Parent Log: http://ci.aztec-labs.com/211a9fb93ab8be76 Command: 26102936e69ab88b: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/b1b65bcdbd44a49fbebe5d2265256dc9466e92be Env: REF_NAME=gh-readonly-queue/master/pr-15044-267ac35e8ccb487bdc79bbe12d428f4c8b4d4d9f CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 16:21:29 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15044_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_39ce75ad687a474b_master 16:21:29 +++ id -u 16:21:29 +++ id -g 16:21:29 ++ 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'\''' 16:21:29 + cid=53809ac4221b7530d6337e7de414d466b8e1736b2b2ddea5e31464d89807ffe7 16:21:29 + set +x 16:21:30 {"level":25,"time":1749831690155,"pid":12,"hostname":"53809ac4221b","module":"logger","msg":"Logger initialized with level verbose"} 16:21:36 [16:21:36.213] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine block 16:21:36 [16:21:36.530] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.560] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:36 [16:21:36.567] WARN: ethereum:cheat_codes Mined 1 L1 blocks 16:21:36 [16:21:36.568] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.584] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 10 blocks 16:21:36 [16:21:36.715] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.730] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [10] on http://127.0.0.1:8545 16:21:36 [16:21:36.736] WARN: ethereum:cheat_codes Mined 10 L1 blocks 16:21:36 [16:21:36.737] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.753] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 42 blocks 16:21:36 [16:21:36.850] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.854] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [42] on http://127.0.0.1:8545 16:21:36 [16:21:36.859] WARN: ethereum:cheat_codes Mined 42 L1 blocks 16:21:36 [16:21:36.859] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.867] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes mine mine 99 blocks 16:21:36 [16:21:36.960] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.964] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [99] on http://127.0.0.1:8545 16:21:36 [16:21:36.972] WARN: ethereum:cheat_codes Mined 99 L1 blocks 16:21:36 [16:21:36.972] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:36 [16:21:36.981] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 100 16:21:37 [16:21:37.067] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.072] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.074] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749831797] on http://127.0.0.1:8545 16:21:37 [16:21:37.075] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1749831797 16:21:37 [16:21:37.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.076] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:37 [16:21:37.078] WARN: ethereum:cheat_codes Mined 1 L1 blocks 16:21:37 [16:21:37.078] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.083] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 42 16:21:37 [16:21:37.163] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.166] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.168] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749831739] on http://127.0.0.1:8545 16:21:37 [16:21:37.169] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1749831739 16:21:37 [16:21:37.169] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.173] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:37 [16:21:37.179] WARN: ethereum:cheat_codes Mined 1 L1 blocks 16:21:37 [16:21:37.179] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.187] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp by 99 16:21:37 [16:21:37.276] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.280] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.282] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749831796] on http://127.0.0.1:8545 16:21:37 [16:21:37.284] WARN: ethereum:cheat_codes Set L1 next block timestamp to 1749831796 16:21:37 [16:21:37.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.285] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:37 [16:21:37.286] WARN: ethereum:cheat_codes Mined 1 L1 blocks 16:21:37 [16:21:37.287] INFO: ethereum:cheat_codes Calling eth_blockNumber with params: [] on http://127.0.0.1:8545 16:21:37 [16:21:37.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.292] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes setNextBlockTimestamp to a past timestamp throws 16:21:37 [16:21:37.371] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:37 [16:21:37.377] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749830697] on http://127.0.0.1:8545 16:21:37 [16:21:37.392] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes load a value at a particular storage slot 16:21:37 [16:21:37.470] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0x0000000000000000000000000000000000000000","0x00","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.476] 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) 16:21:37 [16:21:37.567] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 16:21:37 [16:21:37.570] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 1 to 5 16:21:37 [16:21:37.570] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x01","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.575] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 16:21:37 [16:21:37.578] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 78541660797044910968829902406342334108369226379826116161446442989268089806461 to 5 16:21:37 [16:21:37.579] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xada5013122d395ba3c54772283fb069b10426056ef8ca54750cb9bb552a59e7d","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.602] 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) 16:21:37 [16:21:37.696] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 16:21:37 [16:21:37.701] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 85149632668394328379478047665368132835280330034293399760893490333839055043265 to 5 16:21:37 [16:21:37.701] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0xbc40fbf4394cd00f78fae9763b0c2c71b21ea442c42fdadc5b720537240ebac1","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.705] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 16:21:37 [16:21:37.707] WARN: ethereum:cheat_codes Set L1 storage for contract 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 at 58076768977499219212177354345858258922703203414073725940090140522697466344574 to 5 16:21:37 [16:21:37.708] INFO: ethereum:cheat_codes Calling eth_getStorageAt with params: ["0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","0x8066494f08af53d6edb5c6df49048a3b4ae59e20df6d59c86bf8c8650304747e","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.713] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes set bytecode correctly 16:21:37 [16:21:37.795] INFO: ethereum:cheat_codes Calling hardhat_setCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","0x1234"] on http://127.0.0.1:8545 16:21:37 [16:21:37.806] WARN: ethereum:cheat_codes Set bytecode for 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 to 0x1234 16:21:37 [16:21:37.806] INFO: ethereum:cheat_codes Calling eth_getCode with params: ["0x70997970c51812dc3a010c7d01b50e0d17dc79c8","latest"] on http://127.0.0.1:8545 16:21:37 [16:21:37.814] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L1 cheatcodes impersonate 16:21:37 [16:21:37.947] INFO: ethereum:cheat_codes Calling hardhat_impersonateAccount with params: ["0x1e5519fd76fa95c6b13873a0eb1b9fb0f9334d14"] on http://127.0.0.1:8545 16:21:37 [16:21:37.948] WARN: ethereum:cheat_codes Impersonating 0x1e5519fd76fa95c6b13873a0eb1b9fb0f9334d14 16:21:37 [16:21:37.958] INFO: ethereum:cheat_codes Calling hardhat_stopImpersonatingAccount with params: ["0x1e5519fd76fa95c6b13873a0eb1b9fb0f9334d14"] on http://127.0.0.1:8545 16:21:37 [16:21:37.960] WARN: ethereum:cheat_codes Stopped impersonating 0x1e5519fd76fa95c6b13873a0eb1b9fb0f9334d14 16:21:38 [16:21:38.037] INFO: e2e:e2e_cheat_codes Logging metrics to log/e2e_cheat_codes.jsonl 16:21:38 [16:21:38.200] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-HXzpls/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:21:38 [16:21:38.243] INFO: e2e:e2e_cheat_codes Calling anvil_setBlockTimestampInterval with params: [12] 16:21:38 [16:21:38.247] WARN: e2e:e2e_cheat_codes Set block interval to 12 16:21:38 [16:21:38.247] VERBOSE: e2e:e2e_cheat_codes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:21:38 [16:21:38.278] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 16:21:38 [16:21:38.289] VERBOSE: e2e:e2e_cheat_codes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 16:21:38 [16:21:38.315] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 16:21:38 [16:21:38.322] VERBOSE: e2e:e2e_cheat_codes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:21:38 [16:21:38.337] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 16:21:38 [16:21:38.342] VERBOSE: e2e:e2e_cheat_codes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:21:38 [16:21:38.360] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 16:21:38 [16:21:38.365] VERBOSE: e2e:e2e_cheat_codes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:21:38 [16:21:38.387] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 16:21:38 [16:21:38.395] VERBOSE: e2e:e2e_cheat_codes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:21:38 [16:21:38.413] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 16:21:38 [16:21:38.420] VERBOSE: e2e:e2e_cheat_codes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:21:38 [16:21:38.421] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 16:21:38 [16:21:38.422] INFO: e2e:e2e_cheat_codes Waiting for 6 transactions to be mined... 16:21:38 [16:21:38.439] INFO: e2e:e2e_cheat_codes All transactions mined successfully 16:21:38 [16:21:38.473] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 16:21:38 [16:21:38.474] VERBOSE: e2e:e2e_cheat_codes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 16:21:38 [16:21:38.494] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 16:21:38 [16:21:38.521] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 16:21:38 [16:21:38.528] VERBOSE: e2e:e2e_cheat_codes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:21:38 [16:21:38.542] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 16:21:38 [16:21:38.543] VERBOSE: e2e:e2e_cheat_codes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 16:21:38 [16:21:38.560] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 16:21:38 [16:21:38.564] VERBOSE: e2e:e2e_cheat_codes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 16:21:38 [16:21:38.575] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 16:21:38 [16:21:38.575] VERBOSE: e2e:e2e_cheat_codes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 16:21:38 [16:21:38.575] VERBOSE: e2e:e2e_cheat_codes Waiting for deployments to complete 16:21:38 [16:21:38.575] INFO: e2e:e2e_cheat_codes Waiting for 8 transactions to be mined... 16:21:38 [16:21:38.591] INFO: e2e:e2e_cheat_codes All transactions mined successfully 16:21:38 [16:21:38.621] VERBOSE: e2e:e2e_cheat_codes Deployed shared contracts 16:21:38 [16:21:38.641] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 16:21:38 [16:21:38.642] VERBOSE: e2e:e2e_cheat_codes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 16:21:38 [16:21:38.644] 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} 16:21:38 [16:21:38.655] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 16:21:38 [16:21:38.679] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 16:21:38 [16:21:38.685] VERBOSE: e2e:e2e_cheat_codes Awaiting for linked libraries to be deployed 16:21:38 [16:21:38.739] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x13991160373287c6d3aceea35c95346a3ba73082e30f7a3c933ea91285203648 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 16:21:38 [16:21:38.746] 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} 16:21:38 [16:21:38.747] INFO: e2e:e2e_cheat_codes Waiting for 9 transactions to be mined... 16:21:38 [16:21:38.765] INFO: e2e:e2e_cheat_codes All transactions mined successfully 16:21:38 [16:21:38.765] VERBOSE: e2e:e2e_cheat_codes All core contracts have been deployed 16:21:38 [16:21:38.777] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 16:21:38 [16:21:38.777] VERBOSE: e2e:e2e_cheat_codes Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 16:21:38 [16:21:38.789] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 16:21:38 [16:21:38.794] VERBOSE: e2e:e2e_cheat_codes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 16:21:38 [16:21:38.829] VERBOSE: e2e:e2e_cheat_codes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 16:21:38 [16:21:38.830] VERBOSE: e2e:e2e_cheat_codes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 16:21:38 [16:21:38.830] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 16:21:38 [16:21:38.849] INFO: e2e:e2e_cheat_codes All transactions mined successfully 16:21:38 [16:21:38.860] VERBOSE: e2e:e2e_cheat_codes Rollup deployed 16:21:38 [16:21:38.860] VERBOSE: e2e:e2e_cheat_codes Waiting for rollup and slash factory to be deployed 16:21:38 [16:21:38.860] INFO: e2e:e2e_cheat_codes Waiting for 10 transactions to be mined... 16:21:38 [16:21:38.878] INFO: e2e:e2e_cheat_codes All transactions mined successfully 16:21:38 [16:21:38.878] VERBOSE: e2e:e2e_cheat_codes All transactions for L1 deployment have been mined 16:21:38 [16:21:38.892] 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"} 16:21:38 [16:21:38.897] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 16:21:38 [16:21:38.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:38 [16:21:38.921] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 16:21:38 [16:21:38.922] INFO: telemetry:client Using NoopTelemetryClient 16:21:38 [16:21:38.927] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:21:38 [16:21:38.927] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:21:38 [16:21:38.930] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/e5c47a157cc200b4/blob-sink with map size 134217728 KB (LMDB v2) 16:21:38 [16:21:38.930] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:38 [16:21:38.933] INFO: aztecjs:utils:watcher New L1 time: 1749831938 16:21:38 [16:21:38.933] WARN: foundation:test-date-provider Time set to 2025-06-13T16:25:38.000Z {"offset":239067,"timeMs":1749831938000} 16:21:38 [16:21:38.937] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:21:38 [16:21:38.946] INFO: blob-sink:server Server is running on http://localhost:36513 16:21:38 [16:21:38.946] VERBOSE: e2e:e2e_cheat_codes Creating and synching an aztec node... 16:21:38 [16:21:38.947] VERBOSE: e2e:e2e_cheat_codes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/0b2141da/acvm 16:21:38 [16:21:38.948] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36513"} 16:21:38 [16:21:38.965] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:21:38 [16:21:38.966] INFO: archiver:lmdb Creating archiver data store at directory /tmp/e5c47a157cc200b4/archiver with map size 134217728 KB (LMDB v2) 16:21:38 [16:21:38.967] INFO: archiver:lmdb Starting data store with maxReaders 16 16:21:39 [16:21:39.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:39 [16:21:39.313] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36513"} 16:21:39 [16:21:39.337] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36513"} 16:21:39 [16:21:39.337] WARN: node:blob-sink:client No L1 consensus host urls configured 16:21:39 [16:21:39.337] WARN: node:blob-sink:client No archive client configured 16:21:39 [16:21:39.340] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x7c3616a46888ff8d3a7ebde131e1d0eef87812fe51d55d218835144874b5eafd {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xbef26c31bd4985333e054890e906c41b54c3fb6105497e17bf370b061ea842f2","l1BlockNumber":16}} 16:21:39 [16:21:39.354] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x7c3616a46888ff8d3a7ebde131e1d0eef87812fe51d55d218835144874b5eafd","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:21:39 [16:21:39.362] INFO: world-state:database Creating world state data store at directory /tmp/e5c47a157cc200b4/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:21:39 [16:21:39.386] INFO: world_state Created world state synchroniser with block history of 64 16:21:39 [16:21:39.386] WARN: node Aztec node is accepting fake proofs 16:21:39 [16:21:39.397] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:39 [16:21:39.402] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/e5c47a157cc200b4/p2p with map size 134217728 KB (LMDB v2) 16:21:39 [16:21:39.410] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:21:39 [16:21:39.412] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/e5c47a157cc200b4/p2p-archive with map size 134217728 KB (LMDB v2) 16:21:39 [16:21:39.416] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:21:39 [16:21:39.418] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/e5c47a157cc200b4/p2p-peers with map size 134217728 KB (LMDB v2) 16:21:39 [16:21:39.420] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:21:39 [16:21:39.422] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:21:39 [16:21:39.423] VERBOSE: p2p P2P is disabled. Using dummy P2P service 16:21:39 [16:21:39.426] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:21:39 [16:21:39.426] INFO: world_state Started world state synchronizer from block 1 16:21:39 [16:21:39.429] VERBOSE: world-state:block_stream Starting sync from block number 0 16:21:39 [16:21:39.434] INFO: p2p Starting p2p client from block 0 with empty mempools 16:21:39 [16:21:39.435] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:21:39 [16:21:39.435] INFO: slasher Slasher client initialized 16:21:39 [16:21:39.435] INFO: slasher Starting Slasher client... 16:21:39 [16:21:39.466] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:39 [16:21:39.466] VERBOSE: node All Aztec Node subsystems synced 16:21:39 [16:21:39.474] INFO: sequencer-client Deploying forwarder contract 16:21:39 [16:21:39.478] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:21:39 [16:21:39.490] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 16:21:39 [16:21:39.490] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 16:21:39 [16:21:39.494] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:21:39 [16:21:39.507] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:39 [16:21:39.508] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 16:21:39 [16:21:39.508] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/0b2141da/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:21:39 [16:21:39.770] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:21:39 [16:21:39.772] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:39 [16:21:39.773] INFO: node Aztec Node version: 0.87.8 16:21:39 [16:21:39.774] 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"} 16:21:39 [16:21:39.775] VERBOSE: e2e:e2e_cheat_codes Creating a pxe... 16:21:39 [16:21:39.780] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:39 [16:21:39.786] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/3cfd7ebc056486d6/pxe_data with map size 134217728 KB (LMDB v2) 16:21:39 [16:21:39.797] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","blockNumber":1,"slot":2} 16:21:39 [16:21:39.798] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:21:39 [16:21:39.987] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:40 [16:21:40.109] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:21:40 [16:21:40.110] INFO: pxe:service Started PXE connected to chain 31337 version 4262014026 16:21:40 [16:21:40.177] INFO: pxe:service Registered account 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d 16:21:40 [16:21:40.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:40 [16:21:40.268] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 16:21:40 [16:21:40.269] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d 16:21:40 [16:21:40.320] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","blockNumber":1,"slot":2} 16:21:40 [16:21:40.421] INFO: pxe:service Added contract SchnorrAccount at 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:21:40 [16:21:40.465] VERBOSE: pxe:block_stream Starting sync from block number 0 16:21:40 [16:21:40.494] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:21:40 [16:21:40.545] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:40 [16:21:40.598] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:21:41 [16:21:41.390] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 16:21:41 [16:21:41.488] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:21:41 [16:21:41.558] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:41 [16:21:41.587] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","blockNumber":1,"slot":2} 16:21:41 [16:21:41.688] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:41 [16:21:41.732] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:41 [16:21:41.733] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:41 [16:21:41.770] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:41 [16:21:41.771] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:41 [16:21:41.779] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:41 [16:21:41.938] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:41 [16:21:41.979] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:41 [16:21:41.980] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:41 [16:21:41.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:42 [16:21:42.051] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:42 [16:21:42.054] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:42 [16:21:42.075] VERBOSE: simulator:client_execution_context:debug_log Setting 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d as fee payer 16:21:42 [16:21:42.156] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","blockNumber":1,"slot":2} 16:21:42 [16:21:42.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:42 [16:21:42.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:42 [16:21:42.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:42 [16:21:42.855] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","blockNumber":1,"slot":2} 16:21:43 [16:21:43.217] INFO: pxe:service Proving completed in 2753.5656010000002ms {"timings":{"total":2753.5656010000002,"sync":2.548516999999265,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":155.85425300000315,"oracles":{"callPrivateFunction":{"times":[1003.6543180000008,321.8508009999987,221.01409799999965]}}},{"functionName":"private_kernel_init","time":94.32864300000074},{"functionName":"ContractClassRegisterer:register","time":986.6221199999982,"oracles":{"loadCapsule":{"times":[32.819923999999446]},"notifyCreatedNullifier":{"times":[32.95067799999924]},"debugLog":{"times":[1.300413999999364]},"notifyCreatedContractClassLog":{"times":[7.173748999999589]}}},{"functionName":"private_kernel_inner","time":152.1813659999989},{"functionName":"SchnorrAccount:constructor","time":288.9848170000005,"oracles":{"getContractInstance":{"times":[1.235913000000437]},"debugLog":{"times":[0.5630550000005314,0.5135629999986122]},"fetchTaggedLogs":{"times":[44.49731100000099]},"loadCapsule":{"times":[0.4276509999999689,0.32508899999993446,0.27588700000160316]},"notifyCreatedNullifier":{"times":[0.24916699999994307,0.2680270000000746]},"notifyCreatedNote":{"times":[0.43179199999940465]},"getRandomField":{"times":[0.21967600000061793,0.1811649999999645,0.04925100000036764,0.03986100000111037,0.0564410000006319,0.0578109999987646,0.0916030000007595,0.041931000001568464,0.04461100000116858,0.08015199999863398,0.05328100000042468]},"getIndexedTaggingSecretAsSender":{"times":[33.57038300000022]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.56711499999983]}}},{"functionName":"private_kernel_inner","time":128.60131600000022},{"functionName":"SchnorrAccount:entrypoint","time":197.72215499999947,"oracles":{"debugLog":{"times":[1.3954259999991336,0.445901999999478,0.9282050000001618]},"fetchTaggedLogs":{"times":[72.59757100000024]},"loadCapsule":{"times":[0.23253599999952712,0.27395699999942735,0.2654870000005758]},"getNotes":{"times":[2.1091960000012477]},"getAuthWitness":{"times":[0.5108540000001085]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0861580000000686]}}},{"functionName":"private_kernel_inner","time":125.16365500000029},{"functionName":"private_kernel_reset","time":155.36937000000034},{"functionName":"private_kernel_tail","time":71.26653599999918}],"unaccounted":394.92285300000003}} 16:21:43 [16:21:43.233] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:43 [16:21:43.383] VERBOSE: p2p:tx_pool Adding tx 0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999 to pool {"eventName":"tx-added-to-pool","txHash":"0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:21:43 [16:21:43.402] INFO: node Received tx 0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999 {"txHash":"0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999"} 16:21:43 [16:21:43.403] INFO: pxe:service Sent transaction 0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999 16:21:43 [16:21:43.416] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 16:21:43 [16:21:43.434] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T16:26:02.000Z","now":"2025-06-13T16:25:42.501Z"} 16:21:43 [16:21:43.452] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:43 [16:21:43.702] VERBOSE: simulator:public-processor Processed tx 0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999 with no public calls in 189.73645399999987ms {"txHash":"0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999","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":189.73645399999987} 16:21:43 [16:21:43.712] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:43 [16:21:43.714] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.27812511099999937s {"duration":0.27812511099999937,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 16:21:43 [16:21:43.874] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1208c212bfc07cd1b3c6c4d2ec4a97a36bd8d65dd661acd1faf99cc5e37968d3","globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":1,"slotNumber":2,"timestamp":1749831962,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2831483467da4cf000f1c516cd516ca4019b7fc1fcf4b60ab6732a48d50d7999"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":458.54505000000063,"publicProcessDuration":279.24028999999973,"rollupCircuitsDuration":441.80977899999925,"txCount":1,"blockNumber":1,"blockTimestamp":1749831962,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:21:43 [16:21:43.877] VERBOSE: sequencer Attesting committee is empty 16:21:43 [16:21:43.972] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:44 [16:21:44.252] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:44 [16:21:44.260] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x292792dc53b32b90f352b4aecc083eb2b80e71899dcc30e0754b636f93595cd7 16:21:44 [16:21:44.260] VERBOSE: sequencer-client Sent L1 transaction 0x292792dc53b32b90f352b4aecc083eb2b80e71899dcc30e0754b636f93595cd7 {"gasLimit":514521,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 16:21:44 [16:21:44.274] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:21:44 [16:21:44.275] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x292792dc53b32b90f352b4aecc083eb2b80e71899dcc30e0754b636f93595cd7","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1749831962,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:21:44 [16:21:44.276] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:21:44 [16:21:44.298] INFO: blob-sink:server Received blob sidecar for block 0x52cb75e095b278218a16707938ce56906e98b2e2c190b4f65f66c4f28d451df6 16:21:44 [16:21:44.305] INFO: blob-sink:server Blob sidecar stored successfully for block 0x52cb75e095b278218a16707938ce56906e98b2e2c190b4f65f66c4f28d451df6 16:21:44 [16:21:44.442] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:21:44 [16:21:44.447] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1208c212bfc07cd1b3c6c4d2ec4a97a36bd8d65dd661acd1faf99cc5e37968d3","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":1,"slotNumber":2,"timestamp":1749831962,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","archiveNextLeafIndex":2} 16:21:44 [16:21:44.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:44 [16:21:44.463] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 16:21:44 [16:21:44.465] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:21:44 [16:21:44.467] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:21:44 [16:21:44.478] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749831998] on http://127.0.0.1:8545 16:21:44 [16:21:44.480] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:44 [16:21:44.481] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749831998 16:21:44 [16:21:44.481] WARN: foundation:test-date-provider Time set to 2025-06-13T16:26:38.000Z {"offset":293519,"timeMs":1749831998000} 16:21:44 [16:21:44.481] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:21:44 [16:21:44.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:44 [16:21:44.911] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":373.07548099999985,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749831962,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:21:44 [16:21:44.912] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 16:21:44 [16:21:44.916] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e 16:21:45 [16:21:45.126] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:45 [16:21:45.245] VERBOSE: p2p Synched to latest block 1 16:21:45 [16:21:45.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:45 [16:21:45.595] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:21:45 [16:21:45.618] INFO: pxe:service Added contract Token at 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 16:21:45 [16:21:45.669] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","blockNumber":2,"slot":3} 16:21:45 [16:21:45.676] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","header":{"contentCommitment":{"blobsHash":"0x00653425da564ccc70ebfd428a9f4331fa6bfa83af9bc8b8ce25b58aeea866ac","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749831962,"version":4262014026},"lastArchive":"0x2a039ed26e4a522c04c36c9dc974b3d35690b28970d29bdd2aed3542b6b4cb73","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1835999c8cd84b94c1696175748c9501eba5d7f421c97a01cc652d9daf55b378","nullifierTree":"0x2c7a3b4a7a88ce429f4a3ccced98643fd46189f88795514331a08bd08d489143","publicDataTree":"0x08e65135f9593984a4dcbb15f3eb410a6bbd633d6cfe7a31613545312570e132"},"totalFees":6794052480,"totalManaUsed":20448}} 16:21:45 [16:21:45.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:45 [16:21:45.849] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:45 [16:21:45.886] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:45 [16:21:45.887] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:45 [16:21:45.969] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:45 [16:21:45.976] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0f618df6c9b20842ed5c33f1765e2e8e86596f83b561b1b2b57a4e9e0e0d5342 16:21:45 [16:21:45.992] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:21:45 [16:21:45.993] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:21:46 [16:21:46.005] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:21:46 [16:21:46.006] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:21:46 [16:21:46.013] VERBOSE: pxe:service Added note {"index":0,"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1c0c4d3e580dc94ae1811a0b09699e3fba1bf3317314f8fdd16a7bba752a2e7d","nullifier":"0x01faf6c7e664333f1ab73e96ee14036404e491d98737951ec03e1e4eb4314538"} 16:21:46 [16:21:46.016] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:46 [16:21:46.031] VERBOSE: simulator:client_execution_context:debug_log Setting 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d as fee payer 16:21:46 [16:21:46.093] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:21:46 [16:21:46.623] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 16:21:46 [16:21:46.767] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:21:46 [16:21:46.853] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:46 [16:21:46.970] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:21:47 [16:21:47.003] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","blockNumber":2,"slot":3} 16:21:47 [16:21:47.048] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:21:47 [16:21:47.063] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e,0x0000000000000000000000000000000000000000000000000000000000000001,0x055a4b032bbd31a1f409b91b579d528d2b8bd1bee54d0168f61cccbc1f1e6631,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x2a3392f3904fe5e5cb0b457992f5f7770e4cebbbf49c1dc6ee09d54e53839375,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d 16:21:47 [16:21:47.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:47 [16:21:47.396] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:47 [16:21:47.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:47 [16:21:47.867] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","blockNumber":2,"slot":3} 16:21:47 [16:21:47.869] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:48 [16:21:48.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:48 [16:21:48.396] INFO: pxe:service Proving completed in 2742.3591159999996ms {"timings":{"total":2742.3591159999996,"sync":24.348771000000852,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":382.644121000003,"oracles":{"debugLog":{"times":[0.5988059999999678,0.6536669999986771,0.5547240000014426,0.476423000000068,0.7191779999993742,0.49694300000192015,0.4656230000000505,0.561703999999736]},"fetchTaggedLogs":{"times":[84.85336400000051]},"loadCapsule":{"times":[0.30086799999844516,1.4659279999978025,0.876232999999047,0.3652800000018033,0.3020880000003672,0.27752700000201]},"getSharedSecret":{"times":[6.347737000000052]},"aes128Decrypt":{"times":[1.2940840000010212,0.8538120000011986]},"getPublicKeysAndPartialAddress":{"times":[3.346008000000438]},"getKeyValidationRequest":{"times":[4.720634000001155]},"deliverNote":{"times":[6.895841000001383]},"deleteCapsule":{"times":[0.591244999999617]},"storeCapsule":{"times":[0.5261239999999816]},"getNotes":{"times":[2.487176000002364]},"getAuthWitness":{"times":[0.2622669999982463]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05526100000133738]},"callPrivateFunction":{"times":[818.0633430000016,219.97144000000117]},"notifyEnqueuedPublicFunctionCall":{"times":[0.5061740000019199]}}},{"functionName":"private_kernel_init","time":68.80451099999846},{"functionName":"ContractClassRegisterer:register","time":793.7977449999962,"oracles":{"loadCapsule":{"times":[5.132125000000087]},"notifyCreatedNullifier":{"times":[0.616915999999037]},"debugLog":{"times":[0.9692759999998088]},"notifyCreatedContractClassLog":{"times":[25.322926999997435]}}},{"functionName":"private_kernel_inner","time":188.33969699999943},{"functionName":"ContractInstanceDeployer:deploy","time":127.23369900000398,"oracles":{"storeInExecutionCache":{"times":[0.32921799999894574]},"callPrivateFunction":{"times":[79.97281500000099]},"notifyCreatedNullifier":{"times":[0.44848199999978533]},"debugLog":{"times":[0.9253640000024461]}}},{"functionName":"private_kernel_inner","time":123.63288399999874},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":62.240318999996816,"oracles":{}},{"functionName":"private_kernel_inner","time":151.27017200000046},{"functionName":"private_kernel_reset","time":194.86783899999864},{"functionName":"private_kernel_tail","time":96.7194759999984}],"unaccounted":528.4598820000047}} 16:21:48 [16:21:48.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:48 [16:21:48.702] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","blockNumber":2,"slot":3} 16:21:48 [16:21:48.722] VERBOSE: p2p:tx_pool Adding tx 0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25 to pool {"eventName":"tx-added-to-pool","txHash":"0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 16:21:48 [16:21:48.748] INFO: node Received tx 0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25 {"txHash":"0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25"} 16:21:48 [16:21:48.748] INFO: pxe:service Sent transaction 0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25 16:21:48 [16:21:48.905] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:49 [16:21:49.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:49 [16:21:49.252] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 16:21:49 [16:21:49.276] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T16:26:38.000Z","now":"2025-06-13T16:26:42.795Z"} 16:21:49 [16:21:49.509] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:49 [16:21:49.735] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:49 [16:21:49.939] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:50 [16:21:50.092] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":359.5037830000001} 16:21:50 [16:21:50.262] VERBOSE: simulator:public-processor Processed tx 0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25 with 1 public calls in 720.8899459999993ms {"txHash":"0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25","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":720.8899459999993} 16:21:50 [16:21:50.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:50 [16:21:50.266] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.9882282919999997s {"duration":0.9882282919999997,"rate":386379.3448245055,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 16:21:50 [16:21:50.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:50 [16:21:50.476] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 311754.8407372813 mana/s {"blockHash":"0x2f94129da2486ffdcbdf4d3d18f70b7ed85c6f2b185287d6159078191054316d","globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":2,"slotNumber":3,"timestamp":1749831998,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0c77ae8cd52aeedf1ac3d0b853c3de2c4e622de59bd957ae9b662a0f19e55c25"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1223.9825679999994,"publicProcessDuration":988.5782720000025,"rollupCircuitsDuration":1202.4378509999988,"txCount":1,"blockNumber":2,"blockTimestamp":1749831998,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:21:50 [16:21:50.483] VERBOSE: sequencer Attesting committee is empty 16:21:50 [16:21:50.676] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:50 [16:21:50.818] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8d0d208f2b740da9ad9f1fcc1ac574fc7aa06e73cf7ab8522ea5e78a360a4078 16:21:50 [16:21:50.819] VERBOSE: sequencer-client Sent L1 transaction 0x8d0d208f2b740da9ad9f1fcc1ac574fc7aa06e73cf7ab8522ea5e78a360a4078 {"gasLimit":470220,"maxFeePerGas":"1.303611186","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:21:50 [16:21:50.828] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:21:50 [16:21:50.828] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8d0d208f2b740da9ad9f1fcc1ac574fc7aa06e73cf7ab8522ea5e78a360a4078","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749831998,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:21:50 [16:21:50.829] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:21:50 [16:21:50.834] INFO: blob-sink:server Received blob sidecar for block 0x5e2ea5130dfc6c63c4611173426ddd6b2f1ad13827f2265f1b5121fdb7832d5a 16:21:50 [16:21:50.838] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5e2ea5130dfc6c63c4611173426ddd6b2f1ad13827f2265f1b5121fdb7832d5a 16:21:50 [16:21:50.851] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832034] on http://127.0.0.1:8545 16:21:50 [16:21:50.852] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:50 [16:21:50.853] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832034 16:21:50 [16:21:50.853] WARN: foundation:test-date-provider Time set to 2025-06-13T16:27:14.000Z {"offset":323147,"timeMs":1749832034000} 16:21:50 [16:21:50.853] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:21:50 [16:21:50.879] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:51 [16:21:51.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:51 [16:21:51.347] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:51 [16:21:51.386] VERBOSE: archiver:block-helper Store contract instance at 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e 16:21:51 [16:21:51.423] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 16:21:51 [16:21:51.490] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2f94129da2486ffdcbdf4d3d18f70b7ed85c6f2b185287d6159078191054316d","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":2,"slotNumber":3,"timestamp":1749831998,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","archiveNextLeafIndex":3} 16:21:51 [16:21:51.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:51 [16:21:51.619] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":10.273920999999973,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749831998,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:21:51 [16:21:51.635] VERBOSE: p2p Synched to latest block 2 16:21:51 [16:21:51.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.080] INFO: aztecjs:deploy_sent_tx Contract 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e successfully deployed. 16:21:52 [16:21:52.081] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public 16:21:52 [16:21:52.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.102] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load public returns 0 for non existent value 16:21:52 [16:21:52.115] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private works as expected for no notes 16:21:52 [16:21:52.136] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes load private 16:21:52 [16:21:52.153] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","blockNumber":3,"slot":4} 16:21:52 [16:21:52.353] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.388] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","header":{"contentCommitment":{"blobsHash":"0x00ce5c085b03030be314ac9da4b00b194077b7a80e2d9b6c7f9980eae4b3a784","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749831998,"version":4262014026},"lastArchive":"0x14ec57b545dfece71917d3a175afc114741dda5372956ac4635bccc7ba02b10c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1835999c8cd84b94c1696175748c9501eba5d7f421c97a01cc652d9daf55b378","nullifierTree":"0x136f553fecb191859c23cbb6fbe5d2c094707c869857c82dc9a689e1ca8bc100","publicDataTree":"0x0d35954d84cee1d58085d8c432184342d60c5fe3a721e750168748eb242e8f11"},"totalFees":139009277500,"totalManaUsed":418375}} 16:21:52 [16:21:52.543] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:52 [16:21:52.587] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:52 [16:21:52.588] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:52 [16:21:52.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.688] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d"} 16:21:52 [16:21:52.695] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","blockNumber":3,"slot":4} 16:21:52 [16:21:52.702] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0f618df6c9b20842ed5c33f1765e2e8e86596f83b561b1b2b57a4e9e0e0d5342 16:21:52 [16:21:52.714] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:21:52 [16:21:52.715] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:21:52 [16:21:52.743] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:21:52 [16:21:52.744] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:21:52 [16:21:52.753] VERBOSE: pxe:service Added note {"index":0,"contract":"0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1c0c4d3e580dc94ae1811a0b09699e3fba1bf3317314f8fdd16a7bba752a2e7d","nullifier":"0x01faf6c7e664333f1ab73e96ee14036404e491d98737951ec03e1e4eb4314538"} 16:21:52 [16:21:52.759] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:52 [16:21:52.775] VERBOSE: simulator:client_execution_context:debug_log Setting 0x19e9ab560dc762a1ad96ca9e09d1b7a055457897ef30f3179396863f691bca9d as fee payer 16:21:52 [16:21:52.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.575] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e"} 16:21:53 [16:21:53.647] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:53 [16:21:53.648] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e"} 16:21:53 [16:21:53.845] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","blockNumber":3,"slot":4} 16:21:53 [16:21:53.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.876] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e"} 16:21:53 [16:21:53.881] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:54 [16:21:54.226] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.456] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.585] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","blockNumber":3,"slot":4} 16:21:54 [16:21:54.769] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.995] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:55 [16:21:55.433] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:55 [16:21:55.691] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:55 [16:21:55.722] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","blockNumber":3,"slot":4} 16:21:56 [16:21:56.049] INFO: pxe:service Proving completed in 3671.8780479999987ms {"timings":{"total":3671.8780479999987,"sync":13.32426100000157,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":630.9286380000012,"oracles":{"debugLog":{"times":[0.5237940000006347,0.4087500000023283,0.5970760000018345,0.6803680000011809,0.5788659999998345,0.5025830000013229,0.5909449999999197,0.509143999999651]},"fetchTaggedLogs":{"times":[112.72155700000076]},"loadCapsule":{"times":[0.37903000000005704,0.33563800000047195,0.45881200000076205,2.079215000001568,0.48198300000149175,0.3523200000017823]},"getSharedSecret":{"times":[4.1114290000004985]},"aes128Decrypt":{"times":[0.2780370000000403,1.1576700000005076]},"getPublicKeysAndPartialAddress":{"times":[6.807608999999502]},"getKeyValidationRequest":{"times":[16.95431599999938]},"deliverNote":{"times":[9.234653000003163]},"deleteCapsule":{"times":[0.4308520000013232]},"storeCapsule":{"times":[0.9535049999976764]},"getNotes":{"times":[3.4937020000033954]},"getAuthWitness":{"times":[0.2854669999978796]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05997099999876809]},"callPrivateFunction":{"times":[1521.2019010000004]}}},{"functionName":"private_kernel_init","time":93.46434000000227},{"functionName":"Token:mint_to_private","time":1248.332359,"oracles":{"debugLog":{"times":[0.9309849999990547,0.32610900000145193]},"fetchTaggedLogs":{"times":[231.67412799999875]},"loadCapsule":{"times":[0.23018600000068545,0.24096699999790872,0.25917699999990873]},"getRandomField":{"times":[0.17673499999727937,0.1689250000017637,0.18765500000154134,0.0867820000021311,0.046440999998594634,0.040730999997322215,0.07169199999771081,0.04233100000055856,0.03615200000058394,0.06742099999974016,0.06111199999941164,0.09539299999960349]},"getIndexedTaggingSecretAsSender":{"times":[117.58352500000183]},"incrementAppTaggingSecretIndexAsSender":{"times":[249.5064569999995]},"notifyCreatedNullifier":{"times":[0.36027000000103726]},"storeInExecutionCache":{"times":[0.06792200000199955]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09197199999834993]}}},{"functionName":"private_kernel_inner","time":180.21347999999853},{"functionName":"private_kernel_reset","time":253.02697099999932},{"functionName":"private_kernel_tail","time":107.57736400000067}],"unaccounted":1145.010634999995}} 16:21:56 [16:21:56.097] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:56 [16:21:56.138] VERBOSE: p2p:tx_pool Adding tx 0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda to pool {"eventName":"tx-added-to-pool","txHash":"0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 16:21:56 [16:21:56.155] INFO: node Received tx 0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda {"txHash":"0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda"} 16:21:56 [16:21:56.155] INFO: pxe:service Sent transaction 0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda 16:21:56 [16:21:56.305] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 16:21:56 [16:21:56.316] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:56 [16:21:56.343] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T16:27:14.000Z","now":"2025-06-13T16:27:19.490Z"} 16:21:56 [16:21:56.504] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":99.41867700000148} 16:21:56 [16:21:56.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:56 [16:21:56.559] VERBOSE: simulator:public-processor Processed tx 0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda with 1 public calls in 195.72153099999923ms {"txHash":"0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda","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":195.72153099999923} 16:21:56 [16:21:56.561] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2175990520000014s {"duration":0.2175990520000014,"rate":195290.372864307,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 16:21:56 [16:21:56.709] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 104254.2346833651 mana/s {"blockHash":"0x1a8b01dd9fd8906fd5b8c13d6059c975d82661a8b6465feea1b8e1492288ad7f","globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":3,"slotNumber":4,"timestamp":1749832034,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1a70cdf034497b8b5fac4cb2748f50df06d8ab0f3b226ba4037a45876eb19bda"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":401.34250600000087,"publicProcessDuration":218.02129200000127,"rollupCircuitsDuration":364.3499240000019,"txCount":1,"blockNumber":3,"blockTimestamp":1749832034,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 16:21:56 [16:21:56.715] VERBOSE: sequencer Attesting committee is empty 16:21:56 [16:21:56.837] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.125] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x1429b048985b9072d95c6e47effa839bea7866ebdae485c9ee1b32debc20679c 16:21:57 [16:21:57.125] VERBOSE: sequencer-client Sent L1 transaction 0x1429b048985b9072d95c6e47effa839bea7866ebdae485c9ee1b32debc20679c {"gasLimit":478987,"maxFeePerGas":"1.279583374","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:21:57 [16:21:57.142] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:21:57 [16:21:57.142] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x1429b048985b9072d95c6e47effa839bea7866ebdae485c9ee1b32debc20679c","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1749832034,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 16:21:57 [16:21:57.143] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:21:57 [16:21:57.153] INFO: blob-sink:server Received blob sidecar for block 0x2e20ac8bc5ef071e0613706c5792f5a3f902d282b67cbbadda2e5d1f3736022a 16:21:57 [16:21:57.161] INFO: blob-sink:server Blob sidecar stored successfully for block 0x2e20ac8bc5ef071e0613706c5792f5a3f902d282b67cbbadda2e5d1f3736022a 16:21:57 [16:21:57.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.346] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832070] on http://127.0.0.1:8545 16:21:57 [16:21:57.348] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:21:57 [16:21:57.350] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832070 16:21:57 [16:21:57.351] WARN: foundation:test-date-provider Time set to 2025-06-13T16:27:50.000Z {"offset":352650,"timeMs":1749832070000} 16:21:57 [16:21:57.352] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:21:57 [16:21:57.577] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.595] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1a8b01dd9fd8906fd5b8c13d6059c975d82661a8b6465feea1b8e1492288ad7f","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":4262014026,"blockNumber":3,"slotNumber":4,"timestamp":1749832034,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x04e2e24edda3535e7ce10f5110f921e2b7f5f00620153eb17a7581fc4d7354aa","archiveNextLeafIndex":4} 16:21:57 [16:21:57.718] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":23.153943999997864,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749832034,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 16:21:57 [16:21:57.726] VERBOSE: p2p Synched to latest block 3 16:21:57 [16:21:57.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.992] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:58 [16:21:58.173] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x04e2e24edda3535e7ce10f5110f921e2b7f5f00620153eb17a7581fc4d7354aa","blockNumber":4,"slot":5} 16:21:58 [16:21:58.178] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x04e2e24edda3535e7ce10f5110f921e2b7f5f00620153eb17a7581fc4d7354aa","header":{"contentCommitment":{"blobsHash":"0x00da0208e8e7703fab6d4efba615c1580d5f404f967b53e05880d053855aaca9","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749832034,"version":4262014026},"lastArchive":"0x26a072da80e2015d154b62a501002ec0bde241cb888cb555310f3ba8bab4b603","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f22c080049ec90ecd7958f7eeb025f318746ddf6cb5fa6941e38a144eb575ff","nullifierTree":"0x1c7c8a4fbbc96978531128a5704f2ea1ba8b1492e413fd6cce7f9afdd8148acb","publicDataTree":"0x2868a62e4b1f495695bcdd95edba638bdf27bfc095238cf76bc6453520404f9c"},"totalFees":24485900700,"totalManaUsed":73695}} 16:21:58 [16:21:58.554] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:58 [16:21:58.837] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e","selector":"0xc6cedc33"} 16:21:58 [16:21:58.849] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:58 [16:21:58.855] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 16:21:58 [16:21:58.855] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e"} 16:21:58 [16:21:58.964] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x04e2e24edda3535e7ce10f5110f921e2b7f5f00620153eb17a7581fc4d7354aa","blockNumber":4,"slot":5} 16:21:58 [16:21:58.996] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e"} 16:21:59 [16:21:59.001] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x162420b1ca39943bb643c6ae2d1e045f8ef95a4087f312654207653651b69543 16:21:59 [16:21:59.014] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 16:21:59 [16:21:59.017] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 16:21:59 [16:21:59.021] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x2be727b15ed29f4ac160d0beff58c3ec95a9879aaae893729d1476ce69c3b05c 16:21:59 [16:21:59.023] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e for storage slot 0x183d93976539c30d864e338566a6c2af3167a501ed6d7d13010e393c4870080d 16:21:59 [16:21:59.029] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:21:59 [16:21:59.030] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x2be727b15ed29f4ac160d0beff58c3ec95a9879aaae893729d1476ce69c3b05c 16:21:59 [16:21:59.037] VERBOSE: pxe:service Added note {"index":128,"contract":"0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e","slot":"0x183d93976539c30d864e338566a6c2af3167a501ed6d7d13010e393c4870080d","noteHash":"0x20de97a1b7158312678b122ba00cc7354d6b119090dcf1726ee68a8b2e2b4e04","nullifier":"0x236f9795d4e6eb61ef7074bd0f353b842330b94e37c752487fad45ea91975c70"} 16:21:59 [16:21:59.039] VERBOSE: simulator Utility simulation for 0x28200b693c92ac4c9bb27ce71d50b8cb632cba6d06b21d7f37361b68cc84cd5e.0xc6cedc33 completed 16:21:59 [16:21:59.043] INFO: e2e:e2e_cheat_codes Running test: e2e_cheat_codes L2 cheatcodes markAsProven 16:21:59 [16:21:59.051] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 16:21:59 [16:21:59.052] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:21:59 [16:21:59.053] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 3. Pending tip: 3. 16:21:59 [16:21:59.057] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:59 [16:21:59.059] INFO: node Stopping 16:21:59 [16:21:59.060] INFO: slasher Slasher client stopped. 16:21:59 [16:21:59.060] INFO: sequencer Stopped sequencer 16:21:59 [16:21:59.061] INFO: p2p P2P client stopped. 16:21:59 [16:21:59.063] INFO: world_state Stopped world state synchronizer 16:21:59 [16:21:59.063] INFO: archiver Stopped. 16:21:59 [16:21:59.064] INFO: node Stopped 16:21:59 [16:21:59.064] VERBOSE: e2e:e2e_cheat_codes Cleaning up ACVM state 16:21:59 [16:21:59.064] INFO: e2e:e2e_cheat_codes Cleaning up ACVM temp directory /tmp/0b2141da 16:21:59 [16:21:59.065] VERBOSE: e2e:e2e_cheat_codes Cleaning up BB state 16:21:59 [16:21:59.068] INFO: blob-sink:server Stopping blob sink 16:21:59 [16:21:59.069] INFO: blob-sink:server Blob sink stopped 16:21:59 [16:21:59.069] VERBOSE: e2e:e2e_cheat_codes Cleaning up data directory at /tmp/e5c47a157cc200b4 16:21:59 PASS src/e2e_cheat_codes.test.ts 16:21:59 e2e_cheat_codes 16:21:59 L1 cheatcodes 16:21:59 ✓ setNextBlockTimestamp by 100 (102 ms) 16:21:59 ✓ setNextBlockTimestamp by 42 (103 ms) 16:21:59 ✓ setNextBlockTimestamp by 99 (105 ms) 16:21:59 ✓ setNextBlockTimestamp to a past timestamp throws (100 ms) 16:21:59 ✓ load a value at a particular storage slot (83 ms) 16:21:59 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (123 ms) 16:21:59 ✓ store a value at a given slot and its keccak value of the slot (if it were in a map) (111 ms) 16:21:59 ✓ set bytecode correctly (100 ms) 16:21:59 ✓ impersonate (156 ms) 16:21:59 mine 16:21:59 ✓ mine block (372 ms) 16:21:59 ✓ mine 10 blocks (169 ms) 16:21:59 ✓ mine 42 blocks (114 ms) 16:21:59 ✓ mine 99 blocks (114 ms) 16:21:59 L2 cheatcodes 16:21:59 ✓ load public (20 ms) 16:21:59 ✓ load public returns 0 for non existent value (14 ms) 16:21:59 ✓ load private works as expected for no notes (20 ms) 16:21:59 ✓ load private (6907 ms) 16:21:59 ✓ markAsProven (12 ms) 16:21:59 16:21:59 Test Suites: 1 passed, 1 total 16:21:59 Tests: 18 passed, 18 total 16:21:59 Snapshots: 0 total 16:21:59 Time: 29.111 s 16:21:59 Ran all test suites matching /src\/e2e_cheat_codes.test.ts/i. 16:21:59 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?