Ticket #889: debug-log.txt

File debug-log.txt, 19.2 KB (added by francois, at 2010-01-10T22:34:05Z)

Debug log coming from 'flogtool tail' running during the error.

Line 
1Application versions (embedded in logfile):
2          Nevow: 0.9.33-r17222
3        Twisted: 8.1.0
4allmydata-tahoe: 1.5.0-r4174
5       argparse: 0.9.1
6       foolscap: 0.4.2
7       platform: Linux-debian_5.0.3-i686-32bit
8      pyOpenSSL: 0.7
9     pycryptopp: 0.5.15
10       pysqlite: 2.3.2
11         python: 2.5.2
12         pyutil: 1.3.34
13     setuptools: 0.6c12dev
14     simplejson: 1.9.2
15         sqlite: 3.5.9
16        twisted: 8.1.0
17        zbase32: 1.1.1
18           zfec: 1.4.5
19 zope.interface: 3.3.1
20PID: 31071
21
22s3iqpt6a#1021377 20:08:19.130: web: 127.0.0.1 PUT /uri/[CENSORED].. 200 55
23s3iqpt6a#1021378 20:08:19.325: CHKUploader starting
24s3iqpt6a#1021379 20:08:19.325: starting upload of <allmydata.immutable.upload.EncryptAnUploadable instance at 0xbda18cc>
25s3iqpt6a#1021380 20:08:19.325: creating Encoder <Encoder for unknown storage index>
26s3iqpt6a#1021381 20:08:19.325: file size: 703
27s3iqpt6a#1021382 20:08:19.325: my encoding parameters: (2, 4, 5, 704)
28s3iqpt6a#1021383 20:08:19.325: got encoding parameters: 2/4/5 704
29s3iqpt6a#1021384 20:08:19.325: now setting up codec
30s3iqpt6a#1021385 20:08:19.325: using storage index dk3zi
31s3iqpt6a#1021386 20:08:19.326: <Tahoe2PeerSelector for upload dk3zi> starting
32s3iqpt6a#1021387 20:08:19.768: response from peer rkkkx6sk: alreadygot=(0,), allocated=()
33s3iqpt6a#1021388 20:08:19.796: response from peer jfkoivg7: alreadygot=(1,), allocated=()
34s3iqpt6a#1021389 20:08:19.835: response from peer tkxzeoh2: alreadygot=(2,), allocated=()
35s3iqpt6a#1021390 20:08:20.059: response from peer wpxpieqx: alreadygot=(3,), allocated=()
36s3iqpt6a#1021391 20:08:20.077: response from peer b5lefkbu: alreadygot=(4,), allocated=()
37s3iqpt6a#1021392 20:08:20.077: peer selection successful for <Tahoe2PeerSelector for upload dk3zi>: placed all 5 shares, sent 5 queries to 5 peers, 0 queries placed some shares, 5 placed none, got 0 errors
38s3iqpt6a#1021393 20:08:20.077: _send_shares, used_peers is set([])
39s3iqpt6a#1021394 20:08:20.077: <Encoder for dk3zi> starting
40s3iqpt6a#1021395 20:08:20.084: starting shareholders
41s3iqpt6a#1021396 20:08:20.097:  read_encrypted handling 352B-sized chunk
42s3iqpt6a#1021397 20:08:20.104:  read_encrypted handling 351B-sized chunk
43s3iqpt6a#1021398 20:08:20.104: send_segment(0)
44s3iqpt6a#1021399 20:08:20.105: <Encoder for dk3zi> uploaded 704 / 704 bytes (100%) of your file.
45s3iqpt6a#1021400 20:08:20.115: sending crypttext hash tree
46s3iqpt6a#1021401 20:08:20.115: sending block hash trees
47s3iqpt6a#1021402 20:08:20.116: sending all share hash trees
48s3iqpt6a#1021403 20:08:20.116: sending uri_extension
49s3iqpt6a#1021404 20:08:20.117: uri_extension_data is {'num_segments': 1, 'crypttext_hash': 'vja7oebqthhzu4uywfgcia2ekj4rqbatd62o6momocoeebskpsyq', 'tail_codec_params': '704-2-5', 'share_root_hash': 'nff64yd3t6jazwo7omu3nfemficjr2yp5a4zzgsnag57v6yekfsa', 'crypttext_root_hash': '42d3esyeeupugqizdcwqnl3fvscgqy7xvelyuh6d7zq3uxbhwvmq', 'codec_params': '704-2-5', 'codec_name': 'crs', 'total_shares': 5, 'needed_shares': 2, 'segment_size': 704, 'size': 703}
50s3iqpt6a#1021405 20:08:20.117: closing shareholders
51s3iqpt6a#1021406 20:08:20.117: upload done
52s3iqpt6a#1021407 20:08:20.119: web: 127.0.0.1 PUT /uri/[CENSORED].. 200 95
53s3iqpt6a#1021408 20:08:20.350: CHKUploader starting
54s3iqpt6a#1021409 20:08:20.350: starting upload of <allmydata.immutable.upload.EncryptAnUploadable instance at 0xa496d8c>
55s3iqpt6a#1021410 20:08:20.350: creating Encoder <Encoder for unknown storage index>
56s3iqpt6a#1021411 20:08:20.351: file size: 1998
57s3iqpt6a#1021412 20:08:20.351: my encoding parameters: (2, 4, 5, 1998)
58s3iqpt6a#1021413 20:08:20.351: got encoding parameters: 2/4/5 1998
59s3iqpt6a#1021414 20:08:20.351: now setting up codec
60s3iqpt6a#1021415 20:08:20.351: using storage index dssph
61s3iqpt6a#1021416 20:08:20.351: <Tahoe2PeerSelector for upload dssph> starting
62s3iqpt6a#1021417 20:08:20.396: response from peer rkkkx6sk: alreadygot=(0,), allocated=()
63s3iqpt6a#1021418 20:08:20.411: response from peer b5lefkbu: alreadygot=(1,), allocated=()
64s3iqpt6a#1021419 20:08:20.424: response from peer jfkoivg7: alreadygot=(2,), allocated=()
65s3iqpt6a#1021420 20:08:21.086: response from peer tkxzeoh2: alreadygot=(3,), allocated=()
66s3iqpt6a#1021421 20:08:21.103: response from peer wpxpieqx: alreadygot=(4,), allocated=()
67s3iqpt6a#1021422 20:08:21.103: peer selection successful for <Tahoe2PeerSelector for upload dssph>: placed all 5 shares, sent 5 queries to 5 peers, 0 queries placed some shares, 5 placed none, got 0 errors
68s3iqpt6a#1021423 20:08:21.103: _send_shares, used_peers is set([])
69s3iqpt6a#1021424 20:08:21.103: <Encoder for dssph> starting
70s3iqpt6a#1021425 20:08:21.111: starting shareholders
71s3iqpt6a#1021426 20:08:21.123:  read_encrypted handling 999B-sized chunk
72s3iqpt6a#1021427 20:08:21.146:  read_encrypted handling 999B-sized chunk
73s3iqpt6a#1021428 20:08:21.146: closed hash [0]: 1998B
74s3iqpt6a#1021429 20:08:21.146: plaintext leaf hash [0] is ozjpel2bo5ewdrx64fvwrzpc456rie76bxizrfnnscoezwd5ynga
75s3iqpt6a#1021430 20:08:21.146: send_segment(0)
76s3iqpt6a#1021431 20:08:21.147: <Encoder for dssph> uploaded 1998 / 1998 bytes (100%) of your file.
77s3iqpt6a#1021432 20:08:21.162: sending crypttext hash tree
78s3iqpt6a#1021433 20:08:21.162: sending block hash trees
79s3iqpt6a#1021434 20:08:21.162: sending all share hash trees
80s3iqpt6a#1021435 20:08:21.163: sending uri_extension
81s3iqpt6a#1021436 20:08:21.164: uri_extension_data is {'num_segments': 1, 'crypttext_hash': 'aowmzidmuqvj2x467ahjsg7n4fcfa4ska64gcu5nd7tsdonowlza', 'tail_codec_params': '1998-2-5', 'share_root_hash': 'c5cxxj2vui3mbwobxr7a2phryujq7xerjkzh2mgpu44nbwym3luq', 'crypttext_root_hash': '7zlidgduvrhgon4752znt7ynkb2cteo4naqk7rcccj5s2aj2i4bq', 'codec_params': '1998-2-5', 'codec_name': 'crs', 'total_shares': 5, 'needed_shares': 2, 'segment_size': 1998, 'size': 1998}
82s3iqpt6a#1021437 20:08:21.164: closing shareholders
83s3iqpt6a#1021438 20:08:21.164: upload done
84s3iqpt6a#1021439 20:08:21.166: web: 127.0.0.1 PUT /uri/[CENSORED].. 200 96
85s3iqpt6a#1021440 20:08:21.168: connection to wpxp lost
86s3iqpt6a#1021441 20:08:21.168: Stopping factory <foolscap.negotiate.TubConnectorClientFactory object [from s3iqpt6a] [to wpxpieqx] at 0xa689d2c>
87s3iqpt6a#1021442 20:08:21.193: an outbound callRemote (that we [s3iq] sent to someone else [wpxp]) failed on the far end
88s3iqpt6a#1021443 20:08:21.193:  reqID=18418, rref=<RemoteReference at 0xb973eac [pb://wpxpieqxcuprywpb2haw6gkztmefrgcn@1.2.3.4:43672,127.0.0.1:43672/x7xsfugyxo37afkvf7zpqfjt3pc7h7el]>, methname=RIStorageServer.tahoe.allmydata.com.add_lease
89s3iqpt6a#1021444 20:08:21.193:  the REMOTE failure was:
90 FAILURE:
91 [CopiedFailure instance: Traceback from remote host -- Traceback (most recent call last):
92 Failure: foolscap.ipb.DeadReferenceError: Connection was lost
93 ]
94s3iqpt6a#1021445 20:08:21.193: {'level': 30, 'format': 'local error in add_lease to [%(peerid)s]: %(f_value)s', 'failure': <twisted.python.failure.Failure <class 'foolscap.ipb.DeadReferenceError'>>, 'f_value': 'Connection was lost', 'peerid': 'wpxpieqx', 'umid': 'hEGuQg'}
95s3iqpt6a#1021446 20:08:21.196: an outbound callRemote (that we [s3iq] sent to someone else [wpxp]) failed on the far end
96s3iqpt6a#1021447 20:08:21.196:  reqID=18419, rref=<RemoteReference at 0xb973eac [pb://wpxpieqxcuprywpb2haw6gkztmefrgcn@1.2.3.4:43672,127.0.0.1:43672/x7xsfugyxo37afkvf7zpqfjt3pc7h7el]>, methname=RIStorageServer.tahoe.allmydata.com.get_buckets
97s3iqpt6a#1021448 20:08:21.196:  the REMOTE failure was:
98 FAILURE:
99 [CopiedFailure instance: Traceback from remote host -- Traceback (most recent call last):
100 Failure: foolscap.ipb.DeadReferenceError: Connection was lost
101 ]
102s3iqpt6a#1021449 20:08:21.196: <Checker #23635>(kzxdquqg6uvk): failure from server on 'get_buckets' the REMOTE failure was:
103 FAILURE:
104 [CopiedFailure instance: Traceback from remote host -- Traceback (most recent call last):
105 Failure: foolscap.ipb.DeadReferenceError: Connection was lost
106 ]
107s3iqpt6a#1021450 20:08:21.196: lost connection to wpxpieqx
108s3iqpt6a#1021451 20:08:21.197: Unhandled error in Deferred:
109s3iqpt6a#1021452 20:08:21.198: Unhandled Error
110Traceback (most recent call last):
111  File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/eventual.py", line 26, in _turn
112    cb(*args, **kwargs)
113  File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/call.py", line 90, in fail
114    self.deferred.errback(why)
115  File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 269, in errback
116    self._startRunCallbacks(fail)
117  File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 312, in _startRunCallbacks
118    self._runCallbacks()
119--- <exception caught here> ---
120  File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 328, in _runCallbacks
121    self.result = callback(self.result, *args, **kw)
122  File "/home/francois/dev/tahoe/src/allmydata/immutable/checker.py", line 123, in _add_lease_failed
123    level=log.WEIRD, umid="hEGuQg")
124  File "/home/francois/dev/tahoe/src/allmydata/util/log.py", line 31, in err
125    return log.err(*args, **kwargs)
126  File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/logging/log.py", line 218, in err
127    _stuff = failure.Failure()
128  File "/usr/lib/python2.5/site-packages/twisted/python/failure.py", line 174, in __init__
129    raise NoCurrentExceptionError()
130twisted.python.failure.NoCurrentExceptionError:
131
132 FAILURE:
133 [CopiedFailure instance: Traceback from remote host -- Traceback (most recent call last):
134   File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/eventual.py", line 26, in _turn
135     cb(*args, **kwargs)
136   File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/call.py", line 90, in fail
137     self.deferred.errback(why)
138   File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 269, in errback
139     self._startRunCallbacks(fail)
140   File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 312, in _startRunCallbacks
141     self._runCallbacks()
142 --- <exception caught here> ---
143   File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 328, in _runCallbacks
144     self.result = callback(self.result, *args, **kw)
145   File "/home/francois/dev/tahoe/src/allmydata/immutable/checker.py", line 123, in _add_lease_failed
146     level=log.WEIRD, umid="hEGuQg")
147   File "/home/francois/dev/tahoe/src/allmydata/util/log.py", line 31, in err
148     return log.err(*args, **kwargs)
149   File "/home/francois/dev/tahoe/support/lib/python2.5/site-packages/foolscap-0.4.2-py2.5.egg/foolscap/logging/log.py", line 218, in err
150     _stuff = failure.Failure()
151   File "/usr/lib/python2.5/site-packages/twisted/python/failure.py", line 174, in __init__
152     raise NoCurrentExceptionError()
153 twisted.python.failure.NoCurrentExceptionError:
154 ]
155s3iqpt6a#1021453 20:08:21.205: <Repairer #1>(kzxdq): starting repair
156s3iqpt6a#1021454 20:08:21.205: CHKUploader starting
157s3iqpt6a#1021455 20:08:21.205: starting upload of <DownUpConnector #1>
158s3iqpt6a#1021456 20:08:21.205: creating Encoder <Encoder for unknown storage index>
159s3iqpt6a#1021457 20:08:21.205: <CiphertextDownloader #1>(kzxdquqg6uvk): starting download
160s3iqpt6a#1021458 20:08:21.205: sending DYHB to [b5lefkbu]
161s3iqpt6a#1021459 20:08:21.206: sending DYHB to [jfkoivg7]
162s3iqpt6a#1021460 20:08:21.207: sending DYHB to [rkkkx6sk]
163s3iqpt6a#1021461 20:08:21.208: sending DYHB to [tkxzeoh2]
164s3iqpt6a#1021462 20:08:21.233: got results from [b5lefkbu]: shnums [1]
165s3iqpt6a#1021463 20:08:21.237: got results from [jfkoivg7]: shnums [2]
166s3iqpt6a#1021464 20:08:21.260: got results from [rkkkx6sk]: shnums [3]
167s3iqpt6a#1021465 20:08:21.263: got results from [tkxzeoh2]: shnums [4]
168s3iqpt6a#1021466 20:08:21.381: <CiphertextDownloader #1>(kzxdquqg6uvk): downloading seg#0 of 1 (0%)
169s3iqpt6a#1021467 20:08:21.381: <CiphertextDownloader #1>(kzxdquqg6uvk): starting segment 0
170s3iqpt6a#1021468 20:08:21.382: <BlockDownloader #1>(<ValidatedReadBucketProxy #1>-1): get_block(segnum=0)
171s3iqpt6a#1021469 20:08:21.383: <BlockDownloader #2>(<ValidatedReadBucketProxy #2>-2): get_block(segnum=0)
172s3iqpt6a#1021470 20:08:21.408: <BlockDownloader #1>(<ValidatedReadBucketProxy #1>-1): got block
173s3iqpt6a#1021471 20:08:21.418: <ImmutableFileNode #70028>(URI:CHK-Verifier:dssphylnsjav55lgpjm3i6g4ta:kgv3chjgnsvysx2e76nszaqnv7stav2ccwxgfx4nkx4uaclhnsyq:2:5:1998): starting
174s3iqpt6a#1021472 20:08:21.419: <ImmutableFileNode #70029>(URI:CHK-Verifier:dk3zitpvgm6woeay47l5r6h7gy:pht5cin6mdeobnp7g2lyoxxe53tuh66hftfin6tzu4ilojwwx6hq:2:5:703): starting
175s3iqpt6a#1021473 20:08:21.421: CHKUploader starting
176s3iqpt6a#1021474 20:08:21.421: starting upload of <allmydata.immutable.upload.EncryptAnUploadable instance at 0xb95b08c>
177s3iqpt6a#1021475 20:08:21.421: creating Encoder <Encoder for unknown storage index>
178s3iqpt6a#1021476 20:08:21.422: file size: 876
179s3iqpt6a#1021477 20:08:21.422: my encoding parameters: (2, 4, 5, 876)
180s3iqpt6a#1021478 20:08:21.422: got encoding parameters: 2/4/5 876
181s3iqpt6a#1021479 20:08:21.422: now setting up codec
182s3iqpt6a#1021480 20:08:21.422: using storage index ohhtd
183s3iqpt6a#1021481 20:08:21.422: <Tahoe2PeerSelector for upload ohhtd> starting
184s3iqpt6a#1021482 20:08:21.446: <BlockDownloader #2>(<ValidatedReadBucketProxy #2>-2): got block
185s3iqpt6a#1021483 20:08:21.446: <CiphertextDownloader #1>(kzxdquqg6uvk): download done
186s3iqpt6a#1021484 20:08:21.469: file size: 213
187s3iqpt6a#1021485 20:08:21.469: got encoding parameters: 2/5/5 214
188s3iqpt6a#1021486 20:08:21.469: now setting up codec
189s3iqpt6a#1021487 20:08:21.469: using storage index kzxdq
190s3iqpt6a#1021488 20:08:21.470: <Tahoe2PeerSelector for upload kzxdq> starting
191s3iqpt6a#1021489 20:08:21.477: response from peer rkkkx6sk: alreadygot=(), allocated=(0,)
192s3iqpt6a#1021490 20:08:21.523: response from peer b5lefkbu: alreadygot=(1,), allocated=(0,)
193s3iqpt6a#1021491 20:08:21.527: response from peer b5lefkbu: alreadygot=(), allocated=(1,)
194s3iqpt6a#1021492 20:08:21.571: response from peer jfkoivg7: alreadygot=(2,), allocated=()
195s3iqpt6a#1021493 20:08:21.574: response from peer jfkoivg7: alreadygot=(), allocated=(2,)
196s3iqpt6a#1021494 20:08:21.587: response from peer rkkkx6sk: alreadygot=(3,), allocated=()
197s3iqpt6a#1021495 20:08:21.604: response from peer tkxzeoh2: alreadygot=(), allocated=(3,)
198s3iqpt6a#1021496 20:08:21.604: starting second pass
199s3iqpt6a#1021497 20:08:21.610: response from peer tkxzeoh2: alreadygot=(4,), allocated=()
200s3iqpt6a#1021498 20:08:21.610: peer selection successful for <Tahoe2PeerSelector for upload kzxdq>: placed all 5 shares, sent 4 queries to 4 peers, 1 queries placed some shares, 3 placed none, got 0 errors
201s3iqpt6a#1021499 20:08:21.611: _send_shares, used_peers is set([<PeerTracker for peer b5lefkbu and SI kzxdq>])
202s3iqpt6a#1021500 20:08:21.611: <Encoder for kzxdq> starting
203s3iqpt6a#1021501 20:08:21.622: starting shareholders
204s3iqpt6a#1021502 20:08:21.624: send_segment(0)
205s3iqpt6a#1021503 20:08:21.624: put_block to <WriteBucketProxy for node b5lefkbuqiessl2ypd3u2fgkgm72digb>
206s3iqpt6a#1021504 20:08:21.625: put_block done
207s3iqpt6a#1021505 20:08:21.625: <Encoder for kzxdq> uploaded 214 / 214 bytes (100%) of your file.
208s3iqpt6a#1021506 20:08:21.627: response from peer rkkkx6sk: alreadygot=(), allocated=(4,)
209s3iqpt6a#1021507 20:08:21.627: peer selection successful for <Tahoe2PeerSelector for upload ohhtd>: placed all 5 shares, sent 5 queries to 4 peers, 5 queries placed some shares, 0 placed none, got 0 errors
210s3iqpt6a#1021508 20:08:21.628: _send_shares, used_peers is set([<PeerTracker for peer jfkoivg7 and SI ohhtd>, <PeerTracker for peer b5lefkbu and SI ohhtd>, <PeerTracker for peer tkxzeoh2 and SI ohhtd>, <PeerTracker for peer rkkkx6sk and SI ohhtd>])
211s3iqpt6a#1021509 20:08:21.628: <Encoder for ohhtd> starting
212s3iqpt6a#1021510 20:08:21.648: sending crypttext hash tree
213s3iqpt6a#1021511 20:08:21.649: sending block hash trees
214s3iqpt6a#1021512 20:08:21.650: sending all share hash trees
215s3iqpt6a#1021513 20:08:21.652: sending uri_extension
216s3iqpt6a#1021514 20:08:21.652: uri_extension_data is {'num_segments': 1, 'crypttext_hash': 'qbi76a6smo4lwc4lzzguqvt3v7pwuzvg3velcetvac2k4zs24g3q', 'tail_codec_params': '214-2-5', 'share_root_hash': '2lcpwbnevfhrw56od2b2fhv3mdwsp5nblbvifzoajnlehvojxa6q', 'crypttext_root_hash': 'xhi3omqreclkz3rkesohd5hsyvix237jy2pactb5eymdfr2g7kea', 'codec_params': '214-2-5', 'codec_name': 'crs', 'total_shares': 5, 'needed_shares': 2, 'segment_size': 214, 'size': 213}
217s3iqpt6a#1021515 20:08:21.653: closing shareholders
218s3iqpt6a#1021516 20:08:21.654: starting shareholders
219s3iqpt6a#1021517 20:08:21.682:  read_encrypted handling 438B-sized chunk
220s3iqpt6a#1021518 20:08:21.684: upload done
221s3iqpt6a#1021519 20:08:21.719:  read_encrypted handling 438B-sized chunk
222s3iqpt6a#1021520 20:08:21.719: closed hash [0]: 876B
223s3iqpt6a#1021521 20:08:21.719: plaintext leaf hash [0] is penqgfgjnhpkrtrlc4yicnc7626bbyhviuiyvziwcysmfr5u7eda
224s3iqpt6a#1021522 20:08:21.719: send_segment(0)
225s3iqpt6a#1021523 20:08:21.720: put_block to <WriteBucketProxy for node rkkkx6skn6iyiccklt2qxmbwme3rl62g>
226s3iqpt6a#1021524 20:08:21.720: put_block done
227s3iqpt6a#1021525 20:08:21.721: put_block to <WriteBucketProxy for node b5lefkbuqiessl2ypd3u2fgkgm72digb>
228s3iqpt6a#1021526 20:08:21.721: put_block done
229s3iqpt6a#1021527 20:08:21.722: put_block to <WriteBucketProxy for node jfkoivg7meloi2534daclu46cyfho6jm>
230s3iqpt6a#1021528 20:08:21.722: put_block done
231s3iqpt6a#1021529 20:08:21.723: put_block to <WriteBucketProxy for node tkxzeoh2yqiybnjytqbzrcuxcnigtlrv>
232s3iqpt6a#1021530 20:08:21.723: put_block done
233s3iqpt6a#1021531 20:08:21.723: put_block to <WriteBucketProxy for node rkkkx6skn6iyiccklt2qxmbwme3rl62g>
234s3iqpt6a#1021532 20:08:21.724: put_block done
235s3iqpt6a#1021533 20:08:21.725: <Encoder for ohhtd> uploaded 876 / 876 bytes (100%) of your file.
236s3iqpt6a#1021534 20:08:21.750: sending crypttext hash tree
237s3iqpt6a#1021535 20:08:21.754: sending block hash trees
238s3iqpt6a#1021536 20:08:21.758: sending all share hash trees
239s3iqpt6a#1021537 20:08:21.763: sending uri_extension
240s3iqpt6a#1021538 20:08:21.764: uri_extension_data is {'num_segments': 1, 'crypttext_hash': 'z6llrl5zoa5tmhnqz3klupc2ucy54k7sx7r7etyvrihydeyeslxq', 'tail_codec_params': '876-2-5', 'share_root_hash': 'thyjahoaomnmky4d2sbnwieothyqnbpr7itth7njiamm2nlfi56a', 'crypttext_root_hash': 'vx3276oviqpqrjz6o5rzhfpxyil3hbfj5e6hp5ee3qwb3zat7mdq', 'codec_params': '876-2-5', 'codec_name': 'crs', 'total_shares': 5, 'needed_shares': 2, 'segment_size': 876, 'size': 876}
241s3iqpt6a#1021539 20:08:21.768: closing shareholders
242s3iqpt6a#1021540 20:08:21.814: <Repairer #2>(k4adt): starting repair
243s3iqpt6a#1021541 20:08:21.814: CHKUploader starting
244s3iqpt6a#1021542 20:08:21.814: starting upload of <DownUpConnector #2>
245s3iqpt6a#1021543 20:08:21.814: creating Encoder <Encoder for unknown storage index>
246s3iqpt6a#1021544 20:08:21.814: <CiphertextDownloader #2>(k4adtnc2r4rv): starting download
247s3iqpt6a#1021545 20:08:21.814: sending DYHB to [rkkkx6sk]
248s3iqpt6a#1021546 20:08:21.815: sending DYHB to [b5lefkbu]
249s3iqpt6a#1021547 20:08:21.816: sending DYHB to [tkxzeoh2]
250s3iqpt6a#1021548 20:08:21.817: sending DYHB to [jfkoivg7]
251s3iqpt6a#1021549 20:08:21.841: got results from [b5lefkbu]: shnums [1]
252s3iqpt6a#1021550 20:08:21.848: got results from [jfkoivg7]: shnums [4]
253s3iqpt6a#1021551 20:08:21.850: upload done
254s3iqpt6a#1021552 20:08:21.853: <ImmutableFileNode #70030>(URI:CHK-Verifier:ohhtdyu5gl2bbktjzc44orbi5y:kortxstcv6gdju55aq55ocuyttwrzcvr5nhtqllf4cciyn73cwdq:2:5:876): starting
255s3iqpt6a#1021553 20:08:21.854: web: 127.0.0.1 POST /uri/[CENSORED]..?t=mkdir-immutable 200 100