Intermittent twinopen | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
Categories
(Testing :: Talos, defect, P5)
Tracking
(Not tracked)
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, regression)
Filed by: nerli [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=248931894&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/dSR7BouOT9OaBk8qATfVmA/runs/0/artifacts/public/logs/live_backing.log
11:33:39 INFO - TEST-INFO | started process 1581 (/Users/cltbld/tasks/task_1559129417/build/application/Firefox Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yc/wmg_mdfn04n0_7k9lm7msbs4000017/T/tmpMw0wxC/profile)
11:33:45 INFO - PID 1581 | Cycle 1(1): loaded ext+twinopen:twinopen.html (next: ext+twinopen:twinopen.html)
11:33:47 INFO - PID 1581 | Cycle 1(2): loaded ext+twinopen:twinopen.html (next: ext+twinopen:twinopen.html)
11:33:49 INFO - PID 1581 | Cycle 1(3): loaded ext+twinopen:twinopen.html (next: ext+twinopen:twinopen.html)
11:33:51 INFO - PID 1581 | Cycle 1(4): loaded ext+twinopen:twinopen.html (next: ext+twinopen:twinopen.html)
11:33:53 INFO - PID 1581 | Cycle 1(5): loaded ext+twinopen:twinopen.html (next: ext+twinopen:twinopen.html)
11:33:55 INFO - PID 1581 | 2019-05-29 11:33:55.649 firefox[1581:12255] -[NSTaggedPointerString enumerateKeysAndObjectsUsingBlock:]: unrecognized selector sent to instance 0xe5e5e5e5e5e5e5e5
11:33:56 INFO - PID 1581 | Exiting due to channel error.
11:33:56 INFO - PID 1581 | Exiting due to channel error.
11:33:56 INFO - PID 1581 | Exiting due to channel error.
11:33:56 INFO - Terminating psutil.Process(pid=1581, name='firefox', started='11:33:39')
11:33:56 INFO - TEST-INFO | 1581: exit 1
11:33:56 INFO - TEST-UNEXPECTED-ERROR | twinopen | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
11:33:56 ERROR - Traceback (most recent call last):
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/run_tests.py", line 300, in run_tests
11:33:56 INFO - talos_results.add(mytest.runTest(browser_config, test))
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/ttest.py", line 64, in runTest
11:33:56 INFO - return self._runTest(browser_config, test_config, setup)
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/ttest.py", line 278, in _runTest
11:33:56 INFO - else None)
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/results.py", line 95, in add
11:33:56 INFO - global_counters=self.global_counters
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/results.py", line 326, in init
11:33:56 INFO - self.parse()
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/results.py", line 353, in parse
11:33:56 INFO - % self.report_tokens)
11:33:56 INFO - File "/Users/cltbld/tasks/task_1559129417/build/tests/talos/talos/results.py", line 337, in error
11:33:56 INFO - raise utils.TalosError(message)
11:33:56 INFO - TalosError: Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
11:33:56 INFO - TEST-INFO took 21007ms
11:33:56 INFO - SUITE-END | took 145s
11:33:56 ERROR - Return code: 2
11:33:56 WARNING - setting return code to 2
11:33:56 ERROR - # TBPL FAILURE #
11:33:56 INFO - Running post-action listener: _package_coverage_data
11:33:56 INFO - Running post-action listener: _resource_record_post_action
11:33:56 INFO - Running post-action listener: process_java_coverage_data
11:33:56 INFO - [mozharness: 2019-05-29 11:33:56.553581Z] Finished run-tests step (success)
11:33:56 INFO - Running post-run listener: _resource_record_post_run
11:33:56 INFO - Total resource usage - Wall time: 166s; CPU: 33.0%; Read bytes: 72867840; Write bytes: 497075712; Read time: 562; Write time: 1705
11:33:56 INFO - TinderboxPrint: CPU usage<br/>33.4%
11:33:56 INFO - TinderboxPrint: I/O read bytes / time<br/>72,867,840 / 562
11:33:56 INFO - TinderboxPrint: I/O write bytes / time<br/>497,075,712 / 1,705
11:33:56 INFO - TinderboxPrint: CPU idle<br/>441.9 (66.6%)
11:33:56 INFO - TinderboxPrint: CPU system<br/>40.7 (6.1%)
11:33:56 INFO - TinderboxPrint: CPU user<br/>180.4 (27.2%)
11:33:56 INFO - TinderboxPrint: Swap in / out<br/>641,347,584 / 0
11:33:56 INFO - install - Wall time: 19s; CPU: 39.0%; Read bytes: 243013120; Write bytes: 238546944; Read time: 14076; Write time: 435
11:33:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
11:33:56 INFO - run-tests - Wall time: 147s; CPU: 33.0%; Read bytes: 69812224; Write bytes: 236824064; Read time: 531; Write time: 1220
11:33:56 WARNING - returning nonzero exit status 2
[taskcluster 2019-05-29T11:33:56.726Z] Exit Code: 2
[taskcluster 2019-05-29T11:33:56.726Z] User Time: 2m35.787508s
[taskcluster 2019-05-29T11:33:56.726Z] Kernel Time: 43.283147s
[taskcluster 2019-05-29T11:33:56.726Z] Wall Time: 3m36.679999431s
[taskcluster 2019-05-29T11:33:56.726Z] Result: FAILED
[taskcluster 2019-05-29T11:33:56.726Z] === Task Finished ===
[taskcluster 2019-05-29T11:33:56.726Z] Task Duration: 3m36.680297896s
[taskcluster 2019-05-29T11:33:57.378Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2020-05-28T09:51:36.178Z
[taskcluster 2019-05-29T11:33:57.890Z] Uploading artifact public/test_info/other_errorsummary.log from file build/blobber_upload_dir/other_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2020-05-28T09:51:36.178Z
[taskcluster 2019-05-29T11:33:58.262Z] Uploading artifact public/test_info/other_raw.log from file build/blobber_upload_dir/other_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2020-05-28T09:51:36.178Z
[taskcluster 2019-05-29T11:33:58.661Z] 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 2020-05-28T09:51:36.178Z
[taskcluster:error] exit status 2
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 5•6 years ago
|
||
Comment 6•6 years ago
|
||
New instance:
https://treeherder.mozilla.org/#/jobs?repo=try&selectedJob=276756239&revision=04fae348cd1e2ac74edd6d0fa2852dd3238b4a35
Comment hidden (Intermittent Failures Robot) |
Comment 8•6 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 9•5 years ago
|
||
New occurrence: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=283594650&repo=try&lineNumber=1886
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 12•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Updated•5 years ago
|
Description
•