Users are logged out "in the middle of sessions", have to reauthenticate

Hi,

New to MWS… (so be nice)…

Our users sessions intermittently “stop”, and they are brought back to reauthenticate. Sometimes they are in the middle of working when this happens…

I have aggregated some of the logs from ./MWS/server/default/logs/audit.log and full.log to demo one user below. Has anyone any idea where to start looking for the issue?

From what I can gather they are simply pushed back to the authentication screen in the middle of doing work… sometimes a while has passed since last activity, therefore timeout, however this is not always the case…

Any pointers???

============================

2016-05-12 09:27:01 BST (Framework:INFO) [RID:61851] - Trying to authenticate user: U123456
2016-05-12 09:27:04 BST (Framework:INFO) [RID:61851] - user U123456 authenticated = true
2016-05-12 09:27:08 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463041628251; username=Dom AB/U123456; action=Logged In
2016-05-12 09:27:09 BST (Framework:INFO) [RID:61865] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/appname.pages.application.personrecord.navigation (GET)
2016-05-12 09:27:44 BST (Framework:INFO) [RID:61913] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)

2016-05-12 09:52:57 BST (Framework:INFO) [RID:64115] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET)
2016-05-12 09:54:27 BST (Framework:INFO) [RID:64241] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST) 2016-05-12 09:54:38 BST (Framework:INFO) [RID:64254] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/ (GET)
2016-05-12 09:54:49 BST (Framework:INFO) [RID:64270] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/appname.pages.application.personrecord.search (GET)
2016-05-12 09:54:58 BST (Framework:INFO) [RID:64280] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST) 2016-05-12 09:54:59 BST (Framework:INFO) [RID:64282] - Request [wv761e2fydrz11bhent2gk8bv:U123456] http://sServer1:8787/ (GET)
2016-05-12 09:55:03 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463043303903; username=Dom AB/U123456; action=Logged Out
2016-05-12 09:55:34 BST (Framework:INFO) [RID:64326] - Trying to authenticate user: U123456
2016-05-12 09:55:35 BST (Framework:INFO) [RID:64326] - user U123456 authenticated = true
2016-05-12 09:55:37 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463043337945; username=Dom AB/U123456; action=Logged In
2016-05-12 09:55:38 BST (Framework:INFO) [RID:64328] - Request [1uiyfc10r997j33xo5qag16cs:U123456] http://sServer1:8787/user.current.start.page (GET)

2016-05-12 10:41:10 BST (Framework:INFO) [RID:68110] - Request [1uiyfc10r997j33xo5qag16cs:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET)
2016-05-12 10:41:16 BST (Framework:INFO) [RID:68126] - Request [1uiyfc10r997j33xo5qag16cs:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST) 2016-05-12 10:41:18 BST (Framework:INFO) [RID:68129] - Request [1uiyfc10r997j33xo5qag16cs:U123456] http://sServer1:8787/ (GET)
2016-05-12 10:41:29 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463046089392; username=Dom AB/U123456; action=Logged Out
2016-05-12 10:41:40 BST (Framework:INFO) [RID:68169] - Trying to authenticate user: U123456
2016-05-12 10:41:41 BST (Framework:INFO) [RID:68169] - user U123456 authenticated = true
2016-05-12 10:41:46 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463046106194; username=Dom AB/U123456; action=Logged In
2016-05-12 10:41:49 BST (Framework:INFO) [RID:68178] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/user.current.start.page (GET)
2016-05-12 10:48:41 BST (Framework:INFO) [RID:68902] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/appname.pages.application.personrecord.search (GET)

2016-05-12 11:48:24 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463050104141; username=Dom AB/U123456; action=Logged In

2016-05-12 11:46:42 BST (Framework:INFO) [RID:74407] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/meta/default/folder/0000008956 (GET) 2016-05-12 11:46:49 BST (Framework:INFO) [RID:74426] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 11:47:17 BST (Framework:INFO) [RID:74465] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST)
2016-05-12 11:47:18 BST (Framework:INFO) [RID:74466] - Request [1q5kaitvur9ky1974e3up73p63:U123456] http://sServer1:8787/ (GET)
2016-05-12 11:47:35 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463050055203; username=Dom AB/U123456; action=Logged Out
2016-05-12 11:48:16 BST (Framework:INFO) [RID:74560] - Trying to authenticate user: U123456
2016-05-12 11:48:19 BST (Framework:INFO) [RID:74560] - user U123456 authenticated = true
2016-05-12 11:47:35 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463050055203; username=Dom AB/U123456; action=Logged Out
2016-05-12 11:48:25 BST (Framework:INFO) [RID:74565] - Request [1c4yl0eldj2ft1119oeq2i0ano:U123456] http://sServer1:8787/user.current.start.page (GET)

2016-05-12 12:31:09 BST (Framework:INFO) [RID:78583] - Request [1c4yl0eldj2ft1119oeq2i0ano:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET) 2016-05-12 12:31:12 BST (Framework:INFO) [RID:78585] - Request [1c4yl0eldj2ft1119oeq2i0ano:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST)
2016-05-12 12:31:12 BST (Framework:INFO) [RID:78587] - Request [1c4yl0eldj2ft1119oeq2i0ano:U123456] http://sServer1:8787/ (GET)
2016-05-12 12:31:15 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463052675486; username=Dom AB/U123456; action=Logged Out
LUNCH
2016-05-12 13:02:16 BST (Framework:INFO) [RID:81417] - Trying to authenticate user: U123456
2016-05-12 13:02:19 BST (Framework:INFO) [RID:81417] - user U123456 authenticated = true
2016-05-12 13:02:22 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463054542712; username=Dom AB/U123456; action=Logged In
2016-05-12 13:02:25 BST (Framework:INFO) [RID:81429] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/user.current.start.page (GET)

2016-05-12 13:25:51 BST (Framework:INFO) [RID:83421] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET)
2016-05-12 13:25:52 BST (Framework:INFO) [RID:83423] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/appname.pages.application.personrecord.navigation (GET)
2016-05-12 13:30:00 BST (Framework:INFO) [RID:83769] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:05 BST (Framework:INFO) [RID:83776] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:09 BST (Framework:INFO) [RID:83775] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:12 BST (Framework:INFO) [RID:83774] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:14 BST (Framework:INFO) [RID:83773] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:16 BST (Framework:INFO) [RID:83772] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:19 BST (Framework:INFO) [RID:83771] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST)
2016-05-12 13:30:22 BST (Framework:INFO) [RID:83788] - Request [rr9gunn4kuttso2mg5liraac:U123456] http://sServer1:8787/ (GET)
2016-05-12 13:30:32 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463056232166; username=Dom AB/U123456; action=Logged Out
2016-05-12 13:30:46 BST (Framework:INFO) [RID:83843] - Trying to authenticate user: U123456
2016-05-12 13:30:48 BST (Framework:INFO) [RID:83843] - user U123456 authenticated = true
2016-05-12 13:30:54 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463056254813; username=Dom AB/U123456; action=Logged In
2016-05-12 13:30:59 BST (Framework:INFO) [RID:83862] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/user.current.start.page (GET)
2016-05-12 13:34:41 BST (Framework:INFO) [RID:84130] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/appname.pages.application.personrecord.search (GET)
2016-05-12 13:34:52 BST (Framework:INFO) [RID:84145] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST)


2016-05-12 14:12:00 BST (Framework:INFO) [RID:87493] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET) 2016-05-12 14:12:21 BST (Framework:INFO) [RID:87526] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/ (GET)
2016-05-12 14:12:33 BST (Framework:INFO) [RID:87543] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/appname.pages.application.personrecord.search (GET)
2016-05-12 14:12:38 BST (Framework:INFO) [RID:87549] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST)
2016-05-12 14:12:38 BST (Framework:INFO) [RID:87550] - Request [1d2zkosmy0g601jvbd4pa0245p:U123456] http://sServer1:8787/ (GET)
2016-05-12 14:12:41 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463058761159; username=Dom AB/U123456; action=Logged Out
2016-05-12 14:12:52 BST (Framework:INFO) [RID:87573] - Trying to authenticate user: U123456
2016-05-12 14:12:53 BST (Framework:INFO) [RID:87573] - user U123456 authenticated = true
2016-05-12 14:12:57 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463058777030; username=Dom AB/U123456; action=Logged In
2016-05-12 14:12:59 BST (Framework:INFO) [RID:87579] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/user.current.start.page (GET)


2016-05-12 15:02:50 BST (Framework:INFO) [RID:91012] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/meta/default/folder/0000008956 (GET)
2016-05-12 15:02:50 BST (Framework:INFO) [RID:91013] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/meta/default/folder/0000008956 (GET)
2016-05-12 15:02:51 BST (Framework:INFO) [RID:91014] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/meta/default/folder/0000008955 (POST) 2016-05-12 15:02:51 BST (Framework:INFO) [RID:91015] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/meta/default/folder/0000008955 (GET)
2016-05-12 15:03:20 BST (Framework:INFO) [RID:91032] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/meta/default/folder/0000008956 (POST) 2016-05-12 15:03:21 BST (Framework:INFO) [RID:91033] - Request [kr84m9r1guz619xryisi7yakw:U123456] http://sServer1:8787/ (GET)
2016-05-12 15:03:22 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463061802945; username=Dom AB/U123456; action=Logged Out
2016-05-12 15:03:40 BST (Framework:INFO) [RID:91044] - Trying to authenticate user: U123456
2016-05-12 15:03:41 BST (Framework:INFO) [RID:91044] - user U123456 authenticated = true
2016-05-12 15:03:46 BST (Audit:INFO) - LoginEvent; ip-address=10.11.12.13; timestamp=1463061826904; username=Dom AB/U123456; action=Logged In
2016-05-12 15:03:47 BST (Framework:INFO) [RID:91048] - Request [zocx3lvbyfc81bhyhjcc9vs5a:U123456] http://sServer1:8787/user.current.start.page (GET)
2016-05-12 15:03:55 BST (Framework:INFO) [RID:91055] - Request [zocx3lvbyfc81bhyhjcc9vs5a:U123456] http://sServer1:8787/appname.pages.application.personrecord.search (GET)

=================================

Hi Martin,

please provide wM Version and Fix Levels for your MWS.

As Session Timeout is defined as 10 minutes (if I remember right) most likely our users are getting this Timeout.

Are there any intermediate network components or browser settings which might drop off the session informations?

Can you explain the steps the users are trying perform when this happens a bit more in detail please?

Regards,
Holger

Hi Holger,

Thank you for coming back to me so quickly…

