2011-08-22 11:08:28,832-0500 DEBUG Loader arguments: [-config, cf.ps, -tc.file, tc, -sites.file, sites.grid-ps.xml, -runid, catsn-osg-n50-d200mb, catsn.swift, -n=50] 2011-08-22 11:08:28,832-0500 DEBUG Loader Max heap: 238616576 2011-08-22 11:08:28,833-0500 DEBUG textfiles BEGIN SWIFTSCRIPT: type file; app (file o) cat (file i) { cat @i stdout=@o; } file out[]; foreach j in [1:@toint(@arg("n","1"))] { file data<"data.txt">; out[j] = cat(data); } 2011-08-22 11:08:28,833-0500 DEBUG textfiles END SWIFTSCRIPT: 2011-08-22 11:08:28,834-0500 DEBUG Loader kmlversion is >db117a35-cc00-4f44-a922-50bd4b54b37e< 2011-08-22 11:08:28,834-0500 DEBUG Loader build version is >db117a35-cc00-4f44-a922-50bd4b54b37e< 2011-08-22 11:08:28,834-0500 DEBUG Loader Recompilation suppressed. 2011-08-22 11:08:28,972-0500 DEBUG Loader setting: sites.file to: sites.grid-ps.xml 2011-08-22 11:08:28,972-0500 DEBUG Loader setting: tc.file to: tc 2011-08-22 11:08:28,972-0500 DEBUG textfiles using default sites file 2011-08-22 11:08:28,978-0500 INFO VDL2ExecutionContext Stack dump: Level 1 [iA = 0, iB = 0, bA = false, bB = false] vdl:instanceconfigfile = cf.ps vdl:instanceconfig = Swift configuration [cf.ps] vdl:operation = run PATH_SEPARATOR = / swift.home = /home/ketan/swift-install/0.93/cog/modules/swift/dist/swift-svn/bin/.. 2011-08-22 11:08:29,543-0500 INFO unknown Using sites file: sites.grid-ps.xml 2011-08-22 11:08:29,572-0500 INFO unknown Using tc.data: tc 2011-08-22 11:08:29,661-0500 INFO AbstractScheduler Setting resources to: {localhost=localhost} 2011-08-22 11:08:30,074-0500 INFO unknown Swift svn swift-r4989 (swift modified locally) cog-r3232 2011-08-22 11:08:30,075-0500 INFO unknown RUNID id=run:catsn-osg-n50-d200mb 2011-08-22 11:08:30,146-0500 INFO SetFieldValue Set: swift#mapper#17002=f. 2011-08-22 11:08:30,146-0500 INFO SetFieldValue Set: swift#mapper#17004=.out 2011-08-22 11:08:30,146-0500 INFO VDLFunction FUNCTION: arg() 2011-08-22 11:08:30,147-0500 INFO VDLFunction FUNCTION: toint() 2011-08-22 11:08:30,146-0500 INFO SetFieldValue Set: swift#mapper#17000=outdir 2011-08-22 11:08:30,152-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-4 2011-08-22 11:08:30,152-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-7 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-9 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-10 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-12 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-13 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-14 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-15 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-16 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-17 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-18 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-20 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-3 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-21 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains SCOPE thread=0-3-4 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-6 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-22 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-7 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-23 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-10 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-24 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-12 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-13 2011-08-22 11:08:30,152-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-5 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-14 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-27 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-25 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains SCOPE thread=0-3-9 2011-08-22 11:08:30,154-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-19 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-11 2011-08-22 11:08:30,153-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-8 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-30 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-29 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-33 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-34 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-28 2011-08-22 11:08:30,155-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-26 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains SCOPE thread=0-3-15 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-38 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains SCOPE thread=0-3-16 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-31 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-42 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-43 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-44 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-45 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-46 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-47 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-48 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains SCOPE thread=0-3-17 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-49 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains SCOPE thread=0-3-18 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-20 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-3 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-21 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-6 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-22 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-1 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains SCOPE thread=0-3-23 2011-08-22 11:08:30,158-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-2 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-24 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-5 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-37 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-36 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-35 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-32 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-25 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-11 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-29 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-33 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-8 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-30 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-26 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-28 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-38 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-27 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-42 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-43 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-44 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-45 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-46 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-47 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-48 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-49 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-0 2011-08-22 11:08:30,157-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-41 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-40 2011-08-22 11:08:30,156-0500 DEBUG vdl:mains FOREACH_IT_START line=9 thread=0-3-39 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-2 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-37 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-36 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-35 2011-08-22 11:08:30,162-0500 DEBUG vdl:mains SCOPE thread=0-3-0 2011-08-22 11:08:30,162-0500 DEBUG vdl:mains SCOPE thread=0-3-41 2011-08-22 11:08:30,162-0500 DEBUG vdl:mains SCOPE thread=0-3-40 2011-08-22 11:08:30,162-0500 DEBUG vdl:mains SCOPE thread=0-3-39 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-1 2011-08-22 11:08:30,160-0500 DEBUG vdl:mains SCOPE thread=0-3-31 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-34 2011-08-22 11:08:30,159-0500 DEBUG vdl:mains SCOPE thread=0-3-19 2011-08-22 11:08:30,161-0500 DEBUG vdl:mains SCOPE thread=0-3-32 2011-08-22 11:08:30,171-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,171-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,173-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,172-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,175-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,175-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,175-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,176-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,176-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,176-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,176-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,177-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,177-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,177-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,177-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,177-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,178-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,179-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,179-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,180-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,181-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,184-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,185-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,179-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,176-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,175-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,175-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,174-0500 INFO RootDataNode Found data data:file - Closed.$ 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-9-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-21-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-37-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-14-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-10-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-7-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-29-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-4-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-33-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-13-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-16-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-25-1 name=cat 2011-08-22 11:08:30,196-0500 DEBUG cat PROCEDURE line=3 thread=0-3-49-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-8-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-38-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-18-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-6-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-35-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-28-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-26-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-30-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-44-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-43-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-0-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-22-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-15-1 name=cat 2011-08-22 11:08:30,197-0500 DEBUG cat PROCEDURE line=3 thread=0-3-27-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-5-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-2-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-24-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-47-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-23-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-1-1 name=cat 2011-08-22 11:08:30,199-0500 DEBUG cat PROCEDURE line=3 thread=0-3-42-1 name=cat 2011-08-22 11:08:30,200-0500 DEBUG cat PROCEDURE line=3 thread=0-3-3-1 name=cat 2011-08-22 11:08:30,200-0500 DEBUG cat PROCEDURE line=3 thread=0-3-34-1 name=cat 2011-08-22 11:08:30,203-0500 DEBUG cat PROCEDURE line=3 thread=0-3-40-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-46-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-12-1 name=cat 2011-08-22 11:08:30,204-0500 DEBUG cat PROCEDURE line=3 thread=0-3-19-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-11-1 name=cat 2011-08-22 11:08:30,205-0500 DEBUG cat PROCEDURE line=3 thread=0-3-32-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-39-1 name=cat 2011-08-22 11:08:30,198-0500 DEBUG cat PROCEDURE line=3 thread=0-3-41-1 name=cat 2011-08-22 11:08:30,207-0500 DEBUG cat PROCEDURE line=3 thread=0-3-31-1 name=cat 2011-08-22 11:08:30,215-0500 DEBUG cat PROCEDURE line=3 thread=0-3-36-1 name=cat 2011-08-22 11:08:30,216-0500 DEBUG cat PROCEDURE line=3 thread=0-3-17-1 name=cat 2011-08-22 11:08:30,216-0500 DEBUG cat PROCEDURE line=3 thread=0-3-20-1 name=cat 2011-08-22 11:08:30,217-0500 DEBUG cat PROCEDURE line=3 thread=0-3-48-1 name=cat 2011-08-22 11:08:30,217-0500 DEBUG cat PROCEDURE line=3 thread=0-3-45-1 name=cat 2011-08-22 11:08:30,225-0500 INFO vdl:execute START thread=0-3-7-1 tr=cat 2011-08-22 11:08:30,225-0500 INFO vdl:execute START thread=0-3-4-1 tr=cat 2011-08-22 11:08:30,225-0500 INFO vdl:execute START thread=0-3-14-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-18-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-6-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-35-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-28-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-26-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-44-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-42-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-46-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-43-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-30-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-29-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-2-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-47-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-24-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-27-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-3-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-1-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-23-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-34-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-21-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-19-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-40-1 tr=cat 2011-08-22 11:08:30,227-0500 INFO vdl:execute START thread=0-3-9-1 tr=cat 2011-08-22 11:08:30,228-0500 INFO vdl:execute START thread=0-3-12-1 tr=cat 2011-08-22 11:08:30,228-0500 INFO vdl:execute START thread=0-3-11-1 tr=cat 2011-08-22 11:08:30,228-0500 INFO vdl:execute START thread=0-3-38-1 tr=cat 2011-08-22 11:08:30,229-0500 INFO vdl:execute START thread=0-3-32-1 tr=cat 2011-08-22 11:08:30,229-0500 INFO vdl:execute START thread=0-3-39-1 tr=cat 2011-08-22 11:08:30,230-0500 INFO vdl:execute START thread=0-3-5-1 tr=cat 2011-08-22 11:08:30,230-0500 INFO vdl:execute START thread=0-3-41-1 tr=cat 2011-08-22 11:08:30,231-0500 INFO vdl:execute START thread=0-3-25-1 tr=cat 2011-08-22 11:08:30,231-0500 INFO vdl:execute START thread=0-3-8-1 tr=cat 2011-08-22 11:08:30,232-0500 INFO vdl:execute START thread=0-3-31-1 tr=cat 2011-08-22 11:08:30,236-0500 INFO vdl:execute START thread=0-3-16-1 tr=cat 2011-08-22 11:08:30,241-0500 INFO vdl:execute START thread=0-3-36-1 tr=cat 2011-08-22 11:08:30,241-0500 INFO vdl:execute START thread=0-3-33-1 tr=cat 2011-08-22 11:08:30,241-0500 INFO vdl:execute START thread=0-3-17-1 tr=cat 2011-08-22 11:08:30,242-0500 INFO vdl:execute START thread=0-3-20-1 tr=cat 2011-08-22 11:08:30,245-0500 INFO vdl:execute START thread=0-3-48-1 tr=cat 2011-08-22 11:08:30,245-0500 INFO vdl:execute START thread=0-3-45-1 tr=cat 2011-08-22 11:08:30,225-0500 INFO vdl:execute START thread=0-3-49-1 tr=cat 2011-08-22 11:08:30,225-0500 INFO vdl:execute START thread=0-3-13-1 tr=cat 2011-08-22 11:08:30,226-0500 INFO vdl:execute START thread=0-3-37-1 tr=cat 2011-08-22 11:08:30,271-0500 INFO vdl:execute START thread=0-3-15-1 tr=cat 2011-08-22 11:08:30,273-0500 INFO vdl:execute START thread=0-3-0-1 tr=cat 2011-08-22 11:08:30,276-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:08:30,278-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:08:30,279-0500 INFO GlobalSubmitQueue No global submit throttle set. Using default (1024) 2011-08-22 11:08:30,281-0500 INFO LateBindingScheduler JobQueue: 42 2011-08-22 11:08:30,283-0500 INFO LateBindingScheduler JobQueue: 42 2011-08-22 11:08:30,285-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-t1xnosek thread=0-3-6-1-1 host=localhost replicationGroup=l0xnosek 2011-08-22 11:08:30,285-0500 INFO vdl:execute START thread=0-3-22-1 tr=cat 2011-08-22 11:08:30,286-0500 INFO vdl:execute START thread=0-3-10-1 tr=cat 2011-08-22 11:08:30,287-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-u1xnosek thread=0-3-42-1-1 host=localhost replicationGroup=q0xnosek 2011-08-22 11:08:30,289-0500 DEBUG vdl:execute2 JOB_START jobid=cat-u1xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/u/cat-u1xnosek host=localhost 2011-08-22 11:08:30,290-0500 DEBUG textfiles BEGIN TC: localhost sh /bin/sh null null null localhost cat /bin/cat null null null pbs cat /bin/cat null null null mcs cat /bin/cat null null null localhost catnap /home/wilde/swift/lab/catnap.sh null null GLOBUS::maxwalltime="00:01:00" 2011-08-22 11:08:30,290-0500 DEBUG textfiles END TC: 2011-08-22 11:08:30,305-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-42-1-1-1314029309607) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0043.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0043.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:08:30,289-0500 DEBUG vdl:execute2 JOB_START jobid=cat-t1xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/t/cat-t1xnosek host=localhost 2011-08-22 11:08:30,308-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-6-1-1-1314029309609) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0007.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0007.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:08:30,333-0500 WARN RemoteConfiguration Find: http://localhost:50002 2011-08-22 11:08:30,333-0500 WARN RemoteConfiguration Find: keepalive(120), reconnect - http://localhost:50002 2011-08-22 11:08:30,336-0500 INFO AbstractKarajanChannel MetaChannel: 1437053119[1950676871: {}] -> null: Disabling heartbeats (disabled in config) 2011-08-22 11:08:30,349-0500 INFO AbstractStreamKarajanChannel$Multiplexer Multiplexer 0 started 2011-08-22 11:08:30,349-0500 INFO AbstractStreamKarajanChannel$Multiplexer (0) Scheduling SC-null for addition 2011-08-22 11:08:30,349-0500 INFO AbstractStreamKarajanChannel nullChannel started 2011-08-22 11:08:30,350-0500 INFO AbstractStreamKarajanChannel$Multiplexer Multiplexer 1 started 2011-08-22 11:08:30,393-0500 INFO ChannelConfigurationCommand Got reply 2011-08-22 11:08:30,394-0500 INFO AbstractStreamKarajanChannel Channel configured 2011-08-22 11:08:30,394-0500 INFO MetaChannel MetaChannel: 1437053119[1950676871: {}] -> null.bind -> SC-null 2011-08-22 11:08:40,354-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:08:50,373-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:08:54,825-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:08:55,134-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-t-cat-t1xnosek/./outdir/f.0007.out 2011-08-22 11:08:55,134-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0007.out 2011-08-22 11:08:55,207-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-u-cat-u1xnosek/./outdir/f.0043.out 2011-08-22 11:08:55,208-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0043.out 2011-08-22 11:08:55,208-0500 INFO Buffers elapsedTime=24595, buffersUsed[min,avg,max]=0, 2, 32 2011-08-22 11:09:00,381-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:09:04,888-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:09:05,210-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:09:10,402-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 360460 2011-08-22 11:09:15,225-0500 INFO Buffers elapsedTime=10015, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:09:19,664-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:09:19,773-0500 INFO LateBindingScheduler JobQueue: 48 2011-08-22 11:09:19,773-0500 INFO LateBindingScheduler JobQueue: 48 2011-08-22 11:09:19,779-0500 DEBUG vdl:execute2 JOB_END jobid=cat-t1xnosek 2011-08-22 11:09:19,779-0500 DEBUG vdl:execute2 JOB_END jobid=cat-u1xnosek 2011-08-22 11:09:19,780-0500 INFO vdl:execute END_SUCCESS thread=0-3-6-1 tr=cat 2011-08-22 11:09:19,781-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:09:19,782-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-6 2011-08-22 11:09:19,782-0500 INFO vdl:execute END_SUCCESS thread=0-3-42-1 tr=cat 2011-08-22 11:09:19,783-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:09:19,783-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-42 2011-08-22 11:09:20,280-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:09:20,280-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:09:20,282-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-y1xnosek thread=0-3-46-1-1 host=localhost replicationGroup=r0xnosek 2011-08-22 11:09:20,282-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-z1xnosek thread=0-3-32-1-1 host=localhost replicationGroup=u0xnosek 2011-08-22 11:09:20,283-0500 DEBUG vdl:execute2 JOB_START jobid=cat-y1xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/y/cat-y1xnosek host=localhost 2011-08-22 11:09:20,285-0500 DEBUG vdl:execute2 JOB_START jobid=cat-z1xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/z/cat-z1xnosek host=localhost 2011-08-22 11:09:20,291-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-46-1-1-1314029309611) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0047.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0047.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:09:20,298-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-32-1-1-1314029309613) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0033.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0033.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:09:20,417-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 185 2011-08-22 11:09:30,427-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:09:37,445-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:09:40,435-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:09:44,913-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-y-cat-y1xnosek/./outdir/f.0047.out 2011-08-22 11:09:44,913-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0047.out 2011-08-22 11:09:44,914-0500 INFO Buffers elapsedTime=29689, buffersUsed[min,avg,max]=0, 1, 32 2011-08-22 11:09:45,003-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-z-cat-z1xnosek/./outdir/f.0033.out 2011-08-22 11:09:45,003-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0033.out 2011-08-22 11:09:50,445-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:09:54,932-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:10:00,452-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 360472 2011-08-22 11:10:04,946-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:10:10,003-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:10:10,463-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:10:16,256-0500 INFO Buffers elapsedTime=11309, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:10:18,187-0500 INFO LateBindingScheduler JobQueue: 46 2011-08-22 11:10:18,188-0500 DEBUG vdl:execute2 JOB_END jobid=cat-y1xnosek 2011-08-22 11:10:18,188-0500 INFO vdl:execute END_SUCCESS thread=0-3-46-1 tr=cat 2011-08-22 11:10:18,189-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:10:18,189-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:10:18,189-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-46 2011-08-22 11:10:18,189-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-02xnosek thread=0-3-43-1-1 host=localhost replicationGroup=t0xnosek 2011-08-22 11:10:18,190-0500 DEBUG vdl:execute2 JOB_START jobid=cat-02xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/0/cat-02xnosek host=localhost 2011-08-22 11:10:18,196-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-43-1-1-1314029309615) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0044.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0044.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:10:18,216-0500 INFO LateBindingScheduler JobQueue: 45 2011-08-22 11:10:18,216-0500 DEBUG vdl:execute2 JOB_END jobid=cat-z1xnosek 2011-08-22 11:10:18,217-0500 INFO vdl:execute END_SUCCESS thread=0-3-32-1 tr=cat 2011-08-22 11:10:18,217-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:10:18,217-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-32 2011-08-22 11:10:18,721-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:10:18,725-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-12xnosek thread=0-3-30-1-1 host=localhost replicationGroup=v0xnosek 2011-08-22 11:10:18,726-0500 DEBUG vdl:execute2 JOB_START jobid=cat-12xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/1/cat-12xnosek host=localhost 2011-08-22 11:10:18,729-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-30-1-1-1314029309617) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0031.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0031.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:10:20,478-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:10:26,929-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:10:26,930-0500 INFO Buffers elapsedTime=10674, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:10:30,500-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:10:37,140-0500 INFO Buffers elapsedTime=10210, buffersUsed[min,avg,max]=0, 0, 0 2011-08-22 11:10:37,140-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:10:37,519-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-0-cat-02xnosek/./outdir/f.0044.out 2011-08-22 11:10:37,519-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0044.out 2011-08-22 11:10:40,510-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:10:47,163-0500 INFO Buffers elapsedTime=10023, buffersUsed[min,avg,max]=16, 1, 16 2011-08-22 11:10:50,512-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:10:56,052-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:10:56,052-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-1-cat-12xnosek/./outdir/f.0031.out 2011-08-22 11:10:56,184-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0031.out 2011-08-22 11:10:57,177-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:11:00,518-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 360460 2011-08-22 11:11:01,496-0500 INFO LateBindingScheduler JobQueue: 44 2011-08-22 11:11:01,497-0500 DEBUG vdl:execute2 JOB_END jobid=cat-02xnosek 2011-08-22 11:11:01,497-0500 INFO vdl:execute END_SUCCESS thread=0-3-43-1 tr=cat 2011-08-22 11:11:01,498-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:11:01,498-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-43 2011-08-22 11:11:02,000-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:11:02,002-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-22xnosek thread=0-3-2-1-1 host=localhost replicationGroup=y0xnosek 2011-08-22 11:11:02,003-0500 DEBUG vdl:execute2 JOB_START jobid=cat-22xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/2/cat-22xnosek host=localhost 2011-08-22 11:11:02,004-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-2-1-1-1314029309619) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0003.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0003.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:11:07,181-0500 INFO Buffers elapsedTime=10004, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:11:10,534-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:11:15,120-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:11:17,195-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:11:19,978-0500 INFO LateBindingScheduler JobQueue: 43 2011-08-22 11:11:19,979-0500 DEBUG vdl:execute2 JOB_END jobid=cat-12xnosek 2011-08-22 11:11:19,980-0500 INFO vdl:execute END_SUCCESS thread=0-3-30-1 tr=cat 2011-08-22 11:11:19,980-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:11:20,261-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-30 2011-08-22 11:11:20,482-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:11:20,483-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-32xnosek thread=0-3-47-1-1 host=localhost replicationGroup=01xnosek 2011-08-22 11:11:20,484-0500 DEBUG vdl:execute2 JOB_START jobid=cat-32xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/3/cat-32xnosek host=localhost 2011-08-22 11:11:20,486-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-47-1-1-1314029309621) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0048.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0048.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:11:20,553-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 45 2011-08-22 11:11:21,509-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-2-cat-22xnosek/./outdir/f.0003.out 2011-08-22 11:11:21,509-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0003.out 2011-08-22 11:11:27,202-0500 INFO Buffers elapsedTime=10007, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:11:30,557-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:11:37,219-0500 INFO Buffers elapsedTime=10016, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:11:39,660-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:11:39,661-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-3-cat-32xnosek/./outdir/f.0048.out 2011-08-22 11:11:39,661-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0048.out 2011-08-22 11:11:40,560-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:11:45,427-0500 INFO LateBindingScheduler JobQueue: 42 2011-08-22 11:11:45,433-0500 DEBUG vdl:execute2 JOB_END jobid=cat-22xnosek 2011-08-22 11:11:45,434-0500 INFO vdl:execute END_SUCCESS thread=0-3-2-1 tr=cat 2011-08-22 11:11:45,435-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:11:45,435-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-2 2011-08-22 11:11:45,935-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:11:45,936-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-42xnosek thread=0-3-11-1-1 host=localhost replicationGroup=z0xnosek 2011-08-22 11:11:45,936-0500 DEBUG vdl:execute2 JOB_START jobid=cat-42xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/4/cat-42xnosek host=localhost 2011-08-22 11:11:45,938-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-11-1-1-1314029309623) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0012.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0012.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:11:47,235-0500 INFO Buffers elapsedTime=10015, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:11:50,574-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:11:57,255-0500 INFO Buffers elapsedTime=10020, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:12:00,582-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:12:03,056-0500 INFO LateBindingScheduler JobQueue: 41 2011-08-22 11:12:03,056-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:12:03,057-0500 DEBUG vdl:execute2 JOB_END jobid=cat-32xnosek 2011-08-22 11:12:03,058-0500 INFO vdl:execute END_SUCCESS thread=0-3-47-1 tr=cat 2011-08-22 11:12:03,058-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:12:03,060-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-47 2011-08-22 11:12:03,559-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:12:03,560-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-52xnosek thread=0-3-25-1-1 host=localhost replicationGroup=41xnosek 2011-08-22 11:12:03,561-0500 DEBUG vdl:execute2 JOB_START jobid=cat-52xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/5/cat-52xnosek host=localhost 2011-08-22 11:12:03,563-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-25-1-1-1314029309625) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0026.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0026.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:12:05,527-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-4-cat-42xnosek/./outdir/f.0012.out 2011-08-22 11:12:05,527-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0012.out 2011-08-22 11:12:07,260-0500 INFO Buffers elapsedTime=10005, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:12:10,594-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:12:17,261-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:12:20,239-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:12:20,603-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:12:26,223-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-5-cat-52xnosek/./outdir/f.0026.out 2011-08-22 11:12:26,224-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0026.out 2011-08-22 11:12:27,442-0500 INFO Buffers elapsedTime=10011, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:12:29,516-0500 INFO LateBindingScheduler JobQueue: 40 2011-08-22 11:12:29,518-0500 DEBUG vdl:execute2 JOB_END jobid=cat-42xnosek 2011-08-22 11:12:29,518-0500 INFO vdl:execute END_SUCCESS thread=0-3-11-1 tr=cat 2011-08-22 11:12:29,519-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:12:29,519-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-11 2011-08-22 11:12:30,020-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:12:30,021-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-62xnosek thread=0-3-27-1-1 host=localhost replicationGroup=21xnosek 2011-08-22 11:12:30,022-0500 DEBUG vdl:execute2 JOB_START jobid=cat-62xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/6/cat-62xnosek host=localhost 2011-08-22 11:12:30,024-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-27-1-1-1314029309627) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0028.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0028.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:12:30,277-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 15 2011-08-22 11:12:30,610-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 278636 2011-08-22 11:12:37,446-0500 INFO Buffers elapsedTime=10004, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:12:40,628-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:12:47,456-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:12:49,545-0500 INFO LateBindingScheduler JobQueue: 39 2011-08-22 11:12:49,545-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:12:49,546-0500 DEBUG vdl:execute2 JOB_END jobid=cat-52xnosek 2011-08-22 11:12:49,547-0500 INFO vdl:execute END_SUCCESS thread=0-3-25-1 tr=cat 2011-08-22 11:12:49,547-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:12:49,549-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-25 2011-08-22 11:12:50,048-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:12:50,049-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-72xnosek thread=0-3-29-1-1 host=localhost replicationGroup=x0xnosek 2011-08-22 11:12:50,049-0500 DEBUG vdl:execute2 JOB_START jobid=cat-72xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/7/cat-72xnosek host=localhost 2011-08-22 11:12:50,053-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-29-1-1-1314029309629) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0030.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0030.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:12:50,649-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:12:51,578-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-6-cat-62xnosek/./outdir/f.0028.out 2011-08-22 11:12:51,578-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0028.out 2011-08-22 11:12:57,478-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:13:00,658-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:13:07,488-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:13:09,642-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:13:09,642-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-7-cat-72xnosek/./outdir/f.0030.out 2011-08-22 11:13:09,643-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0030.out 2011-08-22 11:13:10,665-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:13:15,084-0500 INFO LateBindingScheduler JobQueue: 38 2011-08-22 11:13:15,086-0500 DEBUG vdl:execute2 JOB_END jobid=cat-62xnosek 2011-08-22 11:13:15,087-0500 INFO vdl:execute END_SUCCESS thread=0-3-27-1 tr=cat 2011-08-22 11:13:15,087-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:13:15,087-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-27 2011-08-22 11:13:15,587-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:13:15,588-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-82xnosek thread=0-3-3-1-1 host=localhost replicationGroup=31xnosek 2011-08-22 11:13:15,589-0500 DEBUG vdl:execute2 JOB_START jobid=cat-82xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/8/cat-82xnosek host=localhost 2011-08-22 11:13:15,595-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-3-1-1-1314029309631) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0004.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0004.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:13:17,506-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:13:20,668-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:13:25,358-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:13:27,514-0500 INFO Buffers elapsedTime=10008, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:13:30,686-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:13:33,293-0500 INFO LateBindingScheduler JobQueue: 37 2011-08-22 11:13:33,294-0500 DEBUG vdl:execute2 JOB_END jobid=cat-72xnosek 2011-08-22 11:13:33,294-0500 INFO vdl:execute END_SUCCESS thread=0-3-29-1 tr=cat 2011-08-22 11:13:33,294-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:13:33,294-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-29 2011-08-22 11:13:33,795-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:13:33,796-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-92xnosek thread=0-3-1-1-1 host=localhost replicationGroup=51xnosek 2011-08-22 11:13:33,797-0500 DEBUG vdl:execute2 JOB_START jobid=cat-92xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/9/cat-92xnosek host=localhost 2011-08-22 11:13:33,810-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-1-1-1-1314029309633) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0002.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0002.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:13:34,729-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-8-cat-82xnosek/./outdir/f.0004.out 2011-08-22 11:13:34,729-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0004.out 2011-08-22 11:13:35,360-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 14 2011-08-22 11:13:37,528-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:13:40,695-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:13:47,532-0500 INFO Buffers elapsedTime=10004, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:13:50,706-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:13:53,594-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:13:53,594-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-9-cat-92xnosek/./outdir/f.0002.out 2011-08-22 11:13:53,595-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0002.out 2011-08-22 11:13:57,554-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:13:58,265-0500 INFO LateBindingScheduler JobQueue: 36 2011-08-22 11:13:58,266-0500 DEBUG vdl:execute2 JOB_END jobid=cat-82xnosek 2011-08-22 11:13:58,266-0500 INFO vdl:execute END_SUCCESS thread=0-3-3-1 tr=cat 2011-08-22 11:13:58,267-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:13:58,267-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-3 2011-08-22 11:13:58,768-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:13:58,769-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-a2xnosek thread=0-3-23-1-1 host=localhost replicationGroup=61xnosek 2011-08-22 11:13:58,769-0500 DEBUG vdl:execute2 JOB_START jobid=cat-a2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/a/cat-a2xnosek host=localhost 2011-08-22 11:13:58,774-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-23-1-1-1314029309635) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0024.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0024.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:14:00,715-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:14:07,557-0500 INFO Buffers elapsedTime=10003, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:14:10,723-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:14:17,327-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:14:17,460-0500 INFO LateBindingScheduler JobQueue: 35 2011-08-22 11:14:17,461-0500 DEBUG vdl:execute2 JOB_END jobid=cat-92xnosek 2011-08-22 11:14:17,461-0500 INFO vdl:execute END_SUCCESS thread=0-3-1-1 tr=cat 2011-08-22 11:14:17,462-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:14:17,462-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-1 2011-08-22 11:14:17,593-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-a-cat-a2xnosek/./outdir/f.0024.out 2011-08-22 11:14:17,593-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0024.out 2011-08-22 11:14:17,594-0500 INFO Buffers elapsedTime=10037, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:14:17,964-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:14:17,965-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-b2xnosek thread=0-3-34-1-1 host=localhost replicationGroup=71xnosek 2011-08-22 11:14:17,966-0500 DEBUG vdl:execute2 JOB_START jobid=cat-b2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/b/cat-b2xnosek host=localhost 2011-08-22 11:14:17,970-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-34-1-1-1314029309637) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0035.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0035.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:14:20,734-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:14:27,611-0500 INFO Buffers elapsedTime=10017, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:14:30,476-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:14:30,735-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:14:37,574-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-b-cat-b2xnosek/./outdir/f.0035.out 2011-08-22 11:14:37,574-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0035.out 2011-08-22 11:14:37,619-0500 INFO Buffers elapsedTime=10008, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:14:40,744-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 360460 2011-08-22 11:14:41,135-0500 INFO LateBindingScheduler JobQueue: 34 2011-08-22 11:14:41,136-0500 DEBUG vdl:execute2 JOB_END jobid=cat-a2xnosek 2011-08-22 11:14:41,136-0500 INFO vdl:execute END_SUCCESS thread=0-3-23-1 tr=cat 2011-08-22 11:14:41,136-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:14:41,137-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-23 2011-08-22 11:14:41,137-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:14:41,638-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:14:41,639-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-c2xnosek thread=0-3-21-1-1 host=localhost replicationGroup=81xnosek 2011-08-22 11:14:41,640-0500 DEBUG vdl:execute2 JOB_START jobid=cat-c2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/c/cat-c2xnosek host=localhost 2011-08-22 11:14:41,643-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-21-1-1-1314029309639) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0022.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0022.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:14:47,639-0500 INFO Buffers elapsedTime=10019, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:14:50,757-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:14:57,659-0500 INFO Buffers elapsedTime=10020, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:15:00,759-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:15:00,805-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:15:00,805-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-c-cat-c2xnosek/./outdir/f.0022.out 2011-08-22 11:15:00,805-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0022.out 2011-08-22 11:15:01,216-0500 INFO LateBindingScheduler JobQueue: 33 2011-08-22 11:15:01,217-0500 DEBUG vdl:execute2 JOB_END jobid=cat-b2xnosek 2011-08-22 11:15:01,217-0500 INFO vdl:execute END_SUCCESS thread=0-3-34-1 tr=cat 2011-08-22 11:15:01,221-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:15:01,221-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-34 2011-08-22 11:15:01,719-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:15:01,720-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-d2xnosek thread=0-3-8-1-1 host=localhost replicationGroup=a1xnosek 2011-08-22 11:15:01,721-0500 DEBUG vdl:execute2 JOB_START jobid=cat-d2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/d/cat-d2xnosek host=localhost 2011-08-22 11:15:01,725-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-8-1-1-1314029309641) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0009.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0009.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:15:07,678-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:15:10,773-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:15:17,700-0500 INFO Buffers elapsedTime=10021, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:15:20,775-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:15:21,529-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:15:21,529-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-d-cat-d2xnosek/./outdir/f.0009.out 2011-08-22 11:15:21,529-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0009.out 2011-08-22 11:15:24,269-0500 INFO LateBindingScheduler JobQueue: 32 2011-08-22 11:15:24,270-0500 DEBUG vdl:execute2 JOB_END jobid=cat-c2xnosek 2011-08-22 11:15:24,271-0500 INFO vdl:execute END_SUCCESS thread=0-3-21-1 tr=cat 2011-08-22 11:15:24,271-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:15:24,271-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:15:24,271-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-21 2011-08-22 11:15:24,272-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-e2xnosek thread=0-3-19-1-1 host=localhost replicationGroup=91xnosek 2011-08-22 11:15:24,272-0500 DEBUG vdl:execute2 JOB_START jobid=cat-e2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/e/cat-e2xnosek host=localhost 2011-08-22 11:15:24,275-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-19-1-1-1314029309643) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0020.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0020.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:15:27,704-0500 INFO Buffers elapsedTime=10003, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:15:30,778-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:15:35,594-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:15:37,713-0500 INFO Buffers elapsedTime=10009, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:15:40,799-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:15:43,469-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-e-cat-e2xnosek/./outdir/f.0020.out 2011-08-22 11:15:43,469-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0020.out 2011-08-22 11:15:45,113-0500 INFO LateBindingScheduler JobQueue: 31 2011-08-22 11:15:45,114-0500 DEBUG vdl:execute2 JOB_END jobid=cat-d2xnosek 2011-08-22 11:15:45,114-0500 INFO vdl:execute END_SUCCESS thread=0-3-8-1 tr=cat 2011-08-22 11:15:45,115-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:15:45,115-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-8 2011-08-22 11:15:45,617-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:15:45,620-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-f2xnosek thread=0-3-38-1-1 host=localhost replicationGroup=b1xnosek 2011-08-22 11:15:45,621-0500 DEBUG vdl:execute2 JOB_START jobid=cat-f2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/f/cat-f2xnosek host=localhost 2011-08-22 11:15:45,624-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-38-1-1-1314029309645) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0039.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0039.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:15:45,625-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:15:47,727-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:15:50,818-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:15:57,732-0500 INFO Buffers elapsedTime=10005, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:16:00,823-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:16:04,380-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:16:04,402-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-f-cat-f2xnosek/./outdir/f.0039.out 2011-08-22 11:16:04,402-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0039.out 2011-08-22 11:16:07,195-0500 INFO LateBindingScheduler JobQueue: 30 2011-08-22 11:16:07,196-0500 DEBUG vdl:execute2 JOB_END jobid=cat-e2xnosek 2011-08-22 11:16:07,197-0500 INFO vdl:execute END_SUCCESS thread=0-3-19-1 tr=cat 2011-08-22 11:16:07,197-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:16:07,488-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-19 2011-08-22 11:16:07,698-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:16:07,699-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-g2xnosek thread=0-3-39-1-1 host=localhost replicationGroup=e1xnosek 2011-08-22 11:16:07,700-0500 DEBUG vdl:execute2 JOB_START jobid=cat-g2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/g/cat-g2xnosek host=localhost 2011-08-22 11:16:07,702-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-39-1-1-1314029309647) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0040.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0040.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:16:07,748-0500 INFO Buffers elapsedTime=10016, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:16:10,839-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:16:17,766-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:16:20,840-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:16:27,145-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-g-cat-g2xnosek/./outdir/f.0040.out 2011-08-22 11:16:27,145-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0040.out 2011-08-22 11:16:27,146-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:16:27,772-0500 INFO Buffers elapsedTime=10006, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:16:28,114-0500 INFO LateBindingScheduler JobQueue: 29 2011-08-22 11:16:28,115-0500 DEBUG vdl:execute2 JOB_END jobid=cat-f2xnosek 2011-08-22 11:16:28,115-0500 INFO vdl:execute END_SUCCESS thread=0-3-38-1 tr=cat 2011-08-22 11:16:28,116-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:16:28,116-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-38 2011-08-22 11:16:28,617-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:16:28,618-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-h2xnosek thread=0-3-40-1-1 host=localhost replicationGroup=c1xnosek 2011-08-22 11:16:28,618-0500 DEBUG vdl:execute2 JOB_START jobid=cat-h2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/h/cat-h2xnosek host=localhost 2011-08-22 11:16:28,620-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-40-1-1-1314029309649) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0041.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0041.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:16:30,843-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:16:37,788-0500 INFO Buffers elapsedTime=10015, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:16:40,712-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:16:40,854-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:16:47,823-0500 INFO Buffers elapsedTime=10035, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:16:49,881-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-h-cat-h2xnosek/./outdir/f.0041.out 2011-08-22 11:16:49,882-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0041.out 2011-08-22 11:16:50,859-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 376844 2011-08-22 11:16:50,952-0500 INFO LateBindingScheduler JobQueue: 28 2011-08-22 11:16:50,952-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:16:50,953-0500 DEBUG vdl:execute2 JOB_END jobid=cat-g2xnosek 2011-08-22 11:16:50,953-0500 INFO vdl:execute END_SUCCESS thread=0-3-39-1 tr=cat 2011-08-22 11:16:50,954-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:16:50,958-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-39 2011-08-22 11:16:51,456-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:16:51,457-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-i2xnosek thread=0-3-24-1-1 host=localhost replicationGroup=11xnosek 2011-08-22 11:16:51,457-0500 DEBUG vdl:execute2 JOB_START jobid=cat-i2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/i/cat-i2xnosek host=localhost 2011-08-22 11:16:51,460-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-24-1-1-1314029309651) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0025.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0025.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:16:57,839-0500 INFO Buffers elapsedTime=10016, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:17:00,866-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:07,867-0500 INFO Buffers elapsedTime=10028, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:17:10,882-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:12,293-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:17:12,524-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-i-cat-i2xnosek/./outdir/f.0025.out 2011-08-22 11:17:12,524-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0025.out 2011-08-22 11:17:12,547-0500 INFO LateBindingScheduler JobQueue: 27 2011-08-22 11:17:12,549-0500 DEBUG vdl:execute2 JOB_END jobid=cat-h2xnosek 2011-08-22 11:17:12,549-0500 INFO vdl:execute END_SUCCESS thread=0-3-40-1 tr=cat 2011-08-22 11:17:12,549-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:17:12,549-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-40 2011-08-22 11:17:13,050-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:17:13,051-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-j2xnosek thread=0-3-31-1-1 host=localhost replicationGroup=f1xnosek 2011-08-22 11:17:13,053-0500 DEBUG vdl:execute2 JOB_START jobid=cat-j2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/j/cat-j2xnosek host=localhost 2011-08-22 11:17:13,055-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-31-1-1-1314029309653) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0032.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0032.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:17:17,873-0500 INFO Buffers elapsedTime=10006, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:17:20,893-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:27,874-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:17:30,914-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:32,191-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-j-cat-j2xnosek/./outdir/f.0032.out 2011-08-22 11:17:32,191-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0032.out 2011-08-22 11:17:32,192-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:17:35,423-0500 INFO LateBindingScheduler JobQueue: 26 2011-08-22 11:17:35,424-0500 DEBUG vdl:execute2 JOB_END jobid=cat-i2xnosek 2011-08-22 11:17:35,425-0500 INFO vdl:execute END_SUCCESS thread=0-3-24-1 tr=cat 2011-08-22 11:17:35,425-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:17:35,425-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-24 2011-08-22 11:17:35,926-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:17:35,927-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-k2xnosek thread=0-3-12-1-1 host=localhost replicationGroup=g1xnosek 2011-08-22 11:17:35,928-0500 DEBUG vdl:execute2 JOB_START jobid=cat-k2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/k/cat-k2xnosek host=localhost 2011-08-22 11:17:35,929-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-12-1-1-1314029309655) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0013.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0013.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:17:37,897-0500 INFO Buffers elapsedTime=10023, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:17:40,931-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:45,831-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:17:47,916-0500 INFO Buffers elapsedTime=10019, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:17:50,947-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:17:57,426-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:17:57,426-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-k-cat-k2xnosek/./outdir/f.0013.out 2011-08-22 11:17:57,426-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0013.out 2011-08-22 11:17:57,944-0500 INFO Buffers elapsedTime=10028, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:17:57,944-0500 INFO LateBindingScheduler JobQueue: 25 2011-08-22 11:17:57,945-0500 DEBUG vdl:execute2 JOB_END jobid=cat-j2xnosek 2011-08-22 11:17:57,945-0500 INFO vdl:execute END_SUCCESS thread=0-3-31-1 tr=cat 2011-08-22 11:17:57,946-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:17:57,946-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-31 2011-08-22 11:17:58,446-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:17:58,447-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-l2xnosek thread=0-3-9-1-1 host=localhost replicationGroup=d1xnosek 2011-08-22 11:17:58,448-0500 DEBUG vdl:execute2 JOB_START jobid=cat-l2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/l/cat-l2xnosek host=localhost 2011-08-22 11:17:58,451-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-9-1-1-1314029309657) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0010.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0010.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:18:00,965-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:18:07,961-0500 INFO Buffers elapsedTime=10017, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:18:10,972-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:18:17,748-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:18:17,748-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-l-cat-l2xnosek/./outdir/f.0010.out 2011-08-22 11:18:17,749-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0010.out 2011-08-22 11:18:17,966-0500 INFO Buffers elapsedTime=10005, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:18:20,948-0500 INFO LateBindingScheduler JobQueue: 24 2011-08-22 11:18:20,952-0500 DEBUG vdl:execute2 JOB_END jobid=cat-k2xnosek 2011-08-22 11:18:20,952-0500 INFO vdl:execute END_SUCCESS thread=0-3-12-1 tr=cat 2011-08-22 11:18:20,952-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:18:20,952-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-12 2011-08-22 11:18:20,976-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163864 2011-08-22 11:18:21,453-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:18:21,455-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-m2xnosek thread=0-3-5-1-1 host=localhost replicationGroup=j0xnosek 2011-08-22 11:18:21,455-0500 DEBUG vdl:execute2 JOB_START jobid=cat-m2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/m/cat-m2xnosek host=localhost 2011-08-22 11:18:21,457-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-5-1-1-1314029309659) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0006.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0006.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:18:27,979-0500 INFO Buffers elapsedTime=10013, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:18:30,981-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:18:37,981-0500 INFO Buffers elapsedTime=10002, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:18:40,983-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 262156 2011-08-22 11:18:40,983-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:18:40,983-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-m-cat-m2xnosek/./outdir/f.0006.out 2011-08-22 11:18:40,984-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0006.out 2011-08-22 11:18:41,552-0500 INFO LateBindingScheduler JobQueue: 23 2011-08-22 11:18:41,553-0500 DEBUG vdl:execute2 JOB_END jobid=cat-l2xnosek 2011-08-22 11:18:41,553-0500 INFO vdl:execute END_SUCCESS thread=0-3-9-1 tr=cat 2011-08-22 11:18:41,553-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:18:41,554-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-9 2011-08-22 11:18:42,055-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:18:42,056-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-n2xnosek thread=0-3-4-1-1 host=localhost replicationGroup=h0xnosek 2011-08-22 11:18:42,058-0500 DEBUG vdl:execute2 JOB_START jobid=cat-n2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/n/cat-n2xnosek host=localhost 2011-08-22 11:18:42,061-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-4-1-1-1314029309661) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0005.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0005.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:18:47,995-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:18:50,948-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:18:50,991-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:18:58,018-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:19:01,011-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:19:01,834-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:19:01,834-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-n-cat-n2xnosek/./outdir/f.0005.out 2011-08-22 11:19:01,835-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0005.out 2011-08-22 11:19:04,409-0500 INFO LateBindingScheduler JobQueue: 22 2011-08-22 11:19:04,411-0500 DEBUG vdl:execute2 JOB_END jobid=cat-m2xnosek 2011-08-22 11:19:04,411-0500 INFO vdl:execute END_SUCCESS thread=0-3-5-1 tr=cat 2011-08-22 11:19:04,412-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:19:04,412-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-5 2011-08-22 11:19:04,912-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:19:04,913-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-o2xnosek thread=0-3-16-1-1 host=localhost replicationGroup=h1xnosek 2011-08-22 11:19:04,913-0500 DEBUG vdl:execute2 JOB_START jobid=cat-o2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/o/cat-o2xnosek host=localhost 2011-08-22 11:19:04,915-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-16-1-1-1314029309663) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0017.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0017.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:19:08,025-0500 INFO Buffers elapsedTime=10006, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:19:11,019-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:19:18,048-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:19:21,024-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:19:23,507-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:19:24,891-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-o-cat-o2xnosek/./outdir/f.0017.out 2011-08-22 11:19:24,891-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0017.out 2011-08-22 11:19:25,300-0500 INFO LateBindingScheduler JobQueue: 21 2011-08-22 11:19:25,300-0500 DEBUG vdl:execute2 JOB_END jobid=cat-n2xnosek 2011-08-22 11:19:25,300-0500 INFO vdl:execute END_SUCCESS thread=0-3-4-1 tr=cat 2011-08-22 11:19:25,301-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:19:25,301-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-4 2011-08-22 11:19:25,802-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:19:25,803-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-p2xnosek thread=0-3-35-1-1 host=localhost replicationGroup=m0xnosek 2011-08-22 11:19:25,805-0500 DEBUG vdl:execute2 JOB_START jobid=cat-p2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/p/cat-p2xnosek host=localhost 2011-08-22 11:19:25,807-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-35-1-1-1314029309665) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0036.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0036.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:19:28,070-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:19:31,027-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:19:38,087-0500 INFO Buffers elapsedTime=10017, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:19:41,034-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:19:44,925-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:19:44,925-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-p-cat-p2xnosek/./outdir/f.0036.out 2011-08-22 11:19:44,925-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0036.out 2011-08-22 11:19:48,097-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:19:48,625-0500 INFO LateBindingScheduler JobQueue: 20 2011-08-22 11:19:48,626-0500 DEBUG vdl:execute2 JOB_END jobid=cat-o2xnosek 2011-08-22 11:19:48,626-0500 INFO vdl:execute END_SUCCESS thread=0-3-16-1 tr=cat 2011-08-22 11:19:48,627-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:19:48,627-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-16 2011-08-22 11:19:49,128-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:19:49,129-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-q2xnosek thread=0-3-28-1-1 host=localhost replicationGroup=n0xnosek 2011-08-22 11:19:49,130-0500 DEBUG vdl:execute2 JOB_START jobid=cat-q2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/q/cat-q2xnosek host=localhost 2011-08-22 11:19:49,157-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-28-1-1-1314029309667) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0029.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0029.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:19:51,046-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:19:56,066-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:19:58,104-0500 INFO Buffers elapsedTime=10007, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:20:01,055-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:20:08,105-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:20:08,413-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:20:08,413-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-q-cat-q2xnosek/./outdir/f.0029.out 2011-08-22 11:20:08,414-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0029.out 2011-08-22 11:20:08,502-0500 INFO LateBindingScheduler JobQueue: 19 2011-08-22 11:20:08,503-0500 DEBUG vdl:execute2 JOB_END jobid=cat-p2xnosek 2011-08-22 11:20:08,504-0500 INFO vdl:execute END_SUCCESS thread=0-3-35-1 tr=cat 2011-08-22 11:20:08,504-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:20:08,504-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-35 2011-08-22 11:20:09,005-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:20:09,006-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-r2xnosek thread=0-3-36-1-1 host=localhost replicationGroup=i1xnosek 2011-08-22 11:20:09,007-0500 DEBUG vdl:execute2 JOB_START jobid=cat-r2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/r/cat-r2xnosek host=localhost 2011-08-22 11:20:09,008-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-36-1-1-1314029309669) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0037.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0037.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:20:11,069-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:20:18,106-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:20:21,082-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:20:28,116-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:20:28,338-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-r-cat-r2xnosek/./outdir/f.0037.out 2011-08-22 11:20:28,338-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:20:28,339-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0037.out 2011-08-22 11:20:31,094-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:20:31,919-0500 INFO LateBindingScheduler JobQueue: 18 2011-08-22 11:20:31,920-0500 DEBUG vdl:execute2 JOB_END jobid=cat-q2xnosek 2011-08-22 11:20:31,920-0500 INFO vdl:execute END_SUCCESS thread=0-3-28-1 tr=cat 2011-08-22 11:20:31,921-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:20:32,386-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-28 2011-08-22 11:20:32,422-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:20:32,423-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-s2xnosek thread=0-3-33-1-1 host=localhost replicationGroup=j1xnosek 2011-08-22 11:20:32,424-0500 DEBUG vdl:execute2 JOB_START jobid=cat-s2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/s/cat-s2xnosek host=localhost 2011-08-22 11:20:32,429-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-33-1-1-1314029309671) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0034.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0034.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:20:38,143-0500 INFO Buffers elapsedTime=10027, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:20:41,115-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:20:48,152-0500 INFO Buffers elapsedTime=10009, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:20:51,129-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:20:51,429-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-s-cat-s2xnosek/./outdir/f.0034.out 2011-08-22 11:20:51,429-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0034.out 2011-08-22 11:20:51,429-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:20:52,096-0500 INFO LateBindingScheduler JobQueue: 17 2011-08-22 11:20:52,096-0500 DEBUG vdl:execute2 JOB_END jobid=cat-r2xnosek 2011-08-22 11:20:52,096-0500 INFO vdl:execute END_SUCCESS thread=0-3-36-1 tr=cat 2011-08-22 11:20:52,097-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:20:52,097-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-36 2011-08-22 11:20:52,598-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:20:52,599-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-t2xnosek thread=0-3-17-1-1 host=localhost replicationGroup=k1xnosek 2011-08-22 11:20:52,600-0500 DEBUG vdl:execute2 JOB_START jobid=cat-t2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/t/cat-t2xnosek host=localhost 2011-08-22 11:20:52,602-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-17-1-1-1314029309673) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0018.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0018.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:20:58,170-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:21:01,137-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:21:01,189-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:21:08,188-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:21:11,153-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:21:13,980-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-t-cat-t2xnosek/./outdir/f.0018.out 2011-08-22 11:21:13,980-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:21:13,980-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0018.out 2011-08-22 11:21:15,176-0500 INFO LateBindingScheduler JobQueue: 16 2011-08-22 11:21:15,177-0500 DEBUG vdl:execute2 JOB_END jobid=cat-s2xnosek 2011-08-22 11:21:15,177-0500 INFO vdl:execute END_SUCCESS thread=0-3-33-1 tr=cat 2011-08-22 11:21:15,178-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:21:15,178-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-33 2011-08-22 11:21:15,679-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:21:15,680-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-u2xnosek thread=0-3-48-1-1 host=localhost replicationGroup=m1xnosek 2011-08-22 11:21:15,681-0500 DEBUG vdl:execute2 JOB_START jobid=cat-u2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/u/cat-u2xnosek host=localhost 2011-08-22 11:21:15,685-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-48-1-1-1314029309675) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0049.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0049.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:21:18,194-0500 INFO Buffers elapsedTime=10006, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:21:21,172-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:21:28,196-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:21:31,190-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:21:33,743-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:21:36,830-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-u-cat-u2xnosek/./outdir/f.0049.out 2011-08-22 11:21:36,830-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0049.out 2011-08-22 11:21:36,875-0500 INFO LateBindingScheduler JobQueue: 15 2011-08-22 11:21:36,876-0500 DEBUG vdl:execute2 JOB_END jobid=cat-t2xnosek 2011-08-22 11:21:36,877-0500 INFO vdl:execute END_SUCCESS thread=0-3-17-1 tr=cat 2011-08-22 11:21:36,877-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:21:36,880-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-17 2011-08-22 11:21:37,378-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:21:37,379-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-v2xnosek thread=0-3-45-1-1 host=localhost replicationGroup=n1xnosek 2011-08-22 11:21:37,381-0500 DEBUG vdl:execute2 JOB_START jobid=cat-v2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/v/cat-v2xnosek host=localhost 2011-08-22 11:21:37,385-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-45-1-1-1314029309677) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0046.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0046.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:21:38,878-0500 INFO Buffers elapsedTime=10004, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:21:41,192-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:21:48,880-0500 INFO Buffers elapsedTime=10002, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:21:51,212-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:21:56,453-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:21:56,453-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-v-cat-v2xnosek/./outdir/f.0046.out 2011-08-22 11:21:56,453-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0046.out 2011-08-22 11:21:58,894-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:21:59,771-0500 INFO LateBindingScheduler JobQueue: 14 2011-08-22 11:21:59,772-0500 DEBUG vdl:execute2 JOB_END jobid=cat-u2xnosek 2011-08-22 11:21:59,772-0500 INFO vdl:execute END_SUCCESS thread=0-3-48-1 tr=cat 2011-08-22 11:21:59,772-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:21:59,773-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-48 2011-08-22 11:22:00,274-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:22:00,275-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-x2xnosek thread=0-3-14-1-1 host=localhost replicationGroup=i0xnosek 2011-08-22 11:22:00,276-0500 DEBUG vdl:execute2 JOB_START jobid=cat-x2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/x/cat-x2xnosek host=localhost 2011-08-22 11:22:00,277-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-14-1-1-1314029309679) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0015.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0015.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:22:01,225-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 426140 2011-08-22 11:22:06,305-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:22:08,902-0500 INFO Buffers elapsedTime=10007, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:22:11,247-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:22:18,920-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:22:19,581-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:22:19,581-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-x-cat-x2xnosek/./outdir/f.0015.out 2011-08-22 11:22:19,581-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0015.out 2011-08-22 11:22:20,378-0500 INFO LateBindingScheduler JobQueue: 13 2011-08-22 11:22:20,378-0500 DEBUG vdl:execute2 JOB_END jobid=cat-v2xnosek 2011-08-22 11:22:20,379-0500 INFO vdl:execute END_SUCCESS thread=0-3-45-1 tr=cat 2011-08-22 11:22:20,379-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:22:20,379-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-45 2011-08-22 11:22:20,880-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:22:20,886-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-y2xnosek thread=0-3-49-1-1 host=localhost replicationGroup=o1xnosek 2011-08-22 11:22:20,886-0500 DEBUG vdl:execute2 JOB_START jobid=cat-y2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/y/cat-y2xnosek host=localhost 2011-08-22 11:22:20,888-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-49-1-1-1314029309681) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0050.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0050.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:22:21,249-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 327800 2011-08-22 11:22:28,931-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:22:31,272-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:22:38,862-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:22:38,941-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:22:40,389-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-y-cat-y2xnosek/./outdir/f.0050.out 2011-08-22 11:22:40,389-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0050.out 2011-08-22 11:22:41,273-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:22:43,048-0500 INFO LateBindingScheduler JobQueue: 12 2011-08-22 11:22:43,049-0500 DEBUG vdl:execute2 JOB_END jobid=cat-x2xnosek 2011-08-22 11:22:43,049-0500 INFO vdl:execute END_SUCCESS thread=0-3-14-1 tr=cat 2011-08-22 11:22:43,050-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:22:43,053-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-14 2011-08-22 11:22:43,551-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:22:43,553-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-z2xnosek thread=0-3-13-1-1 host=localhost replicationGroup=p1xnosek 2011-08-22 11:22:43,554-0500 DEBUG vdl:execute2 JOB_START jobid=cat-z2xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/z/cat-z2xnosek host=localhost 2011-08-22 11:22:43,555-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-13-1-1-1314029309683) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0014.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0014.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:22:48,949-0500 INFO Buffers elapsedTime=10008, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:22:51,284-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:22:58,965-0500 INFO Buffers elapsedTime=10015, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:23:01,304-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:23:02,436-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:23:02,436-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-z-cat-z2xnosek/./outdir/f.0014.out 2011-08-22 11:23:02,436-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0014.out 2011-08-22 11:23:03,852-0500 INFO LateBindingScheduler JobQueue: 11 2011-08-22 11:23:03,854-0500 DEBUG vdl:execute2 JOB_END jobid=cat-y2xnosek 2011-08-22 11:23:03,854-0500 INFO vdl:execute END_SUCCESS thread=0-3-49-1 tr=cat 2011-08-22 11:23:03,854-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:23:03,854-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-49 2011-08-22 11:23:04,354-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:23:04,355-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-03xnosek thread=0-3-37-1-1 host=localhost replicationGroup=q1xnosek 2011-08-22 11:23:04,356-0500 DEBUG vdl:execute2 JOB_START jobid=cat-03xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/0/cat-03xnosek host=localhost 2011-08-22 11:23:04,359-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-37-1-1-1314029309685) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0038.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0038.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:23:08,983-0500 INFO Buffers elapsedTime=10018, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:23:11,315-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:23:18,984-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:23:21,334-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:23:23,930-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:23:23,930-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-0-cat-03xnosek/./outdir/f.0038.out 2011-08-22 11:23:23,930-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0038.out 2011-08-22 11:23:25,924-0500 INFO LateBindingScheduler JobQueue: 10 2011-08-22 11:23:25,924-0500 DEBUG vdl:execute2 JOB_END jobid=cat-z2xnosek 2011-08-22 11:23:25,924-0500 INFO vdl:execute END_SUCCESS thread=0-3-13-1 tr=cat 2011-08-22 11:23:25,924-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:23:25,925-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:23:25,925-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-13 2011-08-22 11:23:25,925-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-13xnosek thread=0-3-26-1-1 host=localhost replicationGroup=o0xnosek 2011-08-22 11:23:25,926-0500 DEBUG vdl:execute2 JOB_START jobid=cat-13xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/1/cat-13xnosek host=localhost 2011-08-22 11:23:25,927-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-26-1-1-1314029309687) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0027.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0027.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:23:28,997-0500 INFO Buffers elapsedTime=10013, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:23:31,342-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:23:39,006-0500 INFO Buffers elapsedTime=10009, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:23:41,363-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:23:43,978-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:23:45,739-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-1-cat-13xnosek/./outdir/f.0027.out 2011-08-22 11:23:45,739-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0027.out 2011-08-22 11:23:47,493-0500 INFO LateBindingScheduler JobQueue: 9 2011-08-22 11:23:47,494-0500 DEBUG vdl:execute2 JOB_END jobid=cat-03xnosek 2011-08-22 11:23:47,495-0500 INFO vdl:execute END_SUCCESS thread=0-3-37-1 tr=cat 2011-08-22 11:23:47,495-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:23:47,501-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-37 2011-08-22 11:23:47,995-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:23:47,996-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-23xnosek thread=0-3-20-1-1 host=localhost replicationGroup=l1xnosek 2011-08-22 11:23:47,997-0500 DEBUG vdl:execute2 JOB_START jobid=cat-23xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/2/cat-23xnosek host=localhost 2011-08-22 11:23:47,998-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-20-1-1-1314029309689) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0021.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0021.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:23:49,007-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:23:51,366-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:24:01,375-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:24:01,420-0500 INFO Buffers elapsedTime=12413, buffersUsed[min,avg,max]=16, 0, 16 2011-08-22 11:24:07,002-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-2-cat-23xnosek/./outdir/f.0021.out 2011-08-22 11:24:07,002-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0021.out 2011-08-22 11:24:07,002-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:24:11,384-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:24:11,440-0500 INFO Buffers elapsedTime=10020, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:24:13,261-0500 INFO LateBindingScheduler JobQueue: 8 2011-08-22 11:24:13,262-0500 DEBUG vdl:execute2 JOB_END jobid=cat-13xnosek 2011-08-22 11:24:13,263-0500 INFO vdl:execute END_SUCCESS thread=0-3-26-1 tr=cat 2011-08-22 11:24:13,263-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:24:13,263-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-26 2011-08-22 11:24:13,771-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:24:13,772-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-33xnosek thread=0-3-15-1-1 host=localhost replicationGroup=r1xnosek 2011-08-22 11:24:13,772-0500 DEBUG vdl:execute2 JOB_START jobid=cat-33xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/3/cat-33xnosek host=localhost 2011-08-22 11:24:13,774-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-15-1-1-1314029309691) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0016.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0016.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:24:21,398-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:24:21,443-0500 INFO Buffers elapsedTime=10003, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:24:31,229-0500 INFO LateBindingScheduler JobQueue: 7 2011-08-22 11:24:31,230-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:24:31,231-0500 DEBUG vdl:execute2 JOB_END jobid=cat-23xnosek 2011-08-22 11:24:31,231-0500 INFO vdl:execute END_SUCCESS thread=0-3-20-1 tr=cat 2011-08-22 11:24:31,231-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:24:31,231-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-20 2011-08-22 11:24:31,408-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:24:31,732-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:24:31,733-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-43xnosek thread=0-3-0-1-1 host=localhost replicationGroup=s1xnosek 2011-08-22 11:24:31,734-0500 DEBUG vdl:execute2 JOB_START jobid=cat-43xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/4/cat-43xnosek host=localhost 2011-08-22 11:24:31,737-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-0-1-1-1314029309693) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0001.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0001.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:24:32,248-0500 INFO Buffers elapsedTime=10804, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:24:32,608-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-3-cat-33xnosek/./outdir/f.0016.out 2011-08-22 11:24:32,608-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0016.out 2011-08-22 11:24:41,418-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:24:42,256-0500 INFO Buffers elapsedTime=10008, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:24:49,096-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:24:51,082-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-4-cat-43xnosek/./outdir/f.0001.out 2011-08-22 11:24:51,083-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0001.out 2011-08-22 11:24:51,435-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:24:52,258-0500 INFO Buffers elapsedTime=10002, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:24:56,270-0500 INFO LateBindingScheduler JobQueue: 6 2011-08-22 11:24:56,271-0500 DEBUG vdl:execute2 JOB_END jobid=cat-33xnosek 2011-08-22 11:24:56,272-0500 INFO vdl:execute END_SUCCESS thread=0-3-15-1 tr=cat 2011-08-22 11:24:56,272-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:24:56,272-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-15 2011-08-22 11:24:56,772-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:24:56,773-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-53xnosek thread=0-3-22-1-1 host=localhost replicationGroup=v1xnosek 2011-08-22 11:24:56,774-0500 DEBUG vdl:execute2 JOB_START jobid=cat-53xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/5/cat-53xnosek host=localhost 2011-08-22 11:24:56,776-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-22-1-1-1314029309695) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0023.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0023.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:25:01,442-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:25:02,295-0500 INFO Buffers elapsedTime=10037, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:25:11,443-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:25:12,318-0500 INFO Buffers elapsedTime=10023, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:25:14,718-0500 INFO LateBindingScheduler JobQueue: 5 2011-08-22 11:25:14,719-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:25:14,719-0500 DEBUG vdl:execute2 JOB_END jobid=cat-43xnosek 2011-08-22 11:25:14,720-0500 INFO vdl:execute END_SUCCESS thread=0-3-0-1 tr=cat 2011-08-22 11:25:14,720-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:25:14,720-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-0 2011-08-22 11:25:15,221-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:25:15,221-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-63xnosek thread=0-3-10-1-1 host=localhost replicationGroup=x1xnosek 2011-08-22 11:25:15,222-0500 DEBUG vdl:execute2 JOB_START jobid=cat-63xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/6/cat-63xnosek host=localhost 2011-08-22 11:25:15,223-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-10-1-1-1314029309697) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0011.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0011.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:25:15,781-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-5-cat-53xnosek/./outdir/f.0023.out 2011-08-22 11:25:15,781-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0023.out 2011-08-22 11:25:21,463-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:25:22,331-0500 INFO Buffers elapsedTime=10013, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:25:31,482-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:25:32,347-0500 INFO Buffers elapsedTime=10015, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:25:36,463-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:25:36,463-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-6-cat-63xnosek/./outdir/f.0011.out 2011-08-22 11:25:36,464-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0011.out 2011-08-22 11:25:39,547-0500 INFO LateBindingScheduler JobQueue: 4 2011-08-22 11:25:39,548-0500 DEBUG vdl:execute2 JOB_END jobid=cat-53xnosek 2011-08-22 11:25:39,549-0500 INFO vdl:execute END_SUCCESS thread=0-3-22-1 tr=cat 2011-08-22 11:25:39,549-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:25:39,554-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-22 2011-08-22 11:25:40,049-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:25:40,050-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-73xnosek thread=0-3-41-1-1 host=localhost replicationGroup=s0xnosek 2011-08-22 11:25:40,051-0500 DEBUG vdl:execute2 JOB_START jobid=cat-73xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/7/cat-73xnosek host=localhost 2011-08-22 11:25:40,052-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-41-1-1-1314029309699) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0042.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0042.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:25:41,494-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 229388 2011-08-22 11:25:42,369-0500 INFO Buffers elapsedTime=10022, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:25:51,515-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:25:52,373-0500 INFO Buffers elapsedTime=10004, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:25:54,214-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:25:59,463-0500 INFO LateBindingScheduler JobQueue: 3 2011-08-22 11:25:59,464-0500 DEBUG vdl:execute2 JOB_END jobid=cat-63xnosek 2011-08-22 11:25:59,464-0500 INFO vdl:execute END_SUCCESS thread=0-3-10-1 tr=cat 2011-08-22 11:25:59,465-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:25:59,468-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-10 2011-08-22 11:25:59,965-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:25:59,966-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-83xnosek thread=0-3-44-1-1 host=localhost replicationGroup=p0xnosek 2011-08-22 11:25:59,967-0500 DEBUG vdl:execute2 JOB_START jobid=cat-83xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/8/cat-83xnosek host=localhost 2011-08-22 11:25:59,969-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-44-1-1-1314029309701) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0045.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0045.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:26:01,538-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 0 2011-08-22 11:26:01,652-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-7-cat-73xnosek/./outdir/f.0042.out 2011-08-22 11:26:01,652-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0042.out 2011-08-22 11:26:02,383-0500 INFO Buffers elapsedTime=10010, buffersUsed[min,avg,max]=0, 0, 16 2011-08-22 11:26:11,558-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:26:12,388-0500 INFO Buffers elapsedTime=10005, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:26:19,491-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:26:19,491-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-8-cat-83xnosek/./outdir/f.0045.out 2011-08-22 11:26:19,491-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0045.out 2011-08-22 11:26:21,569-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 393228 2011-08-22 11:26:22,410-0500 INFO Buffers elapsedTime=10021, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:26:24,977-0500 INFO LateBindingScheduler JobQueue: 2 2011-08-22 11:26:24,978-0500 DEBUG vdl:execute2 JOB_END jobid=cat-73xnosek 2011-08-22 11:26:24,979-0500 INFO vdl:execute END_SUCCESS thread=0-3-41-1 tr=cat 2011-08-22 11:26:24,980-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:26:24,980-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-41 2011-08-22 11:26:25,480-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:26:25,481-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-93xnosek thread=0-3-18-1-1 host=localhost replicationGroup=k0xnosek 2011-08-22 11:26:25,482-0500 DEBUG vdl:execute2 JOB_START jobid=cat-93xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/9/cat-93xnosek host=localhost 2011-08-22 11:26:25,485-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-18-1-1-1314029309703) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0019.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0019.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:26:31,570-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:26:32,413-0500 INFO Buffers elapsedTime=10003, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:26:41,591-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:26:42,414-0500 INFO Buffers elapsedTime=10001, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:26:42,835-0500 INFO LateBindingScheduler JobQueue: 1 2011-08-22 11:26:42,835-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:26:42,836-0500 DEBUG vdl:execute2 JOB_END jobid=cat-83xnosek 2011-08-22 11:26:42,836-0500 INFO vdl:execute END_SUCCESS thread=0-3-44-1 tr=cat 2011-08-22 11:26:42,837-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:26:42,909-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-44 2011-08-22 11:26:43,337-0500 INFO WeightedHostScoreScheduler CONTACT_SELECTED host=localhost, score=99.854 2011-08-22 11:26:43,338-0500 DEBUG vdl:execute2 THREAD_ASSOCIATION jobid=cat-a3xnosek thread=0-3-7-1-1 host=localhost replicationGroup=g0xnosek 2011-08-22 11:26:43,338-0500 DEBUG vdl:execute2 JOB_START jobid=cat-a3xnosek tr=cat arguments=[data.txt] tmpdir=catsn-catsn-osg-n50-d200mb/jobs/a/cat-a3xnosek host=localhost 2011-08-22 11:26:43,342-0500 INFO GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-3-7-1-1-1314029309705) is /bin/bash _swiftwrap.staging -e /bin/cat -out outdir/f.0008.out -err stderr.txt -i -d outdir -if data.txt -of outdir/f.0008.out -k -cdmfile -status provider -a data.txt 2011-08-22 11:26:45,174-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-9-cat-93xnosek/./outdir/f.0019.out 2011-08-22 11:26:45,174-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0019.out 2011-08-22 11:26:51,608-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:26:52,435-0500 INFO Buffers elapsedTime=10021, buffersUsed[min,avg,max]=0, 1, 16 2011-08-22 11:26:59,332-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:27:01,629-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:27:02,452-0500 INFO Buffers elapsedTime=10016, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:27:03,638-0500 INFO PutFileHandler Source: /tmp/ketan/catsn-catsn-osg-n50-d200mb-a-cat-a3xnosek/./outdir/f.0008.out 2011-08-22 11:27:03,639-0500 INFO PutFileHandler Destination: file://localhost/outdir/f.0008.out 2011-08-22 11:27:08,667-0500 INFO LateBindingScheduler JobQueue: 0 2011-08-22 11:27:08,668-0500 DEBUG vdl:execute2 JOB_END jobid=cat-93xnosek 2011-08-22 11:27:08,668-0500 INFO vdl:execute END_SUCCESS thread=0-3-18-1 tr=cat 2011-08-22 11:27:08,669-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:27:08,669-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-18 2011-08-22 11:27:11,636-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 163852 2011-08-22 11:27:12,472-0500 INFO Buffers elapsedTime=10020, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:27:21,638-0500 INFO AbstractStreamKarajanChannel$Multiplexer Avg stream buf: 196620 2011-08-22 11:27:22,486-0500 INFO Buffers elapsedTime=10014, buffersUsed[min,avg,max]=2147483647, 0, 0 2011-08-22 11:27:27,671-0500 INFO LateBindingScheduler JobQueue: 0 2011-08-22 11:27:27,671-0500 INFO AbstractStreamKarajanChannel Sender 1267363438 queue size: 0 2011-08-22 11:27:27,672-0500 DEBUG vdl:execute2 JOB_END jobid=cat-a3xnosek 2011-08-22 11:27:27,672-0500 INFO vdl:execute END_SUCCESS thread=0-3-7-1 tr=cat 2011-08-22 11:27:27,673-0500 DEBUG cat PROCEDURE_END line=3 2011-08-22 11:27:27,680-0500 DEBUG vdl:mains FOREACH_IT_END line=9 thread=0-3-7 2011-08-22 11:27:28,114-0500 DEBUG vdl:mains Starting cleanups 2011-08-22 11:27:28,115-0500 INFO vdl:cleanups START cleanups=[] 2011-08-22 11:27:28,115-0500 DEBUG vdl:mains Ending cleanups 2011-08-22 11:27:28,120-0500 INFO Loader Swift finished with no errors