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/git2350883547684895807.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 8086f39b61d1060e01d8c77f626356ad6019d7fa (origin/master)
> git config core.sparsecheckout
> git checkout -f 8086f39b61d1060e01d8c77f626356ad6019d7fa
> git rev-list 4eb6c04a90aac1d4630081a157845466919e3205
[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 1.874 secs.
Connected to daemon DaemonInfo{pid=11796, address=[4397b9b0-8335-44f5-acd7-9fa06c2efa77 port:39862, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546181297436, context=DefaultDaemonContext[uid=24efe19b-10f8-484d-8bb8-fcfb67acf1cf,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=11796,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=d0669cd1-9cdd-49f7-814e-88219b3215ab.1, currentDir=/home/tomcat/.jenkins/workspace/house.intelli/house.intelli}.
Received result org.gradle.launcher.daemon.protocol.BuildStarted@2049a9c1 from daemon DaemonInfo{pid=11796, address=[4397b9b0-8335-44f5-acd7-9fa06c2efa77 port:39862, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546181297436, context=DefaultDaemonContext[uid=24efe19b-10f8-484d-8bb8-fcfb67acf1cf,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=11796,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: 11796). The daemon log file: /home/tomcat/.gradle/daemon/3.1/daemon-11796.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=24efe19b-10f8-484d-8bb8-fcfb67acf1cf,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=11796,idleTimeout=10800000,daemonOpts=-XX:MaxPermSize=256m,-XX:+HeapDumpOnOutOfMemoryError,-Xmx1024m,-Dfile.encoding=UTF-8,-Duser.country=GB,-Duser.language=en,-Duser.variant]
Starting Build
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'.
Evaluating project ':house.intelli.android' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.android/build.gradle'.
Evaluating project ':house.intelli.core' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.core/build.gradle'.
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'.
Evaluating project ':house.intelli.raspi' using build file '/home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.raspi/build.gradle'.
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.002 secs) due to:
Task has not declared any outputs.
:clean (Thread[Daemon worker,5,main]) completed. Took 0.031 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.005 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.033 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.005 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.008 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.021 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.032 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.042 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.004 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.002 secs.
:jar (Thread[Daemon worker,5,main]) started.
:jar
Executing task ':jar' (up-to-date check took 0.138 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.266 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.001 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.008 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.001 secs.
:house.intelli.core:compileJava (Thread[Daemon worker,5,main]) started.
:house.intelli.core:compileJava
Executing task ':house.intelli.core:compileJava' (up-to-date check took 0.899 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 5.602 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.093 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.196 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.001 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.762 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 1.626 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.033 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.087 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.005 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.048 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.127 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.001 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.001 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.0 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.0 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.0 secs.
:house.intelli.core:compileTestJava (Thread[Daemon worker,5,main]) started.
:house.intelli.core:compileTestJava
Executing task ':house.intelli.core:compileTestJava' (up-to-date check took 0.077 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 0.485 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.008 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.057 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.
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 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 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 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 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 1'
Successfully started process 'Gradle Test Executor 2'
Successfully started process 'Gradle Test Executor 6'
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 3'
OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0
Successfully started process 'Gradle Test Executor 4'
OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0
Successfully started process 'Gradle Test Executor 5'
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
Initialized native services in: /home/tomcat/.gradle/native
Gradle Test Executor 1 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 6 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 5 started executing tests.
Initialized native services in: /home/tomcat/.gradle/native
Gradle Test Executor 3 started executing tests.
house.intelli.core.rpc.HttpRpcClientTransportTest > posttestserver SKIPPED
Gradle Test Executor 6 finished executing tests.
house.intelli.core.rpc.OpenHabIT > openHabEcho SKIPPED
Gradle Test Executor 4 finished executing tests.
house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT
15:48:45.418 [Test worker] WARN house.intelli.core.rpc.HostId - Environment variable 'HOSTNAME' is missing or empty.
15:48:45.655 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.rpc.PollInverseRequestsThread - run: rpcContext.rpcClientTransportProvider not yet assigned! Going to retry later.
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:45.858 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] INFO house.intelli.core.rpc.PollInverseRequestsThread - run: rpcContext.rpcClientTransportProvider not yet assigned! Going to retry later.
15:48:45.861 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=G6IBe-67RcKFfulrkpQ5mA, clientHostId=server-9NplQqTqriq7uH-6Wx9xZQ, serverHostId=client-ERnjXgD2O88k8GVPckuxfQ, created=Sun Dec 30 15:48:45 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]
house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT
15:48:45.963 [PollInverseRequestsThread-tyrion1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=U-pxpB9rtXM89JSu7gdlMA, clientHostId=tyrion1, serverHostId=server, created=Sun Dec 30 15:48:45 CET 2018, timeout=600000]
15:48:46.086 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.jaxb.IntelliHouseJaxbContextProvider, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@4bb2189c
15:48:46.126 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - getServices: delegateClass=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate, serviceClasses=[house.intelli.core.jaxb.IntelliHouseJaxbContextProviderImpl]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.163 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=jiSz1h3IxcnU53Hz2ReLpg, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithoutFinalSlash STANDARD_OUT
15:48:46.181 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@59765244
house.intelli.core.rpc.HostIdTest > getLocalHostId STANDARD_OUT
15:48:46.123 [Test worker] WARN house.intelli.core.rpc.HostId - Environment variable 'HOSTNAME' is missing or empty.
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.223 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=jiSz1h3IxcnU53Hz2ReLpg, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=G6IBe-67RcKFfulrkpQ5mA, clientHostId=server-9NplQqTqriq7uH-6Wx9xZQ, serverHostId=client-ERnjXgD2O88k8GVPckuxfQ, created=Sun Dec 30 15:48:45 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]]]
house.intelli.core.rpc.HttpRpcClientTransportProviderTest > baseServerUrlWithFinalSlash STANDARD_OUT
15:48:46.246 [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.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.253 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=lwIOjXocNKCH1KFwfaGuXQ, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
house.intelli.core.rpc.HostIdTest > getLocalHostId STANDARD_OUT
localHostId=tyrion1
Gradle Test Executor 3 finished executing tests.
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.324 [pool-1-thread-1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@30a4ce4e
15:48:46.359 [pool-1-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.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:48:46.333 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] INFO house.intelli.core.rpc.PollInverseRequestsThread - run: rpcContext.rpcClientTransportProvider not yet assigned! Going to retry later.
house.intelli.core.util.StringUtilTest > split0 STANDARD_OUT
15:48:46.365 [PollInverseRequestsThread-tyrion1] INFO house.intelli.core.jaxb.IntelliHouseJaxbContext - getJaxbContext: provider.class=house.intelli.core.jaxb.IntelliHouseJaxbContextProviderImpl, classesToBeBound=[class house.intelli.core.rpc.dimmer.DimmerActorWriteRequest, class house.intelli.core.rpc.relay.RelayActorReadResponse, class house.intelli.core.rpc.DeferringResponse, class house.intelli.core.rpc.dimmer.DimmerActorReadRequest, class house.intelli.core.rpc.pv.PvStatusList, class house.intelli.core.rpc.ErrorResponse, class house.intelli.core.rpc.dimmer.DimmerActorEventRequest, class house.intelli.core.rpc.relay.RelayActorWriteRequest, class house.intelli.core.rpc.keybutton.KeyButtonSensorEventRequest, class house.intelli.core.rpc.echo.EchoRequest, class house.intelli.core.rpc.PutInverseResponseRequest, class house.intelli.core.rpc.lightcontroller.LightControllerEventRequest, class house.intelli.core.rpc.pv.PvStatusEventRequest, class house.intelli.core.rpc.relay.RelayActorWriteResponse, class house.intelli.core.rpc.echo.EchoResponse, class house.intelli.core.rpc.dimmer.DimmerActorWriteResponse, class house.intelli.core.rpc.relay.RelayActorReadRequest, class house.intelli.core.rpc.NullResponse, 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.relay.RelayActorEventRequest, class house.intelli.core.rpc.PollInverseRequestsRequest, class house.intelli.core.rpc.DeferredResponseRequest, class house.intelli.core.rpc.lightcontroller.LightControllerFederationPropagationRequest]
Gradle Test Executor 1 finished executing tests.
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.411 [pool-1-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=G6IBe-67RcKFfulrkpQ5mA, clientHostId=server-9NplQqTqriq7uH-6Wx9xZQ, serverHostId=client-ERnjXgD2O88k8GVPckuxfQ, created=Sun Dec 30 15:48:45 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]
15:48:46.416 [pool-1-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=bla bla trallala]
15:48:46.419 [pool-1-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=rzYKdk3VPcB5BhBukyd0NQ, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
15:48:46.425 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=G6IBe-67RcKFfulrkpQ5mA, clientHostId=server-9NplQqTqriq7uH-6Wx9xZQ, serverHostId=client-ERnjXgD2O88k8GVPckuxfQ, payload=bla bla trallala]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:48:46.358 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=142333, payload=lAG_IOkKaY87WTv1HI2doA, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.449 [pool-1-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=rzYKdk3VPcB5BhBukyd0NQ, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:48:46.629 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ya4zKkNhADmxyuvHUB6ayw, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
15:48:46.703 [pool-2-thread-1] INFO house.intelli.core.service.ServiceRegistry - addDelegate: serviceClass=house.intelli.core.rpc.RpcService, delegate=house.intelli.core.service.ServiceLoaderServiceRegistryDelegate@19eedc41
15:48:46.723 [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.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
15:48:46.715 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException
java.lang.InterruptedException: null
at java.lang.Object.wait(Native Method)
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:48:46.747 [pool-2-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=142333, payload=lAG_IOkKaY87WTv1HI2doA, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesNormalServiceOnClient STANDARD_OUT
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)
15:48:46.751 [PollInverseRequestsThread-client-ERnjXgD2O88k8GVPckuxfQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=lwIOjXocNKCH1KFwfaGuXQ, clientHostId=client-ERnjXgD2O88k8GVPckuxfQ, serverHostId=server, inverseRequests=[]]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:48:46.781 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=qspY13WZR5Q5oTrCTQbMsw, clientHostId=server-X_uMkRk6gz_qacxSCXdZqg, serverHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000, payload=uxI-IpefEsZhcbxDvbTqmA, throwExceptionClassName=null, sleep=300000]
15:48:46.785 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=r_p2qaOvPgI_DFTgRHe85Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
15:48:46.793 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=r_p2qaOvPgI_DFTgRHe85Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=qspY13WZR5Q5oTrCTQbMsw, clientHostId=server-X_uMkRk6gz_qacxSCXdZqg, serverHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000, payload=uxI-IpefEsZhcbxDvbTqmA, throwExceptionClassName=null, sleep=300000]]]
15:48:46.796 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ZS_yPmI_jwfUABlD14ZR3g, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000]
15:48:46.813 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=qspY13WZR5Q5oTrCTQbMsw, clientHostId=server-X_uMkRk6gz_qacxSCXdZqg, serverHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, created=Sun Dec 30 15:48:46 CET 2018, timeout=600000, payload=uxI-IpefEsZhcbxDvbTqmA, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:49:16.598 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server]
15:49:16.600 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:49:16 CET 2018, timeout=112091]
15:49:16.658 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ya4zKkNhADmxyuvHUB6ayw, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, inverseRequests=[]]
15:49:16.660 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=pCpzG--gbpt_qFpBrQgnag, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:49:16 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:49:16.798 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ZS_yPmI_jwfUABlD14ZR3g, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:49:16.800 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=AcscuQ-TRGq881ZcR3aVJg, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:49:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:49:46.602 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server]
15:49:46.605 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:49:46 CET 2018, timeout=82086]
15:49:46.663 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=pCpzG--gbpt_qFpBrQgnag, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, inverseRequests=[]]
15:49:46.665 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=tmQlgIM4zWr5xhs6LTg8Mg, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:49:46 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:49:46.804 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=AcscuQ-TRGq881ZcR3aVJg, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:49:46.806 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=bZ8vTwRmwtu4tThXQe0cjA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:49:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:50:16.609 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server]
15:50:16.610 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:50:16 CET 2018, timeout=52081]
15:50:16.668 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=tmQlgIM4zWr5xhs6LTg8Mg, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, inverseRequests=[]]
15:50:16.669 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=3P27IlQLAY0Vtvf3OuaxrA, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:50:16 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:50:16.809 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=bZ8vTwRmwtu4tThXQe0cjA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:50:16.811 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=7UdPfSErLTnG-8Ns4r6NdQ, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:50:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:50:46.612 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server]
15:50:46.613 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:50:46 CET 2018, timeout=22078]
15:50:46.670 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=3P27IlQLAY0Vtvf3OuaxrA, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, inverseRequests=[]]
15:50:46.672 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=NiQ_3DvGg_n6QvCLHSwoaw, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:50:46 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:50:46.814 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=7UdPfSErLTnG-8Ns4r6NdQ, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:50:46.816 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=rMREqzrZTUbEj70uq97R4Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:50:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServerAndEncountersTimeout STANDARD_OUT
15:51:08.694 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server]
15:51:08.717 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: house.intelli.core.rpc.RpcTimeoutException: Request timed out: EchoRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=142333, payload=lAG_IOkKaY87WTv1HI2doA, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.RpcTimeoutException: Request timed out: EchoRequest[requestId=R3FxmqvLoaLDDa6ZcaaYNQ, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, created=Sun Dec 30 15:48:46 CET 2018, timeout=142333, payload=lAG_IOkKaY87WTv1HI2doA, 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)
15:51:08.885 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] 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)
house.intelli.core.rpc.NormalClientServerTest STANDARD_OUT
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.NormalClientServerTest > clientInvokesNormalServiceOnServer STANDARD_OUT
15:51:08.888 [PollInverseRequestsThread-client-FrXrmFboXfvcCx3wm7N2ig] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=NiQ_3DvGg_n6QvCLHSwoaw, clientHostId=client-FrXrmFboXfvcCx3wm7N2ig, serverHostId=server, inverseRequests=[]]
15:51:08.895 [PollInverseRequestsThread-client-r0Hs7iY3RacrdOXEA-r0hg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=UdCF5PeigP7WNcSYuZaR0w, clientHostId=client-r0Hs7iY3RacrdOXEA-r0hg, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000]
15:51:08.895 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=wLYp2mJHV-Jp3HRuN6n0BQ, clientHostId=client-r0Hs7iY3RacrdOXEA-r0hg, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]
15:51:08.905 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=wLYp2mJHV-Jp3HRuN6n0BQ, clientHostId=client-r0Hs7iY3RacrdOXEA-r0hg, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000, payload=bla bla trallala, throwExceptionClassName=null, sleep=0]
15:51:08.906 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=bla bla trallala]
15:51:08.907 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=wLYp2mJHV-Jp3HRuN6n0BQ, clientHostId=client-r0Hs7iY3RacrdOXEA-r0hg, serverHostId=server, payload=bla bla trallala]
house.intelli.core.rpc.NormalClientServerTest STANDARD_OUT
15:51:08.929 [PollInverseRequestsThread-client-r0Hs7iY3RacrdOXEA-r0hg] 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)
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
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)
15:51:08.931 [PollInverseRequestsThread-client-r0Hs7iY3RacrdOXEA-r0hg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=UdCF5PeigP7WNcSYuZaR0w, clientHostId=client-r0Hs7iY3RacrdOXEA-r0hg, serverHostId=server, inverseRequests=[]]
15:51:08.933 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000, payload=vgNGmzr0i-iskg65uLnGVQ, throwExceptionClassName=null, sleep=300000]
15:51:08.934 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=CFs7C-bKyvo6SQ9CcKMiaA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000]
15:51:08.937 [pool-6-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:51:08 CET 2018, timeout=600000, payload=vgNGmzr0i-iskg65uLnGVQ, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:51:16.819 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=rMREqzrZTUbEj70uq97R4Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:51:16.821 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=MuiHPtUw8ILhWE31Pp82nA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:51:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:51:38.938 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:51:38.939 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=CFs7C-bKyvo6SQ9CcKMiaA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:51:38.939 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:51:38 CET 2018, timeout=569994]
15:51:38.941 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Dk7yrHuc7yclMRMZggn9iQ, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:51:38 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:51:46.824 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=MuiHPtUw8ILhWE31Pp82nA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:51:46.826 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=oVb21MK1ATjoINUxNzff2Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:51:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:52:08.946 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:52:08.947 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Dk7yrHuc7yclMRMZggn9iQ, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:52:08.947 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:52:08 CET 2018, timeout=539986]
15:52:08.950 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=ZwZbZhOm-euCj0eoT9F4jw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:52:08 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:52:16.829 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=oVb21MK1ATjoINUxNzff2Q, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:52:16.832 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=VLGsjpI8V_m7WwsWmhrHHA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:52:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:52:38.951 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:52:38.952 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=ZwZbZhOm-euCj0eoT9F4jw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:52:38.952 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:52:38 CET 2018, timeout=509981]
15:52:38.954 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Wa7Xp-64jfhiPgMOZA4p0g, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:52:38 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:52:46.834 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=VLGsjpI8V_m7WwsWmhrHHA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:52:46.835 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=6VxAsa-KlyJTWiYF8kheAA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:52:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:53:08.956 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:53:08.957 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Wa7Xp-64jfhiPgMOZA4p0g, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:53:08.958 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:53:08 CET 2018, timeout=479975]
15:53:08.960 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=c44IItkRPfa93KYzQEQLHw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:53:08 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:53:16.838 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=6VxAsa-KlyJTWiYF8kheAA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:53:16.840 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=QOfb0XjUpzyAy2AMtxgM4A, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:53:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:53:38.961 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:53:38.962 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:53:38 CET 2018, timeout=449971]
15:53:38.963 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=c44IItkRPfa93KYzQEQLHw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:53:38.964 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=WML2gZ5xjS89v76m20vYgQ, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:53:38 CET 2018, timeout=600000]
15:53:46.750 [pool-2-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=lAG_IOkKaY87WTv1HI2doA]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClient STANDARD_OUT
15:53:46.814 [pool-4-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=uxI-IpefEsZhcbxDvbTqmA]
15:53:46.815 [pool-4-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=JbJjhsEnmvzc_IDQ8hKeRA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, created=Sun Dec 30 15:53:46 CET 2018, timeout=600000]
15:53:46.817 [pool-4-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=JbJjhsEnmvzc_IDQ8hKeRA, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server]
15:53:46.818 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=qspY13WZR5Q5oTrCTQbMsw, clientHostId=server-X_uMkRk6gz_qacxSCXdZqg, serverHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, payload=uxI-IpefEsZhcbxDvbTqmA]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:53:46.830 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] 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)
15:53:46.834 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=ZZQ9dH0a_O8jHB1ll3Ue6Q, clientHostId=server-usam3n51u8pfZmHd43lAaA, serverHostId=client-gm9E2wR_IojoaHLZCmerWg, created=Sun Dec 30 15:53:46 CET 2018, timeout=178795, payload=sZEnBfysPckbnMa7viv2Wg, throwExceptionClassName=null, sleep=300000]
15:53:46.834 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=CwDVriE78XpQkJsJItuZQA, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:53:46 CET 2018, timeout=600000]
15:53:46.835 [PollInverseRequestsThread-client-s_7HFvl7LDBe4NmBG8YNJQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=QOfb0XjUpzyAy2AMtxgM4A, clientHostId=client-s_7HFvl7LDBe4NmBG8YNJQ, serverHostId=server, inverseRequests=[]]
15:53:46.844 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=CwDVriE78XpQkJsJItuZQA, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[EchoRequest[requestId=ZZQ9dH0a_O8jHB1ll3Ue6Q, clientHostId=server-usam3n51u8pfZmHd43lAaA, serverHostId=client-gm9E2wR_IojoaHLZCmerWg, created=Sun Dec 30 15:53:46 CET 2018, timeout=178795, payload=sZEnBfysPckbnMa7viv2Wg, throwExceptionClassName=null, sleep=300000]]]
15:53:46.847 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=u3j5hczAmxUHIVt8i48P6A, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:53:46 CET 2018, timeout=600000]
15:53:46.850 [pool-7-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=ZZQ9dH0a_O8jHB1ll3Ue6Q, clientHostId=server-usam3n51u8pfZmHd43lAaA, serverHostId=client-gm9E2wR_IojoaHLZCmerWg, created=Sun Dec 30 15:53:46 CET 2018, timeout=178795, payload=sZEnBfysPckbnMa7viv2Wg, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:54:08.964 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:54:08.965 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=WML2gZ5xjS89v76m20vYgQ, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:54:08.965 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:54:08 CET 2018, timeout=419968]
15:54:08.966 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=rh95fiQe82dEg5KNE41jNw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:54:08 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:54:16.848 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=u3j5hczAmxUHIVt8i48P6A, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:54:16.850 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=kUuYvBzFisNgZXVJ__k-kA, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:54:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:54:38.967 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:54:38.968 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=rh95fiQe82dEg5KNE41jNw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:54:38.968 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:54:38 CET 2018, timeout=389965]
15:54:38.970 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=U6Aab32IKmsTCPf9zK2dQA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:54:38 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:54:46.855 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=kUuYvBzFisNgZXVJ__k-kA, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:54:46.856 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=GzJ2b11b0zPDABsLOQz36A, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:54:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:55:08.971 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:55:08.973 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=U6Aab32IKmsTCPf9zK2dQA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:55:08.973 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:55:08 CET 2018, timeout=359960]
15:55:08.974 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=hF3a5EYm6ctwsB0UFIY1iw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:55:08 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:55:16.859 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=GzJ2b11b0zPDABsLOQz36A, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:55:16.860 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=UzUxIBPtXW5xK0p-Q4u98w, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:55:16 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:55:38.975 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: DeferringResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server]
15:55:38.976 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=hF3a5EYm6ctwsB0UFIY1iw, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:55:38.976 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: DeferredResponseRequest[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:55:38 CET 2018, timeout=329957]
15:55:38.978 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=eY0kI7ZbYEANvlYgdPG1FA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, created=Sun Dec 30 15:55:38 CET 2018, timeout=600000]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:55:46.863 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=UzUxIBPtXW5xK0p-Q4u98w, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:55:46.865 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=xvNQXTUEGFdWq9Xy8k2huw, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:55:46 CET 2018, timeout=600000]
house.intelli.core.rpc.NormalClientServerTest > clientInvokesLongRunningServiceOnServer STANDARD_OUT
15:56:08.938 [pool-6-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoResponse[requestId=null, clientHostId=null, serverHostId=null, payload=vgNGmzr0i-iskg65uLnGVQ]
15:56:08.940 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: EchoResponse[requestId=kO_qGP_ZF0HD4s6-Rji7iA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, payload=vgNGmzr0i-iskg65uLnGVQ]
house.intelli.core.rpc.NormalClientServerTest STANDARD_OUT
15:56:08.944 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] 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)
house.intelli.core.rpc.NormalClientServerTest > clientInvokesServiceOnServerAndExpectsRemoteException STANDARD_OUT
at house.intelli.core.rpc.PollInverseRequestsThread.run(PollInverseRequestsThread.java:56)
15:56:08.948 [PollInverseRequestsThread-client-M_j_Vq6vU8Ml5nh6jVAK7w] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=eY0kI7ZbYEANvlYgdPG1FA, clientHostId=client-M_j_Vq6vU8Ml5nh6jVAK7w, serverHostId=server, inverseRequests=[]]
15:56:08.958 [PollInverseRequestsThread-client-YMU_V5xde3eF-61v8We47A] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=BOdcZf4LPX471lWzg6b4PQ, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000]
15:56:08.958 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:08.962 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:08.963 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:08.964 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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)
15:56:08.975 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server]
15:56:08.978 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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: aQe63cRLBecCD_ZDp-Zyvw
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
15:56:08.988 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=1
15:56:09.989 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:09.992 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:09.993 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:09.994 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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)
15:56:09.997 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server]
15:56:10.000 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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: aQe63cRLBecCD_ZDp-Zyvw
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
15:56:10.010 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=2
15:56:11.011 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:11.014 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:11.015 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:11.016 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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)
15:56:11.020 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server]
15:56:11.026 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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: aQe63cRLBecCD_ZDp-Zyvw
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
15:56:11.049 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=3
15:56:12.050 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:12.052 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, created=Sun Dec 30 15:56:08 CET 2018, timeout=600000, payload=aQe63cRLBecCD_ZDp-Zyvw, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:12.054 [pool-8-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:12.057 [pool-8-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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)
15:56:12.060 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=KnsjY9TGq8LzuY3boY7o9A, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server]
15:56:12.068 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
java.lang.NumberFormatException: aQe63cRLBecCD_ZDp-Zyvw
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: aQe63cRLBecCD_ZDp-Zyvw
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
Gradle Test Executor 5 finished executing tests.
house.intelli.core.rpc.NormalClientServerTest STANDARD_OUT
15:56:12.077 [PollInverseRequestsThread-client-YMU_V5xde3eF-61v8We47A] INFO house.intelli.core.rpc.InverseRequestRegistry - pollRequests: java.lang.InterruptedException
Gradle Test Executor 5 STANDARD_OUT
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)
15:56:12.078 [PollInverseRequestsThread-client-YMU_V5xde3eF-61v8We47A] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=BOdcZf4LPX471lWzg6b4PQ, clientHostId=client-YMU_V5xde3eF-61v8We47A, serverHostId=server, inverseRequests=[]]
house.intelli.core.rpc.InverseClientServerTest > serverInvokesLongRunningServiceOnClientAndEncountersTimeout STANDARD_OUT
15:56:16.869 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=xvNQXTUEGFdWq9Xy8k2huw, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:56:16.870 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Z-vewiI3wiak1IVJicUs6Q, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, created=Sun Dec 30 15:56:16 CET 2018, timeout=600000]
15:56:45.642 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: house.intelli.core.rpc.RpcTimeoutException: Inverse request timed out: EchoRequest[requestId=ZZQ9dH0a_O8jHB1ll3Ue6Q, clientHostId=server-usam3n51u8pfZmHd43lAaA, serverHostId=client-gm9E2wR_IojoaHLZCmerWg, created=Sun Dec 30 15:53:46 CET 2018, timeout=178795, payload=sZEnBfysPckbnMa7viv2Wg, throwExceptionClassName=null, sleep=300000]
house.intelli.core.rpc.RpcTimeoutException: Inverse request timed out: EchoRequest[requestId=ZZQ9dH0a_O8jHB1ll3Ue6Q, clientHostId=server-usam3n51u8pfZmHd43lAaA, serverHostId=client-gm9E2wR_IojoaHLZCmerWg, created=Sun Dec 30 15:53:46 CET 2018, timeout=178795, payload=sZEnBfysPckbnMa7viv2Wg, 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
15:56:45.652 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] 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)
15:56:45.657 [PollInverseRequestsThread-client-gm9E2wR_IojoaHLZCmerWg] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Z-vewiI3wiak1IVJicUs6Q, clientHostId=client-gm9E2wR_IojoaHLZCmerWg, serverHostId=server, inverseRequests=[]]
15:56:45.667 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:45.682 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=TzJh5qyljYybejkv6k6w0Q, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000]
15:56:45.686 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=TzJh5qyljYybejkv6k6w0Q, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]]
15:56:45.688 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=0mh6XM7k3KP_P2jk07YmQw, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000]
15:56:45.690 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:45.695 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:45.697 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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)
15:56:45.707 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=n-F3aLlKLujtujmr5B2-EQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000]
15:56:45.709 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=n-F3aLlKLujtujmr5B2-EQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server]
15:56:45.710 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ]
15:56:45.713 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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: G0mo1XTQN55kHxrkb93kew
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
15:56:45.734 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=1
15:56:46.735 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:46.738 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=0mh6XM7k3KP_P2jk07YmQw, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]]
15:56:46.740 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:46.740 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=NchEORf4sd3lqgamGDOaEA, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:46 CET 2018, timeout=600000]
15:56:46.741 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:46.742 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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)
15:56:46.745 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=-7knTUW6BhZ5L7DYlGEwqQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:46 CET 2018, timeout=600000]
15:56:46.746 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ]
15:56:46.748 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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: G0mo1XTQN55kHxrkb93kew
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
15:56:46.751 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=-7knTUW6BhZ5L7DYlGEwqQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server]
15:56:46.755 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=2
15:56:47.756 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:47.759 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=NchEORf4sd3lqgamGDOaEA, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]]
15:56:47.760 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:47.761 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=Q5E5duaqgRQmUT6h_ArzHw, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:47 CET 2018, timeout=600000]
15:56:47.762 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:47.764 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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)
15:56:47.769 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=9dArzgDnQItnqiw4VMxPvA, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:47 CET 2018, timeout=600000]
15:56:47.770 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=9dArzgDnQItnqiw4VMxPvA, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server]
15:56:47.770 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ]
15:56:47.773 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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: G0mo1XTQN55kHxrkb93kew
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
15:56:47.811 [Test worker] INFO house.intelli.core.rpc.RpcClient - invoke: RETRYING! retryCount=3
15:56:48.812 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:48.814 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=Q5E5duaqgRQmUT6h_ArzHw, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, inverseRequests=[EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]]]
15:56:48.818 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: EchoRequest[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ, created=Sun Dec 30 15:56:45 CET 2018, timeout=600000, payload=G0mo1XTQN55kHxrkb93kew, throwExceptionClassName=java.lang.NumberFormatException, sleep=0]
15:56:48.818 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PollInverseRequestsRequest[requestId=rEJVnfblVkBoNuM9bRJvQg, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:48 CET 2018, timeout=600000]
15:56:48.818 [pool-10-thread-1] INFO house.intelli.core.rpc.echo.EchoRpcService - process: throwing: java.lang.NumberFormatException
15:56:48.821 [pool-10-thread-1] ERROR house.intelli.core.rpc.RpcServiceExecutor - processLocally: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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)
15:56:48.826 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Sending request: PutInverseResponseRequest[requestId=LUyNUF5By7dIgWBzPMMqQQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, created=Sun Dec 30 15:56:48 CET 2018, timeout=600000]
15:56:48.828 [pool-10-thread-1] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: NullResponse[requestId=LUyNUF5By7dIgWBzPMMqQQ, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server]
15:56:48.829 [Test worker] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: ErrorResponse[requestId=-UpjNvgu6O7clYcVO71sag, clientHostId=server-Y9OibUqa7qzpQaFkPY-DyQ, serverHostId=client-kNz1KjVQTepy__G9VL6sAQ]
15:56:48.839 [Test worker] ERROR house.intelli.core.rpc.RpcClient - invoke: java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
java.lang.NumberFormatException: G0mo1XTQN55kHxrkb93kew
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)
Gradle Test Executor 2 finished executing tests.
15:56:48.851 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] DEBUG house.intelli.core.rpc.RpcClient - invoke: Received response: PollInverseRequestsResponse[requestId=rEJVnfblVkBoNuM9bRJvQg, clientHostId=client-kNz1KjVQTepy__G9VL6sAQ, serverHostId=server, inverseRequests=[]]
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: G0mo1XTQN55kHxrkb93kew
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
Gradle Test Executor 2 STANDARD_OUT
15:56:48.849 [PollInverseRequestsThread-client-kNz1KjVQTepy__G9VL6sAQ] 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)
Finished generating test XML results (0.092 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.107 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 8 mins 15.203 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.0 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.0 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.017 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.058 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.0 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.039 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.102 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.0 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.0 secs.
:house.intelli.jdo:compileJava (Thread[Daemon worker,5,main]) started.
:house.intelli.jdo:compileJava
Executing task ':house.intelli.jdo:compileJava' (up-to-date check took 0.028 secs) due to:
Task ':house.intelli.jdo:compileJava' additional action class path has changed.
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] DataNucleus Enhancer (version 5.2.0.m2) for API "JDO"Dec 30, 2018 3:56:51 PM org.datanucleus.enhancer.CommandLineHelper logEnhancerVersion
[ant:datanucleusenhancer] INFO: DataNucleus Enhancer (version 5.2.0.m2) for API "JDO"
[ant:datanucleusenhancer]
[ant:datanucleusenhancer] DataNucleus Enhancer : Classpath
[ant:datanucleusenhancer] >> /home/tomcat/.jenkins/workspace/house.intelli/house.intelli/house.intelli.jdo/build/classes/main
[ant:datanucleusenhancer] >> /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] >> /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 30, 2018 3:56:51 PM 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 30, 2018 3:56:51 PM 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=273 ms, enhance=142 ms, total=415 ms. Consult the log for full details
[ant:datanucleusenhancer] Dec 30, 2018 3:56:51 PM 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 30, 2018 3:56:51 PM org.datanucleus.enhancer.DataNucleusEnhancer addMessage
[ant:datanucleusenhancer] INFO: ENHANCED (Persistable) : house.intelli.jdo.model.PvStatusEntity
[ant:datanucleusenhancer] Dec 30, 2018 3:56:51 PM org.datanucleus.enhancer.DataNucleusEnhancer addMessage
[ant:datanucleusenhancer] INFO: DataNucleus Enhancer completed with success for 2 classes. Timings : input=273 ms, enhance=142 ms, total=415 ms. Consult the log for full details
[ant:echo] ***********************************************
[ant:echo] ***********************************************
[ant:echo] ***********************************************
:house.intelli.jdo:compileJava (Thread[Daemon worker,5,main]) completed. Took 2.353 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.012 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.032 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.0 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.133 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.428 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.001 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 1 mins 3.063 secs) due to:
No history is available.
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 1 mins 3.232 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.006 secs) due to:
No history is available.
:house.intelli.jdo:processTestResources (Thread[Daemon worker,5,main]) completed. Took 0.021 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.001 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:
No history is available.
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.
house.intelli.jdo.test.ImportPvStatusTest > importPvStatusFiles SKIPPED
Gradle Test Executor 7 finished executing tests.
Finished generating test XML results (0.004 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.564 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
Executing task ':house.intelli.pgp:compileJava' (up-to-date check took 0.046 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 1.486 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.024 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.06 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.0 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.421 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 1.322 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.001 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.033 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.142 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.009 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.001 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.031 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
15:58:06.430 [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.004 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.012 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.53 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.0 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.0 secs.
:house.intelli.raspi:compileJava (Thread[Daemon worker,5,main]) started.
:house.intelli.raspi:compileJava
Executing task ':house.intelli.raspi:compileJava' (up-to-date check took 0.052 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 1.028 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.027 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.068 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.001 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.382 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.089 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.031 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.022 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.019 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.009 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.138 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.005 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.015 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.006 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.878 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.0 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.023 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.136 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.004 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.002 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.041 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
15:58:13.876 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@6897f7db property=dimmerValue old=0 value=100
100
15:58:14.087 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
house.intelli.raspi.DimmerActorTest > dimmerValue101 STANDARD_OUT
15:58:14.172 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
house.intelli.raspi.DimmerActorTest > dimmerValue_1 STANDARD_OUT
15:58:14.182 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
house.intelli.raspi.DimmerActorTest > dimmerValue0 STANDARD_OUT
15:58:14.187 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
house.intelli.raspi.DimmerActorTest > dimmerValues STANDARD_OUT
15:58:14.199 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=0 value=12
1
15:58:14.201 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=12 value=25
2
15:58:14.205 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=25 value=37
4
15:58:14.206 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=37 value=50
8
15:58:14.207 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=50 value=62
16
15:58:14.208 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=62 value=75
32
15:58:14.209 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=75 value=87
64
15:58:14.210 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@1f62b1e9 property=dimmerValue old=87 value=100
100
15:58:14.211 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
house.intelli.raspi.DimmerActorTest > dimmerValue STANDARD_OUT
15:58:14.214 [Test worker] DEBUG house.intelli.core.bean.BeanSupport - setPropertyValue: setting: bean=@583f55bf property=dimmerValue old=0 value=87
64
15:58:14.215 [Test worker] DEBUG house.intelli.raspi.DimmerActorImpl - close
Gradle Test Executor 9 finished executing tests.
Finished generating test XML results (0.006 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.018 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.422 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@59e0a976
:install (Thread[Daemon worker,5,main]) completed. Took 1.018 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@14f66ba5
:house.intelli.android:install (Thread[Daemon worker,5,main]) completed. Took 0.093 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@6942c9bf
:house.intelli.core:install (Thread[Daemon worker,5,main]) completed. Took 0.096 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@230eed3e
:house.intelli.desktop:install (Thread[Daemon worker,5,main]) completed. Took 0.263 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@616a5c86
:house.intelli.jdo:install (Thread[Daemon worker,5,main]) completed. Took 0.08 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@26d9caa0
:house.intelli.pgp:install (Thread[Daemon worker,5,main]) completed. Took 0.076 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@5129d13
:house.intelli.raspi:install (Thread[Daemon worker,5,main]) completed. Took 0.101 secs.
BUILD SUCCESSFUL
Total time: 10 mins 2.57 secs
Stopped 0 compiler daemon(s).
Received result Success[value=null] from daemon DaemonInfo{pid=11796, address=[4397b9b0-8335-44f5-acd7-9fa06c2efa77 port:39862, addresses:[/0:0:0:0:0:0:0:1, /127.0.0.1]], state=Busy, lastBusy=1546181297436, context=DefaultDaemonContext[uid=24efe19b-10f8-484d-8bb8-fcfb67acf1cf,javaHome=/usr/lib/jvm/java-8-openjdk-amd64,daemonRegistryDir=/home/tomcat/.gradle/daemon,pid=11796,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