faster elaborator

Stephen Weeks MLton@sourcelight.com
Wed, 3 Jan 2001 12:19:24 -0800 (PST)


I am pleased to report that the new elaborator that I just finished (and has
taken quite a bit of time over the last 3 weeks) was a complete success.  I
decided to rewrite the elaborator because the old one was the largest bottleneck 
in the non backend portion of the self compile.  The old one used a collection
of linked lists and hash tables (one per structure) which often involved linear
lookups.  The new one uses a hash table per namespace (for a total of 6) with
scoping handled much as it is in lcc. 

The new one is *much* faster.  Here's a comparison with the old one from a self
compile log on 2000-12-11 and a self compile I did today.  These are the times
in seconds to parse and elaborate MLton.
		
		old	new
parse		14	7	
elaborate	45	1

The parse times improved as well presumably because of fewer and faster gcs.
The elaboration environment is also much smaller, with the live size on the last 
gc during elaboration of only 25M (it used to be about 90M). 

The exciting thing about this is that it means that whole program type checking
for use during prototyping can be a reality.  I already usually wait 10-15
seconds for CM to spit out error messages.  With type inference (which only
takes a couple of second on the whole of MLton) integrated with the elaborator,
MLton should be able to spit out type error messages in the same amount of time.

This definitely motivates me to move MLton's type checking into the elaborator
and write a proper front end.  After regaining familiarity with the elaborator
during this rewrite, I don't think it will be all that bad.  But, it should wait 
until after the next release.

Following is a log of the latest self compile, with gc messages interspersed.
Here is a breackdown of the time spent in various places.

pre code gen	196
x86 code gen	492
assembler	 32
total		720
gc		304

Also, I ran a self compile without the -v just to see what our best self-compile
time is.  We're down to 663.

--------------------------------------------------------------------------------

time mlton -v -no-polyvariance mlton.cm
/tmp/fileAvNuvO.0.S 17623: GC
Growing stack to size 14400.
MLton internal (built Wed Jan  3 11:36:08 2001 on starlinux.epr.com)
  created this file on Wed Jan  3 11:38:01 2001.
Do not edit this file.
Flag settings: 
   aux: false
   chunk: chunk per function
   contify strategy: Both
   defines: [NODEBUG,MLton_safe=TRUE,MLton_detectOverflow=TRUE]
   fixed heap: None
   indentation: 3
   includes: [mlton.h]
   inline: NonRecursive {product = 320,small = 60}
   input file: mlton.cm
   instrument: false
   instrument Sxml: false
   keep Cps: false
   match: left to right
   messages: true
   native: true
   native-commented: 0
   native-copy-prop: true
   future: 64
   native-ieee-fp: false
   native-move-hoist: true
   native-optimize: 1
   native-split: Some(100000)
   polyvariance: None
   print at fun entry: false
   profile: false
   show types: false
   use basis library: true
compile starting
/tmp/file2WkbeG.2.S 16810: GC
Growing stack to size 28800.
   parse and elaborate starting
/tmp/file5YdaPa.5.S 13134: GC
Starting gc.
Unmapping toSpace
fromSpace 20,742,144  toSpace 20,971,520
Finished gc.
time(ms): 60
live(bytes): 2,415,688 (11.6%)
/tmp/file5YdaPa.5.S 69861: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 20,971,520  toSpace 20,971,520
Finished gc.
time(ms): 80
live(bytes): 3,034,780 (14.5%)
/tmp/file5YdaPa.5.S 69861: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 22954: GC
Starting gc.
Unmapping toSpace
fromSpace 20,971,520  toSpace 24,543,232
Finished gc.
time(ms): 120
live(bytes): 3,848,252 (18.3%)
/tmp/file2WkbeG.2.S 14090: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 24,543,232  toSpace 31,027,200
Finished gc.
time(ms): 140
live(bytes): 4,803,612 (19.6%)
/tmp/file5YdaPa.5.S 67842: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 31,027,200  toSpace 38,670,336
Finished gc.
time(ms): 180
live(bytes): 5,881,640 (19.0%)
/tmp/file5YdaPa.5.S 89189: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 8666: GC
Starting gc.
fromSpace 38,670,336  toSpace 47,292,416
Finished gc.
time(ms): 240
live(bytes): 7,865,172 (20.3%)
/tmp/file5YdaPa.5.S 67842: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 47,292,416  toSpace 63,160,320
Finished gc.
time(ms): 320
live(bytes): 10,605,076 (22.4%)
/tmp/file5YdaPa.5.S 3892: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 63,160,320  toSpace 85,082,112
Finished gc.
time(ms): 430
live(bytes): 14,128,624 (22.4%)
/tmp/fileAvNuvO.0.S 14615: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 8666: GC
Starting gc.
fromSpace 85,082,112  toSpace 113,270,784
Finished gc.
time(ms): 1,000
live(bytes): 19,470,404 (22.9%)
/tmp/file5YdaPa.5.S 89189: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 24910: GC
Starting gc.
fromSpace 113,270,784  toSpace 156,004,352
Finished gc.
time(ms): 810
live(bytes): 25,469,616 (22.5%)
/tmp/fileAvNuvO.0.S 10764: GC
Growing stack to size 28800.
   parse and elaborate finished in 8.700
   core-ml size is 11,019,960 bytes
   numPeeks = 14
   average position in property list = 0.0
   numPeeks = 290623
   average position in bucket = 1.502