I think I have another piece of the puzzle… I have been searching for any related errors for a long time, and think i have found the error!!! (:slight_smile: (I just dont understand it :frowning: )…

… at the point that user is kicked back to the re-authentication screen, I managed to tie the RID: of a used call immediatly before the “logout” back to an RID: in the problem log. I have checked for a few of these and all the ones so far tie up and look liek the error below;

Please tell me(I hope!) that you have seen this before somewhere :slight_smile:

Many Thanks,
Martin.

2016-05-12 15:02:51 BST (jsf:ERROR) [RID:91013] - Render phase of the portlet failed java.lang.IllegalStateException
at com.webmethods.caf.faces.data.object.ListTableContentProvider.deleteRow(ListTableContentProvider.java:412)
at com.webmethods.caf.faces.data.object.SelectableListTableContentProvider.deleteRow(SelectableListTableContentProvider.java:306)
at com.webmethods.caf.tasksearch.TaskSearchDefaultviewView.removeTaskLink(TaskSearchDefaultviewView.java:318)
at com.webmethods.caf.tasksearch.TaskSearchDefaultviewView.beforeRenderResponse(TaskSearchDefaultviewView.java:336)
at com.webmethods.caf.faces.bean.BaseViewBean.beforePhase(BaseViewBean.java:92)
at com.webmethods.caf.faces.bean.FacesBeanPhaseListener.beforePhase(FacesBeanPhaseListener.java:44)
at com.webmethods.caf.faces.portlet.PortletLifecycle.phase(PortletLifecycle.java:301)
at com.webmethods.caf.faces.portlet.PortletLifecycle.render(PortletLifecycle.java:234)
at com.webmethods.caf.faces.portlet.FacesPortlet.render(FacesPortlet.java:503)
at com.webmethods.portal.framework.portletcontainer.impl.PortletApplicationHandler.process(PortletApplicationHandler.java:551)
at com.webmethods.portal.framework.portletcontainer.servlet.PortletServlet.service(PortletServlet.java:58)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:770)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:503)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:575)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:429)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.Dispatcher.include(Dispatcher.java:183)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.dispatch(PortletContainer.java:223)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.process(PortletContainer.java:132)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.renderPortlet(PortletContainer.java:105)
at com.webmethods.portal.framework.portletcontainer.beans.PortletBean.processRequest(PortletBean.java:193)
at com.webmethods.portal.framework.portletcontainer.beans.PortletBean.getContentInternal(PortletBean.java:82)
at com.webmethods.portal.framework.portlet.beans.BasicPortletBean.getContent(BasicPortletBean.java:151)
at com.webmethods.portal.mech.portlet.impl.PortletMechanics.getPortletContent(PortletMechanics.java:96)
at com.webmethods.portal.mech.storage.page.PortletHelper.renderContent(PortletHelper.java:430)
at com.webmethods.portal.mech.storage.page.PortletHelper.renderContent(PortletHelper.java:402)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderPortlet(PortalPageSubRenderer.java:597)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderColumn(PortalPageSubRenderer.java:429)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderRow(PortalPageSubRenderer.java:285)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderContent(PortalPageSubRenderer.java:146)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.subrender(PortalPageSubRenderer.java:124)
at com.webmethods.portal.framework.presentation.renderers.NoodleRenderer.renderPageContent(NoodleRenderer.java:67)
at com.webmethods.portal.framework.presentation.renderers.DefaultRenderer.render(DefaultRenderer.java:345)
at com.webmethods.portal.framework.presentation.PresentationManager.handlePres(PresentationManager.java:431)
at com.webmethods.portal.framework.dispatch.DispatchManager.pres(DispatchManager.java:692)
at com.webmethods.portal.framework.dispatch.DispatchManager.handle(DispatchManager.java:522)
at com.webmethods.portal.framework.dispatch.DispatchManager.handleDispatch(DispatchManager.java:424)
at com.webmethods.portal.framework.impl.PortalServlet.service(PortalServlet.java:313)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:770)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1496)
at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:82)
at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:294)
at com.webmethods.caf.faces.servlet.GZIPFilter.doFilter(GZIPFilter.java:48)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1484)
at com.webmethods.portal.framework.impl.NTLMV1Filter.doFilter(NTLMV1Filter.java:67)
at com.webmethods.portal.framework.impl.NTLMFilter.doFilter(NTLMFilter.java:26)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1484)
at com.webmethods.portal.framework.impl.RequestFilter.doFilter(RequestFilter.java:56)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1476)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:501)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:429)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:255)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:154)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:971)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1033)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:724)

I noticed the following associated error in one of the other logs with the same RID:

Does anyone have any idea what could be causing these java errors in the applicaiton framework, and causing our users to be logged out in the middle of thier sessions?

Many Thanks,
Martin.

