Closed Bug 1664474 Opened 5 years ago Closed 5 years ago

Intermittent TC browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | xpcshell return code: 0

Categories

(Toolkit :: Form Autofill, defect, P5)

Product:
Toolkit
Component:
Form Autofill
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=315434183&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HbpmIyMLSCSVywwrKY1GuA/runs/0/artifacts/public/logs/live_backing.log

[task 2020-09-11T11:31:35.269Z] Couldn't find source info for moz-extension://a39a132d-ec40-43f8-a631-e3d01e09feab/run.js, removing record
[task 2020-09-11T11:31:35.327Z] 11:31:35 INFO - Getting output from command: ['Z:/task_1599820543/fetches\grcov.exe', '-t', 'coveralls', '-p', 'z:/build/build/src/', '--ignore', 'gcc*', '--ignore', 'vs2017_', 'Z:/task_1599820543/fetches\target.code-coverage-gcno.zip', 'c:\users\task_1599820543\appdata\local\temp\tmpgq9dxj', '--token', 'UNUSED', '--commit-sha', 'UNUSED', 'jsvm_lcov_output.info', '--llvm', '--filter', 'covered']
[task 2020-09-11T11:31:35.327Z] 11:31:35 INFO - Copy/paste: Z:/task_1599820543/fetches\grcov.exe -t coveralls -p z:/build/build/src/ --ignore gcc --ignore vs2017_* Z:/task_1599820543/fetches\target.code-coverage-gcno.zip c:\users\task_1599820543\appdata\local\temp\tmpgq9dxj --token UNUSED --commit-sha UNUSED jsvm_lcov_output.info --llvm --filter covered
[task 2020-09-11T11:31:45.240Z] 11:31:45 ERROR - Errors received:
[task 2020-09-11T11:31:45.240Z] 11:31:45 INFO - Reading from file tmpfile_stderr
[task 2020-09-11T11:31:45.240Z] 11:31:45 ERROR - 11:31:35 [ERROR] FN 'top-level' duplicated for 'toolkit/components/osfile/modules/osfile_async_worker.js' in a lcov file
[task 2020-09-11T11:31:45.240Z] 11:31:45 ERROR - Return code: 0
[task 2020-09-11T11:31:46.208Z] 11:31:46 INFO - TinderboxPrint: mochitest-mochitest-plain<br/>1/0/0
[task 2020-09-11T11:31:46.208Z] 11:31:46 WARNING - # TBPL SUCCESS #
[task 2020-09-11T11:31:46.208Z] 11:31:46 WARNING - TinderboxPrint: Per-test run of ...\plain\test_baselinecoverage.html<br/>: SUCCESS
[task 2020-09-11T11:31:46.208Z] 11:31:46 INFO - Per-test suites: {}
[task 2020-09-11T11:31:46.208Z] 11:31:46 INFO - Per-test suites: {'xpcshell': {'tests': (), 'options': ('--xpcshell=%(abs_app_dir)s/xpcshell.exe', '--manifest=tests/xpcshell/tests/xpcshell.ini')}}
[task 2020-09-11T11:31:46.208Z] 11:31:46 INFO - #### Running xpcshell suites
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: MOZ_NODE_PATH is now Z:/task_1599820543/fetches\node/node.exe
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: STYLO_THREADS is now 4
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: RUST_BACKTRACE is now full
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: MOZ_UPLOAD_DIR is now Z:\task_1599820543\build\blobber_upload_dir
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: MINIDUMP_STACKWALK is now Z:/task_1599820543/fetches\minidump_stackwalk\minidump_stackwalk.exe
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - ENV: MINIDUMP_SAVE_PATH is now Z:\task_1599820543\build\blobber_upload_dir
[task 2020-09-11T11:31:46.209Z] 11:31:46 INFO - Per-test file(s) for 'xpcshell': [u'browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js', u'browser/components/newtab/test/xpcshell/test_AboutNewTab.js']
[task 2020-09-11T11:31:46.210Z] 11:31:46 INFO - Running command: ['Z:\task_1599820543\build\venv\Scripts\python', '-u', 'Z:\task_1599820543\build\tests\xpcshell\runxpcshelltests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--self-test', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Mj4eXRcoSDuXNbLZ1asoLg/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=Z:\task_1599820543\build\application\firefox\plugins', '--log-raw=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_raw.log', '--log-errorsummary=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=Z:\task_1599820543\build\application\firefox/xpcshell.exe', '--manifest=tests/xpcshell/tests/xpcshell.ini', u'browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js'] in Z:\task_1599820543\build
[task 2020-09-11T11:31:46.210Z] 11:31:46 INFO - Copy/paste: Z:\task_1599820543\build\venv\Scripts\python -u Z:\task_1599820543\build\tests\xpcshell\runxpcshelltests.py --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --self-test --symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Mj4eXRcoSDuXNbLZ1asoLg/artifacts/public/build/target.crashreporter-symbols.zip --test-plugin-path=Z:\task_1599820543\build\application\firefox\plugins --log-raw=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_raw.log --log-errorsummary=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_errorsummary.log --utility-path=tests/bin --xpcshell=Z:\task_1599820543\build\application\firefox/xpcshell.exe --manifest=tests/xpcshell/tests/xpcshell.ini browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\ProgramData',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'APPDATA': 'Z:\task_1599820543\AppData\Roaming',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'COMMONPROGRAMFILES': 'C:\Program Files\Common Files',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\Program Files (x86)\Common Files',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'COMMONPROGRAMW6432': 'C:\Program Files\Common Files',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'COMPUTERNAME': 'I-0AB2F43B7D553',
[task 2020-09-11T11:31:46.213Z] 11:31:46 INFO - 'COMSPEC': 'C:\Windows\system32\cmd.exe',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'DRIVERDATA': 'C:\Windows\System32\Drivers\DriverData',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'EXTRA_MOZHARNESS_CONFIG': '{"installer_url": "https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Mj4eXRcoSDuXNbLZ1asoLg/artifacts/public/build/target.zip", "test_packages_url": "https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Mj4eXRcoSDuXNbLZ1asoLg/artifacts/public/build/target.test_packages.json"}',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'GCOV_PREFIX': 'c:\users\task_1599820543\appdata\local\temp\tmp69dfrc',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'GCOV_PREFIX_STRIP': '4',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'GCOV_RESULTS_DIR': 'c:\users\task_1599820543\appdata\local\temp\tmp0xo7yz',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'GECKO_HEAD_REPOSITORY': 'https://hg.mozilla.org/mozilla-central',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'GECKO_HEAD_REV': '3618085622203ef418c62c3d99199485c99e0e51',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'HOMEDRIVE': 'C:',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'HOMEPATH': '\Users\task_1599820543',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'JSVM_RESULTS_DIR': 'c:\users\task_1599820543\appdata\local\temp\tmpmfhk8m',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'JS_CODE_COVERAGE_OUTPUT_DIR': 'c:\users\task_1599820543\appdata\local\temp\tmpoqceai',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'LOCALAPPDATA': 'C:\Users\task_1599820543\AppData\Local',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'LOGONSERVER': '\\I-0AB2F43B7D553',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MINIDUMP_SAVE_PATH': 'Z:\task_1599820543\build\blobber_upload_dir',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MINIDUMP_STACKWALK': 'Z:/task_1599820543/fetches\minidump_stackwalk\minidump_stackwalk.exe',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZILLABUILD': 'C:\mozilla-build',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_AUTOMATION': '1',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_FETCHES': '[{"artifact": "public/build/fix-stacks.tar.bz2", "extract": true, "task": "NCJ7izsYSbe7ALHbEj7w9Q"}, {"artifact": "public/build/grcov.tar.bz2", "extract": true, "task": "c35XdKmDTjycbLYyfi5VzA"}, {"artifact": "public/build/minidump_stackwalk.tar.xz", "extract": true, "task": "TYPC0Vs3SUSocQCAladLIg"}, {"artifact": "public/build/node.tar.bz2", "extract": true, "task": "OvEirYPMRneCInPlmPdDfQ"}]',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_FETCHES_DIR': 'Z:/task_1599820543/fetches',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_NODE_PATH': 'Z:/task_1599820543/fetches\node/node.exe',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_SCM_LEVEL': '3',
[task 2020-09-11T11:31:46.214Z] 11:31:46 INFO - 'MOZ_UPLOAD_DIR': 'Z:\task_1599820543\build\blobber_upload_dir',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'NUMBER_OF_PROCESSORS': '8',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'ONEDRIVE': 'C:\Users\task_1599820543\OneDrive',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'OS': 'Windows_NT',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PATH': 'Z:\task_1599820543\build\venv\Scripts;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Windows\system32\config\systemprofile\AppData\Local\Microsoft\WindowsApps;C:\Program Files (x86)\Windows Kits\10\Windows Performance Toolkit\;;C:\Program Files\Mercurial;C:\mozilla-build\bin;C:\mozilla-build\kdiff3;C:\mozilla-build\moztools-x64\bin;C:\mozilla-build\mozmake;C:\mozilla-build\msys\bin;C:\mozilla-build\msys\local\bin;C:\mozilla-build\nsis-3.01;C:\mozilla-build\python;C:\mozilla-build\python\Scripts;C:\mozilla-build\python3;C:\Users\task_1599820543\AppData\Local\Microsoft\WindowsApps;Z:\task_1599820543\build\venv\Lib\site-packages\pywin32_system32',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PIP_DOWNLOAD_CACHE': 'y:\pip-cache',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROCESSOR_ARCHITECTURE': 'AMD64',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 85 Stepping 4, GenuineIntel',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROCESSOR_LEVEL': '6',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROCESSOR_REVISION': '5504',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROGRAMDATA': 'C:\ProgramData',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROGRAMFILES': 'C:\Program Files',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROGRAMFILES(X86)': 'C:\Program Files (x86)',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROGRAMW6432': 'C:\Program Files',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PROMPT': '$P$G',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PSMODULEPATH': '%ProgramFiles%\WindowsPowerShell\Modules;C:\Windows\system32\WindowsPowerShell\v1.0\Modules',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'PUBLIC': 'C:\Users\Public',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'RUN_ID': '0',
[task 2020-09-11T11:31:46.215Z] 11:31:46 INFO - 'RUST_BACKTRACE': 'full',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'SCCACHE_DISABLE': '1',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'STYLO_THREADS': '4',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'SYSTEMDRIVE': 'C:',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'SYSTEMROOT': 'C:\Windows',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TASKCLUSTER_INSTANCE_TYPE': 'c5.2xlarge',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TASKCLUSTER_ROOT_URL': 'https://firefox-ci-tc.services.mozilla.com',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TASKCLUSTER_WORKER_LOCATION': '{"cloud":"aws","region":"us-east-1","availabilityZone":"us-east-1c"}',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TASK_ID': 'HbpmIyMLSCSVywwrKY1GuA',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TEMP': 'C:\Users\task_1599820543\AppData\Local\Temp',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TMP': 'C:\Users\task_1599820543\AppData\Local\Temp',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'TOOLTOOL_CACHE': 'y:\tooltool-cache',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'USERDOMAIN': 'I-0AB2F43B7D553',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'I-0AB2F43B7D553',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'USERNAME': 'task_1599820543',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'USERPROFILE': 'C:\Users\task_1599820543',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'VIRTUAL_ENV': 'Z:\task_1599820543\build\venv',
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - 'WINDIR': 'C:\Windows'}
[task 2020-09-11T11:31:46.216Z] 11:31:46 INFO - Calling ['Z:\task_1599820543\build\venv\Scripts\python', '-u', 'Z:\task_1599820543\build\tests\xpcshell\runxpcshelltests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--self-test', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Mj4eXRcoSDuXNbLZ1asoLg/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=Z:\task_1599820543\build\application\firefox\plugins', '--log-raw=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_raw.log', '--log-errorsummary=Z:\task_1599820543\build\blobber_upload_dir\xpcshell-test10_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=Z:\task_1599820543\build\application\firefox/xpcshell.exe', '--manifest=tests/xpcshell/tests/xpcshell.ini', u'browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js'] with output_timeout 1000
[task 2020-09-11T11:31:52.117Z] 11:31:52 INFO - testAddTaskRunNextTest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:32:06.958Z] 11:32:06 INFO - testAddTaskSkip (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:32:19.932Z] 11:32:19 INFO - testAddTaskSkipAll (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:32:33.868Z] 11:32:33 INFO - testAddTaskStackTrace (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:32:46.862Z] 11:32:46 INFO - testAddTaskTestFailureInside (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:33:00.820Z] 11:33:00 INFO - testAddTaskTestMultiple (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:33:14.100Z] 11:33:14 INFO - testAddTaskTestRejected (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:33:27.832Z] 11:33:27 INFO - testAddTaskTestSingle (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:33:41.010Z] 11:33:41 INFO - testAddTestFailing (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:33:55.037Z] 11:33:55 INFO - testAddTestSimple (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:34:06.856Z] 11:34:06 INFO - testAddTestUncaughtRejection (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:34:14.428Z] 11:34:14 INFO - testAddTestUncaughtRejectionJSM (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:34:14.428Z] 11:34:14 INFO - testAssertStack (main.XPCShellTestsTests) ... skipped "We don't have a stack fixer on hand for windows."
[task 2020-09-11T11:34:23.402Z] 11:34:23 INFO - testAsyncCleanup (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:34:48.148Z] 11:34:48 INFO - testChild (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:35:12.165Z] 11:35:12 INFO - testChildFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:35:35.612Z] 11:35:35 INFO - testChildHang (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:36:00.057Z] 11:36:00 INFO - testChildMozinfo (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:36:23.890Z] 11:36:23 INFO - testChildPass (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:36:35.741Z] 11:36:35 INFO - testCrashLogging (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:36:44.667Z] 11:36:44 INFO - testDoPrintWhenVerboseExplicit (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:36:58.745Z] 11:36:58 INFO - testDoPrintWhenVerboseInManifest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:37:11.972Z] 11:37:11 INFO - testDoPrintWhenVerboseNotExplicit (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:37:24.341Z] 11:37:24 INFO - testDoReportForeignObject (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:37:33.490Z] 11:37:33 INFO - testDoReportNonSyntaxError (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:37:45.227Z] 11:37:45 INFO - testDoReportRefError (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:37:54.166Z] 11:37:54 INFO - testDoReportSyntaxError (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:06.373Z] 11:38:06 INFO - testDoThrowForeignObject (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:13.822Z] 11:38:13 INFO - testDoThrowString (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:21.963Z] 11:38:21 INFO - testFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:21.963Z] 11:38:21 INFO - testHangingTimeout (main.XPCShellTestsTests) ... skipped 'Timeout code path occasionally times out (bug 1098121)'
[task 2020-09-11T11:38:31.260Z] 11:38:31 INFO - testHeadlessWhenHeadlessExplicit (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:44.843Z] 11:38:44 INFO - testHeadlessWhenHeadlessTrueInManifest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:38:56.620Z] 11:38:56 INFO - testKnownFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:39:06.692Z] 11:39:06 INFO - testLogCorrectFileName (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:39:06.918Z] 11:39:06 INFO - testMissingHeadFile (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:39:20.801Z] 11:39:20 INFO - testMozinfo (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:39:33.934Z] 11:39:33 INFO - testNoRunTestAddTask (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:39:47.770Z] 11:39:47 INFO - testNoRunTestAddTaskFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:40:01.242Z] 11:40:01 INFO - testNoRunTestAddTaskMultiple (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:40:14.382Z] 11:40:14 INFO - testNoRunTestAddTest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:40:28.287Z] 11:40:28 INFO - testNoRunTestAddTestAddTask (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:40:41.220Z] 11:40:41 INFO - testNoRunTestAddTestFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:40:54.879Z] 11:40:54 INFO - testNoRunTestEmptyTest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:41:08.214Z] 11:41:08 INFO - testNotHeadlessByDefault (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:41:22.345Z] 11:41:22 INFO - testNotHeadlessWhenHeadlessFalseInManifest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:41:35.517Z] 11:41:35 INFO - testNotSkipForAddTask (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:41:48.308Z] 11:41:48 INFO - testNotSkipForAddTest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:42:01.292Z] 11:42:01 INFO - testPass (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:42:26.322Z] 11:42:26 INFO - testPassFail (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:42:35.561Z] 11:42:35 INFO - testPrefsInManifestNonVerbose (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:42:48.772Z] 11:42:48 INFO - testPrefsInManifestVerbose (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:00.827Z] 11:45:00 INFO - testRandomExecution (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:13.640Z] 11:45:13 INFO - testReturnNonzero (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:13.822Z] 11:45:13 INFO - testSkip (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:27.545Z] 11:45:27 INFO - testSkipForAddTask (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:40.628Z] 11:45:40 INFO - testSkipForAddTest (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:45:54.630Z] 11:45:54 INFO - testSyntaxError (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:46:08.003Z] 11:46:08 INFO - testUncaughtRejection (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:46:19.629Z] 11:46:19 INFO - testUncaughtRejectionJSM (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:46:28.595Z] 11:46:28 INFO - testUnexpectedPass (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:46:42.294Z] 11:46:42 INFO - testUnicodeInAssertMethods (main.XPCShellTestsTests) ... ok
[task 2020-09-11T11:46:42.294Z] 11:46:42 INFO - ----------------------------------------------------------------------
[task 2020-09-11T11:46:42.294Z] 11:46:42 INFO - Ran 62 tests in 895.752s
[task 2020-09-11T11:46:42.294Z] 11:46:42 INFO - OK (skipped=2)
[task 2020-09-11T11:46:42.296Z] 11:46:42 INFO - Found node at Z:/task_1599820543/fetches\node/node.exe
[task 2020-09-11T11:46:42.296Z] 11:46:42 INFO - Found moz-http2 at Z:\task_1599820543\build\tests\xpcshell\moz-http2\moz-http2.js
[task 2020-09-11T11:46:42.482Z] 11:46:42 INFO - Http3 server not found at Z:\task_1599820543\build\tests\xpcshell\http3server\http3server.exe. Tests requiring http/3 will fail.
[task 2020-09-11T11:46:42.909Z] 11:46:42 INFO - Running tests sequentially.
[task 2020-09-11T11:46:42.909Z] 11:46:42 INFO - SUITE-START | Running 1 tests
[task 2020-09-11T11:46:42.909Z] 11:46:42 INFO - profile dir is c:\users\task_1599820543\appdata\local\temp\xpcshell\xpcshellprofile
[task 2020-09-11T11:46:42.918Z] 11:46:42 INFO - TEST-START | browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js
[task 2020-09-11T11:47:14.981Z] 11:47:14 WARNING - TEST-UNEXPECTED-FAIL | browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | xpcshell return code: 0
[task 2020-09-11T11:47:14.982Z] 11:47:14 INFO - TEST-INFO took 32061ms
[task 2020-09-11T11:47:14.982Z] 11:47:14 INFO - >>>>>>>
[task 2020-09-11T11:47:14.983Z] 11:47:14 INFO - PID 9444 | [CodeCoverage] Requested flush for 9444.
[task 2020-09-11T11:47:14.983Z] 11:47:14 INFO - PID 9444 | [CodeCoverage] flush completed.
[task 2020-09-11T11:47:14.983Z] 11:47:14 INFO - PID 9444 | [CodeCoverage] JS flush completed.
[task 2020-09-11T11:47:14.984Z] 11:47:14 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-09-11T11:47:14.984Z] 11:47:14 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2020-09-11T11:47:14.985Z] 11:47:14 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2020-09-11T11:47:14.985Z] 11:47:14 INFO - running event loop
[task 2020-09-11T11:47:14.985Z] 11:47:14 INFO - browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | Starting head_initialize
[task 2020-09-11T11:47:14.986Z] 11:47:14 INFO - (xpcshell/head.js) | test head_initialize pending (2)
[task 2020-09-11T11:47:14.986Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809625 addons.manager DEBUG Application has been upgraded"
[task 2020-09-11T11:47:14.987Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809626 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider", "XPIInternal"]"
[task 2020-09-11T11:47:14.987Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809639 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm"
[task 2020-09-11T11:47:14.988Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809644 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm"
[task 2020-09-11T11:47:14.988Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809645 addons.manager DEBUG Starting provider: XPIProvider"
[task 2020-09-11T11:47:14.989Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809646 addons.xpi DEBUG startup"
[task 2020-09-11T11:47:14.989Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809648 addons.xpi INFO SystemAddonLocation directory is missing"
[task 2020-09-11T11:47:14.989Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809678 addons.xpi INFO Removing all system add-on upgrades."
[task 2020-09-11T11:47:14.990Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809679 addons.xpi DEBUG checkForChanges"
[task 2020-09-11T11:47:14.990Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809680 addons.xpi DEBUG Loaded add-on state: ${}"
[task 2020-09-11T11:47:14.991Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809683 addons.xpi DEBUG scanForChanges changed: false, state: {}"
[task 2020-09-11T11:47:14.991Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809684 addons.xpi DEBUG Empty XPI database, setting schema version preference to 32"
[task 2020-09-11T11:47:14.991Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809684 addons.xpi DEBUG No changes found"
[task 2020-09-11T11:47:14.992Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809715 addons.xpi-utils DEBUG Synchronously loading the add-ons database"
[task 2020-09-11T11:47:14.992Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809716 addons.xpi-utils DEBUG Starting async load of XPI database c:\users\task_1599820543\appdata\local\temp\xpcshell\xpcshellprofile\extensions.json"
[task 2020-09-11T11:47:14.992Z] 11:47:14 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2020-09-11T11:47:14.993Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809835 addons.xpi-utils DEBUG Rebuilding XPI database with no extensions"
[task 2020-09-11T11:47:14.993Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809840 addons.manager DEBUG Registering shutdown blocker for XPIProvider"
[task 2020-09-11T11:47:14.994Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809841 addons.manager DEBUG Provider finished startup: XPIProvider"
[task 2020-09-11T11:47:14.994Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809841 addons.manager DEBUG Starting provider: PluginProvider"
[task 2020-09-11T11:47:14.995Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809841 addons.manager DEBUG Registering shutdown blocker for PluginProvider"
[task 2020-09-11T11:47:14.995Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809842 addons.manager DEBUG Provider finished startup: PluginProvider"
[task 2020-09-11T11:47:14.995Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824809842 addons.manager DEBUG Completed startup sequence"
[task 2020-09-11T11:47:14.995Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810470 addons.xpi-utils DEBUG Make addon app-temporary:formautofill@mozilla.org visible"
[task 2020-09-11T11:47:14.996Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810470 addons.xpi DEBUG XPIStates adding add-on formautofill@mozilla.org in {}: Z:\task_1599820543\build\application\firefox\browser\features\formautofill@mozilla.org.xpi"
[task 2020-09-11T11:47:14.996Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810472 addons.xpi DEBUG Updating XPIState for {"id":"formautofill@mozilla.org","syncGUID":"{c87088e2-8ac9-4cc5-bae5-c72b70835b65}","version":"1.0","type":"extension","loader":null,"updateURL":null,"optionsURL":null,"optionsType":null,"optionsBrowserStyle":true,"aboutURL":null,"defaultLocale":{"name":"Form Autofill","creator":null,"developers":null,"translators":null,"contributors":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"embedderDisabled":false,"installDate":1599824810469,"applyBackgroundUpdates":1,"path":"Z:\\task_1599820543\\build\\application\\firefox\\browser\\features\\formautofill@mozilla.org.xpi","skinnable":false,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":null,"maxVersion":null}],"targetPlatforms":[],"signedState":4,"signedDate":null,"seen":true,"dependencies":[],"incognito":"spanning","userPermissions":{"permissions":[],"origins":[]},"optionalPermissions":{"permissions":[],"origins":[]},"icons":{},"iconURL":null,"blocklistState":0,"blocklistURL":null,"startupData":null,"hidden":false,"installTelemetryInfo":null,"recommendationState":null,"rootURI":"jar:file:///Z:/task_1599820543/build/application/firefox/browser/features/formautofill@mozilla.org.xpi!/","location":"app-temporary"}"
[task 2020-09-11T11:47:14.996Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810473 addons.xpi DEBUG Loading bootstrap scope from jar:file:///Z:/task_1599820543/build/application/firefox/browser/features/formautofill@mozilla.org.xpi!/"
[task 2020-09-11T11:47:14.996Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810473 addons.xpi DEBUG Calling bootstrap method install on formautofill@mozilla.org version 1.0"
[task 2020-09-11T11:47:14.996Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810474 addons.xpi DEBUG Calling bootstrap method startup on formautofill@mozilla.org version 1.0"
[task 2020-09-11T11:47:14.997Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810545 addons.xpi-utils DEBUG XPI Database saved, setting schema version preference to 32"
[task 2020-09-11T11:47:14.997Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810649 addons.manager DEBUG Starting provider: GMPProvider"
[task 2020-09-11T11:47:14.997Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810654 addons.manager DEBUG Registering shutdown blocker for GMPProvider"
[task 2020-09-11T11:47:14.997Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824810655 addons.manager DEBUG Provider finished startup: GMPProvider"
[task 2020-09-11T11:47:14.998Z] 11:47:14 INFO - (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2020-09-11T11:47:14.998Z] 11:47:14 INFO - (xpcshell/head.js) | test head_initialize finished (2)
[task 2020-09-11T11:47:14.999Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824811059 addons.manager DEBUG Registering upgrade listener for formautofill@mozilla.org"
[task 2020-09-11T11:47:14.999Z] 11:47:14 INFO - "CONSOLE_MESSAGE: (info) 1599824811063 addons.xpi DEBUG Install of temporary addon in Z:\task_1599820543\build\application\firefox\browser\features\formautofill@mozilla.org.xpi completed."
[task 2020-09-11T11:47:15.000Z] 11:47:14 INFO - browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | Starting os_key_store_setup
[task 2020-09-11T11:47:15.000Z] 11:47:15 INFO - (xpcshell/head.js) | test os_key_store_setup pending (2)
[task 2020-09-11T11:47:15.000Z] 11:47:15 INFO - (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2020-09-11T11:47:15.001Z] 11:47:15 INFO - (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2020-09-11T11:47:15.001Z] 11:47:15 INFO - (xpcshell/head.js) | test os_key_store_setup finished (2)
[task 2020-09-11T11:47:15.001Z] 11:47:15 INFO - browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | Starting setup
[task 2020-09-11T11:47:15.002Z] 11:47:15 INFO - (xpcshell/head.js) | test setup pending (2)
[task 2020-09-11T11:47:15.002Z] 11:47:15 INFO - (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2020-09-11T11:47:15.002Z] 11:47:15 INFO - (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2020-09-11T11:47:15.002Z] 11:47:15 INFO - (xpcshell/head.js) | test setup finished (2)
[task 2020-09-11T11:47:15.003Z] 11:47:15 INFO - browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | Starting test_all_patterns
[task 2020-09-11T11:47:15.003Z] 11:47:15 INFO - (xpcshell/head.js) | test test_all_patterns pending (2)
[task 2020-09-11T11:47:15.003Z] 11:47:15 INFO - "Starting testcase: Focus on an organization field"
[task 2020-09-11T11:47:15.003Z] 11:47:15 INFO - TEST-PASS | browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | test_all_patterns - [test_all_patterns : 421] 4 == 4
[task 2020-09-11T11:47:15.003Z] 11:47:15 INFO - TEST-PASS | browser/extensions/formautofill/test/unit/test_profileAutocompleteResult.js | test_all_patterns - [test_all_patterns : 422] 0 == 0

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.