1547390 - Intermittent TEST-UNEXPECTED-TIMEOUT | runjunit.py | Timed out after 2400 seconds - org.mozilla.geckoview.test.WebExtensionTest#contentPortDisconnect

Status: RESOLVED WORKSFORME

(GeckoView :: Extensions, defect, P3)

Description

[Treeherder Bug Filer]

#[markdown(off)]
Filed by: csabou [at] mozilla.com

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

https://queue.taskcluster.net/v1/task/T99AtCOSSsyVJpPrSGo4hQ/runs/0/artifacts/public/logs/live_backing.log

[task 2019-04-26T20:29:49.285Z] 20:29:49 INFO - TEST-PASS | org.mozilla.geckoview.test.TextInputDelegateTest.restartInput[#designmode] | took 14537ms
[task 2019-04-26T20:29:49.385Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-04-26T20:29:49.385Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=74
[task 2019-04-26T20:29:49.386Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.WebExtensionTest
[task 2019-04-26T20:29:49.386Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-04-26T20:29:49.387Z] 20:29:49 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.WebExtensionTest:
[task 2019-04-26T20:29:49.387Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=75
[task 2019-04-26T20:29:49.388Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=contentPortDisconnect
[task 2019-04-26T20:29:49.388Z] 20:29:49 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2019-04-26T20:29:49.389Z] 20:29:49 INFO - TEST-START | org.mozilla.geckoview.test.WebExtensionTest.contentPortDisconnect
[task 2019-04-26T20:31:24.723Z] 20:31:24 WARNING - TEST-UNEXPECTED-TIMEOUT | runjunit.py | Timed out after 2400 seconds
[task 2019-04-26T20:31:24.724Z] 20:31:24 INFO - Passed: 68
[task 2019-04-26T20:31:24.724Z] 20:31:24 INFO - Failed: 0
[task 2019-04-26T20:31:24.724Z] 20:31:24 INFO - Todo: 5
[task 2019-04-26T20:31:24.724Z] 20:31:24 INFO - SUITE-END | took 2400s
[task 2019-04-26T20:31:25.943Z] 20:31:25 INFO - Stopping web server
[task 2019-04-26T20:31:25.954Z] 20:31:25 INFO - Stopping web socket server
[task 2019-04-26T20:31:25.975Z] 20:31:25 INFO - Stopping ssltunnel
[task 2019-04-26T20:31:29.335Z] 20:31:29 INFO - Return code: 0
[task 2019-04-26T20:31:29.335Z] 20:31:29 INFO - TinderboxPrint: geckoview-junit<br/>68/0
[task 2019-04-26T20:31:29.335Z] 20:31:29 INFO - ##### geckoview-junit log ends
[task 2019-04-26T20:31:29.335Z] 20:31:29 WARNING - # TBPL WARNING #
[task 2019-04-26T20:31:29.335Z] 20:31:29 WARNING - setting return code to 1
[task 2019-04-26T20:31:29.335Z] 20:31:29 WARNING - The geckoview-junit suite: geckoview-junit ran with return status: WARNING
[task 2019-04-26T20:31:29.335Z] 20:31:29 INFO - Running post-action listener: _package_coverage_data
[task 2019-04-26T20:31:29.336Z] 20:31:29 INFO - Running post-action listener: _resource_record_post_action
[task 2019-04-26T20:31:29.336Z] 20:31:29 INFO - Running post-action listener: process_java_coverage_data
[task 2019-04-26T20:31:29.336Z] 20:31:29 INFO - Running post-action listener: stop_device
[task 2019-04-26T20:31:30.713Z] 20:31:30 INFO - Killing logcat pid 882.
[task 2019-04-26T20:31:30.714Z] 20:31:30 INFO - Killing every process called emulator64-arm
[task 2019-04-26T20:31:30.725Z] 20:31:30 INFO - Killing pid 456.
[task 2019-04-26T20:31:30.725Z] 20:31:30 INFO - [mozharness: 2019-04-26 20:31:30.725301Z] Finished run-tests step (success)
[task 2019-04-26T20:31:30.729Z] 20:31:30 INFO - Running post-run listener: _resource_record_post_run
[task 2019-04-26T20:31:30.894Z] 20:31:30 INFO - Total resource usage - Wall time: 2481s; CPU: 25.0%; Read bytes: 7962624; Write bytes: 782331904; Read time: 536; Write time: 91500
[task 2019-04-26T20:31:30.894Z] 20:31:30 INFO - TinderboxPrint: CPU usage<br/>25.2%
[task 2019-04-26T20:31:30.894Z] 20:31:30 INFO - TinderboxPrint: I/O read bytes / time<br/>7,962,624 / 536
[task 2019-04-26T20:31:30.895Z] 20:31:30 INFO - TinderboxPrint: I/O write bytes / time<br/>782,331,904 / 91,500
[task 2019-04-26T20:31:30.895Z] 20:31:30 INFO - TinderboxPrint: CPU idle<br/>7,311.0 (74.5%)
[task 2019-04-26T20:31:30.896Z] 20:31:30 INFO - TinderboxPrint: CPU user<br/>2,476.9 (25.2%)
[task 2019-04-26T20:31:30.896Z] 20:31:30 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2019-04-26T20:31:30.897Z] 20:31:30 INFO - verify-device - Wall time: 6s; CPU: 7.0%; Read bytes: 0; Write bytes: 22831104; Read time: 0; Write time: 6108
[task 2019-04-26T20:31:30.899Z] 20:31:30 INFO - install - Wall time: 63s; CPU: 25.0%; Read bytes: 0; Write bytes: 531910656; Read time: 0; Write time: 68036
[task 2019-04-26T20:31:30.925Z] 20:31:30 INFO - run-tests - Wall time: 2411s; CPU: 25.0%; Read bytes: 7962624; Write bytes: 222896128; Read time: 536; Write time: 17216
[task 2019-04-26T20:31:31.682Z] 20:31:31 WARNING - returning nonzero exit status 1

Comment 1

[Intermittent Failures Robot]

7 failures in 3031 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• mozilla-central: 2
• mozilla-inbound: 1

Platform breakdown:

• android-em-4-3-armv7-api16: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1547390&startday=2019-04-22&endday=2019-04-28&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 4705 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-inbound: 1

Platform breakdown:

• android-em-4-3-armv7-api16: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1547390&startday=2019-05-06&endday=2019-05-12&tree=all

Comment 3

[Intermittent Failures Robot]

2 failures in 4730 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform breakdown:

• android-em-4-3-armv7-api16: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1547390&startday=2019-05-20&endday=2019-05-26&tree=all

Comment 4

[Intermittent Failures Robot]

5 failures in 4337 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• mozilla-central: 1

Platform breakdown:

• android-em-4-3-armv7-api16: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1547390&startday=2019-05-27&endday=2019-06-02&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 5197 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• android-em-4-3-armv7-api16: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1547390&startday=2019-06-03&endday=2019-06-09&tree=all

Comment 6

[[ex-Mozilla] Agi Sferro | :agi]

Hasn't happened since June, resolving.

Comment 7

[[ex-Mozilla] Agi Sferro | :agi]

6c6f5da9-bf33-4082-a19d-7d99e8083d97 Mass rename intermittents due to Bug 1723034.

Comment 8

[Chris Peterson [:cpeterson]]

Moving some WebExtension bugs to the GeckoView::Extensions component.