##// END OF EJS Templates
rebase: remove "if True"...
rebase: remove "if True" The "if True" block was to make the last patch easier to review. This patch removes "if True" and unindents the block.

File last commit:

r32320:d3177aec default
r33333:8bfd10e4 default
Show More
test-http-bad-server.t
905 lines | 46.8 KiB | text/troff | Tads3Lexer
/ tests / test-http-bad-server.t
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 #require killdaemons serve zstd
Client version is embedded in HTTP request and is effectively dynamic. Pin the
version so behavior is deterministic.
$ cat > fakeversion.py << EOF
> from mercurial import util
> util.version = lambda: '4.2'
> EOF
$ cat >> $HGRCPATH << EOF
> [extensions]
> fakeversion = `pwd`/fakeversion.py
> EOF
$ hg init server0
$ cd server0
$ touch foo
$ hg -q commit -A -m initial
Also disable compression because zstd is optional and causes output to vary
and because debugging partial responses is hard when compression is involved
$ cat > .hg/hgrc << EOF
> [extensions]
> badserver = $TESTDIR/badserverext.py
> [server]
> compressionengines = none
> EOF
Failure to accept() socket should result in connection related error message
$ hg --config badserver.closebeforeaccept=true serve -p $HGPORT -d --pid-file=hg.pid
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
Matt Harbison
test-http-bad-server: conditionalize error output for Windows
r32020 abort: error: Connection reset by peer (no-windows !)
abort: error: An existing connection was forcibly closed by the remote host (windows !)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
(The server exits on its own, but there is a race between that and starting a new server.
So ensure the process is dead.)
$ killdaemons.py $DAEMON_PIDS
Failure immediately after accept() should yield connection related error message
$ hg --config badserver.closeafteraccept=true serve -p $HGPORT -d --pid-file=hg.pid
$ cat hg.pid > $DAEMON_PIDS
Augie Fackler
tests: work around flaky test failure on FreeBSD and relatives...
r32064 TODO: this usually outputs good results, but sometimes emits abort:
error: '' on FreeBSD and OS X.
What we ideally want are:
abort: error: Connection reset by peer (no-windows !)
abort: error: An existing connection was forcibly closed by the remote host (windows !)
The flakiness in this output was observable easily with
--runs-per-test=20 on macOS 10.12 during the freeze for 4.2.
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 $ hg clone http://localhost:$HGPORT/ clone
Augie Fackler
tests: work around flaky test failure on FreeBSD and relatives...
r32064 abort: error: * (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
Failure to read all bytes in initial HTTP request should yield connection related error message
$ hg --config badserver.closeafterrecvbytes=1 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
TODO this error message is not very good
$ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 abort: error: ''
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(1 from 65537) -> (1) G
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
$ rm -f error.log
Same failure, but server reads full HTTP request line
$ hg --config badserver.closeafterrecvbytes=40 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 abort: error: ''
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(40 from 65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(7 from -1) -> (7) Accept-
read limit reached; closing socket
$ rm -f error.log
Failure on subsequent HTTP request on the same socket (cmd?batch)
$ hg --config badserver.closeafterrecvbytes=210 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 abort: error: ''
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(210 from 65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(177 from -1) -> (27) Accept-Encoding: identity\r\n
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 readline(150 from -1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(115 from -1) -> (2?) host: localhost:$HGPORT\r\n (glob)
readline(9? from -1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n (glob)
readline(4? from -1) -> (2) \r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 write(36) -> HTTP/1.1 200 Script output follows\r\n
write(23) -> Server: badhttpserver\r\n
write(37) -> Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41) -> Content-Type: application/mercurial-0.1\r\n
write(21) -> Content-Length: 405\r\n
write(2) -> \r\n
write(405) -> lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
test-http-bad-server: match different in output...
r32320 readline(4? from 65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n (glob)
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(1? from -1) -> (1?) Accept-Encoding* (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(210 from 65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(184 from -1) -> (27) Accept-Encoding: identity\r\n
readline(157 from -1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(128 from -1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(87 from -1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(39 from -1) -> (35) accept: application/mercurial-0.1\r\n
readline(4 from -1) -> (4) host
read limit reached; closing socket
$ rm -f error.log
Failure to read getbundle HTTP request
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 $ hg --config badserver.closeafterrecvbytes=292 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 $ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 abort: error: ''
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(292 from 65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 readline(259 from -1) -> (27) Accept-Encoding: identity\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(232 from -1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(197 from -1) -> (2?) host: localhost:$HGPORT\r\n (glob)
readline(17? from -1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n (glob)
readline(12? from -1) -> (2) \r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 write(36) -> HTTP/1.1 200 Script output follows\r\n
write(23) -> Server: badhttpserver\r\n
write(37) -> Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41) -> Content-Type: application/mercurial-0.1\r\n
write(21) -> Content-Length: 405\r\n
write(2) -> \r\n
write(405) -> lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline\(12[34] from 65537\) -> \(2[67]\) GET /\?cmd=batch HTTP/1.1\\r\\n (re)
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(9? from -1) -> (27) Accept-Encoding: identity\r\n (glob)
readline(7? from -1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n (glob)
readline(4? from -1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n (glob)
readline(1 from -1) -> (1) x (?)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(292 from 65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 readline(266 from -1) -> (27) Accept-Encoding: identity\r\n
readline(239 from -1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(210 from -1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(169 from -1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(121 from -1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(86 from -1) -> (2?) host: localhost:$HGPORT\r\n (glob)
readline(6? from -1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n (glob)
readline(1? from -1) -> (2) \r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 write(36) -> HTTP/1.1 200 Script output follows\r\n
write(23) -> Server: badhttpserver\r\n
write(37) -> Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41) -> Content-Type: application/mercurial-0.1\r\n
write(20) -> Content-Length: 42\r\n
write(2) -> \r\n
write(42) -> 96ee1d7354c4ad7372047672c36a1f561e3a6a4c\n;
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline\(1[23] from 65537\) -> \(1[23]\) GET /\?cmd=ge.? (re)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(292 from 65537) -> (30) GET /?cmd=getbundle HTTP/1.1\r\n
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 readline(262 from -1) -> (27) Accept-Encoding: identity\r\n
readline(235 from -1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(206 from -1) -> (206) x-hgarg-1: bundlecaps=HG20%2Cbundle2%3DHG20%250Achangegroup%253D01%252C02%250Adigests%253Dmd5%252Csha1%252Csha512%250Aerror%253Dabort%252Cunsupportedcontent%252Cpushraced%252Cpushkey%250Ahgtagsfnodes%250Ali
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
$ rm -f error.log
Now do a variation using POST to send arguments
$ hg --config experimental.httppostargs=true --config badserver.closeafterrecvbytes=315 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 abort: error: ''
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(315 from 65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(282 from -1) -> (27) Accept-Encoding: identity\r\n
Gregory Szorc
httppeer: don't send empty Vary request header...
r32022 readline(255 from -1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(220 from -1) -> (2?) host: localhost:$HGPORT\r\n (glob)
readline(19? from -1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n (glob)
readline(14? from -1) -> (2) \r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 write(36) -> HTTP/1.1 200 Script output follows\r\n
write(23) -> Server: badhttpserver\r\n
write(37) -> Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41) -> Content-Type: application/mercurial-0.1\r\n
write(21) -> Content-Length: 418\r\n
write(2) -> \r\n
write(418) -> lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httppostargs httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline\(14[67] from 65537\) -> \(2[67]\) POST /\?cmd=batch HTTP/1.1\\r\\n (re)
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline\(1(19|20) from -1\) -> \(27\) Accept-Encoding: identity\\r\\n (re)
readline(9? from -1) -> (41) content-type: application/mercurial-0.1\r\n (glob)
readline(5? from -1) -> (19) vary: X-HgProto-1\r\n (glob)
readline(3? from -1) -> (19) x-hgargs-post: 28\r\n (glob)
readline(1? from -1) -> (1?) x-hgproto-1: * (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached; closing socket
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(315 from 65537) -> (27) POST /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(288 from -1) -> (27) Accept-Encoding: identity\r\n
readline(261 from -1) -> (41) content-type: application/mercurial-0.1\r\n
readline(220 from -1) -> (19) vary: X-HgProto-1\r\n
readline(201 from -1) -> (19) x-hgargs-post: 28\r\n
readline(182 from -1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(134 from -1) -> (35) accept: application/mercurial-0.1\r\n
readline(99 from -1) -> (20) content-length: 28\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(79 from -1) -> (2?) host: localhost:$HGPORT\r\n (glob)
readline(5? from -1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n (glob)
readline(? from -1) -> (2) \r\n (glob)
read(? from 28) -> (?) cmds=* (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 read limit reached, closing socket
write(36) -> HTTP/1.1 500 Internal Server Error\r\n
$ rm -f error.log
Now move on to partial server responses
Server sends a single character from the HTTP response line
$ hg --config badserver.closeaftersendbytes=1 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
abort: error: H
[255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(1 from 36) -> (0) H
write limit reached; closing socket
write(36) -> HTTP/1.1 500 Internal Server Error\r\n
$ rm -f error.log
Server sends an incomplete capabilities response body
$ hg --config badserver.closeaftersendbytes=180 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 $ hg clone http://localhost:$HGPORT/ clone
abort: HTTP request error (incomplete response; expected 385 bytes got 20)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
[255]
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (144) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (121) Server: badhttpserver\r\n
write(37 from 37) -> (84) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (43) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (22) Content-Length: 405\r\n
write(2 from 2) -> (20) \r\n
write(20 from 405) -> (0) lookup changegroupsu
write limit reached; closing socket
$ rm -f error.log
Server sends incomplete headers for batch request
$ hg --config badserver.closeaftersendbytes=695 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
TODO this output is horrible
$ hg clone http://localhost:$HGPORT/ clone
abort: 'http://localhost:$HGPORT/' does not appear to be an hg repository:
---%<--- (application/mercuria)
---%<---
!
[255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (659) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (636) Server: badhttpserver\r\n
write(37 from 37) -> (599) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (558) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (537) Content-Length: 405\r\n
write(2 from 2) -> (535) \r\n
write(405 from 405) -> (130) lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (94) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (71) Server: badhttpserver\r\n
write(37 from 37) -> (34) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(34 from 41) -> (0) Content-Type: application/mercuria
write limit reached; closing socket
write(36) -> HTTP/1.1 500 Internal Server Error\r\n
$ rm -f error.log
Server sends an incomplete HTTP response body to batch request
$ hg --config badserver.closeaftersendbytes=760 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
TODO client spews a stack due to uncaught ValueError in batch.results()
$ hg clone http://localhost:$HGPORT/ clone 2> /dev/null
[1]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (724) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (701) Server: badhttpserver\r\n
write(37 from 37) -> (664) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (623) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (602) Content-Length: 405\r\n
write(2 from 2) -> (600) \r\n
write(405 from 405) -> (195) lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (159) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (136) Server: badhttpserver\r\n
write(37 from 37) -> (99) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (58) Content-Type: application/mercurial-0.1\r\n
write(20 from 20) -> (38) Content-Length: 42\r\n
write(2 from 2) -> (36) \r\n
write(36 from 42) -> (0) 96ee1d7354c4ad7372047672c36a1f561e3a
write limit reached; closing socket
$ rm -f error.log
Server sends incomplete headers for getbundle response
$ hg --config badserver.closeaftersendbytes=895 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
TODO this output is terrible
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
abort: 'http://localhost:$HGPORT/' does not appear to be an hg repository:
---%<--- (application/mercuri)
---%<---
!
[255]
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (859) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (836) Server: badhttpserver\r\n
write(37 from 37) -> (799) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (758) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (737) Content-Length: 405\r\n
write(2 from 2) -> (735) \r\n
write(405 from 405) -> (330) lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (294) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (271) Server: badhttpserver\r\n
write(37 from 37) -> (234) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (193) Content-Type: application/mercurial-0.1\r\n
write(20 from 20) -> (173) Content-Length: 42\r\n
write(2 from 2) -> (171) \r\n
write(42 from 42) -> (129) 96ee1d7354c4ad7372047672c36a1f561e3a6a4c\n;
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (30) GET /?cmd=getbundle HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (396) x-hgarg-1: bundlecaps=HG20%2Cbundle2%3DHG20%250Achangegroup%253D01%252C02%250Adigests%253Dmd5%252Csha1%252Csha512%250Aerror%253Dabort%252Cunsupportedcontent%252Cpushraced%252Cpushkey%250Ahgtagsfnodes%250Alistkeys%250Apushkey%250Aremote-changegroup%253Dhttp%252Chttps&cg=1&common=0000000000000000000000000000000000000000&heads=96ee1d7354c4ad7372047672c36a1f561e3a6a4c&listkeys=phases%2Cbookmarks\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (93) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (70) Server: badhttpserver\r\n
write(37 from 37) -> (33) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(33 from 41) -> (0) Content-Type: application/mercuri
write limit reached; closing socket
write(36) -> HTTP/1.1 500 Internal Server Error\r\n
$ rm -f error.log
Server sends empty HTTP body for getbundle
$ hg --config badserver.closeaftersendbytes=933 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 $ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
[255]
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (897) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (874) Server: badhttpserver\r\n
write(37 from 37) -> (837) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (796) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (775) Content-Length: 405\r\n
write(2 from 2) -> (773) \r\n
write(405 from 405) -> (368) lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (332) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (309) Server: badhttpserver\r\n
write(37 from 37) -> (272) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (231) Content-Type: application/mercurial-0.1\r\n
write(20 from 20) -> (211) Content-Length: 42\r\n
write(2 from 2) -> (209) \r\n
write(42 from 42) -> (167) 96ee1d7354c4ad7372047672c36a1f561e3a6a4c\n;
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (30) GET /?cmd=getbundle HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (396) x-hgarg-1: bundlecaps=HG20%2Cbundle2%3DHG20%250Achangegroup%253D01%252C02%250Adigests%253Dmd5%252Csha1%252Csha512%250Aerror%253Dabort%252Cunsupportedcontent%252Cpushraced%252Cpushkey%250Ahgtagsfnodes%250Alistkeys%250Apushkey%250Aremote-changegroup%253Dhttp%252Chttps&cg=1&common=0000000000000000000000000000000000000000&heads=96ee1d7354c4ad7372047672c36a1f561e3a6a4c&listkeys=phases%2Cbookmarks\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (131) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (108) Server: badhttpserver\r\n
write(37 from 37) -> (71) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (30) Content-Type: application/mercurial-0.2\r\n
write(28 from 28) -> (2) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (0) \r\n
write limit reached; closing socket
write(36) -> HTTP/1.1 500 Internal Server Error\r\n
$ rm -f error.log
Server sends partial compression string
$ hg --config badserver.closeaftersendbytes=945 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 $ hg clone http://localhost:$HGPORT/ clone
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response; expected 1 bytes got 3)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
[255]
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001
$ killdaemons.py $DAEMON_PIDS
$ cat error.log
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (33) GET /?cmd=capabilities HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (909) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (886) Server: badhttpserver\r\n
write(37 from 37) -> (849) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (808) Content-Type: application/mercurial-0.1\r\n
write(21 from 21) -> (787) Content-Length: 405\r\n
write(2 from 2) -> (785) \r\n
write(405 from 405) -> (380) lookup changegroupsubset branchmap pushkey known getbundle unbundlehash batch streamreqs=generaldelta,revlogv1 bundle2=HG20%0Achangegroup%3D01%2C02%0Adigests%3Dmd5%2Csha1%2Csha512%0Aerror%3Dabort%2Cunsupportedcontent%2Cpushraced%2Cpushkey%0Ahgtagsfnodes%0Alistkeys%0Apushkey%0Aremote-changegroup%3Dhttp%2Chttps unbundle=HG10GZ,HG10BZ,HG10UN httpheader=1024 httpmediatype=0.1rx,0.1tx,0.2tx compression=none
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (26) GET /?cmd=batch HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (41) x-hgarg-1: cmds=heads+%3Bknown+nodes%3D\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (344) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (321) Server: badhttpserver\r\n
write(37 from 37) -> (284) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (243) Content-Type: application/mercurial-0.1\r\n
write(20 from 20) -> (223) Content-Length: 42\r\n
write(2 from 2) -> (221) \r\n
write(42 from 42) -> (179) 96ee1d7354c4ad7372047672c36a1f561e3a6a4c\n;
Gregory Szorc
tests: remove regular expression matching for Python 2.6...
r32282 readline(65537) -> (30) GET /?cmd=getbundle HTTP/1.1\r\n
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (27) Accept-Encoding: identity\r\n
readline(-1) -> (29) vary: X-HgArg-1,X-HgProto-1\r\n
readline(-1) -> (396) x-hgarg-1: bundlecaps=HG20%2Cbundle2%3DHG20%250Achangegroup%253D01%252C02%250Adigests%253Dmd5%252Csha1%252Csha512%250Aerror%253Dabort%252Cunsupportedcontent%252Cpushraced%252Cpushkey%250Ahgtagsfnodes%250Alistkeys%250Apushkey%250Aremote-changegroup%253Dhttp%252Chttps&cg=1&common=0000000000000000000000000000000000000000&heads=96ee1d7354c4ad7372047672c36a1f561e3a6a4c&listkeys=phases%2Cbookmarks\r\n
readline(-1) -> (48) x-hgproto-1: 0.1 0.2 comp=zstd,zlib,none,bzip2\r\n
readline(-1) -> (35) accept: application/mercurial-0.1\r\n
Pierre-Yves David
test: glob out variation from 'HGPORT' length...
r32090 readline(-1) -> (2?) host: localhost:$HGPORT\r\n (glob)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 readline(-1) -> (49) user-agent: mercurial/proto-1.0 (Mercurial 4.2)\r\n
readline(-1) -> (2) \r\n
write(36 from 36) -> (143) HTTP/1.1 200 Script output follows\r\n
write(23 from 23) -> (120) Server: badhttpserver\r\n
write(37 from 37) -> (83) Date: Fri, 14 Apr 2017 00:00:00 GMT\r\n
write(41 from 41) -> (42) Content-Type: application/mercurial-0.2\r\n
write(28 from 28) -> (14) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (12) \r\n
write(6 from 6) -> (6) 1\\r\\n\x04\\r\\n (esc)
write(6 from 9) -> (0) 4\r\nnon
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server sends partial bundle2 header magic
$ hg --config badserver.closeaftersendbytes=954 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response; expected 1 bytes got 3)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -7 error.log
write(28 from 28) -> (23) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (21) \r\n
write(6 from 6) -> (15) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (6) 4\r\nnone\r\n
write(6 from 9) -> (0) 4\r\nHG2
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server sends incomplete bundle2 stream params length
$ hg --config badserver.closeaftersendbytes=963 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response; expected 1 bytes got 3)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -8 error.log
write(28 from 28) -> (32) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (30) \r\n
write(6 from 6) -> (24) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (15) 4\r\nnone\r\n
write(9 from 9) -> (6) 4\r\nHG20\r\n
write(6 from 9) -> (0) 4\\r\\n\x00\x00\x00 (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Servers stops after bundle2 stream params header
$ hg --config badserver.closeaftersendbytes=966 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -8 error.log
write(28 from 28) -> (35) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (33) \r\n
write(6 from 6) -> (27) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (18) 4\r\nnone\r\n
write(9 from 9) -> (9) 4\r\nHG20\r\n
write(9 from 9) -> (0) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops sending after bundle2 part header length
$ hg --config badserver.closeaftersendbytes=975 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -9 error.log
write(28 from 28) -> (44) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (42) \r\n
write(6 from 6) -> (36) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (27) 4\r\nnone\r\n
write(9 from 9) -> (18) 4\r\nHG20\r\n
write(9 from 9) -> (9) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (0) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops sending after bundle2 part header
$ hg --config badserver.closeaftersendbytes=1022 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
transaction abort!
rollback completed
Gregory Szorc
bundle2: ignore errors seeking a bundle after an exception (issue4784)...
r32024 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -10 error.log
write(28 from 28) -> (91) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (89) \r\n
write(6 from 6) -> (83) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (74) 4\r\nnone\r\n
write(9 from 9) -> (65) 4\r\nHG20\r\n
write(9 from 9) -> (56) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (47) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (0) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops after bundle2 part payload chunk size
$ hg --config badserver.closeaftersendbytes=1031 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
transaction abort!
rollback completed
Gregory Szorc
bundle2: ignore errors seeking a bundle after an exception (issue4784)...
r32024 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -11 error.log
write(28 from 28) -> (100) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (98) \r\n
write(6 from 6) -> (92) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (83) 4\r\nnone\r\n
write(9 from 9) -> (74) 4\r\nHG20\r\n
write(9 from 9) -> (65) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (56) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (9) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write(9 from 9) -> (0) 4\\r\\n\x00\x00\x01\xd2\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops sending in middle of bundle2 payload chunk
$ hg --config badserver.closeaftersendbytes=1504 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
transaction abort!
rollback completed
Gregory Szorc
bundle2: ignore errors seeking a bundle after an exception (issue4784)...
r32024 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -12 error.log
write(28 from 28) -> (573) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (571) \r\n
write(6 from 6) -> (565) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (556) 4\r\nnone\r\n
write(9 from 9) -> (547) 4\r\nHG20\r\n
write(9 from 9) -> (538) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (529) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (482) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write(9 from 9) -> (473) 4\\r\\n\x00\x00\x01\xd2\\r\\n (esc)
write(473 from 473) -> (0) 1d2\\r\\n\x00\x00\x00\xb2\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00>6a3df4de388f3c4f8e28f4f9a814299a3cbb5f50\\ntest\\n0 0\\nfoo\\n\\ninitial\x00\x00\x00\x00\x00\x00\x00\xa1j=\xf4\xde8\x8f<O\x8e(\xf4\xf9\xa8\x14)\x9a<\xbb_P\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00-foo\x00b80de5d138758541c5f05265ad144ab9fa86d1db\\n\x00\x00\x00\x00\x00\x00\x00\x07foo\x00\x00\x00h\xb8\\r\xe5\xd18u\x85A\xc5\xf0Re\xad\x14J\xb9\xfa\x86\xd1\xdb\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops sending after 0 length payload chunk size
$ hg --config badserver.closeaftersendbytes=1513 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
adding manifests
adding file changes
added 1 changesets with 1 changes to 1 files
transaction abort!
rollback completed
Gregory Szorc
httppeer: wrap HTTPResponse.read() globally...
r32002 abort: HTTP request error (incomplete response)
(this may be an intermittent network failure; if the error persists, consider contacting the network or server operator)
Gregory Szorc
tests: add tests for poorly behaving HTTP server...
r32001 [255]
$ killdaemons.py $DAEMON_PIDS
$ tail -13 error.log
write(28 from 28) -> (582) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (580) \r\n
write(6 from 6) -> (574) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (565) 4\r\nnone\r\n
write(9 from 9) -> (556) 4\r\nHG20\r\n
write(9 from 9) -> (547) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (538) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (491) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write(9 from 9) -> (482) 4\\r\\n\x00\x00\x01\xd2\\r\\n (esc)
write(473 from 473) -> (9) 1d2\\r\\n\x00\x00\x00\xb2\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00>6a3df4de388f3c4f8e28f4f9a814299a3cbb5f50\\ntest\\n0 0\\nfoo\\n\\ninitial\x00\x00\x00\x00\x00\x00\x00\xa1j=\xf4\xde8\x8f<O\x8e(\xf4\xf9\xa8\x14)\x9a<\xbb_P\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00-foo\x00b80de5d138758541c5f05265ad144ab9fa86d1db\\n\x00\x00\x00\x00\x00\x00\x00\x07foo\x00\x00\x00h\xb8\\r\xe5\xd18u\x85A\xc5\xf0Re\xad\x14J\xb9\xfa\x86\xd1\xdb\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (0) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
Server stops sending after 0 part bundle part header (indicating end of bundle2 payload)
This is before the 0 size chunked transfer part that signals end of HTTP response.
$ hg --config badserver.closeaftersendbytes=1710 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
adding manifests
adding file changes
added 1 changesets with 1 changes to 1 files
updating to branch default
1 files updated, 0 files merged, 0 files removed, 0 files unresolved
$ killdaemons.py $DAEMON_PIDS
$ tail -22 error.log
write(28 from 28) -> (779) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (777) \r\n
write(6 from 6) -> (771) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (762) 4\r\nnone\r\n
write(9 from 9) -> (753) 4\r\nHG20\r\n
write(9 from 9) -> (744) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (735) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (688) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write(9 from 9) -> (679) 4\\r\\n\x00\x00\x01\xd2\\r\\n (esc)
write(473 from 473) -> (206) 1d2\\r\\n\x00\x00\x00\xb2\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00>6a3df4de388f3c4f8e28f4f9a814299a3cbb5f50\\ntest\\n0 0\\nfoo\\n\\ninitial\x00\x00\x00\x00\x00\x00\x00\xa1j=\xf4\xde8\x8f<O\x8e(\xf4\xf9\xa8\x14)\x9a<\xbb_P\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00-foo\x00b80de5d138758541c5f05265ad144ab9fa86d1db\\n\x00\x00\x00\x00\x00\x00\x00\x07foo\x00\x00\x00h\xb8\\r\xe5\xd18u\x85A\xc5\xf0Re\xad\x14J\xb9\xfa\x86\xd1\xdb\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (197) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (188) 4\\r\\n\x00\x00\x00 \\r\\n (esc)
write(38 from 38) -> (150) 20\\r\\n\x08LISTKEYS\x00\x00\x00\x01\x01\x00 \x06namespacephases\\r\\n (esc)
write(9 from 9) -> (141) 4\\r\\n\x00\x00\x00:\\r\\n (esc)
write(64 from 64) -> (77) 3a\r\n96ee1d7354c4ad7372047672c36a1f561e3a6a4c 1\npublishing True\r\n
write(9 from 9) -> (68) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (59) 4\\r\\n\x00\x00\x00#\\r\\n (esc)
write(41 from 41) -> (18) 23\\r\\n\x08LISTKEYS\x00\x00\x00\x02\x01\x00 namespacebookmarks\\r\\n (esc)
write(9 from 9) -> (9) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (0) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
$ rm -rf clone
Server sends a size 0 chunked-transfer size without terminating \r\n
$ hg --config badserver.closeaftersendbytes=1713 serve -p $HGPORT -d --pid-file=hg.pid -E error.log
$ cat hg.pid > $DAEMON_PIDS
$ hg clone http://localhost:$HGPORT/ clone
requesting all changes
adding changesets
adding manifests
adding file changes
added 1 changesets with 1 changes to 1 files
updating to branch default
1 files updated, 0 files merged, 0 files removed, 0 files unresolved
$ killdaemons.py $DAEMON_PIDS
$ tail -23 error.log
write(28 from 28) -> (782) Transfer-Encoding: chunked\r\n
write(2 from 2) -> (780) \r\n
write(6 from 6) -> (774) 1\\r\\n\x04\\r\\n (esc)
write(9 from 9) -> (765) 4\r\nnone\r\n
write(9 from 9) -> (756) 4\r\nHG20\r\n
write(9 from 9) -> (747) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (738) 4\\r\\n\x00\x00\x00)\\r\\n (esc)
write(47 from 47) -> (691) 29\\r\\n\x0bCHANGEGROUP\x00\x00\x00\x00\x01\x01\x07\x02 \x01version02nbchanges1\\r\\n (esc)
write(9 from 9) -> (682) 4\\r\\n\x00\x00\x01\xd2\\r\\n (esc)
write(473 from 473) -> (209) 1d2\\r\\n\x00\x00\x00\xb2\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00>6a3df4de388f3c4f8e28f4f9a814299a3cbb5f50\\ntest\\n0 0\\nfoo\\n\\ninitial\x00\x00\x00\x00\x00\x00\x00\xa1j=\xf4\xde8\x8f<O\x8e(\xf4\xf9\xa8\x14)\x9a<\xbb_P\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00-foo\x00b80de5d138758541c5f05265ad144ab9fa86d1db\\n\x00\x00\x00\x00\x00\x00\x00\x07foo\x00\x00\x00h\xb8\\r\xe5\xd18u\x85A\xc5\xf0Re\xad\x14J\xb9\xfa\x86\xd1\xdb\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x96\xee\x1dsT\xc4\xadsr\x04vr\xc3j\x1fV\x1e:jL\x00\x00\x00\x00\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (200) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (191) 4\\r\\n\x00\x00\x00 \\r\\n (esc)
write(38 from 38) -> (153) 20\\r\\n\x08LISTKEYS\x00\x00\x00\x01\x01\x00 \x06namespacephases\\r\\n (esc)
write(9 from 9) -> (144) 4\\r\\n\x00\x00\x00:\\r\\n (esc)
write(64 from 64) -> (80) 3a\r\n96ee1d7354c4ad7372047672c36a1f561e3a6a4c 1\npublishing True\r\n
write(9 from 9) -> (71) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (62) 4\\r\\n\x00\x00\x00#\\r\\n (esc)
write(41 from 41) -> (21) 23\\r\\n\x08LISTKEYS\x00\x00\x00\x02\x01\x00 namespacebookmarks\\r\\n (esc)
write(9 from 9) -> (12) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(9 from 9) -> (3) 4\\r\\n\x00\x00\x00\x00\\r\\n (esc)
write(3 from 5) -> (0) 0\r\n
write limit reached; closing socket
write(27) -> 15\r\nInternal Server Error\r\n
$ rm -f error.log
$ rm -rf clone