Skip to content

Commit

Permalink
Remove long-stack-traces dependency and add a custom version.
Browse files Browse the repository at this point in the history
  • Loading branch information
Kami committed Mar 27, 2011
1 parent 0df4516 commit 2747d96
Show file tree
Hide file tree
Showing 9 changed files with 378 additions and 3 deletions.
75 changes: 75 additions & 0 deletions lib/extern/long-stack-traces/README.md
Original file line number Diff line number Diff line change
@@ -0,0 +1,75 @@
Long Stacktraces
================

Long stacktraces for V8 implemented in user-land JavaScript. Supports Chrome/Chromium and Node.js.

Background
----------

A common problem when debugging event-driven JavaScript is stack traces are limited to a single "event", so it's difficult to trace the code path that caused an error.

A contrived example (taken from the PDF referenced below):

function f() {
throw new Error('foo');
}

setTimeout(f, Math.random()*1000);
setTimeout(f, Math.random()*1000);

Which one throws the first error?

Node.js intended to fix this problem with a solution called "Long Stacktraces": http://nodejs.org/illuminati0.pdf

But what if we wanted something like this in the browser? It turns out V8 already has everything needed to implement this in user-land JavaScript (although in a slightly hacky way).

V8 has a [stack trace API](http://code.google.com/p/v8/wiki/JavaScriptStackTraceApi) that allows custom formatting of textual stack trace representations. By wrapping any function that registers an asynchronous event callback (e.x. `setTimeout` and `addEventListener` in the browser) we can store the stack trace at the time of callback registration, and later append it to stack traces. This also works for multiple levels of events (a timeout or event registered within a timeout or event, etc).

Usage
-----

For Node.js install using `npm install long-stack-traces`.

Simply include the "long-stack-traces.js" via a script tag or other method before any event listener or timeout registrations. In Node.js call `require("long-stack-traces")`.

Stack traces from example above:

Uncaught Error: foo
at f (index.html:24:23)
----------------------------------------
at setTimeout
at onload (index.html:28:40)
Uncaught Error: foo
at f (index.html:24:23)
----------------------------------------
at setTimeout
at onload (index.html:27:40)

Note one was from the timeout on line 27, the other on line 28. Events' stack traces are divided by a line of dashes.

See examples.html for more examples, and run `node examples.js` for a Node.js example.

Supported APIs
--------------

Currently supports the following APIs:

### Chromium ###
* `setTimeout`
* `setInterval`
* `addEventListener`
* `XMLHttpRequest.onreadystatechange` (stack actually recorded upon `send()`)

### Node.js ###
* `setTimeout`
* `setInterval`
* `EventEmitter.addListener`
* `EventEmitter.on`
* All APIs that use `EventEmitter`

TODO
----

* Gracefully degrade in non-V8 environments.
* Figure out what's up with these stack frames when throwing an exception from an input's event handler:
<error: TypeError: Accessing selectionEnd on an input element that cannot have a selection.>
51 changes: 51 additions & 0 deletions lib/extern/long-stack-traces/examples.html
Original file line number Diff line number Diff line change
@@ -0,0 +1,51 @@
<!DOCTYPE html PUBLIC "-//W3C//DTD HTML 4.01//EN"
"http://www.w3.org/TR/html4/strict.dtd">

<html lang="en">
<head>
<meta http-equiv="Content-Type" content="text/html; charset=utf-8">
<title></title>
<script type="text/javascript" charset="utf-8" src="lib/long-stack-traces.js"></script>
<script type="text/javascript" charset="utf-8">

function initSecondTimeout(tag) {
setTimeout(function secondTimeout() {
try {
throw new Error(tag);
} catch (e) {
console.log(e.stack)
}
}, 1000);
}

function onload() {
// function f() {
// throw new Error('foo');
// }
// setTimeout(f, Math.random()*1000);
// setTimeout(f, Math.random()*1000);

setTimeout(function firstTimeout() {
initSecondTimeout("timeout");
}, 1000);

document.getElementById("button").addEventListener("click", function baz() {
initSecondTimeout("click");
}, false);

var req = new XMLHttpRequest();
req.onreadystatechange = function() {
if (this.readyState === 4) {
initSecondTimeout("onreadystatechange");
}
}
req.open("GET", "README.md", false);
req.send();
}

</script>
</head>
<body onload="onload();">
<input type="button" value="click me!" id="button">
</body>
</html>
30 changes: 30 additions & 0 deletions lib/extern/long-stack-traces/examples.js
Original file line number Diff line number Diff line change
@@ -0,0 +1,30 @@
require("./index");

var fs = require("fs");

function initSecondTimeout(tag) {
setTimeout(function secondTimeout() {
throw new Error(tag);
}, 1000);
}

function onload() {
// function f() {
// throw new Error('foo');
// }
// setTimeout(f, Math.random()*1000);
// setTimeout(f, Math.random()*1000);

setTimeout(function firstTimeout() {
initSecondTimeout("timeout");
}, 1000);

fs.readFile('README.md', 'utf8', function (err, data) {
if (err) throw err;
initSecondTimeout("readFile");
});
}

onload();

process.on('uncaughtException', function(e) { console.log('wa');console.log(e.stack)})
1 change: 1 addition & 0 deletions lib/extern/long-stack-traces/index.js
Original file line number Diff line number Diff line change
@@ -0,0 +1 @@
exports = require('./lib/long-stack-traces')
206 changes: 206 additions & 0 deletions lib/extern/long-stack-traces/lib/long-stack-traces.js
Original file line number Diff line number Diff line change
@@ -0,0 +1,206 @@
(function(LST) {
LST.rethrow = false;

var currentTraceError = null;

var filename = new Error().stack.split("\n")[1].match(/^ at ((?:\w+:\/\/)?[^:]+)/)[1];
function filterInternalFrames(frames) {
return frames.split("\n").filter(function(frame) { return frame.indexOf(filename) < 0; }).join("\n");
}

Error.prepareStackTrace = function(error, structuredStackTrace) {
if (!error.__cachedTrace) {
error.__cachedTrace = filterInternalFrames(FormatStackTrace(error, structuredStackTrace));
if (!has.call(error, "__previous")) {
var previous = currentTraceError;
while (previous) {
var previousTrace = previous.stack;
error.__cachedTrace += "\n----------------------------------------\n" +
" at " + previous.__location + "\n" +
previousTrace.substring(previousTrace.indexOf("\n") + 1);
previous = previous.__previous;
}
}
}
return error.__cachedTrace;
}

var slice = Array.prototype.slice;
var has = Object.prototype.hasOwnProperty;

// Takes an object, a property name for the callback function to wrap, and an argument position
// and overwrites the function with a wrapper that captures the stack at the time of callback registration
function wrapRegistrationFunction(object, property, callbackArg) {
if (typeof object[property] !== "function") {
console.error("(long-stack-traces) Object", object, "does not contain function", property);
return;
}
if (!has.call(object, property)) {
console.warn("(long-stack-traces) Object", object, "does not directly contain function", property);
}

// TODO: better source position detection
var sourcePosition = (object.constructor.name || Object.prototype.toString.call(object)) + "." + property;

// capture the original registration function
var fn = object[property];
// overwrite it with a wrapped registration function that modifies the supplied callback argument
object[property] = function() {
// replace the callback argument with a wrapped version that captured the current stack trace
arguments[callbackArg] = makeWrappedCallback(arguments[callbackArg], sourcePosition);
// call the original registration function with the modified arguments
return fn.apply(this, arguments);
}

// check that the registration function was indeed overwritten
if (object[property] === fn)
console.warn("(long-stack-traces) Couldn't replace ", property, "on", object);
}

// Takes a callback function and name, and captures a stack trace, returning a new callback that restores the stack frame
// This function adds a single function call overhead during callback registration vs. inlining it in wrapRegistationFunction
function makeWrappedCallback(callback, frameLocation) {
// add a fake stack frame. we can't get a real one since we aren't inside the original function
var traceError = new Error();
traceError.__location = frameLocation;
traceError.__previous = currentTraceError;
return function() {
// if (currentTraceError) {
// FIXME: This shouldn't normally happen, but it often does. Do we actually need a stack instead?
// console.warn("(long-stack-traces) Internal Error: currentTrace already set.");
// }
// restore the trace
currentTraceError = traceError;
try {
return callback.apply(this, arguments);
} catch (e) {
var stack = e.stack;
e.stack = stack;
throw e;
} finally {
// clear the trace so we can check that none is set above.
// TODO: could we remove this for slightly better performace?
currentTraceError = null;
}
}
}

var global = (function() { return this; })();
wrapRegistrationFunction(global, "setTimeout", 0);
wrapRegistrationFunction(global, "setInterval", 0);

var EventEmitter = require('events').EventEmitter;
wrapRegistrationFunction(EventEmitter.prototype, "addListener", 1);
wrapRegistrationFunction(EventEmitter.prototype, "on", 1);

wrapRegistrationFunction(process, "nextTick", 0);

// Copyright 2006-2008 the V8 project authors. All rights reserved.
// Redistribution and use in source and binary forms, with or without
// modification, are permitted provided that the following conditions are
// met:
//
// * Redistributions of source code must retain the above copyright
// notice, this list of conditions and the following disclaimer.
// * Redistributions in binary form must reproduce the above
// copyright notice, this list of conditions and the following
// disclaimer in the documentation and/or other materials provided
// with the distribution.
// * Neither the name of Google Inc. nor the names of its
// contributors may be used to endorse or promote products derived
// from this software without specific prior written permission.
//
// THIS SOFTWARE IS PROVIDED BY THE COPYRIGHT HOLDERS AND CONTRIBUTORS
// "AS IS" AND ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT
// LIMITED TO, THE IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS FOR
// A PARTICULAR PURPOSE ARE DISCLAIMED. IN NO EVENT SHALL THE COPYRIGHT
// OWNER OR CONTRIBUTORS BE LIABLE FOR ANY DIRECT, INDIRECT, INCIDENTAL,
// SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, BUT NOT
// LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS OF USE,
// DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED AND ON ANY
// THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, OR TORT
// (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF THE USE
// OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF SUCH DAMAGE.

function FormatStackTrace(error, frames) {
var lines = [];
try {
lines.push(error.toString());
} catch (e) {
try {
lines.push("<error: " + e + ">");
} catch (ee) {
lines.push("<error>");
}
}
for (var i = 0; i < frames.length; i++) {
var frame = frames[i];
var line;
try {
line = FormatSourcePosition(frame);
} catch (e) {
try {
line = "<error: " + e + ">";
} catch (ee) {
// Any code that reaches this point is seriously nasty!
line = "<error>";
}
}
lines.push(" at " + line);
}
return lines.join("\n");
}

function FormatSourcePosition(frame) {
var fileLocation = "";
if (frame.isNative()) {
fileLocation = "native";
} else if (frame.isEval()) {
fileLocation = "eval at " + frame.getEvalOrigin();
} else {
var fileName = frame.getFileName();
if (fileName) {
fileLocation += fileName;
var lineNumber = frame.getLineNumber();
if (lineNumber != null) {
fileLocation += ":" + lineNumber;
var columnNumber = frame.getColumnNumber();
if (columnNumber) {
fileLocation += ":" + columnNumber;
}
}
}
}
if (!fileLocation) {
fileLocation = "unknown source";
}
var line = "";
var functionName = frame.getFunction().name;
var addPrefix = true;
var isConstructor = frame.isConstructor();
var isMethodCall = !(frame.isToplevel() || isConstructor);
if (isMethodCall) {
var methodName = frame.getMethodName();
line += frame.getTypeName() + ".";
if (functionName) {
line += functionName;
if (methodName && (methodName != functionName)) {
line += " [as " + methodName + "]";
}
} else {
line += methodName || "<anonymous>";
}
} else if (isConstructor) {
line += "new " + (functionName || "<anonymous>");
} else if (functionName) {
line += functionName;
} else {
line += fileLocation;
addPrefix = false;
}
if (addPrefix) {
line += " (" + fileLocation + ")";
}
return line;
}
})(typeof exports !== "undefined" ? exports : {});
13 changes: 13 additions & 0 deletions lib/extern/long-stack-traces/package.json
Original file line number Diff line number Diff line change
@@ -0,0 +1,13 @@
{
"name": "long-stack-traces",
"description": "Long stacktraces for V8 implemented in user-land JavaScript.",
"version": "0.1.1",
"author": "Tom Robinson <tom@tlrobinson.net> (http://tlrobinson.net/)",
"main" : "./lib/long-stack-traces",
"directories": {
"lib": "./lib"
},
"engines": {
"node": "*"
}
}
1 change: 0 additions & 1 deletion lib/run.js
Original file line number Diff line number Diff line change
Expand Up @@ -24,7 +24,6 @@ var spawn = require('child_process').spawn;

var async = require('async');
var sprintf = require('sprintf').sprintf;
var longStackTraces = require('long-stack-traces/lib/long-stack-traces');

var constants = require('./constants');
var parser = require('./parser');
Expand Down
1 change: 1 addition & 0 deletions lib/run_test_file.js
Original file line number Diff line number Diff line change
Expand Up @@ -17,6 +17,7 @@

var sys = require('sys');

var longStackTraces = require('./extern/long-stack-traces');
var common = require('./common');
var constants = require('./constants');
var testUtil = require('./util');
Expand Down
Loading

0 comments on commit 2747d96

Please sign in to comment.