Uploaded image for project: '[Read Only] - Hippo Repository'
  1. [Read Only] - Hippo Repository
  2. REPO-101

Cluster journal appending fails during concurrent writes to multiple repository nodes in the cluster

    XMLWordPrintable

Details

    • Bug
    • Status: Closed
    • Normal
    • Resolution: Outdated
    • None
    • Backlog
    • None
    • None
    • CMS 2.12.09. Linux, Mysql Ver 5.0.51a-3ubuntu5.5-log for debian-linux-gnu on x86_64 ((Ubuntu)), Java(TM) SE Runtime Environment (build 1.6.0_20-b02)
      Java HotSpot(TM) 64-Bit Server VM (build 16.3-b01, mixed mode), mysql-connector-java-5.0.8-bin.jar

    Description

      This is probably an upstream (jackrabbit) issue.

      Jun 24 12:50:40 s1720 2010-06-24 12:50:40,410 ERROR [TP-Processor13] org.apache.jackrabbit.core.cluster.ClusterNode - Unable to commit log entry.
      Jun 24 12:50:40 s1720 org.apache.jackrabbit.core.journal.JournalException: Unable to append revision 4364629.
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.journal.DatabaseJournal.append(DatabaseJournal.java:558)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.journal.AppendRecord.update(AppendRecord.java:251)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.cluster.ClusterNode$WorkspaceUpdateChannel.updateCommitted(ClusterNode.java:650)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.SharedItemStateManager$Update.end(SharedItemStateManager.java:758)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.SharedItemStateManager.update(SharedItemStateManager.java:1104)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.jackrabbit.HippoSharedItemStateManager.update(HippoSharedItemStateManager.java:59)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.LocalItemStateManager.update(LocalItemStateManager.java:351)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.ForkedXAItemStateManager.update(ForkedXAItemStateManager.java:360)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.jackrabbit.HippoLocalItemStateManager.update(HippoLocalItemStateManager.java:227)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.LocalItemStateManager.update(LocalItemStateManager.java:326)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.jackrabbit.HippoLocalItemStateManager.update(HippoLocalItemStateManager.java:235)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.state.SessionItemStateManager.update(SessionItemStateManager.java:313)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.ItemImpl.save(ItemImpl.java:1103)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.SessionImpl.save(SessionImpl.java:858)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.decorating.SessionDecorator.save(SessionDecorator.java:202)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.impl.SessionDecorator.save(SessionDecorator.java:179)
      Jun 24 12:50:40 s1720 at org.hippoecm.repository.impl.WorkflowManagerImpl$WorkflowInvocationHandler.invoke(WorkflowManagerImpl.java:499)
      Jun 24 12:50:40 s1720 at $Proxy3.obtainEditableInstance(Unknown Source)
      Jun 24 12:50:40 s1720 at org.hippoecm.frontend.plugins.reviewedactions.FullReviewedActionsWorkflowPlugin$3.execute(FullReviewedActionsWorkflowPlugin.java:137)
      Jun 24 12:50:40 s1720 at org.hippoecm.addon.workflow.CompatibilityWorkflowPlugin$WorkflowAction.execute(CompatibilityWorkflowPlugin.java:156)
      Jun 24 12:50:40 s1720 at org.hippoecm.addon.workflow.CompatibilityWorkflowPlugin$WorkflowAction.execute(CompatibilityWorkflowPlugin.java:142)
      Jun 24 12:50:40 s1720 at org.hippoecm.addon.workflow.CompatibilityWorkflowPlugin$WorkflowAction.invoke(CompatibilityWorkflowPlugin.java:132)
      Jun 24 12:50:40 s1720 at org.hippoecm.addon.workflow.MenuAction$1.onClick(MenuAction.java:43)
      Jun 24 12:50:40 s1720 at org.hippoecm.addon.workflow.MenuLink.onClick(MenuLink.java:50)
      Jun 24 12:50:40 s1720 at org.apache.wicket.ajax.markup.html.AjaxLink$1.onEvent(AjaxLink.java:68)
      Jun 24 12:50:40 s1720 at org.apache.wicket.ajax.AjaxEventBehavior.respond(AjaxEventBehavior.java:177)
      Jun 24 12:50:40 s1720 at org.apache.wicket.ajax.AbstractDefaultAjaxBehavior.onRequest(AbstractDefaultAjaxBehavior.java:299)
      Jun 24 12:50:40 s1720 at org.apache.wicket.request.target.component.listener.BehaviorRequestTarget.processEvents(BehaviorRequestTarget.java:119)
      Jun 24 12:50:40 s1720 at org.apache.wicket.request.AbstractRequestCycleProcessor.processEvents(AbstractRequestCycleProcessor.java:92)
      Jun 24 12:50:40 s1720 at org.hippoecm.frontend.PluginRequestCycleProcessor.processEvents(PluginRequestCycleProcessor.java:34)
      Jun 24 12:50:40 s1720 at org.apache.wicket.RequestCycle.processEventsAndRespond(RequestCycle.java:1250)
      Jun 24 12:50:40 s1720 at org.apache.wicket.RequestCycle.step(RequestCycle.java:1329)
      Jun 24 12:50:40 s1720 at org.apache.wicket.RequestCycle.steps(RequestCycle.java:1428)
      Jun 24 12:50:40 s1720 at org.apache.wicket.RequestCycle.request(RequestCycle.java:545)
      Jun 24 12:50:40 s1720 at org.apache.wicket.protocol.http.WicketFilter.doGet(WicketFilter.java:468)
      Jun 24 12:50:40 s1720 at org.apache.wicket.protocol.http.WicketServlet.doGet(WicketServlet.java:138)
      Jun 24 12:50:40 s1720 at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
      Jun 24 12:50:40 s1720 at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)

      Jun 24 12:50:40 s1720 Caused by: com.mysql.jdbc.exceptions.MySQLIntegrityConstraintViolationException: Duplicate entry '4364629' for key 1
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:931)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:2985)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1631)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:1723)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.Connection.execSQL(Connection.java:3283)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1332)
      Jun 24 12:50:40 s1720 at com.mysql.jdbc.PreparedStatement.execute(PreparedStatement.java:882)
      Jun 24 12:50:40 s1720 at org.apache.tomcat.dbcp.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:169)
      Jun 24 12:50:40 s1720 at org.apache.jackrabbit.core.journal.DatabaseJournal.append(DatabaseJournal.java:552)
      Jun 24 12:50:40 s1720 ... 55 more
      Jun 24 12:51:36 s1720 2010-06-24 12:51:36,692 INFO [TP-Processor2] org.hippoecm.frontend.model.JcrSessionModel - [10.2.13.6] Login by:
      Jun 24 12:53:23 s1720 2010-06-24 12:53:23,897 INFO [TP-Processor17] org.hippoecm.frontend.model.JcrSessionModel - [10.2.13.6] Login by:

      Attachments

        Activity

          People

            jreijn Jeroen Reijn (Inactive)
            jreijn Jeroen Reijn (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: