Appium Selendroid failure (1.2.4)

Appium server

$ appium --session-override --selendroid-port 8082
info: Welcome to Appium v1.2.4 (REV 71584425ecf777349e3215f0f18e71e7782acfb6)
info: Appium REST http interface listener started on 0.0.0.0:4723
info: [debug] Non-default server args: {"sessionOverride":true,"selendroidPort":8082}
info: Console LogLevel: debug
info: --> POST /wd/hub/session {"desiredCapabilities":{"automationName":"Selendroid","app":"/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk","platformVersion":"4.0","deviceName":"Android Device","platformName":"Android","appActivity":"com.foo.activity.LaunchActivity","appPackage":"com.fooapp"}}
info: [debug] Using local app from desired caps: /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Creating new appium session 8631cab9-05da-4562-b311-de26216e6a27
info: [debug] Starting selendroid server
info: [debug] Checking whether selendroid is built yet
info: [debug] Selendroid server exists!
info: [debug] Preparing device for session
info: [debug] Checking whether app is actually present
info: [debug] Checking whether adb is present
info: [debug] Using adb from /Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb
info: Retrieving device
info: [debug] Trying to find a connected android device
info: [debug] Getting connected devices...
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" devices
info: [debug] 1 device(s) connected
info: Found device 014E23850C00F007
info: [debug] Setting device id to 014E23850C00F007
info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 5)
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 wait-for-device
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "echo 'ready'"
info: [debug] Starting logcat capture
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from /Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt
info: [debug] hasInternetPermissionFromManifest: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt" dump badging "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk"
info: [debug] Rebuilt selendroid server already exists, no need to rebuild it with a new manifest
info: [debug] Checking signed status of /tmp/selendroid.com.fooapp.apk
info: [debug] Checking app cert for /tmp/selendroid.com.fooapp.apk: java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/verify.jar" "/tmp/selendroid.com.fooapp.apk"
info: [debug] Checking signed status of /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Checking app cert for /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk: java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/verify.jar" "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk"
info: [debug] App already signed.
info: [debug] Zip-aligning /tmp/selendroid.com.fooapp.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from /Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign" -f 4 "/tmp/selendroid.com.fooapp.apk" "/var/folders/dh/t2np5cvs53371kc1ypxm0f540000gp/T/appium11496-72028-1hyh7qi.tmp"
info: [debug] App already signed.
info: [debug] Zip-aligning /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from /Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign" -f 4 "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/var/folders/dh/t2np5cvs53371kc1ypxm0f540000gp/T/appium11496-72028-tc8v40.tmp"
info: [debug] Rebuilt selendroid apk does not exist, uninstalling any instances of it on device to make way for new one
info: [debug] Uninstalling com.fooapp.selendroid
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "am force-stop com.fooapp.selendroid"
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 uninstall com.fooapp.selendroid
info: [debug] App was uninstalled
info: [debug] Getting install status for com.fooapp.selendroid
info: [debug] Getting device API level
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 18
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "pm list packages -3 com.fooapp.selendroid"
info: [debug] App is not installed
info: [debug] Rebuilt selendroid is not installed, installing it
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 install -r "/tmp/selendroid.com.fooapp.apk"
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "getprop persist.sys.language"
info: [debug] Current device language: en
info: [debug] java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/appium_apk_tools.jar" "stringsFromApk" "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/tmp/com.fooapp" en
info: [debug] No strings.xml for language 'en', getting default strings.xml
info: [debug] java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/appium_apk_tools.jar" "stringsFromApk" "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/tmp/com.fooapp"
info: [debug] Not uninstalling app since server not started with --full-reset
info: [debug] Checking app cert for /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk: java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/verify.jar" "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk"
info: [debug] App already signed.
info: [debug] Zip-aligning /Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from /Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign" -f 4 "/Users/lkung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/var/folders/dh/t2np5cvs53371kc1ypxm0f540000gp/T/appium11496-72028-bs75oh.tmp"
info: [debug] MD5 for app is a8174a8ae857766905685f62deba1720
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "ls /data/local/tmp/a8174a8ae857766905685f62deba1720.apk"
info: [debug] Getting install status for com.fooapp
info: [debug] Getting device API level
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 18
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "pm list packages -3 com.fooapp"
info: [debug] App is installed
info: App is already installed, resetting app
info: [debug] Running fast reset (stop and clear)
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "am force-stop com.fooapp"
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "pm clear com.fooapp"
info: [debug] Forwarding system:8082 to device:8080
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 forward tcp:8082 tcp:8080
info: [debug] Pushing settings apk to device...
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 install "/usr/local/lib/node_modules/appium/build/settings_apk/settings_apk-debug.apk"
info: [debug] Pushing unlock helper app to device...
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 install "/usr/local/lib/node_modules/appium/build/unlock_apk/unlock_apk-debug.apk"
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "dumpsys window"
info: [debug] Writing dumpsys output to /usr/local/lib/node_modules/appium/.dumpsys.log
info: [debug] Screen already unlocked, continuing.
info: [debug] executing: "/Users/lkung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s 014E23850C00F007 shell "am instrument -e main_activity 'com.foo.activity.LaunchActivity' com.fooapp.selendroid/io.selendroid.ServerInstrumentation"
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8082/wd/hub/status","method":"GET"}
info: [debug] Cleaning up appium session
error: Failed to start an Appium session, err was: Error: Waited 20 secs for selendroid server and it never showed up
info: [debug] Error: Waited 20 secs for selendroid server and it never showed up
    at /usr/local/lib/node_modules/appium/lib/devices/android/selendroid.js:338:14
    at Request._callback (/usr/local/lib/node_modules/appium/lib/devices/common.js:116:5)
    at self.callback (/usr/local/lib/node_modules/appium/node_modules/request/request.js:121:22)
    at Request.EventEmitter.emit (events.js:95:17)
    at ClientRequest.self.clientErrorHandler (/usr/local/lib/node_modules/appium/node_modules/request/request.js:230:10)
    at ClientRequest.EventEmitter.emit (events.js:95:17)
    at Socket.socketOnEnd [as onend] (http.js:1568:9)
    at Socket.g (events.js:180:16)
    at Socket.EventEmitter.emit (events.js:117:20)
    at _stream_readable.js:920:16
