You're right the network would be gone too. So if it still happens we'd know that the network is not the issue. It helps narrow down the root cause even further.
The other change is related to audio buffering and sync and will not help here.
Ok, I'll go install the Client on it and put on to try it. I don't know if I'll get the info tonight as the Shield is setup in my kids bedroom but I'll see if something happens before their bedtime.
So I'm trying to watch a recorded program from the DVR on my Sony TV and the Client on the Shield crashed apparently. I don't know why.
What do you mean by "crashed"? Can you give more detail? The clients don't directly interact with each other so I'm not sure why playing from one client would impact another.
So I was watching a DVR'd show on my Sony, I let that play and I installed the client on the Shield as requested and started to play Fox News TVE. Went back upstairs and started to follow the log on the Shield remotely while watching the Sony. After the show finished on my Sony I switched to another show on the DVR. I refreshed the log for the Shield and it was a fresh new log. So I looked in the DVR log and the Fox News stream on the Shield Client closed. 
I haven't gone back downstairs yet.
@tmm1
I restarted the Shield and started fresh.
I noticed that the Audio Buffer on the Shield and the FireTV4k are both set to the Min.
The Sony was less than the Min but in the new beta you changed it to the Max, whats the reasoning for the difference and should it even matter?
Welp... The Shield Client crashed again.
Sent DVR Log: 2740b9b3-c079-4dc0-a7bf-25d9a7b00728
...and a Client Log.
2.1.21.beta-v104012228 (104012228 dvr)
NVIDIA SHIELD Android TV (NVIDIA foster_e)
HDHomeRun CONNECT (10486549) [channels=27, ip=192.168.5.46, auth=NxIT9ZPR2q4VGNW_lsn200Dp], HDHomeRun CONNECT (10481E46) [channels=27, ip=192.168.5.45, auth=vC6Gylt-27Cmv8wz92ivMSiF], FuboTV (TVE-Fubo) [channels=120, ip=null, auth=null]
DVR http://192.168.5.101:8089 Status(os=android, arch=arm64, version=2020.04.01.0126, subscription=active, username=jpblanch75, features=Features(bonjour=true, dvr=true, guide=true))
en_US America/New_York
SDK 9 (28) arm64-v8a, armeabi-v7a, armeabi
NET eth0 = [/192.168.5.101]
--------- beginning of main
04-02 21:25:16.645 11440 11440 E hannels.dvr.ap: Not starting debugger since process cannot load the jdwp agent.
04-02 21:25:16.773 11440 11440 I CrashlyticsInitProvider: CrashlyticsInitProvider skipping initialization
04-02 21:25:16.848 11440 11440 D libcrashlytics: Initializing libcrashlytics version 2.0.5
04-02 21:25:16.848 11440 11440 D libcrashlytics: Initializing native crash handling successful.
04-02 21:25:16.849 11440 11440 I CrashlyticsCore: Initializing Crashlytics 2.6.8.32
04-02 21:25:16.866 11440 11440 D f.a.g.b : Construction of Android Sentry from Android Application.
04-02 21:25:16.868 11440 11440 D f.a.g.b : Sentry init with ctx='com.getchannels.android.ChannelsApp@76854df'
04-02 21:25:16.872 11440 11440 D f.a.g.b : Using buffer dir: /data/user/0/com.getchannels.dvr.app/cache/sentry-buffered-events
04-02 21:25:16.871 11440 11440 W hannels.dvr.app: type=1400 audit(0.0:135): avc: denied { read } for name="version" dev="proc" ino=4026532055 scontext=u:r:untrusted_app:s0:c119,c256,c512,c768 tcontext=u:object_r:proc_version:s0 tclass=file permissive=0
04-02 21:25:16.875 11440 11440 D f.a.g.b : ANR is='false'
04-02 21:25:16.964 11440 11440 E linker : normalize_path - invalid input: "lib/", the input path should be absolute
04-02 21:25:16.964 11440 11440 W linker : Warning: unable to normalize "lib/" (ignoring)
04-02 21:25:16.964 11440 11440 E linker : normalize_path - invalid input: "lib/", the input path should be absolute
04-02 21:25:16.964 11440 11440 W linker : Warning: unable to normalize "lib/" (ignoring)
04-02 21:25:17.012 11440 11487 V mpv : event: idle
04-02 21:25:17.015 11440 11440 D NetworkSecurityConfig: No Network Security Config specified, using platform default
04-02 21:25:17.023 11440 11487 V mpv : property: pause = false
04-02 21:25:17.049 11440 11487 V mpv : property: track-list has 0 entries
04-02 21:25:17.177 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/status
04-02 21:25:17.233 11440 11502 E linker : normalize_path - invalid input: "lib/", the input path should be absolute
04-02 21:25:17.234 11440 11502 W linker : Warning: unable to normalize "lib/" (ignoring)
04-02 21:25:17.234 11440 11502 E linker : normalize_path - invalid input: "lib/", the input path should be absolute
04-02 21:25:17.234 11440 11502 W linker : Warning: unable to normalize "lib/" (ignoring)
04-02 21:25:17.251 11440 11440 V ChannelsApp: Lifecycle.ON_START
04-02 21:25:17.254 11440 11440 V OnNowFragment: onResume
04-02 21:25:17.255 11440 11440 D OpenGLRenderer: Skia GL Pipeline
04-02 21:25:17.270 11440 11440 V ChannelsApp: HDMI available=true channels=8 encodings=[2, 5, 13]
04-02 21:25:17.271 11440 11440 V DVR : Using saved local DVR: http://192.168.5.101:8089
04-02 21:25:17.272 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/status
04-02 21:25:17.276 11440 11440 D View : com.nvidia.immediateInput = false
04-02 21:25:17.276 11440 11440 D View : com.nvidia.mRawCursorInputRequested = false
04-02 21:25:17.313 11440 11440 V DVRClient: Status(os=android, arch=arm64, version=2020.04.01.0126, subscription=active, username=jpblanch75, features=Features(bonjour=true, dvr=true, guide=true))
04-02 21:25:17.313 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/auth
04-02 21:25:17.328 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingString failed to get INvCplHalService
04-02 21:25:17.328 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingString failed to get INvCplHalService
04-02 21:25:17.330 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.331 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.333 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.334 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.336 11440 11505 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 1
04-02 21:25:17.336 11440 11505 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 1
04-02 21:25:17.337 11440 11505 I OpenGLRenderer: Initialized EGL, version 1.4
04-02 21:25:17.337 11440 11505 D OpenGLRenderer: Swap behavior 2
04-02 21:25:17.338 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.338 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.340 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.341 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingStringLength failed to get INvCplHalService
04-02 21:25:17.342 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.342 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingStringLength failed to get INvCplHalService
04-02 21:25:17.343 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.344 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.344 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.345 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.348 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.350 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.418 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.418 11440 11505 E libnvcpl_vendor: NvCplGetAppProfileSettingInt failed to get INvCplHalService
04-02 21:25:17.503 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/devices
04-02 21:25:17.503 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr
04-02 21:25:17.504 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/jobs
04-02 21:25:17.505 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/files
04-02 21:25:17.514 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/rules
04-02 21:25:17.515 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/groups
04-02 21:25:17.516 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/programs
04-02 21:25:17.636 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/devices/ANY/guide?time=1585877117&duration=28800
04-02 21:25:17.661 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/recordings/upnext
04-02 21:25:17.800 11440 11502 V HDHR : found 2 devices [timeout=250]
04-02 21:25:17.827 11440 11502 V HDHR : Device(deviceID=10486549, deviceAuth=NxIT9ZPR2q4VGNW_lsn200Dp, deviceAuthTime=1585877117802, ipAddress=192.168.5.46, tunerCount=2, isLegacy=false, friendlyName=, firmwareName=hdhomerun4_atsc, firmwareVersion=20200225, modelNumber=HDHR4-2US, channels=[], isPlusBased=false)
04-02 21:25:17.851 11440 11502 V HDHR : Device(deviceID=10481E46, deviceAuth=vC6Gylt-27Cmv8wz92ivMSiF, deviceAuthTime=1585877117828, ipAddress=192.168.5.45, tunerCount=2, isLegacy=false, friendlyName=, firmwareName=hdhomerun4_atsc, firmwareVersion=20200225, modelNumber=HDHR4-2US, channels=[], isPlusBased=false)
04-02 21:25:18.662 11440 11450 I hannels.dvr.ap: ThreadFlipBegin blocked for 8.736ms
04-02 21:25:18.662 11440 11476 I hannels.dvr.ap: IncrementDisableThreadFlip blocked for 8.916ms
04-02 21:25:19.098 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/devices/ANY/guide?time=1585877119&duration=28800
04-02 21:25:19.100 11440 11440 V HTTP : Requesting http://192.168.5.101:8089/dvr/recordings/upnext
04-02 21:25:19.134 11440 11510 V DVRClient: jsonpipe connected: 2020.04.01.0126
04-02 21:25:19.327 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:25:19.406 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:25:20.423 11440 11440 V MainActivity: intent: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LEANBACK_LAUNCHER] flg=0x10000000 pkg=com.getchannels.dvr.app cmp=com.getchannels.dvr.app/com.getchannels.android.MainActivity bnds=[1272,399][1512,571] }
04-02 21:25:20.549 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:25:20.679 11440 11440 V OnNowFragment: onResume
04-02 21:25:20.723 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:25:20.759 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:25:21.529 11440 11509 I CrashlyticsCore: Crashlytics report upload complete: 5E868B1703AD-0001-1FBD-9600A367EB45
04-02 21:27:00.107 11440 11513 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-02 21:27:24.888 11440 11804 V ApiServer: REQUEST: GET /log
04-02 21:27:24.890 11440 11804 I hls : goroutine 17 [running, locked to thread]:
04-02 21:27:24.890 11440 11804 I hls : main.FullStackTrace(0x4000044e58, 0x8)
04-02 21:27:24.890 11440 11804 I hls : /Users/fancybox/source/channels-android/vendor/libhls/channels-server/hls/libhls/hls_c.go:249 +0x84
04-02 21:27:24.890 11440 11804 I hls : main.hls_log_stack()
04-02 21:27:24.890 11440 11804 I hls : /Users/fancybox/source/channels-android/vendor/libhls/channels-server/hls/libhls/hls_c.go:259 +0x18
04-02 21:27:24.890 11440 11804 I hls : main._cgoexpwrap_277a0c6059f4_hls_log_stack()
04-02 21:27:24.890 11440 11804 I hls : _cgo_gotypes.go:298 +0x18
04-02 21:27:24.890 11440 11804 I hls :
04-02 21:27:24.890 11440 11804 I hls : goroutine 35 [select]:
04-02 21:27:24.890 11440 11804 I hls : github.com/grafov/kiwi.processSink(0x40001a4000)
04-02 21:27:24.890 11440 11804 I hls : /Users/fancybox/go/pkg/mod/github.com/grafov/[email protected]/sink.go:327 +0x1b8
04-02 21:27:24.890 11440 11804 I hls : created by github.com/grafov/kiwi.SinkTo
04-02 21:27:24.890 11440 11804 I hls : /Users/fancybox/go/pkg/mod/github.com/grafov/[email protected]/sink.go:111 +0x390
04-02 21:27:24.890 11440 11804 I hls :
04-02 21:27:24.890 11440 11804 I hls : goroutine 19 [syscall]:
04-02 21:27:24.890 11440 11804 I hls : os/signal.signal_recv(0x0)
04-02 21:27:24.890 11440 11804 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/runtime/sigqueue.go:147 +0xb8
04-02 21:27:24.890 11440 11804 I hls : os/signal.loop()
04-02 21:27:24.890 11440 11804 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/os/signal/signal_unix.go:23 +0x18
04-02 21:27:24.890 11440 11804 I hls : created by os/signal.Notify.func1
04-02 21:27:24.890 11440 11804 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/os/signal/signal.go:127 +0x38When it crashes please submit Diagnostic logs on the client and select crash.
Is the app set to Software decoding?
I did crash and video player. It was probably 15 minutes from when it crashed to when I submitted the Client logs...
The client was up on the OnNow screen when I got down there. So I don't know if the app closed and reopened or if the video itself just stopped.
It was set to Hybrid.
Please try Software
I'll try it tomorrow, kids are in bed now. I will say one thing I found while I was playing with it between the first crash and the second crash, ipv6 was still toggled on on the Shield. I know ipv6 is off on the router so I'm not sure why the Network info still showed like it was still on. Anyway, I toggled it off and rebooted the Shield. I'll see if it has an affect on my Sony.
Anyway, we are getting into multiple devices again........
OK, Her is tonights log on the Sony TV. I see a few errors.
04-02 23:45:28.725 10432 10432 V mpvstats: AV: 6048.158 A-V: 0.000 Dropped: 0 Cache: 15.787s + 0KB
04-02 23:45:31.726 10432 10432 V mpvstats: AV: 6051.161 A-V: 0.000 Dropped: 0 Cache: 12.800s + 0KB
04-02 23:45:34.727 10432 10432 V mpvstats: AV: 6054.164 A-V: 0.000 Dropped: 0 Cache: 13.909s + 0KB
04-02 23:45:37.728 10432 10432 V mpvstats: AV: 6057.167 A-V: 0.000 Dropped: 0 Cache: 15.019s + 0KB
04-02 23:45:40.487 10432 10477 E mpv : [ffmpeg/audio] aac: env_facs_q 255 is invalid
04-02 23:45:40.729 10432 10432 V mpvstats: AV: 6060.170 A-V: 0.000 Dropped: 0 Cache: 16.128s + 0KB
04-02 23:45:40.756 10432 10477 D mpv : [ffmpeg/video] h264: Reinit context to 1280x720, pix_fmt: yuv420p
04-02 23:45:40.890 10432 10477 V mpv : [vd] Decoder format: 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/auto CL=mpeg1/jpeg (auto 0.000000/0.000000/0.000000)
04-02 23:45:43.730 10432 10432 V mpvstats: AV: 6063.177 A-V: 0.000 Dropped: 0 Cache: 13.013s + 0KB
04-02 23:45:46.731 10432 10432 V mpvstats: AV: 6066.180 A-V: 0.000 Dropped: 0 Cache: 14.080s + 0KB
04-02 23:45:49.732 10432 10432 V mpvstats: AV: 6069.166 A-V: 0.000 Dropped: 0 Cache: 15.232s + 0KB
04-02 23:45:52.735 10432 10432 V mpvstats: AV: 6072.169 A-V: 0.000 Dropped: 0 Cache: 16.341s + 0KB
04-02 23:45:55.737 10432 10432 V mpvstats: AV: 6075.172 A-V: 0.000 Dropped: 0 Cache: 13.397s + 0KB
04-02 23:45:58.737 10432 10432 V mpvstats: AV: 6078.175 A-V: 0.000 Dropped: 0 Cache: 14.379s + 0KB
04-02 23:46:01.739 10432 10432 V mpvstats: AV: 6081.178 A-V: 0.000 Dropped: 0 Cache: 15.573s + 0KB
04-02 23:46:04.740 10432 10432 V mpvstats: AV: 6084.181 A-V: 0.000 Dropped: 0 Cache: 16.683s + 0KB
04-02 23:46:07.741 10432 10432 V mpvstats: AV: 6087.184 A-V: 0.003 Dropped: 0 Cache: 14.848s + 0KB
04-02 23:46:10.743 10432 10432 V mpvstats: AV: 6090.187 A-V: 0.000 Dropped: 0 Cache: 14.763s + 0KB
04-02 23:46:13.744 10432 10432 V mpvstats: AV: 6093.190 A-V: 0.000 Dropped: 0 Cache: 15.872s + 0KB
04-02 23:46:16.746 10432 10432 V mpvstats: AV: 6096.177 A-V: 0.000 Dropped: 0 Cache: 16.896s + 0KB
04-02 23:46:19.748 10432 10432 V mpvstats: AV: 6099.196 A-V: 0.000 Dropped: 0 Cache: 13.909s + 0KB
04-02 23:46:22.749 10432 10432 V mpvstats: AV: 6102.199 A-V: 0.000 Dropped: 0 Cache: 15.019s + 0KB
04-02 23:46:25.750 10432 10432 V mpvstats: AV: 6105.186 A-V: 0.000 Dropped: 0 Cache: 16.128s + 0KB
04-02 23:46:28.750 10432 10432 V mpvstats: AV: 6108.189 A-V: 0.000 Dropped: 0 Cache: 17.195s + 0KB
04-02 23:46:31.751 10432 10432 V mpvstats: AV: 6111.192 A-V: 0.000 Dropped: 0 Cache: 14.208s + 0KB
04-02 23:46:34.754 10432 10432 V mpvstats: AV: 6114.195 A-V: 0.000 Dropped: 0 Cache: 15.232s + 0KB
04-02 23:46:37.754 10432 10432 V mpvstats: AV: 6117.198 A-V: 0.000 Dropped: 0 Cache: 16.341s + 0KB
04-02 23:46:40.756 10432 10432 V mpvstats: AV: 6120.201 A-V: 0.000 Dropped: 0 Cache: 17.451s + 0KB
04-02 23:46:43.757 10432 10432 V mpvstats: AV: 6123.204 A-V: 0.000 Dropped: 0 Cache: 14.464s + 0KB
04-02 23:46:46.758 10432 10432 V mpvstats: AV: 6126.207 A-V: 0.000 Dropped: 0 Cache: 15.616s + 0KB
04-02 23:46:49.761 10432 10432 V mpvstats: AV: 6129.193 A-V: 0.000 Dropped: 0 Cache: 16.640s + 0KB
04-02 23:46:52.762 10432 10432 V mpvstats: AV: 6132.196 A-V: 0.000 Dropped: 0 Cache: 17.749s + 0KB
04-02 23:46:54.245 10432 10488 W g.a.g.c$b: Bad domain name: possible circular name detected. Bad offset: 0x3fff at 0x68
04-02 23:46:54.245 10432 10488 W g.a.g.s.e: Could not find record type for index: 65535
04-02 23:46:54.247 10432 10488 W g.a.g.c : Could not find record type. domain:
04-02 23:46:54.247 10432 10488 W g.a.g.c : dns[response,192.168.5.39:5353, length=106, id=0x0, flags=0x8400:r:aa, answers=3
04-02 23:46:54.247 10432 10488 W g.a.g.c : answers:
04-02 23:46:54.247 10432 10488 W g.a.g.c : [e@24826441 type: TYPE_PTR index 12, class: CLASS_IN index 1, name: ttl: '299/300' alias: '.']
04-02 23:46:54.247 10432 10488 W g.a.g.c : [f@181663566 type: TYPE_SRV index 33, class: CLASS_IN index 1-unique, name: . ttl: '299/300' server: 'F.:62217']
04-02 23:46:54.247 10432 10488 W g.a.g.c : [c@99500143 type: TYPE_A index 1, class: CLASS_IN index 1-unique, name: MyQ-F59.local. ttl: '299/300' address: '192.168.5.39']]
04-02 23:46:54.247 10432 10488 W g.a.g.c : answer: [e@24826441 type: TYPE_PTR index 12, class: CLASS_IN index 1, name: ttl: '299/300' alias: '.']
04-02 23:46:54.247 10432 10488 W g.a.g.c : answer: [f@181663566 type: TYPE_SRV index 33, class: CLASS_IN index 1-unique, name: . ttl: '299/300' server: 'F.:62217']
04-02 23:46:54.247 10432 10488 W g.a.g.c : answer: [c@99500143 type: TYPE_A index 1, class: CLASS_IN index 1-unique, name: MyQ-F59.local. ttl: '299/300' address: '192.168.5.39']
04-02 23:46:54.247 10432 10488 W g.a.g.c : 0: 0000840000000004 0000000100000c00 010000012c000402 8830000288300000 ........ ........ ....,... .0...0..
04-02 23:46:54.247 10432 10488 W g.a.g.c : 20: 2180010000012c00 0bf30880eff30903 81724600074d7951 2d463539056c6f63 !.....,. ........ .rF..MyQ -F59.loc
04-02 23:46:54.247 10432 10488 W g.a.g.c : 40: 616c000001800100 00012c0004c0a805 2702883000002f80 010000012c000b02 al...... ..,..... '..0../. ....,...
04-02 23:46:54.247 10432 10488 W g.a.g.c : 60: 8830000005000800 0040 .0...... .@
04-02 23:46:54.247 10432 10488 W g.a.g.s.d: Could not find record class for index: 65535
04-02 23:46:54.249 10432 10488 W g.a.g.c : Could not find record class. domain: type: TYPE_IGNORE index 0
04-02 23:46:54.249 10432 10488 W g.a.g.c : dns[response,192.168.5.39:5353, length=106, id=0x0, flags=0x8400:r:aa, answers=3
04-02 23:46:54.249 10432 10488 W g.a.g.c : answers:
04-02 23:46:54.249 10432 10488 W g.a.g.c : [e@24826441 type: TYPE_PTR index 12, class: CLASS_IN index 1, name: ttl: '299/300' alias: '.']
04-02 23:46:54.249 10432 10488 W g.a.g.c : [f@181663566 type: TYPE_SRV index 33, class: CLASS_IN index 1-unique, name: . ttl: '299/300' server: 'F.:62217']
04-02 23:46:54.249 10432 10488 W g.a.g.c : [c@99500143 type: TYPE_A index 1, class: CLASS_IN index 1-unique, name: MyQ-F59.local. ttl: '299/300' address: '192.168.5.39']]
04-02 23:46:54.249 10432 10488 W g.a.g.c : answer: [e@24826441 type: TYPE_PTR index 12, class: CLASS_IN index 1, name: ttl: '299/300' alias: '.']
04-02 23:46:54.249 10432 10488 W g.a.g.c : answer: [f@181663566 type: TYPE_SRV index 33, class: CLASS_IN index 1-unique, name: . ttl: '299/300' server: 'F.:62217']
04-02 23:46:54.249 10432 10488 W g.a.g.c : answer: [c@99500143 type: TYPE_A index 1, class: CLASS_IN index 1-unique, name: MyQ-F59.local. ttl: '299/300' address: '192.168.5.39']
04-02 23:46:54.249 10432 10488 W g.a.g.c : 0: 0000840000000004 0000000100000c00 010000012c000402 8830000288300000 ........ ........ ....,... .0...0..
04-02 23:46:54.249 10432 10488 W g.a.g.c : 20: 2180010000012c00 0bf30880eff30903 81724600074d7951 2d463539056c6f63 !.....,. ........ .rF..MyQ -F59.loc
04-02 23:46:54.249 10432 10488 W g.a.g.c : 40: 616c000001800100 00012c0004c0a805 2702883000002f80 010000012c000b02 al...... ..,..... '..0../. ....,...
04-02 23:46:54.249 10432 10488 W g.a.g.c : 60: 8830000005000800 0040 .0...... .@
04-02 23:46:55.763 10432 10432 V mpvstats: AV: 6135.199 A-V: 0.000 Dropped: 0 Cache: 14.763s + 0KB
04-02 23:46:58.764 10432 10432 V mpvstats: AV: 6138.202 A-V: 0.000 Dropped: 0 Cache: 15.829s + 0KB
04-02 23:47:01.764 10432 10432 V mpvstats: AV: 6141.205 A-V: 0.000 Dropped: 0 Cache: 12.843s + 0KB
04-02 23:47:04.766 10432 10432 V mpvstats: AV: 6144.208 A-V: 0.000 Dropped: 0 Cache: 13.995s + 0KB
04-02 23:47:07.766 10432 10432 V mpvstats: AV: 6147.211 A-V: 0.000 Dropped: 0 Cache: 15.104s + 0KB
04-02 23:47:10.767 10432 10432 V mpvstats: AV: 6150.214 A-V: 0.000 Dropped: 0 Cache: 16.085s + 0KB
04-02 23:47:13.769 10432 10432 V mpvstats: AV: 6153.217 A-V: 0.000 Dropped: 0 Cache: 13.099s + 0KB
04-02 23:47:16.771 10432 10432 V mpvstats: AV: 6156.203 A-V: 0.000 Dropped: 0 Cache: 14.208s + 0KB
04-02 23:47:19.773 10432 10432 V mpvstats: AV: 6159.223 A-V: 0.000 Dropped: 0 Cache: 15.275s + 0KB
04-02 23:47:22.774 10432 10432 V mpvstats: AV: 6162.209 A-V: 0.000 Dropped: 0 Cache: 12.288s + 0KB
04-02 23:47:25.774 10432 10432 V mpvstats: AV: 6165.212 A-V: 0.000 Dropped: 0 Cache: 13.312s + 0KB
04-02 23:47:28.775 10432 10432 V mpvstats: AV: 6168.215 A-V: 0.000 Dropped: 0 Cache: 14.507s + 0KB
04-02 23:47:31.776 10432 10432 V mpvstats: AV: 6171.218 A-V: 0.000 Dropped: 0 Cache: 15.616s + 0KB
04-02 23:47:34.778 10432 10432 V mpvstats: AV: 6174.221 A-V: 0.000 Dropped: 0 Cache: 15.019s + 0KB
04-02 23:47:37.778 10432 10432 V mpvstats: AV: 6177.224 A-V: 0.000 Dropped: 0 Cache: 13.739s + 0KB
04-02 23:47:40.779 10432 10432 V mpvstats: AV: 6180.227 A-V: 0.000 Dropped: 0 Cache: 14.805s + 0KB
04-02 23:47:43.780 10432 10432 V mpvstats: AV: 6183.214 A-V: 0.000 Dropped: 0 Cache: 15.872s + 0KB
04-02 23:47:46.781 10432 10432 V mpvstats: AV: 6186.217 A-V: 0.000 Dropped: 0 Cache: 14.592s + 0KB
04-02 23:47:49.782 10432 10432 V mpvstats: AV: 6189.220 A-V: 0.000 Dropped: 0 Cache: 13.995s + 0KB
04-02 23:47:52.783 10432 10432 V mpvstats: AV: 6192.223 A-V: 0.000 Dropped: 0 Cache: 15.104s + 0KB
04-02 23:47:55.784 10432 10432 V mpvstats: AV: 6195.226 A-V: 0.000 Dropped: 0 Cache: 16.171s + 0KB
04-02 23:47:58.785 10432 10432 V mpvstats: AV: 6198.229 A-V: 0.000 Dropped: 0 Cache: 15.019s + 0KB
04-02 23:48:01.787 10432 10432 V mpvstats: AV: 6201.232 A-V: 0.000 Dropped: 0 Cache: 14.165s + 0KB
04-02 23:48:04.788 10432 10432 V mpvstats: AV: 6204.235 A-V: 0.000 Dropped: 0 Cache: 15.317s + 0KB
04-02 23:48:07.790 10432 10432 V mpvstats: AV: 6207.238 A-V: 0.000 Dropped: 0 Cache: 16.384s + 0KB
04-02 23:48:10.791 10432 10432 V mpvstats: AV: 6210.224 A-V: 0.000 Dropped: 0 Cache: 13.824s + 0KB
04-02 23:48:13.791 10432 10432 V mpvstats: AV: 6213.227 A-V: 0.000 Dropped: 0 Cache: 14.635s + 0KB
04-02 23:48:16.792 10432 10432 V mpvstats: AV: 6216.230 A-V: 0.000 Dropped: 0 Cache: 15.659s + 0KB
04-02 23:48:19.793 10432 10432 V mpvstats: AV: 6219.233 A-V: 0.000 Dropped: 0 Cache: 16.725s + 0KB
04-02 23:48:22.794 10432 10432 V mpvstats: AV: 6222.236 A-V: 0.000 Dropped: 0 Cache: 17.835s + 0KB
04-02 23:48:25.796 10432 10432 V mpvstats: AV: 6225.239 A-V: 0.000 Dropped: 0 Cache: 14.848s + 0KB
04-02 23:48:28.797 10432 10432 V mpvstats: AV: 6228.242 A-V: 0.000 Dropped: 0 Cache: 15.957s + 0KB
04-02 23:48:31.798 10432 10432 V mpvstats: AV: 6231.245 A-V: 0.000 Dropped: 0 Cache: 17.024s + 0KB
04-02 23:48:34.800 10432 10432 V mpvstats: AV: 6234.231 A-V: 0.000 Dropped: 0 Cache: 17.280s + 0KB
04-02 23:48:37.803 10432 10432 V mpvstats: AV: 6237.234 A-V: 0.000 Dropped: 0 Cache: 15.104s + 0KB
04-02 23:48:40.804 10432 10432 V mpvstats: AV: 6240.237 A-V: 0.000 Dropped: 0 Cache: 16.171s + 0KB
04-02 23:48:43.807 10432 10432 V mpvstats: AV: 6243.240 A-V: 0.000 Dropped: 0 Cache: 17.280s + 0KB
04-02 23:48:46.807 10432 10432 V mpvstats: AV: 6246.243 A-V: 0.000 Dropped: 0 Cache: 18.389s + 0KB
04-02 23:48:49.808 10432 10432 V mpvstats: AV: 6249.246 A-V: 0.000 Dropped: 0 Cache: 15.403s + 0KB
04-02 23:48:52.809 10432 10432 V mpvstats: AV: 6252.249 A-V: 0.000 Dropped: 0 Cache: 12.416s + 0KB
04-02 23:48:55.809 10432 10432 V mpvstats: AV: 6255.252 A-V: 0.000 Dropped: 0 Cache: 13.440s + 0KB
04-02 23:48:58.810 10432 10432 V mpvstats: AV: 6258.255 A-V: 0.000 Dropped: 0 Cache: 14.592s + 0KB
04-02 23:49:01.810 10432 10432 V mpvstats: AV: 6261.258 A-V: 0.000 Dropped: 0 Cache: 15.659s + 0KB
04-02 23:49:04.810 10432 10432 V mpvstats: AV: 6264.261 A-V: 0.000 Dropped: 0 Cache: 12.672s + 0KB
04-02 23:49:07.810 10432 10432 V mpvstats: AV: 6267.248 A-V: 0.000 Dropped: 0 Cache: 13.824s + 0KB
04-02 23:49:10.812 10432 10432 V mpvstats: AV: 6270.251 A-V: 0.000 Dropped: 0 Cache: 14.848s + 0KB
04-02 23:49:13.530 10432 12658 V Streamer: overflowed 1 (pos: 2304262044, time: 3185s)
04-02 23:49:13.813 10432 10432 V mpvstats: AV: 6273.254 A-V: 0.000 Dropped: 0 Cache: 15.957s + 0KB
04-02 23:49:16.814 10432 10432 V mpvstats: AV: 6276.257 A-V: 0.000 Dropped: 0 Cache: 12.971s + 0KB
04-02 23:49:19.815 10432 10432 V mpvstats: AV: 6279.260 A-V: 0.000 Dropped: 0 Cache: 14.080s + 0KB
04-02 23:49:22.816 10432 10432 V mpvstats: AV: 6282.263 A-V: 0.000 Dropped: 0 Cache: 15.104s + 0KB
04-02 23:49:25.817 10432 10432 V mpvstats: AV: 6285.266 A-V: 0.000 Dropped: 0 Cache: 13.568s + 0KB
04-02 23:49:28.818 10432 10432 V mpvstats: AV: 6288.252 A-V: 0.000 Dropped: 0 Cache: 13.269s + 0KB
04-02 23:49:31.819 10432 10432 V mpvstats: AV: 6291.255 A-V: 0.000 Dropped: 0 Cache: 14.293s + 0KB
04-02 23:49:34.820 10432 10432 V mpvstats: AV: 6294.258 A-V: 0.000 Dropped: 0 Cache: 15.403s + 0KB
04-02 23:49:37.821 10432 10432 V mpvstats: AV: 6297.261 A-V: 0.000 Dropped: 0 Cache: 16.469s + 0KB
04-02 23:49:40.822 10432 10432 V mpvstats: AV: 6300.264 A-V: 0.000 Dropped: 0 Cache: 13.568s + 0KB
04-02 23:49:43.824 10432 10432 V mpvstats: AV: 6303.267 A-V: 0.000 Dropped: 0 Cache: 14.677s + 0KB
04-02 23:49:46.824 10432 10432 V mpvstats: AV: 6306.270 A-V: 0.000 Dropped: 0 Cache: 15.787s + 0KB
04-02 23:49:49.825 10432 10432 V mpvstats: AV: 6309.273 A-V: 0.000 Dropped: 0 Cache: 16.811s + 0KB
04-02 23:49:52.826 10432 10432 V mpvstats: AV: 6312.276 A-V: 0.000 Dropped: 0 Cache: 13.824s + 0KB
04-02 23:49:55.827 10432 10432 V mpvstats: AV: 6315.262 A-V: 0.000 Dropped: 0 Cache: 14.891s + 0KB
04-02 23:49:58.828 10432 10432 V mpvstats: AV: 6318.265 A-V: 0.000 Dropped: 0 Cache: 16.043s + 0KB
04-02 23:50:01.829 10432 10432 V mpvstats: AV: 6321.268 A-V: 0.000 Dropped: 0 Cache: 17.109s + 0KB
04-02 23:50:04.829 10432 10432 V mpvstats: AV: 6324.271 A-V: 0.000 Dropped: 0 Cache: 14.123s + 0KB
04-02 23:50:07.830 10432 10432 V mpvstats: AV: 6327.274 A-V: 0.000 Dropped: 0 Cache: 15.147s + 0KB
04-02 23:50:10.831 10432 10432 V mpvstats: AV: 6330.277 A-V: 0.000 Dropped: 0 Cache: 16.256s + 0KB
04-02 23:50:13.832 10432 10432 V mpvstats: AV: 6333.280 A-V: 0.000 Dropped: 0 Cache: 17.365s + 0KB
04-02 23:50:16.835 10432 10432 V mpvstats: AV: 6336.267 A-V: 0.000 Dropped: 0 Cache: 14.379s + 0KB
04-02 23:50:19.838 10432 10432 V mpvstats: AV: 6339.270 A-V: 0.001 Dropped: 0 Cache: 11.392s + 0KB
04-02 23:50:22.841 10432 10432 V mpvstats: AV: 6342.273 A-V: 0.000 Dropped: 0 Cache: 8.320s + 0KB
04-02 23:50:25.842 10432 10432 V mpvstats: AV: 6345.292 A-V: 0.000 Dropped: 0 Cache: 5.419s + 0KB
04-02 23:50:28.843 10432 10432 V mpvstats: AV: 6348.279 A-V: 0.000 Dropped: 0 Cache: 2.389s + 0KB
04-02 23:50:31.199 10432 10477 V mpv : event: unpause
04-02 23:50:31.200 10432 10477 V mpv : [cplayer] Enter buffering (buffer went from 100% -> 41%) [0.417089s].
04-02 23:50:31.200 10432 10477 V mpv : property: buffering = true
04-02 23:50:31.200 10432 10432 V PlayerActivity: state PLAYING -> BUFFERING
04-02 23:50:31.203 10432 10432 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=6310.1405110000005, end=6351.0980776666665}], cache-end=6351.131455444444, reader-pts=6350.714366555556, cache-duration=0.4170888888884292, eof=false, underrun=true, idle=false, total-bytes=31593024, fw-bytes=374976, debug-low-level-seeks=0, debug-ts-last=6349.880200111112, ts-per-stream=[{type=video, duration=0.4170888888884292, reader=6350.731055555556, end=6351.148144444444}, {type=audio, duration=0.0, reader=6351.164344444444, end=6351.164344444444}]}
04-02 23:50:31.844 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.417s + 0KB
04-02 23:50:34.845 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.417s + 0KB
04-02 23:50:37.846 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.417s + 0KB
04-02 23:50:40.846 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.417s + 0KB
04-02 23:50:43.848 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.417s + 0KB
04-02 23:50:46.216 10432 12659 V Streamer: mpv read bytes:0 after retries:32000 (pos:4655382528)
04-02 23:50:46.849 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:50:49.526 10432 13708 V ApiServer: REQUEST: GET /log
04-02 23:50:49.526 10432 13708 I hls : goroutine 17 [running, locked to thread]:
04-02 23:50:49.526 10432 13708 I hls : main.FullStackTrace(0x8e902030, 0x8e838f50)
04-02 23:50:49.526 10432 13708 I hls : /Users/fancybox/source/channels-android/vendor/libhls/channels-server/hls/libhls/hls_c.go:249 +0x80
04-02 23:50:49.526 10432 13708 I hls : main.hls_log_stack()
04-02 23:50:49.526 10432 13708 I hls : /Users/fancybox/source/channels-android/vendor/libhls/channels-server/hls/libhls/hls_c.go:259 +0x14
04-02 23:50:49.526 10432 13708 I hls : main._cgoexpwrap_277a0c6059f4_hls_log_stack()
04-02 23:50:49.526 10432 13708 I hls : _cgo_gotypes.go:299 +0x14
04-02 23:50:49.526 10432 13708 I hls :
04-02 23:50:49.526 10432 13708 I hls : goroutine 19 [syscall]:
04-02 23:50:49.526 10432 13708 I hls : os/signal.signal_recv(0x0)
04-02 23:50:49.526 10432 13708 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/runtime/sigqueue.go:147 +0x14c
04-02 23:50:49.526 10432 13708 I hls : os/signal.loop()
04-02 23:50:49.526 10432 13708 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/os/signal/signal_unix.go:23 +0x14
04-02 23:50:49.526 10432 13708 I hls : created by os/signal.Notify.func1
04-02 23:50:49.526 10432 13708 I hls : /usr/local/Cellar/go/HEAD-612ef03/libexec/src/os/signal/signal.go:127 +0x38
04-02 23:50:49.526 10432 13708 I hls :
04-02 23:50:49.526 10432 13708 I hls : goroutine 21 [select]:
04-02 23:50:49.526 10432 13708 I hls : github.com/grafov/kiwi.processSink(0x8e928680)
04-02 23:50:49.526 10432 13708 I hls : /Users/fancybox/go/pkg/mod/github.com/grafov/[email protected]/sink.go:327 +0x90
04-02 23:50:49.526 10432 13708 I hls : created by github.com/grafov/kiwi.SinkTo
04-02 23:50:49.526 10432 13708 I hls : /Users/fancybox/go/pkg/mod/github.com/grafov/[email protected]/sink.go:111 +0x310
04-02 23:50:49.850 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:50:52.851 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:50:55.853 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:50:58.853 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:51:01.854 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:51:04.856 10432 10432 V mpvstats: AV: 6350.648 A-V: 0.000 Dropped: 0 Cache: 0.434s + 0KB
04-02 23:51:07.418 10432 10477 V mpv : event: unpause
04-02 23:51:07.418 10432 10477 V mpv : [cplayer] End buffering (waited 36.214768 secs) [2.346667s].
04-02 23:51:07.424 10432 10477 V mpv : property: buffering = false
04-02 23:51:07.425 10432 10432 V PlayerActivity: state BUFFERING -> PLAYING
04-02 23:51:07.668 10432 10477 E mpv : [ffmpeg/video] h264: error while decoding MB 56 41, bytestream -26
04-02 23:51:07.668 10432 10477 V mpv : [ffmpeg/video] h264: concealing 313 DC, 313 AC, 313 MV errors in P frame
04-02 23:51:07.856 10432 10432 V mpvstats: AV: 6351.282 A-V: 0.000 Dropped: 15 Cache: 3.499s + 0KB
04-02 23:51:08.014 10432 10432 V mpvstats: AV: 6351.432 A-V: 0.000 Dropped: 15 Cache: 3.328s + 0KB
04-02 23:51:10.859 10432 10432 V mpvstats: AV: 6354.268 A-V: 0.000 Dropped: 15 Cache: 0.512s + 0KB
04-02 23:51:11.477 10432 10477 V mpv : event: unpause
04-02 23:51:11.477 10432 10477 V mpv : [cplayer] Enter buffering (buffer went from 100% -> 23%) [0.233556s].
04-02 23:51:11.478 10432 10477 V mpv : property: buffering = true
04-02 23:51:11.478 10432 10432 V PlayerActivity: state PLAYING -> BUFFERING
04-02 23:51:11.478 10432 10432 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=6314.244599888889, end=6355.185511000001}], cache-end=6355.218866555556, reader-pts=6354.985311, cache-duration=0.2335555555555402, eof=false, underrun=true, idle=false, total-bytes=31715840, fw-bytes=272640, debug-low-level-seeks=0, debug-ts-last=6354.91857788889, ts-per-stream=[{type=video, duration=0.2335555555555402, reader=6355.002, end=6355.235555555556}, {type=audio, duration=0.0, reader=6355.260344444445, end=6355.260344444445}]}
04-02 23:51:13.860 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:16.861 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:19.862 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:22.863 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:25.863 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:28.863 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:31.863 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:34.864 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:37.864 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.234s + 0KB
04-02 23:51:39.959 10432 12659 V Streamer: mpv read bytes:0 after retries:32000 (pos:4658528256)
04-02 23:51:39.966 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 23% -> 25%) [0.250244s].
04-02 23:51:40.865 10432 10432 V mpvstats: AV: 6354.902 A-V: 0.000 Dropped: 15 Cache: 0.250s + 0KB
04-02 23:51:42.755 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 25% -> 4%) [0.042667s].
04-02 23:51:42.757 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 4% -> 26%) [0.266933s].
04-02 23:51:42.757 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 26% -> 28%) [0.283600s].
04-02 23:51:42.774 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 28% -> 4%) [0.042667s].
04-02 23:51:42.774 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 4% -> 35%) [0.350344s].
04-02 23:51:42.775 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 35% -> 4%) [0.042667s].
04-02 23:51:42.824 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 4% -> 93%) [0.938667s].
04-02 23:51:42.826 10432 10477 V mpv : [cplayer] Still buffering (buffer went from 93% -> 98%) [0.981333s].
04-02 23:51:42.830 10432 10477 V mpv : event: unpause
04-02 23:51:42.830 10432 10477 V mpv : [cplayer] End buffering (waited 31.352135 secs) [1.024000s].
04-02 23:51:42.837 10432 10477 V mpv : property: buffering = false
04-02 23:51:42.837 10432 10432 V PlayerActivity: state BUFFERING -> PLAYING
04-02 23:51:43.049 10432 10477 E mpv : [ffmpeg/video] h264: error while decoding MB 5 42, bytestream -21
04-02 23:51:43.063 10432 10477 V mpv : [ffmpeg/video] h264: concealing 284 DC, 284 AC, 284 MV errors in P frame
04-02 23:51:43.075 10432 10432 V mpvstats: AV: 6355.202 A-V: 0.000 Dropped: 30 Cache: 3.499s + 0KB
04-02 23:51:43.866 10432 10432 V mpvstats: AV: 6356.053 A-V: 0.000 Dropped: 30 Cache: 12.885s + 0KB
04-02 23:51:46.867 10432 10432 V mpvstats: AV: 6359.056 A-V: 0.000 Dropped: 30 Cache: 40.383s + 0KB
04-02 23:51:49.869 10432 10432 V mpvstats: AV: 6362.059 A-V: 0.000 Dropped: 30 Cache: 45.546s + 0KB
04-02 23:51:52.871 10432 10432 V mpvstats: AV: 6365.062 A-V: 0.000 Dropped: 30 Cache: 53.567s + 0KB
04-02 23:51:55.872 10432 10432 V mpvstats: AV: 6368.065 A-V: 0.000 Dropped: 30 Cache: 72.115s + 0KB
04-02 23:51:58.873 10432 10432 V mpvstats: AV: 6371.068 A-V: 0.000 Dropped: 30 Cache: 78.600s + 0KB
04-02 23:52:01.875 10432 10432 V mpvstats: AV: 6374.071 A-V: 0.000 Dropped: 30 Cache: 79.752s + 0KB
04-02 23:52:04.876 10432 10432 V mpvstats: AV: 6377.074 A-V: 0.000 Dropped: 30 Cache: 81.608s + 0KB
04-02 23:52:06.391 10432 10477 D mpv : [ffmpeg/video] h264: Reinit context to 1280x720, pix_fmt: yuv420p
04-02 23:52:06.455 10432 10477 V mpv : [vd] Decoder format: 1280x720 [0:1] yuv420p bt.709/bt.709/bt.1886/limited/auto CL=mpeg1/jpeg (auto 0.000000/0.000000/0.000000)
04-02 23:52:07.876 10432 10432 V mpvstats: AV: 6380.078 A-V: 0.000 Dropped: 30 Cache: 82.717s + 0KB
04-02 23:52:10.880 10432 10432 V mpvstats: AV: 6383.048 A-V: 0.000 Dropped: 30 Cache: 79.645s + 0KB
04-02 23:52:13.882 10432 10432 V mpvstats: AV: 6386.051 A-V: 0.000 Dropped: 30 Cache: 80.712s + 0KB
04-02 23:52:16.883 10432 10432 V mpvstats: AV: 6389.054 A-V: 0.000 Dropped: 30 Cache: 80.541s + 0KB
04-02 23:52:19.884 10432 10432 V mpvstats: AV: 6392.057 A-V: 0.000 Dropped: 30 Cache: 83.784s + 0KB
04-02 23:52:22.885 10432 10432 V mpvstats: AV: 6395.093 A-V: 0.000 Dropped: 30 Cache: 80.776s + 0KB
04-02 23:52:25.886 10432 10432 V mpvstats: AV: 6398.096 A-V: 0.000 Dropped: 30 Cache: 79.838s + 0KB
04-02 23:52:28.888 10432 10432 V mpvstats: AV: 6401.099 A-V: 0.000 Dropped: 30 Cache: 80.862s + 0KB
04-02 23:52:31.182 10432 13812 V ApiServer: REQUEST: GET /logIs the Sony on Software or Hybrid?
Same errors with both. That particular log it was on Hybrid.
Installed the latest Client app on the Sony and it's actually locked up this time after 1 hour. I had to back out after buffering stopped. V 2.1.21-v104022138
04-03 02:05:52.241 16391 16391 V mpvstats: AV: 2749.913 A-V: 0.000 Dropped: 1 Cache: 13.909s + 0KB
04-03 02:05:55.242 16391 16391 V mpvstats: AV: 2752.916 A-V: 0.000 Dropped: 1 Cache: 14.635s + 0KB
04-03 02:05:58.243 16391 16391 V mpvstats: AV: 2755.919 A-V: 0.000 Dropped: 1 Cache: 11.605s + 0KB
04-03 02:06:01.244 16391 16391 V mpvstats: AV: 2758.922 A-V: 0.000 Dropped: 1 Cache: 8.619s + 0KB
04-03 02:06:04.246 16391 16391 V mpvstats: AV: 2761.908 A-V: 0.000 Dropped: 1 Cache: 5.632s + 0KB
04-03 02:06:07.247 16391 16391 V mpvstats: AV: 2764.928 A-V: 0.000 Dropped: 1 Cache: 2.603s + 0KB
04-03 02:06:09.898 16391 16436 V mpv : event: unpause
04-03 02:06:09.898 16391 16436 V mpv : [cplayer] Enter buffering (buffer went from 100% -> 36%) [0.367011s].
04-03 02:06:09.898 16391 16436 V mpv : property: buffering = true
04-03 02:06:09.898 16391 16391 V PlayerActivity: state PLAYING -> BUFFERING
04-03 02:06:09.899 16391 16391 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=2725.438288777778, end=2766.3791776666667}], cache-end=2768.0141332222224, reader-pts=2767.647122111111, cache-duration=0.3670111111114238, eof=false, underrun=true, idle=false, total-bytes=31410816, fw-bytes=221120, debug-low-level-seeks=0, debug-ts-last=2767.1633112222225, ts-per-stream=[{type=video, duration=0.3670111111114238, reader=2767.663811111111, end=2768.0308222222225}, {type=audio, duration=0.0, reader=2768.030311111111, end=2768.030311111111}]}
04-03 02:06:10.256 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:13.257 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:16.258 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:19.258 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:22.259 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:25.260 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:28.261 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:30.494 16391 18073 V ApiServer: REQUEST: GET /log
04-03 02:06:31.261 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:34.262 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:37.263 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.367s + 0KB
04-03 02:06:37.993 16391 17294 V Streamer: mpv read bytes:0 after retries:32000 (pos:1992589312)
04-03 02:06:40.263 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:06:43.265 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:06:46.266 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:06:49.267 16391 16391 I chatty : uid=10150(com.getchannels.dvr.app.beta) identical 1 line
04-03 02:06:52.267 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:06:55.269 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:06:58.270 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:07:01.271 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:07:04.271 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:07:07.273 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:07:10.274 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.384s + 0KB
04-03 02:07:10.414 16391 17294 V Streamer: mpv read bytes:0 after retries:32000 (pos:1992589312)
04-03 02:07:13.274 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:16.275 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:19.276 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:22.277 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:25.278 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:31.279 16391 16391 I chatty : uid=10150(com.getchannels.dvr.app.beta) identical 2 lines
04-03 02:07:34.280 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:37.281 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:40.282 16391 16391 V mpvstats: AV: 2767.580 A-V: 0.000 Dropped: 1 Cache: 0.400s + 0KB
04-03 02:07:42.847 16391 17294 V Streamer: mpv read bytes:0 after retries:32000 (pos:1992589312)
04-03 02:07:42.848 16391 16436 V mpv : [lavf] EOF reached.
04-03 02:07:42.850 16391 16436 V mpv : event: unpause
04-03 02:07:42.851 16391 16436 V mpv : [cplayer] End buffering (waited 92.950824 secs) [0.400389s].
04-03 02:07:42.851 16391 16436 V mpv : [af] filter input EOF
04-03 02:07:42.851 16391 16436 V mpv : [af] filter output EOF
04-03 02:07:42.852 16391 16436 V mpv : property: buffering = false
04-03 02:07:42.852 16391 16391 V PlayerActivity: state BUFFERING -> PLAYING
04-03 02:07:42.854 16391 16391 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=2725.438288777778, end=2768.047511}], cache-end=2768.047511, reader-pts=2767.663788777778, cache-duration=0.38372222222233177, eof=true, underrun=false, idle=true, total-bytes=31423744, fw-bytes=224512, debug-low-level-seeks=0, debug-ts-last=2768.0642000000003, ts-per-stream=[{type=video, duration=0.38372222222233177, reader=2767.680477777778, end=2768.0642000000003}, {type=audio, duration=0.0, reader=2768.030311111111, end=2768.030311111111}]}
04-03 02:07:42.996 16391 16436 V mpv : [cplayer] audio EOF reached
04-03 02:07:43.257 16391 16436 E mpv : [ffmpeg/video] h264: error while decoding MB 43 20, bytestream -5
04-03 02:07:43.257 16391 16436 V mpv : [ffmpeg/video] h264: concealing 2006 DC, 2006 AC, 2006 MV errors in P frame
04-03 02:07:43.282 16391 16391 V mpvstats: AV: 2767.981 A-V: 0.000 Dropped: 1 Cache: 0.000s + 0KB
04-03 02:07:43.333 16391 16436 V mpv : [vf] filter input EOF
04-03 02:07:43.333 16391 16436 V mpv : [vf] filter output EOF
04-03 02:07:43.333 16391 16436 V mpv : [cplayer] using demuxer frame duration for last frame
04-03 02:07:43.333 16391 16436 D mpv : [cplayer] video EOF (status=4)
04-03 02:07:43.365 16391 16436 I chatty : uid=10150(com.getchannels.dvr.app.beta) mpv-events identical 4 lines
04-03 02:07:43.381 16391 16436 D mpv : [cplayer] video EOF (status=4)
04-03 02:07:43.382 16391 16436 V mpv : [cplayer] video EOF reached
04-03 02:07:43.382 16391 16436 D mpv : [cplayer] video EOF (status=5)
04-03 02:07:43.382 16391 16436 V mpv : [cplayer] EOF code: 1
04-03 02:07:43.382 16391 16436 V mpv : [ad] Uninit decoder.
04-03 02:07:43.382 16391 16436 V mpv : event: audio-reconfig
04-03 02:07:43.382 16391 16436 V mpv : [vd] Uninit decoder.
04-03 02:07:43.384 16391 16436 V mpv : event: video-reconfig
04-03 02:07:43.390 16391 16436 V mpv : event: audio-reconfig
04-03 02:07:43.391 16391 16436 D mpv : [cplayer] Terminating demuxers...
04-03 02:07:43.491 16391 17293 V Streamer: read error: java.net.SocketException: Socket closed
04-03 02:07:43.491 16391 17293 V Streamer: finished
04-03 02:07:43.492 16391 16436 V mpv : [cplayer] Forcefully terminating demuxers...
04-03 02:07:43.732 16391 16436 V mpv : event: tracks-changed
04-03 02:07:43.732 16391 16436 V mpv : event: end-file
04-03 02:07:43.733 16391 16436 D mpv : [cplayer] Done terminating demuxers.
04-03 02:07:43.733 16391 16391 V PlayerActivity: state PLAYING -> STOPPED
04-03 02:07:43.733 16391 16436 V mpv : [cplayer] finished playback, success (reason 0)
04-03 02:07:43.733 16391 16436 I mpv : [cplayer]
04-03 02:07:43.735 16391 17295 W libEGL : EGLNativeWindowType 0xba72d008 disconnect failed
04-03 02:07:43.736 16391 16436 V mpv : event: video-reconfig
04-03 02:07:43.737 16391 16436 V mpv : event: idle
04-03 02:07:43.737 16391 16436 V mpv : [cplayer] Set property: aid=1 -> 1
04-03 02:07:43.737 16391 16436 V mpv : property: buffering = false
04-03 02:07:43.737 16391 16436 V mpv : property: track-list has 0 entries
04-03 02:07:43.943 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:07:46.283 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:07:49.284 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:07:52.070 16391 18089 V ApiServer: REQUEST: GET /log
04-03 02:07:52.271 16391 16399 W System : A resource failed to call end.
04-03 02:07:52.284 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:07:55.285 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:07:58.285 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:01.285 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:04.285 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:07.287 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:10.287 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:13.288 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:16.288 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:19.289 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:22.290 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:25.291 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:28.291 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:31.293 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:34.294 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:37.294 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:40.295 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:43.297 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:46.298 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:49.300 16391 16391 I chatty : uid=10150(com.getchannels.dvr.app.beta) identical 1 line
04-03 02:08:52.300 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:55.301 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:08:58.302 16391 16391 I chatty : uid=10150(com.getchannels.dvr.app.beta) identical 1 line
04-03 02:09:01.302 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:04.303 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:07.304 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:10.305 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:13.305 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:16.306 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:19.307 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:22.308 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:25.308 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:28.309 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:31.310 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:34.311 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:37.312 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:40.313 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:40.925 16391 18106 V ApiServer: REQUEST: GET /log
04-03 02:09:41.098 16391 16399 W System : A resource failed to call end.
04-03 02:09:43.313 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:46.314 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:49.315 16391 16391 I chatty : uid=10150(com.getchannels.dvr.app.beta) identical 1 line
04-03 02:09:52.316 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:55.317 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:09:58.319 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:01.319 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:04.320 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:07.320 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:10.320 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:13.320 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:16.321 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:19.321 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:22.322 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:25.323 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:28.323 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:31.323 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:34.324 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:37.325 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:40.326 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:43.327 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:46.328 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:49.328 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:52.328 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:55.329 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:10:58.329 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:11:01.330 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:11:04.032 16391 16478 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-03 02:11:04.039 16391 16478 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-03 02:11:04.342 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:11:07.343 16391 16391 V mpvstats: AV: 2768.048 A-V: 0.000 Dropped: 0 Cache: 0.000s + 0KB
04-03 02:11:08.355 16391 16391 V PlayerActivity: onPause
04-03 02:11:08.386 16391 16391 V OnNowFragment: onResume
04-03 02:11:08.509 16391 16483 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-03 02:11:08.519 16391 16478 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-03 02:11:08.544 16391 16451 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
04-03 02:11:08.668 16391 16483 W ExifInterface: Stop reading file since a wrong offset may cause an infinite loop: 0
04-03 02:11:08.841 16391 16436 D mpv : [cplayer] Run command: stop, flags=64, args=[]
04-03 02:11:08.844 16391 16436 D mpv : [cplayer] Setting option 'wid' = 0 (flags = 64) -> 0
04-03 02:11:08.844 16391 16436 D mpv : [cplayer] Setting option 'mediacodec-embed-osd-surface' = 0 (flags = 64) -> 0
04-03 02:11:08.847 16391 16451 W libEGL : EGLNativeWindowType 0xba72c008 disconnect failed
04-03 02:11:08.855 16391 16391 V PlayerActivity: onStop
04-03 02:11:08.858 16391 16391 V PlayerActivity: onDestroy
04-03 02:11:08.859 16391 16436 D mpv : [cplayer] Run command: stop, flags=64, args=[]
04-03 02:11:23.224 16391 18170 V ApiServer: REQUEST: GET /log@tmm1,
Ok now that the decoder seems to fix the other problems on my Sony TV I'm done blaming the Client app for the TVE buffering.
I watched my Android phone last night and now my Apple TV 4k this morning and the same thing happens. So now I'm turning the blame on the DVR or my network. TVE is the only thing that gets screwed up so it's hard to blame the network.
Here is the AppleTV log that shows the buffer emptying.....
2020-04-03 09:29:44.999 mpvstats: AV: 1176.975 A-V: 0.000 Dropped: 0 Cache: 17.55s + 0KB
2020-04-03 09:29:49.998 mpvstats: AV: 1182.014 A-V: 0.000 Dropped: 0 Cache: 16.58s + 0KB
2020-04-03 09:29:54.999 mpvstats: AV: 1187.019 A-V: 0.000 Dropped: 0 Cache: 15.75s + 0KB
2020-04-03 09:30:00.000 mpvstats: AV: 1191.990 A-V: 0.000 Dropped: 0 Cache: 14.61s + 0KB
2020-04-03 09:30:04.997 mpvstats: AV: 1196.995 A-V: 0.000 Dropped: 0 Cache: 9.61s + 0KB
2020-04-03 09:30:09.998 mpvstats: AV: 1202.000 A-V: 0.000 Dropped: 0 Cache: 4.60s + 0KB
2020-04-03 09:30:15.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:20.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:25.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:30.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:31.754 read(32768) = 0 after 32000000
2020-04-03 09:30:35.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:40.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:45.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:50.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:30:55.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:00.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:05.003 mpvstats: AV: 1206.638 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:06.618 read(32768) = 0 after 32000000
2020-04-03 09:31:10.003 mpvstats: AV: 1206.672 A-V: 0.205 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:15.003 mpvstats: AV: 1206.672 A-V: 0.205 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:20.003 mpvstats: AV: 1206.672 A-V: 0.205 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:31:21.957 [ffmpeg/video] error: h264: error while decoding MB 47 20, bytestream -5
2020-04-03 09:31:21.957 [ffmpeg/video] v: h264: concealing 2002 DC, 2002 AC, 2002 MV errors in P frame
2020-04-03 09:31:24.998 mpvstats: AV: 1209.867 A-V: 0.000 Dropped: 3 Cache: 40.61s + 0KB
2020-04-03 09:31:29.997 mpvstats: AV: 1214.872 A-V: 0.000 Dropped: 3 Cache: 57.97s + 0KB
2020-04-03 09:31:34.998 mpvstats: AV: 1219.877 A-V: 0.000 Dropped: 3 Cache: 86.96s + 0KB
2020-04-03 09:31:39.998 mpvstats: AV: 1224.882 A-V: 0.000 Dropped: 3 Cache: 86.16s + 0KB
2020-04-03 09:31:44.997 mpvstats: AV: 1229.887 A-V: 0.000 Dropped: 3 Cache: 85.22s + 0KB
2020-04-03 09:31:49.998 mpvstats: AV: 1234.859 A-V: 0.000 Dropped: 3 Cache: 84.34s + 0KB
2020-04-03 09:31:53.866 [vd] v: Decoder format: 1920x1080 [0:1] yuv420p bt.709/bt.709/bt.1886/limited/auto CL=mpeg2/4/h264 (auto 0.000000/0.000000/0.000000)
2020-04-03 09:31:53.866 [vf] v: [in] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.898 [vf] v: [userdeint] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.898 [vf] v: [lavfi] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.898 [lavfi] v: format change on in0
2020-04-03 09:31:53.898 [lavfi] v: recovering all eof
2020-04-03 09:31:53.898 [vf] v: [autorotate] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.898 event: video-reconfig
2020-04-03 09:31:53.899 [vf] v: [convert] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.899 [vf] v: [out] 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:53.997 [cplayer] info: VO: [libmpv] 1920x1080 yuv420p
2020-04-03 09:31:53.997 event: video-reconfig
2020-04-03 09:31:53.997 [cplayer] v: VO: Description: render API for libmpv
2020-04-03 09:31:53.997 [vo/libmpv] v: reconfig to 1920x1080 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:31:54.998 mpvstats: AV: 1239.897 A-V: 0.000 Dropped: 0 Cache: 87.53s + 0KB
2020-04-03 09:31:59.998 mpvstats: AV: 1244.902 A-V: 0.000 Dropped: 0 Cache: 86.61s + 0KB
2020-04-03 09:32:04.998 mpvstats: AV: 1249.907 A-V: 0.000 Dropped: 0 Cache: 85.71s + 0KB
2020-04-03 09:32:09.998 mpvstats: AV: 1254.879 A-V: 0.000 Dropped: 0 Cache: 84.82s + 0KB
2020-04-03 09:32:14.997 mpvstats: AV: 1259.884 A-V: 0.000 Dropped: 0 Cache: 88.03s + 0KB
2020-04-03 09:32:19.998 mpvstats: AV: 1264.889 A-V: 0.000 Dropped: 0 Cache: 87.11s + 0KB
2020-04-03 09:32:23.884 [vd] v: Decoder format: 1280x720 [0:1] yuv420p bt.709/bt.709/bt.1886/limited/auto CL=mpeg2/4/h264 (auto 0.000000/0.000000/0.000000)
2020-04-03 09:32:23.884 [vf] v: [in] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.917 [vf] v: [userdeint] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.917 [vf] v: [lavfi] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.917 [lavfi] v: format change on in0
2020-04-03 09:32:23.917 [lavfi] v: recovering all eof
2020-04-03 09:32:23.917 [vf] v: [autorotate] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.917 [vf] v: [convert] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.918 [vf] v: [out] 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
2020-04-03 09:32:23.918 event: video-reconfig
2020-04-03 09:32:24.064 [cplayer] info: VO: [libmpv] 1280x720 yuv420p
2020-04-03 09:32:24.065 event: video-reconfig
2020-04-03 09:32:24.065 [cplayer] v: VO: Description: render API for libmpv
2020-04-03 09:32:24.065 [vo/libmpv] v: reconfig to 1280x720 yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg2/4/h264
It recovers differently but the video was frozen during this period as well....
2020-04-03 09:37:19.997 mpvstats: AV: 1564.898 A-V: 0.000 Dropped: 0 Cache: 23.34s + 0KB
2020-04-03 09:37:24.998 mpvstats: AV: 1569.903 A-V: 0.000 Dropped: 0 Cache: 23.77s + 0KB
2020-04-03 09:37:29.998 mpvstats: AV: 1574.908 A-V: 0.000 Dropped: 0 Cache: 18.73s + 0KB
2020-04-03 09:37:34.997 mpvstats: AV: 1579.896 A-V: 0.000 Dropped: 0 Cache: 13.74s + 0KB
2020-04-03 09:37:39.997 mpvstats: AV: 1584.901 A-V: 0.000 Dropped: 0 Cache: 8.75s + 0KB
2020-04-03 09:37:44.997 mpvstats: AV: 1589.906 A-V: 0.000 Dropped: 0 Cache: 7.89s + 0KB
2020-04-03 09:37:49.997 mpvstats: AV: 1594.895 A-V: 0.000 Dropped: 0 Cache: 2.90s + 0KB
2020-04-03 09:37:54.997 mpvstats: AV: 1599.900 A-V: 0.000 Dropped: 0 Cache: 1.96s + 0KB
2020-04-03 09:38:00.002 mpvstats: AV: 1601.968 A-V: 0.000 Dropped: 0 Cache: 0.00s + 0KB
2020-04-03 09:38:04.997 mpvstats: AV: 1604.254 A-V: 0.000 Dropped: 3 Cache: 1.71s + 0KB
2020-04-03 09:38:10.002 mpvstats: AV: 1606.073 A-V: 0.000 Dropped: 3 Cache: 0.00s + 0KB
2020-04-03 09:38:15.002 mpvstats: AV: 1606.073 A-V: 0.000 Dropped: 3 Cache: 0.00s + 0KB
2020-04-03 09:38:19.997 mpvstats: AV: 1610.744 A-V: 0.000 Dropped: 7 Cache: 3.41s + 0KB
2020-04-03 09:38:25.002 mpvstats: AV: 1614.264 A-V: 0.000 Dropped: 7 Cache: 0.00s + 0KB
2020-04-03 09:38:30.002 mpvstats: AV: 1614.264 A-V: 0.000 Dropped: 7 Cache: 0.00s + 0KB
2020-04-03 09:38:35.002 mpvstats: AV: 1614.264 A-V: 0.000 Dropped: 7 Cache: 0.00s + 0KB
2020-04-03 09:38:39.998 mpvstats: AV: 1619.002 A-V: 0.000 Dropped: 11 Cache: 36.10s + 0KB
2020-04-03 09:38:44.997 mpvstats: AV: 1624.007 A-V: 0.000 Dropped: 11 Cache: 76.16s + 0KB
2020-04-03 09:38:49.997 mpvstats: AV: 1629.012 A-V: 0.000 Dropped: 11 Cache: 77.53s + 0KB
2020-04-03 09:38:54.997 mpvstats: AV: 1634.000 A-V: 0.000 Dropped: 11 Cache: 78.38s + 0KB
2020-04-03 09:38:59.997 mpvstats: AV: 1639.005 A-V: 0.000 Dropped: 11 Cache: 79.32s + 0KB
2020-04-03 09:39:04.997 mpvstats: AV: 1644.010 A-V: 0.000 Dropped: 11 Cache: 79.06s + 0KB
2020-04-03 09:39:09.997 mpvstats: AV: 1648.999 A-V: 0.000 Dropped: 11 Cache: 79.96s + 0KB
2020-04-03 09:39:14.997 mpvstats: AV: 1654.004 A-V: 0.000 Dropped: 11 Cache: 85.16s + 0KB
2020-04-03 09:39:19.998 mpvstats: AV: 1659.009 A-V: 0.000 Dropped: 11 Cache: 88.79s + 0KB
2020-04-03 09:39:24.997 mpvstats: AV: 1663.997 A-V: 0.000 Dropped: 11 Cache: 89.43s + 0KB
Ok so I left the house then came back and the Shield was 2ish minutes behind on the time line. Here is what I was able to grab from the log.
04-03 11:04:39.941 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 24 lines
04-03 11:05:45.972 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 18 lines
04-03 11:06:39.991 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:07:13.001 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:07:43.011 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:08:13.018 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 52 lines
04-03 11:09:32.817 22486 685 I chatty : uid=10119(com.getchannels.dvr.app) expire 1 line
04-03 11:09:33.021 22486 22496 I chatty : uid=10119(com.getchannels.dvr.app) HeapTaskDaemon expire 1 line
04-03 11:10:47.655 22486 22793 I chatty : uid=10119(com.getchannels.dvr.app) streamer expire 1 line
04-03 11:10:49.066 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 16 lines
04-03 11:11:37.077 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 62 lines
04-03 11:12:49.975 22486 22494 I chatty : uid=10119(com.getchannels.dvr.app) FinalizerDaemon expire 1 line
04-03 11:14:43.150 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 20 lines
04-03 11:15:43.169 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:16:13.177 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 21 lines
04-03 11:17:13.189 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 20 lines
04-03 11:18:01.202 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:18:31.209 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 31 lines
04-03 11:20:04.230 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:20:34.236 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 20 lines
04-03 11:21:34.249 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 32 lines
04-03 11:23:04.269 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 31 lines
04-03 11:24:34.299 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:25:01.305 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:25:34.313 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:25:58.317 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:26:28.325 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:26:58.333 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:27:22.336 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:27:52.343 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 5 lines
04-03 11:28:06.606 22486 3092 I chatty : uid=10119(com.getchannels.dvr.app) expire 1 line
04-03 11:28:07.346 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:28:37.350 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:29:07.355 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:29:37.362 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:30:07.366 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:30:37.371 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 6 lines
04-03 11:30:43.917 22486 22494 I chatty : uid=10119(com.getchannels.dvr.app) FinalizerDaemon expire 1 line
04-03 11:30:55.375 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 12 lines
04-03 11:31:29.469 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:31:58.394 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 12 lines
04-03 11:32:34.401 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 13 lines
04-03 11:33:13.428 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:33:43.437 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:34:13.442 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 12 lines
04-03 11:34:49.453 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:35:19.457 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 13 lines
04-03 11:35:58.465 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:36:28.491 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:36:58.493 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 14 lines
04-03 11:37:37.504 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:38:10.506 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:38:40.513 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:39:13.522 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:39:46.534 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:40:16.543 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:40:49.548 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 18 lines
04-03 11:41:37.564 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:42:07.574 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:42:37.580 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 20 lines
04-03 11:43:37.594 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 2 lines
04-03 11:43:38.551 22486 22800 I chatty : uid=10119(com.getchannels.dvr.app) JavaCPP Thread expire 1 line
04-03 11:43:43.596 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 8 lines
04-03 11:44:06.498 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 2 lines
04-03 11:44:07.604 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 1 line
04-03 11:44:09.044 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:44:09.045 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 5 lines
04-03 11:44:16.246 22486 22800 I chatty : uid=10119(com.getchannels.dvr.app) JavaCPP Thread expire 1 line
04-03 11:44:19.607 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 6 lines
04-03 11:44:31.608 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:44:31.615 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:44:58.624 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:45:28.633 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 12 lines
04-03 11:46:01.645 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:46:28.652 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:46:58.660 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 6 lines
04-03 11:47:11.949 22486 22500 I chatty : uid=10119(com.getchannels.dvr.app) Profile Saver expire 2 lines
04-03 11:47:13.663 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:47:43.672 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:48:13.675 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:48:43.685 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:49:06.602 22486 22793 I chatty : uid=10119(com.getchannels.dvr.app) streamer expire 1 line
04-03 11:49:16.695 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 11 lines
04-03 11:49:49.707 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 10 lines
04-03 11:50:19.714 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 7 lines
04-03 11:50:35.248 22486 22800 I chatty : uid=10119(com.getchannels.dvr.app) JavaCPP Thread expire 1 line
04-03 11:50:40.719 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 4 lines
04-03 11:50:50.051 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 5 lines
04-03 11:50:52.720 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 3 lines
04-03 11:50:59.963 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:50:59.965 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 5 lines
04-03 11:51:03.271 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 6 lines
04-03 11:51:04.043 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 9 lines
04-03 11:51:18.789 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:18.796 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 3 lines
04-03 11:51:20.822 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:20.841 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 5 lines
04-03 11:51:30.039 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:30.042 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 5 lines
04-03 11:51:32.023 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:32.025 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 4 lines
04-03 11:51:42.295 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:42.298 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 4 lines
04-03 11:51:44.247 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 4 lines
04-03 11:51:44.248 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 3 lines
04-03 11:51:44.789 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 2 lines
04-03 11:51:44.794 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 3 lines
04-03 11:51:46.741 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:51:46.742 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 7 lines
04-03 11:52:00.055 22486 22530 I chatty : uid=10119(com.getchannels.dvr.app) mpv-events expire 3 lines
04-03 11:52:00.058 22486 22486 I chatty : uid=10119(com.getchannels.dvr.app) expire 2 lines
04-03 11:52:01.733 22486 22486 V mpvstats: AV: 7321.695 A-V: 0.000 Dropped: 64 Cache: 0.256s + 0KB
04-03 11:52:01.986 22486 22530 V mpv : event: unpause
04-03 11:52:01.986 22486 22530 V mpv : [cplayer] Enter buffering (buffer went from 100% -> 16%) [0.166833s].
04-03 11:52:01.986 22486 22530 V mpv : property: buffering = true
04-03 11:52:01.986 22486 22486 V PlayerActivity: state PLAYING -> BUFFERING
04-03 11:52:01.987 22486 22486 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=7281.237277888889, end=7321.561866777778}], cache-end=7322.295922333333, reader-pts=7322.129089, cache-duration=0.16683333333276096, eof=false, underrun=true, idle=false, total-bytes=30520960, fw-bytes=90688, debug-low-level-seeks=0, debug-ts-last=9613.608633333333, ts-per-stream=[{type=video, duration=0.16683333333276096, reader=9613.4418, end=9613.608633333333}, {type=audio, duration=0.0, reader=9613.628911111111, end=9613.628911111111}]}
04-03 11:52:04.734 22486 22486 V mpvstats: AV: 7321.962 A-V: 0.000 Dropped: 64 Cache: 0.167s + 0KB
04-03 11:52:06.301 22486 22530 V mpv : event: unpause
04-03 11:52:06.306 22486 22530 V mpv : [cplayer] End buffering (waited 4.312014 secs) [2.261333s].
04-03 11:52:06.312 22486 22530 V mpv : property: buffering = false
04-03 11:52:06.312 22486 22486 V PlayerActivity: state BUFFERING -> PLAYING
04-03 11:52:06.313 22486 22486 V mpvstats: demuxer-cache-state: {seekable-ranges=[{start=7281.237277888889, end=7324.431377888888}], cache-end=7324.876200111112, reader-pts=7322.444200111111, cache-duration=2.4320000000006985, eof=false, underrun=false, idle=false, total-bytes=32360768, fw-bytes=1872384, debug-low-level-seeks=0, debug-ts-last=9616.14448888889, ts-per-stream=[{type=video, duration=2.6025777777776966, reader=9613.541911111111, end=9616.14448888889}, {type=audio, duration=2.4320000000006985, reader=9613.756911111112, end=9616.188911111112}]}
04-03 11:52:07.152 22486 22486 V mpvstats: AV: 7322.897 A-V: 0.000 Dropped: 66 Cache: 12.674s + 0KB
04-03 11:52:07.734 22486 22486 V mpvstats: AV: 7323.464 A-V: 0.000 Dropped: 66 Cache: 18.690s + 0KB
04-03 11:52:10.734 22486 22486 V mpvstats: AV: 7326.467 A-V: 0.000 Dropped: 66 Cache: 34.007s + 0KB
04-03 11:52:13.734 22486 22486 V mpvstats: AV: 7329.470 A-V: 0.000 Dropped: 66 Cache: 68.269s + 0KB
04-03 11:52:13.926 22486 22530 D mpv : [ffmpeg/video] h264: Reinit context to 1920x1088, pix_fmt: yuv420p
04-03 11:52:14.058 22486 22530 V mpv : [vd] Decoder format: 1920x1080 [0:1] yuv420p bt.709/bt.709/bt.1886/limited/auto CL=mpeg1/jpeg (auto 0.000000/0.000000/0.000000)
04-03 11:52:14.059 22486 22530 V mpv : [vd] Forcing user-set aspect ratio.
04-03 11:52:14.059 22486 22530 V mpv : [vf] [in] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.088 22486 22530 V mpv : [vf] [userdeint] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.088 22486 22530 V mpv : [vf] [lavfi] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.088 22486 22530 V mpv : [lavfi] format change on in0
04-03 11:52:14.088 22486 22530 V mpv : [lavfi] recovering all eof
04-03 11:52:14.095 22486 22530 D mpv : [ffmpeg] mpv_src_in0: w:1920 h:1080 pixfmt:yuv420p tb:1/1000000 fr:60/1 sar:134217729/134217728 sws_param:
04-03 11:52:14.095 22486 22530 D mpv : [lavfi] Filter graph:
04-03 11:52:14.095 22486 22530 D mpv : [lavfi] +--------------------+
04-03 11:52:14.095 22486 22530 D mpv : [lavfi] mpv_src_in0:default--[1920x1080 134217729:134217728 yuv420p]--default| Parsed_fastdeint_0 |default--[1920x1080 134217729:134217728 yuv420p]--mpv_sink_out0:default
04-03 11:52:14.095 22486 22530 D mpv : [lavfi] | (fastdeint) |
04-03 11:52:14.095 22486 22530 D mpv : [lavfi] +--------------------+
04-03 11:52:14.095 22486 22530 D mpv : [lavfi]
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] +---------------+
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] Parsed_fastdeint_0:default--[1920x1080 134217729:134217728 yuv420p]--default| mpv_sink_out0 |
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] | (buffersink) |
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] +---------------+
04-03 11:52:14.096 22486 22530 D mpv : [lavfi]
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] +-------------+
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] | mpv_src_in0 |default--[1920x1080 134217729:134217728 yuv420p]--Parsed_fastdeint_0:default
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] | (buffer) |
04-03 11:52:14.096 22486 22530 D mpv : [lavfi] +-------------+
04-03 11:52:14.096 22486 22530 D mpv : [lavfi]
04-03 11:52:14.096 22486 22530 D mpv : [lavfi]
04-03 11:52:14.096 22486 22530 V mpv : [vf] [autorotate] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.096 22486 22530 V mpv : [vf] [convert] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.096 22486 22530 V mpv : [vf] [out] 1920x1080 [134217729:134217728] yuv420p bt.709/bt.709/bt.1886/limited/display SP=1.000000 CL=mpeg1/jpeg
04-03 11:52:14.096 22486 22530 I mpv : [cplayer] VO: [gpu] 1920x1080 => 1920x1080 yuv420p
04-03 11:52:14.096 22486 22530 V mpv : [cplayer] VO: Description: Shader-based GPU Renderer
04-03 11:52:14.101 22486 22530 V mpv : event: video-reconfig
04-03 11:52:14.101 22486 22530 V mpv : event: video-reconfig
04-03 11:52:14.156 22486 22486 V mpvstats: AV: 7329.870 A-V: 0.001 Dropped: 0 Cache: 73.255s + 0KB
04-03 11:52:16.735 22486 22486 V mpvstats: AV: 7332.456 A-V: 0.000 Dropped: 0 Cache: 95.019s + 0KB
04-03 11:52:19.736 22486 22486 V mpvstats: AV: 7335.459 A-V: 0.000 Dropped: 0 Cache: 95.019s + 0KB
04-03 11:52:22.736 22486 22486 V mpvstats: AV: 7338.462 A-V: 0.000 Dropped: 0 CacheThis is the same 32s timeout you saw on Android. If it's happening on a different device/OS/client then you're right this is not client-specific and either a network or DVR server issue.
What is the network path between the shield and the internet? What are all the switches and hops involved? Are you using powerline or moca or Wi-Fi mesh?
If you look in the last log that was from the Shield which is the same device as the Server. Doesn't that eliminate the network?
My clients are connected to the Router Via Ethernet. My Shield (DVR) is connected to a switch via Ethernet then the switch is connected to the router via Ethernet so one hop.