comparison tests/test-http.t @ 35698:0c4b23ccf1a5

httppeer: add support for tracing all http request made by the peer This changeset introduces a new 'devel.debug.peer-request' config. When set to True, debug message about request made by peer will be issued. This help to understand what actually happens during an exchange and tracks source of performance loss. This changeset implement support for http peer only.
author Boris Feld <boris.feld@octobus.net>
date Fri, 12 Jan 2018 10:41:03 +0000
parents 925107e37619
children 1d118f9f4f57
comparison
equal deleted inserted replaced
35697:5a7906ed78d4 35698:0c4b23ccf1a5
246 remote: adding changesets 246 remote: adding changesets
247 remote: adding manifests 247 remote: adding manifests
248 remote: adding file changes 248 remote: adding file changes
249 remote: added 1 changesets with 1 changes to 1 files 249 remote: added 1 changesets with 1 changes to 1 files
250 $ hg rollback -q 250 $ hg rollback -q
251 $ hg -R dest push http://user:pass@localhost:$HGPORT2/ --debug 251 $ hg -R dest push http://user:pass@localhost:$HGPORT2/ --debug --config devel.debug.peer-request=yes
252 pushing to http://user:***@localhost:$HGPORT2/ 252 pushing to http://user:***@localhost:$HGPORT2/
253 using http://localhost:$HGPORT2/ 253 using http://localhost:$HGPORT2/
254 http auth: user user, password **** 254 http auth: user user, password ****
255 sending capabilities command 255 sending capabilities command
256 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=capabilities
257 devel-peer-request: finished in *.???? seconds (200) (glob)
256 query 1; heads 258 query 1; heads
257 sending batch command 259 sending batch command
260 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=batch
261 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
262 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
263 devel-peer-request: 68 bytes of commands arguments in headers
264 devel-peer-request: finished in *.???? seconds (200) (glob)
258 searching for changes 265 searching for changes
259 all remote heads known locally 266 all remote heads known locally
260 preparing listkeys for "phases" 267 preparing listkeys for "phases"
261 sending listkeys command 268 sending listkeys command
269 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=listkeys
270 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
271 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
272 devel-peer-request: 16 bytes of commands arguments in headers
262 http auth: user user, password **** 273 http auth: user user, password ****
274 devel-peer-request: finished in *.???? seconds (200) (glob)
263 received listkey for "phases": 58 bytes 275 received listkey for "phases": 58 bytes
264 checking for updated bookmarks 276 checking for updated bookmarks
265 preparing listkeys for "bookmarks" 277 preparing listkeys for "bookmarks"
266 sending listkeys command 278 sending listkeys command
279 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=listkeys
280 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
281 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
282 devel-peer-request: 19 bytes of commands arguments in headers
283 devel-peer-request: finished in *.???? seconds (200) (glob)
267 received listkey for "bookmarks": 0 bytes 284 received listkey for "bookmarks": 0 bytes
268 sending branchmap command 285 sending branchmap command
286 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=branchmap
287 devel-peer-request: Vary X-HgProto-1
288 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
289 devel-peer-request: finished in *.???? seconds (200) (glob)
269 sending branchmap command 290 sending branchmap command
291 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=branchmap
292 devel-peer-request: Vary X-HgProto-1
293 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
294 devel-peer-request: finished in *.???? seconds (200) (glob)
270 preparing listkeys for "bookmarks" 295 preparing listkeys for "bookmarks"
271 sending listkeys command 296 sending listkeys command
297 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=listkeys
298 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
299 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
300 devel-peer-request: 19 bytes of commands arguments in headers
301 devel-peer-request: finished in *.???? seconds (200) (glob)
272 received listkey for "bookmarks": 0 bytes 302 received listkey for "bookmarks": 0 bytes
273 1 changesets found 303 1 changesets found
274 list of changesets: 304 list of changesets:
275 7f4e523d01f2cc3765ac8934da3d14db775ff872 305 7f4e523d01f2cc3765ac8934da3d14db775ff872
276 bundle2-output-bundle: "HG20", 5 parts total 306 bundle2-output-bundle: "HG20", 5 parts total
279 bundle2-output-part: "check:heads" streamed payload 309 bundle2-output-part: "check:heads" streamed payload
280 bundle2-output-part: "changegroup" (params: 1 mandatory) streamed payload 310 bundle2-output-part: "changegroup" (params: 1 mandatory) streamed payload
281 bundle2-output-part: "phase-heads" 24 bytes payload 311 bundle2-output-part: "phase-heads" 24 bytes payload
282 sending unbundle command 312 sending unbundle command
283 sending 986 bytes 313 sending 986 bytes
314 devel-peer-request: POST http://localhost:$HGPORT2/?cmd=unbundle
315 devel-peer-request: Content-length 986
316 devel-peer-request: Content-type application/mercurial-0.1
317 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
318 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
319 devel-peer-request: 16 bytes of commands arguments in headers
320 devel-peer-request: 986 bytes of data
321 devel-peer-request: finished in *.???? seconds (200) (glob)
284 bundle2-input-bundle: no-transaction 322 bundle2-input-bundle: no-transaction
285 bundle2-input-part: "reply:changegroup" (advisory) (params: 0 advisory) supported 323 bundle2-input-part: "reply:changegroup" (advisory) (params: 0 advisory) supported
286 bundle2-input-part: "output" (advisory) (params: 0 advisory) supported 324 bundle2-input-part: "output" (advisory) (params: 0 advisory) supported
287 bundle2-input-part: total payload size 100 325 bundle2-input-part: total payload size 100
288 remote: adding changesets 326 remote: adding changesets
291 remote: added 1 changesets with 1 changes to 1 files 329 remote: added 1 changesets with 1 changes to 1 files
292 bundle2-input-part: "output" (advisory) supported 330 bundle2-input-part: "output" (advisory) supported
293 bundle2-input-bundle: 2 parts total 331 bundle2-input-bundle: 2 parts total
294 preparing listkeys for "phases" 332 preparing listkeys for "phases"
295 sending listkeys command 333 sending listkeys command
334 devel-peer-request: GET http://localhost:$HGPORT2/?cmd=listkeys
335 devel-peer-request: Vary X-HgArg-1,X-HgProto-1
336 devel-peer-request: X-hgproto-1 0.1 0.2 comp=$USUAL_COMPRESSIONS$
337 devel-peer-request: 16 bytes of commands arguments in headers
338 devel-peer-request: finished in *.???? seconds (200) (glob)
296 received listkey for "phases": 15 bytes 339 received listkey for "phases": 15 bytes
297 $ hg rollback -q 340 $ hg rollback -q
298 341
299 $ sed 's/.*] "/"/' < ../access.log 342 $ sed 's/.*] "/"/' < ../access.log
300 "GET /?cmd=capabilities HTTP/1.1" 200 - 343 "GET /?cmd=capabilities HTTP/1.1" 200 -