Xbox 360 not playing MP4 video or OGG audio

I have set everything to standard Xbox 360 profile, but MP4 video doesn't play and the same goes for OGG. Just keep getting the ol' "file format may not be supported message" from the Xbox. MKVs and AVIs work perfectly based on the ones I have tried.

I then edited the Xbox 360 profile in profiles.xml:
1. OGG is in the transcode list but its not working.
2. tried adding MP4 to the video transcode list, but its still not working.
3. add the ogg mediaformatprofile to xbox 360 and it still did not work.

So far this works much better than PS3 Media Server (which I also could not get OGG transcode to work but managed to get MP4s to work), but I really need to get OGG transcode to work since thats what all my music is in. As for the MP4s I will convert them (if I can find software that actually works) if all else fails.

any ideas to get these to work???

[zip]

post detailed log of trying to play these files.

Ok, first off I finally found a convert that actually works and converted all the MP4s over to MKVs and they work fine.

[root]/etc/serviio/log/serviio.log : Now for OGG, I purposely cleared the logs to and focused on trying to play OGG files on the Xbox360 but the new log isn't populating. I have tried playing 50 songs (all failed to play) but no logs, even after rebooting my entire server machine. I'm not even getting logs off playing AVIs or MKVs, so now I don't know what is going on, it should have repopulated the log almost immediately.

Now I did find this other log for serviio in [root]/log/serviio.log but I don't see anything too relevant but here it is :

  Code:

2011-11-13 17:38:30,768 INFO  [MediaServer] ------------------------------------------------------------------------
2011-11-13 17:38:30,769 INFO  [MediaServer] Serviio DLNA media streaming server v 0.6.0.1 (rev. 8e4ee98bff12)
2011-11-13 17:38:30,769 INFO  [MediaServer] Petr Nejedly 2009-2011
2011-11-13 17:38:30,769 INFO  [MediaServer] http://www.serviio.org
2011-11-13 17:38:30,769 INFO  [MediaServer]
2011-11-13 17:38:30,769 INFO  [MediaServer] Java 1.6.0_23-Sun Microsystems Inc.
2011-11-13 17:38:30,769 INFO  [MediaServer] OS Linux amd64 3.0.0-12-server
2011-11-13 17:38:30,769 INFO  [MediaServer] File encoding: UTF-8
2011-11-13 17:38:30,770 INFO  [MediaServer] Headless mode enabled: true
2011-11-13 17:38:30,770 INFO  [MediaServer] User home dir: /root
2011-11-13 17:38:30,770 INFO  [MediaServer] Temp dir: /tmp
2011-11-13 17:38:30,770 INFO  [MediaServer] ------------------------------------------------------------------------
2011-11-13 17:38:30,837 INFO  [RestletServer] Starting Restlet server exposed on port 23423
2011-11-13 17:38:30,870 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2011-11-13 17:38:46,255 INFO  [DBSchemaUpdateExecutor] Updating DB schema
2011-11-13 17:38:57,325 INFO  [MediaServer] Serviio server instance is already running
2011-11-13 17:39:03,588 INFO  [ProfilesDefinitionParser] Parsing Profiles definition
2011-11-13 17:39:04,007 INFO  [ProfilesDefinitionParser] Added profile 'Generic DLNA profile' (id=1)
2011-11-13 17:39:04,143 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (B-series)' (id=2)
2011-11-13 17:39:04,226 INFO  [ProfilesDefinitionParser] Added profile 'XBox 360' (id=3)
2011-11-13 17:39:04,299 INFO  [ProfilesDefinitionParser] Added profile 'Playstation 3' (id=4)
2011-11-13 17:39:04,384 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV (A-series)' (id=5)
2011-11-13 17:39:04,440 INFO  [ProfilesDefinitionParser] Added profile 'DirecTV HD-DVR' (id=6)
2011-11-13 17:39:04,579 INFO  [ProfilesDefinitionParser] Added profile 'Samsung TV / player (C/D-series)' (id=7)
2011-11-13 17:39:04,612 INFO  [ProfilesDefinitionParser] Added profile 'LG TV / player' (id=8)
2011-11-13 17:39:04,794 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV' (id=9)
2011-11-13 17:39:05,119 INFO  [ProfilesDefinitionParser] Added profile 'Sony BD Player' (id=10)
2011-11-13 17:39:05,246 INFO  [ProfilesDefinitionParser] Added profile 'Panasonic Viera' (id=12)
2011-11-13 17:39:05,365 INFO  [ProfilesDefinitionParser] Added profile 'Toshiba REGZA' (id=13)
2011-11-13 17:39:05,400 INFO  [ProfilesDefinitionParser] Added profile 'WDTV Live' (id=14)
2011-11-13 17:39:05,419 INFO  [ProfilesDefinitionParser] Added profile 'LaCie LaCinema Media Player' (id=15)
2011-11-13 17:39:05,487 INFO  [ProfilesDefinitionParser] Added profile 'Manta WIFI Centre' (id=16)
2011-11-13 17:39:05,516 INFO  [ProfilesDefinitionParser] Added profile 'Pure Flow' (id=17)
2011-11-13 17:39:05,580 INFO  [ProfilesDefinitionParser] Added profile 'Sharp Aquos' (id=18)
2011-11-13 17:39:05,815 INFO  [ProfilesDefinitionParser] Added profile 'Sony Bravia TV 2011' (id=19)
2011-11-13 17:39:06,018 INFO  [ProfilesDefinitionParser] Added profile 'Sony SMP-N100' (id=20)
2011-11-13 17:39:06,029 INFO  [CompositeCacheManager] Creating cache manager from config file: /cache.ccf
2011-11-13 17:39:06,032 INFO  [ThreadPoolManager] thread_pool.default PoolConfiguration = useBoundary = [true] boundarySize = [2000] maximumPoolSize = [150] minimumPoolSize = [4] keepAliveTime = [300000] whenBlockedPolicy = [RUN] startUpSize = [4]
2011-11-13 17:39:06,034 INFO  [CompositeCacheConfigurator] Setting default auxiliaries to null
2011-11-13 17:39:06,035 INFO  [CompositeCacheConfigurator] No special CompositeCacheAttributes class defined for key [jcs.default.cacheattributes], using default class.
2011-11-13 17:39:06,036 INFO  [CompositeCacheConfigurator] setting defaultCompositeCacheAttributes to [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 100, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2011-11-13 17:39:06,036 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.default.elementattributes], using default class.
2011-11-13 17:39:06,036 INFO  [CompositeCacheConfigurator] setting defaultElementAttributes to [ IS_LATERAL = true, IS_SPOOL = true, IS_REMOTE = true, IS_ETERNAL = true, MaxLifeSeconds = -1, IdleTime = -1, CreateTime = 1321234746036, LastAccessTime = 1321234746036, getTimeToLiveSeconds() = -1, createTime = 1321234746036 ]
2011-11-13 17:39:06,052 INFO  [LRUMemoryCache] initialized LRUMemoryCache for thumbnails
2011-11-13 17:39:06,052 INFO  [CompositeCache] Constructed cache with name [thumbnails] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2011-11-13 17:39:06,052 INFO  [LRUMemoryCache] initialized LRUMemoryCache for online_feeds
2011-11-13 17:39:06,052 INFO  [CompositeCache] Constructed cache with name [online_feeds] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2011-11-13 17:39:06,052 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.region.local_default.elementattributes], using default class.
2011-11-13 17:39:06,052 INFO  [LRUMemoryCache] initialized LRUMemoryCache for local_default
2011-11-13 17:39:06,052 INFO  [CompositeCache] Constructed cache with name [local_default] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2011-11-13 17:39:06,053 INFO  [CompositeCacheConfigurator] No special ElementAttribute class defined for key [jcs.region.local_resetafterplay.elementattributes], using default class.
2011-11-13 17:39:06,053 INFO  [LRUMemoryCache] initialized LRUMemoryCache for local_resetafterplay
2011-11-13 17:39:06,053 INFO  [CompositeCache] Constructed cache with name [local_resetafterplay] and cache attributes [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 1000, maxSpoolPerRun = -1, diskUsagePattern = 0 ]
2011-11-13 17:39:06,053 INFO  [CompositeCacheConfigurator] Parsed regions [thumbnails, online_feeds, local_default, local_resetafterplay]
2011-11-13 17:39:06,053 INFO  [CompositeCacheConfigurator] Finished configuration in 19 ms.
2011-11-13 17:39:06,077 INFO  [WebServer] Socket buffer set to 65535 bytes
2011-11-13 17:39:06,077 INFO  [Device] Created UPnP Device with UUID: 5efe115d-15a1-37d6-a934-04c6214d86eb, bound address: 198.169.2.11
2011-11-13 17:39:06,101 INFO  [PluginCompilerThread] Looking for plugins at plugins
2011-11-13 17:39:06,108 INFO  [PluginCompilerThread] Started looking for plugins
2011-11-13 17:39:06,152 WARN  [FFMPEGWrapper] FFmpeg is not compiled with librtmp support, RTMP streaming will not work.
2011-11-13 17:39:06,155 INFO  [AbstractTranscodingDeliveryEngine] Cleaning transcode engine and its data
2011-11-13 17:39:06,199 INFO  [WebServer] WebServer starting on port 8895
2011-11-13 17:39:06,202 INFO  [EventSubscriptionExpirationChecker] Starting EventSubscriptionExpirationChecker
2011-11-13 17:39:06,203 INFO  [EventDispatcher] Starting EventDispatcher
2011-11-13 17:39:06,222 INFO  [RendererSearchSender] Searching for Renderer devices
2011-11-13 17:39:06,235 INFO  [DiscoveryAdvertisementNotifier] Starting DiscoveryAdvertisementNotifier
2011-11-13 17:39:06,236 INFO  [RendererExpirationChecker] Starting RendererExpirationChecker
2011-11-13 17:39:06,251 INFO  [DiscoverySSDPMessageListener] Starting DiscoverySSDPMessageListener using interface eth0 (eth0) and address 198.169.2.11, timeout = 0
2011-11-13 17:39:06,386 INFO  [RendererManager] Stored a new renderer: uuid='80886680-0a02-4678-857b-6c31678df6f7', name = 'Unrecognized device', ipAddress='198.169.2.8', profile = '1'
2011-11-13 17:39:08,728 INFO  [RendererManager] Stored a new renderer: uuid='99a11a5e-2443-4a39-b696-2e6d8e8aeab2', name = 'Unrecognized device', ipAddress='198.169.2.111', profile = '1'
2011-11-13 17:39:32,270 INFO  [FeedUpdaterThread] Started looking for information about online feeds
2011-11-13 17:39:32,286 INFO  [LibraryAdditionsCheckerThread] Started looking for newly added files
2011-11-13 17:39:32,304 INFO  [LibraryUpdatesCheckerThread] Started looking for updates to currently shared files
2011-11-13 17:41:47,404 INFO  [MediaServer] Serviio server instance is already running