/tmp/file2WkbeG.2.S 16810: GC
Growing stack to size 57600.
   lexAndParse totals 7.310
   elaborate totals 1.200
   dead starting
   dead finished in 0.080
   basis size is 804,664 bytes
   numPeeks = 72609
   average position in property list = 0.0
   numPeeks = 290623
   average position in bucket = 1.502
   size = 186787
   gcc -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/file6FuX7F /tmp/fileEOT59U.c -L/home/sweeks/mlton/lib -lmlton -lm -lgmp
   /tmp/file6FuX7F /tmp/fileomIekH
   infer starting
/tmp/fileb048Nx.6.S 3000: GC
Starting gc.
Unmapping toSpace
fromSpace 156,004,352  toSpace 204,218,368
Finished gc.
time(ms): 470
live(bytes): 11,846,440 (7.6%)
      unification starting
/tmp/fileb048Nx.6.S 35350: GC
Growing stack to size 57600.
/tmp/fileb048Nx.6.S 47545: GC
Growing stack to size 115200.
      unification finished in 1.680
      finish infer starting
/tmp/fileb048Nx.6.S 27525: GC
Starting gc.
fromSpace 204,218,368  toSpace 204,218,368
Finished gc.
time(ms): 1,470
live(bytes): 43,346,788 (21.2%)
/tmp/fileb048Nx.6.S 22463: GC
Starting gc.
Unmapping toSpace
fromSpace 204,218,368  toSpace 224,886,784
Finished gc.
time(ms): 1,350
live(bytes): 43,494,020 (21.3%)
/tmp/fileWaGC6F.1.S 85604: GC
Growing stack to size 57600.
/tmp/file2WkbeG.2.S 99142: GC
Growing stack to size 115200.
/tmp/fileb048Nx.6.S 22307: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,480
live(bytes): 45,670,536 (20.3%)
/tmp/fileWaGC6F.1.S 97886: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,430
live(bytes): 50,857,472 (22.6%)
/tmp/fileb048Nx.6.S 22284: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,280
live(bytes): 45,802,108 (20.4%)
/tmp/fileb048Nx.6.S 18537: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,400
live(bytes): 49,408,684 (22.0%)
/tmp/fileb048Nx.6.S 23261: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,380
live(bytes): 48,818,012 (21.7%)
/tmp/fileWaGC6F.1.S 6597: GC
Growing stack to size 28800.
/tmp/file2WkbeG.2.S 21641: GC
Growing stack to size 57600.
/tmp/file2WkbeG.2.S 21641: GC
Growing stack to size 115200.
/tmp/file2WkbeG.2.S 21641: GC
Growing stack to size 230400.
/tmp/fileb048Nx.6.S 40762: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,300
live(bytes): 46,117,576 (20.5%)
/tmp/fileb048Nx.6.S 46624: GC
Growing stack to size 230400.
      finish infer finished in 21.390
   infer finished in 23.910
   xml.unsimplified size is 36,902,336 bytes
   numPeeks = 1080417
   average position in property list = 0.000
   numPeeks = 429784
   average position in bucket = 1.392
   infer simplify starting
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 460800.
/tmp/file4dQ0c3.3.S 8531: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,600
live(bytes): 72,026,612 (32.0%)
   infer simplify finished in 4.240
   xml size is 20,570,688 bytes
   numPeeks = 3280528
   average position in property list = 0.100
   numPeeks = 429784
   average position in bucket = 1.392
   size = 121155
   num types in program = 21214
   num distinct types = 35993
   hash table size is 0 bytes
   mono starting
