Open
Bug 1961729
Opened 24 days ago
Updated 16 days ago
Intermittent [tier 2] svg/as-image/zoom/reftest.list | single tracking bug
Categories
(Core :: SVG, defect, P5)
Core
SVG
Tracking
()
NEW
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: amarc [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=504933539&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Q1HkH1FUTw6zMe8YnuFo2w/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Q1HkH1FUTw6zMe8YnuFo2w/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2025-04-22T05:24:31.594Z] 05:24:31 INFO - REFTEST TEST-PASS | layout/reftests/svg/as-image/zoom/img-fuzzy-transform-zoomIn-1.html == layout/reftests/svg/as-image/zoom/img-fuzzy-zoomIn-1-ref.html | image comparison, max difference: 0, number of differing pixels: 0
[task 2025-04-22T05:24:31.594Z] 05:24:31 INFO - REFTEST TEST-END | layout/reftests/svg/as-image/zoom/img-fuzzy-transform-zoomIn-1.html == layout/reftests/svg/as-image/zoom/img-fuzzy-zoomIn-1-ref.html
[task 2025-04-22T05:24:31.611Z] 05:24:31 INFO - REFTEST INFO | Slowest test took 170ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/as-image/zoom/img-fuzzy-zoomOut-1.html)
[task 2025-04-22T05:24:31.620Z] 05:24:31 INFO - REFTEST INFO | Total canvas count = 3
[task 2025-04-22T05:24:32.049Z] 05:24:32 INFO - 1745299472048 Marionette TRACE Received observer notification quit-application
[task 2025-04-22T05:24:32.050Z] 05:24:32 INFO - 1745299472048 Marionette INFO Stopped listening on port 2828
[task 2025-04-22T05:24:32.051Z] 05:24:32 INFO - 1745299472051 Marionette DEBUG Marionette stopped listening
[task 2025-04-22T05:24:33.951Z] 05:24:33 INFO - [Parent 9136, IPC I/O Parent] WARNING: Process 9317 may be hanging at shutdown; will wait for up to 80000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:203
[task 2025-04-22T05:24:34.581Z] 05:24:34 INFO - REFTEST INFO | Process mode: e10s
[task 2025-04-22T05:24:34.582Z] 05:24:34 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2025-04-22T05:24:34.591Z] 05:24:34 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/dom/html/reftests/toblob-todataurl/reftest.list
[task 2025-04-22T05:24:34.598Z] 05:24:34 INFO - REFTEST INFO | Running with e10s: True
[task 2025-04-22T05:24:34.599Z] 05:24:34 INFO - REFTEST INFO | Running with fission: True
[task 2025-04-22T05:24:34.599Z] 05:24:34 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpa1spro9v.mozrunner
[task 2025-04-22T05:24:34.653Z] 05:24:34 INFO - [CodeCoverage] Setting handlers for process 9491.
[task 2025-04-22T05:24:35.358Z] 05:24:35 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:24:35.400Z] 05:24:35 INFO - 1745299475399 Marionette INFO Marionette enabled
[task 2025-04-22T05:24:35.402Z] 05:24:35 INFO - 1745299475402 Marionette TRACE Received observer notification final-ui-startup
[task 2025-04-22T05:24:35.510Z] 05:24:35 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:24:35.842Z] 05:24:35 INFO - 1745299475841 Marionette INFO Listening on port 2828
[task 2025-04-22T05:24:35.847Z] 05:24:35 INFO - 1745299475845 Marionette DEBUG Marionette is listening
[task 2025-04-22T05:24:35.877Z] 05:24:35 INFO - 1745299475876 Marionette DEBUG Accepted connection 0 from 127.0.0.1:44696
[task 2025-04-22T05:24:35.911Z] 05:24:35 INFO - 1745299475910 Marionette DEBUG Closed connection 0
[task 2025-04-22T05:24:35.937Z] 05:24:35 INFO - 1745299475936 Marionette DEBUG Accepted connection 1 from 127.0.0.1:44698
[task 2025-04-22T05:24:36.079Z] 05:24:36 INFO - 1745299476078 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-04-22T05:24:36.086Z] 05:24:36 INFO - 1745299476085 Marionette DEBUG Waiting for initial application window
[task 2025-04-22T05:24:36.826Z] 05:24:36 INFO - [CodeCoverage] Setting handlers for process 9582.
[task 2025-04-22T05:24:39.939Z] 05:24:39 INFO - 1745299479938 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2025-04-22T05:24:39.955Z] 05:24:39 INFO - 1745299479954 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2025-04-22T05:24:39.956Z] 05:24:39 INFO - 1745299479955 RemoteAgent TRACE [9] ProgressListener Setting unload timer (80000ms)
[task 2025-04-22T05:24:39.957Z] 05:24:39 INFO - 1745299479956 RemoteAgent TRACE [9] Wait for initial navigation: isInitial=true, isLoadingDocument=false
[task 2025-04-22T05:25:06.074Z] 05:25:06 INFO - 1745299506073 addons.xpi ERROR System addon update list error Error: Failed downloading XML, status: 0, channelStatus: 2152398861, errorCode: 2, reason: error
[task 2025-04-22T05:26:00.164Z] 05:26:00 INFO - 1745299560163 RemoteAgent TRACE [9] ProgressListener No navigation detected: about:blank
[task 2025-04-22T05:26:00.165Z] 05:26:00 INFO - 1745299560164 RemoteAgent TRACE [9] ProgressListener Stop: has error=false url=about:blank
[task 2025-04-22T05:26:00.188Z] 05:26:00 INFO - 1745299560186 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"0176bc63-50dc-4dc1-abc4-5fddf7c20926","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"139.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0","moz:buildID":"20250422040745","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":9491,"moz:profile":"/tmp/tmpa1spro9v.mozrunner","moz:shutdownTimeout":180000,"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-04-22T05:26:00.194Z] 05:26:00 INFO - 1745299560193 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/specialpowers","temporary":true}]
[task 2025-04-22T05:26:00.245Z] 05:26:00 INFO - 1745299560244 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-04-22T05:26:00.253Z] 05:26:00 INFO - 1745299560253 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/reftest","temporary":true}]
[task 2025-04-22T05:26:00.283Z] 05:26:00 INFO - 1745299560282 RemoteAgent TRACE Received observer notification domwindowopened
[task 2025-04-22T05:26:00.286Z] 05:26:00 INFO - 1745299560285 Marionette DEBUG 1 <- [1,3,null,{"value":"reftest@mozilla.org"}]
[task 2025-04-22T05:26:00.292Z] 05:26:00 INFO - 1745299560291 Marionette DEBUG 1 -> [0,4,"WebDriver:DeleteSession",{}]
[task 2025-04-22T05:26:00.294Z] 05:26:00 INFO - 1745299560294 Marionette DEBUG 1 <- [1,4,null,{"value":null}]
[task 2025-04-22T05:26:00.296Z] 05:26:00 INFO - 1745299560295 Marionette DEBUG Closed connection 1
[task 2025-04-22T05:32:10.297Z] 05:32:10 ERROR - REFTEST ERROR | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/as-image/zoom/reftest.list | application timed out after 370 seconds with no output
[task 2025-04-22T05:32:10.297Z] 05:32:10 WARNING - REFTEST WARNING | Force-terminating active process(es).
[task 2025-04-22T05:32:10.297Z] 05:32:10 INFO - REFTEST TEST-INFO | started process screentopng
[task 2025-04-22T05:32:10.423Z] 05:32:10 INFO - REFTEST TEST-INFO | screentopng: exit 0
[task 2025-04-22T05:32:10.580Z] 05:32:10 INFO - REFTEST INFO | Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/dWFAP2AgSc2ANZBBzLayVw/artifacts/public/build/target.crashreporter-symbols.zip
[task 2025-04-22T05:32:21.555Z] 05:32:21 INFO - REFTEST INFO | Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmpm4ccuzwz/2f66a047-8d99-3d3d-8894-2136ce72eb5c.trace /tmp/tmpa1spro9v.mozrunner/minidumps/2f66a047-8d99-3d3d-8894-2136ce72eb5c.dmp /tmp/tmpo7lrv9_z
[task 2025-04-22T05:32:21.685Z] 05:32:21 WARNING - REFTEST WARNING | .extra file does not contain proper json
[task 2025-04-22T05:32:21.685Z] 05:32:21 INFO - REFTEST INFO | Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/2f66a047-8d99-3d3d-8894-2136ce72eb5c.dmp
[task 2025-04-22T05:32:21.686Z] 05:32:21 INFO - REFTEST INFO | Saved app info as /builds/worker/workspace/build/blobber_upload_dir/2f66a047-8d99-3d3d-8894-2136ce72eb5c.extra
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - REFTEST PROCESS-CRASH | application crashed [@ libpthread.so.0 + 0x000000000001159c] | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/as-image/zoom/reftest.list
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Process type: unknown
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Process pid: 9596
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Crash dump filename: /tmp/tmpa1spro9v.mozrunner/minidumps/2f66a047-8d99-3d3d-8894-2136ce72eb5c.dmp
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Operating system: Linux
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - CPU: amd64
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - family 6 model 85 stepping 7
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - 4 CPUs
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Crash reason: SIGABRT
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Crash address: 0x000003e8000003cd
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Crashing instruction: `cmp rax, -0x1000`
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - No memory accessed by instruction
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - No instruction pointer update by instruction
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO - Process uptime: not available
[task 2025-04-22T05:32:21.697Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Linux memory map count: 1239
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Thread 0 IPC Launch (crashed) - tid: 9596
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 0 libpthread.so.0 + 0x1159c
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rax = 0xfffffffffffffffc rdx = 0x00007f0c3f87a600
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rcx = 0x00007f0c7728f59c rbx = 0x0000000000000008
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rsi = 0x0000000000000007 rdi = 0x0000000000000008
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rbp = 0x0000000000000000 rsp = 0x00007f0c3f87a580
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - r8 = 0x0000000000000000 r9 = 0x0000000000000001
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - r10 = 0x0000000000000000 r11 = 0x0000000000000293
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - r12 = 0x00007f0c2952ff40 r13 = 0x0000000000000010
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - r14 = 0x00007f0c3f87a600 r15 = 0x00007ffdc3189c04
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rip = 0x00007f0c7728f59c
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: given as instruction pointer in context
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 1 firefox-bin!Unlock [Mutex.h:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 106]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: inlining
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 2 firefox-bin!Unlock [Mutex.h:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 210]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: inlining
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 3 firefox-bin!~AutoLock [Mutex.h:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 254]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: inlining
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 4 firefox-bin!arena_t::MallocSmall(unsigned long, bool) [mozjemalloc.cpp:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 4229 + 0x17]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rsp = 0x00007f0c3f87a5a0 rip = 0x00005591218e20d1
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: stack scanning
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 5 firefox-bin!Malloc [mozjemalloc.cpp:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 4276]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - Found by: inlining
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - 6 firefox-bin!BaseAllocator::malloc(unsigned long) [mozjemalloc.cpp:55411e761ba0d4a9b16971b98f5a53a850c3cae9 : 5584 + 0x2c]
[task 2025-04-22T05:32:21.698Z] 05:32:21 INFO - rbx = 0x4e7893b25b9f5900 rbp = 0x000000003430382a
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - rsp = 0x00007f0c3f87a5f0 r12 = 0x00007f0c296e5400
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - r13 = 0x00007f0c7728fdd2 r14 = 0x00007f0c3f87a600
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - r15 = 0x0000000200000008 rip = 0x00005591218e79f8
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - Found by: call frame info
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - Loaded modules:
[task 2025-04-22T05:32:21.699Z] 05:32:21 INFO - 0x55912185f000 - 0x5591219bafff firefox-bin 0.0.0.0 (main)
<...>
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - 0x7f0c781f7000 - 0x7f0c78203fff libplc4.so 0.0.0.0
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - 0x7ffdc31da000 - 0x7ffdc31dbfff linux-gate.so 0.0.0.0
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - Unloaded modules:
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO -
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - Unimplemented streams encountered:
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - Stream 0x47670006 LinuxCmdLine (Google Extension) @ 0x00010098
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - Stream 0x47670008 LinuxAuxv (Google Extension) @ 0x00011918
[task 2025-04-22T05:32:21.704Z] 05:32:21 INFO - Stream 0x4767000a LinuxDsoDebug (Google Extension) @ 0x00030110
[task 2025-04-22T05:32:22.750Z] 05:32:22 INFO - REFTEST INFO | Result summary:
[task 2025-04-22T05:32:22.750Z] 05:32:22 INFO - REFTEST INFO | Successful: 313 (313 pass, 0 load only)
[task 2025-04-22T05:32:22.750Z] 05:32:22 INFO - REFTEST INFO | Unexpected: 0 (0 unexpected fail, 0 unexpected pass, 0 unexpected asserts, 0 failed load, 0 exception)
[task 2025-04-22T05:32:22.750Z] 05:32:22 INFO - REFTEST INFO | Known problems: 8 (0 known fail, 0 known asserts, 6 random, 2 skipped, 0 slow)
[task 2025-04-22T05:32:22.750Z] 05:32:22 INFO - REFTEST SUITE-END | Shutdown
[task 2025-04-22T05:32:22.790Z] 05:32:22 INFO - REFTEST INFO | Process mode: e10s
[task 2025-04-22T05:32:22.799Z] 05:32:22 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/css-enabled/output/reftest.list
[task 2025-04-22T05:32:22.806Z] 05:32:22 INFO - REFTEST INFO | Running with e10s: True
[task 2025-04-22T05:32:22.806Z] 05:32:22 INFO - REFTEST INFO | Running with fission: True
[task 2025-04-22T05:32:22.806Z] 05:32:22 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpkpg71ipm.mozrunner
[task 2025-04-22T05:32:22.861Z] 05:32:22 INFO - [CodeCoverage] Setting handlers for process 9706.
[task 2025-04-22T05:32:23.553Z] 05:32:23 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:32:23.593Z] 05:32:23 INFO - 1745299943593 Marionette INFO Marionette enabled
[task 2025-04-22T05:32:23.596Z] 05:32:23 INFO - 1745299943595 Marionette TRACE Received observer notification final-ui-startup
[task 2025-04-22T05:32:23.700Z] 05:32:23 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:32:23.857Z] 05:32:23 INFO - 1745299943856 Marionette INFO Listening on port 2828
[task 2025-04-22T05:32:23.860Z] 05:32:23 INFO - 1745299943858 Marionette DEBUG Marionette is listening
[task 2025-04-22T05:32:23.880Z] 05:32:23 INFO - 1745299943879 Marionette DEBUG Accepted connection 0 from 127.0.0.1:44790
[task 2025-04-22T05:32:23.902Z] 05:32:23 INFO - 1745299943902 Marionette DEBUG Accepted connection 1 from 127.0.0.1:44792
[task 2025-04-22T05:32:23.908Z] 05:32:23 INFO - 1745299943907 Marionette DEBUG Closed connection 0
[task 2025-04-22T05:32:24.044Z] 05:32:24 INFO - 1745299944043 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-04-22T05:32:24.051Z] 05:32:24 INFO - 1745299944050 Marionette DEBUG Waiting for initial application window
[task 2025-04-22T05:32:24.887Z] 05:32:24 INFO - [CodeCoverage] Setting handlers for process 9796.
[task 2025-04-22T05:32:25.292Z] 05:32:25 INFO - [CodeCoverage] Setting handlers for process 9810.
[task 2025-04-22T05:32:28.498Z] 05:32:28 INFO - 1745299948497 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2025-04-22T05:32:28.530Z] 05:32:28 INFO - 1745299948529 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2025-04-22T05:32:28.533Z] 05:32:28 INFO - 1745299948529 RemoteAgent TRACE [9] ProgressListener Setting unload timer (80000ms)
[task 2025-04-22T05:32:28.537Z] 05:32:28 INFO - 1745299948532 RemoteAgent TRACE [9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-04-22T05:32:28.540Z] 05:32:28 INFO - 1745299948532 RemoteAgent TRACE [9] Document already finished loading: about:blank
[task 2025-04-22T05:32:28.542Z] 05:32:28 INFO - 1745299948532 RemoteAgent TRACE [9] ProgressListener Stop: has error=false url=about:blank
[task 2025-04-22T05:32:28.603Z] 05:32:28 INFO - 1745299948601 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"39f49fce-9864-4be7-8b54-886e5bb0fcd9","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"139.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0","moz:buildID":"20250422040745","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":9706,"moz:profile":"/tmp/tmpkpg71ipm.mozrunner","moz:shutdownTimeout":180000,"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-04-22T05:32:28.620Z] 05:32:28 INFO - 1745299948619 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/specialpowers","temporary":true}]
[task 2025-04-22T05:32:28.726Z] 05:32:28 INFO - 1745299948725 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-04-22T05:32:28.743Z] 05:32:28 INFO - 1745299948742 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/reftest","temporary":true}]
[task 2025-04-22T05:32:28.833Z] 05:32:28 INFO - 1745299948832 RemoteAgent TRACE Received observer notification domwindowopened
[task 2025-04-22T05:32:28.837Z] 05:32:28 INFO - 1745299948836 Marionette DEBUG 1 <- [1,3,null,{"value":"reftest@mozilla.org"}]
[task 2025-04-22T05:32:28.854Z] 05:32:28 INFO - 1745299948853 Marionette DEBUG 1 -> [0,4,"WebDriver:DeleteSession",{}]
[task 2025-04-22T05:32:28.866Z] 05:32:28 INFO - 1745299948865 Marionette DEBUG 1 <- [1,4,null,{"value":null}]
[task 2025-04-22T05:32:28.871Z] 05:32:28 INFO - 1745299948870 Marionette DEBUG Closed connection 1
[task 2025-04-22T05:32:29.161Z] 05:32:29 INFO - [CodeCoverage] Setting handlers for process 9888.
[task 2025-04-22T05:32:29.405Z] 05:32:29 INFO - [CodeCoverage] Setting handlers for process 9893.
[task 2025-04-22T05:32:29.520Z] 05:32:29 INFO - [CodeCoverage] Setting handlers for process 9894.
[task 2025-04-22T05:32:29.650Z] 05:32:29 INFO - [CodeCoverage] Setting handlers for process 9896.
[task 2025-04-22T05:32:29.665Z] 05:32:29 INFO - REFTEST TEST-START | layout/reftests/css-enabled/output/output.html == layout/reftests/css-enabled/output/output-ref.html
[task 2025-04-22T05:32:29.666Z] 05:32:29 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/css-enabled/output/output.html | 0 / 1 (0%)
[task 2025-04-22T05:32:29.739Z] 05:32:29 INFO - [GFX1-]: Failed to connect WebRenderBridgeChild. isParent=false
[task 2025-04-22T05:32:30.283Z] 05:32:30 INFO - [CodeCoverage] Setting handlers for process 9997.
[task 2025-04-22T05:32:30.415Z] 05:32:30 INFO - REFTEST INFO | drawWindow flags = DRAWWINDOW_DRAW_CARET | DRAWWINDOW_DRAW_VIEW | DRAWWINDOW_USE_WIDGET_LAYERS; window size = 800,1000; test browser size = 800,1000
[task 2025-04-22T05:32:30.484Z] 05:32:30 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/css-enabled/output/output-ref.html | 0 / 1 (0%)
[task 2025-04-22T05:32:30.583Z] 05:32:30 INFO - REFTEST TEST-PASS | layout/reftests/css-enabled/output/output.html == layout/reftests/css-enabled/output/output-ref.html | image comparison, max difference: 0, number of differing pixels: 0
[task 2025-04-22T05:32:30.583Z] 05:32:30 INFO - REFTEST TEST-END | layout/reftests/css-enabled/output/output.html == layout/reftests/css-enabled/output/output-ref.html
[task 2025-04-22T05:32:30.603Z] 05:32:30 INFO - REFTEST INFO | Slowest test took 112ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/css-enabled/output/output.html)
[task 2025-04-22T05:32:30.604Z] 05:32:30 INFO - REFTEST INFO | Total canvas count = 2
[task 2025-04-22T05:32:31.010Z] 05:32:31 INFO - [CodeCoverage] Setting handlers for process 10033.
[task 2025-04-22T05:32:31.052Z] 05:32:31 INFO - 1745299951051 Marionette TRACE Received observer notification quit-application
[task 2025-04-22T05:32:31.053Z] 05:32:31 INFO - 1745299951051 Marionette INFO Stopped listening on port 2828
[task 2025-04-22T05:32:31.054Z] 05:32:31 INFO - 1745299951053 Marionette DEBUG Marionette stopped listening
[task 2025-04-22T05:32:33.708Z] 05:32:33 INFO - REFTEST INFO | Process mode: e10s
[task 2025-04-22T05:32:33.708Z] 05:32:33 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2025-04-22T05:32:33.717Z] 05:32:33 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/flexbox/pagination/reftest.list
[task 2025-04-22T05:32:33.728Z] 05:32:33 INFO - REFTEST INFO | Running with e10s: True
[task 2025-04-22T05:32:33.729Z] 05:32:33 INFO - REFTEST INFO | Running with fission: True
[task 2025-04-22T05:32:33.729Z] 05:32:33 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpkxichixy.mozrunner
[task 2025-04-22T05:32:33.781Z] 05:32:33 INFO - [CodeCoverage] Setting handlers for process 10084.
[task 2025-04-22T05:32:34.490Z] 05:32:34 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:32:34.530Z] 05:32:34 INFO - 1745299954529 Marionette INFO Marionette enabled
[task 2025-04-22T05:32:34.532Z] 05:32:34 INFO - 1745299954532 Marionette TRACE Received observer notification final-ui-startup
[task 2025-04-22T05:32:34.638Z] 05:32:34 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2025-04-22T05:32:34.781Z] 05:32:34 INFO - 1745299954780 Marionette INFO Listening on port 2828
[task 2025-04-22T05:32:34.785Z] 05:32:34 INFO - 1745299954784 Marionette DEBUG Marionette is listening
[task 2025-04-22T05:32:34.814Z] 05:32:34 INFO - 1745299954813 Marionette DEBUG Accepted connection 0 from 127.0.0.1:44822
[task 2025-04-22T05:32:34.841Z] 05:32:34 INFO - 1745299954840 Marionette DEBUG Accepted connection 1 from 127.0.0.1:44824
[task 2025-04-22T05:32:34.841Z] 05:32:34 INFO - 1745299954840 Marionette DEBUG Closed connection 0
[task 2025-04-22T05:32:34.975Z] 05:32:34 INFO - 1745299954974 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-04-22T05:32:34.981Z] 05:32:34 INFO - 1745299954980 Marionette DEBUG Waiting for initial application window
[task 2025-04-22T05:32:35.871Z] 05:32:35 INFO - [CodeCoverage] Setting handlers for process 10178.
[task 2025-04-22T05:32:36.224Z] 05:32:36 INFO - [CodeCoverage] Setting handlers for process 10192.
[task 2025-04-22T05:32:39.328Z] 05:32:39 INFO - 1745299959327 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2025-04-22T05:32:39.350Z] 05:32:39 INFO - 1745299959349 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2025-04-22T05:32:39.351Z] 05:32:39 INFO - 1745299959350 RemoteAgent TRACE [9] ProgressListener Setting unload timer (80000ms)
[task 2025-04-22T05:32:39.356Z] 05:32:39 INFO - 1745299959352 RemoteAgent TRACE [9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-04-22T05:32:39.359Z] 05:32:39 INFO - 1745299959353 RemoteAgent TRACE [9] Document already finished loading: about:blank
[task 2025-04-22T05:32:39.362Z] 05:32:39 INFO - 1745299959353 RemoteAgent TRACE [9] ProgressListener Stop: has error=false url=about:blank
[task 2025-04-22T05:32:39.470Z] 05:32:39 INFO - 1745299959468 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"213ed2a6-a34f-4779-9dc4-24e6d6e1a9a1","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"139.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0","moz:buildID":"20250422040745","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":10084,"moz:profile":"/tmp/tmpkxichixy.mozrunner","moz:shutdownTimeout":180000,"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-04-22T05:32:39.491Z] 05:32:39 INFO - 1745299959489 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/specialpowers","temporary":true}]
[task 2025-04-22T05:32:39.602Z] 05:32:39 INFO - 1745299959601 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-04-22T05:32:39.631Z] 05:32:39 INFO - 1745299959630 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/reftest","temporary":true}]
[task 2025-04-22T05:32:39.723Z] 05:32:39 INFO - 1745299959723 RemoteAgent TRACE Received observer notification domwindowopened
[task 2025-04-22T05:32:39.742Z] 05:32:39 INFO - 1745299959741 Marionette DEBUG 1 <- [1,3,null,{"value":"reftest@mozilla.org"}]
[task 2025-04-22T05:32:39.768Z] 05:32:39 INFO - 1745299959767 Marionette DEBUG 1 -> [0,4,"WebDriver:DeleteSession",{}]
[task 2025-04-22T05:32:39.779Z] 05:32:39 INFO - 1745299959778 Marionette DEBUG 1 <- [1,4,null,{"value":null}]
[task 2025-04-22T05:32:39.793Z] 05:32:39 INFO - 1745299959792 Marionette DEBUG Closed connection 1
[task 2025-04-22T05:32:40.083Z] 05:32:40 INFO - [CodeCoverage] Setting handlers for process 10265.
[task 2025-04-22T05:32:40.339Z] 05:32:40 INFO - [CodeCoverage] Setting handlers for process 10271.
[task 2025-04-22T05:32:40.375Z] 05:32:40 INFO - [CodeCoverage] Setting handlers for process 10273.
[task 2025-04-22T05:32:40.402Z] 05:32:40 INFO - [CodeCoverage] Setting handlers for process 10270.
[task 2025-04-22T05:32:40.516Z] 05:32:40 INFO - [GFX1-]: Failed to connect WebRenderBridgeChild. isParent=false
[task 2025-04-22T05:32:40.644Z] 05:32:40 INFO - REFTEST TEST-START | layout/reftests/flexbox/pagination/flexbox-empty-1a.html == layout/reftests/flexbox/pagination/flexbox-empty-1-ref.html
[task 2025-04-22T05:32:40.645Z] 05:32:40 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/flexbox/pagination/flexbox-empty-1a.html | 0 / 170 (0%)
[task 2025-04-22T05:32:41.152Z] 05:32:41 INFO - [CodeCoverage] Setting handlers for process 10378.
[task 2025-04-22T05:32:41.304Z] 05:32:41 INFO - REFTEST INFO | drawWindow flags = DRAWWINDOW_DRAW_CARET | DRAWWINDOW_DRAW_VIEW | DRAWWINDOW_USE_WIDGET_LAYERS; window size = 800,1000; test browser size = 800,1000
[task 2025-04-22T05:32:41.473Z] 05:32:41 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/flexbox/pagination/flexbox-empty-1-ref.html | 0 / 170 (0%)
[task 2025-04-22T05:32:41.598Z] 05:32:41 INFO - REFTEST TEST-PASS | layout/reftests/flexbox/pagination/flexbox-empty-1a.html == layout/reftests/flexbox/pagination/flexbox-empty-1-ref.html | image comparison, max difference: 0, number of differing pixels: 0
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•16 days ago
|
Whiteboard: [collect_confirm_failure]
You need to log in
before you can comment on or make changes to this bug.
Description
•