Skip to content

Instantly share code, notes, and snippets.

@chuckremes

chuckremes/gist:9673538

Created March 20, 2014 20:51
Show Gist options
  • Save chuckremes/9673538 to your computer and use it in GitHub Desktop.
Save chuckremes/9673538 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
Total running time: 60.377214919000004s
index % time self children called name
----------------------------------------------------------
[1] 100.0 0.00 60.37 1 Rubinius::Loader#script [1]
0.00 60.37 1 Rubinius::CodeLoader.load_script [2]
0.00 0.00 1 IO.read
-------------------------------------------------------
0.00 60.37 1 Rubinius::Loader#script [1]
[2] 100.0 0.00 60.37 1 Rubinius::CodeLoader.load_script [2]
0.00 60.37 1 Rubinius::CodeLoader#load_script [3]
-------------------------------------------------------
0.00 60.37 1 Rubinius::CodeLoader.load_script [2]
[3] 100.0 0.00 60.37 1 Rubinius::CodeLoader#load_script [3]
0.00 60.37 1 Rubinius.run_script [4]
-------------------------------------------------------
0.00 60.37 1 Rubinius::CodeLoader#load_script [3]
[4] 100.0 0.00 60.37 1 Rubinius.run_script [4]
0.00 60.37 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/lib/benchmark/suite-run.rb [5]
-------------------------------------------------------
0.00 60.37 1 Rubinius.run_script [4]
[5] 100.0 0.00 60.37 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/lib/benchmark/suite-run.rb [5]
0.00 60.31 1 Benchmark::Suite.create [6]
0.00 0.05 2 Kernel#require
0.00 0.01 1 IO.open
0.00 0.00 1 Class#new
0.00 0.00 1 OptionParser#parse!
-------------------------------------------------------
0.00 60.37 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/lib/benchmark/suite-run.rb [5]
[6] 99.9 0.00 60.31 1 Benchmark::Suite.create [6]
0.00 60.31 1 Object::__script__<16> {} [7]
-------------------------------------------------------
0.00 60.31 1 Benchmark::Suite.create [6]
[7] 99.9 0.00 60.31 1 Object::__script__<16> {} [7]
0.00 60.31 1 Array#each [8]
-------------------------------------------------------
0.00 60.31 1 Object::__script__<16> {} [7]
[8] 99.9 0.00 60.31 1 Array#each [8]
0.00 60.31 1 Object::__script__<19> {} [9]
-------------------------------------------------------
0.00 60.31 1 Array#each [8]
[9] 99.9 0.00 60.31 1 Object::__script__<19> {} [9]
0.00 60.31 1 Benchmark::Suite#run [10]
-------------------------------------------------------
0.00 60.31 1 Object::__script__<19> {} [9]
[10] 99.9 0.00 60.31 1 Benchmark::Suite#run [10]
0.00 60.30 1 Kernel#load [11]
-------------------------------------------------------
0.00 60.31 1 Benchmark::Suite#run [10]
[11] 99.9 0.00 60.30 1 Kernel#load [11]
0.00 60.30 1 Rubinius.run_script [12]
-------------------------------------------------------
0.00 60.30 1 Kernel#load [11]
[12] 99.9 0.00 60.30 1 Rubinius.run_script [12]
0.00 60.30 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/core/file/bench_each_byte.rb [13]
-------------------------------------------------------
0.00 60.30 1 Rubinius.run_script [12]
[13] 99.9 0.00 60.30 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/core/file/bench_each_byte.rb [13]
0.00 60.29 1 Benchmark.ips [14]
0.00 0.01 2 Kernel#require
-------------------------------------------------------
0.00 60.30 1 script:/Users/cremes/dev/mygit/rubinius-benchmark/core/file/bench_each_byte.rb [13]
[14] 99.9 0.00 60.29 1 Benchmark.ips [14]
0.00 60.29 1 Array#each [15]
-------------------------------------------------------
0.00 60.29 1 Benchmark.ips [14]
[15] 99.9 0.00 60.29 1 Array#each [15]
0.00 60.29 3 Benchmark::ips<153> {} [16]
-------------------------------------------------------
0.00 60.29 1 Array#each [15]
[16] 99.9 0.00 60.29 3 Benchmark::ips<153> {} [16]
0.00 60.27 36 Benchmark::IPSJob::Entry#call_times [17]
0.00 0.01 3 Benchmark::IPSReport#body
0.00 0.01 6 Benchmark::Timing.clean_env
0.00 0.01 56 Time#to_f
-------------------------------------------------------
0.00 60.29 3 Benchmark::ips<153> {} [16]
[17] 99.8 0.00 60.27 36 Benchmark::IPSJob::Entry#call_times [17]
0.00 60.27 36 Proc#call [18]
-------------------------------------------------------
0.00 60.27 36 Benchmark::IPSJob::Entry#call_times [17]
[18] 99.8 0.00 60.27 36 Proc#call [18]
0.00 44.02 2 Object::__script__<25> {} [19]
0.00 8.82 4 Object::__script__<20> {} [26]
0.00 7.43 30 Object::__script__<15> {} [29]
-------------------------------------------------------
0.00 60.27 36 Proc#call [18]
[19] 72.9 0.00 44.02 2 Object::__script__<25> {} [19]
4.14 39.88 2 IO#each_byte [20]
-------------------------------------------------------
0.00 44.02 2 Object::__script__<25> {} [19]
[20] 72.9 4.14 39.88 2 IO#each_byte [20]
4.51 18.51 2400736 IO#eof? [21]
2.67 13.74 2400734 IO#getbyte [22]
0.23 0.00 1610 GC.collect_young
0.22 0.00 2400734 Object::__script__<26> {}
-------------------------------------------------------
4.14 39.88 2 IO#each_byte [20]
[21] 38.1 4.51 18.51 2400736 IO#eof? [21]
2.69 12.09 2400736 IO::InternalBuffer#fill_from [23]
2.99 0.49 2400736 IO#ensure_open_and_readable [34]
0.25 0.00 2400738 IO::InternalBuffer#exhausted?
-------------------------------------------------------
4.14 39.88 2 IO#each_byte [20]
[22] 27.2 2.67 13.74 2400734 IO#getbyte [22]
4.82 8.75 2400734 IO::InternalBuffer#getbyte [24]
0.18 0.00 2400734 IO#ensure_open
-------------------------------------------------------
4.51 18.51 2400736 IO#eof? [21]
[23] 24.5 2.69 12.09 2400736 IO::InternalBuffer#fill_from [23]
3.87 8.22 2400736 Rubinius.synchronize [25]
-------------------------------------------------------
2.67 13.74 2400734 IO#getbyte [22]
[24] 22.5 4.82 8.75 2400734 IO::InternalBuffer#getbyte [24]
3.50 3.75 2400734 Rubinius.synchronize [31]
1.17 0.16 2400734 IO::InternalBuffer#size
0.16 0.00 2400734 Fixnum#==
-------------------------------------------------------
2.69 12.09 2400736 IO::InternalBuffer#fill_from [23]
[25] 20.0 3.87 8.22 2400736 Rubinius.synchronize [25]
4.65 3.03 2400736 IO::InternalBuffer::fill_from<74> {} [28]
0.30 0.00 2400736 Rubinius.lock
0.24 0.00 2400736 Rubinius.unlock
-------------------------------------------------------
0.00 60.27 36 Proc#call [18]
[26] 14.6 0.00 8.82 4 Object::__script__<20> {} [26]
0.82 8.00 4 IO#each_byte [27]
-------------------------------------------------------
0.00 8.82 4 Object::__script__<20> {} [26]
[27] 14.6 0.82 8.00 4 IO#each_byte [27]
0.90 3.73 480648 IO#eof? [32]
0.53 2.75 480644 IO#getbyte [35]
0.05 0.00 480644 Object::__script__<21> {}
0.04 0.00 318 GC.collect_young
-------------------------------------------------------
3.87 8.22 2400736 Rubinius.synchronize [25]
[28] 12.7 4.65 3.03 2400736 IO::InternalBuffer::fill_from<74> {} [28]
1.23 0.16 2400736 IO::InternalBuffer#empty?
1.18 0.16 2400736 IO::InternalBuffer#size
0.29 0.00 2400736 IO::InternalBuffer#empty_to
0.01 0.00 296 IO::InternalBuffer#fill
-------------------------------------------------------
0.00 60.27 36 Proc#call [18]
[29] 12.3 0.00 7.43 30 Object::__script__<15> {} [29]
0.69 6.74 30 IO#each_byte [30]
-------------------------------------------------------
0.00 7.43 30 Object::__script__<15> {} [29]
[30] 12.3 0.69 6.74 30 IO#each_byte [30]
0.76 3.12 403560 IO#eof? [33]
0.45 2.33 403530 IO#getbyte [38]
0.04 0.00 403530 Object::__script__<16> {}
0.04 0.00 235 GC.collect_young
-------------------------------------------------------
4.82 8.75 2400734 IO::InternalBuffer#getbyte [24]
[31] 12.0 3.50 3.75 2400734 Rubinius.synchronize [31]
2.87 0.33 2400734 IO::InternalBuffer::getbyte<201> {} [36]
0.30 0.00 2400734 Rubinius.lock
0.25 0.00 2400734 Rubinius.unlock
-------------------------------------------------------
0.82 8.00 4 IO#each_byte [27]
[32] 7.7 0.90 3.73 480648 IO#eof? [32]
0.54 2.44 480648 IO::InternalBuffer#fill_from [37]
0.60 0.10 480648 IO#ensure_open_and_readable
0.05 0.00 480652 IO::InternalBuffer#exhausted?
-------------------------------------------------------
0.69 6.74 30 IO#each_byte [30]
[33] 6.4 0.76 3.12 403560 IO#eof? [33]
0.45 2.03 403560 IO::InternalBuffer#fill_from [40]
0.52 0.08 403560 IO#ensure_open_and_readable
0.04 0.00 403590 IO::InternalBuffer#exhausted?
-------------------------------------------------------
4.51 18.51 2400736 IO#eof? [21]
[34] 5.8 2.99 0.49 2400736 IO#ensure_open_and_readable [34]
0.17 0.00 2400736 Fixnum#&
0.16 0.00 2400736 IO#ensure_open
0.16 0.00 2400736 Fixnum#==
-------------------------------------------------------
0.82 8.00 4 IO#each_byte [27]
[35] 5.4 0.53 2.75 480644 IO#getbyte [35]
0.96 1.75 480644 IO::InternalBuffer#getbyte [39]
0.03 0.00 480644 IO#ensure_open
-------------------------------------------------------
3.50 3.75 2400734 Rubinius.synchronize [31]
[36] 5.3 2.87 0.33 2400734 IO::InternalBuffer::getbyte<201> {} [36]
0.18 0.00 2400734 Rubinius::ByteArray#[]
0.16 0.00 2400734 Fixnum#+
-------------------------------------------------------
0.90 3.73 480648 IO#eof? [32]
[37] 4.9 0.54 2.44 480648 IO::InternalBuffer#fill_from [37]
0.78 1.66 480648 Rubinius.synchronize [41]
-------------------------------------------------------
0.69 6.74 30 IO#each_byte [30]
[38] 4.6 0.45 2.33 403530 IO#getbyte [38]
0.79 1.51 403530 IO::InternalBuffer#getbyte [42]
0.03 0.00 403530 IO#ensure_open
-------------------------------------------------------
0.53 2.75 480644 IO#getbyte [35]
[39] 4.5 0.96 1.75 480644 IO::InternalBuffer#getbyte [39]
0.69 0.76 480644 Rubinius.synchronize [45]
0.24 0.03 480644 IO::InternalBuffer#size
0.03 0.00 480644 Fixnum#==
-------------------------------------------------------
0.76 3.12 403560 IO#eof? [33]
[40] 4.1 0.45 2.03 403560 IO::InternalBuffer#fill_from [40]
0.65 1.38 403560 Rubinius.synchronize [43]
0.00 0.00 5 GC.collect_young
-------------------------------------------------------
0.54 2.44 480648 IO::InternalBuffer#fill_from [37]
[41] 4.0 0.78 1.66 480648 Rubinius.synchronize [41]
0.94 0.61 480648 IO::InternalBuffer::fill_from<74> {} [44]
0.06 0.00 480648 Rubinius.lock
0.05 0.00 480648 Rubinius.unlock
-------------------------------------------------------
0.45 2.33 403530 IO#getbyte [38]
[42] 3.8 0.79 1.51 403530 IO::InternalBuffer#getbyte [42]
0.59 0.66 403530 Rubinius.synchronize
0.19 0.03 403530 IO::InternalBuffer#size
0.03 0.00 403530 Fixnum#==
0.00 0.00 29 GC.collect_young
-------------------------------------------------------
0.45 2.03 403560 IO::InternalBuffer#fill_from [40]
[43] 3.4 0.65 1.38 403560 Rubinius.synchronize [43]
0.79 0.50 403560 IO::InternalBuffer::fill_from<74> {}
0.05 0.00 403560 Rubinius.lock
0.04 0.00 403560 Rubinius.unlock
-------------------------------------------------------
0.78 1.66 480648 Rubinius.synchronize [41]
[44] 2.6 0.94 0.61 480648 IO::InternalBuffer::fill_from<74> {} [44]
0.25 0.03 480648 IO::InternalBuffer#size
0.24 0.03 480648 IO::InternalBuffer#empty?
0.06 0.00 480648 IO::InternalBuffer#empty_to
0.00 0.00 64 IO::InternalBuffer#fill
-------------------------------------------------------
0.96 1.75 480644 IO::InternalBuffer#getbyte [39]
[45] 2.4 0.69 0.76 480644 Rubinius.synchronize [45]
0.58 0.07 480644 IO::InternalBuffer::getbyte<201> {}
0.06 0.00 480644 Rubinius.lock
0.05 0.00 480644 Rubinius.unlock
-------------------------------------------------------
265 methods omitted
310 methods called a total of 0 times
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment