Parent Log: http://ci.aztec-labs.com/bac80ed53a95468a Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_double_spend yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_double_spend.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:08:05 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_1cff06cb3d45a684_master 17:08:05 +++ id -u 17:08:05 +++ id -g 17:08:05 ++ docker run -d --name e2e_double_spend --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_double_spend.test.ts'\''' 17:08:05 + cid=4b8979ee965e404719c5ddc3e49f3e1c26230d4819b768dde5ae5dcf0a31cdb0 17:08:05 + set +x 17:08:06 {"level":25,"time":1749834486415,"pid":12,"hostname":"4b8979ee965e","module":"logger","msg":"Logger initialized with level verbose"} 17:08:13 [17:08:13.010] INFO: e2e:e2e_double_spend Logging metrics to log/unknown.jsonl 17:08:13 [17:08:13.339] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-dMhMpK/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:08:13 [17:08:13.389] INFO: e2e:e2e_double_spend Calling anvil_setBlockTimestampInterval with params: [12] 17:08:13 [17:08:13.423] WARN: e2e:e2e_double_spend Set block interval to 12 17:08:13 [17:08:13.424] VERBOSE: e2e:e2e_double_spend Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:13 [17:08:13.522] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:08:13 [17:08:13.534] VERBOSE: e2e:e2e_double_spend Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:08:13 [17:08:13.561] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:08:13 [17:08:13.571] VERBOSE: e2e:e2e_double_spend Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:08:13 [17:08:13.624] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:08:13 [17:08:13.633] VERBOSE: e2e:e2e_double_spend Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:08:13 [17:08:13.668] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:08:13 [17:08:13.678] VERBOSE: e2e:e2e_double_spend Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:08:13 [17:08:13.700] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:08:13 [17:08:13.708] VERBOSE: e2e:e2e_double_spend Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:08:13 [17:08:13.725] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:08:13 [17:08:13.732] VERBOSE: e2e:e2e_double_spend Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:08:13 [17:08:13.733] VERBOSE: e2e:e2e_double_spend Waiting for deployments to complete 17:08:13 [17:08:13.733] INFO: e2e:e2e_double_spend Waiting for 6 transactions to be mined... 17:08:13 [17:08:13.758] INFO: e2e:e2e_double_spend All transactions mined successfully 17:08:13 [17:08:13.783] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:08:13 [17:08:13.784] VERBOSE: e2e:e2e_double_spend Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:08:13 [17:08:13.800] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:08:13 [17:08:13.819] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:08:13 [17:08:13.825] VERBOSE: e2e:e2e_double_spend Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:08:13 [17:08:13.837] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:08:13 [17:08:13.837] VERBOSE: e2e:e2e_double_spend Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:08:13 [17:08:13.853] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:08:13 [17:08:13.866] VERBOSE: e2e:e2e_double_spend Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:08:13 [17:08:13.882] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:08:13 [17:08:13.882] VERBOSE: e2e:e2e_double_spend Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:08:13 [17:08:13.882] VERBOSE: e2e:e2e_double_spend Waiting for deployments to complete 17:08:13 [17:08:13.883] INFO: e2e:e2e_double_spend Waiting for 8 transactions to be mined... 17:08:13 [17:08:13.903] INFO: e2e:e2e_double_spend All transactions mined successfully 17:08:13 [17:08:13.932] VERBOSE: e2e:e2e_double_spend Deployed shared contracts 17:08:13 [17:08:13.969] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:08:13 [17:08:13.970] VERBOSE: e2e:e2e_double_spend Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:08:13 [17:08:13.974] VERBOSE: e2e:e2e_double_spend Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:14 [17:08:14.002] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:08:14 [17:08:14.029] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:08:14 [17:08:14.036] VERBOSE: e2e:e2e_double_spend Awaiting for linked libraries to be deployed 17:08:14 [17:08:14.088] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x8fa29c20daf93e4b265fad6e6f909688c0aaa857436f5e6a959f2e94a67bd0d4 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:08:14 [17:08:14.102] VERBOSE: e2e:e2e_double_spend Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:14 [17:08:14.103] INFO: e2e:e2e_double_spend Waiting for 9 transactions to be mined... 17:08:14 [17:08:14.152] INFO: e2e:e2e_double_spend All transactions mined successfully 17:08:14 [17:08:14.153] VERBOSE: e2e:e2e_double_spend All core contracts have been deployed 17:08:14 [17:08:14.174] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:08:14 [17:08:14.175] VERBOSE: e2e:e2e_double_spend Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:08:14 [17:08:14.192] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:08:14 [17:08:14.202] VERBOSE: e2e:e2e_double_spend Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:08:14 [17:08:14.242] VERBOSE: e2e:e2e_double_spend Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:08:14 [17:08:14.243] VERBOSE: e2e:e2e_double_spend Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:08:14 [17:08:14.243] INFO: e2e:e2e_double_spend Waiting for 10 transactions to be mined... 17:08:14 [17:08:14.275] INFO: e2e:e2e_double_spend All transactions mined successfully 17:08:14 [17:08:14.282] VERBOSE: e2e:e2e_double_spend Rollup deployed 17:08:14 [17:08:14.282] VERBOSE: e2e:e2e_double_spend Waiting for rollup and slash factory to be deployed 17:08:14 [17:08:14.282] INFO: e2e:e2e_double_spend Waiting for 10 transactions to be mined... 17:08:14 [17:08:14.310] INFO: e2e:e2e_double_spend All transactions mined successfully 17:08:14 [17:08:14.311] VERBOSE: e2e:e2e_double_spend All transactions for L1 deployment have been mined 17:08:14 [17:08:14.346] INFO: e2e:e2e_double_spend Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:08:14 [17:08:14.351] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:08:14 [17:08:14.354] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.355] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:08:14 [17:08:14.357] INFO: telemetry:client Using NoopTelemetryClient 17:08:14 [17:08:14.362] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/623f3802c07997c1/blob-sink with map size 134217728 KB (LMDB v2) 17:08:14 [17:08:14.366] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:08:14 [17:08:14.367] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:08:14 [17:08:14.376] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.379] INFO: aztecjs:utils:watcher New L1 time: 1749834733 17:08:14 [17:08:14.380] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:13.000Z {"offset":238620,"timeMs":1749834733000} 17:08:14 [17:08:14.386] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:08:14 [17:08:14.403] INFO: blob-sink:server Server is running on http://localhost:38001 17:08:14 [17:08:14.404] VERBOSE: e2e:e2e_double_spend Creating and synching an aztec node... 17:08:14 [17:08:14.405] VERBOSE: e2e:e2e_double_spend Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/af42cbc1/acvm 17:08:14 [17:08:14.408] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:38001"} 17:08:14 [17:08:14.447] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:08:14 [17:08:14.448] INFO: archiver:lmdb Creating archiver data store at directory /tmp/623f3802c07997c1/archiver with map size 134217728 KB (LMDB v2) 17:08:14 [17:08:14.455] INFO: archiver:lmdb Starting data store with maxReaders 16 17:08:14 [17:08:14.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.922] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:38001"} 17:08:14 [17:08:14.950] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:38001"} 17:08:14 [17:08:14.950] WARN: node:blob-sink:client No L1 consensus host urls configured 17:08:14 [17:08:14.950] WARN: node:blob-sink:client No archive client configured 17:08:14 [17:08:14.955] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xeed44ab78b85f7113813a82896c5675715d655f2f98f833185df26dd7300ec91 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x0f8de96a8e0509f10ba1cf486f55c316c9473a12ac13b90f0e2216309675ed89","l1BlockNumber":16}} 17:08:15 [17:08:15.023] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xeed44ab78b85f7113813a82896c5675715d655f2f98f833185df26dd7300ec91","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:08:15 [17:08:15.032] INFO: world-state:database Creating world state data store at directory /tmp/623f3802c07997c1/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:08:15 [17:08:15.070] INFO: world_state Created world state synchroniser with block history of 64 17:08:15 [17:08:15.070] WARN: node Aztec node is accepting fake proofs 17:08:15 [17:08:15.083] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/623f3802c07997c1/p2p with map size 134217728 KB (LMDB v2) 17:08:15 [17:08:15.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.100] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:08:15 [17:08:15.102] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/623f3802c07997c1/p2p-archive with map size 134217728 KB (LMDB v2) 17:08:15 [17:08:15.105] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:08:15 [17:08:15.109] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/623f3802c07997c1/p2p-peers with map size 134217728 KB (LMDB v2) 17:08:15 [17:08:15.112] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:08:15 [17:08:15.113] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:08:15 [17:08:15.114] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:08:15 [17:08:15.116] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:08:15 [17:08:15.117] INFO: world_state Started world state synchronizer from block 1 17:08:15 [17:08:15.123] VERBOSE: world-state:block_stream Starting sync from block number 0 17:08:15 [17:08:15.125] INFO: p2p Starting p2p client from block 0 with empty mempools 17:08:15 [17:08:15.126] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:08:15 [17:08:15.128] INFO: slasher Slasher client initialized 17:08:15 [17:08:15.128] INFO: slasher Starting Slasher client... 17:08:15 [17:08:15.176] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:15 [17:08:15.176] VERBOSE: node All Aztec Node subsystems synced 17:08:15 [17:08:15.186] INFO: sequencer-client Deploying forwarder contract 17:08:15 [17:08:15.193] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:08:15 [17:08:15.209] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:08:15 [17:08:15.209] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:08:15 [17:08:15.219] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:15 [17:08:15.246] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:15 [17:08:15.247] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:08:15 [17:08:15.247] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/af42cbc1/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:15 [17:08:15.495] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:15 [17:08:15.497] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:15 [17:08:15.499] INFO: node Aztec Node version: 0.87.8 17:08:15 [17:08:15.499] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:08:15 [17:08:15.500] VERBOSE: e2e:e2e_double_spend Creating a pxe... 17:08:15 [17:08:15.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.511] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/d72798be1f1a3f8e/pxe_data with map size 134217728 KB (LMDB v2) 17:08:15 [17:08:15.522] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:15 [17:08:15.523] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:15 [17:08:15.709] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.786] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:15 [17:08:15.787] INFO: pxe:service Started PXE connected to chain 31337 version 4259969856 17:08:15 [17:08:15.836] INFO: pxe:service Registered account 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 17:08:15 [17:08:15.902] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:15 [17:08:15.904] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 17:08:15 [17:08:15.930] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.036] INFO: pxe:service Added contract SchnorrAccount at 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:16 [17:08:16.046] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:16 [17:08:16.094] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:16 [17:08:16.115] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:16 [17:08:16.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.218] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:17 [17:08:17.004] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:17 [17:08:17.166] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:17 [17:08:17.277] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.357] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:17 [17:08:17.434] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.478] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:17 [17:08:17.480] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.561] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.566] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:17 [17:08:17.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.784] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.836] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:17 [17:08:17.837] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.902] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.903] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:17 [17:08:17.914] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:17 [17:08:17.921] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:17 [17:08:17.943] VERBOSE: simulator:client_execution_context:debug_log Setting 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 as fee payer 17:08:18 [17:08:18.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.488] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:18 [17:08:18.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.229] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:19 [17:08:19.757] INFO: pxe:service Proving completed in 3665.8356839999997ms {"timings":{"total":3665.8356839999997,"sync":3.40967400000045,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":175.22916700000133,"oracles":{"callPrivateFunction":{"times":[1108.7162849999986,418.79463300000134,270.67853099999957]}}},{"functionName":"private_kernel_init","time":164.34020599999894},{"functionName":"ContractClassRegisterer:register","time":1084.8337350000002,"oracles":{"loadCapsule":{"times":[77.6424709999992]},"notifyCreatedNullifier":{"times":[0.9477440000009665]},"debugLog":{"times":[1.1610969999983354]},"notifyCreatedContractClassLog":{"times":[20.409131000000343]}}},{"functionName":"private_kernel_inner","time":233.91530799999964},{"functionName":"SchnorrAccount:constructor","time":375.76931500000137,"oracles":{"getContractInstance":{"times":[1.073220999998739]},"debugLog":{"times":[1.0525199999992765,0.6106250000011642]},"fetchTaggedLogs":{"times":[85.3939620000001]},"loadCapsule":{"times":[0.6160149999996065,0.46079700000154844,0.3191079999996873]},"notifyCreatedNullifier":{"times":[0.27240600000004633,0.27410600000075647]},"notifyCreatedNote":{"times":[0.5177000000003318]},"getRandomField":{"times":[0.5723820000002888,0.23870399999941583,0.07559399999991001,0.05352300000049581,0.053743000000395114,0.060833999999886146,0.0482030000002851,0.05152300000008836,0.05175299999973504,0.06493399999999383,0.05016299999988405]},"getIndexedTaggingSecretAsSender":{"times":[45.64280899999903]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.57816699999967]}}},{"functionName":"private_kernel_inner","time":190.01859899999909},{"functionName":"SchnorrAccount:entrypoint","time":232.11714599999868,"oracles":{"debugLog":{"times":[0.8895410000004631,0.914361999999528,0.8023159999993368]},"fetchTaggedLogs":{"times":[81.3791229999988]},"loadCapsule":{"times":[0.6171050000011746,0.6963489999998274,0.4941580000013346]},"getNotes":{"times":[3.320488999999725]},"getAuthWitness":{"times":[0.5292400000016642]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0849720000005618]}}},{"functionName":"private_kernel_inner","time":158.63657200000125},{"functionName":"private_kernel_reset","time":241.19351199999983},{"functionName":"private_kernel_tail","time":107.92930499999966}],"unaccounted":698.4431449999993}} 17:08:19 [17:08:19.781] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.935] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","blockNumber":1,"slot":2} 17:08:19 [17:08:19.954] VERBOSE: p2p:tx_pool Adding tx 0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18 to pool {"eventName":"tx-added-to-pool","txHash":"0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:19 [17:08:19.984] INFO: node Received tx 0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18 {"txHash":"0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18"} 17:08:19 [17:08:19.984] INFO: pxe:service Sent transaction 0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18 17:08:19 [17:08:19.991] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.197] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.403] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.463] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:08:20 [17:08:20.478] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:12:37.000Z","now":"2025-06-13T17:12:19.098Z"} 17:08:20 [17:08:20.649] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.741] VERBOSE: simulator:public-processor Processed tx 0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18 with no public calls in 183.03253100000074ms {"txHash":"0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18","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":183.03253100000074} 17:08:20 [17:08:20.744] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2641154170000009s {"duration":0.2641154170000009,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:08:20 [17:08:20.893] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.906] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2be70a7d799f816fb17bed055e9f11cf12e944475b6b40572493efacd13d4242","globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":1,"slotNumber":2,"timestamp":1749834757,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x06b6fc0aa1952aa03e01e567b07e1f44e15f5456258d92afbb290dd446113e18"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":443.4283059999998,"publicProcessDuration":265.00910900000054,"rollupCircuitsDuration":429.13453299999856,"txCount":1,"blockNumber":1,"blockTimestamp":1749834757,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:20 [17:08:20.908] VERBOSE: sequencer Attesting committee is empty 17:08:21 [17:08:21.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.317] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xae0f17b188ad54bf11c26875024665f3aa535fa9074e115355ed5f79e7a77e2a 17:08:21 [17:08:21.318] VERBOSE: sequencer-client Sent L1 transaction 0xae0f17b188ad54bf11c26875024665f3aa535fa9074e115355ed5f79e7a77e2a {"gasLimit":514599,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:08:21 [17:08:21.329] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:08:21 [17:08:21.335] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:08:21 [17:08:21.340] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:08:21 [17:08:21.344] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:21 [17:08:21.345] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xae0f17b188ad54bf11c26875024665f3aa535fa9074e115355ed5f79e7a77e2a","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":1,"blockTimestamp":1749834757,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:21 [17:08:21.346] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:21 [17:08:21.383] INFO: blob-sink:server Received blob sidecar for block 0x6889eaf1cf45eb68197944cf606e5f41130bb8f3575667aec004814657d2a25c 17:08:21 [17:08:21.395] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6889eaf1cf45eb68197944cf606e5f41130bb8f3575667aec004814657d2a25c 17:08:21 [17:08:21.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.605] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:21 [17:08:21.619] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2be70a7d799f816fb17bed055e9f11cf12e944475b6b40572493efacd13d4242","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":1,"slotNumber":2,"timestamp":1749834757,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","archiveNextLeafIndex":2} 17:08:21 [17:08:21.620] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834793] on http://127.0.0.1:8545 17:08:21 [17:08:21.625] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:21 [17:08:21.636] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834793 17:08:21 [17:08:21.636] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:13.000Z {"offset":291364,"timeMs":1749834793000} 17:08:21 [17:08:21.637] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:08:21 [17:08:21.639] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:08:22 [17:08:22.109] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.120] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":415.75015099999837,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834757,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:22 [17:08:22.122] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 17:08:22 [17:08:22.128] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608 17:08:22 [17:08:22.348] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.464] VERBOSE: p2p Synched to latest block 1 17:08:22 [17:08:22.817] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.838] INFO: pxe:service Added contract Test at 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 17:08:22 [17:08:22.870] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","blockNumber":2,"slot":3} 17:08:22 [17:08:22.875] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","header":{"contentCommitment":{"blobsHash":"0x002cb3805b604f49f4aef6dc1c1fe231319bea51f3b5556ec275ea678f6a0c3b","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834757,"version":4259969856},"lastArchive":"0x1173f573f4b4a9c17837b1bf0fec661425f7cefc4ce93778ac0ba3169c2a384b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x01eb17c275efd229ef0596534980d5ef48d97da889b94d2d9ccc8cef64035b44","nullifierTree":"0x15de2eff621258ce96682285c9a73a1769e80b453e0bee8d89ceff9f316f01c6","publicDataTree":"0x06167c9446ed08ade68a1a1f5f1ddadbf81afe64fc867310c8151e3c2dc37355"},"totalFees":6794052480,"totalManaUsed":20448}} 17:08:23 [17:08:23.015] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:23 [17:08:23.064] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:23 [17:08:23.065] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:23 [17:08:23.066] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.166] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:23 [17:08:23.172] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d01baeda8f998ae18a661dc579c7b064483a340903d9513c631022eca25bed9 17:08:23 [17:08:23.190] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:23 [17:08:23.191] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:23 [17:08:23.201] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:23 [17:08:23.202] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:23 [17:08:23.208] VERBOSE: pxe:service Added note {"index":0,"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x130ca575deae9c72c82a9b2d0501017f7fcc66b55da86d7388c746f496a2e1ea","nullifier":"0x19b036f51aea4e221fe8fae89f9906eafdd1dd1af192efdf500fc25555d99524"} 17:08:23 [17:08:23.210] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:23 [17:08:23.237] VERBOSE: simulator:client_execution_context:debug_log Setting 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 as fee payer 17:08:23 [17:08:23.283] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.300] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:23 [17:08:23.860] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 17:08:24 [17:08:24.020] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:24 [17:08:24.179] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:24 [17:08:24.196] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","blockNumber":2,"slot":3} 17:08:24 [17:08:24.232] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:24 [17:08:24.244] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608,0x0000000000000000000000000000000000000000000000000000000000000001,0x181156b9826324dc227d13249f267506c4ae615b629376f1e5768baa2ab511df,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 17:08:24 [17:08:24.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.982] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608"} 17:08:25 [17:08:25.020] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.038] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:25 [17:08:25.039] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608"} 17:08:25 [17:08:25.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.329] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","blockNumber":2,"slot":3} 17:08:25 [17:08:25.365] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608"} 17:08:25 [17:08:25.370] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:25 [17:08:25.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.724] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.939] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.056] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","blockNumber":2,"slot":3} 17:08:26 [17:08:26.213] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.344] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.372] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","blockNumber":2,"slot":3} 17:08:27 [17:08:27.830] INFO: pxe:service Proving completed in 4968.6361099999995ms {"timings":{"total":4968.6361099999995,"sync":15.930207000001246,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":804.1482529999994,"oracles":{"debugLog":{"times":[0.666138000000501,0.5456010000016249,0.5563220000003639,0.6893190000009781,0.7196709999989253,0.5081890000001295,0.4253839999983029,0.9634150000019872]},"fetchTaggedLogs":{"times":[103.99220100000093]},"loadCapsule":{"times":[0.3198279999996885,0.6956300000019837,0.943953000001784,0.44968599999992875,0.2713449999973818,0.3699909999995725]},"getSharedSecret":{"times":[6.693630999998277]},"aes128Decrypt":{"times":[1.4405819999992673,1.310894999998709]},"getPublicKeysAndPartialAddress":{"times":[2.57084599999871]},"getKeyValidationRequest":{"times":[2.7950090000013006]},"deliverNote":{"times":[5.783348999997543]},"deleteCapsule":{"times":[0.5284600000013597]},"storeCapsule":{"times":[0.452926000001753]},"getNotes":{"times":[8.861403999999311]},"getAuthWitness":{"times":[0.339629000001878]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09610600000087288]},"callPrivateFunction":{"times":[859.2287600000018,148.73642800000016,1132.5006890000004]}}},{"functionName":"private_kernel_init","time":103.90954599999895},{"functionName":"ContractClassRegisterer:register","time":836.8588369999961,"oracles":{"loadCapsule":{"times":[5.600218999999925]},"notifyCreatedNullifier":{"times":[0.927321999999549]},"debugLog":{"times":[1.5581789999996545]},"notifyCreatedContractClassLog":{"times":[26.626286000002438]}}},{"functionName":"private_kernel_inner","time":191.9842299999982},{"functionName":"ContractInstanceDeployer:deploy","time":100.35106299999825,"oracles":{"storeInExecutionCache":{"times":[0.19664100000227336]},"callPrivateFunction":{"times":[55.22347400000217]},"notifyCreatedNullifier":{"times":[0.3158689999982016]},"debugLog":{"times":[0.5375310000017635]}}},{"functionName":"private_kernel_inner","time":154.66883600000074},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.36425400000371,"oracles":{}},{"functionName":"private_kernel_inner","time":150.40535300000192},{"functionName":"Test:initialize","time":686.3537579999975,"oracles":{"getContractInstance":{"times":[29.576954000000114]},"debugLog":{"times":[0.8033260000011069,0.6091050000031828]},"fetchTaggedLogs":{"times":[329.1863720000001]},"loadCapsule":{"times":[0.32929800000056275,0.24346399999922141,0.31573800000114716]},"notifyCreatedNullifier":{"times":[0.31043700000009267]}}},{"functionName":"private_kernel_inner","time":156.44201699999758},{"functionName":"private_kernel_reset","time":205.25992600000245},{"functionName":"private_kernel_tail","time":83.49046299999827}],"unaccounted":1443.4693670000051}} 17:08:27 [17:08:27.854] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.035] VERBOSE: p2p:tx_pool Adding tx 0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd to pool {"eventName":"tx-added-to-pool","txHash":"0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:28 [17:08:28.056] INFO: node Received tx 0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd {"txHash":"0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd"} 17:08:28 [17:08:28.057] INFO: pxe:service Sent transaction 0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd 17:08:28 [17:08:28.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.066] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:08:28 [17:08:28.083] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:13:13.000Z","now":"2025-06-13T17:13:19.447Z"} 17:08:28 [17:08:28.274] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.357] VERBOSE: simulator:public-processor Processed tx 0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd with no public calls in 188.96760799999902ms {"txHash":"0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd","txFee":7272506880,"revertCode":0,"gasUsed":{"totalGas":{"daGas":310272,"l2Gas":21888},"billedGas":{"daGas":310272,"l2Gas":21888},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":188.96760799999902} 17:08:28 [17:08:28.363] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.27955260700000145s {"duration":0.27955260700000145,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 17:08:28 [17:08:28.515] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.525] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1429ca90d232ce81d4da6b2ff0b6b7b98e2981dbd3686ba19f6fb8ba038ecdf9","globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":2,"slotNumber":3,"timestamp":1749834793,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0b690627dc4b77e9afe97af4cd2499b4e8d42370a043bcecd6e5c1e3ce7001fd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":459.0124140000007,"publicProcessDuration":279.9818809999997,"rollupCircuitsDuration":443.235095,"txCount":1,"blockNumber":2,"blockTimestamp":1749834793,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:08:28 [17:08:28.530] VERBOSE: sequencer Attesting committee is empty 17:08:28 [17:08:28.723] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.871] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4b60dc1bcc39afb4c919a8d1a90e9771fc2f044d5aa89fb6fde16eadbac46837 17:08:28 [17:08:28.872] VERBOSE: sequencer-client Sent L1 transaction 0x4b60dc1bcc39afb4c919a8d1a90e9771fc2f044d5aa89fb6fde16eadbac46837 {"gasLimit":470298,"maxFeePerGas":"1.303611222","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:28 [17:08:28.960] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.993] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:08:29 [17:08:29.006] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:08:29 [17:08:29.018] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:29 [17:08:29.019] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4b60dc1bcc39afb4c919a8d1a90e9771fc2f044d5aa89fb6fde16eadbac46837","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1749834793,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:08:29 [17:08:29.020] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:29 [17:08:29.030] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834829] on http://127.0.0.1:8545 17:08:29 [17:08:29.032] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:08:29 [17:08:29.036] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:29 [17:08:29.040] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834829 17:08:29 [17:08:29.041] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:49.000Z {"offset":319960,"timeMs":1749834829000} 17:08:29 [17:08:29.041] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:08:29 [17:08:29.046] INFO: blob-sink:server Received blob sidecar for block 0x18e170fbb24d32c9a49d580c36d9a9f5319131192659c3372e3b4f4031e4f0b4 17:08:29 [17:08:29.066] INFO: blob-sink:server Blob sidecar stored successfully for block 0x18e170fbb24d32c9a49d580c36d9a9f5319131192659c3372e3b4f4031e4f0b4 17:08:29 [17:08:29.280] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.302] VERBOSE: archiver:block-helper Store contract instance at 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608 17:08:29 [17:08:29.333] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 17:08:29 [17:08:29.391] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1429ca90d232ce81d4da6b2ff0b6b7b98e2981dbd3686ba19f6fb8ba038ecdf9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":2,"slotNumber":3,"timestamp":1749834793,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","archiveNextLeafIndex":3} 17:08:29 [17:08:29.399] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:08:29 [17:08:29.487] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.500] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.934449000000313,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834793,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:08:29 [17:08:29.523] VERBOSE: p2p Synched to latest block 2 17:08:29 [17:08:29.554] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","blockNumber":3,"slot":4} 17:08:29 [17:08:29.694] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.087] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","blockNumber":3,"slot":4} 17:08:30 [17:08:30.296] INFO: aztecjs:deploy_sent_tx Contract 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608 successfully deployed. 17:08:30 [17:08:30.296] INFO: e2e:e2e_double_spend Test contract deployed at 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608 17:08:30 [17:08:30.299] INFO: e2e:e2e_double_spend Running test: e2e_double_spend double spends emits a public nullifier and then tries to emit the same nullifier 17:08:30 [17:08:30.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.339] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","header":{"contentCommitment":{"blobsHash":"0x00d602b905e1a92b502efb94e0c4d620b98eb182dd857db0d9cda25a4fd2c8d9","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834793,"version":4259969856},"lastArchive":"0x09f3fdc29e1c2b5fa8b0851dcaeb8e6d2e55cfad6d7cecee57d74a3e7015abba","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x01eb17c275efd229ef0596534980d5ef48d97da889b94d2d9ccc8cef64035b44","nullifierTree":"0x27e05d62f07eb90c57931780615004892fabf5f72d4475e8b950161cb786598a","publicDataTree":"0x02fbe6c398522ff91aea19c5ed616a084c684f7037602a0cd5ce96a9c1962989"},"totalFees":7272506880,"totalManaUsed":21888}} 17:08:30 [17:08:30.428] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:30 [17:08:30.472] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:30 [17:08:30.472] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:30 [17:08:30.515] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.551] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:30 [17:08:30.571] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d01baeda8f998ae18a661dc579c7b064483a340903d9513c631022eca25bed9 17:08:30 [17:08:30.586] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:30 [17:08:30.587] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:30 [17:08:30.614] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:30 [17:08:30.614] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:30 [17:08:30.621] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","blockNumber":3,"slot":4} 17:08:30 [17:08:30.622] VERBOSE: pxe:service Added note {"index":0,"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x130ca575deae9c72c82a9b2d0501017f7fcc66b55da86d7388c746f496a2e1ea","nullifier":"0x19b036f51aea4e221fe8fae89f9906eafdd1dd1af192efdf500fc25555d99524"} 17:08:30 [17:08:30.625] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:30 [17:08:30.643] VERBOSE: simulator:client_execution_context:debug_log Setting 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 as fee payer 17:08:30 [17:08:30.744] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.213] INFO: pxe:service Proving completed in 882.786874999998ms {"timings":{"total":882.786874999998,"sync":12.501812000002246,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":283.80471899999975,"oracles":{"debugLog":{"times":[0.7432120000012219,0.5393010000007052,0.5379100000027393,0.6569369999997434,0.5665120000012394,0.4539660000009462,0.34759000000121887,0.6966600000014296]},"fetchTaggedLogs":{"times":[96.65880299999844]},"loadCapsule":{"times":[0.37427100000059,0.2191930000008142,0.5505120000016177,0.2604939999982889,0.2518739999977697,0.18855099999927916]},"getSharedSecret":{"times":[6.053995000002033]},"aes128Decrypt":{"times":[0.3159379999997327,1.0923020000009274]},"getPublicKeysAndPartialAddress":{"times":[8.773949999998877]},"getKeyValidationRequest":{"times":[13.07008400000268]},"deliverNote":{"times":[8.084840000003169]},"deleteCapsule":{"times":[0.402552999999898]},"storeCapsule":{"times":[0.39288200000009965]},"getNotes":{"times":[1.9284800000023097]},"getAuthWitness":{"times":[0.31350799999927403]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06866400000217254]},"notifyEnqueuedPublicFunctionCall":{"times":[0.41394299999956274]}}},{"functionName":"private_kernel_init","time":95.80859500000224},{"functionName":"private_kernel_reset","time":238.0639340000016},{"functionName":"private_kernel_tail","time":100.91023900000073}],"unaccounted":151.6975759999914}} 17:08:31 [17:08:31.254] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.309] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","blockNumber":3,"slot":4} 17:08:31 [17:08:31.314] VERBOSE: p2p:tx_pool Adding tx 0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64 to pool {"eventName":"tx-added-to-pool","txHash":"0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 17:08:31 [17:08:31.330] INFO: node Received tx 0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64 {"txHash":"0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64"} 17:08:31 [17:08:31.331] INFO: pxe:service Sent transaction 0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64 17:08:31 [17:08:31.462] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.666] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.866] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:08:31 [17:08:31.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.892] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:13:49.000Z","now":"2025-06-13T17:13:51.852Z"} 17:08:32 [17:08:32.017] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x8a4870ec completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x8a4870ec","duration":61.97739100000035} 17:08:32 [17:08:32.057] VERBOSE: simulator:public-processor Processed tx 0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64 with 1 public calls in 130.83878499999992ms {"txHash":"0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64","txFee":11840749620,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":35637},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":9781},"billedGas":{"daGas":1536,"l2Gas":35637}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":130.83878499999992} 17:08:32 [17:08:32.060] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1664401629999993s {"duration":0.1664401629999993,"rate":58765.864102164094,"totalPublicGas":{"daGas":512,"l2Gas":9781},"totalBlockGas":{"daGas":1536,"l2Gas":35637},"totalSizeInBytes":288} 17:08:32 [17:08:32.092] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.236] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 26367.753836753567 mana/s {"blockHash":"0x2cbea4d476a41398afea126a121a4bc72861e2821052012869d52a2657facfa3","globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":3,"slotNumber":4,"timestamp":1749834829,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x234d3d3c0a89742c189061e50e0e8863df46777f0782a000b7ee5d7bdd76eb64"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":370.06890399999975,"publicProcessDuration":166.98244300000079,"rollupCircuitsDuration":346.95172699999966,"txCount":1,"blockNumber":3,"blockTimestamp":1749834829,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:32 [17:08:32.239] VERBOSE: sequencer Attesting committee is empty 17:08:32 [17:08:32.366] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.632] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.641] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xaa8da62a5e8d06cf6abafa5990c68e793334a1351f9930a582bebdf81cc68152 17:08:32 [17:08:32.641] VERBOSE: sequencer-client Sent L1 transaction 0xaa8da62a5e8d06cf6abafa5990c68e793334a1351f9930a582bebdf81cc68152 {"gasLimit":470283,"maxFeePerGas":"1.279583427","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:32 [17:08:32.656] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:32 [17:08:32.657] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaa8da62a5e8d06cf6abafa5990c68e793334a1351f9930a582bebdf81cc68152","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1749834829,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:32 [17:08:32.658] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:32 [17:08:32.662] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834865] on http://127.0.0.1:8545 17:08:32 [17:08:32.665] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:32 [17:08:32.667] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834865 17:08:32 [17:08:32.667] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:25.000Z {"offset":352333,"timeMs":1749834865000} 17:08:32 [17:08:32.668] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:08:32 [17:08:32.669] INFO: blob-sink:server Received blob sidecar for block 0x84b7ff0b0b54c54985c6b8d592449c5c81697c7fdc4b0b7998e32d11f0dc555a 17:08:32 [17:08:32.674] INFO: blob-sink:server Blob sidecar stored successfully for block 0x84b7ff0b0b54c54985c6b8d592449c5c81697c7fdc4b0b7998e32d11f0dc555a 17:08:32 [17:08:32.839] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.848] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:08:32 [17:08:32.851] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:08:32 [17:08:32.853] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:08:33 [17:08:33.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.145] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x2cbea4d476a41398afea126a121a4bc72861e2821052012869d52a2657facfa3","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":3,"slotNumber":4,"timestamp":1749834829,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","archiveNextLeafIndex":4} 17:08:33 [17:08:33.147] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:08:33 [17:08:33.251] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.427100000000792,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834829,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:33 [17:08:33.269] VERBOSE: p2p Synched to latest block 3 17:08:33 [17:08:33.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.414] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 {"origin":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000fde9fb40","authWitnesses":["0x2af6652a52b61f5feb049c62cf706df5cae9623eccfb200e5a12c8e0219da31e"]} 17:08:33 [17:08:33.423] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","header":{"contentCommitment":{"blobsHash":"0x0088c81356d83b59292946ac53dbd766ef0252fa837e49bc69dbeceba6d789c7","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834829,"version":4259969856},"lastArchive":"0x1695e6504bc3f691270f5af6cdcaa8dde66a8fab98a625e6889f845018b63fa0","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x01eb17c275efd229ef0596534980d5ef48d97da889b94d2d9ccc8cef64035b44","nullifierTree":"0x1b50c59616f4b517729a8f479a48814c5af489a364b6da52687a2dd20a53d0ba","publicDataTree":"0x2f2f28f91dd866c1b6a917e5315b3da3bba7954dd3534958411ba5bb02efbe38"},"totalFees":11840749620,"totalManaUsed":35637}} 17:08:33 [17:08:33.544] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:33 [17:08:33.623] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:33 [17:08:33.624] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:33 [17:08:33.627] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.720] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","blockNumber":4,"slot":5} 17:08:33 [17:08:33.784] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:33 [17:08:33.799] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d01baeda8f998ae18a661dc579c7b064483a340903d9513c631022eca25bed9 17:08:33 [17:08:33.825] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:33 [17:08:33.827] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:33 [17:08:33.837] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:33 [17:08:33.838] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:33 [17:08:33.838] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.845] VERBOSE: pxe:service Added note {"index":0,"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x130ca575deae9c72c82a9b2d0501017f7fcc66b55da86d7388c746f496a2e1ea","nullifier":"0x19b036f51aea4e221fe8fae89f9906eafdd1dd1af192efdf500fc25555d99524"} 17:08:33 [17:08:33.847] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:33 [17:08:33.861] VERBOSE: simulator:client_execution_context:debug_log Setting 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 as fee payer 17:08:34 [17:08:34.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.437] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.462] VERBOSE: node Simulating public calls for tx 0x1938b0e352df82d2ecb3d684be1a927ed01a8b2a927bf8afa3b678210c474802 {"globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":4,"slotNumber":5,"timestamp":1749834865,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x1938b0e352df82d2ecb3d684be1a927ed01a8b2a927bf8afa3b678210c474802","blockNumber":4} 17:08:34 [17:08:34.467] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","blockNumber":4,"slot":5} 17:08:34 [17:08:34.505] VERBOSE: simulator:state_manager Siloed nullifier 0x0c6c12e60a00dedfde5da786cb9aa5f46d094b68e151eb20b69d8006518d0c53 already present in tree! 17:08:34 [17:08:34.505] VERBOSE: simulator:avm(f:0x8a4870ec) Exceptional halt (revert by something other than REVERT opcode) 17:08:34 [17:08:34.506] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x8a4870ec reverted with reason Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608).. {"eventName":"avm-simulation","appCircuitName":"0x8a4870ec","duration":23.272055999997974} 17:08:34 [17:08:34.507] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608:0x8a4870ec failed with reason: Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608). 17:08:34 [17:08:34.530] VERBOSE: simulator:public-processor Processed tx 0x1938b0e352df82d2ecb3d684be1a927ed01a8b2a927bf8afa3b678210c474802 with 1 public calls in 53.72025100000246ms {"txHash":"0x1938b0e352df82d2ecb3d684be1a927ed01a8b2a927bf8afa3b678210c474802","txFee":305510899200,"revertCode":1,"revertReason":{"originalMessage":"Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608).","functionErrorStack":[{"contractAddress":"0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608","functionName":"0x8a4870ec"}],"noirErrorStack":["0.46","0.2622"],"revertData":[]},"gasUsed":{"totalGas":{"daGas":1000000000,"l2Gas":6025856},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":999998976,"l2Gas":6000000},"billedGas":{"daGas":1000000000,"l2Gas":6025856}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":53.72025100000246} 17:08:34 [17:08:34.532] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0634115230000025s {"duration":0.0634115230000025,"rate":94620026.71028362,"totalPublicGas":{"daGas":999998976,"l2Gas":6000000},"totalBlockGas":{"daGas":1000000000,"l2Gas":6025856},"totalSizeInBytes":256} 17:08:34 [17:08:34.659] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.122] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.159] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","blockNumber":4,"slot":5} 17:08:35 [17:08:35.266] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:35 [17:08:35.322] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:35 [17:08:35.322] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:35 [17:08:35.332] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.389] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89"} 17:08:35 [17:08:35.395] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d01baeda8f998ae18a661dc579c7b064483a340903d9513c631022eca25bed9 17:08:35 [17:08:35.411] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:35 [17:08:35.412] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:35 [17:08:35.425] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:35 [17:08:35.426] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:35 [17:08:35.430] VERBOSE: pxe:service Added note {"index":0,"contract":"0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x130ca575deae9c72c82a9b2d0501017f7fcc66b55da86d7388c746f496a2e1ea","nullifier":"0x19b036f51aea4e221fe8fae89f9906eafdd1dd1af192efdf500fc25555d99524"} 17:08:35 [17:08:35.432] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:35 [17:08:35.448] VERBOSE: simulator:client_execution_context:debug_log Setting 0x062773bad1186313257090961567e86087bf743fa15a31e32e4e80fafcd60f89 as fee payer 17:08:35 [17:08:35.585] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.818] INFO: pxe:service Proving completed in 666.0528669999985ms {"timings":{"total":666.0528669999985,"sync":8.450761000000057,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":258.7717029999985,"oracles":{"debugLog":{"times":[0.6643979999971634,0.5364599999993516,0.7110600000014529,0.738762000000861,0.6391870000006747,0.4690970000010566,0.3735820000001695,0.6064249999981257]},"fetchTaggedLogs":{"times":[70.3624290000007]},"loadCapsule":{"times":[0.2409239999979036,0.3245489999972051,0.4988279999997758,0.2624949999990349,0.1720900000000256,0.22660200000245823]},"getSharedSecret":{"times":[5.77672000000166]},"aes128Decrypt":{"times":[0.3901530000002822,1.3696279999967373]},"getPublicKeysAndPartialAddress":{"times":[6.497121000000334]},"getKeyValidationRequest":{"times":[2.198594999998022]},"deliverNote":{"times":[4.500796000000264]},"deleteCapsule":{"times":[0.2686250000006112]},"storeCapsule":{"times":[0.26163499999893247]},"getNotes":{"times":[2.6656519999996817]},"getAuthWitness":{"times":[0.19241099999999278]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0563830000028247]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06480399999782094]}}},{"functionName":"private_kernel_init","time":54.628232999999454},{"functionName":"private_kernel_reset","time":156.7078079999992},{"functionName":"private_kernel_tail","time":76.59194299999945}],"unaccounted":110.90241900000183}} 17:08:35 [17:08:35.845] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.872] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2edb2137f483b75400700c627291ccd49d3e59b3d272593542a2f30e96396a13","blockNumber":4,"slot":5} 17:08:35 [17:08:35.876] VERBOSE: p2p:tx_pool Adding tx 0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d to pool {"eventName":"tx-added-to-pool","txHash":"0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 17:08:35 [17:08:35.884] INFO: node Received tx 0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d {"txHash":"0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d"} 17:08:35 [17:08:35.884] INFO: pxe:service Sent transaction 0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d 17:08:36 [17:08:36.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.396] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:08:36 [17:08:36.411] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T17:14:25.000Z","now":"2025-06-13T17:14:28.744Z"} 17:08:36 [17:08:36.449] VERBOSE: simulator:state_manager Siloed nullifier 0x0c6c12e60a00dedfde5da786cb9aa5f46d094b68e151eb20b69d8006518d0c53 already present in tree! 17:08:36 [17:08:36.450] VERBOSE: simulator:avm(f:0x8a4870ec) Exceptional halt (revert by something other than REVERT opcode) 17:08:36 [17:08:36.450] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x8a4870ec reverted with reason Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608).. {"eventName":"avm-simulation","appCircuitName":"0x8a4870ec","duration":17.635584999999992} 17:08:36 [17:08:36.451] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608:0x8a4870ec failed with reason: Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608). 17:08:36 [17:08:36.462] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.470] VERBOSE: simulator:public-processor Processed tx 0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d with 1 public calls in 46.9202329999971ms {"txHash":"0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d","txFee":305510899200,"revertCode":1,"revertReason":{"originalMessage":"Attempted to emit duplicate nullifier 0x0000000000000000000000000000000000000000000000000000000000000001 (contract address: 0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608).","functionErrorStack":[{"contractAddress":"0x17982c81db2b5ff659459dceb899f4fc325bb235c0828ae371b4a6762d4f1608","functionName":"0x8a4870ec"}],"noirErrorStack":["0.46","0.2622"],"revertData":[]},"gasUsed":{"totalGas":{"daGas":1000000000,"l2Gas":6025856},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":999998976,"l2Gas":6000000},"billedGas":{"daGas":1000000000,"l2Gas":6025856}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":46.9202329999971} 17:08:36 [17:08:36.472] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06036744900000122s {"duration":0.06036744900000122,"rate":99391312.692373,"totalPublicGas":{"daGas":999998976,"l2Gas":6000000},"totalBlockGas":{"daGas":1000000000,"l2Gas":6025856},"totalSizeInBytes":256} 17:08:36 [17:08:36.594] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 30213936.72820947 mana/s {"blockHash":"0x0b48f70f652c0d01ebe56fd90928b6771fc62349c0d6874802b677b52b4b2667","globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":4,"slotNumber":5,"timestamp":1749834865,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x1c1a4a60d1afa7cc4e2ebd765de44b127a18fbfbeb6ed8bdd7313f051bcbd48d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":197.78124799999932,"publicProcessDuration":60.82439599999998,"rollupCircuitsDuration":184.75359599999865,"txCount":1,"blockNumber":4,"blockTimestamp":1749834865,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:36 [17:08:36.597] VERBOSE: sequencer Attesting committee is empty 17:08:36 [17:08:36.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.937] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.948] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8d178be14c6c1ae0f88fce538597486c1b364208312bdaf1c03f30e123e9fdfd 17:08:36 [17:08:36.948] VERBOSE: sequencer-client Sent L1 transaction 0x8d178be14c6c1ae0f88fce538597486c1b364208312bdaf1c03f30e123e9fdfd {"gasLimit":470277,"maxFeePerGas":"1.261127755","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:36 [17:08:36.958] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834901] on http://127.0.0.1:8545 17:08:36 [17:08:36.961] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:36 [17:08:36.964] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834901 17:08:36 [17:08:36.964] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:01.000Z {"offset":384036,"timeMs":1749834901000} 17:08:36 [17:08:36.965] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:08:36 [17:08:36.968] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:36 [17:08:36.968] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8d178be14c6c1ae0f88fce538597486c1b364208312bdaf1c03f30e123e9fdfd","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1749834865,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:36 [17:08:36.969] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:36 [17:08:36.976] INFO: blob-sink:server Received blob sidecar for block 0xfd8f6753b51dc595c2861cc68246658f80e83c7ea2419e64c908af6282b3841b 17:08:36 [17:08:36.981] INFO: blob-sink:server Blob sidecar stored successfully for block 0xfd8f6753b51dc595c2861cc68246658f80e83c7ea2419e64c908af6282b3841b 17:08:37 [17:08:37.144] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.146] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:08:37 [17:08:37.148] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:08:37 [17:08:37.149] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:08:37 [17:08:37.347] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.680] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0b48f70f652c0d01ebe56fd90928b6771fc62349c0d6874802b677b52b4b2667","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":4259969856,"blockNumber":4,"slotNumber":5,"timestamp":1749834865,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x104010bfb2a57f870adade56a447a1684057da59ec5061a408aab3fa2f74ca75","archiveNextLeafIndex":5} 17:08:37 [17:08:37.682] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:08:37 [17:08:37.783] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.874428999999509,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749834865,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:37 [17:08:37.795] VERBOSE: p2p Synched to latest block 4 17:08:37 [17:08:37.866] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.955] INFO: node Stopping 17:08:37 [17:08:37.956] INFO: slasher Slasher client stopped. 17:08:37 [17:08:37.956] INFO: sequencer Stopped sequencer 17:08:37 [17:08:37.956] INFO: p2p P2P client stopped. 17:08:37 [17:08:37.958] INFO: world_state Stopped world state synchronizer 17:08:37 [17:08:37.959] INFO: archiver Stopped. 17:08:37 [17:08:37.959] INFO: node Stopped 17:08:37 [17:08:37.959] VERBOSE: e2e:e2e_double_spend Cleaning up ACVM state 17:08:37 [17:08:37.959] INFO: e2e:e2e_double_spend Cleaning up ACVM temp directory /tmp/af42cbc1 17:08:37 [17:08:37.960] VERBOSE: e2e:e2e_double_spend Cleaning up BB state 17:08:37 [17:08:37.968] INFO: blob-sink:server Stopping blob sink 17:08:37 [17:08:37.969] INFO: blob-sink:server Blob sink stopped 17:08:37 [17:08:37.969] VERBOSE: e2e:e2e_double_spend Cleaning up data directory at /tmp/623f3802c07997c1 17:08:37 PASS src/e2e_double_spend.test.ts 17:08:37 e2e_double_spend 17:08:37 double spends 17:08:37 ✓ emits a public nullifier and then tries to emit the same nullifier (7656 ms) 17:08:37 17:08:37 Test Suites: 1 passed, 1 total 17:08:37 Tests: 1 passed, 1 total 17:08:37 Snapshots: 0 total 17:08:37 Time: 31.711 s 17:08:37 Ran all test suites matching /src\/e2e_double_spend.test.ts/i. 17:08:37 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?