/tmp/file2WkbeG.2.S 90005: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 820
live(bytes): 26,545,660 (11.8%)
/tmp/fileWaGC6F.1.S 96120: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 930
live(bytes): 30,049,056 (13.4%)
/tmp/file2WkbeG.2.S 89941: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,430
live(bytes): 47,190,256 (21.0%)
   mono finished in 6.830
   mono.unsimplified size is 47,479,940 bytes
   numPeeks = 8103944
   average position in property list = 0.041
   numPeeks = 1203666
   average position in bucket = 1.838
   mono simplify starting
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 230400.
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 460800.
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 921600.
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 1843200.
/tmp/fileWaGC6F.1.S 12636: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,660
live(bytes): 54,187,308 (24.1%)
   mono simplify finished in 4.020
   mono size is 37,461,140 bytes
   numPeeks = 11412271
   average position in property list = 0.079
   numPeeks = 1203666
   average position in bucket = 1.838
   size = 202763
   num types in program = 13930
   num distinct types = 68384
   hash table size is 0 bytes
   implement exceptions starting
   implement exceptions finished in 0.320
   sxml.unsimplified size is 37,935,580 bytes
   numPeeks = 11726304
   average position in property list = 0.077
   numPeeks = 1205366
   average position in bucket = 1.837
   implement exceptions simplify starting
/tmp/file2WkbeG.2.S 98038: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,090
live(bytes): 64,401,724 (28.6%)
/tmp/file4dQ0c3.3.S 8531: GC
Growing stack to size 921600.
   implement exceptions simplify finished in 4.100
   sxml size is 35,685,876 bytes
   numPeeks = 14252664
   average position in property list = 0.088
   numPeeks = 1205366
   average position in bucket = 1.837
   polyvariance starting
   polyvariance finished in 0.0
   sxml.poly size is 35,685,876 bytes
   numPeeks = 14252664
   average position in property list = 0.088
   numPeeks = 1205366
   average position in bucket = 1.837
   size = 189625
   num types in program = 13512
   num distinct types = 68668
   hash table size is 0 bytes
   closure convert starting
      flow analysis starting
/tmp/fileb048Nx.6.S 56465: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,600
live(bytes): 44,871,272 (20.0%)
      flow analysis finished in 2.450
      flow size is 4,608 bytes
      numPeeks = 15360595
      average position in property list = 0.082
      numPeeks = 1223120
      average position in bucket = 1.828
      free variables starting
      free variables finished in 0.350
      globalize starting
      globalize finished in 0.320
      convert starting
/tmp/file4dQ0c3.3.S 92903: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,270
live(bytes): 85,809,968 (38.2%)
/tmp/file4dQ0c3.3.S 36814: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,620
live(bytes): 107,848,380 (48.0%)
/tmp/fileWaGC6F.1.S 71584: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 4,160
live(bytes): 126,584,708 (56.3%)
/tmp/file4dQ0c3.3.S 36814: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 4,660
live(bytes): 142,467,728 (63.4%)
/tmp/file2WkbeG.2.S 547: GC
Growing stack to size 57600.
/tmp/file4dQ0c3.3.S 39972: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 5,000
live(bytes): 154,707,556 (68.8%)
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 57600.
/tmp/file4dQ0c3.3.S 41114: GC
Growing stack to size 115200.
/tmp/file4dQ0c3.3.S 41114: GC
Growing stack to size 230400.
/tmp/fileAvNuvO.0.S 63841: GC
Growing stack to size 460800.
/tmp/fileSTJKhX.8.S 83498: GC
Growing stack to size 921600.
/tmp/fileSTJKhX.8.S 83498: GC
Growing stack to size 1843200.
/tmp/file4dQ0c3.3.S 36814: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 5,120
live(bytes): 155,453,108 (69.1%)
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 3686400.
      convert finished in 34.160
   closure convert finished in 37.740
   cps.unsimplified size is 70,814,796 bytes
   numPeeks = 22508879
   average position in property list = 1.881
   numPeeks = 1271441
   average position in bucket = 1.793
   closure convert simplify starting
      simplify starting
	 num functions 13015
	 num local functions 147660
	 num primExps 165522
	 removeUnused starting
/tmp/fileWaGC6F.1.S 71538: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,960
live(bytes): 85,795,092 (38.2%)
	 removeUnused finished in 4.270
/tmp/file4dQ0c3.3.S 98782: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,060
live(bytes): 67,101,132 (29.8%)
	 num functions 11235
	 num local functions 85997
	 num primExps 147601
	 leaf-inline starting
	    inline starting
