Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Android. Selendroid. Error when I try driver.quit(); #3258

Closed
evgenytkachenko opened this issue Jul 30, 2014 · 7 comments · Fixed by #3322
Closed

Android. Selendroid. Error when I try driver.quit(); #3258

evgenytkachenko opened this issue Jul 30, 2014 · 7 comments · Fixed by #3322
Milestone

Comments

@evgenytkachenko
Copy link

I got the problem:

Command duration or timeout: 9.98 seconds
Build info: version: '2.41.0', revision: '3192d8a6c4449dc285928ba024779344f5423c58', time: '2014-03-27 11:29:39'
System info: host: 'iosbuildagent.local', ip: '10.33.4.133', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.9.3', java.version: '1.7.0_51'
Session ID: 96f47716-2be4-2035-20e6-893aedc8c39c
Driver info: io.appium.java_client.AppiumDriver
Capabilities [{automationName=selendroid, platformVersion=19, platform=ANDROID, acceptSslCerts=true, javascriptEnabled=true, platformName=android, handlesAlerts=true, browserName=selendroid, networkConnectionEnabled=true, rotatable=true, takesScreenshot=true, version=0.10.0}]
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:57)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
at java.lang.reflect.Constructor.newInstance(Constructor.java:526)
at org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:193)
at org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:145)
at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:595)
at io.appium.java_client.AppiumDriver.execute(AppiumDriver.java:76)
at io.appium.java_client.AppiumDriver.execute(AppiumDriver.java:87)
at org.openqa.selenium.remote.RemoteWebDriver.quit(RemoteWebDriver.java:464)
at resources.BasicTest.closeDeviceITest(BasicTest.java:70)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:84)
at org.testng.internal.Invoker.invokeConfigurationMethod(Invoker.java:564)
at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:213)
at org.testng.internal.Invoker.invokeMethod(Invoker.java:786)
at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:901)
at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1231)
at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:127)
at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:111)
at org.testng.TestRunner.privateRun(TestRunner.java:767)
at org.testng.TestRunner.run(TestRunner.java:617)
at org.testng.SuiteRunner.runTest(SuiteRunner.java:334)
at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329)
at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291)
at org.testng.SuiteRunner.run(SuiteRunner.java:240)
at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)
at org.testng.TestNG.runSuitesSequentially(TestNG.java:1224)
at org.testng.TestNG.runSuitesLocally(TestNG.java:1149)
at org.testng.TestNG.run(TestNG.java:1057)
at org.testng.remote.RemoteTestNG.run(RemoteTestNG.java:111)
at org.testng.remote.RemoteTestNG.initAndRun(RemoteTestNG.java:204)
at org.testng.remote.RemoteTestNG.main(RemoteTestNG.java:175)

debug: Appium request initiated at /wd/hub/session/96f47716-2be4-2035-20e6-893aedc8c39c
debug: Request received with params: {}
info: Shutting down appium session...
info: Removing app from device
info: Uninstalling eu.inn.test
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 shell "am force-stop eu.inn.test"
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 uninstall eu.inn.test
debug: App was uninstalled
info: Stopping selendroid server
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/96f47716-2be4-2035-20e6-893aedc8c39c","method":"DELETE"}
info: Cleaning up appium session
info: Responding to client with error: {"status":13,"value":{"message":"An unknown server-side error occurred while processing the command. (Original error: Device exited with code: 1)","origValue":"Device exited with code: 1"},"sessionId":null}

jlipps added a commit to jlipps/appium that referenced this issue Jul 30, 2014
@jlipps
Copy link
Member

jlipps commented Jul 30, 2014

Just added a pull request that doesn't resolve the issue but should generate a better trace. Can you run from master once it's merged and let me know if anything's fixed?

@evgenytkachenko
Copy link
Author

IDE
An unknown server-side error occurred while processing the command. (Original error: Device exited with code: 1) (WARNING: The server did not provide any stacktrace information)
Command duration or timeout: 13.80 seconds
Build info: version: '2.41.0', revision: '3192d8a6c4449dc285928ba024779344f5423c58', time: '2014-03-27 11:29:39'
System info: host: 'iosbuildagent.local', ip: '10.33.4.133', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.9.3', java.version: '1.7.0_51'
Session ID: 09d7a5b6-b021-e678-b7d1-fc10ba06829c
Driver info: io.appium.java_client.AppiumDriver
Capabilities [{automationName=selendroid, platformVersion=19, platform=ANDROID, acceptSslCerts=true, javascriptEnabled=true, platformName=android, handlesAlerts=true, browserName=selendroid, networkConnectionEnabled=true, rotatable=true, takesScreenshot=true, version=0.10.0}]
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:57)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
at java.lang.reflect.Constructor.newInstance(Constructor.java:526)
at org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:193)
at org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:145)
at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:595)
at io.appium.java_client.AppiumDriver.execute(AppiumDriver.java:76)
at io.appium.java_client.AppiumDriver.execute(AppiumDriver.java:87)
at org.openqa.selenium.remote.RemoteWebDriver.quit(RemoteWebDriver.java:464)
at resources.BasicTest.closeDeviceITest(BasicTest.java:70)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:84)
at org.testng.internal.Invoker.invokeConfigurationMethod(Invoker.java:564)
at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:213)
at org.testng.internal.Invoker.invokeMethod(Invoker.java:786)
at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:901)
at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1231)
at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:127)
at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:111)
at org.testng.TestRunner.privateRun(TestRunner.java:767)
at org.testng.TestRunner.run(TestRunner.java:617)
at org.testng.SuiteRunner.runTest(SuiteRunner.java:334)
at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329)
at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291)
at org.testng.SuiteRunner.run(SuiteRunner.java:240)
at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)
at org.testng.TestNG.runSuitesSequentially(TestNG.java:1224)
at org.testng.TestNG.runSuitesLocally(TestNG.java:1149)
at org.testng.TestNG.run(TestNG.java:1057)
at org.testng.remote.RemoteTestNG.run(RemoteTestNG.java:111)
at org.testng.remote.RemoteTestNG.initAndRun(RemoteTestNG.java:204)
at org.testng.remote.RemoteTestNG.main(RemoteTestNG.java:175)

