Parent Log: http://ci.aztec-labs.com/4394d8959cc7e035 Command: 97e7ef9a556fd7e6: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/a3ecf3ea26aad0390dd15cfadbb1d160e85e5f89 Env: REF_NAME=gh-readonly-queue/master/pr-15194-f3a077dd83e56ee0ae0a1175f0dc39fdfa50e6d7 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Tue Jun 24 17:23:53 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15194_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_39ce75ad687a474b_master 17:23:53 +++ id -u 17:23:53 +++ id -g 17:23:53 ++ 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'\''' 17:23:54 + cid=176aa59ec619037cef787e0317ed2cbdb42e4c3890599e9fdbc0332ec993b3af 17:23:54 + set +x 17:23:55 {"level":25,"time":1750785835014,"pid":12,"hostname":"176aa59ec619","module":"logger","msg":"Logger initialized with level verbose"} 17:24:00 [17:24:00.278] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine block 17:24:00 [17:24:00.546] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.572] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:00 [17:24:00.579] WARN: ethereum:cheat_codes Mined 1 L1 blocks 17:24:00 [17:24:00.580] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.595] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 10 blocks 17:24:00 [17:24:00.720] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.724] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [10] on http://127.0.0.1:8545 17:24:00 [17:24:00.728] WARN: ethereum:cheat_codes Mined 10 L1 blocks 17:24:00 [17:24:00.728] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.734] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 42 blocks 17:24:00 [17:24:00.854] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.865] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [42] on http://127.0.0.1:8545 17:24:00 [17:24:00.870] WARN: ethereum:cheat_codes Mined 42 L1 blocks 17:24:00 [17:24:00.870] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.876] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 99 blocks 17:24:00 [17:24:00.963] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.967] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [99] on http://127.0.0.1:8545 17:24:00 [17:24:00.979] WARN: ethereum:cheat_codes Mined 99 L1 blocks 17:24:00 [17:24:00.979] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:00 [17:24:00.984] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 100 17:24:01 [17:24:01.078] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.085] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750785941] on http://127.0.0.1:8545 17:24:01 [17:24:01.087] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750785941 17:24:01 [17:24:01.088] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.092] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:01 [17:24:01.094] WARN: ethereum:cheat_codes Mined 1 L1 blocks 17:24:01 [17:24:01.094] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.099] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 42 17:24:01 [17:24:01.189] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.192] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.194] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750785883] on http://127.0.0.1:8545 17:24:01 [17:24:01.196] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750785883 17:24:01 [17:24:01.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.198] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:01 [17:24:01.199] WARN: ethereum:cheat_codes Mined 1 L1 blocks 17:24:01 [17:24:01.199] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.201] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.204] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 99 17:24:01 [17:24:01.288] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.302] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.306] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750785940] on http://127.0.0.1:8545 17:24:01 [17:24:01.308] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750785940 17:24:01 [17:24:01.309] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.311] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:01 [17:24:01.312] WARN: ethereum:cheat_codes Mined 1 L1 blocks 17:24:01 [17:24:01.312] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 17:24:01 [17:24:01.314] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.319] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp to a past timestamp throws 17:24:01 [17:24:01.410] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:01 [17:24:01.413] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750784841] on http://127.0.0.1:8545 17:24:01 [17:24:01.429] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes load a value at a particular storage slot 17:24:01 [17:24:01.533] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0x0000000000000000000000000000000000000000","0x00","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.542] 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) 17:24:01 [17:24:01.628] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:24:01 [17:24:01.631] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 1 to 5 17:24:01 [17:24:01.631] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.636] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:24:01 [17:24:01.637] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 78541660797044910968829902406342334108369226379826116161446442989268089806461 to 5 17:24:01 [17:24:01.638] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.642] 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) 17:24:01 [17:24:01.734] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:24:01 [17:24:01.740] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 85149632668394328379478047665368132835280330034293399760893490333839055043265 to 5 17:24:01 [17:24:01.740] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.743] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:24:01 [17:24:01.745] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 58076768977499219212177354345858258922703203414073725940090140522697466344574 to 5 17:24:01 [17:24:01.746] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.749] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes set bytecode correctly 17:24:01 [17:24:01.844] INFO: ethereum:cheat_codes Calling hardhat_setCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","0x1234"] on http://127.0.0.1:8545 17:24:01 [17:24:01.847] WARN: ethereum:cheat_codes Set bytecode for 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 to 0x1234 17:24:01 [17:24:01.847] INFO: ethereum:cheat_codes Calling eth_getCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","latest"] on http://127.0.0.1:8545 17:24:01 [17:24:01.851] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes impersonate 17:24:01 [17:24:01.949] INFO: ethereum:cheat_codes Calling hardhat_impersonateAccount with params: ["0x02426d4d3a2fffeaaf2133f9ce7ce0fa832de55e"] on http://127.0.0.1:8545 17:24:01 [17:24:01.950] WARN: ethereum:cheat_codes Impersonating 0x02426d4d3a2fffeaaf2133f9ce7ce0fa832de55e 17:24:01 [17:24:01.957] INFO: ethereum:cheat_codes Calling hardhat_stopImpersonatingAccount with params: ["0x02426d4d3a2fffeaaf2133f9ce7ce0fa832de55e"] on http://127.0.0.1:8545 17:24:01 [17:24:01.958] WARN: ethereum:cheat_codes Stopped impersonating 0x02426d4d3a2fffeaaf2133f9ce7ce0fa832de55e 17:24:02 [17:24:02.028] INFO: e2e:e2e_cheat_codes Logging metrics to log/e2e_cheat_codes.jsonl 17:24:02 [17:24:02.130] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-qaTWTO/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:24:02 [17:24:02.167] INFO: e2e:e2e_cheat_codes Calling anvil_setBlockTimestampInterval with params: [12] 17:24:02 [17:24:02.169] WARN: e2e:e2e_cheat_codes Set block interval to 12 17:24:02 [17:24:02.169] VERBOSE: e2e:e2e_cheat_codes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:24:02 [17:24:02.192] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:24:02 [17:24:02.199] VERBOSE: e2e:e2e_cheat_codes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:24:02 [17:24:02.212] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:24:02 [17:24:02.215] VERBOSE: e2e:e2e_cheat_codes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:24:02 [17:24:02.231] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:24:02 [17:24:02.235] VERBOSE: e2e:e2e_cheat_codes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:24:02 [17:24:02.246] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:24:02 [17:24:02.250] VERBOSE: e2e:e2e_cheat_codes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:24:02 [17:24:02.275] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:24:02 [17:24:02.281] VERBOSE: e2e:e2e_cheat_codes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:24:02 [17:24:02.294] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:24:02 [17:24:02.298] VERBOSE: e2e:e2e_cheat_codes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:24:02 [17:24:02.299] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 17:24:02 [17:24:02.299] INFO: e2e:e2e_cheat_codes Waiting for 6 transactions to be mined... 17:24:02 [17:24:02.313] INFO: e2e:e2e_cheat_codes All transactions mined successfully 17:24:02 [17:24:02.327] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:24:02 [17:24:02.327] VERBOSE: e2e:e2e_cheat_codes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:24:02 [17:24:02.337] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:24:02 [17:24:02.354] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:24:02 [17:24:02.357] VERBOSE: e2e:e2e_cheat_codes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:24:02 [17:24:02.377] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:24:02 [17:24:02.378] VERBOSE: e2e:e2e_cheat_codes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:24:02 [17:24:02.394] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:24:02 [17:24:02.400] VERBOSE: e2e:e2e_cheat_codes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:24:02 [17:24:02.417] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:24:02 [17:24:02.418] VERBOSE: e2e:e2e_cheat_codes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:24:02 [17:24:02.418] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 17:24:02 [17:24:02.418] INFO: e2e:e2e_cheat_codes Waiting for 8 transactions to be mined... 17:24:02 [17:24:02.435] INFO: e2e:e2e_cheat_codes All transactions mined successfully 17:24:02 [17:24:02.444] VERBOSE: e2e:e2e_cheat_codes Deployed shared contracts 17:24:02 [17:24:02.459] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:24:02 [17:24:02.460] VERBOSE: e2e:e2e_cheat_codes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:24:02 [17:24:02.463] 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} 17:24:02 [17:24:02.478] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:24:02 [17:24:02.506] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:24:02 [17:24:02.511] VERBOSE: e2e:e2e_cheat_codes Awaiting for linked libraries to be deployed 17:24:02 [17:24:02.544] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x14b8468b6d3fe838b085fb4e1ea66350bb9dc44e7b8f3c1411c4af8d36b8bc24 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:24:02 [17:24:02.549] 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} 17:24:02 [17:24:02.550] INFO: e2e:e2e_cheat_codes Waiting for 9 transactions to be mined... 17:24:02 [17:24:02.570] INFO: e2e:e2e_cheat_codes All transactions mined successfully 17:24:02 [17:24:02.570] VERBOSE: e2e:e2e_cheat_codes All core contracts have been deployed 17:24:02 [17:24:02.581] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:24:02 [17:24:02.582] VERBOSE: e2e:e2e_cheat_codes Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:24:02 [17:24:02.591] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:24:02 [17:24:02.598] VERBOSE: e2e:e2e_cheat_codes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:24:02 [17:24:02.636] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:24:02 [17:24:02.636] VERBOSE: e2e:e2e_cheat_codes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:24:02 [17:24:02.637] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 17:24:02 [17:24:02.659] INFO: e2e:e2e_cheat_codes All transactions mined successfully 17:24:02 [17:24:02.670] VERBOSE: e2e:e2e_cheat_codes Rollup deployed 17:24:02 [17:24:02.671] VERBOSE: e2e:e2e_cheat_codes Waiting for rollup and slash factory to be deployed 17:24:02 [17:24:02.671] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 17:24:02 [17:24:02.704] INFO: e2e:e2e_cheat_codes All transactions mined successfully 17:24:02 [17:24:02.704] VERBOSE: e2e:e2e_cheat_codes All transactions for L1 deployment have been mined 17:24:02 [17:24:02.725] 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"} 17:24:02 [17:24:02.729] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:24:02 [17:24:02.731] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:02 [17:24:02.732] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:24:02 [17:24:02.733] INFO: telemetry:client Using NoopTelemetryClient 17:24:02 [17:24:02.742] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:24:02 [17:24:02.742] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:24:02 [17:24:02.744] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/958ec08cc4e80956/blob-sink with map size 134217728 KB (LMDB v2) 17:24:02 [17:24:02.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:02 [17:24:02.750] INFO: aztecjs:utils:watcher New L1 time: 1750786082 17:24:02 [17:24:02.750] WARN: foundation:test-date-provider Time set to 2025-06-24T17:28:02.000Z {"offset":239250,"timeMs":1750786082000} 17:24:02 [17:24:02.753] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:24:02 [17:24:02.765] INFO: blob-sink:server Server is running on http://localhost:39529 17:24:02 [17:24:02.765] VERBOSE: e2e:e2e_cheat_codes Creating and synching an aztec node... 17:24:02 [17:24:02.770] VERBOSE: e2e:e2e_cheat_codes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/1a8f4cc2/acvm 17:24:02 [17:24:02.773] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:39529"} 17:24:02 [17:24:02.788] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:24:02 [17:24:02.789] INFO: archiver:lmdb Creating archiver data store at directory /tmp/958ec08cc4e80956/archiver with map size 134217728 KB (LMDB v2) 17:24:02 [17:24:02.790] INFO: archiver:lmdb Starting data store with maxReaders 16 17:24:02 [17:24:02.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:03 [17:24:03.105] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:39529"} 17:24:03 [17:24:03.124] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:39529"} 17:24:03 [17:24:03.124] WARN: node:blob-sink:client No L1 consensus host urls configured 17:24:03 [17:24:03.124] WARN: node:blob-sink:client No archive client configured 17:24:03 [17:24:03.127] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x2b0d02e2ec2c1139e68859a21f2feb18d1de90a8c0584074ddec617b2b816d75 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xc3fc25f3420de8cb9309e721e025d8aedec751b15e277e899512405d2cc7e0be","l1BlockNumber":16}} 17:24:03 [17:24:03.147] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:24:03 [17:24:03.160] INFO: world-state:database Creating world state data store at directory /tmp/958ec08cc4e80956/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:24:03 [17:24:03.190] INFO: world_state Created world state synchroniser with block history of 64 17:24:03 [17:24:03.190] WARN: node Aztec node is accepting fake proofs 17:24:03 [17:24:03.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:03 [17:24:03.203] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/958ec08cc4e80956/p2p with map size 134217728 KB (LMDB v2) 17:24:03 [17:24:03.205] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:24:03 [17:24:03.207] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/958ec08cc4e80956/p2p-archive with map size 134217728 KB (LMDB v2) 17:24:03 [17:24:03.209] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:24:03 [17:24:03.210] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/958ec08cc4e80956/p2p-peers with map size 134217728 KB (LMDB v2) 17:24:03 [17:24:03.212] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:24:03 [17:24:03.214] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:24:03 [17:24:03.215] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:24:03 [17:24:03.218] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:24:03 [17:24:03.219] INFO: world_state Started world state synchronizer from block 1 17:24:03 [17:24:03.223] VERBOSE: world-state:block_stream Starting sync from block number 0 17:24:03 [17:24:03.229] INFO: p2p Starting p2p client from block 0 with empty mempools 17:24:03 [17:24:03.229] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:24:03 [17:24:03.230] INFO: slasher Slasher client initialized 17:24:03 [17:24:03.230] INFO: slasher Starting Slasher client... 17:24:03 [17:24:03.281] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:24:03 [17:24:03.282] VERBOSE: node All Aztec Node subsystems synced 17:24:03 [17:24:03.293] INFO: sequencer-client Deploying forwarder contract 17:24:03 [17:24:03.299] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:24:03 [17:24:03.312] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:24:03 [17:24:03.313] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:24:03 [17:24:03.318] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:24:03 [17:24:03.334] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:24:03 [17:24:03.335] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:24:03 [17:24:03.335] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/1a8f4cc2/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:24:03 [17:24:03.575] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:24:03 [17:24:03.577] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:24:03 [17:24:03.578] INFO: node Aztec Node version: 0.87.9 17:24:03 [17:24:03.578] 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"} 17:24:03 [17:24:03.579] VERBOSE: e2e:e2e_cheat_codes Creating a pxe... 17:24:03 [17:24:03.582] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:03 [17:24:03.588] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/e619b867182995ec/pxe_data with map size 134217728 KB (LMDB v2) 17:24:03 [17:24:03.601] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:03 [17:24:03.602] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:24:03 [17:24:03.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:03 [17:24:03.914] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:24:03 [17:24:03.915] INFO: pxe:service Started PXE connected to chain 31337 version 1530628867 17:24:03 [17:24:03.967] INFO: pxe:service Registered account 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 17:24:04 [17:24:04.026] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:04 [17:24:04.027] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:24:04 [17:24:04.028] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 17:24:04 [17:24:04.145] INFO: pxe:service Added contract SchnorrAccount at 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:24:04 [17:24:04.154] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:04 [17:24:04.180] VERBOSE: pxe:block_stream Starting sync from block number 0 17:24:04 [17:24:04.219] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:24:04 [17:24:04.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:04 [17:24:04.340] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:24:05 [17:24:05.112] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:24:05 [17:24:05.221] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:24:05 [17:24:05.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:05 [17:24:05.314] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:05 [17:24:05.394] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.429] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:24:05 [17:24:05.429] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.477] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.481] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:24:05 [17:24:05.501] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:05 [17:24:05.628] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.667] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:24:05 [17:24:05.668] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.697] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:05 [17:24:05.700] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:24:05 [17:24:05.706] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:05 [17:24:05.724] VERBOSE: simulator:client_execution_context:debug_log Setting 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 as fee payer 17:24:05 [17:24:05.920] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:06 [17:24:06.020] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:06 [17:24:06.245] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:06 [17:24:06.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:06 [17:24:06.603] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:06 [17:24:06.790] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:07 [17:24:07.353] INFO: pxe:service Proving completed in 3174.7213979999997ms {"timings":{"total":3174.7213979999997,"sync":3.260201999999481,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":160.7931540000027,"oracles":{"callPrivateFunction":{"times":[1009.4406610000005,287.3720689999991,171.6466220000002]}}},{"functionName":"private_kernel_init","time":107.40056300000106},{"functionName":"ContractClassRegisterer:register","time":990.6477249999989,"oracles":{"loadCapsule":{"times":[43.08455200000026]},"notifyCreatedNullifier":{"times":[0.6537939999998343]},"debugLog":{"times":[0.7208559999999125]},"notifyCreatedContractClassLog":{"times":[10.690907000000152]}}},{"functionName":"private_kernel_inner","time":198.95185499999934},{"functionName":"SchnorrAccount:constructor","time":257.2538629999981,"oracles":{"getContractInstance":{"times":[1.2017369999994116]},"debugLog":{"times":[0.47293100000024424,0.33750700000018696]},"fetchTaggedLogs":{"times":[50.67453000000023]},"loadCapsule":{"times":[0.3384280000009312,0.25586500000099477,0.19784400000025926]},"notifyCreatedNullifier":{"times":[0.20097399999940535,0.23179499999969266]},"notifyCreatedNote":{"times":[0.30758699999933015]},"getRandomField":{"times":[0.29978699999992386,0.22548400000050606,0.09056200000122772,0.06952100000125938,0.060231999999814434,0.04385099999853992,0.03782099999989441,0.05171100000006845,0.057251000000178465,0.06187099999988277,0.04872099999920465]},"getIndexedTaggingSecretAsSender":{"times":[36.1122579999992]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.32376699999986]}}},{"functionName":"private_kernel_inner","time":180.48089699999946},{"functionName":"SchnorrAccount:entrypoint","time":149.55470400000013,"oracles":{"debugLog":{"times":[0.5569419999992533,0.5188709999983985,0.7202459999989514]},"fetchTaggedLogs":{"times":[31.389303999998447]},"loadCapsule":{"times":[0.27693600000020524,0.2690760000004957,0.2480649999997695]},"getNotes":{"times":[6.1024450000004435]},"getAuthWitness":{"times":[0.521801000000778]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.959060999999565]}}},{"functionName":"private_kernel_inner","time":157.43352699999923},{"functionName":"private_kernel_reset","time":206.0602029999991},{"functionName":"private_kernel_tail","time":90.13348099999894}],"unaccounted":672.7512240000033}} 17:24:07 [17:24:07.376] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:07 [17:24:07.569] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","blockNumber":1,"slot":2} 17:24:07 [17:24:07.576] VERBOSE: p2p:tx_pool Adding tx 0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0 to pool {"eventName":"tx-added-to-pool","txHash":"0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:24:07 [17:24:07.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:07 [17:24:07.602] INFO: node Received tx 0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0 {"txHash":"0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0"} 17:24:07 [17:24:07.602] INFO: pxe:service Sent transaction 0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0 17:24:07 [17:24:07.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:08 [17:24:08.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:08 [17:24:08.158] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:24:08 [17:24:08.192] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-24T17:28:26.000Z","now":"2025-06-24T17:28:07.442Z"} 17:24:08 [17:24:08.297] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:08 [17:24:08.473] VERBOSE: simulator:public-processor Processed tx 0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0 with no public calls in 160.21844000000056ms {"txHash":"0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0","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":160.21844000000056} 17:24:08 [17:24:08.477] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.28333050000000004s {"duration":0.28333050000000004,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:24:08 [17:24:08.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:08 [17:24:08.623] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e3ee3dd7805953b69f6dc934af9bd423c63994d8b7b37a571e22395a481c493","globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":1,"slotNumber":2,"timestamp":1750786106,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2deeff65693c7a38360280926807be322c95f998a345e025fe1341cd368a44b0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":465.96753499999977,"publicProcessDuration":284.4980450000003,"rollupCircuitsDuration":433.4085449999984,"txCount":1,"blockNumber":1,"blockTimestamp":1750786106,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:24:08 [17:24:08.626] VERBOSE: sequencer Attesting committee is empty 17:24:08 [17:24:08.756] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:09 [17:24:09.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:09 [17:24:09.089] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x6e7a90b59a41dd3ae3e5fcb392cd3612bdf201fc94ebe5a0ab90231b18715ada 17:24:09 [17:24:09.089] VERBOSE: sequencer-client Sent L1 transaction 0x6e7a90b59a41dd3ae3e5fcb392cd3612bdf201fc94ebe5a0ab90231b18715ada {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:24:09 [17:24:09.111] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:24:09 [17:24:09.112] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x6e7a90b59a41dd3ae3e5fcb392cd3612bdf201fc94ebe5a0ab90231b18715ada","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750786106,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:24:09 [17:24:09.113] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:24:09 [17:24:09.130] INFO: blob-sink:server Received blob sidecar for block 0x75d3116273e8f792b64da076fda6b83d6189492686d428e71a79dfbdf2019e65 17:24:09 [17:24:09.138] INFO: blob-sink:server Blob sidecar stored successfully for block 0x75d3116273e8f792b64da076fda6b83d6189492686d428e71a79dfbdf2019e65 17:24:09 [17:24:09.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:09 [17:24:09.312] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:24:09 [17:24:09.321] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:24:09 [17:24:09.330] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:24:09 [17:24:09.336] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786142] on http://127.0.0.1:8545 17:24:09 [17:24:09.341] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:09 [17:24:09.344] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786142 17:24:09 [17:24:09.345] WARN: foundation:test-date-provider Time set to 2025-06-24T17:29:02.000Z {"offset":292655,"timeMs":1750786142000} 17:24:09 [17:24:09.345] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:24:09 [17:24:09.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:09 [17:24:09.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:09 [17:24:09.804] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:24:09 [17:24:09.819] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0e3ee3dd7805953b69f6dc934af9bd423c63994d8b7b37a571e22395a481c493","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":1,"slotNumber":2,"timestamp":1750786106,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","archiveNextLeafIndex":2} 17:24:09 [17:24:09.825] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:24:10 [17:24:10.311] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:10 [17:24:10.315] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":414.07887800000026,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750786106,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:24:10 [17:24:10.316] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 17:24:10 [17:24:10.319] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86 17:24:10 [17:24:10.532] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:10 [17:24:10.756] VERBOSE: p2p Synched to latest block 1 17:24:10 [17:24:10.761] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:11 [17:24:11.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:11 [17:24:11.308] INFO: pxe:service Added contract Token at 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:24:11 [17:24:11.443] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:11 [17:24:11.448] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","blockNumber":2,"slot":3} 17:24:11 [17:24:11.455] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","header":{"contentCommitment":{"blobsHash":"0x00769a113f392d142d96067c22ac671a4abd0d35bef175b1bca4c71a2074a2d5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750786106,"version":1530628867},"lastArchive":"0x1b4aa1a10ed2a684d6f5d9535f5795de21abea32c494514011d6b2b0a03ad0fd","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c562002566419007ff4463a6d75a5d72c3fcaae15c171b3861f816ebacff042","nullifierTree":"0x270bf766e23e5e05d7fbe3287b68b7dc12ed7806c3224abdba2cf19ebaa6db45","publicDataTree":"0x2fed27fd9de3e1d502b7c4fa4c97881b03e6e09b6e759b362c5f118f5e6e65f5"},"totalFees":6794052480,"totalManaUsed":20448}} 17:24:11 [17:24:11.665] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:11 [17:24:11.714] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:24:11 [17:24:11.714] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:11 [17:24:11.722] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:11 [17:24:11.828] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:11 [17:24:11.849] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0257f7ff91f2a5a4ae99e0ee92e95401b08bcba85a5827e91f5bc15c1238463f 17:24:11 [17:24:11.886] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:24:11 [17:24:11.887] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:24:11 [17:24:11.895] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:24:11 [17:24:11.896] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:24:11 [17:24:11.905] VERBOSE: pxe:service Added note {"index":0,"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x141d28d131dca982a4464aa7bbd14eb9c66f74f6011aacbf59f7f99cc370046a","nullifier":"0x02fe981f52a3f3f8723d9d032ddc637b0780181dcf92029f3d304af958a6680f"} 17:24:11 [17:24:11.921] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:24:11 [17:24:11.926] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:12 [17:24:12.020] VERBOSE: simulator:client_execution_context:debug_log Setting 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 as fee payer 17:24:12 [17:24:12.056] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","blockNumber":2,"slot":3} 17:24:12 [17:24:12.090] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:24:12 [17:24:12.636] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 17:24:12 [17:24:12.782] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:24:12 [17:24:12.842] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:12 [17:24:12.939] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:24:12 [17:24:12.957] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","blockNumber":2,"slot":3} 17:24:13 [17:24:13.001] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:24:13 [17:24:13.016] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86,0x0000000000000000000000000000000000000000000000000000000000000001,0x09388fe832ba7c934b894d8b6c5904d9cbc6624e6c55df1859f1c652d443c9a4,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x2e409d9a64570f68323bf489c142fac72d1128853f351ec0e28fb811a95b2aaf,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 17:24:13 [17:24:13.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:13 [17:24:13.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:13 [17:24:13.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:13 [17:24:13.704] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","blockNumber":2,"slot":3} 17:24:13 [17:24:13.922] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:14 [17:24:14.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:14 [17:24:14.408] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:14 [17:24:14.756] INFO: pxe:service Proving completed in 3346.7881290000005ms {"timings":{"total":3346.7881290000005,"sync":48.387369000000035,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":531.4936329999982,"oracles":{"debugLog":{"times":[0.8656990000017686,0.6496739999965939,0.8797400000003108,1.2520870000007562,0.4262689999995928,0.3623479999987467,3.868395999998029,0.9194700000007288]},"fetchTaggedLogs":{"times":[125.76111899999887]},"loadCapsule":{"times":[1.1913860000022396,4.994330000001355,1.0773039999985485,0.5125010000010661,1.175796999999875,14.8981789999998]},"getSharedSecret":{"times":[21.7784610000017]},"aes128Decrypt":{"times":[1.984372999999323,2.63525799999843]},"getPublicKeysAndPartialAddress":{"times":[2.2339890000002924]},"getKeyValidationRequest":{"times":[1.8229599999976926]},"deliverNote":{"times":[10.00188100000014]},"deleteCapsule":{"times":[7.058396000000357]},"storeCapsule":{"times":[4.9091779999980645]},"getNotes":{"times":[49.95892299999832]},"getAuthWitness":{"times":[0.3115770000003977]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07800099999803933]},"callPrivateFunction":{"times":[819.4558940000024,183.32339000000138]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3260069999996631]}}},{"functionName":"private_kernel_init","time":94.23051199999827},{"functionName":"ContractClassRegisterer:register","time":809.0462829999997,"oracles":{"loadCapsule":{"times":[8.876395999999659]},"notifyCreatedNullifier":{"times":[2.810171999997692]},"debugLog":{"times":[1.5495350000019243]},"notifyCreatedContractClassLog":{"times":[10.6987360000021]}}},{"functionName":"private_kernel_inner","time":148.5074510000013},{"functionName":"ContractInstanceDeployer:deploy","time":105.01720099999875,"oracles":{"storeInExecutionCache":{"times":[0.30942700000014156]},"callPrivateFunction":{"times":[62.87919899999906]},"notifyCreatedNullifier":{"times":[0.3472970000002533]},"debugLog":{"times":[0.6064240000014252]}}},{"functionName":"private_kernel_inner","time":205.56921099999818},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.9124260000026,"oracles":{}},{"functionName":"private_kernel_inner","time":169.67946799999845},{"functionName":"private_kernel_reset","time":229.43781899999885},{"functionName":"private_kernel_tail","time":125.11329399999886}],"unaccounted":833.3934620000073}} 17:24:14 [17:24:14.823] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","blockNumber":2,"slot":3} 17:24:15 [17:24:15.009] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:15 [17:24:15.030] VERBOSE: p2p:tx_pool Adding tx 0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7 to pool {"eventName":"tx-added-to-pool","txHash":"0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 17:24:15 [17:24:15.064] INFO: node Received tx 0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7 {"txHash":"0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7"} 17:24:15 [17:24:15.065] INFO: pxe:service Sent transaction 0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7 17:24:15 [17:24:15.217] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:15 [17:24:15.417] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:24:15 [17:24:15.420] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:15 [17:24:15.482] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-24T17:29:02.000Z","now":"2025-06-24T17:29:08.137Z"} 17:24:15 [17:24:15.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:16 [17:24:16.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:16 [17:24:16.336] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:16 [17:24:16.464] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":437.1280770000012} 17:24:16 [17:24:16.660] VERBOSE: simulator:public-processor Processed tx 0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7 with 1 public calls in 935.5049179999987ms {"txHash":"0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7","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":935.5049179999987} 17:24:16 [17:24:16.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:16 [17:24:16.664] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.1811913550000026s {"duration":1.1811913550000026,"rate":323259.22331187327,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 17:24:16 [17:24:16.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:16 [17:24:16.903] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 256843.23277507984 mana/s {"blockHash":"0x04da19ddeba396433ab5b58d42a86f1b57f09b2309a460583b5824a0d9f4ca3f","globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":2,"slotNumber":3,"timestamp":1750786142,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1aeed2d15365ec44310409a77742141998b2e38223fc0f52d6118ffad8e07eb7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1485.8117960000018,"publicProcessDuration":1181.5750249999983,"rollupCircuitsDuration":1443.4562100000003,"txCount":1,"blockNumber":2,"blockTimestamp":1750786142,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:24:16 [17:24:16.906] VERBOSE: sequencer Attesting committee is empty 17:24:17 [17:24:17.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:17 [17:24:17.255] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x443ea72e943423e335ef3c8642b0f716aee57500f7c239a375accfcddf6e6911 17:24:17 [17:24:17.255] VERBOSE: sequencer-client Sent L1 transaction 0x443ea72e943423e335ef3c8642b0f716aee57500f7c239a375accfcddf6e6911 {"gasLimit":470298,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:24:17 [17:24:17.279] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:24:17 [17:24:17.280] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x443ea72e943423e335ef3c8642b0f716aee57500f7c239a375accfcddf6e6911","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1750786142,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:24:17 [17:24:17.280] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:24:17 [17:24:17.293] INFO: blob-sink:server Received blob sidecar for block 0x2ff861c466356cc50de7b24befeda3f6e6e72c85cc021fa3877d2b0d322a7e47 17:24:17 [17:24:17.297] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:17 [17:24:17.304] INFO: blob-sink:server Blob sidecar stored successfully for block 0x2ff861c466356cc50de7b24befeda3f6e6e72c85cc021fa3877d2b0d322a7e47 17:24:17 [17:24:17.325] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786178] on http://127.0.0.1:8545 17:24:17 [17:24:17.327] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:17 [17:24:17.330] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786178 17:24:17 [17:24:17.330] WARN: foundation:test-date-provider Time set to 2025-06-24T17:29:38.000Z {"offset":320670,"timeMs":1750786178000} 17:24:17 [17:24:17.331] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:24:17 [17:24:17.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:17 [17:24:17.778] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:17 [17:24:17.794] VERBOSE: archiver:block-helper Store contract instance at 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86 17:24:17 [17:24:17.817] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:24:17 [17:24:17.864] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x04da19ddeba396433ab5b58d42a86f1b57f09b2309a460583b5824a0d9f4ca3f","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":2,"slotNumber":3,"timestamp":1750786142,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","archiveNextLeafIndex":3} 17:24:17 [17:24:17.902] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.490746999999828,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750786142,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:24:17 [17:24:17.987] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:17 [17:24:17.991] VERBOSE: p2p Synched to latest block 2 17:24:18 [17:24:18.354] INFO: aztecjs:deploy_sent_tx Contract 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86 successfully deployed. 17:24:18 [17:24:18.355] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public 17:24:18 [17:24:18.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:18 [17:24:18.418] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public returns 0 for non existent value 17:24:18 [17:24:18.462] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private works as expected for no notes 17:24:18 [17:24:18.522] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private 17:24:18 [17:24:18.570] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","blockNumber":3,"slot":4} 17:24:18 [17:24:18.841] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:18 [17:24:18.905] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","header":{"contentCommitment":{"blobsHash":"0x00ca5d232ce5a26040a5e98c3830d44d44aabb814e2632eceaed97395b49c54b","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750786142,"version":1530628867},"lastArchive":"0x0517f5ca4b6be3d29a62cbda18f36a4ce3ff058e22d39af5af4189b543d8dcb3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c562002566419007ff4463a6d75a5d72c3fcaae15c171b3861f816ebacff042","nullifierTree":"0x04a3e0d8cc06c956e2e34d7176f88742cd9ea15d433e776775efb2637780d315","publicDataTree":"0x1844101123a7b05691a574261b4a40ccfcfc0bfe8abe64b771ae334e1b03917b"},"totalFees":139009277500,"totalManaUsed":418375}} 17:24:19 [17:24:19.068] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:19 [17:24:19.112] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:24:19 [17:24:19.114] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:19 [17:24:19.115] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:19 [17:24:19.229] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","blockNumber":3,"slot":4} 17:24:19 [17:24:19.273] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412"} 17:24:19 [17:24:19.282] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0257f7ff91f2a5a4ae99e0ee92e95401b08bcba85a5827e91f5bc15c1238463f 17:24:19 [17:24:19.293] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:24:19 [17:24:19.294] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:24:19 [17:24:19.300] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:24:19 [17:24:19.300] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:24:19 [17:24:19.303] VERBOSE: pxe:service Added note {"index":0,"contract":"0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x141d28d131dca982a4464aa7bbd14eb9c66f74f6011aacbf59f7f99cc370046a","nullifier":"0x02fe981f52a3f3f8723d9d032ddc637b0780181dcf92029f3d304af958a6680f"} 17:24:19 [17:24:19.305] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:24:19 [17:24:19.319] VERBOSE: simulator:client_execution_context:debug_log Setting 0x144c33b1191f0502edcca2b59bcf9b80731f2b80531c5de7caf6953b520bb412 as fee payer 17:24:19 [17:24:19.335] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:20 [17:24:20.050] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:20 [17:24:20.222] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86"} 17:24:20 [17:24:20.270] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:24:20 [17:24:20.271] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86"} 17:24:20 [17:24:20.282] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:20 [17:24:20.424] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","blockNumber":3,"slot":4} 17:24:20 [17:24:20.446] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86"} 17:24:20 [17:24:20.450] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:24:20 [17:24:20.595] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:20 [17:24:20.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:21 [17:24:21.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:21 [17:24:21.092] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","blockNumber":3,"slot":4} 17:24:22 [17:24:22.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:22 [17:24:22.138] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","blockNumber":3,"slot":4} 17:24:22 [17:24:22.441] INFO: pxe:service Proving completed in 3557.5709749999987ms {"timings":{"total":3557.5709749999987,"sync":31.20170899999721,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":564.026006,"oracles":{"debugLog":{"times":[1.9858240000030492,0.6056539999990491,0.5360019999970973,0.5109410000004573,0.35064799999963725,0.2275050000025658,0.26941599999918253,0.5261920000011742]},"fetchTaggedLogs":{"times":[165.68706200000088]},"loadCapsule":{"times":[0.3923990000002959,0.3163270000004559,0.6225930000000517,0.21874499999830732,0.33836800000062794,1.1533960000015213]},"getSharedSecret":{"times":[3.6332099999999627]},"aes128Decrypt":{"times":[0.3979990000007092,1.0602929999986372]},"getPublicKeysAndPartialAddress":{"times":[1.3581200000007811]},"getKeyValidationRequest":{"times":[1.4999129999996512]},"deliverNote":{"times":[2.8895340000017313]},"deleteCapsule":{"times":[0.32324700000026496]},"storeCapsule":{"times":[0.2901960000017425]},"getNotes":{"times":[1.313098999999056]},"getAuthWitness":{"times":[0.15183299999989686]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05577100000300561]},"callPrivateFunction":{"times":[1473.501355999997]}}},{"functionName":"private_kernel_init","time":80.61835200000132},{"functionName":"Token:mint_to_private","time":1291.5880639999996,"oracles":{"debugLog":{"times":[1.3428899999998976,0.4397399999979825]},"fetchTaggedLogs":{"times":[177.35179100000096]},"loadCapsule":{"times":[0.26874600000155624,0.2615659999974014,0.23245500000120956]},"getRandomField":{"times":[0.13472299999921233,0.17192399999839836,0.1783240000004298,0.05863200000021607,0.043010000001231674,0.03672100000039791,0.03218099999867263,0.03420999999798369,0.032300999999279156,0.03510100000130478,0.056950999998662155,0.03371999999944819]},"getIndexedTaggingSecretAsSender":{"times":[138.85959999999977]},"incrementAppTaggingSecretIndexAsSender":{"times":[163.2717100000009]},"notifyCreatedNullifier":{"times":[0.49053099999946426]},"storeInExecutionCache":{"times":[0.05968099999881815]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06808100000125705]}}},{"functionName":"private_kernel_inner","time":115.12072500000068},{"functionName":"private_kernel_reset","time":199.71560500000123},{"functionName":"private_kernel_tail","time":102.513676999999}],"unaccounted":1172.7868369999997}} 17:24:22 [17:24:22.475] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:22 [17:24:22.558] VERBOSE: p2p:tx_pool Adding tx 0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a to pool {"eventName":"tx-added-to-pool","txHash":"0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 17:24:22 [17:24:22.573] INFO: node Received tx 0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a {"txHash":"0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a"} 17:24:22 [17:24:22.574] INFO: pxe:service Sent transaction 0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a 17:24:22 [17:24:22.699] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:24:22 [17:24:22.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:22 [17:24:22.729] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-24T17:29:38.000Z","now":"2025-06-24T17:29:43.399Z"} 17:24:22 [17:24:22.849] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":66.95807000000059} 17:24:22 [17:24:22.902] VERBOSE: simulator:public-processor Processed tx 0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a with 1 public calls in 136.96671799999967ms {"txHash":"0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a","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":136.96671799999967} 17:24:22 [17:24:22.903] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1739870469999987s {"duration":0.1739870469999987,"rate":244242.3199469574,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 17:24:22 [17:24:22.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:23 [17:24:23.036] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 123940.4722909265 mana/s {"blockHash":"0x056d79b8ccd44f8337c11ead4acede1df87d6a52609e2203daffe8f208a11c2a","globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":3,"slotNumber":4,"timestamp":1750786178,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1417dc3488210b7d79d241d7d4dc645473be2968b30f49f44d6eae369e19c67a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":342.0755629999985,"publicProcessDuration":174.42833600000085,"rollupCircuitsDuration":309.3374589999985,"txCount":1,"blockNumber":3,"blockTimestamp":1750786178,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:24:23 [17:24:23.042] VERBOSE: sequencer Attesting committee is empty 17:24:23 [17:24:23.167] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:23 [17:24:23.406] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:23 [17:24:23.419] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x360c36673c989e8a3fb66671f6b1f00ee228c3532a5a4bd58d653abb4012cd32 17:24:23 [17:24:23.419] VERBOSE: sequencer-client Sent L1 transaction 0x360c36673c989e8a3fb66671f6b1f00ee228c3532a5a4bd58d653abb4012cd32 {"gasLimit":478938,"maxFeePerGas":"1.279583418","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:24:23 [17:24:23.450] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786214] on http://127.0.0.1:8545 17:24:23 [17:24:23.458] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:24:23 [17:24:23.459] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x360c36673c989e8a3fb66671f6b1f00ee228c3532a5a4bd58d653abb4012cd32","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750786178,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:24:23 [17:24:23.459] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:24:23 [17:24:23.466] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:24:23 [17:24:23.471] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786214 17:24:23 [17:24:23.472] WARN: foundation:test-date-provider Time set to 2025-06-24T17:30:14.000Z {"offset":350528,"timeMs":1750786214000} 17:24:23 [17:24:23.472] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:24:23 [17:24:23.474] INFO: blob-sink:server Received blob sidecar for block 0xb43e19a2a7322ee12d5f0cd920808c285a0d09e42fbe967cd033d982f3531082 17:24:23 [17:24:23.480] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb43e19a2a7322ee12d5f0cd920808c285a0d09e42fbe967cd033d982f3531082 17:24:23 [17:24:23.611] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:23 [17:24:23.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:23 [17:24:23.928] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x056d79b8ccd44f8337c11ead4acede1df87d6a52609e2203daffe8f208a11c2a","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":1530628867,"blockNumber":3,"slotNumber":4,"timestamp":1750786178,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0b625f755bd271c184327d23681b0ae87abdd524d5a2990c1556667592755c0d","archiveNextLeafIndex":4} 17:24:24 [17:24:24.032] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":9.735414999999193,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750786178,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:24:24 [17:24:24.048] VERBOSE: p2p Synched to latest block 3 17:24:24 [17:24:24.111] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:24 [17:24:24.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:24 [17:24:24.490] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0b625f755bd271c184327d23681b0ae87abdd524d5a2990c1556667592755c0d","blockNumber":4,"slot":5} 17:24:24 [17:24:24.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:24 [17:24:24.587] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0b625f755bd271c184327d23681b0ae87abdd524d5a2990c1556667592755c0d","header":{"contentCommitment":{"blobsHash":"0x002627dab83ef68d7b33274a0b340a02ed56798676bc622e835b129ade8cd3cf","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750786178,"version":1530628867},"lastArchive":"0x147fa72f1da529a398fb933e2bfc5cfa0f2ea817270fc90d0aa13894fffeea7b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21aa3bd70a87249c04762d6e97ea9fbde6f095addf7721ba259b412294d2a6fd","nullifierTree":"0x1a2f97dbde394b9feabf373b95969b52112cf80bf817cc5fcb586eb4b57f6fa7","publicDataTree":"0x058666a0b5faaa3dbb84168fcbc177eb4d19de67913c5912edaed421cbe06543"},"totalFees":24485900700,"totalManaUsed":73695}} 17:24:24 [17:24:24.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:24 [17:24:24.894] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86","selector":"0xc6cedc33"} 17:24:24 [17:24:24.909] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:24:24 [17:24:24.909] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86"} 17:24:25 [17:24:25.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:24:25 [17:24:25.091] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0b625f755bd271c184327d23681b0ae87abdd524d5a2990c1556667592755c0d","blockNumber":4,"slot":5} 17:24:25 [17:24:25.103] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86"} 17:24:25 [17:24:25.106] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2c127fd57ecbeaa7d7dcf2e6fb12b4e5591e790d272d0354c97831b433f1e35c 17:24:25 [17:24:25.119] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 17:24:25 [17:24:25.127] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 17:24:25 [17:24:25.132] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x2c1283ab15f85d4421cea901cc3b65f6a162429bd79af6cc87ab9882d0606a7f 17:24:25 [17:24:25.133] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86 for storage slot 0x075a6f73c14df74c29f9525a35efdf1ea7a6e8c8497619b10e2ef94da53d9dbe 17:24:25 [17:24:25.141] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:24:25 [17:24:25.141] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x2c1283ab15f85d4421cea901cc3b65f6a162429bd79af6cc87ab9882d0606a7f 17:24:25 [17:24:25.146] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86","slot":"0x075a6f73c14df74c29f9525a35efdf1ea7a6e8c8497619b10e2ef94da53d9dbe","noteHash":"0x10d9da3b2f7e66df7ca6fa287ca10f2e50bce290651cada62d5d7cd00bc0dcd1","nullifier":"0x2c7144a20da8050561cb3d7fe10a58d1574a969f32cf7678afdca18309c59a71"} 17:24:25 [17:24:25.148] VERBOSE: simulator Utility simulation for 0x0202af968d02b1960365a4daa51044b46f2e6ea46e6878df552b788c4e58af86.0xc6cedc33 completed 17:24:25 [17:24:25.152] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes markAsProven 17:24:25 [17:24:25.159] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:24:25 [17:24:25.161] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:24:25 [17:24:25.163] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 3. Pending tip: 3. 17:24:25 [17:24:25.169] INFO: node Stopping 17:24:25 [17:24:25.170] INFO: slasher Slasher client stopped. 17:24:25 [17:24:25.170] INFO: sequencer Stopped sequencer 17:24:25 [17:24:25.171] INFO: p2p P2P client stopped. 17:24:25 [17:24:25.173] INFO: world_state Stopped world state synchronizer 17:24:25 [17:24:25.173] INFO: archiver Stopped. 17:24:25 [17:24:25.174] INFO: node Stopped 17:24:25 [17:24:25.174] VERBOSE: e2e:e2e_cheat_codes Cleaning up ACVM state 17:24:25 [17:24:25.174] INFO: e2e:e2e_cheat_codes Cleaning up ACVM temp directory /tmp/1a8f4cc2 17:24:25 [17:24:25.175] VERBOSE: e2e:e2e_cheat_codes Cleaning up BB state 17:24:25 [17:24:25.178] INFO: blob-sink:server Stopping blob sink 17:24:25 [17:24:25.179] INFO: blob-sink:server Blob sink stopped 17:24:25 [17:24:25.179] VERBOSE: e2e:e2e_cheat_codes Cleaning up data directory at /tmp/958ec08cc4e80956 17:24:25 PASS src/e2e_cheat_codes.test.ts 17:24:25 e2e_cheat_codes 17:24:25 L1 cheatcodes 17:24:25 ✓ setNextBlockTimestamp by 100 (114 ms) 17:24:25 ✓ setNextBlockTimestamp by 42 (106 ms) 17:24:25 ✓ setNextBlockTimestamp by 99 (114 ms) 17:24:25 ✓ setNextBlockTimestamp to a past timestamp throws (110 ms) 17:24:25 ✓ load a value at a particular storage slot (112 ms) 17:24:25 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (99 ms) 17:24:25 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (107 ms) 17:24:25 ✓ set bytecode correctly (101 ms) 17:24:25 ✓ impersonate (113 ms) 17:24:25 mine 17:24:25 ✓ mine block (317 ms) 17:24:25 ✓ mine 10 blocks (139 ms) 17:24:25 ✓ mine 42 blocks (141 ms) 17:24:25 ✓ mine 99 blocks (108 ms) 17:24:25 L2 cheatcodes 17:24:25 ✓ load public (57 ms) 17:24:25 ✓ load public returns 0 for non existent value (44 ms) 17:24:25 ✓ load private works as expected for no notes (59 ms) 17:24:25 ✓ load private (6630 ms) 17:24:25 ✓ markAsProven (14 ms) 17:24:25 17:24:25 Test Suites: 1 passed, 1 total 17:24:25 Tests: 18 passed, 18 total 17:24:25 Snapshots: 0 total 17:24:25 Time: 30.335 s 17:24:25 Ran all test suites matching /src\/e2e_cheat_codes.test.ts/i. 17:24:25 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?