From a04962cdb747bc8eef6f7a23bc661f7134fca6a8 Mon Sep 17 00:00:00 2001
From: Gregg Zigler <gregg@bitpay.com>
Date: Mon, 22 Jun 2015 15:45:19 -0400
Subject: [PATCH] debug travis issue

---
 test/integration/server.js | 20 +++++++++++++++++++-
 1 file changed, 19 insertions(+), 1 deletion(-)

diff --git a/test/integration/server.js b/test/integration/server.js
index 0aec2fd..f9ae88b 100644
--- a/test/integration/server.js
+++ b/test/integration/server.js
@@ -1770,13 +1770,17 @@ describe('Wallet service', function() {
     });
 
     it('should follow backoff time after consecutive rejections', function(done) {
-      this.timeout(10000); // find out why travis is timing out
+      function logTime(i, j) {
+        console.log('createTx backoff ' + i + ' ' + j + ' ' + (Date.now()));
+      };
       async.series([
 
         function(next) {
           async.each(_.range(3), function(i, next) {
               var txOpts = helpers.createProposalOpts('18PzpUFkFZE8zKWUPvfykkTxmB9oMR8qP7', 1, null, TestData.copayers[0].privKey_1H_0);
+              logTime('' + (i + 1), 'a');
               server.createTx(txOpts, function(err, tx) {
+                logTime('' + (i + 1), 'b');
                 should.not.exist(err);
                 server.rejectTx({
                   txProposalId: tx.id,
@@ -1789,7 +1793,9 @@ describe('Wallet service', function() {
         function(next) {
           // Allow a 4th tx
           var txOpts = helpers.createProposalOpts('18PzpUFkFZE8zKWUPvfykkTxmB9oMR8qP7', 1, null, TestData.copayers[0].privKey_1H_0);
+          logTime('4', 'a');
           server.createTx(txOpts, function(err, tx) {
+            logTime('4', 'b');
             server.rejectTx({
               txProposalId: tx.id,
               reason: 'some reason',
@@ -1799,17 +1805,24 @@ describe('Wallet service', function() {
         function(next) {
           // Do not allow before backoff time
           var txOpts = helpers.createProposalOpts('18PzpUFkFZE8zKWUPvfykkTxmB9oMR8qP7', 1, null, TestData.copayers[0].privKey_1H_0);
+          logTime('5a', 'b');
           server.createTx(txOpts, function(err, tx) {
+            logTime('5a', 'b');
             should.exist(err);
             err.code.should.equal('NOTALLOWEDTOCREATETX');
             next();
           });
         },
         function(next) {
+          logTime('5', 'a');
           var clock = sinon.useFakeTimers(Date.now() + (WalletService.backoffTimeMinutes + 2) * 60 * 1000);
+          logTime('5', 'b');
           var txOpts = helpers.createProposalOpts('18PzpUFkFZE8zKWUPvfykkTxmB9oMR8qP7', 1, null, TestData.copayers[0].privKey_1H_0);
+          logTime('5', 'c');
           server.createTx(txOpts, function(err, tx) {
+            logTime('5', 'd');
             clock.restore();
+            logTime('5', 'e');
             server.rejectTx({
               txProposalId: tx.id,
               reason: 'some reason',
@@ -1818,10 +1831,15 @@ describe('Wallet service', function() {
         },
         function(next) {
           // Do not allow a 5th tx before backoff time
+          logTime('6', 'a');
           var clock = sinon.useFakeTimers(Date.now() + (WalletService.backoffTimeMinutes + 2) * 60 * 1000 + 1);
+          logTime('6', 'b');
           var txOpts = helpers.createProposalOpts('18PzpUFkFZE8zKWUPvfykkTxmB9oMR8qP7', 1, null, TestData.copayers[0].privKey_1H_0);
+          logTime('6', 'c');
           server.createTx(txOpts, function(err, tx) {
+            logTime('6', 'd');
             clock.restore();
+            logTime('6', 'e');
             should.exist(err);
             err.code.should.equal('NOTALLOWEDTOCREATETX');
             next();