Starting Video half way through.

Plex Players Gaming Consoles
21

We're aware of the issue, but not (yet) the reason why. Obviously will continue to look into it.

Thanks for the reports.

22

Time to make a sticky thread of "known issues"?

23

Redacted logs relating to this here (started at about 75% of the way through)

Feb 10, 2015 22:02:42:350 [14132] DEBUG - Request: [192.168.98.145:49783] GET /video/:/transcode/universal/start.m3u8?path=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F1944&mediaIndex=0&partIndex=0&protocol=hls&offset=0&fastSeek=1&directPlay=0&directStream=1&videoQuality=60&videoResolution=1920x1080&maxVideoBitrate=8000&subtitleSize=100&audioBoost=100&session=qbdqzjf6nlqp&X-Plex-Client-Identifier=1hwzkjap5d8l&X-Plex-Product=Plex+for+Xbox+One&X-Plex-Device=Xbox+One&X-Plex-Platform=Xbox+One&X-Plex-Platform-Version=10.0&X-Plex-Version=1.0.0.13&X-Plex-Device-Name=XBOXLOUNGE&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx&X-Plex-Username=DaleFamily (4 live)
Feb 10, 2015 22:02:42:350 [14132] DEBUG -  * path => http://127.0.0.1:32400/library/metadata/1944
Feb 10, 2015 22:02:42:350 [14132] DEBUG -  * mediaIndex => 0
Feb 10, 2015 22:02:42:350 [14132] DEBUG -  * partIndex => 0
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * protocol => hls
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * offset => 0
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * fastSeek => 1
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * directPlay => 0
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * directStream => 1
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * videoQuality => 60
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * videoResolution => 1920x1080
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * maxVideoBitrate => 8000
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * subtitleSize => 100
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * audioBoost => 100
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * session => qbdqzjf6nlqp
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Client-Identifier => 1hwzkjap5d8l
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Product => Plex for Xbox One
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Device => Xbox One
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Platform => Xbox One
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Platform-Version => 10.0
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Version => 1.0.0.13
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Device-Name => XBOXLOUNGE
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Feb 10, 2015 22:02:42:351 [14132] DEBUG -  * X-Plex-Username => DaleFamily
Feb 10, 2015 22:02:42:351 [14132] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Feb 10, 2015 22:02:42:351 [14132] DEBUG - Came in with a super-token, authorization succeeded.
Feb 10, 2015 22:02:42:358 [14132] DEBUG - Using profile Xbox One
Feb 10, 2015 22:02:42:358 [14132] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/1944?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Feb 10, 2015 22:02:42:358 [14132] DEBUG - HTTP requesting to: http://127.0.0.1:32400/library/metadata/1944?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Feb 10, 2015 22:02:42:359 [12248] DEBUG - Request: [127.0.0.1:56187] GET /library/metadata/1944?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (4 live)
Feb 10, 2015 22:02:42:359 [12248] DEBUG -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Feb 10, 2015 22:02:42:359 [12248] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Feb 10, 2015 22:02:42:359 [12248] DEBUG - Came in with a super-token, authorization succeeded.
Feb 10, 2015 22:02:42:364 [12248] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Feb 10, 2015 22:02:42:364 [14132] DEBUG - MDE: analyzing video part 3285: mkv/h264/ac3/
Feb 10, 2015 22:02:42:365 [14132] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/ac3/
Feb 10, 2015 22:02:42:365 [14132] DEBUG - The Writing on the Wall - video.hasScalingMatrix limitation applies: 1 == 1
Feb 10, 2015 22:02:42:365 [14132] DEBUG - MDE: remuxing ac3 audio stream
Feb 10, 2015 22:02:42:366 [14132] DEBUG - MDE: selected media 0
Feb 10, 2015 22:02:42:366 [14132] DEBUG - [Universal] Using local file path instead of URL: [Redacted video filename]
Feb 10, 2015 22:02:42:366 [14132] DEBUG - [Universal] Remuxing to hls/mpegts/h264/ac3
Feb 10, 2015 22:02:42:366 [14132] DEBUG - Found session GUID of qbdqzjf6nlqp in session start.
Feb 10, 2015 22:02:42:366 [14132] DEBUG - Using session GUID qbdqzjf6nlqp for new transcode session.
Feb 10, 2015 22:02:42:366 [14132] DEBUG - Cleaning directory for session qbdqzjf6nlqp ()
Feb 10, 2015 22:02:42:633 [14152] DEBUG - Request: [192.168.98.145:49784] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/index.m3u8 (4 live)
Feb 10, 2015 22:02:42:633 [14152] DEBUG - MDE: analyzing video part 3285: mkv/h264/ac3/
Feb 10, 2015 22:02:42:634 [14152] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/ac3/
Feb 10, 2015 22:02:42:634 [14152] DEBUG - The Writing on the Wall - video.hasScalingMatrix limitation applies: 1 == 1
Feb 10, 2015 22:02:42:634 [14152] DEBUG - MDE: remuxing ac3 audio stream
Feb 10, 2015 22:02:42:634 [14152] DEBUG - MDE: selected media 0
Feb 10, 2015 22:02:42:634 [14152] DEBUG - [Universal] Using local file path instead of URL: [Redacted video filename]
Feb 10, 2015 22:02:42:634 [14152] DEBUG - [Universal] Remuxing to hls/mpegts/h264/ac3
Feb 10, 2015 22:02:42:634 [14152] DEBUG - Starting a transcode session qbdqzjf6nlqp at offset -1.0 (stopped=1)
Feb 10, 2015 22:02:42:635 [14152] DEBUG - Obtained video bitrate of 4110KBps from media analysis.
Feb 10, 2015 22:02:42:635 [14152] DEBUG - Scaled up video bitrate to 6741Kbps based on 150% fudge factor.
Feb 10, 2015 22:02:42:635 [14152] DEBUG - Clipped max bitrate to 6741Kbps based on limit client requested limit.
Feb 10, 2015 22:02:42:635 [14152] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\PlexNewTranscoder.exe -i "[Redacted video filename]" -threads "0" "-y" "-nostats" -segment_format "mpegts" -f "segment" -flags "-global_header" -segment_time "3" -segment_start_number "0" -segment_copyts "1" "-copyts" -loglevel "quiet" -loglevel_plex "error" -map_metadata "-1" -progressurl "http://127.0.0.1:32400/video/:/transcode/session/qbdqzjf6nlqp/progress" -vcodec "libx264" -crf "20" -pix_fmt "yuv420p" -maxrate "6741k" -bufsize "13482k" -preset "veryfast" -x264opts "cabac=0:8x8dct=1:bframes=0:subme=1:me_range=4:rc_lookahead=10:me=hex:8x8dct=0:partitions=none" -force_key_frames "expr:gte(t,0+n_forced*3)" "-sn" -filter_complex "[0:0]scale=w=iw:h=ih:force_original_aspect_ratio=decrease[n0];[n0]copy[out]" -map "[out]" -acodec "copy" -map "0:1" -max_delay "5000000" "media-%05d.ts" 
Feb 10, 2015 22:02:42:944 [11732] INFO - [Transcoder] Input #0, matroska,webm, from '[Redacted video filename]':
Feb 10, 2015 22:02:42:946 [14132] INFO - [Transcoder]     Stream #0:0(eng): Video: h264 (High), yuv420p(tv, bt709), 1280x720 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 2k tbc (default)
Feb 10, 2015 22:02:42:948 [12248] INFO - [Transcoder]     Stream #0:1(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s (default)
Feb 10, 2015 22:02:42:950 [11732] INFO - [Transcoder]     Stream #0:2(eng): Subtitle: subrip
Feb 10, 2015 22:02:42:967 [14152] DEBUG -  [FFMPEG] Duration: 2559
Feb 10, 2015 22:02:42:967 [14152] DEBUG - Read line, and done: 1
Feb 10, 2015 22:02:42:967 [14152] DEBUG - Started session successfully: qbdqzjf6nlqp
Feb 10, 2015 22:02:42:967 [14152] DEBUG - HLS: Building an M3U8 for 2559 total seconds with 3 seconds/segment, target duration of 3.
Feb 10, 2015 22:02:42:998 [14132] INFO - [Transcoder] Output #0, segment, to 'media-%05d.ts':
Feb 10, 2015 22:02:43:001 [12248] INFO - [Transcoder]     Stream #0:0: Video: h264 (libx264), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], q=-1--1, max. 6741 kb/s, 23.98 fps, 23.98 tbn, 23.98 tbc (default)
Feb 10, 2015 22:02:43:003 [14152] INFO - [Transcoder]     Stream #0:1: Audio: ac3, 48000 Hz, 5.1(side), 384 kb/s (default)
Feb 10, 2015 22:02:43:008 [11732] DEBUG - Request: [127.0.0.1:56195] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?width=1280&height=720 (4 live)
Feb 10, 2015 22:02:43:008 [11732] DEBUG -  * width => 1280
Feb 10, 2015 22:02:43:008 [11732] DEBUG -  * height => 720
Feb 10, 2015 22:02:43:009 [11732] DEBUG - We want 20 segments ahead, last returned was -1 and max is -1.
Feb 10, 2015 22:02:43:009 [11732] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:43:101 [14132] DEBUG - Request: [192.168.98.145:49785] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/index.m3u8 (4 live)
Feb 10, 2015 22:02:43:101 [14132] DEBUG - MDE: analyzing video part 3285: mkv/h264/ac3/
Feb 10, 2015 22:02:43:101 [14132] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/ac3/
Feb 10, 2015 22:02:43:102 [14132] DEBUG - The Writing on the Wall - video.hasScalingMatrix limitation applies: 1 == 1
Feb 10, 2015 22:02:43:102 [14132] DEBUG - MDE: remuxing ac3 audio stream
Feb 10, 2015 22:02:43:102 [14132] DEBUG - MDE: selected media 0
Feb 10, 2015 22:02:43:102 [14132] DEBUG - [Universal] Using local file path instead of URL: [Redacted video filename]
Feb 10, 2015 22:02:43:102 [14132] DEBUG - [Universal] Remuxing to hls/mpegts/h264/ac3
Feb 10, 2015 22:02:43:102 [14132] DEBUG - HLS: Building an M3U8 for 2559 total seconds with 3 seconds/segment, target duration of 3.
Feb 10, 2015 22:02:43:149 [14152] DEBUG - Request: [192.168.98.145:49786] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/00000.ts (4 live)
Feb 10, 2015 22:02:43:150 [14152] DEBUG - Asked for segment 0 from session.
Feb 10, 2015 22:02:43:514 [12248] DEBUG - Request: [127.0.0.1:56197] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?progress=0.1&size=-22&speed=5.8&remaining=437 (4 live)
Feb 10, 2015 22:02:43:514 [12248] DEBUG -  * progress => 0.1
Feb 10, 2015 22:02:43:514 [12248] DEBUG -  * size => -22
Feb 10, 2015 22:02:43:514 [12248] DEBUG -  * speed => 5.8
Feb 10, 2015 22:02:43:514 [12248] DEBUG -  * remaining => 437
Feb 10, 2015 22:02:43:517 [12248] DEBUG - We want 20 segments ahead, last returned was -1 and max is -1.
Feb 10, 2015 22:02:43:517 [12248] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:43:572 [14152] DEBUG - Returning segment 0 from session: C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-bd19810b-ac85-4d8c-a7af-d3e2e2683321\media-00000.ts
Feb 10, 2015 22:02:43:572 [14152] DEBUG - Content-Length of C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-bd19810b-ac85-4d8c-a7af-d3e2e2683321\media-00000.ts is 1064832.
Feb 10, 2015 22:02:44:014 [11732] DEBUG - Request: [127.0.0.1:56198] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?progress=0.3&size=-22&speed=10.0&remaining=346 (4 live)
Feb 10, 2015 22:02:44:014 [11732] DEBUG -  * progress => 0.3
Feb 10, 2015 22:02:44:014 [11732] DEBUG -  * size => -22
Feb 10, 2015 22:02:44:014 [11732] DEBUG -  * speed => 10.0
Feb 10, 2015 22:02:44:014 [11732] DEBUG -  * remaining => 346
Feb 10, 2015 22:02:44:018 [11732] DEBUG - HLS segment range: 0 - 1 average bitrate: 4.75 Mbps (segment size min/avg/max: 0.7/1.8/1.1
Feb 10, 2015 22:02:44:019 [11732] DEBUG - We want 20 segments ahead, last returned was 0 and max is 1.
Feb 10, 2015 22:02:44:019 [11732] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:44:073 [14132] DEBUG - Request: [192.168.98.145:49787] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/index.m3u8 (4 live)
Feb 10, 2015 22:02:44:074 [14132] DEBUG - MDE: analyzing video part 3285: mkv/h264/ac3/
Feb 10, 2015 22:02:44:074 [14132] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/ac3/
Feb 10, 2015 22:02:44:075 [14132] DEBUG - The Writing on the Wall - video.hasScalingMatrix limitation applies: 1 == 1
Feb 10, 2015 22:02:44:075 [14132] DEBUG - MDE: remuxing ac3 audio stream
Feb 10, 2015 22:02:44:075 [14132] DEBUG - MDE: selected media 0
Feb 10, 2015 22:02:44:075 [14132] DEBUG - [Universal] Using local file path instead of URL: [Redacted video filename]
Feb 10, 2015 22:02:44:075 [14132] DEBUG - [Universal] Remuxing to hls/mpegts/h264/ac3
Feb 10, 2015 22:02:44:075 [14132] DEBUG - HLS: Building an M3U8 for 2559 total seconds with 3 seconds/segment, target duration of 3.
Feb 10, 2015 22:02:44:117 [14152] DEBUG - Request: [192.168.98.145:49788] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/00601.ts (4 live)
Feb 10, 2015 22:02:44:118 [14152] DEBUG - Asked for segment 601 from session.
Feb 10, 2015 22:02:44:122 [14152] DEBUG - HLS segment range: 0 - 1 average bitrate: 4.75 Mbps (segment size min/avg/max: 0.7/1.8/1.1
Feb 10, 2015 22:02:44:122 [14152] DEBUG - We're in a seek: asked for 601, min/max available was 0/1
Feb 10, 2015 22:02:44:122 [14152] DEBUG - Segment #601 WON.
Feb 10, 2015 22:02:44:122 [14152] DEBUG - Killing job.
Feb 10, 2015 22:02:44:141 [14152] DEBUG - Job was already killed, not killing again.
Feb 10, 2015 22:02:44:141 [14152] DEBUG - Stopping transcode session qbdqzjf6nlqp
Feb 10, 2015 22:02:44:141 [14152] DEBUG - Cleaning directory for session qbdqzjf6nlqp (C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-bd19810b-ac85-4d8c-a7af-d3e2e2683321)
Feb 10, 2015 22:02:44:143 [14152] DEBUG - Starting a transcode session qbdqzjf6nlqp at offset 1803.0 (stopped=1)
Feb 10, 2015 22:02:44:144 [14152] DEBUG - Obtained video bitrate of 4110KBps from media analysis.
Feb 10, 2015 22:02:44:144 [14152] DEBUG - Scaled up video bitrate to 6741Kbps based on 150% fudge factor.
Feb 10, 2015 22:02:44:144 [14152] DEBUG - Clipped max bitrate to 6741Kbps based on limit client requested limit.
Feb 10, 2015 22:02:44:144 [14152] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\PlexNewTranscoder.exe -ss "1803" -i "[Redacted video filename]" -threads "0" "-y" "-nostats" -segment_format "mpegts" -f "segment" -flags "-global_header" -segment_time "3" -segment_start_number "601" -segment_copyts "1" "-copyts" -loglevel "quiet" -loglevel_plex "error" -map_metadata "-1" -progressurl "http://127.0.0.1:32400/video/:/transcode/session/qbdqzjf6nlqp/progress" -vcodec "libx264" -crf "20" -pix_fmt "yuv420p" -maxrate "6741k" -bufsize "13482k" -preset "veryfast" -x264opts "cabac=0:8x8dct=1:bframes=0:subme=1:me_range=4:rc_lookahead=10:me=hex:8x8dct=0:partitions=none" -force_key_frames "expr:gte(t,1803+n_forced*3)" "-sn" -filter_complex "[0:0]scale=w=iw:h=ih:force_original_aspect_ratio=decrease[n0];[n0]copy[out]" -map "[out]" -acodec "copy" -map "0:1" -max_delay "5000000" "media-%05d.ts" 
Feb 10, 2015 22:02:44:219 [12248] INFO - [Transcoder] Input #0, matroska,webm, from '[Redacted video filename]':
Feb 10, 2015 22:02:44:221 [11732] INFO - [Transcoder]     Stream #0:0(eng): Video: h264 (High), yuv420p(tv, bt709), 1280x720 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 2k tbc (default)
Feb 10, 2015 22:02:44:223 [14132] INFO - [Transcoder]     Stream #0:1(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s (default)
Feb 10, 2015 22:02:44:226 [11732] INFO - [Transcoder]     Stream #0:2(eng): Subtitle: subrip
Feb 10, 2015 22:02:44:249 [14152] DEBUG -  [FFMPEG] Duration: 2559
Feb 10, 2015 22:02:44:249 [14152] DEBUG - Read line, and done: 1
Feb 10, 2015 22:02:44:249 [14152] DEBUG - Started session successfully: qbdqzjf6nlqp
Feb 10, 2015 22:02:44:256 [14132] INFO - [Transcoder] Output #0, segment, to 'media-%05d.ts':
Feb 10, 2015 22:02:44:259 [11732] INFO - [Transcoder]     Stream #0:0: Video: h264 (libx264), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], q=-1--1, max. 6741 kb/s, 23.98 fps, 23.98 tbn, 23.98 tbc (default)
Feb 10, 2015 22:02:44:261 [14132] INFO - [Transcoder]     Stream #0:1: Audio: ac3, 48000 Hz, 5.1(side), 384 kb/s (default)
Feb 10, 2015 22:02:44:266 [12248] DEBUG - Request: [127.0.0.1:56206] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?width=1280&height=720 (4 live)
Feb 10, 2015 22:02:44:266 [12248] DEBUG -  * width => 1280
Feb 10, 2015 22:02:44:266 [12248] DEBUG -  * height => 720
Feb 10, 2015 22:02:44:267 [12248] DEBUG - We want 20 segments ahead, last returned was -1 and max is -1.
Feb 10, 2015 22:02:44:267 [12248] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:44:778 [11732] DEBUG - Request: [127.0.0.1:56207] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?progress=70.5&size=-22&speed=3609.9&remaining=0 (4 live)
Feb 10, 2015 22:02:44:778 [11732] DEBUG -  * progress => 70.5
Feb 10, 2015 22:02:44:778 [11732] DEBUG -  * size => -22
Feb 10, 2015 22:02:44:779 [11732] DEBUG -  * speed => 3609.9
Feb 10, 2015 22:02:44:779 [11732] DEBUG -  * remaining => 0
Feb 10, 2015 22:02:44:782 [11732] DEBUG - We want 20 segments ahead, last returned was -1 and max is 601.
Feb 10, 2015 22:02:44:782 [11732] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:44:875 [14152] DEBUG - Returning segment 601 from session: C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00601.ts
Feb 10, 2015 22:02:44:875 [14152] DEBUG - Content-Length of C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00601.ts is 1349840.
Feb 10, 2015 22:02:45:282 [14132] DEBUG - Request: [127.0.0.1:56208] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?progress=70.7&size=-22&speed=7.9&remaining=95 (4 live)
Feb 10, 2015 22:02:45:282 [14132] DEBUG -  * progress => 70.7
Feb 10, 2015 22:02:45:283 [14132] DEBUG -  * size => -22
Feb 10, 2015 22:02:45:283 [14132] DEBUG -  * speed => 7.9
Feb 10, 2015 22:02:45:283 [14132] DEBUG -  * remaining => 95
Feb 10, 2015 22:02:45:288 [14132] DEBUG - HLS segment range: 601 - 602 average bitrate: 8.34 Mbps (segment size min/avg/max: 1.3/3.1/1.8
Feb 10, 2015 22:02:45:288 [14132] DEBUG - We want 20 segments ahead, last returned was 601 and max is 602.
Feb 10, 2015 22:02:45:288 [14132] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Feb 10, 2015 22:02:45:299 [12248] DEBUG - Request: [192.168.98.145:49789] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/00602.ts (4 live)
Feb 10, 2015 22:02:45:300 [12248] DEBUG - Asked for segment 602 from session.
Feb 10, 2015 22:02:45:305 [12248] DEBUG - HLS segment range: 601 - 602 average bitrate: 8.34 Mbps (segment size min/avg/max: 1.3/3.1/1.8
Feb 10, 2015 22:02:45:305 [12248] DEBUG - Returning segment 602 from session: C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00602.ts
Feb 10, 2015 22:02:45:306 [12248] DEBUG - Content-Length of C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00602.ts is 1777164.
Feb 10, 2015 22:02:45:509 [14132] DEBUG - Request: [192.168.98.145:49790] GET /:/timeline?ratingKey=1944&key=%2Flibrary%2Fmetadata%2F1944&state=playing&time=0&duration=2559768 (4 live)
Feb 10, 2015 22:02:45:509 [14132] DEBUG -  * ratingKey => 1944
Feb 10, 2015 22:02:45:509 [14132] DEBUG -  * key => /library/metadata/1944
Feb 10, 2015 22:02:45:509 [14132] DEBUG -  * state => playing
Feb 10, 2015 22:02:45:509 [14132] DEBUG -  * time => 0
Feb 10, 2015 22:02:45:509 [14132] DEBUG -  * duration => 2559768
Feb 10, 2015 22:02:45:510 [14132] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Feb 10, 2015 22:02:45:510 [14132] DEBUG - Came in with a super-token, authorization succeeded.
Feb 10, 2015 22:02:45:510 [14132] DEBUG - Client [1hwzkjap5d8l] reporting timeline state playing, progress of 0/2559768ms for guid=, ratingKey=1944 url=, key=/library/metadata/1944, containerKey=, metadataId=1944
Feb 10, 2015 22:02:45:511 [14132] DEBUG - [Now] User is DaleFamily (ID: 1)
Feb 10, 2015 22:02:45:511 [14132] DEBUG - [Now] Device is Xbox One (XBOXLOUNGE).
Feb 10, 2015 22:02:45:511 [14132] DEBUG - [Now] Updated play state for /library/metadata/1944.
Feb 10, 2015 22:02:45:511 [14160] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/1944
Feb 10, 2015 22:02:45:511 [14160] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Feb 10, 2015 22:02:45:512 [14160] DEBUG - Came in with a super-token, authorization succeeded.
Feb 10, 2015 22:02:45:520 [14160] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Feb 10, 2015 22:02:45:520 [14160] DEBUG - Caching document http://127.0.0.1:32400/library/metadata/1944as 1f6990564958d09593d40bf097d760bd4be9be9e
Feb 10, 2015 22:02:45:521 [14160] DEBUG - [Now] Added metadata for /library/metadata/1944.
Feb 10, 2015 22:02:45:683 [12248] DEBUG - Request: [192.168.98.145:49791] GET /video/:/transcode/universal/session/qbdqzjf6nlqp/base/00603.t (4 live)
Feb 10, 2015 22:02:45:684 [12248] DEBUG - Asked for segment 603 from session.
Feb 10, 2015 22:02:45:689 [12248] DEBUG - HLS segment range: 601 - 603 average bitrate: 5.65 Mbps (segment size min/avg/max: 1.1/2.1/1.8
Feb 10, 2015 22:02:45:690 [12248] DEBUG - Returning segment 603 from session: C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00603.ts
Feb 10, 2015 22:02:45:690 [12248] DEBUG - Content-Length of C:\Users\Richard\AppData\Local\Temp\plex-transcode-qbdqzjf6nlqp-99ba69c7-ad99-4e0a-a5ef-6464db512ee5\media-00603.ts is 1110704.
Feb 10, 2015 22:02:45:798 [14152] DEBUG - Request: [127.0.0.1:56209] PUT /video/:/transcode/session/qbdqzjf6nlqp/progress?progress=70.8&size=-22&speed=8.9&remaining=89 (4 live)
Feb 10, 2015 22:02:45:799 [14152] DEBUG -  * progress => 70.8
Feb 10, 2015 22:02:45:799 [14152] DEBUG -  * size => -22
Feb 10, 2015 22:02:45:799 [14152] DEBUG -  * speed => 8.9
Feb 10, 2015 22:02:45:799 [14152] DEBUG -  * remaining => 89
24

@DaleFamily - Can you please wrap your log in code tags to shorten it up, or take it down and upload it as a text file attached. It's a lot to scroll through right in the post.

25

I have seen this a bunch also...has happened in all three revs of the xbox one app

26

Yes, same here. Movies & TV.

27

Happens to me a lot.

Any chance of a fix at any point? Or at least an update on whether the problem has been identified?

It's been three months now since any improvements to this app, other than to remove the dimming, and you can't really class that as an improvement tbh.

28

Ive had never had an issue. I use mp4 may it be MKV files?

29

We're aware of the problem, but not what causes it. We hope to have a fix or workaround for the next update. Thanks!

30

Overall Plex on my XBone works excellently, however, I am experiencing this problem occasionally with some films, usually 720p or 1080p (don't know if that is relevant). This does not happen with every film of that quality though.

Hopefully update soon? :)

31

I experienced the same issue this past weekend, when watching a movie.

I thought it was a bit odd that we didn't see any pre-real footage, and went straight into a scene. We didn't notice until the end credits as it started playing in, to be honest, a way that looked like a great edit and dramatic start to the film!  -_-

V: x264 MKV 1080p - 10654kbps

A: DTS 5.1 - 1509kbps

32

I see this as well, but rather than movies starting halfway through they start towards the very end. TV shows are fine though. All my movies are mp4, can provide more details if needed.

33

PMS logs would be great, along with the time it occurred. At the very least we'll try and detect when this skip happens, and correct, even if we can't get to the bottom of _why_ it's happening.

34

I'll try to repro when I get home later.

35

I'm getting this issue as well with mp4 tv shows. When are you guys gonna fix this? it's been months!

36

This has been happening for me as well recently. Any information you need just ask.

37

Yep - happening here too. I'll see what I can do.

38

Had this happen three or four times this weekend - any news on a fix?

39

Not yet, I'm afraid. We're still unable to reliably reproduce here and get to the bottom of this one. Will let you know when we do.

Sorry!

40

Thanks Dom!