Something happened to OGG playback

[geotux 4]

Hi,

 

I'm running Version 3.2.8.0 on Debian 7.0 32 bit and am having problems running ogg vorbis format. I'm not sure I understand what the problems is but I have pasted the relative log lines below. Nothing else has changed on the server. I think it started happening after an Emby update.

 

Thank you.
 

 

2017-03-25 15:44:32.4702 Info App: Profile: Unknown Profile, No direct play profiles found for Path: /exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/10 - Empire of the Sun - Without You.ogg
2017-03-25 15:44:32.4702 Info App: Profile: Unknown Profile, No direct play profiles found for Path: /exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/10 - Empire of the Sun - Without You.ogg
2017-03-25 15:44:32.4704 Info App: Profile: Unknown Profile, No direct play profiles found for Path: /exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/10 - Empire of the Sun - Without You.ogg
2017-03-25 15:44:32.4773 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 36ms. http://192.168.2.2:8096/emby/Items/c5c605c89fffcb0279f9a622bee8126d/PlaybackInfo?UserId=ace9caca38414624ad945d08f4d2ba16&StartTimeTicks=0&MaxStreamingBitrate=1500000
2017-03-25 15:44:32.4781 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 134ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.338Z
2017-03-25 15:44:32.4788 Info HttpServer: HTTP Response 204 to 192.168.2.3. Time: 42ms. http://192.168.2.2:8096/emby/Sessions/Playing
2017-03-25 15:44:32.4849 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/audio/c5c605c89fffcb0279f9a622bee8126d/stream.aac?DeviceId=8ce718eded9dbc35b05d1619559829e3c1721be1&MediaSourceId=c5c605c89fffcb0279f9a622bee8126d&AudioCodec=aac&AudioBitrate=192000&PlaySessionId=89c4ef67fcd8421b9b7f929f5974c65d&CopyTimestamps=false&EnableSubtitlesInManifest=false&Tag=0efdbac438d7f9a4fb994c1c6fad406d&RequireAvc=false. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.4915 Debug App: ReportPlaybackStopped PlaySessionId: 7e799ac1178248d29e777ee8d3d5800a
2017-03-25 15:44:32.4915 Info SessionManager: Playback stopped reported by app Emby Mobile 3.2.8.0 playing Tiger by My Side. Stopped at 0 ms
2017-03-25 15:44:32.5048 Info App: /usr/bin/ffmpeg -i file:"/exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/10 - Empire of the Sun - Without You.ogg" -threads 0 -vn -ab 192000 -ac 2 -id3v2_version 3 -write_id3v1 1 -y "/mnt/media/Transcode/transcoding-temp/d6d5cc5ee28e3a0a15b99ce93053929b.aac"
2017-03-25 15:44:32.5105 Info HttpServer: HTTP Response 204 to 192.168.2.3. Time: 77ms. http://192.168.2.2:8096/emby/Sessions/Playing/Stopped
2017-03-25 15:44:32.5992 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.510Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.6002 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 266ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.331Z
2017-03-25 15:44:32.6003 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 160ms. http://192.168.2.2:8096/emby/Users/ace9caca38414624ad945d08f4d2ba16/Items/f8cac43301c0664c1cadc76d29a881db
2017-03-25 15:44:32.6024 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.598Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.6250 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.614Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.6285 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.625Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.7062 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 104ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.598Z
2017-03-25 15:44:32.7089 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.598Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.7434 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 144ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.510Z
2017-03-25 15:44:32.7462 Info HttpServer: HTTP GET http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.510Z. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.98 Safari/537.36
2017-03-25 15:44:32.7837 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 159ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.614Z
2017-03-25 15:44:32.8265 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 198ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.625Z
2017-03-25 15:44:32.8545 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 146ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.598Z
2017-03-25 15:44:32.8932 Info HttpServer: HTTP Response 200 to 192.168.2.3. Time: 147ms. http://192.168.2.2:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-03-24T15%3A44%3A32.510Z
2017-03-25 15:44:32.9920 Debug App: Disposing stream resources
2017-03-25 15:44:32.9920 Info App: FFMpeg exited with code 1
2017-03-25 15:44:33.0930 Debug App: Disposing stream resources
2017-03-25 15:44:33.0930 Info App: FFMpeg exited with code 1

[Luke 42077]

Can you attach the ffmpeg log? thanks.

[geotux 4]

Why is it transcoding? Anyway, see below. Not sure I can see much in this.

 

Cheers

 

