1510824 - Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/content/tests/browser/browser_datetime_datepicker.js | application timed out after 370 seconds with no output

Status: RESOLVED INCOMPLETE

(Toolkit :: General, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=214410294&repo=try

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

task 2018-11-28T17:19:48.235Z] 17:19:48     INFO - TEST-START | toolkit/content/tests/browser/browser_datetime_datepicker.js
[task 2018-11-28T17:25:58.287Z] 17:25:58     INFO - Buffered messages logged at 17:19:48
[task 2018-11-28T17:25:58.287Z] 17:25:58     INFO - Entering test bound test_datepicker_today
[task 2018-11-28T17:25:58.288Z] 17:25:58     INFO - Buffered messages finished
[task 2018-11-28T17:25:58.288Z] 17:25:58    ERROR - TEST-UNEXPECTED-TIMEOUT | toolkit/content/tests/browser/browser_datetime_datepicker.js | application timed out after 370 seconds with no output
[task 2018-11-28T17:25:58.289Z] 17:25:58    ERROR - Force-terminating active process(es).
[task 2018-11-28T17:25:58.292Z] 17:25:58     INFO - Determining child pids from psutil...
[task 2018-11-28T17:25:58.299Z] 17:25:58     INFO - [9113, 8859, 9134, 8752, 8733]
[task 2018-11-28T17:25:58.303Z] 17:25:58     INFO - ==> process 8624 launched child process 8645
[task 2018-11-28T17:25:58.307Z] 17:25:58     INFO - ==> process 8624 launched child process 8733
[task 2018-11-28T17:25:58.310Z] 17:25:58     INFO - ==> process 8624 launched child process 8752
[task 2018-11-28T17:25:58.312Z] 17:25:58     INFO - ==> process 8624 launched child process 8801
[task 2018-11-28T17:25:58.315Z] 17:25:58     INFO - ==> process 8624 launched child process 8859
[task 2018-11-28T17:25:58.317Z] 17:25:58     INFO - ==> process 8624 launched child process 8868
[task 2018-11-28T17:25:58.319Z] 17:25:58     INFO - ==> process 8624 launched child process 9071
[task 2018-11-28T17:25:58.321Z] 17:25:58     INFO - ==> process 8624 launched child process 9111
[task 2018-11-28T17:25:58.323Z] 17:25:58     INFO - ==> process 8624 launched child process 9113
[task 2018-11-28T17:25:58.325Z] 17:25:58     INFO - ==> process 8624 launched child process 9132
[task 2018-11-28T17:25:58.327Z] 17:25:58     INFO - ==> process 8624 launched child process 9134
[task 2018-11-28T17:25:58.329Z] 17:25:58     INFO - Found child pids: set([8801, 8868, 8645, 9132, 9134, 9071, 8752, 9111, 9113, 8859, 8733])
[task 2018-11-28T17:25:58.331Z] 17:25:58     INFO - Failed to get child procs
[task 2018-11-28T17:25:58.333Z] 17:25:58     INFO - Killing process: 8801
[task 2018-11-28T17:25:58.336Z] 17:25:58     INFO - TEST-INFO | started process screentopng
[task 2018-11-28T17:25:58.621Z] 17:25:58     INFO - TEST-INFO | screentopng: exit 0
[task 2018-11-28T17:25:58.623Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.625Z] 17:25:58     INFO - Killing process: 8868
[task 2018-11-28T17:25:58.626Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.629Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.630Z] 17:25:58     INFO - Killing process: 8645
[task 2018-11-28T17:25:58.631Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.632Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.633Z] 17:25:58     INFO - Killing process: 9132
[task 2018-11-28T17:25:58.633Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.634Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.635Z] 17:25:58     INFO - Killing process: 9134
[task 2018-11-28T17:25:58.635Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.636Z] 17:25:58     INFO - Killing process: 9071
[task 2018-11-28T17:25:58.637Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.638Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.638Z] 17:25:58     INFO - Killing process: 8752
[task 2018-11-28T17:25:58.639Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.640Z] 17:25:58     INFO - Killing process: 9111
[task 2018-11-28T17:25:58.641Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.641Z] 17:25:58     INFO - Can't trigger Breakpad, process no longer exists
[task 2018-11-28T17:25:58.642Z] 17:25:58     INFO - Killing process: 9113
[task 2018-11-28T17:25:58.643Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.644Z] 17:25:58     INFO - Killing process: 8859
[task 2018-11-28T17:25:58.645Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.645Z] 17:25:58     INFO - Killing process: 8733
[task 2018-11-28T17:25:58.646Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.647Z] 17:25:58     INFO - Killing process: 8624
[task 2018-11-28T17:25:58.647Z] 17:25:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-11-28T17:25:58.847Z] 17:25:58     INFO - psutil found pid 8624 dead
[task 2018-11-28T17:25:58.883Z] 17:25:58  WARNING - runtests.py | Failed to get app exit code - running/crashed?

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:
* try: 1

Platform breakdown:
* linux64-devedition: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* linux64-ccov: 1

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

Comment 3

[Firefox Bug Husbandry Bot]

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

Comment 4

[Daniel Varga [:dvarga]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=236935906&repo=autoland&lineNumber=7934

[task 2019-03-29T16:38:47.115Z] 16:38:47 INFO - TEST-START | toolkit/content/tests/browser/browser_datetime_datepicker.js
[task 2019-03-29T16:44:57.167Z] 16:44:57 INFO - Buffered messages logged at 16:38:47
[task 2019-03-29T16:44:57.168Z] 16:44:57 INFO - Entering test bound test_datepicker_today
[task 2019-03-29T16:44:57.169Z] 16:44:57 INFO - Buffered messages finished
[task 2019-03-29T16:44:57.169Z] 16:44:57 ERROR - TEST-UNEXPECTED-TIMEOUT | toolkit/content/tests/browser/browser_datetime_datepicker.js | application timed out after 370 seconds with no output
[task 2019-03-29T16:44:57.170Z] 16:44:57 ERROR - Force-terminating active process(es).
[task 2019-03-29T16:44:57.171Z] 16:44:57 INFO - Determining child pids from psutil...
[task 2019-03-29T16:44:57.180Z] 16:44:57 INFO - [10848, 10777, 10793, 10821, 11069, 10659, 10712, 10565, 10727, 11093]
[task 2019-03-29T16:44:57.180Z] 16:44:57 INFO - ==> process 10512 launched child process 10537
[task 2019-03-29T16:44:57.180Z] 16:44:57 INFO - ==> process 10512 launched child process 10565
[task 2019-03-29T16:44:57.182Z] 16:44:57 INFO - ==> process 10512 launched child process 10588
[task 2019-03-29T16:44:57.183Z] 16:44:57 INFO - ==> process 10512 launched child process 10634
[task 2019-03-29T16:44:57.184Z] 16:44:57 INFO - ==> process 10512 launched child process 10659
[task 2019-03-29T16:44:57.185Z] 16:44:57 INFO - ==> process 10512 launched child process 10712
[task 2019-03-29T16:44:57.186Z] 16:44:57 INFO - ==> process 10512 launched child process 10727
[task 2019-03-29T16:44:57.186Z] 16:44:57 INFO - ==> process 10512 launched child process 10777
[task 2019-03-29T16:44:57.187Z] 16:44:57 INFO - ==> process 10512 launched child process 10793
[task 2019-03-29T16:44:57.188Z] 16:44:57 INFO - ==> process 10512 launched child process 10821
[task 2019-03-29T16:44:57.188Z] 16:44:57 INFO - ==> process 10512 launched child process 10848
[task 2019-03-29T16:44:57.189Z] 16:44:57 INFO - ==> process 10512 launched child process 11053
[task 2019-03-29T16:44:57.190Z] 16:44:57 INFO - ==> process 10512 launched child process 11066
[task 2019-03-29T16:44:57.190Z] 16:44:57 INFO - ==> process 10512 launched child process 11069
[task 2019-03-29T16:44:57.191Z] 16:44:57 INFO - ==> process 10512 launched child process 11090
[task 2019-03-29T16:44:57.191Z] 16:44:57 INFO - ==> process 10512 launched child process 11093
[task 2019-03-29T16:44:57.193Z] 16:44:57 INFO - Found child pids: set([10848, 10659, 10821, 10727, 10793, 10634, 11053, 11090, 11093, 10537, 10712, 10777, 11066, 10588, 11069, 10565])
[task 2019-03-29T16:44:57.194Z] 16:44:57 INFO - Failed to get child procs
[task 2019-03-29T16:44:57.195Z] 16:44:57 INFO - Killing process: 10848
[task 2019-03-29T16:44:57.196Z] 16:44:57 INFO - TEST-INFO | started process screentopng
[task 2019-03-29T16:44:57.495Z] 16:44:57 INFO - TEST-INFO | screentopng: exit 0

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux64-shippable: 1

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

Comment 6

[Firefox Bug Husbandry Bot]

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