Hi,
actually I can not use xrdcopy. It does not work at all:
when I do:
xrdcp -np -d 1 root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M - > test.here 2>>upstreamFrom_MWT2_2014-01-13T1801.log
I get the file. Messed up log file but I do get the file.
command:
xrdcopy -np -d 2 root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M - > test.here 2>>upstreamFrom_MWT2_2014-01-13T1801.log
makes 0 bytes file:
[2014-01-16 19:10:33 +0100][Debug ][Utility ] CopyProcess: 1 jobs to prepare
[2014-01-16 19:10:33 +0100][Debug ][Utility ] Creating a classic copy job, from root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M to -
[2014-01-16 19:10:33 +0100][Debug ][Utility ] Monitor library name not set. No monitoring
[2014-01-16 19:10:33 +0100][Debug ][Utility ] Opening root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M for reading
[2014-01-16 19:10:33 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Sending an open command
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Available pollers: built-in
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Attempting to create a poller according to preference: built-in,libevent
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Creating poller: built-in
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Creating and starting the built-in poller...
[2014-01-16 19:10:33 +0100][Debug ][TaskMgr ] Starting the task manager...
[2014-01-16 19:10:33 +0100][Debug ][TaskMgr ] Task manager started
[2014-01-16 19:10:33 +0100][Debug ][JobMgr ] Starting the job manager...
[2014-01-16 19:10:33 +0100][Debug ][JobMgr ] Job manager started, 3 workers
[2014-01-16 19:10:33 +0100][Debug ][TaskMgr ] Registering task: "FileTimer task" to be run at: [2014-01-16 19:10:33 +0100]
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] Creating new channel to: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 1 stream(s)
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0] Stream parameters: Connection Window: 120, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-01-16 19:10:33 +0100][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094" to be run at: [2014-01-16 19:10:48 +0100]
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094] Found 1 address(es): [::192.170.227.128]:1094
[2014-01-16 19:10:33 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Attempting connection to [::192.170.227.128]:1094
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Adding socket 0x18b1880 to the poller
[2014-01-16 19:10:33 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Async connection call returned
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 297)
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] kXR_protocol successful (type: manager [], protocol version 297)
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Sending out kXR_login request, username: ivukotic
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Logged in
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0] Stream 0 connected.
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] Creating new channel to: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 1 stream(s)
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0] Stream parameters: Connection Window: 120, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-01-16 19:10:33 +0100][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997" to be run at: [2014-01-16 19:10:48 +0100]
[2014-01-16 19:10:33 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997] Found 1 address(es): [::192.170.227.128]:60997
[2014-01-16 19:10:33 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Attempting connection to [::192.170.227.128]:60997
[2014-01-16 19:10:33 +0100][Debug ][Poller ] Adding socket 0x780012a0 to the poller
[2014-01-16 19:10:33 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Async connection call returned
[2014-01-16 19:10:33 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Got the server hand shake response (type: server [], protocol version 297)
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] kXR_protocol successful (type: server [], protocol version 297)
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Sending out kXR_login request, username: ivukotic
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Logged in
[2014-01-16 19:10:34 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0] Stream 0 connected.
[2014-01-16 19:10:34 +0100][Debug ][PostMaster ] Creating new channel to: uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 1 stream(s)
[2014-01-16 19:10:34 +0100][Debug ][PostMaster ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0] Stream parameters: Connection Window: 120, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-01-16 19:10:34 +0100][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096" to be run at: [2014-01-16 19:10:49 +0100]
[2014-01-16 19:10:34 +0100][Debug ][PostMaster ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096] Found 1 address(es): [::192.170.227.100]:1096
[2014-01-16 19:10:34 +0100][Debug ][AsyncSock ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Attempting connection to [::192.170.227.100]:1096
[2014-01-16 19:10:34 +0100][Debug ][Poller ] Adding socket 0x7c0012a0 to the poller
[2014-01-16 19:10:34 +0100][Debug ][AsyncSock ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Async connection call returned
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Got the server hand shake response (type: manager [], protocol version 289)
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] kXR_protocol successful (type: manager [], protocol version 289)
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Sending out kXR_login request, username: ivukotic
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Logged in
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Authentication is required: &P=gsi,v:10200,c:ssl,ca:c7a717ce
[2014-01-16 19:10:34 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Sending authentication data
[2014-01-16 19:10:35 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Trying to authenticate using gsi
[2014-01-16 19:10:35 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Sending more authentication data for gsi
[2014-01-16 19:10:35 +0100][Debug ][XRootDTransport ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Authenticated with gsi.
[2014-01-16 19:10:35 +0100][Debug ][PostMaster ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0] Stream 0 connected.
[2014-01-16 19:10:36 +0100][Debug ][PostMaster ] Creating new channel to: 192.170.227.113:24702 1 stream(s)
[2014-01-16 19:10:36 +0100][Debug ][PostMaster ] [192.170.227.113:24702 #0] Stream parameters: Connection Window: 120, ConnectionRetry: 5, Stream Error Widnow: 1800
[2014-01-16 19:10:36 +0100][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: 192.170.227.113:24702" to be run at: [2014-01-16 19:10:51 +0100]
[2014-01-16 19:10:36 +0100][Debug ][PostMaster ] [192.170.227.113:24702] Found 1 address(es): [::192.170.227.113]:24702
[2014-01-16 19:10:36 +0100][Debug ][AsyncSock ] [192.170.227.113:24702 #0.0] Attempting connection to [::192.170.227.113]:24702
[2014-01-16 19:10:36 +0100][Debug ][Poller ] Adding socket 0x6c0013e0 to the poller
[2014-01-16 19:10:36 +0100][Debug ][AsyncSock ] [192.170.227.113:24702 #0.0] Async connection call returned
[2014-01-16 19:10:36 +0100][Debug ][XRootDTransport ] [192.170.227.113:24702 #0.0] Sending out the initial hand shake + kXR_protocol
[2014-01-16 19:10:36 +0100][Debug ][XRootDTransport ] [192.170.227.113:24702 #0.0] Got the server hand shake response (type: server [], protocol version 289)
[2014-01-16 19:10:36 +0100][Debug ][XRootDTransport ] [192.170.227.113:24702 #0.0] kXR_protocol successful (type: server [], protocol version 289)
[2014-01-16 19:10:36 +0100][Debug ][XRootDTransport ] [192.170.227.113:24702 #0.0] Sending out kXR_login request, username: ivukotic
[2014-01-16 19:10:36 +0100][Debug ][XRootDTransport ] [192.170.227.113:24702 #0.0] Logged in
[2014-01-16 19:10:36 +0100][Debug ][PostMaster ] [192.170.227.113:24702 #0] Stream 0 connected.
[2014-01-16 19:10:36 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Open has returned with status [SUCCESS]
[2014-01-16 19:10:36 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] successfully opened at 192.170.227.113:24702, handle: 0x0, session id: 1
[2014-01-16 19:10:36 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Sending a read command for handle 0x0 to 192.170.227.113:24702
[2014-01-16 19:15:36 +0100][Error ][XRootD ] [192.170.227.113:24702] Handling error while processing kXR_read (handle: 0x0000, offset: 0, size: 16777216): [ERROR] Operation expired.
[2014-01-16 19:15:36 +0100][Error ][XRootD ] [192.170.227.113:24702] Unable to get the response to request kXR_read (handle: 0x0000, offset: 0, size: 16777216)
[2014-01-16 19:15:36 +0100][Error ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Fatal file state error. Message kXR_read (handle: 0x0000, offset: 0, size: 16777216) returned with [ERROR] Operation expired
[2014-01-16 19:15:36 +0100][Debug ][Utility ] Unable read 16777216 bytes at 0 from root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M: [ERROR] Operation expired
[2014-01-16 19:15:36 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Sending a close command for handle 0x0 to 192.170.227.113:24702
[2014-01-16 19:15:36 +0100][Error ][XRootDTransport ] Message 0x6521ea30, stream [0, 0] is a response that we're no longer interested in (timed out)
[2014-01-16 19:20:36 +0100][Error ][XRootD ] [192.170.227.113:24702] Handling error while processing kXR_close (handle: 0x0000): [ERROR] Operation expired.
[2014-01-16 19:20:36 +0100][Error ][XRootD ] [192.170.227.113:24702] Unable to get the response to request kXR_close (handle: 0x0000)
[2014-01-16 19:20:36 +0100][Debug ][File ] [0x18ac450@root://uct2-int.mwt2.org:1094//atlas/rucio/user/ivukotic:user.ivukotic.xrootd.mwt2-1M] Close returned from 192.170.227.113:24702 with: [ERROR] Operation expired
Run: [ERROR] Operation expired
[2014-01-16 19:20:36 +0100][Debug ][JobMgr ] Stopping the job manager...
[2014-01-16 19:20:36 +0100][Debug ][JobMgr ] Job manager stopped
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Stopping the task manager...
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Task manager stopped
[2014-01-16 19:20:36 +0100][Debug ][Poller ] Stopping the poller...
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: 192.170.227.113:24702"
[2014-01-16 19:20:36 +0100][Debug ][PostMaster ] [192.170.227.113:24702 #0] Destroying stream
[2014-01-16 19:20:36 +0100][Debug ][AsyncSock ] [192.170.227.113:24702 #0.0] Closing the socket
[2014-01-16 19:20:36 +0100][Debug ][Poller ] <[::188.184.28.28]:59374><--><[::192.170.227.113]:24702> Removing socket from the poller
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094"
[2014-01-16 19:20:36 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0] Destroying stream
[2014-01-16 19:20:36 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:1094 #0.0] Closing the socket
[2014-01-16 19:20:36 +0100][Debug ][Poller ] <[::188.184.28.28]:42150><--><[::192.170.227.128]:1094> Removing socket from the poller
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997"
[2014-01-16 19:20:36 +0100][Debug ][PostMaster ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0] Destroying stream
[2014-01-16 19:20:36 +0100][Debug ][AsyncSock ] [uct2-int.mwt2.org<http://uct2-int.mwt2.org>:60997 #0.0] Closing the socket
[2014-01-16 19:20:36 +0100][Debug ][Poller ] <[::188.184.28.28]:36175><--><[::192.170.227.128]:60997> Removing socket from the poller
[2014-01-16 19:20:36 +0100][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096"
[2014-01-16 19:20:36 +0100][Debug ][PostMaster ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0] Destroying stream
[2014-01-16 19:20:36 +0100][Debug ][AsyncSock ] [uct2-s5.mwt2.org<http://uct2-s5.mwt2.org>:1096 #0.0] Closing the socket
[2014-01-16 19:20:36 +0100][Debug ][Poller ] <[::188.184.28.28]:52079><--><[::192.170.227.100]:1096> Removing socket from the poller
Cheers,
Ilija
--
Dr Ilija Vukotic [log in to unmask]<mailto:[log in to unmask]>
University of Chicago http://www.vukotic.me
5620 S Ellis Ave Tel: +1-773-702-7475
Chicago IL 60637, USA
On Jan 16, 2014, at 3:46 , Lukasz Janyst <[log in to unmask]<mailto:[log in to unmask]>> wrote:
Yes, and I see the problem now. For me it does not print null characters, but rather the normal log interleaved with random garbage. Can you use xrdcopy instead?
Reply to this email directly or view it on GitHub<https://github.com/xrootd/xrootd/issues/71#issuecomment-32454532>.
—
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
