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.

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

Test: Transaction Expiration Too Far #1093

Open
heifner opened this issue Jan 7, 2025 · 0 comments · May be fixed by #1121
Open

Test: Transaction Expiration Too Far #1093

heifner opened this issue Jan 7, 2025 · 0 comments · May be fixed by #1121
Assignees
Labels
👍 lgtm OCI Work exclusive to OCI team test-bug A test is not working as was intended. test-instability tag issues for flaky tests, high priority to address

Comments

@heifner
Copy link
Member

heifner commented Jan 7, 2025

https://github.com/AntelopeIO/spring/actions/runs/12642997278/job/35228605283

The ship_streamer_test.py (and maybe others) passes testTrxGenDurationSec=60*60 which it appears the trx_generator uses for expiration of transactions. This can cause the transactions to fail.

debug 2025-01-07T01:04:05.672 nodeos    producer_plugin.cpp:2464      log_trx_results      ] [TRX_TRACE] Speculative execution is REJECTING tx: fe541e095fff347226ff7a9dd450dcffc925aba0ad1c7d6f5de724733d5014a6, auth: defproducera : action: eosio:transfer, Transaction expiration is too far in the future relative to the reference time of 2025-01-07T01:04:00.000, expiration is 2025-01-07T02:04:05 and the maximum transaction lifetime is 3600 seconds
debug 2025-01-07T01:04:05.672 nodeos    producer_plugin.cpp:2467      log_trx_results      ] [TRX_TRACE] Speculative execution is REJECTING tx: {"expiration":"2025-01-07T02:04:05","ref_block_num":74,"ref_block_prefix":825951873,"max_net_usage_words":0,"max_cpu_usage_ms":0,"delay_sec":0,"context_free_actions":[{"account":"eosio.null","name":"nonce","authorization":[],"data":{"size":41,"hex":"28303a333a373435363937333039333230323832313132333a31373336323131383435363731333137"},"hex_data":{"size":41,"hex":"28303a333a373435363937333039333230323832313132333a31373336323131383435363731333137"}}],"actions":[{"account":"eosio","name":"transfer","authorization":[{"actor":"defproducera","permission":"active"}],"data":{"size":36,"hex":"60ae423ad15b974a70ae423ad15b974a1027000000000000044355520000000003363036"},"hex_data":{"size":36,"hex":"60ae423ad15b974a70ae423ad15b974a1027000000000000044355520000000003363036"}}]} 
debug 2025-01-07T01:04:05.672 nodeos    producer_plugin.cpp:2470      log_trx_results      ] [TRX_TRACE] Speculative execution is REJECTING tx: {"id":"fe541e095fff347226ff7a9dd450dcffc925aba0ad1c7d6f5de724733d5014a6","block_num":123,"block_time":"2025-01-07T01:04:00.000","producer_block_id":null,"receipt":null,"elapsed":161,"net_usage":0,"scheduled":false,"action_traces":[],"account_ram_delta":null,"except":{"code":3040006,"name":"tx_exp_too_far_exception","message":"Transaction Expiration Too Far","stack":[{"context":{"level":"error","file":"controller.cpp","line":5845,"method":"validate_expiration","hostname":"","thread_name":"nodeos","timestamp":"2025-01-07T01:04:05.671"},"format":"Transaction expiration is too far in the future relative to the reference time of ${reference_time}, expiration is ${trx.expiration} and the maximum transaction lifetime is ${max_til_exp} seconds","data":{"trx.expiration":"2025-01-07T02:04:05","reference_time":"2025-01-07T01:04:00.000","max_til_exp":3600}},{"context":{"level":"warn","file":"controller.cpp","line":5846,"method":"validate_expiration","hostname":"","thread_name":"nodeos","timestamp":"2025-01-07T01:04:05.671"},"format":"","data":{"trx":{"expiration":"2025-01-07T02:04:05","ref_block_num":74,"ref_block_prefix":825951873,"max_net_usage_words":0,"max_cpu_usage_ms":0,"delay_sec":0,"context_free_actions":[{"account":"eosio.null","name":"nonce","authorization":[],"data":"28303a333a373435363937333039333230323832313132333a31373336323131383435363731333137"}],"actions":[{"account":"eosio","name":"transfer","authorization":[{"actor":"defproducera","permission":"active"}],"data":"60ae423ad15b974a70ae423ad15b974a1027000000000000044355520000000003363036"}],"transaction_extensions":[]}}}]},"error_code":"10000000000000000000"} 
debug 2025-01-07T01:04:05.672 nodeos    net_plugin.cpp:3825           operator()           ] bad packed_transaction : Transaction Expiration Too Far
debug 2025-01-07T01:04:05.672 net-1     net_plugin.cpp:4108           operator()           ] signaled NACK, trx-id = fe541e095fff347226ff7a9dd450dcffc925aba0ad1c7d6f5de724733d5014a6 : 3040006 tx_exp_too_far_exception: Transaction Expiration Too Far
Transaction expiration is too far in the future relative to the reference time of 2025-01-07T01:04:00.000, expiration is 2025-01-07T02:04:05 and the maximum transaction lifetime is 3600 seconds
    {"trx.expiration":"2025-01-07T02:04:05","reference_time":"2025-01-07T01:04:00.000","max_til_exp":3600}
    nodeos  controller.cpp:5845 validate_expiration

    {"trx":{"expiration":"2025-01-07T02:04:05","ref_block_num":74,"ref_block_prefix":825951873,"max_net_usage_words":0,"max_cpu_usage_ms":0,"delay_sec":0,"context_free_actions":[{"account":"eosio.null","name":"nonce","authorization":[],"data":"28303a333a373435363937333039333230323832313132333a31373336323131383435363731333137"}],"actions":[{"account":"eosio","name":"transfer","authorization":[{"actor":"defproducera","permission":"active"}],"data":"60ae423ad15b974a70ae423ad15b974a1027000000000000044355520000000003363036"}],"transaction_extensions":[]}}
    nodeos  controller.cpp:5846 validate_expiration

debug 2025-01-07T01:04:05.672 net-1     net_plugin.cpp:2811           rejected_transaction ] not sending rejected transaction fe541e095fff347226ff7a9dd450dcffc925aba0ad1c7d6f5de724733d5014a6
@heifner heifner added test-instability tag issues for flaky tests, high priority to address test-bug A test is not working as was intended. labels Jan 7, 2025
@bhazzard bhazzard added 👍 lgtm and removed triage labels Jan 23, 2025
@bhazzard bhazzard added this to the Spring v1.1.0-rc1 milestone Jan 23, 2025
@heifner heifner self-assigned this Jan 24, 2025
@heifner heifner added the OCI Work exclusive to OCI team label Jan 24, 2025
@heifner heifner moved this from Todo to In Progress in Team Backlog Jan 24, 2025
heifner added a commit that referenced this issue Jan 24, 2025
…seconds. 60 minutes is too close to the limit and can sometimes fail.
@heifner heifner moved this from In Progress to Awaiting Review in Team Backlog Jan 24, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
👍 lgtm OCI Work exclusive to OCI team test-bug A test is not working as was intended. test-instability tag issues for flaky tests, high priority to address
Projects
Status: Awaiting Review
Development

Successfully merging a pull request may close this issue.

3 participants