Closed Bug 1453109 Opened 6 years ago Closed 6 years ago

Intermittent browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | A promise chain failed to handle a rejection: ...stack: fetchHighlights@resource://activity-stream/lib/HighlightsFeed.jsm:163:27

Categories

(Firefox :: New Tab Page, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1450875

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: aiakab [at] mozilla.com

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

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

[task 2018-04-10T17:04:58.803Z] 17:04:58     INFO - TEST-START | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js
[task 2018-04-10T17:04:59.162Z] 17:04:59     INFO - GECKO(3261) | openContextMenuForContentSelector: found [object HTMLInputElement]
[task 2018-04-10T17:04:59.164Z] 17:04:59     INFO - GECKO(3261) | console.warn: LoginRecipes: getRecipes: falling back to a synchronous message for: http://mochi.test:8888
[task 2018-04-10T17:05:00.060Z] 17:05:00     INFO - GECKO(3261) | openContextMenuForContentSelector: found [object HTMLInputElement]
[task 2018-04-10T17:05:00.068Z] 17:05:00     INFO - GECKO(3261) | console.warn: LoginRecipes: getRecipes: falling back to a synchronous message for: http://mochi.test:8888
[task 2018-04-10T17:05:01.046Z] 17:05:01     INFO - GECKO(3261) | JavaScript error: resource://activity-stream/lib/HighlightsFeed.jsm, line 163: TypeError: this.store.getState(...).Sections.find(...) is undefined
[task 2018-04-10T17:05:01.047Z] 17:05:01     INFO - GECKO(3261) | JavaScript error: resource://activity-stream/lib/HighlightsFeed.jsm, line 163: TypeError: this.store.getState(...).Sections.find(...) is undefined
[task 2018-04-10T17:05:01.232Z] 17:05:01     INFO - TEST-INFO | started process screentopng
[task 2018-04-10T17:05:01.685Z] 17:05:01     INFO - TEST-INFO | screentopng: exit 0
[task 2018-04-10T17:05:01.686Z] 17:05:01     INFO - Buffered messages logged at 17:04:58
[task 2018-04-10T17:05:01.687Z] 17:05:01     INFO - Entering test bound 
[task 2018-04-10T17:05:01.690Z] 17:05:01     INFO - Buffered messages logged at 17:04:59
[task 2018-04-10T17:05:01.691Z] 17:05:01     INFO - wait for the context menu
[task 2018-04-10T17:05:01.693Z] 17:05:01     INFO - Console message: [JavaScript Error: "this._recipeManager is null" {file: "resource://gre/modules/LoginManagerParent.jsm" line: 84}]
[task 2018-04-10T17:05:01.694Z] 17:05:01     INFO - receiveMessage@resource://gre/modules/LoginManagerParent.jsm:84:9
[task 2018-04-10T17:05:01.695Z] 17:05:01     INFO - receiveMessage@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:248:15
[task 2018-04-10T17:05:01.696Z] 17:05:01     INFO - MessageListener.receiveMessage*init@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:263:7
[task 2018-04-10T17:05:01.696Z] 17:05:01     INFO - BG__beforeUIStartup@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:691:5
[task 2018-04-10T17:05:01.697Z] 17:05:01     INFO - BG_observe@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:389:9
[task 2018-04-10T17:05:01.698Z] 17:05:01     INFO - 
[task 2018-04-10T17:05:01.699Z] 17:05:01     INFO - withBookmarksDialog: opening the dialog
[task 2018-04-10T17:05:01.702Z] 17:05:01     INFO - withBookmarksDialog: waiting for the dialog
[task 2018-04-10T17:05:01.703Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | The bookmark properties dialog is open - 
[task 2018-04-10T17:05:01.705Z] 17:05:01     INFO - must wait for focus
[task 2018-04-10T17:05:01.706Z] 17:05:01     INFO - waiting for the overlay to be loaded
[task 2018-04-10T17:05:01.710Z] 17:05:01     INFO - waiting for focus on the first textfield
[task 2018-04-10T17:05:01.711Z] 17:05:01     INFO - withBookmarksDialog: executing the task
[task 2018-04-10T17:05:01.712Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | Accept button is disabled - true == true - 
[task 2018-04-10T17:05:01.713Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | Accept button is enabled - true == true - 
[task 2018-04-10T17:05:01.714Z] 17:05:01     INFO - Check the keyword entry has been created
[task 2018-04-10T17:05:01.715Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | keyword is correct - "kw" == "kw" - 
[task 2018-04-10T17:05:01.717Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | URL is correct - "http://mochi.test:8888/browser/browser/components/places/tests/browser/keyword_form.html" == "http://mochi.test:8888/browser/browser/components/places/tests/browser/keyword_form.html" - 
[task 2018-04-10T17:05:01.720Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | POST data is correct - "accenti%3D%E0%E8%EC%F2%F9&search%3D%25s" == "accenti%3D%E0%E8%EC%F2%F9&search%3D%25s" - 
[task 2018-04-10T17:05:01.722Z] 17:05:01     INFO - Check the charset has been saved
[task 2018-04-10T17:05:01.723Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | charset is correct - "windows-1252" == "windows-1252" - 
[task 2018-04-10T17:05:01.725Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | getShortcutOrURI POST data is correct - "accenti=àèìòù&search=test" == "accenti=àèìòù&search=test" - 
[task 2018-04-10T17:05:01.727Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | getShortcutOrURI URL is correct - "http://mochi.test:8888/browser/browser/components/places/tests/browser/keyword_form.html" == "http://mochi.test:8888/browser/browser/components/places/tests/browser/keyword_form.html" - 
[task 2018-04-10T17:05:01.728Z] 17:05:01     INFO - withBookmarksDialog: canceling the dialog
[task 2018-04-10T17:05:01.729Z] 17:05:01     INFO - Leaving test bound 
[task 2018-04-10T17:05:01.730Z] 17:05:01     INFO - Entering test bound reopen_same_field
[task 2018-04-10T17:05:01.732Z] 17:05:01     INFO - Buffered messages logged at 17:05:00
[task 2018-04-10T17:05:01.733Z] 17:05:01     INFO - wait for the context menu
[task 2018-04-10T17:05:01.734Z] 17:05:01     INFO - Console message: [JavaScript Error: "this._recipeManager is null" {file: "resource://gre/modules/LoginManagerParent.jsm" line: 84}]
[task 2018-04-10T17:05:01.735Z] 17:05:01     INFO - receiveMessage@resource://gre/modules/LoginManagerParent.jsm:84:9
[task 2018-04-10T17:05:01.736Z] 17:05:01     INFO - receiveMessage@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:248:15
[task 2018-04-10T17:05:01.738Z] 17:05:01     INFO - MessageListener.receiveMessage*init@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:263:7
[task 2018-04-10T17:05:01.739Z] 17:05:01     INFO - BG__beforeUIStartup@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:691:5
[task 2018-04-10T17:05:01.740Z] 17:05:01     INFO - BG_observe@jar:file:///builds/worker/workspace/build/application/firefox/browser/omni.ja!/components/nsBrowserGlue.js:389:9
[task 2018-04-10T17:05:01.741Z] 17:05:01     INFO - 
[task 2018-04-10T17:05:01.742Z] 17:05:01     INFO - withBookmarksDialog: opening the dialog
[task 2018-04-10T17:05:01.743Z] 17:05:01     INFO - withBookmarksDialog: waiting for the dialog
[task 2018-04-10T17:05:01.745Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | The bookmark properties dialog is open - 
[task 2018-04-10T17:05:01.746Z] 17:05:01     INFO - must wait for focus
[task 2018-04-10T17:05:01.747Z] 17:05:01     INFO - waiting for the overlay to be loaded
[task 2018-04-10T17:05:01.748Z] 17:05:01     INFO - waiting for focus on the first textfield
[task 2018-04-10T17:05:01.749Z] 17:05:01     INFO - withBookmarksDialog: executing the task
[task 2018-04-10T17:05:01.750Z] 17:05:01     INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | Accept button is disabled - 
[task 2018-04-10T17:05:01.751Z] 17:05:01     INFO - withBookmarksDialog: canceling the dialog
[task 2018-04-10T17:05:01.752Z] 17:05:01     INFO - Buffered messages logged at 17:05:01
[task 2018-04-10T17:05:01.753Z] 17:05:01     INFO - Console message: [JavaScript Error: "TypeError: this.store.getState(...).Sections.find(...) is undefined" {file: "resource://activity-stream/lib/HighlightsFeed.jsm" line: 163}]
[task 2018-04-10T17:05:01.754Z] 17:05:01     INFO - Console message: [JavaScript Error: "TypeError: this.store.getState(...).Sections.find(...) is undefined" {file: "resource://activity-stream/lib/HighlightsFeed.jsm" line: 163}]
[task 2018-04-10T17:05:01.755Z] 17:05:01     INFO - Buffered messages finished
[task 2018-04-10T17:05:01.756Z] 17:05:01     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | A promise chain failed to handle a rejection: this.store.getState(...).Sections.find(...) is undefined - stack: fetchHighlights@resource://activity-stream/lib/HighlightsFeed.jsm:163:27
[task 2018-04-10T17:05:01.756Z] 17:05:01     INFO - async*onAction@resource://activity-stream/lib/HighlightsFeed.jsm:217:9
[task 2018-04-10T17:05:01.757Z] 17:05:01     INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:49:11
[task 2018-04-10T17:05:01.757Z] 17:05:01     INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:28:55
[task 2018-04-10T17:05:01.758Z] 17:05:01     INFO - refresh@resource://activity-stream/lib/TopSitesFeed.jsm:180:7
[task 2018-04-10T17:05:01.758Z] 17:05:01     INFO - async*onAction@resource://activity-stream/lib/TopSitesFeed.jsm:377:9
[task 2018-04-10T17:05:01.759Z] 17:05:01     INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:49:11
[task 2018-04-10T17:05:01.760Z] 17:05:01     INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:28:55
[task 2018-04-10T17:05:01.760Z] 17:05:01     INFO - init@resource://activity-stream/lib/Store.jsm:136:7
[task 2018-04-10T17:05:01.761Z] 17:05:01     INFO - init@resource://activity-stream/lib/ActivityStream.jsm:289:7
[task 2018-04-10T17:05:01.761Z] 17:05:01     INFO - init@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/worker/workspace/build/application/firefox/browser/features/activity-stream@mozilla.org.xpi!/bootstrap.js:64:5
[task 2018-04-10T17:05:01.762Z] 17:05:01     INFO - onBrowserReady@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/worker/workspace/build/application/firefox/browser/features/activity-stream@mozilla.org.xpi!/bootstrap.js:121:3
[task 2018-04-10T17:05:01.763Z] 17:05:01     INFO - observe/<@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/worker/workspace/build/application/firefox/browser/features/activity-stream@mozilla.org.xpi!/bootstrap.js:147:46
[task 2018-04-10T17:05:01.763Z] 17:05:01     INFO - Rejection date: Tue Apr 10 2018 17:05:01 GMT+0000 (UTC) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 257
[task 2018-04-10T17:05:01.764Z] 17:05:01     INFO - Stack trace:
[task 2018-04-10T17:05:01.765Z] 17:05:01     INFO -     resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:257
[task 2018-04-10T17:05:01.765Z] 17:05:01     INFO -     chrome://mochikit/content/browser-test.js:Tester_execTest/<:1098
[task 2018-04-10T17:05:01.766Z] 17:05:01     INFO -     Tester_execTest@chrome://mochikit/content/browser-test.js:1067:9
[task 2018-04-10T17:05:01.767Z] 17:05:01     INFO -     Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:967:9
[task 2018-04-10T17:05:01.767Z] 17:05:01     INFO -     SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
[task 2018-04-10T17:05:01.768Z] 17:05:01     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-04-10T17:05:01.770Z] 17:05:01     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_bookmarkProperties_addKeywordForThisSearch.js | A promise chain failed to handle a rejection: this.store.getState(...).Sections.find(...) is undefined - stack: fetchHighlights@resource://activity-stream/lib/HighlightsFeed.jsm:163:27
[task 2018-04-10T17:05:01.770Z] 17:05:01     INFO - async*onAction@resource://activity-stream/lib/HighlightsFeed.jsm:217:9
[task 2018-04-10T17:05:01.771Z] 17:05:01     INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:49:11
[task 2018-04-10T17:05:01.772Z] 17:05:01     INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:28:55
[task 2018-04-10T17:05:01.773Z] 17:05:01     INFO - refresh@resource://activity-stream/lib/TopSitesFeed.jsm:183:7
[task 2018-04-10T17:05:01.774Z] 17:05:01     INFO - async*onAction@resource://activity-stream/lib/TopSitesFeed.jsm:390:9
Hi Activity Stream folks, would you mind having a look at this, please? Is AS racing with browser startup when running any test, or is it this bookmarks test in particular that's causing issues?
Component: Bookmarks & History → Activity Streams: Newtab
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE
Component: Activity Streams: Newtab → New Tab Page
You need to log in before you can comment on or make changes to this bug.