ACI ·

Parent Log: http://ci.aztec-labs.com/a259c1275bd5145f Command: be792e9a8a7f847e:ISOLATE=1:NAME=e2e_simple yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_simple.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/a8c553f203c98e5ca274e763c8e51daaaaf760d6 Env: REF_NAME=gh-readonly-queue/next/pr-15017-30660269b33bab8cca354c41659533acf4d48e07 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 09:35:47 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15017_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_be83f9b9c508743c_next 09:35:47 +++ id -u 09:35:47 +++ id -g 09:35:47 ++ docker run -d --name e2e_simple --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_simple.test.ts'\''' 09:35:48 + cid=5d0ef77d620e8f995a881a5cc32f2c56fc2ef29507f5a979ffd85d154fe9ce24 09:35:48 + set +x 09:35:48 {"level":25,"time":1749807348986,"pid":12,"hostname":"5d0ef77d620e","module":"logger","msg":"Logger initialized with level verbose"} 09:35:55 [09:35:55.649] INFO: e2e:e2e_simple Logging metrics to log/unknown.jsonl 09:35:56 [09:35:56.365] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-b3JGVv/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 09:35:56 [09:35:56.408] INFO: e2e:e2e_simple Calling anvil_setBlockTimestampInterval with params: [4] 09:35:56 [09:35:56.435] WARN: e2e:e2e_simple Set block interval to 4 09:35:56 [09:35:56.435] VERBOSE: e2e:e2e_simple Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 09:35:56 [09:35:56.491] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 09:36:00 [09:36:00.531] VERBOSE: e2e:e2e_simple Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 09:36:00 [09:36:00.552] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 09:36:04 [09:36:04.604] VERBOSE: e2e:e2e_simple Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 09:36:04 [09:36:04.640] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x127d08cafb8afc3d7c988fa49d05483d6d2b44a017de0544d9d53ed8e954f028 {"gasLimit":3068916,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 09:36:07 [09:36:07.671] VERBOSE: e2e:e2e_simple Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 09:36:07 [09:36:07.697] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xdb9612b2166822d6497afb75ab3fe675145b118f9d3ef58bc23bdb9816e5d0f5 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 09:36:11 [09:36:11.722] VERBOSE: e2e:e2e_simple Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 09:36:11 [09:36:11.740] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x32ed4059fca555e8be9e05117cb7e979fafb635b31d08729d246c0704eaa1138 {"gasLimit":1966612,"maxFeePerGas":"3.602497631","maxPriorityFeePerGas":"2.48832"} 09:36:15 [09:36:15.777] VERBOSE: e2e:e2e_simple Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 09:36:15 [09:36:15.800] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xf29078d6fdb1fd1334c85ea0a8f17d2b4c4766e863a0822c2fb665091b723499 {"gasLimit":3042380,"maxFeePerGas":"3.968738902","maxPriorityFeePerGas":"2.985984"} 09:36:19 [09:36:19.829] VERBOSE: e2e:e2e_simple Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 09:36:19 [09:36:19.845] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 {"gasLimit":100000,"maxFeePerGas":"4.456512857","maxPriorityFeePerGas":"3.5831808"} 09:36:19 [09:36:19.846] VERBOSE: e2e:e2e_simple Set governance on GSE in 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 09:36:19 [09:36:19.860] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x4888061140170424906ce13c4c3838ee3a5ec9410fecd6eed95b15906dab9050 {"gasLimit":391705,"maxFeePerGas":"4.456512857","maxPriorityFeePerGas":"3.5831808"} 09:36:23 [09:36:23.888] VERBOSE: e2e:e2e_simple Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 09:36:23 [09:36:23.888] VERBOSE: e2e:e2e_simple Waiting for deployments to complete 09:36:23 [09:36:23.889] INFO: e2e:e2e_simple Waiting for 7 transactions to be mined... 09:36:23 [09:36:23.923] INFO: e2e:e2e_simple All transactions mined successfully 09:36:23 [09:36:23.938] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x177575c653ff5213a262c0c0ef21dfa58b8a2c76d39c4e5ec9943bb7b5b1a704 {"gasLimit":100000,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 09:36:23 [09:36:23.939] VERBOSE: e2e:e2e_simple Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x177575c653ff5213a262c0c0ef21dfa58b8a2c76d39c4e5ec9943bb7b5b1a704 09:36:23 [09:36:23.961] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x2944863d9e16ddf5925039bc3364abd9aa64ac4c7183e6d5f0ae24dbcd41b000 {"gasLimit":56661,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 09:36:23 [09:36:23.982] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x2f82c0b62e200467bfdbd2e4f44d9f0cd106201669683608b84ea9079ab3c9be {"gasLimit":339705,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 09:36:28 [09:36:28.009] VERBOSE: e2e:e2e_simple Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 09:36:28 [09:36:28.021] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x6030fb5a4d52e10ec7b6902f91204ea21a8429950ef0b1fad61f1e0ac9b3fdb8 {"gasLimit":56804,"maxFeePerGas":"5.847000973","maxPriorityFeePerGas":"5.159780352"} 09:36:28 [09:36:28.022] VERBOSE: e2e:e2e_simple Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x6030fb5a4d52e10ec7b6902f91204ea21a8429950ef0b1fad61f1e0ac9b3fdb8 09:36:28 [09:36:28.055] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xd86b9b81a47ff6c8bd5a7f806c252faae3f76d6ce9cd74cb8d44e3a2f3bb6feb {"gasLimit":2474287,"maxFeePerGas":"5.847000973","maxPriorityFeePerGas":"5.159780352"} 09:36:32 [09:36:32.081] VERBOSE: e2e:e2e_simple Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 09:36:32 [09:36:32.097] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x8f799f8affd98462c8826410b2faaa24e20ec23611c53bccadbd80b1e2b97255 {"gasLimit":56804,"maxFeePerGas":"6.795217167","maxPriorityFeePerGas":"6.191736422"} 09:36:32 [09:36:32.100] VERBOSE: e2e:e2e_simple Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x8f799f8affd98462c8826410b2faaa24e20ec23611c53bccadbd80b1e2b97255 09:36:32 [09:36:32.101] VERBOSE: e2e:e2e_simple Waiting for deployments to complete 09:36:32 [09:36:32.101] INFO: e2e:e2e_simple Waiting for 9 transactions to be mined... 09:36:32 [09:36:32.140] INFO: e2e:e2e_simple All transactions mined successfully 09:36:36 [09:36:36.149] VERBOSE: e2e:e2e_simple Deployed shared contracts 09:36:36 [09:36:36.209] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x89c898ffccb73c27f70bb76e83eaac57283cbb5df592d71c595fe62ed237e2b4 {"gasLimit":84837,"maxFeePerGas":"7.968736753","maxPriorityFeePerGas":"7.430083706"} 09:36:36 [09:36:36.210] VERBOSE: e2e:e2e_simple Funded reward distributor with 10000000000000000000000000 fee asset in 0x89c898ffccb73c27f70bb76e83eaac57283cbb5df592d71c595fe62ed237e2b4 09:36:36 [09:36:36.269] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xcc3f1c912389942fd43db443a3ca8ba016fad7c8b891a1026f074638078f8409 {"gasLimit":152965,"maxFeePerGas":"7.968736753","maxPriorityFeePerGas":"7.430083706"} 09:36:40 [09:36:40.364] VERBOSE: e2e:e2e_simple Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 09:36:40 [09:36:40.364] VERBOSE: e2e:e2e_simple Rollup config args {"aztecSlotDuration":12,"aztecEpochDuration":4,"targetCommitteeSize":48,"aztecProofSubmissionWindow":8,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 09:36:40 [09:36:40.380] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x0801bb788b69f8f335018a906f5faba49c7c3482bd438b39740c843b75cd4804 {"gasLimit":86383,"maxFeePerGas":"9.387634348","maxPriorityFeePerGas":"8.916100447"} 09:36:44 [09:36:44.433] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x07b435f4377cb110bc61c3ff5ffa01f95d2339655883efc7a32a9aeb90af5eac {"gasLimit":5075920,"maxFeePerGas":"11.112691396","maxPriorityFeePerGas":"10.699320536"} 09:36:48 [09:36:48.507] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x5c5bf24350d4b2c8f3284b34a0936fbece88bf5d20ffe2561a8b83f0bb3dff15 {"gasLimit":2439043,"maxFeePerGas":"13.20113212","maxPriorityFeePerGas":"12.839184643"} 09:36:52 [09:36:52.534] VERBOSE: e2e:e2e_simple Awaiting for linked libraries to be deployed 09:36:52 [09:36:52.590] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xfb2beee958287f85837ace4220d380de73e085292a2075ceaa9a128573df8626 {"gasLimit":10498896,"maxFeePerGas":"15.736484062","maxPriorityFeePerGas":"15.407021571"} 09:36:56 [09:36:56.620] VERBOSE: e2e:e2e_simple Deployed Rollup at 0x3aa5ebb10dc797cac828524e59a333d0a371443c {"aztecSlotDuration":12,"aztecEpochDuration":4,"targetCommitteeSize":48,"aztecProofSubmissionWindow":8,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 09:36:56 [09:36:56.620] INFO: e2e:e2e_simple Waiting for 11 transactions to be mined... 09:36:56 [09:36:56.649] INFO: e2e:e2e_simple All transactions mined successfully 09:36:56 [09:36:56.650] VERBOSE: e2e:e2e_simple All core contracts have been deployed 09:36:56 [09:36:56.677] VERBOSE: e2e:e2e_simple Sent L1 transaction 0xe73d518fc094cae0b2ba895d761e44e34b023ade25570f6ad5ede4194229f40a {"gasLimit":64317,"maxFeePerGas":"18.782285936","maxPriorityFeePerGas":"18.488425885"} 09:36:56 [09:36:56.677] VERBOSE: e2e:e2e_simple Funding fee juice portal with 10000000000000000000000 fee juice in 0xe73d518fc094cae0b2ba895d761e44e34b023ade25570f6ad5ede4194229f40a (accelerated test deployments) 09:36:56 [09:36:56.694] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x10c1154f1245920a8b17baeeb001fbdf3491e72bf0099137fc05b9b34a001014 {"gasLimit":1040131,"maxFeePerGas":"18.782285936","maxPriorityFeePerGas":"18.488425885"} 09:36:59 [09:36:59.718] VERBOSE: e2e:e2e_simple Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 09:36:59 [09:36:59.751] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x514321a7d3dd051eadd0c7e5dc2980f8565aa625f2995691ebc97df237cdb20a {"gasLimit":116846,"maxFeePerGas":"22.464663649","maxPriorityFeePerGas":"22.186111062"} 09:36:59 [09:36:59.751] VERBOSE: e2e:e2e_simple Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x514321a7d3dd051eadd0c7e5dc2980f8565aa625f2995691ebc97df237cdb20a 09:36:59 [09:36:59.790] VERBOSE: e2e:e2e_simple Sent L1 transaction 0x4e6c12d8b542741109480d1d242560fa356b047a86c2fb5e0ff1e4aef3ac15db {"gasLimit":109478,"maxFeePerGas":"22.464663649","maxPriorityFeePerGas":"22.186111062"} 09:36:59 [09:36:59.791] VERBOSE: e2e:e2e_simple Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x4e6c12d8b542741109480d1d242560fa356b047a86c2fb5e0ff1e4aef3ac15db 09:37:03 [09:37:03.800] INFO: e2e:e2e_simple Waiting for 12 transactions to be mined... 09:37:03 [09:37:03.840] INFO: e2e:e2e_simple All transactions mined successfully 09:37:03 [09:37:03.848] VERBOSE: e2e:e2e_simple Rollup deployed 09:37:03 [09:37:03.849] VERBOSE: e2e:e2e_simple Waiting for rollup and slash factory to be deployed 09:37:03 [09:37:03.849] INFO: e2e:e2e_simple Waiting for 12 transactions to be mined... 09:37:03 [09:37:03.896] INFO: e2e:e2e_simple All transactions mined successfully 09:37:03 [09:37:03.896] VERBOSE: e2e:e2e_simple All transactions for L1 deployment have been mined 09:37:03 [09:37:03.926] INFO: e2e:e2e_simple Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 09:37:03 [09:37:03.927] INFO: e2e:e2e_simple Handing over to governance 09:37:03 [09:37:03.930] INFO: e2e:e2e_simple Calling evm_setNextBlockTimestamp with params: [1749807427] 09:37:03 [09:37:03.932] INFO: e2e:e2e_simple Calling hardhat_mine with params: [1] 09:37:03 [09:37:03.935] INFO: e2e:e2e_simple Jumped to slot 1 09:37:03 [09:37:03.942] INFO: aztecjs:utils:watcher Watcher not started because not auto mining 09:37:03 [09:37:03.943] INFO: telemetry:client Using NoopTelemetryClient 09:37:03 [09:37:03.947] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/1e58fffef3388e9d/blob-sink with map size 134217728 KB (LMDB v2) 09:37:03 [09:37:03.949] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 09:37:03 [09:37:03.966] INFO: blob-sink:server Server is running on http://localhost:34353 09:37:03 [09:37:03.966] VERBOSE: e2e:e2e_simple Creating and synching an aztec node... 09:37:03 [09:37:03.969] VERBOSE: e2e:e2e_simple Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/10e8aacd/acvm 09:37:03 [09:37:03.972] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34353"} 09:37:04 [09:37:04.016] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 09:37:04 [09:37:04.017] INFO: archiver:lmdb Creating archiver data store at directory /tmp/1e58fffef3388e9d/archiver with map size 134217728 KB (LMDB v2) 09:37:04 [09:37:04.019] INFO: archiver:lmdb Starting data store with maxReaders 16 09:37:04 [09:37:04.417] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:04 [09:37:04.443] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34353"} 09:37:04 [09:37:04.444] WARN: node:blob-sink:client No L1 consensus host urls configured 09:37:04 [09:37:04.444] WARN: node:blob-sink:client No archive client configured 09:37:04 [09:37:04.448] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 15 to current L1 block 18 with hash 0x27d997699e9cc3e93375ebbb1f2c08dc025e8fd9a1a552c2a65d2c98712b90ff {"blocksSynchedTo":15,"messagesSynchedTo":{"l1BlockHash":"0x10832c7df5c0a2d9149bac527ee8e19e9cb0359f194f704fdb0b7e8de8933bba","l1BlockNumber":15}} 09:37:04 [09:37:04.468] INFO: archiver Initial archiver sync to L1 block 18 complete. {"l1BlockNumber":18,"syncPoint":{"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x27d997699e9cc3e93375ebbb1f2c08dc025e8fd9a1a552c2a65d2c98712b90ff","l1BlockNumber":18}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:37:04 [09:37:04.476] INFO: world-state:database Creating world state data store at directory /tmp/1e58fffef3388e9d/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 09:37:04 [09:37:04.504] INFO: world_state Created world state synchroniser with block history of 64 09:37:04 [09:37:04.504] WARN: node Aztec node is accepting fake proofs 09:37:04 [09:37:04.523] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/1e58fffef3388e9d/p2p with map size 134217728 KB (LMDB v2) 09:37:04 [09:37:04.525] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:37:04 [09:37:04.529] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/1e58fffef3388e9d/p2p-archive with map size 134217728 KB (LMDB v2) 09:37:04 [09:37:04.531] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:37:04 [09:37:04.534] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/1e58fffef3388e9d/p2p-peers with map size 134217728 KB (LMDB v2) 09:37:04 [09:37:04.536] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:37:04 [09:37:04.539] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:37:04 [09:37:04.540] VERBOSE: p2p P2P is disabled. Using dummy P2P service 09:37:04 [09:37:04.544] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 09:37:04 [09:37:04.545] INFO: world_state Started world state synchronizer from block 1 09:37:04 [09:37:04.548] VERBOSE: world-state:block_stream Starting sync from block number 0 09:37:04 [09:37:04.550] INFO: p2p Starting p2p client from block 0 with empty mempools 09:37:04 [09:37:04.550] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 09:37:04 [09:37:04.881] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:37:04 [09:37:04.936] VERBOSE: validator Initialized validator with addresses: 0x78529d422d6cf49f1437df0600b19b146474bd0d 09:37:04 [09:37:04.937] VERBOSE: node All Aztec Node subsystems synced 09:37:04 [09:37:04.980] INFO: slasher Starting Slasher client... 09:37:05 [09:37:05.005] INFO: sequencer-client Deploying forwarder contract 09:37:05 [09:37:05.009] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 09:37:05 [09:37:05.028] VERBOSE: sequencer-client Sent L1 transaction 0xb12c393d6d4a521dbfc8715c3493713c61a83309450c24b0998fe294078e72d8 {"gasLimit":323704,"maxFeePerGas":"1.415522643","maxPriorityFeePerGas":"1.2"} 09:37:05 [09:37:05.028] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0xb12c393d6d4a521dbfc8715c3493713c61a83309450c24b0998fe294078e72d8. 09:37:09 [09:37:09.037] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:37:09 [09:37:09.047] INFO: validator Started validator with addresses: 0x78529d422d6cf49f1437df0600b19b146474bd0d 09:37:09 [09:37:09.047] VERBOSE: validator Validators 0x78529d422d6cf49f1437df0600b19b146474bd0d are not on the validator committee for epoch 0 09:37:09 [09:37:09.048] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/10e8aacd/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":4,"enforceTimeTable":false} 09:37:09 [09:37:09.049] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 09:37:09 [09:37:09.050] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:37:09 [09:37:09.051] INFO: node Aztec Node version: 0.87.6 09:37:09 [09:37:09.051] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 09:37:09 [09:37:09.052] VERBOSE: e2e:e2e_simple Creating and syncing a simulated prover node... 09:37:09 [09:37:09.134] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34353"} 09:37:09 [09:37:09.144] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/1e58fffef3388e9d/93b39c7c7fbe2abf/archiver with map size 134217728 KB (LMDB v2) 09:37:09 [09:37:09.161] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:09 [09:37:09.164] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:09 [09:37:09.164] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 09:37:09 [09:37:09.448] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:09 [09:37:09.453] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:09 [09:37:09.556] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:09 [09:37:09.561] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:34353"} 09:37:09 [09:37:09.561] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 09:37:09 [09:37:09.561] WARN: blob-sink:client:prover-node No archive client configured 09:37:09 [09:37:09.564] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 15 to current L1 block 19 with hash 0x5d43bdc12c308e327e3ff2ee976770186a7cf9f2abc69b3632fd39483a7b9f57 {"blocksSynchedTo":15,"messagesSynchedTo":{"l1BlockHash":"0x10832c7df5c0a2d9149bac527ee8e19e9cb0359f194f704fdb0b7e8de8933bba","l1BlockNumber":15}} 09:37:09 [09:37:09.580] INFO: archiver:prover-node Initial archiver sync to L1 block 19 complete. {"l1BlockNumber":19,"syncPoint":{"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0x5d43bdc12c308e327e3ff2ee976770186a7cf9f2abc69b3632fd39483a7b9f57","l1BlockNumber":19}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:37:09 [09:37:09.584] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34353"} 09:37:09 [09:37:09.584] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 09:37:09 [09:37:09.586] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 09:37:09 [09:37:09.596] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/1e58fffef3388e9d/93b39c7c7fbe2abf/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 09:37:09 [09:37:09.626] INFO: world_state:prover-node Created world state synchroniser with block history of 64 09:37:09 [09:37:09.629] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 09:37:09 [09:37:09.630] INFO: world_state:prover-node Started world state synchronizer from block 1 09:37:09 [09:37:09.632] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 09:37:09 [09:37:09.632] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/1e58fffef3388e9d/93b39c7c7fbe2abf/archiver when loading epoch databases, ignoring 09:37:09 [09:37:09.632] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/1e58fffef3388e9d/93b39c7c7fbe2abf/world_state when loading epoch databases, ignoring 09:37:09 [09:37:09.634] INFO: prover-client:proving-broker:prover-node Proving Broker started 09:37:09 [09:37:09.647] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 09:37:09 [09:37:09.649] INFO: e2e:e2e_simple:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 09:37:09 [09:37:09.650] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 09:37:09 [09:37:09.653] INFO: prover-node:prover-node Started Prover Node with prover id 0x0000000000000000000000003c44cdddb6a900fa2b585dd299e03d12fa4293bc {"proverNodePollingIntervalMs":200,"proverNodeMaxPendingJobs":10,"proverNodeMaxParallelBlocksPerEpoch":32,"txGatheringIntervalMs":1000,"txGatheringBatchSize":10,"txGatheringMaxParallelRequestsPerNode":100,"dataDirectory":"/tmp/1e58fffef3388e9d/93b39c7c7fbe2abf","l1ChainId":31337,"rollupVersion":2744275947} 09:37:09 [09:37:09.654] VERBOSE: e2e:e2e_simple Creating a pxe... 09:37:09 [09:37:09.661] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/41d078af5ffc1d89/pxe_data with map size 134217728 KB (LMDB v2) 09:37:09 [09:37:09.670] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:37:09 [09:37:09.672] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:09 [09:37:09.673] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:10 [09:37:10.077] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:10 [09:37:10.080] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 09:37:10 [09:37:10.082] INFO: pxe:service Started PXE connected to chain 31337 version 2744275947 09:37:10 [09:37:10.149] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:10 [09:37:10.173] INFO: pxe:service Registered account 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 09:37:10 [09:37:10.254] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:37:10 [09:37:10.257] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 09:37:10 [09:37:10.443] INFO: pxe:service Added contract SchnorrAccount at 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:37:10 [09:37:10.456] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:10 [09:37:10.458] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:10 [09:37:10.505] VERBOSE: pxe:block_stream Starting sync from block number 0 09:37:10 [09:37:10.574] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:37:10 [09:37:10.759] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:37:11 [09:37:11.607] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 09:37:11 [09:37:11.752] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 09:37:11 [09:37:11.871] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1749807427,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:11 [09:37:11.927] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":1} 09:37:12 [09:37:12.078] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.177] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:37:12 [09:37:12.179] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.290] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:12 [09:37:12.397] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.415] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:37:12 [09:37:12.545] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:12 [09:37:12.846] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.905] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:37:12 [09:37:12.906] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.929] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:12 [09:37:12.983] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:12 [09:37:12.986] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:37:13 [09:37:13.008] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 as fee payer 09:37:13 [09:37:13.353] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:13 [09:37:13.854] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:14 [09:37:14.211] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:14 [09:37:14.834] INFO: pxe:service Proving completed in 4335.227625999993ms {"timings":{"total":4335.227625999993,"sync":7.410325000004377,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":274.2280129999999,"oracles":{"callPrivateFunction":{"times":[1215.6197569999931,784.5868090000004,397.8247580000025]}}},{"functionName":"private_kernel_init","time":148.71884499999578},{"functionName":"ContractClassRegisterer:register","time":1173.0234480000072,"oracles":{"loadCapsule":{"times":[19.244658999989042]},"notifyCreatedNullifier":{"times":[33.76831299999321]},"debugLog":{"times":[1.1318949999986216]},"notifyCreatedContractClassLog":{"times":[12.784625000000233]}}},{"functionName":"private_kernel_inner","time":213.06510900000285},{"functionName":"SchnorrAccount:constructor","time":712.2465669999947,"oracles":{"getContractInstance":{"times":[30.76164599999902]},"debugLog":{"times":[0.9986020000069402,0.7490670000115642]},"fetchTaggedLogs":{"times":[233.8791440000059]},"loadCapsule":{"times":[0.6792849999910686,1.0224619999935385,0.4457399999955669]},"validateEnqueuedNotesAndEvents":{"times":[5.356678999989526]},"notifyCreatedNullifier":{"times":[0.39227799999935087,0.2655850000010105]},"notifyCreatedNote":{"times":[0.7869470000005094]},"getRandomField":{"times":[0.700966000003973,0.24301599999307655,0.15338299999712035,0.11976299999514595,0.13583299999299925,0.10784199999761768,0.09893200000806246,0.0914420000044629,0.09690200000477489,0.12176300000282936,0.07928200000606012]},"getIndexedTaggingSecretAsSender":{"times":[77.3967849999899]},"incrementAppTaggingSecretIndexAsSender":{"times":[68.05207700000028]}}},{"functionName":"private_kernel_inner","time":190.64923999999883},{"functionName":"SchnorrAccount:entrypoint","time":341.71106699999655,"oracles":{"debugLog":{"times":[0.7859369999932824,0.38492899999255314,0.7897479999955976]},"fetchTaggedLogs":{"times":[79.12332299999252]},"loadCapsule":{"times":[0.2533760000078473,0.23420500000065658,0.3045270000002347]},"validateEnqueuedNotesAndEvents":{"times":[1.6223170000012033]},"getNotes":{"times":[2.236669999998412]},"getAuthWitness":{"times":[0.46966999999131076]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.06809400000202]}}},{"functionName":"private_kernel_inner","time":197.2571869999956},{"functionName":"private_kernel_reset","time":286.08737799999653},{"functionName":"private_kernel_tail","time":106.8337509999983}],"unaccounted":683.996696000002}} 09:37:14 [09:37:14.868] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:37:14 [09:37:14.949] VERBOSE: p2p:tx_pool Adding tx 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 to pool {"eventName":"tx-added-to-pool","txHash":"0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 09:37:14 [09:37:14.975] INFO: node Received tx 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 {"txHash":"0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8"} 09:37:14 [09:37:14.975] INFO: pxe:service Sent transaction 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 09:37:15 [09:37:15.098] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807439,"version":2744275947},"chainTipArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","blockNumber":1,"slot":2} 09:37:15 [09:37:15.121] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-13T09:37:19.000Z","now":"2025-06-13T09:37:15.121Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:37:15 [09:37:15.185] VERBOSE: simulator:public-processor Processed tx 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 with no public calls in 26.525831000006292ms {"txHash":"0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8","txFee":3484587240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":26.525831000006292} 09:37:15 [09:37:15.188] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06308074599999236s {"duration":0.06308074599999236,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:37:15 [09:37:15.216] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807439,"version":2744275947},"txHashes":["0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":103.75974199999473,"publicProcessDuration":64.1501500000013,"rollupCircuitsDuration":95.35418599999684,"txCount":1,"blockNumber":1,"blockTimestamp":1749807439,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:37:15 [09:37:15.225] VERBOSE: sequencer Attesting committee is empty 09:37:18 [09:37:18.295] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x58be25c9e44ec16d34d6754129ed50bdfe863fe3d6971cf5ee887f7d88b872d1 09:37:18 [09:37:18.296] VERBOSE: node Sent L1 transaction 0x58be25c9e44ec16d34d6754129ed50bdfe863fe3d6971cf5ee887f7d88b872d1 {"gasLimit":486998,"maxFeePerGas":"1.365428604","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:37:19 [09:37:19.924] WARN: node:blob-sink:client Unable to get blob sidecar for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:19 [09:37:19.925] WARN: node:blob-sink:client Failed to fetch blobs for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:19 [09:37:19.927] WARN: blob-sink:client:prover-node Unable to get blob sidecar for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:19 [09:37:19.927] WARN: blob-sink:client:prover-node Failed to fetch blobs for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:20 [09:37:20.209] WARN: blob-sink:client:prover-node Unable to get blob sidecar for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:20 [09:37:20.209] WARN: blob-sink:client:prover-node Failed to fetch blobs for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:20 [09:37:20.211] WARN: node:blob-sink:client Unable to get blob sidecar for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:20 [09:37:20.211] WARN: node:blob-sink:client Failed to fetch blobs for 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:20 [09:37:20.363] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:37:20 [09:37:20.365] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x58be25c9e44ec16d34d6754129ed50bdfe863fe3d6971cf5ee887f7d88b872d1","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":1,"blockTimestamp":1749807439,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:37:20 [09:37:20.366] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:37:20 [09:37:20.391] INFO: blob-sink:server Received blob sidecar for block 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 09:37:20 [09:37:20.402] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5526e95b188c634b3cbe572f12b773470eca5db0c44d474be372e85cd2584971 09:37:20 [09:37:20.578] VERBOSE: archiver:block-helper:prover-node Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:37:20 [09:37:20.599] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:37:20 [09:37:20.607] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807439,"version":2744275947},"archiveRoot":"0x2a4d9a428afb0bc1f895c33949e0af64796fe90f413f77109eb1051590f2d6d0","archiveNextLeafIndex":2} 09:37:20 [09:37:20.612] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807439,"version":2744275947},"archiveRoot":"0x2a4d9a428afb0bc1f895c33949e0af64796fe90f413f77109eb1051590f2d6d0","archiveNextLeafIndex":2} 09:37:20 [09:37:20.626] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:20 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:20 [09:37:20.627] WARN: sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check 09:37:20 [09:37:20.701] INFO: e2e:e2e_simple Running test: e2e_simple A simple test deploys a contract 09:37:21 [09:37:21.120] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":439.80989400000544,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807439,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:37:21 [09:37:21.134] INFO: pxe:service Added contract StatefulTest at 0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f with class 0x2e9d9d54374ad5ad29959eb4a11afd64845fb9671d3b277e5fff79d64e9e6634 09:37:21 [09:37:21.153] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 09:37:21 [09:37:21.154] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 09:37:21 [09:37:21.161] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.350301999991643,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807439,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:37:21 [09:37:21.170] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 09:37:21 [09:37:21.171] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 09:37:21 [09:37:21.172] VERBOSE: p2p Synched to latest block 1 09:37:21 [09:37:21.204] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2a4d9a428afb0bc1f895c33949e0af64796fe90f413f77109eb1051590f2d6d0","header":{"contentCommitment":{"blobsHash":"0x0048c2bb6a662b265626fdc39dc7b9af0f799dce0db9f2fb203f70889f291279","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807439,"version":2744275947},"lastArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11b93d1dcbafd4aa59723dbc055b6d5b20a0ee63d7dbd5c96ed4b42970020dcc","nullifierTree":"0x1c1f4680fc0a110b2324a39d9b07a81f2964af51496aebf44f8f62fe2612bff8","publicDataTree":"0x2de24f9051204035f6e2269ae3194e002087ec38ee9caaf73b47e232df82f62c"},"totalFees":3484587240,"totalManaUsed":6324}} 09:37:21 [09:37:21.383] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:21 [09:37:21.427] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:37:21 [09:37:21.428] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:21 [09:37:21.541] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:21 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:21 [09:37:21.542] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:21 [09:37:21.663] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99"} 09:37:21 [09:37:21.675] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x11ec59ff48efd417eb20e6dbdb22ba22d72b9241309805a0acb621c715c73bcb 09:37:21 [09:37:21.719] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 09:37:21 [09:37:21.723] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 09:37:21 [09:37:21.737] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 09:37:21 [09:37:21.739] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 09:37:21 [09:37:21.760] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:37:21 [09:37:21.773] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:21 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:21 [09:37:21.774] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:21 [09:37:21.781] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1849b62a19983b2be2600b1e1d762298f7bb143ee2ed399e8456e45d5982f66e","nullifier":"0x0e961dec7246f7e2bfa93e63e3b1b520e2e27d0639fa1098fe7b12365e81dc07"} 09:37:21 [09:37:21.801] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0401f1f74677b987c9feee605d815677614c94c3fe7608301caab97b1307ff99 as fee payer 09:37:22 [09:37:22.114] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.149] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:37:22 [09:37:22.150] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.281] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:22 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:22 [09:37:22.282] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:22 [09:37:22.334] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.350] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:37:22 [09:37:22.595] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.644] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:37:22 [09:37:22.644] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.682] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:22 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:22 [09:37:22.682] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:22 [09:37:22.773] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0248c15691695e6f69834894a6ff41bceb5700d350effec85d10b111c817bd9f"} 09:37:22 [09:37:22.778] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:37:22 [09:37:22.964] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:22 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:22 [09:37:22.965] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:23 [09:37:23.324] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:23 error: "Rollup__SlotAlreadyInChain(2, 2)" 09:37:23 [09:37:23.325] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:37:23 [09:37:23.847] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:24 [09:37:24.694] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:25 [09:37:25.402] INFO: pxe:service Proving completed in 4208.6165140000085ms {"timings":{"total":4208.6165140000085,"sync":12.126109999997425,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":644.5238470000186,"oracles":{"debugLog":{"times":[0.6763749999954598,0.8678890000010142,3.9812390000006417,2.209348999997019,1.430002000008244,0.801246999995783,0.8080079999926966,1.0014930000033928]},"fetchTaggedLogs":{"times":[239.8633370000025]},"loadCapsule":{"times":[2.9627460000046995,0.754226999997627,2.6432889999996405,1.3713710000010906,3.1150090000010096,0.9377720000047702,5.103703000000678]},"getSharedSecret":{"times":[6.981054999996559]},"aes128Decrypt":{"times":[1.5812349999905564,3.0973589999921387]},"getPublicKeysAndPartialAddress":{"times":[4.8192980000021635]},"getKeyValidationRequest":{"times":[4.0946510000067065]},"storeCapsule":{"times":[2.1636390000057872,2.4072139999916544,8.052239999989979]},"deleteCapsule":{"times":[0.8712390000000596]},"validateEnqueuedNotesAndEvents":{"times":[17.370676999998977]},"getNotes":{"times":[2.7057499999937136]},"getAuthWitness":{"times":[0.41062899999087676]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09684199999901466]},"callPrivateFunction":{"times":[1304.1704219999956]}}},{"functionName":"private_kernel_init","time":112.14175999999861},{"functionName":"StatefulTest:constructor","time":559.9524809999857,"oracles":{"getContractInstance":{"times":[4.604962000012165]},"debugLog":{"times":[0.9623909999936586,0.7345269999932498]},"fetchTaggedLogs":{"times":[194.0322759999981]},"loadCapsule":{"times":[4.55548200001067,0.8833200000080978,2.611858000003849]},"validateEnqueuedNotesAndEvents":{"times":[13.319296999994549]},"storeInExecutionCache":{"times":[0.4964909999980591]},"callPrivateFunction":{"times":[729.2804270000051]},"notifyCreatedNullifier":{"times":[0.37020799999299925]}}},{"functionName":"private_kernel_inner","time":185.83229200000642},{"functionName":"StatefulTest:create_note_no_init_check","time":652.4444539999968,"oracles":{"debugLog":{"times":[0.6161540000030072,0.48498100000142585]},"fetchTaggedLogs":{"times":[132.10487500000454]},"loadCapsule":{"times":[0.2231959999917308,0.35237700000288896,0.4941309999994701]},"validateEnqueuedNotesAndEvents":{"times":[4.205423999999766]},"getRandomField":{"times":[0.179204000000027,0.13512300000002142,0.3126759999868227,0.09194199999910779,0.0597120000020368,0.05488100000366103,0.05272100000001956,0.055992000008700415,0.09016199999314267,0.06590099999448285,0.0642809999990277,0.07732199999736622]},"notifyCreatedNote":{"times":[0.2096049999963725]},"getIndexedTaggingSecretAsSender":{"times":[140.6145749999996]},"incrementAppTaggingSecretIndexAsSender":{"times":[133.27429100000882]}}},{"functionName":"private_kernel_inner","time":233.19584000000032},{"functionName":"private_kernel_reset","time":295.36074999999255},{"functionName":"private_kernel_tail","time":116.94895299999916}],"unaccounted":1396.090027000013}} 09:37:25 [09:37:25.439] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:25 [09:37:25.481] VERBOSE: p2p:tx_pool Adding tx 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 to pool {"eventName":"tx-added-to-pool","txHash":"0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 09:37:25 [09:37:25.486] INFO: node Received tx 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 {"txHash":"0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008"} 09:37:25 [09:37:25.486] INFO: pxe:service Sent transaction 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 09:37:25 [09:37:25.659] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:25 [09:37:25.881] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:26 [09:37:26.100] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:26 [09:37:26.312] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:26 [09:37:26.527] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:26 [09:37:26.740] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:26 [09:37:26.961] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 09:37:27 [09:37:27.193] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807451,"version":2744275947},"chainTipArchive":"0x2a4d9a428afb0bc1f895c33949e0af64796fe90f413f77109eb1051590f2d6d0","blockNumber":2,"slot":3} 09:37:27 [09:37:27.204] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-13T09:37:31.000Z","now":"2025-06-13T09:37:27.204Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:37:27 [09:37:27.235] VERBOSE: simulator:public-processor Processed tx 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 with no public calls in 17.870499000011478ms {"txHash":"0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008","txFee":2652562140,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":4814},"billedGas":{"daGas":11776,"l2Gas":4814},"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":17.870499000011478} 09:37:27 [09:37:27.236] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.029851827000005868s {"duration":0.029851827000005868,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:37:27 [09:37:27.280] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807451,"version":2744275947},"txHashes":["0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":81.38305800000671,"publicProcessDuration":30.38442899999791,"rollupCircuitsDuration":76.33055499999318,"txCount":1,"blockNumber":2,"blockTimestamp":1749807451,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:37:27 [09:37:27.283] VERBOSE: sequencer Attesting committee is empty 09:37:27 [09:37:27.501] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5cd31724b6735f3860fae1e7427d5ea538cea5311d2b72f922e53aeb26a906c9 09:37:27 [09:37:27.502] VERBOSE: node Sent L1 transaction 0x5cd31724b6735f3860fae1e7427d5ea538cea5311d2b72f922e53aeb26a906c9 {"gasLimit":415960,"maxFeePerGas":"1.311185662","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 09:37:27 [09:37:27.848] WARN: blob-sink:client:prover-node Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:27 [09:37:27.849] WARN: blob-sink:client:prover-node Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:27 [09:37:27.851] WARN: node:blob-sink:client Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:27 [09:37:27.852] WARN: node:blob-sink:client Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:28 [09:37:28.131] WARN: blob-sink:client:prover-node Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:28 [09:37:28.132] WARN: blob-sink:client:prover-node Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:28 [09:37:28.153] WARN: node:blob-sink:client Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:28 [09:37:28.155] WARN: node:blob-sink:client Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:28 [09:37:28.381] WARN: blob-sink:client:prover-node Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:28 [09:37:28.381] WARN: blob-sink:client:prover-node Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:28 [09:37:28.410] WARN: node:blob-sink:client Unable to get blob sidecar for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 09:37:28 [09:37:28.410] WARN: node:blob-sink:client Failed to fetch blobs for 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 from all blob sources {"blobSinkUrl":"http://localhost:34353"} 09:37:28 [09:37:28.529] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:37:28 [09:37:28.530] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5cd31724b6735f3860fae1e7427d5ea538cea5311d2b72f922e53aeb26a906c9","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":2,"blockTimestamp":1749807451,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:37:28 [09:37:28.530] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:37:28 [09:37:28.536] INFO: blob-sink:server Received blob sidecar for block 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 09:37:28 [09:37:28.545] INFO: blob-sink:server Blob sidecar stored successfully for block 0x406714f4e508d49a87566819d8213c6096c0619bcb4eb09158ecb0ce9530d265 09:37:28 [09:37:28.666] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807451,"version":2744275947},"archiveRoot":"0x0cda147335567b0d80823ce99e523d4dac2eca4d8f1c0dc19cb39f3c55c851b2","archiveNextLeafIndex":3} 09:37:28 [09:37:28.722] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":551010,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807451,"version":2744275947},"archiveRoot":"0x0cda147335567b0d80823ce99e523d4dac2eca4d8f1c0dc19cb39f3c55c851b2","archiveNextLeafIndex":3} 09:37:28 [09:37:28.756] INFO: prover-node:combined-prover-coordination:prover-node Check for 2 txs found 2 missing. Will gather from nodes and p2p 09:37:28 [09:37:28.757] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.546168999993824,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807451,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:37:28 [09:37:28.763] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 2 of 2 txs from a node 09:37:28 [09:37:28.763] INFO: prover-node:combined-prover-coordination:prover-node Found all 2 txs directly from nodes 09:37:28 [09:37:28.763] VERBOSE: prover-node:prover-node Gathered all 2 txs for epoch 0 {"epochNumber":0} 09:37:28 [09:37:28.769] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":16.982199000005494,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807451,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:37:28 [09:37:28.770] VERBOSE: prover-node:prover-node Gathered all 0 messages for epoch 0 {"epochNumber":0} 09:37:28 [09:37:28.771] VERBOSE: prover-node:prover-node Gathered previous block header 0 for epoch 0 09:37:28 [09:37:28.771] VERBOSE: prover-node:prover-node Creating proving job for epoch 0 for block range 1 to 2 09:37:28 [09:37:28.774] INFO: prover-node:epoch-proving-job Starting epoch 0 proving job with blocks 1 to 2 {"fromBlock":1,"toBlock":2,"epochSizeBlocks":2,"epochNumber":0,"uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332"} 09:37:28 [09:37:28.935] INFO: prover-client:orchestrator Starting epoch 0 with 2 blocks 09:37:28 [09:37:28.935] VERBOSE: prover-client:broker-circuit-prover-facade Starting BrokerCircuitProverFacade 09:37:28 [09:37:28.937] VERBOSE: prover-node:epoch-proving-job Starting processing block 1 {"number":1,"blockHash":"0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee","lastArchive":"0x0b8e76e36fb8c42f8213725458417f5be397704ea32649bc711bd9e056bcc190","noteHashTreeRoot":"0x11b93d1dcbafd4aa59723dbc055b6d5b20a0ee63d7dbd5c96ed4b42970020dcc","nullifierTreeRoot":"0x1c1f4680fc0a110b2324a39d9b07a81f2964af51496aebf44f8f62fe2612bff8","publicDataTreeRoot":"0x2de24f9051204035f6e2269ae3194e002087ec38ee9caaf73b47e232df82f62c","previousHeader":{},"uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332","chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000a39253eb","blockNumber":1,"slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000002","coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","gasFees":{"feePerDaGas":0,"feePerL2Gas":551010}} 09:37:28 [09:37:28.938] INFO: prover-client:orchestrator Starting block 1 for slot 2 09:37:28 [09:37:28.938] VERBOSE: prover-node:epoch-proving-job Starting processing block 2 {"number":2,"blockHash":"0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea","lastArchive":"0x2a4d9a428afb0bc1f895c33949e0af64796fe90f413f77109eb1051590f2d6d0","noteHashTreeRoot":"0x0bda74b42c9f81a713578b9f4d257d328f87d4dabb590117a367c7b95d180f36","nullifierTreeRoot":"0x11d5a572d9662bc8b0df4c6846f31bb506284723d93616b952511c9cf99841ff","publicDataTreeRoot":"0x0193561ebee835239acf3a741d82582f5166f4a5b5be2c58e1050d7ebdce944d","previousHeader":{},"uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332","chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000a39253eb","blockNumber":2,"slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000003","coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","gasFees":{"feePerDaGas":0,"feePerL2Gas":551010}} 09:37:28 [09:37:28.938] INFO: prover-client:orchestrator Starting block 2 for slot 3 09:37:28 [09:37:28.952] INFO: prover-client:proving-broker:prover-node New proving job id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f epochNumber=0 {"provingJobId":"0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f"} 09:37:28 [09:37:28.966] INFO: prover-client:proving-broker:prover-node New proving job id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 epochNumber=0 {"provingJobId":"0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041"} 09:37:28 [09:37:28.987] INFO: prover-client:proving-broker:prover-node New proving job id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 epochNumber=0 {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0"} 09:37:28 [09:37:28.988] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.988] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.988] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.990] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.990] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.990] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.990] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY"} 09:37:28 [09:37:28.991] VERBOSE: p2p Synched to latest block 2 09:37:29 [09:37:29.006] INFO: prover-client:proving-broker-database:prover-node Creating broker database for epoch 0 at /tmp/1e58fffef3388e9d/93b39c7c7fbe2abf/0 with map size 134217728 09:37:29 [09:37:29.010] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:37:29 [09:37:29.018] VERBOSE: simulator:public-processor Processed tx 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 with no public calls in 23.230388999989373ms {"txHash":"0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008","txFee":2652562140,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":4814},"billedGas":{"daGas":11776,"l2Gas":4814},"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":23.230388999989373} 09:37:29 [09:37:29.022] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.030060891999994056s {"duration":0.030060891999994056,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:37:29 [09:37:29.024] INFO: prover-client:orchestrator Adding 1 transactions with 31 blob fields to block 2 09:37:29 [09:37:29.024] INFO: prover-client:orchestrator Received transaction: 0x15b1e3dd786abfb9e4e251cc68e33e3b37752f62465ee4ff34d86878f7ab7008 09:37:29 [09:37:29.025] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f type=TUBE_PROOF epochNumber=0 {"provingJobId":"0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f","provingJobType":"TUBE_PROOF","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22inpu...","status":"not-found","numOutstandingJobs":3} 09:37:29 [09:37:29.025] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 type=TUBE_PROOF epochNumber=0 {"provingJobId":"0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041","provingJobType":"TUBE_PROOF","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22inpu...","status":"not-found","numOutstandingJobs":3} 09:37:29 [09:37:29.025] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY epochNumber=0 {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0","provingJobType":"BASE_PARITY","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A9%2C%22input...","status":"not-found","numOutstandingJobs":3} 09:37:29 [09:37:29.032] VERBOSE: simulator:public-processor Processed tx 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 with no public calls in 26.782388000006904ms {"txHash":"0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8","txFee":3484587240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":26.782388000006904} 09:37:29 [09:37:29.034] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03737899599999946s {"duration":0.03737899599999946,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:37:29 [09:37:29.034] INFO: prover-client:orchestrator Adding 1 transactions with 42 blob fields to block 1 09:37:29 [09:37:29.035] INFO: prover-client:orchestrator Received transaction: 0x0d4a266fa5694cc720676757392d52af85da97a0dfdc97a5d2a65b245aa097f8 09:37:29 [09:37:29.079] INFO: prover-client:proving-agent:prover-node Starting job id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f type=TUBE_PROOF inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22inpu... 09:37:29 [09:37:29.080] INFO: prover-client:proving-agent:job-controller-bd9575a7 Job controller started jobId=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f {"jobId":"0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f"} 09:37:29 [09:37:29.083] INFO: prover-client:proving-agent:prover-node Starting job id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 type=TUBE_PROOF inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22inpu... 09:37:29 [09:37:29.083] INFO: prover-client:proving-agent:job-controller-609d881b Job controller started jobId=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 {"jobId":"0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041"} 09:37:29 [09:37:29.086] INFO: prover-client:proving-agent:prover-node Job id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f type=TUBE_PROOF completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22resu... 09:37:29 [09:37:29.086] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f type=TUBE_PROOF totalAttempts=1 {"provingJobId":"0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f"} 09:37:29 [09:37:29.089] INFO: prover-client:proving-agent:prover-node Job id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 type=TUBE_PROOF completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A11%2C%22resu... 09:37:29 [09:37:29.090] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 type=TUBE_PROOF totalAttempts=1 {"provingJobId":"0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041"} 09:37:29 [09:37:29.091] VERBOSE: prover-node:epoch-proving-job Processed all 1 txs for block 1 {"blockNumber":1,"blockHash":"0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee","uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332"} 09:37:29 [09:37:29.092] VERBOSE: prover-client:orchestrator Block 1 completed. Assembling header. 09:37:29 [09:37:29.092] VERBOSE: prover-node:epoch-proving-job Processed all 1 txs for block 2 {"blockNumber":2,"blockHash":"0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea","uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332"} 09:37:29 [09:37:29.092] VERBOSE: prover-client:orchestrator Block 2 completed. Assembling header. 09:37:29 [09:37:29.109] VERBOSE: prover-client:orchestrator Updating archive tree with block 1 header 0x131402de3f7b6462f9e05297aac8582a7b84c9516a438bf08422f0803235b5ee 09:37:29 [09:37:29.125] VERBOSE: prover-client:orchestrator Updating archive tree with block 2 header 0x26691a3cab5ba96377735993a5598d44a1fddd180e35d94ab1708a7a6a3f57ea 09:37:29 [09:37:29.127] VERBOSE: prover-client:orchestrator Orchestrator finalised block 1 09:37:29 [09:37:29.230] INFO: prover-client:proving-agent:prover-node Starting job id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A9%2C%22input... 09:37:29 [09:37:29.231] INFO: prover-client:proving-agent:job-controller-5bb58b7f Job controller started jobId=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 {"jobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0"} 09:37:29 [09:37:29.236] VERBOSE: prover-client:orchestrator Orchestrator finalised block 2 09:37:29 [09:37:29.381] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:29 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:29 [09:37:29.381] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:29 [09:37:29.480] INFO: prover-client:proving-agent:prover-node Job id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A9%2C%22resul... 09:37:29 [09:37:29.480] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY totalAttempts=1 {"provingJobId":"0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0"} 09:37:29 [09:37:29.499] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 09:37:29 [09:37:29.499] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 09:37:29 [09:37:29.501] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 09:37:29 [09:37:29.501] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 09:37:29 [09:37:29.650] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:29 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:29 [09:37:29.651] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:29 [09:37:29.867] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:29 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:29 [09:37:29.868] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:29 [09:37:29.937] VERBOSE: prover-client:broker-circuit-prover-facade Check for job completion notifications returned 3 job(s), snapshot ids length: 0, num outstanding jobs: 3, total jobs ready: 3 09:37:29 [09:37:29.940] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:TUBE_PROOF:3ec373e85fa095788795b393dc971413dca822daad0e0f13e3df40a4cb142e7f type=TUBE_PROOF 09:37:29 [09:37:29.941] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:TUBE_PROOF:79a46608490b89caaa88ed98f6e7939cdfad8763d2707fb0a0f68a9c0955a041 type=TUBE_PROOF 09:37:29 [09:37:29.941] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:BASE_PARITY:e492da201f5ca9b34a8763416a663d15adb10393e53cc47eded5a2769d3a63a0 type=BASE_PARITY 09:37:29 [09:37:29.941] VERBOSE: prover-client:broker-circuit-prover-facade Successfully retrieved 3 of 3 jobs that should be ready, total ready jobs is now: 0 09:37:29 [09:37:29.952] INFO: prover-client:proving-broker:prover-node New proving job id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 epochNumber=0 {"provingJobId":"0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5"} 09:37:29 [09:37:29.960] VERBOSE: prover-client:broker-circuit-prover-facade Job already found in facade id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY {"provingJobId":"0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5","provingJobType":"ROOT_PARITY"} 09:37:29 [09:37:29.999] INFO: prover-client:proving-broker:prover-node New proving job id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad epochNumber=0 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad"} 09:37:30 [09:37:30.039] INFO: prover-client:proving-broker:prover-node New proving job id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 epochNumber=0 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6"} 09:37:30 [09:37:30.050] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY epochNumber=0 {"provingJobId":"0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5","provingJobType":"ROOT_PARITY","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A10%2C%22inpu...","status":"not-found","numOutstandingJobs":3} 09:37:30 [09:37:30.050] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad type=PRIVATE_BASE_ROLLUP epochNumber=0 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad","provingJobType":"PRIVATE_BASE_ROLLUP","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22input...","status":"not-found","numOutstandingJobs":3} 09:37:30 [09:37:30.050] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 type=PRIVATE_BASE_ROLLUP epochNumber=0 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6","provingJobType":"PRIVATE_BASE_ROLLUP","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22input...","status":"not-found","numOutstandingJobs":3} 09:37:30 [09:37:30.082] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:30 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:30 [09:37:30.082] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:30 [09:37:30.156] INFO: prover-client:proving-agent:prover-node Starting job id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad type=PRIVATE_BASE_ROLLUP inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22input... 09:37:30 [09:37:30.206] INFO: prover-client:proving-agent:job-controller-c33fcad8 Job controller started jobId=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad {"jobId":"0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad"} 09:37:30 [09:37:30.218] INFO: prover-client:proving-agent:prover-node Starting job id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 type=PRIVATE_BASE_ROLLUP inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22input... 09:37:30 [09:37:30.268] INFO: prover-client:proving-agent:job-controller-24523154 Job controller started jobId=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 {"jobId":"0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6"} 09:37:30 [09:37:30.366] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:30 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:30 [09:37:30.366] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:30 [09:37:30.517] INFO: prover-client:proving-agent:prover-node Job id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 type=PRIVATE_BASE_ROLLUP completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22resul... 09:37:30 [09:37:30.517] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 type=PRIVATE_BASE_ROLLUP totalAttempts=1 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6"} 09:37:30 [09:37:30.578] INFO: prover-client:proving-agent:prover-node Job id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad type=PRIVATE_BASE_ROLLUP completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A1%2C%22resul... 09:37:30 [09:37:30.579] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad type=PRIVATE_BASE_ROLLUP totalAttempts=1 {"provingJobId":"0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad"} 09:37:30 [09:37:30.584] INFO: prover-client:proving-agent:prover-node Starting job id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A10%2C%22inpu... 09:37:30 [09:37:30.600] INFO: prover-client:proving-agent:job-controller-5e7b71b8 Job controller started jobId=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 {"jobId":"0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5"} 09:37:30 [09:37:30.617] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:30 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:30 [09:37:30.617] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:30 [09:37:30.736] INFO: prover-client:proving-agent:prover-node Job id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A10%2C%22resu... 09:37:30 [09:37:30.737] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY totalAttempts=1 {"provingJobId":"0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5"} 09:37:30 [09:37:30.830] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:30 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:30 [09:37:30.830] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:30 [09:37:30.942] VERBOSE: prover-client:broker-circuit-prover-facade Check for job completion notifications returned 3 job(s), snapshot ids length: 0, num outstanding jobs: 3, total jobs ready: 3 09:37:30 [09:37:30.945] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:PRIVATE_BASE_ROLLUP:340d63a48a29facdf42c45ac4cc5b76da827dfcf3b4f9073396856024f004ad6 type=PRIVATE_BASE_ROLLUP 09:37:30 [09:37:30.945] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:PRIVATE_BASE_ROLLUP:ebc3b5d17234cffe7f5b040fb308da808542db0da43309ae92e37083bef4aaad type=PRIVATE_BASE_ROLLUP 09:37:30 [09:37:30.945] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:ROOT_PARITY:753b88c434bc5c1cd43db6666d5a6ee2f974b934cbe54f7ec092b6b28a3a99a5 type=ROOT_PARITY 09:37:30 [09:37:30.945] VERBOSE: prover-client:broker-circuit-prover-facade Successfully retrieved 3 of 3 jobs that should be ready, total ready jobs is now: 0 09:37:31 [09:37:31.030] INFO: prover-client:proving-broker:prover-node New proving job id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 epochNumber=0 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3"} 09:37:31 [09:37:31.082] INFO: prover-client:proving-broker:prover-node New proving job id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 epochNumber=0 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8"} 09:37:31 [09:37:31.099] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 type=SINGLE_TX_BLOCK_ROOT_ROLLUP epochNumber=0 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3","provingJobType":"SINGLE_TX_BLOCK_ROOT_ROLLUP","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22input...","status":"not-found","numOutstandingJobs":2} 09:37:31 [09:37:31.100] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 type=SINGLE_TX_BLOCK_ROOT_ROLLUP epochNumber=0 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8","provingJobType":"SINGLE_TX_BLOCK_ROOT_ROLLUP","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22input...","status":"not-found","numOutstandingJobs":2} 09:37:31 [09:37:31.109] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:31 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:31 [09:37:31.109] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:31 [09:37:31.200] INFO: prover-client:proving-agent:prover-node Starting job id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 type=SINGLE_TX_BLOCK_ROOT_ROLLUP inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22input... 09:37:31 [09:37:31.271] INFO: prover-client:proving-agent:job-controller-d5fbf30c Job controller started jobId=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 {"jobId":"0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3"} 09:37:31 [09:37:31.608] INFO: prover-client:proving-agent:prover-node Starting job id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 type=SINGLE_TX_BLOCK_ROOT_ROLLUP inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22input... 09:37:31 [09:37:31.672] INFO: prover-client:proving-agent:job-controller-ed7c4fe8 Job controller started jobId=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 {"jobId":"0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8"} 09:37:31 [09:37:31.950] INFO: prover-client:proving-agent:prover-node Job id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 type=SINGLE_TX_BLOCK_ROOT_ROLLUP completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22resul... 09:37:31 [09:37:31.951] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 type=SINGLE_TX_BLOCK_ROOT_ROLLUP totalAttempts=1 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3"} 09:37:31 [09:37:31.961] INFO: prover-client:proving-agent:prover-node Job id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 type=SINGLE_TX_BLOCK_ROOT_ROLLUP completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A6%2C%22resul... 09:37:31 [09:37:31.961] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 type=SINGLE_TX_BLOCK_ROOT_ROLLUP totalAttempts=1 {"provingJobId":"0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8"} 09:37:31 [09:37:31.962] VERBOSE: prover-client:broker-circuit-prover-facade Check for job completion notifications returned 2 job(s), snapshot ids length: 0, num outstanding jobs: 2, total jobs ready: 2 09:37:31 [09:37:31.966] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:BLOCK_ROOT_ROLLUP:5bb9dcfac5269b345575fa503fde19963c1322faa45cb98add9ace7b5e2d93b3 type=SINGLE_TX_BLOCK_ROOT_ROLLUP 09:37:31 [09:37:31.966] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:BLOCK_ROOT_ROLLUP:97a21ab7d0c0d6153ab42f448505838744b47c2fd7760cee7c0f8518d23965e8 type=SINGLE_TX_BLOCK_ROOT_ROLLUP 09:37:31 [09:37:31.967] VERBOSE: prover-client:broker-circuit-prover-facade Successfully retrieved 2 of 2 jobs that should be ready, total ready jobs is now: 0 09:37:31 [09:37:31.998] INFO: prover-client:proving-broker:prover-node New proving job id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 epochNumber=0 {"provingJobId":"0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249"} 09:37:32 [09:37:32.009] VERBOSE: prover-client:broker-circuit-prover-facade Job enqueued with broker id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 type=ROOT_ROLLUP epochNumber=0 {"provingJobId":"0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249","provingJobType":"ROOT_ROLLUP","epochNumber":0,"inputsUri":"data:application/json;charset=utf-8,%7B%22type%22%3A8%2C%22input...","status":"not-found","numOutstandingJobs":1} 09:37:32 [09:37:32.014] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:32 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:32 [09:37:32.014] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:32 [09:37:32.111] INFO: prover-client:proving-agent:prover-node Starting job id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 type=ROOT_ROLLUP inputsUri=data:application/json;charset=utf-8,%7B%22type%22%3A8%2C%22input... 09:37:32 [09:37:32.121] INFO: prover-client:proving-agent:job-controller-7bb2e3c8 Job controller started jobId=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 {"jobId":"0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249"} 09:37:32 [09:37:32.249] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:32 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:32 [09:37:32.250] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:32 [09:37:32.283] INFO: prover-client:proving-agent:prover-node Job id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 type=ROOT_ROLLUP completed outputUri=data:application/json;charset=utf-8,%7B%22type%22%3A8%2C%22resul... 09:37:32 [09:37:32.283] INFO: prover-client:proving-broker:prover-node Proving job complete id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 type=ROOT_ROLLUP totalAttempts=1 {"provingJobId":"0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249"} 09:37:32 [09:37:32.466] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:32 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:32 [09:37:32.467] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:32 [09:37:32.689] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:32 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:32 [09:37:32.689] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:32 [09:37:32.903] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:32 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:32 [09:37:32.904] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:32 [09:37:32.968] VERBOSE: prover-client:broker-circuit-prover-facade Check for job completion notifications returned 1 job(s), snapshot ids length: 0, num outstanding jobs: 1, total jobs ready: 1 09:37:32 [09:37:32.971] VERBOSE: prover-client:broker-circuit-prover-facade Resolved proving job id=0:ROOT_ROLLUP:26c5939ec9c0d2945320c875419e1ee85007480394fc4a9df5f9c2486f11c249 type=ROOT_ROLLUP 09:37:32 [09:37:32.972] VERBOSE: prover-client:broker-circuit-prover-facade Successfully retrieved 1 of 1 jobs that should be ready, total ready jobs is now: 0 09:37:32 [09:37:32.972] VERBOSE: prover-client:orchestrator Orchestrator completed root rollup for epoch 0 09:37:32 [09:37:32.977] INFO: prover-node:epoch-proving-job Finalised proof for epoch 0 {"epochNumber":0,"uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332","duration":4202.069577999995} 09:37:32 [09:37:32.989] INFO: prover-node:l1-tx-publisher:prover-node SubmitEpochProof proofSize=42 bytes 09:37:33 [09:37:33.057] VERBOSE: ethereum:tx_delayer:prover-node Sent tx immediately 0x9600491cd089ec4055cfa83bda3635f1b9b00103688c1500adee806db07c9a56 09:37:33 [09:37:33.057] VERBOSE: prover-node:prover-node Sent L1 transaction 0x9600491cd089ec4055cfa83bda3635f1b9b00103688c1500adee806db07c9a56 {"gasLimit":501020,"maxFeePerGas":"1.285356149","maxPriorityFeePerGas":"1.2"} 09:37:33 [09:37:33.116] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:33 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:33 [09:37:33.116] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:33 [09:37:33.330] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:33 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:33 [09:37:33.330] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:33 [09:37:33.544] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:33 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:33 [09:37:33.545] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:33 [09:37:33.758] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:33 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:33 [09:37:33.758] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:33 [09:37:33.988] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:33 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:33 [09:37:33.989] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:34 [09:37:34.205] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:34 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:34 [09:37:34.205] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:34 [09:37:34.419] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:34 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:34 [09:37:34.420] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:34 [09:37:34.635] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:34 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:34 [09:37:34.635] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:34 [09:37:34.852] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:34 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:34 [09:37:34.853] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:35 [09:37:35.068] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:35 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:35 [09:37:35.069] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:35 [09:37:35.287] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:35 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:35 [09:37:35.287] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:35 [09:37:35.501] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:37:35 error: "Rollup__SlotAlreadyInChain(3, 3)" 09:37:35 [09:37:35.501] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 09:37:35 [09:37:35.714] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:35 [09:37:35.778] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 09:37:35 [09:37:35.779] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 09:37:35 [09:37:35.928] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:35 [09:37:35.982] INFO: node Stopping Aztec Node 09:37:36 [09:37:36.096] INFO: prover-node:l1-tx-publisher:prover-node Published epoch proof to L1 rollup contract {"gasPrice":1246626496,"gasUsed":411743,"transactionHash":"0x9600491cd089ec4055cfa83bda3635f1b9b00103688c1500adee806db07c9a56","calldataGas":18896,"calldataSize":3716,"sender":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","blobDataGas":0,"blobGasUsed":0,"eventName":"proof-published-to-l1","epochNumber":0,"fromBlock":1,"toBlock":2} 09:37:36 [09:37:36.097] INFO: prover-node:epoch-proving-job Submitted proof for epoch 0 (blocks 1 to 2) {"epochNumber":0,"uuid":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332"} 09:37:36 [09:37:36.097] VERBOSE: prover-client:broker-circuit-prover-facade Stopping BrokerCircuitProverFacade 09:37:36 [09:37:36.098] VERBOSE: prover-node:prover-node Job for 0 exited with state completed {"id":"e324f6ea-7be5-43d7-b3c1-e4afd48ae332","epochNumber":0,"state":"completed"} 09:37:36 [09:37:36.137] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:36 [09:37:36.348] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:36 [09:37:36.561] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:36 [09:37:36.782] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:36 [09:37:36.996] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:37 [09:37:37.206] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:37 [09:37:37.418] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:37 [09:37:37.625] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:37 [09:37:37.835] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 09:37:37 [09:37:37.984] INFO: slasher Slasher client stopped. 09:37:37 [09:37:37.985] INFO: sequencer Stopped sequencer 09:37:37 [09:37:37.985] INFO: p2p P2P client stopped 09:37:37 [09:37:37.988] INFO: world_state Stopped world state synchronizer 09:37:37 [09:37:37.990] INFO: archiver Stopped. 09:37:37 [09:37:37.990] INFO: node Stopped Aztec Node 09:37:37 [09:37:37.991] INFO: prover-node:prover-node Stopping ProverNode 09:37:37 [09:37:37.991] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 09:37:37 [09:37:37.992] INFO: archiver:prover-node Stopped. 09:37:37 [09:37:37.996] INFO: world_state:prover-node Stopped world state synchronizer 09:37:37 [09:37:37.997] INFO: prover-node:prover-node Stopped ProverNode 09:37:38 [09:37:38.012] INFO: blob-sink:server Stopping blob sink 09:37:38 [09:37:38.012] INFO: blob-sink:server Blob sink stopped 09:37:38 PASS src/e2e_simple.test.ts 09:37:38 e2e_simple 09:37:38 A simple test 09:37:38 ✓ deploys a contract (15277 ms) 09:37:38 09:37:38 Test Suites: 1 passed, 1 total 09:37:38 Tests: 1 passed, 1 total 09:37:38 Snapshots: 0 total 09:37:38 Time: 109.251 s 09:37:38 Ran all test suites matching /src\/e2e_simple.test.ts/i. 09:37:38 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?