https://bz.apache.org/bugzilla/show_bug.cgi?id=64478
Bug ID: 64478
Summary: org.apache.coyote.http11.Http11Processor.service Error
parsing HTTP request header
Product: Tomcat 9
Version: 9.0.35
Hardware: Other
OS: Linux
Status: NEW
Severity: blocker
Priority: P2
Component: Connectors
Assignee: dev@tomcat.apache.org
Reporter: aris...@gmail.com
Target Milestone: -----
With the Tomcat version 9.0.35, the following error occurs without deploying
any custom application,
28-May-2020 06:08:44.960 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardServer[8005]] to [INITIALIZING]
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server version name:
Apache Tomcat/9.0.35
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server built:
May 5 2020 20:36:20 UTC
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server version number:
9.0.35.0
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log OS Name:
Linux
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log OS Version:
4.1.12-124.38.1.el6uek.x86_64
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Architecture:
amd64
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Java Home:
/usr/local/jdk/jre
28-May-2020 06:08:44.963 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log JVM Version:
1.8.0_251-b08
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:
Oracle Corporation
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:
/home/tomcat/test1/apache-tomcat-9.0.35
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:
/home/tomcat/test1/apache-tomcat-9.0.35
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.util.logging.config.file=/home/tomcat/test1/apache-tomcat-9
.0.35/conf/logging.properties
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djdk.tls.ephemeralDHKeySize=2048
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.protocol.handler.pkgs=org.apache.catalina.webresources
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dorg.apache.catalina.security.SecurityListener.UMASK=0027
28-May-2020 06:08:44.964 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dignore.endorsed.dirs=
28-May-2020 06:08:44.965 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dcatalina.base=/home/tomcat/test1/apache-tomcat-9.0.35
28-May-2020 06:08:44.965 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dcatalina.home=/home/tomcat/test1/apache-tomcat-9.0.35
28-May-2020 06:08:44.965 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.io.tmpdir=/home/tomcat/test1/apache-tomcat-9.0.35/temp
28-May-2020 06:08:44.965 INFO [main]
org.apache.catalina.core.AprLifecycleListener.lifecycleEvent The Apache Tomcat
Native library which allows using OpenSSL was not found on the j
ava.library.path:
[/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib]
28-May-2020 06:08:45.213 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.deploy.NamingResourcesImpl@3c0f93f1] to [INITIAL
IZING]
28-May-2020 06:08:45.215 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.deploy.NamingResourcesImpl@3c0f93f1] to [INITIAL
IZED]
28-May-2020 06:08:45.229 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardService[Catalina]] to [INITIALIZING]
28-May-2020 06:08:45.230 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina]] to [INITIALIZING]
28-May-2020 06:08:45.231 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina]] to [INITIALIZED]
28-May-2020 06:08:45.231 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.mapper.MapperListener@6fc6f14e] to [INITIALIZING
]
28-May-2020 06:08:45.234 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.mapper.MapperListener@6fc6f14e] to [INITIALIZED]
28-May-2020 06:08:45.234 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[Connector[HTTP/1.1-8080]] to [INITIALIZING]
28-May-2020 06:08:45.238 INFO [main] org.apache.coyote.AbstractProtocol.init
Initializing ProtocolHandler ["http-nio-8080"]
28-May-2020 06:08:45.257 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[Connector[HTTP/1.1-8080]] to [INITIALIZED]
28-May-2020 06:08:45.257 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardService[Catalina]] to [INITIALIZED]
28-May-2020 06:08:45.257 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardServer[8005]] to [INITIALIZED]
28-May-2020 06:08:45.258 INFO [main] org.apache.catalina.startup.Catalina.load
Server initialization in [441] milliseconds
28-May-2020 06:08:45.258 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardServer[8005]] to [STARTING_PREP]
28-May-2020 06:08:45.264 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardServer[8005]] to [STARTING]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.deploy.NamingResourcesImpl@3c0f93f1] to [STARTIN
G_PREP]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.deploy.NamingResourcesImpl@3c0f93f1] to [STARTIN
G]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.deploy.NamingResourcesImpl@3c0f93f1] to [STARTED
]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardService[Catalina]] to [STARTING_PREP]
28-May-2020 06:08:45.277 INFO [main]
org.apache.catalina.core.StandardService.startInternal Starting service
[Catalina]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardService[Catalina]] to [STARTING]
28-May-2020 06:08:45.277 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina]] to [STARTING_PREP]
28-May-2020 06:08:45.277 INFO [main]
org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine:
[Apache Tomcat/9.0.35]
28-May-2020 06:08:45.278 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[LockOutRealm[StandardEngine[Catalina]]] to [INITIALIZING]
28-May-2020 06:08:45.278 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[LockOutRealm[StandardEngine[Catalina]]] to [INITIALIZED]
28-May-2020 06:08:45.278 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[LockOutRealm[StandardEngine[Catalina]]] to [STARTING_PREP]
28-May-2020 06:08:45.279 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[UserDatabaseRealm[StandardEngine[Catalina]]] to [INITIALIZING]
28-May-2020 06:08:45.279 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[UserDatabaseRealm[StandardEngine[Catalina]]] to [INITIALIZED]
28-May-2020 06:08:45.279 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[UserDatabaseRealm[StandardEngine[Catalina]]] to [STARTING_PREP]
28-May-2020 06:08:45.280 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[UserDatabaseRealm[StandardEngine[Catalina]]] to [STARTING]
28-May-2020 06:08:45.280 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[UserDatabaseRealm[StandardEngine[Catalina]]] to [STARTED]
28-May-2020 06:08:45.280 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[LockOutRealm[StandardEngine[Catalina]]] to [STARTING]
28-May-2020 06:08:45.280 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[LockOutRealm[StandardEngine[Catalina]]] to [STARTED]
28-May-2020 06:08:45.281 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina].StandardHost[localhost]] to [INITIALIZING]
28-May-2020 06:08:45.281 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina].StandardHost[localhost]] to [INITIALIZED]
28-May-2020 06:08:45.281 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina].StandardHost[localhost]] to [STARTING_PREP]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZING]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZED]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING_PREP]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[AccessLogValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZING]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[AccessLogValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZED]
28-May-2020 06:08:45.284 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[AccessLogValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING_PREP]
28-May-2020 06:08:45.285 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[AccessLogValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING]
28-May-2020 06:08:45.285 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[AccessLogValve[StandardEngine[Catalina].StandardHost[localhost]]] to [STARTED]
28-May-2020 06:08:45.285 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[ErrorReportValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZING]
28-May-2020 06:08:45.285 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[ErrorReportValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZED]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[ErrorReportValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING_PREP]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[ErrorReportValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[ErrorReportValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTED]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardHostValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZING]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardHostValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[INITIALIZED]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardHostValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING_PREP]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardHostValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardHostValve[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTED]
28-May-2020 06:08:45.286 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTING]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina].StandardHost[localhost]]] to
[STARTED]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina].StandardHost[localhost]] to [STARTING]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina].StandardHost[localhost]] to [STARTED]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina]]] to [INITIALIZING]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina]]] to [INITIALIZED]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina]]] to [STARTING_PREP]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngineValve[StandardEngine[Catalina]]] to [INITIALIZING]
28-May-2020 06:08:45.287 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngineValve[StandardEngine[Catalina]]] to [INITIALIZED]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngineValve[StandardEngine[Catalina]]] to [STARTING_PREP]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngineValve[StandardEngine[Catalina]]] to [STARTING]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngineValve[StandardEngine[Catalina]]] to [STARTED]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina]]] to [STARTING]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardPipeline[StandardEngine[Catalina]]] to [STARTED]
28-May-2020 06:08:45.288 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina]] to [STARTING]
28-May-2020 06:08:45.290 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardEngine[Catalina]] to [STARTED]
28-May-2020 06:08:45.290 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.mapper.MapperListener@6fc6f14e] to [STARTING_PREP]
28-May-2020 06:08:45.290 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.mapper.MapperListener@6fc6f14e] to [STARTING]
28-May-2020 06:08:45.291 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[org.apache.catalina.mapper.MapperListener@6fc6f14e] to [STARTED]
28-May-2020 06:08:45.291 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[Connector[HTTP/1.1-8080]] to [STARTING_PREP]
28-May-2020 06:08:45.291 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[Connector[HTTP/1.1-8080]] to [STARTING]
28-May-2020 06:08:45.291 INFO [main] org.apache.coyote.AbstractProtocol.start
Starting ProtocolHandler ["http-nio-8080"]
28-May-2020 06:08:45.309 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[Connector[HTTP/1.1-8080]] to [STARTED]
28-May-2020 06:08:45.309 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardService[Catalina]] to [STARTED]
28-May-2020 06:08:45.309 FINE [main]
org.apache.catalina.util.LifecycleBase.setStateInternal Setting state for
[StandardServer[8005]] to [STARTED]
28-May-2020 06:08:45.310 INFO [main] org.apache.catalina.startup.Catalina.start
Server startup in [51] milliseconds
28-May-2020 06:08:46.094 INFO [http-nio-8080-exec-1]
org.apache.coyote.http11.Http11Processor.service Error parsing HTTP request
header
Note: further occurrences of HTTP request parsing errors will be logged at
DEBUG level.
java.lang.IllegalStateException: Invalid request line parse phase [6]
at
org.apache.coyote.http11.Http11InputBuffer.parseRequestLine(Http11InputBuffer.java:579)
at
org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:260)
at
org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
at
org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
at
org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
at
org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at
org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:748)
--
You are receiving this mail because:
You are the assignee for the bug.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@tomcat.apache.org
For additional commands, e-mail: dev-h...@tomcat.apache.org
