And then I don’t know if it’s related, but I get a more clear python error (xmodule.modulestore.exceptions.ItemNotFoundError: BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631') when I delete that video xblock back out of the class:
mysql-1 | 2024-08-29T11:36:27.244669Z 133 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-1 | 2024-08-29 11:36:27,254 INFO 7 [tracking] [user 3] [ip 123.123.123.123] logger.py:41 - {"name": "/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631", "context": {"user_id": 3, "path": "/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631", "course_id": "", "org_id": "", "enterprise_uuid": ""}, "username": "AdminUser", "session": "60a63b1df68f134a86b36adf0c9162e9", "ip": "123.123.123.123", "agent": "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36", "host": "studio.mysite.com", "referer": "https://studio.mysite.com/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "accept_language": "en-US,en;q=0.9", "event": "{\"GET\": {}, \"POST\": {}}", "time": "2024-08-29T11:36:27.254675+00:00", "event_type": "/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631", "event_source": "server", "page": null}
cms-1 | 2024-08-29 11:36:27,295 ERROR 7 [django.dispatch] [user 3] [ip 123.123.123.123] dispatcher.py:214 - Error calling handle_item_deleted in Signal.send_robust() (BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631'))
cms-1 | Traceback (most recent call last):
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/dispatch/dispatcher.py", line 212, in send_robust
cms-1 | response = receiver(signal=self, sender=sender, **named)
cms-1 | File "/openedx/edx-platform/./cms/djangoapps/contentstore/signals/handlers.py", line 254, in handle_item_deleted
cms-1 | deleted_block = modulestore().get_item(usage_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 84, in inner
cms-1 | retval = func(field_decorator=strip_key_collection, *args, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 250, in get_item
cms-1 | return store.get_item(usage_key, depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split_draft.py", line 283, in get_item
cms-1 | return super().get_item(usage_key, depth=depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 1183, in get_item
cms-1 | items = self._load_items(course, [BlockKey.from_usage_key(usage_key)], depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in _load_items
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in <listcomp>
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 118, in _load_item
cms-1 | block_data = self.get_module_data(block_key, course_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 145, in get_module_data
cms-1 | raise ItemNotFoundError(block_key)
cms-1 | xmodule.modulestore.exceptions.ItemNotFoundError: BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631')
cms-1 | 2024-08-29 11:36:27,348 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent item_deleted signal to <function handle_item_deleted at 0x79105f55cd30> with kwargs {'usage_key': BlockUsageLocator(CourseLocator('MySite', 'MyClass', 'V1', 'draft-branch', None), 'video', '1955d68fb2c248448371a59e427c1631'), 'user_id': 3}. Response was: BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631')
cms-1 | 2024-08-29 11:36:27,350 INFO 7 [openedx_events.tooling] [user 3] [ip 123.123.123.123] tooling.py:156 - Responses of the Open edX Event <org.openedx.content_authoring.xblock.deleted.v1>:
cms-1 | [(<function listen_for_xblock_deleted at 0x79105f55caf0>, None)]
cms-worker-1 | [2024-08-29 11:36:27,369: INFO/MainProcess] Task cms.djangoapps.contentstore.tasks.update_outline_from_modulestore_task[7daafeaf-a530-4e13-9dab-4e0a51d8c95a] received
cms-worker-1 | [2024-08-29 11:36:27,380: INFO/MainProcess] Task cms.djangoapps.contentstore.tasks.update_search_index[4b3e09e8-e19b-4cae-a427-eb5d73924dd1] received
mysql-1 | 2024-08-29T11:36:27.383131Z 134 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
mysql-1 | 2024-08-29T11:36:27.393229Z 135 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-worker-1 | [2024-08-29 11:36:27,399: INFO/MainProcess] Task openedx.core.djangoapps.discussions.tasks.update_discussions_settings_from_course_task[49f67cce-a088-40af-9ac6-6f350cebdd68] received
cms-1 | 2024-08-29 11:36:27,403 INFO 7 [openedx.core.djangoapps.content.course_overviews.models] [user 3] [ip 123.123.123.123] models.py:294 - Attempting to load CourseOverview for course course-v1:MySite+MyClass+V1 from modulestore.
cms-worker-1 | [2024-08-29 11:36:27,413: INFO/ForkPoolWorker-2] HEAD http://elasticsearch:9200/courseware_content [status:200 request:0.008s]
cms-1 | 2024-08-29 11:36:27,419 INFO 7 [openedx.core.djangoapps.content.course_overviews.models] [user 3] [ip 123.123.123.123] models.py:194 - Updating course overview for course-v1:MySite+MyClass+V1.
lms-worker-1 | 2024-08-29 11:36:27,476 INFO 1 [celery.worker.strategy] [user None] [ip None] strategy.py:161 - Task openedx.core.djangoapps.content.block_structure.tasks.update_course_in_cache_v2[1840ffc7-1982-42bf-8500-2cd0ee0bb649] received
cms-1 | 2024-08-29 11:36:27,497 INFO 7 [openedx.core.djangoapps.course_date_signals.handlers] [user 3] [ip 123.123.123.123] handlers.py:125 - Extracting course dates for course-v1:MySite+MyClass+V1
cms-1 | 2024-08-29 11:36:27,515 INFO 7 [edx_when.api] [user 3] [ip 123.123.123.123] api.py:94 - Setting date for BlockUsageLocator(CourseLocator('MySite', 'MyClass', 'V1', None, None), 'course', 'course'), start, datetime.datetime(2025, 4, 1, 0, 0, tzinfo=<bson.tz_util.FixedOffset object at 0x79105d4943d0>)
cms-worker-1 | [2024-08-29 11:36:27,533: INFO/MainProcess] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[236c5c47-8116-427c-be61-b7d9acbb86e5] received
cms-worker-1 | [2024-08-29 11:36:27,544: INFO/MainProcess] Task openedx.core.djangoapps.course_apps.tasks.update_course_apps_status[05f20ff0-0eb8-4301-96a8-9be799915fcf] received
cms-1 | 2024-08-29 11:36:27,556 INFO 7 [celery_utils.logged_task] [user 3] [ip 123.123.123.123] logged_task.py:25 - Task lms.djangoapps.discussion.tasks.update_discussions_map[a5e52b6b-27cc-48a1-8b52-3dcd724c18a8] submitted with arguments [{'course_id': 'course-v1:MySite+MyClass+V1'}], None
cms-1 | 2024-08-29 11:36:27,556 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function listen_for_course_publish at 0x79105f55c940> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,556 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function export_course_metadata at 0x79105f819160> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function _listen_for_course_publish at 0x79105ea04430> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function _listen_for_course_publish at 0x79105ea04700> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function update_block_structure_on_course_publish at 0x79105ea0ea60> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function _listen_for_course_publish at 0x79105ea18940> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function extract_dates at 0x79105e8c5430> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,557 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function trigger_update_xblocks_cache_task at 0x79105e8b09d0> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,558 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function update_course_apps at 0x79105e8b85e0> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-1 | 2024-08-29 11:36:27,558 INFO 7 [xmodule.modulestore.django] [user 3] [ip 123.123.123.123] django.py:212 - Sent course_published signal to <function update_discussions_on_course_publish at 0x79105e8b8d30> with kwargs {'course_key': CourseLocator('MySite', 'MyClass', 'V1', None, None)}. Response was: None
cms-worker-1 | [2024-08-29 11:36:27,570: INFO/ForkPoolWorker-2] HEAD http://elasticsearch:9200/course_info [status:200 request:0.007s]
caddy-1 | {"level":"info","ts":1724931387.5986936,"logger":"http.log.access.log1","msg":"handled request","request":{"remote_ip":"123.123.123.123","remote_port":"54591","proto":"HTTP/2.0","method":"DELETE","host":"studio.mysite.com","uri":"/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631","tls":{"resumed":true,"version":772,"cipher_suite":4865,"proto":"h2","server_name":"studio.mysite.com"}},"user_id":"","duration":0.360760962,"size":0,"status":204}
cms-1 | [pid: 7|app: 0|req: 23/68] 172.18.0.3 () {64 vars in 3948 bytes} [Thu Aug 29 11:36:27 2024] DELETE /xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631 => generated 0 bytes in 362 msecs (HTTP/1.1 204) 8 headers in 428 bytes (1 switches on core 0)
cms-worker-1 | [2024-08-29 11:36:27,611: INFO/ForkPoolWorker-1] Replacing CourseOutline for course-v1:MySite+MyClass+V1 (version 66d05984b7ef20bd65c35da7, 59 sequences)
cms-worker-1 | [2024-08-29 11:36:27,622: INFO/ForkPoolWorker-1] Found CourseContext for course-v1:MySite+MyClass+V1, updating...
mysql-1 | 2024-08-29T11:36:27.630687Z 136 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-1 | 2024-08-29 11:36:27,644 INFO 13 [tracking] [user 3] [ip 123.123.123.123] logger.py:41 - {"name": "/preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state", "context": {"user_id": 3, "path": "/preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state", "course_id": "", "org_id": "", "enterprise_uuid": ""}, "username": "AdminUser", "session": "60a63b1df68f134a86b36adf0c9162e9", "ip": "123.123.123.123", "agent": "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36", "host": "studio.mysite.com", "referer": "https://studio.mysite.com/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "accept_language": "en-US,en;q=0.9", "event": "{\"GET\": {}, \"POST\": {\"saved_video_position\": [\"00:00:00\"]}}", "time": "2024-08-29T11:36:27.643774+00:00", "event_type": "/preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state", "event_source": "server", "page": null}
cms-worker-1 | [2024-08-29 11:36:27,656: INFO/ForkPoolWorker-2] GET http://elasticsearch:9200/course_info/_mapping [status:200 request:0.014s]
mysql-1 | 2024-08-29T11:36:27.657625Z 137 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-1 | 2024-08-29 11:36:27,662 INFO 7 [tracking] [user 3] [ip 123.123.123.123] logger.py:41 - {"name": "/xblock/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "context": {"user_id": 3, "path": "/xblock/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "course_id": "", "org_id": "", "enterprise_uuid": ""}, "username": "AdminUser", "session": "60a63b1df68f134a86b36adf0c9162e9", "ip": "123.123.123.123", "agent": "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36", "host": "studio.mysite.com", "referer": "https://studio.mysite.com/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "accept_language": "en-US,en;q=0.9", "event": "{\"GET\": {}, \"POST\": {}}", "time": "2024-08-29T11:36:27.661203+00:00", "event_type": "/xblock/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6", "event_source": "server", "page": null}
cms-worker-1 | [2024-08-29 11:36:27,688: INFO/ForkPoolWorker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.017s]
cms-1 | 2024-08-29 11:36:27,731 ERROR 13 [root] [user None] [ip None] signals.py:22 - Uncaught exception from None
cms-1 | Traceback (most recent call last):
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/core/handlers/exception.py", line 47, in inner
cms-1 | response = get_response(request)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/core/handlers/base.py", line 181, in _get_response
cms-1 | response = wrapped_callback(request, *callback_args, **callback_kwargs)
cms-1 | File "/opt/pyenv/versions/3.8.15/lib/python3.8/contextlib.py", line 75, in inner
cms-1 | return func(*args, **kwds)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/contrib/auth/decorators.py", line 21, in _wrapped_view
cms-1 | return view_func(request, *args, **kwargs)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/views/decorators/clickjacking.py", line 50, in wrapped_view
cms-1 | resp = view_func(*args, **kwargs)
cms-1 | File "/openedx/edx-platform/./cms/djangoapps/contentstore/views/preview.py", line 69, in preview_handler
cms-1 | descriptor = modulestore().get_item(usage_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 84, in inner
cms-1 | retval = func(field_decorator=strip_key_collection, *args, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 250, in get_item
cms-1 | return store.get_item(usage_key, depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split_draft.py", line 283, in get_item
cms-1 | return super().get_item(usage_key, depth=depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 1183, in get_item
cms-1 | items = self._load_items(course, [BlockKey.from_usage_key(usage_key)], depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in _load_items
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in <listcomp>
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 118, in _load_item
cms-1 | block_data = self.get_module_data(block_key, course_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 145, in get_module_data
cms-1 | raise ItemNotFoundError(block_key)
cms-1 | xmodule.modulestore.exceptions.ItemNotFoundError: BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631')
caddy-1 | {"level":"info","ts":1724931388.0620222,"logger":"http.log.access.log1","msg":"handled request","request":{"remote_ip":"123.123.123.123","remote_port":"54591","proto":"HTTP/2.0","method":"GET","host":"studio.mysite.com","uri":"/xblock/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6","tls":{"resumed":true,"version":772,"cipher_suite":4865,"proto":"h2","server_name":"studio.mysite.com"}},"user_id":"","duration":0.432310588,"size":1737,"status":200}
cms-1 | [pid: 7|app: 0|req: 24/69] 172.18.0.3 () {62 vars in 3928 bytes} [Thu Aug 29 11:36:27 2024] GET /xblock/container/block-v1:MySite+MyClass+V1+type@vertical+block@04dd0e6b6d2c4cf38a125ca0f00469e6 => generated 10895 bytes in 432 msecs (HTTP/1.1 200) 6 headers in 325 bytes (1 switches on core 0)
cms-1 | 2024-08-29 11:36:27,736 ERROR 13 [django.request] [user 3] [ip 123.123.123.123] log.py:224 - Internal Server Error: /preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state
cms-1 | Traceback (most recent call last):
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/core/handlers/exception.py", line 47, in inner
cms-1 | response = get_response(request)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/core/handlers/base.py", line 181, in _get_response
cms-1 | response = wrapped_callback(request, *callback_args, **callback_kwargs)
cms-1 | File "/opt/pyenv/versions/3.8.15/lib/python3.8/contextlib.py", line 75, in inner
cms-1 | return func(*args, **kwds)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/contrib/auth/decorators.py", line 21, in _wrapped_view
cms-1 | return view_func(request, *args, **kwargs)
cms-1 | File "/openedx/venv/lib/python3.8/site-packages/django/views/decorators/clickjacking.py", line 50, in wrapped_view
cms-1 | resp = view_func(*args, **kwargs)
cms-1 | File "/openedx/edx-platform/./cms/djangoapps/contentstore/views/preview.py", line 69, in preview_handler
cms-1 | descriptor = modulestore().get_item(usage_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 84, in inner
cms-1 | retval = func(field_decorator=strip_key_collection, *args, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/mixed.py", line 250, in get_item
cms-1 | return store.get_item(usage_key, depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split_draft.py", line 283, in get_item
cms-1 | return super().get_item(usage_key, depth=depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 1183, in get_item
cms-1 | items = self._load_items(course, [BlockKey.from_usage_key(usage_key)], depth, **kwargs)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in _load_items
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/split.py", line 780, in <listcomp>
cms-1 | return [runtime.load_item(block_key, course_entry, **kwargs) for block_key in block_keys]
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 118, in _load_item
cms-1 | block_data = self.get_module_data(block_key, course_key)
cms-1 | File "/openedx/edx-platform/xmodule/modulestore/split_mongo/caching_descriptor_system.py", line 145, in get_module_data
cms-1 | raise ItemNotFoundError(block_key)
cms-1 | xmodule.modulestore.exceptions.ItemNotFoundError: BlockKey(type='video', id='1955d68fb2c248448371a59e427c1631')
caddy-1 | {"level":"error","ts":1724931388.149094,"logger":"http.log.access.log1","msg":"handled request","request":{"remote_ip":"123.123.123.123","remote_port":"54591","proto":"HTTP/2.0","method":"POST","host":"studio.mysite.com","uri":"/preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state","tls":{"resumed":true,"version":772,"cipher_suite":4865,"proto":"h2","server_name":"studio.mysite.com"}},"user_id":"","duration":0.531047891,"size":52,"status":500}
cms-1 | [pid: 13|app: 0|req: 23/70] 172.18.0.3 () {68 vars in 4126 bytes} [Thu Aug 29 11:36:27 2024] POST /preview/xblock/block-v1:MySite+MyClass+V1+type@video+block@1955d68fb2c248448371a59e427c1631/handler/xmodule_handler/save_user_state => generated 52 bytes in 531 msecs (HTTP/1.1 500) 8 headers in 440 bytes (1 switches on core 0)
cms-worker-1 | [2024-08-29 11:36:28,772: INFO/ForkPoolWorker-1] Task cms.djangoapps.contentstore.tasks.update_outline_from_modulestore_task[7daafeaf-a530-4e13-9dab-4e0a51d8c95a] succeeded in 1.4003612156957388s: None
cms-worker-1 | [2024-08-29 11:36:28,779: INFO/ForkPoolWorker-1] Starting XBlockCaches update for course_key: course-v1:MySite+MyClass+V1
mysql-1 | 2024-08-29T11:36:28.786980Z 138 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-worker-1 | [2024-08-29 11:36:29,047: INFO/ForkPoolWorker-1] Ending XBlockCaches update for course_key: course-v1:MySite+MyClass+V1
cms-worker-1 | [2024-08-29 11:36:29,049: INFO/ForkPoolWorker-1] Task openedx.core.djangoapps.bookmarks.tasks.update_xblocks_cache[236c5c47-8116-427c-be61-b7d9acbb86e5] succeeded in 0.2720468584448099s: None
cms-worker-1 | [2024-08-29 11:36:29,054: INFO/MainProcess] Task lms.djangoapps.discussion.tasks.update_discussions_map[a5e52b6b-27cc-48a1-8b52-3dcd724c18a8] received
cms-worker-1 | [2024-08-29 11:36:29,058: INFO/ForkPoolWorker-1] openedx.core.djangoapps.course_apps.tasks.update_course_apps_status[05f20ff0-0eb8-4301-96a8-9be799915fcf]: Caching course apps status for course with id: course-v1:MySite+MyClass+V1
cms-worker-1 | [2024-08-29 11:36:29,061: INFO/MainProcess] Task cms.djangoapps.contentstore.tasks.update_special_exams_and_publish[eb52f2d8-508d-40f5-8a12-7b97f936614f] received
mysql-1 | 2024-08-29T11:36:29.068560Z 139 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-worker-1 | [2024-08-29 11:36:29,073: INFO/ForkPoolWorker-2] GET http://elasticsearch:9200/courseware_content/_mapping [status:200 request:0.004s]
cms-worker-1 | [2024-08-29 11:36:29,156: WARNING/ForkPoolWorker-1] Flag 'course_live.enable_course_live' accessed without a request, which is likely in the context of a celery task.
cms-worker-1 | [2024-08-29 11:36:29,169: INFO/ForkPoolWorker-2] POST http://elasticsearch:9200/_bulk [status:200 request:0.029s]
cms-worker-1 | [2024-08-29 11:36:29,177: WARNING/ForkPoolWorker-1] Flag 'teams.enable_teams_app' accessed without a request, which is likely in the context of a celery task.
cms-worker-1 | [2024-08-29 11:36:29,201: INFO/ForkPoolWorker-2] POST http://elasticsearch:9200/courseware_content/_search [status:200 request:0.028s]
cms-worker-1 | [2024-08-29 11:36:29,203: INFO/ForkPoolWorker-2] Task cms.djangoapps.contentstore.tasks.update_search_index[4b3e09e8-e19b-4cae-a427-eb5d73924dd1] succeeded in 1.8196501731872559s: None
cms-worker-1 | [2024-08-29 11:36:29,211: INFO/ForkPoolWorker-2] cms.djangoapps.contentstore.tasks.update_special_exams_and_publish[eb52f2d8-508d-40f5-8a12-7b97f936614f]: Attempting to register exams for course course-v1:MySite+MyClass+V1
mysql-1 | 2024-08-29T11:36:29.219855Z 140 [Warning] [MY-013360] [Server] Plugin mysql_native_password reported: ''mysql_native_password' is deprecated and will be removed in a future release. Please use caching_sha2_password instead'
cms-worker-1 | [2024-08-29 11:36:29,225: WARNING/ForkPoolWorker-2] Flag 'course_apps.exams_ida' accessed without a request, which is likely in the context of a celery task.
cms-worker-1 | [2024-08-29 11:36:29,227: INFO/ForkPoolWorker-2] cms.djangoapps.contentstore.tasks.update_special_exams_and_publish[eb52f2d8-508d-40f5-8a12-7b97f936614f]: Successfully registered exams for course course-v1:MySite+MyClass+V1
cms-worker-1 | [2024-08-29 11:36:29,227: INFO/ForkPoolWorker-2] cms.djangoapps.contentstore.tasks.update_special_exams_and_publish[eb52f2d8-508d-40f5-8a12-7b97f936614f]: Publishing course course-v1:MySite+MyClass+V1
cms-worker-1 | [2024-08-29 11:36:29,232: INFO/ForkPoolWorker-2] Task cms.djangoapps.contentstore.tasks.update_special_exams_and_publish[eb52f2d8-508d-40f5-8a12-7b97f936614f] succeeded in 0.024167943745851517s: None
cms-worker-1 | [2024-08-29 11:36:29,245: INFO/ForkPoolWorker-1] Task openedx.core.djangoapps.course_apps.tasks.update_course_apps_status[05f20ff0-0eb8-4301-96a8-9be799915fcf] succeeded in 0.18955812603235245s: None
^Ccanceled
Though that feels like that could just be because it failed to cache it in the first place