Jump to content

Issue with 4.4.0.44 playback all the sudden?


scaryfast

Recommended Posts

scaryfast

Long time emby user with lifetime membership and literally never had a problem...until today.

 

Server - Mac mini catalina 10.15.3 - 3.6Quad Core and 8gb ram.  Dedicated machine for Emby.

File Share - Drobo5n dedicated for movies.

 

If I play this from my iPhone emby app or browser on another Mac it works instantly.  Trying to stream from the any of the RokuTV's fails with this error.  To my knowledge, I havent changed anything away from default settings. Please advise.

 

Some moves all the sudden are giving this error --> System.Exception: System.Exception: Error starting ffmpeg

 

-----Log File below---

 

2020-03-30 20:44:30.066 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 8ms. http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items/145386/SpecialFeatures?&EnableImageTypes=Primary,Thumb,Backdrop&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear

2020-03-30 20:44:30.090 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Items/145386/Similar?userId=79c645d9f93c42a2a9b96f3b54fd6da9&EnableImageTypes=Primary,Thumb,Backdrop&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear&imagetypelimit=1&limit=10. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:30.113 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 23ms. http://192.168.1.140:8096/emby/Items/145386/Similar?userId=79c645d9f93c42a2a9b96f3b54fd6da9&EnableImageTypes=Primary,Thumb,Backdrop&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear&imagetypelimit=1&limit=10
2020-03-30 20:44:30.117 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items?Recursive=true&EnableImageTypes=Primary,Thumb,Backdrop&IncludeItemTypes=Playlist,Boxset&sortby=SortName&sortorder=Ascending&ListItemIds=145386&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear&imagetypelimit=1&limit=40. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:30.119 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 2ms. http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items?Recursive=true&EnableImageTypes=Primary,Thumb,Backdrop&IncludeItemTypes=Playlist,Boxset&sortby=SortName&sortorder=Ascending&ListItemIds=145386&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear&imagetypelimit=1&limit=40
2020-03-30 20:44:30.806 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/System/Endpoint. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:30.807 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 1ms. http://192.168.1.140:8096/emby/System/Endpoint
2020-03-30 20:44:31.149 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items/145386/Intros?&EnableImageTypes=Primary,Thumb,Backdrop&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:31.156 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 7ms. http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items/145386/Intros?&EnableImageTypes=Primary,Thumb,Backdrop&fields=SortName,PrimaryImageAspectRatio,OfficialRating,CriticRating,CommunityRating,PremiereDate,StartDate,EndDate,ProductionYear
2020-03-30 20:44:31.688 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items/145386?fields=Overview. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:31.692 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 4ms. http://192.168.1.140:8096/emby/Users/79c645d9f93c42a2a9b96f3b54fd6da9/Items/145386?fields=Overview
2020-03-30 20:44:32.089 Info HttpServer: HTTP POST http://192.168.1.140:8096/emby/Items/145386/PlaybackInfo?UserId=79c645d9f93c42a2a9b96f3b54fd6da9&starttimeticks=00000000&audiostreamindex=1&isplayback=true&maxstreamingbitrate=110000000&subtitlestreamindex=-1&mediasourceid=826809813734c9ee15818e4303b04a07. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:32.097 Info MediaInfoService: User policy for Home. EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
2020-03-30 20:44:32.097 Info MediaInfoService: Profile: VideoContainerProfile, DirectPlay=false. Reason=Roku SG.NumVideoStreams Condition: Equals. ConditionValue: 1. IsRequired: False. Path: /Volumes/Drobo5N/drb154901a00351/1/Drobo-Backup/Movies/Spies in Disguise - 2019.m4v
2020-03-30 20:44:32.097 Info MediaInfoService: Profile: VideoContainerProfile, DirectPlay=false. Reason=Roku SG.NumVideoStreams Condition: Equals. ConditionValue: 1. IsRequired: False. Path: /Volumes/Drobo5N/drb154901a00351/1/Drobo-Backup/Movies/Spies in Disguise - 2019.m4v
2020-03-30 20:44:32.097 Info MediaInfoService: Profile: VideoContainerProfile, DirectPlay=false. Reason=Roku SG.NumVideoStreams Condition: Equals. ConditionValue: 1. IsRequired: False. Path: /Volumes/Drobo5N/drb154901a00351/1/Drobo-Backup/Movies/Spies in Disguise - 2019.m4v
2020-03-30 20:44:32.097 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 8ms. http://192.168.1.140:8096/emby/Items/145386/PlaybackInfo?UserId=79c645d9f93c42a2a9b96f3b54fd6da9&starttimeticks=00000000&audiostreamindex=1&isplayback=true&maxstreamingbitrate=110000000&subtitlestreamindex=-1&mediasourceid=826809813734c9ee15818e4303b04a07
2020-03-30 20:44:33.060 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Items/145386/Images/Primary?maxHeight=350&tag=79966ae33f3a6971b56b3e0aa493f0ff&EnableImageEnhancers=false. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:33.060 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Items/145386/Images/Logo?maxWidth=400&tag=f126de0cbfd6eaa7478e02e45f930821. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:33.061 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 1ms. http://192.168.1.140:8096/emby/Items/145386/Images/Logo?maxWidth=400&tag=f126de0cbfd6eaa7478e02e45f930821
2020-03-30 20:44:33.061 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 2ms. http://192.168.1.140:8096/emby/Items/145386/Images/Primary?maxHeight=350&tag=79966ae33f3a6971b56b3e0aa493f0ff&EnableImageEnhancers=false
2020-03-30 20:44:33.510 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/Videos/145386/index.bif?width=320&mediaSourceId=826809813734c9ee15818e4303b04a07. Connection=close, Host=192.168.1.140:8096, User-Agent=Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:33.514 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/videos/145386/master.m3u8?DeviceId=155ff6e4-2452-5c7f-8fe6-183cf91f3c91&MediaSourceId=826809813734c9ee15818e4303b04a07&PlaySessionId=7a654fbee8b849d6a837eb9f5de8d466&VideoCodec=h264,mpeg1video,mpeg2video,hevc&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,opus,vorbis,lpcm&VideoBitrate=109803031&AudioBitrate=196969&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&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=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&opus-audiochannels=6. Host=192.168.1.140:8096, User-Agent=Roku/DVP-9.20 (309.20E04502A), Accept=*/*, Accept-Encoding=deflate, gzip
2020-03-30 20:44:33.531 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 17ms. http://192.168.1.140:8096/emby/videos/145386/master.m3u8?DeviceId=155ff6e4-2452-5c7f-8fe6-183cf91f3c91&MediaSourceId=826809813734c9ee15818e4303b04a07&PlaySessionId=7a654fbee8b849d6a837eb9f5de8d466&VideoCodec=h264,mpeg1video,mpeg2video,hevc&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,opus,vorbis,lpcm&VideoBitrate=109803031&AudioBitrate=196969&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&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=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&opus-audiochannels=6
2020-03-30 20:44:33.537 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/videos/145386/main.m3u8?DeviceId=155ff6e4-2452-5c7f-8fe6-183cf91f3c91&MediaSourceId=826809813734c9ee15818e4303b04a07&PlaySessionId=7a654fbee8b849d6a837eb9f5de8d466&VideoCodec=h264,mpeg1video,mpeg2video,hevc&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,opus,vorbis,lpcm&VideoBitrate=109803031&AudioBitrate=196969&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&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=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&opus-audiochannels=6. Host=192.168.1.140:8096, User-Agent=Roku/DVP-9.20 (309.20E04502A), Accept=*/*, Accept-Encoding=deflate, gzip
2020-03-30 20:44:33.695 Info HttpServer: HTTP Response 200 to 192.168.1.161. Time: 158ms. http://192.168.1.140:8096/emby/videos/145386/main.m3u8?DeviceId=155ff6e4-2452-5c7f-8fe6-183cf91f3c91&MediaSourceId=826809813734c9ee15818e4303b04a07&PlaySessionId=7a654fbee8b849d6a837eb9f5de8d466&VideoCodec=h264,mpeg1video,mpeg2video,hevc&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,opus,vorbis,lpcm&VideoBitrate=109803031&AudioBitrate=196969&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&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=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&opus-audiochannels=6
2020-03-30 20:44:33.780 Info HttpServer: HTTP POST http://192.168.1.140:8096/emby/Sessions/Playing. UserAgent: Roku/DVP-9.20 (309.20E04502A)
2020-03-30 20:44:33.814 Info SessionManager: Playback start reported by app Roku SG 3.0.212 playing Spies in Disguise. Started at 0 ms
2020-03-30 20:44:33.817 Info HttpServer: HTTP Response 204 to 192.168.1.161. Time: 37ms. http://192.168.1.140:8096/emby/Sessions/Playing
2020-03-30 20:44:34.214 Info HttpServer: HTTP GET http://192.168.1.140:8096/emby/videos/145386/hls1/main/0.ts?DeviceId=155ff6e4-2452-5c7f-8fe6-183cf91f3c91&MediaSourceId=826809813734c9ee15818e4303b04a07&PlaySessionId=7a654fbee8b849d6a837eb9f5de8d466&VideoCodec=h264,mpeg1video,mpeg2video,hevc&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,opus,vorbis,lpcm&VideoBitrate=109803031&AudioBitrate=196969&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&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=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&opus-audiochannels=6. Host=192.168.1.140:8096, User-Agent=Roku/DVP-9.20 (309.20E04502A), Accept=*/*
2020-03-30 20:44:34.333 Info DynamicHlsService: ProcessRun 'StreamTranscode 074423' Execute: /Applications/EmbyServer.app/Contents/MacOS/ffmpeg -loglevel +timing -y -print_graphs_file /Users/scaryfast/emby-server/logs/ffmpeg-directstream-07442333-7686-444a-9d3d-ef7b4afaff4f_1graph.txt -copyts -start_at_zero -f m4v -noaccurate_seek -c:v:0 h264 -c:v:1 mjpeg -c:v:2 mjpeg -i "/Volumes/Drobo5N/drb154901a00351/1/Drobo-Backup/Movies/Spies in Disguise - 2019.m4v" -map 0:0 -map 0:1 -sn -c:v:0 copy -bsf:v:0 h264_mp4toannexb -c:a:0 copy -metadata:s:a:0 language=eng -disposition:a:0 default -copypriorss:a:0 0 -max_delay 5000000 -avoid_negative_ts disabled -f segment -map_metadata -1 -map_chapters -1 -segment_format mpegts -segment_list /Users/scaryfast/emby-server/transcoding-temp/A293F8.m3u8 -segment_list_type m3u8 -segment_time 3 -segment_start_number 0 -break_non_keyframes 1 -individual_header_trailer 0 -write_header_trailer 0 -segment_write_temp 1 "/Users/scaryfast/emby-server/transcoding-temp/A293F8_%d.ts"
2020-03-30 20:44:35.811 Info DynamicHlsService: AppendExtraLogData - Read graph file: /Users/scaryfast/emby-server/logs/ffmpeg-directstream-07442333-7686-444a-9d3d-ef7b4afaff4f_1graph.txt
2020-03-30 20:44:35.820 Info DynamicHlsService: AppendExtraLogData - Deserialized GraphData fileStream: {0:n} bytes Graph Count: 0
2020-03-30 20:44:35.820 Info DynamicHlsService: AppendExtraLogData - File Deleted
2020-03-30 20:44:35.831 Error HttpServer: Error processing request
    *** Error Report ***
    Version: 4.4.0.40
    Command line: /Applications/EmbyServer.app/Contents/MacOS/EmbyServer.dll
    Operating system: Unix 19.3.0.0
    64-Bit OS: True
    64-Bit Process: True
    User Interactive: True
    Runtime: file:///Applications/EmbyServer.app/Contents/MacOS/System.Private.CoreLib.dll
    System.Environment.Version: 3.1.2
    Processor count: 4
    Program data path: /Users/scaryfast/emby-server
    Application directory: /Applications/EmbyServer.app/Contents/MacOS
    System.Exception: System.Exception: Error starting ffmpeg
     at Emby.Server.MediaEncoding.Api.BaseStreamingService.StartFfMpeg(StreamState state, String outputPath, CancellationTokenSource cancellationTokenSource, Boolean acquireResources)
     at Emby.Server.MediaEncoding.Api.Hls.DynamicHlsService.GetDynamicSegment(StreamRequest request, String playlistId, String segmentId, Int32 subtitleStreamIndex)
     at Emby.Server.Implementations.Services.ServiceController.GetTaskResult(Task task)
     at Emby.Server.Implementations.Services.ServiceHandler.ProcessRequestAsync(HttpListenerHost appHost, IRequest httpReq, IResponse httpRes, RestPath restPath, String responseContentType, CancellationToken cancellationToken)
     at Emby.Server.Implementations.HttpServer.HttpListenerHost.RequestHandler(IRequest httpReq, ReadOnlyMemory`1 urlString, ReadOnlyMemory`1 localPath, CancellationToken cancellationToken)
    Source: Emby.Server.MediaEncoding
    TargetSite: Void MoveNext()