Server
debug: Appium request initiated at /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element
debug: Request received with params: {"using":"id","value":"signOut"}
debug: Proxying command to localhost:4444
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element","method":"POST","json":{"using":"id","value":"signOut"}}
info: Responding to client with error: {"status":7,"value":{"message":"An element could not be located on the page using the given search parameters.","origValue":"Element was not found.\nio.selendroid.exceptions.NoSuchElementException: Element was not found.\n\tat io.selendroid.server.handler.FindElement.handle(FindElement.java:57)\n\tat io.selendroid.server.AndroidServlet.handleRequest(AndroidServlet.java:290)\n\tat io.selendroid.server.BaseServlet.handleHttpRequest(BaseServlet.java:70)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat io.selendroid.server.inspector.InspectorServlet.handleHttpRequest(InspectorServlet.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.PathMatchHandler.handleHttpRequest(PathMatchHandler.java:33)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.DateHeaderHandler.handleHttpRequest(DateHeaderHandler.java:21)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.ServerHeaderHandler.handleHttpRequest(ServerHeaderHandler.java:25)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:67)\n\tat org.webbitserver.netty.NettyHttpChannelHandler$2.run(NettyHttpChannelHandler.java:72)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1112)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:587)\n\tat java.lang.Thread.run(Thread.java:841)\n"},"sessionId":"09d7a5b6-b021-e678-b7d1-fc10ba06829c"}
POST /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element 500 5511ms - 2.02kb
debug: Appium request initiated at /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element
debug: Request received with params: {"using":"id","value":"signOut"}
debug: Proxying command to localhost:4444
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element","method":"POST","json":{"using":"id","value":"signOut"}}
info: Responding to client with error: {"status":7,"value":{"message":"An element could not be located on the page using the given search parameters.","origValue":"Element was not found.\nio.selendroid.exceptions.NoSuchElementException: Element was not found.\n\tat io.selendroid.server.handler.FindElement.handle(FindElement.java:57)\n\tat io.selendroid.server.AndroidServlet.handleRequest(AndroidServlet.java:290)\n\tat io.selendroid.server.BaseServlet.handleHttpRequest(BaseServlet.java:70)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat io.selendroid.server.inspector.InspectorServlet.handleHttpRequest(InspectorServlet.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.PathMatchHandler.handleHttpRequest(PathMatchHandler.java:33)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.DateHeaderHandler.handleHttpRequest(DateHeaderHandler.java:21)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:62)\n\tat org.webbitserver.handler.ServerHeaderHandler.handleHttpRequest(ServerHeaderHandler.java:25)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:78)\n\tat org.webbitserver.netty.NettyHttpControl.nextHandler(NettyHttpControl.java:67)\n\tat org.webbitserver.netty.NettyHttpChannelHandler$2.run(NettyHttpChannelHandler.java:72)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1112)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:587)\n\tat java.lang.Thread.run(Thread.java:841)\n"},"sessionId":"09d7a5b6-b021-e678-b7d1-fc10ba06829c"}
POST /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/element 500 5488ms - 2.02kb
debug: Appium request initiated at /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/screenshot
debug: Request received with params: {}
debug: Proxying command to localhost:4444
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/screenshot","method":"GET"}
debug: Proxied response received with status 200: "{"value":"iVBORw0KGgoAAAANSUhEUgAAAUAAAAGwCAYAAADYAryzAAAABHNCSVQICAgIfAhkiAAAIABJREFU\neJztnXl4FFXWxt/qdFYIIZBAAkQJgmyKooAwgA6gMo6IuCAqo+OIwrjrjDOK3ziu47iN474x7ruM\nuKEIIrIJiCK4AAEZVtmXJGTtdLru90enKrdu3dp6SQJ1fs/Dc+hazjn31r3vPVXd6VYAMBAEQfiQ\nQHMnQBAE0VyQABIE4VtIAAmC8C0kgARB+BYSQIIgfAsJIEEQvoUEkCAI30ICSBCEbyEBJAjCt5AA\nEgThW0gACYLwLSSABEH4FhJAgiB8CwkgQRC+hQSQIAjfQgJIEIRvIQEkCMK3kAASBOFbSAAJgvAt\nJIAEQfgWEkCCIHwLCSBBEL6FBJAgCN9CAkgQhG8JMka/i04QhD+hCpAgCN9CAkgQhG8hASQIwreQ\nABIE4VtIAAmC8C0kgARB+BYSQIIgfAsJIEEQvoUEkCAI30ICSBCEbyEBJAjCt5AAEgThW0gACYLw\nLSSABEH4FhJAgiB8CwkgQRC+hQSQIAjfQgJIEIRvCTZ3AocyO3bswP79+9GqVSt069btsIlFEH6h\nSSvAtWvXYs2aNU0ZMmY2bNiAOXPm4MMPP8SiRYtQWlpqOubll19Gv379cOuttyY9n6aMJaOyshJr\n1qzBmjVroKpqs+RAEImmySrAn376CU888QQA4K677kJBQUFThfZESUkJ/vSnP2HWrFmG7dnZ2bjl\nlltw8803Iz09HQCQn5+PkSNHori4OOl5NWUsGatWrcLw4cMBABUVFWjdunWz5EEQiURhTfCzcKtW\nrcIzzzwDACguLm62KsaJbdu2YciQIdi+fTuOO+44TJw4EW3btkVJSQmefvpp1NbW4qqrrsLTTz/d\n3Kk2OYsXLyYBJA47kl4BLl++HC+88AIA4Igjjmix4gcAb7zxBrZv347+/ftjwYIFyM7O1vede+65\nGDZsGJ555hlcfvnlGDBgQDNmShBEIkiqAC5YsABvvvkmAKBv3764/vrrkxkubjZu3AgAOOWUUwzi\nBwBDhw7F6NGjsXnzZqxbtw4DBgzA/PnzsWLFCnTp0gUTJkzQjw2FQnjnnXewZMkSpKSk4PTTT8dZ\nZ52Fxx57DKqq4pprrkFGRgamT5+OrVu34rTTTkPHjh3x6quvYv369ejcuTPOPvts9O/fX/cpi+Xl\nfC95ecFrDgTRomBJ4rPPPmOTJ09mkydPZi+99FKywiSUe+65hwFgPXv2ZNu3b3c8/h//+AcDwMaP\nH69vq62tZWeffTYDYPh39dVX6/8vKytjjDF20UUXMQDs1ltvZd27dzccn5qayj799FPbWF7O95KX\njEWLFunHVVRUxJQDQbQ0kvIu8CeffIIZM2YAAEaOHInLLrssGWESzsSJE9GxY0esW7cOgwYNwv33\n34+VK1ciEom49vH666/jww8/RGpqKqZNm4Y1a9Zg1qxZWLhwoeU5jz76KG688UasXr0aCxYswNCh\nQxEOh3H//fe7iunm/Fjy8kK8bSCI5iDht8Aff/wxZs6cqb+eN28e5s2b5/r85557LtEpuaa4uBhf\nfPEFrr/+esybNw9Tp07F1KlTcfTRR2PSpEm4/PLLkZeXZ+vjpZdeAgDceOONuOKKKwAAvXv31m85\nZdxwww245ppr9Ne33HILxo4di4ULF6KmpgaZmZm2Md2cH0teXoi3DQTRHNBfggj07dsXn3/+ORYt\nWoS//OUvKC4uxvr163HLLbfg+OOPx+LFiy3PraiowFdffQUAOOOMMwz77N41zcrKMrzmPyJUXV3t\nmLPT+bHm5YV420AQzUHCK8CzzjoLgUAAH330EYDoLTD/BsGhQCAQwLBhwzBs2DDcd999WLZsGe65\n5x7MmTMH48aNw08//ST9HGN5ebn+/44dO8YVX4PF8Ckl8fxE5RVPDgTREklKBXjmmWfi3HPPBRC9\nBX755ZeTESah1NbWYsWKFVixYoWhYgkGgxg2bBjefvtt5OfnY//+/fjiiy+kPhRF0f/fkv5aoqXm\nRRDNTdJugUePHo2LL74YALB06VI8/vjjyQqVEKqqqjBgwAAMGDAAy5cvN+3Pzc1F9+7dAUD6Z3EA\n0K5dO/1jJNpHaloCLTUvgmhukvoM8JRTTsGkSZMAAKtXr8Y//vGPZIaLi/bt22PcuHEAgHvuuQe7\nd+827F+0aBG+/fZbAMDRRx8t9ZGZmYmzzz4bAPDkk0/qt56qquLjjz9OVuqOtNS8CKK5Sfpfggwa\nNAhpaWl45plnsHXrVtx///0t9q9BHnroIaxduxbz5s1Dt27dMHr0aHTo0AGbNm3CnDlzAADnn38+\nRo4caenjpptuwjvvvIPPP/8c/fr1w5AhQ7B+/XqsXLmyqZpxSOVFEM1Jk7wLfPzxx+O6664DAGza\ntAm7du1qirCe6d69OxYvXoy7774bHTp0wPvvv4/nnnsOc+bMQc+ePfHYY4/h1VdfRTBovW6cdNJJ\n+PTTT9GzZ09s3boV77zzDnJycvQ/BwSMz+SaipaaF0E0J03yZQgaa9euBWMMffr0aaqQMcMYw86d\nO1FdXY3s7Gx06NDBk0BEIhHs2LEDiqKgc+fO+OijjzBu3DikpqaiurraVkSTSUvNiyCagyYd7b17\n927KcHGhKAo6deoU07k7d+5EQUEBioqKAETfYX7xxRcBAGPGjGk2kWmpeRFEc9GkFaBfGDlyJCoq\nKjB48GBkZmZi3rx5WLFiBVJTU7Fw4UIMHjyY8iKIFgAt+Qmmvr4eQ4YMwbRp0/R3jYHot8ncd999\nzSYyLTUvgmhOqAJMEqFQCDt37sTBgwfRrl07dOnSpblTAtBy8yKI5oAEkCAI30JfhkAQhG8hASQI\nwreQABIE4VtIAAmC8C0kgARB+BYSQIIgfAsJIEEQvoUEkCAI30ICSBCEbyEBJAjCt5AAEgThW0gA\nCYLwLSSABEH4FhJAgiB8CwkgQRC+JfjL/OOaOweCIIhmIdglWG+91/QjaAoABigKwKJ2zBuXsrCa\ndkj/nmJGq+zmToEgCI+k1+9i717wpgI06pHBanqFBsO91Gi8BdYkTPvpR/0nIPnXQhAAfdtuUBPe\nMoIgCAd6tdnATHpl0CdN9WDWtQbTKICaMjLWsJNxOyQK27D/ikE/BJgaoa/VJwiiyaitOMCuGvqj\nAsbrFCx0ShH2N77kKkBvlZ+2v0eHSmVM8VKAKSSCBEEknfpQiJ1Z/DUKs2sVaQWoWReVIFcBasro\nrvLj762vP6VEyQ+sV6kSJAgimdRWHGDFqd/g+pNLFBgKPJtKENaVYMBWQW0qP/Fe+vVLFqSMKV6K\nUMW+BiGkipAgiPiJ1IdZbcUBVr5jAzuz23I8Of4bBbwcMVjoF4w6JlaCDFDYoj4Mwj7Zu71GBVUM\nh/HvFu88mMGmr+qK77blYuO+nEP63WGCIJqfbnnl7IQupRh/wubobS+PqcATNjhUggpb3JcZNopv\nJSuChklEL7rd6nbZqpIUz7fwa5uX6N/Oj1Ucmzwtxd9DPIswjv5d5eMlXqM1fWLA/nB3VlHAGGt6\nG2/ecHe5ZR+hMGPVwXaTULwwHuJaHufiwktvC73GtfAXbxw3fvX9bvrD2m8glmd+1s4FK0le+x12\n3YLpp4NrU2NU7nhFs0rDds4a9vP+OX+KLI6YB5ennq9FPDEvyPKXxOXzNMQX4oh58PmI/SdrhyE/\n+eW1m3PeRIQ1+GtiG2/ekGuUaZy46m+L62U3jkzj22qcanlAOF4c77JxKuYhy98prmy8S9plaLdD\nHFm/2omnSV84+MP5jtJ1S+638RmgrOLQt6PxtbDZ+K6L8Frzh0Z/iqUVw0iOY9prBu0JqLU/iV/G\nv1as4+h+RWsXx6Idelw+f6v4VnG9xFcaLoNoYW8hioKVHxvLmsnGkq+pvU628Xy318HVdZWOP368\nSMZT3PEdxr80bgxxmF0ce78m/eB1yKQzjbuluqSfJ+oRQ8CosNxBJgVtPMxAk1R+3MoiW+EUSPzD\n7N8QR77y2K5s+nHCim3I2yqubEW0Wjmt8rCqPIzxxMtomuxOtiHfw9bG1B/ctBCvq+y6GK5PAitC\n2TiTjkuX40yWt6u4snnXwitByYUMSMUPcFZYDakiM8HarRwwvk5YRSamo8QQx86/JI7YHse4iaz0\nYG8B4fgYKjm357cUG087IPablY2lMmyuitDFeJNVatK4HuLI5oHV/BesMQHtiggXwuAIgpV0GFcJ\nBuTKCOgSypcQIiYl5pL0XPmJKxB/vtUzDd4vl7Ui+FcsVmjNvyyOaSVmQr6CFePFVfFZVRLGPMTL\nZpq0Mhtr5dQwOQ8p29CvsbXXbX9y04YfH7aVYRNXhHo+VvPIbtxJ5pMhnjg/7Ma5rF/EfoMQX+hg\n/gqY9IeDP5x3LOhdwKiIsLFG/3IFZoL1oPz8ysOsViwbf1xaYA7+YeXfY2UptoPJ8oo3XqNlBgu5\nBYTjXFRGTsfrlh2i1mN/2PULxH62sl4qw5ZSETrMF2k8D/5t54e9X+PE1q6A0PEGBxCspKOY9i6w\nwkmwJpli5ccLrEl5uaSSWvlJVjY+PcXBPyT+3cYxrXxivIbjDfESUfEZutVdpdeQjysLlxUVs7FK\nM1u7/Ny0T/fnpr/c9j83rQzjSHa9E1QRivMBQnxFjG8zPqXzxiaedN60/ErQ4S9BIFdSk+Iywdqt\nDDC+jrfyk6Vh5R+x+LdaocDlaxUvtoqPGaxYWYiTLREVXpIrrGRbJcntcNOfEK+LaJNYERrGoWSc\neo3HHMYpi9e/3byx92uc6FqPCx1ucADBGjcInwOEscTgNuvnNEflp+/n/cLs19K/08oKSRxj8w0r\nlMG6XFHdVHyN3dhojb1stm4qF6+VneK1AoN7C5fWq994K0ar/kGCKkOhgGmsdGTjwW1FKM4f2Tzg\n5ok4zvX4TuNWNl+t4kjmk5i37l/WfrF/YNyfqEqw4T8K+6pvw/+4g2Tws1J2mRWLE01+JefJ/MpG\nlZVfXfkt8orFv9c4tvHs/boSOzeT23YSexA1uzzitTKRt7PJygMxiKZs8XCzOFjGtxlOBsSBYiMC\nsOg4GbKELP1ZxfMSx8avyb+LfrHKS+pX3u5AYzBmDMKfY1JW86Rv/sqPSfzbrKDSlYrP000cq5Ut\nxopPuNbmyepgrcQP3CR2O2lFi3htDOKnJCJuHBUj32+yfnW8Hs7iZ5of0vHioSLkxpVx3onjWja/\nxPnhUAnK5oddHMv5Imu32C8w7rcTZZNecRjEWPw2GG0neKtt544TxC+62crC+BrcfqZtF54RuPIH\n7nwrK/r16N8uDmL1Lz5DgtFqvWs6zuEZlFYBurJOfpJhYxA/x/Ym28bYj3Z5Q7jeJus8fqTjDpLj\nDONWHNdWx9nFsZjHml/G+YckDu+Xnz+W88shb1NgTsD4juXhdQ38M0D+6vA0Z+Vn8AuzX0W2Igl+\nvVaWEPzrlo8j+mviii/eSk/z35Cfo41ZvFqIddNOLxViPJWh5fVuzNe2IpRVZopYCWoVlnHcSStC\nfny7Huey8S3OSzEO7z+eSlA+3036xOuWoIG6YwVQ2JK+TL8KPPwokl02UVn187jDTBuYtV9+dDj5\nZbA43ypf2fke/cvimOLJ/TGheVJrNdkUq0nm4nbWLh7XzJjFxY3/prRxi6TbOAl8VuiiPYYdUsSB\nZuFR1lAbd4ZEpANaFseLf8GP7MJY+ZX5txVDTkU5AvbOwJ0kEQFAosiNMQ3bDStSE1R+hhUMRv+G\n/Cz8u1kJTfHEfDxMMsuKIcmV3uEifohXzD1UiF7ED4mqCIXxxY8zcVzajn9unIvjX5wnvH+r8W/K\nR5hHEOPw/oV8m7ISbPAT0DfqVmm0jHstil/DdutnaA2vwe1n2vZ4nslJ/ELiV7rfzi+4/MQ4MT7r\n48VCHOxahcZbJtmuT6IYnkW5shbi5mShuLNx5+cyDhR3efPW0O5E5JmAZ4WwyrfxOOtxl+Bng07+\nGTcPTHGgywXAy4sbv1bz0DlPY2BmbCCvZw0moEuzhkkxZYoqeRZgWlm4/Zqi6+fFWPmJfmHj17Cf\n9w9r/6aVx+oZiKz95n4wiR5vY6n4lBgrPZnIWVmrfE3W7bPDBFk38VzlzQ1vt/1iF8+uMgRnpddT\n1k7nfOUVkmScKpL5YJiPnD9tPujzQjYvW0AlKOpBLJUgB1cBWiglX/lxitpiK79Y/FquOB4rPqH7\nDJfAbQWgJKHSk4mclU1WBdfc1kulKO2vRFaEFtdTNh5glafzeJSOX8uKUDIvXPt1mB+u/TPjvJPN\nS9M8lrcLirCMmBMAYPWrcAogTF99NDRJ5ac4+IWDX30/7x8W/huOM/gXVyJJuyHG4SaNuffcV3x8\n5aAkodIT8zJZSYUjy9uNFdsTr9X7w2sesv6y6Qc3/chs+kvvt+RWhI6VkFip8fNEMn6N803zK8wT\n6XyzmSeO/i38GuafrH2iP0FHtAtl6DkYdQ7i7wJrVz+6AY3K2aigjhVVIio/g2DLFT6uyk+2ssC7\nX+MKDsE2Q8UnEzvRNmmF51QBxWqTkG8sFWLC+8PFeIFVXnbjX1Kxua4EYePX4zyU+rfwF2slKFh9\nwoN7zelcVAA1ReSXFu0k15UfhP0WK088lZ/mz8qvHlfwK/XPt0fMT1jZxHYBRrHhuli3ya74RLGT\niZ8sL5OfGCs5sR0txcZaOYr9YtV/jv1udb0SUBE65COtlGTjWomxEpTOL36etLxKUO8gvuc4vQuI\niqgfbLAWyssrumxFQYIrPyZZydz4NfhXJP69+ZWuwFoXO63gXioAWyuInSmfRFZ6LahSa6589H6U\n9LdBBBPZDqdxJMuncb/lvDDNI3G/xfxx8ut2XjK3fm0qQZPeyP0YLpA+Uxs7LOC98hOUN+rOuF8/\nT6ys+PM1vzD6E5Uc/Apg4VePa7FyWa6QYn6if/kKZhI9zYortr5yW1QoilgR8Cs9Z02TzCEP6fku\nKzy4tFaVoduKKx5rFz+e/C3j8f1pdd1trHg9tOtsuv4W7bDNS8iHi2ucZ5L5aTXetXliNZ8M80GY\nT8mqBA15C/pgpx+GDhF6TBH/FtiwU1BYK8X1Uvkx8TiblSDmyk/0B3lcaeUnX4mkK67WW65W6jgr\nEpnomcQvmRVVrH5bmk1CO91UhnHn52KcQRLfYjw3Wsn4l85nm3nq1q/MMs4f7PwK/vj57KUS1ANq\nPWb6PsDGg8yVmqC0+lmSlcWq8jOsGDD6E5Wbz8OVX1j7la1UUv9CeyBbyQXrVPFptikqPjEPPh+3\nFZKXysgynqTiSaT1mk+8/eCqneK4sLh+DPJ2ua0IrfKxiW8e/9prm/llmNeSea/NN6tKEDL/ol7I\n9ETmN3mVoMKWHsNE8ZNiFE7j8eJV1rfLznPwJ/Nr2u7Sr7YUOvqVn28rOuJgVYRJJN1vJV5exM7G\nvywP0UrPs5mstqJ7iFmndori40YkZaIVsyjKFlcr/y4WV3Ga8BsMiAPeogf5RGWY/MvOl/h37deN\nP4sBYPDXeF5AmiQ05XWrrI0Ka/1sTvMHe38NIpWwyo/3K64gfJ6m9tgMTn2ycFY2KMXB2eBfgXZ8\ng/UyKcD5MeXhYvKKlYVdhaMIeRpsCxE1SyursBwsPPaf6Xyb/nEUP5cVoSEfq3bI4xvnocO8AG+F\n+aYI882wX/Ar9S+fbwa/kPl14Q9o9AdJewXRNP4usG4B62cAkv1Me80Ea+dH8Afen+iHWcSz8Mcs\n/LrKj6uIwFunZzBchWWykuNN/sR44Pw6nK/bGOPbWVhYq3xbijXlG4+No1/t+stw3d3k6xBfOi6t\nx7HV+DfME0j2N8qEvS7o88+lLvB+YefXxh84f9LtfOJ8BWip0I27jds5ZVbEyk+RrAiw92fwG0/l\n17AfsvM9VH7gBg9sKga4vR0RV3hhEjAhnm7tVnqH2yKrSoW3Yl6m+BIr5t3SrKt2eKgQ7foZDv1s\n1a9W+cvy0vOTVPB28R3i6uPeav7x81oyT5wrNm4eGnTBQWcUwZ/JbwyVIJ8/186AKL2OlZ+hUuMU\n2aD0dn7AnWdW5sRWfg6VpGANKyW0yW63wsZTcQliq8dt4oovlsrOcvJ6iJsIa5uHk01EhZiMijAB\n113mB9b9YDUfDHdiTpUgYO1Ht5J5aPILo183/phkXltVgmL7mCaJBEEQPiPgfAhBEMThCQkgQRC+\nhQSQIAjfQgJIEIRvIQEkCMK3kAASBOFbSAAJgvAtJIAEQfgWEkCCIHwLCSBBEL6FBJAgCN9CAkgQ\nhG8hASQIwreQABIE4VtIAAmC8C0kgARB+BYSQIIgfAsJIEEQvoUEkCAI30ICSBCEbyEBJAjCt5AA\nEgThW0gACYLwLSSABEH4FhJAgiB8CwkgQRC+hQSQIAjfQgJIEIRvIQEkCMK3kAASBOFbSAAJgvAt\nJIAEQfgWEkCCIHwLCSBBEL6FBJAgCN9CAkgQhG8hASQIwrckRQBX7wzjpv/uxyNzy/HI3HLcMbM0\nGWFcU1ZWhmXLluE///kPnnzySekxmzdvxg033IB+/fqhuLgY48ePx6JFi2z9vvzyy1AUBa+++mpM\nvv72t79BURTTv3feecdw3M6dOzFv3jw89thjmDVrljSXZcuWYeLEiejSpQt69OiBKVOmYNOmTabj\n3Pji+fHHH5GWloYpU6aY9pWWluLee+9Fv3790KFDB5x++ulYsmSJo0+CaCkEE+1w9c4wZq+uxr/P\nb69v21YawbsrqnDBia0SHc6RdevWoVevXvrr8ePH49prrzUc88svv2D48OEYMmQIHn/8cWRmZuKD\nDz7AqFGjsHDhQgwePNjkd9u2bbj55ptN27342rZtG8aOHYsrrrjC4OPYY4/V///GG2/gd7/7nf76\niSeeMMX86quvMGLECNx44414++23wRjDQw89hNNPPx3Lli1D+/btXfviCYfDuPHGGxEOh037ysvL\nceaZZ4IxhnvvvRedOnXCli1b9FgEcUjAEsw731ayrQfqDdvKaiLsnW8rEx3KM5dccgkbP368afuT\nTz7JMjIyWHl5ub5NVVXWv39/NnXqVNPxqqqyiy++mI0dO5YBYK+88kpMvk4++WT2wAMPuM4fAHvi\niSdM288++2w2duxYpqqqvm3Hjh0MAHvzzTc9+eJ5+umnWXFxMRs6dCibPHmyYd/dd9/NjjjiCHbg\nwAHX+RNESyPht8BDumVg9ppqw7alG0MoyvVWbL799tsYPHgw8vLycMEFF+Crr76
GET /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c/screenshot 200 1698ms - 28.84kb
debug: Appium request initiated at /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c
debug: Request received with params: {}
info: Shutting down appium session...
info: Removing app from device
info: Uninstalling eu.inn.test
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 shell "am force-stop eu.inn.test"
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 uninstall eu.inn.test
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
debug: App was uninstalled
info: Stopping selendroid server
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c","method":"DELETE"}
info: Cleaning up appium session
info: Responding to client with error: {"status":13,"value":{"message":"An unknown server-side error occurred while processing the command. (Original error: Device exited with code: 1)","origValue":"Device exited with code: 1"},"sessionId":null}
DELETE /wd/hub/session/09d7a5b6-b021-e678-b7d1-fc10ba06829c 500 13789ms - 234b

