1560417 - Intermittent browser/components/urlbar/tests/browser/browser_inputHistory.js | Test timed out -

Status: RESOLVED FIXED

(Firefox :: Address Bar, defect, P3)

Description

[Treeherder Bug Filer]

Filed by: nerli [at] mozilla.com
Full log: https://queue.taskcluster.net/v1/task/ecOarjpiQ2yOZ4-SFBsuig/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://queue.taskcluster.net/v1/task/ecOarjpiQ2yOZ4-SFBsuig/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=252672003&repo=autoland

---

20:01:34 INFO - Console message: [JavaScript Error: "getScreenshot(http://site.tld/2) failed: TypeError: NetworkError when attempting to fetch resource." {file: "resource://activity-stream/lib/Screenshots.jsm" line: 45}]
20:01:34 INFO - getScreenshotForURL@resource://activity-stream/lib/Screenshots.jsm:45:10
20:01:34 INFO - asyncmaybeCacheScreenshot@resource://activity-stream/lib/Screenshots.jsm:98:37
20:01:34 INFO - _fetchScreenshot@resource://activity-stream/lib/TopSitesFeed.jsm:431:23
20:01:34 INFO - _fetchIcon@resource://activity-stream/lib/TopSitesFeed.jsm:419:16
20:01:34 INFO - getLinksWithDefaults@resource://activity-stream/lib/TopSitesFeed.jsm:322:16
20:01:34 INFO - asyncrefresh@resource://activity-stream/lib/TopSitesFeed.jsm:345:30
20:01:34 INFO - onAction@resource://activity-stream/lib/TopSitesFeed.jsm:654:14
20:01:34 INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:51:17
20:01:34 INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:29:54
20:01:34 INFO - customDispatch/this.placesChangedTimer<@resource://activity-stream/lib/PlacesFeed.jsm:203:22
20:01:34 INFO -
20:01:34 INFO - Buffered messages finished
20:01:34 INFO - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/browser/browser_inputHistory.js | Test timed out -
20:01:34 INFO - GECKO(3120) | [Parent 1656, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x19e7f5c0 (http://mzl.la/1FuID0j).: file z:/build/build/src/storage/mozStoragePrivateHelpers.cpp, line 108
20:01:34 INFO - GECKO(3120) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 110: uncaught exception: Object
20:01:34 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 110}]
20:01:34 INFO - GECKO(3120) | MEMORY STAT | vsize 857MB | vsizeMaxContiguous 468MB | residentFast 278MB | heapAllocated 92MB
20:01:34 INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_inputHistory.js | took 90165ms
20:01:34 INFO - GECKO(3120) | ++DOCSHELL 00F62800 == 1 [pid = 4984] [id = {cea419e0-4395-46aa-a7eb-fa6297ad6feb}]
20:01:34 INFO - GECKO(3120) | [Child 4984, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/widget/windows/nsLookAndFeel.cpp, line 853
20:01:34 INFO - GECKO(3120) | ++DOMWINDOW == 1 (00FBB280) [pid = 4984] [serial = 1] [outer = 00000000]
20:01:34 INFO - GECKO(3120) | [Child 4984, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
20:01:34 INFO - GECKO(3120) | [Child 4984, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
20:01:34 INFO - checking window state
20:01:34 INFO - GECKO(3120) | ++DOMWINDOW == 2 (00F6AC00) [pid = 4984] [serial = 2] [outer = 00FBB280]
20:01:34 INFO - GECKO(3120) | ++DOMWINDOW == 18 (0E7D3400) [pid = 1656] [serial = 20] [outer = 117FD940]
20:01:34 INFO - GECKO(3120) | [Child 4984, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file z:/build/build/src/widget/windows/nsLookAndFeel.cpp, line 481
20:01:34 INFO - GECKO(3120) | ++DOMWINDOW == 19 (0F00E000) [pid = 1656] [serial = 21] [outer = 117FD940]
20:01:34 INFO - GECKO(3120) | --DOMWINDOW == 1 (00876040) [pid = 4324] [serial = 1] [outer = 00000000] [url = about:blank]
20:01:34 INFO - GECKO(3120) | --DOCSHELL 00862800 == 0 [pid = 4324] [id = {df26020b-56f8-4e7b-bd8d-92ff05df218e}] [url = about:blank]
20:01:34 INFO - GECKO(3120) | --DOMWINDOW == 0 (0086AC00) [pid = 4324] [serial = 2] [outer = 00000000] [url = about:blank]
20:01:34 INFO - GECKO(3120) | --DOCSHELL 00962C00 == 0 [pid = 1228] [id = {ad93c015-c3f8-4caf-87b7-ac6eb221455f}] [url = about:newtab]
20:01:34 INFO - GECKO(3120) | --DOMWINDOW == 1 (009C8280) [pid = 1228] [serial = 1] [outer = 00000000] [url = about:newtab]
20:01:34 INFO - GECKO(3120) | --DOMWINDOW == 0 (083B8400) [pid = 1228] [serial = 3] [outer = 00000000] [url = about:newtab]
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 5632
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 4984
20:01:36 INFO - GECKO(3120) | --DOMWINDOW == 18 (152B8400) [pid = 1656] [serial = 14] [outer = 00000000] [url = about:blank]
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 3016
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 5368
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 4324
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 3836
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 4904
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 4392
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 3996
20:01:36 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 1228
20:01:38 INFO - GECKO(3120) | --DOMWINDOW == 17 (0E7D3400) [pid = 1656] [serial = 20] [outer = 00000000] [url = about:blank]
20:01:39 INFO - GECKO(3120) | Completed ShutdownLeaks collections in process 1656

Comment 1

[Noemi Erli[:noemi_erli]]

This stared while Bug 1559686 landed: https://treeherder.mozilla.org/#/jobs?repo=autoland&selectedJob=252676238&resultStatus=testfailed%2Cbusted%2Cexception&revision=c8b11404e7a11df5e546030ae5c03729560b64ca&searchStr=TV

Comment 2

[Marco Bonardo [:mak]]

We may want to split the test into 2, that at least would solve the "This test exceeded the timeout threshold. It should be rewritten or split up". Though it won't solve the "hard" timeout case. That seems to always happen in test_adaptive_mouse anyway.

Comment 3

[Marco Bonardo [:mak]]

I can investigate this, so that in the future it won't happen, but likely we'll uplift the patch as-is because it's quite critical for us. We can uplift test fixes later, if necessary.

Comment 4

[Cosmin Sabou [:CosminS]]

This is a tier 1 failure now: https://treeherder.mozilla.org/#/jobs?repo=autoland&selectedJob=253006025&resultStatus=testfailed%2Cbusted%2Cexception&revision=f7addc19e0ae6fb0f14a99d493e11eaab4725952&searchStr=os%2Cx%2C10.10%2Cdebug%2Cmochitests%2Ctest-macosx1010-64%2Fdebug-mochitest-browser-chrome-e10s-10%2Cm%28bc10%29

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 8
• try: 1
• mozilla-inbound: 1

Platform breakdown:

• windows7-32: 3
• macosx1014-64-shippable: 1
• macosx1014-64: 1
• linux64: 1
• macosx1010-64-shippable: 1
• macosx1010-64: 3

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

Comment 6

[Marco Bonardo [:mak]]

It was expected, TV is an indication of possible future failures.

This timeout is in test_adaptive_mouse, as the previous ones, it looks like the click is not properly handled.

Comment 7

[Intermittent Failures Robot]

45 failures in 4409 pushes (0.01 failures/push) were associated with this bug in the last 7 days.

** 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
• try: 5
• mozilla-esr68: 2
• mozilla-central: 4
• autoland: 23
• mozilla-beta: 1

Platform breakdown:

• macosx1010-64-shippable: 3
• windows10-64-qr: 8
• macosx1010-64: 5
• windows10-64-ccov: 1
• linux64: 20
• windows10-64: 1
• windows7-32: 4
• linux32: 1
• windows10-64-shippable-qr: 1
• macosx1014-64-shippable: 1

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

Comment 8

[Andreea Pavel [:apavel]]

There are 38 total failures in the last 7 days on linux64 asan, macosx1010-64 debug, windows7-32 debug.

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

23:03:26 INFO - TEST-START | browser/components/urlbar/tests/browser/browser_inputHistory.js
23:03:26 INFO - GECKO(2146) | [Parent 2146, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x12826d550 (http://mzl.la/1FuID0j).: file /builds/worker/workspace/build/src/storage/mozStoragePrivateHelpers.cpp, line 108

23:06:26 INFO - Console message: [JavaScript Error: "[Exception... "Component returned failure code: 0x804b0002 (NS_BINDING_ABORTED) [nsIWebNavigation.loadURI]" nsresult: "0x804b0002 (NS_BINDING_ABORTED)" location: "JS frame :: resource://gre/actors/WebNavigationChild.jsm :: loadURI/< :: line 139" data: no]"]
23:06:26 INFO - loadURI/<@resource://gre/actors/WebNavigationChild.jsm:139:33
23:06:26 INFO - _wrapURIChangeCall@resource://gre/actors/WebNavigationChild.jsm:55:7
23:06:26 INFO - loadURI@resource://gre/actors/WebNavigationChild.jsm:138:10
23:06:26 INFO - receiveMessage@resource://gre/actors/WebNavigationChild.jsm:39:14
23:06:26 INFO - receiveMessage@resource://gre/modules/ActorManagerChild.jsm:165:30
23:06:26 INFO - MessageListener.receiveMessage*init@resource://gre/modules/ActorManagerChild.jsm:53:15
23:06:26 INFO - attach@resource://gre/modules/ActorManagerChild.jsm:317:48
23:06:26 INFO - @chrome://global/content/browser-content.js:14:19
23:06:26 INFO -
23:06:26 INFO - Buffered messages finished
23:06:26 INFO - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/browser/browser_inputHistory.js | Test timed out -
23:06:26 INFO - GECKO(2146) | [Parent 2146, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x12826d550 (http://mzl.la/1FuID0j).: file /builds/worker/workspace/build/src/storage/mozStoragePrivateHelpers.cpp, line 108
23:06:26 INFO - GECKO(2146) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 110: uncaught exception: Object
23:06:26 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 110}]
23:06:26 INFO - GECKO(2146) | MEMORY STAT | vsize 5589MB | residentFast 380MB | heapAllocated 101MB
23:06:26 INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_inputHistory.js | took 180312ms

Marco are there any updates here?

Comment 9

[Edwin Takahashi (:egao | infrequent contributor)]

This test is one of the blockers for the migration from macosx1010 to macosx1014 for mochitest-browser-chrome.

Comment 10

[Marco Bonardo [:mak]]

we can disable the test on 10.14 if necessary, we have other tests disabled there for unknown reasons.

Comment 11

[Andreea Pavel [:apavel]]

Attachment: Bug 1560417 - disabled browser_inputHistory.js on mac 10.14 for blocking bug 1558328 r=egao

Comment 12

[Intermittent Failures Robot]

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

** 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-esr68: 1
• autoland: 23
• mozilla-inbound: 6
• mozilla-central: 5
• try: 3

Platform breakdown:

• macosx1010-64: 8
• windows10-64-shippable: 2
• linux64: 14
• windows10-64: 1
• linux64-ccov: 2
• windows10-64-qr: 5
• macosx1014-64-shippable: 1
• macosx1014-64: 1
• windows7-32: 4

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

Comment 13

[Marco Bonardo [:mak]]

Attachment: Bug 1560417 - Intermittent timeout in browser_inputHistory.js - beta patch. r=dao

Comment 14

[Marco Bonardo [:mak]]

This is failing when quantum bar is disabled, afaict, thus bug 1551233 will solve this, anyway. We just need to think what to do in Beta.

Comment 15

[Andreea Pavel [:apavel]]

@sheriffs Don't land disabling patch, wait for developer's good to go.

Comment 16

[Marco Bonardo [:mak]]

the patch removing legacy mochitests landed on autoland.
I'm looking into a patch that we can uplift to beta...

Comment 17

[Marco Bonardo [:mak]]

Please push my patch to beta (NOT the disabling patch).

Comment 18

[Marco Bonardo [:mak]]

This should be fixed in central/autoland anyway, by bug 1551233.
We just need to land the beta patch.

Comment 19

[Andrei Ciure[:aciure]]

https://hg.mozilla.org/releases/mozilla-beta/rev/469b176bd4b4

Comment 20

[Edwin Takahashi (:egao | infrequent contributor)]

I ran mochitest-browser-chrome on macosx1014 recently in both shippable and debug configuration:

https://treeherder.mozilla.org/#/jobs?repo=try&group_state=expanded&revision=2d01f0f33c46fd0edf879eb38c6034192c039274

I was not able to reproduce this failure.

18:57:42     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_inputHistory.js
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:43     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:44     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:45     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:46     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:47     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:48     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:49     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:50     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:51     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:52     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:53     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:54     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:55     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:56     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:57     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:58     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:57:59     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:00     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:01     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:02     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:03     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:04     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:05     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:06     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/0
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/0
18:58:07     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/0
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/3
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/3
18:58:08     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/3
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/4
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/4
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/4
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/5
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/5
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/5
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/6
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/6
18:58:09     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/6
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/7
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/7
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/7
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/8
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/8
18:58:10     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/8
18:58:11     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/9
18:58:11     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/9
18:58:11     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/9
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:12     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:13     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/1
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/1
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/1
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:14     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://site.tld/2
18:58:15     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://site.tld/2
18:58:15     INFO - GECKO(1840) | MEMORY STAT | vsize 7810MB | residentFast 487MB | heapAllocated 178MB
18:58:15     INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_inputHistory.js | took 32950ms
18:58:15     INFO - checking window state
18:58:15     INFO - GECKO(1840) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 112: uncaught exception: Object
18:58:15     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_inputHistory_emptystring.js
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:16     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:17     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:18     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:19     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:20     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:20     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:20     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:21     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Waiting for URL: http://example.com/
18:58:21     INFO - GECKO(1840) | waitForDocLoadAndStopIt: onStateChange f0001:http://example.com/
18:58:21     INFO - GECKO(1840) | waitForDocLoadAndStopIt: Document start: http://example.com/
18:58:21     INFO - GECKO(1840) | MEMORY STAT | vsize 7826MB | residentFast 489MB | heapAllocated 184MB
18:58:21     INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_inputHistory_emptystring.js | took 5454ms

Comment 21

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 15
• try: 1

Platform breakdown:

• linux64: 10
• macosx1010-64: 6

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

Comment 22

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr68: 1

Platform breakdown:

• linux64: 1

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

Comment 23

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/releases/mozilla-esr68/rev/711287a1b63d