self compile problems with SSA simplifier
Stephen Weeks
MLton@sourcelight.com
Wed, 14 Nov 2001 13:50:38 -0800
In order to try out a self compile, I made the CPS simplifier dead,
and built a version of MLton using an old stable version. This worked
fine, and built something of about the right size (7.4M) in about the
right amount of time (520s). The resulting executable however, is
miserably slow when attempting to self compile. I've appended the log
below. All of the pre-SSA passes are of the usual speed, but the SSA
optimizations are sometimes more than 100X too slow. See,
e.g. removeUnused1. The problem isn't too much live data, since GC%
is roughly normal. Also, since it happens to all SSA passes, I'm
inclined to blame the shrinker, or some kind of property list
problem. Anyways, I'm looking into it, but feel free to do so as
well.
--------------------------------------------------------------------------------
time mlton @MLton gc-messages gc-summary fixed-heap 475m -- -v2 -o mlton-compile mlton.cm
MLton starting
MLton VERSION (built Wed Nov 14 12:31:44 2001 on starlinux)
created this file on Wed Nov 14 12:58:06 2001.
Do not edit this file.
Flag settings:
chunk: chunk per function
debug: false
defines: [NODEBUG,MLton_safe=TRUE,Exn_keepHistory=FALSE,MLton_detectOverflow=TRUE]
detect overflow: true
drop passes: []
exn history: false
fixed heap: None
indentation: 3
includes: [mlton.h]
inline: NonRecursive {product = 320,small = 60}
input file: mlton
instrument: false
instrument Sxml: false
keepCps: false
keepSSA: false
keep diagnostics: []
keep dot: false
keep passes: []
limit check per block: true
new return: false
native: true
native commented: 0
native live stack: false
native optimize: 1
native move hoist: true
native copy prop: true
native cutoff: 100
native live transfer: 8
native future: 64
native ieee fp: false
native split: Some (20000)
optimize SSA: true
polyvariance: Some ({rounds = 2,small = 30,product = 300})
print at fun entry: false
profile: false
safe: true
show types: false
stack cont: false
static: false
type check: false
use basis library: true
verbosity: Pass
Compile SML starting
pre codegen starting
parseAndElaborate starting
/tmp/fileDSDaFe.67.S 25002: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 530
live(bytes): 19,035,028 (7.6%)
/tmp/fileDSDaFe.67.S 25002: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 900
live(bytes): 37,845,512 (15.2%)
/tmp/fileuHQjcZ.64.S 13914: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,270
live(bytes): 54,839,120 (22.0%)
parseAndElaborate finished in 5.68 + 2.70 (32% GC)
lex and parse totals 3.70 + 1.43 (28% GC)
elaborate totals 1.96 + 1.27 (39% GC)
dead starting
dead finished in 0.09 + 0.0 (0.0% GC)
gcc -DNODEBUG -DMLton_safe=TRUE -DExn_keepHistory=FALSE \
-DMLton_detectOverflow=TRUE -I/home/sweeks/mlton/include -o \
/tmp/fileHyHiZU /tmp/filetU1WR2.c -L/home/sweeks/mlton/lib \
-lmlton -lm -lgmp
/tmp/fileHyHiZU /tmp/filerWZGdO
infer starting
unification starting
/tmp/fileczChyd.26.S 2884: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,440
live(bytes): 54,651,784 (21.9%)
unification finished in 1.28 + 1.44 (53% GC)
finishInfer starting
/tmp/fileMR6nEf.29.S 3735: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,420
live(bytes): 62,458,776 (25.1%)
finishInfer finished in 1.56 + 1.42 (48% GC)
infer finished in 3.03 + 2.86 (49% GC)
inferSimplify starting
inferSimplify finished in 1.78 + 0.0 (0.0% GC)
mono starting
/tmp/fileclcTK5.11.S 4967: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 680
live(bytes): 32,143,500 (12.9%)
/tmp/fileclcTK5.11.S 4414: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 850
live(bytes): 40,126,796 (16.1%)
mono finished in 3.23 + 1.53 (32% GC)
monoSimplify starting
/tmp/filerQXs1e.65.S 5307: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,280
live(bytes): 63,178,232 (25.4%)
monoSimplify finished in 2.75 + 1.28 (32% GC)
implementExceptions starting
/tmp/file8zWNYR.9.S 21775: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,010
live(bytes): 49,608,672 (19.9%)
implementExceptions finished in 0.23 + 1.01 (81% GC)
implementExceptionsSimplify starting
implementExceptionsSimplify finished in 2.12 + 0.0 (0.0% GC)
polyvariance starting
/tmp/file8zWNYR.9.S 7602: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,180
live(bytes): 54,057,520 (21.7%)
/tmp/fileIrSjOR.59.S 20217: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,700
live(bytes): 135,423,528 (54.4%)
/tmp/file8zWNYR.9.S 8810: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,510
live(bytes): 57,229,940 (23.0%)
/tmp/filekbEv23.60.S 228: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,770
live(bytes): 79,137,996 (31.8%)
polyvariance finished in 7.92 + 8.16 (51% GC)
closureConvert starting
flow analysis starting
flow analysis finished in 0.98 + 0.0 (0.0% GC)
free variables starting
free variables finished in 0.70 + 0.0 (0.0% GC)
globalize starting
/tmp/fileczChyd.26.S 896: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,810
live(bytes): 86,305,424 (34.7%)
globalize finished in 0.46 + 2.81 (86% GC)
convert starting
/tmp/fileXQvCXA.58.S 13231: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,840
live(bytes): 117,427,524 (47.2%)
/tmp/fileDmNIjw.57.S 456: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,300
live(bytes): 143,332,944 (57.6%)
/tmp/fileT4ZEpI.56.S 14693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,680
live(bytes): 162,593,672 (65.3%)
/tmp/fileXQvCXA.58.S 22714: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,970
live(bytes): 180,175,428 (72.3%)
/tmp/fileXQvCXA.58.S 13481: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 4,300
live(bytes): 192,892,796 (77.5%)
/tmp/fileDSDaFe.67.S 12044: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 4,310
live(bytes): 195,029,820 (78.3%)
/tmp/fileQzAfcj.6.S 9576: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,860
live(bytes): 190,086,092 (76.3%)
convert finished in 5.52 + 26.26 (83% GC)
closureConvert finished in 8.15 + 29.07 (78% GC)
closureConvertSimplify starting
closureConvertSimplify finished in 0.0 + 0.0 (0% GC)
toSSA starting
inferHandlers starting
inferHandlers finished in 0.57 + 0.0 (0.0% GC)
/tmp/fileQzAfcj.6.S 1435: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,780
live(bytes): 110,867,140 (44.5%)
toSSA finished in 1.40 + 2.78 (67% GC)
toSSASimplify starting
checkScopes starting
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,260
live(bytes): 109,798,576 (44.1%)
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,280
live(bytes): 126,109,320 (50.6%)
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,540
live(bytes): 140,891,212 (56.6%)
/tmp/filerQXs1e.65.S 4785: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,790
live(bytes): 154,172,080 (61.9%)
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,950
live(bytes): 165,991,720 (66.7%)
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,130
live(bytes): 175,906,640 (70.6%)
/tmp/filerQXs1e.65.S 4391: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,280
live(bytes): 184,963,480 (74.3%)
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,480
live(bytes): 192,730,428 (77.4%)
/tmp/fileDSDaFe.67.S 7488: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,620
live(bytes): 200,254,892 (80.4%)
checkScopes finished in 5.58 + 26.33 (83% GC)
/tmp/fileJOHGbQ.53.S 4825: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,740
live(bytes): 97,061,480 (39.0%)
removeUnused1 starting
/tmp/filehoVcT2.5.S 52384: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,800
live(bytes): 135,890,720 (54.6%)
/tmp/fileJWJIZg.44.S 16772: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,510
live(bytes): 160,544,996 (64.5%)
/tmp/fileJWJIZg.44.S 17025: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,090
live(bytes): 157,361,188 (63.2%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,120
live(bytes): 166,082,032 (66.7%)
/tmp/filedUrc7Q.45.S 5460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,940
live(bytes): 166,758,956 (67.0%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,960
live(bytes): 167,368,252 (67.2%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,960
live(bytes): 168,088,096 (67.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,990
live(bytes): 168,883,200 (67.8%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,010
live(bytes): 169,716,596 (68.1%)
/tmp/filehoVcT2.5.S 80822: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,020
live(bytes): 170,216,312 (68.3%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,020
live(bytes): 170,612,024 (68.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,090
live(bytes): 172,823,280 (69.4%)
/tmp/filegDexK3.68.S 14316: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,050
live(bytes): 172,279,020 (69.2%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,080
live(bytes): 172,652,020 (69.3%)
/tmp/filegDexK3.68.S 4811: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,080
live(bytes): 173,624,716 (69.7%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,120
live(bytes): 174,895,904 (70.2%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,110
live(bytes): 175,437,768 (70.4%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,130
live(bytes): 175,872,096 (70.6%)
/tmp/fileq7epm1.55.S 2333: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,140
live(bytes): 176,352,548 (70.8%)
/tmp/fileq7epm1.55.S 5554: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,240
live(bytes): 181,006,504 (72.7%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,210
live(bytes): 177,838,792 (71.4%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,190
live(bytes): 178,227,788 (71.6%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,200
live(bytes): 178,650,888 (71.7%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,180
live(bytes): 179,425,140 (72.0%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,180
live(bytes): 179,797,460 (72.2%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,200
live(bytes): 180,289,076 (72.4%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,180
live(bytes): 180,476,360 (72.5%)
/tmp/fileq7epm1.55.S 2709: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,240
live(bytes): 180,975,028 (72.7%)
/tmp/filegDexK3.68.S 14316: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,210
live(bytes): 181,112,676 (72.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,190
live(bytes): 181,571,136 (72.9%)
/tmp/fileq7epm1.55.S 2539: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,210
live(bytes): 182,302,132 (73.2%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,210
live(bytes): 182,982,284 (73.5%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,230
live(bytes): 182,878,712 (73.4%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,200
live(bytes): 183,203,324 (73.6%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,210
live(bytes): 183,683,264 (73.8%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,200
live(bytes): 183,367,960 (73.6%)
/tmp/fileq7epm1.55.S 8767: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,190
live(bytes): 183,323,676 (73.6%)
removeUnused1 finished in 454.48 + 115.89 (20% GC)
leafInline starting
/tmp/filegDexK3.68.S 15660: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,030
live(bytes): 92,836,408 (37.3%)
/tmp/fileq7epm1.55.S 9378: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,960
live(bytes): 96,521,292 (38.8%)
/tmp/fileV0BqRW.51.S 13328: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,060
live(bytes): 101,447,220 (40.7%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,170
live(bytes): 106,341,208 (42.7%)
/tmp/fileq7epm1.55.S 2452: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,290
live(bytes): 112,205,728 (45.1%)
/tmp/fileV0BqRW.51.S 10577: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,390
live(bytes): 115,734,796 (46.5%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,450
live(bytes): 119,690,832 (48.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,550
live(bytes): 123,982,752 (49.8%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,700
live(bytes): 131,555,856 (52.8%)
/tmp/filegDexK3.68.S 4811: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,710
live(bytes): 132,041,028 (53.0%)
/tmp/fileDSDaFe.67.S 16473: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,790
live(bytes): 135,927,644 (54.6%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,870
live(bytes): 139,688,020 (56.1%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,940
live(bytes): 143,271,728 (57.5%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,010
live(bytes): 146,735,788 (58.9%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,090
live(bytes): 150,117,104 (60.3%)
/tmp/fileq7epm1.55.S 2591: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,150
live(bytes): 153,513,712 (61.6%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,220
live(bytes): 156,376,216 (62.8%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,280
live(bytes): 159,357,000 (64.0%)
leafInline finished in 174.44 + 47.66 (21% GC)
contify1 starting
initReachCallerCallees starting
initReachCallerCallees finished in 0.13 + 0.0 (0.0% GC)
analyzeDom starting
buildGraph starting
buildGraph finished in 0.11 + 0.0 (0.0% GC)
computeDominators starting
/tmp/filerQXs1e.65.S 4726: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,690
live(bytes): 84,487,072 (33.9%)
computeDominators finished in 0.67 + 1.69 (72% GC)
compute ADom starting
compute ADom finished in 0.03 + 0.0 (0.0% GC)
analyzeDom finished in 0.89 + 1.69 (66% GC)
transform starting
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,640
live(bytes): 87,000,124 (34.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,670
live(bytes): 89,688,348 (36.0%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,740
live(bytes): 92,391,876 (37.1%)
/tmp/fileq7epm1.55.S 5142: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,800
live(bytes): 95,624,996 (38.4%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,890
live(bytes): 98,454,904 (39.5%)
/tmp/fileq7epm1.55.S 5207: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,980
live(bytes): 101,246,640 (40.7%)
/tmp/fileq7epm1.55.S 8427: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,060
live(bytes): 104,770,356 (42.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,240
live(bytes): 109,241,800 (43.9%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,390
live(bytes): 117,102,940 (47.0%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,370
live(bytes): 115,423,836 (46.3%)
transform finished in 68.24 + 19.78 (22% GC)
contify1 finished in 69.40 + 21.47 (24% GC)
localFlatten1 starting
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,450
live(bytes): 71,977,816 (28.9%)
/tmp/filegDexK3.68.S 14352: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,360
live(bytes): 74,083,796 (29.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,400
live(bytes): 76,382,008 (30.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,450
live(bytes): 78,528,072 (31.5%)
/tmp/fileFONEpw.52.S 12756: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,490
live(bytes): 80,726,064 (32.4%)
/tmp/fileFONEpw.52.S 12260: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,510
live(bytes): 82,911,500 (33.3%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,550
live(bytes): 85,111,284 (34.2%)
/tmp/fileq7epm1.55.S 9378: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,610
live(bytes): 88,192,904 (35.4%)
/tmp/fileDSDaFe.67.S 16302: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,620
live(bytes): 88,955,188 (35.7%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,690
live(bytes): 90,867,040 (36.5%)
localFlatten1 finished in 83.41 + 15.13 (15% GC)
constantPropagation starting
fixed point starting
fixed point finished in 1.49 + 0.0 (0.0% GC)
/tmp/fileyXcV6p.54.S 1144: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 4,420
live(bytes): 184,551,392 (74.1%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,560
live(bytes): 176,508,496 (70.9%)
/tmp/fileDSDaFe.67.S 16391: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,520
live(bytes): 177,539,256 (71.3%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,550
live(bytes): 179,307,344 (72.0%)
/tmp/fileDSDaFe.67.S 12856: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,590
live(bytes): 180,238,868 (72.4%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,650
live(bytes): 182,203,356 (73.2%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,720
live(bytes): 183,742,756 (73.8%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,730
live(bytes): 184,951,216 (74.3%)
/tmp/fileq7epm1.55.S 8767: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,730
live(bytes): 185,487,476 (74.5%)
/tmp/fileq7epm1.55.S 3824: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,780
live(bytes): 186,899,564 (75.0%)
/tmp/fileDSDaFe.67.S 12148: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,790
live(bytes): 187,778,336 (75.4%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,840
live(bytes): 189,107,016 (75.9%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,960
live(bytes): 192,898,268 (77.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,880
live(bytes): 191,257,336 (76.8%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,890
live(bytes): 192,334,400 (77.2%)
/tmp/fileDSDaFe.67.S 12856: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,870
live(bytes): 193,444,612 (77.7%)
/tmp/fileDSDaFe.67.S 16302: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,870
live(bytes): 194,472,060 (78.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,940
live(bytes): 197,770,216 (79.4%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,910
live(bytes): 196,461,452 (78.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,940
live(bytes): 198,792,680 (79.8%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,920
live(bytes): 198,720,128 (79.8%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,890
live(bytes): 199,177,680 (80.0%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,870
live(bytes): 200,022,060 (80.3%)
constantPropagation finished in 83.47 + 87.82 (51% GC)
useless starting
/tmp/filerQXs1e.65.S 553: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,630
live(bytes): 78,466,132 (31.5%)
/tmp/filesdEn4b.43.S 18896: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,580
live(bytes): 123,017,848 (49.4%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,600
live(bytes): 135,637,288 (54.5%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,550
live(bytes): 140,738,788 (56.5%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,660
live(bytes): 145,197,080 (58.3%)
/tmp/filehoVcT2.5.S 62555: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,710
live(bytes): 147,065,840 (59.1%)
/tmp/fileq7epm1.55.S 6855: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,840
live(bytes): 150,936,164 (60.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,960
live(bytes): 156,826,504 (63.0%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,970
live(bytes): 158,191,716 (63.5%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,010
live(bytes): 161,493,940 (64.8%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,120
live(bytes): 164,983,360 (66.2%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,160
live(bytes): 168,166,792 (67.5%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,230
live(bytes): 171,082,480 (68.7%)
/tmp/filehoVcT2.5.S 62868: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,260
live(bytes): 173,782,016 (69.8%)
/tmp/fileV0BqRW.51.S 12952: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,340
live(bytes): 177,732,612 (71.4%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,480
live(bytes): 184,907,724 (74.2%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,410
live(bytes): 182,480,612 (73.3%)
/tmp/fileq7epm1.55.S 6346: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,510
live(bytes): 187,922,904 (75.5%)
useless finished in 73.97 + 53.02 (42% GC)
removeUnused2 starting
/tmp/fileJWJIZg.44.S 19168: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,760
live(bytes): 77,768,948 (31.2%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,670
live(bytes): 77,553,080 (31.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,510
live(bytes): 80,809,264 (32.4%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,560
live(bytes): 83,711,348 (33.6%)
/tmp/fileq7epm1.55.S 6225: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,630
live(bytes): 86,865,408 (34.9%)
/tmp/fileDSDaFe.67.S 12856: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,690
live(bytes): 89,956,580 (36.1%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,780
live(bytes): 93,970,316 (37.7%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,790
live(bytes): 96,152,172 (38.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,840
live(bytes): 99,252,300 (39.9%)
removeUnused2 finished in 73.46 + 15.23 (17% GC)
simplifyTypes starting
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,120
live(bytes): 57,013,784 (22.9%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,320
live(bytes): 68,110,684 (27.3%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,520
live(bytes): 78,431,840 (31.5%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,710
live(bytes): 88,136,084 (35.4%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,920
live(bytes): 97,965,536 (39.3%)
/tmp/fileJWJIZg.44.S 9396: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,090
live(bytes): 106,658,316 (42.8%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,260
live(bytes): 115,838,072 (46.5%)
/tmp/fileq7epm1.55.S 2591: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,560
live(bytes): 130,927,844 (52.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,520
live(bytes): 130,144,908 (52.3%)
simplifyTypes finished in 74.63 + 17.02 (19% GC)
polyEqual starting
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 990
live(bytes): 53,258,028 (21.4%)
/tmp/fileq7epm1.55.S 2333: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,020
live(bytes): 56,522,228 (22.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,080
live(bytes): 59,756,560 (24.0%)
/tmp/fileDSDaFe.67.S 16302: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,140
live(bytes): 63,024,968 (25.3%)
/tmp/fileDSDaFe.67.S 17693: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,210
live(bytes): 66,410,772 (26.7%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,280
live(bytes): 70,595,804 (28.3%)
polyEqual finished in 70.44 + 6.72 (9% GC)
contify2 starting
initReachCallerCallees starting
/tmp/filehoVcT2.5.S 55031: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 970
live(bytes): 52,509,380 (21.1%)
initReachCallerCallees finished in 0.08 + 0.97 (92% GC)
analyzeDom starting
buildGraph starting
buildGraph finished in 0.08 + 0.0 (0.0% GC)
computeDominators starting
computeDominators finished in 0.49 + 0.0 (0.0% GC)
compute ADom starting
compute ADom finished in 0.01 + 0.0 (0.0% GC)
analyzeDom finished in 0.64 + 0.0 (0.0% GC)
transform starting
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,050
live(bytes): 57,047,588 (22.9%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,140
live(bytes): 62,177,260 (25.0%)
/tmp/fileq7epm1.55.S 2333: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,190
live(bytes): 64,097,540 (25.7%)
/tmp/fileq7epm1.55.S 10144: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,240
live(bytes): 67,115,956 (27.0%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,280
live(bytes): 70,393,888 (28.3%)
/tmp/fileFONEpw.52.S 12397: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,330
live(bytes): 73,438,344 (29.5%)
transform finished in 67.09 + 7.23 (10% GC)
contify2 finished in 67.91 + 8.20 (11% GC)
inline starting
/tmp/fileDSDaFe.67.S 15876: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,140
live(bytes): 53,758,892 (21.6%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,310
live(bytes): 62,296,032 (25.0%)
/tmp/filecT0VmH.63.S 2904: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,490
live(bytes): 70,227,700 (28.2%)
/tmp/fileFONEpw.52.S 12699: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,630
live(bytes): 77,411,760 (31.1%)
/tmp/fileDSDaFe.67.S 16302: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,760
live(bytes): 84,328,336 (33.9%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,970
live(bytes): 94,052,812 (37.8%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,050
live(bytes): 97,842,056 (39.3%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,180
live(bytes): 104,869,488 (42.1%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,280
live(bytes): 109,868,300 (44.1%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,430
live(bytes): 116,414,284 (46.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,570
live(bytes): 123,780,980 (49.7%)
/tmp/fileDSDaFe.67.S 15945: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,630
live(bytes): 126,672,596 (50.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,750
live(bytes): 131,816,916 (52.9%)
/tmp/fileq7epm1.55.S 8615: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,870
live(bytes): 137,464,732 (55.2%)
/tmp/fileq7epm1.55.S 2333: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,230
live(bytes): 157,454,588 (63.2%)
/tmp/fileDSDaFe.67.S 15718: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,010
live(bytes): 145,368,368 (58.4%)
/tmp/filegDexK3.68.S 14316: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,190
live(bytes): 152,976,740 (61.4%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,380
live(bytes): 164,587,672 (66.1%)
inline finished in 89.70 + 41.87 (32% GC)
localFlatten2 starting
/tmp/fileFONEpw.52.S 10148: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,460
live(bytes): 70,665,636 (28.4%)
/tmp/fileyXcV6p.54.S 18005: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,450
live(bytes): 74,881,376 (30.1%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,440
live(bytes): 75,688,144 (30.4%)
/tmp/fileDSDaFe.67.S 15969: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,520
live(bytes): 78,414,348 (31.5%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,640
live(bytes): 83,449,652 (33.5%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,650
live(bytes): 84,182,108 (33.8%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,680
live(bytes): 86,629,788 (34.8%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,770
live(bytes): 89,374,840 (35.9%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,760
live(bytes): 91,925,640 (36.9%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,820
live(bytes): 94,575,024 (38.0%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,890
live(bytes): 97,793,868 (39.3%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,900
live(bytes): 99,701,228 (40.0%)
localFlatten2 finished in 61.77 + 19.98 (24% GC)
removeUnused3 starting
/tmp/fileJWJIZg.44.S 18570: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,150
live(bytes): 132,026,820 (53.0%)
/tmp/fileq7epm1.55.S 4668: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,850
live(bytes): 129,248,296 (51.9%)
/tmp/fileq7epm1.55.S 5738: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,600
live(bytes): 131,613,784 (52.8%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,650
live(bytes): 133,964,140 (53.8%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,690
live(bytes): 136,336,836 (54.7%)
/tmp/fileDSDaFe.67.S 16302: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,760
live(bytes): 138,621,904 (55.7%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,860
live(bytes): 140,648,728 (56.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,890
live(bytes): 142,924,852 (57.4%)
/tmp/fileFONEpw.52.S 12397: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,920
live(bytes): 145,069,964 (58.3%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,970
live(bytes): 147,418,392 (59.2%)
/tmp/fileDSDaFe.67.S 12856: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,990
live(bytes): 148,977,780 (59.8%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,050
live(bytes): 151,574,572 (60.9%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,080
live(bytes): 153,408,408 (61.6%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,120
live(bytes): 155,380,252 (62.4%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,140
live(bytes): 157,238,160 (63.1%)
/tmp/fileFONEpw.52.S 12148: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,180
live(bytes): 159,251,956 (63.9%)
/tmp/filecT0VmH.63.S 2904: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,390
live(bytes): 170,802,680 (68.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,250
live(bytes): 162,782,164 (65.4%)
/tmp/fileq7epm1.55.S 3890: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,350
live(bytes): 167,933,236 (67.4%)
/tmp/fileDSDaFe.67.S 17716: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 3,370
live(bytes): 168,344,400 (67.6%)
removeUnused3 finished in 75.27 + 60.26 (44% GC)
contify3 starting
initReachCallerCallees starting
initReachCallerCallees finished in 0.07 + 0.0 (0.0% GC)
analyzeDom starting
buildGraph starting
buildGraph finished in 0.07 + 0.0 (0.0% GC)
computeDominators starting
/tmp/filerQXs1e.65.S 5137: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,560
live(bytes): 77,120,900 (31.0%)
computeDominators finished in 0.34 + 1.56 (82% GC)
compute ADom starting
compute ADom finished in 0.01 + 0.0 (0.0% GC)
analyzeDom finished in 0.45 + 1.56 (78% GC)
transform starting
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,420
live(bytes): 73,712,628 (29.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,480
live(bytes): 76,840,396 (30.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,550
live(bytes): 80,124,056 (32.2%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,670
live(bytes): 85,901,868 (34.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,690
live(bytes): 86,033,240 (34.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,720
live(bytes): 88,404,340 (35.5%)
/tmp/fileDSDaFe.67.S 16427: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,800
live(bytes): 92,312,476 (37.1%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,820
live(bytes): 94,304,888 (37.9%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,920
live(bytes): 98,442,196 (39.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,920
live(bytes): 99,963,868 (40.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,020
live(bytes): 105,499,944 (42.4%)
transform finished in 55.90 + 19.01 (25% GC)
contify3 finished in 56.55 + 20.57 (27% GC)
introduceLoops starting
introduceLoops finished in 0.03 + 0.0 (0.0% GC)
loopInvariant starting
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,370
live(bytes): 71,127,308 (28.6%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,580
live(bytes): 83,686,624 (33.6%)
/tmp/fileq7epm1.55.S 9378: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,450
live(bytes): 75,681,176 (30.4%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,570
live(bytes): 80,169,828 (32.2%)
/tmp/fileq7epm1.55.S 9789: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,620
live(bytes): 82,092,556 (33.0%)
/tmp/fileDSDaFe.67.S 16455: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,640
live(bytes): 83,989,292 (33.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,670
live(bytes): 86,146,508 (34.6%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,760
live(bytes): 88,779,480 (35.6%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,790
live(bytes): 92,989,948 (37.3%)
/tmp/fileq7epm1.55.S 10144: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,810
live(bytes): 93,602,684 (37.6%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,840
live(bytes): 96,237,680 (38.6%)
loopInvariant finished in 56.46 + 18.10 (24% GC)
flatten starting
/tmp/fileFONEpw.52.S 12397: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,190
live(bytes): 106,533,920 (42.8%)
/tmp/filegDexK3.68.S 15660: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,190
live(bytes): 110,694,628 (44.4%)
/tmp/fileq7epm1.55.S 3001: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,210
live(bytes): 111,734,340 (44.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,230
live(bytes): 113,203,996 (45.5%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,330
live(bytes): 115,100,188 (46.2%)
/tmp/fileV0BqRW.51.S 12952: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,350
live(bytes): 116,989,196 (47.0%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,390
live(bytes): 118,812,048 (47.7%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,480
live(bytes): 123,529,764 (49.6%)
/tmp/fileDSDaFe.67.S 16391: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,550
live(bytes): 127,153,544 (51.1%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,570
live(bytes): 128,268,144 (51.5%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,580
live(bytes): 129,601,092 (52.0%)
/tmp/filegDexK3.68.S 15460: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,630
live(bytes): 131,797,924 (52.9%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,650
live(bytes): 133,652,288 (53.7%)
/tmp/filegDexK3.68.S 4418: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,640
live(bytes): 134,008,952 (53.8%)
/tmp/fileDSDaFe.67.S 16473: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,870
live(bytes): 146,588,612 (58.9%)
/tmp/fileDSDaFe.67.S 16473: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,760
live(bytes): 139,917,976 (56.2%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,770
live(bytes): 140,761,292 (56.5%)
flatten finished in 82.93 + 42.39 (34% GC)
localFlatten3 starting
/tmp/filegDexK3.68.S 4811: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,320
live(bytes): 69,084,800 (27.7%)
/tmp/fileV0BqRW.51.S 15292: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,400
live(bytes): 73,410,072 (29.5%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,440
live(bytes): 75,020,044 (30.1%)
/tmp/fileq7epm1.55.S 10144: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,530
live(bytes): 78,739,124 (31.6%)
/tmp/fileuHQjcZ.64.S 12445: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,580
live(bytes): 80,558,020 (32.3%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,660
live(bytes): 84,725,824 (34.0%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,700
live(bytes): 87,262,996 (35.0%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,760
live(bytes): 90,000,576 (36.1%)
/tmp/fileDSDaFe.67.S 14338: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,770
live(bytes): 92,717,732 (37.2%)
/tmp/fileDSDaFe.67.S 14356: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,830
live(bytes): 95,361,988 (38.3%)
/tmp/fileFONEpw.52.S 12260: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,860
live(bytes): 97,511,392 (39.2%)
/tmp/filegDexK3.68.S 14352: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,960
live(bytes): 102,559,428 (41.2%)
localFlatten3 finished in 65.24 + 19.81 (23% GC)
commonSubexp starting
/tmp/fileq7epm1.55.S 8948: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,960
live(bytes): 102,919,384 (41.3%)
/tmp/fileDSDaFe.67.S 14374: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 1,980
live(bytes): 102,965,248 (41.3%)
/tmp/fileq7epm1.55.S 8427: GC
Starting gc.
fromSpace 249,036,800 toSpace 249,036,800
Finished gc.
time(ms): 2,020
live(bytes): 105,159,724 (42.2%)
commonSubexp raised in 21.43 + 5.96 (22% GC)
toSSASimplify raised in 1742.38 + 645.17 (27% GC)
pre codegen raised in 1779.26 + 694.56 (28% GC)
Compile SML raised in 1779.26 + 694.56 (28% GC)
MLton raised in 1779.35 + 694.56 (28% GC)
mlton: unhandled exception: Overflow
max semispace size(bytes): 249,036,800
max stack size(bytes): 18,153,472
GC time(ms): 694,560 (28.1%)
maxPause(ms): 4,420
number of GCs: 285
bytes allocated: 35,723,028,264
bytes copied: 35,462,871,828
max bytes live: 200,254,892
Command exited with non-zero status 1
1323.91user 1150.10system 43:05.29elapsed 95%CPU (0avgtext+0avgdata 0maxresident)k
0inputs+0outputs (3699major+597598minor)pagefaults 0swaps
make[1]: *** [mlton-compile] Error 1
make[1]: Leaving directory `/home/sweeks/mlton/src/mlton'
make: *** [/home/sweeks/mlton/src/mlton/mlton-compile] Error 2