here is the [root]/etc/serviio/log/derby.log :

  Code:

----------------------------------------------------------------
Mon Nov 14 23:55:43 PST 2011:
Booting Derby version The Apache Software Foundation - Apache Derby - 10.8.1.2 - (1095077): instance a816c00e-0133-a639-7194-00003ea6991b
on database directory /etc/serviio/library/db  with class loader sun.misc.Launcher$AppClassLoader@1f7182c1
Loaded from file:/etc/serviio/lib/derby.jar
java.vendor=Sun Microsystems Inc.
java.runtime.version=1.6.0_23-b23
user.dir=/
derby.system.home=/etc/serviio/library
derby.stream.error.file=../log/derby.log
Database Class Loader started - derby.database.classpath=''


Neither log is helpful and the main log isn't doing anything. So, Once I get a log, I will post it.

[zip]

you have to enable detailed logging to see the details

I know, detailed logging is turned on...the log just isn't populating.
I have restarted the entire server machine, restarted serviio several times...but log remains unpopulated.

However it has populated 2 lines, but that is about a port that has already been taken:

  Code:

2011-11-15 21:31:03,980 DEBUG [ApplicationInstanceManager] Port is already taken. Notifying first instance.
2011-11-15 21:31:03,980 DEBUG [ApplicationInstanceManager] Successfully notified first instance.


Here's what I got from the last time I restarted Serviio (which isn't the serviio log...):

  Code:

 * Stopping Serviio media server daemon Serviio Media Server
awk: warning: escape sequence `\(' treated as plain `('
awk: warning: escape sequence `\)' treated as plain `)'
log4j: reset attribute= "false".
log4j: Threshold ="null".
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.serviio] additivity to [true].
log4j: Level value for org.serviio is  [DEBUG].
log4j: org.serviio level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [com.sun.syndication] additivity to [true].
log4j: Level value for com.sun.syndication is  [ERROR].
log4j: com.sun.syndication level set to ERROR
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.jaudiotagger] additivity to [true].
log4j: Level value for org.jaudiotagger is  [ERROR].
log4j: org.jaudiotagger level set to ERROR
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.restlet] additivity to [true].
log4j: Level value for org.restlet is  [ERROR].
log4j: org.restlet level set to ERROR
log4j: Level value for root is  [INFO].
log4j: root level set to INFO
log4j: Class name: [org.apache.log4j.RollingFileAppender]
log4j: Setting property [threshold] to [DEBUG].
log4j: Setting property [append] to [true].
log4j: Setting property [file] to [/etc/serviio/log/serviio.log].
log4j: Setting property [maxFileSize] to [500KB].
log4j: Setting property [maxBackupIndex] to [5].
log4j: Setting property [encoding] to [UTF-8].
log4j: Parsing layout of class: "org.apache.log4j.PatternLayout"
log4j: Setting property [conversionPattern] to [%d{ISO8601} %-5p [%c{1}] %m%n].
log4j: setFile called: /etc/serviio/log/serviio.log, true
log4j: setFile ended
log4j: Adding appender named [FILE] to category [root].
.....   ...done.
 * Starting Serviio media server daemon Serviio Media Server
   ...done.

After I got these logs, I reinstalled Serviio for the 5th time and even as it scans my library of movies, music and pics (which takes a long time) it still isn't logging.

Oh, I forgot to mention that I am managing Serviio through the windows client to Linux server....which is by far the most awesome idea I have seen for such products. Mentioning this just in case it helps any.

I don't know what is going on...but I do know this isn't the only problem I am having, I also have an issue with additional users...but that's a fight between Ubuntu and myself.

any ideas about why the logs would stop logging everything....?

Ok, thank you for your patience while I figured out what my server was doing, but I managed to fix some things and got logging back.

From the log it looks like FFMPEG is failing.

I can't provide anything for MP4s since I no longer have any.

Here is the excerpt from the log that shows the only error I get when trying to play OGG files:

  Code:

2011-11-16 23:56:47,011 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)

Any ideas whats going on? Because if I hook speakers up to my server and play them at the machine itself, there's no issue...


EDIT: I decided to attach the actual log itself...so here it is.

derby.log

Derby.log

(605 Bytes) Downloaded 298 times

serviio.log

serviio.log

(223.91 KiB) Downloaded 342 times

EDIT 2: Here is the "ffmpeg -i" read out for one of the songs and all the songs are the same format/encoding.

  Code:

ffmpeg version 0.7.2-4:0.7.2-1ubuntu1, Copyright (c) 2000-2011 the Libav developers
  built on Oct  2 2011 15:13:26 with gcc 4.6.1
  configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=amd64 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --enable-shared --disable-static
  libavutil    51.  7. 0 / 51.  7. 0
  libavcodec   53.  5. 0 / 53.  5. 0
  libavformat  53.  2. 0 / 53.  2. 0
  libavdevice  53.  0. 0 / 53.  0. 0
  libavfilter   2.  4. 0 /  2.  4. 0
  libswscale    2.  0. 0 /  2.  0. 0
  libpostproc  52.  0. 0 / 52.  0. 0
Input #0, ogg, from '/mnt/storage/Music/3/2001 Half Life/02 - Paint by Number.ogg':
  Duration: 00:03:54.16, start: 0.000000, bitrate: 227 kb/s
    Stream #0.0: Audio: vorbis, 44100 Hz, stereo, s16, 256 kb/s
    Metadata:
      TITLE           : Paint by Number
      ARTIST          : 3
      album_artist    : Three
      ALBUM           : Half Life
      GENRE           : Metal
      DATE            : 2001
      PUBLISHER       : Planet Noise Records
      track           : 2
      COMPOSER        : 3/Joey Eppard
At least one output file must be specified


No one have any ideas?

[zip]

the log you posted is not detailed log (link in my signature on how to set it up). Once you post that we'll be able to find the ffmpeg command, you will be able to run it manually so that we can see the actual problem.

Ok, I'm sorry for previous posts, but I truly did have the log4j.xml edited and set to DEBUG. However I did say earlier that I was having log issues. Now, today I reinstalled my entire server system and reconfigured everything to get it back. I did manage to get the log file to display the correct data and such so here is and excerpt of the errors recieved.

serviio.log excerpt:

  Code:

2011-11-22 02:44:31,684 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)
2011-11-22 02:44:31,737 DEBUG [WebServer] Incoming connection from /10.69.2.7:41487
2011-11-22 02:44:31,752 DEBUG [ResourceTransportRequestHandler] GET /resource/10987/MEDIA_ITEM/MP3$0 HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 10.69.2.3,Content-Length: 3]]
2011-11-22 02:44:31,753 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.69.2.7
2011-11-22 02:44:31,753 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:31,754 DEBUG [ResourceTransportRequestHandler] Request for resource 10987 and type 'MEDIA_ITEM' received
2011-11-22 02:44:31,754 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 10987 (local)
2011-11-22 02:44:31,754 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 10987)
2011-11-22 02:44:31,754 DEBUG [MusicTrackDAOImpl] Reading a MusicTrack (id = 10987)
2011-11-22 02:44:31,755 DEBUG [AudioDeliveryEngine] Delivering item '10987' for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:31,755 DEBUG [AudioDeliveryEngine] Delivering file '04 - Fame.ogg' using transcoding
2011-11-22 02:44:31,755 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file '/tmp/Serviio/transcoding-temp-10988-MP3.stf'
2011-11-22 02:44:31,755 DEBUG [AbstractTranscodingDeliveryEngine] Deleted temp file '/tmp/Serviio/transcoding-temp-10988-MP3.stf': true
2011-11-22 02:44:31,755 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:31,755 DEBUG [MediaItemDAOImpl] Getting file of media item 10987
2011-11-22 02:44:31,756 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode audio file: /mnt/Storage/Music/DMX/1999 ...And Then There Was X/04 - Fame.ogg
2011-11-22 02:44:31,756 DEBUG [ProcessExecutor] Starting ffmpeg -i /mnt/Storage/Music/DMX/1999 ...And Then There Was X/04 - Fame.ogg -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10987-MP3.stf
2011-11-22 02:44:31,849 WARN  [ProcessExecutor] Process ffmpeg has a return code of 1! This is a possible error.
2011-11-22 02:44:31,849 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2011-11-22 02:44:37,093 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 10.69.2.3, timeout = 0
2011-11-22 02:44:37,094 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device b560f18a-3fd1-36d5-a351-28ce1f156164
2011-11-22 02:44:38,899 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:01:02
2011-11-22 02:44:39,259 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)
2011-11-22 02:44:39,279 DEBUG [WebServer] Incoming connection from /10.69.2.7:19339
2011-11-22 02:44:39,294 DEBUG [ResourceTransportRequestHandler] GET /resource/10985/MEDIA_ITEM/MP3$0 HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 10.69.2.3,Content-Length: 3]]
2011-11-22 02:44:39,294 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.69.2.7
2011-11-22 02:44:39,295 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:39,295 DEBUG [ResourceTransportRequestHandler] Request for resource 10985 and type 'MEDIA_ITEM' received
2011-11-22 02:44:39,295 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 10985 (local)
2011-11-22 02:44:39,295 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 10985)
2011-11-22 02:44:39,295 DEBUG [MusicTrackDAOImpl] Reading a MusicTrack (id = 10985)
2011-11-22 02:44:39,296 DEBUG [AudioDeliveryEngine] Delivering item '10985' for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:39,296 DEBUG [AudioDeliveryEngine] Delivering file '05 - Alot To Learn (Skit).ogg' using transcoding
2011-11-22 02:44:39,296 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file '/tmp/Serviio/transcoding-temp-10987-MP3.stf'
2011-11-22 02:44:39,296 DEBUG [AbstractTranscodingDeliveryEngine] Deleted temp file '/tmp/Serviio/transcoding-temp-10987-MP3.stf': true
2011-11-22 02:44:39,296 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:39,296 DEBUG [MediaItemDAOImpl] Getting file of media item 10985
2011-11-22 02:44:39,297 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode audio file: /mnt/Storage/Music/DMX/1999 ...And Then There Was X/05 - Alot To Learn (Skit).ogg
2011-11-22 02:44:39,298 DEBUG [ProcessExecutor] Starting ffmpeg -i /mnt/Storage/Music/DMX/1999 ...And Then There Was X/05 - Alot To Learn (Skit).ogg -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10985-MP3.stf
2011-11-22 02:44:39,344 WARN  [ProcessExecutor] Process ffmpeg has a return code of 1! This is a possible error.
2011-11-22 02:44:39,345 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2011-11-22 02:44:40,952 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2011-11-22 02:44:46,801 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)
2011-11-22 02:44:46,820 DEBUG [WebServer] Incoming connection from /10.69.2.7:24393
2011-11-22 02:44:46,835 DEBUG [ResourceTransportRequestHandler] GET /resource/10983/MEDIA_ITEM/MP3$0 HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 10.69.2.3,Content-Length: 3]]
2011-11-22 02:44:46,835 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.69.2.7
2011-11-22 02:44:46,836 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:46,836 DEBUG [ResourceTransportRequestHandler] Request for resource 10983 and type 'MEDIA_ITEM' received
2011-11-22 02:44:46,836 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 10983 (local)
2011-11-22 02:44:46,836 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 10983)
2011-11-22 02:44:46,836 DEBUG [MusicTrackDAOImpl] Reading a MusicTrack (id = 10983)
2011-11-22 02:44:46,837 DEBUG [AudioDeliveryEngine] Delivering item '10983' for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:46,837 DEBUG [AudioDeliveryEngine] Delivering file '06 - Here We Go Again.ogg' using transcoding
2011-11-22 02:44:46,837 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file '/tmp/Serviio/transcoding-temp-10985-MP3.stf'
2011-11-22 02:44:46,837 DEBUG [AbstractTranscodingDeliveryEngine] Deleted temp file '/tmp/Serviio/transcoding-temp-10985-MP3.stf': true
2011-11-22 02:44:46,837 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:46,837 DEBUG [MediaItemDAOImpl] Getting file of media item 10983
2011-11-22 02:44:46,838 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode audio file: /mnt/Storage/Music/DMX/1999 ...And Then There Was X/06 - Here We Go Again.ogg
2011-11-22 02:44:46,839 DEBUG [ProcessExecutor] Starting ffmpeg -i /mnt/Storage/Music/DMX/1999 ...And Then There Was X/06 - Here We Go Again.ogg -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10983-MP3.stf
2011-11-22 02:44:46,910 WARN  [ProcessExecutor] Process ffmpeg has a return code of 1! This is a possible error.
2011-11-22 02:44:46,910 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2011-11-22 02:44:54,342 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)
2011-11-22 02:44:54,361 DEBUG [WebServer] Incoming connection from /10.69.2.7:26015
2011-11-22 02:44:54,376 DEBUG [ResourceTransportRequestHandler] GET /resource/10979/MEDIA_ITEM/MP3$0 HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 10.69.2.3,Content-Length: 3]]
2011-11-22 02:44:54,376 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.69.2.7
2011-11-22 02:44:54,377 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:54,377 DEBUG [ResourceTransportRequestHandler] Request for resource 10979 and type 'MEDIA_ITEM' received
2011-11-22 02:44:54,377 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 10979 (local)
2011-11-22 02:44:54,377 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 10979)
2011-11-22 02:44:54,378 DEBUG [MusicTrackDAOImpl] Reading a MusicTrack (id = 10979)
2011-11-22 02:44:54,378 DEBUG [AudioDeliveryEngine] Delivering item '10979' for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:54,378 DEBUG [AudioDeliveryEngine] Delivering file '07 - Party Up.ogg' using transcoding
2011-11-22 02:44:54,379 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file '/tmp/Serviio/transcoding-temp-10983-MP3.stf'
2011-11-22 02:44:54,379 DEBUG [AbstractTranscodingDeliveryEngine] Deleted temp file '/tmp/Serviio/transcoding-temp-10983-MP3.stf': true
2011-11-22 02:44:54,379 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:44:54,379 DEBUG [MediaItemDAOImpl] Getting file of media item 10979
2011-11-22 02:44:54,380 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode audio file: /mnt/Storage/Music/DMX/1999 ...And Then There Was X/07 - Party Up.ogg
2011-11-22 02:44:54,380 DEBUG [ProcessExecutor] Starting ffmpeg -i /mnt/Storage/Music/DMX/1999 ...And Then There Was X/07 - Party Up.ogg -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10979-MP3.stf
2011-11-22 02:44:54,459 WARN  [ProcessExecutor] Process ffmpeg has a return code of 1! This is a possible error.
2011-11-22 02:44:54,459 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2011-11-22 02:45:01,883 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:117)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:93)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:118)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:116)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:54)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:58)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:187)
2011-11-22 02:45:01,902 DEBUG [WebServer] Incoming connection from /10.69.2.7:64574
2011-11-22 02:45:01,917 DEBUG [ResourceTransportRequestHandler] GET /resource/10973/MEDIA_ITEM/MP3$0 HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 10.69.2.3,Content-Length: 3]]
2011-11-22 02:45:01,918 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.69.2.7
2011-11-22 02:45:01,918 DEBUG [ResourceTransportRequestHandler] Resource request accepted. Using client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:45:01,919 DEBUG [ResourceTransportRequestHandler] Request for resource 10973 and type 'MEDIA_ITEM' received
2011-11-22 02:45:01,919 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 10973 (local)
2011-11-22 02:45:01,919 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 10973)
2011-11-22 02:45:01,919 DEBUG [MusicTrackDAOImpl] Reading a MusicTrack (id = 10973)
2011-11-22 02:45:01,920 DEBUG [AudioDeliveryEngine] Delivering item '10973' for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:45:01,920 DEBUG [AudioDeliveryEngine] Delivering file '08 - Make A Move.ogg' using transcoding
2011-11-22 02:45:01,920 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file '/tmp/Serviio/transcoding-temp-10979-MP3.stf'
2011-11-22 02:45:01,920 DEBUG [AbstractTranscodingDeliveryEngine] Deleted temp file '/tmp/Serviio/transcoding-temp-10979-MP3.stf': true
2011-11-22 02:45:01,920 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/10.69.2.7, Profile=XBox 360'
2011-11-22 02:45:01,920 DEBUG [MediaItemDAOImpl] Getting file of media item 10973
2011-11-22 02:45:01,921 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode audio file: /mnt/Storage/Music/DMX/1999 ...And Then There Was X/08 - Make A Move.ogg
2011-11-22 02:45:01,922 DEBUG [ProcessExecutor] Starting ffmpeg -i /mnt/Storage/Music/DMX/1999 ...And Then There Was X/08 - Make A Move.ogg -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10973-MP3.stf
2011-11-22 02:45:02,006 WARN  [ProcessExecutor] Process ffmpeg has a return code of 1! This is a possible error.
2011-11-22 02:45:02,006 DEBUG [TranscodingJobListener] Transcoding finished; successful: false

and Here is what I get when running 'ffmpeg -i' on a file:

  Code:

ffmpeg -i /mnt/Storage/Music/DMX/1999\ ...And\ Then\ There\ Was\ X/07\ -\ Party\ Up.ogg
ffmpeg version 0.7.2-4:0.7.2-1ubuntu1, Copyright (c) 2000-2011 the Libav developers
  built on Oct  2 2011 15:13:26 with gcc 4.6.1
  configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=amd64 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --enable-shared --disable-static
  libavutil    51.  7. 0 / 51.  7. 0
  libavcodec   53.  5. 0 / 53.  5. 0
  libavformat  53.  2. 0 / 53.  2. 0
  libavdevice  53.  0. 0 / 53.  0. 0
  libavfilter   2.  4. 0 /  2.  4. 0
  libswscale    2.  0. 0 /  2.  0. 0
  libpostproc  52.  0. 0 / 52.  0. 0
Input #0, ogg, from '/mnt/Storage/Music/DMX/1999 ...And Then There Was X/07 - Party Up.ogg':
  Duration: 00:04:28.94, start: 0.000000, bitrate: 212 kb/s
    Stream #0.0: Audio: vorbis, 44100 Hz, stereo, s16, 256 kb/s
    Metadata:
      TITLE           : Party Up
      ARTIST          : DMX
      ALBUM           : ...And Then There Was X
      GENRE           : Rap
      DATE            : 1999
      track           : 7
At least one output file must be specified


Again I apologize for previous posts, hopefully now this problem can be tracked down.

I just noticed something interesting while trying to play things on my Logitech Revue (Google TV) and same things happens on the Xbox 360....if I use any of the other features besides searching through the 'folders' (such as 'movies') all my video files are messed up...they have the category folder name as the title of the movie.

Also, on the Logitech revue, it refuses to even list any of my music...it will list folders but not the actual music file...the Logitech Revue can play OGG and MKV without needing any transcoding. And again...movies play fine...can't even get music to list.

Is there a hierarchy limit (folder depth)?

[zip]

So what happens when you try to run his:

  Code:

ffmpeg -i "/mnt/Storage/Music/DMX/1999 ...And Then There Was X/04 - Fame.ogg" -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10987-MP3.stf

Here's what I get:

  Code:

 ffmpeg -i "/mnt/Storage/Music/DMX/1999 ...And Then There Was X/04 - Fame.ogg" -y -ab 192k -ac 2 -f mp3 /tmp/Serviio/transcoding-temp-10987-MP3.stf
ffmpeg version 0.7.2-4:0.7.2-1ubuntu1, Copyright (c) 2000-2011 the Libav developers
  built on Oct  2 2011 15:13:26 with gcc 4.6.1
  configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=amd64 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --enable-shared --disable-static
  libavutil    51.  7. 0 / 51.  7. 0
  libavcodec   53.  5. 0 / 53.  5. 0
  libavformat  53.  2. 0 / 53.  2. 0
  libavdevice  53.  0. 0 / 53.  0. 0
  libavfilter   2.  4. 0 /  2.  4. 0
  libswscale    2.  0. 0 /  2.  0. 0
  libpostproc  52.  0. 0 / 52.  0. 0
