microsoft / vscode-jupyter

VS Code Jupyter extension
https://marketplace.visualstudio.com/items?itemName=ms-toolsai.jupyter
MIT License
1.28k stars 290 forks source link

debug cell command caused kernel to become un-usable #11371

Closed amunger closed 1 year ago

amunger commented 2 years ago

I don't have a repro for this anymore, but I hit it across multiple kernel restarts and even a window reload.

  1. I was working in the vscode-jupyter repo in vscode
  2. I had been debugging the extension at one point
  3. I opened a notebook in the project and ran a few cells
  4. I tried to set a breakpoint in a cell and debug that cell :bug: the UI changed to show that a debug session was starting (play icon turned to stop, spinner appeared), but never actually started the cell execution, and I eventually just had to kill the kernel

I've tried several variations of these steps and can no longer repro, debugging a cell even works when I'm already debugging the extension.

roblourens commented 2 years ago

Thanks for filing this. I just wanted to make sure I understood what you saw since this is exactly the sort of thing I am looking into this month. Please grab the logs if you see it again.

amunger commented 2 years ago

It occured again out of the blue, ran a few cells, cancelled one, then tried to debug another with a breakpoint.

I can actually still use the kernel to keep running cells but RBL and debugging are disabled, and the debug toolbar is visible but doesn't seem to do anything

