Skip to content

Instantly share code, notes, and snippets.

@ghaiklor

ghaiklor/nodejs-prof-process-example-2.txt

Created April 19, 2016 11:54
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 ghaiklor/6232ce737310baf0d39a101f08a3b0f4 to your computer and use it in GitHub Desktop.
Save ghaiklor/6232ce737310baf0d39a101f08a3b0f4 to your computer and use it in GitHub Desktop.
Download ZIP
Example of statistical profiling result in NodeJS
Raw
nodejs-prof-process-example-2.txt
Statistical profiling result from isolate-0x101804a00-v8.log, (107 ticks, 1 unaccounted, 0 excluded).
[Shared libraries]:
ticks total nonlib name
53 49.5% /usr/local/bin/node
47 43.9% /usr/lib/system/libsystem_kernel.dylib
2 1.9% /usr/lib/system/libsystem_malloc.dylib
1 0.9% /usr/lib/system/libsystem_platform.dylib
1 0.9% /usr/lib/system/libsystem_c.dylib
[JavaScript]:
ticks total nonlib name
1 0.9% 33.3% LazyCompile: formatValue util.js:243:21
1 0.9% 33.3% LazyCompile: COMPARE native runtime.js:73:17
[C++]:
ticks total nonlib name
[Summary]:
ticks total nonlib name
2 1.9% 66.7% JavaScript
0 0.0% 0.0% C++
4 3.7% 133.3% GC
104 97.2% Shared libraries
1 0.9% Unaccounted
[C++ entry points]:
ticks cpp total name
[Bottom up (heavy) profile]:
Note: percentage shows a share of a particular caller in the total
amount of its parent calls.
Callers occupying less than 2.0% are not shown.
ticks parent name
53 49.5% /usr/local/bin/node
47 88.7% /usr/local/bin/node
16 34.0% LazyCompile: ~runInThisContext node.js:306:28
16 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
16 100.0% LazyCompile: NativeModule.require node.js:321:34
5 31.3% LazyCompile: ~startup node.js:13:19
3 18.8% Function: ~<anonymous> module.js:1:11
2 12.5% LazyCompile: ~<anonymous> node.js:222:48
2 12.5% Function: ~<anonymous> tty.js:1:11
1 6.3% LazyCompile: ~setupGlobalVariables node.js:201:32
1 6.3% LazyCompile: Module._load module.js:285:24
1 6.3% Function: ~<anonymous> stream.js:1:11
1 6.3% Function: ~<anonymous> assert.js:1:11
2 4.3% LazyCompile: ~Revive native json.js:19:16
2 100.0% LazyCompile: ~Revive native json.js:19:16
2 100.0% LazyCompile: ~parse native json.js:43:19
2 100.0% LazyCompile: ~setupConfig internal/process.js:50:21
2 4.3% Function: ~<anonymous> timers.js:1:11
2 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
2 100.0% LazyCompile: NativeModule.require node.js:321:34
2 100.0% LazyCompile: ~setupGlobalTimeouts node.js:211:31
2 4.3% Function: ~<anonymous> net.js:1:11
2 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
2 100.0% LazyCompile: NativeModule.require node.js:321:34
2 100.0% Function: ~<anonymous> tty.js:1:11
2 4.3% Function: <anonymous> crypto.js:1:11
2 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
2 100.0% LazyCompile: NativeModule.require node.js:321:34
2 100.0% LazyCompile: Module._load module.js:285:24
1 2.1% LazyCompile: ~startup node.js:13:19
1 100.0% Function: ~<anonymous> node.js:10:10
1 2.1% LazyCompile: ~slowToString buffer.js:414:22
1 100.0% LazyCompile: ~Buffer.toString buffer.js:480:37
1 100.0% LazyCompile: fs.readFileSync fs.js:417:27
1 100.0% LazyCompile: ~Module._extensions..js module.js:420:37
1 2.1% LazyCompile: ~setupConfig internal/process.js:50:21
1 100.0% LazyCompile: ~startup node.js:13:19
1 100.0% Function: ~<anonymous> node.js:10:10
1 2.1% LazyCompile: ~onwrite _stream_writable.js:323:17
1 100.0% LazyCompile: ~WritableState.onwrite _stream_writable.js:88:26
1 100.0% LazyCompile: ~Socket._writeGeneric net.js:628:42
1 100.0% LazyCompile: ~Socket._write net.js:697:35
1 2.1% LazyCompile: ~match native string.js:122:23
1 100.0% LazyCompile: ~<anonymous> node.js:353:58
1 100.0% LazyCompile: ~InnerArraySome native array.js:967:24
1 100.0% LazyCompile: ~some native array.js:987:19
1 2.1% LazyCompile: ~fs.Stats fs.js:109:20
1 100.0% /usr/local/bin/node
1 100.0% LazyCompile: ~fs.lstatSync fs.js:885:24
1 100.0% LazyCompile: ~realpathSync fs.js:1458:40
1 2.1% LazyCompile: ~exports.pbkdf2 crypto.js:534:26
1 100.0% LazyCompile: ~hash /Users/ghaiklor/Library/Projects/test.js:5:14
1 100.0% Function: ~<anonymous> /Users/ghaiklor/Library/Projects/test.js:1:11
1 100.0% LazyCompile: ~Module._compile module.js:380:37
1 2.1% LazyCompile: ~exports.inherits util.js:779:28
1 100.0% Function: ~<anonymous> _stream_readable.js:1:11
1 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
1 100.0% LazyCompile: NativeModule.require node.js:321:34
1 2.1% LazyCompile: ~emitPendingUnhandledRejections internal/process/promises.js:37:42
1 100.0% LazyCompile: ~_tickCallback internal/process/next_tick.js:87:25
1 100.0% LazyCompile: ~Module.runMain module.js:445:26
1 100.0% LazyCompile: ~startup node.js:13:19
1 2.1% LazyCompile: ~bind native v8natives.js:1200:22
1 100.0% LazyCompile: ~Console console.js:5:17
1 100.0% Function: ~<anonymous> console.js:1:11
1 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
1 2.1% LazyCompile: ~WritableState.onwrite _stream_writable.js:88:26
1 100.0% LazyCompile: ~Socket._writeGeneric net.js:628:42
1 100.0% LazyCompile: ~Socket._write net.js:697:35
1 100.0% LazyCompile: ~doWrite _stream_writable.js:293:17
1 2.1% LazyCompile: ~WritableState _stream_writable.js:26:23
1 100.0% LazyCompile: ~Writable _stream_writable.js:138:18
1 100.0% LazyCompile: ~Duplex _stream_duplex.js:23:16
1 100.0% LazyCompile: ~Socket net.js:115:16
1 2.1% LazyCompile: ~Uint8Array native typedarray.js:124:31
1 100.0% LazyCompile: ~createBuffer buffer.js:65:22
1 100.0% LazyCompile: ~createPool buffer.js:71:20
1 100.0% Function: ~<anonymous> buffer.js:1:11
1 2.1% LazyCompile: ~ToPropertyDescriptor native v8natives.js:237:30
1 100.0% LazyCompile: ~defineProperty native v8natives.js:766:30
1 100.0% LazyCompile: ~<anonymous> internal/streams/lazy_transform.js:20:19
1 100.0% LazyCompile: ~InnerArrayForEach native array.js:942:27
1 2.1% LazyCompile: ~ReadableState _stream_readable.js:15:23
1 100.0% LazyCompile: ~Readable _stream_readable.js:81:18
1 100.0% LazyCompile: ~Duplex _stream_duplex.js:23:16
1 100.0% LazyCompile: ~Socket net.js:115:16
1 2.1% LazyCompile: ~NativeModule.compile node.js:387:44
1 100.0% LazyCompile: NativeModule.require node.js:321:34
1 100.0% LazyCompile: ~setupGlobalVariables node.js:201:32
1 100.0% LazyCompile: ~startup node.js:13:19
1 2.1% LazyCompile: ~Module._resolveFilename module.js:325:35
1 100.0% LazyCompile: Module._load module.js:285:24
1 100.0% LazyCompile: ~Module.runMain module.js:445:26
1 100.0% LazyCompile: ~startup node.js:13:19
1 2.1% LazyCompile: ~DefineObjectProperty native v8natives.js:464:30
1 100.0% LazyCompile: ~DefineOwnProperty native v8natives.js:633:27
1 100.0% LazyCompile: ~defineProperty native v8natives.js:766:30
1 100.0% Function: ~<anonymous> events.js:1:11
1 2.1% LazyCompile: ~<anonymous> internal/process/stdio.js:23:46
1 100.0% Function: ~<anonymous> console.js:1:11
1 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
1 100.0% LazyCompile: NativeModule.require node.js:321:34
1 2.1% LazyCompile: SHR native runtime.js:266:13
1 100.0% LazyCompile: ~isFd fs.js:104:14
1 100.0% LazyCompile: fs.readFileSync fs.js:417:27
1 100.0% LazyCompile: ~Module._extensions..js module.js:420:37
1 2.1% LazyCompile: Module._load module.js:285:24
1 100.0% LazyCompile: ~Module.runMain module.js:445:26
1 100.0% LazyCompile: ~startup node.js:13:19
1 100.0% Function: ~<anonymous> node.js:10:10
1 2.1% Function: ~<anonymous> node.js:10:10
1 2.1% Function: ~<anonymous> fs.js:1:11
1 100.0% LazyCompile: ~NativeModule.compile node.js:387:44
1 100.0% LazyCompile: NativeModule.require node.js:321:34
1 100.0% Function: ~<anonymous> module.js:1:11
47 43.9% /usr/lib/system/libsystem_kernel.dylib
1 2.1% /usr/local/bin/node
1 100.0% LazyCompile: NativeModule node.js:311:24
1 100.0% LazyCompile: NativeModule.require node.js:321:34
1 100.0% LazyCompile: ~startup node.js:13:19
1 100.0% Function: ~<anonymous> node.js:10:10
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment