Tutor 10.0.11: Sysadmin feature generates 500 error

nachham · July 17, 2020, 3:19pm

After updating to Tutor 10.0.11, clicking on “generate list of users (csv file)” or on “generate list of team" under the sysadmin, generates the “500 error”

tutor local logs --tail=100 cms-worker

cms-worker_1       | [2020-07-17 00:49:38,293: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[08d02e8f-476d-429b-85ce-691b0570abea] succeeded in 0.04293346800022846s: None
cms-worker_1       | [2020-07-17 00:53:27,717: INFO/MainProcess] Received task: contentstore.tasks.update_search_index[e3182d53-1ff1-4372-a656-ae3ec8975df2]
cms-worker_1       | [2020-07-17 00:53:27,722: INFO/Worker-1] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.002s]
cms-worker_1       | [2020-07-17 00:53:27,776: INFO/Worker-1] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.004s]
cms-worker_1       | [2020-07-17 00:53:27,796: INFO/Worker-1] GET http://elasticsearch:9200/courseware_index/_mapping/course_info [status:200 request:0.007s]
cms-worker_1       | [2020-07-17 00:53:27,803: INFO/Worker-1] POST http://elasticsearch:9200/_bulk [status:200 request:0.005s]
cms-worker_1       | [2020-07-17 00:53:27,940: INFO/MainProcess] Received task: lms.djangoapps.discussion.tasks.update_discussions_map[16e0b6ae-cbb3-4c6c-b8d8-ae35f0c6f77e] eta:[2020-07-17 00:53:57.929453+00:00]
cms-worker_1       | [2020-07-17 00:53:27,954: INFO/MainProcess] Received task: openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[bf905a0b-a189-47cf-8209-9819daf1350e]
cms-worker_1       | [2020-07-17 00:53:27,958: INFO/Worker-2] Starting XBlockCaches update for course_key: course-v1:edX+DemoX+Demo_Course
cms-worker_1       | [2020-07-17 00:53:28,198: INFO/Worker-2] Updating XBlockCache with usage_key: block-v1:edX+DemoX+Demo_Course+type@staffgradedxblock+block@fae186a6c4fc4490909be28a420d5e22
cms-worker_1       | [2020-07-17 00:53:28,203: INFO/Worker-2] Ending XBlockCaches update for course_key: course-v1:edX+DemoX+Demo_Course
cms-worker_1       | [2020-07-17 00:53:28,206: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[bf905a0b-a189-47cf-8209-9819daf1350e] succeeded in 0.2480327989997022s: None
cms-worker_1       | [2020-07-17 00:53:28,835: INFO/Worker-1] GET http://elasticsearch:9200/courseware_index/_mapping/courseware_content [status:200 request:0.002s]
cms-worker_1       | [2020-07-17 00:53:28,872: INFO/Worker-1] POST http://elasticsearch:9200/_bulk [status:200 request:0.022s]
cms-worker_1       | [2020-07-17 00:53:28,883: INFO/Worker-1] GET http://elasticsearch:9200/courseware_index/courseware_content/_search [status:200 request:0.011s]
cms-worker_1       | [2020-07-17 00:53:28,888: INFO/MainProcess] Task contentstore.tasks.update_search_index[e3182d53-1ff1-4372-a656-ae3ec8975df2] succeeded in 1.1689456100002644s: None
cms-worker_1       | [2020-07-17 00:53:58,611: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[16e0b6ae-cbb3-4c6c-b8d8-ae35f0c6f77e] succeeded in 0.03928039000038552s: None
cms-worker_1       | [2020-07-17 00:58:06,959: INFO/MainProcess] Received task: contentstore.tasks.update_search_index[6ea44eca-bc94-4870-a62b-bad9fdb7af53]
cms-worker_1       | [2020-07-17 00:58:06,969: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.007s]
cms-worker_1       | [2020-07-17 00:58:07,081: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.002s]
cms-worker_1       | [2020-07-17 00:58:07,135: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.014s]
cms-worker_1       | [2020-07-17 00:58:07,580: INFO/MainProcess] Received task: lms.djangoapps.discussion.tasks.update_discussions_map[b8227f15-ee2b-46cd-918a-d6c5b02e52e6] eta:[2020-07-17 00:58:37.568751+00:00]
cms-worker_1       | [2020-07-17 00:58:07,599: INFO/MainProcess] Received task: openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[96c0feaa-ef6d-40fe-9a9f-dd524a589b86]
cms-worker_1       | [2020-07-17 00:58:07,602: INFO/Worker-1] Starting XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:08,577: INFO/Worker-1] Creating XBlockCache with usage_key: block-v1:Edukel+cs101+H2020+type@chapter+block@e46428649a9949868f3749659109a9e8
cms-worker_1       | [2020-07-17 00:58:08,583: INFO/Worker-1] Ending XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:08,585: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[96c0feaa-ef6d-40fe-9a9f-dd524a589b86] succeeded in 0.9840651280001111s: None
cms-worker_1       | [2020-07-17 00:58:09,962: INFO/MainProcess] Received task: contentstore.tasks.update_search_index[652f37f1-b30d-4d3b-9ea6-09502851bfc8]
cms-worker_1       | [2020-07-17 00:58:10,670: INFO/MainProcess] Received task: lms.djangoapps.discussion.tasks.update_discussions_map[8c7205e8-2e16-44ea-b58c-bd7814984728] eta:[2020-07-17 00:58:40.657878+00:00]
cms-worker_1       | [2020-07-17 00:58:10,698: INFO/MainProcess] Received task: openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[27d53583-a688-40fe-999c-0fe0ef4f8a74]
cms-worker_1       | [2020-07-17 00:58:24,164: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.033s]
cms-worker_1       | [2020-07-17 00:58:24,257: INFO/Worker-2] GET http://elasticsearch:9200/courseware_index/courseware_content/_search [status:200 request:0.090s]
cms-worker_1       | [2020-07-17 00:58:24,273: INFO/MainProcess] Task contentstore.tasks.update_search_index[6ea44eca-bc94-4870-a62b-bad9fdb7af53] succeeded in 17.312184675000026s: None
cms-worker_1       | [2020-07-17 00:58:24,276: INFO/Worker-1] Starting XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:24,287: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.007s]
cms-worker_1       | [2020-07-17 00:58:24,288: INFO/MainProcess] Received task: contentstore.tasks.update_search_index[cdf50f70-fee9-492a-b70c-1a37f887615b]
cms-worker_1       | [2020-07-17 00:58:24,289: INFO/MainProcess] Received task: lms.djangoapps.discussion.tasks.update_discussions_map[8590325e-f1ec-4d3d-a5e7-5b5739958398] eta:[2020-07-17 00:58:41.662791+00:00]
cms-worker_1       | [2020-07-17 00:58:24,450: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.010s]
cms-worker_1       | [2020-07-17 00:58:24,515: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.010s]
cms-worker_1       | [2020-07-17 00:58:24,893: INFO/MainProcess] Received task: openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[2362ba1c-c5fb-4493-bc8d-6125507de550]
cms-worker_1       | [2020-07-17 00:58:24,989: INFO/Worker-1] Creating XBlockCache with usage_key: block-v1:Edukel+cs101+H2020+type@vertical+block@7be74f373faa47ae931495b47c96e113
cms-worker_1       | [2020-07-17 00:58:25,001: INFO/Worker-1] Creating XBlockCache with usage_key: block-v1:Edukel+cs101+H2020+type@edx_sga+block@8789a3b5018041eaaff87711a095d55a
cms-worker_1       | [2020-07-17 00:58:25,008: INFO/Worker-1] Creating XBlockCache with usage_key: block-v1:Edukel+cs101+H2020+type@sequential+block@af7e51ec6bbf48e8b6adaa57573a24ea
cms-worker_1       | [2020-07-17 00:58:25,013: INFO/Worker-1] Ending XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:25,016: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[27d53583-a688-40fe-999c-0fe0ef4f8a74] succeeded in 0.7402359999996406s: None
cms-worker_1       | [2020-07-17 00:58:41,752: INFO/Worker-2] GET http://elasticsearch:9200/courseware_index/_mapping/courseware_content [status:200 request:0.004s]
cms-worker_1       | [2020-07-17 00:58:41,820: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.038s]
cms-worker_1       | [2020-07-17 00:58:41,941: INFO/Worker-2] GET http://elasticsearch:9200/courseware_index/courseware_content/_search [status:200 request:0.119s]
cms-worker_1       | [2020-07-17 00:58:41,968: INFO/MainProcess] Task contentstore.tasks.update_search_index[652f37f1-b30d-4d3b-9ea6-09502851bfc8] succeeded in 17.694594386000063s: None
cms-worker_1       | [2020-07-17 00:58:41,974: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.007s]
cms-worker_1       | [2020-07-17 00:58:41,976: INFO/Worker-1] Starting XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:42,224: INFO/Worker-2] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.008s]
cms-worker_1       | [2020-07-17 00:58:42,304: INFO/Worker-2] GET http://elasticsearch:9200/courseware_index/_mapping/course_info [status:200 request:0.001s]
cms-worker_1       | [2020-07-17 00:58:42,326: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.016s]
cms-worker_1       | [2020-07-17 00:58:43,800: INFO/Worker-1] Ending XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:58:43,804: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[2362ba1c-c5fb-4493-bc8d-6125507de550] succeeded in 1.8283674819995213s: None
cms-worker_1       | [2020-07-17 00:59:00,203: INFO/Worker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.030s]
cms-worker_1       | [2020-07-17 00:59:00,242: INFO/Worker-2] GET http://elasticsearch:9200/courseware_index/courseware_content/_search [status:200 request:0.037s]
cms-worker_1       | [2020-07-17 00:59:00,259: INFO/MainProcess] Task contentstore.tasks.update_search_index[cdf50f70-fee9-492a-b70c-1a37f887615b] succeeded in 18.29176865199952s: None
cms-worker_1       | [2020-07-17 00:59:00,265: INFO/MainProcess] Received task: contentstore.tasks.update_search_index[a0c760ec-bb18-4668-93c5-09b4de82d976]
cms-worker_1       | [2020-07-17 00:59:00,317: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[8c7205e8-2e16-44ea-b58c-bd7814984728] succeeded in 0.0563486360006209s: None
cms-worker_1       | [2020-07-17 00:59:00,325: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[b8227f15-ee2b-46cd-918a-d6c5b02e52e6] succeeded in 0.06654695100041863s: None
cms-worker_1       | [2020-07-17 00:59:00,331: INFO/MainProcess] Received task: lms.djangoapps.discussion.tasks.update_discussions_map[91a7d6d5-4b9f-4824-99a4-fed4b02713c9] eta:[2020-07-17 00:58:56.345704+00:00]
cms-worker_1       | [2020-07-17 00:59:00,333: INFO/MainProcess] Received task: openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[6d2d7bfe-d47b-488c-b185-e697344c60b5]
cms-worker_1       | [2020-07-17 00:59:00,343: INFO/Worker-1] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.009s]
cms-worker_1       | [2020-07-17 00:59:00,385: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[8590325e-f1ec-4d3d-a5e7-5b5739958398] succeeded in 0.05988126400006877s: None
cms-worker_1       | [2020-07-17 00:59:00,387: INFO/Worker-2] Starting XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:59:00,430: INFO/Worker-1] HEAD http://elasticsearch:9200/courseware_index [status:200 request:0.004s]
cms-worker_1       | [2020-07-17 00:59:00,480: INFO/Worker-1] POST http://elasticsearch:9200/_bulk [status:200 request:0.008s]
cms-worker_1       | [2020-07-17 00:59:01,211: INFO/Worker-2] Ending XBlockCaches update for course_key: course-v1:Edukel+cs101+H2020
cms-worker_1       | [2020-07-17 00:59:01,214: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[6d2d7bfe-d47b-488c-b185-e697344c60b5] succeeded in 0.8273193840004751s: None
cms-worker_1       | [2020-07-17 00:59:17,475: INFO/Worker-1] POST http://elasticsearch:9200/_bulk [status:200 request:0.025s]
cms-worker_1       | [2020-07-17 00:59:17,504: INFO/Worker-1] GET http://elasticsearch:9200/courseware_index/courseware_content/_search [status:200 request:0.027s]
cms-worker_1       | [2020-07-17 00:59:17,520: INFO/MainProcess] Task contentstore.tasks.update_search_index[a0c760ec-bb18-4668-93c5-09b4de82d976] succeeded in 17.19374077499924s: None
cms-worker_1       | [2020-07-17 00:59:17,561: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[91a7d6d5-4b9f-4824-99a4-fed4b02713c9] succeeded in 0.04117794200010394s: None

Thanks

regis · July 21, 2020, 10:25am

Hi @nachham! I managed to reproduce this issue, investigate it and track the root cause to an upstream bug. I created a Tutor issue with all the gory details here: https://github.com/overhangio/tutor/issues/358

This will need to be fixed upstream. I do not have time to address this myself right now but I’ll mention this during the next meeting of the build/test/release working group.

regis · July 23, 2020, 8:45pm

@nachham after discussing this issue with the original authors of the sysadmin dashboard, it appears that it is going to be deprecated really soon. Can you describe more precisely your use case and why you need this feature? How did you even discover it? AFAIK it is completely undocumented.

nachham · July 23, 2020, 9:16pm

Hi @regis

Thanks for the follow-up.

I doubted that this feature was due for depreciation. It is not much used and comments in the edx forum can give a sense of that. I don’t use it neither, and I would suggest to take it off (De-defaulting it) in the next release of Tutor without having to wait for depreciation. (School is back is a few weeks and every thing has to work as a charm )

Thanks for your great work.
Cheers.

regis · July 24, 2020, 6:34am

this will be done in v10.1.1.