xolvio / chimp

Tooling that helps you do quality, faster.
MIT License
798 stars 139 forks source link

Selenium-server on OSX El Capitan #89

Closed samhatoum closed 8 years ago

samhatoum commented 9 years ago

From @dylanmcgowan on October 4, 2015 21:18

Hey, I created a new meteor project, installed the cucumber package, then added the sample tests to the project. I also tried running tests in an existing project with no luck. Here's what the logs say. Do you guys know what's wrong here?

[velocity] Established connection with Velocity.
[xolvio:cucumber] Cucumber is running
debugger listening on port 5858
[chimp][hooks] BeforeFeatures hook had error
{ [Error: The process has not exited yet therefore no result is available ...]
  message: 'The process has not exited yet therefore no result is available ...',
  type: 'RuntimeError' }
Error: The process has not exited yet therefore no result is available ...
  at Object.Future.wait (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/fibers/future.js:420:15)
  at Object.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/xolvio-fiber-utils/index.js:48:19)
  at Object.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/session-manager.js:136:21)
  at initBrowser (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumberjs/hooks.js:83:15)
  at /Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumberjs/hooks.js:125:7
  at /Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumber-wrapper.js:116:43

    - - - - -
  at new ErrorHandler.RuntimeError (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/ErrorHandler.js:92:12)
  at RequestHandler.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/RequestHandler.js:138:25)
  at Request.self.callback (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:373:22)
  at Request.emit (events.js:98:17)
  at Request.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1318:14)
  at Request.emit (events.js:117:20)
  at IncomingMessage.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1266:12)
  at IncomingMessage.emit (events.js:117:20)
  at _stream_readable.js:944:16
  at process._tickDomainCallback (node.js:492:13)

[chimp] Finished running async processes with errors
[chimp] run complete with errors Cucumber steps failed
[chimp] Could not get Cucumber Results from run result:
[ undefined, [ undefined, null ] ]
[xolvio:cucumber] Bad response from Chimp server.
{ statusCode: 200,
  content: '',
  headers:
   { 'content-type': 'application/json; charset=utf-8',
     'cache-control': 'no-cache',
     'content-length': '0',
     date: 'Sun, 04 Oct 2015 21:03:31 GMT',
     connection: 'keep-alive' },
  data: null }

Copied from original issue: xolvio/meteor-cucumber#220

samhatoum commented 9 years ago

looks like you've enabled the debugger somehow:

debugger listening on port 5858

Can you try without?

samhatoum commented 9 years ago

From @dylanmcgowan on October 4, 2015 21:37

Just disabled the debuggers. Heres the logs without.

=> App running at: http://localhost:58437/
[velocity] Established connection with Velocity.
[xolvio:cucumber] Cucumber is running
[chimp][hooks] BeforeFeatures hook had error
{ [Error: The process has not exited yet therefore no result is available ...]
  message: 'The process has not exited yet therefore no result is available ...',
  type: 'RuntimeError' }
Error: The process has not exited yet therefore no result is available ...
  at Object.Future.wait (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/fibers/future.js:420:15)
  at Object.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/xolvio-fiber-utils/index.js:48:19)
  at Object.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/session-manager.js:136:21)
  at initBrowser (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumberjs/hooks.js:83:15)
  at /Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumberjs/hooks.js:125:7
  at /Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/lib/cucumber-wrapper.js:116:43

    - - - - -
  at new ErrorHandler.RuntimeError (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/ErrorHandler.js:92:12)
  at RequestHandler.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/RequestHandler.js:138:25)
  at Request.self.callback (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:373:22)
  at Request.emit (events.js:98:17)
  at Request.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1318:14)
  at Request.emit (events.js:117:20)
  at IncomingMessage.<anonymous> (/Users/dylanmcgowan/.meteor/packages/xolvio_cucumber/.0.14.6.1q5v6ex++os.osx.x86_64+web.browser+web.cordova/npm/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1266:12)
  at IncomingMessage.emit (events.js:117:20)
  at _stream_readable.js:944:16
  at process._tickDomainCallback (node.js:492:13)

[chimp] Finished running async processes with errors
[chimp] run complete with errors Cucumber steps failed
[chimp] Could not get Cucumber Results from run result:
[ undefined, [ undefined, null ] ]
[xolvio:cucumber] Bad response from Chimp server.
{ statusCode: 200,
  content: '',
  headers:
   { 'content-type': 'application/json; charset=utf-8',
     'cache-control': 'no-cache',
     'content-length': '0',
     date: 'Sun, 04 Oct 2015 21:37:03 GMT',
     connection: 'keep-alive' },
  data: null }
samhatoum commented 9 years ago

From @jpmoyn on October 5, 2015 15:59

+1 I am getting the same exact error. This is on the sample meteor project with the sample cucumber tests, is this an error related to the new Meteor 1.2.0.2?

samhatoum commented 9 years ago

can you check which version of java you have installed?

try java -version from the terminal

samhatoum commented 9 years ago

From @jpmoyn on October 5, 2015 16:3

1.6.0_65

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 16:3

1.7.0_21 for me

samhatoum commented 9 years ago

@jpmoyn you need to be on 1.8, be sure to instal the OracleJDK and not the SDK.

@dylanmcgowan I'm not sure if 1.7 works, but I'd try the upgrade anyway, can't hurt :)

samhatoum commented 9 years ago

From @jpmoyn on October 5, 2015 16:17

That worked, thanks Sam.

samhatoum commented 9 years ago

great to hear, I'll see if I can do something about these cryptic errors

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 16:29

I'm still getting the same error. Updated java. My node is also up to date at 4.1.1. Could this have anything to do with updating osx to El Capitan?

samhatoum commented 9 years ago

Possibly. I'll do the update soon and will come back here. In the meantime, can you try java -version again after the update?

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 17:6

Sure, here's what I've got now.

java version "1.8.0_60" Java(TM) SE Runtime Environment (build 1.8.0_60-b27)

samhatoum commented 9 years ago

ok cool, some people update but the update doesn't actually work. Looks like it did for you.

Could you try chimp by itself?

Go to a new directory and type:

npm install chimp
cd node_modules/chimp
./bin/chimp --debug --log= verbose

This will run the default spec inside chimp without cucumber and should have a lot of info

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 17:20

Sure. Here are the heady logs

./bin/chimp --debug --log=verbose
[chimp] Running /Users/dylanmcgowan/.nvm/versions/node/v4.1.1/bin/npm install
[chimp] stdout: ddp@0.11.1 node_modules/ddp
├── ddp-underscore-patched@0.8.1-2
├── ddp-ejson@0.8.1-3
├── faye-websocket@0.9.4 (websocket-driver@0.6.2)
└── request@2.53.0 (aws-sign2@0.5.0, forever-agent@0.5.2, caseless@0.9.0, form-data@0.2.0, tunnel-agent@0.4.1, oauth-sign@0.6.0, stringstream@0.0.4, isstream@0.1.2, json-stringify-safe@5.0.1, tough-cookie@2.1.0, qs@2.3.3, node-uuid@1.4.3, mime-types@2.0.14, combined-stream@0.0.7, http-signature@0.10.1, bl@0.9.4, hawk@2.3.1)

[chimp] stderr:
[chimp] Running...
[chimp] interrupting
[chimp] no processes to interrupt
[chimp][selenium] Selenium object created
[chimp][selenium] Start
[chimp][selenium] Installing Selenium + drivers if needed

[chimp][selenium] hub can be seen at http://localhost:50982/wd/hub
[chimp][session-manager] options are { port: '50982', browser: 'chrome', deviceName: undefined }
[chimp][session-manager] created a new SessionManager { port: '50982', browser: 'chrome', deviceName: undefined }
[chimp][cucumber] Running with [ 'node',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/.bin/cucumber.js',
  '-r',
  'features',
  '-r',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/world.js',
  '-r',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/hooks.js',
  '--snippets',
  'true',
  '--format',
  'pretty',
  '--tags',
  '~@ignore' ]
[chimp][selenium.stderr] 13:16:22.306 INFO - Launching a standalone Selenium Server

[chimp][selenium.stderr] Setting system property webdriver.chrome.driver to /Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/selenium-standalone/.selenium/chromedriver/2.19-x64-chromedriver

[chimp][selenium.stderr] 13:16:22.351 INFO - Java: Oracle Corporation 25.60-b23

[chimp][selenium.stderr] 13:16:22.351 INFO - OS: Mac OS X 10.11 x86_64

[chimp][selenium.stderr] 13:16:22.363 INFO - v2.47.1, with Core v2.47.1. Built from revision 411b314

[chimp][selenium.stderr] 13:16:22.363 INFO - Selenium server running in debug mode.

[chimp][selenium.stderr] 13:16:22.444 INFO - Driver provider org.openqa.selenium.ie.InternetExplorerDriver registration is skipped:
registration capabilities Capabilities [{ensureCleanSession=true, browserName=internet explorer, version=, platform=WINDOWS}] does not match the current platform MAC

[chimp][selenium.stderr] 13:16:22.444 INFO - Driver provider org.openqa.selenium.edge.EdgeDriver registration is skipped:
registration capabilities Capabilities [{browserName=MicrosoftEdge, version=, platform=WINDOWS}] does not match the current platform MAC

[chimp][selenium.stderr] 13:16:22.444 INFO - Driver class not found: com.opera.core.systems.OperaDriver

[chimp][selenium.stderr] 13:16:22.445 INFO - Driver provider com.opera.core.systems.OperaDriver is not registered

[chimp][selenium.stderr] 13:16:22.532 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:50982/wd/hub

[chimp][selenium.stderr] 13:16:22.533 INFO - Selenium Server is up and running

[chimp][selenium.stderr] 13:16:22.789 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 13:16:22.795 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@5e3c18f0)

[chimp][selenium.stderr] 13:16:22.799 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@5e3c18f0

[chimp][selenium.stderr] 13:16:22.799 DEBUG - Finished: GET /status

[chimp][world] Using the jasmine-expect assertion library

[chimp][hooks] Starting BeforeFeatures

[chimp][hooks] getting browser

[chimp][session-manager] options are { port: '50982', browser: 'chrome', deviceName: undefined }

[chimp][session-manager] created a new SessionManager { port: '50982', browser: 'chrome', deviceName: undefined }

[chimp][hooks] custom chimp.js not found, loading defaults

[chimp][hooks] webdriverOptions are  {"waitforTimeout":10000,"desiredCapabilities":{"browserName":"chrome","platform":"ANY","name":"","chromeOptions":{}},"host":"localhost","port":"50982","logLevel":"verbose","sync":true}

[chimp][session-manager] creating webdriver remote

=======================================================================================

Selenium 2.0/webdriver protocol bindings implementation with helper commands in nodejs.
For a complete list of commands, visit http://webdriver.io/docs.html.
=======================================================================================

[chimp][session-manager] checking connection to selenium server

[13:16:24]:  COMMAND    GET      "/wd/hub/status"

[13:16:24]:  DATA        {}

[chimp][selenium.stderr] 13:16:24.218 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 13:16:24.219 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@1e6a2006)

[chimp][selenium.stderr] 13:16:24.219 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@1e6a2006

[chimp][selenium.stderr] 13:16:24.220 DEBUG - Finished: GET /status

[13:16:24]:  RESULT      {"build":{"version":"2.47.1","revision":"411b314","time":"2015-07-30 03:03:16"},"os":{"name":"Mac OS X","arch":"x86_64","version":"10.11"},"java":{"version":"1.8.0_60"}}

[chimp][session-manager] Connection to the to selenium server verified

[chimp][session-manager] requesting sessions from http://localhost:50982/wd/hub/sessions

[chimp][selenium.stderr] 13:16:24.247 DEBUG - Handling: GET /sessions

[chimp][selenium.stderr] 13:16:24.248 INFO - Executing: org.openqa.selenium.remote.server.handler.GetAllSessions@1efa5c4e)

[chimp][selenium.stderr] 13:16:24.249 INFO - Done: org.openqa.selenium.remote.server.handler.GetAllSessions@1efa5c4e

[chimp][selenium.stderr] 13:16:24.249 DEBUG - Finished: GET /sessions

[chimp][session-manager] received data {"state":"success","sessionId":null,"hCode":1149380436,"value":[],"class":"org.openqa.selenium.remote.Response","status":0}

[chimp][session-manager] Did not find any open selenium sessions, not reusing a session

[chimp][session-manager] monkey patching the browser object

[chimp][hooks] init browser

[chimp][session-manager] initializing browser

[13:16:24]:  COMMAND    POST     "/wd/hub/session"

[13:16:24]:  DATA        {"desiredCapabilities":{"browserName":"chrome","version":"","javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"platform":"ANY","name":"","chromeOptions":{},"loggingPrefs":{"browser":"ALL","driver":"ALL"},"requestOrigins":{"url":"http://webdriver.io","version":"3.2.4","name":"webdriverio"}}}

[chimp][selenium.stderr] 13:16:24.275 DEBUG - Handling: POST /session

[chimp][selenium.stderr] 13:16:24.290 INFO - Executing: [new session: Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=chrome, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]])

[chimp][selenium.stderr] 13:16:24.303 INFO - Creating a new session for Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=chrome, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]

[chimp][selenium.stderr] 13:16:24.705 DEBUG - Executing: newSession [null, newSession {desiredCapabilities=Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=chrome, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]}]

[chimp][selenium.stderr] 13:16:24.718 DEBUG - Waiting for [http://localhost:3132/status]

[chimp][selenium.stderr] 13:16:24.719 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] Starting ChromeDriver 2.19.346063 (38b35413bd4a486d436a9749e090454bc9ff6708) on port 3132

[chimp][selenium.stderr] Only local connections are allowed.

[chimp][selenium.stderr] 13:16:25.830 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:26.334 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:26.840 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:27.343 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:27.846 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:28.353 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:28.860 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:29.364 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:29.867 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:30.375 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:30.879 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:31.383 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:31.891 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:32.398 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:32.906 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:33.411 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:33.919 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:34.424 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:34.931 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:35.443 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:35.946 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:36.453 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:36.960 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:37.467 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:37.971 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:38.479 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:38.986 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:39.493 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:40.000 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:40.505 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:41.011 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:41.518 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:42.025 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:42.532 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:43.036 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:43.541 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:44.047 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:44.551 DEBUG - Polling http://localhost:3132/status

[chimp][selenium.stderr] 13:16:44.726 DEBUG - Exception: [null, newSession {desiredCapabilities=Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=chrome, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]}]

[chimp][selenium.stderr] 13:16:44.727 DEBUG - Executing: quit [null, quit {}]

[chimp][selenium.stderr] 13:16:44.727 DEBUG - Waiting for http://localhost:3132/shutdown

[chimp][selenium.stderr] 13:16:44.728 DEBUG - Polling http://localhost:3132/shutdown

[chimp][selenium.stderr] 13:16:44.785 DEBUG - Executed: [null, quit {}]

[chimp][selenium.stderr] 13:16:44.788 WARN - Exception thrown
java.util.concurrent.ExecutionException: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.47.1', revision: '411b314', time: '2015-07-30 03:03:16'
System info: host: 'dylan-mcgowans-macbook-pro.local', ip: '192.168.1.25', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11', java.version: '1.8.0_60'
Driver info: driver.version: unknown
    at java.util.concurrent.FutureTask.report(FutureTask.java:122)
    at java.util.concurrent.FutureTask.get(FutureTask.java:192)
    at org.openqa.selenium.remote.server.DefaultSession.execute(DefaultSession.java:183)
    at org.openqa.selenium.remote.server.DefaultSession.<init>(DefaultSession.java:119)
    at org.openqa.selenium.remote.server.DefaultSession.createSession(DefaultSession.java:95)
    at org.openqa.selenium.remote.server.DefaultDriverSessions.newSession(DefaultDriverSessions.java:125)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:58)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:1)
    at org.openqa.selenium.remote.server.rest.ResultConfig.handle(ResultConfig.java:111)
    at org.openqa.selenium.remote.server.JsonHttpCommandHandler.handleRequest(JsonHttpCommandHandler.java:175)
    at org.openqa.selenium.remote.server.DriverServlet.handleRequest(DriverServlet.java:202)
    at org.openqa.selenium.remote.server.DriverServlet.doPost(DriverServlet.java:164)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
    at org.openqa.selenium.remote.server.DriverServlet.service(DriverServlet.java:130)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
    at org.openqa.jetty.jetty.servlet.ServletHolder.handle(ServletHolder.java:428)
    at org.openqa.jetty.jetty.servlet.ServletHandler.dispatch(ServletHandler.java:680)
    at org.openqa.jetty.jetty.servlet.ServletHandler.handle(ServletHandler.java:571)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1526)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1479)
    at org.openqa.jetty.http.HttpServer.service(HttpServer.java:920)
    at org.openqa.jetty.http.HttpConnection.service(HttpConnection.java:820)
    at org.openqa.jetty.http.HttpConnection.handleNext(HttpConnection.java:986)
    at org.openqa.jetty.http.HttpConnection.handle(HttpConnection.java:837)
    at org.openqa.jetty.http.SocketListener.handleConnection(SocketListener.java:243)
    at org.openqa.jetty.util.ThreadedServer.handle(ThreadedServer.java:358)
    at org.openqa.jetty.util.ThreadPool$PoolThread.run(ThreadPool.java:537)
Caused by: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.47.1', revision: '411b314', time: '2015-07-30 03:03:16'
System info: host: 'dylan-mcgowans-macbook-pro.local', ip: '192.168.1.25', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11', java.version: '1.8.0_60'
Driver info: driver.version: unknown
    at org.openqa.selenium.remote.server.DefaultDriverProvider.callConstructor(DefaultDriverProvider.java:113)
    at org.openqa.selenium.remote.server.DefaultDriverProvider.newInstance(DefaultDriverProvider.java:97)
    at org.openqa.selenium.remote.server.DefaultDriverFactory.newInstance(DefaultDriverFactory.java:60)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:222)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:1)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at org.openqa.selenium.remote.server.DefaultSession$1.run(DefaultSession.java:176)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.reflect.InvocationTargetException
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
    at org.openqa.selenium.remote.server.DefaultDriverProvider.callConstructor(DefaultDriverProvider.java:103)
    ... 9 more
Caused by: org.openqa.selenium.remote.UnreachableBrowserException: Could not start a new session. Possible causes are invalid address of the remote server or browser start-up failure.
Build info: version: '2.47.1', revision: '411b314', time: '2015-07-30 03:03:16'
System info: host: 'dylan-mcgowans-macbook-pro.local', ip: '192.168.1.25', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11', java.version: '1.8.0_60'
Driver info: driver.version: ChromeDriver
    at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:589)
    at org.openqa.selenium.remote.RemoteWebDriver.startSession(RemoteWebDriver.java:242)
    at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:128)
    at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:141)
    at org.openqa.selenium.chrome.ChromeDriver.<init>(ChromeDriver.java:170)
    at org.openqa.selenium.chrome.ChromeDriver.<init>(ChromeDriver.java:138)
    ... 14 more
Caused by: java.lang.IllegalStateException: The process has not exited yet therefore no result is available ...
    at org.apache.commons.exec.DefaultExecuteResultHandler.getException(DefaultExecuteResultHandler.java:76)
    at org.openqa.selenium.os.UnixProcess.checkForError(UnixProcess.java:171)
    at org.openqa.selenium.os.CommandLine.checkForError(CommandLine.java:183)
    at org.openqa.selenium.remote.service.DriverService.start(DriverService.java:169)
    at org.openqa.selenium.remote.service.DriverCommandExecutor.execute(DriverCommandExecutor.java:63)
    at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:568)
    ... 19 more

[chimp][selenium.stderr] 13:16:44.797 WARN - Exception: The process has not exited yet therefore no result is available ...

[chimp][selenium.stderr] 13:16:44.806 DEBUG - Finished: POST /session

[chimp][hooks] BeforeFeatures hook had error
{ [Error: The process has not exited yet therefore no result is available ...]
  message: 'The process has not exited yet therefore no result is available ...',
  type: 'RuntimeError' }
Error: The process has not exited yet therefore no result is available ...
  at Object.Future.wait (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/fibers/future.js:420:15)
  at Object.<anonymous> (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/xolvio-fiber-utils/index.js:48:19)
  at Object.<anonymous> (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/session-manager.js:136:21)
  at initBrowser (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/hooks.js:88:15)
  at /Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/hooks.js:130:7
  at /Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumber-wrapper.js:116:43

    - - - - -
  at new ErrorHandler.RuntimeError (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/ErrorHandler.js:92:12)
  at RequestHandler.<anonymous> (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/RequestHandler.js:138:25)
  at Request.self.callback (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:373:22)
  at emitTwo (events.js:87:13)
  at Request.emit (events.js:172:7)
  at Request.<anonymous> (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1318:14)
  at emitOne (events.js:82:20)
  at Request.emit (events.js:169:7)
  at IncomingMessage.<anonymous> (/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1266:12)
  at emitNone (events.js:72:20)
  at IncomingMessage.emit (events.js:166:7)
  at endReadableNT (_stream_readable.js:893:12)
  at doNTCallback2 (node.js:429:9)
  at process._tickDomainCallback (node.js:384:17)

[chimp][cucumber] Closed with code 2
[chimp][cucumber] Cucumber not in a stopping state
[chimp] Finished running async processes with errors
[chimp] run complete with errors Cucumber steps failed
Error in chimp init Cucumber steps failed
samhatoum commented 9 years ago

look like it could be chromedriver. can you try with --browser=firefox please? Could be related to this: https://github.com/vvo/selenium-standalone/issues/130

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 17:30

Hmm that seemed to be it. Heres the logs just to double check. They're huge haha. What can i do to use firefox for the time being with meteor?

./bin/chimp --debug --log=verbose --browser=firefox
[chimp] Running /Users/dylanmcgowan/.nvm/versions/node/v0.12.4/bin/npm install
[chimp] stdout: ddp@0.11.1 node_modules/ddp
├── ddp-ejson@0.8.1-3
├── ddp-underscore-patched@0.8.1-2
├── faye-websocket@0.9.4 (websocket-driver@0.6.2)
└── request@2.53.0 (caseless@0.9.0, forever-agent@0.5.2, aws-sign2@0.5.0, form-data@0.2.0, stringstream@0.0.4, oauth-sign@0.6.0, tunnel-agent@0.4.1, isstream@0.1.2, json-stringify-safe@5.0.1, qs@2.3.3, node-uuid@1.4.3, combined-stream@0.0.7, tough-cookie@2.1.0, mime-types@2.0.14, http-signature@0.10.1, bl@0.9.4, hawk@2.3.1)

[chimp] stderr:
[chimp] Running...
[chimp] interrupting
[chimp] no processes to interrupt
[chimp][selenium] Selenium object created
[chimp][selenium] Start
[chimp][selenium] Installing Selenium + drivers if needed

[chimp][selenium] hub can be seen at http://localhost:51287/wd/hub
[chimp][session-manager] options are { port: '51287', browser: 'firefox', deviceName: undefined }
[chimp][session-manager] created a new SessionManager { port: '51287', browser: 'firefox', deviceName: undefined }
[chimp][cucumber] Running with [ 'node',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/.bin/cucumber.js',
  '-r',
  'features',
  '-r',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/world.js',
  '-r',
  '/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/lib/cucumberjs/hooks.js',
  '--snippets',
  'true',
  '--format',
  'pretty',
  '--tags',
  '~@ignore' ]
[chimp][selenium.stderr] 13:29:42.805 INFO - Launching a standalone Selenium Server

[chimp][selenium.stderr] Setting system property webdriver.chrome.driver to /Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/node_modules/selenium-standalone/.selenium/chromedriver/2.19-x64-chromedriver

[chimp][selenium.stderr] 13:29:42.850 INFO - Java: Oracle Corporation 25.60-b23

[chimp][selenium.stderr] 13:29:42.850 INFO - OS: Mac OS X 10.11 x86_64

[chimp][selenium.stderr] 13:29:42.863 INFO - v2.47.1, with Core v2.47.1. Built from revision 411b314

[chimp][selenium.stderr] 13:29:42.863 INFO - Selenium server running in debug mode.

[chimp][selenium.stderr] 13:29:42.943 INFO - Driver provider org.openqa.selenium.ie.InternetExplorerDriver registration is skipped:
registration capabilities Capabilities [{ensureCleanSession=true, browserName=internet explorer, version=, platform=WINDOWS}] does not match the current platform MAC
13:29:42.944 INFO - Driver provider org.openqa.selenium.edge.EdgeDriver registration is skipped:
registration capabilities Capabilities [{browserName=MicrosoftEdge, version=, platform=WINDOWS}] does not match the current platform MAC

[chimp][selenium.stderr] 13:29:42.944 INFO - Driver class not found: com.opera.core.systems.OperaDriver
13:29:42.944 INFO - Driver provider com.opera.core.systems.OperaDriver is not registered

[chimp][selenium.stderr] 13:29:43.042 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:51287/wd/hub

[chimp][selenium.stderr] 13:29:43.042 INFO - Selenium Server is up and running

[chimp][selenium.stderr] 13:29:43.305 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 13:29:43.312 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@5e3c18f0)

[chimp][selenium.stderr] 13:29:43.315 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@5e3c18f0

[chimp][selenium.stderr] 13:29:43.315 DEBUG - Finished: GET /status

[chimp][world] Using the jasmine-expect assertion library

[chimp][hooks] Starting BeforeFeatures

[chimp][hooks] getting browser

[chimp][session-manager] options are { port: '51287', browser: 'firefox', deviceName: undefined }

[chimp][session-manager] created a new SessionManager { port: '51287', browser: 'firefox', deviceName: undefined }

[chimp][hooks] custom chimp.js not found, loading defaults

[chimp][hooks] webdriverOptions are  {"waitforTimeout":10000,"desiredCapabilities":{"browserName":"firefox","platform":"ANY","name":"","chromeOptions":{}},"host":"localhost","port":"51287","logLevel":"verbose","sync":true}

[chimp][session-manager] creating webdriver remote

=======================================================================================

Selenium 2.0/webdriver protocol bindings implementation with helper commands in nodejs.
For a complete list of commands, visit http://webdriver.io/docs.html.

=======================================================================================

[chimp][session-manager] checking connection to selenium server

[13:29:45]:  COMMAND    GET      "/wd/hub/status"

[13:29:45]:  DATA        {}

[chimp][selenium.stderr] 13:29:45.120 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 13:29:45.121 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@1e6a2006)

[chimp][selenium.stderr] 13:29:45.121 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@1e6a2006

[chimp][selenium.stderr] 13:29:45.121 DEBUG - Finished: GET /status

[13:29:45]:  RESULT      {"build":{"version":"2.47.1","revision":"411b314","time":"2015-07-30 03:03:16"},"os":{"name":"Mac OS X","arch":"x86_64","version":"10.11"},"java":{"version":"1.8.0_60"}}

[chimp][session-manager] Connection to the to selenium server verified

[chimp][session-manager] requesting sessions from http://localhost:51287/wd/hub/sessions

[chimp][selenium.stderr] 13:29:45.145 DEBUG - Handling: GET /sessions

[chimp][selenium.stderr] 13:29:45.145 INFO - Executing: org.openqa.selenium.remote.server.handler.GetAllSessions@1efa5c4e)

[chimp][selenium.stderr] 13:29:45.147 INFO - Done: org.openqa.selenium.remote.server.handler.GetAllSessions@1efa5c4e

[chimp][selenium.stderr] 13:29:45.147 DEBUG - Finished: GET /sessions

[chimp][session-manager] received data {"state":"success","sessionId":null,"hCode":1149380436,"value":[],"class":"org.openqa.selenium.remote.Response","status":0}

[chimp][session-manager] Did not find any open selenium sessions, not reusing a session

[chimp][session-manager] monkey patching the browser object

[chimp][hooks] init browser

[chimp][session-manager] initializing browser

[13:29:45]:  COMMAND    POST     "/wd/hub/session"

[13:29:45]:  DATA        {"desiredCapabilities":{"browserName":"firefox","version":"","javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"platform":"ANY","name":"","chromeOptions":{},"loggingPrefs":{"browser":"ALL","driver":"ALL"},"requestOrigins":{"url":"http://webdriver.io","version":"3.2.4","name":"webdriverio"}}}

[chimp][selenium.stderr] 13:29:45.172 DEBUG - Handling: POST /session

[chimp][selenium.stderr] 13:29:45.183 INFO - Executing: [new session: Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=firefox, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]])

[chimp][selenium.stderr] 13:29:45.196 INFO - Creating a new session for Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=firefox, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]

[chimp][selenium.stderr] 13:29:48.033 DEBUG - Executing: newSession [null, newSession {desiredCapabilities=Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=firefox, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}], requiredCapabilities=Capabilities [{}]}]

[chimp][selenium.stderr] 13:29:48.060 DEBUG - CookieSpec selected: default

[chimp][selenium.stderr] 13:29:48.075 DEBUG - Auth cache not set in the context

[chimp][selenium.stderr] 13:29:48.078 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:48.101 DEBUG - Connection leased: [id: 0][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]

[chimp][selenium.stderr] 13:29:48.104 DEBUG - Opening connection {}->http://127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.108 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.111 DEBUG - Connection established 127.0.0.1:51354<->127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.112 DEBUG - Executing request POST /hub/session HTTP/1.1

[chimp][selenium.stderr] 13:29:48.113 DEBUG - Target auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:48.113 DEBUG - Proxy auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:48.120 DEBUG - http-outgoing-0 >> POST /hub/session HTTP/1.1

[chimp][selenium.stderr] 13:29:48.120 DEBUG - http-outgoing-0 >> Content-Type: application/json; charset=utf-8

[chimp][selenium.stderr] 13:29:48.120 DEBUG - http-outgoing-0 >> Content-Length: 361

[chimp][selenium.stderr] 13:29:48.121 DEBUG - http-outgoing-0 >> Host: 127.0.0.1:7055
13:29:48.121 DEBUG - http-outgoing-0 >> Connection: Keep-Alive

[chimp][selenium.stderr] 13:29:48.121 DEBUG - http-outgoing-0 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)

[chimp][selenium.stderr] 13:29:48.122 DEBUG - http-outgoing-0 >> Accept-Encoding: gzip,deflate

[chimp][selenium.stderr] 13:29:48.122 DEBUG - http-outgoing-0 >> "POST /hub/session HTTP/1.1[\r][\n]"

[chimp][selenium.stderr] 13:29:48.123 DEBUG - http-outgoing-0 >> "Content-Type: application/json; charset=utf-8[\r][\n]"

[chimp][selenium.stderr] 13:29:48.123 DEBUG - http-outgoing-0 >> "Content-Length: 361[\r][\n]"

[chimp][selenium.stderr] 13:29:48.123 DEBUG - http-outgoing-0 >> "Host: 127.0.0.1:7055[\r][\n]"

[chimp][selenium.stderr] 13:29:48.123 DEBUG - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"

[chimp][selenium.stderr] 13:29:48.124 DEBUG - http-outgoing-0 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"

[chimp][selenium.stderr] 13:29:48.124 DEBUG - http-outgoing-0 >> "Accept-Encoding: gzip,deflate[\r][\n]"

[chimp][selenium.stderr] 13:29:48.124 DEBUG - http-outgoing-0 >> "[\r][\n]"

[chimp][selenium.stderr] 13:29:48.125 DEBUG - http-outgoing-0 >> "{"desiredCapabilities":{"rotatable":true,"locationContextEnabled":true,"name":"","loggingPrefs":{"driver":"ALL","browser":"ALL"},"browserName":"firefox","javascriptEnabled":true,"chromeOptions":{},"handlesAlerts":true,"version":"","platform":"ANY","requestOrigins":{"name":"webdriverio","version":"3.2.4","url":"http://webdriver.io"}},"requiredCapabilities":{}}"

[chimp][selenium.stderr] 13:29:48.312 DEBUG - http-outgoing-0 << "HTTP/1.1 200 OK[\r][\n]"

[chimp][selenium.stderr] 13:29:48.312 DEBUG - http-outgoing-0 << "content-type: application/json; charset=UTF-8[\r][\n]"

[chimp][selenium.stderr] 13:29:48.312 DEBUG - http-outgoing-0 << "connection: close[\r][\n]"

[chimp][selenium.stderr] 13:29:48.313 DEBUG - http-outgoing-0 << "content-length: 420[\r][\n]"

[chimp][selenium.stderr] 13:29:48.314 DEBUG - http-outgoing-0 << "server: httpd.js[\r][\n]"

[chimp][selenium.stderr] 13:29:48.315 DEBUG - http-outgoing-0 << "date: Mon, 05 Oct 2015 17:29:48 GMT[\r][\n]"

[chimp][selenium.stderr] 13:29:48.315 DEBUG - http-outgoing-0 << "[\r][\n]"

[chimp][selenium.stderr] 13:29:48.320 DEBUG - http-outgoing-0 << HTTP/1.1 200 OK

[chimp][selenium.stderr] 13:29:48.320 DEBUG - http-outgoing-0 << content-type: application/json; charset=UTF-8

[chimp][selenium.stderr] 13:29:48.321 DEBUG - http-outgoing-0 << connection: close
13:29:48.321 DEBUG - http-outgoing-0 << content-length: 420
13:29:48.321 DEBUG - http-outgoing-0 << server: httpd.js

[chimp][selenium.stderr] 13:29:48.321 DEBUG - http-outgoing-0 << date: Mon, 05 Oct 2015 17:29:48 GMT

[chimp][selenium.stderr] 13:29:48.335 DEBUG - http-outgoing-0 << "{"name":"newSession","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":{"cssSelectorsEnabled":true,"browserName":"firefox","handlesAlerts":true,"javascriptEnabled":true,"nativeEvents":false,"platform":"Darwin","rotatable":false,"takesScreenshot":true,"version":"31.0","webStorageEnabled":true,"applicationCacheEnabled":true,"databaseEnabled":true,"locationContextEnabled":true,"acceptSslCerts":true}}"

[chimp][selenium.stderr] 13:29:48.336 DEBUG - http-outgoing-0: Shutdown connection

[chimp][selenium.stderr] 13:29:48.336 DEBUG - Connection discarded

[chimp][selenium.stderr] 13:29:48.337 DEBUG - http-outgoing-0: Close connection

[chimp][selenium.stderr] 13:29:48.337 DEBUG - Connection released: [id: 0][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:48.339 DEBUG - Executed: [null, newSession {desiredCapabilities=Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=firefox, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}], requiredCapabilities=Capabilities [{}]}]

[chimp][selenium.stderr] 13:29:48.388 INFO - Done: [new session: Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@51d0aea4, browserName=firefox, javascriptEnabled=true, chromeOptions={}, handlesAlerts=true, version=, platform=ANY, requestOrigins={name=webdriverio, version=3.2.4, url=http://webdriver.io}}]]
13:29:48.389 DEBUG - Finished: POST /session

[13:29:48]:  SET SESSION ID 81874391-442c-4f93-b494-2e6299363ccb
[13:29:48]:  RESULT      {"applicationCacheEnabled":true,"rotatable":false,"handlesAlerts":true,"databaseEnabled":true,"version":"31.0","platform":"MAC","nativeEvents":false,"acceptSslCerts":true,"webdriver.remote.sessionid":"81874391-442c-4f93-b494-2e6299363ccb","webStorageEnabled":true,"locationContextEnabled":true,"browserName":"firefox","takesScreenshot":true,"javascriptEnabled":true,"cssSelectorsEnabled":true}
[chimp][hooks] init browser callback

[13:29:48]:  COMMAND    POST     "/wd/hub/session/81874391-442c-4f93-b494-2e6299363ccb/timeouts/async_script"

[13:29:48]:  DATA        {"ms":10000}

[chimp][selenium.stderr] 13:29:48.412 DEBUG - Handling: POST /session/81874391-442c-4f93-b494-2e6299363ccb/timeouts/async_script

[chimp][selenium.stderr] 13:29:48.416 INFO - Executing: [set script timeout: 10000])

[chimp][selenium.stderr] 13:29:48.420 DEBUG - Executing: setTimeout [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, setTimeout {type=script, ms=10000}]

[chimp][selenium.stderr] 13:29:48.422 DEBUG - CookieSpec selected: default

[chimp][selenium.stderr] 13:29:48.426 DEBUG - Auth cache not set in the context

[chimp][selenium.stderr] 13:29:48.427 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:48.427 DEBUG - Connection leased: [id: 1][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]

[chimp][selenium.stderr] 13:29:48.427 DEBUG - Opening connection {}->http://127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.428 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.429 DEBUG - Connection established 127.0.0.1:51356<->127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.430 DEBUG - Executing request POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/timeouts HTTP/1.1

[chimp][selenium.stderr] 13:29:48.430 DEBUG - Target auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:48.430 DEBUG - Proxy auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:48.431 DEBUG - http-outgoing-1 >> POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/timeouts HTTP/1.1

[chimp][selenium.stderr] 13:29:48.431 DEBUG - http-outgoing-1 >> Content-Type: application/json; charset=utf-8

[chimp][selenium.stderr] 13:29:48.431 DEBUG - http-outgoing-1 >> Content-Length: 28

[chimp][selenium.stderr] 13:29:48.431 DEBUG - http-outgoing-1 >> Host: 127.0.0.1:7055
13:29:48.432 DEBUG - http-outgoing-1 >> Connection: Keep-Alive
13:29:48.432 DEBUG - http-outgoing-1 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)
13:29:48.432 DEBUG - http-outgoing-1 >> Accept-Encoding: gzip,deflate
13:29:48.432 DEBUG - http-outgoing-1 >> "POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/timeouts HTTP/1.1[\r][\n]"
13:29:48.433 DEBUG - http-outgoing-1 >> "Content-Type: application/json; charset=utf-8[\r][\n]"

[chimp][selenium.stderr] 13:29:48.433 DEBUG - http-outgoing-1 >> "Content-Length: 28[\r][\n]"
13:29:48.433 DEBUG - http-outgoing-1 >> "Host: 127.0.0.1:7055[\r][\n]"

[chimp][selenium.stderr] 13:29:48.433 DEBUG - http-outgoing-1 >> "Connection: Keep-Alive[\r][\n]"
13:29:48.434 DEBUG - http-outgoing-1 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"
13:29:48.434 DEBUG - http-outgoing-1 >> "Accept-Encoding: gzip,deflate[\r][\n]"
13:29:48.434 DEBUG - http-outgoing-1 >> "[\r][\n]"
13:29:48.434 DEBUG - http-outgoing-1 >> "{"type":"script","ms":10000}"

[chimp][selenium.stderr] 13:29:48.450 DEBUG - http-outgoing-1 << "HTTP/1.1 200 OK[\r][\n]"
13:29:48.451 DEBUG - http-outgoing-1 << "content-type: application/json; charset=UTF-8[\r][\n]"
13:29:48.452 DEBUG - http-outgoing-1 << "connection: close[\r][\n]"

[chimp][selenium.stderr] 13:29:48.452 DEBUG - http-outgoing-1 << "content-length: 94[\r][\n]"
13:29:48.452 DEBUG - http-outgoing-1 << "server: httpd.js[\r][\n]"
13:29:48.453 DEBUG - http-outgoing-1 << "date: Mon, 05 Oct 2015 17:29:48 GMT[\r][\n]"
13:29:48.454 DEBUG - http-outgoing-1 << "[\r][\n]"
13:29:48.454 DEBUG - http-outgoing-1 << HTTP/1.1 200 OK
13:29:48.454 DEBUG - http-outgoing-1 << content-type: application/json; charset=UTF-8
13:29:48.454 DEBUG - http-outgoing-1 << connection: close
13:29:48.454 DEBUG - http-outgoing-1 << content-length: 94
13:29:48.455 DEBUG - http-outgoing-1 << server: httpd.js
13:29:48.455 DEBUG - http-outgoing-1 << date: Mon, 05 Oct 2015 17:29:48 GMT
13:29:48.456 DEBUG - http-outgoing-1 << "{"name":"setTimeout","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":""}"
13:29:48.456 DEBUG - http-outgoing-1: Shutdown connection
13:29:48.456 DEBUG - Connection discarded
13:29:48.456 DEBUG - http-outgoing-1: Close connection
13:29:48.457 DEBUG - Connection released: [id: 1][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
13:29:48.458 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, setTimeout {type=script, ms=10000}]

[chimp][selenium.stderr] 13:29:48.464 INFO - Done: [set script timeout: 10000]

[chimp][selenium.stderr] 13:29:48.464 DEBUG - Finished: POST /session/81874391-442c-4f93-b494-2e6299363ccb/timeouts/async_script

[13:29:48]:  RESULT      null
[chimp][hooks] set timeoutsAsyncScript
[chimp][hooks] setup DDP
[chimp][hooks] DDP not required
[chimp][hooks] Finished BeforeFeatures
[chimp][hooks] User-defined BeforeFeatures not found, finishing up

Feature: Use browser inside steps

  As a developer
  I want to have webdriver available to me in my steps
  So that I don't have to configure my world object and I focus on testing

[chimp][world] setting up world

  @watch
  Scenario: Visit Google                 # features/webdriver.feature:8
[13:29:48]:  COMMAND    POST     "/wd/hub/session/81874391-442c-4f93-b494-2e6299363ccb/url"
[13:29:48]:  DATA        {"url":"http://www.google.com"}

[chimp][selenium.stderr] 13:29:48.492 DEBUG - Handling: POST /session/81874391-442c-4f93-b494-2e6299363ccb/url

