Closed Bug 1222355 Opened 10 years ago Closed 7 years ago

Intermittent tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client get logs from (nested) mozbrowser iframes

Categories

(Firefox OS Graveyard :: Gaia, defect)

Product:
Firefox OS Graveyard
Component:
Gaia
Platform:
ARM
Gonk (Firefox OS)
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

(feature-b2g:2.6+)

Status:
RESOLVED WONTFIX
Project Flags:
feature-b2g 2.6+

People

(Reporter: nigelb, Unassigned)

References

(
URL
)

Details

(Keywords: intermittent-failure, Whiteboard: [MJS] [intermittents])

https://treeherder.mozilla.org/logviewer.html#?job_id=16898365&repo=mozilla-inbound 05:24:56 INFO - [marionette-mocha] 1) client Catches content errors: 05:24:56 INFO - Error: timeout exceeded! 05:24:56 INFO - at Object.Client.waitForSync (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:756:16) 05:24:56 INFO - at Object.Client.waitFor (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:722:60) 05:24:56 INFO - at Object.Rocketbar.enterText (/home/worker/gaia/apps/system/test/marionette/lib/rocketbar.js:105:17) 05:24:56 INFO - at Context.<anonymous> (/home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js:170:15) 05:24:56 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:223:21) 05:24:56 INFO - at Test.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:24:56 INFO - at Test.MarionetteTest.run (/home/worker/gaia/node_modules/marionette-js-runner/lib/ui.js:25:31) 05:24:56 INFO - at Runner.runTest (/home/worker/gaia/node_modules/mocha/lib/runner.js:373:10) 05:24:56 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:451:12 05:24:56 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:298:14) 05:24:56 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:308:7 05:24:56 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:246:23) 05:24:56 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:24:56 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:24:56 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:228:7) 05:24:56 INFO - at Hook.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:24:56 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:258:10) 05:24:56 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:24:56 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:24:56 INFO - at /home/worker/gaia/node_modules/mocha/lib/runnable.js:226:31 05:24:56 INFO - at /home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/lib/core.js:33:15 05:24:56 INFO - at flush (/home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/node_modules/asap/asap.js:27:13) 05:24:56 INFO - at process._tickCallback (node.js:442:13) 05:24:56 INFO - . 05:24:56 INFO - /home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js failed. Will retry. 05:26:22 INFO - ..........[marionette-mocha] { [Error: Not connected. To write data you must call connect first.] 05:26:22 INFO - client: 05:26:22 INFO - { _scope: { context: 'chrome', scriptTimeout: 20000, searchTimeout: 10000 }, 05:26:22 INFO - _bypassScopeChecks: true } } 05:26:22 INFO - [marionette-mocha] { [Error: Not connected. To write data you must call connect first.] 05:26:22 INFO - client: 05:26:22 INFO - { _scope: { context: 'chrome', scriptTimeout: 20000, searchTimeout: 10000 }, 05:26:22 INFO - _bypassScopeChecks: true } } 05:26:22 INFO - [marionette-mocha] { [Error: Not connected. To write data you must call connect first.] 05:26:22 INFO - client: 05:26:22 INFO - { _scope: { context: 'chrome', scriptTimeout: 20000, searchTimeout: 10000 }, 05:26:22 INFO - _bypassScopeChecks: true } } 05:26:22 INFO - ..[marionette-mocha] 2 failing 05:26:22 INFO - 1) client get logs from (nested) mozbrowser iframes: 05:26:22 INFO - Error: timeout exceeded! 05:26:22 INFO - at Object.Client.waitForSync (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:756:16) 05:26:22 INFO - at Object.Client.waitFor (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:722:60) 05:26:22 INFO - at Object.Rocketbar.enterText (/home/worker/gaia/apps/system/test/marionette/lib/rocketbar.js:105:17) 05:26:22 INFO - at Context.<anonymous> (/home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js:149:15) 05:26:22 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:223:21) 05:26:22 INFO - at Test.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:26:22 INFO - at Test.MarionetteTest.run (/home/worker/gaia/node_modules/marionette-js-runner/lib/ui.js:25:31) 05:26:22 INFO - at Runner.runTest (/home/worker/gaia/node_modules/mocha/lib/runner.js:373:10) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:451:12 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:298:14) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:308:7 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:246:23) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:26:22 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:26:22 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:228:7) 05:26:22 INFO - at Hook.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:258:10) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:26:22 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runnable.js:226:31 05:26:22 INFO - at /home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/lib/core.js:33:15 05:26:22 INFO - at flush (/home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/node_modules/asap/asap.js:27:13) 05:26:22 INFO - at process._tickCallback (node.js:442:13) 05:26:22 INFO - 2) client Catches content errors: 05:26:22 INFO - Error: timeout exceeded! 05:26:22 INFO - at Object.Client.waitForSync (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:756:16) 05:26:22 INFO - at Object.Client.waitFor (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:722:60) 05:26:22 INFO - at Object.Rocketbar.enterText (/home/worker/gaia/apps/system/test/marionette/lib/rocketbar.js:105:17) 05:26:22 INFO - at Context.<anonymous> (/home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js:170:15) 05:26:22 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:223:21) 05:26:22 INFO - at Test.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:26:22 INFO - at Test.MarionetteTest.run (/home/worker/gaia/node_modules/marionette-js-runner/lib/ui.js:25:31) 05:26:22 INFO - at Runner.runTest (/home/worker/gaia/node_modules/mocha/lib/runner.js:373:10) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:451:12 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:298:14) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:308:7 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:246:23) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:26:22 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:26:22 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:228:7) 05:26:22 INFO - at Hook.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:26:22 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:258:10) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:26:22 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:26:22 INFO - at /home/worker/gaia/node_modules/mocha/lib/runnable.js:226:31 05:26:22 INFO - at /home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/lib/core.js:33:15 05:26:22 INFO - at flush (/home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/node_modules/asap/asap.js:27:13) 05:26:22 INFO - at process._tickCallback (node.js:442:13) 05:26:22 INFO - /home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js failed. Will retry. 05:27:31 INFO - ................[marionette-mocha] 1 failing 05:27:31 INFO - 1) client get logs from (nested) mozbrowser iframes: 05:27:31 INFO - Error: timeout exceeded! 05:27:31 INFO - at Object.Client.waitForSync (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:756:16) 05:27:31 INFO - at Object.Client.waitFor (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:722:60) 05:27:31 INFO - at Object.Rocketbar.enterText (/home/worker/gaia/apps/system/test/marionette/lib/rocketbar.js:105:17) 05:27:31 INFO - at Context.<anonymous> (/home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js:149:15) 05:27:31 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:223:21) 05:27:31 INFO - at Test.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:27:31 INFO - at Test.MarionetteTest.run (/home/worker/gaia/node_modules/marionette-js-runner/lib/ui.js:25:31) 05:27:31 INFO - at Runner.runTest (/home/worker/gaia/node_modules/mocha/lib/runner.js:373:10) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:451:12 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:298:14) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:308:7 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:246:23) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:27:31 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:27:31 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:228:7) 05:27:31 INFO - at Hook.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:258:10) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:27:31 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runnable.js:226:31 05:27:31 INFO - at /home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/lib/core.js:33:15 05:27:31 INFO - at flush (/home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/node_modules/asap/asap.js:27:13) 05:27:31 INFO - at process._tickCallback (node.js:442:13) 05:27:31 INFO - TEST-START | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client console 05:27:31 INFO - TEST-PASS | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client console 05:27:31 INFO - TEST-END | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client console took 1168 ms 05:27:31 INFO - TEST-START | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client get logs from (nested) mozbrowser iframes 05:27:31 INFO - TEST-UNEXPECTED-FAIL | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client get logs from (nested) mozbrowser iframes 05:27:31 INFO - Error: timeout exceeded! 05:27:31 INFO - at Object.Client.waitForSync (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:756:16) 05:27:31 INFO - at Object.Client.waitFor (/home/worker/gaia/node_modules/marionette-client/lib/marionette/client.js:722:60) 05:27:31 INFO - at Object.Rocketbar.enterText (/home/worker/gaia/apps/system/test/marionette/lib/rocketbar.js:105:17) 05:27:31 INFO - at Context.<anonymous> (/home/worker/gaia/tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js:149:15) 05:27:31 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:223:21) 05:27:31 INFO - at Test.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:27:31 INFO - at Test.MarionetteTest.run (/home/worker/gaia/node_modules/marionette-js-runner/lib/ui.js:25:31) 05:27:31 INFO - at Runner.runTest (/home/worker/gaia/node_modules/mocha/lib/runner.js:373:10) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:451:12 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:298:14) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:308:7 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:246:23) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:27:31 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:27:31 INFO - at callFn (/home/worker/gaia/node_modules/mocha/lib/runnable.js:228:7) 05:27:31 INFO - at Hook.Runnable.run (/home/worker/gaia/node_modules/mocha/lib/runnable.js:216:7) 05:27:31 INFO - at next (/home/worker/gaia/node_modules/mocha/lib/runner.js:258:10) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runner.js:270:7 05:27:31 INFO - at done (/home/worker/gaia/node_modules/mocha/lib/runnable.js:185:5) 05:27:31 INFO - at /home/worker/gaia/node_modules/mocha/lib/runnable.js:226:31 05:27:31 INFO - at /home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/lib/core.js:33:15 05:27:31 INFO - at flush (/home/worker/gaia/node_modules/marionette-js-runner/node_modules/promise/node_modules/asap/asap.js:27:13) 05:27:31 INFO - at process._tickCallback (node.js:442:13) 05:27:31 INFO - TEST-END | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client get logs from (nested) mozbrowser iframes took 20844 ms 05:27:31 INFO - TEST-START | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client Catches content errors 05:27:31 INFO - TEST-PASS | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client Catches content errors 05:27:31 INFO - TEST-END | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client Catches content errors took 3257 ms 05:27:31 INFO - TEST-START | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client #pollMessages should catch all logs 05:27:31 INFO - TEST-PASS | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client #pollMessages should catch all logs 05:27:31 INFO - TEST-END | tests/jsmarionette/plugins/marionette-js-logger/test/client_test.js | client #pollMessages should catch all logs took 745 ms 05:27:31 INFO - Exit code 1
Been seeing these a lot when we disable the retry logic in bug 1222215. 1.) https://treeherder.mozilla.org/#/jobs?repo=gaia&revision=f738dc459f86b50a4f331908c23f0a3df2366a0f Gareth or Aus, are you guys looking at these marionette client tests?
Blocks: 1222215
Flags: needinfo?(gaye)
Flags: needinfo?(aus)
Yeah, we'll be trying to fix those.
Flags: needinfo?(aus)
feature-b2g: --- → 2.6+
Whiteboard: [MJS]
This is starting to show false positives on even gaia-master [1]. Let's disable this test for now. 1.) https://treeherder.mozilla.org/#/jobs?repo=gaia-master&revision=569ae6b53fb5
Flags: needinfo?(gaye)
Removing the dependency since this test is now disabled.
No longer blocks: 1222215
Whiteboard: [MJS] → [MJS] [intermittents]
Closing all intermittent test failures for Firefox OS (since we're not focusing on it anymore). Please reopen if my search included your bug by mistake.
Firefox OS is not being worked on
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → WONTFIX
You need to log in before you can comment on or make changes to this bug.