AnsweredAssumed Answered

If I enable the auditing then IMAP integration fails

Question asked by patil on Jan 24, 2011
Latest reply on Jan 25, 2011 by patil
If I enable the auditing by putting the property in alfresco-global-properties
# Audit configuration
audit.enabled=true

and enable IMAP

imap.server.enabled=true
imap.server.port=143
imap.server.host=patil.com

then in my outlook 2007 when I try to map, the below exception happens.
If I comment the auditng code then the system works fine. Id this bug?
I am using alfresco ee 3.3.



23:31:48,218 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
23:32:30,265 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
23:32:30,281 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
23:32:30,281 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [D:\Alfresco3.3\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\test\alfresco-global.properties]
23:32:30,281 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [D:\Alfresco3.3\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\tests\alfresco-global.properties]
23:32:30,281 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/D:/Alfresco3.3/tomcat/shared/classes/alfresco-global.properties]
23:32:30,281 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [jar:file:/D:/Alfresco3.3/tomcat/webapps/alfresco/WEB-INF/lib/powergridcms.jar!/alfresco-global.properties]
23:32:30,343 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:00,953 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
23:33:00,968 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
23:33:13,250 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
23:33:14,375 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] No changes were made to the schema.
23:33:14,859 DEBUG [org.alfresco.repo.imap] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@175078b, name=log4j:logger=org.alfresco.repo.imap
23:33:14,921 DEBUG [org.alfresco.repo.googledocs] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@175078b, name=log4j:logger=org.alfresco.repo.googledocs
23:33:15,000 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
23:33:15,046 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:15,062 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
23:33:17,484 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
23:33:17,531 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:17,750 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
23:33:17,750 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
23:33:17,812 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:18,437 ERROR [org.alfresco.util.exec.RuntimeExecBootstrapBean] Bootstrap command failed:
Execution result:
   os:         Windows XP
   command:    [soffice, -accept=socket,host=localhost,port=8100;urp;StarOffice.ServiceManager, -env:UserInstallation=file:///D:/Alfresco3.3/alf_data/oouser, -nologo, -headless, -nofirststartwizard, -nocrashrep, -norestore]
   succeeded:  false
   exit code:  2
   out:       
   err:        Cannot run program "soffice": CreateProcess error=2, The system cannot find the file specified
23:33:19,609 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
23:33:19,640 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
23:33:19,640 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
23:33:19,687 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:19,859 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
23:33:23,000 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: D:\Alfresco3.3\alf_data
23:33:23,062 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
23:33:23,687 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] No patches were required.
23:33:23,828 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Found 0 module(s).
23:33:23,859 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
23:33:23,890 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:24,468 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
23:33:24,484 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:24,812 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
23:33:24,906 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
23:33:24,906 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
23:33:24,937 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:25,171 INFO  [org.alfresco.repo.imap.AlfrescoImapServer] IMAP service started on host:port basanagowda:143.
23:33:25,171 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
23:33:25,171 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
23:33:25,203 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:25,281 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
23:33:25,281 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
23:33:25,296 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:25,453 WARN  [org.springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]
23:33:25,453 WARN  [org.springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
23:33:25,656 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
23:33:25,656 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
23:33:25,687 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:26,640 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
23:33:26,640 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
23:33:26,687 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
23:33:26,687 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
23:33:26,687 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
23:33:26,734 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
23:33:26,890 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
23:33:26,937 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_11-b03; maximum heap size 938.688MB
23:33:27,234 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco license: Enterprise - v3.3 granted to Trial User limited to 30 days expiring Sun Feb 13 00:00:00 IST 2011 (20 days remaining)
23:33:27,234 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco started (Enterprise): Current version 3.3.0 (64) schema 4010 - Originally installed version 3.3.0 (64) schema 4010
23:34:03,781 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 348 Web Scripts (+0 failed), 584 URLs
23:34:03,781 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed)
23:34:03,781 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed)
23:34:03,781 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 18618.352ms)
23:34:03,781 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
23:34:03,796 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
23:34:17,078 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 230 Web Scripts (+0 failed), 238 URLs
23:34:17,078 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed)
23:34:17,078 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed)
23:34:17,203 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 3613.8713ms)
23:34:17,343 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
23:34:17,515 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
23:34:17,640 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
23:34:17,656 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
23:34:17,781 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
23:34:17,859 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
23:34:28,484 DEBUG [org.alfresco.repo.imap.ImapServiceImpl] Listing subscribed mailboxes: mailboxPattern=*
23:34:28,484 DEBUG [org.alfresco.repo.imap.ImapServiceImpl] Listing subscribed mailboxes: mailboxPattern in alfresco=*
23:34:28,625 DEBUG [org.alfresco.repo.imap.ImapServiceImpl] Listing mailboxes: mailboxPattern=*
23:34:28,625 DEBUG [org.alfresco.repo.imap.ImapServiceImpl] Listing mailboxes: name=*
23:34:28,625 DEBUG [org.alfresco.repo.imap.ImapServiceImpl] Search folders namePattern*
23:34:30,328 DEBUG [org.alfresco.repo.imap.AlfrescoImapHostManager] Unannotated service method SiteService.listSites
java.lang.RuntimeException: Unannotated service method SiteService.listSites
   at org.alfresco.repo.audit.AuditComponentImpl.audit(AuditComponentImpl.java:261)
   at org.alfresco.repo.audit.AuditMethodInterceptor.proceed(AuditMethodInterceptor.java:178)
   at org.alfresco.repo.audit.AuditMethodInterceptor.invoke(AuditMethodInterceptor.java:140)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:107)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
   at $Proxy93.listSites(Unknown Source)
   at org.alfresco.repo.imap.ImapServiceImpl$6.execute(ImapServiceImpl.java:1394)
   at org.alfresco.repo.imap.ImapServiceImpl$6.execute(ImapServiceImpl.java:1387)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:321)
   at org.alfresco.repo.imap.ImapServiceImpl.getNonFavouriteSites(ImapServiceImpl.java:1386)
   at org.alfresco.repo.imap.ImapServiceImpl.searchFolders(ImapServiceImpl.java:623)
   at org.alfresco.repo.imap.ImapServiceImpl.listFolder(ImapServiceImpl.java:962)
   at org.alfresco.repo.imap.ImapServiceImpl.listMailboxes(ImapServiceImpl.java:858)
   at org.alfresco.repo.imap.ImapServiceImpl.listSubscribedMailboxes(ImapServiceImpl.java:338)
   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:597)
   at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:107)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
   at $Proxy202.listSubscribedMailboxes(Unknown Source)
   at org.alfresco.repo.imap.AlfrescoImapHostManager.listSubscribedMailboxes(AlfrescoImapHostManager.java:100)
   at com.icegreen.greenmail.imap.commands.LsubCommand.doList(LsubCommand.java:23)
   at com.icegreen.greenmail.imap.commands.ListCommand.doProcess(ListCommand.java:93)
   at com.icegreen.greenmail.imap.commands.CommandTemplate.process(CommandTemplate.java:45)
   at com.icegreen.greenmail.imap.ImapRequestHandler.doProcessRequest(ImapRequestHandler.java:91)
   at com.icegreen.greenmail.imap.ImapRequestHandler.handleRequest(ImapRequestHandler.java:48)
   at com.icegreen.greenmail.imap.ImapHandler.run(ImapHandler.java:103)

   command:    [soffice, -accept=socket,host=localhost,port=8100;urp;StarOffice.ServiceManager, -env:UserInstallation=file:///D:/Alfresco3.3/alf_data/oouser, -nologo, -headless, -nofirststartwizard, -nocrashrep, -norestore]
   succeeded:  false
   exit code:  2
   out:

Outcomes