Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=423452241&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/N5Q8y_usT32DiMeQJxrhhg/runs/0/artifacts/public/logs/live_backing.log
[task 2023-07-21T17:20:55.012Z] 17:20:55 INFO - TEST-START | editor/spellchecker/tests/test_bug1418629.html
[task 2023-07-21T17:20:55.385Z] 17:20:55 INFO - GECKO(9040) | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-07-21T17:26:03.806Z] 17:26:03 INFO - TEST-INFO | started process screentopng
[task 2023-07-21T17:26:03.930Z] 17:26:03 INFO - TEST-INFO | screentopng: exit 0
[task 2023-07-21T17:26:03.931Z] 17:26:03 INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1418629.html | Test timed out. -
[task 2023-07-21T17:26:33.808Z] 17:26:33 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:26:33.808Z] 17:26:33 INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1418629.html | Test timed out. -
[task 2023-07-21T17:27:03.809Z] 17:27:03 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:27:03.810Z] 17:27:03 INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1418629.html | Test timed out. -
[task 2023-07-21T17:27:33.811Z] 17:27:33 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:27:33.811Z] 17:27:33 INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1418629.html | Test timed out. -
[task 2023-07-21T17:27:33.812Z] 17:27:33 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:27:33.812Z] 17:27:33 INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | 4 test timeouts, giving up. -
[task 2023-07-21T17:27:33.813Z] 17:27:33 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:27:33.813Z] 17:27:33 INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | Skipping 18 remaining tests. -
[task 2023-07-21T17:33:43.830Z] 17:33:43 INFO - TEST-UNEXPECTED-TIMEOUT | editor/spellchecker/tests/test_bug1418629.html | application timed out after 370 seconds with no output
[task 2023-07-21T17:33:43.830Z] 17:33:43 INFO - TEST-INFO took 767989ms
[task 2023-07-21T17:33:43.830Z] 17:33:43 INFO - Buffered messages finished
[task 2023-07-21T17:33:43.830Z] 17:33:43 WARNING - Force-terminating active process(es).
[task 2023-07-21T17:33:43.830Z] 17:33:43 INFO - Determining child pids from psutil...
[task 2023-07-21T17:33:43.849Z] 17:33:43 INFO - [9128, 9218, 9219, 9223, 9513, 9557, 9558, 9568, 9569]
[task 2023-07-21T17:33:43.850Z] 17:33:43 INFO - ==> process 9040 launched child process 9057
[task 2023-07-21T17:33:43.850Z] 17:33:43 INFO - ==> process 9040 launched child process 9128
[task 2023-07-21T17:33:43.850Z] 17:33:43 INFO - ==> process 9040 launched child process 9132
[task 2023-07-21T17:33:43.851Z] 17:33:43 INFO - ==> process 9040 launched child process 9218
[task 2023-07-21T17:33:43.853Z] 17:33:43 INFO - ==> process 9040 launched child process 9219
[task 2023-07-21T17:33:43.853Z] 17:33:43 INFO - ==> process 9040 launched child process 9220
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9222
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9223
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9316
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9355
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9356
[task 2023-07-21T17:33:43.855Z] 17:33:43 INFO - ==> process 9040 launched child process 9404
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9431
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9470
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9471
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9513
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9557
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9558
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9568
[task 2023-07-21T17:33:43.857Z] 17:33:43 INFO - ==> process 9040 launched child process 9569
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Found child pids: {9218, 9219, 9220, 9222, 9223, 9355, 9356, 9128, 9513, 9132, 9404, 9557, 9558, 9431, 9568, 9569, 9057, 9316, 9470, 9471}
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Failed to get child procs
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Killing process: 9218
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Killing process: 9219
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Killing process: 9220
[task 2023-07-21T17:33:43.858Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.859Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.859Z] 17:33:43 INFO - Killing process: 9222
[task 2023-07-21T17:33:43.859Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.859Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.859Z] 17:33:43 INFO - Killing process: 9223
[task 2023-07-21T17:33:43.860Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.860Z] 17:33:43 INFO - Killing process: 9355
[task 2023-07-21T17:33:43.860Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.860Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.861Z] 17:33:43 INFO - Killing process: 9356
[task 2023-07-21T17:33:43.861Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.861Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.861Z] 17:33:43 INFO - Killing process: 9128
[task 2023-07-21T17:33:43.862Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.862Z] 17:33:43 INFO - Killing process: 9513
[task 2023-07-21T17:33:43.862Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.862Z] 17:33:43 INFO - Killing process: 9132
[task 2023-07-21T17:33:43.863Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.863Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.863Z] 17:33:43 INFO - Killing process: 9404
[task 2023-07-21T17:33:43.863Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.864Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.864Z] 17:33:43 INFO - Killing process: 9557
[task 2023-07-21T17:33:43.864Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.864Z] 17:33:43 INFO - Killing process: 9558
[task 2023-07-21T17:33:43.865Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.865Z] 17:33:43 INFO - Killing process: 9431
[task 2023-07-21T17:33:43.865Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.865Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.866Z] 17:33:43 INFO - Killing process: 9568
[task 2023-07-21T17:33:43.866Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.866Z] 17:33:43 INFO - Killing process: 9569
[task 2023-07-21T17:33:43.866Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.867Z] 17:33:43 INFO - Killing process: 9057
[task 2023-07-21T17:33:43.867Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.867Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.867Z] 17:33:43 INFO - Killing process: 9316
[task 2023-07-21T17:33:43.867Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.868Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.868Z] 17:33:43 INFO - Killing process: 9470
[task 2023-07-21T17:33:43.868Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.868Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.869Z] 17:33:43 INFO - Killing process: 9471
[task 2023-07-21T17:33:43.869Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.869Z] 17:33:43 INFO - Can't trigger Breakpad, process no longer exists
[task 2023-07-21T17:33:43.869Z] 17:33:43 INFO - Killing process: 9040
[task 2023-07-21T17:33:43.870Z] 17:33:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-21T17:33:43.954Z] 17:33:43 INFO - psutil found pid 9040 dead
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - TEST-INFO | Main app process: exit 0
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - runtests.py | Application ran for: 0:13:19.498380
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - zombiecheck | Reading PID log: /tmp/tmphdu20ta9pidlog
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9057
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9128
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9132
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9218
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9219
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9220
[task 2023-07-21T17:33:43.955Z] 17:33:43 INFO - ==> process 9040 launched child process 9222
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9223
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9316
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9355
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9356
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9404
[task 2023-07-21T17:33:43.956Z] 17:33:43 INFO - ==> process 9040 launched child process 9431
[task 2023-07-21T17:33:43.957Z] 17:33:43 INFO - ==> process 9040 launched child process 9470
[task 2023-07-21T17:33:43.957Z] 17:33:43 INFO - ==> process 9040 launched child process 9471
[task 2023-07-21T17:33:43.957Z] 17:33:43 INFO - ==> process 9040 launched child process 9513
[task 2023-07-21T17:33:43.957Z] 17:33:43 INFO - ==> process 9040 launched child process 9557
[task 2023-07-21T17:33:43.958Z] 17:33:43 INFO - ==> process 9040 launched child process 9558
[task 2023-07-21T17:33:43.958Z] 17:33:43 INFO - ==> process 9040 launched child process 9568
[task 2023-07-21T17:33:43.958Z] 17:33:43 INFO - ==> process 9040 launched child process 9569
[task 2023-07-21T17:33:43.958Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9218
[task 2023-07-21T17:33:43.959Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9219
[task 2023-07-21T17:33:43.959Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9220
[task 2023-07-21T17:33:43.959Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9222
[task 2023-07-21T17:33:43.959Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9223
[task 2023-07-21T17:33:43.960Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9355
[task 2023-07-21T17:33:43.960Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9356
[task 2023-07-21T17:33:43.960Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9128
[task 2023-07-21T17:33:43.960Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9513
[task 2023-07-21T17:33:43.961Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9132
[task 2023-07-21T17:33:43.961Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9404
[task 2023-07-21T17:33:43.961Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9557
[task 2023-07-21T17:33:43.961Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9558
[task 2023-07-21T17:33:43.962Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9431
[task 2023-07-21T17:33:43.962Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9568
[task 2023-07-21T17:33:43.962Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9057
[task 2023-07-21T17:33:43.962Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9569
[task 2023-07-21T17:33:43.963Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9316
[task 2023-07-21T17:33:43.963Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9470
[task 2023-07-21T17:33:43.963Z] 17:33:43 INFO - zombiecheck | Checking for orphan process with PID: 9471
[task 2023-07-21T17:33:43.964Z] 17:33:43 INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AZWtHChJTj6e4C-P35XOAg/artifacts/public/build/target.crashreporter-symbols.zip
[task 2023-07-21T17:33:53.484Z] 17:33:53 INFO - mozcrash Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmptcsoemld/34f7675e-778a-cbbe-2ad6-a06e16442a68.trace /tmp/tmp_pqvtuin.mozrunner/minidumps/34f7675e-778a-cbbe-2ad6-a06e16442a68.dmp /tmp/tmpmf5_tkwl
[task 2023-07-21T17:33:53.490Z] 17:33:53 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/34f7675e-778a-cbbe-2ad6-a06e16442a68.dmp
[task 2023-07-21T17:33:53.491Z] 17:33:53 INFO - PROCESS-CRASH | application crashed [None] | editor/spellchecker/tests/mochitest.ini
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - Process type: unknown
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - Process pid: None
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - Crash dump filename: /tmp/tmp_pqvtuin.mozrunner/minidumps/34f7675e-778a-cbbe-2ad6-a06e16442a68.dmp
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - stderr from minidump-stackwalk:
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - [31mERROR[0m MissingSystemInfo - Error processing dump: The system information stream was not found
[task 2023-07-21T17:33:53.492Z] 17:33:53 INFO - mozcrash Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmpqao754ok/0c4c0368-3bbd-ccbd-6908-3673594bb674.trace /tmp/tmp_pqvtuin.mozrunner/minidumps/0c4c0368-3bbd-ccbd-6908-3673594bb674.dmp /tmp/tmpmf5_tkwl
[task 2023-07-21T17:33:54.740Z] 17:33:54 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/0c4c0368-3bbd-ccbd-6908-3673594bb674.dmp
[task 2023-07-21T17:33:54.740Z] 17:33:54 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/0c4c0368-3bbd-ccbd-6908-3673594bb674.extra
[task 2023-07-21T17:33:54.751Z] 17:33:54 INFO - PROCESS-CRASH | application crashed [@ __lll_lock_wait] | editor/spellchecker/tests/mochitest.ini
[task 2023-07-21T17:33:54.751Z] 17:33:54 INFO - Process type: main
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Process pid: None
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Crash dump filename: /tmp/tmp_pqvtuin.mozrunner/minidumps/0c4c0368-3bbd-ccbd-6908-3673594bb674.dmp
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Operating system: Linux
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - CPU: amd64
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - family 6 model 85 stepping 7
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - 4 CPUs
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Crash reason: SIGABRT
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Crash address: 0x3e800000600
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Crashing instruction: `mov eax, edx`
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - No memory accessed by instruction
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Process uptime: not available
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Thread 0 IPC Launch (crashed)
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - 0 libpthread.so.0!__lll_lock_wait + 0x1d
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rax = 0xfffffffffffffffc rdx = 0x0000000000000002
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rcx = 0x00007fbc357e711d rbx = 0x0000000000000000
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rsi = 0x0000000000000080 rdi = 0x00007fbc35c1d990
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rbp = 0x00007fbbe7dfd020 rsp = 0x00007fbbe7dfcdd8
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - r8 = 0x00007fbc35c1d990 r9 = 0x0000000009393363
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - r10 = 0x0000000000000000 r11 = 0x0000000000000202
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - r12 = 0x00007fbc35c1d060 r13 = 0x00007fbc34ca47f0
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - r14 = 0x00007fbbe7dfcf30 r15 = 0x00007fbc34ca4067
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rip = 0x00007fbc357e711d
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - Found by: given as instruction pointer in context
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - 1 libpthread.so.0!pthread_mutex_lock [pthread_mutex_lock.c : 113 + 0x1b]
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rdx = 0x0000000000002555 rbx = 0x0000000000000000
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - rbp = 0x00007fbbe7dfd020 rsp = 0x00007fbbe7dfcdf0
[task 2023-07-21T17:33:54.752Z] 17:33:54 INFO - r10 = 0x00007fbbd7ff6f40 r12 = 0x00007fbc35c1d060
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r13 = 0x00007fbc34ca47f0 r14 = 0x00007fbbe7dfcf30
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r15 = 0x00007fbc34ca4067 rip = 0x00007fbc357e0098
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: call frame info
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 2 libc.so.6!__dl_iterate_phdr [dl-iteratephdr.c : 40 + 0xf]
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rbx = 0x0000000000000000 rbp = 0x00007fbbe7dfd020
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfce80 r12 = 0x00007fbc35c1d060
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r13 = 0x00007fbc34ca47f0 r14 = 0x00007fbbe7dfcf30
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r15 = 0x00007fbc34ca4067 rip = 0x00007fbc34a0802b
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: call frame info
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 3 libgcc_s.so.1 + 0x12aa0
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rbx = 0x0000000000000000 rbp = 0x00007fbbe7dfd020
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcf30 r12 = 0x00007fbbe7dfd278
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r13 = 0x00007fbc357e4f90 r14 = 0x00007fbc34eaa3b0
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - r15 = 0x00007fbc34ca4067 rip = 0x00007fbc34ca5aa1
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: call frame info
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 4 libgcc_s.so.1 + 0x11066
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcf38 rip = 0x00007fbc34ca4067
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 5 firefox-bin!MozStackWalk + 0x68
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcf80 rip = 0x000055b8ac3303d9
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 6 firefox-bin!MozStackWalk + 0x8f
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcf98 rip = 0x000055b8ac330400
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 7 libgcc_s.so.1 + 0xf182
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcfa0 rip = 0x00007fbc34ca2183
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - 8 firefox-bin!MozStackWalk + 0x68
[task 2023-07-21T17:33:54.753Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfcff0 rip = 0x000055b8ac3303d9
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 9 firefox-bin!MozStackWalk + 0x8f
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfd008 rip = 0x000055b8ac330400
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 10 libgcc_s.so.1 + 0x1035f
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - rsp = 0x00007fbbe7dfd010 rip = 0x00007fbc34ca3360
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - Found by: stack scanning
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - Loaded modules:
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x55b8ac221000 - 0x55b8ac3a8fff firefox-bin ??? (main)
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fb9ea800000 - 0x7fb9ea870fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbc6000000 - 0x7fbbd5ffffff memfd:pulseaudio (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd7031000 - 0x7fbbd70fcfff SYSV00000000 (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd74ff000 - 0x7fbbd7706fff libcanberra-pulse.so ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd77b8000 - 0x7fbbd77fffff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd9b0b000 - 0x7fbbd9b61fff Ubuntu-R.ttf ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd9b64000 - 0x7fbbd9b86fff StaticComponents.gcda ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbd9b87000 - 0x7fbbd9ba4fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbda412000 - 0x7fbbda4befff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdaa53000 - 0x7fbbdaaf8fff libnssckbi.so ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdaafd000 - 0x7fbbdabedfff libfreeblpriv3.so ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdbf01000 - 0x7fbbdbf03fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdbf04000 - 0x7fbbdbf25fff LiberationSans-Bold.ttf ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdbf67000 - 0x7fbbdbfddfff libsoftokn3.so ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdc02e000 - 0x7fbbdc037fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdd507000 - 0x7fbbdd529fff LiberationSans-Regular.ttf ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdd52a000 - 0x7fbbdd538fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdd5fc000 - 0x7fbbdd7fffff libXss.so.1 ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbdda00000 - 0x7fbbdda20fff mochikit@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbe5f46000 - 0x7fbbe5ffefff DejaVuSans.ttf ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbe7c42000 - 0x7fbbe7cfafff DejaVuSans.ttf ???
[task 2023-07-21T17:33:54.754Z] 17:33:54 INFO - 0x7fbbe8b00000 - 0x7fbbe8b01fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbe8b1b000 - 0x7fbbe8b1dfff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbe8b21000 - 0x7fbbe8b7dfff DejaVuSerif.ttf ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbe8fbf000 - 0x7fbbe8ffffff gschemas.compiled ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea30b000 - 0x7fbbea319fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea330000 - 0x7fbbea331fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea332000 - 0x7fbbea33dfff special-powers@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea356000 - 0x7fbbea358fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea39a000 - 0x7fbbea3fffff webcompat@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbea905000 - 0x7fbbea913fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbec959000 - 0x7fbbecb5ffff libpixbufloader-png.so ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf0b67000 - 0x7fbbf0d6cfff libXxf86vm.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf0d6d000 - 0x7fbbf0f87fff libxcb-glx.so.0 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf0f88000 - 0x7fbbf11fefff libGLX_mesa.so.0 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf1a08000 - 0x7fbbf1a09fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf5a9c000 - 0x7fbbf5b9bfff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf5b9c000 - 0x7fbbf5dc5fff libtinfo.so.5 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf5dc6000 - 0x7fbbf5ff8fff libedit.so.2 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf5ffd000 - 0x7fbbf6204fff libdrm_nouveau.so.2 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf6205000 - 0x7fbbf640efff libdrm_amdgpu.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf640f000 - 0x7fbbf6628fff libelf.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf6629000 - 0x7fbbf6834fff libdrm_radeon.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf6835000 - 0x7fbbf6a43fff libsensors.so.4 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf6a44000 - 0x7fbbf6cbefff libzstd.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbf6cbf000 - 0x7fbbfb35afff libLLVM-10.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfb3b1000 - 0x7fbbfc902fff libgallium_dri.so ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfcbe5000 - 0x7fbbfcde6fff libxshmfence.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfcde7000 - 0x7fbbfcfedfff libxcb-sync.so.1 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfcfee000 - 0x7fbbfd1f0fff libxcb-present.so.0 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfd1f1000 - 0x7fbbfd3f4fff libxcb-dri3.so.0 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfd3f5000 - 0x7fbbfd5fcfff libxcb-xfixes.so.0 ???
[task 2023-07-21T17:33:54.755Z] 17:33:54 INFO - 0x7fbbfd5fd000 - 0x7fbbfd801fff libxcb-dri2.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfd802000 - 0x7fbbfda37fff libglapi.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfda39000 - 0x7fbbfdc77fff libEGL_mesa.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfdc79000 - 0x7fbbfde89fff libGLX.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfdeaa000 - 0x7fbbfe134fff libGL.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfe136000 - 0x7fbbfe3cbfff libGLdispatch.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfe3ec000 - 0x7fbbfe5fffff libEGL.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfe800000 - 0x7fbbfe83bfff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfee00000 - 0x7fbbfee00fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfee15000 - 0x7fbbfee15fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfee7b000 - 0x7fbbfee82fff webcompat-reporter@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfee83000 - 0x7fbbfeea9fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbfeeae000 - 0x7fbbfeebdfff pictureinpicture@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbff300000 - 0x7fbbff302fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbff307000 - 0x7fbbff328fff formautofill@mozilla.org.xpi ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbbff700000 - 0x7fbbff701fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc0012b000 - 0x7fbc0033dfff libwayland-server.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc0033e000 - 0x7fbc0054efff libdrm.so.2 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc0054f000 - 0x7fbc0075dfff libgbm.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc0075e000 - 0x7fbc00a06fff libvorbisenc.so.2 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc00a07000 - 0x7fbc00c7dfff libFLAC.so.8 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc00c7e000 - 0x7fbc00e95fff libnsl.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc00e98000 - 0x7fbc010a7fff libapparmor.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc010a8000 - 0x7fbc012adfff libasyncns.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc012ae000 - 0x7fbc01524fff libsndfile.so.1 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc01527000 - 0x7fbc01730fff libwrap.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc01731000 - 0x7fbc019affff libpulsecommon-11.1.so ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc019b0000 - 0x7fbc01bfffff libpulse.so.0 ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc01e00000 - 0x7fbc01e00fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.756Z] 17:33:54 INFO - 0x7fbc01e05000 - 0x7fbc01e05fff e70e5a91697f9e0c108e0faf149b7338-le64.cache-7 ???
....
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc359f5000 - 0x7fbc35a1bfff ld-linux-x86-64.so.2 ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a1c000 - 0x7fbc35a1cfff 4b2eda6bb976bda485cb2176619421d5-le64.cache-7 ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a1d000 - 0x7fbc35a1dfff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a1e000 - 0x7fbc35a1efff user ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a2b000 - 0x7fbc35a34fff libmozwayland.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a35000 - 0x7fbc35a3bfff libmozgtk.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35a3c000 - 0x7fbc35ad3fff libssl3.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35ae7000 - 0x7fbc35b25fff libsmime3.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35b2e000 - 0x7fbc35b73fff libnssutil3.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35b7a000 - 0x7fbc35b8efff liblgpllibs.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35b90000 - 0x7fbc35be7fff libnspr4.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35bfc000 - 0x7fbc35bfcfff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35c01000 - 0x7fbc35c01fff memfd:mozilla-ipc (deleted) ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35c02000 - 0x7fbc35c0bfff libplds4.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7fbc35c0c000 - 0x7fbc35c18fff libplc4.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - 0x7ffd9c9ee000 - 0x7ffd9c9effff linux-gate.so ???
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - Unloaded modules:
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO -
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - Unimplemented streams encountered:
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - Stream 0x4767000a LinuxDsoDebug (Google Extension) @ 0x0003be68
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - Stream 0x47670008 LinuxAuxv (Google Extension) @ 0x000149e0
[task 2023-07-21T17:33:54.761Z] 17:33:54 INFO - Stream 0x47670006 LinuxCmdLine (Google Extension) @ 0x00013320
[task 2023-07-21T17:33:55.357Z] 17:33:55 INFO - Stopping web server
[task 2023-07-21T17:33:55.360Z] 17:33:55 INFO - Server shut down.
[task 2023-07-21T17:33:55.380Z] 17:33:55 INFO - Web server killed.
[task 2023-07-21T17:33:55.380Z] 17:33:55 INFO - Stopping web socket server
[task 2023-07-21T17:33:55.401Z] 17:33:55 INFO - Stopping ssltunnel
[task 2023-07-21T17:33:55.421Z] 17:33:55 INFO - Stopping gst for v4l2loopback
[task 2023-07-21T17:33:55.422Z] 17:33:55 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2023-07-21T17:33:55.422Z] 17:33:55 INFO - runtests.py | Running tests: end.
[task 2023-07-21T17:33:55.437Z] 17:33:55 INFO - Failed to unload module: Module b'78\n' not loaded
[task 2023-07-21T17:33:55.442Z] 17:33:55 INFO - Failed to unload module: Module b'79\n' not loaded
[task 2023-07-21T17:33:55.446Z] 17:33:55 INFO - Failed to unload module: Module b'80\n' not loaded
[task 2023-07-21T17:33:55.451Z] 17:33:55 INFO - Failed to unload module: Module b'81\n' not loaded
[task 2023-07-21T17:33:55.452Z] 17:33:55 INFO - Buffered messages finished
[task 2023-07-21T17:33:55.452Z] 17:33:55 INFO - Running manifest: gfx/tests/mochitest/mochitest.ini
[task 2023-07-21T17:33:55.472Z] 17:33:55 INFO - Setting pipeline to PAUSED ...
[task 2023-07-21T17:33:55.472Z] 17:33:55 INFO - Pipeline is PREROLLING ...
[task 2023-07-21T17:33:55.476Z] 17:33:55 INFO - Pipeline is PREROLLED ...
[task 2023-07-21T17:33:55.476Z] 17:33:55 INFO - Setting pipeline to PLAYING ...
[task 2023-07-21T17:33:55.476Z] 17:33:55 INFO - New clock: GstSystemClock
[task 2023-07-21T17:33:55.507Z] 17:33:55 INFO - Got EOS from element "pipeline0".
[task 2023-07-21T17:33:55.507Z] 17:33:55 INFO - Execution ended after 0:00:00.033464887
[task 2023-07-21T17:33:55.508Z] 17:33:55 INFO - Setting pipeline to PAUSED ...
[task 2023-07-21T17:33:55.509Z] 17:33:55 INFO - Setting pipeline to READY ...
[task 2023-07-21T17:33:55.509Z] 17:33:55 INFO - (gst-launch-1.0:9606): GStreamer-CRITICAL **: 17:33:55.506: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2023-07-21T17:33:55.509Z] 17:33:55 INFO - Setting pipeline to NULL ...
[task 2023-07-21T17:33:55.509Z] 17:33:55 INFO - Freeing pipeline ...
[task 2023-07-21T17:33:55.536Z] 17:33:55 INFO - PID 9617 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2023-07-21T17:33:55.696Z] 17:33:55 INFO - MochitestServer : launching ['/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-e', "const _PROFILE_PATH = '/tmp/tmpw550fg8o.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false; const _HTTPD_PATH = '/builds/worker/workspace/build/tests/bin/components';", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2023-07-21T17:33:55.696Z] 17:33:55 INFO - runtests.py | Server pid: 9635
[task 2023-07-21T17:33:55.701Z] 17:33:55 INFO - runtests.py | Websocket server pid: 9638
[task 2023-07-21T17:33:55.707Z] 17:33:55 INFO - runtests.py | SSL tunnel pid: 9642
[task 2023-07-21T17:33:55.775Z] 17:33:55 INFO - [CodeCoverage] Setting handlers for process 9635.
[task 2023-07-21T17:33:55.808Z] 17:33:55 INFO - use http3 server: 0
[task 2023-07-21T17:33:55.809Z] 17:33:55 INFO - runtests.py | Running with scheme: http
[task 2023-07-21T17:33:55.809Z] 17:33:55 INFO - runtests.py | Running with e10s: True
[task 2023-07-21T17:33:55.810Z] 17:33:55 INFO - runtests.py | Running with fission: True
[task 2023-07-21T17:33:55.810Z] 17:33:55 INFO - runtests.py | Running with cross-origin iframes: True
[task 2023-07-21T17:33:55.810Z] 17:33:55 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2023-07-21T17:33:55.811Z] 17:33:55 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2023-07-21T17:33:55.811Z] 17:33:55 INFO - runtests.py | Running tests: start.
[task 2023-07-21T17:33:55.811Z] 17:33:55 INFO -
[task 2023-07-21T17:33:55.884Z] 17:33:55 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpw550fg8o.mozrunner
[task 2023-07-21T17:33:55.891Z] 17:33:55 INFO - runtests.py | Application pid: 9664
[task 2023-07-21T17:33:55.891Z] 17:33:55 INFO - TEST-INFO | started process GECKO(9664)
[task 2023-07-21T17:33:55.936Z] 17:33:55 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9664.
[task 2023-07-21T17:33:56.690Z] 17:33:56 INFO - GECKO(9664) | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2023-07-21T17:33:56.726Z] 17:33:56 INFO - GECKO(9664) | 1689960836725 Marionette INFO Marionette enabled
[task 2023-07-21T17:33:56.728Z] 17:33:56 INFO - GECKO(9664) | 1689960836727 Marionette TRACE Received observer notification final-ui-startup
[task 2023-07-21T17:33:56.820Z] 17:33:56 INFO - GECKO(9664) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2023-07-21T17:33:56.829Z] 17:33:56 INFO - GECKO(9664) | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2023-07-21T17:33:56.859Z] 17:33:56 INFO - GECKO(9664) | 1689960836858 Marionette INFO Listening on port 2828
[task 2023-07-21T17:33:56.861Z] 17:33:56 INFO - GECKO(9664) | 1689960836861 Marionette DEBUG Marionette is listening
[task 2023-07-21T17:33:56.879Z] 17:33:56 INFO - GECKO(9664) | 1689960836879 Marionette DEBUG Accepted connection 0 from 127.0.0.1:49674
[task 2023-07-21T17:33:56.919Z] 17:33:56 INFO - GECKO(9664) | 1689960836919 Marionette DEBUG Closed connection 0
[task 2023-07-21T17:33:56.920Z] 17:33:56 INFO - GECKO(9664) | 1689960836919 Marionette DEBUG Accepted connection 1 from 127.0.0.1:49676
[task 2023-07-21T17:33:57.190Z] 17:33:57 INFO - GECKO(9664) | 1689960837189 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2023-07-21T17:33:57.196Z] 17:33:57 INFO - GECKO(9664) | 1689960837195 Marionette DEBUG Waiting for initial application window
[task 2023-07-21T17:33:57.730Z] 17:33:57 INFO - GECKO(9664) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-21T17:33:57.844Z] 17:33:57 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9753.
[task 2023-07-21T17:33:57.962Z] 17:33:57 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9757.
[task 2023-07-21T17:34:00.618Z] 17:34:00 INFO - GECKO(9664) | console.error: ({})
[task 2023-07-21T17:34:00.687Z] 17:34:00 INFO - GECKO(9664) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-21T17:34:02.401Z] 17:34:02 INFO - GECKO(9664) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-21T17:34:02.401Z] 17:34:02 INFO - GECKO(9664) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-21T17:34:02.403Z] 17:34:02 INFO - GECKO(9664) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-21T17:34:02.699Z] 17:34:02 INFO - GECKO(9664) | 1689960842698 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2023-07-21T17:34:02.725Z] 17:34:02 INFO - GECKO(9664) | 1689960842724 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2023-07-21T17:34:02.728Z] 17:34:02 INFO - GECKO(9664) | 1689960842724 RemoteAgent TRACE [9] ProgressListener Setting unload timer (80000ms)
[task 2023-07-21T17:34:02.728Z] 17:34:02 INFO - GECKO(9664) | 1689960842725 RemoteAgent TRACE [9] Document already finished loading: about:blank
[task 2023-07-21T17:34:02.728Z] 17:34:02 INFO - GECKO(9664) | 1689960842725 RemoteAgent TRACE [9] ProgressListener Stop: has error=false
[task 2023-07-21T17:34:02.791Z] 17:34:02 INFO - GECKO(9664) | 1689960842789 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"60418846-ccfc-4e0b-9641-990416ccb147","capabilities":{"browserName":"firefox","browserVersion":"117.0a1","platformName":"linux","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","moz:accessibilityChecks":false,"moz:buildID":"20230721155920","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":9664,"moz:profile":"/tmp/tmpw550fg8o.mozrunner","moz:shutdownTimeout":180000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2023-07-21T17:34:02.816Z] 17:34:02 INFO - GECKO(9664) | 1689960842815 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/tmp/tmplt9yo_j1.zip","temporary":false}]
[task 2023-07-21T17:34:03.063Z] 17:34:03 INFO - GECKO(9664) | 1689960843062 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2023-07-21T17:34:03.116Z] 17:34:03 INFO - GECKO(9664) | 1689960843115 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpm33k5r03.zip","temporary":false}]
[task 2023-07-21T17:34:03.204Z] 17:34:03 INFO - GECKO(9664) | 1689960843203 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2023-07-21T17:34:03.212Z] 17:34:03 INFO - GECKO(9664) | 1689960843211 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2023-07-21T17:34:03.213Z] 17:34:03 INFO - GECKO(9664) | 1689960843212 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2023-07-21T17:34:03.221Z] 17:34:03 INFO - GECKO(9664) | 1689960843220 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-07-21T17:34:03.222Z] 17:34:03 INFO - GECKO(9664) | 1689960843220 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2023-07-21T17:34:03.224Z] 17:34:03 INFO - GECKO(9664) | 1689960843223 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distr ... s which flavor and url to load.\nlet ev = new CustomEvent(\"mochitest-load\", { detail: [flavor, url] });\nwin.dispatchEvent(ev);","args":[{"flavor":"mochitest","testUrl":"http://mochi.xorigin-test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true&xOriginTests=true&ignorePrefsFile=ignorePrefs.json"}],"newSandbox":true,"sandbox":"default","line":2169,"filename":"tests/mochitest/runtests.py"}]
[task 2023-07-21T17:34:03.241Z] 17:34:03 INFO - GECKO(9664) | 1689960843241 RemoteAgent TRACE WebDriverProcessData actor created for PID 9664
[task 2023-07-21T17:34:03.244Z] 17:34:03 INFO - GECKO(9664) | 1689960843244 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2023-07-21T17:34:03.312Z] 17:34:03 INFO - GECKO(9664) | 1689960843311 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2023-07-21T17:34:03.330Z] 17:34:03 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9840.
[task 2023-07-21T17:34:03.339Z] 17:34:03 INFO - GECKO(9664) | 1689960843339 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2023-07-21T17:34:03.344Z] 17:34:03 INFO - GECKO(9664) | 1689960843343 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2023-07-21T17:34:03.395Z] 17:34:03 INFO - GECKO(9664) | 1689960843394 Marionette TRACE Remoteness change detected. Set new top-level browsing context to 13
[task 2023-07-21T17:34:03.438Z] 17:34:03 INFO - GECKO(9664) | 1689960843437 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2023-07-21T17:34:03.444Z] 17:34:03 INFO - GECKO(9664) | 1689960843443 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2023-07-21T17:34:03.462Z] 17:34:03 INFO - GECKO(9664) | 1689960843461 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2023-07-21T17:34:03.466Z] 17:34:03 INFO - runtests.py | Waiting for browser...
[task 2023-07-21T17:34:03.467Z] 17:34:03 INFO - GECKO(9664) | 1689960843464 Marionette DEBUG Closed connection 1
[task 2023-07-21T17:34:03.779Z] 17:34:03 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9842.
[task 2023-07-21T17:34:03.847Z] 17:34:03 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9845.
[task 2023-07-21T17:34:03.927Z] 17:34:03 INFO - GECKO(9664) | [CodeCoverage] Setting handlers for process 9843.
[task 2023-07-21T17:34:04.002Z] 17:34:04 INFO - SimpleTest START
[task 2023-07-21T17:34:04.004Z] 17:34:04 INFO - Dumping test context:
[task 2023-07-21T17:34:04.004Z] 17:34:04 INFO - fission.autostart=true
[task 2023-07-21T17:34:04.009Z] 17:34:04 INFO - TEST-START | gfx/tests/mochitest/test_bug509244.html
Description
•