Closed Bug 1641323 Opened 6 years ago Closed 5 years ago

Intermittent toolkit/components/extensions/test/mochitest/test_ext_identity.html | onBeforeRequest called for redirect url: {"requestId":"304","url":"https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go","origin

Categories

(WebExtensions :: General, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: rmaries [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=303985221&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/M80lN-qwQfmcLBqTh_pF5Q/runs/0/artifacts/public/logs/live_backing.log


[task 2020-05-27T19:07:24.751Z] 19:07:24 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_identity.html
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - Buffered messages finished
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_identity.html | onBeforeRequest called for redirect url: {"requestId":"304","url":"https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go","originUrl":"https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb","method":"GET","type":"main_frame","timeStamp":1590606445368,"frameId":0,"parentFrameId":-1,"thirdParty":false,"proxyInfo":null,"ip":null,"frameAncestors":[],"urlClassification":{"firstParty":[],"thirdParty":[]},"requestSize":0,"responseSize":0,"tabId":30,"incognito":false}
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:299:16
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - testHandler@SimpleTest/ExtensionTestUtils.js:72:18
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - testResult@SimpleTest/ExtensionTestUtils.js:82:18
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - AsyncExtensionTestUtils.loadExtension@SimpleTest/ExtensionTestUtils.js:113:33
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - test_interaction@toolkit/components/extensions/test/mochitest/test_ext_identity.html:321:38
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - nextTick/<@SimpleTest/SimpleTest.js:2080:34
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - async
nextTick@SimpleTest/SimpleTest.js:2105:11
[task 2020-05-27T19:07:25.571Z] 19:07:25 INFO - setTimeout handler*SimpleTest_setTimeoutShim@SimpleTest/SimpleTest.js:788:41
[task 2020-05-27T19:07:25.572Z] 19:07:25 INFO - add_task@SimpleTest/SimpleTest.js:2035:17
[task 2020-05-27T19:07:25.572Z] 19:07:25 INFO - @toolkit/components/extensions/test/mochitest/test_ext_identity.html:15:9
[task 2020-05-27T19:07:25.572Z] 19:07:25 INFO - GECKO(3016) | JavaScript error: resource:///modules/UrlbarInput.jsm, line 366: Error: Unrecognized UrlbarInput event: unload

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=316662868&repo=mozilla-central&lineNumber=8371

[task 2020-09-25T00:55:16.317Z] 00:55:16 INFO - TEST-START | gfx/tests/mochitest/test_font_whitelist.html
[task 2020-09-25T00:55:16.637Z] 00:55:16 ERROR - GECKO(8816) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2020-09-25T00:55:16.702Z] 00:55:16 INFO - GECKO(8816) | [Parent 8824, Gecko_IOThread] WARNING: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_win.cc, line 166
[task 2020-09-25T00:55:16.853Z] 00:55:16 INFO - GECKO(8816) | 1600995316846 Marionette TRACE Received observer notification xpcom-will-shutdown
[task 2020-09-25T00:55:16.853Z] 00:55:16 INFO - GECKO(8816) | 1600995316846 Marionette INFO Stopped listening on port 2828
[task 2020-09-25T00:55:16.853Z] 00:55:16 INFO - GECKO(8816) | 1600995316846 Marionette DEBUG Marionette stopped listening
[task 2020-09-25T00:55:17.059Z] 00:55:17 INFO - TEST-INFO | Main app process: exit 0
[task 2020-09-25T00:55:17.060Z] 00:55:17 INFO - runtests.py | Application ran for: 0:00:04.692000
[task 2020-09-25T00:55:17.060Z] 00:55:17 INFO - zombiecheck | Reading PID log: c:\users\task_1600994114\appdata\local\temp\tmpbnondvpidlog
[task 2020-09-25T00:55:17.061Z] 00:55:17 INFO - ==> process 8824 launched child process 5500 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.0.829446228\716026113" -parentBuildID 20200924215348 -prefsHandle 2216 -prefMapHandle 2192 -prefsLen 1 -prefMapSize 242226 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 2284 gpu)
[task 2020-09-25T00:55:17.061Z] 00:55:17 INFO - ==> process 8824 launched child process 7552 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.6.1905357152\1361167626" -childID 1 -isForBrowser -prefsHandle 2888 -prefMapHandle 2856 -prefsLen 1744 -prefMapSize 242226 -parentBuildID 20200924215348 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 1968 tab)
[task 2020-09-25T00:55:17.062Z] 00:55:17 INFO - ==> process 8824 launched child process 1196 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.13.1214356918\326740698" -childID 2 -isForBrowser -prefsHandle 4092 -prefMapHandle 4064 -prefsLen 2157 -prefMapSize 242226 -parentBuildID 20200924215348 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 4120 tab)
[task 2020-09-25T00:55:17.063Z] 00:55:17 INFO - ==> process 8824 launched child process 5508 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.20.1394059394\161337254" -childID 3 -isForBrowser -prefsHandle 4320 -prefMapHandle 4316 -prefsLen 2197 -prefMapSize 242226 -parentBuildID 20200924215348 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 4340 tab)
[task 2020-09-25T00:55:17.063Z] 00:55:17 INFO - ==> process 8824 launched child process 1308 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.27.541786678\262594216" -childID 4 -isForBrowser -prefsHandle 3996 -prefMapHandle 4060 -prefsLen 11891 -prefMapSize 242226 -parentBuildID 20200924215348 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 3804 tab)
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - ==> process 8824 launched child process 6516 ("C:\Users\task_1600994114\build\application\firefox\firefox.exe" -contentproc --channel="8824.34.1174939547\427697390" -childID 5 -isForBrowser -prefsHandle 4752 -prefMapHandle 4736 -prefsLen 12138 -prefMapSize 242226 -parentBuildID 20200924215348 -appdir "C:\Users\task_1600994114\build\application\firefox\browser" - 8824 "\.\pipe\gecko-crash-server-pipe.8824" 4608 tab)
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 7552
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 5508
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 1308
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 1196
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 6516
[task 2020-09-25T00:55:17.064Z] 00:55:17 INFO - zombiecheck | Checking for orphan process with PID: 5500
[task 2020-09-25T00:55:17.065Z] 00:55:17 INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/DMPoqdsNSgCgXfpHlMOy1w/artifacts/public/build/target.crashreporter-symbols.zip
[task 2020-09-25T00:55:21.411Z] 00:55:21 INFO - mozcrash Copy/paste: C:/Users/task_1600994114/fetches\minidump_stackwalk\minidump_stackwalk.exe c:\users\task_1600994114\appdata\local\temp\tmpxnptl_.mozrunner\minidumps\8ab6e3bd-a7f6-4868-b78b-a03b221b0a36.dmp c:\users\task_1600994114\appdata\local\temp\tmpnsyyiy
[task 2020-09-25T00:55:25.177Z] 00:55:25 INFO - mozcrash Saved minidump as C:\Users\task_1600994114\build\blobber_upload_dir\8ab6e3bd-a7f6-4868-b78b-a03b221b0a36.dmp
[task 2020-09-25T00:55:25.177Z] 00:55:25 INFO - mozcrash Saved app info as C:\Users\task_1600994114\build\blobber_upload_dir\8ab6e3bd-a7f6-4868-b78b-a03b221b0a36.extra
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ gfxFontGroup::GetUnderlineOffset()]
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - Crash dump filename: c:\users\task_1600994114\appdata\local\temp\tmpxnptl_.mozrunner\minidumps\8ab6e3bd-a7f6-4868-b78b-a03b221b0a36.dmp
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - Operating system: Windows NT
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - 10.0.17134
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - CPU: amd64
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - family 6 model 94 stepping 3
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - 8 CPUs
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO -
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO - GPU: UNKNOWN
[task 2020-09-25T00:55:25.237Z] 00:55:25 INFO -
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - Crash reason: EXCEPTION_ACCESS_VIOLATION_READ
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - Crash address: 0xd1be096e
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - Assertion: Unknown assertion type 0x00000000
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - Process uptime: 3 seconds
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO -
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - Thread 0 (crashed)
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - 0 xul.dll!gfxFontGroup::GetUnderlineOffset() [gfxTextRun.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 2960 + 0x5]
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - rax = 0x00000241d1be094c rdx = 0x0000000000000020
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - rcx = 0x00000241d0287e30 rbx = 0x00000241d66c4910
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - rsi = 0x00000241d0287e30 rdi = 0x0000000000000000
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - rbp = 0x0000000000000000 rsp = 0x000000cf37bf9470
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - r8 = 0x0000000000000020 r9 = 0x00000241d020b750
[task 2020-09-25T00:55:25.238Z] 00:55:25 INFO - r10 = 0x00000241d020b750 r11 = 0x0000000000000000
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r12 = 0x0000000000000000 r13 = 0x00000241d02a5600
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r14 = 0x000000cf37bf94b7 r15 = 0x0000000000000010
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - rip = 0x00007ff9ef015a27
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - Found by: given as instruction pointer in context
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - 1 xul.dll!nsFontMetrics::MaxDescent() [nsFontMetrics.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 238 + 0x48]
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - rsp = 0x000000cf37bf9520 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9ef02ca72
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - 2 xul.dll!nsTextFrame::ReflowText(nsLineLayout&, int, mozilla::gfx::DrawTarget*, mozilla::ReflowOutput&, nsReflowStatus&) [nsTextFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 9399 + 0x8]
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - rsp = 0x000000cf37bf95d0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1db64bc
[task 2020-09-25T00:55:25.239Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - 3 xul.dll!nsLineLayout::ReflowFrame(nsIFrame*, nsReflowStatus&, mozilla::ReflowOutput*, bool&) [nsLineLayout.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 881 + 0x22]
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rsp = 0x000000cf37bf9990 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9ef00b26f
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - 4 xul.dll!nsInlineFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [nsInlineFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 364 + 0x5a]
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rsp = 0x000000cf37bf9be0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9ef014271
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - 5 xul.dll!nsLineLayout::ReflowFrame(nsIFrame*, nsReflowStatus&, mozilla::ReflowOutput*, bool&) [nsLineLayout.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 878 + 0x49]
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - rsp = 0x000000cf37bf9cf0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9ef00ac85
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.240Z] 00:55:25 INFO - 6 xul.dll!nsBlockFrame::DoReflowInlineFrames(mozilla::BlockReflowInput&, nsLineLayout&, nsLineList_iterator, nsFlowAreaRect&, int&, nsFloatManager::SavedState*, bool*, LineReflowStatus*, bool) [nsBlockFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 4319 + 0x3d]
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rsp = 0x000000cf37bf9f40 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1d22eec
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - 7 xul.dll!nsBlockFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [nsBlockFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1368 + 0x6df]
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rsp = 0x000000cf37bfa080 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeffd9e7
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - 8 xul.dll!nsBlockFrame::ReflowBlockFrame(mozilla::BlockReflowInput&, nsLineList_iterator, bool*) [nsBlockFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 3834 + 0x141]
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - rsp = 0x000000cf37bfa5c0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.241Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1d1e600
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - 9 xul.dll!nsBlockFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [nsBlockFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1368 + 0x28f]
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rsp = 0x000000cf37bfa980 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeffd597
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - 10 xul.dll!nsContainerFrame::ReflowChild(nsIFrame*, nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, mozilla::WritingMode const&, mozilla::LogicalPoint const&, nsSize const&, nsIFrame::ReflowChildFlags, nsReflowStatus&, nsOverflowContinuationTracker*) [nsContainerFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1075 + 0x21]
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rsp = 0x000000cf37bfaec0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeffcda8
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - 11 xul.dll!nsCanvasFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [nsCanvasFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 757 + 0x50]
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - rsp = 0x000000cf37bfaf50 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.242Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1d2cbcc
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - 12 xul.dll!nsContainerFrame::ReflowChild(nsIFrame*, nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, mozilla::WritingMode const&, mozilla::LogicalPoint const&, nsSize const&, nsIFrame::ReflowChildFlags, nsReflowStatus&, nsOverflowContinuationTracker*) [nsContainerFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1075 + 0x21]
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rsp = 0x000000cf37bfb1f0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeffcda8
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - 13 xul.dll!nsHTMLScrollFrame::ReflowScrolledFrame(mozilla::ScrollReflowInput*, bool, bool, mozilla::ReflowOutput*) [nsGfxScrollFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 755 + 0x4e]
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rsp = 0x000000cf37bfb280 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1d5b767
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - 14 xul.dll!nsHTMLScrollFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [nsGfxScrollFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1277 + 0x3d]
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.243Z] 00:55:25 INFO - rsp = 0x000000cf37bfb4c0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeff6964
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - 15 xul.dll!nsContainerFrame::ReflowChild(nsIFrame*, nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, int, int, nsIFrame::ReflowChildFlags, nsReflowStatus&, nsOverflowContinuationTracker*) [nsContainerFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1115 + 0x21]
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - rsp = 0x000000cf37bfb6f0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeff607f
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.244Z] 00:55:25 INFO - 16 xul.dll!mozilla::ViewportFrame::Reflow(nsPresContext*, mozilla::ReflowOutput&, mozilla::ReflowInput const&, nsReflowStatus&) [ViewportFrame.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 297 + 0x40]
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - rsp = 0x000000cf37bfb780 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1d1962c
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - 17 xul.dll!mozilla::PresShell::DoReflow(nsIFrame*, bool, mozilla::OverflowChangedTracker*) [PresShell.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 9651 + 0x1c]
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - rsp = 0x000000cf37bfb9a0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c836be
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - 18 xul.dll!mozilla::PresShell::ProcessReflowCommands(bool) [PresShell.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 9824 + 0xe]
[task 2020-09-25T00:55:25.245Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - rsp = 0x000000cf37bfbd30 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c86dcf
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - 19 xul.dll!mozilla::PresShell::DoFlushPendingNotifications(mozilla::ChangesToFlush) [PresShell.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 4240 + 0x10]
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - rsp = 0x000000cf37bfbe40 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeedb186
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - 20 xul.dll!nsRefreshDriver::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 2152 + 0x15]
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - rsp = 0x000000cf37bfbf90 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.246Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c66dd4
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - 21 xul.dll!mozilla::RefreshDriverTimer::TickRefreshDrivers(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, nsTArray<RefPtr<nsRefreshDriver> >&) [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 352 + 0x1f]
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - rsp = 0x000000cf37bfd490 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c6c6d1
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - 22 xul.dll!mozilla::RefreshDriverTimer::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 367 + 0x1f]
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - rsp = 0x000000cf37bfd520 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c6c521
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.247Z] 00:55:25 INFO - 23 xul.dll!mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::TickRefreshDriver(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 746 + 0x29]
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - rsp = 0x000000cf37bfd5c0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c6c0b2
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - 24 xul.dll!mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::NotifyParentProcessVsync() [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 648 + 0x23]
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - rsp = 0x000000cf37bfd6c0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c6ba06
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - 25 xul.dll!mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::NotifyVsync(mozilla::VsyncEvent const&) [nsRefreshDriver.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 569 + 0x8]
[task 2020-09-25T00:55:25.248Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - rsp = 0x000000cf37bfd780 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9f1c6b7a0
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - 26 xul.dll!mozilla::layout::VsyncChild::RecvNotify(mozilla::VsyncEvent const&) [VsyncChild.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 55 + 0xf]
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - rsp = 0x000000cf37bfd7c0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeed9d4f
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - 27 xul.dll!mozilla::layout::PVsyncChild::OnMessageReceived(IPC::Message const&) [PVsyncChild.cpp: : 187 + 0xb]
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - rsp = 0x000000cf37bfd7f0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeed98ed
[task 2020-09-25T00:55:25.249Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - 28 xul.dll!mozilla::ipc::PBackgroundChild::OnMessageReceived(IPC::Message const&) [PBackgroundChild.cpp: : 6080 + 0x10]
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rsp = 0x000000cf37bfd8d0 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9eeed89a9
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - 29 xul.dll!mozilla::ipc::MessageChannel::DispatchMessage(IPC::Message&&) [MessageChannel.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 2074 + 0x74]
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rsp = 0x000000cf37bfe430 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9efb37c82
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - Found by: call frame info
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - 30 xul.dll!mozilla::ipc::MessageChannel::MessageTask::Run() [MessageChannel.cpp:6d45a17995e220d26df280d6af6c3bf81b69b348 : 1953 + 0xf1]
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rbx = 0x00000241d66c4910 rbp = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - rsp = 0x000000cf37bfe760 r12 = 0x0000000000000000
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r13 = 0x00000241d02a5600 r14 = 0x000000cf37bf94b7
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - r15 = 0x0000000000000010 rip = 0x00007ff9efb39333
[task 2020-09-25T00:55:25.250Z] 00:55:25 INFO - Found by: call frame info

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=328756692&repo=mozilla-beta&lineNumber=8752

[task 2021-02-03T21:52:26.049Z] 21:52:26 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_identity.html
[task 2021-02-03T21:52:26.105Z] 21:52:26 INFO - GECKO(1850) | Console message: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://mochi.test:8888/tests/toolkit/components/extensions/test/mochitest/test_ext_identity.html" line: 0}]
[task 2021-02-03T21:52:26.105Z] 21:52:26 INFO - GECKO(1850) | Console message: Warning: attempting to write 6165 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-03T21:52:26.108Z] 21:52:26 INFO - GECKO(1850) | Console message: Warning: attempting to write 6227 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-03T21:52:26.146Z] 21:52:26 INFO - GECKO(1850) | Console message: Warning: attempting to write 6307 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-03T21:52:26.180Z] 21:52:26 INFO - GECKO(1850) | Console message: Warning: attempting to write 6387 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-03T21:52:26.199Z] 21:52:26 INFO - GECKO(1850) | Console message: Warning: attempting to write 6467 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-03T21:52:26.346Z] 21:52:26 INFO - GECKO(1850) | Console message: [JavaScript Error: "XML Parsing Error: syntax error
[task 2021-02-03T21:52:26.346Z] 21:52:26 INFO - GECKO(1850) | Location: https://example.com/tests/toolkit/components/extensions/test/mochitest/redirect_auto.sjs?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb&no_redirect=1
[task 2021-02-03T21:52:26.346Z] 21:52:26 INFO - GECKO(1850) | Line Number 1, Column 1:" {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/redirect_auto.sjs?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb&no_redirect=1" line: 1 column: 1 source: "ok"}]
[task 2021-02-03T21:52:27.172Z] 21:52:27 INFO - GECKO(1850) | Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb" line: 0}]
[task 2021-02-03T21:52:27.303Z] 21:52:27 INFO - TEST-INFO | started process screencapture
[task 2021-02-03T21:52:27.391Z] 21:52:27 INFO - TEST-INFO | screencapture: exit 0
[task 2021-02-03T21:52:27.391Z] 21:52:27 INFO - Buffered messages logged at 21:52:26
[task 2021-02-03T21:52:27.391Z] 21:52:27 INFO - add_task | Entering test setup
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Leaving test setup
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Entering test test_noPermission
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | No identity api without permission - Expected: undefined, Actual: undefined
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Leaving test test_noPermission
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Entering test test_getRedirectURL
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/foobar, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/foobar
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/callback, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/callback
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Leaving test test_getRedirectURL
[task 2021-02-03T21:52:27.397Z] 21:52:27 INFO - add_task | Entering test test_badAuthURI
[task 2021-02-03T21:52:27.399Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.399Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match /Type error for parameter details/, got "Type error for parameter details (Error processing url: String "foobar" must match /^https?:\/\/.$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-02-03T21:52:27.400Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match /Type error for parameter details/, got "Type error for parameter details (Error processing url: String "about:addons" must match /^https?:\/\/.
$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-02-03T21:52:27.400Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match /Type error for parameter details/, got "Type error for parameter details (Error processing url: String "about:blank" must match /^https?:\/\/.$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-02-03T21:52:27.400Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match /Type error for parameter details/, got "Type error for parameter details (Error processing url: String "ftp://example.com/test\" must match /^https?:\/\/.
$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-02-03T21:52:27.400Z] 21:52:27 INFO - add_task | Leaving test test_badAuthURI
[task 2021-02-03T21:52:27.400Z] 21:52:27 INFO - add_task | Entering test test_badRequestURI
[task 2021-02-03T21:52:27.401Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.401Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "redirect_uri is invalid", got "redirect_uri is invalid": invalid redirect url
[task 2021-02-03T21:52:27.401Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "redirect_uri not allowed", got "redirect_uri not allowed": invalid redirect url
[task 2021-02-03T21:52:27.401Z] 21:52:27 INFO - add_task | Leaving test test_badRequestURI
[task 2021-02-03T21:52:27.401Z] 21:52:27 INFO - add_task | Entering test background_launchWebAuthFlow_requires_interaction
[task 2021-02-03T21:52:27.403Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.403Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "Requires user interaction", got "Requires user interaction": Rejects on required user interaction
[task 2021-02-03T21:52:27.404Z] 21:52:27 INFO - add_task | Leaving test background_launchWebAuthFlow_requires_interaction
[task 2021-02-03T21:52:27.404Z] 21:52:27 INFO - add_task | Entering test test_autoRedirect
[task 2021-02-03T21:52:27.404Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.404Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-02-03T21:52:27.405Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go
[task 2021-02-03T21:52:27.413Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-02-03T21:52:27.413Z] 21:52:27 INFO - add_task | Leaving test test_autoRedirect
[task 2021-02-03T21:52:27.413Z] 21:52:27 INFO - add_task | Entering test test_autoRedirect_noRedirectURI
[task 2021-02-03T21:52:27.413Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/?access_token=here+ya+go
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - add_task | Leaving test test_autoRedirect_noRedirectURI
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - add_task | Entering test test_noRedirect
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Auth page loaded, interaction required. - Expected: Requires user interaction, Actual: Requires user interaction
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - add_task | Leaving test test_noRedirect
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - add_task | Entering test test_interaction
[task 2021-02-03T21:52:27.414Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - Buffered messages finished
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_identity.html | onBeforeRequest called for redirect url: {"requestId":"350","url":"https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go","originUrl":"https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb","method":"GET","type":"main_frame","timeStamp":1612389146921,"tabId":46,"frameId":0,"parentFrameId":-1,"incognito":false,"thirdParty":false,"cookieStoreId":"firefox-default","proxyInfo":null,"ip":null,"frameAncestors":[],"urlClassification":{"firstParty":[],"thirdParty":[]},"requestSize":0,"responseSize":0}
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - testHandler@SimpleTest/ExtensionTestUtils.js:72:18
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - testResult@SimpleTest/ExtensionTestUtils.js:82:18
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - GECKO(1850) | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - add_task | Leaving test test_interaction
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - add_task | Entering test test_auto303Redirect
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - Extension loaded
[task 2021-02-03T21:52:27.415Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-02-03T21:52:27.635Z] 21:52:27 INFO - GECKO(1850) | Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?post=303&server_uri=redirect_auto.sjs&redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb" line: 0}]
[task 2021-02-03T21:52:27.635Z] 21:52:27 INFO - GECKO(1850) | Console message: [JavaScript Warning: "A form was submitted in the windows-1252 encoding which cannot encode all Unicode characters, so user input may get corrupted. To avoid this problem, the page should be changed so that the form is submitted in the UTF-8 encoding either by changing the encoding of the page itself to UTF-8 or by specifying accept-charset=utf-8 on the form element." {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?post=303&server_uri=redirect_auto.sjs&redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb" line: 13}]
[task 2021-02-03T21:52:27.885Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go
[task 2021-02-03T21:52:27.886Z] 21:52:27 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-02-03T21:52:28.031Z] 21:52:28 INFO - add_task | Leaving test test_auto303Redirect
[task 2021-02-03T21:52:28.031Z] 21:52:28 INFO - add_task | Entering test test_loopbackRedirectURI
[task 2021-02-03T21:52:28.031Z] 21:52:28 INFO - Extension loaded
[task 2021-02-03T21:52:28.072Z] 21:52:28 INFO - GECKO(1850) | *** WIFI GEO: onStatus called.wifi-timeout
[task 2021-02-03T21:52:28.072Z] 21:52:28 INFO - GECKO(1850) | *** WIFI GEO: Use request cache:true reason:New req. is GeoIP.
[task 2021-02-03T21:52:28.226Z] 21:52:28 INFO - GECKO(1850) | Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=http%3A%2F%2F127.0.0.1%2Fmozoauth2%2F35b64b676900f491c00e7f618d43f7040e88422e" line: 0}]
[task 2021-02-03T21:52:28.591Z] 21:52:28 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Expected redirect url to be loopback address
[task 2021-02-03T21:52:28.591Z] 21:52:28 INFO - add_task | Leaving test test_loopbackRedirectURI
[task 2021-02-03T21:52:28.591Z] 21:52:28 INFO - GECKO(1850) | MEMORY STAT | vsize 6588MB | residentFast 90MB | heapAllocated 11MB
[task 2021-02-03T21:52:28.591Z] 21:52:28 INFO - TEST-OK | toolkit/components/extensions/test/mochitest/test_ext_identity.html | took 2523ms

Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=339282859&repo=mozilla-esr78&lineNumber=13535

[task 2021-05-10T15:04:51.088Z] 15:04:51 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_identity.html
[task 2021-05-10T15:04:51.154Z] 15:04:51 INFO - GECKO(1889) | Console message: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://mochi.test:8888/tests/toolkit/components/extensions/test/mochitest/test_ext_identity.html" line: 0}]
[task 2021-05-10T15:04:51.154Z] 15:04:51 INFO - GECKO(1889) | Console message: Warning: attempting to write 5525 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-05-10T15:04:51.161Z] 15:04:51 INFO - GECKO(1889) | Console message: Warning: attempting to write 5587 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-05-10T15:04:51.212Z] 15:04:51 INFO - GECKO(1889) | Console message: Warning: attempting to write 5667 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-05-10T15:04:51.271Z] 15:04:51 INFO - GECKO(1889) | Console message: Warning: attempting to write 5747 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-05-10T15:04:51.294Z] 15:04:51 INFO - GECKO(1889) | Console message: Warning: attempting to write 5827 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-05-10T15:04:51.444Z] 15:04:51 INFO - GECKO(1889) | Console message: [JavaScript Error: "XML Parsing Error: syntax error
[task 2021-05-10T15:04:51.444Z] 15:04:51 INFO - GECKO(1889) | Location: https://example.com/tests/toolkit/components/extensions/test/mochitest/redirect_auto.sjs?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb&no_redirect=1
[task 2021-05-10T15:04:51.444Z] 15:04:51 INFO - GECKO(1889) | Line Number 1, Column 1:" {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/redirect_auto.sjs?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb&no_redirect=1" line: 1 column: 1 source: "ok"}]
[task 2021-05-10T15:04:51.643Z] 15:04:51 INFO - GECKO(1889) | Console message: OpenGL compositor Initialized Succesfully.
[task 2021-05-10T15:04:51.643Z] 15:04:51 INFO - GECKO(1889) | Version: 2.1 INTEL-12.9.22
[task 2021-05-10T15:04:51.643Z] 15:04:51 INFO - GECKO(1889) | Vendor: Intel Inc.
[task 2021-05-10T15:04:51.644Z] 15:04:51 INFO - GECKO(1889) | Renderer: Intel Iris OpenGL Engine
[task 2021-05-10T15:04:51.644Z] 15:04:51 INFO - GECKO(1889) | FBO Texture Target: TEXTURE_2D
[task 2021-05-10T15:04:51.694Z] 15:04:51 INFO - GECKO(1889) | Console message: OpenGL compositor Initialized Succesfully.
[task 2021-05-10T15:04:51.694Z] 15:04:51 INFO - GECKO(1889) | Version: 2.1 INTEL-12.9.22
[task 2021-05-10T15:04:51.694Z] 15:04:51 INFO - GECKO(1889) | Vendor: Intel Inc.
[task 2021-05-10T15:04:51.694Z] 15:04:51 INFO - GECKO(1889) | Renderer: Intel Iris OpenGL Engine
[task 2021-05-10T15:04:51.694Z] 15:04:51 INFO - GECKO(1889) | FBO Texture Target: TEXTURE_2D
[task 2021-05-10T15:04:52.048Z] 15:04:52 INFO - GECKO(1889) | Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb" line: 0}]
[task 2021-05-10T15:04:52.048Z] 15:04:52 INFO - TEST-INFO | started process screencapture
[task 2021-05-10T15:04:52.204Z] 15:04:52 INFO - TEST-INFO | screencapture: exit 0
[task 2021-05-10T15:04:52.205Z] 15:04:52 INFO - Buffered messages logged at 15:04:51
[task 2021-05-10T15:04:52.208Z] 15:04:52 INFO - add_task | Entering test setup
[task 2021-05-10T15:04:52.208Z] 15:04:52 INFO - add_task | Leaving test setup
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - add_task | Entering test test_noPermission
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | No identity api without permission - Expected: undefined, Actual: undefined
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - add_task | Leaving test test_noPermission
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - add_task | Entering test test_getRedirectURL
[task 2021-05-10T15:04:52.209Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.210Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-05-10T15:04:52.210Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-05-10T15:04:52.212Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/foobar, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/foobar
[task 2021-05-10T15:04:52.212Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | redirect url ok - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/callback, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/callback
[task 2021-05-10T15:04:52.212Z] 15:04:52 INFO - add_task | Leaving test test_getRedirectURL
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - add_task | Entering test test_badAuthURI
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match <unknown>got "Type error for parameter details (Error processing url: String "foobar" must match /^https?:\/\/.$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match <unknown>got "Type error for parameter details (Error processing url: String "about:addons" must match /^https?:\/\/.
$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match <unknown>got "Type error for parameter details (Error processing url: String "about:blank" must match /^https?:\/\/.$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Function threw, expecting error to match <unknown>got "Type error for parameter details (Error processing url: String "ftp://example.com/test\" must match /^https?:\/\/.
$/) for identity.launchWebAuthFlow.": details.url is invalid
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - add_task | Leaving test test_badAuthURI
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - add_task | Entering test test_badRequestURI
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.213Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "redirect_uri is invalid", got "redirect_uri is invalid": invalid redirect url
[task 2021-05-10T15:04:52.215Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "redirect_uri not allowed", got "redirect_uri not allowed": invalid redirect url
[task 2021-05-10T15:04:52.215Z] 15:04:52 INFO - add_task | Leaving test test_badRequestURI
[task 2021-05-10T15:04:52.215Z] 15:04:52 INFO - add_task | Entering test background_launchWebAuthFlow_requires_interaction
[task 2021-05-10T15:04:52.217Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.217Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Promise rejected, expecting rejection to match "Requires user interaction", got "Requires user interaction": Rejects on required user interaction
[task 2021-05-10T15:04:52.220Z] 15:04:52 INFO - add_task | Leaving test background_launchWebAuthFlow_requires_interaction
[task 2021-05-10T15:04:52.220Z] 15:04:52 INFO - add_task | Entering test test_autoRedirect
[task 2021-05-10T15:04:52.221Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.221Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-05-10T15:04:52.221Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go
[task 2021-05-10T15:04:52.224Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-05-10T15:04:52.224Z] 15:04:52 INFO - add_task | Leaving test test_autoRedirect
[task 2021-05-10T15:04:52.224Z] 15:04:52 INFO - add_task | Entering test test_autoRedirect_noRedirectURI
[task 2021-05-10T15:04:52.232Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.232Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/
[task 2021-05-10T15:04:52.232Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/?access_token=here+ya+go
[task 2021-05-10T15:04:52.232Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-05-10T15:04:52.232Z] 15:04:52 INFO - add_task | Leaving test test_autoRedirect_noRedirectURI
[task 2021-05-10T15:04:52.233Z] 15:04:52 INFO - add_task | Entering test test_noRedirect
[task 2021-05-10T15:04:52.234Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.237Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-05-10T15:04:52.240Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Auth page loaded, interaction required. - Expected: Requires user interaction, Actual: Requires user interaction
[task 2021-05-10T15:04:52.240Z] 15:04:52 INFO - add_task | Leaving test test_noRedirect
[task 2021-05-10T15:04:52.240Z] 15:04:52 INFO - add_task | Entering test test_interaction
[task 2021-05-10T15:04:52.240Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.240Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb
[task 2021-05-10T15:04:52.243Z] 15:04:52 INFO - Buffered messages finished
[task 2021-05-10T15:04:52.243Z] 15:04:52 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_identity.html | onBeforeRequest called for redirect url: {"requestId":"258","url":"https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go","originUrl":"https://example.com/tests/toolkit/components/extensions/test/mochitest/oauth.html?redirect_uri=https%3A%2F%2F35b64b676900f491c00e7f618d43f7040e88422e.example.com%2Fidentity_cb","method":"GET","type":"main_frame","timeStamp":1620659091900,"tabId":31,"frameId":0,"parentFrameId":-1,"incognito":false,"thirdParty":false,"proxyInfo":null,"ip":null,"frameAncestors":[],"urlClassification":{"firstParty":[],"thirdParty":[]},"requestSize":0,"responseSize":0}
[task 2021-05-10T15:04:52.243Z] 15:04:52 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:299:16
[task 2021-05-10T15:04:52.243Z] 15:04:52 INFO - testHandler@SimpleTest/ExtensionTestUtils.js:72:18
[task 2021-05-10T15:04:52.243Z] 15:04:52 INFO - testResult@SimpleTest/ExtensionTestUtils.js:82:18
[task 2021-05-10T15:04:52.318Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | correct redirect url https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb?access_token=here+ya+go
[task 2021-05-10T15:04:52.322Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | Handled auto redirection - Expected: here ya go, Actual: here ya go
[task 2021-05-10T15:04:52.466Z] 15:04:52 INFO - add_task | Leaving test test_interaction
[task 2021-05-10T15:04:52.466Z] 15:04:52 INFO - add_task | Entering test test_auto303Redirect
[task 2021-05-10T15:04:52.466Z] 15:04:52 INFO - Extension loaded
[task 2021-05-10T15:04:52.521Z] 15:04:52 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_identity.html | expected redirect uri matches hash - Expected: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb, Actual: https://35b64b676900f491c00e7f618d43f7040e88422e.example.com/identity_cb

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.