info: [debug] Responding to client with error: {"status":33,"value":{"message":"A new session could not be created. (Original error: Waited 20 secs for selendroid server and it never showed up)","origValue":"Waited 20 secs for selendroid server and it never showed up"},"sessionId":null}
info: <-- POST /wd/hub/session 500 36207.874 ms - 240 

logcat

D/AndroidRuntime(10043): 
D/AndroidRuntime(10043): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10043): CheckJNI is OFF
D/dalvikvm(10043): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10043): Added shared lib libjavacore.so 0x0
D/dalvikvm(10043): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10043): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10043): Calling main entry com.android.commands.am.Am
D/dalvikvm(10043): Note: class Landroid/app/ActivityManagerNative; has 163 unimplemented (abstract) methods
D/AndroidRuntime(10043): Shutting down VM
D/jdwp    (10043): Got wake-up signal, bailing out of select
D/dalvikvm(10043): Debugger has detached; object registry had 1 entries
I/ActivityManager(  394): Force stopping package com.fooapp.selendroid appid=10065 user=0
D/AndroidRuntime(10054): 
D/AndroidRuntime(10054): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10054): CheckJNI is OFF
D/dalvikvm(10054): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10054): Added shared lib libjavacore.so 0x0
D/dalvikvm(10054): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10054): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10054): Calling main entry com.android.commands.pm.Pm
I/ActivityManager(  394): Force stopping package com.fooapp.selendroid appid=10065 user=-1
W/PackageManager(  394): Couldn't delete native library directory /data/app-lib/com.fooapp.selendroid
D/keystore(  130): calling clear_uid in state: 3
I/ActivityManager(  394): Force stopping package com.fooapp.selendroid appid=10065 user=0
I/InputReader(  394): Reconfiguring input devices.  changes=0x00000010
D/VoicemailCleanupService( 8413): Cleaning up data for package: com.fooapp.selendroid
W/PluginManager( 4979): Can't find plugin: com.fooapp.selendroid
W/ContextImpl( 9721): Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1385 android.content.ContextWrapper.startService:473 android.content.ContextWrapper.startService:473 com.android.keychain.KeyChainBroadcastReceiver.onReceive:12 android.app.ActivityThread.handleReceiver:2424 
I/LatinIME:LogUtils(  549): Dictionary info: dictionary = main:en_us ; version = 47 ; date = 1402373181
I/LatinIME:LogUtils(  549): Dictionary info: dictionary = main:en_us ; version = 47 ; date = 1402373181
D/dalvikvm(  606): GC_CONCURRENT freed 339K, 6% free 9299K/9840K, paused 2ms+2ms, total 31ms
D/BackupManagerService(  394): Received broadcast Intent { act=android.intent.action.PACKAGE_REMOVED dat=package:com.fooapp.selendroid flg=0x8000010 (has extras) }
V/BackupManagerService(  394): removePackageParticipantsLocked: uid=10065 #1
I/InternalIcingCorporaPro( 4450): Updating corpora: APPS=com.fooapp.selendroid, CONTACTS=MAYBE
I/ConfigFetchService( 4979): PackageReceiver: Intent { act=android.intent.action.PACKAGE_REMOVED dat=package:com.fooapp.selendroid flg=0x8000010 cmp=com.google.android.gms/.config.ConfigFetchService$PackageReceiver (has extras) }
I/ConfigService( 4925): onCreate
I/InternalIcingCorporaPro( 4450): UpdateCorporaTask done [took 31 ms] updated apps [took 31 ms] 
I/ConfigService( 4925): onBind for Intent { act=com.google.android.gms.config.UPDATE pkg=com.google.android.gms } action com.google.android.gms.config.UPDATE
I/ConfigService( 4925): onBind returning update interface
I/ConfigService( 4925): onBind for Intent { act=com.google.android.gms.config.START pkg=com.google.android.gms } action com.google.android.gms.config.START
I/ConfigService( 4925): onBind returning config service
I/ConfigFetchService( 4979): onStartCommand Intent { act=android.intent.action.PACKAGE_REMOVED dat=package:com.fooapp.selendroid cmp=com.google.android.gms/.config.ConfigFetchService (has extras) }
D/dalvikvm(  394): GC_EXPLICIT freed 3235K, 39% free 22406K/36576K, paused 52ms+14ms, total 360ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 77ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 80ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 81ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 83ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 84ms
D/dalvikvm(  394): WAIT_FOR_CONCURRENT_GC blocked 83ms
I/ConfigFetchService( 4979): service connected
D/AndroidRuntime(10054): Shutting down VM
D/jdwp    (10054): Got wake-up signal, bailing out of select
D/dalvikvm(10054): Debugger has detached; object registry had 1 entries
I/ConfigService( 4925): onDestroy
D/PackageBroadcastService( 4979): Received broadcast action=android.intent.action.PACKAGE_REMOVED and uri=com.fooapp.selendroid
I/PeopleContactsSync( 4979): CP2 sync disabled
I/Icing   ( 4979): doRemovePackageData com.fooapp.selendroid
D/AndroidRuntime(10083): 
D/AndroidRuntime(10083): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10083): CheckJNI is OFF
D/dalvikvm(10083): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10083): Added shared lib libjavacore.so 0x0
D/dalvikvm(10083): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10083): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10083): Calling main entry com.android.commands.pm.Pm
D/AndroidRuntime(10083): Shutting down VM
D/dalvikvm(10083): Debugger has detached; object registry had 1 entries
D/AndroidRuntime(10095): 
D/AndroidRuntime(10095): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10095): CheckJNI is OFF
D/dalvikvm(10095): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10095): Added shared lib libjavacore.so 0x0
D/dalvikvm(10095): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10095): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10095): Calling main entry com.android.commands.pm.Pm
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/selendroid.com.fooapp.apk
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/selendroid.com.fooapp.apk
I/PackageManager(  394): Copying native libraries to /data/app-lib/vmdl-1057957568
I/PackageManager(  394): Running dexopt on: com.fooapp.selendroid
D/dalvikvm(10107): DexOpt: load 63ms, verify+opt 757ms, 1801140 bytes
I/ActivityManager(  394): Force stopping package com.fooapp.selendroid appid=10065 user=-1
W/PackageManager(  394): Not granting permission android.permission.INJECT_EVENTS to package com.fooapp.selendroid (protectionLevel=2 flags=0x8be44)
I/InputReader(  394): Reconfiguring input devices.  changes=0x00000010
D/BackupManagerService(  394): Received broadcast Intent { act=android.intent.action.PACKAGE_ADDED dat=package:com.fooapp.selendroid flg=0x8000010 (has extras) }
V/BackupManagerService(  394): addPackageParticipantsLocked: #1
I/InternalIcingCorporaPro( 4450): Updating corpora: APPS=com.fooapp.selendroid, CONTACTS=MAYBE
I/ConfigFetchService( 4979): PackageReceiver: Intent { act=android.intent.action.PACKAGE_ADDED dat=package:com.fooapp.selendroid flg=0x8000010 cmp=com.google.android.gms/.config.ConfigFetchService$PackageReceiver (has extras) }
I/ConfigService( 4925): onCreate
I/ConfigFetchService( 4979): onStartCommand Intent { act=android.intent.action.PACKAGE_ADDED dat=package:com.fooapp.selendroid cmp=com.google.android.gms/.config.ConfigFetchService (has extras) }
I/ConfigService( 4925): onBind for Intent { act=com.google.android.gms.config.UPDATE pkg=com.google.android.gms } action com.google.android.gms.config.UPDATE
I/ConfigFetchService( 4979): launchTask
I/ConfigService( 4925): onBind returning update interface
I/ConfigService( 4925): onBind for Intent { act=com.google.android.gms.config.START pkg=com.google.android.gms } action com.google.android.gms.config.START
I/ConfigService( 4925): onBind returning config service
D/dalvikvm( 4450): GC_CONCURRENT freed 543K, 8% free 10171K/10972K, paused 4ms+8ms, total 61ms
D/dalvikvm( 4450): WAIT_FOR_CONCURRENT_GC blocked 14ms
I/InternalIcingCorporaPro( 4450): UpdateCorporaTask done [took 67 ms] updated apps [took 67 ms] 
I/ConfigFetchService( 4979): service connected
I/ConfigClient( 4979): service connected
D/PackageBroadcastService( 4979): Received broadcast action=android.intent.action.PACKAGE_ADDED and uri=com.fooapp.selendroid
I/PeopleContactsSync( 4979): CP2 sync disabled
D/dalvikvm(  394): JIT code cache reset in 7 ms (1048476 bytes 13/0)
D/dalvikvm( 4979): GC_CONCURRENT freed 510K, 6% free 10783K/11380K, paused 2ms+3ms, total 43ms
W/SQLiteConnectionPool( 4979): A SQLiteConnection object for database '/data/data/com.google.android.gms/databases/metrics.db' was leaked!  Please fix your application to end transactions in progress properly and to close the database when it is no longer needed.
W/SQLiteConnectionPool( 4979): A SQLiteConnection object for database '/data/data/com.google.android.gms/databases/help_responses.db' was leaked!  Please fix your application to end transactions in progress properly and to close the database when it is no longer needed.
W/SQLiteConnectionPool( 4979): A SQLiteConnection object for database '/data/data/com.google.android.gms/databases/history_query.db' was leaked!  Please fix your application to end transactions in progress properly and to close the database when it is no longer needed.
D/dalvikvm(  394): GC_EXPLICIT freed 2828K, 39% free 22543K/36576K, paused 4ms+22ms, total 450ms
D/dalvikvm( 9925): GC_CONCURRENT freed 254K, 14% free 9509K/11048K, paused 1ms+2ms, total 54ms
D/AndroidRuntime(10095): Shutting down VM
D/jdwp    (10095): Got wake-up signal, bailing out of select
D/dalvikvm(10095): Debugger has detached; object registry had 1 entries
D/dalvikvm( 8413): GC_CONCURRENT freed 380K, 7% free 9255K/9928K, paused 2ms+3ms, total 42ms
D/AndroidRuntime(10127): 
D/AndroidRuntime(10127): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10127): CheckJNI is OFF
D/dalvikvm(10127): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10127): Added shared lib libjavacore.so 0x0
D/dalvikvm(10127): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10127): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10127): Calling main entry com.android.commands.pm.Pm
D/AndroidRuntime(10127): Shutting down VM
D/jdwp    (10127): Got wake-up signal, bailing out of select
D/dalvikvm(10127): Debugger has detached; object registry had 1 entries
D/AndroidRuntime(10138): 
D/AndroidRuntime(10138): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10138): CheckJNI is OFF
D/dalvikvm(10138): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10138): Added shared lib libjavacore.so 0x0
D/dalvikvm(10138): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10138): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10138): Calling main entry com.android.commands.am.Am
D/dalvikvm(10138): Note: class Landroid/app/ActivityManagerNative; has 163 unimplemented (abstract) methods
I/ActivityManager(  394): Force stopping package com.fooapp appid=10066 user=0
D/AndroidRuntime(10138): Shutting down VM
D/dalvikvm(10138): Debugger has detached; object registry had 1 entries
D/AndroidRuntime(10149): 
D/AndroidRuntime(10149): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10149): CheckJNI is OFF
D/dalvikvm(10149): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10149): Added shared lib libjavacore.so 0x0
D/dalvikvm(10149): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10149): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10149): Calling main entry com.android.commands.pm.Pm
D/dalvikvm(10149): Note: class Landroid/app/ActivityManagerNative; has 163 unimplemented (abstract) methods
I/ActivityManager(  394): Force stopping package com.fooapp appid=10066 user=0
D/keystore(  130): calling clear_uid in state: 3
D/PackageBroadcastService( 4979): Received broadcast action=android.intent.action.PACKAGE_DATA_CLEARED and uri=com.fooapp
I/Icing   ( 4979): doRemovePackageData com.fooapp
D/AndroidRuntime(10149): Shutting down VM
D/jdwp    (10149): Got wake-up signal, bailing out of select
D/dalvikvm(10149): Debugger has detached; object registry had 1 entries
D/AndroidRuntime(10162): 
D/AndroidRuntime(10162): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10162): CheckJNI is OFF
D/dalvikvm(10162): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10162): Added shared lib libjavacore.so 0x0
D/dalvikvm(10162): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10162): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10162): Calling main entry com.android.commands.pm.Pm
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/settings_apk-debug.apk
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/settings_apk-debug.apk
I/PackageManager(  394): Copying native libraries to /data/app-lib/vmdl-1187953269
I/PackageParser(  394): io.appium.settings: compat added android.permission.WRITE_EXTERNAL_STORAGE
W/PackageManager(  394): Attempt to re-install io.appium.settings without first uninstalling.
D/dalvikvm(  394): GC_EXPLICIT freed 570K, 40% free 22294K/36576K, paused 4ms+8ms, total 94ms
D/AndroidRuntime(10162): Shutting down VM
D/dalvikvm(10162): Debugger has detached; object registry had 1 entries
D/AndroidRuntime(10176): 
D/AndroidRuntime(10176): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10176): CheckJNI is OFF
D/dalvikvm(10176): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10176): Added shared lib libjavacore.so 0x0
D/dalvikvm(10176): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10176): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10176): Calling main entry com.android.commands.pm.Pm
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/unlock_apk-debug.apk
W/ActivityManager(  394): No content provider found for permission revoke: file:///data/local/tmp/unlock_apk-debug.apk
I/PackageManager(  394): Copying native libraries to /data/app-lib/vmdl1569255469
I/PackageParser(  394): io.appium.unlock: compat added android.permission.WRITE_EXTERNAL_STORAGE android.permission.READ_PHONE_STATE
W/PackageManager(  394): Attempt to re-install io.appium.unlock without first uninstalling.
D/dalvikvm(  394): GC_EXPLICIT freed 255K, 40% free 22247K/36576K, paused 3ms+7ms, total 94ms
D/AndroidRuntime(10176): Shutting down VM
D/dalvikvm(10176): Debugger has detached; object registry had 1 entries
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/dalvikvm(10176): Compiler shutdown in progress - discarding request
D/AndroidRuntime(10193): 
D/AndroidRuntime(10193): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
D/AndroidRuntime(10193): CheckJNI is OFF
D/dalvikvm(10193): Trying to load lib libjavacore.so 0x0
D/dalvikvm(10193): Added shared lib libjavacore.so 0x0
D/dalvikvm(10193): Trying to load lib libnativehelper.so 0x0
D/dalvikvm(10193): Added shared lib libnativehelper.so 0x0
D/AndroidRuntime(10193): Calling main entry com.android.commands.am.Am
D/dalvikvm(10193): Note: class Landroid/app/ActivityManagerNative; has 163 unimplemented (abstract) methods
I/ActivityManager(  394): Force stopping package com.fooapp appid=10066 user=0
D/AndroidRuntime(10193): Shutting down VM
I/ActivityManager(  394): Start proc com.fooapp for added application com.fooapp: pid=10203 uid=10066 gids={50066, 1015, 3003, 1028}
D/dalvikvm(10203): Late-enabling CheckJNI
D/jdwp    (10193): Got wake-up signal, bailing out of select
D/dalvikvm(10193): Debugger has detached; object registry had 1 entries
E/jdwp    (10203): Failed sending reply to debugger: Broken pipe
D/dalvikvm(10203): Debugger has detached; object registry had 1 entries
D/dalvikvm(10203): GC_CONCURRENT freed 174K, 3% free 9195K/9408K, paused 3ms+1ms, total 18ms
D/dalvikvm(10203): GC_CONCURRENT freed 148K, 3% free 9548K/9744K, paused 1ms+2ms, total 15ms
D/dalvikvm(10203): GC_CONCURRENT freed 149K, 3% free 9892K/10096K, paused 1ms+2ms, total 17ms
D/dalvikvm(10203): WAIT_FOR_CONCURRENT_GC blocked 3ms
I/dalvikvm(10203): Could not find method java.lang.management.ManagementFactory.getPlatformMBeanServer, referenced from method org.jacoco.agent.rt.internal_5d10cad.Agent.shutdown
W/dalvikvm(10203): VFY: unable to resolve static method 54278: Ljava/lang/management/ManagementFactory;.getPlatformMBeanServer ()Ljavax/management/MBeanServer;
D/dalvikvm(10203): VFY: replacing opcode 0x71 at 0x001b
I/dalvikvm(10203): Could not find method java.lang.management.ManagementFactory.getPlatformMBeanServer, referenced from method org.jacoco.agent.rt.internal_5d10cad.Agent.startup
W/dalvikvm(10203): VFY: unable to resolve static method 54278: Ljava/lang/management/ManagementFactory;.getPlatformMBeanServer ()Ljavax/management/MBeanServer;
D/dalvikvm(10203): VFY: replacing opcode 0x71 at 0x0028
D/dalvikvm(10203): DexOpt: unable to opt direct call 0xd7ca at 0x23 in Lorg/jacoco/agent/rt/internal_5d10cad/Agent;.shutdown
D/dalvikvm(10203): DexOpt: unable to opt direct call 0xd7cb at 0x30 in Lorg/jacoco/agent/rt/internal_5d10cad/Agent;.startup
D/dalvikvm(10203): DexOpt: unable to opt direct call 0xd7ca at 0x37 in Lorg/jacoco/agent/rt/internal_5d10cad/Agent;.startup
W/System.err(10203): android.os.NetworkOnMainThreadException
W/System.err(10203):    at android.os.StrictMode$AndroidBlockGuardPolicy.onNetwork(StrictMode.java:1133)
W/System.err(10203):    at java.net.InetAddress.lookupHostByName(InetAddress.java:385)
W/System.err(10203):    at java.net.InetAddress.getLocalHost(InetAddress.java:365)
W/System.err(10203):    at org.jacoco.agent.rt.internal_5d10cad.Agent.createSessionId(Agent.java:179)
W/System.err(10203):    at org.jacoco.agent.rt.internal_5d10cad.Agent.startup(Agent.java:122)
W/System.err(10203):    at org.jacoco.agent.rt.internal_5d10cad.Agent.getInstance(Agent.java:56)
W/System.err(10203):    at org.jacoco.agent.rt.internal_5d10cad.Offline.<clinit>(Offline.java:31)
W/System.err(10203):    at com.foo.FooApplication.$jacocoInit(FooApplication.java)
W/System.err(10203):    at com.foo.FooApplication.<init>(FooApplication.java)
W/System.err(10203):    at java.lang.Class.newInstanceImpl(Native Method)
W/System.err(10203):    at java.lang.Class.newInstance(Class.java:1130)
W/System.err(10203):    at android.app.Instrumentation.newApplication(Instrumentation.java:990)
W/System.err(10203):    at android.app.Instrumentation.newApplication(Instrumentation.java:975)
W/System.err(10203):    at android.app.LoadedApk.makeApplication(LoadedApk.java:504)
W/System.err(10203):    at android.app.ActivityThread.handleBindApplication(ActivityThread.java:4417)
W/System.err(10203):    at android.app.ActivityThread.access$1300(ActivityThread.java:141)
W/System.err(10203):    at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1316)
W/System.err(10203):    at android.os.Handler.dispatchMessage(Handler.java:99)
W/System.err(10203):    at android.os.Looper.loop(Looper.java:137)
W/System.err(10203):    at android.app.ActivityThread.main(ActivityThread.java:5103)
W/System.err(10203):    at java.lang.reflect.Method.invokeNative(Native Method)
W/System.err(10203):    at java.lang.reflect.Method.invoke(Method.java:525)
W/System.err(10203):    at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
W/System.err(10203):    at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
W/System.err(10203):    at dalvik.system.NativeStart.main(Native Method)
W/dalvikvm(10203): Class resolved by unexpected DEX: Lcom/foo/modules/ApiModule;(0x42068960):0x58b33000 ref [Lcom/google/gson/GsonBuilder;] Lcom/google/gson/GsonBuilder;(0x42068960):0x57a62000
W/dalvikvm(10203): (Lcom/foo/modules/ApiModule; had used a different Lcom/google/gson/GsonBuilder; during pre-verification)
D/AndroidRuntime(10203): Shutting down VM
W/dalvikvm(10203): threadid=1: thread exiting with uncaught exception (group=0x417bc700)
E/AndroidRuntime(10203): FATAL EXCEPTION: main
E/AndroidRuntime(10203): java.lang.IllegalAccessError: Class ref in pre-verified class resolved to unexpected implementation
E/AndroidRuntime(10203):    at com.foo.modules.ApiModule.providesGson(ApiModule.java:41)
E/AndroidRuntime(10203):    at com.foo.modules.ApiModule$$ModuleAdapter$ProvidesGsonProvidesAdapter.get(ApiModule$$ModuleAdapter.java:79)
E/AndroidRuntime(10203):    at com.foo.modules.ApiModule$$ModuleAdapter$ProvidesGsonProvidesAdapter.get(ApiModule$$ModuleAdapter.java:63)
E/AndroidRuntime(10203):    at dagger.internal.Linker$SingletonBinding.get(Linker.java:327)
E/AndroidRuntime(10203):    at com.foo.model.NewsfeedPost$$StaticInjection.inject(NewsfeedPost$$StaticInjection.java:30)
E/AndroidRuntime(10203):    at dagger.ObjectGraph$DaggerObjectGraph.injectStatics(ObjectGraph.java:240)
E/AndroidRuntime(10203):    at com.foo.FooApplication.getObjectGraph(FooApplication.java:60)
E/AndroidRuntime(10203):    at com.foo.FooApplication.inject(FooApplication.java:54)
E/AndroidRuntime(10203):    at com.foo.provider.FooProvider.onCreate(FooProvider.java:236)
E/AndroidRuntime(10203):    at android.content.ContentProvider.attachInfo(ContentProvider.java:1214)
E/AndroidRuntime(10203):    at android.content.ContentProvider.attachInfo(ContentProvider.java:1189)
E/AndroidRuntime(10203):    at android.app.ActivityThread.installProvider(ActivityThread.java:4879)
E/AndroidRuntime(10203):    at android.app.ActivityThread.installContentProviders(ActivityThread.java:4485)
E/AndroidRuntime(10203):    at android.app.ActivityThread.handleBindApplication(ActivityThread.java:4425)
E/AndroidRuntime(10203):    at android.app.ActivityThread.access$1300(ActivityThread.java:141)
E/AndroidRuntime(10203):    at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1316)
E/AndroidRuntime(10203):    at android.os.Handler.dispatchMessage(Handler.java:99)
E/AndroidRuntime(10203):    at android.os.Looper.loop(Looper.java:137)
E/AndroidRuntime(10203):    at android.app.ActivityThread.main(ActivityThread.java:5103)
E/AndroidRuntime(10203):    at java.lang.reflect.Method.invokeNative(Native Method)
E/AndroidRuntime(10203):    at java.lang.reflect.Method.invoke(Method.java:525)
E/AndroidRuntime(10203):    at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
E/AndroidRuntime(10203):    at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
E/AndroidRuntime(10203):    at dalvik.system.NativeStart.main(Native Method)
W/ActivityManager(  394): Error in app com.fooapp running instrumentation ComponentInfo{com.fooapp.selendroid/io.selendroid.ServerInstrumentation}:
W/ActivityManager(  394):   java.lang.IllegalAccessError
W/ActivityManager(  394):   java.lang.IllegalAccessError: Class ref in pre-verified class resolved to unexpected implementation
I/ActivityManager(  394): Force stopping package com.fooapp appid=10066 user=0
I/ActivityManager(  394): Killing proc 10203:com.fooapp/u0a10066: force stop com.fooapp
I/GoogleHttpClient( 4979): Falling back to old SSLCertificateSocketFactory
I/ConfigFetchService( 4979): fetch service done; releasing wakelock
I/ConfigFetchService( 4979): stopping self
I/ConfigService( 4925): onDestroy
D/Finsky  ( 8459): [1] 5.onFinished: Installation state replication succeeded.
D/dalvikvm(  595): GC_CONCURRENT freed 423K, 5% free 9235K/9704K, paused 8ms+3ms, total 60ms