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.

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

Poor performance with semantic highlighting. #2881

Closed
CmpCtrl opened this issue Jun 1, 2022 · 19 comments
Closed

Poor performance with semantic highlighting. #2881

CmpCtrl opened this issue Jun 1, 2022 · 19 comments
Labels
fixed in next version (main) A fix has been implemented and will appear in an upcoming version

Comments

@CmpCtrl
Copy link

CmpCtrl commented Jun 1, 2022

Environment data

  • Language Server version: 2022.5.3
  • OS and version: win32 x64
  • Python version (and distribution if applicable, e.g. Anaconda):
  • python.analysis.indexing: null
  • python.analysis.typeCheckingMode: off

Expected behaviour

I expect semantic highlighting to be sub second performance.

** Edited to correct my mistake of referring to syntax highlighting when i really mean semantic highlighting **

Actual behaviour

Im working on a package with several modules in it. Two of the modules seem to have very poor performance in Pylance, one taking around 5s and another taking around 2-3s. So the total time for semantic highlighting ends up near 10s. Clearly i've got something wrong in these 2 files. The first is around 3600 lines of code, the second around 1000. I noticed the slowdown last week, but haven't chased it much until now. I've been working on the files, so i cant rule out a change i made, nor can i recall if it started with an update to something.

Unfortunately i cant share this code, so i am looking for some more tips on how to diagnose where the slowdown is.

I looked thru the log trace and didnt see anything that stuck out except for the lines below. It seems like the majority of the lines in the log happen fast except for these.

Thanks for the help.

Logs

Python Language Server Log

[Info  - 9:40:41 AM] (18820) Pylance language server 2022.5.3 (pyright 73c82fab) starting
[Info  - 9:40:41 AM] (18820) Server root directory: c:\Users\ \.vscode\extensions\ms-python.vscode-pylance-2022.5.3\dist
Notebook support: Legacy
[Info  - 9:40:41 AM] (18820) No configuration file found.
[Info  - 9:40:41 AM] (18820) No pyproject.toml file found.
[Info  - 9:40:41 AM] (18820) Setting pythonPath for service "ccg": "c:\Users\ \CCG\ccg\.venv310\Scripts\python.exe"
[Warn  - 9:40:41 AM] (18820) stubPath c:\Users\ \CCG\ccg\typings is not a valid directory.
[Info  - 9:40:42 AM] (18820) Assuming Python version 3.10
[Info  - 9:40:42 AM] (18820) Assuming Python platform Windows
[Info  - 9:40:43 AM] (18820) Searching for source files
[Info  - 9:40:43 AM] (18820) Found 34 source files
[Info  - 9:40:43 AM] (18820) Background analysis(1) root directory: c:\Users\ \.vscode\extensions\ms-python.vscode-pylance-2022.5.3\dist
[Info  - 9:40:43 AM] (18820) Background analysis(1) started

[Info  - 1:24:20 PM] (18820) [BG(1)] Long operation: checking: c:\Users\ \CCG\ccg\ccg\data.py (4392ms)
[Info  - 1:24:20 PM] (18820) [BG(1)] Long operation: analyzing: c:\Users\ \CCG\ccg\ccg\data.py (4392ms)
[Info  - 1:24:44 PM] (18820) [BG(1)] Long operation: checking: c:\Users\ \CCG\ccg\ccg\data.py (4495ms)
[Info  - 1:24:44 PM] (18820) [BG(1)] Long operation: analyzing: c:\Users\ \CCG\ccg\ccg\data.py (4495ms)
[Info  - 1:24:46 PM] (18820) [BG(1)] Long operation: getSemanticTokens delta previousResultId:1654104260807 at c:\Users\ \CCG\ccg\ccg\util.py (2051ms)
[Info  - 1:25:16 PM] (18820) [BG(1)] Long operation: getSemanticTokens delta previousResultId:1654104284557 at c:\Users\ \CCG\ccg\ccg\util.py (3260ms)

Code Snippet / Additional information

@github-actions github-actions bot added the triage label Jun 1, 2022
@judej judej added the needs investigation Could be an issue - needs investigation label Jun 1, 2022
@github-actions github-actions bot removed the triage label Jun 1, 2022
@erictraut
Copy link
Contributor

Here are a couple of ways we might be able to approach this problem.

First, if you'd be willing to give me temporary access to a private github repo which contains the file(s) that exhibit the problem, I could look into the perf issue.

If that's not feasible, I'll need to ask you to do some additional work to narrow down the problem. Based on the logging, the perf issue appears to be related to the file data.py or one of the files it imports. If you comment out parts of the code in data.py, you should be able to quickly narrow down the portion that is resulting in long analysis times. Common causes of long analysis times include things like complex expressions, long chains of if/elif/else statements within deeply nested loops or large numbers (hundreds) of local variables within a scope.

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 2, 2022

@erictraut, Thank you for the tips and the offer for help. For some reason i was stuck with the paradigm that the code would need to be able to run to test subsets of it, so i was daunted at the prospect of testing that way. Clearly that's not the case, and it is easy to test subsets of it by commenting sections.

Anyway, commenting blocks of the data.py seemed to help the checking and analyzing time roughly(really roughly) linearly, but commenting the import numpy as np dropped it out of the long operation warnings. I use numpy extensively, so i will need to dig some more into if there is a particular pattern I'm using that is bad.

This makes me suspect that the slowdown is related to an update somewhere since i've been using numpy extensively in this package for a while, but the slowdown happened sometime last week.

@erictraut
Copy link
Contributor

Make sure you're using recent versions of numpy. Earlier versions had no type information, so all types needed to be inferred from the source, which was expensive. The numpy maintainers have started to add type annotations.

The latest published version of numpy (1.22.4) has a "type completeness score" of 27.2%. That means about a quarter of the symbols that comprise its public interface are fully annotated. That may sound low, but they've started with the most commonly-used functionality. It's possible that you're using some aspect of numpy that is not yet annotated, and that might contribute to performance issues because the types need to be inferred if they are not annotated.

Let me know if you narrow it down any further.

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 2, 2022

Copy that, i tried updating everything to the latest, and spent a bunch of time cleaning up the type hints related to numpy but that only made marginal if any gains in the performance. I'll keep an eye out for issues, but im running short on ideas. Thanks,

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 7, 2022

I got a cleaner log output this morning where i only opened the simpler of the 2 problem files. I'm not sure what to be looking for in this trace, when i looked before the only long times i saw reported were on the Checking and Analyzing of my problem files. Its not clear how these times stack up to get the total time.
Now i see that there are several lines report Could not import... i'll try to chase those a little.
Any other suggestions/insights from these logs?

[Info  - 8:27:13 AM] (25972) Pylance language server 2022.6.0 (pyright c6e1d8dd) starting
[Info  - 8:27:13 AM] (25972) Server root directory: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist
Notebook support: Legacy
[Info  - 8:27:13 AM] (25972) No configuration file found.
[Info  - 8:27:13 AM] (25972) No pyproject.toml file found.
[Info  - 8:27:13 AM] (25972) Setting pythonPath for service "ccg": "c:\Users\...\CCG\ccg\.venv310\Scripts\python.exe"
[Warn  - 8:27:13 AM] (25972) stubPath c:\Users\...\CCG\ccg\typings is not a valid directory.
[Info  - 8:27:13 AM] (25972) Assuming Python version 3.10
[Info  - 8:27:13 AM] (25972) Assuming Python platform Windows
[Info  - 8:27:13 AM] (25972) Search paths for c:\Users\...\CCG\ccg
[Info  - 8:27:13 AM] (25972)   c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\typings
[Info  - 8:27:13 AM] (25972)   c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stubs\...
[Info  - 8:27:13 AM] (25972)   c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs
[Info  - 8:27:13 AM] (25972)   c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs
[Info  - 8:27:13 AM] (25972)   c:\Users\...\AppData\Local\Programs\Python\Python310\Lib
[Info  - 8:27:13 AM] (25972)   c:\Users\...\AppData\Local\Programs\Python\Python310
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\.venv310
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\.venv310\Lib\site-packages
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib
[Info  - 8:27:13 AM] (25972)   c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin
[Info  - 8:27:13 AM] (25972) Adding fs watcher for library directories:
 C:\Users\...\AppData\Local\Programs\Python\Python310\DLLs
