Closed Bug 1605958 Opened 4 years ago Closed 4 years ago

Perma TEST-UNEXPECTED-FAIL | browser/components/extensions/test/xpcshell/test_ext_urlbar.js | xpcshell return code: 0 | test_setOpenViewOnFocus - Open-view-on-focus mode should be enabled by default - false == when Gecko 73 merges to Beta on 2020-01-06

Categories

(Firefox :: Address Bar, defect)

defect
Not set
normal
Points:
2

Tracking

()

VERIFIED FIXED
Firefox 73
Iteration:
73.2 - Dec 16 - Jan 5
Tracking Status
firefox-esr68 --- unaffected
firefox71 --- unaffected
firefox72 --- unaffected
firefox73 + verified

People

(Reporter: CosminS, Assigned: bugzilla)

References

(Regression)

Details

(Keywords: regression)

Attachments

(1 file)

[Tracking Requested - why for this release]:
Central as beta-simulation: https://treeherder.mozilla.org/#/jobs?repo=try&selectedJob=282591253&resultStatus=success%2Ctestfailed%2Cbusted%2Cexception%2Cretry%2Cusercancel%2Crunnable&revision=11f75cc87882200a3e5d6159f83608b33760137b&searchStr=xpc&group_state=expanded

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

[task 2019-12-25T13:11:09.759Z] 13:11:09 INFO - TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_urlbar.js | test_nonPrivateBrowsing - [test_nonPrivateBrowsing : 1412] 1 == 1
[task 2019-12-25T13:11:09.759Z] 13:11:09 INFO - PID 16292 | ###!!! [Child][MessageChannel] Error: (msgtype=0x370132,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost
[task 2019-12-25T13:11:09.759Z] 13:11:09 INFO - PID 16292 | [Child 16912, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2452
[task 2019-12-25T13:11:09.759Z] 13:11:09 INFO - (xpcshell/head.js) | test run_next_test 22 pending (2)
[task 2019-12-25T13:11:09.759Z] 13:11:09 INFO - (xpcshell/head.js) | test test_nonPrivateBrowsing finished (2)
[task 2019-12-25T13:11:09.760Z] 13:11:09 INFO - xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_urlbar.js | Starting test_setOpenViewOnFocus
[task 2019-12-25T13:11:09.760Z] 13:11:09 INFO - (xpcshell/head.js) | test test_setOpenViewOnFocus pending (2)
[task 2019-12-25T13:11:09.760Z] 13:11:09 WARNING - TEST-UNEXPECTED-FAIL | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_urlbar.js | test_setOpenViewOnFocus - [test_setOpenViewOnFocus : 1421] Open-view-on-focus mode should be enabled by default - false == true
[task 2019-12-25T13:11:09.760Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/tests/browser/components/extensions/test/xpcshell/test_ext_urlbar.js:test_setOpenViewOnFocus:1421
[task 2019-12-25T13:11:09.760Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:run_next_test/_run_next_test/<:1567
[task 2019-12-25T13:11:09.760Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_run_next_test:1567
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:run:735
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_do_main:246
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_execute_test:573
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - -e:null:1
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - exiting test
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - (xpcshell/head.js) | test run_next_test 22 finished (2)
[task 2019-12-25T13:11:09.761Z] 13:11:09 INFO - Unexpected exception NS_ERROR_ABORT:
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - _abort_failed_test@/builds/worker/workspace/build/tests/xpcshell/head.js:791:20
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - do_report_result@/builds/worker/workspace/build/tests/xpcshell/head.js:892:5
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - Assert<@/builds/worker/workspace/build/tests/xpcshell/head.js:67:21
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - proto.report@resource://testing-common/Assert.jsm:233:10
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - equal@resource://testing-common/Assert.jsm:275:8
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - test_setOpenViewOnFocus@/builds/worker/workspace/build/tests/xpcshell/tests/browser/components/extensions/test/xpcshell/test_ext_urlbar.js:1421:10
[task 2019-12-25T13:11:09.762Z] 13:11:09 INFO - run_next_test/_run_next_test/<@/builds/worker/workspace/build/tests/xpcshell/head.js:1567:22
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - _run_next_test@/builds/worker/workspace/build/tests/xpcshell/head.js:1567:38
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - run@/builds/worker/workspace/build/tests/xpcshell/head.js:735:9
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - _do_main@/builds/worker/workspace/build/tests/xpcshell/head.js:246:6
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - _execute_test@/builds/worker/workspace/build/tests/xpcshell/head.js:573:5
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - @-e:1:1
[task 2019-12-25T13:11:09.763Z] 13:11:09 INFO - exiting test
[task 2019-12-25T13:11:09.764Z] 13:11:09 INFO - PID 16292 | 1577279467871 addons.manager DEBUG before shutdown
[task 2019-12-25T13:11:09.764Z] 13:11:09 INFO - PID 16292 | 1577279467872 addons.manager DEBUG shutdown
[task 2019-12-25T13:11:09.764Z] 13:11:09 INFO - PID 16292 | 1577279467875 addons.manager DEBUG Calling shutdown blocker for XPIProvider
[task 2019-12-25T13:11:09.764Z] 13:11:09 INFO - PID 16292 | 1577279467875 addons.xpi DEBUG shutdown
[task 2019-12-25T13:11:09.764Z] 13:11:09 INFO - PID 16292 | 1577279467876 addons.xpi-utils DEBUG shutdown
[task 2019-12-25T13:11:09.765Z] 13:11:09 INFO - PID 16292 | 1577279467876 addons.manager DEBUG Calling shutdown blocker for GMPProvider
[task 2019-12-25T13:11:09.765Z] 13:11:09 INFO - PID 16292 | 1577279467878 addons.manager DEBUG Calling shutdown blocker for PluginProvider
[task 2019-12-25T13:11:09.765Z] 13:11:09 INFO - PID 16292 | 1577279467892 addons.manager DEBUG Async provider shutdown done
[task 2019-12-25T13:11:09.765Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467871 addons.manager DEBUG before shutdown"
[task 2019-12-25T13:11:09.765Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467872 addons.manager DEBUG shutdown"
[task 2019-12-25T13:11:09.766Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467875 addons.manager DEBUG Calling shutdown blocker for XPIProvider"
[task 2019-12-25T13:11:09.766Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467875 addons.xpi DEBUG shutdown"
[task 2019-12-25T13:11:09.766Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467876 addons.xpi-utils DEBUG shutdown"
[task 2019-12-25T13:11:09.766Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467876 addons.manager DEBUG Calling shutdown blocker for GMPProvider"
[task 2019-12-25T13:11:09.767Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467878 addons.manager DEBUG Calling shutdown blocker for PluginProvider"
[task 2019-12-25T13:11:09.767Z] 13:11:09 INFO - "CONSOLE_MESSAGE: (info) 1577279467892 addons.manager DEBUG Async provider shutdown done"
[task 2019-12-25T13:11:09.767Z] 13:11:09 INFO - PID 16292 | nsStringStats
[task 2019-12-25T13:11:09.768Z] 13:11:09 INFO - PID 16292 | => mAllocCount: 8312
[task 2019-12-25T13:11:09.768Z] 13:11:09 INFO - PID 16292 | => mReallocCount: 0
[task 2019-12-25T13:11:09.768Z] 13:11:09 INFO - PID 16292 | => mFreeCount: 8312
[task 2019-12-25T13:11:09.769Z] 13:11:09 INFO - PID 16292 | => mShareCount: 4516
[task 2019-12-25T13:11:09.769Z] 13:11:09 INFO - PID 16292 | => mAdoptCount: 77
[task 2019-12-25T13:11:09.769Z] 13:11:09 INFO - PID 16292 | => mAdoptFreeCount: 77
[task 2019-12-25T13:11:09.769Z] 13:11:09 INFO - PID 16292 | => Process ID: 16464, Thread ID: 140069764649408
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | [Child 16912, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3361
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | nsStringStats
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | => mAllocCount: 6893
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | => mReallocCount: 0
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | => mFreeCount: 6893
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | => mShareCount: 3508
[task 2019-12-25T13:11:09.770Z] 13:11:09 INFO - PID 16292 | => mAdoptCount: 268
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | => mAdoptFreeCount: 276
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | => Process ID: 16912, Thread ID: 139845069922752
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | nsStringStats
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | => mAllocCount: 909
[task 2019-12-25T13:11:09.771Z] 13:11:09 INFO - PID 16292 | => mReallocCount: 0
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | => mFreeCount: 909
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | => mShareCount: 405
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | => mAdoptCount: 0
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | => mAdoptFreeCount: 0
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | => Process ID: 16323, Thread ID: 140356881072576
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | [Parent 16292, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3361
[task 2019-12-25T13:11:09.772Z] 13:11:09 INFO - PID 16292 | nsStringStats
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mAllocCount: 84373
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mReallocCount: 0
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mFreeCount: 84373
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mShareCount: 76649
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mAdoptCount: 1296
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => mAdoptFreeCount: 1472
[task 2019-12-25T13:11:09.773Z] 13:11:09 INFO - PID 16292 | => Process ID: 16292, Thread ID: 140523001471424
[task 2019-12-25T13:11:09.774Z] 13:11:09 INFO - <<<<<<<
[task 2019-12-25T13:11:09.774Z] 13:11:09 INFO - INFO | Result summary:
[task 2019-12-25T13:11:09.774Z] 13:11:09 INFO - INFO | Passed: 563
[task 2019-12-25T13:11:09.774Z] 13:11:09 WARNING - INFO | Failed: 1
[task 2019-12-25T13:11:09.774Z] 13:11:09 WARNING - One or more unittests failed.
[task 2019-12-25T13:11:09.774Z] 13:11:09 INFO - INFO | Todo: 0
[task 2019-12-25T13:11:09.774Z] 13:11:09 INFO - INFO | Retried: 2
[task 2019-12-25T13:11:09.775Z] 13:11:09 INFO - SUITE-END | took 849s
[task 2019-12-25T13:11:09.775Z] 13:11:09 INFO - Node moz-http2 server shutting down ...
[task 2019-12-25T13:11:09.805Z] 13:11:09 ERROR - Return code: 1
[task 2019-12-25T13:11:09.806Z] 13:11:09 INFO - TinderboxPrint: xpcshell-xpcshell<br/>563/<em class="testfail">1</em>/0
[task 2019-12-25T13:11:09.806Z] 13:11:09 WARNING - # TBPL FAILURE #
[task 2019-12-25T13:11:09.806Z] 13:11:09 WARNING - setting return code to 2
[task 2019-12-25T13:11:09.807Z] 13:11:09 WARNING - The xpcshell suite: xpcshell ran with return status: FAILURE
[task 2019-12-25T13:11:09.808Z] 13:11:09 INFO - Running post-action listener: _package_coverage_data
[task 2019-12-25T13:11:09.808Z] 13:11:09 INFO - Running post-action listener: _resource_record_post_action
[task 2019-12-25T13:11:09.808Z] 13:11:09 INFO - Running post-action listener: process_java_coverage_data
[task 2019-12-25T13:11:09.808Z] 13:11:09 INFO - [mozharness: 2019-12-25 13:11:09.806683Z] Finished run-tests step (success)
[task 2019-12-25T13:11:09.808Z] 13:11:09 INFO - Running post-run listener: _resource_record_post_run
[task 2019-12-25T13:11:09.881Z] 13:11:09 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2019-12-25T13:11:09.885Z] 13:11:09 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 97.97517441860468}, {"name": "io_write_bytes", "value": 3081465856}, {"name": "io.read_bytes", "value": 2711552}, {"name": "io_write_time", "value": 287408}, {"name": "io_read_time", "value": 44}], "extraOptions": ["e10s", "taskcluster-m5.large"], "name": "xpcshell.xpcshell.1.overall"}, {"subtests": [{"name": "time", "value": 0.027446985244750977}], "name": "xpcshell.xpcshell.1.start-pulseaudio"}, {"subtests": [{"name": "time", "value": 9.829138994216919}, {"name": "cpu_percent", "value": 50.25}], "name": "xpcshell.xpcshell.1.install"}, {"subtests": [{"name": "time", "value": 0.017199993133544922}], "name": "xpcshell.xpcshell.1.stage-files"}, {"subtests": [{"name": "time", "value": 851.4507839679718}, {"name": "cpu_percent", "value": 98.53388235294119}], "name": "xpcshell.xpcshell.1.run-tests"}]}
[task 2019-12-25T13:11:09.886Z] 13:11:09 INFO - Total resource usage - Wall time: 861s; CPU: 99.0%; Read bytes: 2711552; Write bytes: 3081465856; Read time: 44; Write time: 287408
[task 2019-12-25T13:11:09.886Z] 13:11:09 INFO - TinderboxPrint: CPU usage<br/>98.5%
[task 2019-12-25T13:11:09.887Z] 13:11:09 INFO - TinderboxPrint: I/O read bytes / time<br/>2,711,552 / 44
[task 2019-12-25T13:11:09.887Z] 13:11:09 INFO - TinderboxPrint: I/O write bytes / time<br/>3,081,465,856 / 287,408
[task 2019-12-25T13:11:09.887Z] 13:11:09 INFO - TinderboxPrint: CPU idle<br/>33.4 (1.9%)
[task 2019-12-25T13:11:09.888Z] 13:11:09 INFO - TinderboxPrint: CPU system<br/>118.4 (6.9%)
[task 2019-12-25T13:11:09.888Z] 13:11:09 INFO - TinderboxPrint: CPU user<br/>1,568.2 (91.1%)
[task 2019-12-25T13:11:09.888Z] 13:11:09 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2019-12-25T13:11:09.889Z] 13:11:09 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2019-12-25T13:11:09.889Z] 13:11:09 INFO - install - Wall time: 10s; CPU: 50.0%; Read bytes: 0; Write bytes: 45481984; Read time: 0; Write time: 35864
[task 2019-12-25T13:11:09.890Z] 13:11:09 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2019-12-25T13:11:09.895Z] 13:11:09 INFO - run-tests - Wall time: 851s; CPU: 99.0%; Read bytes: 2711552; Write bytes: 3035983872; Read time: 44; Write time: 251544
[task 2019-12-25T13:11:10.016Z] 13:11:10 WARNING - returning nonzero exit status 2

This is a regression from Bug 1603778 https://hg.mozilla.org/mozilla-central/rev/bdb51063d530
Dao, Harry please take a look over it. Thank you.

Flags: needinfo?(htwyford)
Flags: needinfo?(dao+bmo)

We can probably fix this by removing the openViewOnFocus API along with this test.

Flags: needinfo?(dao+bmo)
Assignee: nobody → htwyford
Status: NEW → ASSIGNED
Iteration: --- → 73.2 - Dec 16 - Jan 5
Points: --- → 2
Flags: needinfo?(htwyford)

This API is no longer needed, seeing as the Top Sites experiment is over. Dao suggested in bug 1605958 comment 1 that it be removed.

Pushed by htwyford@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/09417381f879
Disable openViewOnFocus WebExt API. r=mikedeboer
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 73
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: