| Run | | | Workspace | | | Log | | | Issues | | | Fixes | | | Pre-reqs | | | Stats | | | XRef | | | Maven Repository Proxy Log | |
||
Testsuite: org.apache.catalina.tribes.group.interceptors.TestTcpFailureDetector
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.822 sec
------------- Standard Output ---------------
testTcpMcastFail()
Channel-2:member added[Channel-1]
Channel-1:member added[Channel-2]
testTcpFailureMemberAdd()
Channel-2:member added[Channel-1]
testTcpSendFailureMemberDrop()
Channel-2:member added[Channel-1]
Channel-1:member added[Channel-2]
Channel-1:member disappeared[Channel-2]
------------- ---------------- ---------------
------------- Standard Error -----------------
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4000,{127, 0, 0, 1},4000, alive=1504, securePort=-1, UDP Port=-1, id={-21 9 -37 31 -11 -49 79 71 -76 -89 -2 34 14 82 40 106 }, payload={}, command={}, domain={-24 -73 -65 -97 -22 4 70 -96 -114 ...(16)}]] was refused to join cluster
Mar 23, 2023 7:22:26 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4010,{127, 0, 0, 1},4010, alive=1510, securePort=-1, UDP Port=-1, id={123 2 65 17 -57 -51 68 -119 -101 61 4 -46 118 -4 59 -106 }, payload={}, command={}, domain={-24 -73 -65 -97 -22 4 70 -96 -114 ...(16)}]] was refused to join cluster
Mar 23, 2023 7:22:27 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:27 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4002]
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4000,{127, 0, 0, 1},4000, alive=3505, securePort=-1, UDP Port=-1, id={-21 9 -37 31 -11 -49 79 71 -76 -89 -2 34 14 82 40 106 }, payload={}, command={}, domain={-24 -73 -65 -97 -22 4 70 -96 -114 ...(16)}]] was refused to join cluster
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4010,{127, 0, 0, 1},4010, alive=3512, securePort=-1, UDP Port=-1, id={123 2 65 17 -57 -51 68 -119 -101 61 4 -46 118 -4 59 -106 }, payload={}, command={}, domain={-24 -73 -65 -97 -22 4 70 -96 -114 ...(16)}]] was refused to join cluster
Mar 23, 2023 7:22:28 PM org.apache.catalina.tribes.io.BufferPool getBufferPool
INFO: Created a buffer pool with max size:[104857600] bytes of type: [org.apache.catalina.tribes.io.BufferPool]
Mar 23, 2023 7:22:29 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:29 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:30 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:32 PM org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread run
WARNING: Error receiving mcast package. Sleeping 500ms
java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@341efa39[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@551d9a0[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc6a68@16cc1370]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@6e696e5b[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 4]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2065)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:833)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.execute(ScheduledThreadPoolExecutor.java:705)
at org.apache.catalina.tribes.membership.McastServiceImpl.memberDataReceived(McastServiceImpl.java:433)
at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:381)
at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:581)
Mar 23, 2023 7:22:33 PM org.apache.catalina.tribes.group.interceptors.TcpFailureDetector memberDisappeared
INFO: Received memberDisappeared[org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4002,{127, 0, 0, 1},4002, alive=2004, securePort=-1, UDP Port=-1, id={-114 -116 -24 -124 -108 66 74 9 -94 43 -28 -1 -53 67 54 -62 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-72 -71 87 -128 -55 24 68 94 -95 ...(16)}]] message. Will verify.
Mar 23, 2023 7:22:33 PM org.apache.catalina.tribes.group.interceptors.TcpFailureDetector memberDisappeared
INFO: Verification complete. Member still alive[org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4002,{127, 0, 0, 1},4002, alive=2004, securePort=-1, UDP Port=-1, id={-114 -116 -24 -124 -108 66 74 9 -94 43 -28 -1 -53 67 54 -62 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-72 -71 87 -128 -55 24 68 94 -95 ...(16)}]]
Mar 23, 2023 7:22:35 PM org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread run
WARNING: Error receiving mcast package. Sleeping 500ms
java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@738f91f[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@5d27f821[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc6a68@390ac552]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@6e696e5b[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 4]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2065)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:833)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.execute(ScheduledThreadPoolExecutor.java:705)
at org.apache.catalina.tribes.membership.McastServiceImpl.memberDataReceived(McastServiceImpl.java:433)
at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:381)
at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:581)
Mar 23, 2023 7:22:35 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:35 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000]
Mar 23, 2023 7:22:35 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:35 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:36 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:36 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:37 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:37 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:37 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Mar 23, 2023 7:22:37 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:37 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:38 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:38 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:38 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread run
WARNING: Error receiving mcast package. Sleeping 500ms
java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@14d9d9aa[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@1e21b2da[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc6a68@10e64f6e]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@51db4555[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 4]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2065)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:833)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.execute(ScheduledThreadPoolExecutor.java:705)
at org.apache.catalina.tribes.membership.McastServiceImpl.memberDataReceived(McastServiceImpl.java:433)
at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:381)
at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:581)
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000]
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:39 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:40 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:40 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:41 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:41 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Mar 23, 2023 7:22:41 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Mar 23, 2023 7:22:41 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Mar 23, 2023 7:22:41 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Mar 23, 2023 7:22:42 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Mar 23, 2023 7:22:42 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Mar 23, 2023 7:22:43 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Mar 23, 2023 7:22:43 PM org.apache.catalina.tribes.transport.nio.ParallelNioSender doLoop
WARNING: Member send is failing for:[tcp://{127, 0, 0, 1}:4001] ; Setting to suspect and retrying.
Mar 23, 2023 7:22:43 PM org.apache.catalina.tribes.group.interceptors.TcpFailureDetector memberDisappeared
INFO: Received memberDisappeared[org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4001,{127, 0, 0, 1},4001, alive=2002, securePort=-1, UDP Port=-1, id={-64 -81 -31 -119 -4 -66 77 -117 -74 -99 15 -47 -25 103 -93 86 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-76 -90 100 -18 86 -41 76 -79 -70 ...(16)}]] message. Will verify.
Mar 23, 2023 7:22:43 PM org.apache.catalina.tribes.group.interceptors.TcpFailureDetector memberDisappeared
INFO: Verification complete. Member disappeared[org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4001,{127, 0, 0, 1},4001, alive=2002, securePort=-1, UDP Port=-1, id={-64 -81 -31 -119 -4 -66 77 -117 -74 -99 15 -47 -25 103 -93 86 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-76 -90 100 -18 86 -41 76 -79 -70 ...(16)}]]
Mar 23, 2023 7:22:43 PM org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread run
WARNING: Error receiving mcast package. Sleeping 500ms
java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@30e17930[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@71dc730b[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc6a68@75e3e9e8]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@134d22f6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 2]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2065)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:833)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.execute(ScheduledThreadPoolExecutor.java:705)
at org.apache.catalina.tribes.membership.McastServiceImpl.memberDataReceived(McastServiceImpl.java:433)
at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:381)
at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:581)
------------- ---------------- ---------------
Testcase: testTcpMcastFail took 9.349 sec
Testcase: testTcpFailureMemberAdd took 4.23 sec
Testcase: testTcpSendFailureMemberDrop took 4.235 sec
Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.
Last Updated: Thu, 23 Mar 2023 18:00:04 ().