Jump to content

Playlist skipping Files after a 10-12 seconds


yaksplat
 Share

Recommended Posts

I have playlist set up of many old cartoons for the kids.  I've just recently started using an apple TV and I've had an issue where some items on the playlist fail after 10 seconds or so.  All of the files have been viewed countless times, so the files are good, but I noticed an issue in the logs.  You notice that many stop at 10, 11 or 12 seconds. Other run the full course which is normally ~7 minutes.

 

full server log and ffmpeg logs attached.

Line 59640: 2018-03-25 13:19:40.502 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Plastics Inventor. Stopped at 428001 ms
	Line 61285: 2018-03-25 13:27:24.352 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Honey Harvester. Stopped at 434016 ms
	Line 61290: 2018-03-25 13:27:24.356 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Honey Harvester. Stopped at 0 ms
	Line 61308: 2018-03-25 13:27:34.638 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Beach Picnic. Stopped at 10001 ms
	Line 61310: 2018-03-25 13:27:34.641 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Beach Picnic. Stopped at 0 ms
	Line 61657: 2018-03-25 13:33:52.109 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Clown of the Jungle. Stopped at 376000 ms
	Line 61662: 2018-03-25 13:33:52.128 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Clown of the Jungle. Stopped at 0 ms
	Line 61685: 2018-03-25 13:34:02.811 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Hook, Lion and Sinker. Stopped at 10001 ms
	Line 61688: 2018-03-25 13:34:02.814 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Hook, Lion and Sinker. Stopped at 0 ms
	Line 62110: 2018-03-25 13:41:11.026 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Grin and Bear It. Stopped at 426001 ms
	Line 62115: 2018-03-25 13:41:11.030 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Grin and Bear It. Stopped at 0 ms
	Line 62140: 2018-03-25 13:41:23.036 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald Duck and the Gorilla. Stopped at 12001 ms
	Line 62143: 2018-03-25 13:41:23.040 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald Duck and the Gorilla. Stopped at 0 ms
	Line 62259: 2018-03-25 13:42:51.420 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald Duck and the Gorilla. Stopped at 56001 ms
	Line 62280: 2018-03-25 13:43:02.140 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Truant Officer Donald. Stopped at 70001 ms
	Line 62284: 2018-03-25 13:43:02.146 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Truant Officer Donald. Stopped at 0 ms
	Line 62706: 2018-03-25 13:50:50.781 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Penguin. Stopped at 467001 ms
	Line 62710: 2018-03-25 13:50:50.789 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Penguin. Stopped at 0 ms
	Line 62732: 2018-03-25 13:51:01.852 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Off Day. Stopped at 11001 ms
	Line 62735: 2018-03-25 13:51:01.856 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Off Day. Stopped at 0 ms
	Line 63169: 2018-03-25 13:58:40.715 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing A Good Time For A Dime. Stopped at 458001 ms
	Line 63172: 2018-03-25 13:58:40.721 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing A Good Time For A Dime. Stopped at 0 ms
	Line 63193: 2018-03-25 13:58:51.607 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Beezy Bear. Stopped at 0 ms
	Line 63196: 2018-03-25 13:58:51.614 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Beezy Bear. Stopped at 10001 ms
	Line 63565: 2018-03-25 14:05:43.006 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Grand Canyonscope. Stopped at 410001 ms
	Line 63570: 2018-03-25 14:05:43.010 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Grand Canyonscope. Stopped at 0 ms
	Line 63588: 2018-03-25 14:05:53.825 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Fall Out-Fall In. Stopped at 10001 ms
	Line 63591: 2018-03-25 14:05:53.828 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Fall Out-Fall In. Stopped at 0 ms
	Line 63966: 2018-03-25 14:12:49.138 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Commando Duck. Stopped at 414001 ms
	Line 63971: 2018-03-25 14:12:49.141 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Commando Duck. Stopped at 0 ms
	Line 63992: 2018-03-25 14:13:00.203 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 11001 ms
	Line 63996: 2018-03-25 14:13:00.211 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 0 ms
	Line 64390: 2018-03-25 14:19:58.069 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 410001 ms
	Line 64397: 2018-03-25 14:19:58.105 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 0 ms
	Line 64445: 2018-03-25 14:20:05.230 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 7001 ms
	Line 64451: 2018-03-25 14:20:05.432 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 0 ms
	Line 64466: 2018-03-25 14:20:18.941 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 3001 ms
	Line 64477: 2018-03-25 14:20:19.413 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Self Control. Stopped at 391913 ms
	Line 64534: 2018-03-25 14:21:10.264 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Flying Jalopy. Stopped at 442001 ms
	Line 64537: 2018-03-25 14:21:10.268 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Flying Jalopy. Stopped at 0 ms
	Line 64864: 2018-03-25 14:28:32.602 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Eyes Have It. Stopped at 442001 ms
	Line 64869: 2018-03-25 14:28:32.606 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Eyes Have It. Stopped at 0 ms
	Line 64886: 2018-03-25 14:28:43.496 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing No Sail. Stopped at 10001 ms
	Line 64890: 2018-03-25 14:28:43.501 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing No Sail. Stopped at 0 ms
	Line 65294: 2018-03-25 14:36:18.783 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Chef Donald. Stopped at 454000 ms
	Line 65299: 2018-03-25 14:36:18.786 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Chef Donald. Stopped at 0 ms
	Line 65316: 2018-03-25 14:36:29.614 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald and Pluto. Stopped at 10001 ms
	Line 65319: 2018-03-25 14:36:29.622 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald and Pluto. Stopped at 0 ms
	Line 65687: 2018-03-25 14:43:03.193 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Bee At The Beach. Stopped at 392001 ms
	Line 65690: 2018-03-25 14:43:03.197 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Bee At The Beach. Stopped at 0 ms
	Line 66039: 2018-03-25 14:50:22.342 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Village Smithy. Stopped at 438001 ms
	Line 66043: 2018-03-25 14:50:22.346 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Village Smithy. Stopped at 0 ms
	Line 66367: 2018-03-25 14:57:33.788 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Dude Duck. Stopped at 431001 ms
	Line 66371: 2018-03-25 14:57:33.792 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Dude Duck. Stopped at 0 ms
	Line 66393: 2018-03-25 14:57:45.687 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Happy Birthday. Stopped at 11001 ms
	Line 66396: 2018-03-25 14:57:45.691 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Happy Birthday. Stopped at 0 ms
	Line 66777: 2018-03-25 15:03:57.066 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing No Hunting. Stopped at 370001 ms
	Line 66780: 2018-03-25 15:03:57.069 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing No Hunting. Stopped at 0 ms
	Line 66799: 2018-03-25 15:04:08.187 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lighthouse Keeping. Stopped at 11001 ms
	Line 66802: 2018-03-25 15:04:08.189 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lighthouse Keeping. Stopped at 0 ms
	Line 67170: 2018-03-25 15:10:39.144 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Dream Voice. Stopped at 389001 ms
	Line 67175: 2018-03-25 15:10:39.149 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Dream Voice. Stopped at 0 ms
	Line 67194: 2018-03-25 15:10:49.893 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Dilemma. Stopped at 10001 ms
	Line 67197: 2018-03-25 15:10:49.896 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Dilemma. Stopped at 0 ms
	Line 67630: 2018-03-25 15:18:52.311 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Golden Eggs. Stopped at 480001 ms
	Line 67633: 2018-03-25 15:18:52.316 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Golden Eggs. Stopped at 0 ms
	Line 67655: 2018-03-25 15:19:04.892 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Lucky Day. Stopped at 12001 ms
	Line 67658: 2018-03-25 15:19:04.896 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Lucky Day. Stopped at 0 ms
	Line 67765: 2018-03-25 15:19:46.472 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Lucky Day. Stopped at 34001 ms
	Line 67857: 2018-03-25 15:19:51.809 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald in Mathmagic Land. Stopped at 1651000 ms
	Line 67862: 2018-03-25 15:19:51.816 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald in Mathmagic Land. Stopped at 0 ms
	Line 67883: 2018-03-25 15:20:03.895 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky Number. Stopped at 12000 ms
	Line 67887: 2018-03-25 15:20:03.901 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky Number. Stopped at 0 ms
	Line 68373: 2018-03-25 15:28:53.781 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Modern Inventions. Stopped at 528995 ms
	Line 68377: 2018-03-25 15:28:53.787 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Modern Inventions. Stopped at 0 ms
	Line 68717: 2018-03-25 15:36:03.653 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Plastics Inventor. Stopped at 429001 ms
	Line 68722: 2018-03-25 15:36:03.657 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Plastics Inventor. Stopped at 0 ms
	Line 68740: 2018-03-25 15:36:14.885 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Soup's On. Stopped at 11001 ms
	Line 68743: 2018-03-25 15:36:14.890 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Soup's On. Stopped at 0 ms
	Line 69119: 2018-03-25 15:42:47.769 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Sleepy Time Donald. Stopped at 392001 ms
	Line 69125: 2018-03-25 15:42:47.775 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Sleepy Time Donald. Stopped at 0 ms
	Line 69144: 2018-03-25 15:42:58.747 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Don's Fountain of Youth. Stopped at 11000 ms
	Line 69147: 2018-03-25 15:42:58.749 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Don's Fountain of Youth. Stopped at 0 ms
	Line 69564: 2018-03-25 15:50:39.444 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Hockey Champ. Stopped at 452001 ms
	Line 69568: 2018-03-25 15:50:39.448 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Hockey Champ. Stopped at 0 ms
	Line 69588: 2018-03-25 15:50:52.782 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Golf Game. Stopped at 13001 ms
	Line 69592: 2018-03-25 15:50:52.787 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Golf Game. Stopped at 0 ms
	Line 69977: 2018-03-25 15:57:50.530 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Golf Game. Stopped at 411001 ms
	Line 70001: 2018-03-25 15:57:51.043 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing How to Have an Accident at Work. Stopped at 415733 ms
	Line 70004: 2018-03-25 15:57:51.046 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing How to Have an Accident at Work. Stopped at 0 ms
	Line 70022: 2018-03-25 15:58:01.888 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Rugged Bear. Stopped at 10001 ms
	Line 70025: 2018-03-25 15:58:01.891 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Rugged Bear. Stopped at 0 ms
	Line 70446: 2018-03-25 16:06:20.394 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Donald's Vacation. Stopped at 495001 ms

