log.txt

scala@scalabench:~$ cat /proc/cmdline
BOOT_IMAGE=/boot/vmlinuz-3.16.0-4-amd64 root=UUID=64ababa6-cf06-401f-a05b-749630ec8fca ro quiet

scala@scalabench:~/compiler-benchmark$ taskset -c 1-3 sbt
[info] Loading project definition from /home/scala/compiler-benchmark/project
[info] Set current project to compiler-benchmark (in build file:/home/scala/compiler-benchmark/)
> hot -p source=scalap -wi 20 -i 10 -f 1
[info] Running org.openjdk.jmh.Main HotScalacBenchmark -p source=scalap -wi 20 -i 10 -f 1
[info] # JMH 1.14.1 (released 237 days ago, please consider updating!)
[info] # VM version: JDK 1.8.0_131, VM 25.131-b11
[info] # VM invoker: /usr/lib/jvm/java-8-oracle/jre/bin/java
[info] # VM options: -DscalaVersion=2.11.8 -DscalaRef=v2.11.8
[info] # Warmup: 20 iterations, 10 s each
[info] # Measurement: 10 iterations, 10 s each
[info] # Timeout: 10 min per iteration
[info] # Threads: 1 thread, will synchronize iterations
[info] # Benchmark mode: Sampling time
[info] # Benchmark: scala.tools.nsc.HotScalacBenchmark.compile
[info] # Parameters: (extraArgs = , source = scalap)
[info]
[info] # Run progress: 0.00% complete, ETA 00:05:00
[info] # Fork: 1 of 1
[info] # Warmup Iteration   1: 3991.579 ±(99.9%) 39738.152 ms/op
[info] # Warmup Iteration   2: 2114.768 ±(99.9%) 646.550 ms/op
[info] # Warmup Iteration   3: 1710.577 ±(99.9%) 308.317 ms/op
[info] # Warmup Iteration   4: 1574.961 ±(99.9%) 175.164 ms/op
[info] # Warmup Iteration   5: 1443.440 ±(99.9%) 113.283 ms/op
[info] # Warmup Iteration   6: 1354.498 ±(99.9%) 56.764 ms/op
[info] # Warmup Iteration   7: 1315.439 ±(99.9%) 49.748 ms/op
[info] # Warmup Iteration   8: 1302.594 ±(99.9%) 79.024 ms/op
[info] # Warmup Iteration   9: 1276.903 ±(99.9%) 42.512 ms/op
[info] # Warmup Iteration  10: 1279.525 ±(99.9%) 55.990 ms/op
[info] # Warmup Iteration  11: 1259.078 ±(99.9%) 13.026 ms/op
[info] # Warmup Iteration  12: 1253.048 ±(99.9%) 15.306 ms/op
[info] # Warmup Iteration  13: 1254.883 ±(99.9%) 14.044 ms/op
[info] # Warmup Iteration  14: 1255.932 ±(99.9%) 31.312 ms/op
[info] # Warmup Iteration  15: 1246.640 ±(99.9%) 15.067 ms/op
[info] # Warmup Iteration  16: 1247.805 ±(99.9%) 11.555 ms/op
[info] # Warmup Iteration  17: 1248.971 ±(99.9%) 31.771 ms/op
[info] # Warmup Iteration  18: 1243.611 ±(99.9%) 33.386 ms/op
[info] # Warmup Iteration  19: 1238.485 ±(99.9%) 15.271 ms/op
[info] # Warmup Iteration  20: 1236.854 ±(99.9%) 10.973 ms/op
[info] Iteration   1: 1242.446 ±(99.9%) 27.018 ms/op
[info]                  compile·p0.00:   1228.931 ms/op
[info]                  compile·p0.50:   1239.417 ms/op
[info]                  compile·p0.90:   1283.457 ms/op
[info]                  compile·p0.95:   1283.457 ms/op
[info]                  compile·p0.99:   1283.457 ms/op
[info]                  compile·p0.999:  1283.457 ms/op
[info]                  compile·p0.9999: 1283.457 ms/op
[info]                  compile·p1.00:   1283.457 ms/op
[info]
[info] Iteration   2: 1238.485 ±(99.9%) 6.850 ms/op
[info]                  compile·p0.00:   1231.028 ms/op
[info]                  compile·p0.50:   1239.417 ms/op
[info]                  compile·p0.90:   1243.611 ms/op
[info]                  compile·p0.95:   1243.611 ms/op
[info]                  compile·p0.99:   1243.611 ms/op
[info]                  compile·p0.999:  1243.611 ms/op
[info]                  compile·p0.9999: 1243.611 ms/op
[info]                  compile·p1.00:   1243.611 ms/op
[info]
[info] Iteration   3: 1236.621 ±(99.9%) 13.649 ms/op
[info]                  compile·p0.00:   1226.834 ms/op
[info]                  compile·p0.50:   1237.320 ms/op
[info]                  compile·p0.90:   1249.903 ms/op
[info]                  compile·p0.95:   1249.903 ms/op
[info]                  compile·p0.99:   1249.903 ms/op
[info]                  compile·p0.999:  1249.903 ms/op
[info]                  compile·p0.9999: 1249.903 ms/op
[info]                  compile·p1.00:   1249.903 ms/op
[info]
[info] Iteration   4: 1235.689 ±(99.9%) 6.047 ms/op
[info]                  compile·p0.00:   1228.931 ms/op
[info]                  compile·p0.50:   1237.320 ms/op
[info]                  compile·p0.90:   1239.417 ms/op
[info]                  compile·p0.95:   1239.417 ms/op
[info]                  compile·p0.99:   1239.417 ms/op
[info]                  compile·p0.999:  1239.417 ms/op
[info]                  compile·p0.9999: 1239.417 ms/op
[info]                  compile·p1.00:   1239.417 ms/op
[info]
[info] Iteration   5: 1231.494 ±(99.9%) 6.774 ms/op
[info]                  compile·p0.00:   1228.931 ms/op
[info]                  compile·p0.50:   1228.931 ms/op
[info]                  compile·p0.90:   1239.417 ms/op
[info]                  compile·p0.95:   1239.417 ms/op
[info]                  compile·p0.99:   1239.417 ms/op
[info]                  compile·p0.999:  1239.417 ms/op
[info]                  compile·p0.9999: 1239.417 ms/op
[info]                  compile·p1.00:   1239.417 ms/op
[info]
[info] Iteration   6: 1238.718 ±(99.9%) 24.031 ms/op
[info]                  compile·p0.00:   1226.834 ms/op
[info]                  compile·p0.50:   1237.320 ms/op
[info]                  compile·p0.90:   1275.068 ms/op
[info]                  compile·p0.95:   1275.068 ms/op
[info]                  compile·p0.99:   1275.068 ms/op
[info]                  compile·p0.999:  1275.068 ms/op
[info]                  compile·p0.9999: 1275.068 ms/op
[info]                  compile·p1.00:   1275.068 ms/op
[info]
[info] Iteration   7: 1237.553 ±(99.9%) 26.457 ms/op
[info]                  compile·p0.00:   1226.834 ms/op
[info]                  compile·p0.50:   1228.931 ms/op
[info]                  compile·p0.90:   1275.068 ms/op
[info]                  compile·p0.95:   1275.068 ms/op
[info]                  compile·p0.99:   1275.068 ms/op
[info]                  compile·p0.999:  1275.068 ms/op
[info]                  compile·p0.9999: 1275.068 ms/op
[info]                  compile·p1.00:   1275.068 ms/op
[info]
[info] Iteration   8: 1234.290 ±(99.9%) 24.864 ms/op
[info]                  compile·p0.00:   1226.834 ms/op
[info]                  compile·p0.50:   1228.931 ms/op
[info]                  compile·p0.90:   1272.971 ms/op
[info]                  compile·p0.95:   1272.971 ms/op
[info]                  compile·p0.99:   1272.971 ms/op
[info]                  compile·p0.999:  1272.971 ms/op
[info]                  compile·p0.9999: 1272.971 ms/op
[info]                  compile·p1.00:   1272.971 ms/op
[info]
[info] Iteration   9: 1230.096 ±(99.9%) 8.830 ms/op
[info]                  compile·p0.00:   1224.737 ms/op
[info]                  compile·p0.50:   1228.931 ms/op
[info]                  compile·p0.90:   1241.514 ms/op
[info]                  compile·p0.95:   1241.514 ms/op
[info]                  compile·p0.99:   1241.514 ms/op
[info]                  compile·p0.999:  1241.514 ms/op
[info]                  compile·p0.9999: 1241.514 ms/op
[info]                  compile·p1.00:   1241.514 ms/op
[info]
[info] Iteration  10: 1233.824 ±(99.9%) 28.083 ms/op
[info]                  compile·p0.00:   1224.737 ms/op
[info]                  compile·p0.50:   1226.834 ms/op
[info]                  compile·p0.90:   1277.166 ms/op
[info]                  compile·p0.95:   1277.166 ms/op
[info]                  compile·p0.99:   1277.166 ms/op
[info]                  compile·p0.999:  1277.166 ms/op
[info]                  compile·p0.9999: 1277.166 ms/op
[info]                  compile·p1.00:   1277.166 ms/op
[info]
[info]
[info]
[info] Result "compile":
[info]   N = 90
[info]   mean =   1235.922 ±(99.9%) 4.144 ms/op
[info]
[info]   Histogram, ms/op:
[info]     [1220.000, 1225.000) = 4
[info]     [1225.000, 1230.000) = 29
[info]     [1230.000, 1235.000) = 13
[info]     [1235.000, 1240.000) = 29
[info]     [1240.000, 1245.000) = 7
[info]     [1245.000, 1250.000) = 3
[info]     [1250.000, 1255.000) = 0
[info]     [1255.000, 1260.000) = 0
[info]     [1260.000, 1265.000) = 0
[info]     [1265.000, 1270.000) = 0
[info]     [1270.000, 1275.000) = 1
[info]     [1275.000, 1280.000) = 3
[info]     [1280.000, 1285.000) = 1
[info]
[info]   Percentiles, ms/op:
[info]       p(0.0000) =   1224.737 ms/op
[info]      p(50.0000) =   1233.125 ms/op
[info]      p(90.0000) =   1243.611 ms/op
[info]      p(95.0000) =   1273.915 ms/op
[info]      p(99.0000) =   1283.457 ms/op
[info]      p(99.9000) =   1283.457 ms/op
[info]      p(99.9900) =   1283.457 ms/op
[info]      p(99.9990) =   1283.457 ms/op
[info]      p(99.9999) =   1283.457 ms/op
[info]     p(100.0000) =   1283.457 ms/op
[info]
[info]
[info] # Run complete. Total time: 00:05:25
[info]
[info] Benchmark                                   (extraArgs)  (source)    Mode  Cnt     Score   Error  Units
[info] HotScalacBenchmark.compile                                 scalap  sample   90  1235.922 ± 4.144  ms/op
[info] HotScalacBenchmark.compile:compile·p0.00                   scalap  sample       1224.737          ms/op
[info] HotScalacBenchmark.compile:compile·p0.50                   scalap  sample       1233.125          ms/op
[info] HotScalacBenchmark.compile:compile·p0.90                   scalap  sample       1243.611          ms/op
[info] HotScalacBenchmark.compile:compile·p0.95                   scalap  sample       1273.915          ms/op
[info] HotScalacBenchmark.compile:compile·p0.99                   scalap  sample       1283.457          ms/op
[info] HotScalacBenchmark.compile:compile·p0.999                  scalap  sample       1283.457          ms/op
[info] HotScalacBenchmark.compile:compile·p0.9999                 scalap  sample       1283.457          ms/op
[info] HotScalacBenchmark.compile:compile·p1.00                   scalap  sample       1283.457          ms/op
[success] Total time: 326 s, completed May 15, 2017 4:32:25 AM
>