C:\testZ\1\2\15>scalar clone https://SERVERADDRESS/DefaultCollection/Test/_git/Test --cache-server-url=https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:40:35.982808 common-main.c:48 | d0 | main | version | | | | | 2.33.0.vfs.0.0 14:40:35.983808 common-main.c:49 | d0 | main | start | | 0.011824 | | | git.exe clone https://SERVERADDRESS/DefaultCollection/Test/_git/Test --cache-server-url=https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:40:36.005806 ..._win32_process_info.c:118 | d0 | main | data_json | r0 | 0.033038 | 0.033038 | process | windows/ancestry:["scalar.exe","cmd.exe","explorer.exe"] 14:40:36.006808 run-command.c:738 | d0 | main | child_start | | 0.034111 | | | [ch0] class:? argv:[git -c init.defaultBranch=master init -- C:/testZ/1/2/15/Test/src] 14:40:36.041807 common-main.c:48 | d1 | main | version | | | | | 2.33.0.vfs.0.0 14:40:36.042808 common-main.c:49 | d1 | main | start | | 0.011833 | | | git -c init.defaultBranch=master init -- C:/testZ/1/2/15/Test/src 14:40:36.067806 ..._win32_process_info.c:118 | d1 | main | data_json | r0 | 0.036843 | 0.036843 | process | windows/ancestry:["scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:36.068808 git.c:523 | d1 | main | cmd_name | | | | | init (init) 14:40:36.070807 repository.c:132 | d1 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:36.106808 ..._win32_process_info.c:166 | d1 | main | data_json | r1 | 0.075815 | 0.075815 | process | windows/memory:{"PageFaultCount":5920,"PeakWorkingSetSize":7827456,"PeakPagefileUsage":3764224} 14:40:36.106808 git.c:785 | d1 | main | exit | | 0.075843 | | | code:0 14:40:36.106808 trace2/tr2_tgt_perf.c:213 | d1 | main | atexit | | 0.075856 | | | code:0 Initialized empty Git repository in C:/testZ/1/2/15/Test/src/.git/ 14:40:36.109807 run-command.c:993 | d0 | main | child_exit | | 0.137784 | 0.103673 | | [ch0] pid:13412 code:0 14:40:36.110808 repository.c:132 | d0 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:36.111807 contrib/scalar/scalar.c:968 | d0 | main | data | r1 | 0.139704 | 0.139704 | scalar | dir:C:/testZ/1/2/15/Test/src 14:40:36.111807 contrib/scalar/scalar.c:969 | d0 | main | data | r1 | 0.139729 | 0.139729 | scalar | unattended:0 14:40:36.111807 run-command.c:738 | d0 | main | child_start | | 0.139820 | | | [ch1] class:? argv:[git ls-remote --symref https://SERVERADDRESS/DefaultCollection/Test/_git/Test HEAD] 14:40:36.146809 common-main.c:48 | d1 | main | version | | | | | 2.33.0.vfs.0.0 14:40:36.147808 common-main.c:49 | d1 | main | start | | 0.011577 | | | git ls-remote --symref https://SERVERADDRESS/DefaultCollection/Test/_git/Test HEAD 14:40:36.173807 ..._win32_process_info.c:118 | d1 | main | data_json | r0 | 0.036944 | 0.036944 | process | windows/ancestry:["scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:36.174807 repository.c:132 | d1 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:36.176808 git.c:523 | d1 | main | cmd_name | | | | | ls-remote (ls-remote) 14:40:36.176808 run-command.c:738 | d1 | main | child_start | | 0.040584 | | | [ch0] class:remote-https argv:[git remote-https https://SERVERADDRESS/DefaultCollection/Test/_git/Test https://SERVERADDRESS/DefaultCollection/Test/_git/Test] 14:40:36.211807 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:36.212807 common-main.c:49 | d2 | main | start | | 0.011749 | | | git remote-https https://SERVERADDRESS/DefaultCollection/Test/_git/Test https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:36.242806 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040938 | 0.040938 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:36.243808 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (ls-remote/_run_dashed_) 14:40:36.243808 run-command.c:738 | d2 | main | child_start | | 0.042234 | | | [ch0] class:dashed argv:[git-remote-https https://SERVERADDRESS/DefaultCollection/Test/_git/Test https://SERVERADDRESS/DefaultCollection/Test/_git/Test] 14:40:36.282810 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:40:36.283807 common-main.c:49 | d3 | main | start | | 0.011984 | | | git-remote-https https://SERVERADDRESS/DefaultCollection/Test/_git/Test https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:36.316807 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044533 | 0.044533 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:36.317807 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:36.317807 remote-curl.c:1499 | d3 | main | cmd_name | | | | | remote-curl (ls-remote/_run_dashed_/remote-curl) 14:40:36.321807 http.c:781 == Info: Couldn't find host SERVERADDRESS in the (nil) file; using defaults 14:40:36.328006 http.c:781 == Info: Trying SERVERIP:443... 14:40:36.345618 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:36.345618 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:40:36.356584 http.c:728 => Send header, 0000000230 bytes (0x000000e6) 14:40:36.356584 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:36.356584 http.c:740 => Send header: Host: SERVERADDRESS 14:40:36.356584 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:36.356584 http.c:740 => Send header: Accept: */* 14:40:36.356584 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:36.356584 http.c:740 => Send header: Pragma: no-cache 14:40:36.356584 http.c:740 => Send header: Git-Protocol: version=2 14:40:36.356584 http.c:740 => Send header: 14:40:36.360594 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:36.360594 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:36.360594 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:36.360594 http.c:728 <= Recv header, 0000000040 bytes (0x00000028) 14:40:36.361557 http.c:740 <= Recv header: Content-Type: text/html; charset=utf-8 14:40:36.361557 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:36.361557 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:36.361557 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:36.361557 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:36.361557 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:36.361557 http.c:740 <= Recv header: ActivityId: 3a39824a-e64f-4399-9898-513b7b8fefe8 14:40:36.361557 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:36.361557 http.c:740 <= Recv header: X-TFS-Session: 3a39824a-e64f-4399-9898-513b7b8fefe8 14:40:36.361557 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:36.361557 http.c:740 <= Recv header: X-VSS-E2EID: 3a39824a-e64f-4399-9898-513b7b8fefe8 14:40:36.361557 http.c:728 <= Recv header, 0000000690 bytes (0x000002b2) 14:40:36.361557 http.c:740 <= Recv header: X-TFS-SoapException: %3C%3Fxml%20version%3D%221.0%22%20encoding%3D%22utf-8%22%3F%3E%3Csoap%3AEnvelope%20xmlns%3Asoap%3D%22http%3A%2F%2Fwww.w3.org%2F2003%2F05%2Fsoap-envelope%22%3E%3Csoap%3ABody%3E%3Csoap%3AFault%3E%3Csoap%3ACode%3E%3Csoap%3AValue%3Esoap%3AReceiver%3C%2Fsoap%3AValue%3E%3Csoap%3ASubcode%3E%3Csoap%3AValue%3EUnauthorizedRequestException%3C%2Fsoap%3AValue%3E%3C%2Fsoap%3ASubcode%3E%3C%2Fsoap%3ACode%3E%3Csoap%3AReason%3E%3Csoap%3AText%20xml%3Alang%3D%22en%22%3ETF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required.%3C%2Fsoap%3AText%3E%3C%2Fsoap%3AReason%3E%3C%2Fsoap%3AFault%3E%3C%2Fsoap%3ABody%3E%3C%2Fsoap%3AEnvelope%3E 14:40:36.361557 http.c:728 <= Recv header, 0000000128 bytes (0x00000080) 14:40:36.361557 http.c:740 <= Recv header: X-TFS-ServiceError: TF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required. 14:40:36.361557 http.c:728 <= Recv header, 0000000026 bytes (0x0000001a) 14:40:36.361557 http.c:740 <= Recv header: WWW-Authenticate: Bearer 14:40:36.361557 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:36.361557 http.c:740 <= Recv header: WWW-Authenticate: Basic realm="https://SERVERADDRESS/" 14:40:36.361557 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:36.361557 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:36.364559 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:36.364559 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:36.364559 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:36.364559 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:36.364559 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:36.364559 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:36.364559 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:36.364559 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:36.364559 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:36.364559 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:36.364559 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:36.364559 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:36 GMT 14:40:36.364559 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:36.364559 http.c:740 <= Recv header: Content-Length: 20109 14:40:36.364559 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:36.364559 http.c:740 <= Recv header: 14:40:36.364559 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:36.364559 run-command.c:738 | d3 | main | child_start | | 0.092536 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:40:39.148755 run-command.c:993 | d3 | main | child_exit | | 2.876849 | 2.784313 | | [ch0] pid:22480 code:0 14:40:39.148755 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x20713292f10 [serially] 14:40:39.148755 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:39.148755 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:39.148755 http.c:728 => Send header, 0000000230 bytes (0x000000e6) 14:40:39.148755 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:39.148755 http.c:740 => Send header: Host: SERVERADDRESS 14:40:39.148755 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:39.148755 http.c:740 => Send header: Accept: */* 14:40:39.148755 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:39.148755 http.c:740 => Send header: Pragma: no-cache 14:40:39.148755 http.c:740 => Send header: Git-Protocol: version=2 14:40:39.148755 http.c:740 => Send header: 14:40:39.153756 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:39.153756 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:39.153756 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:39.153756 http.c:728 <= Recv header, 0000000040 bytes (0x00000028) 14:40:39.153756 http.c:740 <= Recv header: Content-Type: text/html; charset=utf-8 14:40:39.153756 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:39.153756 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:39.153756 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:39.153756 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:39.153756 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:39.153756 http.c:740 <= Recv header: ActivityId: 3a39824d-e64f-4399-9898-513b7b8fefe8 14:40:39.153756 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:39.153756 http.c:740 <= Recv header: X-TFS-Session: 3a39824d-e64f-4399-9898-513b7b8fefe8 14:40:39.153756 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:39.153756 http.c:740 <= Recv header: X-VSS-E2EID: 3a39824d-e64f-4399-9898-513b7b8fefe8 14:40:39.153756 http.c:728 <= Recv header, 0000000690 bytes (0x000002b2) 14:40:39.153756 http.c:740 <= Recv header: X-TFS-SoapException: %3C%3Fxml%20version%3D%221.0%22%20encoding%3D%22utf-8%22%3F%3E%3Csoap%3AEnvelope%20xmlns%3Asoap%3D%22http%3A%2F%2Fwww.w3.org%2F2003%2F05%2Fsoap-envelope%22%3E%3Csoap%3ABody%3E%3Csoap%3AFault%3E%3Csoap%3ACode%3E%3Csoap%3AValue%3Esoap%3AReceiver%3C%2Fsoap%3AValue%3E%3Csoap%3ASubcode%3E%3Csoap%3AValue%3EUnauthorizedRequestException%3C%2Fsoap%3AValue%3E%3C%2Fsoap%3ASubcode%3E%3C%2Fsoap%3ACode%3E%3Csoap%3AReason%3E%3Csoap%3AText%20xml%3Alang%3D%22en%22%3ETF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required.%3C%2Fsoap%3AText%3E%3C%2Fsoap%3AReason%3E%3C%2Fsoap%3AFault%3E%3C%2Fsoap%3ABody%3E%3C%2Fsoap%3AEnvelope%3E 14:40:39.153756 http.c:728 <= Recv header, 0000000128 bytes (0x00000080) 14:40:39.153756 http.c:740 <= Recv header: X-TFS-ServiceError: TF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required. 14:40:39.153756 http.c:728 <= Recv header, 0000000026 bytes (0x0000001a) 14:40:39.153756 http.c:740 <= Recv header: WWW-Authenticate: Bearer 14:40:39.153756 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:39.153756 http.c:740 <= Recv header: WWW-Authenticate: Basic realm="https://SERVERADDRESS/" 14:40:39.153756 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:39.153756 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:39.153756 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:39.153756 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:39.153756 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:39.153756 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:39.153756 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:39.153756 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:39.153756 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:39.153756 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:39.153756 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:39.153756 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:39.153756 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:39.153756 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:39 GMT 14:40:39.153756 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:39.153756 http.c:740 <= Recv header: Content-Length: 20109 14:40:39.153756 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:39.153756 http.c:740 <= Recv header: 14:40:39.153756 http.c:781 == Info: Ignoring the response-body 14:40:39.153756 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:39.153756 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack' 14:40:39.154758 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x20713292f10 [serially] 14:40:39.154758 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:39.154758 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:39.154758 http.c:781 == Info: Server auth using NTLM with user '' 14:40:39.154758 http.c:728 => Send header, 0000000324 bytes (0x00000144) 14:40:39.154758 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:39.154758 http.c:740 => Send header: Host: SERVERADDRESS 14:40:39.154758 http.c:740 => Send header: Authorization: NTLM 14:40:39.154758 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:39.154758 http.c:740 => Send header: Accept: */* 14:40:39.154758 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:39.154758 http.c:740 => Send header: Pragma: no-cache 14:40:39.154758 http.c:740 => Send header: Git-Protocol: version=2 14:40:39.154758 http.c:740 => Send header: 14:40:39.154758 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:39.154758 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:39.154758 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:39.154758 http.c:728 <= Recv header, 0000000043 bytes (0x0000002b) 14:40:39.154758 http.c:740 <= Recv header: Content-Type: text/html; charset=us-ascii 14:40:39.154758 http.c:728 <= Recv header, 0000000031 bytes (0x0000001f) 14:40:39.154758 http.c:740 <= Recv header: Server: Microsoft-HTTPAPI/2.0 14:40:39.154758 http.c:728 <= Recv header, 0000000353 bytes (0x00000161) 14:40:39.154758 http.c:740 <= Recv header: WWW-Authenticate: NTLM TlRMTVNTUAACAAAADAAMADgAAAAFwomiv2h71c0zP4LrAQEAAAAAALAAsABEAAAACgBhSgAAAA9HAEwATwBCAEEATAACAAwARwBMAE8AQgBBAEwAAQAQAEwAVABEAEUANgA1ADYANgAEACQARwBMAE8AQgBBAEwALgBCAEMARQBDAE8AUgBQAC4ATgBFAFQAAwA2AEwAVABEAEUANgA1ADYANgAuAEcATABPAEIAQQBMAC4AQgBDAEUAQwBPAFIAUAAuAE4ARQBUAAUAFgBCAEMARQBDAE8AUgBQAC4ATgBFAFQABwAIAMOCz8g6I9gBAAAAAA== 14:40:39.154758 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:39.154758 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:39 GMT 14:40:39.154758 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:39.154758 http.c:740 <= Recv header: Content-Length: 341 14:40:39.154758 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:39.154758 http.c:740 <= Recv header: 14:40:39.154758 http.c:781 == Info: Ignoring the response-body 14:40:39.154758 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:39.154758 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack' 14:40:39.155753 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x20713292f10 [serially] 14:40:39.155753 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:39.155753 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:39.161751 http.c:781 == Info: Server auth using NTLM with user '' 14:40:39.161751 http.c:728 => Send header, 0000000372 bytes (0x00000174) 14:40:39.161751 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:39.161751 http.c:740 => Send header: Host: SERVERADDRESS 14:40:39.161751 http.c:740 => Send header: Authorization: NTLM 14:40:39.161751 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:39.161751 http.c:740 => Send header: Accept: */* 14:40:39.161751 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:39.161751 http.c:740 => Send header: Pragma: no-cache 14:40:39.161751 http.c:740 => Send header: Git-Protocol: version=2 14:40:39.161751 http.c:740 => Send header: 14:40:39.172756 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:39.172756 http.c:728 <= Recv header, 0000000017 bytes (0x00000011) 14:40:39.172756 http.c:740 <= Recv header: HTTP/1.1 200 OK 14:40:39.172756 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:39.172756 http.c:740 <= Recv header: Cache-Control: private 14:40:39.172756 http.c:728 <= Recv header, 0000000059 bytes (0x0000003b) 14:40:39.172756 http.c:740 <= Recv header: Content-Type: application/x-git-upload-pack-advertisement 14:40:39.172756 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:39.172756 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:39.172756 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:39.172756 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:39.172756 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:39.172756 http.c:740 <= Recv header: ActivityId: 3a39824e-e64f-4399-9898-513b7b8fefe8 14:40:39.172756 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:39.172756 http.c:740 <= Recv header: X-TFS-Session: 3a39824e-e64f-4399-9898-513b7b8fefe8 14:40:39.172756 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:39.172756 http.c:740 <= Recv header: X-VSS-E2EID: 3a39824e-e64f-4399-9898-513b7b8fefe8 14:40:39.172756 http.c:728 <= Recv header, 0000000066 bytes (0x00000042) 14:40:39.172756 http.c:740 <= Recv header: X-VSS-UserData: 5b5ce3ba-4b39-4fd2-8851-ea5fc53781f3:SAMACKOWIAK 14:40:39.172756 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:39.172756 http.c:740 <= Recv header: X-FRAME-OPTIONS: SAMEORIGIN 14:40:39.172756 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:39.172756 http.c:740 <= Recv header: Persistent-Auth: true 14:40:39.172756 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:39.172756 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:39.172756 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:39.172756 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:39.172756 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:39.172756 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:39.172756 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:39.172756 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:39.172756 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:39.172756 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:39 GMT 14:40:39.172756 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:39.172756 http.c:740 <= Recv header: Content-Length: 296 14:40:39.172756 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:39.172756 http.c:740 <= Recv header: 14:40:39.172756 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:39.172756 run-command.c:738 | d3 | main | child_start | | 2.901213 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe store'] 14:40:40.952876 run-command.c:993 | d3 | main | child_exit | | 4.681301 | 1.780088 | | [ch1] pid:4888 code:0 14:40:40.954875 ..._win32_process_info.c:166 | d3 | main | data_json | r1 | 4.683173 | 4.683173 | process | windows/memory:{"PageFaultCount":8216,"PeakWorkingSetSize":11317248,"PeakPagefileUsage":4050944} 14:40:40.954875 common-main.c:54 | d3 | main | exit | | 4.683202 | | | code:0 14:40:40.954875 trace2/tr2_tgt_perf.c:213 | d3 | main | atexit | | 4.683344 | | | code:0 14:40:40.961888 run-command.c:993 | d2 | main | child_exit | | 4.759955 | 4.717721 | | [ch0] pid:20664 code:0 14:40:40.961888 ..._win32_process_info.c:166 | d2 | main | data_json | r0 | 4.760670 | 4.760670 | process | windows/memory:{"PageFaultCount":6579,"PeakWorkingSetSize":8024064,"PeakPagefileUsage":3768320} 14:40:40.961888 git.c:833 | d2 | main | exit | | 4.760696 | | | code:0 14:40:40.961888 trace2/tr2_tgt_perf.c:213 | d2 | main | atexit | | 4.760714 | | | code:0 14:40:40.966875 run-command.c:993 | d1 | main | child_exit | | 4.830387 | 4.789803 | | [ch0] pid:2564 code:0 14:40:40.967875 ..._win32_process_info.c:166 | d1 | main | data_json | r1 | 4.831142 | 4.831142 | process | windows/memory:{"PageFaultCount":5954,"PeakWorkingSetSize":7835648,"PeakPagefileUsage":3764224} 14:40:40.967875 git.c:785 | d1 | main | exit | | 4.831167 | | | code:0 14:40:40.967875 trace2/tr2_tgt_perf.c:213 | d1 | main | atexit | | 4.831180 | | | code:0 14:40:40.976874 run-command.c:993 | d0 | main | child_exit | | 5.004602 | 4.864782 | | [ch1] pid:16360 code:0 14:40:40.976874 run-command.c:738 | d0 | main | child_start | | 5.004754 | | | [ch2] class:? argv:[git gvfs-helper --remote https://SERVERADDRESS/DefaultCollection/Test/_git/Test endpoint vsts/info] 14:40:41.014875 common-main.c:48 | d1 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.015876 common-main.c:49 | d1 | main | start | | 0.011852 | | | git gvfs-helper --remote https://SERVERADDRESS/DefaultCollection/Test/_git/Test endpoint vsts/info 14:40:41.041875 ..._win32_process_info.c:118 | d1 | main | data_json | r0 | 0.037107 | 0.037107 | process | windows/ancestry:["scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.042876 git.c:808 | d1 | main | cmd_name | | | | | _run_dashed_ (_run_dashed_) 14:40:41.044875 run-command.c:738 | d1 | main | child_start | | 0.041007 | | | [ch0] class:dashed argv:[git-gvfs-helper --remote https://SERVERADDRESS/DefaultCollection/Test/_git/Test endpoint vsts/info] 14:40:41.083875 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.084875 common-main.c:49 | d2 | main | start | | 0.011490 | | | git-gvfs-helper --remote https://SERVERADDRESS/DefaultCollection/Test/_git/Test endpoint vsts/info 14:40:41.114874 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.041795 | 0.041795 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.114874 gvfs-helper.c:4175 | d2 | main | cmd_name | | | | | gvfs-helper (_run_dashed_/gvfs-helper) 14:40:41.115874 repository.c:132 | d2 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:41.116875 gvfs-helper.c:3618 | d2 | main | cmd_mode | | | | | vsts/info 14:40:41.117874 gvfs-helper.c:1334 | d2 | main | data | | 0.044299 | 0.044299 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:41.120876 gvfs-helper.c:1150 | d2 | main | region_enter | | 0.047224 | | gvfs-helper | label:vsts/info(main) 14:40:41.126874 http.c:781 == Info: Trying SERVERIP:443... 14:40:41.127875 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:41.127875 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:40:41.137875 http.c:728 => Send header, 0000000172 bytes (0x000000ac) 14:40:41.137875 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/vsts/info HTTP/1.1 14:40:41.137875 http.c:740 => Send header: Host: SERVERADDRESS 14:40:41.137875 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:41.137875 http.c:740 => Send header: Accept: */* 14:40:41.137875 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:40:41.137875 http.c:740 => Send header: Pragma: no-cache 14:40:41.137875 http.c:740 => Send header: 14:40:41.141875 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:41.141875 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:41.141875 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:41.141875 http.c:728 <= Recv header, 0000000040 bytes (0x00000028) 14:40:41.141875 http.c:740 <= Recv header: Content-Type: text/html; charset=utf-8 14:40:41.141875 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:41.141875 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:41.141875 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:41.141875 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:41.141875 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:41.141875 http.c:740 <= Recv header: ActivityId: 3a398240-e64f-4399-9898-513b7b8fefe8 14:40:41.141875 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:41.141875 http.c:740 <= Recv header: X-TFS-Session: 3a398240-e64f-4399-9898-513b7b8fefe8 14:40:41.141875 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:41.141875 http.c:740 <= Recv header: X-VSS-E2EID: 3a398240-e64f-4399-9898-513b7b8fefe8 14:40:41.141875 http.c:728 <= Recv header, 0000000690 bytes (0x000002b2) 14:40:41.141875 http.c:740 <= Recv header: X-TFS-SoapException: %3C%3Fxml%20version%3D%221.0%22%20encoding%3D%22utf-8%22%3F%3E%3Csoap%3AEnvelope%20xmlns%3Asoap%3D%22http%3A%2F%2Fwww.w3.org%2F2003%2F05%2Fsoap-envelope%22%3E%3Csoap%3ABody%3E%3Csoap%3AFault%3E%3Csoap%3ACode%3E%3Csoap%3AValue%3Esoap%3AReceiver%3C%2Fsoap%3AValue%3E%3Csoap%3ASubcode%3E%3Csoap%3AValue%3EUnauthorizedRequestException%3C%2Fsoap%3AValue%3E%3C%2Fsoap%3ASubcode%3E%3C%2Fsoap%3ACode%3E%3Csoap%3AReason%3E%3Csoap%3AText%20xml%3Alang%3D%22en%22%3ETF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required.%3C%2Fsoap%3AText%3E%3C%2Fsoap%3AReason%3E%3C%2Fsoap%3AFault%3E%3C%2Fsoap%3ABody%3E%3C%2Fsoap%3AEnvelope%3E 14:40:41.141875 http.c:728 <= Recv header, 0000000128 bytes (0x00000080) 14:40:41.141875 http.c:740 <= Recv header: X-TFS-ServiceError: TF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required. 14:40:41.141875 http.c:728 <= Recv header, 0000000026 bytes (0x0000001a) 14:40:41.141875 http.c:740 <= Recv header: WWW-Authenticate: Bearer 14:40:41.141875 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:41.141875 http.c:740 <= Recv header: WWW-Authenticate: Basic realm="https://SERVERADDRESS/" 14:40:41.141875 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:41.141875 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:41.144874 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:41.144874 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:41.144874 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:41.144874 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:41.144874 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:41.144874 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:41.144874 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:41.144874 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:41.144874 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:41.144874 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:41.144874 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:41.144874 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:40 GMT 14:40:41.144874 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:41.144874 http.c:740 <= Recv header: Content-Length: 20081 14:40:41.144874 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:41.144874 http.c:740 <= Recv header: 14:40:41.144874 http.c:781 == Info: Ignoring the response-body 14:40:41.144874 progress.c:268 | d2 | main | region_enter | r1 | 0.071370 | | progress | ..label:Receiving vsts/info (bytes received) 14:40:41.144874 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:41.144874 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/vsts/info' 14:40:41.144874 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x238a7822f80 [serially] 14:40:41.144874 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:41.144874 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:41.145875 http.c:781 == Info: Server auth using Negotiate with user '' 14:40:41.145875 http.c:728 => Send header, 0000000363 bytes (0x0000016b) 14:40:41.145875 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/vsts/info HTTP/1.1 14:40:41.145875 http.c:740 => Send header: Host: SERVERADDRESS 14:40:41.145875 http.c:740 => Send header: Authorization: Negotiate 14:40:41.145875 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:41.145875 http.c:740 => Send header: Accept: */* 14:40:41.145875 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:40:41.145875 http.c:740 => Send header: Pragma: no-cache 14:40:41.145875 http.c:740 => Send header: 14:40:41.145875 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:41.145875 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:41.145875 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:41.145875 http.c:728 <= Recv header, 0000000043 bytes (0x0000002b) 14:40:41.145875 http.c:740 <= Recv header: Content-Type: text/html; charset=us-ascii 14:40:41.145875 http.c:728 <= Recv header, 0000000031 bytes (0x0000001f) 14:40:41.145875 http.c:740 <= Recv header: Server: Microsoft-HTTPAPI/2.0 14:40:41.150909 http.c:728 <= Recv header, 0000000402 bytes (0x00000192) 14:40:41.150909 http.c:740 <= Recv header: WWW-Authenticate: Negotiate oYIBETCCAQ2gAwoBAaEMBgorBgEEAYI3AgIKooH3BIH0TlRMTVNTUAACAAAADAAMADgAAAA1woniSao4tZhNrtrsAQEAAAAAALAAsABEAAAACgBhSgAAAA9HAEwATwBCAEEATAACAAwARwBMAE8AQgBBAEwAAQAQAEwAVABEAEUANgA1ADYANgAEACQARwBMAE8AQgBBAEwALgBCAEMARQBDAE8AUgBQAC4ATgBFAFQAAwA2AEwAVABEAEUANgA1ADYANgAuAEcATABPAEIAQQBMAC4AQgBDAEUAQwBPAFIAUAAuAE4ARQBUAAUAFgBCAEMARQBDAE8AUgBQAC4ATgBFAFQABwAIAMRU/8k6I9gBAAAAAA== 14:40:41.150909 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:41.150909 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:40 GMT 14:40:41.150909 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:41.150909 http.c:740 <= Recv header: Content-Length: 341 14:40:41.150909 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:41.150909 http.c:740 <= Recv header: 14:40:41.150909 http.c:781 == Info: Ignoring the response-body 14:40:41.151903 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:41.151903 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/vsts/info' 14:40:41.151903 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x238a7822f80 [serially] 14:40:41.151903 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:41.151903 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:41.151903 http.c:781 == Info: Server auth using Negotiate with user '' 14:40:41.151903 http.c:728 => Send header, 0000000363 bytes (0x0000016b) 14:40:41.151903 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/vsts/info HTTP/1.1 14:40:41.151903 http.c:740 => Send header: Host: SERVERADDRESS 14:40:41.151903 http.c:740 => Send header: Authorization: Negotiate 14:40:41.151903 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:41.151903 http.c:740 => Send header: Accept: */* 14:40:41.151903 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:40:41.151903 http.c:740 => Send header: Pragma: no-cache 14:40:41.151903 http.c:740 => Send header: 14:40:41.160876 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:41.160876 http.c:728 <= Recv header, 0000000017 bytes (0x00000011) 14:40:41.160876 http.c:740 <= Recv header: HTTP/1.1 200 OK 14:40:41.160876 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:41.160876 http.c:740 <= Recv header: Cache-Control: private 14:40:41.160876 http.c:728 <= Recv header, 0000000047 bytes (0x0000002f) 14:40:41.160876 http.c:740 <= Recv header: Content-Type: application/json; charset=utf-8 14:40:41.160876 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:41.160876 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:41.160876 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:41.160876 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:41.160876 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:41.160876 http.c:740 <= Recv header: ActivityId: 3a398241-e64f-4399-9898-513b7b8fefe8 14:40:41.160876 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:41.160876 http.c:740 <= Recv header: X-TFS-Session: 3a398241-e64f-4399-9898-513b7b8fefe8 14:40:41.160876 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:41.160876 http.c:740 <= Recv header: X-VSS-E2EID: 3a398241-e64f-4399-9898-513b7b8fefe8 14:40:41.160876 http.c:728 <= Recv header, 0000000066 bytes (0x00000042) 14:40:41.160876 http.c:740 <= Recv header: X-VSS-UserData: 5b5ce3ba-4b39-4fd2-8851-ea5fc53781f3:SAMACKOWIAK 14:40:41.160876 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:41.160876 http.c:740 <= Recv header: X-FRAME-OPTIONS: SAMEORIGIN 14:40:41.160876 http.c:781 == Info: Negotiate: noauthpersist -> 0, header part: true 14:40:41.160876 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:41.160876 http.c:740 <= Recv header: Persistent-Auth: true 14:40:41.160876 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:41.160876 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:41.160876 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:41.160876 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:41.160876 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:41.160876 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:41.160876 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:41.160876 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:41.160876 http.c:728 <= Recv header, 0000000070 bytes (0x00000046) 14:40:41.160876 http.c:740 <= Recv header: WWW-Authenticate: Negotiate oRswGaADCgEAoxIEEAEAAACsrraAb4VWHAAAAAA= 14:40:41.160876 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:41.160876 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:40 GMT 14:40:41.160876 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:41.160876 http.c:740 <= Recv header: Content-Length: 703 14:40:41.160876 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:41.160876 http.c:740 <= Recv header: 14:40:41.160876 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:41.160876 gvfs-helper.c:1174 | d2 | main | data | | 0.087816 | 0.016446 | gvfs-helper | ....vsts/info(main)/nr_bytes:703 14:40:41.160876 progress.c:328 | d2 | main | data | r1 | 0.087832 | 0.016462 | progress | ....total_objects:20081 14:40:41.160876 progress.c:336 | d2 | main | region_leave | r1 | 0.087843 | 0.016473 | progress | ..label:Receiving vsts/info (bytes received) Receiving vsts/info (bytes received): 3% (703/20081), done. 14:40:41.161876 gvfs-helper.c:1187 | d2 | main | region_leave | | 0.088435 | 0.041211 | gvfs-helper | label:vsts/info(main) 14:40:41.162876 ..._win32_process_info.c:166 | d2 | main | data_json | r1 | 0.089654 | 0.089654 | process | windows/memory:{"PageFaultCount":7480,"PeakWorkingSetSize":11096064,"PeakPagefileUsage":4071424} 14:40:41.162876 common-main.c:54 | d2 | main | exit | | 0.089681 | | | code:0 14:40:41.162876 trace2/tr2_tgt_perf.c:213 | d2 | main | atexit | | 0.089817 | | | code:0 14:40:41.166879 run-command.c:993 | d1 | main | child_exit | | 0.162514 | 0.121507 | | [ch0] pid:5188 code:0 14:40:41.166879 ..._win32_process_info.c:166 | d1 | main | data_json | r0 | 0.162997 | 0.162997 | process | windows/memory:{"PageFaultCount":5873,"PeakWorkingSetSize":7831552,"PeakPagefileUsage":3772416} 14:40:41.166879 git.c:833 | d1 | main | exit | | 0.163022 | | | code:0 14:40:41.167875 trace2/tr2_tgt_perf.c:213 | d1 | main | atexit | | 0.163316 | | | code:0 14:40:41.183541 run-command.c:993 | d0 | main | child_exit | | 5.211069 | 0.206315 | | [ch2] pid:28348 code:0 Cache server URL: https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:40:41.200551 run-command.c:738 | d0 | main | child_start | | 5.228257 | | | [ch3] class:? argv:[git sparse-checkout init --cone] 14:40:41.233356 common-main.c:48 | d1 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.234356 common-main.c:49 | d1 | main | start | | 0.012166 | | | git sparse-checkout init --cone 14:40:41.260355 ..._win32_process_info.c:118 | d1 | main | data_json | r0 | 0.037551 | 0.037551 | process | windows/ancestry:["scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.261356 repository.c:132 | d1 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:41.263357 git.c:523 | d1 | main | cmd_name | | | | | sparse-checkout (sparse-checkout) 14:40:41.263357 read-cache.c:2405 | d1 | main | region_enter | r1 | 0.040813 | | index | label:do_read_index .git/index 14:40:41.263357 read-cache.c:2410 | d1 | main | region_leave | r1 | 0.040897 | 0.000084 | index | label:do_read_index .git/index 14:40:41.263357 fsmonitor-ipc.c:49 | d1 | main | region_enter | | 0.041048 | | fsm_client | label:query 14:40:41.263357 fsmonitor-ipc.c:50 | d1 | main | data | | 0.041063 | 0.000015 | fsm_client | ..query/command:1645018841263592400 14:40:41.263357 ...imple-ipc/ipc-win32.c:199 | d1 | main | region_enter | | 0.041077 | | ipc-client | ..label:try-connect 14:40:41.263357 ...imple-ipc/ipc-win32.c:200 | d1 | main | data | | 0.041088 | 0.000011 | ipc-client | ....try-connect/path:.git/fsmonitor--daemon.ipc 14:40:41.263357 ...imple-ipc/ipc-win32.c:208 | d1 | main | data | | 0.041273 | 0.000196 | ipc-client | ....try-connect/state:3 14:40:41.263357 ...imple-ipc/ipc-win32.c:210 | d1 | main | region_leave | | 0.041289 | 0.000212 | ipc-client | ..label:try-connect 14:40:41.263357 run-command.c:738 | d1 | main | child_start | | 0.041303 | | | ..[ch0] class:fsmonitor argv:[git fsmonitor--daemon start] 14:40:41.299357 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.299357 common-main.c:49 | d2 | main | start | | 0.011605 | | | git fsmonitor--daemon start 14:40:41.328355 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040559 | 0.040559 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.329355 repository.c:132 | d2 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:41.330356 git.c:523 | d2 | main | cmd_name | | | | | fsmonitor--daemon (sparse-checkout/fsmonitor--daemon) starting fsmonitor-daemon in 'C:/testZ/1/2/15/Test/src' 14:40:41.405356 ..._win32_process_info.c:166 | d2 | main | data_json | r1 | 0.117047 | 0.117047 | process | windows/memory:{"PageFaultCount":6599,"PeakWorkingSetSize":8019968,"PeakPagefileUsage":3760128} 14:40:41.405356 git.c:785 | d2 | main | exit | | 0.117073 | | | code:0 14:40:41.405356 trace2/tr2_tgt_perf.c:213 | d2 | main | atexit | | 0.117085 | | | code:0 14:40:41.409356 run-command.c:993 | d1 | main | child_exit | | 0.187329 | 0.146026 | | ..[ch0] pid:1180 code:0 14:40:41.409356 ...imple-ipc/ipc-win32.c:199 | d1 | main | region_enter | | 0.187371 | | ipc-client | ..label:try-connect 14:40:41.409356 ...imple-ipc/ipc-win32.c:200 | d1 | main | data | | 0.187384 | 0.000013 | ipc-client | ....try-connect/path:.git/fsmonitor--daemon.ipc 14:40:41.410356 ...imple-ipc/ipc-win32.c:208 | d1 | main | data | | 0.187643 | 0.000272 | ipc-client | ....try-connect/state:0 14:40:41.410356 ...imple-ipc/ipc-win32.c:210 | d1 | main | region_leave | | 0.187659 | 0.000288 | ipc-client | ..label:try-connect 14:40:41.410356 ...imple-ipc/ipc-win32.c:240 | d1 | main | region_enter | | 0.187670 | | ipc-client | ..label:send-command 14:40:41.410356 ...imple-ipc/ipc-win32.c:259 | d1 | main | region_leave | | 0.187971 | 0.000301 | ipc-client | ..label:send-command 14:40:41.410356 fsmonitor-ipc.c:62 | d1 | main | data | | 0.188002 | 0.146954 | fsm_client | ..query/response-length:44 14:40:41.410356 fsmonitor-ipc.c:66 | d1 | main | data | | 0.188044 | 0.146996 | fsm_client | ..query/trivial-response:1 14:40:41.410356 fsmonitor-ipc.c:108 | d1 | main | region_leave | | 0.188054 | 0.147006 | fsm_client | label:query 14:40:41.422356 ..._win32_process_info.c:166 | d1 | main | data_json | r1 | 0.199502 | 0.199502 | process | windows/memory:{"PageFaultCount":5967,"PeakWorkingSetSize":7847936,"PeakPagefileUsage":3756032} 14:40:41.422356 git.c:785 | d1 | main | exit | | 0.199530 | | | code:0 14:40:41.422356 trace2/tr2_tgt_perf.c:213 | d1 | main | atexit | | 0.199544 | | | code:0 14:40:41.425356 run-command.c:993 | d0 | main | child_exit | | 5.452880 | 0.224623 | | [ch3] pid:3168 code:0 14:40:41.426356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.453695 | 5.453695 | scalar | am.keepCR:created 14:40:41.429356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.456734 | 5.456734 | scalar | core.FSCache:exists 14:40:41.429356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.456757 | 5.456757 | scalar | core.multiPackIndex:created 14:40:41.432356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.459745 | 5.459745 | scalar | core.preloadIndex:created 14:40:41.435358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.463103 | 5.463103 | scalar | core.untrackedCache:created 14:40:41.439356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.466560 | 5.466560 | scalar | core.bare:exists 14:40:41.439356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.466586 | 5.466586 | scalar | core.logAllRefUpdates:exists 14:40:41.439356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.466599 | 5.466599 | scalar | credential.https://dev.azure.com.useHttpPath:exists 14:40:41.439356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.466609 | 5.466609 | scalar | credential.validate:created 14:40:41.441356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.469395 | 5.469395 | scalar | gc.auto:created 14:40:41.444356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.472137 | 5.472137 | scalar | gui.GCWarning:created 14:40:41.447356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.474829 | 5.474829 | scalar | index.threads:created 14:40:41.450357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.477873 | 5.477873 | scalar | index.version:created 14:40:41.453357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.480834 | 5.480834 | scalar | merge.stat:created 14:40:41.456356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.483882 | 5.483882 | scalar | merge.renames:created 14:40:41.459356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.486647 | 5.486647 | scalar | pack.useBitmaps:created 14:40:41.461356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.489380 | 5.489380 | scalar | pack.useSparse:created 14:40:41.464356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.492137 | 5.492137 | scalar | receive.autoGC:created 14:40:41.467357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.495234 | 5.495234 | scalar | reset.quiet:created 14:40:41.470356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.498270 | 5.498270 | scalar | feature.manyFiles:created 14:40:41.473356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.501109 | 5.501109 | scalar | feature.experimental:created 14:40:41.476356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.503891 | 5.503891 | scalar | fetch.unpackLimit:created 14:40:41.479356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.506647 | 5.506647 | scalar | fetch.writeCommitGraph:created 14:40:41.482360 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.509750 | 5.509750 | scalar | http.sslBackend:exists 14:40:41.482360 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.509777 | 5.509777 | scalar | status.aheadBehind:created 14:40:41.485356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.513004 | 5.513004 | scalar | commitGraph.generationVersion:created 14:40:41.488356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.516102 | 5.516102 | scalar | core.autoCRLF:exists 14:40:41.488356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.516126 | 5.516126 | scalar | core.safeCRLF:created 14:40:41.491358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.519364 | 5.519364 | scalar | maintenance.gc.enabled:created 14:40:41.494357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.522322 | 5.522322 | scalar | maintenance.prefetch.enabled:created 14:40:41.497358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.525215 | 5.525215 | scalar | maintenance.prefetch.auto:created 14:40:41.500358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.528272 | 5.528272 | scalar | maintenance.prefetch.schedule:created 14:40:41.503359 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.531216 | 5.531216 | scalar | maintenance.commit-graph.enabled:created 14:40:41.506357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.534168 | 5.534168 | scalar | maintenance.commit-graph.auto:created 14:40:41.509357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.537031 | 5.537031 | scalar | maintenance.commit-graph.schedule:created 14:40:41.512357 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.539927 | 5.539927 | scalar | maintenance.loose-objects.enabled:created 14:40:41.515358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.542992 | 5.542992 | scalar | maintenance.loose-objects.auto:created 14:40:41.518358 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.545945 | 5.545945 | scalar | maintenance.loose-objects.schedule:created 14:40:41.521359 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.549385 | 5.549385 | scalar | maintenance.incremental-repack.enabled:created 14:40:41.525356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.552629 | 5.552629 | scalar | maintenance.incremental-repack.auto:created 14:40:41.528356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.555528 | 5.555528 | scalar | maintenance.incremental-repack.schedule:created 14:40:41.531356 contrib/scalar/scalar.c:236 | d0 | main | data | r1 | 5.558675 | 5.558675 | scalar | core.useBuiltinFSMonitor:exists 14:40:41.531356 contrib/scalar/scalar.c:230 | d0 | main | data | r1 | 5.558701 | 5.558701 | scalar | core.configWriteLockTimeoutMS:created 14:40:41.534356 contrib/scalar/scalar.c:246 | d0 | main | data | r1 | 5.562003 | 5.562003 | scalar | log.excludeDecoration:created 14:40:41.539356 run-command.c:738 | d0 | main | child_start | | 5.566534 | | | [ch4] class:? argv:[git fetch --quiet origin] 14:40:41.572384 common-main.c:48 | d1 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.573384 common-main.c:49 | d1 | main | start | | 0.011911 | | | git fetch --quiet origin 14:40:41.598383 ..._win32_process_info.c:118 | d1 | main | data_json | r0 | 0.037636 | 0.037636 | process | windows/ancestry:["scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.600384 repository.c:132 | d1 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:41.602384 git.c:523 | d1 | main | cmd_name | | | | | fetch (fetch) 14:40:41.602384 read-cache.c:2405 | d1 | main | region_enter | r1 | 0.041361 | | index | label:do_read_index .git/index 14:40:41.602384 read-cache.c:2410 | d1 | main | region_leave | r1 | 0.041465 | 0.000104 | index | label:do_read_index .git/index 14:40:41.602384 fsmonitor-ipc.c:49 | d1 | main | region_enter | | 0.041633 | | fsm_client | label:query 14:40:41.602384 fsmonitor-ipc.c:50 | d1 | main | data | | 0.041647 | 0.000014 | fsm_client | ..query/command:1645018841602935700 14:40:41.602384 ...imple-ipc/ipc-win32.c:199 | d1 | main | region_enter | | 0.041689 | | ipc-client | ..label:try-connect 14:40:41.602384 ...imple-ipc/ipc-win32.c:200 | d1 | main | data | | 0.041699 | 0.000010 | ipc-client | ....try-connect/path:.git/fsmonitor--daemon.ipc 14:40:41.603394 ...imple-ipc/ipc-win32.c:208 | d1 | main | data | | 0.042017 | 0.000328 | ipc-client | ....try-connect/state:0 14:40:41.603394 ...imple-ipc/ipc-win32.c:210 | d1 | main | region_leave | | 0.042060 | 0.000371 | ipc-client | ..label:try-connect 14:40:41.603394 ...imple-ipc/ipc-win32.c:240 | d1 | main | region_enter | | 0.042072 | | ipc-client | ..label:send-command 14:40:41.603394 ...imple-ipc/ipc-win32.c:259 | d1 | main | region_leave | | 0.042315 | 0.000243 | ipc-client | ..label:send-command 14:40:41.603394 fsmonitor-ipc.c:62 | d1 | main | data | | 0.042363 | 0.000730 | fsm_client | ..query/response-length:44 14:40:41.603394 fsmonitor-ipc.c:66 | d1 | main | data | | 0.042393 | 0.000760 | fsm_client | ..query/trivial-response:1 14:40:41.603394 fsmonitor-ipc.c:108 | d1 | main | region_leave | | 0.042403 | 0.000770 | fsm_client | label:query 14:40:41.605384 run-command.c:738 | d1 | main | child_start | | 0.044343 | | | [ch0] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:40:41.641384 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.642384 common-main.c:49 | d2 | main | start | | 0.011206 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:40:41.670383 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.039838 | 0.039838 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.672385 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:40:41.672385 run-command.c:738 | d2 | main | child_start | | 0.041614 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:40:41.712383 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:40:41.713383 common-main.c:49 | d3 | main | start | | 0.012137 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:40:41.746382 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.045237 | 0.045237 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:41.746382 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:40:41.747384 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:41.748384 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:40:41.749384 gvfs-helper.c:1334 | d3 | main | data | | 0.048574 | 0.048574 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:41.752384 gvfs-helper.c:1392 | d3 | main | data | | 0.051321 | 0.051321 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:40:41.752384 gvfs-helper-client.c:539 | d1 | main | region_enter | r1 | 0.191678 | | gh-client | label:objects/prefetch 14:40:41.753386 run-command.c:738 | d3 | main | child_start | | 0.052087 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:40:41.752384 gvfs-helper-client.c:540 | d1 | main | data | r1 | 0.191705 | 0.000027 | gh-client | ..prefetch/since:0 14:40:44.535929 run-command.c:993 | d3 | main | child_exit | | 2.834982 | 2.782895 | | [ch0] pid:23524 code:0 14:40:44.536930 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.835689 | | gvfs-helper | label:(cs) 14:40:44.546929 http.c:781 == Info: Trying PROXYIP:443... 14:40:44.731203 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:40:44.731203 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:40:45.102294 http.c:781 == Info: Server auth using Basic with user '' 14:40:45.102294 http.c:728 => Send header, 0000000273 bytes (0x00000111) 14:40:45.102294 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/prefetch HTTP/1.1 14:40:45.102294 http.c:740 => Send header: Host: PROXYADDRESS 14:40:45.102294 http.c:740 => Send header: Authorization: Basic 14:40:45.103264 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:45.103264 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:40:45.103264 http.c:740 => Send header: Pragma: no-cache 14:40:45.103264 http.c:740 => Send header: Accept: application/x-gvfs-timestamped-packfiles-indexes 14:40:45.103264 http.c:740 => Send header: 14:40:45.275282 http.c:781 == Info: schannel: remote party requests renegotiation 14:40:45.275282 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:40:45.632731 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:40:46.371056 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:46.371056 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:46.371056 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:46.372104 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:46.372104 http.c:740 <= Recv header: Cache-Control: private 14:40:46.372104 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:40:46.372104 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:40:46.372104 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:46.372104 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:40:46.372104 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:46.372104 http.c:740 <= Recv header: ActivityId: 194d9f99-c6d8-4394-b892-fc34ee92f58e 14:40:46.372104 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:46.372104 http.c:740 <= Recv header: X-TFS-Session: 194d9f99-c6d8-4394-b892-fc34ee92f58e 14:40:46.372104 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:46.372104 http.c:740 <= Recv header: X-VSS-E2EID: 194d9f99-c6d8-4394-b892-fc34ee92f58e 14:40:46.372104 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:40:46.372104 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:40:46.372104 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:46.372104 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:46.379041 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:46.379041 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:46.379041 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:46.379041 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:46.379041 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:46.379041 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:46 GMT 14:40:46.379041 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:40:46.379041 http.c:740 <= Recv header: Content-Length: 72 14:40:46.379041 http.c:781 == Info: The requested URL returned error: 401 14:40:46.379041 http.c:781 == Info: Closing connection 0 14:40:46.379041 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:40:46.379041 gvfs-helper.c:1187 | d3 | main | region_leave | | 4.678097 | 1.842408 | gvfs-helper | label:(cs) 14:40:46.379041 run-command.c:738 | d3 | main | child_start | | 4.678224 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:40:49.159820 run-command.c:993 | d3 | main | child_exit | | 7.458229 | 2.780005 | | [ch1] pid:26000 code:0 14:40:49.159820 run-command.c:738 | d3 | main | child_start | | 7.458467 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:40:51.960926 run-command.c:993 | d3 | main | child_exit | | 10.259299 | 2.800832 | | [ch2] pid:28080 code:0 14:40:51.961906 gvfs-helper.c:1150 | d3 | main | region_enter | | 10.260531 | | gvfs-helper | label:(cs) 14:40:51.961906 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:40:51.961906 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:40:51.961906 http.c:781 == Info: Trying PROXYIP:443... 14:40:52.158155 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:40:52.333184 http.c:781 == Info: Server auth using Basic with user '' 14:40:52.333184 http.c:728 => Send header, 0000000273 bytes (0x00000111) 14:40:52.333184 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/prefetch HTTP/1.1 14:40:52.333184 http.c:740 => Send header: Host: PROXYADDRESS 14:40:52.333184 http.c:740 => Send header: Authorization: Basic 14:40:52.333184 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:52.333184 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:40:52.333184 http.c:740 => Send header: Pragma: no-cache 14:40:52.333184 http.c:740 => Send header: Accept: application/x-gvfs-timestamped-packfiles-indexes 14:40:52.333184 http.c:740 => Send header: 14:40:52.508060 http.c:781 == Info: schannel: remote party requests renegotiation 14:40:52.508060 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:40:52.861220 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:40:52.863229 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:52.864249 usage.c:74 | d1 | main | error | | | | | ..gvfs-helper error: '(http:401) Not Authorized' 14:40:52.863229 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:52.863229 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:52.863229 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:52.863229 http.c:740 <= Recv header: Cache-Control: private 14:40:52.863229 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:40:52.863229 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:40:52.863229 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:52.863229 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:40:52.863229 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:52.863229 http.c:740 <= Recv header: ActivityId: 194d9f9e-c6d8-4394-b892-fc34ee92f58e 14:40:52.863229 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:52.863229 http.c:740 <= Recv header: X-TFS-Session: 194d9f9e-c6d8-4394-b892-fc34ee92f58e 14:40:52.863229 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:52.863229 http.c:740 <= Recv header: X-VSS-E2EID: 194d9f9e-c6d8-4394-b892-fc34ee92f58e 14:40:52.863229 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:40:52.863229 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:40:52.863229 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:52.863229 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:52.863229 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:52.863229 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:52.863229 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:52.863229 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:52.863229 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:52.863229 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:52 GMT 14:40:52.863229 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:40:52.863229 http.c:740 <= Recv header: Content-Length: 72 14:40:52.863229 http.c:781 == Info: The requested URL returned error: 401 14:40:52.863229 http.c:781 == Info: Closing connection 1 14:40:52.863229 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:40:52.863229 gvfs-helper.c:1187 | d3 | main | region_leave | | 11.162347 | 0.901816 | gvfs-helper | label:(cs) error: gvfs-helper error: '(http:401) Not Authorized' 14:40:52.882262 run-command.c:993 | d1 | main | child_exit | | 11.321009 | 11.276666 | | ..[ch0] pid:17444 code:143 14:40:52.882262 gvfs-helper-client.c:560 | d1 | main | data | r1 | 11.321054 | 11.129376 | gh-client | ..prefetch/packfile_count:0 14:40:52.882262 gvfs-helper-client.c:562 | d1 | main | region_leave | r1 | 11.321069 | 11.129391 | gh-client | label:objects/prefetch 14:40:52.882262 builtin/fetch.c:1573 | d1 | main | region_enter | r1 | 11.321571 | | fetch | label:remote_refs 14:40:52.883233 run-command.c:738 | d1 | main | child_start | | 11.321675 | | | ..[ch1] class:remote-https argv:[git remote-https origin https://SERVERADDRESS/DefaultCollection/Test/_git/Test] 14:40:52.920219 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:52.921219 common-main.c:49 | d2 | main | start | | 0.011301 | | | git remote-https origin https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:52.949218 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040117 | 0.040117 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:52.951219 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:40:52.951219 run-command.c:738 | d2 | main | child_start | | 0.041480 | | | [ch0] class:dashed argv:[git-remote-https origin https://SERVERADDRESS/DefaultCollection/Test/_git/Test] 14:40:52.990247 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:40:52.991219 common-main.c:49 | d3 | main | start | | 0.011661 | | | git-remote-https origin https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:53.023218 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.043947 | 0.043947 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:53.024219 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:53.024219 remote-curl.c:1499 | d3 | main | cmd_name | | | | | remote-curl (fetch/_run_dashed_/remote-curl) 14:40:53.029220 http.c:781 == Info: Couldn't find host SERVERADDRESS in the (nil) file; using defaults 14:40:53.036218 http.c:781 == Info: Trying SERVERIP:443... 14:40:53.037221 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:53.037221 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:40:53.047220 http.c:728 => Send header, 0000000230 bytes (0x000000e6) 14:40:53.047220 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:53.047220 http.c:740 => Send header: Host: SERVERADDRESS 14:40:53.047220 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:53.047220 http.c:740 => Send header: Accept: */* 14:40:53.047220 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:53.047220 http.c:740 => Send header: Pragma: no-cache 14:40:53.047220 http.c:740 => Send header: Git-Protocol: version=2 14:40:53.047220 http.c:740 => Send header: 14:40:53.050219 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:53.050219 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:53.050219 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:53.050219 http.c:728 <= Recv header, 0000000040 bytes (0x00000028) 14:40:53.050219 http.c:740 <= Recv header: Content-Type: text/html; charset=utf-8 14:40:53.050219 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:53.050219 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:53.050219 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:53.050219 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:53.050219 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:53.050219 http.c:740 <= Recv header: ActivityId: 3a398259-e64f-4399-9898-513b7b8fefe8 14:40:53.050219 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:53.050219 http.c:740 <= Recv header: X-TFS-Session: 3a398259-e64f-4399-9898-513b7b8fefe8 14:40:53.050219 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:53.050219 http.c:740 <= Recv header: X-VSS-E2EID: 3a398259-e64f-4399-9898-513b7b8fefe8 14:40:53.050219 http.c:728 <= Recv header, 0000000690 bytes (0x000002b2) 14:40:53.050219 http.c:740 <= Recv header: X-TFS-SoapException: %3C%3Fxml%20version%3D%221.0%22%20encoding%3D%22utf-8%22%3F%3E%3Csoap%3AEnvelope%20xmlns%3Asoap%3D%22http%3A%2F%2Fwww.w3.org%2F2003%2F05%2Fsoap-envelope%22%3E%3Csoap%3ABody%3E%3Csoap%3AFault%3E%3Csoap%3ACode%3E%3Csoap%3AValue%3Esoap%3AReceiver%3C%2Fsoap%3AValue%3E%3Csoap%3ASubcode%3E%3Csoap%3AValue%3EUnauthorizedRequestException%3C%2Fsoap%3AValue%3E%3C%2Fsoap%3ASubcode%3E%3C%2Fsoap%3ACode%3E%3Csoap%3AReason%3E%3Csoap%3AText%20xml%3Alang%3D%22en%22%3ETF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required.%3C%2Fsoap%3AText%3E%3C%2Fsoap%3AReason%3E%3C%2Fsoap%3AFault%3E%3C%2Fsoap%3ABody%3E%3C%2Fsoap%3AEnvelope%3E 14:40:53.050219 http.c:728 <= Recv header, 0000000128 bytes (0x00000080) 14:40:53.050219 http.c:740 <= Recv header: X-TFS-ServiceError: TF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required. 14:40:53.050219 http.c:728 <= Recv header, 0000000026 bytes (0x0000001a) 14:40:53.050219 http.c:740 <= Recv header: WWW-Authenticate: Bearer 14:40:53.050219 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:53.050219 http.c:740 <= Recv header: WWW-Authenticate: Basic realm="https://SERVERADDRESS/" 14:40:53.050219 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:53.050219 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:53.053220 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:53.053220 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:53.053220 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:53.053220 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:53.053220 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:53.053220 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:53.053220 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:53.053220 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:53.053220 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:53.053220 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:53.053220 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:53.053220 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:53 GMT 14:40:53.053220 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:53.053220 http.c:740 <= Recv header: Content-Length: 20109 14:40:53.053220 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:53.053220 http.c:740 <= Recv header: 14:40:53.053220 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:53.053220 run-command.c:738 | d3 | main | child_start | | 0.074128 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:40:55.866122 run-command.c:993 | d3 | main | child_exit | | 2.886630 | 2.812502 | | [ch0] pid:18656 code:0 14:40:55.866122 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x1e25d82c240 [serially] 14:40:55.866122 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:55.866122 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:55.866122 http.c:728 => Send header, 0000000230 bytes (0x000000e6) 14:40:55.866122 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:55.866122 http.c:740 => Send header: Host: SERVERADDRESS 14:40:55.866122 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:55.866122 http.c:740 => Send header: Accept: */* 14:40:55.866122 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:55.866122 http.c:740 => Send header: Pragma: no-cache 14:40:55.866122 http.c:740 => Send header: Git-Protocol: version=2 14:40:55.866122 http.c:740 => Send header: 14:40:55.870122 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:55.870122 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:55.870122 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:55.870122 http.c:728 <= Recv header, 0000000040 bytes (0x00000028) 14:40:55.870122 http.c:740 <= Recv header: Content-Type: text/html; charset=utf-8 14:40:55.870122 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:55.870122 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:55.870122 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:55.870122 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:55.870122 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:55.870122 http.c:740 <= Recv header: ActivityId: 3a39825c-e64f-4399-9898-513b7b8fefe8 14:40:55.870122 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:55.870122 http.c:740 <= Recv header: X-TFS-Session: 3a39825c-e64f-4399-9898-513b7b8fefe8 14:40:55.870122 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:55.870122 http.c:740 <= Recv header: X-VSS-E2EID: 3a39825c-e64f-4399-9898-513b7b8fefe8 14:40:55.870122 http.c:728 <= Recv header, 0000000690 bytes (0x000002b2) 14:40:55.870122 http.c:740 <= Recv header: X-TFS-SoapException: %3C%3Fxml%20version%3D%221.0%22%20encoding%3D%22utf-8%22%3F%3E%3Csoap%3AEnvelope%20xmlns%3Asoap%3D%22http%3A%2F%2Fwww.w3.org%2F2003%2F05%2Fsoap-envelope%22%3E%3Csoap%3ABody%3E%3Csoap%3AFault%3E%3Csoap%3ACode%3E%3Csoap%3AValue%3Esoap%3AReceiver%3C%2Fsoap%3AValue%3E%3Csoap%3ASubcode%3E%3Csoap%3AValue%3EUnauthorizedRequestException%3C%2Fsoap%3AValue%3E%3C%2Fsoap%3ASubcode%3E%3C%2Fsoap%3ACode%3E%3Csoap%3AReason%3E%3Csoap%3AText%20xml%3Alang%3D%22en%22%3ETF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required.%3C%2Fsoap%3AText%3E%3C%2Fsoap%3AReason%3E%3C%2Fsoap%3AFault%3E%3C%2Fsoap%3ABody%3E%3C%2Fsoap%3AEnvelope%3E 14:40:55.870122 http.c:728 <= Recv header, 0000000128 bytes (0x00000080) 14:40:55.870122 http.c:740 <= Recv header: X-TFS-ServiceError: TF400813%3A%20Resource%20not%20available%20for%20anonymous%20access.%20Client%20authentication%20required. 14:40:55.870122 http.c:728 <= Recv header, 0000000026 bytes (0x0000001a) 14:40:55.870122 http.c:740 <= Recv header: WWW-Authenticate: Bearer 14:40:55.870122 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:55.870122 http.c:740 <= Recv header: WWW-Authenticate: Basic realm="https://SERVERADDRESS/" 14:40:55.870122 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:55.870122 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:40:55.870122 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:55.870122 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:40:55.870122 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:55.870122 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:55.870122 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:55.870122 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:55.870122 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:55.870122 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:55.870122 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:55.870122 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:55.870122 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:55.870122 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:55 GMT 14:40:55.870122 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:55.870122 http.c:740 <= Recv header: Content-Length: 20109 14:40:55.870122 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:55.870122 http.c:740 <= Recv header: 14:40:55.870122 http.c:781 == Info: Ignoring the response-body 14:40:55.870122 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:55.870122 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack' 14:40:55.870122 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x1e25d82c240 [serially] 14:40:55.870122 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:55.871123 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:55.871123 http.c:781 == Info: Server auth using NTLM with user '' 14:40:55.871123 http.c:728 => Send header, 0000000324 bytes (0x00000144) 14:40:55.871123 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:55.871123 http.c:740 => Send header: Host: SERVERADDRESS 14:40:55.871123 http.c:740 => Send header: Authorization: NTLM 14:40:55.871123 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:55.871123 http.c:740 => Send header: Accept: */* 14:40:55.871123 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:55.871123 http.c:740 => Send header: Pragma: no-cache 14:40:55.871123 http.c:740 => Send header: Git-Protocol: version=2 14:40:55.871123 http.c:740 => Send header: 14:40:55.871123 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:55.871123 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:40:55.871123 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:40:55.871123 http.c:728 <= Recv header, 0000000043 bytes (0x0000002b) 14:40:55.871123 http.c:740 <= Recv header: Content-Type: text/html; charset=us-ascii 14:40:55.871123 http.c:728 <= Recv header, 0000000031 bytes (0x0000001f) 14:40:55.871123 http.c:740 <= Recv header: Server: Microsoft-HTTPAPI/2.0 14:40:55.871123 http.c:728 <= Recv header, 0000000353 bytes (0x00000161) 14:40:55.871123 http.c:740 <= Recv header: WWW-Authenticate: NTLM TlRMTVNTUAACAAAADAAMADgAAAAFwomilVoYYtisKQzvAQEAAAAAALAAsABEAAAACgBhSgAAAA9HAEwATwBCAEEATAACAAwARwBMAE8AQgBBAEwAAQAQAEwAVABEAEUANgA1ADYANgAEACQARwBMAE8AQgBBAEwALgBCAEMARQBDAE8AUgBQAC4ATgBFAFQAAwA2AEwAVABEAEUANgA1ADYANgAuAEcATABPAEIAQQBMAC4AQgBDAEUAQwBPAFIAUAAuAE4ARQBUAAUAFgBCAEMARQBDAE8AUgBQAC4ATgBFAFQABwAIAL85xtI6I9gBAAAAAA== 14:40:55.871123 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:55.871123 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:55 GMT 14:40:55.871123 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:55.871123 http.c:740 <= Recv header: Content-Length: 341 14:40:55.871123 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:55.871123 http.c:740 <= Recv header: 14:40:55.871123 http.c:781 == Info: Ignoring the response-body 14:40:55.871123 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:55.871123 http.c:781 == Info: Issue another request to this URL: 'https://SERVERADDRESS/DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack' 14:40:55.871123 http.c:781 == Info: Found bundle for host SERVERADDRESS: 0x1e25d82c240 [serially] 14:40:55.871123 http.c:781 == Info: Re-using existing connection! (#0) with host SERVERADDRESS 14:40:55.871123 http.c:781 == Info: Connected to SERVERADDRESS (SERVERIP) port 443 (#0) 14:40:55.878122 http.c:781 == Info: Server auth using NTLM with user '' 14:40:55.878122 http.c:728 => Send header, 0000000372 bytes (0x00000174) 14:40:55.878122 http.c:740 => Send header: GET /DefaultCollection/Test/_git/Test/info/refs?service=git-upload-pack HTTP/1.1 14:40:55.878122 http.c:740 => Send header: Host: SERVERADDRESS 14:40:55.878122 http.c:740 => Send header: Authorization: NTLM 14:40:55.878122 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:40:55.878122 http.c:740 => Send header: Accept: */* 14:40:55.878122 http.c:740 => Send header: Accept-Encoding: deflate, gzip, br, zstd 14:40:55.878122 http.c:740 => Send header: Pragma: no-cache 14:40:55.878122 http.c:740 => Send header: Git-Protocol: version=2 14:40:55.878122 http.c:740 => Send header: 14:40:55.925122 http.c:781 == Info: Mark bundle as not supporting multiuse 14:40:55.925122 http.c:728 <= Recv header, 0000000017 bytes (0x00000011) 14:40:55.925122 http.c:740 <= Recv header: HTTP/1.1 200 OK 14:40:55.925122 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:55.925122 http.c:740 <= Recv header: Cache-Control: private 14:40:55.925122 http.c:728 <= Recv header, 0000000059 bytes (0x0000003b) 14:40:55.925122 http.c:740 <= Recv header: Content-Type: application/x-git-upload-pack-advertisement 14:40:55.925122 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:40:55.925122 http.c:740 <= Recv header: X-TFS-ProcessId: 5cc98c08-c246-471c-891b-3c00f4e843f2 14:40:55.925122 http.c:728 <= Recv header, 0000000064 bytes (0x00000040) 14:40:55.925122 http.c:740 <= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains 14:40:55.925122 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:40:55.925122 http.c:740 <= Recv header: ActivityId: 3a39825d-e64f-4399-9898-513b7b8fefe8 14:40:55.925122 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:40:55.925122 http.c:740 <= Recv header: X-TFS-Session: 3a39825d-e64f-4399-9898-513b7b8fefe8 14:40:55.925122 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:40:55.925122 http.c:740 <= Recv header: X-VSS-E2EID: 3a39825d-e64f-4399-9898-513b7b8fefe8 14:40:55.925122 http.c:728 <= Recv header, 0000000066 bytes (0x00000042) 14:40:55.925122 http.c:740 <= Recv header: X-VSS-UserData: 5b5ce3ba-4b39-4fd2-8851-ea5fc53781f3:SAMACKOWIAK 14:40:55.925122 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:40:55.925122 http.c:740 <= Recv header: X-FRAME-OPTIONS: SAMEORIGIN 14:40:55.925122 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:55.925122 http.c:740 <= Recv header: Persistent-Auth: true 14:40:55.925122 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:40:55.925122 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:40:55.925122 http.c:728 <= Recv header, 0000000124 bytes (0x0000007c) 14:40:55.925122 http.c:740 <= Recv header: P3P: CP="CAO DSP COR ADMa DEV CONo TELo CUR PSA PSD TAI IVDo OUR SAMi BUS DEM NAV STA UNI COM INT PHY ONL FIN PUR LOC CNT" 14:40:55.925122 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:40:55.925122 http.c:740 <= Recv header: Lfs-Authenticate: NTLM 14:40:55.925122 http.c:728 <= Recv header, 0000000033 bytes (0x00000021) 14:40:55.925122 http.c:740 <= Recv header: X-Content-Type-Options: nosniff 14:40:55.925122 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:40:55.925122 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:40:55 GMT 14:40:55.925122 http.c:728 <= Recv header, 0000000021 bytes (0x00000015) 14:40:55.925122 http.c:740 <= Recv header: Content-Length: 296 14:40:55.925122 http.c:728 <= Recv header, 0000000002 bytes (0x00000002) 14:40:55.925122 http.c:740 <= Recv header: 14:40:55.925122 http.c:781 == Info: Connection #0 to host SERVERADDRESS left intact 14:40:55.925122 run-command.c:738 | d3 | main | child_start | | 2.945907 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe store'] 14:40:57.702070 run-command.c:993 | d3 | main | child_exit | | 4.723098 | 1.777191 | | [ch1] pid:27660 code:0 14:40:57.703072 builtin/fetch.c:1576 | d1 | main | region_leave | r1 | 16.141754 | 4.820183 | fetch | label:remote_refs 14:40:57.707070 builtin/fetch.c:1298 | d1 | main | region_enter | r1 | 16.145676 | | fetch | label:fetch_refs 14:40:57.707070 builtin/fetch.c:1300 | d1 | main | region_leave | r1 | 16.145870 | 0.000194 | fetch | label:fetch_refs 14:40:57.707070 builtin/fetch.c:1318 | d1 | main | region_enter | r1 | 16.145903 | | fetch | label:consume_refs 14:40:57.709070 gvfs-helper-client.c:488 | d1 | main | printf | | 16.147454 | | | ..gh_client__get_immediate: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:40:57.709070 run-command.c:738 | d1 | main | child_start | | 16.147590 | | | ..[ch2] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:40:57.751070 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:40:57.752068 common-main.c:49 | d2 | main | start | | 0.013748 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:40:57.782067 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.043042 | 0.043042 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:57.783071 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:40:57.783071 run-command.c:738 | d2 | main | child_start | | 0.044918 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:40:57.823068 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:40:57.824068 common-main.c:49 | d3 | main | start | | 0.011759 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:40:57.857068 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044434 | 0.044434 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:40:57.857068 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:40:57.858069 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:40:57.859068 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:40:57.860069 gvfs-helper.c:1334 | d3 | main | data | | 0.048100 | 0.048100 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:40:57.863067 gvfs-helper.c:1392 | d3 | main | data | | 0.050843 | 0.050843 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:40:57.863067 gvfs-helper-client.c:494 | d1 | main | region_enter | r1 | 16.302313 | | gh-client | ..label:objects/get 14:40:57.864069 run-command.c:738 | d3 | main | child_start | | 0.051272 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:00.666134 run-command.c:993 | d3 | main | child_exit | | 2.854200 | 2.802928 | | [ch0] pid:15740 code:0 14:41:00.667134 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.854999 | | gvfs-helper | label:GET/objects(cs) 14:41:00.677135 http.c:781 == Info: Trying PROXYIP:443... 14:41:00.851910 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:00.851910 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:01.228548 http.c:781 == Info: Server auth using Basic with user '' 14:41:01.229544 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:01.229544 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:01.229544 http.c:740 => Send header: Host: PROXYADDRESS 14:41:01.229544 http.c:740 => Send header: Authorization: Basic 14:41:01.229544 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:01.229544 http.c:740 => Send header: Accept: */* 14:41:01.229544 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:01.229544 http.c:740 => Send header: Pragma: no-cache 14:41:01.229544 http.c:740 => Send header: 14:41:01.400161 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:01.400161 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:01.754861 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:01.760134 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:01.760134 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:01.760134 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:01.760134 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:01.760134 http.c:740 <= Recv header: Cache-Control: private 14:41:01.760134 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:01.760134 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:01.760134 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:01.760134 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:01.760134 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:01.760134 http.c:740 <= Recv header: ActivityId: 194d9fa4-c6d8-4394-b892-fc34ee92f58e 14:41:01.760134 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:01.760134 http.c:740 <= Recv header: X-TFS-Session: 194d9fa4-c6d8-4394-b892-fc34ee92f58e 14:41:01.760134 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:01.760134 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fa4-c6d8-4394-b892-fc34ee92f58e 14:41:01.760134 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:01.760134 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:01.760134 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:01.760134 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:01.763904 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:01.763904 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:01.763904 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:01.763904 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:01.763904 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:01.763904 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:01 GMT 14:41:01.763904 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:01.763904 http.c:740 <= Recv header: Content-Length: 72 14:41:01.763904 http.c:781 == Info: The requested URL returned error: 401 14:41:01.763904 http.c:781 == Info: Closing connection 0 14:41:01.763904 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:01.764918 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.952302 | 1.097303 | gvfs-helper | label:GET/objects(cs) 14:41:01.764918 run-command.c:738 | d3 | main | child_start | | 3.952499 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:04.560247 run-command.c:993 | d3 | main | child_exit | | 6.747850 | 2.795351 | | [ch1] pid:12584 code:0 14:41:04.560247 run-command.c:738 | d3 | main | child_start | | 6.748109 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:07.367972 run-command.c:993 | d3 | main | child_exit | | 9.556086 | 2.807977 | | [ch2] pid:20428 code:0 14:41:07.369973 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.557440 | | gvfs-helper | label:GET/objects(cs) 14:41:07.369973 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:41:07.369973 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:41:07.369973 http.c:781 == Info: Trying PROXYIP:443... 14:41:07.555700 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:41:07.748388 http.c:781 == Info: Server auth using Basic with user '' 14:41:07.748388 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:07.748388 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:07.748388 http.c:740 => Send header: Host: PROXYADDRESS 14:41:07.748388 http.c:740 => Send header: Authorization: Basic 14:41:07.748388 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:07.748388 http.c:740 => Send header: Accept: */* 14:41:07.748388 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:07.748388 http.c:740 => Send header: Pragma: no-cache 14:41:07.748388 http.c:740 => Send header: 14:41:07.922232 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:07.922232 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:08.275548 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:08.278550 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:08.278550 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:08.278550 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:08.278550 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:08.278550 http.c:740 <= Recv header: Cache-Control: private 14:41:08.278550 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:08.278550 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:08.278550 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:08.278550 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:08.278550 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:08.278550 http.c:740 <= Recv header: ActivityId: 194d9faf-c6d8-4394-b892-fc34ee92f58e 14:41:08.278550 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:08.278550 http.c:740 <= Recv header: X-TFS-Session: 194d9faf-c6d8-4394-b892-fc34ee92f58e 14:41:08.278550 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:08.278550 http.c:740 <= Recv header: X-VSS-E2EID: 194d9faf-c6d8-4394-b892-fc34ee92f58e 14:41:08.278550 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:08.278550 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:08.278550 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:08.278550 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:08.278550 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:08.278550 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:08.278550 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:08.278550 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:08.278550 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:08.278550 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:08 GMT 14:41:08.278550 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:08.278550 http.c:740 <= Recv header: Content-Length: 72 14:41:08.278550 http.c:781 == Info: The requested URL returned error: 401 14:41:08.278550 http.c:781 == Info: Closing connection 1 14:41:08.278550 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:08.279557 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.467079 | 0.909639 | gvfs-helper | label:GET/objects(cs) 14:41:08.280552 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' error: gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:41:08.301249 run-command.c:993 | d1 | main | child_exit | | 26.740025 | 10.592435 | | ....[ch2] pid:27016 code:143 14:41:08.301249 gvfs-helper-client.c:513 | d1 | main | region_leave | r1 | 26.740063 | 10.437750 | gh-client | ..label:objects/get 14:41:08.302294 promisor-remote.c:249 | d1 | main | data | r1 | 26.740696 | 10.594793 | bug | ..fetch_objects/gvfs-helper:1 14:41:08.302294 gvfs-helper-client.c:400 | d1 | main | printf | | 26.740743 | | | ..gh_client__queue_oid: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:41:08.302294 run-command.c:738 | d1 | main | child_start | | 26.740853 | | | ..[ch3] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:08.339534 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:41:08.340539 common-main.c:49 | d2 | main | start | | 0.011378 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:08.369532 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040035 | 0.040035 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:08.371539 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:41:08.371539 run-command.c:738 | d2 | main | child_start | | 0.041834 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:08.409535 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:41:08.410532 common-main.c:49 | d3 | main | start | | 0.011661 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:08.442535 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044357 | 0.044357 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:08.442535 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:41:08.444537 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:41:08.445502 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:41:08.446538 gvfs-helper.c:1334 | d3 | main | data | | 0.047647 | 0.047647 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:41:08.448501 gvfs-helper.c:1392 | d3 | main | data | | 0.050275 | 0.050275 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:41:08.448501 gvfs-helper-client.c:439 | d1 | main | region_enter | r1 | 26.887871 | | gh-client | ..label:objects/post 14:41:08.449501 run-command.c:738 | d3 | main | child_start | | 0.050717 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:11.265287 run-command.c:993 | d3 | main | child_exit | | 2.867146 | 2.816429 | | [ch0] pid:18256 code:0 14:41:11.266289 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.868122 | | gvfs-helper | label:POST/objects(cs) 14:41:11.277289 http.c:781 == Info: Trying PROXYIP:443... 14:41:11.450848 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:11.450848 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:11.823488 http.c:781 == Info: Server auth using Basic with user '' 14:41:11.824488 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:41:11.824488 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:41:11.824488 http.c:740 => Send header: Host: PROXYADDRESS 14:41:11.824488 http.c:740 => Send header: Authorization: Basic 14:41:11.824488 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:11.824488 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:11.824488 http.c:740 => Send header: Pragma: no-cache 14:41:11.824488 http.c:740 => Send header: Content-Type: application/json 14:41:11.824488 http.c:740 => Send header: Accept: application/x-git-packfile 14:41:11.824488 http.c:740 => Send header: Accept: application/x-git-loose-object 14:41:11.824488 http.c:740 => Send header: Content-Length: 74 14:41:11.824488 http.c:740 => Send header: 14:41:11.995586 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:11.995586 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:12.346030 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:12.348022 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:12.348022 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:12.348022 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:12.348022 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:12.348022 http.c:740 <= Recv header: Cache-Control: private 14:41:12.348022 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:12.348022 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:12.348022 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:12.348022 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:12.348022 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:12.348022 http.c:740 <= Recv header: ActivityId: 194d9fb2-c6d8-4394-b892-fc34ee92f58e 14:41:12.348022 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:12.348022 http.c:740 <= Recv header: X-TFS-Session: 194d9fb2-c6d8-4394-b892-fc34ee92f58e 14:41:12.348022 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:12.349020 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fb2-c6d8-4394-b892-fc34ee92f58e 14:41:12.349020 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:12.349020 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:12.349020 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:12.349020 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:12.359078 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:12.359078 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:12.359078 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:12.359078 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:12.359078 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:12.359078 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:12 GMT 14:41:12.359078 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:12.359078 http.c:740 <= Recv header: Content-Length: 72 14:41:12.359078 http.c:781 == Info: The requested URL returned error: 401 14:41:12.359078 http.c:781 == Info: Closing connection 0 14:41:12.359078 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:12.360011 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.961609 | 1.093487 | gvfs-helper | label:POST/objects(cs) 14:41:12.360011 run-command.c:738 | d3 | main | child_start | | 3.962007 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:15.171527 run-command.c:993 | d3 | main | child_exit | | 6.773460 | 2.811453 | | [ch1] pid:26760 code:0 14:41:15.172526 run-command.c:738 | d3 | main | child_start | | 6.773697 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:17.975313 run-command.c:993 | d3 | main | child_exit | | 9.577108 | 2.803411 | | [ch2] pid:15156 code:0 14:41:17.977314 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.578505 | | gvfs-helper | label:POST/objects(cs) 14:41:17.977314 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:41:17.977314 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:41:17.977314 http.c:781 == Info: Trying PROXYIP:443... 14:41:18.166287 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:41:18.339538 http.c:781 == Info: Server auth using Basic with user '' 14:41:18.339538 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:41:18.339538 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:41:18.339538 http.c:740 => Send header: Host: PROXYADDRESS 14:41:18.339538 http.c:740 => Send header: Authorization: Basic 14:41:18.339538 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:18.339538 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:18.339538 http.c:740 => Send header: Pragma: no-cache 14:41:18.339538 http.c:740 => Send header: Content-Type: application/json 14:41:18.339538 http.c:740 => Send header: Accept: application/x-git-packfile 14:41:18.339538 http.c:740 => Send header: Accept: application/x-git-loose-object 14:41:18.339538 http.c:740 => Send header: Content-Length: 74 14:41:18.339538 http.c:740 => Send header: 14:41:18.513524 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:18.513524 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:18.869902 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:18.871902 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:18.871902 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:18.871902 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:18.871902 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:18.871902 http.c:740 <= Recv header: Cache-Control: private 14:41:18.871902 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:18.871902 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:18.871902 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:18.871902 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:18.871902 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:18.871902 http.c:740 <= Recv header: ActivityId: 194d9fb9-c6d8-4394-b892-fc34ee92f58e 14:41:18.871902 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:18.872850 http.c:740 <= Recv header: X-TFS-Session: 194d9fb9-c6d8-4394-b892-fc34ee92f58e 14:41:18.872850 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:18.872850 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fb9-c6d8-4394-b892-fc34ee92f58e 14:41:18.872850 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:18.872850 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:18.872850 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:18.872850 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:18.872850 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:18.872850 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:18.872850 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:18.872850 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:18.872850 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:18.872850 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:18 GMT 14:41:18.872850 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:18.872850 http.c:740 <= Recv header: Content-Length: 72 14:41:18.872850 http.c:781 == Info: The requested URL returned error: 401 14:41:18.872850 http.c:781 == Info: Closing connection 1 14:41:18.872850 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:18.873902 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.475514 | 0.897009 | gvfs-helper | label:POST/objects(cs) 14:41:18.875894 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from POST' error: gvfs-helper error: '(http:401) Not Authorized: from POST' 14:41:18.901840 run-command.c:993 | d1 | main | child_exit | | 37.340738 | 10.599885 | | ....[ch3] pid:13332 code:143 14:41:18.901840 gvfs-helper-client.c:458 | d1 | main | data | r1 | 37.340778 | 10.452907 | gh-client | ....objects/post/nr_objects:1 14:41:18.901840 gvfs-helper-client.c:460 | d1 | main | region_leave | r1 | 37.340792 | 10.452921 | gh-client | ..label:objects/post 14:41:18.902841 gvfs-helper-client.c:488 | d1 | main | printf | | 37.341667 | | | ..gh_client__get_immediate: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:41:18.902841 run-command.c:738 | d1 | main | child_start | | 37.341773 | | | ..[ch4] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:18.937562 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:41:18.938562 common-main.c:49 | d2 | main | start | | 0.011689 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:18.967527 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040599 | 0.040599 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:18.968526 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:41:18.968526 run-command.c:738 | d2 | main | child_start | | 0.042397 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:19.006562 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:41:19.007561 common-main.c:49 | d3 | main | start | | 0.011578 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:19.039561 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.043940 | 0.043940 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:19.039561 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:41:19.041546 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:41:19.042526 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:41:19.043565 gvfs-helper.c:1334 | d3 | main | data | | 0.047874 | 0.047874 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:41:19.046525 gvfs-helper.c:1392 | d3 | main | data | | 0.050552 | 0.050552 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:41:19.046525 gvfs-helper-client.c:494 | d1 | main | region_enter | r1 | 37.485588 | | gh-client | ..label:objects/get 14:41:19.046525 run-command.c:738 | d3 | main | child_start | | 0.050969 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:21.852393 run-command.c:993 | d3 | main | child_exit | | 2.856705 | 2.805736 | | [ch0] pid:7836 code:0 14:41:21.853379 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.857829 | | gvfs-helper | label:GET/objects(cs) 14:41:21.861379 http.c:781 == Info: Trying PROXYIP:443... 14:41:22.034819 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:22.034819 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:22.407664 http.c:781 == Info: Server auth using Basic with user '' 14:41:22.408611 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:22.408611 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:22.408611 http.c:740 => Send header: Host: PROXYADDRESS 14:41:22.408611 http.c:740 => Send header: Authorization: Basic 14:41:22.408611 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:22.408611 http.c:740 => Send header: Accept: */* 14:41:22.408611 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:22.408611 http.c:740 => Send header: Pragma: no-cache 14:41:22.408611 http.c:740 => Send header: 14:41:22.583028 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:22.583028 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:22.940122 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:22.942081 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:22.942081 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:22.942081 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:22.942081 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:22.942081 http.c:740 <= Recv header: Cache-Control: private 14:41:22.942081 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:22.942081 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:22.942081 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:22.942081 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:22.942081 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:22.942081 http.c:740 <= Recv header: ActivityId: 194d9fbe-c6d8-4394-b892-fc34ee92f58e 14:41:22.942081 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:22.942081 http.c:740 <= Recv header: X-TFS-Session: 194d9fbe-c6d8-4394-b892-fc34ee92f58e 14:41:22.942081 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:22.942081 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fbe-c6d8-4394-b892-fc34ee92f58e 14:41:22.942081 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:22.942081 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:22.942081 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:22.942081 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:22.952126 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:22.952126 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:22.952126 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:22.953128 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:22.953128 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:22.953128 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:22 GMT 14:41:22.953128 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:22.953128 http.c:740 <= Recv header: Content-Length: 72 14:41:22.953128 http.c:781 == Info: The requested URL returned error: 401 14:41:22.953128 http.c:781 == Info: Closing connection 0 14:41:22.953128 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:22.954082 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.958175 | 1.100346 | gvfs-helper | label:GET/objects(cs) 14:41:22.955078 run-command.c:738 | d3 | main | child_start | | 3.958700 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:25.731989 run-command.c:993 | d3 | main | child_exit | | 6.736126 | 2.777426 | | [ch1] pid:23416 code:0 14:41:25.731989 run-command.c:738 | d3 | main | child_start | | 6.736334 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:28.524111 run-command.c:993 | d3 | main | child_exit | | 9.528353 | 2.792019 | | [ch2] pid:4852 code:0 14:41:28.526109 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.529646 | | gvfs-helper | label:GET/objects(cs) 14:41:28.526109 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:41:28.526109 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:41:28.526109 http.c:781 == Info: Trying PROXYIP:443... 14:41:28.707184 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:41:28.889675 http.c:781 == Info: Server auth using Basic with user '' 14:41:28.889675 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:28.889675 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:28.889675 http.c:740 => Send header: Host: PROXYADDRESS 14:41:28.889675 http.c:740 => Send header: Authorization: Basic 14:41:28.889675 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:28.889675 http.c:740 => Send header: Accept: */* 14:41:28.889675 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:28.889675 http.c:740 => Send header: Pragma: no-cache 14:41:28.889675 http.c:740 => Send header: 14:41:29.061899 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:29.061899 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:29.419474 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:29.421465 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:29.425484 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:41:29.421465 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:29.421465 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:29.421465 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:29.421465 http.c:740 <= Recv header: Cache-Control: private 14:41:29.421465 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:29.421465 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:29.421465 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:29.421465 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:29.421465 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:29.421465 http.c:740 <= Recv header: ActivityId: 194d9fc5-c6d8-4394-b892-fc34ee92f58e 14:41:29.421465 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:29.421465 http.c:740 <= Recv header: X-TFS-Session: 194d9fc5-c6d8-4394-b892-fc34ee92f58e 14:41:29.421465 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:29.421465 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fc5-c6d8-4394-b892-fc34ee92f58e 14:41:29.421465 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:29.421465 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:29.421465 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:29.421465 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:29.421465 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:29.421465 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:29.421465 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:29.421465 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:29.421465 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:29.421465 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:29 GMT 14:41:29.421465 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:29.421465 http.c:740 <= Recv header: Content-Length: 72 14:41:29.421465 http.c:781 == Info: The requested URL returned error: 401 14:41:29.421465 http.c:781 == Info: Closing connection 1 14:41:29.421465 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:29.423476 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.427221 | 0.897575 | gvfs-helper | label:GET/objects(cs) error: gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:41:29.460460 run-command.c:993 | d1 | main | child_exit | | 47.899775 | 10.558002 | | ....[ch4] pid:13836 code:143 14:41:29.460460 gvfs-helper-client.c:513 | d1 | main | region_leave | r1 | 47.899824 | 10.414236 | gh-client | ..label:objects/get 14:41:29.461496 promisor-remote.c:249 | d1 | main | data | r1 | 47.900606 | 31.754703 | bug | ..fetch_objects/gvfs-helper:1 14:41:29.461496 gvfs-helper-client.c:400 | d1 | main | printf | | 47.900632 | | | ..gh_client__queue_oid: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:41:29.461496 run-command.c:738 | d1 | main | child_start | | 47.900772 | | | ..[ch5] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:29.498805 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:41:29.499810 common-main.c:49 | d2 | main | start | | 0.011637 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:29.528806 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040483 | 0.040483 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:29.530791 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:41:29.530791 run-command.c:738 | d2 | main | child_start | | 0.042333 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:29.568804 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:41:29.569808 common-main.c:49 | d3 | main | start | | 0.011881 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:29.601807 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044550 | 0.044550 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:29.601807 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:41:29.602771 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:41:29.604806 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:41:29.604806 gvfs-helper.c:1334 | d3 | main | data | | 0.047770 | 0.047770 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:41:29.607804 gvfs-helper.c:1392 | d3 | main | data | | 0.050318 | 0.050318 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:41:29.607804 gvfs-helper-client.c:439 | d1 | main | region_enter | r1 | 48.046871 | | gh-client | ..label:objects/post 14:41:29.607804 run-command.c:738 | d3 | main | child_start | | 0.050737 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:32.418981 run-command.c:993 | d3 | main | child_exit | | 2.861570 | 2.810833 | | [ch0] pid:1288 code:0 14:41:32.419975 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.862724 | | gvfs-helper | label:POST/objects(cs) 14:41:32.430956 http.c:781 == Info: Trying PROXYIP:443... 14:41:32.606483 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:32.606483 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:32.978860 http.c:781 == Info: Server auth using Basic with user '' 14:41:32.978860 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:41:32.978860 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:41:32.978860 http.c:740 => Send header: Host: PROXYADDRESS 14:41:32.978860 http.c:740 => Send header: Authorization: Basic 14:41:32.978860 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:32.978860 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:32.978860 http.c:740 => Send header: Pragma: no-cache 14:41:32.978860 http.c:740 => Send header: Content-Type: application/json 14:41:32.978860 http.c:740 => Send header: Accept: application/x-git-packfile 14:41:32.978860 http.c:740 => Send header: Accept: application/x-git-loose-object 14:41:32.978860 http.c:740 => Send header: Content-Length: 74 14:41:32.978860 http.c:740 => Send header: 14:41:33.152506 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:33.152506 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:33.506024 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:33.507418 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:33.507418 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:33.507418 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:33.507418 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:33.507418 http.c:740 <= Recv header: Cache-Control: private 14:41:33.507418 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:33.507418 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:33.507418 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:33.507418 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:33.508363 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:33.508363 http.c:740 <= Recv header: ActivityId: 194d9fc8-c6d8-4394-b892-fc34ee92f58e 14:41:33.508363 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:33.508363 http.c:740 <= Recv header: X-TFS-Session: 194d9fc8-c6d8-4394-b892-fc34ee92f58e 14:41:33.508363 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:33.508363 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fc8-c6d8-4394-b892-fc34ee92f58e 14:41:33.508363 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:33.508363 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:33.508363 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:33.508363 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:33.519364 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:33.519364 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:33.519364 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:33.519364 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:33.519364 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:33.519364 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:33 GMT 14:41:33.519364 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:33.519364 http.c:740 <= Recv header: Content-Length: 72 14:41:33.519364 http.c:781 == Info: The requested URL returned error: 401 14:41:33.519364 http.c:781 == Info: Closing connection 0 14:41:33.519364 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:33.520368 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.963269 | 1.100545 | gvfs-helper | label:POST/objects(cs) 14:41:33.521374 run-command.c:738 | d3 | main | child_start | | 3.963815 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:36.327779 run-command.c:993 | d3 | main | child_exit | | 6.769844 | 2.806029 | | [ch1] pid:14872 code:0 14:41:36.327779 run-command.c:738 | d3 | main | child_start | | 6.770073 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:39.122612 run-command.c:993 | d3 | main | child_exit | | 9.565138 | 2.795065 | | [ch2] pid:16764 code:0 14:41:39.124613 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.566804 | | gvfs-helper | label:POST/objects(cs) 14:41:39.124613 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:41:39.124613 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:41:39.124613 http.c:781 == Info: Trying PROXYIP:443... 14:41:39.322850 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:41:39.497357 http.c:781 == Info: Server auth using Basic with user '' 14:41:39.497357 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:41:39.498357 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:41:39.498357 http.c:740 => Send header: Host: PROXYADDRESS 14:41:39.498357 http.c:740 => Send header: Authorization: Basic 14:41:39.498357 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:39.498357 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:39.498357 http.c:740 => Send header: Pragma: no-cache 14:41:39.498357 http.c:740 => Send header: Content-Type: application/json 14:41:39.498357 http.c:740 => Send header: Accept: application/x-git-packfile 14:41:39.498357 http.c:740 => Send header: Accept: application/x-git-loose-object 14:41:39.498357 http.c:740 => Send header: Content-Length: 74 14:41:39.498357 http.c:740 => Send header: 14:41:39.674012 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:39.674012 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:40.028488 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:40.029535 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:40.029535 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:40.030490 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:40.030490 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:40.030490 http.c:740 <= Recv header: Cache-Control: private 14:41:40.030490 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:40.030490 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:40.030490 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:40.030490 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:40.030490 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:40.030490 http.c:740 <= Recv header: ActivityId: 194d9fd5-c6d8-4394-b892-fc34ee92f58e 14:41:40.030490 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:40.030490 http.c:740 <= Recv header: X-TFS-Session: 194d9fd5-c6d8-4394-b892-fc34ee92f58e 14:41:40.030490 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:40.030490 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fd5-c6d8-4394-b892-fc34ee92f58e 14:41:40.030490 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:40.030490 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:40.030490 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:40.030490 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:40.030490 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:40.030490 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:40.030490 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:40.030490 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:40.030490 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:40.030490 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:39 GMT 14:41:40.030490 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:40.030490 http.c:740 <= Recv header: Content-Length: 72 14:41:40.030490 http.c:781 == Info: The requested URL returned error: 401 14:41:40.030490 http.c:781 == Info: Closing connection 1 14:41:40.030490 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:40.031491 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.474367 | 0.907563 | gvfs-helper | label:POST/objects(cs) 14:41:40.034482 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from POST' error: gvfs-helper error: '(http:401) Not Authorized: from POST' 14:41:40.055474 run-command.c:993 | d1 | main | child_exit | | 58.494414 | 10.593642 | | ....[ch5] pid:23300 code:143 14:41:40.055474 gvfs-helper-client.c:458 | d1 | main | data | r1 | 58.494454 | 10.447583 | gh-client | ....objects/post/nr_objects:1 14:41:40.055474 gvfs-helper-client.c:460 | d1 | main | region_leave | r1 | 58.494468 | 10.447597 | gh-client | ..label:objects/post 14:41:40.056514 gvfs-helper-client.c:488 | d1 | main | printf | | 58.495545 | | | ..gh_client__get_immediate: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:41:40.056514 run-command.c:738 | d1 | main | child_start | | 58.495659 | | | ..[ch6] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:40.090769 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:41:40.091770 common-main.c:49 | d2 | main | start | | 0.011811 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:40.120738 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040893 | 0.040893 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:40.122739 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:41:40.122739 run-command.c:738 | d2 | main | child_start | | 0.042618 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:40.162935 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:41:40.163968 common-main.c:49 | d3 | main | start | | 0.011658 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:40.195968 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044189 | 0.044189 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:40.195968 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:41:40.196937 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:41:40.197937 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:41:40.198968 gvfs-helper.c:1334 | d3 | main | data | | 0.047435 | 0.047435 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:41:40.201934 gvfs-helper.c:1392 | d3 | main | data | | 0.050249 | 0.050249 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:41:40.201934 gvfs-helper-client.c:494 | d1 | main | region_enter | r1 | 58.641219 | | gh-client | ..label:objects/get 14:41:40.202935 run-command.c:738 | d3 | main | child_start | | 0.050727 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:42.998273 run-command.c:993 | d3 | main | child_exit | | 2.846343 | 2.795616 | | [ch0] pid:24380 code:0 14:41:42.999275 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.847066 | | gvfs-helper | label:GET/objects(cs) 14:41:43.006273 http.c:781 == Info: Trying PROXYIP:443... 14:41:43.180318 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:43.180318 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:43.543543 http.c:781 == Info: Server auth using Basic with user '' 14:41:43.543543 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:43.543543 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:43.543543 http.c:740 => Send header: Host: PROXYADDRESS 14:41:43.543543 http.c:740 => Send header: Authorization: Basic 14:41:43.543543 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:43.543543 http.c:740 => Send header: Accept: */* 14:41:43.543543 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:43.543543 http.c:740 => Send header: Pragma: no-cache 14:41:43.544502 http.c:740 => Send header: 14:41:43.716197 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:43.716197 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:44.070178 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:44.071227 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:44.072226 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:44.072226 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:44.072226 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:44.072226 http.c:740 <= Recv header: Cache-Control: private 14:41:44.072226 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:44.072226 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:44.072226 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:44.072226 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:44.072226 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:44.072226 http.c:740 <= Recv header: ActivityId: 194d9fd8-c6d8-4394-b892-fc34ee92f58e 14:41:44.072226 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:44.072226 http.c:740 <= Recv header: X-TFS-Session: 194d9fd8-c6d8-4394-b892-fc34ee92f58e 14:41:44.072226 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:44.072226 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fd8-c6d8-4394-b892-fc34ee92f58e 14:41:44.072226 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:44.072226 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:44.072226 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:44.072226 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:44.075236 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:44.075236 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:44.075236 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:44.075236 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:44.075236 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:44.075236 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:43 GMT 14:41:44.075236 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:44.075236 http.c:740 <= Recv header: Content-Length: 72 14:41:44.075236 http.c:781 == Info: The requested URL returned error: 401 14:41:44.075236 http.c:781 == Info: Closing connection 0 14:41:44.075236 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:44.075236 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.923519 | 1.076453 | gvfs-helper | label:GET/objects(cs) 14:41:44.075236 run-command.c:738 | d3 | main | child_start | | 3.923675 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:46.875905 run-command.c:993 | d3 | main | child_exit | | 6.723627 | 2.799952 | | [ch1] pid:11044 code:0 14:41:46.875905 run-command.c:738 | d3 | main | child_start | | 6.723781 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:49.684826 run-command.c:993 | d3 | main | child_exit | | 9.533171 | 2.809390 | | [ch2] pid:12500 code:0 14:41:49.685826 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.534193 | | gvfs-helper | label:GET/objects(cs) 14:41:49.685826 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:41:49.685826 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:41:49.685826 http.c:781 == Info: Trying PROXYIP:443... 14:41:49.877177 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:41:50.053772 http.c:781 == Info: Server auth using Basic with user '' 14:41:50.053772 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:41:50.054712 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:41:50.054712 http.c:740 => Send header: Host: PROXYADDRESS 14:41:50.054712 http.c:740 => Send header: Authorization: Basic 14:41:50.054712 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:50.054712 http.c:740 => Send header: Accept: */* 14:41:50.054712 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:50.054712 http.c:740 => Send header: Pragma: no-cache 14:41:50.054712 http.c:740 => Send header: 14:41:50.227436 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:50.227436 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:50.580488 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:51.291929 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:51.291929 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:51.291929 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:51.291929 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:51.291929 http.c:740 <= Recv header: Cache-Control: private 14:41:51.291929 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:51.291929 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:51.291929 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:51.291929 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:51.291929 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:51.291929 http.c:740 <= Recv header: ActivityId: 194d9fdf-c6d8-4394-b892-fc34ee92f58e 14:41:51.291929 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:51.291929 http.c:740 <= Recv header: X-TFS-Session: 194d9fdf-c6d8-4394-b892-fc34ee92f58e 14:41:51.291929 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:51.291929 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fdf-c6d8-4394-b892-fc34ee92f58e 14:41:51.291929 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:51.291929 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:51.291929 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:51.291929 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:51.291929 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:51.291929 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:51.291929 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:51.291929 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:51.291929 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:51.291929 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:51 GMT 14:41:51.291929 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:51.291929 http.c:740 <= Recv header: Content-Length: 72 14:41:51.293626 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:41:51.291929 http.c:781 == Info: The requested URL returned error: 401 14:41:51.291929 http.c:781 == Info: Closing connection 1 14:41:51.291929 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:51.292626 gvfs-helper.c:1187 | d3 | main | region_leave | | 11.140590 | 1.606397 | gvfs-helper | label:GET/objects(cs) error: gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:41:51.312624 run-command.c:993 | d1 | main | child_exit | | 69.751510 | 11.255851 | | ....[ch6] pid:11464 code:143 14:41:51.312624 gvfs-helper-client.c:513 | d1 | main | region_leave | r1 | 69.751572 | 11.110353 | gh-client | ..label:objects/get 14:41:51.313628 promisor-remote.c:249 | d1 | main | data | r1 | 69.752498 | 53.606595 | bug | ..fetch_objects/gvfs-helper:1 14:41:51.313628 gvfs-helper-client.c:400 | d1 | main | printf | | 69.752519 | | | ..gh_client__queue_oid: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:41:51.313628 run-command.c:738 | d1 | main | child_start | | 69.752619 | | | ..[ch7] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:51.351142 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:41:51.352149 common-main.c:49 | d2 | main | start | | 0.011656 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:51.386148 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.046490 | 0.046490 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:51.388148 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:41:51.388148 run-command.c:738 | d2 | main | child_start | | 0.048226 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:41:51.428115 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:41:51.429150 common-main.c:49 | d3 | main | start | | 0.012309 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:41:51.462116 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.045508 | 0.045508 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:41:51.462116 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:41:51.463114 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:41:51.465149 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:41:51.465149 gvfs-helper.c:1334 | d3 | main | data | | 0.048804 | 0.048804 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:41:51.468148 gvfs-helper.c:1392 | d3 | main | data | | 0.051591 | 0.051591 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:41:51.468148 gvfs-helper-client.c:439 | d1 | main | region_enter | r1 | 69.907453 | | gh-client | ..label:objects/post 14:41:51.469150 run-command.c:738 | d3 | main | child_start | | 0.052112 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:54.326650 run-command.c:993 | d3 | main | child_exit | | 2.909869 | 2.857757 | | [ch0] pid:9880 code:0 14:41:54.327654 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.910986 | | gvfs-helper | label:POST/objects(cs) 14:41:54.339648 http.c:781 == Info: Trying PROXYIP:443... 14:41:54.512695 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:41:54.512695 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:41:54.872787 http.c:781 == Info: Server auth using Basic with user '' 14:41:54.872787 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:41:54.872787 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:41:54.872787 http.c:740 => Send header: Host: PROXYADDRESS 14:41:54.872787 http.c:740 => Send header: Authorization: Basic 14:41:54.872787 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:41:54.872787 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:41:54.872787 http.c:740 => Send header: Pragma: no-cache 14:41:54.872787 http.c:740 => Send header: Content-Type: application/json 14:41:54.872787 http.c:740 => Send header: Accept: application/x-git-packfile 14:41:54.872787 http.c:740 => Send header: Accept: application/x-git-loose-object 14:41:54.872787 http.c:740 => Send header: Content-Length: 74 14:41:54.872787 http.c:740 => Send header: 14:41:55.045417 http.c:781 == Info: schannel: remote party requests renegotiation 14:41:55.045417 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:41:55.399537 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:41:55.400720 http.c:781 == Info: Mark bundle as not supporting multiuse 14:41:55.400720 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:41:55.400720 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:41:55.400720 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:55.400720 http.c:740 <= Recv header: Cache-Control: private 14:41:55.400720 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:41:55.400720 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:41:55.400720 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:41:55.400720 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:41:55.400720 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:41:55.400720 http.c:740 <= Recv header: ActivityId: 194d9fe4-c6d8-4394-b892-fc34ee92f58e 14:41:55.400720 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:41:55.400720 http.c:740 <= Recv header: X-TFS-Session: 194d9fe4-c6d8-4394-b892-fc34ee92f58e 14:41:55.400720 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:41:55.400720 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fe4-c6d8-4394-b892-fc34ee92f58e 14:41:55.400720 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:41:55.400720 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:41:55.400720 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:41:55.400720 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:41:55.403684 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:41:55.403684 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:41:55.403684 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:41:55.403684 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:41:55.403684 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:41:55.403684 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:41:55 GMT 14:41:55.403684 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:41:55.403684 http.c:740 <= Recv header: Content-Length: 72 14:41:55.403684 http.c:781 == Info: The requested URL returned error: 401 14:41:55.403684 http.c:781 == Info: Closing connection 0 14:41:55.403684 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:41:55.404684 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.987598 | 1.076612 | gvfs-helper | label:POST/objects(cs) 14:41:55.404684 run-command.c:738 | d3 | main | child_start | | 3.987730 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:41:58.253825 run-command.c:993 | d3 | main | child_exit | | 6.836767 | 2.849037 | | [ch1] pid:13092 code:0 14:41:58.253825 run-command.c:738 | d3 | main | child_start | | 6.836922 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:42:01.076009 run-command.c:993 | d3 | main | child_exit | | 9.659129 | 2.822207 | | [ch2] pid:16460 code:0 14:42:01.077008 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.660611 | | gvfs-helper | label:POST/objects(cs) 14:42:01.077008 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:42:01.077008 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:42:01.078010 http.c:781 == Info: Trying PROXYIP:443... 14:42:01.276712 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:42:01.455612 http.c:781 == Info: Server auth using Basic with user '' 14:42:01.455612 http.c:728 => Send header, 0000000343 bytes (0x00000157) 14:42:01.455612 http.c:740 => Send header: POST /f5929afd472143c0bb4a01cae820fce1/gvfs/objects HTTP/1.1 14:42:01.455612 http.c:740 => Send header: Host: PROXYADDRESS 14:42:01.455612 http.c:740 => Send header: Authorization: Basic 14:42:01.455612 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:42:01.455612 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:42:01.455612 http.c:740 => Send header: Pragma: no-cache 14:42:01.455612 http.c:740 => Send header: Content-Type: application/json 14:42:01.455612 http.c:740 => Send header: Accept: application/x-git-packfile 14:42:01.455612 http.c:740 => Send header: Accept: application/x-git-loose-object 14:42:01.455612 http.c:740 => Send header: Content-Length: 74 14:42:01.455612 http.c:740 => Send header: 14:42:01.628607 http.c:781 == Info: schannel: remote party requests renegotiation 14:42:01.628607 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:42:01.981791 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:42:01.984745 http.c:781 == Info: Mark bundle as not supporting multiuse 14:42:01.984745 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:42:01.984745 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:42:01.984745 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:01.984745 http.c:740 <= Recv header: Cache-Control: private 14:42:01.984745 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:42:01.984745 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:42:01.984745 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:42:01.984745 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:42:01.984745 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:42:01.984745 http.c:740 <= Recv header: ActivityId: 194d9fea-c6d8-4394-b892-fc34ee92f58e 14:42:01.984745 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:42:01.984745 http.c:740 <= Recv header: X-TFS-Session: 194d9fea-c6d8-4394-b892-fc34ee92f58e 14:42:01.984745 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:42:01.984745 http.c:740 <= Recv header: X-VSS-E2EID: 194d9fea-c6d8-4394-b892-fc34ee92f58e 14:42:01.984745 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:42:01.984745 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:42:01.984745 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:42:01.984745 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:42:01.984745 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:01.984745 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:42:01.984745 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:42:01.984745 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:42:01.984745 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:42:01.984745 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:42:01 GMT 14:42:01.984745 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:42:01.984745 http.c:740 <= Recv header: Content-Length: 72 14:42:01.984745 http.c:781 == Info: The requested URL returned error: 401 14:42:01.984745 http.c:781 == Info: Closing connection 1 14:42:01.984745 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:42:01.985786 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.568747 | 0.908136 | gvfs-helper | label:POST/objects(cs) 14:42:01.986758 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from POST' error: gvfs-helper error: '(http:401) Not Authorized: from POST' 14:42:02.008739 run-command.c:993 | d1 | main | child_exit | | 80.448057 | 10.695438 | | ....[ch7] pid:12564 code:143 14:42:02.009741 gvfs-helper-client.c:458 | d1 | main | data | r1 | 80.448098 | 10.540645 | gh-client | ....objects/post/nr_objects:1 14:42:02.009741 gvfs-helper-client.c:460 | d1 | main | region_leave | r1 | 80.448117 | 10.540664 | gh-client | ..label:objects/post 14:42:02.010775 gvfs-helper-client.c:488 | d1 | main | printf | | 80.449242 | | | ..gh_client__get_immediate: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:42:02.010775 run-command.c:738 | d1 | main | child_start | | 80.449359 | | | ..[ch8] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:42:02.045739 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:42:02.046739 common-main.c:49 | d2 | main | start | | 0.011797 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:42:02.075740 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.041070 | 0.041070 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:42:02.077820 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:42:02.077820 run-command.c:738 | d2 | main | child_start | | 0.042952 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:42:02.117739 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:42:02.118739 common-main.c:49 | d3 | main | start | | 0.011574 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:42:02.151737 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.045021 | 0.045021 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:42:02.152739 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:42:02.153741 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:42:02.154738 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:42:02.155740 gvfs-helper.c:1334 | d3 | main | data | | 0.048364 | 0.048364 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:42:02.157739 gvfs-helper.c:1392 | d3 | main | data | | 0.051074 | 0.051074 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:42:02.158740 gvfs-helper-client.c:494 | d1 | main | region_enter | r1 | 80.597306 | | gh-client | ..label:objects/get 14:42:02.158740 run-command.c:738 | d3 | main | child_start | | 0.051564 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:42:04.992049 run-command.c:993 | d3 | main | child_exit | | 2.884914 | 2.833350 | | [ch0] pid:11528 code:0 14:42:04.993046 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.885654 | | gvfs-helper | label:GET/objects(cs) 14:42:05.000049 http.c:781 == Info: Trying PROXYIP:443... 14:42:05.173364 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:42:05.173364 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:42:05.536247 http.c:781 == Info: Server auth using Basic with user '' 14:42:05.536247 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:42:05.536247 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:42:05.536247 http.c:740 => Send header: Host: PROXYADDRESS 14:42:05.536247 http.c:740 => Send header: Authorization: Basic 14:42:05.536247 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:42:05.536247 http.c:740 => Send header: Accept: */* 14:42:05.536247 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:42:05.536247 http.c:740 => Send header: Pragma: no-cache 14:42:05.536247 http.c:740 => Send header: 14:42:05.708532 http.c:781 == Info: schannel: remote party requests renegotiation 14:42:05.708532 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:42:06.083790 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:42:06.085788 http.c:781 == Info: Mark bundle as not supporting multiuse 14:42:06.085788 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:42:06.085788 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:42:06.085788 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:06.085788 http.c:740 <= Recv header: Cache-Control: private 14:42:06.085788 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:42:06.085788 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:42:06.085788 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:42:06.085788 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:42:06.085788 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:42:06.085788 http.c:740 <= Recv header: ActivityId: 194d9ff1-c6d8-4394-b892-fc34ee92f58e 14:42:06.085788 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:42:06.085788 http.c:740 <= Recv header: X-TFS-Session: 194d9ff1-c6d8-4394-b892-fc34ee92f58e 14:42:06.085788 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:42:06.085788 http.c:740 <= Recv header: X-VSS-E2EID: 194d9ff1-c6d8-4394-b892-fc34ee92f58e 14:42:06.085788 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:42:06.085788 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:42:06.085788 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:42:06.085788 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:42:06.096787 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:06.096787 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:42:06.096787 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:42:06.096787 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:42:06.096787 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:42:06.096787 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:42:06 GMT 14:42:06.096787 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:42:06.096787 http.c:740 <= Recv header: Content-Length: 72 14:42:06.096787 http.c:781 == Info: The requested URL returned error: 401 14:42:06.096787 http.c:781 == Info: Closing connection 0 14:42:06.096787 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:42:06.097784 gvfs-helper.c:1187 | d3 | main | region_leave | | 3.990708 | 1.105054 | gvfs-helper | label:GET/objects(cs) 14:42:06.097784 run-command.c:738 | d3 | main | child_start | | 3.990944 | | | [ch1] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:42:08.956510 run-command.c:993 | d3 | main | child_exit | | 6.849123 | 2.858179 | | [ch1] pid:4344 code:0 14:42:08.956510 run-command.c:738 | d3 | main | child_start | | 6.849353 | | | [ch2] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:42:11.897049 run-command.c:993 | d3 | main | child_exit | | 9.789534 | 2.940181 | | [ch2] pid:26752 code:0 14:42:11.898051 gvfs-helper.c:1150 | d3 | main | region_enter | | 9.790509 | | gvfs-helper | label:GET/objects(cs) 14:42:11.898051 http.c:781 == Info: NTLM-proxy picked AND auth done set, clear picked! 14:42:11.898051 http.c:781 == Info: Hostname PROXYADDRESS was found in DNS cache 14:42:11.898051 http.c:781 == Info: Trying PROXYIP:443... 14:42:12.092811 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#1) 14:42:12.267670 http.c:781 == Info: Server auth using Basic with user '' 14:42:12.268718 http.c:728 => Send header, 0000000268 bytes (0x0000010c) 14:42:12.268718 http.c:740 => Send header: GET /f5929afd472143c0bb4a01cae820fce1/gvfs/objects/e745d9a9d5b562918e37e7bb53cf187edd06ccd2 HTTP/1.1 14:42:12.268718 http.c:740 => Send header: Host: PROXYADDRESS 14:42:12.268718 http.c:740 => Send header: Authorization: Basic 14:42:12.268718 http.c:740 => Send header: User-Agent: git/2.33.0.vfs.0.0 14:42:12.268718 http.c:740 => Send header: Accept: */* 14:42:12.268718 http.c:740 => Send header: X-TFS-FedAuthRedirect: Suppress 14:42:12.268718 http.c:740 => Send header: Pragma: no-cache 14:42:12.268718 http.c:740 => Send header: 14:42:12.442147 http.c:781 == Info: schannel: remote party requests renegotiation 14:42:12.442147 http.c:781 == Info: schannel: renegotiating SSL/TLS connection 14:42:12.793304 http.c:781 == Info: schannel: SSL/TLS connection renegotiated 14:42:12.795341 http.c:781 == Info: Mark bundle as not supporting multiuse 14:42:12.798310 usage.c:74 | d1 | main | error | | | | | ....gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' error: gvfs-helper error: '(http:401) Not Authorized: from GET e745d9a9d5b562918e37e7bb53cf187edd06ccd2' 14:42:12.796308 http.c:728 <= Recv header, 0000000027 bytes (0x0000001b) 14:42:12.796308 http.c:740 <= Recv header: HTTP/1.1 401 Unauthorized 14:42:12.796308 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:12.796308 http.c:740 <= Recv header: Cache-Control: private 14:42:12.796308 http.c:728 <= Recv header, 0000000041 bytes (0x00000029) 14:42:12.796308 http.c:740 <= Recv header: Content-Type: text/plain; charset=utf-8 14:42:12.796308 http.c:728 <= Recv header, 0000000055 bytes (0x00000037) 14:42:12.796308 http.c:740 <= Recv header: X-TFS-ProcessId: 8fc59f7e-b893-471e-b278-08edf9e6d1a4 14:42:12.796308 http.c:728 <= Recv header, 0000000050 bytes (0x00000032) 14:42:12.796308 http.c:740 <= Recv header: ActivityId: 194d9ff8-c6d8-4394-b892-fc34ee92f58e 14:42:12.796308 http.c:728 <= Recv header, 0000000053 bytes (0x00000035) 14:42:12.796308 http.c:740 <= Recv header: X-TFS-Session: 194d9ff8-c6d8-4394-b892-fc34ee92f58e 14:42:12.796308 http.c:728 <= Recv header, 0000000051 bytes (0x00000033) 14:42:12.796308 http.c:740 <= Recv header: X-VSS-E2EID: 194d9ff8-c6d8-4394-b892-fc34ee92f58e 14:42:12.796308 http.c:728 <= Recv header, 0000000030 bytes (0x0000001e) 14:42:12.796308 http.c:740 <= Recv header: X-Cache-Name: SVDEAZRPROXY01 14:42:12.796308 http.c:728 <= Recv header, 0000000029 bytes (0x0000001d) 14:42:12.796308 http.c:740 <= Recv header: WWW-Authenticate: Negotiate 14:42:12.796308 http.c:728 <= Recv header, 0000000024 bytes (0x00000018) 14:42:12.796308 http.c:740 <= Recv header: WWW-Authenticate: NTLM 14:42:12.796308 http.c:728 <= Recv header, 0000000023 bytes (0x00000017) 14:42:12.796308 http.c:740 <= Recv header: X-Powered-By: ASP.NET 14:42:12.796308 http.c:728 <= Recv header, 0000000037 bytes (0x00000025) 14:42:12.796308 http.c:740 <= Recv header: Date: Wed, 16 Feb 2022 13:42:12 GMT 14:42:12.796308 http.c:728 <= Recv header, 0000000020 bytes (0x00000014) 14:42:12.796308 http.c:740 <= Recv header: Content-Length: 72 14:42:12.796308 http.c:781 == Info: The requested URL returned error: 401 14:42:12.796308 http.c:781 == Info: Closing connection 1 14:42:12.796308 http.c:781 == Info: schannel: shutting down SSL/TLS connection with PROXYADDRESS port 443 14:42:12.797310 gvfs-helper.c:1187 | d3 | main | region_leave | | 10.690174 | 0.899665 | gvfs-helper | label:GET/objects(cs) 14:42:12.818511 run-command.c:993 | d1 | main | child_exit | | 91.256932 | 10.807573 | | ....[ch8] pid:10964 code:143 14:42:12.818511 gvfs-helper-client.c:513 | d1 | main | region_leave | r1 | 91.256968 | 10.659662 | gh-client | ..label:objects/get 14:42:12.818511 promisor-remote.c:249 | d1 | main | data | r1 | 91.257517 | 75.111614 | bug | ..fetch_objects/gvfs-helper:1 14:42:12.818511 gvfs-helper-client.c:400 | d1 | main | printf | | 91.257536 | | | ..gh_client__queue_oid: e745d9a9d5b562918e37e7bb53cf187edd06ccd2 14:42:12.818511 run-command.c:738 | d1 | main | child_start | | 91.257633 | | | ..[ch9] class:subprocess argv:[git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:42:12.855165 common-main.c:48 | d2 | main | version | | | | | 2.33.0.vfs.0.0 14:42:12.856162 common-main.c:49 | d2 | main | start | | 0.011580 | | | git gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:42:12.885167 ..._win32_process_info.c:118 | d2 | main | data_json | r0 | 0.040987 | 0.040987 | process | windows/ancestry:["git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:42:12.887168 git.c:808 | d2 | main | cmd_name | | | | | _run_dashed_ (fetch/_run_dashed_) 14:42:12.887168 run-command.c:738 | d2 | main | child_start | | 0.042667 | | | [ch0] class:dashed argv:[git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server] 14:42:12.925135 common-main.c:48 | d3 | main | version | | | | | 2.33.0.vfs.0.0 14:42:12.926135 common-main.c:49 | d3 | main | start | | 0.011574 | | | git-gvfs-helper --fallback --cache-server=trust --shared-cache=C:/.scalarCache/id_f5929afd-4721-43c0-bb4a-01cae820fce1 server 14:42:12.959134 ..._win32_process_info.c:118 | d3 | main | data_json | r0 | 0.044651 | 0.044651 | process | windows/ancestry:["git.exe","git.exe","scalar.exe","scalar.exe","cmd.exe","explorer.exe"] 14:42:12.959134 gvfs-helper.c:4175 | d3 | main | cmd_name | | | | | gvfs-helper (fetch/_run_dashed_/gvfs-helper) 14:42:12.961137 repository.c:132 | d3 | main | def_repo | r1 | | | | worktree:C:/testZ/1/2/15/Test/src 14:42:12.965135 gvfs-helper-client.c:439 | d1 | main | region_enter | r1 | 91.404465 | | gh-client | ..label:objects/post 14:42:12.962136 gvfs-helper.c:4070 | d3 | main | cmd_mode | | | | | server 14:42:12.963137 gvfs-helper.c:1334 | d3 | main | data | | 0.048067 | 0.048067 | gvfs-helper | remote/url:https://SERVERADDRESS/DefaultCollection/Test/_git/Test 14:42:12.965135 gvfs-helper.c:1392 | d3 | main | data | | 0.050693 | 0.050693 | gvfs-helper | cache/url:https://PROXYADDRESS:443/f5929afd472143c0bb4a01cae820fce1 14:42:12.966133 run-command.c:738 | d3 | main | child_start | | 0.051194 | | | [ch0] class:cred argv:['C:/Program\ Files/Git/mingw64/libexec/git-core/git-credential-manager-core.exe get'] 14:42:15.778072 run-command.c:993 | d3 | main | child_exit | | 2.863175 | 2.811981 | | [ch0] pid:3828 code:0 14:42:15.779073 gvfs-helper.c:1150 | d3 | main | region_enter | | 2.863975 | | gvfs-helper | label:POST/objects(cs) 14:42:15.790074 http.c:781 == Info: Trying PROXYIP:443... 14:42:15.977795 http.c:781 == Info: Connected to PROXYADDRESS (PROXYIP) port 443 (#0) 14:42:15.977795 http.c:781 == Info: schannel: disabled automatic use of client certificate 14:42:16.077537 ..._win32_process_info.c:166 | d3 | th01:unknown | data_json | r1 | 83.097902 | 18446744073709.550781 | process | windows/memory:{"PageFaultCount":8227,"PeakWorkingSetSize":11362304,"PeakPagefileUsage":4050944} 14:42:16.077537 compat/mingw.c:2873 | d3 | th01:unknown | exit | | 83.098109 | | | code:130 14:42:16.078529 trace2/tr2_tgt_perf.c:213 | d3 | th01:unknown | atexit | | 83.098729 | | | code:130 14:42:16.077537 ..._win32_process_info.c:166 | d1 | th01:unknown | data_json | r1 | 94.516842 | 0.000000 | process | windows/memory:{"PageFaultCount":18514,"PeakWorkingSetSize":8876032,"PeakPagefileUsage":3796992} 14:42:16.078529 compat/mingw.c:2873 | d1 | th01:unknown | exit | | 94.516924 | | | code:130 14:42:16.078529 trace2/tr2_tgt_perf.c:213 | d1 | th01:unknown | atexit | | 94.517384 | | | code:130 14:42:16.077537 ..._win32_process_info.c:166 | d3 | th01:unknown | data_json | r1 | 3.163283 | 0.000000 | process | windows/memory:{"PageFaultCount":7978,"PeakWorkingSetSize":10424320,"PeakPagefileUsage":4059136} 14:42:16.078529 compat/mingw.c:2873 | d3 | th01:unknown | exit | | 3.163374 | | | code:130 14:42:16.078529 trace2/tr2_tgt_perf.c:213 | d3 | th01:unknown | atexit | | 3.163700 | | | code:130 14:42:16.078529 ..._win32_process_info.c:166 | d0 | th01:unknown | data_json | r1 | 100.105809 | 0.000000 | process | windows/memory:{"PageFaultCount":5356,"PeakWorkingSetSize":7798784,"PeakPagefileUsage":3579904} 14:42:16.078529 compat/mingw.c:2873 | d0 | th01:unknown | exit | | 100.105857 | | | code:130 14:42:16.078529 trace2/tr2_tgt_perf.c:213 | d0 | th01:unknown | atexit | | 100.105881 | | | code:130 14:42:16.089531 run-command.c:993 | d2 | main | child_exit | | 83.179768 | 83.138288 | | [ch0] pid:17712 code:130 14:42:16.089531 git.c:833 | d2 | main | exit | | 83.179854 | | | code:130 14:42:16.089531 trace2/tr2_tgt_perf.c:213 | d2 | main | atexit | | 83.179880 | | | code:130 14:42:16.090530 run-command.c:993 | d2 | main | child_exit | | 3.246327 | 3.203660 | | [ch0] pid:12024 code:130 14:42:16.090530 git.c:833 | d2 | main | exit | | 3.246378 | | | code:130 14:42:16.090530 trace2/tr2_tgt_perf.c:213 | d2 | main | atexit | | 3.246391 | | | code:130