Closed
Bug 1786110
Opened 3 years ago
Closed 2 years ago
Intermittent damp | toolbox/browser-toolbox.js: Error: evaluation failed
Categories
(Testing :: Talos, defect, P5)
Testing
Talos
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=387927068&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OcLOVtTBR92ECwaiOJiF3A/runs/0/artifacts/public/logs/live_backing.log
[task 2022-08-19T23:38:14.560Z] 23:38:14 INFO - PID 2918 | Close toolbox on 'custom.netmonitor'
[task 2022-08-19T23:38:15.595Z] 23:38:15 INFO - PID 2918 | Garbage collect
[task 2022-08-19T23:38:15.923Z] 23:38:15 INFO - PID 2918 | netmonitor/custom.js took 6846ms.
[task 2022-08-19T23:38:15.924Z] 23:38:15 INFO - PID 2918 | Loading test 'toolbox/panels-in-background.js'
[task 2022-08-19T23:38:15.924Z] 23:38:15 INFO - PID 2918 | Executing test 'toolbox/panels-in-background.js'
[task 2022-08-19T23:38:15.934Z] 23:38:15 INFO - PID 2918 | Wait for a pageshow event for browsing context 40
[task 2022-08-19T23:38:16.120Z] 23:38:16 INFO - PID 2918 | Received pageshow event for 40
[task 2022-08-19T23:38:16.318Z] 23:38:16 INFO - PID 2918 | Open toolbox on 'webconsole'
[task 2022-08-19T23:38:16.323Z] 23:38:16 INFO - PID 2918 | Open toolbox - Call showToolboxForTab
[task 2022-08-19T23:38:16.326Z] 23:38:16 INFO - PID 2918 | Open toolbox - Wait for "toolbox-created"
[task 2022-08-19T23:38:16.502Z] 23:38:16 INFO - PID 2918 | Open toolbox - Wait for showToolbox to resolve
[task 2022-08-19T23:38:17.084Z] 23:38:17 INFO - PID 2918 | Reload page on 'panelsInBackground'
[task 2022-08-19T23:38:17.084Z] 23:38:17 INFO - PID 2918 | Wait for a pageshow event for browsing context 40
[task 2022-08-19T23:38:17.430Z] 23:38:17 INFO - PID 2918 | Received pageshow event for 40
[task 2022-08-19T23:38:17.430Z] 23:38:17 INFO - PID 2918 | Wait for pending paints on 'panelsInBackground.reload'
[task 2022-08-19T23:38:17.430Z] 23:38:17 INFO - PID 2918 | 'panelsInBackground.reload.settle.DAMP' took 0.04288500000257045ms.
[task 2022-08-19T23:38:19.132Z] 23:38:19 INFO - PID 2918 | Garbage collect
[task 2022-08-19T23:38:19.562Z] 23:38:19 INFO - PID 2918 | toolbox/panels-in-background.js took 3639ms.
[task 2022-08-19T23:38:19.562Z] 23:38:19 INFO - PID 2918 | Loading test 'toolbox/screenshot.js'
[task 2022-08-19T23:38:19.563Z] 23:38:19 INFO - PID 2918 | Executing test 'toolbox/screenshot.js'
[task 2022-08-19T23:38:19.571Z] 23:38:19 INFO - PID 2918 | Wait for a pageshow event for browsing context 45
[task 2022-08-19T23:38:19.832Z] 23:38:19 INFO - PID 2918 | console.warn: LoginHelper(Content): "Couldn't parse specified uri httpdisabled://www.bild.de/suche.bild.html?type=article&query=&resultsStart=0&resultsPerPage=0 with error NS_ERROR_FAILURE"
[task 2022-08-19T23:38:19.872Z] 23:38:19 INFO - PID 2918 | console.warn: LoginHelper(Content): "Couldn't parse specified uri httpdisabled://tarifvergleich.bild.de/strom/strom.php?phpurl=stromrechner.php with error NS_ERROR_FAILURE"
[task 2022-08-19T23:38:20.015Z] 23:38:20 INFO - PID 2918 | Received pageshow event for 45
[task 2022-08-19T23:38:20.116Z] 23:38:20 INFO - PID 2918 | Open toolbox on 'webconsole'
[task 2022-08-19T23:38:20.117Z] 23:38:20 INFO - PID 2918 | Open toolbox - Call showToolboxForTab
[task 2022-08-19T23:38:20.117Z] 23:38:20 INFO - PID 2918 | Open toolbox - Wait for "toolbox-created"
[task 2022-08-19T23:38:20.124Z] 23:38:20 INFO - PID 2918 | Open toolbox - Wait for showToolbox to resolve
[task 2022-08-19T23:38:38.764Z] 23:38:38 INFO - PID 2918 | [Parent 2918, MediaDecoderStateMachine #1] WARNING: 7fbc02a10940 OpenCubeb() failed to init cubeb: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:281
[task 2022-08-19T23:38:38.764Z] 23:38:38 INFO - PID 2918 | [Parent 2918, MediaDecoderStateMachine #1] WARNING: Decoder=7fbd25dd7f00 [OnMediaSinkAudioError]: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp:3979
[task 2022-08-19T23:38:38.764Z] 23:38:38 INFO - PID 2918 | [Parent 2918, MediaDecoderStateMachine #1] WARNING: Decoder=7fbd25dd7f00 Decode error: NS_ERROR_DOM_MEDIA_MEDIASINK_ERR (0x806e000b) - OnMediaSinkAudioError: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachineBase.cpp:151
[task 2022-08-19T23:38:38.937Z] 23:38:38 INFO - PID 2918 | console.warn: "IGNORED REDUX ACTION:" "AUTOCOMPLETE_CLEAR"
[task 2022-08-19T23:38:38.941Z] 23:38:38 INFO - PID 2918 | Garbage collect
[task 2022-08-19T23:38:39.374Z] 23:38:39 INFO - PID 2918 | toolbox/screenshot.js took 19812ms.
[task 2022-08-19T23:38:39.374Z] 23:38:39 INFO - PID 2918 | Loading test 'toolbox/browser-toolbox.js'
[task 2022-08-19T23:38:39.375Z] 23:38:39 INFO - PID 2918 | Executing test 'toolbox/browser-toolbox.js'
[task 2022-08-19T23:38:39.386Z] 23:38:39 INFO - PID 2918 | Wait for a pageshow event for browsing context 48
[task 2022-08-19T23:38:39.412Z] 23:38:39 INFO - PID 2918 | Received pageshow event for 48
[task 2022-08-19T23:38:39.529Z] 23:38:39 INFO - PID 2918 | DevTools Server for Browser Toolbox listening on port: 37645
[task 2022-08-19T23:38:39.535Z] 23:38:39 INFO - PID 2918 | Starting Browser Toolbox /home/cltbld/tasks/task_166095146821506/build/application/firefox/firefox-bin -no-remote -foreground -profile /tmp/tmp768qfz77/profile/chrome_debugger_profile -chrome chrome://devtools/content/framework/browser-toolbox/window.html
[task 2022-08-19T23:39:10.382Z] 23:39:10 INFO - PID 2918 | 6301> Wait for debugger to initialize
[task 2022-08-19T23:39:11.066Z] 23:39:11 INFO - PID 2918 | 6301> Wait for tab source in the content process
[task 2022-08-19T23:39:13.653Z] 23:39:13 INFO - PID 2918 | 6301> JavaScript error: debugger eval code, line 22: Error: timeout on () => findSource(dbg, testUrl)
[task 2022-08-19T23:39:13.653Z] 23:39:13 INFO - PID 2918 | 6301>
[task 2022-08-19T23:39:13.654Z] 23:39:13 INFO - PID 2918 | TEST-UNEXPECTED-FAIL | damp | toolbox/browser-toolbox.js: Error: evaluation failed
[task 2022-08-19T23:39:13.661Z] 23:39:13 INFO - PID 2918 | [DampLoad helper] Unregister DampLoad actors
[task 2022-08-19T23:39:13.662Z] 23:39:13 INFO - PID 2918 | evaluateInBrowserToolbox@resource://damp-test/content/tests/toolbox/browser-toolbox.js:187:11
[task 2022-08-19T23:39:13.662Z] 23:39:13 INFO - PID 2918 | async*module.exports@resource://damp-test/content/tests/toolbox/browser-toolbox.js:87:9
[task 2022-08-19T23:39:13.662Z] 23:39:13 INFO - PID 2918 |
[task 2022-08-19T23:39:13.664Z] 23:39:13 INFO - Terminating psutil.Process(pid=2918, name='firefox-bin', started='23:36:08')
[task 2022-08-19T23:39:13.680Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:13.683Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:13.683Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:13.683Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:13.683Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:13.683Z] 23:39:13 INFO - PID 2918 | Exiting due to channel error.
[task 2022-08-19T23:39:14.240Z] 23:39:14 INFO - mozcrash checking /tmp/tmp768qfz77/profile/minidumps for minidumps...
[task 2022-08-19T23:39:14.241Z] 23:39:14 INFO - rmtree() failed for "('/tmp/tmp768qfz77',)". Reason: Directory not empty (39). Retrying...
[task 2022-08-19T23:39:14.241Z] 23:39:14 INFO - TEST-UNEXPECTED-ERROR | damp | unexpected error
[task 2022-08-19T23:39:14.242Z] 23:39:14 ERROR - Traceback (most recent call last):
[task 2022-08-19T23:39:14.243Z] 23:39:14 INFO - File "/home/cltbld/tasks/task_166095146821506/build/tests/talos/talos/run_tests.py", line 363, in run_tests
[task 2022-08-19T23:39:14.243Z] 23:39:14 INFO - talos_results.add(mytest.runTest(browser_config, test))
[task 2022-08-19T23:39:14.244Z] 23:39:14 INFO - File "/home/cltbld/tasks/task_166095146821506/build/tests/talos/talos/ttest.py", line 65, in runTest
[task 2022-08-19T23:39:14.245Z] 23:39:14 INFO - return self._runTest(browser_config, test_config, setup)
[task 2022-08-19T23:39:14.245Z] 23:39:14 INFO - File "/home/cltbld/tasks/task_166095146821506/build/tests/talos/talos/ttest.py", line 209, in _runTest
[task 2022-08-19T23:39:14.246Z] 23:39:14 INFO - debugger_args=browser_config["debugger_args"],
[task 2022-08-19T23:39:14.247Z] 23:39:14 INFO - File "/home/cltbld/tasks/task_166095146821506/build/tests/talos/talos/talos_process.py", line 191, in run_browser
[task 2022-08-19T23:39:14.247Z] 23:39:14 INFO - raise TalosError("unexpected error")
[task 2022-08-19T23:39:14.248Z] 23:39:14 INFO - talos.utils.TalosError: unexpected error
[task 2022-08-19T23:39:14.248Z] 23:39:14 INFO - TEST-INFO took 185941ms
[task 2022-08-19T23:39:14.249Z] 23:39:14 INFO - SUITE-END | took 185s
[task 2022-08-19T23:39:14.754Z] 23:39:14 ERROR - Return code: 2
[task 2022-08-19T23:39:14.754Z] 23:39:14 WARNING - setting return code to 2
[task 2022-08-19T23:39:14.755Z] 23:39:14 ERROR - # TBPL FAILURE #
[task 2022-08-19T23:39:14.755Z] 23:39:14 INFO - Running post-action listener: _package_coverage_data
[task 2022-08-19T23:39:14.755Z] 23:39:14 INFO - Running post-action listener: _resource_record_post_action
[task 2022-08-19T23:39:14.756Z] 23:39:14 INFO - Running post-action listener: process_java_coverage_data
[task 2022-08-19T23:39:14.756Z] 23:39:14 INFO - [mozharness: 2022-08-19 23:39:14.756119Z] Finished run-tests step (success)
[task 2022-08-19T23:39:14.756Z] 23:39:14 INFO - Running post-run listener: _resource_record_post_run
[task 2022-08-19T23:39:14.807Z] 23:39:14 INFO - Total resource usage - Wall time: 196s; CPU: 5%; Read bytes: 126517248; Write bytes: 2208899072; Read time: 860; Write time: 32840
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: CPU usage<br/>5.3%
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: I/O read bytes / time<br/>126,517,248 / 860
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: I/O write bytes / time<br/>2,208,899,072 / 32,840
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: CPU idle<br/>1,329.2 (84.8%)
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: CPU iowait<br/>155.5 (9.9%)
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: CPU user<br/>69.6 (4.4%)
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2022-08-19T23:39:14.808Z] 23:39:14 INFO - install - Wall time: 10s; CPU: 13%; Read bytes: 483328; Write bytes: 1038573568; Read time: 224; Write time: 19420
[task 2022-08-19T23:39:14.810Z] 23:39:14 INFO - run-tests - Wall time: 187s; CPU: 5%; Read bytes: 125493248; Write bytes: 1169727488; Read time: 636; Write time: 13412
[task 2022-08-19T23:39:14.846Z] 23:39:14 WARNING - returning nonzero exit status 2
[taskcluster 2022-08-19T23:39:14.869Z] Exit Code: 2
[taskcluster 2022-08-19T23:39:14.869Z] User Time: 1m36.409612s
[taskcluster 2022-08-19T23:39:14.869Z] Kernel Time: 15.090835s
[taskcluster 2022-08-19T23:39:14.869Z] Wall Time: 3m58.953742677s
[taskcluster 2022-08-19T23:39:14.869Z] Result: FAILED
[taskcluster 2022-08-19T23:39:14.869Z] === Task Finished ===
[taskcluster 2022-08-19T23:39:14.869Z] Task Duration: 3m58.956512505s
[taskcluster 2022-08-19T23:39:14.938Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2023-08-19T22:11:26.511Z
[taskcluster 2022-08-19T23:39:15.235Z] Uploading artifact public/test_info/damp-other_errorsummary.log from file build/blobber_upload_dir/damp-other_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2023-08-19T22:11:26.511Z
[taskcluster 2022-08-19T23:39:15.398Z] Uploading artifact public/test_info/damp-other_raw.log from file build/blobber_upload_dir/damp-other_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2023-08-19T22:11:26.511Z
[taskcluster 2022-08-19T23:39:15.492Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2023-08-19T22:11:26.511Z
[taskcluster 2022-08-19T23:39:15.649Z] Uploading redirect artifact public/logs/live.log to URL https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OcLOVtTBR92ECwaiOJiF3A/runs/0/artifacts/public%2Flogs%2Flive_backing.log with mime type "text/plain; charset=utf-8" and expiry 2023-08-19T22:11:26.511Z
[taskcluster:error] exit status 2
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
|
Reporter | |
Comment 4•2 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=392130283&repo=mozilla-beta
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 6•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE
|
|
Reporter | |
Comment 7•2 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=416506487&repo=autoland
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 9•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•