[tahoe-lafs-trac-stream] [Tahoe-LAFS] #4023: Integration tests aren't passing on Windows
Tahoe-LAFS
trac at tahoe-lafs.org
Wed May 3 21:16:12 UTC 2023
#4023: Integration tests aren't passing on Windows
----------------------+---------------------------------------
Reporter: itamarst | Owner:
Type: defect | Status: new
Priority: normal | Milestone: HTTP Storage Protocol
Component: unknown | Version: n/a
Keywords: | Launchpad Bug:
----------------------+---------------------------------------
E.g. https://github.com/tahoe-lafs/tahoe-
lafs/actions/runs/4863777261/jobs/8690340300
{{{
integration/test_web.py::test_status node3: 2023-05-03T13:21:51+0000 [-]
storage: get_buckets b'b4fpewqsvd22oi6pclnchfj6my'
alice: 2023-05-03T13:21:51+0000 [twisted.python.log#info] web: 127.0.0.1
GET /operations/something_random 200 418
2023-05-03T13:21:51+0000 [-] CHKUploader starting
2023-05-03T13:21:51+0000 [-] starting upload of
<allmydata.immutable.upload.EncryptAnUploadable object at
0x000001EF5DC8E130>
2023-05-03T13:21:51+0000 [-] creating Encoder <Encoder for unknown storage
index>
2023-05-03T13:21:51+0000 [-] file size: 38400
2023-05-03T13:21:51+0000 [-] got encoding parameters: 1/1/1 38400
2023-05-03T13:21:51+0000 [-] now setting up codec
2023-05-03T13:21:51+0000 [-] using storage index b'b4fpe'
2023-05-03T13:21:51+0000 [-] <Tahoe2ServerSelector for upload
b'b4fpe'>(b4fpe): starting
node3: 2023-05-03T13:21:51+0000 [-] storage: allocate_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
alice: 2023-05-03T13:21:51+0000 [-] <Tahoe2ServerSelector for upload
b'b4fpe'>(b4fpe): server selection successful for <Tahoe2ServerSelector
for upload b'b4fpe'>: placed all 1 shares, want to place shares on at
least 1 servers such that any 1 of them have enough shares to recover the
file, sent 1 queries to 1 servers, 1 queries placed some shares, 0 placed
none (of which 0 placed none due to the server being full and 0 placed
none due to an error): pretty_print_merged: sh0: oyyc26dd,
self.use_trackers: ['0: xctkxh35'], self.preexisting_shares:
2023-05-03T13:21:51+0000 [-] set_shareholders; upload_trackers is ['0:
xctkxh35'], already_serverids is {}
2023-05-03T13:21:51+0000 [-] <Encoder for b'b4fpe'> starting
2023-05-03T13:21:51+0000 [-] <Encoder for b'b4fpe'> uploaded 38400 / 38400
bytes (100%) of your file.
node1: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
alice: 2023-05-03T13:21:51+0000 [twisted.python.log#info] web: 127.0.0.1
PUT /uri 200 97
2023-05-03T13:21:51+0000 [-] upload done
Uploaded data,
cap=URI:CHK:nz76yvubgpdzf4frktjn3cxauq:nxxkldvk5znbocpquncced6d27wtpfaovpqt4rko6sap636hy2ra:1:1:38400
alice: 2023-05-03T13:21:51+0000 [-] Immutable.DownloadNode(b4fpewqsvd22)
created: size=38400, guessed_segsize=38400, guessed_numsegs=1
2023-05-03T13:21:51+0000 [-] imm Node(b4fpewqs).read(0, 38400)
2023-05-03T13:21:51+0000 [-] imm Node(b4fpewqs).get_segment(0)
node3: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
node0: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
node1: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
node3: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
node4: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
alice: 2023-05-03T13:21:51+0000
[twisted.web.client._HTTP11ClientFactory#info] Starting factory
_HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000001EF5D925280>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000001EF5DB9E8E0>)
node2: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
Downloaded 38400 bytes of data
node3: 2023-05-03T13:21:51+0000 [-] storage: get_buckets
b'b4fpewqsvd22oi6pclnchfj6my'
alice: 2023-05-03T13:21:51+0000 [-] validate_and_store_UEB
2023-05-03T13:21:51+0000 [-] delivering segment(0)
2023-05-03T13:21:51+0000 [twisted.python.log#info] web: 127.0.0.1 GET
/uri/[CENSORED] 200 38400
2023-05-03T13:21:51+0000 [-] Segmentation got data: want [0-38400), given
[0-38400), for segnum=0
alice: 2023-05-03T13:21:51+0000 [twisted.python.log#info] web: 127.0.0.1
GET /status 200 19337
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/down-0 200 2864
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/down-0/event_json 200 4910
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/up-7 200 1561
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-53 200 1364
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-68 200 1181
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-52 200 1358
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-67 200 1178
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-51 200 1234
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-17 200 1641
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-65 200 1217
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-50 200 1234
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-64 200 1180
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-49 200 1234
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-63 200 1179
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-16 200 1593
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/up-5 200 1556
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-48 200 1359
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-62 200 1183
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-15 200 1658
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-47 200 1358
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-61 200 1180
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-46 200 1386
alice: 2023-05-03T13:21:52+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-60 200 1189
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-14 200 1843
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-45 200 1388
2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1 GET
//status/mapupdate-58 200 1184
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-13 200 1838
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-44 200 1384
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-56 200 1187
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-43 200 1414
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-55 200 1193
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-42 200 1387
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-54 200 1190
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-12 200 1614
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-41 200 1362
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-52 200 1183
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-40 200 1302
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-11 200 1625
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-50 200 1236
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-39 200 1364
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-49 200 1184
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-38 200 1363
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-48 200 1181
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-37 200 1388
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-47 200 1190
alice: 2023-05-03T13:21:53+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-36 200 1388
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-46 200 1190
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-10 200 1629
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-35 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-44 200 1220
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-34 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/mapupdate-43 200 1185
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-33 200 1386
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-32 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-9 200 1789
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-8 200 1595
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-31 200 1234
2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1 GET
//status/retrieve-30 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-29 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-7 200 1781
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-28 200 1388
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-27 200 1387
2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1 GET
//status/publish-6 200 1843
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-26 200 1386
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-25 200 1360
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-24 200 1388
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-23 200 1364
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-22 200 1388
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-21 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-5 200 1644
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-20 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-19 200 1388
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-18 200 1234
alice: 2023-05-03T13:21:54+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-17 200 1326
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-16 200 1386
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-15 200 1386
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-4 200 1813
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/retrieve-14 200 1386
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-3 200 1843
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-2 200 1595
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-1 200 1796
2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1 GET
//status/retrieve-8 404 167
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/publish-0 200 1844
PASSED
integration/test_web.py::test_directory_deep_check
+++++++++++++++++++++++++++++++++++ Timeout
++++++++++++++++++++++++++++++++++++
~~~~~~~~~~~~ Stack of PoolThread-twisted.internet.reactor-1 (2256)
~~~~~~~~~~~~~
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 937, in _bootstrap
self._bootstrap_inner()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 980, in _bootstrap_inner
self.run()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 917, in run
self._target(*self._args, **self._kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\_threads\_threadworker.py", line 46, in work
for task in iter(queue.get, _stop):
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\queue.py", line
171, in get
self.not_empty.wait()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 312, in wait
waiter.acquire()
~~~~~~~~~~~~ Stack of PoolThread-twisted.internet.reactor-0 (2612)
~~~~~~~~~~~~~
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 937, in _bootstrap
self._bootstrap_inner()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 980, in _bootstrap_inner
self.run()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 917, in run
self._target(*self._args, **self._kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\_threads\_threadworker.py", line 46, in work
for task in iter(queue.get, _stop):
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\queue.py", line
171, in get
self.not_empty.wait()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\threading.py",
line 312, in wait
waiter.acquire()
~~~~~~~~~~~~~~~~~~~~~~~~~~ Stack of MainThread (1604)
~~~~~~~~~~~~~~~~~~~~~~~~~~
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\base.py", line 1318, in run
self.mainLoop()
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\base.py", line 1328, in mainLoop
reactorBaseSelf.runUntilCurrent()
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\base.py", line 967, in runUntilCurrent
f(*a, **kw)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\defer.py", line 696, in callback
self._startRunCallbacks(result)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\defer.py", line 798, in _startRunCallbacks
self._runCallbacks()
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\defer.py", line 892, in _runCallbacks
current.result = callback( # type: ignore[misc]
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\defer.py", line 1792, in gotResult
_inlineCallbacks(r, gen, status, context)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\internet\defer.py", line 1697, in _inlineCallbacks
result = context.run(gen.send, result)
File "D:\a\tahoe-lafs\tahoe-lafs\integration\test_web.py", line 278, in
test_directory_deep_check
resp = requests.get(
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\requests\api.py", line 73, in get
return request("get", url, params=params, **kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\requests\api.py", line 59, in request
return session.request(method=method, url=url, **kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\requests\sessions.py", line 587, in request
resp = self.send(prep, **send_kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\requests\sessions.py", line 701, in send
r = adapter.send(request, **kwargs)
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\requests\adapters.py", line 487, in send
resp = conn.urlopen(
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\urllib3\connectionpool.py", line 703, in urlopen
httplib_response = self._make_request(
File "D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\lib\site-
packages\urllib3\connectionpool.py", line 444, in _make_request
httplib_response = conn.getresponse()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\http\client.py",
line 1377, in getresponse
response.begin()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\http\client.py",
line 320, in begin
version, status, reason = self._read_status()
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\http\client.py",
line 281, in _read_status
line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
File "C:\hostedtoolcache\windows\Python\3.9.13\x64\lib\socket.py", line
704, in readinto
return self._sock.recv_into(b)
+++++++++++++++++++++++++++++++++++ Timeout
++++++++++++++++++++++++++++++++++++
Restarting C:\Users\RUNNER~1\AppData\Local\Temp\tahoe9nhs8nm7\alice for
ZFEC reconfiguration
TahoeProcess.kill_async(3544 /
C:\Users\RUNNER~1\AppData\Local\Temp\tahoe9nhs8nm7\alice)
signaling 3544 with TERM
alice: 2023-05-03T13:21:55+0000 [twisted.python.log#info] web: 127.0.0.1
GET //status/up-0 200 695
introducer: 2023-05-03T13:21:55+0000 [-] introducer:
unsubscribing[storage] <RemoteReference at 0x1f2e8edc4f0
[pb://ehlna2ddvd3oi7lk3neruk2tphygfsiw@tcp:localhost:54491/iiju5newwsdzpbuvicywwp3i6lhvxpvs]>
alice: 'tahoe run' in
'C:\Users\RUNNER~1\AppData\Local\Temp\tahoe9nhs8nm7\alice'
'\\?\C:\Users\RUNNER~1\AppData\Local\Temp\tahoe9nhs8nm7\alice\running.process'
refers to 792 that isn't running
running node in 'C:\Users\RUNNER~1\AppData\Local\Temp\tahoe9nhs8nm7\alice'
2023-05-03T13:21:57+0000 [twisted.application.app.AppLogger#info] twistd
22.10.0 (D:\a\tahoe-lafs\tahoe-lafs\.tox\integration\Scripts\python.EXE
3.9.13) starting up.
2023-05-03T13:21:57+0000 [twisted.application.app.AppLogger#info] reactor
class: twisted.internet.selectreactor.SelectReactor.
alice: 2023-05-03T13:22:02+0000 [twisted.logger._global#warn] D:\a\tahoe-
lafs\tahoe-lafs\.tox\integration\lib\site-packages\foolscap\pb.py:870:
builtins.BytesWarning: str() on a bytes instance
alice: 2023-05-03T13:22:02+0000 [-] Foolscap logging initialized
2023-05-03T13:22:02+0000 [-] Note to developers: twistd.log does not
receive very much.
2023-05-03T13:22:02+0000 [-] Use 'flogtool tail -c
NODEDIR/private/logport.furl' instead
2023-05-03T13:22:02+0000 [-] and read docs/logging.rst
alice: 2023-05-03T13:22:02+0000 [twisted.logger._global#warn] D:\a\tahoe-
lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\conch\ssh\transport.py:97:
cryptography.utils.CryptographyDeprecationWarning: Blowfish has been
deprecated
2023-05-03T13:22:02+0000 [twisted.logger._global#warn] D:\a\tahoe-lafs
\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\conch\ssh\transport.py:101:
cryptography.utils.CryptographyDeprecationWarning: CAST5 has been
deprecated
2023-05-03T13:22:02+0000 [twisted.logger._global#warn] D:\a\tahoe-lafs
\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\conch\ssh\transport.py:106:
cryptography.utils.CryptographyDeprecationWarning: Blowfish has been
deprecated
alice: 2023-05-03T13:22:02+0000 [twisted.logger._global#warn] D:\a\tahoe-
lafs\tahoe-lafs\.tox\integration\lib\site-
packages\twisted\conch\ssh\transport.py:107:
cryptography.utils.CryptographyDeprecationWarning: CAST5 has been
deprecated
alice: 2023-05-03T13:22:02+0000 [-] SSHFactory starting on 8022
2023-05-03T13:22:02+0000 [allmydata.frontends.sftpd.SSHFactory#info]
Starting factory
<allmydata.frontends.sftpd.SFTPServer.__init__.<locals>.SSHFactory object
at 0x000002B50D177490>
alice: 2023-05-03T13:22:04+0000 [-] TahoeLAFSSite starting on 9980
2023-05-03T13:22:04+0000 [allmydata.webish.TahoeLAFSSite#info] Starting
factory <allmydata.webish.TahoeLAFSSite object at 0x000002B50D40F0D0>
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D65AD30>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D666130>)
alice: 2023-05-03T13:22:05+0000 [-] received 5 announcements (v2)
2023-05-03T13:22:05+0000 [-] announcement for nickname 'node4',
service=storage: {'version': 0, 'nickname': 'node4', 'app-versions': [],
'my-version': 'tahoe-lafs/1.18.0.post1113', 'oldest-supported': '1.0.0',
'service-name': 'storage', 'permutation-seed-base32':
'oq2xo2dnm5two3tkojywq4junrsxu5dsoj3hkn3dmf4wq6tjgjrgi5bxgvsho4bwgq3wom3gojugqmtwnjyq',
'anonymous-storage-NURLs':
['pb://1HbCEFUo72t1r9zFPZ5H7Z3SnHdBTDRWC5hQZzCwTCo@localhost:54341/xwqcl32s23fwdso65ybvdo255pbdij3k#v=1'],
'anonymous-storage-FURL':
'pb://6j2ozar5bl2khlvlf2w5p3hwr32dvgsj@tcp:localhost:54341/xwqcl32s23fwdso65ybvdo255pbdij3k',
'seqnum': 1, 'nonce':
'cyxbpgbtjdttwa2pr7pwgec3itwmxxx7dzezde3k6cyodmagb7yq'}
2023-05-03T13:22:05+0000 [-] announcement for nickname 'node2',
service=storage: {'version': 0, 'nickname': 'node2', 'app-versions': [],
'my-version': 'tahoe-lafs/1.18.0.post1113', 'oldest-supported': '1.0.0',
'service-name': 'storage', 'permutation-seed-base32':
'mfxtk2dogn4hkmtimyzgqzdkojzwq4zsmrshknlig53huzzunnxg453jm43tiyjxgvswsntbo42do2lepbyq',
'anonymous-storage-NURLs': ['pb://Ti6VHCngFd-
UBos6nMHz8a4LQpUwloatuqgyYMEUtaE at localhost:54345/jy4qt2bmmd2beht4ghs43q6t5o5gzlmv#v=1'],
'anonymous-storage-FURL':
'pb://4juwtoaf5zdmzng6hxwxf2hwvbu4bome@tcp:localhost:54345/jy4qt2bmmd2beht4ghs43q6t5o5gzlmv',
'seqnum': 1, 'nonce':
'll5r5uhedonxovx73iqshsajg2msxrr2hlq2p4b57tgiag5bhfxq'}
2023-05-03T13:22:05+0000 [-] announcement for nickname 'node3',
service=storage: {'version': 0, 'nickname': 'node3', 'app-versions': [],
'my-version': 'tahoe-lafs/1.18.0.post1113', 'oldest-supported': '1.0.0',
'service-name': 'storage', 'permutation-seed-base32':
'pbrxi23ynaztk232nzyxmmttnvtte4dynjyho2dwna3guzlroa2dk43wmu2hk3dlpi2giytdmrqws6tnnvyq',
'anonymous-storage-NURLs':
['pb://bfNi4KzUXjKroY0G9q5FRSZR39L2QkFXOv2B8PYFMB0@localhost:54340/ei3ynwblevxvvwa56qiiqo4qkh6lkkmq#v=1'],
'anonymous-storage-FURL':
'pb://ihjh2uw552sbwvwvgta34zemeprt2sga@tcp:localhost:54340/ei3ynwblevxvvwa56qiiqo4qkh6lkkmq',
'seqnum': 1, 'nonce':
'7ssrhznkuipvtm5cdbebrvfdxiddee56kr6o6uc24eek6jgsrdma'}
2023-05-03T13:22:05+0000 [-] announcement for nickname 'node1',
service=storage: {'version': 0, 'nickname': 'node1', 'app-versions': [],
'my-version': 'tahoe-lafs/1.18.0.post1113', 'oldest-supported': '1.0.0',
'service-name': 'storage', 'permutation-seed-base32':
'mjvge2dbnv4dgnlegy2hinttnb4hun3vpfvtg2dogr3wg3lmgy3weylkgr5he3jvmrrhknjwoi3wqndigzyq',
'anonymous-storage-NURLs': ['pb://UivzMmQERY83EGD0PK-Sc94SgOpnbLmaInmalU-
UdMQ at localhost:54339/pnnlnu3wfctk3d2yb3tdkfgp4m47bqh5#v=1'], 'anonymous-
storage-FURL':
'pb://653ky67n5tpxamaultgih3dba3drkxg5@tcp:localhost:54339/pnnlnu3wfctk3d2yb3tdkfgp4m47bqh5',
'seqnum': 1, 'nonce':
'2ofdpyoisyxz2rb2ni7bxks3eixtf3uracsjvdxoakz542i5dmva'}
2023-05-03T13:22:05+0000 [-] announcement for nickname 'node0',
service=storage: {'version': 0, 'nickname': 'node0', 'app-versions': [],
'my-version': 'tahoe-lafs/1.18.0.post1113', 'oldest-supported': '1.0.0',
'service-name': 'storage', 'permutation-seed-base32':
'gqzxkzl2g5vgmzbxoftdezdqgzxxmn3zny3w44djobqwc5dqobvdondjojuhmzdegi2gen3fmztwm4lynbyq',
'anonymous-storage-NURLs':
['pb://fn7kWHByrZfGWCxAizmZ4k1L5rSmNEGgtQoAxOWLxlk@localhost:54335/sfvk5a542nh56pefsnzsidqmlcqv7mdc#v=1'],
'anonymous-storage-FURL':
'pb://mydhg6wbugs7334up3vvaxjri64qplzh@tcp:localhost:54335/sfvk5a542nh56pefsnzsidqmlcqv7mdc',
'seqnum': 1, 'nonce':
'cdgr4ui4x2vup65ypoow6zbmtrzrwltzdzl3w5sfarryneuy4sra'}
alice: 2023-05-03T13:22:05+0000
[twisted.web.client._HTTP11ClientFactory#info] Stopping factory
_HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D61CDC0>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D62A250>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D6535E0>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D6666D0>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D69A160>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D696D00>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D66F940>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D6914F0>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D64B700>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D676FA0>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Stopping factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D653550>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D650EE0>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Stopping factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D63C670>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D63D2B0>)
alice: 2023-05-03T13:22:05+0000
[twisted.web.client._HTTP11ClientFactory#info] Stopping factory
_HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D65AD30>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D666130>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Stopping factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D641D30>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D64A070>)
2023-05-03T13:22:05+0000 [twisted.web.client._HTTP11ClientFactory#info]
Starting factory _HTTP11ClientFactory(<function
HTTPConnectionPool._newConnection.<locals>.quiescentCallback at
0x000002B50D60DF70>, <twisted.internet.endpoints._WrapperEndpoint object
at 0x000002B50D6A27F0>)
Now: Wed May 3 13:22:05 2023
Server last-received-data: ['Wed May 3 13:22:05 2023', 'Wed May 3
13:22:05 2023', 'Wed May 3 13:22:05 2023', 'Wed May 3 13:22:05 2023',
'Wed May 3 13:22:05 2023']
waiting because 5 server(s) not contacted
alice: 2023-05-03T13:22:05+0000 [twisted.python.log#info] web: 127.0.0.1
GET /?t=json 200 1208
Now: Wed May 3 13:22:06 2023
Server last-received-data: ['Wed May 3 13:22:06 2023', 'Wed May 3
13:22:06 2023', 'Wed May 3 13:22:06 2023', 'Wed May 3 13:22:06 2023',
'Wed May 3 13:22:06 2023']
Ready.
ERROR: InvocationError for command 'D:\a\tahoe-lafs\tahoe-
lafs\.tox\integration\Scripts\py.test.EXE' --timeout=1800 --coverage -s -v
integration (exited with code 1)
___________________________________ summary
___________________________________
ERROR: integration: commands failed
Error: Process completed with exit code 1.
}}}
--
Ticket URL: <https://tahoe-lafs.org/trac/tahoe-lafs/ticket/4023>
Tahoe-LAFS <https://Tahoe-LAFS.org>
secure decentralized storage
More information about the tahoe-lafs-trac-stream
mailing list