ImageMagick & Libreoffice not working.

Patelvikash09 — Tue, 11 May 2021 08:39:07 GMT

I have installed acs 7.0 using distribution zip in tomcat 9 server on Windows 10.

I have installed the LibreOffice v6.3.5 using LibreOffice_6.3.5.1_Win_x64.msi & ImageMagick v7.0.11 ImageMagick-7.0.11-11-Q16-HDRI-x64-dll.exe at this location
C:/Users/XXX/acs7/libreoffice
C:/Users/XXX/acs7/imagemagick

alfresco-global properties.

ooo.exe=C:/Users/XXX/acs7/libreoffice/program/soffice.exe
ooo.enabled=false
ooo.port=8100
jodconverter.enabled=true
jodconverter.officeHome=C:/Users/XXX/acs7/libreoffice
jodconverter.portNumbers=8100

#Imagemagick config
img.root=C:/Users/XXX/acs7/imagemagick
img.dyn=${img.root}/lib
img.exe=${img.root}/convert.exe
img.coders=${img.root}/modules/coders
img.config=${img.root}
img.gslib=${img.root}/lib

But the server not starting the libreoffice/imagemagick,
In the server startup logs it's not displaying logs for libreoffice/imagemagick started/failed.
Server logs.

2021-05-11 13:13:39,037 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2021-05-11 13:13:39,319 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2021-05-11 13:13:47,347 INFO [population.config.RqaWorkerConfig] [main] QuerySet batch size property is set to [5000].
2021-05-11 13:13:49,392 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2021-05-11 13:13:49,469 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2021-05-11 13:13:52,320 INFO [extensions.webscripts.TemplateProcessorRegistry] [main] Registered template processor Repository Template Processor for extension ftl
2021-05-11 13:13:52,334 INFO [extensions.webscripts.ScriptProcessorRegistry] [main] Registered script processor Repository Script Processor for extension js
2021-05-11 13:13:58,442 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.content.ContentStoreCreatedEvent[source=FileContentStore[ root=C:\Users\XXX\acs7\tomcat\temp\Alfresco, allowRandomAccess=true, readOnly=false]]
2021-05-11 13:13:58,493 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2021-05-11 13:13:58,616 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2021-05-11 13:13:58,621 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.content.ContentStoreCreatedEvent[source=FileContentStore[ root=C:\Users\XXX\acs7\alf_data\contentstore.deleted, allowRandomAccess=true, readOnly=false]]
2021-05-11 13:13:58,724 INFO [domain.schema.SchemaBootstrap] [main] Connecting to database: jdbcostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL JDBC Driver
eventrg.alfresco.repo.domain.schema.SchemaAvailableEvent[source=org.alfresco.repo.domain.schema.SchemaBootstrap@65110149]
2021-05-11 13:13:59,275 DEBUG [enterprise.repo.content] [main] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@614ca7df, name=log4j:logger=org.alfresco.enterprise.repo.content
2021-05-11 13:13:59,288 DEBUG [repo.jscript.ScriptLogger] [main] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@614ca7df, name=log4j:logger=org.alfresco.repo.jscript.ScriptLogger
2021-05-11 13:13:59,303 DEBUG [content.routing.StoreSelectorAspectContentStore] [main] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@614ca7df, name=log4j:logger=org.alfresco.enterprise.repo.content.routing.StoreSelectorAspectContentStore
2021-05-11 13:13:59,331 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@614ca7df, name=log4j:logger=org.alfresco.enterprise.repo.content.cryptodoc.impl.CryptodocLicenseImpl
2021-05-11 13:13:59,356 DEBUG [solr.query.AbstractQParser] [main] preRegister called. Server=com.sun.jmx.mbeanserver.JmxMBeanServer@614ca7df, name=log4j:logger=org.alfresco.solr.query.AbstractQParser
May 11, 2021 1:14:03 PM com.hazelcast.config.InMemoryXmlConfig
INFO: Configuring Hazelcast from 'in-memory xml'.
May 11, 2021 1:14:03 PM com.hazelcast.config.AbstractXmlConfigHelper
WARNING: Name of the hazelcast schema location is incorrect, using default
May 11, 2021 1:14:03 PM com.hazelcast.instance.HazelcastInstanceFactory
WARNING: Hazelcast is starting in a Java modular environment (Java 9 and newer) but without proper access to required Java packages. Use additional Java arguments to provide Hazelcast access to Java internal API. The internal API access is used to get the best performance results. Arguments to be used:
--add-modules java.se --add-exports java.base/jdk.internal.ref=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.management/sun.management=ALL-UNNAMED --add-opens jdk.management/com.sun.management.internal=ALL-UNNAMED
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by com.hazelcast.internal.networking.nio.SelectorOptimizer (file:/C:/Users/XXX/acs7/tomcat/webapps/alfresco/WEB-INF/lib/hazelcast-3.12.6.jar) to field sun.nio.ch.SelectorImpl.selectedKeys
WARNING: Please consider reporting this to the maintainers of com.hazelcast.internal.networking.nio.SelectorOptimizer
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
2021-05-11 13:14:16,839 WARN [cluster.cache.ClusterAwareCacheFactory] [main] Hazelcast cache.activitiTokensCache merge policy is configured with old value (v2.3). The value will be automatically corrected according to v3.11: hz.ADD_NEW_ENTRY --> com.hazelcast.spi.merge.PutIfAbsentMergePolicyPlease update your Hazelcast configuration to new value to stop this warning.
2021-05-11 13:14:16,902 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.enterprise.repo.cluster.core.ClusterServiceInitialisedEvent[source=org.alfresco.enterprise.repo.cluster.core.ClusterServiceImpl@7c7a69b8]
2021-05-11 13:14:16,936 INFO [cluster.core.ClusteringBootstrap] [main] Cluster started, name: MainRepository-b298a322-7fb0-4770-9c0e-7bcf13f7de28
2021-05-11 13:14:16,943 INFO [cluster.core.ClusteringBootstrap] [main] Current cluster members: 192.168.43.117:5701 (hostname: localhost)
2021-05-11 13:14:16,954 INFO [repo.admin.ConfigurationChecker] [main] The root data directory ('dir.root') is: C:\Users\XXX\acs7\alf_data
2021-05-11 13:14:17,002 INFO [admin.patch.PatchExecuter] [main] Checking for patches to apply ...
2021-05-11 13:14:17,692 INFO [admin.patch.PatchExecuter] [main] No patches were required.
2021-05-11 13:14:17,754 INFO [repo.module.ModuleServiceImpl] [main] Found 2 module package(s).
2021-05-11 13:14:17,820 INFO [repo.module.ModuleServiceImpl] [main] Starting module 'alfresco-share-services' version 7.0.0.
2021-05-11 13:14:17,866 INFO [repo.module.ModuleServiceImpl] [main] Starting module 'alfresco-trashcan-cleaner' version 2.3.
2021-05-11 13:14:17,881 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'fileServers' subsystem, ID: [fileServers, default]
2021-05-11 13:14:19,162 INFO [alfresco.ftp.server] [main] Starting server FTP ...
2021-05-11 13:14:19,166 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2021-05-11 13:14:19,167 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'imap' subsystem, ID: [imap, default]
2021-05-11 13:14:19,452 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'imap' subsystem, ID: [imap, default] complete
2021-05-11 13:14:19,453 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'email' subsystem, ID: [email, outbound]
2021-05-11 13:14:20,503 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'email' subsystem, ID: [email, outbound] complete
2021-05-11 13:14:20,504 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'email' subsystem, ID: [email, inbound]
2021-05-11 13:14:20,684 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'email' subsystem, ID: [email, inbound] complete
2021-05-11 13:14:20,685 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2021-05-11 13:14:20,739 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2021-05-11 13:14:20,803 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2021-05-11 13:14:20,947 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.security.sync.SynchronizeStartEvent[source=org.alfresco.repo.security.sync.ChainingUserRegistrySynchronizer@282493f4]
2021-05-11 13:14:21,048 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.security.sync.SynchronizeEndEvent[source=org.alfresco.repo.security.sync.ChainingUserRegistrySynchronizer@282493f4]
2021-05-11 13:14:21,084 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2021-05-11 13:14:21,152 INFO [service.descriptor.DescriptorService] [main] Alfresco JVM - v11.0.2+9-LTS; maximum heap size 3568.000MB
2021-05-11 13:14:21,154 INFO [service.descriptor.DescriptorService] [main] Alfresco license: Mode ENTERPRISE, cluster:enabled granted to Cognizant Technology Solutions Us Corp limited to 396 days expiring Mon May 30 04:30:00 IST 2022 (384 days remaining).
2021-05-11 13:14:21,156 INFO [service.descriptor.DescriptorService] [main] Server Mode :UNKNOWN
2021-05-11 13:14:21,188 INFO [service.descriptor.DescriptorService] [main] Alfresco Content Services started (Enterprise). Current version: 7.0.0 (.1 rd4a33c6d-b2858) schema 14,002. Originally installed version: 7.0.0 (.1 rd4a33c6d-b2858) schema 14,002.
2021-05-11 13:14:21,209 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2021-05-11 13:14:21,639 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2021-05-11 13:14:21,911 INFO [repo.authorization.AuthorizationService] [main] Preauthorized user: admin
2021-05-11 13:14:21,915 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.cache.CacheStatisticsCreated[source=org.alfresco.repo.cache.InMemoryCacheStatistics@3aa0db5d]
2021-05-11 13:14:21,922 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.enterprise.repo.authorization.AuthorizationKeystoreEvent[source=org.alfresco.enterprise.repo.authorization.encryption.AlfrescoContentKeyStoreImpl@4db82eb1]
2021-05-11 13:14:21,924 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'Replication' subsystem, ID: [Replication, default]
2021-05-11 13:14:21,973 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2021-05-11 13:14:23,325 INFO [repo.thumbnail.ThumbnailRegistry] [main] Init'ed thumbnail defs in 1346 ms
2021-05-11 13:14:24,344 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.cache.CacheStatisticsCreated[source=org.alfresco.repo.cache.InMemoryCacheStatistics@3aa0db5d]
2021-05-11 13:14:24,348 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.alfresco.repo.cache.CacheStatisticsCreated[source=org.alfresco.repo.cache.InMemoryCacheStatistics@3aa0db5d]
2021-05-11 13:14:24,377 DEBUG [cryptodoc.impl.CryptodocLicenseImpl] [main] eventrg.springframework.context.event.ContextRefreshedEvent[source=Root WebApplicationContext, started on Tue May 11 13:12:41 IST 2021]
2021-05-11 13:14:24,390 INFO [management.subsystems.ChildApplicationContextFactory] [main] Starting 'Activiti' subsystem, ID: [Activiti, default]
2021-05-11 13:14:24,456 INFO [management.subsystems.ChildApplicationContextFactory] [main] Startup of 'Activiti' subsystem, ID: [Activiti, default] complete
2021-05-11 13:14:54,338 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 478 Web Scripts (+0 failed), 669 URLs
2021-05-11 13:14:54,348 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2021-05-11 13:14:54,349 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)

