390 lines
29 KiB
Plaintext
390 lines
29 KiB
Plaintext
========================================================================
|
|
上次编译状态: 成功 总耗时: 501.25s
|
|
PROF 综合分析报告 生成时间: 1787069174.1244113
|
|
主进程 prof: 1 个, worker prof: 43 个
|
|
总函数调用 115119581 次, 总 tottime 610.6s
|
|
========================================================================
|
|
|
|
【一】Top 40 热点函数 (tottime = 真实 CPU 消耗, 优先优化)
|
|
------------------------------------------------------------------------
|
|
Wed Aug 19 00:01:32 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\main_prof_45008.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_12728_1.prof
|
|
Wed Aug 19 00:00:10 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_12728_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_1.prof
|
|
Wed Aug 19 00:00:06 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_2.prof
|
|
Wed Aug 19 00:00:15 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14748_1.prof
|
|
Wed Aug 19 00:00:13 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14748_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_1.prof
|
|
Wed Aug 19 00:00:05 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_2.prof
|
|
Wed Aug 19 00:00:10 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_3188_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_3188_2.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_2.prof
|
|
Wed Aug 19 00:00:20 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_2.prof
|
|
Wed Aug 19 00:00:17 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_2.prof
|
|
Wed Aug 19 00:00:25 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_2.prof
|
|
Wed Aug 19 00:00:30 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_3.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_2.prof
|
|
Wed Aug 19 00:00:20 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_3.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_1.prof
|
|
Wed Aug 19 00:00:06 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_2.prof
|
|
Wed Aug 19 00:00:12 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_2.prof
|
|
Wed Aug 19 00:00:15 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60724_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60724_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_2.prof
|
|
Wed Aug 19 00:00:13 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_2.prof
|
|
Wed Aug 19 00:00:32 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_7536_1.prof
|
|
Wed Aug 19 00:00:11 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_7536_2.prof
|
|
|
|
117198624 function calls (115119581 primitive calls) in 610.649 seconds
|
|
|
|
Ordered by: internal time
|
|
List reduced from 1597 to 40 due to restriction <40>
|
|
|
|
ncalls tottime percall cumtime percall filename:lineno(function)
|
|
328/225 347.601 1.060 340.376 1.513 {built-in method _winapi.WaitForMultipleObjects}
|
|
8673/8497 35.909 0.004 3.930 0.000 {method 'read' of '_io.TextIOWrapper' objects}
|
|
1566897 32.755 0.000 34.355 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Nodes.py:314(_Init)
|
|
1681 9.850 0.006 44.109 0.026 {built-in method vast_c.parse}
|
|
5992065 9.808 0.000 21.155 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Utils.py:25(iter_child_nodes)
|
|
37941 8.858 0.000 9.456 0.000 {method 'sub' of 're.Pattern' objects}
|
|
22279914 8.469 0.000 8.471 0.000 {built-in method builtins.isinstance}
|
|
102 8.264 0.081 11.625 0.114 {built-in method _pickle.loads}
|
|
43 7.662 0.178 17.425 0.405 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\LLVMCG\StructGen.py:134(finalize)
|
|
9768/9762 7.574 0.001 8.010 0.001 {built-in method _io.open}
|
|
14754 7.149 0.000 7.149 0.000 {built-in method nt._path_isfile}
|
|
2645472 5.942 0.000 30.949 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Utils.py:36(walk)
|
|
7476487 5.586 0.000 8.417 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Utils.py:16(iter_fields)
|
|
16891112 5.172 0.000 5.172 0.000 {method 'startswith' of 'str' objects}
|
|
2638676 4.169 0.000 23.733 0.000 {method 'extend' of 'collections.deque' objects}
|
|
6776 4.058 0.001 4.058 0.001 {built-in method nt._path_isdir}
|
|
6966982/6694056 3.969 0.000 4.322 0.000 {built-in method builtins.getattr}
|
|
256646/41890 3.463 0.000 3.953 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Utils.py:65(_format)
|
|
43 3.360 0.078 3.361 0.078 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\SymbolTable.py:43(__setstate__)
|
|
1 3.117 3.117 26.021 26.021 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:2401(_compile_include_py_files)
|
|
127184 2.983 0.000 3.315 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\Handles\HandlesBase.py:98(__init__)
|
|
78599 2.495 0.000 3.410 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:411(_count_braces_outside_strings)
|
|
5594722 2.429 0.000 2.429 0.000 {method 'split' of 'str' objects}
|
|
108/26 2.365 0.022 0.688 0.026 {built-in method _winapi.CreateProcess}
|
|
8524640/8521367 2.046 0.000 2.048 0.000 {built-in method builtins.len}
|
|
2/1 1.858 0.929 62.458 62.458 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:606(run)
|
|
86 1.765 0.021 2.443 0.028 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:947(_find_all_type_refs)
|
|
2981 1.721 0.001 1.721 0.001 {built-in method nt.stat}
|
|
1342030 1.474 0.000 1.926 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\Handles\HandlesBase.py:49(__get__)
|
|
382 1.467 0.004 1.467 0.004 {built-in method _winapi.CopyFile2}
|
|
483183/117 1.285 0.000 4.300 0.037 D:\Python312\Lib\copy.py:118(deepcopy)
|
|
2639795 1.236 0.000 1.236 0.000 {method 'popleft' of 'collections.deque' objects}
|
|
9588 1.223 0.000 1.223 0.000 {method '__exit__' of '_io._IOBase' objects}
|
|
284 1.215 0.004 1.215 0.004 {built-in method nt.remove}
|
|
239 1.157 0.005 1.157 0.005 {built-in method nt.unlink}
|
|
41890 1.057 0.000 5.022 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\Utils.py:47(dump)
|
|
439 1.050 0.002 16.621 0.038 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Utils.py:91(get_file_dependencies)
|
|
41890/33133 1.044 0.000 15.450 0.000 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\Handles\HandlesTypeMerge.py:36(_GetCTypeInfoInternal)
|
|
1845179 1.035 0.000 1.035 0.000 {method 'get' of 'dict' objects}
|
|
99 0.993 0.010 17.926 0.181 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:882(_build_current_ModuleSha1Map)
|
|
|
|
|
|
|
|
【二】Top 20 调用链耗时 (cumtime = 含子调用, 看大流程)
|
|
------------------------------------------------------------------------
|
|
Wed Aug 19 00:01:32 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\main_prof_45008.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_12728_1.prof
|
|
Wed Aug 19 00:00:10 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_12728_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_1.prof
|
|
Wed Aug 19 00:00:06 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_2.prof
|
|
Wed Aug 19 00:00:15 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14308_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14748_1.prof
|
|
Wed Aug 19 00:00:13 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_14748_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_1.prof
|
|
Wed Aug 19 00:00:05 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_2.prof
|
|
Wed Aug 19 00:00:10 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_21412_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_3188_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_3188_2.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_2.prof
|
|
Wed Aug 19 00:00:20 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_32220_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_2.prof
|
|
Wed Aug 19 00:00:17 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_36004_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_2.prof
|
|
Wed Aug 19 00:00:25 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_41872_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_1.prof
|
|
Wed Aug 19 00:00:08 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_2.prof
|
|
Wed Aug 19 00:00:30 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_47120_3.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_2.prof
|
|
Wed Aug 19 00:00:20 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_54788_3.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_1.prof
|
|
Wed Aug 19 00:00:06 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_2.prof
|
|
Wed Aug 19 00:00:12 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_55456_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_2.prof
|
|
Wed Aug 19 00:00:15 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60112_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60724_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_60724_2.prof
|
|
Wed Aug 19 00:00:02 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_1.prof
|
|
Wed Aug 19 00:00:07 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_2.prof
|
|
Wed Aug 19 00:00:13 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_6192_3.prof
|
|
Wed Aug 19 00:00:03 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_1.prof
|
|
Wed Aug 19 00:00:09 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_2.prof
|
|
Wed Aug 19 00:00:32 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_63756_3.prof
|
|
Wed Aug 19 00:00:04 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_7536_1.prof
|
|
Wed Aug 19 00:00:11 2026 D:\Users\TermiNexus\Desktop\TransPyC\PROF\worker_prof_7536_2.prof
|
|
|
|
117198624 function calls (115119581 primitive calls) in 610.649 seconds
|
|
|
|
Ordered by: cumulative time
|
|
List reduced from 1597 to 20 due to restriction <20>
|
|
|
|
ncalls tottime percall cumtime percall filename:lineno(function)
|
|
362/2 0.006 0.000 409.833 204.916 D:\Python312\Lib\threading.py:302(wait)
|
|
2424/49 0.098 0.000 409.833 8.364 {method 'acquire' of '_thread.lock' objects}
|
|
1 0.000 0.000 409.827 409.827 D:\Python312\Lib\concurrent\futures\process.py:335(run)
|
|
61/59 0.016 0.000 348.841 5.913 D:\Python312\Lib\concurrent\futures\process.py:773(submit)
|
|
90 0.005 0.000 347.709 3.863 D:\Python312\Lib\concurrent\futures\process.py:403(wait_result_broken_or_wakeup)
|
|
208 0.009 0.000 347.667 1.671 D:\Python312\Lib\multiprocessing\connection.py:1014(wait)
|
|
208 0.004 0.000 340.383 1.636 D:\Python312\Lib\multiprocessing\connection.py:992(_exhaustive_wait)
|
|
328/225 347.601 1.060 340.376 1.513 {built-in method _winapi.WaitForMultipleObjects}
|
|
61 0.007 0.000 336.080 5.510 D:\Python312\Lib\concurrent\futures\_base.py:199(as_completed)
|
|
43 0.069 0.002 109.409 2.544 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:69(_parallel_translate_worker)
|
|
43 0.296 0.007 96.859 2.253 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:1286(_translate_file)
|
|
43 0.012 0.000 86.997 2.023 D:\Users\TermiNexus\Desktop\TransPyC\lib\Shell\TransPyC.py:482(Convert)
|
|
200/32 0.066 0.000 85.929 2.685 D:\Python312\Lib\threading.py:1094(join)
|
|
200/32 0.028 0.000 85.927 2.685 D:\Python312\Lib\threading.py:1132(_wait_for_tstate_lock)
|
|
43 0.024 0.001 73.365 1.706 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\Translator\LlvmGenerator.py:324(GenerateCCode)
|
|
43 0.077 0.002 72.785 1.693 D:\Users\TermiNexus\Desktop\TransPyC\lib\core\Translator\LlvmGenerator.py:25(GenerateLlvmDirect)
|
|
2/1 0.017 0.008 62.462 62.462 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Config.py:109(main)
|
|
2/1 1.858 0.929 62.458 62.458 D:\Users\TermiNexus\Desktop\TransPyC\lib\Projectrans\Phase2Translator.py:606(run)
|
|
61 0.001 0.000 47.362 0.776 D:\Python312\Lib\concurrent\futures\process.py:79(wakeup)
|
|
1681 0.019 0.000 44.287 0.026 D:\Users\TermiNexus\Desktop\TransPyC\lib\vast\__init__.py:66(parse)
|
|
|
|
|
|
|
|
【三】热点函数 callers 定位（找出"谁在调用"以定点优化）
|
|
------------------------------------------------------------------------
|
|
|
|
== _path_isfile ==
|
|
<built-in method nt._path_isfile>: tottime=7.149s cumtime=7.149s ncalls=14754
|
|
<- _build_current_ModuleSha1Map x(9306, 9306, 5.764490400000001, 5.764490400000001)
|
|
<- _EmitModuleDeclarationsLlvm x(2170, 2170, 0.2648532, 0.2648532)
|
|
<- _LoadModuleDeclarationsFromFile x(707, 707, 0.1145328, 0.1145328)
|
|
<- _register_compiled_include x(558, 558, 0.1046041, 0.1046041)
|
|
<- _TryGlobalCache x(245, 245, 0.134557, 0.134557)
|
|
<- _compile_ll_files x(239, 239, 0.043330400000000005, 0.043330400000000005)
|
|
<- _scan_include_libraries x(228, 228, 0.0227586, 0.0227586)
|
|
<- _RegisterCrossModuleDocstrings x(198, 198, 0.03636790000000001, 0.03636790000000001)
|
|
_path_isfile: tottime=0.000s cumtime=0.002s ncalls=5
|
|
<- find_spec x(5, 5, 2.7600000000000003e-05, 0.0024415)
|
|
|
|
== _LookupStubFuncType ==
|
|
_LookupStubFuncType: tottime=0.764s cumtime=3.120s ncalls=209
|
|
<- _HandleMethodCallLlvm x(201, 201, 0.6248898, 2.693493)
|
|
<- _HandleExternalCallLlvm x(8, 8, 0.1386203, 0.42693610000000004)
|
|
|
|
== _Init ==
|
|
_Init: tottime=32.755s cumtime=34.355s ncalls=1566897
|
|
<- <built-in method vast_c.parse> x(1553060, 1553060, 32.67106370000001, 34.258838499999996)
|
|
<- _make_replacement_node x(4050, 4050, 0.0093437, 0.011644100000000003)
|
|
<- _make_name_node x(3590, 3590, 0.014290699999999998, 0.0166854)
|
|
<- _body_contains_raise x(3526, 3526, 0.0362245, 0.0415034)
|
|
<- _EmitExternalClassDeclLlvm x(1561, 1561, 0.0180834, 0.020307500000000003)
|
|
<- _specialize_generic_class x(448, 448, 0.0018721000000000002, 0.0021786)
|
|
<- _HandleCallLlvm x(392, 392, 0.0029563000000000007, 0.0033427000000000005)
|
|
<- _apply_type_map_to_expr x(270, 270, 0.0006885999999999999, 0.0008499000000000001)
|
|
|
|
== _TryLoadClassMembersFromPyi ==
|
|
_TryLoadClassMembersFromPyi: tottime=0.942s cumtime=13.839s ncalls=27760
|
|
<- _EmitExternalClassDeclLlvm x(26280, 25992, 0.8715457, 6.3125135000000006)
|
|
<- _TryLoadStructFromStub x(852, 500, 0.059921, 12.739853600000002)
|
|
<- _EnsureClassParentsLoaded x(628, 628, 0.0100637, 0.03792390000000001)
|
|
|
|
== _TryLoadStructFromStub ==
|
|
_TryLoadStructFromStub: tottime=0.059s cumtime=13.246s ncalls=4576
|
|
<- _EmitExternalClassDeclLlvm x(4398, 1818, 0.04607270000000001, 12.950515200000002)
|
|
<- _generate_structs x(164, 65, 0.012509600000000004, 7.769146399999998)
|
|
<- _try_register_vtable_ondemand x(11, 11, 5.4800000000000004e-05, 6.630000000000001e-05)
|
|
<- _try_Load_struct_from_stub x(3, 3, 0.0001218, 0.07452360000000001)
|
|
|
|
== vast_c.parse ==
|
|
<built-in method vast_c.parse>: tottime=9.850s cumtime=44.109s ncalls=1681
|
|
<- parse x(1681, 1681, 9.8499697, 44.108808200000006)
|
|
|
|
== finalize ==
|
|
finalize: tottime=7.662s cumtime=17.425s ncalls=43
|
|
<- GenerateLlvmDirect x(43, 43, 7.661724799999999, 17.425479499999998)
|
|
|
|
== _LoadSha1Map ==
|
|
_LoadSha1Map: tottime=0.113s cumtime=5.072s ncalls=44
|
|
<- __init__ x(44, 44, 0.11333119999999998, 5.072211100000001)
|
|
|
|
== _BuildPyiCacheFile ==
|
|
_BuildPyiCacheFile: tottime=0.012s cumtime=4.602s ncalls=1
|
|
<- _LoadSha1Map x(1, 1, 0.012170100000000001, 4.601761300000001)
|
|
|
|
== _translate_file ==
|
|
_translate_file: tottime=0.296s cumtime=96.859s ncalls=43
|
|
<- _parallel_translate_worker x(43, 43, 0.29592929999999995, 96.8589117)
|
|
|
|
== Convert ==
|
|
_ConvertFunction: tottime=0.043s cumtime=0.133s ncalls=2619
|
|
<- convert x(1346, 1346, 0.0219496, 0.0697753)
|
|
<- _ConvertClass x(1273, 1273, 0.0208297, 0.0634073)
|
|
_ConvertClass: tottime=0.034s cumtime=0.117s ncalls=251
|
|
<- convert x(242, 242, 0.033336500000000005, 0.1171013)
|
|
<- _ConvertClass x(9, 9, 0.0002843, 0.0004173)
|
|
Convert: tottime=0.012s cumtime=86.997s ncalls=43
|
|
<- _translate_file x(43, 43, 0.0123759, 86.99665020000002)
|
|
_ConvertVariable: tottime=0.005s cumtime=0.009s ncalls=810
|
|
<- convert x(810, 810, 0.005180700000000001, 0.0094774)
|
|
|
|
== GenerateCCode ==
|
|
GenerateCCode: tottime=0.024s cumtime=73.365s ncalls=43
|
|
<- Convert x(43, 43, 0.024371399999999998, 73.36474700000001)
|
|
|
|
== _build_current_ModuleSha1Map ==
|
|
_build_current_ModuleSha1Map: tottime=0.993s cumtime=17.926s ncalls=99
|
|
<- run x(98, 98, 0.9912645000000001, 17.8981996)
|
|
<- _compile_include_py_files x(1, 1, 0.0013576, 0.027985600000000003)
|
|
|
|
== iter_child_nodes ==
|
|
iter_child_nodes: tottime=9.808s cumtime=21.155s ncalls=5992065
|
|
<- <method 'extend' of 'collections.deque' objects> x(5320727, 5320727, 9.053009700000006, 19.564493900000002)
|
|
<- visit x(424689, 424689, 0.529203, 1.135389)
|
|
<- _scan_node_for_self_assign x(148078, 148078, 0.13488460000000002, 0.30432620000000005)
|
|
<- generate x(15114, 15114, 0.011840700000000001, 0.0196225)
|
|
<- GenerateLlvmDirect x(13878, 13878, 0.011724000000000002, 0.018197500000000002)
|
|
<- _generate_class_decl x(11704, 11704, 0.010219, 0.013796500000000001)
|
|
<- _CollectInheritedWrapperDecls x(11044, 11044, 0.008940700000000001, 0.015206)
|
|
<- _collect_typedef_map x(10076, 10076, 0.004780100000000001, 0.007480400000000001)
|
|
|
|
== read of ==
|
|
[无匹配 'read of' 的函数]
|
|
|
|
== iter_fields ==
|
|
iter_fields: tottime=5.586s cumtime=8.417s ncalls=7476487
|
|
<- iter_child_nodes x(7476487, 7476487, 5.585532999999999, 8.416754499999998)
|
|
|
|
== walk ==
|
|
walk: tottime=5.942s cumtime=30.949s ncalls=2645472
|
|
<- get_file_dependencies x(554166, 554166, 1.4321114000000001, 7.6097542)
|
|
<- run x(406031, 406031, 1.666206, 8.0717625)
|
|
<- _extract_app_default_args x(406031, 406031, 0.48141090000000003, 2.5379018)
|
|
<- _body_contains_raise x(255751, 255751, 0.38476660000000007, 1.8634377000000002)
|
|
<- _infer_return_type_from_body x(218222, 218222, 0.2991063, 1.615264)
|
|
<- _build_struct_sha1_map x(188688, 188688, 0.6377285, 3.5367842)
|
|
<- _get_needed_include_files x(164518, 164518, 0.44745820000000003, 2.5512192000000002)
|
|
<- _discover_transitive_deps x(149441, 149441, 0.1595975, 0.8626633)
|
|
walk: tottime=0.009s cumtime=0.120s ncalls=98
|
|
<- find_reachable_files_from_entries x(22, 22, 0.0011724, 0.0161676)
|
|
<- _precollect_vtable_state x(13, 13, 0.0027139, 0.059532600000000005)
|
|
<- _get_needed_include_files x(13, 13, 0.0010159000000000001, 0.0121867)
|
|
<- _build_include_py_index x(13, 13, 0.0004531, 0.0084963)
|
|
<- _compile_include_sources x(11, 11, 0.0011647, 0.012670200000000001)
|
|
<- _scan_dir_for_libs x(10, 10, 0.00018820000000000002, 0.0011597)
|
|
<- _scan_include_libraries x(10, 10, 0.00014450000000000002, 0.0013974)
|
|
<- _compile_ll_files x(6, 6, 0.002362, 0.008541100000000001)
|
|
|
|
== _io.open ==
|
|
<built-in method _io.open>: tottime=7.574s cumtime=8.010s ncalls=9768
|
|
<- _build_current_ModuleSha1Map x(4653, 4653, 3.9519885, 4.026187)
|
|
<- _LookupStubFuncType x(919, 919, 0.4358869, 0.44136520000000007)
|
|
<- _LoadDeclarationsFromStubLlvm x(696, 696, 0.3019841999999999, 0.30635930000000006)
|
|
<- parse_python_file x(486, 486, 0.34128450000000005, 0.3472362)
|
|
<- _compile_ll_files x(255, 255, 0.2454773, 0.247264)
|
|
<- extract x(255, 255, 0.1342307, 0.13721170000000002)
|
|
<- _build_shared_symbol_data x(243, 243, 0.2233081, 0.22601130000000003)
|
|
<- _process_file_pyi x(196, 196, 0.4939116, 0.4949057)
|
|
<built-in method _io.open_code>: tottime=0.002s cumtime=0.002s ncalls=5
|
|
<- get_data x(5, 5, 0.0016684, 0.0016684)
|
|
|
|
== _pickle.loads ==
|
|
<built-in method _pickle.loads>: tottime=8.264s cumtime=11.625s ncalls=102
|
|
<- recv x(59, 59, 0.020488600000000003, 0.020488600000000003)
|
|
<- _parallel_translate_worker x(43, 43, 8.243114700000001, 11.604251500000004)
|
|
|
|
【四】模块聚合耗时（按顶层模块归类, tottime 降序）
|
|
------------------------------------------------------------------------
|
|
模块 ncalls tottime(s) cumtime(s)
|
|
~ 84531274 483.12 951.23
|
|
vast 17767923 58.64 148.17
|
|
core 5802693 34.46 606.64
|
|
Projectrans 856256 16.48 629.30
|
|
D:\Python312\Lib\copy.py 571920 3.33 22.80
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\values.py 1082356 2.32 22.07
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\types.py 1164385 1.80 4.28
|
|
includes 571512 1.69 3.63
|
|
<frozen ntpath> 356171 1.47 3.51
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\_utils.py 775537 1.32 4.79
|
|
_bootstrap.py 325643 1.31 3.04
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\instructions.py 232628 1.02 5.61
|
|
D:\Python312\Lib\re\__init__.py 343628 0.93 11.57
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\builder.py 277544 0.57 3.67
|
|
D:\Python312\Lib\threading.py 11314 0.51 613.13
|
|
<frozen codecs> 27303 0.23 0.71
|
|
StubGen 21794 0.21 4.86
|
|
<frozen genericpath> 20590 0.18 0.37
|
|
<frozen os> 7798 0.17 1.06
|
|
D:\Python312\Lib\re\_parser.py 134790 0.13 0.48
|
|
D:\Python312\Lib\subprocess.py 3572 0.13 137.58
|
|
D:\Python312\Lib\copyreg.py 43917 0.09 0.11
|
|
D:\Python312\Lib\json\encoder.py 112864 0.08 0.18
|
|
D:\Python312\Lib\site-packages\llvmlite\ir\module.py 9984 0.07 6.84
|
|
D:\Python312\Lib\re\_compiler.py 10540 0.06 0.46
|
|
D:\Python312\Lib\json\__init__.py 341 0.06 0.24
|
|
D:\Python312\Lib\enum.py 27617 0.05 0.06
|
|
<frozen importlib._bootstrap> 9938 0.03 0.14
|
|
D:\Python312\Lib\concurrent\futures\process.py 800 0.03 1154.73
|
|
D:\Python312\Lib\multiprocessing\connection.py 3352 0.02 702.58
|
|
<frozen _collections_abc> 1789 0.02 0.16
|
|
D:\Python312\Lib\concurrent\futures\_base.py 1270 0.02 368.28
|
|
D:\Python312\Lib\shutil.py 458 0.02 3.91
|
|
D:\Python312\Lib\concurrent\futures\thread.py 133 0.01 9.04
|
|
D:\Python312\Lib\contextlib.py 1744 0.01 0.03
|
|
Shell 131 0.01 87.01
|
|
D:\Python312\Lib\tempfile.py 838 0.01 0.21
|
|
D:\Python312\Lib\argparse.py 322 0.01 0.12
|
|
D:\Python312\Lib\json\decoder.py 198 0.01 0.02
|
|
D:\Python312\Lib\multiprocessing\reduction.py 294 0.01 0.05
|
|
D:\Python312\Lib\multiprocessing\process.py 2899 0.00 0.48
|
|
D:\Python312\Lib\multiprocessing\popen_spawn_win32.py 387 0.00 0.47
|
|
D:\Python312\Lib\queue.py 479 0.00 0.00
|
|
D:\Python312\Lib\_weakrefset.py 418 0.00 0.00
|
|
<frozen importlib._bootstrap_external> 236 0.00 0.07
|
|
<string> 341 0.00 0.00
|
|
D:\Python312\Lib\inspect.py 465 0.00 0.00
|
|
D:\Python312\Lib\functools.py 86 0.00 0.00
|
|
D:\Python312\Lib\multiprocessing\spawn.py 130 0.00 0.01
|
|
D:\Python312\Lib\random.py 53 0.00 0.00
|
|
D:\Python312\Lib\multiprocessing\queues.py 245 0.00 0.00
|
|
D:\Python312\Lib\multiprocessing\context.py 366 0.00 0.47
|
|
<frozen abc> 138 0.00 0.00
|
|
D:\Python312\Lib\multiprocessing\synchronize.py 69 0.00 0.00
|
|
D:\Python312\Lib\gettext.py 18 0.00 0.01
|
|
D:\Python312\Lib\multiprocessing\util.py 26 0.00 0.00
|
|
D:\Python312\Lib\locale.py 9 0.00 0.00
|
|
D:\Python312\Lib\weakref.py 33 0.00 0.00
|
|
<frozen importlib.util> 4 0.00 0.00
|
|
D:\Python312\Lib\encodings\__init__.py 3 0.00 0.00
|
|
<frozen runpy> 4 0.00 0.00
|
|
D:\Python312\Lib\importlib\_abc.py 2 0.00 0.00
|
|
D:\Python312\Lib\site-packages\_distutils_hack\__init__.py 8 0.00 0.00
|
|
<frozen zipimport> 1 0.00 0.00
|
|
|