Skip to content

Instantly share code, notes, and snippets.

@linguinee
Created August 27, 2014 23:59
Show Gist options
  • Save linguinee/ec33f5fe919a8912bdba to your computer and use it in GitHub Desktop.
Save linguinee/ec33f5fe919a8912bdba to your computer and use it in GitHub Desktop.
Appium Selendroid failure
W/ActivityManager( 510): Invalid packageName: com.fooapp.selendroid
W/PackageManager( 510): Package named 'com.fooapp.selendroid' doesn't exist.
W/ActivityManager( 510): No content provider found for permission revoke: file:///data/local/tmp/selendroid.com.fooapp.apk
W/ActivityManager( 510): No content provider found for permission revoke: file:///data/local/tmp/selendroid.com.fooapp.apk
I/PackageManager( 510): Running dexopt on: com.fooapp.selendroid
I/ActivityManager( 510): Force stopping package com.fooapp.selendroid uid=10106
D/PackageManager( 510): New package installed in /data/app/com.fooapp.selendroid-1.apk
W/PackageManager( 510): Not granting permission android.permission.INJECT_EVENTS to package com.fooapp.selendroid (protectionLevel=2 flags=0x8be44)
W/PackageManager( 510): Unknown permission android.permission.WRITE_CALL_LOG in package com.fooapp.selendroid
I/[LGHome]EVENT( 920): [LauncherModel.java:942:onReceive()]onReceive intent=Intent { act=android.intent.action.PACKAGE_ADDED dat=package:com.fooapp.selendroid flg=0x10000010 (has extras) }
D/BackupManagerService( 510): Received broadcast Intent { act=android.intent.action.PACKAGE_ADDED dat=package:com.fooapp.selendroid flg=0x10000010 (has extras) }
D/PackageAddedReceiver( 5112): package added com.fooapp.selendroid
D/PackageBroadcastService( 5128): Received broadcast action=android.intent.action.PACKAGE_ADDED and uri=com.fooapp.selendroid
W/PackageManager( 510): Not granting permission android.permission.INJECT_EVENTS to package com.fooapp.selendroid (protectionLevel=2 flags=0x28be44)
W/PackageManager( 510): Unknown permission android.permission.WRITE_CALL_LOG in package com.fooapp.selendroid
I/SELENDROID(13024): io.selendroid.ServerInstrumentation#onCreate:132 - Instrumentation initialized with main activity: com.foo.activity.LaunchActivity
E/SELENDROID(13024): io.selendroid.ServerInstrumentation#onStart:150 - Error
W/ActivityManager( 510): Error in app com.fooapp running instrumentation ComponentInfo{com.fooapp.selendroid/io.selendroid.ServerInstrumentation}:
info: Welcome to Appium v1.2.2 (REV cf6ff5939ddc6b4d45fcbabfbfe13c950e0058c4)
info: Appium REST http interface listener started on 0.0.0.0:4723
info: [debug] Non-default server args: {"sessionOverride":true,"selendroidPort":8081}
info: LogLevel: debug
info: --> POST /wd/hub/session {"desiredCapabilities":{"automationName":"Selendroid","app":"/Users/ykung/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/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Creating new appium session a0963f5c-fc5d-400e-a6d2-2cdaa23f8086
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/ykung/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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" devices
info: [debug] 1 device(s) connected
info: Found device LG-MS770-20033f1
info: [debug] Setting device id to LG-MS770-20033f1
info: [debug] Waiting for device to be ready and to respond to shell commands (timeout = 5)
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 wait-for-device
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "echo 'ready'"
info: [debug] Starting logcat capture
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from /Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt
info: [debug] hasInternetPermissionFromManifest: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt" dump badging /Users/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Rebuilt selendroid server does not exist, inserting modified manifest
info: [debug] Inserting selendroid manifest
info: [debug] Checking whether aapt is present
info: [debug] Using aapt from /Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt
info: [debug] Compiling manifest /tmp/com.fooapp/AndroidManifest.xml
info: [debug] "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/android-4.4/aapt" package -M "/tmp/com.fooapp/AndroidManifest.xml" --rename-manifest-package "com.fooapp.selendroid" --rename-instrumentation-target-package "com.fooapp" -I "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platforms/android-19/android.jar" -F "/tmp/com.fooapp/AndroidManifest.xml.apk" -f
info: [debug] Compiled manifest
info: [debug] Inserting manifest, src: /usr/local/lib/node_modules/appium/build/selendroid/selendroid.apk, dst: /tmp/selendroid.com.fooapp.apk
info: [debug] Extracting manifest
info: [debug] Unzipping /tmp/com.fooapp/AndroidManifest.xml.apk
info: [debug] Testing zip archive: /tmp/com.fooapp/AndroidManifest.xml.apk
info: [debug] Zip archive tested clean
info: [debug] Unzip successful
info: [debug] Writing tmp apk. /usr/local/lib/node_modules/appium/build/selendroid/selendroid.apk to /tmp/selendroid.com.fooapp.apk
info: [debug] Testing new tmp apk.
info: [debug] Testing zip archive: /tmp/selendroid.com.fooapp.apk
info: [debug] Zip archive tested clean
info: [debug] Moving manifest with: zip -j -m "/tmp/selendroid.com.fooapp.apk" "/tmp/com.fooapp/AndroidManifest.xml"
info: [debug] Inserted 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/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk
info: [debug] Checking app cert for /Users/ykung/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/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk"
info: [debug] App not signed with debug cert.
info: [debug] Resigning apk with: java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/sign.jar" "/tmp/selendroid.com.fooapp.apk" --override
info: [debug] Zip-aligning /tmp/selendroid.com.fooapp.apk
info: [debug] Checking whether zipalign is present
info: [debug] Using zipalign from /Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/ykung/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/appium114727-65597-x1qx5q.tmp"
info: [debug] App already signed.
info: [debug] Zip-aligning /Users/ykung/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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign" -f 4 "/Users/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/var/folders/dh/t2np5cvs53371kc1ypxm0f540000gp/T/appium114727-65597-tm9g8a.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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "am force-stop com.fooapp.selendroid"
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 uninstall com.fooapp.selendroid
info: [debug] App was not uninstalled, maybe it wasn't on device?
info: [debug] Getting install status for com.fooapp.selendroid
info: [debug] Getting device API level
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 15
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 install -r "/tmp/selendroid.com.fooapp.apk"
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "getprop persist.sys.language"
info: [debug] Current device language:
info: [debug] java -jar "/usr/local/lib/node_modules/appium/node_modules/appium-adb/jars/appium_apk_tools.jar" "stringsFromApk" "/Users/ykung/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/ykung/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/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk"
info: [debug] App already signed.
info: [debug] Zip-aligning /Users/ykung/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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign
info: [debug] zipAlignApk: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/build-tools/20.0.0/zipalign" -f 4 "/Users/ykung/Documents/mobileapps/foo_android_app/build/outputs/apk/foo_android_app-foo-debug.apk" "/var/folders/dh/t2np5cvs53371kc1ypxm0f540000gp/T/appium114727-65597-wv5b14.tmp"
info: [debug] MD5 for app is f4295f7479d4f29e6b8916bb1a2e2db8
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "ls /data/local/tmp/f4295f7479d4f29e6b8916bb1a2e2db8.apk"
info: [debug] Getting install status for com.fooapp
info: [debug] Getting device API level
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "getprop ro.build.version.sdk"
info: [debug] Device is at API Level 15
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "pm list packages -3 com.fooapp"
info: [debug] App is not installed
info: Installing App
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "mkdir -p /data/local/tmp/"
info: [debug] Removing any old apks
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "ls /data/local/tmp/*.apk"
info: [debug] Found an apk we want to keep at /data/local/tmp/f4295f7479d4f29e6b8916bb1a2e2db8.apk
info: [debug] Couldn't find any apks to remove
info: [debug] Uninstalling com.fooapp
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "am force-stop com.fooapp"
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 uninstall com.fooapp
info: [debug] App was not uninstalled, maybe it wasn't on device?
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 shell "pm install -r /data/local/tmp/f4295f7479d4f29e6b8916bb1a2e2db8.apk"
info: [debug] Forwarding system:8081 to device:8080
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 forward tcp:8081 tcp:8080
info: [debug] Pushing settings apk to device...
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 install "/usr/local/lib/node_modules/appium/build/unlock_apk/unlock_apk-debug.apk"
info: [debug] executing: "/Users/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 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/ykung/Documents/android/adt-bundle-mac-x86_64/sdk/platform-tools/adb" -s LG-MS770-20033f1 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:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/wd/hub/status","method":"GET"}
info: [debug] Making http request with opts: {"url":"http://localhost:8081/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:330: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 43168.329 ms - 240
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment