search

protyposis / MediaPlayer-Extended

Android MediaPlayer API-compatible media player library with exact seek and DASH support
Apache License 2.0
441 stars 127 forks source link

Video starts stuttering and eventually stops after time #73

Open oseparovic opened 7 years ago

oseparovic commented 7 years ago

This a more complex issue that has existed in earlier versions but I thought it was related to other issues that have since been fixed.

Affected version(s)

compile 'net.protyposis.android.mediaplayer:mediaplayer:4.3.2'
compile 'net.protyposis.android.mediaplayer:mediaplayer-dash:4.3.2'

How to reproduce:

  1. Load a dash stream. Might be dependant on device strength so on newer devices expect to need 5+ minutes at least.
  2. As the video continues to play you might start noticing the video stuttering
  3. If you continue to let this video play it will eventually slow the point where it is paused for several seconds before continuing or just stops completely. I'm not sure what the relationship is but on the SG3 4.4.4 it handles these stutters by pausing and then playing the video at what looks like 4x or 8x speed and then freezing again. On other devices it pauses and then continues playing the video at 1x speed and falling further and further behind the live stream.

Tested devices:

For your own sanity the best way to reproduce the exact scenario would be to download our early alpha streaming app and analyze the logcat output. You can download here https://play.google.com/store/apps/details?id=com.appstronautstudios.steambroadcast. Simply click on any of the videos on the homepage and let the video play for a few minutes while montoring performance. I've removed obfuscation until the app is stable.

oseparovic commented 7 years ago

I'm not sure if this is related but on the Samsung Galaxy S3 (SGH-I747) - 4.4.4 I grabbed this logcat after the video appeared to stop for good.