[chimp][selenium.stderr] 13:29:48.495 INFO - Executing: [get: http://www.google.com])
13:29:48.495 DEBUG - Executing: get [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, get {url=http://www.google.com}]

[chimp][selenium.stderr] 13:29:48.497 DEBUG - CookieSpec selected: default
13:29:48.498 DEBUG - Auth cache not set in the context
13:29:48.499 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
13:29:48.499 DEBUG - Connection leased: [id: 2][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
13:29:48.499 DEBUG - Opening connection {}->http://127.0.0.1:7055
13:29:48.500 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.502 DEBUG - Connection established 127.0.0.1:51358<->127.0.0.1:7055
13:29:48.502 DEBUG - Executing request POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1
13:29:48.503 DEBUG - Target auth state: UNCHALLENGED
13:29:48.503 DEBUG - Proxy auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:48.503 DEBUG - http-outgoing-2 >> POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1

[chimp][selenium.stderr] 13:29:48.504 DEBUG - http-outgoing-2 >> Content-Type: application/json; charset=utf-8

[chimp][selenium.stderr] 13:29:48.504 DEBUG - http-outgoing-2 >> Content-Length: 31

[chimp][selenium.stderr] 13:29:48.504 DEBUG - http-outgoing-2 >> Host: 127.0.0.1:7055

[chimp][selenium.stderr] 13:29:48.505 DEBUG - http-outgoing-2 >> Connection: Keep-Alive

[chimp][selenium.stderr] 13:29:48.505 DEBUG - http-outgoing-2 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)

[chimp][selenium.stderr] 13:29:48.505 DEBUG - http-outgoing-2 >> Accept-Encoding: gzip,deflate

[chimp][selenium.stderr] 13:29:48.505 DEBUG - http-outgoing-2 >> "POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1[\r][\n]"

[chimp][selenium.stderr] 13:29:48.505 DEBUG - http-outgoing-2 >> "Content-Type: application/json; charset=utf-8[\r][\n]"

[chimp][selenium.stderr] 13:29:48.506 DEBUG - http-outgoing-2 >> "Content-Length: 31[\r][\n]"

[chimp][selenium.stderr] 13:29:48.506 DEBUG - http-outgoing-2 >> "Host: 127.0.0.1:7055[\r][\n]"

[chimp][selenium.stderr] 13:29:48.506 DEBUG - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"

[chimp][selenium.stderr] 13:29:48.506 DEBUG - http-outgoing-2 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"

[chimp][selenium.stderr] 13:29:48.506 DEBUG - http-outgoing-2 >> "Accept-Encoding: gzip,deflate[\r][\n]"

[chimp][selenium.stderr] 13:29:48.507 DEBUG - http-outgoing-2 >> "[\r][\n]"

[chimp][selenium.stderr] 13:29:48.507 DEBUG - http-outgoing-2 >> "{"url":"http://www.google.com"}"

[chimp][selenium.stderr] 13:29:49.876 DEBUG - http-outgoing-2 << "HTTP/1.1 200 OK[\r][\n]"

[chimp][selenium.stderr] 13:29:49.876 DEBUG - http-outgoing-2 << "content-type: application/json; charset=UTF-8[\r][\n]"

[chimp][selenium.stderr] 13:29:49.877 DEBUG - http-outgoing-2 << "connection: close[\r][\n]"

[chimp][selenium.stderr] 13:29:49.877 DEBUG - http-outgoing-2 << "content-length: 87[\r][\n]"

[chimp][selenium.stderr] 13:29:49.877 DEBUG - http-outgoing-2 << "server: httpd.js[\r][\n]"

[chimp][selenium.stderr] 13:29:49.877 DEBUG - http-outgoing-2 << "date: Mon, 05 Oct 2015 17:29:49 GMT[\r][\n]"

[chimp][selenium.stderr] 13:29:49.878 DEBUG - http-outgoing-2 << "[\r][\n]"

[chimp][selenium.stderr] 13:29:49.881 DEBUG - http-outgoing-2 << HTTP/1.1 200 OK
13:29:49.881 DEBUG - http-outgoing-2 << content-type: application/json; charset=UTF-8
13:29:49.881 DEBUG - http-outgoing-2 << connection: close
13:29:49.881 DEBUG - http-outgoing-2 << content-length: 87
13:29:49.881 DEBUG - http-outgoing-2 << server: httpd.js
13:29:49.881 DEBUG - http-outgoing-2 << date: Mon, 05 Oct 2015 17:29:49 GMT

[chimp][selenium.stderr] 13:29:49.882 DEBUG - http-outgoing-2 << "{"name":"get","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":""}"

[chimp][selenium.stderr] 13:29:49.883 DEBUG - http-outgoing-2: Shutdown connection
13:29:49.883 DEBUG - Connection discarded
13:29:49.884 DEBUG - http-outgoing-2: Close connection
13:29:49.884 DEBUG - Connection released: [id: 2][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:49.885 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, get {url=http://www.google.com}]

[chimp][selenium.stderr] 13:29:49.886 INFO - Done: [get: http://www.google.com]
13:29:49.886 DEBUG - Finished: POST /session/81874391-442c-4f93-b494-2e6299363ccb/url

[13:29:49]:  RESULT      null

    When I visit "http://www.google.com" # features/webdriver.feature:9

[13:29:49]:  COMMAND    GET      "/wd/hub/session/81874391-442c-4f93-b494-2e6299363ccb/title"

[13:29:49]:  DATA        {}

[chimp][selenium.stderr] 13:29:49.909 DEBUG - Handling: GET /session/81874391-442c-4f93-b494-2e6299363ccb/title

[chimp][selenium.stderr] 13:29:49.910 INFO - Executing: [get title])

[chimp][selenium.stderr] 13:29:49.910 DEBUG - Executing: getTitle [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, getTitle {}]

[chimp][selenium.stderr] 13:29:49.912 DEBUG - CookieSpec selected: default

[chimp][selenium.stderr] 13:29:49.913 DEBUG - Auth cache not set in the context

[chimp][selenium.stderr] 13:29:49.913 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:49.913 DEBUG - Connection leased: [id: 3][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]

[chimp][selenium.stderr] 13:29:49.914 DEBUG - Opening connection {}->http://127.0.0.1:7055

[chimp][selenium.stderr] 13:29:49.914 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:49.916 DEBUG - Connection established 127.0.0.1:51367<->127.0.0.1:7055

[chimp][selenium.stderr] 13:29:49.916 DEBUG - Executing request GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1
13:29:49.916 DEBUG - Target auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:49.916 DEBUG - Proxy auth state: UNCHALLENGED
13:29:49.917 DEBUG - http-outgoing-3 >> GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1
13:29:49.917 DEBUG - http-outgoing-3 >> Cache-Control: no-cache
13:29:49.917 DEBUG - http-outgoing-3 >> Host: 127.0.0.1:7055
13:29:49.917 DEBUG - http-outgoing-3 >> Connection: Keep-Alive
13:29:49.917 DEBUG - http-outgoing-3 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)
13:29:49.917 DEBUG - http-outgoing-3 >> Accept-Encoding: gzip,deflate
13:29:49.918 DEBUG - http-outgoing-3 >> "GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "Cache-Control: no-cache[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "Host: 127.0.0.1:7055[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "Connection: Keep-Alive[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "Accept-Encoding: gzip,deflate[\r][\n]"
13:29:49.918 DEBUG - http-outgoing-3 >> "[\r][\n]"
13:29:49.925 DEBUG - http-outgoing-3 << "HTTP/1.1 200 OK[\r][\n]"
13:29:49.927 DEBUG - http-outgoing-3 << "content-type: application/json; charset=UTF-8[\r][\n]"
13:29:49.927 DEBUG - http-outgoing-3 << "connection: close[\r][\n]"
13:29:49.928 DEBUG - http-outgoing-3 << "content-length: 98[\r][\n]"
13:29:49.928 DEBUG - http-outgoing-3 << "server: httpd.js[\r][\n]"
13:29:49.928 DEBUG - http-outgoing-3 << "date: Mon, 05 Oct 2015 17:29:49 GMT[\r][\n]"

[chimp][selenium.stderr] 13:29:49.928 DEBUG - http-outgoing-3 << "[\r][\n]"
13:29:49.929 DEBUG - http-outgoing-3 << HTTP/1.1 200 OK
13:29:49.929 DEBUG - http-outgoing-3 << content-type: application/json; charset=UTF-8
13:29:49.929 DEBUG - http-outgoing-3 << connection: close
13:29:49.929 DEBUG - http-outgoing-3 << content-length: 98
13:29:49.929 DEBUG - http-outgoing-3 << server: httpd.js

[chimp][selenium.stderr] 13:29:49.929 DEBUG - http-outgoing-3 << date: Mon, 05 Oct 2015 17:29:49 GMT
13:29:49.930 DEBUG - http-outgoing-3 << "{"name":"getTitle","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":"Google"}"
13:29:49.930 DEBUG - http-outgoing-3: Shutdown connection
13:29:49.931 DEBUG - Connection discarded
13:29:49.931 DEBUG - http-outgoing-3: Close connection
13:29:49.931 DEBUG - Connection released: [id: 3][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
13:29:49.932 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, getTitle {}]
13:29:49.932 INFO - Done: [get title]
13:29:49.933 DEBUG - Finished: GET /session/81874391-442c-4f93-b494-2e6299363ccb/title

[13:29:49]:  RESULT      Google
    Then I see the title of "Google"     # features/webdriver.feature:10

[chimp][hooks] attaching failed step screenshot to report

[chimp][world] setting up world

  @not-watch
  Scenario: Visit Github                                       # features/webdriver.feature:13

[13:29:49]:  COMMAND    POST     "/wd/hub/session/81874391-442c-4f93-b494-2e6299363ccb/url"

[13:29:49]:  DATA        {"url":"http://www.github.com"}

[chimp][selenium.stderr] 13:29:49.961 DEBUG - Handling: POST /session/81874391-442c-4f93-b494-2e6299363ccb/url

[chimp][selenium.stderr] 13:29:49.963 INFO - Executing: [get: http://www.github.com])

[chimp][selenium.stderr] 13:29:49.964 DEBUG - Executing: get [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, get {url=http://www.github.com}]

[chimp][selenium.stderr] 13:29:49.965 DEBUG - CookieSpec selected: default

[chimp][selenium.stderr] 13:29:49.966 DEBUG - Auth cache not set in the context

[chimp][selenium.stderr] 13:29:49.966 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:49.966 DEBUG - Connection leased: [id: 4][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]

[chimp][selenium.stderr] 13:29:49.967 DEBUG - Opening connection {}->http://127.0.0.1:7055

[chimp][selenium.stderr] 13:29:49.968 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:49.969 DEBUG - Connection established 127.0.0.1:51369<->127.0.0.1:7055
13:29:49.969 DEBUG - Executing request POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1
13:29:49.969 DEBUG - Target auth state: UNCHALLENGED
13:29:49.969 DEBUG - Proxy auth state: UNCHALLENGED
13:29:49.970 DEBUG - http-outgoing-4 >> POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1
13:29:49.970 DEBUG - http-outgoing-4 >> Content-Type: application/json; charset=utf-8

[chimp][selenium.stderr] 13:29:49.970 DEBUG - http-outgoing-4 >> Content-Length: 31
13:29:49.970 DEBUG - http-outgoing-4 >> Host: 127.0.0.1:7055
13:29:49.970 DEBUG - http-outgoing-4 >> Connection: Keep-Alive
13:29:49.971 DEBUG - http-outgoing-4 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)
13:29:49.971 DEBUG - http-outgoing-4 >> Accept-Encoding: gzip,deflate
13:29:49.971 DEBUG - http-outgoing-4 >> "POST /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/url HTTP/1.1[\r][\n]"
13:29:49.971 DEBUG - http-outgoing-4 >> "Content-Type: application/json; charset=utf-8[\r][\n]"
13:29:49.972 DEBUG - http-outgoing-4 >> "Content-Length: 31[\r][\n]"
13:29:49.972 DEBUG - http-outgoing-4 >> "Host: 127.0.0.1:7055[\r][\n]"
13:29:49.972 DEBUG - http-outgoing-4 >> "Connection: Keep-Alive[\r][\n]"
13:29:49.972 DEBUG - http-outgoing-4 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"
13:29:49.973 DEBUG - http-outgoing-4 >> "Accept-Encoding: gzip,deflate[\r][\n]"
13:29:49.973 DEBUG - http-outgoing-4 >> "[\r][\n]"
13:29:49.973 DEBUG - http-outgoing-4 >> "{"url":"http://www.github.com"}"

[chimp][selenium.stderr] 13:29:52.015 DEBUG - http-outgoing-4 << "HTTP/1.1 200 OK[\r][\n]"
13:29:52.015 DEBUG - http-outgoing-4 << "content-type: application/json; charset=UTF-8[\r][\n]"

[chimp][selenium.stderr] 13:29:52.015 DEBUG - http-outgoing-4 << "connection: close[\r][\n]"
13:29:52.015 DEBUG - http-outgoing-4 << "content-length: 87[\r][\n]"
13:29:52.016 DEBUG - http-outgoing-4 << "server: httpd.js[\r][\n]"

[chimp][selenium.stderr] 13:29:52.016 DEBUG - http-outgoing-4 << "date: Mon, 05 Oct 2015 17:29:52 GMT[\r][\n]"
13:29:52.016 DEBUG - http-outgoing-4 << "[\r][\n]"
13:29:52.017 DEBUG - http-outgoing-4 << HTTP/1.1 200 OK

[chimp][selenium.stderr] 13:29:52.017 DEBUG - http-outgoing-4 << content-type: application/json; charset=UTF-8
13:29:52.017 DEBUG - http-outgoing-4 << connection: close

[chimp][selenium.stderr] 13:29:52.017 DEBUG - http-outgoing-4 << content-length: 87

[chimp][selenium.stderr] 13:29:52.017 DEBUG - http-outgoing-4 << server: httpd.js

[chimp][selenium.stderr] 13:29:52.017 DEBUG - http-outgoing-4 << date: Mon, 05 Oct 2015 17:29:52 GMT

[chimp][selenium.stderr] 13:29:52.018 DEBUG - http-outgoing-4 << "{"name":"get","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":""}"

[chimp][selenium.stderr] 13:29:52.018 DEBUG - http-outgoing-4: Shutdown connection

[chimp][selenium.stderr] 13:29:52.019 DEBUG - Connection discarded

[chimp][selenium.stderr] 13:29:52.020 DEBUG - http-outgoing-4: Close connection

[chimp][selenium.stderr] 13:29:52.020 DEBUG - Connection released: [id: 4][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:52.021 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, get {url=http://www.github.com}]

[chimp][selenium.stderr] 13:29:52.021 INFO - Done: [get: http://www.github.com]

[chimp][selenium.stderr] 13:29:52.022 DEBUG - Finished: POST /session/81874391-442c-4f93-b494-2e6299363ccb/url

[13:29:52]:  RESULT      null

    When I visit "http://www.github.com"                       # features/webdriver.feature:14

[13:29:52]:  COMMAND    GET      "/wd/hub/session/81874391-442c-4f93-b494-2e6299363ccb/title"

[13:29:52]:  DATA        {}

[chimp][selenium.stderr] 13:29:52.036 DEBUG - Handling: GET /session/81874391-442c-4f93-b494-2e6299363ccb/title

[chimp][selenium.stderr] 13:29:52.037 INFO - Executing: [get title])

[chimp][selenium.stderr] 13:29:52.037 DEBUG - Executing: getTitle [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, getTitle {}]

[chimp][selenium.stderr] 13:29:52.039 DEBUG - CookieSpec selected: default

[chimp][selenium.stderr] 13:29:52.039 DEBUG - Auth cache not set in the context

[chimp][selenium.stderr] 13:29:52.039 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:52.039 DEBUG - Connection leased: [id: 5][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]

[chimp][selenium.stderr] 13:29:52.040 DEBUG - Opening connection {}->http://127.0.0.1:7055

[chimp][selenium.stderr] 13:29:52.040 DEBUG - Connecting to /127.0.0.1:7055

[chimp][selenium.stderr] 13:29:52.041 DEBUG - Connection established 127.0.0.1:51390<->127.0.0.1:7055

[chimp][selenium.stderr] 13:29:52.041 DEBUG - Executing request GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1

[chimp][selenium.stderr] 13:29:52.041 DEBUG - Target auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:52.041 DEBUG - Proxy auth state: UNCHALLENGED

[chimp][selenium.stderr] 13:29:52.042 DEBUG - http-outgoing-5 >> GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1

[chimp][selenium.stderr] 13:29:52.042 DEBUG - http-outgoing-5 >> Cache-Control: no-cache

[chimp][selenium.stderr] 13:29:52.042 DEBUG - http-outgoing-5 >> Host: 127.0.0.1:7055

[chimp][selenium.stderr] 13:29:52.042 DEBUG - http-outgoing-5 >> Connection: Keep-Alive

[chimp][selenium.stderr] 13:29:52.042 DEBUG - http-outgoing-5 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)

[chimp][selenium.stderr] 13:29:52.043 DEBUG - http-outgoing-5 >> Accept-Encoding: gzip,deflate

[chimp][selenium.stderr] 13:29:52.043 DEBUG - http-outgoing-5 >> "GET /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905/title HTTP/1.1[\r][\n]"

[chimp][selenium.stderr] 13:29:52.043 DEBUG - http-outgoing-5 >> "Cache-Control: no-cache[\r][\n]"

[chimp][selenium.stderr] 13:29:52.043 DEBUG - http-outgoing-5 >> "Host: 127.0.0.1:7055[\r][\n]"

[chimp][selenium.stderr] 13:29:52.044 DEBUG - http-outgoing-5 >> "Connection: Keep-Alive[\r][\n]"

[chimp][selenium.stderr] 13:29:52.044 DEBUG - http-outgoing-5 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"

[chimp][selenium.stderr] 13:29:52.044 DEBUG - http-outgoing-5 >> "Accept-Encoding: gzip,deflate[\r][\n]"

[chimp][selenium.stderr] 13:29:52.044 DEBUG - http-outgoing-5 >> "[\r][\n]"

[chimp][selenium.stderr] 13:29:52.051 DEBUG - http-outgoing-5 << "HTTP/1.1 200 OK[\r][\n]"
13:29:52.052 DEBUG - http-outgoing-5 << "content-type: application/json; charset=UTF-8[\r][\n]"
13:29:52.052 DEBUG - http-outgoing-5 << "connection: close[\r][\n]"
13:29:52.052 DEBUG - http-outgoing-5 << "content-length: 125[\r][\n]"
13:29:52.053 DEBUG - http-outgoing-5 << "server: httpd.js[\r][\n]"
13:29:52.053 DEBUG - http-outgoing-5 << "date: Mon, 05 Oct 2015 17:29:52 GMT[\r][\n]"
13:29:52.053 DEBUG - http-outgoing-5 << "[\r][\n]"

[chimp][selenium.stderr] 13:29:52.056 DEBUG - http-outgoing-5 << HTTP/1.1 200 OK

[chimp][selenium.stderr] 13:29:52.056 DEBUG - http-outgoing-5 << content-type: application/json; charset=UTF-8

[chimp][selenium.stderr] 13:29:52.057 DEBUG - http-outgoing-5 << connection: close

[chimp][selenium.stderr] 13:29:52.058 DEBUG - http-outgoing-5 << content-length: 125

[chimp][selenium.stderr] 13:29:52.058 DEBUG - http-outgoing-5 << server: httpd.js

[chimp][selenium.stderr] 13:29:52.058 DEBUG - http-outgoing-5 << date: Mon, 05 Oct 2015 17:29:52 GMT

[chimp][selenium.stderr] 13:29:52.060 DEBUG - http-outgoing-5 << "{"name":"getTitle","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":"GitHub [0xc2][0xb7] Where software is built"}"

[chimp][selenium.stderr] 13:29:52.060 DEBUG - http-outgoing-5: Shutdown connection

[chimp][selenium.stderr] 13:29:52.061 DEBUG - Connection discarded

[chimp][selenium.stderr] 13:29:52.061 DEBUG - http-outgoing-5: Close connection

[chimp][selenium.stderr] 13:29:52.061 DEBUG - Connection released: [id: 5][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:52.062 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, getTitle {}]
13:29:52.063 INFO - Done: [get title]
13:29:52.063 DEBUG - Finished: GET /session/81874391-442c-4f93-b494-2e6299363ccb/title
13:29:52.078 DEBUG - Handling: GET /sessions
13:29:52.078 INFO - Executing: org.openqa.selenium.remote.server.handler.GetAllSessions@2ef5310c)
13:29:52.079 INFO - Done: org.openqa.selenium.remote.server.handler.GetAllSessions@2ef5310c
13:29:52.079 DEBUG - Finished: GET /sessions
13:29:52.089 DEBUG - Handling: DELETE /session/81874391-442c-4f93-b494-2e6299363ccb
13:29:52.090 INFO - Executing: [delete session: 81874391-442c-4f93-b494-2e6299363ccb])
13:29:52.090 DEBUG - Executing: quit [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, quit {}]
13:29:52.092 DEBUG - CookieSpec selected: default
13:29:52.092 DEBUG - Auth cache not set in the context
13:29:52.092 DEBUG - Connection request: [route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
13:29:52.095 DEBUG - Connection leased: [id: 6][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
13:29:52.095 DEBUG - Opening connection {}->http://127.0.0.1:7055
13:29:52.095 DEBUG - Connecting to /127.0.0.1:7055

[13:29:52]:  RESULT      GitHub · Where software is built
    Then I see the title of "GitHub · Where software is built" # features/webdriver.feature:15
[chimp][hooks] attaching failed step screenshot to report

2 scenarios (2 passed)
4 steps (4 passed)
[chimp][hooks] Starting AfterFeatures
[chimp][hooks] Ending browser session
[chimp][session-manager] requesting sessions from http://localhost:51287/wd/hub/sessions
[chimp][session-manager] received data {"state":"success","sessionId":null,"hCode":1720842587,"value":[{"capabilities":{"applicationCacheEnabled":true,"rotatable":false,"handlesAlerts":true,"databaseEnabled":true,"version":"31.0","platform":"MAC","nativeEvents":false,"acceptSslCerts":true,"webStorageEnabled":true,"locationContextEnabled":true,"browserName":"firefox","takesScreenshot":true,"javascriptEnabled":true,"cssSelectorsEnabled":true},"id":"81874391-442c-4f93-b494-2e6299363ccb","hCode":1624862368,"class":"org.openqa.selenium.remote.server.handler.GetAllSessions$SessionInfo"}],"class":"org.openqa.selenium.remote.Response","status":0}
[chimp][session-manager] deleting wd session 81874391-442c-4f93-b494-2e6299363ccb

[chimp][cucumber] Received message from cucumber child. Result: [
  {
    "id": "Use-browser-inside-steps",
    "name": "Use browser inside steps",
    "description": "\nAs a developer\nI want to have webdriver available to me in my steps\nSo that I don't have to configure my world object and I focus on testing",
    "line": 1,
    "keyword": "Feature",
    "uri": "/Users/dylanmcgowan/projects/chimpTest/node_modules/chimp/features/webdriver.feature",
    "elements": [
      {
        "name": "Visit Google",
        "id": "Use-browser-inside-steps;visit-google",
        "line": 8,
        "keyword": "Scenario",
        "description": "",
        "type": "scenario",
        "tags": [
          {
            "name": "@watch",
            "line": 7
          }
        ],
        "steps": [
          {
            "name": "I visit \"http://www.google.com\"",
            "line": 9,
            "keyword": "When ",
            "result": {
              "duration": 1409644217,
              "status": "passed"
            },
            "match": {}
          },
          {
            "name": "I see the title of \"Google\"",
            "line": 10,
            "keyword": "Then ",
            "result": {
              "duration": 45602799,
              "status": "passed"
            },
            "match": {}
          },
          {
            "keyword": "After ",
            "hidden": true,
            "result": {
              "duration": 429320,
              "status": "passed"
            },
            "match": {}
          }
        ]
      },
      {
        "name": "Visit Github",
        "id": "Use-browser-inside-steps;visit-github",
        "line": 13,
        "keyword": "Scenario",
        "description": "",
        "type": "scenario",
        "tags": [
          {
            "name": "@not-watch",
            "line": 12
          }
        ],
        "steps": [
          {
            "name": "I visit \"http://www.github.com\"",
            "line": 14,
            "keyword": "When ",
            "result": {
              "duration": 2076071537,
              "status": "passed"
            },
            "match": {}
          },
          {
            "name": "I see the title of \"GitHub · Where software is built\"",
            "line": 15,
            "keyword": "Then ",
            "result": {
              "duration": 40527634,
              "status": "passed"
            },
            "match": {}
          },
          {
            "keyword": "After ",
            "hidden": true,
            "result": {
              "duration": 303615,
              "status": "passed"
            },
            "match": {}
          }
        ]
      }
    ]
  }
]
[chimp][selenium.stderr] 13:29:52.096 DEBUG - Connection established 127.0.0.1:51393<->127.0.0.1:7055
13:29:52.097 DEBUG - Executing request DELETE /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905 HTTP/1.1
13:29:52.097 DEBUG - Target auth state: UNCHALLENGED
13:29:52.097 DEBUG - Proxy auth state: UNCHALLENGED
13:29:52.097 DEBUG - http-outgoing-6 >> DELETE /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905 HTTP/1.1
13:29:52.097 DEBUG - http-outgoing-6 >> Host: 127.0.0.1:7055
13:29:52.097 DEBUG - http-outgoing-6 >> Connection: Keep-Alive
13:29:52.098 DEBUG - http-outgoing-6 >> User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)
13:29:52.098 DEBUG - http-outgoing-6 >> Accept-Encoding: gzip,deflate
13:29:52.098 DEBUG - http-outgoing-6 >> "DELETE /hub/session/6308e4fc-e3cf-4a47-a0ac-b47c45ee6905 HTTP/1.1[\r][\n]"

[chimp][selenium.stderr] 13:29:52.098 DEBUG - http-outgoing-6 >> "Host: 127.0.0.1:7055[\r][\n]"

[chimp][selenium.stderr] 13:29:52.098 DEBUG - http-outgoing-6 >> "Connection: Keep-Alive[\r][\n]"

[chimp][selenium.stderr] 13:29:52.099 DEBUG - http-outgoing-6 >> "User-Agent: Apache-HttpClient/4.4.1 (Java/1.8.0_60)[\r][\n]"

[chimp][selenium.stderr] 13:29:52.099 DEBUG - http-outgoing-6 >> "Accept-Encoding: gzip,deflate[\r][\n]"

[chimp][selenium.stderr] 13:29:52.099 DEBUG - http-outgoing-6 >> "[\r][\n]"

[chimp][selenium.stderr] 13:29:52.105 DEBUG - http-outgoing-6 << "HTTP/1.1 200 OK[\r][\n]"

[chimp][selenium.stderr] 13:29:52.106 DEBUG - http-outgoing-6 << "content-type: application/json; charset=UTF-8[\r][\n]"

[chimp][selenium.stderr] 13:29:52.106 DEBUG - http-outgoing-6 << "connection: close[\r][\n]"

[chimp][selenium.stderr] 13:29:52.106 DEBUG - http-outgoing-6 << "content-length: 88[\r][\n]"

[chimp][selenium.stderr] 13:29:52.106 DEBUG - http-outgoing-6 << "server: httpd.js[\r][\n]"

[chimp][selenium.stderr] 13:29:52.106 DEBUG - http-outgoing-6 << "date: Mon, 05 Oct 2015 17:29:52 GMT[\r][\n]"

[chimp][selenium.stderr] 13:29:52.107 DEBUG - http-outgoing-6 << "[\r][\n]"

[chimp][selenium.stderr] 13:29:52.107 DEBUG - http-outgoing-6 << "{"name":"quit","sessionId":"6308e4fc-e3cf-4a47-a0ac-b47c45ee6905","status":0,"value":""}"

[chimp][selenium.stderr] 13:29:52.107 DEBUG - http-outgoing-6 << HTTP/1.1 200 OK

[chimp][selenium.stderr] 13:29:52.107 DEBUG - http-outgoing-6 << content-type: application/json; charset=UTF-8

[chimp][selenium.stderr] 13:29:52.108 DEBUG - http-outgoing-6 << connection: close

[chimp][selenium.stderr] 13:29:52.108 DEBUG - http-outgoing-6 << content-length: 88

[chimp][selenium.stderr] 13:29:52.108 DEBUG - http-outgoing-6 << server: httpd.js

[chimp][selenium.stderr] 13:29:52.108 DEBUG - http-outgoing-6 << date: Mon, 05 Oct 2015 17:29:52 GMT

[chimp][selenium.stderr] 13:29:52.109 DEBUG - http-outgoing-6: Shutdown connection

[chimp][selenium.stderr] 13:29:52.109 DEBUG - Connection discarded

[chimp][selenium.stderr] 13:29:52.109 DEBUG - http-outgoing-6: Close connection

[chimp][selenium.stderr] 13:29:52.110 DEBUG - Connection released: [id: 6][route: {}->http://127.0.0.1:7055][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]

[chimp][selenium.stderr] 13:29:52.111 DEBUG - Executed: [6308e4fc-e3cf-4a47-a0ac-b47c45ee6905, quit {}]

[chimp][selenium.stderr] 13:29:52.208 INFO - Done: [delete session: 81874391-442c-4f93-b494-2e6299363ccb]

[chimp][selenium.stderr] 13:29:52.209 DEBUG - Finished: DELETE /session/81874391-442c-4f93-b494-2e6299363ccb

[chimp][session-manager] received data {"state":"success","sessionId":"81874391-442c-4f93-b494-2e6299363ccb","hCode":1171401750,"value":null,"class":"org.openqa.selenium.remote.Response","status":0}

[chimp][hooks] Ended browser sessions
[chimp][hooks] Finished AfterFeatures

[chimp][cucumber] Closed with code 0
[chimp][cucumber] Cucumber not in a stopping state
[chimp] Finished running async processes
[chimp] interrupting
[chimp] 2 processes to interrupt
[chimp][cucumber] interrupting cucumber
[chimp][cucumber] kill called on cucumber process with pid 5181
[chimp][cucumber] checking if process exists
[chimp][cucumber] cucumber process does not exists, ignoring
[chimp][selenium] interrupt called
[chimp][selenium] interrupt is not killing selenium because clean-selenium-server not set
[chimp] Finished interrupting processes
[chimp] run complete
samhatoum commented 9 years ago

SELENIUM_BROWSER=firefox meteor, or you can export that env var too.

samhatoum commented 9 years ago

From @dylanmcgowan on October 5, 2015 18:3

Awesome thanks Sam, you the man.

samhatoum commented 9 years ago

welcome! I'll keep this open until I can figure out a workaround

shiftux commented 8 years ago

Hello, I'm having similar issues (error output below for readability). I tried the above

mkdir test && cd test
/home/tgdmosaa/.meteor/packages/meteor-tool/1.1.10/mt-os.linux.x86_64/dev_bundle/bin/npm install chimp
cd node_modules/chimp/
./bin/chimp --debug --log=verbose [--browser=firefox]

but get errors, no matter if I set the firefox option or not My java version is:

java version "1.8.0_65"
Java(TM) SE Runtime Environment (build 1.8.0_65-b17)
Java HotSpot(TM) 64-Bit Server VM (build 25.65-b01, mixed mode)

Chrome is at version 47.0.2526.111.

I can run a firefox session if I manually start selenium and use a browser to navigate to localhost:4444/wd/hub5, but it won't work with chrome.

any ideas? PS. I'm on CentOS 6.7, 64bit


Initial error output:

chimp --watch --ddp=http://localhost:3002 --path=./tests/cucumber --browser=firefox
[chimp] Watching features with tagged with @dev,@watch,@focus

[chimp] Running...
[chimp][helper] setupBrowserAndDDP had error
{ [Error: Bad request
Command duration or timeout: 527 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver]
  message: 'Bad request\nCommand duration or timeout: 527 milliseconds\nBuild info: version: \'2.48.2\', revision: \'41bccdd\', time: \'2015-10-09 19:59:12\'\nSystem info: host: \'localhost.localdomain\', ip: \'127.0.0.1\', os.name: \'Linux\', os.arch: \'amd64\', os.version: \'2.6.32-573.12.1.el6.x86_64\', java.version: \'1.8.0_65\'\nDriver info: org.openqa.selenium.firefox.FirefoxDriver',
  type: 'RuntimeError',
  seleniumStack: 
   { status: 13,
     type: 'UnknownError',
     message: 'An unknown server-side error occurred while processing the command.',
     orgStatusMessage: 'Bad request\nCommand duration or timeout: 527 milliseconds\nBuild info: version: \'2.48.2\', revision: \'41bccdd\', time: \'2015-10-09 19:59:12\'\nSystem info: host: \'localhost.localdomain\', ip: \'127.0.0.1\', os.name: \'Linux\', os.arch: \'amd64\', os.version: \'2.6.32-573.12.1.el6.x86_64\', java.version: \'1.8.0_65\'\nDriver info: org.openqa.selenium.firefox.FirefoxDriver' } }
Error: Bad request
  at Object.Future.wait (/usr/lib/node_modules/chimp/node_modules/fibers/future.js:420:15)
  at Object.<anonymous> (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/xolvio-fiber-utils/index.js:48:19)
  at Object.<anonymous> (/usr/lib/node_modules/chimp/lib/session-manager.js:137:21)
  at initBrowser (/usr/lib/node_modules/chimp/lib/chimp-helper.js:141:15)
  at Object.chimpHelper.setupBrowserAndDDP (/usr/lib/node_modules/chimp/lib/chimp-helper.js:217:7)
  at /usr/lib/node_modules/chimp/lib/cucumberjs/hooks.js:8:17
  at /usr/lib/node_modules/chimp/lib/cucumberjs/cucumber-wrapper.js:114:43

    - - - - -
Command duration or timeout: 527 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver
  at new ErrorHandler.RuntimeError (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/ErrorHandler.js:93:12)
  at RequestHandler.<anonymous> (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/RequestHandler.js:138:25)
  at Request.self.callback (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:373:22)
  at emitTwo (events.js:87:13)
  at Request.emit (events.js:172:7)
  at Request.<anonymous> (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1318:14)
  at emitOne (events.js:82:20)
  at Request.emit (events.js:169:7)
  at IncomingMessage.<anonymous> (/usr/lib/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1266:12)
  at emitNone (events.js:72:20)
  at IncomingMessage.emit (events.js:166:7)
  at endReadableNT (_stream_readable.js:905:12)
  at nextTickCallbackWith2Args (node.js:474:9)
  at process._tickDomainCallback (node.js:429:17)

(node) warning: possible EventEmitter memory leak detected. 11 connected listeners added. Use emitter.setMaxListeners() to increase limit.
Trace
    at addListener (events.js:239:17)
    at once (events.js:265:8)
    at /usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:342:10
    at tryCatcher (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/util.js:26:23)
    at Promise._resolveFromResolver (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/promise.js:480:31)
    at new Promise (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/promise.js:70:37)
    at DDPClient.connect (/usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:310:10)
    at null._onTimeout (/usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:114:58)
    at Timer.listOnTimeout (timers.js:92:15)
(node) warning: possible EventEmitter memory leak detected. 11 failed listeners added. Use emitter.setMaxListeners() to increase limit.
Trace
    at addListener (events.js:239:17)
    at once (events.js:265:8)
    at /usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:343:10
    at tryCatcher (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/util.js:26:23)
    at Promise._resolveFromResolver (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/promise.js:480:31)
    at new Promise (/usr/lib/node_modules/chimp/node_modules/bluebird/js/main/promise.js:70:37)
    at DDPClient.connect (/usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:310:10)
    at null._onTimeout (/usr/lib/node_modules/chimp/node_modules/xolvio-ddp/lib/ddp-client.js:114:58)
    at Timer.listOnTimeout (timers.js:92:15)

Error output of chimp in the test folder (no firefox option):

[chimp][selenium.stderr] 15:55:46.345 WARN - Exception thrown
java.util.concurrent.ExecutionException: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: driver.version: unknown
    at java.util.concurrent.FutureTask.report(FutureTask.java:122)
    at java.util.concurrent.FutureTask.get(FutureTask.java:192)
    at org.openqa.selenium.remote.server.DefaultSession.execute(DefaultSession.java:183)
    at org.openqa.selenium.remote.server.DefaultSession.<init>(DefaultSession.java:119)
    at org.openqa.selenium.remote.server.DefaultSession.createSession(DefaultSession.java:95)
    at org.openqa.selenium.remote.server.DefaultDriverSessions.newSession(DefaultDriverSessions.java:124)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:58)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:1)
    at org.openqa.selenium.remote.server.rest.ResultConfig.handle(ResultConfig.java:111)
    at org.openqa.selenium.remote.server.JsonHttpCommandHandler.handleRequest(JsonHttpCommandHandler.java:175)
    at org.openqa.selenium.remote.server.DriverServlet.handleRequest(DriverServlet.java:202)
    at org.openqa.selenium.remote.server.DriverServlet.doPost(DriverServlet.java:164)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at org.openqa.selenium.remote.server.DriverServlet.service(DriverServlet.java:130)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.openqa.jetty.jetty.servlet.ServletHolder.handle(ServletHolder.java:428)
    at org.openqa.jetty.jetty.servlet.ServletHandler.dispatch(ServletHandler.java:680)
    at org.openqa.jetty.jetty.servlet.ServletHandler.handle(ServletHandler.java:571)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1526)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1479)
    at org.openqa.jetty.http.HttpServer.service(HttpServer.java:920)
    at org.openqa.jetty.http.HttpConnection.service(HttpConnection.java:820)
    at org.openqa.jetty.http.HttpConnection.handleNext(HttpConnection.java:986)
    at org.openqa.jetty.http.HttpConnection.handle(HttpConnection.java:837)
    at org.openqa.jetty.http.SocketListener.handleConnection(SocketListener.java:243)
    at org.openqa.jetty.util.ThreadedServer.handle(ThreadedServer.java:358)
    at org.openqa.jetty.util.ThreadPool$PoolThread.run(ThreadPool.java:537)
Caused by: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: driver.version: unknown
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.callConstructor(FirefoxDriverProvider.java:101)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.newInstance(FirefoxDriverProvider.java:68)
    at org.openqa.selenium.remote.server.DefaultDriverFactory.newInstance(DefaultDriverFactory.java:60)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:222)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:1)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at org.openqa.selenium.remote.server.DefaultSession$1.run(DefaultSession.java:176)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.reflect.InvocationTargetException
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.callConstructor(FirefoxDriverProvider.java:91)
    ... 9 more
Caused by: org.openqa.selenium.UnsupportedCommandException: Bad request
Command duration or timeout: 419 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
    at org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:206)
    at org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:158)
    at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:647)
    at org.openqa.selenium.remote.RemoteWebDriver.startSession(RemoteWebDriver.java:247)
    at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:129)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:218)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:211)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:129)
    ... 14 more

