Context Navigation

← Previous Ticket
Next Ticket →

Opened at 2023-05-03T21:16:12Z

Closed at 2023-05-09T20:49:33Z

#4023 closed defect (fixed)

Integration tests aren't passing on Windows

Reported by:	itamarst	Owned by:	GitHub <noreply@…>
Priority:	normal	Milestone:	HTTP Storage Protocol
Component:	unknown	Version:	n/a
Keywords:		Cc:
Launchpad Bug:

Description

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@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@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.

Change History (1)

comment:1 Changed at 2023-05-09T20:49:33Z by GitHub <noreply@…>

Owner set to GitHub <noreply@…>
Resolution set to fixed
Status changed from new to closed

In 94a91b6/trunk:

Merge pull request #1299 from tahoe-lafs/4023-integration-tests

Fix failing integration tests

Fixes ticket:4023

Note: See TracTickets for help on using tickets.

Download in other formats: