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.831 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 31, 2023 9:13:13 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:13 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4002] Mar 31, 2023 9:13:13 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:13 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:14 AM 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=1503, securePort=-1, UDP Port=-1, id={-73 50 -91 -85 -101 19 65 110 -93 107 -66 -21 -42 66 -116 0 }, payload={}, command={}, domain={-108 111 -96 26 80 -47 79 -14 -128 ...(16)}]] was refused to join cluster Mar 31, 2023 9:13:14 AM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4001,{127, 0, 0, 1},4001, alive=1506, securePort=-1, UDP Port=-1, id={58 -90 4 -81 113 -108 77 58 -75 -47 125 89 53 119 -24 126 }, payload={}, command={}, domain={-108 111 -96 26 80 -47 79 -14 -128 ...(16)}]] was refused to join cluster Mar 31, 2023 9:13:14 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:14 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:15 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:15 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:15 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4003] Mar 31, 2023 9:13:15 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:15 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:16 AM 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={-73 50 -91 -85 -101 19 65 110 -93 107 -66 -21 -42 66 -116 0 }, payload={}, command={}, domain={-108 111 -96 26 80 -47 79 -14 -128 ...(16)}]] was refused to join cluster Mar 31, 2023 9:13:16 AM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4001,{127, 0, 0, 1},4001, alive=3507, securePort=-1, UDP Port=-1, id={58 -90 4 -81 113 -108 77 58 -75 -47 125 89 53 119 -24 126 }, payload={}, command={}, domain={-108 111 -96 26 80 -47 79 -14 -128 ...(16)}]] was refused to join cluster Mar 31, 2023 9:13:16 AM 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 31, 2023 9:13:16 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:16 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:17 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:19 AM 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@5b6a82a2[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@6acacdb1[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc7100@4eb4d769]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@36fec6d5[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 31, 2023 9:13:20 AM 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@6d8d84e[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@eab4cb2[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc7100@79444630]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@36fec6d5[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 31, 2023 9:13:20 AM 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={123 -47 -101 26 78 -119 65 -49 -107 -74 -26 126 38 -16 -54 47 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-27 51 -22 -95 -69 125 75 28 -81 ...(16)}]] message. Will verify. Mar 31, 2023 9:13:20 AM 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={123 -47 -101 26 78 -119 65 -49 -107 -74 -26 126 38 -16 -54 47 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-27 51 -22 -95 -69 125 75 28 -81 ...(16)}]] Mar 31, 2023 9:13:22 AM 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@33ff1d5c[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@280b1729[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc7100@7325b1de]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@36fec6d5[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 31, 2023 9:13:23 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:23 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000] Mar 31, 2023 9:13:23 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:23 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:24 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:24 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:25 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:25 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:25 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001] Mar 31, 2023 9:13:25 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:25 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:26 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:26 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:26 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:27 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:27 AM 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@23fd14c1[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@29057fb1[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc7100@27c284e1]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@66ff8eda[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 31, 2023 9:13:27 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:27 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000] Mar 31, 2023 9:13:27 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:27 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:28 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:28 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:29 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:29 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Mar 31, 2023 9:13:29 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001] Mar 31, 2023 9:13:29 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Mar 31, 2023 9:13:29 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Mar 31, 2023 9:13:30 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Mar 31, 2023 9:13:30 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Mar 31, 2023 9:13:31 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Mar 31, 2023 9:13:31 AM 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 31, 2023 9:13:31 AM 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={-116 52 -60 -7 93 109 67 -33 -88 1 89 -112 -97 -71 -13 24 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-128 -76 -7 -19 -97 -105 66 105 -107 ...(16)}]] message. Will verify. Mar 31, 2023 9:13:31 AM 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={-116 52 -60 -7 93 109 67 -33 -88 1 89 -112 -97 -71 -13 24 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={-128 -76 -7 -19 -97 -105 66 105 -107 ...(16)}]] Mar 31, 2023 9:13:31 AM 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@7e042a58[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@3f392063[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda$84/0x0000000800cc7100@3b06b35c]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@39fcb20c[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.36 sec Testcase: testTcpFailureMemberAdd took 4.228 sec Testcase: testTcpSendFailureMemberDrop took 4.233 sec
Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.