1422140 - Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/components/telemetry/tests/unit/test_TelemetryLateWrites.js | Test timed out

Status: RESOLVED INCOMPLETE

(Toolkit :: Telemetry, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: philringnalda [at] gmail.com

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

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

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1

Platform breakdown:
* android-4-2-x86: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1422140&startday=2017-11-27&endday=2017-12-03&tree=all

Comment 2

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-beta: 1

Platform breakdown:
* android-4-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-06-04&endday=2018-06-10&tree=trunk

Comment 4

[Andreea Pavel [:apavel]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=185986750&repo=mozilla-beta&lineNumber=1740

[task 2018-07-02T17:10:19.110Z] 17:10:19     INFO -  TEST-START | toolkit/components/telemetry/tests/unit/test_TelemetryLateWrites.js
[task 2018-07-02T17:15:19.110Z] 17:15:19  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/components/telemetry/tests/unit/test_TelemetryLateWrites.js | Test timed out
[task 2018-07-02T17:15:19.111Z] 17:15:19     INFO -  TEST-INFO took 300001ms
[task 2018-07-02T17:15:19.316Z] 17:15:19     INFO -  xpcshell return code: -1
[task 2018-07-02T17:15:35.166Z] 17:15:35  WARNING -  TEST-UNEXPECTED-FAIL | Received SIGINT (control-C), so stopped run. (Use --keep-going to keep running tests after killing one with SIGINT)
[task 2018-07-02T17:15:35.166Z] 17:15:35     INFO -  INFO | Result summary:
[task 2018-07-02T17:15:35.167Z] 17:15:35     INFO -  INFO | Passed: 130
[task 2018-07-02T17:15:35.167Z] 17:15:35  WARNING -  INFO | Failed: 1
[task 2018-07-02T17:15:35.167Z] 17:15:35  WARNING -  One or more unittests failed.
[task 2018-07-02T17:15:35.168Z] 17:15:35     INFO -  INFO | Todo: 0
[task 2018-07-02T17:15:35.168Z] 17:15:35     INFO -  INFO | Retried: 0
[task 2018-07-02T17:15:35.168Z] 17:15:35     INFO -  SUITE-END | took 2028s
[task 2018-07-02T17:15:35.209Z] 17:15:35    ERROR - Return code: 1
[task 2018-07-02T17:15:35.209Z] 17:15:35     INFO - TinderboxPrint: xpcshell<br/>130/<em class="testfail">1</em>/0
[task 2018-07-02T17:15:35.210Z] 17:15:35     INFO - ##### xpcshell log ends
[task 2018-07-02T17:15:35.210Z] 17:15:35  WARNING - # TBPL WARNING #
[task 2018-07-02T17:15:35.210Z] 17:15:35  WARNING - setting return code to 1
[task 2018-07-02T17:15:35.210Z] 17:15:35  WARNING - The xpcshell suite: xpcshell ran with return status: WARNING
[task 2018-07-02T17:15:35.210Z] 17:15:35     INFO - Running post-action listener: _package_coverage_data
[task 2018-07-02T17:15:35.211Z] 17:15:35     INFO - Running post-action listener: _resource_record_post_action
[task 2018-07-02T17:15:35.211Z] 17:15:35     INFO - Running post-action listener: stop_emulator
[task 2018-07-02T17:15:35.219Z] 17:15:35     INFO - Killing every process called emulator64-x86
[task 2018-07-02T17:15:35.219Z] 17:15:35     INFO - Killing pid 487.
[task 2018-07-02T17:15:35.222Z] 17:15:35     INFO - [mozharness: 2018-07-02 17:15:35.219646Z] Finished run-tests step (success)
[task 2018-07-02T17:15:35.222Z] 17:15:35     INFO - Running post-run listener: _resource_record_post_run
[task 2018-07-02T17:15:35.371Z] 17:15:35     INFO - Total resource usage - Wall time: 2350s; CPU: 17.0%; Read bytes: 115118080; Write bytes: 879710208; Read time: 177448; Write time: 1691296
[task 2018-07-02T17:15:35.372Z] 17:15:35     INFO - TinderboxPrint: CPU usage<br/>16.6%
[task 2018-07-02T17:15:35.372Z] 17:15:35     INFO - TinderboxPrint: I/O read bytes / time<br/>115,118,080 / 177,448
[task 2018-07-02T17:15:35.372Z] 17:15:35     INFO - TinderboxPrint: I/O write bytes / time<br/>879,710,208 / 1,691,296
[task 2018-07-02T17:15:35.372Z] 17:15:35     INFO - TinderboxPrint: CPU idle<br/>7,672.5 (82.2%)
[task 2018-07-02T17:15:35.373Z] 17:15:35     INFO - TinderboxPrint: CPU iowait<br/>101.8 (1.1%)
[task 2018-07-02T17:15:35.373Z] 17:15:35     INFO - TinderboxPrint: CPU user<br/>1,525.6 (16.3%)
[task 2018-07-02T17:15:35.373Z] 17:15:35     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2018-07-02T17:15:35.375Z] 17:15:35     INFO - verify-emulator - Wall time: 4s; CPU: 5.0%; Read bytes: 548864; Write bytes: 0; Read time: 304; Write time: 0
[task 2018-07-02T17:15:35.376Z] 17:15:35     INFO - install - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2018-07-02T17:15:35.398Z] 17:15:35     INFO - run-tests - Wall time: 2347s; CPU: 17.0%; Read bytes: 114159616; Write bytes: 879710208; Read time: 176640; Write time: 1691296
[task 2018-07-02T17:15:36.078Z] 17:15:36     INFO - Running post-run listener: copy_logs_to_upload_dir
[task 2018-07-02T17:15:36.078Z] 17:15:36     INFO - Copying logs to upload dir...
[task 2018-07-02T17:15:36.079Z] 17:15:36     INFO - mkdir: /builds/worker/workspace/build/upload/logs
[task 2018-07-02T17:15:36.080Z] 17:15:36     INFO - Copying logs to upload dir...
[task 2018-07-02T17:15:36.082Z] 17:15:36  WARNING - returning nonzero exit status 1

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-beta: 1

