Closed Bug 1771393 Opened 4 years ago Closed 1 year ago

Intermittent toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | single tracking bug

Categories

(Toolkit :: Startup and Profile System, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


[task 2022-05-26T21:53:30.616Z] 21:53:30     INFO -  TEST-START | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js
[task 2022-05-26T21:53:31.967Z] 21:53:31  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | xpcshell return code: 0
[task 2022-05-26T21:53:31.967Z] 21:53:31     INFO -  TEST-INFO took 1350ms
[task 2022-05-26T21:53:31.967Z] 21:53:31     INFO -  >>>>>>>
[task 2022-05-26T21:53:31.968Z] 21:53:31     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:2981
[task 2022-05-26T21:53:31.968Z] 21:53:31     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2022-05-26T21:53:31.968Z] 21:53:31     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2022-05-26T21:53:31.968Z] 21:53:31     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2022-05-26T21:53:31.968Z] 21:53:31     INFO -  running event loop
[task 2022-05-26T21:53:31.969Z] 21:53:31     INFO -  toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | Starting setup
[task 2022-05-26T21:53:31.969Z] 21:53:31     INFO -  (xpcshell/head.js) | test pending (2)
[task 2022-05-26T21:53:31.969Z] 21:53:31     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2022-05-26T21:53:31.969Z] 21:53:31     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2022-05-26T21:53:31.969Z] 21:53:31     INFO -  (xpcshell/head.js) | test finished (2)
[task 2022-05-26T21:53:31.970Z] 21:53:31     INFO -  toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | Starting test_backgroundtask_simultaneous_instances
[task 2022-05-26T21:53:31.970Z] 21:53:31     INFO -  (xpcshell/head.js) | test test_backgroundtask_simultaneous_instances pending (2)
[task 2022-05-26T21:53:31.970Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.971Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "226859b6-282b-4765-9125-8ef20e91d184"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.971Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.972Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "e056b799-1861-418a-9afe-72da2c140a3a"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.972Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.973Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "7f9b2e6f-e06e-4ffa-92ad-2f7e5dc078f2"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.973Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.974Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "3f526594-76bf-4fd0-8854-acd640390cdb"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.974Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.975Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "25838224-6669-4d5c-a7f4-c0e060cbec94"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.975Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.976Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "e33180be-5e79-4646-8b7f-5bbb8d510138"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.976Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.977Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "f32b8ee5-0ed8-4009-bf78-a49495823fb4"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.977Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.978Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "3042cb7b-ff28-4da4-a646-4f6629331889"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.978Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.979Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "d4af1a48-72fd-40a1-ad83-4b82948d0cf0"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.979Z] 21:53:31     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 60] resource://testing-common is not substituted - true == true
[task 2022-05-26T21:53:31.980Z] 21:53:31     INFO -  PID 8281 | console.info: "launching background task" ({command:"/opt/worker/tasks/task_165359865638954/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox", args:["--backgroundtask", "unique_profile", "72e5e436-2d21-4048-96eb-81ae0be6d296"], extraEnv:{MOZ_BACKGROUNDTASKS_NO_REMOVE_PROFILE:"1", MOZ_LOG:"BackgroundTasks:5", TMP:"/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/xpc-profile-h2cqcbuo/Temp", XPCSHELL_TESTING_MODULES_URI:"file:///opt/worker/tasks/task_165359865638954/build/tests/modules/"}})
[task 2022-05-26T21:53:31.980Z] 21:53:31     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2022-05-26T21:53:31.980Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Created background task: unique_profile
[task 2022-05-26T21:53:31.980Z] 21:53:31     INFO -  PID 8281 | 8282> *** You are running in background task mode. ***
[task 2022-05-26T21:53:31.981Z] 21:53:31     INFO -  PID 8281 | 8282> *** You are running in headless mode.
[task 2022-05-26T21:53:31.981Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: I/BackgroundTasks Created background task: unique_profile
[task 2022-05-26T21:53:31.981Z] 21:53:31     INFO -  PID 8281 | 8283> *** You are running in background task mode. ***
[task 2022-05-26T21:53:31.981Z] 21:53:31     INFO -  PID 8281 | 8283> *** You are running in headless mode.
<...>
[task 2022-05-26T21:53:31.986Z] 21:53:31     INFO -  PID 8281 | 8291> *** You are running in headless mode.
[task 2022-05-26T21:53:31.986Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.987Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-2
[task 2022-05-26T21:53:31.987Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-5
[task 2022-05-26T21:53:31.987Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-4
[task 2022-05-26T21:53:31.988Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-3
[task 2022-05-26T21:53:31.988Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-8
[task 2022-05-26T21:53:31.988Z] 21:53:31     INFO -  PID 8281 | 8282> [(null) 8282: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1
[task 2022-05-26T21:53:31.989Z] 21:53:31     INFO -  PID 8281 | 8282> [8282, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:31.989Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.989Z] 21:53:31     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.990Z] 21:53:31     INFO -  PID 8281 | 8288> [(null) 8288: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.990Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.990Z] 21:53:31     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-6, profile is not yet stale.
[task 2022-05-26T21:53:31.991Z] 21:53:31     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:31.991Z] 21:53:31     INFO -  PID 8281 | 8288> [8288, Main Thread] ###!!! ASSERTION: Failed to open lock file.: 'Error', file /builds/worker/checkouts/gecko/toolkit/profile/nsProfileLock.cpp:243
[task 2022-05-26T21:53:31.991Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.992Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-6
[task 2022-05-26T21:53:31.992Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:31.992Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-10, profile is not yet stale.
[task 2022-05-26T21:53:31.993Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: W/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-6, unable to retrieve when profile was last modified.
[task 2022-05-26T21:53:31.993Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:31.993Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-10, profile is not yet stale.
[task 2022-05-26T21:53:31.994Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: W/BackgroundTasks Error removing stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7
[task 2022-05-26T21:53:31.994Z] 21:53:31     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-9, profile is not yet stale.
[task 2022-05-26T21:53:31.994Z] 21:53:31     INFO -  PID 8281 | 8285> [(null) 8285: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.995Z] 21:53:31     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-10
[task 2022-05-26T21:53:31.995Z] 21:53:31     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7, profile is not yet stale.
[task 2022-05-26T21:53:31.995Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7
[task 2022-05-26T21:53:31.996Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-9, profile is not yet stale.
[task 2022-05-26T21:53:31.996Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile, profile is not yet stale.
[task 2022-05-26T21:53:31.996Z] 21:53:31     INFO -  PID 8281 | 8283> [(null) 8283: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-2
[task 2022-05-26T21:53:31.997Z] 21:53:31     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:31.997Z] 21:53:31     INFO -  PID 8281 | 8288> #01: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:466]
[task 2022-05-26T21:53:31.997Z] 21:53:31     INFO -  PID 8281 | 8288> #02: nsProfileLock::LockWithFcntl(nsIFile*, nsIProfileUnlocker**) [toolkit/profile/nsProfileLock.cpp:243]
[task 2022-05-26T21:53:31.997Z] 21:53:31     INFO -  PID 8281 | 8288> #03: nsProfileLock::Lock(nsIFile*, nsIProfileUnlocker**) [toolkit/profile/nsProfileLock.cpp:451]
[task 2022-05-26T21:53:31.998Z] 21:53:31     INFO -  PID 8281 | 8288> #04: mozilla::BackgroundTasks::RemoveStaleTemporaryProfileDirectories(nsIFile*, nsTString<char> const&) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:310]
[task 2022-05-26T21:53:31.998Z] 21:53:31     INFO -  PID 8281 | 8288> #05: mozilla::BackgroundTasks::CreateTemporaryProfileDirectoryImpl(nsTString<char> const&, nsIFile**) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:185]
[task 2022-05-26T21:53:31.998Z] 21:53:31     INFO -  PID 8281 | 8288> #06: mozilla::BackgroundTasks::CreateTemporaryProfileDirectory(nsTString<char> const&, nsIFile**) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:114]
[task 2022-05-26T21:53:31.998Z] 21:53:31     INFO -  PID 8281 | 8288> #07: XREMain::XRE_mainStartup(bool*) [toolkit/xre/nsAppRunner.cpp:4901]
[task 2022-05-26T21:53:31.998Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:31.999Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-10, profile is not yet stale.
[task 2022-05-26T21:53:31.999Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: W/BackgroundTasks Error removing stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7
[task 2022-05-26T21:53:31.999Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: W/BackgroundTasks Error removing stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-9
[task 2022-05-26T21:53:32Z] 21:53:31     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: W/BackgroundTasks Error removing stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile
[task 2022-05-26T21:53:32.000Z] 21:53:32     INFO -  PID 8281 | 8289> [(null) 8289: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-3
[task 2022-05-26T21:53:32.000Z] 21:53:32     INFO -  PID 8281 | 8289> [8289, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.000Z] 21:53:32     INFO -  PID 8281 | 8290> [(null) 8290: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:32.001Z] 21:53:32     INFO -  PID 8281 | 8290> [(null) 8290: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:32.001Z] 21:53:32     INFO -  PID 8281 | 8290> [(null) 8290: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-5
[task 2022-05-26T21:53:32.001Z] 21:53:32     INFO -  PID 8281 | 8291> [(null) 8291: Main Thread]: I/BackgroundTasks Checking "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T" for stale profiles matching "MozillaBackgroundTask-F9AD285EA623D140-unique_profile".
[task 2022-05-26T21:53:32.001Z] 21:53:32     INFO -  PID 8281 | 8291> [(null) 8291: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:32.002Z] 21:53:32     INFO -  PID 8281 | 8291> [(null) 8291: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-6
[task 2022-05-26T21:53:32.002Z] 21:53:32     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile
[task 2022-05-26T21:53:32.002Z] 21:53:32     INFO -  PID 8281 | 8284> [(null) 8284: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile
[task 2022-05-26T21:53:32.002Z] 21:53:32     INFO -  PID 8281 | 8284> [8284, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.002Z] 21:53:32     INFO -  PID 8281 | 8285> [(null) 8285: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:32.003Z] 21:53:32     INFO -  PID 8281 | 8285> [(null) 8285: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7
[task 2022-05-26T21:53:32.003Z] 21:53:32     INFO -  PID 8281 | 8285> [8285, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.003Z] 21:53:32     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: I/BackgroundTasks Removed stale temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-9
[task 2022-05-26T21:53:32.003Z] 21:53:32     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: W/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile, unable to retrieve when profile was last modified.
[task 2022-05-26T21:53:32.004Z] 21:53:32     INFO -  PID 8281 | 8287> [(null) 8287: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-4
[task 2022-05-26T21:53:32.004Z] 21:53:32     INFO -  PID 8281 | 8287> [8287, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.004Z] 21:53:32     INFO -  PID 8281 | 8283> [8283, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.004Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-2, profile is not yet stale.
[task 2022-05-26T21:53:32.005Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-3, profile is not yet stale.
[task 2022-05-26T21:53:32.005Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-6, profile is not yet stale.
[task 2022-05-26T21:53:32.005Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1, profile is not yet stale.
[task 2022-05-26T21:53:32.005Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: D/BackgroundTasks Skipping deletion of MozillaBackgroundTask-F9AD285EA623D140-unique_profile, profile is not yet stale.
[task 2022-05-26T21:53:32.006Z] 21:53:32     INFO -  PID 8281 | 8286> [(null) 8286: Main Thread]: I/BackgroundTasks Created temporary profile directory: /var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-8
[task 2022-05-26T21:53:32.006Z] 21:53:32     INFO -  PID 8281 | 8286> [8286, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.006Z] 21:53:32     INFO -  PID 8281 | 8288> #08: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5904]
[task 2022-05-26T21:53:32.006Z] 21:53:32     INFO -  PID 8281 | 8288> #09: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5983]
[task 2022-05-26T21:53:32.006Z] 21:53:32     INFO -  PID 8281 | 8288> #10: main [browser/app/nsBrowserApp.cpp:406]
[task 2022-05-26T21:53:32.007Z] 21:53:32     INFO -  PID 8281 | 8288> Hit MOZ_CRASH([8288, Main Thread] ###!!! ASSERTION: Failed to open lock file.: 'Error', file /builds/worker/checkouts/gecko/toolkit/profile/nsProfileLock.cpp:243) at /builds/worker/checkouts/gecko/xpcom/base/nsDebugImpl.cpp:517
[task 2022-05-26T21:53:32.007Z] 21:53:32     INFO -  PID 8281 | 8288> #01: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:466]
[task 2022-05-26T21:53:32.007Z] 21:53:32     INFO -  PID 8281 | 8288> #02: nsProfileLock::LockWithFcntl(nsIFile*, nsIProfileUnlocker**) [toolkit/profile/nsProfileLock.cpp:243]
[task 2022-05-26T21:53:32.007Z] 21:53:32     INFO -  PID 8281 | 8288> #03: nsProfileLock::Lock(nsIFile*, nsIProfileUnlocker**) [toolkit/profile/nsProfileLock.cpp:451]
[task 2022-05-26T21:53:32.008Z] 21:53:32     INFO -  PID 8281 | 8288> #04: mozilla::BackgroundTasks::RemoveStaleTemporaryProfileDirectories(nsIFile*, nsTString<char> const&) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:310]
[task 2022-05-26T21:53:32.008Z] 21:53:32     INFO -  PID 8281 | 8288> #05: mozilla::BackgroundTasks::CreateTemporaryProfileDirectoryImpl(nsTString<char> const&, nsIFile**) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:185]
[task 2022-05-26T21:53:32.008Z] 21:53:32     INFO -  PID 8281 | 8288> #06: mozilla::BackgroundTasks::CreateTemporaryProfileDirectory(nsTString<char> const&, nsIFile**) [toolkit/components/backgroundtasks/BackgroundTasks.cpp:114]
[task 2022-05-26T21:53:32.008Z] 21:53:32     INFO -  PID 8281 | 8288> #07: XREMain::XRE_mainStartup(bool*) [toolkit/xre/nsAppRunner.cpp:4901]
[task 2022-05-26T21:53:32.008Z] 21:53:32     INFO -  PID 8281 | 8288> #08: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5904]
[task 2022-05-26T21:53:32.009Z] 21:53:32     INFO -  PID 8281 | 8288> #09: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5983]
[task 2022-05-26T21:53:32.009Z] 21:53:32     INFO -  PID 8281 | 8288> #10: main [browser/app/nsBrowserApp.cpp:406]
[task 2022-05-26T21:53:32.009Z] 21:53:32     INFO -  PID 8281 | 8290> [8290, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.009Z] 21:53:32     INFO -  PID 8281 | 8291> [8291, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4593
[task 2022-05-26T21:53:32.010Z] 21:53:32     INFO -  PID 8281 | 8289> console.error: BackgroundTasksManager:
[task 2022-05-26T21:53:32.010Z] 21:53:32     INFO -  PID 8281 | 8289>   Substitution set: resource://testing-common aliases file:///opt/worker/tasks/task_165359865638954/build/tests/modules/
[task 2022-05-26T21:53:32.010Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:335
[task 2022-05-26T21:53:32.010Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp:1605
[task 2022-05-26T21:53:32.010Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp:1527
[task 2022-05-26T21:53:32.011Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:335
[task 2022-05-26T21:53:32.011Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp:1605
[task 2022-05-26T21:53:32.011Z] 21:53:32     INFO -  PID 8281 | 8289> [Parent 8289, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp:1527
[task 2022-05-26T21:53:32.011Z] 21:53:32     INFO -  PID 8281 | 8282> console.error: BackgroundTasksManager:
[task 2022-05-26T21:53:32.012Z] 21:53:32     INFO -  PID 8281 | 8285> console.error: BackgroundTasksManager:
[task 2022-05-26T21:53:32.012Z] 21:53:32     INFO -  PID 8281 | 8282>   Substitution set: resource://testing-common aliases file:///opt/worker/tasks/task_165359865638954/build/tests/modules/
[task 2022-05-26T21:53:32.012Z] 21:53:32     INFO -  PID 8281 | 8291> console.error: BackgroundTasksManager:
[task 2022-05-26T21:53:32.012Z] 21:53:32     INFO -  PID 8281 | 8282> [Parent 8282, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:335
[task 2022-05-26T21:53:32.013Z] 21:53:32     INFO -  PID 8281 | 8282> [Parent 8282, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp:1605
<...>
[task 2022-05-26T21:53:32.036Z] 21:53:32     INFO -  PID 8281 | 8282> [Parent 8282, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.037Z] 21:53:32     INFO -  PID 8281 | 8282> [Parent 8282: Main Thread]: I/BackgroundTasks Shutdown
[task 2022-05-26T21:53:32.037Z] 21:53:32     INFO -  PID 8281 | 8286> [Parent 8286, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-26T21:53:32.037Z] 21:53:32     INFO -  PID 8281 | 8285> [Parent 8285, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-26T21:53:32.038Z] 21:53:32     INFO -  PID 8281 | 8287> [Parent 8287, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-26T21:53:32.038Z] 21:53:32     INFO -  PID 8281 | 8291> [Parent 8291, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-26T21:53:32.038Z] 21:53:32     INFO -  PID 8281 | 8286> [Parent 8286, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3437
[task 2022-05-26T21:53:32.039Z] 21:53:32     INFO -  PID 8281 | 8286> [Parent 8286, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.039Z] 21:53:32     INFO -  PID 8281 | 8286> [Parent 8286: Main Thread]: I/BackgroundTasks Shutdown
[task 2022-05-26T21:53:32.039Z] 21:53:32     INFO -  PID 8281 | 8285> [Parent 8285, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3437
[task 2022-05-26T21:53:32.040Z] 21:53:32     INFO -  PID 8281 | 8285> [Parent 8285, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.040Z] 21:53:32     INFO -  PID 8281 | 8287> [Parent 8287, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3437
[task 2022-05-26T21:53:32.040Z] 21:53:32     INFO -  PID 8281 | 8287> [Parent 8287, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.040Z] 21:53:32     INFO -  PID 8281 | 8287> [Parent 8287: Main Thread]: I/BackgroundTasks Shutdown
[task 2022-05-26T21:53:32.041Z] 21:53:32     INFO -  PID 8281 | 8285> [Parent 8285: Main Thread]: I/BackgroundTasks Shutdown
[task 2022-05-26T21:53:32.041Z] 21:53:32     INFO -  PID 8281 | 8291> [Parent 8291, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3437
[task 2022-05-26T21:53:32.041Z] 21:53:32     INFO -  PID 8281 | 8291> [Parent 8291, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.041Z] 21:53:32     INFO -  PID 8281 | 8291> [Parent 8291: Main Thread]: I/BackgroundTasks Shutdown
[task 2022-05-26T21:53:32.042Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 0 with sentinel 226859b6-282b-4765-9125-8ef20e91d184 exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.043Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 0 with sentinel 226859b6-282b-4765-9125-8ef20e91d184 yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-1" == true
[task 2022-05-26T21:53:32.043Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 1 with sentinel e056b799-1861-418a-9afe-72da2c140a3a exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.044Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 1 with sentinel e056b799-1861-418a-9afe-72da2c140a3a yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-2" == true
[task 2022-05-26T21:53:32.044Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 2 with sentinel 7f9b2e6f-e06e-4ffa-92ad-2f7e5dc078f2 exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.045Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 2 with sentinel 7f9b2e6f-e06e-4ffa-92ad-2f7e5dc078f2 yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile" == true
[task 2022-05-26T21:53:32.045Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 3 with sentinel 3f526594-76bf-4fd0-8854-acd640390cdb exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.045Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 3 with sentinel 3f526594-76bf-4fd0-8854-acd640390cdb yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-7" == true
[task 2022-05-26T21:53:32.046Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 4 with sentinel 25838224-6669-4d5c-a7f4-c0e060cbec94 exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.046Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 4 with sentinel 25838224-6669-4d5c-a7f4-c0e060cbec94 yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-8" == true
[task 2022-05-26T21:53:32.047Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 5 with sentinel e33180be-5e79-4646-8b7f-5bbb8d510138 exited with code 0 - 0 == 0
[task 2022-05-26T21:53:32.047Z] 21:53:32     INFO -  TEST-PASS | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 91] Invocation 5 with sentinel e33180be-5e79-4646-8b7f-5bbb8d510138 yielded a temporary profile directory - "/var/folders/86/m93j_0rs4vddzybb11yk5sqm000014/T/MozillaBackgroundTask-F9AD285EA623D140-unique_profile-4" == true
[task 2022-05-26T21:53:32.048Z] 21:53:32  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js | test_backgroundtask_simultaneous_instances - [test_backgroundtask_simultaneous_instances : 86] Invocation 6 with sentinel f32b8ee5-0ed8-4009-bf78-a49495823fb4 exited with code 0 - 0 == 1
[task 2022-05-26T21:53:32.048Z] 21:53:32     INFO -  /opt/worker/tasks/task_165359865638954/build/tests/xpcshell/tests/toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js:test_backgroundtask_simultaneous_instances:86
[task 2022-05-26T21:53:32.048Z] 21:53:32     INFO -  /opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:_do_main:240
[task 2022-05-26T21:53:32.049Z] 21:53:32     INFO -  /opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:_execute_test:597
[task 2022-05-26T21:53:32.049Z] 21:53:32     INFO -  -e:null:1
[task 2022-05-26T21:53:32.049Z] 21:53:32     INFO -  exiting test
[task 2022-05-26T21:53:32.049Z] 21:53:32     INFO -  Unexpected exception NS_ERROR_ABORT:
[task 2022-05-26T21:53:32.050Z] 21:53:32     INFO -  _abort_failed_test@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:868:20
[task 2022-05-26T21:53:32.050Z] 21:53:32     INFO -  do_report_result@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:969:5
[task 2022-05-26T21:53:32.050Z] 21:53:32     INFO -  Assert<@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:75:21
[task 2022-05-26T21:53:32.050Z] 21:53:32     INFO -  proto.report@resource://testing-common/Assert.jsm:228:10
[task 2022-05-26T21:53:32.051Z] 21:53:32     INFO -  equal@resource://testing-common/Assert.jsm:270:8
[task 2022-05-26T21:53:32.051Z] 21:53:32     INFO -  test_backgroundtask_simultaneous_instances@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/tests/toolkit/components/backgroundtasks/tests/xpcshell/test_backgroundtask_simultaneous_instances.js:86:12
[task 2022-05-26T21:53:32.051Z] 21:53:32     INFO -  _do_main@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:240:6
[task 2022-05-26T21:53:32.051Z] 21:53:32     INFO -  _execute_test@/opt/worker/tasks/task_165359865638954/build/tests/xpcshell/head.js:597:5
[task 2022-05-26T21:53:32.051Z] 21:53:32     INFO -  @-e:1:1
[task 2022-05-26T21:53:32.052Z] 21:53:32     INFO -  exiting test
[task 2022-05-26T21:53:32.052Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.052Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.052Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.052Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.053Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.053Z] 21:53:32     INFO -  PID 8281 | console.warn: "Could not clean up profile directory" ({})
[task 2022-05-26T21:53:32.053Z] 21:53:32     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-26T21:53:32.053Z] 21:53:32     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3437
[task 2022-05-26T21:53:32.054Z] 21:53:32     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-26T21:53:32.054Z] 21:53:32     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: XPCOM object PerThreadData destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:206
[task 2022-05-26T21:53:32.054Z] 21:53:32     INFO -  PID 8281 | [Parent 8281, Main Thread] WARNING: XPCOM object SourceList destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:206
[task 2022-05-26T21:53:32.054Z] 21:53:32     INFO -  <<<<<<<
[task 2022-05-26T21:53:32.055Z] 21:53:32     INFO -  TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_contentscript_permissions_change.js
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.