You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@usergrid.apache.org by Guillaume <gu...@gmail.com> on 2016/03/31 21:41:04 UTC

keep having problems to start tomcat7 after downgrading versions

Here I use :

JDK: 1.8
Tomcat: 7
Cassandra: 2.2.5
Elasticsearch: 1.4.5

on Debian/Jessie

here is the catalina.out result :

Mar 31, 2016 8:13:29 PM org.apache.catalina.startup.HostConfig
deployDescriptor
INFO: Deploying configuration descriptor
/etc/tomcat7/Catalina/localhost/host-manager.xml
Mar 31, 2016 8:13:30 PM org.apache.catalina.startup.HostConfig
deployDescriptor
INFO: Deployment of configuration descriptor
/etc/tomcat7/Catalina/localhost/host-manager.xml has finished in 317 ms
Mar 31, 2016 8:13:30 PM org.apache.catalina.startup.HostConfig
deployDescriptor
INFO: Deploying configuration descriptor
/etc/tomcat7/Catalina/localhost/manager.xml
Mar 31, 2016 8:13:30 PM org.apache.catalina.startup.HostConfig
deployDescriptor
INFO: Deployment of configuration descriptor
/etc/tomcat7/Catalina/localhost/manager.xml has finished in 66 ms
Mar 31, 2016 8:13:30 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /var/lib/tomcat7/webapps/ROOT.war
20:13:35,967  INFO ContextLoader:285 - Root WebApplicationContext:
initialization started
20:13:36,053  INFO XmlWebApplicationContext:512 - Refreshing Root
WebApplicationContext: startup date [Thu Mar 31 20:13:36 CEST 2016]; root
of context hierarchy
20:13:36,099  INFO XmlBeanDefinitionReader:316 - Loading XML bean
definitions from class path resource [usergrid-rest-deploy-context.xml]
20:13:36,175  INFO XmlBeanDefinitionReader:316 - Loading XML bean
definitions from class path resource [usergrid-rest-context.xml]
20:13:36,206  INFO XmlBeanDefinitionReader:316 - Loading XML bean
definitions from class path resource [usergrid-services-context.xml]
20:13:36,375  INFO XmlBeanDefinitionReader:316 - Loading XML bean
definitions from class path resource [usergrid-core-context.xml]
20:13:36,819  INFO DefaultListableBeanFactory:675 - Overriding bean
definition for bean 'injector': replacing [Generic bean: class
[org.apache.usergrid.corepersistence.GuiceFactory]; scope=; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in class path resource
[usergrid-core-context.xml]] with [Generic bean: class
[org.apache.usergrid.corepersistence.GuiceFactory]; scope=; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in class path resource
[usergrid-services-context.xml]]
20:13:36,929  INFO DefaultListableBeanFactory:675 - Overriding bean
definition for bean 'securityManager': replacing [Generic bean: class
[org.apache.shiro.mgt.DefaultSecurityManager]; scope=; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in class path resource
[usergrid-services-context.xml]] with [Generic bean: class
[org.apache.usergrid.rest.security.shiro.RestSecurityManager]; scope=;
abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0;
autowireCandidate=true; primary=false; factoryBeanName=null;
factoryMethodName=null; initMethodName=null; destroyMethodName=null;
defined in class path resource [usergrid-rest-context.xml]]
20:13:36,930  INFO DefaultListableBeanFactory:675 - Overriding bean
definition for bean 'taskExecutor': replacing [Generic bean: class
[org.springframework.core.task.SyncTaskExecutor]; scope=; abstract=false;
lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true;
primary=false; factoryBeanName=null; factoryMethodName=null;
initMethodName=null; destroyMethodName=null; defined in class path resource
[usergrid-services-context.xml]] with [Generic bean: class
[org.springframework.scheduling.concurrent.ThreadPoolTaskExecutor]; scope=;
abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0;
autowireCandidate=true; primary=false; factoryBeanName=null;
factoryMethodName=null; initMethodName=null; destroyMethodName=null;
defined in class path resource [usergrid-rest-context.xml]]
20:13:36,931  INFO DefaultListableBeanFactory:675 - Overriding bean
definition for bean 'serviceResource': replacing [Generic bean: class
[org.apache.usergrid.rest.applications.ServiceResource]; scope=prototype;
abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0;
autowireCandidate=true; primary=false; factoryBeanName=null;
factoryMethodName=null; initMethodName=null; destroyMethodName=null;
defined in file
[/var/lib/tomcat7/webapps/ROOT/WEB-INF/classes/org/apache/usergrid/rest/applications/ServiceResource.class]]
with [Generic bean: class
[org.apache.usergrid.rest.applications.ServiceResource]; scope=prototype;
abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0;
autowireCandidate=true; primary=false; factoryBeanName=null;
factoryMethodName=null; initMethodName=null; destroyMethodName=null;
defined in class path resource [usergrid-rest-context.xml]]
20:13:37,359  INFO PropertiesFactoryBean:172 - Loading properties file from
class path resource [usergrid-default.properties]
20:13:37,362  INFO PropertiesFactoryBean:172 - Loading properties file from
class path resource [usergrid-deployment.properties]
20:13:37,397  INFO AutowiredAnnotationBeanPostProcessor:141 - JSR-330
'javax.inject.Inject' annotation found and supported for autowiring
20:13:37,543  INFO RestSecurityManager:56 - Replacing
org.apache.shiro.web.session.mgt.ServletContainerSessionManager@7c4b46ba
with HttpRequestSessionManager
20:13:37,595  INFO XmlWebApplicationContext:1376 - Bean
'org.springframework.beans.factory.config.MethodInvokingFactoryBean#0' of
type [class
org.springframework.beans.factory.config.MethodInvokingFactoryBean] is not
eligible for getting processed by all BeanPostProcessors (for example: not
eligible for auto-proxying)
20:13:37,661  INFO XmlWebApplicationContext:1376 - Bean 'traceTagReporter'
of type [class
org.apache.usergrid.persistence.cassandra.util.Slf4jTraceTagReporter] is
not eligible for getting processed by all BeanPostProcessors (for example:
not eligible for auto-proxying)
20:13:37,663  INFO XmlWebApplicationContext:1376 - Bean 'traceTagManager'
of type [class
org.apache.usergrid.persistence.cassandra.util.TraceTagManager] is not
eligible for getting processed by all BeanPostProcessors (for example: not
eligible for auto-proxying)
20:13:37,667  INFO XmlWebApplicationContext:1376 - Bean 'taggedOpTimer' of
type [class org.apache.usergrid.persistence.cassandra.util.TaggedOpTimer]
is not eligible for getting processed by all BeanPostProcessors (for
example: not eligible for auto-proxying)
20:13:37,694  INFO XmlWebApplicationContext:1376 - Bean
'loadBalancingPolicy' of type [class
me.prettyprint.cassandra.connection.DynamicLoadBalancingPolicy] is not
eligible for getting processed by all BeanPostProcessors (for example: not
eligible for auto-proxying)
20:13:37,695  INFO XmlWebApplicationContext:1376 - Bean
'cassandraHostConfigurator' of type [class
me.prettyprint.cassandra.service.CassandraHostConfigurator] is not eligible
for getting processed by all BeanPostProcessors (for example: not eligible
for auto-proxying)
20:13:37,703  INFO XmlWebApplicationContext:1376 - Bean 'injector' of type
[class org.apache.usergrid.corepersistence.GuiceFactory] is not eligible
for getting processed by all BeanPostProcessors (for example: not eligible
for auto-proxying)
20:13:37,704  INFO GuiceFactory:89 - Loading Core Persistence properties
20:13:37,711  INFO GuiceFactory:107 - hostsString: 127.0.0.1
20:13:37,731  WARN URLConfigurationSource:120 - No URLs will be polled as
dynamic configuration sources.
20:13:37,732  INFO URLConfigurationSource:121 - To enable URLs as dynamic
configuration sources, define System property
archaius.configurationSource.additionalUrls or make config.properties
available on classpath.
20:13:37,760  INFO XmlWebApplicationContext:1376 - Bean 'serviceModule' of
type [class org.apache.usergrid.services.guice.ServiceModuleImpl] is not
eligible for getting processed by all BeanPostProcessors (for example: not
eligible for auto-proxying)
20:13:38,774  WARN GuicyFigModule:352 - No property defaults file
org/apache/usergrid/persistence/core/astyanax/CassandraFig.properties found
for CassandraFig.
20:13:38,785  INFO DynamicPropertyFactory:281 - DynamicPropertyFactory is
initialized with configuration sources:
com.netflix.config.ConcurrentCompositeConfiguration@7842de02
20:13:38,989  INFO ConnectionPoolMBeanManager:53 - Registering mbean:
com.netflix.MonitoredResources:type=ASTYANAX,name=ConnectionPool-Shared,ServiceType=connectionpool
20:13:39,000  INFO CountingConnectionPoolMonitor:194 - AddHost: 127.0.0.1
20:13:39,001  INFO Slf4jConnectionPoolMonitorImpl:67 - HostAdded:
127.0.0.1(127.0.0.1):9160
20:13:39,237  INFO AstyanaxLockManagerImpl:183 - Keyspace Locks created or
already exists with options
{strategy_class=org.apache.cassandra.locator.SimpleStrategy,
strategy_options={replication_factor=1}}
20:13:39,241  INFO AstyanaxLockManagerImpl:140 - Locks column family
AstyanaxLocks exists with options: {gc_grace_seconds=60,
compaction_strategy_options={sstable_size_in_mb=512}, caching=ALL,
compaction_strategy=org.apache.cassandra.db.compaction.LeveledCompactionStrategy}
20:13:39,242  WARN GuicyFigModule:352 - No property defaults file
org/apache/usergrid/persistence/index/IndexFig.properties found for
IndexFig.
20:13:39,257  WARN GuicyFigModule:352 - No property defaults file
org/apache/usergrid/persistence/core/metrics/MetricsFig.properties found
for MetricsFig.
20:13:39,264  WARN MetricsFactoryImpl:65 - MetricsService:Logger not
started.
20:13:39,464  INFO node:139 - [ES-1] version[1.4.4], pid[22864],
build[c88f77f/2015-02-19T13:05:36Z]
20:13:39,465  INFO node:141 - [ES-1] initializing ...
20:13:39,469  INFO plugins:151 - [ES-1] loaded [], sites []
20:13:41,227  INFO node:207 - [ES-1] initialized
20:13:41,227  INFO node:226 - [ES-1] starting ...
20:13:41,269  INFO transport:93 - [ES-1] bound_address {inet[
0.0.0.0/0.0.0.0:9301] <http://0.0.0.0/0.0.0.0:9301%5D>

}, publish_address {inet[/85.159.232.235:9301

]}
20:13:41,280  INFO discovery:85 - [ES-1]
elasticsearch/8EyL0XM0R1uBbwMTroU8Zw
20:13:45,052  WARN unicast:460 - [ES-1] failed to send ping to
[[#zen_unicast_1#][node1.astrosaid.com

][inet[/127.0.0.1:9200]]]
org.elasticsearch.transport.ReceiveTimeoutTransportException:
[][inet[/127.0.0.1:9200]][internal:discovery/zen/unicast_gte_1_4]
request_id [0] timed out after [3750ms]
at
org.elasticsearch.transport.TransportService$TimeoutHandler.run(TransportService.java:366)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
20:13:49,543  WARN unicast:460 - [ES-1] failed to send ping to
[[#zen_unicast_1#][node1.astrosaid.com

][inet[/127.0.0.1:9200]]]
org.elasticsearch.transport.ReceiveTimeoutTransportException:
[][inet[/127.0.0.1:9200]][internal:discovery/zen/unicast_gte_1_4]
request_id [3] timed out after [3751ms]
at
org.elasticsearch.transport.TransportService$TimeoutHandler.run(TransportService.java:366)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
20:13:54,046  WARN unicast:460 - [ES-1] failed to send ping to
[[#zen_unicast_1#][node1.astrosaid.com

][inet[/127.0.0.1:9200]]]
org.elasticsearch.transport.ReceiveTimeoutTransportException:
[][inet[/127.0.0.1:9200]][internal:discovery/zen/unicast_gte_1_4]
request_id [6] timed out after [3750ms]
at
org.elasticsearch.transport.TransportService$TimeoutHandler.run(TransportService.java:366)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
20:14:03,051  WARN unicast:460 - [ES-1] failed to send ping to
[[#zen_unicast_1#][node1.astrosaid.com

][inet[/127.0.0.1:9200]]]
org.elasticsearch.transport.ReceiveTimeoutTransportException:
[][inet[/127.0.0.1:9200]][internal:discovery/zen/unicast_gte_1_4]
request_id [12] timed out after [3751ms]
at
org.elasticsearch.transport.TransportService$TimeoutHandler.run(TransportService.java:366)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)


