Closed Bug 1725620 Opened 3 years ago Closed 3 years ago

Permanent TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/session_subscribe/subscribe.py | expected OK when Gecko 93 merges to Beta on 2021-09-06

Categories

(Remote Protocol :: WebDriver BiDi, defect, P2)

Product:
Remote Protocol
Component:
WebDriver BiDi
Type:
defect
Points:
2

Tracking

(firefox-esr78 unaffected, firefox-esr91 unaffected, firefox91 unaffected, firefox92 unaffected, firefox93+ verified)

Status:
VERIFIED FIXED
Milestone:
93 Branch
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox-esr91 --- unaffected
firefox91 --- unaffected
firefox92 --- unaffected
firefox93 + verified

People

(Reporter: aryx, Assigned: whimboo)

References

(Regression)

Details

(Keywords: regression, Whiteboard: [bidi-m1-mvp])

Attachments

(1 file)

Bug 1725620 - [wdspec] Disable session.subscribe tests for beta and release.
48 bytes, text/x-phabricator-request
Details | Review

There is much log before, STDOUT: ERROR is mentioned several times.

[task 2021-08-13T12:19:48.499Z] 12:19:48     INFO - STDOUT: ERROR
[task 2021-08-13T12:19:48.503Z] 12:19:48     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/bidi/session_subscribe/subscribe.py::test_params_events_empty 
[task 2021-08-13T12:19:48.503Z] 12:19:48     INFO - PID 1277 | 1628857188498	webdriver::server	DEBUG	-> POST /session {"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile", "/tmp/tmpjpl623p8.mozrunner"], "binary": "/builds/worker/workspace/build/application/firefox/firefox"}, "webSocketUrl": true}}}
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188498	geckodriver::capabilities	DEBUG	Trying to read firefox version from ini files
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188499	geckodriver::capabilities	DEBUG	Found version 93.0
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188499	geckodriver::browser	DEBUG	Backing up prefs to "/tmp/tmpjpl623p8.mozrunner/user.geckodriver_backup_1"
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188506	mozrunner::runner	INFO	Running command: "/builds/worker/workspace/build/application/firefox/firefox" "--marionette" "--profile" "/tmp/tmpjpl623p8.mozrunner" "--remote-debugging-port" "9222" "-no-remote"
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188508	geckodriver::marionette	DEBUG	Waiting 60s to connect to browser on 127.0.0.1:2828
[task 2021-08-13T12:19:48.513Z] 12:19:48     INFO - PID 1277 | 1628857188509	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:48.611Z] 12:19:48     INFO - PID 1277 | 1628857188609	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:48.644Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker OS.File: flush pending requests, warn about unclosed files, shut down service. for phase xpcom-will-shutdown
[task 2021-08-13T12:19:48.646Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker OS.File: flush I/O queued before profileBeforeChange for phase profile-before-change
[task 2021-08-13T12:19:48.648Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker AddonManager: shutting down. for phase profile-before-change
[task 2021-08-13T12:19:48.658Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker IOUtils Blocker (profile-before-change) for phase profile-before-change
[task 2021-08-13T12:19:48.659Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker IOUtils Blocker (xpcom-will-shutdown) for phase xpcom-will-shutdown
[task 2021-08-13T12:19:48.665Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker XPIProvider shutdown for phase quit-application-granted
[task 2021-08-13T12:19:48.666Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker XPIProvider for phase AddonManager: Waiting for providers to shut down.
[task 2021-08-13T12:19:48.667Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker ServiceWorkerRegistrar: Flushing data for phase profile-before-change
[task 2021-08-13T12:19:48.668Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker CrashMonitor: Writing notifications to file after receiving profile-before-change for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-08-13T12:19:48.672Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker TelemetryController: shutting down for phase profile-before-change-telemetry
[task 2021-08-13T12:19:48.711Z] 12:19:48     INFO - PID 1277 | 1628857188709	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:48.811Z] 12:19:48     INFO - PID 1277 | 1628857188809	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:48.912Z] 12:19:48     INFO - PID 1277 | 1628857188910	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:48.927Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker EnvironmentAddonBuilder for phase AddonManager: Waiting to start provider shutdown.
[task 2021-08-13T12:19:48.931Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker RemoteSettingsClient - finish IDB access. for phase profile-before-change
[task 2021-08-13T12:19:48.934Z] 12:19:48     INFO - PID 1277 | 1628857188931	RemoteAgent	DEBUG	CDP enabled
[task 2021-08-13T12:19:48.935Z] 12:19:48     INFO - PID 1277 | 1628857188931	Marionette	INFO	Marionette enabled
[task 2021-08-13T12:19:48.959Z] 12:19:48     INFO - PID 1277 | 1628857188957	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2021-08-13T12:19:48.969Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker ClientManagerService: start destroying IPC actors early for phase xpcom-will-shutdown
[task 2021-08-13T12:19:48.984Z] 12:19:48     INFO - PID 1277 | DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-08-13T12:19:49.012Z] 12:19:49     INFO - PID 1277 | 1628857189010	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.026Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker MediaShutdownManager: shutdown for phase profile-before-change
[task 2021-08-13T12:19:49.038Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-08-13T12:19:49.112Z] 12:19:49     INFO - PID 1277 | 1628857189110	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.152Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker GMPProvider for phase AddonManager: Waiting for providers to shut down.
[task 2021-08-13T12:19:49.156Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker ContentParent: id=7f095e7be800 for phase xpcom-will-shutdown
[task 2021-08-13T12:19:49.158Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker ContentParent: id=7f095e7be800 for phase profile-before-change
[task 2021-08-13T12:19:49.181Z] 12:19:49     INFO - PID 1277 | DEBUG: Adding blocker ServiceWorkerShutdownBlocker: shutting down Service Workers for phase profile-change-teardown
[task 2021-08-13T12:19:49.212Z] 12:19:49     INFO - PID 1277 | 1628857189211	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.312Z] 12:19:49     INFO - PID 1277 | 1628857189311	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.412Z] 12:19:49     INFO - PID 1277 | 1628857189411	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.513Z] 12:19:49     INFO - PID 1277 | 1628857189511	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.613Z] 12:19:49     INFO - PID 1277 | 1628857189611	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.713Z] 12:19:49     INFO - PID 1277 | 1628857189712	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.813Z] 12:19:49     INFO - PID 1277 | 1628857189812	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:49.913Z] 12:19:49     INFO - PID 1277 | 1628857189912	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:50.014Z] 12:19:50     INFO - PID 1277 | 1628857190012	geckodriver::marionette	TRACE	Connection refused (os error 111). Retrying in 100ms
[task 2021-08-13T12:19:50.110Z] 12:19:50     INFO - TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/session_subscribe/subscribe.py | expected OK
Flags: needinfo?(hskupin)
Assignee: nobody → hskupin
Status: NEW → ASSIGNED
Pushed by hskupin@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/a6fae5b1ac2f
[wdspec] Disable session.subscribe tests for beta and release. r=webdriver-reviewers,jgraham

Regression from a M1 bug. As such this bug also needs to be tracked.

Points: --- → 2
Flags: needinfo?(hskupin)
Keywords: regression
Priority: -- → P2
Whiteboard: [bidi-m1-mvp]

https://hg.mozilla.org/mozilla-central/rev/a6fae5b1ac2f

Status: ASSIGNED → RESOLVED
Closed: 3 years ago
status-firefox93: affected → fixed
Resolution: --- → FIXED
Target Milestone: --- → 93 Branch

Verified fixed as of today's central-as-early-beta simulation.

Status: RESOLVED → VERIFIED
status-firefox93: fixed → verified
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: