1496191 - Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/components/search/tests/xpcshell/test_big_icon.js | Test timed out

Status: RESOLVED FIXED

(Firefox :: Search, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: csabou [at] mozilla.com

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

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

15:15:03     INFO -  TEST-START | toolkit/components/search/tests/xpcshell/test_big_icon.js
15:20:03  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/components/search/tests/xpcshell/test_big_icon.js | Test timed out
15:20:03     INFO -  TEST-INFO took 300001ms
15:20:03     INFO -  >>>>>>>
15:20:03     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
15:20:03     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
15:20:03     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
15:20:03     INFO -  running event loop
15:20:03     INFO -  toolkit/components/search/tests/xpcshell/test_big_icon.js | Starting test_big_icon
15:20:03     INFO -  (xpcshell/head.js) | test test_big_icon pending (2)
15:20:03     INFO -  PID 8744 | *** Search: SearchService.init
15:20:03     INFO -  PID 8744 | *** Search: _asyncInit start
15:20:03     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) SearchService.init"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInit start"
15:20:03     INFO -  PID 8744 | *** Search: _asyncReadCacheFile: Error reading cache file: Win error 2 during operation open on file c:\\users\\task_1538578022\\appdata\\local\\temp\\xpc-profile-xdovsh\\search.json.mozlz4 (The system cannot find the file specified.
15:20:03     INFO -  PID 8744 | )
15:20:03     INFO -  PID 8744 | *** Search: _fetchRegion starting with endpoint
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadEngines: start
15:20:03     INFO -  PID 8744 | *** Search: _asyncFindJAREngines: looking for engines in JARs
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncReadCacheFile: Error reading cache file: Win error 2 during operation open on file c:\\users\\task_1538578022\\appdata\\local\\temp\\xpc-profile-xdovsh\\search.json.mozlz4 (The system cannot find the file specified.
15:20:03     INFO -  )"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _fetchRegion starting with endpoint "
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadEngines: start"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncFindJAREngines: looking for engines in JARs"
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadEngines: Absent or outdated cache. Loading engines from disk.
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/google.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/google.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadEngines: Absent or outdated cache. Loading engines from disk."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/google.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/google.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/google.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA..."
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA..." for engine "Google".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/amazondotcom.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/amazondotcom.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/google.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA...""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA..." for engine "Google"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/amazondotcom.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/amazondotcom.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/amazondotcom.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "resource://search-plugins/images/amazon.ico"
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "resource://search-plugins/images/amazon.ico" for engine "Amazon.com".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/bing.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/bing.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/amazondotcom.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "resource://search-plugins/images/amazon.ico""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "resource://search-plugins/images/amazon.ico" for engine "Amazon.com"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/bing.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/bing.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/bing.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAICAAAAEACACoCAAAJgAAABAQAAABAAgAaAUAAM4IAAAoAAAAIAAAAEAAAAABAAgAAAAAAIAEAAAAAAAAAAAAAAABAAAAAAAAhIQMAI+PIwC..."
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAICAAAAEACACoCAAAJgAAABAQAAABAAgAaAUAAM4IAAAoAAAAIAAAAEAAAAABAAgAAAAAAIAEAAAAAAAAAAAAAAABAAAAAAAAhIQMAI+PIwC..." for engine "Bing".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/ddg.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/ddg.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/bing.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAICAAAAEACACoCAAAJgAAABAQAAABAAgAaAUAAM4IAAAoAAAAIAAAAEAAAAABAAgAAAAAAIAEAAAAAAAAAAAAAAABAAAAAAAAhIQMAI+PIwC...""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAICAAAAEACACoCAAAJgAAABAQAAABAAgAaAUAAM4IAAAoAAAAIAAAAEAAAAABAAgAAAAAAIAEAAAAAAAAAAAAAAABAAAAAAAAhIQMAI+PIwC..." for engine "Bing"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/ddg.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/ddg.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/ddg.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "data:image/icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAATCwAAEwsAAAAAAAAAAAAAAAAAAAAAAAAAA..."
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "data:image/icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAATCwAAEwsAAAAAAAAAAAAAAAAAAAAAAAAAA..." for engine "DuckDuckGo".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/ebay.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/ebay.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/ddg.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "data:image/icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAATCwAAEwsAAAAAAAAAAAAAAAAAAAAAAAAAA...""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "data:image/icon;base64,AAABAAIAEBAAAAEAIABoBAAAJgAAACAgAAABACAAqBAAAI4EAAAoAAAAEAAAACAAAAABACAAAAAAAAAEAAATCwAAEwsAAAAAAAAAAAAAAAAAAAAAAAAAA..." for engine "DuckDuckGo"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/ebay.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/ebay.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/ebay.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "resource://search-plugins/images/ebay.ico"
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "resource://search-plugins/images/ebay.ico" for engine "eBay".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/twitter.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/twitter.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/ebay.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "resource://search-plugins/images/ebay.ico""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "resource://search-plugins/images/ebay.ico" for engine "eBay"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/twitter.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/twitter.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/twitter.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAEBAAAAAAAAALAgAAJgAAACAgAAAAAAAAQQQAADECAACJUE5HDQoaCgAAAA1JSERSAAAAEAAAABAIBgAAAB/z/2EAAAHSSURBVDjLfVO/axR..."
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAEBAAAAAAAAALAgAAJgAAACAgAAAAAAAAQQQAADECAACJUE5HDQoaCgAAAA1JSERSAAAAEAAAABAIBgAAAB/z/2EAAAHSSURBVDjLfVO/axR..." for engine "Twitter".
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/wikipedia.xml
15:20:03     INFO -  PID 8744 | *** Search: _asyncInitFromURI: Loading engine from: "resource://search-plugins/wikipedia.xml".
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/twitter.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "data:image/x-icon;base64,AAABAAIAEBAAAAAAAAALAgAAJgAAACAgAAAAAAAAQQQAADECAACJUE5HDQoaCgAAAA1JSERSAAAAEAAAABAIBgAAAB/z/2EAAAHSSURBVDjLfVO/axR...""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "data:image/x-icon;base64,AAABAAIAEBAAAAAAAAALAgAAJgAAACAgAAAAAAAAQQQAADECAACJUE5HDQoaCgAAAA1JSERSAAAAEAAAABAIBgAAAB/z/2EAAAHSSURBVDjLfVO/axR..." for engine "Twitter"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadFromChromeURLs: loading engine from chrome url: resource://search-plugins/wikipedia.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInitFromURI: Loading engine from: "resource://search-plugins/wikipedia.xml"."
15:20:03     INFO -  PID 8744 | *** Search: _init: Initing search plugin from jar:[app]/omni.ja!/wikipedia.xml
15:20:03     INFO -  PID 8744 | *** Search: _parseImage: Image textContent: "resource://search-plugins/images/wikipedia.ico"
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "resource://search-plugins/images/wikipedia.ico" for engine "Wikipedia (en)".
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "Google"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "Amazon.com"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "Bing"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "DuckDuckGo"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "eBay"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "Twitter"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "Wikipedia (en)"
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadEngines: loading user-installed engines from the obsolete cache
15:20:03     INFO -  PID 8744 | *** Search: _buildCache: Writing to cache file.
15:20:03     INFO -  PID 8744 | *** Search: _asyncLoadEngines: done using rebuilt cache
15:20:03     INFO -  PID 8744 | *** Search: _asyncInit: Completed _asyncInit
15:20:03     INFO -  TEST-PASS | toolkit/components/search/tests/xpcshell/test_big_icon.js | test_big_icon - [test_big_icon : 3696] true == true
15:20:03     INFO -  "Adding engine: BigIcon"
15:20:03     INFO -  PID 8744 | *** Search: NOTIFY: Engine: "BigIcon"; Verb: "engine-changed"
15:20:03     INFO -  "Observed engine-changed for BigIcon"
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Setting icon url "http://localhost:57837/data/big_icon.ico" for engine "BigIcon".
15:20:03     INFO -  PID 8744 | *** Search: _setIcon: Downloading icon: "http://localhost:57837/data/big_icon.ico" for engine: "BigIcon"
15:20:03     INFO -  PID 8744 | *** Search: _addEngineToStore: Adding engine: "BigIcon"
15:20:03     INFO -  PID 8744 | *** Search: NOTIFY: Engine: "BigIcon"; Verb: "engine-added"
15:20:03     INFO -  "Observed engine-added for BigIcon"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _init: Initing search plugin from jar:[app]/omni.ja!/wikipedia.xml"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _parseImage: Image textContent: "resource://search-plugins/images/wikipedia.ico""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "resource://search-plugins/images/wikipedia.ico" for engine "Wikipedia (en)"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "Google""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "Amazon.com""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "Bing""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "DuckDuckGo""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "eBay""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "Twitter""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "Wikipedia (en)""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadEngines: loading user-installed engines from the obsolete cache"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _buildCache: Writing to cache file."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncLoadEngines: done using rebuilt cache"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _asyncInit: Completed _asyncInit"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) NOTIFY: Engine: "BigIcon"; Verb: "engine-changed""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Setting icon url "http://localhost:57837/data/big_icon.ico" for engine "BigIcon"."
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _setIcon: Downloading icon: "http://localhost:57837/data/big_icon.ico" for engine: "BigIcon""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _addEngineToStore: Adding engine: "BigIcon""
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) NOTIFY: Engine: "BigIcon"; Verb: "engine-added""
15:20:03     INFO -  PID 8744 | *** Search: loadListener: Starting request: http://localhost:57837/data/big_icon.ico
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) loadListener: Starting request: http://localhost:57837/data/big_icon.ico"
15:20:03     INFO -  PID 8744 | *** Search: loadListener: Stopping request: http://localhost:57837/data/big_icon.ico
15:20:03     INFO -  PID 8744 | *** Search: iconLoadCallback: rescaling icon
15:20:03     INFO -  PID 8744 | *** Search: NOTIFY: Engine: "BigIcon"; Verb: "engine-changed"
15:20:03     INFO -  PID 8744 | JavaScript strict warning: Z:/task_1538578022/build/tests/xpcshell/tests/toolkit/components/search/tests/xpcshell/test_big_icon.js, line 12: ReferenceError: reference to undefined property "name"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) loadListener: Stopping request: http://localhost:57837/data/big_icon.ico"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) iconLoadCallback: rescaling icon"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) NOTIFY: Engine: "BigIcon"; Verb: "engine-changed""
15:20:03     INFO -  "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "ReferenceError: reference to undefined property "name"" {file: "Z:/task_1538578022/build/tests/xpcshell/tests/toolkit/components/search/tests/xpcshell/test_big_icon.js" line: 12}]"
15:20:03     INFO -  PID 8744 | *** Search: batchTask: Invalidating engine cache
15:20:03     INFO -  PID 8744 | *** Search: _buildCache: Writing to cache file.
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) batchTask: Invalidating engine cache"
15:20:03     INFO -  "CONSOLE_MESSAGE: (info) _buildCache: Writing to cache file."
15:20:03     INFO -  <<<<<<<
15:20:03     INFO -  mozcrash kill_pid(): wait failed (-1) terminating pid 8744: error 5
15:20:03     INFO -  xpcshell return code: None
15:20:03     INFO -  toolkit/components/search/tests/xpcshell/test_big_icon.js | Process still running after test!
15:20:03     INFO -  Failed to remove directory: c:\users\task_1538578022\appdata\local\temp\xpc-plugins-zdyjzw. Waiting.
15:20:04     INFO -  TEST-START | toolkit/components/telemetry/tests/unit/test_TelemetrySend.js
15:20:30     INFO -  TEST-PASS | toolkit/components/telemetry/tests/unit/test_TelemetrySend.js | took 26414ms
15:20:30     INFO -  TEST-START | toolkit/components/url-classifier/tests/unit/test_listmanager.js
15:20:32     INFO -  TEST-PASS | toolkit/components/url-classifier/tests/unit/test_listmanager.js | took 1326ms
15:20:32     INFO -  TEST-START | toolkit/components/url-classifier/tests/unit/test_pref.js
15:20:32     INFO -  TEST-PASS | toolkit/components/url-classifier/tests/unit/test_pref.js | took 148ms
15:20:32     INFO -  TEST-START | toolkit/components/url-classifier/tests/unit/test_malwaretable_pref.js
15:20:32     INFO -  TEST-PASS | toolkit/components/url-classifier/tests/unit/test_malwaretable_pref.js | took 152ms
15:20:32     INFO -  c:\users\task_1538578022\appdata\local\temp\xpc-profile-vaabyr could not be cleaned up.
15:20:32     INFO -  INFO | Result summary:
15:20:32     INFO -  INFO | Passed: 3186
15:20:32  WARNING -  INFO | Failed: 1
15:20:32  WARNING -  One or more unittests failed.
15:20:32     INFO -  INFO | Todo: 4
15:20:32     INFO -  INFO | Retried: 9
15:20:32     INFO -  SUITE-END | took 1545s
15:20:32     INFO -  Node moz-http2 server shutting down ...
15:20:32     INFO -  Process stderr
15:20:32     INFO -  (node:1032) Warning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
15:20:32     INFO -  (node:1032) Warning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
15:20:32     INFO -  (node:1032) Warning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
15:20:32     INFO -  (node:1032) Warning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
15:20:32    ERROR - Return code: 1

Comment 1

[Intermittent Failures Robot]

8 failures in 2708 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 2
* mozilla-beta: 1
* mozilla-central: 1
* try: 3
* mozilla-inbound: 1

Platform breakdown:
* windows7-32-devedition: 2
* windows10-64-nightly: 1
* windows10-64: 1
* windows7-32: 3
* windows7-32-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-10-01&endday=2018-10-07&tree=all

Comment 2

[Intermittent Failures Robot]

2 failures in 2740 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1
* mozilla-beta: 1

Platform breakdown:
* windows10-64-devedition: 1
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-10-08&endday=2018-10-14&tree=all

Comment 3

[Intermittent Failures Robot]

2 failures in 2759 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-beta: 2

Platform breakdown:
* windows7-32-devedition: 1
* windows10-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-10-15&endday=2018-10-21&tree=all

Comment 4

[Intermittent Failures Robot]

1 failures in 2584 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-10-22&endday=2018-10-28&tree=all

Comment 5

[Intermittent Failures Robot]

3 failures in 2978 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 3

Platform breakdown:
* windows7-32: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-10-29&endday=2018-11-04&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 3007 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-11-05&endday=2018-11-11&tree=all

Comment 7

[Intermittent Failures Robot]

3 failures in 2917 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1
* mozilla-release: 2

Platform breakdown:
* windows7-32-nightly: 2
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-11-12&endday=2018-11-18&tree=all

Comment 8

[Intermittent Failures Robot]

4 failures in 2387 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1
* autoland: 2
* mozilla-central: 1

Platform breakdown:
* windows7-32: 3
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-11-19&endday=2018-11-25&tree=all

Comment 9

[Intermittent Failures Robot]

17 failures in 477 pushes (0.036 failures/push) were associated with this bug yesterday.

Repository breakdown:
* autoland: 3
* mozilla-central: 1
* try: 13

Platform breakdown:
* windows7-32: 6
* linux64: 2
* windows10-64: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-11-29&endday=2018-11-29&tree=all

Comment 10

[Intermittent Failures Robot]

59 failures in 2808 pushes (0.021 failures/push) were associated with this bug in the last 7 days.

This is the #21 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. ** 

Repository breakdown:
* mozilla-inbound: 10
* autoland: 33
* mozilla-central: 3
* try: 13

Platform breakdown:
* linux64: 2
* windows10-64: 51
* windows7-32: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-11-26&endday=2018-12-02&tree=all

Comment 11

[Intermittent Failures Robot]

21 failures in 1862 pushes (0.011 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 6
* mozilla-beta: 2
* mozilla-inbound: 6
* autoland: 7

Platform breakdown:
* windows10-64-nightly: 2
* windows7-32: 1
* windows10-64: 17
* windows10-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-12-03&endday=2018-12-09&tree=all

Comment 12

[Intermittent Failures Robot]

16 failures in 2485 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* try: 2
* autoland: 11
* mozilla-inbound: 3

Platform breakdown:
* windows10-64: 15
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-12-10&endday=2018-12-16&tree=all

Comment 13

[Intermittent Failures Robot]

20 failures in 2648 pushes (0.008 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 6
* mozilla-beta: 3
* try: 1
* mozilla-inbound: 3
* autoland: 7

Platform breakdown:
* windows7-32-nightly: 2
* windows7-32: 1
* windows10-64: 14
* windows7-32-devedition: 1
* windows10-64-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-12-17&endday=2018-12-23&tree=all

Comment 14

[Intermittent Failures Robot]

15 failures in 1008 pushes (0.015 failures/push) were associated with this bug in the last 7 days.

This is the #48 most frequent failure this week.

Repository breakdown:
* mozilla-inbound: 6
* autoland: 6
* mozilla-central: 2
* try: 1

Platform breakdown:
* windows10-64: 14
* windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-12-24&endday=2018-12-30&tree=all

Comment 15

[Intermittent Failures Robot]

18 failures in 1668 pushes (0.011 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 2
* autoland: 11
* mozilla-beta: 3
* mozilla-central: 2

Platform breakdown:
* windows10-64: 10
* windows10-64-devedition: 2
* windows7-32: 5
* windows7-32-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2018-12-31&endday=2019-01-06&tree=all

Comment 16

[Intermittent Failures Robot]

6 failures in 2627 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 2
• mozilla-beta: 4

Platform breakdown:

• windows7-32-nightly: 1
• windows7-32-devedition: 2
• windows10-64-nightly: 2
• windows10-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-01-07&endday=2019-01-13&tree=all

Comment 17

[Intermittent Failures Robot]

19 failures in 2378 pushes (0.008 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 3
• mozilla-beta: 7
• mozilla-central: 1
• autoland: 5
• mozilla-inbound: 3

Platform breakdown:

• windows7-32-devedition: 2
• windows10-64-nightly: 3
• windows7-32: 2
• windows10-64: 7
• linux64: 1
• windows10-64-devedition: 2
• windows7-32-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-01-14&endday=2019-01-20&tree=all

Comment 18

[Intermittent Failures Robot]

48 failures in 2383 pushes (0.02 failures/push) were associated with this bug in the last 7 days.

This is the #20 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-inbound: 12
• mozilla-central: 6
• autoland: 24
• try: 4
• mozilla-release: 1
• mozilla-beta: 1

Platform breakdown:

• windows10-64-nightly: 2
• windows10-64-devedition: 4
• windows7-32-nightly: 1
• windows10-64: 40
• windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-01-21&endday=2019-01-27&tree=all

Comment 19

[Intermittent Failures Robot]

15 failures in 517 pushes (0.029 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 9
• mozilla-inbound: 3
• mozilla-central: 2
• mozilla-beta: 1

Platform breakdown:

• windows7-32: 1
• windows10-64: 12
• windows10-64-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-01-31&endday=2019-01-31&tree=all

Comment 20

[Intermittent Failures Robot]

51 failures in 2628 pushes (0.019 failures/push) were associated with this bug in the last 7 days.

This is the #34 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 34
• mozilla-inbound: 9
• try: 1
• mozilla-beta: 2
• mozilla-central: 5

Platform breakdown:

• windows7-32-devedition: 1
• windows10-64: 43
• windows7-32: 4
• windows10-64-nightly: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-01-28&endday=2019-02-03&tree=all

Comment 21

[Intermittent Failures Robot]

53 failures in 2658 pushes (0.02 failures/push) were associated with this bug in the last 7 days.

This is the #37 most frequent failure this week.

** This test has failed more than 150 times in the last 21 days. It should be disabled until it can be fixed. **

Repository breakdown:

• autoland: 25
• mozilla-beta: 5
• try: 1
• mozilla-inbound: 15
• mozilla-central: 7

Platform breakdown:

• windows10-64: 45
• windows7-32-nightly: 1
• windows7-32: 1
• windows10-64-devedition: 2
• windows10-64-nightly: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-02-04&endday=2019-02-10&tree=all

Comment 22

[Cristian Brindusan [:cbrindusan]]

Attachment: Bug 1496191 - Disable test_big_icon.js on windows10-64 pgo for frequent failures.

Comment 23

[Cristian Brindusan [:cbrindusan]]

In the last 7 days, there are 47 failures; most of them on windows-10-64 pgo.

I did some retriggers and it seems to start spiking from this push:
https://treeherder.mozilla.org/#/jobs?repo=autoland&searchStr=42c782c78d570d97353fcc2e64195841ade83735&tochange=0eae1c157b3e3642b4cabe1424923d761675c39b&fromchange=cfc581f4768c3a9424902541747e805749565e13

:mstriemer, can you please take a look?

I've added a patch to disable this test (in case we need it).

Comment 24

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/releases/mozilla-release/rev/7c7e75344134

Comment 25

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/d126abe75cf5
Disable test_big_icon.js on windows10-64 pgo for frequent failures. r=jmaher

Comment 26

[Bogdan Tara[:bogdan_tara | bogdant]]

https://hg.mozilla.org/mozilla-central/rev/d126abe75cf5

Comment 27

[Intermittent Failures Robot]

12 failures in 2832 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3
• try: 3
• mozilla-beta: 4
• mozilla-release: 2

Platform breakdown:

• windows10-64: 5
• windows7-32: 1
• windows10-64-devedition: 2
• windows10-64-nightly: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-02-11&endday=2019-02-17&tree=all

Comment 28

[Intermittent Failures Robot]

10 failures in 2602 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 10

Platform breakdown:

• windows10-64-devedition: 7
• windows10-64-nightly: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-02-18&endday=2019-02-24&tree=all

Comment 29

[Intermittent Failures Robot]

19 failures in 2981 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 15
• mozilla-release: 1
• autoland: 2
• mozilla-inbound: 1

Platform breakdown:

• windows10-64-devedition: 6
• windows7-32-nightly: 2
• windows10-64-nightly: 7
• windows7-32: 2
• linux64-pgo-qr: 1
• windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-02-25&endday=2019-03-03&tree=all

Comment 30

[Intermittent Failures Robot]

11 failures in 2818 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 11

Platform breakdown:

• windows10-64-devedition: 5
• windows10-64-nightly: 4
• windows7-32-nightly: 1
• windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-03-04&endday=2019-03-10&tree=all

Comment 31

[Intermittent Failures Robot]

8 failures in 2771 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 6
• mozilla-beta: 1
• try: 1

Platform breakdown:

• windows10-64-nightly: 5
• windows7-32-nightly: 2
• windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-03-11&endday=2019-03-17&tree=all

Comment 32

[Intermittent Failures Robot]

2 failures in 2561 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1
• try: 1

Platform breakdown:

• windows7-32: 1
• windows7-32-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-03-18&endday=2019-03-24&tree=all

Comment 33

[Intermittent Failures Robot]

4 failures in 3910 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1
• mozilla-release: 1
• mozilla-beta: 2

Platform breakdown:

• windows10-64: 1
• windows7-32-nightly: 2
• windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-03-25&endday=2019-03-31&tree=all

Comment 34

[Mark Banner (:standard8)]

I've been running tests locally and hitting this quite frequently (I believe). Locally it tends to timeout the first time, then runs the second time (automatically).

I've noticed this in the failure logs:

JavaScript strict warning: Z:/task_1553785326/build/tests/xpcshell/tests/toolkit/components/search/tests/xpcshell/test_big_icon.js, line 12: ReferenceError: reference to undefined property "name"

For most of our other observers for search engine items, we do a .QueryInterface(Ci.nsISearchEngine), so I think we need to do that here.

I suspect timing or something means that sometimes this has 'lost' its interface information and hence needs to be re-formed.

This seems to work for me locally, so I'll get it on try server.

Comment 35

[Mark Banner (:standard8)]

Try push: https://treeherder.mozilla.org/#/jobs?repo=try&revision=1d1ad8ed7b302b636917db2686bada089f383c4b

Comment 36

[Mark Banner (:standard8)]

Attachment: Bug 1496191 - When test_big_icon is listening for search engine modifications, ensure it QIs the engine to have the proper interface information. r?mikedeboer

Comment 37

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/abf4f3d3b075
When test_big_icon is listening for search engine modifications, ensure it QIs the engine to have the proper interface information. r=mikedeboer

Comment 38

[Andrei Ciure[:aciure]]

https://hg.mozilla.org/mozilla-central/rev/abf4f3d3b075

Comment 39

[Intermittent Failures Robot]

4 failures in 2843 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 2
• mozilla-central: 1
• mozilla-beta: 1

Platform breakdown:

• windows10-64-nightly: 2
• windows7-32: 1
• windows7-32-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-04-01&endday=2019-04-07&tree=all

Comment 40

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/releases/mozilla-beta/rev/dc1994aefb3d

Comment 41

[Intermittent Failures Robot]

2 failures in 3025 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 2

Platform breakdown:

• windows10-64-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-04-08&endday=2019-04-14&tree=all

Comment 42

[Intermittent Failures Robot]

1 failures in 3031 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 1

Platform breakdown:

• windows10-64-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1496191&startday=2019-04-22&endday=2019-04-28&tree=all