Parent Log:
http://ci.aztec-labs.com/5b033f030d6cee54
Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_authwit yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d
Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1
Date: Fri Jun 13 17:07:54 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master
17:07:55 +++ id -u
17:07:55 +++ id -g
17:07:55 ++ docker run -d --name e2e_authwit --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts'\'''
17:07:55 + cid=d08d6b278459d0c597fa01aff6298b103f32a40f8546c2a8748778e4560f7b29
17:07:55 + set +x
17:07:55 {"level":25,"time":1749834475964,"pid":12,"hostname":"d08d6b278459","module":"logger","msg":"Logger initialized with level verbose"}
17:08:01 [17:08:01.727]
INFO:
e2e:e2e_authwit Logging metrics to log/unknown.jsonl
17:08:02 [17:08:02.059]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-OKFMZm/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads.
17:08:02 [17:08:02.093]
INFO:
e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12]
17:08:02 [17:08:02.122]
WARN:
e2e:e2e_authwit Set block interval to 12
17:08:02 [17:08:02.123]
VERBOSE:
e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
17:08:02 [17:08:02.166]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84
{"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"}
17:08:02 [17:08:02.173]
VERBOSE:
e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3
17:08:02 [17:08:02.186]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb
{"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"}
17:08:02 [17:08:02.190]
VERBOSE:
e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512
17:08:02 [17:08:02.211]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169
{"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"}
17:08:02 [17:08:02.215]
VERBOSE:
e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0
17:08:02 [17:08:02.230]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c
{"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"}
17:08:02 [17:08:02.253]
VERBOSE:
e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9
17:08:02 [17:08:02.282]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e
{"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"}
17:08:02 [17:08:02.287]
VERBOSE:
e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9
17:08:02 [17:08:02.299]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64
{"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"}
17:08:02 [17:08:02.304]
VERBOSE:
e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707
17:08:02 [17:08:02.305]
VERBOSE:
e2e:e2e_authwit Waiting for deployments to complete
17:08:02 [17:08:02.305]
INFO:
e2e:e2e_authwit Waiting for 6 transactions to be mined...
17:08:02 [17:08:02.326]
INFO:
e2e:e2e_authwit All transactions mined successfully
17:08:02 [17:08:02.340]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8
{"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"}
17:08:02 [17:08:02.341]
VERBOSE:
e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8
17:08:02 [17:08:02.358]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63
{"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"}
17:08:02 [17:08:02.368]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf
{"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"}
17:08:02 [17:08:02.372]
VERBOSE:
e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6
17:08:02 [17:08:02.385]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2
{"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"}
17:08:02 [17:08:02.385]
VERBOSE:
e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2
17:08:02 [17:08:02.402]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1
{"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"}
17:08:02 [17:08:02.406]
VERBOSE:
e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788
17:08:02 [17:08:02.416]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a
{"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"}
17:08:02 [17:08:02.416]
VERBOSE:
e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a
17:08:02 [17:08:02.416]
VERBOSE:
e2e:e2e_authwit Waiting for deployments to complete
17:08:02 [17:08:02.416]
INFO:
e2e:e2e_authwit Waiting for 8 transactions to be mined...
17:08:02 [17:08:02.432]
INFO:
e2e:e2e_authwit All transactions mined successfully
17:08:02 [17:08:02.440]
VERBOSE:
e2e:e2e_authwit Deployed shared contracts
17:08:02 [17:08:02.460]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034
{"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"}
17:08:02 [17:08:02.460]
VERBOSE:
e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034
17:08:02 [17:08:02.462]
VERBOSE:
e2e:e2e_authwit Rollup config args
{"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100}
17:08:02 [17:08:02.472]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c
{"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"}
17:08:02 [17:08:02.495]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a
{"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"}
17:08:02 [17:08:02.500]
VERBOSE:
e2e:e2e_authwit Awaiting for linked libraries to be deployed
17:08:02 [17:08:02.543]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x0e1b44e0e6988334ddca9415381d9a353105390287402ba14ec719aa42d424c7
{"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"}
17:08:02 [17:08:02.548]
VERBOSE:
e2e:e2e_authwit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016
{"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100}
17:08:02 [17:08:02.548]
INFO:
e2e:e2e_authwit Waiting for 9 transactions to be mined...
17:08:02 [17:08:02.564]
INFO:
e2e:e2e_authwit All transactions mined successfully
17:08:02 [17:08:02.564]
VERBOSE:
e2e:e2e_authwit All core contracts have been deployed
17:08:02 [17:08:02.575]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b
{"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"}
17:08:02 [17:08:02.575]
VERBOSE:
e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments)
17:08:02 [17:08:02.585]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a
{"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"}
17:08:02 [17:08:02.588]
VERBOSE:
e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae
17:08:02 [17:08:02.607]
VERBOSE:
e2e:e2e_authwit Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776
{"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"}
17:08:02 [17:08:02.607]
VERBOSE:
e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776
17:08:02 [17:08:02.607]
INFO:
e2e:e2e_authwit Waiting for 10 transactions to be mined...
17:08:02 [17:08:02.631]
INFO:
e2e:e2e_authwit All transactions mined successfully
17:08:02 [17:08:02.640]
VERBOSE:
e2e:e2e_authwit Rollup deployed
17:08:02 [17:08:02.640]
VERBOSE:
e2e:e2e_authwit Waiting for rollup and slash factory to be deployed
17:08:02 [17:08:02.640]
INFO:
e2e:e2e_authwit Waiting for 10 transactions to be mined...
17:08:02 [17:08:02.659]
INFO:
e2e:e2e_authwit All transactions mined successfully
17:08:02 [17:08:02.659]
VERBOSE:
e2e:e2e_authwit All transactions for L1 deployment have been mined
17:08:02 [17:08:02.678]
INFO:
e2e:e2e_authwit Aztec L1 contracts initialized
{"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
17:08:02 [17:08:02.681]
INFO:
ethereum:cheat_codes Calling anvil_getAutomine with params: [] on
http://127.0.0.1:8545
17:08:02 [17:08:02.684]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:02 [17:08:02.685]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016
17:08:02 [17:08:02.686]
INFO:
telemetry:client Using NoopTelemetryClient
17:08:02 [17:08:02.691]
INFO:
kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/89d99b30165f72c5/blob-sink with map size 134217728 KB (LMDB v2)
17:08:02 [17:08:02.692]
WARN:
aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks
17:08:02 [17:08:02.692]
INFO:
ethereum:cheat_codes Calling evm_mine with params: [] on
http://127.0.0.1:8545
17:08:02 [17:08:02.695]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:02 [17:08:02.697]
INFO:
aztecjs:utils:watcher New L1 time: 1749834721
17:08:02 [17:08:02.698]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:12:01.000Z
{"offset":238303,"timeMs":1749834721000}
17:08:02 [17:08:02.699]
INFO:
kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16
17:08:02 [17:08:02.708]
INFO:
blob-sink:server Server is running on
http://localhost:34211
17:08:02 [17:08:02.709]
VERBOSE:
e2e:e2e_authwit Creating and synching an aztec node...
17:08:02 [17:08:02.709]
VERBOSE:
e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/bfce0d3b/acvm
17:08:02 [17:08:02.711]
INFO:
node:blob-sink:client Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:34211"}
17:08:02 [17:08:02.725]
VERBOSE:
node Snapshot sync is disabled. No snapshots URL provided.
17:08:02 [17:08:02.726]
INFO:
archiver:lmdb Creating archiver data store at directory /tmp/89d99b30165f72c5/archiver with map size 134217728 KB (LMDB v2)
17:08:02 [17:08:02.731]
INFO:
archiver:lmdb Starting data store with maxReaders 16
17:08:02 [17:08:02.920]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:03 [17:08:03.013]
INFO:
node:blob-sink:client Testing configured blob sources
{"blobSinkUrl":"http://localhost:34211"}
17:08:03 [17:08:03.031]
INFO:
node:blob-sink:client Blob sink is reachable
{"blobSinkUrl":"http://localhost:34211"}
17:08:03 [17:08:03.032]
WARN:
node:blob-sink:client No L1 consensus host urls configured
17:08:03 [17:08:03.032]
WARN:
node:blob-sink:client No archive client configured
17:08:03 [17:08:03.034]
INFO:
archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xc7175f929821085db81aa82f5f11a146889938a8dabc06601fa25d6d9a4402bf
{"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x66b07648e3e384afaff37d171879257c59308262b6ad9fe6bfbd0aadb9095ac2","l1BlockNumber":16}}
17:08:03 [17:08:03.047]
INFO:
archiver Initial archiver sync to L1 block 20 complete.
{"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xc7175f929821085db81aa82f5f11a146889938a8dabc06601fa25d6d9a4402bf","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
17:08:03 [17:08:03.054]
INFO:
world-state:database Creating world state data store at directory /tmp/89d99b30165f72c5/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
17:08:03 [17:08:03.077]
INFO:
world_state Created world state synchroniser with block history of 64
17:08:03 [17:08:03.077]
WARN:
node Aztec node is accepting fake proofs
17:08:03 [17:08:03.086]
INFO:
p2p:lmdb-v2 Creating p2p data store at directory /tmp/89d99b30165f72c5/p2p with map size 134217728 KB (LMDB v2)
17:08:03 [17:08:03.087]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
17:08:03 [17:08:03.088]
INFO:
p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/89d99b30165f72c5/p2p-archive with map size 134217728 KB (LMDB v2)
17:08:03 [17:08:03.089]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
17:08:03 [17:08:03.090]
INFO:
p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/89d99b30165f72c5/p2p-peers with map size 134217728 KB (LMDB v2)
17:08:03 [17:08:03.091]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
17:08:03 [17:08:03.092]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
17:08:03 [17:08:03.093]
VERBOSE:
p2p P2P is disabled. Using dummy P2P service
17:08:03 [17:08:03.095]
VERBOSE:
world-state:block_stream Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
17:08:03 [17:08:03.096]
INFO:
world_state Started world state synchronizer from block 1
17:08:03 [17:08:03.098]
VERBOSE:
world-state:block_stream Starting sync from block number 0
17:08:03 [17:08:03.099]
INFO:
p2p Starting p2p client from block 0 with empty mempools
17:08:03 [17:08:03.099]
VERBOSE:
p2p:l2-block-stream Starting L2 block stream
{"batchSize":20,"pollIntervalMS":100,"startingBlock":0}
17:08:03 [17:08:03.100]
INFO:
slasher Slasher client initialized
17:08:03 [17:08:03.101]
INFO:
slasher Starting Slasher client...
17:08:03 [17:08:03.132]
VERBOSE:
validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:08:03 [17:08:03.133]
VERBOSE:
node All Aztec Node subsystems synced
17:08:03 [17:08:03.141]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:03 [17:08:03.143]
INFO:
sequencer-client Deploying forwarder contract
17:08:03 [17:08:03.152]
VERBOSE:
p2p:l2-block-stream Starting sync from block number 0
17:08:03 [17:08:03.169]
VERBOSE:
sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968
{"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"}
17:08:03 [17:08:03.170]
VERBOSE:
sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968.
17:08:03 [17:08:03.175]
INFO:
sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
17:08:03 [17:08:03.198]
INFO:
validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:08:03 [17:08:03.198]
VERBOSE:
validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0
17:08:03 [17:08:03.199]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/bfce0d3b/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false}
17:08:03 [17:08:03.449]
VERBOSE:
sequencer Sequencer timetable updated
{"enforceTimeTable":false}
17:08:03 [17:08:03.451]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:08:03 [17:08:03.452]
INFO:
node Aztec Node version: 0.87.8
17:08:03 [17:08:03.452]
INFO:
node Aztec Node started on chain 0x7a69
{"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"}
17:08:03 [17:08:03.453]
VERBOSE:
e2e:e2e_authwit Creating a pxe...
17:08:03 [17:08:03.457]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:03 [17:08:03.465]
INFO:
pxe:data:lmdb Creating pxe_data data store at directory /tmp/03d71bced254d33b/pxe_data with map size 134217728 KB (LMDB v2)
17:08:03 [17:08:03.477]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
17:08:03 [17:08:03.479]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:03 [17:08:03.674]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:03 [17:08:03.786]
VERBOSE:
pxe:service Registered protocol contracts in pxe
{"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"}
17:08:03 [17:08:03.787]
INFO:
pxe:service Started PXE connected to chain 31337 version 2254972989
17:08:03 [17:08:03.836]
INFO:
pxe:service Registered account 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c
17:08:03 [17:08:03.894]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:03 [17:08:03.898]
WARN:
pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata
17:08:03 [17:08:03.902]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c
17:08:04 [17:08:04.029]
INFO:
pxe:service Added contract SchnorrAccount at 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a
17:08:04 [17:08:04.038]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:04 [17:08:04.068]
VERBOSE:
pxe:block_stream Starting sync from block number 0
17:08:04 [17:08:04.091]
VERBOSE:
simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"}
17:08:04 [17:08:04.135]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:04 [17:08:04.178]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
17:08:04 [17:08:04.802]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c
17:08:04 [17:08:04.912]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
17:08:05 [17:08:05.013]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:05 [17:08:05.090]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:05 [17:08:05.160]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:constructor
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.218]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:05 [17:08:05.220]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.224]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:05 [17:08:05.277]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.280]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:05 [17:08:05.458]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.502]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:05 [17:08:05.503]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.507]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:05 [17:08:05.556]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:05 [17:08:05.559]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:05 [17:08:05.576]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:05 [17:08:05.667]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:05 [17:08:05.777]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:06 [17:08:06.041]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:06 [17:08:06.211]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:06 [17:08:06.375]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:06 [17:08:06.906]
INFO:
pxe:service Proving completed in 2840.9801929999994ms
{"timings":{"total":2840.9801929999994,"sync":3.735893999999462,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":186.45423800000208,"oracles":{"callPrivateFunction":{"times":[866.554924,377.5141279999989,218.4610819999998]}}},{"functionName":"private_kernel_init","time":103.0472060000011},{"functionName":"ContractClassRegisterer:register","time":848.582316,"oracles":{"loadCapsule":{"times":[22.686713999999483]},"notifyCreatedNullifier":{"times":[2.492315999999846]},"debugLog":{"times":[2.9492970000010246]},"notifyCreatedContractClassLog":{"times":[8.176085000000967]}}},{"functionName":"private_kernel_inner","time":162.18285699999979},{"functionName":"SchnorrAccount:constructor","time":327.47725399999945,"oracles":{"getContractInstance":{"times":[5.775150999999823]},"debugLog":{"times":[0.7089759999998932,0.26523599999927683]},"fetchTaggedLogs":{"times":[60.02204999999958]},"loadCapsule":{"times":[0.31760700000086217,0.190454999999929,0.16581399999995483]},"notifyCreatedNullifier":{"times":[0.12643299999945157,0.3862390000012965]},"notifyCreatedNote":{"times":[0.40137899999899673]},"getRandomField":{"times":[0.25550599999951373,0.16387399999985064,0.0827819999994972,0.05171200000040699,0.044841000000815256,0.049651000001176726,0.04937100000097416,0.04299100000025646,0.046741000000110944,0.0637910000004922,0.04010100000050443]},"getIndexedTaggingSecretAsSender":{"times":[35.999556000000666]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.9105610000006]}}},{"functionName":"private_kernel_inner","time":161.35349799999858},{"functionName":"SchnorrAccount:entrypoint","time":170.78574099999787,"oracles":{"debugLog":{"times":[0.6436949999988428,0.5031920000001264,0.8474990000013349]},"fetchTaggedLogs":{"times":[55.189220999998724]},"loadCapsule":{"times":[0.27424599999903876,0.284497000000556,0.24439600000005157]},"getNotes":{"times":[2.166659000000436]},"getAuthWitness":{"times":[0.3062370000006922]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.027953000000707]}}},{"functionName":"private_kernel_inner","time":118.13505799999984},{"functionName":"private_kernel_reset","time":203.12566499999957},{"functionName":"private_kernel_tail","time":108.48747000000003}],"unaccounted":447.61299600000166}}
17:08:06 [17:08:06.930]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:07 [17:08:07.024]
VERBOSE:
sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1)
{"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2}
17:08:07 [17:08:07.104]
VERBOSE:
p2p:tx_pool Adding tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 to pool
{"eventName":"tx-added-to-pool","txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"}
17:08:07 [17:08:07.135]
INFO:
node Received tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15
{"txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15"}
17:08:07 [17:08:07.138]
INFO:
pxe:service Sent transaction 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15
17:08:07 [17:08:07.149]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:07 [17:08:07.354]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:07 [17:08:07.553]
VERBOSE:
sequencer Building block 1 for slot 2
{"slot":2,"blockNumber":1,"msgCount":0}
17:08:07 [17:08:07.557]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:07 [17:08:07.567]
VERBOSE:
sequencer Processing pending txs
{"slot":2,"slotStart":"2025-06-13T17:12:25.000Z","now":"2025-06-13T17:12:05.870Z"}
17:08:07 [17:08:07.794]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:07 [17:08:07.878]
VERBOSE:
simulator:public-processor Processed tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 with no public calls in 232.99843099999998ms
{"txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":232.99843099999998}
17:08:07 [17:08:07.881]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.31269078900000025s
{"duration":0.31269078900000025,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344}
17:08:08 [17:08:08.039]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:08 [17:08:08.053]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x03d9f32061835bbb1f4d7f759d911b8892e382368fa0acff703813b37e2578a0","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":1,"slotNumber":2,"timestamp":1749834745,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":499.77094899999975,"publicProcessDuration":313.5923989999992,"rollupCircuitsDuration":486.3638949999986,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:08:08 [17:08:08.055]
VERBOSE:
sequencer Attesting committee is empty
17:08:08 [17:08:08.246]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:08 [17:08:08.467]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:08 [17:08:08.475]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0
17:08:08 [17:08:08.475]
VERBOSE:
sequencer-client Sent L1 transaction 0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0
{"gasLimit":514570,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"}
17:08:08 [17:08:08.490]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:08 [17:08:08.491]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:08:08 [17:08:08.492]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:08 [17:08:08.512]
INFO:
blob-sink:server Received blob sidecar for block 0x99bffb560909bd233a276cf0cfd8cb36f9310c027b0ec83e887705f7c5462e4f
17:08:08 [17:08:08.519]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x99bffb560909bd233a276cf0cfd8cb36f9310c027b0ec83e887705f7c5462e4f
17:08:08 [17:08:08.746]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:08 [17:08:08.778]
VERBOSE:
archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a
17:08:08 [17:08:08.780]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on
http://127.0.0.1:8545
17:08:08 [17:08:08.786]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
17:08:08 [17:08:08.790]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x03d9f32061835bbb1f4d7f759d911b8892e382368fa0acff703813b37e2578a0","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":1,"slotNumber":2,"timestamp":1749834745,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","archiveNextLeafIndex":2}
17:08:08 [17:08:08.791]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
17:08:08 [17:08:08.792]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834781] on
http://127.0.0.1:8545
17:08:08 [17:08:08.794]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:08 [17:08:08.796]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834781
17:08:08 [17:08:08.797]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:13:01.000Z
{"offset":292204,"timeMs":1749834781000}
17:08:08 [17:08:08.797]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
17:08:08 [17:08:08.908]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":44.94971900000019,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:08:08 [17:08:08.955]
INFO:
pxe:service Registered account 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4
17:08:08 [17:08:08.956]
VERBOSE:
p2p Synched to latest block 1
17:08:09 [17:08:09.059]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:09 [17:08:09.069]
INFO:
pxe:service Added contract SchnorrAccount at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a
17:08:09 [17:08:09.108]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3}
17:08:09 [17:08:09.115]
VERBOSE:
pxe:service Updated pxe last block to 1
{"blockHash":{},"archive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","header":{"contentCommitment":{"blobsHash":"0x00625e41bfa5829ece7b54b2037f957f2f99896a83bfe69bf1237f54d599a1fc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834745,"version":2254972989},"lastArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21963c0f5c7085b3bbe383480ee20e2347925f703de1ffaa2db720b37ab2d05b","nullifierTree":"0x15f9c15e1a2ec733b07283f849600ece2d37dbdfa4a594a6e5af105f11cd390d","publicDataTree":"0x10bbdb7ab2e7708501154cb9a2afd3ad5c72970cbce87ab0d6c20f26c3bb5829"},"totalFees":6794052480,"totalManaUsed":20448}}
17:08:09 [17:08:09.137]
VERBOSE:
simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"}
17:08:09 [17:08:09.232]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:constructor
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.270]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:09 [17:08:09.276]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:09 [17:08:09.276]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.348]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
17:08:09 [17:08:09.373]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.379]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:09 [17:08:09.483]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:09 [17:08:09.590]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.648]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:09 [17:08:09.649]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.690]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:09 [17:08:09.698]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3}
17:08:09 [17:08:09.732]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:09 [17:08:09.753]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:09 [17:08:09.805]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:09 [17:08:09.895]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:10 [17:08:10.251]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:10 [17:08:10.874]
INFO:
pxe:service Proving completed in 1769.0076719999997ms
{"timings":{"total":1769.0076719999997,"sync":11.961370999999417,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":107.09870799999408,"oracles":{"callPrivateFunction":{"times":[344.6452420000005,339.11765699999887]}}},{"functionName":"private_kernel_init","time":82.09861099999944},{"functionName":"SchnorrAccount:constructor","time":310.26749400000153,"oracles":{"getContractInstance":{"times":[3.3941370000011375]},"debugLog":{"times":[0.47195099999953527,0.40466899999955785]},"fetchTaggedLogs":{"times":[101.85303999999996]},"loadCapsule":{"times":[0.26187600000048405,0.2555849999989732,0.47447100000135833]},"notifyCreatedNullifier":{"times":[0.21667499999966822,0.2703160000000935]},"notifyCreatedNote":{"times":[0.08558200000152283]},"getRandomField":{"times":[0.1041029999996681,0.16361400000096182,0.04506100000071456,0.034959999999045976,0.042140999999901396,0.039521000000604545,0.03482100000110222,0.03858100000070408,0.05976100000043516,0.11272300000018731,0.0680609999999433]},"getIndexedTaggingSecretAsSender":{"times":[55.01361700000052]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.098047999999835]}}},{"functionName":"private_kernel_inner","time":144.9641759999995},{"functionName":"SchnorrAccount:entrypoint","time":304.385970000003,"oracles":{"debugLog":{"times":[0.7186970000002475,1.3487409999997908,3.020478999998886]},"fetchTaggedLogs":{"times":[97.36801699999887]},"loadCapsule":{"times":[0.46985099999983504,4.560712999998941,0.6586449999995239]},"getNotes":{"times":[26.480160999999498]},"getAuthWitness":{"times":[0.34021800000118674]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6730959999986226]}}},{"functionName":"private_kernel_inner","time":177.94758300000103},{"functionName":"private_kernel_reset","time":201.7038219999995},{"functionName":"private_kernel_tail","time":104.43446799999947}],"unaccounted":324.1454690000028}}
17:08:10 [17:08:10.890]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:10 [17:08:10.895]
VERBOSE:
sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1)
{"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3}
17:08:10 [17:08:10.930]
VERBOSE:
p2p:tx_pool Adding tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e to pool
{"eventName":"tx-added-to-pool","txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"}
17:08:10 [17:08:10.936]
INFO:
node Received tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e
{"txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e"}
17:08:10 [17:08:10.936]
INFO:
pxe:service Sent transaction 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e
17:08:11 [17:08:11.097]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:11 [17:08:11.301]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:11 [17:08:11.443]
VERBOSE:
sequencer Building block 2 for slot 3
{"slot":3,"blockNumber":2,"msgCount":0}
17:08:11 [17:08:11.468]
VERBOSE:
sequencer Processing pending txs
{"slot":3,"slotStart":"2025-06-13T17:13:01.000Z","now":"2025-06-13T17:13:03.672Z"}
17:08:11 [17:08:11.505]
VERBOSE:
simulator:public-processor Processed tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e with no public calls in 19.14374400000088ms
{"txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":15104},"billedGas":{"daGas":11776,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":19.14374400000088}
17:08:11 [17:08:11.507]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03862291499999992s
{"duration":0.03862291499999992,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992}
17:08:11 [17:08:11.513]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:11 [17:08:11.649]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x16232118a04f9b5e35d965c379b57c4381d93bef4783b4c6fb5f44c5e5edf7bd","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":2,"slotNumber":3,"timestamp":1749834781,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":206.7776670000003,"publicProcessDuration":39.03234499999962,"rollupCircuitsDuration":182.75790299999971,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:11 [17:08:11.652]
VERBOSE:
sequencer Attesting committee is empty
17:08:11 [17:08:11.732]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:11 [17:08:11.960]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:11 [17:08:11.969]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571
17:08:11 [17:08:11.969]
VERBOSE:
sequencer-client Sent L1 transaction 0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571
{"gasLimit":470254,"maxFeePerGas":"1.303611187","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:11 [17:08:11.989]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on
http://127.0.0.1:8545
17:08:11 [17:08:11.994]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
17:08:11 [17:08:11.997]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834817] on
http://127.0.0.1:8545
17:08:12 [17:08:12.006]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
17:08:12 [17:08:12.012]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:12 [17:08:12.018]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834817
17:08:12 [17:08:12.018]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:13:37.000Z
{"offset":324982,"timeMs":1749834817000}
17:08:12 [17:08:12.018]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
17:08:12 [17:08:12.022]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:12 [17:08:12.022]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:12 [17:08:12.023]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:12 [17:08:12.034]
INFO:
blob-sink:server Received blob sidecar for block 0x36b87784b29c4441480494890fe2cade4eb2abcf5593b9bed4c485b91046b1d7
17:08:12 [17:08:12.077]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x36b87784b29c4441480494890fe2cade4eb2abcf5593b9bed4c485b91046b1d7
17:08:12 [17:08:12.223]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:12 [17:08:12.248]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x16232118a04f9b5e35d965c379b57c4381d93bef4783b4c6fb5f44c5e5edf7bd","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":2,"slotNumber":3,"timestamp":1749834781,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","archiveNextLeafIndex":3}
17:08:12 [17:08:12.260]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
17:08:12 [17:08:12.373]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":11.557010999997146,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:12 [17:08:12.393]
VERBOSE:
p2p Synched to latest block 2
17:08:12 [17:08:12.499]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:12 [17:08:12.643]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4}
17:08:12 [17:08:12.648]
VERBOSE:
pxe:service Updated pxe last block to 2
{"blockHash":{},"archive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","header":{"contentCommitment":{"blobsHash":"0x00bae807c9e4ee120e990b524d014fef26020df986bdf19143e3c27f64f63a22","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834781,"version":2254972989},"lastArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x14ffbb4e8d5ecfff878dfdb071d465a0d346acf01608d11ada6e77ea1e2adc5a","publicDataTree":"0x2d5546ec5a702a66520fb9d5e88ae41bb686711c018d7de10b005be2a35dd093"},"totalFees":5018455040,"totalManaUsed":15104}}
17:08:12 [17:08:12.721]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:12 [17:08:12.808]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:12 [17:08:12.864]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:12 [17:08:12.865]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:12 [17:08:12.978]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:13 [17:08:13.040]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:13 [17:08:13.049]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:13 [17:08:13.065]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:13 [17:08:13.066]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:13 [17:08:13.079]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:13 [17:08:13.080]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:13 [17:08:13.100]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:13 [17:08:13.106]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:13 [17:08:13.122]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:13 [17:08:13.207]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:13 [17:08:13.221]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
17:08:13 [17:08:13.243]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4}
17:08:13 [17:08:13.279]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
17:08:13 [17:08:13.297]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c,0x0000000000000000000000000000000000000000000000000000000000000001,0x0e1a4386eb74933caafd688212a2bb990799b853c2ea9475cbd869df074b3a86,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x1feef5cc227695ba4101ff856ef512ce4e18bd4430a801c3d3ea2ce6b447a2c1,0x2eb092b9d7fcb1a074f76f4d690af3b86218b7eadc74008cd9905cdde6e864aa,0x12da8d3426c400f00507beac996cbed0288544d18b43ccf702bafbe584909eea,0x1a88c976e8dd9460d30456f08ae85fc9c80db976189b2d94cac1ac0d6cbf789d,0x2e13719748bacbd7f85c22358a712518c65d5afdcc602b74a6d709fd8a582354,0x1a7bca87bbf1a1b4e2b88f21776479fa18db2aeae855684236aba805252bcb99,0x1eb6a26604d77934282c3556192e5bd45ff74275028d261f76816878ffde4ed6,0x16fa338f8513608eb346513d8c4206f8f30bf5732519533b8aafbda32ca3c3e5,0x1bd09f27dc6e0e4cfa9c00968c16fbb89bac6ac475ad9fc2fd9fc96788cd98aa,0x0000000000000000000000000000000000000000000000000000000000000000
17:08:13 [17:08:13.349]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
17:08:13 [17:08:13.387]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
17:08:13 [17:08:13.398]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4,0x0000000000000000000000000000000000000000000000000000000000000001,0x1ec75b29ff4729aead2690e887680c20561bc1cfc428078191c79effa0e0eccf,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x1a05a8678a12830d640e51980a4568bc0569adbb131f9b8f8aadf143d712c42c,0x0d0d70b29b941e93bfc0c959325ba2bb72866ffd5bf2ff1d8e751a68ec6e4c1f,0x282f8eeca5b139d1aa67809b06d236c838a2154f5ec330b3b99913576077e0fd,0x151a531cbd849436bdd57fdd4ba259e9dca7d30768a8804a4587f58d1d810b10,0x1c8b35245d2a210d1e738b39b55a27331d8cf516a829a30f508807d7d72776f6,0x14b916204245f6d4f9362c7ca08397bba74d80dea2cfbd326db8bf16fc80c25b,0x204a6ee0deb8673ce383f25957634d8c2e80517ddaa0cbce83379f84d699718b,0x138e203f141076914a9a8a9164f9b6bdd9d0791421286ffeba151951cb22c9b9,0x047cede245186ae4c2ceacdd881006614f38c0a112badcc5f8e857f74f36dfff,0x0000000000000000000000000000000000000000000000000000000000000000
17:08:13 [17:08:13.445]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:13 [17:08:13.663]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:13 [17:08:13.949]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:14 [17:08:13.996]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4}
17:08:14 [17:08:14.244]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:14 [17:08:14.515]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:14 [17:08:14.773]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:14 [17:08:14.775]
VERBOSE:
sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1)
{"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4}
17:08:15 [17:08:15.120]
INFO:
pxe:service Proving completed in 2492.5361669999984ms
{"timings":{"total":2492.5361669999984,"sync":27.113184000001638,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":482.1855199999991,"oracles":{"debugLog":{"times":[0.7758580000008806,0.5254520000016782,0.6249040000002424,0.5600330000015674,1.3723009999994247,1.0635640000000421,0.3957200000004377,0.5374719999999797]},"fetchTaggedLogs":{"times":[180.25534699999844]},"loadCapsule":{"times":[0.26508599999942817,1.2012869999998657,0.9902620000029856,0.4486789999973553,1.199096999996982,1.464034000000538]},"getSharedSecret":{"times":[5.476653999998234]},"aes128Decrypt":{"times":[1.344409999997879,1.3959409999988566]},"getPublicKeysAndPartialAddress":{"times":[2.370443999996496]},"getKeyValidationRequest":{"times":[4.802619000001869]},"deliverNote":{"times":[19.150345000001835]},"deleteCapsule":{"times":[0.8378889999985404]},"storeCapsule":{"times":[2.9475169999968784]},"getNotes":{"times":[2.2529410000024654]},"getAuthWitness":{"times":[0.33403700000053504]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11838300000090385]},"callPrivateFunction":{"times":[178.1457279999995,96.38178499999776]}}},{"functionName":"private_kernel_init","time":105.27387600000293},{"functionName":"ContractInstanceDeployer:deploy","time":106.52440699999715,"oracles":{"storeInExecutionCache":{"times":[0.2511159999994561]},"callPrivateFunction":{"times":[62.81331399999908]},"notifyCreatedNullifier":{"times":[0.37705799999821465]},"debugLog":{"times":[0.7349370000010822]}}},{"functionName":"private_kernel_inner","time":140.6008780000011},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.534958000003826,"oracles":{}},{"functionName":"private_kernel_inner","time":158.33984899999996},{"functionName":"ContractInstanceDeployer:deploy","time":55.07694900000206,"oracles":{"storeInExecutionCache":{"times":[0.06250200000067707]},"callPrivateFunction":{"times":[39.85417300000336]},"notifyCreatedNullifier":{"times":[0.3018969999975525]},"debugLog":{"times":[0.5054110000019136]}}},{"functionName":"private_kernel_inner","time":164.687751999998},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.161803999999393,"oracles":{}},{"functionName":"private_kernel_inner","time":164.52975900000092},{"functionName":"private_kernel_reset","time":237.83106899999984},{"functionName":"private_kernel_tail","time":108.1439509999982}],"unaccounted":667.5322109999943}}
17:08:15 [17:08:15.139]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:15 [17:08:15.186]
VERBOSE:
p2p:tx_pool Adding tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b to pool
{"eventName":"tx-added-to-pool","txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"}
17:08:15 [17:08:15.192]
INFO:
node Received tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b
{"txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b"}
17:08:15 [17:08:15.192]
INFO:
pxe:service Sent transaction 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b
17:08:15 [17:08:15.295]
VERBOSE:
sequencer Building block 3 for slot 4
{"slot":4,"blockNumber":3,"msgCount":0}
17:08:15 [17:08:15.307]
VERBOSE:
sequencer Processing pending txs
{"slot":4,"slotStart":"2025-06-13T17:13:37.000Z","now":"2025-06-13T17:13:40.289Z"}
17:08:15 [17:08:15.333]
VERBOSE:
simulator:public-processor Processed tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b with no public calls in 17.049197000000277ms
{"txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b","txFee":5496909440,"revertCode":0,"gasUsed":{"totalGas":{"daGas":18432,"l2Gas":16544},"billedGas":{"daGas":18432,"l2Gas":16544},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":2,"l2ToL1MessageCount":0,"durationMs":17.049197000000277}
17:08:15 [17:08:15.336]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.028188139000001684s
{"duration":0.028188139000001684,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376}
17:08:15 [17:08:15.345]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:15 [17:08:15.474]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0399e362418571e3d233e974b1a16dc6553f0a08a9e062b4c47e6f602056c633","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":3,"slotNumber":4,"timestamp":1749834817,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":179.01717599999756,"publicProcessDuration":28.651160000001255,"rollupCircuitsDuration":167.40032399999836,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:15 [17:08:15.476]
VERBOSE:
sequencer Attesting committee is empty
17:08:15 [17:08:15.564]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:15 [17:08:15.758]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24
17:08:15 [17:08:15.759]
VERBOSE:
sequencer-client Sent L1 transaction 0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24
{"gasLimit":470280,"maxFeePerGas":"1.279583375","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:15 [17:08:15.767]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:15 [17:08:15.775]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:15 [17:08:15.775]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:15 [17:08:15.776]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:15 [17:08:15.783]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on
http://127.0.0.1:8545
17:08:15 [17:08:15.786]
INFO:
blob-sink:server Received blob sidecar for block 0xf10e9bcf8effdb1bd4eeab1f74b69bdee392d21dd2da1a0c0ed64461c143a29d
17:08:15 [17:08:15.789]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
17:08:15 [17:08:15.793]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
17:08:15 [17:08:15.794]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xf10e9bcf8effdb1bd4eeab1f74b69bdee392d21dd2da1a0c0ed64461c143a29d
17:08:15 [17:08:15.803]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834853] on
http://127.0.0.1:8545
17:08:15 [17:08:15.804]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:15 [17:08:15.806]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834853
17:08:15 [17:08:15.806]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:14:13.000Z
{"offset":357194,"timeMs":1749834853000}
17:08:15 [17:08:15.806]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
17:08:15 [17:08:15.972]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:16 [17:08:16.178]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:16 [17:08:16.477]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:16 [17:08:16.496]
VERBOSE:
archiver:block-helper Store contract instance at 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c
17:08:16 [17:08:16.497]
VERBOSE:
archiver:block-helper Store contract instance at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4
17:08:16 [17:08:16.500]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x0399e362418571e3d233e974b1a16dc6553f0a08a9e062b4c47e6f602056c633","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":3,"slotNumber":4,"timestamp":1749834817,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","archiveNextLeafIndex":4}
17:08:16 [17:08:16.506]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
17:08:16 [17:08:16.620]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":14.768625000000611,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:16 [17:08:16.634]
VERBOSE:
p2p Synched to latest block 3
17:08:16 [17:08:16.685]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:16 [17:08:16.818]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5}
17:08:16 [17:08:16.890]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:17 [17:08:17.099]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:17 [17:08:17.249]
WARN:
pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata
17:08:17 [17:08:17.250]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd
17:08:17 [17:08:17.383]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:17 [17:08:17.477]
INFO:
pxe:service Added contract AuthWitTest at 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c
17:08:17 [17:08:17.480]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5}
17:08:17 [17:08:17.501]
VERBOSE:
pxe:service Updated pxe last block to 3
{"blockHash":{},"archive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","header":{"contentCommitment":{"blobsHash":"0x00b154a9556a893a03b83cab901a26e3b329d764a2e94dfa14212595bd918192","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834817,"version":2254972989},"lastArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x1daabb6ca70c12cc95d3d6e771dc43e3fcdc6069066a3c519b072b4e232e789b","publicDataTree":"0x21821fefa1e445cf79db672afbdaeb33311078f94e612247d8f68302d56be457"},"totalFees":5496909440,"totalManaUsed":16544}}
17:08:17 [17:08:17.620]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:17 [17:08:17.684]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:17 [17:08:17.684]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:17 [17:08:17.685]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:17 [17:08:17.828]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:17 [17:08:17.836]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:17 [17:08:17.850]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:17 [17:08:17.851]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:17 [17:08:17.864]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:17 [17:08:17.864]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:17 [17:08:17.868]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:17 [17:08:17.869]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:17 [17:08:17.883]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:17 [17:08:17.897]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:17 [17:08:17.924]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:register
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
17:08:18 [17:08:18.592]
VERBOSE:
simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418
17:08:18 [17:08:18.756]
VERBOSE:
simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..."
17:08:18 [17:08:18.860]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:18 [17:08:18.952]
VERBOSE:
simulator:private_execution Executing private function ContractInstanceDeployer:deploy
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"}
17:08:18 [17:08:18.969]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5}
17:08:19 [17:08:19.011]
VERBOSE:
simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"}
17:08:19 [17:08:19.021]
VERBOSE:
simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd,0x0000000000000000000000000000000000000000000000000000000000000001,0x0fb28a0148a05dac53a7c04241a34b5a9c133fbed3aae2af7a321610120c0b23,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c
17:08:19 [17:08:19.082]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:19 [17:08:19.349]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:19 [17:08:19.630]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:19 [17:08:19.938]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:19 [17:08:19.941]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5}
17:08:20 [17:08:20.251]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:20 [17:08:20.612]
INFO:
pxe:service Proving completed in 3119.941818000003ms
{"timings":{"total":3119.941818000003,"sync":17.629328999999416,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":429.55044199999975,"oracles":{"debugLog":{"times":[0.8001179999992019,0.5443820000000414,0.6251840000004449,0.6528350000007777,0.42205900000044494,0.25425600000016857,0.33672800000204006,0.4709709999988263]},"fetchTaggedLogs":{"times":[149.28109299999778]},"loadCapsule":{"times":[0.23699500000293483,0.35354800000277464,0.49063200000091456,0.21334500000011758,0.2848470000026282,0.25063500000032946]},"getSharedSecret":{"times":[3.9186790000021574]},"aes128Decrypt":{"times":[0.3310480000000098,1.4261520000000019]},"getPublicKeysAndPartialAddress":{"times":[1.7927700000000186]},"getKeyValidationRequest":{"times":[3.7342940000016824]},"deliverNote":{"times":[3.198311999996804]},"deleteCapsule":{"times":[0.23899600000004284]},"storeCapsule":{"times":[0.3190570000006119]},"getNotes":{"times":[1.6007960000024468]},"getAuthWitness":{"times":[0.1653440000009141]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05805099999997765]},"callPrivateFunction":{"times":[953.5484770000003,191.62687300000107]}}},{"functionName":"private_kernel_init","time":115.98632799999905},{"functionName":"ContractClassRegisterer:register","time":934.9013350000023,"oracles":{"loadCapsule":{"times":[6.271892000000662]},"notifyCreatedNullifier":{"times":[0.473149999997986]},"debugLog":{"times":[0.5824529999990773]},"notifyCreatedContractClassLog":{"times":[22.198773000000074]}}},{"functionName":"private_kernel_inner","time":179.17886},{"functionName":"ContractInstanceDeployer:deploy","time":113.45376000000033,"oracles":{"storeInExecutionCache":{"times":[0.1607140000014624]},"callPrivateFunction":{"times":[55.946836999999505]},"notifyCreatedNullifier":{"times":[0.233234999999695]},"debugLog":{"times":[0.45234999999956926]}}},{"functionName":"private_kernel_inner","time":195.5605719999985},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.96962599999824,"oracles":{}},{"functionName":"private_kernel_inner","time":199.01864899999782},{"functionName":"private_kernel_reset","time":242.98023499999908},{"functionName":"private_kernel_tail","time":115.70051199999943}],"unaccounted":540.0121700000091}}
17:08:20 [17:08:20.638]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:20 [17:08:20.766]
VERBOSE:
sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1)
{"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5}
17:08:20 [17:08:20.858]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:20 [17:08:20.872]
VERBOSE:
p2p:tx_pool Adding tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb to pool
{"eventName":"tx-added-to-pool","txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"}
17:08:20 [17:08:20.898]
INFO:
node Received tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb
{"txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb"}
17:08:20 [17:08:20.899]
INFO:
pxe:service Sent transaction 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb
17:08:21 [17:08:21.071]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:21 [17:08:21.278]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:21 [17:08:21.317]
VERBOSE:
sequencer Building block 4 for slot 5
{"slot":5,"blockNumber":4,"msgCount":0}
17:08:21 [17:08:21.332]
VERBOSE:
sequencer Processing pending txs
{"slot":5,"slotStart":"2025-06-13T17:14:13.000Z","now":"2025-06-13T17:14:18.526Z"}
17:08:21 [17:08:21.606]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:21 [17:08:21.703]
VERBOSE:
simulator:public-processor Processed tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb with no public calls in 252.76381800000308ms
{"txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb","txFee":838780800,"revertCode":0,"gasUsed":{"totalGas":{"daGas":39424,"l2Gas":16544},"billedGas":{"daGas":39424,"l2Gas":16544},"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":252.76381800000308}
17:08:21 [17:08:21.710]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3768353490000009s
{"duration":0.3768353490000009,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720}
17:08:21 [17:08:21.879]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:21 [17:08:21.907]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2afe1842cccc5246fb7faf1d99c79dd75f7162280ab81f22e63e2c2b6f428e3b","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":4,"slotNumber":5,"timestamp":1749834853,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":591.9254729999993,"publicProcessDuration":377.3022400000009,"rollupCircuitsDuration":575.2767759999988,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55}
17:08:21 [17:08:21.915]
VERBOSE:
sequencer Attesting committee is empty
17:08:22 [17:08:22.094]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:22 [17:08:22.337]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:22 [17:08:22.350]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8
17:08:22 [17:08:22.351]
VERBOSE:
sequencer-client Sent L1 transaction 0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8
{"gasLimit":470277,"maxFeePerGas":"1.261127724","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:22 [17:08:22.371]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on
http://127.0.0.1:8545
17:08:22 [17:08:22.376]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
17:08:22 [17:08:22.380]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
17:08:22 [17:08:22.384]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:22 [17:08:22.384]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55}
17:08:22 [17:08:22.385]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:22 [17:08:22.392]
INFO:
blob-sink:server Received blob sidecar for block 0xddd347e7cbd173c8eafa9d3245901f4eac33cd9f8e7f23555ee57892ec901ce0
17:08:22 [17:08:22.403]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xddd347e7cbd173c8eafa9d3245901f4eac33cd9f8e7f23555ee57892ec901ce0
17:08:22 [17:08:22.550]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:22 [17:08:22.587]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834889] on
http://127.0.0.1:8545
17:08:22 [17:08:22.588]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:22 [17:08:22.590]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834889
17:08:22 [17:08:22.591]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:14:49.000Z
{"offset":386410,"timeMs":1749834889000}
17:08:22 [17:08:22.591]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
17:08:22 [17:08:22.793]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:22 [17:08:22.817]
VERBOSE:
archiver:block-helper Store contract instance at 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd
17:08:22 [17:08:22.820]
VERBOSE:
archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c
17:08:22 [17:08:22.839]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x2afe1842cccc5246fb7faf1d99c79dd75f7162280ab81f22e63e2c2b6f428e3b","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":4,"slotNumber":5,"timestamp":1749834853,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","archiveNextLeafIndex":5}
17:08:22 [17:08:22.847]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
17:08:22 [17:08:22.925]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":10.914237000000867,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55}
17:08:22 [17:08:22.942]
INFO:
aztecjs:deploy_sent_tx Contract 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd successfully deployed.
17:08:22 [17:08:22.948]
INFO:
e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path
17:08:23 [17:08:23.002]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:23 [17:08:23.006]
VERBOSE:
pxe:service Updated pxe last block to 4
{"blockHash":{},"archive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","header":{"contentCommitment":{"blobsHash":"0x00c831c25b17da50de285068d0c5799ab3d8c014f7f521da7cdd93b43abed1d8","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749834853,"version":2254972989},"lastArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x18208fb86b767a64e97ca0e36772afa32779894c443f41e235888e2520162cd3","publicDataTree":"0x0352097dd1a1baf6de0e1c62f9e36c9052a0c9148f22cd7472431f7f2dc4f39b"},"totalFees":838780800,"totalManaUsed":16544}}
17:08:23 [17:08:23.015]
VERBOSE:
p2p Synched to latest block 4
17:08:23 [17:08:23.127]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:23 [17:08:23.143]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:23 [17:08:23.144]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:23 [17:08:23.210]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:23 [17:08:23.227]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:23 [17:08:23.235]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:23 [17:08:23.249]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:23 [17:08:23.250]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:23 [17:08:23.258]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:23 [17:08:23.258]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:23 [17:08:23.262]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:23 [17:08:23.264]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:23 [17:08:23.283]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:23 [17:08:23.339]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:23 [17:08:23.352]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:23 [17:08:23.414]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:23 [17:08:23.465]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6}
17:08:23 [17:08:23.483]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","selector":"0xd191fb1a"}
17:08:23 [17:08:23.499]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:23 [17:08:23.500]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:23 [17:08:23.559]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:23 [17:08:23.569]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:23 [17:08:23.584]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:23 [17:08:23.585]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:23 [17:08:23.592]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:23 [17:08:23.592]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:23 [17:08:23.595]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:23 [17:08:23.597]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:23 [17:08:23.604]
VERBOSE:
simulator Utility simulation for 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4.0xd191fb1a completed
17:08:23 [17:08:23.636]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:23 [17:08:23.652]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:23 [17:08:23.661]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:23 [17:08:23.766]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:23 [17:08:23.810]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:23 [17:08:23.810]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:23 [17:08:23.855]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:23 [17:08:23.890]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:23 [17:08:23.898]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:23 [17:08:23.912]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:23 [17:08:23.913]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:23 [17:08:23.938]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:23 [17:08:23.939]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:23 [17:08:23.951]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:23 [17:08:23.956]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:23 [17:08:23.971]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:24 [17:08:24.008]
VERBOSE:
simulator:private_execution Executing private function AuthWitTest:consume
{"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"}
17:08:24 [17:08:24.018]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6}
17:08:24 [17:08:24.063]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:24 [17:08:24.145]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:24 [17:08:24.174]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:24 [17:08:24.175]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:24 [17:08:24.280]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:24 [17:08:24.289]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:24 [17:08:24.301]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:24 [17:08:24.302]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:24 [17:08:24.310]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:24 [17:08:24.311]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:24 [17:08:24.313]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:24 [17:08:24.317]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:24 [17:08:24.320]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:24 [17:08:24.579]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:24 [17:08:24.806]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6}
17:08:24 [17:08:24.823]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:25 [17:08:25.065]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:25 [17:08:25.293]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:25 [17:08:25.660]
INFO:
pxe:service Proving completed in 1980.390636ms
{"timings":{"total":1980.390636,"sync":4.377049999999144,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":274.16154200000165,"oracles":{"debugLog":{"times":[0.7851580000024114,0.9484819999997853,0.6020140000000538,0.4978110000010929,0.7002559999964433,0.6990860000005341,0.7601070000018808,0.783806999999797]},"fetchTaggedLogs":{"times":[85.82374500000151]},"loadCapsule":{"times":[0.35765799999717274,0.23917500000243308,0.40077900000324007,0.34892799999943236,0.3593189999992319,0.3809580000015558]},"getSharedSecret":{"times":[5.599196999999549]},"aes128Decrypt":{"times":[0.6390250000004016,1.0115729999997711]},"getPublicKeysAndPartialAddress":{"times":[8.774059000003035]},"getKeyValidationRequest":{"times":[12.653146000000561]},"deliverNote":{"times":[12.808899999999994]},"deleteCapsule":{"times":[1.3426910000016505]},"storeCapsule":{"times":[0.45261000000027707]},"getNotes":{"times":[1.8348020000012184]},"getAuthWitness":{"times":[0.20404499999858672]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08517200000278535]},"callPrivateFunction":{"times":[369.69060700000045]}}},{"functionName":"private_kernel_init","time":97.57459100000051},{"functionName":"AuthWitTest:consume","time":80.13195699999415,"oracles":{"storeInExecutionCache":{"times":[0.13122300000031828]},"callPrivateFunction":{"times":[322.6577410000027]},"loadFromExecutionCache":{"times":[0.18016400000124122]},"notifyCreatedNullifier":{"times":[0.2672759999986738]}}},{"functionName":"private_kernel_inner","time":185.29175800000303},{"functionName":"SchnorrAccount:verify_private_authwit","time":282.722526000005,"oracles":{"debugLog":{"times":[0.8049080000018876,0.46875100000033854,0.6018230000008771,0.5935829999980342,0.41535899999871617,0.2801660000004631,0.3838889999969979]},"fetchTaggedLogs":{"times":[111.38994399999865]},"loadCapsule":{"times":[0.3014369999982591,0.22537499999816646,0.41624900000169873,0.9534319999984291,0.3352779999986524,0.2935169999982463]},"getSharedSecret":{"times":[5.278889000001072]},"aes128Decrypt":{"times":[0.42481000000043423,0.794157999996969]},"getPublicKeysAndPartialAddress":{"times":[1.945424000001367]},"getKeyValidationRequest":{"times":[2.004884999998467]},"deliverNote":{"times":[6.634290999998484]},"deleteCapsule":{"times":[0.38890900000114925]},"storeCapsule":{"times":[0.3235469999999623]},"getNotes":{"times":[2.012166000000434]},"getAuthWitness":{"times":[0.10757300000113901]},"storeInExecutionCache":{"times":[0.20955500000127358]}}},{"functionName":"private_kernel_inner","time":151.7104380000019},{"functionName":"private_kernel_reset","time":260.3828100000028},{"functionName":"private_kernel_tail","time":104.56400000000212}],"unaccounted":539.4739639999898}}
17:08:25 [17:08:25.689]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:25 [17:08:25.766]
VERBOSE:
sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1)
{"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6}
17:08:25 [17:08:25.787]
VERBOSE:
p2p:tx_pool Adding tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 to pool
{"eventName":"tx-added-to-pool","txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"}
17:08:25 [17:08:25.797]
INFO:
node Received tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47
{"txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47"}
17:08:25 [17:08:25.799]
INFO:
pxe:service Sent transaction 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47
17:08:25 [17:08:25.910]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.114]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.320]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.356]
VERBOSE:
sequencer Building block 5 for slot 6
{"slot":6,"blockNumber":5,"msgCount":0}
17:08:26 [17:08:26.381]
VERBOSE:
sequencer Processing pending txs
{"slot":6,"slotStart":"2025-06-13T17:14:49.000Z","now":"2025-06-13T17:14:52.791Z"}
17:08:26 [17:08:26.414]
VERBOSE:
simulator:public-processor Processed tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 with no public calls in 19.2015250000004ms
{"txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47","txFee":567840000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":11200},"billedGas":{"daGas":1536,"l2Gas":11200},"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":19.2015250000004}
17:08:26 [17:08:26.415]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032159039000001936s
{"duration":0.032159039000001936,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288}
17:08:26 [17:08:26.549]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.572]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1edea935100dce20a534e24ca41bcaaf8eb5b935de19d3aaf048f104abbd56eb","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":5,"slotNumber":6,"timestamp":1749834889,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":238.48935399999755,"publicProcessDuration":32.56073800000013,"rollupCircuitsDuration":193.4061529999999,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:26 [17:08:26.587]
VERBOSE:
sequencer Attesting committee is empty
17:08:26 [17:08:26.762]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.968]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:26 [17:08:26.982]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6
17:08:26 [17:08:26.982]
VERBOSE:
sequencer-client Sent L1 transaction 0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6
{"gasLimit":470246,"maxFeePerGas":"1.246951997","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:27 [17:08:27.016]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on
http://127.0.0.1:8545
17:08:27 [17:08:27.019]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834925] on
http://127.0.0.1:8545
17:08:27 [17:08:27.021]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
17:08:27 [17:08:27.025]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:27 [17:08:27.026]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
17:08:27 [17:08:27.028]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:27 [17:08:27.029]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:27 [17:08:27.030]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:27 [17:08:27.034]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834925
17:08:27 [17:08:27.035]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:15:25.000Z
{"offset":417965,"timeMs":1749834925000}
17:08:27 [17:08:27.035]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
17:08:27 [17:08:27.046]
INFO:
blob-sink:server Received blob sidecar for block 0x76cf2f45b5b2dc2d2d8ce4b3013e8b3a47be71e5535e50f30a30871517ae5194
17:08:27 [17:08:27.057]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x76cf2f45b5b2dc2d2d8ce4b3013e8b3a47be71e5535e50f30a30871517ae5194
17:08:27 [17:08:27.181]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:27 [17:08:27.386]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:27 [17:08:27.588]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:27 [17:08:27.782]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x1edea935100dce20a534e24ca41bcaaf8eb5b935de19d3aaf048f104abbd56eb","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":5,"slotNumber":6,"timestamp":1749834889,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","archiveNextLeafIndex":6}
17:08:27 [17:08:27.784]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
17:08:27 [17:08:27.793]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:27 [17:08:27.818]
VERBOSE:
pxe:service Updated pxe last block to 5
{"blockHash":{},"archive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","header":{"contentCommitment":{"blobsHash":"0x003703749dfadc7c5db6aaec0b8c946c8e691ea37c6f85c56e644a574f0db92c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749834889,"version":2254972989},"lastArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x20bf42cbee17300737bd33bc1f6353ee9b746f2cc35b21e266f7a94c0bcd24b4","publicDataTree":"0x2da1d92f39c8e6a1d2b7eb113fd48086b3320a6d46d5620478bbebc39a0741be"},"totalFees":567840000,"totalManaUsed":11200}}
17:08:27 [17:08:27.938]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":9.567427000001771,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:28 [17:08:28.001]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:28 [17:08:28.011]
VERBOSE:
p2p Synched to latest block 5
17:08:28 [17:08:28.176]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:28 [17:08:28.198]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:28 [17:08:28.199]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:28 [17:08:28.206]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:28 [17:08:28.252]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:28 [17:08:28.300]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:28 [17:08:28.322]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:28 [17:08:28.341]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:28 [17:08:28.342]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:28 [17:08:28.351]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:28 [17:08:28.352]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:28 [17:08:28.357]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:28 [17:08:28.360]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:28 [17:08:28.371]
WARN:
node Nullifier 1412136670559030468905179444353797816480882328436364701199225603777842628352 already exists in the tree
17:08:28 [17:08:28.374]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:28 [17:08:28.415]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:28 [17:08:28.436]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:28 [17:08:28.456]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:28 [17:08:28.641]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:28 [17:08:28.700]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:28 [17:08:28.700]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:28 [17:08:28.704]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:28 [17:08:28.798]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:28 [17:08:28.830]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:28 [17:08:28.843]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:28 [17:08:28.858]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:28 [17:08:28.859]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:28 [17:08:28.891]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:28 [17:08:28.892]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:28 [17:08:28.899]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:28 [17:08:28.901]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:28 [17:08:28.922]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:28 [17:08:28.927]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:28 [17:08:28.961]
VERBOSE:
simulator:private_execution Executing private function AuthWitTest:consume
{"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"}
17:08:29 [17:08:29.106]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:29 [17:08:29.142]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:29 [17:08:29.143]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:29 [17:08:29.147]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:29 [17:08:29.291]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:29 [17:08:29.325]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:29 [17:08:29.339]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:29 [17:08:29.341]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:29 [17:08:29.342]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:29 [17:08:29.355]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:29 [17:08:29.356]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:29 [17:08:29.360]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:29 [17:08:29.372]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:29 [17:08:29.377]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:29 [17:08:29.647]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:29 [17:08:29.901]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:30 [17:08:30.028]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:30 [17:08:30.193]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:30 [17:08:30.462]
INFO:
pxe:service Proving completed in 1981.917340999993ms
{"timings":{"total":1981.917340999993,"sync":12.571704999994836,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":418.9723159999994,"oracles":{"debugLog":{"times":[0.7411570000040228,0.5483820000008564,0.6999849999992875,0.6647949999969569,0.6883559999987483,0.3811790000036126,0.47650099999736995,0.8680499999973108]},"fetchTaggedLogs":{"times":[140.24124799999845]},"loadCapsule":{"times":[0.23893499999394407,0.22684499999741092,0.4869010000038543,0.3057859999971697,0.28225599999859696,0.4411289999989094]},"getSharedSecret":{"times":[5.053765000004205]},"aes128Decrypt":{"times":[0.7386570000016945,1.5366349999967497]},"getPublicKeysAndPartialAddress":{"times":[18.639311999999336]},"getKeyValidationRequest":{"times":[8.472222000003967]},"deliverNote":{"times":[7.046790000000328]},"deleteCapsule":{"times":[0.32317699999839533]},"storeCapsule":{"times":[0.3221080000002985]},"getNotes":{"times":[2.5594879999989644]},"getAuthWitness":{"times":[0.3083370000022114]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0659109999978682]},"callPrivateFunction":{"times":[493.6821770000024]}}},{"functionName":"private_kernel_init","time":75.05586100000073},{"functionName":"AuthWitTest:consume","time":104.96093699999619,"oracles":{"storeInExecutionCache":{"times":[0.13543299999582814]},"callPrivateFunction":{"times":[439.4147870000015]},"loadFromExecutionCache":{"times":[0.0892729999977746]},"notifyCreatedNullifier":{"times":[0.4396500000002561]}}},{"functionName":"private_kernel_inner","time":202.4075559999983},{"functionName":"SchnorrAccount:verify_private_authwit","time":378.46457600000576,"oracles":{"debugLog":{"times":[0.8208190000004834,0.5864730000030249,0.4426900000034948,0.7473769999996875,0.7014760000020033,0.4917510000013863,0.590213000003132]},"fetchTaggedLogs":{"times":[174.62099699999817]},"loadCapsule":{"times":[1.8270019999981741,2.0003450000003795,2.621649000000616,0.5886429999954998,0.24826600000233157,0.5615620000025956]},"getSharedSecret":{"times":[7.359416999999667]},"aes128Decrypt":{"times":[0.3120169999965583,0.8955400000049849]},"getPublicKeysAndPartialAddress":{"times":[3.8445080000019516]},"getKeyValidationRequest":{"times":[6.300703000000794]},"deliverNote":{"times":[16.960485000003246]},"deleteCapsule":{"times":[0.4436790000036126]},"storeCapsule":{"times":[0.7070449999955599]},"getNotes":{"times":[4.5117819999941275]},"getAuthWitness":{"times":[0.2346449999968172]},"storeInExecutionCache":{"times":[0.1677739999940968]}}},{"functionName":"private_kernel_inner","time":154.28758599999856},{"functionName":"private_kernel_reset","time":196.15082500000426},{"functionName":"private_kernel_tail","time":74.95400900000095}],"unaccounted":364.09196999999403}}
17:08:30 [17:08:30.485]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:30 [17:08:30.506]
VERBOSE:
p2p:tx_validator:tx_double_spend Rejecting tx 0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96 for repeating a nullifier
17:08:30 [17:08:30.509]
WARN:
node Received invalid tx 0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96: Existing nullifier
{"txHash":"0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96"}
17:08:30 [17:08:30.515]
ERROR:
pxe:service Error: Error: Invalid tx: Existing nullifier
17:08:30 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19)
17:08:30 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
17:08:30 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17)
17:08:30 [17:08:30.517]
INFO:
e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id
17:08:30 [17:08:30.588]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:30 [17:08:30.624]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:30 [17:08:30.638]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:30 [17:08:30.638]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:30 [17:08:30.695]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:30 [17:08:30.722]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:30 [17:08:30.728]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:30 [17:08:30.737]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:30 [17:08:30.738]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:30 [17:08:30.746]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:30 [17:08:30.746]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:30 [17:08:30.750]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:30 [17:08:30.751]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:30 [17:08:30.800]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:30 [17:08:30.805]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:30 [17:08:30.817]
INFO:
pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4
{"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x0b1b0dc7d086bbf4a5918c566dff9e6f520a95e2f3e3290435c9a2ab6c3c2d13"]}
17:08:30 [17:08:30.892]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:30 [17:08:30.931]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:30 [17:08:30.932]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:30 [17:08:30.936]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:30 [17:08:30.990]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:30 [17:08:30.996]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:31 [17:08:31.006]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:31 [17:08:31.006]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:31 [17:08:31.012]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:31 [17:08:31.012]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:31 [17:08:31.015]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:31 [17:08:31.016]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:31 [17:08:31.030]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:31 [17:08:31.044]
VERBOSE:
simulator:private_execution Executing private function AuthWitTest:consume
{"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"}
17:08:31 [17:08:31.122]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:31 [17:08:31.149]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:31 [17:08:31.149]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:31 [17:08:31.154]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:31 [17:08:31.201]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:31 [17:08:31.238]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:31 [17:08:31.248]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:31 [17:08:31.260]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:31 [17:08:31.261]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:31 [17:08:31.272]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:31 [17:08:31.272]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:31 [17:08:31.275]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:31 [17:08:31.277]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:31 [17:08:31.346]
INFO:
e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version
17:08:31 [17:08:31.379]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:31 [17:08:31.425]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:31 [17:08:31.438]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:31 [17:08:31.439]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:31 [17:08:31.489]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:31 [17:08:31.495]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:31 [17:08:31.503]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:31 [17:08:31.504]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:31 [17:08:31.510]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:31 [17:08:31.510]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:31 [17:08:31.512]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:31 [17:08:31.514]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:31 [17:08:31.555]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:31 [17:08:31.568]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:31 [17:08:31.583]
INFO:
pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4
{"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x2a8d07491cb93dac93f4c290d6385585e9df2a5ad77e0924e5a9aa79a74d507d"]}
17:08:31 [17:08:31.585]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:31 [17:08:31.710]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:31 [17:08:31.766]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:31 [17:08:31.766]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:31 [17:08:31.794]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:31 [17:08:31.843]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:31 [17:08:31.872]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:31 [17:08:31.882]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:31 [17:08:31.896]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:31 [17:08:31.897]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:31 [17:08:31.909]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:31 [17:08:31.910]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:31 [17:08:31.913]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:31 [17:08:31.915]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:31 [17:08:31.933]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:31 [17:08:31.956]
VERBOSE:
simulator:private_execution Executing private function AuthWitTest:consume
{"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"}
17:08:32 [17:08:32.042]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.068]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:32 [17:08:32.069]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.071]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:32 [17:08:32.145]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.155]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:32 [17:08:32.169]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:32 [17:08:32.170]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:32 [17:08:32.186]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:32 [17:08:32.186]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:32 [17:08:32.190]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:32 [17:08:32.192]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:32 [17:08:32.294]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:32 [17:08:32.355]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:32 [17:08:32.367]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:32 [17:08:32.368]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.425]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:32 [17:08:32.457]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.463]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:32 [17:08:32.473]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:32 [17:08:32.474]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:32 [17:08:32.480]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:32 [17:08:32.481]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:32 [17:08:32.483]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:32 [17:08:32.485]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:32 [17:08:32.498]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:32 [17:08:32.528]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:32 [17:08:32.538]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:32 [17:08:32.540]
INFO:
e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path
17:08:32 [17:08:32.644]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:32 [17:08:32.657]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:32 [17:08:32.658]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.704]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:32 [17:08:32.717]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.723]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:32 [17:08:32.734]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:32 [17:08:32.735]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:32 [17:08:32.740]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:32 [17:08:32.741]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:32 [17:08:32.744]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:32 [17:08:32.745]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:32 [17:08:32.758]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:32 [17:08:32.803]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:32 [17:08:32.809]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:32 [17:08:32.907]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.949]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:32 [17:08:32.949]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:32 [17:08:32.954]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:32 [17:08:32.999]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:33 [17:08:33.025]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:33 [17:08:33.031]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:33 [17:08:33.042]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:33 [17:08:33.043]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:33 [17:08:33.049]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:33 [17:08:33.049]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:33 [17:08:33.055]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:33 [17:08:33.057]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:33 [17:08:33.074]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:33 [17:08:33.190]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:33 [17:08:33.655]
INFO:
pxe:service Proving completed in 829.4188079999949ms
{"timings":{"total":829.4188079999949,"sync":3.259964000004402,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":221.72049100000004,"oracles":{"debugLog":{"times":[0.5122620000038296,0.5771430000022519,0.47080100000312086,0.40380899999581743,0.5867339999967953,0.2851860000009765,0.3004769999970449,0.5393820000026608]},"fetchTaggedLogs":{"times":[79.96550800000114]},"loadCapsule":{"times":[0.20331399999849964,0.20447499999863794,0.5201919999963138,0.19071400000393623,0.1757930000021588,0.20356500000343658]},"getSharedSecret":{"times":[3.915238000001409]},"aes128Decrypt":{"times":[0.24110499999369495,0.6120440000013332]},"getPublicKeysAndPartialAddress":{"times":[1.3724610000062967]},"getKeyValidationRequest":{"times":[1.420653000001039]},"deliverNote":{"times":[6.090228000000934]},"deleteCapsule":{"times":[0.24937599999975646]},"storeCapsule":{"times":[0.2694859999974142]},"getNotes":{"times":[1.6500280000036582]},"getAuthWitness":{"times":[0.26595599999564]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1779549999992014]},"notifyEnqueuedPublicFunctionCall":{"times":[0.36307799999485724]}}},{"functionName":"private_kernel_init","time":93.64675700000225},{"functionName":"private_kernel_reset","time":242.01710099999764},{"functionName":"private_kernel_tail","time":110.81064500000502}],"unaccounted":157.96384999998554}}
17:08:33 [17:08:33.690]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:33 [17:08:33.731]
VERBOSE:
sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1)
{"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7}
17:08:33 [17:08:33.739]
VERBOSE:
p2p:tx_pool Adding tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 to pool
{"eventName":"tx-added-to-pool","txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"}
17:08:33 [17:08:33.750]
INFO:
node Received tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783
{"txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783"}
17:08:33 [17:08:33.750]
INFO:
pxe:service Sent transaction 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783
17:08:33 [17:08:33.897]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:34 [17:08:34.100]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:34 [17:08:34.258]
VERBOSE:
sequencer Building block 6 for slot 7
{"slot":7,"blockNumber":6,"msgCount":0}
17:08:34 [17:08:34.272]
VERBOSE:
sequencer Processing pending txs
{"slot":7,"slotStart":"2025-06-13T17:15:25.000Z","now":"2025-06-13T17:15:32.237Z"}
17:08:34 [17:08:34.305]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:34 [17:08:34.348]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully.
{"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":43.975234000005}
17:08:34 [17:08:34.382]
VERBOSE:
simulator:public-processor Processed tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 with 1 public calls in 93.29388900000049ms
{"txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783","txFee":2327130000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":93.29388900000049}
17:08:34 [17:08:34.384]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.11048098700000264s
{"duration":0.11048098700000264,"rate":181424.88173100338,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320}
17:08:34 [17:08:34.511]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:34 [17:08:34.522]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 75796.0471915172 mana/s
{"blockHash":"0x20ccc2c198962d6a17a3ed9c4cfd4966b99d02bab80831747406e0020d847566","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":6,"slotNumber":7,"timestamp":1749834925,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":263.76293300000543,"publicProcessDuration":111.06633099999453,"rollupCircuitsDuration":250.51923299999908,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:34 [17:08:34.525]
VERBOSE:
sequencer Attesting committee is empty
17:08:34 [17:08:34.797]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:34 [17:08:34.806]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362
17:08:34 [17:08:34.806]
VERBOSE:
sequencer-client Sent L1 transaction 0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362
{"gasLimit":470295,"maxFeePerGas":"1.236063667","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:34 [17:08:34.823]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:34 [17:08:34.824]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:34 [17:08:34.824]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:34 [17:08:34.833]
INFO:
blob-sink:server Received blob sidecar for block 0xae266447b9be450594c8368fb6cf7192a2531b155e5cd82b131ac63ea61f2ade
17:08:34 [17:08:34.841]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xae266447b9be450594c8368fb6cf7192a2531b155e5cd82b131ac63ea61f2ade
17:08:34 [17:08:34.846]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834961] on
http://127.0.0.1:8545
17:08:34 [17:08:34.847]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:34 [17:08:34.849]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834961
17:08:34 [17:08:34.849]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:16:01.000Z
{"offset":446151,"timeMs":1749834961000}
17:08:34 [17:08:34.850]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
17:08:35 [17:08:35.000]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:35 [17:08:35.005]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on
http://127.0.0.1:8545
17:08:35 [17:08:35.006]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
17:08:35 [17:08:35.008]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
17:08:35 [17:08:35.203]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:35 [17:08:35.498]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:35 [17:08:35.516]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x20ccc2c198962d6a17a3ed9c4cfd4966b99d02bab80831747406e0020d847566","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":6,"slotNumber":7,"timestamp":1749834925,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","archiveNextLeafIndex":7}
17:08:35 [17:08:35.521]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
17:08:35 [17:08:35.625]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":10.9119370000044,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:35 [17:08:35.637]
VERBOSE:
p2p Synched to latest block 6
17:08:35 [17:08:35.703]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:35 [17:08:35.823]
VERBOSE:
pxe:service Updated pxe last block to 6
{"blockHash":{},"archive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","header":{"contentCommitment":{"blobsHash":"0x00420bd79da1ee21928d4bbfa1c3f237a526cc9d1d8fd7a0280daff3fda75b11","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749834925,"version":2254972989},"lastArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x0510b38d01e3452658be0ad382eec29fb089af1fe74d808ea13e18a7475d9163","publicDataTree":"0x07357b706e738e1ffa38c9024afdaf7d1b35aa46f0b473eea3ceb75fe8c1320e"},"totalFees":2327130000,"totalManaUsed":45900}}
17:08:35 [17:08:35.915]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:35 [17:08:35.957]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:35 [17:08:35.978]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:35 [17:08:35.979]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:35 [17:08:35.985]
VERBOSE:
sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1)
{"chainTipArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","blockNumber":7,"slot":8}
17:08:36 [17:08:36.072]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:36 [17:08:36.080]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:36 [17:08:36.096]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:36 [17:08:36.097]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:36 [17:08:36.106]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:36 [17:08:36.107]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:36 [17:08:36.110]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:36 [17:08:36.112]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:36 [17:08:36.122]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:36 [17:08:36.167]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:36 [17:08:36.172]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:36 [17:08:36.175]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:36 [17:08:36.296]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:36 [17:08:36.342]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:36 [17:08:36.343]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:36 [17:08:36.405]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:36 [17:08:36.416]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:36 [17:08:36.423]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:36 [17:08:36.436]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:36 [17:08:36.437]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:36 [17:08:36.447]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:36 [17:08:36.447]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:36 [17:08:36.453]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:36 [17:08:36.456]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:36 [17:08:36.473]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:36 [17:08:36.593]
VERBOSE:
sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1)
{"chainTipArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","blockNumber":7,"slot":8}
17:08:36 [17:08:36.676]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:36 [17:08:36.966]
INFO:
pxe:service Proving completed in 750.371100999997ms
{"timings":{"total":750.371100999997,"sync":3.4189470000055735,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":237.59195100000215,"oracles":{"debugLog":{"times":[0.8984210000053281,0.49149100000067847,0.5622730000031879,0.599794000001566,0.5449220000009518,0.3422279999940656,0.36151799999788636,0.5913929999951506]},"fetchTaggedLogs":{"times":[78.01534299999912]},"loadCapsule":{"times":[0.26177499999903375,0.24779499999567633,0.5289220000049681,0.4762209999971674,0.3299470000056317,0.4652810000043246]},"getSharedSecret":{"times":[4.0310110000064014]},"aes128Decrypt":{"times":[0.21846499999810476,1.113115000000107]},"getPublicKeysAndPartialAddress":{"times":[1.8640620000005583]},"getKeyValidationRequest":{"times":[2.9350869999980205]},"deliverNote":{"times":[5.847822000003362]},"deleteCapsule":{"times":[1.388000999999349]},"storeCapsule":{"times":[0.2404259999966598]},"getNotes":{"times":[3.1267510000034235]},"getAuthWitness":{"times":[0.2165949999980512]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09688299999834271]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08345199999894248]}}},{"functionName":"private_kernel_init","time":78.74233999999706},{"functionName":"private_kernel_reset","time":203.73493499999313},{"functionName":"private_kernel_tail","time":85.05107300000236}],"unaccounted":141.83185499999672}}
17:08:37 [17:08:37.019]
VERBOSE:
p2p:tx_pool Adding tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 to pool
{"eventName":"tx-added-to-pool","txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"}
17:08:37 [17:08:37.028]
INFO:
node Received tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89
{"txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89"}
17:08:37 [17:08:37.028]
INFO:
pxe:service Sent transaction 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89
17:08:37 [17:08:37.116]
VERBOSE:
sequencer Building block 7 for slot 8
{"slot":8,"blockNumber":7,"msgCount":0}
17:08:37 [17:08:37.131]
VERBOSE:
sequencer Processing pending txs
{"slot":8,"slotStart":"2025-06-13T17:16:01.000Z","now":"2025-06-13T17:16:03.282Z"}
17:08:37 [17:08:37.198]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:37 [17:08:37.200]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully.
{"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":49.19647199999599}
17:08:37 [17:08:37.228]
VERBOSE:
simulator:public-processor Processed tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 with 1 public calls in 85.20107600000483ms
{"txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89","txFee":3994298100,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":78783},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":52927},"billedGas":{"daGas":1536,"l2Gas":78783}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":85.20107600000483}
17:08:37 [17:08:37.232]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09976361499999621s
{"duration":0.09976361499999621,"rate":530524.0793449797,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320}
17:08:37 [17:08:37.342]
INFO:
sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 233763.814091214 mana/s
{"blockHash":"0x1d202ea4525597dc0e609c8122d827d1ea5a986ee8766c6ca6c8ced92157bc9f","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":7,"slotNumber":8,"timestamp":1749834961,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":225.75184300000547,"publicProcessDuration":100.34308900000178,"rollupCircuitsDuration":211.81211800000165,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:37 [17:08:37.344]
VERBOSE:
sequencer Attesting committee is empty
17:08:37 [17:08:37.434]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:37 [17:08:37.656]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:37 [17:08:37.666]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73
17:08:37 [17:08:37.666]
VERBOSE:
sequencer-client Sent L1 transaction 0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73
{"gasLimit":489789,"maxFeePerGas":"1.227700382","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:37 [17:08:37.675]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834997] on
http://127.0.0.1:8545
17:08:37 [17:08:37.677]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:37 [17:08:37.681]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:37 [17:08:37.681]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73","calldataSize":1444,"calldataGas":12328,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:37 [17:08:37.681]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:37 [17:08:37.684]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749834997
17:08:37 [17:08:37.684]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:16:37.000Z
{"offset":479316,"timeMs":1749834997000}
17:08:37 [17:08:37.684]
INFO:
aztecjs:utils:watcher Slot 8 was filled, jumped to next slot
17:08:37 [17:08:37.686]
INFO:
blob-sink:server Received blob sidecar for block 0xf2c808667811940f6268cb93f257a8e1dfc6b2637e9420fccbac197a71854e12
17:08:37 [17:08:37.691]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0xf2c808667811940f6268cb93f257a8e1dfc6b2637e9420fccbac197a71854e12
17:08:37 [17:08:37.859]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:37 [17:08:37.870]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on
http://127.0.0.1:8545
17:08:37 [17:08:37.871]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7
17:08:37 [17:08:37.873]
INFO:
aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7.
17:08:38 [17:08:38.172]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:38 [17:08:38.193]
INFO:
archiver Downloaded L2 block 7
{"blockHash":"0x1d202ea4525597dc0e609c8122d827d1ea5a986ee8766c6ca6c8ced92157bc9f","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":7,"slotNumber":8,"timestamp":1749834961,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","archiveNextLeafIndex":8}
17:08:38 [17:08:38.204]
INFO:
archiver Updated proven chain to block 7
{"provenBlockNumber":7}
17:08:38 [17:08:38.297]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":8.905181999994966,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:38 [17:08:38.317]
VERBOSE:
p2p Synched to latest block 7
17:08:38 [17:08:38.378]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:38 [17:08:38.583]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:38 [17:08:38.735]
VERBOSE:
sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1)
{"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9}
17:08:38 [17:08:38.786]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:38 [17:08:38.990]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:39 [17:08:39.047]
VERBOSE:
pxe:service Updated pxe last block to 7
{"blockHash":{},"archive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","header":{"contentCommitment":{"blobsHash":"0x00d67e5103ec3366dea1cc748c4a3bf0bb88f45da70858cf2e21393ec994afc4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1749834961,"version":2254972989},"lastArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x07cb15bc1a4dd2733b56a609596f6621e22f1118fd75c4fcb5b60676d8a9c47c","publicDataTree":"0x2a0fba3674e46b72c7275c94fd46553a0d1c2679d66cf4f125f1af36ae3a41ee"},"totalFees":3994298100,"totalManaUsed":78783}}
17:08:39 [17:08:39.140]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:39 [17:08:39.153]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:39 [17:08:39.153]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.199]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:39 [17:08:39.234]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.265]
VERBOSE:
sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1)
{"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9}
17:08:39 [17:08:39.274]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:39 [17:08:39.283]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:39 [17:08:39.284]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:39 [17:08:39.290]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:39 [17:08:39.291]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:39 [17:08:39.295]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:39 [17:08:39.298]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:39 [17:08:39.306]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:39 [17:08:39.339]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:39 [17:08:39.344]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:39 [17:08:39.347]
INFO:
e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage
17:08:39 [17:08:39.412]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:39 [17:08:39.438]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:39 [17:08:39.455]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:39 [17:08:39.455]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.519]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.526]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:39 [17:08:39.535]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:39 [17:08:39.536]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:39 [17:08:39.543]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:39 [17:08:39.544]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:39 [17:08:39.547]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:39 [17:08:39.548]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:39 [17:08:39.558]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:39 [17:08:39.598]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:39 [17:08:39.603]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:39 [17:08:39.675]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:39 [17:08:39.701]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.743]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:39 [17:08:39.743]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.817]
VERBOSE:
sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1)
{"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9}
17:08:39 [17:08:39.845]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:39 [17:08:39.884]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:39 [17:08:39.902]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:39 [17:08:39.902]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:39 [17:08:39.915]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:39 [17:08:39.916]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:39 [17:08:39.919]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:39 [17:08:39.921]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:39 [17:08:39.939]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:39 [17:08:39.957]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:40 [17:08:40.218]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:40 [17:08:40.559]
INFO:
pxe:service Proving completed in 943.8864850000027ms
{"timings":{"total":943.8864850000027,"sync":3.5673600000009174,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":307.13065300000017,"oracles":{"debugLog":{"times":[0.7321569999985513,3.6611620000039693,0.4168089999948279,0.3371670000051381,0.6329439999972237,0.3973390000028303,0.3509879999983241,0.8562000000019907]},"fetchTaggedLogs":{"times":[133.52201799999602]},"loadCapsule":{"times":[0.18918399999529356,5.328620000000228,0.6199339999948279,0.2366660000043339,0.23210500000277534,0.22582500000135042]},"getSharedSecret":{"times":[5.5065449999965494]},"aes128Decrypt":{"times":[0.24993600000016158,0.6627840000001015]},"getPublicKeysAndPartialAddress":{"times":[2.0159960000019055]},"getKeyValidationRequest":{"times":[3.8267160000032163]},"deliverNote":{"times":[3.5713409999953]},"deleteCapsule":{"times":[0.2790160000004107]},"storeCapsule":{"times":[0.278625999999349]},"getNotes":{"times":[1.704967999998189]},"getAuthWitness":{"times":[0.29892600000312086]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0815020000009099]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09205199999996694]}}},{"functionName":"private_kernel_init","time":102.20779000000039},{"functionName":"private_kernel_reset","time":244.23760000000038},{"functionName":"private_kernel_tail","time":95.90381799999886}],"unaccounted":190.839264000002}}
17:08:40 [17:08:40.587]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:40 [17:08:40.681]
VERBOSE:
sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1)
{"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9}
17:08:40 [17:08:40.692]
VERBOSE:
p2p:tx_pool Adding tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 to pool
{"eventName":"tx-added-to-pool","txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"}
17:08:40 [17:08:40.704]
INFO:
node Received tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78
{"txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78"}
17:08:40 [17:08:40.704]
INFO:
pxe:service Sent transaction 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78
17:08:40 [17:08:40.791]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:40 [17:08:40.993]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:41 [17:08:41.205]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:41 [17:08:41.210]
VERBOSE:
sequencer Building block 8 for slot 9
{"slot":9,"blockNumber":8,"msgCount":0}
17:08:41 [17:08:41.228]
VERBOSE:
sequencer Processing pending txs
{"slot":9,"slotStart":"2025-06-13T17:16:37.000Z","now":"2025-06-13T17:16:40.544Z"}
17:08:41 [17:08:41.296]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully.
{"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":25.48124600000301}
17:08:41 [17:08:41.326]
VERBOSE:
simulator:public-processor Processed tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 with 1 public calls in 78.1144359999962ms
{"txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78","txFee":2327130000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":78.1144359999962}
17:08:41 [17:08:41.328]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09885574400000041s
{"duration":0.09885574400000041,"rate":202760.0945474642,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320}
17:08:41 [17:08:41.471]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:41 [17:08:41.484]
INFO:
sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 73108.87849882603 mana/s
{"blockHash":"0x0613b56461818c9efd552fb3fd8bd1fe7f065465f2854bc82f42148b6151f8cb","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":8,"slotNumber":9,"timestamp":1749834997,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":273.53436299999885,"publicProcessDuration":99.27490399999806,"rollupCircuitsDuration":258.89331200000015,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:41 [17:08:41.486]
VERBOSE:
sequencer Attesting committee is empty
17:08:41 [17:08:41.680]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:41 [17:08:41.814]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f
17:08:41 [17:08:41.814]
VERBOSE:
sequencer-client Sent L1 transaction 0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f
{"gasLimit":470220,"maxFeePerGas":"1.22127985","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:41 [17:08:41.830]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835033] on
http://127.0.0.1:8545
17:08:41 [17:08:41.832]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:41 [17:08:41.833]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:41 [17:08:41.833]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:41 [17:08:41.835]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:41 [17:08:41.839]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749835033
17:08:41 [17:08:41.840]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:17:13.000Z
{"offset":511161,"timeMs":1749835033000}
17:08:41 [17:08:41.840]
INFO:
aztecjs:utils:watcher Slot 9 was filled, jumped to next slot
17:08:41 [17:08:41.843]
INFO:
blob-sink:server Received blob sidecar for block 0x42200659368445d07f10f298b385a92ca0746075eb2cb027fae338084d5b9db4
17:08:41 [17:08:41.849]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x42200659368445d07f10f298b385a92ca0746075eb2cb027fae338084d5b9db4
17:08:41 [17:08:41.883]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:41 [17:08:41.896]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on
http://127.0.0.1:8545
17:08:41 [17:08:41.898]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8
17:08:41 [17:08:41.903]
INFO:
aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8.
17:08:42 [17:08:42.085]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:42 [17:08:42.302]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:42 [17:08:42.611]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:42 [17:08:42.630]
INFO:
archiver Downloaded L2 block 8
{"blockHash":"0x0613b56461818c9efd552fb3fd8bd1fe7f065465f2854bc82f42148b6151f8cb","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":8,"slotNumber":9,"timestamp":1749834997,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","archiveNextLeafIndex":9}
17:08:42 [17:08:42.633]
INFO:
archiver Updated proven chain to block 8
{"provenBlockNumber":8}
17:08:42 [17:08:42.736]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":8.307838000000629,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:42 [17:08:42.747]
VERBOSE:
p2p Synched to latest block 8
17:08:42 [17:08:42.819]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:42 [17:08:42.834]
VERBOSE:
pxe:service Updated pxe last block to 8
{"blockHash":{},"archive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","header":{"contentCommitment":{"blobsHash":"0x0095e1518dfafcc1e1d046b0952d2f833cb18bbad5cb544a688e6bbdf1d22ece","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1749834997,"version":2254972989},"lastArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x1e70d768909f9e32d70476e725c07b73b017a84c5378b2b10c8a11684e5429fd","publicDataTree":"0x2d1130d82dc7b33310598e9fd34f3b67e0b75831560295e4ead2330a47fdd975"},"totalFees":2327130000,"totalManaUsed":45900}}
17:08:42 [17:08:42.955]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:42 [17:08:42.971]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:42 [17:08:42.971]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:43 [17:08:43.020]
VERBOSE:
sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1)
{"chainTipArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","blockNumber":9,"slot":10}
17:08:43 [17:08:43.024]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:43 [17:08:43.066]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:43 [17:08:43.074]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:43 [17:08:43.089]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:43 [17:08:43.090]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:43 [17:08:43.096]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:43 [17:08:43.096]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:43 [17:08:43.099]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:43 [17:08:43.101]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:43 [17:08:43.111]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:43 [17:08:43.151]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:43 [17:08:43.161]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:43 [17:08:43.233]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:43 [17:08:43.263]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:43 [17:08:43.310]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:43 [17:08:43.310]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:43 [17:08:43.391]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:43 [17:08:43.398]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:43 [17:08:43.413]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:43 [17:08:43.414]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:43 [17:08:43.422]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:43 [17:08:43.423]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:43 [17:08:43.426]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:43 [17:08:43.428]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:43 [17:08:43.441]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer
17:08:43 [17:08:43.542]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:44 [17:08:44.011]
INFO:
pxe:service Proving completed in 839.3453420000005ms
{"timings":{"total":839.3453420000005,"sync":4.449619999999413,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":239.85967200000596,"oracles":{"debugLog":{"times":[0.666135999999824,0.6373149999999441,0.6234340000009979,0.6093439999967813,0.5426930000030552,0.49331099999835715,0.36799799999425886,0.5416820000027656]},"fetchTaggedLogs":{"times":[86.00854500000423]},"loadCapsule":{"times":[0.30139699999563163,0.16017399999691406,0.4825510000009672,0.20374400000582682,0.25856600000406615,0.2467160000014701]},"getSharedSecret":{"times":[4.571812999995018]},"aes128Decrypt":{"times":[0.2919670000046608,1.13639599999442]},"getPublicKeysAndPartialAddress":{"times":[2.01942599999893]},"getKeyValidationRequest":{"times":[1.9325240000034682]},"deliverNote":{"times":[3.127270999997563]},"deleteCapsule":{"times":[0.4111689999990631]},"storeCapsule":{"times":[0.35610799999994924]},"getNotes":{"times":[1.792951000003086]},"getAuthWitness":{"times":[0.188984000000346]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07294199999887496]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11653300000034506]}}},{"functionName":"private_kernel_init","time":121.19917900000291},{"functionName":"private_kernel_reset","time":218.36778600000252},{"functionName":"private_kernel_tail","time":109.296190999994}],"unaccounted":146.17289399999572}}
17:08:44 [17:08:44.040]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:44 [17:08:44.046]
VERBOSE:
sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1)
{"chainTipArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","blockNumber":9,"slot":10}
17:08:44 [17:08:44.065]
VERBOSE:
p2p:tx_pool Adding tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 to pool
{"eventName":"tx-added-to-pool","txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"}
17:08:44 [17:08:44.074]
INFO:
node Received tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9
{"txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9"}
17:08:44 [17:08:44.074]
INFO:
pxe:service Sent transaction 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9
17:08:44 [17:08:44.253]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:44 [17:08:44.461]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:44 [17:08:44.579]
VERBOSE:
sequencer Building block 9 for slot 10
{"slot":10,"blockNumber":9,"msgCount":0}
17:08:44 [17:08:44.591]
VERBOSE:
sequencer Processing pending txs
{"slot":10,"slotStart":"2025-06-13T17:17:13.000Z","now":"2025-06-13T17:17:15.752Z"}
17:08:44 [17:08:44.627]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully.
{"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":12.731937999997172}
17:08:44 [17:08:44.649]
VERBOSE:
simulator:public-processor Processed tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 with 1 public calls in 42.96564099999523ms
{"txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9","txFee":276318000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":42.96564099999523}
17:08:44 [17:08:44.650]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05862859600000229s
{"duration":0.05862859600000229,"rate":341880.948334482,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320}
17:08:44 [17:08:44.674]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:44 [17:08:44.781]
INFO:
sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 98443.89880431049 mana/s
{"blockHash":"0x08f552cb2880b42d8567a1ad726a0bf2bbdc7031aaa448ab3f91b0baa323ef32","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":9,"slotNumber":10,"timestamp":1749835033,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":203.03862899999513,"publicProcessDuration":59.09041499999876,"rollupCircuitsDuration":190.8262229999964,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:44 [17:08:44.799]
VERBOSE:
sequencer Attesting committee is empty
17:08:44 [17:08:44.882]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:45 [17:08:45.098]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:45 [17:08:45.105]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261
17:08:45 [17:08:45.105]
VERBOSE:
sequencer-client Sent L1 transaction 0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261
{"gasLimit":470260,"maxFeePerGas":"1.216344976","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
17:08:45 [17:08:45.118]
INFO:
ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on
http://127.0.0.1:8545
17:08:45 [17:08:45.123]
INFO:
ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835069] on
http://127.0.0.1:8545
17:08:45 [17:08:45.125]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9
17:08:45 [17:08:45.129]
INFO:
ethereum:cheat_codes Calling hardhat_mine with params: [1] on
http://127.0.0.1:8545
17:08:45 [17:08:45.132]
INFO:
aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9.
17:08:45 [17:08:45.136]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:08:45 [17:08:45.137]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:45 [17:08:45.138]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
17:08:45 [17:08:45.144]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749835069
17:08:45 [17:08:45.144]
WARN:
foundation:test-date-provider Time set to 2025-06-13T17:17:49.000Z
{"offset":543856,"timeMs":1749835069000}
17:08:45 [17:08:45.145]
INFO:
aztecjs:utils:watcher Slot 10 was filled, jumped to next slot
17:08:45 [17:08:45.147]
INFO:
blob-sink:server Received blob sidecar for block 0x525ac5f1a4ccff4caf726e6123bad783b4beda1b8b1064cbd0fd1b10a3294ee1
17:08:45 [17:08:45.157]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x525ac5f1a4ccff4caf726e6123bad783b4beda1b8b1064cbd0fd1b10a3294ee1
17:08:45 [17:08:45.301]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:45 [17:08:45.505]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:45 [17:08:45.784]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:45 [17:08:45.811]
INFO:
archiver Downloaded L2 block 9
{"blockHash":"0x08f552cb2880b42d8567a1ad726a0bf2bbdc7031aaa448ab3f91b0baa323ef32","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":9,"slotNumber":10,"timestamp":1749835033,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","archiveNextLeafIndex":10}
17:08:45 [17:08:45.815]
INFO:
archiver Updated proven chain to block 9
{"provenBlockNumber":9}
17:08:45 [17:08:45.920]
INFO:
world_state World state updated with L2 block 9
{"eventName":"l2-block-handled","duration":10.438935999998648,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:08:45 [17:08:45.932]
VERBOSE:
p2p Synched to latest block 9
17:08:46 [17:08:45.999]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:46 [17:08:46.115]
VERBOSE:
pxe:service Updated pxe last block to 9
{"blockHash":{},"archive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","header":{"contentCommitment":{"blobsHash":"0x003ddf6b3bd1f78b0f56ff133f4212434155d85075cd3a09b1019d05c8ce7c56","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1749835033,"version":2254972989},"lastArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x246789739844737f77be1bc0c18fc048cefa06d4f1e3b23ee66d594ab82fc3fb","publicDataTree":"0x09d081ef5a04ad28760f44b97bb0d51c77dfaa56657c769d0a76c2b55d470163"},"totalFees":276318000,"totalManaUsed":45900}}
17:08:46 [17:08:46.209]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:46 [17:08:46.258]
VERBOSE:
simulator Executing utility function lookup_validity
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"}
17:08:46 [17:08:46.275]
VERBOSE:
simulator:client_view_context:debug_log Performing message discovery
17:08:46 [17:08:46.276]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:46 [17:08:46.289]
VERBOSE:
sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1)
{"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11}
17:08:46 [17:08:46.374]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"}
17:08:46 [17:08:46.382]
VERBOSE:
simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c
17:08:46 [17:08:46.394]
VERBOSE:
simulator:client_view_context:debug_log Processing private note msg
17:08:46 [17:08:46.396]
VERBOSE:
simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:46 [17:08:46.410]
VERBOSE:
simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:46 [17:08:46.410]
VERBOSE:
simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:46 [17:08:46.417]
VERBOSE:
pxe:service Added note
{"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"}
17:08:46 [17:08:46.417]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:46 [17:08:46.420]
VERBOSE:
simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:46 [17:08:46.435]
VERBOSE:
simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed
17:08:46 [17:08:46.469]
VERBOSE:
simulator Executing utility function utility_is_consumable
{"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"}
17:08:46 [17:08:46.474]
VERBOSE:
simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed
17:08:46 [17:08:46.520]
INFO:
pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4
{"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x1f608cf6419f331ae78905db2c3dbb6c52c75644232b8ed0597e31ef9078108d"]}
17:08:46 [17:08:46.611]
VERBOSE:
simulator:private_execution Executing private function SchnorrAccount:entrypoint
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:46 [17:08:46.661]
VERBOSE:
simulator:client_execution_context:debug_log Performing message discovery
17:08:46 [17:08:46.661]
VERBOSE:
pxe:service Searching for tagged logs
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:46 [17:08:46.662]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:46 [17:08:46.749]
VERBOSE:
pxe:service Searching for nullifiers of known notes
{"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"}
17:08:46 [17:08:46.760]
VERBOSE:
simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e
17:08:46 [17:08:46.773]
VERBOSE:
simulator:client_execution_context:debug_log Processing private note msg
17:08:46 [17:08:46.775]
VERBOSE:
simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001
17:08:46 [17:08:46.783]
VERBOSE:
simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes
17:08:46 [17:08:46.783]
VERBOSE:
simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message
17:08:46 [17:08:46.786]
VERBOSE:
pxe:service Added note
{"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"}
17:08:46 [17:08:46.788]
VERBOSE:
simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes
17:08:46 [17:08:46.815]
VERBOSE:
simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer
17:08:46 [17:08:46.868]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:46 [17:08:46.937]
VERBOSE:
sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1)
{"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11}
17:08:47 [17:08:47.392]
INFO:
ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on
http://127.0.0.1:8545
17:08:47 [17:08:47.411]
VERBOSE:
node Simulating public calls for tx 0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29
{"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":10,"slotNumber":11,"timestamp":1749835069,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29","blockNumber":10}
17:08:47 [17:08:47.468]
VERBOSE:
sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1)
{"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11}
17:08:47 [17:08:47.470]
VERBOSE:
simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: .
{"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":39.23046000000613}
17:08:47 [17:08:47.471]
WARN:
simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed:
17:08:47 [17:08:47.497]
VERBOSE:
simulator:public-processor Processed tx 0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29 with 1 public calls in 74.0139909999998ms
{"txHash":"0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29","txFee":369032020,"revertCode":1,"revertReason":{"originalMessage":"Assertion failed: ","functionErrorStack":[{"contractAddress":"0x0000000000000000000000000000000000000000000000000000000000000001","functionName":"0x2716b166"}],"noirErrorStack":["0.46","0.2567","0.7632"],"revertData":["0x000000000000000000000000000000000000000000000000b0c4aef6fe76bc3f"]},"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":61301},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":35445},"billedGas":{"daGas":1024,"l2Gas":61301}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":74.0139909999998}
17:08:47 [17:08:47.500]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08377955199999997s
{"duration":0.08377955199999997,"rate":423074.59462184773,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256}
17:08:47
PASS src/e2e_authwit.test.ts
17:08:47 e2e_authwit_tests
17:08:47 Private
17:08:47 arbitrary data
17:08:47
✓ happy path (7572 ms)
17:08:47 failure case
17:08:47
✓ invalid chain id (828 ms)
17:08:47
✓ invalid version (1194 ms)
17:08:47 Public
17:08:47 arbitrary data
17:08:47
✓ happy path (6806 ms)
17:08:47 failure case
17:08:47
✓ cancel before usage (8186 ms)
17:08:47
17:08:47
Test Suites: 1 passed, 1 total
17:08:47
Tests: 5 passed, 5 total
17:08:47
Snapshots: 0 total
17:08:47
Time: 51.761 s
17:08:47
Ran all test suites matching /src\/e2e_authwit.test.ts/i
.
17:08:47
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?