1807655 - Intermittent dom/svg/test/test_use_with_hsts.html | single tracking bug

Status: RESOLVED INCOMPLETE

(Core :: SVG, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-12-27T10:12:42.319Z] 10:12:42     INFO - TEST-START | dom/svg/test/test_use_with_hsts.html
[task 2022-12-27T10:12:43.669Z] 10:12:43     INFO - GECKO(5690) | (firefox-default:5690): Gdk-ERROR **: 10:12:43.665: The program 'firefox-default' received an X Window System error.
[task 2022-12-27T10:12:43.669Z] 10:12:43     INFO - GECKO(5690) | This probably reflects a bug in the program.
[task 2022-12-27T10:12:43.670Z] 10:12:43     INFO - GECKO(5690) | The error was 'BadShmSeg (invalid shared segment parameter)'.
[task 2022-12-27T10:12:43.671Z] 10:12:43     INFO - GECKO(5690) |   (Details: serial 933 error_code 128 request_code 130 (MIT-SHM) minor_code 2)
[task 2022-12-27T10:12:43.672Z] 10:12:43     INFO - GECKO(5690) |   (Note to programmers: normally, X errors are reported asynchronously;
[task 2022-12-27T10:12:43.673Z] 10:12:43     INFO - GECKO(5690) |    that is, you will receive the error a while after causing it.
[task 2022-12-27T10:12:43.673Z] 10:12:43     INFO - GECKO(5690) |    To debug your program, run it with the GDK_SYNCHRONIZE environment
[task 2022-12-27T10:12:43.674Z] 10:12:43     INFO - GECKO(5690) |    variable to change this behavior. You can then get a meaningful
[task 2022-12-27T10:12:43.675Z] 10:12:43     INFO - GECKO(5690) |    backtrace from your debugger if you break on the gdk_x_error() function.)
[task 2022-12-27T10:12:43.716Z] 10:12:43     INFO - GECKO(5690) | Exiting due to channel error.
[task 2022-12-27T10:12:43.716Z] 10:12:43     INFO - GECKO(5690) | Exiting due to channel error.
[task 2022-12-27T10:12:43.716Z] 10:12:43     INFO - GECKO(5690) | Exiting due to channel error.
[task 2022-12-27T10:12:43.716Z] 10:12:43     INFO - GECKO(5690) | Exiting due to channel error.
[task 2022-12-27T10:12:43.758Z] 10:12:43     INFO - TEST-INFO | Main app process: killed by SIGTRAP
[task 2022-12-27T10:12:43.758Z] 10:12:43     INFO - Buffered messages finished
[task 2022-12-27T10:12:43.758Z] 10:12:43    ERROR - TEST-UNEXPECTED-FAIL | dom/svg/test/test_use_with_hsts.html | application terminated with exit code -5
[task 2022-12-27T10:12:43.761Z] 10:12:43     INFO - runtests.py | Application ran for: 0:00:07.009461
[task 2022-12-27T10:12:43.761Z] 10:12:43     INFO - zombiecheck | Reading PID log: /tmp/tmpcfi9btaspidlog
[task 2022-12-27T10:12:43.762Z] 10:12:43     INFO - ==> process 5690 launched child process 5710
[task 2022-12-27T10:12:43.762Z] 10:12:43     INFO - ==> process 5690 launched child process 5753
[task 2022-12-27T10:12:43.762Z] 10:12:43     INFO - ==> process 5690 launched child process 5779
[task 2022-12-27T10:12:43.763Z] 10:12:43     INFO - ==> process 5690 launched child process 5801
[task 2022-12-27T10:12:43.763Z] 10:12:43     INFO - ==> process 5690 launched child process 5842
[task 2022-12-27T10:12:43.764Z] 10:12:43     INFO - zombiecheck | Checking for orphan process with PID: 5801
[task 2022-12-27T10:12:43.764Z] 10:12:43     INFO - zombiecheck | Checking for orphan process with PID: 5710
[task 2022-12-27T10:12:43.765Z] 10:12:43     INFO - zombiecheck | Checking for orphan process with PID: 5842
[task 2022-12-27T10:12:43.765Z] 10:12:43     INFO - zombiecheck | Checking for orphan process with PID: 5779
[task 2022-12-27T10:12:43.766Z] 10:12:43     INFO - zombiecheck | Checking for orphan process with PID: 5753
[task 2022-12-27T10:12:43.766Z] 10:12:43     INFO - Stopping web server
[task 2022-12-27T10:12:43.773Z] 10:12:43     INFO - Server shut down.
[task 2022-12-27T10:12:43.790Z] 10:12:43     INFO - Web server killed.
[task 2022-12-27T10:12:43.790Z] 10:12:43     INFO - Stopping web socket server
[task 2022-12-27T10:12:43.810Z] 10:12:43     INFO - Stopping ssltunnel
[task 2022-12-27T10:12:43.831Z] 10:12:43     INFO - Stopping gst for v4l2loopback
[task 2022-12-27T10:12:43.831Z] 10:12:43  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-12-27T10:12:43.832Z] 10:12:43     INFO - runtests.py | Running tests: end.
[task 2022-12-27T10:12:43.864Z] 10:12:43     INFO - Buffered messages finished
[task 2022-12-27T10:12:43.865Z] 10:12:43     INFO - Running manifest: dom/tests/mochitest/ajax/jquery/mochitest.ini
[task 2022-12-27T10:12:43.891Z] 10:12:43     INFO -  Setting pipeline to PAUSED ...
[task 2022-12-27T10:12:43.892Z] 10:12:43     INFO -  Pipeline is PREROLLING ...
[task 2022-12-27T10:12:43.895Z] 10:12:43     INFO -  Pipeline is PREROLLED ...
[task 2022-12-27T10:12:43.896Z] 10:12:43     INFO -  Setting pipeline to PLAYING ...
[task 2022-12-27T10:12:43.896Z] 10:12:43     INFO -  New clock: GstSystemClock
[task 2022-12-27T10:12:43.909Z] 10:12:43     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-12-27T10:12:43.913Z] 10:12:43     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-12-27T10:12:43.913Z] 10:12:43     INFO - UBSan enabled.
[task 2022-12-27T10:12:43.929Z] 10:12:43     INFO -  Got EOS from element "pipeline0".
[task 2022-12-27T10:12:43.930Z] 10:12:43     INFO -  Execution ended after 0:00:00.033129447
[task 2022-12-27T10:12:43.930Z] 10:12:43     INFO -  Setting pipeline to PAUSED ...
[task 2022-12-27T10:12:43.930Z] 10:12:43     INFO -  Setting pipeline to READY ...
[task 2022-12-27T10:12:43.933Z] 10:12:43     INFO -  (gst-launch-1.0:5885): GStreamer-CRITICAL **: 10:12:43.930: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2022-12-27T10:12:43.933Z] 10:12:43     INFO -  Setting pipeline to NULL ...
[task 2022-12-27T10:12:43.933Z] 10:12:43     INFO -  Freeing pipeline ...
[task 2022-12-27T10:12:44.006Z] 10:12:44     INFO - PID 5905 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2022-12-27T10:12:44.164Z] 10:12:44     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-12-27T10:12:44.169Z] 10:12:44     INFO - LSan enabled.
[task 2022-12-27T10:12:44.169Z] 10:12:44     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-12-27T10:12:44.170Z] 10:12:44     INFO - UBSan enabled.
[task 2022-12-27T10:12:44.171Z] 10:12:44     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-12-27T10:12:44.173Z] 10:12:44     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-12-27T10:12:44.173Z] 10:12:44     INFO - UBSan enabled.
[task 2022-12-27T10:12:44.182Z] 10:12:44     INFO - MochitestServer : launching ['/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpt3qqqn23.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2022-12-27T10:12:44.182Z] 10:12:44     INFO - runtests.py | Server pid: 5921
[task 2022-12-27T10:12:44.204Z] 10:12:44     INFO - runtests.py | Websocket server pid: 5924
[task 2022-12-27T10:12:44.204Z] 10:12:44     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-12-27T10:12:44.219Z] 10:12:44     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-12-27T10:12:44.219Z] 10:12:44     INFO - UBSan enabled.
[task 2022-12-27T10:12:44.241Z] 10:12:44     INFO - runtests.py | SSL tunnel pid: 5930
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with scheme: http
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with e10s: True
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with fission: False
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with cross-origin iframes: False
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - runtests.py | Running tests: start.
[task 2022-12-27T10:12:44.447Z] 10:12:44     INFO - 
[task 2022-12-27T10:12:44.467Z] 10:12:44     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpt3qqqn23.mozrunner
[task 2022-12-27T10:12:44.479Z] 10:12:44     INFO - runtests.py | Application pid: 5947
[task 2022-12-27T10:12:44.479Z] 10:12:44     INFO - TEST-INFO | started process GECKO(5947)
[task 2022-12-27T10:12:45.468Z] 10:12:45     INFO - GECKO(5947) | 1672135965467	Marionette	INFO	Marionette enabled
[task 2022-12-27T10:12:45.473Z] 10:12:45     INFO - GECKO(5947) | 1672135965472	Marionette	TRACE	Received observer notification final-ui-startup
[task 2022-12-27T10:12:45.476Z] 10:12:45     INFO - GECKO(5947) | 1672135965476	Marionette	INFO	Listening on port 2828
[task 2022-12-27T10:12:45.477Z] 10:12:45     INFO - GECKO(5947) | 1672135965476	Marionette	DEBUG	Marionette is listening
[task 2022-12-27T10:12:45.698Z] 10:12:45     INFO - GECKO(5947) | 1672135965697	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:50204
[task 2022-12-27T10:12:45.754Z] 10:12:45     INFO - GECKO(5947) | 1672135965753	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:50206
[task 2022-12-27T10:12:45.756Z] 10:12:45     INFO - GECKO(5947) | 1672135965754	Marionette	DEBUG	Closed connection 0
[task 2022-12-27T10:12:46.120Z] 10:12:46     INFO - GECKO(5947) | 1672135966118	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-12-27T10:12:46.129Z] 10:12:46     INFO - GECKO(5947) | 1672135966128	Marionette	DEBUG	Waiting for initial application window
[task 2022-12-27T10:12:48.218Z] 10:12:48     INFO - GECKO(5947) | console.error: (new UnknownCollectionError("Unknown Collection \"main/query-stripping\"", "resource://services-settings/RemoteSettingsClient.jsm", 197))
[task 2022-12-27T10:12:48.851Z] 10:12:48     INFO - GECKO(5947) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpt3qqqn23.mozrunner/search.json.mozlz4", (void 0)))
[task 2022-12-27T10:12:50.781Z] 10:12:50     INFO - GECKO(5947) | console.error: (new UnknownCollectionError("Unknown Collection \"main/quicksuggest\"", "resource://services-settings/RemoteSettingsClient.jsm", 197))
[task 2022-12-27T10:12:50.784Z] 10:12:50     INFO - GECKO(5947) | console.error: (new UnknownCollectionError("Unknown Collection \"main/quicksuggest\"", "resource://services-settings/RemoteSettingsClient.jsm", 197))
[task 2022-12-27T10:12:50.785Z] 10:12:50     INFO - GECKO(5947) | console.error: (new UnknownCollectionError("Unknown Collection \"main/quicksuggest\"", "resource://services-settings/RemoteSettingsClient.jsm", 197))
[task 2022-12-27T10:12:50.951Z] 10:12:50     INFO - GECKO(5947) | 1672135970948	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
[task 2022-12-27T10:12:50.971Z] 10:12:50     INFO - GECKO(5947) | 1672135970970	RemoteAgent	TRACE	[9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=1600 waitForExplicitStart=false
[task 2022-12-27T10:12:50.976Z] 10:12:50     INFO - GECKO(5947) | 1672135970975	RemoteAgent	TRACE	[9] ProgressListener Setting unload timer (1600ms)
[task 2022-12-27T10:12:50.980Z] 10:12:50     INFO - GECKO(5947) | 1672135970979	RemoteAgent	TRACE	[9] Document already finished loading: about:blank
[task 2022-12-27T10:12:50.983Z] 10:12:50     INFO - GECKO(5947) | 1672135970982	RemoteAgent	TRACE	[9] ProgressListener Stop: has error=false
[task 2022-12-27T10:12:51.028Z] 10:12:51     INFO - GECKO(5947) | 1672135971026	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"57007dcc-c07f-41c5-9101-390a7b30fe53","capabilities":{"browserName":"firefox","browserVersion":"110.0a1","platformName":"linux","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","moz:accessibilityChecks":false,"moz:buildID":"20221227091807","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":5947,"moz:profile":"/tmp/tmpt3qqqn23.mozrunner","moz:shutdownTimeout":300000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2022-12-27T10:12:51.060Z] 10:12:51     INFO - GECKO(5947) | 1672135971059	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpyplm6zzm.zip","temporary":false}]
[task 2022-12-27T10:12:51.304Z] 10:12:51     INFO - GECKO(5947) | 1672135971303	Marionette	DEBUG	1 <- [1,2,null,{"value":"[e-mail]"}]
[task 2022-12-27T10:12:51.343Z] 10:12:51     INFO - GECKO(5947) | 1672135971342	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/tmp/tmp_fopnf86.zip","temporary":false}]
[task 2022-12-27T10:12:51.397Z] 10:12:51     INFO - GECKO(5947) | 1672135971396	Marionette	DEBUG	1 <- [1,3,null,{"value":"[e-mail]"}]
[task 2022-12-27T10:12:51.401Z] 10:12:51     INFO - GECKO(5947) | 1672135971400	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2022-12-27T10:12:51.405Z] 10:12:51     INFO - GECKO(5947) | 1672135971401	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2022-12-27T10:12:51.408Z] 10:12:51     INFO - GECKO(5947) | 1672135971404	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-12-27T10:12:51.413Z] 10:12:51     INFO - GECKO(5947) | 1672135971404	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2022-12-27T10:12:51.415Z] 10:12:51     INFO - GECKO(5947) | 1672135971406	Marionette	DEBUG	1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distr ... s which flavor and url to load.\nlet ev = new CustomEvent(\"mochitest-load\", { detail: [flavor, url] });\nwin.dispatchEvent(ev);","args":[{"flavor":"mochitest","testUrl":"http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true"}],"newSandbox":true,"sandbox":"default","line":2025,"filename":"tests/mochitest/runtests.py"}]
[task 2022-12-27T10:12:51.424Z] 10:12:51     INFO - GECKO(5947) | 1672135971423	Marionette	TRACE	[1] MarionetteCommands actor created for window id 2
[task 2022-12-27T10:12:51.440Z] 10:12:51     INFO - GECKO(5947) | 1672135971439	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2022-12-27T10:12:51.447Z] 10:12:51     INFO - GECKO(5947) | 1672135971442	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2022-12-27T10:12:51.449Z] 10:12:51     INFO - GECKO(5947) | 1672135971443	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2022-12-27T10:12:51.452Z] 10:12:51     INFO - GECKO(5947) | 1672135971445	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2022-12-27T10:12:51.453Z] 10:12:51     INFO - GECKO(5947) | 1672135971452	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2022-12-27T10:12:51.455Z] 10:12:51     INFO - runtests.py | Waiting for browser...
[task 2022-12-27T10:12:51.457Z] 10:12:51     INFO - GECKO(5947) | 1672135971456	Marionette	DEBUG	Closed connection 1
[task 2022-12-27T10:12:52.123Z] 10:12:52     INFO - TEST-START | dom/tests/mochitest/ajax/jquery/test_jQuery.html
[task 2022-12-27T10:12:53.910Z] 10:12:53     INFO - GECKO(5947) | JavaScript warning: http://mochi.test:8888/tests/dom/tests/mochitest/ajax/jquery/test/unit/core.js, line 1613: unreachable code after return statement
[task 2022-12-27T10:13:09.026Z] 10:13:09     INFO - GECKO(5947) | ALSA lib seq_hw.c:466:(snd_seq_hw_open) open /dev/snd/seq failed: No such file or directory
[task 2022-12-27T10:13:12.464Z] 10:13:12     INFO - GECKO(5947) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2022-12-27T10:13:12.465Z] 10:13:12     INFO - GECKO(5947) | MEMORY STAT heapAllocated not supported in this build configuration.
[task 2022-12-27T10:13:12.465Z] 10:13:12     INFO - GECKO(5947) | MEMORY STAT | vsize 20974651MB | residentFast 802MB
[task 2022-12-27T10:13:12.543Z] 10:13:12     INFO - TEST-OK | dom/tests/mochitest/ajax/jquery/test_jQuery.html | took 20420ms

Comment 1

[Intermittent Failures Robot]

1 failures in 1328 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1807655&startday=2022-12-26&endday=2023-01-01&tree=all

Comment 2

[Intermittent Failures Robot]

2 failures in 3717 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1
• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1807655&startday=2023-01-16&endday=2023-01-22&tree=all

Comment 3

[Intermittent Failures Robot]

2 failures in 3914 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 1
  • opt: 1
• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1807655&startday=2023-01-23&endday=2023-01-29&tree=all

Comment 4

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.