Closed Bug 1434590 Opened 2 years ago Closed 2 years ago

Intermittent browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]" nsresult: "0x80520015

Categories

(WebExtensions :: General, defect)

defect
Not set

Tracking

(Not tracked)

RESOLVED FIXED

People

(Reporter: intermittent-bug-filer, Assigned: rpl)

References

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell fixed:product])

Attachments

(2 files)

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=159562179&repo=autoland

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

12:47:47     INFO -  476 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js
12:47:47     INFO -  TEST-INFO | started process screenshot
12:47:47     INFO -  TEST-INFO | screenshot: exit 0
12:47:47     INFO -  Buffered messages logged at 12:47:47
12:47:47     INFO -  477 INFO Entering test bound testLastAccessed
12:47:47     INFO -  Buffered messages finished
12:47:47    ERROR -  478 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:47     INFO -  Stack trace:
12:47:47     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:47     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:47     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:47     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:47     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:47     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:47     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:47     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:47     INFO -      testLastAccessed@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js:11:19
12:47:47     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:47     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:47     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:47     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:47     INFO -  479 INFO Leaving test bound testLastAccessed
12:47:47     INFO -  GECKO(5936) | MEMORY STAT | vsize 1152MB | vsizeMaxContiguous 297MB | residentFast 490MB | heapAllocated 190MB
12:47:47     INFO -  480 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | took 219ms
12:47:47     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:47    ERROR -  481 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | Found an unexpected tab at the end of test run: https://example.com/?2 -
12:47:47     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:47    ERROR -  482 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | Found an unexpected tab at the end of test run: https://example.com/?1 -
12:47:47     INFO -  483 INFO checking window state
12:47:47     INFO -  484 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js
12:47:47     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:47     INFO -  Buffered messages logged at 12:47:47
12:47:47     INFO -  485 INFO Entering test bound
12:47:47     INFO -  486 INFO TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js | The tab is pending restore -
12:47:47     INFO -  487 INFO TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js | The tab is lazy -
12:47:47     INFO -  Buffered messages finished
12:47:47    ERROR -  488 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:47     INFO -  Stack trace:
12:47:47     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:47     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:47     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:47     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:47     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:47     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:47     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:47     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:47     INFO -      @chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_lazy.js:33:21
12:47:47     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:47     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:47     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:47     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:47     INFO -  489 INFO Leaving test bound
12:47:47     INFO -  GECKO(5936) | MEMORY STAT | vsize 1152MB | vsizeMaxContiguous 297MB | residentFast 491MB | heapAllocated 191MB
12:47:47     INFO -  490 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js | took 70ms
12:47:47     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:47    ERROR -  491 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lazy.js | Found an unexpected tab at the end of test run: https://example.com/ -
12:47:47     INFO -  492 INFO checking window state
12:47:47     INFO -  493 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js
12:47:48     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:48     INFO -  Buffered messages logged at 12:47:47
12:47:48     INFO -  494 INFO Entering test bound moveMultiple
12:47:48     INFO -  Buffered messages finished
12:47:48    ERROR -  495 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:48     INFO -  Stack trace:
12:47:48     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:48     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:48     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:48     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:48     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:48     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:48     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:48     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:48     INFO -      moveMultiple@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_move_array.js:12:19
12:47:48     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:48     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:48     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:48     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:48     INFO -  496 INFO Leaving test bound moveMultiple
12:47:48     INFO -  GECKO(5936) | MEMORY STAT | vsize 1178MB | vsizeMaxContiguous 297MB | residentFast 482MB | heapAllocated 158MB
12:47:48     INFO -  497 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | took 1254ms
12:47:48     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:48    ERROR -  498 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | Found an unexpected tab at the end of test run: http://example.com/?4 -
12:47:48     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:48    ERROR -  499 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | Found an unexpected tab at the end of test run: http://example.com/?3 -
12:47:48     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:48    ERROR -  500 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | Found an unexpected tab at the end of test run: http://example.com/?2 -
12:47:48     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:48    ERROR -  501 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_array.js | Found an unexpected tab at the end of test run: http://example.com/?1 -
12:47:48     INFO -  502 INFO checking window state
12:47:48     INFO -  503 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js
12:47:50     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:50     INFO -  Buffered messages logged at 12:47:48
12:47:50     INFO -  504 INFO Entering test bound
12:47:50     INFO -  Buffered messages finished
12:47:50    ERROR -  505 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:50     INFO -  Stack trace:
12:47:50     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:50     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:50     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:50     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:50     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:50     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:50     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:50     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:50     INFO -      @chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_move_window.js:10:19
12:47:50     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:50     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:50     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:50     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:50     INFO -  506 INFO Leaving test bound
12:47:50     INFO -  507 INFO Entering test bound test_currentWindowAfterTabMoved
12:47:50     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:50    ERROR -  508 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:50     INFO -  Stack trace:
12:47:50     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:50     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:50     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:50     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:50     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:50     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:50     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:50     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:50     INFO -      test_currentWindowAfterTabMoved@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_move_window.js:79:21
12:47:50     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:50     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:50     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:50     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:50     INFO -  509 INFO Leaving test bound test_currentWindowAfterTabMoved
12:47:50     INFO -  GECKO(5936) | MEMORY STAT | vsize 1170MB | vsizeMaxContiguous 297MB | residentFast 487MB | heapAllocated 183MB
12:47:50     INFO -  510 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js | took 1037ms
12:47:50     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:50    ERROR -  511 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js | Found an unexpected tab at the end of test run: http://example.net/ -
12:47:50     INFO -  512 INFO checking window state
12:47:50     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:50    ERROR -  513 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window.js | Found an unexpected browser window at the end of test run -
12:47:50     INFO -  GECKO(5936) | must wait for focus
12:47:50     INFO -  514 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js
12:47:51     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:51     INFO -  Buffered messages logged at 12:47:50
12:47:51     INFO -  515 INFO Entering test bound
12:47:51     INFO -  Buffered messages finished
12:47:51    ERROR -  516 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:51     INFO -  Stack trace:
12:47:51     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:51     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:51     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:51     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:51     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:51     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:51     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:51     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:51     INFO -      @chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js:12:19
12:47:51     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:51     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:51     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:51     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:51     INFO -  517 INFO Leaving test bound
12:47:51     INFO -  GECKO(5936) | MEMORY STAT | vsize 1188MB | vsizeMaxContiguous 297MB | residentFast 497MB | heapAllocated 188MB
12:47:51     INFO -  518 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js | took 1434ms
12:47:51     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:51    ERROR -  519 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js | Found an unexpected tab at the end of test run: http://example.com/ -
12:47:51     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:51    ERROR -  520 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js | Found an unexpected tab at the end of test run: http://example.net/ -
12:47:51     INFO -  521 INFO checking window state
12:47:51     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:51    ERROR -  522 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_multiple.js | Found an unexpected browser window at the end of test run -
12:47:51     INFO -  GECKO(5936) | must wait for focus
12:47:51     INFO -  523 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js
12:47:52     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:52     INFO -  Buffered messages logged at 12:47:51
12:47:52     INFO -  524 INFO Entering test bound
12:47:52     INFO -  Buffered messages finished
12:47:52    ERROR -  525 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:52     INFO -  Stack trace:
12:47:52     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:52     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:52     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:52     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:52     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:52     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:52     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:52     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:52     INFO -      @chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js:11:19
12:47:52     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:52     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:52     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:52     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:52     INFO -  526 INFO Leaving test bound
12:47:52     INFO -  GECKO(5936) | MEMORY STAT | vsize 1170MB | vsizeMaxContiguous 297MB | residentFast 491MB | heapAllocated 192MB
12:47:52     INFO -  527 INFO TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js | took 826ms
12:47:52     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:52    ERROR -  528 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js | Found an unexpected tab at the end of test run: http://example.net/ -
12:47:52     INFO -  529 INFO checking window state
12:47:52     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:52    ERROR -  530 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_move_window_pinned.js | Found an unexpected browser window at the end of test run -
12:47:52     INFO -  GECKO(5936) | must wait for focus
12:47:52     INFO -  531 INFO TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_onHighlighted.js
12:47:52     INFO -  Not taking screenshot here: see the one that was previously logged
12:47:52     INFO -  Buffered messages logged at 12:47:52
12:47:52     INFO -  532 INFO Entering test bound testTabEvents
12:47:52     INFO -  Buffered messages finished
12:47:52    ERROR -  533 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_onHighlighted.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]
12:47:52     INFO -  Stack trace:
12:47:52     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:268:5
12:47:52     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:260:12
12:47:52     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:354:16
12:47:52     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:581:25
12:47:52     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
12:47:52     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
12:47:52     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2089:5
12:47:52     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
12:47:52     INFO -      testTabEvents@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_tabs_onHighlighted.js:171:19
12:47:52     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1065:21
12:47:52     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1056:9
12:47:52     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:956:9
12:47:52     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
12:47:52     INFO -  534 INFO Leaving test bound testTabEvents
12:47:52     INFO -  GECKO(5936) | MEMORY STAT | vsize 1135MB | vsizeMaxContiguous 297MB | residentFast 467MB | heapAllocated 182MB
Depends on: 1435100
There have been 40 failures in the last 7 days.

