https://tbpl.mozilla.org/php/getParsedLog.php?id=45773605&tree=Mozilla-Inbound Ubuntu VM 12.04 mozilla-inbound debug test mochitest-browser-chrome-1 on 2014-08-12 11:17:19 PDT for push d4e83c4992aa slave: tst-linux32-spot-521 11:32:06 INFO - 10794 INFO TEST-PASS | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | waitForDocLoadAndStopIt: The expected URL was loaded - waitForDocLoadAndStopIt: The expected URL was loaded 11:32:06 INFO - 10795 INFO TEST-PASS | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | Pref should have the correct state. - Pref should have the correct state. 11:32:06 INFO - 10796 INFO waitForDocLoadAndStopIt: Waiting for URL: http://localhost./ 11:32:06 INFO - 10797 INFO waitForDocLoadAndStopIt: onStateChange: http://localhost./ 11:32:06 INFO - 10798 INFO waitForDocLoadAndStopIt: Document start: http://localhost./ 11:32:06 INFO - 10799 INFO TEST-PASS | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | waitForDocLoadAndStopIt: The expected URL was loaded - waitForDocLoadAndStopIt: The expected URL was loaded 11:32:06 INFO - 10800 INFO Console message: [JavaScript Error: "chrome://browser/content/browser.xul : Unable to run script because scripts are blocked internally."] 11:32:06 INFO - 10801 INFO Console message: [JavaScript Error: "chrome://browser/content/browser.xul : Unable to run script because scripts are blocked internally."] 11:32:06 INFO - 10802 INFO TEST-PASS | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | We are expecting to not get a notification - We are expecting to not get a notification 11:32:06 INFO - 10803 INFO Leaving test test_navigate_single_host 11:32:06 INFO - 10804 INFO Entering test test_navigate_single_host 11:32:06 INFO - 10805 INFO Console message: [JavaScript Error: "chrome://browser/content/browser.xul : Unable to run script because scripts are blocked internally."] 11:32:06 INFO - 10806 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10807 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10808 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10809 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10810 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10811 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10812 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10813 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10814 INFO Console message: [JavaScript Warning: "setting a property that has only a getter"] 11:32:06 INFO - 10815 INFO waitForDocLoadAndStopIt: Waiting for URL: https://www.google.com/search?q=localhost&ie=utf-8&oe=utf-8&aq=t&rls=org.mozilla:en-US:unofficial&client=firefox-a&channel=fflb 11:32:06 INFO - 10816 INFO Console message: [JavaScript Error: "chrome://browser/content/browser.xul : Unable to run script because scripts are blocked internally."] 11:32:06 INFO - 10817 INFO Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key="c" modifiers="accel,alt"" {file: "chrome://mochikit/content/tests/SimpleTest/specialpowersAPI.js" line: 150}] 11:32:06 INFO - 10818 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | Test timed out - Test timed out 11:32:06 INFO - TEST-INFO | expected PASS 11:32:06 INFO - 10819 INFO TEST-OK | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | took 46515ms 11:32:06 INFO - 10820 INFO ++DOCSHELL 0x76a7f400 == 19 [pid = 1764] [id = 957] 11:32:06 INFO - 10821 INFO ++DOMWINDOW == 76 (0x79135380) [pid = 1764] [serial = 2477] [outer = (nil)] 11:32:06 INFO - 10822 INFO ++DOMWINDOW == 77 (0x79135570) [pid = 1764] [serial = 2478] [outer = 0x79135380] 11:32:06 INFO - 10823 INFO [1764] WARNING: NS_ENSURE_TRUE(mMutable) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/netwerk/base/src/nsSimpleURI.cpp, line 265 11:32:06 INFO - 10824 INFO dumping last 1 message(s) 11:32:06 INFO - 10825 INFO if you need more context, please use SimpleTest.requestCompleteLog() in your test 11:32:06 INFO - 10826 INFO checking window state 11:32:06 INFO - 10827 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/base/content/test/general/browser_urlbarSearchSingleWordNotification.js | Found a browser window after previous test timed out - Found a browser window after previous test timed out 11:32:06 INFO - TEST-INFO | expected PASS

This correlates much too nicely with bug 1048513 landing. :-\ Not super sure what's specifically causing it, though... Alex, do you have time to look into this further?

remote: https://hg.mozilla.org/integration/fx-team/rev/018c774d1b2d

not sure if it's going to help, but you might want to pass true as third param to waitForFocus, since we stop all documents load.

bug actually, looks like it's timing out here waitForDocLoadAndStopIt: Waiting for URL: https://www.google.com/search?q=localhost&ie=utf-8&oe=utf-8&aq=t&rls=org.mozilla:en-US:unofficial&client=firefox-a&channel=fflb usually you'd get waitForDocLoadAndStopIt: onStateChange but there's nothing like that, so the progress listener is not invoked. Something related to the pb window maybe.

or maybe you should focus the window before trying to synthesizekey, you only focusing the urlbar

(In reply to Marco Bonardo [:mak] (Away 15-31 Aug) from comment #8) > or maybe you should focus the window before trying to synthesizekey, you > only focusing the urlbar There's a waitForFocus call in the code that closes the private window.

(In reply to :Gijs Kruitbosch (intermittently here 14-15 August; then away until 19th) from comment #9) > (In reply to Marco Bonardo [:mak] (Away 15-31 Aug) from comment #8) > > or maybe you should focus the window before trying to synthesizekey, you > > only focusing the urlbar > > There's a waitForFocus call in the code that closes the private window. but it's not focusing the window after opening it.

(In reply to Marco Bonardo [:mak] (Away 15-31 Aug) from comment #10) > (In reply to :Gijs Kruitbosch (intermittently here 14-15 August; then away > until 19th) from comment #9) > > (In reply to Marco Bonardo [:mak] (Away 15-31 Aug) from comment #8) > > > or maybe you should focus the window before trying to synthesizekey, you > > > only focusing the urlbar > > > > There's a waitForFocus call in the code that closes the private window. > > but it's not focusing the window after opening it. As we discussed on IRC, I was confused. The failures we saw in bug 1048513 were related to the test for "mozilla is awesome", and not the "localhost" test for private windows itself, which is the one causing these intermittents. I agree that hopefully a waitForFocus for the newly opened window will help... although as Marco said, "focus is fancy, especially on Linux". I'll write something up and test locally before pushing to fx-team - it seems try is AWOL right now. :-\

remote: https://hg.mozilla.org/integration/fx-team/rev/3d567782f210

https://hg.mozilla.org/mozilla-central/rev/018c774d1b2d https://hg.mozilla.org/mozilla-central/rev/3d567782f210

Hi Gijs, can you provide a point value for this bug.

This seems fixed to me, too - no more intermittents since the latest fix. :-)