Parent Log:
http://ci.aztec-labs.com/cbf3ddc3cc40e3b7
Command: b2a342c9d927fff0: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/3c1b9d57eadcc8fb03a7ed42610cf0a1ae4a32eb
Env: REF_NAME=gh-readonly-queue/next/pr-14858-4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 CURRENT_VERSION=0.87.6 CI_FULL=0
Date: Tue Jun 17 21:38:39 UTC 2025
System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-14858_arm64_a1-fast
Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_9323dbf3b3f7fe91_next
21:38:39 +++ id -u
21:38:39 +++ id -g
21:38:39 ++ 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'\'''
21:38:39 + cid=3777be6d51323697a48378f153c8d8d20ea7c927b125bdcf01e0c89a42819788
21:38:39 + set +x
21:38:40 {"level":25,"time":1750196320279,"pid":12,"hostname":"3777be6d5132","module":"logger","msg":"Logger initialized with level verbose"}
21:38:44 [21:38:44.651]
INFO:
e2e:e2e_offchain_message Logging metrics to log/unknown.jsonl
21:38:45 [21:38:45.019]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-0rDUTX/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads.
21:38:45 [21:38:45.094]
INFO:
e2e:e2e_offchain_message Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
21:38:45 [21:38:45.106]
INFO:
e2e:e2e_offchain_message Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
21:38:45 [21:38:45.115]
INFO:
e2e:e2e_offchain_message Deployed Multicall3
21:38:45 [21:38:45.116]
INFO:
e2e:e2e_offchain_message Calling anvil_setBlockTimestampInterval with params: [12]
21:38:45 [21:38:45.118]
WARN:
e2e:e2e_offchain_message Set block interval to 12
21:38:45 [21:38:45.119]
VERBOSE:
e2e:e2e_offchain_message Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
21:38:45 [21:38:45.146]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x9442c96dbfb1b64a27527fd1a4f8eb19d84a1a68b868640b29ed6b2c81dc2f50
{"gasLimit":854274,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
21:38:45 [21:38:45.153]
VERBOSE:
e2e:e2e_offchain_message Deployed Fee Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512
21:38:45 [21:38:45.169]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x529d27ea68ffcafebe07526577b61092e24b59c533cc9143f998e4fc6dcfb14b
{"gasLimit":854259,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
21:38:45 [21:38:45.175]
VERBOSE:
e2e:e2e_offchain_message Deployed Staking Asset at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0
21:38:45 [21:38:45.195]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x95b7699fe33f0d871f0ae253cf7877a0a99483589cd7195124d29ecd32486788
{"gasLimit":3073296,"maxFeePerGas":"172.377258836","maxPriorityFeePerGas":"171.2876976"}
21:38:45 [21:38:45.200]
VERBOSE:
e2e:e2e_offchain_message Deployed GSE at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9
21:38:45 [21:38:45.216]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xd840470e4520b29f6e66aea9617699fd1a8abdf80bda295d106b2c781e7551c1
{"gasLimit":1014434,"maxFeePerGas":"206.505066871","maxPriorityFeePerGas":"205.54523712"}
21:38:45 [21:38:45.221]
VERBOSE:
e2e:e2e_offchain_message Deployed Registry at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9
21:38:45 [21:38:45.237]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x563bb16d401b06a11b51da2b9ee7cfe951b8fa630d4c267296dbb34e90c4a7d7
{"gasLimit":1966612,"maxFeePerGas":"247.514620583","maxPriorityFeePerGas":"246.654284544"}
21:38:45 [21:38:45.241]
VERBOSE:
e2e:e2e_offchain_message Deployed GovernanceProposer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707
21:38:45 [21:38:45.257]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x9809e7430227c00a4d9dd16542138371f0fc8cc9a202cab272bfad42c53af0c8
{"gasLimit":3042394,"maxFeePerGas":"296.743996283","maxPriorityFeePerGas":"295.985141452"}
21:38:45 [21:38:45.262]
VERBOSE:
e2e:e2e_offchain_message Deployed Governance at 0x0165878a594ca255338adfa4d48449f69242eb8f
21:38:45 [21:38:45.274]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x5660c9700c6cc3fc5ef11719756efe90435549e646aaddc6afa5c32149db4bcb
{"gasLimit":100000,"maxFeePerGas":"355.856531426","maxPriorityFeePerGas":"355.182169742"}
21:38:45 [21:38:45.274]
VERBOSE:
e2e:e2e_offchain_message Set governance on GSE in 0x5660c9700c6cc3fc5ef11719756efe90435549e646aaddc6afa5c32149db4bcb
21:38:45 [21:38:45.290]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xd70b3c233e6bef808e173966891167ea628718fc550577fac9e1792ed01647aa
{"gasLimit":391719,"maxFeePerGas":"426.822917902","maxPriorityFeePerGas":"426.21860369"}
21:38:45 [21:38:45.295]
VERBOSE:
e2e:e2e_offchain_message Deployed CoinIssuer at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6
21:38:45 [21:38:45.295]
VERBOSE:
e2e:e2e_offchain_message Waiting for deployments to complete
21:38:45 [21:38:45.296]
INFO:
e2e:e2e_offchain_message Waiting for 7 transactions to be mined...
21:38:45 [21:38:45.318]
INFO:
e2e:e2e_offchain_message All transactions mined successfully
21:38:45 [21:38:45.327]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0
{"gasLimit":100000,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.328]
VERBOSE:
e2e:e2e_offchain_message Added coin issuer 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0
21:38:45 [21:38:45.341]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x13a19479c80c53e28262b8a87b03014d06d51032c11114e38ce7c6906bd5125c
{"gasLimit":56661,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.354]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xd431ef3723b2de7ec35591cb862dbc668fe288da15c79822d5658456bc23cde8
{"gasLimit":339705,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.358]
VERBOSE:
e2e:e2e_offchain_message Deployed FeeAssetHandler at 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e
21:38:45 [21:38:45.371]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8
{"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.371]
VERBOSE:
e2e:e2e_offchain_message Added fee asset handler 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e as minter on fee asset in 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8
21:38:45 [21:38:45.390]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xa4087f55c628ff0aabbdb178296f38f5e43a286d429551172ffeda45ca1b5f33
{"gasLimit":2474272,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.394]
VERBOSE:
e2e:e2e_offchain_message Deployed StakingAssetHandler at 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82
21:38:45 [21:38:45.406]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2
{"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.406]
VERBOSE:
e2e:e2e_offchain_message Added staking asset handler 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82 as minter on staking asset in 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2
21:38:45 [21:38:45.406]
VERBOSE:
e2e:e2e_offchain_message Waiting for deployments to complete
21:38:45 [21:38:45.406]
INFO:
e2e:e2e_offchain_message Waiting for 9 transactions to be mined...
21:38:45 [21:38:45.425]
INFO:
e2e:e2e_offchain_message All transactions mined successfully
21:38:45 [21:38:45.437]
VERBOSE:
e2e:e2e_offchain_message Deployed shared contracts
21:38:45 [21:38:45.452]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3
{"gasLimit":84837,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.452]
VERBOSE:
e2e:e2e_offchain_message Funded reward distributor with 10000000000000000000000000 fee asset in 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3
21:38:45 [21:38:45.465]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xe864f8598420a3f08ad58dfc390d1839179932035cc0f8f39946ee51d7291728
{"gasLimit":152965,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.469]
VERBOSE:
e2e:e2e_offchain_message Rollup will use the mock verifier at 0x959922be3caee4b8cd9a407cc3ac1c251c2007b1
21:38:45 [21:38:45.470]
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}}
21:38:45 [21:38:45.484]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xc76cf75aa80e4a8e1cc120e0b066bddd181a605b1a16a9246435279515c78fbf
{"gasLimit":86397,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.506]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x6e7105310bd44fb127895b20144b6dd3b58686ab24d55f3a1f4251b1d4fcfb07
{"gasLimit":5019565,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.525]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x2477ffd189f55d6068ad57d2a6a4f3b30e613307035d560852c66aab60e3eaf1
{"gasLimit":2813307,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.530]
VERBOSE:
e2e:e2e_offchain_message Awaiting for linked libraries to be deployed
21:38:45 [21:38:45.571]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xfd7d054a49b8fc539d6a7fe87494f6c75de0f08f4e96fa5c444f08be83a371a6
{"gasLimit":10941267,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.577]
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}}
21:38:45 [21:38:45.577]
INFO:
e2e:e2e_offchain_message Waiting for 11 transactions to be mined...
21:38:45 [21:38:45.601]
INFO:
e2e:e2e_offchain_message All transactions mined successfully
21:38:45 [21:38:45.601]
VERBOSE:
e2e:e2e_offchain_message All core contracts have been deployed
21:38:45 [21:38:45.615]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x2c1dbe3447d26039dc9ec8a117f5ecf3418514eba04363a9f118599e3ac046b6
{"gasLimit":64317,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.615]
VERBOSE:
e2e:e2e_offchain_message Funding fee juice portal with 10000000000000000000000 fee juice in 0x2c1dbe3447d26039dc9ec8a117f5ecf3418514eba04363a9f118599e3ac046b6 (accelerated test deployments)
21:38:45 [21:38:45.627]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x1600c15aeb7a1b359375ba5cf2776b8e1012d977162e9d8d96719cd7624f6972
{"gasLimit":1040131,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.632]
VERBOSE:
e2e:e2e_offchain_message Deployed SlashFactory at 0x4ed7c70f96b99c776995fb64377f0d4ab3b0e1c1
21:38:45 [21:38:45.653]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0x88e756e24bbff758970408d0c377a6de3892502a3df5acd0bdeaa0f8200f71bf
{"gasLimit":116979,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.653]
VERBOSE:
e2e:e2e_offchain_message Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to registry 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 in tx 0x88e756e24bbff758970408d0c377a6de3892502a3df5acd0bdeaa0f8200f71bf
21:38:45 [21:38:45.670]
VERBOSE:
e2e:e2e_offchain_message Sent L1 transaction 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89
{"gasLimit":109478,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"}
21:38:45 [21:38:45.671]
VERBOSE:
e2e:e2e_offchain_message Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to GSE 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89
21:38:45 [21:38:45.675]
INFO:
e2e:e2e_offchain_message Waiting for 12 transactions to be mined...
21:38:45 [21:38:45.699]
INFO:
e2e:e2e_offchain_message All transactions mined successfully
21:38:45 [21:38:45.705]
VERBOSE:
e2e:e2e_offchain_message Rollup deployed
21:38:45 [21:38:45.705]
VERBOSE:
e2e:e2e_offchain_message Waiting for rollup and slash factory to be deployed
21:38:45 [21:38:45.705]
INFO:
e2e:e2e_offchain_message Waiting for 12 transactions to be mined...
21:38:45 [21:38:45.728]
INFO:
e2e:e2e_offchain_message All transactions mined successfully
21:38:45 [21:38:45.728]
VERBOSE:
e2e:e2e_offchain_message All transactions for L1 deployment have been mined
21:38:45 [21:38:45.747]
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"}
21:38:45 [21:38:45.748]
INFO:
e2e:e2e_offchain_message Handing over to governance
21:38:45 [21:38:45.753]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:43:33.000Z
{"offset":287248,"timeMs":1750196613000}
21:38:45 [21:38:45.759]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0xc6e7DF5E7b4f2A278906862b61205850344D4e7d
21:38:45 [21:38:45.760]
INFO:
telemetry:client Using NoopTelemetryClient
21:38:45 [21:38:45.766]
INFO:
kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/8e231589c33fc61b/blob-sink with map size 134217728 KB (LMDB v2)
21:38:45 [21:38:45.770]
INFO:
kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16
21:38:45 [21:38:45.775]
INFO:
blob-sink:server Server is running on
http://localhost:34951
21:38:45 [21:38:45.776]
VERBOSE:
e2e:e2e_offchain_message Creating and synching an aztec node...
21:38:45 [21:38:45.776]
VERBOSE:
e2e:e2e_offchain_message Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/6ce0a8d7/acvm
21:38:45 [21:38:45.777]
INFO:
node:blob-sink:client Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:34951"}
21:38:45 [21:38:45.795]
VERBOSE:
node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided.
21:38:45 [21:38:45.796]
INFO:
archiver:lmdb Creating archiver data store at directory /tmp/8e231589c33fc61b/archiver with map size 134217728 KB (LMDB v2)
21:38:45 [21:38:45.797]
INFO:
archiver:lmdb Starting data store with maxReaders 16
21:38:46 [21:38:46.096]
INFO:
node:blob-sink:client Testing configured blob sources
{"blobSinkUrl":"http://localhost:34951"}
21:38:46 [21:38:46.111]
INFO:
node:blob-sink:client Blob sink is reachable
{"blobSinkUrl":"http://localhost:34951"}
21:38:46 [21:38:46.111]
WARN:
node:blob-sink:client No L1 consensus host urls configured
21:38:46 [21:38:46.111]
WARN:
node:blob-sink:client No archive client configured
21:38:46 [21:38:46.114]
INFO:
archiver Starting archiver sync to rollup contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d from L1 block 22 to current L1 block 26 with hash 0x5fa61b68e97bcb979a2a8d8db876ed3ed7b3b51feda4f5f702e4591aaefcfae6
{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0xb1d12bf0e518c500524d2d374cc152254d59e7e33b11f75809d3c837f58aa353","l1BlockNumber":22}}
21:38:46 [21:38:46.127]
INFO:
archiver Initial archiver sync to L1 block 26 complete.
{"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
21:38:46 [21:38:46.133]
INFO:
world-state:database Creating world state data store at directory /tmp/8e231589c33fc61b/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
21:38:46 [21:38:46.154]
INFO:
world_state Created world state synchroniser with block history of 64
21:38:46 [21:38:46.154]
WARN:
node:MAIN-aztec-node Aztec node is accepting fake proofs
21:38:46 [21:38:46.164]
INFO:
p2p:lmdb-v2 Creating p2p data store at directory /tmp/8e231589c33fc61b/p2p with map size 134217728 KB (LMDB v2)
21:38:46 [21:38:46.165]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
21:38:46 [21:38:46.166]
INFO:
p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/8e231589c33fc61b/p2p-archive with map size 134217728 KB (LMDB v2)
21:38:46 [21:38:46.167]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
21:38:46 [21:38:46.168]
INFO:
p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/8e231589c33fc61b/p2p-peers with map size 134217728 KB (LMDB v2)
21:38:46 [21:38:46.169]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
21:38:46 [21:38:46.170]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
21:38:46 [21:38:46.171]
VERBOSE:
p2p P2P is disabled. Using dummy P2P service.
21:38:46 [21:38:46.173]
VERBOSE:
world-state:block_stream Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
21:38:46 [21:38:46.174]
INFO:
world_state Started world state synchronizer from block 1
21:38:46 [21:38:46.176]
VERBOSE:
world-state:block_stream Starting sync from block number 0
21:38:46 [21:38:46.178]
INFO:
p2p Starting p2p client from block 0 with empty mempools
21:38:46 [21:38:46.178]
VERBOSE:
p2p:l2-block-stream Starting L2 block stream
{"batchSize":20,"pollIntervalMS":100,"startingBlock":0}
21:38:46 [21:38:46.389]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
21:38:46 [21:38:46.422]
VERBOSE:
validator Initialized validator with addresses: 0x1b36205b4ccb2bbd47c17584531a8941c1ba8be7
21:38:46 [21:38:46.423]
VERBOSE:
node:MAIN-aztec-node All Aztec Node subsystems synced
21:38:46 [21:38:46.435]
INFO:
slasher Starting Slasher client...
21:38:46 [21:38:46.446]
VERBOSE:
p2p:l2-block-stream Starting sync from block number 0
21:38:46 [21:38:46.453]
INFO:
validator Started validator with addresses: 0x1b36205b4ccb2bbd47c17584531a8941c1ba8be7
21:38:46 [21:38:46.453]
VERBOSE:
validator Validators 0x1b36205b4ccb2bbd47c17584531a8941c1ba8be7 are not on the validator committee for epoch 0
21:38:46 [21:38:46.454]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/6ce0a8d7/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false}
21:38:46 [21:38:46.454]
VERBOSE:
sequencer Sequencer timetable updated
{"enforceTimeTable":false}
21:38:46 [21:38:46.456]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
21:38:46 [21:38:46.456]
VERBOSE:
node:MAIN-aztec-node Sequencer started
21:38:46 [21:38:46.457]
INFO:
node:MAIN-aztec-node Aztec Node version: 0.87.6
21:38:46 [21:38:46.457]
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"}
21:38:46 [21:38:46.458]
VERBOSE:
e2e:e2e_offchain_message Creating a pxe...
21:38:46 [21:38:46.462]
INFO:
pxe:data:lmdb Creating pxe_data data store at directory /tmp/5318097035644035/pxe_data with map size 134217728 KB (LMDB v2)
21:38:46 [21:38:46.471]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:46 [21:38:46.473]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1)
{"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:46 [21:38:46.473]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
21:38:46 [21:38:46.791]
VERBOSE:
pxe:service Registered protocol contracts in pxe
{"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"}
21:38:46 [21:38:46.791]
INFO:
pxe:service Started PXE connected to chain 31337 version 3476489198
21:38:46 [21:38:46.832]
INFO:
pxe:service Registered account 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7
21:38:46 [21:38:46.896]
WARN:
pxe:service No artifact found for contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 when looking for its metadata
21:38:46 [21:38:46.898]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 as part of deployment for 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7
21:38:47 [21:38:47.054]
INFO:
pxe:service Added contract SchnorrAccount at 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2
21:38:47 [21:38:47.068]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:47 [21:38:47.070]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1)
{"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:47 [21:38:47.096]
VERBOSE:
pxe:block_stream Starting sync from block number 0
21:38:47 [21:38:47.138]
VERBOSE:
simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"}
21:38:47 [21:38:47.264]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
21:38:48 [21:38:48.046]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2
21:38:48 [21:38:48.121]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
21:38:48 [21:38:48.266]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:48 [21:38:48.267]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1)
{"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:48 [21:38:48.357]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:constructor
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.393]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:48 [21:38:48.394]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.436]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.440]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:38:48 [21:38:48.626]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.660]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:48 [21:38:48.660]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.703]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:48 [21:38:48.705]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:38:48 [21:38:48.720]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:38:48 [21:38:48.804]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:48 [21:38:48.805]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1)
{"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:49 [21:38:49.501]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:49 [21:38:49.502]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1)
{"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:49 [21:38:49.875]
INFO:
pxe:service Proving completed in 2780.644528ms
{"timings":{"total":2780.644528,"sync":2.253443999999945,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":159.19360899999992,"oracles":{"callPrivateFunction":{"times":[1055.9593540000005,308.0808589999997,186.69548600000053]}}},{"functionName":"private_kernel_init","time":92.1285399999997},{"functionName":"ContractClassRegisterer:register","time":1027.7601749999994,"oracles":{"loadCapsule":{"times":[12.484560999999303]},"notifyCreatedNullifier":{"times":[0.47025899999971443]},"debugLog":{"times":[0.7213949999986653]},"notifyCreatedContractClassLog":{"times":[9.038914999999179]}}},{"functionName":"private_kernel_inner","time":124.19389899999987},{"functionName":"SchnorrAccount:constructor","time":278.89572600000065,"oracles":{"getContractInstance":{"times":[1.5281020000002172]},"debugLog":{"times":[0.46843599999920116,0.44044900000153575]},"fetchTaggedLogs":{"times":[44.60693800000081]},"loadCapsule":{"times":[0.36159500000030675,0.2310959999995248,0.25333599999976286]},"validateEnqueuedNotesAndEvents":{"times":[1.857612000001609]},"notifyCreatedNullifier":{"times":[0.24910199999976612,0.24945699999989301]},"notifyCreatedNote":{"times":[0.5174019999994925]},"getRandomField":{"times":[0.2183999999997468,0.1558050000003277,0.08714099999997416,0.08334000000104425,0.07219900000018242,0.07214099999873724,0.06710700000076031,0.07371599999896716,0.07477900000048976,0.11380199999985052,0.06277000000045518]},"getIndexedTaggingSecretAsSender":{"times":[43.054283000001305]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.60996999999952]}}},{"functionName":"private_kernel_inner","time":109.26221500000065},{"functionName":"SchnorrAccount:entrypoint","time":158.11150300000008,"oracles":{"debugLog":{"times":[0.4906460000001971,0.4032439999991766,0.5714480000006006]},"fetchTaggedLogs":{"times":[44.22153799999978]},"loadCapsule":{"times":[0.24731700000120327,0.19654300000001967,0.22199000000000524]},"validateEnqueuedNotesAndEvents":{"times":[1.181029999999737]},"getNotes":{"times":[1.4526690000002418]},"getAuthWitness":{"times":[0.3791909999999916]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.809917000000496]}}},{"functionName":"private_kernel_inner","time":108.94369499999993},{"functionName":"private_kernel_reset","time":182.80436999999984},{"functionName":"private_kernel_tail","time":70.72249399999964}],"unaccounted":466.37485800000013}}
21:38:49 [21:38:49.965]
VERBOSE:
p2p:tx_pool Adding tx 0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c to pool
{"eventName":"tx-added-to-pool","txHash":"0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"}
21:38:49 [21:38:49.985]
INFO:
node:MAIN-aztec-node Received tx 0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c
{"txHash":"0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c"}
21:38:49 [21:38:49.986]
INFO:
pxe:service Sent transaction 0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c
21:38:50 [21:38:50.012]
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":1750196601,"version":3476489198},"chainTipArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","blockNumber":1,"slot":1}
21:38:50 [21:38:50.023]
VERBOSE:
block-builder Building block 1 for slot 1
{"slot":1,"slotStart":"2025-06-17T21:43:21.000Z","now":"2025-06-17T21:43:37.271Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
21:38:50 [21:38:50.070]
VERBOSE:
simulator:public-processor Processed tx 0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c with no public calls in 22.45973000000049ms
{"txHash":"0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c","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.45973000000049}
21:38:50 [21:38:50.072]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.045916572000000086s
{"duration":0.045916572000000086,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
21:38:50 [21:38:50.094]
INFO:
sequencer Built block 1 for slot 1 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x19d276e70e58f4ecd6c628f0aa762918bc8823d709f9e9687bf523bb55c14f06","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750196601,"version":3476489198},"txHashes":["0x02288a0db487408dd847653b89f1f22619816c62fbe9c42815d02830e4a9810c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":77.66252499999973,"publicProcessDuration":46.664606000000276,"rollupCircuitsDuration":71.2761419999988,"txCount":1,"blockNumber":1,"blockTimestamp":1750196601,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:50 [21:38:50.097]
VERBOSE:
sequencer Attesting committee is empty
21:38:52 [21:38:52.807]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xf3f2d31ee5106663a0ba4562d3f6b766afb7dc499390bdc94ad75e3a490d4270
21:38:52 [21:38:52.808]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0xf3f2d31ee5106663a0ba4562d3f6b766afb7dc499390bdc94ad75e3a490d4270
{"gasLimit":472026,"maxFeePerGas":"500","maxPriorityFeePerGas":"500","maxFeePerBlobGas":"0.000000001"}
21:38:52 [21:38:52.821]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
21:38:52 [21:38:52.822]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf3f2d31ee5106663a0ba4562d3f6b766afb7dc499390bdc94ad75e3a490d4270","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":1,"blockTimestamp":1750196601,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:52 [21:38:52.822]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
21:38:52 [21:38:52.838]
INFO:
blob-sink:server Received blob sidecar for block 0xaa97b65f6e552f7ce4648765e3e16858975222a4af3414ab7f941b23b407cdd8
21:38:52 [21:38:52.843]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xaa97b65f6e552f7ce4648765e3e16858975222a4af3414ab7f941b23b407cdd8
21:38:52 [21:38:52.865]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750196637
21:38:52 [21:38:52.865]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:43:57.000Z
{"offset":304135,"timeMs":1750196637000}
21:38:52 [21:38:52.866]
INFO:
aztecjs:utils:watcher Slot 1 was filled, jumped to next slot
21:38:52 [21:38:52.949]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
21:38:52 [21:38:52.951]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
21:38:53 [21:38:53.104]
VERBOSE:
archiver:block-helper Store contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2
21:38:53 [21:38:53.118]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x19d276e70e58f4ecd6c628f0aa762918bc8823d709f9e9687bf523bb55c14f06","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750196601,"version":3476489198},"archiveRoot":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","archiveNextLeafIndex":2}
21:38:53 [21:38:53.124]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
21:38:53 [21:38:53.299]
WARN:
pxe:service No artifact found for contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 when looking for its metadata
21:38:53 [21:38:53.299]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18 as part of deployment for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11
21:38:53 [21:38:53.325]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":28.225789000000077,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750196601,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:53 [21:38:53.342]
VERBOSE:
p2p Synched to latest block 1
21:38:53 [21:38:53.493]
INFO:
pxe:service Added contract OffchainMessage at 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11 with class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18
21:38:53 [21:38:53.515]
VERBOSE:
pxe:service Updated pxe last block to 1
{"blockHash":{},"archive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","header":{"contentCommitment":{"blobsHash":"0x00868c76ce2fda4255eeed8417edc2f68ce68fe83a5415ec2d99441f02cd316a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750196601,"version":3476489198},"lastArchive":"0x12fdfc022ad9d9b9ac5c349c53042af82960d36edd5afb50e02139c32d9aac39","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2b187b4236f57f74314d29444a74b7cb6a1a28370e887dedfc4f07448fdc094d","nullifierTree":"0x2b2ff10650ad9180343c09f5b45e9f5f8cfc1bba3530ad1874558e3309cd6c11","publicDataTree":"0x1e617c6d2432acabfd6145b3bd346c6b6bffca30f4e5766d8dfa3f9496d0a1c9"},"totalFees":2101212240,"totalManaUsed":6324}}
21:38:53 [21:38:53.611]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:53 [21:38:53.644]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:53 [21:38:53.644]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:53 [21:38:53.714]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:53 [21:38:53.718]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:38:53 [21:38:53.729]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:38:53 [21:38:53.730]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:38:53 [21:38:53.735]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:38:53 [21:38:53.736]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:38:53 [21:38:53.740]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:38:53 [21:38:53.745]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:38:53 [21:38:53.758]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:38:53 [21:38:53.819]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
21:38:54 [21:38:54.383]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x2f592dbe7e087ce36f4eb433cf3894d708f912cd24736847661984e4cdbc9e1d,0x03e247bc05b2cb615b364b2859d5c43f51e70ed747edc4a6dab18dbb557c1b0c,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2
21:38:54 [21:38:54.455]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
21:38:54 [21:38:54.656]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
21:38:54 [21:38:54.669]
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":1750196637,"version":3476489198},"chainTipArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","blockNumber":2,"slot":2}
21:38:54 [21:38:54.671]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","blockNumber":2,"slot":2}
21:38:54 [21:38:54.724]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
21:38:54 [21:38:54.735]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11,0x0000000000000000000000000000000000000000000000000000000000000001,0x0c2eede9068a907eff12f1822d382236274167f79157cc16d3d70ffc93cb8c40,0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7
21:38:55 [21:38:55.231]
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":1750196637,"version":3476489198},"chainTipArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","blockNumber":2,"slot":2}
21:38:55 [21:38:55.365]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","blockNumber":2,"slot":2}
21:38:55 [21:38:55.824]
INFO:
pxe:service Proving completed in 2315.694788999999ms
{"timings":{"total":2315.694788999999,"sync":8.625812000000224,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":262.88744199999746,"oracles":{"debugLog":{"times":[0.5181490000013582,0.4141970000000583,0.44109299999945506,0.5992989999995189,0.40603099999862025,0.4105940000008559,0.40123099999982514,0.46029400000043097]},"fetchTaggedLogs":{"times":[71.53741300000002]},"loadCapsule":{"times":[0.2368449999994482,0.3909979999989446,0.46984900000097696,0.25698299999930896,0.23633499999959895,0.20137400000021444,0.22940399999970396]},"getSharedSecret":{"times":[3.23337999999967]},"aes128Decrypt":{"times":[0.9363420000008773,1.0855800000008458]},"getPublicKeysAndPartialAddress":{"times":[1.503897999999026]},"getKeyValidationRequest":{"times":[1.7325560000008409]},"storeCapsule":{"times":[2.06818899999962,0.35506600000007893,0.22023099999933038]},"deleteCapsule":{"times":[0.35558900000069116]},"validateEnqueuedNotesAndEvents":{"times":[5.478406000000177]},"getNotes":{"times":[1.424793000000136]},"getAuthWitness":{"times":[0.2462260000011156]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06034699999872828]},"callPrivateFunction":{"times":[803.787429,175.88784599999963]}}},{"functionName":"private_kernel_init","time":54.75927199999933},{"functionName":"ContractClassRegisterer:register","time":782.1675960000011,"oracles":{"loadCapsule":{"times":[4.367889999999534]},"notifyCreatedNullifier":{"times":[0.32083800000145857]},"debugLog":{"times":[0.46918100000038976]},"notifyCreatedContractClassLog":{"times":[8.370401000000129]}}},{"functionName":"private_kernel_inner","time":107.10676699999931},{"functionName":"ContractInstanceDeployer:deploy","time":108.79499900000337,"oracles":{"storeInExecutionCache":{"times":[0.17661899999984598]},"callPrivateFunction":{"times":[69.6434790000003]},"notifyCreatedNullifier":{"times":[0.25352100000054634]},"debugLog":{"times":[0.4900230000002921]}}},{"functionName":"private_kernel_inner","time":107.29935300000034},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":48.81312199999775,"oracles":{}},{"functionName":"private_kernel_inner","time":111.35722999999962},{"functionName":"private_kernel_reset","time":183.18363599999975},{"functionName":"private_kernel_tail","time":68.67417599999862}],"unaccounted":472.0253840000023}}
21:38:55 [21:38:55.916]
VERBOSE:
p2p:tx_pool Adding tx 0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c to pool
{"eventName":"tx-added-to-pool","txHash":"0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"}
21:38:55 [21:38:55.938]
INFO:
node:MAIN-aztec-node Received tx 0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c
{"txHash":"0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c"}
21:38:55 [21:38:55.939]
INFO:
pxe:service Sent transaction 0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c
21:38:55 [21:38:55.944]
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":1750196637,"version":3476489198},"chainTipArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","blockNumber":2,"slot":2}
21:38:55 [21:38:55.953]
VERBOSE:
block-builder Building block 2 for slot 2
{"slot":2,"slotStart":"2025-06-17T21:43:57.000Z","now":"2025-06-17T21:44:00.088Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
21:38:56 [21:38:56.003]
VERBOSE:
simulator:public-processor Processed tx 0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c with no public calls in 25.96308399999907ms
{"txHash":"0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c","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":25.96308399999907}
21:38:56 [21:38:56.004]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04920292999999947s
{"duration":0.04920292999999947,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14848,"l2Gas":5042},"totalSizeInBytes":1184}
21:38:56 [21:38:56.026]
INFO:
sequencer Built block 2 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2579fff14818077df6b769c7eacf4d80a188f0b367bd559100549b9a92d7b8d5","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750196637,"version":3476489198},"txHashes":["0x140b505b49b1dfa06459a779b2eab67b0803159f5ab89532f8c503d58e933b0c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":77.81641300000047,"publicProcessDuration":49.554276999999274,"rollupCircuitsDuration":73.16693099999975,"txCount":1,"blockNumber":2,"blockTimestamp":1750196637,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:56 [21:38:56.028]
VERBOSE:
sequencer Attesting committee is empty
21:38:56 [21:38:56.197]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xdd1fe26777bd77c49a591dc286fa5b9ac611365f564e75c8c7c58fe9326ee4d2
21:38:56 [21:38:56.197]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0xdd1fe26777bd77c49a591dc286fa5b9ac611365f564e75c8c7c58fe9326ee4d2
{"gasLimit":385645,"maxFeePerGas":"1.2576945","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
21:38:56 [21:38:56.208]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
21:38:56 [21:38:56.208]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdd1fe26777bd77c49a591dc286fa5b9ac611365f564e75c8c7c58fe9326ee4d2","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":2,"blockTimestamp":1750196637,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:56 [21:38:56.209]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
21:38:56 [21:38:56.213]
INFO:
blob-sink:server Received blob sidecar for block 0xbaea967f3f7ae3bf0ebd5d26e4e0d6bdcce0ee6938cd9b490c7f9c1b6107dad6
21:38:56 [21:38:56.217]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xbaea967f3f7ae3bf0ebd5d26e4e0d6bdcce0ee6938cd9b490c7f9c1b6107dad6
21:38:56 [21:38:56.253]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
21:38:56 [21:38:56.254]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:44:09.000Z
{"offset":312746,"timeMs":1750196649000}
21:38:56 [21:38:56.258]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
21:38:56 [21:38:56.259]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
21:38:56 [21:38:56.415]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750196673
21:38:56 [21:38:56.415]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:44:33.000Z
{"offset":336585,"timeMs":1750196673000}
21:38:56 [21:38:56.415]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
21:38:56 [21:38:56.562]
VERBOSE:
archiver:block-helper Store contract instance at 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11
21:38:56 [21:38:56.563]
VERBOSE:
archiver:block-helper Store contract class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18
21:38:56 [21:38:56.568]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2579fff14818077df6b769c7eacf4d80a188f0b367bd559100549b9a92d7b8d5","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750196637,"version":3476489198},"archiveRoot":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","archiveNextLeafIndex":3}
21:38:56 [21:38:56.572]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
21:38:56 [21:38:56.615]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":6.440313999999489,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750196637,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
21:38:56 [21:38:56.678]
VERBOSE:
p2p Synched to latest block 2
21:38:56 [21:38:56.728]
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":1750196673,"version":3476489198},"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:56 [21:38:56.730]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:56 [21:38:56.973]
INFO:
aztecjs:deploy_sent_tx Contract 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11 successfully deployed.
21:38:57 [21:38:57.173]
INFO:
pxe:service Added contract OffchainMessage at 0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a with class 0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18
21:38:57 [21:38:57.207]
VERBOSE:
pxe:service Updated pxe last block to 2
{"blockHash":{},"archive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","header":{"contentCommitment":{"blobsHash":"0x006c0cc160eb54bbe4d2d41438b949e027dd383e66a727014d5fd2930fbbc601","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750196637,"version":3476489198},"lastArchive":"0x10a761175556593aa3b42703a1c864b656c8913984766c69b87ed6a464f0a3df","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2b187b4236f57f74314d29444a74b7cb6a1a28370e887dedfc4f07448fdc094d","nullifierTree":"0x28b4cde9c8eaddc31faaa3c540789c0a8f27db73ff498e86e7a0a468d7cfa58d","publicDataTree":"0x240b9ac4aeb35c83a98f80a6afa988d2580d5bca1ab2b8ae9607785e12fc5892"},"totalFees":1675254920,"totalManaUsed":5042}}
21:38:57 [21:38:57.306]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:57 [21:38:57.339]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:57 [21:38:57.339]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:57 [21:38:57.389]
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":1750196673,"version":3476489198},"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:57 [21:38:57.391]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:57 [21:38:57.413]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:57 [21:38:57.420]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:38:57 [21:38:57.431]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:38:57 [21:38:57.432]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:38:57 [21:38:57.439]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:38:57 [21:38:57.440]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:38:57 [21:38:57.518]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:38:57 [21:38:57.522]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:38:57 [21:38:57.534]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:38:57 [21:38:57.588]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
21:38:57 [21:38:57.648]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
21:38:57 [21:38:57.659]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a,0x0000000000000000000000000000000000000000000000000000000000000001,0x1a3b808ce194643c0c03adc66090d4a5b0eeccf727add608983a25255e7462b9,0x1ca6efcb0e2515b1a4dc228269f2c31590c7036f86d7210894beb191985e8b18,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7
21:38:58 [21:38:58.048]
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":1750196673,"version":3476489198},"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:58 [21:38:58.127]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:58 [21:38:58.505]
INFO:
pxe:service Proving completed in 1309.1378509999995ms
{"timings":{"total":1309.1378509999995,"sync":12.686785999998392,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":328.06541899999866,"oracles":{"debugLog":{"times":[0.4734580000003916,0.4295940000010887,0.4813750000030268,0.6087470000020403,0.4650279999987106,0.43902999999772874,0.42495400000188965,0.4750930000009248]},"fetchTaggedLogs":{"times":[78.8591520000009]},"loadCapsule":{"times":[0.38570400000025984,0.20041499999933876,0.5435900000011316,0.49144299999898067,68.71097400000144,1.7256669999987935,0.29656600000089384]},"getSharedSecret":{"times":[3.9876949999998033]},"aes128Decrypt":{"times":[0.27653099999952246,1.5173290000020643]},"getPublicKeysAndPartialAddress":{"times":[2.2154870000013034]},"getKeyValidationRequest":{"times":[2.4147110000012617]},"storeCapsule":{"times":[0.5627150000000256,0.31685300000026473,3.32274299999699]},"deleteCapsule":{"times":[1.513014000000112]},"validateEnqueuedNotesAndEvents":{"times":[4.061954000000696]},"getNotes":{"times":[1.2319050000005518]},"getAuthWitness":{"times":[0.2291479999985313]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05988699999943492]},"callPrivateFunction":{"times":[128.98410199999853]}}},{"functionName":"private_kernel_init","time":55.313812000000325},{"functionName":"ContractInstanceDeployer:deploy","time":64.09201200000098,"oracles":{"storeInExecutionCache":{"times":[0.09910499999750755]},"callPrivateFunction":{"times":[61.99640599999839]},"notifyCreatedNullifier":{"times":[0.27633500000229105]},"debugLog":{"times":[0.486350000002858]}}},{"functionName":"private_kernel_inner","time":107.31064999999944},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.76394900000014,"oracles":{}},{"functionName":"private_kernel_inner","time":111.08031299999857},{"functionName":"private_kernel_reset","time":184.38636199999746},{"functionName":"private_kernel_tail","time":68.58261399999901}],"unaccounted":334.8559340000065}}
21:38:58 [21:38:58.542]
VERBOSE:
p2p:tx_pool Adding tx 0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f to pool
{"eventName":"tx-added-to-pool","txHash":"0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"}
21:38:58 [21:38:58.547]
INFO:
node:MAIN-aztec-node Received tx 0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f
{"txHash":"0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f"}
21:38:58 [21:38:58.548]
INFO:
pxe:service Sent transaction 0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f
21:38:58 [21:38:58.645]
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":1750196673,"version":3476489198},"chainTipArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","blockNumber":3,"slot":3}
21:38:58 [21:38:58.654]
VERBOSE:
block-builder Building block 3 for slot 3
{"slot":3,"slotStart":"2025-06-17T21:44:33.000Z","now":"2025-06-17T21:44:35.239Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
21:38:58 [21:38:58.676]
VERBOSE:
simulator:public-processor Processed tx 0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f with no public calls in 14.517745999997715ms
{"txHash":"0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f","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.517745999997715}
21:38:58 [21:38:58.678]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.022034160999999584s
{"duration":0.022034160999999584,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":3532},"totalSizeInBytes":832}
21:38:58 [21:38:58.697]
INFO:
sequencer Built block 3 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x130230d3d12fe97dade50b951ea660c4ed39e5b79f261c32ec44d30067490f41","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750196673,"version":3476489198},"txHashes":["0x196cae541b2feb6e717f7c3275a317c200fce99162171b8294184c17074f210f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.4384859999991,"publicProcessDuration":22.433203999997204,"rollupCircuitsDuration":43.556876999999076,"txCount":1,"blockNumber":3,"blockTimestamp":1750196673,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:38:58 [21:38:58.699]
VERBOSE:
sequencer Attesting committee is empty
21:38:58 [21:38:58.865]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xe17d67892952f2db39555844677c073a5d3d0a52e958df608b432f29d9df397b
21:38:58 [21:38:58.865]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0xe17d67892952f2db39555844677c073a5d3d0a52e958df608b432f29d9df397b
{"gasLimit":385659,"maxFeePerGas":"1.244281926","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
21:38:58 [21:38:58.874]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
21:38:58 [21:38:58.875]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe17d67892952f2db39555844677c073a5d3d0a52e958df608b432f29d9df397b","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":3,"blockTimestamp":1750196673,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:38:58 [21:38:58.875]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
21:38:58 [21:38:58.878]
INFO:
blob-sink:server Received blob sidecar for block 0xec1029cc5a795626806d36b1add3145198596626f6ba3979044dbf23b905c1bb
21:38:58 [21:38:58.882]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xec1029cc5a795626806d36b1add3145198596626f6ba3979044dbf23b905c1bb
21:38:58 [21:38:58.940]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
21:38:58 [21:38:58.940]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:44:45.000Z
{"offset":346060,"timeMs":1750196685000}
21:38:58 [21:38:58.943]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
21:38:58 [21:38:58.945]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
21:38:58 [21:38:58.973]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750196709
21:38:58 [21:38:58.973]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:45:09.000Z
{"offset":370027,"timeMs":1750196709000}
21:38:58 [21:38:58.973]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
21:38:59 [21:38:59.116]
VERBOSE:
archiver:block-helper Store contract instance at 0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a
21:38:59 [21:38:59.117]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x130230d3d12fe97dade50b951ea660c4ed39e5b79f261c32ec44d30067490f41","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750196673,"version":3476489198},"archiveRoot":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","archiveNextLeafIndex":4}
21:38:59 [21:38:59.119]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
21:38:59 [21:38:59.187]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":6.013192999998864,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750196673,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:38:59 [21:38:59.222]
VERBOSE:
p2p Synched to latest block 3
21:38:59 [21:38:59.399]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:38:59 [21:38:59.399]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:38:59 [21:38:59.585]
INFO:
aztecjs:deploy_sent_tx Contract 0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a successfully deployed.
21:38:59 [21:38:59.587]
INFO:
e2e:e2e_offchain_message Running test: e2e_offchain_message should emit offchain message
21:38:59 [21:38:59.614]
VERBOSE:
pxe:service Updated pxe last block to 3
{"blockHash":{},"archive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","header":{"contentCommitment":{"blobsHash":"0x001810c1b534ac3305d6db5b8105b5fffc1bd891649a517cd92b40181c061775","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750196673,"version":3476489198},"lastArchive":"0x078d97771bc833ddd1ddd8cbc9c0ac52482454ec2d96c6e51949c231394cdfea","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2b187b4236f57f74314d29444a74b7cb6a1a28370e887dedfc4f07448fdc094d","nullifierTree":"0x124a86f0b0c6bbaedbc701c4145d2bc64849794b4acd86d495bc1a1a87b9ea77","publicDataTree":"0x15f806de3d7602ad5e673ab4fc2773b5cf8a885d7267a6aa970af57783eaa7ad"},"totalFees":1173542320,"totalManaUsed":3532}}
21:38:59 [21:38:59.697]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:59 [21:38:59.730]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:59 [21:38:59.730]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:59 [21:38:59.782]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:38:59 [21:38:59.786]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:38:59 [21:38:59.797]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:38:59 [21:38:59.798]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:38:59 [21:38:59.803]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:38:59 [21:38:59.803]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:38:59 [21:38:59.806]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:38:59 [21:38:59.809]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:38:59 [21:38:59.827]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:38:59 [21:38:59.912]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:38:59 [21:38:59.945]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:38:59 [21:38:59.945]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:38:59 [21:38:59.989]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:38:59 [21:38:59.990]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:38:59 [21:38:59.998]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:00 [21:39:00.001]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:00 [21:39:00.095]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient
{"contract":"0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a"}
21:39:00 [21:39:00.128]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:00 [21:39:00.128]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a"}
21:39:00 [21:39:00.170]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1466bb95a75e85fb297a86ddc96b3ce29c048527f0f72b6680215cc8a07c744a"}
21:39:00 [21:39:00.173]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:00 [21:39:00.270]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:00 [21:39:00.302]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:00 [21:39:00.303]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:00 [21:39:00.355]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:00 [21:39:00.359]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:00 [21:39:00.597]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:00 [21:39:00.635]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:01 [21:39:01.491]
INFO:
pxe:service Proving completed in 1888.236251000002ms
{"timings":{"total":1888.236251000002,"sync":12.813089999999647,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":225.56376900000396,"oracles":{"debugLog":{"times":[0.4758940000028815,0.425995999998122,0.40427099999942584,0.528135000000475,0.40080700000180514,0.3713099999986298,0.3646569999982603,0.45373599999948055]},"fetchTaggedLogs":{"times":[53.505301000001054]},"loadCapsule":{"times":[0.18888499999957276,0.1723759999986214,0.36724300000059884,0.23207099999854108,0.1566880000027595,0.2077389999976731,0.19269799999892712]},"getSharedSecret":{"times":[4.790112000002409]},"aes128Decrypt":{"times":[0.23998000000210595,1.0083989999984624]},"getPublicKeysAndPartialAddress":{"times":[1.21391500000027]},"getKeyValidationRequest":{"times":[1.2676549999996496]},"storeCapsule":{"times":[0.30512300000191317,0.2450120000030438,0.3610439999974915]},"deleteCapsule":{"times":[0.21180499999900348]},"validateEnqueuedNotesAndEvents":{"times":[3.836382000001322]},"getNotes":{"times":[6.741557000001194]},"getAuthWitness":{"times":[0.25116999999954714]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06750000000101863]},"callPrivateFunction":{"times":[570.0060460000022]}}},{"functionName":"private_kernel_init","time":54.06784399999742},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":193.18805799999973,"oracles":{"debugLog":{"times":[0.4569869999977527,0.4158540000025823]},"fetchTaggedLogs":{"times":[55.16667199999938]},"loadCapsule":{"times":[0.26639799999975367,0.17031700000006822,0.19598799999948824]},"validateEnqueuedNotesAndEvents":{"times":[1.0287390000012238]},"emitOffchainMessage":{"times":[0.15863199999876088]},"storeInExecutionCache":{"times":[0.12428999999974621]},"callPrivateFunction":{"times":[376.0257959999981]}}},{"functionName":"private_kernel_inner","time":106.480223999999},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":179.46338900000046,"oracles":{"debugLog":{"times":[0.45085699999981443,0.38677300000199466]},"fetchTaggedLogs":{"times":[43.639273000000685]},"loadCapsule":{"times":[0.19220100000165985,0.20466400000077556,0.22250899999926332]},"validateEnqueuedNotesAndEvents":{"times":[1.048717999998189]},"emitOffchainMessage":{"times":[0.06960999999864725]},"storeInExecutionCache":{"times":[0.145436000002519]},"callPrivateFunction":{"times":[194.91212000000087]}}},{"functionName":"private_kernel_inner","time":107.24803500000053},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":164.44826000000103,"oracles":{"debugLog":{"times":[0.48231699999814737,0.3715120000015304]},"fetchTaggedLogs":{"times":[54.94520399999965]},"loadCapsule":{"times":[0.20271599999978207,0.17568799999935436,0.19038000000000466]},"validateEnqueuedNotesAndEvents":{"times":[1.2919350000011036]},"emitOffchainMessage":{"times":[0.07967199999984587]}}},{"functionName":"private_kernel_inner","time":106.33755499999825},{"functionName":"private_kernel_reset","time":180.93641200000275},{"functionName":"private_kernel_tail","time":68.9319370000012}],"unaccounted":488.7576779999981}}
21:39:01 [21:39:01.499]
INFO:
e2e:e2e_offchain_message Running test: e2e_offchain_message should not emit any offchain messages
21:39:01 [21:39:01.528]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:01 [21:39:01.530]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:01 [21:39:01.607]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:01 [21:39:01.639]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:01 [21:39:01.640]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:01 [21:39:01.689]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:01 [21:39:01.693]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:39:01 [21:39:01.702]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:39:01 [21:39:01.703]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:39:01 [21:39:01.709]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:39:01 [21:39:01.710]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:39:01 [21:39:01.712]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:01 [21:39:01.718]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:39:01 [21:39:01.730]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:39:01 [21:39:01.819]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_offchain_message_for_recipient
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:01 [21:39:01.852]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:01 [21:39:01.852]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:01 [21:39:01.889]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:01 [21:39:01.892]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:02 [21:39:02.180]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:02 [21:39:02.294]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:02 [21:39:02.547]
INFO:
pxe:service Proving completed in 1032.8959539999996ms
{"timings":{"total":1032.8959539999996,"sync":15.644501999999193,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":214.38150199999654,"oracles":{"debugLog":{"times":[0.4706850000002305,0.38429399999949965,0.3962680000004184,0.5450350000028266,0.4050490000008722,0.405720000002475,0.34043300000121235,0.43913400000019465]},"fetchTaggedLogs":{"times":[51.572525999999925]},"loadCapsule":{"times":[0.1686730000001262,0.1849289999991015,0.3735759999981383,0.26548799999727635,0.1677029999991646,0.15117500000269501,0.20573700000022654]},"getSharedSecret":{"times":[2.473115000000689]},"aes128Decrypt":{"times":[0.23471300000164774,0.9750050000002375]},"getPublicKeysAndPartialAddress":{"times":[2.79160100000081]},"getKeyValidationRequest":{"times":[1.260270999999193]},"storeCapsule":{"times":[0.35674899999867193,0.22720699999990757,0.20069599999987986]},"deleteCapsule":{"times":[0.18860200000199256]},"validateEnqueuedNotesAndEvents":{"times":[6.784025000000838]},"getNotes":{"times":[1.1765840000007302]},"getAuthWitness":{"times":[0.24137899999914225]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06156800000098883]},"callPrivateFunction":{"times":[177.62143800000194]}}},{"functionName":"private_kernel_init","time":54.39063200000237},{"functionName":"OffchainMessage:emit_offchain_message_for_recipient","time":147.56343900000138,"oracles":{"debugLog":{"times":[0.44208200000139186,0.38235899999926914]},"fetchTaggedLogs":{"times":[38.14832599999863]},"loadCapsule":{"times":[0.18001400000139256,0.1530400000010559,0.20443199999863282]},"validateEnqueuedNotesAndEvents":{"times":[1.0732219999990775]}}},{"functionName":"private_kernel_inner","time":106.01145899999756},{"functionName":"private_kernel_reset","time":185.16465199999948},{"functionName":"private_kernel_tail","time":71.60775000000285}],"unaccounted":238.13201800000024}}
21:39:02 [21:39:02.548]
INFO:
e2e:e2e_offchain_message Running test: e2e_offchain_message should revert when emitting offchain message from utility function
21:39:02 [21:39:02.654]
VERBOSE:
simulator Executing utility function emitting_offchain_message_from_utility_reverts
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","selector":"0xaa12a861"}
21:39:02 [21:39:02.664]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
21:39:02 [21:39:02.665]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:02 [21:39:02.701]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:02 [21:39:02.704]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:02 [21:39:02.712]
INFO:
e2e:e2e_offchain_message Running test: e2e_offchain_message should emit event as offchain message and process it
21:39:02 [21:39:02.802]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:02 [21:39:02.834]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:02 [21:39:02.835]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:02 [21:39:02.883]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:02 [21:39:02.886]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:02 [21:39:02.894]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:02 [21:39:02.898]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:39:02 [21:39:02.908]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:39:02 [21:39:02.909]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:39:02 [21:39:02.914]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:39:02 [21:39:02.915]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:39:02 [21:39:02.917]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:02 [21:39:02.921]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:39:02 [21:39:02.933]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:39:03 [21:39:03.019]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_event_as_offchain_message_for_msg_sender
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:03 [21:39:03.035]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:03 [21:39:03.035]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:03 [21:39:03.079]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:03 [21:39:03.087]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:03 [21:39:03.723]
INFO:
pxe:service Proving completed in 1004.4826519999988ms
{"timings":{"total":1004.4826519999988,"sync":2.67818299999999,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":222.4271349999981,"oracles":{"debugLog":{"times":[0.49294799999915995,0.4171100000021397,0.45450200000050245,0.5517060000020138,0.4127919999991718,0.4017889999995532,0.3798719999977038,0.45836299999791663]},"fetchTaggedLogs":{"times":[61.772807999997895]},"loadCapsule":{"times":[0.20583999999871594,0.16375500000140164,0.3635199999989709,0.2098839999998745,0.17045599999983096,0.19194400000196765,0.20486199999868404]},"getSharedSecret":{"times":[2.737648000002082]},"aes128Decrypt":{"times":[0.41318600000158767,1.2097550000034971]},"getPublicKeysAndPartialAddress":{"times":[1.2537450000017998]},"getKeyValidationRequest":{"times":[1.3122499999990396]},"storeCapsule":{"times":[0.2661049999987881,0.22548599999936414,0.2770329999984824]},"deleteCapsule":{"times":[0.21558899999945424]},"validateEnqueuedNotesAndEvents":{"times":[3.949205000000802]},"getNotes":{"times":[1.0987669999994978]},"getAuthWitness":{"times":[0.2352339999997639]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06688700000086101]},"callPrivateFunction":{"times":[164.6147459999993]}}},{"functionName":"private_kernel_init","time":53.89820400000099},{"functionName":"OffchainMessage:emit_event_as_offchain_message_for_msg_sender","time":134.0530910000016,"oracles":{"debugLog":{"times":[0.4456790000003821,0.3832060000022466]},"fetchTaggedLogs":{"times":[50.90889700000116]},"loadCapsule":{"times":[0.17997900000045775,0.172511000000668,0.22285399999964284]},"validateEnqueuedNotesAndEvents":{"times":[1.0769880000007106]},"getRandomField":{"times":[0.09736999999950058,0.06874299999981304,0.08832900000197696,0.06369599999743514,0.042179999996733386,0.0381070000003092,0.032995999998092884,0.03657999999995809,0.033989999999903375,0.04651899999953457,0.039968999997654464,0.034646000000066124]},"notifyCreatedNullifier":{"times":[0.2625880000014149]},"emitOffchainMessage":{"times":[0.07465800000136369]}}},{"functionName":"private_kernel_inner","time":105.9565569999977},{"functionName":"private_kernel_reset","time":180.9053700000004},{"functionName":"private_kernel_tail","time":69.05058199999985}],"unaccounted":235.51353000000017}}
21:39:03 [21:39:03.765]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:03 [21:39:03.766]
VERBOSE:
p2p:tx_pool Adding tx 0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd to pool
{"eventName":"tx-added-to-pool","txHash":"0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"}
21:39:03 [21:39:03.770]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:03 [21:39:03.770]
INFO:
node:MAIN-aztec-node Received tx 0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd
{"txHash":"0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd"}
21:39:03 [21:39:03.771]
INFO:
pxe:service Sent transaction 0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd
21:39:04 [21:39:04.283]
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":1750196709,"version":3476489198},"chainTipArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","blockNumber":4,"slot":4}
21:39:04 [21:39:04.292]
VERBOSE:
block-builder Building block 4 for slot 4
{"slot":4,"slotStart":"2025-06-17T21:45:09.000Z","now":"2025-06-17T21:45:14.319Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
21:39:04 [21:39:04.313]
VERBOSE:
simulator:public-processor Processed tx 0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd with no public calls in 13.527827000001707ms
{"txHash":"0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd","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.527827000001707}
21:39:04 [21:39:04.314]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020637056000003214s
{"duration":0.020637056000003214,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3532},"totalSizeInBytes":288}
21:39:04 [21:39:04.333]
INFO:
sequencer Built block 4 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2556e2097ef8e414ba88352942d37e567939b753603949cd9bb9dc7711f33479","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750196709,"version":3476489198},"txHashes":["0x0ee8096bc524cde2385241e43073e4923f63e97941c963cee8966a773308fcdd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.13247000000047,"publicProcessDuration":20.96443399999771,"rollupCircuitsDuration":41.45068199999878,"txCount":1,"blockNumber":4,"blockTimestamp":1750196709,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:04 [21:39:04.335]
VERBOSE:
sequencer Attesting committee is empty
21:39:04 [21:39:04.507]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xf791e36f57f128125561467976d0ccc035e04deebecbcf593261dd1bcea032df
21:39:04 [21:39:04.508]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0xf791e36f57f128125561467976d0ccc035e04deebecbcf593261dd1bcea032df
{"gasLimit":385659,"maxFeePerGas":"1.233987456","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
21:39:04 [21:39:04.516]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
21:39:04 [21:39:04.517]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf791e36f57f128125561467976d0ccc035e04deebecbcf593261dd1bcea032df","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":4,"blockTimestamp":1750196709,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:04 [21:39:04.517]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
21:39:04 [21:39:04.521]
INFO:
blob-sink:server Received blob sidecar for block 0xcc6943f651c60937b2e3256c04af0a5a8d003cdb5021598307d09d140a91a591
21:39:04 [21:39:04.524]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xcc6943f651c60937b2e3256c04af0a5a8d003cdb5021598307d09d140a91a591
21:39:04 [21:39:04.561]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
21:39:04 [21:39:04.561]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:45:21.000Z
{"offset":376439,"timeMs":1750196721000}
21:39:04 [21:39:04.562]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
21:39:04 [21:39:04.563]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
21:39:04 [21:39:04.601]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750196745
21:39:04 [21:39:04.601]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:45:45.000Z
{"offset":400399,"timeMs":1750196745000}
21:39:04 [21:39:04.601]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
21:39:05 [21:39:05.071]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x2556e2097ef8e414ba88352942d37e567939b753603949cd9bb9dc7711f33479","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750196709,"version":3476489198},"archiveRoot":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","archiveNextLeafIndex":5}
21:39:05 [21:39:05.072]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
21:39:05 [21:39:05.126]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":5.727343999998993,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750196709,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:05 [21:39:05.137]
VERBOSE:
p2p Synched to latest block 4
21:39:05 [21:39:05.541]
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":1750196745,"version":3476489198},"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:05 [21:39:05.542]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:05 [21:39:05.781]
VERBOSE:
pxe:service Updated pxe last block to 4
{"blockHash":{},"archive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","header":{"contentCommitment":{"blobsHash":"0x00a33acde8f13a07bff59afd00a88fbee50f39b32349acaf632cf7637e4723c5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750196709,"version":3476489198},"lastArchive":"0x2ad5152617bf4eff3a42998768c90c116378478e0977b3b67752afc238b89a11","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2b187b4236f57f74314d29444a74b7cb6a1a28370e887dedfc4f07448fdc094d","nullifierTree":"0x0d8e56e75febd735e7d092505ba684c81b303976a3b93e5ae7985ef3b36848fe","publicDataTree":"0x1043b7aedd8c0a8c06e3fdede2b6b48ae9ba02ee4c44ceddc986f5f0fc46686d"},"totalFees":1173542320,"totalManaUsed":3532}}
21:39:05 [21:39:05.865]
VERBOSE:
simulator Executing utility function process_message
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","selector":"0x988dd306"}
21:39:05 [21:39:05.876]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
21:39:05 [21:39:05.876]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:05 [21:39:05.916]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:05 [21:39:05.918]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:05 [21:39:05.929]
VERBOSE:
simulator:client_view_context:debug_log Processing private event msg
21:39:05 [21:39:05.933]
VERBOSE:
simulator Utility simulation for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11.0x988dd306 completed
21:39:05 [21:39:05.933]
VERBOSE:
pxe:service Getting private events for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11 from 4 to 5
21:39:06 [21:39:06.022]
VERBOSE:
simulator Executing utility function sync_private_state
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","selector":"0xc6cedc33"}
21:39:06 [21:39:06.031]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
21:39:06 [21:39:06.031]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:06 [21:39:06.077]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:06 [21:39:06.078]
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":1750196745,"version":3476489198},"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:06 [21:39:06.079]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:06 [21:39:06.081]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:06 [21:39:06.084]
VERBOSE:
private_event_data_provider storing private event log
{"contractAddress":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","recipient":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","msgContent":["0x0000000000000000000000000000000000000000000000000000000000000001","0x0000000000000000000000000000000000000000000000000000000000000002","0x0000000000000000000000000000000000000000000000000000000000000003"],"blockNumber":4}
21:39:06 [21:39:06.086]
VERBOSE:
simulator Utility simulation for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11.0xc6cedc33 completed
21:39:06 [21:39:06.088]
INFO:
e2e:e2e_offchain_message Running test: e2e_offchain_message should emit note as offchain message and process it
21:39:06 [21:39:06.198]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:06 [21:39:06.231]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:06 [21:39:06.231]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:06 [21:39:06.272]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7"}
21:39:06 [21:39:06.277]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x270fcd4ab2e5fb1770430eaa397d52bdb33c3452aba93d22b259129113e7379b
21:39:06 [21:39:06.286]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
21:39:06 [21:39:06.287]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
21:39:06 [21:39:06.292]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:39:06 [21:39:06.293]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:39:06 [21:39:06.295]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:06 [21:39:06.298]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x113674e277dc36f008c7837d6c34b9f3bce619339603a8c7e336aabe6554c3ff","nullifier":"0x1d2a81a6f329a941668b132a38578ec090604ebb6164acb1fd1a20e2d4abb91d"}
21:39:06 [21:39:06.309]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x22d62b610d0f927568bc3dc20a1cb44e292219c0ef82621ae81a94fd122cdea7 as fee payer
21:39:06 [21:39:06.398]
VERBOSE:
simulator:private_execution Executing private function OffchainMessage:emit_note_as_offchain_message
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:06 [21:39:06.414]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
21:39:06 [21:39:06.415]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:06 [21:39:06.459]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:06 [21:39:06.461]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:06 [21:39:06.662]
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":1750196745,"version":3476489198},"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:06 [21:39:06.720]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:07 [21:39:07.174]
INFO:
pxe:service Proving completed in 1067.020164999998ms
{"timings":{"total":1067.020164999998,"sync":7.299756000000343,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":207.7095679999984,"oracles":{"debugLog":{"times":[0.4419110000017099,0.3941369999993185,0.4335989999999583,0.5342960000016319,0.39828699999998207,0.3743919999978971,0.3093680000019958,0.4448899999988498]},"fetchTaggedLogs":{"times":[44.44052300000112]},"loadCapsule":{"times":[0.1741379999984929,0.1583390000014333,0.3726879999994708,0.1937870000001567,0.1747670000004291,0.17023599999811267,0.16962099999727798]},"getSharedSecret":{"times":[2.6249540000026172]},"aes128Decrypt":{"times":[0.2341310000010708,0.9737680000034743]},"getPublicKeysAndPartialAddress":{"times":[1.2608050000017101]},"getKeyValidationRequest":{"times":[1.2492079999974521]},"storeCapsule":{"times":[0.29822499999863794,0.2247429999988526,0.19658499999786727]},"deleteCapsule":{"times":[0.21549600000071223]},"validateEnqueuedNotesAndEvents":{"times":[3.30119299999933]},"getNotes":{"times":[0.9829900000004272]},"getAuthWitness":{"times":[0.23087300000042887]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0790290000004461]},"callPrivateFunction":{"times":[226.98251900000105]}}},{"functionName":"private_kernel_init","time":55.10072299999956},{"functionName":"OffchainMessage:emit_note_as_offchain_message","time":195.31107200000042,"oracles":{"debugLog":{"times":[0.4474100000006729,0.36455299999943236]},"fetchTaggedLogs":{"times":[45.640088000000105]},"loadCapsule":{"times":[0.18623899999874993,0.1597409999994852,0.20890000000144937]},"validateEnqueuedNotesAndEvents":{"times":[1.025551999999152]},"getRandomField":{"times":[0.08548599999994622,0.08477100000163773,0.07668100000228151,0.056522999999288004,0.04068800000095507,0.03547400000024936,0.032547999999223975,0.03146000000197091,0.03117500000007567,0.0309209999977611,0.03184699999837903,0.037634000000252854]},"notifyCreatedNote":{"times":[0.13559600000007777]},"getIndexedTaggingSecretAsSender":{"times":[34.318403000001126]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.308916000001773]},"emitOffchainMessage":{"times":[0.1461170000002312]}}},{"functionName":"private_kernel_inner","time":105.12356599999839},{"functionName":"private_kernel_reset","time":183.39498200000162},{"functionName":"private_kernel_tail","time":68.85001700000066}],"unaccounted":244.2304809999987}}
21:39:07 [21:39:07.204]
VERBOSE:
p2p:tx_pool Adding tx 0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd to pool
{"eventName":"tx-added-to-pool","txHash":"0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd","noteHashCount":1,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"}
21:39:07 [21:39:07.208]
INFO:
node:MAIN-aztec-node Received tx 0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd
{"txHash":"0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd"}
21:39:07 [21:39:07.208]
INFO:
pxe:service Sent transaction 0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd
21:39:07 [21:39:07.231]
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":1750196745,"version":3476489198},"chainTipArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","blockNumber":5,"slot":5}
21:39:07 [21:39:07.239]
VERBOSE:
block-builder Building block 5 for slot 5
{"slot":5,"slotStart":"2025-06-17T21:45:45.000Z","now":"2025-06-17T21:45:47.638Z","blockNumber":5,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
21:39:07 [21:39:07.260]
VERBOSE:
simulator:public-processor Processed tx 0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd with no public calls in 13.511994000000414ms
{"txHash":"0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd","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.511994000000414}
21:39:07 [21:39:07.261]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02026036799999929s
{"duration":0.02026036799999929,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":3304},"totalSizeInBytes":320}
21:39:07 [21:39:07.279]
INFO:
sequencer Built block 5 for slot 5 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0d9144d07b6c4916e2621c32ac2144967e599b3b0a89346c87fa2dd86f193a6a","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750196745,"version":3476489198},"txHashes":["0x1c9953afb54bfaaecaef6446e081c715bcbd2360882596d4e97813a21592f4dd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":44.36376999999993,"publicProcessDuration":20.885114999997313,"rollupCircuitsDuration":39.752167999999074,"txCount":1,"blockNumber":5,"blockTimestamp":1750196745,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:07 [21:39:07.280]
VERBOSE:
sequencer Attesting committee is empty
21:39:07 [21:39:07.437]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x2db1e3425c4ba521a1904d8558d764073f40e49d8456f7b54c742a6cf8262ef6
21:39:07 [21:39:07.437]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0x2db1e3425c4ba521a1904d8558d764073f40e49d8456f7b54c742a6cf8262ef6
{"gasLimit":385686,"maxFeePerGas":"1.226086201","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
21:39:07 [21:39:07.451]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
21:39:07 [21:39:07.451]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x2db1e3425c4ba521a1904d8558d764073f40e49d8456f7b54c742a6cf8262ef6","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":5,"blockTimestamp":1750196745,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:07 [21:39:07.451]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
21:39:07 [21:39:07.453]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750196781
21:39:07 [21:39:07.453]
WARN:
foundation:test-date-provider Time set to 2025-06-17T21:46:21.000Z
{"offset":433547,"timeMs":1750196781000}
21:39:07 [21:39:07.454]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
21:39:07 [21:39:07.455]
INFO:
blob-sink:server Received blob sidecar for block 0xbe677e44d141fdcb4bca45003a7a64def0f996eff5f6e933627f3d6a0181389e
21:39:07 [21:39:07.458]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xbe677e44d141fdcb4bca45003a7a64def0f996eff5f6e933627f3d6a0181389e
21:39:07 [21:39:07.638]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
21:39:07 [21:39:07.640]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
21:39:07 [21:39:07.990]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x0d9144d07b6c4916e2621c32ac2144967e599b3b0a89346c87fa2dd86f193a6a","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750196745,"version":3476489198},"archiveRoot":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","archiveNextLeafIndex":6}
21:39:07 [21:39:07.992]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
21:39:08 [21:39:08.058]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":5.770494000000326,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750196745,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
21:39:08 [21:39:08.098]
VERBOSE:
p2p Synched to latest block 5
21:39:08 [21:39:08.216]
VERBOSE:
pxe:service Updated pxe last block to 5
{"blockHash":{},"archive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","header":{"contentCommitment":{"blobsHash":"0x0046b63f6876c513245643734391f5420b393ef911a42f876e9dcc9b31fb6f69","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25140,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750196745,"version":3476489198},"lastArchive":"0x05a2e888abfdf5d29650523d6589f5d412fa01fcb64d21ee977b91db9bc11971","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x27559222de8658487c55705c287de4c2bc9795047064fda671313276ccc70dd8","nullifierTree":"0x2178b935b5d8a98aa6d62948cc9b465c3c7e0f400dadc72b45af91282aa02b24","publicDataTree":"0x1b99df6684e147d2f30c229a92a04ed7e2d825aba0c1158a9b10e6948619d6c8"},"totalFees":83062560,"totalManaUsed":3304}}
21:39:08 [21:39:08.307]
VERBOSE:
simulator Executing utility function process_message
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","selector":"0x988dd306"}
21:39:08 [21:39:08.316]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
21:39:08 [21:39:08.317]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:08 [21:39:08.359]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:08 [21:39:08.361]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:08 [21:39:08.371]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
21:39:08 [21:39:08.372]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11 for storage slot 0x006198def9bc1767b45f6a38be613c70ad3875f086791b6136bbe468dddb9f77
21:39:08 [21:39:08.377]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
21:39:08 [21:39:08.377]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
21:39:08 [21:39:08.379]
VERBOSE:
simulator Utility simulation for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11.0x988dd306 completed
21:39:08 [21:39:08.467]
VERBOSE:
simulator Executing utility function get_note_value
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","selector":"0x5e6122e2"}
21:39:08 [21:39:08.478]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
21:39:08 [21:39:08.478]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:08 [21:39:08.527]
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":1750196781,"version":3476489198},"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:08 [21:39:08.530]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11"}
21:39:08 [21:39:08.531]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:08 [21:39:08.535]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
21:39:08 [21:39:08.538]
VERBOSE:
pxe:service Added note
{"index":256,"contract":"0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11","slot":"0x006198def9bc1767b45f6a38be613c70ad3875f086791b6136bbe468dddb9f77","noteHash":"0x21cd498c871da8b2e5aa5456278f6eefeeb2b3abd50c3d2b860210651f1b97b5","nullifier":"0x2f0fb8f317f1705e8b7542844e7fa26bac21b405a0374b004837fbca52ed3438"}
21:39:08 [21:39:08.541]
VERBOSE:
simulator Utility simulation for 0x1f66dc79cd704fb8ad07bcbe96057f60783c58813f3bb2e63c69d8959db5eb11.0x5e6122e2 completed
21:39:08 [21:39:08.543]
INFO:
node:MAIN-aztec-node Stopping Aztec Node
21:39:09 [21:39:09.045]
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":1750196781,"version":3476489198},"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:09 [21:39:09.047]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:09 [21:39:09.561]
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":1750196781,"version":3476489198},"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:09 [21:39:09.562]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:10 [21:39:10.077]
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":1750196781,"version":3476489198},"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:10 [21:39:10.078]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x056db3de4f261b618aafd74869e876c68a42e10aa1d2174b0c84922ef62e4c77","blockNumber":6,"slot":6}
21:39:10 [21:39:10.544]
INFO:
slasher Slasher client stopped.
21:39:10 [21:39:10.545]
INFO:
sequencer Stopped sequencer
21:39:10 [21:39:10.545]
INFO:
p2p P2P client stopped
21:39:10 [21:39:10.546]
INFO:
world_state Stopped world state synchronizer
21:39:10 [21:39:10.547]
INFO:
archiver Stopped.
21:39:10 [21:39:10.547]
INFO:
node:MAIN-aztec-node Stopped Aztec Node
21:39:10 [21:39:10.555]
INFO:
blob-sink:server Stopping blob sink
21:39:10 [21:39:10.556]
INFO:
blob-sink:server Blob sink stopped
21:39:10
PASS src/e2e_offchain_message.test.ts
21:39:10 e2e_offchain_message
21:39:10
✓ should emit offchain message (1912 ms)
21:39:10
✓ should not emit any offchain messages (1049 ms)
21:39:10
✓ should revert when emitting offchain message from utility function (164 ms)
21:39:10
✓ should emit event as offchain message and process it (3375 ms)
21:39:10
✓ should emit note as offchain message and process it (2454 ms)
21:39:10
21:39:10
Test Suites: 1 passed, 1 total
21:39:10
Tests: 5 passed, 5 total
21:39:10
Snapshots: 0 total
21:39:10
Time: 30.568 s
21:39:10
Ran all test suites matching src/e2e_offchain_message.test.ts
.
21:39:10
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?