One of my developer teammates has an issue with git on his machine. Like two days ago, without identifying any configuration change, it has started to be notably slow, be it for pull, checkout, commit, push, whatever.
Using the GIT_TRACE2_PERF environment variable (set GIT_TRACE2_PERF=1
), the log shows a few one second slownesses apparently on win32 calls but not only. On “normal” machines (same network, same Windows OS), these calls take a lot less time.
I have seen some similar questions but which concluded to causes like git credential manager, which does not seem to be the issue here.
I have not found any difference on the affected machine, having checked Defender, network connectivity, CPU/memory usage, …
Slow log for a git pull (done from an isolated command line, but same slowness when done from within Visual Studio):
14:40:00.898249 common-main.c:55 | d0 | main | version | | | | | 2.44.1.windows.1
14:40:00.898249 common-main.c:56 | d0 | main | start | | 0.007827 | | | git.exe pull
14:40:00.898249 ..._win32_process_info.c:120 | d0 | main | data_json | r0 | 0.016661 | 0.016661 | process | windows/ancestry:["git.exe","cmd.exe","explorer.exe"]
14:40:01.984055 repository.c:148 | d0 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:01.984055 git.c:464 | d0 | main | cmd_name | | | | | pull (pull)
14:40:01.984055 read-cache.c:2388 | d0 | main | region_enter | r1 | 1.091696 | | index | label:do_read_index .git/index
14:40:01.984055 cache-tree.c:633 | d0 | main | region_enter | r1 | 1.092739 | | cache_tree | ..label:read
14:40:01.984055 cache-tree.c:635 | d0 | main | region_leave | r1 | 1.092953 | 0.000214 | cache_tree | ..label:read
14:40:01.984055 read-cache.c:2337 | d0 | main | data | r1 | 1.093304 | 0.001608 | index | ..read/version:2
14:40:01.984055 read-cache.c:2339 | d0 | main | data | r1 | 1.093423 | 0.001727 | index | ..read/cache_nr:4447
14:40:01.984055 read-cache.c:2393 | d0 | main | region_leave | r1 | 1.093565 | 0.001869 | index | label:do_read_index .git/index
14:40:01.989637 preload-index.c:125 | d0 | main | region_enter | | 1.094133 | | index | label:preload
14:40:01.991543 preload-index.c:173 | d0 | main | data | | 1.099390 | 0.005257 | index | ..preload/sum_lstat:4447
14:40:01.991543 preload-index.c:174 | d0 | main | region_leave | | 1.099435 | 0.005302 | index | label:preload
14:40:01.991543 read-cache.c:1547 | d0 | main | region_enter | | 1.099624 | | index | label:refresh
14:40:01.991543 read-cache.c:1629 | d0 | main | data | | 1.099904 | 0.000280 | index | ..refresh/sum_lstat:0
14:40:01.991543 read-cache.c:1630 | d0 | main | data | | 1.100146 | 0.000522 | index | ..refresh/sum_scan:0
14:40:01.991543 read-cache.c:1631 | d0 | main | region_leave | | 1.100392 | 0.000768 | index | label:refresh
14:40:01.991543 unpack-trees.c:1899 | d0 | main | region_enter | r1 | 1.101450 | | unpack_trees | label:unpack_trees
14:40:01.991543 unpack-trees.c:2003 | d0 | main | region_enter | r1 | 1.101848 | | unpack_trees | ..label:traverse_trees
14:40:01.991543 unpack-trees.c:2005 | d0 | main | region_leave | r1 | 1.102033 | 0.000185 | unpack_trees | ..label:traverse_trees
14:40:01.991543 unpack-trees.c:2097 | d0 | main | region_leave | r1 | 1.102143 | 0.000693 | unpack_trees | label:unpack_trees
14:40:01.991543 run-command.c:724 | d0 | main | child_start | | 1.102231 | | | [ch0] class:? argv:[git merge-base --fork-point refs/remotes/origin/dev dev]
14:40:03.017946 run-command.c:977 | d0 | main | child_exit | | 2.123290 | 1.021059 | | [ch0] pid:21376 code:0
14:40:03.017946 run-command.c:724 | d0 | main | child_start | | 2.123452 | | | [ch1] class:? argv:[git fetch --update-head-ok]
14:40:03.022451 common-main.c:55 | d1 | main | version | | | | | 2.44.1.windows.1
14:40:03.022451 common-main.c:56 | d1 | main | start | | 0.003940 | | | git fetch --update-head-ok
14:40:03.040470 ..._win32_process_info.c:120 | d1 | main | data_json | r0 | 0.014386 | 0.014386 | process | windows/ancestry:["git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:04.010654 repository.c:148 | d1 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:04.010654 git.c:464 | d1 | main | cmd_name | | | | | fetch (pull/fetch)
14:40:04.010654 read-cache.c:2388 | d1 | main | region_enter | r1 | 0.989327 | | index | label:do_read_index .git/index
14:40:04.010654 cache-tree.c:633 | d1 | main | region_enter | r1 | 0.990965 | | cache_tree | ..label:read
14:40:04.010654 cache-tree.c:635 | d1 | main | region_leave | r1 | 0.991504 | 0.000539 | cache_tree | ..label:read
14:40:04.010654 read-cache.c:2337 | d1 | main | data | r1 | 0.991957 | 0.002630 | index | ..read/version:2
14:40:04.010654 read-cache.c:2339 | d1 | main | data | r1 | 0.992148 | 0.002821 | index | ..read/cache_nr:4447
14:40:04.010654 read-cache.c:2393 | d1 | main | region_leave | r1 | 0.992263 | 0.002936 | index | label:do_read_index .git/index
14:40:04.018963 builtin/fetch.c:1634 | d1 | main | region_enter | r1 | 0.993904 | | fetch | label:remote_refs
14:40:04.018963 run-command.c:724 | d1 | main | child_start | | 0.994081 | | | ..[ch0] class:remote-https argv:[git remote-https origin https://[email protected]/VALAP/ProjetValap/_git/Valap]
14:40:04.030683 common-main.c:55 | d2 | main | version | | | | | 2.44.1.windows.1
14:40:04.030683 common-main.c:56 | d2 | main | start | | 0.004261 | | | git remote-https origin https://[email protected]/VALAP/ProjetValap/_git/Valap
14:40:04.040554 ..._win32_process_info.c:120 | d2 | main | data_json | r0 | 0.019495 | 0.019495 | process | windows/ancestry:["git.exe","git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:04.040554 git.c:744 | d2 | main | cmd_name | | | | | _run_dashed_ (pull/fetch/_run_dashed_)
14:40:04.040554 run-command.c:724 | d2 | main | child_start | | 0.020414 | | | [ch0] class:dashed argv:[git-remote-https origin https://[email protected]/VALAP/ProjetValap/_git/Valap]
14:40:04.059280 common-main.c:55 | d3 | main | version | | | | | 2.44.1.windows.1
14:40:04.059280 common-main.c:56 | d3 | main | start | | 0.004569 | | | git-remote-https origin https://[email protected]/VALAP/ProjetValap/_git/Valap
14:40:04.072646 ..._win32_process_info.c:120 | d3 | main | data_json | r0 | 0.018309 | 0.018309 | process | windows/ancestry:["git.exe","git.exe","git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:04.072646 repository.c:148 | d3 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:04.072646 remote-curl.c:1554 | d3 | main | cmd_name | | | | | remote-curl (pull/fetch/_run_dashed_/remote-curl)
14:40:04.309803 run-command.c:724 | d3 | main | child_start | | 0.257751 | | | [ch0] class:? argv:['git credential-manager get']
14:40:04.347104 common-main.c:55 | d4 | main | version | | | | | 2.44.1.windows.1
14:40:04.347104 common-main.c:56 | d4 | main | start | | 0.003952 | | | 'C:Program FilesGitmingw64libexecgit-coregit.exe' credential-manager get
14:40:04.364869 ..._win32_process_info.c:120 | d4 | main | data_json | r0 | 0.020721 | 0.020721 | process | windows/ancestry:["sh.exe","git-remote-https.exe","git.exe","git.exe","git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:04.365879 git.c:744 | d4 | main | cmd_name | | | | | _run_dashed_ (pull/fetch/_run_dashed_/remote-curl/_run_dashed_)
14:40:04.365879 run-command.c:724 | d4 | main | child_start | | 0.021666 | | | [ch0] class:dashed argv:[git-credential-manager get]
14:40:04.411680 common-main.c:55 | d6 | main | version | | | | | 2.44.1.windows.1
14:40:04.411680 common-main.c:56 | d6 | main | start | | 0.003929 | | | 'C:/Program Files/Git/mingw64/libexec/git-coregit.exe' config --null --list
14:40:04.425725 ..._win32_process_info.c:120 | d6 | main | data_json | r0 | 0.020360 | 0.020360 | process | windows/ancestry:["git-credential-manager.exe","git.exe","sh.exe","git-remote-https.exe","git.exe","git.exe","git.exe","git.exe","cmd.exe","explorer.exe","(truncated)"]
14:40:04.436229 repository.c:148 | d6 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:04.436229 git.c:464 | d6 | main | cmd_name | | | | | config (pull/fetch/_run_dashed_/remote-curl/_run_dashed_/config)
14:40:04.436229 ..._win32_process_info.c:168 | d6 | main | data_json | r1 | 0.022887 | 0.022887 | process | windows/memory:{"PageFaultCount":8509,"PeakWorkingSetSize":8400896,"PeakPagefileUsage":36212736}
14:40:04.436229 git.c:724 | d6 | main | exit | | 0.023178 | | | code:0
14:40:04.436229 trace2/tr2_tgt_perf.c:217 | d6 | main | atexit | | 0.023500 | | | code:0
14:40:04.436229 Program.cs:56 | d0 | AppMain| version | | | | | 2.4.1
14:40:04.436229 Program.cs:56 | d0 | AppMain| start | | 0,045299 | | | git-credential-manager.exe get
14:40:04.500529 Program.cs:71 | d0 | AppMain| exit | | 0,109599 | | | elapsed:0,1095989 code:0
14:40:04.517527 run-command.c:977 | d4 | main | child_exit | | 0.172614 | 0.150948 | | [ch0] pid:23624 code:0
14:40:04.517527 ..._win32_process_info.c:168 | d4 | main | data_json | r0 | 0.172895 | 0.172895 | process | windows/memory:{"PageFaultCount":7912,"PeakWorkingSetSize":8380416,"PeakPagefileUsage":36200448}
14:40:04.517527 git.c:766 | d4 | main | exit | | 0.173011 | | | code:0
14:40:04.517527 trace2/tr2_tgt_perf.c:217 | d4 | main | atexit | | 0.173098 | | | code:0
14:40:04.521778 run-command.c:977 | d3 | main | child_exit | | 0.466872 | 0.209121 | | [ch0] pid:25432 code:0
14:40:04.578290 run-command.c:724 | d3 | main | child_start | | 0.524348 | | | [ch1] class:? argv:['git credential-manager store']
14:40:04.612544 common-main.c:55 | d4 | main | version | | | | | 2.44.1.windows.1
14:40:04.612544 common-main.c:56 | d4 | main | start | | 0.004285 | | | 'C:Program FilesGitmingw64libexecgit-coregit.exe' credential-manager store
14:40:04.625702 ..._win32_process_info.c:120 | d4 | main | data_json | r0 | 0.020367 | 0.020367 | process | windows/ancestry:["sh.exe","git-remote-https.exe","git.exe","git.exe","git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:04.625702 git.c:744 | d4 | main | cmd_name | | | | | _run_dashed_ (pull/fetch/_run_dashed_/remote-curl/_run_dashed_)
14:40:04.625702 run-command.c:724 | d4 | main | child_start | | 0.021778 | | | [ch0] class:dashed argv:[git-credential-manager store]
14:40:04.683585 common-main.c:55 | d6 | main | version | | | | | 2.44.1.windows.1
14:40:04.683585 common-main.c:56 | d6 | main | start | | 0.003980 | | | 'C:/Program Files/Git/mingw64/libexec/git-coregit.exe' config --null --list
14:40:04.689591 ..._win32_process_info.c:120 | d6 | main | data_json | r0 | 0.021527 | 0.021527 | process | windows/ancestry:["git-credential-manager.exe","git.exe","sh.exe","git-remote-https.exe","git.exe","git.exe","git.exe","git.exe","cmd.exe","explorer.exe","(truncated)"]
14:40:04.689591 repository.c:148 | d6 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:04.689591 git.c:464 | d6 | main | cmd_name | | | | | config (pull/fetch/_run_dashed_/remote-curl/_run_dashed_/config)
14:40:04.705223 ..._win32_process_info.c:168 | d6 | main | data_json | r1 | 0.023997 | 0.023997 | process | windows/memory:{"PageFaultCount":8509,"PeakWorkingSetSize":8396800,"PeakPagefileUsage":36212736}
14:40:04.705223 git.c:724 | d6 | main | exit | | 0.024305 | | | code:0
14:40:04.705223 trace2/tr2_tgt_perf.c:217 | d6 | main | atexit | | 0.024408 | | | code:0
14:40:04.705223 Program.cs:56 | d0 | AppMain| version | | | | | 2.4.1
14:40:04.705223 Program.cs:56 | d0 | AppMain| start | | 0,062298 | | | git-credential-manager.exe store
14:40:04.768666 Program.cs:71 | d0 | AppMain| exit | | 0,125741 | | | elapsed:0,1257409 code:0
14:40:04.780534 run-command.c:977 | d4 | main | child_exit | | 0.171364 | 0.149586 | | [ch0] pid:23820 code:0
14:40:04.780534 ..._win32_process_info.c:168 | d4 | main | data_json | r0 | 0.171592 | 0.171592 | process | windows/memory:{"PageFaultCount":7913,"PeakWorkingSetSize":8384512,"PeakPagefileUsage":36204544}
14:40:04.780534 git.c:766 | d4 | main | exit | | 0.171734 | | | code:0
14:40:04.780534 trace2/tr2_tgt_perf.c:217 | d4 | main | atexit | | 0.171901 | | | code:0
14:40:04.785631 run-command.c:977 | d3 | main | child_exit | | 0.730606 | 0.206258 | | [ch1] pid:20204 code:0
14:40:04.785631 connect.c:175 | d3 | main | data | | 0.730809 | 0.730809 | transfer | negotiated-version:0
14:40:04.785631 builtin/fetch.c:1637 | d1 | main | region_leave | r1 | 1.760088 | 0.766184 | fetch | label:remote_refs
14:40:04.786859 run-command.c:724 | d1 | main | child_start | | 1.760831 | | | [ch1] class:? argv:[git rev-list --objects --stdin --not --exclude-hidden=fetch --all --quiet --alternate-refs]
14:40:05.788130 run-command.c:977 | d1 | main | child_exit | | 2.762272 | 1.001441 | | [ch1] pid:23980 code:0
14:40:05.788130 builtin/fetch.c:1357 | d1 | main | region_enter | r1 | 2.762489 | | fetch | label:consume_refs
14:40:05.788130 builtin/fetch.c:1361 | d1 | main | region_leave | r1 | 2.763189 | 0.000700 | fetch | label:consume_refs
14:40:05.791367 ..._win32_process_info.c:168 | d3 | main | data_json | r1 | 1.736441 | 1.736441 | process | windows/memory:{"PageFaultCount":8410,"PeakWorkingSetSize":14802944,"PeakPagefileUsage":37998592}
14:40:05.791367 common-main.c:65 | d3 | main | exit | | 1.736560 | | | code:0
14:40:05.791367 trace2/tr2_tgt_perf.c:217 | d3 | main | atexit | | 1.736955 | | | code:0
14:40:05.794366 run-command.c:977 | d2 | main | child_exit | | 1.768134 | 1.747720 | | [ch0] pid:10344 code:0
14:40:05.795379 ..._win32_process_info.c:168 | d2 | main | data_json | r0 | 1.768400 | 1.768400 | process | windows/memory:{"PageFaultCount":7942,"PeakWorkingSetSize":8364032,"PeakPagefileUsage":36184064}
14:40:05.795379 git.c:766 | d2 | main | exit | | 1.768468 | | | code:0
14:40:05.795379 trace2/tr2_tgt_perf.c:217 | d2 | main | atexit | | 1.768661 | | | code:0
14:40:05.797439 run-command.c:977 | d1 | main | child_exit | | 2.771749 | 1.777668 | | [ch0] pid:18308 code:0
14:40:05.797439 run-command.c:1755 | d1 | main | region_enter | | 2.772155 | | submodule | label:parallel/fetch max:1
14:40:05.798452 run-command.c:1793 | d1 | main | region_leave | | 2.772302 | 0.000147 | submodule | label:parallel/fetch
14:40:05.798452 run-command.c:724 | d1 | main | child_start | | 2.772412 | | | [ch2] class:? argv:[git maintenance run --auto --no-quiet]
14:40:05.807634 common-main.c:55 | d2 | main | version | | | | | 2.44.1.windows.1
14:40:05.807634 common-main.c:56 | d2 | main | start | | 0.003355 | | | git maintenance run --auto --no-quiet
14:40:05.809139 ..._win32_process_info.c:120 | d2 | main | data_json | r0 | 0.014557 | 0.014557 | process | windows/ancestry:["git.exe","git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:06.821302 repository.c:148 | d2 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:06.821302 git.c:464 | d2 | main | cmd_name | | | | | maintenance (pull/fetch/maintenance)
14:40:06.821302 ..._win32_process_info.c:168 | d2 | main | data_json | r1 | 1.024914 | 1.024914 | process | windows/memory:{"PageFaultCount":6126,"PeakWorkingSetSize":8478720,"PeakPagefileUsage":36196352}
14:40:06.821302 git.c:724 | d2 | main | exit | | 1.025061 | | | code:0
14:40:06.821302 trace2/tr2_tgt_perf.c:217 | d2 | main | atexit | | 1.025166 | | | code:0
14:40:06.830930 run-command.c:977 | d1 | main | child_exit | | 3.805723 | 1.033311 | | [ch2] pid:21588 code:0
14:40:06.830930 ..._win32_process_info.c:168 | d1 | main | data_json | r1 | 3.805959 | 3.805959 | process | windows/memory:{"PageFaultCount":6150,"PeakWorkingSetSize":10014720,"PeakPagefileUsage":36360192}
14:40:06.830930 git.c:724 | d1 | main | exit | | 3.806095 | | | code:0
14:40:06.830930 trace2/tr2_tgt_perf.c:217 | d1 | main | atexit | | 3.806187 | | | code:0
14:40:06.833955 run-command.c:977 | d0 | main | child_exit | | 5.939200 | 3.815748 | | [ch1] pid:10112 code:0
14:40:06.833955 run-command.c:724 | d0 | main | child_start | | 5.939814 | | | [ch2] class:? argv:[git merge --ff-only --no-autostash FETCH_HEAD]
14:40:06.844409 common-main.c:55 | d1 | main | version | | | | | 2.44.1.windows.1
14:40:06.844409 common-main.c:56 | d1 | main | start | | 0.004154 | | | git merge --ff-only --no-autostash FETCH_HEAD
14:40:06.853023 ..._win32_process_info.c:120 | d1 | main | data_json | r0 | 0.014570 | 0.014570 | process | windows/ancestry:["git.exe","git.exe","cmd.exe","explorer.exe"]
14:40:07.833802 repository.c:148 | d1 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:40:07.833802 git.c:464 | d1 | main | cmd_name | | | | | merge (pull/merge)
14:40:07.833802 read-cache.c:2388 | d1 | main | region_enter | r1 | 0.995195 | | index | label:do_read_index .git/index
14:40:07.833802 cache-tree.c:633 | d1 | main | region_enter | r1 | 0.996047 | | cache_tree | ..label:read
14:40:07.833802 cache-tree.c:635 | d1 | main | region_leave | r1 | 0.996222 | 0.000175 | cache_tree | ..label:read
14:40:07.833802 read-cache.c:2337 | d1 | main | data | r1 | 0.996329 | 0.001134 | index | ..read/version:2
14:40:07.833802 read-cache.c:2339 | d1 | main | data | r1 | 0.996360 | 0.001165 | index | ..read/cache_nr:4447
14:40:07.833802 read-cache.c:2393 | d1 | main | region_leave | r1 | 0.996399 | 0.001204 | index | label:do_read_index .git/index
Already up to date.
14:40:07.839888 ..._win32_process_info.c:168 | d1 | main | data_json | r1 | 0.998550 | 0.998550 | process | windows/memory:{"PageFaultCount":6163,"PeakWorkingSetSize":10170368,"PeakPagefileUsage":36368384}
14:40:07.839888 git.c:724 | d1 | main | exit | | 0.998709 | | | code:0
14:40:07.839888 trace2/tr2_tgt_perf.c:217 | d1 | main | atexit | | 0.998863 | | | code:0
14:40:07.841629 run-command.c:977 | d0 | main | child_exit | | 6.947600 | 1.007786 | | [ch2] pid:4988 code:0
14:40:07.841629 ..._win32_process_info.c:168 | d0 | main | data_json | r1 | 6.947948 | 6.947948 | process | windows/memory:{"PageFaultCount":6605,"PeakWorkingSetSize":13537280,"PeakPagefileUsage":56737792}
14:40:07.841629 git.c:724 | d0 | main | exit | | 6.948000 | | | code:0
14:40:07.841629 tree-walk.c:194 | d0 | main | data_json | r1 | 6.948048 | 6.948048 | traverse_tre | statistics:{"traverse_trees_count":1,"traverse_trees_max_depth":1}
14:40:07.841629 trace2/tr2_tgt_perf.c:217 | d0 | main | atexit | | 6.948364 | | | code:0
Normal log for a git pull (done from withing Visual Studio, quite trimmed due to post size limit):
14:49:14.721783 common-main.c:55 | d0 | main | version | | | | | 2.44.1.windows.1
14:49:14.721783 common-main.c:56 | d0 | main | start | | 0.010979 | | | git.exe pull
14:49:14.737450 ..._win32_process_info.c:120 | d0 | main | data_json | r0 | 0.026248 | 0.026248 | process | windows/ancestry:["git.exe","cmd.exe","ServiceHub.Host.netfx.x64.exe","Microsoft.ServiceHub.Controller.exe","devenv.exe","explorer.exe"]
14:49:14.737450 repository.c:148 | d0 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:49:14.737450 git.c:464 | d0 | main | cmd_name | | | | | pull (pull)
14:49:14.737450 read-cache.c:2388 | d0 | main | region_enter | r1 | 0.028750 | | index | label:do_read_index .git/index
removed due to post size limit
14:49:14.753062 run-command.c:724 | d0 | main | child_start | | 0.043877 | | | [ch0] class:? argv:[git merge-base --fork-point refs/remotes/origin/dev dev]
14:49:14.800474 run-command.c:977 | d0 | main | child_exit | | 0.089146 | 0.045269 | | [ch0] pid:19072 code:0
14:49:14.800474 run-command.c:724 | d0 | main | child_start | | 0.089369 | | | [ch1] class:? argv:[git fetch --update-head-ok]
14:49:14.816013 common-main.c:55 | d1 | main | version | | | | | 2.44.1.windows.1
14:49:14.816013 common-main.c:56 | d1 | main | start | | 0.006861 | | | git fetch --update-head-ok
14:49:14.831641 ..._win32_process_info.c:120 | d1 | main | data_json | r0 | 0.023700 | 0.023700 | process | windows/ancestry:["git.exe","git.exe","cmd.exe","ServiceHub.Host.netfx.x64.exe","Microsoft.ServiceHub.Controller.exe","devenv.exe","explorer.exe"]
14:49:14.831641 repository.c:148 | d1 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:49:14.831641 git.c:464 | d1 | main | cmd_name | | | | | fetch (pull/fetch)
removed due to post size limit
14:49:16.056437 builtin/fetch.c:1637 | d1 | main | region_leave | r1 | 1.253396 | 1.224548 | fetch | label:remote_refs
14:49:16.056437 run-command.c:724 | d1 | main | child_start | | 1.255260 | | | [ch1] class:? argv:[git rev-list --objects --stdin --not --exclude-hidden=fetch --all --quiet --alternate-refs]
14:49:16.103737 run-command.c:977 | d1 | main | child_exit | | 1.299220 | 0.043960 | | [ch1] pid:3272 code:0
removed due to post size limit
14:49:16.197920 common-main.c:55 | d1 | main | version | | | | | 2.44.1.windows.1
14:49:16.197920 common-main.c:56 | d1 | main | start | | 0.006066 | | | git merge --ff-only --no-autostash FETCH_HEAD
14:49:16.213587 ..._win32_process_info.c:120 | d1 | main | data_json | r0 | 0.026393 | 0.026393 | process | windows/ancestry:["git.exe","git.exe","cmd.exe","ServiceHub.Host.netfx.x64.exe","Microsoft.ServiceHub.Controller.exe","devenv.exe","explorer.exe"]
14:49:16.213587 repository.c:148 | d1 | main | def_repo | r1 | | | | worktree:D:/XVRT
14:49:16.213587 git.c:464 | d1 | main | cmd_name | | | | | merge (pull/merge)
14:49:16.213587 read-cache.c:2388 | d1 | main | region_enter | r1 | 0.030006 | | index | label:do_read_index .git/index
14:49:16.213587 cache-tree.c:633 | d1 | main | region_enter | r1 | 0.030828 | | cache_tree | ..label:read
14:49:16.213587 cache-tree.c:635 | d1 | main | region_leave | r1 | 0.031077 | 0.000249 | cache_tree | ..label:read
14:49:16.213587 read-cache.c:2337 | d1 | main | data | r1 | 0.031330 | 0.001324 | index | ..read/version:2
14:49:16.213587 read-cache.c:2339 | d1 | main | data | r1 | 0.031415 | 0.001409 | index | ..read/cache_nr:4447
14:49:16.213587 read-cache.c:2393 | d1 | main | region_leave | r1 | 0.031514 | 0.001508 | index | label:do_read_index .git/index
Already up to date.
14:49:16.213587 ..._win32_process_info.c:168 | d1 | main | data_json | r1 | 0.035677 | 0.035677 | process | windows/memory:{"PageFaultCount":8037,"PeakWorkingSetSize":10817536,"PeakPagefileUsage":36261888}
14:49:16.213587 git.c:724 | d1 | main | exit | | 0.035831 | | | code:0
14:49:16.213587 trace2/tr2_tgt_perf.c:217 | d1 | main | atexit | | 0.035924 | | | code:0
14:49:16.229158 run-command.c:977 | d0 | main | child_exit | | 1.523782 | 0.053576 | | [ch2] pid:25700 code:0
14:49:16.229158 ..._win32_process_info.c:168 | d0 | main | data_json | r1 | 1.524165 | 1.524165 | process | windows/memory:{"PageFaultCount":8483,"PeakWorkingSetSize":14258176,"PeakPagefileUsage":56696832}
14:49:16.229158 git.c:724 | d0 | main | exit | | 1.524285 | | | code:0
14:49:16.229158 tree-walk.c:194 | d0 | main | data_json | r1 | 1.524438 | 1.524438 | traverse_tre | statistics:{"traverse_trees_count":1,"traverse_trees_max_depth":1}
14:49:16.229158 trace2/tr2_tgt_perf.c:217 | d0 | main | atexit | | 1.524593 | | | code:0