Closed Bug 877939 Opened 11 years ago Closed 10 years ago

Intermittent java-exception | java.lang.RuntimeException: Unable to start service com.mozilla.watcher.WatcherService@442ce890 with null: java.lang.NullPointerExceptionat android.app.ActivityThread.handleServiceArgs(ActivityThread.java:3063)

Categories

(Firefox for Android Graveyard :: General, defect)

ARM
Android
defect
Not set
normal

Tracking

(Not tracked)

RESOLVED WORKSFORME

People

(Reporter: RyanVM, Unassigned)

References

Details

(Keywords: crash, intermittent-failure)

Subsequent runs on this slave have been green.

https://tbpl.mozilla.org/php/getParsedLog.php?id=23613949&tree=Mozilla-Inbound

Android Tegra 250 mozilla-inbound opt test crashtest on 2013-05-30 15:59:58 PDT for push d921692be88f
slave: tegra-097

REFTEST TEST-START | http://10.250.49.160:30097/tests/dom/media/tests/crashtests/863929.html | 575 / 2461 (23%)

INFO | automation.py | Application ran for: 0:04:54.593807
INFO | zombiecheck | Reading PID log: /tmp/tmpmtZyEqpidlog
/data/anr/traces.txt not found
PROCESS-CRASH | java-exception | java.lang.RuntimeException: Unable to start service com.mozilla.watcher.WatcherService@442ce890 with null: java.lang.NullPointerExceptionat android.app.ActivityThread.handleServiceArgs(ActivityThread.java:3063)
WARNING | leakcheck | refcount logging is off, so leaks can't be detected!

REFTEST INFO | runreftest.py | Running tests: end.
Something is consuming all memory, causing Android to shut down processes:

06-02 12:58:45.519 I/ActivityManager( 1017): Process android.process.acore (pid 1258) has died.
06-02 12:58:51.479 I/SUTAgentAndroid( 1498): 10.250.49.156 : activity
06-02 12:58:53.119 I/ActivityManager( 1017): Process com.android.email (pid 1367) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process org.mozilla.f3nn3c.UpdateService (pid 1778) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.svox.pico (pid 1588) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.android.bluetooth (pid 1409) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.android.launcher (pid 1218) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.android.mms (pid 1388) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.android.music (pid 1441) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.android.quicksearchbox (pid 1454) has died.
06-02 12:58:53.129 I/ActivityManager( 1017): Process com.mozilla.watcher (pid 1431) has died.
06-02 12:58:53.159 W/ActivityManager( 1017): Scheduling restart of crashed service com.mozilla.watcher/.WatcherService in 5000ms
06-02 12:58:53.189 I/WindowManager( 1017): WIN DEATH: Window{443ffa78 com.android.launcher/com.android.launcher2.Launcher paused=false}
06-02 12:58:53.359 I/ActivityManager( 1017): Process android.process.media (pid 1340) has died.
06-02 12:58:53.359 I/WindowManager( 1017): WIN DEATH: Window{4448cb78 SurfaceView paused=false}
06-02 12:58:53.359 I/ActivityManager( 1017): Process com.cooliris.media (pid 1463) has died.
06-02 12:58:53.359 I/ActivityManager( 1017): Process com.android.deskclock (pid 1328) has died.
06-02 12:58:53.359 I/ActivityManager( 1017): Process com.android.settings (pid 1224) has died.
06-02 12:58:53.359 I/WindowManager( 1017): WIN DEATH: Window{44486998 org.mozilla.fennec/org.mozilla.fennec.App paused=false}
06-02 12:58:53.359 I/ActivityManager( 1017): Process com.android.providers.calendar (pid 1418) has died.
06-02 12:58:53.359 I/ActivityManager( 1017): Process com.android.defcontainer (pid 1550) has died.
06-02 12:58:53.359 I/ActivityManager( 1017): Low Memory: No more background processes.
06-02 12:58:53.359 I/ActivityManager( 1017): Process org.mozilla.fennec (pid 1706) has died.

I think there is another bug open for this...
See Also: → 689856
Most of these occur following low-memory conditions on a tegra. While a test is running, the system starts running low on memory and kills off processes. The watcher is killed and then it restarts 5 seconds later. On restart, a NullPointerException is thrown:

07-30 05:05:47.952 E/AndroidRuntime( 4371): Caused by: java.lang.NullPointerException
07-30 05:05:47.952 E/AndroidRuntime( 4371): 	at com.mozilla.watcher.WatcherService.handleCommand(WatcherService.java:160)
07-30 05:05:47.952 E/AndroidRuntime( 4371): 	at com.mozilla.watcher.WatcherService.onStartCommand(WatcherService.java:201)
07-30 05:05:47.952 E/AndroidRuntime( 4371): 	at android.app.ActivityThread.handleServiceArgs(ActivityThread.java:3053)
0

I think the NullPointerException was fixed in bug 789458, long, long ago...but that was never deployed because we never seem to get around to updating the watcher. There is hope: bug 876715.
Depends on: 876715
Geoff, any new ideas here? This and bug 807230 are pretty high up the OrangeFactor list on all branches.
Flags: needinfo?(gbrown)
(In reply to Ryan VanderMeulen [:RyanVM UTC-4] from comment #118)
> Geoff, any new ideas here? 

Comment 43 still applies. A watcher update should help -- likely "just" a few weeks away now. 

I notice that most of the recent failures are Tegra Armv6 and mochitest 5/6/7, so there is also a chance of tracking down a particular set of mochitests and/or underlying browser operation that is hogging memory -- but that doesn't look easy.
Flags: needinfo?(gbrown)
I disabled the dom-level* tests on Android this morning over in bug 910229. We'll see what impact that has once it merges around.
Closing inactive keywords:intermittent-failure bugs where the TBPLbot has previously commented and the test isn't marked as disabled; filter on orange-cleanup-201401.
Status: NEW → RESOLVED
Closed: 10 years ago
Resolution: --- → WORKSFORME
Product: Firefox for Android → Firefox for Android Graveyard
You need to log in before you can comment on or make changes to this bug.