[chimp][selenium.stderr] 15:55:46.378 WARN - Exception: Bad request
Command duration or timeout: 419 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver

[chimp][selenium.stderr] 15:55:46.426 DEBUG - Finished: POST /session

[chimp][helper] setupBrowserAndDDP had error
{ [Error: Bad request
Command duration or timeout: 419 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver]
  message: 'Bad request\nCommand duration or timeout: 419 milliseconds\nBuild info: version: \'2.48.2\', revision: \'41bccdd\', time: \'2015-10-09 19:59:12\'\nSystem info: host: \'localhost.localdomain\', ip: \'127.0.0.1\', os.name: \'Linux\', os.arch: \'amd64\', os.version: \'2.6.32-573.12.1.el6.x86_64\', java.version: \'1.8.0_65\'\nDriver info: org.openqa.selenium.firefox.FirefoxDriver',
  type: 'RuntimeError',
  seleniumStack: 
   { status: 13,
     type: 'UnknownError',
     message: 'An unknown server-side error occurred while processing the command.',
     orgStatusMessage: 'Bad request\nCommand duration or timeout: 419 milliseconds\nBuild info: version: \'2.48.2\', revision: \'41bccdd\', time: \'2015-10-09 19:59:12\'\nSystem info: host: \'localhost.localdomain\', ip: \'127.0.0.1\', os.name: \'Linux\', os.arch: \'amd64\', os.version: \'2.6.32-573.12.1.el6.x86_64\', java.version: \'1.8.0_65\'\nDriver info: org.openqa.selenium.firefox.FirefoxDriver' } }
