720064 - Intermittent Android crash in /tests/content/xml/document/test/test_bug691215.html after "Hey, we got here, that's good"

Status: RESOLVED WORKSFORME

(Firefox for Android Graveyard :: General, defect, P3)

Description

[Matt Brubeck (:mbrubeck)]

https://tbpl.mozilla.org/php/getParsedLog.php?id=8710737&tree=Mozilla-Inbound
Android Tegra 250 mozilla-inbound opt test mochitest-1 on 2012-01-20 17:02:29 PST for push 7afd96e2977e

17654 INFO TEST-START | /tests/content/xml/document/test/test_bug691215.html
17655 INFO TEST-PASS | /tests/content/xml/document/test/test_bug691215.html | Hey, we got here, that's good
17656 ERROR TEST-UNEXPECTED-FAIL | /tests/content/xml/document/test/test_bug691215.html | This test left crash dumps behind, but we weren't expecting it to!
17657 INFO TEST-INFO | Found unexpected crash dump file /mnt/sdcard/tests/profile/minidumps/6b30e3fe-9f9a-3ea5-766918c3-44aa6fd0.dmp.
17658 INFO TEST-END | /tests/content/xml/document/test/test_bug691215.html | finished in 3156ms
17659 INFO TEST-START | /tests/content/xml/document/test/test_viewport.xhtml
INFO | automation.py | Application ran for: 0:03:02.319898
INFO | automation.py | Reading PID log: /tmp/tmpBYPsZ8pidlog
getting files in '/mnt/sdcard/tests/profile/minidumps/'
PROCESS-CRASH | automation.py | application crashed (minidump found)
Crash dump filename: /tmp/tmpaFVHz3/6b30e3fe-9f9a-3ea5-766918c3-44aa6fd0.dmp
MINIDUMP_STACKWALK not set, can't process dump.
WARNING | automationutils.processLeakLog() | refcount logging is off, so leaks can't be detected!

INFO | runtests.py | Running tests: end.
removing file: /mnt/sdcard/tests/logs/mochitest.log
program finished with exit code 0
elapsedTime=212.511621

and https://tbpl.mozilla.org/php/getParsedLog.php?id=8709846&tree=Mozilla-Inbound
Android Tegra 250 mozilla-inbound opt test mochitest-1 on 2012-01-20 16:28:24 PST for push a862ba2711fd

17654 INFO TEST-START | /tests/content/xml/document/test/test_bug691215.html
17655 INFO TEST-PASS | /tests/content/xml/document/test/test_bug691215.html | Hey, we got here, that's good
INFO | automation.py | Application ran for: 0:02:34.846052
INFO | automation.py | Reading PID log: /tmp/tmpd93gm9pidlog
getting files in '/mnt/sdcard/tests/profile/minidumps/'
PROCESS-CRASH | automation.py | application crashed (minidump found)
Crash dump filename: /tmp/tmp4UlD0T/66865d01-6c5e-13a6-0f395cd6-7c40f7bc.dmp
MINIDUMP_STACKWALK not set, can't process dump.
WARNING | automationutils.processLeakLog() | refcount logging is off, so leaks can't be detected!

INFO | runtests.py | Running tests: end.
removing file: /mnt/sdcard/tests/logs/mochitest.log
program finished with exit code 0
elapsedTime=178.809865

Comment 1

[Kartikaya Gupta (email:[e-mail])]

The full logs for those failed runs contain this exception:

01-20 17:09:43.765 E/GeckoConsole( 1676): [JavaScript Warning: "Use of Document.load() is deprecated. To upgrade your code, use the DOM XMLHttpRequest object. For more help https://developer.mozilla.org/en/XMLHttpRequest" {file: "about:blank" line: 0}]
01-20 17:09:45.565 E/GeckoTab( 1676): Requested title update on empty history stack
01-20 17:09:45.925 E/GeckoApp( 1676): top level exception
01-20 17:09:45.925 E/GeckoApp( 1676): java.lang.NullPointerException
01-20 17:09:45.925 E/GeckoApp( 1676): 	at org.mozilla.gecko.BrowserToolbar.setProgressVisibility(BrowserToolbar.java:257)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at org.mozilla.gecko.GeckoApp$23.run(GeckoApp.java:1211)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Handler.handleCallback(Handler.java:587)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Handler.dispatchMessage(Handler.java:92)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Looper.loop(Looper.java:123)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at org.mozilla.gecko.GeckoApp$31.run(GeckoApp.java:1556)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Handler.handleCallback(Handler.java:587)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Handler.dispatchMessage(Handler.java:92)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.os.Looper.loop(Looper.java:123)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at android.app.ActivityThread.main(ActivityThread.java:4627)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at java.lang.reflect.Method.invokeNative(Native Method)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at java.lang.reflect.Method.invoke(Method.java:521)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:868)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:626)
01-20 17:09:45.925 E/GeckoApp( 1676): 	at dalvik.system.NativeStart.main(Native Method)
01-20 17:09:46.248 E/GeckoConsole( 1676): [JavaScript Error: "this.browser is null" {file: "chrome://browser/content/browser.js" line: 2000}]
01-20 17:09:47.348 W/InputManagerService( 1017): Got RemoteException sending setActive(false) notification to pid 1676 uid 10033


which points the blame at this line:

https://hg.mozilla.org/integration/mozilla-inbound/file/7afd96e2977e/mobile/android/base/BrowserToolbar.java#l257

The Tabs.java code has changed enough since then (particularly in https://hg.mozilla.org/mozilla-central/rev/fcec3385530b) that this error probably won't happen again. Not sure if this bug should be closed or not though.

Comment 2

[Legacy TBPL/Treeherder Robot]

mfinkle%mozilla.com
https://tbpl.mozilla.org/php/getParsedLog.php?id=12573136&tree=Mozilla-Beta
Android Tegra 250 mozilla-beta opt test mochitest-1 on 2012-06-11 20:25:19
slave: tegra-217

17868 ERROR TEST-UNEXPECTED-FAIL | /tests/content/xml/document/test/test_bug691215.html | Test timed out.
17879 INFO TEST-UNEXPECTED-FAIL | /tests/content/xslt/tests/mochitest/test_bug319374.xhtml | finished in a non-clean fashion (in /tests/content/xml/document/test/test_viewport.xhtml)

Comment 3

[Phil Ringnalda (:philor)]

Yeah, it should be closed.