Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Race in TestAwaitUtilCancelTx caused by the test design #3365

Open
AnnaShaleva opened this issue Mar 19, 2024 · 3 comments · Fixed by #3369, #3391 or #3395
Open

Race in TestAwaitUtilCancelTx caused by the test design #3365

AnnaShaleva opened this issue Mar 19, 2024 · 3 comments · Fixed by #3369, #3391 or #3395
Assignees
@AnnaShaleva
Labels
bug Something isn't working I4 No visible changes S4 Routine test Unit tests U2 Seriously planned
Milestone
v0.106.3

Comments

@AnnaShaleva
Copy link
Member

TestAwaitUtilCancelTx is failing sometimes because of the fact that original transaction is being accepted instead of conflicting one. It happens because chain executor's chain continiousely produces blocks, so occasionally the block is being accepted right after main transaction submission. Go 1.22, macOS, firstly discovered at https://github.com/nspcc-dev/neo-go/actions/runs/8328012697/job/22787046121?pr=3357.

The possible solution is to add two branches into this test. One branch should handle the case of original transaction acceptance, the other branch should handle the conflicting transaction acceptance. This situation is very natural, so let the test follow both cases (similar to the way how TestWalletClaimGas works.

2024-03-18T14:12:38.1281770Z === RUN   TestAwaitUtilCancelTx
2024-03-18T14:12:38.1284550Z     logger.go:146: 2024-03-18T14:11:11.985Z	INFO	initial gas supply is not set or wrong, setting default value	{"InitialGASSupply": "52000000"}
2024-03-18T14:12:38.1289250Z     logger.go:146: 2024-03-18T14:11:11.985Z	INFO	P2PNotaryRequestPayloadPool size is not set or wrong, setting default value	{"P2PNotaryRequestPayloadPoolSize": 1000}
2024-03-18T14:12:38.1293660Z     logger.go:146: 2024-03-18T14:11:11.985Z	INFO	MaxBlockSize is not set or wrong, setting default value	{"MaxBlockSize": 262144}
2024-03-18T14:12:38.1297780Z     logger.go:146: 2024-03-18T14:11:11.985Z	INFO	MaxBlockSystemFee is not set or wrong, setting default value	{"MaxBlockSystemFee": 900000000000}
2024-03-18T14:12:38.1302150Z     logger.go:146: 2024-03-18T14:11:11.985Z	INFO	MaxTransactionsPerBlock is not set or wrong, using default value	{"MaxTransactionsPerBlock": 512}
2024-03-18T14:12:38.1306370Z     logger.go:146: 2024-03-18T14:11:11.986Z	INFO	MaxValidUntilBlockIncrement is not set or wrong, using default value	{"MaxValidUntilBlockIncrement": 864000}
2024-03-18T14:12:38.1310270Z     logger.go:146: 2024-03-18T14:11:11.986Z	INFO	no storage version found! creating genesis block
2024-03-18T14:12:38.1312860Z     logger.go:146: 2024-03-18T14:11:12.032Z	INFO	MaxIteratorResultItems is not set or wrong, setting default value	{"MaxIteratorResultItems": 100}
2024-03-18T14:12:38.1317080Z     logger.go:146: 2024-03-18T14:11:12.033Z	INFO	MaxFindResultItems is not set or wrong, setting default value	{"MaxFindResultItems": 100}
2024-03-18T14:12:38.1321560Z     logger.go:146: 2024-03-18T14:11:12.033Z	INFO	MaxFindStorageResultItems is not set or wrong, setting default value	{"MaxFindStorageResultItems": 50}
2024-03-18T14:12:38.1325620Z     logger.go:146: 2024-03-18T14:11:12.033Z	INFO	MaxNEP11Tokens is not set or wrong, setting default value	{"MaxNEP11Tokens": 100}
2024-03-18T14:12:38.1329240Z     logger.go:146: 2024-03-18T14:11:12.033Z	INFO	MaxRequestBodyBytes is not set or wong, setting default value	{"MaxRequestBodyBytes": 5242880}
2024-03-18T14:12:38.1332860Z     logger.go:146: 2024-03-18T14:11:12.033Z	DEBUG	done processing headers	{"headerIndex": 1, "blockHeight": 0, "took": "634.803µs"}
2024-03-18T14:12:38.1335730Z     logger.go:146: 2024-03-18T14:11:12.033Z	INFO	MaxRequestHeaderBytes is not set or wong, setting default value	{"MaxRequestHeaderBytes": 1048576}
2024-03-18T14:12:38.1338540Z     logger.go:146: 2024-03-18T14:11:12.034Z	INFO	MaxWebSocketClients is not set or wrong, setting default value	{"MaxWebSocketClients": 64}
2024-03-18T14:12:38.1341380Z     logger.go:146: 2024-03-18T14:11:12.034Z	INFO	starting rpc-server	{"endpoint": "127.0.0.1:0"}
2024-03-18T14:12:38.1344790Z     logger.go:146: 2024-03-18T14:11:12.040Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-03-18T14:12:38.1354560Z     logger.go:146: 2024-03-18T14:11:12.042Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-03-18T14:12:38.1356870Z     logger.go:146: 2024-03-18T14:11:12.081Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-03-18T14:12:38.1361330Z     logger.go:146: 2024-03-18T14:11:12.083Z	DEBUG	processing rpc request	{"method": "getnep17balances", "params": "[56c989e76f9a2ca05bb5caa6c96f524d905accd8]"}
2024-03-18T14:12:38.1373300Z     logger.go:146: 2024-03-18T14:11:12.087Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[CxEMFNwk6EPkEi4hj1BzCuuZPYVDDVeBDBTYzFqQTVJvyabKtVugLJpv54nJVhTAHwwIdHJhbnNmZXIMFPVj6kC8KD1NDgXEjqMFs/Kgc0DvQWJ9W1I5 ]"}
2024-03-18T14:12:38.1376930Z     logger.go:146: 2024-03-18T14:11:12.091Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-03-18T14:12:38.1384980Z     logger.go:146: 2024-03-18T14:11:12.092Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AL+xcc+0P5gAAAAAAAAAAAAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQEAKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-03-18T14:12:38.1400300Z     logger.go:146: 2024-03-18T14:11:12.093Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AL+xcc+0P5gAAAAAAPTGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQFCDEA51mOBl0nGji0ZR/T1FTGuRIeBphZ6hut5HtxYtGBhkA55np/tFBSpeLAJdL0zKwtUualypxdPDnaxVBL3/m/IKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-03-18T14:12:38.1408640Z     logger.go:146: 2024-03-18T14:11:12.097Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-03-18T14:12:38.1411190Z     logger.go:146: 2024-03-18T14:11:12.098Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-03-18T14:12:38.1413360Z     logger.go:146: 2024-03-18T14:11:12.114Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-03-18T14:12:38.1417410Z     logger.go:146: 2024-03-18T14:11:12.118Z	DEBUG	processing rpc request	{"method": "getrawtransaction", "params": "[b1b2ba3bc8fbb340cb12841306fc54b8c8fe4477a98956b02fb8f447c578a46b 1]"}
2024-03-18T14:12:38.1427580Z     logger.go:146: 2024-03-18T14:11:12.135Z	DEBUG	done processing headers	{"headerIndex": 2, "blockHeight": 1, "took": "242.594µs"}
2024-03-18T14:12:38.1431180Z     logger.go:146: 2024-03-18T14:11:12.163Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[QA== ]"}
2024-03-18T14:12:38.1433370Z     logger.go:146: 2024-03-18T14:11:12.167Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-03-18T14:12:38.1439410Z     logger.go:146: 2024-03-18T14:11:12.171Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AEK492AAAAAAAAAAAAAAAAAAAAAABQAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBIWukeMVH9LgvsFaJqXdE/si4VPwGE4QSy0Cz+8g7urKxAUABACoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-03-18T14:12:38.1447070Z     logger.go:146: 2024-03-18T14:11:12.172Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AEK492AAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBIWukeMVH9LgvsFaJqXdE/si4VPwGE4QSy0Cz+8g7urKxAUABQgxAKMFykB4BdUMOcwyVKq8OpiTLkCxy0miTzoJZSpWghqf04VXVHNBS0RYZ35suMn4plDa7N8Ky7Dpq5C78J29KPCoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-03-18T14:12:38.1461860Z     logger.go:146: 2024-03-18T14:11:12.173Z	INFO	Error encountered with rpc request	{"code": -507, "cause": "invalid attribute: conflicting transaction b1b2ba3bc8fbb340cb12841306fc54b8c8fe4477a98956b02fb8f447c578a46b is already on chain", "method": "sendrawtransaction", "params": "[AEK492AAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBIWukeMVH9LgvsFaJqXdE/si4VPwGE4QSy0Cz+8g7urKxAUABQgxAKMFykB4BdUMOcwyVKq8OpiTLkCxy0miTzoJZSpWghqf04VXVHNBS0RYZ35suMn4plDa7N8Ky7Dpq5C78J29KPCoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-03-18T14:12:38.1477430Z failed to send conflicting transaction: Invalid transaction attribute (-507) - invalid attribute: conflicting transaction b1b2ba3bc8fbb340cb12841306fc54b8c8fe4477a98956b02fb8f447c578a46b is already on chain
2024-03-18T14:12:38.1482300Z     executor.go:286: 
2024-03-18T14:12:38.1484120Z         	Error Trace:	/Users/runner/work/neo-go/neo-go/internal/testcli/executor.go:286
2024-03-18T14:12:38.1487030Z         	            				/Users/runner/work/neo-go/neo-go/cli/util/util_test.go:171
2024-03-18T14:12:38.1488560Z         	Error:      	Received unexpected error:
2024-03-18T14:12:38.1494180Z         	            	failed to send conflicting transaction: Invalid transaction attribute (-507) - invalid attribute: conflicting transaction b1b2ba3bc8fbb340cb12841306fc54b8c8fe4477a98956b02fb8f447c578a46b is already on chain
2024-03-18T14:12:38.1500160Z         	Test:       	TestAwaitUtilCancelTx
2024-03-18T14:12:38.1502210Z     logger.go:146: 2024-03-18T14:11:12.196Z	INFO	shutting down RPC server	{"endpoint": "127.0.0.1:49239"}
2024-03-18T14:12:38.1505990Z     logger.go:146: 2024-03-18T14:11:12.197Z	INFO	persisted to disk	{"blocks": 2, "keys": 166, "headerHeight": 2, "blockHeight": 2, "took": "121.248µs"}
2024-03-18T14:12:38.1508430Z --- FAIL: TestAwaitUtilCancelTx (0.21s)
2024-03-18T14:12:38.1509280Z FAIL
2024-03-18T14:12:38.1510140Z FAIL	github.com/nspcc-dev/neo-go/cli/util	0.463s
@AnnaShaleva AnnaShaleva added bug Something isn't working test Unit tests U2 Seriously planned S4 Routine I4 No visible changes labels Mar 19, 2024
@AnnaShaleva AnnaShaleva added this to the v0.106.0 milestone Mar 19, 2024
AliceInHunterland added a commit that referenced this issue Mar 20, 2024
@AliceInHunterland
cli: fix TestAwaitUtilCancelTx failing
9a41fa4 
Occasionally the block is being accepted right after main transaction
submission. Added two branches into this TestAwaitUtilCancelTx. One
branch handles the case of original transaction acceptance, the
other branch handles the conflicting transaction acceptance.

Close #3365

Signed-off-by: Ekaterina Pavlova <ekt@morphbits.io>
@AliceInHunterland AliceInHunterland mentioned this issue Mar 20, 2024
Merged
AliceInHunterland added a commit that referenced this issue Mar 22, 2024
@AliceInHunterland
cli: fix TestAwaitUtilCancelTx failing
7f75a72 
Occasionally the block is being accepted right after main transaction
submission. Added two branches into this TestAwaitUtilCancelTx. One
branch handles the case of original transaction acceptance, the
other branch handles the conflicting transaction acceptance.

Close #3365

Signed-off-by: Ekaterina Pavlova <ekt@morphbits.io>
AliceInHunterland added a commit that referenced this issue Mar 22, 2024
@AliceInHunterland
cli: fix TestAwaitUtilCancelTx failing
d80e14d 
Occasionally the block is being accepted right after main transaction
submission. Added two branches into this TestAwaitUtilCancelTx. One
branch handles the case of original transaction acceptance, the
other branch handles the conflicting transaction acceptance.

Close #3365

Signed-off-by: Ekaterina Pavlova <ekt@morphbits.io>
@AnnaShaleva AnnaShaleva reopened this Apr 1, 2024
@AnnaShaleva
Copy link
Member Author

Not fixed, failure discovered in #3387 rebased onto fresh master. The error is:

2024-04-01T16:07:03.8231740Z === RUN   TestAwaitUtilCancelTx
2024-04-01T16:07:03.8234450Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	initial gas supply is not set or wrong, setting default value	{"InitialGASSupply": "52000000"}
2024-04-01T16:07:03.8238700Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	P2PNotaryRequestPayloadPool size is not set or wrong, setting default value	{"P2PNotaryRequestPayloadPoolSize": 1000}
2024-04-01T16:07:03.8243030Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	MaxBlockSize is not set or wrong, setting default value	{"MaxBlockSize": 262144}
2024-04-01T16:07:03.8247200Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	MaxBlockSystemFee is not set or wrong, setting default value	{"MaxBlockSystemFee": 900000000000}
2024-04-01T16:07:03.8250370Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	MaxTransactionsPerBlock is not set or wrong, using default value	{"MaxTransactionsPerBlock": 512}
2024-04-01T16:07:03.8253420Z     logger.go:146: 2024-04-01T16:05:21.609Z	INFO	MaxValidUntilBlockIncrement is not set or wrong, using default value	{"MaxValidUntilBlockIncrement": 864000}
2024-04-01T16:07:03.8257500Z     logger.go:146: 2024-04-01T16:05:21.611Z	INFO	no storage version found! creating genesis block
2024-04-01T16:07:03.8260110Z     logger.go:146: 2024-04-01T16:05:21.617Z	INFO	MaxIteratorResultItems is not set or wrong, setting default value	{"MaxIteratorResultItems": 100}
2024-04-01T16:07:03.8262910Z     logger.go:146: 2024-04-01T16:05:21.617Z	INFO	MaxFindResultItems is not set or wrong, setting default value	{"MaxFindResultItems": 100}
2024-04-01T16:07:03.8265780Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	MaxFindStorageResultItems is not set or wrong, setting default value	{"MaxFindStorageResultItems": 50}
2024-04-01T16:07:03.8268540Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	MaxNEP11Tokens is not set or wrong, setting default value	{"MaxNEP11Tokens": 100}
2024-04-01T16:07:03.8271190Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	MaxRequestBodyBytes is not set or wong, setting default value	{"MaxRequestBodyBytes": 5242880}
2024-04-01T16:07:03.8274050Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	MaxRequestHeaderBytes is not set or wong, setting default value	{"MaxRequestHeaderBytes": 1048576}
2024-04-01T16:07:03.8276850Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	MaxWebSocketClients is not set or wrong, setting default value	{"MaxWebSocketClients": 64}
2024-04-01T16:07:03.8279090Z     logger.go:146: 2024-04-01T16:05:21.618Z	INFO	starting rpc-server	{"endpoint": "127.0.0.1:0"}
2024-04-01T16:07:03.8281280Z     logger.go:146: 2024-04-01T16:05:21.618Z	DEBUG	done processing headers	{"headerIndex": 1, "blockHeight": 0, "took": "393.88µs"}
2024-04-01T16:07:03.8283580Z     logger.go:146: 2024-04-01T16:05:21.620Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-01T16:07:03.8285830Z     logger.go:146: 2024-04-01T16:05:21.622Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-04-01T16:07:03.8288040Z     logger.go:146: 2024-04-01T16:05:21.699Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-01T16:07:03.8291090Z     logger.go:146: 2024-04-01T16:05:21.702Z	DEBUG	processing rpc request	{"method": "getnep17balances", "params": "[56c989e76f9a2ca05bb5caa6c96f524d905accd8]"}
2024-04-01T16:07:03.8295410Z     logger.go:146: 2024-04-01T16:05:21.704Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[CxEMFNwk6EPkEi4hj1BzCuuZPYVDDVeBDBTYzFqQTVJvyabKtVugLJpv54nJVhTAHwwIdHJhbnNmZXIMFPVj6kC8KD1NDgXEjqMFs/Kgc0DvQWJ9W1I5 ]"}
2024-04-01T16:07:03.8298990Z     logger.go:146: 2024-04-01T16:05:21.707Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-04-01T16:07:03.8305210Z     logger.go:146: 2024-04-01T16:05:21.708Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AJ+O0U60P5gAAAAAAAAAAAAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQEAKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-04-01T16:07:03.8316120Z     logger.go:146: 2024-04-01T16:05:21.710Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AJ+O0U60P5gAAAAAAPTGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQFCDEBHS+LsAsy6vRhMf1zAZVKPVci5JESEGGbldIGIjSv/YHOSILofo06298twgq6Rdt4l0N88wO9b4APNkT2oRvzqKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-04-01T16:07:03.8322910Z     logger.go:146: 2024-04-01T16:05:21.714Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-01T16:07:03.8325170Z     logger.go:146: 2024-04-01T16:05:21.716Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-04-01T16:07:03.8327610Z     logger.go:146: 2024-04-01T16:05:21.720Z	DEBUG	done processing headers	{"headerIndex": 2, "blockHeight": 1, "took": "355.844µs"}
2024-04-01T16:07:03.8329930Z     logger.go:146: 2024-04-01T16:05:21.731Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-01T16:07:03.8332840Z     logger.go:146: 2024-04-01T16:05:21.732Z	DEBUG	processing rpc request	{"method": "getrawtransaction", "params": "[5723243dc959a7443cd5b78a2947554515deb0cd8e410b5f20e08f4831b65914 1]"}
2024-04-01T16:07:03.8336030Z transaction 1459b631488fe0205f0b418ecdb0de15455547298ab7d53c44a759c93d242357 is already accepted at block b9b5d74844bc84f4644562b4606dbef666c3cebdf8462d4a71513e3b5749fbec
2024-04-01T16:07:03.8338000Z     executor.go:286: 
2024-04-01T16:07:03.8339200Z         	Error Trace:	/Users/runner/work/neo-go/neo-go/internal/testcli/executor.go:286
2024-04-01T16:07:03.8341080Z         	            				/Users/runner/work/neo-go/neo-go/cli/util/util_test.go:172
2024-04-01T16:07:03.8342100Z         	Error:      	Received unexpected error:
2024-04-01T16:07:03.8344920Z         	            	transaction 1459b631488fe0205f0b418ecdb0de15455547298ab7d53c44a759c93d242357 is already accepted at block b9b5d74844bc84f4644562b4606dbef666c3cebdf8462d4a71513e3b5749fbec
2024-04-01T16:07:03.8346960Z         	Test:       	TestAwaitUtilCancelTx
2024-04-01T16:07:03.8348420Z     logger.go:146: 2024-04-01T16:05:21.733Z	INFO	shutting down RPC server	{"endpoint": "127.0.0.1:49234"}
2024-04-01T16:07:03.8350860Z     logger.go:146: 2024-04-01T16:05:21.736Z	INFO	persisted to disk	{"blocks": 2, "keys": 166, "headerHeight": 2, "blockHeight": 2, "took": "177.485µs"}
2024-04-01T16:07:03.8352530Z --- FAIL: TestAwaitUtilCancelTx (0.13s)
2024-04-01T16:07:03.8353140Z FAIL
2024-04-01T16:07:03.8353710Z FAIL	github.com/nspcc-dev/neo-go/cli/util	0.457s

AnnaShaleva added a commit that referenced this issue Apr 1, 2024
@AnnaShaleva
cli: unify canceltx command output
bff952e 
Always return "Target transaction accepted" if the target transation was
either accepted by the moment of command run or during the command
handling. Exit with code 0 in both cases. Adjust TestAwaitUtilCancelTx
correspondingly, allow both cases in test.

Close #3365.

Signed-off-by: Anna Shaleva <shaleva.ann@nspcc.ru>
AnnaShaleva added a commit that referenced this issue Apr 1, 2024
@AnnaShaleva
cli: unify canceltx command output
8a02621 
Always return "Target transaction accepted" if the target transation was
either accepted by the moment of command run or during the command
handling. Exit with code 0 in both cases. Adjust TestAwaitUtilCancelTx
correspondingly, allow both cases in test. Simplify the test along the
way, remove useless code.

Close #3365.

Signed-off-by: Anna Shaleva <shaleva.ann@nspcc.ru>
@AnnaShaleva AnnaShaleva mentioned this issue Apr 1, 2024
Merged
AnnaShaleva added a commit that referenced this issue Apr 2, 2024
@AnnaShaleva
cli: unify canceltx command output
ac28a1e 
Always return "Target transaction accepted" error if the target transation was
either accepted by the moment of command run or during the command
handling. Exit with code 1 in both cases. Adjust TestAwaitUtilCancelTx
correspondingly, allow both cases in test. Simplify the test along the
way, remove useless code.

Close #3365.

Signed-off-by: Anna Shaleva <shaleva.ann@nspcc.ru>
AnnaShaleva added a commit that referenced this issue Apr 2, 2024
@AnnaShaleva
cli: unify canceltx command output
e0e7fdf 
Always return "Target transaction accepted" error if the target transation was
either accepted by the moment of command run or during the command
handling. Exit with code 1 in both cases. Adjust TestAwaitUtilCancelTx
correspondingly, allow both cases in test. Simplify the test along the
way, remove useless code.

Close #3365.

Signed-off-by: Anna Shaleva <shaleva.ann@nspcc.ru>
@AnnaShaleva
Copy link
Member Author

AnnaShaleva commented Apr 3, 2024 •
edited

Fails with another error case after the last fix. Discovered in #3385.

2024-04-02T17:00:47.8155910Z === RUN   TestAwaitUtilCancelTx
2024-04-02T17:00:47.8157740Z     logger.go:146: 2024-04-02T16:59:13.596Z	INFO	initial gas supply is not set or wrong, setting default value	{"InitialGASSupply": "52000000"}
2024-04-02T17:00:47.8160860Z     logger.go:146: 2024-04-02T16:59:13.596Z	INFO	P2PNotaryRequestPayloadPool size is not set or wrong, setting default value	{"P2PNotaryRequestPayloadPoolSize": 1000}
2024-04-02T17:00:47.8164360Z     logger.go:146: 2024-04-02T16:59:13.596Z	INFO	MaxBlockSize is not set or wrong, setting default value	{"MaxBlockSize": 262144}
2024-04-02T17:00:47.8167270Z     logger.go:146: 2024-04-02T16:59:13.597Z	INFO	MaxBlockSystemFee is not set or wrong, setting default value	{"MaxBlockSystemFee": 900000000000}
2024-04-02T17:00:47.8170180Z     logger.go:146: 2024-04-02T16:59:13.598Z	INFO	MaxTransactionsPerBlock is not set or wrong, using default value	{"MaxTransactionsPerBlock": 512}
2024-04-02T17:00:47.8173250Z     logger.go:146: 2024-04-02T16:59:13.598Z	INFO	MaxValidUntilBlockIncrement is not set or wrong, using default value	{"MaxValidUntilBlockIncrement": 864000}
2024-04-02T17:00:47.8176290Z     logger.go:146: 2024-04-02T16:59:13.599Z	INFO	no storage version found! creating genesis block
2024-04-02T17:00:47.8178890Z     logger.go:146: 2024-04-02T16:59:13.607Z	INFO	MaxIteratorResultItems is not set or wrong, setting default value	{"MaxIteratorResultItems": 100}
2024-04-02T17:00:47.8181730Z     logger.go:146: 2024-04-02T16:59:13.607Z	INFO	MaxFindResultItems is not set or wrong, setting default value	{"MaxFindResultItems": 100}
2024-04-02T17:00:47.8185010Z     logger.go:146: 2024-04-02T16:59:13.607Z	INFO	MaxFindStorageResultItems is not set or wrong, setting default value	{"MaxFindStorageResultItems": 50}
2024-04-02T17:00:47.8188000Z     logger.go:146: 2024-04-02T16:59:13.608Z	INFO	MaxNEP11Tokens is not set or wrong, setting default value	{"MaxNEP11Tokens": 100}
2024-04-02T17:00:47.8191550Z     logger.go:146: 2024-04-02T16:59:13.608Z	INFO	MaxRequestBodyBytes is not set or wong, setting default value	{"MaxRequestBodyBytes": 5242880}
2024-04-02T17:00:47.8194620Z     logger.go:146: 2024-04-02T16:59:13.608Z	INFO	MaxRequestHeaderBytes is not set or wong, setting default value	{"MaxRequestHeaderBytes": 1048576}
2024-04-02T17:00:47.8197470Z     logger.go:146: 2024-04-02T16:59:13.608Z	INFO	MaxWebSocketClients is not set or wrong, setting default value	{"MaxWebSocketClients": 64}
2024-04-02T17:00:47.8288470Z     logger.go:146: 2024-04-02T16:59:13.608Z	INFO	starting rpc-server	{"endpoint": "127.0.0.1:0"}
2024-04-02T17:00:47.8293630Z     logger.go:146: 2024-04-02T16:59:13.612Z	DEBUG	done processing headers	{"headerIndex": 1, "blockHeight": 0, "took": "284.826µs"}
2024-04-02T17:00:47.8296060Z     logger.go:146: 2024-04-02T16:59:13.614Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-02T17:00:47.8298340Z     logger.go:146: 2024-04-02T16:59:13.615Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-04-02T17:00:47.8300590Z     logger.go:146: 2024-04-02T16:59:13.686Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-02T17:00:47.8303250Z     logger.go:146: 2024-04-02T16:59:13.687Z	DEBUG	processing rpc request	{"method": "getnep17balances", "params": "[56c989e76f9a2ca05bb5caa6c96f524d905accd8]"}
2024-04-02T17:00:47.8309500Z     logger.go:146: 2024-04-02T16:59:13.689Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[CxEMFNwk6EPkEi4hj1BzCuuZPYVDDVeBDBTYzFqQTVJvyabKtVugLJpv54nJVhTAHwwIdHJhbnNmZXIMFPVj6kC8KD1NDgXEjqMFs/Kgc0DvQWJ9W1I5 ]"}
2024-04-02T17:00:47.8319730Z     logger.go:146: 2024-04-02T16:59:13.691Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-04-02T17:00:47.9706210Z     logger.go:146: 2024-04-02T16:59:13.692Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AO5z34q0P5gAAAAAAAAAAAAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQEAKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-04-02T17:00:47.9724900Z     logger.go:146: 2024-04-02T16:59:13.693Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AO5z34q0P5gAAAAAAPTGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQFCDEAKEsfNd+KxQLZ6JyXoN8elaug0fN7xY4P1c2GJcRbGCJIhdgUpl+JvOegb3j/eKb2mydhkUOAnNrdWw7DWw3sqKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-04-02T17:00:47.9732150Z     logger.go:146: 2024-04-02T16:59:13.696Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-02T17:00:47.9734460Z     logger.go:146: 2024-04-02T16:59:13.698Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-04-02T17:00:47.9736710Z     logger.go:146: 2024-04-02T16:59:13.711Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-04-02T17:00:47.9739650Z     logger.go:146: 2024-04-02T16:59:13.712Z	DEBUG	processing rpc request	{"method": "getrawtransaction", "params": "[2645a6d6e5b0eb5729f04d83c657f877b06c8389407c1afb4cf67e37001a5f35 1]"}
2024-04-02T17:00:47.9742690Z     logger.go:146: 2024-04-02T16:59:13.712Z	DEBUG	done processing headers	{"headerIndex": 2, "blockHeight": 1, "took": "240.459µs"}
2024-04-02T17:00:47.9745830Z     logger.go:146: 2024-04-02T16:59:13.714Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[QA== ]"}
2024-04-02T17:00:47.9748780Z     logger.go:146: 2024-04-02T16:59:13.715Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-04-02T17:00:47.9753940Z     logger.go:146: 2024-04-02T16:59:13.716Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AEMSQwwAAAAAAAAAAAAAAAAAAAAABQAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBITVfGgA3fvZM+xp8QImDbLB3+FfGg03wKVfrsOXWpkUmAUABACoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-04-02T17:00:47.9762310Z     logger.go:146: 2024-04-02T16:59:13.717Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AEMSQwwAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBITVfGgA3fvZM+xp8QImDbLB3+FfGg03wKVfrsOXWpkUmAUABQgxAEEahFINIcl6HfDfXIsvX7d/XDDaqvLwEafR3N9yFWrSHNtrZTnoVl2eqcg9iwFZUa8NcaSpohszGYvNhMFN87CoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-04-02T17:00:47.9795110Z     logger.go:146: 2024-04-02T16:59:13.717Z	INFO	Error encountered with rpc request	{"code": -507, "cause": "invalid attribute: conflicting transaction 2645a6d6e5b0eb5729f04d83c657f877b06c8389407c1afb4cf67e37001a5f35 is already on chain", "method": "sendrawtransaction", "params": "[AEMSQwwAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBITVfGgA3fvZM+xp8QImDbLB3+FfGg03wKVfrsOXWpkUmAUABQgxAEEahFINIcl6HfDfXIsvX7d/XDDaqvLwEafR3N9yFWrSHNtrZTnoVl2eqcg9iwFZUa8NcaSpohszGYvNhMFN87CoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-04-02T17:00:47.9805980Z failed to send conflicting transaction: Invalid transaction attribute (-507) - invalid attribute: conflicting transaction 2645a6d6e5b0eb5729f04d83c657f877b06c8389407c1afb4cf67e37001a5f35 is already on chain
2024-04-02T17:00:47.9808310Z     executor.go:295: 
2024-04-02T17:00:47.9809530Z         	Error Trace:	/Users/runner/work/neo-go/neo-go/internal/testcli/executor.go:295
2024-04-02T17:00:47.9812120Z         	            				/Users/runner/work/neo-go/neo-go/cli/util/util_test.go:173
2024-04-02T17:00:47.9813230Z         	Error:      	Should be true
2024-04-02T17:00:47.9813970Z         	Test:       	TestAwaitUtilCancelTx
2024-04-02T17:00:47.9815640Z     logger.go:146: 2024-04-02T16:59:13.718Z	INFO	shutting down RPC server	{"endpoint": "127.0.0.1:49228"}
2024-04-02T17:00:47.9818170Z     logger.go:146: 2024-04-02T16:59:13.719Z	INFO	persisted to disk	{"blocks": 2, "keys": 166, "headerHeight": 2, "blockHeight": 2, "took": "122.243µs"}
2024-04-02T17:00:47.9819870Z --- FAIL: TestAwaitUtilCancelTx (0.13s)
2024-04-02T17:00:47.9820480Z FAIL
2024-04-02T17:00:47.9821040Z FAIL	github.com/nspcc-dev/neo-go/cli/util

@AnnaShaleva AnnaShaleva reopened this Apr 3, 2024
AnnaShaleva added a commit that referenced this issue Apr 3, 2024
@AnnaShaleva
cli: ensure all outcomes are handled in TestAwaitUtilCancelTx
b6a9c64 
Close #3365.

Signed-off-by: Anna Shaleva <shaleva.ann@nspcc.ru>
@AnnaShaleva AnnaShaleva mentioned this issue Apr 3, 2024
Merged
@AnnaShaleva
Copy link
Member Author

https://github.com/nspcc-dev/neo-go/actions/runs/8999180144/job/24720829287?pr=3431

2024-05-08T09:08:22.2302570Z === RUN   TestAwaitUtilCancelTx
2024-05-08T09:08:22.2303839Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	initial gas supply is not set or wrong, setting default value	{"InitialGASSupply": "52000000"}
2024-05-08T09:08:22.2305426Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	P2PNotaryRequestPayloadPool size is not set or wrong, setting default value	{"P2PNotaryRequestPayloadPoolSize": 1000}
2024-05-08T09:08:22.2306828Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	MaxBlockSize is not set or wrong, setting default value	{"MaxBlockSize": 262144}
2024-05-08T09:08:22.2308154Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	MaxBlockSystemFee is not set or wrong, setting default value	{"MaxBlockSystemFee": 900000000000}
2024-05-08T09:08:22.2309490Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	MaxTransactionsPerBlock is not set or wrong, using default value	{"MaxTransactionsPerBlock": 512}
2024-05-08T09:08:22.2310947Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	MaxValidUntilBlockIncrement is not set or wrong, using default value	{"MaxValidUntilBlockIncrement": 864000}
2024-05-08T09:08:22.2311808Z     logger.go:146: 2024-05-08T09:07:47.584Z	INFO	no storage version found! creating genesis block
2024-05-08T09:08:22.2313319Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxIteratorResultItems is not set or wrong, setting default value	{"MaxIteratorResultItems": 100}
2024-05-08T09:08:22.2314568Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxFindResultItems is not set or wrong, setting default value	{"MaxFindResultItems": 100}
2024-05-08T09:08:22.2316019Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxFindStorageResultItems is not set or wrong, setting default value	{"MaxFindStorageResultItems": 50}
2024-05-08T09:08:22.2317230Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxNEP11Tokens is not set or wrong, setting default value	{"MaxNEP11Tokens": 100}
2024-05-08T09:08:22.2318540Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxRequestBodyBytes is not set or wong, setting default value	{"MaxRequestBodyBytes": 5242880}
2024-05-08T09:08:22.2319895Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxRequestHeaderBytes is not set or wong, setting default value	{"MaxRequestHeaderBytes": 1048576}
2024-05-08T09:08:22.2321200Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	MaxWebSocketClients is not set or wrong, setting default value	{"MaxWebSocketClients": 64}
2024-05-08T09:08:22.2322061Z     logger.go:146: 2024-05-08T09:07:47.589Z	INFO	starting rpc-server	{"endpoint": "127.0.0.1:0"}
2024-05-08T09:08:22.2323160Z     logger.go:146: 2024-05-08T09:07:47.594Z	DEBUG	done processing headers	{"headerIndex": 1, "blockHeight": 0, "took": "0s"}
2024-05-08T09:08:22.2324169Z     logger.go:146: 2024-05-08T09:07:47.603Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-05-08T09:08:22.2325248Z     logger.go:146: 2024-05-08T09:07:47.605Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-05-08T09:08:22.2326265Z     logger.go:146: 2024-05-08T09:07:47.632Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-05-08T09:08:22.2327698Z     logger.go:146: 2024-05-08T09:07:47.633Z	DEBUG	processing rpc request	{"method": "getnep17balances", "params": "[56c989e76f9a2ca05bb5caa6c96f524d905accd8]"}
2024-05-08T09:08:22.2330088Z     logger.go:146: 2024-05-08T09:07:47.633Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[CxEMFNwk6EPkEi4hj1BzCuuZPYVDDVeBDBTYzFqQTVJvyabKtVugLJpv54nJVhTAHwwIdHJhbnNmZXIMFPVj6kC8KD1NDgXEjqMFs/Kgc0DvQWJ9W1I5 ]"}
2024-05-08T09:08:22.2331122Z     logger.go:146: 2024-05-08T09:07:47.633Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-05-08T09:08:22.2335986Z     logger.go:146: 2024-05-08T09:07:47.633Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AD4acEq0P5gAAAAAAAAAAAAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQEAKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-05-08T09:08:22.2341614Z     logger.go:146: 2024-05-08T09:07:47.633Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AD4acEq0P5gAAAAAAPTGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEAVwsRDBTcJOhD5BIuIY9QcwrrmT2FQw1XgQwU2MxakE1Sb8mmyrVboCyab+eJyVYUwB8MCHRyYW5zZmVyDBT1Y+pAvCg9TQ4FxI6jBbPyoHNA70FifVtSOQFCDEBrQnkAx5HxqAGepLektz7lxOwSRPwDAF/wyED97Y/B020sWCDBJobg5Tz0PC7gZb8m/o2mNzTu8tAK3qGEW1QBKhEMIQKzYiv0AXvf4xfFiu1fTHU/IGt9uJYEb6fXdLvEv3+NwhFBntDcOg==]"}
2024-05-08T09:08:22.2342973Z     logger.go:146: 2024-05-08T09:07:47.671Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-05-08T09:08:22.2344073Z     logger.go:146: 2024-05-08T09:07:47.671Z	DEBUG	processing rpc request	{"method": "getnativecontracts", "params": "[]"}
2024-05-08T09:08:22.2345095Z     logger.go:146: 2024-05-08T09:07:47.680Z	DEBUG	processing rpc request	{"method": "getversion", "params": "[]"}
2024-05-08T09:08:22.2346755Z     logger.go:146: 2024-05-08T09:07:47.688Z	DEBUG	processing rpc request	{"method": "getrawtransaction", "params": "[9f553994099d9369947f1ac8eb691c850be9ef57757a4b72933a27f9ff17b520 1]"}
2024-05-08T09:08:22.2348018Z     logger.go:146: 2024-05-08T09:07:47.689Z	DEBUG	processing rpc request	{"method": "invokescript", "params": "[QA== ]"}
2024-05-08T09:08:22.2349105Z     logger.go:146: 2024-05-08T09:07:47.689Z	DEBUG	processing rpc request	{"method": "getblockcount", "params": "[]"}
2024-05-08T09:08:22.2350250Z     logger.go:146: 2024-05-08T09:07:47.689Z	DEBUG	done processing headers	{"headerIndex": 2, "blockHeight": 1, "took": "0s"}
2024-05-08T09:08:22.2353244Z     logger.go:146: 2024-05-08T09:07:47.689Z	DEBUG	processing rpc request	{"method": "calculatenetworkfee", "params": "[AP/qdYsAAAAAAAAAAAAAAAAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBISC1F//5JzqTckt6dVfv6QuFHGnryBp/lGmTnQmUOVWfAUABACoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-05-08T09:08:22.2357305Z     logger.go:146: 2024-05-08T09:07:47.689Z	DEBUG	processing rpc request	{"method": "sendrawtransaction", "params": "[AP/qdYsAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBISC1F//5JzqTckt6dVfv6QuFHGnryBp/lGmTnQmUOVWfAUABQgxAbTeKQfsJttEma5wY1AtY7flmJ5WVPtyyLOoPkS/eH6tH6jnJCph9kiVyQmw4ocZsg7k6GLEHYaJy0JuRniezHSoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-05-08T09:08:22.2362840Z     logger.go:146: 2024-05-08T09:07:47.693Z	INFO	Error encountered with rpc request	{"code": -507, "cause": "invalid attribute: conflicting transaction 9f553994099d9369947f1ac8eb691c850be9ef57757a4b72933a27f9ff17b520 is already on chain", "method": "sendrawtransaction", "params": "[AP/qdYsAAAAAAAAAAPXGEgAAAAAABAAAAAHYzFqQTVJvyabKtVugLJpv54nJVgEBISC1F//5JzqTckt6dVfv6QuFHGnryBp/lGmTnQmUOVWfAUABQgxAbTeKQfsJttEma5wY1AtY7flmJ5WVPtyyLOoPkS/eH6tH6jnJCph9kiVyQmw4ocZsg7k6GLEHYaJy0JuRniezHSoRDCECs2Ir9AF73+MXxYrtX0x1PyBrfbiWBG+n13S7xL9/jcIRQZ7Q3Do=]"}
2024-05-08T09:08:22.2364530Z failed to send conflicting transaction: Invalid transaction attribute (-507) - invalid attribute: conflicting transaction 9f553994099d9369947f1ac8eb691c850be9ef57757a4b72933a27f9ff17b520 is already on chain
2024-05-08T09:08:22.2366831Z     util_test.go:190: unexpected error: failed to send conflicting transaction: Invalid transaction attribute (-507) - invalid attribute: conflicting transaction 9f553994099d9369947f1ac8eb691c850be9ef57757a4b72933a27f9ff17b520 is already on chain
2024-05-08T09:08:22.2368084Z     logger.go:146: 2024-05-08T09:07:47.694Z	INFO	shutting down RPC server	{"endpoint": "127.0.0.1:49789"}
2024-05-08T09:08:22.2369385Z     logger.go:146: 2024-05-08T09:07:47.696Z	INFO	persisted to disk	{"blocks": 2, "keys": 166, "headerHeight": 2, "blockHeight": 2, "took": "0s"}
2024-05-08T09:08:22.2369695Z --- FAIL: TestAwaitUtilCancelTx (0.11s)
2024-05-08T09:08:22.2369812Z FAIL
2024-05-08T09:08:22.2370165Z FAIL	github.com/nspcc-dev/neo-go/cli/util	0.598s

@AnnaShaleva AnnaShaleva reopened this May 13, 2024
@roman-khimov roman-khimov removed this from the v0.106.0 milestone May 13, 2024
@roman-khimov roman-khimov added this to the v0.107.0 milestone May 13, 2024
@AnnaShaleva AnnaShaleva modified the milestones: v0.107.0, v0.106.1 May 21, 2024
@roman-khimov roman-khimov modified the milestones: v0.106.1, v0.106.2 Jun 1, 2024
@roman-khimov roman-khimov modified the milestones: v0.106.2, v0.106.3 Jun 11, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@AnnaShaleva AnnaShaleva

Labels
bug Something isn't working I4 No visible changes S4 Routine test Unit tests U2 Seriously planned
Projects
None yet
Milestone
v0.106.3
3 participants
@roman-khimov @AnnaShaleva @AliceInHunterland