Closed
Bug 1768764
Opened 3 years ago
Closed 3 years ago
Intermittent LeakSanitizer | leak at PR_NewMonitor, ReentrantMonitor, nsPipe::nsPipe, NS_NewPipe2
Categories
(Core :: DOM: Networking, defect, P5)
Core
DOM: Networking
Tracking
()
RESOLVED
FIXED
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=377636689&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Id3a8F1ORy2FE1mEaGj7lw/runs/0/artifacts/public/logs/live_backing.log
[task 2022-05-11T01:37:08.502Z] 01:37:08 INFO - TEST-START | dom/tests/mochitest/fetch/test_temporaryFileBlob.html
[task 2022-05-11T01:37:09.652Z] 01:37:09 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:09.654Z] 01:37:09 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:09.655Z] 01:37:09 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:09.656Z] 01:37:09 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:09.657Z] 01:37:09 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:09.657Z] 01:37:09 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:17.243Z] 01:37:17 INFO - GECKO(8979) | MEMORY STAT | vsize 20974662MB | residentFast 857MB
[task 2022-05-11T01:37:17.256Z] 01:37:17 INFO - TEST-OK | dom/tests/mochitest/fetch/test_temporaryFileBlob.html | took 8755ms
[task 2022-05-11T01:37:17.361Z] 01:37:17 INFO - TEST-START | Shutdown
[task 2022-05-11T01:37:17.366Z] 01:37:17 INFO - Passed: 16846
[task 2022-05-11T01:37:17.368Z] 01:37:17 INFO - Failed: 0
[task 2022-05-11T01:37:17.370Z] 01:37:17 INFO - Todo: 0
[task 2022-05-11T01:37:17.373Z] 01:37:17 INFO - Mode: e10s
[task 2022-05-11T01:37:17.375Z] 01:37:17 INFO - Slowest: 14769ms - /tests/dom/tests/mochitest/fetch/test_fetch_cors_sw_reroute.html
[task 2022-05-11T01:37:17.380Z] 01:37:17 INFO - SimpleTest FINISHED
[task 2022-05-11T01:37:17.383Z] 01:37:17 INFO - TEST-INFO | Ran 1 Loops
[task 2022-05-11T01:37:17.384Z] 01:37:17 INFO - SimpleTest FINISHED
[task 2022-05-11T01:37:17.600Z] 01:37:17 INFO - GECKO(8979) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: NotFoundError: No such JSWindowActor 'SpecialPowers'
[task 2022-05-11T01:37:17.649Z] 01:37:17 INFO - GECKO(8979) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: NotFoundError: No such JSWindowActor 'AppTestDelegate'
[task 2022-05-11T01:37:17.650Z] 01:37:17 INFO - GECKO(8979) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: NotFoundError: No such JSWindowActor 'AppTestDelegate'
[task 2022-05-11T01:37:17.714Z] 01:37:17 INFO - GECKO(8979) | 1652233037713 Marionette TRACE Received observer notification quit-application
[task 2022-05-11T01:37:17.716Z] 01:37:17 INFO - GECKO(8979) | 1652233037713 Marionette INFO Stopped listening on port 2828
[task 2022-05-11T01:37:17.718Z] 01:37:17 INFO - GECKO(8979) | 1652233037715 Marionette DEBUG Marionette stopped listening
[task 2022-05-11T01:37:22.442Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.443Z] 01:37:22 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:22.443Z] 01:37:22 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:22.444Z] 01:37:22 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:22.445Z] 01:37:22 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:22.445Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.478Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.478Z] 01:37:22 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:22.479Z] 01:37:22 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:22.480Z] 01:37:22 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:22.480Z] 01:37:22 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:22.481Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.497Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.498Z] 01:37:22 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:22.499Z] 01:37:22 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:22.500Z] 01:37:22 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:22.500Z] 01:37:22 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:22.501Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.599Z] 01:37:22 INFO - GECKO(8979) | Waiting in WillDestroyCurrentMessageLoop for pid 9054
[task 2022-05-11T01:37:22.612Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.613Z] 01:37:22 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:22.613Z] 01:37:22 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:22.614Z] 01:37:22 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:22.614Z] 01:37:22 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:22.615Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.616Z] 01:37:22 INFO - GECKO(8979) | Waiting in WillDestroyCurrentMessageLoop for pid 9138
[task 2022-05-11T01:37:22.784Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:22.785Z] 01:37:22 INFO - GECKO(8979) | Suppressions used:
[task 2022-05-11T01:37:22.785Z] 01:37:22 INFO - GECKO(8979) | count bytes template
[task 2022-05-11T01:37:22.785Z] 01:37:22 INFO - GECKO(8979) | 12 384 nsComponentManagerImpl
[task 2022-05-11T01:37:22.785Z] 01:37:22 INFO - GECKO(8979) | 2 288 libfontconfig.so
[task 2022-05-11T01:37:22.785Z] 01:37:22 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:23.906Z] 01:37:23 INFO - GECKO(8979) | =================================================================
[task 2022-05-11T01:37:23.907Z] 01:37:23 ERROR - GECKO(8979) | ==9138==ERROR: LeakSanitizer: detected memory leaks
[task 2022-05-11T01:37:23.908Z] 01:37:23 INFO - GECKO(8979) | Indirect leak of 192 byte(s) in 1 object(s) allocated from:
[task 2022-05-11T01:37:23.949Z] 01:37:23 INFO - GECKO(8979) | #0 0x55fdba5d811e in malloc /builds/worker/fetches/llvm-project/compiler-rt/lib/asan/asan_malloc_linux.cpp:69:3
[task 2022-05-11T01:37:23.949Z] 01:37:23 INFO - GECKO(8979) | #1 0x55fdba61c0ad in moz_xmalloc /builds/worker/checkouts/gecko/memory/mozalloc/mozalloc.cpp:52:15
<...>
[task 2022-05-11T01:37:25.338Z] 01:37:25 INFO - GECKO(8979) | 1 9 libglib-2.0.so
[task 2022-05-11T01:37:25.339Z] 01:37:25 INFO - GECKO(8979) | 2 416 mozJSComponentLoader
[task 2022-05-11T01:37:25.339Z] 01:37:25 INFO - GECKO(8979) | -----------------------------------------------------
[task 2022-05-11T01:37:25.415Z] 01:37:25 INFO - TEST-INFO | Main app process: exit 0
[task 2022-05-11T01:37:25.417Z] 01:37:25 INFO - TEST-INFO | LeakSanitizer | To show the addresses of leaked objects add report_objects=1 to LSAN_OPTIONS
[task 2022-05-11T01:37:25.418Z] 01:37:25 INFO - TEST-INFO | LeakSanitizer | This can be done in testing/mozbase/mozrunner/mozrunner/utils.py
[task 2022-05-11T01:37:25.419Z] 01:37:25 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at PR_NewMonitor, ReentrantMonitor, nsPipe::nsPipe, NS_NewPipe2
[task 2022-05-11T01:37:25.420Z] 01:37:25 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NS_AsyncCopy, mozilla::ipc::InputStreamHelper::SerializeInputStreamAsPipe, mozilla::ipc::SerializeIPCStream, mozilla::ipc::SerializeIPCStream
[task 2022-05-11T01:37:25.421Z] 01:37:25 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Malloc, nsTArray_base, nsTArray_Impl, AppendElement
[task 2022-05-11T01:37:25.422Z] 01:37:25 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at NS_NewPipe2, mozilla::dom::FetchStreamReader::Create, mozilla::dom::Response::Constructor, mozilla::dom::Response_Binding::_constructor
[task 2022-05-11T01:37:25.424Z] 01:37:25 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at already_AddRefed, NS_NewCancelableRunnableFunction, CallbackHolder::CallbackHolder, nsPipeInputStream::AsyncWait
[task 2022-05-11T01:37:25.424Z] 01:37:25 INFO - runtests.py | Application ran for: 0:02:04.452636
[task 2022-05-11T01:37:25.425Z] 01:37:25 INFO - zombiecheck | Reading PID log: /tmp/tmp7ku50_a0pidlog
[task 2022-05-11T01:37:25.427Z] 01:37:25 INFO - ==> process 8979 launched child process 8996
[task 2022-05-11T01:37:25.427Z] 01:37:25 INFO - ==> process 8979 launched child process 9054
[task 2022-05-11T01:37:25.427Z] 01:37:25 INFO - ==> process 8979 launched child process 9076
[task 2022-05-11T01:37:25.428Z] 01:37:25 INFO - ==> process 8979 launched child process 9109
[task 2022-05-11T01:37:25.428Z] 01:37:25 INFO - ==> process 8979 launched child process 9138
[task 2022-05-11T01:37:25.429Z] 01:37:25 INFO - ==> process 8979 launched child process 9144
[task 2022-05-11T01:37:25.431Z] 01:37:25 INFO - ==> process 8979 launched child process 9194
[task 2022-05-11T01:37:25.432Z] 01:37:25 INFO - ==> process 8979 launched child process 9211
[task 2022-05-11T01:37:25.433Z] 01:37:25 INFO - ==> process 8979 launched child process 9258
[task 2022-05-11T01:37:25.433Z] 01:37:25 INFO - ==> process 8979 launched child process 9289
[task 2022-05-11T01:37:25.434Z] 01:37:25 INFO - ==> process 8979 launched child process 9310
[task 2022-05-11T01:37:25.434Z] 01:37:25 INFO - ==> process 8979 launched child process 9341
[task 2022-05-11T01:37:25.435Z] 01:37:25 INFO - ==> process 8979 launched child process 9374
[task 2022-05-11T01:37:25.435Z] 01:37:25 INFO - ==> process 8979 launched child process 9401
[task 2022-05-11T01:37:25.435Z] 01:37:25 INFO - ==> process 8979 launched child process 9431
[task 2022-05-11T01:37:25.436Z] 01:37:25 INFO - ==> process 8979 launched child process 9456
[task 2022-05-11T01:37:25.436Z] 01:37:25 INFO - ==> process 8979 launched child process 9478
[task 2022-05-11T01:37:25.437Z] 01:37:25 INFO - ==> process 8979 launched child process 9543
[task 2022-05-11T01:37:25.438Z] 01:37:25 INFO - ==> process 8979 launched child process 9618
[task 2022-05-11T01:37:25.438Z] 01:37:25 INFO - ==> process 8979 launched child process 9619
[task 2022-05-11T01:37:25.439Z] 01:37:25 INFO - ==> process 8979 launched child process 9641
[task 2022-05-11T01:37:25.440Z] 01:37:25 INFO - ==> process 8979 launched child process 9693
[task 2022-05-11T01:37:25.440Z] 01:37:25 INFO - ==> process 8979 launched child process 9695
[task 2022-05-11T01:37:25.440Z] 01:37:25 INFO - ==> process 8979 launched child process 9737
[task 2022-05-11T01:37:25.441Z] 01:37:25 INFO - ==> process 8979 launched child process 9739
[task 2022-05-11T01:37:25.441Z] 01:37:25 INFO - ==> process 8979 launched child process 9793
[task 2022-05-11T01:37:25.442Z] 01:37:25 INFO - ==> process 8979 launched child process 9815
[task 2022-05-11T01:37:25.442Z] 01:37:25 INFO - ==> process 8979 launched child process 9847
[task 2022-05-11T01:37:25.443Z] 01:37:25 INFO - ==> process 8979 launched child process 9870
[task 2022-05-11T01:37:25.443Z] 01:37:25 INFO - ==> process 8979 launched child process 9909
[task 2022-05-11T01:37:25.444Z] 01:37:25 INFO - ==> process 8979 launched child process 9931
[task 2022-05-11T01:37:25.444Z] 01:37:25 INFO - ==> process 8979 launched child process 9962
[task 2022-05-11T01:37:25.444Z] 01:37:25 INFO - ==> process 8979 launched child process 9990
[task 2022-05-11T01:37:25.445Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9478
[task 2022-05-11T01:37:25.445Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9990
[task 2022-05-11T01:37:25.445Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9737
[task 2022-05-11T01:37:25.446Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9739
[task 2022-05-11T01:37:25.447Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9870
[task 2022-05-11T01:37:25.447Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9618
[task 2022-05-11T01:37:25.448Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9619
[task 2022-05-11T01:37:25.448Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9109
[task 2022-05-11T01:37:25.448Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9374
[task 2022-05-11T01:37:25.449Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 8996
[task 2022-05-11T01:37:25.449Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9641
[task 2022-05-11T01:37:25.450Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9258
[task 2022-05-11T01:37:25.451Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9138
[task 2022-05-11T01:37:25.451Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9909
[task 2022-05-11T01:37:25.452Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9144
[task 2022-05-11T01:37:25.452Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9401
[task 2022-05-11T01:37:25.453Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9793
[task 2022-05-11T01:37:25.454Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9543
[task 2022-05-11T01:37:25.455Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9289
[task 2022-05-11T01:37:25.455Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9931
[task 2022-05-11T01:37:25.456Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9431
[task 2022-05-11T01:37:25.457Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9815
[task 2022-05-11T01:37:25.458Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9693
[task 2022-05-11T01:37:25.458Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9310
[task 2022-05-11T01:37:25.458Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9054
[task 2022-05-11T01:37:25.459Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9695
[task 2022-05-11T01:37:25.460Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9194
[task 2022-05-11T01:37:25.460Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9962
[task 2022-05-11T01:37:25.461Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9456
[task 2022-05-11T01:37:25.462Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9076
[task 2022-05-11T01:37:25.462Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9847
[task 2022-05-11T01:37:25.463Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9211
[task 2022-05-11T01:37:25.464Z] 01:37:25 INFO - zombiecheck | Checking for orphan process with PID: 9341
[task 2022-05-11T01:37:25.464Z] 01:37:25 INFO - Stopping web server
[task 2022-05-11T01:37:25.465Z] 01:37:25 INFO - Server shut down.
[task 2022-05-11T01:37:25.478Z] 01:37:25 INFO - Web server killed.
[task 2022-05-11T01:37:25.479Z] 01:37:25 INFO - Stopping web socket server
[task 2022-05-11T01:37:25.498Z] 01:37:25 INFO - Stopping ssltunnel
[task 2022-05-11T01:37:25.518Z] 01:37:25 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-05-11T01:37:25.519Z] 01:37:25 INFO - runtests.py | Running tests: end.
[task 2022-05-11T01:37:25.572Z] 01:37:25 INFO - Failed to unload module: Module b'50\n' not loaded
[task 2022-05-11T01:37:25.577Z] 01:37:25 INFO - Failed to unload module: Module b'51\n' not loaded
[task 2022-05-11T01:37:25.582Z] 01:37:25 INFO - Failed to unload module: Module b'52\n' not loaded
[task 2022-05-11T01:37:25.588Z] 01:37:25 INFO - Failed to unload module: Module b'53\n' not loaded
[task 2022-05-11T01:37:25.589Z] 01:37:25 INFO - Buffered messages finished
[task 2022-05-11T01:37:25.590Z] 01:37:25 INFO - Running manifest: dom/tests/mochitest/localstorage/mochitest.ini
[task 2022-05-11T01:37:25.607Z] 01:37:25 INFO - Setting pipeline to PAUSED ...
[task 2022-05-11T01:37:25.607Z] 01:37:25 INFO - Pipeline is PREROLLING ...
[task 2022-05-11T01:37:25.610Z] 01:37:25 INFO - Pipeline is PREROLLED ...
[task 2022-05-11T01:37:25.610Z] 01:37:25 INFO - Setting pipeline to PLAYING ...
[task 2022-05-11T01:37:25.610Z] 01:37:25 INFO - New clock: GstSystemClock
[task 2022-05-11T01:37:25.643Z] 01:37:25 INFO - Got EOS from element "pipeline0".
[task 2022-05-11T01:37:25.643Z] 01:37:25 INFO - Execution ended after 0:00:00.033398793
[task 2022-05-11T01:37:25.643Z] 01:37:25 INFO - Setting pipeline to PAUSED ...
[task 2022-05-11T01:37:25.644Z] 01:37:25 INFO - Setting pipeline to READY ...
[task 2022-05-11T01:37:25.645Z] 01:37:25 INFO - (gst-launch-1.0:10066): GStreamer-CRITICAL **: 01:37:25.643: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2022-05-11T01:37:25.645Z] 01:37:25 INFO - Setting pipeline to NULL ...
[task 2022-05-11T01:37:25.645Z] 01:37:25 INFO - Freeing pipeline ...
[task 2022-05-11T01:37:25.691Z] 01:37:25 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-05-11T01:37:25.695Z] 01:37:25 INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-05-11T01:37:25.695Z] 01:37:25 INFO - UBSan enabled.
[task 2022-05-11T01:37:25.944Z] 01:37:25 INFO - PID 10079 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2022-05-11T01:37:26.103Z] 01:37:26 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-05-11T01:37:26.108Z] 01:37:26 INFO - LSan enabled.
[task 2022-05-11T01:37:26.109Z] 01:37:26 INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-05-11T01:37:26.109Z] 01:37:26 INFO - UBSan enabled.
[task 2022-05-11T01:37:26.109Z] 01:37:26 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-05-11T01:37:26.112Z] 01:37:26 INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-05-11T01:37:26.112Z] 01:37:26 INFO - UBSan enabled.
[task 2022-05-11T01:37:26.118Z] 01:37:26 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/tmpo5lwv1x3.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-05-11T01:37:26.118Z] 01:37:26 INFO - runtests.py | Server pid: 10092
[task 2022-05-11T01:37:26.135Z] 01:37:26 INFO - runtests.py | Websocket server pid: 10095
[task 2022-05-11T01:37:26.135Z] 01:37:26 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-05-11T01:37:26.155Z] 01:37:26 INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-05-11T01:37:26.156Z] 01:37:26 INFO - UBSan enabled.
[task 2022-05-11T01:37:26.170Z] 01:37:26 INFO - runtests.py | SSL tunnel pid: 10101
[task 2022-05-11T01:37:26.476Z] 01:37:26 INFO - runtests.py | Running with scheme: http
[task 2022-05-11T01:37:26.477Z] 01:37:26 INFO - runtests.py | Running with e10s: True
[task 2022-05-11T01:37:26.477Z] 01:37:26 INFO - runtests.py | Running with fission: True
[task 2022-05-11T01:37:26.478Z] 01:37:26 INFO - runtests.py | Running with cross-origin iframes: False
[task 2022-05-11T01:37:26.479Z] 01:37:26 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2022-05-11T01:37:26.479Z] 01:37:26 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2022-05-11T01:37:26.479Z] 01:37:26 INFO - runtests.py | Running tests: start.
[task 2022-05-11T01:37:26.479Z] 01:37:26 INFO -
[task 2022-05-11T01:37:26.526Z] 01:37:26 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpo5lwv1x3.mozrunner
[task 2022-05-11T01:37:26.531Z] 01:37:26 INFO - runtests.py | Application pid: 10118
[task 2022-05-11T01:37:26.531Z] 01:37:26 INFO - TEST-INFO | started process GECKO(10118)
[task 2022-05-11T01:37:27.756Z] 01:37:27 INFO - GECKO(10118) | 1652233047755 Marionette INFO Marionette enabled
[task 2022-05-11T01:37:27.761Z] 01:37:27 INFO - GECKO(10118) | 1652233047760 Marionette TRACE Received observer notification final-ui-startup
[task 2022-05-11T01:37:27.765Z] 01:37:27 INFO - GECKO(10118) | 1652233047764 Marionette INFO Listening on port 2828
[task 2022-05-11T01:37:27.765Z] 01:37:27 INFO - GECKO(10118) | 1652233047764 Marionette DEBUG Marionette is listening
[task 2022-05-11T01:37:28.035Z] 01:37:28 INFO - GECKO(10118) | 1652233048034 Marionette DEBUG Accepted connection 0 from 127.0.0.1:46810
[task 2022-05-11T01:37:28.126Z] 01:37:28 INFO - GECKO(10118) | 1652233048125 Marionette DEBUG Accepted connection 1 from 127.0.0.1:46812
[task 2022-05-11T01:37:28.130Z] 01:37:28 INFO - GECKO(10118) | 1652233048126 Marionette DEBUG Closed connection 0
[task 2022-05-11T01:37:28.542Z] 01:37:28 INFO - GECKO(10118) | 1652233048541 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-05-11T01:37:28.553Z] 01:37:28 INFO - GECKO(10118) | 1652233048552 Marionette DEBUG Waiting for initial application window
[task 2022-05-11T01:37:34.179Z] 01:37:34 INFO - GECKO(10118) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpo5lwv1x3.mozrunner/search.json.mozlz4", (void 0)))
[task 2022-05-11T01:37:36.542Z] 01:37:36 INFO - GECKO(10118) | 1652233056540 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2022-05-11T01:37:36.558Z] 01:37:36 INFO - GECKO(10118) | 1652233056557 RemoteAgent TRACE [24] Document already finished loading: about:blank
[task 2022-05-11T01:37:36.578Z] 01:37:36 INFO - GECKO(10118) | 1652233056577 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"d32601a1-7614-4ccd-a073-f3c1074037c5","capabilities":{"browserName":"firefox","browserVersion":"102.0 ... wnTimeout":300000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2022-05-11T01:37:36.602Z] 01:37:36 INFO - GECKO(10118) | 1652233056601 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/tmp/tmp91ub_zk4.zip","temporary":false}]
[task 2022-05-11T01:37:36.800Z] 01:37:36 INFO - GECKO(10118) | 1652233056799 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2022-05-11T01:37:36.844Z] 01:37:36 INFO - GECKO(10118) | 1652233056840 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpdqi222hw.zip","temporary":false}]
[task 2022-05-11T01:37:36.921Z] 01:37:36 INFO - GECKO(10118) | 1652233056919 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2022-05-11T01:37:36.928Z] 01:37:36 INFO - GECKO(10118) | 1652233056927 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2022-05-11T01:37:36.931Z] 01:37:36 INFO - GECKO(10118) | 1652233056928 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2022-05-11T01:37:36.938Z] 01:37:36 INFO - GECKO(10118) | 1652233056937 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-05-11T01:37:36.943Z] 01:37:36 INFO - GECKO(10118) | 1652233056941 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2022-05-11T01:37:36.949Z] 01:37:36 INFO - GECKO(10118) | 1652233056947 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... ry=%2Ftmp&cleanupCrashes=true"}],"newSandbox":true,"sandbox":"default","line":2007,"filename":"tests/mochitest/runtests.py"}]
[task 2022-05-11T01:37:36.967Z] 01:37:36 INFO - GECKO(10118) | 1652233056966 Marionette TRACE [7] MarionetteCommands actor created for window id 2
[task 2022-05-11T01:37:37.020Z] 01:37:37 INFO - GECKO(10118) | 1652233057019 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2022-05-11T01:37:37.034Z] 01:37:37 INFO - GECKO(10118) | 1652233057033 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2022-05-11T01:37:37.039Z] 01:37:37 INFO - GECKO(10118) | 1652233057038 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2022-05-11T01:37:37.051Z] 01:37:37 INFO - GECKO(10118) | 1652233057049 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2022-05-11T01:37:37.062Z] 01:37:37 INFO - GECKO(10118) | 1652233057058 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2022-05-11T01:37:37.067Z] 01:37:37 INFO - runtests.py | Waiting for browser...
[task 2022-05-11T01:37:37.069Z] 01:37:37 INFO - GECKO(10118) | 1652233057069 Marionette DEBUG Closed connection 1
[task 2022-05-11T01:37:38.256Z] 01:37:38 INFO - SimpleTest START
[task 2022-05-11T01:37:38.262Z] 01:37:38 INFO - Dumping test context:
[task 2022-05-11T01:37:38.263Z] 01:37:38 INFO - fission.autostart=true
[task 2022-05-11T01:37:38.285Z] 01:37:38 INFO - TEST-START | dom/tests/mochitest/localstorage/test_brokenUTF-16.html
|
||
Comment 1•3 years ago
|
||
This should be fixed by backout: https://hg.mozilla.org/integration/autoland/rev/ce1bb7d083b9428f4a0985216baddd883c54e62a
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•