2007-09-10 17:08:08,521 INFO Loader sid-wf1.dtm: source file is new. Recompiling. 2007-09-10 17:08:09,539 DEBUG Karajan Validation of XML intermediate file was successful 2007-09-10 17:08:09,680 DEBUG Karajan markDataset exprST=subjectNo st= input=true 2007-09-10 17:08:09,681 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,681 DEBUG Karajan checking(2) dataset for subjectNo 2007-09-10 17:08:09,681 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,688 DEBUG Karajan markDataset exprST=trialTypes st= input=true 2007-09-10 17:08:09,688 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,689 DEBUG Karajan checking(2) dataset for trialTypes 2007-09-10 17:08:09,689 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,721 DEBUG Karajan markDataset exprST=waveletAvgScript st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript input=true 2007-09-10 17:08:09,729 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) dataset for waveletAvgScript 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) dataFiles 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) dataset for waveletAvgScript 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) outputFiles 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) dataset for waveletAvgScript 2007-09-10 17:08:09,729 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,729 DEBUG Karajan success(2) 2007-09-10 17:08:09,730 DEBUG Karajan markdatasetparam(3) 2007-09-10 17:08:09,730 DEBUG Karajan we have some parameter(s) to process (7): 2007-09-10 17:08:09,730 DEBUG Karajan we have just one parameter to process(8) 2007-09-10 17:08:09,739 DEBUG Karajan markDataset exprST= st= t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript input=true 2007-09-10 17:08:09,752 DEBUG Karajan markDataset exprST=t st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript t input=true 2007-09-10 17:08:09,759 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) dataset for t 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) dataFiles 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) dataset for t 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) outputFiles 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) dataset for subjectNo 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) dataset for subjectNo 2007-09-10 17:08:09,759 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,760 DEBUG Karajan checking(2) dataset for subjectNo 2007-09-10 17:08:09,760 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,760 DEBUG Karajan checking(2) dataset for subjectNo 2007-09-10 17:08:09,760 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,766 DEBUG Karajan markDataset exprST=s st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript t s input=true 2007-09-10 17:08:09,769 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) dataset for trialTypes 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) dataset for trialTypes 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) dataset for trialTypes 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) dataset for trialTypes 2007-09-10 17:08:09,769 DEBUG Karajan checking(2) waveletAvgScript 2007-09-10 17:08:09,774 DEBUG Karajan markDataset exprST=dataFiles st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript t s dataFiles input=true 2007-09-10 17:08:09,776 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,776 DEBUG Karajan checking(2) dataset for dataFiles 2007-09-10 17:08:09,776 DEBUG Karajan checking(2) dataFiles 2007-09-10 17:08:09,776 DEBUG Karajan success(2) 2007-09-10 17:08:09,776 DEBUG Karajan markdatasetparam(3) 2007-09-10 17:08:09,776 DEBUG Karajan we have some parameter(s) to process (7): ts 2007-09-10 17:08:09,776 DEBUG Karajan we have just one parameter to process(8) 2007-09-10 17:08:09,780 DEBUG Karajan markDataset exprST= ts st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames waveletAvgScript t s dataFiles input=true 2007-09-10 17:08:09,783 DEBUG Karajan markDataset exprST=outputFiles st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames outputFiles waveletAvgScript t s dataFiles input=false 2007-09-10 17:08:09,785 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,785 DEBUG Karajan checking(2) dataset for outputFiles 2007-09-10 17:08:09,785 DEBUG Karajan checking(2) dataFiles 2007-09-10 17:08:09,785 DEBUG Karajan checking(2) dataset for outputFiles 2007-09-10 17:08:09,785 DEBUG Karajan checking(2) outputFiles 2007-09-10 17:08:09,785 DEBUG Karajan success(2) 2007-09-10 17:08:09,785 DEBUG Karajan markdatasetparam(3) 2007-09-10 17:08:09,785 DEBUG Karajan we have some parameter(s) to process (7): outputNames 2007-09-10 17:08:09,785 DEBUG Karajan we have just one parameter to process(8) 2007-09-10 17:08:09,788 DEBUG Karajan markDataset exprST=outputNames st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames outputFiles waveletAvgScript t s dataFiles input=true 2007-09-10 17:08:09,789 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,789 DEBUG Karajan checking(2) dataset for outputNames 2007-09-10 17:08:09,789 DEBUG Karajan checking(2) dataFiles 2007-09-10 17:08:09,792 DEBUG Karajan markDataset exprST= strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 st= trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames outputFiles waveletAvgScript t s dataFiles input=true 2007-09-10 17:08:09,826 DEBUG Karajan markDataset exprST=trialTypes st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes input=true 2007-09-10 17:08:09,827 DEBUG Karajan treating as a variable 2007-09-10 17:08:09,833 DEBUG Karajan markDataset exprST= st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes input=true 2007-09-10 17:08:09,841 DEBUG Karajan markDataset exprST= st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes input=true 2007-09-10 17:08:09,849 DEBUG Karajan markDataset exprST=subjectNo st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes subjectNo input=true 2007-09-10 17:08:10,080 DEBUG Karajan treating as a variable 2007-09-10 17:08:10,090 DEBUG Karajan markDataset exprST= st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes subjectNo input=true 2007-09-10 17:08:10,098 DEBUG Karajan markDataset exprST= st= cwtsmall waveletScript subjNo trialType true t-98adcd15-7030-4d2f-b6d3-94ccb0f9a8fc subjectNo s-b64df07b-3789-4c6b-a75f-aeefc120b95c trialTypes ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts ts true strCh1strCh2strCh3strCh4strCh5strCh6strCh7strCh8strCh9strCh10strCh11strCh12strCh13strCh14strCh15strCh16strCh17strCh18strCh19strCh20strCh21strCh22strCh23strCh24strCh25strCh26strCh27strCh28 outputNames false outputFiles waveletAvgScript t s dataFiles trialTypes subjectNo input=true 2007-09-10 17:08:10,891 DEBUG ServiceContactImpl Host from contact: localhost 2007-09-10 17:08:10,891 DEBUG ServiceContactImpl Host from contact: localhost 2007-09-10 17:08:11,410 INFO unknown Using sites file: swift.conf/sites.xml 2007-09-10 17:08:11,410 INFO unknown Using tc.data: swift.conf/tc.data 2007-09-10 17:08:11,493 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider local 2007-09-10 17:08:11,496 DEBUG AbstractionClassLoader Using system class loader for provider local 2007-09-10 17:08:11,509 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gsiftp 2007-09-10 17:08:11,509 DEBUG AbstractionClassLoader Using system class loader for provider gsiftp 2007-09-10 17:08:11,515 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gt2 2007-09-10 17:08:11,515 DEBUG AbstractionClassLoader Using system class loader for provider gt2 2007-09-10 17:08:12,520 DEBUG FileResourceCache Got request for resource for localhost(file) 2007-09-10 17:08:12,521 DEBUG FileResourceCache Instantiating new resource for localhost(file) 2007-09-10 17:08:12,521 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.common.task.SecurityContextImpl for provider file 2007-09-10 17:08:12,521 DEBUG AbstractionClassLoader Using system class loader for provider file 2007-09-10 17:08:12,521 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.local.FileResourceImpl for provider file 2007-09-10 17:08:12,532 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:12,532 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) successfully released 2007-09-10 17:08:12,564 DEBUG FileResourceCache Got request for resource for localhost(file) 2007-09-10 17:08:12,564 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:12,565 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:12,565 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) successfully released 2007-09-10 17:08:12,579 DEBUG GetFieldValue GetFieldValue(true) 2007-09-10 17:08:12,586 DEBUG GetFieldValue GetFieldValue(true) 2007-09-10 17:08:12,810 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:12,810 DEBUG FileResourceCache Instantiating new resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:12,810 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl for provider gsiftp 2007-09-10 17:08:12,824 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gridftp 2007-09-10 17:08:12,825 DEBUG AbstractionClassLoader Using system class loader for provider gridftp 2007-09-10 17:08:12,825 DEBUG ServiceContactImpl Host from URI: u2-grid.ccr.buffalo.edu 2007-09-10 17:08:12,825 DEBUG ServiceContactImpl Port from URI: -1 2007-09-10 17:08:15,367 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090902) setting status to Active 2007-09-10 17:08:15,367 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared) 2007-09-10 17:08:15,389 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1) 2007-09-10 17:08:15,405 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie) 2007-09-10 17:08:15,435 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1) 2007-09-10 17:08:15,464 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared) 2007-09-10 17:08:15,481 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:15,481 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:15,482 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090902) setting status to Completed 2007-09-10 17:08:15,503 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090905) setting status to Submitted 2007-09-10 17:08:15,503 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090905) setting status to Active 2007-09-10 17:08:15,503 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://u2-grid.ccr.buffalo.edu 2007-09-10 17:08:15,503 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:15,504 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:15,504 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 17:08:15,942 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:15,942 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:15,942 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090905) setting status to Completed 2007-09-10 17:08:15,945 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090909) setting status to Submitted 2007-09-10 17:08:15,946 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090909) setting status to Active 2007-09-10 17:08:15,946 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://u2-grid.ccr.buffalo.edu 2007-09-10 17:08:15,946 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:15,946 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:15,947 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 17:08:16,168 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,168 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,169 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1189462090909) setting status to Completed 2007-09-10 17:08:16,170 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,171 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,171 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090912) setting status to Active 2007-09-10 17:08:16,171 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/kickstart) 2007-09-10 17:08:16,188 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1) 2007-09-10 17:08:16,218 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/kickstart) 2007-09-10 17:08:16,233 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,233 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,234 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090912) setting status to Completed 2007-09-10 17:08:16,235 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,235 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,235 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090914) setting status to Active 2007-09-10 17:08:16,235 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/status) 2007-09-10 17:08:16,251 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1) 2007-09-10 17:08:16,281 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/status) 2007-09-10 17:08:16,297 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,297 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,297 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090914) setting status to Completed 2007-09-10 17:08:16,299 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,299 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,299 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090916) setting status to Active 2007-09-10 17:08:16,300 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/info) 2007-09-10 17:08:16,315 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1) 2007-09-10 17:08:16,345 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/info) 2007-09-10 17:08:16,361 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,361 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,361 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090916) setting status to Completed 2007-09-10 17:08:16,364 DEBUG vdl:execute2 Job cwtsmall-ji1gz1hi running in thread 0-0-0-1-0-1-0 run ryatce3d38vg1 2007-09-10 17:08:16,370 INFO vdl:execute2 Creating temporary directory sid-wf1-ryatce3d38vg1/cwtsmall-ji1gz1hi on GRASE-CCR-U2 2007-09-10 17:08:16,394 INFO vdl:createdirs Creating directory structure scripts in sid-wf1-ryatce3d38vg1/shared (sid-wf1-ryatce3d38vg1/shared/scripts) 2007-09-10 17:08:16,395 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,395 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,395 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090918) setting status to Active 2007-09-10 17:08:16,395 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared/scripts) 2007-09-10 17:08:16,411 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared) 2007-09-10 17:08:16,443 DEBUG FileResourceImpl createDirectory(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared/scripts) 2007-09-10 17:08:16,459 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,459 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,459 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090918) setting status to Completed 2007-09-10 17:08:16,461 INFO vdl:createdirs Creating directory structure in sid-wf1-ryatce3d38vg1/shared (sid-wf1-ryatce3d38vg1/shared/) 2007-09-10 17:08:16,461 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,461 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,462 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090920) setting status to Active 2007-09-10 17:08:16,462 DEBUG FileResourceImpl exists(/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1/shared/) 2007-09-10 17:08:16,491 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,491 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,491 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1189462090920) setting status to Completed 2007-09-10 17:08:16,499 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 17:08:16,499 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:16,499 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1-1189462090922) setting status to Active 2007-09-10 17:08:16,503 DEBUG FileResourceCache Got request for resource for localhost(local) 2007-09-10 17:08:16,503 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:16,503 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) successfully released 2007-09-10 17:08:16,504 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:16,504 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-1-1189462090922) setting status to Completed 2007-09-10 17:08:16,504 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-2-1189462090925) setting status to Active 2007-09-10 17:08:16,505 DEBUG FileResourceCache Releasing resource for localhost (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) 2007-09-10 17:08:16,505 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.local.FileResourceImpl@9278d5) successfully released 2007-09-10 17:08:16,506 DEBUG TaskImpl Task(type=4, identity=urn:0-0-0-1-0-1-0-2-1189462090925) setting status to Completed 2007-09-10 17:08:16,516 INFO vdl:dostagein Staging in scripts/runWaveletsAvg.R (scripts - runWaveletsAvg.R to sid-wf1-ryatce3d38vg1/shared/scripts on GRASE-CCR-U2 2007-09-10 17:08:16,516 INFO vdl:dostagein Staging in 101_FB-epochs.Rdata ( - 101_FB-epochs.Rdata to sid-wf1-ryatce3d38vg1/shared/ on GRASE-CCR-U2 2007-09-10 17:08:16,518 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1-1189462090928) setting status to Submitted 2007-09-10 17:08:16,519 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1-1189462090928) setting status to Active 2007-09-10 17:08:16,519 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://u2-grid.ccr.buffalo.edu 2007-09-10 17:08:16,519 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,519 DEBUG FileResourceCache Found cached resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,519 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 17:08:16,519 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-2-1189462090931) setting status to Submitted 2007-09-10 17:08:16,520 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-2-1189462090931) setting status to Active 2007-09-10 17:08:16,520 DEBUG DelegatedFileTransferHandler Starting service on gsiftp://u2-grid.ccr.buffalo.edu 2007-09-10 17:08:16,520 DEBUG FileResourceCache Got request for resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,520 DEBUG FileResourceCache Instantiating new resource for gsiftp://u2-grid.ccr.buffalo.edu(gsiftp) 2007-09-10 17:08:16,520 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl for provider gsiftp 2007-09-10 17:08:16,520 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.GlobusSecurityContextImpl for provider gridftp 2007-09-10 17:08:16,521 DEBUG ServiceContactImpl Host from URI: u2-grid.ccr.buffalo.edu 2007-09-10 17:08:16,521 DEBUG ServiceContactImpl Port from URI: -1 2007-09-10 17:08:16,739 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) 2007-09-10 17:08:16,739 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@51e202) successfully released 2007-09-10 17:08:16,740 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-1-1189462090928) setting status to Completed 2007-09-10 17:08:16,741 INFO vdl:dostagein Staged in scripts/runWaveletsAvg.R to sid-wf1-ryatce3d38vg1/shared/scripts on GRASE-CCR-U2 2007-09-10 17:08:19,426 DEBUG DelegatedFileTransferHandler File transfer with resource local->remote 2007-09-10 17:08:22,270 DEBUG FileResourceCache Releasing resource for gsiftp://u2-grid.ccr.buffalo.edu (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@18425b7) 2007-09-10 17:08:22,270 DEBUG FileResourceCache Resource (org.globus.cog.abstraction.impl.file.gridftp.FileResourceImpl@18425b7) successfully released 2007-09-10 17:08:22,271 DEBUG TaskImpl Task(type=2, identity=urn:0-0-0-1-0-1-0-2-1189462090931) setting status to Completed 2007-09-10 17:08:22,272 INFO vdl:dostagein Staged in 101_FB-epochs.Rdata to sid-wf1-ryatce3d38vg1/shared/ on GRASE-CCR-U2 2007-09-10 17:08:22,274 INFO vdl:execute2 Running job cwtsmall-ji1gz1hi cwtsmall with arguments [scripts/runWaveletsAvg.R, 101, FB] in sid-wf1-ryatce3d38vg1/cwtsmall-ji1gz1hi on GRASE-CCR-U2 2007-09-10 17:08:22,320 DEBUG AbstractionFactory Instantiating org.globus.cog.abstraction.impl.execution.gt2.TaskHandlerImpl for provider gt2 2007-09-10 17:08:22,340 DEBUG JobSubmissionTaskHandler RSL: &( arguments = "shared/wrapper.sh" "cwtsmall-ji1gz1hi" "-e" "/san/scratch/grid/grid-tmp/grid-apps/osg/jtie/SIDGrid/wavelet.sh" "-out" "stdout.txt" "-err" "stderr.txt" "-i" "-d" "scripts|" "-if" "scripts/runWaveletsAvg.R|101_FB-epochs.Rdata" "-of" "101-FBchannel20_cwt-avgResults.Rdata|101-FBchannel18_cwt-avgResults.Rdata|101-FBchannel19_cwt-avgResults.Rdata|101-FBchannel16_cwt-avgResults.Rdata|101-FBchannel17_cwt-avgResults.Rdata|101-FBchannel14_cwt-avgResults.Rdata|101-FBchannel15_cwt-avgResults.Rdata|101-FBchannel12_cwt-avgResults.Rdata|101-FBchannel13_cwt-avgResults.Rdata|101-FBchannel22_cwt-avgResults.Rdata|101-FBchannel21_cwt-avgResults.Rdata|101-FBchannel23_cwt-avgResults.Rdata|101-FBchannel24_cwt-avgResults.Rdata|101-FBchannel25_cwt-avgResults.Rdata|101-FBchannel26_cwt-avgResults.Rdata|101-FBchannel27_cwt-avgResults.Rdata|101-FBchannel28_cwt-avgResults.Rdata|101-FBchannel4_cwt-avgResults.Rdata|101-FBchannel3_cwt-avgResults.Rdata|101-FBchannel11_cwt-avgResults.Rdata|101-FBchannel2_cwt-avgResults.Rdata|101-FBchannel1_cwt-avgResults.Rdata|101-FBchannel8_cwt-avgResults.Rdata|101-FBchannel7_cwt-avgResults.Rdata|101-FBchannel6_cwt-avgResults.Rdata|101-FBchannel5_cwt-avgResults.Rdata|101-FBchannel10_cwt-avgResults.Rdata|101-FBchannel9_cwt-avgResults.Rdata" "-k" "" "-a" "scripts/runWaveletsAvg.R" "101" "FB" )( directory = "/san/scratch/grid/grid-tmp/grid-data/osg/jtie/sid-wf1-ryatce3d38vg1" )( executable = "/bin/sh" ) 2007-09-10 17:08:22,346 DEBUG JobSubmissionTaskHandler Execution server: u2-grid.ccr.buffalo.edu/jobmanager-pbs 2007-09-10 17:08:23,808 DEBUG JobSubmissionTaskHandler Submitted job with Globus ID: https://u2-grid.ccr.buffalo.edu:15527/12248/1189462043/ 2007-09-10 17:08:23,808 DEBUG TaskImpl Task(type=1, identity=urn:0-0-0-1-0-1-0-1189462090935) setting status to Submitted 2007-09-10 17:11:12,527 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for localhost 2007-09-10 17:11:12,528 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for gsiftp://u2-grid.ccr.buffalo.edu 2007-09-10 17:11:12,528 DEBUG FileResourceCache Maximum idle time exceeded. Removing resource for gsiftp://u2-grid.ccr.buffalo.edu