Closed Bug 1544098 Opened 6 years ago Closed 6 years ago

Intermittent PID 3760 | 1555090542661 addons.xpi ERROR Failed to process extension changes at startup: TypeError: addon._sourceBundle is undefined(resource://gre/modules/addons/XPIDatabase.jsm:2731:32) JS Stack trace: addonExists@XPIDatabase.jsm:2731:32

Categories

(Firefox :: Session Restore, defect, P5)

Product:
Firefox
Component:
Session Restore
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

#[markdown(off)]
Filed by: btara [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=239981439&repo=mozilla-central

https://queue.taskcluster.net/v1/task/SniqslWdRbyZBHJnWoFfWw/runs/0/artifacts/public/logs/live_backing.log

17:35:42 INFO - Reinstalling /home/cltbld/tasks/task_1555089874/build/tests/talos/talos/startup_test/sessionrestore/profile-manywindows/sessionCheckpoints.json on top of /tmp/tmpsdDkgH/profile/sessionCheckpoints.json
17:35:42 INFO - Using env: {'COMPIZ_CONFIG_PROFILE': 'ubuntu',
17:35:42 INFO - 'DBUS_SESSION_BUS_ADDRESS': 'unix:abstract=/tmp/dbus-U7QNguBWsg,guid=3b9ae1f461eea55cbf0c09525cb0c9d2',
17:35:42 INFO - 'DEFAULTS_PATH': '/usr/share/gconf/ubuntu.default.path',
17:35:42 INFO - 'DESKTOP_AUTOSTART_ID': '10249b5e58844a7662155508987434631300000027410001',
17:35:42 INFO - 'DISPLAY': ':0',
17:35:42 INFO - 'GECKO_HEAD_REPOSITORY': 'https://hg.mozilla.org/mozilla-central',
17:35:42 INFO - 'GECKO_HEAD_REV': 'c261aea0226a3f60a31923b9a98e80826eb18833',
17:35:42 INFO - 'GNOME_DESKTOP_SESSION_ID': 'this-is-deprecated',
17:35:42 INFO - 'GTK2_MODULES': 'overlay-scrollbar',
17:35:42 INFO - 'GTK_MODULES': 'gail:atk-bridge',
17:35:42 INFO - 'HOME': '/home/cltbld',
17:35:42 INFO - 'JSGC_DISABLE_POISONING': '1',
17:35:42 INFO - 'LANG': 'en_US.UTF-8',
17:35:42 INFO - 'LANGUAGE': 'en_US:en',
17:35:42 INFO - 'LD_LIBRARY_PATH': '/home/cltbld/tasks/task_1555089874/build/application/firefox',
17:35:42 INFO - 'LOGNAME': 'cltbld',
17:35:42 INFO - 'MAIL': '/var/mail/cltbld',
17:35:42 INFO - 'MANDATORY_PATH': '/usr/share/gconf/ubuntu.mandatory.path',
17:35:42 INFO - 'MINIDUMP_SAVE_PATH': '/home/cltbld/tasks/task_1555089874/build/blobber_upload_dir',
17:35:42 INFO - 'MINIDUMP_STACKWALK': '/home/cltbld/tasks/task_1555089874/build/linux64-minidump_stackwalk',
17:35:42 INFO - 'MOZ_ACCELERATED': '1',
17:35:42 INFO - 'MOZ_AUTOMATION': '1',
17:35:42 INFO - 'MOZ_CRASHREPORTER': '1',
17:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:35:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
17:35:42 INFO - 'MOZ_UPLOAD_DIR': '/home/cltbld/tasks/task_1555089874/build/blobber_upload_dir',
17:35:42 INFO - 'MOZ_WEBRENDER': '1',
17:35:42 INFO - 'NO_EM_RESTART': '1',
17:35:42 INFO - 'PATH': '/home/cltbld/tasks/task_1555089874/build/venv/bin:/bin:/sbin:/usr/bin:/usr/sbin:/usr/local/bin',
17:35:42 INFO - 'PWD': '/home/cltbld',
17:35:42 INFO - 'PYTHONPATH': '/home/cltbld/tasks/task_1555089874/build/tests/talos',
17:35:42 INFO - 'QT_ACCESSIBILITY': '1',
17:35:42 INFO - 'QT_IM_MODULE': 'ibus',
17:35:42 INFO - 'QT_LINUX_ACCESSIBILITY_ALWAYS_ON': '1',
17:35:42 INFO - 'QT_QPA_PLATFORMTHEME': 'appmenu-qt5',
17:35:42 INFO - 'RUST_BACKTRACE': 'full',
17:35:42 INFO - 'SCCACHE_DISABLE': '1',
17:35:42 INFO - 'SCRIPTSPATH': '/home/cltbld/tasks/task_1555089874/mozharness',
17:35:42 INFO - 'SESSION_MANAGER': 'local/t-linux64-ms-008:@/tmp/.ICE-unix/2741,unix/t-linux64-ms-008:/tmp/.ICE-unix/2741',
17:35:42 INFO - 'SHELL': '/bin/bash',
17:35:42 INFO - 'SHLVL': '2',
17:35:42 INFO - 'SSH_AGENT_PID': '2802',
17:35:42 INFO - 'SSH_AUTH_SOCK': '/run/user/1001/keyring/ssh',
17:35:42 INFO - 'STYLO_FORCE_ENABLED': '1',
17:35:42 INFO - 'TASKCLUSTER_ROOT_URL': 'https://taskcluster.net',
17:35:42 INFO - 'TASK_ID': 'SniqslWdRbyZBHJnWoFfWw',
17:35:42 INFO - 'TERM': 'xterm-256color',
17:35:42 INFO - 'TMOUT': '86400',
17:35:42 INFO - 'USER': 'cltbld',
17:35:42 INFO - 'VTE_VERSION': '4205',
17:35:42 INFO - 'WINDOWID': '23068682',
17:35:42 INFO - 'XDG_CONFIG_DIRS': '/etc/xdg/xdg-ubuntu:/etc/xdg',
17:35:42 INFO - 'XDG_CURRENT_DESKTOP': 'GNOME',
17:35:42 INFO - 'XDG_DATA_DIRS': '/usr/share/ubuntu:/usr/share/gnome:/usr/local/share/:/usr/share/:/var/lib/snapd/desktop',
17:35:42 INFO - 'XDG_MENU_PREFIX': 'gnome-',
17:35:42 INFO - 'XDG_RUNTIME_DIR': '/run/user/1001',
17:35:42 INFO - 'XDG_SESSION_ID': 'c1',
17:35:42 INFO - 'XMODIFIERS': '@im=ibus',
17:35:42 INFO - '_': '/usr/local/bin/generic-worker'}
17:35:42 INFO - TEST-INFO | started process 3760 (/home/cltbld/tasks/task_1555089874/build/application/firefox/firefox -profile /tmp/tmpsdDkgH/profile about:home)
17:35:42 ERROR - PID 3760 | 1555090542661 addons.xpi ERROR Failed to process extension changes at startup: TypeError: addon._sourceBundle is undefined(resource://gre/modules/addons/XPIDatabase.jsm:2731:32) JS Stack trace: addonExists@XPIDatabase.jsm:2731:32
17:35:42 INFO - PID 3760 | processFileChanges@XPIDatabase.jsm:2836:13
17:35:42 INFO - PID 3760 | checkForChanges@XPIProvider.jsm:2719:55
17:35:42 INFO - PID 3760 | startup@XPIProvider.jsm:2265:12
17:35:42 INFO - PID 3760 | callProvider@AddonManager.jsm:200:31
17:35:42 INFO - PID 3760 | _startProvider@AddonManager.jsm:651:5
17:35:42 INFO - PID 3760 | startup@AddonManager.jsm:807:14
17:35:42 INFO - PID 3760 | startup@AddonManager.jsm:2801:26
17:35:42 INFO - PID 3760 | observe@addonManager.js:65:29
17:35:42 INFO - PID 3760 | ATTENTION: default value of option force_s3tc_enable overridden by environment.
17:35:42 INFO - PID 3760 | ATTENTION: default value of option force_s3tc_enable overridden by environment.
17:35:52 INFO - PID 3760 | console.error: "Attempt to set a remote URL http://localhost:8080/favicon.ico as a tab icon without a loading principal."
17:35:52 INFO - PID 3760 | console.error: "Attempt to set a remote URL http://localhost:8080/favicon.ico as a tab icon without a loading principal."
17:36:02 INFO - PID 3760 | ExceptionHandler::GenerateDump cloned child 4041
17:36:02 INFO - PID 3760 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
17:36:02 INFO - PID 3760 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
17:36:02 INFO - PID 3760 | Exiting due to channel error.
17:36:02 INFO - PID 3760 | Exiting due to channel error.
17:36:02 INFO - PID 3760 | Exiting due to channel error.
17:36:02 INFO - PID 3760 | Exiting due to channel error.
17:36:02 INFO - PID 3760 | Exiting due to channel error.
17:36:02 INFO - Terminating psutil.Process(pid=3760, name='firefox-bin', started='17:35:42')
17:36:02 INFO - TEST-INFO | 3760: exit 11
17:36:02 INFO - TEST-UNEXPECTED-ERROR | sessionrestore_many_windows | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
17:36:02 ERROR - Traceback (most recent call last):
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/run_tests.py", line 300, in run_tests
17:36:02 INFO - talos_results.add(mytest.runTest(browser_config, test))
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/ttest.py", line 64, in runTest
17:36:02 INFO - return self._runTest(browser_config, test_config, setup)
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/ttest.py", line 278, in _runTest
17:36:02 INFO - else None)
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/results.py", line 95, in add
17:36:02 INFO - global_counters=self.global_counters
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/results.py", line 326, in __init__
17:36:02 INFO - self.parse()
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/results.py", line 353, in parse
17:36:02 INFO - % self.report_tokens)
17:36:02 INFO - File "/home/cltbld/tasks/task_1555089874/build/tests/talos/talos/results.py", line 337, in error
17:36:02 INFO - raise utils.TalosError(message)
17:36:02 INFO - TalosError: Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
17:36:02 INFO - TEST-INFO took 35809ms
17:36:02 INFO - SUITE-END | took 35s
17:36:02 ERROR - Return code: 2
17:36:02 WARNING - setting return code to 2
17:36:02 ERROR - # TBPL FAILURE #
17:36:02 INFO - Running post-action listener: _package_coverage_data
17:36:02 INFO - Running post-action listener: _resource_record_post_action
17:36:02 INFO - Running post-action listener: process_java_coverage_data
17:36:02 INFO - [mozharness: 2019-04-12 17:36:02.805668Z] Finished run-tests step (success)
17:36:02 INFO - Running post-run listener: _resource_record_post_run
17:36:02 INFO - Total resource usage - Wall time: 43s; CPU: 5.0%; Read bytes: 10821632; Write bytes: 551239680; Read time: 408; Write time: 29100
17:36:02 INFO - TinderboxPrint: CPU usage<br/>4.5%

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

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