Error: Bad request
  at Object.Future.wait (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/fibers/future.js:420:15)
  at Object.<anonymous> (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/xolvio-fiber-utils/index.js:48:19)
  at Object.<anonymous> (/home/tgdmosaa/development/workspace/test/node_modules/chimp/lib/session-manager.js:137:21)
  at initBrowser (/home/tgdmosaa/development/workspace/test/node_modules/chimp/lib/chimp-helper.js:145:15)
  at Object.chimpHelper.setupBrowserAndDDP (/home/tgdmosaa/development/workspace/test/node_modules/chimp/lib/chimp-helper.js:225:7)
  at /home/tgdmosaa/development/workspace/test/node_modules/chimp/lib/cucumberjs/hooks.js:8:17
  at /home/tgdmosaa/development/workspace/test/node_modules/chimp/lib/cucumberjs/cucumber-wrapper.js:114:43

    - - - - -
Command duration or timeout: 419 milliseconds
Build info: version: '2.48.2', revision: '41bccdd', time: '2015-10-09 19:59:12'
System info: host: 'localhost.localdomain', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '2.6.32-573.12.1.el6.x86_64', java.version: '1.8.0_65'
Driver info: org.openqa.selenium.firefox.FirefoxDriver
  at new ErrorHandler.RuntimeError (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/ErrorHandler.js:93:12)
  at RequestHandler.<anonymous> (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/lib/utils/RequestHandler.js:138:25)
  at Request.self.callback (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:373:22)
  at emitTwo (events.js:87:13)
  at Request.emit (events.js:172:7)
  at Request.<anonymous> (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1318:14)
  at emitOne (events.js:82:20)
  at Request.emit (events.js:169:7)
  at IncomingMessage.<anonymous> (/home/tgdmosaa/development/workspace/test/node_modules/chimp/node_modules/xolvio-sync-webdriverio/node_modules/webdriverio/node_modules/request/request.js:1266:12)
  at emitNone (events.js:72:20)
  at IncomingMessage.emit (events.js:166:7)
  at endReadableNT (_stream_readable.js:905:12)
  at nextTickCallbackWith2Args (node.js:474:9)
  at process._tickDomainCallback (node.js:429:17)

