bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 (edited) Hello @@ebr and @@speechles, Sad to report that still not working. It did have slightly different behavior this time, when you select the file and select play it will flash a black screen but then fall back to the show page where you were, if you hit play again the same symptoms appear (loads about 15% on the retrieving bar then goes back to 0% and freezes up, have to exit the app to do anything after this). Server still shows trying to direct play. After going back in and attempting to retest with the same or different files it will not do the new thing I describe above, it just tries to play and does the loading 15%, 0% freeze. I will open my port back up to allow you access to the problem recordings. Thanks! Edit: attaching log log.txt Edited October 10, 2019 by bizarro252 Link to comment Share on other sites More sharing options...
ebr 14898 Posted October 10, 2019 Share Posted October 10, 2019 Hello @@ebr and @@speechles, Sad to report that still not working. It did have slightly different behavior this time, when you select the file and select play it will flash a black screen but then fall back to the show page where you were, if you hit play again the same symptoms appear (loads about 15% on the retrieving bar then goes back to 0% and freezes up, have to exit the app to do anything after this). Server still shows trying to direct play. After going back in and attempting to retest with the same or different files it will not do the new thing I describe above, it just tries to play and does the loading 15%, 0% freeze. I will open my port back up to allow you access to the problem recordings. Thanks! Please confirm your app version is .187...? Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 Yes siree Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 10, 2019 Share Posted October 10, 2019 Hello @@ebr and @@speechles, Sad to report that still not working. It did have slightly different behavior this time, when you select the file and select play it will flash a black screen but then fall back to the show page where you were, if you hit play again the same symptoms appear (loads about 15% on the retrieving bar then goes back to 0% and freezes up, have to exit the app to do anything after this). Server still shows trying to direct play. After going back in and attempting to retest with the same or different files it will not do the new thing I describe above, it just tries to play and does the loading 15%, 0% freeze. I will open my port back up to allow you access to the problem recordings. Thanks! I have time today. Lets try again. Annoying this issue is becoming. It might be something with ffmpeg as there is very little actually the app can do to cause this. I might be chasing the wrong end. But lets try again and then can you share your ffmpeg logs that are generated by that activity with us that we cause? I want to see the ffmpeg logs of my attempts and what happens. To see where this is breaking. The app is getting stuck because it is requesting something incorrectly or being fed something back incorrectly. Seeing the ffmpeg logs from those attempts would help greatly. I can try again shortly and get this done once and for all. It is seriously starting to annoy me that this is always coming back like a ghost to haunt me.. lol. Let me know when you have your port opened back up and lets get this done. I appreciate your patience on this too. Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 10, 2019 Share Posted October 10, 2019 (edited) 2019-10-10 01:51:14.534 Info App: ProcessRun 'StreamTranscode 437cdc' Started. 2019-10-10 01:51:14.957 Info App: ProcessRun 'StreamTranscode 437cdc' Process exited with code 0 2019-10-10 01:51:14.961 Error HttpServer: Error processing request *** Error Report *** Version: 4.2.1.0 Command line: /usr/local/lib/emby-server/system/EmbyServer.exe -os freebsd -ffdetect /usr/local/lib/emby-server/bin/ffdetect -ffmpeg /usr/local/lib/emby-server/bin/ffmpeg -ffprobe /usr/local/lib/emby-server/bin/ffprobe -programdata /var/db/emby-server -updatepackage emby-server-freebsd11_{version}_amd64.txz -noautorunwebapp Operating system: Unix 11.2.0.0 64-Bit OS: True 64-Bit Process: True User Interactive: False Mono: 5.10.1.57 (5.10.1.57 Thu Aug 8 09:38:53 UTC 2019) Runtime: file:///usr/local/lib/mono/4.5/mscorlib.dll Processor count: 4 Program data path: /var/db/emby-server Application directory: /usr/local/lib/emby-server/system System.Exception: System.Exception: Error starting ffmpeg at Emby.Server.MediaEncoding.Api.BaseStreamingService+<StartFfMpeg>d__72.MoveNext () [0x00403] in <a698e297b28446ddabf2cb352d49ac0b>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.MediaEncoding.Api.Hls.DynamicHlsService+<GetDynamicSegment>d__14.MoveNext () [0x007da] in <a698e297b28446ddabf2cb352d49ac0b>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.Services.ServiceController+<GetTaskResult>d__12.MoveNext () [0x00081] in <450b368eae8f4cb8ab4853f8ffe89952>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.Services.ServiceHandler+<ProcessRequestAsync>d__4.MoveNext () [0x001da] in <450b368eae8f4cb8ab4853f8ffe89952>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable+ConfiguredTaskAwaiter.GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.HttpServer.HttpListenerHost+<RequestHandler>d__51.MoveNext () [0x00bd3] in <450b368eae8f4cb8ab4853f8ffe89952>:0 Source: mscorlib TargetSite: Void Throw() I also see this in the log. Not sure if relevant but it is there none the same. ----> System.Exception: Error starting ffmpeg Edited October 10, 2019 by speechles Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 @@speechles Port is open. I'm away so I will have to get you the logs generated back tonight unless I can figure out how to remote in I do not remember the ip No ffmpeg logs were generated from my testing this morning. Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 10, 2019 Share Posted October 10, 2019 (edited) @@speechles Port is open. I'm away so I will have to get you the logs generated back tonight unless I can figure out how to remote in I do not remember the ip No ffmpeg logs were generated from my testing this morning. I think I see why no ffmpeg logs. You are on FreeBSD. What FFMpeg build are you using? Something isn't starting FFMpeg on your system. Does it not have +x execute permission? Edited October 10, 2019 by speechles Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 Ffmpeg works fine on other content though? I can transcode other content on the fly no problem. I think I can remote in via my phone if I figure that out I will let you know the version. Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 10, 2019 Share Posted October 10, 2019 (edited) 2019-10-10 01:51:14.491 Info HttpServer: HTTP Response 200 to snipped. Time: 1ms. http://<snipped>/emby/videos/74787/hls1/main/1567.ts?DeviceId=385897e6-159e-55b3-af4f-f44811a85c37&MediaSourceId=03cea8d675adef9002594ae804d2cb6c&PlaySessionId=6de36254b39442c09d0d25f885e1eff7&VideoCodec=h264,mpeg2video&AudioCodec=aac,mp2,mp3,flac,opus,vorbis,lpcm&VideoBitrate=109616000&AudioBitrate=384000&MaxFramerate=61&MaxWidth=1920&MaxHeight=1080&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=2&flac-audiochannels=2&lpcm-audiochannels=2&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=2&opus-audiochannels=2&TranscodeReasons=AudioCodecNotSupported 2019-10-10 01:51:14.522 Info HttpServer: HTTP GET http://<snipped>/emby/videos/74787/hls1/main/1568.ts?DeviceId=385897e6-159e-55b3-af4f-f44811a85c37&MediaSourceId=03cea8d675adef9002594ae804d2cb6c&PlaySessionId=6de36254b39442c09d0d25f885e1eff7&VideoCodec=h264,mpeg2video&AudioCodec=aac,mp2,mp3,flac,opus,vorbis,lpcm&VideoBitrate=109616000&AudioBitrate=384000&MaxFramerate=61&MaxWidth=1920&MaxHeight=1080&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=2&flac-audiochannels=2&lpcm-audiochannels=2&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=2&opus-audiochannels=2&TranscodeReasons=AudioCodecNotSupported. Host=snipped, User-Agent=Roku/DVP-9.20 (049.20E04100A), Accept=*/* 2019-10-10 01:51:14.526 Info App: ProcessRun 'StreamTranscode 437cdc' Execute: /usr/local/lib/emby-server/bin/ffmpeg -ss 01:18:24.000 -f matroska -noaccurate_seek -i file:"/mnt/movies/The Emperors New Groove (2000).mkv" -threads 2 -map 0:0 -map 0:1 -sn -c:v:0 copy -bsf:v h264_mp4toannexb -copyts -vsync -1 -codec:a:0 aac -metadata:s:a:0 language=eng -disposition:a:0 default -ac:a:0 2 -ab:a:0 192000 -af:a:0 "volume=2" -f segment -max_delay 5000000 -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 -start_at_zero -segment_time 3 -segment_time_delta -4704 -individual_header_trailer 0 -break_non_keyframes 1 -segment_format mpegts -segment_write_temp 1 -segment_list_type m3u8 -segment_start_number 1568 -segment_list "/var/db/emby-server/transcoding-temp/ed019a6931b56d476736a22481954070.m3u8" -y "/var/db/emby-server/transcoding-temp/ed019a6931b56d476736a22481954070%d.ts" 2019-10-10 01:51:14.534 Info App: ProcessRun 'StreamTranscode 437cdc' Started. 2019-10-10 01:51:14.957 Info App: ProcessRun 'StreamTranscode 437cdc' Process exited with code 0 2019-10-10 01:51:14.961 Error HttpServer: Error processing request *** Error Report *** Version: 4.2.1.0 Command line: /usr/local/lib/emby-server/system/EmbyServer.exe -os freebsd -ffdetect /usr/local/lib/emby-server/bin/ffdetect -ffmpeg /usr/local/lib/emby-server/bin/ffmpeg -ffprobe /usr/local/lib/emby-server/bin/ffprobe -programdata /var/db/emby-server -updatepackage emby-server-freebsd11_{version}_amd64.txz -noautorunwebapp Operating system: Unix 11.2.0.0 64-Bit OS: True 64-Bit Process: True User Interactive: False Mono: 5.10.1.57 (5.10.1.57 Thu Aug 8 09:38:53 UTC 2019) Runtime: file:///usr/local/lib/mono/4.5/mscorlib.dll Processor count: 4 Program data path: /var/db/emby-server Application directory: /usr/local/lib/emby-server/system System.Exception: System.Exception: Error starting ffmpeg at Emby.Server.MediaEncoding.Api.BaseStreamingService+<StartFfMpeg>d__72.MoveNext () [0x00403] in <a698e297b28446ddabf2cb352d49ac0b>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.MediaEncoding.Api.Hls.DynamicHlsService+<GetDynamicSegment>d__14.MoveNext () [0x007da] in <a698e297b28446ddabf2cb352d49ac0b>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.Services.ServiceController+<GetTaskResult>d__12.MoveNext () [0x00081] in <450b368eae8f4cb8ab4853f8ffe89952>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1+ConfiguredTaskAwaiter[TResult].GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.Services.ServiceHandler+<ProcessRequestAsync>d__4.MoveNext () [0x001da] in <450b368eae8f4cb8ab4853f8ffe89952>:0 --- End of stack trace from previous location where exception was thrown --- at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <0e06830de9a44394a7e366951eabca52>:0 at System.Runtime.CompilerServices.ConfiguredTaskAwaitable+ConfiguredTaskAwaiter.GetResult () [0x00000] in <0e06830de9a44394a7e366951eabca52>:0 at Emby.Server.Implementations.HttpServer.HttpListenerHost+<RequestHandler>d__51.MoveNext () [0x00bd3] in <450b368eae8f4cb8ab4853f8ffe89952>:0 Source: mscorlib TargetSite: Void Throw() 2019-10-10 01:51:14.962 Info HttpServer: HTTP Response 500 to snipped. Time: 440ms. http://<snipped>/emby/videos/74787/hls1/main/1568.ts?DeviceId=385897e6-159e-55b3-af4f-f44811a85c37&MediaSourceId=03cea8d675adef9002594ae804d2cb6c&PlaySessionId=6de36254b39442c09d0d25f885e1eff7&VideoCodec=h264,mpeg2video&AudioCodec=aac,mp2,mp3,flac,opus,vorbis,lpcm&VideoBitrate=109616000&AudioBitrate=384000&MaxFramerate=61&MaxWidth=1920&MaxHeight=1080&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=2&flac-audiochannels=2&lpcm-audiochannels=2&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=2&opus-audiochannels=2&TranscodeReasons=AudioCodecNotSupported There is a full error trace for it. The error given is 500. We can perhaps use that in the fallback to stop the madness and know when to halt. This is something we can improve. Edited October 10, 2019 by speechles Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 I apparently didn't enable remote access on my own account but found an ffmpeg log I uploaded here a few weeks ago and do not believe it has updated since... That detail below: ffmpeg version 4.0.3-emby_2019_04_09 Copyright © 2000-2018 the FFmpeg developers and softworkz for Emby LLC built with gcc 8.3.0 (FreeBSD Ports Collection) Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 The snippet you pasted about appears to have errors from a different file? Am I reading that right? My wife did play this movie late last night... 01:18:24.000 -f matroska -noaccurate_seek -i file:"/mnt/movies/The Emperors New Groove (2000).mkv" Link to comment Share on other sites More sharing options...
ebr 14898 Posted October 10, 2019 Share Posted October 10, 2019 Speechles - where are those log snippetts from? Can I please see the whole file? Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 10, 2019 Share Posted October 10, 2019 (edited) The snippet you pasted about appears to have errors from a different file? Am I reading that right? My wife did play this movie late last night... 01:18:24.000 -f matroska -noaccurate_seek -i file:"/mnt/movies/The Emperors New Groove (2000).mkv" If you have some time today so do I to finish this. I have added very robust verbose error logging now and should be able to see exactly what is going on now. When you are ready let me know when to try to connect to your server. Thanks. Speechles - where are those log snippetts from? Can I please see the whole file? This post:https://emby.media/community/index.php?/topic/77228-1080i-mpeg2-videos-never-start-playing/?p=795392 The attached log.txt. The only error in there besides one from a website lookup. This may just be unique to *nix or unique to bsd. The 500 error is so generic it just tells you the client isn't the problem. Edited October 10, 2019 by speechles Link to comment Share on other sites More sharing options...
ebr 14898 Posted October 10, 2019 Share Posted October 10, 2019 This post:https://emby.media/community/index.php?/topic/77228-1080i-mpeg2-videos-never-start-playing/?p=795392 The attached log.txt. The only error in there besides one from a website lookup. You don't know that those errors are related to this particular playback. You'd need to examine the log from when you actually experience the error with the app. Bizzarro - do you know what is up with these basic file system errors that your system is generating? 2019-10-10 00:05:02.617 Error LibraryMonitor: Error in Directory watcher for: /mnt/dvr *** Error Report *** Version: 4.2.1.0 Command line: /usr/local/lib/emby-server/system/EmbyServer.exe -os freebsd -ffdetect /usr/local/lib/emby-server/bin/ffdetect -ffmpeg /usr/local/lib/emby-server/bin/ffmpeg -ffprobe /usr/local/lib/emby-server/bin/ffprobe -programdata /var/db/emby-server -updatepackage emby-server-freebsd11_{version}_amd64.txz -noautorunwebapp Operating system: Unix 11.2.0.0 64-Bit OS: True 64-Bit Process: True User Interactive: False Mono: 5.10.1.57 (5.10.1.57 Thu Aug 8 09:38:53 UTC 2019) Runtime: file:///usr/local/lib/mono/4.5/mscorlib.dll Processor count: 4 Program data path: /var/db/emby-server Application directory: /usr/local/lib/emby-server/system System.IO.IOException: System.IO.IOException: persistent kevent() error, error code = '13' Those are occurring for more than one of your libraries. Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 10, 2019 Share Posted October 10, 2019 (edited) @@ebr No I do not. I can fire up a new jail with a fresh install and see if they are still there this evening. @@speechles Server is open go ahead and run your tests! The error for that mkv line was played last night. It did play no issue just fyi. Edited October 10, 2019 by bizarro252 Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 11, 2019 Share Posted October 11, 2019 (edited) You don't know that those errors are related to this particular playback. You'd need to examine the log from when you actually experience the error with the app. Bizzarro - do you know what is up with these basic file system errors that your system is generating? 2019-10-10 00:05:02.617 Error LibraryMonitor: Error in Directory watcher for: /mnt/dvr *** Error Report *** Version: 4.2.1.0 Command line: /usr/local/lib/emby-server/system/EmbyServer.exe -os freebsd -ffdetect /usr/local/lib/emby-server/bin/ffdetect -ffmpeg /usr/local/lib/emby-server/bin/ffmpeg -ffprobe /usr/local/lib/emby-server/bin/ffprobe -programdata /var/db/emby-server -updatepackage emby-server-freebsd11_{version}_amd64.txz -noautorunwebapp Operating system: Unix 11.2.0.0 64-Bit OS: True 64-Bit Process: True User Interactive: False Mono: 5.10.1.57 (5.10.1.57 Thu Aug 8 09:38:53 UTC 2019) Runtime: file:///usr/local/lib/mono/4.5/mscorlib.dll Processor count: 4 Program data path: /var/db/emby-server Application directory: /usr/local/lib/emby-server/system System.IO.IOException: System.IO.IOException: persistent kevent() error, error code = '13' Those are occurring for more than one of your libraries. @@ebr, I did a fresh install, via the FreeNAS plugin instead of manual just in case I was messing something up. I mounted the dvr folder to the jail to allow me to share the files to it and went through the setup via the web interface. Once this was done I tested both a problem file, pulled the log, rebooted and tested a good file and pulled the log. They are both attached, both have the same type of error message, not sure what would cause this, @@Luke? Maybe a permissions issue or something? Seems always related to the library refresh/directory watcher. EDIT: @@ebr, Found a thread where Luke stated this is a FreeBSD bug, sounds like nothing to worry about/to be expected. This is going to happen on FreeBSD. Try turning off the realtime monitor if you don't like seeing errors in your server log. This feature is not officially supported on BSD by the mono runtime. Some FreeBSD developers have patched the mono runtime themselves to try and get it to work. That's really as much as I know about the situation right now. https://emby.media/community/index.php?/topic/64890-error-librarymonitor-heaps-and-heaps-of-error-reports-in-the-server-log/ others reporting same thing: https://emby.media/community/index.php?/topic/52313-persistent-kevent-error-error-code-13/ I turned this off in my libraries and restarted the server, those code 13 errors are all gone now (even after manually triggering a library scan they dont come back). Two errors remain, unsure if either are relevant... Attached that log for your reference. "after turning off library auto sync.txt" new server watch bad file.txt new server watch good file.txt after turning off library auto sync.txt Edited October 11, 2019 by bizarro252 Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 11, 2019 Share Posted October 11, 2019 If you have some time today so do I to finish this. I have added very robust verbose error logging now and should be able to see exactly what is going on now. When you are ready let me know when to try to connect to your server. Thanks. @@speechles, Server is up, test away! I don't see you logging on so let me know if its giving you issues. Should I enable debug logging on the server itself as well? I can send you logs now as you need. Link to comment Share on other sites More sharing options...
speechles 1917 Posted October 11, 2019 Share Posted October 11, 2019 Player error. Error Code: -3 Message: An unexpected problem (but not server timeout or HTTP error) has been detected. <Component: roAssociativeArray> = { category: "mediaplayer" clipid: 0 dbgmsg: "reader pick stream error:bad" errcode: 0 ignored: false source: "" } reader pick stream error:bad That is what the verbose logging is picking up. I am guessing "reader pick stream error:bad" is what we get when no streams were sent to the video player. I can use this to safely exit this condition and flag an error now. But it still does not tell me why ffmpeg is not starting for you. Something on your Emby server is causing a 500 error on the Roku. Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 11, 2019 Share Posted October 11, 2019 (edited) ffmpeg is starting for other content though, does that at least prove out the ffmpeg is not broken? In fact I noticed you were playing one of the 'good' files and it was transcoding (even though it states direct playing...which is weird??? see picture below) I have the test, freshly installed (via the official plugin) server up too if you want to try the same files on that - I did already and see the same failure so not sure it will be any different. If we suspect something on the client side I can install a server on a windows box and point it to the server files if that would help?? Thanks Edited October 11, 2019 by bizarro252 Link to comment Share on other sites More sharing options...
Paint 7 Posted October 12, 2019 Share Posted October 12, 2019 I can confirm this issue is now fixed on Roku. Thank you guys for everything you do! Link to comment Share on other sites More sharing options...
EstebanUno 2 Posted October 12, 2019 Author Share Posted October 12, 2019 Paint, Which version of EmbyBeta for Roku are you using? 3.1.0.187 doesn't fix the problem for me. Link to comment Share on other sites More sharing options...
Paint 7 Posted October 12, 2019 Share Posted October 12, 2019 Paint, Which version of EmbyBeta for Roku are you using? 3.1.0.187 doesn't fix the problem for me. Will confirm with the user Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 12, 2019 Share Posted October 12, 2019 Curious as well. 187 did not fix mine either. Please also confirm they are playing a file that had an issue before because for me about 75% of recordings play fine only dive have issues. Link to comment Share on other sites More sharing options...
Paint 7 Posted October 12, 2019 Share Posted October 12, 2019 Curious as well. 187 did not fix mine either. Please also confirm they are playing a file that had an issue before because for me about 75% of recordings play fine only dive have issues.Yes, I can confirm that. This user complained for months that nothing would stream via Roku (MKV or LiveTV via ServerWMC from my Ceton Infinitv6). The app would display "Loading...." or just freeze. After the fix, the user now confirms that everything works fine. Are you guys using NGINX reverse proxy's or emby's built in http server? I had to debug my nginx setup to ensure it worked correctly with emby (fire sticks and roku's) Link to comment Share on other sites More sharing options...
bizarro252 17 Posted October 12, 2019 Share Posted October 12, 2019 (edited) @@Paint I am having problems locally so no proxy shouldn't be messing with it in my case. Edited October 12, 2019 by bizarro252 Link to comment Share on other sites More sharing options...
Recommended Posts
Create an account or sign in to comment
You need to be a member in order to leave a comment
Create an account
Sign up for a new account in our community. It's easy!
Register a new accountSign in
Already have an account? Sign in here.
Sign In Now