I am having the same problem! Will watch to see if a fix is figured out!
Just an FYI it works fine on my Roku Ultra no stoppages at all watching FBN.
I seem to be having the most issues with FNC and CNBC.
It just happened again during a commercial. Here's the log.
2019/08/24 09:46:42 [TNR] Sharing existing connection to TVE-DTV for ch6073 FNC (clients=2, len=0, transcode=none)
2019/08/24 09:59:41 [ERR] Error during stream TVE-DTV ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=7a9d470d0b87436aa31686c9c1dea6c9&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=36
Last message repeated 6 times
Please try latest DVR build and post the new error message.
I'm assuming I'm already on the most current DVR Build. Please correct me if I'm wrong.
Status About this server
Version
2019.08.15.2304
Check For Update
Uptime
9 days
Started 08/15/2019
Timezone
PDT
OS
Apple Macmini8,1
Darwin
10.14.6 (kernel: 18.7.0)
CPU
6 cores / Intel(R) Core(TM) i7-8700B CPU @ 3.20GHz
load averages: 3.68 3.84 3.85
RAM
16.00 GB
14.1% free
Disk
0.0% used
3724.38 GB available
Activity
Watching ch6030 CNN from 192.168.3.190.
Watching ch6769 from 192.168.4.35 (Running: 33m2s @ 1.01x).
Here's some more error logs.
2019/08/24 11:31:18 [TNR] Opened connection to TVE-DTV for ch6073 FNC
2019/08/24 11:31:19 [HLS] Probed live stream in 512.565371ms: h264 1920x1080 progressive 4883692bps
2019/08/24 11:31:19 [HLS] Starting transcoder for channel 6073 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
[aac @ 0x7fa6db03dc00] Reserved SBR extensions is not implemented. Update your FFmpeg version to the newest one from Git. If the problem still occurs, it means that your file has a feature which has not been implemented.
[aac @ 0x7fa6db03dc00] If you want to help, upload a sample of this file to ftp://upload.ffmpeg.org/incoming/ and contact the ffmpeg-devel mailing list. ([email protected])
[aac @ 0x7fa6db03dc00] Expected to read 15 SBR bytes actually read 18.
[aac @ 0x7fa6db03dc00] env_facs_q 255 is invalid
2019/08/24 11:51:20 [ERR] Error during stream TVE-DTV ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=5f4d6f8034c34094a5e3e9e211398a35&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=17
2019/08/24 11:51:24 [HLS] Stopping transcoder session ch6073-dANY-ip192.168.4.35 @ 19m45.792s
2019/08/24 11:51:24 [TNR] Closed connection to TVE-DTV for ch6073 FNC
2019/08/24 12:29:54 [TNR] Opened connection to TVE-DTV for ch6073 FNC
2019/08/24 12:29:55 [HLS] Probed live stream in 560.034411ms: h264 1920x1080 progressive 5184000bps
2019/08/24 12:29:55 [HLS] Starting transcoder for channel 6073 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
2019/08/24 12:38:53 [HLS] Stopping transcoder session ch6073-dANY-ip192.168.4.35 @ 8m56.064s
[h264 @ 0x7f7ffe915400] cabac decode of qscale diff failed at 9 7
[h264 @ 0x7f7ffe915400] error while decoding MB 9 7, bytestream -6
2019/08/24 12:38:53 [TNR] Closed connection to TVE-DTV for ch6073 FNC
019/08/24 15:10:33 [TNR] Opened connection to TVE-DTV for ch6073 FNC
2019/08/24 15:10:34 [HLS] Probed live stream in 910.261825ms: h264 1280x720 progressive 6143999bps
2019/08/24 15:10:34 [HLS] Starting transcoder for channel 6073 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
[h264_videotoolbox @ 0x7ff06e99ae00] Color range not set for yuv420p. Using MPEG range.
[aac @ 0x7ff06ea98200] env_facs_q 253 is invalid
2019/08/24 15:28:46 [NAT] Successfully mapped port 8089 using natpmp
[aac @ 0x7ff06ea98200] Reserved SBR extensions is not implemented. Update your FFmpeg version to the newest one from Git. If the problem still occurs, it means that your file has a feature which has not been implemented.
[aac @ 0x7ff06ea98200] If you want to help, upload a sample of this file to ftp://upload.ffmpeg.org/incoming/ and contact the ffmpeg-devel mailing list. ([email protected])
[aac @ 0x7ff06ea98200] Expected to read 15 SBR bytes actually read 18.
2019/08/24 15:32:11 [TNR] Opened connection to TVE-DTV for ch6030 CNN [transcode=none]
[aac @ 0x7ff06ea98200] env_facs_q 255 is invalid
2019/08/24 15:40:30 [ERR] Error during stream TVE-DTV ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=b2a4c63f5b1244aaa0d06b8e5331f142&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=23
2019/08/24 15:40:33 [HLS] Stopping transcoder session ch6073-dANY-ip192.168.4.35 @ 29m45.344s
2019/08/24 15:40:33 [TNR] Closed connection to TVE-DTV for ch6073 FNC
2019/08/24 15:44:17 [TNR] Opened connection to TVE-DTV for ch6073 FNC
2019/08/24 15:44:17 [HLS] Probed live stream in 512.630711ms: h264 1280x720 progressive 4280656bps
2019/08/24 15:44:17 [HLS] Starting transcoder for channel 6073 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
[h264_videotoolbox @ 0x7ffb3182be00] Color range not set for yuv420p. Using MPEG range.
[aac @ 0x7ffb318f1e00] env_facs_q 255 is invalid
2019/08/24 16:01:49 [HLS] Stopping transcoder session ch6073-dANY-ip192.168.4.35 @ 17m43.210666s
Last message repeated 2 times
[h264 @ 0x7ffb31926200] error while decoding MB 43 29, bytestream -8
2019/08/24 16:01:49 [TNR] Closed connection to TVE-DTV for ch6073 FNC
2019/08/24 16:02:42 [ERR] Failed to start stream for ch6758: TVE: Stream not live
2019/08/24 16:02:59 [TNR] Opened connection to TVE-DTV for ch6161 NBCSN
2019/08/24 16:03:00 [HLS] Probed live stream in 871.333557ms: h264 1920x1080 progressive 5834008bps
2019/08/24 16:03:00 [HLS] Starting transcoder for channel 6161 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
2019/08/24 16:03:12 [HLS] Stopping transcoder session ch6161-dANY-ip192.168.4.35 @ 22.593s
[h264 @ 0x7f89eb03d200] error while decoding MB 86 36, bytestream -5
pipe:: corrupt decoded frame in stream 0
2019/08/24 16:03:12 [TNR] Closed connection to TVE-DTV for ch6161 NBCSN
2019/08/24 16:03:16 [TNR] Opened connection to TVE-DTV for ch6161 NBCSN
2019/08/24 16:03:17 [HLS] Probed live stream in 783.253831ms: h264 1920x1080 progressive 6066935bps
2019/08/24 16:03:17 [HLS] Starting transcoder for channel 6161 from 192.168.4.35 (encoder=h264_videotoolbox, resolution=720, deinterlacer=blend, bitrate=4000)
2019/08/24 16:03:20 [HLS] Stopping transcoder session ch6161-dANY-ip192.168.4.35 @ 10.0078s
[h264 @ 0x7fa97b8a4600] error while decoding MB 16 66, bytestream -5
pipe:: corrupt decoded frame in stream 0
2019/08/24 16:03:20 [TNR] Closed connection to TVE-DTV for ch6161 NBCSN
Latest is 2019.08.24.1834. Hold shift and click āCheck For updateā.
Latest logs donāt seem to show anything interesting:
2019/08/24 21:21:52 [TNR] Opened connection to TVE-sony_auth-gateway_net for ch6073 FNC
2019/08/24 21:31:12 [ERR] Error during stream TVE-sony_auth-gateway_net ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=df835e3a2482403986a725bcc0cbaf02&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=7: 403 Forbidden
2019/08/24 21:31:12 [TNR] Closed connection to TVE-sony_auth-gateway_net for ch6073 FNC
I've updated to the latest rev and then ran a test again on FNC. It ran for 27 minutes for an error popped up and stopped the stream.
2019/08/24 19:04:01 [TNR] Opened connection to TVE-DTV for ch6073 FNC [transcode=none]
2019/08/24 19:31:10 [ERR] Error during stream TVE-DTV ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=91a215196e2d447a93c4a632ae1c48be&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=17: 403 Forbidden
2019/08/24 19:31:11 [TNR] Closed connection to TVE-DTV for ch6073 FNC
That's very helpful. The 403 Forbidden indicates that the streaming server prevented the file from being downloaded. It will require further investigation to understand why it is returning that.
My SWAG, not knowing your code or how it all fits together is that one of the playlists being used is switching the source to an advertisers stream that is not in sync with the program. Like an 3rd party adverstiser getting imbedded JS put in a web page and the browser does a GET.
Either that, or when the connection drops and CHDVR reconnects it's getting a different HLS stream where the timestamps don't match what it started with.
It's definetly channel (or Network) specific, as some channels (Networks) don't exhibit the issue.
I really only use TVE for one channel (DIY) that comes in HD, where my Xfinity has it in SD, and that channel works fine w/TVE. I figure some day I'll cut the cord and that's why I'm willing to help the effort before I have to rely on it.
Yeah, I didnāt notice the 403 until after I posted. That should be helpful as you said.
Just an observation that I thought Iād share to see if others are seeing the same.
Both yesterday and today so far tit seems the frequency of the issue is less. Yesterday we had FNC playing for 2 1/2 hours before it happened and today itās been running for 2 hours without any problems so far.
Previously, it was happening a couple of times an hour for us.
I just had this happen on 2 completely different channels. My wife is upstairs watching Food network and I'm downstairs watching DIY network. Both streams failed within a few minutes of eachother.
2019/08/28 12:26:04 [TNR] Opened connection to TVE-ATTOTT for ch6108 DIY
2019/08/28 12:30:00 [TNR] Closed connection to 104F208B for ch20.1 WFYI 1
2019/08/28 12:30:04 [DVR] Finished job 1567008000-9 Super Why!
2019/08/28 12:30:04 [DVR] Waiting 5h29m55.280069995s until next job 1567029600-4 Mama's Family
2019/08/28 12:30:04 [DVR] Processing file-70: TV/Super Why!/Super Why! S01E35 2008-09-03 Pinocchio 2019-08-28-1200.mpg
2019/08/28 12:30:07 [DVR] Running commercial detection on file 70 (TV/Super Why!/Super Why! S01E35 2008-09-03 Pinocchio 2019-08-28-1200.mpg)
2019/08/28 12:38:30 [DVR] Commercial detection finished with 4 markers.
2019/08/28 14:42:20 [TNR] Opened connection to TVE-ATTOTT for ch6102 FOOD
2019/08/28 15:40:34 [ERR] Error during stream TVE-ATTOTT ch6102 FOOD: Failed to download file: https://x-default-stgec.uplynk.com/auso/slices/369/4f59ea65df184a2580ad8fc80d3eaa32/369ef7d79c4f4864a657649f90d35f26/H00000004.ts?pbs=20339d74b6c24f77a12e1df84b42ed2f&_jt=l&chid=9181e4aeaf864e45aafe0dd2373ee4cd&oid=e6cf0c55dac249f0a0f72e7c72e6f6cb&si=33
2019/08/28 15:40:36 [TNR] Closed connection to TVE-ATTOTT for ch6102 FOOD
2019/08/28 15:47:52 [ERR] Error during stream TVE-ATTOTT ch6108 DIY: Failed to download file: https://x-default-stgec.uplynk.com/auso/slices/369/4f59ea65df184a2580ad8fc80d3eaa32/369ef7d79c4f4864a657649f90d35f26/H00000004.ts?pbs=2e3e9b1690f4433086ee9e184350e472&_jt=l&chid=480d1ff42e924413990ee0eeb693ce9f&oid=e6cf0c55dac249f0a0f72e7c72e6f6cb&si=138
2019/08/28 15:47:54 [TNR] Closed connection to TVE-ATTOTT for ch6108 DIY
2019/08/28 15:51:47 [TNR] Opened connection to TVE-ATTOTT for ch6102 FOOD
I'm on DVR server build 2019.08.15.2304. ATV Version 3.2.26. I submitted video player diag logs from both ATVs but this is all that I saw in the log on the DVR server.
Please update the DVR to the latest version (click-and-hold the Check For Update button).
If it happens again please provide logs again (the new version has better logs for these failures).
1 Like
FNC just happened again.
2019/08/28 16:26:06 [TNR] Opened connection to TVE-ATTOTT for ch6073 FNC
2019/08/28 16:48:07 [ERR] Error during stream TVE-ATTOTT ch6073 FNC: Failed to download file: https://x-live-fox-stgec.uplynk.com/ausc/slices/afd/4f59ea65df184a2580ad8fc80d3eaa32/afd76bf662454d8b870fd07499a57c8f/H0000000F.ts?pbs=809ec7a2ce254c23955363c41a64e82d&_jt=l&chid=1e298c9d65a245b3bd37f339cadcca58&oid=5b6fd7c6528d417e8bdad7f79754bb9e&si=24: 403 Forbidden
2019/08/28 16:48:10 [TNR] Closed connection to TVE-ATTOTT for ch6073 FNC
Same 403 as seen above. I'l keep trying different channels
Is there anything that can be done in the player to account for this problem? I just returned from a trip and my wife told me it pita and that it happens āall the timeā. Iāve been home for less than a few hours and have seen it 3-4 times already.
Any improvement in the latest DVR build?
Been watching Netflix tonight but we can do some testing. Is 2019.09.03.1947 the latest?