Input #0, ogg, from '/mnt/Storage/Music/DMX/1999 ...And Then There Was X/04 - Fame.ogg':
  Duration: 00:03:37.40, start: 0.000000, bitrate: 231 kb/s
    Stream #0.0: Audio: vorbis, 44100 Hz, stereo, s16, 256 kb/s
    Metadata:
      TITLE           : Fame
      ARTIST          : DMX
      ALBUM           : ...And Then There Was X
      GENRE           : Rap
      DATE            : 1999
      track           : 4
Output #0, mp3, to '/tmp/Serviio/transcoding-temp-10987-MP3.stf':
    Stream #0.0: Audio: [0][0][0][0] / 0x0000, 44100 Hz, stereo, s16, 192 kb/s
    Metadata:
      TITLE           : Fame
      ARTIST          : DMX
      ALBUM           : ...And Then There Was X
      GENRE           : Rap
      DATE            : 1999
      track           : 4
Stream mapping:
  Stream #0.0 -> #0.0
Encoder (codec id 86017) not found for output stream #0.0


and I know I have installed all the needed programs/files/encoders

[Cerberus]

--enable-libmp3 is missing from your ffmpeg. we had this before with a ubuntu user but i dont know if it was solved, try installing the latest version of ffmpeg from your file repo or compile it manualy with the source from the download page here at the serviio website.

Yes, found that package missing....got it installed and now its finally working...don't know how it didn't get installed with all the others...


However, now that problem is fixed...another pops up...now the xbox isn't getting the list of albums when I go into artists...doubt the 2 are connected though...

[zip]

That is a know issue - not implemented.

--enable-libmp3 is missing from your ffmpeg. we had this before with a ubuntu user but i dont know if it was solved, try installing the latest version of ffmpeg from your file repo or compile it manualy with the source from the download page here at the serviio website.

I can confirm that new versions of ffmpeg for Ubuntu are configured the same way and transcoding to MP3 will not work "out-of-the-box". To enable MP3 transcoding, see:

http://ubuntuforums.org/showthread.php?t=1117283

Option B is the easiest as the thread mentions and it worked perfectly for me.

[Cerberus]

we also have a good tutorial on our Wiki

http://wiki.serviio.org/doku.php?id=build_ffmpeg_linux

[patters]

@OP - Incidentally, by converting all your MP4 files to MKV you're losing quality - the Xbox profile will transcode all MKV videos to mpeg2video.
Since your MP4 files are most likely decent quality h264, you want to preserve that as much as possible.
What I suspect was the issue, is that the 360 cannot play surround sound in MP4 - only stereo. It was therefore trying to transcode and not finding libmp3lame. I think there are tools which allow you to strip the audio down to 2 channel without affecting the video stream (so pretty quickly), but you'll need to do this to the files before you add them to the Serviio library.