[2019-09-11 07:05:03.062257 +0200][Debug ][Utility ] Unable to process user config file: [ERROR] OS Error: No such file or directory
[2019-09-11 07:05:03.062430 +0200][Debug ][PlugInMgr ] Initializing plug-in manager...
[2019-09-11 07:05:03.062442 +0200][Debug ][PlugInMgr ] No default plug-in, loading plug-in configs...
[2019-09-11 07:05:03.062448 +0200][Debug ][PlugInMgr ] Processing plug-in definitions in /etc/xrootd/client.plugins.d...
[2019-09-11 07:05:03.062502 +0200][Debug ][PlugInMgr ] Processing plug-in definitions in /var/lib/condor/.xrootd/client.plugins.d...
[2019-09-11 07:05:03.062512 +0200][Debug ][PlugInMgr ] Unable to process directory /var/lib/condor/.xrootd/client.plugins.d: [ERROR] OS Error: No such file or directory
[2019-09-11 07:05:03.062572 +0200][Dump ][App ] Chunk size: 16777216, parallel chunks 4, streams: 1
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:03.062608 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:03.062629 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:03.062646 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:03.062663 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:03.062691 +0200][Dump ][FileSystem ] [[log in to unmask]:1094] Sending kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none)
[2019-09-11 07:05:03.062714 +0200][Debug ][Poller ] Available pollers: built-in
[2019-09-11 07:05:03.062722 +0200][Debug ][Poller ] Attempting to create a poller according to preference: built-in
[2019-09-11 07:05:03.062727 +0200][Debug ][Poller ] Creating poller: built-in
[2019-09-11 07:05:03.062736 +0200][Debug ][Poller ] Creating and starting the built-in poller...
[2019-09-11 07:05:03.066410 +0200][Debug ][Poller ] Using 1 poller threads
[2019-09-11 07:05:03.066441 +0200][Debug ][TaskMgr ] Starting the task manager...
[2019-09-11 07:05:03.066478 +0200][Debug ][TaskMgr ] Task manager started
[2019-09-11 07:05:03.066485 +0200][Debug ][JobMgr ] Starting the job manager...
[2019-09-11 07:05:03.066531 +0200][Debug ][JobMgr ] Job manager started, 3 workers
[2019-09-11 07:05:03.066540 +0200][Debug ][TaskMgr ] Registering task: "FileTimer task" to be run at: [2019-09-11 07:05:03 +0200]
[2019-09-11 07:05:03.066546 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Sending message kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none)
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] URL: golias100.farm.particle.cz:1094
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:03.066582 +0200][Dump ][Utility ] Path:
[2019-09-11 07:05:03.066596 +0200][Debug ][PostMaster ] Creating new channel to: golias100.farm.particle.cz:1094 1 stream(s)
[2019-09-11 07:05:03.066621 +0200][Debug ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Stream parameters: Network Stack: IPAuto, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800
[2019-09-11 07:05:03.066681 +0200][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: golias100.farm.particle.cz:1094" to be run at: [2019-09-11 07:05:18 +0200]
[2019-09-11 07:05:03.066697 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] MsgHandler created: 0x24a6a60 (message: kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) ).
[2019-09-11 07:05:03.066707 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Sending message kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) (0x24a14b0) through substream 0 expecting answer at 0
[2019-09-11 07:05:04.066603 +0200][Dump ][TaskMgr ] Running task: "FileTimer task"
[2019-09-11 07:05:04.066649 +0200][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2019-09-11 07:05:19 +0200]
[2019-09-11 07:05:08.076831 +0200][Debug ][PostMaster ] [golias100.farm.particle.cz:1094] Found 2 address(es): [::ffff:147.231.25.100]:1094, [2001:718:401:6017:2::1000]:1094
[2019-09-11 07:05:08.076892 +0200][Debug ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Attempting connection to [2001:718:401:6017:2::1000]:1094
[2019-09-11 07:05:08.077093 +0200][Debug ][Poller ] Adding socket 0x24a6750 to the poller
[2019-09-11 07:05:08.077122 +0200][Dump ][Poller ] <--> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.082329 +0200][Dump ][Poller ] <--> Got an event: ReadyToWrite
[2019-09-11 07:05:11.082375 +0200][Debug ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Async connection call returned
[2019-09-11 07:05:11.082411 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Sending out the initial hand shake + kXR_protocol
[2019-09-11 07:05:11.082423 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable read notifications, timeout: 15
[2019-09-11 07:05:11.082441 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.082467 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: (0xe0000950), 44 bytes
[2019-09-11 07:05:11.082473 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.083238 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.083270 +0200][Dump ][XRootDTransport ] [msg: 0xe0000a80] Expecting 8 bytes of message body
[2019-09-11 07:05:11.083276 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.083284 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received a message of 16 bytes
[2019-09-11 07:05:11.083295 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Got the server hand shake response (type: manager [], protocol version 400)
[2019-09-11 07:05:11.083303 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.083308 +0200][Dump ][XRootDTransport ] [msg: 0xe0000a80] Expecting 8 bytes of message body
[2019-09-11 07:05:11.083312 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.083317 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received a message of 16 bytes
[2019-09-11 07:05:11.083323 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] kXR_protocol successful (type: manager [], protocol version 400)
[2019-09-11 07:05:11.083465 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Sending out kXR_login request, username: condor, cgi: ?xrd.cc=cz&xrd.tz=1&xrd.appname=xrdcp&xrd.info=&xrd.hostname=mff82.farm.particle.cz&xrd.rn=v4.9.1, dual-stack: true, private IPv4: true, private IPv6: false
[2019-09-11 07:05:11.083473 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.083481 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.083500 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: (0xe0000ba0), 121 bytes
[2019-09-11 07:05:11.083505 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.084278 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.084298 +0200][Dump ][XRootDTransport ] [msg: 0xe00009a0] Expecting 68 bytes of message body
[2019-09-11 07:05:11.084303 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.084309 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received a message of 76 bytes
[2019-09-11 07:05:11.084319 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Logged in, session: 3bad0400ff0d0000fb01000050f40a00
[2019-09-11 07:05:11.084324 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Authentication is required: &P=gsi,v:10400,c:ssl,ca:e523eeaa.0|1db3b27f.0&P=unix
[2019-09-11 07:05:11.084330 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Sending authentication data
[2019-09-11 07:05:11.085171 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Trying to authenticate using gsi
[2019-09-11 07:05:11.095833 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.095884 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.095921 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: (0xe003a6c0), 136 bytes
[2019-09-11 07:05:11.095926 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.329538 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.329596 +0200][Dump ][XRootDTransport ] [msg: 0xe00009a0] Expecting 3840 bytes of message body
[2019-09-11 07:05:11.329602 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.329610 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received a message of 3848 bytes
[2019-09-11 07:05:11.329618 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Sending more authentication data for gsi
[2019-09-11 07:05:11.331073 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.331127 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.331146 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: (0xe0036150), 9307 bytes
[2019-09-11 07:05:11.331151 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.354227 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.354269 +0200][Dump ][XRootDTransport ] [msg: 0xe003d4d0] Expecting 0 bytes of message body
[2019-09-11 07:05:11.354277 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.354282 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received a message of 8 bytes
[2019-09-11 07:05:11.354348 +0200][Debug ][XRootDTransport ] [golias100.farm.particle.cz:1094 #0.0] Authenticated with gsi.
[2019-09-11 07:05:11.354356 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.354365 +0200][Debug ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Stream 0 connected.
[2019-09-11 07:05:11.354373 +0200][Debug ][Utility ] Monitor library name not set. No monitoring
[2019-09-11 07:05:11.354380 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.354430 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) (0x24a14b0), 90 bytes
[2019-09-11 07:05:11.354437 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Successfully sent message: kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) (0x24a14b0).
[2019-09-11 07:05:11.354449 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Message kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) has been successfully sent.
[2019-09-11 07:05:11.354454 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] Moving MsgHandler: 0x24a6a60 (message: kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) ) from out-queu to in-queue.
[2019-09-11 07:05:11.354472 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0.0] All messages consumed, disable uplink
[2019-09-11 07:05:11.354477 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.358509 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.358555 +0200][Dump ][XRootDTransport ] [msg: 0xe00009a0] Expecting 115 bytes of message body
[2019-09-11 07:05:11.358561 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header for 0xe00009a0 size: 8
[2019-09-11 07:05:11.358578 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message 0xe00009a0 of 123 bytes
[2019-09-11 07:05:11.358586 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Handling received message: 0xe00009a0.
[2019-09-11 07:05:11.358640 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Got a kXR_error response to request kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) [3011] Unable to locate /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787; no such file or directory
[2019-09-11 07:05:11.358656 +0200][Debug ][XRootD ] [golias100.farm.particle.cz:1094] Handling error while processing kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none): [ERROR] Error response: No such file or directory.
[2019-09-11 07:05:11.358673 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] Calling MsgHandler: 0x24a6a60 (message: kXR_stat (path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787, flags: none) ) with status: [ERROR] Error response: No such file or directory.
[2019-09-11 07:05:11.358699 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] Destroying MsgHandler: 0x24a6a60.
[2019-09-11 07:05:11.358731 +0200][Dump ][App ] Processing source entry: /tmp/1M, type local file, target file: root://golias100.farm.particle.cz//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.358839 +0200][Dump ][Utility ] Adding job with properties: 'checkSumMode' = 'none', 'checkSumPreset' = '', 'checkSumType' = '', 'chunkSize' = '16777216', 'coerce' = '0', 'delegate' = '0', 'dynamicSource' = '0', 'force' = '0', 'initTimeout' = '600', 'makeDir' = '0', 'parallelChunks' = '4', 'posc' = '0', 'source' = 'file:///tmp/1M', 'target' = 'root://golias100.farm.particle.cz//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787', 'targetIsDir' = '0', 'thirdParty' = 'none', 'tpcTimeout' = '1800', 'xcp' = '0', 'xcpBlockSize' = '134217728', 'zipArchive' = '0'
[2019-09-11 07:05:11.358866 +0200][Debug ][Utility ] CopyProcess: 2 jobs to prepare
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] URL: file:///tmp/1M
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.358885 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.358903 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] URL: file:///tmp/1M
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.358944 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.358959 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.358968 +0200][Debug ][Utility ] Creating a classic copy job, from file://localhost/tmp/1M to root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.359030 +0200][Debug ][Utility ] Opening file://localhost/tmp/1M for reading
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] URL: file://localhost/tmp/1M
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359046 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] URL: file://localhost/tmp/1M
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359060 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] URL: file://localhost/tmp/1M
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359073 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.359081 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] Sending an open command
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] URL: file://localhost/tmp/1M
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359107 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] URL: file://localhost/tmp/1M
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] Protocol: file
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] Host Name: localhost
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359152 +0200][Dump ][Utility ] Path: /tmp/1M
[2019-09-11 07:05:11.359235 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] Open has returned with status [SUCCESS]
[2019-09-11 07:05:11.359251 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] successfully opened at localhost, handle: 0xe, session id: 1
[2019-09-11 07:05:11.359295 +0200][Debug ][Utility ] Opening root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576 for writing
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359316 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359336 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] URL: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] Host Name: golias100.farm.particle.cz
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] Port: 1094
[2019-09-11 07:05:11.359353 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.359361 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Sending an open command
[2019-09-11 07:05:11.359372 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Sending message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat )
[2019-09-11 07:05:11.359379 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] MsgHandler created: 0x24a9580 (message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) ).
[2019-09-11 07:05:11.359396 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Sending message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90) through substream 0 expecting answer at 0
[2019-09-11 07:05:11.359405 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.359428 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToWrite
[2019-09-11 07:05:11.359468 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Wrote a message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90), 108 bytes
[2019-09-11 07:05:11.359474 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Successfully sent message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90).
[2019-09-11 07:05:11.359485 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) has been successfully sent.
[2019-09-11 07:05:11.359490 +0200][Debug ][ExDbgMsg ] [golias100.farm.particle.cz:1094] Moving MsgHandler: 0x24a9580 (message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) ) from out-queu to in-queue.
[2019-09-11 07:05:11.359496 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0.0] All messages consumed, disable uplink
[2019-09-11 07:05:11.359500 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Disable write notifications
[2019-09-11 07:05:11.570753 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Got an event: ReadyToRead
[2019-09-11 07:05:11.570812 +0200][Dump ][XRootDTransport ] [msg: 0xe0000a50] Expecting 369 bytes of message body
[2019-09-11 07:05:11.570821 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message header for 0xe0000a50 size: 8
[2019-09-11 07:05:11.570831 +0200][Dump ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Received message 0xe0000a50 of 377 bytes
[2019-09-11 07:05:11.570840 +0200][Dump ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Handling received message: 0xe0000a50.
[2019-09-11 07:05:11.570897 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Got kXR_redirect response to message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ): dpmpool1.farm.particle.cz?&dpm.time=1568178311&dpm.dhost=dpmpool1.farm.particle.cz&dpm.put=1&dpm.loc=1&dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.nonce=870b737&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==, port 1095
[2019-09-11 07:05:11.570911 +0200][Dump ][XRootD ] [golias100.farm.particle.cz:1094] Current server has been assigned as a load-balancer for message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat )
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] URL: dpmpool1.farm.particle.cz:1095/
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] Host Name: dpmpool1.farm.particle.cz
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] Port: 1095
[2019-09-11 07:05:11.570935 +0200][Dump ][Utility ] Path:
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] URL: fake://fake:111//fake?&dpm.time=1568178311&dpm.dhost=dpmpool1.farm.particle.cz&dpm.put=1&dpm.loc=1&dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.nonce=870b737&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] Protocol: fake
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] Host Name: fake
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] Port: 111
[2019-09-11 07:05:11.570968 +0200][Dump ][Utility ] Path: /fake
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] URL: fake://fake:111//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] Protocol: fake
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] Host Name: fake
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] Port: 111
[2019-09-11 07:05:11.570999 +0200][Dump ][Utility ] Path: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] URL: dpmpool1.farm.particle.cz:1095
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] Protocol: root
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] User Name:
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] Password:
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] Host Name: dpmpool1.farm.particle.cz
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] Port: 1095
[2019-09-11 07:05:11.571032 +0200][Dump ][Utility ] Path:
[2019-09-11 07:05:11.571044 +0200][Debug ][PostMaster ] Creating new channel to: dpmpool1.farm.particle.cz:1095 1 stream(s)
[2019-09-11 07:05:11.571057 +0200][Debug ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Stream parameters: Network Stack: IPAuto, Connection Window: 120, ConnectionRetry: 5, Stream Error Window: 1800
[2019-09-11 07:05:11.571116 +0200][Debug ][TaskMgr ] Registering task: "TickGeneratorTask for: dpmpool1.farm.particle.cz:1095" to be run at: [2019-09-11 07:05:26 +0200]
[2019-09-11 07:05:11.571126 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Retry at server MsgHandler: 0x24a9580 (message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) ).
[2019-09-11 07:05:11.571140 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Sending message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90) through substream 0 expecting answer at 0
[2019-09-11 07:05:11.572774 +0200][Debug ][PostMaster ] [dpmpool1.farm.particle.cz:1095] Found 2 address(es): [::ffff:147.231.25.51]:1095, [2001:718:401:6017:2::1]:1095
[2019-09-11 07:05:11.572810 +0200][Debug ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Attempting connection to [2001:718:401:6017:2::1]:1095
[2019-09-11 07:05:11.572837 +0200][Debug ][Poller ] Adding socket 0xdc002c70 to the poller
[2019-09-11 07:05:11.572847 +0200][Dump ][Poller ] <--> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.573456 +0200][Dump ][Poller ] <--> Got an event: ReadyToWrite
[2019-09-11 07:05:11.573475 +0200][Debug ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Async connection call returned
[2019-09-11 07:05:11.573489 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Sending out the initial hand shake + kXR_protocol
[2019-09-11 07:05:11.573499 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable read notifications, timeout: 15
[2019-09-11 07:05:11.573509 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:11.573530 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: (0xe0002ac0), 44 bytes
[2019-09-11 07:05:11.573535 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:11.574145 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:11.574162 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 8 bytes of message body
[2019-09-11 07:05:11.574167 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.574174 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received a message of 16 bytes
[2019-09-11 07:05:11.574181 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Got the server hand shake response (type: server [], protocol version 400)
[2019-09-11 07:05:11.574188 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:11.574194 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 8 bytes of message body
[2019-09-11 07:05:11.574198 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.574204 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received a message of 16 bytes
[2019-09-11 07:05:11.574210 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] kXR_protocol successful (type: server [], protocol version 400)
[2019-09-11 07:05:11.574313 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Sending out kXR_login request, username: condor, cgi: ?xrd.cc=cz&xrd.tz=1&xrd.appname=xrdcp&xrd.info=&xrd.hostname=mff82.farm.particle.cz&xrd.rn=v4.9.1, dual-stack: true, private IPv4: true, private IPv6: false
[2019-09-11 07:05:11.574321 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.574334 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:11.574351 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: (0xe0005060), 121 bytes
[2019-09-11 07:05:11.574356 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:11.574938 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:11.574955 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 68 bytes of message body
[2019-09-11 07:05:11.574961 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.574967 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received a message of 76 bytes
[2019-09-11 07:05:11.574974 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Logged in, session: 6d040000525b00002f00000080040000
[2019-09-11 07:05:11.574979 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Authentication is required: &P=gsi,v:10400,c:ssl,ca:e523eeaa.0|1db3b27f.0&P=unix
[2019-09-11 07:05:11.574984 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Sending authentication data
[2019-09-11 07:05:11.575010 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Trying to authenticate using gsi
[2019-09-11 07:05:11.590735 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.590781 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:11.590818 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: (0xe002ef20), 136 bytes
[2019-09-11 07:05:11.590824 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:11.681328 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:11.681369 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 3856 bytes of message body
[2019-09-11 07:05:11.681375 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header, size: 8
[2019-09-11 07:05:11.681384 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received a message of 3864 bytes
[2019-09-11 07:05:11.681399 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Sending more authentication data for gsi
[2019-09-11 07:05:11.682596 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:11.682620 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:11.682650 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: (0xe0005080), 9307 bytes
[2019-09-11 07:05:11.682655 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:12.313320 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:12.313372 +0200][Dump ][XRootDTransport ] [msg: 0xe00306e0] Expecting 0 bytes of message body
[2019-09-11 07:05:12.313379 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header, size: 8
[2019-09-11 07:05:12.313385 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received a message of 8 bytes
[2019-09-11 07:05:12.313454 +0200][Debug ][XRootDTransport ] [dpmpool1.farm.particle.cz:1095 #0.0] Authenticated with gsi.
[2019-09-11 07:05:12.313463 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:12.313472 +0200][Debug ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Stream 0 connected.
[2019-09-11 07:05:12.313480 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:12.313513 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90), 447 bytes
[2019-09-11 07:05:12.313521 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Successfully sent message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) (0x24a8d90).
[2019-09-11 07:05:12.313528 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Message kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) has been successfully sent.
[2019-09-11 07:05:12.313535 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Moving MsgHandler: 0x24a9580 (message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) ) from out-queu to in-queue.
[2019-09-11 07:05:12.313542 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0.0] All messages consumed, disable uplink
[2019-09-11 07:05:12.313547 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:12.314763 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:12.314794 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 49 bytes of message body
[2019-09-11 07:05:12.314801 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header for 0xe0002ac0 size: 8
[2019-09-11 07:05:12.314811 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message 0xe0002ac0 of 57 bytes
[2019-09-11 07:05:12.314825 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Handling received message: 0xe0002ac0.
[2019-09-11 07:05:12.314853 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Got a kXR_ok response to request kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat )
[2019-09-11 07:05:12.314865 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Calling MsgHandler: 0x24a9580 (message: kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) ) with status: [SUCCESS] .
[2019-09-11 07:05:12.314877 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Parsing the response to kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat ) as OpenInfo
[2019-09-11 07:05:12.314884 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Parsing StatInfo in response to kXR_open (file: /dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?dpm.chunk0=0,0,dpmpool1.farm.particle.cz:/mnt/fs1/atlas/2019-09-11/1M.xrdcp.20190911070503.057846787.143302.1568178311%3fsfn=%252Fdpm%252Ffarm.particle.cz%252Fhome%252Fatlas%252F1M.xrdcp.20190911070503.057846787&dpm.dhost=dpmpool1.farm.particle.cz&dpm.hv2=NBoSW+W5T7Eti/8yeLbu0w==&dpm.loc=1&dpm.nonce=870b737&dpm.put=1&dpm.time=1568178311&oss.asize=1048576, mode: 0644, flags: kXR_new kXR_open_updt kXR_async kXR_retstat )
[2019-09-11 07:05:12.314920 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Open has returned with status [SUCCESS]
[2019-09-11 07:05:12.314927 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] successfully opened at dpmpool1.farm.particle.cz:1095, handle: 0x0, session id: 1
[2019-09-11 07:05:12.314948 +0200][Debug ][XRootD ] Redirect trace-back:
[2019-09-11 07:05:12.314948 +0200][Debug ][XRootD ] 0. Redirected from: root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787 to: root://dpmpool1.farm.particle.cz:1095/
[2019-09-11 07:05:12.314956 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Destroying MsgHandler: 0x24a9580.
[2019-09-11 07:05:12.314987 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] Sending a read command for handle 0xe to localhost
[2019-09-11 07:05:12.316416 +0200][Dump ][File ] [0x24a87e0@file://localhost/tmp/1M] Got state response for message kXR_read (handle: 0x0e000000, offset: 0, size: 1048576)
[2019-09-11 07:05:12.318422 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Sending a write command for handle 0x0 to dpmpool1.farm.particle.cz:1095
[2019-09-11 07:05:12.318465 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Sending message kXR_write (handle: 0x00000000, offset: 0, size: 1048576)
[2019-09-11 07:05:12.318477 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] MsgHandler created: 0x24aaad0 (message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) ).
[2019-09-11 07:05:12.318488 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Sending message kXR_write (handle: 0x00000000, offset: 0, size: 1048576) (0x24a94c0) through substream 0 expecting answer at 0
[2019-09-11 07:05:12.318495 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:12.318521 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:12.318547 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Will write the payload in one go with the header for message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) (0x24a94c0).
[2019-09-11 07:05:18.067555 +0200][Dump ][TaskMgr ] Running task: "TickGeneratorTask for: golias100.farm.particle.cz:1094"
[2019-09-11 07:05:18.067615 +0200][Dump ][TaskMgr ] Will rerun task "TickGeneratorTask for: golias100.farm.particle.cz:1094" at [2019-09-11 07:05:33 +0200]
[2019-09-11 07:05:18.200499 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:18.200545 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Will write the payload in one go with the header for message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) (0x24a94c0).
[2019-09-11 07:05:18.200559 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] WroteV a message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) (0x24a94c0), 24 bytes
[2019-09-11 07:05:18.200564 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] WroteV raw data: 6160 bytes
[2019-09-11 07:05:18.200570 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Successfully sent message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) (0x24a94c0).
[2019-09-11 07:05:18.200577 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Message kXR_write (handle: 0x00000000, offset: 0, size: 1048576) has been successfully sent.
[2019-09-11 07:05:18.200582 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Moving MsgHandler: 0x24aaad0 (message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) ) from out-queu to in-queue.
[2019-09-11 07:05:18.200590 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0.0] All messages consumed, disable uplink
[2019-09-11 07:05:18.200596 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:19.067696 +0200][Dump ][TaskMgr ] Running task: "FileTimer task"
[2019-09-11 07:05:19.067757 +0200][Dump ][TaskMgr ] Will rerun task "FileTimer task" at [2019-09-11 07:05:34 +0200]
[2019-09-11 07:05:20.314622 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:20.314672 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 0 bytes of message body
[2019-09-11 07:05:20.314678 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header for 0xe0002ac0 size: 8
[2019-09-11 07:05:20.314686 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message 0xe0002ac0 of 8 bytes
[2019-09-11 07:05:20.314702 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Handling received message: 0xe0002ac0.
[2019-09-11 07:05:20.314737 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Got a kXR_ok response to request kXR_write (handle: 0x00000000, offset: 0, size: 1048576)
[2019-09-11 07:05:20.314766 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Calling MsgHandler: 0x24aaad0 (message: kXR_write (handle: 0x00000000, offset: 0, size: 1048576) ) with status: [SUCCESS] .
[2019-09-11 07:05:20.314775 +0200][Dump ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Got state response for message kXR_write (handle: 0x00000000, offset: 0, size: 1048576)
[2019-09-11 07:05:20.314791 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Destroying MsgHandler: 0x24aaad0.
[2019-09-11 07:05:20.314944 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Sending a close command for handle 0x0 to dpmpool1.farm.particle.cz:1095
[2019-09-11 07:05:20.314959 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Sending message kXR_close (handle: 0x00000000)
[2019-09-11 07:05:20.314967 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] MsgHandler created: 0x24a9580 (message: kXR_close (handle: 0x00000000) ).
[2019-09-11 07:05:20.314975 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Sending message kXR_close (handle: 0x00000000) (0x24a6c00) through substream 0 expecting answer at 0
[2019-09-11 07:05:20.314981 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Enable write notifications, timeout: 15
[2019-09-11 07:05:20.315000 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToWrite
[2019-09-11 07:05:20.315018 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Wrote a message: kXR_close (handle: 0x00000000) (0x24a6c00), 24 bytes
[2019-09-11 07:05:20.315024 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Successfully sent message: kXR_close (handle: 0x00000000) (0x24a6c00).
[2019-09-11 07:05:20.315030 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Message kXR_close (handle: 0x00000000) has been successfully sent.
[2019-09-11 07:05:20.315035 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Moving MsgHandler: 0x24a9580 (message: kXR_close (handle: 0x00000000) ) from out-queu to in-queue.
[2019-09-11 07:05:20.315041 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0.0] All messages consumed, disable uplink
[2019-09-11 07:05:20.315046 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Disable write notifications
[2019-09-11 07:05:20.334290 +0200][Dump ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Got an event: ReadyToRead
[2019-09-11 07:05:20.334339 +0200][Dump ][XRootDTransport ] [msg: 0xe0002ac0] Expecting 0 bytes of message body
[2019-09-11 07:05:20.334345 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message header for 0xe0002ac0 size: 8
[2019-09-11 07:05:20.334353 +0200][Dump ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Received message 0xe0002ac0 of 8 bytes
[2019-09-11 07:05:20.334360 +0200][Dump ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Handling received message: 0xe0002ac0.
[2019-09-11 07:05:20.334385 +0200][Dump ][XRootD ] [dpmpool1.farm.particle.cz:1095] Got a kXR_ok response to request kXR_close (handle: 0x00000000)
[2019-09-11 07:05:20.334400 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Calling MsgHandler: 0x24a9580 (message: kXR_close (handle: 0x00000000) ) with status: [SUCCESS] .
[2019-09-11 07:05:20.334426 +0200][Debug ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Close returned from dpmpool1.farm.particle.cz:1095 with: [SUCCESS]
[2019-09-11 07:05:20.334432 +0200][Dump ][File ] [0x24a8bd0@root://golias100.farm.particle.cz:1094//dpm/farm.particle.cz/home/atlas/1M.xrdcp.20190911070503.057846787?oss.asize=1048576] Items in the fly 0, queued for recovery 0
[2019-09-11 07:05:20.334448 +0200][Debug ][ExDbgMsg ] [dpmpool1.farm.particle.cz:1095] Destroying MsgHandler: 0x24a9580.
[2019-09-11 07:05:20.334486 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] Sending a close command for handle 0xe to localhost
[2019-09-11 07:05:20.334552 +0200][Debug ][File ] [0x24a87e0@file://localhost/tmp/1M] Close returned from localhost with: [SUCCESS]
[2019-09-11 07:05:20.334569 +0200][Dump ][File ] [0x24a87e0@file://localhost/tmp/1M] Items in the fly 0, queued for recovery 0
[2019-09-11 07:05:20.334718 +0200][Debug ][JobMgr ] Stopping the job manager...
[2019-09-11 07:05:20.334727 +0200][Dump ][JobMgr ] Stopping worker #0...
[2019-09-11 07:05:20.334856 +0200][Dump ][JobMgr ] Worker #0 stopped
[2019-09-11 07:05:20.334864 +0200][Dump ][JobMgr ] Stopping worker #1...
[2019-09-11 07:05:20.334913 +0200][Dump ][JobMgr ] Worker #1 stopped
[2019-09-11 07:05:20.334919 +0200][Dump ][JobMgr ] Stopping worker #2...
[2019-09-11 07:05:20.334958 +0200][Dump ][JobMgr ] Worker #2 stopped
[2019-09-11 07:05:20.334964 +0200][Debug ][JobMgr ] Job manager stopped
[2019-09-11 07:05:20.334969 +0200][Debug ][TaskMgr ] Stopping the task manager...
[2019-09-11 07:05:20.335037 +0200][Debug ][TaskMgr ] Task manager stopped
[2019-09-11 07:05:20.335044 +0200][Debug ][Poller ] Stopping the poller...
[2019-09-11 07:05:20.335103 +0200][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: dpmpool1.farm.particle.cz:1095"
[2019-09-11 07:05:20.335114 +0200][Debug ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Closing the socket
[2019-09-11 07:05:20.335123 +0200][Debug ][Poller ] <[2001:718:401:6e03::1:82]:49714><--><[2001:718:401:6017:2::1]:1095> Removing socket from the poller
[2019-09-11 07:05:20.335156 +0200][Debug ][PostMaster ] [dpmpool1.farm.particle.cz:1095 #0] Destroying stream
[2019-09-11 07:05:20.335166 +0200][Debug ][AsyncSock ] [dpmpool1.farm.particle.cz:1095 #0.0] Closing the socket
[2019-09-11 07:05:20.335177 +0200][Debug ][TaskMgr ] Requesting unregistration of: "TickGeneratorTask for: golias100.farm.particle.cz:1094"
[2019-09-11 07:05:20.335182 +0200][Debug ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Closing the socket
[2019-09-11 07:05:20.335186 +0200][Debug ][Poller ] <[2001:718:401:6e03::1:82]:36138><--><[2001:718:401:6017:2::1000]:1094> Removing socket from the poller
[2019-09-11 07:05:20.335199 +0200][Debug ][PostMaster ] [golias100.farm.particle.cz:1094 #0] Destroying stream
[2019-09-11 07:05:20.335205 +0200][Debug ][AsyncSock ] [golias100.farm.particle.cz:1094 #0.0] Closing the socket
########################################################################
Use REPLY-ALL to reply to list
To unsubscribe from the XROOTD-L list, click the following link:
https://listserv.slac.stanford.edu/cgi-bin/wa?SUBED1=XROOTD-L&A=1