Closed Bug 1947213 Opened 10 months ago Closed 9 months ago

Almost perma application crashed [@ nsCOMPtr<nsIContent>::get] | devtools/<different paths>

Categories

(Core :: Widget: Gtk, defect)

defect

Tracking

()

RESOLVED WORKSFORME

People

(Reporter: intermittent-bug-filer, Assigned: emilio)

References

Details

(Keywords: crash, intermittent-failure, intermittent-testcase)

Crash Data

Attachments

(1 file)

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


[task 2025-02-10T14:18:58.908Z] 14:18:58     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-blackbox.js | The label of the context menu item shown to the user - 
[task 2025-02-10T14:18:58.908Z] 14:18:58     INFO - Asserts the editor blackbox context menu items when right-clicking on multiple non-blackboxed lines
[task 2025-02-10T14:18:58.909Z] 14:18:58     INFO - Open line context menu on line 3
[task 2025-02-10T14:18:58.909Z] 14:18:58     INFO - Buffered messages finished
[task 2025-02-10T14:18:58.909Z] 14:18:58     INFO - runtests.py | Application ran for: 0:00:42.543544
[task 2025-02-10T14:18:58.909Z] 14:18:58     INFO - zombiecheck | Reading PID log: /tmp/tmp_1d4h_h6pidlog
[task 2025-02-10T14:18:58.910Z] 14:18:58     INFO - ==> process 4468 launched child process 4550
[task 2025-02-10T14:18:58.910Z] 14:18:58     INFO - ==> process 4468 launched child process 4872
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - ==> process 4872 launched child process 4906
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - ==> process 4872 launched child process 4910
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - ==> process 4910 launched child process 5001
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - zombiecheck | Checking for orphan process with PID: 4550
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - zombiecheck | Checking for orphan process with PID: 4872
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - zombiecheck | Checking for orphan process with PID: 5001
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - zombiecheck | Checking for orphan process with PID: 4906
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - zombiecheck | Checking for orphan process with PID: 4910
[task 2025-02-10T14:18:58.913Z] 14:18:58     INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fm2_01D_Sde0Lb6tAW1mXw/artifacts/public/build/target.crashreporter-symbols.zip
[task 2025-02-10T14:19:19.103Z] 14:19:19     INFO - mozcrash Copy/paste: /task_173919688771386/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmpvebf27bu/29956620-6950-aced-7db4-5563e766cf43.trace /tmp/tmpdz3vcmya.mozrunner/minidumps/29956620-6950-aced-7db4-5563e766cf43.dmp /tmp/tmp2zuctuew
[task 2025-02-10T14:19:25.087Z] 14:19:25     INFO - mozcrash Saved minidump as /task_173919688771386/build/blobber_upload_dir/29956620-6950-aced-7db4-5563e766cf43.dmp
[task 2025-02-10T14:19:25.088Z] 14:19:25     INFO - mozcrash Saved app info as /task_173919688771386/build/blobber_upload_dir/29956620-6950-aced-7db4-5563e766cf43.extra
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - PROCESS-CRASH | application crashed [@ nsCOMPtr<nsIContent>::get] | devtools/client/debugger/test/mochitest/browser_dbg-blackbox.js 
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Process type: main
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Process pid: 4468
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Crash dump filename: /tmp/tmpdz3vcmya.mozrunner/minidumps/29956620-6950-aced-7db4-5563e766cf43.dmp
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Operating system: Linux
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -                   6.5.0-1025-gcp #27~22.04.1-Ubuntu SMP Tue Jul 16 23:03:39 UTC 2024
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - CPU: amd64
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -      family 6 model 85 stepping 7
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -      4 CPUs
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Linux Ubuntu 22.04 - jammy (Ubuntu 22.04.4 LTS)
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - 
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Crash reason:  SIGSEGV / SEGV_MAPERR
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Crash address: 0x00000000000000d0 **
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -     ** Null pointer detected with offset: 0x00000000000000d0
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Crashing instruction: `mov rax, qword [rdi + 0xd0]`
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Memory accessed by instruction:
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -   0. Address: 0x00000000000000d0
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -      Size: 8
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO -      Access type: Read
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - No instruction pointer update by instruction
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - Process uptime: not available
[task 2025-02-10T14:19:25.687Z] 14:19:25     INFO - 
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO - Linux memory map count: 3430
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO - 
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO - Thread 0 firefox-bin (crashed) - tid: 4468
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  0  libxul.so!nsCOMPtr<nsIContent>::get() const [nsCOMPtr.h:d0c7725a70110c49be720d4b3e44f29197b48dbf : 751]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -     Found by: inlining
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  1  libxul.so!nsCOMPtr<nsIContent>::operator nsIContent*() const & [nsCOMPtr.h:d0c7725a70110c49be720d4b3e44f29197b48dbf : 759]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -     Found by: inlining
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  2  libxul.so!nsMenuPopupFrame::GetAnchorFrame() const [nsMenuPopupFrame.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 2394]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -     Found by: inlining
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  3  libxul.so!nsMenuPopupFrame::IsDirectionRTL() const [nsMenuPopupFrame.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 2388 + 0x3]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rax = 0x0000000000000000    rdx = 0x000000000000011e
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rcx = 0x0000753faf747250    rbx = 0xe5e5e5e08d66045d
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rsi = 0x0000753f7661b600    rdi = 0x0000000000000000
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rbp = 0x00007fffc0ed8d70    rsp = 0x00007fffc0ed8d60
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -       r8 = 0x0000753faf747220     r9 = 0x0000753faf747250
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      r10 = 0x0000000000000000    r11 = 0x00007fffc0ed9590
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      r12 = 0x0000753faf747220    r13 = 0x00000000000000f3
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      r14 = 0x0000753f7661b600    r15 = 0x0000000000000000
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rip = 0x0000753fac77d617
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -     Found by: given as instruction pointer in context
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  4  libxul.so!nsWindow::WaylandPopupGetPositionFromLayout() [nsWindow.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 2431 + 0x7]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rbx = 0xe5e5e5e08d66045d    rbp = 0x00007fffc0ed8ec0
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed8d80    r12 = 0x0000753faf747220
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      r13 = 0x00000000000000f3    r14 = 0x0000753f7661b600
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      r15 = 0x0000000000000000    rip = 0x0000753fac2d4657
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -  5  libxul.so!nsWindow::NativeMoveResizeWaylandPopup(bool, bool) [nsWindow.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 2252 + 0x7]
[task 2025-02-10T14:19:25.688Z] 14:19:25     INFO -      rbx = 0x0000753f7661b600    rbp = 0x00007fffc0ed8f90
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed8ed0    r12 = 0x0000753faf747220
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r13 = 0x00000000000000f3    r14 = 0x0000000000000000
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r15 = 0x0000000000000000    rip = 0x0000753fac2d3fc3
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -  6  libxul.so!nsWindow::NativeMoveResize(bool, bool) [nsWindow.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 6512 + 0x16]
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rbx = 0x0000753f7661b600    rbp = 0x00007fffc0ed9050
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed8fa0    r12 = 0x0000753faf747220
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r13 = 0x0000000000000001    r14 = 0x0000000000000000
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r15 = 0x000000000000011e    rip = 0x0000753fac2cb733
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -  7  libxul.so!nsWindow::NativeMoveResizeWaylandPopupCallback(_cairo_rectangle_int const*, bool, bool) [nsWindow.cpp:d0c7725a70110c49be720d4b3e44f29197b48dbf : 2032 + 0x6]
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rbx = 0x0000000000000001    rbp = 0x00007fffc0ed9250
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed9060    r12 = 0x00007fffc0ed9580
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r13 = 0x0000000000000000    r14 = 0x0000753f8298d460
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r15 = 0x0000753faf747250    rip = 0x0000753fac2d2958
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -  8  libgdk-3.so.0!_gdk_marshal_VOID__POINTER_POINTER_BOOLEAN_BOOLEANv [gdkmarshalers.c : 571 + 0xe]
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rbx = 0x00007fffc0ed9450    rbp = 0x0000753f7735e8c0
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed9260    r12 = 0x00007fffc0ed9580
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r13 = 0x0000000000000000    r14 = 0x0000753fb051a110
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      r15 = 0x0000753f69d27140    rip = 0x0000753fb0b5651e
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -  9  libgobject-2.0.so.0!_g_closure_invoke_va [gclosure.c : 893]
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -     Found by: inlining
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO - 10  libgobject-2.0.so.0!g_signal_emit_valist [gsignal.c : 3440 + 0x72]
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rbx = 0x00007fffc0ed9450    rbp = 0x00007fffc0ed9430
[task 2025-02-10T14:19:25.689Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed92a0    r12 = 0x0000753fb4bfd7c0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r13 = 0x0000000000000104    r14 = 0x0000753fb051a110
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r15 = 0x0000753f69d27140    rip = 0x0000753fb04ed700
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO - 11  libgobject-2.0.so.0!g_signal_emit_by_name [gsignal.c : 3629 + 0x4]
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rbx = 0x0000753fb0bbd825    rbp = 0x0000753f7735e8c0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed9440    r12 = 0x0000000000000000
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r13 = 0x0000000000000013    r14 = 0x0000753fb4b369e0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r15 = 0x0000753fb051a110    rip = 0x0000753fb04eda8e
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO - 12  libgdk-3.so.0!xdg_popup_configure + 0xbf
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rbx = 0x0000753f827c8b00    rbp = 0x0000753f7735e8c0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed9570    r12 = 0x00007fffc0ed9590
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r13 = 0x00007fffc0ed9580    r14 = 0x0000753fafe3e3d0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r15 = 0x0000753fafe3e110    rip = 0x0000753fb0ba4bc0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -     Found by: call frame info
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO - 13  libffi.so.8!ffi_call_unix64 + 0x55
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rbx = 0x00007fffc0ed9750    rbp = 0x00007fffc0ed95e0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      rsp = 0x00007fffc0ed95e0    r12 = 0x0000000000000004
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r13 = 0x00007fffc0ed9800    r14 = 0x0000753fafe3e3d0
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -      r15 = 0x0000753fafe3e110    rip = 0x0000753fafe3ce2e
[task 2025-02-10T14:19:25.690Z] 14:19:25     INFO -     Found by: call frame info
<...>
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - 0x7fffc0f81000 - 0x7fffc0f82fff  linux-gate.so  0.0.0.0
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - 
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - Unloaded modules:
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - 
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - Unimplemented streams encountered:
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - Stream 0x47670006 LinuxCmdLine (Google Extension) @ 0x0013fd98
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - Stream 0x47670008 LinuxAuxv (Google Extension) @ 0x00140808
[task 2025-02-10T14:19:25.965Z] 14:19:25     INFO - Stream 0x4767000a LinuxDsoDebug (Google Extension) @ 0x00191130
[task 2025-02-10T14:19:26.401Z] 14:19:26     INFO - TEST-CRASH | devtools/client/debugger/test/mochitest/browser_dbg-blackbox.js | took 31021ms
[task 2025-02-10T14:19:26.401Z] 14:19:26     INFO - Stopping web server
[task 2025-02-10T14:19:26.403Z] 14:19:26     INFO - Server shut down.
[task 2025-02-10T14:19:26.404Z] 14:19:26     INFO - Web server killed.
[task 2025-02-10T14:19:26.404Z] 14:19:26     INFO - Stopping web socket server
[task 2025-02-10T14:19:26.404Z] 14:19:26     INFO - Stopping ssltunnel
[task 2025-02-10T14:19:26.405Z] 14:19:26     INFO - Stopping gst for v4l2loopback
[task 2025-02-10T14:19:26.405Z] 14:19:26     INFO - runtests.py | Running tests: end.
[task 2025-02-10T14:19:26.440Z] 14:19:26     INFO - Buffered messages finished
[task 2025-02-10T14:19:26.441Z] 14:19:26     INFO - Running manifest: devtools/client/framework/test/allocations/browser_allocations_reload_debugger.toml
[task 2025-02-10T14:19:26.502Z] 14:19:26     INFO -  Setting pipeline to PAUSED ...
[task 2025-02-10T14:19:26.502Z] 14:19:26     INFO -  Pipeline is PREROLLING ...
[task 2025-02-10T14:19:26.503Z] 14:19:26     INFO -  Pipeline is PREROLLED ...
[task 2025-02-10T14:19:26.503Z] 14:19:26     INFO -  Setting pipeline to PLAYING ...
[task 2025-02-10T14:19:26.504Z] 14:19:26     INFO -  Redistribute latency...
[task 2025-02-10T14:19:26.504Z] 14:19:26     INFO -  New clock: GstSystemClock
[task 2025-02-10T14:19:26.537Z] 14:19:26     INFO -  Got EOS from element "pipeline0".
[task 2025-02-10T14:19:26.537Z] 14:19:26     INFO -  Execution ended after 0:00:00.033482286
[task 2025-02-10T14:19:26.537Z] 14:19:26     INFO -  Setting pipeline to NULL ...
[task 2025-02-10T14:19:26.674Z] 14:19:26     INFO - PID 5449 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2025-02-10T14:19:26.674Z] 14:19:26     INFO - 
[task 2025-02-10T14:19:26.684Z] 14:19:26     INFO - MochitestServer : launching ['/task_173919688771386/build/tests/bin/xpcshell', '-g', '/task_173919688771386/build/application/firefox', '-e', "const _PROFILE_PATH = '/tmp/tmpvk0p9oai.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false; const _HTTPD_PATH = '/task_173919688771386/build/tests/bin/components';", '-f', '/task_173919688771386/build/tests/mochitest/server.js']
[task 2025-02-10T14:19:26.685Z] 14:19:26     INFO - runtests.py | Server pid: 5451
[task 2025-02-10T14:19:26.686Z] 14:19:26     INFO - runtests.py | Websocket server pid: 5452
[task 2025-02-10T14:19:26.686Z] 14:19:26     INFO - runtests.py | SSL tunnel pid: 5453
[task 2025-02-10T14:19:26.786Z] 14:19:26     INFO - use http3 server: 0
[task 2025-02-10T14:19:26.788Z] 14:19:26     INFO - runtests.py | Running with scheme: http
[task 2025-02-10T14:19:26.788Z] 14:19:26     INFO - runtests.py | Running with e10s: True
[task 2025-02-10T14:19:26.789Z] 14:19:26     INFO - runtests.py | Running with fission: True
[task 2025-02-10T14:19:26.789Z] 14:19:26     INFO - runtests.py | Running with cross-origin iframes: False
[task 2025-02-10T14:19:26.789Z] 14:19:26     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2025-02-10T14:19:26.789Z] 14:19:26     INFO - runtests.py | Running tests: start.
[task 2025-02-10T14:19:26.789Z] 14:19:26     INFO - 
[task 2025-02-10T14:19:26.808Z] 14:19:26     INFO - Application command: /task_173919688771386/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpvk0p9oai.mozrunner
[task 2025-02-10T14:19:26.814Z] 14:19:26     INFO - runtests.py | Application pid: 5483
[task 2025-02-10T14:19:26.814Z] 14:19:26     INFO - TEST-INFO | started process GECKO(5483)
[task 2025-02-10T14:19:27.263Z] 14:19:27     INFO - GECKO(5483) | 1739197167262	Marionette	INFO	Marionette enabled
[task 2025-02-10T14:19:27.264Z] 14:19:27     INFO - GECKO(5483) | 1739197167263	Marionette	TRACE	Received observer notification final-ui-startup
[task 2025-02-10T14:19:27.316Z] 14:19:27     INFO - GECKO(5483) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2025-02-10T14:19:27.340Z] 14:19:27     INFO - GECKO(5483) | 1739197167339	Marionette	INFO	Listening on port 2828
[task 2025-02-10T14:19:27.341Z] 14:19:27     INFO - GECKO(5483) | 1739197167340	Marionette	DEBUG	Marionette is listening
[task 2025-02-10T14:19:27.378Z] 14:19:27     INFO - GECKO(5483) | 1739197167377	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:39352
[task 2025-02-10T14:19:27.396Z] 14:19:27     INFO - GECKO(5483) | 1739197167395	Marionette	DEBUG	Closed connection 0
[task 2025-02-10T14:19:27.403Z] 14:19:27     INFO - GECKO(5483) | 1739197167402	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:39366
[task 2025-02-10T14:19:27.536Z] 14:19:27     INFO - GECKO(5483) | 1739197167535	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-02-10T14:19:27.539Z] 14:19:27     INFO - GECKO(5483) | 1739197167538	Marionette	DEBUG	Waiting for initial application window
[task 2025-02-10T14:19:27.580Z] 14:19:27     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5573.log
[task 2025-02-10T14:19:27.584Z] 14:19:27     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_rdd_pid5583.log
[task 2025-02-10T14:19:27.714Z] 14:19:27     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5613.log
[task 2025-02-10T14:19:28.506Z] 14:19:28     INFO - GECKO(5483) | console.error: ({})
[task 2025-02-10T14:19:29.361Z] 14:19:29     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_utility_pid5667.log
[task 2025-02-10T14:19:29.364Z] 14:19:29     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5671.log
[task 2025-02-10T14:19:29.376Z] 14:19:29     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5679.log
[task 2025-02-10T14:19:29.383Z] 14:19:29     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5689.log
[task 2025-02-10T14:19:29.416Z] 14:19:29     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5721.log
[task 2025-02-10T14:19:29.463Z] 14:19:29     INFO - GECKO(5483) | 1739197169462	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
[task 2025-02-10T14:19:29.471Z] 14:19:29     INFO - GECKO(5483) | 1739197169469	RemoteAgent	TRACE	[9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2025-02-10T14:19:29.471Z] 14:19:29     INFO - GECKO(5483) | 1739197169470	RemoteAgent	TRACE	[9] ProgressListener Setting unload timer (5000ms)
[task 2025-02-10T14:19:29.473Z] 14:19:29     INFO - GECKO(5483) | 1739197169470	RemoteAgent	TRACE	[9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-02-10T14:19:29.473Z] 14:19:29     INFO - GECKO(5483) | 1739197169470	RemoteAgent	TRACE	[9] Document already finished loading: about:blank
[task 2025-02-10T14:19:29.473Z] 14:19:29     INFO - GECKO(5483) | 1739197169470	RemoteAgent	TRACE	[9] ProgressListener Stop: has error=false url=about:blank
[task 2025-02-10T14:19:29.485Z] 14:19:29     INFO - GECKO(5483) | 1739197169483	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"e0ab10aa-1ecf-49bc-8faf-92788c88a2af","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"137.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0","moz:buildID":"20250210135015","moz:headless":false,"moz:platformVersion":"6.5.0-1025-gcp","moz:processID":5483,"moz:profile":"/tmp/tmpvk0p9oai.mozrunner","moz:shutdownTimeout":60000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2025-02-10T14:19:29.507Z] 14:19:29     INFO - GECKO(5483) | 1739197169506	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpgl7r6mmr.zip","temporary":false}]
[task 2025-02-10T14:19:29.580Z] 14:19:29     INFO - GECKO(5483) | 1739197169579	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-02-10T14:19:29.602Z] 14:19:29     INFO - GECKO(5483) | 1739197169601	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpn7cql28i.zip","temporary":false}]
[task 2025-02-10T14:19:29.628Z] 14:19:29     INFO - GECKO(5483) | 1739197169627	Marionette	DEBUG	1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2025-02-10T14:19:29.630Z] 14:19:29     INFO - GECKO(5483) | 1739197169629	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2025-02-10T14:19:29.631Z] 14:19:29     INFO - GECKO(5483) | 1739197169629	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2025-02-10T14:19:29.632Z] 14:19:29     INFO - GECKO(5483) | 1739197169631	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-02-10T14:19:29.633Z] 14:19:29     INFO - GECKO(5483) | 1739197169631	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2025-02-10T14:19:29.637Z] 14:19:29     INFO - GECKO(5483) | 1739197169635	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":"browser-chrome","testUrl":"about:blank"}],"newSandbox":true,"sandbox":"default","line":2159,"filename":"tests/mochitest/runtests.py"}]
[task 2025-02-10T14:19:29.640Z] 14:19:29     INFO - GECKO(5483) | 1739197169639	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 5483
[task 2025-02-10T14:19:29.641Z] 14:19:29     INFO - GECKO(5483) | 1739197169640	Marionette	TRACE	[1] MarionetteCommands actor created for window id 2
[task 2025-02-10T14:19:29.659Z] 14:19:29     INFO - GECKO(5483) | 1739197169658	RemoteAgent	TRACE	Received observer notification domwindowopened
[task 2025-02-10T14:19:29.662Z] 14:19:29     INFO - GECKO(5483) | 1739197169661	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2025-02-10T14:19:29.664Z] 14:19:29     INFO - GECKO(5483) | 1739197169663	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-10T14:19:29.665Z] 14:19:29     INFO - GECKO(5483) | 1739197169664	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2025-02-10T14:19:29.697Z] 14:19:29     INFO - runtests.py | Waiting for browser...
[task 2025-02-10T14:19:29.697Z] 14:19:29     INFO - GECKO(5483) | 1739197169689	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2025-02-10T14:19:29.698Z] 14:19:29     INFO - GECKO(5483) | 1739197169690	Marionette	TRACE	[1] MarionetteCommands actor destroyed for window id 2
[task 2025-02-10T14:19:29.698Z] 14:19:29     INFO - GECKO(5483) | 1739197169691	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2025-02-10T14:19:29.699Z] 14:19:29     INFO - GECKO(5483) | 1739197169697	Marionette	DEBUG	Closed connection 1
[task 2025-02-10T14:19:29.969Z] 14:19:29     INFO - *** Start BrowserChrome Test Results ***
[task 2025-02-10T14:19:30.009Z] 14:19:30     INFO - checking window state
[task 2025-02-10T14:19:30.065Z] 14:19:30     INFO - TEST-START | devtools/client/framework/test/allocations/browser_allocations_reload_debugger.js
[task 2025-02-10T14:19:30.074Z] 14:19:30     INFO - GECKO(5483) | DEVTOOLS ALLOCATION: Start logging allocations
[task 2025-02-10T14:19:30.085Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.086Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : about:blank
[task 2025-02-10T14:19:30.087Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : [anonymous sandbox] (from: chrome://remote/content/marionette/evaluate.sys.mjs:261)
[task 2025-02-10T14:19:30.088Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.089Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.090Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.092Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : chrome://extensions/content/dummy.xhtml
[task 2025-02-10T14:19:30.092Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.092Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.093Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : [anonymous sandbox] (from: resource://gre/modules/JsonSchema.sys.mjs:10)
[task 2025-02-10T14:19:30.094Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : about:blank
[task 2025-02-10T14:19:30.095Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.096Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.097Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : [anonymous sandbox] (from: chrome://remote/content/marionette/evaluate.sys.mjs:261)
[task 2025-02-10T14:19:30.097Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : Namespace of ext-*.js scripts for main (from: resource://gre/modules/ExtensionCommon.sys.mjs)
[task 2025-02-10T14:19:30.098Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : shared JSM global
[task 2025-02-10T14:19:30.099Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : about:blank
[task 2025-02-10T14:19:30.099Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : chrome://extensions/content/dummy.xhtml
[task 2025-02-10T14:19:30.102Z] 14:19:30     INFO - Entering test bound panelReloadTest
[task 2025-02-10T14:19:30.150Z] 14:19:30     INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure speculative TCP connection “http://example.com/browser/devtools/client/framework/test/allocations/reloaded-page.html” to use “https”."]
[task 2025-02-10T14:19:30.161Z] 14:19:30     INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure request “http://example.com/browser/devtools/client/framework/test/allocations/reloaded-page.html” to use “https”."]
[task 2025-02-10T14:19:30.258Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : DevTools (Module loader)
[task 2025-02-10T14:19:30.453Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: - : about:blank
[task 2025-02-10T14:19:30.503Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : about:devtools-toolbox
[task 2025-02-10T14:19:30.551Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : DevTools (UI loader)
[task 2025-02-10T14:19:30.719Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : [anonymous sandbox] (from: resource://devtools/shared/indexed-db.js:24)
[task 2025-02-10T14:19:30.784Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : about:devtools-toolbox
[task 2025-02-10T14:19:30.909Z] 14:19:30     INFO - GECKO(5483) | TRACKER NEW GLOBAL: + : DevTools (UI loader)
[task 2025-02-10T14:19:31.356Z] 14:19:31     INFO - Wait for target switched
[task 2025-02-10T14:19:31.361Z] 14:19:31     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5801.log
[task 2025-02-10T14:19:31.679Z] 14:19:31     INFO - Wait for panel reload
[task 2025-02-10T14:19:31.778Z] 14:19:31     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5825.log
[task 2025-02-10T14:19:31.787Z] 14:19:31     INFO - GECKO(5483) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpvk0p9oai.mozrunner/runtests_leaks_tab_pid5831.log
[task 2025-02-10T14:19:32.758Z] 14:19:32     INFO - Wait for target switched
[task 2025-02-10T14:19:32.857Z] 14:19:32     INFO - Wait for panel reload
[task 2025-02-10T14:19:33.931Z] 14:19:33     INFO - GECKO(5483) | DEVTOOLS ALLOCATION: Start logging allocations
[task 2025-02-10T14:19:45.007Z] 14:19:45     INFO - Wait for target switched
[task 2025-02-10T14:19:45.078Z] 14:19:45     INFO - Wait for panel reload
[task 2025-02-10T14:19:46.163Z] 14:19:46     INFO - Wait for target switched
[task 2025-02-10T14:19:46.241Z] 14:19:46     INFO - Wait for panel reload
[task 2025-02-10T14:19:47.342Z] 14:19:47     INFO - Wait for target switched
[task 2025-02-10T14:19:47.426Z] 14:19:47     INFO - Wait for panel reload
[task 2025-02-10T14:19:48.488Z] 14:19:48     INFO - Wait for target switched
[task 2025-02-10T14:19:48.562Z] 14:19:48     INFO - Wait for panel reload
[task 2025-02-10T14:19:49.630Z] 14:19:49     INFO - Wait for target switched
[task 2025-02-10T14:19:49.694Z] 14:19:49     INFO - Wait for panel reload
[task 2025-02-10T14:19:50.789Z] 14:19:50     INFO - Wait for target switched
[task 2025-02-10T14:19:50.878Z] 14:19:50     INFO - Wait for panel reload
[task 2025-02-10T14:19:51.943Z] 14:19:51     INFO - Wait for target switched
[task 2025-02-10T14:19:52.001Z] 14:19:52     INFO - Wait for panel reload
[task 2025-02-10T14:19:53.087Z] 14:19:53     INFO - Wait for target switched
[task 2025-02-10T14:19:53.160Z] 14:19:53     INFO - Wait for panel reload
[task 2025-02-10T14:19:54.240Z] 14:19:54     INFO - Wait for target switched
[task 2025-02-10T14:19:54.334Z] 14:19:54     INFO - Wait for panel reload
[task 2025-02-10T14:19:55.401Z] 14:19:55     INFO - Wait for target switched
[task 2025-02-10T14:19:55.472Z] 14:19:55     INFO - Wait for panel reload
[task 2025-02-10T14:19:56.554Z] 14:19:56     INFO - TEST-PASS | devtools/client/framework/test/allocations/browser_allocations_reload_debugger.js | Allocation were all recorded in the parent process - 
[task 2025-02-10T14:20:01.040Z] 14:20:01     INFO - TEST-PASS | devtools/client/framework/test/allocations/browser_allocations_reload_debugger.js | Allocation were all recorded in the content process - true == true - 
[task 2025-02-10T14:20:04.119Z] 14:20:04     INFO - The reload-debugger test leaked 0 objects (6219 with missing allocation site) in the parent process
[task 2025-02-10T14:20:04.119Z] 14:20:04     INFO - The reload-debugger test leaked 937 objects (1038 with missing allocation site) in the content process
[task 2025-02-10T14:20:04.121Z] 14:20:04     INFO - PERFHERDER_DATA: {"framework":{"name":"devtools"},"suites":[{"name":"reload-debugger:parent-process","subtests":[{"name":"objects-with-stacks","value":0},{"name":"memory","value":352256}]},{"name":"reload-debugger:content-process","subtests":[{"name":"objects-with-stacks","value":937},{"name":"memory","value":1773568}]}]}
[task 2025-02-10T14:20:04.167Z] 14:20:04     INFO - Leaving test bound panelReloadTest
[task 2025-02-10T14:20:04.179Z] 14:20:04     INFO - GECKO(5483) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-02-10T14:20:04.180Z] 14:20:04     INFO - GECKO(5483) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-02-10T14:20:04.181Z] 14:20:04     INFO - GECKO(5483) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-02-10T14:20:04.190Z] 14:20:04     INFO - GECKO(5483) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2025-02-10T14:20:04.192Z] 14:20:04     INFO - GECKO(5483) | MEMORY STAT | vsize 3386MB | residentFast 657MB | heapAllocated 331MB
[task 2025-02-10T14:20:04.193Z] 14:20:04     INFO - TEST-OK | devtools/client/framework/test/allocations/browser_allocations_reload_debugger.js | took 34131ms
[task 2025-02-10T14:20:04.218Z] 14:20:04     INFO - checking window state
[task 2025-02-10T14:20:04.245Z] 14:20:04     INFO - GECKO(5483) | Completed ShutdownLeaks collections in process 5483
[task 2025-02-10T14:20:04.246Z] 14:20:04     INFO - TEST-START | Shutdown

This failure started to appear today and after retriggers and backfills we didn't manage to find the culprit.
This crash appears to be happening only on devtools/ files
Here's some failure logs from the retriggers and backfills:
https://treeherder.mozilla.org/logviewer?job_id=494197632&repo=autoland&lineNumber=1819
https://treeherder.mozilla.org/logviewer?job_id=494202022&repo=autoland&lineNumber=2750
https://treeherder.mozilla.org/logviewer?job_id=494202023&repo=autoland&lineNumber=2071
https://treeherder.mozilla.org/logviewer?job_id=494202675&repo=autoland&lineNumber=2791

Hi, could you please take a look at this? Thanks.

Flags: needinfo?(stransky)
Depends on: 1947181

Null crash, not a security bug afaict.

Flags: needinfo?(stransky)
Group: core-security
Assignee: nobody → emilio
Status: NEW → ASSIGNED
Flags: needinfo?(emilio)

(In reply to Emilio Cobos Álvarez (:emilio) from comment #6)

https://treeherder.mozilla.org/jobs?repo=try&revision=bb1e176703862e74b9550b369cde81f6c55bddc7 is a new one.

Failures still pop up on the Try run, could you please take another look? Thanks.

Flags: needinfo?(emilio)

Yes, that's why I haven't landed this, but it seems this has gone away basically, probably due to some other recent fix, right?

Flags: needinfo?(emilio)

(In reply to Emilio Cobos Álvarez (:emilio) from comment #10)

Yes, that's why I haven't landed this, but it seems this has gone away basically, probably due to some other recent fix, right?

Not sure, will close this bug for now.

Status: ASSIGNED → RESOLVED
Closed: 9 months ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: