ACI ·

Parent Log: http://ci.aztec-labs.com/64e2bdc106a2b1fc Command: e5b0f4b393972465:ISOLATE=1:NAME=e2e_offchain_message yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_offchain_message.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/a8c553f203c98e5ca274e763c8e51daaaaf760d6 Env: REF_NAME=gh-readonly-queue/next/pr-15017-30660269b33bab8cca354c41659533acf4d48e07 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Fri Jun 13 09:39:32 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15017_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_9323dbf3b3f7fe91_next 09:39:32 +++ id -u 09:39:32 +++ id -g 09:39:32 ++ docker run -d --name e2e_offchain_message --net=none --cpuset-cpus=0-63 --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_offchain_message.test.ts'\''' 09:39:33 + cid=b02729dee873673ea315b5b1f287e0137000aa7d70925c2d4c0c62441f85b1a4 09:39:33 + set +x 09:39:33 {"level":25,"time":1749807573580,"pid":12,"hostname":"b02729dee873","module":"logger","msg":"Logger initialized with level verbose"} 09:39:37 [09:39:37.740] INFO: e2e:e2e_offchain_message Logging metrics to log/unknown.jsonl 09:39:38 [09:39:38.191] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-MtQyNE/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 09:39:38 [09:39:38.224] INFO: e2e:e2e_offchain_message Calling anvil_setBlockTimestampInterval with params: [12] 09:39:38 [09:39:38.245] WARN: e2e:e2e_offchain_message Set block interval to 12 09:39:38 [09:39:38.246] VERBOSE: e2e:e2e_offchain_message Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 09:39:38 [09:39:38.292] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 09:39:38 [09:39:38.301] VERBOSE: e2e:e2e_offchain_message Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 09:39:38 [09:39:38.317] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 09:39:38 [09:39:38.322] VERBOSE: e2e:e2e_offchain_message Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 09:39:38 [09:39:38.340] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x127d08cafb8afc3d7c988fa49d05483d6d2b44a017de0544d9d53ed8e954f028 {"gasLimit":3068916,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 09:39:38 [09:39:38.345] VERBOSE: e2e:e2e_offchain_message Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 09:39:38 [09:39:38.359] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xdb9612b2166822d6497afb75ab3fe675145b118f9d3ef58bc23bdb9816e5d0f5 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 09:39:38 [09:39:38.364] VERBOSE: e2e:e2e_offchain_message Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 09:39:38 [09:39:38.382] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x32ed4059fca555e8be9e05117cb7e979fafb635b31d08729d246c0704eaa1138 {"gasLimit":1966612,"maxFeePerGas":"3.602497631","maxPriorityFeePerGas":"2.48832"} 09:39:38 [09:39:38.386] VERBOSE: e2e:e2e_offchain_message Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 09:39:38 [09:39:38.402] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xf29078d6fdb1fd1334c85ea0a8f17d2b4c4766e863a0822c2fb665091b723499 {"gasLimit":3042380,"maxFeePerGas":"3.968738902","maxPriorityFeePerGas":"2.985984"} 09:39:38 [09:39:38.406] VERBOSE: e2e:e2e_offchain_message Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 09:39:38 [09:39:38.417] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 {"gasLimit":100000,"maxFeePerGas":"4.456512857","maxPriorityFeePerGas":"3.5831808"} 09:39:38 [09:39:38.417] VERBOSE: e2e:e2e_offchain_message Set governance on GSE in 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 09:39:38 [09:39:38.429] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xd7c909c2f426dbb387bba51539e35cd537bbd9383154eb2618179b00ef0008b2 {"gasLimit":391705,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 09:39:38 [09:39:38.433] VERBOSE: e2e:e2e_offchain_message Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 09:39:38 [09:39:38.433] VERBOSE: e2e:e2e_offchain_message Waiting for deployments to complete 09:39:38 [09:39:38.434] INFO: e2e:e2e_offchain_message Waiting for 7 transactions to be mined... 09:39:38 [09:39:38.456] INFO: e2e:e2e_offchain_message All transactions mined successfully 09:39:38 [09:39:38.467] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca {"gasLimit":100000,"maxFeePerGas":"5.844872118","maxPriorityFeePerGas":"5.159780352"} 09:39:38 [09:39:38.467] VERBOSE: e2e:e2e_offchain_message Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca 09:39:38 [09:39:38.480] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x7ef4acce2d29fb2e046cebc7a8a26e7c7540e156376f7b1c5bb5b863cbe564c3 {"gasLimit":56661,"maxFeePerGas":"6.793055288","maxPriorityFeePerGas":"6.191736422"} 09:39:38 [09:39:38.492] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xb25c5ab4294e8fbc0c9624e56aa31ec351526cb6af6350c11417f282dd0f9bd3 {"gasLimit":339705,"maxFeePerGas":"7.956474918","maxPriorityFeePerGas":"7.430083706"} 09:39:38 [09:39:38.497] VERBOSE: e2e:e2e_offchain_message Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 09:39:38 [09:39:38.508] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 {"gasLimit":56804,"maxFeePerGas":"9.376899884","maxPriorityFeePerGas":"8.916100447"} 09:39:38 [09:39:38.508] VERBOSE: e2e:e2e_offchain_message Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 09:39:38 [09:39:38.526] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xf9401b33d177baeffffb49aad9037387d78c09beb9e9ec7ba1d3f2570522b753 {"gasLimit":2474287,"maxFeePerGas":"11.103607102","maxPriorityFeePerGas":"10.699320536"} 09:39:38 [09:39:38.531] VERBOSE: e2e:e2e_offchain_message Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 09:39:38 [09:39:38.542] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 {"gasLimit":56804,"maxFeePerGas":"13.193094869","maxPriorityFeePerGas":"12.839184643"} 09:39:38 [09:39:38.543] VERBOSE: e2e:e2e_offchain_message Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 09:39:38 [09:39:38.543] VERBOSE: e2e:e2e_offchain_message Waiting for deployments to complete 09:39:38 [09:39:38.543] INFO: e2e:e2e_offchain_message Waiting for 9 transactions to be mined... 09:39:38 [09:39:38.565] INFO: e2e:e2e_offchain_message All transactions mined successfully 09:39:38 [09:39:38.576] VERBOSE: e2e:e2e_offchain_message Deployed shared contracts 09:39:38 [09:39:38.590] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 {"gasLimit":84837,"maxFeePerGas":"15.722774098","maxPriorityFeePerGas":"15.407021571"} 09:39:38 [09:39:38.590] VERBOSE: e2e:e2e_offchain_message Funded reward distributor with 10000000000000000000000000 fee asset in 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 09:39:38 [09:39:38.603] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xdef66310c9d0b7dd201d14d81f0afe9cb0a7a1bcdfb3985c400aaac3112b99a8 {"gasLimit":152965,"maxFeePerGas":"18.764833904","maxPriorityFeePerGas":"18.488425885"} 09:39:38 [09:39:38.607] VERBOSE: e2e:e2e_offchain_message Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 09:39:38 [09:39:38.607] VERBOSE: e2e:e2e_offchain_message 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}} 09:39:38 [09:39:38.617] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xa30936656c85bd30a140fccee2cc68506bbb2794b4d16485d9d2cef61cfec969 {"gasLimit":86383,"maxFeePerGas":"22.428130924","maxPriorityFeePerGas":"22.186111062"} 09:39:38 [09:39:38.638] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xbe78ed180cb67f2324e0f55f5bcf89cc6f9feb261fdc97fb4688481193c42049 {"gasLimit":5075920,"maxFeePerGas":"26.835357743","maxPriorityFeePerGas":"26.623333274"} 09:39:38 [09:39:38.659] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xadefaa698fbe2ccad8b7262edf757f1bbec31f893ad6df9dc23634f426ba2e27 {"gasLimit":2439043,"maxFeePerGas":"32.133648528","maxPriorityFeePerGas":"31.947999928"} 09:39:38 [09:39:38.663] VERBOSE: e2e:e2e_offchain_message Awaiting for linked libraries to be deployed 09:39:38 [09:39:38.699] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x83112c1d95569c7681dcb79e56d6b61a3d51f7d0ab52c6cb8e56d7ef3342e8be {"gasLimit":10498896,"maxFeePerGas":"38.506586449","maxPriorityFeePerGas":"38.337599913"} 09:39:38 [09:39:38.705] VERBOSE: e2e:e2e_offchain_message 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}} 09:39:38 [09:39:38.705] INFO: e2e:e2e_offchain_message Waiting for 11 transactions to be mined... 09:39:38 [09:39:38.729] INFO: e2e:e2e_offchain_message All transactions mined successfully 09:39:38 [09:39:38.730] VERBOSE: e2e:e2e_offchain_message All core contracts have been deployed 09:39:38 [09:39:38.743] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 {"gasLimit":64317,"maxFeePerGas":"46.155845375","maxPriorityFeePerGas":"46.005119895"} 09:39:38 [09:39:38.743] VERBOSE: e2e:e2e_offchain_message Funding fee juice portal with 10000000000000000000000 fee juice in 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 (accelerated test deployments) 09:39:38 [09:39:38.755] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x6a926be81b73dd91dae704702483da1c551ca87b055c30c4ea85773cbb8c17f2 {"gasLimit":1040131,"maxFeePerGas":"55.349017914","maxPriorityFeePerGas":"55.206143874"} 09:39:38 [09:39:38.758] VERBOSE: e2e:e2e_offchain_message Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 09:39:38 [09:39:38.776] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a {"gasLimit":116846,"maxFeePerGas":"66.372451249","maxPriorityFeePerGas":"66.247372648"} 09:39:38 [09:39:38.777] VERBOSE: e2e:e2e_offchain_message Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a 09:39:38 [09:39:38.790] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e {"gasLimit":109478,"maxFeePerGas":"79.607194411","maxPriorityFeePerGas":"79.496847177"} 09:39:38 [09:39:38.790] VERBOSE: e2e:e2e_offchain_message Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e 09:39:38 [09:39:38.794] INFO: e2e:e2e_offchain_message Waiting for 12 transactions to be mined... 09:39:38 [09:39:38.819] INFO: e2e:e2e_offchain_message All transactions mined successfully 09:39:38 [09:39:38.825] VERBOSE: e2e:e2e_offchain_message Rollup deployed 09:39:38 [09:39:38.825] VERBOSE: e2e:e2e_offchain_message Waiting for rollup and slash factory to be deployed 09:39:38 [09:39:38.825] INFO: e2e:e2e_offchain_message Waiting for 12 transactions to be mined... 09:39:38 [09:39:38.847] INFO: e2e:e2e_offchain_message All transactions mined successfully 09:39:38 [09:39:38.847] VERBOSE: e2e:e2e_offchain_message All transactions for L1 deployment have been mined 09:39:38 [09:39:38.863] INFO: e2e:e2e_offchain_message 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"} 09:39:38 [09:39:38.863] INFO: e2e:e2e_offchain_message Handing over to governance 09:39:38 [09:39:38.871] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 09:39:38 [09:39:38.872] INFO: telemetry:client Using NoopTelemetryClient 09:39:38 [09:39:38.877] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:38 [09:39:38.878] WARN: foundation:test-date-provider Time set to 2025-06-13T09:44:25.000Z {"offset":286123,"timeMs":1749807865000} 09:39:38 [09:39:38.878] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/328df1c332c2a2df/blob-sink with map size 134217728 KB (LMDB v2) 09:39:38 [09:39:38.883] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 09:39:38 [09:39:38.888] INFO: blob-sink:server Server is running on http://localhost:34825 09:39:38 [09:39:38.888] VERBOSE: e2e:e2e_offchain_message Creating and synching an aztec node... 09:39:38 [09:39:38.889] VERBOSE: e2e:e2e_offchain_message Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/d593c24c/acvm 09:39:38 [09:39:38.889] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34825"} 09:39:38 [09:39:38.910] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 09:39:38 [09:39:38.910] INFO: archiver:lmdb Creating archiver data store at directory /tmp/328df1c332c2a2df/archiver with map size 134217728 KB (LMDB v2) 09:39:38 [09:39:38.911] INFO: archiver:lmdb Starting data store with maxReaders 16 09:39:39 [09:39:39.198] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34825"} 09:39:39 [09:39:39.212] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34825"} 09:39:39 [09:39:39.212] WARN: node:blob-sink:client No L1 consensus host urls configured 09:39:39 [09:39:39.213] WARN: node:blob-sink:client No archive client configured 09:39:39 [09:39:39.215] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xf781592b3fb5a3c74bac764b1ad70cc08ad57327cb6ee66ed26b78dc62c12071 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x2ba0ff0b373fe401cc76279069e14621164bd2bfe7ea3cdc9d7f3dd728650afa","l1BlockNumber":20}} 09:39:39 [09:39:39.228] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xf781592b3fb5a3c74bac764b1ad70cc08ad57327cb6ee66ed26b78dc62c12071","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:39:39 [09:39:39.232] INFO: world-state:database Creating world state data store at directory /tmp/328df1c332c2a2df/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 09:39:39 [09:39:39.253] INFO: world_state Created world state synchroniser with block history of 64 09:39:39 [09:39:39.254] WARN: node Aztec node is accepting fake proofs 09:39:39 [09:39:39.263] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/328df1c332c2a2df/p2p with map size 134217728 KB (LMDB v2) 09:39:39 [09:39:39.264] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:39:39 [09:39:39.265] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/328df1c332c2a2df/p2p-archive with map size 134217728 KB (LMDB v2) 09:39:39 [09:39:39.266] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:39:39 [09:39:39.266] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/328df1c332c2a2df/p2p-peers with map size 134217728 KB (LMDB v2) 09:39:39 [09:39:39.267] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:39:39 [09:39:39.268] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:39:39 [09:39:39.269] VERBOSE: p2p P2P is disabled. Using dummy P2P service 09:39:39 [09:39:39.271] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 09:39:39 [09:39:39.272] INFO: world_state Started world state synchronizer from block 1 09:39:39 [09:39:39.274] VERBOSE: world-state:block_stream Starting sync from block number 0 09:39:39 [09:39:39.275] INFO: p2p Starting p2p client from block 0 with empty mempools 09:39:39 [09:39:39.275] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 09:39:39 [09:39:39.504] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:39:39 [09:39:39.537] VERBOSE: validator Initialized validator with addresses: 0xaf65e81194f574dd3a010b92a7a2b10ca9ae32e8 09:39:39 [09:39:39.537] VERBOSE: node All Aztec Node subsystems synced 09:39:39 [09:39:39.550] INFO: slasher Starting Slasher client... 09:39:39 [09:39:39.559] INFO: sequencer-client Deploying forwarder contract 09:39:39 [09:39:39.561] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 09:39:39 [09:39:39.577] VERBOSE: sequencer-client Sent L1 transaction 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb {"gasLimit":323704,"maxFeePerGas":"95.492859983","maxPriorityFeePerGas":"95.396216612"} 09:39:39 [09:39:39.577] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb. 09:39:39 [09:39:39.582] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:39:39 [09:39:39.588] INFO: validator Started validator with addresses: 0xaf65e81194f574dd3a010b92a7a2b10ca9ae32e8 09:39:39 [09:39:39.589] VERBOSE: validator Validators 0xaf65e81194f574dd3a010b92a7a2b10ca9ae32e8 are not on the validator committee for epoch 0 09:39:39 [09:39:39.589] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/d593c24c/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 09:39:39 [09:39:39.589] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 09:39:39 [09:39:39.591] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:39:39 [09:39:39.592] INFO: node Aztec Node version: 0.87.6 09:39:39 [09:39:39.592] 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"} 09:39:39 [09:39:39.593] VERBOSE: e2e:e2e_offchain_message Creating a pxe... 09:39:39 [09:39:39.598] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/f9fcb0d2d32e83cd/pxe_data with map size 134217728 KB (LMDB v2) 09:39:39 [09:39:39.601] 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} 09:39:39 [09:39:39.602] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:39:39 [09:39:39.781] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:39 [09:39:39.781] WARN: foundation:test-date-provider Time set to 2025-06-13T09:44:37.000Z {"offset":297219,"timeMs":1749807877000} 09:39:39 [09:39:39.881] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 09:39:39 [09:39:39.881] INFO: pxe:service Started PXE connected to chain 31337 version 1488075002 09:39:39 [09:39:39.928] INFO: pxe:service Registered account 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 09:39:39 [09:39:39.981] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:39:39 [09:39:39.985] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 09:39:40 [09:39:40.118] INFO: pxe:service Added contract SchnorrAccount at 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:39:40 [09:39:40.135] 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":1749807889,"version":1488075002},"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:40 [09:39:40.137] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:40 [09:39:40.162] VERBOSE: pxe:block_stream Starting sync from block number 0 09:39:40 [09:39:40.202] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:39:40 [09:39:40.303] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:39:40 [09:39:40.694] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 09:39:40 [09:39:40.767] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 09:39:40 [09:39:40.849] 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":1749807889,"version":1488075002},"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:40 [09:39:40.850] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:40 [09:39:40.925] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:40 [09:39:40.961] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:40 [09:39:40.961] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:40 [09:39:41.000] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:41 [09:39:41.003] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:41 [09:39:41.180] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:41 [09:39:41.214] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:41 [09:39:41.214] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:41 [09:39:41.247] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:41 [09:39:41.250] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:41 [09:39:41.264] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:41 [09:39:41.538] 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":1749807889,"version":1488075002},"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:41 [09:39:41.539] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:42 [09:39:42.325] INFO: pxe:service Proving completed in 2164.5030460000007ms {"timings":{"total":2164.5030460000007,"sync":2.2397869999995237,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":141.5964759999997,"oracles":{"callPrivateFunction":{"times":[578.9214300000003,282.1397500000003,170.85459900000023]}}},{"functionName":"private_kernel_init","time":93.04704500000116},{"functionName":"ContractClassRegisterer:register","time":560.1838619999999,"oracles":{"loadCapsule":{"times":[9.549205000000256]},"notifyCreatedNullifier":{"times":[8.741722000000664]},"debugLog":{"times":[0.7218869999996969]},"notifyCreatedContractClassLog":{"times":[7.599065000000337]}}},{"functionName":"private_kernel_inner","time":115.93949900000007},{"functionName":"SchnorrAccount:constructor","time":256.4921749999994,"oracles":{"getContractInstance":{"times":[1.057690999999977]},"debugLog":{"times":[0.46900800000003073,0.3730599999998958]},"fetchTaggedLogs":{"times":[40.63296300000002]},"loadCapsule":{"times":[0.3296840000002703,0.20802200000071025,0.248105000000578]},"validateEnqueuedNotesAndEvents":{"times":[1.6839060000002064]},"notifyCreatedNullifier":{"times":[0.21182000000044354,0.2567029999991064]},"notifyCreatedNote":{"times":[0.5246829999996407]},"getRandomField":{"times":[0.2156989999994039,0.15048200000001088,0.0830550000000585,0.09393100000033883,0.06849500000043918,0.07240199999978358,0.06750300000021525,0.07003999999960797,0.06362999999964813,0.09686499999952503,0.060433999999986554]},"getIndexedTaggingSecretAsSender":{"times":[39.53386800000044]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.002309999999852]}}},{"functionName":"private_kernel_inner","time":109.96515599999839},{"functionName":"SchnorrAccount:entrypoint","time":144.2502629999999,"oracles":{"debugLog":{"times":[0.4426370000001043,0.3983920000009675,0.5698489999995218]},"fetchTaggedLogs":{"times":[34.315990999999485]},"loadCapsule":{"times":[0.2103819999992993,0.2308339999999589,0.22349399999984598]},"validateEnqueuedNotesAndEvents":{"times":[1.191450000000259]},"getNotes":{"times":[1.526369999999588]},"getAuthWitness":{"times":[0.36010300000089046]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7844400000012683]}}},{"functionName":"private_kernel_inner","time":109.83786999999938},{"functionName":"private_kernel_reset","time":173.87792600000103},{"functionName":"private_kernel_tail","time":70.58424299999933}],"unaccounted":386.48874400000295}} 09:39:42 [09:39:42.417] VERBOSE: p2p:tx_pool Adding tx 0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d to pool {"eventName":"tx-added-to-pool","txHash":"0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 09:39:42 [09:39:42.424] 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":1749807889,"version":1488075002},"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:42 [09:39:42.437] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:42 [09:39:42.437] INFO: node Received tx 0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d {"txHash":"0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d"} 09:39:42 [09:39:42.438] INFO: pxe:service Sent transaction 0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d 09:39:42 [09:39:42.946] 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":1749807889,"version":1488075002},"chainTipArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","blockNumber":1,"slot":2} 09:39:42 [09:39:42.960] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-13T09:44:49.000Z","now":"2025-06-13T09:44:40.179Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:39:43 [09:39:43.001] VERBOSE: simulator:public-processor Processed tx 0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d with no public calls in 20.166869000000588ms {"txHash":"0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d","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":20.166869000000588} 09:39:43 [09:39:43.004] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.041567768000000796s {"duration":0.041567768000000796,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:39:43 [09:39:43.030] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0047e23a1acdb026568538c9a0d5fdc84885f428d987b3403eda045380f24022","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807889,"version":1488075002},"txHashes":["0x1549d5983e3015f3e3acd57b88707de0d6171dcc555586e6ebd097aab4e43f6d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":77.3662230000009,"publicProcessDuration":42.31178,"rollupCircuitsDuration":71.0352329999987,"txCount":1,"blockNumber":1,"blockTimestamp":1749807889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:43 [09:39:43.033] VERBOSE: sequencer Attesting committee is empty 09:39:45 [09:39:45.732] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x39ef4a40bb074fcacf8e219f3564eeef44aa481d7a8f715551b10fcf6369489a 09:39:45 [09:39:45.732] VERBOSE: node Sent L1 transaction 0x39ef4a40bb074fcacf8e219f3564eeef44aa481d7a8f715551b10fcf6369489a {"gasLimit":486984,"maxFeePerGas":"114.56009636","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 09:39:45 [09:39:45.744] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:45 [09:39:45.745] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x39ef4a40bb074fcacf8e219f3564eeef44aa481d7a8f715551b10fcf6369489a","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":1,"blockTimestamp":1749807889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:45 [09:39:45.746] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:39:45 [09:39:45.760] INFO: blob-sink:server Received blob sidecar for block 0xfc63c07f0639f74629733f879dd1e48bee857c7d4dfc1f2d32329cb019dec70f 09:39:45 [09:39:45.765] INFO: blob-sink:server Blob sidecar stored successfully for block 0xfc63c07f0639f74629733f879dd1e48bee857c7d4dfc1f2d32329cb019dec70f 09:39:45 [09:39:45.846] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:45 [09:39:45.846] WARN: foundation:test-date-provider Time set to 2025-06-13T09:44:49.000Z {"offset":303154,"timeMs":1749807889000} 09:39:45 [09:39:45.849] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:39:45 [09:39:45.851] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:39:45 [09:39:45.924] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807925 09:39:45 [09:39:45.924] WARN: foundation:test-date-provider Time set to 2025-06-13T09:45:25.000Z {"offset":339076,"timeMs":1749807925000} 09:39:45 [09:39:45.924] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:39:46 [09:39:46.037] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:39:46 [09:39:46.042] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0047e23a1acdb026568538c9a0d5fdc84885f428d987b3403eda045380f24022","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807889,"version":1488075002},"archiveRoot":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","archiveNextLeafIndex":2} 09:39:46 [09:39:46.051] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:39:46 [09:39:46.120] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":55.37598799999978,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:46 [09:39:46.121] WARN: pxe:service No artifact found for contract class 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5 when looking for its metadata 09:39:46 [09:39:46.122] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5 as part of deployment for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd 09:39:46 [09:39:46.177] VERBOSE: p2p Synched to latest block 1 09:39:46 [09:39:46.313] INFO: pxe:service Added contract OffchainMessage at 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd with class 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5 09:39:46 [09:39:46.336] 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":1749807925,"version":1488075002},"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:46 [09:39:46.343] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:46 [09:39:46.349] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","header":{"contentCommitment":{"blobsHash":"0x007cc064f04d9f0da779c37f792e7ccc1d7a5a80aa8b13dd3e5e7602a7a79beb","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807889,"version":1488075002},"lastArchive":"0x19daa524358c435d6cb2428dfe3e9ca7c689d53bbf1e563e79ccb7dd18cdbc79","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0c0a450ab95091afd0611507d6c0850351a591d9c2f7ca6c506736b2452b13b6","nullifierTree":"0x2aea407fe839ca64d244b14782ae190ce2b7c8b48b9587a38bd3c8f059c521f6","publicDataTree":"0x0ff9d60b135cb09c371389504f77000a20c6fedfd50bfe823fcf80485556de50"},"totalFees":2101212240,"totalManaUsed":6324}} 09:39:46 [09:39:46.430] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:46 [09:39:46.462] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:46 [09:39:46.463] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:46 [09:39:46.519] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:46 [09:39:46.524] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:46 [09:39:46.535] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:46 [09:39:46.536] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:46 [09:39:46.541] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:46 [09:39:46.542] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:46 [09:39:46.544] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:46 [09:39:46.549] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:46 [09:39:46.562] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:46 [09:39:46.618] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:39:46 [09:39:46.929] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5,0x2f592dbe7e087ce36f4eb433cf3894d708f912cd24736847661984e4cdbc9e1d,0x03e247bc05b2cb615b364b2859d5c43f51e70ed747edc4a6dab18dbb557c1b0c,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 09:39:46 [09:39:46.999] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 09:39:47 [09:39:47.095] 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":1749807925,"version":1488075002},"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:47 [09:39:47.126] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 09:39:47 [09:39:47.132] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:47 [09:39:47.171] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:39:47 [09:39:47.181] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd,0x0000000000000000000000000000000000000000000000000000000000000001,0x2b2a06bb25f3abc8849dc552585a2e5ba05b4a8dccdd7d5ae79903907b04b880,0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 09:39:47 [09:39:47.829] 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":1749807925,"version":1488075002},"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:47 [09:39:47.831] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:48 [09:39:48.182] INFO: pxe:service Proving completed in 1840.4599230000003ms {"timings":{"total":1840.4599230000003,"sync":8.953555000000051,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":236.445816999998,"oracles":{"debugLog":{"times":[0.4792379999998957,0.39046699999926204,0.41583600000012666,0.5708859999995184,0.3716809999987163,0.3563510000003589,0.35035900000002584,0.457974999999351]},"fetchTaggedLogs":{"times":[57.498320000000604]},"loadCapsule":{"times":[0.22312199999942095,0.3687499999996362,1.9838500000005297,0.23459100000036415,0.1730390000011539,0.21306000000004133,0.21995799999967858]},"getSharedSecret":{"times":[3.3877470000006724]},"aes128Decrypt":{"times":[0.9473749999997381,0.9487430000008317]},"getPublicKeysAndPartialAddress":{"times":[1.3610099999987142]},"getKeyValidationRequest":{"times":[1.6640459999998711]},"storeCapsule":{"times":[0.43118300000060117,0.24338400000124238,0.22953699999925448]},"deleteCapsule":{"times":[0.3410389999990002]},"validateEnqueuedNotesAndEvents":{"times":[5.387773000000379]},"getNotes":{"times":[1.406566000001476]},"getAuthWitness":{"times":[0.21063999999933003]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.053065000000060536]},"callPrivateFunction":{"times":[485.11002499999995,139.80782400000135]}}},{"functionName":"private_kernel_init","time":52.81811200000084},{"functionName":"ContractClassRegisterer:register","time":462.6605600000021,"oracles":{"loadCapsule":{"times":[3.5819529999989754]},"notifyCreatedNullifier":{"times":[0.29694000000017695]},"debugLog":{"times":[0.44960399999945366]},"notifyCreatedContractClassLog":{"times":[6.616959000000861]}}},{"functionName":"private_kernel_inner","time":109.18795300000056},{"functionName":"ContractInstanceDeployer:deploy","time":87.96892700000171,"oracles":{"storeInExecutionCache":{"times":[0.17346700000052806]},"callPrivateFunction":{"times":[47.11691299999984]},"notifyCreatedNullifier":{"times":[0.264988999999332]},"debugLog":{"times":[0.4696560000011232]}}},{"functionName":"private_kernel_inner","time":102.92845099999977},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.851103999999395,"oracles":{}},{"functionName":"private_kernel_inner","time":102.27150699999947},{"functionName":"private_kernel_reset","time":171.87777499999902},{"functionName":"private_kernel_tail","time":69.43146199999865}],"unaccounted":403.0647000000008}} 09:39:48 [09:39:48.259] VERBOSE: p2p:tx_pool Adding tx 0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4 to pool {"eventName":"tx-added-to-pool","txHash":"0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 09:39:48 [09:39:48.275] INFO: node Received tx 0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4 {"txHash":"0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4"} 09:39:48 [09:39:48.276] INFO: pxe:service Sent transaction 0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4 09:39:48 [09:39:48.347] 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":1749807925,"version":1488075002},"chainTipArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","blockNumber":2,"slot":3} 09:39:48 [09:39:48.357] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-13T09:45:25.000Z","now":"2025-06-13T09:45:27.433Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:39:48 [09:39:48.390] VERBOSE: simulator:public-processor Processed tx 0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4 with no public calls in 17.07300000000032ms {"txHash":"0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4","txFee":1675254920,"revertCode":0,"gasUsed":{"totalGas":{"daGas":14848,"l2Gas":5042},"billedGas":{"daGas":14848,"l2Gas":5042},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":17.07300000000032} 09:39:48 [09:39:48.391] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032760379999999714s {"duration":0.032760379999999714,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14848,"l2Gas":5042},"totalSizeInBytes":1184} 09:39:48 [09:39:48.418] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x126caf00c1b25610972459353b82007d842a7b7bf5dc41ab2b920e357a0299ff","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807925,"version":1488075002},"txHashes":["0x058d3637e3ef6c0a73a2a9a19213a8a4513e626d784800eb0126ba39810ec2e4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":66.22869200000059,"publicProcessDuration":33.074946999999156,"rollupCircuitsDuration":61.591943999999785,"txCount":1,"blockNumber":2,"blockTimestamp":1749807925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:48 [09:39:48.420] VERBOSE: sequencer Attesting committee is empty 09:39:48 [09:39:48.585] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xff1aca546eee8227aaebcaa1b6345a75d07dd46aba1e997281060abac23d4503 09:39:48 [09:39:48.586] VERBOSE: node Sent L1 transaction 0xff1aca546eee8227aaebcaa1b6345a75d07dd46aba1e997281060abac23d4503 {"gasLimit":407282,"maxFeePerGas":"1.265176194","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:39:48 [09:39:48.596] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:48 [09:39:48.596] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xff1aca546eee8227aaebcaa1b6345a75d07dd46aba1e997281060abac23d4503","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":2,"blockTimestamp":1749807925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:48 [09:39:48.596] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:39:48 [09:39:48.599] INFO: blob-sink:server Received blob sidecar for block 0x51056d503ae0d49df1ef105d98b36eb559386230d70a3585877a9eebfc5b600a 09:39:48 [09:39:48.603] INFO: blob-sink:server Blob sidecar stored successfully for block 0x51056d503ae0d49df1ef105d98b36eb559386230d70a3585877a9eebfc5b600a 09:39:48 [09:39:48.614] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:48 [09:39:48.614] WARN: foundation:test-date-provider Time set to 2025-06-13T09:45:37.000Z {"offset":348386,"timeMs":1749807937000} 09:39:48 [09:39:48.619] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 09:39:48 [09:39:48.620] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 09:39:48 [09:39:48.688] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807961 09:39:48 [09:39:48.689] WARN: foundation:test-date-provider Time set to 2025-06-13T09:46:01.000Z {"offset":372311,"timeMs":1749807961000} 09:39:48 [09:39:48.689] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 09:39:48 [09:39:48.898] VERBOSE: archiver:block-helper Store contract instance at 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd 09:39:48 [09:39:48.899] VERBOSE: archiver:block-helper Store contract class 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5 09:39:48 [09:39:48.911] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x126caf00c1b25610972459353b82007d842a7b7bf5dc41ab2b920e357a0299ff","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807925,"version":1488075002},"archiveRoot":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","archiveNextLeafIndex":3} 09:39:48 [09:39:48.918] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 09:39:49 [09:39:49.019] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":5.831581000000369,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:49 [09:39:49.035] VERBOSE: p2p Synched to latest block 2 09:39:49 [09:39:49.114] 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":1749807961,"version":1488075002},"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:49 [09:39:49.119] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:49 [09:39:49.308] INFO: aztecjs:deploy_sent_tx Contract 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd successfully deployed. 09:39:49 [09:39:49.510] INFO: pxe:service Added contract OffchainMessage at 0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840 with class 0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5 09:39:49 [09:39:49.532] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","header":{"contentCommitment":{"blobsHash":"0x0065975e8c30092ed99e2f8dccc74e9379203bf38013f18f46dba968049b0ed7","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807925,"version":1488075002},"lastArchive":"0x2bd65d0ab481e02df38b3969ea2e2da784e7c87d186c81bd25c158c8a6a79ee7","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0c0a450ab95091afd0611507d6c0850351a591d9c2f7ca6c506736b2452b13b6","nullifierTree":"0x008bd47bbf407c8537ea6491aebc193f3f8b5c3f390ed55c520ac31bf71b66c1","publicDataTree":"0x108decf4380609ee0b9bb14936c83861b70562b70db8cf31c3d19d255ef0d741"},"totalFees":1675254920,"totalManaUsed":5042}} 09:39:49 [09:39:49.610] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:49 [09:39:49.643] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:49 [09:39:49.643] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:49 [09:39:49.695] 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":1749807961,"version":1488075002},"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:49 [09:39:49.696] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:49 [09:39:49.708] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:49 [09:39:49.713] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:49 [09:39:49.722] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:49 [09:39:49.723] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:49 [09:39:49.728] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:49 [09:39:49.728] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:49 [09:39:49.731] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:49 [09:39:49.734] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:49 [09:39:49.746] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:49 [09:39:49.791] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 09:39:49 [09:39:49.837] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:39:49 [09:39:49.847] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840,0x0000000000000000000000000000000000000000000000000000000000000001,0x11f657faf40f7f3448873ea1b67c03ed26ba1d793fd0a68d69e7fc2961170bdc,0x1c08e94427135be33826fb4eb4ed8c670719158296c30e4f491c082fd10e2af5,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 09:39:50 [09:39:50.286] 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":1749807961,"version":1488075002},"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:50 [09:39:50.395] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:50 [09:39:50.642] INFO: pxe:service Proving completed in 1118.417163000002ms {"timings":{"total":1118.417163000002,"sync":11.527215000001888,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":214.2870200000034,"oracles":{"debugLog":{"times":[0.4517980000018724,0.370812000001024,0.39343899999948917,0.5054920000002312,0.40508499999850756,0.36465400000088266,0.347658999999112,0.4411999999974796]},"fetchTaggedLogs":{"times":[67.72592299999815]},"loadCapsule":{"times":[0.18630399999892688,0.16063000000212924,0.30940600000030827,0.24207100000057835,0.18149500000072294,0.16599500000302214,0.20133699999860255]},"getSharedSecret":{"times":[2.6478680000000168]},"aes128Decrypt":{"times":[0.2130490000017744,0.8570110000000568]},"getPublicKeysAndPartialAddress":{"times":[1.2904809999999998]},"getKeyValidationRequest":{"times":[1.6137850000013714]},"storeCapsule":{"times":[0.2763989999984915,0.2315870000020368,0.1910489999972924]},"deleteCapsule":{"times":[0.29479499999797554]},"validateEnqueuedNotesAndEvents":{"times":[3.7523909999981697]},"getNotes":{"times":[1.21324900000036]},"getAuthWitness":{"times":[0.22422400000141351]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05904799999916577]},"callPrivateFunction":{"times":[106.7918920000011]}}},{"functionName":"private_kernel_init","time":51.481668000000354},{"functionName":"ContractInstanceDeployer:deploy","time":54.89654299999529,"oracles":{"storeInExecutionCache":{"times":[0.08162600000287057]},"callPrivateFunction":{"times":[47.84763600000224]},"notifyCreatedNullifier":{"times":[0.26822700000047917]},"debugLog":{"times":[0.42973799999890616]}}},{"functionName":"private_kernel_inner","time":102.01766700000007},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.56192600000213,"oracles":{}},{"functionName":"private_kernel_inner","time":102.10591000000204},{"functionName":"private_kernel_reset","time":180.02293099999952},{"functionName":"private_kernel_tail","time":69.41342499999882}],"unaccounted":299.1028579999984}} 09:39:50 [09:39:50.670] VERBOSE: p2p:tx_pool Adding tx 0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3 to pool {"eventName":"tx-added-to-pool","txHash":"0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 09:39:50 [09:39:50.674] INFO: node Received tx 0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3 {"txHash":"0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3"} 09:39:50 [09:39:50.675] INFO: pxe:service Sent transaction 0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3 09:39:50 [09:39:50.911] 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":1749807961,"version":1488075002},"chainTipArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","blockNumber":3,"slot":4} 09:39:50 [09:39:50.920] VERBOSE: block-builder Building block 3 for slot 4 {"slot":4,"slotStart":"2025-06-13T09:46:01.000Z","now":"2025-06-13T09:46:03.231Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:39:50 [09:39:50.940] VERBOSE: simulator:public-processor Processed tx 0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3 with no public calls in 12.691130999999586ms {"txHash":"0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3","txFee":1173542320,"revertCode":0,"gasUsed":{"totalGas":{"daGas":9728,"l2Gas":3532},"billedGas":{"daGas":9728,"l2Gas":3532},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":12.691130999999586} 09:39:50 [09:39:50.941] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019334940000000644s {"duration":0.019334940000000644,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":3532},"totalSizeInBytes":832} 09:39:50 [09:39:50.961] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x224f45d00918fbb7e1f2f50d839f30de4366e449283486dd22dbd3538fb6a845","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807961,"version":1488075002},"txHashes":["0x24b2358228e53cae1caef80a06976b3398207b80438bd3efb7ea90f60ea454c3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":45.53822199999922,"publicProcessDuration":19.669844000000012,"rollupCircuitsDuration":40.82803700000295,"txCount":1,"blockNumber":3,"blockTimestamp":1749807961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:50 [09:39:50.963] VERBOSE: sequencer Attesting committee is empty 09:39:51 [09:39:51.129] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf271c1de2e076824871d6018dcf5b52bba5bafa52fee71c2251d5a598431cb77 09:39:51 [09:39:51.129] VERBOSE: node Sent L1 transaction 0xf271c1de2e076824871d6018dcf5b52bba5bafa52fee71c2251d5a598431cb77 {"gasLimit":407311,"maxFeePerGas":"1.25003169","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:39:51 [09:39:51.142] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:51 [09:39:51.143] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf271c1de2e076824871d6018dcf5b52bba5bafa52fee71c2251d5a598431cb77","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":3,"blockTimestamp":1749807961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:51 [09:39:51.143] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:39:51 [09:39:51.145] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807997 09:39:51 [09:39:51.145] WARN: foundation:test-date-provider Time set to 2025-06-13T09:46:37.000Z {"offset":405855,"timeMs":1749807997000} 09:39:51 [09:39:51.145] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 09:39:51 [09:39:51.146] INFO: blob-sink:server Received blob sidecar for block 0x5c11a3d7b06983071bd49957805c603290b27543ce5b5bfb7394778ca05ec0fe 09:39:51 [09:39:51.151] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5c11a3d7b06983071bd49957805c603290b27543ce5b5bfb7394778ca05ec0fe 09:39:51 [09:39:51.360] VERBOSE: archiver:block-helper Store contract instance at 0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840 09:39:51 [09:39:51.362] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 09:39:51 [09:39:51.366] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 09:39:51 [09:39:51.366] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x224f45d00918fbb7e1f2f50d839f30de4366e449283486dd22dbd3538fb6a845","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807961,"version":1488075002},"archiveRoot":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","archiveNextLeafIndex":4} 09:39:51 [09:39:51.464] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":5.873152000000118,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749807961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:51 [09:39:51.479] VERBOSE: p2p Synched to latest block 3 09:39:51 [09:39:51.660] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:51 [09:39:51.661] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:51 [09:39:51.700] INFO: aztecjs:deploy_sent_tx Contract 0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840 successfully deployed. 09:39:51 [09:39:51.702] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit offchain message 09:39:51 [09:39:51.729] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","header":{"contentCommitment":{"blobsHash":"0x0007caf285f9cc31176aee1a91046f43abff62586662fd473ab0c55ea2ea9a10","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807961,"version":1488075002},"lastArchive":"0x297b89f9ae86c05d6854da16f7c2d74d5c29984589ebec5bdf1d6f2fc9780b41","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0c0a450ab95091afd0611507d6c0850351a591d9c2f7ca6c506736b2452b13b6","nullifierTree":"0x151153b045ca9b02ee2e8bb3748cb33a9af4f53f51a5032b31c47fdb52292bb6","publicDataTree":"0x0ab79b65cdc8dcdd672c41cd6d5becabe2f9ec94f138f7bc1b6900667fdba9b9"},"totalFees":1173542320,"totalManaUsed":3532}} 09:39:51 [09:39:51.806] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:51 [09:39:51.838] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:51 [09:39:51.839] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:51 [09:39:51.886] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 09:39:51 [09:39:51.892] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:51 [09:39:51.897] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:51 [09:39:51.906] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:51 [09:39:51.907] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:51 [09:39:51.912] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:51 [09:39:51.912] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:51 [09:39:51.915] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:51 [09:39:51.918] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:51 [09:39:51.930] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:52 [09:39:52.010] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.042] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:52 [09:39:52.043] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.085] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.090] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:52 [09:39:52.178] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840"} 09:39:52 [09:39:52.211] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:52 [09:39:52.211] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840"} 09:39:52 [09:39:52.255] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:52 [09:39:52.256] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:52 [09:39:52.260] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x00f606aa20ad1da67df3fb5e6f37c39eb9865fb6bb630369afbed2c36b74b840"} 09:39:52 [09:39:52.262] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:52 [09:39:52.352] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.385] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:52 [09:39:52.385] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.432] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:52 [09:39:52.436] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:52 [09:39:52.958] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:53 [09:39:53.064] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:53 [09:39:53.511] INFO: pxe:service Proving completed in 1786.0417730000008ms {"timings":{"total":1786.0417730000008,"sync":5.691061000001355,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":213.85190299999886,"oracles":{"debugLog":{"times":[0.4363999999986845,0.3968220000024303,0.41344199999730336,0.5029099999992468,0.4525869999997667,0.3789040000010573,0.3607750000010128,0.4492309999986901]},"fetchTaggedLogs":{"times":[56.24571199999991]},"loadCapsule":{"times":[0.2009409999991476,0.17761399999653804,0.3601649999982328,0.2496099999989383,0.18517100000099163,0.17437900000004447,0.23070499999812455]},"getSharedSecret":{"times":[2.8641610000013316]},"aes128Decrypt":{"times":[0.26054000000294764,0.8777240000017628]},"getPublicKeysAndPartialAddress":{"times":[1.3132890000015323]},"getKeyValidationRequest":{"times":[1.3054410000004282]},"storeCapsule":{"times":[0.28489499999705004,0.25484399999913876,0.3655269999981101]},"deleteCapsule":{"times":[0.20551100000011502]},"validateEnqueuedNotesAndEvents":{"times":[3.677525000002788]},"getNotes":{"times":[1.2979039999991073]},"getAuthWitness":{"times":[0.18935899999996764]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07188500000120257]},"callPrivateFunction":{"times":[541.9664499999999]}}},{"functionName":"private_kernel_init","time":51.16146800000206},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":176.82594800000516,"oracles":{"debugLog":{"times":[0.433192999997118,0.3772099999987404]},"fetchTaggedLogs":{"times":[46.264922000002116]},"loadCapsule":{"times":[0.209750999998505,0.18176000000312342,0.19891500000085216]},"validateEnqueuedNotesAndEvents":{"times":[1.0378139999993437]},"emitOffchainMessage":{"times":[0.19312600000193925]},"storeInExecutionCache":{"times":[0.11700199999904726]},"callPrivateFunction":{"times":[362.58367]}}},{"functionName":"private_kernel_inner","time":101.92440999999963},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":183.17135100000087,"oracles":{"debugLog":{"times":[0.4307149999985995,0.36730700000043726]},"fetchTaggedLogs":{"times":[50.33378199999788]},"loadCapsule":{"times":[0.20040000000153668,0.1523479999996198,0.18369499999971595]},"validateEnqueuedNotesAndEvents":{"times":[0.9885419999991427]},"emitOffchainMessage":{"times":[0.05642900000020745]},"storeInExecutionCache":{"times":[0.11011699999653501]},"callPrivateFunction":{"times":[181.65559300000314]}}},{"functionName":"private_kernel_inner","time":101.57306999999855},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":151.2621459999973,"oracles":{"debugLog":{"times":[0.4513389999992796,0.3881629999996221]},"fetchTaggedLogs":{"times":[49.50548300000082]},"loadCapsule":{"times":[0.17552399999840418,0.17105600000286358,0.20325700000103097]},"validateEnqueuedNotesAndEvents":{"times":[0.935167999999976]},"emitOffchainMessage":{"times":[0.06149500000174157]}}},{"functionName":"private_kernel_inner","time":101.71363299999939},{"functionName":"private_kernel_reset","time":177.16888100000142},{"functionName":"private_kernel_tail","time":66.48505799999839}],"unaccounted":455.21284399999786}} 09:39:53 [09:39:53.515] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should not emit any offchain messages 09:39:53 [09:39:53.613] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:53 [09:39:53.645] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:53 [09:39:53.646] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:53 [09:39:53.690] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:53 [09:39:53.692] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:53 [09:39:53.702] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:53 [09:39:53.706] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:53 [09:39:53.715] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:53 [09:39:53.716] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:53 [09:39:53.721] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:53 [09:39:53.721] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:53 [09:39:53.726] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:53 [09:39:53.729] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:53 [09:39:53.744] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:53 [09:39:53.880] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:53 [09:39:53.935] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:53 [09:39:53.935] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:53 [09:39:53.982] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:53 [09:39:53.984] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:54 [09:39:54.361] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:54 [09:39:54.603] INFO: pxe:service Proving completed in 1073.287952999999ms {"timings":{"total":1073.287952999999,"sync":11.110539000001154,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":246.42460500000016,"oracles":{"debugLog":{"times":[0.44095499999821186,0.38705600000321283,0.42583899999954156,0.5331169999990379,0.3874360000008892,0.3523029999996652,0.36298799999713083,0.4223679999995511]},"fetchTaggedLogs":{"times":[58.845155000002705]},"loadCapsule":{"times":[0.1714460000002873,0.16801000000123167,0.33956100000068545,0.2121609999994689,0.17064600000230712,0.24952000000121188,0.2093220000024303]},"getSharedSecret":{"times":[2.5497270000014396]},"aes128Decrypt":{"times":[0.22564499999862164,0.8645849999993516]},"getPublicKeysAndPartialAddress":{"times":[1.2178290000010747]},"getKeyValidationRequest":{"times":[1.372564000001148]},"storeCapsule":{"times":[0.303725999998278,0.2226970000010624,2.267051000002539]},"deleteCapsule":{"times":[0.19654799999989336]},"validateEnqueuedNotesAndEvents":{"times":[3.829586999996536]},"getNotes":{"times":[4.119072999998025]},"getAuthWitness":{"times":[0.21281599999929313]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06419800000003306]},"callPrivateFunction":{"times":[255.81900300000052]}}},{"functionName":"private_kernel_init","time":56.428281000000425},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":198.29570700000113,"oracles":{"debugLog":{"times":[0.41993599999841535,0.3506969999980356]},"fetchTaggedLogs":{"times":[47.978283000000374]},"loadCapsule":{"times":[0.1674459999994724,0.1669000000001688,0.2200589999993099]},"validateEnqueuedNotesAndEvents":{"times":[1.1714939999983471]}}},{"functionName":"private_kernel_inner","time":101.767573000001},{"functionName":"private_kernel_reset","time":175.36538599999767},{"functionName":"private_kernel_tail","time":68.97308500000145}],"unaccounted":214.92277699999613}} 09:39:54 [09:39:54.604] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should revert when emitting offchain message from utility function 09:39:54 [09:39:54.613] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:54 [09:39:54.699] VERBOSE: simulator Executing utility function emitting_offchain_message_from_utility_reverts {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","selector":"0xaa12a861"} 09:39:54 [09:39:54.707] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 09:39:54 [09:39:54.707] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:54 [09:39:54.740] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:54 [09:39:54.743] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:54 [09:39:54.751] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit event as offchain message and process it 09:39:54 [09:39:54.836] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:54 [09:39:54.868] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:54 [09:39:54.869] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:54 [09:39:54.912] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:54 [09:39:54.915] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:54 [09:39:54.925] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:54 [09:39:54.925] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:54 [09:39:54.930] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:54 [09:39:54.930] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:54 [09:39:54.933] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:54 [09:39:54.936] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:54 [09:39:54.947] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:55 [09:39:55.028] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_event_as_offchain_message_for_msg_sender {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:55 [09:39:55.044] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:55 [09:39:55.045] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:55 [09:39:55.081] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:55 [09:39:55.089] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:55 [09:39:55.209] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:55 [09:39:55.293] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:55 [09:39:55.702] INFO: pxe:service Proving completed in 944.6761890000016ms {"timings":{"total":944.6761890000016,"sync":2.7895430000025954,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":200.8034160000061,"oracles":{"debugLog":{"times":[0.4429920000002312,0.3817029999991064,0.3929920000009588,0.4659690000007686,0.3985350000002654,0.34649800000261166,0.3250850000003993,0.44176400000287686]},"fetchTaggedLogs":{"times":[45.203786999998556]},"loadCapsule":{"times":[0.15223300000070594,0.14275300000008428,0.32623899999816786,0.2034910000002128,0.13880000000062864,0.16719199999715784,0.17559800000162795]},"getSharedSecret":{"times":[2.38122999999905]},"aes128Decrypt":{"times":[0.39029800000207615,0.9923230000022158]},"getPublicKeysAndPartialAddress":{"times":[1.155280999999377]},"getKeyValidationRequest":{"times":[1.2162280000011378]},"storeCapsule":{"times":[0.2633720000012545,0.19154100000014296,0.21761200000037206]},"deleteCapsule":{"times":[0.19202499999664724]},"validateEnqueuedNotesAndEvents":{"times":[3.660117999999784]},"getNotes":{"times":[1.031874999996944]},"getAuthWitness":{"times":[0.19705199999953038]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05268000000069151]},"callPrivateFunction":{"times":[151.6295510000018]}}},{"functionName":"private_kernel_init","time":51.18329900000026},{"functionName":"OffchainMessage:emit_event_as_offchain_message_for_msg_sender","time":122.72034199999689,"oracles":{"debugLog":{"times":[0.432980999998108,0.37050299999827985]},"fetchTaggedLogs":{"times":[43.84770999999819]},"loadCapsule":{"times":[0.1972589999968477,0.15674200000285055,0.1922149999991234]},"validateEnqueuedNotesAndEvents":{"times":[1.036779000001843]},"getRandomField":{"times":[0.09350600000107079,0.08653600000252482,0.07653099999879487,0.058894000001600944,0.03707300000314717,0.03765700000076322,0.030177000000549015,0.04173399999854155,0.03138399999807007,0.03500799999892479,0.02751899999930174,0.036319999999250285]},"notifyCreatedNullifier":{"times":[0.23797399999966729]},"emitOffchainMessage":{"times":[0.0666670000027807]}}},{"functionName":"private_kernel_inner","time":101.89333400000032},{"functionName":"private_kernel_reset","time":173.81308700000227},{"functionName":"private_kernel_tail","time":66.42793399999937}],"unaccounted":225.0452339999938}} 09:39:55 [09:39:55.736] VERBOSE: p2p:tx_pool Adding tx 0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d to pool {"eventName":"tx-added-to-pool","txHash":"0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 09:39:55 [09:39:55.739] INFO: node Received tx 0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d {"txHash":"0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d"} 09:39:55 [09:39:55.740] INFO: pxe:service Sent transaction 0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d 09:39:55 [09:39:55.809] 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":1749807997,"version":1488075002},"chainTipArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","blockNumber":4,"slot":5} 09:39:55 [09:39:55.819] VERBOSE: block-builder Building block 4 for slot 5 {"slot":5,"slotStart":"2025-06-13T09:46:37.000Z","now":"2025-06-13T09:46:41.674Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:39:55 [09:39:55.838] VERBOSE: simulator:public-processor Processed tx 0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d with no public calls in 12.155785999999352ms {"txHash":"0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d","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":12.155785999999352} 09:39:55 [09:39:55.840] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01885981399999946s {"duration":0.01885981399999946,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3532},"totalSizeInBytes":288} 09:39:55 [09:39:55.859] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x01bbf15ecf35f18edff621ad86372a73a0bed5f6919aa3020b7414f86c72f42d","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807997,"version":1488075002},"txHashes":["0x0c346c46138b643dfb1ea0a1226214783c84e8bc15ee9dc10c835f5947284c8d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":45.56053800000154,"publicProcessDuration":19.260051000001113,"rollupCircuitsDuration":40.88032899999962,"txCount":1,"blockNumber":4,"blockTimestamp":1749807997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:55 [09:39:55.861] VERBOSE: sequencer Attesting committee is empty 09:39:56 [09:39:56.011] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x3e473b65920fae89c59755ab85673ad86c17f0fd4ede8299065004889dd940db 09:39:56 [09:39:56.011] VERBOSE: node Sent L1 transaction 0x3e473b65920fae89c59755ab85673ad86c17f0fd4ede8299065004889dd940db {"gasLimit":407323,"maxFeePerGas":"1.23840621","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:39:56 [09:39:56.024] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:56 [09:39:56.024] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x3e473b65920fae89c59755ab85673ad86c17f0fd4ede8299065004889dd940db","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":4,"blockTimestamp":1749807997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:56 [09:39:56.024] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:39:56 [09:39:56.027] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808033 09:39:56 [09:39:56.027] WARN: foundation:test-date-provider Time set to 2025-06-13T09:47:13.000Z {"offset":436973,"timeMs":1749808033000} 09:39:56 [09:39:56.027] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 09:39:56 [09:39:56.030] INFO: blob-sink:server Received blob sidecar for block 0xa3f819950a212bc991292234ae36ee69388eb357f051cb218f92b506b6c7f4b6 09:39:56 [09:39:56.032] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa3f819950a212bc991292234ae36ee69388eb357f051cb218f92b506b6c7f4b6 09:39:56 [09:39:56.211] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 09:39:56 [09:39:56.213] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 09:39:56 [09:39:56.366] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x01bbf15ecf35f18edff621ad86372a73a0bed5f6919aa3020b7414f86c72f42d","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807997,"version":1488075002},"archiveRoot":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","archiveNextLeafIndex":5} 09:39:56 [09:39:56.368] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 09:39:56 [09:39:56.431] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":5.82448800000202,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749807997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:56 [09:39:56.471] VERBOSE: p2p Synched to latest block 4 09:39:56 [09:39:56.540] 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":1749808033,"version":1488075002},"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:56 [09:39:56.541] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:56 [09:39:56.746] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","header":{"contentCommitment":{"blobsHash":"0x005aed4af1906471918cbcc1c8f9b260d2d3c6d32d0dcaf3c62bfa5f92812af2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807997,"version":1488075002},"lastArchive":"0x057247ee28613d5cc257975718f101ad72f2322a1588fb11c1cd168a898d9e1f","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0c0a450ab95091afd0611507d6c0850351a591d9c2f7ca6c506736b2452b13b6","nullifierTree":"0x0edfa6fd8198cbd62a60b03cb7a475a883f569379bd268680310a8316be6a49d","publicDataTree":"0x274c8f2bb9c1a4adc9354fc04e59e7be24dd969ae19563fc7109d1db978ab632"},"totalFees":113659760,"totalManaUsed":3532}} 09:39:56 [09:39:56.825] VERBOSE: simulator Executing utility function process_message {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","selector":"0x988dd306"} 09:39:56 [09:39:56.836] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 09:39:56 [09:39:56.836] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:56 [09:39:56.874] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:56 [09:39:56.879] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:56 [09:39:56.891] VERBOSE: simulator:client_view_context:debug_log Processing private event msg 09:39:56 [09:39:56.893] VERBOSE: simulator Utility simulation for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd.0x988dd306 completed 09:39:56 [09:39:56.894] VERBOSE: pxe:service Getting private events for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd from 4 to 5 09:39:56 [09:39:56.971] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","selector":"0xc6cedc33"} 09:39:56 [09:39:56.981] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 09:39:56 [09:39:56.981] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:57 [09:39:57.011] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:57 [09:39:57.014] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:57 [09:39:57.016] VERBOSE: private_event_data_provider storing private event log {"contractAddress":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","recipient":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","msgContent":["0x0000000000000000000000000000000000000000000000000000000000000001","0x0000000000000000000000000000000000000000000000000000000000000002","0x0000000000000000000000000000000000000000000000000000000000000003"],"blockNumber":4} 09:39:57 [09:39:57.018] VERBOSE: simulator Utility simulation for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd.0xc6cedc33 completed 09:39:57 [09:39:57.020] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit note as offchain message and process it 09:39:57 [09:39:57.110] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:57 [09:39:57.143] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:57 [09:39:57.143] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:57 [09:39:57.182] 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":1749808033,"version":1488075002},"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:57 [09:39:57.184] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:57 [09:39:57.192] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46"} 09:39:57 [09:39:57.195] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c688aafe49511c4cc04f2972f8e1e9fa29c399e932661f48aa34704f1edaf3a 09:39:57 [09:39:57.204] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:39:57 [09:39:57.205] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:39:57 [09:39:57.210] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:39:57 [09:39:57.210] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:39:57 [09:39:57.212] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:57 [09:39:57.215] VERBOSE: pxe:service Added note {"index":0,"contract":"0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1aa578919ce463f5c421dc3311bcd981dbbe06e8a38699f8bc07d58c5a83d3b8","nullifier":"0x2834a8e04f37568ffda1592828c3774a10a37f5fd12e2493e22ec40ae1e3c700"} 09:39:57 [09:39:57.226] VERBOSE: simulator:client_execution_context:debug_log Setting 0x240507191c6b68d97c6921e801c47b3d3f846d0e92bad26293920b2307a96f46 as fee payer 09:39:57 [09:39:57.303] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_note_as_offchain_message {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:57 [09:39:57.319] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:39:57 [09:39:57.320] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:57 [09:39:57.354] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:39:57 [09:39:57.356] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:39:58 [09:39:58.025] INFO: pxe:service Proving completed in 993.6188559999973ms {"timings":{"total":993.6188559999973,"sync":2.463558000003104,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":202.3341529999998,"oracles":{"debugLog":{"times":[0.45345799999995506,0.3706529999981285,0.39734499999758555,0.47206699999878765,0.3711519999997108,0.3103099999971164,0.2918599999975413,0.41285599999901024]},"fetchTaggedLogs":{"times":[50.99059900000066]},"loadCapsule":{"times":[0.16154000000096858,0.13852199999746517,0.32311699999991106,0.17920600000070408,0.15495699999883072,0.144614000000729,0.19131699999707052]},"getSharedSecret":{"times":[2.465007999999216]},"aes128Decrypt":{"times":[0.19048999999722582,0.8496180000001914]},"getPublicKeysAndPartialAddress":{"times":[1.1660139999985404]},"getKeyValidationRequest":{"times":[1.1328619999985676]},"storeCapsule":{"times":[0.26488199999948847,0.18727700000090408,0.2036130000014964]},"deleteCapsule":{"times":[0.20093599999745493]},"validateEnqueuedNotesAndEvents":{"times":[3.1669289999990724]},"getNotes":{"times":[0.9357010000021546]},"getAuthWitness":{"times":[0.20842500000071595]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07352699999682955]},"callPrivateFunction":{"times":[212.3687940000018]}}},{"functionName":"private_kernel_init","time":57.3178590000025},{"functionName":"OffchainMessage:emit_note_as_offchain_message","time":184.81624899999952,"oracles":{"debugLog":{"times":[0.4053719999974419,0.3629220000002533]},"fetchTaggedLogs":{"times":[35.833090000000084]},"loadCapsule":{"times":[0.17835099999865633,0.13880799999969895,0.18318899999940186]},"validateEnqueuedNotesAndEvents":{"times":[0.9992820000006759]},"getRandomField":{"times":[0.09709799999836832,0.08921300000292831,0.067841000000044,0.054703000001609325,0.03711200000179815,0.03143600000112201,0.03276899999764282,0.030333999999129446,0.02878899999996065,0.045040000000881264,0.0409429999999702,0.030256000001827488]},"notifyCreatedNote":{"times":[0.12493499999982305]},"getIndexedTaggingSecretAsSender":{"times":[42.27053100000194]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.222193999998126]},"emitOffchainMessage":{"times":[0.07849200000055134]}}},{"functionName":"private_kernel_inner","time":101.5576379999984},{"functionName":"private_kernel_reset","time":176.8492100000003},{"functionName":"private_kernel_tail","time":68.60262000000148}],"unaccounted":199.67756899999222}} 09:39:58 [09:39:58.068] 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":1749808033,"version":1488075002},"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:58 [09:39:58.068] VERBOSE: p2p:tx_pool Adding tx 0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31 to pool {"eventName":"tx-added-to-pool","txHash":"0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31","noteHashCount":1,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 09:39:58 [09:39:58.073] INFO: node Received tx 0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31 {"txHash":"0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31"} 09:39:58 [09:39:58.073] INFO: pxe:service Sent transaction 0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31 09:39:58 [09:39:58.074] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:58 [09:39:58.591] 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":1749808033,"version":1488075002},"chainTipArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","blockNumber":5,"slot":6} 09:39:58 [09:39:58.602] VERBOSE: block-builder Building block 5 for slot 6 {"slot":6,"slotStart":"2025-06-13T09:47:13.000Z","now":"2025-06-13T09:47:15.575Z","blockNumber":5,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:39:58 [09:39:58.621] VERBOSE: simulator:public-processor Processed tx 0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31 with no public calls in 12.13384600000063ms {"txHash":"0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31","txFee":106322720,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":3304},"billedGas":{"daGas":1536,"l2Gas":3304},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":12.13384600000063} 09:39:58 [09:39:58.621] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.018335195999999995s {"duration":0.018335195999999995,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3304},"totalSizeInBytes":320} 09:39:58 [09:39:58.639] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2f1446a5bbb5e5a047859e4d56acaa33acd5afa05f8404f0493831248618822f","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749808033,"version":1488075002},"txHashes":["0x19437f588f809b3db8d2675492621435cbf3c057e5bcb9c1543740dbe08a3d31"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":42.77598499999658,"publicProcessDuration":19.000577999999223,"rollupCircuitsDuration":38.14355699999942,"txCount":1,"blockNumber":5,"blockTimestamp":1749808033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:58 [09:39:58.641] VERBOSE: sequencer Attesting committee is empty 09:39:58 [09:39:58.796] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x3d0a91eb969fdd1babeb861068eee0d6971059e12979acf098ddc491873082b7 09:39:58 [09:39:58.797] VERBOSE: node Sent L1 transaction 0x3d0a91eb969fdd1babeb861068eee0d6971059e12979acf098ddc491873082b7 {"gasLimit":407308,"maxFeePerGas":"1.229482058","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:39:58 [09:39:58.806] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:58 [09:39:58.807] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x3d0a91eb969fdd1babeb861068eee0d6971059e12979acf098ddc491873082b7","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":5,"blockTimestamp":1749808033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:58 [09:39:58.807] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:39:58 [09:39:58.809] INFO: blob-sink:server Received blob sidecar for block 0x408f082b04ebfc7dc3a54c0c6879fd534100dd739e5a43c48686c18c037a4419 09:39:58 [09:39:58.813] INFO: blob-sink:server Blob sidecar stored successfully for block 0x408f082b04ebfc7dc3a54c0c6879fd534100dd739e5a43c48686c18c037a4419 09:39:58 [09:39:58.859] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:58 [09:39:58.860] WARN: foundation:test-date-provider Time set to 2025-06-13T09:47:25.000Z {"offset":446140,"timeMs":1749808045000} 09:39:58 [09:39:58.864] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 09:39:58 [09:39:58.865] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 09:39:58 [09:39:58.905] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808069 09:39:58 [09:39:58.905] WARN: foundation:test-date-provider Time set to 2025-06-13T09:47:49.000Z {"offset":470095,"timeMs":1749808069000} 09:39:58 [09:39:58.905] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 09:39:59 [09:39:59.155] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2f1446a5bbb5e5a047859e4d56acaa33acd5afa05f8404f0493831248618822f","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749808033,"version":1488075002},"archiveRoot":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","archiveNextLeafIndex":6} 09:39:59 [09:39:59.156] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 09:39:59 [09:39:59.209] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":5.762823000000935,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749808033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:59 [09:39:59.221] VERBOSE: p2p Synched to latest block 5 09:39:59 [09:39:59.326] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:39:59 [09:39:59.328] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:39:59 [09:39:59.838] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:39:59 [09:39:59.839] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:00 [09:40:00.084] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","header":{"contentCommitment":{"blobsHash":"0x00ba0e845b82b450f222ad0ad9acb0ef52db26f90ae48dc6328a85d4214eace5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749808033,"version":1488075002},"lastArchive":"0x054bb7fec1cc4f72c7e8e5b9eea8207cca5cf642e0401ffc09e8e2adfdccd5f5","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x13c14a3391ea61b2cee77aefbd7b60c3c0e0c580b10f82ad9eff73037a1cf6ea","nullifierTree":"0x14369c336a6b2bc63f3fd883dbf18dd2f78977cfef1f13241b7cfa42c51b9dcb","publicDataTree":"0x0af0a22ac512af1b452b69291f7cb9fb3f8635c180934438f5da791a7ced7d13"},"totalFees":106322720,"totalManaUsed":3304}} 09:40:00 [09:40:00.163] VERBOSE: simulator Executing utility function process_message {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","selector":"0x988dd306"} 09:40:00 [09:40:00.174] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 09:40:00 [09:40:00.174] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:40:00 [09:40:00.215] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:40:00 [09:40:00.217] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:40:00 [09:40:00.228] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 09:40:00 [09:40:00.228] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd for storage slot 0x0b67c68e8b3aa1a014729e3db23095530d39cb30d255f072bbac20b44b9c0f3d 09:40:00 [09:40:00.233] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:40:00 [09:40:00.234] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:40:00 [09:40:00.235] VERBOSE: simulator Utility simulation for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd.0x988dd306 completed 09:40:00 [09:40:00.318] VERBOSE: simulator Executing utility function get_note_value {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","selector":"0x5e6122e2"} 09:40:00 [09:40:00.328] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 09:40:00 [09:40:00.328] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:40:00 [09:40:00.368] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:00 [09:40:00.372] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd"} 09:40:00 [09:40:00.372] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:00 [09:40:00.375] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:40:00 [09:40:00.378] VERBOSE: pxe:service Added note {"index":256,"contract":"0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd","slot":"0x0b67c68e8b3aa1a014729e3db23095530d39cb30d255f072bbac20b44b9c0f3d","noteHash":"0x225e326e40d6610cf14d67db8e3d22ba714aaf00706aaa448248136eaf17e756","nullifier":"0x1696060825fe0a86b2e93d5a9b6b23b3490a1b281ca15a06d5d4d339b337b9d2"} 09:40:00 [09:40:00.381] VERBOSE: simulator Utility simulation for 0x1b4ebde1c123da4da6d4d3d1c523b238af68f806d83174a3e672120949e708cd.0x5e6122e2 completed 09:40:00 [09:40:00.383] INFO: node Stopping Aztec Node 09:40:00 [09:40:00.883] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:00 [09:40:00.883] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:01 [09:40:01.394] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:01 [09:40:01.395] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:01 [09:40:01.906] VERBOSE: sequencer Preparing proposal for block 6 at slot 7 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808069,"version":1488075002},"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:01 [09:40:01.907] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x219b78cfc36b3a036eb73d47b5f4f87e332c7800922a007b52f7f5a9bc22685c","blockNumber":6,"slot":7} 09:40:02 [09:40:02.385] INFO: slasher Slasher client stopped. 09:40:02 [09:40:02.385] INFO: sequencer Stopped sequencer 09:40:02 [09:40:02.386] INFO: p2p P2P client stopped 09:40:02 [09:40:02.387] INFO: world_state Stopped world state synchronizer 09:40:02 [09:40:02.387] INFO: archiver Stopped. 09:40:02 [09:40:02.387] INFO: node Stopped Aztec Node 09:40:02 [09:40:02.395] INFO: blob-sink:server Stopping blob sink 09:40:02 [09:40:02.396] INFO: blob-sink:server Blob sink stopped 09:40:02 PASS src/e2e_offchain_message.test.ts 09:40:02 e2e_offchain_message 09:40:02 ✓ should emit offchain message (1813 ms) 09:40:02 ✓ should not emit any offchain messages (1090 ms) 09:40:02 ✓ should revert when emitting offchain message from utility function (146 ms) 09:40:02 ✓ should emit event as offchain message and process it (2268 ms) 09:40:02 ✓ should emit note as offchain message and process it (3361 ms) 09:40:02 09:40:02 Test Suites: 1 passed, 1 total 09:40:02 Tests: 5 passed, 5 total 09:40:02 Snapshots: 0 total 09:40:02 Time: 28.976 s 09:40:02 Ran all test suites matching /src\/e2e_offchain_message.test.ts/i. 09:40:02 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?