Selenium grid 3.0.1 marking the node as down

Switched from selenium-server-standalone 2.53.0 to 3.0.1
Faced with grid issue:

12:06:10.365 DEBUG - Failed to check status of node: Read timed out
12:06:10.365 INFO - Marking the node http://10.100.128.140:4733 as down: cannot reach the node for 2 tries

No issues with tests, but I’m not facing such error with Grid 2.53.0.
It would be nice to know why i’m facing such issue

Grid logs:

java -jar selenium-server-standalone-3.0.1.jar -role hub -port 4444 -debug
12:05:33.319 INFO - Selenium build info: version: ‘3.0.1’, revision: ‘1969d75’
12:05:33.320 INFO - Launching Selenium Grid hub
2017-02-13 12:05:33.741:INFO::main: Logging initialized @653ms
12:05:33.748 INFO - Will listen on 4444
2017-02-13 12:05:33.775:INFO:osjs.Server:main: jetty-9.2.15.v20160210
2017-02-13 12:05:33.793:INFO:osjsh.ContextHandler:main: Started o.s.j.s.ServletContextHandler@4e41089d{/,null,AVAILABLE}
2017-02-13 12:05:33.800:INFO:osjs.ServerConnector:main: Started ServerConnector@80ec1f8{HTTP/1.1}{0.0.0.0:4444}
2017-02-13 12:05:33.801:INFO:osjs.Server:main: Started @712ms
12:05:33.801 INFO - Nodes should register to http://10.100.128.140:4444/grid/register/
12:05:33.801 INFO - Selenium Grid hub is up and running
12:05:40.300 DEBUG - getting the following registration request : {“capabilities”:[{“browserName”:“Galaxy_Tab_S_2”,“version”:“6.0.1”,“maxInstances”:1,“platform”:“ANDROID”}],“configuration”:{“cleanUpCycle”:2000,“timeout”:30000,“proxy”:“org.openqa.grid.selenium.proxy.DefaultRemoteProxy”,“host”:“10.100.128.140”,“role”:“node”,“port”:4733,“url”:“http://10.100.128.140:4733/wd/hub",“maxSession”:1,“register”:true,“registerCycle”:10000,“hubPort”:4444,“hubHost”:“10.100.128.140”,“hub”:“http://10.100.128.140:4444/grid/register”,“id”:"http://10.100.128.140:4733”}}
12:05:40.322 DEBUG - Using class org.openqa.grid.selenium.proxy.DefaultRemoteProxy
12:05:40.324 DEBUG - starting cleanup thread
12:05:40.324 DEBUG - cleanup thread starting…
12:05:40.325 INFO - Registered a node http://10.100.128.140:4733
12:05:40.327 DEBUG - proxy added http://10.100.128.140:4733
12:05:48.599 INFO - Got a request to create a new session: Capabilities [{app=/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk, appPackage=com._lenovocom.android, appActivity=com.[hide].app.activity.MainActivity, clearSystemFiles=true, newCommandTimeout=40, autoGrantPermissions=true, udid=33003dcc58748265, platformName=Android, deviceName=Tablet_Galaxy_S2, fullReset=true}]
12:05:48.600 DEBUG - Available nodes: [http://10.100.128.140:4733]
12:05:48.601 DEBUG - Trying to create a new session on node http://10.100.128.140:4733
12:05:48.601 INFO - Trying to create a new session on test slot {browserName=Galaxy_Tab_S_2, maxInstances=1, version=6.0.1, platform=ANDROID}
12:05:48.611 DEBUG - Closing connections idle longer than 100 MILLISECONDS
12:05:48.623 DEBUG - CookieSpec selected: default
12:05:48.631 DEBUG - Auth cache not set in the context
12:05:48.632 DEBUG - Connection request: [route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
12:05:48.642 DEBUG - Connection leased: [id: 0][route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
12:05:48.643 DEBUG - Opening connection {}->http://10.100.128.140:4733
12:05:48.644 DEBUG - Connecting to /10.100.128.140:4733
12:05:48.645 DEBUG - Connection established 10.100.128.140:49648<->10.100.128.140:4733
12:05:48.646 DEBUG - http-outgoing-0: set socket timeout to 0
12:05:48.646 DEBUG - Executing request POST /wd/hub/session HTTP/1.1
12:05:48.646 DEBUG - Target auth state: UNCHALLENGED
12:05:48.646 DEBUG - Proxy auth state: UNCHALLENGED
12:05:48.648 DEBUG - http-outgoing-0 >> POST /wd/hub/session HTTP/1.1
12:05:48.648 DEBUG - http-outgoing-0 >> Connection: keep-alive
12:05:48.648 DEBUG - http-outgoing-0 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_111)
12:05:48.648 DEBUG - http-outgoing-0 >> Host: 10.100.128.140:4444
12:05:48.649 DEBUG - http-outgoing-0 >> Accept-Encoding: gzip,deflate
12:05:48.649 DEBUG - http-outgoing-0 >> Content-Type: application/json; charset=UTF-8
12:05:48.649 DEBUG - http-outgoing-0 >> Content-Length: 849
12:05:48.649 DEBUG - http-outgoing-0 >> “POST /wd/hub/session HTTP/1.1[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “Connection: keep-alive[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_111)[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “Host: 10.100.128.140:4444[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “Accept-Encoding: gzip,deflate[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “Content-Type: application/json; charset=UTF-8[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “Content-Length: 849[\r][\n]”
12:05:48.650 DEBUG - http-outgoing-0 >> “[\r][\n]”
12:05:48.651 DEBUG - http-outgoing-0 >> “{“capabilities”: {“desiredCapabilities”: {“app”:”/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},“requiredCapabilities”: {}},“desiredCapabilities”: {“app”:"/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},“requiredCapabilities”: {}}"
12:05:50.327 DEBUG - Closing connections idle longer than 100 MILLISECONDS
12:05:50.328 DEBUG - CookieSpec selected: default
12:05:50.328 DEBUG - Auth cache not set in the context
12:05:50.328 DEBUG - Connection request: [route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
12:05:50.328 DEBUG - Connection leased: [id: 1][route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 2 of 2000; total allocated: 2 of 2000]
12:05:50.328 DEBUG - Opening connection {}->http://10.100.128.140:4733
12:05:50.329 DEBUG - Connecting to /10.100.128.140:4733
12:05:50.329 DEBUG - Connection established 10.100.128.140:49779<->10.100.128.140:4733
12:05:50.329 DEBUG - http-outgoing-1: set socket timeout to 5000
12:05:50.329 DEBUG - Executing request GET /wd/hub/status HTTP/1.1
12:05:50.329 DEBUG - Target auth state: UNCHALLENGED
12:05:50.329 DEBUG - Proxy auth state: UNCHALLENGED
12:05:50.329 DEBUG - http-outgoing-1 >> GET /wd/hub/status HTTP/1.1
12:05:50.329 DEBUG - http-outgoing-1 >> Host: 10.100.128.140:4733
12:05:50.329 DEBUG - http-outgoing-1 >> Connection: Keep-Alive
12:05:50.330 DEBUG - http-outgoing-1 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_72)
12:05:50.330 DEBUG - http-outgoing-1 >> Accept-Encoding: gzip,deflate
12:05:50.330 DEBUG - http-outgoing-1 >> “GET /wd/hub/status HTTP/1.1[\r][\n]”
12:05:50.330 DEBUG - http-outgoing-1 >> “Host: 10.100.128.140:4733[\r][\n]”
12:05:50.330 DEBUG - http-outgoing-1 >> “Connection: Keep-Alive[\r][\n]”
12:05:50.330 DEBUG - http-outgoing-1 >> “User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_72)[\r][\n]”
12:05:50.330 DEBUG - http-outgoing-1 >> “Accept-Encoding: gzip,deflate[\r][\n]”
12:05:50.330 DEBUG - http-outgoing-1 >> “[\r][\n]”
12:05:55.336 DEBUG - http-outgoing-1 << “[read] I/O error: Read timed out”
12:05:55.336 DEBUG - http-outgoing-1: Close connection
12:05:55.336 DEBUG - http-outgoing-1: Shutdown connection
12:05:55.336 DEBUG - Connection discarded
12:05:55.336 DEBUG - Connection released: [id: 1][route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
12:05:55.337 DEBUG - Failed to check status of node: Read timed out
12:06:05.337 DEBUG - Closing connections idle longer than 100 MILLISECONDS
12:06:05.340 DEBUG - CookieSpec selected: default
12:06:05.340 DEBUG - Auth cache not set in the context
12:06:05.341 DEBUG - Connection request: [route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
12:06:05.341 DEBUG - Connection leased: [id: 2][route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 2 of 2000; total allocated: 2 of 2000]
12:06:05.341 DEBUG - Opening connection {}->http://10.100.128.140:4733
12:06:05.342 DEBUG - Connecting to /10.100.128.140:4733
12:06:05.342 DEBUG - Connection established 10.100.128.140:50854<->10.100.128.140:4733
12:06:05.355 DEBUG - http-outgoing-2: set socket timeout to 5000
12:06:05.355 DEBUG - Executing request GET /wd/hub/status HTTP/1.1
12:06:05.355 DEBUG - Target auth state: UNCHALLENGED
12:06:05.355 DEBUG - Proxy auth state: UNCHALLENGED
12:06:05.356 DEBUG - http-outgoing-2 >> GET /wd/hub/status HTTP/1.1
12:06:05.356 DEBUG - http-outgoing-2 >> Host: 10.100.128.140:4733
12:06:05.356 DEBUG - http-outgoing-2 >> Connection: Keep-Alive
12:06:05.356 DEBUG - http-outgoing-2 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_72)
12:06:05.357 DEBUG - http-outgoing-2 >> Accept-Encoding: gzip,deflate
12:06:05.357 DEBUG - http-outgoing-2 >> “GET /wd/hub/status HTTP/1.1[\r][\n]”
12:06:05.357 DEBUG - http-outgoing-2 >> “Host: 10.100.128.140:4733[\r][\n]”
12:06:05.357 DEBUG - http-outgoing-2 >> “Connection: Keep-Alive[\r][\n]”
12:06:05.358 DEBUG - http-outgoing-2 >> “User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_72)[\r][\n]”
12:06:05.358 DEBUG - http-outgoing-2 >> “Accept-Encoding: gzip,deflate[\r][\n]”
12:06:05.358 DEBUG - http-outgoing-2 >> “[\r][\n]”
12:06:10.363 DEBUG - http-outgoing-2 << “[read] I/O error: Read timed out”
12:06:10.364 DEBUG - http-outgoing-2: Close connection
12:06:10.364 DEBUG - http-outgoing-2: Shutdown connection
12:06:10.364 DEBUG - Connection discarded
12:06:10.364 DEBUG - Connection released: [id: 2][route: {}->http://10.100.128.140:4733][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
12:06:10.365 DEBUG - Failed to check status of node: Read timed out
12:06:10.365 INFO - Marking the node http://10.100.128.140:4733 as down: cannot reach the node for 2 tries

Appium logs:

appium --address 10.100.128.140 -p 4733 -bp 4734 --nodeconfig nodeS2.json
[Appium] Welcome to Appium v1.6.4-beta
[Appium] Non-default server args:
[Appium] address: ‘10.100.128.140’
[Appium] port: 4733
[Appium] bootstrapPort: 4734
[Appium] nodeconfig: ‘nodeS2.json’
[debug] [Appium] Starting auto register thread for grid. Will try to register every 10000 ms.
[Appium] Appium REST http interface listener started on 10.100.128.140:4733
[debug] [Appium] Appium successfully registered with the grid on 10.100.128.140:4444
[HTTP] --> POST /wd/hub/session {“capabilities”:{“desiredCapabilities”:{“app”:"/home/droidautotests/Downloads/com.[hide].android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},“requiredCapabilities”:{}},“desiredCapabilities”:{“app”:"/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},“requiredCapabilities”:{}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{“app”:"/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},{},{“desiredCapabilities”:{“app”:"/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk",“appPackage”:“com.[hide]lenovocom.android”,“appActivity”:“com.[hide].app.activity.MainActivity”,“clearSystemFiles”:true,“newCommandTimeout”:40,“autoGrantPermissions”:true,“udid”:“33003dcc58748265”,“platformName”:“Android”,“deviceName”:“Tablet_Galaxy_S2”,“fullReset”:true},“requiredCapabilities”:{}},null,null]
[Appium] Creating new AndroidDriver (v1.11.3) session
[Appium] Capabilities:
[Appium] app: ‘/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk’
[Appium] appPackage: ‘com.[hide]lenovocom.android’
[Appium] appActivity: ‘com.[hide].app.activity.MainActivity’
[Appium] clearSystemFiles: true
[Appium] newCommandTimeout: 40
[Appium] autoGrantPermissions: true
[Appium] udid: ‘33003dcc58748265’
[Appium] platformName: ‘Android’
[Appium] deviceName: ‘Tablet_Galaxy_S2’
[Appium] fullReset: true
[debug] [AndroidDriver] AndroidDriver version: 1.11.3
[BaseDriver] The following capabilities were provided, but are not recognized by appium: autoGrantPermissions.
[BaseDriver] Session created with session id: c12232ff-80bf-4f61-a3d7-a649f8f64fca
[debug] [AndroidDriver] Getting Java version
[AndroidDriver] Java version is: 1.8.0_72
[ADB] Checking whether adb is present
[ADB] Using adb from /home/droidautotests/AndroidSdk/platform-tools/adb
[AndroidDriver] Retrieving device list
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices…
[HTTP] --> GET /wd/hub/status {}
[debug] [MJSONWP] Calling AppiumDriver.getStatus() with args: []
[debug] [ADB] 2 device(s) connected
[AndroidDriver] Using device: 33003dcc58748265
[ADB] Checking whether adb is present
[ADB] Using adb from /home/droidautotests/AndroidSdk/platform-tools/adb
[debug] [ADB] Setting device id to 33003dcc58748265
[BaseDriver] Using local app ‘/home/droidautotests/Downloads/com.[hide]lenovocom.android-2.4.2-204020-release.apk’
[debug] [AndroidDriver] Checking whether app is actually present
[AndroidDriver] Starting Android session
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“wait-for-device”]
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“echo”,“ping”]
[debug] [Logcat] Starting logcat capture
[debug] [AndroidDriver] Pushing settings apk to device…
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“install”,"/home/droidautotests/node-v6.9.5-linux-x64/lib/node_modules/appium/node_modules/io.appium.settings/bin/settings_apk-debug.apk"]
[debug] [AndroidDriver] Pushing unlock helper app to device…
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“install”,"/home/droidautotests/node-v6.9.5-linux-x64/lib/node_modules/appium/node_modules/appium-unlock/bin/unlock_apk-debug.apk"]
[ADB] Getting device platform version
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“getprop”,“ro.build.version.release”]
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“wm”,“size”]
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“getprop”,“ro.product.model”]
[debug] [ADB] Current device property ‘ro.product.model’: SM-T715
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“getprop”,“ro.product.manufacturer”]
[debug] [ADB] Current device property ‘ro.product.manufacturer’: samsung
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“dumpsys”,“window”]
[AndroidDriver] Screen already unlocked, doing nothing
[debug] [ADB] Uninstalling com.[hide]lenovocom.android
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“am”,“force-stop”,“com.[hide]lenovocom.android”]
[HTTP] <-- GET /wd/hub/status - - ms - -
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“uninstall”,“com.[hide]lenovocom.android”]
[ADB] App was uninstalled
[AndroidDriver] Remote apk path is /data/local/tmp/a15f2f482324d1d04d06d3f5685b0fc1.apk
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“ls”,"/data/local/tmp/a15f2f482324d1d04d06d3f5685b0fc1.apk"]
[debug] [AndroidDriver] Checking if app is installed
[debug] [ADB] Getting install status for com.[hide]lenovocom.android
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“pm”,“list”,“packages”,“com.[hide]lenovocom.android”]
[debug] [ADB] App is not installed
[AndroidDriver] Apk is not yet installed
[AndroidDriver] installing apk from remote
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“mkdir”,"-p","/data/local/tmp"]
[AndroidDriver] Clearing out any existing remote apks with the same hash
[debug] [AndroidDriver] Removing any old apks
[debug] [AndroidDriver] Except [“a15f2f482324d1d04d06d3f5685b0fc1”]
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“ls”,"/data/local/tmp/*.apk"]
[debug] [ADB] Uninstalling com.[hide]lenovocom.android
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“am”,“force-stop”,“com.[hide]lenovocom.android”]
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“uninstall”,“com.[hide]lenovocom.android”]
[ADB] App was not uninstalled, maybe it wasn’t on device?
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“pm”,“install”,"-r","/data/local/tmp/a15f2f482324d1d04d06d3f5685b0fc1.apk"]
[HTTP] --> GET /wd/hub/status {}
[debug] [MJSONWP] Calling AppiumDriver.getStatus() with args: []
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“getprop”,“ro.build.version.sdk”]
[debug] [ADB] Device API level: 23
[ADB] Checking whether aapt is present
[ADB] Using aapt from /home/droidautotests/AndroidSdk/build-tools/23.0.3/aapt
[ADB] Extracting package and launch activity from manifest
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“pm”,“dump”,“com.[hide]lenovocom.android”]
[debug] [ADB] Getting connected devices…
[debug] [ADB] 2 device(s) connected
[debug] [ADB] Running ‘/home/droidautotests/AndroidSdk/platform-tools/adb’ with args: ["-P",5037,"-s",“33003dcc58748265”,“shell”,“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.INTERNET”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.ACCESS_NETWORK_STATE”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.ACCESS_WIFI_STATE”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.CHANGE_WIFI_MULTICAST_STATE”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.WRITE_EXTERNAL_STORAGE”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.WAKE_LOCK”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.ACCESS_FINE_LOCATION”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.NFC”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.VIBRATE”,";",“pm”,“grant”,“com.[hide]lenovocom.android”,“android.permission.READ_EXTERNAL_STORAGE”,";"]
[HTTP] <-- GET /wd/hub/status - - ms - -
[HTTP] <-- POST /wd/hub/session - - ms - -
^C[Appium] Received SIGINT - shutting down
[Logcat] Logcat terminated with code null, signal SIGINT