Occurrences per platform:
Windows 7: 29
windows10-64: 11

Occurrences per build:
debug: 19
pgo: 16
opt: 5

Here is a recent log file and a snippet with the failure:
https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=160020957

05:05:34     INFO -  TEST-INFO | started process screenshot
05:05:35     INFO -  TEST-INFO | screenshot: exit 0
05:05:35     INFO -  Buffered messages logged at 05:05:34
05:05:35     INFO -  1181 INFO Entering test bound testLastAccessed
05:05:35     INFO -  Buffered messages finished
05:05:35    ERROR -  1182 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 268"  data: no]

Depends on: 1435100
Flags: needinfo?(amckay)
There are 99 failures in the last week. Most of them on Windows 7 pgo/ debug, windows10-64 pgo/ debug, some on windows10-64-ccov debug, windows7-32-nightly opt, one occurrence on windows10-64-devedition opt, windows10-64-nightly opt and windows7-32-devedition opt.

Recent log failure: https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=161529507

Relevant part of the log: 
17:43:10     INFO -  Buffered messages logged at 17:43:09
17:43:10     INFO -  630 INFO Entering test bound testLastAccessed
17:43:10     INFO -  Buffered messages finished
17:43:10    ERROR -  631 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lastAccessed.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 266"  data: no]
17:43:10     INFO -  Stack trace:
17:43:10     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:266:5
17:43:10     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:258:12
17:43:10     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:352:16
17:43:10     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:573:25
17:43:10     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
17:43:10     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
17:43:10     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2085:5
17:43:10     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
17:43:10     INFO -      testLastAccessed@chrome://mochitests/content/browser/browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lastAccessed.js:11:19
17:43:10     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1067:21
17:43:10     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1058:9
17:43:10     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:958:9
17:43:10     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
17:43:10     INFO -  632 INFO Leaving test bound testLastAccessed
17:43:10     INFO -  GECKO(996) | MEMORY STAT | vsize 2099592MB | vsizeMaxContiguous 128422478MB | residentFast 626MB | heapAllocated 163MB
17:43:10     INFO -  633 INFO TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lastAccessed.js | took 645ms
17:43:10     INFO -  Not taking screenshot here: see the one that was previously logged
17:43:10    ERROR -  634 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lastAccessed.js | Found an unexpected tab at the end of test run: https://example.com/?2 -
17:43:10     INFO -  Not taking screenshot here: see the one that was previously logged
17:43:10    ERROR -  635 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lastAccessed.js | Found an unexpected tab at the end of test run: https://example.com/?1 -
17:43:10     INFO -  GECKO(996) | ++DOCSHELL 0000017460B95800 == 3 [pid = 4284] [id = {3f2dd1e9-cf67-4e7f-836d-7148620714bd}]
17:43:10     INFO -  GECKO(996) | ++DOMWINDOW == 6 (000001745D1A28C0) [pid = 4284] [serial = 54] [outer = 0000000000000000]
17:43:10     INFO -  636 INFO checking window state
17:43:10     INFO -  GECKO(996) | ++DOMWINDOW == 7 (0000017461F31C00) [pid = 4284] [serial = 55] [outer = 000001745D1A28C0]
17:43:10     INFO -  637 INFO TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js
17:43:10     INFO -  GECKO(996) | ++DOCSHELL 0000015B1BAE5000 == 2 [pid = 2472] [id = {cfe02752-d152-4a58-bddd-a475caad82af}]
17:43:10     INFO -  GECKO(996) | ++DOMWINDOW == 14 (0000015B1BAA0200) [pid = 2472] [serial = 414] [outer = 0000000000000000]
17:43:10     INFO -  GECKO(996) | ++DOMWINDOW == 15 (0000015B1FA25C00) [pid = 2472] [serial = 415] [outer = 0000015B1BAA0200]
17:43:10     INFO -  Not taking screenshot here: see the one that was previously logged
17:43:10     INFO -  Buffered messages logged at 17:43:10
17:43:10     INFO -  638 INFO Entering test bound
17:43:10     INFO -  639 INFO TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js | The tab is pending restore -
17:43:10     INFO -  640 INFO TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js | The tab is lazy -
17:43:10     INFO -  Buffered messages finished
17:43:10    ERROR -  641 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js | Uncaught exception - [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.createUnique]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://testing-common/ExtensionTestCommon.jsm :: generateZipFile :: line 266"  data: no]
17:43:10     INFO -  Stack trace:
17:43:10     INFO -      generateZipFile@resource://testing-common/ExtensionTestCommon.jsm:266:5
17:43:10     INFO -      generateXPI@resource://testing-common/ExtensionTestCommon.jsm:258:12
17:43:10     INFO -      generate@resource://testing-common/ExtensionTestCommon.jsm:352:16
17:43:10     INFO -      _receiveMessageAPI@chrome://mochikit/content/tests/SimpleTest/SpecialPowersObserverAPI.js:573:25
17:43:10     INFO -      ChromePowers.prototype._receiveMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:83:14
17:43:10     INFO -      ChromePowers.prototype._sendAsyncMessage@chrome://mochikit/content/tests/SimpleTest/ChromePowers.js:45:3
17:43:10     INFO -      loadExtension@chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js:2085:5
17:43:10     INFO -      ExtensionTestUtils.loadExtension@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:105:19
17:43:10     INFO -      @chrome://mochitests/content/browser/browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js:33:21
17:43:10     INFO -      Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1067:21
17:43:10     INFO -      Tester_execTest@chrome://mochikit/content/browser-test.js:1058:9
17:43:10     INFO -      Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:958:9
17:43:10     INFO -      SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59
17:43:10     INFO -  642 INFO Leaving test bound
17:43:10     INFO -  GECKO(996) | ++DOMWINDOW == 16 (0000015B1DE9C000) [pid = 2472] [serial = 416] [outer = 0000015B1BAA0200]
17:43:10     INFO -  GECKO(996) | MEMORY STAT | vsize 2099577MB | vsizeMaxContiguous 128422478MB | residentFast 616MB | heapAllocated 159MB
17:43:10     INFO -  643 INFO TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js | took 148ms
17:43:10     INFO -  Not taking screenshot here: see the one that was previously logged
17:43:10    ERROR -  644 INFO TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_tabs_lazy.js | Found an unexpected tab at the end of test run: https://example.com/ -

