Started by an SCM change Building in workspace /home/tomcat/.jenkins/workspace/house.intelli > git rev-parse --is-inside-work-tree Fetching changes from the remote Git repository > git config remote.origin.url https://github.com/intellihouse/intellihouse.git Fetching upstream changes from https://github.com/intellihouse/intellihouse.git > git --version using .gitcredentials to set credentials > git config --local credential.helper store --file=/home/tomcat/tomcat/temp/git803312937070540167.credentials > git fetch --tags --progress https://github.com/intellihouse/intellihouse.git +refs/heads/*:refs/remotes/origin/* > git config --local --remove-section credential > git rev-parse origin/master^{commit} Checking out Revision f370a56fcd89fe54db34ec3a6e80a9794cc3f4a0 (origin/master) > git config core.sparsecheckout > git checkout -f f370a56fcd89fe54db34ec3a6e80a9794cc3f4a0 > git rev-list ca45e116f454655fbe1c23441a7a48123ecc931d [Gradle] - Launching build. [house.intelli] $ gradle -Dtest.ignoreFailures=true -i clean build install Initialized native services in: /home/tomcat/.gradle/native Removing 0 daemon stop events from registry Starting a Gradle Daemon (subsequent builds will be faster) Starting daemon process: workingDir = /home/tomcat/.gradle/daemon/3.1, daemonArgs: [/usr/lib/jvm/java-8-openjdk-amd64/bin/java, -XX:MaxPermSize=256m, -XX:+HeapDumpOnOutOfMemoryError, -Xmx1024m, -Dfile.encoding=UTF-8, -Duser.country=GB, -Duser.language=en, -Duser.variant, -cp, /home/tomcat/gradle-3.1/lib/gradle-launcher-3.1.jar, org.gradle.launcher.daemon.bootstrap.GradleDaemon, 3.1] Starting process 'Gradle build daemon'. Working directory: /home/tomcat/.gradle/daemon/3.1 Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -XX:MaxPermSize=256m -XX:+HeapDumpOnOutOfMemoryError -Xmx1024m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -cp /home/tomcat/gradle-3.1/lib/gradle-launcher-3.1.jar org.gradle.launcher.daemon.bootstrap.GradleDaemon 3.1 Successfully started process 'Gradle build daemon' An attempt to start the daemon took 2.185 secs. Connected to daemon DaemonInfo{pid=9738, address=[3316a64a-638d-49e2-96b5-a8c32e5f0e38 port:34619, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546219903255, context=DefaultDaemonContext[uid=a9f47f13-687e-4ba9-a047-a45842857cc2,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=9738,idleTimeout=10800000,daemonOpts=-XX:MaxPermSize=256m,-XX:+HeapDumpOnOutOfMemoryError,-Xmx1024m,-Dfile.encoding=UTF-8,-Duser.country=GB,-Duser.language=en,-Duser.variant]}. Dispatching request Build{id=4933cf78-8419-4cde-a932-cd9e0583d573.1, currentDir=/home/tomcat/.jenkins/workspace/house.intelli/house.intelli}. Received result org.gradle.launcher.daemon.protocol.BuildStarted@2049a9c1 from daemon DaemonInfo{pid=9738, address=[3316a64a-638d-49e2-96b5-a8c32e5f0e38 port:34619, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546219903255, context=DefaultDaemonContext[uid=a9f47f13-687e-4ba9-a047-a45842857cc2,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=9738,idleTimeout=10800000,daemonOpts=-XX:MaxPermSize=256m,-XX:+HeapDumpOnOutOfMemoryError,-Xmx1024m,-Dfile.encoding=UTF-8,-Duser.country=GB,-Duser.language=en,-Duser.variant]} (build should be starting). The client will now receive all logging from the daemon (pid: 9738). The daemon log file: /home/tomcat/.gradle/daemon/3.1/daemon-9738.out.log Starting build in new daemon [memory: 954.7 MB] Closing daemon's stdin at end of input. The daemon will no longer process any standard input. Executing build with daemon context: DefaultDaemonContext[uid=a9f47f13-687e-4ba9-a047-a45842857cc2,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=9738,idleTimeout=10800000,daemonOpts=-XX:MaxPermSize=256m,-XX:+HeapDumpOnOutOfMemoryError,-Xmx1024m,-Dfile.encoding=UTF-8,-Duser.country=GB,-Duser.language=en,-Duser.variant] Starting Build Compiling settings file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/settings.gradle' using SubsetScriptTransformer. Compiling settings file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/settings.gradle' using BuildScriptTransformer. Settings evaluated using settings file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/settings.gradle'. Projects loaded. Root project using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build.gradle'. Included projects: [root project 'house.intelli', project ':house.intelli.android', project ':house.intelli.core', project ':house.intelli.desktop', project ':house.intelli.jdo', project ':house.intelli.pgp', project ':house.intelli.raspi'] Evaluating root project 'house.intelli' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build.gradle' using BuildScriptTransformer. Evaluating project ':house.intelli.android' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build.gradle' using BuildScriptTransformer. Evaluating project ':house.intelli.core' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build.gradle' using BuildScriptTransformer. Evaluating project ':house.intelli.desktop' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build.gradle'. Evaluating project ':house.intelli.jdo' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build.gradle' using BuildScriptTransformer. Evaluating project ':house.intelli.pgp' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build.gradle' using BuildScriptTransformer. Evaluating project ':house.intelli.raspi' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build.gradle'. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build.gradle' using SubsetScriptTransformer. Compiling build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build.gradle' using BuildScriptTransformer. All projects evaluated. Selected primary task 'clean' from project : Selected primary task 'build' from project : Selected primary task 'install' from project : Tasks to be executed: [task ':clean', task ':house.intelli.android:clean', task ':house.intelli.core:clean', task ':house.intelli.desktop:clean', task ':house.intelli.jdo:clean', task ':house.intelli.pgp:clean', task ':house.intelli.raspi:clean', task ':compileJava', task ':processResources', task ':classes', task ':jar', task ':assemble', task ':compileTestJava', task ':processTestResources', task ':testClasses', task ':test', task ':check', task ':build', task ':house.intelli.core:compileJava', task ':house.intelli.core:processResources', task ':house.intelli.core:classes', task ':house.intelli.core:jar', task ':house.intelli.android:compileJava', task ':house.intelli.android:processResources', task ':house.intelli.android:classes', task ':house.intelli.android:jar', task ':house.intelli.android:assemble', task ':house.intelli.android:compileTestJava', task ':house.intelli.android:processTestResources', task ':house.intelli.android:testClasses', task ':house.intelli.android:test', task ':house.intelli.android:check', task ':house.intelli.android:build', task ':house.intelli.core:assemble', task ':house.intelli.core:compileTestJava', task ':house.intelli.core:processTestResources', task ':house.intelli.core:testClasses', task ':house.intelli.core:test', task ':house.intelli.core:check', task ':house.intelli.core:build', task ':house.intelli.desktop:compileJava', task ':house.intelli.desktop:processResources', task ':house.intelli.desktop:classes', task ':house.intelli.desktop:jar', task ':house.intelli.desktop:assemble', task ':house.intelli.desktop:compileTestJava', task ':house.intelli.desktop:processTestResources', task ':house.intelli.desktop:testClasses', task ':house.intelli.desktop:test', task ':house.intelli.desktop:check', task ':house.intelli.desktop:build', task ':house.intelli.jdo:compileJava', task ':house.intelli.jdo:processResources', task ':house.intelli.jdo:classes', task ':house.intelli.jdo:jar', task ':house.intelli.jdo:assemble', task ':house.intelli.jdo:compileTestJava', task ':house.intelli.jdo:processTestResources', task ':house.intelli.jdo:testClasses', task ':house.intelli.jdo:test', task ':house.intelli.jdo:check', task ':house.intelli.jdo:build', task ':house.intelli.pgp:compileJava', task ':house.intelli.pgp:processResources', task ':house.intelli.pgp:classes', task ':house.intelli.pgp:jar', task ':house.intelli.pgp:assemble', task ':house.intelli.pgp:compileTestJava', task ':house.intelli.pgp:processTestResources', task ':house.intelli.pgp:testClasses', task ':house.intelli.pgp:test', task ':house.intelli.pgp:check', task ':house.intelli.pgp:build', task ':house.intelli.raspi:compileJava', task ':house.intelli.raspi:processResources', task ':house.intelli.raspi:classes', task ':house.intelli.raspi:jar', task ':house.intelli.raspi:copyFilesFromAssembly', task ':house.intelli.raspi:copyFilesFromBin', task ':house.intelli.raspi:chmodMainExecutable', task ':house.intelli.raspi:copyDependencies', task ':house.intelli.raspi:copyJar', task ':house.intelli.raspi:tarGzAssembly', task ':house.intelli.raspi:assemble', task ':house.intelli.raspi:compileTestJava', task ':house.intelli.raspi:processTestResources', task ':house.intelli.raspi:testClasses', task ':house.intelli.raspi:test', task ':house.intelli.raspi:check', task ':house.intelli.raspi:build', task ':copyDistributions', task ':install', task ':house.intelli.android:install', task ':house.intelli.core:install', task ':house.intelli.desktop:install', task ':house.intelli.jdo:install', task ':house.intelli.pgp:install', task ':house.intelli.raspi:install'] :clean (Thread[Daemon worker,5,main]) started. :clean Executing task ':clean' (up-to-date check took 0.001 secs) due to: Task has not declared any outputs. :clean (Thread[Daemon worker,5,main]) completed. Took 0.067 secs. :house.intelli.android:clean (Thread[Daemon worker,5,main]) started. :house.intelli.android:clean Executing task ':house.intelli.android:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.android:clean (Thread[Daemon worker,5,main]) completed. Took 0.035 secs. :house.intelli.core:clean (Thread[Daemon worker,5,main]) started. :house.intelli.core:clean Executing task ':house.intelli.core:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.core:clean (Thread[Daemon worker,5,main]) completed. Took 0.448 secs. :house.intelli.desktop:clean (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:clean Executing task ':house.intelli.desktop:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.desktop:clean (Thread[Daemon worker,5,main]) completed. Took 0.051 secs. :house.intelli.jdo:clean (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:clean Executing task ':house.intelli.jdo:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.jdo:clean (Thread[Daemon worker,5,main]) completed. Took 0.141 secs. :house.intelli.pgp:clean (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:clean Executing task ':house.intelli.pgp:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.pgp:clean (Thread[Daemon worker,5,main]) completed. Took 0.183 secs. :house.intelli.raspi:clean (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:clean Executing task ':house.intelli.raspi:clean' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. :house.intelli.raspi:clean (Thread[Daemon worker,5,main]) completed. Took 0.142 secs. :compileJava (Thread[Daemon worker,5,main]) started. :compileJava file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/main/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/main/java', not found Skipping task ':compileJava' as it has no source files. :compileJava UP-TO-DATE :compileJava (Thread[Daemon worker,5,main]) completed. Took 0.065 secs. :processResources (Thread[Daemon worker,5,main]) started. :processResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/main/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/main/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/main/resources', not found Skipping task ':processResources' as it has no source files. :processResources UP-TO-DATE :processResources (Thread[Daemon worker,5,main]) completed. Took 0.003 secs. :classes (Thread[Daemon worker,5,main]) started. :classes Skipping task ':classes' as it has no actions. :classes UP-TO-DATE :classes (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :jar (Thread[Daemon worker,5,main]) started. :jar Executing task ':jar' (up-to-date check took 0.596 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build/libs/house.intelli-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build/libs/house.intelli-0.9.1-SNAPSHOT.jar has been removed. :jar (Thread[Daemon worker,5,main]) completed. Took 0.74 secs. :assemble (Thread[Daemon worker,5,main]) started. :assemble Skipping task ':assemble' as it has no actions. :assemble (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :compileTestJava (Thread[Daemon worker,5,main]) started. :compileTestJava file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/test/java', not found Skipping task ':compileTestJava' as it has no source files. :compileTestJava UP-TO-DATE :compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.005 secs. :processTestResources (Thread[Daemon worker,5,main]) started. :processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/src/test/resources', not found Skipping task ':processTestResources' as it has no source files. :processTestResources UP-TO-DATE :processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.005 secs. :testClasses (Thread[Daemon worker,5,main]) started. :testClasses Skipping task ':testClasses' as it has no actions. :testClasses UP-TO-DATE :testClasses (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :test (Thread[Daemon worker,5,main]) started. :test file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build/classes/test', not found Skipping task ':test' as it has no source files. :test UP-TO-DATE :test (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :check (Thread[Daemon worker,5,main]) started. :check Skipping task ':check' as it has no actions. :check UP-TO-DATE :check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :build (Thread[Daemon worker,5,main]) started. :build Skipping task ':build' as it has no actions. :build (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.core:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.core:compileJava Download https://jcenter.bintray.com/org/slf4j/slf4j-api/1.7.21/slf4j-api-1.7.21.pom Download https://jcenter.bintray.com/org/slf4j/slf4j-parent/1.7.21/slf4j-parent-1.7.21.pom Download https://jcenter.bintray.com/org/apache/commons/commons-collections4/4.0/commons-collections4-4.0.pom Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/apache/commons/commons-parent/32/commons-parent-32.pom, /home/tomcat/.m2/repository/org/apache/commons/commons-parent/32/commons-parent-32.pom] Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/apache/apache/13/apache-13.pom, /home/tomcat/.m2/repository/org/apache/apache/13/apache-13.pom] Download https://jcenter.bintray.com/org/slf4j/slf4j-api/1.7.21/slf4j-api-1.7.21.jar Download https://jcenter.bintray.com/org/apache/commons/commons-collections4/4.0/commons-collections4-4.0.jar Executing task ':house.intelli.core:compileJava' (up-to-date check took 2.805 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.core:compileJava'. Compiling with JDK Java compiler API. Note: Some input files use unchecked or unsafe operations. Note: Recompile with -Xlint:unchecked for details. :house.intelli.core:compileJava (Thread[Daemon worker,5,main]) completed. Took 11.001 secs. :house.intelli.core:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.core:processResources Executing task ':house.intelli.core:processResources' (up-to-date check took 0.103 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/resources/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/resources/main/META-INF has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/resources/main/META-INF/services has been removed. :house.intelli.core:processResources (Thread[Daemon worker,5,main]) completed. Took 0.283 secs. :house.intelli.core:classes (Thread[Daemon worker,5,main]) started. :house.intelli.core:classes Skipping task ':house.intelli.core:classes' as it has no actions. :house.intelli.core:classes (Thread[Daemon worker,5,main]) completed. Took 0.004 secs. :house.intelli.core:jar (Thread[Daemon worker,5,main]) started. :house.intelli.core:jar Executing task ':house.intelli.core:jar' (up-to-date check took 0.805 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/libs/house.intelli.core-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/libs/house.intelli.core-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.core:jar (Thread[Daemon worker,5,main]) completed. Took 3.853 secs. :house.intelli.android:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.android:compileJava Executing task ':house.intelli.android:compileJava' (up-to-date check took 0.023 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.android:compileJava'. Compiling with JDK Java compiler API. :house.intelli.android:compileJava (Thread[Daemon worker,5,main]) completed. Took 0.083 secs. :house.intelli.android:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.android:processResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/main/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/main/resources', not found Skipping task ':house.intelli.android:processResources' as it has no source files. :house.intelli.android:processResources UP-TO-DATE :house.intelli.android:processResources (Thread[Daemon worker,5,main]) completed. Took 0.004 secs. :house.intelli.android:classes (Thread[Daemon worker,5,main]) started. :house.intelli.android:classes Skipping task ':house.intelli.android:classes' as it has no actions. :house.intelli.android:classes (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.android:jar (Thread[Daemon worker,5,main]) started. :house.intelli.android:jar Executing task ':house.intelli.android:jar' (up-to-date check took 0.045 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/libs/house.intelli.android-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/libs/house.intelli.android-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.android:jar (Thread[Daemon worker,5,main]) completed. Took 0.125 secs. :house.intelli.android:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.android:assemble Skipping task ':house.intelli.android:assemble' as it has no actions. :house.intelli.android:assemble (Thread[Daemon worker,5,main]) completed. Took 0.0 secs. :house.intelli.android:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.android:compileTestJava file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/test/java', not found Skipping task ':house.intelli.android:compileTestJava' as it has no source files. :house.intelli.android:compileTestJava UP-TO-DATE :house.intelli.android:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.android:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.android:processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/src/test/resources', not found Skipping task ':house.intelli.android:processTestResources' as it has no source files. :house.intelli.android:processTestResources UP-TO-DATE :house.intelli.android:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.003 secs. :house.intelli.android:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.android:testClasses Skipping task ':house.intelli.android:testClasses' as it has no actions. :house.intelli.android:testClasses UP-TO-DATE :house.intelli.android:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.android:test (Thread[Daemon worker,5,main]) started. :house.intelli.android:test file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build/classes/test', not found Skipping task ':house.intelli.android:test' as it has no source files. :house.intelli.android:test UP-TO-DATE :house.intelli.android:test (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.android:check (Thread[Daemon worker,5,main]) started. :house.intelli.android:check Skipping task ':house.intelli.android:check' as it has no actions. :house.intelli.android:check UP-TO-DATE :house.intelli.android:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.android:build (Thread[Daemon worker,5,main]) started. :house.intelli.android:build Skipping task ':house.intelli.android:build' as it has no actions. :house.intelli.android:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.core:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.core:assemble Skipping task ':house.intelli.core:assemble' as it has no actions. :house.intelli.core:assemble (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.core:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.core:compileTestJava Download https://jcenter.bintray.com/org/jmockit/jmockit/1.24/jmockit-1.24.pom Download https://jcenter.bintray.com/junit/junit/4.12/junit-4.12.pom Download https://jcenter.bintray.com/org/assertj/assertj-core/2.4.1/assertj-core-2.4.1.pom Download https://jcenter.bintray.com/org/assertj/assertj-parent-pom/2.1.4/assertj-parent-pom-2.1.4.pom Download https://jcenter.bintray.com/org/slf4j/log4j-over-slf4j/1.7.21/log4j-over-slf4j-1.7.21.pom Download https://jcenter.bintray.com/ch/qos/logback/logback-classic/1.1.7/logback-classic-1.1.7.pom Download https://jcenter.bintray.com/ch/qos/logback/logback-parent/1.1.7/logback-parent-1.1.7.pom Download https://jcenter.bintray.com/org/hamcrest/hamcrest-core/1.3/hamcrest-core-1.3.pom Download https://jcenter.bintray.com/org/hamcrest/hamcrest-parent/1.3/hamcrest-parent-1.3.pom Download https://jcenter.bintray.com/ch/qos/logback/logback-core/1.1.7/logback-core-1.1.7.pom Download https://jcenter.bintray.com/org/jmockit/jmockit/1.24/jmockit-1.24.jar Download https://jcenter.bintray.com/junit/junit/4.12/junit-4.12.jar Download https://jcenter.bintray.com/org/assertj/assertj-core/2.4.1/assertj-core-2.4.1.jar Download https://jcenter.bintray.com/org/slf4j/log4j-over-slf4j/1.7.21/log4j-over-slf4j-1.7.21.jar Download https://jcenter.bintray.com/ch/qos/logback/logback-classic/1.1.7/logback-classic-1.1.7.jar Download https://jcenter.bintray.com/org/hamcrest/hamcrest-core/1.3/hamcrest-core-1.3.jar Download https://jcenter.bintray.com/ch/qos/logback/logback-core/1.1.7/logback-core-1.1.7.jar Executing task ':house.intelli.core:compileTestJava' (up-to-date check took 7.989 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/classes/test has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/classes/test/house has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/classes/test/house/intelli has been removed. All input files are considered out-of-date for incremental task ':house.intelli.core:compileTestJava'. Compiling with JDK Java compiler API. :house.intelli.core:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 8.477 secs. :house.intelli.core:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.core:processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/src/test/resources', not found Skipping task ':house.intelli.core:processTestResources' as it has no source files. :house.intelli.core:processTestResources UP-TO-DATE :house.intelli.core:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.007 secs. :house.intelli.core:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.core:testClasses Skipping task ':house.intelli.core:testClasses' as it has no actions. :house.intelli.core:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.core:test (Thread[Daemon worker,5,main]) started. :house.intelli.core:test Executing task ':house.intelli.core:test' (up-to-date check took 0.091 secs) due to: Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/test-results/test/binary has changed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/test-results/test/binary/output.bin has been removed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/test-results/test/binary/output.bin.idx has been removed. Download https://jcenter.bintray.com/org/jacoco/org.jacoco.agent/0.7.7.201606060606/org.jacoco.agent-0.7.7.201606060606.pom Download https://jcenter.bintray.com/org/jacoco/org.jacoco.build/0.7.7.201606060606/org.jacoco.build-0.7.7.201606060606.pom Download https://jcenter.bintray.com/org/jacoco/org.jacoco.agent/0.7.7.201606060606/org.jacoco.agent-0.7.7.201606060606.jar Starting process 'Gradle Test Executor 6'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 6' Starting process 'Gradle Test Executor 2'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 2' Starting process 'Gradle Test Executor 1'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 1' Starting process 'Gradle Test Executor 3'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 3' Starting process 'Gradle Test Executor 4'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 4' Starting process 'Gradle Test Executor 5'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 5' Successfully started process 'Gradle Test Executor 6' Successfully started process 'Gradle Test Executor 5' Successfully started process 'Gradle Test Executor 1' Successfully started process 'Gradle Test Executor 3' Successfully started process 'Gradle Test Executor 4' OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 Successfully started process 'Gradle Test Executor 2' OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 5 started executing tests. Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 2 started executing tests. Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 4 started executing tests. Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 3 started executing tests. Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 6 started executing tests. Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 1 started executing tests. house.intelli.core.rpc.HttpRpcClientTransportTest > posttestserver SKIPPED Gradle Test Executor 3 finished executing tests. Gradle Test Executor 4 finished executing tests. house.intelli.core.rpc.OpenHabIT > openHabEcho SKIPPED house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT 02:32:34.385 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] INFO house.intelli.core.rpc.PollInverseRequestsThread - run: rpcContext.rpcClientTransportProvider not yet assigned! Going to retry later. 02:32:34.397 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=Hv5aFtyClbLswUAsQbjlVg, clientHostId=server-ICS64bn0ymA4YZI7mOoZCg, serverHostId=client-7cwJuLKsK7Y4UK1THluT0g, created=Mon Dec 31 02:32:34 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0] 02:32:34.737 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=uGCd2iJPASCYfpLUJew90g, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server, created=Mon Dec 31 02:32:34 CET 2018, timeout=600000] 02:32:34.830 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=uGCd2iJPASCYfpLUJew90g, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server, inverseRequests=[EchoRequest[requestId=Hv5aFtyClbLswUAsQbjlVg, clientHostId=server-ICS64bn0ymA4YZI7mOoZCg, serverHostId=client-7cwJuLKsK7Y4UK1THluT0g, created=Mon Dec 31 02:32:34 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]]] 02:32:34.840 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Berwt5cajDv8r_roRECyqw, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server, created=Mon Dec 31 02:32:34 CET 2018, timeout=600000] 02:32:34.897 [pool-1-thread-1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@4cf539ba 02:32:34.949 [pool-1-thread-1] INFO house.intelli.core.service.ServiceRegistry - getServices: delegateClass=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate, serviceClasses=[house.intelli.core.rpc.echo.EchoRpcService] 02:32:35.008 [pool-1-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=Hv5aFtyClbLswUAsQbjlVg, clientHostId=server-ICS64bn0ymA4YZI7mOoZCg, serverHostId=client-7cwJuLKsK7Y4UK1THluT0g, created=Mon Dec 31 02:32:34 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0] 02:32:35.010 [pool-1-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=bla bla trallala] 02:32:35.012 [pool-1-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=Iuvow-MiR06yN4CGndzSeQ, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000] 02:32:35.014 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=Hv5aFtyClbLswUAsQbjlVg, clientHostId=server-ICS64bn0ymA4YZI7mOoZCg, serverHostId=client-7cwJuLKsK7Y4UK1THluT0g, payload=bla bla trallala] 02:32:35.014 [pool-1-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=Iuvow-MiR06yN4CGndzSeQ, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:32:35.094 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=130467, payload=cuojFhKcwHOL4hCA7ozOcQ, throwExceptionClassName=null, sleep=300000] 02:32:35.105 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=revcQdOgdZcw1b5AJP9J8Q, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000] 02:32:35.361 [pool-2-thread-1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@3df42c54 02:32:35.392 [pool-2-thread-1] INFO house.intelli.core.service.ServiceRegistry - getServices: delegateClass=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate, serviceClasses=[house.intelli.core.rpc.echo.EchoRpcService] house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT 02:32:35.367 [Test worker] WARN house.intelli.core.rpc.HostId - Environment variable 'HOSTNAME' is missing or empty. house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:32:35.435 [pool-2-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=130467, payload=cuojFhKcwHOL4hCA7ozOcQ, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT 02:32:35.550 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.rpc.PollInverseRequestsThread - run: rpcContext.rpcClientTransportProvider not yet assigned! Going to retry later. house.intelli.core.rpc.HostIdTest > getLocalHostId STANDARD_OUT 02:32:35.611 [Test worker] WARN house.intelli.core.rpc.HostId - Environment variable 'HOSTNAME' is missing or empty. house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:32:35.749 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) house.intelli.core.rpc.HostIdTest > getLocalHostId STANDARD_OUT localHostId=tyrion1 house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:32:35.765 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=3NzPETMrk9Kdh7p2ENAbXA, clientHostId=server-2B_A0kuG5b99C_eNw8X2tw, serverHostId=client-vLHUWByX3tUQYz7-Md7-XA, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000, payload=8n8y8b3XPCYoftNfFag01g, throwExceptionClassName=null, sleep=300000] 02:32:35.766 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=IXDH0n4pRa_sQZLplvZE5g, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000] Gradle Test Executor 1 finished executing tests. 02:32:35.790 [PollInverseRequestsThread-client-7cwJuLKsK7Y4UK1THluT0g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Berwt5cajDv8r_roRECyqw, clientHostId=client-7cwJuLKsK7Y4UK1THluT0g, serverHostId=server, inverseRequests=[]] 02:32:35.817 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=IXDH0n4pRa_sQZLplvZE5g, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[EchoRequest[requestId=3NzPETMrk9Kdh7p2ENAbXA, clientHostId=server-2B_A0kuG5b99C_eNw8X2tw, serverHostId=client-vLHUWByX3tUQYz7-Md7-XA, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000, payload=8n8y8b3XPCYoftNfFag01g, throwExceptionClassName=null, sleep=300000]]] 02:32:35.832 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=j7HRb-6K1FbCRO7ZfpLhxA, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000] 02:32:35.842 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=3NzPETMrk9Kdh7p2ENAbXA, clientHostId=server-2B_A0kuG5b99C_eNw8X2tw, serverHostId=client-vLHUWByX3tUQYz7-Md7-XA, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000, payload=8n8y8b3XPCYoftNfFag01g, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT 02:32:35.871 [PollInverseRequestsThread-tyrion1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=LaqVn91Ln5hnzzF0vX-MxA, clientHostId=tyrion1, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=600000] 02:32:36.023 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.jaxb.IntelliHouseJaxbContextProvider, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@3030a2f4 02:32:36.049 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - getServices: delegateClass=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate, serviceClasses=[house.intelli.core.jaxb.IntelliHouseJaxbContextProviderImpl] 02:32:36.062 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@7e42cefb 02:32:36.072 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - getServices: delegateClass=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate, serviceClasses=[house.intelli.core.rpc.echo.EchoRpcService] house.intelli.core.util.StringUtilTest > split0 STANDARD_OUT 02:32:36.112 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.jaxb.IntelliHouseJaxbContext - getJaxbContext: provider.class=house.intelli.core.jaxb.IntelliHouseJaxbContextProviderImpl, classesToBeBound=[class house.intelli.core.rpc.lightcontroller.LightControllerEventRequest, class house.intelli.core.rpc.pv.PvStatusEventRequest, class house.intelli.core.rpc.ErrorResponse, class house.intelli.core.rpc.DeferredResponseRequest, class house.intelli.core.rpc.dimmer.DimmerActorReadRequest, class house.intelli.core.rpc.NullResponse, class house.intelli.core.rpc.pv.PvStatusList, class house.intelli.core.rpc.PollInverseRequestsRequest, class house.intelli.core.rpc.echo.EchoResponse, class house.intelli.core.rpc.dimmer.DimmerActorWriteResponse, class house.intelli.core.rpc.lightcontroller.LightControllerFederationPropagationRequest, class house.intelli.core.rpc.echo.EchoRequest, class house.intelli.core.rpc.relay.RelayActorReadResponse, class house.intelli.core.rpc.relay.RelayActorReadRequest, class house.intelli.core.rpc.relay.RelayActorWriteRequest, class house.intelli.core.rpc.dimmer.DimmerActorReadResponse, class house.intelli.core.rpc.keybutton.KeyButtonSensorRemotePropagationRequest, class house.intelli.core.rpc.PollInverseRequestsResponse, class house.intelli.core.rpc.dimmer.DimmerActorWriteRequest, class house.intelli.core.rpc.dimmer.DimmerActorEventRequest, class house.intelli.core.rpc.keybutton.KeyButtonSensorEventRequest, class house.intelli.core.rpc.relay.RelayActorWriteResponse, class house.intelli.core.rpc.DeferringResponse, class house.intelli.core.rpc.relay.RelayActorEventRequest, class house.intelli.core.rpc.PutInverseResponseRequest] Gradle Test Executor 6 finished executing tests. house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:33:05.272 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server] 02:33:05.274 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:33:05 CET 2018, timeout=100273] 02:33:05.286 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=revcQdOgdZcw1b5AJP9J8Q, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, inverseRequests=[]] 02:33:05.289 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=jZLtiIqgsRg51IuSh1Lv5A, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:33:05 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:33:05.834 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=j7HRb-6K1FbCRO7ZfpLhxA, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:33:05.835 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=WuDZJvl3qX1PRDrpkuTKSw, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:33:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:33:35.276 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server] 02:33:35.278 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:33:35 CET 2018, timeout=70269] 02:33:35.291 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=jZLtiIqgsRg51IuSh1Lv5A, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, inverseRequests=[]] 02:33:35.292 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=7xKCCQDnvWDJe9hjArXCSw, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:33:35 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:33:35.838 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=WuDZJvl3qX1PRDrpkuTKSw, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:33:35.840 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=iT4Sv8dmpibsFuJNyj93JQ, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:33:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:34:05.280 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server] 02:34:05.281 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:34:05 CET 2018, timeout=40265] 02:34:05.295 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=7xKCCQDnvWDJe9hjArXCSw, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, inverseRequests=[]] 02:34:05.297 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=HoE9_Gkpm36Rgqqph2lFHA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:34:05 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:34:05.842 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=iT4Sv8dmpibsFuJNyj93JQ, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:34:05.844 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=3Ggo4_fH8_UCyQsWPHTPgg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:34:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:34:35.283 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server] 02:34:35.285 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:34:35 CET 2018, timeout=10261] 02:34:35.300 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=HoE9_Gkpm36Rgqqph2lFHA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, inverseRequests=[]] 02:34:35.302 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=-TwEzcqH28AOVvMf1MJW8A, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:34:35 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:34:35.847 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=3Ggo4_fH8_UCyQsWPHTPgg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:34:35.849 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=2Cj9Iv-6KvQ_pYXB_jpwbQ, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:34:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT 02:34:45.549 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server] 02:34:45.567 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: house.intelli.core.rpc.RpcTimeoutException: Request timed out: EchoRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=130467, payload=cuojFhKcwHOL4hCA7ozOcQ, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.RpcTimeoutException: Request timed out: EchoRequest[requestId=2WdlObowL-BldOTDWffbmA, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, created=Mon Dec 31 02:32:35 CET 2018, timeout=130467, payload=cuojFhKcwHOL4hCA7ozOcQ, throwExceptionClassName=null, sleep=300000] at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:111) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.NormalClientServerTest.clientInvokesLongRunningServiceOnServerAndEncountersTimeout(NormalClientServerTest.java:101) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:34:45.791 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) house.intelli.core.rpc.NormalClientServerTest STANDARD_OUT at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) house.intelli.core.rpc.NormalClientServerTest > clientInvokesNormalServiceOnServer STANDARD_OUT 02:34:45.798 [PollInverseRequestsThread-client-Ttz-f0DMHEISARGxClGm7g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=H6tcz7k5i3ZoubZkmk3hpQ, clientHostId=client-Ttz-f0DMHEISARGxClGm7g, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000] 02:34:45.798 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=gDzW1T31qcqCKjT-4m3Xbg, clientHostId=client-Ttz-f0DMHEISARGxClGm7g, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0] 02:34:45.805 [PollInverseRequestsThread-client-iDnawUz_d6TmxXFmEaJ1_g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=-TwEzcqH28AOVvMf1MJW8A, clientHostId=client-iDnawUz_d6TmxXFmEaJ1_g, serverHostId=server, inverseRequests=[]] 02:34:45.817 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=gDzW1T31qcqCKjT-4m3Xbg, clientHostId=client-Ttz-f0DMHEISARGxClGm7g, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0] 02:34:45.818 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=bla bla trallala] 02:34:45.821 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=gDzW1T31qcqCKjT-4m3Xbg, clientHostId=client-Ttz-f0DMHEISARGxClGm7g, serverHostId=server, payload=bla bla trallala] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:34:45.847 [PollInverseRequestsThread-client-Ttz-f0DMHEISARGxClGm7g] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:34:45.849 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=auCFhpot569dm9XMASNUxA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000] 02:34:45.849 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000, payload=jULGjVcRX2g4WRjsVcQDOw, throwExceptionClassName=null, sleep=300000] 02:34:45.851 [PollInverseRequestsThread-client-Ttz-f0DMHEISARGxClGm7g] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=H6tcz7k5i3ZoubZkmk3hpQ, clientHostId=client-Ttz-f0DMHEISARGxClGm7g, serverHostId=server, inverseRequests=[]] 02:34:45.858 [pool-6-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:34:45 CET 2018, timeout=600000, payload=jULGjVcRX2g4WRjsVcQDOw, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:35:05.852 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=2Cj9Iv-6KvQ_pYXB_jpwbQ, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:35:05.854 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=kRvACnl0Mn_-EKjDeAgb7w, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:35:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:35:15.859 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:35:15.860 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:35:15 CET 2018, timeout=569989] 02:35:15.864 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=auCFhpot569dm9XMASNUxA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:35:15.866 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Jqa3gKbcf_JARuUcL2ZimA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:35:15 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:35:35.861 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=kRvACnl0Mn_-EKjDeAgb7w, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:35:35.863 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=0-E71mA8Vlaufv8u8752fg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:35:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:35:45.862 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:35:45.863 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:35:45 CET 2018, timeout=539986] 02:35:45.869 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Jqa3gKbcf_JARuUcL2ZimA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:35:45.870 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ziJHjJTt_pM7n5lAwXFXCQ, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:35:45 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:36:05.868 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=0-E71mA8Vlaufv8u8752fg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:36:05.871 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=kKF4V4fjMxe7TuXwT8vYHg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:36:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:36:15.865 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:36:15.866 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:36:15 CET 2018, timeout=509983] 02:36:15.872 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ziJHjJTt_pM7n5lAwXFXCQ, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:36:15.873 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=rLv39N5_KXayCinF4AK7Bw, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:36:15 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:36:35.876 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=kKF4V4fjMxe7TuXwT8vYHg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:36:35.879 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=eLSaJAFatrAIueQKPP4OGg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:36:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:36:45.868 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:36:45.869 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:36:45 CET 2018, timeout=479980] 02:36:45.874 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=rLv39N5_KXayCinF4AK7Bw, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:36:45.876 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=fOu69VlsRdpm4GuZhdikXg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:36:45 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:37:05.884 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=eLSaJAFatrAIueQKPP4OGg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:37:05.885 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ZBqzjGX2zNyXbmvLHmPKCg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:37:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:37:15.873 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:37:15.875 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:37:15 CET 2018, timeout=449974] 02:37:15.879 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=fOu69VlsRdpm4GuZhdikXg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:37:15.881 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ZlzZDFCU4KwrnL2mdPuTDg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:37:15 CET 2018, timeout=600000] 02:37:35.453 [pool-2-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=cuojFhKcwHOL4hCA7ozOcQ] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT 02:37:35.845 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=8n8y8b3XPCYoftNfFag01g] 02:37:35.846 [pool-4-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=DA_c9qj0xPTldma8N98Vzw, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, created=Mon Dec 31 02:37:35 CET 2018, timeout=600000] 02:37:35.847 [pool-4-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=DA_c9qj0xPTldma8N98Vzw, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server] 02:37:35.850 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=3NzPETMrk9Kdh7p2ENAbXA, clientHostId=server-2B_A0kuG5b99C_eNw8X2tw, serverHostId=client-vLHUWByX3tUQYz7-Md7-XA, payload=8n8y8b3XPCYoftNfFag01g] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:37:35.859 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:37:35.861 [PollInverseRequestsThread-client-vLHUWByX3tUQYz7-Md7-XA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ZBqzjGX2zNyXbmvLHmPKCg, clientHostId=client-vLHUWByX3tUQYz7-Md7-XA, serverHostId=server, inverseRequests=[]] 02:37:35.870 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=kXTURh5q2h_9cqpuFqTcFQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:37:35 CET 2018, timeout=600000] 02:37:35.870 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=2Y0k6Hgkq0Qf7qCfpRT17w, clientHostId=server-sxV6ifqzwYEensAshVrdJA, serverHostId=client-x2DlYRIVhPGlwhAyhE5kDw, created=Mon Dec 31 02:37:35 CET 2018, timeout=158475, payload=ZyCmkCnD1pI5cZzFHRU5UA, throwExceptionClassName=null, sleep=300000] 02:37:35.882 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=kXTURh5q2h_9cqpuFqTcFQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[EchoRequest[requestId=2Y0k6Hgkq0Qf7qCfpRT17w, clientHostId=server-sxV6ifqzwYEensAshVrdJA, serverHostId=client-x2DlYRIVhPGlwhAyhE5kDw, created=Mon Dec 31 02:37:35 CET 2018, timeout=158475, payload=ZyCmkCnD1pI5cZzFHRU5UA, throwExceptionClassName=null, sleep=300000]]] 02:37:35.896 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=VxMxxXIvi7Ykq4tYwZyoyQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:37:35 CET 2018, timeout=600000] 02:37:35.898 [pool-7-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=2Y0k6Hgkq0Qf7qCfpRT17w, clientHostId=server-sxV6ifqzwYEensAshVrdJA, serverHostId=client-x2DlYRIVhPGlwhAyhE5kDw, created=Mon Dec 31 02:37:35 CET 2018, timeout=158475, payload=ZyCmkCnD1pI5cZzFHRU5UA, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:37:45.880 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:37:45.882 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:37:45 CET 2018, timeout=419967] 02:37:45.883 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ZlzZDFCU4KwrnL2mdPuTDg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:37:45.885 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=-OrTQId7-0Hq67YNDXwCfA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:37:45 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:38:05.898 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=VxMxxXIvi7Ykq4tYwZyoyQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:38:05.899 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=-jH79eiYXEETpXuWBdOwbw, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:38:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:38:15.884 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:38:15.885 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:38:15 CET 2018, timeout=389964] 02:38:15.887 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=-OrTQId7-0Hq67YNDXwCfA, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:38:15.889 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=416z7nSw11lZpFp4zvlE_w, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:38:15 CET 2018, timeout=600000] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:38:35.902 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=-jH79eiYXEETpXuWBdOwbw, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:38:35.903 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=fEYq5yOU5guOaUObOBlOTQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:38:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:38:45.892 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=416z7nSw11lZpFp4zvlE_w, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:38:45.893 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:38:45.894 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=kuum2-It6E4YhoCHgoKUCQ, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:38:45 CET 2018, timeout=600000] 02:38:45.895 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:38:45 CET 2018, timeout=359954] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:39:05.907 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=fEYq5yOU5guOaUObOBlOTQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:39:05.909 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=89uq1hibyKhnB17vFUz6Tg, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:39:05 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:39:15.899 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=kuum2-It6E4YhoCHgoKUCQ, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:39:15.899 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server] 02:39:15.900 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=vephVghlqQcaC1eHurV5Fw, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:39:15 CET 2018, timeout=600000] 02:39:15.901 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, created=Mon Dec 31 02:39:15 CET 2018, timeout=329948] house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:39:35.912 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=89uq1hibyKhnB17vFUz6Tg, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:39:35.913 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=-rwvO3RkWZ5vNY-aaobORQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:39:35 CET 2018, timeout=600000] house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT 02:39:45.860 [pool-6-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=jULGjVcRX2g4WRjsVcQDOw] 02:39:45.862 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=XvXj04fUchyyEEWAt5uAAg, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, payload=jULGjVcRX2g4WRjsVcQDOw] house.intelli.core.rpc.NormalClientServerTest > clientInvokesServiceOnServerAndExpectsRemoteException STANDARD_OUT 02:39:45.865 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:39:45.871 [PollInverseRequestsThread-client-s6jRG1wiDtrdcZDbcQGwbA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=vephVghlqQcaC1eHurV5Fw, clientHostId=client-s6jRG1wiDtrdcZDbcQGwbA, serverHostId=server, inverseRequests=[]] 02:39:45.871 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:45.872 [PollInverseRequestsThread-client-Rk2ETz3UcQhaAq4pGj5Nhw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=PP-2INxaNomRm1n_mUfg_Q, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000] 02:39:45.878 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:45.881 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:39:45.882 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:39:45.891 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server] 02:39:45.894 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.NormalClientServerTest.clientInvokesServiceOnServerAndExpectsRemoteException(NormalClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:39:45.903 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=1 02:39:46.908 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:46.910 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:46.911 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:39:46.912 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:39:46.915 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server] 02:39:46.918 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.NormalClientServerTest.clientInvokesServiceOnServerAndExpectsRemoteException(NormalClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:39:46.938 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=2 02:39:47.941 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:47.943 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:47.945 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:39:47.946 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:39:47.949 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server] 02:39:47.951 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.NormalClientServerTest.clientInvokesServiceOnServerAndExpectsRemoteException(NormalClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:39:47.959 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=3 02:39:48.960 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:48.963 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, created=Mon Dec 31 02:39:45 CET 2018, timeout=600000, payload=vZW10l_le0HXWtq2A1Gxkw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:39:48.965 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:39:48.966 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:39:48.969 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=edbkwbZHFANfwFi3i6D1DQ, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server] 02:39:48.975 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw java.lang.NumberFormatException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.NormalClientServerTest.clientInvokesServiceOnServerAndExpectsRemoteException(NormalClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: vZW10l_le0HXWtq2A1Gxkw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.RpcServiceExecutor$2.run(RpcServiceExecutor.java:94) Gradle Test Executor 2 finished executing tests. at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 02:39:48.985 [PollInverseRequestsThread-client-Rk2ETz3UcQhaAq4pGj5Nhw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=PP-2INxaNomRm1n_mUfg_Q, clientHostId=client-Rk2ETz3UcQhaAq4pGj5Nhw, serverHostId=server, inverseRequests=[]] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted Gradle Test Executor 2 STANDARD_OUT 02:39:48.984 [PollInverseRequestsThread-client-Rk2ETz3UcQhaAq4pGj5Nhw] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT 02:40:05.916 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=-rwvO3RkWZ5vNY-aaobORQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:40:05.918 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=WaulZJ1WFLaf1OF2PzCqAQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, created=Mon Dec 31 02:40:05 CET 2018, timeout=600000] 02:40:14.359 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: house.intelli.core.rpc.RpcTimeoutException: Inverse request timed out: EchoRequest[requestId=2Y0k6Hgkq0Qf7qCfpRT17w, clientHostId=server-sxV6ifqzwYEensAshVrdJA, serverHostId=client-x2DlYRIVhPGlwhAyhE5kDw, created=Mon Dec 31 02:37:35 CET 2018, timeout=158475, payload=ZyCmkCnD1pI5cZzFHRU5UA, throwExceptionClassName=null, sleep=300000] house.intelli.core.rpc.RpcTimeoutException: Inverse request timed out: EchoRequest[requestId=2Y0k6Hgkq0Qf7qCfpRT17w, clientHostId=server-sxV6ifqzwYEensAshVrdJA, serverHostId=client-x2DlYRIVhPGlwhAyhE5kDw, created=Mon Dec 31 02:37:35 CET 2018, timeout=158475, payload=ZyCmkCnD1pI5cZzFHRU5UA, throwExceptionClassName=null, sleep=300000] at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:104) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.InverseClientServerTest.serverInvokesLongRunningServiceOnClientAndEncountersTimeout(InverseClientServerTest.java:101) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) house.intelli.core.rpc.InverseClientServerTest > serverInvokesServiceOnClientAndExpectsRemoteException STANDARD_OUT 02:40:14.374 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:40:14.377 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=YzU2A1t6k4gd_h4l529Rqw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000] 02:40:14.377 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:14.377 [PollInverseRequestsThread-client-x2DlYRIVhPGlwhAyhE5kDw] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=WaulZJ1WFLaf1OF2PzCqAQ, clientHostId=client-x2DlYRIVhPGlwhAyhE5kDw, serverHostId=server, inverseRequests=[]] 02:40:14.384 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=YzU2A1t6k4gd_h4l529Rqw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, inverseRequests=[EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]] 02:40:14.385 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=OFpLW1xBUTZWNtjH7Zk7CQ, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000] 02:40:14.386 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:14.388 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:40:14.389 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:40:14.399 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=H-HbWCWnv-qO9PQRkCDu_g, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000] 02:40:14.400 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA] 02:40:14.402 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.InverseClientServerTest.serverInvokesServiceOnClientAndExpectsRemoteException(InverseClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:40:14.403 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=H-HbWCWnv-qO9PQRkCDu_g, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server] 02:40:14.408 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=1 02:40:15.417 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:15.418 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=OFpLW1xBUTZWNtjH7Zk7CQ, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, inverseRequests=[EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]] 02:40:15.420 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:15.420 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=5z0OcnaNIN7cQ6NF1nI4pw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:15 CET 2018, timeout=600000] 02:40:15.421 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:40:15.424 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:40:15.427 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=ZSYYHPJGcxr41kUDiAb6Fg, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:15 CET 2018, timeout=600000] 02:40:15.429 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=ZSYYHPJGcxr41kUDiAb6Fg, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server] 02:40:15.429 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA] 02:40:15.431 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.InverseClientServerTest.serverInvokesServiceOnClientAndExpectsRemoteException(InverseClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:40:15.437 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=2 02:40:16.438 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:16.440 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=5z0OcnaNIN7cQ6NF1nI4pw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, inverseRequests=[EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]] 02:40:16.443 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:16.443 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=0rgMEExHJR6n-_mudurt8A, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:16 CET 2018, timeout=600000] 02:40:16.445 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:40:16.448 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:40:16.450 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=b3dKB3pxA73siD8Mquijxw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:16 CET 2018, timeout=600000] 02:40:16.451 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA] 02:40:16.452 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.InverseClientServerTest.serverInvokesServiceOnClientAndExpectsRemoteException(InverseClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted 02:40:16.453 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=b3dKB3pxA73siD8Mquijxw, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server] 02:40:16.475 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=3 02:40:17.478 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:17.480 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=0rgMEExHJR6n-_mudurt8A, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, inverseRequests=[EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]] 02:40:17.482 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA, created=Mon Dec 31 02:40:14 CET 2018, timeout=600000, payload=B8RcHSAT1xVIxiAkvR3gXw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0] 02:40:17.482 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=i2yZOR3_i43Rw8m0Ud_9lQ, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:17 CET 2018, timeout=600000] 02:40:17.483 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException 02:40:17.485 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 02:40:17.489 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=awQeizn0OvqYlrPcleKSnA, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, created=Mon Dec 31 02:40:17 CET 2018, timeout=600000] 02:40:17.489 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=awQeizn0OvqYlrPcleKSnA, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server] 02:40:17.490 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=BAz-POEZlVWr8_yVZfMVUA, clientHostId=server-3cw3XIeaBw7anJExyx6Faw, serverHostId=client-U__gdzf9EbVD7eX7mzMOFA] 02:40:17.494 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw java.lang.NumberFormatException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.rpc.RemoteExceptionUtil.getObjectOrNull(RemoteExceptionUtil.java:109) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:53) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:123) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.InverseClientServerTest.serverInvokesServiceOnClientAndExpectsRemoteException(InverseClientServerTest.java:122) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57) at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66) at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93) at com.sun.proxy.$Proxy2.processTestClass(Unknown Source) at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:109) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) at org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:377) at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: house.intelli.core.rpc.RemoteException: B8RcHSAT1xVIxiAkvR3gXw at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at house.intelli.core.util.ReflectionUtil.invoke(ReflectionUtil.java:137) at house.intelli.core.util.ReflectionUtil.invokeConstructor(ReflectionUtil.java:58) Gradle Test Executor 5 finished executing tests. at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:34) at house.intelli.core.rpc.echo.EchoRpcService.process(EchoRpcService.java:12) at house.intelli.core.rpc.RpcServiceExecutor.processLocally(RpcServiceExecutor.java:151) at house.intelli.core.rpc.PollInverseRequestsThread.processLocally(PollInverseRequestsThread.java:101) at house.intelli.core.rpc.PollInverseRequestsThread$1.run(PollInverseRequestsThread.java:84) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at house.intelli.core.rpc.RemoteExceptionUtil.throwOriginalExceptionIfPossible(RemoteExceptionUtil.java:43) ... 52 common frames omitted Gradle Test Executor 5 STANDARD_OUT 02:40:17.506 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException java.lang.InterruptedException: null at java.lang.Object.wait(Native Method) at house.intelli.core.rpc.InverseRequestRegistry.pollRequests(InverseRequestRegistry.java:115) at house.intelli.core.rpc.RpcServer.process(RpcServer.java:73) at house.intelli.core.rpc.RpcServer.receiveAndProcessRequest(RpcServer.java:41) at house.intelli.core.rpc.mocktransport.MockRpcServerTransport.putRequest(MockRpcServerTransport.java:20) at house.intelli.core.rpc.mocktransport.MockRpcClientTransport.sendRequest(MockRpcClientTransport.java:20) at house.intelli.core.rpc.RpcClient._invoke(RpcClient.java:96) at house.intelli.core.rpc.RpcClient.invoke(RpcClient.java:43) at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56) 02:40:17.506 [PollInverseRequestsThread-client-U__gdzf9EbVD7eX7mzMOFA] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=i2yZOR3_i43Rw8m0Ud_9lQ, clientHostId=client-U__gdzf9EbVD7eX7mzMOFA, serverHostId=server, inverseRequests=[]] Finished generating test XML results (0.128 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/test-results/test Generating HTML test report... Finished generating test html results (0.1 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/reports/tests/test :house.intelli.core:test (Thread[Daemon worker,5,main]) completed. Took 7 mins 55.781 secs. :house.intelli.core:check (Thread[Daemon worker,5,main]) started. :house.intelli.core:check Skipping task ':house.intelli.core:check' as it has no actions. :house.intelli.core:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.core:build (Thread[Daemon worker,5,main]) started. :house.intelli.core:build Skipping task ':house.intelli.core:build' as it has no actions. :house.intelli.core:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:compileJava Executing task ':house.intelli.desktop:compileJava' (up-to-date check took 0.018 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.desktop:compileJava'. Compiling with JDK Java compiler API. :house.intelli.desktop:compileJava (Thread[Daemon worker,5,main]) completed. Took 0.073 secs. :house.intelli.desktop:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:processResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/main/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/main/resources', not found Skipping task ':house.intelli.desktop:processResources' as it has no source files. :house.intelli.desktop:processResources UP-TO-DATE :house.intelli.desktop:processResources (Thread[Daemon worker,5,main]) completed. Took 0.003 secs. :house.intelli.desktop:classes (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:classes Skipping task ':house.intelli.desktop:classes' as it has no actions. :house.intelli.desktop:classes (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:jar (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:jar Executing task ':house.intelli.desktop:jar' (up-to-date check took 0.032 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/libs/house.intelli.desktop-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/libs/house.intelli.desktop-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.desktop:jar (Thread[Daemon worker,5,main]) completed. Took 0.259 secs. :house.intelli.desktop:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:assemble Skipping task ':house.intelli.desktop:assemble' as it has no actions. :house.intelli.desktop:assemble (Thread[Daemon worker,5,main]) completed. Took 0.003 secs. :house.intelli.desktop:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:compileTestJava file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/test/java', not found Skipping task ':house.intelli.desktop:compileTestJava' as it has no source files. :house.intelli.desktop:compileTestJava UP-TO-DATE :house.intelli.desktop:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/test/java', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/src/test/resources', not found Skipping task ':house.intelli.desktop:processTestResources' as it has no source files. :house.intelli.desktop:processTestResources UP-TO-DATE :house.intelli.desktop:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.desktop:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:testClasses Skipping task ':house.intelli.desktop:testClasses' as it has no actions. :house.intelli.desktop:testClasses UP-TO-DATE :house.intelli.desktop:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:test (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:test file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.desktop/build/classes/test', not found Skipping task ':house.intelli.desktop:test' as it has no source files. :house.intelli.desktop:test UP-TO-DATE :house.intelli.desktop:test (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:check (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:check Skipping task ':house.intelli.desktop:check' as it has no actions. :house.intelli.desktop:check UP-TO-DATE :house.intelli.desktop:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.desktop:build (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:build Skipping task ':house.intelli.desktop:build' as it has no actions. :house.intelli.desktop:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.jdo:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:compileJava Download https://jcenter.bintray.com/org/datanucleus/javax.jdo/3.2.0-m10/javax.jdo-3.2.0-m10.pom Download https://jcenter.bintray.com/org/datanucleus/datanucleus-maven-parent/5.0.0/datanucleus-maven-parent-5.0.0.pom Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/sonatype/oss/oss-parent/7/oss-parent-7.pom, /home/tomcat/.m2/repository/org/sonatype/oss/oss-parent/7/oss-parent-7.pom] Download https://jcenter.bintray.com/org/datanucleus/datanucleus-core/5.2.0-m2/datanucleus-core-5.2.0-m2.pom Download https://jcenter.bintray.com/org/datanucleus/datanucleus-api-jdo/5.2.0-m2/datanucleus-api-jdo-5.2.0-m2.pom Download https://jcenter.bintray.com/org/datanucleus/datanucleus-rdbms/5.2.0-m2/datanucleus-rdbms-5.2.0-m2.pom Download https://jcenter.bintray.com/javax/transaction/transaction-api/1.1/transaction-api-1.1.pom Download https://jcenter.bintray.com/org/datanucleus/javax.jdo/3.2.0-m10/javax.jdo-3.2.0-m10.jar Download https://jcenter.bintray.com/org/datanucleus/datanucleus-core/5.2.0-m2/datanucleus-core-5.2.0-m2.jar Download https://jcenter.bintray.com/org/datanucleus/datanucleus-api-jdo/5.2.0-m2/datanucleus-api-jdo-5.2.0-m2.jar Download https://jcenter.bintray.com/org/datanucleus/datanucleus-rdbms/5.2.0-m2/datanucleus-rdbms-5.2.0-m2.jar Download https://jcenter.bintray.com/javax/transaction/transaction-api/1.1/transaction-api-1.1.jar Executing task ':house.intelli.jdo:compileJava' (up-to-date check took 2.214 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.jdo:compileJava'. Compiling with JDK Java compiler API. [ant:echo] *********************************************** [ant:echo] ******************* ENHANCE ******************* [ant:echo] *********************************************** [ant:echo] Note: You must run gradle with the '-i' option to see output from the enhancer! [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.CommandLineHelper logEnhancerVersionDataNucleus Enhancer (version 5.2.0.m2) for API "JDO" [ant:datanucleusenhancer] DataNucleus Enhancer : Classpath [ant:datanucleusenhancer] >> /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main [ant:datanucleusenhancer] [ant:datanucleusenhancer] INFO: DataNucleus Enhancer (version 5.2.0.m2) for API "JDO">> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.slf4j/slf4j-api/1.7.21/139535a69a4239db087de9bab0bee568bf8e0b70/slf4j-api-1.7.21.jar [ant:datanucleusenhancer] [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.apache.commons/commons-collections4/4.0/da217367fd25e88df52ba79e47658d4cf928b0d1/commons-collections4-4.0.jar [ant:datanucleusenhancer] >> /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build/libs/house.intelli.core-0.9.1-SNAPSHOT.jar [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.datanucleus/javax.jdo/3.2.0-m10/196f521d4c3113d64ddbad4254c9fea8f5651a56/javax.jdo-3.2.0-m10.jar [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.datanucleus/datanucleus-core/5.2.0-m2/ddfd0e9a113e572d25f962f6581659348f5a8cd6/datanucleus-core-5.2.0-m2.jar [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.datanucleus/datanucleus-api-jdo/5.2.0-m2/7d070fef5b21caa001061839eb03b843405a7768/datanucleus-api-jdo-5.2.0-m2.jar [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/org.datanucleus/datanucleus-rdbms/5.2.0-m2/ebcb21c4865e9866e3e15c0e39c15bdd19d3be5e/datanucleus-rdbms-5.2.0-m2.jar [ant:datanucleusenhancer] >> /home/tomcat/.gradle/caches/modules-2/files-2.1/javax.transaction/transaction-api/1.1/2ca09f0b36ca7d71b762e14ea2ff09d5eac57558/transaction-api-1.1.jar [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.ClassEnhancerImpl save [ant:datanucleusenhancer] INFO: Writing class file "/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main/house/intelli/jdo/Entity.class" with enhanced definition [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.DataNucleusEnhancer addMessage [ant:datanucleusenhancer] INFO: ENHANCED (Persistable) : house.intelli.jdo.Entity [ant:datanucleusenhancer] ENHANCED (Persistable) : house.intelli.jdo.Entity [ant:datanucleusenhancer] ENHANCED (Persistable) : house.intelli.jdo.model.PvStatusEntity [ant:datanucleusenhancer] DataNucleus Enhancer completed with success for 2 classes. Timings : input=282 ms, enhance=146 ms, total=428 ms. Consult the log for full details [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.ClassEnhancerImpl save [ant:datanucleusenhancer] INFO: Writing class file "/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main/house/intelli/jdo/model/PvStatusEntity.class" with enhanced definition [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.DataNucleusEnhancer addMessage [ant:datanucleusenhancer] INFO: ENHANCED (Persistable) : house.intelli.jdo.model.PvStatusEntity [ant:datanucleusenhancer] Dec 31, 2018 2:40:22 AM org.datanucleus.enhancer.DataNucleusEnhancer addMessage [ant:datanucleusenhancer] INFO: DataNucleus Enhancer completed with success for 2 classes. Timings : input=282 ms, enhance=146 ms, total=428 ms. Consult the log for full details [ant:echo] *********************************************** [ant:echo] *********************************************** [ant:echo] *********************************************** :house.intelli.jdo:compileJava (Thread[Daemon worker,5,main]) completed. Took 4.687 secs. :house.intelli.jdo:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:processResources Executing task ':house.intelli.jdo:processResources' (up-to-date check took 0.014 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/main/META-INF has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/main/META-INF/services has been removed. :house.intelli.jdo:processResources (Thread[Daemon worker,5,main]) completed. Took 0.07 secs. :house.intelli.jdo:classes (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:classes Skipping task ':house.intelli.jdo:classes' as it has no actions. :house.intelli.jdo:classes (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.jdo:jar (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:jar Executing task ':house.intelli.jdo:jar' (up-to-date check took 0.13 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/libs/house.intelli.jdo-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/libs/house.intelli.jdo-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.jdo:jar (Thread[Daemon worker,5,main]) completed. Took 0.42 secs. :house.intelli.jdo:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:assemble Skipping task ':house.intelli.jdo:assemble' as it has no actions. :house.intelli.jdo:assemble (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.jdo:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:compileTestJava Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/postgresql/postgresql/42.2.5.jre7/postgresql-42.2.5.jre7.pom, /home/tomcat/.m2/repository/org/postgresql/postgresql/42.2.5.jre7/postgresql-42.2.5.jre7.pom] Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/postgresql/pgjdbc-core-prevjre/1.1.5/pgjdbc-core-prevjre-1.1.5.pom, /home/tomcat/.m2/repository/org/postgresql/pgjdbc-core-prevjre/1.1.5/pgjdbc-core-prevjre-1.1.5.pom] Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/postgresql/pgjdbc-core-parent/1.1.5/pgjdbc-core-parent-1.1.5.pom, /home/tomcat/.m2/repository/org/postgresql/pgjdbc-core-parent/1.1.5/pgjdbc-core-parent-1.1.5.pom] Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/postgresql/pgjdbc-versions/1.1.5/pgjdbc-versions-1.1.5.pom, /home/tomcat/.m2/repository/org/postgresql/pgjdbc-versions/1.1.5/pgjdbc-versions-1.1.5.pom] Found locally available resource with matching checksum: [https://jcenter.bintray.com/org/postgresql/postgresql/42.2.5.jre7/postgresql-42.2.5.jre7.jar, /home/tomcat/.m2/repository/org/postgresql/postgresql/42.2.5.jre7/postgresql-42.2.5.jre7.jar] Executing task ':house.intelli.jdo:compileTestJava' (up-to-date check took 0.647 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/test has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/test/house has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/test/house/intelli has been removed. All input files are considered out-of-date for incremental task ':house.intelli.jdo:compileTestJava'. Compiling with JDK Java compiler API. :house.intelli.jdo:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.78 secs. :house.intelli.jdo:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:processTestResources Executing task ':house.intelli.jdo:processTestResources' (up-to-date check took 0.028 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/test has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/test/house has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/resources/test/house/intelli has been removed. :house.intelli.jdo:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.048 secs. :house.intelli.jdo:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:testClasses Skipping task ':house.intelli.jdo:testClasses' as it has no actions. :house.intelli.jdo:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.0 secs. :house.intelli.jdo:test (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:test Executing task ':house.intelli.jdo:test' (up-to-date check took 0.025 secs) due to: Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/test-results/test/binary has changed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/test-results/test/binary/output.bin has been removed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/test-results/test/binary/output.bin.idx has been removed. Starting process 'Gradle Test Executor 7'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 7' Successfully started process 'Gradle Test Executor 7' OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 7 started executing tests. Gradle Test Executor 7 finished executing tests. house.intelli.jdo.test.ImportPvStatusTest > importPvStatusFiles SKIPPED Finished generating test XML results (0.005 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/test-results/test Generating HTML test report... Finished generating test html results (0.01 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/reports/tests/test :house.intelli.jdo:test (Thread[Daemon worker,5,main]) completed. Took 3.338 secs. :house.intelli.jdo:check (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:check Skipping task ':house.intelli.jdo:check' as it has no actions. :house.intelli.jdo:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.jdo:build (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:build Skipping task ':house.intelli.jdo:build' as it has no actions. :house.intelli.jdo:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.pgp:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:compileJava Resource missing. [HTTP GET: https://jcenter.bintray.com/org/bouncycastle/org.bouncycastle.openpgp.wot/1.60.0/org.bouncycastle.openpgp.wot-1.60.0.pom] Resource missing. [HTTP HEAD: https://jcenter.bintray.com/org/bouncycastle/org.bouncycastle.openpgp.wot/1.60.0/org.bouncycastle.openpgp.wot-1.60.0.jar] Download https://codewizards.co/maven/release/org/bouncycastle/org.bouncycastle.openpgp.wot/1.60.0/org.bouncycastle.openpgp.wot-1.60.0.pom Download https://jcenter.bintray.com/org/bouncycastle/bcpg-jdk15on/1.60/bcpg-jdk15on-1.60.pom Download https://jcenter.bintray.com/org/bouncycastle/bcprov-jdk15on/1.60/bcprov-jdk15on-1.60.pom Download https://codewizards.co/maven/release/org/bouncycastle/org.bouncycastle.openpgp.wot/1.60.0/org.bouncycastle.openpgp.wot-1.60.0.jar Download https://jcenter.bintray.com/org/bouncycastle/bcpg-jdk15on/1.60/bcpg-jdk15on-1.60.jar Download https://jcenter.bintray.com/org/bouncycastle/bcprov-jdk15on/1.60/bcprov-jdk15on-1.60.jar Executing task ':house.intelli.pgp:compileJava' (up-to-date check took 2.553 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.pgp:compileJava'. Compiling with JDK Java compiler API. Note: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/src/main/java/house/intelli/pgp/gnupg/BcPgpKey.java uses or overrides a deprecated API. Note: Recompile with -Xlint:deprecation for details. :house.intelli.pgp:compileJava (Thread[Daemon worker,5,main]) completed. Took 4.623 secs. :house.intelli.pgp:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:processResources Executing task ':house.intelli.pgp:processResources' (up-to-date check took 0.021 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/resources/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/resources/main/META-INF has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/resources/main/META-INF/services has been removed. :house.intelli.pgp:processResources (Thread[Daemon worker,5,main]) completed. Took 0.148 secs. :house.intelli.pgp:classes (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:classes Skipping task ':house.intelli.pgp:classes' as it has no actions. :house.intelli.pgp:classes (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.pgp:jar (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:jar Executing task ':house.intelli.pgp:jar' (up-to-date check took 0.291 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/libs/house.intelli.pgp-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/libs/house.intelli.pgp-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.pgp:jar (Thread[Daemon worker,5,main]) completed. Took 0.934 secs. :house.intelli.pgp:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:assemble Skipping task ':house.intelli.pgp:assemble' as it has no actions. :house.intelli.pgp:assemble (Thread[Daemon worker,5,main]) completed. Took 0.002 secs. :house.intelli.pgp:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:compileTestJava Executing task ':house.intelli.pgp:compileTestJava' (up-to-date check took 0.026 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/classes/test has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/classes/test/house has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/classes/test/house/intelli has been removed. All input files are considered out-of-date for incremental task ':house.intelli.pgp:compileTestJava'. Compiling with JDK Java compiler API. :house.intelli.pgp:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.387 secs. :house.intelli.pgp:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/src/test/resources', not found Skipping task ':house.intelli.pgp:processTestResources' as it has no source files. :house.intelli.pgp:processTestResources UP-TO-DATE :house.intelli.pgp:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.004 secs. :house.intelli.pgp:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:testClasses Skipping task ':house.intelli.pgp:testClasses' as it has no actions. :house.intelli.pgp:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.0 secs. :house.intelli.pgp:test (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:test Executing task ':house.intelli.pgp:test' (up-to-date check took 0.022 secs) due to: Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/test-results/test/binary has changed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/test-results/test/binary/output.bin has been removed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/test-results/test/binary/output.bin.idx has been removed. Starting process 'Gradle Test Executor 8'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 8' Successfully started process 'Gradle Test Executor 8' OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 8 started executing tests. house.intelli.pgp.rpc.PgpTransportSupportTest > hashTest STANDARD_OUT 02:40:38.060 [Test worker] INFO house.intelli.pgp.rpc.PgpTransportSupportTest - Data corruption was properly detected: java.io.IOException: Data corruption: Declared hash does not match found hash!!! Gradle Test Executor 8 finished executing tests. Finished generating test XML results (0.003 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/test-results/test Generating HTML test report... Finished generating test html results (0.008 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.pgp/build/reports/tests/test :house.intelli.pgp:test (Thread[Daemon worker,5,main]) completed. Took 4.494 secs. :house.intelli.pgp:check (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:check Skipping task ':house.intelli.pgp:check' as it has no actions. :house.intelli.pgp:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.pgp:build (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:build Skipping task ':house.intelli.pgp:build' as it has no actions. :house.intelli.pgp:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.raspi:compileJava (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:compileJava Resource missing. [HTTP GET: https://jcenter.bintray.com/com/pi4j/pi4j-core/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://jcenter.bintray.com/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://jcenter.bintray.com/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.jar] Resource missing. [HTTP GET: https://codewizards.co/maven/release/com/pi4j/pi4j-core/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://codewizards.co/maven/release/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://codewizards.co/maven/release/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.jar] Resource missing. [HTTP GET: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-core/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-SNAPSHOT.jar] Download https://oss.sonatype.org/content/groups/public/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-20180423.162750-37.pom Resource missing. [HTTP GET: https://jcenter.bintray.com/com/pi4j/pi4j-parent/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://jcenter.bintray.com/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://jcenter.bintray.com/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.jar] Resource missing. [HTTP GET: https://codewizards.co/maven/release/com/pi4j/pi4j-parent/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://codewizards.co/maven/release/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://codewizards.co/maven/release/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.jar] Resource missing. [HTTP GET: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-parent/1.2-SNAPSHOT/maven-metadata.xml] Resource missing. [HTTP GET: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.pom] Resource missing. [HTTP HEAD: https://codewizards.co/maven/snapshot/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-SNAPSHOT.jar] Download https://oss.sonatype.org/content/groups/public/com/pi4j/pi4j-parent/1.2-SNAPSHOT/pi4j-parent-1.2-20180423.162238-49.pom Download https://jcenter.bintray.com/org/springframework/spring-context/4.3.5.RELEASE/spring-context-4.3.5.RELEASE.pom Download https://jcenter.bintray.com/org/rxtx/rxtx/2.1.7/rxtx-2.1.7.pom Download https://jcenter.bintray.com/org/springframework/spring-aop/4.3.5.RELEASE/spring-aop-4.3.5.RELEASE.pom Download https://jcenter.bintray.com/org/springframework/spring-beans/4.3.5.RELEASE/spring-beans-4.3.5.RELEASE.pom Download https://jcenter.bintray.com/org/springframework/spring-core/4.3.5.RELEASE/spring-core-4.3.5.RELEASE.pom Download https://jcenter.bintray.com/org/springframework/spring-expression/4.3.5.RELEASE/spring-expression-4.3.5.RELEASE.pom Download https://jcenter.bintray.com/commons-logging/commons-logging/1.2/commons-logging-1.2.pom Download https://jcenter.bintray.com/org/apache/commons/commons-parent/34/commons-parent-34.pom Download https://oss.sonatype.org/content/groups/public/com/pi4j/pi4j-core/1.2-SNAPSHOT/pi4j-core-1.2-20180423.162750-37.jar Download https://jcenter.bintray.com/org/springframework/spring-context/4.3.5.RELEASE/spring-context-4.3.5.RELEASE.jar Download https://jcenter.bintray.com/org/rxtx/rxtx/2.1.7/rxtx-2.1.7.jar Download https://jcenter.bintray.com/org/springframework/spring-aop/4.3.5.RELEASE/spring-aop-4.3.5.RELEASE.jar Download https://jcenter.bintray.com/org/springframework/spring-beans/4.3.5.RELEASE/spring-beans-4.3.5.RELEASE.jar Download https://jcenter.bintray.com/org/springframework/spring-core/4.3.5.RELEASE/spring-core-4.3.5.RELEASE.jar Download https://jcenter.bintray.com/org/springframework/spring-expression/4.3.5.RELEASE/spring-expression-4.3.5.RELEASE.jar Download https://jcenter.bintray.com/commons-logging/commons-logging/1.2/commons-logging-1.2.jar Executing task ':house.intelli.raspi:compileJava' (up-to-date check took 11.379 secs) due to: Output property 'dependencyCacheDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/dependency-cache has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/classes/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/classes/main/house has been removed. All input files are considered out-of-date for incremental task ':house.intelli.raspi:compileJava'. Compiling with JDK Java compiler API. :house.intelli.raspi:compileJava (Thread[Daemon worker,5,main]) completed. Took 12.899 secs. :house.intelli.raspi:processResources (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:processResources Executing task ':house.intelli.raspi:processResources' (up-to-date check took 0.02 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/resources/main has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/resources/main/META-INF has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/resources/main/META-INF/spring has been removed. :house.intelli.raspi:processResources (Thread[Daemon worker,5,main]) completed. Took 0.099 secs. :house.intelli.raspi:classes (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:classes Skipping task ':house.intelli.raspi:classes' as it has no actions. :house.intelli.raspi:classes (Thread[Daemon worker,5,main]) completed. Took 0.0 secs. :house.intelli.raspi:jar (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:jar Executing task ':house.intelli.raspi:jar' (up-to-date check took 0.386 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/libs/house.intelli.raspi-0.9.1-SNAPSHOT.jar has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/libs/house.intelli.raspi-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.raspi:jar (Thread[Daemon worker,5,main]) completed. Took 1.183 secs. :house.intelli.raspi:copyFilesFromAssembly (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:copyFilesFromAssembly Executing task ':house.intelli.raspi:copyFilesFromAssembly' (up-to-date check took 0.002 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/installation.properties has been removed. :house.intelli.raspi:copyFilesFromAssembly (Thread[Daemon worker,5,main]) completed. Took 0.053 secs. :house.intelli.raspi:copyFilesFromBin (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:copyFilesFromBin Executing task ':house.intelli.raspi:copyFilesFromBin' (up-to-date check took 0.003 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/bin has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/bin/house.intelli.raspi has been removed. :house.intelli.raspi:copyFilesFromBin (Thread[Daemon worker,5,main]) completed. Took 0.027 secs. :house.intelli.raspi:chmodMainExecutable (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:chmodMainExecutable Executing task ':house.intelli.raspi:chmodMainExecutable' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Starting process 'command 'chmod''. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/bin Command: chmod a+x house.intelli.raspi Successfully started process 'command 'chmod'' :house.intelli.raspi:chmodMainExecutable (Thread[Daemon worker,5,main]) completed. Took 0.011 secs. :house.intelli.raspi:copyDependencies (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:copyDependencies Executing task ':house.intelli.raspi:copyDependencies' (up-to-date check took 0.051 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/lib has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/lib/bcpg-jdk15on-1.60.jar has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/lib/bcprov-jdk15on-1.60.jar has been removed. :house.intelli.raspi:copyDependencies (Thread[Daemon worker,5,main]) completed. Took 0.187 secs. :house.intelli.raspi:copyJar (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:copyJar Executing task ':house.intelli.raspi:copyJar' (up-to-date check took 0.004 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/assembly/house.intelli.raspi/lib/house.intelli.raspi-0.9.1-SNAPSHOT.jar has been removed. :house.intelli.raspi:copyJar (Thread[Daemon worker,5,main]) completed. Took 0.014 secs. :house.intelli.raspi:tarGzAssembly (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:tarGzAssembly Executing task ':house.intelli.raspi:tarGzAssembly' (up-to-date check took 0.004 secs) due to: Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/distributions/house.intelli.raspi-0.9.1-SNAPSHOT-bin.tar.gz has changed. Output property 'archivePath' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/distributions/house.intelli.raspi-0.9.1-SNAPSHOT-bin.tar.gz has been removed. :house.intelli.raspi:tarGzAssembly (Thread[Daemon worker,5,main]) completed. Took 0.949 secs. :house.intelli.raspi:assemble (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:assemble Skipping task ':house.intelli.raspi:assemble' as it has no actions. :house.intelli.raspi:assemble (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.raspi:compileTestJava (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:compileTestJava Executing task ':house.intelli.raspi:compileTestJava' (up-to-date check took 0.029 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/classes/test has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/classes/test/house has been removed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/classes/test/house/intelli has been removed. All input files are considered out-of-date for incremental task ':house.intelli.raspi:compileTestJava'. Compiling with JDK Java compiler API. :house.intelli.raspi:compileTestJava (Thread[Daemon worker,5,main]) completed. Took 0.147 secs. :house.intelli.raspi:processTestResources (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:processTestResources file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/src/test/resources', not found file or directory '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/src/test/resources', not found Skipping task ':house.intelli.raspi:processTestResources' as it has no source files. :house.intelli.raspi:processTestResources UP-TO-DATE :house.intelli.raspi:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.003 secs. :house.intelli.raspi:testClasses (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:testClasses Skipping task ':house.intelli.raspi:testClasses' as it has no actions. :house.intelli.raspi:testClasses (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.raspi:test (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:test Executing task ':house.intelli.raspi:test' (up-to-date check took 0.088 secs) due to: Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/test-results/test/binary has changed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/test-results/test/binary/output.bin has been removed. Output property 'binResultsDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/test-results/test/binary/output.bin.idx has been removed. Starting process 'Gradle Test Executor 9'. Working directory: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi Command: /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Djava.security.manager=worker.org.gradle.process.internal.worker.child.BootstrapSecurityManager -XX:MaxPermSize=256m -javaagent:build/tmp/expandedArchives/org.jacoco.agent-0.7.7.201606060606.jar_alq9f7txs0b41o93er67xw618/jacocoagent.jar=destfile=build/jacoco/test.exec,append=true,inclnolocationclasses=false,dumponexit=true,output=file,jmx=false -Xmx512m -Dfile.encoding=UTF-8 -Duser.country=GB -Duser.language=en -Duser.variant -ea -cp /home/tomcat/.gradle/caches/3.1/workerMain/gradle-worker.jar worker.org.gradle.process.internal.worker.GradleWorkerMain 'Gradle Test Executor 9' Successfully started process 'Gradle Test Executor 9' OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0 Initialized native services in: /home/tomcat/.gradle/native Gradle Test Executor 9 started executing tests. house.intelli.raspi.DimmerActorTest > dimmerValue100 STANDARD_OUT 02:40:57.558 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@6897f7db property=dimmerValue old=0 value=100 100 02:40:57.743 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close house.intelli.raspi.DimmerActorTest > dimmerValue101 STANDARD_OUT 02:40:57.880 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close house.intelli.raspi.DimmerActorTest > dimmerValue_1 STANDARD_OUT 02:40:57.888 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close house.intelli.raspi.DimmerActorTest > dimmerValue0 STANDARD_OUT 02:40:57.892 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close house.intelli.raspi.DimmerActorTest > dimmerValues STANDARD_OUT 02:40:57.904 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=0 value=12 1 02:40:57.905 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=12 value=25 2 02:40:57.909 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=25 value=37 4 02:40:57.911 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=37 value=50 8 02:40:57.912 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=50 value=62 16 02:40:57.913 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=62 value=75 32 02:40:57.914 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=75 value=87 64 02:40:57.915 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=87 value=100 100 02:40:57.920 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close house.intelli.raspi.DimmerActorTest > dimmerValue STANDARD_OUT 02:40:57.926 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@583f55bf property=dimmerValue old=0 value=87 64 02:40:57.929 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close Gradle Test Executor 9 finished executing tests. Finished generating test XML results (0.003 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/test-results/test Generating HTML test report... Finished generating test html results (0.012 secs) into: /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build/reports/tests/test :house.intelli.raspi:test (Thread[Daemon worker,5,main]) completed. Took 4.3 secs. :house.intelli.raspi:check (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:check Skipping task ':house.intelli.raspi:check' as it has no actions. :house.intelli.raspi:check (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :house.intelli.raspi:build (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:build Skipping task ':house.intelli.raspi:build' as it has no actions. :house.intelli.raspi:build (Thread[Daemon worker,5,main]) completed. Took 0.001 secs. :copyDistributions (Thread[Daemon worker,5,main]) started. :copyDistributions Executing task ':copyDistributions' (up-to-date check took 0.06 secs) due to: Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build/distributions has changed. Output property 'destinationDir' file /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/build/distributions/house.intelli.raspi-0.9.1-SNAPSHOT-bin.tar.gz has been removed. :copyDistributions (Thread[Daemon worker,5,main]) completed. Took 0.161 secs. :install (Thread[Daemon worker,5,main]) started. :install Executing task ':install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@3dade8cb :install (Thread[Daemon worker,5,main]) completed. Took 2.093 secs. :house.intelli.android:install (Thread[Daemon worker,5,main]) started. :house.intelli.android:install Executing task ':house.intelli.android:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.android:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@7abc265d :house.intelli.android:install (Thread[Daemon worker,5,main]) completed. Took 0.107 secs. :house.intelli.core:install (Thread[Daemon worker,5,main]) started. :house.intelli.core:install Executing task ':house.intelli.core:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.core:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@5031f33c :house.intelli.core:install (Thread[Daemon worker,5,main]) completed. Took 0.099 secs. :house.intelli.desktop:install (Thread[Daemon worker,5,main]) started. :house.intelli.desktop:install Executing task ':house.intelli.desktop:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.desktop:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@4cb107ad :house.intelli.desktop:install (Thread[Daemon worker,5,main]) completed. Took 0.074 secs. :house.intelli.jdo:install (Thread[Daemon worker,5,main]) started. :house.intelli.jdo:install Executing task ':house.intelli.jdo:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.jdo:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@4b62b25b :house.intelli.jdo:install (Thread[Daemon worker,5,main]) completed. Took 0.07 secs. :house.intelli.pgp:install (Thread[Daemon worker,5,main]) started. :house.intelli.pgp:install Executing task ':house.intelli.pgp:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.pgp:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@3a9486a3 :house.intelli.pgp:install (Thread[Daemon worker,5,main]) completed. Took 0.071 secs. :house.intelli.raspi:install (Thread[Daemon worker,5,main]) started. :house.intelli.raspi:install Executing task ':house.intelli.raspi:install' (up-to-date check took 0.0 secs) due to: Task has not declared any outputs. Publishing configuration: configuration ':house.intelli.raspi:archives' Publishing to org.gradle.api.publication.maven.internal.deployer.BaseMavenInstaller@6d27fdaa :house.intelli.raspi:install (Thread[Daemon worker,5,main]) completed. Took 0.09 secs. BUILD SUCCESSFUL Total time: 9 mins 23.677 secs Stopped 0 compiler daemon(s). Received result Success[value=null] from daemon DaemonInfo{pid=9738, address=[3316a64a-638d-49e2-96b5-a8c32e5f0e38 port:34619, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546219903255, context=DefaultDaemonContext[uid=a9f47f13-687e-4ba9-a047-a45842857cc2,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=9738,idleTimeout=10800000,daemonOpts=-XX:MaxPermSize=256m,-XX:+HeapDumpOnOutOfMemoryError,-Xmx1024m,-Dfile.encoding=UTF-8,-Duser.country=GB,-Duser.language=en,-Duser.variant]} (build should be done). Build step 'Invoke Gradle script' changed build result to SUCCESS Archiving artifacts Recording test results Warning: you have no plugins providing access control for builds, so falling back to legacy behavior of permitting any downstream builds to be triggered Triggering a new build of org.openhab.binding.intellihouse Finished: SUCCESS