search

ssbc / go-ssb

Go implementation of ssb (work in progress!)
https://scuttlebutt.nz
162 stars 26 forks source link

TestBlocking is flaky #273

Open KyleMaas opened 1 year ago

KyleMaas commented 1 year ago

See #237 

2022/12/21 02:37:58 [margaret/indexes/badger] overwrote batch limit 0
=== RUN   TestBlocking
2022/12/21 02:37:58 saved identity @ulA/kpxMTZBo1ScyGzsZIZJVtSJKqmvpCIP4IROSLVM=.ed25519 to testrun/TestBlocking/secrets/alice
2022/12/21 02:37:58 saved identity @7PKY2sh4VVXMQo/Pdycds0BeBKxnOB9i1tURcI/rbQQ=.ed25519 to testrun/TestBlocking/secret
    interop_test.go:123: go-sbot: @7PKY2sh4VVXMQo/Pdycds0BeBKxnOB9i1tURcI/rbQQ=.ed25519
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:1 @i2BSwiQ4E0+qhOdWiNliL6y3HEMRZfZvQpCYLLi9NTI=.ed25519
ok 1 parallel of publish
ok 2 message count
# dialing:net:127.0.0.1:45635~shs:7PKY2sh4VVXMQo/Pdycds0BeBKxnOB9i1tURcI/rbQQ=
ok 3 connected
level=debug t=1.587427629s plugin=ebt event=replicating version=3
level=debug t=1.635623009s unit=gossip fr=<@ulA/.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.636402933s unit=gossip fr=<@7PKY.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.707683987s unit=gossip fr=<@ulA/.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.708260053s unit=gossip fr=<@7PKY.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.758725993s unit=gossip fr=<@7PKY.ed25519> event=gossiptx n=2 starting=0
level=debug t=4.708197069s event=update-replicate feed-want-count=2 hops=0 took=678.762µs
level=debug t=6.950398636s plugin=ebt r=<@i2BS.ed25519> event="loop exited"
# now should have feed:@ulA/kpxMTZBo1ScyGzsZIZJVtSJKqmvpCIP4IROSLVM=.ed25519
ok 4 query worked
ok 5 got all the messages
not ok 6 latest keys match
  ---
    operator: equal
    expected: '%CxuSAIU7MdOlQWn7bJKTZqEZRcgouAPitxx0/Pv8Bj4=.sha256'
    actual:   '%nqVh3QKh22+GGSkkTLn2kCCfoh2m6TU6M5Ld4Q3hptY=.sha256'
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest keys match
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:26:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
not ok 7 latest sequence
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest sequence
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# closed sbot

1..7
# tests 7
# pass  5
# fail  2

JS Sbot process returned
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:2 @i2BSwiQ4E0+qhOdWiNliL6y3HEMRZfZvQpCYLLi9NTI=.ed25519
    interop_test.go:282:
                Error Trace:    /home/go-ssb/go-ssb/tests/interop_test.go:282
                                                        /home/go-ssb/go-ssb/tests/blocking_test.go:133
                Error:          Received unexpected error:
                                cmd wait failed: exit status 1
                Test:           TestBlocking
--- FAIL: TestBlocking (7.80s)
FAIL
ok 1 init query worked
not ok 2 should have previous messages
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: should have previous messages
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# dialing:net:127.0.0.1:45635~shs:7PKY2sh4VVXMQo/Pdycds0BeBKxnOB9i1tURcI/rbQQ=
not ok 3 connected
  ---
    operator: error
    at: <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:66:9)
    stack: |-
      Error: connect ECONNREFUSED 127.0.0.1:45635
          at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1138:16)
  ...
not ok 4 TestBlocking/claire timed out after 15000ms
  ---
    operator: fail
    stack: |-
      Error: TestBlocking/claire timed out after 15000ms
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.fail (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:398:10)
          at Test.bound [as fail] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Timeout._onTimeout (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:173:14)
          at listOnTimeout (internal/timers.js:554:17)
          at processTimers (internal/timers.js:497:7)
  ...