:ddurst, Could you please take a look?
Flags: needinfo?(ddurst)
Attached patch bug1434590.patchSplinter Review
I've made a patch to disable this test that is failing frequently on Windows. Could you please review it?

 [browser_ext_tabs_hide.js]
 [browser_ext_tabs_insertCSS.js]
 [browser_ext_tabs_lastAccessed.js]
+skip-if = os == 'win' # Bug 1434590
 [browser_ext_tabs_lazy.js]
 [browser_ext_tabs_removeCSS.js]
 [browser_ext_tabs_move_array.js]
Attachment #8950072 - Flags: review?(jmaher)
Attachment #8950072 - Flags: review?(gbrown)
Comment on attachment 8950072 [details] [diff] [review]
bug1434590.patch

Review of attachment 8950072 [details] [diff] [review]:
-----------------------------------------------------------------

That looks fine - thanks!
Attachment #8950072 - Flags: review?(jmaher)
Attachment #8950072 - Flags: review?(gbrown)
Attachment #8950072 - Flags: review+
Pushed by gbrown@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/ce3478941993
disable browser/components/extensions/test/browser/browser_ext_tabs_lastAccessed.js for frequent failures r=gbrown
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Flags: needinfo?(amckay)
Comment on attachment 8955462 [details]
Bug 1434590 - Re-enabled browser_ext_tabs_lastAccessed.js test on Windows.