/tmp/fileAvNuvO.0.S 93141: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,530
live(bytes): 72,790,528 (32.4%)
	    inline finished in 4.000
	 leaf-inline finished in 4.000
	 num functions 8491
	 num local functions 60434
	 num primExps 145928
	 raise-to-jump starting
	    inferHandlers starting
/tmp/file4dQ0c3.3.S 59306: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,200
live(bytes): 93,854,976 (41.7%)
	    inferHandlers finished in 3.370
/tmp/file4dQ0c3.3.S 97957: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,290
live(bytes): 97,944,236 (43.6%)
/tmp/file2WkbeG.2.S 1026: GC
Growing stack to size 230400.
	 raise-to-jump finished in 7.940
	 num functions 8491
	 num local functions 60020
	 num primExps 145902
	 contify starting
/tmp/file2WkbeG.2.S 547: GC
Growing stack to size 460800.
/tmp/fileEIBVmM.4.S 24934: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,110
live(bytes): 61,870,892 (27.5%)
	 contify finished in 3.340
	 num functions 3773
	 num local functions 56003
	 num primExps 136840
	 constantPropagation starting
	    inferHandlers starting
	    inferHandlers finished in 0.150
	    fixed point starting
	    fixed point finished in 0.980
/tmp/fileAvNuvO.0.S 93141: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,140
live(bytes): 92,382,360 (41.1%)
/tmp/file2WkbeG.2.S 547: GC
Growing stack to size 230400.
	 constantPropagation finished in 5.910
	 num functions 3773
	 num local functions 55396
	 num primExps 100245
	 useless starting
	    analyze starting
/tmp/fileWaGC6F.1.S 85391: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,040
live(bytes): 61,663,052 (27.4%)
/tmp/fileEIBVmM.4.S 54584: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,230
live(bytes): 95,027,340 (42.3%)
	    analyze finished in 7.450
/tmp/fileEIBVmM.4.S 57086: GC
Growing stack to size 115200.
/tmp/file2WkbeG.2.S 547: GC
Growing stack to size 230400.
/tmp/file4dQ0c3.3.S 94353: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,770
live(bytes): 83,706,904 (37.2%)
	 useless finished in 12.220
	 num functions 3773
	 num local functions 52617
	 num primExps 90965
	 removeUnused starting
	 removeUnused finished in 0.630
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 230400.
/tmp/file4dQ0c3.3.S 97364: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,380
live(bytes): 44,793,648 (19.9%)
	 num functions 3703
	 num local functions 51161
	 num primExps 88220
	 simplifyTypes starting
	    fixed point starting
	    fixed point finished in 0.050
/tmp/fileEIBVmM.4.S 47255: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,560
live(bytes): 48,956,780 (21.8%)
/tmp/file4dQ0c3.3.S 94353: GC
Growing stack to size 115200.
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 230400.
	 simplifyTypes finished in 2.970
	 num functions 3703
	 num local functions 42541
	 num primExps 84883
	 poly-equal starting
	 poly-equal finished in 0.160
	 num functions 3715
	 num local functions 43178
	 num primExps 85382
	 contify starting
	 contify finished in 0.800
	 num functions 3606
	 num local functions 43144
	 num primExps 85232
	 inline starting
/tmp/fileWaGC6F.1.S 72176: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,400
live(bytes): 40,992,020 (18.2%)
/tmp/file2WkbeG.2.S 547: GC
Growing stack to size 230400.
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 460800.
/tmp/fileAvNuvO.0.S 93141: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,450
live(bytes): 67,988,628 (30.2%)
	 inline finished in 5.830
	 num functions 981
	 num local functions 68177
	 num primExps 136940
	 removeUnused starting
	 removeUnused finished in 0.850
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 460800.
/tmp/file4dQ0c3.3.S 94353: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,850
live(bytes): 53,586,008 (23.8%)
	 num functions 981
	 num local functions 65891
	 num primExps 135826
	 raise-to-jump starting
	    inferHandlers starting
	    inferHandlers finished in 0.170
/tmp/file4dQ0c3.3.S 74390: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,950
live(bytes): 56,466,540 (25.1%)
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 230400.
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 460800.
	 raise-to-jump finished in 3.420
	 num functions 981
	 num local functions 65844
	 num primExps 135809
	 contify starting
