@@ -8,6 +8,8 @@ const MiddlewareRunner = require('./middleware-runner')
88const EndpointContext = require ( './endpoint-context' )
99const EndpointRunner = require ( './endpoint-runner' )
1010
11+ const DeltaTime = require ( '../utils/delta-time' )
12+
1113const Router = require ( 'origin-router' ) . Router
1214
1315class ServiceRunner {
@@ -45,6 +47,8 @@ class ServiceRunner {
4547 }
4648
4749 debug ( 'loadEndpoint' , name )
50+
51+ let dt = new DeltaTime ( ) . start ( )
4852 const build = Hoek . reach ( this . service , `compiled.endpoints.${ name } ` )
4953 let endpoint = new EndpointRunner ( build . code , build . map )
5054
@@ -63,6 +67,8 @@ class ServiceRunner {
6367 this . endpoint [ name ] = endpoint
6468
6569 this . router . add ( name , this . endpointHandler ( endpoint ) )
70+ dt . end ( )
71+ debug ( 'loaded endpoint' , name , 'in' , dt . deltaMs , 'ms' )
6672 }
6773
6874
@@ -85,6 +91,7 @@ class ServiceRunner {
8591
8692 debug ( 'loadMiddleware' , type , name )
8793
94+ let dt = new DeltaTime ( ) . start ( )
8895 const build = Hoek . reach ( this . service , `compiled.middleware.${ type } .${ name } ` )
8996
9097 if ( ! build || ! build . code ) {
@@ -99,6 +106,9 @@ class ServiceRunner {
99106
100107 this . middleware [ type ] [ name ] = runner
101108
109+ dt . end ( )
110+ debug ( 'loaded middleware' , name , 'in' , dt . deltaMs , 'ms' )
111+
102112 return runner
103113 }
104114
@@ -127,6 +137,8 @@ class ServiceRunner {
127137
128138 let route = await this . router . route ( req , res )
129139
140+ debug ( 'req done' )
141+
130142
131143 if ( ! route ) {
132144 res . status ( 404 ) . end ( )
@@ -158,13 +170,16 @@ class ServiceRunner {
158170
159171 await this . runMiddleware ( middlewareCfg , context , 'pre' )
160172
161- const result = await endpoint . run ( context )
173+ const result = await endpoint . run ( context , { Package : this . service . compiled . package } )
162174
163175 context . setOutput ( result )
164176
165177 await this . runMiddleware ( middlewareCfg , context , 'post' )
166178
179+ context . dt . end ( )
180+
167181 /*debug('ctx.log', context._debugContent)*/
182+ debug ( 'ran endpoint' , endpoint . info . Name , 'in' , context . dt . deltaMs , 'ms' )
168183 debug ( 'result' , context . output )
169184
170185 context . res . send ( context . output )
@@ -173,6 +188,10 @@ class ServiceRunner {
173188 catch ( err ) {
174189 debug ( 'caught error' , err )
175190
191+ context . dt . end ( )
192+
193+ debug ( 'crashed (' , endpoint . info . Name , ') in' , context . dt . deltaMs , 'ms' )
194+
176195 context . res . status ( 500 ) . send ( {
177196 error : {
178197 code : err . code ,
@@ -202,7 +221,11 @@ class ServiceRunner {
202221 debug ( '\t\trunning' , name )
203222 const middleware = Hoek . reach ( this . middleware , `${ type } .${ name } ` )
204223
205- await middleware . run ( ctx , info )
224+ const dt = new DeltaTime ( ) . start ( )
225+ await middleware . run ( ctx , { Config : info } )
226+ dt . end ( )
227+
228+ debug ( 'runMiddleware(' , type , name , ') in' , dt . deltaMs , 'ms' )
206229 }
207230 }
208231}
0 commit comments