[
https://issues.apache.org/jira/browse/GEODE-1594?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15348868#comment-15348868
]
Hitesh Khamesra commented on GEODE-1594:
----------------------------------------
Skip to content
titletitle log in
search
ENABLE AUTO REFRESH
Jenkins
Geode_develop_DistributedTests
#3016
Test Results
com.gemstone.gemfire.rest.internal.web.controllers
RestAPIsOnMembersFunctionExecutionDUnitTest
testFunctionExecutionOnAllMembers
Back to Project
Status
Changes
Console Output
View Build Information
History
Parameters
Metadata
Environment Variables
Git Build Data
Test Result
Changes since last success
Compare environment
JS Widgets
Previous Build
Next Build
Regression
com.gemstone.gemfire.rest.internal.web.controllers.RestAPIsOnMembersFunctionExecutionDUnitTest.testFunctionExecutionOnAllMembers
Failing for the past 1 build (Since Failed#3016 )
Took 12 sec.
Failed 1 times in the last 30 runs. Stability: 96 %
Error Message
java.lang.AssertionError: unexpected exception
Stacktrace
java.lang.AssertionError: unexpected exception
at com.gemstone.gemfire.test.dunit.Assert.fail(Assert.java:64)
at
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase.executeFunctionThroughRestCall(RestAPITestBase.java:151)
at
com.gemstone.gemfire.rest.internal.web.controllers.RestAPIsOnMembersFunctionExecutionDUnitTest.testFunctionExecutionOnAllMembers(RestAPIsOnMembersFunctionExecutionDUnitTest.java:106)
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:497)
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
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.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at
org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:112)
at
org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:56)
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:497)
at
org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
at
org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
at
org.gradle.messaging.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32)
at
org.gradle.messaging.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:497)
at
org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
at
org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
at
org.gradle.messaging.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:360)
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:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.http.NoHttpResponseException: kuwait.gemstone.com:27072
failed to respond
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
at
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase.executeFunctionThroughRestCall(RestAPITestBase.java:149)
... 49 more
Standard Output
Previously run tests: [LauncherLifecycleCommandsDUnitTest,
SharedConfigurationEndToEndDUnitTest,
RestAPIOnRegionFunctionExecutionDUnitTest, RestAPIsAndInterOpsDUnitTest,
RestAPIsOnGroupsFunctionExecutionDUnitTest, RestAPIsWithSSLDUnitTest,
RestAPIsOnMembersFunctionExecutionDUnitTest]
[vm_1][info 2016/06/23 13:18:10.261 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run
with 0 args on object: runnable(setupVM)
[vm_1][info 2016/06/23 13:18:10.261 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on
object: runnable(setupVM) (took 0 ms)
[vm_2][info 2016/06/23 13:18:10.262 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run
with 0 args on object: runnable(setupVM)
[vm_2][info 2016/06/23 13:18:10.263 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on
object: runnable(setupVM) (took 0 ms)
[setup] START TEST
RestAPIsOnMembersFunctionExecutionDUnitTest.testFunctionExecutionOnAllMembers
[vm_1][info 2016/06/23 13:18:10.265 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/164365436.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/164365436@7cddc18a
[vm_1][info 2016/06/23 13:18:10.266 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_1] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/164365436.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/164365436@7cddc18a
(took 0 ms)
[vm_2][info 2016/06/23 13:18:10.266 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/803322279.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/803322279@220014c4
[vm_2][info 2016/06/23 13:18:10.266 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_2] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/803322279.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/803322279@220014c4
(took 0 ms)
[info 2016/06/23 13:18:10.267 PDT <Test worker> tid=0x13] GEMFIRE
HOME:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode
[info 2016/06/23 13:18:10.268 PDT <Test worker> tid=0x13] geode-web-api war
found:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war
[vm_1][info 2016/06/23 13:18:10.269 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$12/1075948277.call
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$12/1075948277@77f2304f
[vm_1][info 2016/06/23 13:18:10.269 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest
[vm_1] from
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$12/1075948277.call
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$12/1075948277@77f2304f
(took 0 ms)
[vm_2][info 2016/06/23 13:18:10.270 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$9/695495763.call
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$9/695495763@5d27ce3
[vm_2][info 2016/06/23 13:18:10.270 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest
[vm_2] from
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$9/695495763.call
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$9/695495763@5d27ce3
(took 0 ms)
[vm_0]distributed system properties: {name=m1, http-service-port=22519,
start-dev-rest-api=true, mcast-port=0, log-level=info,
http-service-bind-address=kuwait.gemstone.com, disable-auto-reconnect=true,
enable-cluster-configuration=false, locators=localhost[28169],
use-cluster-configuration=false}
[locator][info 2016/06/23 13:18:10.299 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received join request from kuwait(m1:17446)<ec>:1025
[locator][info 2016/06/23 13:18:10.600 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 1 requests for the next membership view
[locator][info 2016/06/23 13:18:10.600 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|34]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}]
[locator]failure detection ports: 51730 56379
[locator][info 2016/06/23 13:18:10.601 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[locator][info 2016/06/23 13:18:10.601 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|34]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|33] members:
[kuwait(17441:locator)<ec><v0>:1024] shutdown: [kuwait(17468)<ec><v32>:1027,
kuwait(17446)<ec><v30>:1025, kuwait(17451)<ec><v31>:1026]
[locator][info 2016/06/23 13:18:10.601 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|34] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead}]
[locator][info 2016/06/23 13:18:10.602 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|34] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead}]
[locator]failure detection ports: 51730 56379
[locator][info 2016/06/23 13:18:10.602 PDT <View Message Processor> tid=0x3f]
Membership: Processing addition < kuwait(m1:17446)<ec><v34>:1025 >
[locator][info 2016/06/23 13:18:10.603 PDT <View Message Processor> tid=0x3f]
Admitting member <kuwait(m1:17446)<ec><v34>:1025>. Now there are 2 non-admin
member(s).
[locator][info 2016/06/23 13:18:10.605 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member kuwait(m1:17446)<ec><v34>:1025 is equivalent or
in the same redundancy zone.
[vm_0]299.009: [GC (Allocation Failure) [PSYoungGen: 146117K->19570K(152064K)]
182214K->55675K(501760K), 0.0160803 secs] [Times: user=0.12 sys=0.00, real=0.02
secs]
[vm_1][info 2016/06/23 13:18:12.966 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedCallable.call
with 0 args on object: callable(createCacheAndRegisterFunction)
[vm_1]distributed system properties: {name=m2, http-service-port=24850,
start-dev-rest-api=true, mcast-port=0, log-level=info,
http-service-bind-address=kuwait.gemstone.com, disable-auto-reconnect=true,
enable-cluster-configuration=false, locators=localhost[28169],
use-cluster-configuration=false}
[vm_1][info 2016/06/23 13:18:12.975 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Startup Configuration:
[vm_1] ### GemFire Properties defined with api ###
[vm_1]disable-auto-reconnect=true
[vm_1]enable-cluster-configuration=false
[vm_1]http-service-bind-address=kuwait.gemstone.com
[vm_1]http-service-port=24850
[vm_1]locators=localhost[28169]
[vm_1]log-level=info
[vm_1]mcast-port=0
[vm_1]name=m2
[vm_1]start-dev-rest-api=true
[vm_1]use-cluster-configuration=false
[vm_1]### GemFire Properties using default values ###
[vm_1]ack-severe-alert-threshold=0
[vm_1]ack-wait-threshold=15
[vm_1]archive-disk-space-limit=0
[vm_1]archive-file-size-limit=0
[vm_1]async-distribution-timeout=0
[vm_1]async-max-queue-size=8
[vm_1]async-queue-timeout=60000
[vm_1]bind-address=
[vm_1]cache-xml-file=cache.xml
[vm_1]cluster-configuration-dir=
[vm_1]cluster-ssl-ciphers=any
[vm_1]cluster-ssl-enabled=false
[vm_1]cluster-ssl-keystore=
[vm_1]cluster-ssl-keystore-password=
[vm_1]cluster-ssl-keystore-type=
[vm_1]cluster-ssl-protocols=any
[vm_1]cluster-ssl-require-authentication=true
[vm_1]cluster-ssl-truststore=
[vm_1]cluster-ssl-truststore-password=
[vm_1]conflate-events=server
[vm_1]conserve-sockets=true
[vm_1]delta-propagation=true
[vm_1]deploy-working-dir=.
[vm_1]disable-tcp=false
[vm_1]distributed-system-id=-1
[vm_1]distributed-transactions=false
[vm_1]durable-client-id=
[vm_1]durable-client-timeout=300
[vm_1]enable-network-partition-detection=false
[vm_1]enable-time-statistics=false
[vm_1]enforce-unique-host=false
[vm_1]gateway-ssl-ciphers=any
[vm_1]gateway-ssl-enabled=false
[vm_1]gateway-ssl-keystore=
[vm_1]gateway-ssl-keystore-password=
[vm_1]gateway-ssl-keystore-type=
[vm_1]gateway-ssl-protocols=any
[vm_1]gateway-ssl-require-authentication=true
[vm_1]gateway-ssl-truststore=
[vm_1]gateway-ssl-truststore-password=
[vm_1]groups=
[vm_1]http-service-ssl-ciphers=any
[vm_1]http-service-ssl-enabled=false
[vm_1]http-service-ssl-keystore=
[vm_1]http-service-ssl-keystore-password=
[vm_1]http-service-ssl-keystore-type=
[vm_1]http-service-ssl-protocols=any
[vm_1]http-service-ssl-require-authentication=false
[vm_1]http-service-ssl-truststore=
[vm_1]http-service-ssl-truststore-password=
[vm_1]jmx-manager=false
[vm_1]jmx-manager-access-file=
[vm_1]jmx-manager-bind-address=
[vm_1]jmx-manager-hostname-for-clients=
[vm_1]jmx-manager-http-port=24850
[vm_1]jmx-manager-password-file=
[vm_1]jmx-manager-port=1099
[vm_1]jmx-manager-ssl=false
[vm_1]jmx-manager-ssl-ciphers=any
[vm_1]jmx-manager-ssl-enabled=false
[vm_1]jmx-manager-ssl-keystore=
[vm_1]jmx-manager-ssl-keystore-password=
[vm_1]jmx-manager-ssl-keystore-type=
[vm_1]jmx-manager-ssl-protocols=any
[vm_1]jmx-manager-ssl-require-authentication=true
[vm_1]jmx-manager-ssl-truststore=
[vm_1]jmx-manager-ssl-truststore-password=
[vm_1]jmx-manager-start=false
[vm_1]jmx-manager-update-rate=2000
[vm_1]load-cluster-configuration-from-dir=false
[vm_1]locator-wait-time=0
[vm_1]lock-memory=false
[vm_1]log-disk-space-limit=0
[vm_1]log-file=
[vm_1]log-file-size-limit=0
[vm_1]max-num-reconnect-tries=3
[vm_1]max-wait-time-reconnect=60000
[vm_1]mcast-address=239.192.81.1
[vm_1]mcast-flow-control=1048576, 0.25, 5000
[vm_1]mcast-recv-buffer-size=1048576
[vm_1]mcast-send-buffer-size=65535
[vm_1]mcast-ttl=32
[vm_1]member-timeout=5000
[vm_1]membership-port-range=1024-65535
[vm_1]memcached-bind-address=
[vm_1]memcached-port=0
[vm_1]memcached-protocol=ASCII
[vm_1]off-heap-memory-size=
[vm_1]redis-bind-address=
[vm_1]redis-password=
[vm_1]redis-port=0
[vm_1]redundancy-zone=
[vm_1]remote-locators=
[vm_1]remove-unresponsive-client=false
[vm_1]roles=
[vm_1]security-client-accessor=
[vm_1]security-client-accessor-pp=
[vm_1]security-client-auth-init=
[vm_1]security-client-authenticator=
[vm_1]security-client-dhalgo=
[vm_1]security-log-file=
[vm_1]security-log-level=config
[vm_1]security-peer-auth-init=
[vm_1]security-peer-authenticator=
[vm_1]security-peer-verifymember-timeout=1000
[vm_1]server-bind-address=
[vm_1]server-ssl-ciphers=any
[vm_1]server-ssl-enabled=false
[vm_1]server-ssl-keystore=
[vm_1]server-ssl-keystore-password=
[vm_1]server-ssl-keystore-type=
[vm_1]server-ssl-protocols=any
[vm_1]server-ssl-require-authentication=true
[vm_1]server-ssl-truststore=
[vm_1]server-ssl-truststore-password=
[vm_1]socket-buffer-size=32768
[vm_1]socket-lease-time=60000
[vm_1]ssl-ciphers=any
[vm_1]ssl-enabled=false
[vm_1]ssl-protocols=any
[vm_1]ssl-require-authentication=true
[vm_1]start-locator=
[vm_1]statistic-archive-file=
[vm_1]statistic-sample-rate=1000
[vm_1]statistic-sampling-enabled=true
[vm_1]tcp-port=0
[vm_1]udp-fragment-size=60000
[vm_1]udp-recv-buffer-size=1048576
[vm_1]udp-send-buffer-size=65535
[vm_1]user-command-packages=
[vm_1][info 2016/06/23 13:18:12.978 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Starting membership services
[vm_1][info 2016/06/23 13:18:12.990 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] JGroups channel created (took 12ms)
[vm_1][info 2016/06/23 13:18:12.992 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GemFire P2P Listener started on null
[vm_1][info 2016/06/23 13:18:12.992 PDT <Geode Failure Detection Server thread
0> tid=0x678] Started failure detection server thread on
kuwait.gemstone.com/10.118.32.93:63430.
[vm_1][info 2016/06/23 13:18:12.994 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to join the distributed system through coordinator
kuwait(17441:locator)<ec><v0>:1024 using address kuwait(m2:17451)<ec>:1026
[locator][info 2016/06/23 13:18:12.994 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received join request from kuwait(m2:17451)<ec>:1026
[locator][info 2016/06/23 13:18:13.295 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 1 requests for the next membership view
[locator][info 2016/06/23 13:18:13.295 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|35]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026]
[locator]failure detection ports: 51730 56379 63430
[vm_1][info 2016/06/23 13:18:13.296 PDT <unicast receiver,kuwait-63314>
tid=0x674] received new view: View[kuwait(17441:locator)<ec><v0>:1024|35]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026]
[vm_1]old view is: null
[locator][info 2016/06/23 13:18:13.297 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[locator][info 2016/06/23 13:18:13.297 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|35]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|34] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead}]
[locator][info 2016/06/23 13:18:13.297 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|35] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026]
[locator][info 2016/06/23 13:18:13.297 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|35] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026]
[locator]failure detection ports: 51730 56379 63430
[vm_1][info 2016/06/23 13:18:13.297 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Finished joining (took 305ms).
[vm_1][info 2016/06/23 13:18:13.297 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Starting DistributionManager kuwait(m2:17451)<ec><v35>:1026. (took
320 ms)
[locator][info 2016/06/23 13:18:13.297 PDT <View Message Processor> tid=0x3f]
Membership: Processing addition < kuwait(m2:17451)<ec><v35>:1026 >
[vm_1][info 2016/06/23 13:18:13.298 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initial (distribution manager) view =
View[kuwait(17441:locator)<ec><v0>:1024|35] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026]
[vm_1][info 2016/06/23 13:18:13.298 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(17441:locator)<ec><v0>:1024>. Now there are
1 non-admin member(s).
[locator][info 2016/06/23 13:18:13.298 PDT <View Message Processor> tid=0x3f]
Admitting member <kuwait(m2:17451)<ec><v35>:1026>. Now there are 3 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:13.298 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m1:17446)<ec><v34>:1025>. Now there are 2
non-admin member(s).
[vm_1][info 2016/06/23 13:18:13.298 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m2:17451)<ec><v35>:1026>. Now there are 3
non-admin member(s).
[locator][info 2016/06/23 13:18:13.302 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member kuwait(m2:17451)<ec><v35>:1026 is equivalent or
in the same redundancy zone.
[vm_1][info 2016/06/23 13:18:13.305 PDT <P2P message reader for
kuwait(m1:17446)<ec><v34>:1025 shared unordered uid=80 port=54445> tid=0x681]
Member kuwait(m1:17446)<ec><v34>:1025 is equivalent or in the same redundancy
zone.
[vm_1][info 2016/06/23 13:18:13.305 PDT <P2P message reader for
kuwait(17441:locator)<ec><v0>:1024 shared unordered uid=27 port=54444>
tid=0x67f] Member kuwait(17441:locator)<ec><v0>:1024 is equivalent or in the
same redundancy zone.
[vm_1][info 2016/06/23 13:18:13.323 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region _monitoringRegion_10.118.32.93<v35>1026
[vm_1][info 2016/06/23 13:18:13.324 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region _monitoringRegion_10.118.32.93<v35>1026
completed
[vm_1][info 2016/06/23 13:18:13.334 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] The cache has been created with "use-cluster-configuration=false". It
will not receive any cluster configuration
[vm_1][info 2016/06/23 13:18:13.335 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region PdxTypes
[vm_1][info 2016/06/23 13:18:13.339 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Region PdxTypes requesting initial image from
kuwait(m1:17446)<ec><v34>:1025
[vm_1][info 2016/06/23 13:18:13.339 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] PdxTypes is done getting image from kuwait(m1:17446)<ec><v34>:1025.
isDeltaGII is false
[vm_1][info 2016/06/23 13:18:13.340 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region PdxTypes completed
[vm_1][info 2016/06/23 13:18:13.340 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to start HTTP service on port (24850) at bind-address
(kuwait.gemstone.com)...
[vm_1][info 2016/06/23 13:18:13.340 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GEMFIRE
HOME:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode
[vm_1][info 2016/06/23 13:18:13.341 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] geode-web-api war found:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war
[vm_1][info 2016/06/23 13:18:13.341 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] jetty-9.3.6.v20151106
[vm_1][info 2016/06/23 13:18:13.989 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] NO JSP Support for /gemfire-api, did not find
org.eclipse.jetty.jsp.JettyJspServlet
[vm_1]301.180: [GC (Allocation Failure) [PSYoungGen: 155117K->5748K(159232K)]
252198K->104599K(468992K), 0.0129939 secs] [Times: user=0.09 sys=0.00,
real=0.01 secs]
[vm_1][info 2016/06/23 13:18:14.358 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing Spring FrameworkServlet 'gemfire-api'
[vm_1][info 2016/06/23 13:18:14.358 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] FrameworkServlet 'gemfire-api': initialization started
[vm_1][info 2016/06/23 13:18:14.371 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Refreshing WebApplicationContext for namespace 'gemfire-api-servlet':
startup date [Thu Jun 23 13:18:14 PDT 2016]; root of context hierarchy
[vm_1][info 2016/06/23 13:18:14.398 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Loading XML bean definitions from ServletContext resource
[/WEB-INF/gemfire-api-servlet.xml]
[vm_1][info 2016/06/23 13:18:14.601 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Overriding bean definition for bean 'swaggerCache' with a different
definition: replacing [Generic bean: class
[com.mangofactory.swagger.core.SwaggerCache]; scope=singleton; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in URL
[jar:file:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest/dunit/vm1/GemFire_build/services/http/kuwait.gemstone.com_24850_gemfire-api/webapp/WEB-INF/lib/swagger-springmvc-0.8.2.jar!/com/mangofactory/swagger/core/SwaggerCache.class]]
with [Root bean: class [null]; scope=; abstract=false; lazyInit=false;
autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false;
factoryBeanName=springSwaggerConfig; factoryMethodName=swaggerCache;
initMethodName=null; destroyMethodName=(inferred); defined in class path
resource [com/mangofactory/swagger/configuration/SpringSwaggerConfig.class]]
[vm_1][info 2016/06/23 13:18:14.799 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/functions/{functionId}],methods=[POST],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.FunctionAccessController.execute(java.lang.String,java.lang.String,java.lang.String[],java.lang.String[],java.lang.String[],java.lang.String)
[vm_1][info 2016/06/23 13:18:14.799 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/functions],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.FunctionAccessController.list()
[vm_1][info 2016/06/23 13:18:14.806 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[PUT],consumes=[application/json],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.update(java.lang.String,java.lang.String[],java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.806 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[HEAD],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.size(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.806 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.read(java.lang.String,java.lang.String[],java.lang.String)
[vm_1][info 2016/06/23 13:18:14.806 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.read(java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.807 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}],methods=[POST],consumes=[application/json],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.create(java.lang.String,java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.807 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/servers],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.servers()
[vm_1][info 2016/06/23 13:18:14.807 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1],methods=[GET],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.regions()
[vm_1][info 2016/06/23 13:18:14.807 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/ping],methods=[GET || HEAD]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.ping()
[vm_1][info 2016/06/23 13:18:14.807 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[DELETE],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.delete(java.lang.String,java.lang.String[])
[vm_1][info 2016/06/23 13:18:14.808 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[DELETE]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.delete(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.808 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/keys],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.keys(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.809 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/queries/adhoc],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.runAdhocQuery(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.810 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/queries/{query}],methods=[POST],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.runNamedQuery(java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.810 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries/{query}],methods=[PUT]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.update(java.lang.String,java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.810 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries/{query}],methods=[DELETE]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.delete(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.810 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries],methods=[POST]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.create(java.lang.String,java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.810 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.list()
[vm_1][info 2016/06/23 13:18:14.814 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs/{resourceKey}],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ResourceListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getResourceListing(java.lang.String)
[vm_1][info 2016/06/23 13:18:14.815 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs/{resourceKey}/{resource}],methods=[GET]}" onto
public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ApiListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getApiListing(java.lang.String,java.lang.String)
[vm_1][info 2016/06/23 13:18:14.815 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ResourceListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getResourceListingByKey()
[vm_1][info 2016/06/23 13:18:14.876 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Looking for @ControllerAdvice: WebApplicationContext for namespace
'gemfire-api-servlet': startup date [Thu Jun 23 13:18:14 PDT 2016]; root of
context hierarchy
[vm_1][info 2016/06/23 13:18:14.915 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Looking for @ControllerAdvice: WebApplicationContext for namespace
'gemfire-api-servlet': startup date [Thu Jun 23 13:18:14 PDT 2016]; root of
context hierarchy
[vm_1][info 2016/06/23 13:18:14.936 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Detected @ExceptionHandler methods in baseControllerAdvice
[vm_1][info 2016/06/23 13:18:14.958 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped URL path [/**] onto handler
'org.springframework.web.servlet.resource.DefaultServletHttpRequestHandler#0'
[vm_1][info 2016/06/23 13:18:15.226 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Scanning for api listing references
[vm_1][info 2016/06/23 13:18:15.227 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group functions for handler method: execute
[vm_1][info 2016/06/23 13:18:15.227 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group functions for handler method: list
[vm_1][info 2016/06/23 13:18:15.227 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: update
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: size
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: read
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: read
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: create
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: servers
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: regions
[vm_1][info 2016/06/23 13:18:15.228 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: ping
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: delete
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: delete
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: keys
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: runAdhocQuery
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: runNamedQuery
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: update
[vm_1][info 2016/06/23 13:18:15.229 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: delete
[vm_1][info 2016/06/23 13:18:15.230 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: create
[vm_1][info 2016/06/23 13:18:15.230 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: list
[vm_1][info 2016/06/23 13:18:15.230 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_1][info 2016/06/23 13:18:15.230 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_1][info 2016/06/23 13:18:15.230 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_1][info 2016/06/23 13:18:15.243 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:24850/gemfire-api/api-docs/gemfireApi/functions
Description: functions Position: 0
[vm_1][info 2016/06/23 13:18:15.244 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:24850/gemfire-api/api-docs/gemfireApi/queries
Description: queries Position: 1
[vm_1][info 2016/06/23 13:18:15.244 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:24850/gemfire-api/api-docs/gemfireApi/region
Description: region Position: 2
[vm_1]302.572: [GC (Allocation Failure) [PSYoungGen: 149620K->12812K(157184K)]
248471K->113888K(466944K), 0.0165531 secs] [Times: user=0.11 sys=0.00,
real=0.02 secs]
[vm_1][info 2016/06/23 13:18:15.911 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] FrameworkServlet 'gemfire-api': initialization completed in 1553 ms
[vm_1][info 2016/06/23 13:18:15.911 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started
o.e.j.w.WebAppContext@683eff6e{/gemfire-api,file:///kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest/dunit/vm1/GemFire_build/services/http/kuwait.gemstone.com_24850_gemfire-api/webapp/,AVAILABLE}{/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war}
[vm_1][info 2016/06/23 13:18:15.912 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started
ServerConnector@6c2a12c5{HTTP/1.1,[http/1.1]}{kuwait.gemstone.com:24850}
[vm_1][info 2016/06/23 13:18:15.913 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started @302998ms
[vm_1][info 2016/06/23 13:18:15.913 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] HTTP service started successfully...!!
[vm_1][info 2016/06/23 13:18:15.914 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region __ParameterizedQueries__
[vm_1][info 2016/06/23 13:18:15.916 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Region __ParameterizedQueries__ requesting initial image from
kuwait(m1:17446)<ec><v34>:1025
[vm_1][info 2016/06/23 13:18:15.917 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] __ParameterizedQueries__ is done getting image from
kuwait(m1:17446)<ec><v34>:1025. isDeltaGII is false
[vm_1][info 2016/06/23 13:18:15.917 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region __ParameterizedQueries__ completed
[vm_1][info 2016/06/23 13:18:15.918 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: http://kuwait.gemstone.com:24850/gemfire-api/v1
[vm_1] from com.gemstone.gemfire.test.dunit.NamedCallable.call with 0 args on
object: callable(createCacheAndRegisterFunction) (took 2950 ms)
[vm_2][info 2016/06/23 13:18:15.925 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedCallable.call
with 0 args on object: callable(createCacheAndRegisterFunction)
[vm_2]distributed system properties: {name=m3, http-service-port=27072,
start-dev-rest-api=true, mcast-port=0, log-level=info,
http-service-bind-address=kuwait.gemstone.com, disable-auto-reconnect=true,
enable-cluster-configuration=false, locators=localhost[28169],
use-cluster-configuration=false}
[vm_2][info 2016/06/23 13:18:15.930 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Startup Configuration:
[vm_2] ### GemFire Properties defined with api ###
[vm_2]disable-auto-reconnect=true
[vm_2]enable-cluster-configuration=false
[vm_2]http-service-bind-address=kuwait.gemstone.com
[vm_2]http-service-port=27072
[vm_2]locators=localhost[28169]
[vm_2]log-level=info
[vm_2]mcast-port=0
[vm_2]name=m3
[vm_2]start-dev-rest-api=true
[vm_2]use-cluster-configuration=false
[vm_2]### GemFire Properties using default values ###
[vm_2]ack-severe-alert-threshold=0
[vm_2]ack-wait-threshold=15
[vm_2]archive-disk-space-limit=0
[vm_2]archive-file-size-limit=0
[vm_2]async-distribution-timeout=0
[vm_2]async-max-queue-size=8
[vm_2]async-queue-timeout=60000
[vm_2]bind-address=
[vm_2]cache-xml-file=cache.xml
[vm_2]cluster-configuration-dir=
[vm_2]cluster-ssl-ciphers=any
[vm_2]cluster-ssl-enabled=false
[vm_2]cluster-ssl-keystore=
[vm_2]cluster-ssl-keystore-password=
[vm_2]cluster-ssl-keystore-type=
[vm_2]cluster-ssl-protocols=any
[vm_2]cluster-ssl-require-authentication=true
[vm_2]cluster-ssl-truststore=
[vm_2]cluster-ssl-truststore-password=
[vm_2]conflate-events=server
[vm_2]conserve-sockets=true
[vm_2]delta-propagation=true
[vm_2]deploy-working-dir=.
[vm_2]disable-tcp=false
[vm_2]distributed-system-id=-1
[vm_2]distributed-transactions=false
[vm_2]durable-client-id=
[vm_2]durable-client-timeout=300
[vm_2]enable-network-partition-detection=false
[vm_2]enable-time-statistics=false
[vm_2]enforce-unique-host=false
[vm_2]gateway-ssl-ciphers=any
[vm_2]gateway-ssl-enabled=false
[vm_2]gateway-ssl-keystore=
[vm_2]gateway-ssl-keystore-password=
[vm_2]gateway-ssl-keystore-type=
[vm_2]gateway-ssl-protocols=any
[vm_2]gateway-ssl-require-authentication=true
[vm_2]gateway-ssl-truststore=
[vm_2]gateway-ssl-truststore-password=
[vm_2]groups=
[vm_2]http-service-ssl-ciphers=any
[vm_2]http-service-ssl-enabled=false
[vm_2]http-service-ssl-keystore=
[vm_2]http-service-ssl-keystore-password=
[vm_2]http-service-ssl-keystore-type=
[vm_2]http-service-ssl-protocols=any
[vm_2]http-service-ssl-require-authentication=false
[vm_2]http-service-ssl-truststore=
[vm_2]http-service-ssl-truststore-password=
[vm_2]jmx-manager=false
[vm_2]jmx-manager-access-file=
[vm_2]jmx-manager-bind-address=
[vm_2]jmx-manager-hostname-for-clients=
[vm_2]jmx-manager-http-port=27072
[vm_2]jmx-manager-password-file=
[vm_2]jmx-manager-port=1099
[vm_2]jmx-manager-ssl=false
[vm_2]jmx-manager-ssl-ciphers=any
[vm_2]jmx-manager-ssl-enabled=false
[vm_2]jmx-manager-ssl-keystore=
[vm_2]jmx-manager-ssl-keystore-password=
[vm_2]jmx-manager-ssl-keystore-type=
[vm_2]jmx-manager-ssl-protocols=any
[vm_2]jmx-manager-ssl-require-authentication=true
[vm_2]jmx-manager-ssl-truststore=
[vm_2]jmx-manager-ssl-truststore-password=
[vm_2]jmx-manager-start=false
[vm_2]jmx-manager-update-rate=2000
[vm_2]load-cluster-configuration-from-dir=false
[vm_2]locator-wait-time=0
[vm_2]lock-memory=false
[vm_2]log-disk-space-limit=0
[vm_2]log-file=
[vm_2]log-file-size-limit=0
[vm_2]max-num-reconnect-tries=3
[vm_2]max-wait-time-reconnect=60000
[vm_2]mcast-address=239.192.81.1
[vm_2]mcast-flow-control=1048576, 0.25, 5000
[vm_2]mcast-recv-buffer-size=1048576
[vm_2]mcast-send-buffer-size=65535
[vm_2]mcast-ttl=32
[vm_2]member-timeout=5000
[vm_2]membership-port-range=1024-65535
[vm_2]memcached-bind-address=
[vm_2]memcached-port=0
[vm_2]memcached-protocol=ASCII
[vm_2]off-heap-memory-size=
[vm_2]redis-bind-address=
[vm_2]redis-password=
[vm_2]redis-port=0
[vm_2]redundancy-zone=
[vm_2]remote-locators=
[vm_2]remove-unresponsive-client=false
[vm_2]roles=
[vm_2]security-client-accessor=
[vm_2]security-client-accessor-pp=
[vm_2]security-client-auth-init=
[vm_2]security-client-authenticator=
[vm_2]security-client-dhalgo=
[vm_2]security-log-file=
[vm_2]security-log-level=config
[vm_2]security-peer-auth-init=
[vm_2]security-peer-authenticator=
[vm_2]security-peer-verifymember-timeout=1000
[vm_2]server-bind-address=
[vm_2]server-ssl-ciphers=any
[vm_2]server-ssl-enabled=false
[vm_2]server-ssl-keystore=
[vm_2]server-ssl-keystore-password=
[vm_2]server-ssl-keystore-type=
[vm_2]server-ssl-protocols=any
[vm_2]server-ssl-require-authentication=true
[vm_2]server-ssl-truststore=
[vm_2]server-ssl-truststore-password=
[vm_2]socket-buffer-size=32768
[vm_2]socket-lease-time=60000
[vm_2]ssl-ciphers=any
[vm_2]ssl-enabled=false
[vm_2]ssl-protocols=any
[vm_2]ssl-require-authentication=true
[vm_2]start-locator=
[vm_2]statistic-archive-file=
[vm_2]statistic-sample-rate=1000
[vm_2]statistic-sampling-enabled=true
[vm_2]tcp-port=0
[vm_2]udp-fragment-size=60000
[vm_2]udp-recv-buffer-size=1048576
[vm_2]udp-send-buffer-size=65535
[vm_2]user-command-packages=
[vm_2][info 2016/06/23 13:18:15.933 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Starting membership services
[vm_2][info 2016/06/23 13:18:15.943 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] JGroups channel created (took 10ms)
[vm_2][info 2016/06/23 13:18:15.944 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GemFire P2P Listener started on null
[vm_2][info 2016/06/23 13:18:15.945 PDT <Geode Failure Detection Server thread
0> tid=0x5df] Started failure detection server thread on
kuwait.gemstone.com/10.118.32.93:47952.
[vm_2][info 2016/06/23 13:18:15.946 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to join the distributed system through coordinator
kuwait(17441:locator)<ec><v0>:1024 using address kuwait(m3:17468)<ec>:1027
[locator][info 2016/06/23 13:18:15.947 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received join request from kuwait(m3:17468)<ec>:1027
[locator][info 2016/06/23 13:18:16.248 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 1 requests for the next membership view
[locator][info 2016/06/23 13:18:16.248 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|36]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026,
kuwait(m3:17468)<ec><v36>:1027]
[locator]failure detection ports: 51730 56379 63430 47952
[vm_2][info 2016/06/23 13:18:16.249 PDT <unicast receiver,kuwait-14199>
tid=0x5db] received new view: View[kuwait(17441:locator)<ec><v0>:1024|36]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026,
kuwait(m3:17468)<ec><v36>:1027]
[vm_2]old view is: null
[locator][info 2016/06/23 13:18:16.249 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[vm_2][info 2016/06/23 13:18:16.249 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Finished joining (took 304ms).
[vm_2][info 2016/06/23 13:18:16.249 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Starting DistributionManager kuwait(m3:17468)<ec><v36>:1027. (took
317 ms)
[locator][info 2016/06/23 13:18:16.249 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|36]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026,
kuwait(m3:17468)<ec><v36>:1027]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|35] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026]
[locator][info 2016/06/23 13:18:16.249 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|36] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026, kuwait(m3:17468)<ec><v36>:1027]
[vm_2][info 2016/06/23 13:18:16.249 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initial (distribution manager) view =
View[kuwait(17441:locator)<ec><v0>:1024|36] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026, kuwait(m3:17468)<ec><v36>:1027]
[locator][info 2016/06/23 13:18:16.250 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|36] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026, kuwait(m3:17468)<ec><v36>:1027]
[locator]failure detection ports: 51730 56379 63430 47952
[vm_2][info 2016/06/23 13:18:16.250 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(17441:locator)<ec><v0>:1024>. Now there are
1 non-admin member(s).
[vm_1][info 2016/06/23 13:18:16.250 PDT <unicast receiver,kuwait-63314>
tid=0x674] received new view: View[kuwait(17441:locator)<ec><v0>:1024|36]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v34>:1025{lead}, kuwait(m2:17451)<ec><v35>:1026,
kuwait(m3:17468)<ec><v36>:1027]
[vm_1]old view is: View[kuwait(17441:locator)<ec><v0>:1024|35] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v34>:1025{lead},
kuwait(m2:17451)<ec><v35>:1026]
[locator][info 2016/06/23 13:18:16.250 PDT <View Message Processor> tid=0x3f]
Membership: Processing addition < kuwait(m3:17468)<ec><v36>:1027 >
[locator][info 2016/06/23 13:18:16.250 PDT <View Message Processor> tid=0x3f]
Admitting member <kuwait(m3:17468)<ec><v36>:1027>. Now there are 4 non-admin
member(s).
[vm_2][info 2016/06/23 13:18:16.250 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m1:17446)<ec><v34>:1025>. Now there are 2
non-admin member(s).
[vm_2][info 2016/06/23 13:18:16.250 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m2:17451)<ec><v35>:1026>. Now there are 3
non-admin member(s).
[vm_2][info 2016/06/23 13:18:16.250 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m3:17468)<ec><v36>:1027>. Now there are 4
non-admin member(s).
[vm_1][info 2016/06/23 13:18:16.251 PDT <View Message Processor> tid=0x69b]
Membership: Processing addition < kuwait(m3:17468)<ec><v36>:1027 >
[vm_1][info 2016/06/23 13:18:16.251 PDT <View Message Processor> tid=0x69b]
Admitting member <kuwait(m3:17468)<ec><v36>:1027>. Now there are 4 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:16.254 PDT <Pooled High Priority Message Processor
1> tid=0x68c] Member kuwait(m3:17468)<ec><v36>:1027 is equivalent or in the
same redundancy zone.
[locator][info 2016/06/23 13:18:16.254 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member kuwait(m3:17468)<ec><v36>:1027 is equivalent or
in the same redundancy zone.
[vm_2][info 2016/06/23 13:18:16.257 PDT <P2P message reader for
kuwait(m2:17451)<ec><v35>:1026 shared unordered uid=92 port=40489> tid=0x5e8]
Member kuwait(m2:17451)<ec><v35>:1026 is equivalent or in the same redundancy
zone.
[vm_2][info 2016/06/23 13:18:16.258 PDT <P2P message reader for
kuwait(17441:locator)<ec><v0>:1024 shared unordered uid=28 port=40490>
tid=0x5e9] Member kuwait(17441:locator)<ec><v0>:1024 is equivalent or in the
same redundancy zone.
[vm_2][info 2016/06/23 13:18:16.258 PDT <P2P message reader for
kuwait(m1:17446)<ec><v34>:1025 shared unordered uid=81 port=40491> tid=0x5eb]
Member kuwait(m1:17446)<ec><v34>:1025 is equivalent or in the same redundancy
zone.
[vm_2][info 2016/06/23 13:18:16.269 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region _monitoringRegion_10.118.32.93<v36>1027
[vm_2][info 2016/06/23 13:18:16.270 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region _monitoringRegion_10.118.32.93<v36>1027
completed
[vm_2][info 2016/06/23 13:18:16.274 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] The cache has been created with "use-cluster-configuration=false". It
will not receive any cluster configuration
[vm_2][info 2016/06/23 13:18:16.275 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region PdxTypes
[vm_2][info 2016/06/23 13:18:16.279 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Region PdxTypes requesting initial image from
kuwait(m1:17446)<ec><v34>:1025
[vm_2][info 2016/06/23 13:18:16.280 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] PdxTypes is done getting image from kuwait(m1:17446)<ec><v34>:1025.
isDeltaGII is false
[vm_2][info 2016/06/23 13:18:16.280 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region PdxTypes completed
[vm_2][info 2016/06/23 13:18:16.281 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to start HTTP service on port (27072) at bind-address
(kuwait.gemstone.com)...
[vm_2][info 2016/06/23 13:18:16.281 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GEMFIRE
HOME:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode
[vm_2][info 2016/06/23 13:18:16.281 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] geode-web-api war found:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war
[vm_2][info 2016/06/23 13:18:16.282 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] jetty-9.3.6.v20151106
[vm_2]303.646: [GC (GCLocker Initiated GC) [PSYoungGen:
126983K->18310K(139264K)] 191001K->85461K(488960K), 0.0214982 secs] [Times:
user=0.15 sys=0.01, real=0.02 secs]
[vm_2][info 2016/06/23 13:18:16.954 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] NO JSP Support for /gemfire-api, did not find
org.eclipse.jetty.jsp.JettyJspServlet
[vm_2][info 2016/06/23 13:18:17.255 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing Spring FrameworkServlet 'gemfire-api'
[vm_2][info 2016/06/23 13:18:17.256 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] FrameworkServlet 'gemfire-api': initialization started
[vm_2][info 2016/06/23 13:18:17.270 PDT <RMI TCP Connection(
...[truncated 169032 chars]...
tid=0x1c] JGroups channel created (took 9ms)
[vm_2][info 2016/06/23 13:18:41.138 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GemFire P2P Listener started on null
[vm_2][info 2016/06/23 13:18:41.139 PDT <Geode Failure Detection Server thread
0> tid=0x682] Started failure detection server thread on
kuwait.gemstone.com/10.118.32.93:47406.
[vm_2][info 2016/06/23 13:18:41.140 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to join the distributed system through coordinator
kuwait(17441:locator)<ec><v0>:1024 using address kuwait(m3:17468)<ec>:1027
[locator][info 2016/06/23 13:18:41.141 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received join request from kuwait(m3:17468)<ec>:1027
[locator][info 2016/06/23 13:18:41.441 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 1 requests for the next membership view
[locator][info 2016/06/23 13:18:41.442 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|46]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027]
[locator]failure detection ports: 51730 56853 61867 47406
[vm_2][info 2016/06/23 13:18:41.443 PDT <unicast receiver,kuwait-51833>
tid=0x67e] received new view: View[kuwait(17441:locator)<ec><v0>:1024|46]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027]
[vm_2]old view is: null
[locator][info 2016/06/23 13:18:41.443 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[locator][info 2016/06/23 13:18:41.443 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|46]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|45] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026]
[locator][info 2016/06/23 13:18:41.443 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[vm_2][info 2016/06/23 13:18:41.443 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Finished joining (took 304ms).
[vm_2][info 2016/06/23 13:18:41.443 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Starting DistributionManager kuwait(m3:17468)<ec><v46>:1027. (took
315 ms)
[vm_2][info 2016/06/23 13:18:41.444 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initial (distribution manager) view =
View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[locator][info 2016/06/23 13:18:41.444 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[locator]failure detection ports: 51730 56853 61867 47406
[vm_2][info 2016/06/23 13:18:41.444 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(17441:locator)<ec><v0>:1024>. Now there are
1 non-admin member(s).
[locator][info 2016/06/23 13:18:41.444 PDT <View Message Processor> tid=0x3f]
Membership: Processing addition < kuwait(m3:17468)<ec><v46>:1027 >
[vm_2][info 2016/06/23 13:18:41.444 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m1:17446)<ec><v44>:1025>. Now there are 2
non-admin member(s).
[vm_2][info 2016/06/23 13:18:41.444 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m2:17451)<ec><v45>:1026>. Now there are 3
non-admin member(s).
[vm_2][info 2016/06/23 13:18:41.444 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Admitting member <kuwait(m3:17468)<ec><v46>:1027>. Now there are 4
non-admin member(s).
[vm_1][info 2016/06/23 13:18:41.444 PDT <unicast receiver,kuwait-22527>
tid=0x711] received new view: View[kuwait(17441:locator)<ec><v0>:1024|46]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027]
[vm_1]old view is: View[kuwait(17441:locator)<ec><v0>:1024|45] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026]
[locator][info 2016/06/23 13:18:41.444 PDT <View Message Processor> tid=0x3f]
Admitting member <kuwait(m3:17468)<ec><v46>:1027>. Now there are 4 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:41.445 PDT <View Message Processor> tid=0x737]
Membership: Processing addition < kuwait(m3:17468)<ec><v46>:1027 >
[vm_1][info 2016/06/23 13:18:41.445 PDT <View Message Processor> tid=0x737]
Admitting member <kuwait(m3:17468)<ec><v46>:1027>. Now there are 4 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:41.448 PDT <Pooled High Priority Message Processor
2> tid=0x729] Member kuwait(m3:17468)<ec><v46>:1027 is equivalent or in the
same redundancy zone.
[locator][info 2016/06/23 13:18:41.448 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member kuwait(m3:17468)<ec><v46>:1027 is equivalent or
in the same redundancy zone.
[vm_2][info 2016/06/23 13:18:41.450 PDT <P2P message reader for
kuwait(m2:17451)<ec><v45>:1026 shared unordered uid=106 port=33449> tid=0x68c]
Member kuwait(m2:17451)<ec><v45>:1026 is equivalent or in the same redundancy
zone.
[vm_2][info 2016/06/23 13:18:41.450 PDT <P2P message reader for
kuwait(m1:17446)<ec><v44>:1025 shared unordered uid=95 port=33448> tid=0x68b]
Member kuwait(m1:17446)<ec><v44>:1025 is equivalent or in the same redundancy
zone.
[vm_2][info 2016/06/23 13:18:41.450 PDT <P2P message reader for
kuwait(17441:locator)<ec><v0>:1024 shared unordered uid=36 port=33450>
tid=0x68d] Member kuwait(17441:locator)<ec><v0>:1024 is equivalent or in the
same redundancy zone.
[vm_2]328.539: [GC (Allocation Failure) [PSYoungGen: 119013K->10087K(118272K)]
198354K->89436K(467968K), 0.0137014 secs] [Times: user=0.11 sys=0.00, real=0.01
secs]
[vm_2][info 2016/06/23 13:18:41.485 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region _monitoringRegion_10.118.32.93<v46>1027
[vm_2][info 2016/06/23 13:18:41.649 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region _monitoringRegion_10.118.32.93<v46>1027
completed
[vm_2][info 2016/06/23 13:18:41.654 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] The cache has been created with "use-cluster-configuration=false". It
will not receive any cluster configuration
[vm_2][info 2016/06/23 13:18:41.655 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region PdxTypes
[vm_2][info 2016/06/23 13:18:41.660 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Region PdxTypes requesting initial image from
kuwait(m1:17446)<ec><v44>:1025
[vm_2][info 2016/06/23 13:18:41.661 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] PdxTypes is done getting image from kuwait(m1:17446)<ec><v44>:1025.
isDeltaGII is false
[vm_2][info 2016/06/23 13:18:41.662 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region PdxTypes completed
[vm_2][info 2016/06/23 13:18:41.662 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Attempting to start HTTP service on port (20035) at bind-address
(kuwait.gemstone.com)...
[vm_2][info 2016/06/23 13:18:41.663 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GEMFIRE
HOME:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode
[vm_2][info 2016/06/23 13:18:41.663 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] geode-web-api war found:
/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war
[vm_2][info 2016/06/23 13:18:41.664 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] jetty-9.3.6.v20151106
[vm_2][info 2016/06/23 13:18:42.298 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] NO JSP Support for /gemfire-api, did not find
org.eclipse.jetty.jsp.JettyJspServlet
[vm_2][info 2016/06/23 13:18:42.455 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing Spring FrameworkServlet 'gemfire-api'
[vm_2][info 2016/06/23 13:18:42.455 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] FrameworkServlet 'gemfire-api': initialization started
[vm_2][info 2016/06/23 13:18:42.469 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Refreshing WebApplicationContext for namespace 'gemfire-api-servlet':
startup date [Thu Jun 23 13:18:42 PDT 2016]; root of context hierarchy
[vm_2][info 2016/06/23 13:18:42.496 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Loading XML bean definitions from ServletContext resource
[/WEB-INF/gemfire-api-servlet.xml]
[vm_2][info 2016/06/23 13:18:42.716 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Overriding bean definition for bean 'swaggerCache' with a different
definition: replacing [Generic bean: class
[com.mangofactory.swagger.core.SwaggerCache]; scope=singleton; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in URL
[jar:file:/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest/dunit/vm2/GemFire_build/services/http/kuwait.gemstone.com_20035_gemfire-api/webapp/WEB-INF/lib/swagger-springmvc-0.8.2.jar!/com/mangofactory/swagger/core/SwaggerCache.class]]
with [Root bean: class [null]; scope=; abstract=false; lazyInit=false;
autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false;
factoryBeanName=springSwaggerConfig; factoryMethodName=swaggerCache;
initMethodName=null; destroyMethodName=(inferred); defined in class path
resource [com/mangofactory/swagger/configuration/SpringSwaggerConfig.class]]
[vm_2][info 2016/06/23 13:18:42.915 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/functions/{functionId}],methods=[POST],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.FunctionAccessController.execute(java.lang.String,java.lang.String,java.lang.String[],java.lang.String[],java.lang.String[],java.lang.String)
[vm_2][info 2016/06/23 13:18:42.916 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/functions],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.FunctionAccessController.list()
[vm_2][info 2016/06/23 13:18:42.922 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[PUT],consumes=[application/json],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.update(java.lang.String,java.lang.String[],java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.922 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[HEAD],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.size(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.923 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.read(java.lang.String,java.lang.String[],java.lang.String)
[vm_2][info 2016/06/23 13:18:42.923 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.read(java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.923 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}],methods=[POST],consumes=[application/json],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.PdxBasedCrudController.create(java.lang.String,java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.923 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/servers],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.servers()
[vm_2][info 2016/06/23 13:18:42.923 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1],methods=[GET],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.regions()
[vm_2][info 2016/06/23 13:18:42.924 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/ping],methods=[GET || HEAD]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.ping()
[vm_2][info 2016/06/23 13:18:42.924 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/{keys}],methods=[DELETE],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.delete(java.lang.String,java.lang.String[])
[vm_2][info 2016/06/23 13:18:42.924 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/{region}],methods=[DELETE]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.delete(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.924 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/{region}/keys],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.CommonCrudController.keys(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.926 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/queries/{query}],methods=[POST],produces=[application/json]}" onto
public org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.runNamedQuery(java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.926 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped
"{[/v1/queries/adhoc],methods=[GET],produces=[application/json]}" onto public
org.springframework.http.ResponseEntity<java.lang.String>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.runAdhocQuery(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.926 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries/{query}],methods=[PUT]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.update(java.lang.String,java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.926 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries/{query}],methods=[DELETE]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.delete(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.926 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries],methods=[POST]}" onto public
org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.create(java.lang.String,java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.927 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/v1/queries],methods=[GET],produces=[application/json]}"
onto public org.springframework.http.ResponseEntity<?>
com.gemstone.gemfire.rest.internal.web.controllers.QueryAccessController.list()
[vm_2][info 2016/06/23 13:18:42.930 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs/{resourceKey}],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ResourceListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getResourceListing(java.lang.String)
[vm_2][info 2016/06/23 13:18:42.931 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs/{resourceKey}/{resource}],methods=[GET]}" onto
public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ApiListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getApiListing(java.lang.String,java.lang.String)
[vm_2][info 2016/06/23 13:18:42.931 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped "{[/api-docs],methods=[GET]}" onto public
org.springframework.http.ResponseEntity<com.wordnik.swagger.model.ResourceListing>
com.mangofactory.swagger.controllers.DefaultSwaggerController.getResourceListingByKey()
[vm_2]330.055: [GC (Allocation Failure) [PSYoungGen: 118119K->12738K(141312K)]
197468K->93172K(491008K), 0.0154752 secs] [Times: user=0.09 sys=0.00, real=0.01
secs]
[vm_2][info 2016/06/23 13:18:43.202 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Looking for @ControllerAdvice: WebApplicationContext for namespace
'gemfire-api-servlet': startup date [Thu Jun 23 13:18:42 PDT 2016]; root of
context hierarchy
[vm_2][info 2016/06/23 13:18:43.243 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Looking for @ControllerAdvice: WebApplicationContext for namespace
'gemfire-api-servlet': startup date [Thu Jun 23 13:18:42 PDT 2016]; root of
context hierarchy
[vm_2][info 2016/06/23 13:18:43.265 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Detected @ExceptionHandler methods in baseControllerAdvice
[vm_2][info 2016/06/23 13:18:43.287 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Mapped URL path [/**] onto handler
'org.springframework.web.servlet.resource.DefaultServletHttpRequestHandler#0'
[vm_2][info 2016/06/23 13:18:43.554 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Scanning for api listing references
[vm_2][info 2016/06/23 13:18:43.555 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group functions for handler method: execute
[vm_2][info 2016/06/23 13:18:43.555 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group functions for handler method: list
[vm_2][info 2016/06/23 13:18:43.555 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: update
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: size
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: read
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: read
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: create
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: servers
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: regions
[vm_2][info 2016/06/23 13:18:43.556 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: ping
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: delete
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: delete
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group region for handler method: keys
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: runNamedQuery
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: runAdhocQuery
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: update
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: delete
[vm_2][info 2016/06/23 13:18:43.557 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: create
[vm_2][info 2016/06/23 13:18:43.558 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Adding resource to group queries for handler method: list
[vm_2][info 2016/06/23 13:18:43.558 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_2][info 2016/06/23 13:18:43.558 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_2][info 2016/06/23 13:18:43.558 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Excluding method as it contains the excluded annotation: interface
com.mangofactory.swagger.annotations.ApiIgnore
[vm_2][info 2016/06/23 13:18:43.571 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:20035/gemfire-api/api-docs/gemfireApi/functions
Description: functions Position: 0
[vm_2][info 2016/06/23 13:18:43.572 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:20035/gemfire-api/api-docs/gemfireApi/queries
Description: queries Position: 1
[vm_2][info 2016/06/23 13:18:43.572 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Creating resource listing Path:
http://kuwait.gemstone.com:20035/gemfire-api/api-docs/gemfireApi/region
Description: region Position: 2
[vm_2]331.235: [GC (Allocation Failure) [PSYoungGen: 121282K->9834K(140800K)]
201716K->93747K(490496K), 0.0164976 secs] [Times: user=0.12 sys=0.00, real=0.02
secs]
[vm_2][info 2016/06/23 13:18:44.372 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] FrameworkServlet 'gemfire-api': initialization completed in 1917 ms
[vm_2][info 2016/06/23 13:18:44.372 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started
o.e.j.w.WebAppContext@534b7693{/gemfire-api,file:///kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/distributedTest/dunit/vm2/GemFire_build/services/http/kuwait.gemstone.com_20035_gemfire-api/webapp/,AVAILABLE}{/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war}
[vm_2][info 2016/06/23 13:18:44.373 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started
ServerConnector@5cd98f5b{HTTP/1.1,[http/1.1]}{kuwait.gemstone.com:20035}
[vm_2][info 2016/06/23 13:18:44.373 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Started @331454ms
[vm_2][info 2016/06/23 13:18:44.373 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] HTTP service started successfully...!!
[vm_2][info 2016/06/23 13:18:44.373 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initializing region __ParameterizedQueries__
[vm_2][info 2016/06/23 13:18:44.378 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Region __ParameterizedQueries__ requesting initial image from
kuwait(m2:17451)<ec><v45>:1026
[vm_2][info 2016/06/23 13:18:44.379 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] __ParameterizedQueries__ is done getting image from
kuwait(m2:17451)<ec><v45>:1026. isDeltaGII is false
[vm_2][info 2016/06/23 13:18:44.379 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Initialization of region __ParameterizedQueries__ completed
[vm_2][info 2016/06/23 13:18:44.380 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: http://kuwait.gemstone.com:20035/gemfire-api/v1
[vm_2] from com.gemstone.gemfire.test.dunit.NamedCallable.call with 0 args on
object: callable(createCacheAndRegisterFunction) (took 3257 ms)
[vm_3]distributed system properties: {name=m4, http-service-port=26973,
start-dev-rest-api=true, mcast-port=0, log-level=info,
http-service-bind-address=kuwait.gemstone.com, disable-auto-reconnect=true,
enable-cluster-configuration=false, locators=localhost[28169],
use-cluster-configuration=false}
[locator][info 2016/06/23 13:18:44.402 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received join request from kuwait(m4:17473)<ec>:1028
[locator][info 2016/06/23 13:18:44.703 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 1 requests for the next membership view
[locator][info 2016/06/23 13:18:44.703 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|47]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027, kuwait(m4:17473)<ec><v47>:1028]
[locator]failure detection ports: 51730 56853 61867 47406 49937
[locator][info 2016/06/23 13:18:44.718 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[locator][info 2016/06/23 13:18:44.718 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|47]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027, kuwait(m4:17473)<ec><v47>:1028]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[locator][info 2016/06/23 13:18:44.718 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|47] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027,
kuwait(m4:17473)<ec><v47>:1028]
[locator][info 2016/06/23 13:18:44.718 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|47] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027,
kuwait(m4:17473)<ec><v47>:1028]
[locator]failure detection ports: 51730 56853 61867 47406 49937
[locator][info 2016/06/23 13:18:44.718 PDT <View Message Processor> tid=0x3f]
Membership: Processing addition < kuwait(m4:17473)<ec><v47>:1028 >
[locator][info 2016/06/23 13:18:44.718 PDT <View Message Processor> tid=0x3f]
Admitting member <kuwait(m4:17473)<ec><v47>:1028>. Now there are 5 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:44.719 PDT <unicast receiver,kuwait-22527>
tid=0x711] received new view: View[kuwait(17441:locator)<ec><v0>:1024|47]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027, kuwait(m4:17473)<ec><v47>:1028]
[vm_1]old view is: View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[vm_2][info 2016/06/23 13:18:44.719 PDT <unicast receiver,kuwait-51833>
tid=0x67e] received new view: View[kuwait(17441:locator)<ec><v0>:1024|47]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m1:17446)<ec><v44>:1025{lead}, kuwait(m2:17451)<ec><v45>:1026,
kuwait(m3:17468)<ec><v46>:1027, kuwait(m4:17473)<ec><v47>:1028]
[vm_2]old view is: View[kuwait(17441:locator)<ec><v0>:1024|46] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027]
[vm_1][info 2016/06/23 13:18:44.719 PDT <View Message Processor> tid=0x737]
Membership: Processing addition < kuwait(m4:17473)<ec><v47>:1028 >
[vm_1][info 2016/06/23 13:18:44.719 PDT <View Message Processor> tid=0x737]
Admitting member <kuwait(m4:17473)<ec><v47>:1028>. Now there are 5 non-admin
member(s).
[vm_2][info 2016/06/23 13:18:44.720 PDT <View Message Processor> tid=0x6a8]
Membership: Processing addition < kuwait(m4:17473)<ec><v47>:1028 >
[vm_2][info 2016/06/23 13:18:44.720 PDT <View Message Processor> tid=0x6a8]
Admitting member <kuwait(m4:17473)<ec><v47>:1028>. Now there are 5 non-admin
member(s).
[vm_1][info 2016/06/23 13:18:44.725 PDT <Pooled High Priority Message Processor
2> tid=0x729] Member kuwait(m4:17473)<ec><v47>:1028 is equivalent or in the
same redundancy zone.
[vm_2][info 2016/06/23 13:18:44.725 PDT <Pooled High Priority Message Processor
1> tid=0x698] Member kuwait(m4:17473)<ec><v47>:1028 is equivalent or in the
same redundancy zone.
[locator][info 2016/06/23 13:18:44.725 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member kuwait(m4:17473)<ec><v47>:1028 is equivalent or
in the same redundancy zone.
[vm_3]332.447: [GC (Allocation Failure) [PSYoungGen: 149228K->17570K(150528K)]
184086K->52436K(500224K), 0.0172653 secs] [Times: user=0.10 sys=0.00, real=0.02
secs]
[vm_3]333.506: [GC (Allocation Failure) [PSYoungGen: 145058K->23078K(151040K)]
179924K->57952K(500736K), 0.0178580 secs] [Times: user=0.12 sys=0.00, real=0.02
secs]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:26973/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_0]SWAP:1:executing OnMembersFunction:0
[vm_1]SWAP:1:executing OnMembersFunction:0
[vm_2]SWAP:1:executing OnMembersFunction:0
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:20035/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_2]SWAP:1:executing OnMembersFunction:1
[vm_0]SWAP:1:executing OnMembersFunction:1
[vm_1]SWAP:1:executing OnMembersFunction:1
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:20035/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_2]SWAP:1:executing OnMembersFunction:2
[vm_0]SWAP:1:executing OnMembersFunction:2
[vm_1]SWAP:1:executing OnMembersFunction:2
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:21584/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_0]SWAP:1:executing OnMembersFunction:3
[vm_2]SWAP:1:executing OnMembersFunction:3
[vm_1]SWAP:1:executing OnMembersFunction:3
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:20035/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_2]SWAP:1:executing OnMembersFunction:4
[vm_0]SWAP:1:executing OnMembersFunction:4
[vm_1]SWAP:1:executing OnMembersFunction:4
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:21584/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_0]SWAP:1:executing OnMembersFunction:5
[vm_2]SWAP:1:executing OnMembersFunction:5
[vm_1]SWAP:1:executing OnMembersFunction:5
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:29454/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_1]SWAP:1:executing OnMembersFunction:6
[vm_2]SWAP:1:executing OnMembersFunction:6
[vm_0]SWAP:1:executing OnMembersFunction:6
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:26973/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_2]SWAP:1:executing OnMembersFunction:7
[vm_0]SWAP:1:executing OnMembersFunction:7
[vm_1]SWAP:1:executing OnMembersFunction:7
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:29454/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_1]SWAP:1:executing OnMembersFunction:8
[vm_2]SWAP:1:executing OnMembersFunction:8
[vm_0]SWAP:1:executing OnMembersFunction:8
Response : [ true, true, true ]
Entering executeFunctionThroughRestCall
Request: POST POST
http://kuwait.gemstone.com:21584/gemfire-api/v1/functions/OnMembersFunction?onMembers=m1,m2,m3
HTTP/1.1
[vm_0]SWAP:1:executing OnMembersFunction:9
[vm_2]SWAP:1:executing OnMembersFunction:9
[vm_1]SWAP:1:executing OnMembersFunction:9
Response : [ true, true, true ]
[vm_1][info 2016/06/23 13:18:47.615 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedCallable.call
with 0 args on object: callable(getInvocationCount)
[vm_1][info 2016/06/23 13:18:47.615 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: 10
[vm_1] from com.gemstone.gemfire.test.dunit.NamedCallable.call with 0 args on
object: callable(getInvocationCount) (took 0 ms)
[vm_2][info 2016/06/23 13:18:47.616 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method: com.gemstone.gemfire.test.dunit.NamedCallable.call
with 0 args on object: callable(getInvocationCount)
[vm_2][info 2016/06/23 13:18:47.616 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: 10
[vm_2] from com.gemstone.gemfire.test.dunit.NamedCallable.call with 0 args on
object: callable(getInvocationCount) (took 0 ms)
[vm_1][info 2016/06/23 13:18:47.621 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/1957550982.run
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/1957550982@53af400
[vm_1][info 2016/06/23 13:18:47.621 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_1] from
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/1957550982.run
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/1957550982@53af400
(took 0 ms)
[vm_2][info 2016/06/23 13:18:47.622 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/2138898061.run
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/2138898061@2a7c24b2
[vm_2][info 2016/06/23 13:18:47.622 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_2] from
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/2138898061.run
with 0 args on object:
com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase$$Lambda$23/2138898061@2a7c24b2
(took 0 ms)
[vm_1][info 2016/06/23 13:18:47.625 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1926692593.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1926692593@788d24c3
[vm_1][info 2016/06/23 13:18:47.625 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_1] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1926692593.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1926692593@788d24c3
(took 0 ms)
[vm_2][info 2016/06/23 13:18:47.626 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1758374434.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1758374434@266b2fdb
[vm_2][info 2016/06/23 13:18:47.626 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_2] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1758374434.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1758374434@266b2fdb
(took 0 ms)
[vm_2][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message Processor
3> tid=0x699] received leave request from kuwait(m1:17446)<ec><v44>:1025 for
kuwait(m1:17446)<ec><v44>:1025
[vm_1][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message Processor
1> tid=0x728] received leave request from kuwait(m1:17446)<ec><v44>:1025 for
kuwait(m1:17446)<ec><v44>:1025
[vm_2][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message Processor
3> tid=0x699] Member at kuwait(m1:17446)<ec><v44>:1025 gracefully left the
distributed cache: shutdown message received
[vm_1][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message Processor
1> tid=0x728] Member at kuwait(m1:17446)<ec><v44>:1025 gracefully left the
distributed cache: shutdown message received
[locator][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] received leave request from
kuwait(m1:17446)<ec><v44>:1025 for kuwait(m1:17446)<ec><v44>:1025
[locator][info 2016/06/23 13:18:47.638 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member at kuwait(m1:17446)<ec><v44>:1025 gracefully left
the distributed cache: shutdown message received
[vm_1][info 2016/06/23 13:18:47.740 PDT <unicast receiver,kuwait-22527>
tid=0x711] received leave request from kuwait(m1:17446)<ec><v44>:1025 for
kuwait(m1:17446)<ec><v44>:1025
[locator][info 2016/06/23 13:18:47.740 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received leave request from kuwait(m1:17446)<ec><v44>:1025 for
kuwait(m1:17446)<ec><v44>:1025
[vm_2][info 2016/06/23 13:18:47.740 PDT <unicast receiver,kuwait-51833>
tid=0x67e] received leave request from kuwait(m1:17446)<ec><v44>:1025 for
kuwait(m1:17446)<ec><v44>:1025
[vm_1][info 2016/06/23 13:18:47.764 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1152520920.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1152520920@1564dc9
[vm_1][info 2016/06/23 13:18:47.765 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GemFireCache[id = 228444943; isClosing = true; isShutDownAll = false;
created = Thu Jun 23 13:18:38 PDT 2016; server = false; copyOnRead = false;
lockLease = 120; lockTimeout = 60]: Now closing.
[vm_1][info 2016/06/23 13:18:47.771 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Shutting down DistributionManager kuwait(m2:17451)<ec><v45>:1026.
[vm_2][info 2016/06/23 13:18:47.772 PDT <Pooled High Priority Message Processor
3> tid=0x699] received leave request from kuwait(m2:17451)<ec><v45>:1026 for
kuwait(m2:17451)<ec><v45>:1026
[vm_2][info 2016/06/23 13:18:47.772 PDT <Pooled High Priority Message Processor
3> tid=0x699] Member at kuwait(m2:17451)<ec><v45>:1026 gracefully left the
distributed cache: shutdown message received
[locator][info 2016/06/23 13:18:47.772 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] received leave request from
kuwait(m2:17451)<ec><v45>:1026 for kuwait(m2:17451)<ec><v45>:1026
[locator][info 2016/06/23 13:18:47.772 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member at kuwait(m2:17451)<ec><v45>:1026 gracefully left
the distributed cache: shutdown message received
[vm_1][info 2016/06/23 13:18:47.873 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Now closing distribution for kuwait(m2:17451)<ec><v45>:1026
[vm_1][info 2016/06/23 13:18:47.873 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopping membership services
[vm_1][info 2016/06/23 13:18:47.874 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GMSHealthMonitor server socket is closed in stopServices().
[vm_2][info 2016/06/23 13:18:47.874 PDT <unicast receiver,kuwait-51833>
tid=0x67e] received leave request from kuwait(m2:17451)<ec><v45>:1026 for
kuwait(m2:17451)<ec><v45>:1026
[vm_1][info 2016/06/23 13:18:47.874 PDT <Geode Failure Detection Server thread
0> tid=0x715] GMSHealthMonitor server thread exiting
[vm_1][info 2016/06/23 13:18:47.874 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GMSHealthMonitor serverSocketExecutor is terminated
[locator][info 2016/06/23 13:18:47.874 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received leave request from kuwait(m2:17451)<ec><v45>:1026 for
kuwait(m2:17451)<ec><v45>:1026
[vm_1][info 2016/06/23 13:18:47.879 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] DistributionManager stopped in 108ms.
[vm_1][info 2016/06/23 13:18:47.880 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Marking DistributionManager kuwait(m2:17451)<ec><v45>:1026 as closed.
[vm_1][info 2016/06/23 13:18:47.880 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Rest Server on port 29,454 is shutting down
[vm_1][info 2016/06/23 13:18:47.880 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopping the HTTP service...
[vm_1][info 2016/06/23 13:18:47.881 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopped
ServerConnector@d6f1991{HTTP/1.1,[http/1.1]}{kuwait.gemstone.com:29454}
[vm_1][info 2016/06/23 13:18:47.881 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Destroying Spring FrameworkServlet 'gemfire-api'
[vm_1][info 2016/06/23 13:18:47.882 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Closing WebApplicationContext for namespace 'gemfire-api-servlet':
startup date [Thu Jun 23 13:18:39 PDT 2016]; root of context hierarchy
[vm_1][info 2016/06/23 13:18:47.892 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopped
o.e.j.w.WebAppContext@22d9ec0{/gemfire-api,null,UNAVAILABLE}{/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war}
[vm_1][info 2016/06/23 13:18:47.893 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_1] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1152520920.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1152520920@1564dc9
(took 129 ms)
[vm_2][info 2016/06/23 13:18:47.894 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/85360676.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/85360676@1894a51e
[vm_2][info 2016/06/23 13:18:47.896 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GemFireCache[id = 2094044026; isClosing = true; isShutDownAll =
false; created = Thu Jun 23 13:18:41 PDT 2016; server = false; copyOnRead =
false; lockLease = 120; lockTimeout = 60]: Now closing.
[vm_2][info 2016/06/23 13:18:47.902 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Shutting down DistributionManager kuwait(m3:17468)<ec><v46>:1027.
[locator][info 2016/06/23 13:18:47.903 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] received leave request from
kuwait(m3:17468)<ec><v46>:1027 for kuwait(m3:17468)<ec><v46>:1027
[locator][info 2016/06/23 13:18:47.903 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member at kuwait(m3:17468)<ec><v46>:1027 gracefully left
the distributed cache: shutdown message received
[locator][info 2016/06/23 13:18:48.003 PDT <Geode Membership View Creator>
tid=0x32] View Creator is processing 5 requests for the next membership view
[locator][info 2016/06/23 13:18:48.003 PDT <Geode Membership View Creator>
tid=0x32] preparing new view View[kuwait(17441:locator)<ec><v0>:1024|48]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m4:17473)<ec><v47>:1028{lead}] shutdown:
[kuwait(m3:17468)<ec><v46>:1027, kuwait(m1:17446)<ec><v44>:1025,
kuwait(m2:17451)<ec><v45>:1026]
[locator]failure detection ports: 51730 49937
[vm_2][info 2016/06/23 13:18:48.003 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Now closing distribution for kuwait(m3:17468)<ec><v46>:1027
[vm_2][info 2016/06/23 13:18:48.004 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopping membership services
[locator][info 2016/06/23 13:18:48.004 PDT <Geode Membership View Creator>
tid=0x32] finished waiting for responses to view preparation
[locator][info 2016/06/23 13:18:48.004 PDT <Geode Membership View Creator>
tid=0x32] received new view: View[kuwait(17441:locator)<ec><v0>:1024|48]
members: [kuwait(17441:locator)<ec><v0>:1024,
kuwait(m4:17473)<ec><v47>:1028{lead}] shutdown:
[kuwait(m3:17468)<ec><v46>:1027, kuwait(m1:17446)<ec><v44>:1025,
kuwait(m2:17451)<ec><v45>:1026]
[locator]old view is: View[kuwait(17441:locator)<ec><v0>:1024|47] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m1:17446)<ec><v44>:1025{lead},
kuwait(m2:17451)<ec><v45>:1026, kuwait(m3:17468)<ec><v46>:1027,
kuwait(m4:17473)<ec><v47>:1028]
[locator][info 2016/06/23 13:18:48.004 PDT <Geode Membership View Creator>
tid=0x32] Peer locator received new membership view:
View[kuwait(17441:locator)<ec><v0>:1024|48] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m4:17473)<ec><v47>:1028{lead}]
shutdown: [kuwait(m3:17468)<ec><v46>:1027, kuwait(m1:17446)<ec><v44>:1025,
kuwait(m2:17451)<ec><v45>:1026]
[locator][info 2016/06/23 13:18:48.005 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received leave request from kuwait(m3:17468)<ec><v46>:1027 for
kuwait(m3:17468)<ec><v46>:1027
[locator][info 2016/06/23 13:18:48.005 PDT <Geode Membership View Creator>
tid=0x32] sending new view View[kuwait(17441:locator)<ec><v0>:1024|48] members:
[kuwait(17441:locator)<ec><v0>:1024, kuwait(m4:17473)<ec><v47>:1028{lead}]
shutdown: [kuwait(m3:17468)<ec><v46>:1027, kuwait(m1:17446)<ec><v44>:1025,
kuwait(m2:17451)<ec><v45>:1026]
[locator]failure detection ports: 51730 49937
[vm_2][info 2016/06/23 13:18:48.005 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GMSHealthMonitor server socket is closed in stopServices().
[vm_2][info 2016/06/23 13:18:48.005 PDT <Geode Failure Detection Server thread
0> tid=0x682] GMSHealthMonitor server thread exiting
[vm_2][info 2016/06/23 13:18:48.005 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] GMSHealthMonitor serverSocketExecutor is terminated
[vm_2][info 2016/06/23 13:18:48.010 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] DistributionManager stopped in 108ms.
[vm_2][info 2016/06/23 13:18:48.011 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Marking DistributionManager kuwait(m3:17468)<ec><v46>:1027 as closed.
[vm_2][info 2016/06/23 13:18:48.011 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Rest Server on port 20,035 is shutting down
[vm_2][info 2016/06/23 13:18:48.011 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopping the HTTP service...
[vm_2][info 2016/06/23 13:18:48.012 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopped
ServerConnector@5cd98f5b{HTTP/1.1,[http/1.1]}{kuwait.gemstone.com:20035}
[vm_2][info 2016/06/23 13:18:48.012 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Destroying Spring FrameworkServlet 'gemfire-api'
[vm_2][info 2016/06/23 13:18:48.012 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Closing WebApplicationContext for namespace 'gemfire-api-servlet':
startup date [Thu Jun 23 13:18:42 PDT 2016]; root of context hierarchy
[vm_2][info 2016/06/23 13:18:48.023 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Stopped
o.e.j.w.WebAppContext@534b7693{/gemfire-api,null,UNAVAILABLE}{/kuwait1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-assembly/build/install/apache-geode/tools/Extensions/geode-web-api-1.0.0-incubating.M3-SNAPSHOT.war}
[vm_2][info 2016/06/23 13:18:48.023 PDT <RMI TCP Connection(2)-10.118.32.93>
tid=0x1c] Got result: null
[vm_2] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/85360676.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/85360676@1894a51e
(took 129 ms)
[locator][info 2016/06/23 13:18:48.030 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] received leave request from
kuwait(m4:17473)<ec><v47>:1028 for kuwait(m4:17473)<ec><v47>:1028
[locator][info 2016/06/23 13:18:48.031 PDT <Pooled High Priority Message
Processor 2> tid=0x9b] Member at kuwait(m4:17473)<ec><v47>:1028 gracefully left
the distributed cache: shutdown message received
[locator][info 2016/06/23 13:18:48.132 PDT <unicast receiver,kuwait-4654>
tid=0x2c] received leave request from kuwait(m4:17473)<ec><v47>:1028 for
kuwait(m4:17473)<ec><v47>:1028
[locator][info 2016/06/23 13:18:48.152 PDT <RMI TCP Connection(3)-10.118.32.93>
tid=0x1c] Received method:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$5/1193060183.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$5/1193060183@47e1cdf8
[locator][info 2016/06/23 13:18:48.152 PDT <RMI TCP Connection(3)-10.118.32.93>
tid=0x1c] Got result: null
[locator] from
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$5/1193060183.run
with 0 args on object:
com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$5/1193060183@47e1cdf8
(took 0 ms)
Eclipse integration is not enabled. Help us localize this page Page generated:
Jun 24, 2016 4:25:29 PM PDTREST APIJenkins ver. 1.646
Enable Notifications
> CI failure:
> RestAPIsOnMembersFunctionExecutionDUnitTest.testFunctionExecutionOnAllMembers
> -----------------------------------------------------------------------------------------
>
> Key: GEODE-1594
> URL: https://issues.apache.org/jira/browse/GEODE-1594
> Project: Geode
> Issue Type: Bug
> Components: rest (dev)
> Reporter: Hitesh Khamesra
> Labels: CI
>
> java.lang.AssertionError: unexpected exception
> at com.gemstone.gemfire.test.dunit.Assert.fail(Assert.java:64)
> at
> com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase.executeFunctionThroughRestCall(RestAPITestBase.java:151)
> at
> com.gemstone.gemfire.rest.internal.web.controllers.RestAPIsOnMembersFunctionExecutionDUnitTest.testFunctionExecutionOnAllMembers(RestAPIsOnMembersFunctionExecutionDUnitTest.java:106)
> 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:497)
> 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
> 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.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
> at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
> at
> org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:112)
> at
> org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:56)
> 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:497)
> at
> org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
> at
> org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
> at
> org.gradle.messaging.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32)
> at
> org.gradle.messaging.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:497)
> at
> org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
> at
> org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
> at
> org.gradle.messaging.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:360)
> 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:1142)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: org.apache.http.NoHttpResponseException: kuwait.gemstone.com:27072
> failed to respond
> at
> org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
> at
> org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
> at
> org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
> at
> org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
> at
> org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
> at
> org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
> at
> org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
> at
> org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
> at
> org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
> at
> org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
> at
> org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
> at
> org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
> at
> org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
> at
> com.gemstone.gemfire.rest.internal.web.controllers.RestAPITestBase.executeFunctionThroughRestCall(RestAPITestBase.java:149)
> ... 49 more
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