https://reviewboard.mozilla.org/r/224624/#review230632

::: browser/components/extensions/test/browser/browser-common.ini
(Diff revision 1)
>  [browser_ext_tabs_getCurrent.js]
>  [browser_ext_tabs_hide.js]
>  [browser_ext_tabs_hide_update.js]
>  [browser_ext_tabs_insertCSS.js]
>  [browser_ext_tabs_lastAccessed.js]
> -skip-if = os == 'win' # Bug 1434590

Hi Joel,
this intermittent test (disabled in Comment 12) should have been now fixed by Bug 1435100, and we'd like to re-enable it.

(like described in a bit more detail in Bug 1434777 comment 17, while testing the fix landed by Bug 143100 I've re-enabled this test to check that the changes introduced by Bug 1435100 were also fixing the high intermittency of this test).
Comment on attachment 8955462 [details]
Bug 1434590 - Re-enabled browser_ext_tabs_lastAccessed.js test on Windows.

https://reviewboard.mozilla.org/r/224626/#review230638

excited to see tests re-enabled!
Attachment #8955462 - Flags: review?(jmaher) → review+
Pushed by luca.greco@alcacoop.it:
https://hg.mozilla.org/integration/autoland/rev/486b8df0c3aa
Re-enabled browser_ext_tabs_lastAccessed.js test on Windows. r=jmaher
Assignee: nobody → lgreco
Status: NEW → ASSIGNED
Flags: needinfo?(ddurst)
Whiteboard: [stockwell disabled] → [stockwell]
Status: ASSIGNED → RESOLVED
Closed: 2 years ago
Keywords: leave-open
Resolution: --- → FIXED
Whiteboard: [stockwell] → [stockwell fixed:product]
Product: Toolkit → WebExtensions
You need to log in before you can comment on or make changes to this bug.