C:\Users\...\AppData\Local\Programs\Python\Python310\lib
C:\Users\...\AppData\Local\Programs\Python\Python310
c:\Users\...\CCG\ccg\.venv310
c:\Users\...\CCG\ccg\.venv310\lib\site-packages
c:\Users\...\CCG\ccg\.venv310\lib\site-packages\win32
c:\Users\...\CCG\ccg\.venv310\lib\site-packages\win32\lib
c:\Users\...\CCG\ccg\.venv310\lib\site-packages\Pythonwin
[Info  - 8:27:13 AM] (25972) Adding fs watcher for directories:
 c:\Users\...\CCG\ccg
[Info  - 8:27:13 AM] (25972) Searching for source files
[Info  - 8:27:13 AM] (25972) Found 21 source files
[Info  - 8:27:13 AM] (25972) Background analysis(1) root directory: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist
[Info  - 8:27:13 AM] (25972) Background analysis(1) started
(25972) Background analysis message: setConfigOptions
(25972) Background analysis message: setImportResolver
(25972) Background analysis message: ensurePartialStubPackages
(25972) Background analysis message: setTrackedFiles
(25972) Background analysis message: markAllFilesDirty
(25972) Background analysis message: analyze
(25972) [IDX(FG)] index libraries c:\Users\...\CCG\ccg (index) ...
(25972) [IDX(FG)]   read stdlib indices (36ms)
(25972) [IDX(FG)] index libraries c:\Users\...\CCG\ccg (index) [succeed] (37ms)
(25972) [FG] parsing: c:\Users\...\CCG\ccg\ccg\util.py (166ms)
(25972) [FG] parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\builtins.pyi [fs read 1ms] (74ms)
(25972) [FG] binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\builtins.pyi (41ms)
(25972) [FG] binding: c:\Users\...\CCG\ccg\ccg\util.py (11ms)
(25972) Background analysis message: setFileOpened
(25972) Background analysis message: analyze
(25972) [BG(1)] analyzing: c:\Users\...\CCG\ccg\ccg\util.py ...
(25972) [BG(1)]   parsing: c:\Users\...\CCG\ccg\ccg\util.py (173ms)
(25972) [BG(1)]   parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\builtins.pyi [fs read 2ms] (67ms)
(25972) [BG(1)]   binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\builtins.pyi (31ms)
(25972) [BG(1)]   binding: c:\Users\...\CCG\ccg\ccg\util.py (13ms)
(25972) [BG(1)]   checking: c:\Users\...\CCG\ccg\ccg\util.py ...
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\typing_extensions.pyi [fs read 1ms] (8ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\typing_extensions.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\typing.pyi [fs read 4ms] (17ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\typing.pyi (14ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_typeshed\__init__.pyi [fs read 0ms] (12ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_typeshed\__init__.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\types.pyi [fs read 1ms] (15ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\types.pyi (5ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\abc.pyi [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\abc.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\__future__.pyi [fs read 0ms] (0ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\__future__.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\__init__.pyi [fs read 7ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\__init__.pyi ...
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\base_events.pyi [fs read 7ms] (21ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\base_events.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\coroutines.pyi [fs read 6ms] (7ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\coroutines.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\events.pyi [fs read 7ms] (16ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\events.pyi (5ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\futures.pyi [fs read 7ms] (19ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\futures.pyi (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\locks.pyi [fs read 8ms] (13ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\locks.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\protocols.pyi [fs read 7ms] (8ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\protocols.pyi (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\queues.pyi [fs read 8ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\queues.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\streams.pyi [fs read 7ms] (10ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\streams.pyi (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\subprocess.pyi [fs read 9ms] (12ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\subprocess.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\tasks.pyi [fs read 9ms] (14ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\tasks.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\transports.pyi [fs read 8ms] (11ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\transports.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\runners.pyi [fs read 6ms] (6ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\runners.pyi (6ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\exceptions.pyi [fs read 5ms] (5ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\exceptions.pyi (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\threads.pyi [fs read 5ms] (6ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\threads.pyi (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\windows_events.pyi [fs read 6ms] (8ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\windows_events.pyi (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\asyncio\__init__.pyi (192ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\colorsys.pyi [fs read 5ms] (6ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\colorsys.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\datetime.pyi [fs read 1ms] (5ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\datetime.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\json\__init__.pyi [fs read 1ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\json\__init__.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\logging\__init__.pyi [fs read 0ms] (8ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\logging\__init__.pyi (3ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\pathlib.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\pathlib.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\os\__init__.pyi [fs read 0ms] (9ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\os\__init__.pyi (4ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\sys.pyi [fs read 6ms] (8ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\sys.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\numbers.pyi [fs read 5ms] (6ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\numbers.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\collections\__init__.pyi [fs read 0ms] (4ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\collections\__init__.pyi (3ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\collections\abc.pyi [fs read 5ms] (5ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\collections\abc.pyi ...
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_collections_abc.pyi [fs read 1ms] (1ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_collections_abc.pyi (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\collections\abc.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\__init__.pyi [fs read 1ms] (106ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\__init__.pyi (16ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\__init__.py [fs read 1ms] (5ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\__init__.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\__init__.py [fs read 7ms] (19ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\__init__.py ...
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_base.py [fs read 10ms] (25ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_base.py (6ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_csr.py [fs read 6ms] (10ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_csr.py (3ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_csc.py [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_csc.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_lil.py [fs read 7ms] (13ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_lil.py (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_dok.py [fs read 6ms] (18ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_dok.py (3ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_coo.py [fs read 9ms] (14ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_coo.py (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_dia.py [fs read 8ms] (11ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_dia.py (3ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_bsr.py [fs read 7ms] (14ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_bsr.py (5ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_construct.py [fs read 9ms] (21ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_construct.py (3ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_extract.py [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_extract.py (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_matrix_io.py [fs read 6ms] (8ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_matrix_io.py (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\__init__.py (182ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\__init__.py [fs read 7ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\__init__.py ...
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\__init__.py [fs read 6ms] (7ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\__init__.py ...
(25972) [BG(1)]         parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\iterative.py [fs read 11ms] (19ms)
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\iterative.py (4ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\__init__.py (23ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\__init__.py [fs read 5ms] (6ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\__init__.py ...
(25972) [BG(1)]         parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\linsolve.py [fs read 8ms] (19ms)
[Info  - 8:27:32 AM] (25972) Could not import 'scikits.umfpack' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\linsolve.py'
[Info  - 8:27:32 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
[Info  - 8:27:32 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\linsolve.py (4ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_dsolve\__init__.py (23ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_interface.py [fs read 9ms] (20ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_interface.py (10ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\__init__.py [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\__init__.py ...
(25972) [BG(1)]         parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\arpack\__init__.py [fs read 7ms] (7ms)
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\arpack\__init__.py ...
(25972) [BG(1)]           parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\arpack\arpack.py [fs read 10ms] (20ms)
(25972) [BG(1)]           binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\arpack\arpack.py (7ms)
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\arpack\__init__.py (27ms)
(25972) [BG(1)]         parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\lobpcg\__init__.py [fs read 7ms] (8ms)
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\lobpcg\__init__.py ...
(25972) [BG(1)]           parsing: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\lobpcg\lobpcg.pyi [fs read 6ms] (7ms)
(25972) [BG(1)]           binding: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\lobpcg\lobpcg.pyi (0ms)
(25972) [BG(1)]         binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\lobpcg\__init__.py (7ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_eigen\__init__.py (49ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_matfuncs.py [fs read 8ms] (16ms)
[Info  - 8:27:32 AM] (25972) Could not import 'sparse' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_matfuncs.py'
[Info  - 8:27:32 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
[Info  - 8:27:32 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_matfuncs.py (4ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_onenormest.py [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_onenormest.py (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_norm.py [fs read 5ms] (7ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_norm.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_expm_multiply.py [fs read 8ms] (15ms)
[Info  - 8:27:32 AM] (25972) Could not import 'sparse' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_expm_multiply.py'
[Info  - 8:27:32 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:32 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:32 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:32 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:32 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
[Info  - 8:27:32 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:32 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:32 AM] (25972)   Typeshed path not found
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_expm_multiply.py (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\__init__.py (205ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\__init__.py [fs read 9ms] (14ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\__init__.py ...
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_misc.py [fs read 6ms] (10ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_misc.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_cythonized_array_utils.pyi [fs read 5ms] (6ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_cythonized_array_utils.pyi (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_basic.py [fs read 20ms] (38ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_basic.py (6ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp.py [fs read 14ms] (25ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp.py (4ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_lu.py [fs read 8ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_lu.py (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_ldl.py [fs read 13ms] (15ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_ldl.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_cholesky.py [fs read 15ms] (19ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_cholesky.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_qr.py [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_qr.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_qz.py [fs read 8ms] (11ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_qz.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_svd.py [fs read 11ms] (14ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_svd.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_schur.py [fs read 8ms] (12ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_schur.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_polar.py [fs read 8ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_polar.py (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_matfuncs.py [fs read 9ms] (15ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_matfuncs.py (1ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\blas.py [fs read 7ms] (10ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\blas.py ...
(25972) [BG(1)]         parsing: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_fblas.pyi [fs read 6ms] (22ms)
(25972) [BG(1)]         binding: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_fblas.pyi (3ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\blas.py (26ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\lapack.py [fs read 13ms] (18ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\lapack.py ...
(25972) [BG(1)]         parsing: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_flapack.pyi [fs read 25ms] (56ms)
(25972) [BG(1)]         binding: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_flapack.pyi (9ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\lapack.py (67ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_special_matrices.py [fs read 15ms] (25ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_special_matrices.py (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_solvers.py [fs read 12ms] (16ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_solvers.py (2ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_procrustes.py [fs read 6ms] (6ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_procrustes.py (0ms)
(25972) [BG(1)]       parsing: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_update.pyi [fs read 7ms] (8ms)
(25972) [BG(1)]       binding: [virtual] c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_update.pyi (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_sketches.py [fs read 6ms] (7ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_sketches.py (0ms)
(25972) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_cossin.py [fs read 6ms] (8ms)
(25972) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\_decomp_cossin.py (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\linalg\__init__.py (408ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\ccg\__init__.py [fs read 0ms] (0ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\ccg\__init__.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_dtype_like.py [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_dtype_like.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_generic_alias.py [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_generic_alias.py (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_shape.py [fs read 1ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_shape.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\fromnumeric.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\fromnumeric.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_array_like.py [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_array_like.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_nested_sequence.py [fs read 1ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_nested_sequence.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\multiarray.pyi [fs read 0ms] (4ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\multiarray.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_nbit.py [fs read 0ms] (0ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_nbit.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\function_base.pyi [fs read 0ms] (4ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\function_base.pyi (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_scalars.py [fs read 0ms] (0ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_scalars.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\shape_base.pyi [fs read 8ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\shape_base.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\array.pyi [fs read 1ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\array.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\mmap.pyi [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\mmap.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\ctypes\__init__.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\ctypes\__init__.pyi (3ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\pickle.pyi [fs read 1ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\pickle.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\enum.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\enum.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\json\decoder.pyi [fs read 1ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\json\decoder.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\io.pyi [fs read 1ms] (3ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\io.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\ccg\data.py [fs read 0ms] (52ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\ccg\data.py (20ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\atexit.pyi [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\atexit.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler.py [fs read 0ms] (13ms)
[Info  - 8:27:34 AM] (25972) Could not import 'cPickle' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler.py'
[Info  - 8:27:34 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
[Info  - 8:27:34 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
[Info  - 8:27:34 AM] (25972) Could not import 'cStringIO' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler.py'
[Info  - 8:27:34 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
[Info  - 8:27:34 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
[Info  - 8:27:34 AM] (25972) Could not import '__builtin__' in file 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler.py'
[Info  - 8:27:34 AM] (25972)   Looking in stubPath 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\typings'
[Info  - 8:27:34 AM] (25972)   Looking in root directory of execution environment 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\DLLs'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310\Lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\AppData\Local\Programs\Python\Python310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\win32\lib'
[Info  - 8:27:34 AM] (25972)   Looking in python search path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\pythonwin'
[Info  - 8:27:34 AM] (25972)   Looking in bundled stubs path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve stub package using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\bundled\stubs'
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stdlib path
[Info  - 8:27:34 AM] (25972)   Attempting to resolve using root path 'c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib'
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
[Info  - 8:27:34 AM] (25972)   Looking for typeshed third-party path
[Info  - 8:27:34 AM] (25972)   Looking for typeshed stubs path
[Info  - 8:27:34 AM] (25972)   Typeshed path not found
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler.py (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\ccg\par.py [fs read 12ms] (20ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\ccg\par.py (11ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\copy.pyi [fs read 1ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\copy.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\__init__.py [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\__init__.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler_py35.py [fs read 0ms] (0ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\line_profiler\line_profiler_py35.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\functools.pyi [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\functools.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_char_codes.py [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_char_codes.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\math.pyi [fs read 1ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\math.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\numeric.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\numeric.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_ufunc.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_ufunc.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\statistics.pyi [fs read 0ms] (3ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\statistics.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stubs\xxhash\xxhash.pyi [fs read 5ms] (7ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stubs\xxhash\xxhash.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\hashlib.pyi [fs read 5ms] (6ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\hashlib.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\nanfunctions.pyi [fs read 6ms] (7ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\nanfunctions.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\utils.pyi [fs read 8ms] (9ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\utils.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\numerictypes.pyi [fs read 7ms] (9ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\numerictypes.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\index_tricks.pyi [fs read 0ms] (1ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\index_tricks.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_arrays.py [fs read 6ms] (8ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_arrays.py (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_compressed.py [fs read 9ms] (19ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_compressed.py (4ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_data.py [fs read 7ms] (9ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_data.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_index.py [fs read 8ms] (11ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_index.py (2ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_sputils.py [fs read 7ms] (9ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_sputils.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi [fs read 8ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi ...
(25972) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_operator.pyi [fs read 7ms] (9ms)
(25972) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_operator.pyi (1ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi (10ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\warnings.pyi [fs read 10ms] (12ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\warnings.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_warnings.pyi [fs read 6ms] (6ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_warnings.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\arraysetops.pyi [fs read 0ms] (2ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\arraysetops.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\_lib\_util.py [fs read 9ms] (23ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\_lib\_util.py (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\shape_base.pyi [fs read 5ms] (5ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\shape_base.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\twodim_base.pyi [fs read 6ms] (7ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\twodim_base.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\linalg\__init__.pyi [fs read 5ms] (7ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\linalg\__init__.pyi (0ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\linalg\linalg.pyi [fs read 6ms] (7ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\linalg\linalg.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\re.pyi [fs read 1ms] (4ms)
(25972) [BG(1)]     binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\re.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_callable.pyi [fs read 8ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_callable.pyi (1ms)
(25972) [BG(1)]     parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\lsqr.py [fs read 8ms] (10ms)
(25972) [BG(1)]     binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\linalg\_isolve\lsqr.py (1ms)
(25972) [BG(1)]   checking: c:\Users\...\CCG\ccg\ccg\util.py (5149ms)
[Info  - 8:27:37 AM] (25972) [BG(1)] Long operation: checking: c:\Users\...\CCG\ccg\ccg\util.py (5149ms)
(25972) [BG(1)] analyzing: c:\Users\...\CCG\ccg\ccg\util.py (5437ms)
[Info  - 8:27:37 AM] (25972) [BG(1)] Long operation: analyzing: c:\Users\...\CCG\ccg\ccg\util.py (5437ms)
(25972) Background analysis message: getSemanticTokens full
(25972) [BG(1)] getSemanticTokens full at c:\Users\...\CCG\ccg\ccg\util.py (124ms)
(25972) Background analysis message: getDiagnosticsForRange
(25972) Background analysis message: getDiagnosticsForRange
(25972) Background analysis message: getSemanticTokens range
(25972) [BG(1)] getSemanticTokens range 0:0 - 85:0 at c:\Users\...\CCG\ccg\ccg\util.py (10ms)
(25972) Background analysis message: resumeAnalysis
(25972) Background analysis message: getDiagnosticsForRange
(25972) Background analysis message: getDiagnosticsForRange
(25972) Background analysis message: getDiagnosticsForRange


@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 7, 2022

Ok it seems that the Could not import ... warnings aren't really relevant, at least not to the script. Those seem to mostly come from optional imports.
I also now see how the indenting indicates the times that get accumulated on a latter line, so i tried to add up all the larger times to see if it checks with the overall reported time. In a slightly different case from that shown above i came up with around 1200ms, skipping lots of quick lines, so id estimate it to be 1500ms - ish, but it reported 6100ms. So it seems that whatever is taking the majority of the time isn't being reported in this log. Or i am misinterpreting it.

Anyway, i would appreciate any further tips on what to check for.

@erictraut
Copy link
Contributor

Thanks for posting the logs. Unfortunately, I don't see any clues that help get us closer to understanding the problem.

Here's the next thing you can try. Add the following to the settings.json file for your project:

  "python.analysis.logLevel": "Trace",
  "python.analysis.logTypeEvaluationTime": true,

Then open the file c:\Users\...\CCG\ccg\ccg\util.py in the editor. You should see much more verbose logging in the Output window. It should help us narrow down the part of the code that is taking up the majority of the time.

When you're done with the experiment, make sure to remove the above two lines from your settings.

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 7, 2022

Thanks for the tip.

It seems like the worst offending line is the following which is making use of scipy sparse arrays which are new in scipy 1.8.0.

    model_matrix = scipy.sparse.csr_array(
        (intf_array, (rows, ind_array)),
        shape=(n_samples, n_grid),
    )
(23860) [BG(1)]   isNodeReachable ...
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_arrays.py [fs read 1ms] (1ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_arrays.py (1ms)
(23860) [BG(1)]     import lookup [scipy.sparse._arrays] (2ms) [f:1, t:0, p:0, i:0, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_compressed.py [fs read 1ms] (9ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_compressed.py (4ms)
(23860) [BG(1)]     import lookup [scipy.sparse._compressed] (13ms) [f:1, t:2, p:5, i:1, b:4]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_data.py [fs read 0ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_data.py (1ms)
(23860) [BG(1)]     import lookup [scipy.sparse._data] (3ms) [f:0, t:1, p:1, i:0, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_index.py [fs read 0ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_index.py (1ms)
(23860) [BG(1)]     import lookup [scipy.sparse._index] (3ms) [f:0, t:1, p:1, i:0, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_sputils.py [fs read 0ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\sparse\_sputils.py (1ms)
(23860) [BG(1)]     import lookup [scipy.sparse._sputils] (3ms) [f:0, t:1, p:1, i:0, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi [fs read 0ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi ...
(23860) [BG(1)]         parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_operator.pyi [fs read 0ms] (1ms)
(23860) [BG(1)]         binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_operator.pyi (1ms)
(23860) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\operator.pyi (2ms)
(23860) [BG(1)]     import lookup [operator] (4ms) [f:0, t:2, p:0, i:1, b:2]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\warnings.pyi [fs read 1ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\warnings.pyi (1ms)
(23860) [BG(1)]     import lookup [warnings] (3ms) [f:1, t:0, p:0, i:1, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_warnings.pyi [fs read 0ms] (1ms)
(23860) [BG(1)]       binding: c:\Users\...\.vscode\extensions\ms-python.vscode-pylance-2022.6.0\dist\typeshed-fallback\stdlib\_warnings.pyi (0ms)
(23860) [BG(1)]     import lookup [_warnings] (1ms) [f:0, t:0, p:1, i:0, b:0]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\arraysetops.pyi [fs read 1ms] (2ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\arraysetops.pyi (1ms)
(23860) [BG(1)]     import lookup [numpy.lib.arraysetops] (3ms) [f:1, t:0, p:1, i:0, b:1]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\_lib\_util.py [fs read 0ms] (15ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\scipy\_lib\_util.py (2ms)
(23860) [BG(1)]     import lookup [scipy._lib._util] (17ms) [f:0, t:1, p:5, i:9, b:2]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\shape_base.pyi [fs read 0ms] (1ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\core\shape_base.pyi (0ms)
(23860) [BG(1)]     import lookup [numpy.core.shape_base] (1ms) [f:0, t:1, p:0, i:0, b:0]
(23860) [BG(1)]   isNodeReachable ["model_matrix" (ccg.util)] (531ms) [f:4, t:9, p:15, i:12, b:14]

Another interesting one is np.newaxis, which i would have thought would be pretty commonly used.

points = points[:, np.newaxis]
(23860) [BG(1)]   getDeclarationsForNameNode ["newaxis" (ccg.util)] (178ms)

This is curious too, I use list.append() a lot so its hard to tell which instance this refers to.

23860) [BG(1)]   getDeclarationsForNameNode ...
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\function_base.pyi [fs read 0ms] (5ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\lib\function_base.pyi (2ms)
(23860) [BG(1)]     import lookup [numpy.lib.function_base] (8ms) [f:0, t:1, p:3, i:1, b:2]
(23860) [BG(1)]     import lookup ...
(23860) [BG(1)]       parsing: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_scalars.py [fs read 0ms] (1ms)
(23860) [BG(1)]       binding: c:\Users\...\CCG\ccg\.venv310\Lib\site-packages\numpy\typing\_scalars.py (0ms)
(23860) [BG(1)]     import lookup [numpy.typing._scalars] (1ms) [f:0, t:0, p:1, i:0, b:0]
(23860) [BG(1)]   getDeclarationsForNameNode ["append" (ccg.util)] (289ms) [f:0, t:1, p:4, i:1, b:2]

@erictraut
Copy link
Contributor

I don't see anything obviously wrong here.

I'm happy to dig into it deeper, but I'll need a self-contained sample that I can use to repro locally. If you're willing to give me temporary private access to your repo, I could diagnose directly. Or if you want to set up a temporary repo that contains simplified or redacted versions, that would work as well.

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 7, 2022

@erictraut I appreciate the help. I'll make up a simplified repo and give you access.

@bschnurr
Copy link
Member

bschnurr commented Jun 7, 2022

We've had issues with scipy in the pasts. previously
we wrote partial stubs.. most likely we need to add scipy.sparse.csr_array

@bschnurr bschnurr added needs stub and removed needs investigation Could be an issue - needs investigation labels Jun 9, 2022
@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 13, 2022

@erictraut Just checking in if you've had a chance to look at this, i've tried to share a simplified version of the repo with you. Again, thanks for the help.

@erictraut
Copy link
Contributor

@CmpCtrl, I didn't receive an invitation from github, so I wasn't aware that you had created a simplified repro. Could you confirm that I have access to the repo. If so, perhaps you could try sending the invitation again?

@erictraut
Copy link
Contributor

@CmpCtrl, I received your github invite. Thanks for the repro. I'll look at it when I have time, probably later this week.

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 14, 2022

Copy that, thanks for the help.

@bschnurr
Copy link
Member

you can try disabling semantic highlighting.

"editor.semanticHighlighting.enabled": false,

@CmpCtrl
Copy link
Author

CmpCtrl commented Jun 30, 2022

I realize that i've not been making a clear distinction (either in my head or in these comments/issues) between syntax highlighting and semantic highlighting and what I'm concerned with is the performance of the semantic highlighting. I apologize for the confusion.

I've posted a gif in the microsoft/pyright#3582 of the slow performance that I'm hoping to improve.

@CmpCtrl CmpCtrl changed the title Poor performance with syntax highlighting. Poor performance with semantic highlighting. Jun 30, 2022
@erictraut erictraut added fixed in next version (main) A fix has been implemented and will appear in an upcoming version and removed needs stub labels Jul 19, 2022
@erictraut
Copy link
Contributor

I've introduced several more rounds of optimizations to pyright that incrementally improve performance for this code. Overall, I cut the time in roughly half. For more details, refer to the tracking bug in pyright.

@heejaechang
Copy link
Contributor

This issue has been fixed in version 2022.7.41, which we've just released. You can find the changelog here: CHANGELOG.md

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
fixed in next version (main) A fix has been implemented and will appear in an upcoming version
Projects
None yet
Development

No branches or pull requests

5 participants