Eos CP - socket error?

Hi,

Not sure what’s happening here:

[root@tpm03 ~]# eos cp /root/stagetape /eos/users/test/
[eoscp] stagetape                Total 0.00 MB	|====================| 100.00 % [0.0 MB/s]
error: [SUCCESS]
error: failed copying path=root://localhost//eos/users/test/stagetape
#WARNING [eos-cp] copied 0/1 files and 0 B in 0.04 seconds with 0 B/s

the file was erroneously copied ‘successfully’ . Doing an eos ls -y shows the file as 0 sized:

[root@tpm03 ~]# eos ls -y /eos/users/test
d0::t0   -rw-r-----   0 root     root                0 Sep 24 14:35 stagetape
d0::t0   -rw-r-----   0 root     root                0 Sep 24 14:32 test-osm-perf2

I don’t see anything indicating an error on the logs…what gives?

Dump when running w/ XRD_LOGLEVEL=Dump:


[2021-09-24 15:30:23.159765 +0200][Dump   ][AsyncSock         ] [tpm03.d.de:1095 #0.0] Wrote a message: kXR_close (handle: 0x00000000) (0x1d09330), 24 bytes
[2021-09-24 15:30:23.159773 +0200][Dump   ][AsyncSock         ] [tpm03.d.de:1095 #0.0] Successfully sent message: kXR_close (handle: 0x00000000) (0x1d09330).
[2021-09-24 15:30:23.159778 +0200][Dump   ][XRootD            ] [tpm03.d.de:1095] Message kXR_close (handle: 0x00000000) has been successfully sent.
[2021-09-24 15:30:23.159782 +0200][Debug  ][ExDbgMsg          ] [tpm03.d.de:1095] Moving MsgHandler: 0x1d1ee40 (message: kXR_close (handle: 0x00000000) ) from out-queu to in-queue.
[2021-09-24 15:30:23.159787 +0200][Dump   ][PostMaster        ] [tpm03.d.de:1095 #0.0] All messages consumed, disable uplink
[2021-09-24 15:30:23.169777 +0200][Error  ][AsyncSock         ] [tpm03.d.de:1095 #0.0] Socket error encountered: [ERROR] Socket error
[2021-09-24 15:30:23.169789 +0200][Debug  ][AsyncSock         ] [tpm03.d.de:1095 #0.0] Closing the socket
[2021-09-24 15:30:23.169796 +0200][Debug  ][Poller            ] <[::ffff:131.169.80.133]:38870><--><[::ffff:131.169.80.133]:1095> Removing socket from the poller
[2021-09-24 15:30:23.169834 +0200][Debug  ][PostMaster        ] [tpm03.d.de:1095 #0] Recovering error for stream #0: [ERROR] Socket error.
[2021-09-24 15:30:23.169840 +0200][Debug  ][PostMaster        ] [tpm03.d.de:1095 #0] Reporting disconnection to queued message handlers.
[2021-09-24 15:30:23.169847 +0200][Dump   ][XRootD            ] [tpm03.d.de:1095] Stream event reported for msg kXR_close (handle: 0x00000000)
[2021-09-24 15:30:23.169852 +0200][Debug  ][XRootD            ] [tpm03.d.de:1095] Handling error while processing kXR_close (handle: 0x00000000): [ERROR] Socket error.
[2021-09-24 15:30:23.169856 +0200][Error  ][XRootD            ] [tpm03.d.de:1095] Unable to get the response to request kXR_close (handle: 0x00000000)
[2021-09-24 15:30:23.169862 +0200][Debug  ][ExDbgMsg          ] [tpm03.d.de:1095] Passing to the thread-pool MsgHandler: 0x1d1ee40 (message: kXR_close (handle: 0x00000000) ).
[2021-09-24 15:30:23.169888 +0200][Debug  ][ExDbgMsg          ] [tpm03.d.de:1095] Calling MsgHandler: 0x1d1ee40 (message: kXR_close (handle: 0x00000000) ) with status: [ERROR] Socket error.
[2021-09-24 15:30:23.169917 +0200][Debug  ][File              ] [0x1d137b0@root://localhost:1094//eos/users/test/stagetape?eos.app=eoscp&eos.bookingsize=694&eos.rgid=0&eos.ruid=0&eos.targetsize=694&fst.valid=1632490282&xrdcl.requuid=42f79beb-bd6c-4115-ab62-3e39721493f9] Close returned from tpm03.d.de:1095 with: [ERROR] Socket error

thanks,
mwai