and logcat
07-31 05:30:06.742 W/ResourceType( 2191): No known package when getting name for resource number 0xffffffff
07-31 05:30:06.772 I/Choreographer( 2191): Skipped 41 frames! The application may be doing too much work on its main thread.
07-31 05:30:06.882 I/Choreographer( 2191): Skipped 30 frames! The application may be doing too much work on its main thread.
07-31 05:30:06.972 I/Choreographer( 2191): Skipped 33 frames! The application may be doing too much work on its main thread.
07-31 05:30:07.402 I/Choreographer( 2191): Skipped 63 frames! The application may be doing too much work on its main thread.
07-31 05:30:07.672 I/Choreographer( 2191): Skipped 33 frames! The application may be doing too much work on its main thread.
07-31 05:30:07.932 I/Choreographer( 2191): Skipped 52 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.002 I/Choreographer( 2191): Skipped 37 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.212 I/Choreographer( 2191): Skipped 126 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.542 I/Choreographer( 2191): Skipped 190 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.662 I/Choreographer( 2191): Skipped 72 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.742 I/Choreographer( 2191): Skipped 45 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.832 I/Choreographer( 2191): Skipped 37 frames! The application may be doing too much work on its main thread.
07-31 05:30:08.882 I/SELENDROID( 2191): io.selendroid.server.handler.CaptureScreenshot#handle:32 - take screenshot command
07-31 05:30:08.912 I/Choreographer( 2191): Skipped 36 frames! The application may be doing too much work on its main thread.
07-31 05:30:09.072 D/dalvikvm( 2191): GC_FOR_ALLOC freed 945K, 18% free 7085K/8612K, paused 83ms, total 85ms
07-31 05:30:09.072 I/dalvikvm-heap( 2191): Grow heap (frag case) to 7.579MB for 552976-byte allocation
07-31 05:30:09.162 D/dalvikvm( 2191): GC_FOR_ALLOC freed <1K, 17% free 7625K/9156K, paused 84ms, total 84ms
07-31 05:30:09.602 I/Choreographer( 2191): Skipped 440 frames! The application may be doing too much work on its main thread.
07-31 05:30:09.972 I/Choreographer( 2191): Skipped 35 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.162 I/Choreographer( 2191): Skipped 37 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.312 D/dalvikvm( 2191): GC_FOR_ALLOC freed 1025K, 24% free 7219K/9420K, paused 86ms, total 87ms
07-31 05:30:10.442 I/Choreographer( 2191): Skipped 89 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.562 I/Choreographer( 2191): Skipped 73 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.682 I/Choreographer( 2191): Skipped 43 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.922 I/Choreographer( 2191): Skipped 55 frames! The application may be doing too much work on its main thread.
07-31 05:30:10.992 I/Choreographer( 2191): Skipped 38 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.202 E/NetdConnector( 373): NDC Command {254 bandwidth gettetherstats} took too long (553ms)
07-31 05:30:11.232 I/Choreographer( 2191): Skipped 60 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.392 I/Choreographer( 2191): Skipped 58 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.522 I/Choreographer( 2191): Skipped 65 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.572 I/Choreographer( 2191): Skipped 30 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.642 I/Choreographer( 2191): Skipped 37 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.732 I/Choreographer( 2191): Skipped 59 frames! The application may be doing too much work on its main thread.
07-31 05:30:11.902 I/Choreographer( 2191): Skipped 58 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.022 D/AndroidRuntime( 2264):
07-31 05:30:12.022 D/AndroidRuntime( 2264): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
07-31 05:30:12.052 D/AndroidRuntime( 2264): CheckJNI is ON
07-31 05:30:12.062 I/Choreographer( 2191): Skipped 72 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.092 D/MobileDataStateTracker( 373): default: setPolicyDataEnable(enabled=true)
07-31 05:30:12.212 I/Choreographer( 2191): Skipped 88 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.292 D/dalvikvm( 2264): Trying to load lib libjavacore.so 0x0
07-31 05:30:12.302 D/dalvikvm( 2264): Added shared lib libjavacore.so 0x0
07-31 05:30:12.332 I/Choreographer( 2191): Skipped 45 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.352 D/dalvikvm( 2264): Trying to load lib libnativehelper.so 0x0
07-31 05:30:12.372 D/dalvikvm( 2264): Added shared lib libnativehelper.so 0x0
07-31 05:30:12.372 D/dalvikvm( 2264): No JNI_OnLoad found in libnativehelper.so 0x0, skipping init
07-31 05:30:12.532 I/Choreographer( 2191): Skipped 47 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.602 I/Choreographer( 2191): Skipped 45 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.702 I/Choreographer( 2191): Skipped 66 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.922 I/Choreographer( 2191): Skipped 49 frames! The application may be doing too much work on its main thread.
07-31 05:30:12.952 D/dalvikvm( 2264): Note: class Landroid/app/ActivityManagerNative; has 179 unimplemented (abstract) methods
07-31 05:30:13.082 I/Choreographer( 2191): Skipped 106 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.202 I/Choreographer( 2191): Skipped 55 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.332 I/Choreographer( 2191): Skipped 43 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.462 I/Choreographer( 2191): Skipped 51 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.702 I/Choreographer( 2191): Skipped 49 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.792 I/Choreographer( 2191): Skipped 58 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.922 I/Choreographer( 2191): Skipped 53 frames! The application may be doing too much work on its main thread.
07-31 05:30:13.972 I/Choreographer( 2191): Skipped 33 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.192 I/Choreographer( 2191): Skipped 43 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.242 I/Choreographer( 2191): Skipped 31 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.342 I/Choreographer( 2191): Skipped 39 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.472 I/Choreographer( 2191): Skipped 37 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.542 I/Choreographer( 2191): Skipped 30 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.822 I/Choreographer( 2191): Skipped 41 frames! The application may be doing too much work on its main thread.
07-31 05:30:14.892 E/memtrack( 2264): Couldn't load memtrack module (No such file or directory)
07-31 05:30:14.892 E/android.os.Debug( 2264): failed to load memtrack module: -2
07-31 05:30:14.942 I/Choreographer( 2191): Skipped 51 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.052 I/Choreographer( 2191): Skipped 40 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.392 I/Choreographer( 2191): Skipped 50 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.462 I/Choreographer( 2191): Skipped 38 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.592 I/Choreographer( 2191): Skipped 55 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.672 I/Choreographer( 2191): Skipped 49 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.732 D/AndroidRuntime( 2264): Calling main entry com.android.commands.am.Am
07-31 05:30:15.782 I/Choreographer( 2191): Skipped 67 frames! The application may be doing too much work on its main thread.
07-31 05:30:15.812 I/ActivityManager( 373): Force stopping eu.inn.test appid=10057 user=0: from pid 2264
07-31 05:30:15.812 I/ActivityManager( 373): Killing 2191:eu.inn.test/u0a57 (adj 0): stop eu.inn.test
07-31 05:30:15.832 W/ActivityManager( 373): Force removing ActivityRecord{b307cb58 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity t6}: app died, no saved state
07-31 05:30:15.862 W/ActivityManager( 373): Crash of app eu.inn.test running instrumentation ComponentInfo{eu.inn.test.selendroid/io.selendroid.ServerInstrumentation}
07-31 05:30:15.892 I/ActivityManager( 373): Force stopping eu.inn.test appid=10057 user=0: finished inst
07-31 05:30:15.892 I/ActivityManager( 373): Force finishing activity ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6}
07-31 05:30:15.992 I/ActivityManager( 373): Force finishing activity ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6 f}
07-31 05:30:15.992 W/ActivityManager( 373): Duplicate finish request for ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6 f}
07-31 05:30:16.052 D/AndroidRuntime( 2264): Shutting down VM
07-31 05:30:16.082 D/dalvikvm( 2264): GC_CONCURRENT freed 93K, 15% free 553K/648K, paused 12ms+2ms, total 22ms
07-31 05:30:16.242 I/Choreographer( 929): Skipped 181 frames! The application may be doing too much work on its main thread.
07-31 05:30:16.382 D/dalvikvm( 929): GC_CONCURRENT freed 735K, 14% free 5240K/6080K, paused 5ms+6ms, total 203ms
07-31 05:30:16.632 W/ActivityManager( 373): Activity pause timeout for ActivityRecord{b3089208 u0 com.android.deskclock/.DeskClock t2}
07-31 05:30:16.682 I/Choreographer( 373): Skipped 44 frames! The application may be doing too much work on its main thread.
07-31 05:30:16.842 I/Choreographer( 373): Skipped 40 frames! The application may be doing too much work on its main thread.
07-31 05:30:17.102 V/TimerReceiver( 929): Received intent Intent { act=notif_in_use_cancel flg=0x10 cmp=com.android.deskclock/.timer.TimerReceiver }
07-31 05:30:17.112 I/Choreographer( 929): Skipped 542 frames! The application may be doing too much work on its main thread.
07-31 05:30:17.582 D/AndroidRuntime( 2276):
07-31 05:30:17.582 D/AndroidRuntime( 2276): >>>>>> AndroidRuntime START com.android.internal.os.RuntimeInit <<<<<<
07-31 05:30:17.592 D/AndroidRuntime( 2276): CheckJNI is ON
07-31 05:30:17.642 I/Choreographer( 373): Skipped 41 frames! The application may be doing too much work on its main thread.
07-31 05:30:17.802 D/dalvikvm( 2276): Trying to load lib libjavacore.so 0x0
07-31 05:30:17.852 D/dalvikvm( 2276): Added shared lib libjavacore.so 0x0
07-31 05:30:17.892 I/Choreographer( 373): Skipped 43 frames! The application may be doing too much work on its main thread.
07-31 05:30:17.902 D/dalvikvm( 2276): Trying to load lib libnativehelper.so 0x0
07-31 05:30:17.912 D/dalvikvm( 2276): Added shared lib libnativehelper.so 0x0
07-31 05:30:17.912 D/dalvikvm( 2276): No JNI_OnLoad found in libnativehelper.so 0x0, skipping init
07-31 05:30:17.982 I/Choreographer( 373): Skipped 53 frames! The application may be doing too much work on its main thread.
07-31 05:30:18.512 D/dalvikvm( 2276): Note: class Landroid/app/ActivityManagerNative; has 179 unimplemented (abstract) methods
07-31 05:30:18.582 I/Choreographer( 373): Skipped 34 frames! The application may be doing too much work on its main thread.
07-31 05:30:18.732 W/WindowManager( 373): Rebuild removed 4 windows but added 3
07-31 05:30:18.732 W/WindowManager( 373): java.lang.RuntimeException: here
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.rebuildAppWindowListLocked(WindowManagerService.java:8011)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.rebuildAppWindowListLocked(WindowManagerService.java:7947)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.handleAppTransitionReadyLocked(WindowManagerService.java:8430)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLockedInner(WindowManagerService.java:9193)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLockedLoop(WindowManagerService.java:8163)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLocked(WindowManagerService.java:8105)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.access$300(WindowManagerService.java:157)
07-31 05:30:18.732 W/WindowManager( 373): at com.android.server.wm.WindowManagerService$H.handleMessage(WindowManagerService.java:7139)
07-31 05:30:18.732 W/WindowManager( 373): at android.os.Handler.dispatchMessage(Handler.java:102)
07-31 05:30:18.732 W/WindowManager( 373): at android.os.Looper.loop(Looper.java:136)
07-31 05:30:18.732 W/WindowManager( 373): at android.os.HandlerThread.run(HandlerThread.java:61)
07-31 05:30:18.792 W/WindowManager( 373): This window was lost: Window{b3078848 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity}
07-31 05:30:18.792 W/WindowManager( 373): mDisplayId=0 mSession=Session{b3094b80 2191:u0a10057} mClient=android.os.BinderProxy@b3040798
07-31 05:30:18.792 W/WindowManager( 373): mOwnerUid=10057 mShowToOwnerOnly=true package=eu.inn.test appop=NONE
07-31 05:30:18.792 W/WindowManager( 373): mAttrs=WM.LayoutParams{(0,0)(fillxfill) sim=#110 ty=1 fl=#1810100 pfl=0x8 wanim=0x10302f5}
07-31 05:30:18.792 W/WindowManager( 373): Requested w=320 h=432 mLayoutSeq=215
07-31 05:30:18.792 W/WindowManager( 373): mBaseLayer=21000 mSubLayer=0 mAnimLayer=21020+0=21020 mLastLayer=21020
07-31 05:30:18.792 W/WindowManager( 373): mToken=AppWindowToken{b30aeb28 token=Token{b305fcd0 ActivityRecord{b307cb58 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity t6}}}
07-31 05:30:18.792 W/WindowManager( 373): mRootToken=AppWindowToken{b30aeb28 token=Token{b305fcd0 ActivityRecord{b307cb58 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity t6}}}
07-31 05:30:18.792 W/WindowManager( 373): mAppToken=AppWindowToken{b30aeb28 token=Token{b305fcd0 ActivityRecord{b307cb58 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity t6}}}
07-31 05:30:18.792 W/WindowManager( 373): mViewVisibility=0x0 mHaveFrame=true mObscured=false
07-31 05:30:18.792 W/WindowManager( 373): mSeq=0 mSystemUiVisibility=0x0
07-31 05:30:18.792 W/WindowManager( 373): mGivenContentInsets=[0,0][0,0] mGivenVisibleInsets=[0,0][0,0]
07-31 05:30:18.792 W/WindowManager( 373): mConfiguration={1.0 310mcc260mnc en_US ldltr sw320dp w320dp h407dp 160dpi smll port finger qwerty/v/v -nav/h s.5}
07-31 05:30:18.792 W/WindowManager( 373): mHasSurface=true mShownFrame=[0.0,0.0][320.0,432.0] isReadyForDisplay()=false
07-31 05:30:18.792 W/WindowManager( 373): mFrame=[0,0][320,432] last=[0,0][320,432]
07-31 05:30:18.792 W/WindowManager( 373): mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
07-31 05:30:18.792 W/WindowManager( 373): Frames: containing=[0,0][320,432] parent=[0,0][320,432]
07-31 05:30:18.792 W/WindowManager( 373): display=[0,0][320,432] overscan=[0,0][320,480]
07-31 05:30:18.792 W/WindowManager( 373): content=[0,25][320,432] visible=[0,25][320,432]
07-31 05:30:18.792 W/WindowManager( 373): decor=[0,25][320,432]
07-31 05:30:18.792 W/WindowManager( 373): Cur insets: overscan=[0,0][0,0] content=[0,25][0,0] visible=[0,25][0,0]
07-31 05:30:18.792 W/WindowManager( 373): Lst insets: overscan=[0,0][0,0] content=[0,25][0,0] visible=[0,25][0,0]
07-31 05:30:18.792 W/WindowManager( 373): WindowStateAnimator{b3087110 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity}:
07-31 05:30:18.792 W/WindowManager( 373): mSurface=Surface(name=eu.inn.test/eu.inn.sdk4game.impl.SignInActivity)
07-31 05:30:18.792 W/WindowManager( 373): mDrawState=HAS_DRAWN mLastHidden=true
07-31 05:30:18.792 W/WindowManager( 373): Surface: shown=false layer=21020 alpha=1.0 rect=(0.0,0.0) 320.0 x 432.0
07-31 05:30:18.832 W/WindowManager( 373): Current app token list:
07-31 05:30:18.832 V/WindowManager( 373): Display 0
07-31 05:30:18.842 V/WindowManager( 373): #1: Token{b301cbc0 ActivityRecord{b301cf18 u0 com.android.launcher/com.android.launcher2.Launcher t1}}
07-31 05:30:18.842 V/WindowManager( 373): #0: Token{b2f86b98 ActivityRecord{b3089208 u0 com.android.deskclock/.DeskClock t2}}
07-31 05:30:18.842 W/WindowManager( 373): Final window list:
07-31 05:30:18.842 V/WindowManager( 373): #0: Window{b3078d50 u0 SearchPanel}
07-31 05:30:18.842 V/WindowManager( 373): #1: Window{b3036e48 u0 NavigationBar}
07-31 05:30:18.842 V/WindowManager( 373): #2: Window{b30128e8 u0 StatusBar}
07-31 05:30:18.842 V/WindowManager( 373): #3: Window{b2fe70f0 u0 Keyguard}
07-31 05:30:18.892 V/WindowManager( 373): #4: Window{b2fca6f8 u0 KeyguardScrim}
07-31 05:30:18.892 V/WindowManager( 373): #5: Window{b306ccd0 u0 com.android.launcher/com.android.launcher2.Launcher}
07-31 05:30:18.902 V/WindowManager( 373): #6: Window{b309b828 u0 com.android.deskclock/com.android.deskclock.DeskClock}
07-31 05:30:18.902 V/WindowManager( 373): #7: Window{b307d298 u0 eu.inn.test/eu.inn.test.MainActivity}
07-31 05:30:18.902 V/WindowManager( 373): #8: Window{b2f56d48 u0 com.android.systemui.ImageWallpaper}
07-31 05:30:18.942 I/Choreographer( 530): Skipped 1392 frames! The application may be doing too much work on its main thread.
07-31 05:30:18.992 I/Choreographer( 373): Skipped 263 frames! The application may be doing too much work on its main thread.
07-31 05:30:18.992 W/InputMethodManagerService( 373): Focus gain on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@b3084d08 (uid=10020 pid=929)
07-31 05:30:19.102 V/TimerReceiver( 929): Received intent Intent { act=notif_in_use_show flg=0x10 cmp=com.android.deskclock/.timer.TimerReceiver }
07-31 05:30:19.132 I/Choreographer( 929): Skipped 314 frames! The application may be doing too much work on its main thread.
07-31 05:30:19.372 W/InputDispatcher( 373): channel 'b307d298 eu.inn.test/eu.inn.test.MainActivity (server)' ~ Consumer closed input channel or an error occurred. events=0x9
07-31 05:30:19.372 E/InputDispatcher( 373): channel 'b307d298 eu.inn.test/eu.inn.test.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
07-31 05:30:19.382 W/InputDispatcher( 373): channel 'b3078848 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity (server)' ~ Consumer closed input channel or an error occurred. events=0x9
07-31 05:30:19.382 E/InputDispatcher( 373): channel 'b3078848 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
07-31 05:30:19.502 W/WindowManager( 373): Rebuild removed 3 windows but added 2
07-31 05:30:19.502 W/WindowManager( 373): java.lang.RuntimeException: here
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.rebuildAppWindowListLocked(WindowManagerService.java:8011)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.rebuildAppWindowListLocked(WindowManagerService.java:7947)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.handleAnimatingStoppedAndTransitionLocked(WindowManagerService.java:8691)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLockedInner(WindowManagerService.java:9205)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLockedLoop(WindowManagerService.java:8163)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.performLayoutAndPlaceSurfacesLocked(WindowManagerService.java:8105)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService.access$300(WindowManagerService.java:157)
07-31 05:30:19.502 W/WindowManager( 373): at com.android.server.wm.WindowManagerService$H.handleMessage(WindowManagerService.java:7139)
07-31 05:30:19.502 W/WindowManager( 373): at android.os.Handler.dispatchMessage(Handler.java:102)
07-31 05:30:19.502 W/WindowManager( 373): at android.os.Looper.loop(Looper.java:136)
07-31 05:30:19.502 W/WindowManager( 373): at android.os.HandlerThread.run(HandlerThread.java:61)
07-31 05:30:19.572 W/WindowManager( 373): This window was lost: Window{b307d298 u0 eu.inn.test/eu.inn.test.MainActivity}
07-31 05:30:19.572 W/WindowManager( 373): mDisplayId=0 mSession=Session{b3094b80 2191:u0a10057} mClient=android.os.BinderProxy@b3094190
07-31 05:30:19.572 W/WindowManager( 373): mOwnerUid=10057 mShowToOwnerOnly=true package=eu.inn.test appop=NONE
07-31 05:30:19.572 W/WindowManager( 373): mAttrs=WM.LayoutParams{(0,0)(fillxfill) sim=#120 ty=1 fl=#1810100 pfl=0x8 wanim=0x10302f5}
07-31 05:30:19.572 W/WindowManager( 373): Requested w=320 h=432 mLayoutSeq=208
07-31 05:30:19.572 W/WindowManager( 373): mBaseLayer=21000 mSubLayer=0 mAnimLayer=21005+0=21005 mLastLayer=21015
07-31 05:30:19.572 W/WindowManager( 373): mToken=AppWindowToken{b30d1de8 token=Token{b2faa4b0 ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6}}}
07-31 05:30:19.572 W/WindowManager( 373): mRootToken=AppWindowToken{b30d1de8 token=Token{b2faa4b0 ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6}}}
07-31 05:30:19.572 W/WindowManager( 373): mAppToken=AppWindowToken{b30d1de8 token=Token{b2faa4b0 ActivityRecord{b307ea40 u0 eu.inn.test/.MainActivity t6}}}
07-31 05:30:19.572 W/WindowManager( 373): mViewVisibility=0x8 mHaveFrame=true mObscured=false
07-31 05:30:19.572 W/WindowManager( 373): mSeq=0 mSystemUiVisibility=0x0
07-31 05:30:19.572 W/WindowManager( 373): mGivenContentInsets=[0,0][0,0] mGivenVisibleInsets=[0,0][0,0]
07-31 05:30:19.572 W/WindowManager( 373): mConfiguration={1.0 310mcc260mnc en_US ldltr sw320dp w320dp h407dp 160dpi smll port finger qwerty/v/v -nav/h s.5}
07-31 05:30:19.572 W/WindowManager( 373): mHasSurface=false mShownFrame=[0.0,0.0][320.0,432.0] isReadyForDisplay()=false
07-31 05:30:19.572 W/WindowManager( 373): mFrame=[0,0][320,432] last=[0,0][320,432]
07-31 05:30:19.572 W/WindowManager( 373): mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
07-31 05:30:19.572 W/WindowManager( 373): Frames: containing=[0,0][320,432] parent=[0,0][320,432]
07-31 05:30:19.572 W/WindowManager( 373): display=[0,0][320,432] overscan=[0,0][320,480]
07-31 05:30:19.572 W/WindowManager( 373): content=[0,25][320,432] visible=[0,25][320,432]
07-31 05:30:19.572 W/WindowManager( 373): decor=[0,25][320,432]
07-31 05:30:19.572 W/WindowManager( 373): Cur insets: overscan=[0,0][0,0] content=[0,25][0,0] visible=[0,25][0,0]
07-31 05:30:19.572 W/WindowManager( 373): Lst insets: overscan=[0,0][0,0] content=[0,25][0,0] visible=[0,25][0,0]
07-31 05:30:19.572 W/WindowManager( 373): WindowStateAnimator{b301e060 eu.inn.test/eu.inn.test.MainActivity}:
07-31 05:30:19.572 W/WindowManager( 373): mShownAlpha=1.0 mAlpha=1.0 mLastAlpha=0.0
07-31 05:30:19.582 W/WindowManager( 373): Current app token list:
07-31 05:30:19.582 V/WindowManager( 373): Display 0
07-31 05:30:19.582 V/WindowManager( 373): #1: Token{b301cbc0 ActivityRecord{b301cf18 u0 com.android.launcher/com.android.launcher2.Launcher t1}}
07-31 05:30:19.582 V/WindowManager( 373): #0: Token{b2f86b98 ActivityRecord{b3089208 u0 com.android.deskclock/.DeskClock t2}}
07-31 05:30:19.582 W/WindowManager( 373): Final window list:
07-31 05:30:19.582 V/WindowManager( 373): #0: Window{b3078d50 u0 SearchPanel}
07-31 05:30:19.582 V/WindowManager( 373): #1: Window{b3036e48 u0 NavigationBar}
07-31 05:30:19.592 V/WindowManager( 373): #2: Window{b30128e8 u0 StatusBar}
07-31 05:30:19.592 V/WindowManager( 373): #3: Window{b2fe70f0 u0 Keyguard}
07-31 05:30:19.592 V/WindowManager( 373): #4: Window{b2fca6f8 u0 KeyguardScrim}
07-31 05:30:19.592 V/WindowManager( 373): #5: Window{b306ccd0 u0 com.android.launcher/com.android.launcher2.Launcher}
07-31 05:30:19.592 V/WindowManager( 373): #6: Window{b309b828 u0 com.android.deskclock/com.android.deskclock.DeskClock}
07-31 05:30:19.592 V/WindowManager( 373): #7: Window{b2f56d48 u0 com.android.systemui.ImageWallpaper}
07-31 05:30:19.702 W/InputDispatcher( 373): Attempted to unregister already unregistered input channel 'b307d298 eu.inn.test/eu.inn.test.MainActivity (server)'
07-31 05:30:19.702 I/WindowState( 373): WIN DEATH: Window{b307d298 u0 eu.inn.test/eu.inn.test.MainActivity}
07-31 05:30:19.722 W/InputDispatcher( 373): Attempted to unregister already unregistered input channel 'b3078848 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity (server)'
07-31 05:30:19.722 I/WindowState( 373): WIN DEATH: Window{b3078848 u0 eu.inn.test/eu.inn.sdk4game.impl.SignInActivity}
07-31 05:30:19.752 I/Choreographer( 373): Skipped 57 frames! The application may be doing too much work on its main thread.
07-31 05:30:20.012 I/Choreographer( 929): Skipped 131 frames! The application may be doing too much work on its main thread.
07-31 05:30:20.252 W/InputMethodManagerService( 373): Got RemoteException sending setActive(false) notification to pid 2191 uid 10057
07-31 05:30:20.272 I/Choreographer( 373): Skipped 47 frames! The application may be doing too much work on its main thread.
07-31 05:30:20.322 I/Choreographer( 373): Skipped 31 frames! The application may be doing too much work on its main thread.
07-31 05:30:20.402 W/Binder ( 490): Caught a RuntimeException from the binder stub implementation.
07-31 05:30:20.402 W/Binder ( 490): java.lang.NullPointerException
07-31 05:30:20.402 W/Binder ( 490): at android.inputmethodservice.IInputMethodWrapper.setSessionEnabled(IInputMethodWrapper.java:280)
07-31 05:30:20.402 W/Binder ( 490): at com.android.internal.view.IInputMethod$Stub.onTransact(IInputMethod.java:129)
07-31 05:30:20.402 W/Binder ( 490): at android.os.Binder.execTransact(Binder.java:404)
07-31 05:30:20.402 W/Binder ( 490): at dalvik.system.NativeStart.run(Native Method)
07-31 05:30:20.452 D/MobileDataStateTracker( 373): default: setPolicyDataEnable(enabled=true)
07-31 05:30:20.522 D/ConnectivityService( 373): Sampling interval elapsed, updating statistics ..
07-31 05:30:20.532 E/memtrack( 2276): Couldn't load memtrack module (No such file or directory)
07-31 05:30:20.532 E/android.os.Debug( 2276): failed to load memtrack module: -2
07-31 05:30:20.672 D/ConnectivityService( 373): Done.
07-31 05:30:20.672 D/ConnectivityService( 373): Setting timer for 720seconds
07-31 05:30:20.722 V/BackupManagerService( 373): Running a backup pass
07-31 05:30:20.742 V/BackupManagerService( 373): clearing pending backups
07-31 05:30:20.742 V/PerformBackupTask( 373): Beginning backup of 7 targets
07-31 05:30:20.752 I/PerformBackupTask( 373): Initializing (wiping) backup state and transport storage
07-31 05:30:20.792 D/BackupManagerService( 373): Now staging backup of android
07-31 05:30:21.002 D/BackupManagerService( 373): Now staging backup of com.android.providers.settings
07-31 05:30:21.012 D/BackupManagerService( 373): Now staging backup of com.android.providers.userdictionary
07-31 05:30:21.042 D/BackupManagerService( 373): Now staging backup of com.android.dialer
07-31 05:30:21.072 D/BackupManagerService( 373): Now staging backup of com.android.sharedstoragebackup
07-31 05:30:21.112 D/BackupManagerService( 373): Now staging backup of com.android.browser
07-31 05:30:21.152 V/LocalTransport( 373): wiping all data
07-31 05:30:21.152 D/BackupManagerService( 373): Now staging backup of com.android.calendar
07-31 05:30:21.222 D/PerformBackupTask( 373): invokeAgentForBackup on @pm@
07-31 05:30:21.222 E/PerformBackupTask( 373): Error invoking for backup on @pm@
07-31 05:30:21.262 I/PerformBackupTask( 373): Backup pass finished.
07-31 05:30:21.262 E/PerformBackupTask( 373): Duplicate finish
07-31 05:30:21.312 D/AndroidRuntime( 2276): Calling main entry com.android.commands.pm.Pm
07-31 05:30:21.372 I/ActivityManager( 373): Force stopping eu.inn.test appid=10057 user=-1: uninstall pkg
07-31 05:30:21.422 W/PackageManager( 373): Couldn't delete native library directory /data/app-lib/eu.inn.test
07-31 05:30:21.542 D/keystore( 54): calling clear_uid in state: 3
07-31 05:30:21.542 I/ActivityManager( 373): Force stopping eu.inn.test appid=10057 user=0: pkg removed
07-31 05:30:21.722 I/InputReader( 373): Reconfiguring input devices. changes=0x00000010
07-31 05:30:21.782 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:21.782 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:21.792 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:21.792 I/PackageManager( 373): Scheme: "sms"
07-31 05:30:21.932 D/dalvikvm( 373): GC_EXPLICIT freed 785K, 14% free 5711K/6608K, paused 8ms+11ms, total 356ms
07-31 05:30:21.932 D/dalvikvm( 373): WAIT_FOR_CONCURRENT_GC blocked 89ms
07-31 05:30:21.952 D/dalvikvm( 373): WAIT_FOR_CONCURRENT_GC blocked 57ms
07-31 05:30:22.052 D/BackupManagerService( 373): Received broadcast Intent { act=android.intent.action.PACKAGE_REMOVED dat=package:eu.inn.test flg=0x4000010 (has extras) }
07-31 05:30:22.052 V/BackupManagerService( 373): removePackageParticipantsLocked: uid=10057 #1
07-31 05:30:22.122 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.122 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.122 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.132 I/PackageManager( 373): Scheme: "smsto"
07-31 05:30:22.212 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.212 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.212 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.222 I/PackageManager( 373): Scheme: "mms"
07-31 05:30:22.312 D/dalvikvm( 515): GC_CONCURRENT freed 462K, 15% free 3301K/3884K, paused 14ms+5ms, total 130ms
07-31 05:30:22.362 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.362 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.362 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.372 I/PackageManager( 373): Scheme: "mmsto"
07-31 05:30:22.432 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.432 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.432 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.442 I/PackageManager( 373): Scheme: "sms"
07-31 05:30:22.502 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.502 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.502 I/PackageManager( 373): Scheme: "smsto"
07-31 05:30:22.502 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.532 D/Documents( 1481): Used cached roots for com.android.providers.downloads.documents
07-31 05:30:22.632 D/dalvikvm( 373): GC_FOR_ALLOC freed 572K, 15% free 5671K/6608K, paused 114ms, total 116ms
07-31 05:30:22.682 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.682 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.682 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.692 I/PackageManager( 373): Scheme: "mms"
07-31 05:30:22.732 I/PackageManager( 373): Action: "android.intent.action.SENDTO"
07-31 05:30:22.732 I/PackageManager( 373): Adding preferred activity ComponentInfo{com.android.mms/com.android.mms.ui.ComposeMessageActivity} for user 0 :
07-31 05:30:22.742 I/PackageManager( 373): Category: "android.intent.category.DEFAULT"
07-31 05:30:22.742 I/PackageManager( 373): Scheme: "mmsto"
07-31 05:30:22.792 D/Documents( 1481): Loading roots for com.android.externalstorage.documents
07-31 05:30:22.872 D/dalvikvm( 515): GC_FOR_ALLOC freed 368K, 15% free 3324K/3884K, paused 52ms, total 52ms
07-31 05:30:22.932 D/dalvikvm( 515): GC_CONCURRENT freed 29K, 15% free 3327K/3884K, paused 5ms+3ms, total 55ms
07-31 05:30:22.952 I/ActivityManager( 373): Delay finish: com.android.providers.contacts/.PackageIntentReceiver
07-31 05:30:23.022 D/VoicemailCleanupService( 577): Cleaning up data for package: eu.inn.test
07-31 05:30:23.042 D/Documents( 1481): Used cached roots for com.android.providers.media.documents
07-31 05:30:23.042 D/Documents( 1481): Update found 5 roots in 1058ms
07-31 05:30:23.272 D/MobileDataStateTracker( 373): default: setPolicyDataEnable(enabled=true)
07-31 05:30:23.302 I/ActivityManager( 373): Resuming delayed broadcast
07-31 05:30:23.322 W/ContextImpl( 1465): Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1479 android.content.ContextWrapper.startService:494 android.content.ContextWrapper.startService:494 com.android.keychain.KeyChainBroadcastReceiver.onReceive:12 android.app.ActivityThread.handleReceiver:2419
07-31 05:30:23.372 I/ActivityManager( 373): Delay finish: com.android.keychain/.KeyChainBroadcastReceiver
07-31 05:30:23.462 I/ActivityManager( 373): Resuming delayed broadcast
07-31 05:30:23.592 D/dalvikvm( 1481): GC_CONCURRENT freed 409K, 15% free 2844K/3328K, paused 4ms+15ms, total 87ms
07-31 05:30:23.702 I/LatinIME:LogUtils( 490): Dictionary info: dictionary = main:en ; version = 42 ; date = 1381226429
07-31 05:30:23.822 D/dalvikvm( 373): GC_EXPLICIT freed 473K, 15% free 5669K/6608K, paused 92ms+15ms, total 834ms
07-31 05:30:23.832 D/AndroidRuntime( 2276): Shutting down VM
07-31 05:30:23.882 D/dalvikvm( 2276): GC_CONCURRENT freed 94K, 15% free 558K/656K, paused 2ms+2ms, total 35ms
07-31 05:30:24.072 I/Choreographer( 530): Skipped 33 frames! The application may be doing too much work on its main thread.
07-31 05:32:26.502 D/MDnsDS ( 46): MDnsSdListener::Monitor poll timed out
07-31 05:32:26.502 D/MDnsDS ( 46): Going to poll with pollCount 1

