Dear experts, 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. Can somebody give me an advise? Best regards, WooJin. ----------------- [null-7c6d628f4797:~] madpark% xrdcp -f test root://f01-081-126-e.gridka.de:1094//test_file => write file via redirector failed Last server error 3011 ('Unable to access file; file does not exist.') Error accessing path/file for root://f01-081-126-e.gridka.de:1094//test_file [null-7c6d628f4797:~] madpark% xrdcp -f test root://f01-081-126-e.gridka.de:1095//test_file => direct copy to the server succeeds [xrootd] Total 0.00 MB |====================| 100.00 % [inf MB/s] [null-7c6d628f4797:~] madpark% xrdcp -f test root://f01-081-126-e.gridka.de:1094//test_file => try again via redirector, and it succeeds (because 'test_file' is now already in the server) [xrootd] Total 0.00 MB |====================| 100.00 % [inf MB/s] [null-7c6d628f4797:~] madpark% ------------------ * error log with a debug level 2: ---------------------------------------------------------------------------------- [null-7c6d628f4797:~] madpark% xrdcp -f -d 2 test root://f01-081-126-e.gridka.de:1094//test Set 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=631 130416 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<http://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<http://f01-081-126-e.gridka.de>:1094 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 13:27:18 771 Xrd: TakeUrl: Port: 1094 130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving f01-081-126-e.gridka.de<http://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<http://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=631 130416 13:27:18 771 Xrd: TakeUrl: Proto: root 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 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=631 130416 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<http://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<http://f01-081-126-e.gridka.de>:1094 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 13:27:18 771 Xrd: TakeUrl: Port: 1094 130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving f01-081-126-e.gridka.de<http://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<http://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<http://f01-081-126-e.gridka.de>]'s domain name into [gridka.de<http://gridka.de>] 130416 13:27:18 771 Xrd: DomainMatcher: search for 'gridka.de<http://gridka.de>' in '' 130416 13:27:18 771 Xrd: DomainMatcher: no domain matching 'gridka.de<http://gridka.de>' found in '' 130416 13:27:18 771 Xrd: DomainMatcher: search for 'gridka.de<http://gridka.de>' in '*' 130416 13:27:18 771 Xrd: DomainMatcher: domain: * matches 'gridka.de<http://gridka.de>' (matching chars: 1) 130416 13:27:18 771 Xrd: CheckHostDomain: Access granted to the domain of [f01-081-126-e.gridka.de<http://f01-081-126-e.gridka.de>]. 130416 13:27:18 771 Xrd: Open: Trying to connect to f01-081-126-e.gridka.de<http://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<http://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<http://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<http://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<http://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<http://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=631 130416 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=631 130416 13:27:18 771 Xrd: TakeUrl: parsing url: root://f01-081-126-e.gridka.de:1094//test?oss.asize=631 130416 13:27:18 771 Xrd: TakeUrl: Proto: root 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 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<http://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<http://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<http://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<http://f01-081-126-e.gridka.de>:1094]... 130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [f01-081-126-e.gridka.de<http://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<http://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<http://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=631 130416 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<http://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<http://f01-081-126-e.gridka.de>:1094 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 13:27:18 771 Xrd: TakeUrl: Port: 1094 130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving f01-081-126-e.gridka.de<http://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<http://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=631 130416 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<http://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<http://f01-081-126-e.gridka.de>:1094 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 13:27:18 771 Xrd: TakeUrl: Port: 1094 130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving f01-081-126-e.gridka.de<http://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<http://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<http://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<http://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=631 130416 13:27:18 771 Xrd: DoHandShake: Setting Load Balancer Server Url = 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=631 130416 13:27:18 771 Xrd: TakeUrl: Proto: root 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 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<http://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<http://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<http://f01-081-126-e.gridka.de>:1094]... 130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [f01-081-126-e.gridka.de<http://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<http://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=631 130416 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<http://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<http://f01-081-126-e.gridka.de>:1094 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 13:27:18 771 Xrd: TakeUrl: Port: 1094 130416 13:27:18 771 Xrd: ConvertDNSAlias: resolving f01-081-126-e.gridka.de<http://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<http://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=631 130416 13:27:18 771 Xrd: TakeUrl: Proto: root 130416 13:27:18 771 Xrd: TakeUrl: HostWPort: f01-081-126-e.gridka.de<http://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.de<http://f01-081-126-e.gridka.de> 130416 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<http://f01-081-126-e.gridka.de>:1094]... 130416 13:27:18 771 Xrd: ReadPartialAnswer: Server [f01-081-126-e.gridka.de<http://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<http://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<http://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% ######################################################################## 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