********************************************************************************
Beginning Test:  com/sun/ts/tests/websocket/ee/javax/websocket/remoteendpoint/usercoder/async/WSClient.java#sendObjectPrimitivesBinaryStreamEncoderOnClientTest
********************************************************************************

Undeploying apps...
StandardDeployment14.isDeployed()
Deployed Modules: 

Search for s1as runtime files match:`wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web.war`
Valid runtime files after sweep:
Deploying apps for forward rebuildable...
Search for s1as runtime files match:`wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web.war`
Valid runtime files after sweep:
StandardDeployment14.deploy()
Starting to distribute:  /home/ec2-user/jakartaee8tck/dist/com/sun/ts/tests/websocket/ee/javax/websocket/remoteendpoint/usercoder/async/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web.war
file: /home/ec2-user/jakartaee8tck/dist/com/sun/ts/tests/websocket/ee/javax/websocket/remoteendpoint/usercoder/async/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web.war
plan: java.io.ByteArrayInputStream@362a930e
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
$$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee8tck/dist/com/sun/ts/tests/websocket/ee/javax/websocket/remoteendpoint/usercoder/async/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web.war"
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
harness.executeMode is set to "0"
keywords (to be passed to tests) set to:  all
sClassPathFromExecProps = ::
harness.executeMode is set to "0"
keywords (to be passed to tests) set to:  all
sClassPathFromExecProps = ::
02-08-2022 16:26:43:  Harness - harness.executeMode is set to "0"
02-08-2022 16:26:43:  Harness - keywords (to be passed to tests) set to:  all
02-08-2022 16:26:43:  Harness - sClassPathFromExecProps = ::
command: com.sun.ts.lib.harness.ExecTSTestCmd CLASSPATH=:::/home/ec2-user/jakartaee8tck/lib/jaxb-api.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-core.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-impl.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-xjc.jar:/home/ec2-user/jakartaee8tck/lib/tsharness.jar:/home/ec2-user/jakartaee8tck/lib/cts.jar:/home/ec2-user/jakartaee8tck/lib/sigtest.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/javaee-api-8.0-5-tomcat.jar:/home/ec2-user/jdk8u282-b08/jre/lib/rt.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/tomee-tck-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/openejb-core-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/openejb-core-eclipselink-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/activemq-client-5.16.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/activemq-jdbc-store-5.16.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/bval-jsr-2.0.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/catalina.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-cli-1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-collections-3.2.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-dbcp2-2.3.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-lang3-3.12.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-logging-1.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/commons-pool2-2.11.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/cts-8.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/dbprocedures-8.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/derby-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/derbyclient-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/derbynet-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/eclipselink-2.7.9.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/el-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/geronimo-connector-3.1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/geronimo-javamail_1.6_mail-1.0.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/geronimo-mail-2.0.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/geronimo-transaction-3.1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/hawtbuf-1.11.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/howl-1.0.1-1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/hsqldb-2.3.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/istack-commons-runtime-3.0.11.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jackson-annotations-2.13.0-rc2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jackson-core-2.13.0-rc2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jackson-databind-2.13.0-rc2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jakarta.activation-1.2.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jakarta.xml.bind-api-2.3.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jaspic-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/javaee-api-8.0-5-tomcat.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jaxb-runtime-2.3.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/johnzon-core-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/johnzon-jaxrs-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/johnzon-jsonb-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/johnzon-jsonp-strict-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/johnzon-mapper-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/jsp-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/mbean-annotation-api-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-api-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-core-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-core-eclipselink-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-cxf-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-cxf-rs-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-cxf-transport-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-javaagent.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-jee-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-jee-accessors-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-jpa-integration-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openejb-loader-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openjpa-3.2.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-ee-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-ee-common-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-ejb-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-el22-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-impl-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-spi-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/openwebbeans-web-2.0.26.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/quartz-openejb-shade-2.2.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/serp-1.15.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/servlet-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/slf4j-api-1.7.21.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/stax-ex-1.8.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/swizzle-stream-1.6.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/sxc-jaxb-core-0.8.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/sxc-runtime-0.8.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomcat-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomcat-juli.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomcat-util-scan.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomcat-util.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomcat-websocket.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomee-catalina-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tomee-security-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tsharness-8.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/tssv-8.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/txw2-2.3.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/webdeployer-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/websocket-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/whitebox-8.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/xbean-asm9-shaded-4.20.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/xbean-bundleutils-4.20.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/xbean-finder-shaded-4.20.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/xbean-naming-4.20.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/lib/xbean-reflect-4.20.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/commons-logging-1.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/eclipselink-2.7.9.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/derby-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/derbyclient-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/openejb-client-8.0.10-SNAPSHOT.jar:/home/ec2-user/jakartaee8tck/lib/javatest.jar:/home/ec2-user/jakartaee8tck/lib/tsharness.jar:/home/ec2-user/jakartaee8tck/lib/cts.jar:/home/ec2-user/jakartaee8tck/lib/dbprocedures.jar:/home/ec2-user/jakartaee8tck/lib/commons-httpclient-3.1.jar:/home/ec2-user/jakartaee8tck/lib/jdom-1.1.3.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-api.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-impl.jar:/home/ec2-user/jakartaee8tck/lib/jaxb-xjc.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/jasper-el.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/cxf-shade-8.0.10-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/woodstox-core-6.2.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/stax2-api-4.2.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/xmlschema-core-2.2.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/cxf-rt-rs-sse-3.4.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/johnzon-core-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/johnzon-jaxrs-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/johnzon-jsonb-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/johnzon-jsonp-strict-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/johnzon-mapper-1.2.16.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-coyote.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-dbcp.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-cs.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-de.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-es.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-fr.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-ja.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-ko.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-pt-BR.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-ru.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-i18n-zh-CN.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-jdbc.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-jni.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-util-scan.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-util.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/lib/tomcat-websocket.jar:/home/ec2-user/jakartaee8tck/lib/javatest.jar:/home/ec2-user/jakartaee8tck/lib/jdom-1.1.3.jar:/lib/ant.jar:/home/ec2-user/glassfish5/glassfish/modules/admin-cli.jar:/home/ec2-user/jakartaee8tck/lib/http.jar:/home/ec2-user/jakartaee8tck/classes:/home/ec2-user/jdk8u282-b08/jre/../lib/tools.jar:/home/ec2-user/jakartaee8tck/lib/commons-httpclient-3.1.jar:/home/ec2-user/jakartaee8tck/lib/commons-logging-1.1.3.jar:/home/ec2-user/jakartaee8tck/lib/commons-codec-1.9.jar:/home/ec2-user/jakartaee8tck/lib/cssparser-0.9.25.jar:/home/ec2-user/jakartaee8tck/lib/htmlunit-2.15.jar:/home/ec2-user/jakartaee8tck/lib/htmlunit-core-js-2.15.jar:/home/ec2-user/jakartaee8tck/lib/httpclient-4.5.5.jar:/home/ec2-user/jakartaee8tck/lib/httpmime-4.5.5.jar:/home/ec2-user/jakartaee8tck/lib/httpcore-4.4.9.jar:/home/ec2-user/jakartaee8tck/lib/commons-collections-3.2.1.jar:/home/ec2-user/jakartaee8tck/lib/commons-io-2.4.jar:/home/ec2-user/jakartaee8tck/lib/commons-lang3-3.3.2.jar:/home/ec2-user/jakartaee8tck/lib/jaxen-1.1.6.jar:/home/ec2-user/jakartaee8tck/lib/jaxen-core-1.0.jar:/home/ec2-user/jakartaee8tck/lib/js-1.6R1.jar:/home/ec2-user/jakartaee8tck/lib/nekohtml-1.9.21.jar:/home/ec2-user/jakartaee8tck/lib/sac-1.3.jar:/home/ec2-user/jakartaee8tck/lib/saxpath.jar:/home/ec2-user/jakartaee8tck/lib/xercesImpl-2.11.0.jar:/home/ec2-user/jakartaee8tck/lib/xalan-2.7.2.jar:/home/ec2-user/jakartaee8tck/lib/tssv.jar:/home/ec2-user/jakartaee8tck/lib/xml-apis-1.4.01.jar DISPLAY=:0.0 HOME=/home/ec2-user windir= SYSTEMROOT= PATH=/home/ec2-user/glassfish5/glassfish/nativelib /home/ec2-user/jdk8u282-b08/jre/bin/java -Dcts.tmp=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/harnesstmp/ -Djava.protocol.handler.pkgs=javax.net.ssl -Djavax.net.ssl.keyStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/src/test/keystores/clientcert.jks -Djavax.net.ssl.keyStorePassword=changeit -Djavax.net.ssl.trustStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/src/test/keystores/ssl-truststore -Djavax.net.ssl.trustStorePassword=changeit -Djava.endorsed.dirs=/home/ec2-user/jakartaee8tck/endorsedlib -Dcom.sun.aas.installRoot=/home/ec2-user/glassfish5/glassfish -Dcatalina.base=target/apache-tomee-plume-8.0.10-SNAPSHOT -Dlog.file.location=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/logs -Dservlet.is.jsr115.compatible=false -Dprovider.configuration.file=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/apache-tomee-plume-8.0.10-SNAPSHOT/conf/ProviderConfiguration.xml -Dlogical.hostname.servlet=Catalina/localhost -Dcom.sun.aas.configRoot=/home/ec2-user/glassfish5/glassfish/config -Ddeliverable.class=com.sun.ts.lib.deliverable.cts.CTSDeliverable -Dopenejb.validation.output.level=3 -Djava.security.egd=file:/dev/./urandom -Dbin.dir=/home/ec2-user/jakartaeetck-8.0.2-final/bin com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient -p /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp8730793806951932480dir/gbuild/work/workspace-1/project-11118/target/harnesstmp//tmp/tstest.jte -t sendObjectPrimitivesBinaryStreamEncoderOnClientTest
************************************************************
* props file set to "/tmp/ec2-user-cts-props.txt"
************************************************************
02-08-2022 16:26:44:  TRACE: #######  Value of harness.socket.retry.count is "10"
02-08-2022 16:26:44:  TRACE: #######  Value of harness.log.port is "41285"
02-08-2022 16:26:44:  TRACE: #######  Actual bind value of harness.log.port is "41285"
02-08-2022 16:26:44:  TRACE: in custom vehicle so call on EETest.
02-08-2022 16:26:44:  TRACE: *** in EETest.run(argv,p)
02-08-2022 16:26:44:  TRACE: TESTCLASS=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:44:  TRACE: ** IN getRunMethod: testClass=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:44:  TRACE: ** IN getRunMethod: testname=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:44:  TRACE: ** GOT RUN METHOD!
02-08-2022 16:26:44:  TRACE: **runmethod=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:44:  TRACE: ABOUT TO GET SETUP METHOD!
02-08-2022 16:26:44:  TRACE: No setupMethod annotation present
02-08-2022 16:26:44:  TRACE: getSetupMethod - checking for testcase specific setup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_setup
02-08-2022 16:26:44:  TRACE: getSetupMethod - checking for default class specific setup method
02-08-2022 16:26:44:  TRACE: GOT SETUP METHOD!
02-08-2022 16:26:44:  TRACE: No cleanupMethod annotation present
02-08-2022 16:26:44:  TRACE: getCleanupMethod - checking for testcase specific cleanup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_cleanup
02-08-2022 16:26:44:  TRACE: getCleanupMethod - checking for default class specific cleanup method
02-08-2022 16:26:44:  TRACE: GOT CLEANUP METHOD!
02-08-2022 16:26:44:  TRACE: ABOUT TO INVOKE SETUP METHOD!
02-08-2022 16:26:44:  TRACE: setup method WebSocketCommonClient
02-08-2022 16:26:44:  [WebSocketCommonClient] Test setup OK
02-08-2022 16:26:44:  TRACE: INVOKED SETUP METHOD!
02-08-2022 16:26:44:  TRACE: ABOUT TO INVOKE EETEST RUN METHOD!
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 0
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 0
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 0
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 0 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 1
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 1
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 1
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 1 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 2
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 2
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 2
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 2 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 3
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 3
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 3
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 3 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 4
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 4
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 4
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 4 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 5
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 5
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 5
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 5 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 6
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 6
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 6
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 6 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  TRACE: Reseting callback and message
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:44:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:44:  TRACE: On open on session id 7
02-08-2022 16:26:44:  TRACE: RequestUri: NULL
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Connection session id: 7
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:44:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:44:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:44:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] session.close() on session id 7
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] On close on session id 7 reason CloseReason: code [1000], reason []
02-08-2022 16:26:44:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:44:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: SLEPT FOR:  1000
02-08-2022 16:26:45:  TRACE: in custom vehicle so call on EETest.
02-08-2022 16:26:45:  TRACE: *** in EETest.run(argv,p)
02-08-2022 16:26:45:  TRACE: TESTCLASS=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:45:  TRACE: ** IN getRunMethod: testClass=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:45:  TRACE: ** IN getRunMethod: testname=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:45:  TRACE: ** GOT RUN METHOD!
02-08-2022 16:26:45:  TRACE: **runmethod=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:45:  TRACE: ABOUT TO GET SETUP METHOD!
02-08-2022 16:26:45:  TRACE: No setupMethod annotation present
02-08-2022 16:26:45:  TRACE: getSetupMethod - checking for testcase specific setup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_setup
02-08-2022 16:26:45:  TRACE: getSetupMethod - checking for default class specific setup method
02-08-2022 16:26:45:  TRACE: GOT SETUP METHOD!
02-08-2022 16:26:45:  TRACE: No cleanupMethod annotation present
02-08-2022 16:26:45:  TRACE: getCleanupMethod - checking for testcase specific cleanup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_cleanup
02-08-2022 16:26:45:  TRACE: getCleanupMethod - checking for default class specific cleanup method
02-08-2022 16:26:45:  TRACE: GOT CLEANUP METHOD!
02-08-2022 16:26:45:  TRACE: ABOUT TO INVOKE SETUP METHOD!
02-08-2022 16:26:45:  TRACE: setup method WebSocketCommonClient
02-08-2022 16:26:45:  [WebSocketCommonClient] Test setup OK
02-08-2022 16:26:45:  TRACE: INVOKED SETUP METHOD!
02-08-2022 16:26:45:  TRACE: ABOUT TO INVOKE EETEST RUN METHOD!
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id 8
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: 8
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id 8
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id 8 reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id 9
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: 9
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id 9
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id 9 reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id a
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: a
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id a
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id a reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id b
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: b
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id b
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id b reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id c
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: c
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id c
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id c reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id d
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: d
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id d
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id d reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id e
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: e
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id e
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id e reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  TRACE: Reseting callback and message
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:45:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:45:  TRACE: On open on session id f
02-08-2022 16:26:45:  TRACE: RequestUri: NULL
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Connection session id: f
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:45:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:45:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:45:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] session.close() on session id f
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] On close on session id f reason CloseReason: code [1000], reason []
02-08-2022 16:26:45:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:45:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: SLEPT FOR:  1000
02-08-2022 16:26:46:  TRACE: in custom vehicle so call on EETest.
02-08-2022 16:26:46:  TRACE: *** in EETest.run(argv,p)
02-08-2022 16:26:46:  TRACE: TESTCLASS=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:46:  TRACE: ** IN getRunMethod: testClass=com.sun.ts.tests.websocket.ee.javax.websocket.remoteendpoint.usercoder.async.WSClient
02-08-2022 16:26:46:  TRACE: ** IN getRunMethod: testname=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:46:  TRACE: ** GOT RUN METHOD!
02-08-2022 16:26:46:  TRACE: **runmethod=sendObjectPrimitivesBinaryStreamEncoderOnClientTest
02-08-2022 16:26:46:  TRACE: ABOUT TO GET SETUP METHOD!
02-08-2022 16:26:46:  TRACE: No setupMethod annotation present
02-08-2022 16:26:46:  TRACE: getSetupMethod - checking for testcase specific setup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_setup
02-08-2022 16:26:46:  TRACE: getSetupMethod - checking for default class specific setup method
02-08-2022 16:26:46:  TRACE: GOT SETUP METHOD!
02-08-2022 16:26:46:  TRACE: No cleanupMethod annotation present
02-08-2022 16:26:46:  TRACE: getCleanupMethod - checking for testcase specific cleanup method:  sendObjectPrimitivesBinaryStreamEncoderOnClientTest_cleanup
02-08-2022 16:26:46:  TRACE: getCleanupMethod - checking for default class specific cleanup method
02-08-2022 16:26:46:  TRACE: GOT CLEANUP METHOD!
02-08-2022 16:26:46:  TRACE: ABOUT TO INVOKE SETUP METHOD!
02-08-2022 16:26:46:  TRACE: setup method WebSocketCommonClient
02-08-2022 16:26:46:  [WebSocketCommonClient] Test setup OK
02-08-2022 16:26:46:  TRACE: INVOKED SETUP METHOD!
02-08-2022 16:26:46:  TRACE: ABOUT TO INVOKE EETEST RUN METHOD!
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 10
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 10
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 10
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 10 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 11
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 11
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 11
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 11 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 12
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 12
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 12
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 12 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 13
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 13
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 13
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 13 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 14
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 14
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 14
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 14 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 15
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 15
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 15
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 15 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 16
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 16
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 16
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 16 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  TRACE: Reseting callback and message
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] A new test case has been created
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] invoke
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] EXECUTING
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] setTestProperties
02-08-2022 16:26:46:  [WebSocketCommonClient] Connecting to ws://localhost:42543/wsc_ee_javax_websocket_remoteendpoint_usercoder_async_web/echo
02-08-2022 16:26:46:  TRACE: On open on session id 17
02-08-2022 16:26:46:  TRACE: RequestUri: NULL
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Connection session id: 17
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] Setting CountDownLatch to 5 seconds, should be hit 1 times
02-08-2022 16:26:46:  TRACE: Received message so far Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch hit
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Expected Status Code '200' found in response line!
02-08-2022 16:26:46:  [WebSocketCommonClient] Response: Anything that should have been coded has been coded into this
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Scanning response for search string: 'Anything that should have been coded has been coded into this' starting at index location: 0
02-08-2022 16:26:46:  TRACE: [WebValidatorBase] Found search string: 'Anything that should have been coded has been coded into this' at index '0' in the server's response
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] CountDownLatch has been hit 1 times as expected
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] session.close() on session id 17
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] On close on session id 17 reason CloseReason: code [1000], reason []
02-08-2022 16:26:46:  TRACE: [WebSocketCommonClient] onClose has been called
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:46:  [WebSocketCommonClient] Test cleanup OK
02-08-2022 16:26:47:  TRACE: SLEPT FOR:  1000
STATUS:Passed.
Passed.
********************************************************************************
Finished Test:  PASSED........com/sun/ts/tests/websocket/ee/javax/websocket/remoteendpoint/usercoder/async/WSClient.java#sendObjectPrimitivesBinaryStreamEncoderOnClientTest
********************************************************************************