note I use a "compiled" version of ROOT.war, I already tried with build
2.1.0 but I have more errors.

now I use openjdk 1.8 instead of sun java for all services.

here is the result from elasticsearch log :

[2016-03-31 20:07:05,181][WARN ][http.netty               ] [ES-1] Caught
exception while handling client http traffic, closing connection [id:
0x26c60774, /127.0.0.1:44571 => /127.0.0.1:9200]
java.lang.IllegalArgumentException: empty text
at
org.elasticsearch.common.netty.handler.codec.http.HttpVersion.<init>(HttpVersion.java:97)
at
org.elasticsearch.common.netty.handler.codec.http.HttpVersion.valueOf(HttpVersion.java:62)
at
org.elasticsearch.common.netty.handler.codec.http.HttpRequestDecoder.createMessage(HttpRequestDecoder.java:75)
at
org.elasticsearch.common.netty.handler.codec.http.HttpMessageDecoder.decode(HttpMessageDecoder.java:191)
at
org.elasticsearch.common.netty.handler.codec.http.HttpMessageDecoder.decode(HttpMessageDecoder.java:102)
at
org.elasticsearch.common.netty.handler.codec.replay.ReplayingDecoder.callDecode(ReplayingDecoder.java:500)
at
org.elasticsearch.common.netty.handler.codec.replay.ReplayingDecoder.messageReceived(ReplayingDecoder.java:435)
at
org.elasticsearch.common.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70)
at
org.elasticsearch.common.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564)
at
org.elasticsearch.common.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791)
at
org.elasticsearch.common.netty.OpenChannelsHandler.handleUpstream(OpenChannelsHandler.java:74)
at
org.elasticsearch.common.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564)
at
org.elasticsearch.common.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:559)
at
org.elasticsearch.common.netty.channel.Channels.fireMessageReceived(Channels.java:268)
at
org.elasticsearch.common.netty.channel.Channels.fireMessageReceived(Channels.java:255)
at
org.elasticsearch.common.netty.channel.socket.nio.NioWorker.read(NioWorker.java:88)
at
org.elasticsearch.common.netty.channel.socket.nio.AbstractNioWorker.process(AbstractNioWorker.java:108)
at
org.elasticsearch.common.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318)
at
org.elasticsearch.common.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:89)
at
org.elasticsearch.common.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)
at
org.elasticsearch.common.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108)
at
org.elasticsearch.common.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)


# curl -v 127.0.0.1:9200
* Rebuilt URL to: 127.0.0.1:9200/
* Hostname was NOT found in DNS cache
*   Trying 127.0.0.1...
* Connected to 127.0.0.1 (127.0.0.1) port 9200 (#0)
> GET / HTTP/1.1
> User-Agent: curl/7.38.0
> Host: 127.0.0.1:9200
> Accept: */*
>
< HTTP/1.1 200 OK
< Content-Type: application/json; charset=UTF-8
< Content-Length: 332
<
{
  "status" : 200,
  "name" : "ES-1",
  "cluster_name" : "elasticsearch",
  "version" : {
    "number" : "1.4.5",
    "build_hash" : "2aaf797f2a571dcb779a3b61180afe8390ab61f9",
    "build_timestamp" : "2015-04-27T08:06:06Z",
    "build_snapshot" : false,
    "lucene_version" : "4.10.4"
  },
  "tagline" : "You Know, for Search"
}
* Connection #0 to host 127.0.0.1 left intact


# nodetool status
Datacenter: datacenter1
=======================
Status=Up/Down
|/ State=Normal/Leaving/Joining/Moving
--  Address    Load       Tokens       Owns    Host ID
          Rack
UN  127.0.0.1  130.38 KB  256          ?
a83d15ee-893f-4613-abca-a80d29e047a1  rack1

*Note: Non-system keyspaces don't have the same replication settings,
effective ownership information is meaningless <<< ???*

Well if you have other ideas ? Thank you for helping to deploy.