Parent Log:
http://ci.aztec-labs.com/9ef2f13bc7b64e46
Command: d9d36df79db5e113 aztec-up/scripts/run_test.sh amm_flow
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/04abcb151443d51d2f1b002a2412a083a9384a51
Env: REF_NAME=gh-readonly-queue/next/pr-15077-263498dd65e8700218979d7a94dbfd25b2a8a8a8 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Tue Jun 17 20:51:08 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15077_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_a75f1f6610262cee_next
20:51:08 Unable to find image 'aztecprotocol/dind:latest' locally
20:51:08 latest: Pulling from aztecprotocol/dind
20:51:09 afad30e59d72: Pulling fs layer
20:51:09 4e9c72eacf62: Pulling fs layer
20:51:09 1fdf475197e7: Pulling fs layer
20:51:09 5be0e287c3f8: Pulling fs layer
20:51:09 5be0e287c3f8: Waiting
20:51:09 afad30e59d72: Verifying Checksum
20:51:09 afad30e59d72: Download complete
20:51:09 4e9c72eacf62: Verifying Checksum
20:51:09 4e9c72eacf62: Download complete
20:51:09 5be0e287c3f8: Download complete
20:51:11 afad30e59d72: Pull complete
20:51:11 1fdf475197e7: Verifying Checksum
20:51:11 4e9c72eacf62: Pull complete
20:51:15 1fdf475197e7: Pull complete
20:51:15 5be0e287c3f8: Pull complete
20:51:15 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b
20:51:15 Status: Downloaded newer image for aztecprotocol/dind:latest
20:51:16 Starting docker...
20:51:20 time="2025-06-17T20:51:16.246055881Z" level=info msg="Starting up"
20:51:20 time="2025-06-17T20:51:16.246890615Z" level=info msg="containerd not running, starting managed containerd"
20:51:20 time="2025-06-17T20:51:16.248821173Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=84
20:51:20 time="2025-06-17T20:51:16.279689866Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=1.7.25-1
20:51:20 time="2025-06-17T20:51:16.298010138Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.298313817Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exec: \"modprobe\": executable file not found in $PATH \"\"): skip plugin" type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.298337388Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
20:51:20 time="2025-06-17T20:51:16.298352999Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
20:51:20 time="2025-06-17T20:51:16.301557813Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
20:51:20 time="2025-06-17T20:51:16.301589604Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301670487Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301683617Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301861012Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (tmpfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301876003Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301898504Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301908624Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.301954555Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.302145081Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.302250404Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
20:51:20 time="2025-06-17T20:51:16.302264954Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
20:51:20 time="2025-06-17T20:51:16.302293025Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
20:51:20 time="2025-06-17T20:51:16.302326956Z" level=info msg="metadata content store policy set" policy=shared
20:51:20 time="2025-06-17T20:51:16.302511451Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
20:51:20 time="2025-06-17T20:51:16.302542043Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
20:51:20 time="2025-06-17T20:51:16.302557563Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
20:51:20 time="2025-06-17T20:51:16.302574413Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
20:51:20 time="2025-06-17T20:51:16.302592214Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
20:51:20 time="2025-06-17T20:51:16.304538772Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
20:51:20 time="2025-06-17T20:51:16.304855011Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
20:51:20 time="2025-06-17T20:51:16.305061927Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
20:51:20 time="2025-06-17T20:51:16.305077987Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
20:51:20 time="2025-06-17T20:51:16.305101088Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
20:51:20 time="2025-06-17T20:51:16.305115469Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305128899Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305141980Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305156770Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305172850Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305192941Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305206411Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305218902Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
20:51:20 time="2025-06-17T20:51:16.305240282Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305255683Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305269783Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305284234Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305297384Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305311314Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305326015Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305343546Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305357226Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305372396Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305384247Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305396817Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305410508Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305435658Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
20:51:20 time="2025-06-17T20:51:16.305458509Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305487130Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305501970Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
20:51:20 time="2025-06-17T20:51:16.305571612Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
20:51:20 time="2025-06-17T20:51:16.305588083Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
20:51:20 time="2025-06-17T20:51:16.305598653Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
20:51:20 time="2025-06-17T20:51:16.305611523Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
20:51:20 time="2025-06-17T20:51:16.305655085Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
20:51:20 time="2025-06-17T20:51:16.305676405Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
20:51:20 time="2025-06-17T20:51:16.305689566Z" level=info msg="NRI interface is disabled by configuration."
20:51:20 time="2025-06-17T20:51:16.307264792Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
20:51:20 time="2025-06-17T20:51:16.307377396Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
20:51:20 time="2025-06-17T20:51:16.307504659Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
20:51:20 time="2025-06-17T20:51:16.307538671Z" level=info msg="containerd successfully booted in 0.029946s"
20:51:20 time="2025-06-17T20:51:17.255195958Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
20:51:20 time="2025-06-17T20:51:17.284946988Z" level=info msg="Loading containers: start."
20:51:20 time="2025-06-17T20:51:17.523743606Z" level=info msg="Loading containers: done."
20:51:20 time="2025-06-17T20:51:17.536261227Z" level=info msg="Docker daemon" commit=38b84dce32c45732606fe09ffebef8b29a783644 containerd-snapshotter=false storage-driver=overlay2 version=27.5.0-1
20:51:20 time="2025-06-17T20:51:17.536524694Z" level=info msg="Daemon has completed initialization"
20:51:20 time="2025-06-17T20:51:17.549899100Z" level=info msg="API listen on /var/run/docker.sock"
20:51:20 Loading image...
20:51:56 Loaded image: aztecprotocol/aztec:latest
20:51:57
Installing scripts in /home/ubuntu/.aztec/bin...
20:51:57 Installed: /home/ubuntu/.aztec/bin/.aztec-run
20:51:57 Installed: /home/ubuntu/.aztec/bin/aztec
20:51:57 Installed: /home/ubuntu/.aztec/bin/aztec-up
20:51:57 Installed: /home/ubuntu/.aztec/bin/aztec-nargo
20:51:57 Installed: /home/ubuntu/.aztec/bin/aztec-wallet
20:51:57
Done!
20:52:03
20:52:03 _
20:52:03 /\ | |
20:52:03 / \ ___| |_ ___ ___
20:52:03 / /\ \ |_ / __/ _ \/ __|
20:52:03 / ____ \ / /| || __/ (__
20:52:03 /_/___ \_\/___|\__\___|\___|
20:52:03
20:52:03
https://github.com/AztecProtocol
20:52:03
20:52:03
20:52:03 Setting up Aztec Sandbox 04abcb151443d51d2f1b002a2412a083a9384a51, please stand by...
20:52:03 Setting up test accounts
20:52:04 [20:52:04.378]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-eWmpSd/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads.
20:52:04 [20:52:04.452]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
20:52:04 [20:52:04.459]
WARN:
sandbox Set block interval to 12
20:52:04 [20:52:04.695]
INFO:
sandbox Waiting for 7 transactions to be mined...
20:52:04 [20:52:04.731]
INFO:
sandbox All transactions mined successfully
20:52:04 [20:52:04.827]
INFO:
sandbox Waiting for 9 transactions to be mined...
20:52:04 [20:52:04.865]
INFO:
sandbox All transactions mined successfully
20:52:05 [20:52:05.091]
INFO:
sandbox Waiting for 11 transactions to be mined...
20:52:05 [20:52:05.122]
INFO:
sandbox All transactions mined successfully
20:52:05 [20:52:05.196]
INFO:
sandbox Waiting for 12 transactions to be mined...
20:52:05 [20:52:05.224]
INFO:
sandbox All transactions mined successfully
20:52:05 [20:52:05.235]
INFO:
sandbox Waiting for 12 transactions to be mined...
20:52:05 [20:52:05.255]
INFO:
sandbox All transactions mined successfully
20:52:05 [20:52:05.298]
INFO:
sandbox Aztec L1 contracts initialized
{"registryAddress":"0xa86e85110d4e2b1aea1ab2ad2934a16934df8144","governanceAddress":"0x8f09af5dc083b064aa01a16fa3eb9f63d6a2ae4a","governanceProposerAddress":"0xc23e89d2877bd0b432a4bfd405b5d95b9a26a331","rollupAddress":"0xb6c2fcb74963e295df758fba262d5cfc4a99bf96","inboxAddress":"0xc49d22d02320c874452315ae9db79dcd72bd3926","outboxAddress":"0x59febbca9ca6e7ab398b1a605716a9211aec7784","feeJuicePortalAddress":"0xdf5412f583f700d9b311e7266b25f471cf663285","feeJuiceAddress":"0x8a00b42331f81b10f2e6e789d2d33f0055532b7d","stakingAssetAddress":"0x5c63d9f2bcc46a53be89a6e3fe8a7c65084d85b5","rewardDistributorAddress":"0x230503758b07b237ef17312c1670fa0fd6be7e93","gseAddress":"0x3b7d73c762041564af9c6abe42b9d0fe00d63a4f","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
20:52:05 [20:52:05.298]
INFO:
sandbox Handing over to governance
20:52:05 [20:52:05.311]
INFO:
sandbox Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
20:52:05 [20:52:05.315]
INFO:
sandbox Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
20:52:05 [20:52:05.321]
INFO:
sandbox Deployed Multicall3
20:52:05 [20:52:05.327]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0xB6C2fCB74963E295Df758FBA262d5cFc4a99bF96
20:52:05 [20:52:05.328]
INFO:
telemetry:client Using NoopTelemetryClient
20:52:05 [20:52:05.328]
INFO:
blob-sink:client Creating local blob sink client.
20:52:05 [20:52:05.336]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
20:52:05 [20:52:05.337]
WARN:
foundation:test-date-provider Time set to 2025-06-17T20:57:10.000Z
{"offset":304663,"timeMs":1750193830000}
20:52:05 [20:52:05.389]
INFO:
archiver:lmdb Starting data store with maxReaders 16
20:52:05 [20:52:05.772]
INFO:
archiver Starting archiver sync to rollup contract 0xb6c2fcb74963e295df758fba262d5cfc4a99bf96 from L1 block 20 to current L1 block 26 with hash 0x190ad523d962571feb3d5fc7ad3c7655e80939dd313df137a52bfcabb9fd083b
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xea68421c46bdd814ad0dc71e1f1f7d18241053a229a2fb369b76cbc271639071","l1BlockNumber":20}}
20:52:05 [20:52:05.792]
INFO:
archiver Initial archiver sync to L1 block 26 complete.
{"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
20:52:05 [20:52:05.804]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-nk5BHw/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads.
20:52:05 [20:52:05.833]
INFO:
world_state Created world state synchroniser with block history of 64
20:52:05 [20:52:05.833]
WARN:
node Aztec node is accepting fake proofs
20:52:05 [20:52:05.857]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
20:52:05 [20:52:05.863]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
20:52:05 [20:52:05.866]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
20:52:05 [20:52:05.868]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
20:52:05 [20:52:05.872]
INFO:
world_state Started world state synchronizer from block 1
20:52:06 [20:52:05.877]
INFO:
p2p Starting p2p client from block 0 with empty mempools
20:52:06 [20:52:06.115]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
20:52:06 [20:52:06.170]
INFO:
slasher Starting Slasher client...
20:52:06 [20:52:06.192]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
20:52:06 [20:52:06.193]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/usr/src/acvm","acvmBinaryPath":"/usr/src/noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true}
20:52:06 [20:52:06.194]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
20:52:06 [20:52:06.195]
INFO:
node Aztec Node version: 04abcb151443d51d2f1b002a2412a083a9384a51
20:52:06 [20:52:06.195]
INFO:
node Aztec Node started on chain 0x7a69
{"rollupAddress":"0xb6c2fcb74963e295df758fba262d5cfc4a99bf96","registryAddress":"0xa86e85110d4e2b1aea1ab2ad2934a16934df8144","inboxAddress":"0xc49d22d02320c874452315ae9db79dcd72bd3926","outboxAddress":"0x59febbca9ca6e7ab398b1a605716a9211aec7784","feeJuiceAddress":"0x8a00b42331f81b10f2e6e789d2d33f0055532b7d","stakingAssetAddress":"0x5c63d9f2bcc46a53be89a6e3fe8a7c65084d85b5","feeJuicePortalAddress":"0xdf5412f583f700d9b311e7266b25f471cf663285","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0x230503758b07b237ef17312c1670fa0fd6be7e93","governanceProposerAddress":"0xc23e89d2877bd0b432a4bfd405b5d95b9a26a331","governanceAddress":"0x8f09af5dc083b064aa01a16fa3eb9f63d6a2ae4a","slashFactoryAddress":"0x1b487b7d45eb57416f3c2414924768aa8dbaabdd","feeAssetHandlerAddress":"0xb3e5e5a18734c10781e0d140ecb8800fbc03bf9c","stakingAssetHandlerAddress":"0xdfe4ff4dc39c10d02231f86a8539fbcfde1c0244","gseAddress":"0x3b7d73c762041564af9c6abe42b9d0fe00d63a4f","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
20:52:06 [20:52:06.197]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
20:52:06 Setting up funded test accounts...
20:52:06 [20:52:06.573]
INFO:
pxe:service Started PXE connected to chain 31337 version 957172393
20:52:06 [20:52:06.620]
INFO:
pxe:service Registered account 0x157696a468edc69cc6656e0bb7cc82fd2a3d43d47e7076cc7ce0a7b93514e89f
20:52:06 [20:52:06.691]
WARN:
pxe:service No artifact found for contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 when looking for its metadata
20:52:06 [20:52:06.693]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 as part of deployment for 0x157696a468edc69cc6656e0bb7cc82fd2a3d43d47e7076cc7ce0a7b93514e89f
20:52:06 [20:52:06.877]
INFO:
pxe:service Added contract SchnorrAccount at 0x157696a468edc69cc6656e0bb7cc82fd2a3d43d47e7076cc7ce0a7b93514e89f with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2
20:52:11 [20:52:10.089]
INFO:
pxe:service Proving completed in 3142.7672169999987ms
{"timings":{"total":3142.7672169999987,"sync":18.750019000000975,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":178.43349299999863,"oracles":{"callPrivateFunction":{"times":[1290.613041999999,328.6062860000002,193.0422180000005]}}},{"functionName":"private_kernel_init","time":121.71202500000072},{"functionName":"ContractClassRegisterer:register","time":1265.4034909999991,"oracles":{"loadCapsule":{"times":[26.555820000001404]},"notifyCreatedNullifier":{"times":[1.0125500000012835]},"debugLog":{"times":[0.6810499999992317]},"notifyCreatedContractClassLog":{"times":[11.243074999998498]}}},{"functionName":"private_kernel_inner","time":123.90115999999944},{"functionName":"SchnorrAccount:constructor","time":304.4966280000008,"oracles":{"getContractInstance":{"times":[0.9833890000008978]},"debugLog":{"times":[0.2591579999989335,0.17368500000156928]},"fetchTaggedLogs":{"times":[55.6671580000002]},"loadCapsule":{"times":[0.3718910000006872,0.24125800000001618,0.23266700000021956]},"validateEnqueuedNotesAndEvents":{"times":[2.35283999999956]},"notifyCreatedNullifier":{"times":[0.2633780000014667,0.3601010000002134]},"notifyCreatedNote":{"times":[0.7090210000005754]},"getRandomField":{"times":[0.2525470000000496,0.34309099999882164,0.1569550000003801,0.11781300000075134,0.2219070000010106,0.0938029999997525,0.061991000000489294,0.06358200000067882,0.0534509999997681,0.07630200000130571,0.05651200000102108]},"getIndexedTaggingSecretAsSender":{"times":[44.10560400000031]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.20995100000073]}}},{"functionName":"private_kernel_inner","time":93.37568999999894},{"functionName":"SchnorrAccount:entrypoint","time":172.50096700000176,"oracles":{"debugLog":{"times":[0.367750999999771,0.14420400000017253,0.5055449999999837]},"fetchTaggedLogs":{"times":[51.76579100000163]},"loadCapsule":{"times":[0.414651999999478,0.34029000000009546,0.3101590000005672]},"validateEnqueuedNotesAndEvents":{"times":[2.046481000001222]},"getNotes":{"times":[2.6957299999994575]},"getAuthWitness":{"times":[0.2790180000010878]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2397170000003825]}}},{"functionName":"private_kernel_inner","time":128.232657999999},{"functionName":"private_kernel_reset","time":184.39034099999844},{"functionName":"private_kernel_tail","time":63.138890000000174}],"unaccounted":488.4318550000007}}
20:52:11 [20:52:10.205]
INFO:
node Received tx 0x1a120e3ce7efe60a676b72324444a79dac78d80e3301113514e1f74465ffdad1
{"txHash":"0x1a120e3ce7efe60a676b72324444a79dac78d80e3301113514e1f74465ffdad1"}
20:52:11 [20:52:10.206]
INFO:
pxe:service Sent transaction 0x1a120e3ce7efe60a676b72324444a79dac78d80e3301113514e1f74465ffdad1
20:52:11 [20:52:10.785]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.054461482000000616s
{"duration":0.054461482000000616,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
20:52:11 [20:52:10.816]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2ede641decd2407411a4cb286a7abf14a1a22a45dec43c600bd8e316eb6e3dac","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750193830,"version":957172393},"txHashes":["0x1a120e3ce7efe60a676b72324444a79dac78d80e3301113514e1f74465ffdad1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":101.1882540000006,"publicProcessDuration":55.37788899999941,"rollupCircuitsDuration":93.02740000000085,"txCount":1,"blockNumber":1,"blockTimestamp":1750193830,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
20:52:14 [20:52:13.711]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
20:52:14 [20:52:13.794]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2ede641decd2407411a4cb286a7abf14a1a22a45dec43c600bd8e316eb6e3dac","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750193830,"version":957172393},"archiveRoot":"0x21b50fd2c68adf720803ff8f07a21347ae1f5fb8c3d0b99d7a5d1cffd7096481","archiveNextLeafIndex":2}
20:52:14 [20:52:13.811]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750193866
20:52:14 [20:52:13.812]
WARN:
foundation:test-date-provider Time set to 2025-06-17T20:57:46.000Z
{"offset":332189,"timeMs":1750193866000}
20:52:14 [20:52:13.812]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
20:52:14 [20:52:13.883]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xb6c2fcb74963e295df758fba262d5cfc4a99bf96 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
20:52:14 [20:52:13.885]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
20:52:14 [20:52:13.950]
INFO:
pxe:service Registered account 0x0b32ce2392c99abd1a21295c84868ee1924f3ed05f411aabbb9e4ce21be248a5
20:52:14 [20:52:14.067]
INFO:
pxe:service Added contract SchnorrAccount at 0x0b32ce2392c99abd1a21295c84868ee1924f3ed05f411aabbb9e4ce21be248a5 with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2
20:52:14 [20:52:14.120]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":8.04725899999903,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750193830,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
20:52:14 [20:52:14.371]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
20:52:16 [20:52:15.855]
INFO:
pxe:service Proving completed in 1763.5004180000014ms
{"timings":{"total":1763.5004180000014,"sync":13.39904899999965,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":116.26103799999692,"oracles":{"callPrivateFunction":{"times":[388.9542339999989,273.72369700000127]}}},{"functionName":"private_kernel_init","time":74.05665099999896},{"functionName":"SchnorrAccount:constructor","time":354.2445310000021,"oracles":{"getContractInstance":{"times":[9.423221000000922]},"debugLog":{"times":[0.14443500000015774,0.2526879999986704]},"fetchTaggedLogs":{"times":[124.88639200000034]},"loadCapsule":{"times":[0.397170999998707,1.3425100000004022,0.733382000000347]},"validateEnqueuedNotesAndEvents":{"times":[2.8915560000004916]},"notifyCreatedNullifier":{"times":[0.2616580000012618,0.4480839999996533]},"notifyCreatedNote":{"times":[0.14726399999926798]},"getRandomField":{"times":[0.20332600000074308,0.2754480000003241,0.13619400000061432,0.10207300000001851,0.0771020000011049,0.07861200000115787,0.05994199999986449,0.0749519999990298,0.10451299999840558,0.05434100000093167,0.08066200000030221]},"getIndexedTaggingSecretAsSender":{"times":[51.49249100000088]},"incrementAppTaggingSecretIndexAsSender":{"times":[31.299129999999423]}}},{"functionName":"private_kernel_inner","time":135.61338199999955},{"functionName":"SchnorrAccount:entrypoint","time":248.34722200000033,"oracles":{"debugLog":{"times":[0.4510630000004312,0.292648000000554,0.3930819999986852]},"fetchTaggedLogs":{"times":[88.48237999999947]},"loadCapsule":{"times":[0.3199590000003809,0.7795630000000529,0.43278300000019954]},"validateEnqueuedNotesAndEvents":{"times":[3.3240889999997307]},"getNotes":{"times":[2.847075000001496]},"getAuthWitness":{"times":[0.27371800000037183]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1794059999992896]}}},{"functionName":"private_kernel_inner","time":154.63502700000026},{"functionName":"private_kernel_reset","time":205.33311499999763},{"functionName":"private_kernel_tail","time":86.06439799999862}],"unaccounted":375.5460050000074}}
20:52:16 [20:52:15.917]
INFO:
node Received tx 0x23b769990a07a2cc1ec92d503cc8d177627cb8964db056d094b53e2181c7f769
{"txHash":"0x23b769990a07a2cc1ec92d503cc8d177627cb8964db056d094b53e2181c7f769"}
20:52:16 [20:52:15.917]
INFO:
pxe:service Sent transaction 0x23b769990a07a2cc1ec92d503cc8d177627cb8964db056d094b53e2181c7f769
20:52:16 [20:52:16.503]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.026531128000002353s
{"duration":0.026531128000002353,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
20:52:16 [20:52:16.527]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0b2fd288018f18ddd6cfe34a0e956874b2e4303297b0482e0e59cf7800fd06c8","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750193866,"version":957172393},"txHashes":["0x23b769990a07a2cc1ec92d503cc8d177627cb8964db056d094b53e2181c7f769"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":65.0445839999993,"publicProcessDuration":26.71116400000028,"rollupCircuitsDuration":54.756898999999976,"txCount":1,"blockNumber":2,"blockTimestamp":1750193866,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
20:52:16 [20:52:16.744]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
20:52:16 [20:52:16.770]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750193902
20:52:16 [20:52:16.770]
WARN:
foundation:test-date-provider Time set to 2025-06-17T20:58:22.000Z
{"offset":365230,"timeMs":1750193902000}
20:52:16 [20:52:16.770]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
20:52:17 [20:52:16.932]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xb6c2fcb74963e295df758fba262d5cfc4a99bf96 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
20:52:17 [20:52:16.933]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
20:52:17 [20:52:17.014]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x0b2fd288018f18ddd6cfe34a0e956874b2e4303297b0482e0e59cf7800fd06c8","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750193866,"version":957172393},"archiveRoot":"0x1696d2ad9047e10242c3bbdca9d7a46ddad7001a718a67ed8780276fb8dd211c","archiveNextLeafIndex":3}
20:52:17 [20:52:17.015]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
20:52:17 [20:52:17.077]
INFO:
pxe:service Registered account 0x2031b54a5398e358d402af9a09f599b742f5943d83ff10e5e40a576d9a22c18b
20:52:17 [20:52:17.186]
INFO:
pxe:service Added contract SchnorrAccount at 0x2031b54a5398e358d402af9a09f599b742f5943d83ff10e5e40a576d9a22c18b with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2
20:52:17 [20:52:17.224]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":5.461621999998897,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750193866,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}