http://192.168.2.2:8096/emby/audio/c2e7d81be8cac91ce4e5462212a76e6d/stream.aac?DeviceId=8ce718eded9dbc35b05d1619559829e3c1721be1&MediaSourceId=c2e7d81be8cac91ce4e5462212a76e6d&AudioCodec=aac&AudioBitrate=192000&PlaySessionId=e6a7c6342f444aabb39e003a2fd14846&api_key=30ad63bab4394c99a2a69f507f20b781&CopyTimestamps=false&EnableSubtitlesInManifest=false&Tag=668e5123496eb922db212d3d8d452d21&RequireAvc=false

{"Protocol":"File","Id":"c2e7d81be8cac91ce4e5462212a76e6d","Path":"/exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/06 - Empire of the Sun - Country.ogg","Type":"Default","Container":"ogg","Size":8793542,"Name":"Country","IsRemote":false,"ETag":"668e5123496eb922db212d3d8d452d21","RunTimeTicks":3044930000,"ReadAtNativeFramerate":false,"SupportsTranscoding":true,"SupportsDirectStream":true,"SupportsDirectPlay":true,"IsInfiniteStream":false,"RequiresOpening":false,"RequiresClosing":false,"SupportsProbing":true,"MediaStreams":[{"Codec":"vorbis","TimeBase":"1/44100","CodecTimeBase":"1/44100","Title":"Country","DisplayTitle":"Country","IsInterlaced":false,"ChannelLayout":"stereo","BitRate":224000,"Channels":2,"SampleRate":44100,"IsDefault":false,"IsForced":false,"Type":"Audio","Index":0,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"Level":0}],"PlayableStreamFileNames":[],"Formats":[],"Bitrate":231034,"RequiredHttpHeaders":{}}

/usr/bin/ffmpeg -i file:"/exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/06 - Empire of the Sun - Country.ogg" -threads 0 -vn -ab 192000 -ac 2 -id3v2_version 3 -write_id3v1 1 -y "/mnt/media/Transcode/transcoding-temp/5c0e1f8615ba4462027d905a84187288.aac"


ffmpeg version 2.8-1~bpo8+1 Copyright © 2000-2015 the FFmpeg developers
built with gcc 4.9.2 (Debian 4.9.2-10)
configuration: --prefix=/usr --extra-version='1~bpo8+1' --build-suffix=-ffmpeg --toolchain=hardened --libdir=/usr/lib/i386-linux-gnu --incdir=/usr/include/i386-linux-gnu --enable-gpl --enable-shared --disable-stripping --disable-decoder=libopenjpeg --disable-decoder=libschroedinger --enable-avresample --enable-avisynth --enable-gnutls --enable-ladspa --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libmodplug --enable-libmp3lame --enable-libopenjpeg --enable-openal --enable-libopus --enable-libpulse --enable-librtmp --enable-libschroedinger --enable-libshine --enable-libsnappy --enable-libspeex --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxvid --enable-libzvbi --enable-opengl --enable-x11grab --enable-libiec61883 --enable-libdc1394 --enable-libzmq --enable-frei0r --enable-libx264 --enable-libopencv --disable-i686
libavutil 54. 31.100 / 54. 31.100
libavcodec 56. 60.100 / 56. 60.100
libavformat 56. 40.101 / 56. 40.101
libavdevice 56. 4.100 / 56. 4.100
libavfilter 5. 40.101 / 5. 40.101
libavresample 2. 1. 0 / 2. 1. 0
libswscale 3. 1.101 / 3. 1.101
libswresample 1. 2.101 / 1. 2.101
libpostproc 53. 3.100 / 53. 3.100
Input #0, ogg, from 'file:/exports/zeusmedia/Music/Empire Of The Sun/Walking On A Dream/06 - Empire of the Sun - Country.ogg':
Duration: 00:05:04.49, start: 0.000000, bitrate: 231 kb/s
Stream #0:0: Audio: vorbis, 44100 Hz, stereo, fltp, 224 kb/s
Metadata:
ALBUM : Walking on a Dream
album_artist : Empire of the Sun
ARTIST : Empire of the Sun
DATE : 2009
disc : 1
DISCTOTAL : 1
GENRE : Pop
TITLE : Country
track : 6
TRACKTOTAL : 10
[aac @ 0x9818920] The encoder 'aac' is experimental but experimental codecs are not enabled, add '-strict -2' if you want to use it.

[Luke 42077]

Thanks for reporting the issue.

[geotux 4]

Hi,

 

any idea of what the cause may be?

 

Cheers

[Luke 42077]

Try the latest version of Emby server.

[geotux 4]

Yes, now ogg vorbis content its working. Is it a fortuitous resolution of a hidden problem or do you know what the problem was?

 

The web interface seems to be slightly more responsive too with nothing else having changed other than an apt-get dist-upgrade on my wheezy box.

 

Thanks for sorting.

[Luke 42077]

Yes a change was made. Thanks for the feedback.