Parent Log: http://ci.aztec-labs.com/5f5605ea89201c3c Command: 2cb8f772663bb840: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/af8041048ee98abe05402607256df4b4cac51dd8 Env: REF_NAME=gh-readonly-queue/next/pr-15067-a0a8617413ca6f4fba2ad190ce73dab59bd75a45 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Tue Jun 17 15:07:36 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15067_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_9323dbf3b3f7fe91_next 15:07:36 +++ id -u 15:07:36 +++ id -g 15:07:36 ++ 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'\''' 15:07:37 + cid=43b29272177339dd747f46165b4a3280756e9ae3b7436a8ac2b2ca0bce65604f 15:07:37 + set +x 15:07:37 {"level":25,"time":1750172857809,"pid":13,"hostname":"43b292721773","module":"logger","msg":"Logger initialized with level verbose"} 15:07:42 [15:07:42.137] INFO: e2e:e2e_offchain_message Logging metrics to log/unknown.jsonl 15:07:42 [15:07:42.497] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Fcb5Nx/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:07:42 [15:07:42.570] INFO: e2e:e2e_offchain_message Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 15:07:42 [15:07:42.581] INFO: e2e:e2e_offchain_message Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 15:07:42 [15:07:42.589] INFO: e2e:e2e_offchain_message Deployed Multicall3 15:07:42 [15:07:42.591] INFO: e2e:e2e_offchain_message Calling anvil_setBlockTimestampInterval with params: [12] 15:07:42 [15:07:42.592] WARN: e2e:e2e_offchain_message Set block interval to 12 15:07:42 [15:07:42.593] VERBOSE: e2e:e2e_offchain_message Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:07:42 [15:07:42.618] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x9442c96dbfb1b64a27527fd1a4f8eb19d84a1a68b868640b29ed6b2c81dc2f50 {"gasLimit":854274,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"} 15:07:42 [15:07:42.624] VERBOSE: e2e:e2e_offchain_message Deployed Fee Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:07:42 [15:07:42.639] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x529d27ea68ffcafebe07526577b61092e24b59c533cc9143f998e4fc6dcfb14b {"gasLimit":854259,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"} 15:07:42 [15:07:42.643] VERBOSE: e2e:e2e_offchain_message Deployed Staking Asset at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:07:42 [15:07:42.662] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x95b7699fe33f0d871f0ae253cf7877a0a99483589cd7195124d29ecd32486788 {"gasLimit":3073296,"maxFeePerGas":"172.377258836","maxPriorityFeePerGas":"171.2876976"} 15:07:42 [15:07:42.667] VERBOSE: e2e:e2e_offchain_message Deployed GSE at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:07:42 [15:07:42.681] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xd840470e4520b29f6e66aea9617699fd1a8abdf80bda295d106b2c781e7551c1 {"gasLimit":1014434,"maxFeePerGas":"206.505066871","maxPriorityFeePerGas":"205.54523712"} 15:07:42 [15:07:42.685] VERBOSE: e2e:e2e_offchain_message Deployed Registry at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:07:42 [15:07:42.700] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x563bb16d401b06a11b51da2b9ee7cfe951b8fa630d4c267296dbb34e90c4a7d7 {"gasLimit":1966612,"maxFeePerGas":"247.514620583","maxPriorityFeePerGas":"246.654284544"} 15:07:42 [15:07:42.704] VERBOSE: e2e:e2e_offchain_message Deployed GovernanceProposer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:07:42 [15:07:42.720] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x9809e7430227c00a4d9dd16542138371f0fc8cc9a202cab272bfad42c53af0c8 {"gasLimit":3042394,"maxFeePerGas":"296.743996283","maxPriorityFeePerGas":"295.985141452"} 15:07:42 [15:07:42.724] VERBOSE: e2e:e2e_offchain_message Deployed Governance at 0x0165878a594ca255338adfa4d48449f69242eb8f 15:07:42 [15:07:42.735] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x5660c9700c6cc3fc5ef11719756efe90435549e646aaddc6afa5c32149db4bcb {"gasLimit":100000,"maxFeePerGas":"355.856531426","maxPriorityFeePerGas":"355.182169742"} 15:07:42 [15:07:42.735] VERBOSE: e2e:e2e_offchain_message Set governance on GSE in 0x5660c9700c6cc3fc5ef11719756efe90435549e646aaddc6afa5c32149db4bcb 15:07:42 [15:07:42.750] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xd70b3c233e6bef808e173966891167ea628718fc550577fac9e1792ed01647aa {"gasLimit":391719,"maxFeePerGas":"426.822917902","maxPriorityFeePerGas":"426.21860369"} 15:07:42 [15:07:42.755] VERBOSE: e2e:e2e_offchain_message Deployed CoinIssuer at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:07:42 [15:07:42.755] VERBOSE: e2e:e2e_offchain_message Waiting for deployments to complete 15:07:42 [15:07:42.755] INFO: e2e:e2e_offchain_message Waiting for 7 transactions to be mined... 15:07:42 [15:07:42.775] INFO: e2e:e2e_offchain_message All transactions mined successfully 15:07:42 [15:07:42.783] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0 {"gasLimit":100000,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.783] VERBOSE: e2e:e2e_offchain_message Added coin issuer 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0 15:07:42 [15:07:42.795] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x13a19479c80c53e28262b8a87b03014d06d51032c11114e38ce7c6906bd5125c {"gasLimit":56661,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.806] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xd431ef3723b2de7ec35591cb862dbc668fe288da15c79822d5658456bc23cde8 {"gasLimit":339705,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.811] VERBOSE: e2e:e2e_offchain_message Deployed FeeAssetHandler at 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e 15:07:42 [15:07:42.822] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8 {"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.822] VERBOSE: e2e:e2e_offchain_message Added fee asset handler 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e as minter on fee asset in 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8 15:07:42 [15:07:42.840] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x4f8916fe0f2144fcf9390f656996f742df326d423a5a65cadfd9204798dff1cf {"gasLimit":2474272,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.845] VERBOSE: e2e:e2e_offchain_message Deployed StakingAssetHandler at 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82 15:07:42 [15:07:42.856] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2 {"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.857] VERBOSE: e2e:e2e_offchain_message Added staking asset handler 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82 as minter on staking asset in 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2 15:07:42 [15:07:42.857] VERBOSE: e2e:e2e_offchain_message Waiting for deployments to complete 15:07:42 [15:07:42.857] INFO: e2e:e2e_offchain_message Waiting for 9 transactions to be mined... 15:07:42 [15:07:42.876] INFO: e2e:e2e_offchain_message All transactions mined successfully 15:07:42 [15:07:42.887] VERBOSE: e2e:e2e_offchain_message Deployed shared contracts 15:07:42 [15:07:42.902] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3 {"gasLimit":84837,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.903] VERBOSE: e2e:e2e_offchain_message Funded reward distributor with 10000000000000000000000000 fee asset in 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3 15:07:42 [15:07:42.915] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xe864f8598420a3f08ad58dfc390d1839179932035cc0f8f39946ee51d7291728 {"gasLimit":152965,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.919] VERBOSE: e2e:e2e_offchain_message Rollup will use the mock verifier at 0x959922be3caee4b8cd9a407cc3ac1c251c2007b1 15:07:42 [15:07:42.920] VERBOSE: e2e:e2e_offchain_message Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:07:42 [15:07:42.933] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xe39dc163ad8bc96e03f2f8f6425216e95b43094810675c3e16976eab0db0be9f {"gasLimit":86397,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.955] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x43c691672366ebb2778496250adcd370840b546110e29a7c757288a7e4a91912 {"gasLimit":5019565,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.975] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x0ba4928285b2b12d9ce76fcc5ee08c7adc56d68c44e5ad17f2bbbbd348f0661c {"gasLimit":2813307,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:42 [15:07:42.979] VERBOSE: e2e:e2e_offchain_message Awaiting for linked libraries to be deployed 15:07:43 [15:07:43.018] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xed4a3f7ef41f05a8938868ff1a6e39e81f348ee0de84b43670280c08ce9b9e92 {"gasLimit":10876612,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:43 [15:07:43.024] VERBOSE: e2e:e2e_offchain_message Deployed Rollup at 0xc6e7df5e7b4f2a278906862b61205850344d4e7d {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:07:43 [15:07:43.024] INFO: e2e:e2e_offchain_message Waiting for 11 transactions to be mined... 15:07:43 [15:07:43.048] INFO: e2e:e2e_offchain_message All transactions mined successfully 15:07:43 [15:07:43.048] VERBOSE: e2e:e2e_offchain_message All core contracts have been deployed 15:07:43 [15:07:43.061] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x2c1dbe3447d26039dc9ec8a117f5ecf3418514eba04363a9f118599e3ac046b6 {"gasLimit":64317,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:43 [15:07:43.061] VERBOSE: e2e:e2e_offchain_message Funding fee juice portal with 10000000000000000000000 fee juice in 0x2c1dbe3447d26039dc9ec8a117f5ecf3418514eba04363a9f118599e3ac046b6 (accelerated test deployments) 15:07:43 [15:07:43.073] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x2906ecab60d32dc8d141ff035e30e8b3110ab6886e2d25ad4bf4ad27f4aba8ce {"gasLimit":1040116,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:43 [15:07:43.077] VERBOSE: e2e:e2e_offchain_message Deployed SlashFactory at 0x4ed7c70f96b99c776995fb64377f0d4ab3b0e1c1 15:07:43 [15:07:43.098] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0x88e756e24bbff758970408d0c377a6de3892502a3df5acd0bdeaa0f8200f71bf {"gasLimit":116979,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:43 [15:07:43.098] VERBOSE: e2e:e2e_offchain_message Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to registry 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 in tx 0x88e756e24bbff758970408d0c377a6de3892502a3df5acd0bdeaa0f8200f71bf 15:07:43 [15:07:43.114] VERBOSE: e2e:e2e_offchain_message Sent L1 transaction 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89 {"gasLimit":109478,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 15:07:43 [15:07:43.115] VERBOSE: e2e:e2e_offchain_message Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to GSE 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89 15:07:43 [15:07:43.119] INFO: e2e:e2e_offchain_message Waiting for 12 transactions to be mined... 15:07:43 [15:07:43.142] INFO: e2e:e2e_offchain_message All transactions mined successfully 15:07:43 [15:07:43.148] VERBOSE: e2e:e2e_offchain_message Rollup deployed 15:07:43 [15:07:43.148] VERBOSE: e2e:e2e_offchain_message Waiting for rollup and slash factory to be deployed 15:07:43 [15:07:43.149] INFO: e2e:e2e_offchain_message Waiting for 12 transactions to be mined... 15:07:43 [15:07:43.170] INFO: e2e:e2e_offchain_message All transactions mined successfully 15:07:43 [15:07:43.171] VERBOSE: e2e:e2e_offchain_message All transactions for L1 deployment have been mined 15:07:43 [15:07:43.189] INFO: e2e:e2e_offchain_message Aztec L1 contracts initialized {"registryAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x0165878a594ca255338adfa4d48449f69242eb8f","governanceProposerAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","rollupAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","inboxAddress":"0x624dc0ecefd94640d316ee3acfd147ed9b764638","outboxAddress":"0x94cd1b4dea480e09a1e0d83f6c92b9a5c6136171","feeJuicePortalAddress":"0x42d729740c681c1626a3b909081ad726b3975b49","feeJuiceAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","stakingAssetAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","rewardDistributorAddress":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","gseAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 15:07:43 [15:07:43.190] INFO: e2e:e2e_offchain_message Handing over to governance 15:07:43 [15:07:43.195] WARN: foundation:test-date-provider Time set to 2025-06-17T15:12:30.000Z {"offset":286805,"timeMs":1750173150000} 15:07:43 [15:07:43.200] INFO: aztecjs:utils:watcher Watcher started for rollup at 0xc6e7DF5E7b4f2A278906862b61205850344D4e7d 15:07:43 [15:07:43.201] INFO: telemetry:client Using NoopTelemetryClient 15:07:43 [15:07:43.207] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/854937d9eeb559c0/blob-sink with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.211] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:07:43 [15:07:43.216] INFO: blob-sink:server Server is running on http://localhost:42581 15:07:43 [15:07:43.216] VERBOSE: e2e:e2e_offchain_message Creating and synching an aztec node... 15:07:43 [15:07:43.217] VERBOSE: e2e:e2e_offchain_message Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/1baf3648/acvm 15:07:43 [15:07:43.218] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42581"} 15:07:43 [15:07:43.235] VERBOSE: node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided. 15:07:43 [15:07:43.235] INFO: archiver:lmdb Creating archiver data store at directory /tmp/854937d9eeb559c0/archiver with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.236] INFO: archiver:lmdb Starting data store with maxReaders 16 15:07:43 [15:07:43.533] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42581"} 15:07:43 [15:07:43.548] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42581"} 15:07:43 [15:07:43.548] WARN: node:blob-sink:client No L1 consensus host urls configured 15:07:43 [15:07:43.548] WARN: node:blob-sink:client No archive client configured 15:07:43 [15:07:43.550] INFO: archiver Starting archiver sync to rollup contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d from L1 block 22 to current L1 block 26 with hash 0x210366efdbbfb26e7c292c8e39100e900b4e2659b1acb08e032a2d7ebf3cfe6a {"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x1c088e533c08dc2d546b91369ec684d6da98b82c4ea22f4ce7c2b970a5a4b682","l1BlockNumber":22}} 15:07:43 [15:07:43.563] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0x210366efdbbfb26e7c292c8e39100e900b4e2659b1acb08e032a2d7ebf3cfe6a","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:07:43 [15:07:43.568] INFO: world-state:database Creating world state data store at directory /tmp/854937d9eeb559c0/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:07:43 [15:07:43.588] INFO: world_state Created world state synchroniser with block history of 64 15:07:43 [15:07:43.588] WARN: node:MAIN-aztec-node Aztec node is accepting fake proofs 15:07:43 [15:07:43.598] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/854937d9eeb559c0/p2p with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.599] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:07:43 [15:07:43.600] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/854937d9eeb559c0/p2p-archive with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.601] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:07:43 [15:07:43.602] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/854937d9eeb559c0/p2p-peers with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.603] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:07:43 [15:07:43.604] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:07:43 [15:07:43.604] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 15:07:43 [15:07:43.607] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:07:43 [15:07:43.607] INFO: world_state Started world state synchronizer from block 1 15:07:43 [15:07:43.609] VERBOSE: world-state:block_stream Starting sync from block number 0 15:07:43 [15:07:43.611] INFO: p2p Starting p2p client from block 0 with empty mempools 15:07:43 [15:07:43.611] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:07:43 [15:07:43.822] INFO: epoch-prune-watcher EpochPruneWatcher initialized 15:07:43 [15:07:43.855] VERBOSE: validator Initialized validator with addresses: 0xc4bc6f27aea9894a32f65cccdcbd6f51b970b0ba 15:07:43 [15:07:43.856] VERBOSE: node:MAIN-aztec-node All Aztec Node subsystems synced 15:07:43 [15:07:43.867] INFO: slasher Starting Slasher client... 15:07:43 [15:07:43.877] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:07:43 [15:07:43.884] INFO: validator Started validator with addresses: 0xc4bc6f27aea9894a32f65cccdcbd6f51b970b0ba 15:07:43 [15:07:43.885] VERBOSE: validator Validators 0xc4bc6f27aea9894a32f65cccdcbd6f51b970b0ba are not on the validator committee for epoch 0 15:07:43 [15:07:43.885] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/1baf3648/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:07:43 [15:07:43.886] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:07:43 [15:07:43.887] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:07:43 [15:07:43.888] VERBOSE: node:MAIN-aztec-node Sequencer started 15:07:43 [15:07:43.888] INFO: node:MAIN-aztec-node Aztec Node version: 0.87.6 15:07:43 [15:07:43.888] INFO: node:MAIN-aztec-node Aztec Node started on chain 0x7a69 {"registryAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x0165878a594ca255338adfa4d48449f69242eb8f","governanceProposerAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","rollupAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","inboxAddress":"0x624dc0ecefd94640d316ee3acfd147ed9b764638","outboxAddress":"0x94cd1b4dea480e09a1e0d83f6c92b9a5c6136171","feeJuicePortalAddress":"0x42d729740c681c1626a3b909081ad726b3975b49","feeJuiceAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","stakingAssetAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","rewardDistributorAddress":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","gseAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x4ed7c70f96b99c776995fb64377f0d4ab3b0e1c1","feeAssetHandlerAddress":"0xb7f8bc63bbcad18155201308c8f3540b07f84f5e","stakingAssetHandlerAddress":"0x0dcd1bf9a1b36ce34237eeafef220932846bcd82","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 15:07:43 [15:07:43.889] VERBOSE: e2e:e2e_offchain_message Creating a pxe... 15:07:43 [15:07:43.893] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/588ddfd854da4b5a/pxe_data with map size 134217728 KB (LMDB v2) 15:07:43 [15:07:43.902] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:43 [15:07:43.903] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:43 [15:07:43.904] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:07:44 [15:07:44.208] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:07:44 [15:07:44.209] INFO: pxe:service Started PXE connected to chain 31337 version 3239198200 15:07:44 [15:07:44.250] INFO: pxe:service Registered account 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 15:07:44 [15:07:44.311] WARN: pxe:service No artifact found for contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 when looking for its metadata 15:07:44 [15:07:44.312] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 as part of deployment for 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 15:07:44 [15:07:44.468] INFO: pxe:service Added contract SchnorrAccount at 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 15:07:44 [15:07:44.483] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:44 [15:07:44.485] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:44 [15:07:44.511] VERBOSE: pxe:block_stream Starting sync from block number 0 15:07:44 [15:07:44.554] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:07:44 [15:07:44.680] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:07:45 [15:07:45.486] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2 15:07:45 [15:07:45.561] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:07:45 [15:07:45.705] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:45 [15:07:45.737] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:45 [15:07:45.795] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:45 [15:07:45.837] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:45 [15:07:45.837] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:45 [15:07:45.876] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:45 [15:07:45.880] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:46 [15:07:46.066] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:46 [15:07:46.103] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:46 [15:07:46.103] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:46 [15:07:46.141] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:46 [15:07:46.144] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:46 [15:07:46.165] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:07:46 [15:07:46.364] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:46 [15:07:46.367] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:46 [15:07:46.943] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:46 [15:07:46.944] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:47 [15:07:47.322] INFO: pxe:service Proving completed in 2812.2271579999997ms {"timings":{"total":2812.2271579999997,"sync":2.2628500000000713,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":160.44162300000062,"oracles":{"callPrivateFunction":{"times":[1082.2006110000011,305.90816500000074,191.40254099999947]}}},{"functionName":"private_kernel_init","time":92.55721300000005},{"functionName":"ContractClassRegisterer:register","time":1053.4405800000004,"oracles":{"loadCapsule":{"times":[14.165587000000414]},"notifyCreatedNullifier":{"times":[0.5107930000012857]},"debugLog":{"times":[0.7899349999988772]},"notifyCreatedContractClassLog":{"times":[9.025394999998753]}}},{"functionName":"private_kernel_inner","time":124.7995979999996},{"functionName":"SchnorrAccount:constructor","time":277.3416559999987,"oracles":{"getContractInstance":{"times":[3.6476590000002034]},"debugLog":{"times":[0.48184399999991,0.4094230000009702]},"fetchTaggedLogs":{"times":[41.10640500000045]},"loadCapsule":{"times":[0.36604299999999057,0.2316160000009404,0.2416270000012446]},"validateEnqueuedNotesAndEvents":{"times":[1.8092749999996158]},"notifyCreatedNullifier":{"times":[0.23412900000039372,0.2308419999990292]},"notifyCreatedNote":{"times":[0.5137780000004568]},"getRandomField":{"times":[0.21672899999975925,0.14692700000159675,0.09484300000076473,0.07697300000108953,0.08009099999981117,0.06949800000074902,0.07254099999954633,0.062373000000661705,0.08222100000057253,0.08185599999887927,0.07113500000014028]},"getIndexedTaggingSecretAsSender":{"times":[44.29105299999901]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.932669999998325]}}},{"functionName":"private_kernel_inner","time":111.41160900000068},{"functionName":"SchnorrAccount:entrypoint","time":161.9792749999997,"oracles":{"debugLog":{"times":[0.48082199999953446,0.3938749999997526,0.5931870000003983]},"fetchTaggedLogs":{"times":[39.05072300000029]},"loadCapsule":{"times":[0.22554800000034447,0.20849699999962468,0.23051099999975122]},"validateEnqueuedNotesAndEvents":{"times":[7.491045999999187]},"getNotes":{"times":[1.5095609999989392]},"getAuthWitness":{"times":[0.38377700000091863]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8407500000012078]}}},{"functionName":"private_kernel_inner","time":110.55089000000044},{"functionName":"private_kernel_reset","time":187.2377180000003},{"functionName":"private_kernel_tail","time":71.94861499999934}],"unaccounted":458.2555309999998}} 15:07:47 [15:07:47.414] VERBOSE: p2p:tx_pool Adding tx 0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a to pool {"eventName":"tx-added-to-pool","txHash":"0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 15:07:47 [15:07:47.435] INFO: node:MAIN-aztec-node Received tx 0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a {"txHash":"0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a"} 15:07:47 [15:07:47.435] INFO: pxe:service Sent transaction 0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a 15:07:47 [15:07:47.453] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"chainTipArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","blockNumber":1,"slot":1} 15:07:47 [15:07:47.465] VERBOSE: block-builder Building block 1 for slot 1 {"slot":1,"slotStart":"2025-06-17T15:12:18.000Z","now":"2025-06-17T15:12:34.270Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:07:47 [15:07:47.512] VERBOSE: simulator:public-processor Processed tx 0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a with no public calls in 22.02713699999913ms {"txHash":"0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a","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":22.02713699999913} 15:07:47 [15:07:47.513] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.045471056999998836s {"duration":0.045471056999998836,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 15:07:47 [15:07:47.536] INFO: sequencer Built block 1 for slot 1 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x078b2de713c14d6fa83e8126b78731b48ef68f730de7aa2bf82165a46f7510cc","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"txHashes":["0x263f853d41ee0039da407385bac92138e8bd6e71bf02afec91fa301c3cf8676a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":77.44638999999916,"publicProcessDuration":46.24167899999884,"rollupCircuitsDuration":71.1006150000012,"txCount":1,"blockNumber":1,"blockTimestamp":1750173138,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:47 [15:07:47.539] VERBOSE: sequencer Attesting committee is empty 15:07:50 [15:07:50.243] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xa61225606e379b6ac2b98d37214e9000df533ab984c73139a08f5df173cb7201 15:07:50 [15:07:50.243] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0xa61225606e379b6ac2b98d37214e9000df533ab984c73139a08f5df173cb7201 {"gasLimit":471982,"maxFeePerGas":"500","maxPriorityFeePerGas":"500","maxFeePerBlobGas":"0.000000001"} 15:07:50 [15:07:50.255] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:07:50 [15:07:50.255] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa61225606e379b6ac2b98d37214e9000df533ab984c73139a08f5df173cb7201","calldataSize":1252,"calldataGas":9916,"txCount":1,"blockNumber":1,"blockTimestamp":1750173138,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:50 [15:07:50.256] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:07:50 [15:07:50.270] INFO: blob-sink:server Received blob sidecar for block 0x854c9661242e1b1f1fa85c83380af3f16405d0eb7b44ae31dea54a5841c84c55 15:07:50 [15:07:50.279] INFO: blob-sink:server Blob sidecar stored successfully for block 0x854c9661242e1b1f1fa85c83380af3f16405d0eb7b44ae31dea54a5841c84c55 15:07:50 [15:07:50.395] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:07:50 [15:07:50.397] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:07:50 [15:07:50.399] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:07:50 [15:07:50.400] WARN: foundation:test-date-provider Time set to 2025-06-17T15:12:42.000Z {"offset":291600,"timeMs":1750173162000} 15:07:50 [15:07:50.414] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750173174 15:07:50 [15:07:50.414] WARN: foundation:test-date-provider Time set to 2025-06-17T15:12:54.000Z {"offset":303586,"timeMs":1750173174000} 15:07:50 [15:07:50.414] INFO: aztecjs:utils:watcher Slot 1 was filled, jumped to next slot 15:07:50 [15:07:50.484] VERBOSE: archiver:block-helper Store contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 15:07:50 [15:07:50.489] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x078b2de713c14d6fa83e8126b78731b48ef68f730de7aa2bf82165a46f7510cc","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"archiveRoot":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","archiveNextLeafIndex":2} 15:07:50 [15:07:50.495] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:07:50 [15:07:50.545] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.73010400000021,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750173138,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:50 [15:07:50.548] VERBOSE: p2p Synched to latest block 1 15:07:50 [15:07:50.641] WARN: pxe:service No artifact found for contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 when looking for its metadata 15:07:50 [15:07:50.643] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 as part of deployment for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 15:07:50 [15:07:50.829] INFO: pxe:service Added contract OffchainMessage at 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 with class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 15:07:50 [15:07:50.848] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:50 [15:07:50.852] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:50 [15:07:50.864] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","header":{"contentCommitment":{"blobsHash":"0x00fdcd003a6feb3ddbfd0f470cda0df423075655c2a71e7efd02c14acd4ad53a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750173138,"version":3239198200},"lastArchive":"0x03d27f5152467ee7f0225113d18d7d6770e061ed41c821c0cafed5e634ff075a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x19757171000461686ce793edf89a2f26ab572730452a7ed7509977a2f3b90fd6","nullifierTree":"0x1e5550923f685bcb057486a639e950be053a2128a3cab12169ab3dcb0b6049f7","publicDataTree":"0x0de2fff035c49e09cc1e7a210b5072f688d72d41315d49c24589445a0bce8582"},"totalFees":2101212240,"totalManaUsed":6324}} 15:07:50 [15:07:50.959] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:50 [15:07:50.995] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:50 [15:07:50.995] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:51 [15:07:51.067] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:51 [15:07:51.071] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:07:51 [15:07:51.082] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:07:51 [15:07:51.083] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:07:51 [15:07:51.089] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:07:51 [15:07:51.089] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:07:51 [15:07:51.092] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:51 [15:07:51.097] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:07:51 [15:07:51.110] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:07:51 [15:07:51.170] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:07:51 [15:07:51.769] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x2f592dbe7e087ce36f4eb433cf3894d708f912cd24736847661984e4cdbc9e1d,0x03e247bc05b2cb615b364b2859d5c43f51e70ed747edc4a6dab18dbb557c1b0c,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2 15:07:51 [15:07:51.841] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:07:52 [15:07:52.026] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:52 [15:07:52.041] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:07:52 [15:07:52.055] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:52 [15:07:52.105] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:07:52 [15:07:52.116] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15,0x0000000000000000000000000000000000000000000000000000000000000001,0x10772925fb98e764206ec951e9666c3bcc3efe1617cd9543cf4d809a4ee0b0b3,0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 15:07:52 [15:07:52.748] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:52 [15:07:52.831] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:53 [15:07:53.212] INFO: pxe:service Proving completed in 2355.173376999999ms {"timings":{"total":2355.173376999999,"sync":8.541825000000244,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":266.25339299999723,"oracles":{"debugLog":{"times":[0.49207399999977497,0.41397800000049756,0.429865999998583,0.5643860000000132,0.4594580000011774,0.36898699999983364,0.3494699999992008,0.4995390000003681]},"fetchTaggedLogs":{"times":[73.56890099999873]},"loadCapsule":{"times":[0.20680799999900046,0.4079839999994874,0.45484899999974004,0.2763009999998758,0.1906460000009247,0.22786700000142446,0.23862600000029488]},"getSharedSecret":{"times":[3.459313999999722]},"aes128Decrypt":{"times":[1.064447000000655,1.110819999999876]},"getPublicKeysAndPartialAddress":{"times":[1.4704629999996541]},"getKeyValidationRequest":{"times":[1.7326410000005126]},"storeCapsule":{"times":[0.43599600000015926,0.24942100000043865,0.23300899999958347]},"deleteCapsule":{"times":[0.33461800000077346]},"validateEnqueuedNotesAndEvents":{"times":[5.646649000000252]},"getNotes":{"times":[1.3771809999998368]},"getAuthWitness":{"times":[0.22722500000054424]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0665740000004007]},"callPrivateFunction":{"times":[833.2820330000013,175.80705900000066]}}},{"functionName":"private_kernel_init","time":56.163133000000016},{"functionName":"ContractClassRegisterer:register","time":813.5050970000011,"oracles":{"loadCapsule":{"times":[4.3522570000004634]},"notifyCreatedNullifier":{"times":[0.28756799999973737]},"debugLog":{"times":[0.46987999999873864]},"notifyCreatedContractClassLog":{"times":[9.149418999999398]}}},{"functionName":"private_kernel_inner","time":113.46442899999965},{"functionName":"ContractInstanceDeployer:deploy","time":111.97052700000131,"oracles":{"storeInExecutionCache":{"times":[0.20280199999979232]},"callPrivateFunction":{"times":[65.64381300000059]},"notifyCreatedNullifier":{"times":[0.26624700000138546]},"debugLog":{"times":[0.48516299999937473]}}},{"functionName":"private_kernel_inner","time":112.55347400000028},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.103861999999936,"oracles":{}},{"functionName":"private_kernel_inner","time":112.15601100000094},{"functionName":"private_kernel_reset","time":185.5184649999992},{"functionName":"private_kernel_tail","time":70.77268200000071}],"unaccounted":460.1704789999985}} 15:07:53 [15:07:53.296] VERBOSE: p2p:tx_pool Adding tx 0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17 to pool {"eventName":"tx-added-to-pool","txHash":"0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 15:07:53 [15:07:53.316] INFO: node:MAIN-aztec-node Received tx 0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17 {"txHash":"0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17"} 15:07:53 [15:07:53.317] INFO: pxe:service Sent transaction 0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17 15:07:53 [15:07:53.357] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"chainTipArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","blockNumber":2,"slot":2} 15:07:53 [15:07:53.367] VERBOSE: block-builder Building block 2 for slot 2 {"slot":2,"slotStart":"2025-06-17T15:12:54.000Z","now":"2025-06-17T15:12:56.953Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:07:53 [15:07:53.407] VERBOSE: simulator:public-processor Processed tx 0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17 with no public calls in 19.18395899999996ms {"txHash":"0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17","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":19.18395899999996} 15:07:53 [15:07:53.408] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03957858099999976s {"duration":0.03957858099999976,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14848,"l2Gas":5042},"totalSizeInBytes":1184} 15:07:53 [15:07:53.428] INFO: sequencer Built block 2 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x20c27f41eb69ab50ef51aeccce98e514284f06eb467a8250cf5b3cb25a4d6e49","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"txHashes":["0x162214a0f6d1442d45be4e72a8fca3f7e567e02edd674de038e9d94e01058d17"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":65.91881300000023,"publicProcessDuration":39.89429000000018,"rollupCircuitsDuration":61.24934700000085,"txCount":1,"blockNumber":2,"blockTimestamp":1750173174,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:53 [15:07:53.430] VERBOSE: sequencer Attesting committee is empty 15:07:53 [15:07:53.600] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x92d92fb8f918f1ffb2a8dd611c2f38c4ec929302ef11d8c06a9294ef7bb6795c 15:07:53 [15:07:53.600] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0x92d92fb8f918f1ffb2a8dd611c2f38c4ec929302ef11d8c06a9294ef7bb6795c {"gasLimit":385616,"maxFeePerGas":"1.257667234","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:07:53 [15:07:53.610] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:07:53 [15:07:53.610] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x92d92fb8f918f1ffb2a8dd611c2f38c4ec929302ef11d8c06a9294ef7bb6795c","calldataSize":1252,"calldataGas":9916,"txCount":1,"blockNumber":2,"blockTimestamp":1750173174,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:53 [15:07:53.611] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:07:53 [15:07:53.615] INFO: blob-sink:server Received blob sidecar for block 0x40e921890c2018622ce2df8743853a00942661cda3d1839c60c93d6721a2780c 15:07:53 [15:07:53.618] INFO: blob-sink:server Blob sidecar stored successfully for block 0x40e921890c2018622ce2df8743853a00942661cda3d1839c60c93d6721a2780c 15:07:53 [15:07:53.657] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:07:53 [15:07:53.659] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:07:53 [15:07:53.659] WARN: foundation:test-date-provider Time set to 2025-06-17T15:13:06.000Z {"offset":312341,"timeMs":1750173186000} 15:07:53 [15:07:53.660] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:07:53 [15:07:53.712] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750173210 15:07:53 [15:07:53.712] WARN: foundation:test-date-provider Time set to 2025-06-17T15:13:30.000Z {"offset":336288,"timeMs":1750173210000} 15:07:53 [15:07:53.712] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:07:53 [15:07:53.930] VERBOSE: archiver:block-helper Store contract instance at 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 15:07:53 [15:07:53.930] VERBOSE: archiver:block-helper Store contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 15:07:53 [15:07:53.940] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x20c27f41eb69ab50ef51aeccce98e514284f06eb467a8250cf5b3cb25a4d6e49","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"archiveRoot":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","archiveNextLeafIndex":3} 15:07:53 [15:07:53.944] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:07:54 [15:07:54.032] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.046903000002203,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750173174,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:07:54 [15:07:54.060] VERBOSE: p2p Synched to latest block 2 15:07:54 [15:07:54.127] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:54 [15:07:54.128] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:54 [15:07:54.346] INFO: aztecjs:deploy_sent_tx Contract 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 successfully deployed. 15:07:54 [15:07:54.545] INFO: pxe:service Added contract OffchainMessage at 0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86 with class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 15:07:54 [15:07:54.567] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","header":{"contentCommitment":{"blobsHash":"0x000ae6d617b41cb3cef12924878fb9718444a8525d1c2d40011c83ba77066e6d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750173174,"version":3239198200},"lastArchive":"0x14f05ddc3e55c60394ef18f059fdd48860737a328952754b524bf67951234013","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x19757171000461686ce793edf89a2f26ab572730452a7ed7509977a2f3b90fd6","nullifierTree":"0x1a43ce900b2a6dc623328db4450295c305810075e65cd2a0cbc33e48c32d6869","publicDataTree":"0x14e73c005b6dba2c729a128baa4d283334fdb3382de82f0743f9029797929a71"},"totalFees":1675254920,"totalManaUsed":5042}} 15:07:54 [15:07:54.658] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:54 [15:07:54.694] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:54 [15:07:54.695] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:54 [15:07:54.752] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:54 [15:07:54.753] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:54 [15:07:54.772] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:54 [15:07:54.778] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:07:54 [15:07:54.788] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:07:54 [15:07:54.789] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:07:54 [15:07:54.829] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:07:54 [15:07:54.829] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:07:54 [15:07:54.858] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:54 [15:07:54.862] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:07:54 [15:07:54.874] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:07:54 [15:07:54.924] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:07:54 [15:07:54.983] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:07:54 [15:07:54.995] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86,0x0000000000000000000000000000000000000000000000000000000000000001,0x2e820fc8beea6b0c12d0344294d843750d9645887c126a034102fcaed3ed3b18,0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 15:07:55 [15:07:55.461] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:55 [15:07:55.462] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:55 [15:07:55.840] INFO: pxe:service Proving completed in 1282.567498999997ms {"timings":{"total":1282.567498999997,"sync":10.610698000000411,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":307.43548600000213,"oracles":{"debugLog":{"times":[0.47155900000143447,0.41345799999908195,0.4506169999986014,30.267603000000236,0.4484389999997802,0.4396000000015192,0.42298500000106287,0.4637409999995725]},"fetchTaggedLogs":{"times":[81.333373999998]},"loadCapsule":{"times":[0.26041600000098697,0.26843799999915063,0.4477499999993597,0.4858380000005127,20.994698000002245,0.5067230000022391,0.34158000000024913]},"getSharedSecret":{"times":[3.1212349999987055]},"aes128Decrypt":{"times":[0.25784099999873433,1.344277999996848]},"getPublicKeysAndPartialAddress":{"times":[4.8690759999990405]},"getKeyValidationRequest":{"times":[2.607245999999577]},"storeCapsule":{"times":[0.5398260000001756,0.38729199999943376,1.726991999999882]},"deleteCapsule":{"times":[2.3636179999994056]},"validateEnqueuedNotesAndEvents":{"times":[4.352480999998079]},"getNotes":{"times":[1.2388229999996838]},"getAuthWitness":{"times":[0.23402999999962049]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05749700000160374]},"callPrivateFunction":{"times":[124.27802599999995]}}},{"functionName":"private_kernel_init","time":56.887816999998904},{"functionName":"ContractInstanceDeployer:deploy","time":61.93430199999784,"oracles":{"storeInExecutionCache":{"times":[0.0769880000007106]},"callPrivateFunction":{"times":[61.76107200000115]},"notifyCreatedNullifier":{"times":[0.2526209999996354]},"debugLog":{"times":[0.4909780000016326]}}},{"functionName":"private_kernel_inner","time":110.93513900000107},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.53714300000138,"oracles":{}},{"functionName":"private_kernel_inner","time":112.22908699999971},{"functionName":"private_kernel_reset","time":188.71905999999944},{"functionName":"private_kernel_tail","time":72.56858199999988}],"unaccounted":318.7101849999963}} 15:07:55 [15:07:55.878] VERBOSE: p2p:tx_pool Adding tx 0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986 to pool {"eventName":"tx-added-to-pool","txHash":"0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 15:07:55 [15:07:55.883] INFO: node:MAIN-aztec-node Received tx 0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986 {"txHash":"0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986"} 15:07:55 [15:07:55.883] INFO: pxe:service Sent transaction 0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986 15:07:55 [15:07:55.983] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"chainTipArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","blockNumber":3,"slot":3} 15:07:55 [15:07:55.992] VERBOSE: block-builder Building block 3 for slot 3 {"slot":3,"slotStart":"2025-06-17T15:13:30.000Z","now":"2025-06-17T15:13:32.280Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:07:56 [15:07:56.014] VERBOSE: simulator:public-processor Processed tx 0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986 with no public calls in 14.143304999997781ms {"txHash":"0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986","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":14.143304999997781} 15:07:56 [15:07:56.017] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02306660700000066s {"duration":0.02306660700000066,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":3532},"totalSizeInBytes":832} 15:07:56 [15:07:56.036] INFO: sequencer Built block 3 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x148ef6e23996bb91f797fa168955d365f320f805e29eb50ca79805d83feb977d","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"txHashes":["0x06b4758b43c6de93b50dbfd04813160c51c1ffc069b52d699389886419799986"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":49.342984000002616,"publicProcessDuration":23.476199000000634,"rollupCircuitsDuration":44.500348999998096,"txCount":1,"blockNumber":3,"blockTimestamp":1750173210,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:07:56 [15:07:56.038] VERBOSE: sequencer Attesting committee is empty 15:07:56 [15:07:56.199] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7e6227fdff34ac429cbbdca993435e3372cc26f5fb051b27786c0f5361655685 15:07:56 [15:07:56.200] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0x7e6227fdff34ac429cbbdca993435e3372cc26f5fb051b27786c0f5361655685 {"gasLimit":385659,"maxFeePerGas":"1.244260992","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:07:56 [15:07:56.210] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:07:56 [15:07:56.210] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7e6227fdff34ac429cbbdca993435e3372cc26f5fb051b27786c0f5361655685","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":3,"blockTimestamp":1750173210,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:07:56 [15:07:56.210] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:07:56 [15:07:56.213] INFO: blob-sink:server Received blob sidecar for block 0x4cb86fdaa59a910b64e9865da561439f3638a814164a13e43c0f023622959afa 15:07:56 [15:07:56.217] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4cb86fdaa59a910b64e9865da561439f3638a814164a13e43c0f023622959afa 15:07:56 [15:07:56.263] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:07:56 [15:07:56.263] WARN: foundation:test-date-provider Time set to 2025-06-17T15:13:42.000Z {"offset":345737,"timeMs":1750173222000} 15:07:56 [15:07:56.267] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:07:56 [15:07:56.269] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 15:07:56 [15:07:56.305] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750173246 15:07:56 [15:07:56.305] WARN: foundation:test-date-provider Time set to 2025-06-17T15:14:06.000Z {"offset":369695,"timeMs":1750173246000} 15:07:56 [15:07:56.305] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:07:56 [15:07:56.448] VERBOSE: archiver:block-helper Store contract instance at 0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86 15:07:56 [15:07:56.449] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x148ef6e23996bb91f797fa168955d365f320f805e29eb50ca79805d83feb977d","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"archiveRoot":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","archiveNextLeafIndex":4} 15:07:56 [15:07:56.450] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 15:07:56 [15:07:56.522] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.203133000002708,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750173210,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:07:56 [15:07:56.554] VERBOSE: p2p Synched to latest block 3 15:07:56 [15:07:56.732] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:56 [15:07:56.733] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:56 [15:07:56.914] INFO: aztecjs:deploy_sent_tx Contract 0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86 successfully deployed. 15:07:56 [15:07:56.916] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit offchain message 15:07:56 [15:07:56.949] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","header":{"contentCommitment":{"blobsHash":"0x0070f4f8da4256394f616c532bd45fa4a61c0705bb8052eed25b76feddb241cc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750173210,"version":3239198200},"lastArchive":"0x1fe1f7b9f620acbbe2a804792a8b2273cf29aa681c75f13f409e9d514ce04ccf","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x19757171000461686ce793edf89a2f26ab572730452a7ed7509977a2f3b90fd6","nullifierTree":"0x2af80c35f8f5b63ffbd33d7317f1235bf5ecce713b34c5baed8042c2c7aa1820","publicDataTree":"0x297307e72e722b7010083e5ed1a8033831bee151fe46af9a9b015b7eeba7fad4"},"totalFees":1173542320,"totalManaUsed":3532}} 15:07:57 [15:07:57.030] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:57 [15:07:57.066] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:57 [15:07:57.066] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:57 [15:07:57.114] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:57 [15:07:57.118] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:07:57 [15:07:57.127] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:07:57 [15:07:57.128] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:07:57 [15:07:57.134] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:07:57 [15:07:57.135] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:07:57 [15:07:57.137] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:57 [15:07:57.140] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:07:57 [15:07:57.158] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:07:57 [15:07:57.240] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.278] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:57 [15:07:57.278] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.323] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:57 [15:07:57.326] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:57 [15:07:57.328] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.331] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:57 [15:07:57.423] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86"} 15:07:57 [15:07:57.461] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:57 [15:07:57.461] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86"} 15:07:57 [15:07:57.503] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1024bd8de6a6a68b17012b60392d14b20d2ae9dab91f4ad1aa0a2eb6d656eb86"} 15:07:57 [15:07:57.506] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:57 [15:07:57.595] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.632] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:57 [15:07:57.633] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.679] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:57 [15:07:57.684] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:58 [15:07:58.018] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:58 [15:07:58.020] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:58 [15:07:58.809] INFO: pxe:service Proving completed in 1877.3527919999979ms {"timings":{"total":1877.3527919999979,"sync":18.0471890000008,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":220.15388899999743,"oracles":{"debugLog":{"times":[0.46251999999731197,0.3664649999991525,0.3945139999996172,0.4951120000005176,0.41780500000095344,0.34578500000134227,0.3494300000020303,0.44311300000117626]},"fetchTaggedLogs":{"times":[49.643308000002435]},"loadCapsule":{"times":[0.17535700000007637,0.1546039999993809,0.3644029999995837,0.21072499999718275,0.16670800000065356,0.16976399999839487,0.1849210000000312]},"getSharedSecret":{"times":[2.7122889999991457]},"aes128Decrypt":{"times":[0.22226700000101118,0.956756999999925]},"getPublicKeysAndPartialAddress":{"times":[2.893082000002323]},"getKeyValidationRequest":{"times":[1.3425869999991846]},"storeCapsule":{"times":[0.2778440000001865,0.23317799999858835,0.3308930000021064]},"deleteCapsule":{"times":[0.18988600000011502]},"validateEnqueuedNotesAndEvents":{"times":[8.599839000002248]},"getNotes":{"times":[1.8384729999997944]},"getAuthWitness":{"times":[0.26175399999920046]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05830199999763863]},"callPrivateFunction":{"times":[562.0125889999981]}}},{"functionName":"private_kernel_init","time":55.31998200000089},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":191.5457400000014,"oracles":{"debugLog":{"times":[0.439076999999088,0.3912669999990612]},"fetchTaggedLogs":{"times":[52.170492000001104]},"loadCapsule":{"times":[0.21228999999948428,0.17037799999889103,0.1931780000013532]},"validateEnqueuedNotesAndEvents":{"times":[1.0363959999995132]},"emitOffchainMessage":{"times":[0.17091800000343937]},"storeInExecutionCache":{"times":[0.15946099999928265]},"callPrivateFunction":{"times":[370.57252399999925]}}},{"functionName":"private_kernel_inner","time":108.52970300000015},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":182.83659299999636,"oracles":{"debugLog":{"times":[0.4410119999993185,0.38176000000021304]},"fetchTaggedLogs":{"times":[44.154609000001074]},"loadCapsule":{"times":[0.19844699999885052,0.15785200000027544,0.19758999999976368]},"validateEnqueuedNotesAndEvents":{"times":[0.97497999999905]},"emitOffchainMessage":{"times":[0.05372999999963213]},"storeInExecutionCache":{"times":[0.11954799999875831]},"callPrivateFunction":{"times":[186.64278900000136]}}},{"functionName":"private_kernel_inner","time":108.47112600000037},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":156.99989000000278,"oracles":{"debugLog":{"times":[0.47091100000034203,0.34777300000132527]},"fetchTaggedLogs":{"times":[50.02337700000135]},"loadCapsule":{"times":[0.18202300000120886,0.17476100000203587,0.18432100000063656]},"validateEnqueuedNotesAndEvents":{"times":[1.1118830000013986]},"emitOffchainMessage":{"times":[0.05556300000171177]}}},{"functionName":"private_kernel_inner","time":108.19255699999849},{"functionName":"private_kernel_reset","time":183.78809199999887},{"functionName":"private_kernel_tail","time":69.78145199999926}],"unaccounted":473.6865790000011}} 15:07:58 [15:07:58.814] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should not emit any offchain messages 15:07:58 [15:07:58.844] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:58 [15:07:58.845] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:58 [15:07:58.921] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:58 [15:07:58.957] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:58 [15:07:58.958] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:59 [15:07:59.003] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:07:59 [15:07:59.007] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:07:59 [15:07:59.016] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:07:59 [15:07:59.017] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:07:59 [15:07:59.023] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:07:59 [15:07:59.024] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:07:59 [15:07:59.026] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:59 [15:07:59.029] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:07:59 [15:07:59.043] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:07:59 [15:07:59.131] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:59 [15:07:59.169] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:07:59 [15:07:59.169] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:59 [15:07:59.203] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:07:59 [15:07:59.206] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:07:59 [15:07:59.487] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:59 [15:07:59.605] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:07:59 [15:07:59.855] INFO: pxe:service Proving completed in 1025.339086ms {"timings":{"total":1025.339086,"sync":14.708281999999599,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":213.01500500000475,"oracles":{"debugLog":{"times":[0.4868499999975029,0.3763589999980468,0.37002399999983027,0.5082270000020799,0.3740490000018326,0.36571600000024773,0.3017599999984668,0.44342999999935273]},"fetchTaggedLogs":{"times":[47.422223999998096]},"loadCapsule":{"times":[0.1674219999986235,0.3034799999986717,0.38859299999967334,0.20125299999926938,0.1806800000013027,0.17128600000069127,0.1735530000005383]},"getSharedSecret":{"times":[2.5723649999999907]},"aes128Decrypt":{"times":[0.25228900000001886,0.9459580000002461]},"getPublicKeysAndPartialAddress":{"times":[2.6313149999987218]},"getKeyValidationRequest":{"times":[1.221084000000701]},"storeCapsule":{"times":[0.2970260000001872,0.20488100000147824,0.1876879999981611]},"deleteCapsule":{"times":[0.18067800000062562]},"validateEnqueuedNotesAndEvents":{"times":[3.564652000000933]},"getNotes":{"times":[4.021457000002556]},"getAuthWitness":{"times":[0.24136100000032457]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05633700000180397]},"callPrivateFunction":{"times":[180.84911999999895]}}},{"functionName":"private_kernel_init","time":55.37807900000189},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":150.02629999999772,"oracles":{"debugLog":{"times":[0.4813770000000659,0.38915500000075554]},"fetchTaggedLogs":{"times":[35.600712999999814]},"loadCapsule":{"times":[0.20219900000302005,0.37247300000308314,0.4628640000009909]},"validateEnqueuedNotesAndEvents":{"times":[2.46381399999882]}}},{"functionName":"private_kernel_inner","time":107.55972800000018},{"functionName":"private_kernel_reset","time":184.65151400000104},{"functionName":"private_kernel_tail","time":69.60933099999966}],"unaccounted":230.39084699999512}} 15:07:59 [15:07:59.857] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should revert when emitting offchain message from utility function 15:07:59 [15:07:59.955] VERBOSE: simulator Executing utility function emitting_offchain_message_from_utility_reverts {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","selector":"0xaa12a861"} 15:07:59 [15:07:59.965] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:07:59 [15:07:59.965] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:00 [15:08:00.004] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:00 [15:08:00.007] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:00 [15:08:00.015] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit event as offchain message and process it 15:08:00 [15:08:00.103] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:00 [15:08:00.139] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:08:00 [15:08:00.140] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:00 [15:08:00.187] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:08:00 [15:08:00.188] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:08:00 [15:08:00.198] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:00 [15:08:00.202] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:08:00 [15:08:00.211] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:08:00 [15:08:00.212] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:08:00 [15:08:00.217] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:08:00 [15:08:00.217] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:08:00 [15:08:00.220] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:00 [15:08:00.223] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:08:00 [15:08:00.235] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:08:00 [15:08:00.318] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_event_as_offchain_message_for_msg_sender {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:00 [15:08:00.339] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:08:00 [15:08:00.339] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:00 [15:08:00.375] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:00 [15:08:00.377] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:01 [15:08:01.023] INFO: pxe:service Proving completed in 1002.4462469999999ms {"timings":{"total":1002.4462469999999,"sync":2.596099000002141,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":223.43256299999848,"oracles":{"debugLog":{"times":[0.4629919999970298,0.39044099999955506,0.40675499999997555,0.49690799999734736,0.396152000001166,0.3704330000000482,0.35595200000170735,0.42024599999786005]},"fetchTaggedLogs":{"times":[60.600248000002466]},"loadCapsule":{"times":[0.19079599999895436,0.14887699999962933,0.3842850000000908,0.21593299999949522,0.15319499999895925,0.17219900000054622,0.2048319999994419]},"getSharedSecret":{"times":[2.5700640000031854]},"aes128Decrypt":{"times":[0.39659600000231876,1.1326690000023518]},"getPublicKeysAndPartialAddress":{"times":[1.2003850000000966]},"getKeyValidationRequest":{"times":[1.2168540000020585]},"storeCapsule":{"times":[0.2701549999983399,0.19290099999852828,0.2905480000008538]},"deleteCapsule":{"times":[0.20510900000226684]},"validateEnqueuedNotesAndEvents":{"times":[3.6959029999998165]},"getNotes":{"times":[1.0392629999987548]},"getAuthWitness":{"times":[0.24023099999976694]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05297199999768054]},"callPrivateFunction":{"times":[159.8855599999988]}}},{"functionName":"private_kernel_init","time":55.23381199999858},{"functionName":"OffchainMessage:emit_event_as_offchain_message_for_msg_sender","time":129.26723700000002,"oracles":{"debugLog":{"times":[0.44225400000141235,0.40945599999758997]},"fetchTaggedLogs":{"times":[36.78397799999948]},"loadCapsule":{"times":[0.18457500000295113,0.15802999999868916,1.7031439999991562]},"validateEnqueuedNotesAndEvents":{"times":[6.8225600000005215]},"getRandomField":{"times":[0.09871500000008382,0.05949799999871175,0.07270900000003166,0.044892000001709675,0.04011199999877135,0.03308199999810313,0.03874800000266987,0.030217999999877065,0.029316000000108033,0.036757999998371815,0.0329970000020694,0.03520800000114832]},"notifyCreatedNullifier":{"times":[0.20971300000019255]},"emitOffchainMessage":{"times":[0.06662499999947613]}}},{"functionName":"private_kernel_inner","time":108.38427500000034},{"functionName":"private_kernel_reset","time":185.3420819999992},{"functionName":"private_kernel_tail","time":70.02581599999758}],"unaccounted":228.1643630000035}} 15:08:01 [15:08:01.064] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:08:01 [15:08:01.066] VERBOSE: p2p:tx_pool Adding tx 0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335 to pool {"eventName":"tx-added-to-pool","txHash":"0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 15:08:01 [15:08:01.071] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:08:01 [15:08:01.072] INFO: node:MAIN-aztec-node Received tx 0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335 {"txHash":"0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335"} 15:08:01 [15:08:01.073] INFO: pxe:service Sent transaction 0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335 15:08:01 [15:08:01.588] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"chainTipArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","blockNumber":4,"slot":4} 15:08:01 [15:08:01.599] VERBOSE: block-builder Building block 4 for slot 4 {"slot":4,"slotStart":"2025-06-17T15:14:06.000Z","now":"2025-06-17T15:14:11.294Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:08:01 [15:08:01.620] VERBOSE: simulator:public-processor Processed tx 0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335 with no public calls in 13.511886000000231ms {"txHash":"0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335","txFee":1173542320,"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":13.511886000000231} 15:08:01 [15:08:01.621] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0206548870000006s {"duration":0.0206548870000006,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3532},"totalSizeInBytes":288} 15:08:01 [15:08:01.640] INFO: sequencer Built block 4 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x00ed45742932d3496616983c0d7ab6185b83947706ccceb4f994f12b74b07711","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"txHashes":["0x29517564ee529941f65994e83cb65f300b20469fb6b945c5ec14683162040335"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.17858899999919,"publicProcessDuration":20.962037000001146,"rollupCircuitsDuration":41.536009999999806,"txCount":1,"blockNumber":4,"blockTimestamp":1750173246,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:01 [15:08:01.642] VERBOSE: sequencer Attesting committee is empty 15:08:01 [15:08:01.797] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xceaf92128e7c1929d6fe1b37ed500a9ff7631ecd056983674bf11ec2d52dd962 15:08:01 [15:08:01.797] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0xceaf92128e7c1929d6fe1b37ed500a9ff7631ecd056983674bf11ec2d52dd962 {"gasLimit":385645,"maxFeePerGas":"1.233971387","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:08:01 [15:08:01.807] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:08:01 [15:08:01.808] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xceaf92128e7c1929d6fe1b37ed500a9ff7631ecd056983674bf11ec2d52dd962","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":4,"blockTimestamp":1750173246,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:01 [15:08:01.808] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:08:01 [15:08:01.811] INFO: blob-sink:server Received blob sidecar for block 0xec4a2624877a57a990c99bc0547fa3d2308f0fe98a4ff540e08c2f45008072f5 15:08:01 [15:08:01.814] INFO: blob-sink:server Blob sidecar stored successfully for block 0xec4a2624877a57a990c99bc0547fa3d2308f0fe98a4ff540e08c2f45008072f5 15:08:01 [15:08:01.862] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:08:01 [15:08:01.862] WARN: foundation:test-date-provider Time set to 2025-06-17T15:14:18.000Z {"offset":376138,"timeMs":1750173258000} 15:08:01 [15:08:01.865] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 15:08:01 [15:08:01.867] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 15:08:01 [15:08:01.903] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750173282 15:08:01 [15:08:01.903] WARN: foundation:test-date-provider Time set to 2025-06-17T15:14:42.000Z {"offset":400097,"timeMs":1750173282000} 15:08:01 [15:08:01.903] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:08:02 [15:08:02.148] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x00ed45742932d3496616983c0d7ab6185b83947706ccceb4f994f12b74b07711","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"archiveRoot":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","archiveNextLeafIndex":5} 15:08:02 [15:08:02.150] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 15:08:02 [15:08:02.212] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":5.724419000001944,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750173246,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:02 [15:08:02.256] VERBOSE: p2p Synched to latest block 4 15:08:02 [15:08:02.324] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:02 [15:08:02.326] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:02 [15:08:02.837] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:02 [15:08:02.837] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:03 [15:08:03.084] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","header":{"contentCommitment":{"blobsHash":"0x00ca05da0be2baf32bbc5afe88cdb8984ca2c402d51e37c0b49bf8a7e95613c2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750173246,"version":3239198200},"lastArchive":"0x03e8387afa2f35b3af4b45f820200431ad35356b8efa6b358a2180612b87cc77","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x19757171000461686ce793edf89a2f26ab572730452a7ed7509977a2f3b90fd6","nullifierTree":"0x2e5a373153a1ce17df16b1e24c6036664592b892d9b242d642382e1e18a99952","publicDataTree":"0x23ebbc6934f3bc20b9362e3f6e320d6b7e53e0d4aeb48435b73f6571e98476ca"},"totalFees":1173542320,"totalManaUsed":3532}} 15:08:03 [15:08:03.170] VERBOSE: simulator Executing utility function process_message {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","selector":"0x988dd306"} 15:08:03 [15:08:03.181] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:08:03 [15:08:03.182] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.227] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.229] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:03 [15:08:03.239] VERBOSE: simulator:client_view_context:debug_log Processing private event msg 15:08:03 [15:08:03.241] VERBOSE: simulator Utility simulation for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15.0x988dd306 completed 15:08:03 [15:08:03.242] VERBOSE: pxe:service Getting private events for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 from 4 to 5 15:08:03 [15:08:03.330] VERBOSE: simulator Executing utility function sync_private_state {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","selector":"0xc6cedc33"} 15:08:03 [15:08:03.341] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:08:03 [15:08:03.341] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.383] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:03 [15:08:03.384] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:03 [15:08:03.388] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.390] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:03 [15:08:03.394] VERBOSE: private_event_data_provider storing private event log {"contractAddress":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","recipient":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","msgContent":["0x0000000000000000000000000000000000000000000000000000000000000001","0x0000000000000000000000000000000000000000000000000000000000000002","0x0000000000000000000000000000000000000000000000000000000000000003"],"blockNumber":4} 15:08:03 [15:08:03.396] VERBOSE: simulator Utility simulation for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15.0xc6cedc33 completed 15:08:03 [15:08:03.398] INFO: e2e:e2e_offchain_message Running test: e2e_offchain_message should emit note as offchain message and process it 15:08:03 [15:08:03.493] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:03 [15:08:03.529] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:08:03 [15:08:03.529] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:03 [15:08:03.574] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27"} 15:08:03 [15:08:03.577] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1b7a0e3534680ecf49039f5c859cfc2815c2263692b2e169529c9840c8621107 15:08:03 [15:08:03.586] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:08:03 [15:08:03.587] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:08:03 [15:08:03.594] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:08:03 [15:08:03.594] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:08:03 [15:08:03.596] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:03 [15:08:03.600] VERBOSE: pxe:service Added note {"index":0,"contract":"0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1880c4ccd94863eb1ee2692c5012d79bd3ce2c2fd38900698e4272579bf18c47","nullifier":"0x0da37443c04a33784fd2d7e0e78e1745cd6e01a7a0c9ed7b509cdddaef198ad6"} 15:08:03 [15:08:03.611] VERBOSE: simulator:client_execution_context:debug_log Setting 0x20cc157536dd6b01b6c937d65a646a1d7690ec5964080b8702e48a47ee0fce27 as fee payer 15:08:03 [15:08:03.695] VERBOSE: simulator:private_execution Executing private function OffchainMessage:emit_note_as_offchain_message {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.716] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:08:03 [15:08:03.716] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.758] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:03 [15:08:03.763] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:03 [15:08:03.943] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:04 [15:08:04.038] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:04 [15:08:04.468] INFO: pxe:service Proving completed in 1056.1395200000006ms {"timings":{"total":1056.1395200000006,"sync":2.56556499999715,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":209.33318800000052,"oracles":{"debugLog":{"times":[0.4220320000022184,0.4435520000006363,0.38915300000007846,0.515268000002834,0.39525200000207406,0.3258559999994759,0.41282700000010664,0.47375100000135717]},"fetchTaggedLogs":{"times":[46.792167000003246]},"loadCapsule":{"times":[0.16005299999960698,0.14868099999875994,0.3526140000030864,0.22394100000019534,0.150709999998071,0.1506870000011986,0.1695399999989604]},"getSharedSecret":{"times":[2.495734000000084]},"aes128Decrypt":{"times":[0.19181699999899138,0.955286000000342]},"getPublicKeysAndPartialAddress":{"times":[2.8764960000007704]},"getKeyValidationRequest":{"times":[1.2152879999994184]},"storeCapsule":{"times":[0.2747770000023593,0.2077880000033474,0.2010840000002645]},"deleteCapsule":{"times":[0.21164100000169128]},"validateEnqueuedNotesAndEvents":{"times":[3.715248000000429]},"getNotes":{"times":[1.0026949999992212]},"getAuthWitness":{"times":[0.22742700000162586]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06144700000004377]},"callPrivateFunction":{"times":[225.10238000000027]}}},{"functionName":"private_kernel_init","time":56.67573700000139},{"functionName":"OffchainMessage:emit_note_as_offchain_message","time":194.38768399999753,"oracles":{"debugLog":{"times":[0.4701999999997497,0.36185199999817996]},"fetchTaggedLogs":{"times":[45.06217699999979]},"loadCapsule":{"times":[0.16784899999765912,0.1516909999991185,0.8847769999993034]},"validateEnqueuedNotesAndEvents":{"times":[2.940675999998348]},"getRandomField":{"times":[0.09806700000262936,0.09381399999983842,0.08256400000027497,0.05906699999832199,0.04133400000137044,0.0338530000008177,0.030273999997007195,0.02859600000010687,0.027936000002227956,0.0403230000010808,0.030262000000220723,0.028555999997479375]},"notifyCreatedNote":{"times":[0.1259460000001127]},"getIndexedTaggingSecretAsSender":{"times":[34.3380909999978]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.78862400000071]},"emitOffchainMessage":{"times":[0.13098299999910523]}}},{"functionName":"private_kernel_inner","time":107.70996200000081},{"functionName":"private_kernel_reset","time":184.55710700000054},{"functionName":"private_kernel_tail","time":69.74342400000023}],"unaccounted":231.16685300000245}} 15:08:04 [15:08:04.504] VERBOSE: p2p:tx_pool Adding tx 0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5 to pool {"eventName":"tx-added-to-pool","txHash":"0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5","noteHashCount":1,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 15:08:04 [15:08:04.509] INFO: node:MAIN-aztec-node Received tx 0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5 {"txHash":"0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5"} 15:08:04 [15:08:04.509] INFO: pxe:service Sent transaction 0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5 15:08:04 [15:08:04.550] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"chainTipArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","blockNumber":5,"slot":5} 15:08:04 [15:08:04.558] VERBOSE: block-builder Building block 5 for slot 5 {"slot":5,"slotStart":"2025-06-17T15:14:42.000Z","now":"2025-06-17T15:14:44.655Z","blockNumber":5,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:08:04 [15:08:04.579] VERBOSE: simulator:public-processor Processed tx 0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5 with no public calls in 13.735225999997056ms {"txHash":"0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5","txFee":83062560,"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":13.735225999997056} 15:08:04 [15:08:04.580] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02036600900000121s {"duration":0.02036600900000121,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3304},"totalSizeInBytes":320} 15:08:04 [15:08:04.599] INFO: sequencer Built block 5 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x24b3aacd9647e783f4b2346561efbff8eeb78e723aa9b6525195c6287cd3a905","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"txHashes":["0x146a9b60e8b27fcd626dddea4a92011c5d62da0a2cf88dc40c1f9e43d992ffb5"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.09048200000325,"publicProcessDuration":21.00385499999902,"rollupCircuitsDuration":41.4337400000004,"txCount":1,"blockNumber":5,"blockTimestamp":1750173282,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:04 [15:08:04.601] VERBOSE: sequencer Attesting committee is empty 15:08:04 [15:08:04.750] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x896a59f793b948cdfa733c1b46ddff3624259be566031ba16bf43ad867a0f322 15:08:04 [15:08:04.751] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0x896a59f793b948cdfa733c1b46ddff3624259be566031ba16bf43ad867a0f322 {"gasLimit":385671,"maxFeePerGas":"1.226073864","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:08:04 [15:08:04.762] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:08:04 [15:08:04.762] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x896a59f793b948cdfa733c1b46ddff3624259be566031ba16bf43ad867a0f322","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":5,"blockTimestamp":1750173282,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:04 [15:08:04.762] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:08:04 [15:08:04.764] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750173318 15:08:04 [15:08:04.765] WARN: foundation:test-date-provider Time set to 2025-06-17T15:15:18.000Z {"offset":433235,"timeMs":1750173318000} 15:08:04 [15:08:04.765] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 15:08:04 [15:08:04.766] INFO: blob-sink:server Received blob sidecar for block 0x7664e84d943bb3d2cd629e3c860bdfd9e5ae5c504a8af2805ef2cfb9846f42ed 15:08:04 [15:08:04.769] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7664e84d943bb3d2cd629e3c860bdfd9e5ae5c504a8af2805ef2cfb9846f42ed 15:08:04 [15:08:04.950] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 15:08:04 [15:08:04.952] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 15:08:05 [15:08:05.061] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x24b3aacd9647e783f4b2346561efbff8eeb78e723aa9b6525195c6287cd3a905","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"archiveRoot":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","archiveNextLeafIndex":6} 15:08:05 [15:08:05.062] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 15:08:05 [15:08:05.078] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":5.717538000000786,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750173282,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:08:05 [15:08:05.080] VERBOSE: p2p Synched to latest block 5 15:08:05 [15:08:05.278] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750173318,"version":3239198200},"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:05 [15:08:05.279] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:05 [15:08:05.517] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","header":{"contentCommitment":{"blobsHash":"0x00a28ec5f322e5a6ade3ecd6c26875d9581c6a9a696370795fd25735057699aa","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750173282,"version":3239198200},"lastArchive":"0x227706881e006aab923c7fbda890883cdf6be585042ef97e35ce49eee67fd593","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x22b6370657ad163c35897df00bc5c8defa946631179491e60b974655bee37b16","nullifierTree":"0x1ffaa962dde832fde7d375964c80a31124048a65df9f94eb5f6d2a5d95c6cf3f","publicDataTree":"0x010a28c6b3276c2f4de19414db69c5f9a41e59e887d31efd30928a8fec34083e"},"totalFees":83062560,"totalManaUsed":3304}} 15:08:05 [15:08:05.604] VERBOSE: simulator Executing utility function process_message {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","selector":"0x988dd306"} 15:08:05 [15:08:05.616] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:08:05 [15:08:05.616] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:05 [15:08:05.662] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:05 [15:08:05.664] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:05 [15:08:05.674] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 15:08:05 [15:08:05.675] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15 for storage slot 0x0aa0d671260cf78e0eaa34e3267e6bcb7047760da0f866cb83b0c728aeab3c3f 15:08:05 [15:08:05.679] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:08:05 [15:08:05.680] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:08:05 [15:08:05.681] VERBOSE: simulator Utility simulation for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15.0x988dd306 completed 15:08:05 [15:08:05.767] VERBOSE: simulator Executing utility function get_note_value {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","selector":"0x5e6122e2"} 15:08:05 [15:08:05.777] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:08:05 [15:08:05.778] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:05 [15:08:05.819] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750173318,"version":3239198200},"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:05 [15:08:05.820] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:05 [15:08:05.823] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15"} 15:08:05 [15:08:05.826] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:08:05 [15:08:05.829] VERBOSE: pxe:service Added note {"index":256,"contract":"0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15","slot":"0x0aa0d671260cf78e0eaa34e3267e6bcb7047760da0f866cb83b0c728aeab3c3f","noteHash":"0x0933fa65c79db6476fe7cdad019981460e7cb073b4d04c933764a2b39915066d","nullifier":"0x1dfc8fa13c3ba8e11a53194fedb74fdbeee5af77b1d0ebd0e31449ac7b9ae909"} 15:08:05 [15:08:05.834] VERBOSE: simulator Utility simulation for 0x2aabbfcbbecb5413796fa3df1349517ef09f0d4ff059f99d68772cb5fa432b15.0x5e6122e2 completed 15:08:05 [15:08:05.836] INFO: node:MAIN-aztec-node Stopping Aztec Node 15:08:06 [15:08:06.333] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750173318,"version":3239198200},"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:06 [15:08:06.333] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:06 [15:08:06.845] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750173318,"version":3239198200},"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:06 [15:08:06.846] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:07 [15:08:07.356] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750173318,"version":3239198200},"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:07 [15:08:07.356] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1dc2c1b9264e19da3b18d8e570d22118b75d69b2d6eafda2692ee7778741b480","blockNumber":6,"slot":6} 15:08:07 [15:08:07.838] INFO: slasher Slasher client stopped. 15:08:07 [15:08:07.839] INFO: sequencer Stopped sequencer 15:08:07 [15:08:07.839] INFO: p2p P2P client stopped 15:08:07 [15:08:07.840] INFO: world_state Stopped world state synchronizer 15:08:07 [15:08:07.840] INFO: archiver Stopped. 15:08:07 [15:08:07.841] INFO: node:MAIN-aztec-node Stopped Aztec Node 15:08:07 [15:08:07.849] INFO: blob-sink:server Stopping blob sink 15:08:07 [15:08:07.850] INFO: blob-sink:server Blob sink stopped 15:08:07 PASS src/e2e_offchain_message.test.ts 15:08:07 e2e_offchain_message 15:08:07 ✓ should emit offchain message (1897 ms) 15:08:07 ✓ should not emit any offchain messages (1043 ms) 15:08:07 ✓ should revert when emitting offchain message from utility function (157 ms) 15:08:07 ✓ should emit event as offchain message and process it (3384 ms) 15:08:07 ✓ should emit note as offchain message and process it (2436 ms) 15:08:07 15:08:07 Test Suites: 1 passed, 1 total 15:08:07 Tests: 5 passed, 5 total 15:08:07 Snapshots: 0 total 15:08:07 Time: 30.323 s 15:08:07 Ran all test suites matching src/e2e_offchain_message.test.ts. 15:08:07 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?