Skip to content

Instantly share code, notes, and snippets.

@isterin
Last active August 29, 2015 13:57
Show Gist options
  • Save isterin/9470504 to your computer and use it in GitHub Desktop.
Save isterin/9470504 to your computer and use it in GitHub Desktop.
Scalatra
new AsyncResult {
val is = Future {
try {
val results = searchService.findEntry(eventId.toLong, term, limit)
Ok("DUDE")
}
catch {
case e:Throwable => e.printStackTrace(); Ok(e.getMessage)
}
}
}
new AsyncResult {
val is = Future {
try {
Thread.sleep(50)
Ok("DUDE")
}
catch {
case e:Throwable => e.printStackTrace(); Ok(e.getMessage)
}
}
}
15:49:08.488 [qtp1666176350-24-acceptor-0-ServerConnector@7be212d0{HTTP/1.1}{0.0.0.0:8080}] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectorManager$ManagedSelector$Accept@6c42672c
15:49:08.488 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 0/0 selected
15:49:08.488 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectorManager$ManagedSelector$Accept@6c42672c
15:49:08.489 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onOpen SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,-,-,30000,null}{io=0,kio=0,kro=0}
15:49:08.489 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,-,-,30000,null}{io=0,kio=0,kro=0} idle timeout check, elapsed: 0 ms, remaining: 30000 ms
15:49:08.490 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.server.HttpConnection - New HTTP Connection HttpConnection@1a922bc8{IDLE}
15:49:08.490 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.AbstractConnection - onOpen HttpConnection@1a922bc8{IDLE}
15:49:08.490 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@1a922bc8{IDLE}
15:49:08.490 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED HttpConnection@1a922bc8{FILL_INTERESTED}
15:49:08.491 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updated 0 -> 1 for SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=0,kro=0}
15:49:08.491 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@72786518
15:49:08.491 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1
15:49:08.491 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Created SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=0}
15:49:08.491 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select
15:49:10.105 [Scheduler-2075268385] DEBUG org.eclipse.jetty.server.session - Scavenging sessions at 1394480950105
15:49:24.708 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/1 selected
15:49:24.708 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0
15:49:24.709 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updated 1 -> 0 for SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,R,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:24.709 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@72786518
15:49:24.710 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->FILLING HttpConnection@1a922bc8{FILLING}
15:49:24.710 [qtp1666176350-16-selector-ServerConnectorManager@48c36b2a/5] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select
15:49:24.710 [qtp1666176350-52] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@1a922bc8{FILLING} onFillable HttpChannelState@27fbea18{s=IDLE i=true a=null}
15:49:24.711 [qtp1666176350-52] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled -1 SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,-,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:24.711 [qtp1666176350-52] DEBUG org.eclipse.jetty.io.ChannelEndPoint - ishut SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,Open,in,out,-,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:24.712 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - atEOF HttpParser{s=START,0 of 0}
15:49:24.712 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - parseNext s=START HeapByteBuffer@6894b5af[p=0,l=0,c=16384,r=0]={<<<>>>GET /api/search/e...���������������}
15:49:24.712 [qtp1666176350-52] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,CLOSED,ISHUT,out,-,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:24.713 [qtp1666176350-52] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,CLOSED,ISHUT,out,-,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:24.713 [qtp1666176350-52] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=0,kio=-1,kro=-1}
15:49:24.714 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - onClose HttpConnection@1a922bc8{FILLING}
15:49:24.714 [qtp1666176350-52] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@7b7e3427{/0:0:0:0:0:0:0:1:49768<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=0,kio=-1,kro=-1}
15:49:24.715 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSED
15:49:24.715 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - FILLING-->IDLE HttpConnection@1a922bc8{IDLE}
15:49:28.165 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 29999 ms, remaining: 1 ms
15:49:28.167 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 30001 ms, remaining: -1 ms
15:49:28.168 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout expired
15:49:28.168 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@4f966198{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:28.168 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE HttpConnection@dcd4755{IDLE}
15:49:28.168 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=CLOSED,0 of -1}
15:49:28.168 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - CLOSED --> CLOSED
15:49:28.168 [Scheduler-1254328772] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,CLOSED,in,OSHUT,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:28.168 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@dcd4755{IDLE} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:28.169 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,CLOSED,in,OSHUT,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:28.169 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=1,kio=-1,kro=-1}
15:49:28.170 [Scheduler-1254328772] DEBUG o.e.jetty.io.AbstractConnection - onClose HttpConnection@dcd4755{IDLE}
15:49:28.170 [Scheduler-1254328772] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@413efaf2{/0:0:0:0:0:0:0:1:49762<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=1,kio=-1,kro=-1}
15:49:28.170 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 29911 ms, remaining: 89 ms
15:49:28.260 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 30001 ms, remaining: -1 ms
15:49:28.261 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout expired
15:49:28.261 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@1995e0a5{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:28.261 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE HttpConnection@253e41fe{IDLE}
15:49:28.261 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=START,0 of -1}
15:49:28.261 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSED
15:49:28.261 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@253e41fe{IDLE} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:28.262 [qtp1666176350-52] DEBUG org.eclipse.jetty.io.ChannelEndPoint - oshut SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,out,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:28.262 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@253e41fe{IDLE}
15:49:28.262 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED HttpConnection@253e41fe{FILL_INTERESTED}
15:49:28.262 [qtp1666176350-52] DEBUG o.e.jetty.io.SelectChannelEndPoint - Ignoring local interests update 1 -> 1 for SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:28.262 [qtp1666176350-24-acceptor-0-ServerConnector@7be212d0{HTTP/1.1}{0.0.0.0:8080}] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectorManager$ManagedSelector$Accept@639c3c08
15:49:28.262 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 0/0 selected
15:49:28.262 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectorManager$ManagedSelector$Accept@639c3c08
15:49:28.263 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onOpen SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,-,-,30000,null}{io=0,kio=0,kro=0}
15:49:28.263 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,-,-,30000,null}{io=0,kio=0,kro=0} idle timeout check, elapsed: 0 ms, remaining: 30000 ms
15:49:28.263 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.server.HttpConnection - New HTTP Connection HttpConnection@16d9e492{IDLE}
15:49:28.263 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.AbstractConnection - onOpen HttpConnection@16d9e492{IDLE}
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@16d9e492{IDLE}
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED HttpConnection@16d9e492{FILL_INTERESTED}
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updated 0 -> 1 for SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=0,kro=0}
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@3b2d38f6
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Created SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=0}
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/1 selected
15:49:28.264 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0
15:49:28.265 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updated 1 -> 0 for SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:28.265 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@3b2d38f6
15:49:28.265 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->FILLING HttpConnection@16d9e492{FILLING}
15:49:28.265 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select
15:49:28.265 [qtp1666176350-50] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@16d9e492{FILLING} onFillable HttpChannelState@15f6bcd4{s=IDLE i=true a=null}
15:49:28.265 [qtp1666176350-50] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 535 SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,-,-,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:28.265 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - parseNext s=START HeapByteBuffer@6894b5af[p=0,l=535,c=16384,r=535]={<<<GET /api/search/e...69:t|77cb:t||||>>>�����������������...���������������}
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - START --> SPACE1
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - SPACE1 --> URI
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - URI --> SPACE2
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - SPACE2 --> REQUEST_VERSION
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - REQUEST_VERSION --> HEADER
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_IN_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.266 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_IN_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> HEADER_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_VALUE --> HEADER_IN_VALUE
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER_IN_VALUE --> HEADER
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - HEADER --> END
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=IDLE,uri=-} messageComplete
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.server.HttpInput - HttpInputOverHTTP@712911bd EOF
15:49:28.267 [qtp1666176350-50] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=IDLE,uri=-} handle enter
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.jetty.server.HttpChannelState - HttpChannelState@15f6bcd4{s=IDLE i=true a=null} handling IDLE
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=DISPATCHED,uri=/api/search/event/932/entry} action REQUEST_DISPATCH
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG org.eclipse.jetty.server.Server - REQUEST /api/search/event/932/entry on HttpChannelOverHttp@79e70d8f{r=1,a=DISPATCHED,uri=/api/search/event/932/entry}
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.j.server.handler.ContextHandler - scope null||/api/search/event/932/entry @ o.e.j.w.WebAppContext@204dce2e{/,file:/Users/ilya/projects/sandbox/results-services/src/main/webapp,AVAILABLE}
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.j.server.handler.ContextHandler - context=||/api/search/event/932/entry @ o.e.j.w.WebAppContext@204dce2e{/,file:/Users/ilya/projects/sandbox/results-services/src/main/webapp,AVAILABLE}
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG org.eclipse.jetty.server.session - sessionManager=org.eclipse.jetty.server.session.HashSessionManager@d1dca40
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG org.eclipse.jetty.server.session - session=null
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.jetty.servlet.ServletHandler - servlet |/api/search|/event/932/entry -> com.chronotrack.ctlive.results.api.resources.SearchResource@2831a1c9==com.chronotrack.ctlive.results.api.resources.SearchResource,-1,true
15:49:28.268 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.jetty.servlet.ServletHandler - chain=null
15:49:28.272 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG org.eclipse.jetty.server.Server - RESPONSE /api/search/event/932/entry 200 handled=true
15:49:28.272 [qtp1666176350-50 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.jetty.server.HttpChannelState - HttpChannelState@15f6bcd4{s=DISPATCHED i=true a=STARTED} unhandle DISPATCHED
15:49:28.272 [qtp1666176350-50] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=ASYNCWAIT,uri=/api/search/event/932/entry} handle exit, result WAIT
15:49:28.272 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - FILLING-->IDLE HttpConnection@16d9e492{IDLE}
15:49:28.353 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=ASYNCWAIT,uri=/api/search/event/932/entry} handle enter
15:49:28.354 [default-akka.actor.default-dispatcher-4 - /api/search/event/932/entry?callback=athlete_complete3585789&term=kitwara] DEBUG o.e.jetty.server.HttpChannelState - HttpChannelState@15f6bcd4{s=ASYNCWAIT i=false a=COMPLETE} handling ASYNCWAIT
15:49:28.354 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$CommitCallback@88f0bea[ITERATING] generate: NEED_HEADER (null,[p=0,l=4,c=32768,r=4],true)@START
15:49:28.354 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$CommitCallback@88f0bea[ITERATING] generate: FLUSH ([p=0,l=117,c=8192,r=117],[p=0,l=4,c=32768,r=4],true)@COMPLETING
15:49:28.354 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@67573409{IDLE} [HeapByteBuffer@443f36e4[p=0,l=117,c=8192,r=117]={<<<HTTP/1.1 200 OK||....v20140225)||||>>>�����������������...���������������},HeapByteBuffer@122cd5bd[p=0,l=4,c=32768,r=4]={<<<DUDE>>>�����������������...���������������}]
15:49:28.354 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@67573409{WRITING}:IDLE-->WRITING
15:49:28.354 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 121 SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,-,W,30000,HttpConnection}{io=0,kio=0,kro=1}
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.WriteFlusher - flushed true
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@67573409{IDLE}:WRITING-->IDLE
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$CommitCallback@88f0bea[ITERATING] generate: DONE ([p=117,l=117,c=8192,r=0],[p=4,l=4,c=32768,r=0],true)@END
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.http.HttpParser - reset HttpParser{s=END,0 of 0}
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.http.HttpParser - END --> START
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@16d9e492{IDLE}
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED HttpConnection@16d9e492{FILL_INTERESTED}
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updated 0 -> 1 for SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=0,kro=1}
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@3b2d38f6
15:49:28.355 [default-akka.actor.default-dispatcher-4] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1
15:49:28.356 [default-akka.actor.default-dispatcher-4] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@79e70d8f{r=1,a=IDLE,uri=-} handle exit, result COMPLETE
15:49:28.356 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 0/1 selected
15:49:28.356 [qtp1666176350-12-selector-ServerConnectorManager@48c36b2a/6] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select
15:49:40.105 [Scheduler-2075268385] DEBUG org.eclipse.jetty.server.session - Scavenging sessions at 1394480980105
15:49:58.262 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 29999 ms, remaining: 1 ms
15:49:58.263 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 30001 ms, remaining: -1 ms
15:49:58.263 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout expired
15:49:58.264 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@1995e0a5{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:58.264 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE HttpConnection@253e41fe{IDLE}
15:49:58.264 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=CLOSED,0 of -1}
15:49:58.264 [qtp1666176350-52] DEBUG org.eclipse.jetty.http.HttpParser - CLOSED --> CLOSED
15:49:58.264 [Scheduler-1254328772] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,CLOSED,in,OSHUT,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:58.264 [qtp1666176350-52] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@253e41fe{IDLE} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:58.264 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,CLOSED,in,OSHUT,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:58.265 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=1,kio=-1,kro=-1}
15:49:58.265 [Scheduler-1254328772] DEBUG o.e.jetty.io.AbstractConnection - onClose HttpConnection@253e41fe{IDLE}
15:49:58.266 [Scheduler-1254328772] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@318161d6{/0:0:0:0:0:0:0:1:49766<->8080,CLOSED,ISHUT,OSHUT,-,-,30000,HttpConnection}{io=1,kio=-1,kro=-1}
15:49:58.267 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 29911 ms, remaining: 89 ms
15:49:58.357 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 30001 ms, remaining: -1 ms
15:49:58.357 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,R,-,30000,HttpConnection}{io=1,kio=1,kro=1} idle timeout expired
15:49:58.357 [Scheduler-1254328772] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@67573409{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:58.357 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE HttpConnection@16d9e492{IDLE}
15:49:58.357 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=START,0 of -1}
15:49:58.357 [qtp1666176350-50] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSED
15:49:58.358 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@16d9e492{IDLE} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
15:49:58.358 [qtp1666176350-50] DEBUG org.eclipse.jetty.io.ChannelEndPoint - oshut SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,out,-,-,30000,HttpConnection}{io=1,kio=1,kro=1}
15:49:58.358 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@16d9e492{IDLE}
15:49:58.358 [qtp1666176350-50] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED HttpConnection@16d9e492{FILL_INTERESTED}
15:49:58.358 [qtp1666176350-50] DEBUG o.e.jetty.io.SelectChannelEndPoint - Ignoring local interests update 1 -> 1 for SelectChannelEndPoint@19c9e8e8{/0:0:0:0:0:0:0:1:49769<->8080,Open,in,OSHUT,R,-,30000,HttpConnection}{io=1,kio=1,kro=1}
class SearchResource(private val searchService:SearchServiceInterface) {
protected implicit def executor: ExecutionContext = GlobalContext.system.dispatcher // This is for now just ActorSystem()
protected implicit val defaultTimeout = Timeout(10, TimeUnit.SECONDS)
protected implicit def jsonFormats: Formats = DefaultFormats
get("/event/:eventId/entry") {
new AsyncResult {
val eventId, term, limit; // assigns params
val is = Future {
try {
val results = searchService.findEntry(eventId.toLong, term, limit)
Ok(results)
}
catch {
case e:Throwable =>
e.printStackTrace();
Ok(e.getMessage)
}
}
}
}
}
for (i <- 0 until 50) {
new Thread() {
for (i <- 0 until 10) {
val s = System.currentTimeMillis()
val results = searchService.findEntry(932, "sammy")
println("COMPLETED IN: " + (System.currentTimeMillis() - s))
}
}.start()
}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment