Filed by: nerli [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=249202266&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/Hvp47wl-RpuqPiGYlJoLSg/runs/0/artifacts/public/logs/live_backing.log

[task 2019-05-30T18:39:35.684Z] 18:39:35 INFO - TEST-START | org.mozilla.geckoview.test.SessionLifecycleTest.readFromParcel_throwOnAlreadyOpen
[task 2019-05-30T18:41:40.673Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-30T18:41:40.674Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=140
[task 2019-05-30T18:41:40.674Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.SessionLifecycleTest
[task 2019-05-30T18:41:40.674Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-05-30T18:41:40.674Z] 18:41:40 INFO - org.mozilla.geckoview.test | Error in readFromParcel_throwOnAlreadyOpen(org.mozilla.geckoview.test.SessionLifecycleTest):
[task 2019-05-30T18:41:40.674Z] 18:41:40 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-05-30T18:41:40.675Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:56)
[task 2019-05-30T18:41:40.675Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-05-30T18:41:40.676Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-05-30T18:41:40.677Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.loopUntilIdle(UiThreadUtils.java:154)
[task 2019-05-30T18:41:40.677Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForInitialLoad(GeckoSessionTestRule.java:1314)
[task 2019-05-30T18:41:40.678Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForOpenSession(GeckoSessionTestRule.java:1263)
[task 2019-05-30T18:41:40.679Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.openSession(GeckoSessionTestRule.java:1259)
[task 2019-05-30T18:41:40.679Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.prepareStatement(GeckoSessionTestRule.java:1241)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$3$1.run(GeckoSessionTestRule.java:1421)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-05-30T18:41:40.685Z] 18:41:40 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | at dalvik.system.NativeStart.main(Native Method)
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test |
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=161
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-05-30T18:41:40.686Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:56)
[task 2019-05-30T18:41:40.687Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-05-30T18:41:40.687Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-05-30T18:41:40.687Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.loopUntilIdle(UiThreadUtils.java:154)
[task 2019-05-30T18:41:40.687Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForInitialLoad(GeckoSessionTestRule.java:1314)
[task 2019-05-30T18:41:40.687Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForOpenSession(GeckoSessionTestRule.java:1263)
[task 2019-05-30T18:41:40.688Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.openSession(GeckoSessionTestRule.java:1259)
[task 2019-05-30T18:41:40.688Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.prepareStatement(GeckoSessionTestRule.java:1241)
[task 2019-05-30T18:41:40.689Z] 18:41:40 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$3$1.run(GeckoSessionTestRule.java:1421)
[task 2019-05-30T18:41:40.690Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-05-30T18:41:40.690Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-05-30T18:41:40.690Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-05-30T18:41:40.691Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-05-30T18:41:40.692Z] 18:41:40 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-05-30T18:41:40.692Z] 18:41:40 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-05-30T18:41:40.693Z] 18:41:40 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-05-30T18:41:40.693Z] 18:41:40 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2019-05-30T18:41:40.694Z] 18:41:40 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2019-05-30T18:41:40.695Z] 18:41:40 INFO - org.mozilla.geckoview.test | at dalvik.system.NativeStart.main(Native Method)
[task 2019-05-30T18:41:40.695Z] 18:41:40 INFO - org.mozilla.geckoview.test |
[task 2019-05-30T18:41:40.696Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=readFromParcel_throwOnAlreadyOpen
[task 2019-05-30T18:41:40.697Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2019-05-30T18:41:40.697Z] 18:41:40 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.SessionLifecycleTest.readFromParcel_throwOnAlreadyOpen | status -2
[task 2019-05-30T18:41:40.697Z] 18:41:40 INFO - TEST-INFO took 125004ms
[task 2019-05-30T18:41:40.785Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-30T18:41:40.787Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=141
[task 2019-05-30T18:41:40.787Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.SessionLifecycleTest
[task 2019-05-30T18:41:40.788Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-05-30T18:41:40.788Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=161
[task 2019-05-30T18:41:40.788Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=restoreInstanceState_noSessionOntoClosedSession
[task 2019-05-30T18:41:40.789Z] 18:41:40 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1

This seems to be a regression from Bug 1424433 : https://tinyurl.com/y3vdklsl

jaws: could you please take a look at this?

A test disabling can't cause a different test to fail, except a reordering of tests exposes an issue due to inter-test dependencies.

This one looks like it started with bug 1549561.

There are 22 failures in the last 7 days on linux64 debug & asan as well as macosx1010-64 debug platforms: https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2019-06-08&endday=2019-06-15&tree=trunk&bug=1555778

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=251856474&repo=autoland&lineNumber=2476

[task 2019-06-14T10:01:44.671Z] 10:01:44 INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Found certificate chain -
[task 2019-06-14T10:01:44.671Z] 10:01:44 INFO - Leaving test bound checkAdvancedDetails
[task 2019-06-14T10:01:44.671Z] 10:01:44 INFO - Entering test bound checkAdvancedDetailsForHSTS
[task 2019-06-14T10:01:44.672Z] 10:01:44 INFO - Loading a bad STS cert page and verifying the advanced details section
[task 2019-06-14T10:01:44.672Z] 10:01:44 INFO - Buffered messages logged at 10:01:43
[task 2019-06-14T10:01:44.672Z] 10:01:44 INFO - Loading and waiting for the cert error
[task 2019-06-14T10:01:44.673Z] 10:01:44 INFO - Buffered messages finished
[task 2019-06-14T10:01:44.675Z] 10:01:44 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Correct error message found - Got , expected SSL_ERROR_BAD_CERT_DOMAIN
[task 2019-06-14T10:01:44.676Z] 10:01:44 INFO - Stack trace:
[task 2019-06-14T10:01:44.677Z] 10:01:44 INFO - chrome://mochikit/content/browser-test.js:test_is:1324
[task 2019-06-14T10:01:44.677Z] 10:01:44 INFO - chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:checkAdvancedDetailsForHSTS:199
[task 2019-06-14T10:01:44.677Z] 10:01:44 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1115
[task 2019-06-14T10:01:44.679Z] 10:01:44 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1143
[task 2019-06-14T10:01:44.680Z] 10:01:44 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1004
[task 2019-06-14T10:01:44.680Z] 10:01:44 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
[task 2019-06-14T10:01:44.681Z] 10:01:44 INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Error message is a link -
[task 2019-06-14T10:01:44.681Z] 10:01:44 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-06-14T10:01:44.681Z] 10:01:44 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Correct cert_domain_link contents found - Got , expected include-subdomains.pinning.example.com
[task 2019-06-14T10:01:44.682Z] 10:01:44 INFO - Stack trace:
[task 2019-06-14T10:01:44.683Z] 10:01:44 INFO - chrome://mochikit/content/browser-test.js:test_is:1324

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup