We set up 4 xrootd servers (version 3.2.6), and are having a trouble to write files via redirectors.
Below is the full log (debug level 2) of writing test from a local machine, and it ends up with 'Unable to access file; file does not exist.', while direct write attempt succeeds (via port 1095).
In the middle of the log, I see 'Unable to access file; file does not exist.(error code: 3011)'.. but no idea why this happen.
Strange thing is.. if there's an existing file with a same name, then file copy via redirector also succeeds.. See below trials.
WooJin.
----------------------------------------------------------------------------------
[null-7c6d628f4797:~] madpark% xrdcp -f -d 2 test
root://f01-081-126-e.gridka.de:1094//testSet debug level 2
130416 13:27:18 771 Xrd: main: (C) 2004-2011 by the XRootD collaboration. Version: v3.2.6
130416 13:27:18 771 Xrd: Create: (C) 2004-2010 by the Xrootd group. XrdClient $Revision$ - Xrootd version: v3.2.6
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
130416 13:27:18 771 Xrd: XrdClientUrlSet: parsing:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: XrdClientUrlSet: protocol: root
130416 13:27:18 771 Xrd: XrdClientUrlSet: file: /test?oss.asize=631
130416 13:27:18 771 Xrd: XrdClientUrlSet: list of [host:port] :
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: Remote file to open is '/test?oss.asize=631'
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: CheckPort: specified port (1094) potentially valid.
130416 13:27:18 771 Xrd: ConvertDNSAlias: found host
f01-081-126-e.gridka.de with addr 192.108.47.162
130416 13:27:18 771 Xrd: ShowUrls: The converted URLs count is 1
130416 13:27:18 771 Xrd: ShowUrls: URL n.1:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631.
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: Proto: root
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /test?oss.asize=631
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: parsing:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: XrdClientUrlSet: protocol: root
130416 13:27:18 771 Xrd: XrdClientUrlSet: file: /test?oss.asize=631
130416 13:27:18 771 Xrd: XrdClientUrlSet: list of [host:port] :
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: Remote file to open is '/test?oss.asize=631'
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: CheckPort: specified port (1094) potentially valid.
130416 13:27:18 771 Xrd: ConvertDNSAlias: found host
f01-081-126-e.gridka.de with addr 192.108.47.162
130416 13:27:18 771 Xrd: ShowUrls: The converted URLs count is 1
130416 13:27:18 771 Xrd: ShowUrls: URL n.1:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631.
130416 13:27:18 771 Xrd: CheckHostDomain: Resolved [
f01-081-126-e.gridka.de]'s domain name into [
gridka.de]
130416 13:27:18 771 Xrd: DomainMatcher: search for '
gridka.de' in ''
130416 13:27:18 771 Xrd: DomainMatcher: no domain matching '
gridka.de' found in ''
130416 13:27:18 771 Xrd: DomainMatcher: search for '
gridka.de' in '*'
130416 13:27:18 771 Xrd: DomainMatcher: domain: * matches '
gridka.de' (matching chars: 1)
130416 13:27:18 771 Xrd: CheckHostDomain: Access granted to the domain of [
f01-081-126-e.gridka.de].
130416 13:27:18 771 Xrd: Open: Trying to connect to
f01-081-126-e.gridka.de:1094. Connect try 1
130416 13:27:18 771 Xrd: XrdClientConn: Trying to connect to 192.108.47.162:1094
130416 13:27:18 771 Xrd: Connect: Creating a logical connection...
130416 13:27:18 771 Xrd: Connect: Physical connection not found. Creating a new one...
130416 13:27:18 771 Xrd: Connect: Connecting to [
f01-081-126-e.gridka.de:1094]
130416 13:27:18 771 Xrd: ClientSock::TryConnect_low: Trying to connect to
f01-081-126-e.gridka.de(192.108.47.162):1094 Windowsize=0 Timeout=120
130416 13:27:18 771 Xrd: Connect: Connected to [
f01-081-126-e.gridka.de:1094]
130416 13:27:18 771 Xrd: Connect: New physical connection to server
f01-081-126-e.gridka.de:1094 succesfully created.
130416 13:27:18 771 Xrd: Connect: LogConn: size:1 count: 1PhyConn: size:1
130416 13:27:18 771 Xrd: Connect: Connect(
f01-081-126-e.gridka.de, 1094) returned 0
130416 13:27:18 771 Xrd: Open: The logical connection id is 0.
130416 13:27:18 771 Xrd: Open: Working url is
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: DoHandShake: HandShake step 1: Sending handshake with a piggy-backed protocol request
130416 13:27:18 771 Xrd: DoHandShake: HandShake step 2: Reading 4 bytes.
130416 13:27:18 771 Xrd: DoHandShake: HandShake step 3: Reading 12 bytes.
130416 13:27:18 771 Xrd: DoHandShake: Server protocol: 663 type: 0
130416 13:27:18 771 Xrd: DoHandShake: Server protocol (kXR_protocol): 663 flags: 2
130416 13:27:18 771 Xrd: DoHandShake: Setting Load Balancer Server Url =
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: parsing url:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: Proto: root
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /test?oss.asize=631
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: GetAccessToSrv: Ok: the server on [
f01-081-126-e.gridka.de:1094] is an xrootd redirector.
130416 13:27:18 771 Xrd: StartReader: Starting reader thread...
130416 13:27:18 6147 Xrd: SocketReaderThread: Reader Thread starting.
130416 13:27:18 771 Xrd: DoLogin: Logging into the server [
f01-081-126-e.gridka.de:1094]. pid=17839 uid=madpark
130416 13:27:18 771 Xrd: SendGenCommand: Sending command XrdClientConn::DoLogin
130416 13:27:18 771 Xrd: ReadPartialAnswer: Reading a XrdClientMessage from the server [
f01-081-126-e.gridka.de:1094]...
130416 13:27:18 771 Xrd: DoLogin: Got session ID: ffffffd86701007315000014000000ffffffdf670100
130416 13:27:18 771 Xrd: DoLogin: No prev session info for 192.108.47.162:1094.
130416 13:27:18 771 Xrd: Open: Access to server granted.
130416 13:27:18 771 Xrd: Open: Opening the remote file /test?oss.asize=631
130416 13:27:18 771 Xrd: SendGenCommand: Sending command Open
130416 13:27:18 771 Xrd: ReadPartialAnswer: Reading a XrdClientMessage from the server [
f01-081-126-e.gridka.de:1094]...
130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [
f01-081-126-e.gridka.de:1094] answered [kXR_error] (4003)
130416 13:27:18 771 Xrd: CheckErrorStatus: Server [
f01-081-126-e.gridka.de:1094] declared: Unable to access file; file does not exist.(error code: 3011)
130416 13:27:18 771 Xrd: Open: Error opening the file /test?oss.asize=631 on host
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
130416 13:27:18 771 Xrd: XrdClientUrlSet: parsing:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: XrdClientUrlSet: protocol: root
130416 13:27:18 771 Xrd: XrdClientUrlSet: file: /test?oss.asize=631
130416 13:27:18 771 Xrd: XrdClientUrlSet: list of [host:port] :
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: Remote file to open is '/test?oss.asize=631'
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: CheckPort: specified port (1094) potentially valid.
130416 13:27:18 771 Xrd: ConvertDNSAlias: found host
f01-081-126-e.gridka.de with addr 192.108.47.162
130416 13:27:18 771 Xrd: ShowUrls: The converted URLs count is 1
130416 13:27:18 771 Xrd: ShowUrls: URL n.1:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631.
130416 13:27:18 771 Xrd: XrdClientUrlSet: parsing:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: XrdClientUrlSet: protocol: root
130416 13:27:18 771 Xrd: XrdClientUrlSet: file: /test?oss.asize=631
130416 13:27:18 771 Xrd: XrdClientUrlSet: list of [host:port] :
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: Remote file to open is '/test?oss.asize=631'
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: CheckPort: specified port (1094) potentially valid.
130416 13:27:18 771 Xrd: ConvertDNSAlias: found host
f01-081-126-e.gridka.de with addr 192.108.47.162
130416 13:27:18 771 Xrd: ShowUrls: The converted URLs count is 1
130416 13:27:18 771 Xrd: ShowUrls: URL n.1:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631.
130416 13:27:18 771 Xrd: Connect: Trying to connect to
f01-081-126-e.gridka.de:1094. Connect try 1
130416 13:27:18 771 Xrd: XrdClientConn: Trying to connect to 192.108.47.162:1094
130416 13:27:18 771 Xrd: Connect: Creating a logical connection...
130416 13:27:18 771 Xrd: Connect: LogConn: size:2 count: 2PhyConn: size:1
130416 13:27:18 771 Xrd: Connect: Connect(
f01-081-126-e.gridka.de, 1094) returned 1
130416 13:27:18 771 Xrd: Connect: The logical connection id is 1. This will be the streamid for this client
130416 13:27:18 771 Xrd: Connect: Working url is
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: DoHandShake: Setting Load Balancer Server Url =
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: parsing url:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: Proto: root
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /test?oss.asize=631
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: GetAccessToSrv: Ok: the server on [
f01-081-126-e.gridka.de:1094] is an xrootd redirector.
130416 13:27:18 771 Xrd: GetAccessToSrv: Reusing physical connection to server [
f01-081-126-e.gridka.de:1094]).
130416 13:27:18 771 Xrd: Connect: Access to server granted.
130416 13:27:18 771 Xrd: Connect: Connected.
130416 13:27:18 771 Xrd: SendGenCommand: Sending command Rm
130416 13:27:18 771 Xrd: ReadPartialAnswer: Reading a XrdClientMessage from the server [
f01-081-126-e.gridka.de:1094]...
130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [
f01-081-126-e.gridka.de:1094] answered [kXR_error] (4003)
130416 13:27:18 771 Xrd: CheckErrorStatus: Server [
f01-081-126-e.gridka.de:1094] declared: Unable to access file; file does not exist.(error code: 3011)
130416 13:27:18 771 Xrd: XrdClientUrlSet: parsing:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: XrdClientUrlSet: protocol: root
130416 13:27:18 771 Xrd: XrdClientUrlSet: file: /test?oss.asize=631
130416 13:27:18 771 Xrd: XrdClientUrlSet: list of [host:port] :
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: XrdClientUrlSet: Remote file to open is '/test?oss.asize=631'
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: CheckPort: specified port (1094) potentially valid.
130416 13:27:18 771 Xrd: ConvertDNSAlias: found host
f01-081-126-e.gridka.de with addr 192.108.47.162
130416 13:27:18 771 Xrd: ShowUrls: The converted URLs count is 1
130416 13:27:18 771 Xrd: ShowUrls: URL n.1:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631.
130416 13:27:18 771 Xrd: TakeUrl: parsing url:
root://f01-081-126-e.gridka.de:1094//test?oss.asize=631130416 13:27:18 771 Xrd: TakeUrl: Proto: root
130416 13:27:18 771 Xrd: TakeUrl: HostWPort:
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: TakeUrl: File: /test?oss.asize=631
130416 13:27:18 771 Xrd: TakeUrl: Host:
f01-081-126-e.gridka.de130416 13:27:18 771 Xrd: TakeUrl: Port: 1094
130416 13:27:18 771 Xrd: Open: Opening the remote file /test?oss.asize=631
130416 13:27:18 771 Xrd: SendGenCommand: Sending command Open
130416 13:27:18 771 Xrd: ReadPartialAnswer: Reading a XrdClientMessage from the server [
f01-081-126-e.gridka.de:1094]...
130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [
f01-081-126-e.gridka.de:1094] answered [kXR_error] (4003)
130416 13:27:18 771 Xrd: CheckErrorStatus: Server [
f01-081-126-e.gridka.de:1094] declared: Unable to access file; file does not exist.(error code: 3011)
130416 13:27:18 771 Xrd: Open: Error opening the file /test?oss.asize=631 on host
f01-081-126-e.gridka.de:1094
130416 13:27:18 771 Xrd: Disconnect: LogConnID: 1 destroyed
Last server error 3011 ('Unable to access file; file does not exist.')
130416 13:27:18 771 Xrd: Disconnect: LogConnID: 0 destroyed
Low level caching info:
StallsRate=0
StallsCount=0
ReadsCounter=0
BytesUsefulness=0
BytesSubmitted=0 BytesHit=0
XrdClient counters:
ReadBytes: 0
WrittenBytes: 0
WriteRequests: 0
ReadRequests: 0
ReadMisses: 0
ReadHits: 0
ReadMissRate: 0.000000
ReadVRequests: 0
ReadVSubRequests: 0
ReadVSubChunks: 0
ReadVBytes: 0
ReadVAsyncRequests: 0
ReadVAsyncSubRequests: 0
ReadVAsyncSubChunks: 0
ReadVAsyncBytes: 0
ReadAsyncRequests: 0
ReadAsyncBytes: 0
Error accessing path/file for
root://f01-081-126-e.gridka.de:1094//test[null-7c6d628f4797:~] madpark%