Couldn't detect product, will use ProductFilter.ALL

[Jiri Pik]

How to fix this?

2018-02-26 18:06:06,200 WARN [ThreadPoolAsyncTaskExecutor::Thread 6] [spring.scanner.util.ProductFilterUtil] detectProduct Couldn't detect product, will use ProductFilter.ALL
2018-02-26 18:06:06,454 WARN [ThreadPoolAsyncTaskExecutor::Thread 19] [spring.scanner.util.ProductFilterUtil] detectProduct Couldn't detect product, will use ProductFilter.ALL

[AnnWorley · Accepted solution]

Hi Jiri,

I have seen those warnings in healthy logs. They are benign in most cases (see the comment on Run-time product detection doesn't work for Confluence):

did you mean: you're seeing these "Couldn't detect product" messages in your Confluence 5.9.5 logs, but nothing specific is broken? (If so, you probably can just ignore them - they're harmless in most cases)

 Best wishes,

Ann

[Sanjeev kumar N]

Hi Worley,

Even i am getting the same error and not able to login to confluence URL, attaching the logs of atlassian-confluence.log and catalina.out  for the ref....

Any help please.

History:

We have experienced a loss of our VM server that host our confluence instance.

We have restarted thee server and confluence service with oracle 12 DB with no issues but confluence application is not starting properly. Below is the error.

You cannot access Confluence at present. Look at the table below to identify the reasons.
Type         Description                                             Exception     Level     Time
startup     Unable to start up Confluence. Fatal error during startup sequence:                fatal                    2018-06-04 12:54:38
        confluence.lifecycle.core:mananagedjobs (Start and stop the Managed Scheduled Jobs)
        - org.springframework.transaction.UnexpectedRollbackException: Transaction rolled back
        because it has been marked as rollback-only

Your server id is: XXXX-XXXX-XXXX-XXXX


atlassian-confluence.log

  2018-06-04 12:53:15,285 INFO [localhost-startStop-1] [com.atlassian.confluence.lifecycle] contextInitialized Starting Confluence 6.2.1 [build 7111 based on commit hash a907385b66       
       baaca023118cdaeb4d4b0e6dac0f88] - synchrony version 0.3.1-release-confluence_6.1-e20fb944
      2 2018-06-04 12:53:18,191 INFO [localhost-startStop-1] [atlassian.confluence.cluster.DefaultClusterConfigurationHelper] lambda$populateExistingClusterSetupConfig$1
     Populating setup configuration if running with Cluster mode...
      3 2018-06-04 12:53:18,464 INFO [localhost-startStop-1] [springframework.web.context.ContextLoader] initWebApplicationContext Root WebApplicationContext: initialization started
      4 2018-06-04 12:53:22,293 INFO [localhost-startStop-1] [com.atlassian.confluence.lifecycle] <init> Loading EhCache cache manager
      5 2018-06-04 12:53:35,499 INFO [localhost-startStop-1] [springframework.web.context.ContextLoader] initWebApplicationContext Root WebApplicationContext: initialization completed in   
      17035 ms
      6 2018-06-04 12:53:40,334 INFO [localhost-startStop-1] [atlassian.plugin.manager.DefaultPluginManager] earlyStartup Plugin system earlyStartup begun
      7 2018-06-04 12:54:02,388 WARN [ThreadPoolAsyncTaskExecutor::Thread 16] [spring.scanner.util.ProductFilterUtil] detectProduct Couldn't detect product, will use ProductFilter.ALL
      8 2018-06-04 12:54:02,396 WARN [ThreadPoolAsyncTaskExecutor::Thread 19] [spring.scanner.util.ProductFilterUtil] detectProduct Couldn't detect product, will use ProductFilter.ALL
      9 2018-06-04 12:54:04,815 WARN [ThreadPoolAsyncTaskExecutor::Thread 6] [spring.scanner.util.ProductFilterUtil] detectProduct Couldn't detect product, will use ProductFilter.ALL
     10 2018-06-04 12:54:24,862 INFO [localhost-startStop-1] [atlassian.plugin.manager.DefaultPluginManager] logTime Plugin system earlyStartup ended
     11 2018-06-04 12:54:24,937 INFO [localhost-startStop-1] [atlassian.plugin.manager.DefaultPluginManager] lateStartup Plugin system lateStartup begun
     12 2018-06-04 12:54:25,671 WARN [AtlassianEvent::CustomizableThreadFactory-1] [jdbc.connections.internal.ConnectionProviderInitiator] instantiateC3p0Provider HHH000022: c3p0
     properties were encountered, but the c3p0 provider class was not found on the classpath; these properties are going to be ignored.
     13 2018-06-04 12:54:25,683 WARN [AtlassianEvent::CustomizableThreadFactory-1] [hibernate.orm.connections.pooling] configure HHH10001002: Using Hibernate built-in connection pool
    (not for production use!)
     14 2018-06-04 12:54:27,672 WARN [ThreadPoolAsyncTaskExecutor::Thread 23] [client.eventfilter.whitelist.AnalyticsWhitelistModuleDescriptor] readPluginWhitelist No whitelist resource
     file found at [mediaviewer/lib/analytics-whitelist.json] in plugin [com.atlassian.confluence.plugins.confluence-previews] (bundle entry not found)
     15 2018-06-04 12:54:27,672 WARN [ThreadPoolAsyncTaskExecutor::Thread 23] [client.eventfilter.whitelist.AnalyticsWhitelistModuleDescriptor] readPluginWhitelist No whitelist resource
     file found at [mediaviewer/lib/analytics-whitelist.json] in plugin [com.atlassian.confluence.plugins.confluence-previews] (null InputStream)
     16 2018-06-04 12:54:28,914 ERROR [ThreadPoolAsyncTaskExecutor::Thread 4] [spring.scanner.extension.ComponentImportBeanFactoryPostProcessor]
     postProcessBeanFactory Unable to load class 'com.atlassian.bitbucket.auth.RememberMeService' for component importation purposes.  Skipping...
     17 2018-06-04 12:54:28,915 ERROR [ThreadPoolAsyncTaskExecutor::Thread 4] [spring.scanner.extension.ComponentImportBeanFactoryPostProcessor]
     postProcessBeanFactory Unable to load class 'com.atlassian.jira.config.properties.ApplicationProperties' for component importation purposes.  Skipping...

     18 2018-06-04 12:54:29,045 INFO [ThreadPoolAsyncTaskExecutor::Thread 5] [plugins.synchrony.utils.TomcatConfigHelper] getConnectorPort Tomcat connector port:
     19 2018-06-04 12:54:29,057 INFO [ThreadPoolAsyncTaskExecutor::Thread 5] [plugins.synchrony.bootstrap.DefaultSynchronyProxyMonitor]
     <init> synchrony-proxy healthcheck url: http://127.0.0.1:8090/synchrony-proxy/healthcheck
     20 2018-06-04 12:54:30,616 INFO [localhost-startStop-1] [atlassian.plugin.manager.DefaultPluginManager] logTime Plugin system lateStartup ended
     21 2018-06-04 12:54:30,756 WARN [lifecycle:thread-11] [expose.jmx.schedule.JmxInstrumentSchedulerImpl] onStart atlassian-instrumentation-jmx expose scheduler started.
     22 2018-06-04 12:54:30,758 INFO [lifecycle:thread-8] [plugins.synchrony.bootstrap.DefaultSynchronyProcessManager] startup Starting Synchrony and enabling Collaborative Editing
     23 2018-06-04 12:54:30,958 WARN [lifecycle:thread-5] [hql.internal.ast.HqlSqlWalker] generatePositionalParameter [DEPRECATION] Encountered positional parameter near line 1,
     column 9  3 in HQL: [FROM com.atlassian.confluence.impl.schedule.caesium.SchedulerClusteredJob t WHERE t.jobId = ?].  Positional parameter are considered deprecated;
     use named parameters or JPA-style positional parameters instead.

     24 2018-06-04 12:54:32,458 WARN [UpmScheduler:thread-1] [hql.internal.ast.HqlSqlWalker] generatePositionalParameter [DEPRECATION] Encountered positional parameter near line 1,
    column 110 in HQL: [SELECT usr.name, usr.lowerName FROM com.atlassian.crowd.model.user.InternalUser usr WHERE usr.directory.id = ? AND usr.active = ? ORDER BY usr.lowerName].  
    Positional parameter are considered deprecated; use named parameters or JPA-style positional parameters instead.

     25 2018-06-04 12:54:32,463 WARN [UpmScheduler:thread-1] [hql.internal.ast.HqlSqlWalker] generatePositionalParameter [DEPRECATION]
     Encountered positional parameter near line 1, column 129 in HQL: [SELECT usr.name, usr.lowerName FROM com.atlassian.crowd.model.user.InternalUser usr
     WHERE usr.directory.id = ? AND usr.active = ? ORDER BY usr.lowerName].  
      Positional parameter are considered deprecated; use named parameters or JPA-style positional parameters instead.
     26 2018-06-04 12:54:32,925 WARN [UpmScheduler:thread-1] [hql.internal.ast.HqlSqlWalker] generatePositionalParameter [DEPRECATION]
    Encountered positional parameter near line 1, column 159 in HQL: [SELECT mem.userMember.name FROM com.atlassian.crowd.embedded.hibernate2.HibernateMembership mem WHERE mem.groupMember
     is null and mem.parentGroup.lowerName = ? and mem.parentGroup.directory.id = ? and mem.parentGroup.type = ? ORDER BY mem.userMember.lowerName].  
     Positional parameter are considered deprecated; use named parameters or JPA-style positional parameters instead.

=====Catalina.out log========

 1 04-Jun-2018 12:53:11.672 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin [SetPropertiesRule]{Server} Setting property 'debug' to '0' did not find a matching property.
      2 04-Jun-2018 12:53:11.764 WARNING [main] org.apache.catalina.startup.SetAllPropertiesRule.begin [SetAllPropertiesRule]{Server/Service/Connector} Setting property 'debug' to '0' did not         find a matching property.
      3 04-Jun-2018 12:53:11.775 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin [SetPropertiesRule]{Server/Service/Engine} Setting property 'debug' to '0' did not find         a matching property.
      4 04-Jun-2018 12:53:11.780 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin [SetPropertiesRule]{Server/Service/Engine/Host} Setting property 'debug' to '0' did not         find a matching property.
      5 04-Jun-2018 12:53:11.824 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin [SetPropertiesRule]{Server/Service/Engine/Host/Context} Setting property 'debug' to '0'         did not find a matching property.
      6 04-Jun-2018 12:53:11.846 WARNING [main] org.apache.tomcat.util.digester.SetPropertiesRule.begin [SetPropertiesRule]{Server/Service/Engine/Host/Context} Setting property 'debug' to '0'         did not find a matching property.
      7 04-Jun-2018 12:53:12.209 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8090"]
      8 04-Jun-2018 12:53:12.228 INFO [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read
      9 04-Jun-2018 12:53:12.231 INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 641 ms
     10 04-Jun-2018 12:53:12.248 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat-Standalone
     11 04-Jun-2018 12:53:12.249 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.43
     12 SLF4J: A number (1) of logging calls during the initialization phase have been intercepted and are
     13 SLF4J: now being replayed. These are subject to the filtering rules of the underlying logging system.
     14 SLF4J: See also http://www.slf4j.org/codes.html#replay
     15 04-Jun-2018 12:53:14.417 INFO [localhost-startStop-2] org.apache.catalina.core.ApplicationContext.log Spring WebApplicationInitializers detected on classpath:
     [com.atlassian.synchrony.proxy.SynchronyDispatcherServletInitializer@30f6c4d4]
     16 2018-06-04 12:53:15,285 INFO [localhost-startStop-1] [com.atlassian.confluence.lifecycle] contextInitialized Starting Confluence 6.2.1
    [build 7111 based on commit hash a907385b66baaca023118cdaeb4d4b0e6dac0f88] - synchrony version 0.3.1-release-confluence_6.1-e20fb944
     17 2018-06-04 12:53:18,191 INFO [localhost-startStop-1] [atlassian.confluence.cluster.DefaultClusterConfigurationHelper]
      lambda$populateExistingClusterSetupConfig$1 Populating setup configuration if running with Cluster mode...
     18 04-Jun-2018 12:53:39.961 INFO [localhost-startStop-2] org.apache.catalina.util.SessionIdGeneratorBase.createSecureRandom Creation of SecureRandom instance for session
    ID generation using [SHA1PRNG] took [25,205] milliseconds.
     19 04-Jun-2018 12:53:40.186 INFO [localhost-startStop-2] org.apache.catalina.core.ApplicationContext.log Initializing Spring FrameworkServlet 'dispatcher'
     20 04-Jun-2018 12:53:40.186 INFO [localhost-startStop-2] org.springframework.web.servlet.DispatcherServlet.initServletBean FrameworkServlet 'dispatcher': initialization started
     21 04-Jun-2018 12:53:40.194 INFO [localhost-startStop-2] org.springframework.web.context.support.AnnotationConfigWebApplicationContext.prepareRefresh Refreshing
     WebApplicationContext for namespace 'dispatcher-servlet': startup date [Mon Jun 04 12:53:40 CEST 2018]; root of context hierarchy
     22 04-Jun-2018 12:53:40.271 INFO [localhost-startStop-2] org.springframework.web.context.support.AnnotationConfigWebApplicationContext.loadBeanDefinitions
     Registering annotated classes: [class com.atlassian.synchrony.proxy.websocket.WebSocketConfig,class com.atlassian.synchrony.proxy.web.SynchronyWebMvcConfig]
     23 04-Jun-2018 12:53:41.226 INFO [localhost-startStop-2] org.springframework.scheduling.concurrent.ThreadPoolTaskScheduler.initialize Initializing ExecutorService
     'defaultSockJsTaskScheduler'
     24 04-Jun-2018 12:53:41.741 INFO [localhost-startStop-2] org.springframework.web.socket.server.support.WebSocketHandlerMapping.registerHandler
     Mapped URL path [/sockjs/v1/**] onto handler of type [class org.springframework.web.socket.sockjs.support.SockJsHttpRequestHandler]
     25 04-Jun-2018 12:53:42.264 INFO [localhost-startStop-2] org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping.register
     Mapped "{[/reload],methods=[PUT]}" onto public org.springframework.http.ResponseEntity com.atlassian.synchrony.proxy.web.SynchronyProxyRestController.reloadConfiguration
      (com.atlassian.synchrony.proxy.web.SynchronyProxyConfigPayload)
     26 04-Jun-2018 12:53:42.265 INFO [localhost-startStop-2] org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping.register
     Mapped "{[/healthcheck]}" onto public com.atlassian.synchrony.proxy.web.HealthCheckResult com.atlassian.synchrony.proxy.web.SynchronyProxyRestController.getSynchronyProxyInfo()
     27 04-Jun-2018 12:53:42.310 INFO [localhost-startStop-2] org.springframework.web.servlet.handler.SimpleUrlHandlerMapping.registerHandler
    Mapped URL path [/**] onto handler of type [class org.springframework.web.servlet.resource.DefaultServletHttpRequestHandler]
     28 04-Jun-2018 12:53:42.388 INFO [localhost-startStop-2] org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.initControllerAdviceCache
    Looking for @Controll erAdvice: WebApplicationContext for namespace 'dispatcher-servlet': startup date [Mon Jun 04 12:53:40 CEST 2018]; root of context hierarchy
     29 04-Jun-2018 12:53:42.583 INFO [localhost-startStop-2] org.springframework.context.support.DefaultLifecycleProcessor.start Starting beans in phase 2147483647
     30 04-Jun-2018 12:53:42.630 INFO [localhost-startStop-2] org.springframework.web.servlet.DispatcherServlet.initServletBean FrameworkServlet 'dispatcher':
     initialization completed in 2443

Thanks

Sanjeev kumar N