ACI ·

Parent Log: http://ci.aztec-labs.com/2adfcb763b57baed 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/a3ecf3ea26aad0390dd15cfadbb1d160e85e5f89 Env: REF_NAME=gh-readonly-queue/master/pr-15194-f3a077dd83e56ee0ae0a1175f0dc39fdfa50e6d7 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Tue Jun 24 17:25:13 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15194_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_6b4a73ce992ff502_master 17:25:13 +++ id -u 17:25:13 +++ id -g 17:25:13 ++ docker run -d --name e2e_partial_notes --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_partial_notes.test.ts'\''' 17:25:13 + cid=a54fa012440b81d7392473cb02515a7211acc56f1f5c16d09f58f2d9af863606 17:25:13 + set +x 17:25:14 {"level":25,"time":1750785914200,"pid":12,"hostname":"a54fa012440b","module":"logger","msg":"Logger initialized with level verbose"} 17:25:20 [17:25:20.808] INFO: e2e:e2e_partial_notes Logging metrics to log/unknown.jsonl 17:25:21 [17:25:21.208] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-2iGg09/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:25:21 [17:25:21.264] INFO: e2e:e2e_partial_notes Calling anvil_setBlockTimestampInterval with params: [12] 17:25:21 [17:25:21.304] WARN: e2e:e2e_partial_notes Set block interval to 12 17:25:21 [17:25:21.305] VERBOSE: e2e:e2e_partial_notes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:25:21 [17:25:21.372] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:25:21 [17:25:21.391] VERBOSE: e2e:e2e_partial_notes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:25:21 [17:25:21.424] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:25:21 [17:25:21.437] VERBOSE: e2e:e2e_partial_notes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:25:21 [17:25:21.469] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:25:21 [17:25:21.485] VERBOSE: e2e:e2e_partial_notes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:25:21 [17:25:21.515] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:25:21 [17:25:21.523] VERBOSE: e2e:e2e_partial_notes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:25:21 [17:25:21.565] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:25:21 [17:25:21.572] VERBOSE: e2e:e2e_partial_notes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:25:21 [17:25:21.594] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:25:21 [17:25:21.602] VERBOSE: e2e:e2e_partial_notes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:25:21 [17:25:21.604] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 17:25:21 [17:25:21.605] INFO: e2e:e2e_partial_notes Waiting for 6 transactions to be mined... 17:25:21 [17:25:21.638] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:25:21 [17:25:21.684] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:25:21 [17:25:21.685] VERBOSE: e2e:e2e_partial_notes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:25:21 [17:25:21.721] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:25:21 [17:25:21.745] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:25:21 [17:25:21.752] VERBOSE: e2e:e2e_partial_notes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:25:21 [17:25:21.773] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:25:21 [17:25:21.774] VERBOSE: e2e:e2e_partial_notes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:25:21 [17:25:21.793] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:25:21 [17:25:21.797] VERBOSE: e2e:e2e_partial_notes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:25:21 [17:25:21.807] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:25:21 [17:25:21.807] VERBOSE: e2e:e2e_partial_notes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:25:21 [17:25:21.807] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 17:25:21 [17:25:21.807] INFO: e2e:e2e_partial_notes Waiting for 8 transactions to be mined... 17:25:21 [17:25:21.834] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:25:21 [17:25:21.858] VERBOSE: e2e:e2e_partial_notes Deployed shared contracts 17:25:21 [17:25:21.873] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:25:21 [17:25:21.874] VERBOSE: e2e:e2e_partial_notes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:25:21 [17:25:21.877] VERBOSE: e2e:e2e_partial_notes Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:25:21 [17:25:21.897] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:25:21 [17:25:21.926] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:25:21 [17:25:21.934] VERBOSE: e2e:e2e_partial_notes Awaiting for linked libraries to be deployed 17:25:21 [17:25:21.986] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x9b1598990122f66452556bd2bb3bb1278930c00aecb2a714b73be2dd111e8ef2 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:25:21 [17:25:21.992] VERBOSE: e2e:e2e_partial_notes Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:25:21 [17:25:21.992] INFO: e2e:e2e_partial_notes Waiting for 9 transactions to be mined... 17:25:22 [17:25:22.011] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:25:22 [17:25:22.012] VERBOSE: e2e:e2e_partial_notes All core contracts have been deployed 17:25:22 [17:25:22.026] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:25:22 [17:25:22.027] VERBOSE: e2e:e2e_partial_notes Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 17:25:22 [17:25:22.040] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:25:22 [17:25:22.048] VERBOSE: e2e:e2e_partial_notes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:25:22 [17:25:22.081] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:25:22 [17:25:22.082] VERBOSE: e2e:e2e_partial_notes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:25:22 [17:25:22.082] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 17:25:22 [17:25:22.137] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:25:22 [17:25:22.143] VERBOSE: e2e:e2e_partial_notes Rollup deployed 17:25:22 [17:25:22.144] VERBOSE: e2e:e2e_partial_notes Waiting for rollup and slash factory to be deployed 17:25:22 [17:25:22.144] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 17:25:22 [17:25:22.161] INFO: e2e:e2e_partial_notes All transactions mined successfully 17:25:22 [17:25:22.161] VERBOSE: e2e:e2e_partial_notes All transactions for L1 deployment have been mined 17:25:22 [17:25:22.176] INFO: e2e:e2e_partial_notes Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:25:22 [17:25:22.179] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:25:22 [17:25:22.181] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:22 [17:25:22.181] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:25:22 [17:25:22.182] INFO: telemetry:client Using NoopTelemetryClient 17:25:22 [17:25:22.187] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/c471596cbead0001/blob-sink with map size 134217728 KB (LMDB v2) 17:25:22 [17:25:22.188] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:25:22 [17:25:22.188] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:25:22 [17:25:22.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:22 [17:25:22.193] INFO: aztecjs:utils:watcher New L1 time: 1750786160 17:25:22 [17:25:22.193] WARN: foundation:test-date-provider Time set to 2025-06-24T17:29:20.000Z {"offset":237807,"timeMs":1750786160000} 17:25:22 [17:25:22.196] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:25:22 [17:25:22.203] INFO: blob-sink:server Server is running on http://localhost:33049 17:25:22 [17:25:22.203] VERBOSE: e2e:e2e_partial_notes Creating and synching an aztec node... 17:25:22 [17:25:22.204] VERBOSE: e2e:e2e_partial_notes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/64d5b788/acvm 17:25:22 [17:25:22.205] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33049"} 17:25:22 [17:25:22.224] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:25:22 [17:25:22.225] INFO: archiver:lmdb Creating archiver data store at directory /tmp/c471596cbead0001/archiver with map size 134217728 KB (LMDB v2) 17:25:22 [17:25:22.227] INFO: archiver:lmdb Starting data store with maxReaders 16 17:25:22 [17:25:22.458] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:22 [17:25:22.583] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33049"} 17:25:22 [17:25:22.607] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33049"} 17:25:22 [17:25:22.607] WARN: node:blob-sink:client No L1 consensus host urls configured 17:25:22 [17:25:22.607] WARN: node:blob-sink:client No archive client configured 17:25:22 [17:25:22.612] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x6ecbc02da89758563d3cbdc4ece79c8ff7256204d266bb6192e4df4812996fd5 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xcc46f1ab05f27858299a5b4eeaf1123e019255bd397202d046291984fe28d944","l1BlockNumber":16}} 17:25:22 [17:25:22.634] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:25:22 [17:25:22.646] INFO: world-state:database Creating world state data store at directory /tmp/c471596cbead0001/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:25:22 [17:25:22.669] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:22 [17:25:22.676] INFO: world_state Created world state synchroniser with block history of 64 17:25:22 [17:25:22.677] WARN: node Aztec node is accepting fake proofs 17:25:22 [17:25:22.687] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/c471596cbead0001/p2p with map size 134217728 KB (LMDB v2) 17:25:22 [17:25:22.689] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:25:22 [17:25:22.691] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/c471596cbead0001/p2p-archive with map size 134217728 KB (LMDB v2) 17:25:22 [17:25:22.692] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:25:22 [17:25:22.693] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/c471596cbead0001/p2p-peers with map size 134217728 KB (LMDB v2) 17:25:22 [17:25:22.698] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:25:22 [17:25:22.704] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:25:22 [17:25:22.705] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:25:22 [17:25:22.710] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:25:22 [17:25:22.711] INFO: world_state Started world state synchronizer from block 1 17:25:22 [17:25:22.716] VERBOSE: world-state:block_stream Starting sync from block number 0 17:25:22 [17:25:22.720] INFO: p2p Starting p2p client from block 0 with empty mempools 17:25:22 [17:25:22.720] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:25:22 [17:25:22.722] INFO: slasher Slasher client initialized 17:25:22 [17:25:22.723] INFO: slasher Starting Slasher client... 17:25:22 [17:25:22.773] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:25:22 [17:25:22.774] VERBOSE: node All Aztec Node subsystems synced 17:25:22 [17:25:22.786] INFO: sequencer-client Deploying forwarder contract 17:25:22 [17:25:22.793] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:25:22 [17:25:22.814] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:25:22 [17:25:22.815] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:25:22 [17:25:22.824] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:25:22 [17:25:22.848] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:25:22 [17:25:22.848] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:25:22 [17:25:22.849] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/64d5b788/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:25:23 [17:25:23.068] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:25:23 [17:25:23.073] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:25:23 [17:25:23.077] INFO: node Aztec Node version: 0.87.9 17:25:23 [17:25:23.077] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:25:23 [17:25:23.079] VERBOSE: e2e:e2e_partial_notes Creating a pxe... 17:25:23 [17:25:23.089] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:23 [17:25:23.103] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/99a9e5aa879a429e/pxe_data with map size 134217728 KB (LMDB v2) 17:25:23 [17:25:23.123] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:23 [17:25:23.124] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:25:23 [17:25:23.326] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:23 [17:25:23.412] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:25:23 [17:25:23.413] INFO: pxe:service Started PXE connected to chain 31337 version 2515967373 17:25:23 [17:25:23.479] INFO: pxe:service Registered account 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 17:25:23 [17:25:23.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:23 [17:25:23.570] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:25:23 [17:25:23.574] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 17:25:23 [17:25:23.795] INFO: pxe:service Added contract SchnorrAccount at 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:25:23 [17:25:23.803] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:23 [17:25:23.809] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:23 [17:25:23.856] VERBOSE: pxe:block_stream Starting sync from block number 0 17:25:23 [17:25:23.887] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:25:23 [17:25:23.997] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:25:24 [17:25:24.829] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:25:25 [17:25:25.005] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:25:25 [17:25:25.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:25 [17:25:25.168] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:25 [17:25:25.240] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.288] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:25 [17:25:25.289] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.316] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:25 [17:25:25.347] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.351] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:25 [17:25:25.534] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:25 [17:25:25.552] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.593] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:25 [17:25:25.594] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.635] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:25 [17:25:25.639] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:25 [17:25:25.652] VERBOSE: simulator:client_execution_context:debug_log Setting 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 as fee payer 17:25:25 [17:25:25.708] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:25 [17:25:25.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:26 [17:25:26.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:26 [17:25:26.351] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:26 [17:25:26.492] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:27 [17:25:27.050] INFO: pxe:service Proving completed in 3203.9145439999993ms {"timings":{"total":3203.9145439999993,"sync":9.968692000000374,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":175.91495600000053,"oracles":{"callPrivateFunction":{"times":[1146.5422910000016,377.2258590000001,193.49263300000166]}}},{"functionName":"private_kernel_init","time":103.6906629999994},{"functionName":"ContractClassRegisterer:register","time":1124.2470429999994,"oracles":{"loadCapsule":{"times":[72.80282299999999]},"notifyCreatedNullifier":{"times":[26.192917000000307]},"debugLog":{"times":[1.6985119999990275]},"notifyCreatedContractClassLog":{"times":[14.392547999999806]}}},{"functionName":"private_kernel_inner","time":170.13872300000003},{"functionName":"SchnorrAccount:constructor","time":335.8824229999973,"oracles":{"getContractInstance":{"times":[1.1994460000005347]},"debugLog":{"times":[0.564766999999847,0.5614069999992353]},"fetchTaggedLogs":{"times":[61.189250999999786]},"loadCapsule":{"times":[0.5564059999996971,0.3343199999999342,0.30017899999984365]},"notifyCreatedNullifier":{"times":[0.27521900000101596,0.3609410000008211]},"notifyCreatedNote":{"times":[0.45511400000032154]},"getRandomField":{"times":[0.52626600000076,1.0411610000010114,0.13054399999964517,0.1101940000007744,0.07956200000080571,0.0609809999987192,0.06515199999921606,0.07817299999987881,0.09737300000051619,0.31566900000143505,0.06639200000063283]},"getIndexedTaggingSecretAsSender":{"times":[42.074468999999226]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.740283000001]}}},{"functionName":"private_kernel_inner","time":130.81818700000076},{"functionName":"SchnorrAccount:entrypoint","time":168.19071500000064,"oracles":{"debugLog":{"times":[0.6236289999997098,0.30857900000046357,0.592398000000685]},"fetchTaggedLogs":{"times":[43.91872599999988]},"loadCapsule":{"times":[0.23237700000026962,0.20385600000008708,0.26982800000041607]},"getNotes":{"times":[1.921078999999736]},"getAuthWitness":{"times":[0.3045490000004065]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1135139999987587]}}},{"functionName":"private_kernel_inner","time":168.66335900000013},{"functionName":"private_kernel_reset","time":228.89140899999984},{"functionName":"private_kernel_tail","time":66.21386300000086}],"unaccounted":521.294511}} 17:25:27 [17:25:27.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:27 [17:25:27.180] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","blockNumber":1,"slot":2} 17:25:27 [17:25:27.187] VERBOSE: p2p:tx_pool Adding tx 0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543 to pool {"eventName":"tx-added-to-pool","txHash":"0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:25:27 [17:25:27.201] INFO: node Received tx 0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543 {"txHash":"0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543"} 17:25:27 [17:25:27.202] INFO: pxe:service Sent transaction 0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543 17:25:27 [17:25:27.277] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:27 [17:25:27.480] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:27 [17:25:27.686] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:27 [17:25:27.703] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:25:27 [17:25:27.718] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-24T17:29:44.000Z","now":"2025-06-24T17:29:25.525Z"} 17:25:27 [17:25:27.942] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:28 [17:25:28.006] VERBOSE: simulator:public-processor Processed tx 0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543 with no public calls in 194.76498100000026ms {"txHash":"0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543","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":194.76498100000026} 17:25:28 [17:25:28.011] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.29190250500000003s {"duration":0.29190250500000003,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:25:28 [17:25:28.121] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x219f9ae7d8a2c2450529e1d268729b63ed30c0e96fa9f47b40a8988019dc3203","globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":1,"slotNumber":2,"timestamp":1750786184,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x20dd39d9b2d95b33a6d7f6fbd6da03dc6711573c613a48e794293dad32516543"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":419.02081999999973,"publicProcessDuration":292.9100359999993,"rollupCircuitsDuration":405.2731219999987,"txCount":1,"blockNumber":1,"blockTimestamp":1750786184,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:25:28 [17:25:28.123] VERBOSE: sequencer Attesting committee is empty 17:25:28 [17:25:28.202] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:28 [17:25:28.429] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:28 [17:25:28.432] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x809ff9b03e20eb1479731db1a4ddbd7205ad94c880f307388560dc23371d0f61 17:25:28 [17:25:28.433] VERBOSE: sequencer-client Sent L1 transaction 0x809ff9b03e20eb1479731db1a4ddbd7205ad94c880f307388560dc23371d0f61 {"gasLimit":514538,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:25:28 [17:25:28.447] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:25:28 [17:25:28.447] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x809ff9b03e20eb1479731db1a4ddbd7205ad94c880f307388560dc23371d0f61","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1750786184,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:25:28 [17:25:28.448] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:25:28 [17:25:28.474] INFO: blob-sink:server Received blob sidecar for block 0xf03fee4da869503e8f41cb543c0af408612c71169ae857db95cc0c44ce61c956 17:25:28 [17:25:28.482] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf03fee4da869503e8f41cb543c0af408612c71169ae857db95cc0c44ce61c956 17:25:28 [17:25:28.630] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:28 [17:25:28.641] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:25:28 [17:25:28.644] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:25:28 [17:25:28.647] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:25:28 [17:25:28.778] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:25:28 [17:25:28.787] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786220] on http://127.0.0.1:8545 17:25:28 [17:25:28.789] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x219f9ae7d8a2c2450529e1d268729b63ed30c0e96fa9f47b40a8988019dc3203","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":1,"slotNumber":2,"timestamp":1750786184,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","archiveNextLeafIndex":2} 17:25:28 [17:25:28.791] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:25:28 [17:25:28.794] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786220 17:25:28 [17:25:28.794] WARN: foundation:test-date-provider Time set to 2025-06-24T17:30:20.000Z {"offset":291206,"timeMs":1750786220000} 17:25:28 [17:25:28.795] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:25:28 [17:25:28.833] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:28 [17:25:28.922] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":43.66111799999999,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750786184,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:25:28 [17:25:28.944] VERBOSE: p2p Synched to latest block 1 17:25:28 [17:25:28.945] INFO: pxe:service Registered account 0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37 17:25:29 [17:25:29.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:29 [17:25:29.049] INFO: pxe:service Added contract SchnorrAccount at 0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:25:29 [17:25:29.081] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","blockNumber":2,"slot":3} 17:25:29 [17:25:29.087] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","header":{"contentCommitment":{"blobsHash":"0x00525f9d9a738fb0834e639ad8e68aa6b5b2ce8073e30eb5857cabaebc475389","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750786184,"version":2515967373},"lastArchive":"0x1bc25fdf8a80b9c260b46d541279dcbf65dad8348fdcabb10b75808c719e1f0b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x225e027939331b5dd776ff0fc22546e28b645c70fe776ce4e196dcbf3161e1f8","nullifierTree":"0x18089a648f3850ca03fb16213a790d20a38e93fbe024057e184000b3b2473205","publicDataTree":"0x002d4bbf590d0c1d965991bd269bdeeff3d9f0ccd60386aeaaa8656661d66aad"},"totalFees":6794052480,"totalManaUsed":20448}} 17:25:29 [17:25:29.102] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:25:29 [17:25:29.200] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.252] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:29 [17:25:29.253] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.253] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:29 [17:25:29.324] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:25:29 [17:25:29.352] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.368] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:29 [17:25:29.464] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:29 [17:25:29.605] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.666] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:29 [17:25:29.667] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.671] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:29 [17:25:29.735] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","blockNumber":2,"slot":3} 17:25:29 [17:25:29.781] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37"} 17:25:29 [17:25:29.798] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:29 [17:25:29.867] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b926f4bd6f1a4cedaa9d42ddfd8147a93f3bb19a4fbd4ee01e9710c7251bb37 as fee payer 17:25:29 [17:25:29.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:30 [17:25:30.262] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:30 [17:25:30.361] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","blockNumber":2,"slot":3} 17:25:30 [17:25:30.750] INFO: pxe:service Proving completed in 1671.7832999999973ms {"timings":{"total":1671.7832999999973,"sync":9.698174999999537,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":100.50220499999887,"oracles":{"callPrivateFunction":{"times":[369.69428999999946,395.67691099999865]}}},{"functionName":"private_kernel_init","time":72.00734899999952},{"functionName":"SchnorrAccount:constructor","time":337.66273700000056,"oracles":{"getContractInstance":{"times":[2.800415999998222]},"debugLog":{"times":[0.6246289999999135,0.8428050000002258]},"fetchTaggedLogs":{"times":[112.49899000000005]},"loadCapsule":{"times":[0.4814439999991009,0.4912850000000617,0.5211350000008679]},"notifyCreatedNullifier":{"times":[0.5049159999998665,0.43974400000115565]},"notifyCreatedNote":{"times":[0.2939380000007077]},"getRandomField":{"times":[0.2656489999990299,0.4092820000005304,0.23734700000022713,0.1706450000001496,0.17909599999984493,0.19853500000135682,0.19037500000013097,0.1510340000004362,0.1763250000003609,0.1278840000013588,0.12547400000039488]},"getIndexedTaggingSecretAsSender":{"times":[41.670367000000624]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.24557900000036]}}},{"functionName":"private_kernel_inner","time":112.81304100000125},{"functionName":"SchnorrAccount:entrypoint","time":355.36326400000144,"oracles":{"debugLog":{"times":[0.8263260000003356,0.4444739999999001,0.6038790000002336]},"fetchTaggedLogs":{"times":[130.07501499999853]},"loadCapsule":{"times":[0.3046790000007604,0.23002699999960896,0.42590199999904144]},"getNotes":{"times":[1.8396259999990434]},"getAuthWitness":{"times":[56.16106699999909]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.49909500000103435]}}},{"functionName":"private_kernel_inner","time":106.13200700000016},{"functionName":"private_kernel_reset","time":178.7025829999984},{"functionName":"private_kernel_tail","time":100.0859730000011}],"unaccounted":298.8159659999965}} 17:25:30 [17:25:30.766] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:30 [17:25:30.810] VERBOSE: p2p:tx_pool Adding tx 0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273 to pool {"eventName":"tx-added-to-pool","txHash":"0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:25:30 [17:25:30.818] INFO: node Received tx 0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273 {"txHash":"0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273"} 17:25:30 [17:25:30.818] INFO: pxe:service Sent transaction 0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273 17:25:30 [17:25:30.888] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:25:30 [17:25:30.905] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-24T17:30:20.000Z","now":"2025-06-24T17:30:22.111Z"} 17:25:30 [17:25:30.933] VERBOSE: simulator:public-processor Processed tx 0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273 with no public calls in 17.087158999998792ms {"txHash":"0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273","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":17.087158999998792} 17:25:30 [17:25:30.937] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03077054599999974s {"duration":0.03077054599999974,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 17:25:31 [17:25:31.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:31 [17:25:31.057] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2dd4a3a74d15abf797063a57ec06e055245e2c1d472c37ec411e947f0a57b5ab","globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":2,"slotNumber":3,"timestamp":1750786220,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x28e1574a0072b7b18c53c9e44ac18802f1fbf6678cac0a8573e86242e1e66273"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":168.11229200000162,"publicProcessDuration":31.169647999999142,"rollupCircuitsDuration":152.62077000000136,"txCount":1,"blockNumber":2,"blockTimestamp":1750786220,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:31 [17:25:31.060] VERBOSE: sequencer Attesting committee is empty 17:25:31 [17:25:31.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:31 [17:25:31.314] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xd4d47fd7cd8dfd40ab62a763de4a4dc8aee2fd9772b0a1a72ec87ae945e6485a 17:25:31 [17:25:31.315] VERBOSE: sequencer-client Sent L1 transaction 0xd4d47fd7cd8dfd40ab62a763de4a4dc8aee2fd9772b0a1a72ec87ae945e6485a {"gasLimit":470269,"maxFeePerGas":"1.303611186","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:25:31 [17:25:31.326] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786256] on http://127.0.0.1:8545 17:25:31 [17:25:31.330] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:25:31 [17:25:31.333] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786256 17:25:31 [17:25:31.333] WARN: foundation:test-date-provider Time set to 2025-06-24T17:30:56.000Z {"offset":324667,"timeMs":1750786256000} 17:25:31 [17:25:31.334] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:25:31 [17:25:31.335] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:25:31 [17:25:31.335] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd4d47fd7cd8dfd40ab62a763de4a4dc8aee2fd9772b0a1a72ec87ae945e6485a","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750786220,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:31 [17:25:31.335] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:25:31 [17:25:31.339] INFO: blob-sink:server Received blob sidecar for block 0xd5c3e703373e960dfbd0f5e1827310713dcdc2179e1421190a247dde279103c9 17:25:31 [17:25:31.345] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd5c3e703373e960dfbd0f5e1827310713dcdc2179e1421190a247dde279103c9 17:25:31 [17:25:31.487] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2dd4a3a74d15abf797063a57ec06e055245e2c1d472c37ec411e947f0a57b5ab","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":2,"slotNumber":3,"timestamp":1750786220,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","archiveNextLeafIndex":3} 17:25:31 [17:25:31.508] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:31 [17:25:31.514] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:25:31 [17:25:31.515] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:25:31 [17:25:31.517] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:25:31 [17:25:31.592] INFO: e2e:e2e_partial_notes Deploying Token contract... 17:25:31 [17:25:31.954] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:31 [17:25:31.964] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 17:25:31 [17:25:31.969] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8 17:25:32 [17:25:32.167] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:32 [17:25:32.173] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.93769600000087,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750786220,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:32 [17:25:32.246] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:25:32 [17:25:32.248] VERBOSE: p2p Synched to latest block 2 17:25:32 [17:25:32.543] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:32 [17:25:32.586] INFO: pxe:service Added contract Token at 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:25:32 [17:25:32.765] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","header":{"contentCommitment":{"blobsHash":"0x00c5be6ded3e81afe7e2d24a944fcef78465e43ff42d89f7cf2df50fe5d1d370","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750786220,"version":2515967373},"lastArchive":"0x21a1566f47d64a1ccca83227370c19807ae43f56712820cacf6d5ab6f22b802d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11c9baa43e9f0233dc655b41f0d9b33ed2df53d444a2dc51b132e98085b0325f","nullifierTree":"0x15f86c7996fc6bc97581bde5055e4e92d833c1c12271369aa867e9bfb37d0e0f","publicDataTree":"0x2bb5d916548f5992dfbdb69f118fadb95c08223b3b84f3c408418d3ae54d235d"},"totalFees":5018455040,"totalManaUsed":15104}} 17:25:32 [17:25:32.767] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","blockNumber":3,"slot":4} 17:25:32 [17:25:32.800] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:32 [17:25:32.978] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:33 [17:25:33.035] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:33 [17:25:33.035] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:33 [17:25:33.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:33 [17:25:33.114] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:33 [17:25:33.121] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x240c6a6623ec4cdf31d8a5f57356dfce7fc0f8f6cf7bbc1e32c41c961ee0b37a 17:25:33 [17:25:33.132] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:25:33 [17:25:33.133] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:25:33 [17:25:33.140] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:25:33 [17:25:33.141] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:25:33 [17:25:33.148] VERBOSE: pxe:service Added note {"index":0,"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x03f9819a91193b93b74fa64c91e7d270480f8c77f3804079f7c5ddd431e5c4c8","nullifier":"0x143dcf288dee7f1e8138c2b86752e54e0413a98b11796c55d49161bebd09e696"} 17:25:33 [17:25:33.150] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:33 [17:25:33.165] VERBOSE: simulator:client_execution_context:debug_log Setting 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 as fee payer 17:25:33 [17:25:33.209] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:25:33 [17:25:33.650] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 17:25:33 [17:25:33.794] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:25:33 [17:25:33.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:33 [17:25:33.936] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:25:33 [17:25:33.949] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","blockNumber":3,"slot":4} 17:25:33 [17:25:33.990] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:25:34 [17:25:34.011] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8,0x0000000000000000000000000000000000000000000000000000000000000001,0x238f8f7a4e9a7e8e05500b2314e471b4a30a387c769eb9803ae7153a5b0af7ad,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x28220e807d1546b6157ae55dc4f11c7bccc29a893bea6e5508718b3458806e93,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 17:25:34 [17:25:34.077] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:34 [17:25:34.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:34 [17:25:34.523] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:34 [17:25:34.536] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","blockNumber":3,"slot":4} 17:25:34 [17:25:34.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:35 [17:25:35.031] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:35 [17:25:35.324] INFO: pxe:service Proving completed in 2647.390488000001ms {"timings":{"total":2647.390488000001,"sync":94.91271000000052,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":412.5559770000109,"oracles":{"debugLog":{"times":[0.8654780000033497,0.46320399999967776,0.3966519999994489,0.46579400000337046,0.484455000001617,0.32647999999971944,0.38482199999998556,0.8293059999996331]},"fetchTaggedLogs":{"times":[82.97267999999895]},"loadCapsule":{"times":[0.233527000000322,0.2378069999977015,0.5415070000017295,0.25791799999933573,0.15359499999976833,0.1662350000005972]},"getSharedSecret":{"times":[3.2763840000006894]},"aes128Decrypt":{"times":[1.0564130000020668,1.0615930000021763]},"getPublicKeysAndPartialAddress":{"times":[1.9533320000009553]},"getKeyValidationRequest":{"times":[2.0051429999984975]},"deliverNote":{"times":[7.464697999999771]},"deleteCapsule":{"times":[0.39869199999884586]},"storeCapsule":{"times":[0.3246499999986554]},"getNotes":{"times":[2.7947090000016033]},"getAuthWitness":{"times":[0.21554699999978766]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06607199999780278]},"callPrivateFunction":{"times":[690.5243520000004,161.19772899999953]},"notifyEnqueuedPublicFunctionCall":{"times":[0.6055789999991248]}}},{"functionName":"private_kernel_init","time":92.96784800000023},{"functionName":"ContractClassRegisterer:register","time":669.9249269999964,"oracles":{"loadCapsule":{"times":[3.2736039999981585]},"notifyCreatedNullifier":{"times":[0.4360529999976279]},"debugLog":{"times":[0.6068899999991118]},"notifyCreatedContractClassLog":{"times":[6.198677000000316]}}},{"functionName":"private_kernel_inner","time":129.75455800000054},{"functionName":"ContractInstanceDeployer:deploy","time":112.4800699999978,"oracles":{"storeInExecutionCache":{"times":[0.26906899999812595]},"callPrivateFunction":{"times":[59.74675099999877]},"notifyCreatedNullifier":{"times":[0.5917090000002645]},"debugLog":{"times":[0.8653269999995246]}}},{"functionName":"private_kernel_inner","time":147.52086399999826},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":31.755679999998392,"oracles":{}},{"functionName":"private_kernel_inner","time":252.9417190000022},{"functionName":"private_kernel_reset","time":191.42686099999992},{"functionName":"private_kernel_tail","time":100.80711800000063}],"unaccounted":410.34215599999516}} 17:25:35 [17:25:35.353] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:35 [17:25:35.540] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","blockNumber":3,"slot":4} 17:25:35 [17:25:35.547] VERBOSE: p2p:tx_pool Adding tx 0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79 to pool {"eventName":"tx-added-to-pool","txHash":"0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 17:25:35 [17:25:35.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:35 [17:25:35.568] INFO: node Received tx 0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79 {"txHash":"0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79"} 17:25:35 [17:25:35.568] INFO: pxe:service Sent transaction 0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79 17:25:35 [17:25:35.771] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:35 [17:25:35.974] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:36 [17:25:36.055] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:25:36 [17:25:36.068] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-24T17:30:56.000Z","now":"2025-06-24T17:31:00.735Z"} 17:25:36 [17:25:36.218] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:36 [17:25:36.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:36 [17:25:36.577] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":205.03227299999708} 17:25:36 [17:25:36.737] VERBOSE: simulator:public-processor Processed tx 0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79 with 1 public calls in 505.90229700000054ms {"txHash":"0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79","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":505.90229700000054} 17:25:36 [17:25:36.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:36 [17:25:36.741] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6716928630000002s {"duration":0.6716928630000002,"rate":568460.7073158672,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 17:25:36 [17:25:36.909] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 447044.70755110873 mana/s {"blockHash":"0x254a79a36529305f3531325254650bd1703c19a5034f4a90dae7b8ddc0a05510","globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":3,"slotNumber":4,"timestamp":1750786256,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x15d78ac868262481ad506a5fe898b679b84a18ffe54cf49bc0d35b70607c8e79"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":853.5926310000032,"publicProcessDuration":672.0413840000001,"rollupCircuitsDuration":841.9332900000009,"txCount":1,"blockNumber":3,"blockTimestamp":1750786256,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:25:36 [17:25:36.912] VERBOSE: sequencer Attesting committee is empty 17:25:37 [17:25:37.006] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:37 [17:25:37.192] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5d01a5f235077cd10383e2a8a990a73f9b677097944d788e570a60e6d7563939 17:25:37 [17:25:37.192] VERBOSE: sequencer-client Sent L1 transaction 0x5d01a5f235077cd10383e2a8a990a73f9b677097944d788e570a60e6d7563939 {"gasLimit":470248,"maxFeePerGas":"1.279583383","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:25:37 [17:25:37.203] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:25:37 [17:25:37.203] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5d01a5f235077cd10383e2a8a990a73f9b677097944d788e570a60e6d7563939","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1750786256,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:25:37 [17:25:37.204] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:25:37 [17:25:37.210] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:37 [17:25:37.216] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:25:37 [17:25:37.220] INFO: blob-sink:server Received blob sidecar for block 0x8a3fc4a8fbf37abbf15cba839c6385bde7419725558bc71a611e6b1eeb103271 17:25:37 [17:25:37.226] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:25:37 [17:25:37.231] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:25:37 [17:25:37.232] INFO: blob-sink:server Blob sidecar stored successfully for block 0x8a3fc4a8fbf37abbf15cba839c6385bde7419725558bc71a611e6b1eeb103271 17:25:37 [17:25:37.236] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786292] on http://127.0.0.1:8545 17:25:37 [17:25:37.238] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:25:37 [17:25:37.240] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786292 17:25:37 [17:25:37.240] WARN: foundation:test-date-provider Time set to 2025-06-24T17:31:32.000Z {"offset":354760,"timeMs":1750786292000} 17:25:37 [17:25:37.240] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:25:37 [17:25:37.416] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:37 [17:25:37.650] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:37 [17:25:37.671] VERBOSE: archiver:block-helper Store contract instance at 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8 17:25:37 [17:25:37.701] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:25:37 [17:25:37.744] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x254a79a36529305f3531325254650bd1703c19a5034f4a90dae7b8ddc0a05510","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":3,"slotNumber":4,"timestamp":1750786256,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","archiveNextLeafIndex":4} 17:25:37 [17:25:37.759] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:25:37 [17:25:37.774] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.0137030000005325,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750786256,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:25:37 [17:25:37.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:37 [17:25:37.882] VERBOSE: p2p Synched to latest block 3 17:25:38 [17:25:38.064] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:38 [17:25:38.265] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:38 [17:25:38.282] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","blockNumber":4,"slot":5} 17:25:38 [17:25:38.472] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:38 [17:25:38.860] INFO: aztecjs:deploy_sent_tx Contract 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8 successfully deployed. 17:25:38 [17:25:38.860] INFO: e2e:e2e_partial_notes L2 contract deployed 17:25:38 [17:25:38.863] INFO: e2e:e2e_partial_notes Running test: partial notes mint to private 17:25:38 [17:25:38.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:39 [17:25:39.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:39 [17:25:39.078] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","blockNumber":4,"slot":5} 17:25:39 [17:25:39.106] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","header":{"contentCommitment":{"blobsHash":"0x00ced184892e904bed9d9a87b03810d6f794a7fcced7d2a033e2e321c0dbd88d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750786256,"version":2515967373},"lastArchive":"0x025c4fadf4883a4c4704e04472b0eafcb94c4228987caf3d7c7874e7d384fa87","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11c9baa43e9f0233dc655b41f0d9b33ed2df53d444a2dc51b132e98085b0325f","nullifierTree":"0x00a5ceca5e86a88ea2152e3a96a7520fb1a7c1c4531c216d13ff453dca082e5e","publicDataTree":"0x1f19a5a3f35dc3b973e61507a31c805eab39f78140910a4519addb4075faae97"},"totalFees":139009277500,"totalManaUsed":418375}} 17:25:39 [17:25:39.200] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:39 [17:25:39.240] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:39 [17:25:39.241] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:39 [17:25:39.275] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:39 [17:25:39.318] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299"} 17:25:39 [17:25:39.325] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x240c6a6623ec4cdf31d8a5f57356dfce7fc0f8f6cf7bbc1e32c41c961ee0b37a 17:25:39 [17:25:39.334] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:25:39 [17:25:39.335] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:25:39 [17:25:39.341] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:25:39 [17:25:39.341] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:25:39 [17:25:39.347] VERBOSE: pxe:service Added note {"index":0,"contract":"0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x03f9819a91193b93b74fa64c91e7d270480f8c77f3804079f7c5ddd431e5c4c8","nullifier":"0x143dcf288dee7f1e8138c2b86752e54e0413a98b11796c55d49161bebd09e696"} 17:25:39 [17:25:39.349] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:39 [17:25:39.364] VERBOSE: simulator:client_execution_context:debug_log Setting 0x13ff7d760f992849be3d37319b331483587891d290adb65e2701a6a0d16d3299 as fee payer 17:25:39 [17:25:39.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:39 [17:25:39.666] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8"} 17:25:39 [17:25:39.715] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:25:39 [17:25:39.715] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8"} 17:25:39 [17:25:39.729] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:39 [17:25:39.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:40 [17:25:40.002] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","blockNumber":4,"slot":5} 17:25:40 [17:25:40.041] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8"} 17:25:40 [17:25:40.046] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:25:40 [17:25:40.238] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:40 [17:25:40.501] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:40 [17:25:40.882] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:41 [17:25:41.010] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","blockNumber":4,"slot":5} 17:25:41 [17:25:41.250] INFO: pxe:service Proving completed in 2166.239967999998ms {"timings":{"total":2166.239967999998,"sync":24.640733999996883,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":323.7102089999935,"oracles":{"debugLog":{"times":[0.5769189999991795,0.4149230000002717,0.4392539999971632,0.4252840000008291,0.3650310000011814,0.25632799999948475,0.4399139999986801,0.5049159999980475]},"fetchTaggedLogs":{"times":[81.80856299999868]},"loadCapsule":{"times":[0.19456699999864213,0.1580950000025041,0.4909850000003644,0.28710900000078254,0.2535680000000866,0.46948499999780324]},"getSharedSecret":{"times":[3.3297459999994317]},"aes128Decrypt":{"times":[0.21963700000196695,0.7850150000012945]},"getPublicKeysAndPartialAddress":{"times":[1.6603629999990517]},"getKeyValidationRequest":{"times":[1.4845280000008643]},"deliverNote":{"times":[6.134394999997312]},"deleteCapsule":{"times":[0.2334870000013325]},"storeCapsule":{"times":[0.21907699999792385]},"getNotes":{"times":[1.6906239999989339]},"getAuthWitness":{"times":[0.2537880000018049]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04552200000034645]},"callPrivateFunction":{"times":[885.170474999999]}}},{"functionName":"private_kernel_init","time":86.22883400000137},{"functionName":"Token:mint_to_private","time":797.0920240000014,"oracles":{"debugLog":{"times":[0.6177889999999024,0.3355410000003758]},"fetchTaggedLogs":{"times":[330.2533179999991]},"loadCapsule":{"times":[0.20488599999953294,0.1851859999987937,0.1983360000012908]},"getRandomField":{"times":[0.11412399999971967,0.09177199999976438,0.1347139999998035,0.036450999999942724,0.03648100000282284,0.03548099999898113,0.030831000000034692,0.02875099999801023,0.04076100000020233,0.051310999999259366,0.039951999999175314,0.03327100000024075]},"getIndexedTaggingSecretAsSender":{"times":[95.46798800000033]},"incrementAppTaggingSecretIndexAsSender":{"times":[83.49457600000096]},"notifyCreatedNullifier":{"times":[0.25395799999751034]},"storeInExecutionCache":{"times":[0.06493200000113575]},"notifyEnqueuedPublicFunctionCall":{"times":[0.047752000002219575]}}},{"functionName":"private_kernel_inner","time":102.81640200000038},{"functionName":"private_kernel_reset","time":161.49332899999717},{"functionName":"private_kernel_tail","time":79.90539200000057}],"unaccounted":590.3530440000068}} 17:25:41 [17:25:41.276] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:41 [17:25:41.298] VERBOSE: p2p:tx_pool Adding tx 0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228 to pool {"eventName":"tx-added-to-pool","txHash":"0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 17:25:41 [17:25:41.308] INFO: node Received tx 0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228 {"txHash":"0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228"} 17:25:41 [17:25:41.308] INFO: pxe:service Sent transaction 0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228 17:25:41 [17:25:41.480] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:41 [17:25:41.535] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:25:41 [17:25:41.552] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-24T17:31:32.000Z","now":"2025-06-24T17:31:36.312Z"} 17:25:41 [17:25:41.625] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":45.53355900000315} 17:25:41 [17:25:41.652] VERBOSE: simulator:public-processor Processed tx 0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228 with 1 public calls in 83.99799300000086ms {"txHash":"0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228","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":83.99799300000086} 17:25:41 [17:25:41.654] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10056748999999764s {"duration":0.10056748999999764,"rate":422552.05931858293,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 17:25:41 [17:25:41.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:41 [17:25:41.794] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 163358.6448189685 mana/s {"blockHash":"0x0a2ab4b6efc88f53fc7bad14d0445a8978c30b7d06434bcd96a11a432a6e585f","globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":4,"slotNumber":5,"timestamp":1750786292,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x10ef75a01a73e9663a6a38f9bbffa991bde42e3a71c079b9ad957001683d4228"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":259.48469599999953,"publicProcessDuration":101.07278700000097,"rollupCircuitsDuration":242.67922199999884,"txCount":1,"blockNumber":4,"blockTimestamp":1750786292,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:41 [17:25:41.797] VERBOSE: sequencer Attesting committee is empty 17:25:41 [17:25:41.980] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:42 [17:25:42.126] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xa5f5e9a2df1eda9107138e363197a5f11c6b4b61cc825c781c6a6a27274390ac 17:25:42 [17:25:42.126] VERBOSE: sequencer-client Sent L1 transaction 0xa5f5e9a2df1eda9107138e363197a5f11c6b4b61cc825c781c6a6a27274390ac {"gasLimit":470246,"maxFeePerGas":"1.261127721","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:25:42 [17:25:42.136] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:25:42 [17:25:42.136] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa5f5e9a2df1eda9107138e363197a5f11c6b4b61cc825c781c6a6a27274390ac","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":4,"blockTimestamp":1750786292,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:42 [17:25:42.136] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:25:42 [17:25:42.141] INFO: blob-sink:server Received blob sidecar for block 0x8c97d61212e2989b313823ee5599ebe6756b8530bedf4422cfd331c3378762e0 17:25:42 [17:25:42.146] INFO: blob-sink:server Blob sidecar stored successfully for block 0x8c97d61212e2989b313823ee5599ebe6756b8530bedf4422cfd331c3378762e0 17:25:42 [17:25:42.184] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:42 [17:25:42.192] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:25:42 [17:25:42.193] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:25:42 [17:25:42.195] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:25:42 [17:25:42.336] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750786328] on http://127.0.0.1:8545 17:25:42 [17:25:42.337] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:25:42 [17:25:42.339] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750786328 17:25:42 [17:25:42.339] WARN: foundation:test-date-provider Time set to 2025-06-24T17:32:08.000Z {"offset":385661,"timeMs":1750786328000} 17:25:42 [17:25:42.339] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:25:42 [17:25:42.390] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:42 [17:25:42.589] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0a2ab4b6efc88f53fc7bad14d0445a8978c30b7d06434bcd96a11a432a6e585f","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2515967373,"blockNumber":4,"slotNumber":5,"timestamp":1750786292,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x14c44d2de84ad918fa82c0599004f0c8c3a94d5bc262a4013f54f92069b12972","archiveNextLeafIndex":5} 17:25:42 [17:25:42.591] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:42 [17:25:42.592] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:25:42 [17:25:42.694] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.758456000003207,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750786292,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:25:42 [17:25:42.705] VERBOSE: p2p Synched to latest block 4 17:25:42 [17:25:42.793] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:42 [17:25:42.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:43 [17:25:43.156] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x14c44d2de84ad918fa82c0599004f0c8c3a94d5bc262a4013f54f92069b12972","blockNumber":5,"slot":6} 17:25:43 [17:25:43.199] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:43 [17:25:43.322] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x14c44d2de84ad918fa82c0599004f0c8c3a94d5bc262a4013f54f92069b12972","header":{"contentCommitment":{"blobsHash":"0x008118b996d7b3cfede18ff7ef0284adf65ace4991301bc3aa182e79522f6582","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750786292,"version":2515967373},"lastArchive":"0x1bb13ab7e8e4b6545f202f2856dcef9c5c987a7a7c4f6c771a400c0dd7d7ab7d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x26e29167f70ab73ca199be7111285ee461b7a6200aa260db215642f2ea4b3042","nullifierTree":"0x29613e0f56167f9ea9a4f35aacaa8bb63d614a26725148dff6936f2f494aed21","publicDataTree":"0x17ff32462dab44548b9ef1cbfb6a142400dd473cb9d153968a3a5b3d9a2ec7f0"},"totalFees":3736336500,"totalManaUsed":73695}} 17:25:43 [17:25:43.426] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:43 [17:25:43.614] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8","selector":"0x4375727c"} 17:25:43 [17:25:43.626] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:25:43 [17:25:43.626] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8"} 17:25:43 [17:25:43.630] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:43 [17:25:43.835] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:25:43 [17:25:43.868] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x14c44d2de84ad918fa82c0599004f0c8c3a94d5bc262a4013f54f92069b12972","blockNumber":5,"slot":6} 17:25:43 [17:25:43.890] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8"} 17:25:43 [17:25:43.895] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1ce3ba8e434509d0d5abd1b86286b5caa0133d34e3fea1f57af1ec8874e08c1f 17:25:43 [17:25:43.908] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 17:25:43 [17:25:43.911] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 17:25:43 [17:25:43.916] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x2a0c4e339ebbe29d39177c55a2f62eb98fe6534766f979cd6fd649e4c2d4994f 17:25:43 [17:25:43.917] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8 for storage slot 0x25197143929af5917b0f063dbe4954bc2befe0c6994bdedc35c9f7731a160dc5 17:25:43 [17:25:43.927] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:25:43 [17:25:43.928] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x2a0c4e339ebbe29d39177c55a2f62eb98fe6534766f979cd6fd649e4c2d4994f 17:25:43 [17:25:43.933] VERBOSE: pxe:service Added note {"index":192,"contract":"0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8","slot":"0x25197143929af5917b0f063dbe4954bc2befe0c6994bdedc35c9f7731a160dc5","noteHash":"0x253e946bfb7a562fbf5f076d1460b8ee76ede23c882d9eed5e3004ea2e9cc618","nullifier":"0x04a07c19b3d81ac865251efa32b82b10ca4ce576120fe2c5f132ff2d9102a3cc"} 17:25:43 [17:25:43.937] VERBOSE: simulator Utility simulation for 0x1169a2042462402279400cef2fd0ab9b1434ba442ba86e8a09a7689c275e0db8.0x4375727c completed 17:25:43 [17:25:43.943] INFO: node Stopping 17:25:43 [17:25:43.943] INFO: slasher Slasher client stopped. 17:25:43 [17:25:43.944] INFO: sequencer Stopped sequencer 17:25:43 [17:25:43.944] INFO: p2p P2P client stopped. 17:25:43 [17:25:43.946] INFO: world_state Stopped world state synchronizer 17:25:43 [17:25:43.946] INFO: archiver Stopped. 17:25:43 [17:25:43.946] INFO: node Stopped 17:25:43 [17:25:43.946] VERBOSE: e2e:e2e_partial_notes Cleaning up ACVM state 17:25:43 [17:25:43.946] INFO: e2e:e2e_partial_notes Cleaning up ACVM temp directory /tmp/64d5b788 17:25:43 [17:25:43.947] VERBOSE: e2e:e2e_partial_notes Cleaning up BB state 17:25:43 [17:25:43.958] INFO: blob-sink:server Stopping blob sink 17:25:43 [17:25:43.959] INFO: blob-sink:server Blob sink stopped 17:25:43 [17:25:43.959] VERBOSE: e2e:e2e_partial_notes Cleaning up data directory at /tmp/c471596cbead0001 17:25:43 PASS src/e2e_partial_notes.test.ts 17:25:43 partial notes 17:25:43 ✓ mint to private (5079 ms) 17:25:43 17:25:43 Test Suites: 1 passed, 1 total 17:25:43 Tests: 1 passed, 1 total 17:25:43 Snapshots: 0 total 17:25:43 Time: 29.948 s 17:25:43 Ran all test suites matching /src\/e2e_partial_notes.test.ts/i. 17:25:43 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?