[kmohrman@earth: ~]$ xrdcp -d 2 -f root://ndcms.crc.nd.edu//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root /dev/null [2022-02-09 08:04:47.305130 -0500][Debug ][Utility ] CopyProcess: 2 jobs to prepare [2022-02-09 08:04:47.305418 -0500][Debug ][Utility ] Creating a classic copy job, from root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root to file://localhost/dev/null [2022-02-09 08:04:47.305452 -0500][Debug ][Utility ] Monitor library name not set. No monitoring [2022-02-09 08:04:47.305824 -0500][Debug ][Poller ] Available pollers: built-in [2022-02-09 08:04:47.305882 -0500][Debug ][Poller ] Attempting to create a poller according to preference: built-in [2022-02-09 08:04:47.305937 -0500][Debug ][Poller ] Creating poller: built-in [2022-02-09 08:04:47.305968 -0500][Debug ][Poller ] Creating and starting the built-in poller... [2022-02-09 08:04:47.306307 -0500][Debug ][Poller ] Using 1 poller threads [2022-02-09 08:04:47.306337 -0500][Debug ][TaskMgr ] Starting the task manager... [2022-02-09 08:04:47.306433 -0500][Debug ][TaskMgr ] Task manager started [2022-02-09 08:04:47.306468 -0500][Debug ][JobMgr ] Starting the job manager... [2022-02-09 08:04:47.306640 -0500][Debug ][JobMgr ] Job manager started, 3 workers [2022-02-09 08:04:47.306671 -0500][Debug ][TaskMgr ] Registering task: "FileTimer task" to be run at: [2022-02-09 08:04:47 -0500] [2022-02-09 08:04:47.306713 -0500][Debug ][Utility ] Opening root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root for reading [2022-02-09 08:04:47.306929 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending an open command [2022-02-09 08:04:47.307040 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0xf07a40 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ). [2022-02-09 08:04:47.307133 -0500][Debug ][PostMaster ] Creating new channel to: ndcms.crc.nd.edu:1094 1 stream(s) [2022-02-09 08:04:47.307183 -0500][Debug ][PostMaster ] [ndcms.crc.nd.edu:1094 #0] Stream parameters: Network Stack: IPAuto, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800 [2022-02-09 08:04:47.307754 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: ndcms.crc.nd.edu:1094" to be run at: [2022-02-09 08:05:02 -0500] [2022-02-09 08:04:47.308266 -0500][Debug ][PostMaster ] [ndcms.crc.nd.edu:1094] Found 1 address(es): [::ffff:129.74.85.4]:1094 [2022-02-09 08:04:47.308320 -0500][Debug ][AsyncSock ] [ndcms.crc.nd.edu:1094 #0.0] Attempting connection to [::ffff:129.74.85.4]:1094 [2022-02-09 08:04:47.308378 -0500][Debug ][Poller ] Adding socket 0xf08830 to the poller [2022-02-09 08:04:47.308584 -0500][Debug ][AsyncSock ] [ndcms.crc.nd.edu:1094 #0.0] Async connection call returned [2022-02-09 08:04:47.308644 -0500][Debug ][XRootDTransport ] [ndcms.crc.nd.edu:1094 #0.0] Sending out the initial hand shake + kXR_protocol [2022-02-09 08:04:47.309191 -0500][Debug ][XRootDTransport ] [ndcms.crc.nd.edu:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 500) [2022-02-09 08:04:47.309257 -0500][Debug ][XRootDTransport ] [ndcms.crc.nd.edu:1094 #0.0] kXR_protocol successful (type: manager [], protocol version 500) [2022-02-09 08:04:47.310356 -0500][Debug ][XRootDTransport ] [ndcms.crc.nd.edu:1094 #0.0] Sending out kXR_login request, username: kmohrman, cgi: ?xrd.cc=us&xrd.tz=-5&xrd.appname=xrdcp&xrd.info=&xrd.hostname=earth.crc.nd.edu&xrd.rn=v4.12.6, dual-stack: false, private IPv4: true, private IPv6: false [2022-02-09 08:04:47.310526 -0500][Debug ][XRootDTransport ] [ndcms.crc.nd.edu:1094 #0.0] Logged in, session: d8a21f000c09000018000000d9a21f00 [2022-02-09 08:04:47.310562 -0500][Debug ][PostMaster ] [ndcms.crc.nd.edu:1094 #0] Stream 0 connected. [2022-02-09 08:04:47.310630 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0xf07a40 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue. [2022-02-09 08:04:47.311162 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0xf07a40 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ). [2022-02-09 08:04:47.311274 -0500][Debug ][PostMaster ] Creating new channel to: primeradiant06.crc.nd.edu:1094 1 stream(s) [2022-02-09 08:04:47.311317 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Stream parameters: Network Stack: IPAuto, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800 [2022-02-09 08:04:47.312103 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: primeradiant06.crc.nd.edu:1094" to be run at: [2022-02-09 08:05:02 -0500] [2022-02-09 08:04:47.312535 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094] Found 1 address(es): [::ffff:149.165.243.14]:1094 [2022-02-09 08:04:47.312581 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Attempting connection to [::ffff:149.165.243.14]:1094 [2022-02-09 08:04:47.312630 -0500][Debug ][Poller ] Adding socket 0x90001b30 to the poller [2022-02-09 08:04:47.312791 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Async connection call returned [2022-02-09 08:04:47.312829 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out the initial hand shake + kXR_protocol [2022-02-09 08:04:47.337743 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got the server hand shake response (type: server [], protocol version 500) [2022-02-09 08:04:47.337794 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] kXR_protocol successful (type: server [proxy], protocol version 500) [2022-02-09 08:04:47.338835 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_login request, username: kmohrman, cgi: ?xrd.cc=us&xrd.tz=-5&xrd.appname=xrdcp&xrd.info=&xrd.hostname=earth.crc.nd.edu&xrd.rn=v4.12.6, dual-stack: false, private IPv4: true, private IPv6: false [2022-02-09 08:04:47.339067 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Logged in, session: 04000000e61200001d00000005000000 [2022-02-09 08:04:47.339103 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Stream 0 connected. [2022-02-09 08:04:47.339184 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf07a40 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue. [2022-02-09 08:04:47.339470 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf07a40 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) with status: [SUCCESS] . [2022-02-09 08:04:47.339570 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Open has returned with status [SUCCESS] [2022-02-09 08:04:47.339599 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] successfully opened at primeradiant06.crc.nd.edu:1094, handle: 0x0, session id: 1 [2022-02-09 08:04:47.339689 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:04:47.339689 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:04:47.339742 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf07a40. [2022-02-09 08:04:47.339776 -0500][Debug ][Utility ] Opening file://localhost/dev/null?oss.asize=35415439 for writing [2022-02-09 08:04:47.339923 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending an open command [2022-02-09 08:04:47.340163 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Open has returned with status [SUCCESS] [2022-02-09 08:04:47.340194 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] successfully opened at localhost, handle: 0xb, session id: 1 [2022-02-09 08:04:47.340288 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a read command for handle 0x0 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:04:47.340362 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf093c0 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ). [2022-02-09 08:04:47.340423 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a read command for handle 0x0 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:04:47.340474 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf09ea0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ). [2022-02-09 08:04:47.340523 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a read command for handle 0x0 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:04:47.340549 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf093c0 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:04:47.340568 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf0a650 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ). [2022-02-09 08:04:47.340631 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf09ea0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:04:47.340660 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a read command for handle 0x0 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:04:47.340676 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf0a650 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:04:47.340737 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf0aa00 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ). [2022-02-09 08:04:47.340836 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf0aa00 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:05:47.432497 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:05:47.432583 -0500][Debug ][Poller ] <[::ffff:10.32.77.18]:61492><--><[::ffff:149.165.243.14]:1094> Removing socket from the poller [2022-02-09 08:05:47.432682 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Recovering error for stream #0: [ERROR] Socket error. [2022-02-09 08:05:47.432713 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Reporting disconnection to queued message handlers. [2022-02-09 08:05:47.432772 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 0, size: 8388608): [ERROR] Socket error. [2022-02-09 08:05:47.432821 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 0, size: 8388608) [2022-02-09 08:05:47.432848 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0xf093c0 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ). [2022-02-09 08:05:47.432882 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608): [ERROR] Socket error. [2022-02-09 08:05:47.432902 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) [2022-02-09 08:05:47.432922 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0xf09ea0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ). [2022-02-09 08:05:47.432982 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608): [ERROR] Socket error. [2022-02-09 08:05:47.433032 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) [2022-02-09 08:05:47.433034 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf093c0 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:05:47.433034 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf09ea0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:05:47.433103 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0xf0a650 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ). [2022-02-09 08:05:47.433185 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf093c0. [2022-02-09 08:05:47.433274 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf0a650 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:05:47.433316 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf0a650. [2022-02-09 08:05:47.433198 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf09ea0. [2022-02-09 08:05:47.433262 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608): [ERROR] Socket error. [2022-02-09 08:05:47.433462 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) [2022-02-09 08:05:47.433489 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0xf0aa00 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ). [2022-02-09 08:05:47.433533 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf0aa00 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:05:47.433571 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Running the recovery procedure [2022-02-09 08:05:47.433642 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:05:47.433700 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf0aa00. [2022-02-09 08:05:47.433726 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:05:47.434260 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:05:47.434851 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094] Found 1 address(es): [::ffff:149.165.243.14]:1094 [2022-02-09 08:05:47.434904 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Attempting connection to [::ffff:149.165.243.14]:1094 [2022-02-09 08:05:47.434952 -0500][Debug ][Poller ] Adding socket 0x90001b30 to the poller [2022-02-09 08:05:47.435106 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Async connection call returned [2022-02-09 08:05:47.435141 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out the initial hand shake + kXR_protocol [2022-02-09 08:05:47.435332 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got the server hand shake response (type: server [], protocol version 500) [2022-02-09 08:05:47.435367 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] kXR_protocol successful (type: server [proxy], protocol version 500) [2022-02-09 08:05:47.436823 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_login request, username: kmohrman, cgi: ?xrd.cc=us&xrd.tz=-5&xrd.appname=xrdcp&xrd.info=&xrd.hostname=earth.crc.nd.edu&xrd.rn=v4.12.6, dual-stack: false, private IPv4: true, private IPv6: false [2022-02-09 08:05:47.437103 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Logged in, session: 05000000e61200002f00000006000000 [2022-02-09 08:05:47.437148 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:05:47.437454 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:05:47.437485 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:05:47.437529 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c90" to be run at: [2022-02-09 08:05:51 -0500] [2022-02-09 08:05:51.311772 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c90" [2022-02-09 08:05:51.312334 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:05:51.312403 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:05:51.312426 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000bd0" to be run at: [2022-02-09 08:05:57 -0500] [2022-02-09 08:05:57.312267 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000bd0" [2022-02-09 08:05:57.312782 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:05:57.312869 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:05:57.312902 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c10" to be run at: [2022-02-09 08:06:05 -0500] [2022-02-09 08:06:05.313087 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c10" [2022-02-09 08:06:05.313636 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:06:05.313713 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:06:05.313746 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c90" to be run at: [2022-02-09 08:06:15 -0500] [2022-02-09 08:06:15.313817 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c90" [2022-02-09 08:06:15.314360 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:06:15.314441 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:06:15.314474 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000bd0" to be run at: [2022-02-09 08:06:27 -0500] [2022-02-09 08:06:27.314659 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000bd0" [2022-02-09 08:06:27.315203 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:06:27.315303 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:06:27.315336 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c10" to be run at: [2022-02-09 08:06:41 -0500] [2022-02-09 08:06:41.315876 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c10" [2022-02-09 08:06:41.316454 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:06:41.316534 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:06:41.316567 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c90" to be run at: [2022-02-09 08:06:57 -0500] [2022-02-09 08:06:57.317488 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c90" [2022-02-09 08:06:57.318058 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:06:57.318126 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:06:57.318149 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000bd0" to be run at: [2022-02-09 08:07:15 -0500] [2022-02-09 08:07:15.319767 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000bd0" [2022-02-09 08:07:15.320282 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:07:15.320347 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:07:15.320371 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c10" to be run at: [2022-02-09 08:07:35 -0500] [2022-02-09 08:07:35.322443 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c10" [2022-02-09 08:07:35.322991 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:07:35.323072 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 04000000e61200001d00000005000000 [2022-02-09 08:07:35.323097 -0500][Error ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Wont retry kXR_endsess request because wouldreach connection timeout. [2022-02-09 08:07:35.323166 -0500][Error ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout [2022-02-09 08:07:35.323189 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:07:35.323213 -0500][Debug ][Poller ] <[::ffff:10.32.77.18]:61524><--><[::ffff:149.165.243.14]:1094> Removing socket from the poller [2022-02-09 08:07:35.323288 -0500][Error ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] elapsed = 108, pConnectionWindow = 120 seconds. [2022-02-09 08:07:35.323311 -0500][Info ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Attempting reconnection in 12 seconds. [2022-02-09 08:07:35.323369 -0500][Debug ][TaskMgr ] Registering task: "StreamConnectorTask for primeradiant06.crc.nd.edu:1094 #0" to be run at: [2022-02-09 08:07:47 -0500] [2022-02-09 08:07:47.325134 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094] Found 1 address(es): [::ffff:149.165.243.14]:1094 [2022-02-09 08:07:47.325250 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Attempting connection to [::ffff:149.165.243.14]:1094 [2022-02-09 08:07:47.325309 -0500][Debug ][Poller ] Adding socket 0x90001b30 to the poller [2022-02-09 08:07:47.325362 -0500][Debug ][TaskMgr ] Done with task: "StreamConnectorTask for primeradiant06.crc.nd.edu:1094 #0" [2022-02-09 08:07:47.325466 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Async connection call returned [2022-02-09 08:07:47.325508 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out the initial hand shake + kXR_protocol [2022-02-09 08:07:47.325733 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got the server hand shake response (type: server [], protocol version 500) [2022-02-09 08:07:47.325769 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] kXR_protocol successful (type: server [proxy], protocol version 500) [2022-02-09 08:07:47.327250 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_login request, username: kmohrman, cgi: ?xrd.cc=us&xrd.tz=-5&xrd.appname=xrdcp&xrd.info=&xrd.hostname=earth.crc.nd.edu&xrd.rn=v4.12.6, dual-stack: false, private IPv4: true, private IPv6: false [2022-02-09 08:07:47.327533 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Logged in, session: 08000000e61200003100000009000000 [2022-02-09 08:07:47.327577 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 05000000e61200002f00000006000000 [2022-02-09 08:07:47.327863 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Stream 0 connected. [2022-02-09 08:07:47.327908 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:07:47.328173 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) with status: [SUCCESS] . [2022-02-09 08:07:47.328277 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Open has returned with status [SUCCESS] [2022-02-09 08:07:47.328309 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] successfully opened at primeradiant06.crc.nd.edu:1094, handle: 0x0, session id: 2 [2022-02-09 08:07:47.328360 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x94001060 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ). [2022-02-09 08:07:47.328419 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x940017e0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ). [2022-02-09 08:07:47.328429 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x94001060 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:07:47.328485 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x94001a70 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ). [2022-02-09 08:07:47.328549 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x940017e0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:07:47.328574 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x940022a0 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ). [2022-02-09 08:07:47.328629 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x94001a70 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:07:47.328663 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:07:47.328663 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:07:47.328678 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x940022a0 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:07:47.328723 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x90000930. [2022-02-09 08:08:47.393654 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:08:47.393756 -0500][Debug ][Poller ] <[::ffff:10.32.77.18]:61590><--><[::ffff:149.165.243.14]:1094> Removing socket from the poller [2022-02-09 08:08:47.393838 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Recovering error for stream #0: [ERROR] Socket error. [2022-02-09 08:08:47.393862 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Reporting disconnection to queued message handlers. [2022-02-09 08:08:47.393891 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608): [ERROR] Socket error. [2022-02-09 08:08:47.393985 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) [2022-02-09 08:08:47.394010 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0x940022a0 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ). [2022-02-09 08:08:47.394048 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 0, size: 8388608): [ERROR] Socket error. [2022-02-09 08:08:47.394102 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 0, size: 8388608) [2022-02-09 08:08:47.394123 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0x94001060 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ). [2022-02-09 08:08:47.394159 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608): [ERROR] Socket error. [2022-02-09 08:08:47.394206 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) [2022-02-09 08:08:47.394201 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x940022a0 (message: kXR_read (handle: 0x00000000, offset: 25165824, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:08:47.394280 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0x940017e0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ). [2022-02-09 08:08:47.394310 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x94001060 (message: kXR_read (handle: 0x00000000, offset: 0, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:08:47.394377 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Running the recovery procedure [2022-02-09 08:08:47.394387 -0500][Debug ][XRootD ] [primeradiant06.crc.nd.edu:1094] Handling error while processing kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608): [ERROR] Socket error. [2022-02-09 08:08:47.394489 -0500][Error ][XRootD ] [primeradiant06.crc.nd.edu:1094] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) [2022-02-09 08:08:47.394520 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Passing to the thread-pool MsgHandler: 0x94001a70 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ). [2022-02-09 08:08:47.394523 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x940017e0 (message: kXR_read (handle: 0x00000000, offset: 8388608, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:08:47.394524 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.394667 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x940022a0. [2022-02-09 08:08:47.394674 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Running the recovery procedure [2022-02-09 08:08:47.394683 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:08:47.394725 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x94001a70 (message: kXR_read (handle: 0x00000000, offset: 16777216, size: 8388608) ) with status: [ERROR] Socket error. [2022-02-09 08:08:47.394784 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0x88001650 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.394883 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x94001060. [2022-02-09 08:08:47.394900 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Running the recovery procedure [2022-02-09 08:08:47.394894 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0x88001650 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:08:47.394962 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0x94001060 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.395009 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x940017e0. [2022-02-09 08:08:47.395019 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Running the recovery procedure [2022-02-09 08:08:47.395016 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0x94001060 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:08:47.395077 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] MsgHandler created: 0x90002390 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.395114 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x94001a70. [2022-02-09 08:08:47.395134 -0500][Debug ][ExDbgMsg ] [ndcms.crc.nd.edu:1094] Moving MsgHandler: 0x90002390 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:08:47.395285 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.395346 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0x88001650 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.395559 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0x94001060 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.396214 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094] Found 1 address(es): [::ffff:149.165.243.14]:1094 [2022-02-09 08:08:47.396274 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Attempting connection to [::ffff:149.165.243.14]:1094 [2022-02-09 08:08:47.396325 -0500][Debug ][Poller ] Adding socket 0x90001b30 to the poller [2022-02-09 08:08:47.396457 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Async connection call returned [2022-02-09 08:08:47.396503 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Retry at server MsgHandler: 0x90002390 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ). [2022-02-09 08:08:47.396529 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out the initial hand shake + kXR_protocol [2022-02-09 08:08:47.396768 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got the server hand shake response (type: server [], protocol version 500) [2022-02-09 08:08:47.396808 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] kXR_protocol successful (type: server [proxy], protocol version 500) [2022-02-09 08:08:47.397835 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_login request, username: kmohrman, cgi: ?xrd.cc=us&xrd.tz=-5&xrd.appname=xrdcp&xrd.info=&xrd.hostname=earth.crc.nd.edu&xrd.rn=v4.12.6, dual-stack: false, private IPv4: true, private IPv6: false [2022-02-09 08:08:47.398017 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Logged in, session: 09000000e61200002f0000000a000000 [2022-02-09 08:08:47.398055 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:08:47.398332 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:08:47.398365 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:08:47.398399 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000ff0" to be run at: [2022-02-09 08:08:51 -0500] [2022-02-09 08:08:51.336018 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000ff0" [2022-02-09 08:08:51.336570 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:08:51.336636 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:08:51.336697 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000bd0" to be run at: [2022-02-09 08:08:57 -0500] [2022-02-09 08:08:57.337146 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000bd0" [2022-02-09 08:08:57.337712 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:08:57.337791 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:08:57.337867 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c10" to be run at: [2022-02-09 08:09:05 -0500] [2022-02-09 08:09:05.338617 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c10" [2022-02-09 08:09:05.339150 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:09:05.339211 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:09:05.339291 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000e20" to be run at: [2022-02-09 08:09:15 -0500] [2022-02-09 08:09:15.340352 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000e20" [2022-02-09 08:09:15.340909 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:09:15.340959 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:09:15.341023 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000bd0" to be run at: [2022-02-09 08:09:27 -0500] [2022-02-09 08:09:27.342470 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000bd0" [2022-02-09 08:09:27.343016 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:09:27.343075 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:09:27.343143 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000c10" to be run at: [2022-02-09 08:09:41 -0500] [2022-02-09 08:09:41.344832 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000c10" [2022-02-09 08:09:41.345374 -0500][Info ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Got wait response to kXR_endsess: session still active [2022-02-09 08:09:41.345447 -0500][Debug ][XRootDTransport ] [primeradiant06.crc.nd.edu:1094 #0.0] Sending out kXR_endsess for session: 08000000e61200003100000009000000 [2022-02-09 08:09:41.345481 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x7fe998000e20" to be run at: [2022-02-09 08:09:57 -0500] [2022-02-09 08:09:57.347586 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x7fe998000e20" [2022-02-09 08:09:57.348141 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Stream 0 connected. [2022-02-09 08:09:57.348252 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:09:57.348331 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x88001650 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:09:57.348376 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x94001060 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:09:57.348463 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x90002390 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue. [2022-02-09 08:09:57.348711 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x90000930 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) with status: [SUCCESS] . [2022-02-09 08:09:57.348769 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x88001650 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) with status: [SUCCESS] . [2022-02-09 08:09:57.348786 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:09:57.348786 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:09:57.348820 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:09:57.348820 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:09:57.348787 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x94001060 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) with status: [SUCCESS] . [2022-02-09 08:09:57.348844 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x88001650. [2022-02-09 08:09:57.348844 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x90000930. [2022-02-09 08:09:57.348930 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x90002390 (message: kXR_open (file: /store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root, mode: 00, flags: kXR_open_read ) ) with status: [SUCCESS] . [2022-02-09 08:09:57.348917 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:09:57.348917 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:09:57.348975 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x94001060. [2022-02-09 08:09:57.348991 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Open has returned with status [SUCCESS] [2022-02-09 08:09:57.349056 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] successfully opened at primeradiant06.crc.nd.edu:1094, handle: 0x3, session id: 3 [2022-02-09 08:09:57.349127 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x88001650 (message: kXR_read (handle: 0x03000000, offset: 25165824, size: 8388608) ). [2022-02-09 08:09:57.349206 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x88002760 (message: kXR_read (handle: 0x03000000, offset: 0, size: 8388608) ). [2022-02-09 08:09:57.349228 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x88001650 (message: kXR_read (handle: 0x03000000, offset: 25165824, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:09:57.349294 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x880029f0 (message: kXR_read (handle: 0x03000000, offset: 8388608, size: 8388608) ). [2022-02-09 08:09:57.349314 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x88002760 (message: kXR_read (handle: 0x03000000, offset: 0, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:09:57.349337 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0x88002c80 (message: kXR_read (handle: 0x03000000, offset: 16777216, size: 8388608) ). [2022-02-09 08:09:57.349360 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x880029f0 (message: kXR_read (handle: 0x03000000, offset: 8388608, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:09:57.349383 -0500][Debug ][XRootD ] Redirect trace-back: [2022-02-09 08:09:57.349383 -0500][Debug ][XRootD ] 0. Redirected from: root://ndcms.crc.nd.edu:1094/ to: root://primeradiant06.crc.nd.edu:1094/ [2022-02-09 08:09:57.349434 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0x88002c80 (message: kXR_read (handle: 0x03000000, offset: 16777216, size: 8388608) ) from out-queu to in-queue. [2022-02-09 08:09:57.349473 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x90002390. [2022-02-09 08:09:57.375742 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x88001650 (message: kXR_read (handle: 0x03000000, offset: 25165824, size: 8388608) ) with status: [SUCCESS] . [2022-02-09 08:09:57.375806 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x88001650. [2022-02-09 08:09:57.392630 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x88002760 (message: kXR_read (handle: 0x03000000, offset: 0, size: 8388608) ) with status: [SUCCESS] . [2022-02-09 08:09:57.392716 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x88002760. [2022-02-09 08:09:57.392817 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a write command for handle 0xb to localhost [8MB/33.77MB][ 23%][===========> ][26.43kB/s] [2022-02-09 08:09:57.393393 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a read command for handle 0x3 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:09:57.393441 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf0a620 (message: kXR_read (handle: 0x03000000, offset: 33554432, size: 1861007) ). [2022-02-09 08:09:57.394570 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf0a620 (message: kXR_read (handle: 0x03000000, offset: 33554432, size: 1861007) ) from out-queu to in-queue. [2022-02-09 08:09:57.408137 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x880029f0 (message: kXR_read (handle: 0x03000000, offset: 8388608, size: 8388608) ) with status: [SUCCESS] . [2022-02-09 08:09:57.408175 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x880029f0. [2022-02-09 08:09:57.408312 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a write command for handle 0xb to localhost [2022-02-09 08:09:57.422934 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0x88002c80 (message: kXR_read (handle: 0x03000000, offset: 16777216, size: 8388608) ) with status: [SUCCESS] . [2022-02-09 08:09:57.423009 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0x88002c80. [2022-02-09 08:09:57.423130 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a write command for handle 0xb to localhost [2022-02-09 08:09:57.423302 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a write command for handle 0xb to localhost [2022-02-09 08:09:57.426250 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf0a620 (message: kXR_read (handle: 0x03000000, offset: 33554432, size: 1861007) ) with status: [SUCCESS] . [2022-02-09 08:09:57.426299 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf0a620. [2022-02-09 08:09:57.427954 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a write command for handle 0xb to localhost [33.77MB/33.77MB][100%][==================================================][111.6kB/s] [2022-02-09 08:09:57.433173 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Sending a close command for handle 0xb to localhost [2022-02-09 08:09:57.433291 -0500][Debug ][File ] [0xf07660@file://localhost/dev/null?oss.asize=35415439&xrdcl.requuid=b94e0629-af89-460d-bfd6-612823c82a1a] Close returned from localhost with: [SUCCESS] [2022-02-09 08:09:57.433381 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Sending a close command for handle 0x3 to primeradiant06.crc.nd.edu:1094 [2022-02-09 08:09:57.433428 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] MsgHandler created: 0xf07660 (message: kXR_close (handle: 0x03000000) ). [2022-02-09 08:09:57.433525 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Moving MsgHandler: 0xf07660 (message: kXR_close (handle: 0x03000000) ) from out-queu to in-queue. [2022-02-09 08:09:57.433684 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Calling MsgHandler: 0xf07660 (message: kXR_close (handle: 0x03000000) ) with status: [SUCCESS] . [2022-02-09 08:09:57.433728 -0500][Debug ][File ] [0xf02280@root://ndcms.crc.nd.edu:1094//store/mc/RunIISummer20UL17NanoAODv9/WZTo3LNu_TuneCP5_13TeV-amcatnloFXFX-pythia8/NANOAODSIM/106X_mc2017_realistic_v9-v2/250000/3259A23F-EBAD-7B4A-A0AF-098263FDE109.root?xrdcl.requuid=50e0aad9-06ac-4ce7-bb97-2ccd13b7f773] Close returned from primeradiant06.crc.nd.edu:1094 with: [SUCCESS] [2022-02-09 08:09:57.433763 -0500][Debug ][ExDbgMsg ] [primeradiant06.crc.nd.edu:1094] Destroying MsgHandler: 0xf07660. [33.77MB/33.77MB][100%][==================================================][111.6kB/s] [2022-02-09 08:09:57.434046 -0500][Debug ][JobMgr ] Stopping the job manager... [2022-02-09 08:09:57.434423 -0500][Debug ][JobMgr ] Job manager stopped [2022-02-09 08:09:57.434453 -0500][Debug ][TaskMgr ] Stopping the task manager... [2022-02-09 08:09:57.434631 -0500][Debug ][TaskMgr ] Task manager stopped [2022-02-09 08:09:57.434659 -0500][Debug ][Poller ] Stopping the poller... [2022-02-09 08:09:57.434813 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: ndcms.crc.nd.edu:1094" [2022-02-09 08:09:57.434843 -0500][Debug ][AsyncSock ] [ndcms.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:09:57.434873 -0500][Debug ][Poller ] <[::ffff:10.32.77.18]:13346><--><[::ffff:129.74.85.4]:1094> Removing socket from the poller [2022-02-09 08:09:57.434931 -0500][Debug ][PostMaster ] [ndcms.crc.nd.edu:1094 #0] Destroying stream [2022-02-09 08:09:57.434960 -0500][Debug ][AsyncSock ] [ndcms.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:09:57.434999 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: primeradiant06.crc.nd.edu:1094" [2022-02-09 08:09:57.435021 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Closing the socket [2022-02-09 08:09:57.435044 -0500][Debug ][Poller ] <[::ffff:10.32.77.18]:61618><--><[::ffff:149.165.243.14]:1094> Removing socket from the poller [2022-02-09 08:09:57.435085 -0500][Debug ][PostMaster ] [primeradiant06.crc.nd.edu:1094 #0] Destroying stream [2022-02-09 08:09:57.435113 -0500][Debug ][AsyncSock ] [primeradiant06.crc.nd.edu:1094 #0.0] Closing the socket