space not exists #96
Description
Have you read a contributing guide?
- I have read CONTRIBUTING.md
- I have searched the existing issues and didn't find any that were similar
- I have considered creating a pull request with fixes instead of a bug report and want to proceed
Current Behavior
This is a self hosted instance of Any Type sync, not the docker-compose version. One of each node is running on the same host: coordinator, node, filenode, and consensus. My Any Type client on Windows refuses to sync with the Any Sync cluster, all created objects just pin wheel infinitely. Connection to the Any Sync cluster has been confirmed successful both by the client's Debug>Network output (attached below), and the use of the any-sync-netcheck utility. In the output of the Any Sync coordinator, I notice that when creating a fresh vault, after selecting New Vault>Get my Key, the coordinator begins to error "space not exists". The spaceId given for the error matches the Space the Vault is creating in the background. This error repeats multiple times until I continue through the vault creation process with Show my Key>Next>Enter my Vault. Once I reach the typical Any Type Space home page, the coordinator starts to error "manager closed: EOF" and "Application error 0x2" and fails to sync the initial objects Any Type generates for a new vault.
Expected Behavior
When a new vault is created, the space should be added and recognized. The AnyType client should be able to sync to the sync node cluster.
Steps To Reproduce
- Start any-sync-* servers
- Start up a fresh client instance of Any Type (Windows)
- Select "New Vault"
- Select "Get my Key"
- Select "Show my Key"
- Select "Next"
- Enter a name
- Select "Enter my Vault"
Environment
- OS: Windows 11 Home (Client)
- Version: x86_64 (ARM)
- OS: Debian (AnySync)
- Version: Bookworm/BullseyeAnything else?
AnySync output when Client is on New Vault > Get my Key page
Mar 02 22:10:26 anytype anysync-coordinator[248]: 2025-03-02T22:10:26.485-0500 DEBUG common.net.drpcserver drpc serve peer {"remoteAddr": "10.0.99.110:60281", "localAddr": "10.0.99.5:5830"}
Mar 02 22:10:26 anytype anysync-coordinator[248]: 2025-03-02T22:10:26.486-0500 DEBUG coordinator.coordinator finished checking status {"error": "space not exists", "spaceId": "bafyreicmrmlkv22mqka5d7ktaguksr5f7pco54356yzf4nv7tjyw33lsmu.31mswp0e7mwic", "error": "space not exists"}
Mar 02 22:10:26 anytype anysync-coordinator[248]: 2025-03-02T22:10:26.486-0500 INFO rpcLog {"totalDur": 0.000830327, "addr": "quic://10.0.99.110:60281", "error": "space not exists", "app": "v0.4.4", "peerId": "12D3KooWHa6VW85nsNz9Kpko7zpNUd4mrpDzY83tgtjTEvcga7vK", "identity": "A9xRjfaVtjMixYVgaP9pLR6AktAVTWWUL7j33Dh52qzAsepL", "rpc": "coordinator.spaceStatusCheckMany", "peerVersion": "Windows:0.45.3/middle:v0.39.11/any-sync:"}
Mar 02 22:10:26 anytype anysync-coordinator[248]: 2025-03-02T22:10:26.497-0500 DEBUG coordinator.coordinator finished checking status {"error": "space not exists", "spaceId": "bafyreiglkxbruw7doclsxregt3rqzetz5ex64lkgg5rmz2b22skvn6st6y.31mswp0e7mwic", "error": "space not exists"}
Mar 02 22:10:26 anytype anysync-coordinator[248]: 2025-03-02T22:10:26.497-0500 INFO rpcLog {"totalDur": 0.000195573, "spaceId": "bafyreiglkxbruw7doclsxregt3rqzetz5ex64lkgg5rmz2b22skvn6st6y.31mswp0e7mwic", "addr": "quic://10.0.99.110:60281", "error": "space not exists", "app": "v0.4.4", "peerId": "12D3KooWHa6VW85nsNz9Kpko7zpNUd4mrpDzY83tgtjTEvcga7vK", "identity": "A9xRjfaVtjMixYVgaP9pLR6AktAVTWWUL7j33Dh52qzAsepL", "rpc": "coordinator.spaceStatusCheck", "peerVersion": "Windows:0.45.3/middle:v0.39.11/any-sync:"}
AnySync output when Client is on Space home page
Mar 02 22:35:09 anytype anysync-coordinator[248]: 2025-03-02T22:35:09.449-0500 INFO common.net.peer serve connection error {"error": "manager closed: EOF; close called for canceled stream 8", "errorVerbose": "group:\n--- manager closed: EOF\n\tstorj.io/drpc/drpcmanager.(*Manager).manageReader:234\n--- close called for canceled stream 8"}
Mar 02 22:35:09 anytype anysync-coordinator[248]: 2025-03-02T22:35:09.450-0500 INFO common.net.peer serve connection error {"error": "manager closed: Application error 0x2 (remote)", "errorVerbose": "manager closed: Application error 0x2 (remote)\n\tstorj.io/drpc/drpcmanager.(*Manager).manageReader:234"}
Client Debug>Network
system info: GoOS:windows,Kernel:windows,Core:10.0.22631.4460,Platform:x86_64,OS:windows,Hostname:sforker,CPUs:2
open TCP conn, addr: 10.0.99.5:4830
TCP conn established, ip:10.0.99.5:4830, dur: 13.8546ms
start handshake
handshake success, dur: 26.5251ms, total: 40.3797ms
open yamux session
yamux session success, dur: 0s, total: 40.5948ms
open sub connection
open sub conn success, dur: 0s, total: 40.5948ms
start proto handshake
proto handshake success, dur: 7.3897ms, total: 47.9845ms
start configuration request
configuration request success, dur: 9.8721ms, total: 57.8566ms, nid: N5nU8iEdQWT42g4UTjgLtbMy7QpGVW4R4hU75q1kdtq3qXKk
success, dur: 57.8566ms
open QUIC conn, addr: 10.0.99.5:5830
QUIC conn established, ip:quic://10.0.99.5:5830, dur: 19.4933ms
open sub connection
open sub conn success, dur: 0s, total: 19.4933ms
start proto handshake
proto handshake success, dur: 6.9159ms, total: 26.4092ms
start configuration request
configuration request success, dur: 8.0502ms, total: 34.4594ms, nid: N5nU8iEdQWT42g4UTjgLtbMy7QpGVW4R4hU75q1kdtq3qXKk
success, dur: 34.4594ms
open TCP conn, addr: 10.0.99.5:4830
TCP conn established, ip:10.0.99.5:4830, dur: 5.5399ms
start handshake
handshake success, dur: 19.4393ms, total: 24.9792ms
open yamux session
yamux session success, dur: 0s, total: 24.9792ms
open sub connection
open sub conn success, dur: 0s, total: 24.9792ms
start proto handshake
proto handshake success, dur: 9.3095ms, total: 34.2887ms
start configuration request
configuration request success, dur: 9.1768ms, total: 43.4655ms, nid: N5nU8iEdQWT42g4UTjgLtbMy7QpGVW4R4hU75q1kdtq3qXKk
success, dur: 43.4655ms
open QUIC conn, addr: 10.0.99.5:5830
QUIC conn established, ip:quic://10.0.99.5:5830, dur: 30.4947ms
open sub connection
open sub conn success, dur: 0s, total: 30.4947ms
start proto handshake
proto handshake success, dur: 3.5919ms, total: 34.0866ms
start configuration request
configuration request success, dur: 5.2868ms, total: 39.3734ms, nid: N5nU8iEdQWT42g4UTjgLtbMy7QpGVW4R4hU75q1kdtq3qXKk
success, dur: 39.3734ms
Client Debug>Process
[2025-03-02 22:35:48.942] [warn] 2025-03-02T22:35:48.936-0500 ERROR anytype-identity push profile to identity registry {"error": "failed to push identity: unable to connect"}
...
[2025-03-02 22:36:19.691] [warn] {"level":"WARN","ts":"2025-03-02T22:36:19.691-0500","logger":"common.commonspace.peermanager","msg":"failed to get responsible peer from common pool","error":"unable to connect"}
...
[2025-03-02 22:36:39.048] [warn] {"level":"ERROR","ts":"2025-03-02T22:36:39.046-0500","logger":"anytype-gateway","msg":"error getting image: get image reader: context deadline exceeded","path":"/image/bafyreicwp5c5eci7itqjiysweueg2ybbfqyijunl4b3bnpwdmpuwv7wboq"}
...
[2025-03-02 22:37:59.561] [warn] {"level":"WARN","ts":"2025-03-02T22:37:59.556-0500","logger":"common.commonspace.headsync","msg":"periodic call error","spaceId":"bafyreigb23ctlbpgx6imbqpnoqr4r73s3dvpfob47u3l4tris4v5pruskq.3h8llq3pxsck3","error":"context deadline exceeded"}
any-sync-coordinator config
account:
peerId: 12D3KooWCt8Zs9KXD9KNeBDXFsmoVYthpsgxQDj7xMeew7BhhNPx
peerKey: <redact>
signingKey: <redact>
==
drpc:
stream:
maxMsgSizeMb: 256
yamux:
listenAddrs:
- 0.0.0.0:4830
writeTimeoutSec: 10
dialTimeoutSec: 10
quic:
listenAddrs:
- 0.0.0.0:5830
writeTimeoutSec: 10
dialTimeoutSec: 10
network:
id: 67c345ee6b9da82824c6b2b4
networkId: N5nU8iEdQWT42g4UTjgLtbMy7QpGVW4R4hU75q1kdtq3qXKk
nodes:
- peerId: 12D3KooWCt8Zs9KXD9KNeBDXFsmoVYthpsgxQDj7xMeew7BhhNPx
addresses:
- 127.0.0.1:4830
- quic://127.0.0.1:5830
- 127.0.0.1:4830
- quic://127.0.0.1:5830
types:
- coordinator
- peerId: 12D3KooWCs9ZkMZvm3Xc4hTLnNUdPuzq3wVQdctfBjKdhw4da76V
addresses:
- 127.0.0.1:4530
- quic://127.0.0.1:5530
- 127.0.0.1:4530
- quic://127.0.0.1:5530
types:
- consensus
- peerId: 12D3KooWMMPBW3J26TqQz4YS5WriJEPYHDD1imVFQAFq35kp5iSy
addresses:
- 127.0.0.1:4430
- quic://127.0.0.1:5430
- 127.0.0.1:4430
- quic://127.0.0.1:5430
types:
- tree
- peerId: 12D3KooWRvJTrzD55Qie5e3GmPsyjqYw9CPJ7SU5fhuUaDRK4Wxx
addresses:
- 127.0.0.1:4730
- quic://127.0.0.1:5730
- 127.0.0.1:4730
- quic://127.0.0.1:5730
types:
- file
networkStorePath: /networkStore
log:
production: false
defaultLevel: ""
namedLevels: {}
metric:
addr: 0.0.0.0:8001
mongo:
connect: mongodb://localhost:27017
database: coordinator
log: log
spaces: spaces
spaceStatus:
runSeconds: 5
deletionPeriodDays: 0
defaultLimits:
spaceMembersRead: 1000
spaceMembersWrite: 1000
sharedSpacesLimit: 1000