image
Jupyter logs ``` Visual Studio Code - Insiders (1.72.0-insider, undefined, desktop) Jupyter Extension Version: 2022.9.1002781135. Python Extension Version: 2022.15.12731017. Workspace folder c:\src\vscode-jupyter info 10:18:14.859: ZMQ install verified. User belongs to experiment group 'jupyterTest' User belongs to experiment group 'jupyterEnhancedDataViewer' debug 10:18:15.895: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:15.903: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunNonPythonCode" debug 10:18:15.904: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:15.910: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter", Arg 2: "RunNonPythonCode" debug 10:18:15.912: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter", Arg 2: "RunPythonCode" debug 10:18:15.912: getCondaFile, Class name = k (started execution) debug 10:18:15.913: getCondaVersion, Class name = k (started execution) debug 10:18:15.913: getCondaVersionFromPython, Class name = k (started execution) info 10:18:15.927: LSP Notebooks experiment is disabled -- not in treatment group debug 10:18:15.993: Get Custom Env Variables, Class name = w, completed in 90ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunNonPythonCode" debug 10:18:15.995: Get Custom Env Variables, Class name = w, completed in 91ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:15.997: Get Custom Env Variables, Class name = w, completed in 86ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter", Arg 2: "RunNonPythonCode" debug 10:18:16.009: Get Custom Env Variables, Class name = w, completed in 87ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter", Arg 2: "RunPythonCode" debug 10:18:17.520: Get Active Interpreter, Class name = I (started execution), Arg 1: undefined debug 10:18:17.520: Get Interpreters, Class name = I (started execution), debug 10:18:17.520: Get Active Interpreter, Class name = I (started execution), Arg 1: undefined info 10:18:17.777: Checking for server existence. info 10:18:17.778: Checking for server usability. info 10:18:17.778: Starting notebook server. info 10:18:17.778: Connecting to server debug 10:18:18.308: getCondaFile, Class name = k, completed in 2396ms, has a truthy return value debug 10:18:18.308: getCondaVersion, Class name = k, completed in 2395ms, has a truthy return value info 10:18:33.651: Connecting to process server info 10:18:33.651: Connecting server kernel http://127.0.0.1:8888/ Connecting to Jupyter server at http://127.0.0.1:8888/ info 10:18:33.653: Creating server with url : http://127.0.0.1:8888/ info 10:18:33.757: Connection complete server info 10:18:33.759: Server started. info 10:18:33.760: Creating server with url : http://127.0.0.1:8888/ error 10:18:33.845: Error fetching remote kernels: FetchError: request to http://127.0.0.1:8888/api/kernels?1664817513767 failed, reason: connect ECONNREFUSED 127.0.0.1:8888 at ClientRequest. (c:\Users\aamunger\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\out\extension.node.js:17:610475) at ClientRequest.emit (node:events:526:28) at Socket.socketErrorListener (node:_http_client:442:9) at Socket.emit (node:events:526:28) at emitErrorNT (node:internal/streams/destroy:157:8) at emitErrorCloseNT (node:internal/streams/destroy:122:3) at processTicksAndRejections (node:internal/process/task_queues:83:21) debug 10:18:33.847: Disposing session manager debug 10:18:33.847: SessionManager - dispose contents manager debug 10:18:33.847: ShutdownSessionAndConnection - dispose session manager debug 10:18:33.896: Finished disposing jupyter session manager error 10:18:33.900: SessionManager:getKernelSpecs failure: Error: Poll (@jupyterlab/services:KernelSpecManager#specs) is disposed. at e.dispose (c:\Users\aamunger\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\out\node_modules\@jupyterlab\services.js:2:156575) at m.dispose (c:\Users\aamunger\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\out\node_modules\@jupyterlab\services.js:2:48238) at u.dispose (c:\Users\aamunger\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\out\extension.node.js:2:2082899) at processTicksAndRejections (node:internal/process/task_queues:96:5) at P.listKernelsFromConnection (c:\Users\aamunger\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\out\extension.node.js:2:1934952) debug 10:18:36.216: Get Active Interpreter, Class name = I, completed in 20321ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:36.216: Get Active Interpreter, Class name = I, completed in 18697ms, has a truthy return value, Arg 1: undefined debug 10:18:36.217: interpreterPackages getPackageInformation, Class name = r (started execution), Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:18:36.217: Create activated Env, Class name = _ (started execution), Arg 1: {"allowEnvironmentFetchExceptions":true,"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:18:36.217: Getting activated env variables, Class name = V (started execution), Arg 1: undefined, Arg 2: , Arg 3: true debug 10:18:36.217: Getting activated env variables impl, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:18:36.218: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:18:36.218: Getting activated env variables from Python, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:18:36.218: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:36.219: Cached data exists getEnvironmentVariables, debug 10:18:36.219: Cached custom vars data exists getCustomEnvironmentVariables, debug 10:18:36.219: Get Active Interpreter, Class name = I, completed in 18699ms, has a truthy return value, Arg 1: undefined debug 10:18:36.220: Get Custom Env Variables, Class name = w, completed in 2ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:36.229: Get Interpreter details, Class name = I (started execution), Arg 1: "/c:/venvs/.venv3/Scripts/python.exe", Arg 2: undefined debug 10:18:36.229: Got activation Env Vars without any caching. Key is \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:18:36.230: Get Interpreter details, Class name = I, completed in 1ms, has a truthy return value, Arg 1: "/c:/venvs/.venv3/Scripts/python.exe", Arg 2: undefined debug 10:18:36.230: Create ProcessService, Class name = h (started execution), Arg 1: undefined debug 10:18:36.230: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunNonPythonCode" debug 10:18:36.230: Cached data exists getEnvironmentVariables, debug 10:18:36.230: Getting env activation commands, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:18:36.230: Getting activation commands for file:///c%3A/venvs/.venv3/Scripts/python.exe debug 10:18:36.230: Getting activation commands for file:///c%3A/venvs/.venv3/Scripts/python.exe are cached. debug 10:18:36.230: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:36.230: Cached data exists getEnvironmentVariables, debug 10:18:36.230: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunNonPythonCode" debug 10:18:36.231: Getting env activation commands, Class name = V, completed in 1ms, has a truthy return value, Arg 1: undefined, Arg 2: debug 10:18:36.231: Get Custom Env Variables, Class name = w, completed in 1ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:36.231: Create ProcessService, Class name = h, completed in 1ms, has a truthy return value, Arg 1: undefined debug 10:18:36.231: Activation Commands received c:/venvs/.venv3/Scripts/activate.bat for shell cmd debug 10:18:36.232: Has Custom Env Vars debug 10:18:36.233: Activating Environment to capture Environment variables, c:/venvs/.venv3/Scripts/activate.bat && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py debug 10:18:36.233: Execing shell command, Class name = b (started execution), Arg 1: "c:/venvs/.venv3/Scripts/activate.bat && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py", Arg 2: "" debug 10:18:37.342: Execing shell command, Class name = b, completed in 1109ms, has a truthy return value, Arg 1: "c:/venvs/.venv3/Scripts/activate.bat && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py", Arg 2: "" debug 10:18:37.343: parseEnvironmentOutput, Class name = V, completed in 1ms, has a truthy return value debug 10:18:37.344: Getting activated env variables ourselves, Class name = V, completed in 1127ms, has a truthy return value, Arg 1: undefined, Arg 2: info 10:18:37.345: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 1128ms debug 10:18:37.345: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 1128ms debug 10:18:37.345: Getting activated env variables impl, Class name = V, completed in 1128ms, has a truthy return value, Arg 1: undefined, Arg 2: debug 10:18:37.345: Getting activated env variables, Class name = V, completed in 1128ms, has a truthy return value, Arg 1: undefined, Arg 2: , Arg 3: true debug 10:18:37.346: Create activated Env, Class name = _, completed in 1129ms, has a truthy return value, Arg 1: {"allowEnvironmentFetchExceptions":true,"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} info 10:18:37.356: Process Execution: > c:\venvs\.venv3\Scripts\python.exe -m pip list > c:\venvs\.venv3\Scripts\python.exe -m pip list info 10:18:37.382: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 61 and custom env var count 0 in 1164ms debug 10:18:37.383: Getting activated env variables from Python, Class name = V, completed in 1165ms, has a truthy return value, Arg 1: undefined, Arg 2: debug 10:18:37.383: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 1166ms debug 10:18:43.192: getCondaVersionFromPython, Class name = k, completed in 27279ms, has a truthy return value debug 10:18:43.557: interpreterPackages getPackageInformation, Class name = r, completed in 7340ms, has a falsy return value, Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:18:43.828: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:43.828: Cached data exists getEnvironmentVariables, debug 10:18:43.829: Get Interpreters, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.829: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.830: Get Custom Env Variables, Class name = w, completed in 2ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:18:43.830: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 2ms, has a truthy return value, , Return Value: debug 10:18:43.830: Get Active Interpreter, Class name = I, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.830: Get Jupyter Sub Paths, Class name = j, completed in 2ms, has a truthy return value, Arg 1: "", Arg 2: "kernels", Return Value: debug 10:18:43.830: Get Jupyter Kernel Paths, Class name = j, completed in 2ms, has a truthy return value, Arg 1: "", Return Value: debug 10:18:43.831: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 1ms, has a truthy return value, , Return Value: debug 10:18:43.832: Full interpreter list for is length: 17, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 ('.venv3'):Venv:c:\venvs\.venv3\Scripts\python.exe debug 10:18:43.834: Get KernelSpec root path, Class name = j, completed in 6ms, has a truthy return value, Arg 1: {"_isCancelled":false,"_emitter":null}, Return Value: , debug 10:18:43.835: Get Interpreters, Class name = I, completed in 26315ms, has a truthy return value, debug 10:18:43.835: Full interpreter list for c:\src\vscode-jupyter is length: 17, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 ('.venv3'):Venv:c:\venvs\.venv3\Scripts\python.exe debug 10:18:43.838: Get Interpreters, Class name = I, completed in 9ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.839: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.840: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 1ms, has a truthy return value, , Return Value: debug 10:18:43.840: Get Active Interpreter, Class name = I, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.840: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 1ms, has a truthy return value, , Return Value: debug 10:18:43.840: Get Jupyter Kernel Paths, Class name = j, completed in 1ms, has a truthy return value, Arg 1: "", Return Value: debug 10:18:43.840: Get Jupyter Kernel Paths, Class name = j, completed in 1ms, has a truthy return value, Arg 1: "", Return Value: debug 10:18:43.840: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 0ms, has a truthy return value, , Return Value: debug 10:18:43.840: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 0ms, has a truthy return value, , Return Value: debug 10:18:43.841: Get KernelSpec root path, Class name = j, completed in 1ms, has a truthy return value, Arg 1: , Return Value: , debug 10:18:43.841: Get KernelSpec root path, Class name = j, completed in 2ms, has a truthy return value, Arg 1: , Return Value: , debug 10:18:43.847: Not Searching for kernels as path not found, c:\Users\aamunger\AppData\Local\Programs\Python\Python310_5\share\jupyter\kernels debug 10:18:43.848: Not Searching for kernels as path not found, c:\Program Files\WindowsApps\PythonSoftwareFoundation.Python.3.9_3.9.3568.0_x64__qbz5n2kfra8p0\share\jupyter\kernels debug 10:18:43.848: Not Searching for kernels as path not found, c:\Users\aamunger\AppData\Local\Programs\Python\Python39\share\jupyter\kernels debug 10:18:43.848: Not Searching for kernels as path not found, c:\Users\aamunger\Anaconda3\envs\condaEnv1\share\jupyter\kernels debug 10:18:43.848: Not Searching for kernels as path not found, share\jupyter\kernels debug 10:18:43.868: Loading kernelspec from c:\Users\aamunger\AppData\Roaming\jupyter\kernels\.venvkernel\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\Users\aamunger\AppData\Roaming\jupyter\kernels\.venvkernel2\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\Users\aamunger\AppData\Roaming\jupyter\kernels\.venvnokernel\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\Users\aamunger\AppData\Roaming\jupyter\kernels\julia-1.7\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\Users\aamunger\AppData\Roaming\jupyter\kernels\vulnerability\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\ProgramData\jupyter\kernels\python3\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\ProgramData\jupyter\kernels\vulnerability\kernel.json for debug 10:18:43.868: Loading kernelspec from c:\ProgramData\jupyter\kernels\vulnerability2\kernel.json for debug 10:18:43.869: Loading kernelspec from c:\Users\aamunger\Anaconda3\share\jupyter\kernels\python3\kernel.json for c:\Users\aamunger\Anaconda3\python.exe debug 10:18:43.869: Loading kernelspec from c:\Users\aamunger\Anaconda3\envs\env2\share\jupyter\kernels\python3\kernel.json for c:\Users\aamunger\Anaconda3\envs\env2\python.exe debug 10:18:43.869: Loading kernelspec from c:\Users\aamunger\AppData\Local\Programs\Python\Python37\share\jupyter\kernels\python3\kernel.json for c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe debug 10:18:43.869: Loading kernelspec from c:\venvs\.venv3\share\jupyter\kernels\python3\kernel.json for c:\venvs\.venv3\Scripts\python.exe debug 10:18:43.902: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/src/test/datascience/.venvkernel/Scripts/python2.exe" debug 10:18:43.902: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/.venvkernel/Scripts/python.exe" debug 10:18:43.903: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/.venvnokernel/Scripts/python.exe" debug 10:18:43.903: Get Interpreter details, Class name = I (started execution), Arg 1: "/Windows/system32/calc.exe" debug 10:18:43.921: Get Interpreters, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.921: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.921: Get Active Interpreter, Class name = I, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.922: Full interpreter list for c:\src\vscode-jupyter is length: 19, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 ('.venv3'):Venv:c:\venvs\.venv3\Scripts\python.exe, Python 3.9.13 64-bit (microsoft store):MicrosoftStore:c:\Users\aamunger\AppData\Local\Microsoft\WindowsApps\python3.9.exe, Python 3.9.7 ('base'):Conda:c:\Users\aamunger\Anaconda3\python.exe, Python 3.10.5 64-bit:Global:c:\Python310\python.exe, Python 3.9.10 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python39\python.exe, Python 3.10.4 ('env2'):Conda:c:\Users\aamunger\Anaconda3\envs\env2\python.exe, Python ('rstudio'):Conda:python, Python 3.10.4 ('condaEnv1'):Conda:c:\Users\aamunger\Anaconda3\envs\condaEnv1\python.exe, Python 3.7.0 64-bit:Global:c:\Users\aamunger\AppData\Local\Programs\Python\Python37\python.exe, Python 3.9.13 ('.venv3'):Venv:c:\venvs\.venv3\Scripts\python.exe, Python 3.9.13 ('.venv3'):Venv:c:\venvs\.venv3\Scripts\python.exe debug 10:18:43.923: Get Interpreters, Class name = I, completed in 2ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.924: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.924: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 0ms, has a truthy return value, , Return Value: debug 10:18:43.924: Get Active Interpreter, Class name = I, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter" debug 10:18:43.924: Get Jupyter Kernel Paths, Class name = j, completed in 0ms, has a truthy return value, Arg 1: "", Return Value: debug 10:18:43.924: Getting Jupyter KernelSpec Root Path, Class name = j, completed in 0ms, has a truthy return value, , Return Value: debug 10:18:43.925: Get KernelSpec root path, Class name = j, completed in 1ms, has a truthy return value, Arg 1: {"_isCancelled":false,"_emitter":null}, Return Value: , debug 10:18:43.938: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/src/test/datascience/.venvkernel/Scripts/python2.exe" debug 10:18:43.938: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/.venvkernel/Scripts/python.exe" debug 10:18:43.939: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/src/vscode-jupyter/.venvnokernel/Scripts/python.exe" debug 10:18:43.939: Get Interpreter details, Class name = I (started execution), Arg 1: "/Windows/system32/calc.exe" debug 10:18:44.092: Get Interpreter details, Class name = I, completed in 189ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/.venvkernel/Scripts/python.exe" debug 10:18:44.092: Get Interpreter details, Class name = I, completed in 154ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/.venvkernel/Scripts/python.exe" debug 10:18:44.092: Kernel Spec for .venvkernel ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel\\kernel.json","name":".venvkernel","argv":["C:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe","display_name":".venvkernel","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel\\kernel.json","originalDisplayName":".venvkernel"}}},"id":"..venvkernel.c:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.092: Kernel Spec for .venvkernel ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel\\kernel.json","name":".venvkernel","argv":["C:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe","display_name":".venvkernel","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel\\kernel.json","originalDisplayName":".venvkernel"}}},"id":"..venvkernel.c:\\src\\vscode-jupyter\\.venvkernel\\Scripts\\python.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.093: Get Interpreter details, Class name = I, completed in 191ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/src/test/datascience/.venvkernel/Scripts/python2.exe" debug 10:18:44.093: Get Interpreter details, Class name = I, completed in 155ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/src/test/datascience/.venvkernel/Scripts/python2.exe" debug 10:18:44.093: Kernel Spec for .venvBad ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel2\\kernel.json","name":".venvkernel2","argv":["C:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe","display_name":".venvBad","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel2\\kernel.json","originalDisplayName":".venvBad"}}},"id":"..venvkernel2.c:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.093: Kernel Spec for .venvBad ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel2\\kernel.json","name":".venvkernel2","argv":["C:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe","display_name":".venvBad","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvkernel2\\kernel.json","originalDisplayName":".venvBad"}}},"id":"..venvkernel2.c:\\src\\vscode-jupyter\\src\\test\\datascience\\.venvkernel\\Scripts\\python2.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.123: Get Interpreter details, Class name = I, completed in 220ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/.venvnokernel/Scripts/python.exe" debug 10:18:44.123: Get Interpreter details, Class name = I, completed in 184ms, has a falsy return value, Arg 1: "/C:/src/vscode-jupyter/.venvnokernel/Scripts/python.exe" debug 10:18:44.123: Kernel Spec for .venvnokernel ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvnokernel\\kernel.json","name":".venvnokernel","argv":["C:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe","display_name":".venvnokernel","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvnokernel\\kernel.json","originalDisplayName":".venvnokernel"}}},"id":"..venvnokernel.c:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.123: Kernel Spec for .venvnokernel ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvnokernel\\kernel.json","name":".venvnokernel","argv":["C:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"C:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe","display_name":".venvnokernel","metadata":{"debugger":true,"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\.venvnokernel\\kernel.json","originalDisplayName":".venvnokernel"}}},"id":"..venvnokernel.c:\\src\\vscode-jupyter\\.venvnokernel\\Scripts\\python.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.130: Get Interpreter details, Class name = I, completed in 227ms, has a falsy return value, Arg 1: "/Windows/system32/calc.exe" debug 10:18:44.130: Get Interpreter details, Class name = I, completed in 191ms, has a falsy return value, Arg 1: "/Windows/system32/calc.exe" debug 10:18:44.131: Kernel Spec for exp ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\vulnerability\\kernel.json","name":"vulnerability","argv":["/Windows/system32/calc.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"/Windows/system32/calc.exe","display_name":"exp","metadata":{"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\vulnerability\\kernel.json","originalDisplayName":"exp"}}},"id":".vulnerability.Windows\\system32\\calc.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.131: Kernel Spec for exp ignored as we cannot find a matching interpreter {"kind":"startUsingLocalKernelSpec","kernelSpec":{"specFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\vulnerability\\kernel.json","name":"vulnerability","argv":["/Windows/system32/calc.exe","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"/Windows/system32/calc.exe","display_name":"exp","metadata":{"vscode":{"originalSpecFile":"c:\\Users\\aamunger\\AppData\\Roaming\\jupyter\\kernels\\vulnerability\\kernel.json","originalDisplayName":"exp"}}},"id":".vulnerability.Windows\\system32\\calc.exe.\\.-m#ipykernel_launcher"} debug 10:18:44.131: Hiding default kernel spec 'Python 3 (ipykernel)', 'python370jvsc74a57bd0c425ebb03616a8a25d4d93a3e4bafd01d56f1c50213fc0be01320c989c46a1ea', python debug 10:18:44.131: Hiding default kernel spec 'Python 3 (ipykernel)', 'python397jvsc74a57bd0a50e409ee52969325c66223eefa701d149e5f25a648490dd122f6f291d156538', ~\Anaconda3\python.exe debug 10:18:44.132: Hiding default kernel spec 'Python 3 (ipykernel)', 'python3104jvsc74a57bd0ac25f088eb6f8666873568c96fa138b15818ded9f23c0a31a5dd0870477f537c', ~\Anaconda3\envs\env2\python.exe debug 10:18:44.132: Hiding default kernel spec 'Python 3 (ipykernel)', 'python397jvsc74a57bd0a50e409ee52969325c66223eefa701d149e5f25a648490dd122f6f291d156538', ~\Anaconda3\python.exe debug 10:18:44.132: Hiding default kernel spec 'Python 3 (ipykernel)', 'python3104jvsc74a57bd0ac25f088eb6f8666873568c96fa138b15818ded9f23c0a31a5dd0870477f537c', ~\Anaconda3\envs\env2\python.exe debug 10:18:44.132: Hiding default kernel spec 'Python 3 (ipykernel)', 'python370jvsc74a57bd0c425ebb03616a8a25d4d93a3e4bafd01d56f1c50213fc0be01320c989c46a1ea', python debug 10:18:44.132: Hiding default kernel spec 'Python 3 (ipykernel)', 'python3913jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649', python debug 10:24:56.881: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:56.889: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:56.893: Get Active Interpreter, Class name = I, completed in 12ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:56.893: Get Active Interpreter, Class name = I, completed in 4ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:56.897: Creating notebook controller with name .venv3 (Python 3.9.13) debug 10:24:56.908: KernelProvider switched kernel to id = .jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649.c:\venvs\.venv3\Scripts\python.exe.c:\venvs\.venv3\Scripts\python.exe.-m#ipykernel_launcher debug 10:24:56.909: start the kernel, options.disableUI=true debug 10:24:56.910: Start Jupyter Session in kernel.ts with disableUI = true debug 10:24:56.913: Controller selection change completed debug 10:24:56.949: Storing Preferred remote kernel for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb is undefined info 10:24:57.568: Starting Jupyter Session startUsingPythonInterpreter, .jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649.c:\venvs\.venv3\Scripts\python.exe.c:\venvs\.venv3\Scripts\python.exe.-m#ipykernel_launcher (Python Path: c:\venvs\.venv3, EnvType: Venv, EnvName: '.venv3', Version: 3.9.13) for 'c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb' (disableUI=true) debug 10:24:57.569: Creating raw notebook for resource 'c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb' info 10:24:57.570: Computing working directory for resource 'c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb' debug 10:24:57.570: interpreterPackages getPackageInformation, Class name = r (started execution), Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:24:57.570: Create activated Env, Class name = _ (started execution), Arg 1: {"allowEnvironmentFetchExceptions":true,"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:24:57.570: Getting activated env variables, Class name = V (started execution), Arg 1: undefined, Arg 2: , Arg 3: true debug 10:24:57.570: Getting activated env variables impl, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:24:57.570: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:24:57.571: Getting activated env variables from Python, Class name = V (started execution), Arg 1: undefined, Arg 2: debug 10:24:57.571: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:24:57.571: Cached data exists getEnvironmentVariables, debug 10:24:57.571: Cached custom vars data exists getCustomEnvironmentVariables, debug 10:24:57.571: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:24:57.572: Got activation Env Vars from cached promise with key \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:24:57.573: Getting activated env variables ourselves, Class name = V, completed in 2ms, has a truthy return value, Arg 1: undefined, Arg 2: info 10:24:57.573: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 61 and custom env var count 0 in 2ms info 10:24:57.573: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 3ms debug 10:24:57.573: Getting activated env variables from Python, Class name = V, completed in 2ms, has a truthy return value, Arg 1: undefined, Arg 2: debug 10:24:57.573: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 3ms debug 10:24:57.574: Getting activated env variables impl, Class name = V, completed in 4ms, has a truthy return value, Arg 1: undefined, Arg 2: debug 10:24:57.574: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 4ms debug 10:24:57.574: Getting activated env variables, Class name = V, completed in 4ms, has a truthy return value, Arg 1: undefined, Arg 2: , Arg 3: true debug 10:24:57.574: Create activated Env, Class name = _, completed in 4ms, has a truthy return value, Arg 1: {"allowEnvironmentFetchExceptions":true,"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} info 10:24:57.583: Process Execution: > c:\venvs\.venv3\Scripts\python.exe -m pip list > c:\venvs\.venv3\Scripts\python.exe -m pip list debug 10:24:58.407: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.411: Get Active Interpreter, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.413: Get Active Interpreter, Class name = I, completed in 6ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.413: Get Active Interpreter, Class name = I, completed in 2ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.419: Kernel Launcher. launch, Class name = r (started execution), Arg 1: {"kind":"startUsingPythonInterpreter","kernelSpec":{"interpreterPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","isRegisteredByVSC":"registeredByNewVersionOfExt","name":"python3913jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649","argv":["python","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"python","display_name":"Python 3.9.13 ('.venv3')","metadata":{"interpreter":{"path":"c:\\venvs\\.venv3\\Scripts\\python.exe"}},"env":{}},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"id":".jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649.c:\\venvs\\.venv3\\Scripts\\python.exe.c:\\venvs\\.venv3\\Scripts\\python.exe.-m#ipykernel_launcher"}, Arg 2: 60000, Arg 3: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 4: "c:\\src\\vscode-jupyter\\.vscode\\notebooks", Arg 5: {"_isCancelled":false,"_emitter":null} debug 10:24:58.419: Create activated Env, Class name = _ (started execution), Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"}} debug 10:24:58.420: Getting activated env variables, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:24:58.420: Getting activated env variables impl, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.420: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.420: Getting activated env variables from Python, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.420: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.420: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.420: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.421: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.423: Got activation Env Vars from cached promise with key \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:24:58.423: Getting activated env variables ourselves, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: info 10:24:58.423: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 3ms debug 10:24:58.423: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 3ms debug 10:24:58.423: Getting activated env variables impl, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.423: Getting activated env variables, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:24:58.424: Create activated Env, Class name = _, completed in 4ms, has a truthy return value, Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"}} info 10:24:58.432: Process Execution: > c:\venvs\.venv3\Scripts\python.exe -c "import ipykernel; print(ipykernel.__version__); print("5dc3a68c-e34e-4080-9c3e-2a532b2ccb4d"); print(ipykernel.__file__)" > c:\venvs\.venv3\Scripts\python.exe -c "import ipykernel; print(ipykernel.__version__); print("5dc3a68c-e34e-4080-9c3e-2a532b2ccb4d"); print(ipykernel.__file__)" info 10:24:58.737: Registering dummy command feature debug 10:24:58.825: Launching kernel in kernelProcess.ts, Class name = x (started execution), Arg 1: "c:\\src\\vscode-jupyter\\.vscode\\notebooks", Arg 2: "" debug 10:24:58.825: Create activated Env, Class name = _ (started execution), Arg 1: {"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:24:58.825: Getting activated env variables, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:24:58.825: Getting activated env variables impl, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.825: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.825: Getting activated env variables from Python, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.825: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.825: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.825: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.826: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.826: Getting activated env variables, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: false debug 10:24:58.826: Getting activated env variables impl, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.826: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.826: Getting activated env variables from Python, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.826: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.826: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.826: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.826: Get Custom Env Variables, Class name = w, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.827: Get Custom Env Variables, Class name = w, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.828: Got activation Env Vars from cached promise with key \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:24:58.828: Got activation Env Vars from cached promise with key \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:24:58.828: Getting activated env variables ourselves, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.828: Getting activated env variables ourselves, Class name = V, completed in 2ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: info 10:24:58.828: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 3ms info 10:24:58.828: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 2ms debug 10:24:58.828: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 3ms debug 10:24:58.828: Getting activated env variables impl, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.828: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 2ms debug 10:24:58.828: Getting activated env variables impl, Class name = V, completed in 2ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.828: Getting activated env variables, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:24:58.828: Getting activated env variables, Class name = V, completed in 2ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: false debug 10:24:58.828: Create activated Env, Class name = _, completed in 3ms, has a truthy return value, Arg 1: {"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:24:58.831: Get Interpreters, Class name = I (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.832: Get Interpreters, Class name = I, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.833: Create activated Env, Class name = _ (started execution), Arg 1: {"interpreter":{"id":"C:\\USERS\\AAMUNGER\\ANACONDA3\\PYTHON.EXE","sysPrefix":"C:\\Users\\aamunger\\Anaconda3","envType":"Conda","envName":"base","envPath":{"$mid":1,"fsPath":"c:\\Users\\aamunger\\Anaconda3","_sep":1,"path":"/C:/Users/aamunger/Anaconda3","scheme":"file"},"architecture":3,"sysVersion":"3.9.7 (default, Sep 16 2021, 16:59:28) [MSC v.1916 64 bit (AMD64)]","version":{"raw":"3.9.7","major":3,"minor":9,"patch":7,"build":[],"prerelease":["final","0"]},"companyDisplayName":"ContinuumAnalytics","displayName":"Python 3.9.7 ('base')","detailedDisplayName":"Python 3.9.7 ('base': conda)","uri":{"$mid":1,"fsPath":"c:\\Users\\aamunger\\Anaconda3\\python.exe","_sep":1,"external":"file:///c%3A/Users/aamunger/Anaconda3/python.exe","path":"/C:/Users/aamunger/Anaconda3/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"}} debug 10:24:58.833: Getting activated env variables, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:24:58.833: Getting activated env variables impl, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.833: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.833: Getting activated env variables from Python, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.833: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.833: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.833: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.833: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.834: getCondaEnvVariables, Class name = V (started execution) debug 10:24:58.834: getCondaVersion, Class name = k (started execution) debug 10:24:58.834: Got activation Env Vars without any caching. Key is \C:\SRC\VSCODE-JUPYTER_a50e409ee52969325c66223eefa701d149e5f25a648490dd122f6f291d156538 debug 10:24:58.834: getCondaVersion, Class name = k, completed in 0ms, has a truthy return value debug 10:24:58.835: Get Interpreter details, Class name = I (started execution), Arg 1: "/C:/Users/aamunger/Anaconda3/python.exe", Arg 2: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.835: Get Interpreter details, Class name = I, completed in 0ms, has a truthy return value, Arg 1: "/C:/Users/aamunger/Anaconda3/python.exe", Arg 2: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.835: Create ProcessService, Class name = h (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.835: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunNonPythonCode" debug 10:24:58.836: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.836: Getting env activation commands, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.836: Getting activation commands for file:///c%3A/Users/aamunger/Anaconda3/python.exe debug 10:24:58.836: Getting activation commands for file:///c%3A/Users/aamunger/Anaconda3/python.exe are cached. debug 10:24:58.836: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.836: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:24:58.836: Get Custom Env Variables, Class name = w, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunNonPythonCode" debug 10:24:58.836: Getting env activation commands, Class name = V, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:24:58.836: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:24:58.836: Create ProcessService, Class name = h, completed in 1ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb" debug 10:24:58.836: Activation Commands received C:/Users/aamunger/Anaconda3/Scripts/activate,conda activate base for shell cmd debug 10:24:58.837: Has Custom Env Vars debug 10:24:58.837: Activating Environment to capture Environment variables, C:/Users/aamunger/Anaconda3/Scripts/activate && conda activate base && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py debug 10:24:58.837: Execing shell command, Class name = b (started execution), Arg 1: "C:/Users/aamunger/Anaconda3/Scripts/activate && conda activate base && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py", Arg 2: "" info 10:25:00.308: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 62 and custom env var count 0 in 1888ms debug 10:25:00.308: Getting activated env variables from Python, Class name = V, completed in 1888ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:25:00.309: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 1889ms debug 10:25:00.368: interpreterPackages getPackageInformation, Class name = r, completed in 2798ms, has a falsy return value, Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} info 10:25:01.262: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 62 and custom env var count 0 in 2436ms debug 10:25:01.262: Getting activated env variables from Python, Class name = V, completed in 2436ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:25:01.262: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 2436ms info 10:25:01.370: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 62 and custom env var count 0 in 2545ms debug 10:25:01.370: Getting activated env variables from Python, Class name = V, completed in 2545ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:25:01.370: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 2545ms info 10:25:02.371: ipykernel version & path 6.15.3, c:\venvs\.venv3\lib\site-packages\ipykernel\__init__.py for c:\venvs\.venv3\Scripts\python.exe debug 10:25:02.993: Execing shell command, Class name = b, completed in 4156ms, has a truthy return value, Arg 1: "C:/Users/aamunger/Anaconda3/Scripts/activate && conda activate base && echo 'e8b39361-0157-4923-80e1-22d70d46dee6' && python c:/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/pythonFiles/printEnvVariables.py", Arg 2: "" debug 10:25:02.993: parseEnvironmentOutput, Class name = V, completed in 0ms, has a truthy return value debug 10:25:02.995: getCondaEnvVariables, Class name = V, completed in 4161ms, has a truthy return value debug 10:25:02.996: getCondaEnvVariables and send telemetry took: 4162ms debug 10:25:02.996: Getting activated env variables ourselves, Class name = V, completed in 4163ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: info 10:25:02.996: Got env vars ourselves faster c:\Users\aamunger\Anaconda3\python.exe with env var count 64 in 4163ms debug 10:25:02.996: Got env vars ourselves c:\Users\aamunger\Anaconda3\python.exe in 4163ms debug 10:25:02.996: Getting activated env variables impl, Class name = V, completed in 4163ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:25:02.997: Getting activated env variables, Class name = V, completed in 4164ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: undefined debug 10:25:02.997: Create activated Env, Class name = _, completed in 4164ms, has a truthy return value, Arg 1: {"interpreter":{"id":"C:\\USERS\\AAMUNGER\\ANACONDA3\\PYTHON.EXE","sysPrefix":"C:\\Users\\aamunger\\Anaconda3","envType":"Conda","envName":"base","envPath":{"$mid":1,"fsPath":"c:\\Users\\aamunger\\Anaconda3","_sep":1,"path":"/C:/Users/aamunger/Anaconda3","scheme":"file"},"architecture":3,"sysVersion":"3.9.7 (default, Sep 16 2021, 16:59:28) [MSC v.1916 64 bit (AMD64)]","version":{"raw":"3.9.7","major":3,"minor":9,"patch":7,"build":[],"prerelease":["final","0"]},"companyDisplayName":"ContinuumAnalytics","displayName":"Python 3.9.7 ('base')","detailedDisplayName":"Python 3.9.7 ('base': conda)","uri":{"$mid":1,"fsPath":"c:\\Users\\aamunger\\Anaconda3\\python.exe","_sep":1,"external":"file:///c%3A/Users/aamunger/Anaconda3/python.exe","path":"/C:/Users/aamunger/Anaconda3/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"}} info 10:25:03.014: Process Execution: > ~\Anaconda3\python.exe ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\vscode_datascience_helpers\kernel_interrupt_daemon.py --ppid 12808 > ~\Anaconda3\python.exe ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\vscode_datascience_helpers\kernel_interrupt_daemon.py --ppid 12808 info 10:25:03.014: Process Execution: cwd: ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\vscode_datascience_helpers cwd: ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\vscode_datascience_helpers warn 10:25:03.693: 12808 debug 10:25:03.694: Got a response of 1808 for INITIALIZE_INTERRUPT:0 info 10:25:03.708: Process Execution: > c:\venvs\.venv3\Scripts\python.exe -m ipykernel_launcher --ip=127.0.0.1 --stdin=9008 --control=9006 --hb=9005 --Session.signature_scheme="hmac-sha256" --Session.key=b"2d237659-0fae-4424-8af1-203db5a9bcee" --shell=9007 --transport="tcp" --iopub=9009 --f=c:\Users\aamunger\AppData\Roaming\jupyter\runtime\kernel-v2-12808sIyViW7cNNon.json > c:\venvs\.venv3\Scripts\python.exe -m ipykernel_launcher --ip=127.0.0.1 --stdin=9008 --control=9006 --hb=9005 --Session.signature_scheme="hmac-sha256" --Session.key=b"2d237659-0fae-4424-8af1-203db5a9bcee" --shell=9007 --transport="tcp" --iopub=9009 --f=c:\Users\aamunger\AppData\Roaming\jupyter\runtime\kernel-v2-12808sIyViW7cNNon.json info 10:25:03.708: Process Execution: cwd: c:\src\vscode-jupyter\.vscode\notebooks cwd: c:\src\vscode-jupyter\.vscode\notebooks debug 10:25:03.708: Launching kernel in kernelProcess.ts, Class name = x, completed in 4884ms, has a truthy return value, Arg 1: "c:\\src\\vscode-jupyter\\.vscode\\notebooks", Arg 2: "" info 10:25:03.991: Got env vars with python c:\Users\aamunger\Anaconda3\python.exe, with env var count 64 and custom env var count 0 in 5158ms debug 10:25:03.991: Getting activated env variables from Python, Class name = V, completed in 5158ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:25:03.991: Got env vars with python c:\Users\aamunger\Anaconda3\python.exe in 5158ms debug 10:25:16.166: KernelProcess error: c:\venvs\.venv3\lib\site-packages\traitlets\traitlets.py:2412: FutureWarning: Supporting extra quotes around strings is deprecated in traitlets 5.0. You can use 'hmac-sha256' instead of '"hmac-sha256"' if you require traitlets >=5. warn( c:\venvs\.venv3\lib\site-packages\traitlets\traitlets.py:2366: FutureWarning: Supporting extra quotes around Bytes is deprecated in traitlets 5.0. Use '2d237659-0fae-4424-8af1-203db5a9bcee' instead of 'b"2d237659-0fae-4424-8af1-203db5a9bcee"'. warn( debug 10:25:16.549: Kernel Launcher. launch, Class name = r, completed in 18130ms, has a truthy return value, Arg 1: {"kind":"startUsingPythonInterpreter","kernelSpec":{"interpreterPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","isRegisteredByVSC":"registeredByNewVersionOfExt","name":"python3913jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649","argv":["python","-m","ipykernel_launcher","-f","{connection_file}"],"language":"python","executable":"python","display_name":"Python 3.9.13 ('.venv3')","metadata":{"interpreter":{"path":"c:\\venvs\\.venv3\\Scripts\\python.exe"}},"env":{}},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"id":".jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649.c:\\venvs\\.venv3\\Scripts\\python.exe.c:\\venvs\\.venv3\\Scripts\\python.exe.-m#ipykernel_launcher"}, Arg 2: 60000, Arg 3: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 4: "c:\\src\\vscode-jupyter\\.vscode\\notebooks", Arg 5: debug 10:25:16.639: Waiting for Raw Session to be ready in postStartRawSession debug 10:25:16.640: Waiting for Raw session to be ready, currently connected debug 10:25:16.640: Raw session connected debug 10:25:16.640: Waiting for Raw session to be ready for 30s debug 10:25:16.642: Waited for Raw session to be ready & got connected debug 10:25:16.642: Successfully waited for Raw Session to be ready in postStartRawSession debug 10:25:16.643: Kernel status before requesting kernel info and after ready is unknown debug 10:25:16.643: Sending request for kernelinfo debug 10:25:16.844: KernelProcess output: NOTE: When using the `ipython kernel` entry point, Ctrl-C will not work. To exit, you will have to explicitly quit this process, by either sending "quit" from a client, or using Ctrl-\ in UNIX-like environments. To read more about this, see https://github.com/ipython/ipython/issues/2049 To connect another client to this kernel, use: --existing c:\Users\aamunger\AppData\Roaming\jupyter\runtime\kernel-v2-12808sIyViW7cNNon.json info 10:25:16.844: Kernel Output: To connect another client to this kernel, use: --existing c:\Users\aamunger\AppData\Roaming\jupyter\runtime\kernel-v2-12808sIyViW7cNNon.json debug 10:25:17.072: Got response for requestKernelInfo debug 10:25:17.072: Successfully compelted postStartRawSession info 10:25:17.075: Started Kernel .venv3 (Python 3.9.13) (pid: 26192) debug 10:25:17.081: Started running kernel initialization for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:25:17.087: Add SVG to matplotlib figure formats debug 10:25:17.087: Executing silently Code (busy) = import os as __VSCODE_os\n__VSCODE_os.environ["PYDEVD_IPYTHON_COMPATIBLE_DEBUGGING"] = "1"\ndel __VSCO debug 10:25:17.869: Executing silently Code (completed) = import os as __VSCODE_os\n__VSCODE_os.environ["PYDEVD_IPYTHON_COMPATIBLE_DEBUGGING"] = "1"\ndel __VSCO with 1 output(s) debug 10:25:17.869: Not executing startup session: Object, code: debug 10:25:17.870: Requesting Kernel info debug 10:25:17.870: Got Kernel info debug 10:25:17.870: End running kernel initialization, now waiting for idle debug 10:25:17.870: Waiting for 60000ms idle on (kernel): 8a2334cd-2506-4588-880a-86712144067b -> idle debug 10:25:17.871: Finished waiting for idle on (kernel): 8a2334cd-2506-4588-880a-86712144067b -> idle debug 10:25:17.871: End running kernel initialization, session is idle debug 10:33:46.834: Intiailize notebook communications for editor c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:33:46.834: Resolving notebook UI Comms (resolve) for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:33:46.835: initialize CommonMessageCoordinator debug 10:33:46.837: IPyWidgetScriptSource.initialize debug 10:33:46.839: Registering commtarget jupyter.widget debug 10:33:46.839: IPyWidgetMessageDispatcher.initialize debug 10:33:46.844: getDataDirsImpl, Class name = j (started execution), Arg 1: {"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:33:46.845: Get Custom Env Variables, Class name = w (started execution), Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:33:46.845: Cached data exists getEnvironmentVariables, debug 10:33:46.846: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: undefined, Arg 2: "RunPythonCode" debug 10:33:46.846: Get Jupyter Sub Paths, Class name = j, completed in 2ms, has a truthy return value, Arg 1: undefined, Return Value: debug 10:33:46.846: Get Jupyter Paths, Class name = j, completed in 2ms, has a truthy return value, , Return Value: debug 10:33:46.846: Create activated Env, Class name = _ (started execution), Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"allowEnvironmentFetchExceptions":true} debug 10:33:46.846: Getting activated env variables, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: true debug 10:33:46.846: Getting activated env variables impl, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:33:46.846: Getting activated env variables ourselves, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:33:46.847: Getting activated env variables from Python, Class name = V (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:33:46.847: Get Custom Env Variables, Class name = w (started execution), Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:33:46.847: Cached data exists getEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:33:46.847: Cached custom vars data exists getCustomEnvironmentVariables, c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:33:46.847: Get Custom Env Variables, Class name = w, completed in 0ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: "RunPythonCode" debug 10:33:46.849: Got activation Env Vars from cached promise with key \C:\SRC\VSCODE-JUPYTER_05cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 debug 10:33:46.849: Getting activated env variables ourselves, Class name = V, completed in 3ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: info 10:33:46.851: Got env vars with python c:\venvs\.venv3\Scripts\python.exe, with env var count 62 and custom env var count 0 in 4ms info 10:33:46.852: Got env vars ourselves faster c:\venvs\.venv3\Scripts\python.exe with env var count 62 in 6ms debug 10:33:46.852: Getting activated env variables from Python, Class name = V, completed in 5ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:33:46.852: Got env vars ourselves c:\venvs\.venv3\Scripts\python.exe in 6ms debug 10:33:46.852: Getting activated env variables impl, Class name = V, completed in 6ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: debug 10:33:46.852: Got env vars with python c:\venvs\.venv3\Scripts\python.exe in 6ms debug 10:33:46.852: Getting activated env variables, Class name = V, completed in 6ms, has a truthy return value, Arg 1: "/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb", Arg 2: , Arg 3: true debug 10:33:46.853: Create activated Env, Class name = _, completed in 7ms, has a truthy return value, Arg 1: {"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}},"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"allowEnvironmentFetchExceptions":true} info 10:33:46.976: Process Execution: > c:\venvs\.venv3\Scripts\python.exe ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\printJupyterDataDir.py > c:\venvs\.venv3\Scripts\python.exe ~\.vscode-insiders\extensions\ms-toolsai.jupyter-2022.9.1002781135\pythonFiles\printJupyterDataDir.py debug 10:33:48.124: getDataDirsImpl, Class name = j, completed in 1280ms, has a truthy return value, Arg 1: {"resource":{"$mid":1,"fsPath":"c:\\src\\vscode-jupyter\\.vscode\\notebooks\\CITestResults.ipynb","_sep":1,"external":"file:///c%3A/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","path":"/c:/src/vscode-jupyter/.vscode/notebooks/CITestResults.ipynb","scheme":"file"},"interpreter":{"id":"C:\\VENVS\\.VENV3\\SCRIPTS\\PYTHON.EXE","sysPrefix":"c:\\venvs\\.venv3","envType":"Venv","envName":".venv3","envPath":{"$mid":1,"fsPath":"c:\\venvs\\.venv3","_sep":1,"path":"/c:/venvs/.venv3","scheme":"file"},"architecture":3,"sysVersion":"3.9.13 (tags/v3.9.13:6de2ca5, May 17 2022, 16:36:42) [MSC v.1929 64 bit (AMD64)]","version":{"raw":"3.9.13","major":3,"minor":9,"patch":13,"build":[],"prerelease":["final","0"]},"displayName":"Python 3.9.13 ('.venv3')","detailedDisplayName":"Python 3.9.13 ('.venv3': venv)","uri":{"$mid":1,"fsPath":"c:\\venvs\\.venv3\\Scripts\\python.exe","_sep":1,"external":"file:///c%3A/venvs/.venv3/Scripts/python.exe","path":"/c:/venvs/.venv3/Scripts/python.exe","scheme":"file"}}} debug 10:33:48.404: IPyWidgetMessageDispatcher.initialize debug 10:33:48.411: Widget Message: Received IPyWidgets_kernelOptions in ScriptManager debug 10:33:48.411: Widget Message: Received IPyWidgetMessages.IPyWidgets_kernelOptions debug 10:33:48.419: IPyWidgetMessageDispatcher.initialize debug 10:33:48.419: IPyWidgetMessageDispatcher.initialize debug 10:33:48.420: Widget Message: data-base-url set to https://file%2B.vscode-resource.vscode-cdn.net/c%3A/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/tmp/scripts/cbaddd7c260f10b17bc2961eca4b2c64cab0ed6989aed5c1a7a8d9fb4726cf43/jupyter debug 10:33:48.427: Widget Message: Received IPyWidgets_kernelOptions in ScriptManager debug 10:33:48.427: Widget Message: Received IPyWidgetMessages.IPyWidgets_kernelOptions debug 10:33:48.428: Widget Message: data-base-url set to https://file%2B.vscode-resource.vscode-cdn.net/c%3A/Users/aamunger/.vscode-insiders/extensions/ms-toolsai.jupyter-2022.9.1002781135/tmp/scripts/cbaddd7c260f10b17bc2961eca4b2c64cab0ed6989aed5c1a7a8d9fb4726cf43/jupyter debug 10:56:41.497: notebook communications already initialized for editor c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:56:55.051: VSCodeNotebookController::handleExecution, Class name = j (started execution) debug 10:56:55.054: Execute Cell 3 c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:56:55.056: start the kernel, options.disableUI=false debug 10:56:55.061: Start Jupyter Session in kernel.ts with disableUI = false debug 10:56:55.171: Cell 3 executed with state Success debug 10:56:55.173: VSCodeNotebookController::handleExecution, Class name = j, completed in 122ms, has a falsy return value debug 10:56:56.614: VSCodeNotebookController::handleExecution, Class name = j (started execution) debug 10:56:56.615: Execute Cell 4 c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:56:56.616: start the kernel, options.disableUI=false debug 10:56:56.618: Start Jupyter Session in kernel.ts with disableUI = false debug 10:56:56.760: Cell 4 executed with state Success debug 10:56:56.760: VSCodeNotebookController::handleExecution, Class name = j, completed in 146ms, has a falsy return value debug 10:56:59.174: VSCodeNotebookController::handleExecution, Class name = j (started execution) debug 10:56:59.175: Execute Cell 6 c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:56:59.176: start the kernel, options.disableUI=false debug 10:56:59.177: Start Jupyter Session in kernel.ts with disableUI = false debug 10:57:02.929: Cell 6 executed with state Success debug 10:57:02.930: VSCodeNotebookController::handleExecution, Class name = j, completed in 3756ms, has a falsy return value debug 10:57:05.901: VSCodeNotebookController::handleExecution, Class name = j (started execution) debug 10:57:05.902: Execute Cell 7 c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:57:05.902: start the kernel, options.disableUI=false debug 10:57:05.903: Start Jupyter Session in kernel.ts with disableUI = false debug 10:57:06.029: Cell 7 executed with state Success debug 10:57:06.029: VSCodeNotebookController::handleExecution, Class name = j, completed in 128ms, has a falsy return value debug 10:57:08.911: VSCodeNotebookController::handleExecution, Class name = j (started execution) debug 10:57:08.912: Execute Cell 8 c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:57:08.912: start the kernel, options.disableUI=false debug 10:57:08.913: Start Jupyter Session in kernel.ts with disableUI = false debug 10:57:25.087: VS Code interrupted kernel for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:57:25.088: Command interrupted kernel for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb debug 10:57:25.089: interrupt the kernel, options.disableUI=false info 10:57:25.089: Interrupt requested c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb info 10:57:25.090: Interrupt requested & sent for c:\src\vscode-jupyter\.vscode\notebooks\CITestResults.ipynb in notebookEditor. info 10:57:25.090: Interrupt kernel execution debug 10:57:25.091: Cancel pending cells info 10:57:25.091: Interrupt kernel execution info 10:57:25.091: Interrupting kernel: python3913jvsc74a57bd005cadb55cbb23d0d156eeac1bfe39405b391b4fa73e06b1a6140e7007eb56649 info 10:57:25.091: Interrupting kernel via custom event (Win32) debug 10:57:25.093: Got a response of undefined for INTERRUPT:1 info 10:57:28.107: Cancel all remaining cells true || Error || undefined debug 10:57:28.107: Cancel pending cells debug 10:57:28.108: Cell 8 executed with state Error debug 10:57:28.109: VSCodeNotebookController::handleExecution, Class name = j, completed in 19198ms, has a falsy return value debug 10:57:43.164: Start Jupyter Session in kernel.ts with disableUI = false debug 10:57:43.167: Executing silently Code (idle) = import ipykernel\nprint(ipykernel.__version__) debug 10:57:43.188: Executing silently Code (completed) = import ipykernel\nprint(ipykernel.__version__) with 1 output(s) ```
roblourens commented 2 years ago

It looks like you don't have "jupyter.logging.level": "verbose", so the debug logs don't show up 😭

roblourens commented 2 years ago

It looks like you did an interrupt right before the time that didn't work?

roblourens commented 2 years ago

Oh, yes you said that

amunger commented 2 years ago

I already had log level at verbose for this repro - I can try to confirm if that's working correctly

roblourens commented 2 years ago

You should see a lot of messages that look like [Debug] to kernel: {"command":"variables","arguments":{"variablesReference":6},"type":"request","seq":54}

amunger commented 2 years ago

my current state seems to be caused by https://github.com/microsoft/vscode-jupyter/issues/11528