2016-05-12 15:02:51 BST (Framework:INFO) [RID:91013] - [POP.001.0002] A “java.lang.IllegalStateException” occurred with the Message “at com.webmethods.c
af.faces.data.object.ListTableContentProvider.deleteRow(ListTableContentProvider.java:412)”
java.lang.IllegalStateException
at com.webmethods.caf.faces.data.object.ListTableContentProvider.deleteRow(ListTableContentProvider.java:412)
at com.webmethods.caf.faces.data.object.SelectableListTableContentProvider.deleteRow(SelectableListTableContentProvider.java:306)
at com.webmethods.caf.tasksearch.TaskSearchDefaultviewView.removeTaskLink(TaskSearchDefaultviewView.java:318)
at com.webmethods.caf.tasksearch.TaskSearchDefaultviewView.beforeRenderResponse(TaskSearchDefaultviewView.java:336)
at com.webmethods.caf.faces.bean.BaseViewBean.beforePhase(BaseViewBean.java:92)
at com.webmethods.caf.faces.bean.FacesBeanPhaseListener.beforePhase(FacesBeanPhaseListener.java:44)
at com.webmethods.caf.faces.portlet.PortletLifecycle.phase(PortletLifecycle.java:301)
at com.webmethods.caf.faces.portlet.PortletLifecycle.render(PortletLifecycle.java:234)
at com.webmethods.caf.faces.portlet.FacesPortlet.render(FacesPortlet.java:503)
at com.webmethods.portal.framework.portletcontainer.impl.PortletApplicationHandler.process(PortletApplicationHandler.java:551)
at com.webmethods.portal.framework.portletcontainer.servlet.PortletServlet.service(PortletServlet.java:58)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:770)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:503)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:575)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:429)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.Dispatcher.include(Dispatcher.java:183)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.dispatch(PortletContainer.java:223)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.process(PortletContainer.java:132)
at com.webmethods.portal.framework.portletcontainer.PortletContainer.renderPortlet(PortletContainer.java:105)
at com.webmethods.portal.framework.portletcontainer.beans.PortletBean.processRequest(PortletBean.java:193)
at com.webmethods.portal.framework.portletcontainer.beans.PortletBean.getContentInternal(PortletBean.java:82)
at com.webmethods.portal.framework.portlet.beans.BasicPortletBean.getContent(BasicPortletBean.java:151)
at com.webmethods.portal.mech.portlet.impl.PortletMechanics.getPortletContent(PortletMechanics.java:96)
at com.webmethods.portal.mech.storage.page.PortletHelper.renderContent(PortletHelper.java:430)
at com.webmethods.portal.mech.storage.page.PortletHelper.renderContent(PortletHelper.java:402)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderPortlet(PortalPageSubRenderer.java:597)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderColumn(PortalPageSubRenderer.java:429)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderRow(PortalPageSubRenderer.java:285)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.renderContent(PortalPageSubRenderer.java:146)
at com.webmethods.portal.framework.presentation.renderers.PortalPageSubRenderer.subrender(PortalPageSubRenderer.java:124)
at com.webmethods.portal.framework.presentation.renderers.NoodleRenderer.renderPageContent(NoodleRenderer.java:67)
at com.webmethods.portal.framework.presentation.renderers.DefaultRenderer.render(DefaultRenderer.java:345)
at com.webmethods.portal.framework.presentation.PresentationManager.handlePres(PresentationManager.java:431)
at com.webmethods.portal.framework.dispatch.DispatchManager.pres(DispatchManager.java:692)
at com.webmethods.portal.framework.dispatch.DispatchManager.handle(DispatchManager.java:522)
at com.webmethods.portal.framework.dispatch.DispatchManager.handleDispatch(DispatchManager.java:424)
at com.webmethods.portal.framework.impl.PortalServlet.service(PortalServlet.java:313)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:770)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1496)
at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:82)
at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:294)
at com.webmethods.caf.faces.servlet.GZIPFilter.doFilter(GZIPFilter.java:48)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1484)
at com.webmethods.portal.framework.impl.NTLMV1Filter.doFilter(NTLMV1Filter.java:67)
at com.webmethods.portal.framework.impl.NTLMFilter.doFilter(NTLMFilter.java:26)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1484)
at com.webmethods.portal.framework.impl.RequestFilter.doFilter(RequestFilter.java:56)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1476)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:501)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:429)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:255)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:154)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:971)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1033)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:724)

Hi Martin,

I would suggest to open an incident with SAG Support for this.

They might be able to help you to analyze this deeper.

Not sure why the IllegalStateException of the ListTableContentProvider would/could cause the reauthentication.

Regards,
Holger