2007-09-10 15:43:41,257 DEBUG Loader Recompilation suppressed. 2007-09-10 15:43:41,912 DEBUG ServiceContactImpl Host from contact: localhost 2007-09-10 15:43:41,912 DEBUG ServiceContactImpl Host from contact: localhost 2007-09-10 15:43:42,374 INFO unknown Using sites file: swift.conf/sites.xml 2007-09-10 15:43:42,374 INFO unknown Using tc.data: swift.conf/tc.data 2007-09-10 15:43:42,460 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider local 2007-09-10 15:43:42,464 DEBUG AbstractionClassLoader Using system class loader for provider local 2007-09-10 15:43:42,471 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gsiftp 2007-09-10 15:43:42,471 DEBUG AbstractionClassLoader Using system class loader for provider gsiftp 2007-09-10 15:43:42,477 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gt2 2007-09-10 15:43:42,477 DEBUG AbstractionClassLoader Using system class loader for provider gt2 2007-09-10 15:43:43,277 DEBUG FileResourceCache Got request for resource for localhost(file) 2007-09-10 15:43:43,278 DEBUG FileResourceCache Instantiating new resource for localhost(file) 2007-09-10 15:43:43,278 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider file 2007-09-10 15:43:43,278 DEBUG AbstractionClassLoader Using system class loader for provider file 2007-09-10 15:43:43,278 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.local.FileResourceImpl for provider file 2007-09-10 15:43:43,289 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:43:43,289 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:43:43,294 DEBUG FileResourceCache Got request for resource for localhost(file) 2007-09-10 15:43:43,295 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:43:43,295 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:43:43,295 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:43:43,429 DEBUG GetFieldValue GetFieldValue(true) 2007-09-10 15:43:43,513 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:43,513 DEBUG FileResourceCache Instantiating new resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:43,514 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl for provider gsiftp 2007-09-10 15:43:43,528 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gridftp 2007-09-10 15:43:43,528 DEBUG AbstractionClassLoader Using system class loader for provider gridftp 2007-09-10 15:43:43,528 DEBUG ServiceContactImpl Host from URI: cmsgrid01.hep.wisc.edu 2007-09-10 15:43:43,529 DEBUG ServiceContactImpl Port from URI: -1 2007-09-10 15:43:45,465 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021922) setting status to Active 2007-09-10 15:43:45,466 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/shared) 2007-09-10 15:43:45,487 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0) 2007-09-10 15:43:45,508 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie) 2007-09-10 15:43:45,548 DEBUG FileResourceImpl createDirectory(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0) 2007-09-10 15:43:45,573 DEBUG FileResourceImpl createDirectory(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/shared) 2007-09-10 15:43:45,595 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:45,595 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:45,595 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021922) setting status to Completed 2007-09-10 15:43:45,612 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021925) setting status to Submitted 2007-09-10 15:43:45,612 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021925) setting status to Active 2007-09-10 15:43:45,613 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:43:45,613 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:45,613 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:45,614 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 15:43:46,052 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,052 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,052 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021925) setting status to Completed 2007-09-10 15:43:46,056 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021929) setting status to Submitted 2007-09-10 15:43:46,056 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021929) setting status to Active 2007-09-10 15:43:46,057 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:43:46,057 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,057 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,058 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 15:43:46,284 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,284 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,284 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021929) setting status to Completed 2007-09-10 15:43:46,287 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,287 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,288 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021932) setting status to Active 2007-09-10 15:43:46,288 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/kickstart) 2007-09-10 15:43:46,309 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0) 2007-09-10 15:43:46,348 DEBUG FileResourceImpl createDirectory(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/kickstart) 2007-09-10 15:43:46,370 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,370 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,370 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021932) setting status to Completed 2007-09-10 15:43:46,372 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,372 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,373 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021934) setting status to Active 2007-09-10 15:43:46,373 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/status) 2007-09-10 15:43:46,393 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0) 2007-09-10 15:43:46,432 DEBUG FileResourceImpl createDirectory(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/status) 2007-09-10 15:43:46,453 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,453 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,453 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021934) setting status to Completed 2007-09-10 15:43:46,456 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,456 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,456 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021936) setting status to Active 2007-09-10 15:43:46,456 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/info) 2007-09-10 15:43:46,476 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0) 2007-09-10 15:43:46,516 DEBUG FileResourceImpl createDirectory(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/info) 2007-09-10 15:43:46,537 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,537 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,537 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021936) setting status to Completed 2007-09-10 15:43:46,541 DEBUG vdl:execute2 Job duplicate-pms2v1hi running in thread 0-0 run 8fzfp19rn1in0 2007-09-10 15:43:46,546 INFO vdl:execute2 Creating temporary directory simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi on GLOW 2007-09-10 15:43:46,555 INFO vdl:createdirs Creating directory structure in simple-wf-8fzfp19rn1in0/shared (simple-wf-8fzfp19rn1in0/shared/) 2007-09-10 15:43:46,556 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,556 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,557 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021938) setting status to Active 2007-09-10 15:43:46,557 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/shared/) 2007-09-10 15:43:46,596 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,596 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,596 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021938) setting status to Completed 2007-09-10 15:43:46,603 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:43:46,603 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:43:46,603 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021940) setting status to Active 2007-09-10 15:43:46,607 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:43:46,607 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:43:46,608 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021940) setting status to Completed 2007-09-10 15:43:46,621 INFO vdl:dostagein Staging in simpleFile.txt ( - simpleFile.txt to simple-wf-8fzfp19rn1in0/shared/ on GLOW 2007-09-10 15:43:46,624 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1-1189457021943) setting status to Submitted 2007-09-10 15:43:46,624 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1-1189457021943) setting status to Active 2007-09-10 15:43:46,625 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:43:46,625 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:43:46,625 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,625 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 15:43:46,849 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:43:46,849 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:43:46,849 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1-1189457021943) setting status to Completed 2007-09-10 15:43:46,850 INFO vdl:dostagein Staged in simpleFile.txt to simple-wf-8fzfp19rn1in0/shared/ on GLOW 2007-09-10 15:43:46,852 INFO vdl:execute2 Running job duplicate-pms2v1hi duplicate with arguments [simpleFile.txt] in simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi on GLOW 2007-09-10 15:43:46,882 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.TaskHandlerImpl for provider gt2 2007-09-10 15:43:46,902 DEBUG JobSubmissionTaskHandler RSL: &( arguments = "shared/wrapper.sh" "duplicate-pms2v1hi" "-e" "/afs/hep.wisc.edu/osg/app/osg/jtie/duplicate.sh" "-out" "simpleFile.output" "-err" "stderr.txt" "-i" "-d" "" "-if" "simpleFile.txt" "-of" "simpleFile.output" "-k" "" "-a" "simpleFile.txt" )( directory = "/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0" )( executable = "/bin/sh" ) 2007-09-10 15:43:46,908 DEBUG JobSubmissionTaskHandler Execution server: cmsgrid01.hep.wisc.edu/jobmanager-condor 2007-09-10 15:43:48,369 DEBUG JobSubmissionTaskHandler Submitted job with Globus ID: https://cmsgrid01.hep.wisc.edu:41301/17285/1189457027/ 2007-09-10 15:43:48,369 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021946) setting status to Submitted 2007-09-10 15:46:37,390 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021946) setting status to Completed 2007-09-10 15:46:37,393 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:46:37,393 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,393 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021948) setting status to Active 2007-09-10 15:46:37,416 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,416 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:46:37,416 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021948) setting status to Failed Cannot delete the given file 2007-09-10 15:46:37,419 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:46:37,419 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,419 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021950) setting status to Active 2007-09-10 15:46:37,419 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/status/duplicate-pms2v1hi-error) 2007-09-10 15:46:37,439 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,440 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:46:37,440 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021950) setting status to Completed 2007-09-10 15:46:37,446 DEBUG vdl:execute2 Application exception: No status file was found. Check the shared filesystem on GLOW sys:throw @ vdl-int.k, line: 93 sys:else @ vdl-int.k, line: 92 sys:if @ vdl-int.k, line: 81 sys:try @ vdl-int.k, line: 69 vdl:checkjobstatus @ vdl-int.k, line: 366 sys:sequential @ vdl-int.k, line: 337 sys:try @ vdl-int.k, line: 336 task:allocatehost @ vdl-int.k, line: 319 vdl:execute2 @ execute-default.k, line: 22 sys:restartonerror @ execute-default.k, line: 20 sys:sequential @ execute-default.k, line: 19 sys:try @ execute-default.k, line: 18 sys:if @ execute-default.k, line: 17 sys:then @ execute-default.k, line: 16 sys:if @ execute-default.k, line: 15 vdl:execute @ simple-wf.kml, line: 17 duplicatefile @ simple-wf.kml, line: 60 sys:parallel @ simple-wf.kml, line: 59 vdl:mainp @ simple-wf.kml, line: 58 mainp @ vdl.k, line: 141 vdl:mains @ simple-wf.kml, line: 57 vdl:mains @ simple-wf.kml, line: 57 rlog:restartlog @ simple-wf.kml, line: 55 kernel:project @ simple-wf.kml, line: 2 simple-wf-8fzfp19rn1in0 2007-09-10 15:46:37,455 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021952) setting status to Submitted 2007-09-10 15:46:37,455 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021952) setting status to Active 2007-09-10 15:46:37,455 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:46:37,456 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:46:37,456 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,498 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:46:37,730 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:46:37,732 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,732 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:46:37,732 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021952) setting status to Failed Exception in getFile 2007-09-10 15:46:37,735 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:46:37,741 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:46:37,741 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:37,741 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021955) setting status to Active 2007-09-10 15:46:37,748 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:37,748 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:46:37,749 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021955) setting status to Completed 2007-09-10 15:46:37,752 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021958) setting status to Submitted 2007-09-10 15:46:37,752 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021958) setting status to Active 2007-09-10 15:46:37,752 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:46:37,753 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:46:37,753 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:37,796 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:46:38,025 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:46:38,026 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) 2007-09-10 15:46:38,026 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@cbc2d3) successfully released 2007-09-10 15:46:38,026 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021958) setting status to Failed Exception in getFile 2007-09-10 15:46:38,027 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-pms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:46:38,032 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:46:38,032 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:38,032 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021961) setting status to Active 2007-09-10 15:46:38,037 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:38,037 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:46:38,037 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021961) setting status to Completed 2007-09-10 15:46:38,053 DEBUG vdl:execute2 Job duplicate-qms2v1hi running in thread 0-0 run 8fzfp19rn1in0 2007-09-10 15:46:38,055 INFO vdl:execute2 Creating temporary directory simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi on GLOW 2007-09-10 15:46:38,064 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:46:38,064 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:38,064 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021965) setting status to Active 2007-09-10 15:46:38,065 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) 2007-09-10 15:46:38,065 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@33549b) successfully released 2007-09-10 15:46:38,065 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021965) setting status to Completed 2007-09-10 15:46:38,066 INFO vdl:execute2 Running job duplicate-qms2v1hi duplicate with arguments [simpleFile.txt] in simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi on GLOW 2007-09-10 15:46:38,076 DEBUG JobSubmissionTaskHandler RSL: &( arguments = "shared/wrapper.sh" "duplicate-qms2v1hi" "-e" "/afs/hep.wisc.edu/osg/app/osg/jtie/duplicate.sh" "-out" "simpleFile.output" "-err" "stderr.txt" "-i" "-d" "" "-if" "simpleFile.txt" "-of" "simpleFile.output" "-k" "" "-a" "simpleFile.txt" )( directory = "/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0" )( executable = "/bin/sh" ) 2007-09-10 15:46:38,077 DEBUG JobSubmissionTaskHandler Execution server: cmsgrid01.hep.wisc.edu/jobmanager-condor 2007-09-10 15:46:39,455 DEBUG JobSubmissionTaskHandler Submitted job with Globus ID: https://cmsgrid01.hep.wisc.edu:41425/22715/1189457198/ 2007-09-10 15:46:39,456 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021968) setting status to Submitted 2007-09-10 15:48:43,291 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:48:43,291 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for localhost 2007-09-10 15:50:00,054 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021968) setting status to Completed 2007-09-10 15:50:00,058 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:50:00,058 DEBUG FileResourceCache Instantiating new resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:50:00,058 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl for provider gsiftp 2007-09-10 15:50:00,058 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gridftp 2007-09-10 15:50:00,058 DEBUG ServiceContactImpl Host from URI: cmsgrid01.hep.wisc.edu 2007-09-10 15:50:00,058 DEBUG ServiceContactImpl Port from URI: -1 2007-09-10 15:50:00,989 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021970) setting status to Active 2007-09-10 15:50:01,009 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,009 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) successfully released 2007-09-10 15:50:01,009 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021970) setting status to Failed Cannot delete the given file 2007-09-10 15:50:01,011 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:50:01,011 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,011 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021973) setting status to Active 2007-09-10 15:50:01,011 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/status/duplicate-qms2v1hi-error) 2007-09-10 15:50:01,031 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,031 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) successfully released 2007-09-10 15:50:01,031 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021973) setting status to Completed 2007-09-10 15:50:01,033 DEBUG vdl:execute2 Application exception: No status file was found. Check the shared filesystem on GLOW sys:throw @ vdl-int.k, line: 93 sys:else @ vdl-int.k, line: 92 sys:if @ vdl-int.k, line: 81 sys:try @ vdl-int.k, line: 69 vdl:checkjobstatus @ vdl-int.k, line: 366 sys:sequential @ vdl-int.k, line: 337 sys:try @ vdl-int.k, line: 336 task:allocatehost @ vdl-int.k, line: 319 vdl:execute2 @ execute-default.k, line: 22 sys:restartonerror @ execute-default.k, line: 20 sys:sequential @ execute-default.k, line: 19 sys:try @ execute-default.k, line: 18 sys:if @ execute-default.k, line: 17 sys:then @ execute-default.k, line: 16 sys:if @ execute-default.k, line: 15 vdl:execute @ simple-wf.kml, line: 17 duplicatefile @ simple-wf.kml, line: 60 sys:parallel @ simple-wf.kml, line: 59 vdl:mainp @ simple-wf.kml, line: 58 mainp @ vdl.k, line: 141 vdl:mains @ simple-wf.kml, line: 57 vdl:mains @ simple-wf.kml, line: 57 rlog:restartlog @ simple-wf.kml, line: 55 kernel:project @ simple-wf.kml, line: 2 simple-wf-8fzfp19rn1in0 2007-09-10 15:50:01,038 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021975) setting status to Submitted 2007-09-10 15:50:01,038 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021975) setting status to Active 2007-09-10 15:50:01,038 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:50:01,039 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:50:01,039 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,082 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:50:01,332 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:50:01,333 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,333 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) successfully released 2007-09-10 15:50:01,333 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021975) setting status to Failed Exception in getFile 2007-09-10 15:50:01,335 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:50:01,335 DEBUG FileResourceCache Instantiating new resource for localhost(local) 2007-09-10 15:50:01,335 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider local 2007-09-10 15:50:01,335 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.local.FileResourceImpl for provider local 2007-09-10 15:50:01,335 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:50:01,337 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021978) setting status to Active 2007-09-10 15:50:01,343 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) 2007-09-10 15:50:01,343 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) successfully released 2007-09-10 15:50:01,343 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021978) setting status to Completed 2007-09-10 15:50:01,346 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021982) setting status to Submitted 2007-09-10 15:50:01,347 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021982) setting status to Active 2007-09-10 15:50:01,347 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:50:01,347 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:50:01,347 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,389 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:50:01,616 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:50:01,617 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) 2007-09-10 15:50:01,617 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@d2bee) successfully released 2007-09-10 15:50:01,617 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021982) setting status to Failed Exception in getFile 2007-09-10 15:50:01,619 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-qms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:50:01,620 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:50:01,621 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) 2007-09-10 15:50:01,621 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021985) setting status to Active 2007-09-10 15:50:01,627 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) 2007-09-10 15:50:01,627 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) successfully released 2007-09-10 15:50:01,627 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021985) setting status to Completed 2007-09-10 15:50:01,635 DEBUG vdl:execute2 Job duplicate-rms2v1hi running in thread 0-0 run 8fzfp19rn1in0 2007-09-10 15:50:01,637 INFO vdl:execute2 Creating temporary directory simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi on GLOW 2007-09-10 15:50:01,645 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:50:01,645 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) 2007-09-10 15:50:01,645 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021989) setting status to Active 2007-09-10 15:50:01,647 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) 2007-09-10 15:50:01,647 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@b6be69) successfully released 2007-09-10 15:50:01,647 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1-1189457021989) setting status to Completed 2007-09-10 15:50:01,649 INFO vdl:execute2 Running job duplicate-rms2v1hi duplicate with arguments [simpleFile.txt] in simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi on GLOW 2007-09-10 15:50:01,655 DEBUG JobSubmissionTaskHandler RSL: &( arguments = "shared/wrapper.sh" "duplicate-rms2v1hi" "-e" "/afs/hep.wisc.edu/osg/app/osg/jtie/duplicate.sh" "-out" "simpleFile.output" "-err" "stderr.txt" "-i" "-d" "" "-if" "simpleFile.txt" "-of" "simpleFile.output" "-k" "" "-a" "simpleFile.txt" )( directory = "/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0" )( executable = "/bin/sh" ) 2007-09-10 15:50:01,656 DEBUG JobSubmissionTaskHandler Execution server: cmsgrid01.hep.wisc.edu/jobmanager-condor 2007-09-10 15:50:03,056 DEBUG JobSubmissionTaskHandler Submitted job with Globus ID: https://cmsgrid01.hep.wisc.edu:42044/6080/1189457402/ 2007-09-10 15:50:03,056 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021992) setting status to Submitted 2007-09-10 15:52:43,301 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:52:43,302 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for localhost 2007-09-10 15:53:13,368 DEBUG TaskImpl Task(type=1, identity=urn:0-0-1189457021992) setting status to Completed 2007-09-10 15:53:13,370 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:53:13,370 DEBUG FileResourceCache Instantiating new resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:53:13,371 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl for provider gsiftp 2007-09-10 15:53:13,371 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gridftp 2007-09-10 15:53:13,371 DEBUG ServiceContactImpl Host from URI: cmsgrid01.hep.wisc.edu 2007-09-10 15:53:13,371 DEBUG ServiceContactImpl Port from URI: -1 2007-09-10 15:53:14,320 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021994) setting status to Active 2007-09-10 15:53:14,343 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,343 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) successfully released 2007-09-10 15:53:14,343 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021994) setting status to Failed Cannot delete the given file 2007-09-10 15:53:14,345 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:53:14,345 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,345 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021997) setting status to Active 2007-09-10 15:53:14,345 DEBUG FileResourceImpl exists(/afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/status/duplicate-rms2v1hi-error) 2007-09-10 15:53:14,368 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,368 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) successfully released 2007-09-10 15:53:14,368 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457021997) setting status to Completed 2007-09-10 15:53:14,370 DEBUG vdl:execute2 Application exception: No status file was found. Check the shared filesystem on GLOW sys:throw @ vdl-int.k, line: 93 sys:else @ vdl-int.k, line: 92 sys:if @ vdl-int.k, line: 81 sys:try @ vdl-int.k, line: 69 vdl:checkjobstatus @ vdl-int.k, line: 366 sys:sequential @ vdl-int.k, line: 337 sys:try @ vdl-int.k, line: 336 task:allocatehost @ vdl-int.k, line: 319 vdl:execute2 @ execute-default.k, line: 22 sys:restartonerror @ execute-default.k, line: 20 sys:sequential @ execute-default.k, line: 19 sys:try @ execute-default.k, line: 18 sys:if @ execute-default.k, line: 17 sys:then @ execute-default.k, line: 16 sys:if @ execute-default.k, line: 15 vdl:execute @ simple-wf.kml, line: 17 duplicatefile @ simple-wf.kml, line: 60 sys:parallel @ simple-wf.kml, line: 59 vdl:mainp @ simple-wf.kml, line: 58 mainp @ vdl.k, line: 141 vdl:mains @ simple-wf.kml, line: 57 vdl:mains @ simple-wf.kml, line: 57 rlog:restartlog @ simple-wf.kml, line: 55 kernel:project @ simple-wf.kml, line: 2 simple-wf-8fzfp19rn1in0 2007-09-10 15:53:14,374 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021999) setting status to Submitted 2007-09-10 15:53:14,374 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021999) setting status to Active 2007-09-10 15:53:14,375 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:53:14,375 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:53:14,375 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,417 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:53:14,647 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:53:14,648 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,648 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) successfully released 2007-09-10 15:53:14,648 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457021999) setting status to Failed Exception in getFile 2007-09-10 15:53:14,649 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/stderr.txt 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:53:14,649 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:53:14,650 DEBUG FileResourceCache Instantiating new resource for localhost(local) 2007-09-10 15:53:14,650 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider local 2007-09-10 15:53:14,650 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.local.FileResourceImpl for provider local 2007-09-10 15:53:14,651 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457022002) setting status to Active 2007-09-10 15:53:14,683 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@327473) 2007-09-10 15:53:14,683 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@327473) successfully released 2007-09-10 15:53:14,683 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457022002) setting status to Completed 2007-09-10 15:53:14,686 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457022006) setting status to Submitted 2007-09-10 15:53:14,686 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457022006) setting status to Active 2007-09-10 15:53:14,687 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://cmsgrid01.hep.wisc.edu 2007-09-10 15:53:14,687 DEBUG FileResourceCache Got request for resource for gsiftp://cmsgrid01.hep.wisc.edu(gsiftp) 2007-09-10 15:53:14,687 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,728 DEBUG DelegatedFileTransferHandler File transfer with resource remote->tmp 2007-09-10 15:53:14,978 DEBUG DelegatedFileTransferHandler Exception in transfer org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:53:14,979 DEBUG FileResourceCache Releasing resource for gsiftp://cmsgrid01.hep.wisc.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) 2007-09-10 15:53:14,979 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@78f83a) successfully released 2007-09-10 15:53:14,979 DEBUG TaskImpl Task(type=2, identity=urn:0-0-1189457022006) setting status to Failed Exception in getFile 2007-09-10 15:53:14,982 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 15:53:14,982 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@327473) 2007-09-10 15:53:14,982 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457022009) setting status to Active 2007-09-10 15:53:14,982 DEBUG DelegatedFileTransferHandler File transfer failed org.globus.cog.abstraction.impl.file.FileResourceException: Exception in getFile at org.globus.cog.abstraction.impl.file.ftp.AbstractFTPFileResource.translateException(AbstractFTPFileResource.java:47) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:338) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.doSource(DelegatedFileTransferHandler.java:276) at org.globus.cog.abstraction.impl.fileTransfer.CachingDelegatedFileTransferHandler.doSource(CachingDelegatedFileTransferHandler.java:60) at org.globus.cog.abstraction.impl.fileTransfer.DelegatedFileTransferHandler.run(DelegatedFileTransferHandler.java:491) at java.lang.Thread.run(Thread.java:619) Caused by: org.globus.ftp.exception.ServerException: Server refused performing the request. Custom message: (error code 1) [Nested exception message: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] [Nested exception is org.globus.ftp.exception.UnexpectedReplyCodeException: Custom message: Unexpected reply: 500-Command failed. : globus_gridftp_server_file.c:globus_l_gfs_file_send:2190: 500-globus_l_gfs_file_open failed. 500-globus_gridftp_server_file.c:globus_l_gfs_file_open:1694: 500-globus_xio_register_open failed. 500-globus_xio_file_driver.c:globus_l_xio_file_open:438: 500-Unable to open file /afs/hep.wisc.edu/osg/data/osg/jtie/simple-wf-8fzfp19rn1in0/duplicate-rms2v1hi/simpleFile.output 500-globus_xio_file_driver.c:globus_l_xio_file_open:381: 500-System error in open: No such file or directory 500-globus_xio: A system call failed: No such file or directory 500 End.] at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:101) at org.globus.ftp.exception.ServerException.embedUnexpectedReplyCodeException(ServerException.java:110) at org.globus.ftp.vanilla.TransferMonitor.run(TransferMonitor.java:195) at org.globus.ftp.vanilla.TransferMonitor.start(TransferMonitor.java:109) at org.globus.ftp.FTPClient.transferRunSingleThread(FTPClient.java:1456) at org.globus.ftp.FTPClient.get(FTPClient.java:1225) at org.globus.cog.abstraction.impl.file.gridftp.old.FileResourceImpl.getFile(FileResourceImpl.java:335) ... 4 more 2007-09-10 15:53:14,990 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@327473) 2007-09-10 15:53:14,990 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@327473) successfully released 2007-09-10 15:53:14,990 DEBUG TaskImpl Task(type=4, identity=urn:0-0-1189457022009) setting status to Completed 2007-09-10 15:53:15,159 INFO vdl:mains Errors detected. Cleanup not done. 2007-09-10 15:53:15,168 DEBUG VDL2ExecutionContext Execution completed with errors Execution completed with errors sys:throw @ vdl.k, line: 134 sys:if @ vdl.k, line: 134 vdl:mains @ simple-wf.kml, line: 57 rlog:restartlog @ simple-wf.kml, line: 55 kernel:project @ simple-wf.kml, line: 2 simple-wf-8fzfp19rn1in0 at org.globus.cog.karajan.workflow.nodes.FlowNode.fail(FlowNode.java:413) at org.globus.cog.karajan.workflow.nodes.FlowNode.fail(FlowNode.java:417) at org.globus.cog.karajan.workflow.nodes.GenerateErrorNode.post(GenerateErrorNode.java:28) at org.globus.cog.karajan.workflow.nodes.AbstractSequentialWithArguments.childCompleted(AbstractSequentialWithArguments.java:192) at org.globus.cog.karajan.workflow.nodes.Sequential.notificationEvent(Sequential.java:33) at org.globus.cog.karajan.workflow.nodes.FlowNode.event(FlowNode.java:335) at org.globus.cog.karajan.workflow.events.EventBus.send(EventBus.java:123) at org.globus.cog.karajan.workflow.events.EventBus.sendHooked(EventBus.java:97) at org.globus.cog.karajan.workflow.nodes.FlowNode.fireNotificationEvent(FlowNode.java:173) at org.globus.cog.karajan.workflow.nodes.FlowNode.complete(FlowNode.java:299) at org.globus.cog.karajan.workflow.nodes.functions.AbstractFunction.executeChildren(AbstractFunction.java:37) at org.globus.cog.karajan.workflow.nodes.FlowContainer.execute(FlowContainer.java:63) at org.globus.cog.karajan.workflow.nodes.FlowNode.restart(FlowNode.java:240) at org.globus.cog.karajan.workflow.nodes.FlowNode.start(FlowNode.java:281) at org.globus.cog.karajan.workflow.nodes.FlowNode.controlEvent(FlowNode.java:393) at org.globus.cog.karajan.workflow.nodes.FlowNode.event(FlowNode.java:332) at org.globus.cog.karajan.workflow.FlowElementWrapper.event(FlowElementWrapper.java:227) at org.globus.cog.karajan.workflow.events.EventBus.send(EventBus.java:123) at org.globus.cog.karajan.workflow.events.EventBus.sendHooked(EventBus.java:97) at org.globus.cog.karajan.workflow.events.EventWorker.run(EventWorker.java:69)