Parent Log:
http://ci.aztec-labs.com/f390c288863afd04
Command: 01fd3f15e3ce3b51 aztec-up/scripts/run_test.sh bridge_and_claim
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/6e2f55a89973b55c8c3c210b7f3a692b4d3d6473
Env: REF_NAME=gh-readonly-queue/next/pr-15216-b52f0ff5ec39d6832a15613ed349e6e2f8077a2d CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 23 15:59:47 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15216_amd64_x4-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_ee64b3b6ca626708_next
15:59:47 Unable to find image 'aztecprotocol/dind:latest' locally
15:59:47 latest: Pulling from aztecprotocol/dind
15:59:47 afad30e59d72: Pulling fs layer
15:59:47 4e9c72eacf62: Pulling fs layer
15:59:47 1fdf475197e7: Pulling fs layer
15:59:47 5be0e287c3f8: Pulling fs layer
15:59:47 5be0e287c3f8: Download complete
15:59:47 4e9c72eacf62: Download complete
15:59:47 1fdf475197e7: Download complete
15:59:48 afad30e59d72: Pull complete
15:59:48 4e9c72eacf62: Pull complete
15:59:52 1fdf475197e7: Pull complete
15:59:52 5be0e287c3f8: Pull complete
15:59:52 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b
15:59:52 Status: Image is up to date for aztecprotocol/dind:latest
15:59:53 Starting docker...
15:59:58 time="2025-06-23T15:59:53.736715484Z" level=info msg="Starting up"
15:59:58 time="2025-06-23T15:59:53.738753617Z" level=info msg="containerd not running, starting managed containerd"
15:59:58 time="2025-06-23T15:59:53.742780783Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=83
15:59:58 time="2025-06-23T15:59:53.772003760Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=1.7.25-1
15:59:58 time="2025-06-23T15:59:53.786052447Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.786296754Z" 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
15:59:58 time="2025-06-23T15:59:53.786319525Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
15:59:58 time="2025-06-23T15:59:53.786336666Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
15:59:58 time="2025-06-23T15:59:53.790028090Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
15:59:58 time="2025-06-23T15:59:53.790049061Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790096212Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790105052Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790300979Z" 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
15:59:58 time="2025-06-23T15:59:53.790316069Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790327290Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790334120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790369111Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790552506Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
15:59:58 time="2025-06-23T15:59:53.790667940Z" 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
15:59:58 time="2025-06-23T15:59:53.790680030Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
15:59:58 time="2025-06-23T15:59:53.790707831Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
15:59:58 time="2025-06-23T15:59:53.790740712Z" level=info msg="metadata content store policy set" policy=shared
15:59:58 time="2025-06-23T15:59:53.790908648Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
15:59:58 time="2025-06-23T15:59:53.790938678Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
15:59:58 time="2025-06-23T15:59:53.790954459Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
15:59:58 time="2025-06-23T15:59:53.790970639Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
15:59:58 time="2025-06-23T15:59:53.791017651Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
15:59:58 time="2025-06-23T15:59:53.791210737Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
15:59:58 time="2025-06-23T15:59:53.791605799Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
15:59:58 time="2025-06-23T15:59:53.792015222Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
15:59:58 time="2025-06-23T15:59:53.792041463Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
15:59:58 time="2025-06-23T15:59:53.792066504Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
15:59:58 time="2025-06-23T15:59:53.792084674Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792106365Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792160686Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792184917Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792215848Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792236329Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792255389Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792271660Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
15:59:58 time="2025-06-23T15:59:53.792303561Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792322001Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792337912Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792357553Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792373113Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792390474Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792437125Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792454405Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792470066Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792492297Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792510837Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792554789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792573189Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792591630Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
15:59:58 time="2025-06-23T15:59:53.792629691Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792659912Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792671512Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
15:59:58 time="2025-06-23T15:59:53.792756295Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
15:59:58 time="2025-06-23T15:59:53.792778415Z" 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
15:59:58 time="2025-06-23T15:59:53.792786986Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
15:59:58 time="2025-06-23T15:59:53.792796496Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
15:59:58 time="2025-06-23T15:59:53.792804196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
15:59:58 time="2025-06-23T15:59:53.792815267Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
15:59:58 time="2025-06-23T15:59:53.792828887Z" level=info msg="NRI interface is disabled by configuration."
15:59:58 time="2025-06-23T15:59:53.793263691Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
15:59:58 time="2025-06-23T15:59:53.793383734Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
15:59:58 time="2025-06-23T15:59:53.793490278Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
15:59:58 time="2025-06-23T15:59:53.793533069Z" level=info msg="containerd successfully booted in 0.025374s"
15:59:58 time="2025-06-23T15:59:54.748355646Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
15:59:58 time="2025-06-23T15:59:54.776993396Z" level=info msg="Loading containers: start."
15:59:58 time="2025-06-23T15:59:55.015537475Z" level=info msg="Loading containers: done."
15:59:58 time="2025-06-23T15:59:55.030168249Z" level=info msg="Docker daemon" commit=38b84dce32c45732606fe09ffebef8b29a783644 containerd-snapshotter=false storage-driver=overlay2 version=27.5.0-1
15:59:58 time="2025-06-23T15:59:55.030471309Z" level=info msg="Daemon has completed initialization"
15:59:58 time="2025-06-23T15:59:55.042012517Z" level=info msg="API listen on /var/run/docker.sock"
15:59:58 Loading image...
16:00:31 Loaded image: aztecprotocol/aztec:latest
16:00:32
Installing scripts in /home/ubuntu/.aztec/bin...
16:00:32 Installed: /home/ubuntu/.aztec/bin/.aztec-run
16:00:32 Installed: /home/ubuntu/.aztec/bin/aztec
16:00:32 Installed: /home/ubuntu/.aztec/bin/aztec-up
16:00:32 Installed: /home/ubuntu/.aztec/bin/aztec-nargo
16:00:32 Installed: /home/ubuntu/.aztec/bin/aztec-wallet
16:00:32
Done!
16:00:34 anvil Version: 1.0.0-nightly
16:00:34 Commit SHA: 256cc50331d8a00b86c8e1f18ca092a66e220da5
16:00:34 Build Timestamp: 2025-04-08T06:01:46.133564851Z (1744092106)
16:00:34 Build Profile: maxperf
16:00:39
16:00:39 _
16:00:39 /\ | |
16:00:39 / \ ___| |_ ___ ___
16:00:39 / /\ \ |_ / __/ _ \/ __|
16:00:39 / ____ \ / /| || __/ (__
16:00:39 /_/___ \_\/___|\__\___|\___|
16:00:39
16:00:39
https://github.com/AztecProtocol
16:00:39
16:00:39
16:00:39 Setting up Aztec Sandbox 6e2f55a89973b55c8c3c210b7f3a692b4d3d6473, please stand by...
16:00:39 Setting up test accounts
16:00:41 [16:00:40.577]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-hTlYxs/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads.
16:00:41 [16:00:40.660]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
16:00:41 [16:00:40.665]
WARN:
sandbox Set block interval to 12
16:00:41 [16:00:40.666]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.718]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.741]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.769]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.795]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.820]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.863]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.883]
INFO:
sandbox Waiting for 7 transactions to be mined...
16:00:41 [16:00:40.924]
INFO:
sandbox All transactions mined successfully
16:00:41 [16:00:40.944]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:40.973]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.023]
INFO:
sandbox Waiting for 9 transactions to be mined...
16:00:41 [16:00:41.049]
INFO:
sandbox All transactions mined successfully
16:00:41 [16:00:41.077]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.094]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.109]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.135]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.172]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.231]
INFO:
sandbox Waiting for 11 transactions to be mined...
16:00:41 [16:00:41.266]
INFO:
sandbox All transactions mined successfully
16:00:41 [16:00:41.290]
INFO:
sandbox Deploying contract with salt 0x000000000000000000000000000000000000000000000000000000000000517d
16:00:41 [16:00:41.355]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:00:41 [16:00:41.376]
INFO:
sandbox All transactions mined successfully
16:00:41 [16:00:41.394]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:00:41 [16:00:41.427]
INFO:
sandbox All transactions mined successfully
16:00:41 [16:00:41.443]
INFO:
sandbox Aztec L1 contracts initialized
{"registryAddress":"0x3da98d467897be16ed872456ec329349e3e2b893","governanceAddress":"0x84c6be6b6e148ebeda285040e8f2628fef5903a6","governanceProposerAddress":"0x5476dd7b064561264114d495ef340ea5b0d66c58","rollupAddress":"0xa984bcbed42ffed03d0c147d35ee1763db9c59c8","inboxAddress":"0xff61d927bf9218849594aaf0b8bfd0f0053ae1c1","outboxAddress":"0x586497b8560949a51c3806e1a20c5e7fd70215f9","feeJuicePortalAddress":"0x706b2a36de48215f7d8b84f781a6ce62a4a8fbd1","feeJuiceAddress":"0xb37f7fcbd02654181cf8145a6f58500719051dd7","stakingAssetAddress":"0xd973ae8dfcc519b8ec1498860a0f9282f57c62c3","rewardDistributorAddress":"0x2e357216a6fda8dbdf426dcd5c4ced4eae4be32b","gseAddress":"0x7507fec14825a9adf23a7ad7fbff9513042798f7","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
16:00:41 [16:00:41.443]
INFO:
sandbox Handing over to governance
16:00:41 [16:00:41.458]
INFO:
sandbox Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
16:00:41 [16:00:41.464]
INFO:
sandbox Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
16:00:41 [16:00:41.471]
INFO:
sandbox Deployed Multicall3
16:00:41 [16:00:41.479]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0xa984BCBed42Ffed03d0C147d35EE1763dB9C59c8
16:00:41 [16:00:41.479]
INFO:
telemetry:client Using NoopTelemetryClient
16:00:41 [16:00:41.479]
INFO:
blob-sink:client Creating local blob sink client.
16:00:41 [16:00:41.494]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:00:41 [16:00:41.494]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:05:46.000Z
{"offset":304506,"timeMs":1750694746000}
16:00:41 [16:00:41.521]
INFO:
archiver:lmdb Starting data store with maxReaders 16
16:00:42 [16:00:41.838]
INFO:
archiver Starting archiver sync to rollup contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 from L1 block 20 to current L1 block 26 with hash 0xb0204dd6b3da09710c95695e03bf41b83df574aeeab52d9409f63c2e8aef7dfb
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xf89291353a46be29890bfcdf0b5c117b7324efb4771045d9e955487936973f77","l1BlockNumber":20}}
16:00:42 [16:00:41.854]
INFO:
archiver Initial archiver sync to L1 block 26 complete.
{"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
16:00:42 [16:00:41.870]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-HOMwb6/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads.
16:00:42 [16:00:41.915]
INFO:
world_state Created world state synchroniser with block history of 64
16:00:42 [16:00:41.915]
WARN:
node Aztec node is accepting fake proofs
16:00:42 [16:00:41.915]
INFO:
bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers
16:00:42 [16:00:41.932]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
16:00:42 [16:00:41.937]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
16:00:42 [16:00:41.941]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
16:00:42 [16:00:41.944]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
16:00:42 [16:00:41.949]
INFO:
world_state Started world state synchronizer from block 1
16:00:42 [16:00:41.953]
INFO:
p2p Starting p2p client from block 0 with empty mempools
16:00:42 [16:00:42.220]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
16:00:42 [16:00:42.261]
INFO:
slasher Starting Slasher client...
16:00:42 [16:00:42.275]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:00:42 [16:00:42.275]
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}
16:00:42 [16:00:42.277]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:00:42 [16:00:42.277]
INFO:
node Aztec Node version: 6e2f55a89973b55c8c3c210b7f3a692b4d3d6473
16:00:42 [16:00:42.277]
INFO:
node Aztec Node started on chain 0x7a69
{"rollupAddress":"0xa984bcbed42ffed03d0c147d35ee1763db9c59c8","registryAddress":"0x3da98d467897be16ed872456ec329349e3e2b893","inboxAddress":"0xff61d927bf9218849594aaf0b8bfd0f0053ae1c1","outboxAddress":"0x586497b8560949a51c3806e1a20c5e7fd70215f9","feeJuiceAddress":"0xb37f7fcbd02654181cf8145a6f58500719051dd7","stakingAssetAddress":"0xd973ae8dfcc519b8ec1498860a0f9282f57c62c3","feeJuicePortalAddress":"0x706b2a36de48215f7d8b84f781a6ce62a4a8fbd1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0x2e357216a6fda8dbdf426dcd5c4ced4eae4be32b","governanceProposerAddress":"0x5476dd7b064561264114d495ef340ea5b0d66c58","governanceAddress":"0x84c6be6b6e148ebeda285040e8f2628fef5903a6","slashFactoryAddress":"0xb8f7ff23c06f110697956911492be7ef03bb3fe2","feeAssetHandlerAddress":"0xf2d185a17ab513c17f09600aea8486f22db7ee19","stakingAssetHandlerAddress":"0x809a71a2090e49653548f4c4ef32bd5a4971fbce","gseAddress":"0x7507fec14825a9adf23a7ad7fbff9513042798f7","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
16:00:42 [16:00:42.284]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
16:00:42 Setting up funded test accounts...
16:00:42 [16:00:42.692]
INFO:
pxe:service Started PXE connected to chain 31337 version 1667649171
16:00:42 [16:00:42.744]
INFO:
pxe:service Registered account 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:00:42 [16:00:42.824]
WARN:
pxe:service No artifact found for contract class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d when looking for its metadata
16:00:42 [16:00:42.827]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d as part of deployment for 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:00:43 [16:00:43.017]
INFO:
pxe:service Added contract SchnorrAccount at 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:00:46 [16:00:46.078]
INFO:
pxe:service Proving completed in 3030.395756ms
{"timings":{"total":3030.395756,"sync":2.613842000000659,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":144.34907600000042,"oracles":{"callPrivateFunction":{"times":[1308.4985649999999,305.8235139999997,148.2752070000006]}}},{"functionName":"private_kernel_init","time":118.08274999999958},{"functionName":"ContractClassRegisterer:register","time":1264.8081160000002,"oracles":{"loadCapsule":{"times":[11.978295000000799]},"notifyCreatedNullifier":{"times":[25.81999999999971]},"debugLog":{"times":[0.6223200000003999]},"notifyCreatedContractClassLog":{"times":[8.37691200000154]}}},{"functionName":"private_kernel_inner","time":152.58210199999849},{"functionName":"SchnorrAccount:constructor","time":293.9816719999999,"oracles":{"getContractInstance":{"times":[1.4862360000006447]},"debugLog":{"times":[0.2470180000000255,0.16538500000024214]},"fetchTaggedLogs":{"times":[68.96457099999861]},"loadCapsule":{"times":[0.5132250000006024,0.23642799999834097,0.19347600000037346,0.23275699999976496,0.2854979999992793,0.20259600000099454]},"bulkRetrieveLogs":{"times":[2.2552209999994375]},"validateEnqueuedNotesAndEvents":{"times":[2.0969960000002175]},"notifyCreatedNullifier":{"times":[0.3505910000003496,0.3404310000005353]},"notifyCreatedNote":{"times":[0.49427599999944505]},"getRandomField":{"times":[0.27166899999974703,0.2710690000003524,0.05648199999995995,0.18627600000036182,0.08625199999914912,0.06800199999997858,0.047532000000501284,0.051432000000204425,0.04410199999983888,0.08370199999990291,0.044251000001167995]},"getIndexedTaggingSecretAsSender":{"times":[45.11677400000008]},"incrementAppTaggingSecretIndexAsSender":{"times":[13.118711000000985]}}},{"functionName":"private_kernel_inner","time":113.61051000000043},{"functionName":"SchnorrAccount:entrypoint","time":138.2320920000002,"oracles":{"debugLog":{"times":[0.2634679999991931,0.15287499999976717,0.46067499999844586]},"fetchTaggedLogs":{"times":[21.803673999998864]},"loadCapsule":{"times":[0.6417610000007699,0.5595269999994343,0.31604999999944994,0.5391670000008162,0.21652700000049663,1.1431549999997515]},"bulkRetrieveLogs":{"times":[1.6112709999997605]},"validateEnqueuedNotesAndEvents":{"times":[2.4089850000000297]},"getNotes":{"times":[2.0450439999985974]},"getAuthWitness":{"times":[0.2838289999999688]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0493729999998322]}}},{"functionName":"private_kernel_inner","time":152.34615399999893},{"functionName":"private_kernel_reset","time":178.27140700000018},{"functionName":"private_kernel_tail","time":95.9594679999991}],"unaccounted":375.55856700000186}}
16:00:46 [16:00:46.205]
INFO:
node Received tx 0x069f71bd27350ebcb4f727fbcdc06f1e50c02cdf2957ddb8d42e09f74533b62c
{"txHash":"0x069f71bd27350ebcb4f727fbcdc06f1e50c02cdf2957ddb8d42e09f74533b62c"}
16:00:46 [16:00:46.205]
INFO:
pxe:service Sent transaction 0x069f71bd27350ebcb4f727fbcdc06f1e50c02cdf2957ddb8d42e09f74533b62c
16:00:47 [16:00:46.784]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03587205399999948s
{"duration":0.03587205399999948,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
16:00:47 [16:00:46.811]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2a7d86763c810112b5aec7425da2f3bfdb4258813cc589475a348f84b4d75f66","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750694746,"version":1667649171},"txHashes":["0x069f71bd27350ebcb4f727fbcdc06f1e50c02cdf2957ddb8d42e09f74533b62c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":73.76840200000152,"publicProcessDuration":36.48459300000104,"rollupCircuitsDuration":66.04515999999967,"txCount":1,"blockNumber":1,"blockTimestamp":1750694746,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:00:47 [16:00:47.128]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:00:47 [16:00:47.128]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:05:58.000Z
{"offset":310872,"timeMs":1750694758000}
16:00:47 [16:00:47.135]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:00:47 [16:00:47.141]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
16:00:47 [16:00:47.143]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
16:00:47 [16:00:47.273]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2a7d86763c810112b5aec7425da2f3bfdb4258813cc589475a348f84b4d75f66","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750694746,"version":1667649171},"archiveRoot":"0x10180f75e7139e71eab66182a7d9325dd9c2e9ab6c2939411300e548c3049c6b","archiveNextLeafIndex":2}
16:00:47 [16:00:47.291]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
16:00:47 [16:00:47.307]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694782
16:00:47 [16:00:47.307]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:06:22.000Z
{"offset":334693,"timeMs":1750694782000}
16:00:47 [16:00:47.307]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
16:00:47 [16:00:47.423]
INFO:
pxe:service Registered account 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4
16:00:47 [16:00:47.562]
INFO:
pxe:service Added contract SchnorrAccount at 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:00:47 [16:00:47.629]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":8.185426000000007,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750694746,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:00:49 [16:00:48.842]
INFO:
pxe:service Proving completed in 1252.3261660000007ms
{"timings":{"total":1252.3261660000007,"sync":20.47609100000045,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":76.1203149999983,"oracles":{"callPrivateFunction":{"times":[241.7007050000011,165.2692989999996]}}},{"functionName":"private_kernel_init","time":84.05473400000119},{"functionName":"SchnorrAccount:constructor","time":233.28321099999812,"oracles":{"getContractInstance":{"times":[6.49180399999932]},"debugLog":{"times":[0.1958859999995184,0.07700300000033167]},"fetchTaggedLogs":{"times":[89.72421199999917]},"loadCapsule":{"times":[0.18347600000015518,0.9256189999996423,0.22753799999918556,0.4088530000008177,0.1400549999998475,0.11648299999978917]},"bulkRetrieveLogs":{"times":[1.0529029999997874]},"validateEnqueuedNotesAndEvents":{"times":[1.3438729999998031]},"notifyCreatedNullifier":{"times":[0.22457700000086334,0.30706000000100175]},"notifyCreatedNote":{"times":[0.19542600000022503]},"getRandomField":{"times":[0.12532400000054622,0.18920600000092236,0.07199300000138464,0.035990999998830375,0.0533610000002227,0.05770200000006298,0.036211000000548665,0.029540999999881024,0.049492000000100234,0.03555100000085076,0.04732200000034936]},"getIndexedTaggingSecretAsSender":{"times":[16.39287399999921]},"incrementAppTaggingSecretIndexAsSender":{"times":[18.206371000000217]}}},{"functionName":"private_kernel_inner","time":105.64839100000063},{"functionName":"SchnorrAccount:entrypoint","time":157.0333410000003,"oracles":{"debugLog":{"times":[0.2459579999995185,0.13232400000015332,0.25575799999933224]},"fetchTaggedLogs":{"times":[48.15063800000098]},"loadCapsule":{"times":[0.19762599999921804,0.21261699999922712,0.2595479999999952,0.17405600000165578,0.18547599999874365,0.2345370000002731]},"bulkRetrieveLogs":{"times":[1.2481189999998605]},"validateEnqueuedNotesAndEvents":{"times":[1.3668020000004617]},"getNotes":{"times":[1.2064480000008189]},"getAuthWitness":{"times":[0.18079500000021653]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6064290000012988]}}},{"functionName":"private_kernel_inner","time":106.31713099999979},{"functionName":"private_kernel_reset","time":222.3116370000007},{"functionName":"private_kernel_tail","time":69.24135999999999}],"unaccounted":177.83995500000128}}
16:00:49 [16:00:48.888]
INFO:
node Received tx 0x13a35544f0a2e6f4be47c78e5c4762fc71c7fb7c2d3fe1623b9824cd6ede6f95
{"txHash":"0x13a35544f0a2e6f4be47c78e5c4762fc71c7fb7c2d3fe1623b9824cd6ede6f95"}
16:00:49 [16:00:48.888]
INFO:
pxe:service Sent transaction 0x13a35544f0a2e6f4be47c78e5c4762fc71c7fb7c2d3fe1623b9824cd6ede6f95
16:00:49 [16:00:49.459]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.025403725000000123s
{"duration":0.025403725000000123,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:00:49 [16:00:49.489]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x05ae60354e31ae6ea1cb66a23b0619e4d88eb449437ff1ad00f9052d424c7707","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750694782,"version":1667649171},"txHashes":["0x13a35544f0a2e6f4be47c78e5c4762fc71c7fb7c2d3fe1623b9824cd6ede6f95"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":62.76032699999996,"publicProcessDuration":25.534299999999348,"rollupCircuitsDuration":57.220062999998845,"txCount":1,"blockNumber":2,"blockTimestamp":1750694782,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:00:49 [16:00:49.686]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:00:49 [16:00:49.686]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:06:34.000Z
{"offset":344314,"timeMs":1750694794000}
16:00:49 [16:00:49.690]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:00:49 [16:00:49.694]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
16:00:49 [16:00:49.699]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
16:00:49 [16:00:49.746]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694818
16:00:49 [16:00:49.746]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:06:58.000Z
{"offset":368254,"timeMs":1750694818000}
16:00:49 [16:00:49.746]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
16:00:50 [16:00:49.995]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x05ae60354e31ae6ea1cb66a23b0619e4d88eb449437ff1ad00f9052d424c7707","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750694782,"version":1667649171},"archiveRoot":"0x1277cad5c9792a0ecd2114e1567bbb5028675f33dfc83e3b95381bba71c49ffa","archiveNextLeafIndex":3}
16:00:50 [16:00:49.999]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
16:00:50 [16:00:50.143]
INFO:
pxe:service Registered account 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e
16:00:50 [16:00:50.281]
INFO:
pxe:service Added contract SchnorrAccount at 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:00:50 [16:00:50.344]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":8.183686999998827,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750694782,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:00:52 [16:00:51.611]
INFO:
pxe:service Proving completed in 1301.161075ms
{"timings":{"total":1301.161075,"sync":17.429576000000452,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.07056300000113,"oracles":{"callPrivateFunction":{"times":[277.4783950000001,191.58249400000022]}}},{"functionName":"private_kernel_init","time":62.39127499999995},{"functionName":"SchnorrAccount:constructor","time":266.6068749999995,"oracles":{"getContractInstance":{"times":[1.128725000000486]},"debugLog":{"times":[0.1610049999999319,0.10156300000016927]},"fetchTaggedLogs":{"times":[109.41089900000043]},"loadCapsule":{"times":[0.8918979999998555,0.2178569999996398,0.3028090000007069,0.24230700000043726,0.19628600000032748,0.16895500000100583]},"bulkRetrieveLogs":{"times":[1.4294350000000122]},"validateEnqueuedNotesAndEvents":{"times":[1.3549819999989268]},"notifyCreatedNullifier":{"times":[0.288499000000229,0.2936200000003737]},"notifyCreatedNote":{"times":[0.1666350000014063]},"getRandomField":{"times":[0.17829499999970722,0.21589700000004086,0.074242000000595,0.09706400000141002,0.41322300000138057,0.18493600000147126,0.05740200000036566,0.04209199999968405,0.050752000001011766,0.056360999999014894,0.03363100000024133]},"getIndexedTaggingSecretAsSender":{"times":[19.18032200000016]},"incrementAppTaggingSecretIndexAsSender":{"times":[9.720345000001544]}}},{"functionName":"private_kernel_inner","time":112.79793400000199},{"functionName":"SchnorrAccount:entrypoint","time":182.1501279999993,"oracles":{"debugLog":{"times":[0.1454150000008667,0.06282199999986915,0.13634499999898253]},"fetchTaggedLogs":{"times":[88.77794300000096]},"loadCapsule":{"times":[0.20056600000134495,0.14283400000022084,0.21525699999983772,0.1410840000007738,0.13019399999939196,0.1369940000004135]},"bulkRetrieveLogs":{"times":[1.049232999999731]},"validateEnqueuedNotesAndEvents":{"times":[1.1219249999994645]},"getNotes":{"times":[1.3182510000006005]},"getAuthWitness":{"times":[0.10991400000057183]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.40729300000020885]}}},{"functionName":"private_kernel_inner","time":128.85918799999854},{"functionName":"private_kernel_reset","time":197.86879099999715},{"functionName":"private_kernel_tail","time":77.21490999999878}],"unaccounted":180.7718350000032}}
16:00:52 [16:00:51.656]
INFO:
node Received tx 0x15a03f65fac865eda2c6983b664a03f687878cf30c874a5a87dffe9cb308681d
{"txHash":"0x15a03f65fac865eda2c6983b664a03f687878cf30c874a5a87dffe9cb308681d"}
16:00:52 [16:00:51.657]
INFO:
pxe:service Sent transaction 0x15a03f65fac865eda2c6983b664a03f687878cf30c874a5a87dffe9cb308681d
16:00:52 [16:00:52.236]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.027749189000001933s
{"duration":0.027749189000001933,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:00:52 [16:00:52.263]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2bee823da3fcc0d2138a906b3abca1803d8a29f8ced5b60e3204b13d16f44214","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750694818,"version":1667649171},"txHashes":["0x15a03f65fac865eda2c6983b664a03f687878cf30c874a5a87dffe9cb308681d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":66.51710400000229,"publicProcessDuration":27.88306299999749,"rollupCircuitsDuration":59.14153299999816,"txCount":1,"blockNumber":3,"blockTimestamp":1750694818,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:00:52 [16:00:52.450]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:00:52 [16:00:52.455]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:00:52 [16:00:52.455]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:07:10.000Z
{"offset":377545,"timeMs":1750694830000}
16:00:52 [16:00:52.461]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
16:00:52 [16:00:52.465]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
16:00:52 [16:00:52.518]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694854
16:00:52 [16:00:52.518]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:07:34.000Z
{"offset":401482,"timeMs":1750694854000}
16:00:52 [16:00:52.518]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
16:00:52 [16:00:52.767]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2bee823da3fcc0d2138a906b3abca1803d8a29f8ced5b60e3204b13d16f44214","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750694818,"version":1667649171},"archiveRoot":"0x243df9872f4ce9e12df6a78e4da5b7a235e2e8b78c8ce5d85b9323532dfa287f","archiveNextLeafIndex":4}
16:00:52 [16:00:52.770]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
16:00:52 Initial Accounts:
16:00:52
16:00:52 Address: 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:00:52 Partial Address: 0x195ec6a96ab64a44906026150ba2ddcf9207edb1d78c915a8d879d36348d04f4
16:00:52 Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
16:00:52 Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
16:00:52 Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
16:00:52
16:00:52 Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
16:00:52
16:00:52 Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
16:00:52
16:00:52 Address: 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4
16:00:52 Partial Address: 0x03c3294451f1fc44a211eb54ef48412001f8fe56c25a4449b538621d8bbf5c87
16:00:52 Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
16:00:52 Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
16:00:52 Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
16:00:52
16:00:52 Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
16:00:52
16:00:52 Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
16:00:52
16:00:52 Address: 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e
16:00:52 Partial Address: 0x0ec55390822ffa5d2f79b61a3ba1f32269ca6ebb6ecffcc66d519c372e1d75c6
16:00:52 Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
16:00:52 Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
16:00:52 Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
16:00:52
16:00:52 Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
16:00:52
16:00:52 Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
16:00:52
16:00:52
16:00:53 [16:00:53.600]
WARN:
pxe:service No artifact found for contract class 0x1be9438198cd4a17f90b0053f7d7401f759a3063313e6dcf8db7f63d50653f4f when looking for its metadata
16:00:53 [16:00:53.600]
WARN:
pxe:service No artifact found for contract class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54 when looking for its metadata
16:00:53 [16:00:53.608]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54 as part of deployment for 0x28dd81686d0474176485aec1d0ba84f3a1642608164b31f3bed150fb3d0832ef
16:00:53 [16:00:53.804]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1be9438198cd4a17f90b0053f7d7401f759a3063313e6dcf8db7f63d50653f4f as part of deployment for 0x2b07e0e48fd4dedb04270c765a44384eff50a49b46d0edd0a63f42dee4fd11b2
16:00:53 [16:00:53.857]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":8.228578000002017,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750694818,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:00:54 [16:00:54.477]
INFO:
pxe:service Added contract Token at 0x28dd81686d0474176485aec1d0ba84f3a1642608164b31f3bed150fb3d0832ef with class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54
16:00:54 [16:00:54.479]
INFO:
pxe:service Added contract FPC at 0x2b07e0e48fd4dedb04270c765a44384eff50a49b46d0edd0a63f42dee4fd11b2 with class 0x1be9438198cd4a17f90b0053f7d7401f759a3063313e6dcf8db7f63d50653f4f
16:00:56 [16:00:56.812]
INFO:
pxe:service Proving completed in 2302.994719999999ms
{"timings":{"total":2302.994719999999,"sync":6.929037000001699,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":222.30301600000166,"oracles":{"debugLog":{"times":[0.2274280000019644,0.08009200000014971,0.0790019999985816,0.11759299999903305,0.10976300000038464,0.11447399999815389,0.08169300000008661,0.2575089999991178]},"fetchTaggedLogs":{"times":[61.850627999996505]},"loadCapsule":{"times":[0.21197700000266195,0.12575400000059744,0.40759299999990617,0.21405700000104844,0.21893700000146055,0.23482700000022305,0.21582599999965169,0.2971689999976661,0.1746450000027835,0.16384499999912805]},"getSharedSecret":{"times":[4.297034999999596]},"aes128Decrypt":{"times":[1.0455130000009376,0.5330460000004678]},"getPublicKeysAndPartialAddress":{"times":[1.6368919999986247]},"getKeyValidationRequest":{"times":[2.8063679999977467]},"storeCapsule":{"times":[0.54056700000001,0.3667219999988447,0.26640799999950104]},"deleteCapsule":{"times":[0.4712040000013076]},"bulkRetrieveLogs":{"times":[1.6081000000012864]},"validateEnqueuedNotesAndEvents":{"times":[7.119343000002118]},"getNotes":{"times":[7.424143000000186]},"getAuthWitness":{"times":[0.2579379999988305]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0712920000005397]},"callPrivateFunction":{"times":[977.543654000001,100.23231000000305]},"notifyEnqueuedPublicFunctionCall":{"times":[0.26001800000085495]}}},{"functionName":"private_kernel_init","time":49.46342100000038},{"functionName":"ContractClassRegisterer:register","time":963.0655110000007,"oracles":{"loadCapsule":{"times":[1.9330100000006496]},"notifyCreatedNullifier":{"times":[0.3376399999979185]},"debugLog":{"times":[0.10434300000270014]},"notifyCreatedContractClassLog":{"times":[7.01593000000139]}}},{"functionName":"private_kernel_inner","time":119.98143999999957},{"functionName":"ContractInstanceDeployer:deploy","time":66.47887399999672,"oracles":{"storeInExecutionCache":{"times":[0.2269769999984419]},"callPrivateFunction":{"times":[40.77640699999756]},"notifyCreatedNullifier":{"times":[0.19250599999941187]},"debugLog":{"times":[0.12048299999878509]}}},{"functionName":"private_kernel_inner","time":102.22700299999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":23.472755000002508,"oracles":{}},{"functionName":"private_kernel_inner","time":126.64867800000138},{"functionName":"private_kernel_reset","time":175.58848299999954},{"functionName":"private_kernel_tail","time":95.8274829999973}],"unaccounted":351.00901899999735}}
16:00:56 [16:00:56.961]
INFO:
node Received tx 0x286d035510c95835e124688595fa482bc2d1f3a041b30af0d0ab7a50035e97b8
{"txHash":"0x286d035510c95835e124688595fa482bc2d1f3a041b30af0d0ab7a50035e97b8"}
16:00:56 [16:00:56.961]
INFO:
pxe:service Sent transaction 0x286d035510c95835e124688595fa482bc2d1f3a041b30af0d0ab7a50035e97b8
16:01:00 [16:00:59.548]
INFO:
pxe:service Proving completed in 2734.6412149999996ms
{"timings":{"total":2734.6412149999996,"sync":135.0917240000017,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":399.35032399999545,"oracles":{"debugLog":{"times":[0.19119599999976344,0.06890199999907054,0.11051299999962794,0.22083700000075623,0.15384500000072876,0.11570399999982328,0.10253300000113086,0.18264600000111386]},"fetchTaggedLogs":{"times":[133.05184999999983]},"loadCapsule":{"times":[0.3161499999987427,0.17420599999968545,0.3545610000001034,0.48131499999726657,0.2969890000022133,0.35159099999873433,1.165327000002435,0.3282199999994191,0.28595900000073016,1.6588520000004792]},"getSharedSecret":{"times":[12.412179000002652]},"aes128Decrypt":{"times":[0.3533710000010615,0.7364029999989725]},"getPublicKeysAndPartialAddress":{"times":[20.7191899999998]},"getKeyValidationRequest":{"times":[3.5475810000025376]},"storeCapsule":{"times":[0.3757819999991625,0.3066499999986263,0.6078089999973599]},"deleteCapsule":{"times":[0.2856690000007802]},"bulkRetrieveLogs":{"times":[2.766867000002094]},"validateEnqueuedNotesAndEvents":{"times":[73.34086799999932]},"getNotes":{"times":[2.623911999999109]},"getAuthWitness":{"times":[0.22000699999989592]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0667730000022857]},"callPrivateFunction":{"times":[970.4477420000003,103.81273399999918]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07708199999979115]}}},{"functionName":"private_kernel_init","time":71.6718260000016},{"functionName":"ContractClassRegisterer:register","time":958.9004400000013,"oracles":{"loadCapsule":{"times":[1.4274249999980384]},"notifyCreatedNullifier":{"times":[0.47551499999826774]},"debugLog":{"times":[0.12519299999985378]},"notifyCreatedContractClassLog":{"times":[5.9999080000015965]}}},{"functionName":"private_kernel_inner","time":148.27168800000072},{"functionName":"ContractInstanceDeployer:deploy","time":59.61882700000206,"oracles":{"storeInExecutionCache":{"times":[0.1659350000008999]},"callPrivateFunction":{"times":[46.86203800000294]},"notifyCreatedNullifier":{"times":[0.30615899999975227]},"debugLog":{"times":[0.15138500000102795]}}},{"functionName":"private_kernel_inner","time":139.84889399999884},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.44395199999781,"oracles":{}},{"functionName":"private_kernel_inner","time":99.69306500000312},{"functionName":"private_kernel_reset","time":157.80857599999945},{"functionName":"private_kernel_tail","time":73.92844699999841}],"unaccounted":455.01345199999923}}
16:01:00 [16:00:59.645]
INFO:
node Received tx 0x06d75739c81654dab9102515f2c8e374d8442aa8afb48a28ac61fbde330afb46
{"txHash":"0x06d75739c81654dab9102515f2c8e374d8442aa8afb48a28ac61fbde330afb46"}
16:01:00 [16:00:59.645]
INFO:
pxe:service Sent transaction 0x06d75739c81654dab9102515f2c8e374d8442aa8afb48a28ac61fbde330afb46
16:01:00 [16:00:59.672]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.572461071999998s
{"duration":2.572461071999998,"rate":123015.27259029412,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
16:01:00 [16:00:59.738]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 119467.22235155942 mana/s
{"blockHash":"0x1267884979b3e89d5f5b8eaa532e912f5dce803e5da5a91bf793af61362715b8","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750694854,"version":1667649171},"txHashes":["0x286d035510c95835e124688595fa482bc2d1f3a041b30af0d0ab7a50035e97b8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2648.776145,"publicProcessDuration":2572.6007470000004,"rollupCircuitsDuration":2641.779585,"txCount":1,"blockNumber":4,"blockTimestamp":1750694854,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:01:00 [16:01:00.023]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:00 [16:01:00.036]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
16:01:00 [16:01:00.037]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
16:01:00 [16:01:00.056]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694890
16:01:00 [16:01:00.057]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:08:10.000Z
{"offset":429944,"timeMs":1750694890000}
16:01:00 [16:01:00.057]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
16:01:00 [16:01:00.432]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1267884979b3e89d5f5b8eaa532e912f5dce803e5da5a91bf793af61362715b8","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750694854,"version":1667649171},"archiveRoot":"0x00be66bba8991481ca95823410537407ef3d6c6189741f7381fbc9c2b32129be","archiveNextLeafIndex":5}
16:01:00 [16:01:00.436]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
16:01:00 [16:01:00.606]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":13.051688999999897,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750694854,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:01:00 [16:01:00.833]
INFO:
aztecjs:deploy_sent_tx Contract 0x28dd81686d0474176485aec1d0ba84f3a1642608164b31f3bed150fb3d0832ef successfully deployed.
16:01:01 [16:01:01.253]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.17611577000000034s
{"duration":0.17611577000000034,"rate":225936.6097652693,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
16:01:01 [16:01:01.291]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 179169.26545252703 mana/s
{"blockHash":"0x0b5ba226a958cc61c0f58c0b9b0d3c10bd86fa0e1d7ab7d1b49bdc30e120b174","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750694890,"version":1667649171},"txHashes":["0x06d75739c81654dab9102515f2c8e374d8442aa8afb48a28ac61fbde330afb46"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":222.01355799999874,"publicProcessDuration":176.41742000000158,"rollupCircuitsDuration":216.7213730000003,"txCount":1,"blockNumber":5,"blockTimestamp":1750694890,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:01:01 [16:01:01.544]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:01 [16:01:01.545]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694926
16:01:01 [16:01:01.545]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:08:46.000Z
{"offset":464455,"timeMs":1750694926000}
16:01:01 [16:01:01.545]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
16:01:01 [16:01:01.721]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
16:01:01 [16:01:01.722]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
16:01:02 [16:01:02.116]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x0b5ba226a958cc61c0f58c0b9b0d3c10bd86fa0e1d7ab7d1b49bdc30e120b174","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750694890,"version":1667649171},"archiveRoot":"0x260aa5f98b9af89e2b1c352d8080db642bb25a43e1c14e500f63d04cdba5a2f8","archiveNextLeafIndex":6}
16:01:02 [16:01:02.122]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
16:01:02 [16:01:02.139]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":10.961032999999588,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750694890,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:01:02 BananaCoin: 0x28dd81686d0474176485aec1d0ba84f3a1642608164b31f3bed150fb3d0832ef
16:01:02 FPC: 0x2b07e0e48fd4dedb04270c765a44384eff50a49b46d0edd0a63f42dee4fd11b2
16:01:03 [16:01:02.879]
INFO:
aztecjs:deploy_sent_tx Contract 0x2b07e0e48fd4dedb04270c765a44384eff50a49b46d0edd0a63f42dee4fd11b2 successfully deployed.
16:01:03 [16:01:02.913]
WARN:
pxe:service No artifact found for contract class 0x0d07d07598940a6830f09de3c0c6fd4d0bea7ac2e425edc29dfa557545eb62f4 when looking for its metadata
16:01:03 [16:01:02.913]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0d07d07598940a6830f09de3c0c6fd4d0bea7ac2e425edc29dfa557545eb62f4 as part of deployment for 0x12127f11755af3d9705ad35a07502f4092709722efe780ea4d728a02e8508f78
16:01:03 [16:01:03.055]
INFO:
pxe:service Added contract SponsoredFPC at 0x12127f11755af3d9705ad35a07502f4092709722efe780ea4d728a02e8508f78 with class 0x0d07d07598940a6830f09de3c0c6fd4d0bea7ac2e425edc29dfa557545eb62f4
16:01:06 [16:01:05.470]
INFO:
pxe:service Proving completed in 2401.977988999999ms
{"timings":{"total":2401.977988999999,"sync":31.11650500000178,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":86.74119699999574,"oracles":{"callPrivateFunction":{"times":[974.799965000002,137.23250100000223,43.41574000000037]}}},{"functionName":"private_kernel_init","time":74.1130430000012},{"functionName":"ContractClassRegisterer:register","time":949.3102850000032,"oracles":{"loadCapsule":{"times":[2.6220119999998133]},"notifyCreatedNullifier":{"times":[0.42529300000023795]},"debugLog":{"times":[0.17877600000065286]},"notifyCreatedContractClassLog":{"times":[7.261046999999962]}}},{"functionName":"private_kernel_inner","time":114.64338299999872},{"functionName":"ContractInstanceDeployer:deploy","time":87.08666200000152,"oracles":{"storeInExecutionCache":{"times":[0.07415299999775016]},"callPrivateFunction":{"times":[73.43802099999812]},"notifyCreatedNullifier":{"times":[0.6270499999991443]},"debugLog":{"times":[0.16244499999811524]}}},{"functionName":"private_kernel_inner","time":103.77374199999758},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":41.28424300000188,"oracles":{}},{"functionName":"private_kernel_inner","time":116.0551480000031},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":32.04560499999934,"oracles":{"debugLog":{"times":[0.19197599999824888]}}},{"functionName":"private_kernel_inner","time":122.27065299999958},{"functionName":"private_kernel_reset","time":200.91874800000005},{"functionName":"private_kernel_tail","time":73.78446299999996}],"unaccounted":368.8343119999954}}
16:01:06 [16:01:05.597]
INFO:
node Received tx 0x0e3ea7d4e967c35bb8b3154cfa322f1019063c5b09cebcf0efa05411bc35c695
{"txHash":"0x0e3ea7d4e967c35bb8b3154cfa322f1019063c5b09cebcf0efa05411bc35c695"}
16:01:06 [16:01:05.597]
INFO:
pxe:service Sent transaction 0x0e3ea7d4e967c35bb8b3154cfa322f1019063c5b09cebcf0efa05411bc35c695
16:01:06 [16:01:05.659]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03315853900000002s
{"duration":0.03315853900000002,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
16:01:06 [16:01:05.695]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x10c3b83f7072223716a010814f92e1e7effa547358e6a81df038766b5d17ce91","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750694926,"version":1667649171},"txHashes":["0x0e3ea7d4e967c35bb8b3154cfa322f1019063c5b09cebcf0efa05411bc35c695"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":75.51848700000119,"publicProcessDuration":33.38208699999814,"rollupCircuitsDuration":71.15611100000024,"txCount":1,"blockNumber":6,"blockTimestamp":1750694926,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:06 [16:01:05.878]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:06 [16:01:05.904]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:06 [16:01:05.904]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:08:58.000Z
{"offset":472096,"timeMs":1750694938000}
16:01:06 [16:01:05.920]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
16:01:06 [16:01:05.921]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
16:01:06 [16:01:06.100]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750694962
16:01:06 [16:01:06.100]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:09:22.000Z
{"offset":495900,"timeMs":1750694962000}
16:01:06 [16:01:06.100]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
16:01:06 [16:01:06.170]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x10c3b83f7072223716a010814f92e1e7effa547358e6a81df038766b5d17ce91","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750694926,"version":1667649171},"archiveRoot":"0x134b3a9e762d11136830efef486b2f6b668e71dd8427f43cd082c1560ee72f17","archiveNextLeafIndex":7}
16:01:06 [16:01:06.175]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
16:01:06 SponsoredFPC: 0x12127f11755af3d9705ad35a07502f4092709722efe780ea4d728a02e8508f78
16:01:06 [16:01:06.528]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":7.853326000000379,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750694926,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:06 [16:01:06.623]
INFO:
aztecjs:deploy_sent_tx Contract 0x12127f11755af3d9705ad35a07502f4092709722efe780ea4d728a02e8508f78 successfully deployed.
16:01:06 [16:01:06.629]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x1077d4a3bdaf7a197f11cf08170dea38311ed462aaa367fef18e1f0fd3b21197","l2ProtocolContractsTreeRoot":"0x0ef0ebce007b13ba690a833063974936ba993b1d97d31029b77ddef6d5cf6082"}
16:01:09 Registering protocol contract aliases...
16:01:09 Data stored in database with alias contracts:AuthRegistry
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000001
16:01:09 Data stored in database with alias contracts:ContractInstanceDeployer
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000002
16:01:09 Data stored in database with alias contracts:ContractClassRegisterer
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000003
16:01:09 Data stored in database with alias contracts:MultiCallEntrypoint
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000004
16:01:09 Data stored in database with alias contracts:FeeJuice
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000005
16:01:09 Data stored in database with alias contracts:Router
16:01:09 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000006
16:01:09 [16:01:09.337] INFO: wallet Using local PXE service
16:01:09 [16:01:09.339] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:09 [16:01:09.538] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:09 [16:01:09.543] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:10 [16:01:10.229] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:10 [16:01:10.623] INFO: pxe:service Added contract SchnorrAccount at 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:01:10 [16:01:10.627] INFO: pxe:service Added contract SchnorrAccount at 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:01:10 [16:01:10.642] INFO: pxe:service Added contract SchnorrAccount at 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:01:10 [16:01:10.736] INFO: pxe:service Registered account 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:01:10 Account stored in database with aliases last & test0
16:01:10 [16:01:10.744] INFO: pxe:service Registered account 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4
16:01:10 [16:01:10.750] INFO: pxe:service Registered account 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e
16:01:10
16:01:10 Test account:
16:01:10 Alias: test0
16:01:10 Address: 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:01:10 Secret key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
16:01:10 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:10 Account stored in database with aliases last & test1
16:01:10
16:01:10 Test account:
16:01:10 Alias: test1
16:01:10 Address: 0x09d0928db53ac46787ece50ab3bd033b6cd286afcabd5bee155726a1bbcd9cf4
16:01:10 Secret key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
16:01:10 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:10 Account stored in database with aliases last & test2
16:01:10
16:01:10 Test account:
16:01:10 Alias: test2
16:01:10 Address: 0x0a43cfe8278fe466cd13d711611b784ed4f50e2f3d60698d518b923d42442a4e
16:01:10 Secret key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
16:01:10 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:10
16:01:10 3 test accounts imported to wallet db.
16:01:10
16:01:14 [16:01:14.211] INFO: wallet Using local PXE service
16:01:14 [16:01:14.214] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:14 [16:01:14.284] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:14 [16:01:14.294] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:15
16:01:15 New account:
16:01:15
16:01:15 Address: 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870
16:01:15 Public key: 0x1c70ee7ddca3cd0b334e016d8a93379086995708119e3036bf7ae0b8b64520ff10403f723cb81091022da9fc2f0e227385a8f766dca184eed5cda48332c817c8065a6e1cc2bf8777bdd88d80ee46424627ebd0ef2f6f7860e319256d03532ece23b55b48b87152029f2ce2f63caef2c57e7ffaf7ceca3ad761b6911eef792d75118be4267355acbfdd850d838edb3b50afab007ac3521d6699b9b99b097a19b71006a104ae421791f1c81c6b358c46ad774213a8f87c611ca265d1fc53782c2a124284ba794711400a5886a096fa1004306d856c38a7a17b576ac2cac30551f90156ad53698a9c1ddc3c62011e8a387932ac5c38e69bd262272b911541ad9415
16:01:15 Secret key: 0x0d7361fa86337ef125166f7c43b3687235f4de3c149024b04417258292b34edb
16:01:15 Partial address: 0x1489dbfc6c1ffefe5bfc05b0945e88095ad1a11837e3788fd287e7ba2c286844
16:01:15 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:15 Init hash: 0x2ec5eb6f85556570dbdf1fa68fc0a15a8be1c576381cbc29d44b39ecf03a4210
16:01:15 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:15 Account stored in database with aliases last & main
16:01:15 [16:01:15.009] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:15 [16:01:15.204] INFO: pxe:service Added contract SchnorrAccount at 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:01:15 [16:01:15.262] INFO: pxe:service Registered account 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870
16:01:19 [16:01:19.065] INFO: wallet Using local PXE service
16:01:19 [16:01:19.067] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:19 [16:01:19.546] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:19 [16:01:19.549] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:20 Minted 1000000000000000000 fee juice on L1 and pushed to L2 portal
16:01:20 claimAmount=1000000000000000000,claimSecret=0x295a07d41660c07a673f8538c9a9ab54dc943036a5de63639179cabb58f8b1b3,messageHash=0x000562eba1aaeda617bdebf8bc9e5ee0d110e25b2200b3d81e42b5927b16613d,messageLeafIndex=112
16:01:20
16:01:20 Note: You need to wait for two L2 blocks before pulling them from the L2 side
16:01:20 Pushed 1000000000000000000 fee juice for recipient 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870. Stack pointer 1
16:01:20 [16:01:20.270] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:20 [16:01:20.410] INFO: wallet Minting 1000000000000000000 tokens for 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
16:01:20 [16:01:20.433] INFO: wallet Approving 1000000000000000000 tokens for FeeJuice Portal (0x706b2a36de48215f7d8b84f781a6ce62a4a8fbd1)
16:01:20 [16:01:20.459] INFO: wallet Sending L1 Fee Juice to L2 to be claimed publicly
16:01:20 [16:01:20.484] INFO: wallet Deposited to Aztec public successfully
16:01:20 [16:01:20.462]
WARN:
sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 8 but got 9.
{"now":1750694976,"syncedToL1Ts":1750694962,"syncedToL2Slot":8,"nextL2Slot":8,"nextL2SlotTs":1750694962,"l1SlotDuration":12,"rollup":{"blockNumber":7,"slot":9,"timeOfNextL1Slot":1750694998},"newBlockNumber":7,"expectedSlot":8}
16:01:20 [16:01:20.540]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:20 [16:01:20.540]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:09:58.000Z
{"offset":517460,"timeMs":1750694998000}
16:01:20 [16:01:20.782]
INFO:
archiver Retrieved 1 new L1 to L2 messages up to message with index 112 for L2 block 8
{"lastMessage":{"index":112,"l1BlockHash":"0x6e3c299466fae25fc6c1205fe2f2f8dd4ec8e72d9e14ee548f43ab9c66238f8c","l1BlockNumber":41,"l2BlockNumber":8,"leaf":"0x000562eba1aaeda617bdebf8bc9e5ee0d110e25b2200b3d81e42b5927b16613d","rollingHash":"0xc164c8eed25c47ae9579010675024b83"},"messageCount":1}
16:01:27 [16:01:27.416] INFO: wallet Using local PXE service
16:01:27 [16:01:27.418] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:27 [16:01:27.491] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:27 [16:01:27.495] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:28 [16:01:28.194] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:28 [16:01:28.276] INFO: wallet Using wallet with address 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:01:28 [16:01:28.831] WARN: pxe:service No artifact found for contract class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54 when looking for its metadata
16:01:29 [16:01:29.304] INFO: pxe:service Added contract Token at 0x0047ff4eab8a355689a5ded7bc614538da94884ce5aec31262c16205e0749229 with class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54
16:01:31 [16:01:31.634]
INFO:
node Received tx 0x217f6dc6db648d3b505ec37d9b223465594d25867002088f75f1eec075dbae06
{"txHash":"0x217f6dc6db648d3b505ec37d9b223465594d25867002088f75f1eec075dbae06"}
16:01:32 [16:01:32.210]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24423472099999344s
{"duration":0.24423472099999344,"rate":1295688.011533825,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472}
16:01:32 [16:01:32.240]
INFO:
sequencer Built block 7 for slot 9 with 1 txs and 0 messages. 1115088.0945212087 mana/s
{"blockHash":"0x079162a60ce108e13e39900560f19442562bf558b878f635f4b1c9e59511095c","globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750694998,"version":1667649171},"txHashes":["0x217f6dc6db648d3b505ec37d9b223465594d25867002088f75f1eec075dbae06"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":283.74421900000016,"publicProcessDuration":244.38082600000052,"rollupCircuitsDuration":277.5161650000009,"txCount":1,"blockNumber":7,"blockTimestamp":1750694998,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:32 [16:01:32.451]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:32 [16:01:32.489]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7
16:01:32 [16:01:32.493]
INFO:
aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7.
16:01:32 [16:01:31.539] INFO: pxe:service Proving completed in 2221.3659399999997ms {"timings":{"total":2221.3659399999997,"sync":298.61154899999974,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":709.385061,"oracles":{"debugLog":{"times":[1.0619729999998526,0.2333570000000691,0.19388600000002043,0.33056000000033237,0.2467980000001262,0.1971559999992678,0.15306499999951484,0.31196900000031746]},"fetchTaggedLogs":{"times":[370.5820330000006]},"loadCapsule":{"times":[0.729392000000189,0.25442800000018906,0.5315669999999955,0.35783099999935075,0.3722120000002178,0.24041699999997945,0.33154000000013184,0.20838699999967503,0.3851619999995819,0.2750880000003235]},"getSharedSecret":{"times":[6.523441999999704]},"aes128Decrypt":{"times":[1.251169000000118,0.9682899999997971]},"getPublicKeysAndPartialAddress":{"times":[2.342453000000205]},"getKeyValidationRequest":{"times":[3.32364299999972]},"storeCapsule":{"times":[3.155058000000281,3.5570200000001932,3.000173000000359]},"deleteCapsule":{"times":[2.9285110000000714]},"bulkRetrieveLogs":{"times":[6.058338000000731]},"validateEnqueuedNotesAndEvents":{"times":[35.578665]},"getNotes":{"times":[3.261970999999903]},"getAuthWitness":{"times":[0.2457780000004277]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5131860000001325]},"callPrivateFunction":{"times":[115.14154400000007]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2023460000000341]}}},{"functionName":"private_kernel_init","time":133.03723900000023},{"functionName":"ContractInstanceDeployer:deploy","time":57.73186199999964,"oracles":{"storeInExecutionCache":{"times":[0.29232000000047265]},"callPrivateFunction":{"times":[64.25488499999938]},"notifyCreatedNullifier":{"times":[0.3989419999998063]},"debugLog":{"times":[0.24427800000012212]}}},{"functionName":"private_kernel_inner","time":152.95795799999996},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":49.96994200000063,"oracles":{}},{"functionName":"private_kernel_inner","time":124.76030900000023},{"functionName":"private_kernel_reset","time":205.8562890000003},{"functionName":"private_kernel_tail","time":101.66846499999974}],"unaccounted":387.3872659999993}}
16:01:32 [16:01:31.636] INFO: pxe:service Sent transaction 0x217f6dc6db648d3b505ec37d9b223465594d25867002088f75f1eec075dbae06
16:01:32 [16:01:32.658]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695034
16:01:32 [16:01:32.658]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:10:34.000Z
{"offset":541342,"timeMs":1750695034000}
16:01:32 [16:01:32.658]
INFO:
aztecjs:utils:watcher Slot 9 was filled, jumped to next slot
16:01:32 [16:01:32.753]
INFO:
archiver Downloaded L2 block 7
{"blockHash":"0x079162a60ce108e13e39900560f19442562bf558b878f635f4b1c9e59511095c","blockNumber":7,"txCount":1,"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750694998,"version":1667649171},"archiveRoot":"0x1b408f0cee250469897bdfaae884b9df5a77c0c339d31af74362dd539e360863","archiveNextLeafIndex":8}
16:01:32 [16:01:32.757]
INFO:
archiver Updated proven chain to block 7
{"provenBlockNumber":7}
16:01:33 [16:01:32.972]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":7.394992000001366,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750694998,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:33 Contract deployed at 0x0047ff4eab8a355689a5ded7bc614538da94884ce5aec31262c16205e0749229
16:01:33 Contract partial address 0x1ee6a6c40da9364db7695f5466481ae0edf3b30c78a38689c7f6b701a0529203
16:01:33 Contract init hash 0x1702345771ce8ab195a1a3209933b3a419251fc0c62152382c74ed9c81d88e88
16:01:33 Deployment tx hash: 0x217f6dc6db648d3b505ec37d9b223465594d25867002088f75f1eec075dbae06
16:01:33 Deployment salt: 0x0221cfb7011b01a447c89bddc202a365c196a5f8f8abcc955a77382dc09e0aa1
16:01:33 Deployment fee: 11001882240
16:01:33 Contract stored in database with alias last
16:01:37 [16:01:37.258] INFO: wallet Using local PXE service
16:01:37 [16:01:37.259] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:37 [16:01:37.319] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:37 [16:01:37.324] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:38 [16:01:38.040] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:38 [16:01:38.125] INFO: wallet Using wallet with address 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:01:39 [16:01:39.386] INFO: pxe:service Added contract Token at 0x0abe0f8d0a05f9a39656cb2b8829458e93e7df631341ff3c82a71b09e2913878 with class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54
16:01:41 [16:01:41.333] INFO: pxe:service Proving completed in 1932.4185699999998ms {"timings":{"total":1932.4185699999998,"sync":49.71358800000007,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":609.8123949999999,"oracles":{"debugLog":{"times":[0.6574510000000373,0.4388340000004973,0.22618700000020908,0.31801999999970576,0.19989699999950972,0.17723500000010972,0.29810899999938556,0.27983899999981077]},"fetchTaggedLogs":{"times":[288.9540729999999]},"loadCapsule":{"times":[0.3978529999994862,1.018912000000455,2.306692000000112,0.2652490000000398,0.6118689999993876,0.6098299999994197,0.3799319999998261,0.3313509999998132,0.508006000000023,0.37536199999976816]},"getSharedSecret":{"times":[7.265777999999955]},"aes128Decrypt":{"times":[1.2637800000002244,0.9800709999999526]},"getPublicKeysAndPartialAddress":{"times":[2.3956450000005134]},"getKeyValidationRequest":{"times":[3.4249879999997574]},"storeCapsule":{"times":[2.8933609999994587,2.6073120000000927,4.885863000000427]},"deleteCapsule":{"times":[4.258354000000509]},"bulkRetrieveLogs":{"times":[12.03636700000061]},"validateEnqueuedNotesAndEvents":{"times":[28.25142499999947]},"getNotes":{"times":[3.60029300000042]},"getAuthWitness":{"times":[0.28000799999972514]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3504799999991519]},"callPrivateFunction":{"times":[123.03435499999978]},"notifyEnqueuedPublicFunctionCall":{"times":[0.25936799999999494]}}},{"functionName":"private_kernel_init","time":107.71960500000023},{"functionName":"ContractInstanceDeployer:deploy","time":72.34989599999972,"oracles":{"storeInExecutionCache":{"times":[0.3577210000003106]},"callPrivateFunction":{"times":[58.1892629999993]},"notifyCreatedNullifier":{"times":[0.41944299999977375]},"debugLog":{"times":[0.18617600000015955]}}},{"functionName":"private_kernel_inner","time":145.12738700000045},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":41.49038000000019,"oracles":{}},{"functionName":"private_kernel_inner","time":149.9093270000003},{"functionName":"private_kernel_reset","time":272.05959299999995},{"functionName":"private_kernel_tail","time":112.26498699999956}],"unaccounted":371.9714119999994}}
16:01:41 [16:01:41.440] INFO: pxe:service Sent transaction 0x0488b937becc3416a2d5f50226b692ee77a6f9f0698a3757e24d5aec9031c547
16:01:42 [16:01:41.438]
INFO:
node Received tx 0x0488b937becc3416a2d5f50226b692ee77a6f9f0698a3757e24d5aec9031c547
{"txHash":"0x0488b937becc3416a2d5f50226b692ee77a6f9f0698a3757e24d5aec9031c547"}
16:01:42 [16:01:42.114]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2850237289999932s
{"duration":0.2850237289999932,"rate":1110265.4544247,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472}
16:01:42 [16:01:42.145]
INFO:
sequencer Built block 8 for slot 10 with 1 txs and 1 messages. 974873.5320995004 mana/s
{"blockHash":"0x17484420a5269392d91b6617fdcbe3610ff2446aea7b857e573660b1aa91515c","globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750695034,"version":1667649171},"txHashes":["0x0488b937becc3416a2d5f50226b692ee77a6f9f0698a3757e24d5aec9031c547"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":324.56708799999615,"publicProcessDuration":285.1588630000042,"rollupCircuitsDuration":319.8638510000019,"txCount":1,"blockNumber":8,"blockTimestamp":1750695034,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:42 [16:01:42.360]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:42 [16:01:42.553]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:42 [16:01:42.553]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:10:46.000Z
{"offset":543447,"timeMs":1750695046000}
16:01:42 [16:01:42.556]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8
16:01:42 [16:01:42.558]
INFO:
aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8.
16:01:42 [16:01:42.567]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695070
16:01:42 [16:01:42.567]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:11:10.000Z
{"offset":567433,"timeMs":1750695070000}
16:01:42 [16:01:42.567]
INFO:
aztecjs:utils:watcher Slot 10 was filled, jumped to next slot
16:01:42 [16:01:42.608]
INFO:
archiver Downloaded L2 block 8
{"blockHash":"0x17484420a5269392d91b6617fdcbe3610ff2446aea7b857e573660b1aa91515c","blockNumber":8,"txCount":1,"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750695034,"version":1667649171},"archiveRoot":"0x0d9bc7ade51de4ff4d450ebc3e6053730118c733c069a4a5af389432c4c6a88e","archiveNextLeafIndex":9}
16:01:42 [16:01:42.611]
INFO:
archiver Updated proven chain to block 8
{"provenBlockNumber":8}
16:01:43 [16:01:43.064]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":8.363131999998586,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750695034,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:43 Contract deployed at 0x0abe0f8d0a05f9a39656cb2b8829458e93e7df631341ff3c82a71b09e2913878
16:01:43 Contract partial address 0x0573ef224ba7fff2c6ad3888c6f2cd06d7a207934bba237b3c3520df461bd5d2
16:01:43 Contract init hash 0x1702345771ce8ab195a1a3209933b3a419251fc0c62152382c74ed9c81d88e88
16:01:43 Deployment tx hash: 0x0488b937becc3416a2d5f50226b692ee77a6f9f0698a3757e24d5aec9031c547
16:01:43 Deployment salt: 0x0bd5824026aff01db6f949b73b7f262f335c92583ff690def0a4a6f3de4a15e4
16:01:43 Deployment fee: 11001882240
16:01:43 Contract stored in database with alias last
16:01:48 [16:01:48.099] INFO: wallet Using local PXE service
16:01:48 [16:01:48.100] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:48 [16:01:48.158] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:48 [16:01:48.160] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:48 [16:01:48.874] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:49 [16:01:48.968] INFO: wallet Using wallet with address 0x14351e23ffa52ea55753f0dc1618db87fb3f3ed6a1684b3894d23d65356b9ca9
16:01:51 [16:01:50.286] INFO: pxe:service Added contract Token at 0x08626edca69432f2394c25e748fc9adc169d8ccca25a913d1c80612c1ac9352b with class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54
16:01:53 [16:01:52.467] INFO: pxe:service Proving completed in 2167.9599350000003ms {"timings":{"total":2167.9599350000003,"sync":67.8997290000002,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":609.6633400000001,"oracles":{"debugLog":{"times":[0.7203630000003614,0.1556350000000748,0.12042400000063935,0.186546000000817,0.16921499999989464,0.10677400000076886,0.23321800000030635,0.3197599999994054]},"fetchTaggedLogs":{"times":[272.71824800000013]},"loadCapsule":{"times":[0.5030759999999646,0.2629579999993439,0.39856299999974,1.0775340000000142,0.5779080000002068,0.4191930000006323,3.906293000000005,0.40407299999969837,0.37734199999977136,0.3358109999999215]},"getSharedSecret":{"times":[5.625997000000098]},"aes128Decrypt":{"times":[0.9380190000001676,0.5942990000003192]},"getPublicKeysAndPartialAddress":{"times":[2.413346000000274]},"getKeyValidationRequest":{"times":[2.7554259999997157]},"storeCapsule":{"times":[3.0078649999995832,5.51671400000032,3.6628749999999854]},"deleteCapsule":{"times":[4.558473000000049]},"bulkRetrieveLogs":{"times":[10.053667000000132]},"validateEnqueuedNotesAndEvents":{"times":[24.185231999999814]},"getNotes":{"times":[5.902594999999565]},"getAuthWitness":{"times":[0.33932000000004336]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6137799999996787]},"callPrivateFunction":{"times":[147.3619519999993]},"notifyEnqueuedPublicFunctionCall":{"times":[0.31343999999990046]}}},{"functionName":"private_kernel_init","time":113.02049999999963},{"functionName":"ContractInstanceDeployer:deploy","time":79.18257399999948,"oracles":{"storeInExecutionCache":{"times":[0.17137600000023667]},"callPrivateFunction":{"times":[69.29091200000039]},"notifyCreatedNullifier":{"times":[0.5280670000001919]},"debugLog":{"times":[0.288579000000027]}}},{"functionName":"private_kernel_inner","time":208.49979600000006},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":51.206742000000304,"oracles":{}},{"functionName":"private_kernel_inner","time":148.42335400000047},{"functionName":"private_kernel_reset","time":245.9157750000004},{"functionName":"private_kernel_tail","time":120.11041299999943}],"unaccounted":524.0377120000003}}
16:01:53 [16:01:52.567] INFO: pxe:service Sent transaction 0x1564f6af2749ab6039abb04242870406902304b06f7347c2fd0c6de529a2c748
16:01:53 [16:01:52.565]
INFO:
node Received tx 0x1564f6af2749ab6039abb04242870406902304b06f7347c2fd0c6de529a2c748
{"txHash":"0x1564f6af2749ab6039abb04242870406902304b06f7347c2fd0c6de529a2c748"}
16:01:53 [16:01:52.953]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2360167619999993s
{"duration":0.2360167619999993,"rate":1340803.0739782834,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472}
16:01:53 [16:01:52.988]
INFO:
sequencer Built block 9 for slot 11 with 1 txs and 0 messages. 1134785.3152873246 mana/s
{"blockHash":"0x073e065cbc82f8efac39eb75bba7d241664a92bf3ad02c26aac6c25a596bc190","globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750695070,"version":1667649171},"txHashes":["0x1564f6af2749ab6039abb04242870406902304b06f7347c2fd0c6de529a2c748"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":278.80882000000565,"publicProcessDuration":236.19666800000414,"rollupCircuitsDuration":273.83026399998926,"txCount":1,"blockNumber":9,"blockTimestamp":1750695070,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:53 [16:01:53.212]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:53 [16:01:53.214]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695106
16:01:53 [16:01:53.214]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:11:46.000Z
{"offset":592786,"timeMs":1750695106000}
16:01:53 [16:01:53.214]
INFO:
aztecjs:utils:watcher Slot 11 was filled, jumped to next slot
16:01:53 [16:01:53.406]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9
16:01:53 [16:01:53.409]
INFO:
aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9.
16:01:53 [16:01:53.490]
INFO:
archiver Downloaded L2 block 9
{"blockHash":"0x073e065cbc82f8efac39eb75bba7d241664a92bf3ad02c26aac6c25a596bc190","blockNumber":9,"txCount":1,"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750695070,"version":1667649171},"archiveRoot":"0x0b2b13b61e54b7a6d580cf6b80d22696f16c633839450b29609f67404b4bdaf3","archiveNextLeafIndex":10}
16:01:53 [16:01:53.501]
INFO:
archiver Updated proven chain to block 9
{"provenBlockNumber":9}
16:01:53 [16:01:53.625]
INFO:
world_state World state updated with L2 block 9
{"eventName":"l2-block-handled","duration":8.895310000007157,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750695070,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:53 Contract deployed at 0x08626edca69432f2394c25e748fc9adc169d8ccca25a913d1c80612c1ac9352b
16:01:53 Contract partial address 0x0c4c2386f9190c062e93996d7031738c2f9d1575c00cb223f11c5047c316d5d1
16:01:53 Contract init hash 0x1702345771ce8ab195a1a3209933b3a419251fc0c62152382c74ed9c81d88e88
16:01:53 Deployment tx hash: 0x1564f6af2749ab6039abb04242870406902304b06f7347c2fd0c6de529a2c748
16:01:53 Deployment salt: 0x07c2d5f56905e1885279e42c996e1ada389a938adea3685ea06b5d75241e4919
16:01:53 Deployment fee: 979153920
16:01:53 Contract stored in database with alias last
16:01:57 [16:01:56.823] INFO: wallet Using local PXE service
16:01:57 [16:01:56.825] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:01:57 [16:01:56.874] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:01:57 [16:01:56.877] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:01:57 [16:01:57.555] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:01:57
16:01:57 New account:
16:01:57
16:01:57 Address: 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870
16:01:57 Public key: 0x1c70ee7ddca3cd0b334e016d8a93379086995708119e3036bf7ae0b8b64520ff10403f723cb81091022da9fc2f0e227385a8f766dca184eed5cda48332c817c8065a6e1cc2bf8777bdd88d80ee46424627ebd0ef2f6f7860e319256d03532ece23b55b48b87152029f2ce2f63caef2c57e7ffaf7ceca3ad761b6911eef792d75118be4267355acbfdd850d838edb3b50afab007ac3521d6699b9b99b097a19b71006a104ae421791f1c81c6b358c46ad774213a8f87c611ca265d1fc53782c2a124284ba794711400a5886a096fa1004306d856c38a7a17b576ac2cac30551f90156ad53698a9c1ddc3c62011e8a387932ac5c38e69bd262272b911541ad9415
16:01:57 Secret key: 0x0d7361fa86337ef125166f7c43b3687235f4de3c149024b04417258292b34edb
16:01:57 Partial address: 0x1489dbfc6c1ffefe5bfc05b0945e88095ad1a11837e3788fd287e7ba2c286844
16:01:57 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:57 Init hash: 0x2ec5eb6f85556570dbdf1fa68fc0a15a8be1c576381cbc29d44b39ecf03a4210
16:01:57 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000
16:01:57 Retrieved 1000000000000000000 fee juice for recipient 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870. Stack pointer 0
16:01:57 Using Fee Juice for fee payments with claim for 1000000000000000000 tokens
16:01:57 [16:01:57.736] INFO: pxe:service Registered account 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870
16:01:57 [16:01:57.863] INFO: pxe:service Added contract SchnorrAccount at 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870 with class 0x232f822d2c8f0cd4ecb91d65a8b59acba439eac8d83b77ae78374feb8883d49d
16:02:02 [16:02:02.164] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 3099.269215ms
16:02:02 [16:02:02.165] INFO: pxe:bb:native Generating Client IVC proof
16:02:03 [16:02:03.333] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y/ivc-inputs.msgpack
16:02:03 [16:02:03.333] INFO: pxe:bb:native bb - BB concurrency: undefined
16:02:03 [16:02:03.333] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y/ivc-inputs.msgpack -v --scheme client_ivc
16:02:03 [16:02:03.362] INFO: pxe:bb:native bb - bb command: prove (mem:
16:02:03 [16:02:03.363] INFO: pxe:bb:native bb - 188.11 MiB)
16:02:03 Scheme is: client_ivc, num threads: 128 (mem: 188.11 MiB)
16:02:03 --scheme: client_ivc (mem: 188.11 MiB)
16:02:03 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y (mem: 188.11 MiB)
16:02:03 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y/ivc-inputs.msgpack (mem: 188.11 MiB)
16:02:03 --verbose: true (mem: 188.11 MiB)
16:02:04 [16:02:04.334] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 188.11 MiB)
16:02:04 [16:02:04.335] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 188.11 MiB)
16:02:04 [16:02:04.382] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 188.11 MiB)
16:02:04 [16:02:04.393] INFO: pxe:bb:native bb - ClientIVC: accumulating MultiCallEntrypoint:entrypoint (mem: 188.11 MiB)
16:02:04 Constructing DeciderProvingKey (mem: 188.11 MiB)
16:02:04 [16:02:04.399] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 188.11 MiB)
16:02:04 goblin ecc op : 4/1024 (mem: 188.11 MiB)
16:02:04 busread : 742/6000 (mem: 188.11 MiB)
16:02:04 lookups : 2/15000 (mem: 188.11 MiB)
16:02:04 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 188.11 MiB)
16:02:04 arithmetic : 4296/56000 (mem: 188.11 MiB)
16:02:04 delta range : 2030/18000 (mem: 188.11 MiB)
16:02:04 elliptic : 2/6000 (mem: 188.11 MiB)
16:02:04 auxiliary : 2420/26000 (mem: 188.11 MiB)
16:02:04 poseidon ext : 82/17000 (mem: 188.11 MiB)
16:02:04 poseidon int : 458/92000 (mem: 188.11 MiB)
16:02:04 overflow : 0/0 (mem: 188.11 MiB)
16:02:04 (mem: 188.11 MiB)
16:02:04 Total structured size: 242025 (mem: 188.11 MiB)
16:02:04 allocating polynomials object in proving key... (mem: 188.11 MiB)
16:02:04 [16:02:04.537] INFO: pxe:bb:native bb - populating trace... (mem: 430.22 MiB)
16:02:04 [16:02:04.548] INFO: pxe:bb:native bb - time to construct proving key: 156 ms. (mem: 437.22 MiB)
16:02:04 [16:02:04.607] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edbd17b80 (mem: 437.22 MiB)
16:02:04 [16:02:04.607] INFO: pxe:bb:native bb - computing oink proof... (mem: 437.22 MiB)
16:02:04 [16:02:04.608] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 437.22 MiB)
16:02:04 [16:02:04.744] INFO: pxe:bb:native bb - oink proof constructed (mem: 447.22 MiB)
16:02:04 [16:02:04.793] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 449.22 MiB)
16:02:04 [16:02:04.811] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 451.22 MiB)
16:02:04 Constructing DeciderProvingKey (mem: 451.22 MiB)
16:02:04 [16:02:04.818] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 451.22 MiB)
16:02:04 goblin ecc op : 56/1024 (mem: 451.22 MiB)
16:02:04 busread : 2529/6000 (mem: 451.22 MiB)
16:02:04 lookups : 2/15000 (mem: 451.22 MiB)
16:02:04 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 451.22 MiB)
16:02:04 arithmetic : 21701/56000 (mem: 451.22 MiB)
16:02:04 delta range : 3034/18000 (mem: 451.22 MiB)
16:02:04 elliptic : 340/6000 (mem: 451.22 MiB)
16:02:04 [16:02:04.819] INFO: pxe:bb:native bb -
16:02:04 auxiliary : 799/26000 (mem: 451.22 MiB)
16:02:04 poseidon ext : 2452/17000 (mem: 451.22 MiB)
16:02:04 poseidon int : 13967/92000 (mem: 451.22 MiB)
16:02:04 overflow : 0/0 (mem: 451.22 MiB)
16:02:04 (mem: 451.22 MiB)
16:02:04 Total structured size: 242025 (mem: 451.22 MiB)
16:02:04 allocating polynomials object in proving key... (mem: 451.22 MiB)
16:02:04 [16:02:04.867] INFO: pxe:bb:native bb - populating trace... (mem: 675.22 MiB)
16:02:04 [16:02:04.896] INFO: pxe:bb:native bb - time to construct proving key: 85 ms. (mem: 696.22 MiB)
16:02:04 [16:02:04.957] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edd42a280 (mem: 696.22 MiB)
16:02:04 computing folding proof (mem: 696.22 MiB)
16:02:04 [16:02:04.957] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000001bd1a86328896fb6a68f0efbbf47d67e (mem: 696.22 MiB)
16:02:05 [16:02:05.173] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 712.22 MiB)
16:02:05 [16:02:05.241] INFO: pxe:bb:native bb - perturbator round (mem: 739.22 MiB)
16:02:05 [16:02:05.285] INFO: pxe:bb:native bb - combiner quotient round (mem: 772.22 MiB)
16:02:05 [16:02:05.381] INFO: pxe:bb:native bb - folded (mem: 772.22 MiB)
16:02:05 constructed folding proof (mem: 772.22 MiB)
16:02:05 [16:02:05.468] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:constructor (mem: 772.22 MiB)
16:02:05 Constructing DeciderProvingKey (mem: 772.22 MiB)
16:02:05 [16:02:05.474] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 772.22 MiB)
16:02:05 goblin ecc op : 4/1024 (mem: 772.22 MiB)
16:02:05 busread : 742/6000 (mem: 772.22 MiB)
16:02:05 lookups : 12218/15000 (mem: 772.22 MiB)
16:02:05 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 772.22 MiB)
16:02:05 arithmetic : 15035/56000 (mem:
16:02:05 [16:02:05.474] INFO: pxe:bb:native bb - 772.22 MiB)
16:02:05 delta range : 2476/18000 (mem: 772.22 MiB)
16:02:05 elliptic : 1008/6000 (mem: 772.22 MiB)
16:02:05 auxiliary : 899/26000 (mem: 772.22 MiB)
16:02:05 poseidon ext : 132/17000 (mem: 772.22 MiB)
16:02:05 poseidon int : 743/92000 (mem: 772.22 MiB)
16:02:05 overflow : 0/0 (mem: 772.22 MiB)
16:02:05 (mem: 772.22 MiB)
16:02:05 Total structured size: 242025 (mem: 772.22 MiB)
16:02:05 allocating polynomials object in proving key... (mem: 772.22 MiB)
16:02:05 [16:02:05.515] INFO: pxe:bb:native bb - populating trace... (mem: 772.22 MiB)
16:02:05 [16:02:05.558] INFO: pxe:bb:native bb - time to construct proving key: 89 ms. (mem: 772.22 MiB)
16:02:05 [16:02:05.619] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edbd8bb00 (mem: 772.22 MiB)
16:02:05 computing folding proof (mem: 772.22 MiB)
16:02:05 [16:02:05.619] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 772.22 MiB)
16:02:05 [16:02:05.847] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 772.22 MiB)
16:02:05 [16:02:05.909] INFO: pxe:bb:native bb - perturbator round (mem: 772.22 MiB)
16:02:05 [16:02:05.959] INFO: pxe:bb:native bb - combiner quotient round (mem: 781.48 MiB)
16:02:06 [16:02:06.085] INFO: pxe:bb:native bb - folded (mem: 781.48 MiB)
16:02:06 constructed folding proof (mem: 781.48 MiB)
16:02:06 [16:02:06.168] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000001bd1a86328896fb6a68f0efbbf47d67e (mem: 781.48 MiB)
16:02:06 [16:02:06.228] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 781.48 MiB)
16:02:06 [16:02:06.279] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 781.48 MiB)
16:02:06 Constructing DeciderProvingKey (mem: 781.48 MiB)
16:02:06 [16:02:06.295] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 781.48 MiB)
16:02:06 goblin ecc op : 792/1024 (mem: 781.48 MiB)
16:02:06 busread : 4184/6000 (mem: 781.48 MiB)
16:02:06 lookups : 2/15000 (mem: 781.48 MiB)
16:02:06 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 781.48 MiB)
16:02:06 arithmetic : 44918/56000 (mem: 781.48 MiB)
16:02:06 delta range : 5025/18000 (mem: 781.48 MiB)
16:02:06 elliptic : 340/6000 (mem: 781.48 MiB)
16:02:06 auxiliary : 1399/26000 (mem: 781.48 MiB)
16:02:06 poseidon ext : 6542/17000 (mem: 781.48 MiB)
16:02:06 poseidon int : 37280/92000 (mem:
16:02:06 [16:02:06.296] INFO: pxe:bb:native bb - 781.48 MiB)
16:02:06 overflow : 0/0 (mem: 781.48 MiB)
16:02:06 (mem: 781.48 MiB)
16:02:06 Total structured size: 242025 (mem: 781.48 MiB)
16:02:06 allocating polynomials object in proving key... (mem: 781.48 MiB)
16:02:06 [16:02:06.340] INFO: pxe:bb:native bb - populating trace... (mem: 781.48 MiB)
16:02:06 [16:02:06.396] INFO: pxe:bb:native bb - time to construct proving key: 117 ms. (mem: 784.08 MiB)
16:02:06 [16:02:06.476] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edd7e2740 (mem: 784.08 MiB)
16:02:06 computing folding proof (mem: 784.08 MiB)
16:02:06 [16:02:06.476] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 784.08 MiB)
16:02:06 [16:02:06.786] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 784.08 MiB)
16:02:06 [16:02:06.855] INFO: pxe:bb:native bb - perturbator round (mem: 803.08 MiB)
16:02:06 [16:02:06.897] INFO: pxe:bb:native bb - combiner quotient round (mem: 803.08 MiB)
16:02:07 [16:02:07.046] INFO: pxe:bb:native bb - folded (mem: 803.08 MiB)
16:02:07 constructed folding proof (mem: 803.08 MiB)
16:02:07 [16:02:07.111] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 803.08 MiB)
16:02:07 Constructing DeciderProvingKey (mem: 803.08 MiB)
16:02:07 [16:02:07.119] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 803.08 MiB)
16:02:07 goblin ecc op : 4/1024 (mem: 803.08 MiB)
16:02:07 busread : 742/6000 (mem: 803.08 MiB)
16:02:07 lookups : 2076/15000 (mem: 803.08 MiB)
16:02:07 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 803.08 MiB)
16:02:07 arithmetic : 9353/56000 (mem: 803.08 MiB)
16:02:07 delta range : 2977/18000 (mem: 803.08 MiB)
16:02:07 elliptic : 794/6000 (mem: 803.08 MiB)
16:02:07 auxiliary : 4528/26000 (mem: 803.08 MiB)
16:02:07 [16:02:07.120] INFO: pxe:bb:native bb - poseidon ext : 312/17000 (mem: 803.08 MiB)
16:02:07 poseidon int : 1769/92000 (mem: 803.08 MiB)
16:02:07 overflow : 0/0 (mem: 803.08 MiB)
16:02:07 (mem: 803.08 MiB)
16:02:07 Total structured size: 242025 (mem: 803.08 MiB)
16:02:07 allocating polynomials object in proving key... (mem: 803.08 MiB)
16:02:07 [16:02:07.182] INFO: pxe:bb:native bb - populating trace... (mem: 803.08 MiB)
16:02:07 [16:02:07.221] INFO: pxe:bb:native bb - time to construct proving key: 110 ms. (mem: 803.08 MiB)
16:02:07 [16:02:07.284] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edd7e3d80 (mem: 803.08 MiB)
16:02:07 computing folding proof (mem: 803.08 MiB)
16:02:07 [16:02:07.285] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 803.08 MiB)
16:02:07 [16:02:07.458] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 803.08 MiB)
16:02:07 [16:02:07.535] INFO: pxe:bb:native bb - perturbator round (mem: 803.08 MiB)
16:02:07 [16:02:07.584] INFO: pxe:bb:native bb - combiner quotient round (mem: 803.08 MiB)
16:02:07 [16:02:07.702] INFO: pxe:bb:native bb - folded (mem: 803.08 MiB)
16:02:07 constructed folding proof (mem: 803.08 MiB)
16:02:07 [16:02:07.790] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 803.08 MiB)
16:02:07 [16:02:07.838] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 803.08 MiB)
16:02:07 [16:02:07.881] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 803.08 MiB)
16:02:07 Constructing DeciderProvingKey (mem: 803.08 MiB)
16:02:07 [16:02:07.895] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 803.08 MiB)
16:02:07 goblin ecc op : 792/1024 (mem: 803.08 MiB)
16:02:07 busread : 4184/6000 (mem: 803.08 MiB)
16:02:07 lookups : 2/15000 (mem: 803.08 MiB)
16:02:07 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 803.08 MiB)
16:02:07 arithmetic : 44918/56000 (mem: 803.08 MiB)
16:02:07 delta range : 5025/18000 (mem: 803.08 MiB)
16:02:07 elliptic : 340/6000 (mem: 803.08 MiB)
16:02:07 auxiliary : 1399/26000 (mem: 803.08 MiB)
16:02:07 poseidon ext : 6542/17000 (mem: 803.08 MiB)
16:02:07 poseidon int : 37280/92000 (mem: 803.08 MiB)
16:02:07 overflow : 0/0 (mem: 803.08 MiB)
16:02:07 [16:02:07.895] INFO: pxe:bb:native bb - (mem: 803.08 MiB)
16:02:07 Total structured size: 242025 (mem: 803.08 MiB)
16:02:07 allocating polynomials object in proving key... (mem: 803.08 MiB)
16:02:07 [16:02:07.936] INFO: pxe:bb:native bb - populating trace... (mem: 803.08 MiB)
16:02:07 [16:02:07.974] INFO: pxe:bb:native bb - time to construct proving key: 92 ms. (mem: 803.08 MiB)
16:02:08 [16:02:08.079] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631edc19be00 (mem: 803.08 MiB)
16:02:08 computing folding proof (mem: 803.08 MiB)
16:02:08 [16:02:08.079] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 803.08 MiB)
16:02:08 [16:02:08.500] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 803.08 MiB)
16:02:08 [16:02:08.559] INFO: pxe:bb:native bb - perturbator round (mem: 805.08 MiB)
16:02:08 [16:02:08.630] INFO: pxe:bb:native bb - combiner quotient round (mem: 837.08 MiB)
16:02:08 [16:02:08.763] INFO: pxe:bb:native bb - folded (mem: 837.08 MiB)
16:02:08 constructed folding proof (mem: 837.08 MiB)
16:02:08 [16:02:08.851] INFO: pxe:bb:native bb - ClientIVC: accumulating FeeJuice:claim (mem: 837.08 MiB)
16:02:08 Constructing DeciderProvingKey (mem: 837.08 MiB)
16:02:08 [16:02:08.853] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 837.08 MiB)
16:02:08 goblin ecc op : 4/1024 (mem: 837.08 MiB)
16:02:08 busread : 742/6000 (mem: 837.08 MiB)
16:02:08 lookups : 17378/15000 (mem: 837.08 MiB)
16:02:08 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 837.08 MiB)
16:02:08 arithmetic : 13735/56000 (mem: 837.08 MiB)
16:02:08 delta range : 2547/18000 (mem: 837.08 MiB)
16:02:08 elliptic : 2/6000 (mem: 837.08 MiB)
16:02:08 auxiliary : 26/26000 (mem: 837.08 MiB)
16:02:08 poseidon ext : 452/17000 (mem: 837.08 MiB)
16:02:08 [16:02:08.854] INFO: pxe:bb:native bb - poseidon int : 2567/92000 (mem: 837.08 MiB)
16:02:08 overflow : 0/0 (mem: 837.08 MiB)
16:02:08 (mem: 837.08 MiB)
16:02:08 Total structured size: 242025 (mem: 837.08 MiB)
16:02:08 [16:02:08.854] INFO: pxe:bb:native bb - WARNING: Structured trace overflow mechanism in use. Performance may be degraded! (mem: 837.08 MiB)
16:02:08 Gate blocks summary: (actual gates / fixed capacity) (mem: 837.08 MiB)
16:02:08 goblin ecc op : 4/1024 (mem: 837.08 MiB)
16:02:08 busread : 742/6000 (mem: 837.08 MiB)
16:02:08 lookups : 15000/15000 (mem: 837.08 MiB)
16:02:08 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 837.08 MiB)
16:02:08 arithmetic : 13735/56000 (mem: 837.08 MiB)
16:02:08 delta range : 2547/18000 (mem: 837.08 MiB)
16:02:08 elliptic : 2/6000 (mem: 837.08 MiB)
16:02:08 auxiliary : 26/26000 (mem: 837.08 MiB)
16:02:08 poseidon ext : 452/17000 (mem: 837.08 MiB)
16:02:08 poseidon int : 2567/92000 (mem: 837.08 MiB)
16:02:08 overflow : 2379/2379 (mem: 837.08 MiB)
16:02:08 (mem: 837.08 MiB)
16:02:08 Total structured size: 244404 (mem: 837.08 MiB)
16:02:08 allocating polynomials object in proving key... (mem: 837.08 MiB)
16:02:08 [16:02:08.916] INFO: pxe:bb:native bb - populating trace... (mem: 929.33 MiB)
16:02:08 [16:02:08.963] INFO: pxe:bb:native bb - time to construct proving key: 112 ms. (mem: 929.33 MiB)
16:02:09 [16:02:09.062] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631ede685480 (mem: 929.33 MiB)
16:02:09 computing folding proof (mem: 929.33 MiB)
16:02:09 [16:02:09.062] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 929.33 MiB)
16:02:09 [16:02:09.303] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 942.33 MiB)
16:02:09 [16:02:09.390] INFO: pxe:bb:native bb - perturbator round (mem: 960.33 MiB)
16:02:09 [16:02:09.450] INFO: pxe:bb:native bb - combiner quotient round (mem: 992.33 MiB)
16:02:09 [16:02:09.552] INFO: pxe:bb:native bb - folded (mem: 992.33 MiB)
16:02:09 constructed folding proof (mem: 992.33 MiB)
16:02:09 [16:02:09.633] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 992.33 MiB)
16:02:09 [16:02:09.684] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 992.33 MiB)
16:02:09 [16:02:09.734] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 992.33 MiB)
16:02:09 Constructing DeciderProvingKey (mem: 992.33 MiB)
16:02:09 [16:02:09.743] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 992.33 MiB)
16:02:09 goblin ecc op : 792/1024 (mem: 992.33 MiB)
16:02:09 busread : 4184/6000 (mem: 992.33 MiB)
16:02:09 lookups : 2/15000 (mem: 992.33 MiB)
16:02:09 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 992.33 MiB)
16:02:09 arithmetic : 44918/56000 (mem: 992.33 MiB)
16:02:09 delta range : 5025/18000 (mem: 992.33 MiB)
16:02:09 elliptic : 340/6000 (mem: 992.33 MiB)
16:02:09 auxiliary : 1399/26000 (mem: 992.33 MiB)
16:02:09 poseidon ext : 6542/17000 (mem: 992.33 MiB)
16:02:09 poseidon int : 37280/92000 (mem: 992.33 MiB)
16:02:09 overflow : 0/0 (mem: 992.33 MiB)
16:02:09 (mem: 992.33 MiB)
16:02:09 Total structured size: 242025 (mem: 992.33 MiB)
16:02:09 allocating polynomials object in proving key... (mem: 992.33 MiB)
16:02:09 [16:02:09.798] INFO: pxe:bb:native bb - populating trace... (mem: 992.33 MiB)
16:02:09 [16:02:09.848] INFO: pxe:bb:native bb - time to construct proving key: 113 ms. (mem: 992.33 MiB)
16:02:09 [16:02:09.947] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631ede9cb1c0 (mem: 992.33 MiB)
16:02:09 computing folding proof (mem: 992.33 MiB)
16:02:09 [16:02:09.947] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 992.33 MiB)
16:02:10 [16:02:10.276] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 992.33 MiB)
16:02:10 [16:02:10.366] INFO: pxe:bb:native bb - perturbator round (mem: 1006.94 MiB)
16:02:10 [16:02:10.445] INFO: pxe:bb:native bb - combiner quotient round (mem: 1038.94 MiB)
16:02:10 [16:02:10.561] INFO: pxe:bb:native bb - folded (mem: 1038.94 MiB)
16:02:10 constructed folding proof (mem: 1038.94 MiB)
16:02:10 [16:02:10.658] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 1038.94 MiB)
16:02:10 [16:02:10.711] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 1038.94 MiB)
16:02:10 Constructing DeciderProvingKey (mem: 1038.94 MiB)
16:02:10 [16:02:10.724] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1038.94 MiB)
16:02:10 goblin ecc op : 392/1024 (mem: 1038.94 MiB)
16:02:10 busread : 2347/6000 (mem: 1038.94 MiB)
16:02:10 lookups : 2/15000 (mem: 1038.94 MiB)
16:02:10 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 1038.94 MiB)
16:02:10 arithmetic : 36765/56000 (mem: 1038.94 MiB)
16:02:10 delta range : 4306/18000 (mem: 1038.94 MiB)
16:02:10 elliptic : 1274/6000 (mem: 1038.94 MiB)
16:02:10 auxiliary : 12562/26000 (mem: 1038.94 MiB)
16:02:10 poseidon ext : 6542/17000 (mem: 1038.94 MiB)
16:02:10 poseidon int : 37280/92000 (mem: 1038.94 MiB)
16:02:10 overflow : 0/0 (mem: 1038.94 MiB)
16:02:10 (mem: 1038.94 MiB)
16:02:10 Total structured size: 242025 (mem: 1038.94 MiB)
16:02:10 allocating polynomials object in proving key... (mem: 1038.94 MiB)
16:02:10 [16:02:10.755] INFO: pxe:bb:native bb - populating trace... (mem: 1038.94 MiB)
16:02:10 [16:02:10.823] INFO: pxe:bb:native bb - time to construct proving key: 111 ms. (mem: 1038.94 MiB)
16:02:10 [16:02:10.942] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631ee0e52c40 (mem: 1038.94 MiB)
16:02:10 computing folding proof (mem: 1038.94 MiB)
16:02:10 [16:02:10.943] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000381475db651ebd05cb58988eb1e00c00 (mem: 1038.94 MiB)
16:02:11 [16:02:11.282] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1038.94 MiB)
16:02:11 [16:02:11.371] INFO: pxe:bb:native bb - perturbator round (mem: 1038.94 MiB)
16:02:11 [16:02:11.451] INFO: pxe:bb:native bb - combiner quotient round (mem: 1045.19 MiB)
16:02:11 [16:02:11.573] INFO: pxe:bb:native bb - folded (mem: 1045.19 MiB)
16:02:11 constructed folding proof (mem: 1045.19 MiB)
16:02:11 [16:02:11.637] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000381475db651ebd05cb58988eb1e00c00 (mem: 1045.19 MiB)
16:02:11 [16:02:11.690] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 1045.19 MiB)
16:02:11 Constructing DeciderProvingKey (mem: 1045.19 MiB)
16:02:11 [16:02:11.702] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1045.19 MiB)
16:02:11 goblin ecc op : 392/1024 (mem: 1045.19 MiB)
16:02:11 busread : 231/6000 (mem: 1045.19 MiB)
16:02:11 lookups : 2/15000 (mem: 1045.19 MiB)
16:02:11 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 1045.19 MiB)
16:02:11 arithmetic : 32886/56000 (mem: 1045.19 MiB)
16:02:11 delta range : 4411/18000 (mem: 1045.19 MiB)
16:02:11 elliptic : 2/6000 (mem: 1045.19 MiB)
16:02:11 auxiliary : 11868/26000 (mem: 1045.19 MiB)
16:02:11 poseidon ext : 2982/17000 (mem: 1045.19 MiB)
16:02:11 poseidon int : 16988/92000 (mem: 1045.19 MiB)
16:02:11 overflow : 0/0 (mem: 1045.19 MiB)
16:02:11 (mem: 1045.19 MiB)
16:02:11 Total structured size: 242025 (mem:
16:02:11 [16:02:11.703] INFO: pxe:bb:native bb - 1045.19 MiB)
16:02:11 allocating polynomials object in proving key... (mem: 1045.19 MiB)
16:02:11 [16:02:11.744] INFO: pxe:bb:native bb - populating trace... (mem: 1045.19 MiB)
16:02:11 [16:02:11.776] INFO: pxe:bb:native bb - time to construct proving key: 90 ms. (mem: 1045.19 MiB)
16:02:11 [16:02:11.900] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x631eddb051c0 (mem: 1045.19 MiB)
16:02:11 computing folding proof (mem: 1045.19 MiB)
16:02:11 [16:02:11.901] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000007b5461b8ea2d0a193b3cc5c82ff90e7a (mem: 1045.19 MiB)
16:02:12 [16:02:12.132] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1045.19 MiB)
16:02:12 [16:02:12.190] INFO: pxe:bb:native bb - perturbator round (mem: 1045.19 MiB)
16:02:12 [16:02:12.250] INFO: pxe:bb:native bb - combiner quotient round (mem: 1045.41 MiB)
16:02:12 [16:02:12.349] INFO: pxe:bb:native bb - folded (mem: 1045.41 MiB)
16:02:12 constructed folding proof (mem: 1045.41 MiB)
16:02:12 [16:02:12.350] INFO: pxe:bb:native bb - Largest circuit: 101078 gates. Trace details: (mem: 1045.41 MiB)
16:02:12 Minimum required block sizes for structured trace: (mem: 1045.41 MiB)
16:02:12 [16:02:12.351] INFO: pxe:bb:native bb - ecc_op : 792
16:02:12 busread : 4184
16:02:12 lookup : 15000
16:02:12 pub_inputs : 1859
16:02:12 arithmetic : 44918
16:02:12 delta_range : 5025
16:02:12 elliptic : 1274
16:02:12 aux : 12562
16:02:12 poseidon2_external : 6542
16:02:12 poseidon2_internal : 37280
16:02:12 overflow : 2379
16:02:12 [16:02:12.351] INFO: pxe:bb:native bb - (mem: 1045.41 MiB)
16:02:12 prove decider... (mem: 1045.41 MiB)
16:02:12 [16:02:12.436] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1045.41 MiB)
16:02:12 [16:02:12.522] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1045.41 MiB)
16:02:13 [16:02:12.958] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1045.41 MiB)
16:02:13 [16:02:13.042] INFO: pxe:bb:native bb - computed opening proof (mem: 1045.41 MiB)
16:02:13 finished decider proving. (mem: 1045.41 MiB)
16:02:13 [16:02:13.053] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000007b5461b8ea2d0a193b3cc5c82ff90e7a (mem: 1045.41 MiB)
16:02:13 [16:02:13.178] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 1045.41 MiB)
16:02:13 [16:02:13.183] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 1045.41 MiB)
16:02:13 [16:02:13.219] INFO: pxe:bb:native bb - populating trace... (mem: 1045.41 MiB)
16:02:13 [16:02:13.272] INFO: pxe:bb:native bb - time to construct proving key: 93 ms. (mem: 1045.41 MiB)
16:02:13 [16:02:13.670] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000005c8a4e75ab3d4ac0ef682b0d38b0dd9f (mem: 1045.41 MiB)
16:02:14 [16:02:13.946] INFO: pxe:bb:native bb - created oink proof (mem: 1045.41 MiB)
16:02:14 [16:02:14.066] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1045.41 MiB)
16:02:14 [16:02:14.472] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 1045.41 MiB)
16:02:15 [16:02:14.903] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1045.41 MiB)
16:02:15 [16:02:14.945] INFO: pxe:bb:native bb - computed opening proof (mem: 1045.41 MiB)
16:02:15 finished decider proving. (mem: 1045.41 MiB)
16:02:15 [16:02:14.946] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3818 (mem: 1045.41 MiB)
16:02:15 [16:02:15.044] INFO: pxe:bb:native bb - prove eccvm... (mem: 1045.41 MiB)
16:02:15 [16:02:15.424] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 1045.41 MiB)
16:02:15 [16:02:15.435] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 1045.41 MiB)
16:02:16 [16:02:16.616] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1045.41 MiB)
16:02:18 [16:02:17.711] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 1045.41 MiB)
16:02:20 [16:02:20.046] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 1045.41 MiB)
16:02:20 prove translator... (mem: 1045.41 MiB)
16:02:21 [16:02:21.191] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1060.29 MiB)
16:02:22 [16:02:22.316] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1060.29 MiB)
16:02:23 [16:02:23.245] INFO: pxe:bb:native bb - computed opening proof (mem: 1060.29 MiB)
16:02:23 [16:02:23.246] INFO: pxe:bb:native bb - finished translator proving. (mem: 1060.29 MiB)
16:02:23 [16:02:23.247] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000005c8a4e75ab3d4ac0ef682b0d38b0dd9f (mem: 1060.29 MiB)
16:02:23 [16:02:23.267] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 1060.29 MiB)
16:02:23 libra_evals_verified: 1 (mem: 1060.29 MiB)
16:02:23 pairing_check_verified: 1 (mem: 1060.29 MiB)
16:02:23 Mega verified: 1 (mem: 1060.29 MiB)
16:02:23 [16:02:23.319] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 1061.29 MiB)
16:02:23 batch opening verified?: 1 (mem: 1061.29 MiB)
16:02:23 eccvm consistency check verified?: 1 (mem: 1061.29 MiB)
16:02:23 translation masking consistency checked?: 1 (mem: 1061.29 MiB)
16:02:23 [16:02:23.334] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 1061.29 MiB)
16:02:23 eccvm verified?: 1 (mem: 1061.29 MiB)
16:02:23 accumulator construction_verified?: 1 (mem: 1061.29 MiB)
16:02:23 translation verified?: 1 (mem: 1061.29 MiB)
16:02:23 consistency verified?: 1 (mem: 1061.29 MiB)
16:02:23 Goblin verified: 1 (mem: 1061.29 MiB)
16:02:23 [16:02:23.335] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-oR2b6y" (mem: 1061.29 MiB)
16:02:23 [16:02:23.521] INFO: pxe:bb:native Generated IVC proof {"duration":20186.713458,"eventName":"circuit-proving"}
16:02:23 [16:02:23.526] INFO: pxe:service Proving completed in 25582.894739ms {"timings":{"total":25582.894739,"sync":61.341891999999916,"proving":21361.31754,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":139.5524949999999,"oracles":{"callPrivateFunction":{"times":[427.874045,515.1397929999998]}}},{"functionName":"private_kernel_init","time":241.349381},{"functionName":"SchnorrAccount:constructor","time":413.478971,"oracles":{"getContractInstance":{"times":[7.657360999999582]},"debugLog":{"times":[0.6660610000003544,0.20614700000032826]},"fetchTaggedLogs":{"times":[170.18022999999994]},"loadCapsule":{"times":[0.6956929999996646,0.35590099999990343,0.282408999999916,1.3171110000002955,0.7639439999998103,0.3485019999998258]},"bulkRetrieveLogs":{"times":[7.232306999999764]},"validateEnqueuedNotesAndEvents":{"times":[8.244128999999703]},"notifyCreatedNullifier":{"times":[0.9227890000001935,0.3848320000001877]},"notifyCreatedNote":{"times":[0.6424899999997251]},"getRandomField":{"times":[0.5670669999999518,0.4127830000002177,0.19020599999976184,0.1590649999998277,0.3311309999999139,0.16594500000019252,0.1083929999999782,0.10783300000002782,0.1056229999999232,0.12708400000019537,0.08058200000004945]},"getIndexedTaggingSecretAsSender":{"times":[31.572465000000193]},"incrementAppTaggingSecretIndexAsSender":{"times":[12.607406999999967]}}},{"functionName":"private_kernel_inner","time":499.7990399999999},{"functionName":"SchnorrAccount:entrypoint","time":317.4262579999995,"oracles":{"debugLog":{"times":[0.32502000000022235,0.1521749999997155,0.2761679999998705]},"fetchTaggedLogs":{"times":[138.94415499999968]},"loadCapsule":{"times":[0.308770000000095,0.22634699999980512,0.3878120000003946,0.29655899999988833,0.2045469999998204,2.8025480000001153]},"bulkRetrieveLogs":{"times":[5.897816000000148]},"validateEnqueuedNotesAndEvents":{"times":[8.351763000000119]},"getNotes":{"times":[3.3520250000001397]},"getAuthWitness":{"times":[0.4229840000002696]},"callPrivateFunction":{"times":[192.17074200000025]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0726840000002085]}}},{"functionName":"private_kernel_inner","time":485.4872889999997},{"functionName":"FeeJuice:claim","time":180.23377500000015,"oracles":{"getL1ToL2MembershipWitness":{"times":[45.30434699999978]},"notifyCreatedNullifier":{"times":[0.44327400000020134]},"storeInExecutionCache":{"times":[0.2516279999999824]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3018499999998312]}}},{"functionName":"private_kernel_inner","time":513.4144589999996},{"functionName":"private_kernel_reset","time":452.10626800000045},{"functionName":"private_kernel_tail","time":520.9093440000006}],"unaccounted":396.478027000001}}
16:02:23
16:02:23 Waiting for account contract deployment...
16:02:23 [16:02:23.631] INFO: pxe:service Sent transaction 0x26e1896cb57ac3a05441f7e2c7d286650325a43f81a1df39fd1ea775cc28726e
16:02:23 [16:02:23.629]
INFO:
node Received tx 0x26e1896cb57ac3a05441f7e2c7d286650325a43f81a1df39fd1ea775cc28726e
{"txHash":"0x26e1896cb57ac3a05441f7e2c7d286650325a43f81a1df39fd1ea775cc28726e"}
16:02:29 [16:02:29.349]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
16:02:29 [16:02:29.351]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695143
16:02:29 [16:02:29.555]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:02:29 [16:02:29.555]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:12:23.000Z
{"offset":593445,"timeMs":1750695143000}
16:02:29 [16:02:29.806]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08707829600000695s
{"duration":0.08707829600000695,"rate":163347.24786069384,"totalPublicGas":{"daGas":1024,"l2Gas":14224},"totalBlockGas":{"daGas":13312,"l2Gas":40548},"totalSizeInBytes":1024}
16:02:29 [16:02:29.840]
INFO:
sequencer Built block 10 for slot 13 with 1 txs and 0 messages. 109540.64940369941 mana/s
{"blockHash":"0x27a1ff44541e3ae15962159574d73c0f6775d006473d915dc5bc8d773bbc0d11","globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750695142,"version":1667649171},"txHashes":["0x26e1896cb57ac3a05441f7e2c7d286650325a43f81a1df39fd1ea775cc28726e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":129.7805870000011,"publicProcessDuration":87.283122000008,"rollupCircuitsDuration":123.96908500000427,"txCount":1,"blockNumber":10,"blockTimestamp":1750695142,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:02:30 [16:02:30.051]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 10
16:02:30 [16:02:30.054]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:02:30 [16:02:30.056]
INFO:
aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10.
16:02:30 [16:02:30.058]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695178
16:02:30 [16:02:30.058]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:12:58.000Z
{"offset":627942,"timeMs":1750695178000}
16:02:30 [16:02:30.058]
INFO:
aztecjs:utils:watcher Slot 13 was filled, jumped to next slot
16:02:30 [16:02:30.178]
INFO:
archiver Downloaded L2 block 10
{"blockHash":"0x27a1ff44541e3ae15962159574d73c0f6775d006473d915dc5bc8d773bbc0d11","blockNumber":10,"txCount":1,"globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750695142,"version":1667649171},"archiveRoot":"0x1ff19b19efbffb7dd94e8cdf95f06c6639ab60a642080ab9c04a1db51c187673","archiveNextLeafIndex":11}
16:02:30 [16:02:30.186]
INFO:
archiver Updated proven chain to block 10
{"provenBlockNumber":10}
16:02:30 [16:02:30.217]
INFO:
world_state World state updated with L2 block 10
{"eventName":"l2-block-handled","duration":9.186759000003804,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1750695142,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:02:30 Deploy tx hash: 0x26e1896cb57ac3a05441f7e2c7d286650325a43f81a1df39fd1ea775cc28726e
16:02:30 Deploy tx fee: 116778240
16:02:34 [16:02:34.336] INFO: wallet Using local PXE service
16:02:34 [16:02:34.337] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16
16:02:34 [16:02:34.384] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2)
16:02:34 [16:02:34.392] INFO: pxe:data:lmdb Starting data store with maxReaders 16
16:02:35 [16:02:35.017] INFO: pxe:service Started PXE connected to chain 31337 version 1667649171
16:02:35 [16:02:35.105] INFO: wallet Using wallet with address 0x2196913bd4d8014ea8013abee63a98ac163c3d135282cf254c182c6ea6384870
16:02:37 [16:02:36.348] INFO: pxe:service Added contract Token at 0x190eb1791b1c88c91b7023e57f3f2b896218e3a4067837e7bc0fc406a31801b2 with class 0x13347f00f167aa60dc0296fda1cc349a6da99389c854500cd1e2d2ae9f80ae54
16:02:40 [16:02:39.435] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2383.727613ms
16:02:40 [16:02:39.435] INFO: pxe:bb:native Generating Client IVC proof
16:02:40 [16:02:40.240] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM/ivc-inputs.msgpack
16:02:40 [16:02:40.241] INFO: pxe:bb:native bb - BB concurrency: undefined
16:02:40 [16:02:40.241] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM/ivc-inputs.msgpack -v --scheme client_ivc
16:02:40 [16:02:40.270] INFO: pxe:bb:native bb - bb command: prove (mem: 258.00 MiB)
16:02:40 [16:02:40.270] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 258.00 MiB)
16:02:40 --scheme: client_ivc (mem: 258.00 MiB)
16:02:40 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM (mem: 258.00 MiB)
16:02:40 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM/ivc-inputs.msgpack (mem: 258.00 MiB)
16:02:40 --verbose: true (mem: 258.00 MiB)
16:02:41 [16:02:40.976] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 258.00 MiB)
16:02:41 using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 258.00 MiB)
16:02:41 [16:02:41.027] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 258.00 MiB)
16:02:41 [16:02:41.079] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 258.00 MiB)
16:02:41 Constructing DeciderProvingKey (mem: 258.00 MiB)
16:02:41 [16:02:41.087] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 258.00 MiB)
16:02:41 goblin ecc op : 4/1024 (mem: 258.00 MiB)
16:02:41 busread : 742/6000 (mem: 258.00 MiB)
16:02:41 lookups : 2076/15000 (mem: 258.00 MiB)
16:02:41 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 258.00 MiB)
16:02:41 arithmetic : 9353/56000 (mem:
16:02:41 [16:02:41.087] INFO: pxe:bb:native bb - 258.00 MiB)
16:02:41 delta range : 2977/18000 (mem: 258.00 MiB)
16:02:41 elliptic : 794/6000 (mem: 258.00 MiB)
16:02:41 auxiliary : 4528/26000 (mem: 258.00 MiB)
16:02:41 poseidon ext : 312/17000 (mem: 258.00 MiB)
16:02:41 poseidon int : 1769/92000 (mem: 258.00 MiB)
16:02:41 overflow : 0/0 (mem: 258.00 MiB)
16:02:41 (mem: 258.00 MiB)
16:02:41 Total structured size: 242025 (mem: 258.00 MiB)
16:02:41 allocating polynomials object in proving key... (mem: 258.00 MiB)
16:02:41 [16:02:41.228] INFO: pxe:bb:native bb - populating trace... (mem: 422.22 MiB)
16:02:41 [16:02:41.254] INFO: pxe:bb:native bb - time to construct proving key: 175 ms. (mem: 437.22 MiB)
16:02:41 [16:02:41.296] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x616348906600 (mem: 437.22 MiB)
16:02:41 [16:02:41.296] INFO: pxe:bb:native bb - computing oink proof... (mem: 437.22 MiB)
16:02:41 [16:02:41.297] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 437.22 MiB)
16:02:41 [16:02:41.466] INFO: pxe:bb:native bb - oink proof constructed (mem: 465.22 MiB)
16:02:41 [16:02:41.523] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 465.22 MiB)
16:02:41 [16:02:41.538] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 465.22 MiB)
16:02:41 Constructing DeciderProvingKey (mem: 465.22 MiB)
16:02:41 [16:02:41.544] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 465.22 MiB)
16:02:41 goblin ecc op : 56/1024 (mem: 465.22 MiB)
16:02:41 busread : 2529/6000 (mem: 465.22 MiB)
16:02:41 lookups : 2/15000 (mem: 465.22 MiB)
16:02:41 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 465.22
16:02:41 [16:02:41.544] INFO: pxe:bb:native bb - MiB)
16:02:41 arithmetic : 21701/56000 (mem: 465.22 MiB)
16:02:41 delta range : 3034/18000 (mem: 465.22 MiB)
16:02:41 elliptic : 340/6000 (mem: 465.22 MiB)
16:02:41 auxiliary : 799/26000 (mem: 465.22 MiB)
16:02:41 poseidon ext : 2452/17000 (mem: 465.22 MiB)
16:02:41 poseidon int : 13967/92000 (mem: 465.22 MiB)
16:02:41 overflow : 0/0 (mem: 465.22 MiB)
16:02:41 (mem: 465.22 MiB)
16:02:41 Total structured size: 242025 (mem: 465.22 MiB)
16:02:41 allocating polynomials object in proving key... (mem: 465.22 MiB)
16:02:41 [16:02:41.595] INFO: pxe:bb:native bb - populating trace... (mem: 674.22 MiB)
16:02:41 [16:02:41.625] INFO: pxe:bb:native bb - time to construct proving key: 86 ms. (mem: 691.22 MiB)
16:02:41 [16:02:41.677] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x616348f42b40 (mem: 691.22 MiB)
16:02:41 computing folding proof (mem: 691.22 MiB)
16:02:41 [16:02:41.679] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000001bd1a86328896fb6a68f0efbbf47d67e (mem: 691.22 MiB)
16:02:41 [16:02:41.871] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 691.22 MiB)
16:02:41 [16:02:41.939] INFO: pxe:bb:native bb - perturbator round (mem: 721.22 MiB)
16:02:42 [16:02:41.987] INFO: pxe:bb:native bb - combiner quotient round (mem: 754.22 MiB)
16:02:42 [16:02:42.051] INFO: pxe:bb:native bb - folded (mem: 754.22 MiB)
16:02:42 constructed folding proof (mem: 754.22 MiB)
16:02:42 [16:02:42.060] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractInstanceDeployer:deploy (mem: 754.22 MiB)
16:02:42 Constructing DeciderProvingKey (mem: 754.22 MiB)
16:02:42 [16:02:42.062] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 754.22 MiB)
16:02:42 goblin ecc op : 4/1024 (mem: 754.22 MiB)
16:02:42 busread : 742/6000 (mem: 754.22 MiB)
16:02:42 lookups : 2/15000 (mem: 754.22 MiB)
16:02:42 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 754.22 MiB)
16:02:42 arithmetic : 3656/56000 (mem: 754.22 MiB)
16:02:42 delta range : 1838/18000 (mem: 754.22 MiB)
16:02:42 elliptic : 340/6000 (mem: 754.22 MiB)
16:02:42 auxiliary : 187/26000 (mem: 754.22 MiB)
16:02:42 poseidon ext : 162/17000 (mem: 754.22 MiB)
16:02:42 poseidon int : 914/92000 (mem: 754.22 MiB)
16:02:42 overflow : 0/0 (mem: 754.22 MiB)
16:02:42 (mem: 754.22 MiB)
16:02:42 Total structured size: 242025 (mem: 754.22 MiB)
16:02:42 [16:02:42.063] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 754.22 MiB)
16:02:42 [16:02:42.091] INFO: pxe:bb:native bb - populating trace... (mem: 754.22 MiB)
16:02:42 [16:02:42.099] INFO: pxe:bb:native bb - time to construct proving key: 39 ms. (mem: 754.22 MiB)
16:02:42 [16:02:42.147] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x61634892b680 (mem: 754.22 MiB)
16:02:42 computing folding proof (mem: 754.22 MiB)
16:02:42 [16:02:42.147] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 754.22 MiB)
16:02:42 [16:02:42.268] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 754.22 MiB)
16:02:42 [16:02:42.329] INFO: pxe:bb:native bb - perturbator round (mem: 754.22 MiB)
16:02:42 [16:02:42.370] INFO: pxe:bb:native bb - combiner quotient round (mem: 755.30 MiB)
16:02:42 [16:02:42.479] INFO: pxe:bb:native bb - folded (mem: 755.30 MiB)
16:02:42 [16:02:42.480] INFO: pxe:bb:native bb - constructed folding proof (mem: 755.30 MiB)
16:02:42 [16:02:42.567] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000001bd1a86328896fb6a68f0efbbf47d67e (mem: 755.30 MiB)
16:02:42 [16:02:42.640] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 755.30 MiB)
16:02:42 [16:02:42.685] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 755.30 MiB)
16:02:42 Constructing DeciderProvingKey (mem: 755.30 MiB)
16:02:42 [16:02:42.694] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 755.30 MiB)
16:02:42 goblin ecc op : 792/1024 (mem: 755.30 MiB)
16:02:42 busread : 4184/6000 (mem: 755.30 MiB)
16:02:42 lookups : 2/15000 (mem: 755.30 MiB)
16:02:42 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 755.30 MiB)
16:02:42 arithmetic : 44918/56000 (mem: 755.30 MiB)
16:02:42 delta range : 5025/18000 (mem: 755.30 MiB)
16:02:42 elliptic : 340/6000 (mem: 755.30 MiB)
16:02:42 auxiliary : 1399/26000 (mem: 755.30 MiB)
16:02:42 poseidon ext : 6542/17000 (mem: 755.30 MiB)
16:02:42 [16:02:42.694] INFO: pxe:bb:native bb - poseidon int : 37280/92000 (mem: 755.30 MiB)
16:02:42 overflow : 0/0 (mem: 755.30 MiB)
16:02:42 (mem: 755.30 MiB)
16:02:42 Total structured size: 242025 (mem: 755.30 MiB)
16:02:42 allocating polynomials object in proving key... (mem: 755.30 MiB)
16:02:42 [16:02:42.746] INFO: pxe:bb:native bb - populating trace... (mem: 755.30 MiB)
16:02:42 [16:02:42.799] INFO: pxe:bb:native bb - time to construct proving key: 114 ms. (mem: 758.71 MiB)
16:02:42 [16:02:42.853] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x6163487cc7c0 (mem: 758.71 MiB)
16:02:42 computing folding proof (mem: 758.71
16:02:42 [16:02:42.853] INFO: pxe:bb:native bb - MiB)
16:02:42 [16:02:42.853] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 758.71 MiB)
16:02:43 [16:02:43.099] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 758.71 MiB)
16:02:43 [16:02:43.173] INFO: pxe:bb:native bb - perturbator round (mem: 779.71 MiB)
16:02:43 [16:02:43.233] INFO: pxe:bb:native bb - combiner quotient round (mem: 812.71 MiB)
16:02:43 [16:02:43.373] INFO: pxe:bb:native bb - folded (mem: 812.71 MiB)
16:02:43 [16:02:43.373] INFO: pxe:bb:native bb - constructed folding proof (mem: 812.71 MiB)
16:02:43 [16:02:43.382] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractClassRegisterer:assert_class_id_is_registered (mem: 812.71 MiB)
16:02:43 Constructing DeciderProvingKey (mem: 812.71 MiB)
16:02:43 [16:02:43.385] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 812.71 MiB)
16:02:43 goblin ecc op : 4/1024 (mem: 812.71 MiB)
16:02:43 busread : 742/6000 (mem: 812.71 MiB)
16:02:43 lookups : 2/15000 (mem: 812.71 MiB)
16:02:43 [16:02:43.386] INFO: pxe:bb:native bb - pub inputs : 16/5000 (populated in decider pk constructor) (mem: 812.71 MiB)
16:02:43 arithmetic : 3287/56000 (mem: 812.71 MiB)
16:02:43 delta range : 1787/18000 (mem: 812.71 MiB)
16:02:43 elliptic : 2/6000 (mem: 812.71 MiB)
16:02:43 auxiliary : 26/26000 (mem: 812.71 MiB)
16:02:43 poseidon ext : 12/17000 (mem: 812.71 MiB)
16:02:43 poseidon int : 59/92000 (mem: 812.71 MiB)
16:02:43 overflow : 0/0 (mem: 812.71 MiB)
16:02:43 (mem: 812.71 MiB)
16:02:43 Total structured size: 242025 (mem: 812.71 MiB)
16:02:43 allocating polynomials object in proving key... (mem: 812.71 MiB)
16:02:43 [16:02:43.443] INFO: pxe:bb:native bb - populating trace... (mem: 812.71 MiB)
16:02:43 [16:02:43.451] INFO: pxe:bb:native bb - time to construct proving key: 68 ms. (mem: 812.71 MiB)
16:02:43 [16:02:43.503] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x6163486ab480 (mem: 812.71 MiB)
16:02:43 computing folding proof (mem: 812.71 MiB)
16:02:43 [16:02:43.503] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 812.71 MiB)
16:02:43 [16:02:43.592] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 812.71 MiB)
16:02:43 [16:02:43.684] INFO: pxe:bb:native bb - perturbator round (mem: 812.71 MiB)
16:02:43 [16:02:43.732] INFO: pxe:bb:native bb - combiner quotient round (mem: 812.71 MiB)
16:02:43 [16:02:43.802] INFO: pxe:bb:native bb - folded (mem: 812.71 MiB)
16:02:43 constructed folding proof (mem: 812.71 MiB)
16:02:43 [16:02:43.890] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 812.71 MiB)
16:02:43 [16:02:43.956] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 812.71 MiB)
16:02:44 [16:02:43.999] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 812.71 MiB)
16:02:44 Constructing DeciderProvingKey (mem: 812.71 MiB)
16:02:44 [16:02:44.009] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 812.71 MiB)
16:02:44 goblin ecc op : 792/1024 (mem: 812.71 MiB)
16:02:44 busread : 4184/6000 (mem: 812.71 MiB)
16:02:44 lookups : 2/15000 (mem: 812.71 MiB)
16:02:44 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 812.71 MiB)
16:02:44 arithmetic : 44918/56000 (mem: 812.71 MiB)
16:02:44 delta range : 5025/18000 (mem: 812.71 MiB)
16:02:44 elliptic : 340/6000 (mem: 812.71 MiB)
16:02:44 auxiliary : 1399/26000 (mem: 812.71 MiB)
16:02:44 [16:02:44.009] INFO: pxe:bb:native bb - poseidon ext : 6542/17000 (mem: 812.71 MiB)
16:02:44 poseidon int : 37280/92000 (mem: 812.71 MiB)
16:02:44 overflow : 0/0 (mem: 812.71 MiB)
16:02:44 (mem: 812.71 MiB)
16:02:44 Total structured size: 242025 (mem: 812.71 MiB)
16:02:44 allocating polynomials object in proving key... (mem: 812.71 MiB)
16:02:44 [16:02:44.044] INFO: pxe:bb:native bb - populating trace... (mem: 812.71 MiB)
16:02:44 [16:02:44.083] INFO: pxe:bb:native bb - time to construct proving key: 83 ms. (mem: 812.71 MiB)
16:02:44 [16:02:44.154] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x61634996b500 (mem: 812.71 MiB)
16:02:44 computing folding proof (mem: 812.71 MiB)
16:02:44 [16:02:44.154] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 812.71 MiB)
16:02:44 [16:02:44.444] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 812.71 MiB)
16:02:44 [16:02:44.521] INFO: pxe:bb:native bb - perturbator round (mem: 812.71 MiB)
16:02:44 [16:02:44.562] INFO: pxe:bb:native bb - combiner quotient round (mem: 812.71 MiB)
16:02:44 [16:02:44.680] INFO: pxe:bb:native bb - folded (mem: 812.71 MiB)
16:02:44 [16:02:44.680] INFO: pxe:bb:native bb - constructed folding proof (mem: 812.71 MiB)
16:02:44 [16:02:44.808] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000b16f1d26129439f5062fbb445cdd5488 (mem: 812.71 MiB)
16:02:44 [16:02:44.862] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 812.71 MiB)
16:02:44 Constructing DeciderProvingKey (mem: 812.71 MiB)
16:02:44 [16:02:44.875] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 812.71 MiB)
16:02:44 goblin ecc op : 392/1024 (mem: 812.71 MiB)
16:02:44 busread : 2347/6000 (mem: 812.71 MiB)
16:02:44 lookups : 2/15000 (mem: 812.71 MiB)
16:02:44 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 812.71 MiB)
16:02:44 arithmetic : 36765/56000 (mem: 812.71 MiB)
16:02:44 delta range : 4306/18000 (mem: 812.71 MiB)
16:02:44 elliptic : 1274/6000 (mem: 812.71
16:02:44 [16:02:44.875] INFO: pxe:bb:native bb - MiB)
16:02:44 auxiliary : 12562/26000 (mem: 812.71 MiB)
16:02:44 poseidon ext : 6542/17000 (mem: 812.71 MiB)
16:02:44 poseidon int : 37280/92000 (mem: 812.71 MiB)
16:02:44 overflow : 0/0 (mem: 812.71 MiB)
16:02:44 (mem: 812.71 MiB)
16:02:44 Total structured size: 242025 (mem: 812.71 MiB)
16:02:44 allocating polynomials object in proving key... (mem: 812.71 MiB)
16:02:44 [16:02:44.921] INFO: pxe:bb:native bb - populating trace... (mem: 812.71 MiB)
16:02:44 [16:02:44.957] INFO: pxe:bb:native bb - time to construct proving key: 95 ms. (mem: 812.71 MiB)
16:02:45 [16:02:45.020] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x61634a34c880 (mem: 812.71 MiB)
16:02:45 computing folding proof (mem: 812.71 MiB)
16:02:45 [16:02:45.021] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000381475db651ebd05cb58988eb1e00c00 (mem: 812.71 MiB)
16:02:45 [16:02:45.317] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 812.71 MiB)
16:02:45 [16:02:45.372] INFO: pxe:bb:native bb - perturbator round (mem: 812.71 MiB)
16:02:45 [16:02:45.424] INFO: pxe:bb:native bb - combiner quotient round (mem: 820.70 MiB)
16:02:45 [16:02:45.486] INFO: pxe:bb:native bb - folded (mem: 820.70 MiB)
16:02:45 constructed folding proof (mem: 820.70 MiB)
16:02:45 [16:02:45.541] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000381475db651ebd05cb58988eb1e00c00 (mem: 820.70 MiB)
16:02:45 [16:02:45.585] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 820.70 MiB)
16:02:45 Constructing DeciderProvingKey (mem: 820.70 MiB)
16:02:45 [16:02:45.596] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 820.70 MiB)
16:02:45 goblin ecc op : 392/1024 (mem: 820.70 MiB)
16:02:45 busread : 231/6000 (mem: 820.70 MiB)
16:02:45 lookups : 2/15000 (mem: 820.70 MiB)
16:02:45 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 820.70 MiB)
16:02:45 arithmetic : 32886/56000 (mem: 820.70 MiB)
16:02:45 delta range : 4411/18000 (mem: 820.70 MiB)
16:02:45 elliptic : 2/6000 (mem: 820.70 MiB)
16:02:45 auxiliary : 11868/26000 (mem: 820.70 MiB)
16:02:45 poseidon ext : 2982/17000 (mem: 820.70 MiB)
16:02:45 poseidon int : 16988/92000 (mem: 820.70 MiB)
16:02:45 [16:02:45.596] INFO: pxe:bb:native bb -
16:02:45 overflow : 0/0 (mem: 820.70 MiB)
16:02:45 (mem: 820.70 MiB)
16:02:45 Total structured size: 242025 (mem: 820.70 MiB)
16:02:45 allocating polynomials object in proving key... (mem: 820.70 MiB)
16:02:45 [16:02:45.623] INFO: pxe:bb:native bb - populating trace... (mem: 820.70 MiB)
16:02:45 [16:02:45.650] INFO: pxe:bb:native bb - time to construct proving key: 64 ms. (mem: 820.70 MiB)
16:02:45 [16:02:45.712] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x616349f62c00 (mem: 820.70 MiB)
16:02:45 computing folding proof (mem: 820.70 MiB)
16:02:45 [16:02:45.712] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000007b5461b8ea2d0a193b3cc5c82ff90e7a (mem: 820.70 MiB)
16:02:45 [16:02:45.883] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 820.70 MiB)
16:02:45 [16:02:45.933] INFO: pxe:bb:native bb - perturbator round (mem: 820.70 MiB)
16:02:45 [16:02:45.987] INFO: pxe:bb:native bb - combiner quotient round (mem: 820.70 MiB)
16:02:46 [16:02:46.057] INFO: pxe:bb:native bb - folded (mem: 820.70 MiB)
16:02:46 constructed folding proof (mem:
16:02:46 [16:02:46.057] INFO: pxe:bb:native bb - 820.70 MiB)
16:02:46 [16:02:46.057] INFO: pxe:bb:native bb - Largest circuit: 101078 gates. Trace details: (mem: 820.70 MiB)
16:02:46 [16:02:46.057] INFO: pxe:bb:native bb - Minimum required block sizes for structured trace: (mem: 820.70 MiB)
16:02:46 [16:02:46.058] INFO: pxe:bb:native bb - ecc_op : 792
16:02:46 busread : 4184
16:02:46 lookup : 2076
16:02:46 pub_inputs : 1859
16:02:46 arithmetic : 44918
16:02:46 delta_range : 5025
16:02:46 elliptic : 1274
16:02:46 aux : 12562
16:02:46 poseidon2_external : 6542
16:02:46 poseidon2_internal : 37280
16:02:46 overflow : 0
16:02:46 [16:02:46.058] INFO: pxe:bb:native bb - (mem: 820.70 MiB)
16:02:46 prove decider... (mem: 820.70 MiB)
16:02:46 [16:02:46.118] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 820.70 MiB)
16:02:46 [16:02:46.178] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 820.70 MiB)
16:02:46 [16:02:46.538] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 820.70 MiB)
16:02:46 [16:02:46.614] INFO: pxe:bb:native bb - computed opening proof (mem: 820.70 MiB)
16:02:46 finished decider proving. (mem: 820.70 MiB)
16:02:46 [16:02:46.627] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000007b5461b8ea2d0a193b3cc5c82ff90e7a (mem: 820.70 MiB)
16:02:46 [16:02:46.747] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 820.70 MiB)
16:02:46 [16:02:46.751] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 820.70 MiB)
16:02:46 [16:02:46.778] INFO: pxe:bb:native bb - populating trace... (mem: 820.70 MiB)
16:02:46 [16:02:46.823] INFO: pxe:bb:native bb - time to construct proving key: 74 ms. (mem: 820.70 MiB)
16:02:47 [16:02:47.146] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000005c8a4e75ab3d4ac0ef682b0d38b0dd9f (mem: 820.70 MiB)
16:02:47 [16:02:47.383] INFO: pxe:bb:native bb - created oink proof (mem: 820.70 MiB)
16:02:47 [16:02:47.498] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 820.70 MiB)
16:02:48 [16:02:47.897] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 820.70 MiB)
16:02:48 [16:02:48.285] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 820.70 MiB)
16:02:48 [16:02:48.326] INFO: pxe:bb:native bb - computed opening proof (mem: 820.70 MiB)
16:02:48 finished decider proving. (mem: 820.70 MiB)
16:02:48 [16:02:48.326] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3022 (mem: 820.70 MiB)
16:02:48 [16:02:48.389] INFO: pxe:bb:native bb - prove eccvm... (mem: 820.70 MiB)
16:02:48 [16:02:48.769] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 820.70 MiB)
16:02:48 [16:02:48.781] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 820.70 MiB)
16:02:49 [16:02:49.489] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 820.70 MiB)
16:02:50 [16:02:50.215] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 820.70 MiB)
16:02:52 [16:02:51.712] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 820.70 MiB)
16:02:52 prove translator... (mem: 820.70 MiB)
16:02:52 [16:02:52.456] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 835.20 MiB)
16:02:53 [16:02:53.272] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 835.20 MiB)
16:02:54 [16:02:54.141] INFO: pxe:bb:native bb - computed opening proof (mem: 835.20 MiB)
16:02:54 [16:02:54.141] INFO: pxe:bb:native bb - finished translator proving. (mem: 835.20 MiB)
16:02:54 [16:02:54.142] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000005c8a4e75ab3d4ac0ef682b0d38b0dd9f (mem: 835.20 MiB)
16:02:54 [16:02:54.162] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 835.20 MiB)
16:02:54 libra_evals_verified: 1 (mem: 835.20 MiB)
16:02:54 pairing_check_verified: 1 (mem: 835.20 MiB)
16:02:54 Mega verified: 1 (mem: 835.20 MiB)
16:02:54 [16:02:54.237] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 835.20 MiB)
16:02:54 batch opening verified?: 1 (mem: 835.20 MiB)
16:02:54 eccvm consistency check verified?: 1 (mem: 835.20 MiB)
16:02:54 translation masking consistency checked?: 1 (mem: 835.20 MiB)
16:02:54 [16:02:54.252] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 835.20 MiB)
16:02:54 eccvm verified?: 1 (mem: 835.20 MiB)
16:02:54 accumulator construction_verified?: 1 (mem: 835.20 MiB)
16:02:54 translation verified?: 1 (mem: 835.20 MiB)
16:02:54 consistency verified?: 1 (mem: 835.20 MiB)
16:02:54 Goblin verified: 1 (mem: 835.20 MiB)
16:02:54 [16:02:54.252] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-wb1TlM" (mem: 835.20 MiB)
16:02:54 [16:02:54.411] INFO: pxe:bb:native Generated IVC proof {"duration":14169.894144999998,"eventName":"circuit-proving"}
16:02:54 [16:02:54.416] INFO: pxe:service Proving completed in 18056.486143000002ms {"timings":{"total":18056.486143000002,"sync":66.27359500000011,"proving":14980.336865,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":479.3874390000001,"oracles":{"debugLog":{"times":[0.7120140000001811,0.1606549999996787,0.30529999999998836,0.44236399999999776,0.16445500000008906,0.6111299999997755,0.30202900000040245,0.3001589999994394]},"fetchTaggedLogs":{"times":[171.81740200000013]},"loadCapsule":{"times":[0.4176029999998718,0.285649999999805,0.4444240000002537,0.6434709999998631,0.7020529999999781,0.5502770000002783,0.6184599999996863,0.7471540000005916,0.5878490000004604,0.46556499999951484]},"getSharedSecret":{"times":[4.737983999999869]},"aes128Decrypt":{"times":[0.9425599999999577,5.3311329999996815]},"getPublicKeysAndPartialAddress":{"times":[11.776230999999825]},"getKeyValidationRequest":{"times":[4.397621999999956]},"storeCapsule":{"times":[4.057761000000028,3.212015000000065,3.0627699999995457]},"deleteCapsule":{"times":[3.853175000000192]},"bulkRetrieveLogs":{"times":[8.27437800000007]},"validateEnqueuedNotesAndEvents":{"times":[24.382778999999573]},"getNotes":{"times":[5.2520400000003065]},"getAuthWitness":{"times":[0.5673580000002403]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5095170000004146]},"callPrivateFunction":{"times":[135.108244]},"notifyEnqueuedPublicFunctionCall":{"times":[0.25522799999998824]}}},{"functionName":"private_kernel_init","time":294.9497969999993},{"functionName":"ContractInstanceDeployer:deploy","time":69.0225249999994,"oracles":{"storeInExecutionCache":{"times":[0.3622320000004038]},"callPrivateFunction":{"times":[69.8136800000002]},"notifyCreatedNullifier":{"times":[0.42667399999936606]},"debugLog":{"times":[0.20039699999961158]}}},{"functionName":"private_kernel_inner","time":436.45434900000055},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":56.47425700000076,"oracles":{}},{"functionName":"private_kernel_inner","time":393.897191},{"functionName":"private_kernel_reset","time":452.1416960000006},{"functionName":"private_kernel_tail","time":372.2361200000005}],"unaccounted":455.3123090000008}}
16:02:54 [16:02:54.535] INFO: pxe:service Sent transaction 0x10b9adaf13c7c322297e76a3ee65bcef8fb7d28866ad362cc4784c94fb786ef1
16:02:55 [16:02:54.533]
INFO:
node Received tx 0x10b9adaf13c7c322297e76a3ee65bcef8fb7d28866ad362cc4784c94fb786ef1
{"txHash":"0x10b9adaf13c7c322297e76a3ee65bcef8fb7d28866ad362cc4784c94fb786ef1"}
16:03:06 [16:03:06.134]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695214
16:03:06 [16:03:06.134]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:13:34.000Z
{"offset":627866,"timeMs":1750695214000}
16:03:06 [16:03:06.134]
INFO:
aztecjs:utils:watcher Slot 14 was missed, jumped to next slot
16:03:07 [16:03:06.914]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2203239889999968s
{"duration":0.2203239889999968,"rate":1436302.9710759486,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472}
16:03:07 [16:03:06.940]
INFO:
sequencer Built block 11 for slot 15 with 1 txs and 0 messages. 1238097.7528592087 mana/s
{"blockHash":"0x2705247a4e97d3889cdfffe8112eb0acd98a889a53521e15af44d1fc608b8e60","globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750695214,"version":1667649171},"txHashes":["0x10b9adaf13c7c322297e76a3ee65bcef8fb7d28866ad362cc4784c94fb786ef1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":255.50692499999423,"publicProcessDuration":220.4790149999899,"rollupCircuitsDuration":249.51831700000912,"txCount":1,"blockNumber":11,"blockTimestamp":1750695214,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:03:07 [16:03:07.114]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:03:07 [16:03:07.190]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:03:07 [16:03:07.190]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:13:46.000Z
{"offset":638810,"timeMs":1750695226000}
16:03:07 [16:03:07.195]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750695250
16:03:07 [16:03:07.195]
WARN:
foundation:test-date-provider Time set to 2025-06-23T16:14:10.000Z
{"offset":662805,"timeMs":1750695250000}
16:03:07 [16:03:07.195]
INFO:
aztecjs:utils:watcher Slot 15 was filled, jumped to next slot
16:03:07 [16:03:07.305]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0xa984bcbed42ffed03d0c147d35ee1763db9c59c8 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 11
16:03:07 [16:03:07.306]
INFO:
aztecjs:cheat_codes Proven tip moved: 10 -> 11. Pending tip: 11.
16:03:07 [16:03:07.379]
INFO:
archiver Downloaded L2 block 11
{"blockHash":"0x2705247a4e97d3889cdfffe8112eb0acd98a889a53521e15af44d1fc608b8e60","blockNumber":11,"txCount":1,"globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2880,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750695214,"version":1667649171},"archiveRoot":"0x063ca2476f57aed86fa653c80846fb673e2f4a712fec141427af6c28629b0cd2","archiveNextLeafIndex":12}
16:03:07 [16:03:07.381]
INFO:
archiver Updated proven chain to block 11
{"provenBlockNumber":11}
16:03:07 [16:03:07.490]
INFO:
world_state World state updated with L2 block 11
{"eventName":"l2-block-handled","duration":6.418032000015955,"unfinalisedBlockNumber":11,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":11,"blockTimestamp":1750695214,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:03:07 Contract deployed at 0x190eb1791b1c88c91b7023e57f3f2b896218e3a4067837e7bc0fc406a31801b2
16:03:07 Contract partial address 0x03bc9cd5735b324e91773816dbe6b3f6cb942bfc529acc6b8ab090031bc8a015
16:03:07 Contract init hash 0x14328aa2ffa4e6d03c463c9bf3fe56ce1649dcd78e56a8fab345acd50584b6ac
16:03:07 Deployment tx hash: 0x10b9adaf13c7c322297e76a3ee65bcef8fb7d28866ad362cc4784c94fb786ef1
16:03:07 Deployment salt: 0x13d3b22d778ef7fe867baeffdddafcfd5a4b3fb71dcdef71e5fd2fe6a82ea822
16:03:07 Deployment fee: 979153920
16:03:07 Contract stored in database with alias last
16:03:09 Sending kill to pid 449
16:03:09 Sending kill to aztec-start-1e5d7b70