NodeConfig:

{
“capabilities”:
[{
“browserName”: “Galaxy_Tab_S_2”,
“version”: “6.0.1”,
“maxInstances”: 1,
“platform”: “ANDROID”
}],
“configuration”:
{
“cleanUpCycle”: 2000,
“timeout”: 30000,
“proxy”: “org.openqa.grid.selenium.proxy.DefaultRemoteProxy”,
“host”: “10.100.128.140”,
“role”: “node”,
“port”: 4733,
“url”: “http://10.100.128.140:4733/wd/hub”,
“maxSession”: 1,
“register”: true,
“registerCycle”: 10000,
“hubPort”: 4444,
“hubHost”: “10.100.128.140”,
“hub”: “http://10.100.128.140:4444/grid/register
}
}

This looks like a bug in appium. Its not responding to the status requests. I saw this in the early 1.6 betas (Appium wouldn’t respond to GET /wd/hub/status requests when it was busy installing the app) but it got fixed. Maybe its come back again. You could try workaround it by changing the grid settings to have a longer period before marking nodes as down. Maybe try set this in your configuration section of your node config

“unregisterIfStillDownAfter”: 60000,

assuming 60 seconds is enough time to install the app. Also the nodeStatusCheckTimeout set to 60000 might achieve the same thing if that doesn’t work.

We use SeleniumGridExtras which is an appium customization of the seleniumGrid so its possible the timeouts I mentioned are unique to that, but I’m not sure.

1 Like

Thank you for your fast and clear help.
“nodeStatusCheckTimeout” fixed this behavior.
And I’ll research SeleniumGridExtras asap, didn’t hear about it.