Parent Log: http://ci.aztec-labs.com/a6379728c23043a9 Command: d2a1f586812a792c: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/464e1a9d9b40b5188586643b44bc52bffccbc3e6 Env: REF_NAME=gh-readonly-queue/master/pr-15117-c06f30929f18b85bcea93c0926a8d640a3819f00 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Tue Jun 17 20:22:25 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15117_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_39ce75ad687a474b_master 20:22:25 +++ id -u 20:22:25 +++ id -g 20:22:25 ++ 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'\''' 20:22:26 + cid=8a0b1a05eb4c68f0c964642c9eeb71ce11418010c4112f5dbf8fea85f7cdb3ae 20:22:26 + set +x 20:22:26 {"level":25,"time":1750191746871,"pid":12,"hostname":"8a0b1a05eb4c","module":"logger","msg":"Logger initialized with level verbose"} 20:22:32 [20:22:32.266] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine block 20:22:32 [20:22:32.578] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.604] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:32 [20:22:32.610] WARN: ethereum:cheat_codes Mined 1 L1 blocks 20:22:32 [20:22:32.610] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.623] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 10 blocks 20:22:32 [20:22:32.733] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.738] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [10] on http://127.0.0.1:8545 20:22:32 [20:22:32.743] WARN: ethereum:cheat_codes Mined 10 L1 blocks 20:22:32 [20:22:32.743] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.749] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 42 blocks 20:22:32 [20:22:32.848] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.851] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [42] on http://127.0.0.1:8545 20:22:32 [20:22:32.857] WARN: ethereum:cheat_codes Mined 42 L1 blocks 20:22:32 [20:22:32.857] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.867] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 99 blocks 20:22:32 [20:22:32.972] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.976] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [99] on http://127.0.0.1:8545 20:22:32 [20:22:32.984] WARN: ethereum:cheat_codes Mined 99 L1 blocks 20:22:32 [20:22:32.985] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:32 [20:22:32.990] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 100 20:22:33 [20:22:33.088] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.098] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750191853] on http://127.0.0.1:8545 20:22:33 [20:22:33.100] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750191853 20:22:33 [20:22:33.100] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.102] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:33 [20:22:33.103] WARN: ethereum:cheat_codes Mined 1 L1 blocks 20:22:33 [20:22:33.103] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.104] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.107] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 42 20:22:33 [20:22:33.189] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.194] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.197] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750191795] on http://127.0.0.1:8545 20:22:33 [20:22:33.198] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750191795 20:22:33 [20:22:33.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.200] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:33 [20:22:33.201] WARN: ethereum:cheat_codes Mined 1 L1 blocks 20:22:33 [20:22:33.201] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.202] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.205] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 99 20:22:33 [20:22:33.297] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.302] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.305] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750191852] on http://127.0.0.1:8545 20:22:33 [20:22:33.307] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1750191852 20:22:33 [20:22:33.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.308] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:33 [20:22:33.309] WARN: ethereum:cheat_codes Mined 1 L1 blocks 20:22:33 [20:22:33.309] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 20:22:33 [20:22:33.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.313] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp to a past timestamp throws 20:22:33 [20:22:33.386] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:33 [20:22:33.389] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750190753] on http://127.0.0.1:8545 20:22:33 [20:22:33.400] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes load a value at a particular storage slot 20:22:33 [20:22:33.475] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0x0000000000000000000000000000000000000000","0x00","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.483] 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) 20:22:33 [20:22:33.562] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 20:22:33 [20:22:33.564] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 1 to 5 20:22:33 [20:22:33.565] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.569] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 20:22:33 [20:22:33.572] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 78541660797044910968829902406342334108369226379826116161446442989268089806461 to 5 20:22:33 [20:22:33.573] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.578] 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) 20:22:33 [20:22:33.677] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 20:22:33 [20:22:33.682] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 85149632668394328379478047665368132835280330034293399760893490333839055043265 to 5 20:22:33 [20:22:33.682] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.684] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 20:22:33 [20:22:33.685] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 58076768977499219212177354345858258922703203414073725940090140522697466344574 to 5 20:22:33 [20:22:33.686] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.689] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes set bytecode correctly 20:22:33 [20:22:33.787] INFO: ethereum:cheat_codes Calling hardhat_setCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","0x1234"] on http://127.0.0.1:8545 20:22:33 [20:22:33.790] WARN: ethereum:cheat_codes Set bytecode for 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 to 0x1234 20:22:33 [20:22:33.791] INFO: ethereum:cheat_codes Calling eth_getCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","latest"] on http://127.0.0.1:8545 20:22:33 [20:22:33.794] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes impersonate 20:22:33 [20:22:33.899] INFO: ethereum:cheat_codes Calling hardhat_impersonateAccount with params: ["0x4f81fd025b240a09fb825af74fc547f91d160600"] on http://127.0.0.1:8545 20:22:33 [20:22:33.900] WARN: ethereum:cheat_codes Impersonating 0x4f81fd025b240a09fb825af74fc547f91d160600 20:22:33 [20:22:33.906] INFO: ethereum:cheat_codes Calling hardhat_stopImpersonatingAccount with params: ["0x4f81fd025b240a09fb825af74fc547f91d160600"] on http://127.0.0.1:8545 20:22:33 [20:22:33.907] WARN: ethereum:cheat_codes Stopped impersonating 0x4f81fd025b240a09fb825af74fc547f91d160600 20:22:33 [20:22:33.970] INFO: e2e:e2e_cheat_codes Logging metrics to log/e2e_cheat_codes.jsonl 20:22:34 [20:22:34.088] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-hq5nmj/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 20:22:34 [20:22:34.122] INFO: e2e:e2e_cheat_codes Calling anvil_setBlockTimestampInterval with params: [12] 20:22:34 [20:22:34.126] WARN: e2e:e2e_cheat_codes Set block interval to 12 20:22:34 [20:22:34.126] VERBOSE: e2e:e2e_cheat_codes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 20:22:34 [20:22:34.156] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 20:22:34 [20:22:34.173] VERBOSE: e2e:e2e_cheat_codes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 20:22:34 [20:22:34.195] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 20:22:34 [20:22:34.200] VERBOSE: e2e:e2e_cheat_codes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 20:22:34 [20:22:34.215] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 20:22:34 [20:22:34.220] VERBOSE: e2e:e2e_cheat_codes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 20:22:34 [20:22:34.238] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 20:22:34 [20:22:34.242] VERBOSE: e2e:e2e_cheat_codes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 20:22:34 [20:22:34.265] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 20:22:34 [20:22:34.273] VERBOSE: e2e:e2e_cheat_codes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 20:22:34 [20:22:34.288] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 20:22:34 [20:22:34.293] VERBOSE: e2e:e2e_cheat_codes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 20:22:34 [20:22:34.294] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 20:22:34 [20:22:34.294] INFO: e2e:e2e_cheat_codes Waiting for 6 transactions to be mined... 20:22:34 [20:22:34.311] INFO: e2e:e2e_cheat_codes All transactions mined successfully 20:22:34 [20:22:34.327] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 20:22:34 [20:22:34.328] VERBOSE: e2e:e2e_cheat_codes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 20:22:34 [20:22:34.339] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 20:22:34 [20:22:34.356] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 20:22:34 [20:22:34.362] VERBOSE: e2e:e2e_cheat_codes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 20:22:34 [20:22:34.381] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 20:22:34 [20:22:34.381] VERBOSE: e2e:e2e_cheat_codes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 20:22:34 [20:22:34.395] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 20:22:34 [20:22:34.399] VERBOSE: e2e:e2e_cheat_codes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 20:22:34 [20:22:34.409] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 20:22:34 [20:22:34.409] VERBOSE: e2e:e2e_cheat_codes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 20:22:34 [20:22:34.409] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 20:22:34 [20:22:34.409] INFO: e2e:e2e_cheat_codes Waiting for 8 transactions to be mined... 20:22:34 [20:22:34.424] INFO: e2e:e2e_cheat_codes All transactions mined successfully 20:22:34 [20:22:34.433] VERBOSE: e2e:e2e_cheat_codes Deployed shared contracts 20:22:34 [20:22:34.446] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 20:22:34 [20:22:34.446] VERBOSE: e2e:e2e_cheat_codes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 20:22:34 [20:22:34.448] 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} 20:22:34 [20:22:34.466] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 20:22:34 [20:22:34.496] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 20:22:34 [20:22:34.502] VERBOSE: e2e:e2e_cheat_codes Awaiting for linked libraries to be deployed 20:22:34 [20:22:34.541] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x35e585e4b20a6d5ca4262d3581d6306bda34ca2f83daebf74eee56358e0a0b6a {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 20:22:34 [20:22:34.547] 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} 20:22:34 [20:22:34.547] INFO: e2e:e2e_cheat_codes Waiting for 9 transactions to be mined... 20:22:34 [20:22:34.582] INFO: e2e:e2e_cheat_codes All transactions mined successfully 20:22:34 [20:22:34.582] VERBOSE: e2e:e2e_cheat_codes All core contracts have been deployed 20:22:34 [20:22:34.593] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 20:22:34 [20:22:34.593] VERBOSE: e2e:e2e_cheat_codes Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 20:22:34 [20:22:34.602] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 20:22:34 [20:22:34.605] VERBOSE: e2e:e2e_cheat_codes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 20:22:34 [20:22:34.621] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 20:22:34 [20:22:34.621] VERBOSE: e2e:e2e_cheat_codes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 20:22:34 [20:22:34.621] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 20:22:34 [20:22:34.637] INFO: e2e:e2e_cheat_codes All transactions mined successfully 20:22:34 [20:22:34.642] VERBOSE: e2e:e2e_cheat_codes Rollup deployed 20:22:34 [20:22:34.642] VERBOSE: e2e:e2e_cheat_codes Waiting for rollup and slash factory to be deployed 20:22:34 [20:22:34.642] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 20:22:34 [20:22:34.667] INFO: e2e:e2e_cheat_codes All transactions mined successfully 20:22:34 [20:22:34.668] VERBOSE: e2e:e2e_cheat_codes All transactions for L1 deployment have been mined 20:22:34 [20:22:34.693] 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"} 20:22:34 [20:22:34.696] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 20:22:34 [20:22:34.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:34 [20:22:34.699] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 20:22:34 [20:22:34.700] INFO: telemetry:client Using NoopTelemetryClient 20:22:34 [20:22:34.705] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/dbce2475ebb2d1de/blob-sink with map size 134217728 KB (LMDB v2) 20:22:34 [20:22:34.706] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 20:22:34 [20:22:34.706] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 20:22:34 [20:22:34.708] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:34 [20:22:34.711] INFO: aztecjs:utils:watcher New L1 time: 1750191993 20:22:34 [20:22:34.711] WARN: foundation:test-date-provider Time set to 2025-06-17T20:26:33.000Z {"offset":238289,"timeMs":1750191993000} 20:22:34 [20:22:34.713] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 20:22:34 [20:22:34.719] INFO: blob-sink:server Server is running on http://localhost:45415 20:22:34 [20:22:34.720] VERBOSE: e2e:e2e_cheat_codes Creating and synching an aztec node... 20:22:34 [20:22:34.720] VERBOSE: e2e:e2e_cheat_codes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/e9505180/acvm 20:22:34 [20:22:34.721] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:45415"} 20:22:34 [20:22:34.737] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 20:22:34 [20:22:34.738] INFO: archiver:lmdb Creating archiver data store at directory /tmp/dbce2475ebb2d1de/archiver with map size 134217728 KB (LMDB v2) 20:22:34 [20:22:34.740] INFO: archiver:lmdb Starting data store with maxReaders 16 20:22:34 [20:22:34.953] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:35 [20:22:35.082] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:45415"} 20:22:35 [20:22:35.101] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:45415"} 20:22:35 [20:22:35.102] WARN: node:blob-sink:client No L1 consensus host urls configured 20:22:35 [20:22:35.102] WARN: node:blob-sink:client No archive client configured 20:22:35 [20:22:35.105] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x6a37ebec93596f143fc04e71bc07cff4864658717834b3e1bfd6afa27a1950e1 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xf4af81f12e66e65d0ef3db61cd680bc8e51ac987a1c29f636d58bce4614ad7b9","l1BlockNumber":16}} 20:22:35 [20:22:35.123] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 20:22:35 [20:22:35.134] INFO: world-state:database Creating world state data store at directory /tmp/dbce2475ebb2d1de/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 20:22:35 [20:22:35.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:35 [20:22:35.169] INFO: world_state Created world state synchroniser with block history of 64 20:22:35 [20:22:35.169] WARN: node Aztec node is accepting fake proofs 20:22:35 [20:22:35.184] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/dbce2475ebb2d1de/p2p with map size 134217728 KB (LMDB v2) 20:22:35 [20:22:35.186] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 20:22:35 [20:22:35.188] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/dbce2475ebb2d1de/p2p-archive with map size 134217728 KB (LMDB v2) 20:22:35 [20:22:35.189] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 20:22:35 [20:22:35.191] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/dbce2475ebb2d1de/p2p-peers with map size 134217728 KB (LMDB v2) 20:22:35 [20:22:35.193] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 20:22:35 [20:22:35.194] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 20:22:35 [20:22:35.195] VERBOSE: p2p P2P is disabled. Using dummy P2P service 20:22:35 [20:22:35.198] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 20:22:35 [20:22:35.199] INFO: world_state Started world state synchronizer from block 1 20:22:35 [20:22:35.201] VERBOSE: world-state:block_stream Starting sync from block number 0 20:22:35 [20:22:35.205] INFO: p2p Starting p2p client from block 0 with empty mempools 20:22:35 [20:22:35.205] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 20:22:35 [20:22:35.206] INFO: slasher Slasher client initialized 20:22:35 [20:22:35.206] INFO: slasher Starting Slasher client... 20:22:35 [20:22:35.240] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 20:22:35 [20:22:35.240] VERBOSE: node All Aztec Node subsystems synced 20:22:35 [20:22:35.250] INFO: sequencer-client Deploying forwarder contract 20:22:35 [20:22:35.256] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 20:22:35 [20:22:35.268] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 20:22:35 [20:22:35.268] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 20:22:35 [20:22:35.273] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 20:22:35 [20:22:35.286] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 20:22:35 [20:22:35.286] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 20:22:35 [20:22:35.287] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/e9505180/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 20:22:35 [20:22:35.502] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 20:22:35 [20:22:35.504] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 20:22:35 [20:22:35.505] INFO: node Aztec Node version: 0.87.8 20:22:35 [20:22:35.505] 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"} 20:22:35 [20:22:35.506] VERBOSE: e2e:e2e_cheat_codes Creating a pxe... 20:22:35 [20:22:35.510] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:35 [20:22:35.520] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/14f7b245a4f87bf3/pxe_data with map size 134217728 KB (LMDB v2) 20:22:35 [20:22:35.535] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:35 [20:22:35.536] INFO: pxe:data:lmdb Starting data store with maxReaders 16 20:22:35 [20:22:35.722] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:35 [20:22:35.810] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 20:22:35 [20:22:35.811] INFO: pxe:service Started PXE connected to chain 31337 version 2980222476 20:22:35 [20:22:35.862] INFO: pxe:service Registered account 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf 20:22:35 [20:22:35.922] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 20:22:35 [20:22:35.922] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf 20:22:35 [20:22:35.947] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:36 [20:22:36.043] INFO: pxe:service Added contract SchnorrAccount at 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 20:22:36 [20:22:36.054] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:36 [20:22:36.082] VERBOSE: pxe:block_stream Starting sync from block number 0 20:22:36 [20:22:36.116] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 20:22:36 [20:22:36.174] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:36 [20:22:36.227] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 20:22:36 [20:22:36.925] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 20:22:37 [20:22:37.025] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 20:22:37 [20:22:37.104] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:37 [20:22:37.127] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:37 [20:22:37.237] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.282] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:22:37 [20:22:37.283] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:37 [20:22:37.348] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.356] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:22:37 [20:22:37.538] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:37 [20:22:37.557] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.598] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:22:37 [20:22:37.598] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.645] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:37 [20:22:37.647] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:37 [20:22:37.650] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:22:37 [20:22:37.680] VERBOSE: simulator:client_execution_context:debug_log Setting 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf as fee payer 20:22:37 [20:22:37.843] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:38 [20:22:38.074] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:38 [20:22:38.208] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:38 [20:22:38.366] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:38 [20:22:38.852] INFO: pxe:service Proving completed in 2777.143489ms {"timings":{"total":2777.143489,"sync":7.706351000000723,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":172.8722639999978,"oracles":{"callPrivateFunction":{"times":[924.7045340000004,375.69912400000067,220.90094599999975]}}},{"functionName":"private_kernel_init","time":104.37556699999914},{"functionName":"ContractClassRegisterer:register","time":904.7716999999993,"oracles":{"loadCapsule":{"times":[11.678970000000845]},"notifyCreatedNullifier":{"times":[47.43216599999869]},"debugLog":{"times":[1.443355999999767]},"notifyCreatedContractClassLog":{"times":[10.385046999999759]}}},{"functionName":"private_kernel_inner","time":129.00707799999873},{"functionName":"SchnorrAccount:constructor","time":337.99812999999995,"oracles":{"getContractInstance":{"times":[1.1591590000007272]},"debugLog":{"times":[0.7893590000003314,0.5550540000003821]},"fetchTaggedLogs":{"times":[70.60317099999884]},"loadCapsule":{"times":[0.4365010000001348,1.3901739999982965,0.3469089999998687]},"notifyCreatedNullifier":{"times":[0.27545700000155193,0.3403780000007828]},"notifyCreatedNote":{"times":[0.4881420000001526]},"getRandomField":{"times":[0.3712889999987965,0.23484599999937927,0.0652219999992667,0.05866200000127719,0.049810999998953776,0.05678099999931874,0.05598200000167708,0.056411000001389766,0.05418199999985518,0.06852099999923666,0.04744100000061735]},"getIndexedTaggingSecretAsSender":{"times":[37.76588599999923]},"incrementAppTaggingSecretIndexAsSender":{"times":[33.86602899999889]}}},{"functionName":"private_kernel_inner","time":149.54347700000108},{"functionName":"SchnorrAccount:entrypoint","time":195.2040500000021,"oracles":{"debugLog":{"times":[0.47794099999919126,0.4525809999995545,0.8881320000000414]},"fetchTaggedLogs":{"times":[50.83038999999917]},"loadCapsule":{"times":[0.30688700000064273,0.25791600000047765,0.45171099999970465]},"getNotes":{"times":[8.574652000001151]},"getAuthWitness":{"times":[0.5596839999998338]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.4608469999984663]}}},{"functionName":"private_kernel_inner","time":119.67311700000027},{"functionName":"private_kernel_reset","time":187.88871800000015},{"functionName":"private_kernel_tail","time":69.75912000000062}],"unaccounted":398.34391700000015}} 20:22:38 [20:22:38.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:38 [20:22:38.945] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","blockNumber":1,"slot":2} 20:22:39 [20:22:39.022] VERBOSE: p2p:tx_pool Adding tx 0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc to pool {"eventName":"tx-added-to-pool","txHash":"0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 20:22:39 [20:22:39.048] INFO: node Received tx 0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc {"txHash":"0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc"} 20:22:39 [20:22:39.048] INFO: pxe:service Sent transaction 0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc 20:22:39 [20:22:39.084] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:39 [20:22:39.290] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:39 [20:22:39.469] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 20:22:39 [20:22:39.483] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-17T20:26:57.000Z","now":"2025-06-17T20:26:37.772Z"} 20:22:39 [20:22:39.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:39 [20:22:39.827] VERBOSE: simulator:public-processor Processed tx 0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc with no public calls in 229.57656099999986ms {"txHash":"0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc","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":229.57656099999986} 20:22:39 [20:22:39.831] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:39 [20:22:39.833] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3476944400000011s {"duration":0.3476944400000011,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 20:22:39 [20:22:39.982] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1b3bb4e2efa7322842fa4dadfb33df482897f494ee9cf05a14ae8f130f795de2","globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":1,"slotNumber":2,"timestamp":1750192017,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x287e87b3b59c57a414a41c7aa5e4268c59ce72fae683fee47e015f25f7be28fc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":512.8645449999985,"publicProcessDuration":348.8390589999999,"rollupCircuitsDuration":499.84337199999936,"txCount":1,"blockNumber":1,"blockTimestamp":1750192017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:22:39 [20:22:39.986] VERBOSE: sequencer Attesting committee is empty 20:22:40 [20:22:40.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:40 [20:22:40.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:40 [20:22:40.431] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x1aa5b17d75e8c27e747fdfad1a726658664c192fef78cedb665b4d1ae90d0efa 20:22:40 [20:22:40.431] VERBOSE: sequencer-client Sent L1 transaction 0x1aa5b17d75e8c27e747fdfad1a726658664c192fef78cedb665b4d1ae90d0efa {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 20:22:40 [20:22:40.449] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 20:22:40 [20:22:40.450] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x1aa5b17d75e8c27e747fdfad1a726658664c192fef78cedb665b4d1ae90d0efa","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750192017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:22:40 [20:22:40.451] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 20:22:40 [20:22:40.478] INFO: blob-sink:server Received blob sidecar for block 0xe4683b56e86abecd171c2dbeafd6071f6123368931d06414d17393f34235306a 20:22:40 [20:22:40.486] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe4683b56e86abecd171c2dbeafd6071f6123368931d06414d17393f34235306a 20:22:40 [20:22:40.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:40 [20:22:40.526] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 20:22:40 [20:22:40.531] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 20:22:40 [20:22:40.545] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 20:22:40 [20:22:40.682] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 20:22:40 [20:22:40.699] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1b3bb4e2efa7322842fa4dadfb33df482897f494ee9cf05a14ae8f130f795de2","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":1,"slotNumber":2,"timestamp":1750192017,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","archiveNextLeafIndex":2} 20:22:40 [20:22:40.712] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750192053] on http://127.0.0.1:8545 20:22:40 [20:22:40.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:40 [20:22:40.719] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:40 [20:22:40.727] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750192053 20:22:40 [20:22:40.728] WARN: foundation:test-date-provider Time set to 2025-06-17T20:27:33.000Z {"offset":292272,"timeMs":1750192053000} 20:22:40 [20:22:40.728] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 20:22:41 [20:22:41.214] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:41 [20:22:41.221] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":440.86686999999984,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750192017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:22:41 [20:22:41.222] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 20:22:41 [20:22:41.228] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3 20:22:41 [20:22:41.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:41 [20:22:41.568] VERBOSE: p2p Synched to latest block 1 20:22:41 [20:22:41.579] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 20:22:41 [20:22:41.959] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:41 [20:22:41.978] INFO: pxe:service Added contract Token at 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 20:22:42 [20:22:42.027] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","blockNumber":2,"slot":3} 20:22:42 [20:22:42.036] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","header":{"contentCommitment":{"blobsHash":"0x00e7683660f9f00652d3d17e9006f5fb3c758cb3d685e11028d99c566540577f","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750192017,"version":2980222476},"lastArchive":"0x21c01513ef175ef82589a89332b8fa728ebc247878f319c9019b40027741711d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2304cbf4ff7d31785e3af185914eafb2ad41bfca42a034eceef435d4fcad5fe7","nullifierTree":"0x222323271b6d78ac1760d39c7c5e933e80da6f8a117e78e904352152caeb95e0","publicDataTree":"0x1805521a839c142e690d395af8fce34f485279365e5acbd1b08e70e63f055f00"},"totalFees":6794052480,"totalManaUsed":20448}} 20:22:42 [20:22:42.174] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:42 [20:22:42.215] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:22:42 [20:22:42.215] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:42 [20:22:42.226] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:42 [20:22:42.318] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:42 [20:22:42.328] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x137f989985188df7723faed5cabfdedabde5478651e89a12562734ec79d6e639 20:22:42 [20:22:42.341] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 20:22:42 [20:22:42.342] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 20:22:42 [20:22:42.350] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 20:22:42 [20:22:42.351] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 20:22:42 [20:22:42.358] VERBOSE: pxe:service Added note {"index":0,"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c453801d73362f1f2f7548cb284169139079f1b218c020d08e0c236fd4eafb0","nullifier":"0x004cd9119c9572036d104d839c719442c61be60bb14572279d74fa3d101aaa57"} 20:22:42 [20:22:42.362] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:22:42 [20:22:42.383] VERBOSE: simulator:client_execution_context:debug_log Setting 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf as fee payer 20:22:42 [20:22:42.437] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:42 [20:22:42.446] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 20:22:43 [20:22:43.083] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 20:22:43 [20:22:43.233] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 20:22:43 [20:22:43.457] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 20:22:43 [20:22:43.482] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","blockNumber":2,"slot":3} 20:22:43 [20:22:43.532] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 20:22:43 [20:22:43.548] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3,0x0000000000000000000000000000000000000000000000000000000000000001,0x1227e574bf97a1fd5bcd0d91f9838227a0bdb157f55ef0d4f81576a096095517,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x030be049583bd95c62dfb348cdb547869c7381577bf94407da18a9fdca86f98c,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf 20:22:43 [20:22:43.572] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:43 [20:22:43.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:44 [20:22:44.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:44 [20:22:44.317] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","blockNumber":2,"slot":3} 20:22:44 [20:22:44.532] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:44 [20:22:44.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:45 [20:22:45.191] INFO: pxe:service Proving completed in 3170.7173950000015ms {"timings":{"total":3170.7173950000015,"sync":18.69288299999971,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":367.8638499999961,"oracles":{"debugLog":{"times":[0.6446859999996377,0.5547940000014933,0.5871839999999793,0.5117229999996198,0.6479869999984658,0.5289730000004056,0.4694519999993645,0.8264500000004773]},"fetchTaggedLogs":{"times":[108.75723599999947]},"loadCapsule":{"times":[1.1250180000006367,0.4549110000007204,0.596704999999929,0.42210999999952037,0.46016099999906146,0.38367900000048394]},"getSharedSecret":{"times":[4.483290999998644]},"aes128Decrypt":{"times":[1.066106000000218,1.2668410000005679]},"getPublicKeysAndPartialAddress":{"times":[1.9089480000002368]},"getKeyValidationRequest":{"times":[2.3656389999996463]},"deliverNote":{"times":[7.548017000000982]},"deleteCapsule":{"times":[0.7017669999986538]},"storeCapsule":{"times":[0.9855250000000524]},"getNotes":{"times":[2.5252929999987828]},"getAuthWitness":{"times":[0.2815370000007533]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06963200000063807]},"callPrivateFunction":{"times":[928.5092079999995,238.51416299999983]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3731289999996079]}}},{"functionName":"private_kernel_init","time":110.05558799999926},{"functionName":"ContractClassRegisterer:register","time":907.6375210000006,"oracles":{"loadCapsule":{"times":[7.092376000000513]},"notifyCreatedNullifier":{"times":[1.044925999998668]},"debugLog":{"times":[1.134437999997317]},"notifyCreatedContractClassLog":{"times":[18.95865000000049]}}},{"functionName":"private_kernel_inner","time":185.44622799999706},{"functionName":"ContractInstanceDeployer:deploy","time":151.22493899999972,"oracles":{"storeInExecutionCache":{"times":[0.329278000001068]},"callPrivateFunction":{"times":[74.80416499999774]},"notifyCreatedNullifier":{"times":[0.32820799999899464]},"debugLog":{"times":[0.6106950000030338]}}},{"functionName":"private_kernel_inner","time":195.5402380000014},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":59.72802100000263,"oracles":{}},{"functionName":"private_kernel_inner","time":146.5638629999994},{"functionName":"private_kernel_reset","time":309.6944570000014},{"functionName":"private_kernel_tail","time":107.46903400000156}],"unaccounted":610.8007730000027}} 20:22:45 [20:22:45.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:45 [20:22:45.492] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","blockNumber":2,"slot":3} 20:22:45 [20:22:45.507] VERBOSE: p2p:tx_pool Adding tx 0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0 to pool {"eventName":"tx-added-to-pool","txHash":"0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 20:22:45 [20:22:45.546] INFO: node Received tx 0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0 {"txHash":"0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0"} 20:22:45 [20:22:45.546] INFO: pxe:service Sent transaction 0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0 20:22:45 [20:22:45.676] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:45 [20:22:45.881] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:46 [20:22:46.052] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 20:22:46 [20:22:46.076] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-17T20:27:33.000Z","now":"2025-06-17T20:27:38.348Z"} 20:22:46 [20:22:46.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:46 [20:22:46.597] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:46 [20:22:46.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:47 [20:22:47.029] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":436.45021500000075} 20:22:47 [20:22:47.241] VERBOSE: simulator:public-processor Processed tx 0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0 with 1 public calls in 910.8685110000006ms {"txHash":"0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0","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":910.8685110000006} 20:22:47 [20:22:47.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:47 [20:22:47.246] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.1690478089999996s {"duration":1.1690478089999996,"rate":326617.09560588223,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 20:22:47 [20:22:47.442] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 274600.7043255534 mana/s {"blockHash":"0x1831fb1925694a33d90c5e41e8d6186c897f6a14b935e5e11f2f4b323511e11f","globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":2,"slotNumber":3,"timestamp":1750192053,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x10a830d57bb0ec227b9bc206b0cddaf60ba44494da1f1237858f56cf8b1c9ad0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1389.904043999999,"publicProcessDuration":1169.4569200000005,"rollupCircuitsDuration":1367.5781910000005,"txCount":1,"blockNumber":2,"blockTimestamp":1750192053,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 20:22:47 [20:22:47.444] VERBOSE: sequencer Attesting committee is empty 20:22:47 [20:22:47.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:47 [20:22:47.784] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:47 [20:22:47.791] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf17daa745442d7f147972cbd3a3b22e4309a492870f551b8ff8b67f36aa7c403 20:22:47 [20:22:47.791] VERBOSE: sequencer-client Sent L1 transaction 0xf17daa745442d7f147972cbd3a3b22e4309a492870f551b8ff8b67f36aa7c403 {"gasLimit":470203,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 20:22:47 [20:22:47.810] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 20:22:47 [20:22:47.811] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf17daa745442d7f147972cbd3a3b22e4309a492870f551b8ff8b67f36aa7c403","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1750192053,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 20:22:47 [20:22:47.811] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 20:22:47 [20:22:47.823] INFO: blob-sink:server Received blob sidecar for block 0x81120cea0fd696de67e905f7fc51e0919a104365d3febf3bc51814ee50056d64 20:22:47 [20:22:47.838] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750192089] on http://127.0.0.1:8545 20:22:47 [20:22:47.851] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:47 [20:22:47.855] INFO: blob-sink:server Blob sidecar stored successfully for block 0x81120cea0fd696de67e905f7fc51e0919a104365d3febf3bc51814ee50056d64 20:22:47 [20:22:47.860] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750192089 20:22:47 [20:22:47.861] WARN: foundation:test-date-provider Time set to 2025-06-17T20:28:09.000Z {"offset":321139,"timeMs":1750192089000} 20:22:47 [20:22:47.861] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 20:22:47 [20:22:47.989] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:48 [20:22:48.195] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:48 [20:22:48.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:48 [20:22:48.479] VERBOSE: archiver:block-helper Store contract instance at 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3 20:22:48 [20:22:48.516] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 20:22:48 [20:22:48.576] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1831fb1925694a33d90c5e41e8d6186c897f6a14b935e5e11f2f4b323511e11f","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":2,"slotNumber":3,"timestamp":1750192053,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","archiveNextLeafIndex":3} 20:22:48 [20:22:48.646] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:48 [20:22:48.666] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":10.53810799999701,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750192053,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 20:22:48 [20:22:48.917] INFO: aztecjs:deploy_sent_tx Contract 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3 successfully deployed. 20:22:48 [20:22:48.919] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public 20:22:48 [20:22:48.921] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:48 [20:22:48.931] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public returns 0 for non existent value 20:22:48 [20:22:48.935] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private works as expected for no notes 20:22:48 [20:22:48.943] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private 20:22:49 [20:22:49.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:49 [20:22:49.170] VERBOSE: p2p Synched to latest block 2 20:22:49 [20:22:49.210] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","blockNumber":3,"slot":4} 20:22:49 [20:22:49.223] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","header":{"contentCommitment":{"blobsHash":"0x00016f584cf150dc581a552a7b711b0b041a256104936d3d8b9515541ba1f37a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750192053,"version":2980222476},"lastArchive":"0x15582d4569a8bd6e60f4c6f117b9377ca3b0b8a4c3e925371e7cd070dea246fd","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2304cbf4ff7d31785e3af185914eafb2ad41bfca42a034eceef435d4fcad5fe7","nullifierTree":"0x2c3873dfdaa4aa885a8426c493480058040c2d0d604fbdd280589c47535fb3c8","publicDataTree":"0x2b2a6ed8a5adbea8c7612ff6f7aefd81185b0d4f50ac16bfcbc6f852d5795ea6"},"totalFees":139009277500,"totalManaUsed":418375}} 20:22:49 [20:22:49.347] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:49 [20:22:49.404] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:22:49 [20:22:49.405] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:49 [20:22:49.406] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:49 [20:22:49.500] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf"} 20:22:49 [20:22:49.506] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x137f989985188df7723faed5cabfdedabde5478651e89a12562734ec79d6e639 20:22:49 [20:22:49.520] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 20:22:49 [20:22:49.521] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 20:22:49 [20:22:49.528] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 20:22:49 [20:22:49.529] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 20:22:49 [20:22:49.535] VERBOSE: pxe:service Added note {"index":0,"contract":"0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c453801d73362f1f2f7548cb284169139079f1b218c020d08e0c236fd4eafb0","nullifier":"0x004cd9119c9572036d104d839c719442c61be60bb14572279d74fa3d101aaa57"} 20:22:49 [20:22:49.537] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:22:49 [20:22:49.555] VERBOSE: simulator:client_execution_context:debug_log Setting 0x10a7988652369dcf641899b72ee72123aeea159f7e9e65f6bbe2092c07a515cf as fee payer 20:22:49 [20:22:49.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:50 [20:22:50.180] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3"} 20:22:50 [20:22:50.226] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:22:50 [20:22:50.227] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3"} 20:22:50 [20:22:50.233] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:50 [20:22:50.255] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","blockNumber":3,"slot":4} 20:22:50 [20:22:50.392] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3"} 20:22:50 [20:22:50.399] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:22:50 [20:22:50.562] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:50 [20:22:50.815] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:51 [20:22:51.051] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:51 [20:22:51.200] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","blockNumber":3,"slot":4} 20:22:51 [20:22:51.325] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:52 [20:22:52.084] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:52 [20:22:52.111] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","blockNumber":3,"slot":4} 20:22:52 [20:22:52.468] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:52 [20:22:52.791] INFO: pxe:service Proving completed in 3593.924446000001ms {"timings":{"total":3593.924446000001,"sync":26.732013999997434,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":447.5838580000018,"oracles":{"debugLog":{"times":[1.0017679999982647,0.5571650000019872,0.5039250000008906,0.3632099999995262,0.4777040000008128,0.36537999999927706,0.3011289999994915,0.6670690000028117]},"fetchTaggedLogs":{"times":[99.11504699999932]},"loadCapsule":{"times":[0.4579029999986233,0.19048599999950966,0.454091999999946,0.23137599999972736,0.2390769999983604,0.1825749999989057]},"getSharedSecret":{"times":[7.42750999999771]},"aes128Decrypt":{"times":[0.3112790000013774,0.6072469999999157]},"getPublicKeysAndPartialAddress":{"times":[2.908712000000378]},"getKeyValidationRequest":{"times":[1.655955999998696]},"deliverNote":{"times":[6.25754600000073]},"deleteCapsule":{"times":[0.23177700000087498]},"storeCapsule":{"times":[0.2261770000004617]},"getNotes":{"times":[4.255040000000008]},"getAuthWitness":{"times":[0.3170289999980014]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07223099999828264]},"callPrivateFunction":{"times":[1182.7020109999976]}}},{"functionName":"private_kernel_init","time":95.70539099999951},{"functionName":"Token:mint_to_private","time":1043.8616650000004,"oracles":{"debugLog":{"times":[0.9971980000009353,0.406580999999278]},"fetchTaggedLogs":{"times":[170.1340909999999]},"loadCapsule":{"times":[0.24938699999984237,0.2983089999979711,0.32294899999760673]},"getRandomField":{"times":[0.11037299999952666,0.09194299999944633,0.19022499999846332,0.06864200000200071,0.07091199999922537,0.05719200000021374,0.07704300000114017,0.05238200000167126,0.04424099999960163,0.04167099999904167,0.04453099999955157,0.08317300000271644]},"getIndexedTaggingSecretAsSender":{"times":[176.3488449999968]},"incrementAppTaggingSecretIndexAsSender":{"times":[130.7986009999986]},"notifyCreatedNullifier":{"times":[0.5580759999975271]},"storeInExecutionCache":{"times":[0.08239300000059302]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10959399999774178]}}},{"functionName":"private_kernel_inner","time":331.850104000001},{"functionName":"private_kernel_reset","time":225.41600099999778},{"functionName":"private_kernel_tail","time":113.80748099999983}],"unaccounted":1308.9679320000032}} 20:22:52 [20:22:52.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:52 [20:22:52.863] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","blockNumber":3,"slot":4} 20:22:52 [20:22:52.871] VERBOSE: p2p:tx_pool Adding tx 0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1 to pool {"eventName":"tx-added-to-pool","txHash":"0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 20:22:52 [20:22:52.885] INFO: node Received tx 0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1 {"txHash":"0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1"} 20:22:52 [20:22:52.886] INFO: pxe:service Sent transaction 0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1 20:22:53 [20:22:53.030] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:53 [20:22:53.236] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:53 [20:22:53.462] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:53 [20:22:53.489] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 20:22:53 [20:22:53.509] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-17T20:28:09.000Z","now":"2025-06-17T20:28:14.648Z"} 20:22:53 [20:22:53.649] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":92.2809840000009} 20:22:53 [20:22:53.668] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:53 [20:22:53.685] VERBOSE: simulator:public-processor Processed tx 0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1 with 1 public calls in 150.01131299999906ms {"txHash":"0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1","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":150.01131299999906} 20:22:53 [20:22:53.688] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.17750284900000043s {"duration":0.17750284900000043,"rate":239404.6080916701,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 20:22:53 [20:22:53.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:53 [20:22:53.879] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 108293.44537503955 mana/s {"blockHash":"0x00a31a7dcc69f50eac719849b2c423e02b2a035fe452ced5631bdd89c00d1a5b","globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":3,"slotNumber":4,"timestamp":1750192089,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x28d75b4509c5e2776d8b17f82afb75f16a42b01f093f8ccd36567d1b98f636e1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":391.93891899999653,"publicProcessDuration":178.53185699999813,"rollupCircuitsDuration":370.7695120000026,"txCount":1,"blockNumber":3,"blockTimestamp":1750192089,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 20:22:53 [20:22:53.881] VERBOSE: sequencer Attesting committee is empty 20:22:54 [20:22:54.080] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:54 [20:22:54.242] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x68afb1dc32950ee2588ac6ed02785b7d7e6fe9b4ca037d3d1e4f6822181f69ed 20:22:54 [20:22:54.243] VERBOSE: sequencer-client Sent L1 transaction 0x68afb1dc32950ee2588ac6ed02785b7d7e6fe9b4ca037d3d1e4f6822181f69ed {"gasLimit":478938,"maxFeePerGas":"1.279583392","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 20:22:54 [20:22:54.283] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750192125] on http://127.0.0.1:8545 20:22:54 [20:22:54.288] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 20:22:54 [20:22:54.289] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x68afb1dc32950ee2588ac6ed02785b7d7e6fe9b4ca037d3d1e4f6822181f69ed","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750192089,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 20:22:54 [20:22:54.290] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 20:22:54 [20:22:54.297] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 20:22:54 [20:22:54.302] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750192125 20:22:54 [20:22:54.302] WARN: foundation:test-date-provider Time set to 2025-06-17T20:28:45.000Z {"offset":350698,"timeMs":1750192125000} 20:22:54 [20:22:54.302] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 20:22:54 [20:22:54.305] INFO: blob-sink:server Received blob sidecar for block 0xf66b55d19970dacb26c724bdd42d25868539d2660b7e88175651eb1efe242acf 20:22:54 [20:22:54.308] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:54 [20:22:54.313] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf66b55d19970dacb26c724bdd42d25868539d2660b7e88175651eb1efe242acf 20:22:54 [20:22:54.521] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:54 [20:22:54.779] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:54 [20:22:54.797] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x00a31a7dcc69f50eac719849b2c423e02b2a035fe452ced5631bdd89c00d1a5b","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2980222476,"blockNumber":3,"slotNumber":4,"timestamp":1750192089,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2c464804024669be56751ca7b404ae66be600e7e874cbdb54aa8faeac9e7c7fa","archiveNextLeafIndex":4} 20:22:54 [20:22:54.905] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":9.891478999998071,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750192089,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 20:22:54 [20:22:54.911] VERBOSE: p2p Synched to latest block 3 20:22:54 [20:22:54.986] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:55 [20:22:55.023] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2c464804024669be56751ca7b404ae66be600e7e874cbdb54aa8faeac9e7c7fa","header":{"contentCommitment":{"blobsHash":"0x001e97ffbc3abc0745ee9e58d23278a41c31211ce19c9ba3ff74177fc43554dc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750192089,"version":2980222476},"lastArchive":"0x2b7b8de6abf798a77f9435320896d3834e790f633d2c6498bdd17f5cc405cd03","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1c369c467f390bc373b89b23ecbb0dbaf64074715333898b3fe777d704aaf1f5","nullifierTree":"0x080928a09abe7fec8dfa49da9e4b6063e8f35696f6a2c689a7329ab4a647bdba","publicDataTree":"0x2359dd7cdadec14f6fb98ebe74a15225be9224fcaf63f6b81967d9533c96ec9b"},"totalFees":24485900700,"totalManaUsed":73695}} 20:22:55 [20:22:55.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:55 [20:22:55.447] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3","selector":"0xc6cedc33"} 20:22:55 [20:22:55.468] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 20:22:55 [20:22:55.469] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3"} 20:22:55 [20:22:55.666] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 20:22:55 [20:22:55.670] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c464804024669be56751ca7b404ae66be600e7e874cbdb54aa8faeac9e7c7fa","blockNumber":4,"slot":5} 20:22:55 [20:22:55.723] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3"} 20:22:55 [20:22:55.738] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x097dee2934fef7e0f35c11f0a4a04316e4f6d1a3c0eac825f2b0593a08625265 20:22:55 [20:22:55.756] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 20:22:55 [20:22:55.761] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 20:22:55 [20:22:55.766] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x13b84a52243632cb64c142c6b78c259013b1842bbaf7864bf7054c29746db5c0 20:22:55 [20:22:55.770] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3 for storage slot 0x0e5fd9cff21499ab838fe801b1702818c1c0bf067a8cdcfed84ee10089147eb9 20:22:55 [20:22:55.783] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 20:22:55 [20:22:55.783] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x13b84a52243632cb64c142c6b78c259013b1842bbaf7864bf7054c29746db5c0 20:22:55 [20:22:55.788] VERBOSE: pxe:service Added note {"index":128,"contract":"0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3","slot":"0x0e5fd9cff21499ab838fe801b1702818c1c0bf067a8cdcfed84ee10089147eb9","noteHash":"0x244a6edef06c2106d8eb63d9fa306ddf9e7036d2d8fc1bc4e3bfc1b6d2c2e059","nullifier":"0x2486d9bab08cbb0c9f54ce5b8fa465879c171255224c5f272442b70f06508c4e"} 20:22:55 [20:22:55.790] VERBOSE: simulator Utility simulation for 0x160d6ece80a80412cbba2dad38f0e2a409d7663dd4103548422ebf36a04041c3.0xc6cedc33 completed 20:22:55 [20:22:55.795] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes markAsProven 20:22:55 [20:22:55.804] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 20:22:55 [20:22:55.806] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 20:22:55 [20:22:55.809] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 3. Pending tip: 3. 20:22:55 [20:22:55.814] INFO: node Stopping 20:22:55 [20:22:55.815] INFO: slasher Slasher client stopped. 20:22:55 [20:22:55.816] INFO: sequencer Stopped sequencer 20:22:55 [20:22:55.816] INFO: p2p P2P client stopped. 20:22:55 [20:22:55.819] INFO: world_state Stopped world state synchronizer 20:22:55 [20:22:55.820] INFO: archiver Stopped. 20:22:55 [20:22:55.820] INFO: node Stopped 20:22:55 [20:22:55.820] VERBOSE: e2e:e2e_cheat_codes Cleaning up ACVM state 20:22:55 [20:22:55.820] INFO: e2e:e2e_cheat_codes Cleaning up ACVM temp directory /tmp/e9505180 20:22:55 [20:22:55.822] VERBOSE: e2e:e2e_cheat_codes Cleaning up BB state 20:22:55 [20:22:55.826] INFO: blob-sink:server Stopping blob sink 20:22:55 [20:22:55.826] INFO: blob-sink:server Blob sink stopped 20:22:55 [20:22:55.827] VERBOSE: e2e:e2e_cheat_codes Cleaning up data directory at /tmp/dbce2475ebb2d1de 20:22:55 PASS src/e2e_cheat_codes.test.ts 20:22:55 e2e_cheat_codes 20:22:55 L1 cheatcodes 20:22:55 ✓ setNextBlockTimestamp by 100 (117 ms) 20:22:55 ✓ setNextBlockTimestamp by 42 (98 ms) 20:22:55 ✓ setNextBlockTimestamp by 99 (108 ms) 20:22:55 ✓ setNextBlockTimestamp to a past timestamp throws (87 ms) 20:22:55 ✓ load a value at a particular storage slot (83 ms) 20:22:55 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (94 ms) 20:22:55 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (110 ms) 20:22:55 ✓ set bytecode correctly (104 ms) 20:22:55 ✓ impersonate (118 ms) 20:22:55 mine 20:22:55 ✓ mine block (357 ms) 20:22:55 ✓ mine 10 blocks (126 ms) 20:22:55 ✓ mine 42 blocks (118 ms) 20:22:55 ✓ mine 99 blocks (123 ms) 20:22:55 L2 cheatcodes 20:22:55 ✓ load public (13 ms) 20:22:55 ✓ load public returns 0 for non existent value (4 ms) 20:22:55 ✓ load private works as expected for no notes (7 ms) 20:22:55 ✓ load private (6851 ms) 20:22:55 ✓ markAsProven (17 ms) 20:22:55 20:22:55 Test Suites: 1 passed, 1 total 20:22:55 Tests: 18 passed, 18 total 20:22:55 Snapshots: 0 total 20:22:55 Time: 29.154 s 20:22:55 Ran all test suites matching /src\/e2e_cheat_codes.test.ts/i. 20:22:55 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?