12-16-2013 04:47 PM
14:39:39,792 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
14:39:39,818 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
14:39:40,184 DEBUG [org.alfresco.repo.dictionary.DictionaryDAO] Init Dictionary: [Thread[localhost-startStop-1,5,main]]
14:39:40,196 INFO [org.alfresco.repo.dictionary.DictionaryDAO] Init Dictionary: model count = 0 in 12 msecs [Thread[localhost-startStop-1,5,main]]
14:39:40,274 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: d:dictionary (from alfresco/model/dictionaryModel.xml)
14:39:40,303 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: sys:systemmodel (from alfresco/model/systemModel.xml)
14:39:40,317 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: usr:usermodel (from org/alfresco/repo/security/authentication/userModel.xml)
14:39:40,460 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cm:contentmodel (from alfresco/model/contentModel.xml)
14:39:40,492 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: bpm:businessprocessmodel (from alfresco/model/bpmModel.xml)
14:39:40,521 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wcm:wcmmodel (from alfresco/model/wcmModel.xml)
14:39:40,523 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: fm:forummodel (from alfresco/model/forumModel.xml)
14:39:40,527 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: imap:imapmodel (from alfresco/model/imapModel.xml)
14:39:40,533 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: trx:applicationmodel (from alfresco/model/transferModel.xml)
14:39:40,536 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: app:applicationmodel (from alfresco/model/applicationModel.xml)
14:39:40,548 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wca:applicationmodel (from alfresco/model/wcmAppModel.xml)
14:39:40,557 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: act:actionmodel (from org/alfresco/repo/action/actionModel.xml)
14:39:40,561 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: rule:rulemodel (from org/alfresco/repo/rule/ruleModel.xml)
14:39:40,565 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ver:versionmodel (from org/alfresco/repo/version/version_model.xml)
14:39:40,570 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ver2:versionmodel (from org/alfresco/repo/version/version2_model.xml)
14:39:40,573 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: emailserver:emailserverModel (from alfresco/model/emailServerModel.xml)
14:39:40,579 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ia:CalendarEventModel (from alfresco/model/calendarModel.xml)
14:39:40,583 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: blg:blogintegration (from alfresco/model/blogIntegrationModel.xml)
14:39:40,586 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: lnk:linksmodel (from alfresco/model/linksModel.xml)
14:39:40,589 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: rc:RemoteCredentialsModel (from alfresco/model/remoteCredentialsModel.xml)
14:39:40,599 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: dl:datalistmodel (from alfresco/model/datalistModel.xml)
14:39:40,603 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: qshare:qsharemodel (from alfresco/model/quickShareModel.xml)
14:39:40,604 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=0, load=22, after=22 in 423 msecs [Thread[localhost-startStop-1,5,main]]
14:39:42,896 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: custom:customModel (from alfresco/model/defaultCustomModel.xml)
14:39:42,897 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=22, load=1, after=23 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:48,881 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: st:siteModel (from alfresco/model/siteModel.xml)
14:39:48,882 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=23, load=1, after=24 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:49,581 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: jcr:jcrmodel (from alfresco/model/jcrModel.xml)
14:39:49,582 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=24, load=1, after=25 in 3 msecs [Thread[localhost-startStop-1,5,main]]
14:39:49,879 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: download:downloadModel (from alfresco/model/downloadModel.xml)
14:39:49,879 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=25, load=1, after=26 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:50,685 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cmis:cmismodel (from alfresco/model/cmisModel.xml)
14:39:50,688 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cmiscustom:model (from alfresco/model/cmisTestModel.xml)
14:39:50,689 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=26, load=2, after=28 in 6 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,056 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: pub:publishingmodel (from alfresco/model/publishingModel.xml)
14:39:51,058 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=28, load=1, after=29 in 5 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,127 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: youtube:publishingmodel (from alfresco/model/youtubePublishingModel.xml)
14:39:51,128 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=29, load=1, after=30 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,152 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: twitter:publishingmodel (from alfresco/model/twitterPublishingModel.xml)
14:39:51,152 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=30, load=1, after=31 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,621 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: linkedin:publishingmodel (from alfresco/model/linkedInPublishingModel.xml)
14:39:51,622 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=31, load=1, after=32 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,662 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: flickr:publishingmodel (from alfresco/model/flickrPublishingModel.xml)
14:39:51,663 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=32, load=1, after=33 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,705 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: facebook:publishingmodel (from alfresco/model/facebookPublishingModel.xml)
14:39:51,705 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=33, load=1, after=34 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:39:51,754 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: slideshare:publishingmodel (from alfresco/model/slidesharePublishingModel.xml)
14:39:51,755 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=34, load=1, after=35 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:39:52,858 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: tsh:timesheetmodel (from alfresco/extension/kesTimesheetModel.xml)
14:39:52,901 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=35, load=1, after=36 in 46 msecs [Thread[localhost-startStop-1,5,main]]
14:39:52,947 ERROR [org.alfresco.repo.content.transform.RuntimeExecutableContentTransformerWorker] Failed to start a runtime executable content transformer:
Execution result:
os: Linux
command: ${ffmpeg.exe} -version
succeeded: false
exit code: 2
out:
err: Cannot run program "${ffmpeg.exe}": error=2, No such file or directory
14:39:52,954 ERROR [org.alfresco.repo.content.transform.RuntimeExecutableContentTransformerWorker] Failed to start a runtime executable content transformer:
Execution result:
os: Linux
command: ${ffmpeg.exe} -version
succeeded: false
exit code: 2
out:
err: Cannot run program "${ffmpeg.exe}": error=2, No such file or directory
14:39:52,960 ERROR [org.alfresco.repo.content.transform.RuntimeExecutableContentTransformerWorker] Failed to start a runtime executable content transformer:
Execution result:
os: Linux
command: ${ffmpeg.exe} -version
succeeded: false
exit code: 2
out:
err: Cannot run program "${ffmpeg.exe}": error=2, No such file or directory
14:39:52,966 ERROR [org.alfresco.repo.content.transform.RuntimeExecutableContentTransformerWorker] Failed to start a runtime executable content transformer:
Execution result:
os: Linux
command: ${ffmpeg.exe} -version
succeeded: false
exit code: 2
out:
err: Cannot run program "${ffmpeg.exe}": error=2, No such file or directory
14:39:53,124 INFO [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
14:39:53,128 INFO [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
14:40:00,526 INFO [org.alfresco.repo.domain.schema.SchemaBootstrap] Connecting to database: jdbc:mysql://localhost:3306/kes42c, UserName=kes@localhost, MySQL-AB JDBC Driver
14:40:00,527 INFO [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
14:40:00,900 INFO [org.alfresco.repo.domain.schema.SchemaBootstrap] No changes were made to the schema.
14:40:01,250 DEBUG [org.alfresco.repo.dictionary.DictionaryDAO] Dictionary destroyed
14:40:01,277 DEBUG [org.alfresco.repo.dictionary.DictionaryDAO] Init Dictionary: [Thread[localhost-startStop-1,5,main]]
14:40:01,278 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: d:dictionary (from alfresco/model/dictionaryModel.xml)
14:40:01,280 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: sys:systemmodel (from alfresco/model/systemModel.xml)
14:40:01,282 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: usr:usermodel (from org/alfresco/repo/security/authentication/userModel.xml)
14:40:01,291 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cm:contentmodel (from alfresco/model/contentModel.xml)
14:40:01,297 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: bpm:businessprocessmodel (from alfresco/model/bpmModel.xml)
14:40:01,299 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wcm:wcmmodel (from alfresco/model/wcmModel.xml)
14:40:01,300 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: fm:forummodel (from alfresco/model/forumModel.xml)
14:40:01,302 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: imap:imapmodel (from alfresco/model/imapModel.xml)
14:40:01,304 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: trx:applicationmodel (from alfresco/model/transferModel.xml)
14:40:01,306 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: app:applicationmodel (from alfresco/model/applicationModel.xml)
14:40:01,310 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wca:applicationmodel (from alfresco/model/wcmAppModel.xml)
14:40:01,314 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: act:actionmodel (from org/alfresco/repo/action/actionModel.xml)
14:40:01,315 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: rule:rulemodel (from org/alfresco/repo/rule/ruleModel.xml)
14:40:01,317 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ver:versionmodel (from org/alfresco/repo/version/version_model.xml)
14:40:01,319 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ver2:versionmodel (from org/alfresco/repo/version/version2_model.xml)
14:40:01,320 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: emailserver:emailserverModel (from alfresco/model/emailServerModel.xml)
14:40:01,321 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: ia:CalendarEventModel (from alfresco/model/calendarModel.xml)
14:40:01,323 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: blg:blogintegration (from alfresco/model/blogIntegrationModel.xml)
14:40:01,323 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: lnk:linksmodel (from alfresco/model/linksModel.xml)
14:40:01,325 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: rc:RemoteCredentialsModel (from alfresco/model/remoteCredentialsModel.xml)
14:40:01,327 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: dl:datalistmodel (from alfresco/model/datalistModel.xml)
14:40:01,330 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: qshare:qsharemodel (from alfresco/model/quickShareModel.xml)
14:40:01,330 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=0, load=22, after=22 in 53 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,330 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: custom:customModel (from alfresco/model/defaultCustomModel.xml)
14:40:01,330 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=22, load=1, after=23 in 0 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,331 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: st:siteModel (from alfresco/model/siteModel.xml)
14:40:01,331 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=23, load=1, after=24 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,332 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: jcr:jcrmodel (from alfresco/model/jcrModel.xml)
14:40:01,333 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=24, load=1, after=25 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,334 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: download:downloadModel (from alfresco/model/downloadModel.xml)
14:40:01,334 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=25, load=1, after=26 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,336 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cmis:cmismodel (from alfresco/model/cmisModel.xml)
14:40:01,338 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: cmiscustom:model (from alfresco/model/cmisTestModel.xml)
14:40:01,338 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=26, load=2, after=28 in 4 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,340 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: pub:publishingmodel (from alfresco/model/publishingModel.xml)
14:40:01,341 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=28, load=1, after=29 in 3 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,342 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: youtube:publishingmodel (from alfresco/model/youtubePublishingModel.xml)
14:40:01,342 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=29, load=1, after=30 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,342 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: twitter:publishingmodel (from alfresco/model/twitterPublishingModel.xml)
14:40:01,343 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=30, load=1, after=31 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,343 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: linkedin:publishingmodel (from alfresco/model/linkedInPublishingModel.xml)
14:40:01,343 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=31, load=1, after=32 in 0 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,344 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: flickr:publishingmodel (from alfresco/model/flickrPublishingModel.xml)
14:40:01,344 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=32, load=1, after=33 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,345 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: facebook:publishingmodel (from alfresco/model/facebookPublishingModel.xml)
14:40:01,345 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=33, load=1, after=34 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,345 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: slideshare:publishingmodel (from alfresco/model/slidesharePublishingModel.xml)
14:40:01,345 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=34, load=1, after=35 in 0 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,347 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: tsh:timesheetmodel (from alfresco/extension/kesTimesheetModel.xml)
14:40:01,348 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=35, load=1, after=36 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,403 DEBUG [org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap] Model count: before=36, load/update=0, after=36 in 55 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,404 INFO [org.alfresco.repo.dictionary.DictionaryDAO] Init Dictionary: model count = 36 in 127 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,407 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wf:workflowmodel (from alfresco/workflow/workflowModel.xml)
14:40:01,413 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: wcmwf:workflowmodel (from alfresco/workflow/wcmWorkflowModel.xml)
14:40:01,417 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: inwf:invite-workflow-model (from alfresco/workflow/invitation-nominated-workflow-model.xml)
14:40:01,419 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: imwf:invitation-moderated-workflow-model (from alfresco/workflow/invitation-moderated-workflow-model.xml)
14:40:01,420 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=36, load=4, after=40 in 143 msecs [Thread[localhost-startStop-1,5,main]]
14:40:01,498 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Search' subsystem, ID: [Search, managed, lucene]
14:40:01,838 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Search' subsystem, ID: [Search, managed, lucene] complete
14:40:02,331 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
14:40:02,443 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
14:40:02,443 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
14:40:04,249 WARN [org.alfresco.util.OpenOfficeConnectionTester] Error trying to query Open Office version information. OpenOffice.org's ConfigurationRegistry not implemented in this version of OOo. This should not affect the operation of OOo.
14:40:04,254 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
14:40:05,120 INFO [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/kes-4.2.c/alf_data
14:40:05,172 INFO [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
14:40:06,410 INFO [org.alfresco.repo.admin.patch.PatchExecuter] No patches were required.
14:40:06,422 INFO [org.alfresco.repo.module.ModuleServiceImpl] Found 1 module(s).
14:40:06,461 INFO [org.alfresco.repo.module.ModuleServiceImpl] Starting module 'org.alfresco.integrations.google.docs' version 2.0.1.
14:40:06,488 WARN [org.alfresco.repo.module.ModuleServiceImpl] A previously-installed module 'org_alfresco_reporting' (version 0.8.0.2) is not present in your distribution.
14:40:06,498 WARN [org.alfresco.repo.module.ModuleServiceImpl] A previously-installed module 'org.alfresco.reporting' (version 0.8.0.3) is not present in your distribution.
14:40:06,500 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
14:40:07,017 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
14:40:07,150 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
14:40:12,170 WARN [org.alfresco.fileserver] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
14:40:12,202 ERROR [org.alfresco.fileserver] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Address already in use
14:40:12,208 ERROR [org.alfresco.fileserver] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Address already in use
at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
at java.lang.Thread.run(Thread.java:722)
14:40:12,212 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
14:40:12,212 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
14:40:12,344 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
14:40:12,344 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
14:40:12,396 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
14:40:12,397 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
14:40:12,485 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
14:40:12,485 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
14:40:12,514 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: gd:googledocs (from alfresco/subsystems/googledocs/default/googledocs-model.xml)
14:40:12,514 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=40, load=1, after=41 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:12,549 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
14:40:12,549 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
14:40:12,565 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
14:40:12,565 INFO [org.alfresco.repo.usage.UserUsageTrackingComponent] Disabled - clear non-missing user usages …
14:40:12,581 INFO [org.alfresco.repo.usage.UserUsageTrackingComponent] Found 0 users to clear
14:40:12,581 INFO [org.alfresco.repo.usage.UserUsageTrackingComponent] … cleared non-missing usages for 0 users
14:40:12,581 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
14:40:12,625 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
14:40:12,683 INFO [org.alfresco.service.descriptor.DescriptorService] Alfresco JVM - v1.7.0_07-b10; maximum heap size 910.250MB
14:40:12,683 INFO [org.alfresco.service.descriptor.DescriptorService] Alfresco started (Community). Current version: 4.2.0 (4576) schema 6,022. Originally installed version: 4.2.0 (4576) schema 6,022.
14:40:12,685 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
14:40:12,783 WARN [org.alfresco.util.AbstractTriggerBean] Job feedNotifierTrigger is not enabled
14:40:12,783 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
14:40:12,783 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
14:40:12,797 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
14:40:14,851 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: pubwf:workflowModel (from alfresco/workflow/publishingWorkflowModel.xml)
14:40:14,851 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=41, load=1, after=42 in 1 msecs [Thread[localhost-startStop-1,5,main]]
14:40:14,864 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, v2]
14:40:14,903 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Loading model: gd2:googledocs (from alfresco/subsystems/googledocs/v2/googledocs-model.xml)
14:40:14,904 DEBUG [org.alfresco.repo.dictionary.DictionaryBootstrap] Model count: before=42, load=1, after=43 in 2 msecs [Thread[localhost-startStop-1,5,main]]
14:40:14,956 INFO [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, v2] complete
14:40:22,104 INFO [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 492 Web Scripts (+0 failed), 772 URLs
14:40:22,105 INFO [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed)
14:40:22,105 INFO [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed)
14:40:22,108 INFO [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 7103.005ms)
14:40:22,129 INFO [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:40:22,132 INFO [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
05:04:41,765 ERROR [org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet]
org.apache.chemistry.opencmis.commons.exceptions.CmisRuntimeException
at org.apache.chemistry.opencmis.server.shared.Dispatcher.dispatch(Dispatcher.java:101)
at org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet.dispatch(CmisAtomPubServlet.java:236)
at org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet.service(CmisAtomPubServlet.java:185)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:722)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:305)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
at org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:222)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:123)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:472)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:168)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:929)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:407)
at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1002)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:585)
at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:1813)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
at java.lang.Thread.run(Thread.java:722)
Caused by: java.lang.reflect.InvocationTargetException
at sun.reflect.GeneratedMethodAccessor1141.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:601)
at org.apache.chemistry.opencmis.server.shared.Dispatcher.dispatch(Dispatcher.java:94)
… 22 more
Caused by: javax.xml.bind.MarshalException
- with linked exception:
[com.sun.istack.SAXException2: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null
javax.xml.transform.TransformerException: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null]
at com.sun.xml.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:328)
at com.sun.xml.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:172)
at org.apache.chemistry.opencmis.commons.impl.JaxBHelper.marshal(JaxBHelper.java:130)
at org.apache.chemistry.opencmis.server.impl.atompub.AtomEntry.writeObject(AtomEntry.java:95)
at org.apache.chemistry.opencmis.server.impl.atompub.AtomPubUtils.writeObjectEntry(AtomPubUtils.java:173)
at org.apache.chemistry.opencmis.server.impl.atompub.NavigationService.getChildren(NavigationService.java:184)
… 26 more
Caused by: com.sun.istack.SAXException2: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null
javax.xml.transform.TransformerException: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null
at com.sun.xml.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:245)
at com.sun.xml.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:260)
at com.sun.xml.bind.v2.runtime.XMLSerializer.writeDom(XMLSerializer.java:809)
at com.sun.xml.bind.v2.runtime.property.ArrayReferenceNodeProperty.serializeListBody(ArrayReferenceNodeProperty.java:112)
at com.sun.xml.bind.v2.runtime.property.ArrayERProperty.serializeBody(ArrayERProperty.java:152)
at com.sun.xml.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:332)
at com.sun.xml.bind.v2.runtime.XMLSerializer.childAsXsiType(XMLSerializer.java:698)
at com.sun.xml.bind.v2.runtime.property.SingleElementNodeProperty.serializeBody(SingleElementNodeProperty.java:152)
at com.sun.xml.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:332)
at com.sun.xml.bind.v2.runtime.XMLSerializer.childAsXsiType(XMLSerializer.java:698)
at com.sun.xml.bind.v2.runtime.property.SingleElementNodeProperty.serializeBody(SingleElementNodeProperty.java:152)
at com.sun.xml.bind.v2.runtime.ElementBeanInfoImpl$1.serializeBody(ElementBeanInfoImpl.java:157)
at com.sun.xml.bind.v2.runtime.ElementBeanInfoImpl$1.serializeBody(ElementBeanInfoImpl.java:189)
at com.sun.xml.bind.v2.runtime.ElementBeanInfoImpl.serializeBody(ElementBeanInfoImpl.java:315)
at com.sun.xml.bind.v2.runtime.ElementBeanInfoImpl.serializeRoot(ElementBeanInfoImpl.java:322)
at com.sun.xml.bind.v2.runtime.ElementBeanInfoImpl.serializeRoot(ElementBeanInfoImpl.java:72)
at com.sun.xml.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:493)
at com.sun.xml.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:325)
… 31 more
Caused by: javax.xml.transform.TransformerException: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null
at org.apache.xalan.transformer.TransformerIdentityImpl.transform(TransformerIdentityImpl.java:400)
at com.sun.xml.bind.v2.runtime.XMLSerializer.writeDom(XMLSerializer.java:807)
… 46 more
Caused by: com.sun.istack.SAXException2
com.ctc.wstx.exc.WstxIOException: null
at com.sun.xml.bind.v2.runtime.ContentHandlerAdaptor.endElement(ContentHandlerAdaptor.java:154)
at org.apache.xalan.transformer.TransformerIdentityImpl.endElement(TransformerIdentityImpl.java:1101)
at org.apache.xml.serializer.TreeWalker.endNode(TreeWalker.java:458)
at org.apache.xml.serializer.TreeWalker.traverse(TreeWalker.java:149)
at org.apache.xalan.transformer.TransformerIdentityImpl.transform(TransformerIdentityImpl.java:389)
… 47 more
Caused by: com.ctc.wstx.exc.WstxIOException: null
at com.ctc.wstx.sw.BaseStreamWriter.writeCharacters(BaseStreamWriter.java:511)
at com.sun.xml.bind.v2.runtime.output.XMLStreamWriterOutput.text(XMLStreamWriterOutput.java:150)
at com.sun.xml.bind.v2.runtime.XMLSerializer.text(XMLSerializer.java:405)
at com.sun.xml.bind.v2.runtime.ContentHandlerAdaptor.flushText(ContentHandlerAdaptor.java:160)
at com.sun.xml.bind.v2.runtime.ContentHandlerAdaptor.endElement(ContentHandlerAdaptor.java:149)
… 51 more
Caused by: ClientAbortException: java.io.IOException
at org.apache.catalina.connector.OutputBuffer.realWriteBytes(OutputBuffer.java:388)
at org.apache.tomcat.util.buf.ByteChunk.flushBuffer(ByteChunk.java:462)
at org.apache.tomcat.util.buf.ByteChunk.append(ByteChunk.java:366)
at org.apache.catalina.connector.OutputBuffer.writeBytes(OutputBuffer.java:413)
at org.apache.catalina.connector.OutputBuffer.write(OutputBuffer.java:401)
at org.apache.catalina.connector.CoyoteOutputStream.write(CoyoteOutputStream.java:91)
at com.ctc.wstx.io.UTF8Writer.write(UTF8Writer.java:139)
at com.ctc.wstx.sw.BufferingXmlWriter.flushBuffer(BufferingXmlWriter.java:1103)
at com.ctc.wstx.sw.BufferingXmlWriter.writeRaw(BufferingXmlWriter.java:229)
at com.ctc.wstx.sw.BufferingXmlWriter.writeCharacters(BufferingXmlWriter.java:543)
at com.ctc.wstx.sw.BaseStreamWriter.writeCharacters(BaseStreamWriter.java:509)
… 55 more
Caused by: java.io.IOException
at org.apache.coyote.http11.InternalAprOutputBuffer.flushBuffer(InternalAprOutputBuffer.java:205)
at org.apache.coyote.http11.InternalAprOutputBuffer.access$100(InternalAprOutputBuffer.java:37)
at org.apache.coyote.http11.InternalAprOutputBuffer$SocketOutputBuffer.doWrite(InternalAprOutputBuffer.java:235)
at org.apache.coyote.http11.filters.ChunkedOutputFilter.doWrite(ChunkedOutputFilter.java:119)
at org.apache.coyote.http11.AbstractOutputBuffer.doWrite(AbstractOutputBuffer.java:192)
at org.apache.coyote.Response.doWrite(Response.java:504)
at org.apache.catalina.connector.OutputBuffer.realWriteBytes(OutputBuffer.java:383)
… 65 more
05:04:41,780 ERROR [org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet] getOutputStream() has already been called for this response
java.lang.IllegalStateException: getOutputStream() has already been called for this response
at org.apache.catalina.connector.Response.getWriter(Response.java:639)
at org.apache.catalina.connector.ResponseFacade.getWriter(ResponseFacade.java:214)
at javax.servlet.ServletResponseWrapper.getWriter(ServletResponseWrapper.java:105)
at org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet.printError(CmisAtomPubServlet.java:301)
at org.apache.chemistry.opencmis.server.impl.atompub.CmisAtomPubServlet.service(CmisAtomPubServlet.java:195)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:722)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:305)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
at org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:222)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:123)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:472)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:168)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:929)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:407)
at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1002)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:585)
at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:1813)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
at java.lang.Thread.run(Thread.java:722)
06:00:10,039 ERROR [org.quartz.core.JobRunShell] Job DEFAULT.scheduledFillReportingDatabaseJob threw an unhandled Exception:
org.springframework.transaction.UnexpectedRollbackException: Transaction rolled back because it has been marked as rollback-only
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:717)
at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:393)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:120)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
at $Proxy138.executeScript(Unknown Source)
at org.alfresco.repo.jscript.ExecuteScriptJob.execute(ExecuteScriptJob.java:80)
at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
06:00:10,043 ERROR [org.quartz.core.ErrorLogger] Job (DEFAULT.scheduledFillReportingDatabaseJob threw an exception.
org.quartz.SchedulerException: Job threw an unhandled exception. [See nested exception: org.springframework.transaction.UnexpectedRollbackException: Transaction rolled back because it has been marked as rollback-only]
at org.quartz.core.JobRunShell.run(JobRunShell.java:227)
at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
Caused by: org.springframework.transaction.UnexpectedRollbackException: Transaction rolled back because it has been marked as rollback-only
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:717)
at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:393)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:120)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
at $Proxy138.executeScript(Unknown Source)
at org.alfresco.repo.jscript.ExecuteScriptJob.execute(ExecuteScriptJob.java:80)
at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
… 1 more
12-16-2013 06:46 PM
Tags
Find what you came for
We want to make your experience in Hyland Connect as valuable as possible, so we put together some helpful links.