1575388 - Intermittent Tier 2 TEST-UNEXPECTED-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | We expect at least one assertion to fail because this test file is marked as fail-if in the manifest. -

Reporter

Description

•

5 years ago

treeherder

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=262565021&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/S3YTDEPKQUKgx18B0EfU6A/runs/0/artifacts/public/logs/live_backing.log

[task 2019-08-20T22:39:54.467Z] 22:39:54 [task 2019-08-20T22:39:54.467Z] 22:39:54 [task 2019-08-20T22:39:54.469Z] 22:39:54 [task 2019-08-20T22:39:54.470Z] 22:39:54 [task 2019-08-20T22:39:54.471Z] 22:39:54 [task 2019-08-20T22:39:54.471Z] 22:39:54 [task 2019-08-20T22:39:54.472Z] 22:39:54 [task 2019-08-20T22:39:54.472Z] 22:39:54 [task 2019-08-20T22:39:54.473Z] 22:39:54 [task 2019-08-20T22:39:54.474Z] 22:39:54 [task 2019-08-20T22:39:54.474Z] 22:39:54 [task 2019-08-20T22:39:54.481Z] 22:39:54 [task 2019-08-20T22:39:54.482Z] 22:39:54 [task 2019-08-20T22:39:54.483Z] 22:39:54 [task 2019-08-20T22:39:54.483Z] 22:39:54 [task 2019-08-20T22:39:54.484Z] 22:39:54 [task 2019-08-20T22:39:54.484Z] 22:39:54 [task 2019-08-20T22:39:54.485Z] 22:39:54 [task 2019-08-20T22:39:54.486Z] 22:39:54 [task 2019-08-20T22:39:54.486Z] 22:39:54 [task 2019-08-20T22:39:54.487Z] 22:39:54 [task 2019-08-20T22:39:54.487Z] 22:39:54 [task 2019-08-20T22:39:54.488Z] 22:39:54 [task 2019-08-20T22:39:54.488Z] 22:39:54 [task 2019-08-20T22:39:54.489Z] 22:39:54 [task 2019-08-20T22:39:54.489Z] 22:39:54 [task 2019-08-20T22:39:54.490Z] 22:39:54 [task 2019-08-20T22:39:54.490Z] 22:39:54 [task 2019-08-20T22:39:54.491Z] 22:39:54 [task 2019-08-20T22:39:54.491Z] 22:39:54 [task 2019-08-20T22:39:54.492Z] 22:39:54 [task 2019-08-20T22:39:54.492Z] 22:39:54 [task 2019-08-20T22:39:54.493Z] 22:39:54 [task 2019-08-20T22:39:54.493Z] 22:39:54 [task 2019-08-20T22:39:54.494Z] 22:39:54 [task 2019-08-20T22:39:54.495Z] 22:39:54 [task 2019-08-20T22:39:54.495Z] 22:39:54 [task 2019-08-20T22:39:54.496Z] 22:39:54 [task 2019-08-20T22:39:54.496Z] 22:39:54 [task 2019-08-20T22:39:54.497Z] 22:39:54 [task 2019-08-20T22:39:54.498Z] 22:39:54 [task 2019-08-20T22:39:54.498Z] 22:39:54 [task 2019-08-20T22:39:54.499Z] 22:39:54 [task 2019-08-20T22:39:54.500Z] 22:39:54 [task 2019-08-20T22:39:54.500Z] 22:39:54 [task 2019-08-20T22:39:54.501Z] 22:39:54 [task 2019-08-20T22:39:54.501Z] 22:39:54 [task 2019-08-20T22:39:54.502Z] 22:39:54 [task 2019-08-20T22:39:54.505Z] 22:39:54 [task 2019-08-20T22:39:54.506Z] 22:39:54 [task 2019-08-20T22:39:54.507Z] 22:39:54 [task 2019-08-20T22:39:54.507Z] 22:39:54 [task 2019-08-20T22:39:54.508Z] 22:39:54 [task 2019-08-20T22:39:54.508Z] 22:39:54 [task 2019-08-20T22:39:54.509Z] 22:39:54 [task 2019-08-20T22:39:54.510Z] 22:39:54 [task 2019-08-20T22:39:54.510Z] 22:39:54 [task 2019-08-20T22:39:54.511Z] 22:39:54 [task 2019-08-20T22:39:54.511Z] 22:39:54 [task 2019-08-20T22:39:54.512Z] 22:39:54 [task 2019-08-20T22:39:54.513Z] 22:39:54 [task 2019-08-20T22:39:54.513Z] 22:39:54 [task 2019-08-20T22:39:54.514Z] 22:39:54 [task 2019-08-20T22:39:54.514Z] 22:39:54 [task 2019-08-20T22:39:54.515Z] 22:39:54 [task 2019-08-20T22:39:54.516Z] 22:39:54 [task 2019-08-20T22:39:54.516Z] 22:39:54 [task 2019-08-20T22:39:54.517Z] 22:39:54 [task 2019-08-20T22:39:54.517Z] 22:39:54 [task 2019-08-20T22:39:54.518Z] 22:39:54 [task 2019-08-20T22:39:54.518Z] 22:39:54 [task 2019-08-20T22:39:54.519Z] 22:39:54 [task 2019-08-20T22:39:54.520Z] 22:39:54 [task 2019-08-20T22:39:54.520Z] 22:39:54 [task 2019-08-20T22:39:54.521Z] 22:39:54 [task 2019-08-20T22:39:54.522Z] 22:39:54 [task 2019-08-20T22:39:54.522Z] 22:39:54 [task 2019-08-20T22:39:54.523Z] 22:39:54 [task 2019-08-20T22:39:54.524Z] 22:39:54 [task 2019-08-20T22:39:54.524Z] 22:39:54 [task 2019-08-20T22:39:54.524Z] 22:39:54 [task 2019-08-20T22:39:54.525Z] 22:39:54 [task 2019-08-20T22:39:54.525Z] 22:39:54 [task 2019-08-20T22:39:54.525Z] 22:39:54 [task 2019-08-20T22:39:54.525Z] 22:39:54 [task 2019-08-20T22:39:54.526Z] 22:39:54 [task 2019-08-20T22:39:54.526Z] 22:39:54 [task 2019-08-20T22:39:54.526Z] 22:39:54 [task 2019-08-20T22:39:54.526Z] 22:39:54 [task 2019-08-20T22:39:54.527Z] 22:39:54 [task 2019-08-20T22:39:54.527Z] 22:39:54 [task 2019-08-20T22:39:54.527Z] 22:39:54 [task 2019-08-20T22:39:54.528Z] 22:39:54 [task 2019-08-20T22:39:54.528Z] 22:39:54 [task 2019-08-20T22:39:54.528Z] 22:39:54 [task 2019-08-20T22:39:54.528Z] 22:39:54 [task 2019-08-20T22:39:54.529Z] 22:39:54 INFO - TEST-START | browser/base/content/test/permissions/browser_temporary_permissions.js
INFO - GECKO(1614) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpwpvxBB.mozrunner/runtests_leaks_tab_pid2228.log
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: Can't add a range if the end is older that the start.: file /builds/worker/workspace/build/src/dom/html/TimeRanges.cpp, line 73
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: Can't add a range if the end is older that the start.: file /builds/worker/workspace/build/src/dom/html/TimeRanges.cpp, line 73
INFO - GECKO(1614) | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
INFO - GECKO(1614) | --DOCSHELL 0x7f8ec93b7000 == 0 [pid = 2193] [id = {4a9e8236-51a8-47aa-bed7-b91238760c0f}] [url = https://example.com/browser/browser/base/content/test/permissions/browser_autoplay_muted.html]
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 6852
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 6852
INFO - GECKO(1614) | --DOMWINDOW == 3 (0x7f8eca2c2f20) [pid = 2193] [serial = 1] [outer = (nil)] [url = https://example.com/browser/browser/base/content/test/permissions/browser_autoplay_muted.html]
INFO - GECKO(1614) | --DOMWINDOW == 2 (0x7f8ec935f800) [pid = 2193] [serial = 2] [outer = (nil)] [url = about:blank]
INFO - GECKO(1614) | --DOMWINDOW == 1 (0x7f8ec9cba400) [pid = 2193] [serial = 4] [outer = (nil)] [url = https://example.com/browser/browser/base/content/test/permissions/browser_autoplay_muted.html]
INFO - GECKO(1614) | --DOMWINDOW == 0 (0x7f8eca3c1800) [pid = 2193] [serial = 3] [outer = (nil)] [url = https://example.com/browser/browser/base/content/test/permissions/browser_autoplay_muted.html]
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - GECKO(1614) | [Child 2193, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - GECKO(1614) | nsStringStats
INFO - GECKO(1614) | => mAllocCount: 8789
INFO - GECKO(1614) | => mReallocCount: 0
INFO - GECKO(1614) | => mFreeCount: 8789
INFO - GECKO(1614) | => mShareCount: 6970
INFO - GECKO(1614) | => mAdoptCount: 473
INFO - GECKO(1614) | => mAdoptFreeCount: 481
INFO - GECKO(1614) | => Process ID: 2193, Thread ID: 140251679590208
INFO - GECKO(1614) | WARN 2019-08-20T22:39:32Z: audio_thread_priority::rt_linux: Could not make thread real-time.
INFO - GECKO(1614) | WARN 2019-08-20T22:39:32Z: audioipc_client: Could not promote audio threads to real-time during initialization.
INFO - GECKO(1614) | ++DOCSHELL 0x7f5cc37b5800 == 1 [pid = 2228] [id = {1face4a8-79f9-495a-9b86-1f3b4f1ba16d}]
INFO - GECKO(1614) | ++DOMWINDOW == 1 (0x7f5cc46d6f20) [pid = 2228] [serial = 1] [outer = (nil)]
INFO - GECKO(1614) | ++DOMWINDOW == 2 (0x7f5cc3751400) [pid = 2228] [serial = 2] [outer = 0x7f5cc46d6f20]
INFO - GECKO(1614) | [Child 2228, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
INFO - GECKO(1614) | ++DOMWINDOW == 3 (0x7f5cc40c2400) [pid = 2228] [serial = 3] [outer = 0x7f5cc46d6f20]
INFO - GECKO(1614) | --DOMWINDOW == 0 (0x7f03a50c0c00) [pid = 1904] [serial = 3] [outer = (nil)] [url = about:home]
INFO - GECKO(1614) | [Child 1883, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
INFO - GECKO(1614) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpwpvxBB.mozrunner/runtests_leaks_tab_pid2254.log
INFO - GECKO(1614) | --DOCSHELL 0x7f5cc37b5800 == 0 [pid = 2228] [id = {1face4a8-79f9-495a-9b86-1f3b4f1ba16d}] [url = https://example.com/]
INFO - GECKO(1614) | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
INFO - GECKO(1614) | --DOMWINDOW == 2 (0x7f5cc46d6f20) [pid = 2228] [serial = 1] [outer = (nil)] [url = https://example.com/]
INFO - GECKO(1614) | --DOMWINDOW == 1 (0x7f5cc40c2400) [pid = 2228] [serial = 3] [outer = (nil)] [url = https://example.com/]
INFO - GECKO(1614) | --DOMWINDOW == 0 (0x7f5cc3751400) [pid = 2228] [serial = 2] [outer = (nil)] [url = about:blank]
INFO - GECKO(1614) | [Child 2228, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - GECKO(1614) | [Child 2228, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - GECKO(1614) | nsStringStats
INFO - GECKO(1614) | => mAllocCount: 8530
INFO - GECKO(1614) | => mReallocCount: 0
INFO - GECKO(1614) | => mFreeCount: 8530
INFO - GECKO(1614) | => mShareCount: 7726
INFO - GECKO(1614) | => mAdoptCount: 650
INFO - GECKO(1614) | => mAdoptFreeCount: 654
INFO - GECKO(1614) | => Process ID: 2228, Thread ID: 140036834801472
INFO - GECKO(1614) | WARN 2019-08-20T22:39:33Z: audio_thread_priority::rt_linux: Could not make thread real-time.
INFO - GECKO(1614) | WARN 2019-08-20T22:39:33Z: audioipc_client: Could not promote audio threads to real-time during initialization.
INFO - GECKO(1614) | ++DOCSHELL 0x7f5b3b7b6800 == 1 [pid = 2254] [id = {5791024b-2499-4fcd-8991-0c76bb6d379c}]
INFO - GECKO(1614) | ++DOMWINDOW == 1 (0x7f5b3c79af20) [pid = 2254] [serial = 1] [outer = (nil)]
INFO - GECKO(1614) | ++DOMWINDOW == 2 (0x7f5b3b76a800) [pid = 2254] [serial = 2] [outer = 0x7f5b3c79af20]
INFO - GECKO(1614) | [Child 2254, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
INFO - GECKO(1614) | ++DOMWINDOW == 3 (0x7f5b3c8c3400) [pid = 2254] [serial = 3] [outer = 0x7f5b3c79af20]
INFO - GECKO(1614) | ++DOCSHELL 0x7f5b3b236000 == 2 [pid = 2254] [id = {555ab705-3fb2-4bc3-ac59-27684e2832cf}]
INFO - GECKO(1614) | ++DOMWINDOW == 4 (0x7f5b3c79b2e0) [pid = 2254] [serial = 4] [outer = (nil)]
INFO - GECKO(1614) | --DOMWINDOW == 2 (0x7fef7b56c400) [pid = 2038] [serial = 2] [outer = (nil)] [url = about:blank]
INFO - GECKO(1614) | [Child 2254, Main Thread] WARNING: CompleteRedirectSetup failed, HttpChannelChild already open?: file /builds/worker/workspace/build/src/netwerk/protocol/http/HttpChannelChild.cpp, line 2125
INFO - GECKO(1614) | JavaScript error: resource:///actors/PageStyleChild.jsm, line 35: SecurityError: Permission denied to access property "document" on cross-origin object
INFO - GECKO(1614) | [Child 2254, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/workspace/build/src/dom/base/WindowDestroyedEvent.cpp, line 106
INFO - GECKO(1614) | --DOMWINDOW == 1 (0x7fef7b523f20) [pid = 2038] [serial = 1] [outer = (nil)] [url = about:home]
INFO - GECKO(1614) | --DOCSHELL 0x7fef7b5b1000 == 0 [pid = 2038] [id = {983b4b75-439c-414c-8423-3b94869f5ed2}] [url = about:home]
INFO - GECKO(1614) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpwpvxBB.mozrunner/runtests_leaks_tab_pid2280.log
INFO - GECKO(1614) | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
INFO - GECKO(1614) | WARN 2019-08-20T22:39:34Z: audio_thread_priority::rt_linux: Could not make thread real-time.
INFO - GECKO(1614) | WARN 2019-08-20T22:39:34Z: audioipc_client: Could not promote audio threads to real-time during initialization.
INFO - GECKO(1614) | ++DOCSHELL 0x7f7c79ab7800 == 1 [pid = 2280] [id = {9e470942-d7a3-4ccb-9ffd-339c5d625c55}]
INFO - GECKO(1614) | ++DOMWINDOW == 1 (0x7f7c7a9c4f20) [pid = 2280] [serial = 1] [outer = (nil)]
INFO - GECKO(1614) | ++DOMWINDOW == 2 (0x7f7c79a64400) [pid = 2280] [serial = 2] [outer = 0x7f7c7a9c4f20]
INFO - GECKO(1614) | --DOMWINDOW == 0 (0x7f4d7d7c1400) [pid = 1969] [serial = 3] [outer = (nil)] [url = about:home]
INFO - GECKO(1614) | ++DOMWINDOW == 3 (0x7f7c7aab2800) [pid = 2280] [serial = 3] [outer = 0x7f7c7a9c4f20]
INFO - GECKO(1614) | [Child 2280, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
INFO - GECKO(1614) | [Child 2280, Main Thread] WARNING: 'aRv.Failed()', file /builds/worker/workspace/build/src/dom/ipc/StructuredCloneData.cpp, line 120
INFO - GECKO(1614) | [Child 2280, Main Thread] WARNING: Workers don't support the 'mem.mem.' preference!: file /builds/worker/workspace/build/src/dom/workers/RuntimeService.cpp, line 544
INFO - GECKO(1614) | [Child 2280, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
INFO - GECKO(1614) | "example.org" != "example.com"
INFO - GECKO(1614) | [Child 1883, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
INFO - Buffered messages logged at 22:39:31
INFO - Entering test bound testTempPermissionChangeEvents
INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 112}]
INFO - Buffered messages logged at 22:39:32
INFO - TEST-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | {"state":2,"scope":"{SitePermissions.SCOPE_TEMPORARY}"} deepEqual {"state":2,"scope":"{SitePermissions.SCOPE_TEMPORARY}"} -
INFO - TEST-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | geo anchor should be visible - 16 != 0 -
INFO - TEST-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | geo anchor should not be visible - 0 == 0 -
INFO - Leaving test bound testTempPermissionChangeEvents
INFO - Entering test bound testTempPermissionSubframes
INFO - Buffered messages logged at 22:39:34
INFO - Console message: [JavaScript Error: "SecurityError: Permission denied to access property "document" on cross-origin object" {file: "resource:///actors/PageStyleChild.jsm" line: 35}]
INFO - Buffered messages logged at 22:39:35
INFO - Console message: [JavaScript Warning: "Sending message that cannot be cloned. Are you trying to send an XPCOM object?" {file: "resource://specialpowers/SpecialPowersAPI.jsm" line: 1499}]
INFO - TEST-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | {"state":2,"scope":"{SitePermissions.SCOPE_TEMPORARY}"} deepEqual {"state":2,"scope":"{SitePermissions.SCOPE_TEMPORARY}"} -
INFO - Leaving test bound testTempPermissionSubframes
INFO - Buffered messages finished
INFO - TEST-UNEXPECTED-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | We expect at least one assertion to fail because this test file is marked as fail-if in the manifest. -
INFO - TEST-INFO | expected FAIL
INFO - GECKO(1614) | MEMORY STAT | vsize 3300MB | residentFast 397MB | heapAllocated 146MB
INFO - TEST-OK | browser/base/content/test/permissions/browser_temporary_permissions.js | took 4628ms

Alexandru Michis [:malexandru]

Comment 1

•

5 years ago

Andrew, this fails quite frequently and as far as I can see it is caused by an expectation not being met after Bug 1573958 landed.
Could you please take a look at it?

Push with failures: https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&fromchange=fbccacbaaf80f5d7b05a82ea358959e0881fbb34&searchStr=linux%2Cx64%2Cdebug%2Cmochitests%2Cwith%2Cfission%2Cenabled%2Ctest-linux64%2Fdebug-mochitest-browser-chrome-fis-e10s-13%2Cm-fis%28bc13%29&group_state=expanded&tochange=0dc91d87721bbd95ec2bccd1bfff87f22125ae6d&selectedJob=262565021

Flags: needinfo?(continuation)

Regressed by: 1573958

Andrew McCreight [:mccr8]

Assignee

Comment 2

•

5 years ago

Oops, I forgot to reenable the test after I fixed it.

Andrew McCreight [:mccr8]

Assignee

Comment 3

•

5 years ago

Attached file Bug 1575388 - Mark browser_temporary_permissions.js as passing with Fission. — Details

Pulsebot

Comment 4

•

5 years ago

Pushed by amccreight@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/72b6c637b56e
Mark browser_temporary_permissions.js as passing with Fission. r=kmag

Johann Hofmann [:johannh]

Updated

•

5 years ago

Assignee: nobody → continuation

Status: NEW → ASSIGNED

Daniel Varga [:dvarga]

Comment 5

•

5 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/72b6c637b56e

Status: ASSIGNED → RESOLVED

Closed: 5 years ago

status-firefox70: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → Firefox 70

Andrew McCreight [:mccr8]

Assignee

Updated

•

5 years ago

Flags: needinfo?(continuation)

Ryan VanderMeulen [:RyanVM]

Updated

•

5 years ago

status-firefox68: --- → unaffected

status-firefox69: --- → unaffected

status-firefox-esr60: --- → unaffected

status-firefox-esr68: --- → unaffected

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Updated

•

2 years ago

Has Regression Range: --- → yes

Bugzilla

Quick Search

Intermittent Tier 2 TEST-UNEXPECTED-PASS | browser/base/content/test/permissions/browser_temporary_permissions.js | We expect at least one assertion to fail because this test file is marked as fail-if in the manifest. -

Categories

(Firefox :: Site Identity, defect, P5)

Tracking

()

People

(Reporter: intermittent-bug-filer, Assigned: mccr8)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Crash Data

Security

(public)

User Story

Attachments

(1 file)

Description

Comment 1

Comment 2

Comment 3

Comment 4

Updated

Comment 5

Updated

Updated

Comment 6

Updated

Attachment

General

Description

File Name

Content Type