2021-05-11 13:15:29,335 INFO [extensions.webscripts.DeclarativeRegistry] [main] Registered 14 Web Scripts (+0 failed), 103 URLs
2021-05-11 13:15:29,335 INFO [extensions.webscripts.DeclarativeRegistry] [main] Registered 0 Package Description Documents (+0 failed)
2021-05-11 13:15:29,341 INFO [extensions.webscripts.DeclarativeRegistry] [main] Registered 0 Schema Description Documents (+0 failed)
2021-05-11 13:15:29,358 INFO [extensions.webscripts.AbstractRuntimeContainer] [main] Initialised Public Api Web Script Container (in 18231.648ms)
2021-05-11 13:15:29,449 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 14 Web Scripts (+0 failed), 103 URLs
2021-05-11 13:15:29,450 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2021-05-11 13:15:29,455 INFO [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
May 11, 2021 1:15:31 PM org.apache.catalina.util.SessionIdGeneratorBase createSecureRandom
WARNING: Creation of SecureRandom instance for session ID generation using [SHA1PRNG] took [1,375] milliseconds.
2021-05-11 13:15:31,173 WARN [scripts.servlet.X509ServletFilterBase] [main] clientAuth does not appear to be set for Tomcat. clientAuth must be set to 'want' for X509 Authentication
2021-05-11 13:15:31,174 WARN [scripts.servlet.X509ServletFilterBase] [main] Attempting to set clientAuth=want through JMX...
2021-05-11 13:15:31,215 WARN [scripts.servlet.X509ServletFilterBase] [main] Unable to set clientAuth=want through JMX.
11-May-2021 13:15:38.453 INFO [main] org.apache.catalina.startup.HostConfig.deployDescriptor Deployment of deployment descriptor [C:\Users\XXX\acs7\tomcat\conf\Catalina\localhost\alfresco.xml] has finished in [228,447] ms
11-May-2021 13:15:38.454 INFO [main] org.apache.catalina.startup.HostConfig.deployDescriptor Deploying deployment descriptor [C:\Users\XXX\acs7\tomcat\conf\Catalina\localhost\share.xml]
11-May-2021 13:16:07.820 INFO [main] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
2021-05-11 13:16:48,313 INFO [extensions.webscripts.TemplateProcessorRegistry] [main] Registered template processor freemarker for extension ftl
2021-05-11 13:16:48,314 INFO [extensions.webscripts.ScriptProcessorRegistry] [main] Registered script processor javascript for extension js
2021-05-11 13:16:48,405 INFO [site.servlet.AIMSFilter] [main] Initializing the AIMS filter.
2021-05-11 13:16:48,426 INFO [site.servlet.AIMSFilter] [main] AIMS filter initialized.
11-May-2021 13:16:48.742 INFO [main] org.apache.catalina.startup.HostConfig.deployDescriptor Deployment of deployment descriptor [C:\Users\XXX\acs7\tomcat\conf\Catalina\localhost\share.xml] has finished in [70,287] ms
11-May-2021 13:16:48.757 INFO [main] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [C:\Users\XXX\acs7\tomcat\webapps\ROOT.war]
11-May-2021 13:16:48.764 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin Match [Context] failed to set property [debug] to [100]
11-May-2021 13:16:49.318 INFO [main] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
11-May-2021 13:16:49.326 INFO [main] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [C:\Users\XXX\acs7\tomcat\webapps\ROOT.war] has finished in [570] ms
11-May-2021 13:16:49.334 INFO [main] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [C:\Users\XXX\acs7\tomcat\webapps\_vti_bin.war]
11-May-2021 13:16:49.993 INFO [main] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
11-May-2021 13:16:50.021 INFO [main] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [C:\Users\XXX\acs7\tomcat\webapps\_vti_bin.war] has finished in [688] ms
11-May-2021 13:16:50.040 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"]
11-May-2021 13:16:50.089 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in [300258] milliseconds
2021-05-11 13:16:50,369 INFO [management.subsystems.ChildApplicationContextFactory] [http-nio-8080-exec-1] Starting 'Search' subsystem, ID: [Search, managed, solr6]
2021-05-11 13:16:53,153 INFO [management.subsystems.ChildApplicationContextFactory] [http-nio-8080-exec-1] Startup of 'Search' subsystem, ID: [Search, managed, solr6] complete

Please guide what's wrong here I am doing.

Thanks,
Vikash

Re: ImageMagick & Libreoffice not working.

afaust — Tue, 11 May 2021 10:16:42 GMT

You might have missed the fact that ACS 7.0 no longer supports the legacy transformers. Those have been deprecated in 6.1 and 6.2, and were finally removed in 7.0. Now all transformations have to go through the new framework with T-Engines, which are separate Java applications that interact with LibreOffice / ImageMagick / etc. Unfortunately, T-Engines are currently under-documented on docs.alfresco.com - they are only mentioned in passing, e.g. when listing the various Alfresco Docker containers

So your best bet currently is to set them up using Docker-Compose and configure the appropriate URLs in the global properties.

topic Re: ImageMagick & Libreoffice not working. in Alfresco Forum

ImageMagick & Libreoffice not working.

Re: ImageMagick & Libreoffice not working.