MaccaOz 0 Posted February 2, 2018 Posted February 2, 2018 Using my Apple TV some shows play for a few moments then stops, more noticeably toward the end of the file. Is this a network performance issue, or a problem with Transcoding? More complete logs are attached. Thanx for any help! 2018-02-02 16:38:41.849 Info App: Profile: VideoAudioCodecProfile, DirectPlay=false. Reason=Unknown Profile.AudioProfile Condition: NotEquals. ConditionValue: HE-AAC. IsRequired: True. Path: O:\Storage3\TV\The X-Files\Season 7\11.mp4 2018-02-02 16:38:41.849 Info HttpServer: HTTP Response 200 to 192.168.10.48. Time: 103ms. http://192.168.10.199:8096/emby/Items/e69cc27043479baa0afdff5778ca418c/PlaybackInfo?UserId=ddc1cfd5f6ae5a0a255cb32c2646b213&StartTimeTicks=0&AutoOpenLiveStream=true&MaxStreamingBitrate=140000000 2018-02-02 16:38:41.873 Info HttpServer: HTTP Response 200 to 192.168.10.48. Time: 439ms. http://192.168.10.199:8096/emby/Shows/NextUp?userId=ddc1cfd5f6ae5a0a255cb32c2646b213&limit=2&excludeLocationTypes=Virtual 2018-02-02 16:38:41.890 Info HttpServer: HTTP GET http://192.168.10.199:8096/emby/Users/ddc1cfd5f6ae5a0a255cb32c2646b213/Items?recursive=true&limit=1&includeItemTypes=Movie&filters=IsResumable&sortBy=DatePlayed&sortOrder=Descending. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0 2018-02-02 16:38:42.257 Info HttpServer: HTTP Response 200 to 192.168.10.48. Time: 367ms. http://192.168.10.199:8096/emby/Users/ddc1cfd5f6ae5a0a255cb32c2646b213/Items?recursive=true&limit=1&includeItemTypes=Movie&filters=IsResumable&sortBy=DatePlayed&sortOrder=Descending 2018-02-02 16:38:42.274 Info HttpServer: HTTP GET http://192.168.10.199:8096/emby/Users/ddc1cfd5f6ae5a0a255cb32c2646b213/Items?recursive=true&limit=3&includeItemTypes=Movie&filters=IsUnplayed&sortBy=DateCreated&sortOrder=Descending. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0 2018-02-02 16:38:42.572 Info HttpServer: HTTP Response 200 to 192.168.10.48. Time: 298ms. http://192.168.10.199:8096/emby/Users/ddc1cfd5f6ae5a0a255cb32c2646b213/Items?recursive=true&limit=3&includeItemTypes=Movie&filters=IsUnplayed&sortBy=DateCreated&sortOrder=Descending 2018-02-02 16:38:42.876 Info HttpServer: HTTP Response 204 to 192.168.10.48. Time: 1443ms (slow). http://192.168.10.199:8096/emby/Sessions/Playing/Stopped 2018-02-02 16:38:44.200 Info App: Transcoding kill timer stopped for JobId 6e8665bc1d8745f5a3dac49dd7147bae PlaySessionId bc80249e17984bdca777f134ad71a15d. Killing transcoding 2018-02-02 16:38:44.200 Info App: Deleting partial stream file(s) C:\Temp\transcoding-temp\00f086882b5f3f8bb6bdc7621b846148.m3u8 2018-02-02 16:38:46.093 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/System/Configuration. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 2018-02-02 16:38:46.129 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/Plugins/SecurityInfo. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 2018-02-02 16:38:46.145 Info HttpServer: HTTP Response 200 to 192.168.10.1. Time: 16ms. http://pmc.chickenkiller.com:8096/emby/Plugins/SecurityInfo 2018-02-02 16:38:46.145 Info HttpServer: HTTP Response 200 to 192.168.10.1. Time: 53ms. http://pmc.chickenkiller.com:8096/emby/System/Configuration 2018-02-02 16:38:47.507 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/Users/fee3d563143d449e990e057ab338f6f0. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 2018-02-02 16:38:47.508 Info HttpServer: HTTP Response 200 to 192.168.10.1. Time: 2ms. http://pmc.chickenkiller.com:8096/emby/Users/fee3d563143d449e990e057ab338f6f0 2018-02-02 16:38:47.522 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/System/Logs. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 2018-02-02 16:38:47.522 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/System/Configuration. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 2018-02-02 16:38:47.523 Info HttpServer: HTTP Response 200 to 192.168.10.1. Time: 1ms. http://pmc.chickenkiller.com:8096/emby/System/Configuration 2018-02-02 16:38:47.524 Info HttpServer: HTTP Response 200 to 192.168.10.1. Time: 3ms. http://pmc.chickenkiller.com:8096/emby/System/Logs 2018-02-02 16:38:51.725 Info HttpServer: HTTP GET http://pmc.chickenkiller.com:8096/emby/System/Logs/Log?name=server-63653126400.txt. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_13_2) AppleWebKit/604.4.7 (KHTML, like Gecko) Version/11.0.2 Safari/604.4.7 EmbyServerLog.txt Transcoding.txt
MaccaOz 0 Posted February 5, 2018 Author Posted February 5, 2018 (edited) Just a 4Tb WD Red HDD with all my movies and TV shows. Should I put the temp drive on the same disk? At the moment the temp drive is my SSD which i thought would be quicker. Edited February 5, 2018 by MaccaOz
alekdavis 2 Posted February 6, 2018 Posted February 6, 2018 I have a similar issue only with Android client: playback stops after a few minutes. If I restart and fast forward, it will play a bit longer but stop again. The log file says that the server forced the socket to close. The transcoding log has this error: frame=77734 fps=333 q=21.0 size= 1367623kB time=00:54:02.43 bitrate=3455.3kbits/s speed=13.9x [h264 @ 00000182ed489540] Invalid NAL unit size (37499 > 28480). [h264 @ 00000182ed489540] Error splitting the input into NAL units. file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid argument frame=77773 fps=271 q=21.0 size= 1367623kB time=00:54:04.10 bitrate=3453.5kbits/s speed=11.3x file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid argument [mov,mp4,m4a,3gp,3g2,mj2 @ 00000182ed42b500] stream 2, offset 0x76abd5fc: partial file file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid data found when processing input The movies plays fine in VLC.
Luke 42083 Posted February 6, 2018 Posted February 6, 2018 I have a similar issue only with Android client: playback stops after a few minutes. If I restart and fast forward, it will play a bit longer but stop again. The log file says that the server forced the socket to close. The transcoding log has this error: frame=77734 fps=333 q=21.0 size= 1367623kB time=00:54:02.43 bitrate=3455.3kbits/s speed=13.9x [h264 @ 00000182ed489540] Invalid NAL unit size (37499 > 28480). [h264 @ 00000182ed489540] Error splitting the input into NAL units. file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid argument frame=77773 fps=271 q=21.0 size= 1367623kB time=00:54:04.10 bitrate=3453.5kbits/s speed=11.3x file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid argument [mov,mp4,m4a,3gp,3g2,mj2 @ 00000182ed42b500] stream 2, offset 0x76abd5fc: partial file file:\\nas\Movies\Movies\Movies (EN)\xxx.m4v: Invalid data found when processing input The movies plays fine in VLC. Please attach the complete emby server log and ffmpeg, thanks.
alekdavis 2 Posted February 6, 2018 Posted February 6, 2018 Attached server and ffmpeg transcoding log files (I masked personal info in the files). emby_ffmpeg-transcode.log emby_server.log
Luke 42083 Posted February 6, 2018 Posted February 6, 2018 Attached server and ffmpeg transcoding log files (I masked personal info in the files). You may want to re-encode that file as it looks like there's something that ffmpeg is complaining about: [mov,mp4,m4a,3gp,3g2,mj2 @ 000001fe904ab500] stream 2, offset 0x2f797a9e: partial file file:\\****\Movies\*** ************* ******* (****)\*** ************* ******* (****).m4v: Invalid data found when processing input [mov,mp4,m4a,3gp,3g2,mj2 @ 000001fe904ab500] stream 2, offset 0x2f797c2c: partial file file:\\****\Movies\*** ************* ******* (****)\*** ************* ******* (****).m4v: Invalid data found when processing input In fact, first we tried to direct play, the client video player didn't like it so we automatically switched to transcoding, then ffmpeg had a problem with it as well and that's what led you to us.
alekdavis 2 Posted February 7, 2018 Posted February 7, 2018 You may want to re-encode that file as it looks like there's something that ffmpeg is complaining about: [mov,mp4,m4a,3gp,3g2,mj2 @ 000001fe904ab500] stream 2, offset 0x2f797a9e: partial file file:\\****\Movies\*** ************* ******* (****)\*** ************* ******* (****).m4v: Invalid data found when processing input [mov,mp4,m4a,3gp,3g2,mj2 @ 000001fe904ab500] stream 2, offset 0x2f797c2c: partial file file:\\****\Movies\*** ************* ******* (****)\*** ************* ******* (****).m4v: Invalid data found when processing input In fact, first we tried to direct play, the client video player didn't like it so we automatically switched to transcoding, then ffmpeg had a problem with it as well and that's what led you to us. If the file is unplayable, I'm wondering why VLC has no problem playing it. Also, if it were unplayable, I'd assume Emby to crash on a specific frame consistently, which does not seem to be the case (once I restart replay and advance to the crashing point, it plays past it, but then crashes a couple of minutes later). It would be nice if there were a tool to validate the media files, or at least to have a message suggesting that the file is unplayable in Emby.
MaccaOz 0 Posted February 7, 2018 Author Posted February 7, 2018 No it is not a network drive, just a local HDD. Drive read write performance seems fine if thats your thoughts.
Luke 42083 Posted February 7, 2018 Posted February 7, 2018 If the file is unplayable, I'm wondering why VLC has no problem playing it. Also, if it were unplayable, I'd assume Emby to crash on a specific frame consistently, which does not seem to be the case (once I restart replay and advance to the crashing point, it plays past it, but then crashes a couple of minutes later). It would be nice if there were a tool to validate the media files, or at least to have a message suggesting that the file is unplayable in Emby. VLC is not the best measuring stick because it has been designed over the years to be highly resilient to whatever you throw at it. Browser video players are much more strict.
MaccaOz 0 Posted February 7, 2018 Author Posted February 7, 2018 Do you think my problem related back to bad media?
MaccaOz 0 Posted February 7, 2018 Author Posted February 7, 2018 Some additional information, the same file plays fine when viewing through Emby in iOS and also using chrome on a laptop....
Luke 42083 Posted February 8, 2018 Posted February 8, 2018 Do you think my problem related back to bad media? I'm not sure yet. Can you produce more log examples? thanks.
MaccaOz 0 Posted February 9, 2018 Author Posted February 9, 2018 Don't think it can be bad media if the same fie plays fine using a different viewer ir iOS app or a web browser?? Could it be some problem with the Apple TV app? Seems elimination would point at that? Is there way to get logs form the TV App? What additional logs do you require? I attached full server log and transcoding log on the first post, would you like something else? Thanx for your help with this!
Luke 42083 Posted February 9, 2018 Posted February 9, 2018 I attached full server log and transcoding log on the first post, would you like something else? You did, thanks, but i would like to see more logs from other failing examples. Thanks !
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