/tmp/file4dQ0c3.3.S 72218: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,800
live(bytes): 54,299,756 (24.1%)
	 contify finished in 3.040
	 num functions 980
	 num local functions 65842
	 num primExps 135807
	 introduce-loops starting
	 introduce-loops finished in 0.050
	 num functions 980
	 num local functions 65868
	 num primExps 135807
	 loop-invariant starting
/tmp/fileAvNuvO.0.S 63841: GC
Growing stack to size 460800.
/tmp/fileAvNuvO.0.S 58303: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,830
live(bytes): 53,263,464 (23.7%)
	 loop-invariant finished in 2.960
	 num functions 980
	 num local functions 62766
	 num primExps 127670
	 flatten starting
	    analyze starting
	    analyze finished in 0.150
/tmp/fileWaGC6F.1.S 99886: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,920
live(bytes): 55,178,440 (24.5%)
/tmp/file2WkbeG.2.S 1026: GC
Growing stack to size 230400.
	 flatten finished in 3.620
	 num functions 980
	 num local functions 62851
	 num primExps 87198
	 redundant starting
	 redundant finished in 0.740
	 num functions 980
	 num local functions 62851
	 num primExps 87198
	 removeUnused starting
/tmp/fileEIBVmM.4.S 43347: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,200
live(bytes): 58,295,748 (25.9%)
	 removeUnused finished in 2.920
/tmp/fileWaGC6F.1.S 99566: GC
Growing stack to size 230400.
	 num functions 980
	 num local functions 62538
	 num primExps 85539
      simplify finished in 77.030
   closure convert simplify finished in 77.030
   cps size is 50,543,140 bytes
   numPeeks = 54873462
   average position in property list = 0.857
   numPeeks = 1545222
   average position in bucket = 2.045
   backend starting
      compute representations starting
      compute representations finished in 0.030
      inferHandlers starting
      inferHandlers finished in 0.150
      chunkify starting
      chunkify finished in 0.050
/tmp/fileWaGC6F.1.S 57103: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,190
live(bytes): 61,089,984 (27.2%)
      allocate registers starting
/tmp/fileb048Nx.6.S 73990: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 2,930
live(bytes): 82,034,996 (36.5%)
      allocate registers finished in 5.800
