You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@geode.apache.org by "Dick Cavender (Jira)" <ji...@apache.org> on 2019/09/26 18:03:09 UTC

[jira] [Closed] (GEODE-6888) CI failure: HAGIIDUnitTest.testGIIRegionQueue Suspect string in the log

     [ https://issues.apache.org/jira/browse/GEODE-6888?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Dick Cavender closed GEODE-6888.
--------------------------------

> CI failure: HAGIIDUnitTest.testGIIRegionQueue Suspect string in the log
> -----------------------------------------------------------------------
>
>                 Key: GEODE-6888
>                 URL: https://issues.apache.org/jira/browse/GEODE-6888
>             Project: Geode
>          Issue Type: Bug
>          Components: client/server
>            Reporter: Anilkumar Gingade
>            Assignee: Nabarun Nag
>            Priority: Major
>             Fix For: 1.10.0
>
>          Time Spent: 50m
>  Remaining Estimate: 0h
>
> java.lang.AssertionError: Suspicious strings were written to the log during this run. Fix the strings or use IgnoredException.addIgnoredException to ignore. -----------------------------------------------------------------------
> Found suspect string in log4j at line 2826 java.net.ConnectException: Connection refused (Connection refused)
> Vm2 log with Exception:
> [vm2] Library Path: [vm2] /usr/java/packages/lib [vm2] /usr/lib/x86_64-linux-gnu/jni [vm2] /lib/x86_64-linux-gnu [vm2] /usr/lib/x86_64-linux-gnu [vm2] /usr/lib/jni [vm2] /lib [vm2] /usr/lib [vm2] System Properties: [vm2] Locator.inhibitDMBanner = true [vm2] WORKSPACE_DIR = /home/geode/geode/geode-core/build/distributedTest933/. [vm2] awt.toolkit = sun.awt.X11.XToolkit [vm2] dummyArg = true [vm2] file.encoding = UTF-8 [vm2] file.separator = / [vm2] gemfire.DEFAULT_MAX_OPLOG_SIZE = 10 [vm2] gemfire.DUnitLauncher.LAUNCHED = true [vm2] gemfire.DUnitLauncher.RMI_PORT = 24145 [vm2] gemfire.DUnitLauncher.VM_NUM = 2 [vm2] gemfire.DUnitLauncher.VM_VERSION = 000 [vm2] gemfire.disallowMcastDefaults = true [vm2] gemfire.free-off-heap-memory = true [vm2] gemfire.use-ephemeral-ports = true [vm2] gemfire.validate-serializable-objects = true [vm2] java.awt.graphicsenv = sun.awt.X11GraphicsEnvironment [vm2] java.awt.printerjob = sun.print.PSPrinterJob [vm2] java.class.version = 55.0 [vm2] java.home = /usr/lib/jvm/java-11-openjdk-amd64 [vm2] java.io.tmpdir = /tmp [vm2] java.runtime.name = OpenJDK Runtime Environment [vm2] java.runtime.version = 11.0.3+7-Ubuntu-1ubuntu218.04.1 [vm2] java.specification.name = Java Platform API Specification [vm2] java.specification.vendor = Oracle Corporation [vm2] java.specification.version = 11 [vm2] java.vendor = Oracle Corporation [vm2] java.vendor.url = [http://java.oracle.com/] [vm2] java.vendor.url.bug = [http://bugreport.java.com/bugreport/] [vm2] java.version = 11.0.3 [vm2] java.version.date = 2019-04-16 [vm2] java.vm.compressedOopsMode = 32-bit [vm2] java.vm.info = mixed mode, sharing [vm2] java.vm.name = OpenJDK 64-Bit Server VM [vm2] java.vm.specification.name = Java Virtual Machine Specification [vm2] java.vm.specification.vendor = Oracle Corporation [vm2] java.vm.specification.version = 11 [vm2] java.vm.vendor = Oracle Corporation [vm2] java.vm.version = 11.0.3+7-Ubuntu-1ubuntu218.04.1 [vm2] jdk.debug = release [vm2] line.separator = [vm2] log-level = info [vm2] os.version = 4.15.0-1033-gcp [vm2] path.separator = : [vm2] sun.arch.data.model = 64 [vm2] sun.boot.library.path = /usr/lib/jvm/java-11-openjdk-amd64/lib [vm2] sun.cpu.endian = little [vm2] sun.cpu.isalist = [vm2] sun.io.unicode.encoding = UnicodeLittle [vm2] sun.java.command = org.apache.geode.test.dunit.internal.ChildVM [vm2] sun.java.launcher = SUN_STANDARD [vm2] sun.jnu.encoding = UTF-8 [vm2] sun.management.compiler = HotSpot 64-Bit Tiered Compilers [vm2] sun.nio.ch.bugLevel = [vm2] sun.os.patch.level = unknown [vm2] user.language = en [vm2] user.timezone = GMT [vm2] Log4J 2 Configuration: [vm2] /home/geode/geode/geode-core/build/resources/main/log4j2.xml [vm2] --------------------------------------------------------------------------- [vm2] [info 2019/06/18 16:53:44.443 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Startup Configuration: [vm2] ### GemFire Properties defined with system property ### [vm2] validate-serializable-objects=true [vm2] ### GemFire Properties defined with api ### [vm2] disable-auto-reconnect=true [vm2] enable-cluster-configuration=false [vm2] locators= [vm2] log-level=info [vm2] mcast-port=0 [vm2] use-cluster-configuration=false [vm2] ### GemFire Properties using default values ### [vm2] ack-severe-alert-threshold=0 [vm2] ack-wait-threshold=15 [vm2] archive-disk-space-limit=0 [vm2] archive-file-size-limit=0 [vm2] async-distribution-timeout=0 [vm2] async-max-queue-size=8 [vm2] async-queue-timeout=60000 [vm2] bind-address= [vm2] cache-xml-file=cache.xml [vm2] cluster-configuration-dir= [vm2] cluster-ssl-ciphers=any [vm2] cluster-ssl-enabled=false [vm2] cluster-ssl-keystore= [vm2] cluster-ssl-keystore-password= [vm2] cluster-ssl-keystore-type= [vm2] cluster-ssl-protocols=any [vm2] cluster-ssl-require-authentication=true [vm2] cluster-ssl-truststore= [vm2] cluster-ssl-truststore-password= [vm2] conflate-events=server [vm2] conserve-sockets=true [vm2] delta-propagation=true [vm2] deploy-working-dir=/home/geode/geode/geode-core/build/distributedTest933/dunit/vm2 [vm2] disable-jmx=false [vm2] disable-tcp=false [vm2] distributed-system-id=-1 [vm2] distributed-transactions=false [vm2] durable-client-id= [vm2] durable-client-timeout=300 [vm2] enable-network-partition-detection=true [vm2] enable-time-statistics=false [vm2] enforce-unique-host=false [vm2] gateway-ssl-ciphers=any [vm2] gateway-ssl-enabled=false [vm2] gateway-ssl-keystore= [vm2] gateway-ssl-keystore-password= [vm2] gateway-ssl-keystore-type= [vm2] gateway-ssl-protocols=any [vm2] gateway-ssl-require-authentication=true [vm2] gateway-ssl-truststore= [vm2] gateway-ssl-truststore-password= [vm2] groups= [vm2] http-service-bind-address= [vm2] http-service-port=7070 [vm2] http-service-ssl-ciphers=any [vm2] http-service-ssl-enabled=false [vm2] http-service-ssl-keystore= [vm2] http-service-ssl-keystore-password= [vm2] http-service-ssl-keystore-type= [vm2] http-service-ssl-protocols=any [vm2] http-service-ssl-require-authentication=false [vm2] http-service-ssl-truststore= [vm2] http-service-ssl-truststore-password= [vm2] jmx-manager=false [vm2] jmx-manager-access-file= [vm2] jmx-manager-bind-address= [vm2] jmx-manager-hostname-for-clients= [vm2] jmx-manager-http-port=7070 [vm2] jmx-manager-password-file= [vm2] jmx-manager-port=1099 [vm2] jmx-manager-ssl-ciphers=any [vm2] jmx-manager-ssl-enabled=false [vm2] jmx-manager-ssl-keystore= [vm2] jmx-manager-ssl-keystore-password= [vm2] jmx-manager-ssl-keystore-type= [vm2] jmx-manager-ssl-protocols=any [vm2] jmx-manager-ssl-require-authentication=true [vm2] jmx-manager-ssl-truststore= [vm2] jmx-manager-ssl-truststore-password= [vm2] jmx-manager-start=false [vm2] jmx-manager-update-rate=2000 [vm2] load-cluster-configuration-from-dir=false [vm2] locator-wait-time=0 [vm2] lock-memory=false [vm2] log-disk-space-limit=0 [vm2] log-file= [vm2] log-file-size-limit=0 [vm2] max-num-reconnect-tries=3 [vm2] max-wait-time-reconnect=60000 [vm2] mcast-address=239.192.81.1 [vm2] mcast-flow-control=1048576, 0.25, 5000 [vm2] mcast-recv-buffer-size=1048576 [vm2] mcast-send-buffer-size=65535 [vm2] mcast-ttl=32 [vm2] member-timeout=5000 [vm2] membership-port-range=41000-61000 [vm2] memcached-bind-address= [vm2] memcached-port=0 [vm2] memcached-protocol=ASCII [vm2] name= [vm2] off-heap-memory-size= [vm2] redis-bind-address= [vm2] redis-password= [vm2] redis-port=0 [vm2] redundancy-zone= [vm2] remote-locators= [vm2] remove-unresponsive-client=false [vm2] roles= [vm2] security-client-accessor= [vm2] security-client-accessor-pp= [vm2] security-client-auth-init= [vm2] security-client-authenticator= [vm2] security-client-dhalgo= [vm2] security-log-file= [vm2] security-log-level=config [vm2] security-manager= [vm2] security-peer-auth-init= [vm2] security-peer-authenticator= [vm2] security-peer-verifymember-timeout=1000 [vm2] security-post-processor= [vm2] security-udp-dhalgo= [vm2] serializable-object-filter=Unable to render embedded object: File (53:44.444 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] initializing InternalDataSerializer with 0 services [vm2] [info 2019/06/18 16:53:44.452 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] setting a serialization filter containing java.**;javax.management.**;javax.print.attribute.EnumSyntax;antlr.**;org.apache.commons.modeler.AttributeInfo;org.apache.commons.modeler.FeatureInfo;org.apache.commons.modeler.ManagedBean;org.apache.geode.distributed.internal.DistributionConfigSnapshot;org.apache.geode.distributed.internal.RuntimeDistributionConfigImpl;org.apache.geode.distributed.internal.DistributionConfigImpl;org.apache.geode.distributed.internal.membership.InternalDistributedMember;org.apache.geode.internal.cache.persistence.PersistentMemberID;org.apache.geode.internal.cache.persistence.DiskStoreID;org.apache.geode.internal.cache.tier.sockets.VersionedObjectList;org.apache.shiro.*;org.apache.shiro.authz.*;org.apache.shiro.authc.*;org.apache.logging.log4j.Level;org.apache.logging.log4j.spi.StandardLevel;com.sun.proxy.$Proxy*;com.healthmarketscience.rmiio.RemoteInputStream;javax.rmi.ssl.SslRMIClientSocketFactory;javax.net.ssl.SSLHandshakeException;javax.net.ssl.SSLException;sun.security.validator.ValidatorException;sun.security.provider.certpath.SunCertPathBuilderException;org.apache.geode.modules.util.SessionCustomExpiry;) not found.*;!* [vm2] [info 2019/06/18 16:53:44.464 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] [ThreadsMonitor] New Monitor object and process were created. [vm2] [info 2019/06/18 16:53:44.475 GMT <StatSampler> tid=0x32] Disabling statistic archival. [vm2] [info 2019/06/18 16:53:44.642 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Running in local mode since no locators were specified. [vm2] [info 2019/06/18 16:53:44.827 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Enabled HttpService on port 7070 [vm2] [info 2019/06/18 16:53:44.947 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Initializing region _monitoringRegion_172.17.0.8<v-1>0 [vm2] [info 2019/06/18 16:53:44.959 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Initialization of region _monitoringRegion_172.17.0.8<v-1>0 completed [vm2] [info 2019/06/18 16:53:45.894 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Initialized cache service org.apache.geode.internal.cache.MockCacheServiceImpl [vm2] [info 2019/06/18 16:53:45.897 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Loading previously deployed jars [vm2] [warn 2019/06/18 16:53:45.988 GMT <poolTimer-testPool-2> tid=0x3d] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:222) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:192) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:186) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefillConnection(ConnectionManagerImpl.java:583) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefill(ConnectionManagerImpl.java:551) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.access$200(ConnectionManagerImpl.java:70) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl$PrefillConnectionsTask.run2(ConnectionManagerImpl.java:663) [vm2] at org.apache.geode.cache.client.internal.PoolImpl$PoolTask.run(PoolImpl.java:1303) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834) [vm2] [warn 2019/06/18 16:53:45.988 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.QueueManagerImpl.initializeConnections(QueueManagerImpl.java:453) [vm2] at org.apache.geode.cache.client.internal.QueueManagerImpl.start(QueueManagerImpl.java:292) [vm2] at org.apache.geode.cache.client.internal.PoolImpl.start(PoolImpl.java:338) [vm2] at org.apache.geode.cache.client.internal.PoolImpl.finishCreate(PoolImpl.java:175) [vm2] at org.apache.geode.cache.client.internal.PoolImpl.create(PoolImpl.java:161) [vm2] at org.apache.geode.internal.cache.PoolFactoryImpl.create(PoolFactoryImpl.java:374) [vm2] at org.apache.geode.cache30.ClientServerTestCase.configureConnectionPoolWithNameAndFactory(ClientServerTestCase.java:223) [vm2] at org.apache.geode.cache30.ClientServerTestCase.configureConnectionPoolWithName(ClientServerTestCase.java:165) [vm2] at org.apache.geode.cache30.ClientServerTestCase.configureConnectionPool(ClientServerTestCase.java:240) [vm2] at org.apache.geode.internal.cache.ha.HAGIIDUnitTest.createClientCache(HAGIIDUnitTest.java:143) [vm2] at org.apache.geode.internal.cache.ha.HAGIIDUnitTest.lambda$postSetUp$ff2366df$1(HAGIIDUnitTest.java:106) [vm2] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [vm2] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [vm2] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [vm2] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [vm2] at org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123) [vm2] at org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:69) [vm2] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [vm2] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [vm2] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [vm2] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [vm2] at java.rmi/sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:359) [vm2] at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:200) [vm2] at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:197) [vm2] at java.base/java.security.AccessController.doPrivileged(Native Method) [vm2] at java.rmi/sun.rmi.transport.Transport.serviceCall(Transport.java:196) [vm2] at java.rmi/sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:562) [vm2] at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:796) [vm2] at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:677) [vm2] at java.base/java.security.AccessController.doPrivileged(Native Method) [vm2] at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:676) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834) [vm2] [info 2019/06/18 16:53:45.995 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Updating membership port. Port changed from 0 to 35402. ID is now c031e683c5e7(157:loner):0:8937826b [vm2] [warn 2019/06/18 16:53:46.144 GMT <poolTimer-testPool-2> tid=0x3d] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm0] [info 2019/06/18 16:53:46.144 GMT <Client Queue Initialization Thread 1> tid=0x71] :Cache server: Initializing primary server-to-client communication socket: Socket[addr=/172.17.0.8,port=35408,localport=28355] [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:222) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:192) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:186) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefillConnection(ConnectionManagerImpl.java:583) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefill(ConnectionManagerImpl.java:551) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.access$200(ConnectionManagerImpl.java:70) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl$PrefillConnectionsTask.run2(ConnectionManagerImpl.java:663) [vm2] at org.apache.geode.cache.client.internal.PoolImpl$PoolTask.run(PoolImpl.java:1303) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834) [vm2] [warn 2019/06/18 16:53:46.150 GMT <poolTimer-testPool-2> tid=0x3d] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:222) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:192) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:186) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefillConnection(ConnectionManagerImpl.java:583) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefill(ConnectionManagerImpl.java:551) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.access$200(ConnectionManagerImpl.java:70) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl$PrefillConnectionsTask.run2(ConnectionManagerImpl.java:663) [vm2] at org.apache.geode.cache.client.internal.PoolImpl$PoolTask.run(PoolImpl.java:1303) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834) [vm0] [info 2019/06/18 16:53:46.165 GMT <Client Queue Initialization Thread 1> tid=0x71] Initializing region _gfe_non_durable_client_with_id_172.17.0.8(157:loner):35402:8937826b_1_queue [vm0] [info 2019/06/18 16:53:46.169 GMT <Client Queue Initialization Thread 1> tid=0x71] Initialization of region _gfe_non_durable_client_with_id_172.17.0.8(157:loner):35402:8937826b_1_queue completed [vm2] [info 2019/06/18 16:53:46.182 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Pool testPool started with multiuser-authentication=false [vm2] [warn 2019/06/18 16:53:46.185 GMT <poolTimer-testPool-2> tid=0x3d] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:222) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:192) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.createPooledConnection(ConnectionManagerImpl.java:186) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefillConnection(ConnectionManagerImpl.java:583) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.prefill(ConnectionManagerImpl.java:551) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl.access$200(ConnectionManagerImpl.java:70) [vm2] at org.apache.geode.cache.client.internal.pooling.ConnectionManagerImpl$PrefillConnectionsTask.run2(ConnectionManagerImpl.java:663) [vm2] at org.apache.geode.cache.client.internal.PoolImpl$PoolTask.run(PoolImpl.java:1303) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834) [vm0] [info 2019/06/18 16:53:46.186 GMT <Client Queue Initialization Thread 1> tid=0x71] Entry expiry tasks disabled because the queue became primary. Old messageTimeToLive was: 180 [vm2] [info 2019/06/18 16:53:46.187 GMT <Cache Client Updater Thread on c031e683c5e7(149)<v2>:41001 port 28355> tid=0x40] Cache Client Updater Thread on c031e683c5e7(149)<v2>:41001 port 28355 (c031e683c5e7:28355) : ready to process messages. [vm2] [info 2019/06/18 16:53:46.222 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm2] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$136/0x00000008401a9840.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$136/0x00000008401a9840@3a9287c8 (took 2494 ms) [vm2] [info 2019/06/18 16:53:46.229 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$264/0x000000084045b440.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$264/0x000000084045b440@4a464fdd [vm2] [info 2019/06/18 16:53:46.297 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm2] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$264/0x000000084045b440.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$264/0x000000084045b440@4a464fdd (took 67 ms) [vm2] [info 2019/06/18 16:53:46.302 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$273/0x000000084045d840.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$273/0x000000084045d840@9985f2c [vm2] [info 2019/06/18 16:53:46.332 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm2] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$273/0x000000084045d840.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$273/0x000000084045d840@9985f2c (took 29 ms) [vm0] [info 2019/06/18 16:53:46.336 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$328/0x00000008404ae040.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$328/0x00000008404ae040@226c354c [vm0] [info 2019/06/18 16:53:46.352 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm0] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$328/0x00000008404ae040.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$328/0x00000008404ae040@226c354c (took 14 ms) [vm0] [info 2019/06/18 16:53:46.356 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$331/0x00000008404ad040.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$331/0x00000008404ad040@6de2b314 [vm0] [info 2019/06/18 16:53:46.359 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm0] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$331/0x00000008404ad040.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$331/0x00000008404ad040@6de2b314 (took 1 ms) [vm2] [info 2019/06/18 16:53:46.363 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$274/0x000000084045dc40.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$274/0x000000084045dc40@39ac8e0d [vm2] [info 2019/06/18 16:53:46.595 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Got result: null [vm2] from org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$274/0x000000084045dc40.run with 0 args on object: org.apache.geode.internal.cache.ha.HAGIIDUnitTest$$Lambda$274/0x000000084045dc40@39ac8e0d (took 230 ms) [vm1] [info 2019/06/18 16:53:46.599 GMT <RMI TCP Connection(1)-172.17.0.8> tid=0x22] Received method: org.apache.geode.internal.cache.ha.HAGIIDUnitTest.createServer2Cache with 1 args [vm1] distributed system properties: {locators=localhost[35189], validate-serializable-objects=true, disable-auto-reconnect=true, enable-cluster-configuration=false, use-cluster-configuration=false, log-level=info, mcast-port=0} [vm2] [warn 2019/06/18 16:53:47.181 GMT <queueTimer-testPool1> tid=0x42] Could not connect to: c031e683c5e7:27401 [vm2] java.net.ConnectException: Connection refused (Connection refused) [vm2] at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) [vm2] at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242) [vm2] at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224) [vm2] at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403) [vm2] at java.base/java.net.Socket.connect(Socket.java:591) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:898) [vm2] at org.apache.geode.internal.net.SocketCreator.connect(SocketCreator.java:839) [vm2] at org.apache.geode.internal.net.SocketCreator.connectForClient(SocketCreator.java:811) [vm2] at org.apache.geode.cache.client.internal.ConnectionImpl.connect(ConnectionImpl.java:106) [vm2] at org.apache.geode.cache.client.internal.ConnectionConnector.connectClientToServer(ConnectionConnector.java:75) [vm2] at org.apache.geode.cache.client.internal.ConnectionFactoryImpl.createClientToServerConnection(ConnectionFactoryImpl.java:111) [vm2] at org.apache.geode.cache.client.internal.QueueManagerImpl.recoverRedundancy(QueueManagerImpl.java:660) [vm2] at org.apache.geode.cache.client.internal.QueueManagerImpl.access$700(QueueManagerImpl.java:76) [vm2] at org.apache.geode.cache.client.internal.QueueManagerImpl$RedundancySatisfierTask.run2(QueueManagerImpl.java:1444) [vm2] at org.apache.geode.cache.client.internal.PoolImpl$PoolTask.run(PoolImpl.java:1303) [vm2] at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) [vm2] at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [vm2] at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [vm2] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [vm2] at java.base/java.lang.Thread.run(Thread.java:834)
>  
>  
>  
>  
>  



--
This message was sent by Atlassian Jira
(v8.3.4#803005)