ACI ·

Parent Log: http://ci.aztec-labs.com/a0947d4e5c3fb9d9 Command: 3cad4e1fd0756a5c:ISOLATE=1:NAME=e2e_cheat_codes yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_cheat_codes.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/e9a2301883801edbe36ea8bba05dcca7e714f30a Env: REF_NAME=gh-readonly-queue/master/pr-15131-464e1a9d9b40b5188586643b44bc52bffccbc3e6 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Wed Jun 18 12:49:26 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15131_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_39ce75ad687a474b_master 12:49:26 +++ id -u 12:49:26 +++ id -g 12:49:26 ++ docker run -d --name e2e_cheat_codes --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_cheat_codes.test.ts'\''' 12:49:26 + cid=9186e3dd02d92b3d1844502ac18868a8f25c1db655493132b22dd2c121099e8a 12:49:26 + set +x 12:49:27 {"level":25,"time":1750250967208,"pid":12,"hostname":"9186e3dd02d9","module":"logger","msg":"Logger initialized with level verbose"} 12:49:32 [12:49:32.809] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine block 12:49:33 [12:49:33.043] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.071] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:33 [12:49:33.078] WARN: ethereum:cheat_codes Mined 1 L1 blocks 12:49:33 [12:49:33.079] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.094] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 10 blocks 12:49:33 [12:49:33.206] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.210] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [10] on http://127.0.0.1:8545 12:49:33 [12:49:33.214] WARN: ethereum:cheat_codes Mined 10 L1 blocks 12:49:33 [12:49:33.215] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.220] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 42 blocks 12:49:33 [12:49:33.299] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.307] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [42] on http://127.0.0.1:8545 12:49:33 [12:49:33.315] WARN: ethereum:cheat_codes Mined 42 L1 blocks 12:49:33 [12:49:33.315] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.333] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 99 blocks 12:49:33 [12:49:33.436] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.442] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [99] on http://127.0.0.1:8545 12:49:33 [12:49:33.464] WARN: ethereum:cheat_codes Mined 99 L1 blocks 12:49:33 [12:49:33.464] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.473] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 100 12:49:33 [12:49:33.592] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.597] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.600] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251073] on http://127.0.0.1:8545 12:49:33 [12:49:33.605] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750251073 12:49:33 [12:49:33.605] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.607] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:33 [12:49:33.610] WARN: ethereum:cheat_codes Mined 1 L1 blocks 12:49:33 [12:49:33.610] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.613] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.619] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 42 12:49:33 [12:49:33.734] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.738] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.740] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251015] on http://127.0.0.1:8545 12:49:33 [12:49:33.742] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750251015 12:49:33 [12:49:33.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.744] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:33 [12:49:33.746] WARN: ethereum:cheat_codes Mined 1 L1 blocks 12:49:33 [12:49:33.746] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.748] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.754] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 99 12:49:33 [12:49:33.859] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.865] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.868] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251072] on http://127.0.0.1:8545 12:49:33 [12:49:33.870] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750251072 12:49:33 [12:49:33.870] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.872] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:33 [12:49:33.874] WARN: ethereum:cheat_codes Mined 1 L1 blocks 12:49:33 [12:49:33.874] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 12:49:33 [12:49:33.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:33 [12:49:33.884] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp to a past timestamp throws 12:49:34 [12:49:34.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:34 [12:49:34.004] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750249973] on http://127.0.0.1:8545 12:49:34 [12:49:34.020] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes load a value at a particular storage slot 12:49:34 [12:49:34.121] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0x0000000000000000000000000000000000000000","0x00","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.131] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes store a value at a given slot and its keccak value of the slot (if it were in a map) 12:49:34 [12:49:34.253] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 12:49:34 [12:49:34.256] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 1 to 5 12:49:34 [12:49:34.256] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.260] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 12:49:34 [12:49:34.261] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 78541660797044910968829902406342334108369226379826116161446442989268089806461 to 5 12:49:34 [12:49:34.267] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.271] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes store a value at a given slot and its keccak value of the slot (if it were in a map) 12:49:34 [12:49:34.362] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 12:49:34 [12:49:34.369] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 85149632668394328379478047665368132835280330034293399760893490333839055043265 to 5 12:49:34 [12:49:34.369] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.374] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 12:49:34 [12:49:34.376] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 58076768977499219212177354345858258922703203414073725940090140522697466344574 to 5 12:49:34 [12:49:34.376] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.380] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes set bytecode correctly 12:49:34 [12:49:34.479] INFO: ethereum:cheat_codes Calling hardhat_setCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","0x1234"] on http://127.0.0.1:8545 12:49:34 [12:49:34.483] WARN: ethereum:cheat_codes Set bytecode for 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 to 0x1234 12:49:34 [12:49:34.483] INFO: ethereum:cheat_codes Calling eth_getCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","latest"] on http://127.0.0.1:8545 12:49:34 [12:49:34.488] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes impersonate 12:49:34 [12:49:34.597] INFO: ethereum:cheat_codes Calling hardhat_impersonateAccount with params: ["0x64f08bce3ae84dfecfd1d870c80c4658d0a3dc3e"] on http://127.0.0.1:8545 12:49:34 [12:49:34.598] WARN: ethereum:cheat_codes Impersonating 0x64f08bce3ae84dfecfd1d870c80c4658d0a3dc3e 12:49:34 [12:49:34.606] INFO: ethereum:cheat_codes Calling hardhat_stopImpersonatingAccount with params: ["0x64f08bce3ae84dfecfd1d870c80c4658d0a3dc3e"] on http://127.0.0.1:8545 12:49:34 [12:49:34.608] WARN: ethereum:cheat_codes Stopped impersonating 0x64f08bce3ae84dfecfd1d870c80c4658d0a3dc3e 12:49:34 [12:49:34.706] INFO: e2e:e2e_cheat_codes Logging metrics to log/e2e_cheat_codes.jsonl 12:49:34 [12:49:34.839] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-TQ8SY2/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 12:49:34 [12:49:34.876] INFO: e2e:e2e_cheat_codes Calling anvil_setBlockTimestampInterval with params: [12] 12:49:34 [12:49:34.878] WARN: e2e:e2e_cheat_codes Set block interval to 12 12:49:34 [12:49:34.878] VERBOSE: e2e:e2e_cheat_codes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:34 [12:49:34.903] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 12:49:34 [12:49:34.908] VERBOSE: e2e:e2e_cheat_codes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 12:49:34 [12:49:34.922] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 12:49:34 [12:49:34.930] VERBOSE: e2e:e2e_cheat_codes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 12:49:34 [12:49:34.955] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 12:49:34 [12:49:34.962] VERBOSE: e2e:e2e_cheat_codes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 12:49:34 [12:49:34.979] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 12:49:34 [12:49:34.985] VERBOSE: e2e:e2e_cheat_codes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 12:49:35 [12:49:35.012] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 12:49:35 [12:49:35.018] VERBOSE: e2e:e2e_cheat_codes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 12:49:35 [12:49:35.031] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 12:49:35 [12:49:35.037] VERBOSE: e2e:e2e_cheat_codes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 12:49:35 [12:49:35.038] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 12:49:35 [12:49:35.038] INFO: e2e:e2e_cheat_codes Waiting for 6 transactions to be mined... 12:49:35 [12:49:35.056] INFO: e2e:e2e_cheat_codes All transactions mined successfully 12:49:35 [12:49:35.074] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 12:49:35 [12:49:35.075] VERBOSE: e2e:e2e_cheat_codes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 12:49:35 [12:49:35.087] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 12:49:35 [12:49:35.098] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 12:49:35 [12:49:35.102] VERBOSE: e2e:e2e_cheat_codes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 12:49:35 [12:49:35.117] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 12:49:35 [12:49:35.117] VERBOSE: e2e:e2e_cheat_codes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 12:49:35 [12:49:35.135] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 12:49:35 [12:49:35.152] VERBOSE: e2e:e2e_cheat_codes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 12:49:35 [12:49:35.167] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 12:49:35 [12:49:35.167] VERBOSE: e2e:e2e_cheat_codes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 12:49:35 [12:49:35.168] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 12:49:35 [12:49:35.168] INFO: e2e:e2e_cheat_codes Waiting for 8 transactions to be mined... 12:49:35 [12:49:35.188] INFO: e2e:e2e_cheat_codes All transactions mined successfully 12:49:35 [12:49:35.198] VERBOSE: e2e:e2e_cheat_codes Deployed shared contracts 12:49:35 [12:49:35.214] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 12:49:35 [12:49:35.215] VERBOSE: e2e:e2e_cheat_codes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 12:49:35 [12:49:35.218] VERBOSE: e2e:e2e_cheat_codes Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 12:49:35 [12:49:35.232] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 12:49:35 [12:49:35.264] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 12:49:35 [12:49:35.273] VERBOSE: e2e:e2e_cheat_codes Awaiting for linked libraries to be deployed 12:49:35 [12:49:35.316] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe1c4120b6755c78324d7c930bd7ec775a35f0484bd4e0f8a60da81d5c57f96cc {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 12:49:35 [12:49:35.321] VERBOSE: e2e:e2e_cheat_codes Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 12:49:35 [12:49:35.322] INFO: e2e:e2e_cheat_codes Waiting for 9 transactions to be mined... 12:49:35 [12:49:35.340] INFO: e2e:e2e_cheat_codes All transactions mined successfully 12:49:35 [12:49:35.340] VERBOSE: e2e:e2e_cheat_codes All core contracts have been deployed 12:49:35 [12:49:35.351] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 12:49:35 [12:49:35.352] VERBOSE: e2e:e2e_cheat_codes Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 12:49:35 [12:49:35.383] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 12:49:35 [12:49:35.389] VERBOSE: e2e:e2e_cheat_codes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 12:49:35 [12:49:35.412] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 12:49:35 [12:49:35.413] VERBOSE: e2e:e2e_cheat_codes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 12:49:35 [12:49:35.413] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 12:49:35 [12:49:35.432] INFO: e2e:e2e_cheat_codes All transactions mined successfully 12:49:35 [12:49:35.439] VERBOSE: e2e:e2e_cheat_codes Rollup deployed 12:49:35 [12:49:35.439] VERBOSE: e2e:e2e_cheat_codes Waiting for rollup and slash factory to be deployed 12:49:35 [12:49:35.440] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 12:49:35 [12:49:35.457] INFO: e2e:e2e_cheat_codes All transactions mined successfully 12:49:35 [12:49:35.457] VERBOSE: e2e:e2e_cheat_codes All transactions for L1 deployment have been mined 12:49:35 [12:49:35.481] INFO: e2e:e2e_cheat_codes 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"} 12:49:35 [12:49:35.489] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 12:49:35 [12:49:35.491] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:35 [12:49:35.492] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 12:49:35 [12:49:35.493] INFO: telemetry:client Using NoopTelemetryClient 12:49:35 [12:49:35.497] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/6a8f04e999c27549/blob-sink with map size 134217728 KB (LMDB v2) 12:49:35 [12:49:35.498] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 12:49:35 [12:49:35.499] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 12:49:35 [12:49:35.502] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:35 [12:49:35.505] INFO: aztecjs:utils:watcher New L1 time: 1750251214 12:49:35 [12:49:35.506] WARN: foundation:test-date-provider Time set to 2025-06-18T12:53:34.000Z {"offset":238495,"timeMs":1750251214000} 12:49:35 [12:49:35.508] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 12:49:35 [12:49:35.514] INFO: blob-sink:server Server is running on http://localhost:40671 12:49:35 [12:49:35.514] VERBOSE: e2e:e2e_cheat_codes Creating and synching an aztec node... 12:49:35 [12:49:35.516] VERBOSE: e2e:e2e_cheat_codes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/1145b5ea/acvm 12:49:35 [12:49:35.517] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40671"} 12:49:35 [12:49:35.530] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 12:49:35 [12:49:35.531] INFO: archiver:lmdb Creating archiver data store at directory /tmp/6a8f04e999c27549/archiver with map size 134217728 KB (LMDB v2) 12:49:35 [12:49:35.532] INFO: archiver:lmdb Starting data store with maxReaders 16 12:49:35 [12:49:35.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:35 [12:49:35.838] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:40671"} 12:49:35 [12:49:35.852] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:40671"} 12:49:35 [12:49:35.852] WARN: node:blob-sink:client No L1 consensus host urls configured 12:49:35 [12:49:35.852] WARN: node:blob-sink:client No archive client configured 12:49:35 [12:49:35.855] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xcf685826dee1de52bb9eb5d8bfd05f5ca559c4e88afff463f470707143f03e85 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x187db37ebad3aaef3878e5c448eead01ffcc8ba932b45c09fa5ecb8a7f6aa08e","l1BlockNumber":16}} 12:49:35 [12:49:35.866] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 12:49:35 [12:49:35.874] INFO: world-state:database Creating world state data store at directory /tmp/6a8f04e999c27549/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 12:49:35 [12:49:35.896] INFO: world_state Created world state synchroniser with block history of 64 12:49:35 [12:49:35.896] WARN: node Aztec node is accepting fake proofs 12:49:35 [12:49:35.907] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/6a8f04e999c27549/p2p with map size 134217728 KB (LMDB v2) 12:49:35 [12:49:35.908] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 12:49:35 [12:49:35.910] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/6a8f04e999c27549/p2p-archive with map size 134217728 KB (LMDB v2) 12:49:35 [12:49:35.911] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 12:49:35 [12:49:35.912] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/6a8f04e999c27549/p2p-peers with map size 134217728 KB (LMDB v2) 12:49:35 [12:49:35.914] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 12:49:35 [12:49:35.915] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 12:49:35 [12:49:35.916] VERBOSE: p2p P2P is disabled. Using dummy P2P service 12:49:35 [12:49:35.918] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 12:49:35 [12:49:35.920] INFO: world_state Started world state synchronizer from block 1 12:49:35 [12:49:35.922] VERBOSE: world-state:block_stream Starting sync from block number 0 12:49:35 [12:49:35.923] INFO: p2p Starting p2p client from block 0 with empty mempools 12:49:35 [12:49:35.924] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 12:49:35 [12:49:35.924] INFO: slasher Slasher client initialized 12:49:35 [12:49:35.925] INFO: slasher Starting Slasher client... 12:49:35 [12:49:35.953] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:35 [12:49:35.954] VERBOSE: node All Aztec Node subsystems synced 12:49:35 [12:49:35.962] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:35 [12:49:35.967] INFO: sequencer-client Deploying forwarder contract 12:49:35 [12:49:35.976] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 12:49:35 [12:49:35.993] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 12:49:35 [12:49:35.993] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 12:49:35 [12:49:35.999] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:36 [12:49:36.016] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:36 [12:49:36.016] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 12:49:36 [12:49:36.017] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/1145b5ea/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 12:49:36 [12:49:36.251] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 12:49:36 [12:49:36.253] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:36 [12:49:36.255] INFO: node Aztec Node version: 0.87.8 12:49:36 [12:49:36.255] 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"} 12:49:36 [12:49:36.256] VERBOSE: e2e:e2e_cheat_codes Creating a pxe... 12:49:36 [12:49:36.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:36 [12:49:36.271] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/1cfc70bb062e15d9/pxe_data with map size 134217728 KB (LMDB v2) 12:49:36 [12:49:36.286] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:36 [12:49:36.287] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:49:36 [12:49:36.473] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:36 [12:49:36.599] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 12:49:36 [12:49:36.600] INFO: pxe:service Started PXE connected to chain 31337 version 26898890 12:49:36 [12:49:36.669] INFO: pxe:service Registered account 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e 12:49:36 [12:49:36.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:36 [12:49:36.746] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 12:49:36 [12:49:36.749] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e 12:49:36 [12:49:36.903] INFO: pxe:service Added contract SchnorrAccount at 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:49:36 [12:49:36.915] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:36 [12:49:36.952] VERBOSE: pxe:block_stream Starting sync from block number 0 12:49:36 [12:49:36.979] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 12:49:37 [12:49:37.022] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:37 [12:49:37.089] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:49:37 [12:49:37.832] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 12:49:37 [12:49:37.951] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:49:38 [12:49:38.028] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:38 [12:49:38.078] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:38 [12:49:38.180] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.228] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:38 [12:49:38.230] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:38 [12:49:38.292] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.297] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:38 [12:49:38.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:38 [12:49:38.517] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.576] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:38 [12:49:38.577] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.640] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:38 [12:49:38.649] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:38 [12:49:38.654] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:38 [12:49:38.672] VERBOSE: simulator:client_execution_context:debug_log Setting 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e as fee payer 12:49:38 [12:49:38.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:39 [12:49:39.088] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:39 [12:49:39.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:39 [12:49:39.359] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:39 [12:49:39.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:40 [12:49:40.022] INFO: pxe:service Proving completed in 3074.488112000001ms {"timings":{"total":3074.488112000001,"sync":5.259017999998832,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":160.53495999999905,"oracles":{"callPrivateFunction":{"times":[995.1753099999987,407.36451099999977,260.3098879999998]}}},{"functionName":"private_kernel_init","time":107.0585489999994},{"functionName":"ContractClassRegisterer:register","time":971.9200500000006,"oracles":{"loadCapsule":{"times":[88.06330799999887]},"notifyCreatedNullifier":{"times":[1.2425750000002154]},"debugLog":{"times":[1.3443420000003243]},"notifyCreatedContractClassLog":{"times":[15.969708000000537]}}},{"functionName":"private_kernel_inner","time":130.5657339999998},{"functionName":"SchnorrAccount:constructor","time":375.33502000000044,"oracles":{"getContractInstance":{"times":[6.393267000001288]},"debugLog":{"times":[0.6798319999998057,0.44322699999975157]},"fetchTaggedLogs":{"times":[65.69674200000009]},"loadCapsule":{"times":[0.5442629999997735,0.28773700000056124,0.3677619999998569]},"notifyCreatedNullifier":{"times":[0.23592500000086147,0.2273029999996652]},"notifyCreatedNote":{"times":[0.49536000000080094]},"getRandomField":{"times":[0.4425460000002204,0.24902499999916472,0.09204499999941618,0.048772999998618616,0.06816400000025169,0.051743999998507206,0.05270299999938288,0.045772999999826425,0.05604400000083842,0.07762499999989814,0.06564400000024762]},"getIndexedTaggingSecretAsSender":{"times":[63.963927000000695]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.255283000000418]}}},{"functionName":"private_kernel_inner","time":128.6051349999998},{"functionName":"SchnorrAccount:entrypoint","time":227.2027419999995,"oracles":{"debugLog":{"times":[0.6709609999998065,0.6854519999997137,0.800917999999001]},"fetchTaggedLogs":{"times":[75.32446499999969]},"loadCapsule":{"times":[0.37379299999884097,0.2887480000008509,0.27311699999881967]},"getNotes":{"times":[2.292529000000286]},"getAuthWitness":{"times":[0.3612919999995938]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0387229999996634]}}},{"functionName":"private_kernel_inner","time":135.81578199999967},{"functionName":"private_kernel_reset","time":195.4859290000004},{"functionName":"private_kernel_tail","time":108.64526599999954}],"unaccounted":528.0599270000039}} 12:49:40 [12:49:40.049] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:40 [12:49:40.128] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","blockNumber":1,"slot":2} 12:49:40 [12:49:40.188] VERBOSE: p2p:tx_pool Adding tx 0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db to pool {"eventName":"tx-added-to-pool","txHash":"0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 12:49:40 [12:49:40.213] INFO: node Received tx 0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db {"txHash":"0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db"} 12:49:40 [12:49:40.213] INFO: pxe:service Sent transaction 0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db 12:49:40 [12:49:40.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:40 [12:49:40.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:40 [12:49:40.648] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 12:49:40 [12:49:40.662] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T12:53:58.000Z","now":"2025-06-18T12:53:39.157Z"} 12:49:40 [12:49:40.682] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.022] VERBOSE: simulator:public-processor Processed tx 0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db with no public calls in 262.540692999999ms {"txHash":"0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db","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":262.540692999999} 12:49:41 [12:49:41.023] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.026] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3620390639999987s {"duration":0.3620390639999987,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 12:49:41 [12:49:41.193] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27e220e0249dae39e4c4c184d6c207d959a189831a9969f3b42964b21fa8e443","globalVariables":{"chainId":31337,"version":26898890,"blockNumber":1,"slotNumber":2,"timestamp":1750251238,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0ac98bbd7ce73dea6067d51c263bdd6e1e7f5187b879c9687579f7e7fa71d9db"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":545.7880710000009,"publicProcessDuration":363.0838480000002,"rollupCircuitsDuration":532.8202760000004,"txCount":1,"blockNumber":1,"blockTimestamp":1750251238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:41 [12:49:41.196] VERBOSE: sequencer Attesting committee is empty 12:49:41 [12:49:41.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.500] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.737] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.749] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x44e37a5c16ea2af564b625915d476f4d6b10805401556f43a72a74036b38e73d 12:49:41 [12:49:41.749] VERBOSE: sequencer-client Sent L1 transaction 0x44e37a5c16ea2af564b625915d476f4d6b10805401556f43a72a74036b38e73d {"gasLimit":514441,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 12:49:41 [12:49:41.777] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:49:41 [12:49:41.780] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x44e37a5c16ea2af564b625915d476f4d6b10805401556f43a72a74036b38e73d","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":1,"blockTimestamp":1750251238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:41 [12:49:41.781] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:49:41 [12:49:41.787] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251274] on http://127.0.0.1:8545 12:49:41 [12:49:41.793] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:41 [12:49:41.795] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251274 12:49:41 [12:49:41.796] WARN: foundation:test-date-provider Time set to 2025-06-18T12:54:34.000Z {"offset":292204,"timeMs":1750251274000} 12:49:41 [12:49:41.796] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 12:49:41 [12:49:41.810] INFO: blob-sink:server Received blob sidecar for block 0x9363256637ccfbdcc542cad8aed2a28a16da9b608d8df0867b64b48470e306b3 12:49:41 [12:49:41.817] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9363256637ccfbdcc542cad8aed2a28a16da9b608d8df0867b64b48470e306b3 12:49:41 [12:49:41.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:41 [12:49:41.953] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 12:49:41 [12:49:41.956] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 12:49:41 [12:49:41.958] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 12:49:42 [12:49:42.156] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:42 [12:49:42.462] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:42 [12:49:42.486] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:49:42 [12:49:42.496] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x27e220e0249dae39e4c4c184d6c207d959a189831a9969f3b42964b21fa8e443","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":26898890,"blockNumber":1,"slotNumber":2,"timestamp":1750251238,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","archiveNextLeafIndex":2} 12:49:42 [12:49:42.513] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 12:49:43 [12:49:43.032] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:43 [12:49:43.043] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 12:49:43 [12:49:43.048] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774 12:49:43 [12:49:43.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:43 [12:49:43.271] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":231.52937300000121,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750251238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:43 [12:49:43.388] VERBOSE: p2p Synched to latest block 1 12:49:43 [12:49:43.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:43 [12:49:43.737] INFO: pxe:service Added contract Token at 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 12:49:43 [12:49:43.793] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","header":{"contentCommitment":{"blobsHash":"0x0027d2c2d6835fc9510e6850d6d0a7f3112d04ec29557b9f4ca872193bea98bb","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750251238,"version":26898890},"lastArchive":"0x1e8de97553c216aeed5c50e34bd240cb32cfaea5bc85ec39fdd21ba395327b4a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x224ec44750a09d6951e7e0d80455b020bfc2df06dec5b394de7ce9c9fed753c8","nullifierTree":"0x2341a7aa37f3eedcdeca3d548f85aef6973f07b9ab96116ff2a51f9ab8e4ee85","publicDataTree":"0x2ce2132bf67484c7cca776b0e5e12f7846d4a0904d08457c81546384bf788e20"},"totalFees":6794052480,"totalManaUsed":20448}} 12:49:43 [12:49:43.796] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","blockNumber":2,"slot":3} 12:49:44 [12:49:44.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:44 [12:49:44.080] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:44 [12:49:44.141] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:44 [12:49:44.142] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:44 [12:49:44.258] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:44 [12:49:44.262] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1568b2db3d985843089a4b3149f847bb1bebb2f281ca64ca571dca0378b8603d 12:49:44 [12:49:44.273] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:49:44 [12:49:44.274] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:49:44 [12:49:44.293] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:49:44 [12:49:44.294] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:49:44 [12:49:44.315] VERBOSE: pxe:service Added note {"index":0,"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06ee787b9241717920ec44110f4a9143bb2b492f345b210df86c62a8fd10977d","nullifier":"0x251e8818bda5cabeda8a90a0d4a37b854518b37660e90489bb64d2b62093f436"} 12:49:44 [12:49:44.325] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:44 [12:49:44.342] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","blockNumber":2,"slot":3} 12:49:44 [12:49:44.360] VERBOSE: simulator:client_execution_context:debug_log Setting 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e as fee payer 12:49:44 [12:49:44.362] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:44 [12:49:44.402] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:49:44 [12:49:44.941] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 12:49:45 [12:49:45.049] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:49:45 [12:49:45.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:45 [12:49:45.166] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 12:49:45 [12:49:45.193] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","blockNumber":2,"slot":3} 12:49:45 [12:49:45.214] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:49:45 [12:49:45.228] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774,0x0000000000000000000000000000000000000000000000000000000000000001,0x1a83f023f3f52090d3f524ae18cdc3d73a795f77069e913b4eb908f3f5952dbb,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x11bec14b3cbb05c0a3bc2169c89f4f2149fba15166cdca529178a7568efdfbf7,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e 12:49:45 [12:49:45.329] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:45 [12:49:45.632] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:45 [12:49:45.946] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:46 [12:49:46.056] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","blockNumber":2,"slot":3} 12:49:46 [12:49:46.366] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:46 [12:49:46.710] INFO: pxe:service Proving completed in 2944.865446ms {"timings":{"total":2944.865446,"sync":31.664170000000013,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":568.2376140000051,"oracles":{"debugLog":{"times":[1.1100569999980507,0.3327300000019022,0.8015679999989516,0.8398009999982605,0.7632560000020021,0.45971799999824725,0.5497829999985697,0.890863000000536]},"fetchTaggedLogs":{"times":[118.79607100000067]},"loadCapsule":{"times":[0.20205199999691104,0.3733830000019225,0.5148210000006657,2.856062999999267,1.3056680000008782,4.674063999998907]},"getSharedSecret":{"times":[3.2126250000001164]},"aes128Decrypt":{"times":[0.8567020000009506,0.888254000001325]},"getPublicKeysAndPartialAddress":{"times":[3.1079680000002554]},"getKeyValidationRequest":{"times":[10.459263999997347]},"deliverNote":{"times":[20.96618099999978]},"deleteCapsule":{"times":[2.856173000000126]},"storeCapsule":{"times":[2.1384190000026138]},"getNotes":{"times":[8.000004999998055]},"getAuthWitness":{"times":[0.3108490000013262]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07801499999914085]},"callPrivateFunction":{"times":[734.5967249999994,140.18966699999874]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4467469999981404]}}},{"functionName":"private_kernel_init","time":62.080393000000186},{"functionName":"ContractClassRegisterer:register","time":717.7521649999981,"oracles":{"loadCapsule":{"times":[8.89781899999798]},"notifyCreatedNullifier":{"times":[1.2983089999979711]},"debugLog":{"times":[0.8753530000030878]},"notifyCreatedContractClassLog":{"times":[7.266650999998092]}}},{"functionName":"private_kernel_inner","time":151.49166200000036},{"functionName":"ContractInstanceDeployer:deploy","time":87.83563199999844,"oracles":{"storeInExecutionCache":{"times":[0.3460010000017064]},"callPrivateFunction":{"times":[39.68068499999936]},"notifyCreatedNullifier":{"times":[0.42231600000013714]},"debugLog":{"times":[0.7001320000017586]}}},{"functionName":"private_kernel_inner","time":193.8594000000012},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":29.92097400000057,"oracles":{}},{"functionName":"private_kernel_inner","time":249.47111199999927},{"functionName":"private_kernel_reset","time":233.2189959999996},{"functionName":"private_kernel_tail","time":109.46394399999917}],"unaccounted":509.8693839999978}} 12:49:46 [12:49:46.754] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:47 [12:49:47.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:47 [12:49:47.081] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","blockNumber":2,"slot":3} 12:49:47 [12:49:47.107] VERBOSE: p2p:tx_pool Adding tx 0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7 to pool {"eventName":"tx-added-to-pool","txHash":"0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 12:49:47 [12:49:47.147] INFO: node Received tx 0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7 {"txHash":"0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7"} 12:49:47 [12:49:47.148] INFO: pxe:service Sent transaction 0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7 12:49:47 [12:49:47.286] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:47 [12:49:47.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:47 [12:49:47.638] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 12:49:47 [12:49:47.676] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T12:54:34.000Z","now":"2025-06-18T12:54:39.880Z"} 12:49:47 [12:49:47.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:48 [12:49:48.121] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:48 [12:49:48.346] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:48 [12:49:48.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:48 [12:49:48.557] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":485.1121639999983} 12:49:48 [12:49:48.729] VERBOSE: simulator:public-processor Processed tx 0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7 with 1 public calls in 865.2206440000009ms {"txHash":"0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7","txFee":139009277500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":380416,"l2Gas":418375},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":6144,"l2Gas":381831},"billedGas":{"daGas":380416,"l2Gas":418375}},"publicDataWriteCount":12,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":865.2206440000009} 12:49:48 [12:49:48.731] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.0543558970000013s {"duration":1.0543558970000013,"rate":362146.21750249434,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 12:49:48 [12:49:48.752] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:48 [12:49:48.927] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 296089.41665733047 mana/s {"blockHash":"0x129f6050e83ee5bc2a3b3710f2c4a092c65df528379231ce25ac63833919a757","globalVariables":{"chainId":31337,"version":26898890,"blockNumber":2,"slotNumber":3,"timestamp":1750251274,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x173c649ff9f0ecfd27e0851efc88994eaa0cc146c8da76e7eb5de0bb302ae3a7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1288.8918330000015,"publicProcessDuration":1054.7791529999995,"rollupCircuitsDuration":1256.1362769999978,"txCount":1,"blockNumber":2,"blockTimestamp":1750251274,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:49:48 [12:49:48.929] VERBOSE: sequencer Attesting committee is empty 12:49:49 [12:49:49.055] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:49 [12:49:49.285] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:49 [12:49:49.293] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4c8ea4825888b0a1d77488a981f28bacf04dfa6c0f9078278066d7db02f74d69 12:49:49 [12:49:49.293] VERBOSE: sequencer-client Sent L1 transaction 0x4c8ea4825888b0a1d77488a981f28bacf04dfa6c0f9078278066d7db02f74d69 {"gasLimit":470280,"maxFeePerGas":"1.303611161","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:49:49 [12:49:49.306] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251310] on http://127.0.0.1:8545 12:49:49 [12:49:49.309] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:49:49 [12:49:49.310] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4c8ea4825888b0a1d77488a981f28bacf04dfa6c0f9078278066d7db02f74d69","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1750251274,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:49:49 [12:49:49.311] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:49:49 [12:49:49.318] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:49 [12:49:49.324] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251310 12:49:49 [12:49:49.324] WARN: foundation:test-date-provider Time set to 2025-06-18T12:55:10.000Z {"offset":320676,"timeMs":1750251310000} 12:49:49 [12:49:49.325] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 12:49:49 [12:49:49.329] INFO: blob-sink:server Received blob sidecar for block 0x22ca6ae6ca83f691466e3c777afab5dffa4d197e24c4edf15f3e0b399d1d7b3e 12:49:49 [12:49:49.338] INFO: blob-sink:server Blob sidecar stored successfully for block 0x22ca6ae6ca83f691466e3c777afab5dffa4d197e24c4edf15f3e0b399d1d7b3e 12:49:49 [12:49:49.488] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:49 [12:49:49.691] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:49 [12:49:49.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:49 [12:49:49.913] VERBOSE: archiver:block-helper Store contract instance at 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774 12:49:49 [12:49:49.946] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 12:49:50 [12:49:50.014] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x129f6050e83ee5bc2a3b3710f2c4a092c65df528379231ce25ac63833919a757","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":26898890,"blockNumber":2,"slotNumber":3,"timestamp":1750251274,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","archiveNextLeafIndex":3} 12:49:50 [12:49:50.170] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":32.7339350000002,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750251274,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:49:50 [12:49:50.188] VERBOSE: p2p Synched to latest block 2 12:49:50 [12:49:50.398] INFO: aztecjs:deploy_sent_tx Contract 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774 successfully deployed. 12:49:50 [12:49:50.399] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public 12:49:50 [12:49:50.402] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:50 [12:49:50.430] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public returns 0 for non existent value 12:49:50 [12:49:50.440] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private works as expected for no notes 12:49:50 [12:49:50.453] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private 12:49:50 [12:49:50.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:50 [12:49:50.798] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","blockNumber":3,"slot":4} 12:49:50 [12:49:50.816] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","header":{"contentCommitment":{"blobsHash":"0x006d534939fe6a543dae16ec4c668bbf853dfc52186a6fbb526ab7dab84b73c2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750251274,"version":26898890},"lastArchive":"0x022d2393b31da2ab699e26f5d5f2961f6e1847ad0e03ed7152f07b2ab1d57a9d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x224ec44750a09d6951e7e0d80455b020bfc2df06dec5b394de7ce9c9fed753c8","nullifierTree":"0x10cdb3af71c1c6739d735ebfd6a721e65bbefc963db3f63e3a0f51b04b5713ff","publicDataTree":"0x267eea31b86d9ba688480b4f914064aadaaea1d4cffe46e178b0aeb2332b0d60"},"totalFees":139009277500,"totalManaUsed":418375}} 12:49:50 [12:49:50.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:50 [12:49:50.944] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:50 [12:49:50.992] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:50 [12:49:50.992] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:51 [12:49:51.077] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e"} 12:49:51 [12:49:51.095] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1568b2db3d985843089a4b3149f847bb1bebb2f281ca64ca571dca0378b8603d 12:49:51 [12:49:51.113] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:49:51 [12:49:51.115] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:49:51 [12:49:51.126] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:49:51 [12:49:51.127] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:49:51 [12:49:51.139] VERBOSE: pxe:service Added note {"index":0,"contract":"0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06ee787b9241717920ec44110f4a9143bb2b492f345b210df86c62a8fd10977d","nullifier":"0x251e8818bda5cabeda8a90a0d4a37b854518b37660e90489bb64d2b62093f436"} 12:49:51 [12:49:51.143] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:51 [12:49:51.156] VERBOSE: simulator:client_execution_context:debug_log Setting 0x009404fd45de0989ebc8fe733e51193b093fc9a1ad4adf309edf076f0c73411e as fee payer 12:49:51 [12:49:51.295] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:51 [12:49:51.690] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774"} 12:49:51 [12:49:51.792] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:51 [12:49:51.793] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774"} 12:49:51 [12:49:51.807] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.002] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","blockNumber":3,"slot":4} 12:49:52 [12:49:52.038] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774"} 12:49:52 [12:49:52.042] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:52 [12:49:52.067] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.336] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:53 [12:49:53.259] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","blockNumber":3,"slot":4} 12:49:53 [12:49:53.541] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:53 [12:49:53.918] INFO: pxe:service Proving completed in 3144.7214989999993ms {"timings":{"total":3144.7214989999993,"sync":45.89292199999909,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":575.3264209999979,"oracles":{"debugLog":{"times":[0.5232519999990473,0.6566600000005565,0.7267640000027313,0.822280000000319,0.6200370000005933,0.5012600000009115,0.39190400000006775,0.42148599999927683]},"fetchTaggedLogs":{"times":[99.41703599999892]},"loadCapsule":{"times":[0.47164799999882234,0.498249999996915,0.9338669999997364,1.167260999998689,0.21081300000150804,0.3351699999984703]},"getSharedSecret":{"times":[8.857487000001129]},"aes128Decrypt":{"times":[0.4070350000001781,1.3587220000008529]},"getPublicKeysAndPartialAddress":{"times":[4.541785000001255]},"getKeyValidationRequest":{"times":[2.26340799999889]},"deliverNote":{"times":[12.6889889999984]},"deleteCapsule":{"times":[0.36929199999940465]},"storeCapsule":{"times":[0.48085899999932735]},"getNotes":{"times":[2.104267999999138]},"getAuthWitness":{"times":[0.26631600000109756]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.03880299999946146]},"callPrivateFunction":{"times":[1203.265212000002]}}},{"functionName":"private_kernel_init","time":75.62752400000318},{"functionName":"Token:mint_to_private","time":952.1523430000016,"oracles":{"debugLog":{"times":[0.8464910000002419,0.47170900000128313]},"fetchTaggedLogs":{"times":[248.0646459999989]},"loadCapsule":{"times":[0.21325299999807612,0.3000580000007176,0.22830400000020745]},"getRandomField":{"times":[0.15546900000117603,0.09979600000224309,0.16666999999870313,0.06982500000231084,0.05770299999858253,0.05127300000094692,0.05409299999882933,0.049742999999580206,0.0594329999985348,0.053423000001203036,0.045552999999927124,0.052643999999418156]},"getIndexedTaggingSecretAsSender":{"times":[142.5556609999985]},"incrementAppTaggingSecretIndexAsSender":{"times":[135.3709549999985]},"notifyCreatedNullifier":{"times":[0.28315700000166544]},"storeInExecutionCache":{"times":[0.053212999999232125]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07010499999887543]}}},{"functionName":"private_kernel_inner","time":216.67511300000115},{"functionName":"private_kernel_reset","time":262.3207500000026},{"functionName":"private_kernel_tail","time":119.4515399999982}],"unaccounted":897.2748859999956}} 12:49:53 [12:49:53.957] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:53 [12:49:53.997] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","blockNumber":3,"slot":4} 12:49:54 [12:49:54.005] VERBOSE: p2p:tx_pool Adding tx 0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916 to pool {"eventName":"tx-added-to-pool","txHash":"0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 12:49:54 [12:49:54.016] INFO: node Received tx 0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916 {"txHash":"0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916"} 12:49:54 [12:49:54.016] INFO: pxe:service Sent transaction 0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916 12:49:54 [12:49:54.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.700] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 12:49:54 [12:49:54.732] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T12:55:10.000Z","now":"2025-06-18T12:55:15.408Z"} 12:49:54 [12:49:54.803] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.809] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":50.67095100000006} 12:49:54 [12:49:54.838] VERBOSE: simulator:public-processor Processed tx 0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916 with 1 public calls in 94.00317799999902ms {"txHash":"0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916","txFee":24485900700,"revertCode":0,"gasUsed":{"totalGas":{"daGas":13312,"l2Gas":73695},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":2048,"l2Gas":42495},"billedGas":{"daGas":13312,"l2Gas":73695}},"publicDataWriteCount":2,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":1,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":94.00317799999902} 12:49:54 [12:49:54.840] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10694725199999812s {"duration":0.10694725199999812,"rate":397345.4128583009,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 12:49:54 [12:49:54.992] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 139106.53894681894 mana/s {"blockHash":"0x1d23f8567f104f02c003a2aa6d99ec42cc49dd558138a30bd96951a85387299b","globalVariables":{"chainId":31337,"version":26898890,"blockNumber":3,"slotNumber":4,"timestamp":1750251310,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1f4532460369adbefd32259b3a0b77dc4e545631deeba1e5ae0b46fecff83916"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":304.7042419999998,"publicProcessDuration":107.28234299999895,"rollupCircuitsDuration":261.10984899999676,"txCount":1,"blockNumber":3,"blockTimestamp":1750251310,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 12:49:54 [12:49:54.995] VERBOSE: sequencer Attesting committee is empty 12:49:55 [12:49:55.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.310] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcee30da5e6e18df5dbed716356e41278594fbb3a31021f35f4552a92fde4bfed 12:49:55 [12:49:55.310] VERBOSE: sequencer-client Sent L1 transaction 0xcee30da5e6e18df5dbed716356e41278594fbb3a31021f35f4552a92fde4bfed {"gasLimit":478969,"maxFeePerGas":"1.279583383","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:49:55 [12:49:55.325] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251346] on http://127.0.0.1:8545 12:49:55 [12:49:55.329] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:55 [12:49:55.335] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:49:55 [12:49:55.336] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcee30da5e6e18df5dbed716356e41278594fbb3a31021f35f4552a92fde4bfed","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1750251310,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 12:49:55 [12:49:55.337] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:49:55 [12:49:55.341] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251346 12:49:55 [12:49:55.341] WARN: foundation:test-date-provider Time set to 2025-06-18T12:55:46.000Z {"offset":350659,"timeMs":1750251346000} 12:49:55 [12:49:55.341] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 12:49:55 [12:49:55.346] INFO: blob-sink:server Received blob sidecar for block 0x68e4ef89472796f17da93e76c680e999b2165c8be995580c44386790ed2f7e5a 12:49:55 [12:49:55.368] INFO: blob-sink:server Blob sidecar stored successfully for block 0x68e4ef89472796f17da93e76c680e999b2165c8be995580c44386790ed2f7e5a 12:49:55 [12:49:55.504] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.707] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.911] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.042] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1d23f8567f104f02c003a2aa6d99ec42cc49dd558138a30bd96951a85387299b","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":26898890,"blockNumber":3,"slotNumber":4,"timestamp":1750251310,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1fc14a9dbae5527c409497838277c47563702c0d45286f083e1e1cf6319808f4","archiveNextLeafIndex":4} 12:49:56 [12:49:56.112] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1fc14a9dbae5527c409497838277c47563702c0d45286f083e1e1cf6319808f4","header":{"contentCommitment":{"blobsHash":"0x0075ebd303532ac916d9bbf44ac9eb1432382e4ec0b3d629e2ee3cc263c4c4d1","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750251310,"version":26898890},"lastArchive":"0x221dca658edcffb3c7b3e4438f5413605ec153065f56617c10305782bfae9aaf","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x17386ff19421519cbfd8421eb696d917665be08a34880e4277a21334ef16c591","nullifierTree":"0x23159f5fea5c9717aea01aaf57def2f6a8c69f8c3eddac772d17b8cc7dd27fd1","publicDataTree":"0x1b5c8efff075328d4172d1f2be7c816d3cab427cd19fbe2385410fb95763b6b2"},"totalFees":24485900700,"totalManaUsed":73695}} 12:49:56 [12:49:56.260] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.286] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":12.913123000002088,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750251310,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 12:49:56 [12:49:56.295] VERBOSE: p2p Synched to latest block 3 12:49:56 [12:49:56.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.743] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774","selector":"0xc6cedc33"} 12:49:56 [12:49:56.759] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 12:49:56 [12:49:56.759] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774"} 12:49:56 [12:49:56.916] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1fc14a9dbae5527c409497838277c47563702c0d45286f083e1e1cf6319808f4","blockNumber":4,"slot":5} 12:49:56 [12:49:56.947] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774"} 12:49:56 [12:49:56.954] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x05dda2771fc20627d65ff8f1b4269230fa23a1b679e99e6e0693565ccdb2ed6a 12:49:56 [12:49:56.958] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.969] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 12:49:56 [12:49:56.974] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 12:49:56 [12:49:56.980] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x12edf17be64938466e44e1e0c248b8e43eb7d4e446018d2bcb75e3c148beaa0d 12:49:56 [12:49:56.981] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774 for storage slot 0x037862aba29bd49869ec8a75892ad3c09ad6be8e236b4d472be1eee0fd7e5b31 12:49:57 [12:49:57.000] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:49:57 [12:49:57.001] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x12edf17be64938466e44e1e0c248b8e43eb7d4e446018d2bcb75e3c148beaa0d 12:49:57 [12:49:57.011] VERBOSE: pxe:service Added note {"index":128,"contract":"0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774","slot":"0x037862aba29bd49869ec8a75892ad3c09ad6be8e236b4d472be1eee0fd7e5b31","noteHash":"0x28de12170ae2c2a745c3c573959285d6246f28fd131988a196acab24a539b2ca","nullifier":"0x09a577800a3e05f3f6ce8d748ae57027195006322f23be029b5fcafd41e17829"} 12:49:57 [12:49:57.013] VERBOSE: simulator Utility simulation for 0x07e6ca99830308c63fecf88d451725d50ba519a9b4a36a130ce28f4420a7e774.0xc6cedc33 completed 12:49:57 [12:49:57.017] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes markAsProven 12:49:57 [12:49:57.024] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 12:49:57 [12:49:57.025] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 12:49:57 [12:49:57.028] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 3. Pending tip: 3. 12:49:57 [12:49:57.035] INFO: node Stopping 12:49:57 [12:49:57.035] INFO: slasher Slasher client stopped. 12:49:57 [12:49:57.036] INFO: sequencer Stopped sequencer 12:49:57 [12:49:57.036] INFO: p2p P2P client stopped. 12:49:57 [12:49:57.037] INFO: world_state Stopped world state synchronizer 12:49:57 [12:49:57.038] INFO: archiver Stopped. 12:49:57 [12:49:57.038] INFO: node Stopped 12:49:57 [12:49:57.038] VERBOSE: e2e:e2e_cheat_codes Cleaning up ACVM state 12:49:57 [12:49:57.038] INFO: e2e:e2e_cheat_codes Cleaning up ACVM temp directory /tmp/1145b5ea 12:49:57 [12:49:57.039] VERBOSE: e2e:e2e_cheat_codes Cleaning up BB state 12:49:57 [12:49:57.041] INFO: blob-sink:server Stopping blob sink 12:49:57 [12:49:57.042] INFO: blob-sink:server Blob sink stopped 12:49:57 [12:49:57.042] VERBOSE: e2e:e2e_cheat_codes Cleaning up data directory at /tmp/6a8f04e999c27549 12:49:57 PASS src/e2e_cheat_codes.test.ts 12:49:57 e2e_cheat_codes 12:49:57 L1 cheatcodes 12:49:57 ✓ setNextBlockTimestamp by 100 (147 ms) 12:49:57 ✓ setNextBlockTimestamp by 42 (134 ms) 12:49:57 ✓ setNextBlockTimestamp by 99 (129 ms) 12:49:57 ✓ setNextBlockTimestamp to a past timestamp throws (135 ms) 12:49:57 ✓ load a value at a particular storage slot (110 ms) 12:49:57 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (139 ms) 12:49:57 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (109 ms) 12:49:57 ✓ set bytecode correctly (107 ms) 12:49:57 ✓ impersonate (131 ms) 12:49:57 mine 12:49:57 ✓ mine block (286 ms) 12:49:57 ✓ mine 10 blocks (126 ms) 12:49:57 ✓ mine 42 blocks (111 ms) 12:49:57 ✓ mine 99 blocks (140 ms) 12:49:57 L2 cheatcodes 12:49:57 ✓ load public (32 ms) 12:49:57 ✓ load public returns 0 for non existent value (10 ms) 12:49:57 ✓ load private works as expected for no notes (12 ms) 12:49:57 ✓ load private (6563 ms) 12:49:57 ✓ markAsProven (13 ms) 12:49:57 12:49:57 Test Suites: 1 passed, 1 total 12:49:57 Tests: 18 passed, 18 total 12:49:57 Snapshots: 0 total 12:49:57 Time: 30.04 s 12:49:57 Ran all test suites matching /src\/e2e_cheat_codes.test.ts/i. 12:49:57 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?