10-10 09:11:30.683 23643-28097/com.appstronautstudios.steambroadcast W/QComExtractorFactory: Didn't match the sniff <=== status = 1 10-10 09:11:30.683 23643-28097/com.appstronautstudios.steambroadcast W/QComExtractorFactory: Didn't match the sniff <=== status = 1 10-10 09:11:30.683 23643-28097/com.appstronautstudios.steambroadcast I/FFmpegExtractor: android-source:0x761977f0 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'android-source:0x761977f0': 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: Metadata: 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: major_brand : iso5 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: minor_version : 1 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: compatible_brands: isomiso5dash 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: Duration: 00:00:03.01, start: 0.000000, bitrate: 169 kb/s 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFMPEG: Stream #0:0(und): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, fltp, 162 kb/s (default) 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast D/FFmpegExtractor: FFmpegExtrator, url: android-source:0x761977f0, format_name: mov,mp4,m4a,3gp,3g2,mj2, format_long_name: QuickTime / MOV 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast I/FFmpegExtractor: adjust mime(video/mp4 -> audio/mp4a-latm) 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast D/FFmpegExtractor: suppoted codec(aac) by official Stagefright 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast D/FFmpegExtractor: ffmpeg detected media content as 'audio/mp4a-latm' with confidence 0.08 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast E/MPEG4Extractor: No width or height, assuming worst case 1080p 10-10 09:11:30.693 23643-28097/com.appstronautstudios.steambroadcast D/ExtendedUtils: extended extractor not needed, return default 10-10 09:11:30.703 23643-23643/com.appstronautstudios.steambroadcast D/MediaPlayer: onInfo 10-10 09:11:30.703 23643-23643/com.appstronautstudios.steambroadcast D/VideoViewActivity: onInfo MEDIA_INFO_BUFFERING_START 10-10 09:11:31.023 23643-28094/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1610658bps current, 1502370 bps average 10-10 09:11:31.023 23643-28094/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 216 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/audio/1/11462/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null918145820.tmp 10-10 09:11:31.023 23643-28094/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1596845bps current, 1586951 bps average 10-10 09:11:31.023 23643-28094/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 217 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/audio/1/11463/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null455526392.tmp 10-10 09:11:31.123 23643-23643/com.appstronautstudios.steambroadcast D/MediaPlayer: onInfo 10-10 09:11:31.123 23643-23643/com.appstronautstudios.steambroadcast D/VideoViewActivity: onInfo MEDIA_INFO_BUFFERING_END 10-10 09:11:31.274 23643-28094/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 2175282bps current, 1707320 bps average 10-10 09:11:31.274 23643-28094/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 219 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/audio/1/11465/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null1433168708.tmp 10-10 09:11:31.344 23643-28094/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1617362bps current, 1689410 bps average 10-10 09:11:31.344 23643-28094/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 218 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/audio/1/11464/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null-1095895388.tmp 10-10 09:11:31.484 185-559/? I/AudioFlinger: BUFFER TIMEOUT: remove(4099) from active list on thread 0xb5b0c008 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tkhd 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tkhd 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trex 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trex 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tfhd 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tfhd 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trun 10-10 09:11:31.894 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trun 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping hdlr 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of hdlr 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping stts 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of stts 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping mdhd 10-10 09:11:31.904 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of mdhd 10-10 09:11:31.914 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.914 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.914 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:31.914 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:31.924 524-542/system_process E/Sensors: accelHandler -0.077838 0.358055 9.380094 10-10 09:11:31.934 23643-28064/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1781708bps current, 1665117 bps average 10-10 09:11:31.934 23643-28064/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 217 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/video/1/11463/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null119951472.tmp 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tkhd 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tkhd 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trex 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trex 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tfhd 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tfhd 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.094 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trun 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trun 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping hdlr 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of hdlr 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping stts 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of stts 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping mdhd 10-10 09:11:32.104 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of mdhd 10-10 09:11:32.114 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.114 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.114 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.114 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.124 23643-28064/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1672903bps current, 1628041 bps average 10-10 09:11:32.124 23643-28064/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 218 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/video/1/11464/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null804990388.tmp 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tkhd 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tkhd 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trex 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trex 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping tfhd 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of tfhd 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping trun 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of trun 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping hdlr 10-10 09:11:32.625 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of hdlr 10-10 09:11:32.635 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping stts 10-10 09:11:32.635 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of stts 10-10 09:11:32.635 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:mem mapping mdhd 10-10 09:11:32.635 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: AbstractBox:parsing details of mdhd 10-10 09:11:32.665 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.665 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.665 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:potentially expensive size() call 10-10 09:11:32.665 23643-28064/com.appstronautstudios.steambroadcast D/isoparser: LazyList:blowup running 10-10 09:11:32.695 23643-28064/com.appstronautstudios.steambroadcast D/SimpleRateBasedAdaptationLogic: 0 1534254bps current, 1608641 bps average 10-10 09:11:32.695 23643-28064/com.appstronautstudios.steambroadcast D/DashMediaExtractor: async cached 216 Segment{media='http://valve600.broadcast.steamcontent.com/broadcast/897978770874996004/segment/video/1/11462/?broadcast_origin=br02.broadcast.iad.steamstatic.com:80', range='null'} -> /data/data/com.appstronautstudios.steambroadcast/cache/seg1null-1148601076.tmp 10-10 09:11:32.885 524-546/system_process I/ProcessStatsService: Prepared write state in 12ms 10-10 09:11:33.075 524-547/system_process I/ProcessStatsService: Pruning old procstats: /data/system/procstats/state-2017-10-08-19-24-00.bin 10-10 09:11:33.966 185-559/? D/ALSADevice: standby: handle 0xb8272cd0 h 0x0 10-10 09:11:34.147 185-559/? D/alsa_ucm: snd_use_case_set(): uc_mgr 0xb823f108 identifier _verb value Inactive 10-10 09:11:34.147 185-559/? D/alsa_ucm: Set mixer controls for HiFi enable 0 10-10 09:11:34.147 185-559/? D/alsa_ucm: Setting mixer control: PRI_RX Audio Mixer MultiMedia1, value: 0 10-10 09:11:34.147 185-559/? D/alsa_ucm: snd_use_case_set(): uc_mgr 0xb823f108 identifier _disdev value Speaker 10-10 09:11:34.147 185-559/? D/alsa_ucm: Set mixer controls for Speaker enable 0 10-10 09:11:34.147 185-559/? D/alsa_ucm: Setting mixer control: RX5 MIX1 INP1, value: ZERO 10-10 09:11:34.147 185-559/? D/alsa_ucm: Setting mixer control: RX5 MIX1 INP2, value: ZERO 10-10 09:11:34.147 185-559/? D/alsa_ucm: Setting mixer control: LINEOUT2 Volume, value: 0 10-10 09:11:34.157 185-559/? D/alsa_ucm: Setting mixer control: LINEOUT4 Volume, value: 0 10-10 09:11:34.157 185-559/? D/alsa_ucm: Setting mixer control: RX5 Digital Volume, value: 0 10-10 09:11:34.157 185-559/? D/AudioUsbALSA: exitPlaybackThread, mproxypfdPlayback: -1 10-10 09:11:34.157 185-559/? D/AudioUsbALSA: closeDevice handle 0x0 10-10 09:11:34.157 185-559/? D/AudioUsbALSA: closeDevice handle 0x0 10-10 09:11:35.418 524-542/system_process E/Sensors: accelHandler -0.086221 0.374821 9.372909 10-10 09:11:38.922 524-542/system_process E/Sensors: accelHandler -0.081431 0.373623 9.387280 10-10 09:11:42.425 524-542/system_process E/Sensors: accelHandler -0.117356 0.393981 9.422007 10-10 09:11:45.919 524-542/system_process E/Sensors: accelHandler -0.124541 0.372426 9.402846 10-10 09:11:49.423 524-542/system_process E/Sensors: accelHandler -0.108973 0.377216 9.416019 10-10 09:11:52.927 524-542/system_process E/Sensors: accelHandler -0.119751 0.358055 9.447155 10-10 09:11:56.420 524-542/system_process E/Sensors: accelHandler -0.087418 0.349673 9.463920 10-10 09:11:59.924 524-542/system_process E/Sensors: accelHandler -0.094603 0.382006 9.408834 10-10 09:12:03.418 524-542/system_process E/Sensors: accelHandler -0.088616 0.378413 9.412427 10-10 09:12:06.922 524-542/system_process E/Sensors: accelHandler -0.114961 0.379611 9.401649 10-10 09:12:10.425 524-542/system_process E/Sensors: accelHandler -0.091011 0.362845 9.438772 10-10 09:12:13.919 524-542/system_process E/Sensors: accelHandler -0.092208 0.387993 9.444759 10-10 09:12:17.423 524-542/system_process E/Sensors: accelHandler -0.083826 0.349673 9.417217 10-10 09:12:20.927 524-542/system_process E/Sensors: accelHandler -0.098196 0.376018 9.419612 10-10 09:12:24.420 524-542/system_process E/Sensors: accelHandler -0.100591 0.409548 9.441167 10-10 09:12:27.924 524-542/system_process E/Sensors: accelHandler -0.085023 0.353265 9.451944 10-10 09:12:31.428 524-542/system_process E/Sensors: accelHandler -0.087418 0.365240 9.430389 10-10 09:12:34.921 524-542/system_process E/Sensors: accelHandler -0.130529 0.366438 9.424402 10-10 09:12:38.425 524-542/system_process E/Sensors: accelHandler -0.087418 0.378413 9.465117 10-10 09:12:41.919 524-542/system_process E/Sensors: accelHandler -0.102986 0.373623 9.465117 10-10 09:12:45.423 524-542/system_process E/Sensors: accelHandler -0.089813 0.353265 9.432784 10-10 09:12:48.926 524-542/system_process E/Sensors: accelHandler -0.067061 0.377216 9.435180 10-10 09:12:52.420 524-542/system_process E/Sensors: accelHandler -0.059875 0.347278 9.472302 10-10 09:12:55.293 524-542/system_process I/Sensors: Motion 10-10 09:12:55.924 524-542/system_process E/Sensors: accelHandler 3.279979 4.939728 0.874182 10-10 09:12:56.104 524-550/system_process I/ActivityManager: Config changes=480 {1.0 ?mcc?mnc en_CA ldltr sw360dp w360dp h615dp 320dpi nrml long port finger -keyb/v/h dpad/v s.21 themeResource=null} 10-10 09:12:56.114 524-630/system_process I/InputReader: Reconfiguring input devices. changes=0x00000004 10-10 09:12:56.114 524-630/system_process I/InputReader: Device reconfigured: id=13, name='sec_touchscreen', size 720x1280, orientation 0, mode 1, display id 0 10-10 09:12:56.144 667-667/com.android.systemui D/PhoneStatusBar: mSettingsPanelGravity = 55 10-10 09:12:56.324 524-543/system_process I/Timeline: Timeline: Activity_windows_visible id: ActivityRecord{41aacf28 u0 com.appstronautstudios.steambroadcast/.activities.VideoViewActivity t24} time:261960195 10-10 09:12:56.324 524-543/system_process I/WindowManager: Screen frozen for +264ms due to Window{41a900b0 u0 com.appstronautstudios.steambroadcast/com.appstronautstudios.steambroadcast.activities.VideoViewActivity} 10-10 09:12:57.936 524-629/system_process I/ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.cyanogenmod.trebuchet/org.cyanogenmod.trebuchet.CustomHomeLauncher} from pid 524 10-10 09:12:58.166 185-24538/? E/OMX-VDEC-1080P: send_command: Recieved a Command from Client 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): cmd = 0, Current State 3, Expected State 2 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): OMX_CommandStateSet issued 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Current State 3, Expected State 2 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Command Recieved in OMX_StateExecuting 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): Executing --> Idle 10-10 09:12:58.166 185-24538/? E/OMX-VDEC-1080P: send_command: Command Processed 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Driver flush i/p Port complete 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Initiate Input Flush 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Flush Input OMX_COMPONENT_GENERATE_EBD 0xb82842b8 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Reset all the variables before flusing 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Initialize parser 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: OMX flush i/p Port complete PenBuf(0) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Driver flush o/p Port complete 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Initiate Output Flush 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Buffer queue size 5 pending buf cnt 5 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: ID(c) P1(b82873b8) P2(40000000) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Buffer queue size 4 pending buf cnt 4 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: ID(c) P1(b8287318) P2(40000000) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Buffer queue size 3 pending buf cnt 3 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: ID(c) P1(b8287368) P2(40000000) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Buffer queue size 2 pending buf cnt 2 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: ID(c) P1(b8287408) P2(40000000) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: Buffer queue size 1 pending buf cnt 1 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: ID(c) P1(b82874f8) P2(40000000) 10-10 09:12:58.166 185-28128/? E/OMX-VDEC-1080P: OMX flush o/p Port complete PenBuf(0) 10-10 09:12:58.216 185-28128/? E/OMX-VDEC-1080P: Rxd OMX_COMPONENT_GENERATE_STOP_DONE 10-10 09:12:58.216 185-24524/? E/OMX-VDEC-1080P: send_command: Recieved a Command from Client 10-10 09:12:58.216 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): cmd = 0, Current State 2, Expected State 1 10-10 09:12:58.216 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): OMX_CommandStateSet issued 10-10 09:12:58.216 185-28128/? E/OMX-VDEC-1080P: Current State 2, Expected State 1 10-10 09:12:58.216 185-28128/? E/OMX-VDEC-1080P: send_command_proxy(): Idle-->Loaded-Pending 10-10 09:12:58.216 185-24524/? E/OMX-VDEC-1080P: send_command: Command Processed 10-10 09:12:58.216 841-841/com.cyanogenmod.trebuchet I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@41a699e8 time:261962089 10-10 09:12:58.226 185-185/? E/OMX-VDEC-1080P: ION: free: handle(0xEC75A840), len(2097152), fd(0x20) 10-10 09:12:58.226 185-185/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb82828b8 successful 10-10 09:12:58.226 185-658/? E/OMX-VDEC-1080P: ION: free: handle(0xE22A2DC0), len(2097152), fd(0x1f) 10-10 09:12:58.226 185-658/? E/OMX-VDEC-1080P: ALL input buffers are freed/released 10-10 09:12:58.226 185-658/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8282868 successful 10-10 09:12:58.226 185-24538/? E/OMX-VDEC-1080P: free_output: munmap(0xb164d000, 1433600) 10-10 09:12:58.226 185-24538/? E/OMX-VDEC-1080P: ION: free: handle(0xE0509B00), len(2457600), fd(0x28) 10-10 09:12:58.226 185-24538/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287598 successful 10-10 09:12:58.226 185-560/? E/OMX-VDEC-1080P: free_output: munmap(0xb190a000, 1433600) 10-10 09:12:58.226 185-560/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287548 successful 10-10 09:12:58.226 185-24524/? E/OMX-VDEC-1080P: free_output: munmap(0xb1bc7000, 1433600) 10-10 09:12:58.226 185-24524/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb82874f8 successful 10-10 09:12:58.226 185-185/? E/OMX-VDEC-1080P: free_output: munmap(0xb1e84000, 1433600) 10-10 09:12:58.226 185-185/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb82874a8 successful 10-10 09:12:58.226 185-658/? E/OMX-VDEC-1080P: free_output: munmap(0xb2141000, 1433600) 10-10 09:12:58.226 185-658/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287458 successful 10-10 09:12:58.226 185-24538/? E/OMX-VDEC-1080P: free_output: munmap(0xb23fe000, 1433600) 10-10 09:12:58.226 185-24538/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287408 successful 10-10 09:12:58.226 185-185/? E/OMX-VDEC-1080P: free_output: munmap(0xb26bb000, 1433600) 10-10 09:12:58.226 185-185/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb82873b8 successful 10-10 09:12:58.236 185-24524/? E/OMX-VDEC-1080P: free_output: munmap(0xb2978000, 1433600) 10-10 09:12:58.236 185-24524/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287368 successful 10-10 09:12:58.236 185-658/? E/OMX-VDEC-1080P: free_output: munmap(0xb2c35000, 1433600) 10-10 09:12:58.236 185-658/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb8287318 successful 10-10 09:12:58.236 185-24538/? E/OMX-VDEC-1080P: free_output: munmap(0xb2ef2000, 1433600) 10-10 09:12:58.236 185-24538/? E/OMX-VDEC-1080P: ALL output buffers are freed/released 10-10 09:12:58.236 185-24538/? I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0xb82872c8 successful 10-10 09:12:58.236 185-28128/? E/OMX-VDEC-1080P: OMX_CommandStateSet complete, m_state = 1 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: Playback Ended - PASSED 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: ALL output buffers are freed/released 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: Calling VDEC_IOCTL_STOP_NEXT_MSG 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: omx_vdec::component_deinit() complete 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: In OMX Vdec Destructor(), Vdec instances = 1 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: Waiting on OMX Msg Thread exit 10-10 09:12:58.236 185-28129/? E/OMX-VDEC-1080P: Error in ioctl read next msg 10-10 09:12:58.236 185-28129/? E/OMX-VDEC-1080P: omx_vdec: Async thread stop 10-10 09:12:58.236 185-28128/? E/OMX-VDEC-1080P: omx_vdec: message thread stop 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: Waiting on OMX Async Thread exit 10-10 09:12:58.236 185-560/? E/OMX-VDEC-1080P: Calling close() on Video Driver 10-10 09:12:58.256 185-560/? E/OMX-VDEC-1080P: Calling close() on vdec ion devicefd = 26 10-10 09:12:58.256 185-560/? E/OMX-VDEC-1080P: Successfully destroyed vdec ionlock 10-10 09:12:58.256 185-560/? E/OMX-VDEC-1080P: Exit OMX vdec Destructor

                                           [ 10-10 09:12:58.256   185:  560 E/         ]

                                            Destroy C2D instance

                                           [ 10-10 09:12:58.256   185:  560 E/         ]

                                            Destroy C2D instance

10-10 09:12:58.256 23643-28125/com.appstronautstudios.steambroadcast D/MediaCodecVideoDecoder: decoder released 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x78304588 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x7611d128 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x796b3460 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x782d8d28 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x75e1bd78 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x765975d8 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x78355e80 successful 10-10 09:12:58.256 23643-28131/com.appstronautstudios.steambroadcast I/OMXNodeInstance: OMX_FreeBuffer for buffer header 0x782f7200 successful 10-10 09:12:58.256 23643-28125/com.appstronautstudios.steambroadcast D/MediaCodecAudioDecoder: decoder released 10-10 09:12:58.497 23643-28125/com.appstronautstudios.steambroadcast D/MediaPlayer: PlaybackThread destroyed