Platform breakdown:
* android-em-4-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-07-02&endday=2018-07-08&tree=trunk

Comment 6

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 7

[Tiberius Oros[:tiberius_oros]]

New failure log file:
https://treeherder.mozilla.org/logviewer.html#?job_id=196988674&repo=autoland&lineNumber=2625

[task 2018-09-01T01:19:02.157Z] 01:19:02     INFO -  TEST-START | toolkit/components/telemetry/tests/unit/test_TelemetryFlagClear.js
[task 2018-09-01T01:19:05.580Z] 01:19:05     INFO -  TEST-PASS | toolkit/components/telemetry/tests/unit/test_TelemetryFlagClear.js | took 3423ms
[task 2018-09-01T01:19:06.317Z] 01:19:06     INFO -  adb Ignoring attempt to chmod external storage
[task 2018-09-01T01:19:07.151Z] 01:19:07     INFO -  adb Ignoring attempt to chmod external storage
[task 2018-09-01T01:19:07.776Z] 01:19:07     INFO -  adb Ignoring attempt to chmod external storage
[task 2018-09-01T01:19:07.984Z] 01:19:07     INFO -  adb Ignoring attempt to chmod external storage
[task 2018-09-01T01:19:07.985Z] 01:19:07     INFO -  TEST-START | toolkit/components/telemetry/tests/unit/test_TelemetryLateWrites.js
[task 2018-09-01T01:24:07.986Z] 01:24:07  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/components/telemetry/tests/unit/test_TelemetryLateWrites.js | Test timed out
[task 2018-09-01T01:24:07.986Z] 01:24:07     INFO -  TEST-INFO took 300000ms
[task 2018-09-01T01:24:08.194Z] 01:24:08     INFO -  xpcshell return code: -1
[task 2018-09-01T01:24:24.113Z] 01:24:24  WARNING -  TEST-UNEXPECTED-FAIL | Received SIGINT (control-C), so stopped run. (Use --keep-going to keep running tests after killing one with SIGINT)
[task 2018-09-01T01:24:24.114Z] 01:24:24     INFO -  INFO | Result summary:
[task 2018-09-01T01:24:24.115Z] 01:24:24     INFO -  INFO | Passed: 131
[task 2018-09-01T01:24:24.115Z] 01:24:24  WARNING -  INFO | Failed: 1
[task 2018-09-01T01:24:24.116Z] 01:24:24  WARNING -  One or more unittests failed.
[task 2018-09-01T01:24:24.116Z] 01:24:24     INFO -  INFO | Todo: 0
[task 2018-09-01T01:24:24.116Z] 01:24:24     INFO -  INFO | Retried: 0
[task 2018-09-01T01:24:24.117Z] 01:24:24     INFO -  SUITE-END | took 2267s
[task 2018-09-01T01:24:24.151Z] 01:24:24    ERROR - Return code: 1
[task 2018-09-01T01:24:24.151Z] 01:24:24     INFO - TinderboxPrint: xpcshell<br/>131/<em class="testfail">1</em>/0
[task 2018-09-01T01:24:24.152Z] 01:24:24     INFO - ##### xpcshell log ends
[task 2018-09-01T01:24:24.152Z] 01:24:24  WARNING - # TBPL WARNING #
[task 2018-09-01T01:24:24.153Z] 01:24:24  WARNING - setting return code to 1
[task 2018-09-01T01:24:24.153Z] 01:24:24  WARNING - The xpcshell suite: xpcshell ran with return status: WARNING
[task 2018-09-01T01:24:24.153Z] 01:24:24     INFO - Running post-action listener: _package_coverage_data
[task 2018-09-01T01:24:24.153Z] 01:24:24     INFO - Running post-action listener: _resource_record_post_action
[task 2018-09-01T01:24:24.154Z] 01:24:24     INFO - Running post-action listener: process_java_coverage_data
[task 2018-09-01T01:24:24.154Z] 01:24:24     INFO - Running post-action listener: stop_emulator
[task 2018-09-01T01:24:24.163Z] 01:24:24     INFO - Killing every process called emulator64-x86
[task 2018-09-01T01:24:24.163Z] 01:24:24     INFO - Killing pid 910.

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1

Platform breakdown:
* android-em-4-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-08-27&endday=2018-09-02&tree=all

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-beta: 1

Platform breakdown:
* android-em-4-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-09-17&endday=2018-09-23&tree=all

Comment 10

[Intermittent Failures Robot]

1 failures in 2773 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-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-09-24&endday=2018-09-30&tree=all

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1
* mozilla-inbound: 1

Platform breakdown:
* android-em-4-2-x86: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-10-01&endday=2018-10-07&tree=all

Comment 12

[Intermittent Failures Robot]

1 failures in 2759 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-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-10-15&endday=2018-10-21&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:
* try: 1

Platform breakdown:
* android-em-4-2-x86: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1422140&startday=2018-11-19&endday=2018-11-25&tree=all

Comment 14

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup