Hi JT, Well, in the trace it looks like roots copy recovered and completed successfully. In each cse (roots and https) please trun on tls tracing on the server and when a failure happens please post the server loh s we can see what it really is complaining about. On Fri, 10 Mar 2023, jthiltges wrote: > Good question! I'm able to reproduce the same behavior with `xrdcp roots://$HOST//store/hello_world.txt -` > > <details> > <summary>Client logs</summary> > > ``` > [2023-03-10 15:43:36.899973 -0600][Debug ][Utility ] Initializing xrootd client version: v5.5.3 > [2023-03-10 15:43:36.900575 -0600][Debug ][Utility ] Unable to process user config file: [ERROR] OS Error: no such file or directory > [2023-03-10 15:43:36.900750 -0600][Info ][Utility ] Env: Importing from shell XRD_NETWORKSTACK=IPv4 as networkstack > [2023-03-10 15:43:36.900805 -0600][Debug ][PlugInMgr ] Initializing plug-in manager... > [2023-03-10 15:43:36.900823 -0600][Debug ][PlugInMgr ] No default plug-in, loading plug-in configs... > [2023-03-10 15:43:36.900836 -0600][Debug ][PlugInMgr ] Processing plug-in definitions in /etc/xrootd/client.plugins.d... > [2023-03-10 15:43:36.900890 -0600][Dump ][PlugInMgr ] Processing: /etc/xrootd/client.plugins.d/recorder.conf > [2023-03-10 15:43:36.900963 -0600][Dump ][PlugInMgr ] Settings from '/etc/xrootd/client.plugins.d/recorder.conf': url='*', lib='/usr/lib64/libXrdClRecorder-5.so', enable='false' > [2023-03-10 15:43:36.900979 -0600][Debug ][PlugInMgr ] Trying to disable plug-in for '*' > [2023-03-10 15:43:36.901262 -0600][Debug ][PlugInMgr ] Processing plug-in definitions in /home/swanson/jthiltge/.xrootd/client.plugins.d... > [2023-03-10 15:43:36.901291 -0600][Debug ][PlugInMgr ] Unable to process directory /home/swanson/jthiltge/.xrootd/client.plugins.d: [ERROR] OS Error: no such file or directory > [2023-03-10 15:43:36.904563 -0600][Dump ][App ] Chunk size: 8388608, parallel chunks 4, streams: 1 > [2023-03-10 15:43:36.904587 -0600][Dump ][App ] Processing source entry: roots://xrootd-local.unl.edu//store/hello_world.txt, type other, target file: - > [2023-03-10 15:43:36.904744 -0600][Dump ][Utility ] Adding job with properties: 'checkSumMode' = 'none', 'checkSumPreset' = '', 'checkSumType' = '', 'chunkSize' = '8388608', 'coerce' = '0', 'continue' = '0', 'cpTimeout' = '0', 'delegate' = '0', 'doServer' = '0', 'dynamicSource' = '0', 'force' = '0', 'initTimeout' = '600', 'makeDir' = '0', 'parallelChunks' = '4', 'posc' = '0', 'preserveXAttr' = '0', 'rmOnBadCksum' = '0', 'source' = 'roots://xrootd-local.unl.edu//store/hello_world.txt', 'target' = '-', 'targetIsDir' = '0', 'thirdParty' = 'none', 'tpcTimeout' = '1800', 'xcp' = '0', 'xcpBlockSize' = '134217728', 'xrate' = '0', 'xrateThreshold' = '0', 'zipAppend' = '0', 'zipArchive' = '0' > [2023-03-10 15:43:36.904780 -0600][Debug ][Utility ] CopyProcess: 2 jobs to prepare > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu//store/hello_world.txt > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.904816 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] URL: - > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] Protocol: stdio > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] Host Name: > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] Port: 0 > [2023-03-10 15:43:36.904848 -0600][Dump ][Utility ] Path: - > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu//store/hello_world.txt > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.904888 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] URL: - > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] Protocol: stdio > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] Host Name: > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] Port: 0 > [2023-03-10 15:43:36.905028 -0600][Dump ][Utility ] Path: - > [2023-03-10 15:43:36.905049 -0600][Debug ][Utility ] Creating a classic copy job, from roots://xrootd-local.unl.edu:1094//store/hello_world.txt to stdio://- > [2023-03-10 15:43:36.905081 -0600][Debug ][Utility ] Monitor library name not set. No monitoring > [2023-03-10 15:43:36.905163 -0600][Debug ][Utility ] Opening roots://xrootd-local.unl.edu:1094//store/hello_world.txt for reading > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu:1094//store/hello_world.txt > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.905455 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu:1094//store/hello_world.txt > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.905491 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu:1094//store/hello_world.txt > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.905523 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:43:36.905610 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Sending an open command > [2023-03-10 15:43:36.905658 -0600][Debug ][Utility ] Env: trying to get a non-existent string entry: pollerpreference > [2023-03-10 15:43:36.905677 -0600][Debug ][Poller ] Available pollers: built-in > [2023-03-10 15:43:36.905694 -0600][Debug ][Poller ] Attempting to create a poller according to preference: built-in > [2023-03-10 15:43:36.905706 -0600][Debug ][Poller ] Creating poller: built-in > [2023-03-10 15:43:36.905721 -0600][Debug ][Poller ] Creating and starting the built-in poller... > [2023-03-10 15:43:36.915954 -0600][Debug ][Poller ] Using 1 poller threads > [2023-03-10 15:43:36.915980 -0600][Debug ][TaskMgr ] Starting the task manager... > [2023-03-10 15:43:36.916044 -0600][Debug ][TaskMgr ] Task manager started > [2023-03-10 15:43:36.916068 -0600][Debug ][JobMgr ] Starting the job manager... > [2023-03-10 15:43:36.916220 -0600][Debug ][JobMgr ] Job manager started, 3 workers > [2023-03-10 15:43:36.916244 -0600][Debug ][TaskMgr ] Registering task: "FileTimer task" to be run at: [2023-03-10 15:43:36 -0600] > [2023-03-10 15:43:36.916257 -0600][Dump ][XRootD ] [xrootd-local.unl.edu:1094] Sending message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) > [2023-03-10 15:43:36.916293 -0600][Debug ][ExDbgMsg ] [xrootd-local.unl.edu:1094] MsgHandler created: 0x205e680 (message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ). > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] URL: xrootd-local.unl.edu:1094 > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] Protocol: root > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.916347 -0600][Dump ][Utility ] Path: > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu:1094/ > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] Password: > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:43:36.916384 -0600][Dump ][Utility ] Path: > [2023-03-10 15:43:36.916419 -0600][Debug ][PostMaster ] Creating new channel to: roots://xrootd-local.unl.edu:1094/ > [2023-03-10 15:43:36.916458 -0600][Debug ][PostMaster ] [xrootd-local.unl.edu:1094] Stream parameters: Network Stack: IPv4, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800 > [2023-03-10 15:43:36.916485 -0600][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" to be run at: [2023-03-10 15:43:51 -0600] > [2023-03-10 15:43:36.916506 -0600][Dump ][PostMaster ] [xrootd-local.unl.edu:1094] Sending message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0) through substream 0 expecting answer at 0 > [2023-03-10 15:43:36.916882 -0600][Debug ][PostMaster ] [xrootd-local.unl.edu:1094] Found 1 address(es): [::ffff:129.93.239.164]:1094 > [2023-03-10 15:43:36.916935 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Attempting connection to [::ffff:129.93.239.164]:1094 > [2023-03-10 15:43:36.916996 -0600][Debug ][Poller ] Adding socket 0x205ebb0 to the poller > [2023-03-10 15:43:36.924003 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Async connection call returned > [2023-03-10 15:43:36.924056 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending out the initial hand shake + kXR_protocol > [2023-03-10 15:43:36.924108 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb4000950), 44 bytes > [2023-03-10 15:43:36.924344 -0600][Dump ][XRootDTransport ] [msg: 0xb4000ab0] Expecting 8 bytes of message body > [2023-03-10 15:43:36.924360 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:43:36.924376 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 16 bytes > [2023-03-10 15:43:36.924393 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Got the server hand shake response (type: manager [], protocol version 511) > [2023-03-10 15:43:36.924415 -0600][Dump ][XRootDTransport ] [msg: 0xb4000ab0] Expecting 8 bytes of message body > [2023-03-10 15:43:36.924433 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:43:36.924447 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 16 bytes > [2023-03-10 15:43:36.924464 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] kXR_protocol successful (type: manager [], protocol version 511) > [2023-03-10 15:43:36.924982 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending out kXR_login request, username: jthiltge, cgi: xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp&xrd.info=&xrd.hostname=t3.unl.edu&xrd.rn=v5.5.3, dual-stack: true, private IPv4: false, private IPv6: false > [2023-03-10 15:43:36.925006 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:43:36.925982 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:43:36.926013 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:43:51 -0600] > [2023-03-10 15:43:36.930822 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:43:36.934956 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:43:36.935099 -0600][Info ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake done. > [2023-03-10 15:43:36.935160 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb4000be0), 109 bytes > [2023-03-10 15:43:36.935415 -0600][Error ][TlsMsg ] [] TLS error rc=-1 ec=5 (error_syscall) errno=104. > [2023-03-10 15:43:36.935442 -0600][Error ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Socket error while handshaking: [ERROR] TLS error > [2023-03-10 15:43:36.935455 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Closing the socket > [2023-03-10 15:43:36.935469 -0600][Debug ][Poller ] <[::ffff:129.93.239.166]:14642><--><[::ffff:129.93.239.164]:1094> Removing socket from the poller > [2023-03-10 15:43:36.935552 -0600][Error ][PostMaster ] [xrootd-local.unl.edu:1094] elapsed = 0, pConnectionWindow = 120 seconds. > [2023-03-10 15:43:36.935568 -0600][Info ][PostMaster ] [xrootd-local.unl.edu:1094] Attempting reconnection in 120 seconds. > [2023-03-10 15:43:36.935580 -0600][Debug ][TaskMgr ] Registering task: "StreamConnectorTask for xrootd-local.unl.edu:1094" to be run at: [2023-03-10 15:45:36 -0600] > [2023-03-10 15:43:51.927003 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:43:51.927057 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:44:06 -0600] > [2023-03-10 15:43:51.927069 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:43:51.927084 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:44:06 -0600] > [2023-03-10 15:44:06.928441 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:44:06.928488 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:44:21 -0600] > [2023-03-10 15:44:06.928500 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:44:06.928515 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:44:21 -0600] > [2023-03-10 15:44:21.929523 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:44:21.929574 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:44:36 -0600] > [2023-03-10 15:44:21.929588 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:44:21.929603 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:44:36 -0600] > [2023-03-10 15:44:36.930591 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:44:36.930638 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:44:51 -0600] > [2023-03-10 15:44:36.930650 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:44:36.930665 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:44:51 -0600] > [2023-03-10 15:44:51.931649 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:44:51.931704 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:45:06 -0600] > [2023-03-10 15:44:51.931718 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:44:51.931734 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:45:06 -0600] > [2023-03-10 15:45:06.932726 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:45:06.932772 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:45:21 -0600] > [2023-03-10 15:45:06.932784 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:45:06.932799 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:45:21 -0600] > [2023-03-10 15:45:21.933794 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:45:21.933845 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:45:36 -0600] > [2023-03-10 15:45:21.933857 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:45:21.933871 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:45:36 -0600] > [2023-03-10 15:45:36.934863 -0600][Dump ][TaskMgr ] Running task: "StreamConnectorTask for xrootd-local.unl.edu:1094" > [2023-03-10 15:45:36.935251 -0600][Debug ][PostMaster ] [xrootd-local.unl.edu:1094] Found 1 address(es): [::ffff:129.93.239.164]:1094 > [2023-03-10 15:45:36.935292 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Attempting connection to [::ffff:129.93.239.164]:1094 > [2023-03-10 15:45:36.935344 -0600][Debug ][Poller ] Adding socket 0x205ebb0 to the poller > [2023-03-10 15:45:36.935386 -0600][Debug ][TaskMgr ] Done with task: "StreamConnectorTask for xrootd-local.unl.edu:1094" > [2023-03-10 15:45:36.935401 -0600][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:45:36.935418 -0600][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" at [2023-03-10 15:45:51 -0600] > [2023-03-10 15:45:36.935430 -0600][Dump ][TaskMgr ] Running task: "FileTimer task" > [2023-03-10 15:45:36.935445 -0600][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2023-03-10 15:45:51 -0600] > [2023-03-10 15:45:36.935554 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Async connection call returned > [2023-03-10 15:45:36.935587 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending out the initial hand shake + kXR_protocol > [2023-03-10 15:45:36.935632 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb40430f0), 44 bytes > [2023-03-10 15:45:36.935873 -0600][Dump ][XRootDTransport ] [msg: 0xb4020400] Expecting 8 bytes of message body > [2023-03-10 15:45:36.935892 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:36.935906 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 16 bytes > [2023-03-10 15:45:36.935938 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Got the server hand shake response (type: manager [], protocol version 511) > [2023-03-10 15:45:36.935961 -0600][Dump ][XRootDTransport ] [msg: 0xb4020400] Expecting 8 bytes of message body > [2023-03-10 15:45:36.935973 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:36.935988 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 16 bytes > [2023-03-10 15:45:36.936003 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] kXR_protocol successful (type: manager [], protocol version 511) > [2023-03-10 15:45:36.936445 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending out kXR_login request, username: jthiltge, cgi: xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp&xrd.info=&xrd.hostname=t3.unl.edu&xrd.rn=v5.5.3, dual-stack: true, private IPv4: false, private IPv6: false > [2023-03-10 15:45:36.936467 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:36.938352 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:36.940851 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:36.940970 -0600][Info ][AsyncSock ] [xrootd-local.unl.edu:1094.0] TLS hand-shake done. > [2023-03-10 15:45:36.941024 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb40401d0), 109 bytes > [2023-03-10 15:45:36.941203 -0600][Dump ][XRootDTransport ] [msg: 0xb40430f0] Expecting 75 bytes of message body > [2023-03-10 15:45:36.941221 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:36.941260 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 83 bytes > [2023-03-10 15:45:36.941282 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Logged in, session: c3eb220023490000080700007e552900 > [2023-03-10 15:45:36.941293 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Authentication is required: &P=gsi,v:10600,c:ssl,ca:ba240aa8.0|f5f0dfc2.0&P=ztn,0:4096: > [2023-03-10 15:45:36.941304 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending authentication data > [2023-03-10 15:45:36.942942 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Trying to authenticate using gsi > [2023-03-10 15:45:37.755591 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb40584f0), 136 bytes > [2023-03-10 15:45:37.763666 -0600][Dump ][XRootDTransport ] [msg: 0xb40439d0] Expecting 3252 bytes of message body > [2023-03-10 15:45:37.763684 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.763752 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 3260 bytes > [2023-03-10 15:45:37.763766 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Sending more authentication data for gsi > [2023-03-10 15:45:37.795794 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: (0xb4057df0), 9932 bytes > [2023-03-10 15:45:37.846827 -0600][Dump ][XRootDTransport ] [msg: 0xb40401d0] Expecting 0 bytes of message body > [2023-03-10 15:45:37.846848 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.846859 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received a message of 8 bytes > [2023-03-10 15:45:37.846925 -0600][Debug ][XRootDTransport ] [xrootd-local.unl.edu:1094.0] Authenticated with gsi. > [2023-03-10 15:45:37.846951 -0600][Debug ][PostMaster ] [xrootd-local.unl.edu:1094] Stream 0 connected (IPv4). > [2023-03-10 15:45:37.846992 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Wrote a message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0), 46 bytes > [2023-03-10 15:45:37.847031 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Successfully sent message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0). > [2023-03-10 15:45:37.847049 -0600][Dump ][XRootD ] [xrootd-local.unl.edu:1094] Message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) has been successfully sent. > [2023-03-10 15:45:37.847060 -0600][Debug ][ExDbgMsg ] [xrootd-local.unl.edu:1094] Moving MsgHandler: 0x205e680 (message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue. > [2023-03-10 15:45:37.847074 -0600][Dump ][PostMaster ] [xrootd-local.unl.edu:1094.0] All messages consumed, disable uplink > [2023-03-10 15:45:37.847561 -0600][Dump ][XRootDTransport ] [msg: 0xb4043630] Expecting 21 bytes of message body > [2023-03-10 15:45:37.847579 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message header for 0xb4043630 size: 8 > [2023-03-10 15:45:37.847592 -0600][Debug ][ExDbgMsg ] [msg: 0xb4043630] Assigned MsgHandler: 0x205e680. > [2023-03-10 15:45:37.847603 -0600][Debug ][ExDbgMsg ] [handler: 0x205e680] Removed MsgHandler: 0x205e680 from the in-queue. > [2023-03-10 15:45:37.847644 -0600][Dump ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Received message 0xb4043630 of 29 bytes > [2023-03-10 15:45:37.847663 -0600][Dump ][PostMaster ] [xrootd-local.unl.edu:1094] Handling received message: 0xb4043630. > [2023-03-10 15:45:37.847738 -0600][Dump ][XRootD ] [xrootd-local.unl.edu:1094] Got kXR_redirect response to message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): red-xfer8.unl.edu, port 1094 > [2023-03-10 15:45:37.847766 -0600][Dump ][XRootD ] [xrootd-local.unl.edu:1094] Current server has been assigned as a load-balancer for message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] URL: red-xfer8.unl.edu:1094/ > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] Protocol: root > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] Host Name: red-xfer8.unl.edu > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.847798 -0600][Dump ][Utility ] Path: > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] URL: fake://fake:111//fake?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316& > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] Protocol: fake > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] Host Name: fake > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] Port: 111 > [2023-03-10 15:45:37.847840 -0600][Dump ][Utility ] Path: /fake > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] URL: fake://fake:111//store/hello_world.txt > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] Protocol: fake > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] Host Name: fake > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] Port: 111 > [2023-03-10 15:45:37.847893 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] URL: roots://xrootd-local.unl.edu:1094//store/hello_world.txt > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] Host Name: xrootd-local.unl.edu > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.847960 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] URL: roots://red-xfer8.unl.edu:1094/ > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] Host Name: red-xfer8.unl.edu > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.847998 -0600][Dump ][Utility ] Path: > [2023-03-10 15:45:37.848039 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Retry at server MsgHandler: 0x205e680 (message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ). > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] URL: red-xfer8.unl.edu:1094 > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] Protocol: root > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] Host Name: red-xfer8.unl.edu > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.848067 -0600][Dump ][Utility ] Path: > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] URL: roots://red-xfer8.unl.edu:1094/ > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] Host Name: red-xfer8.unl.edu > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.848100 -0600][Dump ][Utility ] Path: > [2023-03-10 15:45:37.848124 -0600][Debug ][PostMaster ] Creating new channel to: roots://red-xfer8.unl.edu:1094/ > [2023-03-10 15:45:37.848158 -0600][Debug ][PostMaster ] [red-xfer8.unl.edu:1094] Stream parameters: Network Stack: IPv4, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800 > [2023-03-10 15:45:37.848178 -0600][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: roots://red-xfer8.unl.edu:1094/" to be run at: [2023-03-10 15:45:52 -0600] > [2023-03-10 15:45:37.848194 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Sending message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0) through substream 0 expecting answer at 0 > [2023-03-10 15:45:37.848531 -0600][Debug ][PostMaster ] [red-xfer8.unl.edu:1094] Found 1 address(es): [::ffff:129.93.239.138]:1094 > [2023-03-10 15:45:37.848570 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Attempting connection to [::ffff:129.93.239.138]:1094 > [2023-03-10 15:45:37.848618 -0600][Debug ][Poller ] Adding socket 0xb0001e00 to the poller > [2023-03-10 15:45:37.848719 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Async connection call returned > [2023-03-10 15:45:37.848746 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Sending out the initial hand shake + kXR_protocol > [2023-03-10 15:45:37.848778 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: (0xb4000be0), 44 bytes > [2023-03-10 15:45:37.848866 -0600][Dump ][XRootDTransport ] [msg: 0xb4039090] Expecting 8 bytes of message body > [2023-03-10 15:45:37.848888 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.848902 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received a message of 16 bytes > [2023-03-10 15:45:37.848922 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Got the server hand shake response (type: server [], protocol version 511) > [2023-03-10 15:45:37.848942 -0600][Dump ][XRootDTransport ] [msg: 0xb4039090] Expecting 14 bytes of message body > [2023-03-10 15:45:37.848953 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.848966 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received a message of 22 bytes > [2023-03-10 15:45:37.848982 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] kXR_protocol successful (type: server [], protocol version 511) > [2023-03-10 15:45:37.849429 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Sending out kXR_login request, username: jthiltge, cgi: xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp&xrd.info=&xrd.hostname=t3.unl.edu&xrd.rn=v5.5.3, dual-stack: true, private IPv4: false, private IPv6: false > [2023-03-10 15:45:37.849450 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:37.851225 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:37.853330 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] TLS hand-shake exchange. > [2023-03-10 15:45:37.853440 -0600][Info ][AsyncSock ] [red-xfer8.unl.edu:1094.0] TLS hand-shake done. > [2023-03-10 15:45:37.853493 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: (0xb40430f0), 109 bytes > [2023-03-10 15:45:37.853639 -0600][Dump ][XRootDTransport ] [msg: 0xb4000be0] Expecting 75 bytes of message body > [2023-03-10 15:45:37.853653 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.853692 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received a message of 83 bytes > [2023-03-10 15:45:37.853712 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Logged in, session: 30335e00410500008700000091e15f00 > [2023-03-10 15:45:37.853722 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Authentication is required: &P=gsi,v:10600,c:ssl,ca:ba240aa8.0|f5f0dfc2.0&P=ztn,0:4096: > [2023-03-10 15:45:37.853733 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Sending authentication data > [2023-03-10 15:45:37.853762 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Trying to authenticate using gsi > [2023-03-10 15:45:37.879376 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: (0xb4069560), 136 bytes > [2023-03-10 15:45:37.891120 -0600][Dump ][XRootDTransport ] [msg: 0xb40430f0] Expecting 3272 bytes of message body > [2023-03-10 15:45:37.891139 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.891218 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received a message of 3280 bytes > [2023-03-10 15:45:37.891234 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Sending more authentication data for gsi > [2023-03-10 15:45:37.923098 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: (0xb4068310), 9932 bytes > [2023-03-10 15:45:37.937567 -0600][Dump ][XRootDTransport ] [msg: 0xb40698b0] Expecting 0 bytes of message body > [2023-03-10 15:45:37.937586 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header, size: 8 > [2023-03-10 15:45:37.937597 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received a message of 8 bytes > [2023-03-10 15:45:37.937981 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] XrdSecProtect loaded. > [2023-03-10 15:45:37.938002 -0600][Debug ][XRootDTransport ] [red-xfer8.unl.edu:1094.0] Authenticated with gsi. > [2023-03-10 15:45:37.938029 -0600][Debug ][PostMaster ] [red-xfer8.unl.edu:1094] Stream 0 connected (IPv4). > [2023-03-10 15:45:37.938069 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0), 46 bytes > [2023-03-10 15:45:37.938100 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Successfully sent message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) (0x2058bb0). > [2023-03-10 15:45:37.938115 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Message kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) has been successfully sent. > [2023-03-10 15:45:37.938127 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Moving MsgHandler: 0x205e680 (message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue. > [2023-03-10 15:45:37.938139 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094.0] All messages consumed, disable uplink > [2023-03-10 15:45:37.938407 -0600][Dump ][XRootDTransport ] [msg: 0xb40788c0] Expecting 87 bytes of message body > [2023-03-10 15:45:37.938424 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header for 0xb40788c0 size: 8 > [2023-03-10 15:45:37.938436 -0600][Debug ][ExDbgMsg ] [msg: 0xb40788c0] Assigned MsgHandler: 0x205e680. > [2023-03-10 15:45:37.938447 -0600][Debug ][ExDbgMsg ] [handler: 0x205e680] Removed MsgHandler: 0x205e680 from the in-queue. > [2023-03-10 15:45:37.938490 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message 0xb40788c0 of 95 bytes > [2023-03-10 15:45:37.938506 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Handling received message: 0xb40788c0. > [2023-03-10 15:45:37.938581 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Got a kXR_ok response to request kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) > [2023-03-10 15:45:37.938613 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Calling MsgHandler: 0x205e680 (message: kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) with status: [SUCCESS] . > [2023-03-10 15:45:37.938626 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Parsing the response to kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) as OpenInfo > [2023-03-10 15:45:37.938637 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Parsing StatInfo in response to kXR_open (file: /store/hello_world.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) > [2023-03-10 15:45:37.938688 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Open has returned with status [SUCCESS] > [2023-03-10 15:45:37.938708 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] successfully opened at red-xfer8.unl.edu:1094, handle: 0x0, session id: 1 > [2023-03-10 15:45:37.938750 -0600][Debug ][XRootD ] Redirect trace-back: > [2023-03-10 15:45:37.938750 -0600][Debug ][XRootD ] 0. Redirected from: roots://xrootd-local.unl.edu:1094//store/hello_world.txt to: roots://red-xfer8.unl.edu:1094/ > [2023-03-10 15:45:37.938765 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Destroying MsgHandler: 0x205e680. > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] URL: roots://red-xfer8.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316 > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] Protocol: roots > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] User Name: > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] Password: > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] Host Name: red-xfer8.unl.edu > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] Port: 1094 > [2023-03-10 15:45:37.938791 -0600][Dump ][Utility ] Path: /store/hello_world.txt > [2023-03-10 15:45:37.938838 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Sending a read command for handle 0x0 to red-xfer8.unl.edu:1094 > [2023-03-10 15:45:37.938873 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Sending message kXR_read (handle: 0x00000000, offset: 0, size: 13) > [2023-03-10 15:45:37.938892 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] MsgHandler created: 0x205e680 (message: kXR_read (handle: 0x00000000, offset: 0, size: 13) ). > [2023-03-10 15:45:37.938910 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Sending message kXR_read (handle: 0x00000000, offset: 0, size: 13) (0x205afc0) through substream 0 expecting answer at 0 > [2023-03-10 15:45:37.938962 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: kXR_read (handle: 0x00000000, offset: 0, size: 13) (0x205afc0), 32 bytes > [2023-03-10 15:45:37.938994 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Successfully sent message: kXR_read (handle: 0x00000000, offset: 0, size: 13) (0x205afc0). > [2023-03-10 15:45:37.939007 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Message kXR_read (handle: 0x00000000, offset: 0, size: 13) has been successfully sent. > [2023-03-10 15:45:37.939018 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Moving MsgHandler: 0x205e680 (message: kXR_read (handle: 0x00000000, offset: 0, size: 13) ) from out-queu to in-queue. > [2023-03-10 15:45:37.939029 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094.0] All messages consumed, disable uplink > [2023-03-10 15:45:37.939104 -0600][Dump ][XRootDTransport ] [msg: 0xb4068400] Expecting 13 bytes of message body > [2023-03-10 15:45:37.939119 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header for 0xb4068400 size: 8 > [2023-03-10 15:45:37.939129 -0600][Debug ][ExDbgMsg ] [msg: 0xb4068400] Assigned MsgHandler: 0x205e680. > [2023-03-10 15:45:37.939139 -0600][Debug ][ExDbgMsg ] [handler: 0x205e680] Removed MsgHandler: 0x205e680 from the in-queue. > [2023-03-10 15:45:37.939149 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Will use the raw handler to read body of message 0xb4068400 > [2023-03-10 15:45:37.939181 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message 0xb4068400 of 21 bytes > [2023-03-10 15:45:37.939196 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Handling received message: 0xb4068400. > [2023-03-10 15:45:37.939256 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Got a kXR_ok response to request kXR_read (handle: 0x00000000, offset: 0, size: 13) > [2023-03-10 15:45:37.939281 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Calling MsgHandler: 0x205e680 (message: kXR_read (handle: 0x00000000, offset: 0, size: 13) ) with status: [SUCCESS] . > [2023-03-10 15:45:37.939296 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Parsing the response to kXR_read (handle: 0x00000000, offset: 0, size: 13) as ChunkInfo > [2023-03-10 15:45:37.939311 -0600][Dump ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Got state response for message kXR_read (handle: 0x00000000, offset: 0, size: 13) > [2023-03-10 15:45:37.939337 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Destroying MsgHandler: 0x205e680. > hello world! > [2023-03-10 15:45:37.939371 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Sending a close command for handle 0x0 to red-xfer8.unl.edu:1094 > [2023-03-10 15:45:37.939404 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Sending message kXR_close (handle: 0x00000000) > [2023-03-10 15:45:37.939421 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] MsgHandler created: 0x205e680 (message: kXR_close (handle: 0x00000000) ). > [2023-03-10 15:45:37.939439 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Sending message kXR_close (handle: 0x00000000) (0x2058a70) through substream 0 expecting answer at 0 > [2023-03-10 15:45:37.939479 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Wrote a message: kXR_close (handle: 0x00000000) (0x2058a70), 24 bytes > [2023-03-10 15:45:37.939509 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Successfully sent message: kXR_close (handle: 0x00000000) (0x2058a70). > [2023-03-10 15:45:37.939523 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Message kXR_close (handle: 0x00000000) has been successfully sent. > [2023-03-10 15:45:37.939533 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Moving MsgHandler: 0x205e680 (message: kXR_close (handle: 0x00000000) ) from out-queu to in-queue. > [2023-03-10 15:45:37.939544 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094.0] All messages consumed, disable uplink > [2023-03-10 15:45:37.939700 -0600][Dump ][XRootDTransport ] [msg: 0xb4063300] Expecting 0 bytes of message body > [2023-03-10 15:45:37.939716 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message header for 0xb4063300 size: 8 > [2023-03-10 15:45:37.939726 -0600][Debug ][ExDbgMsg ] [msg: 0xb4063300] Assigned MsgHandler: 0x205e680. > [2023-03-10 15:45:37.939736 -0600][Debug ][ExDbgMsg ] [handler: 0x205e680] Removed MsgHandler: 0x205e680 from the in-queue. > [2023-03-10 15:45:37.939747 -0600][Dump ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Received message 0xb4063300 of 8 bytes > [2023-03-10 15:45:37.939758 -0600][Dump ][PostMaster ] [red-xfer8.unl.edu:1094] Handling received message: 0xb4063300. > [2023-03-10 15:45:37.939791 -0600][Dump ][XRootD ] [red-xfer8.unl.edu:1094] Got a kXR_ok response to request kXR_close (handle: 0x00000000) > [2023-03-10 15:45:37.939808 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Calling MsgHandler: 0x205e680 (message: kXR_close (handle: 0x00000000) ) with status: [SUCCESS] . > [2023-03-10 15:45:37.939824 -0600][Debug ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Close returned from red-xfer8.unl.edu:1094 with: [SUCCESS] > [2023-03-10 15:45:37.939835 -0600][Dump ][File ] ***@***.***://xrootd-local.unl.edu:1094//store/hello_world.txt?xrdcl.requuid=1e31cbb6-5cab-4b1d-aa29-5810685d9316] Items in the fly 0, queued for recovery 0 > [2023-03-10 15:45:37.939855 -0600][Debug ][ExDbgMsg ] [red-xfer8.unl.edu:1094] Destroying MsgHandler: 0x205e680. > [2023-03-10 15:45:37.940452 -0600][Debug ][JobMgr ] Stopping the job manager... > [2023-03-10 15:45:37.940475 -0600][Dump ][JobMgr ] Stopping worker #0... > [2023-03-10 15:45:37.940602 -0600][Dump ][JobMgr ] Worker #0 stopped > [2023-03-10 15:45:37.940620 -0600][Dump ][JobMgr ] Stopping worker #1... > [2023-03-10 15:45:37.940679 -0600][Dump ][JobMgr ] Worker #1 stopped > [2023-03-10 15:45:37.940695 -0600][Dump ][JobMgr ] Stopping worker #2... > [2023-03-10 15:45:37.940752 -0600][Dump ][JobMgr ] Worker #2 stopped > [2023-03-10 15:45:37.940768 -0600][Debug ][JobMgr ] Job manager stopped > [2023-03-10 15:45:37.940779 -0600][Debug ][TaskMgr ] Stopping the task manager... > [2023-03-10 15:45:37.940882 -0600][Debug ][TaskMgr ] Task manager stopped > [2023-03-10 15:45:37.940900 -0600][Debug ][Poller ] Stopping the poller... > [2023-03-10 15:45:37.941133 -0600][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: roots://red-xfer8.unl.edu:1094/" > [2023-03-10 15:45:37.941159 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Closing the socket > [2023-03-10 15:45:37.941205 -0600][Debug ][Poller ] <[::ffff:129.93.239.166]:13868><--><[::ffff:129.93.239.138]:1094> Removing socket from the poller > [2023-03-10 15:45:37.941281 -0600][Debug ][PostMaster ] [red-xfer8.unl.edu:1094] Destroying stream > [2023-03-10 15:45:37.941300 -0600][Debug ][AsyncSock ] [red-xfer8.unl.edu:1094.0] Closing the socket > [2023-03-10 15:45:37.941319 -0600][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: roots://xrootd-local.unl.edu:1094/" > [2023-03-10 15:45:37.941331 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Closing the socket > [2023-03-10 15:45:37.941341 -0600][Debug ][Poller ] <[::ffff:129.93.239.166]:33348><--><[::ffff:129.93.239.164]:1094> Removing socket from the poller > [2023-03-10 15:45:37.941457 -0600][Debug ][PostMaster ] [xrootd-local.unl.edu:1094] Destroying stream > [2023-03-10 15:45:37.941474 -0600][Debug ][AsyncSock ] [xrootd-local.unl.edu:1094.0] Closing the socket > ``` > </details> > > -- > Reply to this email directly or view it on GitHub: > https://github.com/xrootd/xrootd/issues/1952#issuecomment-1464519072 > You are receiving this because you are subscribed to this thread. > > Message ID: ***@***.***> -- Reply to this email directly or view it on GitHub: https://github.com/xrootd/xrootd/issues/1952#issuecomment-1464545830 You are receiving this because you are subscribed to this thread. 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