/tmp/fileSTJKhX.8.S 90762: GC
Growing stack to size 115200.
/tmp/file4dQ0c3.3.S 58618: GC
Growing stack to size 230400.
/tmp/fileAvNuvO.0.S 48863: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 3,150
live(bytes): 91,015,520 (40.5%)
   backend finished in 12.930
    size is 58,454,824 bytes
   numPeeks = 63096236
   average position in property list = 0.829
   numPeeks = 1546202
   average position in bucket = 2.045
   x86 code gen starting
      outputC starting
      outputC finished in 0.360
      outputAssembly starting
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,800
live(bytes): 55,969,388 (24.9%)
/tmp/fileTrMcKh.7.S 33290: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,570
live(bytes): 55,365,128 (24.6%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,980
live(bytes): 55,133,028 (24.5%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,580
live(bytes): 55,534,328 (24.7%)
/tmp/fileWaGC6F.1.S 97530: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 77669: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,600
live(bytes): 56,059,456 (24.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 84168: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,610
live(bytes): 56,022,404 (24.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,550
live(bytes): 54,363,476 (24.2%)
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,540
live(bytes): 54,309,660 (24.1%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 83589: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,530
live(bytes): 53,983,788 (24.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,540
live(bytes): 54,089,740 (24.1%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,550
live(bytes): 54,143,836 (24.1%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,520
live(bytes): 53,438,972 (23.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,550
live(bytes): 54,023,260 (24.0%)
/tmp/fileAvNuvO.0.S 7032: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,520
live(bytes): 53,427,824 (23.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 83459: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,510
live(bytes): 53,159,964 (23.6%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 7032: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,690
live(bytes): 54,882,104 (24.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,560
live(bytes): 54,050,488 (24.0%)
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,520
live(bytes): 53,059,692 (23.6%)
/tmp/fileAvNuvO.0.S 4558: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,640
live(bytes): 53,742,852 (23.9%)
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,550
live(bytes): 53,633,892 (23.8%)
/tmp/fileWaGC6F.1.S 97530: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,490
live(bytes): 51,950,848 (23.1%)
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,480
live(bytes): 51,784,764 (23.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,480
live(bytes): 51,530,420 (22.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 81942: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,540
live(bytes): 52,020,984 (23.1%)
/tmp/fileWaGC6F.1.S 97530: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,460
live(bytes): 51,057,632 (22.7%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,530
live(bytes): 52,257,528 (23.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,530
live(bytes): 50,912,344 (22.6%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,470
live(bytes): 50,928,780 (22.6%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,460
live(bytes): 50,845,604 (22.6%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,490
live(bytes): 50,587,160 (22.5%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,440
live(bytes): 50,374,976 (22.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30099: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,440
live(bytes): 50,165,552 (22.3%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,510
live(bytes): 49,875,132 (22.2%)
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,450
live(bytes): 49,845,852 (22.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,440
live(bytes): 49,871,920 (22.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,420
live(bytes): 49,313,024 (21.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,430
live(bytes): 49,436,004 (22.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileWaGC6F.1.S 84966: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,470
live(bytes): 49,005,080 (21.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 69154: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,430
live(bytes): 49,276,180 (21.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,400
live(bytes): 48,560,172 (21.6%)
/tmp/fileTrMcKh.7.S 42586: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,450
live(bytes): 48,218,408 (21.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,390
live(bytes): 48,090,532 (21.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 78512: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,410
live(bytes): 48,653,408 (21.6%)
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,470
live(bytes): 48,001,204 (21.3%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/file2WkbeG.2.S 35828: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,380
live(bytes): 47,697,404 (21.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85553: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,360
live(bytes): 46,984,200 (20.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 54000: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,340
live(bytes): 46,825,776 (20.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 84658: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,410
live(bytes): 48,251,320 (21.5%)
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,400
live(bytes): 48,242,040 (21.5%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,350
live(bytes): 46,401,940 (20.6%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,360
live(bytes): 46,783,184 (20.8%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,460
live(bytes): 45,945,088 (20.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,330
live(bytes): 45,856,444 (20.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,320
live(bytes): 45,465,120 (20.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,330
live(bytes): 45,595,960 (20.3%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,330
live(bytes): 45,397,812 (20.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 69154: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,330
live(bytes): 45,533,792 (20.2%)
/tmp/fileAvNuvO.0.S 4558: GC
Growing stack to size 28800.
/tmp/fileWaGC6F.1.S 96283: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,300
live(bytes): 44,421,328 (19.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 66930: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,290
live(bytes): 44,164,916 (19.6%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 115200.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,590
live(bytes): 49,490,732 (22.0%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,380
live(bytes): 46,867,556 (20.8%)
/tmp/fileAvNuvO.0.S 73222: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,380
live(bytes): 46,683,984 (20.8%)
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,360
live(bytes): 46,592,744 (20.7%)
/tmp/fileWaGC6F.1.S 97530: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 10505: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,360
live(bytes): 46,551,312 (20.7%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 42,521,908 (18.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 42,411,112 (18.9%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 73222: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 42,358,480 (18.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,320
live(bytes): 42,626,964 (19.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 42,198,004 (18.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 42,265,868 (18.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,230
live(bytes): 41,218,268 (18.3%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,230
live(bytes): 41,465,952 (18.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileWaGC6F.1.S 84856: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,260
live(bytes): 41,970,716 (18.7%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileWaGC6F.1.S 85312: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,190
live(bytes): 40,439,108 (18.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,200
live(bytes): 40,475,572 (18.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 40,012,688 (17.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 85096: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,170
live(bytes): 39,677,448 (17.6%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,170
live(bytes): 39,448,012 (17.5%)
/tmp/fileAvNuvO.0.S 49708: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 79218: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,160
live(bytes): 39,230,896 (17.4%)
/tmp/fileAvNuvO.0.S 49708: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 6952: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,230
live(bytes): 40,775,508 (18.1%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,140
live(bytes): 38,688,444 (17.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 115200.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,300
live(bytes): 42,043,884 (18.7%)
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,240
live(bytes): 41,162,712 (18.3%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,320
live(bytes): 41,191,040 (18.3%)
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,210
live(bytes): 40,803,136 (18.1%)
/tmp/fileWaGC6F.1.S 97530: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,150
live(bytes): 38,687,244 (17.2%)
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,120
live(bytes): 37,737,720 (16.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileWaGC6F.1.S 84949: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,150
live(bytes): 38,474,180 (17.1%)
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,220
live(bytes): 37,878,196 (16.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileWaGC6F.1.S 96432: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,100
live(bytes): 36,828,032 (16.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 36,458,796 (16.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 10505: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,170
live(bytes): 36,377,292 (16.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49231: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,210
live(bytes): 39,115,804 (17.4%)
/tmp/fileAvNuvO.0.S 49708: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 73521: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,150
live(bytes): 38,185,416 (17.0%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 36,052,820 (16.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 35,451,412 (15.8%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,190
live(bytes): 35,684,436 (15.9%)
/tmp/fileb048Nx.6.S 83851: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,120
live(bytes): 37,140,944 (16.5%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,120,872 (15.6%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 34,874,536 (15.5%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileb048Nx.6.S 85680: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,020
live(bytes): 34,559,828 (15.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 82667: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,120
live(bytes): 35,223,644 (15.7%)
/tmp/fileAvNuvO.0.S 10505: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 34,621,584 (15.4%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileAvNuvO.0.S 6952: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,090
live(bytes): 34,295,008 (15.2%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,020
live(bytes): 34,322,048 (15.3%)
/tmp/fileAvNuvO.0.S 67365: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 980
live(bytes): 33,268,176 (14.8%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 33,883,008 (15.1%)
/tmp/fileb048Nx.6.S 85680: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 950
live(bytes): 32,446,792 (14.4%)
/tmp/fileAvNuvO.0.S 5444: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 115200.
/tmp/fileTrMcKh.7.S 40313: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,130
live(bytes): 36,694,312 (16.3%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,170
live(bytes): 38,178,244 (17.0%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,150
live(bytes): 38,302,144 (17.0%)
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 28800.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 57600.
/tmp/fileTrMcKh.7.S 30157: GC
Growing stack to size 115200.
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,090
live(bytes): 36,515,964 (16.2%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 36,452,388 (16.2%)
/tmp/fileAvNuvO.0.S 48794: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 36,638,080 (16.3%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,150
live(bytes): 38,577,144 (17.2%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,210
live(bytes): 40,683,368 (18.1%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,230
live(bytes): 42,416,820 (18.9%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,270
live(bytes): 43,963,540 (19.5%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,300
live(bytes): 45,331,808 (20.2%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,320
live(bytes): 46,546,032 (20.7%)
/tmp/fileAvNuvO.0.S 49708: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,140
live(bytes): 37,984,688 (16.9%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,190
live(bytes): 40,101,944 (17.8%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,220
live(bytes): 41,827,368 (18.6%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,250
live(bytes): 43,306,412 (19.3%)
/tmp/fileb048Nx.6.S 85142: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,290
live(bytes): 44,726,540 (19.9%)
/tmp/fileb048Nx.6.S 85680: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,080
live(bytes): 36,506,268 (16.2%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,000
live(bytes): 34,132,220 (15.2%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 990
live(bytes): 34,097,532 (15.2%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 990
live(bytes): 34,078,364 (15.2%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 990
live(bytes): 34,063,356 (15.1%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 990
live(bytes): 33,920,740 (15.1%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,000
live(bytes): 34,222,480 (15.2%)
/tmp/fileAvNuvO.0.S 81942: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,000
live(bytes): 34,421,968 (15.3%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,010
live(bytes): 34,567,476 (15.4%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,020
live(bytes): 34,710,716 (15.4%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,020
live(bytes): 34,835,264 (15.5%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,010
live(bytes): 34,951,808 (15.5%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,020
live(bytes): 35,053,700 (15.6%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,149,364 (15.6%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,231,132 (15.7%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,318,132 (15.7%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,401,088 (15.7%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,481,644 (15.8%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,040
live(bytes): 35,559,680 (15.8%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,040
live(bytes): 35,629,104 (15.8%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,040
live(bytes): 35,693,340 (15.9%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,030
live(bytes): 35,755,504 (15.9%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 35,814,296 (15.9%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 35,871,052 (16.0%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 35,929,664 (16.0%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 35,992,944 (16.0%)
/tmp/fileAvNuvO.0.S 6935: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 36,054,448 (16.0%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 36,114,884 (16.1%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,060
live(bytes): 36,173,488 (16.1%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 36,230,008 (16.1%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,060
live(bytes): 36,286,220 (16.1%)
/tmp/fileAvNuvO.0.S 6900: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Finished gc.
time(ms): 1,050
live(bytes): 36,335,552 (16.2%)
	 translateChunk totals 10.870
	 simplify totals 111.710
	    verifyLiveInfo totals 26.530
	    computeJumpInfo totals 1.080
	    elimGoto totals 11.100
	       elimIff: 4
	       elimSwitch: 37
	       elimSimpleGoto totals 2.040
	       elimComplexGoto totals 0.840
	    verifyJumpInfo totals 0.0
	    peepholeBlock_pre totals 4.530
	       commuteBinALMD: 517
	       elimAddSub1: 1919
	       elimMDPow2: 238
	    toLivenessBlock totals 18.870
	    moveHoist totals 20.790
	    peepholeLivenessBlock totals 6.160
	       elimALCopy: 17235
	       elimFltACopy: 23
	       elimDeadDsts: 176
	       elimSelfMove: 923
	       elimFltSelfMove: 0
	       commuteBinALMD: 1001
	       commuteFltBinA: 17
	       conditionalJump: 3248
	    copyPropagate totals 10.980
	    peepholeLivenessBlock_minor totals 4.110
	       elimDeadDsts_minor: 0
	       elimSelfMove_minor: 1
	       elimFltSelfMove_minor: 0
	    verifyLivenessBlock totals 0.0
	    toBlock totals 0.610
	    peepholeBlock_post totals 3.220
	       elimBinALMDDouble: 17
	       elimFltBinADouble: 0
	       elimCMPTST: 10
	    generateTransfers totals 4.570
	 allocateRegisters totals 318.090
	    toLiveness totals 136.530
	    toNoLiveness totals 0.0
	    Assembly.allocateRegisters totals 180.680
	       Instruction.allocateRegisters totals 97.390
		  pre totals 19.830
		  post totals 31.670
		  allocateOperand totals 29.970
		  allocateFltOperand totals 0.0
		  allocateFltStackOperands totals 0.0
	       Directive.allocateRegisters totals 20.620
	 validate totals 0.0
      outputAssembly finished in 451.190
   x86 code gen finished in 491.980
   numPeeks = 70368522
   average position in property list = 0.956
   numPeeks = 1624068
   average position in bucket = 2.035
compile finished in 688.230
/tmp/fileAvNuvO.0.S 39779: GC
Starting gc.
fromSpace 224,886,784  toSpace 224,886,784
Shrinking heap to 1470464 bytes.
Finished gc.
time(ms): 70
live(bytes): 183,716 (0.1%)
/tmp/fileAvNuvO.0.S 37601: GC
Starting gc.
Unmapping toSpace
fromSpace 1,470,464  toSpace 1,585,152
Finished gc.
time(ms): 0
live(bytes): 183,716 (12.5%)
gcc -S -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileUFVJZU.s /tmp/fileKqiy0j.c
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/filegkS2Ps.o /tmp/fileUFVJZU.s
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileH4O8BP.o /tmp/fileatoevt.9.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/filewusT9Z.o /tmp/fileST9wPa.8.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/filei42TBK.o /tmp/fileons5f1.7.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileNFU0vT.o /tmp/fileQ7vDCb.6.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileowl1GK.o /tmp/fileNheiVh.5.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/filero3L5J.o /tmp/fileZT3Zhy.4.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/file4NOkpT.o /tmp/fileAIWVgQ.3.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileM6D6iY.o /tmp/file9eZxWV.2.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/file5EZrAe.o /tmp/fileJFg6Sa.1.S
gcc -c -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o /tmp/fileqjpi1h.o /tmp/fileShZm2m.0.S
gcc -DNODEBUG -DMLton_safe=TRUE -DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -O1 -w -fomit-frame-pointer -fno-strength-reduce -m486 -malign-loops=2 -malign-jumps=2 -malign-functions=2 -o mlton /tmp/filegkS2Ps.o /tmp/fileqjpi1h.o /tmp/file5EZrAe.o /tmp/fileM6D6iY.o /tmp/file4NOkpT.o /tmp/filero3L5J.o /tmp/fileowl1GK.o /tmp/fileNFU0vT.o /tmp/filei42TBK.o /tmp/filewusT9Z.o /tmp/fileH4O8BP.o -L/home/sweeks/mlton/lib -lmlton -lm -lgmp
max semispace size(bytes): 224,886,784
max stack size(bytes): 3,686,400
GC time(ms): 304,480 (44.2%)
maxPause(ms): 5,120
number of GCs: 214
bytes allocated: 36,003,159,076
bytes copied: 9,903,706,492
max bytes live: 155,453,108
size mlton
711.81user 8.59system 12:02.94elapsed 99%CPU (0avgtext+0avgdata 0maxresident)k
0inputs+0outputs (25163major+416334minor)pagefaults 0swaps
   text	   data	    bss	    dec	    hex	filename
3832030	 544248	  27192	4403470	 43310e	mlton