Link to comment
Share on other sites

Hi there, I apologize for this issue. The 4.4 release has a problem with conversion of m4v files. We'll be getting a 4.4.1 update out to resolve this. Thanks.

  • Like 1
Link to comment
Share on other sites

scaryfast

@@Luke 4.4.1 did NOT resolve the issue.  Please advise.

 

2020-04-04 09:35:59.546 Info DynamicHlsService: ProcessRun 'StreamTranscode fcb535' Execute: /Applications/EmbyServer.app/Contents/MacOS/ffmpeg -loglevel +timing -y -print_graphs_file /Users/scaryfast/emby-server/logs/ffmpeg-directstream-fcb535c4-7bb6-45ac-ac87-1e1aa9a9d844_1graph.txt -copyts -start_at_zero -f m4v -noaccurate_seek -c:v:0 h264 -c:v:1 mjpeg -c:v:2 mjpeg -i "/Volumes/Drobo5N/drb154901a00351/1/Drobo-Backup/Movies/moviename - 2020.m4v" -map 0:0 -map 0:1 -sn -c:v:0 copy -bsf:v:0 h264_mp4toannexb -c:a:0 copy -metadata:s:a:0 language=eng -disposition:a:0 default -copypriorss:a:0 0 -max_delay 5000000 -avoid_negative_ts disabled -f segment -map_metadata -1 -map_chapters -1 -segment_format mpegts -segment_list /Users/scaryfast/emby-server/transcoding-temp/DFD62C.m3u8 -segment_list_type m3u8 -segment_time 3 -segment_start_number 0 -break_non_keyframes 1 -individual_header_trailer 0 -write_header_trailer 0 -segment_write_temp 1 "/Users/scaryfast/emby-server/transcoding-temp/DFD62C_%d.ts"