[chimp][cucumber] Closed with code 2
[chimp][cucumber] Cucumber not in a stopping state
[chimp] Finished running async processes with errors
[chimp] run complete with errors Cucumber steps failed
Cucumber steps failed
Error in chimp init Cucumber steps failed
bmanturner commented 8 years ago

Possibly related. I can't run chimp and when I debug the output stops at

[chimp][session-manager] checking connection to selenium server

[13:38:05]  COMMAND GET      "/wd/hub/status"

[13:38:05]  DATA        {}

edit: I was using the wrong version of node. Ran fine on 4.4.3

samhatoum commented 8 years ago

which version of Java are you running?

bmanturner commented 8 years ago

1.8. I just solved it though. I was using the latest version of node. Installed NVM and ran nvm use 4.4.3 before running the script and it worked fine. Thanks for your quick response.

aurelben commented 8 years ago

Sorry i got the same issue node version 4.4.3 java version = 1.8 chimp version = 0.41.2

OSX version = 10.11.4

lgandecki commented 8 years ago

@aurelben could you provide us with an error log? There might be some differences that would help us pinpoint the problem.

aurelben commented 8 years ago

This is when i run my test first time after reinstall chimp after the browser is opened but nothing append :/

[chimp][helper] setupBrowserAndDDP had error { [Error: session not created exception from unknown error: bad inspector message: {"method":"Page.loadEventFired","params":{"timestamp":11110,207324}}] message: 'session not created exception\nfrom unknown error: bad inspector message: {"method":"Page.loadEventFired","params":{"timestamp":11110,207324}}', type: 'RuntimeError', seleniumStack: { status: 33, type: 'SessionNotCreatedException', message: 'A new session could not be created.', orgStatusMessage: 'session not created exception\nfrom unknown error: bad inspector message: {"method":"Page.loadEventFired","params":{"timestamp":11110,207324}}\n (Session info: chrome=54.0.2840.71)\n (Driver info: chromedriver=2.24.417412 (ac882d3ce7c0d99292439bf3405780058fcca0a6),platform=Mac OS X 10.11.4 x86_64) (WARNING: The server did not provide any stacktrace information)\nCommand duration or timeout: 1.18 seconds\nBuild info: version: \'2.53.1\', revision: \'a36b8b1\', time: \'2016-06-30 17:37:03\'\nSystem info: host: \'aurel\', ip: \'192.168.0.125\', os.name: \'Mac OS X\', os.arch: \'x86_64\', os.version: \'10.11.4\', java.version: \'1.8.0_111\'\nDriver info: org.openqa.selenium.chrome.ChromeDriver' } } Error: session not created exception at Object.Future.wait (/usr/local/lib/node_modules/chimp/node_modules/fibers/future.js:449:15) at Object. (/usr/local/lib/node_modules/chimp/node_modules/wdio-sync/build/index.js:345:27) at initBrowser (/usr/local/lib/node_modules/chimp/dist/lib/chimp-helper.js:161:17) at Object.setupBrowserAndDDP (/usr/local/lib/node_modules/chimp/dist/lib/chimp-helper.js:215:7) at Context. (/usr/local/lib/node_modules/chimp/dist/lib/mocha/mocha-helper.js:11:15) at /usr/local/lib/node_modules/chimp/dist/lib/utils/fiberize.js:25:14


from unknown error: bad inspector message: {"method":"Page.loadEventFired","params":{"timestamp":11110,207324}} Mocha failed

lgandecki commented 8 years ago

try export LC_NUMERIC=en_US.UTF-8 and run again. It's a messed up chrome version. It might be fixed in the next incremental update, if not we will try to tweak chimp

aurelben commented 8 years ago

and ther is the verbose log with firefox

[chimp] Running...
[chimp] interrupting
[chimp] no processes to interrupt
[chimp][selenium] Selenium object created
[chimp][selenium] Start
[chimp][selenium] Installing Selenium + drivers if needed

[chimp][selenium] hub can be seen at http://localhost:55867/wd/hub
[chimp][session-manager] options are { host: 'localhost',
  port: '55867',
  browser: 'firefox',
  deviceName: undefined }
[chimp][session-manager] created a new SessionManager { host: 'localhost',
  port: '55867',
  browser: 'firefox',
  deviceName: undefined }
[chimp][mocha] Running...
[chimp][selenium.stderr] 14:17:14.254 INFO - Launching a standalone Selenium Server

[chimp][selenium.stderr] 14:17:14.296 INFO - Java: Oracle Corporation 25.111-b14

[chimp][selenium.stderr] 14:17:14.296 INFO - OS: Mac OS X 10.11.4 x86_64

[chimp][selenium.stderr] 14:17:14.305 INFO - v2.53.1, with Core v2.53.1. Built from revision a36b8b1

[chimp][selenium.stderr] 14:17:14.305 INFO - Selenium server running in debug mode.

[chimp][selenium.stderr] 14:17:14.383 INFO - Driver provider org.openqa.selenium.ie.InternetExplorerDriver registration is skipped:
registration capabilities Capabilities [{ensureCleanSession=true, browserName=internet explorer, version=, platform=WINDOWS}] does not match the current platform MAC

[chimp][selenium.stderr] 14:17:14.384 INFO - Driver provider org.openqa.selenium.edge.EdgeDriver registration is skipped:
registration capabilities Capabilities [{browserName=MicrosoftEdge, version=, platform=WINDOWS}] does not match the current platform MAC

[chimp][selenium.stderr] 14:17:14.384 INFO - Driver class not found: com.opera.core.systems.OperaDriver
14:17:14.384 INFO - Driver provider com.opera.core.systems.OperaDriver is not registered

[chimp][selenium.stderr] 14:17:14.387 INFO - Driver class not found: org.openqa.selenium.htmlunit.HtmlUnitDriver
14:17:14.387 INFO - Driver provider org.openqa.selenium.htmlunit.HtmlUnitDriver is not registered

[chimp][selenium.stderr] 14:17:14.468 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:55867/wd/hub

[chimp][selenium.stderr] 14:17:14.468 INFO - Selenium Server is up and running

[chimp][selenium.stderr] 14:17:14.741 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 14:17:14.749 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@3188d7ef)

[chimp][selenium.stderr] 14:17:14.753 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@3188d7ef

[chimp][selenium.stderr] 14:17:14.754 DEBUG - Finished: GET /status

[chimp][helper] Using the chai-expect assertion library
[chimp][helper] getting browser
[chimp][session-manager-factory] options are { host: 'localhost',
  port: 55867,
  user: undefined,
  key: undefined,
  browser: 'firefox',
  deviceName: undefined }
[chimp][session-manager] options are { host: 'localhost',
  port: 55867,
  user: undefined,
  key: undefined,
  browser: 'firefox',
  deviceName: undefined }
[chimp][session-manager] created a new SessionManager { host: 'localhost',
  port: 55867,
  user: undefined,
  key: undefined,
  browser: 'firefox',
  deviceName: undefined }
[chimp][helper] webdriverioOptions are  {"desiredCapabilities":{"browserName":"firefox","platform":"ANY","name":""},"logLevel":"verbose","host":"localhost","port":55867,"path":"/wd/hub","baseUrl":null,"coloredLogs":true,"screenshotPath":null,"waitforTimeout":500,"waitforInterval":250,"sync":true}
[chimp][session-manager] creating webdriver remote 

=======================================================================================
Selenium 2.0 / webdriver protocol bindings implementation with helper commands in nodejs.
For a complete list of commands, visit http://webdriver.io/api.html.
=======================================================================================

[chimp][session-manager] checking connection to selenium server
[14:17:16]  COMMAND GET      "/wd/hub/status"
[14:17:16]  DATA        {}
[chimp][selenium.stderr] 14:17:16.824 DEBUG - Handling: GET /status

[chimp][selenium.stderr] 14:17:16.825 DEBUG - Executing: org.openqa.selenium.remote.server.handler.Status@2ec4121e)

[chimp][selenium.stderr] 14:17:16.825 DEBUG - Done: org.openqa.selenium.remote.server.handler.Status@2ec4121e

[chimp][selenium.stderr] 14:17:16.825 DEBUG - Finished: GET /status

[14:17:16]  RESULT      {"build":{"version":"2.53.1","revision":"a36b8b1","time":"2016-06-30 17:37:03"},"os":{"name":"Mac OS X","arch":"x86_64","version":"10.11.4"},"java":{"version":"1.8.0_111"}}
[chimp][session-manager] Connection to the to selenium server verified
[chimp][session-manager] watch mode is false, not reusing a session
[chimp][hooks] init browser
[chimp][hooks] init browser callback
[14:17:16]  COMMAND POST     "/wd/hub/session"
[14:17:16]  DATA        {"desiredCapabilities":{"javascriptEnabled":true,"locationContextEnabled":true,"handlesAlerts":true,"rotatable":true,"browserName":"firefox","platform":"ANY","name":"","loggingPrefs":{"browser":"ALL","driver":"ALL"},"requestOrigins":{"url":"http://webdriver.io","version":"4.2.16","name":"webdriverio"}}}
[chimp][selenium.stderr] 14:17:16.861 DEBUG - Handling: POST /session

[chimp][selenium.stderr] 14:17:16.877 INFO - Executing: [new session: Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@2925dce1, browserName=firefox, javascriptEnabled=true, handlesAlerts=true, platform=ANY, requestOrigins={name=webdriverio, version=4.2.16, url=http://webdriver.io}}]])

[chimp][selenium.stderr] 14:17:16.891 INFO - Creating a new session for Capabilities [{rotatable=true, locationContextEnabled=true, name=, loggingPrefs=org.openqa.selenium.logging.LoggingPreferences@2925dce1, browserName=firefox, javascriptEnabled=true, handlesAlerts=true, platform=ANY, requestOrigins={name=webdriverio, version=4.2.16, url=http://webdriver.io}}]

[chimp][selenium.stderr] org.openqa.selenium.firefox.NotConnectedException: Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvider
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded

[chimp][selenium.stderr]    at org.openqa.selenium.firefox.internal.NewProfileExtensionConnection.start(NewProfileExtensionConnection.java:112)
    at org.openqa.selenium.firefox.FirefoxDriver.startClient(FirefoxDriver.java:271)
    at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:119)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:218)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:211)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:129)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.callConstructor(FirefoxDriverProvider.java:91)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.newInstance(FirefoxDriverProvider.java:68)
    at org.openqa.selenium.remote.server.DefaultDriverFactory.newInstance(DefaultDriverFactory.java:60)

[chimp][selenium.stderr]    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:222)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:1)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at org.openqa.selenium.remote.server.DefaultSession$1.run(DefaultSession.java:176)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)

[chimp][selenium.stderr] 14:18:02.574 WARN - Exception thrown
java.util.concurrent.ExecutionException: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.53.1', revision: 'a36b8b1', time: '2016-06-30 17:37:03'
System info: host: 'aurel', ip: '192.168.0.125', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11.4', java.version: '1.8.0_111'
Driver info: driver.version: unknown
    at java.util.concurrent.FutureTask.report(FutureTask.java:122)
    at java.util.concurrent.FutureTask.get(FutureTask.java:192)
    at org.openqa.selenium.remote.server.DefaultSession.execute(DefaultSession.java:183)
    at org.openqa.selenium.remote.server.DefaultSession.<init>(DefaultSession.java:119)
    at org.openqa.selenium.remote.server.DefaultSession.createSession(DefaultSession.java:95)
    at org.openqa.selenium.remote.server.DefaultDriverSessions.newSession(DefaultDriverSessions.java:124)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:59)
    at org.openqa.selenium.remote.server.handler.NewSession.handle(NewSession.java:1)
    at org.openqa.selenium.remote.server.rest.ResultConfig.handle(ResultConfig.java:111)
    at org.openqa.selenium.remote.server.JsonHttpCommandHandler.handleRequest(JsonHttpCommandHandler.java:79)
    at org.openqa.selenium.remote.server.DriverServlet.handleRequest(DriverServlet.java:204)
    at org.openqa.selenium.remote.server.DriverServlet.doPost(DriverServlet.java:166)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at org.openqa.selenium.remote.server.DriverServlet.service(DriverServlet.java:132)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.openqa.jetty.jetty.servlet.ServletHolder.handle(ServletHolder.java:428)
    at org.openqa.jetty.jetty.servlet.ServletHandler.dispatch(ServletHandler.java:680)
    at org.openqa.jetty.jetty.servlet.ServletHandler.handle(ServletHandler.java:571)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1526)
    at org.openqa.jetty.http.HttpContext.handle(HttpContext.java:1479)
    at org.openqa.jetty.http.HttpServer.service(HttpServer.java:920)
    at org.openqa.jetty.http.HttpConnection.service(HttpConnection.java:820)
    at org.openqa.jetty.http.HttpConnection.handleNext(HttpConnection.java:986)
    at org.openqa.jetty.http.HttpConnection.handle(HttpConnection.java:837)
    at org.openqa.jetty.http.SocketListener.handleConnection(SocketListener.java:243)
    at org.openqa.jetty.util.ThreadedServer.handle(ThreadedServer.java:358)
    at org.openqa.jetty.util.ThreadPool$PoolThread.run(ThreadPool.java:537)
