ucfopen / UDOIT

The Universal Design Online content Inspection Tool, or UDOIT (pronounced, “You Do It”) enables faculty to identify accessibility issues in their Learning Management System. It will scan a course, generate a report, and provide resources on how to address common accessibility issues.
GNU General Public License v3.0
108 stars 65 forks source link

Course Scan Runs Indefinitely #713

Closed ghost closed 2 years ago

ghost commented 2 years ago

When the course menu item for UDOIT is first clicked, it takes a very long time for the program to appear, perhaps 20 to 30 seconds or so. I attribute this to the fact that it is contacting the Heroku server and may have to spool up. However, once it does appear users see the message "UDOIT is scanning the course content for accessibility issues..." This process seems to go on forever regardless of the size of the course. I have had it run for more than 30 minutes on a course that had very little content. If after a period of time I exit the course and re-enter it and click on UDOIT one of two things will happen 1) it will run a brief scan and then the results will appear or 2) it will start scanning again and continue scanning like it was the first time. I am curious as to why the initial scan seems to take forever and does not complete.

bagofarms commented 2 years ago

Unfortunately, we're unable to replicate the infinite scanning issue on our end. Do you see anything in the Heroku logs? You can view them by viewing the settings of your Heroku instance, then clicking on "More->View Logs" in the top right.

ghost commented 2 years ago

When I review the logs it looks like it is timing out. I increased the timeout from 15 to 30 but that did not change anything. The strange thing is that it works for some classes but not others. I would think that would indicate the it is configured properly. I attached the log file, not sure if you can decipher anything from it. I’m also seeing a message in the log file “executing too slow”. Is there perhaps some Heroku tweaking that I need to consider?

