Print

Print


It seems someone has enabled debug for FTS transfers. Thank you!

The gfal checksum operation seems to
1. find a bearer token (`Found token in credential_map`)
2. find a cached ne_session (`cached ne_session found ! taken from cache `)
3. send checksum request (`Sending request-line and headers:`) via Davix
4. timeout after 950s [start 14:22:32, end 14:38:22] (`Aborted request (-1): Could not read status line`)

On my end, I do not see this checksum request, only the stat and rm (cleanup) after the timeout.

I looked through other issues, and I do not have `http.tlsreuse` in any of the configs.
I am running xrootd 5.5.0.

<details>
<summary>CHECKSUM:ENTER details</summary>
<pre>
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Event triggered: DESTINATION http_plugin CHECKSUM:ENTER 
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Impossible to get string_list parameter HTTP PLUGIN:HEADERS, set to a default value (null), err Key file does not have key “HEADERS” in group “HTTP PLUGIN”
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Impossible to get integer parameter HTTP PLUGIN:OPERATION_TIMEOUT, set to default value 8000, err Key file does not have key “OPERATION_TIMEOUT” in group “HTTP PLUGIN”
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Using client X509 for HTTPS session authorization
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: ssl: Match common name '1664259124' against ''
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Identity match for '': bad
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: ssl: Match common name '1664259124' against ''
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Identity match for '': bad
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; (SEToken) Found token in credential_map[davs://xrootd.phy.bris.ac.uk:1094/xrootd/cms/store/mc/Run3Summer22GS/MinBias_TuneCP5_13p6TeV-pythia8/GEN-SIM/124X_mcRun3_2022_realistic_v10-v1/40006/1d37f646-1a9d-4aa7-ad26-58c0d5b631ba.root] (access=write) (needed=read)
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Using bearer token for HTTPS request authorization
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix:  -> checksum
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Create HttpRequest for davs://xrootd.phy.bris.ac.uk:1094/xrootd/cms/store/mc/Run3Summer22GS/MinBias_TuneCP5_13p6TeV-pythia8/GEN-SIM/124X_mcRun3_2022_realistic_v10-v1/40006/1d37f646-1a9d-4aa7-ad26-58c0d5b631ba.root
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix:  -> executeRequest
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix:  -> negotiateRequest
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: NEON start internal request
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: cached ne_session found ! taken from cache 
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: configure session...
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: define connection timeout to 30
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: define operation timeout to 1800
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: add CA PATH /etc/grid-security/certificates/
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: disable login/password authentication
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: enable client cert authentication by callback 
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Running pre_send hooks
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: > HEAD /xrootd/cms/store/mc/Run3Summer22GS/MinBias_TuneCP5_13p6TeV-pythia8/GEN-SIM/124X_mcRun3_2022_realistic_v10-v1/40006/1d37f646-1a9d-4aa7-ad26-58c0d5b631ba.root HTTP/1.1
> User-Agent: fts_url_copy/3.12.1 gfal2/2.21.0 neon/0.0.29
> TE: trailers
> Host: xrootd.phy.bris.ac.uk:1094
> Want-Digest: ADLER32
> ClientInfo: job-id=9737ef08-40b9-11ed-af88-fa163e36d89b;file-id=3450963706;retry=0
> Authorization: Bearer MDAyNGxvY2F0aW9uIFVLSS1TT1VUSEdSSUQtQlJJUy1IRVAKMDAzNGlkZW50aWZpZXIgMzExOTZhYjctYjIwNC00ZDQ2LWJiZmYtZDdlYmQ4NmU5OTFhCjAwMThjaWQgbmFtZTo3ZGM0MjI2MC4wCjAwNTJjaWQgYWN0aXZpdHk6UkVBRF9NRVRBREFUQSxVUExPQUQsRE9XTkxPQUQsREVMRVRFLE1BTkFHRSxVUERBVEVfTUVUQURBVEEsTElTVAowMDM0Y2lkIGFjdGl2aXR5OkxJU1QsRE9XTkxPQUQsTUFOQUdFLFVQTE9BRCxERUxFVEUKMDBhYmNpZCBwYXRoOi94cm9vdGQvY21zL3N0b3JlL21jL1J1bjNTdW1tZXIyMkdTL01pbkJpYXNfVHVuZUNQNV8xM3A2VGVWLXB5dGhpYTgvR0VOLVNJTS8xMjRYX21jUnVuM18yMDIyX3JlYWxpc3RpY192MTAtdjEvNDAwMDYvMWQzN2Y2NDYtMWE5ZC00YWE3LWFkMjYtNThjMGQ1YjYzMWJhLnJvb3QKMDAyNGNpZCBiZWZvcmU6MjAyMi0wOS0zMFQxNToxNTo0MVoKMDAyZnNpZ25hdHVyZSCzrWofC-zAm7z_c3UBg9cYpdofgECNBIfNceJX15a2pgo
> 

DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Sending request-line and headers:
DEBUG   Fri, 30 Sep 2022 14:22:32 +0200; Davix: Request sent; retry is 1.
DEBUG   Fri, 30 Sep 2022 14:38:22 +0200; Davix: Aborted request (-1): Could not read status line
</pre>
</details>

[Full FTS debug log](https://gist.github.com/kreczko/d5840cd996522102dd0f9f30470961d0)

-- 
Reply to this email directly or view it on GitHub:
https://github.com/xrootd/xrootd/issues/1736#issuecomment-1263611292
You are receiving this because you commented.

Message ID: <[log in to unmask]>
########################################################################
Use REPLY-ALL to reply to list

To unsubscribe from the XROOTD-DEV list, click the following link:
https://listserv.slac.stanford.edu/cgi-bin/wa?SUBED1=XROOTD-DEV&A=1