Parent Log: http://ci.aztec-labs.com/8e8dd02b40b54e5e 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/cf4d4501e7edfb97cb6406ee7f30893939a522f9 Env: REF_NAME=gh-readonly-queue/master/pr-14912-015cb0cadef6a41094c3649f32a735392e1b9693 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Wed Jun 18 15:32:58 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14912_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_39ce75ad687a474b_master 15:32:58 +++ id -u 15:32:58 +++ id -g 15:32:58 ++ 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'\''' 15:32:58 + cid=19a4aa9e697555863941c810ec9dfdd2c66ca86da3e86c619b1231d378d8928a 15:32:58 + set +x 15:32:59 {"level":25,"time":1750260779265,"pid":12,"hostname":"19a4aa9e6975","module":"logger","msg":"Logger initialized with level verbose"} 15:33:05 [15:33:05.108] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine block 15:33:05 [15:33:05.369] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.392] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:05 [15:33:05.397] WARN: ethereum:cheat_codes Mined 1 L1 blocks 15:33:05 [15:33:05.398] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.411] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 10 blocks 15:33:05 [15:33:05.527] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.532] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [10] on http://127.0.0.1:8545 15:33:05 [15:33:05.536] WARN: ethereum:cheat_codes Mined 10 L1 blocks 15:33:05 [15:33:05.537] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.543] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 42 blocks 15:33:05 [15:33:05.652] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.656] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [42] on http://127.0.0.1:8545 15:33:05 [15:33:05.660] WARN: ethereum:cheat_codes Mined 42 L1 blocks 15:33:05 [15:33:05.660] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.667] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 99 blocks 15:33:05 [15:33:05.764] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.768] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [99] on http://127.0.0.1:8545 15:33:05 [15:33:05.774] WARN: ethereum:cheat_codes Mined 99 L1 blocks 15:33:05 [15:33:05.774] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.780] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 100 15:33:05 [15:33:05.882] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.895] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:05 [15:33:05.900] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260885] on http://127.0.0.1:8545 15:33:05 [15:33:05.902] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750260885 15:33:05 [15:33:05.903] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:05 [15:33:05.905] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:05 [15:33:05.906] WARN: ethereum:cheat_codes Mined 1 L1 blocks 15:33:05 [15:33:05.907] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:05 [15:33:05.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:05 [15:33:05.915] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 42 15:33:06 [15:33:06.016] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:06 [15:33:06.020] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.022] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260827] on http://127.0.0.1:8545 15:33:06 [15:33:06.024] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750260827 15:33:06 [15:33:06.025] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.026] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:06 [15:33:06.028] WARN: ethereum:cheat_codes Mined 1 L1 blocks 15:33:06 [15:33:06.028] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:06 [15:33:06.030] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.035] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 99 15:33:06 [15:33:06.134] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:06 [15:33:06.142] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.146] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260885] on http://127.0.0.1:8545 15:33:06 [15:33:06.149] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750260885 15:33:06 [15:33:06.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.152] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:06 [15:33:06.153] WARN: ethereum:cheat_codes Mined 1 L1 blocks 15:33:06 [15:33:06.154] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 15:33:06 [15:33:06.156] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.161] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp to a past timestamp throws 15:33:06 [15:33:06.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:06 [15:33:06.277] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750259786] on http://127.0.0.1:8545 15:33:06 [15:33:06.296] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes load a value at a particular storage slot 15:33:06 [15:33:06.409] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0x0000000000000000000000000000000000000000","0x00","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.421] 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) 15:33:06 [15:33:06.511] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 15:33:06 [15:33:06.514] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 1 to 5 15:33:06 [15:33:06.514] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.518] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 15:33:06 [15:33:06.520] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 78541660797044910968829902406342334108369226379826116161446442989268089806461 to 5 15:33:06 [15:33:06.521] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.526] 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) 15:33:06 [15:33:06.619] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 15:33:06 [15:33:06.628] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 85149632668394328379478047665368132835280330034293399760893490333839055043265 to 5 15:33:06 [15:33:06.628] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.631] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 15:33:06 [15:33:06.633] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 58076768977499219212177354345858258922703203414073725940090140522697466344574 to 5 15:33:06 [15:33:06.634] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.639] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes set bytecode correctly 15:33:06 [15:33:06.744] INFO: ethereum:cheat_codes Calling hardhat_setCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","0x1234"] on http://127.0.0.1:8545 15:33:06 [15:33:06.747] WARN: ethereum:cheat_codes Set bytecode for 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 to 0x1234 15:33:06 [15:33:06.748] INFO: ethereum:cheat_codes Calling eth_getCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","latest"] on http://127.0.0.1:8545 15:33:06 [15:33:06.752] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes impersonate 15:33:06 [15:33:06.877] INFO: ethereum:cheat_codes Calling hardhat_impersonateAccount with params: ["0x98406a678dc5ac09d9208144b85068a3877d36c9"] on http://127.0.0.1:8545 15:33:06 [15:33:06.879] WARN: ethereum:cheat_codes Impersonating 0x98406a678dc5ac09d9208144b85068a3877d36c9 15:33:06 [15:33:06.893] INFO: ethereum:cheat_codes Calling hardhat_stopImpersonatingAccount with params: ["0x98406a678dc5ac09d9208144b85068a3877d36c9"] on http://127.0.0.1:8545 15:33:06 [15:33:06.895] WARN: ethereum:cheat_codes Stopped impersonating 0x98406a678dc5ac09d9208144b85068a3877d36c9 15:33:06 [15:33:06.967] INFO: e2e:e2e_cheat_codes Logging metrics to log/e2e_cheat_codes.jsonl 15:33:07 [15:33:07.109] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-d3cn6l/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:33:07 [15:33:07.142] INFO: e2e:e2e_cheat_codes Calling anvil_setBlockTimestampInterval with params: [12] 15:33:07 [15:33:07.148] WARN: e2e:e2e_cheat_codes Set block interval to 12 15:33:07 [15:33:07.148] VERBOSE: e2e:e2e_cheat_codes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:33:07 [15:33:07.174] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:33:07 [15:33:07.187] VERBOSE: e2e:e2e_cheat_codes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:33:07 [15:33:07.211] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:33:07 [15:33:07.216] VERBOSE: e2e:e2e_cheat_codes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:33:07 [15:33:07.236] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:33:07 [15:33:07.241] VERBOSE: e2e:e2e_cheat_codes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:33:07 [15:33:07.255] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:33:07 [15:33:07.265] VERBOSE: e2e:e2e_cheat_codes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:33:07 [15:33:07.287] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 15:33:07 [15:33:07.297] VERBOSE: e2e:e2e_cheat_codes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:33:07 [15:33:07.317] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 15:33:07 [15:33:07.323] VERBOSE: e2e:e2e_cheat_codes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:33:07 [15:33:07.324] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 15:33:07 [15:33:07.324] INFO: e2e:e2e_cheat_codes Waiting for 6 transactions to be mined... 15:33:07 [15:33:07.343] INFO: e2e:e2e_cheat_codes All transactions mined successfully 15:33:07 [15:33:07.363] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 15:33:07 [15:33:07.363] VERBOSE: e2e:e2e_cheat_codes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 15:33:07 [15:33:07.378] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 15:33:07 [15:33:07.406] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 15:33:07 [15:33:07.412] VERBOSE: e2e:e2e_cheat_codes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:33:07 [15:33:07.422] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 15:33:07 [15:33:07.423] VERBOSE: e2e:e2e_cheat_codes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 15:33:07 [15:33:07.447] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 15:33:07 [15:33:07.452] VERBOSE: e2e:e2e_cheat_codes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:33:07 [15:33:07.466] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 15:33:07 [15:33:07.466] VERBOSE: e2e:e2e_cheat_codes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 15:33:07 [15:33:07.466] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 15:33:07 [15:33:07.466] INFO: e2e:e2e_cheat_codes Waiting for 8 transactions to be mined... 15:33:07 [15:33:07.486] INFO: e2e:e2e_cheat_codes All transactions mined successfully 15:33:07 [15:33:07.506] VERBOSE: e2e:e2e_cheat_codes Deployed shared contracts 15:33:07 [15:33:07.534] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 15:33:07 [15:33:07.535] VERBOSE: e2e:e2e_cheat_codes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 15:33:07 [15:33:07.542] 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} 15:33:07 [15:33:07.557] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 15:33:07 [15:33:07.592] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 15:33:07 [15:33:07.601] VERBOSE: e2e:e2e_cheat_codes Awaiting for linked libraries to be deployed 15:33:07 [15:33:07.658] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2f960b5cbc0618d588e5ac02a925bd85b5b0c469a2dc035813d9190433acb11f {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 15:33:07 [15:33:07.668] 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} 15:33:07 [15:33:07.669] INFO: e2e:e2e_cheat_codes Waiting for 9 transactions to be mined... 15:33:07 [15:33:07.688] INFO: e2e:e2e_cheat_codes All transactions mined successfully 15:33:07 [15:33:07.688] VERBOSE: e2e:e2e_cheat_codes All core contracts have been deployed 15:33:07 [15:33:07.704] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 15:33:07 [15:33:07.705] VERBOSE: e2e:e2e_cheat_codes Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 15:33:07 [15:33:07.732] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 15:33:07 [15:33:07.738] VERBOSE: e2e:e2e_cheat_codes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:33:07 [15:33:07.792] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 15:33:07 [15:33:07.793] VERBOSE: e2e:e2e_cheat_codes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 15:33:07 [15:33:07.793] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 15:33:07 [15:33:07.821] INFO: e2e:e2e_cheat_codes All transactions mined successfully 15:33:07 [15:33:07.832] VERBOSE: e2e:e2e_cheat_codes Rollup deployed 15:33:07 [15:33:07.833] VERBOSE: e2e:e2e_cheat_codes Waiting for rollup and slash factory to be deployed 15:33:07 [15:33:07.833] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 15:33:07 [15:33:07.855] INFO: e2e:e2e_cheat_codes All transactions mined successfully 15:33:07 [15:33:07.856] VERBOSE: e2e:e2e_cheat_codes All transactions for L1 deployment have been mined 15:33:07 [15:33:07.893] 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"} 15:33:07 [15:33:07.898] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:33:07 [15:33:07.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:07 [15:33:07.902] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 15:33:07 [15:33:07.903] INFO: telemetry:client Using NoopTelemetryClient 15:33:07 [15:33:07.911] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 15:33:07 [15:33:07.911] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 15:33:07 [15:33:07.912] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/091071e79f40254c/blob-sink with map size 134217728 KB (LMDB v2) 15:33:07 [15:33:07.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:07 [15:33:07.917] INFO: aztecjs:utils:watcher New L1 time: 1750261026 15:33:07 [15:33:07.917] WARN: foundation:test-date-provider Time set to 2025-06-18T15:37:06.000Z {"offset":238083,"timeMs":1750261026000} 15:33:07 [15:33:07.920] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:33:07 [15:33:07.929] INFO: blob-sink:server Server is running on http://localhost:44133 15:33:07 [15:33:07.929] VERBOSE: e2e:e2e_cheat_codes Creating and synching an aztec node... 15:33:07 [15:33:07.930] VERBOSE: e2e:e2e_cheat_codes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/5570f5c1/acvm 15:33:07 [15:33:07.931] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:44133"} 15:33:07 [15:33:07.954] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:33:07 [15:33:07.955] INFO: archiver:lmdb Creating archiver data store at directory /tmp/091071e79f40254c/archiver with map size 134217728 KB (LMDB v2) 15:33:07 [15:33:07.957] INFO: archiver:lmdb Starting data store with maxReaders 16 15:33:08 [15:33:08.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:08 [15:33:08.315] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:44133"} 15:33:08 [15:33:08.335] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:44133"} 15:33:08 [15:33:08.336] WARN: node:blob-sink:client No L1 consensus host urls configured 15:33:08 [15:33:08.336] WARN: node:blob-sink:client No archive client configured 15:33:08 [15:33:08.340] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x64f52d7788ab4a7db40179c3cb67e873432781905728d475518db6d9b1956c7c {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x8698c96dd87324a14fa2e82ddf54a0cece6353ec1e256d95a50f44616bf5ed25","l1BlockNumber":16}} 15:33:08 [15:33:08.357] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:33:08 [15:33:08.368] INFO: world-state:database Creating world state data store at directory /tmp/091071e79f40254c/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:33:08 [15:33:08.400] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:08 [15:33:08.406] INFO: world_state Created world state synchroniser with block history of 64 15:33:08 [15:33:08.407] WARN: node Aztec node is accepting fake proofs 15:33:08 [15:33:08.424] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/091071e79f40254c/p2p with map size 134217728 KB (LMDB v2) 15:33:08 [15:33:08.435] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:33:08 [15:33:08.436] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/091071e79f40254c/p2p-archive with map size 134217728 KB (LMDB v2) 15:33:08 [15:33:08.438] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:33:08 [15:33:08.439] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/091071e79f40254c/p2p-peers with map size 134217728 KB (LMDB v2) 15:33:08 [15:33:08.441] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:33:08 [15:33:08.442] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:33:08 [15:33:08.443] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:33:08 [15:33:08.447] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:33:08 [15:33:08.448] INFO: world_state Started world state synchronizer from block 1 15:33:08 [15:33:08.450] VERBOSE: world-state:block_stream Starting sync from block number 0 15:33:08 [15:33:08.452] INFO: p2p Starting p2p client from block 0 with empty mempools 15:33:08 [15:33:08.452] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:33:08 [15:33:08.453] INFO: slasher Slasher client initialized 15:33:08 [15:33:08.453] INFO: slasher Starting Slasher client... 15:33:08 [15:33:08.507] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:08 [15:33:08.508] VERBOSE: node All Aztec Node subsystems synced 15:33:08 [15:33:08.518] INFO: sequencer-client Deploying forwarder contract 15:33:08 [15:33:08.522] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:33:08 [15:33:08.539] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 15:33:08 [15:33:08.540] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 15:33:08 [15:33:08.545] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:33:08 [15:33:08.562] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:08 [15:33:08.563] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 15:33:08 [15:33:08.563] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/5570f5c1/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:33:08 [15:33:08.855] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:33:08 [15:33:08.860] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:08 [15:33:08.863] INFO: node Aztec Node version: 0.87.9 15:33:08 [15:33:08.864] 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"} 15:33:08 [15:33:08.866] VERBOSE: e2e:e2e_cheat_codes Creating a pxe... 15:33:08 [15:33:08.877] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:08 [15:33:08.903] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/4261690786bfef82/pxe_data with map size 134217728 KB (LMDB v2) 15:33:08 [15:33:08.934] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:08 [15:33:08.937] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:33:09 [15:33:09.123] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:09 [15:33:09.199] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:33:09 [15:33:09.200] INFO: pxe:service Started PXE connected to chain 31337 version 3727408360 15:33:09 [15:33:09.259] INFO: pxe:service Registered account 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc 15:33:09 [15:33:09.322] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 15:33:09 [15:33:09.323] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc 15:33:09 [15:33:09.346] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:09 [15:33:09.450] INFO: pxe:service Added contract SchnorrAccount at 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:33:09 [15:33:09.461] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:09 [15:33:09.495] VERBOSE: pxe:block_stream Starting sync from block number 0 15:33:09 [15:33:09.528] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:33:09 [15:33:09.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:09 [15:33:09.625] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:10 [15:33:10.408] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:33:10 [15:33:10.525] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:33:10 [15:33:10.615] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:10 [15:33:10.640] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:10 [15:33:10.734] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:10 [15:33:10.796] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:10 [15:33:10.797] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:10 [15:33:10.835] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:10 [15:33:10.882] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:10 [15:33:10.891] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:11 [15:33:11.054] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:11 [15:33:11.128] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:11 [15:33:11.186] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:11 [15:33:11.187] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:11 [15:33:11.263] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:11 [15:33:11.279] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:11 [15:33:11.293] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:11 [15:33:11.319] VERBOSE: simulator:client_execution_context:debug_log Setting 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc as fee payer 15:33:11 [15:33:11.407] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:11 [15:33:11.611] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:11 [15:33:11.867] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:12 [15:33:12.013] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:12 [15:33:12.194] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:12 [15:33:12.748] INFO: pxe:service Proving completed in 3263.867683999999ms {"timings":{"total":3263.867683999999,"sync":11.43412200000057,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":176.5504949999995,"oracles":{"callPrivateFunction":{"times":[1039.220684,406.9210329999987,327.5053629999984]}}},{"functionName":"private_kernel_init","time":141.7292039999993},{"functionName":"ContractClassRegisterer:register","time":1021.6207759999998,"oracles":{"loadCapsule":{"times":[14.939452000000529]},"notifyCreatedNullifier":{"times":[33.56556199999977]},"debugLog":{"times":[2.8290170000000217]},"notifyCreatedContractClassLog":{"times":[10.21398600000066]}}},{"functionName":"private_kernel_inner","time":193.9784899999995},{"functionName":"SchnorrAccount:constructor","time":375.67566499999884,"oracles":{"getContractInstance":{"times":[3.7141110000011395]},"debugLog":{"times":[0.5969769999992423,0.6762029999990773]},"fetchTaggedLogs":{"times":[92.64973500000087]},"loadCapsule":{"times":[0.5689459999994142,0.38812399999915215,0.5056110000004992]},"notifyCreatedNullifier":{"times":[0.3679730000003474,0.3359810000001744]},"notifyCreatedNote":{"times":[0.7130849999994098]},"getRandomField":{"times":[0.6413200000006327,0.2910379999993893,0.1573789999984001,0.13135800000054587,0.10527600000023085,0.4044450000001234,0.12833799999862094,0.09775600000102713,0.0604139999995823,0.11187700000118639,0.06834399999934249]},"getIndexedTaggingSecretAsSender":{"times":[52.03872299999966]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.17589500000031]}}},{"functionName":"private_kernel_inner","time":167.6122379999997},{"functionName":"SchnorrAccount:entrypoint","time":269.79197600000043,"oracles":{"debugLog":{"times":[1.2730300000002899,0.8882049999992887,1.140041000000565]},"fetchTaggedLogs":{"times":[103.42978599999878]},"loadCapsule":{"times":[0.46126900000126625,0.39203400000042166,0.5276519999988523]},"getNotes":{"times":[3.986957999999504]},"getAuthWitness":{"times":[0.8275210000010702]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.5856880000010278]}}},{"functionName":"private_kernel_inner","time":144.76960300000064},{"functionName":"private_kernel_reset","time":212.9651240000003},{"functionName":"private_kernel_tail","time":78.30226100000073}],"unaccounted":469.43772999999965}} 15:33:12 [15:33:12.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:12 [15:33:12.852] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","blockNumber":1,"slot":2} 15:33:12 [15:33:12.913] VERBOSE: p2p:tx_pool Adding tx 0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049 to pool {"eventName":"tx-added-to-pool","txHash":"0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:33:12 [15:33:12.930] INFO: node Received tx 0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049 {"txHash":"0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049"} 15:33:12 [15:33:12.931] INFO: pxe:service Sent transaction 0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049 15:33:12 [15:33:12.973] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:13 [15:33:13.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:13 [15:33:13.367] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 15:33:13 [15:33:13.380] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T15:37:30.000Z","now":"2025-06-18T15:37:11.463Z"} 15:33:13 [15:33:13.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:13 [15:33:13.602] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:13 [15:33:13.683] VERBOSE: simulator:public-processor Processed tx 0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049 with no public calls in 202.61491900000146ms {"txHash":"0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049","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":202.61491900000146} 15:33:13 [15:33:13.687] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3054541980000013s {"duration":0.3054541980000013,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 15:33:13 [15:33:13.883] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1a29efd319de3d9216e1c0429a12ffc64a5e8c0197175098ff5e6130ec4ac23a","globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":1,"slotNumber":2,"timestamp":1750261050,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x226b0e2815f4adcbb512ec621d08fa2c235fca0a9eb859e29e1b77b259851049"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":515.5732650000009,"publicProcessDuration":306.8554159999985,"rollupCircuitsDuration":503.73797699999886,"txCount":1,"blockNumber":1,"blockTimestamp":1750261050,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:13 [15:33:13.887] VERBOSE: sequencer Attesting committee is empty 15:33:13 [15:33:13.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:14 [15:33:14.290] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:14 [15:33:14.304] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x07a480e4b57d9b2a79036762e583cd90a8e5f9d1e5dc37b234f8782530e61729 15:33:14 [15:33:14.304] VERBOSE: sequencer-client Sent L1 transaction 0x07a480e4b57d9b2a79036762e583cd90a8e5f9d1e5dc37b234f8782530e61729 {"gasLimit":514521,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 15:33:14 [15:33:14.319] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:33:14 [15:33:14.320] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x07a480e4b57d9b2a79036762e583cd90a8e5f9d1e5dc37b234f8782530e61729","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1750261050,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:14 [15:33:14.321] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:33:14 [15:33:14.345] INFO: blob-sink:server Received blob sidecar for block 0xf9b5aca83c8fd31a0455b2aa2161eec8265586b6f138bbed4c6e09eed930f9c4 15:33:14 [15:33:14.356] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf9b5aca83c8fd31a0455b2aa2161eec8265586b6f138bbed4c6e09eed930f9c4 15:33:14 [15:33:14.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:14 [15:33:14.580] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:33:14 [15:33:14.588] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:33:14 [15:33:14.591] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:33:14 [15:33:14.599] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1a29efd319de3d9216e1c0429a12ffc64a5e8c0197175098ff5e6130ec4ac23a","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":1,"slotNumber":2,"timestamp":1750261050,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","archiveNextLeafIndex":2} 15:33:14 [15:33:14.602] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:33:14 [15:33:14.606] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261086] on http://127.0.0.1:8545 15:33:14 [15:33:14.609] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:14 [15:33:14.613] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261086 15:33:14 [15:33:14.613] WARN: foundation:test-date-provider Time set to 2025-06-18T15:38:06.000Z {"offset":291387,"timeMs":1750261086000} 15:33:14 [15:33:14.613] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:33:15 [15:33:15.126] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:15 [15:33:15.133] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":443.03732500000115,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750261050,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:15 [15:33:15.134] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 15:33:15 [15:33:15.142] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a 15:33:15 [15:33:15.385] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:15 [15:33:15.419] VERBOSE: p2p Synched to latest block 1 15:33:15 [15:33:15.517] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:33:15 [15:33:15.911] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:15 [15:33:15.939] INFO: pxe:service Added contract Token at 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 15:33:15 [15:33:15.972] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","blockNumber":2,"slot":3} 15:33:15 [15:33:15.986] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","header":{"contentCommitment":{"blobsHash":"0x000fccfa495033e24f0b6be3efaa58b812af47947193151e21b9dc90ae357820","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750261050,"version":3727408360},"lastArchive":"0x0306198b065185b555b8d0ee4bc800bbf02ff22cd2423d0ab86b6124a81bd25b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0db89a4f3bb9a3712e58ce6f99a70ef6fab1968d8acc5d0b7467061773d50ccb","nullifierTree":"0x10db7d4f2c42f768c30210448fd49b959adc4e2b853dae08c605041fdc3db517","publicDataTree":"0x06f7414418533eec5080f09e71d6fe3d39db6223f152af66017b42c46a70c5b3"},"totalFees":6794052480,"totalManaUsed":20448}} 15:33:16 [15:33:16.160] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:16 [15:33:16.219] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:16 [15:33:16.221] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:16 [15:33:16.232] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:16 [15:33:16.326] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:16 [15:33:16.332] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1af97c56dd769eb20500fd873e817f211e808b655774cd381cd64111b0640db0 15:33:16 [15:33:16.349] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:33:16 [15:33:16.351] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:33:16 [15:33:16.371] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:33:16 [15:33:16.375] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:33:16 [15:33:16.382] VERBOSE: pxe:service Added note {"index":0,"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c2159beba57416f999a10b704c60a5254040f5721401fdbeedc23ddbbfe860e","nullifier":"0x097faade8e6a11fdf8cb90049682fd46c16fe27c9d260cfff25db34bedc9597a"} 15:33:16 [15:33:16.392] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:16 [15:33:16.415] VERBOSE: simulator:client_execution_context:debug_log Setting 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc as fee payer 15:33:16 [15:33:16.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:16 [15:33:16.545] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:17 [15:33:17.305] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 15:33:17 [15:33:17.513] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:33:17 [15:33:17.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:17 [15:33:17.680] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","blockNumber":2,"slot":3} 15:33:17 [15:33:17.738] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:33:17 [15:33:17.785] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:17 [15:33:17.799] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a,0x0000000000000000000000000000000000000000000000000000000000000001,0x04baee9c39b8104054eeb63164af4268ee08944942eaf523c8bfa7cc1fd36940,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x0a0681372ad4a47121d0cac10282dccbaae6e073f240b32b3c188e641a1117db,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc 15:33:17 [15:33:17.854] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:18 [15:33:18.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:18 [15:33:18.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:18 [15:33:18.528] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","blockNumber":2,"slot":3} 15:33:18 [15:33:18.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:19 [15:33:19.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:19 [15:33:19.518] INFO: pxe:service Proving completed in 3547.3813950000003ms {"timings":{"total":3547.3813950000003,"sync":18.65497300000061,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":410.1763660000033,"oracles":{"debugLog":{"times":[1.725467000000208,0.7744680000032531,0.7816689999999653,0.906607000000804,3.4196830000000773,0.592966999996861,0.7812980000016978,0.9569599999995262]},"fetchTaggedLogs":{"times":[108.02995299999748]},"loadCapsule":{"times":[0.35134199999811244,0.5568840000014461,0.6769920000006096,0.42479699999967124,6.234969000001001,0.7681379999994533]},"getSharedSecret":{"times":[6.835805999999138]},"aes128Decrypt":{"times":[1.7431279999982507,0.9853110000003653]},"getPublicKeysAndPartialAddress":{"times":[6.273601000000781]},"getKeyValidationRequest":{"times":[9.594017999999778]},"deliverNote":{"times":[7.590192999999999]},"deleteCapsule":{"times":[0.7207850000013423]},"storeCapsule":{"times":[0.5318929999993998]},"getNotes":{"times":[3.7418739999993704]},"getAuthWitness":{"times":[0.2912580000011076]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1344390000012936]},"callPrivateFunction":{"times":[1163.9650279999987,227.91624600000068]},"notifyEnqueuedPublicFunctionCall":{"times":[0.5263430000013614]}}},{"functionName":"private_kernel_init","time":113.35777600000074},{"functionName":"ContractClassRegisterer:register","time":1137.378761,"oracles":{"loadCapsule":{"times":[8.442665999999008]},"notifyCreatedNullifier":{"times":[0.5730660000008356]},"debugLog":{"times":[0.9260380000014266]},"notifyCreatedContractClassLog":{"times":[19.88666000000012]}}},{"functionName":"private_kernel_inner","time":221.4071699999986},{"functionName":"ContractInstanceDeployer:deploy","time":157.74458099999902,"oracles":{"storeInExecutionCache":{"times":[0.4046249999992142]},"callPrivateFunction":{"times":[47.673251000000164]},"notifyCreatedNullifier":{"times":[0.3750430000000051]},"debugLog":{"times":[0.7600170000005164]}}},{"functionName":"private_kernel_inner","time":185.3107600000003},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.19672499999797,"oracles":{}},{"functionName":"private_kernel_inner","time":176.07635500000106},{"functionName":"private_kernel_reset","time":294.6558550000009},{"functionName":"private_kernel_tail","time":126.57469900000069}],"unaccounted":670.8473739999972}} 15:33:19 [15:33:19.558] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:19 [15:33:19.908] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:19 [15:33:19.923] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","blockNumber":2,"slot":3} 15:33:19 [15:33:19.958] VERBOSE: p2p:tx_pool Adding tx 0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466 to pool {"eventName":"tx-added-to-pool","txHash":"0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 15:33:20 [15:33:19.995] INFO: node Received tx 0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466 {"txHash":"0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466"} 15:33:20 [15:33:20.000] INFO: pxe:service Sent transaction 0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466 15:33:20 [15:33:20.123] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:20 [15:33:20.334] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:20 [15:33:20.515] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 15:33:20 [15:33:20.543] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:20 [15:33:20.592] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T15:38:06.000Z","now":"2025-06-18T15:38:11.979Z"} 15:33:20 [15:33:20.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:21 [15:33:21.102] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:21 [15:33:21.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:21 [15:33:21.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:21 [15:33:21.778] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":680.5247030000028} 15:33:22 [15:33:22.001] VERBOSE: simulator:public-processor Processed tx 0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466 with 1 public calls in 1122.8239490000014ms {"txHash":"0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466","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":1122.8239490000014} 15:33:22 [15:33:22.017] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:22 [15:33:22.020] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.4262777889999998s {"duration":1.4262777889999998,"rate":267711.5236210133,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 15:33:22 [15:33:22.226] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:22 [15:33:22.440] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 198198.27088716335 mana/s {"blockHash":"0x1db9e218c5d70e247e019964d86dc1e76fc052d5d3b8069ad6ee3ee4ba32f4ab","globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":2,"slotNumber":3,"timestamp":1750261086,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x22834686d676c30fafc9f5103e0e950898ed21f122f800e21689abe748315466"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1925.8805189999985,"publicProcessDuration":1426.9543909999993,"rollupCircuitsDuration":1864.3249720000022,"txCount":1,"blockNumber":2,"blockTimestamp":1750261086,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:33:22 [15:33:22.445] VERBOSE: sequencer Attesting committee is empty 15:33:22 [15:33:22.590] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:22 [15:33:22.889] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:22 [15:33:22.898] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xed1cf71855131349311ca836747b0621f3e47c7d140af78a284f5e4684b5c18f 15:33:22 [15:33:22.898] VERBOSE: sequencer-client Sent L1 transaction 0xed1cf71855131349311ca836747b0621f3e47c7d140af78a284f5e4684b5c18f {"gasLimit":470265,"maxFeePerGas":"1.303611175","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:33:22 [15:33:22.935] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261122] on http://127.0.0.1:8545 15:33:22 [15:33:22.938] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:33:22 [15:33:22.938] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xed1cf71855131349311ca836747b0621f3e47c7d140af78a284f5e4684b5c18f","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1750261086,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:33:22 [15:33:22.939] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:33:22 [15:33:22.943] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:22 [15:33:22.947] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261122 15:33:22 [15:33:22.948] WARN: foundation:test-date-provider Time set to 2025-06-18T15:38:42.000Z {"offset":319052,"timeMs":1750261122000} 15:33:22 [15:33:22.948] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:33:22 [15:33:22.951] INFO: blob-sink:server Received blob sidecar for block 0x554587c3524229ebf413476e7d549e90443b3bafb950a0973d8235241f8fad6a 15:33:22 [15:33:22.959] INFO: blob-sink:server Blob sidecar stored successfully for block 0x554587c3524229ebf413476e7d549e90443b3bafb950a0973d8235241f8fad6a 15:33:23 [15:33:23.100] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:23 [15:33:23.347] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:23 [15:33:23.373] VERBOSE: archiver:block-helper Store contract instance at 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a 15:33:23 [15:33:23.411] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 15:33:23 [15:33:23.505] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1db9e218c5d70e247e019964d86dc1e76fc052d5d3b8069ad6ee3ee4ba32f4ab","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":2,"slotNumber":3,"timestamp":1750261086,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","archiveNextLeafIndex":3} 15:33:23 [15:33:23.575] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:23 [15:33:23.664] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":23.79622300000119,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750261086,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:33:23 [15:33:23.708] VERBOSE: p2p Synched to latest block 2 15:33:23 [15:33:23.791] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:23 [15:33:23.996] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:24 [15:33:24.146] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:24 [15:33:24.202] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:24 [15:33:24.657] INFO: aztecjs:deploy_sent_tx Contract 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a successfully deployed. 15:33:24 [15:33:24.660] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public 15:33:24 [15:33:24.663] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:24 [15:33:24.700] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public returns 0 for non existent value 15:33:24 [15:33:24.716] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private works as expected for no notes 15:33:24 [15:33:24.735] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private 15:33:24 [15:33:24.759] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:25 [15:33:25.176] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:25 [15:33:25.247] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","header":{"contentCommitment":{"blobsHash":"0x009a6f66a62b185215463386aca2f673618d8689a96bd0dd02c53c0916be2b75","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750261086,"version":3727408360},"lastArchive":"0x06b4923c4475ad0f304e5b06d5e4a3ea4144bca8ffdd21c173e87bfcb92e2a61","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0db89a4f3bb9a3712e58ce6f99a70ef6fab1968d8acc5d0b7467061773d50ccb","nullifierTree":"0x0b1175a3d88216a9435058fff253a6b378ddb76760373047d084b319e4f7fd98","publicDataTree":"0x304029c9c278fcdb06ca1a1560337f3c72ffedf930b5189f943321061eac39eb"},"totalFees":139009277500,"totalManaUsed":418375}} 15:33:25 [15:33:25.399] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:25 [15:33:25.445] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:25 [15:33:25.514] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:25 [15:33:25.515] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:25 [15:33:25.583] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:25 [15:33:25.641] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc"} 15:33:25 [15:33:25.654] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1af97c56dd769eb20500fd873e817f211e808b655774cd381cd64111b0640db0 15:33:25 [15:33:25.672] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:33:25 [15:33:25.673] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:33:25 [15:33:25.693] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:33:25 [15:33:25.693] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:33:25 [15:33:25.708] VERBOSE: pxe:service Added note {"index":0,"contract":"0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c2159beba57416f999a10b704c60a5254040f5721401fdbeedc23ddbbfe860e","nullifier":"0x097faade8e6a11fdf8cb90049682fd46c16fe27c9d260cfff25db34bedc9597a"} 15:33:25 [15:33:25.716] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:25 [15:33:25.743] VERBOSE: simulator:client_execution_context:debug_log Setting 0x22b80a8b37691c6db7641cdf89eadc8a6890b78772dfa662225ab9f4427452dc as fee payer 15:33:25 [15:33:25.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:26 [15:33:26.247] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:26 [15:33:26.475] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:26 [15:33:26.701] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a"} 15:33:26 [15:33:26.747] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:26 [15:33:26.748] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a"} 15:33:26 [15:33:26.917] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:26 [15:33:26.950] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:26 [15:33:26.963] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a"} 15:33:26 [15:33:26.975] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:27 [15:33:27.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:27 [15:33:27.397] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:27 [15:33:27.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:28 [15:33:28.046] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:28 [15:33:28.252] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:29 [15:33:29.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:29 [15:33:29.267] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","blockNumber":3,"slot":4} 15:33:29 [15:33:29.625] INFO: pxe:service Proving completed in 4396.8893309999985ms {"timings":{"total":4396.8893309999985,"sync":23.256285999999818,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":688.0858399999997,"oracles":{"debugLog":{"times":[0.7520259999982954,0.9983519999987038,0.7602269999988494,0.7346749999996973,0.6958320000012463,0.5958769999997457,0.7761380000010831,0.7736680000016349]},"fetchTaggedLogs":{"times":[136.01164600000266]},"loadCapsule":{"times":[0.5387929999997141,0.34992199999760487,0.6551499999986845,3.876908000002004,1.133669999999256,6.488107999997737]},"getSharedSecret":{"times":[6.35497899999973]},"aes128Decrypt":{"times":[0.5546340000000782,1.4836909999976342]},"getPublicKeysAndPartialAddress":{"times":[2.1011690000013914]},"getKeyValidationRequest":{"times":[13.356728999999177]},"deliverNote":{"times":[15.078413999999611]},"deleteCapsule":{"times":[0.6558299999996962]},"storeCapsule":{"times":[0.38020399999732035]},"getNotes":{"times":[2.8737870000004477]},"getAuthWitness":{"times":[0.2393949999968754]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08634499999971013]},"callPrivateFunction":{"times":[1630.6072349999995]}}},{"functionName":"private_kernel_init","time":167.7828019999979},{"functionName":"Token:mint_to_private","time":1393.780490000001,"oracles":{"debugLog":{"times":[0.7148940000006405,0.5635650000003807]},"fetchTaggedLogs":{"times":[225.71842399999878]},"loadCapsule":{"times":[0.39499399999840534,0.4484169999996084,0.31427999999868916]},"getRandomField":{"times":[0.16596100000242586,0.3910940000023402,0.30300800000259187,0.1219280000004801,0.13432800000009593,0.14969900000141934,0.11108700000113458,0.09571599999981117,0.11233699999866076,0.10961699999825214,0.07590500000151224,0.08401600000070175]},"getIndexedTaggingSecretAsSender":{"times":[163.51002100000187]},"incrementAppTaggingSecretIndexAsSender":{"times":[198.32635500000106]},"notifyCreatedNullifier":{"times":[0.7659370000001218]},"storeInExecutionCache":{"times":[0.0924059999997553]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08679500000289408]}}},{"functionName":"private_kernel_inner","time":209.24661399999968},{"functionName":"private_kernel_reset","time":286.6712690000022},{"functionName":"private_kernel_tail","time":99.00877799999944}],"unaccounted":1529.0572519999987}} 15:33:29 [15:33:29.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:29 [15:33:29.705] VERBOSE: p2p:tx_pool Adding tx 0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c to pool {"eventName":"tx-added-to-pool","txHash":"0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 15:33:29 [15:33:29.723] INFO: node Received tx 0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c {"txHash":"0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c"} 15:33:29 [15:33:29.723] INFO: pxe:service Sent transaction 0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c 15:33:29 [15:33:29.812] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 15:33:29 [15:33:29.832] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T15:38:42.000Z","now":"2025-06-18T15:38:48.884Z"} 15:33:29 [15:33:29.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:29 [15:33:29.935] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":64.41672800000015} 15:33:29 [15:33:29.967] VERBOSE: simulator:public-processor Processed tx 0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c with 1 public calls in 112.12093199999799ms {"txHash":"0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c","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":112.12093199999799} 15:33:29 [15:33:29.968] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1341413109999994s {"duration":0.1341413109999994,"rate":316792.78876289044,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 15:33:30 [15:33:30.103] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:30 [15:33:30.120] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 133944.58165941059 mana/s {"blockHash":"0x2c230fd37e235a9fd933f12c6633bca844e765f0aba734806ea1f22e99b15aef","globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":3,"slotNumber":4,"timestamp":1750261122,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x17e9fbf6e2748b99da7db34c8f1cb4f50a58b1b79c2682feb891586eb2937f1c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":316.45543499999985,"publicProcessDuration":134.53264499999932,"rollupCircuitsDuration":290.8589260000008,"txCount":1,"blockNumber":3,"blockTimestamp":1750261122,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:30 [15:33:30.124] VERBOSE: sequencer Attesting committee is empty 15:33:30 [15:33:30.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:30 [15:33:30.525] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x23a6c27930d3bb2426678a4c01f038d8c020769e459b5682fd90b39de833f971 15:33:30 [15:33:30.526] VERBOSE: sequencer-client Sent L1 transaction 0x23a6c27930d3bb2426678a4c01f038d8c020769e459b5682fd90b39de833f971 {"gasLimit":479001,"maxFeePerGas":"1.279583385","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:33:30 [15:33:30.537] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:30 [15:33:30.540] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261158] on http://127.0.0.1:8545 15:33:30 [15:33:30.550] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:30 [15:33:30.555] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:33:30 [15:33:30.556] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x23a6c27930d3bb2426678a4c01f038d8c020769e459b5682fd90b39de833f971","calldataSize":1444,"calldataGas":12328,"txCount":1,"blockNumber":3,"blockTimestamp":1750261122,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:30 [15:33:30.556] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:33:30 [15:33:30.561] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261158 15:33:30 [15:33:30.561] WARN: foundation:test-date-provider Time set to 2025-06-18T15:39:18.000Z {"offset":347439,"timeMs":1750261158000} 15:33:30 [15:33:30.562] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:33:30 [15:33:30.566] INFO: blob-sink:server Received blob sidecar for block 0x393f3738d529f75b8ba8646923e0d8deaff1b424721b179a431918b717aa2cba 15:33:30 [15:33:30.573] INFO: blob-sink:server Blob sidecar stored successfully for block 0x393f3738d529f75b8ba8646923e0d8deaff1b424721b179a431918b717aa2cba 15:33:30 [15:33:30.744] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:31 [15:33:31.013] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:31 [15:33:31.039] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x2c230fd37e235a9fd933f12c6633bca844e765f0aba734806ea1f22e99b15aef","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3727408360,"blockNumber":3,"slotNumber":4,"timestamp":1750261122,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0bbca2e54a1cf7650e3fbc16502cc5d7e053c4394fa00c3d37346845d81de094","archiveNextLeafIndex":4} 15:33:31 [15:33:31.154] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":13.624644999999873,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750261122,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:31 [15:33:31.163] VERBOSE: p2p Synched to latest block 3 15:33:31 [15:33:31.226] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:31 [15:33:31.429] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:31 [15:33:31.599] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0bbca2e54a1cf7650e3fbc16502cc5d7e053c4394fa00c3d37346845d81de094","blockNumber":4,"slot":5} 15:33:31 [15:33:31.634] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:31 [15:33:31.743] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0bbca2e54a1cf7650e3fbc16502cc5d7e053c4394fa00c3d37346845d81de094","header":{"contentCommitment":{"blobsHash":"0x00472ae13378067913e10c41c1ce98491f5fcc3f02722bc4dcdbd0d2a77060ef","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750261122,"version":3727408360},"lastArchive":"0x0a7b648fada10faf86559610a51bcd5b2a1ccc7c97aecda50c65718397bf2b7f","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x135b8bb2a7cb78375d983280494769ffe0cd741ba743a361e654d83a4fec94bc","nullifierTree":"0x2394169d1e03d1686a8d1943fce89a7d909905df2d6c9224c3b6272f3f94a09a","publicDataTree":"0x2b8d221471376458c85b95ece6944a64a1a65ecd619d054fdc432dddff9f3727"},"totalFees":24485900700,"totalManaUsed":73695}} 15:33:31 [15:33:31.932] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:32 [15:33:32.142] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:32 [15:33:32.320] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a","selector":"0xc6cedc33"} 15:33:32 [15:33:32.348] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:33:32 [15:33:32.349] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a"} 15:33:32 [15:33:32.389] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0bbca2e54a1cf7650e3fbc16502cc5d7e053c4394fa00c3d37346845d81de094","blockNumber":4,"slot":5} 15:33:32 [15:33:32.587] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:32 [15:33:32.665] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a"} 15:33:32 [15:33:32.690] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1a4b3649aab6d9b0cd938392e20ab72f1238ca777036ea35c80d275562ac7a63 15:33:32 [15:33:32.714] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 15:33:32 [15:33:32.724] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 15:33:32 [15:33:32.733] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x20a64e3f289342bc8dd072dd38149d034f75e326389f4d7561f986f16307beea 15:33:32 [15:33:32.734] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a for storage slot 0x06cf1c5ddbb58527b7420b954111f44b5c684f1b85815397aded865152553455 15:33:32 [15:33:32.746] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:33:32 [15:33:32.748] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x20a64e3f289342bc8dd072dd38149d034f75e326389f4d7561f986f16307beea 15:33:32 [15:33:32.760] VERBOSE: pxe:service Added note {"index":128,"contract":"0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a","slot":"0x06cf1c5ddbb58527b7420b954111f44b5c684f1b85815397aded865152553455","noteHash":"0x0bcadc744281c0c36705e4ec2bacc10e5a4a275c1f49a10d807656fcf0978665","nullifier":"0x2364908df1249991c8456e45154aa04a0023c9f85d90ac156b297fc22547f043"} 15:33:32 [15:33:32.766] VERBOSE: simulator Utility simulation for 0x2cde530d120522f5f9ff78af26c7845bd25dbbf1d2345df762d7d9331fb4908a.0xc6cedc33 completed 15:33:32 [15:33:32.773] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes markAsProven 15:33:32 [15:33:32.788] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 15:33:32 [15:33:32.790] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:33:32 [15:33:32.793] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 3. Pending tip: 3. 15:33:32 [15:33:32.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:32 [15:33:32.800] INFO: node Stopping 15:33:32 [15:33:32.801] INFO: slasher Slasher client stopped. 15:33:32 [15:33:32.801] INFO: sequencer Stopped sequencer 15:33:32 [15:33:32.802] INFO: p2p P2P client stopped. 15:33:32 [15:33:32.804] INFO: world_state Stopped world state synchronizer 15:33:32 [15:33:32.805] INFO: archiver Stopped. 15:33:32 [15:33:32.805] INFO: node Stopped 15:33:32 [15:33:32.805] VERBOSE: e2e:e2e_cheat_codes Cleaning up ACVM state 15:33:32 [15:33:32.805] INFO: e2e:e2e_cheat_codes Cleaning up ACVM temp directory /tmp/5570f5c1 15:33:32 [15:33:32.807] VERBOSE: e2e:e2e_cheat_codes Cleaning up BB state 15:33:32 [15:33:32.810] INFO: blob-sink:server Stopping blob sink 15:33:32 [15:33:32.811] INFO: blob-sink:server Blob sink stopped 15:33:32 [15:33:32.811] VERBOSE: e2e:e2e_cheat_codes Cleaning up data directory at /tmp/091071e79f40254c 15:33:32 PASS src/e2e_cheat_codes.test.ts 15:33:32 e2e_cheat_codes 15:33:32 L1 cheatcodes 15:33:32 ✓ setNextBlockTimestamp by 100 (136 ms) 15:33:32 ✓ setNextBlockTimestamp by 42 (119 ms) 15:33:32 ✓ setNextBlockTimestamp by 99 (126 ms) 15:33:32 ✓ setNextBlockTimestamp to a past timestamp throws (134 ms) 15:33:32 ✓ load a value at a particular storage slot (124 ms) 15:33:32 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (105 ms) 15:33:32 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (114 ms) 15:33:32 ✓ set bytecode correctly (112 ms) 15:33:32 ✓ impersonate (151 ms) 15:33:32 mine 15:33:32 ✓ mine block (304 ms) 15:33:32 ✓ mine 10 blocks (132 ms) 15:33:32 ✓ mine 42 blocks (123 ms) 15:33:32 ✓ mine 99 blocks (112 ms) 15:33:32 L2 cheatcodes 15:33:32 ✓ load public (40 ms) 15:33:32 ✓ load public returns 0 for non existent value (15 ms) 15:33:32 ✓ load private works as expected for no notes (20 ms) 15:33:32 ✓ load private (8036 ms) 15:33:32 ✓ markAsProven (24 ms) 15:33:32 15:33:32 Test Suites: 1 passed, 1 total 15:33:32 Tests: 18 passed, 18 total 15:33:32 Snapshots: 0 total 15:33:32 Time: 33.72 s 15:33:32 Ran all test suites matching /src\/e2e_cheat_codes.test.ts/i. 15:33:32 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?