Here's a failed cartoon

2018-03-25 15:42:47.776 Info HttpServer: HTTP Response 204 to 192.168.1.250. Time: 7ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 
2018-03-25 15:42:48.652 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Progress. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0
2018-03-25 15:42:48.656 Info HttpServer: HTTP Response 204 to 192.168.1.250. Time: 4ms. http://192.168.1.150:8096/emby/Sessions/Playing/Progress 
2018-03-25 15:42:58.220 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/videos/145cf09b3811c1941283121a3b3fedec/hls1/main/18.ts?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=145cf09b3811c1941283121a3b3fedec&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=7b9b32e7aab746b3b61c292432ee7aab&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=4060a6675aa8fc185cd8bc1ee54bbdb5&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported. Host=192.168.1.150:8096, X-Playback-Session-Id=EDDD0759-7BE0-453F-A0EB-7A44DDE8C3A3, Accept=*/*, User-Agent=AppleCoreMedia/1.0.0.15K600 (Apple TV; U; CPU OS 11_2_6 like Mac OS X; en_us), Accept-Language=en-us, Accept-Encoding=identity, Connection=keep-alive
2018-03-25 15:42:58.223 Debug App: Starting transcoding because currentTranscodingIndex=null
2018-03-25 15:42:58.223 Info App: C:\Users\jim\AppData\Roaming\Emby-Server\system\ffmpeg.exe -ss 00:01:48.000 -noaccurate_seek -f matroska,webm -i file:"\\GRUNKLE-HS\Disney Cartoons\Donald Duck - Disney Animated Shorts\Don's Fountain of Youth (1953)\Don's Fountain of Youth (1953).mkv" -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 copy -bsf:v h264_mp4toannexb -copyts -vsync -1 -codec:a:0 copy -copypriorss:a:0 0 -f segment -max_delay 5000000 -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 -start_at_zero -segment_time 6 -segment_time_delta -108 -individual_header_trailer 0 -break_non_keyframes 1 -segment_format mpegts -segment_list_type m3u8 -segment_start_number 18 -segment_list "C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\68780b3fbac442a3c3d499bd382a2983.m3u8" -y "C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\68780b3fbac442a3c3d499bd382a2983%d.ts"
2018-03-25 15:42:58.311 Info App: ffmpeg successfully started
2018-03-25 15:42:58.311 Info App: returning C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\68780b3fbac442a3c3d499bd382a298318.ts
2018-03-25 15:42:58.582 Info HttpResultFactory: Transmit file C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\68780b3fbac442a3c3d499bd382a298318.ts
2018-03-25 15:42:58.621 Info HttpServer: HTTP Response 500 to 192.168.1.250. Time: 401ms. http://192.168.1.150:8096/emby/videos/145cf09b3811c1941283121a3b3fedec/hls1/main/18.ts?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=145cf09b3811c1941283121a3b3fedec&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=7b9b32e7aab746b3b61c292432ee7aab&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=4060a6675aa8fc185cd8bc1ee54bbdb5&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported 
2018-03-25 15:42:58.655 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Progress. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0
2018-03-25 15:42:58.658 Info HttpServer: HTTP Response 204 to 192.168.1.250. Time: 3ms. http://192.168.1.150:8096/emby/Sessions/Playing/Progress 
2018-03-25 15:42:58.712 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/videos/36bab8066b819cf6f030a1bf7c0ff765/hls1/main/0.ts?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=36bab8066b819cf6f030a1bf7c0ff765&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=3f120f9bf62a4e4e8e5f105d5f6faa8b&SubtitleMethod=Hls&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=b9f9198408aa7ff833435cb014f5d631&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported. Host=192.168.1.150:8096, X-Playback-Session-Id=27025E49-F414-491B-A54A-23623EC91B5B, Accept=*/*, User-Agent=AppleCoreMedia/1.0.0.15K600 (Apple TV; U; CPU OS 11_2_6 like Mac OS X; en_us), Accept-Language=en-us, Accept-Encoding=identity, Connection=keep-alive
2018-03-25 15:42:58.715 Debug App: Starting transcoding because currentTranscodingIndex=null
2018-03-25 15:42:58.715 Info App: C:\Users\jim\AppData\Roaming\Emby-Server\system\ffmpeg.exe -noaccurate_seek -f matroska,webm -i file:"\\GRUNKLE-HS\Disney Cartoons\Donald Duck - Disney Animated Shorts\The Hockey Champ (1939)\The Hockey Champ (1939).mkv" -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 copy -bsf:v h264_mp4toannexb -copyts -vsync -1 -codec:a:0 copy -copypriorss:a:0 0 -f segment -max_delay 5000000 -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 -start_at_zero -segment_time 6  -individual_header_trailer 0 -break_non_keyframes 1 -segment_format mpegts -segment_list_type m3u8 -segment_start_number 0 -segment_list "C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\1c756b415e4cb0bfafba3926c533b962.m3u8" -y "C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\1c756b415e4cb0bfafba3926c533b962%d.ts"
2018-03-25 15:42:58.745 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Stopped. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0
2018-03-25 15:42:58.746 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Stopped. UserAgent: Emby/3 CFNetwork/893.14 Darwin/17.4.0
2018-03-25 15:42:58.747 Debug App: ReportPlaybackStopped PlaySessionId: 3f120f9bf62a4e4e8e5f105d5f6faa8b
2018-03-25 15:42:58.747 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Don's Fountain of Youth. Stopped at 11000 ms
2018-03-25 15:42:58.747 Debug App: ReportPlaybackStopped PlaySessionId: 3f120f9bf62a4e4e8e5f105d5f6faa8b
2018-03-25 15:42:58.748 Info HttpServer: HTTP Response 204 to 192.168.1.250. Time: 3ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 
2018-03-25 15:42:58.749 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Don's Fountain of Youth. Stopped at 0 ms
2018-03-25 15:42:58.751 Info HttpServer: HTTP Response 204 to 192.168.1.250. Time: 5ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 
2018-03-25 15:42:58.959 Info App: ffmpeg successfully started
2018-03-25 15:42:58.959 Info App: returning C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\1c756b415e4cb0bfafba3926c533b9620.ts
2018-03-25 15:42:59.354 Info HttpResultFactory: Transmit file C:\Users\jim\AppData\Roaming\Emby-Server\programdata\transcoding-temp\1c756b415e4cb0bfafba3926c533b9620.ts
2018-03-25 15:42:59.376 Info HttpServer: HTTP Response 200 to 192.168.1.250. Time: 664ms. http://192.168.1.150:8096/emby/videos/36bab8066b819cf6f030a1bf7c0ff765/hls1/main/0.ts?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=36bab8066b819cf6f030a1bf7c0ff765&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=3f120f9bf62a4e4e8e5f105d5f6faa8b&SubtitleMethod=Hls&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=b9f9198408aa7ff833435cb014f5d631&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported 
2018-03-25 15:42:59.418 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/videos/36bab8066b819cf6f030a1bf7c0ff765/hls1/main/1.ts?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=36bab8066b819cf6f030a1bf7c0ff765&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=3f120f9bf62a4e4e8e5f105d5f6faa8b&SubtitleMethod=Hls&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=b9f9198408aa7ff833435cb014f5d631&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported. Host=192.168.1.150:8096, X-Playback-Session-Id=27025E49-F414-491B-A54A-23623EC91B5B, Accept=*/*, User-Agent=AppleCoreMedia/1.0.0.15K600 (Apple TV; U; CPU OS 11_2_6 like Mac OS X; en_us), Accept-Language=en-us, Accept-Encoding=identity, Connection=keep-alive
2018-03-25 15:42:59.471 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/videos/4bc906d62a342aabd54e82f7cb7f2e59/master.m3u8?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=4bc906d62a342aabd54e82f7cb7f2e59&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=2c6ced1895c44660877a1e1921ee44bb&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=7a8d22d60ce5a710490098eb03ed3fe9&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported. Host=192.168.1.150:8096, X-Playback-Session-Id=9E8EEA39-D4D0-4E2A-ACC6-F26E5B001E38, Accept=*/*, User-Agent=AppleCoreMedia/1.0.0.15K600 (Apple TV; U; CPU OS 11_2_6 like Mac OS X; en_us), Accept-Language=en-us, Accept-Encoding=gzip, Connection=keep-alive
2018-03-25 15:42:59.476 Debug App: Master playlist: 
#EXTM3U
#EXT-X-VERSION:3
#EXT-X-INDEPENDENT-SEGMENTS
#EXT-X-STREAM-INF:BANDWIDTH=6023407,AVERAGE-BANDWIDTH=5019506,VIDEO-RANGE=SDR,CODECS="avc1.4d0028,mp4a.40.2",RESOLUTION=720x480,FRAME-RATE=59.940
main.m3u8?DeviceId=22E7B8AE-76FD-46A6-95A2-C51BB72523E2&MediaSourceId=4bc906d62a342aabd54e82f7cb7f2e59&VideoCodec=h264&AudioCodec=aac,ac3,mp3&AudioStreamIndex=1&VideoBitrate=139808000&AudioBitrate=192000&MaxWidth=3840&PlaySessionId=2c6ced1895c44660877a1e1921ee44bb&api_key=72995c60543d4abc901498cd5ab1ed47&EnableSubtitlesInManifest=true&RequireAvc=false&Tag=7a8d22d60ce5a710490098eb03ed3fe9&SegmentContainer=ts&BreakOnNonKeyFrames=True&h264-profile=high,main,baseline,constrainedbaseline&h264-deinterlace=true&h264-level=42&audiochannels=6&TranscodeReasons=ContainerNotSupported,VideoCodecNotSupported,AudioCodecNotSupported


server-63657532801.txt

ffmpeg-directstream-065c70e9-47ec-4c1e-ae96-e3ab9577c6c0.txt

Link to comment
Share on other sites

Hey @@yaksplat --

 

I'm one of the Apple TV devs but I'm not an expert on the server side. Taking a quick pass at the logs it looks like it's possible that the transcoding process may have aborted prematurely. @@ebr or @@Luke should be able to chime in here and give you more information.

Link to comment
Share on other sites

My guess is this is another variation of the HLS stream copy issue.  It usually manifests itself by jumping back into the item at the end of it but, with such short items, I can see how ending too soon could potentially be a side effect as well.

 

If I'm right, forcing them to transcode should make them play properly (set the bitrate in the app below their bitrate to test).

Link to comment
Share on other sites

I've found that this also happens with regular length shows (22 min).  Occasionally when it goes to play the episode that's next up, it'll crash out about 12 seconds in.

Link to comment
Share on other sites

I've found that this also happens with regular length shows (22 min).  Occasionally when it goes to play the episode that's next up, it'll crash out about 12 seconds in.

 

Can we look at the log files from an example of that? thanks.

Link to comment
Share on other sites

I'll have to wait for the next time this happens and grab the server log.  The log with the show that was affected isn't there anymore.

Link to comment
Share on other sites

