Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
Running org.eclipse.jetty.proxy.AsyncMiddleManServletTest.testAfterContentTransformerOverflowingToDisk()
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: Server@276eafad{STOPPED}[9.4.21-SNAPSHOT] added {QueuedThreadPool[server]@76d220eb{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY],AUTO}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: HttpConnectionFactory@29dcad7e[HTTP/1.1] added {HttpConfiguration@5ce1ec7{32768/8192,8192/8192,https://:0,[]},POJO}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{null,[]}{0.0.0.0:0} added {Server@276eafad{STOPPED}[9.4.21-SNAPSHOT],UNMANAGED}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{null,[]}{0.0.0.0:0} added {QueuedThreadPool[server]@76d220eb{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY],AUTO}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{null,[]}{0.0.0.0:0} added {ScheduledExecutorScheduler@30bd6bc8{STOPPED},AUTO}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.io.ArrayByteBufferPool@7c4697fc,POJO}
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{null,[http/1.1]}{0.0.0.0:0} added {HttpConnectionFactory@29dcad7e[HTTP/1.1],AUTO}
2019-09-08 21:30:12.044:DBUG:oejs.AbstractConnector:main: ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added HttpConnectionFactory@29dcad7e[HTTP/1.1]
2019-09-08 21:30:12.044:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added {SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0},MANAGED}
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: Server@276eafad{STOPPED}[9.4.21-SNAPSHOT] added {ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0},AUTO}
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: Server@276eafad{STOPPED}[9.4.21-SNAPSHOT] added {o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE},MANAGED}
2019-09-08 21:30:12.045:DBUG:oeju.DecoratedObjectFactory:main: Adding Decorator: org.eclipse.jetty.util.DeprecationWarning@e6fbf82
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE} added {org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1,MANAGED}
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1 added {ServletHandler@1de6f29d{STOPPED},MANAGED}
2019-09-08 21:30:12.045:DBUG:oejuc.AbstractLifeCycle:main: starting Server@276eafad{STOPPED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: Server@276eafad{STARTING}[9.4.21-SNAPSHOT] added {ErrorHandler@3b6c55b6{STOPPED},AUTO}
2019-09-08 21:30:12.045:INFO:oejs.Server:main: jetty-9.4.21-SNAPSHOT; built: 2019-09-08T21:19:37.149Z; git: 8e811b9dcfcf481246fab094e2b83e16bf52ceab; jvm 12.0.2+10
2019-09-08 21:30:12.045:DBUG:oejsh.AbstractHandler:main: starting Server@276eafad{STARTING}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.045:DBUG:oejuc.AbstractLifeCycle:main: starting QueuedThreadPool[server]@76d220eb{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY]
2019-09-08 21:30:12.045:DBUG:oejut.ReservedThreadExecutor:main: ReservedThreadExecutor@55e02661{s=0/1,p=0}
2019-09-08 21:30:12.045:DBUG:oejuc.ContainerLifeCycle:main: QueuedThreadPool[server]@76d220eb{STARTING,8<=0<=200,i=0,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}] added {ReservedThreadExecutor@55e02661{s=0/1,p=0},AUTO}
2019-09-08 21:30:12.045:DBUG:oejuc.AbstractLifeCycle:main: starting ReservedThreadExecutor@55e02661{s=0/1,p=0}
2019-09-08 21:30:12.045:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57326ms ReservedThreadExecutor@55e02661{s=0/1,p=0}
2019-09-08 21:30:12.045:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1351,5,main]
2019-09-08 21:30:12.045:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1352,5,main]
2019-09-08 21:30:12.045:DBUG:oejut.QueuedThreadPool:server-1351: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=2<=200,i=0,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.045:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1353,5,main]
2019-09-08 21:30:12.045:DBUG:oejut.QueuedThreadPool:server-1352: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=3<=200,i=1,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1354,5,main]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:server-1353: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=4<=200,i=2,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1355,5,main]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:server-1354: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=5<=200,i=3,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1356,5,main]
2019-09-08 21:30:12.046:DBUG:oejut.QueuedThreadPool:server-1355: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=6<=200,i=4,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.050:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1357,5,main]
2019-09-08 21:30:12.050:DBUG:oejut.QueuedThreadPool:server-1356: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=7<=200,i=5,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.054:DBUG:oejut.QueuedThreadPool:main: Starting Thread[server-1358,5,main]
2019-09-08 21:30:12.054:DBUG:oejut.QueuedThreadPool:server-1357: Runner started for QueuedThreadPool[server]@76d220eb{STARTING,8<=8<=200,i=6,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.058:DBUG:oejut.QueuedThreadPool:server-1358: Runner started for QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.058:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57339ms QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.058:DBUG:oejuc.AbstractLifeCycle:main: starting o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE}
2019-09-08 21:30:12.058:DBUG:oejsh.AbstractHandler:main: starting o.e.j.s.ServletContextHandler@90b9695{/,null,STARTING}
2019-09-08 21:30:12.058:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:12.058:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1 added {org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false],AUTO}
2019-09-08 21:30:12.058:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false] added {org.eclipse.jetty.server.session.NullSessionDataStore@4d4337f9[passivating=false,graceSec=3600],AUTO}
2019-09-08 21:30:12.058:DBUG:oejuc.AbstractLifeCycle:main: starting DefaultSessionIdManager@1e6f7c25{STOPPED}[worker=null]
2019-09-08 21:30:12.059:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0
2019-09-08 21:30:12.059:INFO:oejs.session:main: No SessionScavenger set, using defaults
2019-09-08 21:30:12.059:DBUG:oejuc.ContainerLifeCycle:main: DefaultSessionIdManager@1e6f7c25{STARTING}[worker=node0] added {HouseKeeper@1a7f2d34{STOPPED}[interval=600000, ownscheduler=false],MANAGED}
2019-09-08 21:30:12.059:DBUG:oejuc.AbstractLifeCycle:main: starting HouseKeeper@1a7f2d34{STOPPED}[interval=600000, ownscheduler=false]
2019-09-08 21:30:12.059:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@23243bc0{STOPPED}
2019-09-08 21:30:12.059:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57340ms ScheduledExecutorScheduler@23243bc0{STARTED}
2019-09-08 21:30:12.059:DBUG:oejs.session:main: Using own scheduler for scavenging
2019-09-08 21:30:12.059:INFO:oejs.session:main: node0 Scavenging every 600000ms
2019-09-08 21:30:12.062:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57343ms HouseKeeper@1a7f2d34{STARTED}[interval=600000, ownscheduler=true]
2019-09-08 21:30:12.062:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57343ms DefaultSessionIdManager@1e6f7c25{STARTED}[worker=node0]
2019-09-08 21:30:12.062:DBUG:oejuc.ContainerLifeCycle:main: Server@276eafad{STARTING}[9.4.21-SNAPSHOT] added {DefaultSessionIdManager@1e6f7c25{STARTED}[worker=node0],MANAGED}
2019-09-08 21:30:12.062:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1 added {DefaultSessionIdManager@1e6f7c25{STARTED}[worker=node0],UNMANAGED}
2019-09-08 21:30:12.062:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@1267f832{STOPPED}
2019-09-08 21:30:12.062:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57344ms ScheduledExecutorScheduler@1267f832{STARTED}
2019-09-08 21:30:12.062:DBUG:oejsh.AbstractHandler:main: starting org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:12.062:DBUG:oejuc.AbstractLifeCycle:main: starting ServletHandler@1de6f29d{STOPPED}
2019-09-08 21:30:12.062:DBUG:oejs.ServletHandler:main: Path=/*[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a[EMBEDDED:null]
2019-09-08 21:30:12.062:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/*",pathDepth=1,group=PREFIX_GLOB],resource=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true] to PathMappings[size=1]
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: filterNameMap={}
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: pathFilters=null
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletFilterMap=null
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletPathMap=PathMappings[size=1]
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletNameMap={org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true}
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: Adding Default404Servlet to ServletHandler@1de6f29d{STARTING}
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: Path=/*[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a[EMBEDDED:null]
2019-09-08 21:30:12.063:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/*",pathDepth=1,group=PREFIX_GLOB],resource=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true] to PathMappings[size=1]
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: Path=/[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7[EMBEDDED:null]
2019-09-08 21:30:12.063:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/",pathDepth=-1,group=DEFAULT],resource=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true] to PathMappings[size=2]
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: filterNameMap={}
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: pathFilters=null
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletFilterMap=null
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletPathMap=PathMappings[size=2]
2019-09-08 21:30:12.063:DBUG:oejs.ServletHandler:main: servletNameMap={org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true, org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true}
2019-09-08 21:30:12.063:DBUG:oejsh.AbstractHandler:main: starting ServletHandler@1de6f29d{STARTING}
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57344ms ServletHandler@1de6f29d{STARTED}
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.NullSessionDataStore@4d4337f9[passivating=false,graceSec=3600]
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms org.eclipse.jetty.server.session.NullSessionDataStore@4d4337f9[passivating=false,graceSec=3600]
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:12.063:DBUG:oejs.ServletHolder:main: Servlet.init org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32@73eaae1e for org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:12.063:INFO:oejsh.ContextHandler:main: Started o.e.j.s.ServletContextHandler@90b9695{/,null,AVAILABLE}
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms o.e.j.s.ServletContextHandler@90b9695{/,null,AVAILABLE}
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: starting ErrorHandler@3b6c55b6{STOPPED}
2019-09-08 21:30:12.063:DBUG:oejsh.AbstractHandler:main: starting ErrorHandler@3b6c55b6{STARTING}
2019-09-08 21:30:12.063:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms ErrorHandler@3b6c55b6{STARTED}
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:12.064:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641} added {sun.nio.ch.ServerSocketChannelImpl[/0.0.0.0:36641],POJO}
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@30bd6bc8{STOPPED}
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms ScheduledExecutorScheduler@30bd6bc8{STARTED}
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting HttpConnectionFactory@29dcad7e[HTTP/1.1]
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57345ms HttpConnectionFactory@29dcad7e[HTTP/1.1]
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641}
2019-09-08 21:30:12.064:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064454Z added {SelectorProducer@481eb705,POJO}
2019-09-08 21:30:12.064:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064577Z added {QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}],UNMANAGED}
2019-09-08 21:30:12.064:DBUG:oejuts.EatWhatYouKill:main: EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064671Z created
2019-09-08 21:30:12.064:DBUG:oejuc.ContainerLifeCycle:main: ManagedSelector@2ae0eb98{STOPPED} id=0 keys=-1 selected=-1 updates=0 added {EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064755Z,MANAGED}
2019-09-08 21:30:12.064:DBUG:oejuc.ContainerLifeCycle:main: SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641} added {ManagedSelector@2ae0eb98{STOPPED} id=0 keys=-1 selected=-1 updates=0,AUTO}
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting ManagedSelector@2ae0eb98{STOPPED} id=0 keys=-1 selected=-1 updates=0
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: starting EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064876Z
2019-09-08 21:30:12.064:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57346ms EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.064927Z
2019-09-08 21:30:12.065:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@c5c2a84 startThread=false
2019-09-08 21:30:12.065:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$Start@42a89cef on ManagedSelector@2ae0eb98{STARTING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.065:DBUG:oejut.QueuedThreadPool:server-1351: run org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@c5c2a84 in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.065:DBUG:oejuts.EatWhatYouKill:server-1351: EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.065204Z tryProduce false
2019-09-08 21:30:12.065:DBUG:oeji.ManagedSelector:server-1351: updateable 1
2019-09-08 21:30:12.065:DBUG:oeji.ManagedSelector:server-1351: update org.eclipse.jetty.io.ManagedSelector$Start@42a89cef
2019-09-08 21:30:12.065:DBUG:oeji.ManagedSelector:server-1351: updates 0
2019-09-08 21:30:12.065:DBUG:oeji.ManagedSelector:server-1351: Selector sun.nio.ch.EPollSelectorImpl@71af297a waiting with 0 keys
2019-09-08 21:30:12.065:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57346ms ManagedSelector@2ae0eb98{STARTED} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.065:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57346ms SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641}
2019-09-08 21:30:12.065:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641} added {acceptor-0@7f33ad20,POJO}
2019-09-08 21:30:12.065:DBUG:oejut.QueuedThreadPool:main: queue acceptor-0@7f33ad20 startThread=false
2019-09-08 21:30:12.065:DBUG:oejut.QueuedThreadPool:server-1352: run acceptor-0@7f33ad20 in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@55e02661{s=0/1,p=0}]
2019-09-08 21:30:12.065:INFO:oejs.AbstractConnector:main: Started ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641}
2019-09-08 21:30:12.065:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57346ms ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641}
2019-09-08 21:30:12.065:INFO:oejs.Server:main: Started @57346ms
2019-09-08 21:30:12.065:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57346ms Server@276eafad{STARTED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT] added {QueuedThreadPool[proxy]@464017f5{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY],AUTO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: HttpConnectionFactory@397f9672[HTTP/1.1] added {HttpConfiguration@72e4ffa2{32768/8192,8192/8192,https://:0,[]},POJO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{null,[]}{0.0.0.0:0} added {Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT],UNMANAGED}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{null,[]}{0.0.0.0:0} added {QueuedThreadPool[proxy]@464017f5{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY],AUTO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{null,[]}{0.0.0.0:0} added {ScheduledExecutorScheduler@193d73d3{STOPPED},AUTO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.io.ArrayByteBufferPool@5cb4ba80,POJO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{null,[http/1.1]}{0.0.0.0:0} added {HttpConnectionFactory@397f9672[HTTP/1.1],AUTO}
2019-09-08 21:30:12.067:DBUG:oejs.AbstractConnector:main: ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added HttpConnectionFactory@397f9672[HTTP/1.1]
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added {SelectorManager@ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:0},MANAGED}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT] added {ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:0},AUTO}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT] added {o.e.j.s.ServletContextHandler@978475b{/,null,UNAVAILABLE},MANAGED}
2019-09-08 21:30:12.067:DBUG:oeju.DecoratedObjectFactory:main: Adding Decorator: org.eclipse.jetty.util.DeprecationWarning@507187c1
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: o.e.j.s.ServletContextHandler@978475b{/,null,UNAVAILABLE} added {org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1,MANAGED}
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1 added {ServletHandler@5bb90b89{STOPPED},MANAGED}
2019-09-08 21:30:12.067:DBUG:oejuc.AbstractLifeCycle:main: starting Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.067:DBUG:oejuc.ContainerLifeCycle:main: Server@3c4231e5{STARTING}[9.4.21-SNAPSHOT] added {ErrorHandler@4c231f62{STOPPED},AUTO}
2019-09-08 21:30:12.067:INFO:oejs.Server:main: jetty-9.4.21-SNAPSHOT; built: 2019-09-08T21:19:37.149Z; git: 8e811b9dcfcf481246fab094e2b83e16bf52ceab; jvm 12.0.2+10
2019-09-08 21:30:12.068:DBUG:oejsh.AbstractHandler:main: starting Server@3c4231e5{STARTING}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.068:DBUG:oejuc.AbstractLifeCycle:main: starting QueuedThreadPool[proxy]@464017f5{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY]
2019-09-08 21:30:12.068:DBUG:oejut.ReservedThreadExecutor:main: ReservedThreadExecutor@6888746c{s=0/1,p=0}
2019-09-08 21:30:12.068:DBUG:oejuc.ContainerLifeCycle:main: QueuedThreadPool[proxy]@464017f5{STARTING,8<=0<=200,i=0,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}] added {ReservedThreadExecutor@6888746c{s=0/1,p=0},AUTO}
2019-09-08 21:30:12.068:DBUG:oejuc.AbstractLifeCycle:main: starting ReservedThreadExecutor@6888746c{s=0/1,p=0}
2019-09-08 21:30:12.068:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57349ms ReservedThreadExecutor@6888746c{s=0/1,p=0}
2019-09-08 21:30:12.068:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1360,5,main]
2019-09-08 21:30:12.070:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1361,5,main]
2019-09-08 21:30:12.070:DBUG:oejut.QueuedThreadPool:proxy-1360: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=2<=200,i=0,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1362,5,main]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:proxy-1361: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=3<=200,i=1,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1363,5,main]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:proxy-1362: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=4<=200,i=2,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1364,5,main]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:proxy-1363: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=5<=200,i=3,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1365,5,main]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:proxy-1364: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=6<=200,i=4,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.074:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1366,5,main]
2019-09-08 21:30:12.075:DBUG:oejut.QueuedThreadPool:proxy-1365: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=7<=200,i=5,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.075:DBUG:oejut.QueuedThreadPool:main: Starting Thread[proxy-1367,5,main]
2019-09-08 21:30:12.075:DBUG:oejut.QueuedThreadPool:proxy-1366: Runner started for QueuedThreadPool[proxy]@464017f5{STARTING,8<=8<=200,i=6,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.075:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57356ms QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.075:DBUG:oejut.QueuedThreadPool:proxy-1367: Runner started for QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.075:DBUG:oejuc.AbstractLifeCycle:main: starting o.e.j.s.ServletContextHandler@978475b{/,null,UNAVAILABLE}
2019-09-08 21:30:12.075:DBUG:oejsh.AbstractHandler:main: starting o.e.j.s.ServletContextHandler@978475b{/,null,STARTING}
2019-09-08 21:30:12.075:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1
2019-09-08 21:30:12.075:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1 added {org.eclipse.jetty.server.session.DefaultSessionCache@539f2fec[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false],AUTO}
2019-09-08 21:30:12.075:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.DefaultSessionCache@539f2fec[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false] added {org.eclipse.jetty.server.session.NullSessionDataStore@a4e1ca7[passivating=false,graceSec=3600],AUTO}
2019-09-08 21:30:12.075:DBUG:oejuc.AbstractLifeCycle:main: starting DefaultSessionIdManager@7d466ef9{STOPPED}[worker=null]
2019-09-08 21:30:12.075:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0
2019-09-08 21:30:12.075:INFO:oejs.session:main: No SessionScavenger set, using defaults
2019-09-08 21:30:12.075:DBUG:oejuc.ContainerLifeCycle:main: DefaultSessionIdManager@7d466ef9{STARTING}[worker=node0] added {HouseKeeper@4a561f7d{STOPPED}[interval=600000, ownscheduler=false],MANAGED}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting HouseKeeper@4a561f7d{STOPPED}[interval=600000, ownscheduler=false]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@601ca994{STOPPED}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57357ms ScheduledExecutorScheduler@601ca994{STARTED}
2019-09-08 21:30:12.076:DBUG:oejs.session:main: Using own scheduler for scavenging
2019-09-08 21:30:12.076:INFO:oejs.session:main: node0 Scavenging every 660000ms
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57357ms HouseKeeper@4a561f7d{STARTED}[interval=660000, ownscheduler=true]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57357ms DefaultSessionIdManager@7d466ef9{STARTED}[worker=node0]
2019-09-08 21:30:12.076:DBUG:oejuc.ContainerLifeCycle:main: Server@3c4231e5{STARTING}[9.4.21-SNAPSHOT] added {DefaultSessionIdManager@7d466ef9{STARTED}[worker=node0],MANAGED}
2019-09-08 21:30:12.076:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1 added {DefaultSessionIdManager@7d466ef9{STARTED}[worker=node0],UNMANAGED}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@5432be12{STOPPED}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57357ms ScheduledExecutorScheduler@5432be12{STARTED}
2019-09-08 21:30:12.076:DBUG:oejsh.AbstractHandler:main: starting org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting ServletHandler@5bb90b89{STOPPED}
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: Path=/*[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a[EMBEDDED:null]
2019-09-08 21:30:12.076:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/*",pathDepth=1,group=PREFIX_GLOB],resource=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true] to PathMappings[size=1]
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: filterNameMap={}
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: pathFilters=null
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletFilterMap=null
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletPathMap=PathMappings[size=1]
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletNameMap={org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true}
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: Adding Default404Servlet to ServletHandler@5bb90b89{STARTING}
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: Path=/*[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a[EMBEDDED:null]
2019-09-08 21:30:12.076:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/*",pathDepth=1,group=PREFIX_GLOB],resource=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true] to PathMappings[size=1]
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: Path=/[EMBEDDED:null] mapped to servlet=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e[EMBEDDED:null]
2019-09-08 21:30:12.076:DBUG:oejhp.PathMappings:main: Added MappedResource[pathSpec=ServletPathSpec["/",pathDepth=-1,group=DEFAULT],resource=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e@356d218a==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true] to PathMappings[size=2]
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: filterNameMap={}
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: pathFilters=null
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletFilterMap=null
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletPathMap=PathMappings[size=2]
2019-09-08 21:30:12.076:DBUG:oejs.ServletHandler:main: servletNameMap={org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e=org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e@356d218a==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true, org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a=org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true}
2019-09-08 21:30:12.076:DBUG:oejsh.AbstractHandler:main: starting ServletHandler@5bb90b89{STARTING}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57358ms ServletHandler@5bb90b89{STARTED}
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.DefaultSessionCache@539f2fec[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.session.NullSessionDataStore@a4e1ca7[passivating=false,graceSec=3600]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57358ms org.eclipse.jetty.server.session.NullSessionDataStore@a4e1ca7[passivating=false,graceSec=3600]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57358ms org.eclipse.jetty.server.session.DefaultSessionCache@539f2fec[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57358ms org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:12.076:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57358ms org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:12.077:DBUG:oejs.ServletHolder:main: Servlet.init org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33@2b30b25f for org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STOPPED} added {HttpClientTransportOverHTTP@195d4780{STOPPED},AUTO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STOPPED} added {org.eclipse.jetty.client.ProtocolHandlers@18c95fbb,POJO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STOPPED} added {org.eclipse.jetty.client.HttpClient$ContentDecoderFactorySet@36c5a4b7,POJO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STOPPED} added {QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}],UNMANAGED}
2019-09-08 21:30:12.077:DBUG:oejuc.AbstractLifeCycle:main: starting HttpClient@58dea0a7{STOPPED}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STARTING} added {org.eclipse.jetty.io.MappedByteBufferPool@1bb3e150,POJO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STARTING} added {ScheduledExecutorScheduler@6821d4e1{STOPPED},AUTO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@58dea0a7{STARTING} added {org.eclipse.jetty.util.SocketAddressResolver$Async@3ac76ad9,POJO}
2019-09-08 21:30:12.077:DBUG:oejuc.AbstractLifeCycle:main: starting HttpClientTransportOverHTTP@195d4780{STOPPED}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: HttpClientTransportOverHTTP@195d4780{STARTING} added {ClientSelectorManager@213c812a{STOPPED},AUTO}
2019-09-08 21:30:12.077:DBUG:oejuc.AbstractLifeCycle:main: starting ClientSelectorManager@213c812a{STOPPED}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.077896Z added {SelectorProducer@436103b1,POJO}
2019-09-08 21:30:12.077:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.077965Z added {QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}],UNMANAGED}
2019-09-08 21:30:12.077:DBUG:oejuts.EatWhatYouKill:main: EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.078016Z created
2019-09-08 21:30:12.078:DBUG:oejuc.ContainerLifeCycle:main: ManagedSelector@427128a6{STOPPED} id=0 keys=-1 selected=-1 updates=0 added {EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.078065Z,MANAGED}
2019-09-08 21:30:12.078:DBUG:oejuc.ContainerLifeCycle:main: ClientSelectorManager@213c812a{STARTING} added {ManagedSelector@427128a6{STOPPED} id=0 keys=-1 selected=-1 updates=0,AUTO}
2019-09-08 21:30:12.078:DBUG:oejuc.AbstractLifeCycle:main: starting ManagedSelector@427128a6{STOPPED} id=0 keys=-1 selected=-1 updates=0
2019-09-08 21:30:12.078:DBUG:oejuc.AbstractLifeCycle:main: starting EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.078138Z
2019-09-08 21:30:12.078:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57359ms EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=8,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.078175Z
2019-09-08 21:30:12.078:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@701c413 startThread=false
2019-09-08 21:30:12.078:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$Start@28468162 on ManagedSelector@427128a6{STARTING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.078:DBUG:oejut.QueuedThreadPool:proxy-1360: run org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@701c413 in QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.078:DBUG:oejuts.EatWhatYouKill:proxy-1360: EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.078421Z tryProduce false
2019-09-08 21:30:12.078:DBUG:oeji.ManagedSelector:proxy-1360: updateable 1
2019-09-08 21:30:12.078:DBUG:oeji.ManagedSelector:proxy-1360: update org.eclipse.jetty.io.ManagedSelector$Start@28468162
2019-09-08 21:30:12.078:DBUG:oeji.ManagedSelector:proxy-1360: updates 0
2019-09-08 21:30:12.078:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms ManagedSelector@427128a6{STARTED} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.078:DBUG:oeji.ManagedSelector:proxy-1360: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb waiting with 0 keys
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms ClientSelectorManager@213c812a{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms HttpClientTransportOverHTTP@195d4780{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@6821d4e1{STOPPED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms ScheduledExecutorScheduler@6821d4e1{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms HttpClient@58dea0a7{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e@356d218a==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-2ee5fe1e@356d218a==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:12.079:INFO:oejsh.ContextHandler:main: Started o.e.j.s.ServletContextHandler@978475b{/,null,AVAILABLE}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57360ms o.e.j.s.ServletContextHandler@978475b{/,null,AVAILABLE}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting ErrorHandler@4c231f62{STOPPED}
2019-09-08 21:30:12.079:DBUG:oejsh.AbstractHandler:main: starting ErrorHandler@4c231f62{STARTING}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms ErrorHandler@4c231f62{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:12.079:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843} added {sun.nio.ch.ServerSocketChannelImpl[/0.0.0.0:32843],POJO}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting ScheduledExecutorScheduler@193d73d3{STOPPED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms ScheduledExecutorScheduler@193d73d3{STARTED}
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting HttpConnectionFactory@397f9672[HTTP/1.1]
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms HttpConnectionFactory@397f9672[HTTP/1.1]
2019-09-08 21:30:12.079:DBUG:oejuc.AbstractLifeCycle:main: starting SelectorManager@ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843}
2019-09-08 21:30:12.079:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.079933Z added {SelectorProducer@280e4390,POJO}
2019-09-08 21:30:12.079:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.079987Z added {QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}],UNMANAGED}
2019-09-08 21:30:12.080:DBUG:oejuts.EatWhatYouKill:main: EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080038Z created
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: ManagedSelector@21262bde{STOPPED} id=0 keys=-1 selected=-1 updates=0 added {EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080082Z,MANAGED}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: SelectorManager@ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843} added {ManagedSelector@21262bde{STOPPED} id=0 keys=-1 selected=-1 updates=0,AUTO}
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: starting ManagedSelector@21262bde{STOPPED} id=0 keys=-1 selected=-1 updates=0
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: starting EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080162Z
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080196Z
2019-09-08 21:30:12.080:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@3df7e309 startThread=false
2019-09-08 21:30:12.080:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$Start@55f4ec04 on ManagedSelector@21262bde{STARTING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.080:DBUG:oejut.QueuedThreadPool:proxy-1361: run org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@3df7e309 in QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.080:DBUG:oejuts.EatWhatYouKill:proxy-1361: EatWhatYouKill@63f16350/SelectorProducer@280e4390/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080382Z tryProduce false
2019-09-08 21:30:12.080:DBUG:oeji.ManagedSelector:proxy-1361: updateable 1
2019-09-08 21:30:12.080:DBUG:oeji.ManagedSelector:proxy-1361: update org.eclipse.jetty.io.ManagedSelector$Start@55f4ec04
2019-09-08 21:30:12.080:DBUG:oeji.ManagedSelector:proxy-1361: updates 0
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms ManagedSelector@21262bde{STARTED} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:12.080:DBUG:oeji.ManagedSelector:proxy-1361: Selector sun.nio.ch.EPollSelectorImpl@1ce00744 waiting with 0 keys
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57361ms SelectorManager@ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843} added {acceptor-0@f3c27e9,POJO}
2019-09-08 21:30:12.080:DBUG:oejut.QueuedThreadPool:main: queue acceptor-0@f3c27e9 startThread=false
2019-09-08 21:30:12.080:INFO:oejs.AbstractConnector:main: Started ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843}
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57362ms ServerConnector@34dda1b4{HTTP/1.1,[http/1.1]}{0.0.0.0:32843}
2019-09-08 21:30:12.080:DBUG:oejut.QueuedThreadPool:proxy-1362: run acceptor-0@f3c27e9 in QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=5,r=1,q=0}[ReservedThreadExecutor@6888746c{s=0/1,p=0}]
2019-09-08 21:30:12.080:INFO:oejs.Server:main: Started @57362ms
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: STARTED @57362ms Server@3c4231e5{STARTED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STOPPED} added {HttpClientTransportOverHTTP@6f5f892c{STOPPED},AUTO}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STOPPED} added {org.eclipse.jetty.client.ProtocolHandlers@1b2e841,POJO}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STOPPED} added {org.eclipse.jetty.client.HttpClient$ContentDecoderFactorySet@3a75d9a1,POJO}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STOPPED} added {QueuedThreadPool[client]@1fd4850b{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY],AUTO}
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: starting HttpClient@1db9d253{STOPPED}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STARTING} added {org.eclipse.jetty.io.MappedByteBufferPool@698daff6,POJO}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STARTING} added {ScheduledExecutorScheduler@7a085d02{STOPPED},AUTO}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClient@1db9d253{STARTING} added {org.eclipse.jetty.util.SocketAddressResolver$Async@6cee52e2,POJO}
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: starting HttpClientTransportOverHTTP@6f5f892c{STOPPED}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: HttpClientTransportOverHTTP@6f5f892c{STARTING} added {ClientSelectorManager@7842260f{STOPPED},AUTO}
2019-09-08 21:30:12.080:DBUG:oejuc.AbstractLifeCycle:main: starting ClientSelectorManager@7842260f{STOPPED}
2019-09-08 21:30:12.080:DBUG:oejuc.ContainerLifeCycle:main: EatWhatYouKill@7cb4d4ee/SelectorProducer@44ec6637/IDLE/p=false/QueuedThreadPool[client]@1fd4850b{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY][pc=0,pic=0,pec=0,epc=0]@2019-09-08T21:30:12.080936
...[truncated 186156 chars]...
21d4e1{STARTED}
2019-09-08 21:30:17.097:DBUG:oejs.HttpConnection:server-1351: HttpConnection@b330579::SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,ISHUT,fill=-,flush=-,to=4993/30000}{io=0/0,kio=0,kro=1}->HttpConnection@b330579[p=HttpParser{s=START,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0} parse HeapByteBuffer@6fc1576e[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 ...\x00\x00\x00\x00\x00\x00\x00} {}
2019-09-08 21:30:17.097:DBUG:oejh.HttpParser:server-1351: parseNext s=START HeapByteBuffer@6fc1576e[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 ...\x00\x00\x00\x00\x00\x00\x00}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ScheduledExecutorScheduler@6821d4e1{STOPPED}
2019-09-08 21:30:17.097:DBUG:oejh.HttpParser:server-1351: START --> CLOSED
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: stopping HttpClientTransportOverHTTP@195d4780{STARTED}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: stopping ClientSelectorManager@213c812a{STARTED}
2019-09-08 21:30:17.097:DBUG:oeji.AbstractEndPoint:server-1351: close SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,ISHUT,fill=-,flush=-,to=4994/30000}{io=0/0,kio=0,kro=1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: stopping ManagedSelector@427128a6{STARTED} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@38eafdab on ManagedSelector@427128a6{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:17.097:DBUG:oeji.AbstractEndPoint:server-1351: close(null) SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,ISHUT,fill=-,flush=-,to=4994/30000}{io=0/0,kio=0,kro=1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:main: Wakeup on submit ManagedSelector@427128a6{STOPPING} id=0 keys=0 selected=0 updates=1
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb woken with none selected
2019-09-08 21:30:17.097:DBUG:oeji.ChannelEndPoint:server-1351: doClose SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=0,kro=1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb woken up from select, 0/0/0 selected
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb processing 0 keys, 1 updates
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: updateable 1
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: update org.eclipse.jetty.io.ManagedSelector$CloseConnections@38eafdab
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Closing 0 connections on ManagedSelector@427128a6{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: updates 0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@373c8f35 on ManagedSelector@427128a6{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb waiting with 0 keys
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:main: Wakeup on submit ManagedSelector@427128a6{STOPPING} id=0 keys=0 selected=0 updates=1
2019-09-08 21:30:17.097:DBUG:oeji.WriteFlusher:server-1351: ignored: WriteFlusher@3d24ddbd{IDLE}->null
java.nio.channels.ClosedChannelException
at org.eclipse.jetty.io.WriteFlusher.onClose(WriteFlusher.java:521)
at org.eclipse.jetty.io.AbstractEndPoint.onClose(AbstractEndPoint.java:354)
at org.eclipse.jetty.io.ChannelEndPoint.onClose(ChannelEndPoint.java:214)
at org.eclipse.jetty.io.AbstractEndPoint.doOnClose(AbstractEndPoint.java:225)
at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:192)
at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:175)
at org.eclipse.jetty.io.AbstractConnection.close(AbstractConnection.java:254)
at org.eclipse.jetty.server.HttpChannelOverHttp.earlyEOF(HttpChannelOverHttp.java:233)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:1526)
at org.eclipse.jetty.server.HttpConnection.parseRequestBuffer(HttpConnection.java:359)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:783)
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:919)
at java.base/java.lang.Thread.run(Thread.java:835)
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb woken with none selected
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb woken up from select, 0/0/0 selected
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: Selector sun.nio.ch.EPollSelectorImpl@6d2277bb processing 0 keys, 1 updates
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: updateable 1
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: update org.eclipse.jetty.io.ManagedSelector$StopSelector@373c8f35
2019-09-08 21:30:17.097:DBUG:oeji.FillInterest:server-1351: onClose FillInterest@73f934cd{null}
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1351: Wakeup ManagedSelector@2ae0eb98{STARTED} id=0 keys=1 selected=0 updates=0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:proxy-1364: updates 0
2019-09-08 21:30:17.097:DBUG:oejut.QueuedThreadPool:server-1351: queue org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@3639d94d startThread=false
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken with none selected
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: stopping EatWhatYouKill@25814d3c/SelectorProducer@436103b1/PRODUCING/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=5,r=1,q=0}[ReservedThreadExecutor@6888746c{s=1/1,p=0}][pc=0,pic=0,pec=0,epc=1]@2019-09-08T21:30:17.097641Z
2019-09-08 21:30:17.097:DBUG:oejut.ReservedThreadExecutor:proxy-1364: ReservedThreadExecutor@6888746c{s=1/1,p=0}@16186c34 size 1 > capacity 1
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken up from select, 0/0/0 selected
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a processing 0 keys, 0 updates
2019-09-08 21:30:17.097:DBUG:oejs.HttpConnection:server-1351: HttpConnection@b330579::SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0} parsed false HttpParser{s=CLOSED,0 of -1}
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: updateable 0
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: updates 0
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED EatWhatYouKill@25814d3c/SelectorProducer@436103b1/IDLE/p=false/QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=5,r=1,q=0}[ReservedThreadExecutor@6888746c{s=1/1,p=0}][pc=0,pic=0,pec=0,epc=1]@2019-09-08T21:30:17.097707Z
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a waiting with 0 keys
2019-09-08 21:30:17.097:DBUG:oejut.QueuedThreadPool:server-1357: run org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@3639d94d in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=3,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:17.097:DBUG:oejut.QueuedThreadPool:proxy-1364: ran ReservedThreadExecutor@6888746c{s=1/1,p=0}@16186c34 in QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=5,r=1,q=0}[ReservedThreadExecutor@6888746c{s=1/1,p=0}]
2019-09-08 21:30:17.097:DBUG:oejs.HttpConnection:server-1351: releaseRequestBuffer HttpConnection@b330579::SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ManagedSelector@427128a6{STOPPED} id=0 keys=-1 selected=-1 updates=0
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ClientSelectorManager@213c812a{STOPPED}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED HttpClientTransportOverHTTP@195d4780{STOPPED}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED HttpClient@58dea0a7{STOPPED}
2019-09-08 21:30:17.097:DBUG:oeji.AbstractEndPoint:server-1351: shutdownOutput SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33-10b0dd3a@800cab51==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$33,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:17.097:DBUG:oeji.ManagedSelector:server-1357: Destroyed SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ServletHandler@5bb90b89{STOPPED}
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.server.session.SessionHandler572573175==dftMaxIdleSec=-1
2019-09-08 21:30:17.097:DBUG:oejs.HttpConnection:server-1351: HttpConnection@b330579::SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0} onFillable exit HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0} null
2019-09-08 21:30:17.097:INFO:oejsh.ContextHandler:main: Stopped o.e.j.s.ServletContextHandler@978475b{/,null,UNAVAILABLE}
2019-09-08 21:30:17.097:DBUG:oejut.QueuedThreadPool:server-1351: ran org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@c5c2a84 in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=3,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:17.097:DBUG:oejuc.AbstractLifeCycle:main: STOPPED o.e.j.s.ServletContextHandler@978475b{/,null,UNAVAILABLE}
2019-09-08 21:30:17.097:DBUG:oeji.AbstractConnection:server-1357: onClose HttpConnection@b330579::SocketChannelEndPoint@25888509{/127.0.0.1:49218<->/127.0.0.1:36641,CLOSED,fill=-,flush=-,to=4994/30000}{io=0/0,kio=-1,kro=-1}->HttpConnection@b330579[p=HttpParser{s=CLOSED,0 of -1},g=HttpGenerator@5b520af8{s=START}]=>HttpChannelOverHttp@2f70ee79{s=HttpChannelState@6a7265f3{s=IDLE rs=BLOCKING os=OPEN is=IDLE awp=false se=false i=true al=0},r=1,c=false/false,a=IDLE,uri=null,age=0}
2019-09-08 21:30:17.098:DBUG:oejuc.AbstractLifeCycle:main: stopping QueuedThreadPool[proxy]@464017f5{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@6888746c{s=1/1,p=0}]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:server-1357: ran org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@3639d94d in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=4,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:main: Stopping QueuedThreadPool[proxy]@464017f5{STOPPING,8<=8<=200,i=6,r=-1,q=0}[ReservedThreadExecutor@6888746c{s=1/1,p=0}]
2019-09-08 21:30:17.098:DBUG:oejuc.AbstractLifeCycle:main: stopping ReservedThreadExecutor@6888746c{s=1/1,p=0}
2019-09-08 21:30:17.098:DBUG:oejut.ReservedThreadExecutor:main: ReservedThreadExecutor@6888746c{s=0/1,p=0}@22d89e54 offer STOP!
2019-09-08 21:30:17.098:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ReservedThreadExecutor@6888746c{s=0/1,p=0}
2019-09-08 21:30:17.098:DBUG:oejut.ReservedThreadExecutor:proxy-1363: ReservedThreadExecutor@6888746c{s=0/1,p=0}@22d89e54 task=STOP!
2019-09-08 21:30:17.098:DBUG:oejut.ReservedThreadExecutor:proxy-1363: ReservedThreadExecutor@6888746c{s=0/1,p=0}@22d89e54 Exited
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[proxy-1366,5,main] for 14999
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1363: ran ReservedThreadExecutor@6888746c{s=0/1,p=0}@22d89e54 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1367: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1362: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=6}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1367: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=5}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1363: Thread[proxy-1363,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=6}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1367: Thread[proxy-1367,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1362: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=5}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1365: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1366: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=3}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1362: Thread[proxy-1362,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=3}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1366: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1365: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=3}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1366: Thread[proxy-1366,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1364: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1361: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=5}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1364: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1365: Thread[proxy-1365,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1364: Thread[proxy-1364,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[proxy-1363,5,] for 14999
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[proxy-1360,5,main] for 14999
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1361: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:17.098:DBUG:oejut.QueuedThreadPool:proxy-1361: Thread[proxy-1361,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.461:DBUG:oejpA.b0dd3a:proxy-1360: 836371871 proxying content to downstream: 18 bytes CountingCallback@4f5141cd
2019-09-08 21:30:19.461:DBUG:oejpA.b0dd3a:proxy-1360: 836371871 proxying content to downstream: 0 bytes CountingCallback@155dd5f7
2019-09-08 21:30:19.461:DBUG:oejpA.b0dd3a:proxy-1360: 836371871 downstream content transformation 27 -> 18 bytes
2019-09-08 21:30:19.461:DBUG:oejs.HttpChannelState:proxy-1360: onWritePossible HttpChannelState@3c9881ae{s=WAITING rs=ASYNC os=OPEN is=IDLE awp=false se=false i=false al=0}
2019-09-08 21:30:19.461:DBUG:oejc.HttpReceiver:proxy-1360: State update failed: TRANSIENT -> CONTENT: FAILURE
2019-09-08 21:30:19.461:DBUG:oejc.HttpExchange:proxy-1360: Terminated response for HttpExchange@efdfee req=TERMINATED/null@null res=TERMINATED/java.nio.channels.AsynchronousCloseException@79aa675b, result: Result[HttpRequest[GET / HTTP/1.1]@74d88dc0 > HttpResponse[HTTP/1.1 200 OK]@13b01b0f] java.nio.channels.AsynchronousCloseException
2019-09-08 21:30:19.462:DBUG:oejc.HttpReceiver:proxy-1360: Response complete HttpResponse[HTTP/1.1 200 OK]@13b01b0f
2019-09-08 21:30:19.462:DBUG:oejc.HttpChannel:proxy-1360: HttpExchange@efdfee req=TERMINATED/null@null res=TERMINATED/java.nio.channels.AsynchronousCloseException@79aa675b disassociated true from HttpChannelOverHTTP@79ee3e9d(exchange=null)[send=HttpSenderOverHTTP@3cecbfc4(req=QUEUED,snd=COMPLETED,failure=null)[HttpGenerator@7d143c89{s=START}],recv=HttpReceiverOverHTTP@d9a0099(rsp=FAILURE,failure=java.nio.channels.AsynchronousCloseException)[HttpParser{s=CLOSE,27 of 27}]]
2019-09-08 21:30:19.462:DBUG:oejc.HttpChannel:proxy-1360: Closing, reason: failure - HttpConnectionOverHTTP@7dd1b5ff::SocketChannelEndPoint@731655ed{localhost/127.0.0.1:36641<->/127.0.0.1:49218,CLOSED,fill=-,flush=-,to=7359/30000}{io=0/0,kio=-1,kro=-1}->HttpConnectionOverHTTP@7dd1b5ff(l:/127.0.0.1:49218 <-> r:localhost/127.0.0.1:36641,closed=true)=>HttpChannelOverHTTP@79ee3e9d(exchange=null)[send=HttpSenderOverHTTP@3cecbfc4(req=QUEUED,snd=COMPLETED,failure=null)[HttpGenerator@7d143c89{s=START}],recv=HttpReceiverOverHTTP@d9a0099(rsp=FAILURE,failure=java.nio.channels.AsynchronousCloseException)[HttpParser{s=CLOSE,27 of 27}]]
2019-09-08 21:30:19.462:DBUG:oejc.HttpReceiver:proxy-1360: Request/Response failed: Result[HttpRequest[GET / HTTP/1.1]@74d88dc0 > HttpResponse[HTTP/1.1 200 OK]@13b01b0f] java.nio.channels.AsynchronousCloseException
2019-09-08 21:30:19.462:DBUG:oejpA.b0dd3a:proxy-1360: 836371871 proxying failed
java.nio.channels.AsynchronousCloseException
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.close(HttpConnectionOverHTTP.java:181)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
at org.eclipse.jetty.client.AbstractConnectionPool.close(AbstractConnectionPool.java:208)
at org.eclipse.jetty.client.DuplexConnectionPool.close(DuplexConnectionPool.java:237)
at org.eclipse.jetty.client.HttpDestination.close(HttpDestination.java:385)
at org.eclipse.jetty.client.HttpClient.doStop(HttpClient.java:260)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.proxy.AbstractProxyServlet.destroy(AbstractProxyServlet.java:154)
at org.eclipse.jetty.servlet.ServletHolder.destroyInstance(ServletHolder.java:475)
at org.eclipse.jetty.servlet.ServletHolder.doStop(ServletHolder.java:447)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.servlet.ServletHandler.doStop(ServletHandler.java:279)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180)
at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201)
at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117)
at org.eclipse.jetty.server.session.SessionHandler.doStop(SessionHandler.java:498)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180)
at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201)
at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117)
at org.eclipse.jetty.server.handler.ContextHandler.stopContext(ContextHandler.java:897)
at org.eclipse.jetty.servlet.ServletContextHandler.stopContext(ServletContextHandler.java:368)
at org.eclipse.jetty.server.handler.ContextHandler.doStop(ContextHandler.java:971)
at org.eclipse.jetty.servlet.ServletContextHandler.doStop(ServletContextHandler.java:285)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180)
at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201)
at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117)
at org.eclipse.jetty.server.Server.doStop(Server.java:454)
at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93)
at org.eclipse.jetty.proxy.AsyncMiddleManServletTest.dispose(AsyncMiddleManServletTest.java:163)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675)
at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125)
at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132)
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptLifecycleMethod(TimeoutExtension.java:111)
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptAfterEachMethod(TimeoutExtension.java:95)
at org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115)
at org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105)
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104)
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62)
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43)
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35)
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104)
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98)
at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.invokeMethodInExtensionContext(ClassBasedTestDescriptor.java:464)
at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.lambda$synthesizeAfterEachMethodAdapter$17(ClassBasedTestDescriptor.java:454)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeAfterEachMethods$9(TestMethodTestDescriptor.java:228)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeAllAfterMethodsOrCallbacks$12(TestMethodTestDescriptor.java:256)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeAllAfterMethodsOrCallbacks$13(TestMethodTestDescriptor.java:256)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeAllAfterMethodsOrCallbacks(TestMethodTestDescriptor.java:255)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeAfterEachMethods(TestMethodTestDescriptor.java:226)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:139)
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32)
at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51)
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:220)
at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$6(DefaultLauncher.java:188)
at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:202)
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:181)
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:128)
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:150)
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:124)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
2019-09-08 21:30:19.463:DBUG:oejs.HttpChannelState:proxy-1360: sendError HttpChannelState@3c9881ae{s=WOKEN rs=ASYNC os=OPEN is=IDLE awp=true se=false i=false al=0}
2019-09-08 21:30:19.463:DBUG:oejs.HttpChannelState:proxy-1360: complete HttpChannelState@3c9881ae{s=WOKEN rs=ASYNC os=OPEN is=IDLE awp=true se=true i=false al=0}
2019-09-08 21:30:19.463:DBUG:oejc.TimeoutCompleteListener:proxy-1360: Cancelled (false) timeout for HttpRequest[GET / HTTP/1.1]@74d88dc0 on org.eclipse.jetty.client.TimeoutCompleteListener@5d2c89a2
2019-09-08 21:30:19.463:DBUG:oejc.HttpReceiver:proxy-1360: Parsed true, remaining 0 HttpParser{s=CLOSE,27 of 27}
2019-09-08 21:30:19.463:DBUG:oejut.QueuedThreadPool:proxy-1360: ran org.eclipse.jetty.io.ManagedSelector$$Lambda$437/0x00000008012c0440@701c413 in QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.463:DBUG:oejut.QueuedThreadPool:proxy-1360: Thread[proxy-1360,5,main] exited for QueuedThreadPool[proxy]@464017f5{STOPPING,8<=0<=200,i=6,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.463:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[proxy-1361,5,] for 12634
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: STOPPED QueuedThreadPool[proxy]@464017f5{STOPPED,8<=0<=200,i=6,r=-1,q=0}[NO_TRY]
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: STOPPED Server@3c4231e5{STOPPED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: stopping Server@276eafad{STARTED}[9.4.21-SNAPSHOT]
2019-09-08 21:30:19.463:DBUG:oejs.Server:main: doStop Server@276eafad{STOPPING}[9.4.21-SNAPSHOT]
2019-09-08 21:30:19.463:DBUG:oejut.QueuedThreadPool:server-1352: ran server-1352-acceptor-0@7f33ad20-ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:36641} in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=5,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:19.463:DBUG:oejsh.AbstractHandlerContainer:main: Graceful shutdown Server@276eafad{STOPPING}[9.4.21-SNAPSHOT] by Sun Sep 08 21:30:49 UTC 2019
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: stopping ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: stopping SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:19.463:DBUG:oejuc.AbstractLifeCycle:main: stopping ManagedSelector@2ae0eb98{STARTED} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:19.463:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@1d86b636 on ManagedSelector@2ae0eb98{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:19.463:DBUG:oeji.ManagedSelector:main: Wakeup on submit ManagedSelector@2ae0eb98{STOPPING} id=0 keys=0 selected=0 updates=1
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken with none selected
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken up from select, 0/0/0 selected
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a processing 0 keys, 1 updates
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: updateable 1
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: update org.eclipse.jetty.io.ManagedSelector$CloseConnections@1d86b636
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Closing 0 connections on ManagedSelector@2ae0eb98{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: updates 0
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a waiting with 0 keys
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@e0c03bd on ManagedSelector@2ae0eb98{STOPPING} id=0 keys=0 selected=0 updates=0
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:main: Wakeup on submit ManagedSelector@2ae0eb98{STOPPING} id=0 keys=0 selected=0 updates=1
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken with none selected
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a woken up from select, 0/0/0 selected
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: Selector sun.nio.ch.EPollSelectorImpl@71af297a processing 0 keys, 1 updates
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: updateable 1
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: update org.eclipse.jetty.io.ManagedSelector$StopSelector@e0c03bd
2019-09-08 21:30:19.464:DBUG:oeji.ManagedSelector:server-1354: updates 0
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping EatWhatYouKill@659565ed/SelectorProducer@481eb705/PRODUCING/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}][pc=0,pic=0,pec=1,epc=1]@2019-09-08T21:30:19.46427Z
2019-09-08 21:30:19.464:DBUG:oejut.ReservedThreadExecutor:server-1354: ReservedThreadExecutor@55e02661{s=1/1,p=0}@7b57420a size 1 > capacity 1
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED EatWhatYouKill@659565ed/SelectorProducer@481eb705/IDLE/p=false/QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}][pc=0,pic=0,pec=1,epc=1]@2019-09-08T21:30:19.464323Z
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ManagedSelector@2ae0eb98{STOPPED} id=0 keys=-1 selected=-1 updates=0
2019-09-08 21:30:19.464:DBUG:oejut.QueuedThreadPool:server-1354: ran ReservedThreadExecutor@55e02661{s=1/1,p=0}@7b57420a in QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=6,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED SelectorManager@ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping HttpConnectionFactory@29dcad7e[HTTP/1.1]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED HttpConnectionFactory@29dcad7e[HTTP/1.1]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping ScheduledExecutorScheduler@30bd6bc8{STARTED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ScheduledExecutorScheduler@30bd6bc8{STOPPED}
2019-09-08 21:30:19.464:INFO:oejs.AbstractConnector:main: Stopped ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ServerConnector@627cb3ed{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandler:main: stopping Server@276eafad{STOPPING}[9.4.21-SNAPSHOT]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping DefaultSessionIdManager@1e6f7c25{STARTED}[worker=node0]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping HouseKeeper@1a7f2d34{STARTED}[interval=600000, ownscheduler=true]
2019-09-08 21:30:19.464:INFO:oejs.session:main: node0 Stopped scavenging
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping ScheduledExecutorScheduler@23243bc0{STARTED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ScheduledExecutorScheduler@23243bc0{STOPPED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED HouseKeeper@1a7f2d34{STOPPED}[interval=600000, ownscheduler=true]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED DefaultSessionIdManager@1e6f7c25{STOPPED}[worker=node0]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping ErrorHandler@3b6c55b6{STARTED}
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandler:main: stopping ErrorHandler@3b6c55b6{STOPPING}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ErrorHandler@3b6c55b6{STOPPED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping o.e.j.s.ServletContextHandler@90b9695{/,null,SHUTDOWN}
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandlerContainer:main: Graceful shutdown o.e.j.s.ServletContextHandler@90b9695{/,null,SHUTDOWN} by Sun Sep 08 21:30:49 UTC 2019
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandler:main: stopping o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.server.session.NullSessionDataStore@4d4337f9[passivating=false,graceSec=3600]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.server.session.NullSessionDataStore@4d4337f9[passivating=false,graceSec=3600]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.server.session.DefaultSessionCache@79d8075c[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping ScheduledExecutorScheduler@1267f832{STARTED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ScheduledExecutorScheduler@1267f832{STOPPED}
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandler:main: stopping org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping ServletHandler@1de6f29d{STARTED}
2019-09-08 21:30:19.464:DBUG:oejsh.AbstractHandler:main: stopping ServletHandler@1de6f29d{STOPPING}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-711261c7@251222be==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32-488c608a@25a613c9==org.eclipse.jetty.proxy.AsyncMiddleManServletTest$32,jsp=null,order=-1,inst=true,async=true
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ServletHandler@1de6f29d{STOPPED}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.server.session.SessionHandler1440183980==dftMaxIdleSec=-1
2019-09-08 21:30:19.464:INFO:oejsh.ContextHandler:main: Stopped o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: STOPPED o.e.j.s.ServletContextHandler@90b9695{/,null,UNAVAILABLE}
2019-09-08 21:30:19.464:DBUG:oejuc.AbstractLifeCycle:main: stopping QueuedThreadPool[server]@76d220eb{STARTED,8<=8<=200,i=7,r=1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Stopping QueuedThreadPool[server]@76d220eb{STOPPING,8<=8<=200,i=7,r=-1,q=0}[ReservedThreadExecutor@55e02661{s=1/1,p=0}]
2019-09-08 21:30:19.465:DBUG:oejuc.AbstractLifeCycle:main: stopping ReservedThreadExecutor@55e02661{s=1/1,p=0}
2019-09-08 21:30:19.465:DBUG:oejut.ReservedThreadExecutor:main: ReservedThreadExecutor@55e02661{s=0/1,p=0}@3e55c304 offer STOP!
2019-09-08 21:30:19.465:DBUG:oejuc.AbstractLifeCycle:main: STOPPED ReservedThreadExecutor@55e02661{s=0/1,p=0}
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[server-1351,5,main] for 14999
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1358: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1358: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1358: Thread[server-1358,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.ReservedThreadExecutor:server-1356: ReservedThreadExecutor@55e02661{s=0/1,p=0}@3e55c304 task=STOP!
2019-09-08 21:30:19.465:DBUG:oejut.ReservedThreadExecutor:server-1356: ReservedThreadExecutor@55e02661{s=0/1,p=0}@3e55c304 Exited
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1356: ran ReservedThreadExecutor@55e02661{s=0/1,p=0}@3e55c304 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=7}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1356: Thread[server-1356,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=6}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1351: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1353: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=6}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1355: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1353: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1352: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1351: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=4}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1355: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1353: Thread[server-1353,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1351: Thread[server-1351,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1355: Thread[server-1355,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1354: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1352: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1354: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1352: Thread[server-1352,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1357: run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=2}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1354: Thread[server-1354,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[server-1353,5,] for 14999
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[server-1352,5,] for 14999
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[server-1354,5,] for 14999
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1357: ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$412/0x0000000801267440@4c835c94 in QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:main: Waiting for Thread[server-1357,5,main] for 14999
2019-09-08 21:30:19.465:DBUG:oejut.QueuedThreadPool:server-1357: Thread[server-1357,5,main] exited for QueuedThreadPool[server]@76d220eb{STOPPING,8<=0<=200,i=7,r=-1,q=1}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejuc.AbstractLifeCycle:main: STOPPED QueuedThreadPool[server]@76d220eb{STOPPED,8<=0<=200,i=7,r=-1,q=0}[NO_TRY]
2019-09-08 21:30:19.465:DBUG:oejuc.AbstractLifeCycle:main: STOPPED Server@276eafad{STOPPED}[9.4.21-SNAPSHOT]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
You can’t perform that action at this time.