# test timeout
FAIL    github.com/ssbc/go-ssb/tests    27.066s
FAIL
2022/12/21 02:40:17 [margaret/indexes/badger] overwrote batch limit 0
=== RUN   TestBlocking
2022/12/21 02:40:17 saved identity @wYo6fOWLQARFZWV86CqDHNg/Nbw0KmKFJXwU4oMhsww=.ed25519 to testrun/TestBlocking/secrets/alice
2022/12/21 02:40:17 saved identity @/8EMpLUNned3nZPt/QjKAmqaLXvJrJ/JrdVJIVOT35U=.ed25519 to testrun/TestBlocking/secret
    interop_test.go:123: go-sbot: @/8EMpLUNned3nZPt/QjKAmqaLXvJrJ/JrdVJIVOT35U=.ed25519
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:1 @prrOY8DdRbZJ4o/cHsDycOqfQWNGW/8yLqHRpmqdLlo=.ed25519
ok 1 parallel of publish
ok 2 message count
# dialing:net:127.0.0.1:36911~shs:/8EMpLUNned3nZPt/QjKAmqaLXvJrJ/JrdVJIVOT35U=
ok 3 connected
level=debug t=1.514993227s plugin=ebt event=replicating version=3
level=debug t=1.562869361s unit=gossip fr=<@wYo6.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.563082315s unit=gossip fr=<@/8EM.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.626540618s unit=gossip fr=<@/8EM.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.626804422s unit=gossip fr=<@wYo6.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.670726853s unit=gossip fr=<@wYo6.ed25519> event=gossiptx n=2 starting=0
level=debug t=4.580800286s event=update-replicate feed-want-count=2 hops=0 took=598.014µs
level=debug t=6.682862006s plugin=ebt r=<@prrO.ed25519> event="loop exited"
# now should have feed:@wYo6fOWLQARFZWV86CqDHNg/Nbw0KmKFJXwU4oMhsww=.ed25519
ok 4 query worked
ok 5 got all the messages
not ok 6 latest keys match
  ---
    operator: equal
    expected: '%uoBAXWOgm8fhxWBTXKoohw26eIYton3FvsXMF3wZRkc=.sha256'
    actual:   '%Cb25K+Qp+ubLo93jKU0qsik/F7wOsrS7sA7yCBY3KbY=.sha256'
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest keys match
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:26:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
not ok 7 latest sequence
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest sequence
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# closed sbot

1..7
# tests 7
# pass  5
# fail  2

JS Sbot process returned
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:2 @prrOY8DdRbZJ4o/cHsDycOqfQWNGW/8yLqHRpmqdLlo=.ed25519
    interop_test.go:282:
                Error Trace:    /home/go-ssb/go-ssb/tests/interop_test.go:282
                                                        /home/go-ssb/go-ssb/tests/blocking_test.go:133
                Error:          Received unexpected error:
                                cmd wait failed: exit status 1
                Test:           TestBlocking
--- FAIL: TestBlocking (7.55s)
FAIL
ok 1 init query worked
not ok 2 should have previous messages
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: should have previous messages
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# dialing:net:127.0.0.1:36911~shs:/8EMpLUNned3nZPt/QjKAmqaLXvJrJ/JrdVJIVOT35U=
not ok 3 connected
  ---
    operator: error
    at: <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:66:9)
    stack: |-
      Error: connect ECONNREFUSED 127.0.0.1:36911
          at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1138:16)
  ...
not ok 4 TestBlocking/claire timed out after 15000ms
  ---
    operator: fail
    stack: |-
      Error: TestBlocking/claire timed out after 15000ms
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.fail (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:398:10)
          at Test.bound [as fail] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Timeout._onTimeout (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:173:14)
          at listOnTimeout (internal/timers.js:554:17)
          at processTimers (internal/timers.js:497:7)
  ...
# test timeout
FAIL    github.com/ssbc/go-ssb/tests    26.830s
FAIL
2022/12/21 02:44:58 [margaret/indexes/badger] overwrote batch limit 0
=== RUN   TestBlocking
2022/12/21 02:44:58 saved identity @K7xW3eOTdaSYnTvQ8zT/taPnDtO/ypqLL1xx1iiZ+OQ=.ed25519 to testrun/TestBlocking/secrets/alice
2022/12/21 02:44:58 saved identity @aNBRPpNNfzXLRmExX5G5Zz96+O+aEDsRWbqjfwLfCpc=.ed25519 to testrun/TestBlocking/secret
    interop_test.go:123: go-sbot: @aNBRPpNNfzXLRmExX5G5Zz96+O+aEDsRWbqjfwLfCpc=.ed25519
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:1 @fEeigui8SNzk2uhxYmV1LlNHKIARU2oSeGExPNZcJ5Q=.ed25519
ok 1 parallel of publish
ok 2 message count
# dialing:net:127.0.0.1:44411~shs:aNBRPpNNfzXLRmExX5G5Zz96+O+aEDsRWbqjfwLfCpc=
ok 3 connected
level=debug t=1.559590741s plugin=ebt event=replicating version=3
level=debug t=1.603157675s unit=gossip fr=<@K7xW.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.603939996s unit=gossip fr=<@aNBR.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.640994232s unit=gossip fr=<@K7xW.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.641558895s unit=gossip fr=<@aNBR.ed25519> event=gossiptx n=2 starting=0
level=debug t=1.686454787s unit=gossip fr=<@aNBR.ed25519> event=gossiptx n=2 starting=0
level=debug t=4.641438163s event=update-replicate feed-want-count=2 hops=0 took=498.216µs
level=debug t=6.716438528s plugin=ebt r=<@fEei.ed25519> event="loop exited"
# now should have feed:@K7xW3eOTdaSYnTvQ8zT/taPnDtO/ypqLL1xx1iiZ+OQ=.ed25519
ok 4 query worked
ok 5 got all the messages
not ok 6 latest keys match
  ---
    operator: equal
    expected: '%gk/IIvErXTMVbJ94O1VB1UC5D+FshGXndliD38rwkvY=.sha256'
    actual:   '%Q/K8ll/ryG17dfu6LlU5MK95EiL97Vh+0oYqylJKICE=.sha256'
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest keys match
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:26:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
not ok 7 latest sequence
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: latest sequence
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# closed sbot

1..7
# tests 7
# pass  5
# fail  2

JS Sbot process returned
    interop_test.go:152: starting client TestBlocking/claire
TAP version 13
# TestBlocking/claire
# sbot spawned, running before
    interop_test.go:200: JS TestBlocking/claire:2 @fEeigui8SNzk2uhxYmV1LlNHKIARU2oSeGExPNZcJ5Q=.ed25519
    interop_test.go:282:
                Error Trace:    /home/go-ssb/go-ssb/tests/interop_test.go:282
                                                        /home/go-ssb/go-ssb/tests/blocking_test.go:133
                Error:          Received unexpected error:
                                cmd wait failed: exit status 1
                Test:           TestBlocking
--- FAIL: TestBlocking (7.59s)
FAIL
ok 1 init query worked
not ok 2 should have previous messages
  ---
    operator: equal
    expected: 2
    actual:   1
    at: <anonymous> (/home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5)
    stack: |-
      Error: should have previous messages
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.strictEqual (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:468:10)
          at Test.bound [as equal] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at eval (eval at <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:102:3), <anonymous>:27:6)
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/reduce.js:10:5
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/sinks/drain.js:20:24
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/through.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/map.js:19:9
          at /home/go-ssb/go-ssb/tests/node_modules/pull-stream/throughs/filter.js:17:11
  ...
# dialing:net:127.0.0.1:44411~shs:aNBRPpNNfzXLRmExX5G5Zz96+O+aEDsRWbqjfwLfCpc=
not ok 3 connected
  ---
    operator: error
    at: <anonymous> (/home/go-ssb/go-ssb/tests/sbot_client.js:66:9)
    stack: |-
      Error: connect ECONNREFUSED 127.0.0.1:44411
          at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1138:16)
  ...
not ok 4 TestBlocking/claire timed out after 15000ms
  ---
    operator: fail
    stack: |-
      Error: TestBlocking/claire timed out after 15000ms
          at Test.assert [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:304:54)
          at Test.bound [as _assert] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Test.fail (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:398:10)
          at Test.bound [as fail] (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:91:32)
          at Timeout._onTimeout (/home/go-ssb/go-ssb/tests/node_modules/tape/lib/test.js:173:14)
          at listOnTimeout (internal/timers.js:554:17)
          at processTimers (internal/timers.js:497:7)
  ...
# test timeout
FAIL    github.com/ssbc/go-ssb/tests    26.874s
FAIL
KyleMaas commented 1 year ago

Okay, so once again, way too much stuff is being tested and failing on this one. There's something far more basic that needs to be fixed before this one is even looked at.