 |
 |
Hi,
I copy the xrdcopy behavior below. It didn't even get this far - it was unable to connect to the data server and immediately gave up.
If it asks cms-xrd-global.cern.ch for a different replica, there is another one available.
Brian
[bbockelm@hcc-briantest ~]$ XRD_CONNECTIONWINDOW=10 XRD_NETWORKSTACK=IPv4 xrdcopy -d 2 -f 'root://cmsxrootd.fnal.gov//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root' /dev/null
[2014-07-31 09:53:57.590053 -0500][Debug ][Poller ] Available pollers: built-in
[2014-07-31 09:53:57.590138 -0500][Debug ][Poller ] Attempting to create a poller according to preference: built-in,libevent
[2014-07-31 09:53:57.590157 -0500][Debug ][Poller ] Creating poller: built-in
[2014-07-31 09:53:57.590172 -0500][Debug ][Poller ] Creating and starting the built-in poller...
[2014-07-31 09:53:57.590478 -0500][Debug ][TaskMgr ] Starting the task manager...
[2014-07-31 09:53:57.590603 -0500][Debug ][TaskMgr ] Task manager started
[2014-07-31 09:53:57.590778 -0500][Debug ][JobMgr ] Starting the job manager...
[2014-07-31 09:53:57.590925 -0500][Debug ][JobMgr ] Job manager started, 3 workers
[2014-07-31 09:53:57.590975 -0500][Debug ][TaskMgr ] Registering task: "FileTimer task" to be run at: [2014-07-31 09:53:57 -0500]
[2014-07-31 09:53:57.590975 -0500][Debug ][PostMaster ] Creating new channel to: cmsxrootd.fnal.gov:1094 1 stream(s)
[2014-07-31 09:53:57.590975 -0500][Debug ][PostMaster ] [cmsxrootd.fnal.gov:1094 #0] Stream parameters: Network Stack: IPv4, Connection Window: 10, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-07-31 09:53:57.591661 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: cmsxrootd.fnal.gov:1094" to be run at: [2014-07-31 09:54:12 -0500]
[2014-07-31 09:53:57.592294 -0500][Debug ][PostMaster ] [cmsxrootd.fnal.gov:1094] Found 2 address(es): [::ffff:131.225.204.174]:1094, [::ffff:129.93.239.131]:1094
[2014-07-31 09:53:57.592348 -0500][Debug ][AsyncSock ] [cmsxrootd.fnal.gov:1094 #0.0] Attempting connection to [::ffff:131.225.204.174]:1094
[2014-07-31 09:53:57.592630 -0500][Debug ][Poller ] Adding socket 0x17bc5c0 to the poller
[2014-07-31 09:53:57.610637 -0500][Debug ][AsyncSock ] [cmsxrootd.fnal.gov:1094 #0.0] Async connection call returned
[2014-07-31 09:53:57.610689 -0500][Debug ][XRootDTransport ] [cmsxrootd.fnal.gov:1094 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-07-31 09:53:57.628762 -0500][Debug ][XRootDTransport ] [cmsxrootd.fnal.gov:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 297)
[2014-07-31 09:53:57.628811 -0500][Debug ][XRootDTransport ] [cmsxrootd.fnal.gov:1094 #0.0] kXR_protocol successful (type: manager [], protocol version 297)
[2014-07-31 09:53:57.630250 -0500][Debug ][XRootDTransport ] [cmsxrootd.fnal.gov:1094 #0.0] Sending out kXR_login request, username: bbockelm, cgi: ?xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp
[2014-07-31 09:53:57.648046 -0500][Debug ][XRootDTransport ] [cmsxrootd.fnal.gov:1094 #0.0] Logged in
[2014-07-31 09:53:57.648102 -0500][Debug ][PostMaster ] [cmsxrootd.fnal.gov:1094 #0] Stream 0 connected.
[2014-07-31 09:53:57.648119 -0500][Debug ][Utility ] Monitor library name not set. No monitoring
[2014-07-31 09:53:57.666362 -0500][Error ][XRootD ] [cmsxrootd.fnal.gov:1094] Handling error while processing kXR_stat (path: /store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root, flags: none): [ERROR] Error response.
[2014-07-31 09:53:57.666413 -0500][Debug ][Utility ] CopyProcess: 1 jobs to prepare
[2014-07-31 09:53:57.666657 -0500][Debug ][Utility ] Creating a classic copy job, from root://cmsxrootd.fnal.gov:1094//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root to file:///dev/null
[2014-07-31 09:53:57.666665 -0500][Debug ][Utility ] Opening root://cmsxrootd.fnal.gov:1094//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root for reading
[2014-07-31 09:53:57.666665 -0500][Debug ][File ] [0x17bd4c0@root://cmsxrootd.fnal.gov:1094//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root] Sending an open command
[2014-07-31 09:53:57.703137 -0500][Debug ][PostMaster ] Creating new channel to: cms-xrd-global.cern.ch:1094 1 stream(s)
[2014-07-31 09:53:57.703181 -0500][Debug ][PostMaster ] [cms-xrd-global.cern.ch:1094 #0] Stream parameters: Network Stack: IPv4, Connection Window: 10, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-07-31 09:53:57.703922 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: cms-xrd-global.cern.ch:1094" to be run at: [2014-07-31 09:54:12 -0500]
[2014-07-31 09:53:57.704764 -0500][Debug ][PostMaster ] [cms-xrd-global.cern.ch:1094] Found 2 address(es): [::ffff:128.142.138.171]:1094, [::ffff:128.142.139.172]:1094
[2014-07-31 09:53:57.704764 -0500][Debug ][AsyncSock ] [cms-xrd-global.cern.ch:1094 #0.0] Attempting connection to [::ffff:128.142.138.171]:1094
[2014-07-31 09:53:57.704843 -0500][Debug ][Poller ] Adding socket 0x600014a0 to the poller
[2014-07-31 09:53:57.840069 -0500][Debug ][AsyncSock ] [cms-xrd-global.cern.ch:1094 #0.0] Async connection call returned
[2014-07-31 09:53:57.840161 -0500][Debug ][XRootDTransport ] [cms-xrd-global.cern.ch:1094 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-07-31 09:53:57.978066 -0500][Debug ][XRootDTransport ] [cms-xrd-global.cern.ch:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 297)
[2014-07-31 09:53:57.978131 -0500][Debug ][XRootDTransport ] [cms-xrd-global.cern.ch:1094 #0.0] kXR_protocol successful (type: manager [meta], protocol version 297)
[2014-07-31 09:53:57.979646 -0500][Debug ][XRootDTransport ] [cms-xrd-global.cern.ch:1094 #0.0] Sending out kXR_login request, username: bbockelm, cgi: ?xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp
[2014-07-31 09:53:58.115605 -0500][Debug ][XRootDTransport ] [cms-xrd-global.cern.ch:1094 #0.0] Logged in
[2014-07-31 09:53:58.115660 -0500][Debug ][PostMaster ] [cms-xrd-global.cern.ch:1094 #0] Stream 0 connected.
[2014-07-31 09:53:58.251794 -0500][Debug ][TaskMgr ] Registering task: "WaitTask for: 0x0x17bcbf0" to be run at: [2014-07-31 09:54:03 -0500]
[2014-07-31 09:54:03.591660 -0500][Debug ][TaskMgr ] Done with task: "WaitTask for: 0x0x17bcbf0"
[2014-07-31 09:54:03.727778 -0500][Debug ][PostMaster ] Creating new channel to: cmsdbs.ihep.ac.cn:1094 1 stream(s)
[2014-07-31 09:54:03.727822 -0500][Debug ][PostMaster ] [cmsdbs.ihep.ac.cn:1094 #0] Stream parameters: Network Stack: IPv4, Connection Window: 10, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-07-31 09:54:03.728751 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: cmsdbs.ihep.ac.cn:1094" to be run at: [2014-07-31 09:54:18 -0500]
[2014-07-31 09:54:03.729339 -0500][Debug ][PostMaster ] [cmsdbs.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.52]:1094
[2014-07-31 09:54:03.729384 -0500][Debug ][AsyncSock ] [cmsdbs.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.52]:1094
[2014-07-31 09:54:03.729450 -0500][Debug ][Poller ] Adding socket 0x5c001390 to the poller
[2014-07-31 09:54:03.940392 -0500][Debug ][AsyncSock ] [cmsdbs.ihep.ac.cn:1094 #0.0] Async connection call returned
[2014-07-31 09:54:03.940461 -0500][Debug ][XRootDTransport ] [cmsdbs.ihep.ac.cn:1094 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-07-31 09:54:04.150457 -0500][Debug ][XRootDTransport ] [cmsdbs.ihep.ac.cn:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 291)
[2014-07-31 09:54:04.150735 -0500][Debug ][XRootDTransport ] [cmsdbs.ihep.ac.cn:1094 #0.0] kXR_protocol successful (type: manager [], protocol version 291)
[2014-07-31 09:54:04.152103 -0500][Debug ][XRootDTransport ] [cmsdbs.ihep.ac.cn:1094 #0.0] Sending out kXR_login request, username: bbockelm, cgi: ?xrd.cc=us&xrd.tz=-6&xrd.appname=xrdcp
[2014-07-31 09:54:04.361933 -0500][Debug ][XRootDTransport ] [cmsdbs.ihep.ac.cn:1094 #0.0] Logged in
[2014-07-31 09:54:04.361988 -0500][Debug ][PostMaster ] [cmsdbs.ihep.ac.cn:1094 #0] Stream 0 connected.
[2014-07-31 09:54:04.579622 -0500][Debug ][PostMaster ] Creating new channel to: seadmin.ihep.ac.cn:1094 1 stream(s)
[2014-07-31 09:54:04.579666 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094 #0] Stream parameters: Network Stack: IPv4, Connection Window: 10, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-07-31 09:54:04.580462 -0500][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: seadmin.ihep.ac.cn:1094" to be run at: [2014-07-31 09:54:19 -0500]
[2014-07-31 09:54:04.581075 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:04.581106 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:04.581316 -0500][Debug ][Poller ] Adding socket 0x600020c0 to the poller
[2014-07-31 09:54:19.595002 -0500][Error ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout
[2014-07-31 09:54:19.595034 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:54:19.595044 -0500][Debug ][Poller ] <x><--><x> Removing socket from the poller
[2014-07-31 09:54:19.595623 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:19.602204 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:19.602278 -0500][Debug ][Poller ] Adding socket 0x600020c0 to the poller
[2014-07-31 09:54:34.617613 -0500][Error ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout
[2014-07-31 09:54:34.617654 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:54:34.617664 -0500][Debug ][Poller ] <x><--><x> Removing socket from the poller
[2014-07-31 09:54:34.618361 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:34.618408 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:34.618685 -0500][Debug ][Poller ] Adding socket 0x600020c0 to the poller
[2014-07-31 09:54:49.633035 -0500][Error ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout
[2014-07-31 09:54:49.633071 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:54:49.633082 -0500][Debug ][Poller ] <x><--><x> Removing socket from the poller
[2014-07-31 09:54:49.633741 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:49.633761 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.22]:1094
[2014-07-31 09:54:49.634002 -0500][Debug ][Poller ] Adding socket 0x600020c0 to the poller
[2014-07-31 09:55:04.647680 -0500][Error ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout
[2014-07-31 09:55:04.647719 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:55:04.647729 -0500][Debug ][Poller ] <x><--><x> Removing socket from the poller
[2014-07-31 09:55:04.648565 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094] Found 1 address(es): [::ffff:202.122.33.22]:1094
[2014-07-31 09:55:04.648602 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Attempting connection to [::ffff:202.122.33.22]:1094
[2014-07-31 09:55:04.648781 -0500][Debug ][Poller ] Adding socket 0x600020c0 to the poller
[2014-07-31 09:55:19.663584 -0500][Error ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Socket error while handshaking: [ERROR] Socket timeout
[2014-07-31 09:55:19.663614 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:55:19.663624 -0500][Debug ][Poller ] <x><--><x> Removing socket from the poller
[2014-07-31 09:55:19.663666 -0500][Error ][PostMaster ] [seadmin.ihep.ac.cn:1094 #0] Unable to recover: [ERROR] Socket timeout.
[2014-07-31 09:55:19.663678 -0500][Error ][XRootD ] [seadmin.ihep.ac.cn:1094] Impossible to send message kXR_open (file: /store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root?tried=+1213xrootd.unl.edu1213cmsxrootd1.fnal.gov, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ). Trying to recover.
[2014-07-31 09:55:19.663693 -0500][Error ][XRootD ] [seadmin.ihep.ac.cn:1094] Handling error while processing kXR_open (file: /store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root?tried=+1213xrootd.unl.edu1213cmsxrootd1.fnal.gov, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): [FATAL] Socket timeout.
[2014-07-31 09:55:20.013534 -0500][Error ][XRootD ] [cmsdbs.ihep.ac.cn:1094] Handling error while processing kXR_open (file: /store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root?tried=+1213xrootd.unl.edu1213cmsxrootd1.fnal.gov,seadmin.ihep.ac.cn, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): [ERROR] Error response.
[2014-07-31 09:55:20.013610 -0500][Debug ][File ] [0x17bd4c0@root://cmsxrootd.fnal.gov:1094//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root] Open has returned with status [ERROR] Server responded with an error: [3011] No servers have read access to the file
[2014-07-31 09:55:20.013624 -0500][Debug ][File ] [0x17bd4c0@root://cmsxrootd.fnal.gov:1094//store/mc/Spring14dr/WplusToTauNu_CT10_13TeV-powheg-pythia8-tauola/AODSIM/PU_S14_POSTLS170_V6-v1/00000/024BD287-7E08-E411-93B6-00266CFFBE68.root] Error while opening at cmsdbs.ihep.ac.cn:1094: [ERROR] Server responded with an error: [3011] No servers have read access to the file
[0B/0B][100%][==================================================][0B/s]
Run: [ERROR] Server responded with an error: [3011] No servers have read access to the file
[2014-07-31 09:55:20.013750 -0500][Debug ][JobMgr ] Stopping the job manager...
[2014-07-31 09:55:20.014126 -0500][Debug ][JobMgr ] Job manager stopped
[2014-07-31 09:55:20.014126 -0500][Debug ][TaskMgr ] Stopping the task manager...
[2014-07-31 09:55:20.014294 -0500][Debug ][TaskMgr ] Task manager stopped
[2014-07-31 09:55:20.014294 -0500][Debug ][Poller ] Stopping the poller...
[2014-07-31 09:55:20.016467 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: cms-xrd-global.cern.ch:1094"
[2014-07-31 09:55:20.016467 -0500][Debug ][AsyncSock ] [cms-xrd-global.cern.ch:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016467 -0500][Debug ][Poller ] <[::ffff:129.93.244.208]:49622><--><[::ffff:128.142.138.171]:1094> Removing socket from the poller
[2014-07-31 09:55:20.016543 -0500][Debug ][PostMaster ] [cms-xrd-global.cern.ch:1094 #0] Destroying stream
[2014-07-31 09:55:20.016574 -0500][Debug ][AsyncSock ] [cms-xrd-global.cern.ch:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016605 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: cmsdbs.ihep.ac.cn:1094"
[2014-07-31 09:55:20.016610 -0500][Debug ][AsyncSock ] [cmsdbs.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016610 -0500][Debug ][Poller ] <[::ffff:129.93.244.208]:52796><--><[::ffff:202.122.33.52]:1094> Removing socket from the poller
[2014-07-31 09:55:20.016610 -0500][Debug ][PostMaster ] [cmsdbs.ihep.ac.cn:1094 #0] Destroying stream
[2014-07-31 09:55:20.016610 -0500][Debug ][AsyncSock ] [cmsdbs.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016610 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: cmsxrootd.fnal.gov:1094"
[2014-07-31 09:55:20.016610 -0500][Debug ][AsyncSock ] [cmsxrootd.fnal.gov:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016610 -0500][Debug ][Poller ] <[::ffff:129.93.244.208]:35108><--><[::ffff:131.225.204.174]:1094> Removing socket from the poller
[2014-07-31 09:55:20.016614 -0500][Debug ][PostMaster ] [cmsxrootd.fnal.gov:1094 #0] Destroying stream
[2014-07-31 09:55:20.016624 -0500][Debug ][AsyncSock ] [cmsxrootd.fnal.gov:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016634 -0500][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: seadmin.ihep.ac.cn:1094"
[2014-07-31 09:55:20.016642 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
[2014-07-31 09:55:20.016650 -0500][Debug ][PostMaster ] [seadmin.ihep.ac.cn:1094 #0] Destroying stream
[2014-07-31 09:55:20.016657 -0500][Debug ][AsyncSock ] [seadmin.ihep.ac.cn:1094 #0.0] Closing the socket
—
Reply to this email directly or view it on GitHub.
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