Closed
Bug 1681114
Opened 5 years ago
Closed 5 years ago
Intermittent toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 234] Older extension regained control. - false == true
Categories
(WebExtensions :: General, defect, P5)
WebExtensions
General
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1625455
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=323785445&repo=mozilla-esr78
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Y-o35gPPR0K0chOYNZo9yQ/runs/0/artifacts/public/logs/live_backing.log
[task 2020-12-07T16:16:28.234Z] 16:16:28 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_extensionPreferencesManager.js: Per-test extra prefs will be set:
[task 2020-12-07T16:16:28.234Z] 16:16:28 INFO - services.settings.server=http://localhost:7777/remote-settings-dummy/v1
[task 2020-12-07T16:16:28.234Z] 16:16:28 INFO - services.settings.default_bucket=nonexistent-bucket-foo
[task 2020-12-07T16:16:28.239Z] 16:16:28 INFO - TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_extensionPreferencesManager.js
[task 2020-12-07T16:16:36.159Z] 16:16:36 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_extensionPreferencesManager.js | took 7916ms
[task 2020-12-07T16:16:36.160Z] 16:16:36 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js: Per-test extra prefs will be set:
[task 2020-12-07T16:16:36.160Z] 16:16:36 INFO - services.settings.server=http://localhost:7777/remote-settings-dummy/v1
[task 2020-12-07T16:16:36.160Z] 16:16:36 INFO - services.settings.default_bucket=nonexistent-bucket-foo
[task 2020-12-07T16:16:36.168Z] 16:16:36 INFO - TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js
[task 2020-12-07T16:16:49.905Z] 16:16:49 WARNING - TEST-UNEXPECTED-FAIL | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | xpcshell return code: 0
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - TEST-INFO took 13734ms
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - >>>>>>>
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - running event loop
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | Starting check_remote
[task 2020-12-07T16:16:49.906Z] 16:16:49 INFO - (xpcshell/head.js) | test check_remote pending (2)
[task 2020-12-07T16:16:49.907Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | check_remote - [check_remote : 1] useRemoteWebExtensions matches - true == true
[task 2020-12-07T16:16:49.907Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | check_remote - [check_remote : 1] testing from extension process - false == false
[task 2020-12-07T16:16:49.908Z] 16:16:49 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2020-12-07T16:16:49.908Z] 16:16:49 INFO - (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2020-12-07T16:16:49.909Z] 16:16:49 INFO - (xpcshell/head.js) | test check_remote finished (2)
[task 2020-12-07T16:16:49.909Z] 16:16:49 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | Starting test_privacy
[task 2020-12-07T16:16:49.909Z] 16:16:49 INFO - (xpcshell/head.js) | test test_privacy pending (2)
[task 2020-12-07T16:16:49.910Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797828 addons.manager DEBUG Application has been upgraded"
[task 2020-12-07T16:16:49.910Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797830 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider", "XPIInternal"]"
[task 2020-12-07T16:16:49.910Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797880 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm"
[task 2020-12-07T16:16:49.911Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797898 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm"
[task 2020-12-07T16:16:49.911Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797901 addons.manager DEBUG Starting provider: XPIProvider"
[task 2020-12-07T16:16:49.911Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797901 addons.xpi DEBUG startup"
[task 2020-12-07T16:16:49.911Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357797907 addons.xpi INFO SystemAddonLocation directory is missing"
[task 2020-12-07T16:16:49.912Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798021 addons.xpi INFO Removing all system add-on upgrades."
[task 2020-12-07T16:16:49.912Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798025 addons.xpi DEBUG checkForChanges"
[task 2020-12-07T16:16:49.912Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798026 addons.xpi DEBUG Loaded add-on state: ${}"
[task 2020-12-07T16:16:49.912Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798034 addons.xpi DEBUG scanForChanges changed: false, state: {}"
[task 2020-12-07T16:16:49.913Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798038 addons.xpi DEBUG Empty XPI database, setting schema version preference to 32"
[task 2020-12-07T16:16:49.913Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798039 addons.xpi DEBUG No changes found"
[task 2020-12-07T16:16:49.913Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798121 addons.xpi-utils DEBUG Synchronously loading the add-ons database"
[task 2020-12-07T16:16:49.913Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357798124 addons.xpi-utils DEBUG Starting async load of XPI database /tmp/xpc-profile-cORdrI/extensions.json"
[task 2020-12-07T16:16:49.914Z] 16:16:49 INFO - (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2020-12-07T16:16:49.914Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799604 addons.xpi-utils DEBUG Rebuilding XPI database with no extensions"
[task 2020-12-07T16:16:49.914Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799622 addons.manager DEBUG Registering shutdown blocker for XPIProvider"
[task 2020-12-07T16:16:49.914Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799623 addons.manager DEBUG Provider finished startup: XPIProvider"
[task 2020-12-07T16:16:49.915Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799624 addons.manager DEBUG Starting provider: PluginProvider"
[task 2020-12-07T16:16:49.915Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799624 addons.manager DEBUG Registering shutdown blocker for PluginProvider"
[task 2020-12-07T16:16:49.915Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799626 addons.manager DEBUG Provider finished startup: PluginProvider"
[task 2020-12-07T16:16:49.916Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357799627 addons.manager DEBUG Completed startup sequence"
[task 2020-12-07T16:16:49.916Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801019 addons.xpi-utils DEBUG Make addon app-temporary:{4fb6f670-c051-4bfd-9701-e03eebd622a0} visible"
[task 2020-12-07T16:16:49.916Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801021 addons.xpi DEBUG XPIStates adding add-on {4fb6f670-c051-4bfd-9701-e03eebd622a0} in {}: /tmp/xpc-profile-cORdrI/temp/generated-extension.xpi"
[task 2020-12-07T16:16:49.917Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801026 addons.xpi DEBUG Updating XPIState for {"id":"{4fb6f670-c051-4bfd-9701-e03eebd622a0}","syncGUID":"{6c44bbb5-40ab-4e98-a46c-0e199f524173}","version":"1.0","type":"extension","loader":null,"optionsURL":null,"optionsType":null,"optionsBrowserStyle":true,"aboutURL":null,"defaultLocale":{"name":"Generated extension","creator":null,"developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"embedderDisabled":false,"installDate":1607357801019,"applyBackgroundUpdates":1,"path":"/tmp/xpc-profile-cORdrI/temp/generated-extension.xpi","skinnable":false,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org"}],"targetPlatforms":[],"signedState":4,"signedDate":null,"seen":true,"dependencies":[],"incognito":"spanning","userPermissions":{"permissions":["privacy"],"origins":[]},"optionalPermissions":{"permissions":[],"origins":[]},"icons":{},"iconURL":null,"blocklistState":0,"blocklistURL":null,"startupData":null,"hidden":false,"installTelemetryInfo":null,"recommendationState":null,"rootURI":"jar:file:///tmp/xpc-profile-cORdrI/temp/generated-extension.xpi!/","location":"app-temporary"}"
[task 2020-12-07T16:16:49.917Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801063 addons.xpi DEBUG Loading bootstrap scope from jar:file:///tmp/xpc-profile-cORdrI/temp/generated-extension.xpi!/"
[task 2020-12-07T16:16:49.917Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801064 addons.xpi DEBUG Calling bootstrap method install on {4fb6f670-c051-4bfd-9701-e03eebd622a0} version 1.0"
[task 2020-12-07T16:16:49.917Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801066 addons.xpi DEBUG Calling bootstrap method startup on {4fb6f670-c051-4bfd-9701-e03eebd622a0} version 1.0"
[task 2020-12-07T16:16:49.917Z] 16:16:49 INFO - "Extension attached"
[task 2020-12-07T16:16:49.918Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357801368 addons.xpi-utils DEBUG XPI Database saved, setting schema version preference to 32"
[task 2020-12-07T16:16:49.918Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357802610 addons.manager DEBUG Starting provider: GMPProvider"
[task 2020-12-07T16:16:49.918Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357802632 addons.manager DEBUG Registering shutdown blocker for GMPProvider"
[task 2020-12-07T16:16:49.918Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357802635 addons.manager DEBUG Provider finished startup: GMPProvider"
[task 2020-12-07T16:16:49.918Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.919Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.919Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.919Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.919Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.919Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.920Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.920Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.920Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.920Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.920Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.921Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.922Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.922Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.922Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.922Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.922Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.923Z] 16:16:49 INFO - PID 20092 | ==20125==WARNING: Symbolizer buffer too small
[task 2020-12-07T16:16:49.924Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806098 addons.xpi DEBUG Install of temporary addon in /tmp/xpc-profile-cORdrI/temp/generated-extension.xpi completed."
[task 2020-12-07T16:16:49.924Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806173 addons.xpi-utils DEBUG Make addon app-temporary:{78fdb433-9ec0-41ae-b84b-60a3e90ee412} visible"
[task 2020-12-07T16:16:49.924Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806175 addons.xpi DEBUG XPIStates adding add-on {78fdb433-9ec0-41ae-b84b-60a3e90ee412} in {}: /tmp/xpc-profile-cORdrI/temp/generated-extension-1.xpi"
[task 2020-12-07T16:16:49.924Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806181 addons.xpi DEBUG Updating XPIState for {"id":"{78fdb433-9ec0-41ae-b84b-60a3e90ee412}","syncGUID":"{f6382383-1ac0-48d5-b93d-d78957813ca4}","version":"1.0","type":"extension","loader":null,"optionsURL":null,"optionsType":null,"optionsBrowserStyle":true,"aboutURL":null,"defaultLocale":{"name":"Generated extension","creator":null,"developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"embedderDisabled":false,"installDate":1607357806173,"applyBackgroundUpdates":1,"path":"/tmp/xpc-profile-cORdrI/temp/generated-extension-1.xpi","skinnable":false,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org"}],"targetPlatforms":[],"signedState":4,"signedDate":null,"seen":true,"dependencies":[],"incognito":"spanning","userPermissions":{"permissions":["privacy"],"origins":[]},"optionalPermissions":{"permissions":[],"origins":[]},"icons":{},"iconURL":null,"blocklistState":0,"blocklistURL":null,"startupData":null,"hidden":false,"installTelemetryInfo":null,"recommendationState":null,"rootURI":"jar:file:///tmp/xpc-profile-cORdrI/temp/generated-extension-1.xpi!/","location":"app-temporary"}"
[task 2020-12-07T16:16:49.925Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806184 addons.xpi DEBUG Loading bootstrap scope from jar:file:///tmp/xpc-profile-cORdrI/temp/generated-extension-1.xpi!/"
[task 2020-12-07T16:16:49.925Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806185 addons.xpi DEBUG Calling bootstrap method install on {78fdb433-9ec0-41ae-b84b-60a3e90ee412} version 1.0"
[task 2020-12-07T16:16:49.925Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806187 addons.xpi DEBUG Calling bootstrap method startup on {78fdb433-9ec0-41ae-b84b-60a3e90ee412} version 1.0"
[task 2020-12-07T16:16:49.925Z] 16:16:49 INFO - "Extension attached"
[task 2020-12-07T16:16:49.932Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806502 addons.xpi DEBUG Install of temporary addon in /tmp/xpc-profile-cORdrI/temp/generated-extension-1.xpi completed."
[task 2020-12-07T16:16:49.933Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 125] get returns expected value. - true == true
[task 2020-12-07T16:16:49.934Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 126] get returns expected levelOfControl. - "controllable_by_this_extension" == "controllable_by_this_extension"
[task 2020-12-07T16:16:49.934Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 134] get returns expected value with incognito. - true == true
[task 2020-12-07T16:16:49.935Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 135] get returns expected levelOfControl with incognito. - "not_controllable" == "not_controllable"
[task 2020-12-07T16:16:49.935Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 144] get returns expected value after setting. - true == true
[task 2020-12-07T16:16:49.936Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 145] get returns expected levelOfControl after setting. - "controlled_by_this_extension" == "controlled_by_this_extension"
[task 2020-12-07T16:16:49.936Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 157] network.predictor.enabled set correctly for network.networkPredictionEnabled - false == false
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 157] network.prefetch-next set correctly for network.networkPredictionEnabled - false == false
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 155] network.http.speculative-parallel-limit set correctly for network.networkPredictionEnabled - 0 == 0
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 157] network.dns.disablePrefetch set correctly for network.networkPredictionEnabled - true == true
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 164] get returns expected value after setting via newer extension. - true == true
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 168] get returns expected levelOfControl after setting. - "controlled_by_this_extension" == "controlled_by_this_extension"
[task 2020-12-07T16:16:49.937Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 184] network.predictor.enabled set correctly for network.networkPredictionEnabled - true == true
[task 2020-12-07T16:16:49.938Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 184] network.prefetch-next set correctly for network.networkPredictionEnabled - true == true
[task 2020-12-07T16:16:49.938Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 178] network.http.speculative-parallel-limit set correctly for network.networkPredictionEnabled - 6 == 6
[task 2020-12-07T16:16:49.939Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 184] network.dns.disablePrefetch set correctly for network.networkPredictionEnabled - false == false
[task 2020-12-07T16:16:49.939Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 191] Newer extension remains in control. - true == true
[task 2020-12-07T16:16:49.939Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 192] get returns expected levelOfControl when controlled by other. - "controlled_by_other_extensions" == "controlled_by_other_extensions"
[task 2020-12-07T16:16:49.940Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 201] Older extension gains control. - true == true
[task 2020-12-07T16:16:49.940Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 202] Expected levelOfControl returned after clearing. - "controllable_by_this_extension" == "controllable_by_this_extension"
[task 2020-12-07T16:16:49.940Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 210] Current, older extension has control. - true == true
[task 2020-12-07T16:16:49.941Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 211] Expected levelOfControl returned after clearing. - "controlled_by_this_extension" == "controlled_by_this_extension"
[task 2020-12-07T16:16:49.941Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 220] get returns expected value after setting via newer extension. - true == true
[task 2020-12-07T16:16:49.942Z] 16:16:49 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 224] get returns expected levelOfControl after setting. - "controlled_by_this_extension" == "controlled_by_this_extension"
[task 2020-12-07T16:16:49.942Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357806921 addons.xpi DEBUG Calling bootstrap method shutdown on {78fdb433-9ec0-41ae-b84b-60a3e90ee412} version 1.0"
[task 2020-12-07T16:16:49.942Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357807134 addons.xpi DEBUG Calling bootstrap method uninstall on {78fdb433-9ec0-41ae-b84b-60a3e90ee412} version 1.0"
[task 2020-12-07T16:16:49.943Z] 16:16:49 INFO - "CONSOLE_MESSAGE: (info) 1607357807144 addons.xpi DEBUG Disabling XPIState for {78fdb433-9ec0-41ae-b84b-60a3e90ee412}"
[task 2020-12-07T16:16:49.943Z] 16:16:49 WARNING - TEST-UNEXPECTED-FAIL | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 234] Older extension regained control. - false == true
[task 2020-12-07T16:16:49.944Z] 16:16:49 INFO - /builds/worker/workspace/build/tests/xpcshell/tests/toolkit/components/extensions/test/xpcshell/test_ext_privacy.js:test_privacy:234
[task 2020-12-07T16:16:49.944Z] 16:16:49 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_do_main:248
[task 2020-12-07T16:16:49.944Z] 16:16:49 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_execute_test:577
[task 2020-12-07T16:16:49.944Z] 16:16:49 INFO - -e:null:1
[task 2020-12-07T16:16:49.945Z] 16:16:49 INFO - exiting test
[task 2020-12-07T16:16:49.945Z] 16:16:49 INFO - Unexpected exception NS_ERROR_ABORT:
[task 2020-12-07T16:16:49.946Z] 16:16:49 INFO - _abort_failed_test@/builds/worker/workspace/build/tests/xpcshell/head.js:833:20
[task 2020-12-07T16:16:49.946Z] 16:16:49 INFO - do_report_result@/builds/worker/workspace/build/tests/xpcshell/head.js:934:5
[task 2020-12-07T16:16:49.946Z] 16:16:49 INFO - Assert<@/builds/worker/workspace/build/tests/xpcshell/head.js:73:21
[task 2020-12-07T16:16:49.947Z] 16:16:49 INFO - proto.report@resource://testing-common/Assert.jsm:233:10
[task 2020-12-07T16:16:49.947Z] 16:16:49 INFO - proto.ok@resource://testing-common/Assert.jsm:259:10
[task 2020-12-07T16:16:49.947Z] 16:16:49 INFO - test_privacy@/builds/worker/workspace/build/tests/xpcshell/tests/toolkit/components/extensions/test/xpcshell/test_ext_privacy.js:234:7
[task 2020-12-07T16:16:49.949Z] 16:16:49 INFO - _do_main@/builds/worker/workspace/build/tests/xpcshell/head.js:248:6
[task 2020-12-07T16:16:49.949Z] 16:16:49 INFO - _execute_test@/builds/worker/workspace/build/tests/xpcshell/head.js:577:5
[task 2020-12-07T16:16:49.949Z] 16:16:49 INFO - @-e:1:1
[task 2020-12-07T16:16:49.950Z] 16:16:49 INFO - exiting test
[task 2020-12-07T16:16:49.950Z] 16:16:49 WARNING - TEST-UNEXPECTED-FAIL | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js | test_privacy - [test_privacy : 332] Extension left running at test shutdown - "running" == "unloaded"
[task 2020-12-07T16:16:49.951Z] 16:16:49 INFO - resource://testing-common/ExtensionXPCShellUtils.jsm:ExtensionWrapper/<:332
[task 2020-12-07T16:16:49.951Z] 16:16:49 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_execute_test/<:641
[task 2020-12-07T16:16:49.952Z] 16:16:49 INFO - /builds/worker/workspace/build/tests/xpcshell/head.js:_execute_test:653
[task 2020-12-07T16:16:49.952Z] 16:16:49 INFO - -e:null:1
[task 2020-12-07T16:16:49.953Z] 16:16:49 INFO - exiting test
[task 2020-12-07T16:16:49.953Z] 16:16:49 INFO - NS_ERROR_ABORT:
[task 2020-12-07T16:16:49.953Z] 16:16:49 INFO - _abort_failed_test@/builds/worker/workspace/build/tests/xpcshell/head.js:833:20
[task 2020-12-07T16:16:49.954Z] 16:16:49 INFO - do_report_result@/builds/worker/workspace/build/tests/xpcshell/head.js:934:5
[task 2020-12-07T16:16:49.954Z] 16:16:49 INFO - Assert<@/builds/worker/workspace/build/tests/xpcshell/head.js:73:21
[task 2020-12-07T16:16:49.955Z] 16:16:49 INFO - proto.report@resource://testing-common/Assert.jsm:233:10
[task 2020-12-07T16:16:49.955Z] 16:16:49 INFO - equal@resource://testing-common/Assert.jsm:275:8
[task 2020-12-07T16:16:49.956Z] 16:16:49 INFO - ExtensionWrapper/<@resource://testing-common/ExtensionXPCShellUtils.jsm:332:24
[task 2020-12-07T16:16:49.956Z] 16:16:49 INFO - _execute_test/<@/builds/worker/workspace/build/tests/xpcshell/head.js:641:28
[task 2020-12-07T16:16:49.957Z] 16:16:49 INFO - _execute_test@/builds/worker/workspace/build/tests/xpcshell/head.js:653:16
[task 2020-12-07T16:16:49.957Z] 16:16:49 INFO - @-e:1:1
[task 2020-12-07T16:16:49.958Z] 16:16:49 INFO - Error: Found unexpected files in temporary directory: generated-extension.xpi at resource://testing-common/AddonTestUtils.jsm:450
[task 2020-12-07T16:16:49.958Z] 16:16:49 INFO - init/<@resource://testing-common/AddonTestUtils.jsm:450:15
[task 2020-12-07T16:16:49.958Z] 16:16:49 INFO - _execute_test/<@/builds/worker/workspace/build/tests/xpcshell/head.js:641:28
[task 2020-12-07T16:16:49.959Z] 16:16:49 INFO - _execute_test@/builds/worker/workspace/build/tests/xpcshell/head.js:653:16
[task 2020-12-07T16:16:49.959Z] 16:16:49 INFO - @-e:1:1
[task 2020-12-07T16:16:49.960Z] 16:16:49 INFO - <<<<<<<
[task 2020-12-07T16:16:49.960Z] 16:16:49 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_proxy_startup.js: Per-test extra prefs will be set:
[task 2020-12-07T16:16:49.961Z] 16:16:49 INFO - services.settings.server=http://localhost:7777/remote-settings-dummy/v1
[task 2020-12-07T16:16:49.961Z] 16:16:49 INFO - services.settings.default_bucket=nonexistent-bucket-foo
[task 2020-12-07T16:16:49.964Z] 16:16:49 INFO - TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_proxy_startup.js
[task 2020-12-07T16:17:11.656Z] 16:17:11 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_proxy_startup.js | took 21690ms
[task 2020-12-07T16:17:11.660Z] 16:17:11 INFO - xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_requestSize.js: Per-test extra prefs will be set:
[task 2020-12-07T16:17:11.661Z] 16:17:11 INFO - services.settings.server=http://localhost:7777/remote-settings-dummy/v1
[task 2020-12-07T16:17:11.661Z] 16:17:11 INFO - services.settings.default_bucket=nonexistent-bucket-foo
[task 2020-12-07T16:17:11.665Z] 16:17:11 INFO - TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_requestSize.js
[task 2020-12-07T16:17:24.922Z] 16:17:24 INFO - TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_requestSize.js | took 13255ms
[task 2020-12-07T16:17:24.923Z] 16:17:24 INFO - INFO | Result summary:
[task 2020-12-07T16:17:24.927Z] 16:17:24 INFO - INFO | Passed: 162
[task 2020-12-07T16:17:24.927Z] 16:17:24 WARNING - INFO | Failed: 1
[task 2020-12-07T16:17:24.927Z] 16:17:24 WARNING - One or more unittests failed.
[task 2020-12-07T16:17:24.927Z] 16:17:24 INFO - INFO | Todo: 0
[task 2020-12-07T16:17:24.927Z] 16:17:24 INFO - INFO | Retried: 4
[task 2020-12-07T16:17:24.927Z] 16:17:24 INFO - SUITE-END | took 2060s
[task 2020-12-07T16:17:24.927Z] 16:17:24 INFO - Node moz-http2 server shutting down ...
[task 2020-12-07T16:17:25.005Z] 16:17:25 ERROR - Return code: 1
[task 2020-12-07T16:17:25.005Z] 16:17:25 INFO - TinderboxPrint: xpcshell-xpcshell<br/>162/<em class="testfail">1</em>/0
[task 2020-12-07T16:17:25.005Z] 16:17:25 WARNING - # TBPL FAILURE #
[task 2020-12-07T16:17:25.006Z] 16:17:25 WARNING - setting return code to 2
[task 2020-12-07T16:17:25.006Z] 16:17:25 WARNING - The xpcshell suite: xpcshell ran with return status: FAILURE
[task 2020-12-07T16:17:25.006Z] 16:17:25 INFO - Running post-action listener: _package_coverage_data
[task 2020-12-07T16:17:25.007Z] 16:17:25 INFO - Running post-action listener: _resource_record_post_action
[task 2020-12-07T16:17:25.007Z] 16:17:25 INFO - Running post-action listener: process_java_coverage_data
[task 2020-12-07T16:17:25.008Z] 16:17:25 INFO - [mozharness: 2020-12-07 16:17:25.007935Z] Finished run-tests step (success)
[task 2020-12-07T16:17:25.008Z] 16:17:25 INFO - Running post-run listener: _resource_record_post_run
[task 2020-12-07T16:17:25.212Z] 16:17:25 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2020-12-07T16:17:25.216Z] 16:17:25 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 97.5186035389766}, {"name": "io_write_bytes", "value": 3449069568}, {"name": "io.read_bytes", "value": 700301312}, {"name": "io_write_time", "value": 380468}, {"name": "io_read_time", "value": 23192}], "extraOptions": ["e10s", "taskcluster-m5.large"], "name": "xpcshell.xpcshell.overall"}, {"subtests": [{"name": "time", "value": 0.03301692008972168}], "name": "xpcshell.xpcshell.start-pulseaudio"}, {"subtests": [{"name": "time", "value": 31.412873029708862}, {"name": "cpu_percent", "value": 50.294999999999995}], "name": "xpcshell.xpcshell.install"}, {"subtests": [{"name": "time", "value": 0.013538122177124023}], "name": "xpcshell.xpcshell.stage-files"}, {"subtests": [{"name": "time", "value": 2061.8619859218597}, {"name": "cpu_percent", "value": 98.25893637688202}], "name": "xpcshell.xpcshell.run-tests"}]}
[task 2020-12-07T16:17:25.216Z] 16:17:25 INFO - Total resource usage - Wall time: 2093s; CPU: 98.0%; Read bytes: 700301312; Write bytes: 3449069568; Read time: 23192; Write time: 380468
[task 2020-12-07T16:17:25.216Z] 16:17:25 INFO - TinderboxPrint: CPU usage<br/>98.3%
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: I/O read bytes / time<br/>700,301,312 / 23,192
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: I/O write bytes / time<br/>3,449,069,568 / 380,468
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: CPU idle<br/>100.6 (2.4%)
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: CPU system<br/>697.7 (16.7%)
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: CPU user<br/>3,382.4 (80.8%)
[task 2020-12-07T16:17:25.217Z] 16:17:25 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2020-12-07T16:17:25.218Z] 16:17:25 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2020-12-07T16:17:25.220Z] 16:17:25 INFO - install - Wall time: 31s; CPU: 50.0%; Read bytes: 8192; Write bytes: 281575424; Read time: 24; Write time: 26796
[task 2020-12-07T16:17:25.221Z] 16:17:25 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2020-12-07T16:17:25.232Z] 16:17:25 INFO - run-tests - Wall time: 2062s; CPU: 98.0%; Read bytes: 699973632; Write bytes: 2711171072; Read time: 22168; Write time: 328200
[task 2020-12-07T16:17:25.529Z] 16:17:25 WARNING - returning nonzero exit status 2
[task 2020-12-07T16:17:25.560Z] cleanup
[task 2020-12-07T16:17:25.561Z] + cleanup
[task 2020-12-07T16:17:25.561Z] + local rv=2
[task 2020-12-07T16:17:25.561Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2020-12-07T16:17:25.561Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2020-12-07T16:17:25.573Z] + true
[task 2020-12-07T16:17:25.574Z] + cleanup_xvfb
[task 2020-12-07T16:17:25.574Z] ++ pidof Xvfb
[task 2020-12-07T16:17:25.589Z] + local xvfb_pid=41
[task 2020-12-07T16:17:25.590Z] + local vnc=false
[task 2020-12-07T16:17:25.590Z] + local interactive=false
[task 2020-12-07T16:17:25.590Z] + '[' -n 41 ']'
[task 2020-12-07T16:17:25.590Z] + [[ false == false ]]
[task 2020-12-07T16:17:25.590Z] + [[ false == false ]]
[task 2020-12-07T16:17:25.590Z] + kill 41
[task 2020-12-07T16:17:25.590Z] + screen -XS xvfb quit
[task 2020-12-07T16:17:25.645Z] + exit 2
[fetches 2020-12-07T16:17:25.656Z] removing /builds/worker/fetches
[fetches 2020-12-07T16:17:26.309Z] finished
[taskcluster 2020-12-07 16:17:27.272Z] === Task Finished ===
[taskcluster 2020-12-07 16:17:29.572Z] Unsuccessful task run with exit code: 2 completed in 2364.716 seconds```
|
||
Updated•5 years ago
|
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•