Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Marimo hangs forever when using Logur logger.remove(None) #3756

Open
jjAtNxtPt opened this issue Feb 11, 2025 · 10 comments
Open

Marimo hangs forever when using Logur logger.remove(None) #3756

jjAtNxtPt opened this issue Feb 11, 2025 · 10 comments
Labels
bug Something isn't working platform:windows

Comments

@jjAtNxtPt
Copy link

Describe the bug

I use Loguru for my message logging. Prior to last week (maybe?) I had not issues running logger.remove() when doing the setup for my logger when in edit mode. However, now when I run that line in edit mode the notebook hangs forever. I've attached a screenshot showing that it the cell was at 2 minutes and 46 seconds. It's now over 8 minutes. I can still use Loguru to log my messages and everything works find when I run the notebook as a script from the command line, but I just can't run this one line while in edit mode anymore. This line needs to be done so I can create a new format for the logger instead of using the defaults. If I create the new logger without this, then the logged message is printed twice.

Image

Environment

Replace this line with the output of marimo env. Leave the backticks in place.

Code to reproduce

import marimo as mo
from loguru import logger

logger.remove()
@jjAtNxtPt jjAtNxtPt added the bug Something isn't working label Feb 11, 2025
@mscolnick
Copy link
Contributor

mscolnick commented Feb 11, 2025 •
edited
Loading 

import marimo as mo
from loguru import logger

logger.remove()

actually works find for me. can you try in a clean env or different python version?

@jjAtNxtPt
Copy link
Author

I tried creating a virtual environment using uv with just adding loguru and marimo to it. I then created a new marimo notebook with just the imports and then the logger.remove(). That didn't change anything. The logger.remove() line of code hanges forever, never completing.

@mscolnick
Copy link
Contributor

@jjAtNxtPt can you send us the output of marimo env

@jjAtNxtPt
Copy link
Author

{
"marimo": "0.11.2",
"OS": "Windows",
"OS Version": "10",
"Processor": "Intel64 Family 6 Model 85 Stepping 7, GenuineIntel",
"Python Version": "3.12.2",
"Binaries": {
"Browser": "132.0.6834.160",
"Node": "--"
},
"Dependencies": {
"click": "8.1.8",
"docutils": "0.21.2",
"itsdangerous": "2.2.0",
"jedi": "0.19.2",
"markdown": "3.7",
"narwhals": "1.26.0",
"packaging": "24.2",
"psutil": "6.1.1",
"pygments": "2.19.1",
"pymdown-extensions": "10.14.3",
"pyyaml": "6.0.2",
"ruff": "0.9.6",
"starlette": "0.45.3",
"tomlkit": "0.13.2",
"typing-extensions": "4.12.2",
"uvicorn": "0.34.0",
"websockets": "14.2"
},
"Optional Dependencies": {
"altair": "5.3.0",
"anywidget": "0.9.13",
"duckdb": "1.2.0",
"ibis-framework": "10.0.0",
"pandas": "2.2.3",
"polars": "1.22.0",
"pyarrow": "19.0.0"
},
"Experimental Flags": {}
}

@mahadi
Copy link

mahadi commented Feb 17, 2025 •
edited
Loading

Same issue here (reproduced with 0.11.1 and 0.11.5) using marimo edit --sandbox using

import marimo as mo
from loguru import logger

logger.remove()

{
"marimo": "0.11.1",
"OS": "Windows",
"OS Version": "11",
"Processor": "Intel64 Family 6 Model 142 Stepping 12, GenuineIntel",
"Python Version": "3.9.21",
"Binaries": {
"Browser": "128.0.6613.114",
"Node": "--"
},
"Dependencies": {
"click": "8.1.8",
"docutils": "0.21.2",
"itsdangerous": "2.2.0",
"jedi": "0.19.1",
"markdown": "3.6",
"narwhals": "1.26.0",
"packaging": "23.2",
"psutil": "6.1.1",
"pygments": "2.17.2",
"pymdown-extensions": "10.14.3",
"pyyaml": "6.0.2",
"ruff": "0.9.6",
"starlette": "0.45.3",
"tomlkit": "0.13.2",
"typing-extensions": "4.9.0",
"uvicorn": "0.34.0",
"websockets": "14.2"
},
"Optional Dependencies": {},
"Experimental Flags": {}
}

Using 0.10.19 it works.

@mscolnick
Copy link
Contributor

My guess is this is a Windows bug. (unfortunately I don't have the ability to debug on windows). Can you run marimo -d edit to run in debug mode and let me know if you see any errors / hints?

@jjAtNxtPt
Copy link
Author

I did as you asked but didn't find any errors. I'm using 0.11.5 now and created a new notebook with just the imports and the logger.remove(). I let the "logger.remove()" run for a few minutes and no errors appeared before I elected to shutdown.

Here's the output at the terminal:

[D 250217 11:44:56 lifespans:56] Setup: open_browser
[D 250217 11:44:56 manager:236] Using config at C:\Users\my_id.marimo.toml
INFO: Application startup complete.
INFO: Uvicorn running on http://127.0.0.1:2718 (Press CTRL+C to quit)
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:51] Validated access_token
[D 250217 11:44:57 assets:89] No file key provided, serving homepage
[D 250217 11:44:57 manager:236] Using config at C:\Users\my_id.marimo.toml
INFO: 127.0.0.1:53718 - "GET /?access_token=_jd6YlUGkLeyFGUMidu0QA HTTP/1.1" 200 OK
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
INFO: 127.0.0.1:53718 - "GET /assets/gradient-yHQUC_QB.png HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53723 - "GET /assets/PTSans-Bold-D9fedIX3.ttf HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/index-CmekZQwh.css HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53719 - "GET /assets/noise-60BoTA8O.png HTTP/1.1" 304 Not Modified
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /assets/PTSans-Regular-CxL0S8W7.ttf HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53720 - "GET /assets/Lora-VariableFont_wght-B2ootaw-.ttf HTTP/1.1" 304 Not Modified
[D 250217 11:44:57 auth:37] Validating auth
[D 250217 11:44:57 auth:37] Validating auth
INFO: 127.0.0.1:53723 - "GET /assets/FiraMono-Medium-DU3aDxX5.ttf HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/FiraMono-Bold-CLVRCuM9.ttf HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53718 - "GET /assets/FiraMono-Regular-BTCkDNvf.ttf HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53719 - "GET /assets/index-DA_9Xzp8.js HTTP/1.1" 304 Not Modified
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53719 - "GET /assets/home-page-BelELDaD.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53723 - "GET /assets/createWsUrl-DpnvBbzH.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/main-DPWVgc5Y.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53721 - "GET /assets/tree-C1rhMrxo.css HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53720 - "GET /assets/index-GK0MZKTa.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53718 - "GET /assets/tree-CmpjLpgm.js HTTP/1.1" 304 Not Modified
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53718 - "GET /assets/web-vitals-rCWRSGQR.js HTTP/1.1" 304 Not Modified
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53718 - "POST /api/home/recent_files HTTP/1.1" 200 OK
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53720 - "POST /api/home/running_notebooks HTTP/1.1" 200 OK
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:79] Invalid auth
INFO: 127.0.0.1:53724 - "GET /manifest.json HTTP/1.1" 200 OK
[D 250217 11:44:58 auth:37] Validating auth
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53720 - "POST /api/home/workspace_files HTTP/1.1" 200 OK
[D 250217 11:44:58 auth:37] Validating auth
INFO: 127.0.0.1:53718 - "GET /logo.png HTTP/1.1" 200 OK
INFO: 127.0.0.1:53721 - "GET /android-chrome-192x192.png HTTP/1.1" 200 OK
[D 250217 11:45:00 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /public-files-sw.js?v=2 HTTP/1.1" 200 OK
[D 250217 11:45:00 auth:37] Validating auth
[D 250217 11:45:00 assets:99] File key provided: __new__s_hmejxe
[D 250217 11:45:00 manager:236] Using config at C:\Users\my_id.marimo.toml
[D 250217 11:45:01 manager:236] Using config at C:\Users\my_id.marimo.toml
INFO: 127.0.0.1:53721 - "GET /?file=__new__s_hmejxe HTTP/1.1" 200 OK
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /public-files-sw.js?v=2 HTTP/1.1" 200 OK
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /assets/edit-page-vmd73V0q.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53718 - "GET /assets/useMarimoWebSocket-DDCV4AaU.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53723 - "GET /assets/step-CaHXtLdi.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/transform-D6ULhE8R.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /assets/edit-page-DeKBwDVH.css HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53718 - "GET /assets/time-CIdJ7-co.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53720 - "GET /assets/useMarimoWebSocket-CYiIF7o8.css HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53719 - "GET /assets/compile-D61BeNWL.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53723 - "GET /assets/linear-BV4Hv62W.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/init-DLRA0X12.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /assets/range-CtcPcB_L.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53718 - "GET /assets/ordinal-BcaZTuz9.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:01 auth:37] Validating auth
INFO: 127.0.0.1:53719 - "GET /assets/arc-BTlVLyGF.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53720 - "GET /assets/colors-bszWmPJw.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53723 - "GET /assets/sortBy-DlR_wEdD.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53722 - "GET /assets/_baseEach-ikVNrrLw.js HTTP/1.1" 304 Not Modified
INFO: 127.0.0.1:53721 - "GET /assets/_baseMap-Dg8xkOC2.js HTTP/1.1" 304 Not Modified
[D 250217 11:45:02 auth:37] Validating auth
[D 250217 11:45:02 manager:236] Using config at C:\Users\my_id.marimo.toml
INFO: ('127.0.0.1', 53727) - "WebSocket /ws?file=__new__s_hmejxe&session_id=s_yffyhc" [accepted]
[D 250217 11:45:02 ws:502] Websocket open request for session with id s_yffyhc
[D 250217 11:45:02 ws:505] Existing sessions: {}
[D 250217 11:45:02 sessions:781] Creating new session for id s_yffyhc
[D 250217 11:45:02 manager:236] Using config at C:\Users\my_id.marimo.toml
[D 250217 11:45:02 manager:236] Using config at C:\Users\my_id.marimo.toml
[D 250217 11:45:03 runtime:2154] Launching kernel
INFO: connection open
[D 250217 11:45:03 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/instantiate HTTP/1.1" 200 OK
[D 250217 11:45:03 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /public-files-sw.js?v=2 HTTP/1.1" 200 OK
[D 250217 11:45:04 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:45:04 runtime:2294] Received control request: CreationRequest(execution_requests=(ExecutionRequest(cell=Hbol, code_preview=),), set_ui_element_value_request=SetUIElementValueRequest(n_elements=0, token=70d962ea-19c1-4dbc-8ca8-53c7f7b8bf35), auto_run=False, request=HTTPRequest(path=/api/kernel/instantiate, params=0))
[D 250217 11:45:04 runtime:2086] Acquiring globals lock to handle request CreationRequest(execution_requests=(ExecutionRequest(cell=Hbol, code_preview=),), set_ui_element_value_request=SetUIElementValueRequest(n_elements=0, token=70d962ea-19c1-4dbc-8ca8-53c7f7b8bf35), auto_run=False, request=HTTPRequest(path=/api/kernel/instantiate, params=0))
[D 250217 11:45:04 runtime:2088] Handling control request: CreationRequest(execution_requests=(ExecutionRequest(cell=Hbol, code_preview=),), set_ui_element_value_request=SetUIElementValueRequest(n_elements=0, token=70d962ea-19c1-4dbc-8ca8-53c7f7b8bf35), auto_run=False, request=HTTPRequest(path=/api/kernel/instantiate, params=0))
[D 250217 11:45:04 runtime:2132] Handled control request: CreationRequest(execution_requests=(ExecutionRequest(cell=Hbol, code_preview=),), set_ui_element_value_request=SetUIElementValueRequest(n_elements=0, token=70d962ea-19c1-4dbc-8ca8-53c7f7b8bf35), auto_run=False, request=HTTPRequest(path=/api/kernel/instantiate, params=0))
[D 250217 11:45:14 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:45:14 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /favicon.ico HTTP/1.1" 200 OK
[D 250217 11:45:16 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /circle-check.ico HTTP/1.1" 200 OK
[D 250217 11:45:16 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:17 complete:334] Completion worker acquired globals lock
[D 250217 11:45:17 complete:493] Completion worker released globals lock.
[D 250217 11:45:18 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:18 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:19 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:19 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:19 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:21 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:21 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:22 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:45:22 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:22 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:23 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:24 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:25 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/run HTTP/1.1" 200 OK
[D 250217 11:45:25 runtime:2294] Received control request: ExecuteMultipleRequest(cells=1)
[D 250217 11:45:25 runtime:2086] Acquiring globals lock to handle request ExecuteMultipleRequest(cells=1)
[D 250217 11:45:25 runtime:2088] Handling control request: ExecuteMultipleRequest(cells=1)
[D 250217 11:45:25 dataflow:125] Acquiring graph lock to register cell Hbol
[D 250217 11:45:25 dataflow:127] Acquired graph lock.
[D 250217 11:45:25 dataflow:193] Registered cell Hbol and released graph lock
[D 250217 11:45:25 runtime:1028] Mutating graph.
[D 250217 11:45:25 runtime:1029] Current set of errors: {}
[D 250217 11:45:25 dataflow:125] Acquiring graph lock to register cell Hbol
[D 250217 11:45:25 dataflow:127] Acquired graph lock.
[D 250217 11:45:25 dataflow:193] Registered cell Hbol and released graph lock
[D 250217 11:45:25 runtime:728] registered cell Hbol
[D 250217 11:45:25 runtime:729] parents: set()
[D 250217 11:45:25 runtime:730] children: set()
[D 250217 11:45:25 runtime:846] graph:
cell id Hbol
parents {'Hbol': set()}
children {'Hbol': set()}
siblings {'Hbol': set()}
[D 250217 11:45:25 runtime:1067] After mutation, syntax errors {}
[D 250217 11:45:25 runtime:1068] Semantic errors {}
[D 250217 11:45:25 runtime:1112] Final set of errors, after pruning valid cells: {}
[D 250217 11:45:25 cell_runner:523] Running preparation hooks
[D 250217 11:45:25 cell_runner:529] Cell runner processing Hbol
[D 250217 11:45:25 cell_runner:552] Running pre_execution hooks
[D 250217 11:45:25 cell_runner:555] Running cell Hbol
[D 250217 11:45:25 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /circle-play.ico HTTP/1.1" 200 OK
[D 250217 11:45:25 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/sync/cell_ids HTTP/1.1" 200 OK
[D 250217 11:45:26 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:27 cell_runner:562] Running post_execution hooks
[D 250217 11:45:27 hooks_post_execution:56] Acquiring graph lock to update cell import workspace
[D 250217 11:45:27 hooks_post_execution:58] Acquired graph lock to update import workspace.
[D 250217 11:45:27 cell_runner:566] Running on_finish hooks
[D 250217 11:45:27 runtime:1248] Finished run.
[D 250217 11:45:27 runtime:2132] Handled control request: ExecuteMultipleRequest(cells=1)
[D 250217 11:45:27 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:27 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:27 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:28 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:28 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:28 complete:334] Completion worker acquired globals lock
[D 250217 11:45:28 complete:493] Completion worker released globals lock.
[D 250217 11:45:29 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:30 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:30 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/code_autocomplete HTTP/1.1" 200 OK
[D 250217 11:45:30 complete:334] Completion worker acquired globals lock
[D 250217 11:45:30 complete:493] Completion worker released globals lock.
[D 250217 11:45:31 auth:37] Validating auth
[D 250217 11:45:31 runtime:2294] Received control request: ExecuteMultipleRequest(cells=1)
INFO: 127.0.0.1:53721 - "POST /api/kernel/run HTTP/1.1" 200 OK
[D 250217 11:45:31 runtime:2086] Acquiring globals lock to handle request ExecuteMultipleRequest(cells=1)
[D 250217 11:45:31 runtime:2088] Handling control request: ExecuteMultipleRequest(cells=1)
[D 250217 11:45:31 runtime:1028] Mutating graph.
[D 250217 11:45:31 runtime:1029] Current set of errors: {}
[D 250217 11:45:31 dataflow:125] Acquiring graph lock to register cell PeHA
[D 250217 11:45:31 dataflow:127] Acquired graph lock.
[D 250217 11:45:31 dataflow:193] Registered cell PeHA and released graph lock
[D 250217 11:45:31 runtime:728] registered cell PeHA
[D 250217 11:45:31 runtime:729] parents: {'Hbol'}
[D 250217 11:45:31 runtime:730] children: set()
[D 250217 11:45:31 runtime:846] graph:
cell id PeHA
parents {'Hbol': set(), 'PeHA': {'Hbol'}}
children {'Hbol': {'PeHA'}, 'PeHA': set()}
siblings {'Hbol': set(), 'PeHA': set()}
[D 250217 11:45:31 runtime:1067] After mutation, syntax errors {}
[D 250217 11:45:31 runtime:1068] Semantic errors {}
[D 250217 11:45:31 runtime:1112] Final set of errors, after pruning valid cells: {}
[D 250217 11:45:31 cell_runner:523] Running preparation hooks
[D 250217 11:45:31 cell_runner:529] Cell runner processing PeHA
[D 250217 11:45:31 cell_runner:552] Running pre_execution hooks
[D 250217 11:45:31 cell_runner:555] Running cell PeHA
[D 250217 11:45:31 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "POST /api/kernel/sync/cell_ids HTTP/1.1" 200 OK
[D 250217 11:45:32 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:45:57 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:42 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:46 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:50 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:54 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:56 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:46:58 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:47:04 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:48:41 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:48:41 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:48:42 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:49:18 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:49:31 auth:37] Validating auth
INFO: 127.0.0.1:53721 - "GET /api/usage HTTP/1.1" 200 OK
[D 250217 11:49:50 auth:37] Validating auth
[D 250217 11:49:50 auth:37] Validating auth
[D 250217 11:49:50 execution:256] Received shutdown request
[D 250217 11:49:50 sessions:1051] Closing session s_yffyhc
[D 250217 11:49:50 auth:37] Validating auth
INFO: 127.0.0.1:53723 - "POST /api/home/running_notebooks HTTP/1.1" 200 OK
INFO: 127.0.0.1:53720 - "POST /api/home/running_notebooks HTTP/1.1" 200 OK
[D 250217 11:49:50 ws:696] Websocket terminated with CancelledError
INFO: connection closed

@mscolnick
Copy link
Contributor

@akshayka, could this be an issue from #3628 ?

@akshayka
Copy link
Contributor

No I don't think so:

Using 0.10.19 it works.

#3628 was released in 0.10.18.

@mahadi, if it's not too much trouble can you tell us the earliest version at which this fails for you? I can't reproduce the issue either.

@mahadi
Copy link

mahadi commented Feb 17, 2025

The first version which shows the error is 0.11.1 for me (0.11.0 is not available on conda-forge).

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working platform:windows
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@mahadi @akshayka @mscolnick @jjAtNxtPt