Closed Bug 1567186 Opened 5 years ago Closed 5 years ago

Intermittent /webdriver/tests/new_session/page_load_strategy.py | test_pageLoadStrategy - AssertionError: unknown error (500): permission denied

Categories

(Remote Protocol :: Marionette, defect, P5)

Version 3
defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1517538

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=257145853&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/XzdqNOZnSA2PG3BXzNm_EA/runs/0/artifacts/public/logs/live_backing.log


13:44:55 INFO - TEST-OK | /webdriver/tests/new_session/merge.py | took 36796ms
13:44:55 INFO - TEST-START | /webdriver/tests/new_session/page_load_strategy.py
13:44:55 INFO - STDOUT: ============================= test session starts =============================
13:44:55 INFO - STDOUT: platform win32 -- Python 2.7.11, pytest-unknown, py-1.5.2, pluggy-0.5.3.dev -- Z:\task_1563450804\build\venv\Scripts\python.exe
13:44:55 INFO - STDOUT: rootdir: Z:\task_1563450804\build, inifile:
13:44:55 INFO - STDOUT: collecting ...
13:44:55 INFO - STDOUT: collected 1 item
13:44:55 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/new_session/page_load_strategy.py::test_pageLoadStrategy
13:44:55 INFO - PID 4052 | 1563457495212 webdriver::server DEBUG -> POST /session {"capabilities": {"alwaysMatch": {"pageLoadStrategy": "eager", "moz:firefoxOptions": {"binary": "Z:\task_1563450804\build\application\firefox\firefox.exe", "prefs": {"network.dns.localDomains": "www1.xn--n8j6ds53lwwkrqhv28a.web-platform.test,xn--lve-6lad.www1.web-platform.test,www.www2.not-web-platform.test,www2.www2.not-web-platform.test,xn--lve-6lad.www.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,www.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.www.not-web-platform.test,not-web-platform.test,www1.www.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.www1.web-platform.test,www2.not-web-platform.test,www1.not-web-platform.test,www1.www1.web-platform.test,www2.xn--lve-6lad.web-platform.test,www1.xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.xn--n8j6ds53lwwkrqhv28a.web-platform.test,www1.www2.web-platform.test,xn--lve-6lad.xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,xn--lve-6lad.xn--lve-6lad.not-web-platform.test,www2.www1.not-web-platform.test,www2.xn--n8j6ds53lwwkrqhv28a.web-platform.test,www.xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,web-platform.test,xn--n8j6ds53lwwkrqhv28a.xn--lve-6lad.not-web-platform.test,xn--lve-6lad.www.web-platform.test,www.www.web-platform.test,www1.xn--lve-6lad.web-platform.test,xn--lve-6lad.www2.web-platform.test,www.www2.web-platform.test,www2.www.web-platform.test,xn--n8j6ds53lwwkrqhv28a.www2.not-web-platform.test,www1.www.web-platform.test,www.xn--lve-6lad.web-platform.test,www.www.not-web-platform.test,xn--lve-6lad.xn--lve-6lad.web-platform.test,xn--lve-6lad.www1.not-web-platform.test,www1.www1.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.www2.web-platform.test,xn--n8j6ds53lwwkrqhv28a.www1.not-web-platform.test,www2.www2.web-platform.test,xn--lve-6lad.web-platform.test,xn--n8j6ds53lwwkrqhv28a.web-platform.test,xn--n8j6ds53lwwkrqhv28a.www.web-platform.test,xn--lve-6lad.not-web-platform.test,www2.xn--n8j6ds53lwwkrqhv28a.not-web-platform.test,www2.xn--lve-6lad.not-web-platform.test,xn--n8j6ds53lwwkrqhv28a.xn--lve-6lad.web-platform.test,www1.xn--lve-6lad.not-web-platform.test,www1.web-platform.test,www.www1.web-platform.test,www2.web-platform.test,www.xn--lve-6lad.not-web-platform.test,www.web-platform.test,xn--lve-6lad.xn--n8j6ds53lwwkrqhv28a.web-platform.test,www1.www2.not-web-platform.test,www2.www1.web-platform.test,www.www1.not-web-platform.test,www.xn--n8j6ds53lwwkrqhv28a.web-platform.test,xn--lve-6lad.www2.not-web-platform.test,www2.www.not-web-platform.test"}}}}}
13:44:55 INFO - PID 4052 | 1563457495216 mozrunner::runner INFO Running command: "Z:\task_1563450804\build\application\firefox\firefox.exe" "-marionette" "-foreground" "-no-remote" "-profile" "C:\Users\task_1563450804\AppData\Local\Temp\rust_mozprofilegKVNHI"
13:44:55 INFO - PID 4052 | 1563457495221 geckodriver::marionette DEBUG Waiting 60s to connect to browser on 127.0.0.1:2828
13:44:55 INFO - PID 4052 | [5168, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file z:/build/build/src/extensions/permissions/nsPermissionManager.cpp, line 2903
13:44:55 INFO - PID 4052 | Hit MOZ_CRASH(Bad canary value 0x534dc0f5 in FromData) at z:/build/build/src/xpcom/string/nsSubstring.cpp:330
13:44:55 INFO - PID 4052 | #01: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x4e91b]
13:44:55 INFO - PID 4052 | #02: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x543e9]
13:44:55 INFO - PID 4052 | #03: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x4cd55]
13:44:55 INFO - PID 4052 | #04: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0xc7732]
13:44:55 INFO - PID 4052 | #05: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x253cb8]
13:44:55 INFO - PID 4052 | #06: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x24e871]
13:44:55 INFO - PID 4052 | #07: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x1a86b8]
13:44:55 INFO - PID 4052 | #08: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x1d6061]
13:44:55 INFO - PID 4052 | #09: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x140416]
13:44:55 INFO - PID 4052 | #10: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x13ab9f]
13:44:55 INFO - PID 4052 | #11: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x13ddb4]
13:44:55 INFO - PID 4052 | #12: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x7f69fa]
13:44:55 INFO - PID 4052 | #13: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x7a6911]
13:44:55 INFO - PID 4052 | #14: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x7a682c]
13:44:55 INFO - PID 4052 | #15: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x7a66ff]
13:44:55 INFO - PID 4052 | #16: Ordinal0[Z:\task_1563450804\build\application\firefox\xul.dll +0x13763b]
13:44:55 INFO - PID 4052 | #17: PRP_TryLock[Z:\task_1563450804\build\application\firefox\nss3.dll +0x135168]
13:44:55 INFO - PID 4052 | #18: PR_MD_UNLOCK[Z:\task_1563450804\build\application\firefox\nss3.dll +0x123b9d]
13:44:55 INFO - PID 4052 | #19: o____lc_collate_cp_func[Z:\task_1563450804\build\application\firefox\ucrtbase.DLL +0x3e16f]
13:44:55 INFO - PID 4052 | #20: BaseThreadInitThunk[C:\windows\system32\kernel32.dll +0x4ef3c]
13:44:55 INFO - PID 4052 | #21: DllBlocklist_Initialize[Z:\task_1563450804\build\application\firefox\mozglue.dll +0x6a19]
13:44:55 INFO - PID 4052 | #22: RtlInitializeExceptionChain[C:\windows\SYSTEM32\ntdll.dll +0x63618]
13:44:55 INFO - PID 4052 | #23: RtlInitializeExceptionChain[C:\windows\SYSTEM32\ntdll.dll +0x635eb]
13:44:55 INFO - PID 4052 | [Socket 4684, Main Thread] WARNING: Shutting down Socket process early due to a crash!: file z:/build/build/src/netwerk/ipc/SocketProcessChild.cpp, line 100
13:44:56 INFO - PID 4052 | 1563457496318 mozrunner::runner DEBUG Killing process 4848
13:44:56 INFO - PID 4052 | 1563457496318 webdriver::server DEBUG <- 500 Internal Server Error {"value":{"error":"unknown error","message":"permission denied","stacktrace":""}}
13:44:56 INFO - STDOUT: FAILED
13:44:56 INFO - STDOUT: ================================== FAILURES ===================================
13:44:56 INFO - STDOUT: ____________________________ test_pageLoadStrategy ____________________________
13:44:56 INFO - STDOUT: new_session = <function new_session at 0x0412BB70>
13:44:56 INFO - STDOUT: add_browser_capabilities = <function add_browser_capabilities at 0x0412BDF0>
13:44:56 INFO - STDOUT: def test_pageLoadStrategy(new_session, add_browser_capabilities):
13:44:56 INFO - STDOUT: response, _ = new_session({"capabilities": {
13:44:56 INFO - STDOUT: "alwaysMatch": add_browser_capabilities({"pageLoadStrategy": "eager"})}})
13:44:56 INFO - STDOUT: > value = assert_success(response)
13:44:56 INFO - STDOUT: _ = None
13:44:56 INFO - STDOUT: add_browser_capabilities = <function add_browser_capabilities at 0x0412BDF0>
13:44:56 INFO - STDOUT: new_session = <function new_session at 0x0412BB70>
13:44:56 INFO - STDOUT: response = <Response status=500 error=<UnknownErrorException http_status=500>>
13:44:56 INFO - STDOUT: tests\web-platform\tests\webdriver\tests\new_session\page_load_strategy.py
13:44:56 INFO - STDOUT: :6:
13:44:56 INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
13:44:56 INFO - STDOUT: response = <Response status=500 error=<UnknownErrorException http_status=500>>
13:44:56 INFO - STDOUT: value = None
13:44:56 INFO - STDOUT: def assert_success(response, value=None):
13:44:56 INFO - STDOUT: """
13:44:56 INFO - STDOUT: Verify that the provided webdriver.Response instance described
13:44:56 INFO - STDOUT: a valid success response as defined by dfn-send-a-response and
13:44:56 INFO - STDOUT: the provided response value.
13:44:56 INFO - STDOUT:
13:44:56 INFO - STDOUT: :param response: webdriver.Response instance.
13:44:56 INFO - STDOUT: :param value: Expected value of the response body, if any.
13:44:56 INFO - STDOUT: """
13:44:56 INFO - STDOUT: > assert response.status == 200, str(response.error)
13:44:56 INFO - STDOUT: E AssertionError: unknown error (500): permission denied
13:44:56 INFO - STDOUT: E
13:44:56 INFO - STDOUT: E assert 500 == 200
13:44:56 INFO - STDOUT: E + where 500 = <Response status=500 error=<UnknownErrorException http_status=500>>.status
13:44:56 INFO - STDOUT: response = <Response status=500 error=<UnknownErrorException http_status=500>>
13:44:56 INFO - STDOUT: value = None
13:44:56 INFO - STDOUT: tests\web-platform\tests\webdriver\tests\support\asserts.py
13:44:56 INFO - STDOUT: :67: AssertionError
13:44:56 INFO - STDOUT: ============================== warnings summary ===============================
13:44:56 INFO - STDOUT: <undetermined location>
13:44:56 INFO - STDOUT: Module already imported so cannot be rewritten: mozlog
13:44:56 INFO - STDOUT: Module already imported so cannot be rewritten: tests.support.fixtures
13:44:56 INFO - STDOUT: -- Docs: http://doc.pytest.org/en/latest/warnings.html
13:44:56 INFO - STDOUT: ==================== 1 failed, 2 warnings in 1.15 seconds =====================
13:44:56 INFO -
13:44:56 INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/new_session/page_load_strategy.py | test_pageLoadStrategy - AssertionError: unknown error (500): permission denied
13:44:56 INFO - new_session = <function new_session at 0x0412BB70>
13:44:56 INFO - add_browser_capabilities = <function add_browser_capabilities at 0x0412BDF0>
13:44:56 INFO -
13:44:56 INFO - def test_pageLoadStrategy(new_session, add_browser_capabilities):
13:44:56 INFO - response, _ = new_session({"capabilities": {
13:44:56 INFO - "alwaysMatch": add_browser_capabilities({"pageLoadStrategy": "eager"})}})
13:44:56 INFO - > value = assert_success(response)
13:44:56 INFO -
13:44:56 INFO - _ = None
13:44:56 INFO - add_browser_capabilities = <function add_browser_capabilities at 0x0412BDF0>
13:44:56 INFO - new_session = <function new_session at 0x0412BB70>
13:44:56 INFO - response = <Response status=500 error=<UnknownErrorException http_status=500>>
13:44:56 INFO -
13:44:56 INFO - tests\web-platform\tests\webdriver\tests\new_session\page_load_strategy.py:6:
13:44:56 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
13:44:56 INFO -
13:44:56 INFO - response = <Response status=500 error=<UnknownErrorException http_status=500>>

This is due to Bad canary value, and as such a dupe of bug 1517538.

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
Moving bug to Remote Protocol::Marionette component per bug 1815831.
Component: geckodriver → Marionette
Product: Testing → Remote Protocol
You need to log in before you can comment on or make changes to this bug.