Caused by: org.openqa.selenium.WebDriverException: java.lang.reflect.InvocationTargetException
Build info: version: '2.53.1', revision: 'a36b8b1', time: '2016-06-30 17:37:03'
System info: host: 'aurel', ip: '192.168.0.125', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11.4', java.version: '1.8.0_111'
Driver info: driver.version: unknown
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.callConstructor(FirefoxDriverProvider.java:101)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.newInstance(FirefoxDriverProvider.java:68)
    at org.openqa.selenium.remote.server.DefaultDriverFactory.newInstance(DefaultDriverFactory.java:60)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:222)
    at org.openqa.selenium.remote.server.DefaultSession$BrowserCreator.call(DefaultSession.java:1)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at org.openqa.selenium.remote.server.DefaultSession$1.run(DefaultSession.java:176)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.reflect.InvocationTargetException
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
    at org.openqa.selenium.remote.server.FirefoxDriverProvider.callConstructor(FirefoxDriverProvider.java:91)
    ... 9 more
Caused by: org.openqa.selenium.WebDriverException: Failed to connect to binary FirefoxBinary(/Applications/Firefox.app/Contents/MacOS/firefox-bin) on port 7055; process output follows: 
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvide
[chimp][selenium.stderr] r
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded

Build info: version: '2.53.1', revision: 'a36b8b1', time: '2016-06-30 17:37:03'
System info: host: 'aurel', ip: '192.168.0.125', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.11.4', java.version: '1.8.0_111'
Driver info: driver.version: FirefoxDriver
    at org.openqa.selenium.firefox.internal.NewProfileExtensionConnection.start(NewProfileExtensionConnection.java:124)
    at org.openqa.selenium.firefox.FirefoxDriver.startClient(FirefoxDriver.java:271)
    at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:119)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:218)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:211)
    at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:129)
    ... 14 more
Caused by: org.openqa.selenium.firefox.NotConnectedException: Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvider
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded

    at org.openqa.selenium.firefox.internal.NewProfileExtensionConnection.start(NewProfileExtensionConnection.java:112)
    ... 19 more

[chimp][selenium.stderr] 14:18:02.582 WARN - Exception: Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvider
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded

[chimp][selenium.stderr] 14:18:02.592 DEBUG - Finished: POST /session

[chimp][helper] setupBrowserAndDDP had error
{ [Error: Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvider
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded
]
  message: 'Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:\n08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}\n1477484238202\taddons.xpi\tDEBUG\tgetModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}\n1477484238204\tDeferredSave.extensions.json\tDEBUG\tSave changes\n1477484238204\taddons.xpi\tDEBUG\tUpdating database with changes to installed add-ons\n1477484238204\taddons.xpi-utils\tDEBUG\tUpdating add-on states\n1477484238205\taddons.xpi-utils\tDEBUG\tWriting add-ons list\n1477484238206\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi\n1477484238207\taddons.xpi\tDEBUG\tCalling bootstrap method startup on e10srollout@mozilla.org version 1.3\n1477484238207\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi\n1477484238207\taddons.xpi\tDEBUG\tCalling bootstrap method startup on firefox@getpocket.com version 1.0.4\n1477484238208\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi\n1477484238209\taddons.xpi\tDEBUG\tCalling bootstrap method startup on webcompat@mozilla.org version 1.0\n1477484238211\taddons.manager\tDEBUG\tRegistering shutdown blocker for XPIProvider\n1477484238212\taddons.manager\tDEBUG\tProvider finished startup: XPIProvider\n1477484238212\taddons.manager\tDEBUG\tStarting provider: LightweightThemeManager\n1477484238212\taddons.manager\tDEBUG\tRegistering shutdown blocker for LightweightThemeManager\n1477484238212\taddons.manager\tDEBUG\tProvider finished startup: LightweightThemeManager\n1477484238213\taddons.manager\tDEBUG\tStarting provider: GMPProvider\n1477484238223\taddons.manager\tDEBUG\tRegistering shutdown blocker for GMPProvider\n1477484238224\taddons.manager\tDEBUG\tProvider finished startup: GMPProvider\n1477484238224\taddons.manager\tDEBUG\tStarting provider: PluginProvider\n1477484238224\taddons.manager\tDEBUG\tRegistering shutdown blocker for PluginProvider\n1477484238224\taddons.manager\tDEBUG\tProvider finished startup: PluginProvider\n1477484238225\taddons.manager\tDEBUG\tCompleted startup sequence\n1477484238652\tDeferredSave.extensions.json\tDEBUG\tStarting write\n1477484238663\taddons.manager\tDEBUG\tStarting provider: <unnamed-provider>\n1477484238663\taddons.manager\tDEBUG\tRegistering shutdown blocker for <unnamed-provider>\n1477484238664\taddons.manager\tDEBUG\tProvider finished startup: <unnamed-provider>\n1477484238843\taddons.repository\tDEBUG\tNo addons.json found.\n1477484238844\tDeferredSave.addons.json\tDEBUG\tSave changes\n1477484238850\tDeferredSave.addons.json\tDEBUG\tStarting timer\n1477484238896\taddons.manager\tDEBUG\tStarting provider: PreviousExperimentProvider\n1477484238896\taddons.manager\tDEBUG\tRegistering shutdown blocker for PreviousExperimentProvider\n1477484238897\taddons.manager\tDEBUG\tProvider finished startup: PreviousExperimentProvider\n1477484238910\tDeferredSave.extensions.json\tDEBUG\tWrite succeeded\n1477484238911\taddons.xpi-utils\tDEBUG\tXPI Database saved, setting schema version preference to 17\n1477484238915\tDeferredSave.addons.json\tDEBUG\tStarting write\n1477484238944\tDeferredSave.addons.json\tDEBUG\tWrite succeeded\n',
  type: 'RuntimeError',
  seleniumStack: 
   { status: 13,
     type: 'UnknownError',
     message: 'An unknown server-side error occurred while processing the command.',
     orgStatusMessage: 'Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:\n08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}\n1477484238202\taddons.xpi\tDEBUG\tgetModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}\n1477484238204\tDeferredSave.extensions.json\tDEBUG\tSave changes\n1477484238204\taddons.xpi\tDEBUG\tUpdating database with changes to installed add-ons\n1477484238204\taddons.xpi-utils\tDEBUG\tUpdating add-on states\n1477484238205\taddons.xpi-utils\tDEBUG\tWriting add-ons list\n1477484238206\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi\n1477484238207\taddons.xpi\tDEBUG\tCalling bootstrap method startup on e10srollout@mozilla.org version 1.3\n1477484238207\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi\n1477484238207\taddons.xpi\tDEBUG\tCalling bootstrap method startup on firefox@getpocket.com version 1.0.4\n1477484238208\taddons.xpi\tDEBUG\tRegistering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi\n1477484238209\taddons.xpi\tDEBUG\tCalling bootstrap method startup on webcompat@mozilla.org version 1.0\n1477484238211\taddons.manager\tDEBUG\tRegistering shutdown blocker for XPIProvider\n1477484238212\taddons.manager\tDEBUG\tProvider finished startup: XPIProvider\n1477484238212\taddons.manager\tDEBUG\tStarting provider: LightweightThemeManager\n1477484238212\taddons.manager\tDEBUG\tRegistering shutdown blocker for LightweightThemeManager\n1477484238212\taddons.manager\tDEBUG\tProvider finished startup: LightweightThemeManager\n1477484238213\taddons.manager\tDEBUG\tStarting provider: GMPProvider\n1477484238223\taddons.manager\tDEBUG\tRegistering shutdown blocker for GMPProvider\n1477484238224\taddons.manager\tDEBUG\tProvider finished startup: GMPProvider\n1477484238224\taddons.manager\tDEBUG\tStarting provider: PluginProvider\n1477484238224\taddons.manager\tDEBUG\tRegistering shutdown blocker for PluginProvider\n1477484238224\taddons.manager\tDEBUG\tProvider finished startup: PluginProvider\n1477484238225\taddons.manager\tDEBUG\tCompleted startup sequence\n1477484238652\tDeferredSave.extensions.json\tDEBUG\tStarting write\n1477484238663\taddons.manager\tDEBUG\tStarting provider: <unnamed-provider>\n1477484238663\taddons.manager\tDEBUG\tRegistering shutdown blocker for <unnamed-provider>\n1477484238664\taddons.manager\tDEBUG\tProvider finished startup: <unnamed-provider>\n1477484238843\taddons.repository\tDEBUG\tNo addons.json found.\n1477484238844\tDeferredSave.addons.json\tDEBUG\tSave changes\n1477484238850\tDeferredSave.addons.json\tDEBUG\tStarting timer\n1477484238896\taddons.manager\tDEBUG\tStarting provider: PreviousExperimentProvider\n1477484238896\taddons.manager\tDEBUG\tRegistering shutdown blocker for PreviousExperimentProvider\n1477484238897\taddons.manager\tDEBUG\tProvider finished startup: PreviousExperimentProvider\n1477484238910\tDeferredSave.extensions.json\tDEBUG\tWrite succeeded\n1477484238911\taddons.xpi-utils\tDEBUG\tXPI Database saved, setting schema version preference to 17\n1477484238915\tDeferredSave.addons.json\tDEBUG\tStarting write\n1477484238944\tDeferredSave.addons.json\tDEBUG\tWrite succeeded\n' } }
Error: Unable to connect to host localhost on port 7055 after 45000 ms. Firefox console output:
    at Object.Future.wait (/usr/local/lib/node_modules/chimp/node_modules/fibers/future.js:449:15)
    at Object.<anonymous> (/usr/local/lib/node_modules/chimp/node_modules/wdio-sync/build/index.js:345:27)
    at initBrowser (/usr/local/lib/node_modules/chimp/dist/lib/chimp-helper.js:161:17)
    at Object.setupBrowserAndDDP (/usr/local/lib/node_modules/chimp/dist/lib/chimp-helper.js:215:7)
    at Context.<anonymous> (/usr/local/lib/node_modules/chimp/dist/lib/mocha/mocha-helper.js:11:15)
    at /usr/local/lib/node_modules/chimp/dist/lib/utils/fiberize.js:25:14
    - - - - -
08198ce6fd}","syncGUID":"VM7ywjE4iN6d","location":"app-global","version":"49.0.2","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/Applications/Firefox.app/Contents/Resources/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1476922735000,"updateDate":1476922735000,"applyBackgroundUpdates":1,"skinnable":true,"size":7140,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"49.0.2","maxVersion":"49.0.2"}],"targetPlatforms":[],"seen":true}
1477484238202   addons.xpi  DEBUG   getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd}
1477484238204   DeferredSave.extensions.json    DEBUG   Save changes
1477484238204   addons.xpi  DEBUG   Updating database with changes to installed add-ons
1477484238204   addons.xpi-utils    DEBUG   Updating add-on states
1477484238205   addons.xpi-utils    DEBUG   Writing add-ons list
1477484238206   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/e10srollout@mozilla.org.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on e10srollout@mozilla.org version 1.3
1477484238207   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/firefox@getpocket.com.xpi
1477484238207   addons.xpi  DEBUG   Calling bootstrap method startup on firefox@getpocket.com version 1.0.4
1477484238208   addons.xpi  DEBUG   Registering manifest for /Applications/Firefox.app/Contents/Resources/browser/features/webcompat@mozilla.org.xpi
1477484238209   addons.xpi  DEBUG   Calling bootstrap method startup on webcompat@mozilla.org version 1.0
1477484238211   addons.manager  DEBUG   Registering shutdown blocker for XPIProvider
1477484238212   addons.manager  DEBUG   Provider finished startup: XPIProvider
1477484238212   addons.manager  DEBUG   Starting provider: LightweightThemeManager
1477484238212   addons.manager  DEBUG   Registering shutdown blocker for LightweightThemeManager
1477484238212   addons.manager  DEBUG   Provider finished startup: LightweightThemeManager
1477484238213   addons.manager  DEBUG   Starting provider: GMPProvider
1477484238223   addons.manager  DEBUG   Registering shutdown blocker for GMPProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: GMPProvider
1477484238224   addons.manager  DEBUG   Starting provider: PluginProvider
1477484238224   addons.manager  DEBUG   Registering shutdown blocker for PluginProvider
1477484238224   addons.manager  DEBUG   Provider finished startup: PluginProvider
1477484238225   addons.manager  DEBUG   Completed startup sequence
1477484238652   DeferredSave.extensions.json    DEBUG   Starting write
1477484238663   addons.manager  DEBUG   Starting provider: <unnamed-provider>
1477484238663   addons.manager  DEBUG   Registering shutdown blocker for <unnamed-provider>
1477484238664   addons.manager  DEBUG   Provider finished startup: <unnamed-provider>
1477484238843   addons.repository   DEBUG   No addons.json found.
1477484238844   DeferredSave.addons.json    DEBUG   Save changes
1477484238850   DeferredSave.addons.json    DEBUG   Starting timer
1477484238896   addons.manager  DEBUG   Starting provider: PreviousExperimentProvider
1477484238896   addons.manager  DEBUG   Registering shutdown blocker for PreviousExperimentProvider
1477484238897   addons.manager  DEBUG   Provider finished startup: PreviousExperimentProvider
1477484238910   DeferredSave.extensions.json    DEBUG   Write succeeded
1477484238911   addons.xpi-utils    DEBUG   XPI Database saved, setting schema version preference to 17
1477484238915   DeferredSave.addons.json    DEBUG   Starting write
1477484238944   DeferredSave.addons.json    DEBUG   Write succeeded

[chimp][mocha] Closed with code 2
[chimp][mocha] Mocha not in a stopping state
[chimp] Finished running async processes with errors
[chimp] run complete with errors Mocha failed
Mocha failed
Error in chimp init Mocha failed
aurelben commented 8 years ago

export LC_NUMERIC=en_US.UTF-8 worked for me with chrome but not with FF (but for me it's not a probleme)

Thanks a LOT for quick help and for your great testing tool :)