@@Luke My son had this happen today while watching 20+ minute episodes of the Goldbergs.  Man that kid watched a lot of TV while off sick.

 

You can see a bunch of the stopping at roughly the 10 second mark.  All of the episodes were played via "next up" and not selecting individual episodes. Server Log Attached.

 

All of the ffmpeg logs are attached as well.  ffmpeg_logs_rar.txt is a rar file.

Line 156208: 2018-04-10 09:42:34.843 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing MTV Spring Break. Stopped at 1262000 ms
	Line 157538: 2018-04-10 10:05:22.879 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Dinner With The Goldbergs. Stopped at 1285001 ms
	Line 159281: 2018-04-10 10:27:00.223 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing I Caddyshacked the Pool. Stopped at 1261001 ms
	Line 160943: 2018-04-10 10:49:18.172 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Couples Costume. Stopped at 1264001 ms
	Line 160948: 2018-04-10 10:49:18.464 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Couples Costume. Stopped at 0 ms
	Line 160977: 2018-04-10 10:49:28.545 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky. Stopped at 9001 ms
	Line 160987: 2018-04-10 10:49:28.762 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky. Stopped at 0 ms
	Line 161015: 2018-04-10 10:49:40.958 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Goldbergs (2013).S03E08.In Conclusion, Thanksgiving.SDTV. Stopped at 12001 ms
	Line 162652: 2018-04-10 11:15:12.291 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky. Stopped at 1264000 ms
	Line 162657: 2018-04-10 11:15:12.410 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lucky. Stopped at 1264000 ms
	Line 163154: 2018-04-10 11:38:30.867 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Goldbergs (2013).S03E08.In Conclusion, Thanksgiving.SDTV. Stopped at 1266001 ms
	Line 163158: 2018-04-10 11:38:30.872 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Goldbergs (2013).S03E08.In Conclusion, Thanksgiving.SDTV. Stopped at 1266001 ms
	Line 163223: 2018-04-10 11:38:36.343 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Wingmom. Stopped at 4010 ms
	Line 166848: 2018-04-10 11:59:46.862 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Wingmom. Stopped at 1260000 ms
	Line 166852: 2018-04-10 11:59:47.169 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Wingmom. Stopped at 0 ms
	Line 166870: 2018-04-10 11:59:57.986 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing A Christmas Story. Stopped at 11001 ms
	Line 166874: 2018-04-10 11:59:57.998 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing A Christmas Story. Stopped at 0 ms
	Line 166933: 2018-04-10 12:00:00.355 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Tasty Boys. Stopped at 1001 ms
	Line 168972: 2018-04-10 12:36:28.962 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Circle of Driving (Pilot). Stopped at 636001 ms
	Line 169521: 2018-04-10 12:49:26.045 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Circle of Driving (Pilot). Stopped at 1290001 ms
	Line 170862: 2018-04-10 13:10:54.811 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Circle Of Driving Again. Stopped at 1263001 ms
	Line 170866: 2018-04-10 13:10:55.063 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Circle Of Driving Again. Stopped at 0 ms
	Line 171770: 2018-04-10 13:32:01.718 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Parents Just Don't Understand. Stopped at 1266001 ms
	Line 171774: 2018-04-10 13:32:02.044 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Parents Just Don't Understand. Stopped at 0 ms
	Line 171792: 2018-04-10 13:32:12.856 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing We Didn't Start The Fire. Stopped at 11001 ms
	Line 171796: 2018-04-10 13:32:12.862 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing We Didn't Start The Fire. Stopped at 0 ms
	Line 171875: 2018-04-10 13:32:25.188 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Goldberg Girls. Stopped at 10001 ms
	Line 172991: 2018-04-10 13:54:40.725 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing We Didn't Start The Fire. Stopped at 1264001 ms
	Line 172995: 2018-04-10 13:54:41.005 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing We Didn't Start The Fire. Stopped at 0 ms
	Line 173004: 2018-04-10 13:54:46.878 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing The Goldberg Girls. Stopped at 6000 ms
	Line 174182: 2018-04-10 14:15:57.403 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Hail Barry. Stopped at 1262001 ms
	Line 174186: 2018-04-10 14:15:57.733 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Hail Barry. Stopped at 0 ms
	Line 174413: 2018-04-10 14:43:22.006 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Adam Spielberg. Stopped at 10044 ms
	Line 174585: 2018-04-10 16:13:58.383 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Adam Spielberg. Stopped at 10044 ms
	Line 175631: 2018-04-10 16:34:53.634 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Let Us Pray. Stopped at 1222001 ms
	Line 182756: 2018-04-10 18:07:25.636 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Evan Almighty. Stopped at 5473000 ms
	Line 189827: 2018-04-10 18:21:51.498 Info SessionManager: Playback stopped reported by app tvOS 1.1.15 playing Lava. Stopped at 431001 ms

server-63658915201.txt

ffmpeg_logs_rar.txt

Edited by yaksplat
Link to comment
Share on other sites

  • 6 months later...

I'm facing the same issue. Is there already a solution available instead of watching in low quality to force the transcoding?

Thanks in advance.

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
 Share

×
×
  • Create New...