[ 
https://issues.apache.org/jira/browse/OPENMEETINGS-2301?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17095267#comment-17095267
 ] 

Konstantin Kuzov commented on OPENMEETINGS-2301:
------------------------------------------------

I'm already in the process of bisecting but maven is painfully slow in 
downloading some dependencies so it will take a while... For some reason 
Client.getRoom() is sometimes null while RoomPanel.getRoom() isn't. Clients 
which are already in the room observing growing list of duplicates in the room 
users tab every time it happens. Which are stuck indefinetely and only 
re-entering to the room clears them for that client.

Some curious thing is that on debian 10 with the same build, pretty much 
similar runtime, the same VM profile and on the same hardware the problem is 
really hard to reproduce. I only reproduced it by mashing F5 while in room for 
like 50+ times. When on centos 8.1 it triggers way more often without any abuse.

> Sporadic internal error on room entering
> ----------------------------------------
>
>                 Key: OPENMEETINGS-2301
>                 URL: https://issues.apache.org/jira/browse/OPENMEETINGS-2301
>             Project: Openmeetings
>          Issue Type: Bug
>          Components: Room
>    Affects Versions: 5.0.0-M4
>            Reporter: Konstantin Kuzov
>            Assignee: Maxim Solodovnik
>            Priority: Critical
>             Fix For: 5.0.0-M5
>
>
> Sometimes when entering a room it throws Internal error page.
> {code:java}
> DEBUG 04-26 05:00:31.359 o.a.o.w.a.ClientManager:386 [nio-5443-exec-2] - 
> Cluster:: The only server found
> DEBUG 04-26 05:00:31.360 o.a.o.w.c.MainPanel:401 [nio-5443-exec-2] - 
> updateContents:: npanels IS null ? false, client IS null ? false
> DEBUG 04-26 05:00:31.376 o.a.o.w.r.RoomPanel:345 [nio-5443-exec-2] - public ? 
> true, ownedId ? null true
> DEBUG 04-26 05:00:31.377 o.a.o.d.d.l.ConferenceLogDao:52 [nio-5443-exec-2] - 
> [add]: org.apache.openmeetings.db.entity.log.ConferenceLog@4abadb1e
> DEBUG 04-26 05:00:31.400 o.a.o.w.a.ClientManager:232 [nio-5443-exec-2] - 
> Adding online room client: 170bfba9-781c-40da-91b0-6db499ee5679, room: 3
> DEBUG 04-26 05:00:31.402 o.a.o.w.a.ClientManager:250 [nio-5443-exec-2] - 
> Cluster:: room 3 was not found for server 'server-1', adding ...
> DEBUG 04-26 05:00:31.403 o.a.o.w.a.ClientManager:479 [nio-5443-exec-2] - 
> Cluster:: room 3 is added to server, whole list [3]
> DEBUG 04-26 05:00:31.403 o.a.o.w.a.ClientManager:117 [erver-1.event-1] - 
> Cluster:: Server was updated server-1 -> ServerInfo[rooms: [3]]
> DEBUG 04-26 05:00:31.405 o.a.o.d.u.AuthLevelUtil:40 [nio-5443-exec-2] - Level 
> ADMIN :: [GRANTED]
>  INFO 04-26 05:00:31.406 o.a.o.w.r.RoomPanel:394 [nio-5443-exec-2] - Setting 
> rights for client:: [SUPER_MODERATOR] -> true
> DEBUG 04-26 05:00:31.407 o.a.o.d.u.AuthLevelUtil:40 [nio-5443-exec-2] - Level 
> ADMIN :: [GRANTED]
> DEBUG 04-26 05:00:31.409 o.a.o.d.d.r.PollDao:87 [nio-5443-exec-2] -  :: 
> getPoll :: 3
> DEBUG 04-26 05:00:31.415 o.a.o.d.d.r.PollDao:98 [nio-5443-exec-2] -  :: 
> getArchived :: 3
> DEBUG 04-26 05:00:31.440 o.a.o.d.d.f.FileItemDao:55 [nio-5443-exec-2] - 
> getByOwner() started
> DEBUG 04-26 05:00:31.446 o.a.o.d.d.f.FileItemDao:50 [nio-5443-exec-2] - 
> getByRoom roomId :: 3
> DEBUG 04-26 05:00:31.716 o.a.o.w.r.RoomPanel:136 [nio-5443-exec-3] - 
> RoomPanel::roomEnter
> DEBUG 04-26 05:00:31.726 o.a.o.w.r.RoomPanel:166 [nio-5443-exec-3] - 
> RoomPanel::roomEnter, mods IS EMPTY ? false, is MOD ? true
> DEBUG 04-26 05:00:31.735 o.a.o.d.d.r.PollDao:104 [Thread-127] -  :: hasPoll 
> :: 3
> DEBUG 04-26 05:00:31.740 o.a.o.d.d.r.PollDao:98 [Thread-127] -  :: 
> getArchived :: 3
> DEBUG 04-26 05:00:31.741 o.a.o.c.r.KurentoHandler:222 [Thread-127] - 
> Searching for room 3
> DEBUG 04-26 05:00:31.741 o.a.o.c.r.KurentoHandler:226 [Thread-127] - Room 3 
> does not exist. Will create now!
>  INFO 04-26 05:00:31.763 o.a.o.c.r.KRoom:75 [Thread-127] - ROOM 3 has been 
> created
> DEBUG 04-26 05:00:31.763 o.a.o.c.r.KurentoHandler:236 [Thread-127] - Room 3 
> found!
> DEBUG 04-26 05:00:31.764 o.a.o.c.r.KurentoHandler:397 [EventExec-e2-t4] - 
> Kurento::ObjectCreated -> [RemoteObject: type=MediaPipeline 
> remoteRef=fec772df-072e-4a32-8f5a-c94150645f2f_kurento.MediaPipeline]
> ERROR 04-26 05:00:31.833 o.a.w.DefaultExceptionMapper:170 [nio-5443-exec-1] - 
> Unexpected error occurred
> java.lang.NullPointerException: null
>         at 
> org.apache.openmeetings.web.room.sidebar.RoomSidebar$1.respond(RoomSidebar.java:94)
>         at 
> org.apache.wicket.ajax.AbstractDefaultAjaxBehavior.onRequest(AbstractDefaultAjaxBehavior.java:597)
>         at 
> org.apache.wicket.core.request.handler.ListenerRequestHandler.internalInvoke(ListenerRequestHandler.java:306)
>         at 
> org.apache.wicket.core.request.handler.ListenerRequestHandler.invoke(ListenerRequestHandler.java:280)
>         at 
> org.apache.wicket.core.request.handler.ListenerRequestHandler.invokeListener(ListenerRequestHandler.java:222)
>         at 
> org.apache.wicket.core.request.handler.ListenerRequestHandler.respond(ListenerRequestHandler.java:208)
>         at 
> org.apache.wicket.request.cycle.RequestCycle$HandlerExecutor.respond(RequestCycle.java:917)
>         at 
> org.apache.wicket.request.RequestHandlerExecutor.execute(RequestHandlerExecutor.java:63)
>         at 
> org.apache.wicket.request.cycle.RequestCycle.execute(RequestCycle.java:283)
>         at 
> org.apache.wicket.request.cycle.RequestCycle.processRequest(RequestCycle.java:254)
>         at 
> org.apache.wicket.request.cycle.RequestCycle.processRequestAndDetach(RequestCycle.java:222)
>         at 
> org.apache.wicket.protocol.ws.AbstractUpgradeFilter.processRequestCycle(AbstractUpgradeFilter.java:71)
>         at 
> org.apache.wicket.protocol.http.WicketFilter.processRequest(WicketFilter.java:207)
>         at 
> org.apache.wicket.protocol.http.WicketFilter.doFilter(WicketFilter.java:300)
>         at 
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
>         at 
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
>         at 
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202)
>         at 
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
>         at 
> org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:666)
>         at 
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:139)
>         at 
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)
>         at 
> org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690)
>         at 
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74)
>         at 
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
>         at 
> org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:373)
>         at 
> org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
>         at 
> org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
>         at 
> org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
>         at 
> org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
>         at 
> java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>         at 
> java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>         at 
> org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
>         at java.base/java.lang.Thread.run(Thread.java:834)
> DEBUG 04-26 05:00:31.888 o.a.o.d.u.AuthLevelUtil:40 [io-5443-exec-10] - Level 
> ADMIN :: [GRANTED]
> DEBUG 04-26 05:00:31.931 o.a.o.w.c.OmWebSocketPanel:188 [nio-5443-exec-8] - 
> WebSocketBehavior::closeHandler The client closed its connection with code 
> '1001' and message: 'null'
> DEBUG 04-26 05:00:31.936 o.a.o.d.d.l.ConferenceLogDao:52 [nio-5443-exec-8] - 
> [add]: org.apache.openmeetings.db.entity.log.ConferenceLog@3801c6a2
> DEBUG 04-26 05:00:32.023 o.a.o.w.a.ClientManager:263 [nio-5443-exec-8] - 
> Removing online room client: 170bfba9-781c-40da-91b0-6db499ee5679, room: null
> DEBUG 04-26 05:00:32.024 o.a.o.w.a.ClientManager:190 [nio-5443-exec-8] - 
> Removing online client: 170bfba9-781c-40da-91b0-6db499ee5679, roomId: null
> {code}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)

Reply via email to