DVR v2023.11.04.1722 and Synology Chrome version

[chDVRuser]

DVR Pre-Release Notes

v2023.11.04.0454 • UPDATED: Provide updated Chrome for x86_64-based NAS without Experimental setting

So which Chrome version is it using, 97 or 114?

2023/11/04 11:06:08.130701 [TVE] action=version product=Chrome/114.0.5735.199 jsVersion=11.4.183.25 protocol=1.3 revision=@581ada08cf738a4eb44f712c6f8cd40030e5c1a0
2023/11/04 11:06:08.132266 [TVE] action=page_ready chromeVersion=97

[chDVRuser]

After stopping and starting the Channels DVR Synology package, it looks normal.

2023/11/04 18:24:14.649060 [TVE] action=version product=Chrome/114.0.5735.199 jsVersion=11.4.183.25 protocol=1.3 revision=@581ada08cf738a4eb44f712c6f8cd40030e5c1a0
2023/11/04 18:24:14.651813 [TVE] action=page_ready chromeVersion=114

[chDVRuser]

Channels DVR v2023.11.06.2221
[TVE] Couldn't get Chrome User Agent: fork/exec ./chromedp-shell: no such file or directory
Is this considered normal?

2023/11/08 11:52:31.678446 [TVE] Auth starting for Dish as testing123
2023/11/08 11:52:31.829621 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 11:52:33.131949 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 11:52:33.871027 [TVE] chromedp-chroot already up to date
2023/11/08 11:52:33.871645 [TVE] Couldn't get Chrome User Agent: fork/exec ./chromedp-shell: no such file or directory
2023/11/08 11:52:34.145862 [TVE] action=auth mvpd=Dish requestor=nbcentertainment
2023/11/08 11:52:34.147119 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 11:52:34.589965 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 11:52:35.254008 [TVE] chromedp-chroot already up to date
2023/11/08 11:52:35.263206 [TVE] Auth failed for Dish: fork/exec ./chromedp-shell: no such file or directory

Run troubleshooting and click the green Click here to upgrade Chrome button

2023/11/08 12:27:47.942322 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 12:27:48.791049 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 12:27:49.510231 [TVE] chromedp-chroot already up to date

Add DirecTV click and hold Sign In button

2023/11/08 12:31:28.590131 [TVE] Auth starting for DTV as testing234
2023/11/08 12:31:29.034627 [TVE] action=auth mvpd=DTV requestor=nbcentertainment
2023/11/08 12:31:29.035885 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 12:31:29.882622 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 12:31:30.614783 [TVE] chromedp-chroot already up to date
2023/11/08 12:31:30.615984 [TVE] Auth failed for DTV: fork/exec ./chromedp-shell: no such file or directory

Troubleshooting shows chrome corrupt again. Click update chrome

2023/11/08 12:33:25.504237 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 12:33:26.375666 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 12:33:27.085779 [TVE] chromedp-chroot already up to date

No change after updating to v2023.11.08.1851

[eric]

does chromedp-shell exist in the data directory? Does /bin/bash exist?

[chDVRuser]

@eric

does chromedp-shell exist in the data directory?

No, just data/chromedp-chroot

@eric

Does /bin/bash exist?

Yes

root@DS1019PLUS:~# which bash
/bin/bash
root@DS1019PLUS:~# ls -l /bin/bash
-rwxr-xr-x 1 root root 1204768 Oct  6  2021 /bin/bash

root@DS1019PLUS:/volume1/@appstore/ChannelsDVR/channels-dvr/data# ls -l
total 54420
drwxr-xr-x  3 channels channels     4096 Aug 11 19:39 cache
-rw-r--r--  1 channels channels     1094 Aug 11 19:39 cert.pem
-rw-r--r--  1 channels channels  1773039 Nov  8 15:20 channels-dvr-http.log
-rw-r--r--  1 channels channels  1107760 Nov  8 15:20 channels-dvr.log
-rw-r--r--  1 channels channels  2097129 Nov  6 09:38 channels-http-cache-2023-11-06T09-38-53.347.log
-rw-r--r--  1 channels channels  2097151 Nov  6 12:07 channels-http-cache-2023-11-06T12-07-24.991.log
-rw-r--r--  1 channels channels  2097012 Nov  8 11:55 channels-http-cache-2023-11-08T11-55-05.560.log
-rw-r--r--  1 channels channels  1114824 Nov  8 15:19 channels-http-cache.log
-rw-r--r--  1 channels channels      249 Nov  4 10:48 channels-http-cache-trace.log
drwxr-xr-x  4 channels channels     4096 Nov  4 21:06 chromedata
drwxr-xr-x 22 channels channels     4096 Nov  4 10:58 chromedp-chroot
-rw-r--r--  1 channels channels 10485447 Nov  6 01:59 hls-2023-11-06T01-59-24.316.log
-rw-r--r--  1 channels channels 10484883 Nov  6 03:01 hls-2023-11-06T03-01-17.405.log
-rw-r--r--  1 channels channels 10485750 Nov  6 05:30 hls-2023-11-06T05-30-47.828.log
-rw-r--r--  1 channels channels 10314083 Nov  8 14:43 hls.log
-rw-------  1 channels channels     1675 Aug 11 19:39 key.pem
-rw-------  1 channels channels   131072 Nov  8 15:20 recorder.db
drwx------  5 channels channels     4096 Aug 11 19:40 recorder.idx
-rw-------  1 channels channels  1048576 Nov  8 13:46 settings.db
-rw-r--r--  1 channels channels  2559414 Nov  4 21:12 tve_chrome.log
-rw-r--r--  1 channels channels   163077 Nov  4 11:49 tve_error_screenshot.html
-rw-r--r--  1 channels channels    25887 Nov  4 11:49 tve_error_screenshot.png
drwx------  3 channels channels     4096 Nov  6 10:46 X-M3U.airings
drwx------  3 channels channels     4096 Nov  6 10:46 X-M3U.groups
drwx------  3 channels channels     4096 Nov  6 10:46 X-TVE.airings
drwx------  3 channels channels     4096 Nov  6 10:46 X-TVE.groups

[Frank_Monroe]

I'm seeing this exact same behavior on my Sinology DS218+.

[bpa_dvr]

now seeing the same thing on my QNAP NAS

[Frank_Monroe]

With the latest update, the error has changed to the following:

2023/11/08 20:19:08.124958 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/08 20:19:08.184547 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/08 20:19:08.186001 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 20:19:08.960436 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 20:19:09.518676 [ERR] Failed to start stream for ch6012: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:10.583454 [HLS] Couldn't generate stream playlist for ch6012-dANY-ip192.168.1.191: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:10.583585 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/08 20:19:11.602772 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/08 20:19:11.662929 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/08 20:19:11.664447 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 20:19:11.980469 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 20:19:12.576185 [ERR] Failed to start stream for ch6012: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:12.583693 [HLS] Couldn't generate stream playlist for ch6012-dANY-ip192.168.1.191: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:12.583816 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/08 20:19:13.637532 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/08 20:19:13.711777 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/08 20:19:13.713355 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 20:19:13.986624 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 20:19:14.617259 [ERR] Failed to start stream for ch6012: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:14.696432 [HLS] Couldn't generate stream playlist for ch6012-dANY-ip192.168.1.191: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")
2023/11/08 20:19:14.696553 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/08 20:19:15.641161 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/08 20:19:15.710322 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/08 20:19:15.711658 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 20:19:15.982308 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/08 20:19:16.015488 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 20:19:16.683434 [ERR] Failed to start stream for ch6012: TVE: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n  \"errors\": [\n    {\n      \"code\": \"TOOMANYREQUESTS\",\n      \"message\": \"You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: https://www.docker.com/increase-rate-limit\"\n    }\n  ]\n}\n")

[bpa_dvr]

with the latest update, troubleshooting is just repeatedly trying to check chrome then errors saying too many pulls...

2023/11/08 17:37:52.974019 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 17:37:53.407856 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 17:37:54.072922 [TVE] chromedp-chroot already up to date
2023/11/08 17:37:54.073927 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 17:37:54.558838 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 17:37:55.227655 [TVE] chromedp-chroot already up to date
2023/11/08 17:37:55.228696 registry.ping url=https://registry-1.docker.io/v2/
2023/11/08 17:37:55.696277 registry.manifest.get url=https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199 repository=chromedp/headless-shell reference=114.0.5735.199
2023/11/08 17:37:56.314457 [TVE] Couldn't get Chrome User Agent: Get "https://registry-1.docker.io/v2/chromedp/headless-shell/manifests/114.0.5735.199": http: non-successful response (status=429 body="{\n "errors": [\n {\n "code": "TOOMANYREQUESTS",\n "message": "You have reached your pull rate limit. You may increase the limit by authenticating and upgrading: Understanding Your Docker Hub Rate Limit | Docker"\n }\n ]\n}\n")

