2022-02-15 12:53:54.702 INFO 19400 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 19400 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 12:53:54.705 INFO 19400 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 12:53:57.102 INFO 19400 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 12:53:57.121 INFO 19400 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 12:53:57.121 INFO 19400 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 12:53:57.285 INFO 19400 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 12:53:57.286 INFO 19400 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 2442 ms
2022-02-15 12:57:45.678 INFO 16820 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 16820 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 12:57:45.680 INFO 16820 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 12:57:47.451 INFO 16820 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 12:57:47.463 INFO 16820 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 12:57:47.464 INFO 16820 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 12:57:47.614 INFO 16820 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 12:57:47.615 INFO 16820 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 1866 ms
2022-02-15 13:04:53.703 INFO 12332 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 12332 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 13:04:53.706 INFO 12332 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 13:04:55.672 INFO 12332 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 13:04:55.687 INFO 12332 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 13:04:55.688 INFO 12332 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 13:04:55.826 INFO 12332 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 13:04:55.826 INFO 12332 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 2052 ms
2022-02-15 13:07:28.830 INFO 14108 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 14108 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 13:07:28.832 INFO 14108 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 13:07:30.706 INFO 14108 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 13:07:30.719 INFO 14108 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 13:07:30.722 INFO 14108 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 13:07:30.896 INFO 14108 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 13:07:30.897 INFO 14108 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 1997 ms
2022-02-15 13:07:35.517 INFO 14108 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 7777 (http) with context path ''
2022-02-15 13:07:35.528 INFO 14108 --- [main] o.c.s.a.automation.RemoteDebugDriver : 开启webview相关功能
2022-02-15 13:07:36.551 INFO 14108 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 13:07:36.573 INFO 14108 --- [main] o.c.s.a.automation.RemoteDebugDriver : chromeDriver启动完毕！
2022-02-15 13:07:36.573 INFO 14108 --- [main] o.c.s.a.b.a.AndroidDeviceBridgeTool : 开启安卓相关功能
2022-02-15 13:07:36.578 INFO 14108 --- [main] org.cloud.sonic.agent.AgentApplication : Started AgentApplication in 8.494 seconds (JVM running for 9.141)
2022-02-15 13:07:58.064 INFO 14108 --- [AgentNettyClient-3-1] org.cloud.sonic.agent.netty.NettyClient : 连接到服务器120.24.77.126:8095失败！10s后重连...
2022-02-15 13:08:29.131 INFO 14108 --- [AgentNettyClient-3-2] org.cloud.sonic.agent.netty.NettyClient : 连接到服务器120.24.77.126:8095失败！10s后重连...
2022-02-15 13:10:45.659 INFO 22088 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 22088 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 13:10:45.662 INFO 22088 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 13:10:47.564 INFO 22088 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 13:10:47.577 INFO 22088 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 13:10:47.578 INFO 22088 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 13:10:47.716 INFO 22088 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 13:10:47.717 INFO 22088 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 1990 ms
2022-02-15 13:10:52.533 INFO 22088 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 7777 (http) with context path ''
2022-02-15 13:10:52.542 INFO 22088 --- [main] o.c.s.a.automation.RemoteDebugDriver : 开启webview相关功能
2022-02-15 13:10:53.474 INFO 22088 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 13:10:53.506 INFO 22088 --- [main] o.c.s.a.automation.RemoteDebugDriver : chromeDriver启动完毕！
2022-02-15 13:10:53.507 INFO 22088 --- [main] o.c.s.a.b.a.AndroidDeviceBridgeTool : 开启安卓相关功能
2022-02-15 13:10:53.510 INFO 22088 --- [main] org.cloud.sonic.agent.AgentApplication : Started AgentApplication in 8.63 seconds (JVM running for 9.363)
2022-02-15 13:10:56.207 INFO 22088 --- [AgentNettyClient-3-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : 安卓设备监听已开启
2022-02-15 13:10:56.215 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 13:10:57.210 INFO 22088 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : Agent:/10.25.7.86:63414 请求连接到服务器 /120.24.77.126:8095 !
2022-02-15 13:10:57.539 INFO 22088 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : Agent:/10.25.7.86:63414 收到服务器 /120.24.77.126:8095 返回验证消息: {"msg":"auth","result":"pass","id":3}
2022-02-15 13:10:57.540 INFO 22088 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : 服务器认证通过！
2022-02-15 13:10:57.542 INFO 22088 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : 当前sonic-agent版本为：1.3.1-beta
2022-02-15 13:10:57.544 INFO 22088 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:63414 连接到服务器 /120.24.77.126:8095 成功!
2022-02-15 13:11:16.224 INFO 22088 --- [http-nio-7777-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2022-02-15 13:11:16.224 INFO 22088 --- [http-nio-7777-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2022-02-15 13:11:16.226 INFO 22088 --- [http-nio-7777-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 0 ms
2022-02-15 13:11:16.347 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 13:11:16.350 INFO 22088 --- [pool-2-thread-2] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 13:11:16.351 INFO 22088 --- [pool-2-thread-1] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 13:11:16.462 ERROR 22088 --- [http-nio-7777-exec-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : For input string: "null"
2022-02-15 13:11:19.219 INFO 22088 --- [Thread-2] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 13:11:19.229 INFO 22088 --- [Thread-3] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 13:11:19.460 INFO 22088 --- [pool-2-thread-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：63498
2022-02-15 13:11:19.696 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 3298
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 13:11:19.722 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
2022-02-15 13:11:19.753 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 13:11:20.233 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：63570
2022-02-15 13:11:20.247 INFO 22088 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 13:11:20.266 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 13:11:26.267 INFO 22088 --- [pool-2-thread-3] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动失败！","log":"","time":"13:11:26","rid":0,"udId":"MF2CG121630I252383","status":4,"cid":0}
2022-02-15 13:11:26.268 ERROR 22088 --- [pool-2-thread-3] o.c.s.agent.websockets.AndroidWSServer : Unable to create a new remote session. Please check the server log for more details. Original error: An unknown server-side error occurred while processing the command. Original error: Appium Settings app is not running after 5000ms
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: driver.version: AndroidDriver
remote stacktrace: UnknownError: An unknown server-side error occurred while processing the command. Original error: Appium Settings app is not running after 5000ms
at getResponseForW3CError (C:\Program Files\nodejs\node_global\node_modules\appium\node_modules\appium-base-driver\lib\protocol\errors.js:804:9)
at asyncHandler (C:\Program Files\nodejs\node_global\node_modules\appium\node_modules\appium-base-driver\lib\protocol\protocol.js:380:37)
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: driver.version: AndroidDriver
2022-02-15 13:16:00.856 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.TerminalWSServer : 1退出
2022-02-15 13:16:00.856 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 关闭driver异常!
2022-02-15 13:16:00.859 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 0退出
2022-02-15 13:16:00.859 INFO 22088 --- [Thread-2] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备方向监听启动异常！
2022-02-15 13:16:00.860 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : MF2CG121630I252383 设备miniCap启动异常！
2022-02-15 13:16:00.860 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 13:16:00.860 ERROR 22088 --- [Thread-2] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:16:00.860 ERROR 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:16:00.866 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 13:16:00.867 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 13:16:00.867 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：63570
2022-02-15 13:16:01.630 INFO 22088 --- [pool-2-thread-1] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 13:16:01.631 INFO 22088 --- [Thread-3] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备touch服务启动异常！
2022-02-15 13:16:01.633 INFO 22088 --- [pool-2-thread-1] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 13:16:01.645 ERROR 22088 --- [Thread-3] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:16:01.646 INFO 22088 --- [pool-2-thread-1] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 13:16:01.651 INFO 22088 --- [pool-2-thread-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：63498
2022-02-15 13:18:20.983 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 13:18:20.997 INFO 22088 --- [pool-2-thread-5] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 13:18:20.997 INFO 22088 --- [pool-2-thread-4] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 13:18:21.074 ERROR 22088 --- [http-nio-7777-exec-5] o.c.s.a.b.a.AndroidDeviceBridgeTool : For input string: "null"
2022-02-15 13:18:21.893 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 13:18:22.766 INFO 22088 --- [Thread-10] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 13:18:22.768 INFO 22088 --- [Thread-9] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 13:18:22.896 INFO 22088 --- [pool-2-thread-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：62456
2022-02-15 13:18:23.249 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 3734
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 13:18:23.276 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
2022-02-15 13:18:23.302 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 13:18:23.771 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：62549
2022-02-15 13:18:23.783 INFO 22088 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 13:18:23.793 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 13:18:28.430 INFO 22088 --- [pool-2-thread-6] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动失败！","log":"","time":"13:18:28","rid":0,"udId":"MF2CG121630I252383","status":4,"cid":0}
2022-02-15 13:18:28.431 ERROR 22088 --- [pool-2-thread-6] o.c.s.agent.websockets.AndroidWSServer : Unable to create a new remote session. Please check the server log for more details. Original error: An unknown server-side error occurred while processing the command. Original error: Appium Settings app is not running after 5000ms
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: driver.version: AndroidDriver
remote stacktrace: UnknownError: An unknown server-side error occurred while processing the command. Original error: Appium Settings app is not running after 5000ms
at getResponseForW3CError (C:\Program Files\nodejs\node_global\node_modules\appium\node_modules\appium-base-driver\lib\protocol\errors.js:804:9)
at asyncHandler (C:\Program Files\nodejs\node_global\node_modules\appium\node_modules\appium-base-driver\lib\protocol\protocol.js:380:37)
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: driver.version: AndroidDriver
2022-02-15 13:19:42.460 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 290 284 50\n","type":"touch"}
2022-02-15 13:19:43.771 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:53.699 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 364 450 50\n","type":"touch"}
2022-02-15 13:19:53.784 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:54.045 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 241 450 50\n","type":"touch"}
2022-02-15 13:19:54.144 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:55.306 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 162 532 50\n","type":"touch"}
2022-02-15 13:19:55.383 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:55.855 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 230 697 50\n","type":"touch"}
2022-02-15 13:19:55.943 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:56.083 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 230 697 50\n","type":"touch"}
2022-02-15 13:19:56.147 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:56.319 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 230 697 50\n","type":"touch"}
2022-02-15 13:19:56.433 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:56.929 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 356 554 50\n","type":"touch"}
2022-02-15 13:19:57.036 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:57.421 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 233 678 50\n","type":"touch"}
2022-02-15 13:19:57.498 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:57.768 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 147 678 50\n","type":"touch"}
2022-02-15 13:19:57.848 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:58.096 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 230 682 50\n","type":"touch"}
2022-02-15 13:19:58.194 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:58.469 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 219 752 50\n","type":"touch"}
2022-02-15 13:19:58.555 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:58.953 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 164 620 50\n","type":"touch"}
2022-02-15 13:19:59.038 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:19:59.322 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 303 614 50\n","type":"touch"}
2022-02-15 13:19:59.424 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:00.548 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 452 460 50\n","type":"touch"}
2022-02-15 13:20:00.638 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:01.540 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 249 551 50\n","type":"touch"}
2022-02-15 13:20:01.569 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:03.193 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 360 419 50\n","type":"touch"}
2022-02-15 13:20:03.234 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:04.568 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 311 550 50\n","type":"touch"}
2022-02-15 13:20:04.641 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:05.207 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 195 551 50\n","type":"touch"}
2022-02-15 13:20:05.219 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:06.468 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 449 535 50\n","type":"touch"}
2022-02-15 13:20:06.531 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:07.740 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 447 697 50\n","type":"touch"}
2022-02-15 13:20:07.835 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:08.424 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 144 516 50\n","type":"touch"}
2022-02-15 13:20:08.511 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:08.755 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 221 533 50\n","type":"touch"}
2022-02-15 13:20:08.836 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:09.125 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 277 533 50\n","type":"touch"}
2022-02-15 13:20:09.233 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:10.199 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 434 525 50\n","type":"touch"}
2022-02-15 13:20:10.299 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:10.572 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 361 536 50\n","type":"touch"}
2022-02-15 13:20:10.649 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:11.382 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 143 611 50\n","type":"touch"}
2022-02-15 13:20:11.459 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:11.697 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 263 618 50\n","type":"touch"}
2022-02-15 13:20:11.774 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"m 0 264 618 50\n","type":"touch"}
2022-02-15 13:20:11.775 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:12.038 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 329 612 50\n","type":"touch"}
2022-02-15 13:20:12.111 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:12.868 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 449 469 50\n","type":"touch"}
2022-02-15 13:20:12.966 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:14.007 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 258 750 50\n","type":"touch"}
2022-02-15 13:20:14.079 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:16.895 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 311 684 50\n","type":"touch"}
2022-02-15 13:20:16.960 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:17.921 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 443 428 50\n","type":"touch"}
2022-02-15 13:20:18.007 INFO 22088 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:31.373 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 457 78 50\n","type":"touch"}
2022-02-15 13:20:31.439 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:32.828 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 400 283 50\n","type":"touch"}
2022-02-15 13:20:32.901 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:34.458 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"d 0 332 508 50\n","type":"touch"}
2022-02-15 13:20:34.555 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 2 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 13:20:40.332 INFO 22088 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.TerminalWSServer : 3退出
2022-02-15 13:20:40.333 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 关闭driver异常!
2022-02-15 13:20:40.334 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2退出
2022-02-15 13:20:40.334 INFO 22088 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 13:20:40.334 INFO 22088 --- [Thread-9] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备方向监听启动异常！
2022-02-15 13:20:40.334 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : MF2CG121630I252383 设备miniCap启动异常！
2022-02-15 13:20:40.336 ERROR 22088 --- [Thread-9] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:20:40.336 ERROR 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:20:40.341 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 13:20:40.341 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 13:20:40.341 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：62549
2022-02-15 13:20:41.027 INFO 22088 --- [pool-2-thread-4] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 13:20:41.028 INFO 22088 --- [Thread-10] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备touch服务启动异常！
2022-02-15 13:20:41.028 INFO 22088 --- [pool-2-thread-4] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 13:20:41.028 ERROR 22088 --- [Thread-10] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 13:20:41.028 INFO 22088 --- [pool-2-thread-4] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 13:20:41.029 INFO 22088 --- [pool-2-thread-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：62456
2022-02-15 13:22:49.081 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 OFFLINE！
2022-02-15 13:22:49.089 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 13:22:49.089 ERROR 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device 'MF2CG121630I252383' not found
2022-02-15 13:22:49.090 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 13:22:49.616 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 13:22:49.625 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 13:22:49.626 ERROR 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device offline
2022-02-15 13:22:49.629 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 13:22:49.698 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 13:54:55.496 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 OFFLINE！
2022-02-15 13:54:55.505 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 13:54:55.506 ERROR 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device 'MF2CG121630I252383' not found
2022-02-15 13:54:55.525 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 13:54:56.641 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 13:54:56.651 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 13:54:56.651 ERROR 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device offline
2022-02-15 13:54:56.651 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 13:54:56.701 INFO 22088 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 14:08:01.076 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 14:08:01.090 INFO 22088 --- [pool-2-thread-7] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 14:08:01.090 INFO 22088 --- [pool-2-thread-8] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 14:08:01.192 ERROR 22088 --- [http-nio-7777-exec-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : For input string: "null"
2022-02-15 14:08:02.086 INFO 22088 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:08:03.130 INFO 22088 --- [Thread-17] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:08:03.132 INFO 22088 --- [Thread-16] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 14:08:03.590 INFO 22088 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：59555
2022-02-15 14:08:03.602 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 6078
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 14:08:03.609 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
2022-02-15 14:08:03.640 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:08:04.138 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：59643
2022-02-15 14:08:04.159 INFO 22088 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:08:04.179 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:08:12.938 INFO 22088 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:08:12.955 INFO 22088 --- [pool-2-thread-9] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:08:12","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:08:13.074 INFO 22088 --- [pool-2-thread-9] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：9
设备序列号：MF2CG121630I252383
设备制造商：Newland
设备型号：N5S
安卓API等级：28
设备分辨率：480x800","time":"14:08:13","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:08:15.393 INFO 22088 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 39 429 50\n","type":"touch"}
2022-02-15 14:08:15.503 INFO 22088 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:08:29.971 INFO 22088 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:08:45.628 ERROR 22088 --- [pool-2-thread-9] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15519ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59559, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59559, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: e9b2fe38-2c7e-4f4f-bd45-4bee7c6c633b
2022-02-15 14:08:53.902 INFO 22088 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:09:09.501 ERROR 22088 --- [pool-2-thread-9] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15517ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59559, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59559, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: e9b2fe38-2c7e-4f4f-bd45-4bee7c6c633b
2022-02-15 14:09:49.712 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"caseId":2,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:10:40.804 INFO 22088 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.TerminalWSServer : 5退出
2022-02-15 14:11:51.869 ERROR 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : java.io.IOException: 你的主机中的软件中止了一个已建立的连接。
2022-02-15 14:11:52.238 INFO 22088 --- [http-nio-7777-exec-7] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"退出连接设备","log":"","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:11:52.238 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 4退出
2022-02-15 14:11:52.238 INFO 22088 --- [Thread-16] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备方向监听启动异常！
2022-02-15 14:11:52.238 INFO 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : MF2CG121630I252383 设备miniCap启动异常！
2022-02-15 14:11:52.239 INFO 22088 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 14:11:52.239 ERROR 22088 --- [Thread-16] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:11:52.240 ERROR 22088 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:11:52.246 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:11:52.246 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:11:52.246 INFO 22088 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：59643
2022-02-15 14:11:52.760 INFO 22088 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 14:11:52.760 INFO 22088 --- [Thread-17] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备touch服务启动异常！
2022-02-15 14:11:52.761 INFO 22088 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:11:52.764 ERROR 22088 --- [Thread-17] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:11:52.769 INFO 22088 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:11:52.770 INFO 22088 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：59555
2022-02-15 14:11:52.817 INFO 22088 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:63414 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"4","pwd":"","udId":"MF2CG121630I252383","steps":[{"step":{"stepType":"openApp","caseId":2,"elements":[],"id":1,"sort":1,"text":"com.rf.zjkj","error":3,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:11:59.949 INFO 21952 --- [main] org.cloud.sonic.agent.AgentApplication : Starting AgentApplication v1.3.1-beta using Java 17.0.2 on LAPTOP-I77IF2GQ with PID 21952 (C:\Users\kongyunyun\Documents\mywork\sonic\sonic-agent-windows-x86_64.jar started by kongyunyun in C:\Users\kongyunyun\Documents\mywork\sonic)
2022-02-15 14:11:59.951 INFO 21952 --- [main] org.cloud.sonic.agent.AgentApplication : The following profiles are active: prod,windows-x86_64
2022-02-15 14:12:01.870 INFO 21952 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 7777 (http)
2022-02-15 14:12:01.886 INFO 21952 --- [main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-02-15 14:12:01.887 INFO 21952 --- [main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.53]
2022-02-15 14:12:02.031 INFO 21952 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-02-15 14:12:02.031 INFO 21952 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 2000 ms
2022-02-15 14:12:07.070 INFO 21952 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 7777 (http) with context path ''
2022-02-15 14:12:07.082 INFO 21952 --- [main] o.c.s.a.automation.RemoteDebugDriver : 开启webview相关功能
2022-02-15 14:12:08.167 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:12:08.184 INFO 21952 --- [main] o.c.s.a.automation.RemoteDebugDriver : chromeDriver启动完毕！
2022-02-15 14:12:08.185 INFO 21952 --- [main] o.c.s.a.b.a.AndroidDeviceBridgeTool : 开启安卓相关功能
2022-02-15 14:12:08.188 INFO 21952 --- [main] org.cloud.sonic.agent.AgentApplication : Started AgentApplication in 8.887 seconds (JVM running for 9.511)
2022-02-15 14:12:08.590 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : 安卓设备监听已开启
2022-02-15 14:12:08.597 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 14:12:09.592 INFO 21952 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : Agent:/10.25.7.86:59938 请求连接到服务器 /120.24.77.126:8095 !
2022-02-15 14:12:09.743 INFO 21952 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 返回验证消息: {"msg":"auth","result":"pass","id":3}
2022-02-15 14:12:09.743 INFO 21952 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : 服务器认证通过！
2022-02-15 14:12:09.745 INFO 21952 --- [AgentNettyClient-3-1] o.c.sonic.agent.netty.SecurityHandler : 当前sonic-agent版本为：1.3.1-beta
2022-02-15 14:12:09.747 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 连接到服务器 /120.24.77.126:8095 成功!
2022-02-15 14:12:16.462 INFO 21952 --- [http-nio-7777-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2022-02-15 14:12:16.463 INFO 21952 --- [http-nio-7777-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2022-02-15 14:12:16.464 INFO 21952 --- [http-nio-7777-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 0 ms
2022-02-15 14:12:16.541 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 14:12:16.542 INFO 21952 --- [pool-2-thread-1] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 14:12:16.544 INFO 21952 --- [pool-2-thread-2] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 14:12:17.467 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:12:18.313 INFO 21952 --- [Thread-2] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 14:12:18.334 INFO 21952 --- [Thread-3] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:12:18.473 INFO 21952 --- [pool-2-thread-2] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：59969
2022-02-15 14:12:18.825 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 6408
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 14:12:18.858 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:12:19.325 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：60048
2022-02-15 14:12:19.346 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:12:19.348 INFO 21952 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:12:24.053 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"type":"forwardView"}
2022-02-15 14:12:24.219 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口转发到：60110
2022-02-15 14:12:27.789 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:12:27.807 INFO 21952 --- [pool-2-thread-3] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:12:27","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:12:27.929 INFO 21952 --- [pool-2-thread-3] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：9
设备序列号：MF2CG121630I252383
设备制造商：Newland
设备型号：N5S
安卓API等级：28
设备分辨率：480x800","time":"14:12:27","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:12:28.115 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"type":"forwardView"}
2022-02-15 14:12:28.374 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口取消转发到：60110
2022-02-15 14:12:28.382 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口转发到：60129
2022-02-15 14:12:55.407 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"type":"forwardView"}
2022-02-15 14:12:55.665 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口取消转发到：60129
2022-02-15 14:12:55.677 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口转发到：60164
2022-02-15 14:13:14.185 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"caseId":2,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:13:14.857 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"0","pwd":"","udId":"MF2CG121630I252383","steps":[{"step":{"stepType":"openApp","caseId":2,"elements":[],"id":1,"sort":1,"text":"com.rf.zjkj","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:13:15.733 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.rf.zjkj","time":"14:13:15","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:13:15.733 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:13:15","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:13:29.078 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"type":"forwardView"}
2022-02-15 14:13:29.333 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口取消转发到：60164
2022-02-15 14:13:29.340 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口转发到：60200
2022-02-15 14:13:33.544 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:13:49.226 ERROR 21952 --- [pool-2-thread-4] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15518ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59974, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59974, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 09e0020f-bc41-4f10-a7e4-c7bf08b641ec
2022-02-15 14:15:25.541 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:15:41.158 ERROR 21952 --- [pool-2-thread-5] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15518ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59974, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59974, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 09e0020f-bc41-4f10-a7e4-c7bf08b641ec
2022-02-15 14:17:12.360 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"detail":"d 0 224 450 50\n","type":"touch"}
2022-02-15 14:17:12.459 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:17:17.768 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:17:33.365 ERROR 21952 --- [pool-2-thread-6] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15519ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59974, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59974, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 09e0020f-bc41-4f10-a7e4-c7bf08b641ec
2022-02-15 14:18:14.367 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 0 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:18:29.950 ERROR 21952 --- [pool-2-thread-6] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15517ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 59974, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 59974, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 09e0020f-bc41-4f10-a7e4-c7bf08b641ec
2022-02-15 14:23:15.981 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 OFFLINE！
2022-02-15 14:23:15.986 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:23:15.988 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:23:15.991 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 14:23:15.991 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：60048
2022-02-15 14:23:15.991 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device 'MF2CG121630I252383' not found
2022-02-15 14:23:15.993 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:23:16.001 ERROR 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool :
2022-02-15 14:23:16.903 INFO 21952 --- [pool-2-thread-2] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:23:16.903 INFO 21952 --- [pool-2-thread-2] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:23:16.907 INFO 21952 --- [pool-2-thread-2] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：59969
2022-02-15 14:23:16.914 ERROR 21952 --- [pool-2-thread-2] o.c.s.a.b.a.AndroidDeviceBridgeTool :
2022-02-15 14:23:28.786 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 14:23:28.794 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 MF2CG121630I252383 异常！
2022-02-15 14:23:28.794 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device offline
2022-02-15 14:23:28.796 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:23:28.838 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：MF2CG121630I252383 ONLINE！
2022-02-15 14:23:37.832 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.TerminalWSServer : 1退出
2022-02-15 14:23:38.365 INFO 21952 --- [http-nio-7777-exec-4] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"退出连接设备","log":"","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:23:38.366 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 com.android.internal.os.WebViewZygoteInit/74e11aee-50c6-4d64-8871-5703b2ce1cf9 服务端口取消转发到：60200
2022-02-15 14:23:38.383 ERROR 21952 --- [http-nio-7777-exec-4] o.c.s.a.b.a.AndroidDeviceBridgeTool : listener 'tcp:60200' not found
2022-02-15 14:23:38.384 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 0退出
2022-02-15 14:23:38.384 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 14:24:34.930 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：1556470135000Z3 ONLINE！
2022-02-15 14:24:34.944 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 1556470135000Z3 异常！
2022-02-15 14:24:34.948 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device offline
2022-02-15 14:24:34.957 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:24:41.891 INFO 21952 --- [Thread-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 dumpsys battery 给设备 1556470135000Z3 异常！
2022-02-15 14:24:41.892 ERROR 21952 --- [Thread-1] o.c.s.a.b.a.AndroidDeviceBridgeTool : device unauthorized.
This adb server's $ADB_VENDOR_KEYS is not set
Try 'adb kill-server' if that seems wrong.
Otherwise check for a confirmation dialog on your device.
2022-02-15 14:25:01.300 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：1556470135000Z3 OFFLINE！
2022-02-15 14:25:01.307 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 1556470135000Z3 异常！
2022-02-15 14:25:01.309 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device '1556470135000Z3' not found
2022-02-15 14:25:01.312 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:25:02.108 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：1556470135000Z3 ONLINE！
2022-02-15 14:25:02.184 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 1556470135000Z3 异常！
2022-02-15 14:25:02.194 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device still authorizing
2022-02-15 14:25:02.198 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:25:06.299 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：1556470135000Z3 ONLINE！
2022-02-15 14:25:12.804 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 14:25:12.819 INFO 21952 --- [pool-2-thread-7] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 14:25:12.820 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 14:25:13.711 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:25:14.577 INFO 21952 --- [Thread-11] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 14:25:14.596 INFO 21952 --- [Thread-12] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:25:14.714 INFO 21952 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：50026
2022-02-15 14:25:15.057 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 7199
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 14:25:15.083 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
2022-02-15 14:25:15.088 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:25:15.579 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：50131
2022-02-15 14:25:15.593 INFO 21952 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:25:15.605 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:25:23.014 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:25:23.049 INFO 21952 --- [pool-2-thread-9] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:25:23","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:25:23.152 INFO 21952 --- [pool-2-thread-9] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：9
设备序列号：MF2CG121630I252383
设备制造商：Newland
设备型号：N5S
安卓API等级：28
设备分辨率：480x800","time":"14:25:23","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:25:27.652 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.TerminalWSServer : 3退出
2022-02-15 14:25:28.007 INFO 21952 --- [http-nio-7777-exec-9] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"退出连接设备","log":"","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:25:28.007 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 2退出
2022-02-15 14:25:28.007 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : MF2CG121630I252383 设备miniCap启动异常！
2022-02-15 14:25:28.007 INFO 21952 --- [Thread-11] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备方向监听启动异常！
2022-02-15 14:25:28.009 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 14:25:28.009 ERROR 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:25:28.009 ERROR 21952 --- [Thread-11] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:25:28.016 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:25:28.020 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:25:28.025 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：50131
2022-02-15 14:25:28.742 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 14:25:28.742 INFO 21952 --- [Thread-12] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备touch服务启动异常！
2022-02-15 14:25:28.743 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:25:28.744 ERROR 21952 --- [Thread-12] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:25:28.745 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:25:28.746 INFO 21952 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：50026
2022-02-15 14:25:33.775 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：1556470135000Z3
2022-02-15 14:25:33.787 INFO 21952 --- [pool-2-thread-9] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启logcat
2022-02-15 14:25:33.787 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启terminal
2022-02-15 14:25:36.229 INFO 21952 --- [Thread-19] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:25:36.243 INFO 21952 --- [Thread-18] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3旋转到：0
2022-02-15 14:25:36.492 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : PID: 32679
INFO: Using projection 1080x2400@360x800/0
INFO: (external/minicap/src/minicap_31.cpp:245) Creating SurfaceComposerClient
INFO: (external/minicap/src/minicap_31.cpp:248) Performing SurfaceComposerClient init check
INFO: (external/minicap/src/minicap_31.cpp:259) Creating virtual display
INFO: (external/minicap/src/minicap_31.cpp:265) Creating buffer queue
INFO: (external/minicap/src/minicap_31.cpp:268) Setting buffer options
INFO: (external/minicap/src/minicap_31.cpp:272) Creating CPU consumer
INFO: (external/minicap/src/minicap_31.cpp:276) Creating frame waiter
INFO: (external/minicap/src/minicap_31.cpp:280) Publishing virtual display
INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 7835652 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:25:36.501 INFO 21952 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口转发到：50203
2022-02-15 14:25:36.746 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口转发到：50271
2022-02-15 14:25:36.763 INFO 21952 --- [android-output-socket-task-0-0-1556470135000Z3] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:25:36.780 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:25:43.157 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:25:43.166 INFO 21952 --- [pool-2-thread-7] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:25:43","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:25:43.267 INFO 21952 --- [pool-2-thread-7] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：12
设备序列号：1556470135000Z3
设备制造商：vivo
设备型号：V2141A
安卓API等级：31
设备分辨率：1080x2400","time":"14:25:43","rid":0,"udId":"1556470135000Z3","status":1,"cid":0}
2022-02-15 14:26:54.475 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"caseId":3,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:26:55.453 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"4","pwd":"","udId":"1556470135000Z3","steps":[{"step":{"stepType":"openApp","caseId":3,"elements":[],"id":2,"sort":2,"text":"com.tencent.mm","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:26:55.739 INFO 21952 --- [android-run-step-task-0-0-1556470135000Z3] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.tencent.mm","time":"14:26:55","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:26:55.740 INFO 21952 --- [android-run-step-task-0-0-1556470135000Z3] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:26:55","rid":0,"udId":"1556470135000Z3","status":1,"cid":0}
2022-02-15 14:27:09.317 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 730 1782 50\n","type":"touch"}
2022-02-15 14:27:09.365 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 609 1759 50\n","type":"touch"}
2022-02-15 14:27:09.415 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 351 1720 50\n","type":"touch"}
2022-02-15 14:27:09.465 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 266 1716 50\n","type":"touch"}
2022-02-15 14:27:09.495 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:10.282 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 841 1741 50\n","type":"touch"}
2022-02-15 14:27:10.283 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 839 1739 50\n","type":"touch"}
2022-02-15 14:27:10.333 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 828 1735 50\n","type":"touch"}
2022-02-15 14:27:10.383 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 758 1731 50\n","type":"touch"}
2022-02-15 14:27:10.433 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 624 1731 50\n","type":"touch"}
2022-02-15 14:27:10.486 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 496 1731 50\n","type":"touch"}
2022-02-15 14:27:10.535 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 417 1731 50\n","type":"touch"}
2022-02-15 14:27:10.583 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 406 1731 50\n","type":"touch"}
2022-02-15 14:27:10.635 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 372 1735 50\n","type":"touch"}
2022-02-15 14:27:10.683 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 325 1735 50\n","type":"touch"}
2022-02-15 14:27:10.733 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"m 0 283 1735 50\n","type":"touch"}
2022-02-15 14:27:10.764 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:13.310 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 202 481 50\n","type":"touch"}
2022-02-15 14:27:13.387 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:14.491 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 975 787 50\n","type":"touch"}
2022-02-15 14:27:14.589 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:27.089 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"caseId":3,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:27:27.472 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"4","pwd":"","udId":"1556470135000Z3","steps":[{"step":{"stepType":"openApp","caseId":3,"elements":[],"id":2,"sort":2,"text":"com.tencent.mm","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:27:27.708 INFO 21952 --- [android-run-step-task-0-0-1556470135000Z3] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.tencent.mm","time":"14:27:27","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:27:27.709 INFO 21952 --- [android-run-step-task-0-0-1556470135000Z3] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:27:27","rid":0,"udId":"1556470135000Z3","status":1,"cid":0}
2022-02-15 14:27:40.873 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 174 534 50\n","type":"touch"}
2022-02-15 14:27:40.950 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:41.902 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 941 777 50\n","type":"touch"}
2022-02-15 14:27:41.978 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:46.070 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"d 0 296 453 50\n","type":"touch"}
2022-02-15 14:27:46.137 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:27:54.687 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : 4 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:29:11.862 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.TerminalWSServer : 5退出
2022-02-15 14:29:31.528 INFO 21952 --- [pool-2-thread-12] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启logcat
2022-02-15 14:29:31.528 INFO 21952 --- [pool-2-thread-11] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启terminal
2022-02-15 14:30:01.503 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : 30s内获取设备锁失败，请确保设备无人使用
2022-02-15 14:30:28.409 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.TerminalWSServer : 7退出
2022-02-15 14:30:28.409 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : 关闭driver异常!
2022-02-15 14:30:28.410 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：1556470135000Z3
2022-02-15 14:30:28.428 ERROR 21952 --- [http-nio-7777-exec-4] o.a.t.websocket.pojo.PojoEndpointBase : Failed to call onClose method of POJO end point for POJO of type [org.cloud.sonic.agent.websockets.AndroidWSServer]
java.lang.reflect.InvocationTargetException: null
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:na]
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) ~[na:na]
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:na]
at java.base/java.lang.reflect.Method.invoke(Method.java:568) ~[na:na]
at org.apache.tomcat.websocket.pojo.PojoEndpointBase.onClose(PojoEndpointBase.java:107) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.WsSession.fireEndpointOnClose(WsSession.java:759) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.WsSession.onClose(WsSession.java:740) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.WsFrameBase.processDataControl(WsFrameBase.java:367) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.WsFrameBase.processData(WsFrameBase.java:296) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.WsFrameBase.processInputBuffer(WsFrameBase.java:133) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:85) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:183) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:162) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:156) ~[tomcat-embed-websocket-9.0.53.jar!/:na]
at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:60) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:59) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:893) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1726) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) ~[tomcat-embed-core-9.0.53.jar!/:na]
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) ~[tomcat-embed-core-9.0.53.jar!/:na]
at java.base/java.lang.Thread.run(Thread.java:833) ~[na:na]
Caused by: java.lang.NullPointerException: Cannot invoke "com.android.ddmlib.IDevice.getSerialNumber()" because the return value of "java.util.Map.get(Object)" is null
at org.cloud.sonic.agent.websockets.AndroidWSServer.exit(AndroidWSServer.java:641) ~[classes!/:1.3.1-beta]
at org.cloud.sonic.agent.websockets.AndroidWSServer.onClose(AndroidWSServer.java:319) ~[classes!/:1.3.1-beta]
... 23 common frames omitted
2022-02-15 14:30:28.430 ERROR 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : null
2022-02-15 14:30:41.738 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：1556470135000Z3
2022-02-15 14:30:41.752 INFO 21952 --- [pool-2-thread-13] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启terminal
2022-02-15 14:30:41.752 INFO 21952 --- [pool-2-thread-14] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启logcat
2022-02-15 14:30:42.987 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:30:43.198 INFO 21952 --- [Thread-32] o.c.s.agent.websockets.AndroidWSServer : Server start
java.io.IOException: Address already in use
at android.net.LocalSocketImpl.bindLocal(Native Method)
at android.net.LocalSocketImpl.bind(LocalSocketImpl.java:275)
at android.net.LocalServerSocket.(LocalServerSocket.java:49)
at org.cloud.sonic.android.SonicTouchService.run(SonicTouchService.java:286)
2022-02-15 14:30:43.208 INFO 21952 --- [Thread-31] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3旋转到：0
2022-02-15 14:30:43.490 INFO 21952 --- [pool-2-thread-14] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口转发到：50716
2022-02-15 14:30:43.563 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : PID: 10087
INFO: Using projection 1080x2400@360x800/0
INFO: (external/minicap/src/minicap_31.cpp:245) Creating SurfaceComposerClient
INFO: (external/minicap/src/minicap_31.cpp:248) Performing SurfaceComposerClient init check
INFO: (external/minicap/src/minicap_31.cpp:259) Creating virtual display
INFO: (external/minicap/src/minicap_31.cpp:265) Creating buffer queue
INFO: (external/minicap/src/minicap_31.cpp:268) Setting buffer options
INFO: (external/minicap/src/minicap_31.cpp:272) Creating CPU consumer
INFO: (external/minicap/src/minicap_31.cpp:276) Creating frame waiter
INFO: (external/minicap/src/minicap_31.cpp:280) Publishing virtual display
2022-02-15 14:30:43.589 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 7835652 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
INFO: (external/minicap/src/minicap_31.cpp:295) Destroying virtual display
2022-02-15 14:30:43.709 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口转发到：50776
2022-02-15 14:30:43.716 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:30:43.716 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:30:43.717 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口取消转发到：50776
2022-02-15 14:30:46.192 ERROR 21952 --- [pool-2-thread-10] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Could not proxy. Proxy error: Could not proxy command to the remote server. Original error: socket hang up
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 50207, udid: 1556470135000Z3, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 31, deviceManufacturer: vivo, deviceModel: V2141A, deviceName: 1556470135000Z3, deviceScreenDensity: 480, deviceScreenSize: 1080x2400, deviceUDID: 1556470135000Z3, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 3, platform: LINUX, platformName: ANDROID, platformVersion: 12, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 96, systemPort: 50207, takesScreenshot: true, udid: 1556470135000Z3, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 2216, left: 0, top: 96, width: 1080}, warnings: {}, webStorageEnabled: false}
Session ID: 7ca463e0-d101-41f6-8d6a-8a2420961e80
2022-02-15 14:30:46.913 INFO 21952 --- [http-nio-7777-exec-1] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"退出连接设备","log":"","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:30:46.914 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 4退出
2022-02-15 14:30:46.914 INFO 21952 --- [Thread-18] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3 设备方向监听启动异常！
2022-02-15 14:30:46.914 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : 1556470135000Z3 设备miniCap启动异常！
2022-02-15 14:30:46.915 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：1556470135000Z3
2022-02-15 14:30:46.915 ERROR 21952 --- [Thread-18] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:30:46.916 ERROR 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:30:46.971 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:30:46.972 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:30:46.973 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口取消转发到：50271
2022-02-15 14:30:47.219 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.TerminalWSServer : 9退出
2022-02-15 14:30:47.219 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 关闭driver异常!
2022-02-15 14:30:47.221 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 8退出
2022-02-15 14:30:47.221 INFO 21952 --- [Thread-31] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3 设备方向监听启动异常！
2022-02-15 14:30:47.221 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：1556470135000Z3
2022-02-15 14:30:47.221 ERROR 21952 --- [Thread-31] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:30:47.511 INFO 21952 --- [pool-2-thread-14] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 14:30:47.511 INFO 21952 --- [Thread-32] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3 设备touch服务启动异常！
2022-02-15 14:30:47.511 INFO 21952 --- [pool-2-thread-14] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:30:47.513 ERROR 21952 --- [Thread-32] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:30:47.513 INFO 21952 --- [pool-2-thread-14] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:30:47.514 INFO 21952 --- [pool-2-thread-14] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口取消转发到：50716
2022-02-15 14:30:47.684 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 14:30:47.685 INFO 21952 --- [Thread-19] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3 设备touch服务启动异常！
2022-02-15 14:30:47.686 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:30:47.690 ERROR 21952 --- [Thread-19] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:30:47.691 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:30:47.693 INFO 21952 --- [pool-2-thread-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口取消转发到：50203
2022-02-15 14:30:51.030 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:30:51.035 INFO 21952 --- [pool-2-thread-15] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:30:51.138 INFO 21952 --- [pool-2-thread-15] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：12
设备序列号：1556470135000Z3
设备制造商：vivo
设备型号：V2141A
安卓API等级：31
设备分辨率：1080x2400","rid":0,"udId":"1556470135000Z3","status":1,"cid":0}
2022-02-15 14:30:57.036 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：1556470135000Z3
2022-02-15 14:30:57.073 INFO 21952 --- [pool-2-thread-8] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启logcat
2022-02-15 14:30:57.073 INFO 21952 --- [pool-2-thread-15] o.c.s.agent.websockets.TerminalWSServer : 1556470135000Z3开启terminal
2022-02-15 14:30:58.150 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:30:58.332 INFO 21952 --- [Thread-38] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:30:58.389 INFO 21952 --- [Thread-37] o.c.s.agent.websockets.AndroidWSServer : 1556470135000Z3旋转到：0
2022-02-15 14:30:58.635 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : PID: 12440
INFO: Using projection 1080x2400@360x800/0
INFO: (external/minicap/src/minicap_31.cpp:245) Creating SurfaceComposerClient
INFO: (external/minicap/src/minicap_31.cpp:248) Performing SurfaceComposerClient init check
INFO: (external/minicap/src/minicap_31.cpp:259) Creating virtual display
INFO: (external/minicap/src/minicap_31.cpp:265) Creating buffer queue
INFO: (external/minicap/src/minicap_31.cpp:268) Setting buffer options
INFO: (external/minicap/src/minicap_31.cpp:272) Creating CPU consumer
INFO: (external/minicap/src/minicap_31.cpp:276) Creating frame waiter
INFO: (external/minicap/src/minicap_31.cpp:280) Publishing virtual display
2022-02-15 14:30:58.654 INFO 21952 --- [pool-2-thread-15] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口转发到：50907
2022-02-15 14:30:58.691 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 7835652 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:30:58.891 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口转发到：50970
2022-02-15 14:30:58.902 INFO 21952 --- [android-output-socket-task-0-0-1556470135000Z3] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:30:58.925 INFO 21952 --- [android-start-minicap-server-task-0-0-1556470135000Z3] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:31:05.280 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:31:05.289 INFO 21952 --- [pool-2-thread-14] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:31:05","rid":0,"udId":"1556470135000Z3","status":2,"cid":0}
2022-02-15 14:31:05.402 INFO 21952 --- [pool-2-thread-14] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：12
设备序列号：1556470135000Z3
设备制造商：vivo
设备型号：V2141A
安卓API等级：31
设备分辨率：1080x2400","time":"14:31:05","rid":0,"udId":"1556470135000Z3","status":1,"cid":0}
2022-02-15 14:31:06.209 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 570 1820 50\n","type":"touch"}
2022-02-15 14:31:06.288 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 575 1801 50\n","type":"touch"}
2022-02-15 14:31:06.352 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 604 1654 50\n","type":"touch"}
2022-02-15 14:31:06.402 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 645 1369 50\n","type":"touch"}
2022-02-15 14:31:06.452 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 664 1075 50\n","type":"touch"}
2022-02-15 14:31:06.506 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 673 856 50\n","type":"touch"}
2022-02-15 14:31:06.542 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:36.865 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"type":"forwardView"}
2022-02-15 14:31:37.176 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口转发到：51128
2022-02-15 14:31:39.420 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 771 1264 50\n","type":"touch"}
2022-02-15 14:31:39.434 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 771 1247 50\n","type":"touch"}
2022-02-15 14:31:39.486 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 771 1094 50\n","type":"touch"}
2022-02-15 14:31:39.535 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 771 868 50\n","type":"touch"}
2022-02-15 14:31:39.585 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 773 615 50\n","type":"touch"}
2022-02-15 14:31:39.638 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 788 508 50\n","type":"touch"}
2022-02-15 14:31:39.645 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:40.522 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 632 2199 50\n","type":"touch"}
2022-02-15 14:31:40.569 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 632 2127 50\n","type":"touch"}
2022-02-15 14:31:40.623 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 632 1933 50\n","type":"touch"}
2022-02-15 14:31:40.670 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 639 1665 50\n","type":"touch"}
2022-02-15 14:31:40.719 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 671 1399 50\n","type":"touch"}
2022-02-15 14:31:40.770 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"m 0 681 1313 50\n","type":"touch"}
2022-02-15 14:31:40.789 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:41.759 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 713 698 50\n","type":"touch"}
2022-02-15 14:31:41.859 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:46.315 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 438 2248 50\n","type":"touch"}
2022-02-15 14:31:46.392 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:49.239 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"type":"forwardView"}
2022-02-15 14:31:49.521 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口取消转发到：51128
2022-02-15 14:31:49.529 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口转发到：51146
2022-02-15 14:31:52.369 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 568 534 50\n","type":"touch"}
2022-02-15 14:31:52.468 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:31:59.049 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"type":"forwardView"}
2022-02-15 14:31:59.336 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口取消转发到：51146
2022-02-15 14:31:59.344 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口转发到：51162
2022-02-15 14:32:12.194 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"d 0 500 704 50\n","type":"touch"}
2022-02-15 14:32:12.303 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:32:13.438 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : a 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:33:07.100 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.TerminalWSServer : b退出
2022-02-15 14:34:31.308 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:34:31.312 ERROR 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Could not proxy. Proxy error: Could not proxy command to the remote server. Original error: socket hang up
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 50909, udid: 1556470135000Z3, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 31, deviceManufacturer: vivo, deviceModel: V2141A, deviceName: 1556470135000Z3, deviceScreenDensity: 480, deviceScreenSize: 1080x2400, deviceUDID: 1556470135000Z3, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 3, platform: LINUX, platformName: ANDROID, platformVersion: 12, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 96, systemPort: 50909, takesScreenshot: true, udid: 1556470135000Z3, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 2216, left: 0, top: 96, width: 1080}, warnings: {}, webStorageEnabled: false}
Session ID: aa6e587e-32bf-45bb-87a2-0c2b1530a4ae
2022-02-15 14:34:31.314 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceStatusListener : Android设备：1556470135000Z3 OFFLINE！
2022-02-15 14:34:31.314 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:34:31.323 INFO 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 minicap 服务端口取消转发到：50970
2022-02-15 14:34:31.329 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 发送shell指令 wm size 给设备 1556470135000Z3 异常！
2022-02-15 14:34:31.330 ERROR 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : device '1556470135000Z3' not found
2022-02-15 14:34:31.331 INFO 21952 --- [Device List Monitor] o.c.s.a.b.a.AndroidDeviceBridgeTool : 获取屏幕尺寸失败！拔插瞬间可忽略该错误...
2022-02-15 14:34:31.333 ERROR 21952 --- [android-input-socket-task-0-0-1556470135000Z3] o.c.s.a.b.a.AndroidDeviceBridgeTool :
2022-02-15 14:34:31.790 INFO 21952 --- [pool-2-thread-15] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:34:31.792 INFO 21952 --- [pool-2-thread-15] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:34:31.804 INFO 21952 --- [pool-2-thread-15] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 sonictouchservice 服务端口取消转发到：50907
2022-02-15 14:34:31.817 ERROR 21952 --- [pool-2-thread-15] o.c.s.a.b.a.AndroidDeviceBridgeTool :
2022-02-15 14:34:33.505 INFO 21952 --- [http-nio-7777-exec-8] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"测试终止异常！请检查设备连接状态","log":"","rid":0,"udId":"1556470135000Z3","status":3,"cid":0}
2022-02-15 14:34:33.517 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.a.b.a.AndroidDeviceBridgeTool : 1556470135000Z3 设备 com.android.internal.os.WebViewZygoteInit/763d5e49-fd01-4553-95bd-f0104b09883e 服务端口取消转发到：51162
2022-02-15 14:34:33.524 ERROR 21952 --- [http-nio-7777-exec-8] o.c.s.a.b.a.AndroidDeviceBridgeTool :
2022-02-15 14:34:33.524 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : a退出
2022-02-15 14:34:33.525 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：1556470135000Z3
2022-02-15 14:34:49.383 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 14:34:49.395 INFO 21952 --- [pool-2-thread-15] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 14:34:49.395 INFO 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 14:34:50.322 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:34:51.187 INFO 21952 --- [Thread-44] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 14:34:51.196 INFO 21952 --- [Thread-45] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:34:51.328 INFO 21952 --- [pool-2-thread-16] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：51378
2022-02-15 14:34:51.634 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 7668
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 14:34:51.666 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:34:51.695 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：51471
2022-02-15 14:34:51.710 INFO 21952 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:34:51.723 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:34:58.324 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:34:58.334 INFO 21952 --- [pool-2-thread-17] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:34:58","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:34:58.436 INFO 21952 --- [pool-2-thread-17] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：9
设备序列号：MF2CG121630I252383
设备制造商：Newland
设备型号：N5S
安卓API等级：28
设备分辨率：480x800","time":"14:34:58","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:35:07.216 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"d 0 299 330 50\n","type":"touch"}
2022-02-15 14:35:07.298 INFO 21952 --- [http-nio-7777-exec-2] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:35:15.928 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"caseId":3,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:35:16.778 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"c","pwd":"","udId":"MF2CG121630I252383","steps":[]}
2022-02-15 14:35:16.779 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:35:16","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:35:26.549 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"d 0 317 514 50\n","type":"touch"}
2022-02-15 14:35:26.598 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"m 0 317 417 50\n","type":"touch"}
2022-02-15 14:35:26.644 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"m 0 317 287 50\n","type":"touch"}
2022-02-15 14:35:26.695 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"m 0 318 160 50\n","type":"touch"}
2022-02-15 14:35:26.727 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : c 发送 {"detail":"u 0\n","type":"touch"}
2022-02-15 14:35:53.809 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.TerminalWSServer : d退出
2022-02-15 14:35:54.153 INFO 21952 --- [http-nio-7777-exec-1] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"退出连接设备","log":"","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:35:54.154 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : c退出
2022-02-15 14:35:54.154 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : MF2CG121630I252383 设备miniCap启动异常！
2022-02-15 14:35:54.154 INFO 21952 --- [Thread-44] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备方向监听启动异常！
2022-02-15 14:35:54.155 INFO 21952 --- [http-nio-7777-exec-1] o.c.s.agent.websockets.AndroidWSServer : android解锁udId：MF2CG121630I252383
2022-02-15 14:35:54.157 ERROR 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:35:54.157 ERROR 21952 --- [Thread-44] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:35:54.161 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap socket已关闭
2022-02-15 14:35:54.162 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.InputSocketThread : miniCap input流已关闭
2022-02-15 14:35:54.166 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口取消转发到：51471
2022-02-15 14:35:54.371 INFO 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.AndroidWSServer : touch thread已关闭
2022-02-15 14:35:54.371 INFO 21952 --- [Thread-45] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383 设备touch服务启动异常！
2022-02-15 14:35:54.371 INFO 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.AndroidWSServer : touch socket已关闭
2022-02-15 14:35:54.373 ERROR 21952 --- [Thread-45] o.c.s.agent.websockets.AndroidWSServer : executeRemoteCommand interrupted with immediate timeout via interruption.
2022-02-15 14:35:54.373 INFO 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.AndroidWSServer : touch output流已关闭
2022-02-15 14:35:54.374 INFO 21952 --- [pool-2-thread-16] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口取消转发到：51378
2022-02-15 14:36:19.440 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : android上锁udId：MF2CG121630I252383
2022-02-15 14:36:19.461 INFO 21952 --- [pool-2-thread-16] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启terminal
2022-02-15 14:36:19.462 INFO 21952 --- [pool-2-thread-18] o.c.s.agent.websockets.TerminalWSServer : MF2CG121630I252383开启logcat
2022-02-15 14:36:20.355 INFO 21952 --- [http-nio-7777-exec-9] o.c.s.agent.websockets.AndroidWSServer : 已安装Sonic插件
2022-02-15 14:36:21.224 INFO 21952 --- [Thread-54] o.c.s.agent.websockets.AndroidWSServer : Server start
2022-02-15 14:36:21.224 INFO 21952 --- [Thread-53] o.c.s.agent.websockets.AndroidWSServer : MF2CG121630I252383旋转到：0
2022-02-15 14:36:21.357 INFO 21952 --- [pool-2-thread-18] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 sonictouchservice 服务端口转发到：51622
2022-02-15 14:36:21.748 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : PID: 7971
INFO: Using projection 480x800@480x800/0
INFO: (external/MY_minicap/src/minicap_28.cpp:241) Creating SurfaceComposerClient
INFO: (external/MY_minicap/src/minicap_28.cpp:244) Performing SurfaceComposerClient init check
INFO: (external/MY_minicap/src/minicap_28.cpp:255) Creating virtual display
INFO: (external/MY_minicap/src/minicap_28.cpp:261) Creating buffer queue
2022-02-15 14:36:21.756 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (external/MY_minicap/src/minicap_28.cpp:264) Setting buffer options
INFO: (external/MY_minicap/src/minicap_28.cpp:268) Creating CPU consumer
INFO: (external/MY_minicap/src/minicap_28.cpp:272) Creating frame waiter
INFO: (external/MY_minicap/src/minicap_28.cpp:276) Publishing virtual display
2022-02-15 14:36:21.783 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/JpgEncoder.cpp:64) Allocating 1154052 bytes for JPG encoder
INFO: (jni/minicap/minicap.cpp:489) Server start
2022-02-15 14:36:22.241 INFO 21952 --- [android-input-socket-task-0-0-MF2CG121630I252383] o.c.s.a.b.a.AndroidDeviceBridgeTool : MF2CG121630I252383 设备 minicap 服务端口转发到：51736
2022-02-15 14:36:22.252 INFO 21952 --- [android-output-socket-task-0-0-MF2CG121630I252383] o.c.s.a.t.android.OutputSocketThread : banner读取已就绪
2022-02-15 14:36:22.271 INFO 21952 --- [android-start-minicap-server-task-0-0-MF2CG121630I252383] o.c.s.a.tests.android.SonicLocalThread : INFO: (jni/minicap/minicap.cpp:492) New client connection
2022-02-15 14:36:28.225 INFO 21952 --- [Forwarding newSession on session null to remote] o.o.selenium.remote.ProtocolHandshake : Detected dialect: W3C
2022-02-15 14:36:28.231 INFO 21952 --- [pool-2-thread-19] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"连接设备驱动成功","log":"","time":"14:36:28","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:36:28.332 INFO 21952 --- [pool-2-thread-19] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"","log":"设备操作系统：Android
操作系统版本：9
设备序列号：MF2CG121630I252383
设备制造商：Newland
设备型号：N5S
安卓API等级：28
设备分辨率：480x800","time":"14:36:28","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:36:28.478 INFO 21952 --- [http-nio-7777-exec-5] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"caseId":2,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:36:28.834 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"e","pwd":"","udId":"MF2CG121630I252383","steps":[{"step":{"stepType":"openApp","caseId":2,"elements":[],"id":1,"sort":1,"text":"com.rf.zjkj","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:36:29.845 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.rf.zjkj","time":"14:36:29","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:36:29.846 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:36:29","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:36:39.932 INFO 21952 --- [http-nio-7777-exec-3] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"caseId":2,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:36:40.847 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"e","pwd":"","udId":"MF2CG121630I252383","steps":[{"step":{"stepType":"openApp","caseId":2,"elements":[],"id":1,"sort":1,"text":"com.rf.zjkj","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:36:42.146 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.rf.zjkj","time":"14:36:42","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:36:42.147 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:36:42","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:36:52.533 INFO 21952 --- [http-nio-7777-exec-6] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"caseId":2,"detail":"runStep","type":"debug","pwd":""}
2022-02-15 14:36:52.885 INFO 21952 --- [AgentNettyClient-3-1] o.c.s.agent.netty.NettyClientHandler : Agent:/10.25.7.86:59938 收到服务器 /120.24.77.126:8095 消息: {"msg":"runStep","pf":1,"gp":{},"sessionId":"e","pwd":"","udId":"MF2CG121630I252383","steps":[{"step":{"stepType":"openApp","caseId":2,"elements":[],"id":1,"sort":1,"text":"com.rf.zjkj","error":1,"projectId":1,"content":"","platform":1}}]}
2022-02-15 14:36:53.759 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"step","des":"打开应用","log":"App包名： com.rf.zjkj","time":"14:36:53","rid":0,"udId":"MF2CG121630I252383","status":2,"cid":0}
2022-02-15 14:36:53.760 INFO 21952 --- [android-run-step-task-0-0-MF2CG121630I252383] org.cloud.sonic.agent.tools.LogTool : {"msg":"status","des":"","log":"","time":"14:36:53","rid":0,"udId":"MF2CG121630I252383","status":1,"cid":0}
2022-02-15 14:37:03.041 INFO 21952 --- [http-nio-7777-exec-4] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:37:18.645 ERROR 21952 --- [pool-2-thread-19] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15518ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 51626, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 51626, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 439d431e-29ed-4069-9f79-a5eb57e66c9a
2022-02-15 14:40:35.025 INFO 21952 --- [http-nio-7777-exec-7] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:40:50.636 ERROR 21952 --- [pool-2-thread-20] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15517ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 51626, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 51626, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 439d431e-29ed-4069-9f79-a5eb57e66c9a
2022-02-15 14:50:04.128 INFO 21952 --- [http-nio-7777-exec-8] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:50:19.740 ERROR 21952 --- [pool-2-thread-21] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15517ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 51626, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 51626, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 439d431e-29ed-4069-9f79-a5eb57e66c9a
2022-02-15 14:50:28.111 INFO 21952 --- [http-nio-7777-exec-10] o.c.s.agent.websockets.AndroidWSServer : e 发送 {"hasScreen":true,"detail":"tree","type":"debug"}
2022-02-15 14:50:43.684 ERROR 21952 --- [pool-2-thread-21] o.c.s.agent.websockets.AndroidWSServer : An unknown server-side error occurred while processing the command. Original error: Timed out after 15517ms waiting for the root AccessibilityNodeInfo in the active window. Make sure the active window is not constantly hogging the main UI thread (e.g. the application is being idle long enough), so the accessibility manager could do its work
Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
System info: host: 'LAPTOP-I77IF2GQ', ip: '10.25.7.86', os.name: 'Windows 10', os.arch: 'amd64', os.version: '10.0', java.version: '17.0.2'
Driver info: io.appium.java_client.android.AndroidDriver
Capabilities {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, databaseEnabled: false, desired: {adbExecTimeout: 7200000, automationName: UIAutomator2, browserName: , chromedriverChromeMappingFile: webview/version.json, chromedriverExecutableDir: webview, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, newCommandTimeout: 7200, noReset: true, platformName: android, recreateChromeDriverSessions: true, skipLogcatCapture: true, systemPort: 51626, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000}, deviceApiLevel: 28, deviceManufacturer: Newland, deviceModel: N5S, deviceName: MF2CG121630I252383, deviceScreenDensity: 240, deviceScreenSize: 480x800, deviceUDID: MF2CG121630I252383, disableSuppressAccessibilityService: true, goog:chromeOptions: {androidProcess: com.tencent.mm:tools, args: [], extensions: []}, javascriptEnabled: true, locationContextEnabled: false, networkConnectionEnabled: true, newCommandTimeout: 7200, noReset: true, pixelRatio: 1.5, platform: LINUX, platformName: ANDROID, platformVersion: 9, recreateChromeDriverSessions: true, skipLogcatCapture: true, statBarHeight: 36, systemPort: 51626, takesScreenshot: true, udid: MF2CG121630I252383, uiautomator2ServerInstallTimeout: 600000, viewportRect: {height: 764, left: 0, top: 36, width: 480}, warnings: {}, webStorageEnabled: false}
Session ID: 439d431e-29ed-4069-9f79-a5eb57e66c9a