Unable to start application

[kurtkbee]

After upgrading source to latest in HEAD (752) i got the following error in my alfresco.log:

12:02:28,032 WARN  [remoting.rmi.RmiRegistryFactoryBean] Could not detect RMI registry - creating new one
12:02:34,990 INFO  [domain.schema.SchemaBootstrap] Executing database script: /usr/share/tomcat5/temp/Alfresco/AlfrescoSchemaUpdate-org.hibernate.dialect.PostgreSQLDialect-39175.sql
12:02:35,098 INFO  [domain.schema.SchemaBootstrap] Executing database script: classpath:alfresco/dbscripts/upgrade/2.1/${db.script.dialect}/AlfrescoSchemaUpdate-2.1-JBPMData.sql
12:02:35,115 ERROR [domain.schema.SchemaBootstrap] Statement execution failed:
   SQL:  UPDATE jbpm_node SET isasyncexcl_ = 0
   Error: ERROR: column "isasyncexcl_" is of type boolean but expression is of type integer
   File: /usr/share/tomcat5/temp/Alfresco/AlfrescoSchemaUpdate-org.hibernate.dialect.PostgreSQLDialect-39176.sql
   Line: 11
12:02:35,121 ERROR [web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: Schema auto-update failed
        at org.alfresco.repo.domain.schema.SchemaBootstrap.onBootstrap(SchemaBootstrap.java:676)
        at org.alfresco.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:62)
        at org.springframework.context.event.SimpleApplicationEventMulticaster$1.run(SimpleApplicationEventMulticaster.java:77)
        at org.springframework.core.task.SyncTaskExecutor.execute(SyncTaskExecutor.java:49)
        at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:75)
        at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:241)
        at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:349)
        at org.springframework.web.context.support.AbstractRefreshableWebApplicationContext.refresh(AbstractRefreshableWebApplicationContext.java:156)


I have been using postgresql prior to this without a problem.

[kurtkbee]

I had to manually fix the update scripts and change bool values to be wrapped in ''

[kurtkbee]

Seems that there is still a problem. This happens when configuring details of a fileplan

14:26:37,898 ERROR [util.transaction.SpringAwareUserTransaction] Transaction didn't commit
org.hibernate.exception.DataException: Could not execute JDBC batch update
        at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:77)
        at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
        at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:249)
        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:235)
        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:139)
        at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:298)
        at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27)
        at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1000)
        at org.alfresco.repo.node.db.hibernate.HibernateNodeDaoServiceImpl.flush(HibernateNodeDaoServiceImpl.java:281)
        at org.alfresco.repo.transaction.AlfrescoTransactionSupport$TransactionSynchronizationImpl.flush(AlfrescoTransactionSupport.java:569)
        at org.alfresco.repo.transaction.AlfrescoTransactionSupport$TransactionSynchronizationImpl.beforeCommit(AlfrescoTransactionSupport.java:630)
        at org.springframework.transaction.support.TransactionSynchronizationUtils.triggerBeforeCommit(TransactionSynchronizationUtils.java:48)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.triggerBeforeCommit(AbstractPlatformTransactionManager.java:821)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:637)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:624)
        at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:307)
        at org.alfresco.util.transaction.SpringAwareUserTransaction.commit(SpringAwareUserTransaction.java:407)
        at org.alfresco.web.bean.dialog.BaseDialogBean.finish(BaseDialogBean.java:118)
        at org.alfresco.web.bean.dialog.DialogManager.finish(DialogManager.java:335)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:585)
        at org.apache.myfaces.el.MethodBindingImpl.invoke(MethodBindingImpl.java:132)
        at org.apache.myfaces.application.ActionListenerImpl.processAction(ActionListenerImpl.java:61)
        at javax.faces.component.UICommand.broadcast(UICommand.java:109)
        at javax.faces.component.UIViewRoot._broadcastForPhase(UIViewRoot.java:97)
        at javax.faces.component.UIViewRoot.processApplication(UIViewRoot.java:171)
        at org.apache.myfaces.lifecycle.InvokeApplicationExecutor.execute(InvokeApplicationExecutor.java:32)
        at org.apache.myfaces.lifecycle.LifecycleImpl.executePhase(LifecycleImpl.java:95)
        at org.apache.myfaces.lifecycle.LifecycleImpl.execute(LifecycleImpl.java:70)
        at javax.faces.webapp.FacesServlet.service(FacesServlet.java:139)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
        at org.alfresco.web.app.servlet.AuthenticationFilter.doFilter(AuthenticationFilter.java:81)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:210)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:174)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
        at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:151)
        at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:870)
        at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
        at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
        at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
        at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:685)
        at java.lang.Thread.run(Thread.java:595)
