Parent Log:
http://ci.aztec-labs.com/3331709b9043bb65
Command: 97e7ef9a556fd7e6:ISOLATE=1:NAME=e2e_max_block_number yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_max_block_number.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/015cb0cadef6a41094c3649f32a735392e1b9693
Env: REF_NAME=gh-readonly-queue/master/pr-15027-e9a2301883801edbe36ea8bba05dcca7e714f30a CURRENT_VERSION=0.87.8 CI_FULL=1
Date: Wed Jun 18 14:23:38 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15027_amd64_x2-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_d488fdfe97c9ae48_master
14:23:38 +++ id -u
14:23:38 +++ id -g
14:23:38 ++ docker run -d --name e2e_max_block_number --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_max_block_number.test.ts'\'''
14:23:39 + cid=9f898a80640189faef29c97b4be9e47749a4126f5f750282f14294d812c3bf85
14:23:39 + set +x
14:23:39 {"level":25,"time":1750256619783,"pid":12,"hostname":"9f898a806401","module":"logger","msg":"Logger initialized with level verbose"}
14:23:46 [14:23:46.770]
INFO:
e2e:e2e_max_block_number Logging metrics to log/unknown.jsonl
14:23:47 [14:23:47.154]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-SFJ6iu/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads.
14:23:47 [14:23:47.279]
INFO:
e2e:e2e_max_block_number Calling anvil_setBlockTimestampInterval with params: [12]
14:23:47 [14:23:47.356]
WARN:
e2e:e2e_max_block_number Set block interval to 12
14:23:47 [14:23:47.360]
VERBOSE:
e2e:e2e_max_block_number Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
14:23:47 [14:23:47.486]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84
{"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"}
14:23:47 [14:23:47.500]
VERBOSE:
e2e:e2e_max_block_number Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3
14:23:47 [14:23:47.526]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb
{"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"}
14:23:47 [14:23:47.533]
VERBOSE:
e2e:e2e_max_block_number Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512
14:23:47 [14:23:47.553]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169
{"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"}
14:23:47 [14:23:47.558]
VERBOSE:
e2e:e2e_max_block_number Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0
14:23:47 [14:23:47.576]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c
{"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"}
14:23:47 [14:23:47.589]
VERBOSE:
e2e:e2e_max_block_number Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9
14:23:47 [14:23:47.614]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e
{"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"}
14:23:47 [14:23:47.624]
VERBOSE:
e2e:e2e_max_block_number Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9
14:23:47 [14:23:47.649]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64
{"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"}
14:23:47 [14:23:47.664]
VERBOSE:
e2e:e2e_max_block_number Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707
14:23:47 [14:23:47.665]
VERBOSE:
e2e:e2e_max_block_number Waiting for deployments to complete
14:23:47 [14:23:47.665]
INFO:
e2e:e2e_max_block_number Waiting for 6 transactions to be mined...
14:23:47 [14:23:47.689]
INFO:
e2e:e2e_max_block_number All transactions mined successfully
14:23:47 [14:23:47.709]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8
{"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"}
14:23:47 [14:23:47.709]
VERBOSE:
e2e:e2e_max_block_number Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8
14:23:47 [14:23:47.730]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63
{"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"}
14:23:47 [14:23:47.756]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf
{"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"}
14:23:47 [14:23:47.765]
VERBOSE:
e2e:e2e_max_block_number Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6
14:23:47 [14:23:47.794]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2
{"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"}
14:23:47 [14:23:47.795]
VERBOSE:
e2e:e2e_max_block_number Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2
14:23:47 [14:23:47.823]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1
{"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"}
14:23:47 [14:23:47.831]
VERBOSE:
e2e:e2e_max_block_number Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788
14:23:47 [14:23:47.849]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a
{"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"}
14:23:47 [14:23:47.849]
VERBOSE:
e2e:e2e_max_block_number Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a
14:23:47 [14:23:47.849]
VERBOSE:
e2e:e2e_max_block_number Waiting for deployments to complete
14:23:47 [14:23:47.849]
INFO:
e2e:e2e_max_block_number Waiting for 8 transactions to be mined...
14:23:47 [14:23:47.869]
INFO:
e2e:e2e_max_block_number All transactions mined successfully
14:23:47 [14:23:47.878]
VERBOSE:
e2e:e2e_max_block_number Deployed shared contracts
14:23:47 [14:23:47.902]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034
{"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"}
14:23:47 [14:23:47.903]
VERBOSE:
e2e:e2e_max_block_number Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034
14:23:47 [14:23:47.908]
VERBOSE:
e2e:e2e_max_block_number Rollup config args
{"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100}
14:23:47 [14:23:47.920]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c
{"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"}
14:23:47 [14:23:47.951]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a
{"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"}
14:23:47 [14:23:47.957]
VERBOSE:
e2e:e2e_max_block_number Awaiting for linked libraries to be deployed
14:23:48 [14:23:48.007]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x4d2927b4b3d55da26ff6e0063683b8b3c116f278421747d2cb87e20187debbff
{"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"}
14:23:48 [14:23:48.016]
VERBOSE:
e2e:e2e_max_block_number Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016
{"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100}
14:23:48 [14:23:48.016]
INFO:
e2e:e2e_max_block_number Waiting for 9 transactions to be mined...
14:23:48 [14:23:48.060]
INFO:
e2e:e2e_max_block_number All transactions mined successfully
14:23:48 [14:23:48.063]
VERBOSE:
e2e:e2e_max_block_number All core contracts have been deployed
14:23:48 [14:23:48.090]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a
{"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"}
14:23:48 [14:23:48.090]
VERBOSE:
e2e:e2e_max_block_number Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments)
14:23:48 [14:23:48.105]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a
{"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"}
14:23:48 [14:23:48.111]
VERBOSE:
e2e:e2e_max_block_number Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae
14:23:48 [14:23:48.137]
VERBOSE:
e2e:e2e_max_block_number Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776
{"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"}
14:23:48 [14:23:48.138]
VERBOSE:
e2e:e2e_max_block_number Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776
14:23:48 [14:23:48.138]
INFO:
e2e:e2e_max_block_number Waiting for 10 transactions to be mined...
14:23:48 [14:23:48.160]
INFO:
e2e:e2e_max_block_number All transactions mined successfully
14:23:48 [14:23:48.173]
VERBOSE:
e2e:e2e_max_block_number Rollup deployed
14:23:48 [14:23:48.173]
VERBOSE:
e2e:e2e_max_block_number Waiting for rollup and slash factory to be deployed
14:23:48 [14:23:48.173]
INFO:
e2e:e2e_max_block_number Waiting for 10 transactions to be mined...
14:23:48 [14:23:48.199]
INFO:
e2e:e2e_max_block_number All transactions mined successfully
14:23:48 [14:23:48.199]
VERBOSE:
e2e:e2e_max_block_number All transactions for L1 deployment have been mined
14:23:48 [14:23:48.228]
INFO:
e2e:e2e_max_block_number Aztec L1 contracts initialized
{"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
14:23:48 [14:23:48.232]
INFO:
ethereum:cheat_codes Calling anvil_getAutomine with params: [] on
http://127.0.0.1:8545
14:23:48 [14:23:48.236]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:48 [14:23:48.237]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016
14:23:48 [14:23:48.238]
INFO:
telemetry:client Using NoopTelemetryClient
14:23:48 [14:23:48.244]
WARN:
aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks
14:23:48 [14:23:48.245]
INFO:
ethereum:cheat_codes Calling evm_mine with params: [] on
http://127.0.0.1:8545
14:23:48 [14:23:48.246]
INFO:
kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/bcc3bfc678f602a3/blob-sink with map size 134217728 KB (LMDB v2)
14:23:48 [14:23:48.249]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:48 [14:23:48.251]
INFO:
aztecjs:utils:watcher New L1 time: 1750256866
14:23:48 [14:23:48.252]
WARN:
foundation:test-date-provider Time set to 2025-06-18T14:27:46.000Z
{"offset":237748,"timeMs":1750256866000}
14:23:48 [14:23:48.254]
INFO:
kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16
14:23:48 [14:23:48.263]
INFO:
blob-sink:server Server is running on
http://localhost:43949
14:23:48 [14:23:48.263]
VERBOSE:
e2e:e2e_max_block_number Creating and synching an aztec node...
14:23:48 [14:23:48.264]
VERBOSE:
e2e:e2e_max_block_number Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/f25ea097/acvm
14:23:48 [14:23:48.265]
INFO:
node:blob-sink:client Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:43949"}
14:23:48 [14:23:48.305]
VERBOSE:
node Snapshot sync is disabled. No snapshots URL provided.
14:23:48 [14:23:48.307]
INFO:
archiver:lmdb Creating archiver data store at directory /tmp/bcc3bfc678f602a3/archiver with map size 134217728 KB (LMDB v2)
14:23:48 [14:23:48.314]
INFO:
archiver:lmdb Starting data store with maxReaders 16
14:23:48 [14:23:48.507]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:48 [14:23:48.742]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:48 [14:23:48.752]
INFO:
node:blob-sink:client Testing configured blob sources
{"blobSinkUrl":"http://localhost:43949"}
14:23:48 [14:23:48.770]
INFO:
node:blob-sink:client Blob sink is reachable
{"blobSinkUrl":"http://localhost:43949"}
14:23:48 [14:23:48.770]
WARN:
node:blob-sink:client No L1 consensus host urls configured
14:23:48 [14:23:48.770]
WARN:
node:blob-sink:client No archive client configured
14:23:48 [14:23:48.773]
INFO:
archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xd8a5e88c60118249a992103c891517d91b6c0edac1d89b5ff4cbcd6cd021871f
{"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xf2fd1f53cb6ed185fb9f1cef907580d24d7b53845ede5a18a73c4b19aa86264b","l1BlockNumber":16}}
14:23:48 [14:23:48.787]
INFO:
archiver Initial archiver sync to L1 block 20 complete.
{"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
14:23:48 [14:23:48.795]
INFO:
world-state:database Creating world state data store at directory /tmp/bcc3bfc678f602a3/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
14:23:48 [14:23:48.818]
INFO:
world_state Created world state synchroniser with block history of 64
14:23:48 [14:23:48.818]
WARN:
node Aztec node is accepting fake proofs
14:23:48 [14:23:48.828]
INFO:
p2p:lmdb-v2 Creating p2p data store at directory /tmp/bcc3bfc678f602a3/p2p with map size 134217728 KB (LMDB v2)
14:23:48 [14:23:48.830]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
14:23:48 [14:23:48.831]
INFO:
p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/bcc3bfc678f602a3/p2p-archive with map size 134217728 KB (LMDB v2)
14:23:48 [14:23:48.832]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
14:23:48 [14:23:48.833]
INFO:
p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/bcc3bfc678f602a3/p2p-peers with map size 134217728 KB (LMDB v2)
14:23:48 [14:23:48.834]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
14:23:48 [14:23:48.835]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
14:23:48 [14:23:48.836]
VERBOSE:
p2p P2P is disabled. Using dummy P2P service
14:23:48 [14:23:48.838]
VERBOSE:
world-state:block_stream Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
14:23:48 [14:23:48.839]
INFO:
world_state Started world state synchronizer from block 1
14:23:48 [14:23:48.841]
VERBOSE:
world-state:block_stream Starting sync from block number 0
14:23:48 [14:23:48.842]
INFO:
p2p Starting p2p client from block 0 with empty mempools
14:23:48 [14:23:48.843]
VERBOSE:
p2p:l2-block-stream Starting L2 block stream
{"batchSize":20,"pollIntervalMS":100,"startingBlock":0}
14:23:48 [14:23:48.844]
INFO:
slasher Slasher client initialized
14:23:48 [14:23:48.844]
INFO:
slasher Starting Slasher client...
14:23:48 [14:23:48.872]
VERBOSE:
validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
14:23:48 [14:23:48.873]
VERBOSE:
node All Aztec Node subsystems synced
14:23:48 [14:23:48.883]
INFO:
sequencer-client Deploying forwarder contract
14:23:48 [14:23:48.892]
VERBOSE:
p2p:l2-block-stream Starting sync from block number 0
14:23:48 [14:23:48.907]
VERBOSE:
sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968
{"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"}
14:23:48 [14:23:48.907]
VERBOSE:
sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968.
14:23:48 [14:23:48.912]
INFO:
sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
14:23:48 [14:23:48.925]
INFO:
validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
14:23:48 [14:23:48.926]
VERBOSE:
validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0
14:23:48 [14:23:48.926]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/f25ea097/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false}
14:23:49 [14:23:49.162]
VERBOSE:
sequencer Sequencer timetable updated
{"enforceTimeTable":false}
14:23:49 [14:23:49.165]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
14:23:49 [14:23:49.166]
INFO:
node Aztec Node version: 0.87.8
14:23:49 [14:23:49.167]
INFO:
node Aztec Node started on chain 0x7a69
{"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"}
14:23:49 [14:23:49.168]
VERBOSE:
e2e:e2e_max_block_number Creating a pxe...
14:23:49 [14:23:49.172]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:49 [14:23:49.182]
INFO:
pxe:data:lmdb Creating pxe_data data store at directory /tmp/97f3cec5418cb805/pxe_data with map size 134217728 KB (LMDB v2)
14:23:49 [14:23:49.195]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:49 [14:23:49.196]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
14:23:49 [14:23:49.457]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:49 [14:23:49.579]
VERBOSE:
pxe:service Registered protocol contracts in pxe
{"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"}
14:23:49 [14:23:49.580]
INFO:
pxe:service Started PXE connected to chain 31337 version 3957803416
14:23:49 [14:23:49.671]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:49 [14:23:49.698]
INFO:
pxe:service Registered account 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800
14:23:49 [14:23:49.792]
WARN:
pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata
14:23:49 [14:23:49.794]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800
14:23:49 [14:23:49.824]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:49 [14:23:49.925]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:49 [14:23:49.996]
INFO:
pxe:service Added contract SchnorrAccount at 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a
14:23:50 [14:23:50.105]
VERBOSE:
pxe:block_stream Starting sync from block number 0
14:23:50 [14:23:50.151]
VERBOSE:
simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"}
14:23:50 [14:23:50.212]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:50 [14:23:50.296]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
14:23:51 [14:23:51.102]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c
14:23:51 [14:23:51.214]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
14:23:51 [14:23:51.283]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:51 [14:23:51.343]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:51 [14:23:51.404]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:constructor
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.440]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:23:51 [14:23:51.441]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.488]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.492]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:23:51 [14:23:51.495]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:51 [14:23:51.675]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.713]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:23:51 [14:23:51.713]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.740]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:51 [14:23:51.757]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:51 [14:23:51.762]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:23:51 [14:23:51.799]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:23:51 [14:23:51.912]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:52 [14:23:52.154]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:52 [14:23:52.518]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:52 [14:23:52.823]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:52 [14:23:52.833]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:53 [14:23:53.175]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:53 [14:23:53.806]
INFO:
pxe:service Proving completed in 3719.1751569999997ms
{"timings":{"total":3719.1751569999997,"sync":18.935757999999623,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":194.3039009999975,"oracles":{"callPrivateFunction":{"times":[1067.7310290000005,329.81351899999936,211.48229300000094]}}},{"functionName":"private_kernel_init","time":232.4989540000006},{"functionName":"ContractClassRegisterer:register","time":1036.3491300000005,"oracles":{"loadCapsule":{"times":[33.58170500000051]},"notifyCreatedNullifier":{"times":[0.9764600000016799]},"debugLog":{"times":[0.9798510000000533]},"notifyCreatedContractClassLog":{"times":[12.143534999999247]}}},{"functionName":"private_kernel_inner","time":157.10011000000122},{"functionName":"SchnorrAccount:constructor","time":298.1531529999993,"oracles":{"getContractInstance":{"times":[1.9825419999997393]},"debugLog":{"times":[0.6160029999991821,0.4618300000001909]},"fetchTaggedLogs":{"times":[49.664292999999816]},"loadCapsule":{"times":[0.3393070000001899,0.3351170000005368,3.293799000000945]},"notifyCreatedNullifier":{"times":[0.254014999998617,0.26217499999984284]},"notifyCreatedNote":{"times":[0.434159999998883]},"getRandomField":{"times":[0.41319900000053167,0.22994499999913387,0.13528300000143645,0.08772200000021257,0.07800200000019686,0.05940099999861559,0.12907300000006217,0.05412199999955192,0.056640999999217456,0.08727100000032806,0.04423099999985425]},"getIndexedTaggingSecretAsSender":{"times":[50.61947300000065]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.341255999999703]}}},{"functionName":"private_kernel_inner","time":144.2502999999997},{"functionName":"SchnorrAccount:entrypoint","time":185.58666900000208,"oracles":{"debugLog":{"times":[0.5828220000003057,0.6817449999998644,1.1296339999989868]},"fetchTaggedLogs":{"times":[47.381484999999884]},"loadCapsule":{"times":[0.33134700000118755,0.3760579999998299,0.37820800000008603]},"getNotes":{"times":[12.086934000000838]},"getAuthWitness":{"times":[0.4796200000000681]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.5532129999992321]}}},{"functionName":"private_kernel_inner","time":228.57577200000014},{"functionName":"private_kernel_reset","time":208.01391999999942},{"functionName":"private_kernel_tail","time":101.77826800000003}],"unaccounted":913.6292219999996}}
14:23:53 [14:23:53.837]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:53 [14:23:53.909]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","blockNumber":1,"slot":2}
14:23:53 [14:23:53.990]
VERBOSE:
p2p:tx_pool Adding tx 0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f to pool
{"eventName":"tx-added-to-pool","txHash":"0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"}
14:23:54 [14:23:54.021]
INFO:
node Received tx 0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f
{"txHash":"0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f"}
14:23:54 [14:23:54.021]
INFO:
pxe:service Sent transaction 0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f
14:23:54 [14:23:54.046]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:54 [14:23:54.250]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:54 [14:23:54.439]
VERBOSE:
sequencer Building block 1 for slot 2
{"slot":2,"blockNumber":1,"msgCount":0}
14:23:54 [14:23:54.458]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:54 [14:23:54.460]
VERBOSE:
sequencer Processing pending txs
{"slot":2,"slotStart":"2025-06-18T14:28:10.000Z","now":"2025-06-18T14:27:52.208Z"}
14:23:54 [14:23:54.770]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:54 [14:23:54.896]
VERBOSE:
simulator:public-processor Processed tx 0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f with no public calls in 295.13480900000104ms
{"txHash":"0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":295.13480900000104}
14:23:54 [14:23:54.902]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.44060086500000034s
{"duration":0.44060086500000034,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344}
14:23:55 [14:23:55.095]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:55 [14:23:55.107]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x08012ca212fbc1b74502c14278eba1538fbf688f1b7086457e1f2fe94014cb6c","globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":1,"slotNumber":2,"timestamp":1750256890,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1646ea20f361665de9c236e263480d28cfdb80b7155f5fb9d783655ac9cecb4f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":668.6599260000003,"publicProcessDuration":441.9145440000011,"rollupCircuitsDuration":650.8382320000001,"txCount":1,"blockNumber":1,"blockTimestamp":1750256890,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:23:55 [14:23:55.110]
VERBOSE:
sequencer Attesting committee is empty
14:23:55 [14:23:55.301]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:55 [14:23:55.630]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:55 [14:23:55.635]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x389de715f22971110f993574d02d404b37fe4a6f5c730aa1a98093cee3c685fb
14:23:55 [14:23:55.636]
VERBOSE:
sequencer-client Sent L1 transaction 0x389de715f22971110f993574d02d404b37fe4a6f5c730aa1a98093cee3c685fb
{"gasLimit":514521,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"}
14:23:55 [14:23:55.651]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:23:55 [14:23:55.653]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x389de715f22971110f993574d02d404b37fe4a6f5c730aa1a98093cee3c685fb","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1750256890,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:23:55 [14:23:55.653]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
14:23:55 [14:23:55.676]
INFO:
blob-sink:server Received blob sidecar for block 0x0d13f439e373bcf97de926636ee2d6c1003359d09017aa860391fdfb7055e205
14:23:55 [14:23:55.686]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x0d13f439e373bcf97de926636ee2d6c1003359d09017aa860391fdfb7055e205
14:23:55 [14:23:55.840]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:55 [14:23:55.855]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on
http://127.0.0.1:8545
14:23:55 [14:23:55.862]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
14:23:55 [14:23:55.868]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
14:23:55 [14:23:55.882]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256926] on
http://127.0.0.1:8545
14:23:55 [14:23:55.885]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
14:23:55 [14:23:55.889]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750256926
14:23:55 [14:23:55.890]
WARN:
foundation:test-date-provider Time set to 2025-06-18T14:28:46.000Z
{"offset":290110,"timeMs":1750256926000}
14:23:55 [14:23:55.890]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
14:23:56 [14:23:56.156]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:56 [14:23:56.212]
VERBOSE:
archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a
14:23:56 [14:23:56.233]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x08012ca212fbc1b74502c14278eba1538fbf688f1b7086457e1f2fe94014cb6c","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":1,"slotNumber":2,"timestamp":1750256890,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","archiveNextLeafIndex":2}
14:23:56 [14:23:56.243]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
14:23:56 [14:23:56.770]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:56 [14:23:56.776]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":472.37682300000233,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750256890,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:23:56 [14:23:56.779]
WARN:
pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata
14:23:56 [14:23:56.794]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757
14:23:57 [14:23:57.006]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:57 [14:23:57.112]
VERBOSE:
p2p Synched to latest block 1
14:23:57 [14:23:57.437]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:57 [14:23:57.455]
INFO:
pxe:service Added contract Test at 0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f
14:23:57 [14:23:57.487]
VERBOSE:
pxe:service Updated pxe last block to 1
{"blockHash":{},"archive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","header":{"contentCommitment":{"blobsHash":"0x00a1146608526c63f1b5d96d3a992f88f590d81494fc82b67738af8a2f96766a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750256890,"version":3957803416},"lastArchive":"0x00043f8b393b4b192c212f03a2e6c265076f4033bbf618800a685d416d2a7d95","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2f77ca8c80ac69fdc85adee974e7bf34c7a47af26563def1b16168be72681e37","nullifierTree":"0x24f30121e545aa206e3aafc24e71bacab8bb2482e1531b567615dbb2b2d16626","publicDataTree":"0x2d7a8586b02a264739e3986240b8b49ab95535c18d78209471ae517eb415f430"},"totalFees":6794052480,"totalManaUsed":20448}}
14:23:57 [14:23:57.606]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:57 [14:23:57.651]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:23:57 [14:23:57.652]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:57 [14:23:57.655]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:57 [14:23:57.766]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:23:57 [14:23:57.803]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:23:57 [14:23:57.808]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:23:57 [14:23:57.823]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:23:57 [14:23:57.824]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:23:57 [14:23:57.833]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:23:57 [14:23:57.833]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:23:57 [14:23:57.838]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:23:57 [14:23:57.840]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:23:57 [14:23:57.855]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:23:57 [14:23:57.872]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:57 [14:23:57.900]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
14:23:58 [14:23:58.459]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e
14:23:58 [14:23:58.567]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
14:23:58 [14:23:58.629]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:58 [14:23:58.694]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
14:23:58 [14:23:58.714]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:23:58 [14:23:58.747]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
14:23:58 [14:23:58.757]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757,0x0000000000000000000000000000000000000000000000000000000000000001,0x1fc58f7bb0504290a72cff7790a60808f7eee908eeb97cb26c01b81709914bf2,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800
14:23:58 [14:23:58.913]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:59 [14:23:59.208]
VERBOSE:
simulator:private_execution Executing private function Test:initialize
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:23:59 [14:23:59.239]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:23:59 [14:23:59.239]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:23:59 [14:23:59.268]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:59 [14:23:59.270]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:23:59 [14:23:59.470]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:59 [14:23:59.488]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:23:59 [14:23:59.494]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:23:59 [14:23:59.692]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:59 [14:23:59.908]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:23:59 [14:23:59.925]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:24:00 [14:24:00.125]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:00 [14:24:00.346]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:00 [14:24:00.633]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:00 [14:24:00.902]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:01 [14:24:01.329]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:01 [14:24:01.341]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:24:01 [14:24:01.866]
INFO:
pxe:service Proving completed in 4388.963696999999ms
{"timings":{"total":4388.963696999999,"sync":13.07631400000173,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":515.8596169999983,"oracles":{"debugLog":{"times":[0.9367889999994077,0.45979000000079395,0.6573740000021644,0.7610760000025039,0.6634840000006079,0.5161709999993036,0.3263070000029984,0.5554119999978866]},"fetchTaggedLogs":{"times":[153.3674310000024]},"loadCapsule":{"times":[0.24293499999839696,0.4316690000014205,0.6290140000019164,0.215714999998454,0.18358400000215624,0.16907400000127382]},"getSharedSecret":{"times":[6.441334999999526]},"aes128Decrypt":{"times":[1.5977029999994556,0.883228999999119]},"getPublicKeysAndPartialAddress":{"times":[2.200595999998768]},"getKeyValidationRequest":{"times":[2.457310999998299]},"deliverNote":{"times":[4.6880290000008245]},"deleteCapsule":{"times":[0.4029289999998582]},"storeCapsule":{"times":[0.30743599999914295]},"getNotes":{"times":[3.5498440000010305]},"getAuthWitness":{"times":[0.19722399999955087]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06081100000301376]},"callPrivateFunction":{"times":[767.966032999997,137.33149400000184,739.6278659999989]}}},{"functionName":"private_kernel_init","time":63.72451899999942},{"functionName":"ContractClassRegisterer:register","time":748.3892220000016,"oracles":{"loadCapsule":{"times":[6.239481000000524]},"notifyCreatedNullifier":{"times":[0.6980250000015076]},"debugLog":{"times":[0.7593959999976505]},"notifyCreatedContractClassLog":{"times":[13.843430000000808]}}},{"functionName":"private_kernel_inner","time":110.23425599999973},{"functionName":"ContractInstanceDeployer:deploy","time":83.04788399999961,"oracles":{"storeInExecutionCache":{"times":[0.23962499999834108]},"callPrivateFunction":{"times":[54.00253399999929]},"notifyCreatedNullifier":{"times":[0.23686499999894295]},"debugLog":{"times":[0.5005610000007437]}}},{"functionName":"private_kernel_inner","time":121.04378199999701},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.680537000000186,"oracles":{}},{"functionName":"private_kernel_inner","time":110.24483600000167},{"functionName":"Test:initialize","time":590.0595549999998,"oracles":{"getContractInstance":{"times":[10.648213000000396]},"debugLog":{"times":[0.7044150000001537,0.5126610000006622]},"fetchTaggedLogs":{"times":[252.84906099999716]},"loadCapsule":{"times":[0.35939800000051036,0.38713799999823095,0.42205900000044494]},"notifyCreatedNullifier":{"times":[0.3382369999999355]}}},{"functionName":"private_kernel_inner","time":162.4059410000009},{"functionName":"private_kernel_reset","time":249.03452099999777},{"functionName":"private_kernel_tail","time":96.02149699999791}],"unaccounted":1483.1412160000036}}
14:24:01 [14:24:01.883]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.037]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","blockNumber":2,"slot":3}
14:24:02 [14:24:02.042]
VERBOSE:
p2p:tx_pool Adding tx 0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193 to pool
{"eventName":"tx-added-to-pool","txHash":"0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"}
14:24:02 [14:24:02.059]
INFO:
node Received tx 0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193
{"txHash":"0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193"}
14:24:02 [14:24:02.059]
INFO:
pxe:service Sent transaction 0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193
14:24:02 [14:24:02.090]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.292]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.495]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.565]
VERBOSE:
sequencer Building block 2 for slot 3
{"slot":3,"blockNumber":2,"msgCount":0}
14:24:02 [14:24:02.582]
VERBOSE:
sequencer Processing pending txs
{"slot":3,"slotStart":"2025-06-18T14:28:46.000Z","now":"2025-06-18T14:28:52.692Z"}
14:24:02 [14:24:02.701]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.989]
VERBOSE:
simulator:public-processor Processed tx 0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193 with no public calls in 280.946391999998ms
{"txHash":"0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193","txFee":7272506880,"revertCode":0,"gasUsed":{"totalGas":{"daGas":310272,"l2Gas":21888},"billedGas":{"daGas":310272,"l2Gas":21888},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":280.946391999998}
14:24:02 [14:24:02.993]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:02 [14:24:02.998]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.41539513600000283s
{"duration":0.41539513600000283,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648}
14:24:03 [14:24:03.205]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x27a0d75fc18927933ce27094da160c396a5d37484e96f4ca98ba55f1d33d9e5a","globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":2,"slotNumber":3,"timestamp":1750256926,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x10e6e8496f990f01e8aba50701d9016cb3a0c8fa75da0cee229c49005fbb7193"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":639.5241749999986,"publicProcessDuration":416.0566699999981,"rollupCircuitsDuration":625.5104900000006,"txCount":1,"blockNumber":2,"blockTimestamp":1750256926,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583}
14:24:03 [14:24:03.207]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:03 [14:24:03.208]
VERBOSE:
sequencer Attesting committee is empty
14:24:03 [14:24:03.549]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:03 [14:24:03.561]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xcf5945f4ac6c5f8ba0a8227b420b596d2ef76119d35429889280bc299d1a718b
14:24:03 [14:24:03.561]
VERBOSE:
sequencer-client Sent L1 transaction 0xcf5945f4ac6c5f8ba0a8227b420b596d2ef76119d35429889280bc299d1a718b
{"gasLimit":470269,"maxFeePerGas":"1.303611175","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
14:24:03 [14:24:03.572]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256962] on
http://127.0.0.1:8545
14:24:03 [14:24:03.576]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
14:24:03 [14:24:03.581]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:24:03 [14:24:03.581]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcf5945f4ac6c5f8ba0a8227b420b596d2ef76119d35429889280bc299d1a718b","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750256926,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583}
14:24:03 [14:24:03.582]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
14:24:03 [14:24:03.590]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750256962
14:24:03 [14:24:03.590]
WARN:
foundation:test-date-provider Time set to 2025-06-18T14:29:22.000Z
{"offset":318410,"timeMs":1750256962000}
14:24:03 [14:24:03.590]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
14:24:03 [14:24:03.597]
INFO:
blob-sink:server Received blob sidecar for block 0xfcc4cf917a62f626f5f93245ddf9989ec9ea29df1ed35b90241eaf690c0700df
14:24:03 [14:24:03.609]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xfcc4cf917a62f626f5f93245ddf9989ec9ea29df1ed35b90241eaf690c0700df
14:24:03 [14:24:03.626]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on
http://127.0.0.1:8545
14:24:03 [14:24:03.628]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
14:24:03 [14:24:03.629]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
14:24:03 [14:24:03.754]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:03 [14:24:03.957]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:04 [14:24:04.165]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:04 [14:24:04.319]
VERBOSE:
archiver:block-helper Store contract instance at 0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757
14:24:04 [14:24:04.344]
VERBOSE:
archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f
14:24:04 [14:24:04.372]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:04 [14:24:04.376]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x27a0d75fc18927933ce27094da160c396a5d37484e96f4ca98ba55f1d33d9e5a","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":2,"slotNumber":3,"timestamp":1750256926,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","archiveNextLeafIndex":3}
14:24:04 [14:24:04.386]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
14:24:04 [14:24:04.429]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":11.382078999999067,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750256926,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583}
14:24:04 [14:24:04.511]
VERBOSE:
p2p Synched to latest block 2
14:24:04 [14:24:04.581]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:04 [14:24:04.640]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:04 [14:24:04.785]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:04 [14:24:04.988]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:05 [14:24:05.295]
INFO:
aztecjs:deploy_sent_tx Contract 0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757 successfully deployed.
14:24:05 [14:24:05.298]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers higher than the mined one with no enqueued public calls sets the max block number
14:24:05 [14:24:05.304]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:05 [14:24:05.359]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:05 [14:24:05.368]
VERBOSE:
pxe:service Updated pxe last block to 2
{"blockHash":{},"archive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","header":{"contentCommitment":{"blobsHash":"0x00af4979c5202b06ed025457a8236773795e26bd1100469baf8cce8c561f8e5e","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750256926,"version":3957803416},"lastArchive":"0x2f3780580d02d23c8ae405aa9a26bbafd6e0f3681eaab00a6b0d426abf60a6d1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2f77ca8c80ac69fdc85adee974e7bf34c7a47af26563def1b16168be72681e37","nullifierTree":"0x25c3adcbd4d5ef1027e8486a9e156531fbceeb09509b7e451183d7580a80962c","publicDataTree":"0x27bbfc98396dba186db4982e94bbd4f646ceefa8f2b2e8f53628a14d105615b7"},"totalFees":7272506880,"totalManaUsed":21888}}
14:24:05 [14:24:05.469]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:05 [14:24:05.519]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:05 [14:24:05.520]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:05 [14:24:05.522]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:05 [14:24:05.598]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:05 [14:24:05.607]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:05 [14:24:05.623]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:05 [14:24:05.624]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:05 [14:24:05.633]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:05 [14:24:05.634]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:05 [14:24:05.638]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:05 [14:24:05.640]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:05 [14:24:05.660]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:05 [14:24:05.841]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:06 [14:24:06.198]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:06 [14:24:06.213]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:06 [14:24:06.213]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:06 [14:24:06.226]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:06 [14:24:06.640]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:06 [14:24:06.670]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:06 [14:24:06.698]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:06 [14:24:06.703]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:06 [14:24:06.899]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:07 [14:24:07.481]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:07 [14:24:07.514]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:07 [14:24:07.705]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:08 [14:24:08.098]
INFO:
pxe:service Proving completed in 2747.740270000002ms
{"timings":{"total":2747.740270000002,"sync":20.206285000000207,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":448.97577100000126,"oracles":{"debugLog":{"times":[0.7765360000012151,0.6539230000016687,0.9379900000021735,0.8754279999993742,0.6606040000006033,0.5508010000012291,0.41305799999827286,0.7258959999999206]},"fetchTaggedLogs":{"times":[84.2474089999996]},"loadCapsule":{"times":[0.3489869999975781,0.3120770000023185,0.5653920000004291,0.23441499999898952,0.2250850000018545,0.21421399999962887]},"getSharedSecret":{"times":[5.480905000000348]},"aes128Decrypt":{"times":[0.5090110000019195,1.7387969999981578]},"getPublicKeysAndPartialAddress":{"times":[2.5541439999979048]},"getKeyValidationRequest":{"times":[2.5159719999974186]},"deliverNote":{"times":[3.888222000001406]},"deleteCapsule":{"times":[0.3747480000020005]},"storeCapsule":{"times":[0.30818600000202423]},"getNotes":{"times":[1.9039799999991374]},"getAuthWitness":{"times":[0.24606500000300002]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08680200000162586]},"callPrivateFunction":{"times":[1049.5878369999991]}}},{"functionName":"private_kernel_init","time":80.09719299999779},{"functionName":"Test:set_tx_max_block_number","time":864.4803700000011,"oracles":{"debugLog":{"times":[0.6203029999996943,0.5648519999995187]},"fetchTaggedLogs":{"times":[488.271976]},"loadCapsule":{"times":[0.26103499999953783,0.23885499999960302,0.22489499999937834]}}},{"functionName":"private_kernel_inner","time":173.92070400000011},{"functionName":"private_kernel_reset","time":281.27067800000077},{"functionName":"private_kernel_tail","time":117.52768899999865}],"unaccounted":761.2615800000021}}
14:24:08 [14:24:08.104]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers higher than the mined one with no enqueued public calls does not invalidate the transaction
14:24:08 [14:24:08.107]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:08 [14:24:08.151]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:08 [14:24:08.251]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:08 [14:24:08.302]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:08 [14:24:08.303]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:08 [14:24:08.351]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:08 [14:24:08.389]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:08 [14:24:08.398]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:08 [14:24:08.419]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:08 [14:24:08.420]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:08 [14:24:08.435]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:08 [14:24:08.435]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:08 [14:24:08.443]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:08 [14:24:08.449]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:08 [14:24:08.471]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:08 [14:24:08.694]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:09 [14:24:09.076]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:09 [14:24:09.087]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:09 [14:24:09.088]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:09 [14:24:09.104]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:09 [14:24:09.363]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:09 [14:24:09.371]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:09 [14:24:09.416]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:09 [14:24:09.423]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:09 [14:24:09.600]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:09 [14:24:09.844]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:10 [14:24:10.092]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:10 [14:24:10.453]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:10 [14:24:10.483]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:10 [14:24:10.964]
INFO:
pxe:service Proving completed in 2817.385832ms
{"timings":{"total":2817.385832,"sync":5.9941859999999,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":496.57726399999956,"oracles":{"debugLog":{"times":[0.7146850000026461,0.6636240000007092,0.6632840000020224,0.7919270000020333,0.60720300000321,0.5297619999982999,0.5748629999980039,0.8576480000010633]},"fetchTaggedLogs":{"times":[93.01576399999976]},"loadCapsule":{"times":[0.29938599999877624,0.19133400000282563,0.7594160000007832,2.824560000000929,0.4987699999983306,1.3943189999990864]},"getSharedSecret":{"times":[5.212129999999888]},"aes128Decrypt":{"times":[0.35355799999888404,3.757989000001544]},"getPublicKeysAndPartialAddress":{"times":[7.90691599999991]},"getKeyValidationRequest":{"times":[2.0007519999999204]},"deliverNote":{"times":[8.005167999999685]},"deleteCapsule":{"times":[0.3400870000004943]},"storeCapsule":{"times":[0.2562450000004901]},"getNotes":{"times":[2.6790559999972174]},"getAuthWitness":{"times":[0.35992800000167335]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1373329999987618]},"callPrivateFunction":{"times":[959.9397040000003]}}},{"functionName":"private_kernel_init","time":70.04069199999867},{"functionName":"Test:set_tx_max_block_number","time":771.8293620000004,"oracles":{"debugLog":{"times":[0.6039620000010473,0.70055499999944]},"fetchTaggedLogs":{"times":[333.3909339999991]},"loadCapsule":{"times":[0.4358589999974356,0.36358800000016345,0.261225000002014]}}},{"functionName":"private_kernel_inner","time":126.45900600000095},{"functionName":"private_kernel_reset","time":218.10075100000176},{"functionName":"private_kernel_tail","time":120.47310099999959}],"unaccounted":1007.9114699999991}}
14:24:10 [14:24:10.981]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:11 [14:24:11.026]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","blockNumber":3,"slot":4}
14:24:11 [14:24:11.031]
VERBOSE:
p2p:tx_pool Adding tx 0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d to pool
{"eventName":"tx-added-to-pool","txHash":"0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"}
14:24:11 [14:24:11.038]
INFO:
node Received tx 0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d
{"txHash":"0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d"}
14:24:11 [14:24:11.038]
INFO:
pxe:service Sent transaction 0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d
14:24:11 [14:24:11.187]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:11 [14:24:11.391]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:11 [14:24:11.548]
VERBOSE:
sequencer Building block 3 for slot 4
{"slot":4,"blockNumber":3,"msgCount":0}
14:24:11 [14:24:11.565]
VERBOSE:
sequencer Processing pending txs
{"slot":4,"slotStart":"2025-06-18T14:29:22.000Z","now":"2025-06-18T14:29:29.974Z"}
14:24:11 [14:24:11.585]
VERBOSE:
simulator:public-processor Processed tx 0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d with no public calls in 12.429542000001675ms
{"txHash":"0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d","txFee":1945714560,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":5856},"billedGas":{"daGas":1024,"l2Gas":5856},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":12.429542000001675}
14:24:11 [14:24:11.586]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020575701999998273s
{"duration":0.020575701999998273,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1024,"l2Gas":5856},"totalSizeInBytes":256}
14:24:11 [14:24:11.594]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:11 [14:24:11.716]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0523c18554abefc1d378b0b41578bd9b125de14a08d4cbc1ef582adb0837cbaa","globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":3,"slotNumber":4,"timestamp":1750256962,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x18ca10fdfbf0c825496ea69cf5ee240cdf79ba5ed8671a6a53a22905af599c1d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":167.6065610000005,"publicProcessDuration":20.87547799999811,"rollupCircuitsDuration":152.13121599999795,"txCount":1,"blockNumber":3,"blockTimestamp":1750256962,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:11 [14:24:11.722]
VERBOSE:
sequencer Attesting committee is empty
14:24:11 [14:24:11.805]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:12 [14:24:12.026]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:12 [14:24:12.045]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x1412a927de88b1b8104332ac893d39c0b0982b1dcb2afe6f507ef002ca9afaf5
14:24:12 [14:24:12.046]
VERBOSE:
sequencer-client Sent L1 transaction 0x1412a927de88b1b8104332ac893d39c0b0982b1dcb2afe6f507ef002ca9afaf5
{"gasLimit":470280,"maxFeePerGas":"1.279583375","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
14:24:12 [14:24:12.054]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256998] on
http://127.0.0.1:8545
14:24:12 [14:24:12.056]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
14:24:12 [14:24:12.059]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:24:12 [14:24:12.059]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x1412a927de88b1b8104332ac893d39c0b0982b1dcb2afe6f507ef002ca9afaf5","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750256962,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:12 [14:24:12.060]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
14:24:12 [14:24:12.062]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750256998
14:24:12 [14:24:12.062]
WARN:
foundation:test-date-provider Time set to 2025-06-18T14:29:58.000Z
{"offset":345938,"timeMs":1750256998000}
14:24:12 [14:24:12.063]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
14:24:12 [14:24:12.066]
INFO:
blob-sink:server Received blob sidecar for block 0x3b380a2e4f3023669fa1857c52c6d58e52a5243e59e96dbca8e32589bdab05e5
14:24:12 [14:24:12.073]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x3b380a2e4f3023669fa1857c52c6d58e52a5243e59e96dbca8e32589bdab05e5
14:24:12 [14:24:12.234]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on
http://127.0.0.1:8545
14:24:12 [14:24:12.236]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
14:24:12 [14:24:12.238]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
14:24:12 [14:24:12.245]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:12 [14:24:12.483]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:12 [14:24:12.503]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x0523c18554abefc1d378b0b41578bd9b125de14a08d4cbc1ef582adb0837cbaa","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":3,"slotNumber":4,"timestamp":1750256962,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","archiveNextLeafIndex":4}
14:24:12 [14:24:12.508]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
14:24:12 [14:24:12.607]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":8.56091899999592,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750256962,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:12 [14:24:12.623]
VERBOSE:
p2p Synched to latest block 3
14:24:12 [14:24:12.691]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:12 [14:24:12.894]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:13 [14:24:13.057]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers higher than the mined one with an enqueued public call sets the max block number
14:24:13 [14:24:13.096]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:13 [14:24:13.098]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:13 [14:24:13.099]
VERBOSE:
pxe:service Updated pxe last block to 3
{"blockHash":{},"archive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","header":{"contentCommitment":{"blobsHash":"0x00fe54b1639e38c02dec456671870c175f07053bd1f7bf36fb14fea5cccd9595","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750256962,"version":3957803416},"lastArchive":"0x089c602d4eb5f70fb7f7e6eb797a441d4c7d6a5ba690d416b59921e3f3b246b2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2f77ca8c80ac69fdc85adee974e7bf34c7a47af26563def1b16168be72681e37","nullifierTree":"0x1acea25e95abadd10bb153d21f851f66d2fcf8f8a7c0b0fa0f1c595f77d003ef","publicDataTree":"0x19607ac0c8f2c11a6b689d155f7dc13ca9dad42fcb80a0091ee9422a883deba4"},"totalFees":1945714560,"totalManaUsed":5856}}
14:24:13 [14:24:13.238]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:13 [14:24:13.285]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:13 [14:24:13.285]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:13 [14:24:13.333]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:13 [14:24:13.369]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:13 [14:24:13.376]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:13 [14:24:13.403]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:13 [14:24:13.404]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:13 [14:24:13.419]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:13 [14:24:13.420]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:13 [14:24:13.423]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:13 [14:24:13.425]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:13 [14:24:13.439]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:13 [14:24:13.617]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:13 [14:24:13.882]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:13 [14:24:13.892]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:13 [14:24:13.893]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:14 [14:24:14.028]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:14 [14:24:14.037]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:14 [14:24:14.056]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:14 [14:24:14.059]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:14 [14:24:14.336]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:14 [14:24:14.624]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:14 [14:24:14.931]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:15 [14:24:15.055]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:15 [14:24:15.351]
INFO:
pxe:service Proving completed in 2276.2206129999977ms
{"timings":{"total":2276.2206129999977,"sync":34.278356999995594,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":423.9778249999945,"oracles":{"debugLog":{"times":[0.8110240000023623,0.5153449999997974,0.7269409999935306,0.7390119999981835,0.6649000000033993,0.2942990000010468,0.4493930000026012,0.6340189999973518]},"fetchTaggedLogs":{"times":[88.11920799999643]},"loadCapsule":{"times":[0.2770590000000084,0.21800600000278791,0.528214999998454,0.28764899999805493,0.23188700000173412,0.25659799999993993]},"getSharedSecret":{"times":[16.623486999997112]},"aes128Decrypt":{"times":[0.5219960000031278,1.4157429999977467]},"getPublicKeysAndPartialAddress":{"times":[3.8471649999992223]},"getKeyValidationRequest":{"times":[7.030270000002929]},"deliverNote":{"times":[3.2142260000036913]},"deleteCapsule":{"times":[0.36087099999713246]},"storeCapsule":{"times":[0.3359600000039791]},"getNotes":{"times":[1.822585000001709]},"getAuthWitness":{"times":[0.27519800000300165]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06912200000078883]},"callPrivateFunction":{"times":[625.4533169999995]}}},{"functionName":"private_kernel_init","time":68.90555299999687},{"functionName":"Test:set_tx_max_block_number","time":499.7729130000007,"oracles":{"debugLog":{"times":[0.5618469999972149,0.39680200000293553]},"fetchTaggedLogs":{"times":[165.62407900000107]},"loadCapsule":{"times":[0.18116500000178348,0.17515500000445172,0.1688750000030268]},"storeInExecutionCache":{"times":[0.05160199999954784]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3407900000020163]}}},{"functionName":"private_kernel_inner","time":99.6865850000031},{"functionName":"private_kernel_reset","time":198.72207999999955},{"functionName":"private_kernel_tail","time":100.22222000000329}],"unaccounted":850.6550800000041}}
14:24:15 [14:24:15.353]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers higher than the mined one with an enqueued public call does not invalidate the transaction
14:24:15 [14:24:15.354]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:15 [14:24:15.459]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:15 [14:24:15.501]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:15 [14:24:15.502]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:15 [14:24:15.557]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:15 [14:24:15.559]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:15 [14:24:15.576]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:15 [14:24:15.578]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:15 [14:24:15.591]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:15 [14:24:15.592]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:15 [14:24:15.599]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:15 [14:24:15.599]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:15 [14:24:15.602]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:15 [14:24:15.604]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:15 [14:24:15.622]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:15 [14:24:15.774]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:16 [14:24:16.101]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:16 [14:24:16.117]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:16 [14:24:16.118]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:16 [14:24:16.298]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:16 [14:24:16.308]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:16 [14:24:16.312]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:16 [14:24:16.328]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:16 [14:24:16.657]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:17 [14:24:17.249]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:17 [14:24:17.398]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","blockNumber":4,"slot":5}
14:24:17 [14:24:17.663]
INFO:
pxe:service Proving completed in 2290.2519329999996ms
{"timings":{"total":2290.2519329999996,"sync":2.8698959999965155,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":420.99396500000876,"oracles":{"debugLog":{"times":[0.8662459999977727,0.30524899999727495,0.3562900000033551,0.4271819999994477,0.41262299999652896,0.3516700000036508,0.317799999997078,0.9133080000028713]},"fetchTaggedLogs":{"times":[73.10849900000176]},"loadCapsule":{"times":[0.351901000001817,0.9757089999984601,0.7973239999992074,0.16261500000109663,0.1742549999980838,0.21677700000145705]},"getSharedSecret":{"times":[7.850985000004584]},"aes128Decrypt":{"times":[0.3463499999998021,0.7931539999990491]},"getPublicKeysAndPartialAddress":{"times":[1.6362690000023576]},"getKeyValidationRequest":{"times":[1.588287999999011]},"deliverNote":{"times":[2.905916999996407]},"deleteCapsule":{"times":[0.22526700000162236]},"storeCapsule":{"times":[0.250677000003634]},"getNotes":{"times":[1.1822050000046147]},"getAuthWitness":{"times":[0.21118600000045262]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.14242399999784539]},"callPrivateFunction":{"times":[693.3623709999956]}}},{"functionName":"private_kernel_init","time":67.58733399999619},{"functionName":"Test:set_tx_max_block_number","time":500.7199419999961,"oracles":{"debugLog":{"times":[0.959619000001112,0.4233920000042417]},"fetchTaggedLogs":{"times":[192.5341449999978]},"loadCapsule":{"times":[0.271547999996983,0.19013499999709893,0.23065700000006473]},"storeInExecutionCache":{"times":[0.05212200000096345]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0975929999985965]}}},{"functionName":"private_kernel_inner","time":114.83722799999668},{"functionName":"private_kernel_reset","time":170.01254999999946},{"functionName":"private_kernel_tail","time":102.92287200000283}],"unaccounted":910.308146000003}}
14:24:17 [14:24:17.690]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:17 [14:24:17.712]
VERBOSE:
p2p:tx_pool Adding tx 0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313 to pool
{"eventName":"tx-added-to-pool","txHash":"0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226281,"feePaymentMethod":"fee_juice"}
14:24:17 [14:24:17.719]
INFO:
node Received tx 0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313
{"txHash":"0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313"}
14:24:17 [14:24:17.720]
INFO:
pxe:service Sent transaction 0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313
14:24:17 [14:24:17.896]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:17 [14:24:17.930]
VERBOSE:
sequencer Building block 4 for slot 5
{"slot":5,"blockNumber":4,"msgCount":0}
14:24:17 [14:24:17.941]
VERBOSE:
sequencer Processing pending txs
{"slot":5,"slotStart":"2025-06-18T14:29:58.000Z","now":"2025-06-18T14:30:03.879Z"}
14:24:17 [14:24:17.991]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0x5189a417 completed successfully.
{"eventName":"avm-simulation","appCircuitName":"0x5189a417","duration":25.577254999996512}
14:24:18 [14:24:18.019]
VERBOSE:
simulator:public-processor Processed tx 0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313 with 1 public calls in 66.1311410000053ms
{"txHash":"0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313","txFee":1487487300,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":29339},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":3483},"billedGas":{"daGas":1024,"l2Gas":29339}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":66.1311410000053}
14:24:18 [14:24:18.021]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07901166599999851s
{"duration":0.07901166599999851,"rate":44082.09795247281,"totalPublicGas":{"daGas":0,"l2Gas":3483},"totalBlockGas":{"daGas":1024,"l2Gas":29339},"totalSizeInBytes":256}
14:24:18 [14:24:18.117]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:18 [14:24:18.127]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 17628.726716244237 mana/s
{"blockHash":"0x10ee53520858d66274fd0ff1b0824db6a554408b658682b33937a88fb84cf340","globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":4,"slotNumber":5,"timestamp":1750256998,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x22003494e0ff9fff67e79217d4f537c90ab07e6cde1cdaf9faecc12377084313"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":197.0114889999968,"publicProcessDuration":79.5241309999983,"rollupCircuitsDuration":186.61562799999956,"txCount":1,"blockNumber":4,"blockTimestamp":1750256998,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:18 [14:24:18.132]
VERBOSE:
sequencer Attesting committee is empty
14:24:18 [14:24:18.383]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:18 [14:24:18.390]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xfda0f629af1d6dec113e9e2603305660190dd1c0c48f0092bface3d207057153
14:24:18 [14:24:18.391]
VERBOSE:
sequencer-client Sent L1 transaction 0xfda0f629af1d6dec113e9e2603305660190dd1c0c48f0092bface3d207057153
{"gasLimit":470295,"maxFeePerGas":"1.261127724","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
14:24:18 [14:24:18.405]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:24:18 [14:24:18.406]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xfda0f629af1d6dec113e9e2603305660190dd1c0c48f0092bface3d207057153","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1750256998,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:18 [14:24:18.406]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
14:24:18 [14:24:18.411]
INFO:
blob-sink:server Received blob sidecar for block 0x74a75c1d3042720adb00d2a66dfd36317fe7aa324709bbd89949ba0aaf6426ab
14:24:18 [14:24:18.414]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x74a75c1d3042720adb00d2a66dfd36317fe7aa324709bbd89949ba0aaf6426ab
14:24:18 [14:24:18.419]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257034] on
http://127.0.0.1:8545
14:24:18 [14:24:18.420]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
14:24:18 [14:24:18.422]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750257034
14:24:18 [14:24:18.422]
WARN:
foundation:test-date-provider Time set to 2025-06-18T14:30:34.000Z
{"offset":375578,"timeMs":1750257034000}
14:24:18 [14:24:18.422]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
14:24:18 [14:24:18.587]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:18 [14:24:18.591]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on
http://127.0.0.1:8545
14:24:18 [14:24:18.592]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
14:24:18 [14:24:18.596]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
14:24:18 [14:24:18.870]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:18 [14:24:18.888]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x10ee53520858d66274fd0ff1b0824db6a554408b658682b33937a88fb84cf340","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3957803416,"blockNumber":4,"slotNumber":5,"timestamp":1750256998,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","archiveNextLeafIndex":5}
14:24:18 [14:24:18.893]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
14:24:18 [14:24:18.993]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":7.546135999997205,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750256998,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:24:19 [14:24:19.010]
VERBOSE:
p2p Synched to latest block 4
14:24:19 [14:24:19.076]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:19 [14:24:19.280]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:19 [14:24:19.426]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:19 [14:24:19.483]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:19 [14:24:19.686]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:19 [14:24:19.734]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers lower than the mined one with no enqueued public calls sets the max block number
14:24:19 [14:24:19.761]
VERBOSE:
pxe:service Updated pxe last block to 4
{"blockHash":{},"archive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","header":{"contentCommitment":{"blobsHash":"0x0031ec258d971c3594d4079f64473195243eb64f6df4d3c7ad3f8ac67942dcc9","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750256998,"version":3957803416},"lastArchive":"0x129e95f613210c965a725bf0bf78e99730e270bf077ef99c41141ee0bbb77f40","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2f77ca8c80ac69fdc85adee974e7bf34c7a47af26563def1b16168be72681e37","nullifierTree":"0x20e710dcffc737db11fc3b2417e8d9e2b5e58e4078512a66b0718f5716828437","publicDataTree":"0x0dd52ea91bae64e28034a29d873cb6b8c07b52157494f41962d18ea5f0b7d4f8"},"totalFees":1487487300,"totalManaUsed":29339}}
14:24:19 [14:24:19.852]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:19 [14:24:19.887]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:19 [14:24:19.888]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:19 [14:24:19.889]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:19 [14:24:19.968]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:19 [14:24:19.969]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:19 [14:24:19.973]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:19 [14:24:19.983]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:19 [14:24:19.984]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:19 [14:24:19.993]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:19 [14:24:19.994]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:19 [14:24:19.999]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:20 [14:24:20.002]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:20 [14:24:20.025]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:20 [14:24:20.166]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:20 [14:24:20.390]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:20 [14:24:20.401]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:20 [14:24:20.402]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:20 [14:24:20.521]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:20 [14:24:20.554]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:20 [14:24:20.556]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:20 [14:24:20.558]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:20 [14:24:20.733]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:21 [14:24:21.184]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:21 [14:24:21.317]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:21 [14:24:21.535]
INFO:
pxe:service Proving completed in 1780.7635479999954ms
{"timings":{"total":1780.7635479999954,"sync":8.51116500000353,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":368.68534799999907,"oracles":{"debugLog":{"times":[0.5306049999999232,0.447003000001132,0.5831580000012764,0.9608089999965159,0.6641100000051665,0.5219450000004144,0.4015120000040042,1.1707549999991897]},"fetchTaggedLogs":{"times":[83.73288799999864]},"loadCapsule":{"times":[0.1826260000016191,0.14212400000542402,0.3396199999988312,0.3274900000033085,0.2707880000016303,0.17639500000223052]},"getSharedSecret":{"times":[2.969258000004629]},"aes128Decrypt":{"times":[0.2873089999993681,0.6941200000001118]},"getPublicKeysAndPartialAddress":{"times":[2.345369999995455]},"getKeyValidationRequest":{"times":[1.952898000003188]},"deliverNote":{"times":[5.879595999998855]},"deleteCapsule":{"times":[0.2878980000023148]},"storeCapsule":{"times":[0.33009999999922]},"getNotes":{"times":[3.1962859999985085]},"getAuthWitness":{"times":[0.3318899999940186]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.10440300000482239]},"callPrivateFunction":{"times":[534.7328500000003]}}},{"functionName":"private_kernel_init","time":64.60368400000152},{"functionName":"Test:set_tx_max_block_number","time":413.49274100000184,"oracles":{"debugLog":{"times":[0.44772399999783374,0.242048000000068]},"fetchTaggedLogs":{"times":[155.95467899999494]},"loadCapsule":{"times":[0.15386399999988498,0.16298499999538762,0.15008400000078836]}}},{"functionName":"private_kernel_inner","time":97.41442700000334},{"functionName":"private_kernel_reset","time":153.31205999999656},{"functionName":"private_kernel_tail","time":73.17909199999849}],"unaccounted":601.565030999991}}
14:24:21 [14:24:21.538]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers lower than the mined one with no enqueued public calls invalidates the transaction
14:24:21 [14:24:21.539]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:21 [14:24:21.658]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:21 [14:24:21.690]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:21 [14:24:21.690]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:21 [14:24:21.749]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:21 [14:24:21.761]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:21 [14:24:21.791]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:21 [14:24:21.811]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:21 [14:24:21.812]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:21 [14:24:21.888]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:21 [14:24:21.888]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:21 [14:24:21.924]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:21 [14:24:21.925]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:21 [14:24:21.926]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:21 [14:24:21.937]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:21 [14:24:21.955]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:22 [14:24:22.219]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:22 [14:24:22.347]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:22 [14:24:22.359]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:22 [14:24:22.359]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:22 [14:24:22.562]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:22 [14:24:22.564]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:22 [14:24:22.565]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:22 [14:24:22.575]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:22 [14:24:22.874]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:23 [14:24:23.159]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:23 [14:24:23.287]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:23 [14:24:23.526]
INFO:
pxe:service Proving completed in 1952.2222410000031ms
{"timings":{"total":1952.2222410000031,"sync":3.679458999999042,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":479.9174899999998,"oracles":{"debugLog":{"times":[0.5371759999979986,0.5108649999965564,0.6467790000024252,0.5001750000010361,0.4212019999977201,0.29181899999821326,0.32744000000093365,0.5431360000002314]},"fetchTaggedLogs":{"times":[93.75063699999737]},"loadCapsule":{"times":[2.8772159999934956,0.4411130000007688,2.0129999999990105,0.265187999997579,0.1656749999965541,0.18741600000066683]},"getSharedSecret":{"times":[12.529015000000072]},"aes128Decrypt":{"times":[0.5744879999983823,1.7712129999999888]},"getPublicKeysAndPartialAddress":{"times":[3.264947999996366]},"getKeyValidationRequest":{"times":[68.51912199999788]},"deliverNote":{"times":[35.70068899999751]},"deleteCapsule":{"times":[0.25428800000372576]},"storeCapsule":{"times":[0.5631070000017644]},"getNotes":{"times":[1.028360000003886]},"getAuthWitness":{"times":[0.14712399999552872]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.058942000003298745]},"callPrivateFunction":{"times":[643.333881999999]}}},{"functionName":"private_kernel_init","time":54.99990699999762},{"functionName":"Test:set_tx_max_block_number","time":507.9967889999971,"oracles":{"debugLog":{"times":[0.6180290000047535,0.3631309999982477]},"fetchTaggedLogs":{"times":[213.58049500000197]},"loadCapsule":{"times":[0.2923289999962435,1.2650880000001052,1.3039090000020224]}}},{"functionName":"private_kernel_inner","time":100.39346600000135},{"functionName":"private_kernel_reset","time":157.76219900000433},{"functionName":"private_kernel_tail","time":88.49735599999985}],"unaccounted":558.975575000004}}
14:24:23 [14:24:23.543]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:23 [14:24:23.565]
VERBOSE:
p2p:tx_validator:tx_metadata Rejecting tx 0x2772504ecdba57feb5d096090a8bc57948c9b9ba6aaf8de8e448d6084a650e61 for low max block number. Tx max block number: 0x0000000000000000000000000000000000000000000000000000000000000004, current block number: 0x0000000000000000000000000000000000000000000000000000000000000005.
14:24:23 [14:24:23.572]
WARN:
node Received invalid tx 0x2772504ecdba57feb5d096090a8bc57948c9b9ba6aaf8de8e448d6084a650e61: Invalid max block number
{"txHash":"0x2772504ecdba57feb5d096090a8bc57948c9b9ba6aaf8de8e448d6084a650e61"}
14:24:23 [14:24:23.579]
ERROR:
pxe:service Error: Error: Invalid tx: Invalid max block number
14:24:23 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19)
14:24:23 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
14:24:23 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17)
14:24:23 [14:24:23.581]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers lower than the mined one with an enqueued public call sets the max block number
14:24:23 [14:24:23.675]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:23 [14:24:23.715]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:23 [14:24:23.715]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:23 [14:24:23.748]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:23 [14:24:23.778]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:23 [14:24:23.784]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:23 [14:24:23.823]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:23 [14:24:23.825]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:23 [14:24:23.907]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:23 [14:24:23.908]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:23 [14:24:23.912]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:23 [14:24:23.915]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:23 [14:24:23.917]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:23 [14:24:23.990]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:23 [14:24:23.992]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:24 [14:24:24.252]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:24 [14:24:24.552]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:24 [14:24:24.566]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:24 [14:24:24.567]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:24 [14:24:24.764]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:24 [14:24:24.774]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:24 [14:24:24.797]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:24 [14:24:24.801]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:24 [14:24:24.980]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:25 [14:24:25.438]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:25 [14:24:25.577]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:25 [14:24:25.822]
INFO:
pxe:service Proving completed in 2225.090467000002ms
{"timings":{"total":2225.090467000002,"sync":3.418391999999585,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":516.9378219999926,"oracles":{"debugLog":{"times":[0.7931060000046273,0.4921699999977136,1.1700739999942016,0.7621160000053351,0.6849350000047707,0.6292130000001634,0.41317899999557994,0.600031999994826]},"fetchTaggedLogs":{"times":[66.61106999999902]},"loadCapsule":{"times":[0.2556750000003376,0.23473399999784306,0.4321090000012191,0.23479500000394182,0.21169499999814434,0.19140400000469526]},"getSharedSecret":{"times":[27.838800999998057]},"aes128Decrypt":{"times":[0.6431830000001355,2.680144999998447]},"getPublicKeysAndPartialAddress":{"times":[58.52573100000154]},"getKeyValidationRequest":{"times":[19.94268600000214]},"deliverNote":{"times":[6.431773999996949]},"deleteCapsule":{"times":[0.5210609999994631]},"storeCapsule":{"times":[0.513371000000916]},"getNotes":{"times":[2.5694129999974393]},"getAuthWitness":{"times":[0.3073960000037914]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.19314399999711895]},"callPrivateFunction":{"times":[814.0358919999999]}}},{"functionName":"private_kernel_init","time":65.14348899999459},{"functionName":"Test:set_tx_max_block_number","time":668.4648250000027,"oracles":{"debugLog":{"times":[0.749165000001085,0.32246699999814155]},"fetchTaggedLogs":{"times":[232.8744979999974]},"loadCapsule":{"times":[0.15445299999555573,0.13180299999658018,0.21685399999842048]},"storeInExecutionCache":{"times":[0.043201000000408385]},"notifyEnqueuedPublicFunctionCall":{"times":[0.04753099999652477]}}},{"functionName":"private_kernel_inner","time":106.79594799999904},{"functionName":"private_kernel_reset","time":180.03587599999446},{"functionName":"private_kernel_tail","time":77.3241629999975}],"unaccounted":606.9699520000213}}
14:24:25 [14:24:25.825]
INFO:
e2e:e2e_max_block_number Running test: e2e_max_block_number when requesting max block numbers lower than the mined one with an enqueued public call invalidates the transaction
14:24:25 [14:24:25.825]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:25 [14:24:25.908]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:25 [14:24:25.940]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:25 [14:24:25.941]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:25 [14:24:25.995]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800"}
14:24:26 [14:24:26.002]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x1485a314efabdb3845b5c19106d1a04dedd78e7873c26a7809754ae8cf6dc1a2
14:24:26 [14:24:26.016]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
14:24:26 [14:24:26.017]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
14:24:26 [14:24:26.023]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
14:24:26 [14:24:26.024]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
14:24:26 [14:24:26.027]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0052a6ab7651558eafb654a2d81903015489468d9870486b91ae6be251d05d16","nullifier":"0x23ae624ece1501c6df58d918e0efdc112d3441327b7292915e70f18b71a87f6d"}
14:24:26 [14:24:26.029]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:26 [14:24:26.086]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:26 [14:24:26.121]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x2ddaf167cd0e3cec1558bf6d24dce10c0fb52be3d0a883bb8f4686d1f217b800 as fee payer
14:24:26 [14:24:26.200]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:26 [14:24:26.354]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:26 [14:24:26.617]
VERBOSE:
simulator:private_execution Executing private function Test:set_tx_max_block_number
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:26 [14:24:26.628]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
14:24:26 [14:24:26.629]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:26 [14:24:26.762]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:26 [14:24:26.786]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:26 [14:24:26.790]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1bd9059da1b55c9755d7b88cc64c2d42e4e46e90dca99e43174d25967d9d5757"}
14:24:26 [14:24:26.792]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
14:24:26 [14:24:26.967]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:27 [14:24:27.414]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:27 [14:24:27.555]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x03f5a45ce5761551d80e0fd0d40954f375102b1749f2b5e6424e9327e615a5d7","blockNumber":5,"slot":6}
14:24:27 [14:24:27.798]
INFO:
pxe:service Proving completed in 1953.2074749999956ms
{"timings":{"total":1953.2074749999956,"sync":2.2783070000004955,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":393.11526899999444,"oracles":{"debugLog":{"times":[0.6096429999961401,0.3791579999960959,0.512470999994548,0.5428309999988414,0.398259000001417,0.3557470000014291,0.6603140000006533,0.5685119999980088]},"fetchTaggedLogs":{"times":[59.077431999998225]},"loadCapsule":{"times":[0.38167799999791896,0.30546599999797763,0.8047770000048331,0.23678499999368796,3.7369479999979376,5.375482000003103]},"getSharedSecret":{"times":[5.143026999998256]},"aes128Decrypt":{"times":[0.5850629999986268,1.3470979999983683]},"getPublicKeysAndPartialAddress":{"times":[1.6105139999999665]},"getKeyValidationRequest":{"times":[1.7909979999967618]},"deliverNote":{"times":[4.113855000003241]},"deleteCapsule":{"times":[0.4491199999974924]},"storeCapsule":{"times":[52.64952800000174]},"getNotes":{"times":[18.21027999999933]},"getAuthWitness":{"times":[0.21036500000627711]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07412199999816949]},"callPrivateFunction":{"times":[675.3820390000037]}}},{"functionName":"private_kernel_init","time":73.26669899999979},{"functionName":"Test:set_tx_max_block_number","time":547.7933980000016,"oracles":{"debugLog":{"times":[0.42719799999758834,0.28706599999713944]},"fetchTaggedLogs":{"times":[162.4226090000011]},"loadCapsule":{"times":[0.3383979999998701,0.1557939999984228,0.16660399999818765]},"storeInExecutionCache":{"times":[0.0691819999992731]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0416110000005574]}}},{"functionName":"private_kernel_inner","time":112.5637080000015},{"functionName":"private_kernel_reset","time":166.71000800000184},{"functionName":"private_kernel_tail","time":83.00159200000053}],"unaccounted":574.4784939999954}}
14:24:27 [14:24:27.825]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
14:24:27 [14:24:27.845]
VERBOSE:
p2p:tx_validator:tx_metadata Rejecting tx 0x2362ea87b2aca2d4ad88ee296b897406274102ba8cd28b085c78dafeb4fd9d48 for low max block number. Tx max block number: 0x0000000000000000000000000000000000000000000000000000000000000004, current block number: 0x0000000000000000000000000000000000000000000000000000000000000005.
14:24:27 [14:24:27.850]
WARN:
node Received invalid tx 0x2362ea87b2aca2d4ad88ee296b897406274102ba8cd28b085c78dafeb4fd9d48: Invalid max block number
{"txHash":"0x2362ea87b2aca2d4ad88ee296b897406274102ba8cd28b085c78dafeb4fd9d48"}
14:24:27 [14:24:27.852]
ERROR:
pxe:service Error: Error: Invalid tx: Invalid max block number
14:24:27 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19)
14:24:27 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
14:24:27 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17)
14:24:27 [14:24:27.855]
INFO:
node Stopping
14:24:27 [14:24:27.856]
INFO:
slasher Slasher client stopped.
14:24:27 [14:24:27.856]
INFO:
sequencer Stopped sequencer
14:24:27 [14:24:27.856]
INFO:
p2p P2P client stopped.
14:24:27 [14:24:27.858]
INFO:
world_state Stopped world state synchronizer
14:24:27 [14:24:27.858]
INFO:
archiver Stopped.
14:24:27 [14:24:27.858]
INFO:
node Stopped
14:24:27 [14:24:27.859]
VERBOSE:
e2e:e2e_max_block_number Cleaning up ACVM state
14:24:27 [14:24:27.859]
INFO:
e2e:e2e_max_block_number Cleaning up ACVM temp directory /tmp/f25ea097
14:24:27 [14:24:27.860]
VERBOSE:
e2e:e2e_max_block_number Cleaning up BB state
14:24:27 [14:24:27.870]
INFO:
blob-sink:server Stopping blob sink
14:24:27 [14:24:27.870]
INFO:
blob-sink:server Blob sink stopped
14:24:27 [14:24:27.870]
VERBOSE:
e2e:e2e_max_block_number Cleaning up data directory at /tmp/bcc3bfc678f602a3
14:24:27
PASS src/e2e_max_block_number.test.ts
14:24:27 e2e_max_block_number
14:24:27 when requesting max block numbers higher than the mined one
14:24:27 with no enqueued public calls
14:24:27
✓ sets the max block number (2807 ms)
14:24:27
✓ does not invalidate the transaction (4951 ms)
14:24:27 with an enqueued public call
14:24:27
✓ sets the max block number (2296 ms)
14:24:27
✓ does not invalidate the transaction (4380 ms)
14:24:27 when requesting max block numbers lower than the mined one
14:24:27 with no enqueued public calls
14:24:27
✓ sets the max block number (1804 ms)
14:24:27
✓ invalidates the transaction (2042 ms)
14:24:27 with an enqueued public call
14:24:27
✓ sets the max block number (2243 ms)
14:24:27
✓ invalidates the transaction (2028 ms)
14:24:27
14:24:27
Test Suites: 1 passed, 1 total
14:24:27
Tests: 8 passed, 8 total
14:24:27
Snapshots: 0 total
14:24:27
Time: 48.305 s
14:24:27
Ran all test suites matching /src\/e2e_max_block_number.test.ts/i
.
14:24:27
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?