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.714 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 26, 2024 8:30:12 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:12 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001] Apr 26, 2024 8:30:12 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:12 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30:12 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=1502, securePort=-1, UDP Port=-1, id={-16 -83 -1 -5 -24 -110 77 93 -120 60 55 -112 77 79 -71 12 }, payload={}, command={}, domain={-64 66 -96 53 43 -39 77 118 -127 ...(16)}]] was refused to join cluster Apr 26, 2024 8:30:12 AM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4009,{127, 0, 0, 1},4009, alive=1506, securePort=-1, UDP Port=-1, id={-59 81 119 107 67 110 73 -54 -116 -75 -73 36 103 -73 -26 127 }, payload={}, command={}, domain={-64 66 -96 53 43 -39 77 118 -127 ...(16)}]] was refused to join cluster Apr 26, 2024 8:30:13 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:13 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4002] Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30: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=3504, securePort=-1, UDP Port=-1, id={-16 -83 -1 -5 -24 -110 77 93 -120 60 55 -112 77 79 -71 12 }, payload={}, command={}, domain={-64 66 -96 53 43 -39 77 118 -127 ...(16)}]] was refused to join cluster Apr 26, 2024 8:30:14 AM org.apache.catalina.tribes.group.interceptors.DomainFilterInterceptor memberAdded INFO: Member [org.apache.catalina.tribes.membership.MemberImpl[tcp://{127, 0, 0, 1}:4009,{127, 0, 0, 1},4009, alive=3507, securePort=-1, UDP Port=-1, id={-59 81 119 107 67 110 73 -54 -116 -75 -73 36 103 -73 -26 127 }, payload={}, command={}, domain={-64 66 -96 53 43 -39 77 118 -127 ...(16)}]] was refused to join cluster Apr 26, 2024 8:30:14 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.BufferPool15Impl] Apr 26, 2024 8:30:15 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:15 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:16 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:17 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@494fa853[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@78fdd27a[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f27870c5848@76f2641c]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@7a3d45bd[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:432) at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:380) at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:580) Apr 26, 2024 8:30:19 AM 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=1503, securePort=-1, UDP Port=-1, id={40 121 -11 -78 -41 3 77 121 -108 -73 -35 127 122 -20 31 -27 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={34 16 25 -122 53 4 66 -38 -93 ...(16)}]] message. Will verify. Apr 26, 2024 8:30:19 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}:4002,{127, 0, 0, 1},4002, alive=1503, securePort=-1, UDP Port=-1, id={40 121 -11 -78 -41 3 77 121 -108 -73 -35 127 122 -20 31 -27 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={34 16 25 -122 53 4 66 -38 -93 ...(16)}]] Apr 26, 2024 8:30:21 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@4921bd70[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@76ca4277[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f27870c5848@13d9f92f]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@7a3d45bd[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:432) at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:380) at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:580) Apr 26, 2024 8:30:21 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:21 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000] Apr 26, 2024 8:30:21 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:21 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30:22 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:22 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:23 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:23 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:23 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001] Apr 26, 2024 8:30:23 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:23 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30:24 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:24 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:24 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:25 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:25 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@6353e8c8[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@69ab83b8[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f27870c5848@676c60fd]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@32eebfca[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:432) at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:380) at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:580) Apr 26, 2024 8:30:25 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:25 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4000] Apr 26, 2024 8:30:25 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:25 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30:26 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:26 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:27 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:27 AM org.apache.catalina.tribes.group.GroupChannel start WARNING: No utility executor was set, creating one Apr 26, 2024 8:30:27 AM org.apache.catalina.tribes.transport.ReceiverBase bind INFO: Receiver Server Socket bound to:[localhost/127.0.0.1:4001] Apr 26, 2024 8:30:27 AM org.apache.catalina.tribes.membership.McastServiceImpl setupSocket INFO: Setting cluster mcast soTimeout to [500] Apr 26, 2024 8:30:27 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[4] Apr 26, 2024 8:30:28 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[4] Apr 26, 2024 8:30:28 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Sleeping for [1000] milliseconds to establish cluster membership, start level:[8] Apr 26, 2024 8:30:29 AM org.apache.catalina.tribes.membership.McastServiceImpl waitForMembers INFO: Done sleeping, membership established, start level:[8] Apr 26, 2024 8:30:29 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. Apr 26, 2024 8:30:29 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=2004, securePort=-1, UDP Port=-1, id={-82 -19 15 -128 -8 121 64 13 -88 -116 -32 94 -85 -42 -35 -116 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={29 -45 -88 -11 -16 81 67 104 -93 ...(16)}]] message. Will verify. Apr 26, 2024 8:30:29 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=2004, securePort=-1, UDP Port=-1, id={-82 -19 15 -128 -8 121 64 13 -88 -116 -32 94 -85 -42 -35 -116 }, payload={67 104 97 110 110 101 108 45 50 ...(9)}, command={}, domain={29 -45 -88 -11 -16 81 67 104 -93 ...(16)}]] Apr 26, 2024 8:30:29 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@65ae0dee[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@249307d5[Wrapped task = org.apache.catalina.tribes.membership.McastServiceImpl$$Lambda/0x00007f27870c5848@20ac879f]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@64485a47[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:432) at org.apache.catalina.tribes.membership.McastServiceImpl.receive(McastServiceImpl.java:380) at org.apache.catalina.tribes.membership.McastServiceImpl$ReceiverThread.run(McastServiceImpl.java:580) ------------- ---------------- --------------- Testcase: testTcpMcastFail took 9.351 sec Testcase: testTcpFailureMemberAdd took 4.215 sec Testcase: testTcpSendFailureMemberDrop took 4.14 sec
Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.