[eric]

Checking it out. Thanks everyone.

[eric]

@bpa_dvr: Please update to the latest pre-release. It should be better now.

[chDVRuser]

DVR Pre-Release Notes

v2023.11.09.1609 • FIXED: Always make sure chromedp-shell is written for downloaded Chrome

DVR Pre-Release Notes

v2023.11.09.2207 • IMPROVED: Troubleshooting list now reports the current Chrome version

[Frank_Monroe]

Thanks for all the work on this. Is this supposed to fix YouTube TV TVE on Synology? With the latest update Google is still blocking Chrome:

2023/11/09 18:13:44.368051 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/09 18:13:44.440744 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/09 18:13:44.561865 [TVE] action=version product=Chrome/114.0.5735.199 jsVersion=11.4.183.25 protocol=1.3 revision=@581ada08cf738a4eb44f712c6f8cd40030e5c1a0
2023/11/09 18:13:44.563319 [TVE] action=page_ready chromeVersion=114
2023/11/09 18:13:44.564178 [TVE] action=navigate url=https://sp.auth.adobe.com/adobe-services/authenticate/saml?noflash=true&mso_id=YouTubeTV&requestor_id=ABC&no_iframe=true&domain_name=adobe.com&redirect_url=https%3A%2F%2Fsp.auth.adobe.com%2Fadobe-services%2FcompletePassiveAuthentication
2023/11/09 18:13:44.565916 [TVE] action=request type=Document method=GET url=https://sp.auth.adobe.com/adobe-services/authenticate/saml
2023/11/09 18:13:45.327534 [TVE] action=wait_for_page
2023/11/09 18:13:45.356398 [TVE] action=request type=Document method=POST url=https://youtube.auth-gateway.net/saml/saml2/idp/SSOService.php
2023/11/09 18:13:45.356448 [TVE] action=auth_domain domain=youtube.auth-gateway.net
2023/11/09 18:13:45.560200 [TVE] action=request type=Document method=GET url=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php redirected_from=https://youtube.auth-gateway.net/saml/saml2/idp/SSOService.php
2023/11/09 18:13:45.686039 [TVE] action=request type=Document method=GET url=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php
2023/11/09 18:13:45.754608 [TVE] action=request type=Document method=GET url=https://accounts.google.com/o/oauth2/auth redirected_from=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php
2023/11/09 18:13:46.040182 [TVE] action=request type=Document method=GET url=https://accounts.google.com/v3/signin/identifier redirected_from=https://accounts.google.com/o/oauth2/auth
2023/11/09 18:13:52.718933 [TVE] action=page_ready
2023/11/09 18:13:52.719001 [TVE] action=wait_for_page done=true reason=page_ready
2023/11/09 18:13:52.719124 [TVE] action=wait_for_auth timeout=24s
2023/11/09 18:13:52.719165 [TVE] action=fill_form [email protected]
2023/11/09 18:13:52.725032 [TVE] action=tvejs msg="googleLogin"
2023/11/09 18:13:55.265050 [TVE] action=tvejs msg="googleLoginPassword browser or app may not be secure"
2023/11/09 18:13:55.265681 [TVE] action=fill_form state=done err=&runtime.ExceptionDetails{ExceptionID:1, Text:"Uncaught (in promise)", LineNumber:0, ColumnNumber:0, ScriptID:"", URL:"", StackTrace:(*runtime.StackTrace)(nil), Exception:(*runtime.RemoteObject)(0xc000927b90), ExecutionContextID:0, ExceptionMetaData:easyjson.RawMessage(nil)}
2023/11/09 18:13:55.265732 [TVE] action=screenshot
2023/11/09 18:13:55.377704 [TVE] action=screenshot size=24335
2023/11/09 18:13:55.378048 [TVE] action=capture_html
2023/11/09 18:13:55.419869 [TVE] action=capture_html size=636098
2023/11/09 18:13:55.422003 [TVE] action=script_error err=Blocked by Google: This browser or app may not be secure
2023/11/09 18:13:56.360374 [ERR] Failed to start stream for ch6012: TVE: Blocked by Google: This browser or app may not be secure
2023/11/09 18:13:56.885336 [HLS] Couldn't generate stream playlist for ch6012-dANY-ip192.168.1.191: TVE: Blocked by Google: This browser or app may not be secure
2023/11/09 18:13:56.885431 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/09 18:13:57.977935 [TVE] action=authz_retry err=adobe.pendingLogout reason=34764
2023/11/09 18:13:58.038583 [TVE] action=auth mvpd=YouTubeTV requestor=ABC
2023/11/09 18:13:58.165689 [TVE] action=version product=Chrome/114.0.5735.199 jsVersion=11.4.183.25 protocol=1.3 revision=@581ada08cf738a4eb44f712c6f8cd40030e5c1a0
2023/11/09 18:13:58.167182 [TVE] action=page_ready chromeVersion=114
2023/11/09 18:13:58.168192 [TVE] action=navigate url=https://sp.auth.adobe.com/adobe-services/authenticate/saml?noflash=true&mso_id=YouTubeTV&requestor_id=ABC&no_iframe=true&domain_name=adobe.com&redirect_url=https%3A%2F%2Fsp.auth.adobe.com%2Fadobe-services%2FcompletePassiveAuthentication
2023/11/09 18:13:58.169673 [TVE] action=request type=Document method=GET url=https://sp.auth.adobe.com/adobe-services/authenticate/saml
2023/11/09 18:13:58.371842 [TVE] action=wait_for_page
2023/11/09 18:13:58.405779 [TVE] action=request type=Document method=POST url=https://youtube.auth-gateway.net/saml/saml2/idp/SSOService.php
2023/11/09 18:13:58.405830 [TVE] action=auth_domain domain=youtube.auth-gateway.net
2023/11/09 18:13:58.566051 [TVE] action=request type=Document method=GET url=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php redirected_from=https://youtube.auth-gateway.net/saml/saml2/idp/SSOService.php
2023/11/09 18:13:58.654936 [TVE] action=request type=Document method=GET url=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php
2023/11/09 18:13:58.826180 [TVE] action=request type=Document method=GET url=https://accounts.google.com/o/oauth2/auth redirected_from=https://youtube.auth-gateway.net/saml/module.php/authbypass/firstbookend.php
2023/11/09 18:13:59.157336 [TVE] action=request type=Document method=GET url=https://accounts.google.com/v3/signin/identifier redirected_from=https://accounts.google.com/o/oauth2/auth
2023/11/09 18:14:05.750124 [TVE] action=page_ready
2023/11/09 18:14:05.750179 [TVE] action=wait_for_page done=true reason=page_ready
2023/11/09 18:14:05.750249 [TVE] action=wait_for_auth timeout=24s
2023/11/09 18:14:05.750301 [TVE] action=fill_form [email protected]
2023/11/09 18:14:05.756314 [TVE] action=tvejs msg="googleLogin"
2023/11/09 18:14:06.889195 [HLS] Stopping transcoder session ch6012-dANY-ip192.168.1.191
2023/11/09 18:14:08.296361 [TVE] action=tvejs msg="googleLoginPassword browser or app may not be secure"
2023/11/09 18:14:08.297118 [TVE] action=fill_form state=done err=&runtime.ExceptionDetails{ExceptionID:1, Text:"Uncaught (in promise)", LineNumber:0, ColumnNumber:0, ScriptID:"", URL:"", StackTrace:(*runtime.StackTrace)(nil), Exception:(*runtime.RemoteObject)(0xc003ebeb40), ExecutionContextID:0, ExceptionMetaData:easyjson.RawMessage(nil)}
2023/11/09 18:14:08.297220 [TVE] action=screenshot
2023/11/09 18:14:08.390784 [TVE] action=screenshot size=24335
2023/11/09 18:14:08.391097 [TVE] action=capture_html
2023/11/09 18:14:08.440333 [TVE] action=capture_html size=636391
2023/11/09 18:14:08.442043 [TVE] action=script_error err=Blocked by Google: This browser or app may not be secure
2023/11/09 18:14:09.173456 [ERR] Failed to start stream for ch6012: TVE: Blocked by Google: This browser or app may not be secure

[chDVRuser]

If this is still true, you're fighting Google AI

YouTubeTV TVE failing: This browser or app may not be secure

Google controls the code in both Chrome and on their servers. They specifically try to detect and block automated Chrome usage, and there's very little we can do about it. The reason it works randomly sometimes and not others is because there's an AI on the other side making the decisions of what to block and not.