Caused by: java.sql.BatchUpdateException: Batch entry 0 insert into alf_audit_fact (user_id, timestamp, transaction_id, session_id, store_protocol, store_id, node_uuid, path, filtered, return_val, arg_1, arg_2, arg_3, arg_4, arg_5, fail, serialized_url, exception_message, host_address, client_address, message_text, audit_date_id, audit_conf_id, audit_source_id, id) values (admin, 2007-05-01 14:26:37.855000 -04:00:00, 7faeb502-f811-11db-88eb-2f317f1181bb, NULL, workspace, SpacesStore, d5c60919-f802-11db-ad2d-a1b364f52368, NULL, 0, NULL, workspace://SpacesStore/d5c60919-f802-11db-ad2d-a1b364f52368, {{http://www.alfresco.org/model/record/1.0}privacyActSystem=FDA-21-CFR-P11, {http://www.alfresco.org/model/record/1.0}vitalRecordIndicator=true, {http://www.alfresco.org/model/content/1.0}template=workspace://SpacesStore/fileplan_template, {http://www.alfresco.org/model/application/1.0}icon=space-icon-default, {http://www.alfresco.org/model/system/1.0}node-uuid=d5c60919-f802-11db-ad2d-a1b364f52368, {http://www.alfresco.org/model/record/1.0}dispositionAuthority=RM-eRT-21CFR-P11, {http://www.alfresco.org/model/record/1.0}defaultMediaType=workspace://SpacesStore/rm:markings-3-7, {http://www.alfresco.org/model/record/1.0}cutoffOnSuperseded=false, {http://www.alfresco.org/model/content/1.0}counter=1, {http://www.alfresco.org/model/content/1.0}created=Tue May 01 12:41:39 EDT 2007, {http://www.alfresco.org/model/record/1.0}holdPeriodValue=1, {http://www.alfresco.org/model/content/1.0}creator=admin, {http://www.alfresco.org/model/record/1.0}containsRecordFolders=true, {http://www.alfresco.org/model/record/1.0}vitalRecordReviewPeriodUnit=workspace://SpacesStore/rm:date..., {http://www.alfresco.org/model/record/1.0}discretionaryHold=false, {http://www.alfresco.org/model/record/1.0}eventTrigger=, {http://www.alfresco.org/model/content/1.0}name=21CFR-Part11 Compliance Space2, {http://www.alfresco.org/model/system/1.0}store-identifier=SpacesStore, {http://www.alfresco.org/model/record/1.0}vitalRecordReviewPeriodValue=1, {http://www.alfresco.org/model/content/1.0}description=Regulated Docs2, {http://www.alfresco.org/model/system/1.0}node-dbid=3024, {http://www.alfresco.org/model/content/1.0}title=Regulated Docs2, {http://www.alfresco.org/model/record/1.0}cutoffPeriodValue=1, {http://www.alfresco.org/model/record/1.0}cutoffOnObsolete=false, {http://www.alfresco.org/model/record/1.0}processCutoff=true, {http://www.alfresco.org/model/record/1.0}defaultMarkingList=[workspace://SpacesStore/cad4c2e9-f29d-11db-8c48-73295e9e9b27, workspace://SpacesStore/rm:mediaTypes-1], {http://www.alfresco.org/model/content/1.0}modifier=admin, {http://www.alfresco.org/model/record/1.0}permanentRecordIndicator=true, {http://www.alfresco.org/model/content/1.0}modified=Tue May 01 13:38:17 EDT 2007, {http://www.alfresco.org/model/record/1.0}dispositionInstructions=File for 15 years then Purge, {http://www.alfresco.org/model/record/1.0}recordCategoryIdentifier=eRT-21CFR-P11, {http://www.alfresco.org/model/system/1.0}store-protocol=workspace, {http://www.alfresco.org/model/record/1.0}defaultOriginatingOrganization=eRT, {http://www.alfresco.org/model/record/1.0}processHold=true}, NULL, NULL, NULL, 0, NULL, NULL, sulley.bw.ert.com/10.20.40.161, NULL, NULL, 3030, 3029, 3636, 3637) was aborted.  Call getNextException to see the cause.
        at org.postgresql.jdbc2.AbstractJdbc2Statement$BatchResultHandler.handleError(AbstractJdbc2Statement.java:2530)
        at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1317)
        at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:350)
        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeBatch(AbstractJdbc2Statement.java:2592)
        at org.apache.commons.dbcp.DelegatingStatement.executeBatch(DelegatingStatement.java:294)
        at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:48)
        at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:242)
        … 46 more
14:26:37,901 ERROR [ui.common.Utils] Failed to create new space due to error: Transaction didn't commit: Could not execute JDBC batch update
javax.transaction.RollbackException: Transaction didn't commit: Could not execute JDBC batch update

[kurtkbee]

I am starting to believe that this JDBC batch update error is related to the date format used by the audit table mentioned.