1623273 - Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/update/tests/browser/browser_aboutPrefs_fc_patch_partialBadSize_completeBadSize.js | application timed out after 370 seconds with no output

Status: RESOLVED INCOMPLETE

(Toolkit :: Application Update, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: dvarga [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=293625496&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/G-LjWlRBSSy_NcLSHAB0CA/runs/0/artifacts/public/logs/live_backing.log

---

[task 2020-03-18T06:25:49.929Z] 06:25:49     INFO - TEST-PASS | toolkit/mozapps/update/tests/browser/browser_aboutPrefs_fc_patch_partialBadSize_completeBadSize.js | The patch property internalResult value should equal 2147549183 - 
[task 2020-03-18T06:25:49.929Z] 06:25:49     INFO - TEST-PASS | toolkit/mozapps/update/tests/browser/browser_aboutPrefs_fc_patch_partialBadSize_completeBadSize.js | The patch property bitsResult value should equal 2147549183 - 
[task 2020-03-18T06:25:49.929Z] 06:25:49     INFO - Buffered messages finished
[task 2020-03-18T06:25:49.930Z] 06:25:49    ERROR - TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/update/tests/browser/browser_aboutPrefs_fc_patch_partialBadSize_completeBadSize.js | application timed out after 370 seconds with no output
[task 2020-03-18T06:25:49.930Z] 06:25:49    ERROR - Force-terminating active process(es).
[task 2020-03-18T06:25:49.930Z] 06:25:49     INFO - Determining child pids from psutil...
[task 2020-03-18T06:25:49.932Z] 06:25:49     INFO - [9500]
[task 2020-03-18T06:25:49.932Z] 06:25:49     INFO - ==> process 9500 launched child process 9484 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.0.3095498\1641470179" -parentBuildID 20200318041411 -prefsHandle 2248 -prefMapHandle 2236 -prefsLen 1 -prefMapSize 229555 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 2336 gpu)
[task 2020-03-18T06:25:49.933Z] 06:25:49     INFO - ==> process 9500 launched child process 4260 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.6.51925059\1771160677" -childID 1 -isForBrowser -prefsHandle 2920 -prefMapHandle 2916 -prefsLen 1391 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 2928 tab)
[task 2020-03-18T06:25:49.933Z] 06:25:49     INFO - ==> process 9500 launched child process 7484 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.13.2011766878\883246479" -childID 2 -isForBrowser -prefsHandle 3020 -prefMapHandle 2916 -prefsLen 1857 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3044 tab)
[task 2020-03-18T06:25:49.934Z] 06:25:49     INFO - ==> process 9500 launched child process 2404 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.20.275706659\2106650836" -childID 3 -isForBrowser -prefsHandle 5504 -prefMapHandle 5500 -prefsLen 1857 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 5516 tab)
[task 2020-03-18T06:25:49.934Z] 06:25:49     INFO - ==> process 9500 launched child process 4204 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.27.1151483905\58322627" -childID 4 -isForBrowser -prefsHandle 2076 -prefMapHandle 3448 -prefsLen 11502 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 2080 tab)
[task 2020-03-18T06:25:49.934Z] 06:25:49     INFO - ==> process 9500 launched child process 5860 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.34.671779640\886268193" -childID 5 -isForBrowser -prefsHandle 3344 -prefMapHandle 5380 -prefsLen 12377 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3196 tab)
[task 2020-03-18T06:25:49.935Z] 06:25:49     INFO - ==> process 9500 launched child process 10524 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.41.1963447104\509726491" -childID 6 -isForBrowser -prefsHandle 3740 -prefMapHandle 4784 -prefsLen 12432 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3536 tab)
[task 2020-03-18T06:25:49.935Z] 06:25:49     INFO - ==> process 9500 launched child process 10984 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.48.2082525816\1396984925" -childID 7 -isForBrowser -prefsHandle 4980 -prefMapHandle 3792 -prefsLen 12515 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3776 tab)
[task 2020-03-18T06:25:49.936Z] 06:25:49     INFO - ==> process 9500 launched child process 6228 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.55.459826514\1494464435" -childID 8 -isForBrowser -prefsHandle 3596 -prefMapHandle 3712 -prefsLen 12513 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3852 tab)
[task 2020-03-18T06:25:49.936Z] 06:25:49     INFO - ==> process 9500 launched child process 5884 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.62.729136444\1490452404" -childID 9 -isForBrowser -prefsHandle 5128 -prefMapHandle 5100 -prefsLen 12537 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 3636 tab)
[task 2020-03-18T06:25:49.937Z] 06:25:49     INFO - ==> process 9500 launched child process 11004 ("Z:\task_1584510957\build\application\firefox\firefox.exe" -contentproc --channel="9500.69.1833331748\1581627780" -childID 10 -isForBrowser -prefsHandle 3248 -prefMapHandle 4384 -prefsLen 12536 -prefMapSize 229555 -parentBuildID 20200318041411 -appdir "Z:\task_1584510957\build\application\firefox\browser" - 9500 "\\.\pipe\gecko-crash-server-pipe.9500" 1572 tab)
[task 2020-03-18T06:25:49.937Z] 06:25:49     INFO - Found child pids: set([2404, 5884, 10984, 4204, 11004, 9484, 6228, 5860, 10524, 7484, 4260, 9500])
[task 2020-03-18T06:25:49.937Z] 06:25:49     INFO - Killing process: 2404
[task 2020-03-18T06:25:49.937Z] 06:25:49     INFO - TEST-INFO | started process screenshot
[task 2020-03-18T06:25:50.020Z] 06:25:50     INFO - TEST-INFO | screenshot: exit 0
[task 2020-03-18T06:25:50.089Z] 06:25:50     INFO - Killing process: 5884
[task 2020-03-18T06:25:50.089Z] 06:25:50     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-03-18T06:25:50.154Z] 06:25:50     INFO - Killing process: 10984
[task 2020-03-18T06:25:50.154Z] 06:25:50     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-03-18T06:25:50.218Z] 06:25:50     INFO - Killing process: 4204
[task 2020-03-18T06:25:50.218Z] 06:25:50     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-03-18T06:25:50.297Z] 06:25:50     INFO - Killing process: 11004
[task 2020-03-18T06:25:50.297Z] 06:25:50     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-03-18T06:25:50.355Z] 06:25:50     INFO - Killing process: 9484
[task 2020-03-18T06:25:50.355Z] 06:25:50     INFO - Not taking screenshot here: see the one that was previously logged

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1623273&startday=2020-03-16&endday=2020-03-22&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64: 1

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-central: 1

Platform breakdown:

• windows10-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1623273&startday=2020-04-27&endday=2020-05-03&tree=all

Comment 4

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 5

[Razvan Maries]

New occurrence: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=304020729&repo=autoland&lineNumber=6156

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• windows10-64: 2

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

Comment 7

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.