2013-03-19 19:58:46,781+0000 DEBUG Loader arguments: [-config, cf, -sites.file, sandyb.xml, -tc.file, tc, ../modis.swift, -modisdir=input/]
2013-03-19 19:58:46,783+0000 DEBUG Loader Max heap: 3817799680
2013-03-19 19:58:46,784+0000 DEBUG textfiles BEGIN SWIFTSCRIPT:
type imagefile;
type landuse;
type perlscript;

perlscript getlanduse_pl <"getlanduse.pl">;

app (landuse output) getLandUse (imagefile input, perlscript ps)
{
  perl @ps @filename(input) stdout=@filename(output);
}

# Constants and command line arguments
int nFiles       = @toInt(@arg("nfiles", "1000"));
string MODISdir  = @arg("modisdir", "../data/modis/2002");

# Input Dataset
imagefile geos[] <filesys_mapper; location=MODISdir, suffix=".rgb">;

# Compute the land use summary of each MODIS tile
landuse land[] <structured_regexp_mapper; source=geos, match="(h..v..)",
                transform=@strcat("landuse/\\1.landuse.byfreq")>;

foreach g,i in geos {
    land[i] = getLandUse(g, getlanduse_pl);
}


2013-03-19 19:58:46,784+0000 DEBUG textfiles END SWIFTSCRIPT:
2013-03-19 19:58:46,784+0000 DEBUG Loader kmlversion is >63992dd9-9307-4555-ba4f-99879e26b7fd-no-provenance<
2013-03-19 19:58:46,785+0000 DEBUG Loader build version is >63992dd9-9307-4555-ba4f-99879e26b7fd-no-provenance<
2013-03-19 19:58:46,785+0000 DEBUG Loader Recompilation suppressed.
2013-03-19 19:58:46,927+0000 DEBUG Loader setting: sites.file to: sandyb.xml
2013-03-19 19:58:46,927+0000 DEBUG Loader setting: tc.file to: tc
2013-03-19 19:58:46,927+0000 DEBUG Loader Swift configuration ([cf]): {throttle.score.job.factor=4, throttle.file.operations=8, throttle.host.submit=2, pgraph.node.options=color="seagreen", style="filled", wrapper.parameter.mode=args, provenance.log=false, throttle.submit=4, ticker.prefix=Progress:  time:, provider.staging.pin.swiftfiles=true, clustering.enabled=false, replication.min.queue.time=60, sites.file=sandyb.xml, cdm.broadcast.mode=file, kickstart.enabled=maybe, wrapperlog.always.transfer=true, caching.algorithm=LRU, use.provider.staging=true, use.wrapper.staging=false, status.mode=provider, clustering.min.time=60, ticker.date.format=, kickstart.always.transfer=false, file.gc.enabled=true, throttle.transfers=4, execution.retries=0, sitedir.keep=true, pgraph.graph.options=splines="compound", rankdir="TB", replication.enabled=false, clustering.queue.delay=4, pgraph=false, mapping.checker=on, wrapper.invocation.mode=absolute, tc.file=tc, replication.limit=3, lazy.errors=false}
2013-03-19 19:58:46,928+0000 DEBUG textfiles BEGIN SITES:
<config>
  <pool handle="midway">
    <execution provider="coaster" jobmanager="local:slurm"/>
    <profile namespace="globus" key="queue">sandyb</profile>
    <profile namespace="globus" key="jobsPerNode">16</profile>
    <profile namespace="globus" key="maxWalltime">00:05:00</profile>
    <profile namespace="globus" key="maxTime">3600</profile>
    <profile namespace="globus" key="highOverAllocation">100</profile>
    <profile namespace="globus" key="lowOverAllocation">100</profile>
    <profile namespace="globus" key="slots">4</profile>
    <profile namespace="globus" key="maxNodes">1</profile>
    <profile namespace="globus" key="nodeGranularity">1</profile>
    <profile namespace="karajan" key="jobThrottle">.64</profile>
    <profile namespace="karajan" key="initialScore">10000</profile>
    <workdirectory>/tmp/{env.USER}</workdirectory>
  </pool>
</config>


2013-03-19 19:58:46,928+0000 DEBUG textfiles END SITES:
2013-03-19 19:58:46,934+0000 DEBUG VDL2ExecutionContext Stack dump:
Level 1
[iA = 0, iB = 0, bA = false, bB = false]
	vdl:instanceconfigfile = cf
	vdl:instanceconfig = Swift configuration ([cf]): {throttle.score.job.factor=4, throttle.file.operations=8, throttle.host.submit=2, pgraph.node.options=color="seagreen", style="filled", wrapper.parameter.mode=args, provenance.log=false, throttle.submit=4, ticker.prefix=Progress:  time:, provider.staging.pin.swiftfiles=true, clustering.enabled=false, replication.min.queue.time=60, sites.file=sandyb.xml, cdm.broadcast.mode=file, kickstart.enabled=maybe, wrapperlog.always.transfer=true, caching.algorithm=LRU, use.provider.staging=true, use.wrapper.staging=false, status.mode=provider, clustering.min.time=60, ticker.date.format=, kickstart.always.transfer=false, file.gc.enabled=true, throttle.transfers=4, execution.retries=0, sitedir.keep=true, pgraph.graph.options=splines="compound", rankdir="TB", replication.enabled=false, clustering.queue.delay=4, pgraph=false, mapping.checker=on, wrapper.invocation.mode=absolute, tc.file=tc, replication.limit=3, lazy.errors=false}
	vdl:operation = run
	PATH_SEPARATOR = /
	swift.home = /home/wilde/swift/src/0.94/cog/modules/swift/dist/rc5.1/bin/..


2013-03-19 19:58:46,935+0000 INFO  VDL2ExecutionContext swift.home = /home/wilde/swift/src/0.94/cog/modules/swift/dist/rc5.1/bin/..
2013-03-19 19:58:47,466+0000 INFO  swift Using sites file: sandyb.xml
2013-03-19 19:58:47,491+0000 INFO  swift Using tc.data: tc
2013-03-19 19:58:47,578+0000 INFO  AbstractScheduler Setting resources to: {midway=midway}
2013-03-19 19:58:47,997+0000 INFO  swift Swift 0.94 swift-r6362 cog-r3637

2013-03-19 19:58:47,998+0000 INFO  swift RUNID id=run:20130319-1958-jgq018sg
2013-03-19 19:58:48,055+0000 INFO  RuntimeStats$ProgressTicker 
2013-03-19 19:58:48,056+0000 INFO  VDLFunction FUNCTION: arg()
2013-03-19 19:58:48,056+0000 INFO  VDLFunction FUNCTION: arg()
2013-03-19 19:58:48,056+0000 INFO  VDLFunction FUNCTION: toint()
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-0
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-6
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-0
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-6
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-4
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-3
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-4
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-3
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-5
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-8
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-5
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-13
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-8
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-13
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-10
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-10
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-14
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-14
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-15
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-15
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-16
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-16
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-11
2013-03-19 19:58:48,085+0000 DEBUG swift SCOPE thread=0-5-11
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-19
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-19
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-2
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-2
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-20
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-20
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-12
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-9
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-12
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-9
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-22
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-22
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-23
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-23
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-17
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-18
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-17
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-18
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-25
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-24
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-25
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-24
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-26
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-1
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-26
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-27
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-1
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-27
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-21
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-21
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-30
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-31
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-28
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-31
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-28
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-29
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-29
2013-03-19 19:58:48,085+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-7
2013-03-19 19:58:48,086+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-32
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-7
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-32
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-33
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-33
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-34
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-34
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-35
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-35
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-36
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-36
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-37
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-38
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-37
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-38
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-39
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-39
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-40
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-40
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-41
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-41
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-42
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-43
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-42
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-43
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-44
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-44
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-45
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-46
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-45
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-46
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-47
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-47
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-48
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-48
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-49
2013-03-19 19:58:48,087+0000 DEBUG swift SCOPE thread=0-5-49
2013-03-19 19:58:48,087+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-51
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-51
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-50
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-50
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-52
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-52
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-53
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-53
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-54
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-54
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-55
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-55
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-56
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-57
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-56
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-57
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-60
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-58
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-60
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-58
2013-03-19 19:58:48,086+0000 DEBUG swift SCOPE thread=0-5-30
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-62
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-62
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-61
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-63
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-61
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-64
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-66
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-64
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-66
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-59
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-78
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-59
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-78
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-79
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-80
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-79
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-80
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-77
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-81
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-77
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-81
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-76
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-75
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-76
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-75
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-73
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-85
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-83
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-86
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-85
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-83
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-74
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-72
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-74
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-72
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-71
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-88
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-71
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-88
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-69
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-70
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-90
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-70
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-90
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-68
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-68
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-91
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-91
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-67
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-65
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-67
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-65
2013-03-19 19:58:48,088+0000 DEBUG swift SCOPE thread=0-5-63
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-92
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-93
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-92
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-93
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-89
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-95
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-89
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-96
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-97
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-94
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-97
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-94
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-69
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-86
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-99
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-99
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-87
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-87
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-73
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-84
2013-03-19 19:58:48,088+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-82
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-84
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-82
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-96
2013-03-19 19:58:48,089+0000 DEBUG swift FOREACH_IT_START line=23 thread=0-5-98
2013-03-19 19:58:48,090+0000 DEBUG swift SCOPE thread=0-5-98
2013-03-19 19:58:48,089+0000 DEBUG swift SCOPE thread=0-5-95
2013-03-19 19:58:48,090+0000 DEBUG swift PROCEDURE line=7 thread=0-5-0-1 name=get_land_use
2013-03-19 19:58:48,090+0000 DEBUG swift PROCEDURE line=7 thread=0-5-5-1 name=get_land_use
2013-03-19 19:58:48,090+0000 DEBUG swift PROCEDURE line=7 thread=0-5-3-1 name=get_land_use
2013-03-19 19:58:48,090+0000 DEBUG swift PROCEDURE line=7 thread=0-5-6-1 name=get_land_use
2013-03-19 19:58:48,090+0000 DEBUG swift PROCEDURE line=7 thread=0-5-8-1 name=get_land_use
2013-03-19 19:58:48,091+0000 DEBUG swift PROCEDURE line=7 thread=0-5-14-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-19-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-2-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-16-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-13-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-10-1 name=get_land_use
2013-03-19 19:58:48,092+0000 DEBUG swift PROCEDURE line=7 thread=0-5-9-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-22-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-23-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-25-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-24-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-26-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-27-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-4-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-15-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-7-1 name=get_land_use
2013-03-19 19:58:48,093+0000 DEBUG swift PROCEDURE line=7 thread=0-5-33-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-12-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-17-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-20-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-18-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-11-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-37-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-21-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-32-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-41-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-45-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-29-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-48-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-1-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-34-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-35-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-36-1 name=get_land_use
2013-03-19 19:58:48,094+0000 DEBUG swift PROCEDURE line=7 thread=0-5-28-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-31-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-52-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-39-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-44-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-55-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-60-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-47-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-62-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-43-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-38-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-51-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-59-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-42-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-58-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-75-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-85-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-72-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-40-1 name=get_land_use
2013-03-19 19:58:48,095+0000 DEBUG swift PROCEDURE line=7 thread=0-5-49-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-56-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-90-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-91-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-53-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-66-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-57-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-97-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-71-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-88-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-69-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-87-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-50-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-86-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-68-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-63-1 name=get_land_use
2013-03-19 19:58:48,096+0000 DEBUG swift PROCEDURE line=7 thread=0-5-65-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-54-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-78-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-77-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-67-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-74-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-79-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-92-1 name=get_land_use
2013-03-19 19:58:48,097+0000 DEBUG swift PROCEDURE line=7 thread=0-5-89-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-46-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-94-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-81-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-64-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-80-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-73-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-83-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-30-1 name=get_land_use
2013-03-19 19:58:48,101+0000 DEBUG swift PROCEDURE line=7 thread=0-5-96-1 name=get_land_use
2013-03-19 19:58:48,102+0000 DEBUG swift PROCEDURE line=7 thread=0-5-84-1 name=get_land_use
2013-03-19 19:58:48,102+0000 DEBUG swift PROCEDURE line=7 thread=0-5-70-1 name=get_land_use
2013-03-19 19:58:48,102+0000 DEBUG swift PROCEDURE line=7 thread=0-5-93-1 name=get_land_use
2013-03-19 19:58:48,102+0000 DEBUG swift PROCEDURE line=7 thread=0-5-61-1 name=get_land_use
2013-03-19 19:58:48,102+0000 DEBUG swift PROCEDURE line=7 thread=0-5-76-1 name=get_land_use
2013-03-19 19:58:48,103+0000 DEBUG swift PROCEDURE line=7 thread=0-5-99-1 name=get_land_use
2013-03-19 19:58:48,103+0000 DEBUG swift PROCEDURE line=7 thread=0-5-82-1 name=get_land_use
2013-03-19 19:58:48,103+0000 DEBUG swift PROCEDURE line=7 thread=0-5-98-1 name=get_land_use
2013-03-19 19:58:48,103+0000 DEBUG swift PROCEDURE line=7 thread=0-5-95-1 name=get_land_use
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-43-1 tr=perl
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-35-1 tr=perl
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-88-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-87-1 tr=perl
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-91-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-44-1 tr=perl
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-79-1 tr=perl
2013-03-19 19:58:48,148+0000 INFO  swift START thread=0-5-37-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-53-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-20-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-3-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-89-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-14-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-38-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-68-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-75-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-96-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-64-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-28-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-84-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-12-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-41-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-83-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-70-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-93-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-32-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-30-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-7-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-57-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-80-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-58-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-55-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-33-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-18-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-77-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-78-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-71-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-15-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-69-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-2-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-31-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-9-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-5-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-11-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-47-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-51-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-34-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-23-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-74-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-39-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-97-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-86-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-85-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-73-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-48-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-49-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-52-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-66-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-90-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-0-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-27-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-54-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-6-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-92-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-19-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-42-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-29-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-16-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-60-1 tr=perl
2013-03-19 19:58:48,150+0000 INFO  swift START thread=0-5-1-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-67-1 tr=perl
2013-03-19 19:58:48,149+0000 INFO  swift START thread=0-5-40-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-94-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-63-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-50-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-21-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-72-1 tr=perl
2013-03-19 19:58:48,151+0000 INFO  swift START thread=0-5-99-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-8-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-26-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-22-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-13-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-59-1 tr=perl
2013-03-19 19:58:48,152+0000 INFO  swift START thread=0-5-81-1 tr=perl
2013-03-19 19:58:48,153+0000 INFO  swift START thread=0-5-76-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-82-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-25-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-24-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-17-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-46-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-56-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-45-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-10-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-4-1 tr=perl
2013-03-19 19:58:48,154+0000 INFO  swift START thread=0-5-98-1 tr=perl
2013-03-19 19:58:48,155+0000 INFO  swift START thread=0-5-36-1 tr=perl
2013-03-19 19:58:48,155+0000 INFO  swift START thread=0-5-62-1 tr=perl
2013-03-19 19:58:48,156+0000 INFO  swift START thread=0-5-65-1 tr=perl
2013-03-19 19:58:48,157+0000 INFO  swift START thread=0-5-61-1 tr=perl
2013-03-19 19:58:48,163+0000 INFO  swift START thread=0-5-95-1 tr=perl
2013-03-19 19:58:48,193+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):0/64 overload: 0]
2013-03-19 19:58:48,193+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):1/64 overload: 0]
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):2/64 overload: 0]
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):3/64 overload: 0]
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):4/64 overload: 0]
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):5/64 overload: 0]
2013-03-19 19:58:48,194+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):6/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):7/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):8/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):9/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):10/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):11/64 overload: 0]
2013-03-19 19:58:48,195+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):12/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):13/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):14/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):15/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):16/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):17/64 overload: 0]
2013-03-19 19:58:48,196+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):18/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):19/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):20/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):21/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):22/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):23/64 overload: 0]
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,197+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):24/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):25/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):26/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):27/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):28/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):29/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):30/64 overload: 0]
2013-03-19 19:58:48,198+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):31/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):32/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):33/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):34/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):35/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):36/64 overload: 0]
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,199+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):37/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):38/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):39/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):40/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):41/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):42/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):43/64 overload: 0]
2013-03-19 19:58:48,200+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):44/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):45/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):46/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):47/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):48/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):49/64 overload: 0]
2013-03-19 19:58:48,201+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):50/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):51/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):52/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):53/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):54/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):55/64 overload: 0]
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,202+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):56/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):57/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):58/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):59/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):60/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):61/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):62/64 overload: 0]
2013-03-19 19:58:48,203+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,204+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):63/64 overload: 0]
2013-03-19 19:58:48,204+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,204+0000 INFO  WeightedHostScoreScheduler Sorted: [midway:10,000.000(99.854):64/64 overload: 0]
2013-03-19 19:58:48,204+0000 INFO  WeightedHostScoreScheduler CONTACT_SELECTED host=midway, score=99.854
2013-03-19 19:58:48,205+0000 INFO  GlobalSubmitQueue No global submit throttle set. Using default (1024)
2013-03-19 19:58:48,206+0000 INFO  LateBindingScheduler jobs queued: 35
2013-03-19 19:58:48,207+0000 INFO  LateBindingScheduler jobs queued: 35
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-r2e3ut6l thread=0-5-40-1-1 host=midway replicationGroup=b1e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-x2e3ut6l thread=0-5-73-1-1 host=midway replicationGroup=v1e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-s2e3ut6l thread=0-5-71-1-1 host=midway replicationGroup=o1e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-u2e3ut6l thread=0-5-19-1-1 host=midway replicationGroup=o0e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-t2e3ut6l thread=0-5-76-1-1 host=midway replicationGroup=a2e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-v2e3ut6l thread=0-5-87-1-1 host=midway replicationGroup=x1e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-y3e3ut6l thread=0-5-31-1-1 host=midway replicationGroup=g1e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-13e3ut6l thread=0-5-9-1-1 host=midway replicationGroup=61e3ut6l
2013-03-19 19:58:48,215+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-y2e3ut6l thread=0-5-6-1-1 host=midway replicationGroup=22e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-z2e3ut6l thread=0-5-43-1-1 host=midway replicationGroup=71e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-23e3ut6l thread=0-5-37-1-1 host=midway replicationGroup=21e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-m3e3ut6l thread=0-5-83-1-1 host=midway replicationGroup=41e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-53e3ut6l thread=0-5-78-1-1 host=midway replicationGroup=92e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-z3e3ut6l thread=0-5-67-1-1 host=midway replicationGroup=31e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-04e3ut6l thread=0-5-15-1-1 host=midway replicationGroup=91e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-03e3ut6l thread=0-5-74-1-1 host=midway replicationGroup=72e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-14e3ut6l thread=0-5-21-1-1 host=midway replicationGroup=n1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-83e3ut6l thread=0-5-62-1-1 host=midway replicationGroup=g2e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-n3e3ut6l thread=0-5-80-1-1 host=midway replicationGroup=k1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-93e3ut6l thread=0-5-84-1-1 host=midway replicationGroup=h0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-33e3ut6l thread=0-5-79-1-1 host=midway replicationGroup=x0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-24e3ut6l thread=0-5-29-1-1 host=midway replicationGroup=90e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-73e3ut6l thread=0-5-30-1-1 host=midway replicationGroup=zzd3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-34e3ut6l thread=0-5-3-1-1 host=midway replicationGroup=12e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-d3e3ut6l thread=0-5-75-1-1 host=midway replicationGroup=80e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-e3e3ut6l thread=0-5-2-1-1 host=midway replicationGroup=r0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-c3e3ut6l thread=0-5-5-1-1 host=midway replicationGroup=t1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-64e3ut6l thread=0-5-94-1-1 host=midway replicationGroup=d0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-f3e3ut6l thread=0-5-10-1-1 host=midway replicationGroup=k2e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-r3e3ut6l thread=0-5-85-1-1 host=midway replicationGroup=c0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-i3e3ut6l thread=0-5-22-1-1 host=midway replicationGroup=d1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-k3e3ut6l thread=0-5-33-1-1 host=midway replicationGroup=10e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-a4e3ut6l thread=0-5-17-1-1 host=midway replicationGroup=e2e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-t3e3ut6l thread=0-5-18-1-1 host=midway replicationGroup=20e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-94e3ut6l thread=0-5-66-1-1 host=midway replicationGroup=c1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-p3e3ut6l thread=0-5-88-1-1 host=midway replicationGroup=50e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-f4e3ut6l thread=0-5-50-1-1 host=midway replicationGroup=n0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-g4e3ut6l thread=0-5-11-1-1 host=midway replicationGroup=i0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-v3e3ut6l thread=0-5-90-1-1 host=midway replicationGroup=81e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-o3e3ut6l thread=0-5-20-1-1 host=midway replicationGroup=l0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-h4e3ut6l thread=0-5-69-1-1 host=midway replicationGroup=q0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-i4e3ut6l thread=0-5-96-1-1 host=midway replicationGroup=30e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-j4e3ut6l thread=0-5-32-1-1 host=midway replicationGroup=v0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-l4e3ut6l thread=0-5-70-1-1 host=midway replicationGroup=xzd3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-k4e3ut6l thread=0-5-1-1-1 host=midway replicationGroup=p0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-63e3ut6l thread=0-5-12-1-1 host=midway replicationGroup=z1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-43e3ut6l thread=0-5-26-1-1 host=midway replicationGroup=m0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-l3e3ut6l thread=0-5-28-1-1 host=midway replicationGroup=z0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-j3e3ut6l thread=0-5-77-1-1 host=midway replicationGroup=01e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-x3e3ut6l thread=0-5-59-1-1 host=midway replicationGroup=52e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-74e3ut6l thread=0-5-14-1-1 host=midway replicationGroup=y1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-u3e3ut6l thread=0-5-53-1-1 host=midway replicationGroup=m1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-d4e3ut6l thread=0-5-97-1-1 host=midway replicationGroup=b0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-e4e3ut6l thread=0-5-89-1-1 host=midway replicationGroup=f0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-b4e3ut6l thread=0-5-8-1-1 host=midway replicationGroup=e1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-c4e3ut6l thread=0-5-58-1-1 host=midway replicationGroup=u1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-s3e3ut6l thread=0-5-0-1-1 host=midway replicationGroup=40e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-84e3ut6l thread=0-5-60-1-1 host=midway replicationGroup=r1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-h3e3ut6l thread=0-5-51-1-1 host=midway replicationGroup=h1e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-g3e3ut6l thread=0-5-92-1-1 host=midway replicationGroup=k0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-54e3ut6l thread=0-5-63-1-1 host=midway replicationGroup=g0e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-q3e3ut6l thread=0-5-56-1-1 host=midway replicationGroup=m2e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-a3e3ut6l thread=0-5-72-1-1 host=midway replicationGroup=62e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-b3e3ut6l thread=0-5-46-1-1 host=midway replicationGroup=b2e3ut6l
2013-03-19 19:58:48,216+0000 DEBUG swift THREAD_ASSOCIATION jobid=perl-44e3ut6l thread=0-5-49-1-1 host=midway replicationGroup=51e3ut6l
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-03e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v74.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/0/perl-03e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-x2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v73.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/x/perl-x2e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-33e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v79.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/3/perl-33e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-13e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v09.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/1/perl-13e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-g3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v92.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/g/perl-g3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-y2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v06.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/y/perl-y2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-v3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v90.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/v/perl-v3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-74e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v14.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/7/perl-74e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-84e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v60.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/8/perl-84e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-64e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v94.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/6/perl-64e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-j4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v32.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/j/perl-j4e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-04e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v15.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/0/perl-04e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-53e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v78.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/5/perl-53e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-l3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v28.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/l/perl-l3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-s3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v00.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/s/perl-s3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-r2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v40.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/r/perl-r2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-93e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v84.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/9/perl-93e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-83e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v62.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/8/perl-83e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-l4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v70.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/l/perl-l4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-u3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v53.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/u/perl-u3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-a4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v17.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/a/perl-a4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-i4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v96.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/i/perl-i4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-73e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v30.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/7/perl-73e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-63e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v12.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/6/perl-63e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-z3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v67.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/z/perl-z3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-k4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v01.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/k/perl-k4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-z2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v43.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/z/perl-z2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-k3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v33.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/k/perl-k3e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-e4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v89.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/e/perl-e4e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-94e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v66.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/9/perl-94e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-c3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v05.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/c/perl-c3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-t3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v18.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/t/perl-t3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-44e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v49.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/4/perl-44e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-s2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v71.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/s/perl-s2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-a3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v72.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/a/perl-a3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-c4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v58.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/c/perl-c4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-14e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v21.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/1/perl-14e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-54e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v63.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/5/perl-54e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-x3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v59.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/x/perl-x3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-o3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v20.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/o/perl-o3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-f4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v50.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/f/perl-f4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-b3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v46.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/b/perl-b3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-f3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v10.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/f/perl-f3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-q3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v56.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/q/perl-q3e3ut6l host=midway
2013-03-19 19:58:48,226+0000 DEBUG swift JOB_START jobid=perl-24e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v29.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/2/perl-24e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-j3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v77.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/j/perl-j3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-m3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v83.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/m/perl-m3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-h4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v69.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/h/perl-h4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-h3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v51.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/h/perl-h3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-d4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v97.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/d/perl-d4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-43e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v26.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/4/perl-43e3ut6l host=midway
2013-03-19 19:58:48,228+0000 DEBUG swift JOB_START jobid=perl-34e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v03.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/3/perl-34e3ut6l host=midway
2013-03-19 19:58:48,228+0000 DEBUG swift JOB_START jobid=perl-r3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v85.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/r/perl-r3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-g4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v11.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/g/perl-g4e3ut6l host=midway
2013-03-19 19:58:48,228+0000 DEBUG swift JOB_START jobid=perl-i3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v22.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/i/perl-i3e3ut6l host=midway
2013-03-19 19:58:48,228+0000 DEBUG swift JOB_START jobid=perl-n3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v80.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/n/perl-n3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-p3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v88.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/p/perl-p3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-23e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v37.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/2/perl-23e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-b4e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v08.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/b/perl-b4e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-e3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v02.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/e/perl-e3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-u2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v19.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/u/perl-u2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-t2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v76.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/t/perl-t2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-v2e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v87.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/v/perl-v2e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-d3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v75.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/d/perl-d3e3ut6l host=midway
2013-03-19 19:58:48,227+0000 DEBUG swift JOB_START jobid=perl-y3e3ut6l tr=perl arguments=[getlanduse.pl, input/h00v31.rgb] tmpdir=modis-20130319-1958-jgq018sg/jobs/y/perl-y3e3ut6l host=midway
2013-03-19 19:58:48,231+0000 DEBUG textfiles BEGIN TC:
midway perl /usr/bin/perl null null null


