| 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.706 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 -----------------
Apr 23, 2024 1:52:30 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:30 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Apr 23, 2024 1:52:30 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:30 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:30 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4011,{127, 0, 0, 1},4011, alive=6016, securePort=-1, UDP Port=-1, id={-30 -75 51 123 41 106 76 -34 -98 32 15 -86 46 -89 24 -26 }, payload={}, command={}, domain={8 -5 -89 107 -112 -126 71 77 -100 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:30 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=6016, securePort=-1, UDP Port=-1, id={-114 -95 102 54 -70 39 71 -29 -122 64 -2 88 -25 -111 105 -67 }, payload={}, command={}, domain={8 -5 -89 107 -112 -126 71 77 -100 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:31 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:31 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:31 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=1002, securePort=-1, UDP Port=-1, id={-83 21 -45 72 -48 123 66 112 -91 -19 -85 -35 -123 74 -65 -3 }, payload={}, command={}, domain={43 89 -19 7 -92 62 68 23 -96 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:31 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4002,{127, 0, 0, 1},4002, alive=1002, securePort=-1, UDP Port=-1, id={64 -41 -55 -6 0 -55 74 82 -127 -61 -92 39 -48 59 47 -57 }, payload={}, command={}, domain={43 89 -19 7 -92 62 68 23 -96 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4003]
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:32 PM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded
INFO: Member [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={64 -41 -55 -6 0 -55 74 82 -127 -61 -92 39 -48 59 47 -57 }, payload={}, command={}, domain={43 89 -19 7 -92 62 68 23 -96 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:32 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=2004, securePort=-1, UDP Port=-1, id={-83 21 -45 72 -48 123 66 112 -91 -19 -85 -35 -123 74 -65 -3 }, payload={}, command={}, domain={43 89 -19 7 -92 62 68 23 -96 ...(16)}]] was refused to join cluster
Apr 23, 2024 1:52:32 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]
Apr 23, 2024 1:52:33 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:33 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:34 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52:37 PM org.apache.catalina.tribes.group.interceptors.TcpFailureDetector memberDisappeared
INFO: Received memberDisappeared[org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4003,{127, 0, 0, 1},4003, alive=1503, securePort=-1, UDP Port=-1, id={-30 -69 -103 28 -89 -52 70 104 -72 74 -29 47 11 21 -104 30 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={40 107 19 -57 -43 -55 74 -19 -68 ...(16)}]] message. Will verify.
Apr 23, 2024 1:52:37 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}:4003,{127, 0, 0, 1},4003, alive=1503, securePort=-1, UDP Port=-1, id={-30 -69 -103 28 -89 -52 70 104 -72 74 -29 47 11 21 -104 30 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={40 107 19 -57 -43 -55 74 -19 -68 ...(16)}]]
Apr 23, 2024 1:52:37 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@7c48ce96[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@1e1e19da[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f10a702fb60@5b1c847d]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@37374a5e[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2081)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:841)
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)
Apr 23, 2024 1:52:38 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@77aa68a6[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@3f7d24a8[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f10a702fb60@1715ad25]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@37374a5e[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2081)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:841)
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)
Apr 23, 2024 1:52: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@190c94a1[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@701ddb7[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f10a702fb60@3d4724f7]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@37374a5e[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2081)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:841)
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)
Apr 23, 2024 1:52:39 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:39 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000]
Apr 23, 2024 1:52:39 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:39 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:40 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:40 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:41 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52:41 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:41 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Apr 23, 2024 1:52:41 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:41 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:42 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:42 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:42 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:43 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52: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@5e68a985[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@5490c2f5[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f10a702fb60@5a573617]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@150c158[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 4]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2081)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:841)
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)
Apr 23, 2024 1:52:43 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:43 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000]
Apr 23, 2024 1:52:43 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:43 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:44 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:44 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:45 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52:45 PM org.apache.catalina.tribes.group.GroupChannel start
WARNING: No utility executor was set, creating one
Apr 23, 2024 1:52:45 PM org.apache.catalina.tribes.transport.ReceiverBase bind
INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001]
Apr 23, 2024 1:52:45 PM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket
INFO: Setting cluster mcast soTimeout to [500]
Apr 23, 2024 1:52:45 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4]
Apr 23, 2024 1:52:46 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[4]
Apr 23, 2024 1:52:46 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8]
Apr 23, 2024 1:52:47 PM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers
INFO: Done sleeping, membership established, start level:[8]
Apr 23, 2024 1:52:47 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.
Apr 23, 2024 1:52:47 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=2003, securePort=-1, UDP Port=-1, id={-28 -7 -40 81 99 86 76 12 -120 -48 62 47 -67 -117 55 -74 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={119 -6 -3 -25 81 104 78 37 -115 ...(16)}]] message. Will verify.
Apr 23, 2024 1:52:47 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=2003, securePort=-1, UDP Port=-1, id={-28 -7 -40 81 99 86 76 12 -120 -48 62 47 -67 -117 55 -74 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={119 -6 -3 -25 81 104 78 37 -115 ...(16)}]]
Apr 23, 2024 1:52:47 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@40e43c5e[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@1d93665[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f10a702fb60@5e6a286]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@4c762604[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 2]
at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2081)
at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:841)
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.359 sec
Testcase: testTcpFailureMemberAdd took 4.22 sec
Testcase: testTcpSendFailureMemberDrop took 4.119 sec
Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.
Last Updated: Tue, 23 Apr 2024 12:00:03 ().