@evgenytkachenko
Copy link
Author

And the same

info: Uninstalling eu.inn.test
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 shell "am force-stop eu.inn.test"
debug: executing: "/usr/local/adt/sdk/platform-tools/adb" -s emulator-5554 uninstall eu.inn.test
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
info: [SELENDROID] mSeq=0 mSystemUiVisibility=0x0
info: [SELENDROID] mSystemDecorRect=[0,25][320,432] last=[0,25][320,432]
debug: App was uninstalled
info: Stopping selendroid server
info: Making http request with opts: {"url":"http://localhost:4444/wd/hub/session/5c78566c-0d0d-6c5a-1887-d99d0ff4e715","method":"DELETE"}
info: Cleaning up appium session
info: Responding to client with error: {"status":13,"value":{"message":"An unknown server-side error occurred while processing the command. (Original error: Device exited with code: 1)","origValue":"Device exited with code: 1"},"sessionId":null}

@evgenytkachenko
Copy link
Author

Is It possible to solve It ?

@jlipps
Copy link
Member

jlipps commented Aug 5, 2014

Not sure. This isn't the real issue your test is failing, however. The real issue seems to be that the element isn't found.

Still, I'm adding this to the 1.2.2 milestone to fix the bug that ending the session results in a status 13 error.

@jlipps jlipps added this to the Appium 1.2.2 milestone Aug 5, 2014
@imurchie
Copy link
Contributor

imurchie commented Aug 6, 2014

This is reproducible with fullReset turned on.

@lock
Copy link

lock bot commented May 2, 2019

This thread has been automatically locked since there has not been any recent activity after it was closed. Please open a new issue for related bugs.

@lock lock bot locked and limited conversation to collaborators May 2, 2019
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

Successfully merging a pull request may close this issue.

3 participants