Parent Log: http://ci.aztec-labs.com/8e8dd02b40b54e5e Command: 97e7ef9a556fd7e6: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/cf4d4501e7edfb97cb6406ee7f30893939a522f9 Env: REF_NAME=gh-readonly-queue/master/pr-14912-015cb0cadef6a41094c3649f32a735392e1b9693 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Wed Jun 18 15:33:38 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14912_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_6b4a73ce992ff502_master 15:33:38 +++ id -u 15:33:38 +++ id -g 15:33: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'\''' 15:33:38 + cid=0d1b9ce7b8602b6739e16cff3e688772d6df436deef3cc2e8d730b44ff5b4f9f 15:33:38 + set +x 15:33:39 {"level":25,"time":1750260819098,"pid":12,"hostname":"0d1b9ce7b860","module":"logger","msg":"Logger initialized with level verbose"} 15:33:46 [15:33:46.002] INFO: e2e:e2e_partial_notes Logging metrics to log/unknown.jsonl 15:33:46 [15:33:46.313] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-OvINHf/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:33:46 [15:33:46.360] INFO: e2e:e2e_partial_notes Calling anvil_setBlockTimestampInterval with params: [12] 15:33:46 [15:33:46.383] WARN: e2e:e2e_partial_notes Set block interval to 12 15:33:46 [15:33:46.384] VERBOSE: e2e:e2e_partial_notes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:33:46 [15:33:46.431] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:33:46 [15:33:46.445] VERBOSE: e2e:e2e_partial_notes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:33:46 [15:33:46.512] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:33:46 [15:33:46.527] VERBOSE: e2e:e2e_partial_notes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:33:46 [15:33:46.559] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:33:46 [15:33:46.566] VERBOSE: e2e:e2e_partial_notes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:33:46 [15:33:46.585] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:33:46 [15:33:46.590] VERBOSE: e2e:e2e_partial_notes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:33:46 [15:33:46.622] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 15:33:46 [15:33:46.628] VERBOSE: e2e:e2e_partial_notes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:33:46 [15:33:46.648] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 15:33:46 [15:33:46.655] VERBOSE: e2e:e2e_partial_notes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:33:46 [15:33:46.656] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 15:33:46 [15:33:46.656] INFO: e2e:e2e_partial_notes Waiting for 6 transactions to be mined... 15:33:46 [15:33:46.677] INFO: e2e:e2e_partial_notes All transactions mined successfully 15:33:46 [15:33:46.694] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 15:33:46 [15:33:46.694] VERBOSE: e2e:e2e_partial_notes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 15:33:46 [15:33:46.716] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 15:33:46 [15:33:46.732] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 15:33:46 [15:33:46.738] VERBOSE: e2e:e2e_partial_notes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:33:46 [15:33:46.755] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 15:33:46 [15:33:46.755] VERBOSE: e2e:e2e_partial_notes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 15:33:46 [15:33:46.773] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 15:33:46 [15:33:46.781] VERBOSE: e2e:e2e_partial_notes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:33:46 [15:33:46.796] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 15:33:46 [15:33:46.796] VERBOSE: e2e:e2e_partial_notes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 15:33:46 [15:33:46.797] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 15:33:46 [15:33:46.797] INFO: e2e:e2e_partial_notes Waiting for 8 transactions to be mined... 15:33:46 [15:33:46.814] INFO: e2e:e2e_partial_notes All transactions mined successfully 15:33:46 [15:33:46.824] VERBOSE: e2e:e2e_partial_notes Deployed shared contracts 15:33:46 [15:33:46.849] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 15:33:46 [15:33:46.850] VERBOSE: e2e:e2e_partial_notes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 15:33:46 [15:33:46.855] 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} 15:33:46 [15:33:46.874] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 15:33:46 [15:33:46.904] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 15:33:46 [15:33:46.910] VERBOSE: e2e:e2e_partial_notes Awaiting for linked libraries to be deployed 15:33:47 [15:33:47.037] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x16a2db19da51bf7f3505d8bb2b0b3bd29725d74724d502846f451a7c3f706b0b {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 15:33:47 [15:33:47.048] 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} 15:33:47 [15:33:47.049] INFO: e2e:e2e_partial_notes Waiting for 9 transactions to be mined... 15:33:47 [15:33:47.068] INFO: e2e:e2e_partial_notes All transactions mined successfully 15:33:47 [15:33:47.069] VERBOSE: e2e:e2e_partial_notes All core contracts have been deployed 15:33:47 [15:33:47.091] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 15:33:47 [15:33:47.091] VERBOSE: e2e:e2e_partial_notes Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 15:33:47 [15:33:47.103] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 15:33:47 [15:33:47.107] VERBOSE: e2e:e2e_partial_notes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:33:47 [15:33:47.127] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 15:33:47 [15:33:47.128] VERBOSE: e2e:e2e_partial_notes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 15:33:47 [15:33:47.128] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 15:33:47 [15:33:47.149] INFO: e2e:e2e_partial_notes All transactions mined successfully 15:33:47 [15:33:47.161] VERBOSE: e2e:e2e_partial_notes Rollup deployed 15:33:47 [15:33:47.161] VERBOSE: e2e:e2e_partial_notes Waiting for rollup and slash factory to be deployed 15:33:47 [15:33:47.161] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 15:33:47 [15:33:47.184] INFO: e2e:e2e_partial_notes All transactions mined successfully 15:33:47 [15:33:47.184] VERBOSE: e2e:e2e_partial_notes All transactions for L1 deployment have been mined 15:33:47 [15:33:47.206] 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"} 15:33:47 [15:33:47.211] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:33:47 [15:33:47.216] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:47 [15:33:47.218] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 15:33:47 [15:33:47.220] INFO: telemetry:client Using NoopTelemetryClient 15:33:47 [15:33:47.230] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 15:33:47 [15:33:47.231] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 15:33:47 [15:33:47.232] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/90471b906068fb11/blob-sink with map size 134217728 KB (LMDB v2) 15:33:47 [15:33:47.235] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:47 [15:33:47.238] INFO: aztecjs:utils:watcher New L1 time: 1750261066 15:33:47 [15:33:47.238] WARN: foundation:test-date-provider Time set to 2025-06-18T15:37:46.000Z {"offset":238762,"timeMs":1750261066000} 15:33:47 [15:33:47.240] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:33:47 [15:33:47.247] INFO: blob-sink:server Server is running on http://localhost:41667 15:33:47 [15:33:47.248] VERBOSE: e2e:e2e_partial_notes Creating and synching an aztec node... 15:33:47 [15:33:47.248] VERBOSE: e2e:e2e_partial_notes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/d76479c3/acvm 15:33:47 [15:33:47.250] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41667"} 15:33:47 [15:33:47.267] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:33:47 [15:33:47.267] INFO: archiver:lmdb Creating archiver data store at directory /tmp/90471b906068fb11/archiver with map size 134217728 KB (LMDB v2) 15:33:47 [15:33:47.269] INFO: archiver:lmdb Starting data store with maxReaders 16 15:33:47 [15:33:47.470] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:47 [15:33:47.573] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:41667"} 15:33:47 [15:33:47.591] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:41667"} 15:33:47 [15:33:47.592] WARN: node:blob-sink:client No L1 consensus host urls configured 15:33:47 [15:33:47.592] WARN: node:blob-sink:client No archive client configured 15:33:47 [15:33:47.595] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xb32867e307ca0968a8bb050a1c83827136c4d2dc915fdbea8e653d86fb4cfddd {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x80d4117b9de99fdd4de9246905e5a4adceb3a38c3e66d150e72073ff1acfe069","l1BlockNumber":16}} 15:33:47 [15:33:47.632] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:33:47 [15:33:47.642] INFO: world-state:database Creating world state data store at directory /tmp/90471b906068fb11/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:33:47 [15:33:47.672] INFO: world_state Created world state synchroniser with block history of 64 15:33:47 [15:33:47.673] WARN: node Aztec node is accepting fake proofs 15:33:47 [15:33:47.678] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:47 [15:33:47.684] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/90471b906068fb11/p2p with map size 134217728 KB (LMDB v2) 15:33:47 [15:33:47.686] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:33:47 [15:33:47.687] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/90471b906068fb11/p2p-archive with map size 134217728 KB (LMDB v2) 15:33:47 [15:33:47.688] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:33:47 [15:33:47.689] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/90471b906068fb11/p2p-peers with map size 134217728 KB (LMDB v2) 15:33:47 [15:33:47.692] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:33:47 [15:33:47.695] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:33:47 [15:33:47.696] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:33:47 [15:33:47.701] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:33:47 [15:33:47.702] INFO: world_state Started world state synchronizer from block 1 15:33:47 [15:33:47.711] VERBOSE: world-state:block_stream Starting sync from block number 0 15:33:47 [15:33:47.715] INFO: p2p Starting p2p client from block 0 with empty mempools 15:33:47 [15:33:47.716] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:33:47 [15:33:47.717] INFO: slasher Slasher client initialized 15:33:47 [15:33:47.717] INFO: slasher Starting Slasher client... 15:33:47 [15:33:47.751] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:47 [15:33:47.751] VERBOSE: node All Aztec Node subsystems synced 15:33:47 [15:33:47.760] INFO: sequencer-client Deploying forwarder contract 15:33:47 [15:33:47.769] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:33:47 [15:33:47.787] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 15:33:47 [15:33:47.787] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 15:33:47 [15:33:47.794] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:33:47 [15:33:47.810] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:47 [15:33:47.811] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 15:33:47 [15:33:47.811] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/d76479c3/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:33:48 [15:33:48.044] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:33:48 [15:33:48.046] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:33:48 [15:33:48.048] INFO: node Aztec Node version: 0.87.9 15:33:48 [15:33:48.048] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 15:33:48 [15:33:48.049] VERBOSE: e2e:e2e_partial_notes Creating a pxe... 15:33:48 [15:33:48.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:48 [15:33:48.060] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/0305324e8d6a031d/pxe_data with map size 134217728 KB (LMDB v2) 15:33:48 [15:33:48.072] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:33:48 [15:33:48.074] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","blockNumber":1,"slot":2} 15:33:48 [15:33:48.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:48 [15:33:48.346] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:33:48 [15:33:48.346] INFO: pxe:service Started PXE connected to chain 31337 version 3628792160 15:33:48 [15:33:48.393] INFO: pxe:service Registered account 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 15:33:48 [15:33:48.456] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 15:33:48 [15:33:48.457] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 15:33:48 [15:33:48.491] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:48 [15:33:48.603] INFO: pxe:service Added contract SchnorrAccount at 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:33:48 [15:33:48.626] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","blockNumber":1,"slot":2} 15:33:48 [15:33:48.656] VERBOSE: pxe:block_stream Starting sync from block number 0 15:33:48 [15:33:48.677] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:33:48 [15:33:48.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:48 [15:33:48.799] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:49 [15:33:49.419] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:33:49 [15:33:49.526] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:33:49 [15:33:49.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:49 [15:33:49.672] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","blockNumber":1,"slot":2} 15:33:49 [15:33:49.788] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:49 [15:33:49.825] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:49 [15:33:49.826] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:49 [15:33:49.851] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:49 [15:33:49.885] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:49 [15:33:49.890] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:50 [15:33:50.046] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:50 [15:33:50.087] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:50 [15:33:50.088] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:50 [15:33:50.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:50 [15:33:50.130] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:50 [15:33:50.133] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:50 [15:33:50.146] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 as fee payer 15:33:50 [15:33:50.217] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","blockNumber":1,"slot":2} 15:33:50 [15:33:50.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:50 [15:33:50.569] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:50 [15:33:50.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:50 [15:33:50.946] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","blockNumber":1,"slot":2} 15:33:51 [15:33:51.328] INFO: pxe:service Proving completed in 2674.602465ms {"timings":{"total":2674.602465,"sync":3.05855899999915,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":166.14752299999964,"oracles":{"callPrivateFunction":{"times":[869.5750310000003,369.64332300000024,181.93764799999917]}}},{"functionName":"private_kernel_init","time":100.99243399999978},{"functionName":"ContractClassRegisterer:register","time":842.1913469999981,"oracles":{"loadCapsule":{"times":[22.13658899999973]},"notifyCreatedNullifier":{"times":[16.226654000000053]},"debugLog":{"times":[1.5498760000009497]},"notifyCreatedContractClassLog":{"times":[9.202538999999888]}}},{"functionName":"private_kernel_inner","time":129.61183300000084},{"functionName":"SchnorrAccount:constructor","time":339.1841089999998,"oracles":{"getContractInstance":{"times":[1.1515220000001136]},"debugLog":{"times":[0.6816319999998086,0.38486400000147114]},"fetchTaggedLogs":{"times":[62.57684899999913]},"loadCapsule":{"times":[0.37972399999853224,0.23626399999920977,0.22988399999849207]},"notifyCreatedNullifier":{"times":[0.19926200000008976,0.2597359999999753]},"notifyCreatedNote":{"times":[0.4809500000010303]},"getRandomField":{"times":[0.3814039999997476,0.2962680000000546,0.14670900000055553,0.10503699999935634,0.10290600000007544,0.090596000000005,0.08018499999889173,0.07047400000010384,0.06216300000050978,0.0930160000007163,0.06916400000045542]},"getIndexedTaggingSecretAsSender":{"times":[26.765493999999308]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.864590999999564]}}},{"functionName":"private_kernel_inner","time":130.79055599999992},{"functionName":"SchnorrAccount:entrypoint","time":155.87452699999994,"oracles":{"debugLog":{"times":[0.595976000000519,0.34614200000032724,0.7342050000006566]},"fetchTaggedLogs":{"times":[43.74425400000109]},"loadCapsule":{"times":[0.21298399999977846,0.2030030000005354,0.23964500000147382]},"getNotes":{"times":[1.685434000000896]},"getAuthWitness":{"times":[0.3111799999987852]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0790570000008302]}}},{"functionName":"private_kernel_inner","time":140.40999100000045},{"functionName":"private_kernel_reset","time":165.94886000000042},{"functionName":"private_kernel_tail","time":62.14030199999979}],"unaccounted":438.25242400000207}} 15:33:51 [15:33:51.346] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:51 [15:33:51.486] VERBOSE: p2p:tx_pool Adding tx 0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20 to pool {"eventName":"tx-added-to-pool","txHash":"0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:33:51 [15:33:51.512] INFO: node Received tx 0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20 {"txHash":"0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20"} 15:33:51 [15:33:51.512] INFO: pxe:service Sent transaction 0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20 15:33:51 [15:33:51.522] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 15:33:51 [15:33:51.535] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T15:38:10.000Z","now":"2025-06-18T15:37:50.297Z"} 15:33:51 [15:33:51.558] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:51 [15:33:51.780] VERBOSE: simulator:public-processor Processed tx 0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20 with no public calls in 146.7970750000004ms {"txHash":"0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20","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":146.7970750000004} 15:33:51 [15:33:51.787] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24958527099999991s {"duration":0.24958527099999991,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 15:33:51 [15:33:51.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:51 [15:33:51.911] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0a2d11fb88f6de88a4883c64eddcae8788ecd6cf1ef5951efb419fd9e202bd76","globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":1,"slotNumber":2,"timestamp":1750261090,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x14357871bff113e82b83e85594e3d3ef8c608c8e6f2ef41ee9de95324d896c20"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":389.73574499999995,"publicProcessDuration":250.78560500000094,"rollupCircuitsDuration":377.10221400000046,"txCount":1,"blockNumber":1,"blockTimestamp":1750261090,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:51 [15:33:51.915] VERBOSE: sequencer Attesting committee is empty 15:33:52 [15:33:52.102] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:52 [15:33:52.263] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8a953616a4ccec44b13fc296c82d16883257a109aad55df1b1ec8dcfcee5cdb4 15:33:52 [15:33:52.263] VERBOSE: sequencer-client Sent L1 transaction 0x8a953616a4ccec44b13fc296c82d16883257a109aad55df1b1ec8dcfcee5cdb4 {"gasLimit":514570,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 15:33:52 [15:33:52.276] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:33:52 [15:33:52.277] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8a953616a4ccec44b13fc296c82d16883257a109aad55df1b1ec8dcfcee5cdb4","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1750261090,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:52 [15:33:52.278] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:33:52 [15:33:52.300] INFO: blob-sink:server Received blob sidecar for block 0x3d498ad699ba2aac44fb25c1e69bf095faddd996cf5c6e435a8b868cab82e24f 15:33:52 [15:33:52.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:52 [15:33:52.312] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3d498ad699ba2aac44fb25c1e69bf095faddd996cf5c6e435a8b868cab82e24f 15:33:52 [15:33:52.317] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:33:52 [15:33:52.320] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:33:52 [15:33:52.322] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:33:52 [15:33:52.337] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261126] on http://127.0.0.1:8545 15:33:52 [15:33:52.339] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:52 [15:33:52.340] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261126 15:33:52 [15:33:52.341] WARN: foundation:test-date-provider Time set to 2025-06-18T15:38:46.000Z {"offset":293659,"timeMs":1750261126000} 15:33:52 [15:33:52.341] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:33:52 [15:33:52.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:52 [15:33:52.696] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:33:52 [15:33:52.702] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0a2d11fb88f6de88a4883c64eddcae8788ecd6cf1ef5951efb419fd9e202bd76","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":1,"slotNumber":2,"timestamp":1750261090,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x24851cb17e95f8531f2b637c504284a6006648169bf95a4c3e382338c2122b0e","archiveNextLeafIndex":2} 15:33:52 [15:33:52.709] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:33:52 [15:33:52.721] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:52 [15:33:52.867] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.529900000001362,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750261090,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:33:52 [15:33:52.886] VERBOSE: p2p Synched to latest block 1 15:33:52 [15:33:52.888] INFO: pxe:service Registered account 0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6 15:33:52 [15:33:52.994] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:53 [15:33:53.008] INFO: pxe:service Added contract SchnorrAccount at 0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:33:53 [15:33:53.033] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x24851cb17e95f8531f2b637c504284a6006648169bf95a4c3e382338c2122b0e","header":{"contentCommitment":{"blobsHash":"0x004878c93a258ccaecbae04835da0d38658ba9ec437f6f3459e3d7a9030dd978","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750261090,"version":3628792160},"lastArchive":"0x0aa5c6c127698ef89b7c2a86281749d7e1963b8b0f1e4c16708a00b874293f09","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x08fcfb98859b4f68c8fe92ac1bd16d4f01d460ce1e3b8c9d59d6bafc7677d4d5","nullifierTree":"0x2707d43b1223aab93a5e6d72929f8d360786b649022663af93d049d58aa58964","publicDataTree":"0x0e999fc0ea8345a29fd1147494a456cf5d8edaf980d9fec7eb48c4731cad37a0"},"totalFees":6794052480,"totalManaUsed":20448}} 15:33:53 [15:33:53.051] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:33:53 [15:33:53.161] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.204] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:53 [15:33:53.215] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:53 [15:33:53.216] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.326] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24851cb17e95f8531f2b637c504284a6006648169bf95a4c3e382338c2122b0e","blockNumber":2,"slot":3} 15:33:53 [15:33:53.348] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.355] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:53 [15:33:53.421] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:53 [15:33:53.558] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.597] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:53 [15:33:53.597] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:53 [15:33:53.652] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6"} 15:33:53 [15:33:53.657] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:53 [15:33:53.669] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2e8f68a804297ab552b14d034fb2d4ccc37c44a0864ac8696f322ad7247d30f6 as fee payer 15:33:53 [15:33:53.832] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:54 [15:33:54.076] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:54 [15:33:54.094] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24851cb17e95f8531f2b637c504284a6006648169bf95a4c3e382338c2122b0e","blockNumber":2,"slot":3} 15:33:54 [15:33:54.464] INFO: pxe:service Proving completed in 1438.4600320000009ms {"timings":{"total":1438.4600320000009,"sync":9.992757999998503,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":89.70040599999993,"oracles":{"callPrivateFunction":{"times":[398.80342500000006,212.67555900000116]}}},{"functionName":"private_kernel_init","time":79.95805300000029},{"functionName":"SchnorrAccount:constructor","time":364.55139699999927,"oracles":{"getContractInstance":{"times":[5.743304999999964]},"debugLog":{"times":[0.7607580000003509,0.6566710000006424]},"fetchTaggedLogs":{"times":[137.3606120000004]},"loadCapsule":{"times":[0.29166799999984505,0.40143499999976484,0.2893179999991844]},"notifyCreatedNullifier":{"times":[0.33976100000109,0.28213700000014796]},"notifyCreatedNote":{"times":[0.22492400000010093]},"getRandomField":{"times":[0.21032299999933457,0.30344899999909103,0.09168599999975413,0.07879500000126427,0.07543500000065251,0.07272499999999127,0.10205599999972037,0.07269399999859161,0.06694400000014866,0.06760399999984656,0.08549499999935506]},"getIndexedTaggingSecretAsSender":{"times":[51.07560800000101]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.967889000001378]}}},{"functionName":"private_kernel_inner","time":128.164084},{"functionName":"SchnorrAccount:entrypoint","time":190.98449800000162,"oracles":{"debugLog":{"times":[0.7151450000001205,0.4667989999998099,0.5534539999989647]},"fetchTaggedLogs":{"times":[58.5977129999992]},"loadCapsule":{"times":[0.22127399999953923,0.19530200000008335,0.25470599999971455]},"getNotes":{"times":[1.1278789999996661]},"getAuthWitness":{"times":[0.15478900000016438]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5197220000009111]}}},{"functionName":"private_kernel_inner","time":108.41103199999998},{"functionName":"private_kernel_reset","time":144.9812239999992},{"functionName":"private_kernel_tail","time":59.751734000001306}],"unaccounted":261.96484600000076}} 15:33:54 [15:33:54.476] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:54 [15:33:54.498] VERBOSE: p2p:tx_pool Adding tx 0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d to pool {"eventName":"tx-added-to-pool","txHash":"0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:33:54 [15:33:54.502] INFO: node Received tx 0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d {"txHash":"0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d"} 15:33:54 [15:33:54.502] INFO: pxe:service Sent transaction 0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d 15:33:54 [15:33:54.634] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 15:33:54 [15:33:54.652] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T15:38:46.000Z","now":"2025-06-18T15:38:48.311Z"} 15:33:54 [15:33:54.675] VERBOSE: simulator:public-processor Processed tx 0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d with no public calls in 15.492397999998502ms {"txHash":"0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d","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":15.492397999998502} 15:33:54 [15:33:54.677] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.024002823999999236s {"duration":0.024002823999999236,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 15:33:54 [15:33:54.682] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:54 [15:33:54.798] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2daed97ed18a0eb9759f15531a7f195d49bd4fd4ce6b642b36f6a2781cc7898e","globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":2,"slotNumber":3,"timestamp":1750261126,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1001c0957f0327e7a5d2701505cb08136eb71d00bf662b5294048d7ea8e97e1d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":164.22678299999825,"publicProcessDuration":24.369606000000203,"rollupCircuitsDuration":147.49869899999794,"txCount":1,"blockNumber":2,"blockTimestamp":1750261126,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:54 [15:33:54.801] VERBOSE: sequencer Attesting committee is empty 15:33:54 [15:33:54.885] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:55 [15:33:55.051] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcf10750910216c9b021ebf82d1132d4a8031cdff33b47ae89c046c4e36149940 15:33:55 [15:33:55.051] VERBOSE: sequencer-client Sent L1 transaction 0xcf10750910216c9b021ebf82d1132d4a8031cdff33b47ae89c046c4e36149940 {"gasLimit":470191,"maxFeePerGas":"1.303611187","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:33:55 [15:33:55.063] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:33:55 [15:33:55.063] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcf10750910216c9b021ebf82d1132d4a8031cdff33b47ae89c046c4e36149940","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":2,"blockTimestamp":1750261126,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:55 [15:33:55.064] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:33:55 [15:33:55.068] INFO: blob-sink:server Received blob sidecar for block 0xfce688fbd05efde119724cd2efc91b1aa4ed9946905b5b878fedff52058dd017 15:33:55 [15:33:55.073] INFO: blob-sink:server Blob sidecar stored successfully for block 0xfce688fbd05efde119724cd2efc91b1aa4ed9946905b5b878fedff52058dd017 15:33:55 [15:33:55.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:55 [15:33:55.098] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 15:33:55 [15:33:55.100] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:33:55 [15:33:55.108] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:33:55 [15:33:55.136] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261162] on http://127.0.0.1:8545 15:33:55 [15:33:55.137] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:33:55 [15:33:55.140] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261162 15:33:55 [15:33:55.140] WARN: foundation:test-date-provider Time set to 2025-06-18T15:39:22.000Z {"offset":326860,"timeMs":1750261162000} 15:33:55 [15:33:55.140] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:33:55 [15:33:55.286] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2daed97ed18a0eb9759f15531a7f195d49bd4fd4ce6b642b36f6a2781cc7898e","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":2,"slotNumber":3,"timestamp":1750261126,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","archiveNextLeafIndex":3} 15:33:55 [15:33:55.289] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:33:55 [15:33:55.295] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:55 [15:33:55.394] INFO: e2e:e2e_partial_notes Deploying Token contract... 15:33:55 [15:33:55.802] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:55 [15:33:55.809] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 15:33:55 [15:33:55.815] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2 15:33:56 [15:33:56.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:56 [15:33:56.027] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.204297000000224,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750261126,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:33:56 [15:33:56.037] VERBOSE: p2p Synched to latest block 2 15:33:56 [15:33:56.358] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:56 [15:33:56.373] INFO: pxe:service Added contract Token at 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 15:33:56 [15:33:56.400] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","header":{"contentCommitment":{"blobsHash":"0x001d3c20086903427399fd0bf43c9bc7f319e88d1e60416298f7d43e613bd237","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750261126,"version":3628792160},"lastArchive":"0x24851cb17e95f8531f2b637c504284a6006648169bf95a4c3e382338c2122b0e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x26fbf0637bcea0b7a4b43de4971b307c63ba0fbbcaf813759d2c69f5cb0f90e6","nullifierTree":"0x076b030e7947a8d0d8ab35b6b71727de4dadfdb6b1fa7ea335409abb18150e80","publicDataTree":"0x161698709ea560e48f26a95a30b53c08da77b4b79dfde59708da5fda11daf5c1"},"totalFees":5018455040,"totalManaUsed":15104}} 15:33:56 [15:33:56.510] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:56 [15:33:56.564] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:33:56 [15:33:56.565] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:56 [15:33:56.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:56 [15:33:56.633] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","blockNumber":3,"slot":4} 15:33:56 [15:33:56.716] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:33:56 [15:33:56.725] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x236c86feb68f36cf9580c7b2546b0793dba633d1055dd8e6de9bc47781bb3808 15:33:56 [15:33:56.763] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:33:56 [15:33:56.764] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:33:56 [15:33:56.774] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:33:56 [15:33:56.774] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:33:56 [15:33:56.777] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:56 [15:33:56.784] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2fa54a76d9456994fade17636787ffbaa98f6a40dde51907836eff5dc9f4f291","nullifier":"0x1c40ca250d583b74fee405f88ad6e8435cf8f8d06566d60dd0e526c18f49f7b8"} 15:33:56 [15:33:56.793] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:33:56 [15:33:56.873] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 as fee payer 15:33:56 [15:33:56.983] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:57 [15:33:57.458] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 15:33:57 [15:33:57.555] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:33:57 [15:33:57.608] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:57 [15:33:57.676] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:33:57 [15:33:57.696] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","blockNumber":3,"slot":4} 15:33:57 [15:33:57.725] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:33:57 [15:33:57.742] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2,0x0000000000000000000000000000000000000000000000000000000000000001,0x220fb740d9c934f037264576c651e44e41ad53d9730555405b9cfc949c09fe78,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x194ddd03b6528c324d5269dcaf12a57094fdadbb214c263ee642618bccd7c117,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 15:33:57 [15:33:57.875] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:58 [15:33:58.179] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:58 [15:33:58.385] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","blockNumber":3,"slot":4} 15:33:58 [15:33:58.430] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:58 [15:33:58.818] INFO: pxe:service Proving completed in 2430.546552ms {"timings":{"total":2430.546552,"sync":15.256924000001163,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":480.8190979999963,"oracles":{"debugLog":{"times":[0.6914030000007187,0.38069300000279327,0.4264370000018971,0.5953969999973197,0.417435999999725,0.3076389999987441,0.4150859999972454,0.6072769999991579]},"fetchTaggedLogs":{"times":[157.5518009999978]},"loadCapsule":{"times":[0.3307910000003176,0.3468310000025667,1.0064519999978074,5.196621999999479,0.5090410000011616,2.728939000000537]},"getSharedSecret":{"times":[30.408000000003085]},"aes128Decrypt":{"times":[1.2016640000001644,1.235856999999669]},"getPublicKeysAndPartialAddress":{"times":[2.666004000002431]},"getKeyValidationRequest":{"times":[4.584363000001758]},"deliverNote":{"times":[10.446696000002703]},"deleteCapsule":{"times":[1.505763000001025]},"storeCapsule":{"times":[0.5705549999984214]},"getNotes":{"times":[7.9590019999996]},"getAuthWitness":{"times":[0.2501949999968929]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06194400000094902]},"callPrivateFunction":{"times":[731.4629879999993,142.01634800000102]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3726719999976922]}}},{"functionName":"private_kernel_init","time":91.89173300000039},{"functionName":"ContractClassRegisterer:register","time":717.4966129999993,"oracles":{"loadCapsule":{"times":[5.461997000002157]},"notifyCreatedNullifier":{"times":[0.3933230000002368]},"debugLog":{"times":[0.5022700000008626]},"notifyCreatedContractClassLog":{"times":[6.631603999998333]}}},{"functionName":"private_kernel_inner","time":119.5672659999982},{"functionName":"ContractInstanceDeployer:deploy","time":87.94613900000695,"oracles":{"storeInExecutionCache":{"times":[0.29328699999678065]},"callPrivateFunction":{"times":[55.99401299999954]},"notifyCreatedNullifier":{"times":[0.4408060000023397]},"debugLog":{"times":[0.6970709999986866]}}},{"functionName":"private_kernel_inner","time":99.83089500000278},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":40.63420199999746,"oracles":{}},{"functionName":"private_kernel_inner","time":121.33676099999866},{"functionName":"private_kernel_reset","time":183.08103499999925},{"functionName":"private_kernel_tail","time":73.3399219999992}],"unaccounted":399.3459640000001}} 15:33:58 [15:33:58.843] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:59 [15:33:59.030] VERBOSE: p2p:tx_pool Adding tx 0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2 to pool {"eventName":"tx-added-to-pool","txHash":"0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 15:33:59 [15:33:59.057] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:59 [15:33:59.060] INFO: node Received tx 0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2 {"txHash":"0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2"} 15:33:59 [15:33:59.061] INFO: pxe:service Sent transaction 0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2 15:33:59 [15:33:59.077] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 15:33:59 [15:33:59.088] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T15:39:22.000Z","now":"2025-06-18T15:39:25.948Z"} 15:33:59 [15:33:59.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:59 [15:33:59.488] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:59 [15:33:59.626] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":240.39388699999836} 15:33:59 [15:33:59.770] VERBOSE: simulator:public-processor Processed tx 0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2 with 1 public calls in 556.6385960000007ms {"txHash":"0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2","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.6385960000007} 15:33:59 [15:33:59.771] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:33:59 [15:33:59.775] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6864790820000016s {"duration":0.6864790820000016,"rate":556216.5111973493,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 15:34:00 [15:34:00.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:00 [15:34:00.016] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 406144.00896209775 mana/s {"blockHash":"0x1b8a10b0d18e871d9b5c748c59ae11e1bd7e958fad8933e5b93669a17c2638d1","globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":3,"slotNumber":4,"timestamp":1750261162,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1a12a1b3b0707d9765cc706b91e1f1043c022f23436607d5ace2f45c63e2d8b2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":939.322497000001,"publicProcessDuration":686.8785349999998,"rollupCircuitsDuration":928.7182780000003,"txCount":1,"blockNumber":3,"blockTimestamp":1750261162,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:34:00 [15:34:00.019] VERBOSE: sequencer Attesting committee is empty 15:34:00 [15:34:00.205] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:00 [15:34:00.404] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xe0a19f3e49be1fec4318f20692d0d9641b5045f71d03fc80e6c38c7071d5bff8 15:34:00 [15:34:00.404] VERBOSE: sequencer-client Sent L1 transaction 0xe0a19f3e49be1fec4318f20692d0d9641b5045f71d03fc80e6c38c7071d5bff8 {"gasLimit":470298,"maxFeePerGas":"1.279583357","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:34:00 [15:34:00.410] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:00 [15:34:00.417] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261198] on http://127.0.0.1:8545 15:34:00 [15:34:00.422] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:34:00 [15:34:00.425] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:34:00 [15:34:00.426] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe0a19f3e49be1fec4318f20692d0d9641b5045f71d03fc80e6c38c7071d5bff8","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750261162,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:34:00 [15:34:00.426] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:34:00 [15:34:00.429] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 15:34:00 [15:34:00.431] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261198 15:34:00 [15:34:00.431] WARN: foundation:test-date-provider Time set to 2025-06-18T15:39:58.000Z {"offset":357569,"timeMs":1750261198000} 15:34:00 [15:34:00.431] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:34:00 [15:34:00.433] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:34:00 [15:34:00.435] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 15:34:00 [15:34:00.438] INFO: blob-sink:server Received blob sidecar for block 0x1b8dfecdb02afdee7c488f4536263dbef18f85dac78cbc7b7772eb56007f7923 15:34:00 [15:34:00.445] INFO: blob-sink:server Blob sidecar stored successfully for block 0x1b8dfecdb02afdee7c488f4536263dbef18f85dac78cbc7b7772eb56007f7923 15:34:00 [15:34:00.617] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:00 [15:34:00.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:00 [15:34:00.877] VERBOSE: archiver:block-helper Store contract instance at 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2 15:34:00 [15:34:00.902] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 15:34:00 [15:34:00.952] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1b8a10b0d18e871d9b5c748c59ae11e1bd7e958fad8933e5b93669a17c2638d1","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":3,"slotNumber":4,"timestamp":1750261162,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","archiveNextLeafIndex":4} 15:34:00 [15:34:00.972] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 15:34:00 [15:34:00.991] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.272192000000359,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750261162,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 15:34:01 [15:34:01.065] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:01 [15:34:01.078] VERBOSE: p2p Synched to latest block 3 15:34:01 [15:34:01.366] INFO: aztecjs:deploy_sent_tx Contract 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2 successfully deployed. 15:34:01 [15:34:01.367] INFO: e2e:e2e_partial_notes L2 contract deployed 15:34:01 [15:34:01.370] INFO: e2e:e2e_partial_notes Running test: partial notes mint to private 15:34:01 [15:34:01.371] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:01 [15:34:01.581] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:01 [15:34:01.626] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","blockNumber":4,"slot":5} 15:34:01 [15:34:01.636] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","header":{"contentCommitment":{"blobsHash":"0x00bb4ef6421bc41ee5c35922de1eee4a7648d70c1236d6ca5b0a7bf04a95e88a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750261162,"version":3628792160},"lastArchive":"0x11b3b332f7089416de17f6e89bdbcbbefc35b7dc21b547468de855a8e148625c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x26fbf0637bcea0b7a4b43de4971b307c63ba0fbbcaf813759d2c69f5cb0f90e6","nullifierTree":"0x152f78435988c95df22c677096fc3263599d6731477432ba9f4da67509815642","publicDataTree":"0x0b65576667d64b7be2e87dd38db51bb8f811eb9ca1006d714a2821b18ee9dde3"},"totalFees":139009277500,"totalManaUsed":418375}} 15:34:01 [15:34:01.717] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:34:01 [15:34:01.761] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:34:01 [15:34:01.762] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:34:01 [15:34:01.792] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:01 [15:34:01.859] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06"} 15:34:01 [15:34:01.866] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x236c86feb68f36cf9580c7b2546b0793dba633d1055dd8e6de9bc47781bb3808 15:34:01 [15:34:01.878] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:34:01 [15:34:01.879] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:34:01 [15:34:01.885] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:34:01 [15:34:01.885] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:34:01 [15:34:01.889] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2fa54a76d9456994fade17636787ffbaa98f6a40dde51907836eff5dc9f4f291","nullifier":"0x1c40ca250d583b74fee405f88ad6e8435cf8f8d06566d60dd0e526c18f49f7b8"} 15:34:01 [15:34:01.891] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:34:01 [15:34:01.909] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c0e9249b9408cd2cdfdd0ca148be7fd15ecd902cae581914042813b2e1acc06 as fee payer 15:34:02 [15:34:02.067] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:02 [15:34:02.276] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2"} 15:34:02 [15:34:02.309] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:34:02 [15:34:02.309] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2"} 15:34:02 [15:34:02.444] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:02 [15:34:02.461] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","blockNumber":4,"slot":5} 15:34:02 [15:34:02.510] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2"} 15:34:02 [15:34:02.515] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:34:02 [15:34:02.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:03 [15:34:03.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:03 [15:34:03.174] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","blockNumber":4,"slot":5} 15:34:03 [15:34:03.368] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:03 [15:34:03.801] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:03 [15:34:03.958] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","blockNumber":4,"slot":5} 15:34:04 [15:34:04.234] INFO: pxe:service Proving completed in 2621.3208720000002ms {"timings":{"total":2621.3208720000002,"sync":24.905878000001394,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":342.122875999994,"oracles":{"debugLog":{"times":[0.7842469999995956,0.5157710000021325,0.45397700000103214,0.4699979999968491,0.4395570000015141,0.3448610000014014,0.43880600000193226,0.5152610000004643]},"fetchTaggedLogs":{"times":[102.47150099999999]},"loadCapsule":{"times":[0.16096900000047754,0.33961099999942235,0.673319999998057,0.4964700000018638,0.24861499999678927,0.24732500000027358]},"getSharedSecret":{"times":[5.637385000001814]},"aes128Decrypt":{"times":[0.24992500000007567,0.698631999999634]},"getPublicKeysAndPartialAddress":{"times":[1.3537099999994098]},"getKeyValidationRequest":{"times":[1.6250760000002629]},"deliverNote":{"times":[3.7494929999993474]},"deleteCapsule":{"times":[0.31014800000048126]},"storeCapsule":{"times":[0.38440300000002026]},"getNotes":{"times":[2.374160999999731]},"getAuthWitness":{"times":[0.2691560000021127]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.060362999996868894]},"callPrivateFunction":{"times":[1152.6535379999987]}}},{"functionName":"private_kernel_init","time":63.018919999998616},{"functionName":"Token:mint_to_private","time":1066.402809000003,"oracles":{"debugLog":{"times":[0.6350480000000971,0.5149899999996705]},"fetchTaggedLogs":{"times":[204.37576900000204]},"loadCapsule":{"times":[0.19617199999993318,0.14389899999878253,0.2055030000010447]},"getRandomField":{"times":[0.11365699999805656,0.12699699999939185,0.18007999999827007,0.0627039999999397,0.0466420000011567,0.05413299999781884,0.04535299999770359,0.047802999997657025,0.04176200000074459,0.05224300000190851,0.10336600000300677,0.04541300000346382]},"getIndexedTaggingSecretAsSender":{"times":[364.1773630000025]},"incrementAppTaggingSecretIndexAsSender":{"times":[145.4322310000025]},"notifyCreatedNullifier":{"times":[0.3037980000008247]},"storeInExecutionCache":{"times":[0.042762999997648876]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06191299999773037]}}},{"functionName":"private_kernel_inner","time":134.11004999999932},{"functionName":"private_kernel_reset","time":189.51864700000078},{"functionName":"private_kernel_tail","time":87.50407300000006}],"unaccounted":713.7376190000032}} 15:34:04 [15:34:04.263] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:04 [15:34:04.298] VERBOSE: p2p:tx_pool Adding tx 0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6 to pool {"eventName":"tx-added-to-pool","txHash":"0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 15:34:04 [15:34:04.311] INFO: node Received tx 0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6 {"txHash":"0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6"} 15:34:04 [15:34:04.311] INFO: pxe:service Sent transaction 0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6 15:34:04 [15:34:04.470] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:04 [15:34:04.490] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 15:34:04 [15:34:04.506] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-18T15:39:58.000Z","now":"2025-06-18T15:40:02.075Z"} 15:34:04 [15:34:04.597] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":55.5846590000001} 15:34:04 [15:34:04.623] VERBOSE: simulator:public-processor Processed tx 0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6 with 1 public calls in 105.34532200000103ms {"txHash":"0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6","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":105.34532200000103} 15:34:04 [15:34:04.625] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.11804661599999963s {"duration":0.11804661599999963,"rate":359984.90630176244,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 15:34:04 [15:34:04.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:04 [15:34:04.756] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 159285.09296862903 mana/s {"blockHash":"0x08cf4e1a2ec46c643a0656191dbc48c54e1c15b507f50469bb9dc7a467c89439","globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":4,"slotNumber":5,"timestamp":1750261198,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x27a3937e6167a819ca980c54f521d0d4323d694c412c7bb4af7cb6cc3af24fa6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":266.1739170000001,"publicProcessDuration":118.60670899999968,"rollupCircuitsDuration":250.3882709999998,"txCount":1,"blockNumber":4,"blockTimestamp":1750261198,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:34:04 [15:34:04.758] VERBOSE: sequencer Attesting committee is empty 15:34:04 [15:34:04.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:05 [15:34:05.075] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7bb6eb8e07e25972fdd90d6d2c4163b4046cf40b22a64b64ba0f2b4408bb3ce1 15:34:05 [15:34:05.076] VERBOSE: sequencer-client Sent L1 transaction 0x7bb6eb8e07e25972fdd90d6d2c4163b4046cf40b22a64b64ba0f2b4408bb3ce1 {"gasLimit":470310,"maxFeePerGas":"1.261127708","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:34:05 [15:34:05.086] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:34:05 [15:34:05.086] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7bb6eb8e07e25972fdd90d6d2c4163b4046cf40b22a64b64ba0f2b4408bb3ce1","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":4,"blockTimestamp":1750261198,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:34:05 [15:34:05.087] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:34:05 [15:34:05.092] INFO: blob-sink:server Received blob sidecar for block 0x4e953915e8cbbcd08a3290f69e3239bb3eab8a47e5bdecb31ca65a742e511f95 15:34:05 [15:34:05.096] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4e953915e8cbbcd08a3290f69e3239bb3eab8a47e5bdecb31ca65a742e511f95 15:34:05 [15:34:05.148] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:05 [15:34:05.156] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 15:34:05 [15:34:05.157] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 15:34:05 [15:34:05.159] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 15:34:05 [15:34:05.174] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261234] on http://127.0.0.1:8545 15:34:05 [15:34:05.175] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:34:05 [15:34:05.179] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261234 15:34:05 [15:34:05.179] WARN: foundation:test-date-provider Time set to 2025-06-18T15:40:34.000Z {"offset":388821,"timeMs":1750261234000} 15:34:05 [15:34:05.179] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 15:34:05 [15:34:05.354] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:05 [15:34:05.554] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x08cf4e1a2ec46c643a0656191dbc48c54e1c15b507f50469bb9dc7a467c89439","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3628792160,"blockNumber":4,"slotNumber":5,"timestamp":1750261198,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0a45869a099dff2293bb08b15a28c6e2f001062ac95f7f69185dfa10ae299fe5","archiveNextLeafIndex":5} 15:34:05 [15:34:05.556] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:05 [15:34:05.557] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 15:34:05 [15:34:05.659] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.8143940000009025,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750261198,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 15:34:05 [15:34:05.669] VERBOSE: p2p Synched to latest block 4 15:34:05 [15:34:05.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:05 [15:34:05.961] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:06 [15:34:06.111] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0a45869a099dff2293bb08b15a28c6e2f001062ac95f7f69185dfa10ae299fe5","blockNumber":5,"slot":6} 15:34:06 [15:34:06.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:06 [15:34:06.327] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x0a45869a099dff2293bb08b15a28c6e2f001062ac95f7f69185dfa10ae299fe5","header":{"contentCommitment":{"blobsHash":"0x00bac960c1e718799d8b7b36df3e3adcbda119df015ced79183e773e69033301","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750261198,"version":3628792160},"lastArchive":"0x23bb00579328541c9e6a5173c9e819527db4915138faa83b385e29b1c2af2e0e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x014e9f330d9804dcfd2a5bdee343d76088541f03a1f0df4798f71879e1979339","nullifierTree":"0x20762a040e72743d37440e66bc61667e76c8d01058f5a56adff03ad571ddad55","publicDataTree":"0x0bc62e2424cd8c107393ccacb4511b39757c2fd1a05e568b74c61e24744cb5d7"},"totalFees":3736336500,"totalManaUsed":73695}} 15:34:06 [15:34:06.461] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:06 [15:34:06.625] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2","selector":"0x4375727c"} 15:34:06 [15:34:06.635] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:34:06 [15:34:06.635] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2"} 15:34:06 [15:34:06.915] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:34:06 [15:34:06.919] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0a45869a099dff2293bb08b15a28c6e2f001062ac95f7f69185dfa10ae299fe5","blockNumber":5,"slot":6} 15:34:06 [15:34:06.971] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2"} 15:34:06 [15:34:06.976] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x13b68400a8d269a40ed4f65f8d0606ce3d2bd30a798328ec585de0bde3e89c5c 15:34:06 [15:34:06.985] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 15:34:06 [15:34:06.992] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 15:34:06 [15:34:06.999] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x12f870011a2942ae2e2a9d00a2e008a4aed1d1fa009b028302bcdcff60f4ba85 15:34:06 [15:34:06.999] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2 for storage slot 0x2ec13d77f63c0268df5b6e17d7d1ba0ce2db98024d9f6bed9afc305d5d424651 15:34:07 [15:34:07.009] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:34:07 [15:34:07.010] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x12f870011a2942ae2e2a9d00a2e008a4aed1d1fa009b028302bcdcff60f4ba85 15:34:07 [15:34:07.017] VERBOSE: pxe:service Added note {"index":192,"contract":"0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2","slot":"0x2ec13d77f63c0268df5b6e17d7d1ba0ce2db98024d9f6bed9afc305d5d424651","noteHash":"0x2273d653bf9af5cba01e3d06c9bc90c36cd8c7ec1544314a631b7524607de655","nullifier":"0x1825a39d682cb55d81202ea2f41819d99e0f247804d817e4d160a4f6cc8654bc"} 15:34:07 [15:34:07.031] VERBOSE: simulator Utility simulation for 0x11a4358bd2e0f083ebb0514ed8d8a39a2809fcf30c0d727b853be47450689bd2.0x4375727c completed 15:34:07 [15:34:07.038] INFO: node Stopping 15:34:07 [15:34:07.038] INFO: slasher Slasher client stopped. 15:34:07 [15:34:07.039] INFO: sequencer Stopped sequencer 15:34:07 [15:34:07.039] INFO: p2p P2P client stopped. 15:34:07 [15:34:07.041] INFO: world_state Stopped world state synchronizer 15:34:07 [15:34:07.041] INFO: archiver Stopped. 15:34:07 [15:34:07.041] INFO: node Stopped 15:34:07 [15:34:07.042] VERBOSE: e2e:e2e_partial_notes Cleaning up ACVM state 15:34:07 [15:34:07.042] INFO: e2e:e2e_partial_notes Cleaning up ACVM temp directory /tmp/d76479c3 15:34:07 [15:34:07.044] VERBOSE: e2e:e2e_partial_notes Cleaning up BB state 15:34:07 [15:34:07.059] INFO: blob-sink:server Stopping blob sink 15:34:07 [15:34:07.060] INFO: blob-sink:server Blob sink stopped 15:34:07 [15:34:07.060] VERBOSE: e2e:e2e_partial_notes Cleaning up data directory at /tmp/90471b906068fb11 15:34:07 PASS src/e2e_partial_notes.test.ts 15:34:07 partial notes 15:34:07 ✓ mint to private (5667 ms) 15:34:07 15:34:07 Test Suites: 1 passed, 1 total 15:34:07 Tests: 1 passed, 1 total 15:34:07 Snapshots: 0 total 15:34:07 Time: 28.145 s 15:34:07 Ran all test suites matching /src\/e2e_partial_notes.test.ts/i. 15:34:07 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?