2012-05-01-16-09-43-perf_good-rebuild-alt-compiler

gistfile1.txt

myke rebuild-alt-compiler C:\Projects\Perf_Good 
psi: filename = cmd.exe, arguments = /C ant build -buildfile build.xml, home = C:\Projects\Perf_Good
Buildfile: C:\Projects\Perf_Good\build.xml

init.jars.check:

init.jars:

init:
     [echo]        build time: 1 May 2012, 16:09:44
     [echo]      java version: Java HotSpot(TM) 64-Bit Server VM 1.6.0_25
     [echo]         java args: -Xss128m -Xms3072m -Xmx3072m -XX:+UseParallelGC -XX:MaxPermSize=1024M 
     [echo]        javac args: 
     [echo]       scalac args: -Xmacros -Ystatistics
     [echo]      build number: a7cf0c3c31

locker.start:

locker.pre-lib:

locker.lib:

locker.pre-comp:

locker.comp:

locker.done:

quick.start:

quick.pre-lib:

quick.lib:

quick.newlibs:

quick.libs:

quick.newforkjoin:

quick.forkjoin:

quick.pre-comp:

quick.comp:
    [mkdir] Created dir: C:\Projects\Perf_Good\build\quick\classes\compiler
[scalacfork] Compiling 468 files to C:\Projects\Perf_Good\build\quick\classes\compiler
[scalacfork] Enabling statistics, measuring overhead = 52.4926ns to 358.142ns per timer
[scalacfork] *** Cumulative statistics at phase parser
[scalacfork] #created tree nodes  : 582524
[scalacfork] #created tree nodes by type: ArrayBuffer()
[scalacfork] *** Cumulative statistics at phase typer
[scalacfork] #created tree nodes  : 1448357
[scalacfork] #created tree nodes by type: ArrayBuffer()
[scalacfork] #retained nodes          : 725102
[scalacfork] #retained nodes by type  : ArrayBuffer(Select: 182630, Ident: 92435, TypeTree: 92177, Apply: 81256, This: 65058, ValDef: 35252, Literal: 32918, : 31411, DefDef: 25719, TypeApply: 14454, Block: 13108, CaseDef: 9616, If: 7227, Bind: 7150, Function: 4654, New: 4095, Match: 3234, ApplyImplicitView: 3047, Super: 2568, Template: 2534, ApplyToImplicitArgs: 2420, Assign: 2202, Typed: 1742, Import: 1712, ClassDef: 1656, PackageDef: 930, ModuleDef: 878, TypeDef: 793, Throw: 647, LabelDef: 350, Try: 340, Return: 313, UnApply: 300, Alternative: 251, BackQuotedIdent: 15, AppliedTypeTree: 7, Star: 3)
[scalacfork] #typechecked identifiers : 223086
[scalacfork] #typechecked selections  : 135057
[scalacfork] #typechecked applications: 91940
[scalacfork] #raw type creations      : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #unique types            : 729040
[scalacfork] #symbols                 : 715907
[scalacfork]   of which type symbols  : 0
[scalacfork]   of which class symbols : 0
[scalacfork] #base type seqs          : 0
[scalacfork] avg base type seq length : NaN
[scalacfork] #singleton base type seqs: 0
[scalacfork] #compound base type seqs : 0
[scalacfork] #typeref base type seqs  : 0
[scalacfork] #findMember ops          : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #notfound member         : 0
[scalacfork] #multiple member         : 0
[scalacfork] #asSeenFrom ops          : 0
[scalacfork] #subtype                 : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork]   of which in app impl   : 0
[scalacfork]   of which in improv     : 0
[scalacfork] #sametype                : 0
[scalacfork] ms type-flow-analysis: 0
[scalacfork] time spent typechecking  : 1 spans, 35703915539ns (100,0%)
[scalacfork] time classfilereading    : 869 spans, 1077016487ns (3,0%)
[scalacfork] time spent in implicits  : 20400 spans, 9889692098ns (27,7%)
[scalacfork]     successful in scope  : 11895 spans, 4854866581ns (13,6%)
[scalacfork]         failed in scope  : 18705 spans, 2241136941ns (6,3%)
[scalacfork]      successful of type  : 9660 spans, 2513262498ns (7,0%)
[scalacfork]          failed of type  : 15855 spans, 164573569ns (0,5%)
[scalacfork]        assembling parts  : 2882 spans, 671098499ns (1,9%)
[scalacfork]               matchesPT  : 61661 spans, 1808412967ns (5,1%)
[scalacfork] implicit cache hits      : 13903 (82,8%)
[scalacfork] time spent in failed     : 146103 spans, 0ns (0,0%)
[scalacfork]        failed apply      : 76910 spans, 30431044ns (0,1%)
[scalacfork]        failed op=        : 46533 spans, 615557234ns (1,7%)
[scalacfork] time spent ref scanning  : 9 spans, 940017ns (0,0%)
[scalacfork] micros by tree node      : ArrayBuffer(Apply: 10748979, Select: 10629223, Ident: 5703856, DefDef: 1369511, ClassDef: 1190303, If: 864895, Match: 751494, AppliedTypeTree: 644690, Literal: 602030, Block: 573191, ModuleDef: 377919, ValDef: 340337, Function: 254539, TypeApply: 197164, New: 109870, This: 78868, ApplyToImplicitArgs: 73298, ApplyImplicitView: 66470, PackageDef: 64877, Typed: 62785, Bind: 57078, TypeTree: 37859, Assign: 25334, Super: 23902, Annotated: 19664, Try: 15132, ExistentialTypeTree: 14239, TypeBoundsTree: 11807, TypeDef: 10559, SelectFromTypeTree: 9122, LabelDef: 4996, Throw: 4939, AssignOrNamedArg: 3065, Return: 3007, CompoundTypeTree: 2834, SingletonTypeTree: 2763, BackQuotedIdent: 2328, Alternative: 2276, : 564, Star: 152)
[scalacfork] #visits by tree node     : ArrayBuffer(Ident: 240050, Select: 170412, Apply: 90364, TypeTree: 51565, Literal: 40541, DefDef: 25729, Block: 18735, This: 15330, ValDef: 14673, AppliedTypeTree: 14072, If: 7337, Bind: 7176, Function: 6606, TypeApply: 5658, ApplyImplicitView: 5330, New: 4818, Match: 3579, Assign: 3519, ApplyToImplicitArgs: 2669, Super: 2572, ClassDef: 1656, TypeBoundsTree: 1571, Typed: 1194, PackageDef: 930, ModuleDef: 878, : 836, SingletonTypeTree: 687, Throw: 654, Annotated: 619, TypeDef: 393, LabelDef: 353, Try: 345, Return: 318, Alternative: 251, ExistentialTypeTree: 189, SelectFromTypeTree: 82, AssignOrNamedArg: 74, CompoundTypeTree: 44, BackQuotedIdent: 32, Star: 3)
[scalacfork] avg micros by tree node  : ArrayBuffer(ClassDef: 718, ModuleDef: 430, Match: 209, Apply: 118, If: 117, SelectFromTypeTree: 111, ExistentialTypeTree: 75, BackQuotedIdent: 72, PackageDef: 69, CompoundTypeTree: 64, Select: 62, DefDef: 53, Typed: 52, Star: 50, AppliedTypeTree: 45, Try: 43, AssignOrNamedArg: 41, Function: 38, TypeApply: 34, Annotated: 31, Block: 30, ApplyToImplicitArgs: 27, TypeDef: 26, ValDef: 23, Ident: 23, New: 22, Literal: 14, LabelDef: 14, ApplyImplicitView: 12, Alternative: 9, Return: 9, Super: 9, Assign: 7, TypeBoundsTree: 7, Throw: 7, Bind: 7, This: 5, SingletonTypeTree: 4, : 0, TypeTree: 0)
[scalacfork] time spent in <:<        : 0 spans, 0ns (0,0%)
[scalacfork] time spent in findmember : 0 spans, 0ns (0,0%)
[scalacfork] time spent in asSeenFrom : 0 spans, 0ns (0,0%)
[scalacfork] #implicit searches       : 20400
[scalacfork] #tried, plausible, matching, typed, found implicits: 0, 5802, 5802, 5709, 5689
[scalacfork] #implicit improves tests : 15039
[scalacfork] #implicit improves cached: 12400
[scalacfork] #implicit inscope hits   : 3390
[scalacfork] #implicit oftype hits    : 2310
[scalacfork] #ctr1                    : 0
[scalacfork] #ctr2                    : 0
[scalacfork] #ctr3                    : 0
[scalacfork] #ctr4                    : 0
[scalacfork] #counter1                : 0
[scalacfork] #counter2                : 0
[scalacfork] #timer1                  : 0 spans, 0ns
[scalacfork] #timer2                  : 0 spans, 0ns
[scalacfork] *** Cumulative statistics at phase erasure
[scalacfork] #created tree nodes  : 3493706
[scalacfork] #created tree nodes by type: ArrayBuffer()
[scalacfork] #retained nodes          : 1341982
[scalacfork] #retained nodes by type  : ArrayBuffer(Select: 284078, Apply: 237079, TypeTree: 212270, Ident: 115100, This: 100838, ValDef: 72494, DefDef: 61700, : 54880, Block: 44191, Literal: 40739, TypeApply: 31629, New: 16750, If: 15332, Template: 9258, ClassDef: 9258, Super: 9004, Typed: 7173, Assign: 3122, ApplyImplicitView: 3042, LabelDef: 2811, CaseDef: 2781, ApplyToImplicitArgs: 2412, ArrayValue: 1973, Throw: 1951, PackageDef: 930, Try: 377, Match: 296, Return: 273, Bind: 218, ApplyDynamic: 23)
[scalacfork] #typechecked identifiers : 344959
[scalacfork] #typechecked selections  : 436695
[scalacfork] #typechecked applications: 388643
[scalacfork] #raw type creations      : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #unique types            : 872659
[scalacfork] #symbols                 : 1318248
[scalacfork]   of which type symbols  : 0
[scalacfork]   of which class symbols : 0
[scalacfork] #base type seqs          : 0
[scalacfork] avg base type seq length : NaN
[scalacfork] #singleton base type seqs: 0
[scalacfork] #compound base type seqs : 0
[scalacfork] #typeref base type seqs  : 0
[scalacfork] #findMember ops          : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #notfound member         : 0
[scalacfork] #multiple member         : 0
[scalacfork] #asSeenFrom ops          : 0
[scalacfork] #subtype                 : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork]   of which in app impl   : 0
[scalacfork]   of which in improv     : 0
[scalacfork] #sametype                : 0
[scalacfork] ms type-flow-analysis: 0
[scalacfork] #ctr1                    : 0
[scalacfork] #ctr2                    : 0
[scalacfork] #ctr3                    : 0
[scalacfork] #ctr4                    : 0
[scalacfork] #counter1                : 0
[scalacfork] #counter2                : 0
[scalacfork] #timer1                  : 0 spans, 0ns
[scalacfork] #timer2                  : 0 spans, 0ns
[scalacfork] *** Cumulative statistics at phase cleanup
[scalacfork] #created tree nodes  : 4123545
[scalacfork] #created tree nodes by type: ArrayBuffer()
[scalacfork] #retained nodes          : 1639499
[scalacfork] #retained nodes by type  : ArrayBuffer(Select: 366456, Apply: 259704, TypeTree: 239453, Ident: 154346, This: 127488, ValDef: 92769, : 81981, DefDef: 65906, Literal: 52934, Block: 48967, TypeApply: 30385, If: 22709, New: 21701, Assign: 18097, Super: 9398, Template: 9258, ClassDef: 9258, Typed: 7196, Throw: 6255, ApplyImplicitView: 3031, LabelDef: 2811, CaseDef: 2804, ApplyToImplicitArgs: 2377, ArrayValue: 2029, PackageDef: 930, Try: 400, Return: 319, Match: 296, Bind: 241)
[scalacfork] #typechecked identifiers : 367665
[scalacfork] #typechecked selections  : 484908
[scalacfork] #typechecked applications: 415442
[scalacfork] #raw type creations      : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #unique types            : 899241
[scalacfork] #symbols                 : 1420256
[scalacfork]   of which type symbols  : 0
[scalacfork]   of which class symbols : 0
[scalacfork] #base type seqs          : 0
[scalacfork] avg base type seq length : NaN
[scalacfork] #singleton base type seqs: 0
[scalacfork] #compound base type seqs : 0
[scalacfork] #typeref base type seqs  : 0
[scalacfork] #findMember ops          : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork] #notfound member         : 0
[scalacfork] #multiple member         : 0
[scalacfork] #asSeenFrom ops          : 0
[scalacfork] #subtype                 : 0
[scalacfork]   of which in failed     : 0
[scalacfork]   of which in implicits  : 0
[scalacfork]   of which in app impl   : 0
[scalacfork]   of which in improv     : 0
[scalacfork] #sametype                : 0
[scalacfork] ms type-flow-analysis: 0
[scalacfork] #ctr1                    : 0
[scalacfork] #ctr2                    : 0
[scalacfork] #ctr3                    : 0
[scalacfork] #ctr4                    : 0
[scalacfork] #counter1                : 0
[scalacfork] #counter2                : 0
[scalacfork] #timer1                  : 0 spans, 0ns
[scalacfork] #timer2                  : 0 spans, 0ns
[scalacfork] warning: there were 27 deprecation warnings; re-run with -deprecation for details
[scalacfork] warning: there were 23 unchecked warnings; re-run with -unchecked for details
[scalacfork] two warnings found
[propertyfile] Creating new property file: C:\Projects\Perf_Good\build\quick\classes\compiler\compiler.properties
     [copy] Copying 57 files to C:\Projects\Perf_Good\build\quick\classes\compiler
[stopwatch] [quick.comp.timer: 1:50.282 sec]