Skip to content

Instantly share code, notes, and snippets.

@bobsilverberg

bobsilverberg/test_log.txt

Created August 15, 2016 18:15
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save bobsilverberg/dcafa81ea0513f9e9a4bcde935e7e32a to your computer and use it in GitHub Desktop.
Save bobsilverberg/dcafa81ea0513f9e9a4bcde935e7e32a to your computer and use it in GitHub Desktop.
Download ZIP
Raw
test_log.txt
(management.getSelf)mozilla-central$ ./mach xpcshell-test toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js
Elapsed: 1.54s; From _tests: Kept 29501 existing; Added/updated 0; Removed 0 files and 0 directories.
0:00.38 LOG: MainThread INFO Running tests sequentially.
0:00.38 SUITE_START: MainThread 2
0:00.38 LOG: Thread-1 INFO profile dir is /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile
0:00.39 TEST_START: Thread-1 xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js
0:00.39 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | full command: ['/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/MacOS/xpcshell', '-g', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources', '-a', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources/browser', '-r', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources/components/httpd.manifest', '-m', '-s', '-e', 'const _HEAD_JS_PATH = "/Users/bsilverberg/mozilla-central/testing/xpcshell/head.js";', '-e', 'const _MOZINFO_JS_PATH = "/var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/mozinfo.json";', '-e', 'const _TESTING_MODULES_DIR = "/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/modules/";', '-f', '/Users/bsilverberg/mozilla-central/testing/xpcshell/head.js', '-p', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/temp/xpc-plugins-KsF3Od', '-e', 'const _SERVER_ADDR = "localhost"', '-e', 'const _HEAD_FILES = ["/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/head_addons.js", "/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/head_unpack.js"];', '-e', 'const _TAIL_FILES = [];', '-e', 'const _JSDEBUGGER_PORT = 0;', '-e', 'const _TEST_FILE = ["/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js"];', '-e', 'const _TEST_NAME = "xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js"', '-e', '_execute_test(); quit(0);']
0:00.39 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | current directory: '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell'
0:00.39 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | environment: ['XPCOM_DEBUG_BREAK=stack-and-abort', 'MOZ_CRASHREPORTER=1', 'DYLD_LIBRARY_PATH=/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/MacOS', 'XPCSHELL_TEST_TEMP_DIR=/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/temp/xpc-other-a4a1aw', 'XPCSHELL_TEST_PROFILE_DIR=/var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile', 'MOZ_DISABLE_NONLOCAL_CONNECTIONS=1', 'MOZ_CRASHREPORTER_NO_REPORT=1']
0:00.54 PROCESS_OUTPUT: Thread-1 (pid:28608) Full command: ['/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/MacOS/xpcshell', '-g', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources', '-a', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources/browser', '-r', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/dist/Nightly.app/Contents/Resources/components/httpd.manifest', '-m', '-s', '-e', 'const _HEAD_JS_PATH = "/Users/bsilverberg/mozilla-central/testing/xpcshell/head.js";', '-e', 'const _MOZINFO_JS_PATH = "/var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/mozinfo.json";', '-e', 'const _TESTING_MODULES_DIR = "/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/modules/";', '-f', '/Users/bsilverberg/mozilla-central/testing/xpcshell/head.js', '-p', '/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/temp/xpc-plugins-KsF3Od', '-e', 'const _SERVER_ADDR = "localhost"', '-e', 'const _HEAD_FILES = ["/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/head_addons.js", "/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/head_unpack.js"];', '-e', 'const _TAIL_FILES = [];', '-e', 'const _JSDEBUGGER_PORT = 0;', '-e', 'const _TEST_FILE = ["/Users/bsilverberg/mozilla-central/obj-ff-opt-artifact/_tests/xpcshell/toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js"];', '-e', 'const _TEST_NAME = "xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js"', '-e', '_execute_test(); quit(0);']
(pid:28608) "1471284357453 addons.manager DEBUG Application has been upgraded"
0:00.57 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357483 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider"]"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357485 addons.manager DEBUG Loaded provider scope for resource://gre/modules/LightweightThemeManager.jsm: ["LightweightThemeManager"]"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357489 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357492 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm"
0:00.58 LOG: Thread-1 INFO "Mock profileBeforeChange blocker for 'AddonManager: shutting down.'"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357492 addons.manager DEBUG Starting provider: XPIProvider"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357493 addons.xpi DEBUG startup"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357493 addons.xpi INFO SystemAddonInstallLocation directory is missing"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357493 addons.xpi DEBUG Skipping unavailable install location app-system-defaults"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357494 addons.xpi DEBUG checkForChanges"
0:00.58 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357495 addons.xpi DEBUG Loaded add-on state from prefs: {}"
0:00.59 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357496 addons.xpi DEBUG getInstallState changed: false, state: {}"
0:00.59 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357496 addons.xpi DEBUG Empty XPI database, setting schema version preference to 17"
0:00.59 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357496 addons.xpi DEBUG No changes found"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357507 addons.manager DEBUG Registering shutdown blocker for XPIProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357508 addons.manager DEBUG Provider finished startup: XPIProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357508 addons.manager DEBUG Starting provider: LightweightThemeManager"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357508 addons.manager DEBUG Registering shutdown blocker for LightweightThemeManager"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357508 addons.manager DEBUG Provider finished startup: LightweightThemeManager"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357508 addons.manager DEBUG Starting provider: GMPProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357514 addons.manager DEBUG Registering shutdown blocker for GMPProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357514 addons.manager DEBUG Provider finished startup: GMPProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357514 addons.manager DEBUG Starting provider: PluginProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357514 addons.manager DEBUG Registering shutdown blocker for PluginProvider"
0:00.60 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357515 addons.manager DEBUG Provider finished startup: PluginProvider"
0:00.61 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357518 addons.manager DEBUG Completed startup sequence"
0:00.61 LOG: Thread-1 INFO (xpcshell/head.js) | test MAIN run_test pending (1)
0:00.61 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 0 pending (2)
0:00.61 LOG: Thread-1 INFO (xpcshell/head.js) | test MAIN run_test finished (2)
0:00.61 LOG: Thread-1 INFO running event loop
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357453 addons.manager DEBUG Application has been upgraded"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357483 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider"]"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357485 addons.manager DEBUG Loaded provider scope for resource://gre/modules/LightweightThemeManager.jsm: ["LightweightThemeManager"]"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357489 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357492 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357492 addons.manager DEBUG Starting provider: XPIProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357493 addons.xpi DEBUG startup"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357493 addons.xpi INFO SystemAddonInstallLocation directory is missing"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357493 addons.xpi DEBUG Skipping unavailable install location app-system-defaults"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357494 addons.xpi DEBUG checkForChanges"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357495 addons.xpi DEBUG Loaded add-on state from prefs: {}"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357496 addons.xpi DEBUG getInstallState changed: false, state: {}"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357496 addons.xpi DEBUG Empty XPI database, setting schema version preference to 17"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357496 addons.xpi DEBUG No changes found"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357507 addons.manager DEBUG Registering shutdown blocker for XPIProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357508 addons.manager DEBUG Provider finished startup: XPIProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357508 addons.manager DEBUG Starting provider: LightweightThemeManager"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357508 addons.manager DEBUG Registering shutdown blocker for LightweightThemeManager"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357508 addons.manager DEBUG Provider finished startup: LightweightThemeManager"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357508 addons.manager DEBUG Starting provider: GMPProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357514 addons.manager DEBUG Registering shutdown blocker for GMPProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357514 addons.manager DEBUG Provider finished startup: GMPProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357514 addons.manager DEBUG Starting provider: PluginProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357514 addons.manager DEBUG Registering shutdown blocker for PluginProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357515 addons.manager DEBUG Provider finished startup: PluginProvider"
0:00.61 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357518 addons.manager DEBUG Completed startup sequence"
0:00.61 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | Starting test_management_get_self_complete
0:00.61 LOG: Thread-1 INFO (xpcshell/head.js) | test test_management_get_self_complete pending (2)
0:00.63 LOG: Thread-1 INFO "Extension loaded"
0:00.67 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 0 finished (2)
0:00.77 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357675 addons.xpi WARN Add-on get_self_test_complete@tests.mozilla.com is not compatible with application version."
0:00.77 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357680 addons.xpi-utils DEBUG Starting async load of XPI database /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions.json"
0:00.77 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357675 addons.xpi WARN Add-on get_self_test_complete@tests.mozilla.com is not compatible with application version."
0:00.77 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357680 addons.xpi-utils DEBUG Starting async load of XPI database /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions.json"
0:00.77 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357682 addons.xpi-utils DEBUG Rebuilding XPI database with no extensions"
0:00.77 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357682 addons.xpi INFO Mapping get_self_test_complete@tests.mozilla.com to /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.77 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357683 addons.xpi DEBUG Loading bootstrap scope from /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357684 addons.xpi DEBUG Calling bootstrap method install on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357684 addons.xpi DEBUG Install of temporary addon in /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi completed."
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357685 addons.xpi-utils DEBUG Make addon app-temporary:get_self_test_complete@tests.mozilla.com visible"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357687 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357687 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357687 addons.xpi DEBUG XPIStates adding add-on get_self_test_complete@tests.mozilla.com in app-temporary: /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357688 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_complete@tests.mozilla.com","syncGUID":"{f1322836-4171-884a-ac9c-e9235c4c9308}","location":"app-temporary","version":"1.0","type":"webextension","internalName":null,"updateURL":"https://updates.mozilla.com/","updateKey":null,"optionsURL":"get_self_options.html","optionsType":5,"aboutURL":null,"icons":{"16":"icons/icon-16.png","48":"icons/icon-48.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","description":"test extension description","homepageURL":"http://www.example.com/","developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":true,"descriptor":"/Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi","applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":811,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357688 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_complete@tests.mozilla.com"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357688 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357688 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357689 addons.xpi DEBUG Calling bootstrap method startup on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.78 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357691 DeferredSave.extensions.json DEBUG Starting timer"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357682 addons.xpi-utils DEBUG Rebuilding XPI database with no extensions"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357682 addons.xpi INFO Mapping get_self_test_complete@tests.mozilla.com to /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357683 addons.xpi DEBUG Loading bootstrap scope from /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357684 addons.xpi DEBUG Calling bootstrap method install on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357684 addons.xpi DEBUG Install of temporary addon in /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi completed."
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357685 addons.xpi-utils DEBUG Make addon app-temporary:get_self_test_complete@tests.mozilla.com visible"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357687 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357687 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357687 addons.xpi DEBUG XPIStates adding add-on get_self_test_complete@tests.mozilla.com in app-temporary: /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357688 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_complete@tests.mozilla.com","syncGUID":"{f1322836-4171-884a-ac9c-e9235c4c9308}","location":"app-temporary","version":"1.0","type":"webextension","internalName":null,"updateURL":"https://updates.mozilla.com/","updateKey":null,"optionsURL":"get_self_options.html","optionsType":5,"aboutURL":null,"icons":{"16":"icons/icon-16.png","48":"icons/icon-48.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","description":"test extension description","homepageURL":"http://www.example.com/","developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":true,"descriptor":"/Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-25.xpi","applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":811,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357688 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_complete@tests.mozilla.com"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357688 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357688 DeferredSave.extensions.json DEBUG Save changes"
0:00.78 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357689 addons.xpi DEBUG Calling bootstrap method startup on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.84 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357691 DeferredSave.extensions.json DEBUG Starting timer"
0:00.85 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357756 DeferredSave.extensions.json DEBUG Starting write"
0:00.87 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357756 DeferredSave.extensions.json DEBUG Starting write"
0:00.93 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "ReferenceError: reference to undefined property tabBrowser.localName" {file: "chrome://global/content/bindings/browser.xml" line: 369}]"
0:00.96 PROCESS_OUTPUT: Thread-1 (pid:28608) "---------- addon.permissions: 9 ---------------"
0:00.96 PROCESS_OUTPUT: Thread-1 (pid:28608) "---------- AddonManager.PERM_CAN_DISABLE: 4 ---------------"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 51] getSelf returned the expected id - "get_self_test_complete@tests.mozilla.com" == "get_self_test_complete@tests.mozilla.com"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 52] getSelf returned the expected installType - "development" == "development"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 54] getSelf returned the expected name - "test extension name" == "test extension name"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 54] getSelf returned the expected description - "test extension description" == "test extension description"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 54] getSelf returned the expected version - "1.0" == "1.0"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 56] getSelf returned the expected shortName - "test extension short name" == "test extension short name"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 59] getSelf returned the expected value for enabled - true == true
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 60] getSelf returned the expected homepageUrl - "http://www.example.com/" == "http://www.example.com/"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 61] getSelf returned the expected updateUrl - "https://updates.mozilla.com/" == "https://updates.mozilla.com/"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 62] getSelf returned the expected optionsUrl - true == true
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 64] getSelf returned the expected icon size - 16 == 16
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 65] getSelf returned the expected icon url - "icons/icon-16.png" == "icons/icon-16.png"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 64] getSelf returned the expected icon size - 48 == 48
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 65] getSelf returned the expected icon url - "icons/icon-48.png" == "icons/icon-48.png"
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 67] getSelf returned the expected permissions - ["cookies","management"] deepEqual ["cookies","management"]
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 68] getSelf returned the expected hostPermissions - ["*://example.org/","https://foo.example.org/"] deepEqual ["*://example.org/","https://foo.example.org/"]
0:00.97 TEST_STATUS: Thread-1 test_management_get_self_complete PASS [test_management_get_self_complete : 69] getSelf returned the expected installType - "development" == "development"
0:00.97 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357885 addons.xpi DEBUG Calling bootstrap method shutdown on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.98 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357893 addons.xpi DEBUG Calling bootstrap method uninstall on get_self_test_complete@tests.mozilla.com version 1.0"
0:00.98 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357894 DeferredSave.extensions.json DEBUG Save changes"
0:00.98 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357894 DeferredSave.extensions.json DEBUG Data changed while write in progress"
0:00.98 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357895 addons.xpi DEBUG Removing XPIState for app-temporary:get_self_test_complete@tests.mozilla.com"
0:01.00 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 1 pending (2)
0:01.00 LOG: Thread-1 INFO (xpcshell/head.js) | test test_management_get_self_complete finished (2)
0:01.00 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357885 addons.xpi DEBUG Calling bootstrap method shutdown on get_self_test_complete@tests.mozilla.com version 1.0"
0:01.00 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357893 addons.xpi DEBUG Calling bootstrap method uninstall on get_self_test_complete@tests.mozilla.com version 1.0"
0:01.00 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357894 DeferredSave.extensions.json DEBUG Save changes"
0:01.00 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357894 DeferredSave.extensions.json DEBUG Data changed while write in progress"
0:01.00 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357895 addons.xpi DEBUG Removing XPIState for app-temporary:get_self_test_complete@tests.mozilla.com"
0:01.00 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | Starting test_management_get_self_minimal
0:01.00 LOG: Thread-1 INFO (xpcshell/head.js) | test test_management_get_self_minimal pending (2)
0:01.00 LOG: Thread-1 INFO "Extension loaded"
0:01.00 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 1 finished (2)
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357920 addons.xpi WARN Add-on get_self_test_minimal@tests.mozilla.com is not compatible with application version."
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357921 addons.xpi INFO Mapping get_self_test_minimal@tests.mozilla.com to /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357921 addons.xpi DEBUG Loading bootstrap scope from /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 addons.xpi DEBUG Calling bootstrap method install on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 addons.xpi DEBUG Install of temporary addon in /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi completed."
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 addons.xpi-utils DEBUG Make addon app-temporary:get_self_test_minimal@tests.mozilla.com visible"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 DeferredSave.extensions.json DEBUG Save changes"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 DeferredSave.extensions.json DEBUG Save changes"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357923 addons.xpi DEBUG XPIStates adding add-on get_self_test_minimal@tests.mozilla.com in app-temporary: /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357924 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_minimal@tests.mozilla.com","syncGUID":"{b7fd3177-c51b-594c-afa7-41c31a06049e}","location":"app-temporary","version":"1.0","type":"webextension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":true,"descriptor":"/Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi","applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":450,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357924 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_minimal@tests.mozilla.com"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357924 DeferredSave.extensions.json DEBUG Save changes"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357924 DeferredSave.extensions.json DEBUG Save changes"
0:01.01 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357925 addons.xpi DEBUG Calling bootstrap method startup on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357920 addons.xpi WARN Add-on get_self_test_minimal@tests.mozilla.com is not compatible with application version."
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357921 addons.xpi INFO Mapping get_self_test_minimal@tests.mozilla.com to /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357921 addons.xpi DEBUG Loading bootstrap scope from /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 addons.xpi DEBUG Calling bootstrap method install on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 addons.xpi DEBUG Install of temporary addon in /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi completed."
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 addons.xpi-utils DEBUG Make addon app-temporary:get_self_test_minimal@tests.mozilla.com visible"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 DeferredSave.extensions.json DEBUG Save changes"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 DeferredSave.extensions.json DEBUG Save changes"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357923 addons.xpi DEBUG XPIStates adding add-on get_self_test_minimal@tests.mozilla.com in app-temporary: /Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357924 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_minimal@tests.mozilla.com","syncGUID":"{b7fd3177-c51b-594c-afa7-41c31a06049e}","location":"app-temporary","version":"1.0","type":"webextension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":true,"descriptor":"/Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-26.xpi","applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":450,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357924 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_minimal@tests.mozilla.com"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357924 DeferredSave.extensions.json DEBUG Save changes"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357924 DeferredSave.extensions.json DEBUG Save changes"
0:01.02 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357925 addons.xpi DEBUG Calling bootstrap method startup on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.05 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "ReferenceError: reference to undefined property tabBrowser.localName" {file: "chrome://global/content/bindings/browser.xml" line: 369}]"
0:01.06 PROCESS_OUTPUT: Thread-1 (pid:28608) "---------- addon.permissions: 9 ---------------"
0:01.06 PROCESS_OUTPUT: Thread-1 (pid:28608) "---------- AddonManager.PERM_CAN_DISABLE: 4 ---------------"
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 94] getSelf returned the expected id - "get_self_test_minimal@tests.mozilla.com" == "get_self_test_minimal@tests.mozilla.com"
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 95] getSelf returned the expected installType - "development" == "development"
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 97] getSelf returned the expected name - "test extension name" == "test extension name"
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 97] getSelf returned the expected version - "1.0" == "1.0"
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 100] getSelf returned the expected shortName - "" == ""
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 100] getSelf returned the expected description - "" == ""
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 100] getSelf returned the expected optionsUrl - "" == ""
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 103] getSelf did not return a homepageUrl property - false == false
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 103] getSelf did not return a updateUrl property - false == false
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 103] getSelf did not return a icons property - false == false
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 106] getSelf returned the expected permissions - [] deepEqual []
0:01.06 TEST_STATUS: Thread-1 test_management_get_self_minimal PASS [test_management_get_self_minimal : 106] getSelf returned the expected hostPermissions - [] deepEqual []
0:01.07 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357976 addons.xpi DEBUG Calling bootstrap method shutdown on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.07 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357979 addons.xpi DEBUG Calling bootstrap method uninstall on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.07 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357980 DeferredSave.extensions.json DEBUG Save changes"
0:01.07 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357980 addons.xpi DEBUG Removing XPIState for app-temporary:get_self_test_minimal@tests.mozilla.com"
0:01.07 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 2 pending (2)
0:01.07 LOG: Thread-1 INFO (xpcshell/head.js) | test test_management_get_self_minimal finished (2)
0:01.07 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357976 addons.xpi DEBUG Calling bootstrap method shutdown on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.07 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357979 addons.xpi DEBUG Calling bootstrap method uninstall on get_self_test_minimal@tests.mozilla.com version 1.0"
0:01.07 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357980 DeferredSave.extensions.json DEBUG Save changes"
0:01.07 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357980 addons.xpi DEBUG Removing XPIState for app-temporary:get_self_test_minimal@tests.mozilla.com"
0:01.07 LOG: Thread-1 INFO xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | Starting test_management_get_self_permanent
0:01.07 LOG: Thread-1 INFO (xpcshell/head.js) | test test_management_get_self_permanent pending (2)
0:01.08 LOG: Thread-1 INFO "Extension loaded"
0:01.08 LOG: Thread-1 INFO (xpcshell/head.js) | test run_next_test 2 finished (2)
0:01.08 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357995 addons.xpi WARN Add-on get_self_test_permanent@tests.mozilla.com is not compatible with application version."
0:01.09 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357996 addons.repository DEBUG cacheAddons: enabled false IDs ["get_self_test_permanent@tests.mozilla.com"]"
0:01.09 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284357996 addons.xpi WARN Add-on get_self_test_permanent@tests.mozilla.com is not compatible with application version."
0:01.09 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358001 addons.update-checker DEBUG Requesting http://127.0.0.1/updateURL"
0:01.09 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357995 addons.xpi WARN Add-on get_self_test_permanent@tests.mozilla.com is not compatible with application version."
0:01.09 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357996 addons.repository DEBUG cacheAddons: enabled false IDs ["get_self_test_permanent@tests.mozilla.com"]"
0:01.10 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284357996 addons.xpi WARN Add-on get_self_test_permanent@tests.mozilla.com is not compatible with application version."
0:01.10 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358001 addons.update-checker DEBUG Requesting http://127.0.0.1/updateURL"
0:01.10 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358006 addons.update-checker WARN HTTP Request failed for an unknown reason"
0:01.10 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358007 addons.xpi DEBUG Starting install of get_self_test_permanent@tests.mozilla.com from file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi"
0:01.10 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358006 addons.update-checker WARN HTTP Request failed for an unknown reason"
0:01.10 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358007 addons.xpi DEBUG Starting install of get_self_test_permanent@tests.mozilla.com from file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi"
0:01.12 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358032 DeferredSave.extensions.json DEBUG Write succeeded"
0:01.12 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358032 addons.xpi-utils DEBUG XPI Database saved, setting schema version preference to 17"
0:01.12 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358032 DeferredSave.extensions.json DEBUG Starting timer"
0:01.12 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358032 DeferredSave.extensions.json DEBUG Write succeeded"
0:01.12 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358032 addons.xpi-utils DEBUG XPI Database saved, setting schema version preference to 17"
0:01.12 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358032 DeferredSave.extensions.json DEBUG Starting timer"
0:01.14 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358054 DeferredSave.extensions.json DEBUG Starting write"
0:01.15 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358057 addons.xpi DEBUG Addon get_self_test_permanent@tests.mozilla.com will be installed as an unpacked directory"
0:01.15 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358054 DeferredSave.extensions.json DEBUG Starting write"
0:01.15 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358057 addons.xpi DEBUG Addon get_self_test_permanent@tests.mozilla.com will be installed as an unpacked directory"
0:01.15 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358058 DeferredSave.extensions.json DEBUG Write succeeded"
0:01.15 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358058 DeferredSave.extensions.json DEBUG Write succeeded"
0:01.16 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358074 addons.xpi INFO Mapping get_self_test_permanent@tests.mozilla.com to /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.16 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358074 addons.xpi-utils DEBUG Make addon app-profile:get_self_test_permanent@tests.mozilla.com visible"
0:01.16 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358074 DeferredSave.extensions.json DEBUG Save changes"
0:01.16 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358074 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358074 addons.xpi DEBUG XPIStates adding add-on get_self_test_permanent@tests.mozilla.com in app-profile: /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358075 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_permanent@tests.mozilla.com","syncGUID":"{4ef9111d-f0f0-0948-90e8-4f71fc77a234}","location":"app-profile","version":"1.0","type":"webextension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","developers":null,"translators":null,"contributors":null},"visible":true,"active":false,"userDisabled":false,"appDisabled":true,"descriptor":"/var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com","installDate":1471284357996,"updateDate":1471284357996,"applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":452,"sourceURI":"file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358075 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_permanent@tests.mozilla.com"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358075 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358075 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358076 addons.xpi DEBUG Loading bootstrap scope from /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358077 addons.xpi DEBUG Calling bootstrap method install on get_self_test_permanent@tests.mozilla.com version 1.0"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358077 addons.xpi DEBUG Install of file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi completed."
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358078 DeferredSave.extensions.json DEBUG Starting timer"
0:01.17 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358078 addons.xpi DEBUG removeTemporaryFile: file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi does not own temp file"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358074 addons.xpi INFO Mapping get_self_test_permanent@tests.mozilla.com to /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358074 addons.xpi-utils DEBUG Make addon app-profile:get_self_test_permanent@tests.mozilla.com visible"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358074 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358074 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358074 addons.xpi DEBUG XPIStates adding add-on get_self_test_permanent@tests.mozilla.com in app-profile: /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358075 addons.xpi DEBUG Updating XPIState for {"id":"get_self_test_permanent@tests.mozilla.com","syncGUID":"{4ef9111d-f0f0-0948-90e8-4f71fc77a234}","location":"app-profile","version":"1.0","type":"webextension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"test extension name","developers":null,"translators":null,"contributors":null},"visible":true,"active":false,"userDisabled":false,"appDisabled":true,"descriptor":"/var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com","installDate":1471284357996,"updateDate":1471284357996,"applyBackgroundUpdates":1,"bootstrap":true,"skinnable":false,"size":452,"sourceURI":"file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"42.0a1","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":true,"signedState":2,"seen":true,"dependencies":[]}"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358075 addons.xpi DEBUG getModTime: Recursive scan of get_self_test_permanent@tests.mozilla.com"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358075 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358075 DeferredSave.extensions.json DEBUG Save changes"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358076 addons.xpi DEBUG Loading bootstrap scope from /var/folders/kk/kg9b05_93xv73zflrf0v17m00000gn/T/firefox/xpcshellprofile/extensions/get_self_test_permanent@tests.mozilla.com"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358077 addons.xpi DEBUG Calling bootstrap method install on get_self_test_permanent@tests.mozilla.com version 1.0"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358077 addons.xpi DEBUG Install of file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi completed."
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358078 DeferredSave.extensions.json DEBUG Starting timer"
0:01.17 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358078 addons.xpi DEBUG removeTemporaryFile: file:///Users/bsilverberg/Library/Caches/TemporaryItems/generated-extension-27.xpi does not own temp file"
0:01.19 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358099 DeferredSave.extensions.json DEBUG Starting write"
0:01.19 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358099 DeferredSave.extensions.json DEBUG Starting write"
0:01.19 PROCESS_OUTPUT: Thread-1 (pid:28608) "1471284358103 DeferredSave.extensions.json DEBUG Write succeeded"
0:01.19 LOG: Thread-1 INFO "CONSOLE_MESSAGE: (info) 1471284358103 DeferredSave.extensions.json DEBUG Write succeeded"
5:00.39 TEST_END: Thread-3 Harness TIMEOUT, expected PASS. Subtests passed 29/29. Unexpected 1
Test timed out
5:00.39 LOG: Thread-3 INFO xpcshell return code: None
5:00.39 LOG: Thread-3 ERROR xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js | Process still running after test!
5:00.40 LOG: MainThread ERROR TEST-UNEXPECTED-FAIL | Received SIGINT (control-C), so stopped run. (Use --keep-going to keep running tests after killing one with SIGINT)
5:00.40 LOG: MainThread INFO INFO | Result summary:
5:00.40 LOG: MainThread INFO INFO | Passed: 0
5:00.40 LOG: MainThread INFO INFO | Failed: 1
5:00.40 LOG: MainThread INFO INFO | Todo: 0
5:00.40 LOG: MainThread INFO INFO | Retried: 0
5:00.40 SUITE_END: MainThread
Summary
=======
Ran 30 tests (1 parents, 29 subtests)
Expected results: 29
Unexpected results: 1 (TIMEOUT: 1)
Unexpected Results
==================
xpcshell-unpack.ini:toolkit/mozapps/extensions/test/xpcshell/test_ext_management.js
-----------------------------------------------------------------------------------
TIMEOUT [Parent]
(management.getSelf)mozilla-central$
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment