Parent Log: http://ci.aztec-labs.com/78edc4b7863ae88d Command: f682b45a820409ef:ISOLATE=1:NAME=e2e_keys yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_keys.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/c0e766a133071c44b2c0d8fac5df352c6e059df1 Env: REF_NAME=gh-readonly-queue/next/pr-15015-cf8be0f9e81e248048560619de041e90d9d6990a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 07:53:14 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15015_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c393731fea71056e_next 07:53:15 +++ id -u 07:53:15 +++ id -g 07:53:15 ++ docker run -d --name e2e_keys --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_keys.test.ts'\''' 07:53:15 + cid=020e96567395cadcbe0c2039fee41ada95ac107bc924a7d00f866a22fc0fe157 07:53:15 + set +x 07:53:16 {"level":25,"time":1749801196016,"pid":12,"hostname":"020e96567395","module":"logger","msg":"Logger initialized with level verbose"} 07:53:22 [07:53:22.283] INFO: e2e:e2e_keys Logging metrics to log/unknown.jsonl 07:53:23 [07:53:23.046] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-yFXCsI/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 07:53:23 [07:53:23.106] INFO: e2e:e2e_keys Calling anvil_setBlockTimestampInterval with params: [12] 07:53:23 [07:53:23.155] WARN: e2e:e2e_keys Set block interval to 12 07:53:23 [07:53:23.156] VERBOSE: e2e:e2e_keys Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 07:53:23 [07:53:23.235] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 07:53:23 [07:53:23.247] VERBOSE: e2e:e2e_keys Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 07:53:23 [07:53:23.278] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 07:53:23 [07:53:23.285] VERBOSE: e2e:e2e_keys Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 07:53:23 [07:53:23.310] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x127d08cafb8afc3d7c988fa49d05483d6d2b44a017de0544d9d53ed8e954f028 {"gasLimit":3068916,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 07:53:23 [07:53:23.319] VERBOSE: e2e:e2e_keys Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 07:53:23 [07:53:23.342] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdb9612b2166822d6497afb75ab3fe675145b118f9d3ef58bc23bdb9816e5d0f5 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 07:53:23 [07:53:23.353] VERBOSE: e2e:e2e_keys Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 07:53:23 [07:53:23.396] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x32ed4059fca555e8be9e05117cb7e979fafb635b31d08729d246c0704eaa1138 {"gasLimit":1966612,"maxFeePerGas":"3.602497631","maxPriorityFeePerGas":"2.48832"} 07:53:23 [07:53:23.402] VERBOSE: e2e:e2e_keys Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 07:53:23 [07:53:23.426] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf29078d6fdb1fd1334c85ea0a8f17d2b4c4766e863a0822c2fb665091b723499 {"gasLimit":3042380,"maxFeePerGas":"3.968738902","maxPriorityFeePerGas":"2.985984"} 07:53:23 [07:53:23.433] VERBOSE: e2e:e2e_keys Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 07:53:23 [07:53:23.459] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 {"gasLimit":100000,"maxFeePerGas":"4.456512857","maxPriorityFeePerGas":"3.5831808"} 07:53:23 [07:53:23.460] VERBOSE: e2e:e2e_keys Set governance on GSE in 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 07:53:23 [07:53:23.481] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xd7c909c2f426dbb387bba51539e35cd537bbd9383154eb2618179b00ef0008b2 {"gasLimit":391705,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 07:53:23 [07:53:23.489] VERBOSE: e2e:e2e_keys Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 07:53:23 [07:53:23.489] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 07:53:23 [07:53:23.489] INFO: e2e:e2e_keys Waiting for 7 transactions to be mined... 07:53:23 [07:53:23.526] INFO: e2e:e2e_keys All transactions mined successfully 07:53:23 [07:53:23.570] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca {"gasLimit":100000,"maxFeePerGas":"5.844872118","maxPriorityFeePerGas":"5.159780352"} 07:53:23 [07:53:23.571] VERBOSE: e2e:e2e_keys Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca 07:53:23 [07:53:23.594] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x7ef4acce2d29fb2e046cebc7a8a26e7c7540e156376f7b1c5bb5b863cbe564c3 {"gasLimit":56661,"maxFeePerGas":"6.793055288","maxPriorityFeePerGas":"6.191736422"} 07:53:23 [07:53:23.622] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xb25c5ab4294e8fbc0c9624e56aa31ec351526cb6af6350c11417f282dd0f9bd3 {"gasLimit":339705,"maxFeePerGas":"7.956474918","maxPriorityFeePerGas":"7.430083706"} 07:53:23 [07:53:23.631] VERBOSE: e2e:e2e_keys Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 07:53:23 [07:53:23.656] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 {"gasLimit":56804,"maxFeePerGas":"9.376899884","maxPriorityFeePerGas":"8.916100447"} 07:53:23 [07:53:23.657] VERBOSE: e2e:e2e_keys Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 07:53:23 [07:53:23.688] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf9401b33d177baeffffb49aad9037387d78c09beb9e9ec7ba1d3f2570522b753 {"gasLimit":2474287,"maxFeePerGas":"11.103607102","maxPriorityFeePerGas":"10.699320536"} 07:53:23 [07:53:23.701] VERBOSE: e2e:e2e_keys Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 07:53:23 [07:53:23.728] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 {"gasLimit":56804,"maxFeePerGas":"13.193094869","maxPriorityFeePerGas":"12.839184643"} 07:53:23 [07:53:23.728] VERBOSE: e2e:e2e_keys Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 07:53:23 [07:53:23.729] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 07:53:23 [07:53:23.729] INFO: e2e:e2e_keys Waiting for 9 transactions to be mined... 07:53:23 [07:53:23.772] INFO: e2e:e2e_keys All transactions mined successfully 07:53:23 [07:53:23.788] VERBOSE: e2e:e2e_keys Deployed shared contracts 07:53:23 [07:53:23.817] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 {"gasLimit":84837,"maxFeePerGas":"15.722774098","maxPriorityFeePerGas":"15.407021571"} 07:53:23 [07:53:23.817] VERBOSE: e2e:e2e_keys Funded reward distributor with 10000000000000000000000000 fee asset in 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 07:53:23 [07:53:23.843] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdef66310c9d0b7dd201d14d81f0afe9cb0a7a1bcdfb3985c400aaac3112b99a8 {"gasLimit":152965,"maxFeePerGas":"18.764833904","maxPriorityFeePerGas":"18.488425885"} 07:53:23 [07:53:23.854] VERBOSE: e2e:e2e_keys Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 07:53:23 [07:53:23.854] VERBOSE: e2e:e2e_keys Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 07:53:23 [07:53:23.907] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xa30936656c85bd30a140fccee2cc68506bbb2794b4d16485d9d2cef61cfec969 {"gasLimit":86383,"maxFeePerGas":"22.428130924","maxPriorityFeePerGas":"22.186111062"} 07:53:23 [07:53:23.953] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xbe78ed180cb67f2324e0f55f5bcf89cc6f9feb261fdc97fb4688481193c42049 {"gasLimit":5075920,"maxFeePerGas":"26.835357743","maxPriorityFeePerGas":"26.623333274"} 07:53:24 [07:53:24.016] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xadefaa698fbe2ccad8b7262edf757f1bbec31f893ad6df9dc23634f426ba2e27 {"gasLimit":2439043,"maxFeePerGas":"32.133648528","maxPriorityFeePerGas":"31.947999928"} 07:53:24 [07:53:24.023] VERBOSE: e2e:e2e_keys Awaiting for linked libraries to be deployed 07:53:24 [07:53:24.079] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x6baf1569a55c8d54a8d760960008bbcf7907f687beb688189b27ea7f2254038a {"gasLimit":10498896,"maxFeePerGas":"38.506586449","maxPriorityFeePerGas":"38.337599913"} 07:53:24 [07:53:24.086] VERBOSE: e2e:e2e_keys Deployed Rollup at 0x3aa5ebb10dc797cac828524e59a333d0a371443c {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 07:53:24 [07:53:24.087] INFO: e2e:e2e_keys Waiting for 11 transactions to be mined... 07:53:24 [07:53:24.134] INFO: e2e:e2e_keys All transactions mined successfully 07:53:24 [07:53:24.135] VERBOSE: e2e:e2e_keys All core contracts have been deployed 07:53:24 [07:53:24.167] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 {"gasLimit":64317,"maxFeePerGas":"46.155845375","maxPriorityFeePerGas":"46.005119895"} 07:53:24 [07:53:24.168] VERBOSE: e2e:e2e_keys Funding fee juice portal with 10000000000000000000000 fee juice in 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 (accelerated test deployments) 07:53:24 [07:53:24.187] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x6a926be81b73dd91dae704702483da1c551ca87b055c30c4ea85773cbb8c17f2 {"gasLimit":1040131,"maxFeePerGas":"55.349017914","maxPriorityFeePerGas":"55.206143874"} 07:53:24 [07:53:24.193] VERBOSE: e2e:e2e_keys Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 07:53:24 [07:53:24.235] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a {"gasLimit":116846,"maxFeePerGas":"66.372451249","maxPriorityFeePerGas":"66.247372648"} 07:53:24 [07:53:24.235] VERBOSE: e2e:e2e_keys Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a 07:53:24 [07:53:24.256] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e {"gasLimit":109478,"maxFeePerGas":"79.607194411","maxPriorityFeePerGas":"79.496847177"} 07:53:24 [07:53:24.256] VERBOSE: e2e:e2e_keys Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e 07:53:24 [07:53:24.261] INFO: e2e:e2e_keys Waiting for 12 transactions to be mined... 07:53:24 [07:53:24.293] INFO: e2e:e2e_keys All transactions mined successfully 07:53:24 [07:53:24.301] VERBOSE: e2e:e2e_keys Rollup deployed 07:53:24 [07:53:24.301] VERBOSE: e2e:e2e_keys Waiting for rollup and slash factory to be deployed 07:53:24 [07:53:24.301] INFO: e2e:e2e_keys Waiting for 12 transactions to be mined... 07:53:24 [07:53:24.328] INFO: e2e:e2e_keys All transactions mined successfully 07:53:24 [07:53:24.328] VERBOSE: e2e:e2e_keys All transactions for L1 deployment have been mined 07:53:24 [07:53:24.351] INFO: e2e:e2e_keys Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 07:53:24 [07:53:24.352] INFO: e2e:e2e_keys Handing over to governance 07:53:24 [07:53:24.361] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 07:53:24 [07:53:24.363] INFO: telemetry:client Using NoopTelemetryClient 07:53:24 [07:53:24.370] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 07:53:24 [07:53:24.370] WARN: foundation:test-date-provider Time set to 2025-06-13T07:58:10.000Z {"offset":285630,"timeMs":1749801490000} 07:53:24 [07:53:24.371] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/bc4e120bb7fa73cf/blob-sink with map size 134217728 KB (LMDB v2) 07:53:24 [07:53:24.376] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 07:53:24 [07:53:24.386] INFO: blob-sink:server Server is running on http://localhost:36577 07:53:24 [07:53:24.386] VERBOSE: e2e:e2e_keys Creating and synching an aztec node... 07:53:24 [07:53:24.387] VERBOSE: e2e:e2e_keys Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/298771bd/acvm 07:53:24 [07:53:24.388] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36577"} 07:53:24 [07:53:24.424] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 07:53:24 [07:53:24.426] INFO: archiver:lmdb Creating archiver data store at directory /tmp/bc4e120bb7fa73cf/archiver with map size 134217728 KB (LMDB v2) 07:53:24 [07:53:24.428] INFO: archiver:lmdb Starting data store with maxReaders 16 07:53:24 [07:53:24.794] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36577"} 07:53:24 [07:53:24.814] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36577"} 07:53:24 [07:53:24.814] WARN: node:blob-sink:client No L1 consensus host urls configured 07:53:24 [07:53:24.814] WARN: node:blob-sink:client No archive client configured 07:53:24 [07:53:24.819] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x51c11ba115541f724db7640bebd8ce124974a659de25a7411415f33e5f7ae55d {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x97f714bedb3c48554b74bac8bdeff812185c95cebd431b165ea524f445660ca8","l1BlockNumber":20}} 07:53:24 [07:53:24.839] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x51c11ba115541f724db7640bebd8ce124974a659de25a7411415f33e5f7ae55d","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 07:53:24 [07:53:24.847] INFO: world-state:database Creating world state data store at directory /tmp/bc4e120bb7fa73cf/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 07:53:24 [07:53:24.873] INFO: world_state Created world state synchroniser with block history of 64 07:53:24 [07:53:24.873] WARN: node Aztec node is accepting fake proofs 07:53:24 [07:53:24.888] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/bc4e120bb7fa73cf/p2p with map size 134217728 KB (LMDB v2) 07:53:24 [07:53:24.892] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 07:53:24 [07:53:24.894] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/bc4e120bb7fa73cf/p2p-archive with map size 134217728 KB (LMDB v2) 07:53:24 [07:53:24.895] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 07:53:24 [07:53:24.896] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/bc4e120bb7fa73cf/p2p-peers with map size 134217728 KB (LMDB v2) 07:53:24 [07:53:24.898] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 07:53:24 [07:53:24.900] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 07:53:24 [07:53:24.902] VERBOSE: p2p P2P is disabled. Using dummy P2P service 07:53:24 [07:53:24.908] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 07:53:24 [07:53:24.910] INFO: world_state Started world state synchronizer from block 1 07:53:24 [07:53:24.912] VERBOSE: world-state:block_stream Starting sync from block number 0 07:53:24 [07:53:24.921] INFO: p2p Starting p2p client from block 0 with empty mempools 07:53:24 [07:53:24.922] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 07:53:25 [07:53:25.182] INFO: epoch-prune-watcher EpochPruneWatcher initialized 07:53:25 [07:53:25.218] VERBOSE: validator Initialized validator with addresses: 0xe331a83f3e1f903138d4ffda46b9ca0d045cd49f 07:53:25 [07:53:25.218] VERBOSE: node All Aztec Node subsystems synced 07:53:25 [07:53:25.233] INFO: slasher Starting Slasher client... 07:53:25 [07:53:25.242] INFO: sequencer-client Deploying forwarder contract 07:53:25 [07:53:25.244] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 07:53:25 [07:53:25.258] VERBOSE: sequencer-client Sent L1 transaction 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb {"gasLimit":323704,"maxFeePerGas":"95.492859983","maxPriorityFeePerGas":"95.396216612"} 07:53:25 [07:53:25.258] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb. 07:53:25 [07:53:25.263] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 07:53:25 [07:53:25.275] INFO: validator Started validator with addresses: 0xe331a83f3e1f903138d4ffda46b9ca0d045cd49f 07:53:25 [07:53:25.276] VERBOSE: validator Validators 0xe331a83f3e1f903138d4ffda46b9ca0d045cd49f are not on the validator committee for epoch 0 07:53:25 [07:53:25.276] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/298771bd/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 07:53:25 [07:53:25.277] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 07:53:25 [07:53:25.279] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 07:53:25 [07:53:25.281] INFO: node Aztec Node version: 0.87.6 07:53:25 [07:53:25.281] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 07:53:25 [07:53:25.282] VERBOSE: e2e:e2e_keys Creating a pxe... 07:53:25 [07:53:25.293] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/784a36e65960840e/pxe_data with map size 134217728 KB (LMDB v2) 07:53:25 [07:53:25.297] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 07:53:25 [07:53:25.299] INFO: pxe:data:lmdb Starting data store with maxReaders 16 07:53:25 [07:53:25.552] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 07:53:25 [07:53:25.553] WARN: foundation:test-date-provider Time set to 2025-06-13T07:58:22.000Z {"offset":296447,"timeMs":1749801502000} 07:53:25 [07:53:25.675] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 07:53:25 [07:53:25.678] INFO: pxe:service Started PXE connected to chain 31337 version 1148068633 07:53:25 [07:53:25.747] INFO: pxe:service Registered account 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa 07:53:25 [07:53:25.842] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 07:53:25 [07:53:25.848] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa 07:53:26 [07:53:26.038] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:26 [07:53:26.039] INFO: pxe:service Added contract SchnorrAccount at 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 07:53:26 [07:53:26.041] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:26 [07:53:26.082] VERBOSE: pxe:block_stream Starting sync from block number 0 07:53:26 [07:53:26.160] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 07:53:26 [07:53:26.299] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 07:53:27 [07:53:27.109] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 07:53:27 [07:53:27.248] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 07:53:27 [07:53:27.384] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:27 [07:53:27.385] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:27 [07:53:27.530] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:27 [07:53:27.577] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:27 [07:53:27.578] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:27 [07:53:27.669] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:27 [07:53:27.674] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:27 [07:53:27.963] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:28 [07:53:28.011] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:28 [07:53:28.012] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:28 [07:53:28.037] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:28 [07:53:28.062] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:28 [07:53:28.084] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:28 [07:53:28.092] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:28 [07:53:28.134] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa as fee payer 07:53:28 [07:53:28.917] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:28 [07:53:28.919] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:29 [07:53:29.715] INFO: pxe:service Proving completed in 3638.6402160000016ms {"timings":{"total":3638.6402160000016,"sync":5.726838000000498,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":227.97607600000083,"oracles":{"callPrivateFunction":{"times":[1106.934772999999,510.12319600000046,307.68901200000073]}}},{"functionName":"private_kernel_init","time":128.91333900000063},{"functionName":"ContractClassRegisterer:register","time":1077.8964639999995,"oracles":{"loadCapsule":{"times":[24.05249999999978]},"notifyCreatedNullifier":{"times":[20.850522999999157]},"debugLog":{"times":[1.9791879999993398]},"notifyCreatedContractClassLog":{"times":[7.82162900000003]}}},{"functionName":"private_kernel_inner","time":188.1189579999991},{"functionName":"SchnorrAccount:constructor","time":463.38666899999953,"oracles":{"getContractInstance":{"times":[5.1856450000013865]},"debugLog":{"times":[0.659326000000874,0.5649040000007517]},"fetchTaggedLogs":{"times":[94.672403999999]},"loadCapsule":{"times":[0.47375100000135717,0.26819700000123703,0.2645059999995283]},"validateEnqueuedNotesAndEvents":{"times":[2.770465999999942]},"notifyCreatedNullifier":{"times":[0.29643700000087847,0.39346000000114145]},"notifyCreatedNote":{"times":[0.5724039999986417]},"getRandomField":{"times":[0.27110699999866483,0.3523989999994228,0.13071300000046904,0.06643099999928381,0.06425099999978556,0.06577099999958591,0.05265199999848846,0.055121999999755644,0.0835110000007262,0.12038199999915378,0.1229829999992944]},"getIndexedTaggingSecretAsSender":{"times":[37.318710999999894]},"incrementAppTaggingSecretIndexAsSender":{"times":[76.97376600000098]}}},{"functionName":"private_kernel_inner","time":165.36479900000086},{"functionName":"SchnorrAccount:entrypoint","time":275.4855660000012,"oracles":{"debugLog":{"times":[1.3801039999998466,1.2487789999995584,1.002715000000535]},"fetchTaggedLogs":{"times":[75.04909000000043]},"loadCapsule":{"times":[0.4913109999997687,3.685448999998698,10.713048999999955]},"validateEnqueuedNotesAndEvents":{"times":[9.714633999999933]},"getNotes":{"times":[4.6747230000000854]},"getAuthWitness":{"times":[0.5460029999994731]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9427129999985482]}}},{"functionName":"private_kernel_inner","time":135.75388500000008},{"functionName":"private_kernel_reset","time":247.3462070000005},{"functionName":"private_kernel_tail","time":82.40880800000014}],"unaccounted":640.2626069999988}} 07:53:29 [07:53:29.835] VERBOSE: p2p:tx_pool Adding tx 0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6 to pool {"eventName":"tx-added-to-pool","txHash":"0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 07:53:29 [07:53:29.840] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:29 [07:53:29.850] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:29 [07:53:29.858] INFO: node Received tx 0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6 {"txHash":"0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6"} 07:53:29 [07:53:29.859] INFO: pxe:service Sent transaction 0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6 07:53:30 [07:53:30.369] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"chainTipArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","blockNumber":1,"slot":2} 07:53:30 [07:53:30.391] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-13T07:58:34.000Z","now":"2025-06-13T07:58:26.838Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 07:53:30 [07:53:30.476] VERBOSE: simulator:public-processor Processed tx 0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6 with no public calls in 32.13175499999852ms {"txHash":"0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6","txFee":2101212240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"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":32.13175499999852} 07:53:30 [07:53:30.478] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08275608600000123s {"duration":0.08275608600000123,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 07:53:30 [07:53:30.515] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x049eb8d650a320b3f32612f0c34f3c2ae286b6c92d6f2fb792fa4b95195ae4f4","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"txHashes":["0x0616767851357847ae3d62aedc000ff6423a5618796cecb27e0b641fb4bc3cf6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":134.57427599999937,"publicProcessDuration":84.16182099999969,"rollupCircuitsDuration":124.07165299999906,"txCount":1,"blockNumber":1,"blockTimestamp":1749801514,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 07:53:30 [07:53:30.518] VERBOSE: sequencer Attesting committee is empty 07:53:33 [07:53:33.583] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x315525ffe13117d0736d551237c0d8cf763174fbe6d81d23954b6baeb9138af7 07:53:33 [07:53:33.584] VERBOSE: node Sent L1 transaction 0x315525ffe13117d0736d551237c0d8cf763174fbe6d81d23954b6baeb9138af7 {"gasLimit":486984,"maxFeePerGas":"114.56009636","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 07:53:33 [07:53:33.623] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 07:53:33 [07:53:33.624] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x315525ffe13117d0736d551237c0d8cf763174fbe6d81d23954b6baeb9138af7","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":1,"blockTimestamp":1749801514,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 07:53:33 [07:53:33.626] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 07:53:33 [07:53:33.652] INFO: blob-sink:server Received blob sidecar for block 0xd43749955711f824cfc02b77ee014fdbf8a1cbead688267e317d6c9c812b6d6f 07:53:33 [07:53:33.670] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 07:53:33 [07:53:33.671] WARN: foundation:test-date-provider Time set to 2025-06-13T07:58:34.000Z {"offset":300329,"timeMs":1749801514000} 07:53:33 [07:53:33.677] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd43749955711f824cfc02b77ee014fdbf8a1cbead688267e317d6c9c812b6d6f 07:53:33 [07:53:33.684] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 07:53:33 [07:53:33.690] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 07:53:33 [07:53:33.743] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749801550 07:53:33 [07:53:33.744] WARN: foundation:test-date-provider Time set to 2025-06-13T07:59:10.000Z {"offset":336256,"timeMs":1749801550000} 07:53:33 [07:53:33.744] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 07:53:33 [07:53:33.974] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 07:53:34 [07:53:34.009] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x049eb8d650a320b3f32612f0c34f3c2ae286b6c92d6f2fb792fa4b95195ae4f4","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"archiveRoot":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","archiveNextLeafIndex":2} 07:53:34 [07:53:34.019] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 07:53:34 [07:53:34.524] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":455.24098199999935,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749801514,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 07:53:34 [07:53:34.525] WARN: pxe:service No artifact found for contract class 0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2 when looking for its metadata 07:53:34 [07:53:34.532] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2 as part of deployment for 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae 07:53:34 [07:53:34.840] VERBOSE: p2p Synched to latest block 1 07:53:35 [07:53:35.173] INFO: pxe:service Added contract Test at 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae with class 0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2 07:53:35 [07:53:35.207] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","header":{"contentCommitment":{"blobsHash":"0x00d2f9d68d3fcbce9ccc497821931789016cbdf0db337af408f921a23a7a53e3","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749801514,"version":1148068633},"lastArchive":"0x20eafca32225d31c15ff485ea265a08bfe26ddaec50b9d8656979db840e30772","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x186c13dbabbf41c4b13cc7bf03ac35ad87586a3e8c43de79673312967d0f489f","nullifierTree":"0x27f230ec21125b99556f48a0e69da3b1cf7461856a089d78801905f4646db074","publicDataTree":"0x261602c9bcfb7883ad38df91e03656df9f1302d5bc2285315216f619d4cac820"},"totalFees":2101212240,"totalManaUsed":6324}} 07:53:35 [07:53:35.275] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:35 [07:53:35.353] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:35 [07:53:35.394] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:35 [07:53:35.395] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:35 [07:53:35.396] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:35 [07:53:35.513] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:35 [07:53:35.517] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1212df30acd0de5f9711ce6e2eef261d1388a6dfd3274754a892f443c021c8f8 07:53:35 [07:53:35.528] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:35 [07:53:35.529] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 07:53:35 [07:53:35.535] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:35 [07:53:35.536] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:35 [07:53:35.539] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:35 [07:53:35.546] VERBOSE: pxe:service Added note {"index":0,"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x26f8db62bd170682e7d3f3dbe24900af8e966ba430b9d0f014f1b77d20bd7310","nullifier":"0x10bd213354c0e76c2f200276d2579583a05c825e3e2045144a8de286253113c8"} 07:53:35 [07:53:35.563] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa as fee payer 07:53:35 [07:53:35.627] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 07:53:36 [07:53:36.140] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2,0x262e74af8ae835bfadba235edebeb76736bd2bd650028647749f086c00dd3fa5,0x21dce5d1a40c9b23fd7019e7a54ae130784a3b9bb348a27d9dc2585df56e0461,0x06543d061b8914adbb45c8cb460b9db71250ba39356bc17451069e57d1fc2189 07:53:36 [07:53:36.271] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 07:53:36 [07:53:36.446] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:36 [07:53:36.464] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 07:53:36 [07:53:36.483] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:36 [07:53:36.543] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 07:53:36 [07:53:36.555] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae,0x0000000000000000000000000000000000000000000000000000000000000001,0x1dd8d4fae4dad2864fc355d5b4e19c6c7678e4142e843ee45d0aef8bcd6e69f1,0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa 07:53:37 [07:53:37.383] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:37 [07:53:37.411] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:37 [07:53:37.412] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:37 [07:53:37.647] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:37 [07:53:37.658] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:37 [07:53:37.686] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:37 [07:53:37.691] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:38 [07:53:38.388] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:38 [07:53:38.536] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:39 [07:53:39.608] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:39 [07:53:39.808] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:40 [07:53:40.185] INFO: pxe:service Proving completed in 4989.379353999997ms {"timings":{"total":4989.379353999997,"sync":12.788017999999283,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":604.6976770000074,"oracles":{"debugLog":{"times":[0.7685289999972156,0.37104900000122143,0.44702999999935855,0.45440099999905215,0.3817589999998745,0.2914570000029926,0.46274199999970733,0.5120020000031218]},"fetchTaggedLogs":{"times":[120.68866200000048]},"loadCapsule":{"times":[0.19073500000013155,0.4205199999996694,0.37455899999986286,0.2649459999993269,0.3140979999989213,0.2678470000028028,0.22381500000119559]},"getSharedSecret":{"times":[3.7245199999997567]},"aes128Decrypt":{"times":[1.1839680000011867,0.699706999999762]},"getPublicKeysAndPartialAddress":{"times":[1.609269000000495]},"getKeyValidationRequest":{"times":[1.8440540000010515]},"storeCapsule":{"times":[0.6592860000018845,0.31349799999952666,0.36486800000056974]},"deleteCapsule":{"times":[0.5023719999990135]},"validateEnqueuedNotesAndEvents":{"times":[7.523291000001336]},"getNotes":{"times":[1.9559270000027027]},"getAuthWitness":{"times":[0.27664699999877485]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.058981000001949724]},"callPrivateFunction":{"times":[766.2663549999997,229.49771600000167,1138.216341000003]}}},{"functionName":"private_kernel_init","time":80.70750699999917},{"functionName":"ContractClassRegisterer:register","time":746.191010999999,"oracles":{"loadCapsule":{"times":[5.410710000000108]},"notifyCreatedNullifier":{"times":[0.5860339999999269]},"debugLog":{"times":[0.703577000000223]},"notifyCreatedContractClassLog":{"times":[6.426715000001423]}}},{"functionName":"private_kernel_inner","time":179.71724600000016},{"functionName":"ContractInstanceDeployer:deploy","time":147.45891699999993,"oracles":{"storeInExecutionCache":{"times":[0.6836370000019087]},"callPrivateFunction":{"times":[77.97647100000177]},"notifyCreatedNullifier":{"times":[0.4161400000011781]},"debugLog":{"times":[0.5873739999988175]}}},{"functionName":"private_kernel_inner","time":144.26579800000036},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":57.35684399999809,"oracles":{}},{"functionName":"private_kernel_inner","time":140.3132489999989},{"functionName":"Test:initialize","time":919.3538469999985,"oracles":{"getContractInstance":{"times":[11.336194000003161]},"debugLog":{"times":[0.7035169999981008,0.5669220000017958]},"fetchTaggedLogs":{"times":[277.4653640000033]},"loadCapsule":{"times":[0.27825700000175857,0.24797600000238162,0.2998260000022128]},"validateEnqueuedNotesAndEvents":{"times":[1.5984360000002198]},"notifyCreatedNullifier":{"times":[0.3045270000002347]}}},{"functionName":"private_kernel_inner","time":186.84852700000192},{"functionName":"private_kernel_reset","time":271.5371840000007},{"functionName":"private_kernel_tail","time":104.9141120000022}],"unaccounted":1393.2294169999914}} 07:53:40 [07:53:40.371] VERBOSE: p2p:tx_pool Adding tx 0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9 to pool {"eventName":"tx-added-to-pool","txHash":"0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":567,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 07:53:40 [07:53:40.406] INFO: node Received tx 0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9 {"txHash":"0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9"} 07:53:40 [07:53:40.407] INFO: pxe:service Sent transaction 0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9 07:53:40 [07:53:40.424] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"chainTipArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","blockNumber":2,"slot":3} 07:53:40 [07:53:40.442] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-13T07:59:10.000Z","now":"2025-06-13T07:59:16.698Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 07:53:40 [07:53:40.567] VERBOSE: simulator:public-processor Processed tx 0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9 with no public calls in 57.36601100000189ms {"txHash":"0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9","txFee":2176967520,"revertCode":0,"gasUsed":{"totalGas":{"daGas":302080,"l2Gas":6552},"billedGas":{"daGas":302080,"l2Gas":6552},"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":57.36601100000189} 07:53:40 [07:53:40.572] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1276544939999985s {"duration":0.1276544939999985,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":302080,"l2Gas":6552},"totalSizeInBytes":19136} 07:53:40 [07:53:40.630] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0b6a1020d3c96c5ab57d8eb5bba2f1313681dec751da24aa083e0bb60fcfca3c","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"txHashes":["0x2d96595a0678cff3df3fb54801407ef87e362b0eb90f4d89854e0ea2bfe429c9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":193.38539399999718,"publicProcessDuration":128.1088349999991,"rollupCircuitsDuration":188.46946299999763,"txCount":1,"blockNumber":2,"blockTimestamp":1749801550,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":567} 07:53:40 [07:53:40.633] VERBOSE: sequencer Attesting committee is empty 07:53:40 [07:53:40.864] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcddf5c31c90f503c1fd57bf7eb9e417641c5192b46278aac4b28be180dd2f658 07:53:40 [07:53:40.865] VERBOSE: node Sent L1 transaction 0xcddf5c31c90f503c1fd57bf7eb9e417641c5192b46278aac4b28be180dd2f658 {"gasLimit":407282,"maxFeePerGas":"1.265176194","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 07:53:40 [07:53:40.875] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 07:53:40 [07:53:40.875] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcddf5c31c90f503c1fd57bf7eb9e417641c5192b46278aac4b28be180dd2f658","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":2,"blockTimestamp":1749801550,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":567} 07:53:40 [07:53:40.876] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 07:53:40 [07:53:40.884] INFO: blob-sink:server Received blob sidecar for block 0x02d87e47ab36e1f7d4f4d4c89cf3a7b7634dbd8d0ee0a0d3157f27b8bd05915c 07:53:40 [07:53:40.895] INFO: blob-sink:server Blob sidecar stored successfully for block 0x02d87e47ab36e1f7d4f4d4c89cf3a7b7634dbd8d0ee0a0d3157f27b8bd05915c 07:53:40 [07:53:40.958] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749801586 07:53:40 [07:53:40.964] WARN: foundation:test-date-provider Time set to 2025-06-13T07:59:46.000Z {"offset":365036,"timeMs":1749801586000} 07:53:40 [07:53:40.964] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 07:53:41 [07:53:41.064] VERBOSE: archiver:block-helper Store contract instance at 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae 07:53:41 [07:53:41.089] VERBOSE: archiver:block-helper Store contract class 0x062ce75aa93d3c1c8900325c2d906975dc048b9aea013217c0b306cd8416fcf2 07:53:41 [07:53:41.141] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0b6a1020d3c96c5ab57d8eb5bba2f1313681dec751da24aa083e0bb60fcfca3c","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"archiveRoot":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","archiveNextLeafIndex":3} 07:53:41 [07:53:41.145] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 07:53:41 [07:53:41.151] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 07:53:41 [07:53:41.256] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.003290000000561,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749801550,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":567} 07:53:41 [07:53:41.278] VERBOSE: p2p Synched to latest block 2 07:53:41 [07:53:41.398] VERBOSE: sequencer Cannot propose block 3 at next L2 slot 4 due to pending sync from L1 {"syncedToL1Ts":1749801562,"syncedToL2Slot":3,"nextSlot":4,"nextSlotTs":1749801586,"l1SlotDuration":12} 07:53:41 [07:53:41.627] INFO: aztecjs:deploy_sent_tx Contract 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae successfully deployed. 07:53:41 [07:53:41.632] INFO: e2e:e2e_keys Running test: Keys using nsk_app to detect nullification nsk_app and contract address are enough to detect note nullification 07:53:41 [07:53:41.702] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 07:53:41 [07:53:41.725] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","header":{"contentCommitment":{"blobsHash":"0x00b78f9f006098aeb4aa9be21b1cf7139ea706051a8aa855b396cb06f559c9ff","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749801550,"version":1148068633},"lastArchive":"0x2fb2920880d10f9ae7bdf93a4377604a4dc98000ab82796bb0ea7c4c393b47ea","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x186c13dbabbf41c4b13cc7bf03ac35ad87586a3e8c43de79673312967d0f489f","nullifierTree":"0x0694eae894f50d4cfa2f8ebf204afd5763a9120208bc3b3446b4333139484aea","publicDataTree":"0x1be8be09130edd7f2924c07c4ecca40745347725c8664a23ba4085a07e742492"},"totalFees":2176967520,"totalManaUsed":6552}} 07:53:41 [07:53:41.913] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:41 [07:53:41.966] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:41 [07:53:41.967] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:42 [07:53:42.086] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:42 [07:53:42.100] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:42 [07:53:42.126] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:42 [07:53:42.147] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1212df30acd0de5f9711ce6e2eef261d1388a6dfd3274754a892f443c021c8f8 07:53:42 [07:53:42.162] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:42 [07:53:42.163] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 07:53:42 [07:53:42.178] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:42 [07:53:42.179] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:42 [07:53:42.183] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:42 [07:53:42.192] VERBOSE: pxe:service Added note {"index":0,"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x26f8db62bd170682e7d3f3dbe24900af8e966ba430b9d0f014f1b77d20bd7310","nullifier":"0x10bd213354c0e76c2f200276d2579583a05c825e3e2045144a8de286253113c8"} 07:53:42 [07:53:42.221] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa as fee payer 07:53:43 [07:53:43.138] VERBOSE: simulator:private_execution Executing private function Test:call_create_note {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:43 [07:53:43.185] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:43 [07:53:43.185] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:43 [07:53:43.214] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:43 [07:53:43.216] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:43 [07:53:43.465] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:43 [07:53:43.469] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:44 [07:53:44.113] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:44 [07:53:44.174] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:45 [07:53:45.130] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:45 [07:53:45.146] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:45 [07:53:45.516] INFO: pxe:service Proving completed in 3831.3837219999987ms {"timings":{"total":3831.3837219999987,"sync":43.788636000001134,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":634.4315279999937,"oracles":{"debugLog":{"times":[0.7969190000003437,0.7855090000011842,0.7583289999965928,0.8189999999995052,0.5459429999973509,0.32552799999757553,0.7836600000009639,1.1989789999970526]},"fetchTaggedLogs":{"times":[176.63538000000335]},"loadCapsule":{"times":[0.48292200000287266,0.3911200000002282,0.5839239999986603,0.3415480000003299,0.36526900000171736,0.22471500000028755,0.2991569999976491]},"getSharedSecret":{"times":[4.93713199999911]},"aes128Decrypt":{"times":[0.44107099999746424,1.2804709999982151]},"getPublicKeysAndPartialAddress":{"times":[2.444949999997334]},"getKeyValidationRequest":{"times":[9.039612000000488]},"storeCapsule":{"times":[1.3383329999996931,0.44611100000111037,0.33049800000299]},"deleteCapsule":{"times":[0.3501289999985602]},"validateEnqueuedNotesAndEvents":{"times":[11.824130999997578]},"getNotes":{"times":[7.652618000000075]},"getAuthWitness":{"times":[0.31523700000252575]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11062300000048708]},"callPrivateFunction":{"times":[1760.2909639999998]}}},{"functionName":"private_kernel_init","time":86.58329700000104},{"functionName":"Test:call_create_note","time":1569.4882460000008,"oracles":{"debugLog":{"times":[0.7232680000015534,0.3098580000005313]},"fetchTaggedLogs":{"times":[282.36849900000016]},"loadCapsule":{"times":[0.26299699999799486,0.15259299999888754,0.20114500000272528]},"validateEnqueuedNotesAndEvents":{"times":[1.6135289999983797]},"getRandomField":{"times":[0.11561299999812036,0.07075199999962933,0.1368030000012368,0.04805099999794038,0.04972099999940838,0.057911000003514346,0.057742000000871485,0.06249200000092969,0.050180999998701736,0.05268100000103004,0.05030099999930826,0.045530999999755295]},"notifyCreatedNote":{"times":[0.1412930000005872]},"getIndexedTaggingSecretAsSender":{"times":[211.8118940000022]},"incrementAppTaggingSecretIndexAsSender":{"times":[270.3502129999979]}}},{"functionName":"private_kernel_inner","time":194.04454800000167},{"functionName":"private_kernel_reset","time":291.89172300000064},{"functionName":"private_kernel_tail","time":102.05694699999731}],"unaccounted":909.0987970000024}} 07:53:45 [07:53:45.586] VERBOSE: p2p:tx_pool Adding tx 0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0 to pool {"eventName":"tx-added-to-pool","txHash":"0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0","noteHashCount":1,"nullifierCount":1,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 07:53:45 [07:53:45.598] INFO: node Received tx 0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0 {"txHash":"0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0"} 07:53:45 [07:53:45.598] INFO: pxe:service Sent transaction 0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0 07:53:45 [07:53:45.832] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"chainTipArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","blockNumber":3,"slot":4} 07:53:45 [07:53:45.870] VERBOSE: block-builder Building block 3 for slot 4 {"slot":4,"slotStart":"2025-06-13T07:59:46.000Z","now":"2025-06-13T07:59:50.906Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 07:53:45 [07:53:45.918] VERBOSE: simulator:public-processor Processed tx 0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0 with no public calls in 24.673006000000896ms {"txHash":"0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0","txFee":1097787040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11264,"l2Gas":3304},"billedGas":{"daGas":11264,"l2Gas":3304},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":24.673006000000896} 07:53:45 [07:53:45.921] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.047433486000001725s {"duration":0.047433486000001725,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11264,"l2Gas":3304},"totalSizeInBytes":960} 07:53:45 [07:53:45.958] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ff2ddcb8a88744456f87d455faff759b7a96253419ed17a614afd3505dc0078","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"txHashes":["0x15508fbddaa9bdd8788ad7b2309175a64e9464e52cbe4b6d186ad86649e22da0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":94.00855000000229,"publicProcessDuration":48.207964999997785,"rollupCircuitsDuration":88.3805919999977,"txCount":1,"blockNumber":3,"blockTimestamp":1749801586,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:45 [07:53:45.962] VERBOSE: sequencer Attesting committee is empty 07:53:46 [07:53:46.229] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x006bcdd1e101ffdcec38659fd7db7bdc585060abf5ed189ce6fb13b63b4213b0 07:53:46 [07:53:46.230] VERBOSE: node Sent L1 transaction 0x006bcdd1e101ffdcec38659fd7db7bdc585060abf5ed189ce6fb13b63b4213b0 {"gasLimit":407296,"maxFeePerGas":"1.25003169","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 07:53:46 [07:53:46.267] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 07:53:46 [07:53:46.267] WARN: foundation:test-date-provider Time set to 2025-06-13T07:59:58.000Z {"offset":371733,"timeMs":1749801598000} 07:53:46 [07:53:46.277] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 07:53:46 [07:53:46.277] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x006bcdd1e101ffdcec38659fd7db7bdc585060abf5ed189ce6fb13b63b4213b0","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":3,"blockTimestamp":1749801586,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:46 [07:53:46.278] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 07:53:46 [07:53:46.284] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 07:53:46 [07:53:46.288] INFO: blob-sink:server Received blob sidecar for block 0xfcf6f7f7f899b0e6373a183e049a97a0640292fc786e8a8e39b124991a486dae 07:53:46 [07:53:46.295] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 07:53:46 [07:53:46.301] INFO: blob-sink:server Blob sidecar stored successfully for block 0xfcf6f7f7f899b0e6373a183e049a97a0640292fc786e8a8e39b124991a486dae 07:53:46 [07:53:46.358] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749801622 07:53:46 [07:53:46.362] WARN: foundation:test-date-provider Time set to 2025-06-13T08:00:22.000Z {"offset":395638,"timeMs":1749801622000} 07:53:46 [07:53:46.363] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 07:53:46 [07:53:46.852] VERBOSE: sequencer Cannot propose block 3 at next L2 slot 5 due to pending sync from L1 {"syncedToL1Ts":1749801586,"syncedToL2Slot":4,"nextSlot":5,"nextSlotTs":1749801622,"l1SlotDuration":12} 07:53:46 [07:53:46.868] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1ff2ddcb8a88744456f87d455faff759b7a96253419ed17a614afd3505dc0078","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"archiveRoot":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","archiveNextLeafIndex":4} 07:53:46 [07:53:46.872] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 07:53:46 [07:53:46.987] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":15.774387999997998,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749801586,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:46 [07:53:46.998] VERBOSE: p2p Synched to latest block 3 07:53:47 [07:53:47.380] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:47 [07:53:47.388] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:47 [07:53:47.692] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","header":{"contentCommitment":{"blobsHash":"0x00cce9bdea82d6550d706218cf95a906a4accc31c481af137c60b81d477d72fe","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749801586,"version":1148068633},"lastArchive":"0x238380845113031dac3dd8de841e084ec8f79fbcf818bd2eeb286ba50cc5a08b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x16791cbf591b94bd6258fc90ffae0ab263e6e711da2494bcb09e2f149ee191be","nullifierTree":"0x0e6dee1afa839f000c43288e7f49dbafa56296d85bd7d2bae68a53ff5ed15717","publicDataTree":"0x0b45e0be562a037eac2aaeeffaeebcc36edf22f434bb5e84ed7b716d2d0b6928"},"totalFees":1097787040,"totalManaUsed":3304}} 07:53:47 [07:53:47.848] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:47 [07:53:47.899] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:47 [07:53:47.899] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:47 [07:53:47.989] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:47 [07:53:47.997] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:48 [07:53:48.042] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:48 [07:53:48.050] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1212df30acd0de5f9711ce6e2eef261d1388a6dfd3274754a892f443c021c8f8 07:53:48 [07:53:48.065] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:48 [07:53:48.068] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 07:53:48 [07:53:48.078] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:48 [07:53:48.079] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:48 [07:53:48.096] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:48 [07:53:48.114] VERBOSE: pxe:service Added note {"index":0,"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x26f8db62bd170682e7d3f3dbe24900af8e966ba430b9d0f014f1b77d20bd7310","nullifier":"0x10bd213354c0e76c2f200276d2579583a05c825e3e2045144a8de286253113c8"} 07:53:48 [07:53:48.158] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa as fee payer 07:53:48 [07:53:48.954] VERBOSE: simulator:private_execution Executing private function Test:call_destroy_note {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:49 [07:53:49.003] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:49 [07:53:49.004] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:49 [07:53:49.031] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:49 [07:53:49.033] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:49 [07:53:49.423] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:49 [07:53:49.428] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x21c21598b22ef378b1fac3ec95c4bb78ed75d19023a6740f0c9eaf66ffb8de8f 07:53:49 [07:53:49.445] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:49 [07:53:49.446] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 07:53:49 [07:53:49.462] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:49 [07:53:49.464] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:49 [07:53:49.470] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:49 [07:53:49.476] VERBOSE: pxe:service Added note {"index":128,"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x0b34b684dad067055b201dc3f7ab0ad3fc5fa98cb989e0c180be4a9d0983f00e","nullifier":"0x018fe18419598373049314274ea4bd5760139d561ad429840b26d7a85b288a95"} 07:53:49 [07:53:49.673] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:49 [07:53:49.675] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:50 [07:53:50.674] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:50 [07:53:50.679] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:50 [07:53:50.966] INFO: pxe:service Proving completed in 3290.773792ms {"timings":{"total":3290.773792,"sync":20.245237999999517,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":601.932628999999,"oracles":{"debugLog":{"times":[0.8122800000019197,0.5629740000003949,1.9972789999992528,0.978343999999197,0.6213650000026973,0.3652990000009595,0.7153380000017933,0.7445880000013858]},"fetchTaggedLogs":{"times":[148.31232399999863]},"loadCapsule":{"times":[0.6688159999976051,0.25524700000096345,0.5218119999990449,0.6500359999990906,0.2479170000005979,3.569127999999182,9.011281999999483]},"getSharedSecret":{"times":[5.109105999999883]},"aes128Decrypt":{"times":[0.337878999998793,1.1204479999978503]},"getPublicKeysAndPartialAddress":{"times":[2.3269470000013825]},"getKeyValidationRequest":{"times":[1.8783359999979439]},"storeCapsule":{"times":[5.091055000000779,3.0804860000025656,1.1053979999996955]},"deleteCapsule":{"times":[2.1546129999987897]},"validateEnqueuedNotesAndEvents":{"times":[12.829385000000912]},"getNotes":{"times":[24.816719000002195]},"getAuthWitness":{"times":[0.29331699999966077]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.12158300000010058]},"callPrivateFunction":{"times":[1367.578293999999]}}},{"functionName":"private_kernel_init","time":95.39061399999628},{"functionName":"Test:call_destroy_note","time":1202.3968560000067,"oracles":{"debugLog":{"times":[0.8251400000008289,0.48447200000373414,0.4829719999979716,0.565894000006665,1.1615979999987758,0.9470240000009653,0.6805370000001858]},"fetchTaggedLogs":{"times":[421.8591060000035]},"loadCapsule":{"times":[0.2519560000000638,0.1700249999994412,0.4611120000045048,0.7367080000040005,0.3122280000025057,0.2962279999992461,0.28888699999515666]},"getSharedSecret":{"times":[7.611508000001777]},"aes128Decrypt":{"times":[0.36875899999722606,1.0533660000000964]},"getPublicKeysAndPartialAddress":{"times":[4.302636000000348,2.103661999994074]},"getKeyValidationRequest":{"times":[6.80251799999678,6.604792999998608]},"storeCapsule":{"times":[0.9910640000016429,0.8230699999985518,0.413990000000922]},"deleteCapsule":{"times":[0.46038099999714177]},"validateEnqueuedNotesAndEvents":{"times":[6.865058000003046]},"getNotes":{"times":[5.704389999998966]},"notifyNullifiedNote":{"times":[0.8081690000035451]}}},{"functionName":"private_kernel_inner","time":138.85695300000225},{"functionName":"private_kernel_reset","time":199.33708800000022},{"functionName":"private_kernel_tail","time":94.96812399999908}],"unaccounted":937.646289999997}} 07:53:50 [07:53:50.994] VERBOSE: p2p:tx_pool Adding tx 0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472 to pool {"eventName":"tx-added-to-pool","txHash":"0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 07:53:50 [07:53:50.997] INFO: node Received tx 0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472 {"txHash":"0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472"} 07:53:50 [07:53:50.997] INFO: pxe:service Sent transaction 0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472 07:53:51 [07:53:51.246] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"chainTipArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","blockNumber":4,"slot":5} 07:53:51 [07:53:51.261] VERBOSE: block-builder Building block 4 for slot 5 {"slot":5,"slotStart":"2025-06-13T08:00:22.000Z","now":"2025-06-13T08:00:26.899Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 07:53:51 [07:53:51.315] VERBOSE: simulator:public-processor Processed tx 0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472 with no public calls in 24.222716000003857ms {"txHash":"0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472","txFee":113659760,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":3532},"billedGas":{"daGas":1536,"l2Gas":3532},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":24.222716000003857} 07:53:51 [07:53:51.318] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04552781799999502s {"duration":0.04552781799999502,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3532},"totalSizeInBytes":288} 07:53:51 [07:53:51.346] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0a5a82bdf73e353f2ce430883d895f3c80670b889fd7b17282ea041c74e307e7","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"txHashes":["0x0cec4d30c62ed5b95080ced04c25fed76ff89c6d257f0a34df7fe0db44f3a472"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":91.98554000000149,"publicProcessDuration":46.21284600000217,"rollupCircuitsDuration":85.3093760000047,"txCount":1,"blockNumber":4,"blockTimestamp":1749801622,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:51 [07:53:51.352] VERBOSE: sequencer Attesting committee is empty 07:53:51 [07:53:51.586] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x29bfb328a8778364235c4486945c43bae62aeecc85dbccc9af17f6143b61e835 07:53:51 [07:53:51.587] VERBOSE: node Sent L1 transaction 0x29bfb328a8778364235c4486945c43bae62aeecc85dbccc9af17f6143b61e835 {"gasLimit":407308,"maxFeePerGas":"1.238406206","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 07:53:51 [07:53:51.617] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 07:53:51 [07:53:51.618] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x29bfb328a8778364235c4486945c43bae62aeecc85dbccc9af17f6143b61e835","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":4,"blockTimestamp":1749801622,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:51 [07:53:51.619] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 07:53:51 [07:53:51.627] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 07:53:51 [07:53:51.627] WARN: foundation:test-date-provider Time set to 2025-06-13T08:00:34.000Z {"offset":402373,"timeMs":1749801634000} 07:53:51 [07:53:51.637] INFO: blob-sink:server Received blob sidecar for block 0xa357fb8307ee73c7d2ad48892aca6dd9939cf1c94d843dc8c69c96b293d40fdc 07:53:51 [07:53:51.656] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 07:53:51 [07:53:51.662] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa357fb8307ee73c7d2ad48892aca6dd9939cf1c94d843dc8c69c96b293d40fdc 07:53:51 [07:53:51.665] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 07:53:51 [07:53:51.685] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749801658 07:53:51 [07:53:51.685] WARN: foundation:test-date-provider Time set to 2025-06-13T08:00:58.000Z {"offset":426315,"timeMs":1749801658000} 07:53:51 [07:53:51.685] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 07:53:51 [07:53:51.852] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0a5a82bdf73e353f2ce430883d895f3c80670b889fd7b17282ea041c74e307e7","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"archiveRoot":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","archiveNextLeafIndex":5} 07:53:51 [07:53:51.856] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 07:53:51 [07:53:51.959] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":10.138379000003624,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749801622,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 07:53:52 [07:53:52.034] VERBOSE: p2p Synched to latest block 4 07:53:52 [07:53:52.087] INFO: e2e:e2e_keys Running test: Keys ovsk_app gets ovsk_app 07:53:52 [07:53:52.105] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa {"origin":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000446e2319","authWitnesses":["0x0af9344cb43332f2c6a342cb3ed81f905b73af905e3d9881ac2ca39d3e3f3ebc"]} 07:53:52 [07:53:52.113] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","header":{"contentCommitment":{"blobsHash":"0x004cc569427f4584d6463459d0cf86bd172b85ad57829cfac3525e62e7cb6453","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749801622,"version":1148068633},"lastArchive":"0x064a296900eac53a31ebd954ea37b51afc67bb1c8aa80a232e4c6488812453e7","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x16791cbf591b94bd6258fc90ffae0ab263e6e711da2494bcb09e2f149ee191be","nullifierTree":"0x0ff5457b58a6576904f4b785a0351714a2a65560db01c2cda65cd25f90fb05f8","publicDataTree":"0x1b678bcad48de2bed82f967716f298efae1e605cf34103ba097b5fde1167f821"},"totalFees":113659760,"totalManaUsed":3532}} 07:53:52 [07:53:52.230] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:52 [07:53:52.294] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:52 [07:53:52.294] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:52 [07:53:52.353] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:52 [07:53:52.355] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:52 [07:53:52.383] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa"} 07:53:52 [07:53:52.390] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1212df30acd0de5f9711ce6e2eef261d1388a6dfd3274754a892f443c021c8f8 07:53:52 [07:53:52.401] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:52 [07:53:52.403] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 07:53:52 [07:53:52.411] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:52 [07:53:52.412] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:52 [07:53:52.415] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:52 [07:53:52.419] VERBOSE: pxe:service Added note {"index":0,"contract":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x26f8db62bd170682e7d3f3dbe24900af8e966ba430b9d0f014f1b77d20bd7310","nullifier":"0x10bd213354c0e76c2f200276d2579583a05c825e3e2045144a8de286253113c8"} 07:53:52 [07:53:52.433] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa as fee payer 07:53:52 [07:53:52.869] VERBOSE: simulator:private_execution Executing private function Test:get_ovsk_app {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:52 [07:53:52.885] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 07:53:52 [07:53:52.885] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:53 [07:53:53.052] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:53 [07:53:53.055] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:53 [07:53:53.080] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae"} 07:53:53 [07:53:53.087] VERBOSE: pxe:service Removed note for contract 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae at slot 0x000000000000000000000000000000000000000000000000000000000000000c {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","nullifier":"0x018fe18419598373049314274ea4bd5760139d561ad429840b26d7a85b288a95"} 07:53:53 [07:53:53.090] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x21c21598b22ef378b1fac3ec95c4bb78ed75d19023a6740f0c9eaf66ffb8de8f 07:53:53 [07:53:53.103] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 07:53:53 [07:53:53.104] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 07:53:53 [07:53:53.118] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 07:53:53 [07:53:53.119] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 07:53:53 [07:53:53.124] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 07:53:53 [07:53:53.129] VERBOSE: pxe:service Added note {"index":128,"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x0b34b684dad067055b201dc3f7ab0ad3fc5fa98cb989e0c180be4a9d0983f00e","nullifier":"0x018fe18419598373049314274ea4bd5760139d561ad429840b26d7a85b288a95"} 07:53:53 [07:53:53.131] VERBOSE: pxe:service Removed just-added note {"contract":"0x024cdc5734b3c5177352e13e0f7501da3cfd55d2ef01acd5dd6cd84fa8017bae","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x0b34b684dad067055b201dc3f7ab0ad3fc5fa98cb989e0c180be4a9d0983f00e","nullifier":"0x018fe18419598373049314274ea4bd5760139d561ad429840b26d7a85b288a95"} 07:53:54 [07:53:54.184] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:54 [07:53:54.193] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:54 [07:53:54.584] INFO: pxe:service Simulation completed for 0x25f03145d660fc7308ffc97eb97b79f521dcbf04234fac27bc3d2ad892c25782 in 2477.312460000001ms {"txHash":"0x25f03145d660fc7308ffc97eb97b79f521dcbf04234fac27bc3d2ad892c25782","origin":"0x24149f2aad2710f6c2f7ffb6c305d68222e95b1ac9ec72cd8550b4a2b71eaaaa","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000446e2319","authWitnesses":["0x0af9344cb43332f2c6a342cb3ed81f905b73af905e3d9881ac2ca39d3e3f3ebc"]} 07:53:54 [07:53:54.599] INFO: node Stopping Aztec Node 07:53:54 [07:53:54.734] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:54 [07:53:54.737] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:55 [07:53:55.258] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:55 [07:53:55.263] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:55 [07:53:55.864] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:55 [07:53:55.881] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:56 [07:53:56.406] VERBOSE: sequencer Preparing proposal for block 5 at slot 6 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749801658,"version":1148068633},"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:56 [07:53:56.408] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x047771d1c45b5d93d01fc2dab5b0c35e4064ab6c0d655a4f32549eb37b2a20a8","blockNumber":5,"slot":6} 07:53:56 [07:53:56.605] INFO: slasher Slasher client stopped. 07:53:56 [07:53:56.606] INFO: sequencer Stopped sequencer 07:53:56 [07:53:56.607] INFO: p2p P2P client stopped 07:53:56 [07:53:56.610] INFO: world_state Stopped world state synchronizer 07:53:56 [07:53:56.611] INFO: archiver Stopped. 07:53:56 [07:53:56.611] INFO: node Stopped Aztec Node 07:53:56 [07:53:56.631] INFO: blob-sink:server Stopping blob sink 07:53:56 [07:53:56.632] INFO: blob-sink:server Blob sink stopped 07:53:56 PASS src/e2e_keys.test.ts 07:53:56 Keys 07:53:56 using nsk_app to detect nullification 07:53:56 nsk_app and contract address are enough to detect note nullification (10456 ms) 07:53:56 ovsk_app 07:53:56 gets ovsk_app (2502 ms) 07:53:56 07:53:56 Test Suites: 1 passed, 1 total 07:53:56 Tests: 2 passed, 2 total 07:53:56 Snapshots: 0 total 07:53:56 Time: 40.794 s 07:53:56 Ran all test suites matching /src\/e2e_keys.test.ts/i. 07:53:56 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?