Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

fix(bitbucket): detect expired OAuth credentials #1812

Open
wants to merge 1 commit into
base: main
Choose a base branch
from

Conversation

becm
Copy link

@becm becm commented Jan 25, 2025

The code flow for OAuth-only authMode must report back credential expiry correctly.

If neither of the supported modes is selected, this constitutes an invalid configuration anyway.
Better let more sophisticated existing parts of the code (token refresh/create) deal with this inconsistency.

Resolves #1775

fixes git-ecosystem#1775
credentials MUST be valid for OAuth and/or BasicAuth modes
credentials SHOULD be considered invalid on auth mode mismatch
setting override exists to skip credential expiry checks
@r-hans
Copy link

r-hans commented Feb 3, 2025

Hey @becm,

please find attached the log files. This log comes from a "git fetch" with still valid access_token and "bitbucketAlwaysRefreshCredentials = false". For me, this looks good so far.

I will re-record the log with expired access_token in 1-2h.

C:\git\>git fetch
14:20:20.130569 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/bin
14:20:20.146187 git.c:465               trace: built-in: git fetch
14:20:20.146187 run-command.c:657       trace: run_command: GIT_DIR=.git git remote-https origin <my-git-url>
14:20:20.262547 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:20.262547 git.c:750               trace: exec: git-remote-https origin <my-git-url>
14:20:20.262547 run-command.c:657       trace: run_command: git-remote-https origin <my-git-url>
14:20:20.366897 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:20.366897 http.c:868              == Info: Uses proxy env variable no_proxy == '<my-proxy-settings>'
14:20:20.366897 http.c:868              == Info: Couldn't find host <hostname> in the .netrc file; using defaults
14:20:20.382517 http.c:868              == Info: Host <hostname>:443 was resolved.
14:20:20.382517 http.c:868              == Info: IPv6: (none)
14:20:20.382517 http.c:868              == Info: IPv4: 10.139.209.84
14:20:20.382517 http.c:868              == Info:   Trying 10.139.209.84:443...
14:20:20.399698 http.c:868              == Info: Connected to <hostname> (10.139.209.84) port 443
14:20:20.399698 http.c:868              == Info: schannel: disabled automatic use of client certificate
14:20:20.446134 http.c:868              == Info: using HTTP/1.x
14:20:20.446134 http.c:815              => Send header, 0000000264 bytes (0x00000108)
14:20:20.446134 http.c:827              => Send header: GET /scm/soc/socialcoding-python-package.git/info/refs?service=git-upload-pack HTTP/1.1
14:20:20.446134 http.c:827              => Send header: Host: <hostname>
14:20:20.446134 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
14:20:20.446134 http.c:827              => Send header: Accept: */*
14:20:20.446134 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
14:20:20.461893 http.c:827              => Send header: Pragma: no-cache
14:20:20.461893 http.c:827              => Send header: Git-Protocol: version=2
14:20:20.461893 http.c:827              => Send header:
14:20:20.461893 http.c:868              == Info: Request completely sent off
14:20:20.477531 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
14:20:20.477531 http.c:827              <= Recv header: HTTP/1.1 401
14:20:20.477531 http.c:815              <= Recv header, 0000000039 bytes (0x00000027)
14:20:20.477531 http.c:827              <= Recv header: X-AREQUESTID: *1TL9EG1x860x46926163x7
14:20:20.477531 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:20.477531 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
14:20:20.477531 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
14:20:20.477531 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
14:20:20.477531 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:20.477531 http.c:827              <= Recv header: x-content-type-options: nosniff
14:20:20.477531 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
14:20:20.477531 http.c:827              <= Recv header: WWW-Authenticate: Basic realm="Atlassian Bitbucket"
14:20:20.477531 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
14:20:20.477531 http.c:827              <= Recv header: Transfer-Encoding: chunked
14:20:20.477531 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
14:20:20.477531 http.c:827              <= Recv header: Date: Mon, 03 Feb 2025 13:20:20 GMT
14:20:20.477531 http.c:815              <= Recv header, 0000000088 bytes (0x00000058)
14:20:20.477531 http.c:827              <= Recv header: Set-Cookie: foo=rd3673o00000000000000000000ffff0a8bd150o7990; path=/; Httponly; Secure
14:20:20.477531 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
14:20:20.477531 http.c:827              <= Recv header:
14:20:20.477531 http.c:868              == Info: Connection #0 to host <hostname> left intact
14:20:20.477531 run-command.c:657       trace: run_command: 'C:/Program\ Files\ \(x86\)/Git\ Credential\ Manager/git-credential-manager.exe get'
14:20:20.777393 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:20.777393 git.c:465               trace: built-in: git config --null --list
14:20:20.840573 ...\Application.cs:106  trace: [RunInternalAsync] Version: 2.6.1.0
14:20:20.840573 ...\Application.cs:107  trace: [RunInternalAsync] Runtime: .NET Framework 4.8.9290.0
14:20:20.840573 ...\Application.cs:108  trace: [RunInternalAsync] Platform: Windows (x86-64)
14:20:20.840573 ...\Application.cs:109  trace: [RunInternalAsync] OSVersion: 10.0 (build 22631)
14:20:20.840573 ...\Application.cs:110  trace: [RunInternalAsync] AppPath: C:\Program Files (x86)\Git Credential Manager\git-credential-manager.exe
14:20:20.840573 ...\Application.cs:111  trace: [RunInternalAsync] InstallDir: C:\Program Files (x86)\Git Credential Manager\
14:20:20.840573 ...\Application.cs:112  trace: [RunInternalAsync] Arguments: get
14:20:20.856095 ...GitCommandBase.cs:32 trace: [ExecuteAsync] Start 'get' command...
14:20:20.871783 ...GitCommandBase.cs:46 trace: [ExecuteAsync] Detecting host provider for input:
14:20:20.871783 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   protocol=https
14:20:20.871783 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   host=<hostname>
14:20:20.871783 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   wwwauth=Basic realm="Atlassian Bitbucket"
14:20:20.871783 ...oviderRegistry.cs:99 trace: [GetProviderAsync] Host provider override was set id='bitbucket'
14:20:20.887346 ...GitCommandBase.cs:49 trace: [ExecuteAsync] Host provider 'Bitbucket' was selected.
14:20:20.887346 ...tHostProvider.cs:271 trace: [GetSupportedAuthenticationModesAsync] Supported authentication modes override present: OAuth
14:20:20.887346 ...tHostProvider.cs:112 trace: [GetStoredCredentials] Look for existing credentials under https://<hostname> ...
14:20:20.900012 ...tHostProvider.cs:122 trace: [GetStoredCredentials] Found stored credentials: OAUTH_USERNAME/********
14:20:20.903038 ...tHostProvider.cs:411 trace: [ValidateCredentialsWork] Validate credentials (OAUTH_USERNAME/********) are fresh for https://<hostname>/ ...
14:20:20.903038 ...tbucketRestApi.cs:53 trace: [GetUserInformationAsync] HTTP: GET https://<hostname>/rest/api/1.0/users
14:20:20.903038 ...pClientFactory.cs:60 trace: [CreateClient] Creating new HTTP client instance...
14:20:20.918692 ...ClientFactory.cs:323 trace: [TryCreateProxy] Created a WebProxy instance:
14:20:20.918692 ...ClientFactory.cs:324 trace: [TryCreateProxy]         address=http://rb-proxy-de.bosch.com:8080/
14:20:20.918692 ...ClientFactory.cs:324 trace: [TryCreateProxy]         useDefaultCredentials=true
14:20:20.918692 ...ClientFactory.cs:324 trace: [TryCreateProxy]         noProxy=127.0.0.1,localhost,rb-omscloudasl4.server.bosch.com,127.0.0.*,.docker.internal,192.168.49.2
14:20:20.918692 ...ClientFactory.cs:324 trace: [TryCreateProxy]         bypass=(\.|\:\/\/)127\.0\.0\.1$,(\.|\:\/\/)localhost$,(\.|\:\/\/)rb-omscloudasl4\.server\.bosch\.com$,(\.|\:\/\/)127\.0\.0\.\*$,(\.|\:\/\/)docker\.internal$,(\.|\:\/\/)192\.168\.49\.2$
14:20:20.918692 ...pClientFactory.cs:66 trace: [CreateClient] HTTP client is using the configured proxy.
14:20:20.934460 ...pClientFactory.cs:80 trace: [CreateClient] Git's SSL/TLS backend is: Schannel
14:20:20.952397 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:20.952397 git.c:465               trace: built-in: git version
14:20:20.982813 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:20.998380 git.c:465               trace: built-in: git config --null --type=path http.https://<hostname>.sslCAInfo
14:20:21.032094 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.032094 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.sslCAInfo
14:20:21.080705 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.080705 git.c:465               trace: built-in: git config --null --type=path http.https://socialcoding.bosch.com.sslCAInfo
14:20:21.125754 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.125754 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.sslCAInfo
14:20:21.204911 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.204911 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.sslCAInfo
14:20:21.221005 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.221005 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.sslCAInfo
14:20:21.301070 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.301070 git.c:465               trace: built-in: git config --null --type=path http.sslCAInfo
14:20:21.317962 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.317962 git.c:465               trace: built-in: git config --null --type=path http.https://<hostname>.cookieFile
14:20:21.362807 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.362807 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.cookieFile
14:20:21.410362 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.410362 git.c:465               trace: built-in: git config --null --type=path http.https://socialcoding.bosch.com.cookieFile
14:20:21.441779 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.441779 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.cookieFile
14:20:21.490011 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.490011 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.cookieFile
14:20:21.536325 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.536325 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.cookieFile
14:20:21.583453 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:21.583453 git.c:465               trace: built-in: git config --null --type=path http.cookieFile
14:20:21.819935 ...tbucketRestApi.cs:56 trace: [GetUserInformationAsync] HTTP: Response 200 [OK]
14:20:21.819935 ...tHostProvider.cs:420 trace: [ValidateCredentialsWork] Validated existing credentials using OAuth
14:20:21.819935 ...\GetCommand.cs:39    trace: [ExecuteInternalAsync] Writing credentials to output:
14:20:21.819935 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   protocol=https
14:20:21.819935 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   host=<hostname>
14:20:21.819935 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   username=OAUTH_USERNAME
14:20:21.832745 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   password=********
14:20:21.832745 ...GitCommandBase.cs:53 trace: [ExecuteAsync] End 'get' command...
14:20:21.844474 http.c:868              == Info: Uses proxy env variable no_proxy == '<my-proxy-settings>'
14:20:21.844474 http.c:868              == Info: Found bundle for host: 0x2881d8a1ec0 [serially]
14:20:21.844474 http.c:868              == Info: Re-using existing connection with host <hostname>
14:20:21.844474 http.c:868              == Info: Server auth using Basic with user 'OAUTH_USERNAME'
14:20:21.844474 http.c:815              => Send header, 0000000467 bytes (0x000001d3)
14:20:21.844474 http.c:827              => Send header: GET /scm/soc/socialcoding-python-package.git/info/refs?service=git-upload-pack HTTP/1.1
14:20:21.844474 http.c:827              => Send header: Host: <hostname>
14:20:21.844474 http.c:827              => Send header: Authorization: Basic <redacted>
14:20:21.844474 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
14:20:21.844474 http.c:827              => Send header: Accept: */*
14:20:21.844474 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
14:20:21.844474 http.c:827              => Send header: Pragma: no-cache
14:20:21.844474 http.c:827              => Send header: Git-Protocol: version=2
14:20:21.844474 http.c:827              => Send header:
14:20:21.844474 http.c:868              == Info: Request completely sent off
14:20:21.931026 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
14:20:21.931026 http.c:827              <= Recv header: HTTP/1.1 200
14:20:21.931026 http.c:815              <= Recv header, 0000000039 bytes (0x00000027)
14:20:21.931026 http.c:827              <= Recv header: X-AREQUESTID: *1TL9EG1x860x46926221x7
14:20:21.931026 http.c:815              <= Recv header, 0000000024 bytes (0x00000018)
14:20:21.931026 http.c:827              <= Recv header: Cache-Control: private
14:20:21.931026 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:21.931026 http.c:827              <= Recv header: X-AUSERID: 11095
14:20:21.931026 http.c:815              <= Recv header, 0000000021 bytes (0x00000015)
14:20:21.931026 http.c:827              <= Recv header: X-AUSERNAME: RHP9FE
14:20:21.931026 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:21.931026 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
14:20:21.931026 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
14:20:21.931026 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
14:20:21.931026 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:21.931026 http.c:827              <= Recv header: x-content-type-options: nosniff
14:20:21.931026 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:21.931026 http.c:827              <= Recv header: x-bb-async: true
14:20:21.931026 http.c:815              <= Recv header, 0000000040 bytes (0x00000028)
14:20:21.931026 http.c:827              <= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT
14:20:21.931026 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:21.931026 http.c:827              <= Recv header: Pragma: no-cache
14:20:21.931026 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
14:20:21.931026 http.c:827              <= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate
14:20:21.931026 http.c:815              <= Recv header, 0000000059 bytes (0x0000003b)
14:20:21.931026 http.c:827              <= Recv header: Content-Type: application/x-git-upload-pack-advertisement
14:20:21.931026 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
14:20:21.931026 http.c:827              <= Recv header: Transfer-Encoding: chunked
14:20:21.931026 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
14:20:21.931026 http.c:827              <= Recv header: Date: Mon, 03 Feb 2025 13:20:21 GMT
14:20:21.931026 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
14:20:21.931026 http.c:827              <= Recv header:
14:20:21.931026 http.c:868              == Info: Connection #0 to host <hostname> left intact
14:20:21.931026 run-command.c:657       trace: run_command: 'C:/Program\ Files\ \(x86\)/Git\ Credential\ Manager/git-credential-manager.exe store'
14:20:22.073725 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:22.073725 git.c:465               trace: built-in: git config --null --list
14:20:22.138028 ...\Application.cs:106  trace: [RunInternalAsync] Version: 2.6.1.0
14:20:22.138028 ...\Application.cs:107  trace: [RunInternalAsync] Runtime: .NET Framework 4.8.9290.0
14:20:22.138028 ...\Application.cs:108  trace: [RunInternalAsync] Platform: Windows (x86-64)
14:20:22.138028 ...\Application.cs:109  trace: [RunInternalAsync] OSVersion: 10.0 (build 22631)
14:20:22.138028 ...\Application.cs:110  trace: [RunInternalAsync] AppPath: C:\Program Files (x86)\Git Credential Manager\git-credential-manager.exe
14:20:22.138028 ...\Application.cs:111  trace: [RunInternalAsync] InstallDir: C:\Program Files (x86)\Git Credential Manager\
14:20:22.138028 ...\Application.cs:112  trace: [RunInternalAsync] Arguments: store
14:20:22.167688 ...GitCommandBase.cs:32 trace: [ExecuteAsync] Start 'store' command...
14:20:22.167688 ...GitCommandBase.cs:46 trace: [ExecuteAsync] Detecting host provider for input:
14:20:22.167688 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   protocol=https
14:20:22.167688 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   host=<hostname>
14:20:22.167688 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   username=OAUTH_USERNAME
14:20:22.167688 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   password=********
14:20:22.184529 ...oviderRegistry.cs:99 trace: [GetProviderAsync] Host provider override was set id='bitbucket'
14:20:22.184529 ...GitCommandBase.cs:49 trace: [ExecuteAsync] Host provider 'Bitbucket' was selected.
14:20:22.184529 ...tHostProvider.cs:335 trace: [StoreCredentialAsync] Storing credential...
14:20:22.184529 ...tHostProvider.cs:337 trace: [StoreCredentialAsync] Credential was successfully stored.
14:20:22.184529 ...GitCommandBase.cs:53 trace: [ExecuteAsync] End 'store' command...
14:20:22.203135 run-command.c:657       trace: run_command: 'git credential-wincred store'
14:20:22.279579 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:22.279579 git.c:750               trace: exec: git-credential-wincred store
14:20:22.279579 run-command.c:657       trace: run_command: git-credential-wincred store
14:20:22.391628 run-command.c:657       trace: run_command: 'git credential-oauth store'
14:20:22.442543 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:22.442543 git.c:750               trace: exec: git-credential-oauth store
14:20:22.442543 run-command.c:657       trace: run_command: git-credential-oauth store
14:20:22.516009 run-command.c:657       trace: run_command: 'C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store'
C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store: -c: line 1: syntax error near unexpected token `('
C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store: -c: line 1: `C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store'
14:20:22.594655 http.c:868              == Info: Uses proxy env variable no_proxy == '<my-proxy-settings>'
14:20:22.594655 http.c:868              == Info: Found bundle for host: 0x2881d8a1ec0 [serially]
14:20:22.594655 http.c:868              == Info: Re-using existing connection with host <hostname>
14:20:22.594655 http.c:868              == Info: Server auth using Basic with user 'OAUTH_USERNAME'
14:20:22.594655 http.c:815              => Send header, 0000000539 bytes (0x0000021b)
14:20:22.594655 http.c:827              => Send header: POST /scm/soc/socialcoding-python-package.git/git-upload-pack HTTP/1.1
14:20:22.594655 http.c:827              => Send header: Host: <hostname>
14:20:22.594655 http.c:827              => Send header: Authorization: Basic <redacted>
14:20:22.594655 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
14:20:22.594655 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
14:20:22.594655 http.c:827              => Send header: Content-Type: application/x-git-upload-pack-request
14:20:22.594655 http.c:827              => Send header: Accept: application/x-git-upload-pack-result
14:20:22.594655 http.c:827              => Send header: Git-Protocol: version=2
14:20:22.594655 http.c:827              => Send header: Content-Length: 263
14:20:22.594655 http.c:827              => Send header:
14:20:22.594655 http.c:868              == Info: upload completely sent off: 263 bytes
14:20:22.721066 http.c:868              == Info: schannel: failed to decrypt data, need more data
14:20:22.721066 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
14:20:22.721066 http.c:827              <= Recv header: HTTP/1.1 200
14:20:22.721066 http.c:815              <= Recv header, 0000000040 bytes (0x00000028)
14:20:22.721066 http.c:827              <= Recv header: X-AREQUESTID: *1TL9EG1x860x46926262x11
14:20:22.721066 http.c:815              <= Recv header, 0000000024 bytes (0x00000018)
14:20:22.721066 http.c:827              <= Recv header: Cache-Control: private
14:20:22.721066 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:22.721066 http.c:827              <= Recv header: X-AUSERID: 11095
14:20:22.721066 http.c:815              <= Recv header, 0000000021 bytes (0x00000015)
14:20:22.721066 http.c:827              <= Recv header: X-AUSERNAME: RHP9FE
14:20:22.721066 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:22.721066 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
14:20:22.721066 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
14:20:22.721066 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
14:20:22.721066 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
14:20:22.721066 http.c:827              <= Recv header: x-content-type-options: nosniff
14:20:22.721066 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:22.721066 http.c:827              <= Recv header: x-bb-async: true
14:20:22.721066 http.c:815              <= Recv header, 0000000040 bytes (0x00000028)
14:20:22.721066 http.c:827              <= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT
14:20:22.721066 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
14:20:22.721066 http.c:827              <= Recv header: Pragma: no-cache
14:20:22.721066 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
14:20:22.721066 http.c:827              <= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate
14:20:22.721066 http.c:815              <= Recv header, 0000000052 bytes (0x00000034)
14:20:22.721066 http.c:827              <= Recv header: Content-Type: application/x-git-upload-pack-result
14:20:22.721066 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
14:20:22.721066 http.c:827              <= Recv header: Transfer-Encoding: chunked
14:20:22.721066 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
14:20:22.721066 http.c:827              <= Recv header: Date: Mon, 03 Feb 2025 13:20:22 GMT
14:20:22.721066 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
14:20:22.721066 http.c:827              <= Recv header:
14:20:22.721066 http.c:868              == Info: Connection #0 to host <hostname> left intact
14:20:22.721066 run-command.c:657       trace: run_command: git rev-list --objects --stdin --not --exclude-hidden=fetch --all --quiet --alternate-refs
14:20:22.783433 run-command.c:1521      run_processes_parallel: preparing to run up to 1 tasks
14:20:22.783433 run-command.c:1549      run_processes_parallel: done
14:20:22.783433 run-command.c:657       trace: run_command: git maintenance run --auto --no-quiet
14:20:22.799060 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
14:20:22.799060 git.c:465               trace: built-in: git maintenance run --auto --no-quiet`

@r-hans
Copy link

r-hans commented Feb 4, 2025

Once again, now a log with expired credentials

C:\git\soc\socialcoding-python-package>git fetch
07:50:31.019525 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/bin
07:50:31.035293 git.c:465               trace: built-in: git fetch
07:50:31.046964 run-command.c:657       trace: run_command: GIT_DIR=.git git remote-https origin <repo-url>
07:50:31.289885 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:31.292412 git.c:750               trace: exec: git-remote-https origin <repo-url>
07:50:31.292412 run-command.c:657       trace: run_command: git-remote-https origin <repo-url>
07:50:31.452005 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:31.513555 http.c:868              == Info: Uses proxy env variable no_proxy == '<no_proxy>'
07:50:31.513555 http.c:868              == Info: Couldn't find host sourcecode.socialcoding.bosch.com in the .netrc file; using defaults
07:50:31.530074 http.c:868              == Info: Host sourcecode.socialcoding.bosch.com:443 was resolved.
07:50:31.530074 http.c:868              == Info: IPv6: (none)
07:50:31.530074 http.c:868              == Info: IPv4: 10.139.209.84
07:50:31.530074 http.c:868              == Info:   Trying 10.139.209.84:443...
07:50:31.530074 http.c:868              == Info: Connected to <fqdn> (10.139.209.84) port 443
07:50:31.530074 http.c:868              == Info: schannel: disabled automatic use of client certificate
07:50:31.563179 http.c:868              == Info: using HTTP/1.x
07:50:31.563179 http.c:815              => Send header, 0000000264 bytes (0x00000108)
07:50:31.563179 http.c:827              => Send header: GET /scm/soc/socialcoding-python-package.git/info/refs?service=git-upload-pack HTTP/1.1
07:50:31.563179 http.c:827              => Send header: Host: <fqdn>
07:50:31.563179 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
07:50:31.563179 http.c:827              => Send header: Accept: */*
07:50:31.563179 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
07:50:31.563179 http.c:827              => Send header: Pragma: no-cache
07:50:31.563179 http.c:827              => Send header: Git-Protocol: version=2
07:50:31.563179 http.c:827              => Send header:
07:50:31.563179 http.c:868              == Info: Request completely sent off
07:50:31.563179 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
07:50:31.563179 http.c:827              <= Recv header: HTTP/1.1 401
07:50:31.563179 http.c:815              <= Recv header, 0000000039 bytes (0x00000027)
07:50:31.563179 http.c:827              <= Recv header: X-AREQUESTID: *1AX4HUAx470x36989634x7
07:50:31.563179 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:31.563179 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
07:50:31.563179 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
07:50:31.563179 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
07:50:31.563179 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:31.563179 http.c:827              <= Recv header: x-content-type-options: nosniff
07:50:31.563179 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
07:50:31.563179 http.c:827              <= Recv header: WWW-Authenticate: Basic realm="Atlassian Bitbucket"
07:50:31.563179 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
07:50:31.563179 http.c:827              <= Recv header: Transfer-Encoding: chunked
07:50:31.563179 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
07:50:31.563179 http.c:827              <= Recv header: Date: Tue, 04 Feb 2025 06:50:30 GMT
07:50:31.563179 http.c:815              <= Recv header, 0000000088 bytes (0x00000058)
07:50:31.563179 http.c:827              <= Recv header: Set-Cookie: foo=rd3673o00000000000000000000ffff0a8bd153o7990; path=/; Httponly; Secure
07:50:31.563179 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
07:50:31.563179 http.c:827              <= Recv header:
07:50:31.563179 http.c:868              == Info: Connection #0 to host <fqdn> left intact
07:50:31.563179 run-command.c:657       trace: run_command: 'C:/Program\ Files\ \(x86\)/Git\ Credential\ Manager/git-credential-manager.exe get'
07:50:32.716568 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:32.726636 git.c:465               trace: built-in: git config --null --list
07:50:32.787086 ...\Application.cs:106  trace: [RunInternalAsync] Version: 2.6.1.0
07:50:32.787086 ...\Application.cs:107  trace: [RunInternalAsync] Runtime: .NET Framework 4.8.9290.0
07:50:32.796685 ...\Application.cs:108  trace: [RunInternalAsync] Platform: Windows (x86-64)
07:50:32.796685 ...\Application.cs:109  trace: [RunInternalAsync] OSVersion: 10.0 (build 22631)
07:50:32.796685 ...\Application.cs:110  trace: [RunInternalAsync] AppPath: C:\Program Files (x86)\Git Credential Manager\git-credential-manager.exe
07:50:32.796685 ...\Application.cs:111  trace: [RunInternalAsync] InstallDir: C:\Program Files (x86)\Git Credential Manager\
07:50:32.796685 ...\Application.cs:112  trace: [RunInternalAsync] Arguments: get
07:50:32.819041 ...GitCommandBase.cs:32 trace: [ExecuteAsync] Start 'get' command...
07:50:32.830785 ...GitCommandBase.cs:46 trace: [ExecuteAsync] Detecting host provider for input:
07:50:32.835771 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   protocol=https
07:50:32.835771 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   host=<fqdn>
07:50:32.835771 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   wwwauth=Basic realm="Atlassian Bitbucket"
07:50:32.835771 ...oviderRegistry.cs:99 trace: [GetProviderAsync] Host provider override was set id='bitbucket'
07:50:32.835771 ...GitCommandBase.cs:49 trace: [ExecuteAsync] Host provider 'Bitbucket' was selected.
07:50:32.835771 ...tHostProvider.cs:271 trace: [GetSupportedAuthenticationModesAsync] Supported authentication modes override present: OAuth
07:50:32.847337 ...tHostProvider.cs:112 trace: [GetStoredCredentials] Look for existing credentials under https://<fqdn> ...
07:50:32.851415 ...tHostProvider.cs:122 trace: [GetStoredCredentials] Found stored credentials: OAUTH_USERNAME/********
07:50:32.851415 ...tHostProvider.cs:411 trace: [ValidateCredentialsWork] Validate credentials (OAUTH_USERNAME/********) are fresh for https://<fqdn>/ ...
07:50:32.963509 ...tbucketRestApi.cs:53 trace: [GetUserInformationAsync] HTTP: GET https://<fqdn>/rest/api/1.0/users
07:50:32.963509 ...pClientFactory.cs:60 trace: [CreateClient] Creating new HTTP client instance...
07:50:32.963509 ...ClientFactory.cs:323 trace: [TryCreateProxy] Created a WebProxy instance:
07:50:32.963509 ...ClientFactory.cs:324 trace: [TryCreateProxy]         address=<proxy>:8080/
07:50:32.963509 ...ClientFactory.cs:324 trace: [TryCreateProxy]         useDefaultCredentials=true
07:50:32.963509 ...ClientFactory.cs:324 trace: [TryCreateProxy]         noProxy=<no_proxy>
07:50:32.963509 ...ClientFactory.cs:324 trace: [TryCreateProxy]         bypass=(\.|\:\/\/)127\.0\.0\.1$,(\.|\:\/\/)localhost$,(\.|\:\/\/)rb-omscloudasl4\.server\.bosch\.com$,(\.|\:\/\/)127\.0\.0\.\*$,(\.|\:\/\/)docker\.internal$,(\.|\:\/\/)192\.168\.49\.2$
07:50:32.963509 ...pClientFactory.cs:66 trace: [CreateClient] HTTP client is using the configured proxy.
07:50:33.041588 ...pClientFactory.cs:80 trace: [CreateClient] Git's SSL/TLS backend is: Schannel
07:50:33.057236 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.057236 git.c:465               trace: built-in: git version
07:50:33.105413 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.105413 git.c:465               trace: built-in: git config --null --type=path http.https://<fqdn>.sslCAInfo
07:50:33.153722 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.153722 git.c:465               trace: built-in: git config --null --type=path http.<fqdn>.sslCAInfo
07:50:33.201202 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.201202 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.sslCAInfo
07:50:33.249193 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.249193 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.sslCAInfo
07:50:33.291981 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.298129 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.sslCAInfo
07:50:33.337410 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.344916 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.sslCAInfo
07:50:33.381966 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.381966 git.c:465               trace: built-in: git config --null --type=path http.sslCAInfo
07:50:33.455992 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.455992 git.c:465               trace: built-in: git config --null --type=path http.https://<fqdn>.cookieFile
07:50:33.479376 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.480514 git.c:465               trace: built-in: git config --null --type=path http.<fqdn>.cookieFile
07:50:33.518896 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.518896 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.cookieFile
07:50:33.566573 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.566573 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.cookieFile
07:50:33.614708 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.614708 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.cookieFile
07:50:33.661460 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.663465 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.cookieFile
07:50:33.696842 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.710200 git.c:465               trace: built-in: git config --null --type=path http.cookieFile
07:50:33.964456 ...tbucketRestApi.cs:56 trace: [GetUserInformationAsync] HTTP: Response 401 [Unauthorized]
07:50:33.965667 ...tHostProvider.cs:426 trace: [ValidateCredentialsWork] Failed to validate existing credentials using OAuth
07:50:33.965667 ...tHostProvider.cs:427 trace: [ValidateCredentialsWork] ! error: 'Failed to resolve username. HTTP: Unauthorized'.
07:50:33.965667 ...tHostProvider.cs:135 trace: [GetRefreshedCredentials] Refresh credentials...
07:50:33.965667 ...tHostProvider.cs:141 trace: [GetRefreshedCredentials] Checking for refresh token...
07:50:33.965667 ...tHostProvider.cs:181 trace: [GetRefreshedCredentials] Found stored refresh token: ********
07:50:33.965667 ...tHostProvider.cs:207 trace: [GetOAuthCredentialsViaRefreshFlow] Refreshing OAuth credentials using refresh token...
07:50:33.965667 ...pClientFactory.cs:60 trace: [CreateClient] Creating new HTTP client instance...
07:50:33.965667 ...ClientFactory.cs:323 trace: [TryCreateProxy] Created a WebProxy instance:
07:50:33.965667 ...ClientFactory.cs:324 trace: [TryCreateProxy]         address=<proxy>:8080/
07:50:33.965667 ...ClientFactory.cs:324 trace: [TryCreateProxy]         useDefaultCredentials=true
07:50:33.965667 ...ClientFactory.cs:324 trace: [TryCreateProxy]         noProxy=<no_proxy>
07:50:33.965667 ...ClientFactory.cs:324 trace: [TryCreateProxy]         bypass=<bypass-options>
07:50:33.965667 ...pClientFactory.cs:66 trace: [CreateClient] HTTP client is using the configured proxy.
07:50:33.980172 ...pClientFactory.cs:80 trace: [CreateClient] Git's SSL/TLS backend is: Schannel
07:50:33.996213 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:33.996717 git.c:465               trace: built-in: git config --null --type=path http.https://<fqdn>.sslCAInfo
07:50:34.063508 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.065700 git.c:465               trace: built-in: git config --null --type=path http.<fqdn>.sslCAInfo
07:50:34.080037 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.080037 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.sslCAInfo
07:50:34.130005 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.130005 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.sslCAInfo
07:50:34.173048 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.173048 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.sslCAInfo
07:50:34.221035 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.221035 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.sslCAInfo
07:50:34.269187 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.270462 git.c:465               trace: built-in: git config --null --type=path http.sslCAInfo
07:50:34.313190 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.317196 git.c:465               trace: built-in: git config --null --type=path http.https://<fqdn>.cookieFile
07:50:34.349501 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.363548 git.c:465               trace: built-in: git config --null --type=path http.<fqdn>.cookieFile
07:50:34.404807 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.404807 git.c:465               trace: built-in: git config --null --type=path http.<hostname>.cookieFile
07:50:34.461742 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.463267 git.c:465               trace: built-in: git config --null --type=path http.socialcoding.bosch.com.cookieFile
07:50:34.508847 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.508847 git.c:465               trace: built-in: git config --null --type=path http.https://bosch.com.cookieFile
07:50:34.557110 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.557110 git.c:465               trace: built-in: git config --null --type=path http.bosch.com.cookieFile
07:50:34.597645 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:34.605155 git.c:465               trace: built-in: git config --null --type=path http.cookieFile
07:50:34.880284 ...tHostProvider.cs:212 trace: [GetOAuthCredentialsViaRefreshFlow] Resolving username for refreshed OAuth credential...
07:50:34.880284 ...tbucketRestApi.cs:53 trace: [GetUserInformationAsync] HTTP: GET https://<fqdn>/rest/api/1.0/users
07:50:34.913303 ...tbucketRestApi.cs:56 trace: [GetUserInformationAsync] HTTP: Response 200 [OK]
07:50:34.913303 ...tHostProvider.cs:214 trace: [GetOAuthCredentialsViaRefreshFlow] Username for refreshed OAuth credential is 'OAUTH_USERNAME'
07:50:34.913303 ...tHostProvider.cs:217 trace: [GetOAuthCredentialsViaRefreshFlow] Storing new refresh token...
07:50:34.913303 ...\GetCommand.cs:39    trace: [ExecuteInternalAsync] Writing credentials to output:
07:50:34.913303 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   protocol=https
07:50:34.913303 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   host=<fqdn>
07:50:34.913303 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   username=OAUTH_USERNAME
07:50:34.913303 ...\GetCommand.cs:40    trace: [ExecuteInternalAsync]   password=********
07:50:34.926032 ...GitCommandBase.cs:53 trace: [ExecuteAsync] End 'get' command...
07:50:34.930110 http.c:868              == Info: Uses proxy env variable no_proxy == '<no_proxy>'
07:50:34.930110 http.c:868              == Info: Found bundle for host: 0x2202f571e40 [serially]
07:50:34.930110 http.c:868              == Info: Re-using existing connection with host <fqdn>
07:50:34.930110 http.c:868              == Info: Server auth using Basic with user 'OAUTH_USERNAME'
07:50:34.930110 http.c:815              => Send header, 0000000467 bytes (0x000001d3)
07:50:34.930110 http.c:827              => Send header: GET /scm/soc/socialcoding-python-package.git/info/refs?service=git-upload-pack HTTP/1.1
07:50:34.930110 http.c:827              => Send header: Host: <fqdn>
07:50:34.930110 http.c:827              => Send header: Authorization: Basic <redacted>
07:50:34.930110 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
07:50:34.942235 http.c:827              => Send header: Accept: */*
07:50:34.942235 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
07:50:34.942235 http.c:827              => Send header: Pragma: no-cache
07:50:34.942235 http.c:827              => Send header: Git-Protocol: version=2
07:50:34.942235 http.c:827              => Send header:
07:50:34.942235 http.c:868              == Info: Request completely sent off
07:50:35.037683 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
07:50:35.037683 http.c:827              <= Recv header: HTTP/1.1 200
07:50:35.037683 http.c:815              <= Recv header, 0000000039 bytes (0x00000027)
07:50:35.046804 http.c:827              <= Recv header: X-AREQUESTID: *1AX4HUAx470x36989763x6
07:50:35.046804 http.c:815              <= Recv header, 0000000024 bytes (0x00000018)
07:50:35.046804 http.c:827              <= Recv header: Cache-Control: private
07:50:35.046804 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:35.046804 http.c:827              <= Recv header: X-AUSERID: 11095
07:50:35.046804 http.c:815              <= Recv header, 0000000021 bytes (0x00000015)
07:50:35.046804 http.c:827              <= Recv header: X-AUSERNAME: RHP9FE
07:50:35.046804 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:35.046804 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
07:50:35.046804 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
07:50:35.046804 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
07:50:35.046804 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:35.046804 http.c:827              <= Recv header: x-content-type-options: nosniff
07:50:35.046804 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:35.046804 http.c:827              <= Recv header: x-bb-async: true
07:50:35.046804 http.c:815              <= Recv header, 0000000040 bytes (0x00000028)
07:50:35.046804 http.c:827              <= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT
07:50:35.046804 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:35.046804 http.c:827              <= Recv header: Pragma: no-cache
07:50:35.046804 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
07:50:35.046804 http.c:827              <= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate
07:50:35.046804 http.c:815              <= Recv header, 0000000059 bytes (0x0000003b)
07:50:35.046804 http.c:827              <= Recv header: Content-Type: application/x-git-upload-pack-advertisement
07:50:35.046804 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
07:50:35.046804 http.c:827              <= Recv header: Transfer-Encoding: chunked
07:50:35.046804 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
07:50:35.046804 http.c:827              <= Recv header: Date: Tue, 04 Feb 2025 06:50:34 GMT
07:50:35.046804 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
07:50:35.046804 http.c:827              <= Recv header:
07:50:35.050637 http.c:868              == Info: Connection #0 to host <fqdn> left intact
07:50:35.050637 run-command.c:657       trace: run_command: 'C:/Program\ Files\ \(x86\)/Git\ Credential\ Manager/git-credential-manager.exe store'
07:50:35.188933 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:35.188933 git.c:465               trace: built-in: git config --null --list
07:50:35.263259 ...\Application.cs:106  trace: [RunInternalAsync] Version: 2.6.1.0
07:50:35.263259 ...\Application.cs:107  trace: [RunInternalAsync] Runtime: .NET Framework 4.8.9290.0
07:50:35.263259 ...\Application.cs:108  trace: [RunInternalAsync] Platform: Windows (x86-64)
07:50:35.263259 ...\Application.cs:109  trace: [RunInternalAsync] OSVersion: 10.0 (build 22631)
07:50:35.263259 ...\Application.cs:110  trace: [RunInternalAsync] AppPath: C:\Program Files (x86)\Git Credential Manager\git-credential-manager.exe
07:50:35.263259 ...\Application.cs:111  trace: [RunInternalAsync] InstallDir: C:\Program Files (x86)\Git Credential Manager\
07:50:35.263259 ...\Application.cs:112  trace: [RunInternalAsync] Arguments: store
07:50:35.282428 ...GitCommandBase.cs:32 trace: [ExecuteAsync] Start 'store' command...
07:50:35.298090 ...GitCommandBase.cs:46 trace: [ExecuteAsync] Detecting host provider for input:
07:50:35.298090 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   protocol=https
07:50:35.298090 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   host=<fqdn>
07:50:35.298090 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   username=OAUTH_USERNAME
07:50:35.298090 ...GitCommandBase.cs:47 trace: [ExecuteAsync]   password=********
07:50:35.298090 ...oviderRegistry.cs:99 trace: [GetProviderAsync] Host provider override was set id='bitbucket'
07:50:35.309602 ...GitCommandBase.cs:49 trace: [ExecuteAsync] Host provider 'Bitbucket' was selected.
07:50:35.309602 ...tHostProvider.cs:335 trace: [StoreCredentialAsync] Storing credential...
07:50:35.363321 ...tHostProvider.cs:337 trace: [StoreCredentialAsync] Credential was successfully stored.
07:50:35.372831 ...GitCommandBase.cs:53 trace: [ExecuteAsync] End 'store' command...
07:50:35.380670 run-command.c:657       trace: run_command: 'git credential-wincred store'
07:50:35.436909 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:35.436909 git.c:750               trace: exec: git-credential-wincred store
07:50:35.436909 run-command.c:657       trace: run_command: git-credential-wincred store
07:50:35.580177 run-command.c:657       trace: run_command: 'git credential-oauth store'
07:50:35.660415 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:35.663529 git.c:750               trace: exec: git-credential-oauth store
07:50:35.663529 run-command.c:657       trace: run_command: git-credential-oauth store
07:50:36.130305 run-command.c:657       trace: run_command: 'C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store'
C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store: -c: line 1: syntax error near unexpected token `('
C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store: -c: line 1: `C:/Program Files (x86)/Git Credential Manager/git-credential-manager.exe store'
07:50:36.207024 http.c:868              == Info: Uses proxy env variable no_proxy == '<no_proxy>'
07:50:36.207024 http.c:868              == Info: Found bundle for host: 0x2202f571e40 [serially]
07:50:36.207024 http.c:868              == Info: Re-using existing connection with host <fqdn>
07:50:36.207024 http.c:868              == Info: Server auth using Basic with user 'OAUTH_USERNAME'
07:50:36.207024 http.c:815              => Send header, 0000000539 bytes (0x0000021b)
07:50:36.207024 http.c:827              => Send header: POST /scm/soc/socialcoding-python-package.git/git-upload-pack HTTP/1.1
07:50:36.207024 http.c:827              => Send header: Host: <fqdn>
07:50:36.208635 http.c:827              => Send header: Authorization: Basic <redacted>
07:50:36.208635 http.c:827              => Send header: User-Agent: git/2.45.2.windows.1
07:50:36.208635 http.c:827              => Send header: Accept-Encoding: deflate, gzip, br, zstd
07:50:36.208635 http.c:827              => Send header: Content-Type: application/x-git-upload-pack-request
07:50:36.208635 http.c:827              => Send header: Accept: application/x-git-upload-pack-result
07:50:36.208635 http.c:827              => Send header: Git-Protocol: version=2
07:50:36.208635 http.c:827              => Send header: Content-Length: 263
07:50:36.208635 http.c:827              => Send header:
07:50:36.208635 http.c:868              == Info: upload completely sent off: 263 bytes
07:50:36.352823 http.c:868              == Info: schannel: failed to decrypt data, need more data
07:50:36.361370 http.c:868              == Info: schannel: failed to decrypt data, need more data
07:50:36.361370 http.c:815              <= Recv header, 0000000015 bytes (0x0000000f)
07:50:36.361370 http.c:827              <= Recv header: HTTP/1.1 200
07:50:36.361370 http.c:815              <= Recv header, 0000000039 bytes (0x00000027)
07:50:36.361993 http.c:827              <= Recv header: X-AREQUESTID: *1AX4HUAx470x36989816x9
07:50:36.361993 http.c:815              <= Recv header, 0000000024 bytes (0x00000018)
07:50:36.361993 http.c:827              <= Recv header: Cache-Control: private
07:50:36.361993 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:36.361993 http.c:827              <= Recv header: X-AUSERID: 11095
07:50:36.361993 http.c:815              <= Recv header, 0000000021 bytes (0x00000015)
07:50:36.361993 http.c:827              <= Recv header: X-AUSERNAME: RHP9FE
07:50:36.361993 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:36.361993 http.c:827              <= Recv header: x-xss-protection: 1; mode=block
07:50:36.361993 http.c:815              <= Recv header, 0000000029 bytes (0x0000001d)
07:50:36.361993 http.c:827              <= Recv header: x-frame-options: SAMEORIGIN
07:50:36.361993 http.c:815              <= Recv header, 0000000033 bytes (0x00000021)
07:50:36.361993 http.c:827              <= Recv header: x-content-type-options: nosniff
07:50:36.361993 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:36.361993 http.c:827              <= Recv header: x-bb-async: true
07:50:36.361993 http.c:815              <= Recv header, 0000000040 bytes (0x00000028)
07:50:36.361993 http.c:827              <= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT
07:50:36.361993 http.c:815              <= Recv header, 0000000018 bytes (0x00000012)
07:50:36.363523 http.c:827              <= Recv header: Pragma: no-cache
07:50:36.363523 http.c:815              <= Recv header, 0000000053 bytes (0x00000035)
07:50:36.363523 http.c:827              <= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate
07:50:36.363523 http.c:815              <= Recv header, 0000000052 bytes (0x00000034)
07:50:36.363523 http.c:827              <= Recv header: Content-Type: application/x-git-upload-pack-result
07:50:36.363523 http.c:815              <= Recv header, 0000000028 bytes (0x0000001c)
07:50:36.363523 http.c:827              <= Recv header: Transfer-Encoding: chunked
07:50:36.363523 http.c:815              <= Recv header, 0000000037 bytes (0x00000025)
07:50:36.363523 http.c:827              <= Recv header: Date: Tue, 04 Feb 2025 06:50:35 GMT
07:50:36.363523 http.c:815              <= Recv header, 0000000002 bytes (0x00000002)
07:50:36.363523 http.c:827              <= Recv header:
07:50:36.363523 http.c:868              == Info: Connection #0 to host <fqdn> left intact
07:50:36.364957 run-command.c:657       trace: run_command: git rev-list --objects --stdin --not --exclude-hidden=fetch --all --quiet --alternate-refs
07:50:36.430098 run-command.c:1521      run_processes_parallel: preparing to run up to 1 tasks
07:50:36.430098 run-command.c:1549      run_processes_parallel: done
07:50:36.430098 run-command.c:657       trace: run_command: git maintenance run --auto --no-quiet
07:50:36.446706 exec-cmd.c:243          trace: resolved executable dir: C:/Program Files/Git/mingw64/libexec/git-core
07:50:36.449214 git.c:465               trace: built-in: git maintenance run --auto --no-quiet

@Csnyder9372
Copy link

Csnyder9372 commented Feb 4, 2025 via email

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

OAuth2 authentication fails once after access_token expired.
3 participants