2021-11-12T15:18:33.439454+00:00 heroku[router]: at=info method=POST path="/lti/authorize" host=wsccudoitv3.herokuapp.com request_id=d133e0af-e168-4282-81c7-ef026406b8f6 fwd="104.145.240.50" dyno=web.1 connect=0ms service=39ms status=302 bytes=4850 protocol=https 2021-11-12T15:18:33.440852+00:00 app[web.1]: 10.1.49.169 - - [12/Nov/2021:15:18:33 +0000] "POST /lti/authorize HTTP/1.1" 302 3638 "https://westshore.instructure.com/courses/1834732/external_tools/335975" "Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:94.0) Gecko/20100101 Firefox/94.0 2021-11-12T15:18:33.838165+00:00 heroku[router]: at=info method=POST path="/lti/authorize/check" host=wsccudoitv3.herokuapp.com request_id=d4dddc3d-a77d-479c-9901-ff3f28a4b7ab fwd="104.145.240.50" dyno=web.1 connect=0ms service=105ms status=302 bytes=979 protocol=https 2021-11-12T15:18:33.842204+00:00 app[web.1]: 10.1.49.169 - - [12/Nov/2021:15:18:33 +0000] "POST /lti/authorize/check HTTP/1.1" 302 610 "https://westshore.instructure.com/api/lti/authorize?client_id=....." "Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:94.0) Gecko/20100101 Firefox/94.0 2021-11-12T15:18:34.028809+00:00 app[web.1]: 10.1.49.169 - - [12/Nov/2021:15:18:33 +0000] "GET /dashboard?auth_token=..... HTTP/1.1" 200 36836 "https://westshore.instructure.com/api/lti/authorize?client_id=....." "Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:94.0) Gecko/20100101 Firefox/94.0 2021-11-12T15:18:34.027323+00:00 heroku[router]: at=info method=GET path="/dashboard?auth_token=....." host=wsccudoitv3.herokuapp.com request_id=c4c06116-399f-4407-be0f-421e0028ebab fwd="104.145.240.50" dyno=web.1 connect=0ms service=142ms status=200 bytes=37233 protocol=https 2021-11-12T15:18:34.166324+00:00 heroku[router]: at=info method=GET path="/build/images/udoit_logo.ee0f2cab.png" host=wsccudoitv3.herokuapp.com request_id=c6e52232-570a-4772-a638-9b51b9b5300b fwd="104.145.240.50" dyno=web.1 connect=0ms service=1ms status=200 bytes=8668 protocol=https 2021-11-12T15:18:34.167807+00:00 app[web.1]: 10.1.49.169 - - [12/Nov/2021:15:18:34 +0000] "GET /build/images/udoit_logo.ee0f2cab.png HTTP/1.1" 200 8434 "https://wsccudoitv3.herokuapp.com/dashboard?auth_token=....." "Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:94.0) Gecko/20100101 Firefox/94.0 2021-11-12T15:18:37.797013+00:00 app[web.1]: [12-Nov-2021 15:18:37] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") executing too slow (3.579837 sec), logging 2021-11-12T15:18:37.797820+00:00 app[web.1]: 2021-11-12T15:18:37.797955+00:00 app[web.1]: [12-Nov-2021 15:18:37] [pool www] pid 115 2021-11-12T15:18:37.798022+00:00 app[web.1]: script_filename = /app/public/index.php 2021-11-12T15:18:37.798240+00:00 app[web.1]: [0x00007efce5a13bc0] curl_multi_select() /app/vendor/symfony/http-client/Response/CurlResponse.php:351 2021-11-12T15:18:37.798425+00:00 app[web.1]: [0x00007efce5a13ae0] select() /app/vendor/symfony/http-client/Response/TransportResponseTrait.php:296 2021-11-12T15:18:37.798610+00:00 app[web.1]: [0x00007efce52d18c0] stream() /app/vendor/symfony/http-client/Response/CommonResponseTrait.php:156 2021-11-12T15:18:37.798788+00:00 app[web.1]: [0x00007efce5a13a40] initialize() /app/vendor/symfony/http-client/Response/TransportResponseTrait.php:65 2021-11-12T15:18:37.798903+00:00 app[web.1]: [0x00007efce5a139d0] getHeaders() /app/src/Lms/LmsResponse.php:85 2021-11-12T15:18:37.799027+00:00 app[web.1]: [0x00007efce5a13930] setResponse() /app/src/Lms/Canvas/CanvasApi.php:54 2021-11-12T15:18:37.799150+00:00 app[web.1]: [0x00007efce5a13800] apiGet() /app/src/Lms/Canvas/CanvasApi.php:81 2021-11-12T15:18:37.799266+00:00 app[web.1]: [0x00007efce5a136d0] apiGet() /app/src/Lms/Canvas/CanvasLms.php:190 2021-11-12T15:18:37.799411+00:00 app[web.1]: [0x00007efce5a13520] updateCourseContent() /app/src/Services/LmsFetchService.php:83 2021-11-12T15:18:37.799561+00:00 app[web.1]: [0x00007efce5a13460] refreshLmsContent() /app/src/Controller/SyncController.php:44 2021-11-12T15:18:37.799709+00:00 app[web.1]: [0x00007efce5a13340] requestSync() /app/vendor/symfony/http-kernel/HttpKernel.php:157 2021-11-12T15:18:37.799855+00:00 app[web.1]: [0x00007efce5a13260] handleRaw() /app/vendor/symfony/http-kernel/HttpKernel.php:79 2021-11-12T15:18:37.799989+00:00 app[web.1]: [0x00007efce5a131b0] handle() /app/vendor/symfony/http-kernel/Kernel.php:195 2021-11-12T15:18:37.800097+00:00 app[web.1]: [0x00007efce5a130f0] handle() /app/public/index.php:25 2021-11-12T15:19:04.216275+00:00 heroku[router]: at=error code=H12 desc="Request timeout" method=GET path="/api/sync/6" host=wsccudoitv3.herokuapp.com request_id=0c25f24f-c886-4130-bd9e-b47756b55ad3 fwd="104.145.240.50" dyno=web.1 connect=0ms service=30001ms status=503 bytes=0 protocol=https 2021-11-12T15:19:04.828596+00:00 app[web.1]: [12-Nov-2021 15:19:04] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (30.611457 sec), terminating 2021-11-12T15:19:05.829685+00:00 app[web.1]: [12-Nov-2021 15:19:05] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (31.612535 sec), terminating 2021-11-12T15:19:06.830829+00:00 app[web.1]: [12-Nov-2021 15:19:06] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (32.613676 sec), terminating 2021-11-12T15:19:07.830942+00:00 app[web.1]: [12-Nov-2021 15:19:07] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (33.613749 sec), terminating 2021-11-12T15:19:08.831465+00:00 app[web.1]: [12-Nov-2021 15:19:08] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (34.613895 sec), terminating 2021-11-12T15:19:09.832329+00:00 app[web.1]: [12-Nov-2021 15:19:09] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (35.615002 sec), terminating 2021-11-12T15:19:10.832238+00:00 app[web.1]: [12-Nov-2021 15:19:10] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (36.615094 sec), terminating 2021-11-12T15:19:11.834565+00:00 app[web.1]: [12-Nov-2021 15:19:11] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (37.616406 sec), terminating 2021-11-12T15:19:12.834832+00:00 app[web.1]: [12-Nov-2021 15:19:12] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (38.617553 sec), terminating 2021-11-12T15:19:14.837224+00:00 app[web.1]: [12-Nov-2021 15:19:14] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (40.620018 sec), terminating 2021-11-12T15:19:13.836352+00:00 app[web.1]: [12-Nov-2021 15:19:13] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (39.618728 sec), terminating 2021-11-12T15:19:15.837784+00:00 app[web.1]: [12-Nov-2021 15:19:15] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (41.620175 sec), terminating 2021-11-12T15:19:16.838329+00:00 app[web.1]: [12-Nov-2021 15:19:16] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (42.621079 sec), terminating 2021-11-12T15:19:17.838696+00:00 app[web.1]: [12-Nov-2021 15:19:17] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (43.621484 sec), terminating 2021-11-12T15:19:18.839757+00:00 app[web.1]: [12-Nov-2021 15:19:18] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (44.622557 sec), terminating 2021-11-12T15:19:19.840871+00:00 app[web.1]: [12-Nov-2021 15:19:19] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (45.623636 sec), terminating 2021-11-12T15:19:20.842765+00:00 app[web.1]: [12-Nov-2021 15:19:20] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (46.624816 sec), terminating 2021-11-12T15:19:21.843737+00:00 app[web.1]: [12-Nov-2021 15:19:21] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (47.626486 sec), terminating 2021-11-12T15:19:22.846286+00:00 app[web.1]: [12-Nov-2021 15:19:22] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (48.627580 sec), terminating 2021-11-12T15:19:23.846018+00:00 app[web.1]: [12-Nov-2021 15:19:23] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (49.628665 sec), terminating 2021-11-12T15:19:24.850601+00:00 app[web.1]: [12-Nov-2021 15:19:24] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (50.629440 sec), terminating 2021-11-12T15:19:25.851303+00:00 app[web.1]: [12-Nov-2021 15:19:25] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (51.633430 sec), terminating 2021-11-12T15:19:26.851689+00:00 app[web.1]: [12-Nov-2021 15:19:26] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (52.634531 sec), terminating 2021-11-12T15:19:27.852941+00:00 app[web.1]: [12-Nov-2021 15:19:27] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (53.635666 sec), terminating 2021-11-12T15:19:28.853900+00:00 app[web.1]: [12-Nov-2021 15:19:28] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (54.636768 sec), terminating 2021-11-12T15:19:29.858617+00:00 app[web.1]: [12-Nov-2021 15:19:29] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (55.641420 sec), terminating 2021-11-12T15:19:30.860917+00:00 app[web.1]: [12-Nov-2021 15:19:30] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (56.643716 sec), terminating 2021-11-12T15:19:31.861983+00:00 app[web.1]: [12-Nov-2021 15:19:31] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (57.644802 sec), terminating 2021-11-12T15:19:32.862562+00:00 app[web.1]: [12-Nov-2021 15:19:32] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (58.645412 sec), terminating 2021-11-12T15:19:33.863627+00:00 app[web.1]: [12-Nov-2021 15:19:33] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (59.646495 sec), terminating 2021-11-12T15:19:34.274789+00:00 app[web.1]: [Fri Nov 12 15:19:34.274169 2021] [proxy_fcgi:error] [pid 123:tid 139773670799104] (70007)The timeout specified has expired: [client 10.1.42.0:21829] AH01075: Error dispatching request to : (polling), referer: https://wsccudoitv3.herokuapp.com/dashboard?auth_token=..... 2021-11-12T15:19:34.275191+00:00 app[web.1]: 10.1.42.0 - - [12/Nov/2021:15:18:34 +0000] "GET /api/sync/6 HTTP/1.1" 504 247 "https://wsccudoitv3.herokuapp.com/dashboard?auth_token=....." "Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:94.0) Gecko/20100101 Firefox/94.0 2021-11-12T15:19:34.864720+00:00 app[web.1]: [12-Nov-2021 15:19:34] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (60.647568 sec), terminating 2021-11-12T15:19:35.865807+00:00 app[web.1]: [12-Nov-2021 15:19:35] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (61.648645 sec), terminating 2021-11-12T15:19:36.866604+00:00 app[web.1]: [12-Nov-2021 15:19:36] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (62.649439 sec), terminating 2021-11-12T15:19:37.867684+00:00 app[web.1]: [12-Nov-2021 15:19:37] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (63.650486 sec), terminating 2021-11-12T15:19:38.870149+00:00 app[web.1]: [12-Nov-2021 15:19:38] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (64.651184 sec), terminating 2021-11-12T15:19:39.868946+00:00 app[web.1]: [12-Nov-2021 15:19:39] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (65.651613 sec), terminating 2021-11-12T15:19:40.869901+00:00 app[web.1]: [12-Nov-2021 15:19:40] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (66.652729 sec), terminating 2021-11-12T15:19:41.871195+00:00 app[web.1]: [12-Nov-2021 15:19:41] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (67.653731 sec), terminating 2021-11-12T15:19:42.871999+00:00 app[web.1]: [12-Nov-2021 15:19:42] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (68.654802 sec), terminating 2021-11-12T15:19:43.873124+00:00 app[web.1]: [12-Nov-2021 15:19:43] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (69.655883 sec), terminating 2021-11-12T15:19:44.874425+00:00 app[web.1]: [12-Nov-2021 15:19:44] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (70.657197 sec), terminating 2021-11-12T15:19:45.874747+00:00 app[web.1]: [12-Nov-2021 15:19:45] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (71.657441 sec), terminating 2021-11-12T15:19:46.875790+00:00 app[web.1]: [12-Nov-2021 15:19:46] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (72.658571 sec), terminating 2021-11-12T15:19:47.878790+00:00 app[web.1]: [12-Nov-2021 15:19:47] WARNING: [pool www] child 115, script '/app/public/index.php' (request: "GET /index.php") execution timed out (73.661424 sec), terminating 2021-11-12T15:19:48.234601+00:00 app[web.1]: [12-Nov-2021 15:19:48 UTC] PHP Fatal error: Maximum execution time of 30 seconds exceeded in /app/vendor/cidilabs/phpally/src/Rule/RedirectedLink.php on line 53

bagofarms commented 2 years ago

After doing some research and testing, this issue appears to be a result of our new broken and redirected link detection. Since it's not possible to increase the maximum execution time beyond 30 seconds on Heroku, here is our plan for solving this:

  1. Issue a hotfix that disables the broken and redirected link checker.
  2. Add the ability to enable/disable the broken and redirected link checker either through .env.local or the Heroku app settings. It would be disabled by default for Heroku.
  3. Implement a background worker that would handle all course scanning activity, since Heroku has much longer timeouts for workers.
ghost commented 2 years ago

Hello Jacob,

Thank you for taking time to clarify what the issue is. Also, thanking for taking time to troubleshoot. I assume that working out the details to a patch will take some time. While I await a fix, is there another option for me? The version 2.5 that was previous installed has since ceased to work on my end. This is what lead me to the update. I see that version 2.8 was the last iteration prior to moving to the cloud version however, I cannot locate the folder on GitHub where it is installed. Could you provide a link to it so that I could try installing version 2.8 while I await resolution of UDOIT Cloud? Unless you think that the fix will be coming quickly.

Sincerely, Tom Alway

bagofarms commented 2 years ago

3.1.1 is released. Please try it out on Heroku to see if it fixes your issue. You can set up a new Heroku instance by clicking the Heroku button. If you have the code downloaded to your machine via Git, you can update your existing Heroku instance of UDOIT 3.1.0 by pushing the main branch to your Heroku's master branch.

If you would like to try UDOIT 2.8.3, you can click the Heroku button in the classic branch.

ghost commented 2 years ago

Wow, that was fast. Thank you. I will give it go.

bagofarms commented 2 years ago

Closing in favor of the worker feature request issue.

jh246118 commented 2 years ago

I've recently deployed the latest version 3.1.1 and am running into this issue where some courses are scanning indefinitely. No issues with smaller courses but am running into the execution time out with larger courses

Log Sample:

2022-02-24T22:19:20.932583+00:00 app[web.1]: 2022-02-24T22:19:20.932684+00:00 app[web.1]: [24-Feb-2022 22:19:20] [pool www] pid 113 2022-02-24T22:19:20.932754+00:00 app[web.1]: script_filename = /app/public/index.php 2022-02-24T22:19:20.932926+00:00 app[web.1]: [0x00007f091dc13a90] curl_multi_select() /app/vendor/symfony/http-client/Response/CurlResponse.php:351 2022-02-24T22:19:20.933096+00:00 app[web.1]: [0x00007f091dc139b0] select() /app/vendor/symfony/http-client/Response/TransportResponseTrait.php:296 2022-02-24T22:19:20.933261+00:00 app[web.1]: [0x00007f091dc7d8c0] stream() /app/vendor/symfony/http-client/Response/CommonResponseTrait.php:156 2022-02-24T22:19:20.933436+00:00 app[web.1]: [0x00007f091dc13910] initialize() /app/vendor/symfony/http-client/Response/TransportResponseTrait.php:65 2022-02-24T22:19:20.933548+00:00 app[web.1]: [0x00007f091dc138a0] getHeaders() /app/src/Lms/LmsResponse.php:85 2022-02-24T22:19:20.933671+00:00 app[web.1]: [0x00007f091dc13800] setResponse() /app/src/Lms/Canvas/CanvasApi.php:54 2022-02-24T22:19:20.933785+00:00 app[web.1]: [0x00007f091dc136d0] apiGet() /app/src/Lms/Canvas/CanvasLms.php:190 2022-02-24T22:19:20.933927+00:00 app[web.1]: [0x00007f091dc13520] updateCourseContent() /app/src/Services/LmsFetchService.php:83 2022-02-24T22:19:20.934066+00:00 app[web.1]: [0x00007f091dc13460] refreshLmsContent() /app/src/Controller/SyncController.php:44 2022-02-24T22:19:20.934212+00:00 app[web.1]: [0x00007f091dc13340] requestSync() /app/vendor/symfony/http-kernel/HttpKernel.php:157 2022-02-24T22:19:20.934351+00:00 app[web.1]: [0x00007f091dc13260] handleRaw() /app/vendor/symfony/http-kernel/HttpKernel.php:79 2022-02-24T22:19:20.934481+00:00 app[web.1]: [0x00007f091dc131b0] handle() /app/vendor/symfony/http-kernel/Kernel.php:195 2022-02-24T22:19:20.934576+00:00 app[web.1]: [0x00007f091dc130f0] handle() /app/public/index.php:25 2022-02-24T22:19:42.080497+00:00 heroku[router]: at=error code=H12 desc="Request timeout" method=GET path="/api/sync/3" host=sccprod-udoit-canvas.herokuapp.com request_id=62ae8788-75b0-4b6b-bb21-50d65611766e fwd="64.89.52.22" dyno=web.1 connect=0ms service=30001ms status=503 bytes=0 protocol=https 2022-02-24T22:19:47.954902+00:00 app[web.1]: [24-Feb-2022 22:19:47] WARNING: [pool www] child 113, script '/app/public/index.php' (request: "GET /index.php") execution timed out (30.221667 sec), terminating 2022-02-24T22:19:48.955926+00:00 app[web.1]: [24-Feb-2022 22:19:48] WARNING: [pool www] child 113, script '/app/public/index.php' (request: "GET /index.php") execution timed out (31.222752 sec), terminating 2022-02-24T22:19:49.957169+00:00 app[web.1]: [24-Feb-2022 22:19:49] WARNING: [pool www] child 113, script '/app/public/index.php' (request: "GET /index.php") execution timed out (32.223853 sec), terminating 2022-02-24T22:19:50.958110+00:00 app[web.1]: [24-Feb-2022 22:19:50] WARNING: [pool www] child 113, script '/app/public/index.php' (request: "GET /index.php") execution timed out (33.224924 sec), terminating 2022-02-24T22:19:51.715231+00:00 app[web.1]: 10.1.53.33 - - [24/Feb/2022:22:19:12 +0000] "GET /api/sync/3 HTTP/1.1" 500 831 "https://sccprod-udoit-canvas.herokuapp.com/dashboard?auth_token=97f7f8b8-5b8d-4f50-87f6-0b3d85c1db61" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/98.0.4758.102 Safari/537.36

The network logs are showing a 503 (service Unavailable) error:

image

image

I'm not quite sure where to go with this since it works in some courses but not others.

I will add that I used the 'deploy to Heroku' button from the main page and followed the install instructions in HEROKU.md and INSTALL_Canvas_md

bagofarms commented 2 years ago

It looks like you're experiencing the same issue as the original poster. It is still our plan to implement a worker for Heroku, which will be the solution to this problem