Parent Log: http://ci.aztec-labs.com/bac80ed53a95468a Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_partial_notes yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_partial_notes.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:08:38 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_6b4a73ce992ff502_master 17:08:38 +++ id -u 17:08:38 +++ id -g 17:08:38 ++ docker run -d --name e2e_partial_notes --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_partial_notes.test.ts'\''' 17:08:38 + cid=7d9a4b634e35de47865fc984f76f6e9400512120160e63df317b80075ea3144c 17:08:38 + set +x 17:08:39 {"level":25,"time":1749834519171,"pid":12,"hostname":"7d9a4b634e35","module":"logger","msg":"Logger initialized with level verbose"} 17:08:45 [17:08:45.761] INFO: e2e:e2e_partial_notes Logging metrics to log/unknown.jsonl 17:08:46 [17:08:46.086] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-C7N7Mi/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:08:46 [17:08:46.140] INFO: e2e:e2e_partial_notes Calling anvil_setBlockTimestampInterval with params: [12] 17:08:46 [17:08:46.178] WARN: e2e:e2e_partial_notes Set block interval to 12 17:08:46 [17:08:46.179] VERBOSE: e2e:e2e_partial_notes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:46 [17:08:46.281] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:08:46 [17:08:46.307] VERBOSE: e2e:e2e_partial_notes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:08:46 [17:08:46.338] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:08:46 [17:08:46.348] VERBOSE: e2e:e2e_partial_notes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:08:46 [17:08:46.381] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:08:46 [17:08:46.392] VERBOSE: e2e:e2e_partial_notes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:08:46 [17:08:46.412] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:08:46 [17:08:46.419] VERBOSE: e2e:e2e_partial_notes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:08:46 [17:08:46.449] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:08:46 [17:08:46.462] VERBOSE: e2e:e2e_partial_notes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:08:46 [17:08:46.480] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:08:46 [17:08:46.486] VERBOSE: e2e:e2e_partial_notes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:08:46 [17:08:46.487] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 17:08:46 [17:08:46.488] INFO: e2e:e2e_partial_notes Waiting for 6 transactions to be mined... 17:08:46 [17:08:46.510] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:08:46 [17:08:46.526] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:08:46 [17:08:46.527] VERBOSE: e2e:e2e_partial_notes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:08:46 [17:08:46.548] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:08:46 [17:08:46.566] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:08:46 [17:08:46.580] VERBOSE: e2e:e2e_partial_notes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:08:46 [17:08:46.596] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:08:46 [17:08:46.597] VERBOSE: e2e:e2e_partial_notes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:08:46 [17:08:46.623] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:08:46 [17:08:46.638] VERBOSE: e2e:e2e_partial_notes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:08:46 [17:08:46.664] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:08:46 [17:08:46.664] VERBOSE: e2e:e2e_partial_notes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:08:46 [17:08:46.664] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 17:08:46 [17:08:46.665] INFO: e2e:e2e_partial_notes Waiting for 8 transactions to be mined... 17:08:46 [17:08:46.684] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:08:46 [17:08:46.699] VERBOSE: e2e:e2e_partial_notes Deployed shared contracts 17:08:46 [17:08:46.731] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:08:46 [17:08:46.732] VERBOSE: e2e:e2e_partial_notes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:08:46 [17:08:46.740] VERBOSE: e2e:e2e_partial_notes Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:46 [17:08:46.758] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:08:46 [17:08:46.801] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:08:46 [17:08:46.809] VERBOSE: e2e:e2e_partial_notes Awaiting for linked libraries to be deployed 17:08:46 [17:08:46.868] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf64aa66b82dc0235654cbb5066daf165511e7e639fdaf837edaee66e404fa57e {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:08:46 [17:08:46.874] VERBOSE: e2e:e2e_partial_notes Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:46 [17:08:46.875] INFO: e2e:e2e_partial_notes Waiting for 9 transactions to be mined... 17:08:46 [17:08:46.897] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:08:46 [17:08:46.897] VERBOSE: e2e:e2e_partial_notes All core contracts have been deployed 17:08:46 [17:08:46.911] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:08:46 [17:08:46.912] VERBOSE: e2e:e2e_partial_notes Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 17:08:46 [17:08:46.930] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 17:08:46 [17:08:46.941] VERBOSE: e2e:e2e_partial_notes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:08:46 [17:08:46.972] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 17:08:46 [17:08:46.972] VERBOSE: e2e:e2e_partial_notes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 17:08:46 [17:08:46.973] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 17:08:47 [17:08:47.012] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:08:47 [17:08:47.021] VERBOSE: e2e:e2e_partial_notes Rollup deployed 17:08:47 [17:08:47.022] VERBOSE: e2e:e2e_partial_notes Waiting for rollup and slash factory to be deployed 17:08:47 [17:08:47.022] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 17:08:47 [17:08:47.053] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:08:47 [17:08:47.054] VERBOSE: e2e:e2e_partial_notes All transactions for L1 deployment have been mined 17:08:47 [17:08:47.082] INFO: e2e:e2e_partial_notes Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:08:47 [17:08:47.086] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:08:47 [17:08:47.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.095] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:08:47 [17:08:47.097] INFO: telemetry:client Using NoopTelemetryClient 17:08:47 [17:08:47.107] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:08:47 [17:08:47.107] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:08:47 [17:08:47.108] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/e156c5764cf5b3d6/blob-sink with map size 134217728 KB (LMDB v2) 17:08:47 [17:08:47.110] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.112] INFO: aztecjs:utils:watcher New L1 time: 1749834765 17:08:47 [17:08:47.112] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:45.000Z {"offset":237888,"timeMs":1749834765000} 17:08:47 [17:08:47.114] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:08:47 [17:08:47.120] INFO: blob-sink:server Server is running on http://localhost:33075 17:08:47 [17:08:47.120] VERBOSE: e2e:e2e_partial_notes Creating and synching an aztec node... 17:08:47 [17:08:47.121] VERBOSE: e2e:e2e_partial_notes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/a919254d/acvm 17:08:47 [17:08:47.122] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33075"} 17:08:47 [17:08:47.150] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:08:47 [17:08:47.152] INFO: archiver:lmdb Creating archiver data store at directory /tmp/e156c5764cf5b3d6/archiver with map size 134217728 KB (LMDB v2) 17:08:47 [17:08:47.161] INFO: archiver:lmdb Starting data store with maxReaders 16 17:08:47 [17:08:47.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.503] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33075"} 17:08:47 [17:08:47.531] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33075"} 17:08:47 [17:08:47.532] WARN: node:blob-sink:client No L1 consensus host urls configured 17:08:47 [17:08:47.532] WARN: node:blob-sink:client No archive client configured 17:08:47 [17:08:47.536] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x3b82ed0d350a5e6a0aa127cb3b3767afc4ac2b33e25510cb327cf75888e19676 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x63b6014eb4c67ff9e6f9559edf2b45646f8c2678a292fab8846552284609e800","l1BlockNumber":16}} 17:08:47 [17:08:47.561] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x3b82ed0d350a5e6a0aa127cb3b3767afc4ac2b33e25510cb327cf75888e19676","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:08:47 [17:08:47.573] INFO: world-state:database Creating world state data store at directory /tmp/e156c5764cf5b3d6/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:08:47 [17:08:47.601] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.608] INFO: world_state Created world state synchroniser with block history of 64 17:08:47 [17:08:47.608] WARN: node Aztec node is accepting fake proofs 17:08:47 [17:08:47.624] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/e156c5764cf5b3d6/p2p with map size 134217728 KB (LMDB v2) 17:08:47 [17:08:47.627] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:08:47 [17:08:47.629] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/e156c5764cf5b3d6/p2p-archive with map size 134217728 KB (LMDB v2) 17:08:47 [17:08:47.630] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:08:47 [17:08:47.631] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/e156c5764cf5b3d6/p2p-peers with map size 134217728 KB (LMDB v2) 17:08:47 [17:08:47.632] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:08:47 [17:08:47.633] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:08:47 [17:08:47.634] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:08:47 [17:08:47.637] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:08:47 [17:08:47.637] INFO: world_state Started world state synchronizer from block 1 17:08:47 [17:08:47.639] VERBOSE: world-state:block_stream Starting sync from block number 0 17:08:47 [17:08:47.641] INFO: p2p Starting p2p client from block 0 with empty mempools 17:08:47 [17:08:47.641] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:08:47 [17:08:47.643] INFO: slasher Slasher client initialized 17:08:47 [17:08:47.643] INFO: slasher Starting Slasher client... 17:08:47 [17:08:47.677] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:47 [17:08:47.677] VERBOSE: node All Aztec Node subsystems synced 17:08:47 [17:08:47.689] INFO: sequencer-client Deploying forwarder contract 17:08:47 [17:08:47.701] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:08:47 [17:08:47.719] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 17:08:47 [17:08:47.719] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 17:08:47 [17:08:47.726] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:47 [17:08:47.748] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:47 [17:08:47.748] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:08:47 [17:08:47.749] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/a919254d/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:48 [17:08:48.043] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:48 [17:08:48.049] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:48 [17:08:48.053] INFO: node Aztec Node version: 0.87.8 17:08:48 [17:08:48.053] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:08:48 [17:08:48.056] VERBOSE: e2e:e2e_partial_notes Creating a pxe... 17:08:48 [17:08:48.067] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.081] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/553fa73e6315c344/pxe_data with map size 134217728 KB (LMDB v2) 17:08:48 [17:08:48.106] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:48 [17:08:48.109] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:48 [17:08:48.339] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.454] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:48 [17:08:48.455] INFO: pxe:service Started PXE connected to chain 31337 version 4142630518 17:08:48 [17:08:48.503] INFO: pxe:service Registered account 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc 17:08:48 [17:08:48.571] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.573] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:48 [17:08:48.575] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc 17:08:48 [17:08:48.712] INFO: pxe:service Added contract SchnorrAccount at 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:48 [17:08:48.720] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:48 [17:08:48.760] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:48 [17:08:48.797] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:48 [17:08:48.867] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.928] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:49 [17:08:49.607] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:49 [17:08:49.755] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:49 [17:08:49.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:49 [17:08:49.899] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:50 [17:08:50.033] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.083] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:50 [17:08:50.084] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.163] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.167] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:50 [17:08:50.298] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.391] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.432] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:50 [17:08:50.432] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.486] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:50 [17:08:50.497] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:50 [17:08:50.504] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.508] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:50 [17:08:50.522] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc as fee payer 17:08:50 [17:08:50.740] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.041] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.181] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:51 [17:08:51.342] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.951] INFO: pxe:service Proving completed in 3201.292807ms {"timings":{"total":3201.292807,"sync":11.924787999998443,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":176.05167599999913,"oracles":{"callPrivateFunction":{"times":[985.4797910000016,446.7862120000009,239.58877799999937]}}},{"functionName":"private_kernel_init","time":127.44836199999918},{"functionName":"ContractClassRegisterer:register","time":958.6281710000003,"oracles":{"loadCapsule":{"times":[16.573082000000795]},"notifyCreatedNullifier":{"times":[16.408402000000933]},"debugLog":{"times":[1.063082000000577]},"notifyCreatedContractClassLog":{"times":[10.087383000000045]}}},{"functionName":"private_kernel_inner","time":170.7578459999986},{"functionName":"SchnorrAccount:constructor","time":413.7605459999995,"oracles":{"getContractInstance":{"times":[2.07669100000021]},"debugLog":{"times":[1.099264000000403,0.279699000000619]},"fetchTaggedLogs":{"times":[81.80179099999987]},"loadCapsule":{"times":[0.3168020000011893,0.19785400000000664,0.19555300000138232]},"notifyCreatedNullifier":{"times":[0.1407390000003943,0.4101879999998346]},"notifyCreatedNote":{"times":[0.42249900000024354]},"getRandomField":{"times":[0.7410309999995661,0.4037669999997888,0.20145400000001246,0.14097899999978836,0.12199799999871175,0.11756799999966461,0.13957899999877554,0.12136800000007497,0.1634810000014113,0.12282800000139105,0.11852799999905983]},"getIndexedTaggingSecretAsSender":{"times":[36.69255599999997]},"incrementAppTaggingSecretIndexAsSender":{"times":[47.98370000000068]}}},{"functionName":"private_kernel_inner","time":147.31437800000094},{"functionName":"SchnorrAccount:entrypoint","time":216.73888100000113,"oracles":{"debugLog":{"times":[0.5887299999994866,0.43465999999898486,0.7074680000005173]},"fetchTaggedLogs":{"times":[73.13067299999966]},"loadCapsule":{"times":[1.0203590000000986,0.808855000001131,0.34326299999884213]},"getNotes":{"times":[1.9574220000013156]},"getAuthWitness":{"times":[0.29836099999920407]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9855170000009821]}}},{"functionName":"private_kernel_inner","time":164.9875549999997},{"functionName":"private_kernel_reset","time":227.81742100000156},{"functionName":"private_kernel_tail","time":94.1227859999999}],"unaccounted":491.7403970000014}} 17:08:51 [17:08:51.972] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:52 [17:08:52.094] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","blockNumber":1,"slot":2} 17:08:52 [17:08:52.103] VERBOSE: p2p:tx_pool Adding tx 0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c to pool {"eventName":"tx-added-to-pool","txHash":"0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:52 [17:08:52.119] INFO: node Received tx 0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c {"txHash":"0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c"} 17:08:52 [17:08:52.119] INFO: pxe:service Sent transaction 0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c 17:08:52 [17:08:52.181] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:52 [17:08:52.385] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:52 [17:08:52.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:52 [17:08:52.610] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:08:52 [17:08:52.622] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:13:09.000Z","now":"2025-06-13T17:12:50.510Z"} 17:08:52 [17:08:52.866] VERBOSE: simulator:public-processor Processed tx 0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c with no public calls in 178.30360699999983ms {"txHash":"0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c","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":178.30360699999983} 17:08:52 [17:08:52.869] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:52 [17:08:52.872] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24843442800000048s {"duration":0.24843442800000048,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:08:53 [17:08:53.000] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1754bce984519c6d3bc519d47b5eea3283e3f6de7daa2793eadfdd86c5e75d32","globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":1,"slotNumber":2,"timestamp":1749834789,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x222da3f0faf408ff0cfb54f8285e1b3240666c540d57cff9a56049e071334e5c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":390.8247820000015,"publicProcessDuration":249.50982999999906,"rollupCircuitsDuration":378.6089950000005,"txCount":1,"blockNumber":1,"blockTimestamp":1749834789,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:53 [17:08:53.008] VERBOSE: sequencer Attesting committee is empty 17:08:53 [17:08:53.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:53 [17:08:53.336] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:53 [17:08:53.345] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcfb6d397bb3d0b7a3ed898d51c882ed123eaeb25b892a5799369ba7bbbd0bf3d 17:08:53 [17:08:53.345] VERBOSE: sequencer-client Sent L1 transaction 0xcfb6d397bb3d0b7a3ed898d51c882ed123eaeb25b892a5799369ba7bbbd0bf3d {"gasLimit":514552,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:08:53 [17:08:53.355] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:53 [17:08:53.356] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcfb6d397bb3d0b7a3ed898d51c882ed123eaeb25b892a5799369ba7bbbd0bf3d","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749834789,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:53 [17:08:53.356] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:53 [17:08:53.375] INFO: blob-sink:server Received blob sidecar for block 0xee5beb932f37cb22638b571b990fa91830ced58e8b90053388e98d258059720e 17:08:53 [17:08:53.382] INFO: blob-sink:server Blob sidecar stored successfully for block 0xee5beb932f37cb22638b571b990fa91830ced58e8b90053388e98d258059720e 17:08:53 [17:08:53.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:53 [17:08:53.635] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:53 [17:08:53.642] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:08:53 [17:08:53.645] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:08:53 [17:08:53.646] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1754bce984519c6d3bc519d47b5eea3283e3f6de7daa2793eadfdd86c5e75d32","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":1,"slotNumber":2,"timestamp":1749834789,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","archiveNextLeafIndex":2} 17:08:53 [17:08:53.649] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:08:53 [17:08:53.650] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834825] on http://127.0.0.1:8545 17:08:53 [17:08:53.654] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:53 [17:08:53.656] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834825 17:08:53 [17:08:53.656] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:45.000Z {"offset":291344,"timeMs":1749834825000} 17:08:53 [17:08:53.656] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:08:53 [17:08:53.779] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":41.826853999999,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834789,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:53 [17:08:53.800] INFO: pxe:service Registered account 0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05 17:08:53 [17:08:53.801] VERBOSE: p2p Synched to latest block 1 17:08:53 [17:08:53.889] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:53 [17:08:53.896] INFO: pxe:service Added contract SchnorrAccount at 0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:53 [17:08:53.936] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","blockNumber":2,"slot":3} 17:08:53 [17:08:53.942] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","header":{"contentCommitment":{"blobsHash":"0x002d20615732259ff3aefe9ed86d94b2afa252253868d8336fa6b123e1df016b","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834789,"version":4142630518},"lastArchive":"0x1f2790979b638e0ef56425c16d3ef49116fb911b4284fb1d7e24004f4d40c613","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2ffc2e8faecfa05e43e90b1417507fe696b01a9f6168492d55856793c6a3ad63","nullifierTree":"0x12847b612d4d5eba0dec20b37c5a14f80b664d8d0e1925c03bff826b2fbf7faf","publicDataTree":"0x08c51191593b60dbb1f782453927c3edf0efe48fbc6ddcfe0b7e36b35e98a80d"},"totalFees":6794052480,"totalManaUsed":20448}} 17:08:53 [17:08:53.960] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:54 [17:08:54.056] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.088] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:54 [17:08:54.088] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:54 [17:08:54.159] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.173] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:08:54 [17:08:54.180] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:54 [17:08:54.330] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:54 [17:08:54.397] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.445] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:54 [17:08:54.446] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.505] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","blockNumber":2,"slot":3} 17:08:54 [17:08:54.538] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05"} 17:08:54 [17:08:54.544] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:54 [17:08:54.561] VERBOSE: simulator:client_execution_context:debug_log Setting 0x22183ec8e9c98c3c47783be65cd17781ac4499c3fcb7515b0b0e0e276d217b05 as fee payer 17:08:54 [17:08:54.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:54 [17:08:54.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.058] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.472] INFO: pxe:service Proving completed in 1538.977611000002ms {"timings":{"total":1538.977611000002,"sync":10.460374000000229,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":103.49982499999896,"oracles":{"callPrivateFunction":{"times":[326.69400099999984,280.8183919999992]}}},{"functionName":"private_kernel_init","time":85.07742900000085},{"functionName":"SchnorrAccount:constructor","time":293.2788610000007,"oracles":{"getContractInstance":{"times":[0.7051600000013423]},"debugLog":{"times":[0.500077999999121,0.6070449999988341]},"fetchTaggedLogs":{"times":[85.54568599999948]},"loadCapsule":{"times":[1.1456749999997555,4.348038000000088,0.4073530000005121]},"notifyCreatedNullifier":{"times":[0.2676050000009127,0.3336189999990893]},"notifyCreatedNote":{"times":[0.188441000000239]},"getRandomField":{"times":[0.17194000000017695,0.1906010000002425,0.10324599999876227,0.07866400000057183,0.08784500000001572,0.06976399999985006,0.04656200000135868,0.05239299999993818,0.05895299999974668,0.07296400000086578,0.051402999999481835]},"getIndexedTaggingSecretAsSender":{"times":[52.352646999999706]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.94296399999985]}}},{"functionName":"private_kernel_inner","time":168.14612399999896},{"functionName":"SchnorrAccount:entrypoint","time":243.54360199999974,"oracles":{"debugLog":{"times":[0.5720020000007935,0.5929140000007465,0.7844440000008035]},"fetchTaggedLogs":{"times":[96.49821800000063]},"loadCapsule":{"times":[0.24649399999907473,0.22105200000078185,0.2520439999989321]},"getNotes":{"times":[1.550358000000415]},"getAuthWitness":{"times":[0.3147079999998823]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6770390000001498]}}},{"functionName":"private_kernel_inner","time":102.21961400000146},{"functionName":"private_kernel_reset","time":149.16316400000142},{"functionName":"private_kernel_tail","time":69.82965200000035}],"unaccounted":313.7589659999994}} 17:08:55 [17:08:55.488] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.495] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","blockNumber":2,"slot":3} 17:08:55 [17:08:55.515] VERBOSE: p2p:tx_pool Adding tx 0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b to pool {"eventName":"tx-added-to-pool","txHash":"0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:55 [17:08:55.521] INFO: node Received tx 0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b {"txHash":"0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b"} 17:08:55 [17:08:55.521] INFO: pxe:service Sent transaction 0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b 17:08:55 [17:08:55.694] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.898] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.022] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:08:56 [17:08:56.036] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:13:45.000Z","now":"2025-06-13T17:13:47.380Z"} 17:08:56 [17:08:56.065] VERBOSE: simulator:public-processor Processed tx 0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b with no public calls in 18.326623000000836ms {"txHash":"0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":15104},"billedGas":{"daGas":11776,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":18.326623000000836} 17:08:56 [17:08:56.067] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.029981965999999374s {"duration":0.029981965999999374,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 17:08:56 [17:08:56.171] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.197] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0b1fbb74272cc9fefe2cfd61c0490cb26ccf19194883d2ed3ddd36e44b4cbb62","globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":2,"slotNumber":3,"timestamp":1749834825,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0be4151e02f1219cf181d244b1c253d6be96c3673f11145e67eb427615bb623b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":174.74273800000083,"publicProcessDuration":30.306233999999677,"rollupCircuitsDuration":161.29609399999754,"txCount":1,"blockNumber":2,"blockTimestamp":1749834825,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:56 [17:08:56.200] VERBOSE: sequencer Attesting committee is empty 17:08:56 [17:08:56.444] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.453] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x39b45729481d96ffca6dd938bc5f5a1249fe36eac1fa62f10aa073faa0b67825 17:08:56 [17:08:56.453] VERBOSE: sequencer-client Sent L1 transaction 0x39b45729481d96ffca6dd938bc5f5a1249fe36eac1fa62f10aa073faa0b67825 {"gasLimit":470236,"maxFeePerGas":"1.303611187","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:56 [17:08:56.466] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834861] on http://127.0.0.1:8545 17:08:56 [17:08:56.469] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:56 [17:08:56.469] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x39b45729481d96ffca6dd938bc5f5a1249fe36eac1fa62f10aa073faa0b67825","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749834825,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:56 [17:08:56.469] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:56 [17:08:56.472] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:56 [17:08:56.475] INFO: blob-sink:server Received blob sidecar for block 0x02a20a3f52aae4fe135636c1dee98df5402e0610803155822b67c7a3ed38be7e 17:08:56 [17:08:56.478] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834861 17:08:56 [17:08:56.478] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:21.000Z {"offset":324522,"timeMs":1749834861000} 17:08:56 [17:08:56.479] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:08:56 [17:08:56.481] INFO: blob-sink:server Blob sidecar stored successfully for block 0x02a20a3f52aae4fe135636c1dee98df5402e0610803155822b67c7a3ed38be7e 17:08:56 [17:08:56.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.732] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:08:56 [17:08:56.737] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:08:56 [17:08:56.741] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0b1fbb74272cc9fefe2cfd61c0490cb26ccf19194883d2ed3ddd36e44b4cbb62","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":2,"slotNumber":3,"timestamp":1749834825,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","archiveNextLeafIndex":3} 17:08:56 [17:08:56.742] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:08:56 [17:08:56.841] INFO: e2e:e2e_partial_notes Deploying Token contract... 17:08:57 [17:08:57.185] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.190] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 17:08:57 [17:08:57.194] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682 17:08:57 [17:08:57.392] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.395] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.32990399999835,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834825,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:57 [17:08:57.405] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:08:57 [17:08:57.454] VERBOSE: p2p Synched to latest block 2 17:08:57 [17:08:57.702] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.720] INFO: pxe:service Added contract Token at 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:08:57 [17:08:57.744] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","header":{"contentCommitment":{"blobsHash":"0x007de08ced970ff7a5b0e381f1c7dbadc6674548784a75f80bfecdf657abaa9c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834825,"version":4142630518},"lastArchive":"0x03ad01678593b8c4736691d398adeff5f09a794a9a5669ceedc28d2b9f2cce7a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x25d047e50a15b7842a9fab501c58689d3c783842d478b8200d4f5fb5577581d4","nullifierTree":"0x1c60cfe916f3ac7e6b80de0ac2336d50193aebaa6a1c4c8159e66092ba338866","publicDataTree":"0x2b9166e71ca1a074a13188dee50ae47be3a4c8f4a67e81ad14e73a7c0120e2ea"},"totalFees":5018455040,"totalManaUsed":15104}} 17:08:57 [17:08:57.830] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:57 [17:08:57.883] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:57 [17:08:57.883] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:57 [17:08:57.924] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.938] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","blockNumber":3,"slot":4} 17:08:58 [17:08:58.023] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:08:58 [17:08:58.029] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x16ae86eaeeefdf2bd532e269292ba52cb2e7f78264212b1f07e2e15579870606 17:08:58 [17:08:58.099] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:58 [17:08:58.100] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:58 [17:08:58.112] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:58 [17:08:58.112] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:58 [17:08:58.119] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2703112210b167a84aa6a57d784c9c85c0aa24a90188f97213ee44c9cfa6e467","nullifier":"0x28fbcb6cb25c54b0432c8bf7f48b8641a0c625d7d304398ad3d55bf3c38baf19"} 17:08:58 [17:08:58.122] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:58 [17:08:58.200] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc as fee payer 17:08:58 [17:08:58.219] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:58 [17:08:58.276] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:58 [17:08:58.699] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 17:08:58 [17:08:58.791] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:58 [17:08:58.842] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:58 [17:08:58.912] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:58 [17:08:58.924] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","blockNumber":3,"slot":4} 17:08:58 [17:08:58.946] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:58 [17:08:58.956] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682,0x0000000000000000000000000000000000000000000000000000000000000001,0x012140096070654ffe21606a0f77d19938bf03c4bc9341d9ebbd98088716de71,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x1346f129decbb510da85f63a403021eb1c41cdf3e27468676a2adb288a9da487,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc 17:08:59 [17:08:59.056] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.321] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.594] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.776] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","blockNumber":3,"slot":4} 17:09:00 [17:09:00.031] INFO: pxe:service Proving completed in 2293.8966080000027ms {"timings":{"total":2293.8966080000027,"sync":8.704594999999244,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":491.8060730000034,"oracles":{"debugLog":{"times":[0.6366959999977553,0.38892199999827426,0.41415300000153366,0.40717399999994086,0.3922320000019681,0.33358899999802816,0.4733070000002044,0.6545679999981076]},"fetchTaggedLogs":{"times":[143.98952900000222]},"loadCapsule":{"times":[0.30070700000214856,0.19004100000165636,0.43183399999907124,0.4522849999993923,0.43056499999875086,0.3023769999999786]},"getSharedSecret":{"times":[8.070478999998159]},"aes128Decrypt":{"times":[1.5363870000001043,1.4836039999972854]},"getPublicKeysAndPartialAddress":{"times":[4.059330000000045]},"getKeyValidationRequest":{"times":[5.425208000000566]},"deliverNote":{"times":[6.685379999998986]},"deleteCapsule":{"times":[0.5628920000017388]},"storeCapsule":{"times":[0.48378800000136835]},"getNotes":{"times":[3.2114629999996396]},"getAuthWitness":{"times":[0.3424190000005183]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06529399999999441]},"callPrivateFunction":{"times":[639.0508260000024,119.45338400000037]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4106130000000121]}}},{"functionName":"private_kernel_init","time":62.76094899999953},{"functionName":"ContractClassRegisterer:register","time":608.307757999999,"oracles":{"loadCapsule":{"times":[7.461284000000887]},"notifyCreatedNullifier":{"times":[0.34825999999884516]},"debugLog":{"times":[0.5044190000007802]},"notifyCreatedContractClassLog":{"times":[5.846972999999707]}}},{"functionName":"private_kernel_inner","time":116.26042199999938},{"functionName":"ContractInstanceDeployer:deploy","time":73.1262379999971,"oracles":{"storeInExecutionCache":{"times":[0.5130190000018047]},"callPrivateFunction":{"times":[33.18249800000194]},"notifyCreatedNullifier":{"times":[0.30666800000108196]},"debugLog":{"times":[0.4550860000017565]}}},{"functionName":"private_kernel_inner","time":120.9629700000005},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":24.290052000000287,"oracles":{}},{"functionName":"private_kernel_inner","time":153.52807200000098},{"functionName":"private_kernel_reset","time":155.23557900000014},{"functionName":"private_kernel_tail","time":103.2532919999976}],"unaccounted":375.6606080000056}} 17:09:00 [17:09:00.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.300] VERBOSE: p2p:tx_pool Adding tx 0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2 to pool {"eventName":"tx-added-to-pool","txHash":"0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 17:09:00 [17:09:00.332] INFO: node Received tx 0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2 {"txHash":"0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2"} 17:09:00 [17:09:00.332] INFO: pxe:service Sent transaction 0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2 17:09:00 [17:09:00.351] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:09:00 [17:09:00.363] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:14:21.000Z","now":"2025-06-13T17:14:24.885Z"} 17:09:00 [17:09:00.493] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.718] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.896] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":260.61854299999686} 17:09:01 [17:09:01.057] VERBOSE: simulator:public-processor Processed tx 0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2 with 1 public calls in 556.8689329999979ms {"txHash":"0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2","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":556.8689329999979} 17:09:01 [17:09:01.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.065] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.7009015939999991s {"duration":0.7009015939999991,"rate":544771.1965112188,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 17:09:01 [17:09:01.268] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.285] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 408445.8066424132 mana/s {"blockHash":"0x043f1cd324e1b6928288924142ea0507c396abf7a4ff91c2fe2950b7a672639f","globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":3,"slotNumber":4,"timestamp":1749834861,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x09fc71eab32764516096057f47dbc731a77d5bd20bea26737d9fe7b3c41c51f2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":933.7834299999995,"publicProcessDuration":701.3727519999993,"rollupCircuitsDuration":922.5809430000008,"txCount":1,"blockNumber":3,"blockTimestamp":1749834861,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:09:01 [17:09:01.289] VERBOSE: sequencer Attesting committee is empty 17:09:01 [17:09:01.474] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.637] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x06464a844fbbd68b108c4346930c3280ab068ddfa6a4b2fddde6ded6266e1c36 17:09:01 [17:09:01.637] VERBOSE: sequencer-client Sent L1 transaction 0x06464a844fbbd68b108c4346930c3280ab068ddfa6a4b2fddde6ded6266e1c36 {"gasLimit":470312,"maxFeePerGas":"1.279583375","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:01 [17:09:01.647] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834897] on http://127.0.0.1:8545 17:09:01 [17:09:01.650] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:01 [17:09:01.653] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:01 [17:09:01.653] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x06464a844fbbd68b108c4346930c3280ab068ddfa6a4b2fddde6ded6266e1c36","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1749834861,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:09:01 [17:09:01.654] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:01 [17:09:01.658] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834897 17:09:01 [17:09:01.658] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:57.000Z {"offset":355342,"timeMs":1749834897000} 17:09:01 [17:09:01.658] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:09:01 [17:09:01.662] INFO: blob-sink:server Received blob sidecar for block 0x790016871f16cf540faff8e94d4505e315e61c75f03c6158480dc1442ee78fa1 17:09:01 [17:09:01.668] INFO: blob-sink:server Blob sidecar stored successfully for block 0x790016871f16cf540faff8e94d4505e315e61c75f03c6158480dc1442ee78fa1 17:09:01 [17:09:01.677] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.683] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:09:01 [17:09:01.685] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:09:01 [17:09:01.687] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:09:01 [17:09:01.880] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.106] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.131] VERBOSE: archiver:block-helper Store contract instance at 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682 17:09:02 [17:09:02.155] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:09:02 [17:09:02.199] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x043f1cd324e1b6928288924142ea0507c396abf7a4ff91c2fe2950b7a672639f","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":3,"slotNumber":4,"timestamp":1749834861,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","archiveNextLeafIndex":4} 17:09:02 [17:09:02.216] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:09:02 [17:09:02.232] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.018638999998075,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834861,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:09:02 [17:09:02.320] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.326] VERBOSE: p2p Synched to latest block 3 17:09:02 [17:09:02.589] INFO: aztecjs:deploy_sent_tx Contract 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682 successfully deployed. 17:09:02 [17:09:02.590] INFO: e2e:e2e_partial_notes L2 contract deployed 17:09:02 [17:09:02.593] INFO: e2e:e2e_partial_notes Running test: partial notes mint to private 17:09:02 [17:09:02.595] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.885] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","blockNumber":4,"slot":5} 17:09:02 [17:09:02.893] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","header":{"contentCommitment":{"blobsHash":"0x001db63a90dc9e8077a9db6889104736ff70fffd206a5d7d298fd161119021ef","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834861,"version":4142630518},"lastArchive":"0x05dbcac1f056abc037006166ed7c531cc004450206815d92e538ef28c030646b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x25d047e50a15b7842a9fab501c58689d3c783842d478b8200d4f5fb5577581d4","nullifierTree":"0x12669973c8d681de3dded8983079035b1c1246b3950c9c8337dffe1039d4da93","publicDataTree":"0x1dfc02d527e88baf372eacd838736cd446531d37cb0d409845adf4c38c22c2de"},"totalFees":139009277500,"totalManaUsed":418375}} 17:09:02 [17:09:02.975] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:09:03 [17:09:03.016] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:03 [17:09:03.016] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:09:03 [17:09:03.052] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.124] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc"} 17:09:03 [17:09:03.140] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x16ae86eaeeefdf2bd532e269292ba52cb2e7f78264212b1f07e2e15579870606 17:09:03 [17:09:03.151] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:03 [17:09:03.152] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:03 [17:09:03.160] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:03 [17:09:03.160] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:03 [17:09:03.164] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2703112210b167a84aa6a57d784c9c85c0aa24a90188f97213ee44c9cfa6e467","nullifier":"0x28fbcb6cb25c54b0432c8bf7f48b8641a0c625d7d304398ad3d55bf3c38baf19"} 17:09:03 [17:09:03.166] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:03 [17:09:03.179] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c828190d5e30db643b003cd4745698d7c58366e247473c5de6fe8c706b78ffc as fee payer 17:09:03 [17:09:03.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.472] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682"} 17:09:03 [17:09:03.500] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:03 [17:09:03.500] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682"} 17:09:03 [17:09:03.504] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.629] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","blockNumber":4,"slot":5} 17:09:03 [17:09:03.673] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682"} 17:09:03 [17:09:03.678] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:03 [17:09:03.707] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.169] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.271] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","blockNumber":4,"slot":5} 17:09:04 [17:09:04.422] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.796] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.947] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","blockNumber":4,"slot":5} 17:09:05 [17:09:05.223] INFO: pxe:service Proving completed in 2362.597883999999ms {"timings":{"total":2362.597883999999,"sync":33.74989999999889,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":354.16354699999283,"oracles":{"debugLog":{"times":[0.7547229999981937,0.9244429999998829,0.48475799999869196,0.5046089999996184,0.5306700000001001,0.44294600000284845,0.2957769999993616,0.8041660000017146]},"fetchTaggedLogs":{"times":[118.83417900000131]},"loadCapsule":{"times":[0.3422900000005029,0.6021039999977802,1.3820579999992333,0.2625140000018291,0.19128099999943515,0.1859309999999823]},"getSharedSecret":{"times":[3.3770020000010845]},"aes128Decrypt":{"times":[0.2795059999989462,1.018287999999302]},"getPublicKeysAndPartialAddress":{"times":[2.026355000001786]},"getKeyValidationRequest":{"times":[2.751135999998951]},"deliverNote":{"times":[3.5901039999989734]},"deleteCapsule":{"times":[0.288936000000831]},"storeCapsule":{"times":[0.27025500000308966]},"getNotes":{"times":[1.469094000000041]},"getAuthWitness":{"times":[0.16971900000135065]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.10313599999790313]},"callPrivateFunction":{"times":[967.2115520000007]}}},{"functionName":"private_kernel_init","time":58.38241099999868},{"functionName":"Token:mint_to_private","time":877.1113770000011,"oracles":{"debugLog":{"times":[0.49875600000086706,0.5798810000014782]},"fetchTaggedLogs":{"times":[176.6323709999997]},"loadCapsule":{"times":[0.2094249999972817,0.24852800000007846,0.22842600000149105]},"getRandomField":{"times":[0.20845399999961955,0.19068400000105612,0.2208950000022014,0.1255490000003192,0.10017700000025798,0.09364600000117207,0.08786699999836856,0.06395500000144239,0.058654000000387896,0.04302299999835668,0.036303000000771135,0.036372999999002786]},"getIndexedTaggingSecretAsSender":{"times":[304.08742699999857]},"incrementAppTaggingSecretIndexAsSender":{"times":[131.0870759999998]},"notifyCreatedNullifier":{"times":[0.5470490000006976]},"storeInExecutionCache":{"times":[0.06005400000140071]},"notifyEnqueuedPublicFunctionCall":{"times":[0.098056999999244]}}},{"functionName":"private_kernel_inner","time":119.31722500000251},{"functionName":"private_kernel_reset","time":204.28717699999834},{"functionName":"private_kernel_tail","time":77.78155699999843}],"unaccounted":637.8046900000081}} 17:09:05 [17:09:05.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.288] VERBOSE: p2p:tx_pool Adding tx 0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a to pool {"eventName":"tx-added-to-pool","txHash":"0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 17:09:05 [17:09:05.299] INFO: node Received tx 0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a {"txHash":"0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a"} 17:09:05 [17:09:05.299] INFO: pxe:service Sent transaction 0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a 17:09:05 [17:09:05.460] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.480] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:09:05 [17:09:05.495] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T17:14:57.000Z","now":"2025-06-13T17:15:00.837Z"} 17:09:05 [17:09:05.555] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":35.12072900000203} 17:09:05 [17:09:05.576] VERBOSE: simulator:public-processor Processed tx 0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a with 1 public calls in 67.03871000000072ms {"txHash":"0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a","txFee":3736336500,"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":67.03871000000072} 17:09:05 [17:09:05.577] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08111872600000061s {"duration":0.08111872600000061,"rate":523861.7776122332,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 17:09:05 [17:09:05.692] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.704] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 187767.8409163843 mana/s {"blockHash":"0x1b25e04ea5181f8fb2d9659c9a1eb5fa5c95b188b06754b6c60c660c6cdc84e0","globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":4,"slotNumber":5,"timestamp":1749834897,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x183ac9d7b8f8cdbb61c05ece5df9fdba4c26b734a9cd0aa4654aef5a5c4e735a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":225.84703700000318,"publicProcessDuration":81.56189799999993,"rollupCircuitsDuration":210.25028299999758,"txCount":1,"blockNumber":4,"blockTimestamp":1749834897,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:05 [17:09:05.711] VERBOSE: sequencer Attesting committee is empty 17:09:05 [17:09:05.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.978] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x158c0397178bd5e7361fc7b91058df289b1e6414ccbe1ec016caca841a5ab74d 17:09:05 [17:09:05.978] VERBOSE: sequencer-client Sent L1 transaction 0x158c0397178bd5e7361fc7b91058df289b1e6414ccbe1ec016caca841a5ab74d {"gasLimit":470277,"maxFeePerGas":"1.261127728","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:05 [17:09:05.989] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:05 [17:09:05.990] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x158c0397178bd5e7361fc7b91058df289b1e6414ccbe1ec016caca841a5ab74d","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1749834897,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:05 [17:09:05.990] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:05 [17:09:05.997] INFO: blob-sink:server Received blob sidecar for block 0x531737450d357aa3b7dc2e85103b473e976aebfbb36124d7b504af9e05e09571 17:09:06 [17:09:06.014] INFO: blob-sink:server Blob sidecar stored successfully for block 0x531737450d357aa3b7dc2e85103b473e976aebfbb36124d7b504af9e05e09571 17:09:06 [17:09:06.019] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834933] on http://127.0.0.1:8545 17:09:06 [17:09:06.021] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:06 [17:09:06.022] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834933 17:09:06 [17:09:06.022] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:33.000Z {"offset":386978,"timeMs":1749834933000} 17:09:06 [17:09:06.023] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:09:06 [17:09:06.171] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.179] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:09:06 [17:09:06.181] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:09:06 [17:09:06.183] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:09:06 [17:09:06.375] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.474] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1b25e04ea5181f8fb2d9659c9a1eb5fa5c95b188b06754b6c60c660c6cdc84e0","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":4142630518,"blockNumber":4,"slotNumber":5,"timestamp":1749834897,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x20145052c4a7e7fdcfe2aa310caa8b14862bf9125e39e6381de1fae83dddc974","archiveNextLeafIndex":5} 17:09:06 [17:09:06.482] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:09:06 [17:09:06.578] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.184522999999899,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749834897,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:06 [17:09:06.592] VERBOSE: p2p Synched to latest block 4 17:09:06 [17:09:06.662] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.865] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.015] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x20145052c4a7e7fdcfe2aa310caa8b14862bf9125e39e6381de1fae83dddc974","blockNumber":5,"slot":6} 17:09:07 [17:09:07.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.319] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x20145052c4a7e7fdcfe2aa310caa8b14862bf9125e39e6381de1fae83dddc974","header":{"contentCommitment":{"blobsHash":"0x0042e4dd6922e5c7fbb22c46eadea60a30e5e3c4e336c6cbfdd22623581af4bf","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749834897,"version":4142630518},"lastArchive":"0x2e581b84013983445b2f52ecf8f4f17fe07534853dcfea83a076bef1c23d77d0","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0fc5b0d932eb0f703fc77dea808f2df06f6b8f5904929291775cb72beae02232","nullifierTree":"0x235f0023fbf92d35deea34f389103bf3ad734c671492f79bdd90a4f6b593c07a","publicDataTree":"0x1774cfb1a6a037fc3c62b227158af6366cf065d2c8ec4968c7616b2a3078fcb9"},"totalFees":3736336500,"totalManaUsed":73695}} 17:09:07 [17:09:07.542] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.628] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682","selector":"0x4375727c"} 17:09:07 [17:09:07.641] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:09:07 [17:09:07.642] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682"} 17:09:07 [17:09:07.903] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.909] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x20145052c4a7e7fdcfe2aa310caa8b14862bf9125e39e6381de1fae83dddc974","blockNumber":5,"slot":6} 17:09:07 [17:09:07.960] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682"} 17:09:07 [17:09:07.966] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0c93466aeb417c206cc196c1596e90c7b2714e046a1b789320d3fc84bfac6e39 17:09:07 [17:09:07.979] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 17:09:07 [17:09:07.982] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 17:09:07 [17:09:07.987] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x113c62f34d2737def5721eeb413bf0733ccd88a8aa900160356b8df6407c9438 17:09:07 [17:09:07.987] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682 for storage slot 0x282d5020a633cfd1515161bd38abfd3ef2011bb7f793b01d86b8be27c86cbbd1 17:09:07 [17:09:07.995] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:07 [17:09:07.996] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x113c62f34d2737def5721eeb413bf0733ccd88a8aa900160356b8df6407c9438 17:09:08 [17:09:07.999] VERBOSE: pxe:service Added note {"index":192,"contract":"0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682","slot":"0x282d5020a633cfd1515161bd38abfd3ef2011bb7f793b01d86b8be27c86cbbd1","noteHash":"0x1b1e0b9e829639db5196d6f2bb5b4dae991d3ef1013cbefa7825dcdc90ac3f3f","nullifier":"0x0bd13769f4023ade584ab60f5d56a8f92be1fdbf7aaf8ee0c6539541cc74e147"} 17:09:08 [17:09:08.004] VERBOSE: simulator Utility simulation for 0x172c65c5e249a2a38905ee817d18c98881a2587134500358224ec3e9c8970682.0x4375727c completed 17:09:08 [17:09:08.009] INFO: node Stopping 17:09:08 [17:09:08.010] INFO: slasher Slasher client stopped. 17:09:08 [17:09:08.010] INFO: sequencer Stopped sequencer 17:09:08 [17:09:08.011] INFO: p2p P2P client stopped. 17:09:08 [17:09:08.013] INFO: world_state Stopped world state synchronizer 17:09:08 [17:09:08.013] INFO: archiver Stopped. 17:09:08 [17:09:08.013] INFO: node Stopped 17:09:08 [17:09:08.013] VERBOSE: e2e:e2e_partial_notes Cleaning up ACVM state 17:09:08 [17:09:08.013] INFO: e2e:e2e_partial_notes Cleaning up ACVM temp directory /tmp/a919254d 17:09:08 [17:09:08.014] VERBOSE: e2e:e2e_partial_notes Cleaning up BB state 17:09:08 [17:09:08.025] INFO: blob-sink:server Stopping blob sink 17:09:08 [17:09:08.025] INFO: blob-sink:server Blob sink stopped 17:09:08 [17:09:08.025] VERBOSE: e2e:e2e_partial_notes Cleaning up data directory at /tmp/e156c5764cf5b3d6 17:09:08 PASS src/e2e_partial_notes.test.ts 17:09:08 partial notes 17:09:08 ✓ mint to private (5416 ms) 17:09:08 17:09:08 Test Suites: 1 passed, 1 total 17:09:08 Tests: 1 passed, 1 total 17:09:08 Snapshots: 0 total 17:09:08 Time: 29.048 s 17:09:08 Ran all test suites matching /src\/e2e_partial_notes.test.ts/i. 17:09:08 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?