search

mangui / flashls

HLS Flash Plugin/Player (Chromeless,OSMF,FlowPlayer,mediaelement.js,video.js,Clappr)
http://www.flashls.org
Mozilla Public License 2.0
751 stars 264 forks source link

Live HLS stream stops - need help to understand logs #493

Open arnaudleyder opened 8 years ago

arnaudleyder commented 8 years ago

Hi,

I have a live HLS stream: http://m-1.data.lt/m-1/smil:m-1.smil/playlist.m3u8 I am seeing an issue where our player based on OSMF/flashhls will stop playing video after about 15 minutes of playback and will enter infinite buffering. Below are the logs (latest Chrome 48 + Flash 20). I suspect it comes from:

GET http://m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155707.ts?time=1456142930198 net::ERR_CONTENT_LENGTH_MISMATCH VM66557:1 WARN:Parsing Error :HTTP 2OO but IO error, treat as parsing error VM66558:1 DEBUG:StreamBuffer.flushLastFragment, cannot flush, tag already pushed in NetStream VM66559:1 WARN:error parsing fragment, skip it and load next one VM66560:1 DEBUG:fragments skipped / max: 1/5

Because after that it just keeps trying to load fragments DEBUG:loadnextfragment() with a DEBUG:TS: cancel demux.

I would like to understand what it means and what could cause this issue. I have other live streams running without issue so I am guessing it could be a transcoding or segmenting issue but I would like to narrow down the source of this issue so any help on interpretting those logs would be appreciated.

DEBUG:level 0 playlist:

EXTM3U

EXT-X-VERSION:3

EXT-X-ALLOW-CACHE:NO

EXT-X-TARGETDURATION:11

EXT-X-MEDIA-SEQUENCE:155709

EXTINF:10.014,

media_w1652912314_b350000_155709.ts?time=1456142950445

EXTINF:9.987,

media_w1652912314_b350000_155710.ts?time=1456142950445

EXTINF:10.007,

media_w1652912314_b350000_155711.ts?time=1456142950445

VM66090:1 DEBUG:updateFragments: unknown PTS info for this level VM66091:1 DEBUG:Level 0 Live Playlist parsing finished: reload in 9738 ms 5VM66092:1 DEBUG:AVC: AUD,SEI,NDR slices VM66097:1 DEBUG:11 tags extracted VM66098:1 DEBUG:AutoBufferController:minBufferLength:22.892628205128204 VM66099:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:4.73/30.01/0.24/4.68/0.12/0.15/0.13/true/true VM66100:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967022/29967022/4.85 VM66101:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967169/29967169/4.99 VM66106:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:4.83/30.01/0.16/4.79/0.00/0.00/0.16/true/true VM66107:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:4.94/30.01/0.06/4.89/0.00/0.00/0.06/true/true VM66108:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:4.94/30.01/0.00/4.89/0.00/0.00/0.00/true/true VM66111:1 DEBUG:3 tags extracted VM66112:1 DEBUG:AutoBufferController:minBufferLength:23.393915448439355 VM66113:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:4.94/30.01/0.00/4.89/0.05/0.00/0.00/true/true VM66114:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967191/29967191/5.02 VM66115:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967237/29967237/5.06 VM66116:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.02/30.01/0.05/4.97/0.00/0.00/0.05/true/true 2VM66117:1 DEBUG:AVC: AUD,SEI,NDR slices VM66119:1 DEBUG:5 tags extracted VM66120:1 DEBUG:AutoBufferController:minBufferLength:23.489867498051442 VM66121:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.02/30.01/0.09/4.97/0.05/0.04/0.05/true/true VM66122:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967210/29967210/5.04 VM66123:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967307/29967307/5.13 VM66126:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.02/30.01/0.12/4.97/0.00/0.00/0.12/true/true VM66127:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.10/30.01/0.03/5.06/0.00/0.00/0.03/true/true VM66128:1 DEBUG:AVC: AUD,SEI,NDR slices VM66129:1 DEBUG:1 tags extracted VM66130:1 DEBUG:AutoBufferController:minBufferLength:24.371552403467295 VM66131:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.10/30.01/0.00/5.06/0.00/0.00/0.00/true/true VM66132:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967293/29967293/5.02 VM66133:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967293/29967293/5.02 5VM66135:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.10/30.01/0.01/5.06/0.00/0.00/0.01/true/true VM66140:1 DEBUG:AVC: AUD,SEI,NDR slices VM66141:1 DEBUG:4 tags extracted VM66142:1 DEBUG:AutoBufferController:minBufferLength:24.977888867525476 VM66143:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.10/30.01/0.01/5.06/0.05/0.00/0.01/true/true VM66144:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967330/29967330/5.15 VM66145:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967376/29967376/5.20 VM66146:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.12/30.01/0.08/5.08/0.00/0.00/0.08/true/true 2VM66147:1 DEBUG:AVC: AUD,SEI,NDR slices VM66149:1 DEBUG:8 tags extracted VM66150:1 DEBUG:AutoBufferController:minBufferLength:24.71072832802846 VM66151:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.12/30.01/0.12/5.08/0.12/0.04/0.08/true/true VM66152:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967375/29967375/5.20 VM66153:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967516/29967516/5.34 VM66154:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.12/30.01/0.22/5.08/0.00/0.00/0.22/true/true VM66157:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.21/30.01/0.13/5.17/0.00/0.00/0.13/true/true VM66158:1 DEBUG:AVC: AUD,SEI,NDR slices VM66159:1 DEBUG:1 tags extracted VM66160:1 DEBUG:AutoBufferController:minBufferLength:25.776421213277377 VM66161:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.31/30.01/0.03/5.27/0.00/0.00/0.03/true/true VM66162:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967459/29967459/5.14 VM66163:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967459/29967459/5.14 2VM66164:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.31/30.01/0.00/5.27/0.00/0.00/0.00/true/true VM66168:1 DEBUG:AVC: AUD,SEI,NDR slices VM66169:1 DEBUG:1 tags extracted VM66170:1 DEBUG:AutoBufferController:minBufferLength:26.158213474640423 VM66171:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.31/30.01/0.00/5.27/0.00/0.00/0.00/true/true VM66172:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967501/29967501/5.23 VM66173:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967501/29967501/5.23 2VM66174:1 DEBUG:AVC: AUD,SEI,NDR slices VM66176:1 DEBUG:5 tags extracted VM66177:1 DEBUG:AutoBufferController:minBufferLength:25.744916820702404 VM66178:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.31/30.01/0.06/5.27/0.05/0.04/0.01/true/true VM66179:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967539/29967539/5.36 VM66180:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967585/29967585/5.41 3VM66181:1 DEBUG:AVC: AUD,SEI,NDR slices VM66184:1 DEBUG:9 tags extracted VM66185:1 DEBUG:AutoBufferController:minBufferLength:25.296449810776714 VM66186:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.33/30.01/0.15/5.28/0.12/0.06/0.08/true/true VM66187:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967609/29967609/5.43 VM66188:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967724/29967724/5.55 VM66189:1 DEBUG:AVC: AUD,SEI,NDR slices VM66190:1 DEBUG:4 tags extracted VM66191:1 DEBUG:AutoBufferController:minBufferLength:25.168179391350773 VM66192:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.33/30.01/0.22/5.28/0.05/0.00/0.22/true/true VM66193:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967729/29967729/5.55 VM66194:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967794/29967794/5.62 4VM66195:1 DEBUG:AVC: AUD,SEI,NDR slices VM66199:1 DEBUG:10 tags extracted VM66200:1 DEBUG:AutoBufferController:minBufferLength:24.742966307745743 VM66201:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.42/30.01/0.31/5.38/0.12/0.13/0.20/true/true VM66202:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967770/29967770/5.59 VM66203:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29967933/29967933/5.76 4VM66206:1 DEBUG:AVC: AUD,SEI,NDR slices VM66210:1 DEBUG:10 tags extracted VM66211:1 DEBUG:AutoBufferController:minBufferLength:24.333672431332655 VM66212:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.52/30.01/0.35/5.48/0.12/0.12/0.24/true/true VM66213:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29967937/29967937/5.76 VM66214:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968073/29968073/5.90 VM66215:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.63/30.01/0.27/5.59/0.00/0.00/0.27/true/true VM66216:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.72/30.01/0.17/5.68/0.00/0.00/0.17/true/true VM66219:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.83/30.01/0.07/5.79/0.00/0.00/0.07/true/true 2VM66220:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.83/30.01/0.00/5.79/0.00/0.00/0.00/true/true 2VM66224:1 DEBUG:AVC: AUD,SEI,NDR slices VM66226:1 DEBUG:5 tags extracted VM66227:1 DEBUG:AutoBufferController:minBufferLength:25.082956259426847 VM66228:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.83/30.01/0.04/5.79/0.05/0.04/0.00/true/true VM66229:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968096/29968096/5.92 VM66230:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968144/29968144/5.97 63VM66231:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.92/30.01/0.05/5.88/0.00/0.00/0.05/true/true VM66296:1 DEBUG:level 0 playlist:

EXTM3U

EXT-X-VERSION:3

EXT-X-ALLOW-CACHE:NO

EXT-X-TARGETDURATION:11

EXT-X-MEDIA-SEQUENCE:155710

EXTINF:9.987,

media_w1652912314_b350000_155710.ts?time=1456142960520

EXTINF:10.007,

media_w1652912314_b350000_155711.ts?time=1456142960520

EXTINF:10.002,

media_w1652912314_b350000_155712.ts?time=1456142960520

VM66297:1 DEBUG:updateFragments: unknown PTS info for this level VM66298:1 DEBUG:Level 0 Live Playlist parsing finished: reload in 9698 ms 99VM66299:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.92/30.00/0.05/5.88/0.00/0.00/0.05/true/true VM66400:1 DEBUG:level 0 playlist:

EXTM3U

EXT-X-VERSION:3

EXT-X-ALLOW-CACHE:NO

EXT-X-TARGETDURATION:11

EXT-X-MEDIA-SEQUENCE:155711

EXTINF:10.007,

media_w1652912314_b350000_155711.ts?time=1456142970617

EXTINF:10.002,

media_w1652912314_b350000_155712.ts?time=1456142970617

EXTINF:9.995,

media_w1652912314_b350000_155713.ts?time=1456142970617

VM66401:1 DEBUG:updateFragments: unknown PTS info for this level VM66402:1 DEBUG:Level 0 Live Playlist parsing finished: reload in 9719 ms 19VM66403:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.92/30.00/0.05/5.88/0.00/0.00/0.05/true/true VM66424:1 DEBUG:AVC: AUD,SPS,PPS,SEI,IDR slices VM66425:1 DEBUG:AVC: H264 Baseline level 30 VM66426:1 DEBUG:AVC: AUD,SEI,NDR slices VM66427:1 DEBUG:5 tags extracted VM66428:1 DEBUG:AutoBufferController:minBufferLength:55.549113798244164 VM66429:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.92/30.00/0.09/5.88/0.05/0.04/0.05/true/true VM66430:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968166/29968166/5.99 VM66431:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU_K/29968225/29968225/6.05 2VM66432:1 DEBUG:AVC: AUD,SEI,NDR slices VM66434:1 DEBUG:8 tags extracted VM66435:1 DEBUG:AutoBufferController:minBufferLength:54.4705310880829 VM66436:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:5.92/30.00/0.17/5.88/0.12/0.04/0.13/true/true VM66437:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968236/29968236/6.06 VM66438:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968351/29968351/6.18 2VM66439:1 DEBUG:AVC: AUD,SEI,NDR slices VM66441:1 DEBUG:5 tags extracted VM66442:1 DEBUG:AutoBufferController:minBufferLength:54.02657700928594 VM66443:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.01/30.00/0.21/5.97/0.05/0.06/0.16/true/true VM66444:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968329/29968329/6.15 VM66445:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968421/29968421/6.25 5VM66446:1 DEBUG:AVC: AUD,SEI,NDR slices VM66451:1 DEBUG:14 tags extracted VM66452:1 DEBUG:AutoBufferController:minBufferLength:52.43841982958947 VM66453:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.11/30.00/0.30/6.07/0.18/0.17/0.13/true/true VM66454:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968413/29968413/6.24 VM66455:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968630/29968630/6.46 3VM66458:1 DEBUG:AVC: AUD,SEI,NDR slices VM66461:1 DEBUG:6 tags extracted VM66462:1 DEBUG:AutoBufferController:minBufferLength:52.038314176245215 VM66463:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.22/30.00/0.28/6.18/0.05/0.08/0.23/true/true VM66464:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968619/29968619/6.44 VM66465:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968701/29968701/6.53 5VM66466:1 DEBUG:AVC: AUD,SEI,NDR slices VM66471:1 DEBUG:17 tags extracted VM66472:1 DEBUG:AutoBufferController:minBufferLength:50.070557107158606 VM66473:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.32/30.00/0.35/6.28/0.26/0.15/0.20/true/true VM66474:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968723/29968723/6.55 VM66475:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29968978/29968978/6.80 5VM66476:1 DEBUG:AVC: AUD,SEI,NDR slices VM66481:1 DEBUG:14 tags extracted VM66482:1 DEBUG:AutoBufferController:minBufferLength:48.73074729035938 VM66483:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.44/30.00/0.53/6.39/0.18/0.16/0.37/true/true VM66484:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29968931/29968931/6.76 VM66485:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969187/29969187/7.01 7VM66488:1 DEBUG:AVC: AUD,SEI,NDR slices VM66495:1 DEBUG:19 tags extracted VM66496:1 DEBUG:AutoBufferController:minBufferLength:47.010012343985736 VM66497:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.54/30.00/0.72/6.49/0.25/0.25/0.48/true/true VM66498:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29969136/29969136/6.96 VM66499:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969466/29969466/7.29 VM66500:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.64/30.00/0.65/6.60/0.00/0.00/0.65/true/true 6VM66501:1 DEBUG:AVC: AUD,SEI,NDR slices VM66507:1 DEBUG:15 tags extracted VM66508:1 DEBUG:AutoBufferController:minBufferLength:45.98133333333333 VM66509:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.74/30.00/0.73/6.70/0.18/0.19/0.55/true/true VM66510:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29969426/29969426/7.25 VM66511:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969675/29969675/7.50 VM66514:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.86/30.00/0.64/6.82/0.00/0.00/0.64/true/true VM66515:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:6.95/30.00/0.55/6.91/0.00/0.00/0.55/true/true 3VM66516:1 DEBUG:AVC: AUD,SEI,NDR slices VM66519:1 DEBUG:6 tags extracted VM66520:1 DEBUG:AutoBufferController:minBufferLength:45.96565389696169 VM66521:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.06/30.00/0.48/7.02/0.05/0.08/0.44/true/true VM66522:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29969654/29969654/7.48 VM66523:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969745/29969745/7.57 VM66526:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.16/30.00/0.41/7.12/0.00/0.00/0.41/true/true VM66527:1 DEBUG:AVC: AUD,SEI,NDR slices VM66528:1 DEBUG:4 tags extracted VM66529:1 DEBUG:AutoBufferController:minBufferLength:45.82013352533054 VM66530:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.26/30.00/0.31/7.22/0.05/0.00/0.31/true/true VM66531:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969768/29969768/7.59 VM66532:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969814/29969814/7.64 VM66533:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.37/30.00/0.27/7.33/0.00/0.00/0.27/true/true 3VM66536:1 DEBUG:AVC: AUD,SEI,NDR slices VM66539:1 DEBUG:6 tags extracted VM66540:1 DEBUG:AutoBufferController:minBufferLength:45.67129329355299 VM66541:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.47/30.00/0.22/7.43/0.05/0.08/0.17/true/true VM66542:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AVC_NALU/29969821/29969821/7.65 VM66543:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AVC_NALU/29969904/29969904/7.73 2VM66544:1 DEBUG:AVC: AUD,SEI,NDR slices VM66546:1 DEBUG:8 tags extracted VM66547:1 DEBUG:AutoBufferController:minBufferLength:44.99235474006117 VM66548:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.58/30.00/0.17/7.54/0.12/0.02/0.15/true/true VM66549:1 DEBUG:appending first level/sn/type/dts/pts/position:0/155707/AAC_RAW/29969908/29969908/7.73 VM66550:1 DEBUG:appending last level/sn/type/dts/pts/position:0/155707/AAC_RAW/29970023/29970023/7.85 VM66551:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.67/30.00/0.17/7.63/0.00/0.00/0.17/true/true VM66554:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.07/7.74/0.00/0.00/0.07/true/true 2VM66555:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.00/7.74/0.00/0.00/0.00/true/true m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155707.ts?time=1456142930198:1 GET http://m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155707.ts?time=1456142930198 net::ERR_CONTENT_LENGTH_MISMATCH VM66557:1 WARN:Parsing Error :HTTP 2OO but IO error, treat as parsing error VM66558:1 DEBUG:StreamBuffer.flushLastFragment, cannot flush, tag already pushed in NetStream VM66559:1 WARN:error parsing fragment, skip it and load next one VM66560:1 DEBUG:fragments skipped / max: 1/5 VM66562:1 DEBUG:loadnextfragment() VM66563:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=-1 VM66564:1 DEBUG:loadnextfragment : getFirstSeqNumfromContinuity(level,cc:0,0)=155711 VM66565:1 DEBUG:analyzing PTS 155711 of [155711,155713],level 0 VM66566:1 DEBUG:loading fragment:http://m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155711.ts?time=1456142970617 4VM66567:1 DEBUG:AVC: AUD,SEI,NDR slices VM66571:1 DEBUG:10 tags extracted VM66572:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.00/7.74/0.00/0.00/0.00/true/true VM66573:1 DEBUG:10 tags extracted VM66574:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.00/7.74/0.00/0.00/0.00/true/true VM66575:1 DEBUG:probe fragment type VM66576:1 DEBUG:AAC/MP3/TS match:false/false/true VM66577:1 DEBUG:TS: PAT found.PMT PID:4095 VM66578:1 DEBUG:TS: PMT found VM66579:1 DEBUG:TS: Selected ID3 PID: 258 VM66580:1 DEBUG:TS: Selected video PID: 256 VM66581:1 DEBUG:TS: Found 1 audio tracks VM66582:1 DEBUG:TS: selected AAC PID: 257 VM66583:1 DEBUG:10 tags extracted VM66584:1 DEBUG:analyzed PTS 155711 of [155711,155713],level 0 m PTS:29970047 VM66585:1 DEBUG:analyzed PTS : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155714 VM66586:1 DEBUG:PTS analysis done on 155711, matching seqnum is 155714 of [155711,155713],cancel loading and get new one VM66587:1 DEBUG:TS: cancel demux VM66588:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.00/7.74/0.00/0.00/0.00/true/true VM66589:1 DEBUG:loadnextfragment() VM66590:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155714 54VM66591:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/30.00/0.00/7.74/0.00/0.00/0.00/true/true VM66645:1 DEBUG:level 0 playlist:

EXTM3U

EXT-X-VERSION:3

EXT-X-ALLOW-CACHE:NO

EXT-X-TARGETDURATION:11

EXT-X-MEDIA-SEQUENCE:155712

EXTINF:10.002,

media_w1652912314_b350000_155712.ts?time=1456142980683

EXTINF:9.995,

media_w1652912314_b350000_155713.ts?time=1456142980683

EXTINF:9.996,

media_w1652912314_b350000_155714.ts?time=1456142980683

VM66646:1 DEBUG:updateFragments: unknown PTS info for this level VM66647:1 DEBUG:Level 0 Live Playlist parsing finished: reload in 9727 ms VM66648:1 DEBUG:loadnextfragment() VM66649:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=-1 VM66650:1 DEBUG:loadnextfragment : getFirstSeqNumfromContinuity(level,cc:0,0)=155712 VM66651:1 DEBUG:analyzing PTS 155712 of [155712,155714],level 0 VM66652:1 DEBUG:loading fragment:http://m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155712.ts?time=1456142980683 VM66653:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66654:1 DEBUG:probe fragment type VM66655:1 DEBUG:AAC/MP3/TS match:false/false/true VM66658:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66659:1 DEBUG:TS: PAT found.PMT PID:4095 VM66660:1 DEBUG:TS: PMT found VM66661:1 DEBUG:TS: Selected ID3 PID: 258 VM66662:1 DEBUG:TS: Selected video PID: 256 VM66663:1 DEBUG:TS: Found 1 audio tracks VM66664:1 DEBUG:TS: selected AAC PID: 257 VM66665:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66666:1 DEBUG:AVC: AUD,SPS,PPS,SEI,IDR slices VM66667:1 DEBUG:AVC: width/height:426/240 VM66668:1 DEBUG:AVC: H264 Baseline level 30 VM66669:1 DEBUG:AAC: LC, 44100 Hz 2 channel(s) VM66670:1 DEBUG:TS/AAC: insert ADIF TAG VM66671:1 DEBUG:AVC: AUD,SEI,NDR slices VM66672:1 DEBUG:6 tags extracted VM66673:1 DEBUG:analyzed PTS 155712 of [155712,155714],level 0 m PTS:30012191 VM66674:1 DEBUG:analyzed PTS : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155715 VM66675:1 DEBUG:PTS analysis done on 155712, matching seqnum is 155715 of [155712,155714],cancel loading and get new one VM66676:1 DEBUG:TS: cancel demux VM66677:1 DEBUG:loadnextfragment() VM66678:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155715 95VM66679:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66774:1 DEBUG:level 0 playlist:

EXTM3U

EXT-X-VERSION:3

EXT-X-ALLOW-CACHE:NO

EXT-X-TARGETDURATION:11

EXT-X-MEDIA-SEQUENCE:155713

EXTINF:9.995,

media_w1652912314_b350000_155713.ts?time=1456142990704

EXTINF:9.996,

media_w1652912314_b350000_155714.ts?time=1456142990704

EXTINF:9.997,

media_w1652912314_b350000_155715.ts?time=1456142990704

VM66775:1 DEBUG:updateFragments: unknown PTS info for this level VM66776:1 DEBUG:Level 0 Live Playlist parsing finished: reload in 9729 ms VM66777:1 DEBUG:loadnextfragment() VM66778:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=-1 VM66779:1 DEBUG:loadnextfragment : getFirstSeqNumfromContinuity(level,cc:0,0)=155713 VM66780:1 DEBUG:analyzing PTS 155713 of [155713,155715],level 0 VM66781:1 DEBUG:loading fragment:http://m-1.data.lt/m-1/smil:m-1.smil/media_w1652912314_b350000_155713.ts?time=1456142990704 VM66782:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66783:1 DEBUG:probe fragment type VM66784:1 DEBUG:AAC/MP3/TS match:false/false/true VM66787:1 DEBUG:TS: PAT found.PMT PID:4095 VM66788:1 DEBUG:TS: PMT found VM66789:1 DEBUG:TS: Selected ID3 PID: 258 VM66790:1 DEBUG:TS: Selected video PID: 256 VM66791:1 DEBUG:TS: Found 1 audio tracks VM66792:1 DEBUG:TS: selected AAC PID: 257 VM66793:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66794:1 DEBUG:AVC: AUD,SPS,PPS,SEI,IDR slices VM66795:1 DEBUG:AVC: width/height:426/240 VM66796:1 DEBUG:AVC: H264 Baseline level 30 VM66797:1 DEBUG:1 tags extracted VM66798:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true VM66799:1 DEBUG:AAC: LC, 44100 Hz 2 channel(s) VM66800:1 DEBUG:TS/AAC: insert ADIF TAG 16VM66801:1 DEBUG:AVC: AUD,SEI,NDR slices VM66817:1 DEBUG:44 tags extracted VM66818:1 DEBUG:analyzed PTS 155713 of [155713,155715],level 0 m PTS:30022222 VM66819:1 DEBUG:analyzed PTS : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155716 VM66820:1 DEBUG:PTS analysis done on 155713, matching seqnum is 155716 of [155713,155715],cancel loading and get new one VM66821:1 DEBUG:TS: cancel demux VM66822:1 DEBUG:loadnextfragment() VM66823:1 DEBUG:loadnextfragment : getSeqNumNearestPTS(level,pts,cc:0,NaN,0)=155716 95VM66824:1 DEBUG:position/duration/buffer/backBuffer/audio/video/NetStream bufferLength/audioExpected/videoExpected:7.78/29.99/0.00/7.74/0.00/0.00/0.00/true/true

arnaudleyder commented 8 years ago

Attached complete stream logs. flashhls.zip

mangui commented 8 years ago

net::ERR_CONTENT_LENGTH_MISMATCH means that there is a mismatch between signaled fragment length (in HTTP headers) and received fragment length. as u can see, it is considered as a parsing error.

arnaudleyder commented 8 years ago

Thanks for the reply. Thanks also for the amazing project and support. Is flashls supposed to recover from these kind of errors or is it expected that the player should stop functionning? As you can see in this case the player loadnextfragment() and then cancel demux in a loop just after the error shows in the log.

Thanks Arnaud

mangui commented 8 years ago

It is expected to recover. I didnt check the logs yet