2020-04-04 09:36:00.170 Info DynamicHlsService: AppendExtraLogData - Read graph file: /Users/scaryfast/emby-server/logs/ffmpeg-directstream-fcb535c4-7bb6-45ac-ac87-1e1aa9a9d844_1graph.txt
2020-04-04 09:36:00.177 Info DynamicHlsService: AppendExtraLogData - Deserialized GraphData fileStream: {0:n} bytes Graph Count: 0
2020-04-04 09:36:00.178 Info DynamicHlsService: AppendExtraLogData - File Deleted
2020-04-04 09:36:00.220 Error HttpServer: Error processing request
    *** Error Report ***
    Version: 4.4.1.0
    Command line: /Applications/EmbyServer.app/Contents/MacOS/EmbyServer.dll -psn_0_2241059 -noautorunwebapp
    Operating system: Unix 19.4.0.0
    64-Bit OS: True
    64-Bit Process: True
    User Interactive: True
    Runtime: file:///Applications/EmbyServer.app/Contents/MacOS/System.Private.CoreLib.dll
    System.Environment.Version: 3.1.2
    Processor count: 4
    Program data path: /Users/scaryfast/emby-server
    Application directory: /Applications/EmbyServer.app/Contents/MacOS
    System.Exception: System.Exception: Error starting ffmpeg
     at Emby.Server.MediaEncoding.Api.BaseStreamingService.StartFfMpeg(StreamState state, String outputPath, CancellationTokenSource cancellationTokenSource, Boolean acquireResources)
     at Emby.Server.MediaEncoding.Api.Hls.DynamicHlsService.GetDynamicSegment(StreamRequest request, String playlistId, String segmentId, Int32 subtitleStreamIndex)
     at Emby.Server.Implementations.Services.ServiceController.GetTaskResult(Task task)
     at Emby.Server.Implementations.Services.ServiceHandler.ProcessRequestAsync(HttpListenerHost appHost, IRequest httpReq, IResponse httpRes, RestPath restPath, String responseContentType, CancellationToken cancellationToken)
     at Emby.Server.Implementations.HttpServer.HttpListenerHost.RequestHandler(IRequest httpReq, ReadOnlyMemory`1 urlString, ReadOnlyMemory`1 localPath, CancellationToken cancellationToken)
    Source: Emby.Server.MediaEncoding
    TargetSite: Void MoveNext()

Link to comment
Share on other sites

Ok yes there's still an issue with certain m4v files. We'll be getting a 4.4.2 update out in the coming days. Thanks.

Link to comment
Share on other sites

scaryfast

@@Luke I see a bunch of 4.4.2 releases 4.4.2.0 but I dont see a release for MacOS and the main page is still linked to 4.4.1.

 

Which version should I install to test.

Link to comment
Share on other sites

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 account

Sign in

Already have an account? Sign in here.

Sign In Now
×
×
  • Create New...