Skip to content

Instantly share code, notes, and snippets.

@yokolet
Created March 30, 2011 22:58
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save yokolet/895486 to your computer and use it in GitHub Desktop.
Save yokolet/895486 to your computer and use it in GitHub Desktop.
main thread profile results:
Total time: 19.36
total self children calls method
----------------------------------------------------------------
10.10 0.08 10.02 457 Kernel#require
9.23 0.00 9.23 1001 ROXML::ClassMethods::Operations#from_xml
9.15 0.02 9.13 5079 Array#each
8.79 0.00 8.79 1007 Kernel#tap
8.78 0.00 8.78 2001 ROXML::XMLRef#value_in
8.78 0.00 8.78 1 ROXML::XMLObjectRef#fetch_value
8.78 0.00 8.78 2001 ROXML::XMLRef#nodes_in
8.55 0.00 8.55 2 Enumerable#collect
8.55 0.00 8.54 1 Nokogiri::XML::NodeSet#each
8.55 0.03 8.52 2 Integer#upto
8.07 0.02 8.05 2000 ROXML::XMLTextRef#fetch_value
6.93 0.03 6.91 2001 ROXML::XML::NodeExtensions#roxml_search
6.90 0.08 6.82 2001 Nokogiri::XML::Node#search
6.44 0.06 6.37 2001 Nokogiri::XML::Node#xpath
6.44 0.14 6.29 9060 Array#collect
5.86 5.80 0.06 2001 Nokogiri::XML::XPathContext#evaluate
5.51 0.00 5.51 195 Kernel#require
0.47 0.01 0.46 2001 ROXML::XMLRef#xpath
0.47 0.02 0.45 3002 Nokogiri::XML::Node.from
0.46 0.00 0.46 2001 ROXML::XMLRef#xpath_name
0.44 0.00 0.44 1 ROXML::XML.parse_string
0.44 0.00 0.44 1 Nokogiri.XML
0.44 0.00 0.44 1 Nokogiri::XML::Document.parse
0.44 0.44 0.00 1 Nokogiri::XML::Document.read_memory
0.44 0.00 0.44 3 Gem.try_activate
0.39 0.01 0.38 3261 Class#new
0.37 0.02 0.34 3 Gem.searcher
0.34 0.00 0.34 1 Gem::GemPathSearcher#initialize
0.33 0.02 0.31 1 Gem::GemPathSearcher#init_gemspecs
0.31 0.00 0.31 5 Gem.source_index
0.31 0.00 0.31 1 Gem::SourceIndex.from_installed_gems
0.30 0.01 0.29 4002 ROXML::XMLRef#several?
0.29 0.12 0.17 4002 ROXML::XMLRef#array?
0.26 0.26 0.00 6004 Nokogiri::XML::Document#root
0.26 0.01 0.25 2001 ROXML::XML::NodeExtensions#default_namespace
0.25 0.05 0.20 12025 Kernel#send
0.25 0.08 0.17 2001 ROXML::XMLRef#namespacify
0.25 0.01 0.24 2001 Nokogiri::XML::Document#default_namespace
0.24 0.00 0.24 20 Regexp.new
0.24 0.24 0.00 20 Regexp#initialize
0.21 0.01 0.20 2001 ROXML::XMLRef#name
0.20 0.00 0.20 1 Gem::SourceIndex.from_gems_in
0.20 0.00 0.20 1 Gem::SourceIndex#refresh!
0.20 0.00 0.20 1 Gem::SourceIndex#load_gems_in
0.20 0.01 0.19 1 Array#reverse_each
0.19 0.00 0.19 13 Gem::Specification.load
0.19 0.06 0.13 4002 Nokogiri::XML::Node#namespaces
0.18 0.18 0.00 2001 Nokogiri::XML::XPathContext.new
0.18 0.04 0.13 13 Kernel#eval
0.16 0.05 0.11 2001 Nokogiri::XML::Node#extract_params
Flat profile of 20.50 secs (1497 total ticks): main
Interpreted + native Method
4.1% 0 + 61 java.lang.Throwable.fillInStackTrace
3.7% 16 + 40 java.lang.Class.getDeclaredConstructors0
2.2% 33 + 0 org.jruby.javasupport.util.RuntimeHelpers.constructObjectArray
1.8% 0 + 27 java.io.UnixFileSystem.getBooleanAttributes0
1.7% 23 + 3 java.lang.ClassLoader.defineClass1
1.1% 16 + 0 org.jruby.internal.runtime.methods.InvocationMethodFactory.getCompiledMethodOffline
0.9% 14 + 0 nokogiri.XmlDocument.root
0.9% 13 + 0 org.jruby.javasupport.util.RuntimeHelpers.constructRubyArray
0.9% 13 + 0 java.util.regex.Matcher.<init>
0.8% 12 + 0 org.jruby.runtime.Block.<init>
0.8% 0 + 12 sun.nio.ch.FileDispatcher.read0
0.8% 12 + 0 com.sun.org.apache.xpath.internal.VariableStack.<init>
0.7% 11 + 0 org.jruby.compiler.impl.InheritedCacheCompiler.cacheCallSite
0.7% 11 + 0 org.jruby.compiler.impl.StandardInvocationCompiler.invokeDynamic
0.7% 10 + 0 com.sun.org.apache.xpath.internal.VariableStack.reset
0.5% 8 + 0 org.jruby.RubyArray.<init>
0.5% 0 + 8 java.lang.ClassLoader.findLoadedClass0
0.5% 8 + 0 java.util.Hashtable.<init>
0.5% 8 + 0 org.jruby.compiler.impl.StandardASMCompiler.getStaticMethodSignature
0.5% 8 + 0 org.jruby.RubyArray$RubyArrayConversionIterator.next
0.5% 8 + 0 org.jruby.compiler.impl.BaseBodyCompiler.loadRuntime
0.5% 7 + 0 java.util.Arrays.copyOf
0.5% 2 + 5 java.security.AccessController.doPrivileged
0.5% 7 + 0 org.jruby.compiler.impl.MethodBodyCompiler.endBody
0.5% 7 + 0 com.sun.org.apache.xml.internal.dtm.ref.dom2dtm.DOM2DTM.nextNode
67.3% 769 + 239 Total interpreted (including elided)
Compiled + native Method
8.1% 122 + 0 com.sun.org.apache.xml.internal.dtm.ref.dom2dtm.DOM2DTM.addNode
5.0% 75 + 0 com.sun.org.apache.xml.internal.dtm.ref.dom2dtm.DOM2DTM.nextNode
1.3% 19 + 0 com.sun.org.apache.xml.internal.dtm.ref.dom2dtm.DOM2DTM.getHandleFromNode
0.2% 0 + 3 org.jruby.compiler.ASTCompiler.compile
0.2% 3 + 0 org.jruby.org.objectweb.asm.ClassWriter.newUTF8
0.2% 3 + 0 org.jruby.util.CodegenUtils.ci
0.1% 2 + 0 org.jruby.org.objectweb.asm.Frame.b
0.1% 2 + 0 org.jruby.parser.DefaultRubyParser.yyparse
0.1% 2 + 0 org.jruby.org.objectweb.asm.Type.getArgumentsAndReturnSizes
0.1% 2 + 0 sun.nio.cs.UTF_8$Decoder.decodeArrayLoop
0.1% 2 + 0 org.jruby.runtime.callsite.CachingCallSite.call
0.1% 2 + 0 org.jruby.util.CodegenUtils.sigParams
0.1% 2 + 0 org.jruby.org.objectweb.asm.MethodWriter.visitMethodInsn
0.1% 2 + 0 sun.misc.URLClassPath.getResource
0.1% 0 + 2 org.joni.ArrayCompiler.compileLengthTree
0.1% 0 + 2 java.lang.ClassLoader.loadClass
0.1% 1 + 0 org.jruby.org.objectweb.asm.ClassWriter.a
0.1% 1 + 0 org.jruby.org.objectweb.asm.MethodWriter.visitMaxs
0.1% 1 + 0 org.jruby.org.objectweb.asm.Type.a
0.1% 1 + 0 com.sun.org.apache.xpath.internal.axes.AxesWalker.nextNode
0.1% 1 + 0 org.jruby.org.objectweb.asm.ClassWriter.a
0.1% 0 + 1 java.util.AbstractCollection.toArray
0.1% 1 + 0 org.jruby.org.objectweb.asm.Type.getArgumentTypes
0.1% 1 + 0 java.util.regex.Matcher.appendReplacement
0.1% 1 + 0 java.net.URL.<init>
17.7% 255 + 10 Total compiled (including elided)
Stub + native Method
3.0% 0 + 45 java.lang.System.nanoTime
2.3% 0 + 34 java.lang.System.arraycopy
2.1% 0 + 32 java.util.zip.ZipFile.getEntry
1.3% 0 + 20 java.lang.String.intern
1.3% 2 + 17 java.lang.Object.clone
0.5% 2 + 5 java.security.AccessController.doPrivileged
0.4% 0 + 6 java.lang.ClassLoader.findLoadedClass0
0.4% 0 + 6 sun.misc.Unsafe.compareAndSwapInt
0.3% 0 + 4 java.lang.Thread.currentThread
0.1% 0 + 2 java.lang.Class.isPrimitive
0.1% 0 + 2 java.lang.Object.getClass
0.1% 0 + 1 java.io.UnixFileSystem.getBooleanAttributes0
0.1% 0 + 1 sun.misc.Unsafe.getInt
12.0% 4 + 175 Total stub
Thread-local ticks:
3.0% 45 Class loader
Flat profile of 0.00 secs (1 total ticks): DestroyJavaVM
Thread-local ticks:
100.0% 1 Blocked (of total)
Flat profile of 19.61 secs (1425 total ticks): Poller SunPKCS11-Darwin
Thread-local ticks:
100.0% 1425 Blocked (of total)
Global summary of 20.51 seconds:
100.0% 1525 Received ticks
1.3% 20 Received GC ticks
44.5% 678 Compilation
0.3% 5 Other VM operations
3.0% 45 Class loader
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment