Log has the "error: status: code = 3072 message = container not found" after container was created #231

New Issue

Closed

opened 2023-04-10 11:28:10 +00:00 by anikeev-yadro · 2 comments

anikeev-yadro commented

2023-04-10 11:28:10 +00:00

Expected Behavior

Log shouldn't has any errors after container was created.

Current Behavior

Log has the "error: status: code = 3072 message = container not found" after container was created.

Steps to Reproduce (for bugs)

create container

neofs-cli container create -r node1:8080 -w wallet.json --policy "REP 4 IN X  SELECT 4 FROM * AS X" --await
Enter password >
container ID: 8XLU5iSNayA5UNEkMysC6GUz46n9YU1cLnLyUV83tMZ4

found errors in log:

Dec 14 09:58:13 az neofs-node[17341]: 2022-12-14T09:58:13.185Z        error        neofs-node/container.go:92        read newly created container after the notification        {"id": "8XLU5iSNayA5UNEkMysC6GUz46n9YU1cLnLyUV83tMZ4", "error": "status: code = 3072 message = container not found"}

Version

FrostFS Storage node
Version: v0.0.1-384-gb689027d
GoVersion: go1.18.4

Regression

Yes

Your Environment

Virtual

Related to https://github.com/nspcc-dev/neofs-node/issues/2155 ## Expected Behavior Log shouldn't has any errors after container was created. ## Current Behavior Log has the "error: status: code = 3072 message = container not found" after container was created. ## Steps to Reproduce (for bugs) 1. create container ``` neofs-cli container create -r node1:8080 -w wallet.json --policy "REP 4 IN X SELECT 4 FROM * AS X" --await Enter password > container ID: 8XLU5iSNayA5UNEkMysC6GUz46n9YU1cLnLyUV83tMZ4 ``` 2. found errors in log: ``` Dec 14 09:58:13 az neofs-node[17341]: 2022-12-14T09:58:13.185Z error neofs-node/container.go:92 read newly created container after the notification {"id": "8XLU5iSNayA5UNEkMysC6GUz46n9YU1cLnLyUV83tMZ4", "error": "status: code = 3072 message = container not found"} ``` ## Version ``` FrostFS Storage node Version: v0.0.1-384-gb689027d GoVersion: go1.18.4 ``` ## Regression Yes ## Your Environment Virtual

anikeev-yadro added the

triage

label 2023-04-10 11:28:10 +00:00

fyrchik commented

2023-04-10 15:16:03 +00:00

Owner

Most likely, we have a problem in the cache (poll and polute the cache with ErrNotFound).

Most likely, we have a problem in the cache (poll and polute the cache with `ErrNotFound`).

fyrchik added this to the v0.37.0 milestone 2023-04-11 08:20:19 +00:00

fyrchik added

frostfs-node

and removed

triage

labels 2023-04-14 09:12:19 +00:00

dstepanov-yadro self-assigned this 2023-04-19 07:00:09 +00:00

dstepanov-yadro commented

2023-04-19 13:49:28 +00:00

Collaborator

апр 19 08:01:09 nightly-build-node1 frostfs-ir[6336]: 2023-04-19T05:01:09.828Z        info        container/handlers.go:16        notification        {"type": "container put", "id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd"}
апр 19 08:01:12 nightly-build-node1 frostfs-node[6677]: 2023-04-19T05:01:12.381Z        error        frostfs-node/container.go:139        read newly created container after the notification        {"id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd", "error": "status: code = 3072 message = container not found"}
апр 19 08:01:12 nightly-build-node1 frostfs-node[6677]: 2023-04-19T05:01:12.381Z        debug        frostfs-node/container.go:145        container creation event's receipt        {"id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd"}

looks like bug in neo-go: 2023-04-19T05:01:09.828Z - container created 2023-04-19T05:01:12.381Z - received notification of container put success 2023-04-19T05:01:12.381Z - requested information about the container and did not find it in neo-go ``` апр 19 08:01:09 nightly-build-node1 frostfs-ir[6336]: 2023-04-19T05:01:09.828Z info container/handlers.go:16 notification {"type": "container put", "id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd"} апр 19 08:01:12 nightly-build-node1 frostfs-node[6677]: 2023-04-19T05:01:12.381Z error frostfs-node/container.go:139 read newly created container after the notification {"id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd", "error": "status: code = 3072 message = container not found"} апр 19 08:01:12 nightly-build-node1 frostfs-node[6677]: 2023-04-19T05:01:12.381Z debug frostfs-node/container.go:145 container creation event's receipt {"id": "CRueueBpZMjAdSocYiADfUYMdDp11RPweFcL1fFtWHVd"} ```

dstepanov-yadro referenced a pull request that will close this issue

2023-04-21 08:05:21 +00:00

Invalidate container cache on PutSuccess event #272

fyrchik closed this issue

2023-04-25 12:36:12 +00:00

fyrchik referenced this issue from a commit

2023-04-25 12:36:12 +00:00

[#231] node: Invalidate container cache on PutSuccess event

fyrchik referenced this issue from a commit

2023-04-25 12:36:12 +00:00

[#231] node: Fix race condition in TTL cache

fyrchik referenced this issue from a commit