2013-03-19 19:58:48,231+0000 DEBUG textfiles END TC:
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-83-1-1-1363723127609) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v83.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v83.rgb|getlanduse.pl -of landuse/h00v83.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v83.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-72-1-1-1363723127612) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v72.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v72.rgb|getlanduse.pl -of landuse/h00v72.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v72.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-40-1-1-1363723127606) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v40.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v40.rgb|getlanduse.pl -of landuse/h00v40.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v40.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-67-1-1-1363723127613) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v67.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v67.rgb|getlanduse.pl -of landuse/h00v67.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v67.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-50-1-1-1363723127611) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v50.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v50.rgb|getlanduse.pl -of landuse/h00v50.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v50.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-90-1-1-1363723127607) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v90.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v90.rgb|getlanduse.pl -of landuse/h00v90.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v90.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-20-1-1-1363723127601) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v20.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v20.rgb|getlanduse.pl -of landuse/h00v20.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v20.rgb
2013-03-19 19:58:48,264+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-85-1-1-1363723127610) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v85.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v85.rgb|getlanduse.pl -of landuse/h00v85.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v85.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-46-1-1-1363723127604) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v46.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v46.rgb|getlanduse.pl -of landuse/h00v46.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v46.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-30-1-1-1363723127605) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v30.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v30.rgb|getlanduse.pl -of landuse/h00v30.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v30.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-78-1-1-1363723127608) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v78.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v78.rgb|getlanduse.pl -of landuse/h00v78.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v78.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-26-1-1-1363723127625) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v26.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v26.rgb|getlanduse.pl -of landuse/h00v26.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v26.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-10-1-1-1363723127626) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v10.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v10.rgb|getlanduse.pl -of landuse/h00v10.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v10.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-62-1-1-1363723127624) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v62.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v62.rgb|getlanduse.pl -of landuse/h00v62.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v62.rgb
2013-03-19 19:58:48,265+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-17-1-1-1363723127630) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v17.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v17.rgb|getlanduse.pl -of landuse/h00v17.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v17.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-15-1-1-1363723127633) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v15.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v15.rgb|getlanduse.pl -of landuse/h00v15.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v15.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-73-1-1-1363723127635) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v73.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v73.rgb|getlanduse.pl -of landuse/h00v73.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v73.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-33-1-1-1363723127636) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v33.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v33.rgb|getlanduse.pl -of landuse/h00v33.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v33.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-11-1-1-1363723127637) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v11.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v11.rgb|getlanduse.pl -of landuse/h00v11.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v11.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-43-1-1-1363723127639) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v43.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v43.rgb|getlanduse.pl -of landuse/h00v43.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v43.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-29-1-1-1363723127645) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v29.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v29.rgb|getlanduse.pl -of landuse/h00v29.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v29.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-9-1-1-1363723127647) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v09.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v09.rgb|getlanduse.pl -of landuse/h00v09.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v09.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-21-1-1-1363723127649) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v21.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v21.rgb|getlanduse.pl -of landuse/h00v21.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v21.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-18-1-1-1363723127650) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v18.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v18.rgb|getlanduse.pl -of landuse/h00v18.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v18.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-77-1-1-1363723127651) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v77.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v77.rgb|getlanduse.pl -of landuse/h00v77.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v77.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-49-1-1-1363723127627) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v49.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v49.rgb|getlanduse.pl -of landuse/h00v49.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v49.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-32-1-1-1363723127655) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v32.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v32.rgb|getlanduse.pl -of landuse/h00v32.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v32.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-1-1-1-1363723127656) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v01.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v01.rgb|getlanduse.pl -of landuse/h00v01.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v01.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-75-1-1-1363723127658) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v75.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v75.rgb|getlanduse.pl -of landuse/h00v75.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v75.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-70-1-1-1363723127659) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v70.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v70.rgb|getlanduse.pl -of landuse/h00v70.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v70.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-0-1-1-1363723127660) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v00.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v00.rgb|getlanduse.pl -of landuse/h00v00.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v00.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-66-1-1-1363723127662) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v66.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v66.rgb|getlanduse.pl -of landuse/h00v66.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v66.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-71-1-1-1363723127665) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v71.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v71.rgb|getlanduse.pl -of landuse/h00v71.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v71.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-79-1-1-1363723127668) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v79.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v79.rgb|getlanduse.pl -of landuse/h00v79.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v79.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-89-1-1-1363723127669) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v89.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v89.rgb|getlanduse.pl -of landuse/h00v89.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v89.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-74-1-1-1363723127670) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v74.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v74.rgb|getlanduse.pl -of landuse/h00v74.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v74.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-3-1-1-1363723127671) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v03.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v03.rgb|getlanduse.pl -of landuse/h00v03.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v03.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-59-1-1-1363723127679) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v59.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v59.rgb|getlanduse.pl -of landuse/h00v59.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v59.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-60-1-1-1363723127680) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v60.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v60.rgb|getlanduse.pl -of landuse/h00v60.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v60.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-22-1-1-1363723127681) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v22.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v22.rgb|getlanduse.pl -of landuse/h00v22.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v22.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-28-1-1-1363723127683) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v28.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v28.rgb|getlanduse.pl -of landuse/h00v28.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v28.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-51-1-1-1363723127684) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v51.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v51.rgb|getlanduse.pl -of landuse/h00v51.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v51.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-84-1-1-1363723127687) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v84.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v84.rgb|getlanduse.pl -of landuse/h00v84.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v84.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-63-1-1-1363723127688) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v63.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v63.rgb|getlanduse.pl -of landuse/h00v63.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v63.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-80-1-1-1363723127692) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v80.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v80.rgb|getlanduse.pl -of landuse/h00v80.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v80.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-5-1-1-1363723127693) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v05.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v05.rgb|getlanduse.pl -of landuse/h00v05.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v05.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-92-1-1-1363723127694) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v92.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v92.rgb|getlanduse.pl -of landuse/h00v92.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v92.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-97-1-1-1363723127696) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v97.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v97.rgb|getlanduse.pl -of landuse/h00v97.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v97.rgb
2013-03-19 19:58:48,266+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-14-1-1-1363723127652) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v14.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v14.rgb|getlanduse.pl -of landuse/h00v14.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v14.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-76-1-1-1363723127600) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v76.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v76.rgb|getlanduse.pl -of landuse/h00v76.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v76.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-8-1-1-1363723127695) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v08.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v08.rgb|getlanduse.pl -of landuse/h00v08.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v08.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-87-1-1-1363723127682) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v87.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v87.rgb|getlanduse.pl -of landuse/h00v87.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v87.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-88-1-1-1363723127603) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v88.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v88.rgb|getlanduse.pl -of landuse/h00v88.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v88.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-19-1-1-1363723127602) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v19.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v19.rgb|getlanduse.pl -of landuse/h00v19.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v19.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-96-1-1-1363723127697) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v96.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v96.rgb|getlanduse.pl -of landuse/h00v96.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v96.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-12-1-1-1363723127698) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v12.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v12.rgb|getlanduse.pl -of landuse/h00v12.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v12.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-56-1-1-1363723127699) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v56.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v56.rgb|getlanduse.pl -of landuse/h00v56.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v56.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-6-1-1-1363723127700) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v06.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v06.rgb|getlanduse.pl -of landuse/h00v06.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v06.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-69-1-1-1363723127701) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v69.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v69.rgb|getlanduse.pl -of landuse/h00v69.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v69.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-37-1-1-1363723127702) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v37.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v37.rgb|getlanduse.pl -of landuse/h00v37.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v37.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-2-1-1-1363723127704) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v02.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v02.rgb|getlanduse.pl -of landuse/h00v02.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v02.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-31-1-1-1363723127703) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v31.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v31.rgb|getlanduse.pl -of landuse/h00v31.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v31.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-58-1-1-1363723127615) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v58.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v58.rgb|getlanduse.pl -of landuse/h00v58.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v58.rgb
2013-03-19 19:58:48,267+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-53-1-1-1363723127614) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v53.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v53.rgb|getlanduse.pl -of landuse/h00v53.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v53.rgb
2013-03-19 19:58:48,268+0000 INFO  GridExec TASK_DEFINITION: Task(type=JOB_SUBMISSION, identity=urn:0-5-94-1-1-1363723127705) is /bin/bash _swiftwrap.staging -e /usr/bin/perl -out landuse/h00v94.landuse.byfreq -err stderr.txt -i -d landuse -if input/h00v94.rgb|getlanduse.pl -of landuse/h00v94.landuse.byfreq -k -cdmfile  -status provider -a getlanduse.pl input/h00v94.rgb
2013-03-19 19:58:48,295+0000 INFO  LocalService Started local service: 10.50.181.1:43825
2013-03-19 19:58:48,300+0000 INFO  BootstrapService Socket bound. URL is http://midway001:41861
2013-03-19 19:58:48,331+0000 INFO  Settings Local contacts: [http://172.25.181.1:50662, http://169.254.95.120:50662, http://128.135.112.73:50662, http://10.50.181.1:50662]
2013-03-19 19:58:48,333+0000 INFO  CoasterService Started local service: http://10.50.181.1:50662
2013-03-19 19:58:48,333+0000 INFO  CoasterService Reserving channel for registration
2013-03-19 19:58:48,349+0000 INFO  MetaChannel MetaChannel[cpipe] -> null bind -> cpipe://1
2013-03-19 19:58:48,349+0000 INFO  MetaChannel MetaChannel[spipe] -> null bind -> spipe://1
2013-03-19 19:58:48,349+0000 INFO  CoasterService Sending registration
2013-03-19 19:58:48,352+0000 INFO  MetaChannel Trying to re-bind current channel
2013-03-19 19:58:48,353+0000 INFO  RequestHandler Handler(tag: 1, REGISTER) unregistering (send)
2013-03-19 19:58:48,353+0000 INFO  CoasterService Registration complete
2013-03-19 19:58:48,353+0000 INFO  CoasterService Started coaster service: http://10.50.181.1:36379
2013-03-19 19:58:48,355+0000 INFO  RequestHandler Handler(tag: 1, CONFIGSERVICE) unregistering (send)
2013-03-19 19:58:48,366+0000 INFO  BlockQueueProcessor Starting... id=0319-5807480
2013-03-19 19:58:48,369+0000 INFO  RequestHandler Handler(tag: 3, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,369+0000 INFO  RequestHandler Handler(tag: 2, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,370+0000 INFO  RequestHandler Handler(tag: 5, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,370+0000 INFO  RequestHandler Handler(tag: 4, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,371+0000 INFO  RequestHandler Handler(tag: 6, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,371+0000 INFO  BlockQueueProcessor 
Settings {
	slots = 4
	jobsPerNode = 16
	workersPerNode = 16
	nodeGranularity = 1
	allocationStepSize = 0.1
	maxNodes = 1
	lowOverallocation = 100.0
	highOverallocation = 100.0
	overallocationDecayFactor = 0.001
	spread = 0.9
	reserve = 60.000s
	maxtime = 3600
	remoteMonitorEnabled = false
	internalHostname = 10.50.181.1
	hookClass = null
	workerManager = block
	workerLoggingLevel = NONE
	workerLoggingDirectory = DEFAULT
	ldLibraryPath = null
	workerCopies = null
	directory = null
	useHashBang = null
	parallelism = 0.01
	coresPerNode = 1
	attributes = {queue=sandyb}
}

2013-03-19 19:58:48,371+0000 INFO  RequestHandler Handler(tag: 7, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,371+0000 INFO  BlockQueueProcessor Jobs in holding queue: 1
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor Time estimate for holding queue (seconds): 1
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor Allocating blocks for a total walltime of: 1s
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor 	 Considering: Job(id:0 300.000s)
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor 	  Max Walltime (seconds):   300
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor 	  Time estimate (seconds):  3540
2013-03-19 19:58:48,372+0000 INFO  BlockQueueProcessor 	  Total for this new Block (est. seconds): 0
2013-03-19 19:58:48,372+0000 INFO  RequestHandler Handler(tag: 8, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,373+0000 INFO  RequestHandler Handler(tag: 9, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,373+0000 INFO  RequestHandler Handler(tag: 10, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,374+0000 INFO  RequestHandler Handler(tag: 11, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,374+0000 INFO  BlockQueueProcessor index: 0, last: 0, holding.size(): 1
2013-03-19 19:58:48,374+0000 INFO  BlockQueueProcessor Queued: 1 jobs to new Block
2013-03-19 19:58:48,374+0000 INFO  BlockQueueProcessor index: 0, last: 0, ii: 1, holding.size(): 1
2013-03-19 19:58:48,374+0000 INFO  RequestHandler Handler(tag: 12, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,374+0000 INFO  Block Starting block: workers=16, walltime=3540.000s
2013-03-19 19:58:48,375+0000 INFO  RequestHandler Handler(tag: 13, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,375+0000 INFO  RequestHandler Handler(tag: 14, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,376+0000 INFO  RemoteLogHandler BLOCK_REQUESTED id=0319-5807480-000000, workers=16, walltime=3540
2013-03-19 19:58:48,376+0000 INFO  RequestHandler Handler(tag: 2, RLOG) unregistering (send)
2013-03-19 19:58:48,376+0000 INFO  RequestHandler Handler(tag: 15, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,377+0000 INFO  RequestHandler Handler(tag: 16, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,377+0000 INFO  BlockTaskSubmitter Queuing block Block 0319-5807480-000000 (16x3540.000s) for submission
2013-03-19 19:58:48,377+0000 INFO  BlockQueueProcessor Added 1 jobs to new blocks
2013-03-19 19:58:48,377+0000 INFO  BlockTaskSubmitter Submitting block Block 0319-5807480-000000 (16x3540.000s)
2013-03-19 19:58:48,377+0000 INFO  BlockQueueProcessor Committed 14 new jobs
2013-03-19 19:58:48,377+0000 INFO  ExecutionTaskHandler provider=slurm
2013-03-19 19:58:48,377+0000 INFO  RequestHandler Handler(tag: 17, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,378+0000 INFO  RequestHandler Handler(tag: 18, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,379+0000 INFO  RequestHandler Handler(tag: 19, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,379+0000 INFO  RequestHandler Handler(tag: 20, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,380+0000 INFO  RequestHandler Handler(tag: 21, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,380+0000 INFO  Block Block task status changed: Submitting
2013-03-19 19:58:48,381+0000 INFO  RequestHandler Handler(tag: 22, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,381+0000 INFO  RequestHandler Handler(tag: 23, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,382+0000 INFO  RequestHandler Handler(tag: 24, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,382+0000 INFO  RequestHandler Handler(tag: 25, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,383+0000 INFO  RequestHandler Handler(tag: 27, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,383+0000 INFO  RequestHandler Handler(tag: 26, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,384+0000 INFO  RequestHandler Handler(tag: 28, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,384+0000 DEBUG AbstractExecutor Writing Slurm script to /home/yadunand/.globus/scripts/Slurm9205114084934863737.submit
2013-03-19 19:58:48,384+0000 INFO  RequestHandler Handler(tag: 29, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,385+0000 INFO  RequestHandler Handler(tag: 30, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,385+0000 DEBUG AbstractExecutor Wrote Slurm script to /home/yadunand/.globus/scripts/Slurm9205114084934863737.submit
2013-03-19 19:58:48,385+0000 DEBUG AbstractExecutor Command line: sbatch /home/yadunand/.globus/scripts/Slurm9205114084934863737.submit
2013-03-19 19:58:48,385+0000 INFO  RequestHandler Handler(tag: 31, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,386+0000 INFO  RequestHandler Handler(tag: 32, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,386+0000 INFO  RequestHandler Handler(tag: 33, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,387+0000 INFO  RequestHandler Handler(tag: 34, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,387+0000 INFO  RequestHandler Handler(tag: 35, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,388+0000 INFO  RequestHandler Handler(tag: 36, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,388+0000 INFO  RequestHandler Handler(tag: 37, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,389+0000 INFO  RequestHandler Handler(tag: 38, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,389+0000 INFO  RequestHandler Handler(tag: 39, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,389+0000 INFO  RequestHandler Handler(tag: 40, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,390+0000 INFO  RequestHandler Handler(tag: 41, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,390+0000 INFO  RequestHandler Handler(tag: 42, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,391+0000 INFO  RequestHandler Handler(tag: 43, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,391+0000 INFO  RequestHandler Handler(tag: 44, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,392+0000 INFO  RequestHandler Handler(tag: 45, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,392+0000 INFO  RequestHandler Handler(tag: 46, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,392+0000 INFO  RequestHandler Handler(tag: 47, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,393+0000 INFO  RequestHandler Handler(tag: 48, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,393+0000 INFO  RequestHandler Handler(tag: 49, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,393+0000 INFO  RequestHandler Handler(tag: 50, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,394+0000 INFO  RequestHandler Handler(tag: 51, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,394+0000 INFO  RequestHandler Handler(tag: 52, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,394+0000 INFO  RequestHandler Handler(tag: 53, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,395+0000 INFO  RequestHandler Handler(tag: 54, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,395+0000 INFO  RequestHandler Handler(tag: 55, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,395+0000 INFO  RequestHandler Handler(tag: 56, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,396+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:48,396+0000 DEBUG AbstractExecutor Output from sbatch is: ""
2013-03-19 19:58:48,396+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:48,396+0000 DEBUG AbstractExecutor Output from sbatch is: "sbatch: error: Batch job submission failed: Requested reservation is invalid"
2013-03-19 19:58:48,396+0000 INFO  RequestHandler Handler(tag: 57, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,396+0000 INFO  RequestHandler Handler(tag: 58, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,396+0000 INFO  BlockTaskSubmitter Error submitting block task
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Cannot submit job: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:63)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.submit(AbstractTaskHandler.java:45)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.submit(ExecutionTaskHandler.java:61)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.run(BlockTaskSubmitter.java:70)
Caused by: org.globus.cog.abstraction.impl.scheduler.common.ProcessException: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.start(AbstractExecutor.java:108)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:53)
	... 3 more
2013-03-19 19:58:48,396+0000 INFO  RequestHandler Handler(tag: 59, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,399+0000 INFO  RequestHandler Handler(tag: 60, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,399+0000 INFO  RequestHandler Handler(tag: 61, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,399+0000 INFO  RequestHandler Handler(tag: 62, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,400+0000 INFO  RequestHandler Handler(tag: 63, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,400+0000 INFO  RequestHandler Handler(tag: 64, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,400+0000 INFO  RequestHandler Handler(tag: 65, SUBMITJOB) unregistering (send)
2013-03-19 19:58:48,401+0000 INFO  RequestHandler Handler(tag: 66, SUBMITJOB) unregistering (send)
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor Jobs in holding queue: 49
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor Time estimate for holding queue (seconds): 54
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor Allocating blocks for a total walltime of: 54s
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor 	 Considering: Job(id:64 300.000s)
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor 	  Max Walltime (seconds):   300
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor 	  Time estimate (seconds):  3540
2013-03-19 19:58:49,537+0000 INFO  BlockQueueProcessor 	  Total for this new Block (est. seconds): 48
2013-03-19 19:58:49,538+0000 INFO  BlockQueueProcessor index: 48, last: 0, holding.size(): 49
2013-03-19 19:58:49,538+0000 INFO  BlockQueueProcessor Queued: 17 jobs to new Block
2013-03-19 19:58:49,538+0000 INFO  BlockQueueProcessor index: 48, last: 0, ii: 17, holding.size(): 49
2013-03-19 19:58:49,538+0000 INFO  Block Starting block: workers=16, walltime=3540.000s
2013-03-19 19:58:49,538+0000 INFO  RemoteLogHandler BLOCK_REQUESTED id=0319-5807480-000001, workers=16, walltime=3540
2013-03-19 19:58:49,538+0000 INFO  RequestHandler Handler(tag: 3, RLOG) unregistering (send)
2013-03-19 19:58:49,538+0000 INFO  BlockTaskSubmitter Queuing block Block 0319-5807480-000001 (16x3540.000s) for submission
2013-03-19 19:58:49,538+0000 INFO  BlockQueueProcessor Added 17 jobs to new blocks
2013-03-19 19:58:49,538+0000 INFO  BlockTaskSubmitter Submitting block Block 0319-5807480-000001 (16x3540.000s)
2013-03-19 19:58:49,538+0000 INFO  ExecutionTaskHandler provider=slurm
2013-03-19 19:58:49,538+0000 INFO  Block Block task status changed: Submitting
2013-03-19 19:58:49,538+0000 DEBUG AbstractExecutor Writing Slurm script to /home/yadunand/.globus/scripts/Slurm9069957957290161585.submit
2013-03-19 19:58:49,539+0000 DEBUG AbstractExecutor Wrote Slurm script to /home/yadunand/.globus/scripts/Slurm9069957957290161585.submit
2013-03-19 19:58:49,539+0000 DEBUG AbstractExecutor Command line: sbatch /home/yadunand/.globus/scripts/Slurm9069957957290161585.submit
2013-03-19 19:58:49,547+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:49,547+0000 DEBUG AbstractExecutor Output from sbatch is: ""
2013-03-19 19:58:49,547+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:49,547+0000 DEBUG AbstractExecutor Output from sbatch is: "sbatch: error: Batch job submission failed: Requested reservation is invalid"
2013-03-19 19:58:49,547+0000 INFO  BlockTaskSubmitter Error submitting block task
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Cannot submit job: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:63)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.submit(AbstractTaskHandler.java:45)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.submit(ExecutionTaskHandler.java:61)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.run(BlockTaskSubmitter.java:70)
Caused by: org.globus.cog.abstraction.impl.scheduler.common.ProcessException: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.start(AbstractExecutor.java:108)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:53)
	... 3 more
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Requeued 1 non-fitting jobs
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Jobs in holding queue: 33
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Time estimate for holding queue (seconds): 37
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Allocating blocks for a total walltime of: 36s
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor 	 Considering: Job(id:0 300.000s)
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor 	  Max Walltime (seconds):   300
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor 	  Time estimate (seconds):  3540
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor 	  Total for this new Block (est. seconds): 32
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor index: 32, last: 0, holding.size(): 33
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Queued: 17 jobs to new Block
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor index: 32, last: 0, ii: 17, holding.size(): 33
2013-03-19 19:58:50,559+0000 INFO  Block Starting block: workers=16, walltime=3540.000s
2013-03-19 19:58:50,559+0000 INFO  RemoteLogHandler BLOCK_REQUESTED id=0319-5807480-000002, workers=16, walltime=3540
2013-03-19 19:58:50,559+0000 INFO  BlockTaskSubmitter Queuing block Block 0319-5807480-000002 (16x3540.000s) for submission
2013-03-19 19:58:50,559+0000 INFO  RequestHandler Handler(tag: 4, RLOG) unregistering (send)
2013-03-19 19:58:50,559+0000 INFO  BlockQueueProcessor Added 17 jobs to new blocks
2013-03-19 19:58:50,559+0000 INFO  BlockTaskSubmitter Submitting block Block 0319-5807480-000002 (16x3540.000s)
2013-03-19 19:58:50,559+0000 INFO  ExecutionTaskHandler provider=slurm
2013-03-19 19:58:50,559+0000 INFO  Block Block task status changed: Submitting
2013-03-19 19:58:50,560+0000 DEBUG AbstractExecutor Writing Slurm script to /home/yadunand/.globus/scripts/Slurm741523248459325194.submit
2013-03-19 19:58:50,560+0000 DEBUG AbstractExecutor Wrote Slurm script to /home/yadunand/.globus/scripts/Slurm741523248459325194.submit
2013-03-19 19:58:50,560+0000 DEBUG AbstractExecutor Command line: sbatch /home/yadunand/.globus/scripts/Slurm741523248459325194.submit
2013-03-19 19:58:50,569+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:50,569+0000 DEBUG AbstractExecutor Output from sbatch is: ""
2013-03-19 19:58:50,569+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:50,569+0000 DEBUG AbstractExecutor Output from sbatch is: "sbatch: error: Batch job submission failed: Requested reservation is invalid"
2013-03-19 19:58:50,569+0000 INFO  BlockTaskSubmitter Error submitting block task
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Cannot submit job: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:63)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.submit(AbstractTaskHandler.java:45)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.submit(ExecutionTaskHandler.java:61)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.run(BlockTaskSubmitter.java:70)
Caused by: org.globus.cog.abstraction.impl.scheduler.common.ProcessException: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.start(AbstractExecutor.java:108)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:53)
	... 3 more
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor Jobs in holding queue: 16
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor Time estimate for holding queue (seconds): 18
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor Allocating blocks for a total walltime of: 17s
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor 	 Considering: Job(id:0 300.000s)
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor 	  Max Walltime (seconds):   300
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor 	  Time estimate (seconds):  3540
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor 	  Total for this new Block (est. seconds): 15
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor index: 15, last: 0, holding.size(): 16
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor Queued: 16 jobs to new Block
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor index: 15, last: 0, ii: 16, holding.size(): 16
2013-03-19 19:58:51,580+0000 INFO  Block Starting block: workers=16, walltime=3540.000s
2013-03-19 19:58:51,580+0000 INFO  RemoteLogHandler BLOCK_REQUESTED id=0319-5807480-000003, workers=16, walltime=3540
2013-03-19 19:58:51,580+0000 INFO  RequestHandler Handler(tag: 5, RLOG) unregistering (send)
2013-03-19 19:58:51,580+0000 INFO  BlockTaskSubmitter Queuing block Block 0319-5807480-000003 (16x3540.000s) for submission
2013-03-19 19:58:51,580+0000 INFO  BlockQueueProcessor Added 16 jobs to new blocks
2013-03-19 19:58:51,580+0000 INFO  BlockTaskSubmitter Submitting block Block 0319-5807480-000003 (16x3540.000s)
2013-03-19 19:58:51,580+0000 INFO  ExecutionTaskHandler provider=slurm
2013-03-19 19:58:51,580+0000 INFO  Block Block task status changed: Submitting
2013-03-19 19:58:51,581+0000 DEBUG AbstractExecutor Writing Slurm script to /home/yadunand/.globus/scripts/Slurm8627038042414459018.submit
2013-03-19 19:58:51,581+0000 DEBUG AbstractExecutor Wrote Slurm script to /home/yadunand/.globus/scripts/Slurm8627038042414459018.submit
2013-03-19 19:58:51,581+0000 DEBUG AbstractExecutor Command line: sbatch /home/yadunand/.globus/scripts/Slurm8627038042414459018.submit
2013-03-19 19:58:51,589+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:51,589+0000 DEBUG AbstractExecutor Output from sbatch is: ""
2013-03-19 19:58:51,589+0000 DEBUG AbstractExecutor Waiting for output from sbatch
2013-03-19 19:58:51,589+0000 DEBUG AbstractExecutor Output from sbatch is: "sbatch: error: Batch job submission failed: Requested reservation is invalid"
2013-03-19 19:58:51,589+0000 INFO  BlockTaskSubmitter Error submitting block task
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Cannot submit job: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:63)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.submit(AbstractTaskHandler.java:45)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.submit(ExecutionTaskHandler.java:61)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.run(BlockTaskSubmitter.java:70)
Caused by: org.globus.cog.abstraction.impl.scheduler.common.ProcessException: Could not submit job (sbatch reported an exit code of 1). 
sbatch: error: Batch job submission failed: Requested reservation is invalid

	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.start(AbstractExecutor.java:108)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.submit(AbstractJobSubmissionTaskHandler.java:53)
	... 3 more
2013-03-19 19:58:58,360+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:08,360+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:18,055+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 19:59:18,360+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:28,360+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:38,360+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:48,055+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 19:59:48,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 19:59:58,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:08,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:18,056+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:00:18,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:28,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:38,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:48,056+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:00:48,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:00:58,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:08,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:18,056+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:01:18,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:28,361+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:38,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:48,056+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:01:48,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:01:58,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:08,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:18,057+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:02:18,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:28,362+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:38,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:48,057+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:02:48,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:02:58,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:08,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:18,057+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:03:18,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:28,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:38,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:48,057+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:03:48,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:03:58,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:08,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:18,058+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:04:18,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:28,363+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:38,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:48,058+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:04:48,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:04:58,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:08,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:18,058+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:05:18,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:28,364+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:38,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:48,058+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:05:48,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:05:58,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:08,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:18,059+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:06:18,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:28,365+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:38,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:48,059+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:06:48,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:06:58,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:08,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:18,059+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:07:18,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:28,366+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:38,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:48,059+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:07:48,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:07:58,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:08,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:18,060+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:08:18,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:28,367+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:38,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:48,060+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:08:48,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:08:58,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:08,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:18,060+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:09:18,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:28,368+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:38,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:48,060+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:09:48,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:09:58,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:08,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:18,061+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:10:18,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:28,369+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:38,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:48,061+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:10:48,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:10:58,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:08,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:18,061+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:11:18,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:28,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:38,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:48,061+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:11:48,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:11:58,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:08,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:18,062+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:12:18,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:28,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:38,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:48,062+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:12:48,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:12:58,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:08,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:18,062+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:13:18,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:28,370+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:38,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:48,062+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:13:48,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:13:58,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:08,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:18,063+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:14:18,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:28,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:38,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:48,063+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:14:48,371+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:14:58,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:08,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:18,063+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:15:18,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:28,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:38,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:48,063+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:15:48,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:15:58,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:08,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:18,064+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:16:18,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:28,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:38,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:48,064+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:16:48,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:16:58,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:08,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:18,064+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:17:18,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:28,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:38,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:48,064+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:17:48,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:17:58,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:08,372+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:18,064+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:18:18,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:28,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:38,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:48,065+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:18:48,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:18:58,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:08,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:18,065+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:19:18,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:28,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:38,373+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:48,065+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:19:48,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:19:58,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:08,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:18,065+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:20:18,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:28,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:38,374+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:48,066+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:20:48,375+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:20:58,375+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:21:08,375+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:21:18,066+0000 INFO  RuntimeStats$ProgressTicker   Selecting site:35  Submitted:65
2013-03-19 20:21:18,375+0000 INFO  TaskNotifier Congestion queue size: 0
2013-03-19 20:21:20,153+0000 INFO  ServiceManager Cleaning up...
2013-03-19 20:21:20,153+0000 INFO  ServiceManager Shutting down service at https://10.50.181.1:36379
2013-03-19 20:21:20,154+0000 INFO  RequestHandler Handler(tag: 67, SHUTDOWNSERVICE) unregistering (send)
2013-03-19 20:21:20,255+0000 INFO  RequestHandler Handler(tag: 6, UNREGISTER) unregistering (send)
2013-03-19 20:21:20,258+0000 INFO  BlockQueueProcessor Shutting down blocks
2013-03-19 20:21:20,258+0000 INFO  Block Shutting down block Block 0319-5807480-000000 (16x3540.000s)
2013-03-19 20:21:20,258+0000 INFO  Block Block Block 0319-5807480-000000 (16x3540.000s) not running. Cancelling job.
2013-03-19 20:21:20,258+0000 INFO  RemoteLogHandler BLOCK_SHUTDOWN id=0319-5807480-000000
2013-03-19 20:21:20,258+0000 INFO  RequestHandler Handler(tag: 7, RLOG) unregistering (send)
2013-03-19 20:21:20,258+0000 WARN  Block Failed to shut down block: Block 0319-5807480-000000 (16x3540.000s)
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Can only cancel an active task
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.cancel(AbstractExecutor.java:196)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.cancel(AbstractJobSubmissionTaskHandler.java:85)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.cancel(AbstractTaskHandler.java:69)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:106)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:95)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.cancel(BlockTaskSubmitter.java:46)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.forceShutdown(Block.java:332)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.shutdown(Block.java:312)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdownBlocks(BlockQueueProcessor.java:800)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdown(BlockQueueProcessor.java:789)
	at org.globus.cog.abstraction.coaster.service.job.manager.JobQueue.shutdown(JobQueue.java:119)
	at org.globus.cog.abstraction.coaster.service.CoasterService.shutdown(CoasterService.java:271)
	at org.globus.cog.abstraction.coaster.service.ServiceShutdownHandler.requestComplete(ServiceShutdownHandler.java:28)
	at org.globus.cog.karajan.workflow.service.handlers.RequestHandler.receiveCompleted(RequestHandler.java:88)
	at org.globus.cog.karajan.workflow.service.channels.AbstractKarajanChannel.handleRequest(AbstractKarajanChannel.java:519)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel.actualSend(AbstractPipedChannel.java:86)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel$Sender.run(AbstractPipedChannel.java:115)
2013-03-19 20:21:20,258+0000 INFO  BlockQueueProcessor Removing block Block 0319-5807480-000000 (16x3540.000s)
2013-03-19 20:21:20,258+0000 INFO  Block Shutting down block Block 0319-5807480-000001 (16x3540.000s)
2013-03-19 20:21:20,258+0000 INFO  Block Block Block 0319-5807480-000001 (16x3540.000s) not running. Cancelling job.
2013-03-19 20:21:20,259+0000 INFO  RemoteLogHandler BLOCK_SHUTDOWN id=0319-5807480-000001
2013-03-19 20:21:20,259+0000 WARN  Block Failed to shut down block: Block 0319-5807480-000001 (16x3540.000s)
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Can only cancel an active task
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.cancel(AbstractExecutor.java:196)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.cancel(AbstractJobSubmissionTaskHandler.java:85)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.cancel(AbstractTaskHandler.java:69)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:106)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:95)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.cancel(BlockTaskSubmitter.java:46)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.forceShutdown(Block.java:332)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.shutdown(Block.java:312)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdownBlocks(BlockQueueProcessor.java:800)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdown(BlockQueueProcessor.java:789)
	at org.globus.cog.abstraction.coaster.service.job.manager.JobQueue.shutdown(JobQueue.java:119)
	at org.globus.cog.abstraction.coaster.service.CoasterService.shutdown(CoasterService.java:271)
	at org.globus.cog.abstraction.coaster.service.ServiceShutdownHandler.requestComplete(ServiceShutdownHandler.java:28)
	at org.globus.cog.karajan.workflow.service.handlers.RequestHandler.receiveCompleted(RequestHandler.java:88)
	at org.globus.cog.karajan.workflow.service.channels.AbstractKarajanChannel.handleRequest(AbstractKarajanChannel.java:519)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel.actualSend(AbstractPipedChannel.java:86)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel$Sender.run(AbstractPipedChannel.java:115)
2013-03-19 20:21:20,259+0000 INFO  RequestHandler Handler(tag: 8, RLOG) unregistering (send)
2013-03-19 20:21:20,259+0000 INFO  BlockQueueProcessor Removing block Block 0319-5807480-000001 (16x3540.000s)
2013-03-19 20:21:20,259+0000 INFO  Block Shutting down block Block 0319-5807480-000002 (16x3540.000s)
2013-03-19 20:21:20,259+0000 INFO  Block Block Block 0319-5807480-000002 (16x3540.000s) not running. Cancelling job.
2013-03-19 20:21:20,259+0000 INFO  RemoteLogHandler BLOCK_SHUTDOWN id=0319-5807480-000002
2013-03-19 20:21:20,259+0000 WARN  Block Failed to shut down block: Block 0319-5807480-000002 (16x3540.000s)
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Can only cancel an active task
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.cancel(AbstractExecutor.java:196)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.cancel(AbstractJobSubmissionTaskHandler.java:85)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.cancel(AbstractTaskHandler.java:69)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:106)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:95)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.cancel(BlockTaskSubmitter.java:46)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.forceShutdown(Block.java:332)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.shutdown(Block.java:312)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdownBlocks(BlockQueueProcessor.java:800)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdown(BlockQueueProcessor.java:789)
	at org.globus.cog.abstraction.coaster.service.job.manager.JobQueue.shutdown(JobQueue.java:119)
	at org.globus.cog.abstraction.coaster.service.CoasterService.shutdown(CoasterService.java:271)
	at org.globus.cog.abstraction.coaster.service.ServiceShutdownHandler.requestComplete(ServiceShutdownHandler.java:28)
	at org.globus.cog.karajan.workflow.service.handlers.RequestHandler.receiveCompleted(RequestHandler.java:88)
	at org.globus.cog.karajan.workflow.service.channels.AbstractKarajanChannel.handleRequest(AbstractKarajanChannel.java:519)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel.actualSend(AbstractPipedChannel.java:86)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel$Sender.run(AbstractPipedChannel.java:115)
2013-03-19 20:21:20,259+0000 INFO  RequestHandler Handler(tag: 9, RLOG) unregistering (send)
2013-03-19 20:21:20,260+0000 INFO  BlockQueueProcessor Removing block Block 0319-5807480-000002 (16x3540.000s)
2013-03-19 20:21:20,260+0000 INFO  Block Shutting down block Block 0319-5807480-000003 (16x3540.000s)
2013-03-19 20:21:20,260+0000 INFO  Block Block Block 0319-5807480-000003 (16x3540.000s) not running. Cancelling job.
2013-03-19 20:21:20,260+0000 INFO  RemoteLogHandler BLOCK_SHUTDOWN id=0319-5807480-000003
2013-03-19 20:21:20,260+0000 WARN  Block Failed to shut down block: Block 0319-5807480-000003 (16x3540.000s)
org.globus.cog.abstraction.impl.common.task.TaskSubmissionException: Can only cancel an active task
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractExecutor.cancel(AbstractExecutor.java:196)
	at org.globus.cog.abstraction.impl.scheduler.common.AbstractJobSubmissionTaskHandler.cancel(AbstractJobSubmissionTaskHandler.java:85)
	at org.globus.cog.abstraction.impl.common.AbstractTaskHandler.cancel(AbstractTaskHandler.java:69)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:106)
	at org.globus.cog.abstraction.impl.common.task.ExecutionTaskHandler.cancel(ExecutionTaskHandler.java:95)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockTaskSubmitter.cancel(BlockTaskSubmitter.java:46)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.forceShutdown(Block.java:332)
	at org.globus.cog.abstraction.coaster.service.job.manager.Block.shutdown(Block.java:312)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdownBlocks(BlockQueueProcessor.java:800)
	at org.globus.cog.abstraction.coaster.service.job.manager.BlockQueueProcessor.shutdown(BlockQueueProcessor.java:789)
	at org.globus.cog.abstraction.coaster.service.job.manager.JobQueue.shutdown(JobQueue.java:119)
	at org.globus.cog.abstraction.coaster.service.CoasterService.shutdown(CoasterService.java:271)
	at org.globus.cog.abstraction.coaster.service.ServiceShutdownHandler.requestComplete(ServiceShutdownHandler.java:28)
	at org.globus.cog.karajan.workflow.service.handlers.RequestHandler.receiveCompleted(RequestHandler.java:88)
	at org.globus.cog.karajan.workflow.service.channels.AbstractKarajanChannel.handleRequest(AbstractKarajanChannel.java:519)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel.actualSend(AbstractPipedChannel.java:86)
	at org.globus.cog.karajan.workflow.service.channels.AbstractPipedChannel$Sender.run(AbstractPipedChannel.java:115)
2013-03-19 20:21:20,260+0000 INFO  RequestHandler Handler(tag: 10, RLOG) unregistering (send)
2013-03-19 20:21:20,260+0000 INFO  BlockQueueProcessor Removing block Block 0319-5807480-000003 (16x3540.000s)
2013-03-19 20:21:20,260+0000 INFO  CoasterService Shutdown sequence completed