1313157 - Intermittent dom/workers/test/test_subworkers_suspended.html | We have data from the worker - got -1, expected +0

Status: RESOLVED FIXED

(Core :: DOM: Workers, defect)

Description

[Treeherder Bug Filer]

Filed by: philringnalda [at] gmail.com

https://treeherder.mozilla.org/logviewer.html#?job_id=5684168&repo=autoland

https://queue.taskcluster.net/v1/task/T0r0BjEgQFahs2FcMuQj0A/runs/0/artifacts/public%2Flogs%2Flive_backing.log

Comment 1

[Intermittent Failures Robot]

12 failures in 777 pushes (0.015 failures/push) were associated with this bug in the last 7 days.   

Repository breakdown:
* autoland: 7
* mozilla-inbound: 3
* try: 2

Platform breakdown:
* android-4-3-armv7-api15: 10
* windows7-32-vm: 1
* linux32: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1313157&startday=2017-03-13&endday=2017-03-19&tree=all

Comment 2

[Intermittent Failures Robot]

32 failures in 879 pushes (0.036 failures/push) were associated with this bug in the last 7 days. 

This is the #42 most frequent failure this week.  

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. ** 

Repository breakdown:
* mozilla-inbound: 14
* autoland: 9
* mozilla-central: 5
* try: 3
* oak: 1

Platform breakdown:
* android-4-3-armv7-api15: 30
* windows8-64: 1
* linux32: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1313157&startday=2017-05-08&endday=2017-05-14&tree=all

Comment 3

[Geoff Brown [:gbrown]]

All failures are Android-Debug (except for a few desktop failures with a different failure in the same test).

All Android failures look like:

[task 2017-05-12T01:32:50.244114Z] 01:32:50     INFO -  533 INFO TEST-START | dom/workers/test/test_subworkers_suspended.html
[task 2017-05-12T01:33:22.015054Z] 01:33:22     INFO -  Buffered messages logged at 01:32:53
[task 2017-05-12T01:33:22.015338Z] 01:33:22     INFO -  534 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | A valid string reason is expected
[task 2017-05-12T01:33:22.015445Z] 01:33:22     INFO -  535 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | Reason cannot be empty
[task 2017-05-12T01:33:22.015562Z] 01:33:22     INFO -  Buffered messages logged at 01:33:00
[task 2017-05-12T01:33:22.016276Z] 01:33:22     INFO -  536 INFO Page1Shown: http://mochi.test:8888/tests/dom/workers/test/window_suspended.html?page1Shown
[task 2017-05-12T01:33:22.016887Z] 01:33:22     INFO -  537 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | test page should have been persisted initially
[task 2017-05-12T01:33:22.017551Z] 01:33:22     INFO -  538 INFO Create a worker and subworkers...
[task 2017-05-12T01:33:22.018005Z] 01:33:22     INFO -  539 INFO Waiting until workers are ready...
[task 2017-05-12T01:33:22.018843Z] 01:33:22     INFO -  Buffered messages logged at 01:33:07
[task 2017-05-12T01:33:22.019718Z] 01:33:22     INFO -  540 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | We want to receive: -ready-
[task 2017-05-12T01:33:22.020727Z] 01:33:22     INFO -  541 INFO Retrieving data from cache...
[task 2017-05-12T01:33:22.021470Z] 01:33:22     INFO -  Buffered messages logged at 01:33:08
[task 2017-05-12T01:33:22.022382Z] 01:33:22     INFO -  542 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | We have data from the worker
[task 2017-05-12T01:33:22.024032Z] 01:33:22     INFO -  543 INFO New location: window_suspended.html?page2Shown
[task 2017-05-12T01:33:22.024632Z] 01:33:22     INFO -  Buffered messages logged at 01:33:12
[task 2017-05-12T01:33:22.025477Z] 01:33:22     INFO -  544 INFO Page2Shown: http://mochi.test:8888/tests/dom/workers/test/window_suspended.html?page2Shown
[task 2017-05-12T01:33:22.026022Z] 01:33:22     INFO -  545 INFO Create a worker...
[task 2017-05-12T01:33:22.026533Z] 01:33:22     INFO -  546 INFO Waiting until workers are ready...
[task 2017-05-12T01:33:22.027260Z] 01:33:22     INFO -  Buffered messages logged at 01:33:15
[task 2017-05-12T01:33:22.028069Z] 01:33:22     INFO -  547 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | We want to receive: -ready-
[task 2017-05-12T01:33:22.030521Z] 01:33:22     INFO -  548 INFO Retrieving data from cache...
[task 2017-05-12T01:33:22.031298Z] 01:33:22     INFO -  549 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | We have data from the second worker
[task 2017-05-12T01:33:22.031991Z] 01:33:22     INFO -  550 INFO Going back
[task 2017-05-12T01:33:22.032753Z] 01:33:22     INFO -  551 INFO Page1Shown: http://mochi.test:8888/tests/dom/workers/test/window_suspended.html?page1Shown
[task 2017-05-12T01:33:22.033514Z] 01:33:22     INFO -  552 INFO TEST-PASS | dom/workers/test/test_subworkers_suspended.html | test page should have been persisted in pageshow
[task 2017-05-12T01:33:22.034587Z] 01:33:22     INFO -  553 INFO Waiting a few seconds...
[task 2017-05-12T01:33:22.035254Z] 01:33:22     INFO -  554 INFO TEST-FAIL | dom/workers/test/test_subworkers_suspended.html | The author of the test has indicated that flaky timeouts are expected.  Reason: untriaged
[task 2017-05-12T01:33:22.035856Z] 01:33:22     INFO -  Buffered messages logged at 01:33:21
[task 2017-05-12T01:33:22.036456Z] 01:33:22     INFO -  555 INFO Retrieving data from cache...
[task 2017-05-12T01:33:22.036988Z] 01:33:22     INFO -  Buffered messages finished
[task 2017-05-12T01:33:22.037614Z] 01:33:22     INFO -  556 INFO TEST-UNEXPECTED-FAIL | dom/workers/test/test_subworkers_suspended.html | We have data from the worker - got -1, expected +0
[task 2017-05-12T01:33:22.038216Z] 01:33:22     INFO -      SimpleTest.is@SimpleTest/SimpleTest.js:312:5
[task 2017-05-12T01:33:22.038755Z] 01:33:22     INFO -      page1Shown/<@dom/workers/test/test_subworkers_suspended.html:78:9
[task 2017-05-12T01:33:32.554295Z] 01:33:32     INFO -  557 INFO TEST-OK | dom/workers/test/test_subworkers_suspended.html | took 34171ms

This looks just like bug 1307566, where the timeout was increased from 2 to 5 seconds.

https://hg.mozilla.org/mozilla-central/rev/25e1e4d63f11


:baku - Increase the timeout again? Skip on Android-Debug?

Comment 4

[Andrea Marchesini [:baku]]

Attachment: timeout.patch

I don't like the idea to disable the test. Let's increase the timeout.
In case we still have failures, we can disable it on android only.

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/mozilla-inbound/rev/d51900e0fb6c
Increase timeout for test_subworkers_suspended.html, r=gbrown

Comment 6

[Wes Kocher (:KWierso) (Not reading bugmail; email directly if needed)]

https://hg.mozilla.org/mozilla-central/rev/d51900e0fb6c

Comment 7

[Intermittent Failures Robot]

41 failures in 777 pushes (0.053 failures/push) were associated with this bug in the last 7 days. 

This is the #22 most frequent failure this week.  

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. ** 

Repository breakdown:
* autoland: 16
* mozilla-inbound: 11
* try: 8
* mozilla-central: 3
* graphics: 3

Platform breakdown:
* android-4-3-armv7-api15: 41

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1313157&startday=2017-05-15&endday=2017-05-21&tree=all