Parent Log: http://ci.aztec-labs.com/2171d22e1569df51 Command: 86bb7a844cc38c99 aztec-up/scripts/run_test.sh bridge_and_claim Commit: https://github.com/AztecProtocol/aztec-packages/commit/1fc5957df9da86dc8fdc6c622544db2499cdbbc1 Env: REF_NAME=gh-readonly-queue/next/pr-15286-85c7d115f07bdc47eb18778910e372b8db1e0d3d CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 26 11:58:58 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15286_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_ee64b3b6ca626708_next 11:58:58 Unable to find image 'aztecprotocol/dind:latest' locally 11:58:58 latest: Pulling from aztecprotocol/dind 11:58:58 afad30e59d72: Already exists 11:58:58 4e9c72eacf62: Already exists 11:58:58 1fdf475197e7: Pulling fs layer 11:58:58 5be0e287c3f8: Pulling fs layer 11:58:58 5be0e287c3f8: Download complete 11:59:02 1fdf475197e7: Pull complete 11:59:02 5be0e287c3f8: Pull complete 11:59:02 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b 11:59:02 Status: Downloaded newer image for aztecprotocol/dind:latest 11:59:02 Starting docker... 11:59:07 time="2025-06-26T11:59:02.981450420Z" level=info msg="Starting up" 11:59:07 time="2025-06-26T11:59:02.982236251Z" level=info msg="containerd not running, starting managed containerd" 11:59:07 time="2025-06-26T11:59:02.983682872Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=84 11:59:07 time="2025-06-26T11:59:03.027719655Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=1.7.25-1 11:59:07 time="2025-06-26T11:59:03.049286937Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.050008342Z" 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 11:59:07 time="2025-06-26T11:59:03.050057676Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 11:59:07 time="2025-06-26T11:59:03.050082168Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 11:59:07 time="2025-06-26T11:59:03.054679172Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 11:59:07 time="2025-06-26T11:59:03.054742967Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.054831744Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.054857666Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055093355Z" 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 11:59:07 time="2025-06-26T11:59:03.055119177Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055139339Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055204884Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055280840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055565683Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 11:59:07 time="2025-06-26T11:59:03.055732806Z" 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 11:59:07 time="2025-06-26T11:59:03.055756418Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 11:59:07 time="2025-06-26T11:59:03.055787211Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 11:59:07 time="2025-06-26T11:59:03.055841655Z" level=info msg="metadata content store policy set" policy=shared 11:59:07 time="2025-06-26T11:59:03.056129808Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 11:59:07 time="2025-06-26T11:59:03.056232797Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 11:59:07 time="2025-06-26T11:59:03.056261509Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 11:59:07 time="2025-06-26T11:59:03.056291501Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 11:59:07 time="2025-06-26T11:59:03.056321904Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 11:59:07 time="2025-06-26T11:59:03.056544582Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 11:59:07 time="2025-06-26T11:59:03.057126438Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 11:59:07 time="2025-06-26T11:59:03.057538441Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 11:59:07 time="2025-06-26T11:59:03.057569093Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 11:59:07 time="2025-06-26T11:59:03.057592235Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 11:59:07 time="2025-06-26T11:59:03.057612497Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057641649Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057657901Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057677282Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057704535Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057730077Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057748378Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057765869Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 11:59:07 time="2025-06-26T11:59:03.057797752Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057828354Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057866768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057886649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057901620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057922022Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057939793Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057957445Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057974296Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.057995478Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058009379Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058023660Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058041331Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058064553Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 11:59:07 time="2025-06-26T11:59:03.058099586Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058133009Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058179453Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 11:59:07 time="2025-06-26T11:59:03.058266569Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 11:59:07 time="2025-06-26T11:59:03.058294912Z" 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 11:59:07 time="2025-06-26T11:59:03.058306963Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 11:59:07 time="2025-06-26T11:59:03.058320384Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 11:59:07 time="2025-06-26T11:59:03.058330065Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 11:59:07 time="2025-06-26T11:59:03.058346096Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 11:59:07 time="2025-06-26T11:59:03.058371508Z" level=info msg="NRI interface is disabled by configuration." 11:59:07 time="2025-06-26T11:59:03.058768620Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock 11:59:07 time="2025-06-26T11:59:03.058938053Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc 11:59:07 time="2025-06-26T11:59:03.059046192Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock 11:59:07 time="2025-06-26T11:59:03.059074284Z" level=info msg="containerd successfully booted in 0.032373s" 11:59:07 time="2025-06-26T11:59:03.989132853Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" 11:59:07 time="2025-06-26T11:59:04.018063191Z" level=info msg="Loading containers: start." 11:59:07 time="2025-06-26T11:59:04.269838921Z" level=info msg="Loading containers: done." 11:59:07 time="2025-06-26T11:59:04.283077422Z" level=info msg="Docker daemon" commit=38b84dce32c45732606fe09ffebef8b29a783644 containerd-snapshotter=false storage-driver=overlay2 version=27.5.0-1 11:59:07 time="2025-06-26T11:59:04.283356804Z" level=info msg="Daemon has completed initialization" 11:59:07 time="2025-06-26T11:59:04.296979825Z" level=info msg="API listen on /var/run/docker.sock" 11:59:07 Loading image... 11:59:42 Loaded image: aztecprotocol/aztec:latest 11:59:43 Installing scripts in /home/ubuntu/.aztec/bin... 11:59:43 Installed: /home/ubuntu/.aztec/bin/.aztec-run 11:59:43 Installed: /home/ubuntu/.aztec/bin/aztec 11:59:43 Installed: /home/ubuntu/.aztec/bin/aztec-up 11:59:43 Installed: /home/ubuntu/.aztec/bin/aztec-nargo 11:59:43 Installed: /home/ubuntu/.aztec/bin/aztec-wallet 11:59:43 Done! 11:59:44 anvil Version: 1.2.3-nightly 11:59:44 Commit SHA: 99634144b6c9371982dcfc551a7975c5dbf9fad8 11:59:44 Build Timestamp: 2025-06-06T06:02:57.177433691Z (1749189777) 11:59:44 Build Profile: maxperf 11:59:50 11:59:50 _ 11:59:50 /\ | | 11:59:50 / \ ___| |_ ___ ___ 11:59:50 / /\ \ |_ / __/ _ \/ __| 11:59:50 / ____ \ / /| || __/ (__ 11:59:50 /_/___ \_\/___|\__\___|\___| 11:59:50 11:59:50 https://github.com/AztecProtocol 11:59:50 11:59:50 11:59:50 Setting up Aztec Sandbox 1fc5957df9da86dc8fdc6c622544db2499cdbbc1, please stand by... 11:59:50 Setting up test accounts 11:59:51 [11:59:51.147] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-AMwKnr/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 11:59:51 [11:59:51.228] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 11:59:51 [11:59:51.233] WARN: sandbox Set block interval to 12 11:59:51 [11:59:51.234] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.298] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.319] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.344] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.366] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.394] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.434] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.455] INFO: sandbox Waiting for 7 transactions to be mined... 11:59:51 [11:59:51.505] INFO: sandbox All transactions mined successfully 11:59:51 [11:59:51.532] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.569] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.619] INFO: sandbox Waiting for 9 transactions to be mined... 11:59:51 [11:59:51.646] INFO: sandbox All transactions mined successfully 11:59:51 [11:59:51.697] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.717] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.732] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.765] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.823] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:51 [11:59:51.881] INFO: sandbox Waiting for 11 transactions to be mined... 11:59:51 [11:59:51.915] INFO: sandbox All transactions mined successfully 11:59:51 [11:59:51.933] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000000a2f 11:59:52 [11:59:52.015] INFO: sandbox Waiting for 12 transactions to be mined... 11:59:52 [11:59:52.054] INFO: sandbox All transactions mined successfully 11:59:52 [11:59:52.062] INFO: sandbox Waiting for 12 transactions to be mined... 11:59:52 [11:59:52.104] INFO: sandbox All transactions mined successfully 11:59:52 [11:59:52.124] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0xea4e3dce94bf8e9ecc35c968bc51d46c148c2528","governanceAddress":"0xfff91e41d9b6930a0395a2d85c77aab8079e3751","governanceProposerAddress":"0x558857b9fc10f1b13012b787b9d3cfe485a699a8","rollupAddress":"0x3f4481c96076d4c37f9c9b65819f63e0e35e5707","inboxAddress":"0x708dd88d1af1f3c0be17e3ba28c2c0087ac4e97a","outboxAddress":"0x0da25aa4c8dd2a5af56fa2e82ca62f370ec3bb88","feeJuicePortalAddress":"0x0e45141fc552dc4f804cd96d93a95eead8ae3957","feeJuiceAddress":"0xf93689b1d769e7bba9c083ca5b62f414bb68bc63","stakingAssetAddress":"0x8f4a5d7ed3f57d1062332fc573eb42bd92107007","rewardDistributorAddress":"0x0b2c5b54f410374459e384168bb6f29a0385af66","gseAddress":"0x3fa8f11f1116ad148f531ff57300c7999e710972","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 11:59:52 [11:59:52.124] INFO: sandbox Handing over to governance 11:59:52 [11:59:52.141] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 11:59:52 [11:59:52.147] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 11:59:52 [11:59:52.154] INFO: sandbox Deployed Multicall3 11:59:52 [11:59:52.162] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3F4481c96076D4c37f9C9B65819F63e0e35e5707 11:59:52 [11:59:52.163] INFO: telemetry:client Using NoopTelemetryClient 11:59:52 [11:59:52.163] INFO: blob-sink:client Creating local blob sink client. 11:59:52 [11:59:52.181] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 11:59:52 [11:59:52.182] WARN: foundation:test-date-provider Time set to 2025-06-26T12:04:56.000Z {"offset":303818,"timeMs":1750939496000} 11:59:52 [11:59:52.210] INFO: archiver:lmdb Starting data store with maxReaders 16 11:59:52 [11:59:52.536] INFO: archiver Starting archiver sync to rollup contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 from L1 block 20 to current L1 block 26 with hash 0x1e6085daff351672b500bbe01ff77448980e875622a9b1d3147b04e608d99579 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xb4b5f8fe1d219d92c7f3711298e00b3aea23d35ba630f3804b21c208b0419521","l1BlockNumber":20}} 11:59:52 [11:59:52.551] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 11:59:52 [11:59:52.560] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-oV0kk2/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 11:59:52 [11:59:52.600] INFO: world_state Created world state synchroniser with block history of 64 11:59:52 [11:59:52.600] WARN: node Aztec node is accepting fake proofs 11:59:52 [11:59:52.600] INFO: bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers 11:59:52 [11:59:52.611] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 11:59:52 [11:59:52.613] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 11:59:52 [11:59:52.615] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 11:59:52 [11:59:52.616] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 11:59:52 [11:59:52.620] INFO: world_state Started world state synchronizer from block 1 11:59:52 [11:59:52.624] INFO: p2p Starting p2p client from block 0 with empty mempools 11:59:52 [11:59:52.857] INFO: epoch-prune-watcher EpochPruneWatcher initialized 11:59:52 [11:59:52.931] INFO: slasher Starting Slasher client... 11:59:52 [11:59:52.958] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 11:59:52 [11:59:52.958] 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} 11:59:52 [11:59:52.961] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 11:59:52 [11:59:52.962] INFO: node Aztec Node version: 1fc5957df9da86dc8fdc6c622544db2499cdbbc1 11:59:52 [11:59:52.962] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x3f4481c96076d4c37f9c9b65819f63e0e35e5707","registryAddress":"0xea4e3dce94bf8e9ecc35c968bc51d46c148c2528","inboxAddress":"0x708dd88d1af1f3c0be17e3ba28c2c0087ac4e97a","outboxAddress":"0x0da25aa4c8dd2a5af56fa2e82ca62f370ec3bb88","feeJuiceAddress":"0xf93689b1d769e7bba9c083ca5b62f414bb68bc63","stakingAssetAddress":"0x8f4a5d7ed3f57d1062332fc573eb42bd92107007","feeJuicePortalAddress":"0x0e45141fc552dc4f804cd96d93a95eead8ae3957","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0x0b2c5b54f410374459e384168bb6f29a0385af66","governanceProposerAddress":"0x558857b9fc10f1b13012b787b9d3cfe485a699a8","governanceAddress":"0xfff91e41d9b6930a0395a2d85c77aab8079e3751","slashFactoryAddress":"0x80ef2a4ca2e805a6cddef6a1b925114d784269c7","feeAssetHandlerAddress":"0xdbcfc899989ed4c33bad7206cf64e62e69778bd3","stakingAssetHandlerAddress":"0xf81bcc722660c687c13fe8b9d9a10cda06b0742d","gseAddress":"0x3fa8f11f1116ad148f531ff57300c7999e710972","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 11:59:52 [11:59:52.966] INFO: pxe:data:lmdb Starting data store with maxReaders 16 11:59:53 Setting up funded test accounts... 11:59:53 [11:59:53.357] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 11:59:53 [11:59:53.405] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 11:59:53 [11:59:53.468] WARN: pxe:service No artifact found for contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf when looking for its metadata 11:59:53 [11:59:53.470] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf as part of deployment for 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 11:59:53 [11:59:53.693] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 11:59:57 [11:59:57.133] INFO: pxe:service Proving completed in 3396.3306299999986ms {"timings":{"total":3396.3306299999986,"sync":10.258346000000529,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":157.70750100000078,"oracles":{"callPrivateFunction":{"times":[1416.4294759999993,388.56179800000064,218.55689300000085]}}},{"functionName":"private_kernel_init","time":117.0635140000013},{"functionName":"ContractClassRegisterer:register","time":1381.9330129999998,"oracles":{"loadCapsule":{"times":[20.759163000000626]},"notifyCreatedNullifier":{"times":[0.8077030000004015]},"debugLog":{"times":[0.5619540000006964]},"notifyCreatedContractClassLog":{"times":[13.050176000000647]}}},{"functionName":"private_kernel_inner","time":173.82544499999858},{"functionName":"SchnorrAccount:constructor","time":364.4870140000003,"oracles":{"getContractInstance":{"times":[1.2170760000008158]},"debugLog":{"times":[0.2785519999997632,0.14374099999986356]},"fetchTaggedLogs":{"times":[79.96861600000011]},"loadCapsule":{"times":[0.4423850000002858,0.23132799999984854,0.2773109999998269,0.18953400000100373,0.27559199999996054,0.18207500000062282]},"bulkRetrieveLogs":{"times":[1.7814699999998993]},"validateEnqueuedNotesAndEvents":{"times":[1.783740000000762]},"notifyCreatedNullifier":{"times":[0.24567999999999302,0.3238760000003822]},"notifyCreatedNote":{"times":[0.5798649999996996]},"getRandomField":{"times":[0.3332270000009885,0.2932330000003276,0.11413900000115973,0.2634909999997035,0.09098699999958626,0.07438600000023143,0.15400200000112818,0.05259499999920081,0.06920499999978347,0.11323799999991024,0.07172599999830709]},"getIndexedTaggingSecretAsSender":{"times":[41.49786200000017]},"incrementAppTaggingSecretIndexAsSender":{"times":[11.21234099999856]}}},{"functionName":"private_kernel_inner","time":147.1419679999999},{"functionName":"SchnorrAccount:entrypoint","time":205.65181800000028,"oracles":{"debugLog":{"times":[0.32475500000145985,0.13311000000066997,0.41684300000088115]},"fetchTaggedLogs":{"times":[62.72326199999952]},"loadCapsule":{"times":[0.4392440000010538,1.980306000001292,1.23418700000002,0.22536700000091514,0.1825140000000829,0.19360500000038883]},"bulkRetrieveLogs":{"times":[1.4338629999983823]},"validateEnqueuedNotesAndEvents":{"times":[1.8628570000000764]},"getNotes":{"times":[2.727745000000141]},"getAuthWitness":{"times":[0.32440500000120664]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0943260000003647]}}},{"functionName":"private_kernel_inner","time":133.0959039999998},{"functionName":"private_kernel_reset","time":215.2419119999995},{"functionName":"private_kernel_tail","time":86.2939239999996}],"unaccounted":403.6302709999982}} 11:59:57 [11:59:57.272] INFO: node Received tx 0x0b78a5c39d08ce8b98f779cbb6c45687e3a12400c7e2271a7b71aa796d907f19 {"txHash":"0x0b78a5c39d08ce8b98f779cbb6c45687e3a12400c7e2271a7b71aa796d907f19"} 11:59:57 [11:59:57.272] INFO: pxe:service Sent transaction 0x0b78a5c39d08ce8b98f779cbb6c45687e3a12400c7e2271a7b71aa796d907f19 11:59:57 [11:59:57.923] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1051836289999992s {"duration":0.1051836289999992,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 11:59:57 [11:59:57.958] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x07594694caaa2986b25bd0fbf41022e009613cdc809f02b6b160d2e18d3b3a6d","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750939496,"version":2896790463},"txHashes":["0x0b78a5c39d08ce8b98f779cbb6c45687e3a12400c7e2271a7b71aa796d907f19"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":151.55289500000072,"publicProcessDuration":106.26284400000077,"rollupCircuitsDuration":143.6584640000001,"txCount":1,"blockNumber":1,"blockTimestamp":1750939496,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:00:01 [12:00:00.705] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:01 [12:00:00.730] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939532 12:00:01 [12:00:00.730] WARN: foundation:test-date-provider Time set to 2025-06-26T12:05:32.000Z {"offset":331270,"timeMs":1750939532000} 12:00:01 [12:00:00.730] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 12:00:01 [12:00:00.907] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 12:00:01 [12:00:00.908] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x07594694caaa2986b25bd0fbf41022e009613cdc809f02b6b160d2e18d3b3a6d","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750939496,"version":2896790463},"archiveRoot":"0x15e3f8058730f0fb968007c00fca9f9bec828073ab6ca9e138db7f85a497ca5c","archiveNextLeafIndex":2} 12:00:01 [12:00:00.910] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 12:00:01 [12:00:01.009] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 12:00:01 [12:00:01.144] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:01 [12:00:01.238] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":11.828400000002148,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750939496,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:00:01 [12:00:01.490] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 12:00:03 [12:00:02.772] INFO: pxe:service Proving completed in 1596.8093169999993ms {"timings":{"total":1596.8093169999993,"sync":45.19251300000178,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":109.30742399999872,"oracles":{"callPrivateFunction":{"times":[346.6831659999989,212.97216300000218]}}},{"functionName":"private_kernel_init","time":91.37133299999914},{"functionName":"SchnorrAccount:constructor","time":333.08296600000176,"oracles":{"getContractInstance":{"times":[3.3109199999998964]},"debugLog":{"times":[0.2034669999993639,0.1307600000000093]},"fetchTaggedLogs":{"times":[102.73062600000048]},"loadCapsule":{"times":[1.6553299999977753,1.1684920000006969,1.062103999996907,0.2447089999986929,0.18835500000204775,0.18608400000084657]},"bulkRetrieveLogs":{"times":[2.010067999999592]},"validateEnqueuedNotesAndEvents":{"times":[2.21551399999953]},"notifyCreatedNullifier":{"times":[0.47379800000271644,0.5419029999975464]},"notifyCreatedNote":{"times":[0.2697009999974398]},"getRandomField":{"times":[0.2686409999987518,0.27650200000061886,0.07487599999876693,0.046813000000838656,0.05664499999693362,0.050333999999566004,0.04319400000167661,0.04375399999844376,0.04459299999871291,0.06796600000234321,0.04811400000107824]},"getIndexedTaggingSecretAsSender":{"times":[27.031245000001945]},"incrementAppTaggingSecretIndexAsSender":{"times":[22.710366000002978]}}},{"functionName":"private_kernel_inner","time":146.8798969999989},{"functionName":"SchnorrAccount:entrypoint","time":198.6250050000017,"oracles":{"debugLog":{"times":[0.35335699999995995,0.15725199999724282,0.27592100000038045]},"fetchTaggedLogs":{"times":[82.79015900000013]},"loadCapsule":{"times":[0.34309700000085286,0.2025850000027276,1.7221449999997276,0.38837100000091596,0.21467699999993783,0.17962400000033085]},"bulkRetrieveLogs":{"times":[1.3952200000021548]},"validateEnqueuedNotesAndEvents":{"times":[1.8208229999981995]},"getNotes":{"times":[2.254016999999294]},"getAuthWitness":{"times":[0.20409600000130013]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.742048000000068]}}},{"functionName":"private_kernel_inner","time":132.64816900000005},{"functionName":"private_kernel_reset","time":218.93421200000012},{"functionName":"private_kernel_tail","time":79.31061599999884}],"unaccounted":241.45718199999828}} 12:00:03 [12:00:02.810] INFO: node Received tx 0x026d9a147940f0162d94403b1a07a8638d6feb0c49594f617d48252e88d2d000 {"txHash":"0x026d9a147940f0162d94403b1a07a8638d6feb0c49594f617d48252e88d2d000"} 12:00:03 [12:00:02.810] INFO: pxe:service Sent transaction 0x026d9a147940f0162d94403b1a07a8638d6feb0c49594f617d48252e88d2d000 12:00:03 [12:00:03.382] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03638994100000127s {"duration":0.03638994100000127,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 12:00:03 [12:00:03.420] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0f89ccd3bf85c5236cb79f3c6cff44dccdeb6752c5f48ac0979d6d2a95ed09c6","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750939532,"version":2896790463},"txHashes":["0x026d9a147940f0162d94403b1a07a8638d6feb0c49594f617d48252e88d2d000"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":84.10953300000256,"publicProcessDuration":36.592336999998224,"rollupCircuitsDuration":78.64394299999913,"txCount":1,"blockNumber":2,"blockTimestamp":1750939532,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:03 [12:00:03.599] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:03 [12:00:03.615] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:03 [12:00:03.615] WARN: foundation:test-date-provider Time set to 2025-06-26T12:05:44.000Z {"offset":340385,"timeMs":1750939544000} 12:00:03 [12:00:03.622] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 12:00:03 [12:00:03.624] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 12:00:03 [12:00:03.669] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939568 12:00:03 [12:00:03.669] WARN: foundation:test-date-provider Time set to 2025-06-26T12:06:08.000Z {"offset":364331,"timeMs":1750939568000} 12:00:03 [12:00:03.669] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 12:00:03 [12:00:03.916] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0f89ccd3bf85c5236cb79f3c6cff44dccdeb6752c5f48ac0979d6d2a95ed09c6","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750939532,"version":2896790463},"archiveRoot":"0x198eb4a9a96cc65d699c3aa4209d655bfc31f2fdd9a8935231242baaf44a69d8","archiveNextLeafIndex":3} 12:00:03 [12:00:03.918] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 12:00:04 [12:00:04.040] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 12:00:04 [12:00:04.162] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:04 [12:00:04.206] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.602648000000045,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750939532,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:06 Initial Accounts: 12:00:06 12:00:06 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:00:06 Partial Address: 0x094a6663324a8544a40feeacc00ceca29902f1e171ea9015b006dd08d155b962 12:00:06 Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 12:00:06 Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 12:00:06 Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 12:00:06 12:00:06 Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 12:00:06 12:00:06 Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 12:00:06 12:00:06 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 12:00:06 Partial Address: 0x2b84d2628da65fd311052223c692573fdd885b8656536fa5aae92743f0422302 12:00:06 Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 12:00:06 Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 12:00:06 Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 12:00:06 12:00:06 Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 12:00:06 12:00:06 Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 12:00:06 12:00:06 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 12:00:06 Partial Address: 0x0c66cb7f2e50aaf65f67688f65683ba06d1262cab4c413c12f0148f9f5541891 12:00:06 Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 12:00:06 Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 12:00:06 Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 12:00:06 12:00:06 Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 12:00:06 12:00:06 Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 12:00:06 12:00:06 12:00:06 [12:00:05.551] INFO: pxe:service Proving completed in 1367.677463ms {"timings":{"total":1367.677463,"sync":7.859388000000763,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":79.51155900000231,"oracles":{"callPrivateFunction":{"times":[231.28334299999915,171.71789999999964]}}},{"functionName":"private_kernel_init","time":70.6674860000021},{"functionName":"SchnorrAccount:constructor","time":217.65365200000087,"oracles":{"getContractInstance":{"times":[1.0348810000032245]},"debugLog":{"times":[0.1484520000012708,0.13244099999792525]},"fetchTaggedLogs":{"times":[51.87694900000133]},"loadCapsule":{"times":[0.3082840000024589,0.2166479999978037,0.20073599999886937,0.15882199999759905,0.15172099999836064,0.17680399999881047]},"bulkRetrieveLogs":{"times":[1.2388370000007853]},"validateEnqueuedNotesAndEvents":{"times":[1.664442000001145]},"notifyCreatedNullifier":{"times":[0.34314699999958975,0.3024439999971946]},"notifyCreatedNote":{"times":[0.17268400000102702]},"getRandomField":{"times":[0.18553500000052736,0.29133200000069337,0.1163589999996475,0.12102900000172667,0.11931900000126916,0.08978700000079698,0.07432600000174716,0.07358600000225124,0.0921569999991334,0.07239599999957136,0.08020699999906356]},"getIndexedTaggingSecretAsSender":{"times":[28.410413000001427]},"incrementAppTaggingSecretIndexAsSender":{"times":[12.004064000000653]}}},{"functionName":"private_kernel_inner","time":123.57855600000039},{"functionName":"SchnorrAccount:entrypoint","time":163.71522099999856,"oracles":{"debugLog":{"times":[0.215477000001556,0.1107590000028722,0.17639300000155345]},"fetchTaggedLogs":{"times":[56.92393499999889]},"loadCapsule":{"times":[0.2568700000010722,0.25975000000107684,0.2025260000009439,0.1882049999985611,0.22208800000225892,0.17927399999825866]},"bulkRetrieveLogs":{"times":[1.2130460000007588]},"validateEnqueuedNotesAndEvents":{"times":[5.850819999999658]},"getNotes":{"times":[1.5669039999993402]},"getAuthWitness":{"times":[0.17139299999689683]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4534449999991921]}}},{"functionName":"private_kernel_inner","time":191.48098400000163},{"functionName":"private_kernel_reset","time":234.1314659999989},{"functionName":"private_kernel_tail","time":92.61013099999764}],"unaccounted":186.46901999999682}} 12:00:06 [12:00:05.603] INFO: node Received tx 0x0ab4867962a2b1b4b794e6743dd22f74c61c0b3f5a158eabe998b0859c6a30de {"txHash":"0x0ab4867962a2b1b4b794e6743dd22f74c61c0b3f5a158eabe998b0859c6a30de"} 12:00:06 [12:00:05.603] INFO: pxe:service Sent transaction 0x0ab4867962a2b1b4b794e6743dd22f74c61c0b3f5a158eabe998b0859c6a30de 12:00:06 [12:00:05.643] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02123015999999916s {"duration":0.02123015999999916,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 12:00:06 [12:00:05.679] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x08a0195559e5978e7e0f266fa73470b426dfbb06bab14408ad545a0a896ae18c","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750939568,"version":2896790463},"txHashes":["0x0ab4867962a2b1b4b794e6743dd22f74c61c0b3f5a158eabe998b0859c6a30de"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":66.83720499999981,"publicProcessDuration":21.38568099999975,"rollupCircuitsDuration":60.395158999999694,"txCount":1,"blockNumber":3,"blockTimestamp":1750939568,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:06 [12:00:05.897] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:06 [12:00:05.984] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:06 [12:00:05.984] WARN: foundation:test-date-provider Time set to 2025-06-26T12:06:20.000Z {"offset":374016,"timeMs":1750939580000} 12:00:06 [12:00:05.988] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 12:00:06 [12:00:05.989] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 12:00:06 [12:00:06.106] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939604 12:00:06 [12:00:06.106] WARN: foundation:test-date-provider Time set to 2025-06-26T12:06:44.000Z {"offset":397894,"timeMs":1750939604000} 12:00:06 [12:00:06.106] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 12:00:06 [12:00:06.145] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x08a0195559e5978e7e0f266fa73470b426dfbb06bab14408ad545a0a896ae18c","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750939568,"version":2896790463},"archiveRoot":"0x2b7b5d3bdf930a798905b8d632dcd6dba8bc731aed133983fc2cfd1f06f7decb","archiveNextLeafIndex":4} 12:00:06 [12:00:06.147] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 12:00:07 [12:00:06.931] WARN: pxe:service No artifact found for contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 when looking for its metadata 12:00:07 [12:00:06.932] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 12:00:07 [12:00:06.937] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 as part of deployment for 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 12:00:07 [12:00:06.957] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 as part of deployment for 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 12:00:07 [12:00:07.192] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":11.687058999999863,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750939568,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:07 [12:00:07.798] INFO: pxe:service Added contract Token at 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 12:00:07 [12:00:07.800] INFO: pxe:service Added contract FPC at 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 with class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 12:00:10 [12:00:10.729] INFO: pxe:service Proving completed in 2905.2375530000027ms {"timings":{"total":2905.2375530000027,"sync":9.275799999999435,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":311.3104910000038,"oracles":{"debugLog":{"times":[0.24711999999999534,0.17779399999926682,0.15275199999814504,0.2895429999989574,0.13652100000035716,0.09020700000110082,0.0763150000020687,0.21316700000170385]},"fetchTaggedLogs":{"times":[122.66201799999908]},"loadCapsule":{"times":[0.4980490000016289,0.25226000000111526,0.41416300000128103,0.27359099999739556,0.19855599999937112,0.15833199999906356,0.19934500000090338,0.1289599999981874,0.17879399999947054,0.17816400000083377]},"getSharedSecret":{"times":[6.450046000001748]},"aes128Decrypt":{"times":[1.6407680000011169,1.0964060000005702]},"getPublicKeysAndPartialAddress":{"times":[2.2019230000005336]},"getKeyValidationRequest":{"times":[3.2437650000028952]},"storeCapsule":{"times":[0.5647439999993367,0.27484199999889825,0.24925900000016554]},"deleteCapsule":{"times":[0.35719800000151736]},"bulkRetrieveLogs":{"times":[1.0954259999998612]},"validateEnqueuedNotesAndEvents":{"times":[14.168351000000257]},"getNotes":{"times":[5.596429000001081]},"getAuthWitness":{"times":[0.3116139999983716]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09470800000053714]},"callPrivateFunction":{"times":[1258.0594779999992,140.20424399999683]},"notifyEnqueuedPublicFunctionCall":{"times":[0.6115280000012717]}}},{"functionName":"private_kernel_init","time":70.36719799999992},{"functionName":"ContractClassRegisterer:register","time":1242.7878709999968,"oracles":{"loadCapsule":{"times":[3.7758360000007087]},"notifyCreatedNullifier":{"times":[0.4516159999984666]},"debugLog":{"times":[0.1212599999998929]},"notifyCreatedContractClassLog":{"times":[4.181958000001032]}}},{"functionName":"private_kernel_inner","time":141.05215999999928},{"functionName":"ContractInstanceDeployer:deploy","time":89.49672799999826,"oracles":{"storeInExecutionCache":{"times":[0.2743510000000242]},"callPrivateFunction":{"times":[68.90366300000096]},"notifyCreatedNullifier":{"times":[0.40960199999972247]},"debugLog":{"times":[0.22210700000141514]}}},{"functionName":"private_kernel_inner","time":131.2726139999977},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.27348300000085,"oracles":{}},{"functionName":"private_kernel_inner","time":133.49681799999962},{"functionName":"private_kernel_reset","time":199.1692379999986},{"functionName":"private_kernel_tail","time":108.994157000001}],"unaccounted":424.7409950000074}} 12:00:10 [12:00:10.880] INFO: node Received tx 0x11cf030c4da44d9fcd3900eb0add39b2374a7f4f663abae0992548ab420e9fd7 {"txHash":"0x11cf030c4da44d9fcd3900eb0add39b2374a7f4f663abae0992548ab420e9fd7"} 12:00:10 [12:00:10.880] INFO: pxe:service Sent transaction 0x11cf030c4da44d9fcd3900eb0add39b2374a7f4f663abae0992548ab420e9fd7 12:00:13 [12:00:13.640] INFO: pxe:service Proving completed in 2908.616052999998ms {"timings":{"total":2908.616052999998,"sync":131.75846100000126,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":374.5940629999932,"oracles":{"debugLog":{"times":[0.2296779999996943,0.0897270000023127,0.13682100000005448,0.21197700000266195,0.1655030000001716,0.12109000000054948,0.06055399999968358,0.15643200000340585]},"fetchTaggedLogs":{"times":[111.59573100000125]},"loadCapsule":{"times":[0.2977129999999306,0.20717599999989034,0.2947229999990668,0.4370049999997718,0.47133600000233855,0.22354700000141747,0.4148730000015348,0.20337599999766098,0.16178299999955925,0.18460399999821675]},"getSharedSecret":{"times":[5.9260639999993145]},"aes128Decrypt":{"times":[0.6638019999991229,0.5586340000008931]},"getPublicKeysAndPartialAddress":{"times":[2.4403309999979683]},"getKeyValidationRequest":{"times":[2.8254309999974794]},"storeCapsule":{"times":[0.6756630000018049,0.28560300000026473,0.32300499999837484]},"deleteCapsule":{"times":[0.3057040000021516]},"bulkRetrieveLogs":{"times":[1.341694999999163]},"validateEnqueuedNotesAndEvents":{"times":[61.99910199999795]},"getNotes":{"times":[5.3836020000017015]},"getAuthWitness":{"times":[0.15513300000020536]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.056764999997540144]},"callPrivateFunction":{"times":[1104.8081409999977,206.1833970000007]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10012799999822164]}}},{"functionName":"private_kernel_init","time":62.060026000002836},{"functionName":"ContractClassRegisterer:register","time":1089.761931000001,"oracles":{"loadCapsule":{"times":[4.001634000000195]},"notifyCreatedNullifier":{"times":[1.0889349999997648]},"debugLog":{"times":[0.26492100000177743]},"notifyCreatedContractClassLog":{"times":[4.232671999998274]}}},{"functionName":"private_kernel_inner","time":128.6725400000032},{"functionName":"ContractInstanceDeployer:deploy","time":89.5089780000053,"oracles":{"storeInExecutionCache":{"times":[0.17088399999920512]},"callPrivateFunction":{"times":[125.66941399999996]},"notifyCreatedNullifier":{"times":[0.31091400000150315]},"debugLog":{"times":[0.16871399999945424]}}},{"functionName":"private_kernel_inner","time":127.69926299999861},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":107.84835699999894,"oracles":{}},{"functionName":"private_kernel_inner","time":120.8149940000003},{"functionName":"private_kernel_reset","time":210.85687399999733},{"functionName":"private_kernel_tail","time":104.6836289999992}],"unaccounted":360.35693699999683}} 12:00:13 [12:00:13.751] INFO: node Received tx 0x2797d6fed222093ee513058aa3221a59d4eeb12f642c42009cb3f3cc234a8318 {"txHash":"0x2797d6fed222093ee513058aa3221a59d4eeb12f642c42009cb3f3cc234a8318"} 12:00:13 [12:00:13.752] INFO: pxe:service Sent transaction 0x2797d6fed222093ee513058aa3221a59d4eeb12f642c42009cb3f3cc234a8318 12:00:13 [12:00:13.801] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.8118439849999994s {"duration":2.8118439849999994,"rate":112542.51718379036,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 12:00:13 [12:00:13.845] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 107946.7072620039 mana/s {"blockHash":"0x0feef42aa7d7cd48bd149872dd7e19d12538593a60c871ad49eadd0866894241","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750939604,"version":2896790463},"txHashes":["0x11cf030c4da44d9fcd3900eb0add39b2374a7f4f663abae0992548ab420e9fd7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2931.4798059999994,"publicProcessDuration":2812.0378999999994,"rollupCircuitsDuration":2920.414947999998,"txCount":1,"blockNumber":4,"blockTimestamp":1750939604,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 12:00:14 [12:00:14.112] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:14 [12:00:14.125] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:14 [12:00:14.125] WARN: foundation:test-date-provider Time set to 2025-06-26T12:06:56.000Z {"offset":401875,"timeMs":1750939616000} 12:00:14 [12:00:14.182] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939640 12:00:14 [12:00:14.182] WARN: foundation:test-date-provider Time set to 2025-06-26T12:07:20.000Z {"offset":425818,"timeMs":1750939640000} 12:00:14 [12:00:14.182] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 12:00:14 [12:00:14.304] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 12:00:14 [12:00:14.314] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 12:00:14 [12:00:14.352] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0feef42aa7d7cd48bd149872dd7e19d12538593a60c871ad49eadd0866894241","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750939604,"version":2896790463},"archiveRoot":"0x0e8221afb97da1ae69fb499b7e7ed0594279b08f66736c4fecceac36d4a82896","archiveNextLeafIndex":5} 12:00:14 [12:00:14.701] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.068783999999141,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750939604,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 12:00:14 [12:00:14.928] INFO: aztecjs:deploy_sent_tx Contract 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 successfully deployed. 12:00:15 [12:00:14.977] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 12:00:15 [12:00:15.318] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.16517958200000066s {"duration":0.16517958200000066,"rate":240895.39105384005,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 12:00:15 [12:00:15.356] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 189549.9214738067 mana/s {"blockHash":"0x0c54c6bd72f227a78dfb9ede628d0fd24fc9f07aa8384ea3e5ec23c8de152368","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750939640,"version":2896790463},"txHashes":["0x2797d6fed222093ee513058aa3221a59d4eeb12f642c42009cb3f3cc234a8318"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":209.88967799999955,"publicProcessDuration":165.9118500000004,"rollupCircuitsDuration":205.34707200000048,"txCount":1,"blockNumber":5,"blockTimestamp":1750939640,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 12:00:15 [12:00:15.572] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:15 [12:00:15.581] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939676 12:00:15 [12:00:15.581] WARN: foundation:test-date-provider Time set to 2025-06-26T12:07:56.000Z {"offset":460419,"timeMs":1750939676000} 12:00:15 [12:00:15.581] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 12:00:15 [12:00:15.759] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 12:00:15 [12:00:15.761] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 12:00:16 [12:00:16.141] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0c54c6bd72f227a78dfb9ede628d0fd24fc9f07aa8384ea3e5ec23c8de152368","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750939640,"version":2896790463},"archiveRoot":"0x254540dec7f2f7aabd24237eb574b938a7f4f5c320f551ea11d6673d53bfcdb2","archiveNextLeafIndex":6} 12:00:16 [12:00:16.143] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 12:00:16 [12:00:16.221] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":6.790092000002915,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750939640,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 12:00:16 BananaCoin: 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 12:00:16 FPC: 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 12:00:17 [12:00:16.976] INFO: aztecjs:deploy_sent_tx Contract 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 successfully deployed. 12:00:17 [12:00:17.010] WARN: pxe:service No artifact found for contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 when looking for its metadata 12:00:17 [12:00:17.011] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 as part of deployment for 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 12:00:17 [12:00:17.179] INFO: pxe:service Added contract SponsoredFPC at 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 with class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 12:00:20 [12:00:19.682] INFO: pxe:service Proving completed in 2489.5860260000045ms {"timings":{"total":2489.5860260000045,"sync":17.77044300000125,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":78.96296399999119,"oracles":{"callPrivateFunction":{"times":[1074.6429060000046,153.56035100000008,29.15760600000067]}}},{"functionName":"private_kernel_init","time":57.08103599999595},{"functionName":"ContractClassRegisterer:register","time":1057.9766989999953,"oracles":{"loadCapsule":{"times":[2.050581000003149]},"notifyCreatedNullifier":{"times":[0.9501840000011725]},"debugLog":{"times":[0.14769199999864213]},"notifyCreatedContractClassLog":{"times":[3.1544470000008005]}}},{"functionName":"private_kernel_inner","time":110.02749700000277},{"functionName":"ContractInstanceDeployer:deploy","time":99.3184459999975,"oracles":{"storeInExecutionCache":{"times":[0.08272700000088662]},"callPrivateFunction":{"times":[64.88740800000232]},"notifyCreatedNullifier":{"times":[0.5321320000002743]},"debugLog":{"times":[0.2511099999974249]}}},{"functionName":"private_kernel_inner","time":148.2806969999947},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":37.01793300001009,"oracles":{}},{"functionName":"private_kernel_inner","time":112.49392100000114},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":23.50597199999902,"oracles":{"debugLog":{"times":[0.1676930000030552]}}},{"functionName":"private_kernel_inner","time":123.8520720000015},{"functionName":"private_kernel_reset","time":196.6801919999998},{"functionName":"private_kernel_tail","time":87.75828100000217}],"unaccounted":338.85987300001216}} 12:00:20 [12:00:19.791] INFO: node Received tx 0x2b95c577288218e817b9f2f59209f14f069a932955fddd3d592d9d301e31adab {"txHash":"0x2b95c577288218e817b9f2f59209f14f069a932955fddd3d592d9d301e31adab"} 12:00:20 [12:00:19.791] INFO: pxe:service Sent transaction 0x2b95c577288218e817b9f2f59209f14f069a932955fddd3d592d9d301e31adab 12:00:20 [12:00:19.846] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.036135843999996725s {"duration":0.036135843999996725,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 12:00:20 [12:00:19.887] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x10ada5c1fe29aeb1951d807fa245bbef2d610cbda8b3bfbc970a6fdb999374fd","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750939676,"version":2896790463},"txHashes":["0x2b95c577288218e817b9f2f59209f14f069a932955fddd3d592d9d301e31adab"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":84.07542300000205,"publicProcessDuration":36.42563599999994,"rollupCircuitsDuration":79.2709360000008,"txCount":1,"blockNumber":6,"blockTimestamp":1750939676,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:00:20 [12:00:20.107] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:20 [12:00:20.113] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:20 [12:00:20.113] WARN: foundation:test-date-provider Time set to 2025-06-26T12:08:08.000Z {"offset":467887,"timeMs":1750939688000} 12:00:20 [12:00:20.128] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 12:00:20 [12:00:20.129] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 12:00:20 [12:00:20.196] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939712 12:00:20 [12:00:20.196] WARN: foundation:test-date-provider Time set to 2025-06-26T12:08:32.000Z {"offset":491804,"timeMs":1750939712000} 12:00:20 [12:00:20.196] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 12:00:20 [12:00:20.363] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x10ada5c1fe29aeb1951d807fa245bbef2d610cbda8b3bfbc970a6fdb999374fd","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750939676,"version":2896790463},"archiveRoot":"0x074aedf279038c33a38cc35c43d1766b3e376e2f8a4cb5e71cd2c5ce3e0c5c14","archiveNextLeafIndex":7} 12:00:20 [12:00:20.372] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 12:00:20 SponsoredFPC: 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 12:00:20 [12:00:20.728] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":7.778140000002168,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750939676,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:00:20 [12:00:20.806] INFO: aztecjs:deploy_sent_tx Contract 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 successfully deployed. 12:00:20 [12:00:20.814] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x1a5079b513266d78cf61cc98914d568e800982d8b2b9fe79c90f47ce27ffa2ec","l2ProtocolContractsTreeRoot":"0x00d0980697e140a074810b2bee11c5042763b87e95bfdbf2f28269c79e6abad6"} 12:00:23 Registering protocol contract aliases... 12:00:23 Data stored in database with alias contracts:AuthRegistry 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000001 12:00:23 Data stored in database with alias contracts:ContractInstanceDeployer 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000002 12:00:23 Data stored in database with alias contracts:ContractClassRegisterer 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000003 12:00:23 Data stored in database with alias contracts:MultiCallEntrypoint 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000004 12:00:23 Data stored in database with alias contracts:FeeJuice 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000005 12:00:23 Data stored in database with alias contracts:Router 12:00:23 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000006 12:00:23 [12:00:23.474] INFO: wallet Using local PXE service 12:00:23 [12:00:23.477] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:00:23 [12:00:23.659] 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) 12:00:23 [12:00:23.663] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:00:24 Account stored in database with aliases last & test0 12:00:24 12:00:24 Test account: 12:00:24 Alias: test0 12:00:24 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:00:24 Secret key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 12:00:24 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 12:00:24 Account stored in database with aliases last & test1 12:00:24 12:00:24 Test account: 12:00:24 Alias: test1 12:00:24 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 12:00:24 Secret key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 12:00:24 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 12:00:24 Account stored in database with aliases last & test2 12:00:24 12:00:24 Test account: 12:00:24 Alias: test2 12:00:24 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 12:00:24 Secret key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 12:00:24 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 12:00:24 12:00:24 3 test accounts imported to wallet db. 12:00:24 12:00:25 [12:00:24.396] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:00:25 [12:00:24.766] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:25 [12:00:24.770] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:25 [12:00:24.784] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:25 [12:00:24.908] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:00:25 [12:00:24.912] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 12:00:25 [12:00:24.915] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 12:00:28 [12:00:28.642] INFO: wallet Using local PXE service 12:00:28 [12:00:28.644] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:00:28 [12:00:28.713] 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) 12:00:28 [12:00:28.717] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:00:29 12:00:29 New account: 12:00:29 12:00:29 Address: 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe 12:00:29 Public key: 0x1df43a58f69a80c0056f2a44b3d2b7d268202631207630333bf5af05fc315cd024708600a92589eaa7ae71c920d6af51e59a5699caf8ab3233f697fd3f836ab52e5e6b795ef5f9fff1fe4679155e792d3b0326264ab2f8372beae5b62c24cea628c894db24fcba4283279992d5ebf22760c92d0ec9f788a17bd63d4671df79f62f2896dcf29aaa56fa3bdfc6a9b65705d974b28df1fb831b4a6ac3c0b53f483814f31c06f15ec1d90d24d735d600360a14714a41a2f4aa987c8a4ce0e2f8eace025bc3366e69c2be4c4ce50ae40e5db8e265912d01f86dbac6ae78a5acbc2f38133049fa59f85d581de0157d8ad456983cfa012afa6a9830f73f9be812e92fd5 12:00:29 Secret key: 0x1df5a2707a465c88f53767bd958335195a35beb0a84626d47a566500ac2c6e00 12:00:29 Partial address: 0x06a00efcbd638a77663ef6f8e46cc236ddef90cfd8a04fcffe28b40656f6c499 12:00:29 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 12:00:29 Init hash: 0x162951460ae52387dd76fc8b6997b3a8458298f2b2b3a79ff90408b1743cf4b7 12:00:29 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 12:00:29 Account stored in database with aliases last & main 12:00:29 [12:00:29.490] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:00:29 [12:00:29.668] INFO: pxe:service Added contract SchnorrAccount at 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:00:29 [12:00:29.730] INFO: pxe:service Registered account 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe 12:00:33 [12:00:33.447] INFO: wallet Using local PXE service 12:00:33 [12:00:33.448] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:00:33 [12:00:33.943] 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) 12:00:33 [12:00:33.947] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:00:34 [12:00:34.711] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:00:34 [12:00:34.906] INFO: wallet Minting 1000000000000000000 tokens for 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:00:34 [12:00:34.936] INFO: wallet Approving 1000000000000000000 tokens for FeeJuice Portal (0x0e45141fc552dc4f804cd96d93a95eead8ae3957) 12:00:34 [12:00:34.975] INFO: wallet Sending L1 Fee Juice to L2 to be claimed publicly 12:00:35 Minted 1000000000000000000 fee juice on L1 and pushed to L2 portal 12:00:35 claimAmount=1000000000000000000,claimSecret=0x0a3d72c1a2f1c3576fc3702edcb735887b9c1a13a2cbded1651b192dd1167eb2,messageHash=0x0086907f35fcf8efa75bb8579511f45908ac27a6632278737fa24dd705827a06,messageLeafIndex=112 12:00:35 12:00:35 Note: You need to wait for two L2 blocks before pulling them from the L2 side 12:00:35 Pushed 1000000000000000000 fee juice for recipient 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe. Stack pointer 1 12:00:35 [12:00:35.003] INFO: wallet Deposited to Aztec public successfully 12:00:35 [12:00:34.960] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:35 [12:00:34.961] WARN: foundation:test-date-provider Time set to 2025-06-26T12:08:56.000Z {"offset":501039,"timeMs":1750939736000} 12:00:35 [12:00:35.093] INFO: archiver Retrieved 1 new L1 to L2 messages up to message with index 112 for L2 block 8 {"lastMessage":{"index":112,"l1BlockHash":"0xb34fcdcbbb49f6438e240b2e12eeea95a390af6e59e93f7b2494bd1d9ef4eecb","l1BlockNumber":41,"l2BlockNumber":8,"leaf":"0x0086907f35fcf8efa75bb8579511f45908ac27a6632278737fa24dd705827a06","rollingHash":"0xcca594b27fa4543ccf87f07533f9ba97"},"messageCount":1} 12:00:35 [12:00:35.163] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:35 [12:00:35.163] WARN: foundation:test-date-provider Time set to 2025-06-26T12:09:08.000Z {"offset":512837,"timeMs":1750939748000} 12:00:41 [12:00:41.768] INFO: wallet Using local PXE service 12:00:41 [12:00:41.769] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:00:41 [12:00:41.831] 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) 12:00:41 [12:00:41.835] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:00:42 [12:00:42.589] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:00:42 [12:00:42.654] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:00:43 [12:00:43.255] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 12:00:44 [12:00:43.768] INFO: pxe:service Added contract Token at 0x0431bca9fac933f9341c9b872231b3dcf38d1b221b5bb031e6f795d51ca4e049 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 12:00:46 [12:00:46.178] INFO: pxe:service Proving completed in 2395.030932ms {"timings":{"total":2395.030932,"sync":352.7241949999993,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":761.3105479999995,"oracles":{"debugLog":{"times":[0.7318189999996321,0.23040900000069087,0.3515480000005482,1.373490999999376,0.36328899999989517,0.2201279999999315,0.3851910000003045,0.3855119999998351]},"fetchTaggedLogs":{"times":[344.7102339999992]},"loadCapsule":{"times":[0.7172579999996742,0.504081000000042,0.5058009999993374,0.9600090000003547,0.49248999999963416,0.8258169999999154,0.39428200000020297,0.3688700000002427,0.9530070000000705,0.491729999999734]},"getSharedSecret":{"times":[15.380309000000125]},"aes128Decrypt":{"times":[2.6233030000003055,1.5175429999999324]},"getPublicKeysAndPartialAddress":{"times":[8.477858999999626]},"getKeyValidationRequest":{"times":[12.76572699999997]},"storeCapsule":{"times":[4.243723999999929,2.7596340000000055,3.799019000000044]},"deleteCapsule":{"times":[3.9106580000006943]},"bulkRetrieveLogs":{"times":[7.498018999999658]},"validateEnqueuedNotesAndEvents":{"times":[32.45520699999997]},"getNotes":{"times":[7.388269999999466]},"getAuthWitness":{"times":[0.5290519999998651]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6104789999999412]},"callPrivateFunction":{"times":[164.5184360000003]},"notifyEnqueuedPublicFunctionCall":{"times":[0.21896800000013172]}}},{"functionName":"private_kernel_init","time":110.47428499999933},{"functionName":"ContractInstanceDeployer:deploy","time":77.17385999999897,"oracles":{"storeInExecutionCache":{"times":[0.28137299999980314]},"callPrivateFunction":{"times":[94.45981399999982]},"notifyCreatedNullifier":{"times":[0.5040210000006482]},"debugLog":{"times":[0.37650099999973463]}}},{"functionName":"private_kernel_inner","time":147.43378800000028},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":73.93662700000004,"oracles":{}},{"functionName":"private_kernel_inner","time":123.09187999999995},{"functionName":"private_kernel_reset","time":217.1415109999998},{"functionName":"private_kernel_tail","time":120.57906600000024}],"unaccounted":411.1651720000027}} 12:00:46 [12:00:46.264] INFO: pxe:service Sent transaction 0x2a2179df7fad6f42cbb19c3f174fb97ac230e9dfba9d4b74564bcdc3464fb193 12:00:47 [12:00:46.262] INFO: node Received tx 0x2a2179df7fad6f42cbb19c3f174fb97ac230e9dfba9d4b74564bcdc3464fb193 {"txHash":"0x2a2179df7fad6f42cbb19c3f174fb97ac230e9dfba9d4b74564bcdc3464fb193"} 12:00:47 [12:00:46.895] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2180737369999988s {"duration":0.2180737369999988,"rate":1451123.846242896,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 12:00:47 [12:00:46.924] INFO: sequencer Built block 7 for slot 9 with 1 txs and 0 messages. 1201374.6722055953 mana/s {"blockHash":"0x0819a73f0a3eb394363da369e21408bef6f56c03384a012b72f2f2afb7c4a5ba","globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750939748,"version":2896790463},"txHashes":["0x2a2179df7fad6f42cbb19c3f174fb97ac230e9dfba9d4b74564bcdc3464fb193"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":263.29239000000234,"publicProcessDuration":218.18483500000002,"rollupCircuitsDuration":253.86410400000022,"txCount":1,"blockNumber":7,"blockTimestamp":1750939748,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:47 [12:00:47.141] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:47 [12:00:47.161] WARN: archiver Failed to reach L2 block 7 at 41 (latest is 6). Rolling back last synched L1 block number to 37. {"latestLocalL2BlockNumber":6,"latestLocalL2BlockArchive":"0x074aedf279038c33a38cc35c43d1766b3e376e2f8a4cb5e71cd2c5ce3e0c5c14","blocksSynchedTo":37,"currentL1BlockNumber":41,"provenBlockNumber":6,"provenArchive":"0x074aedf279038c33a38cc35c43d1766b3e376e2f8a4cb5e71cd2c5ce3e0c5c14","pendingBlockNumber":7,"pendingArchive":"0x265f23a2a75f5ec98a3326f32e2bc47fd10531fd9102ef7678c35be2ebba5118"} 12:00:47 [12:00:47.195] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939784 12:00:47 [12:00:47.195] WARN: foundation:test-date-provider Time set to 2025-06-26T12:09:44.000Z {"offset":536805,"timeMs":1750939784000} 12:00:47 [12:00:47.195] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 12:00:47 [12:00:47.332] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 12:00:47 [12:00:47.334] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 12:00:47 [12:00:47.715] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x0819a73f0a3eb394363da369e21408bef6f56c03384a012b72f2f2afb7c4a5ba","blockNumber":7,"txCount":1,"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750939748,"version":2896790463},"archiveRoot":"0x265f23a2a75f5ec98a3326f32e2bc47fd10531fd9102ef7678c35be2ebba5118","archiveNextLeafIndex":8} 12:00:47 [12:00:47.718] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 12:00:48 [12:00:47.979] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":18.825950000005832,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750939748,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:48 Contract deployed at 0x0431bca9fac933f9341c9b872231b3dcf38d1b221b5bb031e6f795d51ca4e049 12:00:48 Contract partial address 0x1eb2eb6d3285b20f93f746211178bb234f06660acaa7396cf1617ddc4e05c6cc 12:00:48 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 12:00:48 Deployment tx hash: 0x2a2179df7fad6f42cbb19c3f174fb97ac230e9dfba9d4b74564bcdc3464fb193 12:00:48 Deployment salt: 0x1c1fb0d6cb6d5cd60f1df26008f6abe8ca8bffb50bd4e3cc44dfcfc5abba3581 12:00:48 Deployment fee: 11008681920 12:00:48 Contract stored in database with alias last 12:00:52 [12:00:52.739] INFO: wallet Using local PXE service 12:00:52 [12:00:52.740] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:00:52 [12:00:52.803] 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) 12:00:52 [12:00:52.808] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:00:53 [12:00:53.561] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:00:53 [12:00:53.660] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:00:56 [12:00:55.050] INFO: pxe:service Added contract Token at 0x0abed2b64eb80b0ec030c81357f6bf9723431bedb6d86c2becb1c3a2e03a95a9 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 12:00:58 [12:00:57.318] INFO: node Received tx 0x21a945b534f6558f992160093488b9639952fcfc7cbb91ba2a23f456cf93fd8e {"txHash":"0x21a945b534f6558f992160093488b9639952fcfc7cbb91ba2a23f456cf93fd8e"} 12:00:58 [12:00:57.750] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24393775699999243s {"duration":0.24393775699999243,"rate":1297265.351177308,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 12:00:58 [12:00:57.782] INFO: sequencer Built block 8 for slot 10 with 1 txs and 1 messages. 1090229.6052446777 mana/s {"blockHash":"0x236d7f31329777eeec50803cd0ce72ece6f4477d3e15e98741f2fd20b68d7bbb","globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750939784,"version":2896790463},"txHashes":["0x21a945b534f6558f992160093488b9639952fcfc7cbb91ba2a23f456cf93fd8e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":290.1784570000018,"publicProcessDuration":244.05762599999434,"rollupCircuitsDuration":283.6863230000017,"txCount":1,"blockNumber":8,"blockTimestamp":1750939784,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:58 [12:00:58.007] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:00:58 [12:00:58.011] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:00:58 [12:00:58.011] WARN: foundation:test-date-provider Time set to 2025-06-26T12:09:56.000Z {"offset":537989,"timeMs":1750939796000} 12:00:58 [12:00:58.014] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939820 12:00:58 [12:00:58.014] WARN: foundation:test-date-provider Time set to 2025-06-26T12:10:20.000Z {"offset":561986,"timeMs":1750939820000} 12:00:58 [12:00:58.014] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 12:00:58 [12:00:58.074] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x236d7f31329777eeec50803cd0ce72ece6f4477d3e15e98741f2fd20b68d7bbb","blockNumber":8,"txCount":1,"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32380,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750939784,"version":2896790463},"archiveRoot":"0x2be96d5975eb1113327f3cf4f7d9e3556e7d6cfcd2569dd9a858c7683220c200","archiveNextLeafIndex":9} 12:00:58 [12:00:57.196] INFO: pxe:service Proving completed in 2133.6138520000004ms {"timings":{"total":2133.6138520000004,"sync":67.49113399999987,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":652.1407720000007,"oracles":{"debugLog":{"times":[0.8388749999994616,0.2678809999997611,0.16162199999962468,0.2833920000002763,0.18199400000048627,0.16532399999960035,0.19603600000027654,1.4262009999993097]},"fetchTaggedLogs":{"times":[296.4255640000001]},"loadCapsule":{"times":[0.6095869999999195,0.3470969999998488,0.7527989999998681,0.4709160000002157,0.3435170000002472,0.33577599999989616,0.2819019999997181,0.29396300000007614,0.4084919999995691,0.28147099999932834]},"getSharedSecret":{"times":[10.633020999999644]},"aes128Decrypt":{"times":[1.6061460000000807,0.878219000000172]},"getPublicKeysAndPartialAddress":{"times":[2.5202879999997094]},"getKeyValidationRequest":{"times":[3.8881140000003143]},"storeCapsule":{"times":[3.0170259999995324,2.671578999999838,2.933208999999806]},"deleteCapsule":{"times":[3.0878109999994194]},"bulkRetrieveLogs":{"times":[7.012628000000404]},"validateEnqueuedNotesAndEvents":{"times":[22.09172699999999]},"getNotes":{"times":[5.18208500000037]},"getAuthWitness":{"times":[0.2824909999999363]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5352020000000266]},"callPrivateFunction":{"times":[145.24665100000038]},"notifyEnqueuedPublicFunctionCall":{"times":[0.39663999999993393]}}},{"functionName":"private_kernel_init","time":130.69310300000052},{"functionName":"ContractInstanceDeployer:deploy","time":73.0618999999997,"oracles":{"storeInExecutionCache":{"times":[0.2392390000004525]},"callPrivateFunction":{"times":[74.85226899999998]},"notifyCreatedNullifier":{"times":[0.6714819999997417]},"debugLog":{"times":[0.45950599999923725]}}},{"functionName":"private_kernel_inner","time":197.05976900000041},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":56.51751599999989,"oracles":{}},{"functionName":"private_kernel_inner","time":153.81957499999953},{"functionName":"private_kernel_reset","time":267.9320660000003},{"functionName":"private_kernel_tail","time":106.2464689999997}],"unaccounted":428.6515479999998}} 12:00:58 [12:00:57.320] INFO: pxe:service Sent transaction 0x21a945b534f6558f992160093488b9639952fcfc7cbb91ba2a23f456cf93fd8e 12:00:58 [12:00:58.198] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 12:00:58 [12:00:58.201] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 12:00:58 [12:00:58.355] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":7.535427000009804,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750939784,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:00:58 [12:00:58.598] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 12:00:58 Contract deployed at 0x0abed2b64eb80b0ec030c81357f6bf9723431bedb6d86c2becb1c3a2e03a95a9 12:00:58 Contract partial address 0x04fe672a71133457a5bc5a25efa9d73c21156412bdc43073d2ac80ea62244d65 12:00:58 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 12:00:58 Deployment tx hash: 0x21a945b534f6558f992160093488b9639952fcfc7cbb91ba2a23f456cf93fd8e 12:00:58 Deployment salt: 0x20fb70da904a081226b9bb16e26604e50c8e312174bfe3fde29308dd045d38e1 12:00:58 Deployment fee: 11008681920 12:00:58 Contract stored in database with alias last 12:01:02 [12:01:02.555] INFO: wallet Using local PXE service 12:01:02 [12:01:02.557] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:01:02 [12:01:02.669] 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) 12:01:02 [12:01:02.685] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:01:03 [12:01:03.397] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:01:03 [12:01:03.484] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 12:01:04 [12:01:04.736] INFO: pxe:service Added contract Token at 0x1cc9ba96d9f49f7120dfa2164a8402d989ecd3fe4d78f5393878a4c4a6e5ddfa with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 12:01:06 [12:01:06.640] INFO: pxe:service Proving completed in 1891.0475199999996ms {"timings":{"total":1891.0475199999996,"sync":74.32190200000014,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":627.3745040000013,"oracles":{"debugLog":{"times":[0.7514200000005076,0.18086399999992864,0.1269300000003568,0.1934449999998833,0.23986899999999878,0.18095399999947404,0.15349199999945995,0.30513500000051863]},"fetchTaggedLogs":{"times":[322.5176960000008]},"loadCapsule":{"times":[0.42558400000052643,0.253179999999702,0.4348039999995308,0.31256500000017695,0.339907000000494,0.294304000000011,0.2305690000002869,0.3254059999999299,1.7233960000003208,0.32341600000017934]},"getSharedSecret":{"times":[4.631276000000071]},"aes128Decrypt":{"times":[0.8946310000001176,0.7925129999994169]},"getPublicKeysAndPartialAddress":{"times":[6.606133000000227]},"getKeyValidationRequest":{"times":[5.011656000000585]},"storeCapsule":{"times":[3.1606599999995524,1.877198999999564,2.7442980000005264]},"deleteCapsule":{"times":[3.321313000000373]},"bulkRetrieveLogs":{"times":[7.147015000000465]},"validateEnqueuedNotesAndEvents":{"times":[18.978391999999985]},"getNotes":{"times":[4.3908369999999195]},"getAuthWitness":{"times":[0.37011899999924935]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.44015500000023167]},"callPrivateFunction":{"times":[146.86979400000018]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2391990000005535]}}},{"functionName":"private_kernel_init","time":97.06529299999966},{"functionName":"ContractInstanceDeployer:deploy","time":82.60219700000016,"oracles":{"storeInExecutionCache":{"times":[0.37570899999991525]},"callPrivateFunction":{"times":[76.99466399999983]},"notifyCreatedNullifier":{"times":[0.44084399999974266]},"debugLog":{"times":[0.24708900000041467]}}},{"functionName":"private_kernel_inner","time":146.49000400000023},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":55.1361339999994,"oracles":{}},{"functionName":"private_kernel_inner","time":120.81805299999996},{"functionName":"private_kernel_reset","time":224.14482100000077},{"functionName":"private_kernel_tail","time":87.30048899999929}],"unaccounted":375.79412299999876}} 12:01:06 [12:01:06.740] INFO: pxe:service Sent transaction 0x013e1cc78b955feb804750fade183255d018745682ef15a0adbbb5821837facf 12:01:07 [12:01:06.738] INFO: node Received tx 0x013e1cc78b955feb804750fade183255d018745682ef15a0adbbb5821837facf {"txHash":"0x013e1cc78b955feb804750fade183255d018745682ef15a0adbbb5821837facf"} 12:01:07 [12:01:06.957] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1853795919999975s {"duration":0.1853795919999975,"rate":1707048.7456893541,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 12:01:07 [12:01:06.987] INFO: sequencer Built block 9 for slot 11 with 1 txs and 0 messages. 1418881.970041517 mana/s {"blockHash":"0x1e1f27bc938d23b05cc3f07f803883bca84133bf6e815cec6bdb42dcd8ba1f3a","globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750939820,"version":2896790463},"txHashes":["0x013e1cc78b955feb804750fade183255d018745682ef15a0adbbb5821837facf"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":222.9531960000022,"publicProcessDuration":185.51303199998802,"rollupCircuitsDuration":217.40783699999156,"txCount":1,"blockNumber":9,"blockTimestamp":1750939820,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:01:07 [12:01:07.164] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:01:07 [12:01:07.189] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939856 12:01:07 [12:01:07.189] WARN: foundation:test-date-provider Time set to 2025-06-26T12:10:56.000Z {"offset":588811,"timeMs":1750939856000} 12:01:07 [12:01:07.189] INFO: aztecjs:utils:watcher Slot 11 was filled, jumped to next slot 12:01:07 [12:01:07.365] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 12:01:07 [12:01:07.366] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 12:01:07 [12:01:07.369] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x1e1f27bc938d23b05cc3f07f803883bca84133bf6e815cec6bdb42dcd8ba1f3a","blockNumber":9,"txCount":1,"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750939820,"version":2896790463},"archiveRoot":"0x0d20a8a6cac77f8e364653dc0f53b0f8d2bbc25958a489dffd62a4caf7e27e92","archiveNextLeafIndex":10} 12:01:07 [12:01:07.428] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":6.433179999992717,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750939820,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:01:07 [12:01:07.879] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 12:01:07 Contract deployed at 0x1cc9ba96d9f49f7120dfa2164a8402d989ecd3fe4d78f5393878a4c4a6e5ddfa 12:01:07 Contract partial address 0x201d801dd25f95c067e645fbf57ed9af313bee658bb62c9989e3924ad369816d 12:01:07 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 12:01:07 Deployment tx hash: 0x013e1cc78b955feb804750fade183255d018745682ef15a0adbbb5821837facf 12:01:07 Deployment salt: 0x2871a6284f58ffb60297137cc5c1d7d36f0a41950ebd770284fca9d7933333bc 12:01:07 Deployment fee: 982553760 12:01:08 Contract stored in database with alias last 12:01:12 [12:01:12.324] INFO: wallet Using local PXE service 12:01:12 [12:01:12.326] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:01:12 [12:01:12.385] 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) 12:01:12 [12:01:12.389] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:01:13 12:01:13 New account: 12:01:13 12:01:13 Address: 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe 12:01:13 Public key: 0x1df43a58f69a80c0056f2a44b3d2b7d268202631207630333bf5af05fc315cd024708600a92589eaa7ae71c920d6af51e59a5699caf8ab3233f697fd3f836ab52e5e6b795ef5f9fff1fe4679155e792d3b0326264ab2f8372beae5b62c24cea628c894db24fcba4283279992d5ebf22760c92d0ec9f788a17bd63d4671df79f62f2896dcf29aaa56fa3bdfc6a9b65705d974b28df1fb831b4a6ac3c0b53f483814f31c06f15ec1d90d24d735d600360a14714a41a2f4aa987c8a4ce0e2f8eace025bc3366e69c2be4c4ce50ae40e5db8e265912d01f86dbac6ae78a5acbc2f38133049fa59f85d581de0157d8ad456983cfa012afa6a9830f73f9be812e92fd5 12:01:13 Secret key: 0x1df5a2707a465c88f53767bd958335195a35beb0a84626d47a566500ac2c6e00 12:01:13 Partial address: 0x06a00efcbd638a77663ef6f8e46cc236ddef90cfd8a04fcffe28b40656f6c499 12:01:13 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 12:01:13 Init hash: 0x162951460ae52387dd76fc8b6997b3a8458298f2b2b3a79ff90408b1743cf4b7 12:01:13 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 12:01:13 Retrieved 1000000000000000000 fee juice for recipient 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe. Stack pointer 0 12:01:13 Using Fee Juice for fee payments with claim for 1000000000000000000 tokens 12:01:13 [12:01:13.059] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:01:13 [12:01:13.239] INFO: pxe:service Registered account 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe 12:01:13 [12:01:13.376] INFO: pxe:service Added contract SchnorrAccount at 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 12:01:17 [12:01:17.448] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2985.3222370000003ms 12:01:17 [12:01:17.448] INFO: pxe:bb:native Generating Client IVC proof 12:01:19 [12:01:18.500] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W/ivc-inputs.msgpack 12:01:19 [12:01:18.501] INFO: pxe:bb:native bb - BB concurrency: undefined 12:01:19 [12:01:18.501] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W/ivc-inputs.msgpack -v --scheme client_ivc 12:01:19 [12:01:18.529] INFO: pxe:bb:native bb - bb command: prove (mem: 179.00 MiB) 12:01:19 [12:01:18.529] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 179.00 MiB) 12:01:19 --scheme: client_ivc (mem: 179.00 MiB) 12:01:19 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W (mem: 179.00 MiB) 12:01:19 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W/ivc-inputs.msgpack (mem: 179.00 MiB) 12:01:19 --verbose: true (mem: 179.00 MiB) 12:01:19 [12:01:19.545] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 179.00 MiB) 12:01:19 [12:01:19.545] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 179.00 MiB) 12:01:19 [12:01:19.590] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 179.00 MiB) 12:01:19 [12:01:19.607] INFO: pxe:bb:native bb - ClientIVC: accumulating MultiCallEntrypoint:entrypoint (mem: 179.00 MiB) 12:01:19 Constructing DeciderProvingKey (mem: 179.00 MiB) 12:01:19 [12:01:19.612] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 179.00 MiB) 12:01:19 goblin ecc op : 4/1024 (mem: 179.00 MiB) 12:01:19 busread : 742/6000 (mem: 179.00 MiB) 12:01:19 lookups : 2/15000 (mem: 179.00 MiB) 12:01:19 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 179.00 MiB) 12:01:19 arithmetic : 4296/56000 (mem: 179.00 MiB) 12:01:19 delta range : 2030/18000 (mem: 179.00 MiB) 12:01:19 elliptic : 2/6000 (mem: 179.00 MiB) 12:01:19 auxiliary : 2420/26000 (mem: 179.00 MiB) 12:01:19 poseidon ext : 82/17000 (mem: 179.00 MiB) 12:01:19 poseidon int : 458/92000 (mem: 179.00 MiB) 12:01:19 overflow : 0/0 (mem: 179.00 MiB) 12:01:19 (mem: 179.00 MiB) 12:01:19 Total structured size: 242025 (mem: 179.00 MiB) 12:01:19 [12:01:19.612] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 179.00 MiB) 12:01:19 [12:01:19.751] INFO: pxe:bb:native bb - populating trace... (mem: 429.67 MiB) 12:01:19 [12:01:19.763] INFO: pxe:bb:native bb - time to construct proving key: 155 ms. (mem: 441.67 MiB) 12:01:19 getting honk vk... precomputed?: 0x59ef6cf873c0 (mem: 441.67 MiB) 12:01:19 [12:01:19.763] INFO: pxe:bb:native bb - computing oink proof... (mem: 441.67 MiB) 12:01:19 [12:01:19.763] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 441.67 MiB) 12:01:19 [12:01:19.908] INFO: pxe:bb:native bb - oink proof constructed (mem: 449.67 MiB) 12:01:20 [12:01:20.009] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 452.67 MiB) 12:01:20 [12:01:20.028] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 455.67 MiB) 12:01:20 Constructing DeciderProvingKey (mem: 455.67 MiB) 12:01:20 [12:01:20.033] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 456.67 MiB) 12:01:20 goblin ecc op : 56/1024 (mem: 456.67 12:01:20 [12:01:20.034] INFO: pxe:bb:native bb - MiB) 12:01:20 busread : 2529/6000 (mem: 456.67 MiB) 12:01:20 lookups : 2/15000 (mem: 456.67 MiB) 12:01:20 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 456.67 MiB) 12:01:20 arithmetic : 21160/56000 (mem: 456.67 MiB) 12:01:20 delta range : 3041/18000 (mem: 456.67 MiB) 12:01:20 elliptic : 340/6000 (mem: 456.67 MiB) 12:01:20 auxiliary : 799/26000 (mem: 456.67 MiB) 12:01:20 poseidon ext : 2022/17000 (mem: 456.67 MiB) 12:01:20 poseidon int : 11516/92000 (mem: 456.67 MiB) 12:01:20 overflow : 0/0 (mem: 456.67 MiB) 12:01:20 (mem: 456.67 MiB) 12:01:20 Total structured size: 242025 (mem: 456.67 MiB) 12:01:20 allocating polynomials object in proving key... (mem: 456.67 MiB) 12:01:20 [12:01:20.099] INFO: pxe:bb:native bb - populating trace... (mem: 669.67 MiB) 12:01:20 [12:01:20.130] INFO: pxe:bb:native bb - time to construct proving key: 102 ms. (mem: 683.67 MiB) 12:01:20 getting honk vk... precomputed?: 0x59ef6e615f00 (mem: 683.67 MiB) 12:01:20 computing folding proof (mem: 12:01:20 [12:01:20.130] INFO: pxe:bb:native bb - 683.67 MiB) 12:01:20 [12:01:20.131] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 683.67 MiB) 12:01:20 [12:01:20.351] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 708.67 MiB) 12:01:20 [12:01:20.429] INFO: pxe:bb:native bb - perturbator round (mem: 737.67 MiB) 12:01:20 [12:01:20.475] INFO: pxe:bb:native bb - combiner quotient round (mem: 770.67 MiB) 12:01:20 [12:01:20.576] INFO: pxe:bb:native bb - folded (mem: 770.67 MiB) 12:01:20 constructed folding proof (mem: 770.67 MiB) 12:01:20 [12:01:20.719] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:constructor (mem: 770.67 MiB) 12:01:20 Constructing DeciderProvingKey (mem: 770.67 MiB) 12:01:20 [12:01:20.723] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 770.67 MiB) 12:01:20 goblin ecc op : 4/1024 (mem: 770.67 MiB) 12:01:20 busread : 742/6000 (mem: 770.67 MiB) 12:01:20 lookups : 12218/15000 (mem: 770.67 MiB) 12:01:20 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 770.67 MiB) 12:01:20 [12:01:20.723] INFO: pxe:bb:native bb - arithmetic : 15035/56000 (mem: 770.67 MiB) 12:01:20 delta range : 2476/18000 (mem: 770.67 MiB) 12:01:20 elliptic : 1008/6000 (mem: 770.67 MiB) 12:01:20 auxiliary : 899/26000 (mem: 770.67 MiB) 12:01:20 poseidon ext : 132/17000 (mem: 770.67 MiB) 12:01:20 poseidon int : 743/92000 (mem: 770.67 MiB) 12:01:20 overflow : 0/0 (mem: 770.67 MiB) 12:01:20 (mem: 770.67 MiB) 12:01:20 Total structured size: 242025 (mem: 770.67 MiB) 12:01:20 allocating polynomials object in proving key... (mem: 770.67 MiB) 12:01:20 [12:01:20.764] INFO: pxe:bb:native bb - populating trace... (mem: 770.67 MiB) 12:01:20 [12:01:20.807] INFO: pxe:bb:native bb - time to construct proving key: 87 ms. (mem: 770.67 MiB) 12:01:20 getting honk vk... precomputed?: 0x59ef6cf18f80 (mem: 770.67 MiB) 12:01:20 computing folding proof (mem: 770.67 MiB) 12:01:20 [12:01:20.807] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 770.67 MiB) 12:01:21 [12:01:21.041] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 770.67 MiB) 12:01:21 [12:01:21.117] INFO: pxe:bb:native bb - perturbator round (mem: 770.67 MiB) 12:01:21 [12:01:21.151] INFO: pxe:bb:native bb - combiner quotient round (mem: 770.67 MiB) 12:01:21 [12:01:21.303] INFO: pxe:bb:native bb - folded (mem: 770.67 MiB) 12:01:21 [12:01:21.303] INFO: pxe:bb:native bb - constructed folding proof (mem: 770.67 MiB) 12:01:21 [12:01:21.443] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 770.67 MiB) 12:01:21 [12:01:21.501] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 770.67 MiB) 12:01:21 [12:01:21.542] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 770.67 MiB) 12:01:21 Constructing DeciderProvingKey (mem: 770.67 MiB) 12:01:21 [12:01:21.549] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 770.67 MiB) 12:01:21 goblin ecc op : 792/1024 (mem: 770.67 MiB) 12:01:21 busread : 4184/6000 (mem: 770.67 MiB) 12:01:21 lookups : 2/15000 (mem: 770.67 MiB) 12:01:21 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 770.67 MiB) 12:01:21 arithmetic : 43824/56000 (mem: 12:01:21 [12:01:21.549] INFO: pxe:bb:native bb - 770.67 MiB) 12:01:21 delta range : 5034/18000 (mem: 770.67 MiB) 12:01:21 elliptic : 340/6000 (mem: 770.67 MiB) 12:01:21 auxiliary : 1399/26000 (mem: 770.67 MiB) 12:01:21 poseidon ext : 5682/17000 (mem: 770.67 MiB) 12:01:21 poseidon int : 32378/92000 (mem: 770.67 MiB) 12:01:21 overflow : 0/0 (mem: 770.67 MiB) 12:01:21 (mem: 770.67 MiB) 12:01:21 Total structured size: 242025 (mem: 770.67 MiB) 12:01:21 allocating polynomials object in proving key... (mem: 770.67 MiB) 12:01:21 [12:01:21.599] INFO: pxe:bb:native bb - populating trace... (mem: 770.67 MiB) 12:01:21 [12:01:21.653] INFO: pxe:bb:native bb - time to construct proving key: 110 ms. (mem: 770.67 MiB) 12:01:21 getting honk vk... precomputed?: 0x59ef6e99d0c0 (mem: 770.67 MiB) 12:01:21 [12:01:21.654] INFO: pxe:bb:native bb - computing folding proof (mem: 770.67 MiB) 12:01:21 [12:01:21.654] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 770.67 MiB) 12:01:22 [12:01:21.936] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 770.67 MiB) 12:01:22 [12:01:22.015] INFO: pxe:bb:native bb - perturbator round (mem: 774.01 MiB) 12:01:22 [12:01:22.067] INFO: pxe:bb:native bb - combiner quotient round (mem: 806.01 MiB) 12:01:22 [12:01:22.259] INFO: pxe:bb:native bb - folded (mem: 806.01 MiB) 12:01:22 constructed folding proof (mem: 806.01 MiB) 12:01:22 [12:01:22.411] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 806.01 MiB) 12:01:22 Constructing DeciderProvingKey (mem: 806.01 MiB) 12:01:22 [12:01:22.417] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 806.01 MiB) 12:01:22 goblin ecc op : 4/1024 (mem: 806.01 MiB) 12:01:22 busread : 742/6000 (mem: 806.01 MiB) 12:01:22 lookups : 2076/15000 (mem: 806.01 MiB) 12:01:22 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 806.01 MiB) 12:01:22 arithmetic : 9353/56000 (mem: 806.01 MiB) 12:01:22 delta range : 2977/18000 12:01:22 [12:01:22.417] INFO: pxe:bb:native bb - (mem: 806.01 MiB) 12:01:22 elliptic : 794/6000 (mem: 806.01 MiB) 12:01:22 auxiliary : 4528/26000 (mem: 806.01 MiB) 12:01:22 poseidon ext : 312/17000 (mem: 806.01 MiB) 12:01:22 poseidon int : 1769/92000 (mem: 806.01 MiB) 12:01:22 overflow : 0/0 (mem: 806.01 MiB) 12:01:22 (mem: 806.01 MiB) 12:01:22 Total structured size: 242025 (mem: 806.01 MiB) 12:01:22 allocating polynomials object in proving key... (mem: 806.01 MiB) 12:01:22 [12:01:22.448] INFO: pxe:bb:native bb - populating trace... (mem: 806.01 MiB) 12:01:22 [12:01:22.472] INFO: pxe:bb:native bb - time to construct proving key: 59 ms. (mem: 806.01 MiB) 12:01:22 getting honk vk... precomputed?: 0x59ef6cf48500 (mem: 806.01 MiB) 12:01:22 computing folding proof (mem: 806.01 MiB) 12:01:22 [12:01:22.473] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 806.01 MiB) 12:01:22 [12:01:22.701] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 806.01 MiB) 12:01:22 [12:01:22.799] INFO: pxe:bb:native bb - perturbator round (mem: 806.01 MiB) 12:01:22 [12:01:22.840] INFO: pxe:bb:native bb - combiner quotient round (mem: 806.01 MiB) 12:01:22 [12:01:22.964] INFO: pxe:bb:native bb - folded (mem: 806.01 MiB) 12:01:22 constructed folding proof (mem: 806.01 MiB) 12:01:23 [12:01:23.141] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 806.01 MiB) 12:01:23 [12:01:23.197] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 806.01 MiB) 12:01:23 [12:01:23.243] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 806.01 MiB) 12:01:23 Constructing DeciderProvingKey (mem: 806.01 MiB) 12:01:23 [12:01:23.249] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 806.01 MiB) 12:01:23 goblin ecc op : 792/1024 (mem: 806.01 MiB) 12:01:23 busread : 4184/6000 (mem: 806.01 MiB) 12:01:23 lookups : 2/15000 (mem: 806.01 MiB) 12:01:23 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 806.01 MiB) 12:01:23 arithmetic : 43824/56000 (mem: 806.01 MiB) 12:01:23 delta range : 5034/18000 (mem: 806.01 MiB) 12:01:23 [12:01:23.250] INFO: pxe:bb:native bb - elliptic : 340/6000 (mem: 806.01 MiB) 12:01:23 auxiliary : 1399/26000 (mem: 806.01 MiB) 12:01:23 poseidon ext : 5682/17000 (mem: 806.01 MiB) 12:01:23 poseidon int : 32378/92000 (mem: 806.01 MiB) 12:01:23 overflow : 0/0 (mem: 806.01 MiB) 12:01:23 (mem: 806.01 MiB) 12:01:23 Total structured size: 242025 (mem: 806.01 MiB) 12:01:23 allocating polynomials object in proving key... (mem: 806.01 MiB) 12:01:23 [12:01:23.307] INFO: pxe:bb:native bb - populating trace... (mem: 806.01 MiB) 12:01:23 [12:01:23.342] INFO: pxe:bb:native bb - time to construct proving key: 98 ms. (mem: 806.01 MiB) 12:01:23 getting honk vk... precomputed?: 0x59ef6d0e8a80 (mem: 806.01 MiB) 12:01:23 computing folding proof (mem: 806.01 MiB) 12:01:23 [12:01:23.342] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 806.01 MiB) 12:01:23 [12:01:23.651] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 806.01 MiB) 12:01:23 [12:01:23.731] INFO: pxe:bb:native bb - perturbator round (mem: 806.01 MiB) 12:01:23 [12:01:23.802] INFO: pxe:bb:native bb - combiner quotient round (mem: 808.27 MiB) 12:01:23 [12:01:23.901] INFO: pxe:bb:native bb - folded (mem: 808.27 MiB) 12:01:23 constructed folding proof (mem: 808.27 MiB) 12:01:24 [12:01:24.059] INFO: pxe:bb:native bb - ClientIVC: accumulating FeeJuice:claim (mem: 808.27 MiB) 12:01:24 Constructing DeciderProvingKey (mem: 808.27 MiB) 12:01:24 [12:01:24.062] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 808.27 MiB) 12:01:24 goblin ecc op : 4/1024 (mem: 808.27 MiB) 12:01:24 busread : 742/6000 (mem: 808.27 MiB) 12:01:24 lookups : 17378/15000 (mem: 808.27 MiB) 12:01:24 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 808.27 MiB) 12:01:24 arithmetic : 13735/56000 (mem: 808.27 MiB) 12:01:24 delta range : 2547/18000 (mem: 808.27 MiB) 12:01:24 elliptic : 2/6000 (mem: 808.27 MiB) 12:01:24 auxiliary : 26/26000 (mem: 808.27 MiB) 12:01:24 [12:01:24.062] INFO: pxe:bb:native bb - poseidon ext : 452/17000 (mem: 808.27 MiB) 12:01:24 poseidon int : 2567/92000 (mem: 808.27 MiB) 12:01:24 overflow : 0/0 (mem: 808.27 MiB) 12:01:24 (mem: 808.27 MiB) 12:01:24 Total structured size: 242025 (mem: 808.27 MiB) 12:01:24 [12:01:24.063] INFO: pxe:bb:native bb - WARNING: Structured trace overflow mechanism in use. Performance may be degraded! (mem: 808.27 MiB) 12:01:24 Gate blocks summary: (actual gates / fixed capacity) (mem: 808.27 MiB) 12:01:24 goblin ecc op : 4/1024 (mem: 808.27 MiB) 12:01:24 busread : 742/6000 (mem: 808.27 MiB) 12:01:24 lookups : 15000/15000 (mem: 808.27 MiB) 12:01:24 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 808.27 MiB) 12:01:24 [12:01:24.063] INFO: pxe:bb:native bb - arithmetic : 13735/56000 (mem: 808.27 MiB) 12:01:24 delta range : 2547/18000 (mem: 808.27 MiB) 12:01:24 elliptic : 2/6000 (mem: 808.27 MiB) 12:01:24 auxiliary : 26/26000 (mem: 808.27 MiB) 12:01:24 poseidon ext : 452/17000 (mem: 808.27 MiB) 12:01:24 poseidon int : 2567/92000 (mem: 808.27 MiB) 12:01:24 overflow : 2379/2379 (mem: 808.27 MiB) 12:01:24 (mem: 808.27 MiB) 12:01:24 Total structured size: 244404 (mem: 808.27 MiB) 12:01:24 allocating polynomials object in proving key... (mem: 808.27 MiB) 12:01:24 [12:01:24.132] INFO: pxe:bb:native bb - populating trace... (mem: 922.37 MiB) 12:01:24 [12:01:24.183] INFO: pxe:bb:native bb - time to construct proving key: 124 ms. (mem: 922.37 MiB) 12:01:24 getting honk vk... precomputed?: 0x59ef6cebfb00 (mem: 922.37 MiB) 12:01:24 computing folding proof (mem: 922.37 MiB) 12:01:24 [12:01:24.183] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 922.37 MiB) 12:01:24 [12:01:24.420] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 941.37 MiB) 12:01:24 [12:01:24.499] INFO: pxe:bb:native bb - perturbator round (mem: 955.37 MiB) 12:01:24 [12:01:24.558] INFO: pxe:bb:native bb - combiner quotient round (mem: 987.37 MiB) 12:01:24 [12:01:24.664] INFO: pxe:bb:native bb - folded (mem: 987.37 MiB) 12:01:24 constructed folding proof (mem: 987.37 MiB) 12:01:24 [12:01:24.832] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 987.37 MiB) 12:01:24 [12:01:24.882] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 987.37 MiB) 12:01:24 [12:01:24.923] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 987.37 MiB) 12:01:24 Constructing DeciderProvingKey (mem: 987.37 MiB) 12:01:24 [12:01:24.929] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 987.37 MiB) 12:01:24 goblin ecc op : 792/1024 (mem: 987.37 MiB) 12:01:24 busread : 4184/6000 (mem: 987.37 MiB) 12:01:24 lookups : 2/15000 (mem: 987.37 MiB) 12:01:24 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 987.37 MiB) 12:01:24 arithmetic : 43824/56000 (mem: 987.37 MiB) 12:01:24 delta range : 5034/18000 (mem: 987.37 MiB) 12:01:24 elliptic : 340/6000 (mem: 987.37 MiB) 12:01:24 auxiliary : 1399/26000 (mem: 987.37 MiB) 12:01:24 poseidon ext : 5682/17000 (mem: 987.37 MiB) 12:01:24 poseidon int : 32378/92000 (mem: 987.37 MiB) 12:01:24 overflow : 0/0 (mem: 987.37 MiB) 12:01:24 (mem: 987.37 MiB) 12:01:24 Total structured size: 242025 (mem: 987.37 MiB) 12:01:24 allocating polynomials object in proving key... (mem: 987.37 MiB) 12:01:25 [12:01:24.986] INFO: pxe:bb:native bb - populating trace... (mem: 987.37 MiB) 12:01:25 [12:01:25.031] INFO: pxe:bb:native bb - time to construct proving key: 108 ms. (mem: 987.37 MiB) 12:01:25 getting honk vk... precomputed?: 0x59ef6d6aee00 (mem: 987.37 MiB) 12:01:25 computing folding proof (mem: 987.37 MiB) 12:01:25 [12:01:25.033] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 987.37 MiB) 12:01:25 [12:01:25.324] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 987.37 MiB) 12:01:25 [12:01:25.412] INFO: pxe:bb:native bb - perturbator round (mem: 987.37 MiB) 12:01:25 [12:01:25.476] INFO: pxe:bb:native bb - combiner quotient round (mem: 1007.18 MiB) 12:01:25 [12:01:25.627] INFO: pxe:bb:native bb - folded (mem: 1007.18 MiB) 12:01:25 constructed folding proof (mem: 1007.18 MiB) 12:01:25 [12:01:25.826] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 1007.18 MiB) 12:01:25 [12:01:25.878] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 1007.18 MiB) 12:01:25 Constructing DeciderProvingKey (mem: 1007.18 MiB) 12:01:25 [12:01:25.891] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1007.18 MiB) 12:01:25 goblin ecc op : 392/1024 (mem: 1007.18 MiB) 12:01:25 busread : 2347/6000 (mem: 1007.18 MiB) 12:01:25 lookups : 2/15000 (mem: 1007.18 MiB) 12:01:25 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 1007.18 MiB) 12:01:25 arithmetic : 36211/56000 (mem: 1007.18 MiB) 12:01:25 delta range : 4306/18000 (mem: 1007.18 MiB) 12:01:25 elliptic : 1274/6000 (mem: 1007.18 MiB) 12:01:25 auxiliary : 12562/26000 (mem: 1007.18 MiB) 12:01:25 poseidon ext : 6112/17000 (mem: 1007.18 MiB) 12:01:25 poseidon int : 34829/92000 (mem: 12:01:25 [12:01:25.891] INFO: pxe:bb:native bb - 1007.18 MiB) 12:01:25 overflow : 0/0 (mem: 1007.18 MiB) 12:01:25 (mem: 1007.18 MiB) 12:01:25 Total structured size: 242025 (mem: 1007.18 MiB) 12:01:25 allocating polynomials object in proving key... (mem: 1007.18 MiB) 12:01:25 [12:01:25.930] INFO: pxe:bb:native bb - populating trace... (mem: 12:01:25 [12:01:25.930] INFO: pxe:bb:native bb - 1007.18 MiB) 12:01:25 [12:01:25.982] INFO: pxe:bb:native bb - time to construct proving key: 107 ms. (mem: 1007.18 MiB) 12:01:25 getting honk vk... precomputed?: 0x59ef6ecd8000 (mem: 1007.18 MiB) 12:01:25 computing folding proof (mem: 1007.18 MiB) 12:01:25 [12:01:25.983] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 1007.18 MiB) 12:01:26 [12:01:26.319] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1007.18 MiB) 12:01:26 [12:01:26.402] INFO: pxe:bb:native bb - perturbator round (mem: 1007.18 MiB) 12:01:26 [12:01:26.477] INFO: pxe:bb:native bb - combiner quotient round (mem: 1038.48 MiB) 12:01:26 [12:01:26.597] INFO: pxe:bb:native bb - folded (mem: 1038.48 MiB) 12:01:26 constructed folding proof (mem: 1038.48 MiB) 12:01:26 [12:01:26.743] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 1038.48 MiB) 12:01:26 [12:01:26.797] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 1038.48 MiB) 12:01:26 Constructing DeciderProvingKey (mem: 1038.48 MiB) 12:01:26 [12:01:26.813] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1038.48 MiB) 12:01:26 goblin ecc op : 392/1024 (mem: 1038.48 MiB) 12:01:26 busread : 231/6000 (mem: 1038.48 MiB) 12:01:26 lookups : 2/15000 (mem: 1038.48 MiB) 12:01:26 [12:01:26.813] INFO: pxe:bb:native bb - pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 1038.48 MiB) 12:01:26 arithmetic : 32332/56000 (mem: 1038.48 MiB) 12:01:26 delta range : 4412/18000 (mem: 1038.48 MiB) 12:01:26 elliptic : 2/6000 (mem: 1038.48 MiB) 12:01:26 auxiliary : 11868/26000 (mem: 1038.48 MiB) 12:01:26 poseidon ext : 2552/17000 (mem: 1038.48 MiB) 12:01:26 poseidon int : 14537/92000 (mem: 1038.48 MiB) 12:01:26 overflow : 0/0 (mem: 1038.48 MiB) 12:01:26 (mem: 1038.48 MiB) 12:01:26 Total structured size: 242025 (mem: 1038.48 MiB) 12:01:26 allocating polynomials object in proving key... (mem: 1038.48 MiB) 12:01:26 [12:01:26.854] INFO: pxe:bb:native bb - populating trace... (mem: 1038.48 MiB) 12:01:26 [12:01:26.898] INFO: pxe:bb:native bb - time to construct proving key: 100 ms. (mem: 1038.48 MiB) 12:01:26 getting honk vk... precomputed?: 0x59ef722eb200 (mem: 1038.48 MiB) 12:01:26 computing folding proof (mem: 1038.48 MiB) 12:01:26 [12:01:26.899] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 1038.48 MiB) 12:01:27 [12:01:27.171] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1038.48 MiB) 12:01:27 [12:01:27.256] INFO: pxe:bb:native bb - perturbator round (mem: 1038.48 MiB) 12:01:27 [12:01:27.335] INFO: pxe:bb:native bb - combiner quotient round (mem: 1038.48 MiB) 12:01:27 [12:01:27.448] INFO: pxe:bb:native bb - folded (mem: 1038.48 MiB) 12:01:27 [12:01:27.448] INFO: pxe:bb:native bb - constructed folding proof (mem: 1038.48 MiB) 12:01:27 [12:01:27.541] INFO: pxe:bb:native bb - Largest circuit: 97643 gates. Trace details: (mem: 1038.48 MiB) 12:01:27 Minimum required block sizes for structured trace: (mem: 1038.48 MiB) 12:01:27 [12:01:27.542] INFO: pxe:bb:native bb - (mem: 1038.48 MiB) 12:01:27 prove decider... (mem: 1038.48 MiB) 12:01:27 [12:01:27.542] INFO: pxe:bb:native bb - ecc_op : 792 12:01:27 busread : 4184 12:01:27 lookup : 15000 12:01:27 pub_inputs : 1859 12:01:27 arithmetic : 43824 12:01:27 delta_range : 5034 12:01:27 elliptic : 1274 12:01:27 aux : 12562 12:01:27 poseidon2_external : 6112 12:01:27 poseidon2_internal : 34829 12:01:27 overflow : 2379 12:01:27 [12:01:27.619] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1038.48 MiB) 12:01:27 [12:01:27.722] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1038.48 MiB) 12:01:28 [12:01:28.324] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1038.48 MiB) 12:01:28 [12:01:28.401] INFO: pxe:bb:native bb - computed opening proof (mem: 1038.48 MiB) 12:01:28 finished decider proving. (mem: 1038.48 MiB) 12:01:28 [12:01:28.411] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 1038.48 MiB) 12:01:28 [12:01:28.596] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 1038.48 MiB) 12:01:28 [12:01:28.601] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 1038.48 MiB) 12:01:28 [12:01:28.709] INFO: pxe:bb:native bb - populating trace... (mem: 1038.48 MiB) 12:01:28 [12:01:28.775] INFO: pxe:bb:native bb - time to construct proving key: 178 ms. (mem: 1038.48 MiB) 12:01:29 [12:01:29.249] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 1038.48 MiB) 12:01:29 [12:01:29.588] INFO: pxe:bb:native bb - created oink proof (mem: 1038.48 MiB) 12:01:29 [12:01:29.720] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1038.48 MiB) 12:01:30 [12:01:30.235] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 1038.48 MiB) 12:01:31 [12:01:30.909] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1038.48 MiB) 12:01:31 [12:01:30.971] INFO: pxe:bb:native bb - computed opening proof (mem: 1038.48 MiB) 12:01:31 finished decider proving. (mem: 1038.48 MiB) 12:01:31 [12:01:30.972] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3818 (mem: 1038.48 MiB) 12:01:31 [12:01:31.100] INFO: pxe:bb:native bb - prove eccvm... (mem: 1038.48 MiB) 12:01:31 [12:01:31.397] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 1038.48 MiB) 12:01:31 [12:01:31.407] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 1038.48 MiB) 12:01:33 [12:01:32.546] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1038.48 MiB) 12:01:33 [12:01:33.717] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 1038.48 MiB) 12:01:36 [12:01:35.809] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 1038.48 MiB) 12:01:36 prove translator... (mem: 1038.48 MiB) 12:01:36 [12:01:36.575] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1054.81 MiB) 12:01:37 [12:01:37.404] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1054.81 MiB) 12:01:38 [12:01:38.287] INFO: pxe:bb:native bb - computed opening proof (mem: 1054.81 MiB) 12:01:38 [12:01:38.288] INFO: pxe:bb:native bb - finished translator proving. (mem: 1054.81 MiB) 12:01:38 [12:01:38.289] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 1054.81 MiB) 12:01:38 [12:01:38.315] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 1054.81 MiB) 12:01:38 libra_evals_verified: 1 (mem: 1054.81 MiB) 12:01:38 pairing_check_verified: 1 (mem: 1054.81 MiB) 12:01:38 Mega verified: 1 (mem: 1054.81 MiB) 12:01:38 [12:01:38.379] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 1054.81 MiB) 12:01:38 batch opening verified?: 1 (mem: 1054.81 MiB) 12:01:38 eccvm consistency check verified?: 1 (mem: 1054.81 MiB) 12:01:38 translation masking consistency checked?: 1 (mem: 1054.81 MiB) 12:01:38 [12:01:38.398] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 1055.81 MiB) 12:01:38 eccvm verified?: 1 (mem: 1055.81 MiB) 12:01:38 accumulator construction_verified?: 1 (mem: 1055.81 MiB) 12:01:38 translation verified?: 1 (mem: 1055.81 MiB) 12:01:38 consistency verified?: 1 (mem: 1055.81 MiB) 12:01:38 Goblin verified: 1 (mem: 1055.81 MiB) 12:01:38 [12:01:38.398] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-uH8K0W" (mem: 1055.81 MiB) 12:01:38 [12:01:38.603] INFO: pxe:bb:native Generated IVC proof {"duration":20101.641224,"eventName":"circuit-proving"} 12:01:38 [12:01:38.610] INFO: pxe:service Proving completed in 25171.428336ms {"timings":{"total":25171.428336,"sync":67.28830599999992,"proving":21161.542716,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":138.51016600000003,"oracles":{"callPrivateFunction":{"times":[412.15835100000004,428.4892689999997]}}},{"functionName":"private_kernel_init","time":266.07768499999975},{"functionName":"SchnorrAccount:constructor","time":397.6854569999996,"oracles":{"getContractInstance":{"times":[0.8493169999997008]},"debugLog":{"times":[0.486547999999857,0.1348710000002029]},"fetchTaggedLogs":{"times":[194.51583699999992]},"loadCapsule":{"times":[0.525220999999874,0.22682800000029602,0.2342279999998027,0.2938930000000255,0.19367499999998472,0.1774639999998726]},"bulkRetrieveLogs":{"times":[7.173157000000174]},"validateEnqueuedNotesAndEvents":{"times":[6.934248999999909]},"notifyCreatedNullifier":{"times":[0.48481800000035946,0.4065820000000713]},"notifyCreatedNote":{"times":[0.3958700000002864]},"getRandomField":{"times":[0.35904800000025716,0.26918099999966216,0.07234500000004118,0.0504439999999704,0.2157470000001922,0.06201499999997395,0.04376400000001013,0.05036400000017238,0.04563400000006368,0.08474699999987934,0.040802999999868916]},"getIndexedTaggingSecretAsSender":{"times":[32.110523999999714]},"incrementAppTaggingSecretIndexAsSender":{"times":[22.569892999999865]}}},{"functionName":"private_kernel_inner","time":497.94956399999955},{"functionName":"SchnorrAccount:entrypoint","time":264.9138039999998,"oracles":{"debugLog":{"times":[0.2252480000001924,0.09709699999984878,0.29118300000027375]},"fetchTaggedLogs":{"times":[116.76223800000025]},"loadCapsule":{"times":[0.17702299999973548,0.1691129999999248,3.655753999999888,0.2608700000000681,0.18148400000018228,0.25363999999990483]},"bulkRetrieveLogs":{"times":[6.102333999999701]},"validateEnqueuedNotesAndEvents":{"times":[6.041708999999628]},"getNotes":{"times":[2.466870999999628]},"getAuthWitness":{"times":[0.3075340000000324]},"callPrivateFunction":{"times":[156.6888100000001]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.237116000000242]}}},{"functionName":"private_kernel_inner","time":432.4298149999995},{"functionName":"FeeJuice:claim","time":145.5526550000004,"oracles":{"getL1ToL2MembershipWitness":{"times":[29.837377000000288]},"notifyCreatedNullifier":{"times":[0.40711099999998623]},"storeInExecutionCache":{"times":[0.21092600000019956]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3009839999999713]}}},{"functionName":"private_kernel_inner","time":414.3563320000003},{"functionName":"private_kernel_reset","time":541.8449120000005},{"functionName":"private_kernel_tail","time":426.21580300000005}],"unaccounted":417.06112100000246}} 12:01:38 12:01:38 Waiting for account contract deployment... 12:01:38 [12:01:38.724] INFO: pxe:service Sent transaction 0x2285eb1caf23d99f430ca315e336ea254dfe11f8e2faa03b5fbd08e21e183857 12:01:39 [12:01:38.722] INFO: node Received tx 0x2285eb1caf23d99f430ca315e336ea254dfe11f8e2faa03b5fbd08e21e183857 {"txHash":"0x2285eb1caf23d99f430ca315e336ea254dfe11f8e2faa03b5fbd08e21e183857"} 12:01:44 [12:01:43.247] WARN: aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time 12:01:44 [12:01:43.253] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939893 12:01:44 [12:01:43.456] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:01:44 [12:01:43.456] WARN: foundation:test-date-provider Time set to 2025-06-26T12:11:33.000Z {"offset":589544,"timeMs":1750939893000} 12:01:44 [12:01:43.752] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08255732799999532s {"duration":0.08255732799999532,"rate":172292.39783536605,"totalPublicGas":{"daGas":1024,"l2Gas":14224},"totalBlockGas":{"daGas":13312,"l2Gas":40548},"totalSizeInBytes":1024} 12:01:44 [12:01:43.782] INFO: sequencer Built block 10 for slot 13 with 1 txs and 0 messages. 118726.58360408462 mana/s {"blockHash":"0x094e193ede03d4026ce1bb8088e92acae5b772909290037e9328c0b808cf9a9a","globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750939892,"version":2896790463},"txHashes":["0x2285eb1caf23d99f430ca315e336ea254dfe11f8e2faa03b5fbd08e21e183857"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":119.65002499999537,"publicProcessDuration":82.71317000000272,"rollupCircuitsDuration":114.59717100000125,"txCount":1,"blockNumber":10,"blockTimestamp":1750939892,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:01:44 [12:01:44.010] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 10 12:01:44 [12:01:44.012] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939928 12:01:44 [12:01:44.012] WARN: foundation:test-date-provider Time set to 2025-06-26T12:12:08.000Z {"offset":623988,"timeMs":1750939928000} 12:01:44 [12:01:44.012] INFO: aztecjs:utils:watcher Slot 13 was filled, jumped to next slot 12:01:44 [12:01:44.012] INFO: aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10. 12:01:44 [12:01:44.015] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:01:44 [12:01:44.554] INFO: archiver Downloaded L2 block 10 {"blockHash":"0x094e193ede03d4026ce1bb8088e92acae5b772909290037e9328c0b808cf9a9a","blockNumber":10,"txCount":1,"globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750939892,"version":2896790463},"archiveRoot":"0x1b4de327049869f4cc6c76d9ae5fb4dd4994ef409b00f3dca79df0e231e4a491","archiveNextLeafIndex":11} 12:01:44 [12:01:44.556] INFO: archiver Updated proven chain to block 10 {"provenBlockNumber":10} 12:01:44 [12:01:44.695] INFO: world_state World state updated with L2 block 10 {"eventName":"l2-block-handled","duration":7.494405000004917,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1750939892,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:01:44 Deploy tx hash: 0x2285eb1caf23d99f430ca315e336ea254dfe11f8e2faa03b5fbd08e21e183857 12:01:44 Deploy tx fee: 117183720 12:01:48 [12:01:48.938] INFO: wallet Using local PXE service 12:01:48 [12:01:48.940] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 12:01:49 [12:01:48.996] 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) 12:01:49 [12:01:48.999] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:01:50 [12:01:49.655] INFO: pxe:service Started PXE connected to chain 31337 version 2896790463 12:01:50 [12:01:49.726] INFO: wallet Using wallet with address 0x1a5cc0d77a442f8bb3565bed39b41564a6268113b8ee78c9fa5dbea1904d84fe 12:01:51 [12:01:50.953] INFO: pxe:service Added contract Token at 0x1d4a6b30802a854ee217c1f2f6bc49246622ede5f6d1e2eff755cea9e8749b88 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 12:01:55 [12:01:54.148] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2441.8580809999994ms 12:01:55 [12:01:54.148] INFO: pxe:bb:native Generating Client IVC proof 12:01:55 [12:01:55.003] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3/ivc-inputs.msgpack 12:01:55 [12:01:55.004] INFO: pxe:bb:native bb - BB concurrency: undefined 12:01:55 [12:01:55.004] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3 --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3/ivc-inputs.msgpack -v --scheme client_ivc 12:01:55 [12:01:55.029] INFO: pxe:bb:native bb - bb command: prove (mem: 212.76 MiB) 12:01:55 [12:01:55.030] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 212.76 MiB) 12:01:55 --scheme: client_ivc (mem: 212.76 MiB) 12:01:55 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3 (mem: 212.76 MiB) 12:01:55 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3/ivc-inputs.msgpack (mem: 212.76 MiB) 12:01:55 --verbose: true (mem: 212.76 MiB) 12:01:56 [12:01:55.692] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 212.76 MiB) 12:01:56 [12:01:55.692] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 212.76 MiB) 12:01:56 [12:01:55.735] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 212.76 MiB) 12:01:56 [12:01:55.789] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 212.76 MiB) 12:01:56 Constructing DeciderProvingKey (mem: 212.76 MiB) 12:01:56 [12:01:55.794] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 212.76 MiB) 12:01:56 goblin ecc op : 4/1024 (mem: 212.76 MiB) 12:01:56 busread : 742/6000 (mem: 212.76 MiB) 12:01:56 lookups : 2076/15000 (mem: 212.76 MiB) 12:01:56 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 212.76 MiB) 12:01:56 arithmetic : 9353/56000 (mem: 212.76 MiB) 12:01:56 delta range : 2977/18000 (mem: 212.76 MiB) 12:01:56 elliptic : 794/6000 (mem: 212.76 MiB) 12:01:56 auxiliary : 4528/26000 (mem: 212.76 MiB) 12:01:56 poseidon ext : 312/17000 (mem: 212.76 MiB) 12:01:56 poseidon int : 1769/92000 (mem: 212.76 MiB) 12:01:56 overflow : 0/0 (mem: 212.76 MiB) 12:01:56 (mem: 212.76 MiB) 12:01:56 Total structured size: 242025 (mem: 212.76 MiB) 12:01:56 allocating polynomials object in proving key... (mem: 212.76 MiB) 12:01:56 [12:01:55.943] INFO: pxe:bb:native bb - populating trace... (mem: 425.69 MiB) 12:01:56 [12:01:55.974] INFO: pxe:bb:native bb - time to construct proving key: 184 ms. (mem: 441.69 MiB) 12:01:56 getting honk vk... precomputed?: 0x559676db8380 (mem: 441.69 MiB) 12:01:56 [12:01:55.974] INFO: pxe:bb:native bb - computing oink proof... (mem: 441.69 MiB) 12:01:56 [12:01:55.975] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 441.69 MiB) 12:01:56 [12:01:56.206] INFO: pxe:bb:native bb - oink proof constructed (mem: 466.69 MiB) 12:01:56 [12:01:56.293] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 466.69 MiB) 12:01:56 [12:01:56.304] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 466.69 MiB) 12:01:56 Constructing DeciderProvingKey (mem: 466.69 MiB) 12:01:56 [12:01:56.308] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 466.69 MiB) 12:01:56 goblin ecc op : 56/1024 (mem: 466.69 MiB) 12:01:56 busread : 2529/6000 (mem: 466.69 MiB) 12:01:56 lookups : 2/15000 (mem: 466.69 MiB) 12:01:56 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 466.69 MiB) 12:01:56 arithmetic : 21160/56000 (mem: 466.69 MiB) 12:01:56 delta range : 3041/18000 (mem: 466.69 MiB) 12:01:56 elliptic : 340/6000 (mem: 466.69 MiB) 12:01:56 auxiliary : 799/26000 (mem: 466.69 MiB) 12:01:56 poseidon ext : 2022/17000 (mem: 466.69 MiB) 12:01:56 poseidon int : 11516/92000 (mem: 466.69 MiB) 12:01:56 [12:01:56.308] INFO: pxe:bb:native bb - overflow : 0/0 (mem: 466.69 MiB) 12:01:56 (mem: 466.69 MiB) 12:01:56 Total structured size: 242025 (mem: 466.69 MiB) 12:01:56 allocating polynomials object in proving key... (mem: 466.69 MiB) 12:01:56 [12:01:56.352] INFO: pxe:bb:native bb - populating trace... (mem: 674.69 MiB) 12:01:56 [12:01:56.393] INFO: pxe:bb:native bb - time to construct proving key: 89 ms. (mem: 691.69 MiB) 12:01:56 getting honk vk... precomputed?: 0x5596773f5a80 (mem: 691.69 MiB) 12:01:56 computing folding proof (mem: 691.69 MiB) 12:01:56 [12:01:56.394] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 691.69 MiB) 12:01:56 [12:01:56.573] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 691.69 MiB) 12:01:56 [12:01:56.648] INFO: pxe:bb:native bb - perturbator round (mem: 721.69 MiB) 12:01:56 [12:01:56.713] INFO: pxe:bb:native bb - combiner quotient round (mem: 754.69 MiB) 12:01:56 [12:01:56.790] INFO: pxe:bb:native bb - folded (mem: 754.69 MiB) 12:01:56 constructed folding proof (mem: 754.69 MiB) 12:01:56 [12:01:56.860] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractInstanceDeployer:deploy (mem: 754.69 MiB) 12:01:56 Constructing DeciderProvingKey (mem: 754.69 MiB) 12:01:56 [12:01:56.864] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 754.69 MiB) 12:01:56 goblin ecc op : 4/1024 (mem: 754.69 MiB) 12:01:56 busread : 742/6000 (mem: 754.69 MiB) 12:01:56 lookups : 2/15000 (mem: 754.69 MiB) 12:01:56 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 754.69 MiB) 12:01:56 arithmetic : 3656/56000 (mem: 754.69 MiB) 12:01:56 [12:01:56.864] INFO: pxe:bb:native bb - delta range : 1838/18000 (mem: 754.69 MiB) 12:01:56 elliptic : 340/6000 (mem: 754.69 MiB) 12:01:56 auxiliary : 187/26000 (mem: 754.69 MiB) 12:01:56 poseidon ext : 162/17000 (mem: 754.69 MiB) 12:01:56 poseidon int : 914/92000 (mem: 754.69 MiB) 12:01:56 overflow : 0/0 (mem: 754.69 MiB) 12:01:56 (mem: 754.69 MiB) 12:01:56 Total structured size: 242025 (mem: 754.69 MiB) 12:01:56 allocating polynomials object in proving key... (mem: 754.69 MiB) 12:01:56 [12:01:56.903] INFO: pxe:bb:native bb - populating trace... (mem: 754.69 MiB) 12:01:56 [12:01:56.912] INFO: pxe:bb:native bb - time to construct proving key: 51 ms. (mem: 754.69 MiB) 12:01:56 getting honk vk... precomputed?: 0x559676ddd440 (mem: 754.69 MiB) 12:01:56 computing folding proof (mem: 754.69 MiB) 12:01:56 [12:01:56.913] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 754.69 MiB) 12:01:57 [12:01:57.023] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 754.69 MiB) 12:01:57 [12:01:57.073] INFO: pxe:bb:native bb - perturbator round (mem: 754.69 MiB) 12:01:57 [12:01:57.138] INFO: pxe:bb:native bb - combiner quotient round (mem: 756.03 MiB) 12:01:57 [12:01:57.256] INFO: pxe:bb:native bb - folded (mem: 756.03 MiB) 12:01:57 constructed folding proof (mem: 756.03 MiB) 12:01:57 [12:01:57.386] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 756.03 MiB) 12:01:57 [12:01:57.434] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 756.03 MiB) 12:01:57 [12:01:57.476] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 756.03 MiB) 12:01:57 Constructing DeciderProvingKey (mem: 756.03 MiB) 12:01:57 [12:01:57.482] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 756.03 MiB) 12:01:57 goblin ecc op : 792/1024 (mem: 756.03 MiB) 12:01:57 busread : 4184/6000 (mem: 756.03 MiB) 12:01:57 lookups : 2/15000 (mem: 756.03 MiB) 12:01:57 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 756.03 MiB) 12:01:57 arithmetic : 43824/56000 (mem: 756.03 MiB) 12:01:57 delta range : 5034/18000 (mem: 756.03 MiB) 12:01:57 elliptic : 340/6000 (mem: 756.03 MiB) 12:01:57 auxiliary : 1399/26000 (mem: 756.03 MiB) 12:01:57 poseidon ext : 5682/17000 (mem: 756.03 MiB) 12:01:57 poseidon int : 32378/92000 (mem: 756.03 MiB) 12:01:57 [12:01:57.483] INFO: pxe:bb:native bb - overflow : 0/0 (mem: 756.03 MiB) 12:01:57 (mem: 756.03 MiB) 12:01:57 Total structured size: 242025 (mem: 756.03 MiB) 12:01:57 allocating polynomials object in proving key... (mem: 756.03 MiB) 12:01:57 [12:01:57.511] INFO: pxe:bb:native bb - populating trace... (mem: 756.03 MiB) 12:01:57 [12:01:57.557] INFO: pxe:bb:native bb - time to construct proving key: 80 ms. (mem: 756.03 MiB) 12:01:57 getting honk vk... precomputed?: 0x559676ba0b40 (mem: 756.03 MiB) 12:01:57 computing folding proof (mem: 756.03 MiB) 12:01:57 [12:01:57.557] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 756.03 MiB) 12:01:57 [12:01:57.781] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 756.03 MiB) 12:01:57 [12:01:57.844] INFO: pxe:bb:native bb - perturbator round (mem: 757.64 MiB) 12:01:57 [12:01:57.940] INFO: pxe:bb:native bb - combiner quotient round (mem: 789.64 MiB) 12:01:58 [12:01:58.105] INFO: pxe:bb:native bb - folded (mem: 789.64 MiB) 12:01:58 constructed folding proof (mem: 789.64 MiB) 12:01:58 [12:01:58.168] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractClassRegisterer:assert_class_id_is_registered (mem: 789.64 MiB) 12:01:58 Constructing DeciderProvingKey (mem: 789.64 MiB) 12:01:58 [12:01:58.171] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 789.64 MiB) 12:01:58 goblin ecc op : 4/1024 (mem: 789.64 MiB) 12:01:58 busread : 742/6000 (mem: 789.64 MiB) 12:01:58 lookups : 2/15000 (mem: 789.64 MiB) 12:01:58 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 789.64 MiB) 12:01:58 arithmetic : 3287/56000 (mem: 789.64 MiB) 12:01:58 [12:01:58.171] INFO: pxe:bb:native bb - delta range : 1787/18000 (mem: 789.64 MiB) 12:01:58 elliptic : 2/6000 (mem: 789.64 MiB) 12:01:58 auxiliary : 26/26000 (mem: 789.64 MiB) 12:01:58 poseidon ext : 12/17000 (mem: 789.64 MiB) 12:01:58 poseidon int : 59/92000 (mem: 789.64 MiB) 12:01:58 overflow : 0/0 (mem: 789.64 MiB) 12:01:58 (mem: 789.64 MiB) 12:01:58 Total structured size: 242025 (mem: 789.64 MiB) 12:01:58 allocating polynomials object in proving key... (mem: 789.64 MiB) 12:01:58 [12:01:58.205] INFO: pxe:bb:native bb - populating trace... (mem: 789.64 MiB) 12:01:58 [12:01:58.213] INFO: pxe:bb:native bb - time to construct proving key: 44 ms. (mem: 789.64 MiB) 12:01:58 getting honk vk... precomputed?: 0x55967747e5c0 (mem: 789.64 MiB) 12:01:58 computing folding proof (mem: 789.64 MiB) 12:01:58 [12:01:58.214] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 789.64 MiB) 12:01:58 [12:01:58.316] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 789.64 MiB) 12:01:58 [12:01:58.408] INFO: pxe:bb:native bb - perturbator round (mem: 789.64 MiB) 12:01:58 [12:01:58.475] INFO: pxe:bb:native bb - combiner quotient round (mem: 789.64 MiB) 12:01:58 [12:01:58.551] INFO: pxe:bb:native bb - folded (mem: 789.64 MiB) 12:01:58 constructed folding proof (mem: 789.64 MiB) 12:01:58 [12:01:58.683] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 789.64 MiB) 12:01:58 [12:01:58.730] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 789.64 MiB) 12:01:58 [12:01:58.772] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 789.64 MiB) 12:01:58 Constructing DeciderProvingKey (mem: 789.64 MiB) 12:01:58 [12:01:58.778] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 789.64 MiB) 12:01:58 goblin ecc op : 792/1024 (mem: 789.64 MiB) 12:01:58 busread : 4184/6000 (mem: 789.64 MiB) 12:01:58 lookups : 2/15000 (mem: 789.64 12:01:58 [12:01:58.778] INFO: pxe:bb:native bb - MiB) 12:01:58 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 789.64 MiB) 12:01:58 arithmetic : 43824/56000 (mem: 789.64 MiB) 12:01:58 delta range : 5034/18000 (mem: 789.64 MiB) 12:01:58 elliptic : 340/6000 (mem: 789.64 MiB) 12:01:58 auxiliary : 1399/26000 (mem: 789.64 MiB) 12:01:58 poseidon ext : 5682/17000 (mem: 789.64 MiB) 12:01:58 poseidon int : 32378/92000 (mem: 789.64 MiB) 12:01:58 overflow : 0/0 (mem: 789.64 MiB) 12:01:58 (mem: 789.64 MiB) 12:01:58 Total structured size: 242025 (mem: 789.64 MiB) 12:01:58 allocating polynomials object in proving key... (mem: 789.64 MiB) 12:01:58 [12:01:58.821] INFO: pxe:bb:native bb - populating trace... (mem: 789.64 MiB) 12:01:58 [12:01:58.866] INFO: pxe:bb:native bb - time to construct proving key: 94 ms. (mem: 789.64 MiB) 12:01:58 getting honk vk... precomputed?: 0x55967747f380 (mem: 789.64 MiB) 12:01:58 [12:01:58.867] INFO: pxe:bb:native bb - computing folding proof (mem: 789.64 MiB) 12:01:58 [12:01:58.867] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 789.64 MiB) 12:01:59 [12:01:59.144] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 789.64 MiB) 12:01:59 [12:01:59.197] INFO: pxe:bb:native bb - perturbator round (mem: 789.64 MiB) 12:01:59 [12:01:59.251] INFO: pxe:bb:native bb - combiner quotient round (mem: 791.54 MiB) 12:01:59 [12:01:59.314] INFO: pxe:bb:native bb - folded (mem: 791.54 MiB) 12:01:59 constructed folding proof (mem: 791.54 MiB) 12:01:59 [12:01:59.453] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 791.54 MiB) 12:01:59 [12:01:59.496] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 791.54 MiB) 12:01:59 Constructing DeciderProvingKey (mem: 791.54 MiB) 12:01:59 [12:01:59.508] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 791.54 MiB) 12:01:59 goblin ecc op : 392/1024 (mem: 791.54 MiB) 12:01:59 busread : 2347/6000 (mem: 791.54 MiB) 12:01:59 lookups : 2/15000 (mem: 791.54 MiB) 12:01:59 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 791.54 MiB) 12:01:59 arithmetic : 36211/56000 (mem: 791.54 MiB) 12:01:59 delta range : 4306/18000 (mem: 791.54 MiB) 12:01:59 [12:01:59.508] INFO: pxe:bb:native bb - 12:01:59 elliptic : 1274/6000 (mem: 791.54 MiB) 12:01:59 auxiliary : 12562/26000 (mem: 791.54 MiB) 12:01:59 poseidon ext : 6112/17000 (mem: 791.54 MiB) 12:01:59 poseidon int : 34829/92000 (mem: 791.54 MiB) 12:01:59 overflow : 0/0 (mem: 791.54 MiB) 12:01:59 (mem: 791.54 MiB) 12:01:59 Total structured size: 242025 (mem: 791.54 MiB) 12:01:59 allocating polynomials object in proving key... (mem: 791.54 MiB) 12:01:59 [12:01:59.534] INFO: pxe:bb:native bb - populating trace... (mem: 791.54 MiB) 12:01:59 [12:01:59.568] INFO: pxe:bb:native bb - time to construct proving key: 71 ms. (mem: 791.54 MiB) 12:01:59 getting honk vk... precomputed?: 0x55967820ad80 (mem: 791.54 MiB) 12:01:59 computing folding proof (mem: 791.54 MiB) 12:01:59 [12:01:59.569] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 791.54 MiB) 12:01:59 [12:01:59.789] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 791.54 MiB) 12:01:59 [12:01:59.844] INFO: pxe:bb:native bb - perturbator round (mem: 791.54 MiB) 12:01:59 [12:01:59.895] INFO: pxe:bb:native bb - combiner quotient round (mem: 822.54 MiB) 12:01:59 [12:01:59.953] INFO: pxe:bb:native bb - folded (mem: 822.54 MiB) 12:01:59 constructed folding proof (mem: 822.54 MiB) 12:02:00 [12:02:00.065] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 822.54 MiB) 12:02:00 [12:02:00.105] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 822.54 MiB) 12:02:00 Constructing DeciderProvingKey (mem: 822.54 MiB) 12:02:00 [12:02:00.116] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 822.54 MiB) 12:02:00 goblin ecc op : 392/1024 (mem: 822.54 MiB) 12:02:00 busread : 231/6000 (mem: 822.54 MiB) 12:02:00 [12:02:00.116] INFO: pxe:bb:native bb - lookups : 2/15000 (mem: 822.54 MiB) 12:02:00 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 822.54 MiB) 12:02:00 arithmetic : 32332/56000 (mem: 822.54 MiB) 12:02:00 delta range : 4412/18000 (mem: 822.54 MiB) 12:02:00 elliptic : 2/6000 (mem: 822.54 MiB) 12:02:00 auxiliary : 11868/26000 (mem: 822.54 MiB) 12:02:00 poseidon ext : 2552/17000 (mem: 822.54 MiB) 12:02:00 poseidon int : 14537/92000 (mem: 822.54 MiB) 12:02:00 overflow : 0/0 (mem: 822.54 MiB) 12:02:00 (mem: 822.54 MiB) 12:02:00 Total structured size: 242025 (mem: 822.54 MiB) 12:02:00 allocating polynomials object in proving key... (mem: 822.54 MiB) 12:02:00 [12:02:00.141] INFO: pxe:bb:native bb - populating trace... (mem: 822.54 MiB) 12:02:00 [12:02:00.166] INFO: pxe:bb:native bb - time to construct proving key: 60 ms. (mem: 822.54 MiB) 12:02:00 getting honk vk... precomputed?: 0x5596780908c0 (mem: 822.54 MiB) 12:02:00 computing folding proof (mem: 822.54 MiB) 12:02:00 [12:02:00.167] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 822.54 MiB) 12:02:00 [12:02:00.334] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 822.54 MiB) 12:02:00 [12:02:00.382] INFO: pxe:bb:native bb - perturbator round (mem: 822.54 MiB) 12:02:00 [12:02:00.415] INFO: pxe:bb:native bb - combiner quotient round (mem: 822.54 MiB) 12:02:00 [12:02:00.474] INFO: pxe:bb:native bb - folded (mem: 822.54 MiB) 12:02:00 constructed folding proof (mem: 822.54 12:02:00 [12:02:00.475] INFO: pxe:bb:native bb - MiB) 12:02:00 [12:02:00.533] INFO: pxe:bb:native bb - Largest circuit: 97643 gates. Trace details: (mem: 822.54 MiB) 12:02:00 Minimum required block sizes for structured trace: (mem: 822.54 MiB) 12:02:00 [12:02:00.533] INFO: pxe:bb:native bb - (mem: 822.54 MiB) 12:02:00 prove decider... (mem: 822.54 MiB) 12:02:00 [12:02:00.533] INFO: pxe:bb:native bb - ecc_op : 792 12:02:00 busread : 4184 12:02:00 lookup : 2076 12:02:00 pub_inputs : 1859 12:02:00 arithmetic : 43824 12:02:00 delta_range : 5034 12:02:00 elliptic : 1274 12:02:00 aux : 12562 12:02:00 poseidon2_external : 6112 12:02:00 poseidon2_internal : 34829 12:02:00 overflow : 0 12:02:00 [12:02:00.581] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 822.54 MiB) 12:02:00 [12:02:00.641] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 822.54 MiB) 12:02:01 [12:02:00.989] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 822.54 MiB) 12:02:01 [12:02:01.067] INFO: pxe:bb:native bb - computed opening proof (mem: 822.54 MiB) 12:02:01 finished decider proving. (mem: 822.54 MiB) 12:02:01 [12:02:01.079] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 822.54 MiB) 12:02:01 [12:02:01.262] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 822.54 MiB) 12:02:01 [12:02:01.267] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 822.54 MiB) 12:02:01 [12:02:01.297] INFO: pxe:bb:native bb - populating trace... (mem: 822.54 MiB) 12:02:01 [12:02:01.339] INFO: pxe:bb:native bb - time to construct proving key: 77 ms. (mem: 822.54 MiB) 12:02:01 [12:02:01.643] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 822.54 MiB) 12:02:01 [12:02:01.868] INFO: pxe:bb:native bb - created oink proof (mem: 822.54 MiB) 12:02:02 [12:02:02.008] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 822.54 MiB) 12:02:02 [12:02:02.595] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 822.54 MiB) 12:02:03 [12:02:03.114] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 822.54 MiB) 12:02:03 [12:02:03.157] INFO: pxe:bb:native bb - computed opening proof (mem: 822.54 MiB) 12:02:03 finished decider proving. (mem: 822.54 MiB) 12:02:03 [12:02:03.158] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3022 (mem: 822.54 MiB) 12:02:03 [12:02:03.255] INFO: pxe:bb:native bb - prove eccvm... (mem: 822.54 MiB) 12:02:03 [12:02:03.547] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 822.54 MiB) 12:02:03 [12:02:03.555] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 822.54 MiB) 12:02:04 [12:02:04.442] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 822.54 MiB) 12:02:05 [12:02:05.334] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 822.54 MiB) 12:02:07 [12:02:07.528] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 822.54 MiB) 12:02:07 prove translator... (mem: 822.54 MiB) 12:02:08 [12:02:08.440] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 838.63 MiB) 12:02:09 [12:02:09.528] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 838.63 MiB) 12:02:10 [12:02:10.631] INFO: pxe:bb:native bb - computed opening proof (mem: 838.63 MiB) 12:02:10 [12:02:10.633] INFO: pxe:bb:native bb - finished translator proving. (mem: 838.63 MiB) 12:02:10 [12:02:10.634] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 838.63 MiB) 12:02:10 [12:02:10.659] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 838.63 MiB) 12:02:10 libra_evals_verified: 1 (mem: 838.63 MiB) 12:02:10 pairing_check_verified: 1 (mem: 838.63 MiB) 12:02:10 Mega verified: 1 (mem: 838.63 MiB) 12:02:10 [12:02:10.726] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 838.63 MiB) 12:02:10 batch opening verified?: 1 (mem: 838.63 MiB) 12:02:10 eccvm consistency check verified?: 1 (mem: 838.63 12:02:10 [12:02:10.727] INFO: pxe:bb:native bb - MiB) 12:02:10 translation masking consistency checked?: 1 (mem: 838.63 MiB) 12:02:10 [12:02:10.745] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 839.63 MiB) 12:02:10 eccvm verified?: 1 (mem: 839.63 MiB) 12:02:10 accumulator construction_verified?: 1 (mem: 839.63 MiB) 12:02:10 translation verified?: 1 (mem: 839.63 MiB) 12:02:10 consistency verified?: 1 (mem: 839.63 MiB) 12:02:10 Goblin verified: 1 (mem: 839.63 MiB) 12:02:10 [12:02:10.745] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-kdjBq3" (mem: 839.63 MiB) 12:02:10 [12:02:10.907] INFO: pxe:bb:native Generated IVC proof {"duration":15902.458477,"eventName":"circuit-proving"} 12:02:10 [12:02:10.911] INFO: pxe:service Proving completed in 19949.728896ms {"timings":{"total":19949.728896,"sync":82.73428000000013,"proving":16762.955042,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":508.2178849999982,"oracles":{"debugLog":{"times":[0.6839039999999841,0.142400999999154,0.11411900000075548,0.24655900000016118,0.14475099999981467,0.10294799999974202,0.24326900000050955,0.3634879999999612]},"fetchTaggedLogs":{"times":[158.17590900000005]},"loadCapsule":{"times":[0.3837499999999636,0.2508900000002541,0.45218500000009954,0.4790869999997085,2.183270999999877,0.39503100000001723,0.4463350000005448,0.45727500000066357,0.6323900000006688,0.3519880000003468]},"getSharedSecret":{"times":[4.282195000000684]},"aes128Decrypt":{"times":[0.8867499999996653,0.5794059999998353]},"getPublicKeysAndPartialAddress":{"times":[2.0423600000003717]},"getKeyValidationRequest":{"times":[2.436891000000287]},"storeCapsule":{"times":[4.766072999999778,9.944408999999723,3.3936949999997523]},"deleteCapsule":{"times":[3.8881649999993897]},"bulkRetrieveLogs":{"times":[11.005952000000434]},"validateEnqueuedNotesAndEvents":{"times":[20.836632000000463]},"getNotes":{"times":[4.351440000000366]},"getAuthWitness":{"times":[0.43517400000018824]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.38995000000068103]},"callPrivateFunction":{"times":[141.88889300000028]},"notifyEnqueuedPublicFunctionCall":{"times":[0.21070700000018405]}}},{"functionName":"private_kernel_init","time":280.05678400000033},{"functionName":"ContractInstanceDeployer:deploy","time":75.63751499999944,"oracles":{"storeInExecutionCache":{"times":[0.22493800000029296]},"callPrivateFunction":{"times":[71.44764599999962]},"notifyCreatedNullifier":{"times":[0.49594900000010966]},"debugLog":{"times":[0.28664200000002893]}}},{"functionName":"private_kernel_inner","time":488.29515400000037},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":57.66237600000113,"oracles":{}},{"functionName":"private_kernel_inner","time":418.3665169999995},{"functionName":"private_kernel_reset","time":456.81377800000064},{"functionName":"private_kernel_tail","time":423.4077819999993}],"unaccounted":395.58178300000145}} 12:02:11 [12:02:11.010] INFO: pxe:service Sent transaction 0x23ae28f2ea2509147a30f72d94f2fc4940ee2d3998dcd6ad5a96e4054349c7d0 12:02:11 [12:02:11.009] INFO: node Received tx 0x23ae28f2ea2509147a30f72d94f2fc4940ee2d3998dcd6ad5a96e4054349c7d0 {"txHash":"0x23ae28f2ea2509147a30f72d94f2fc4940ee2d3998dcd6ad5a96e4054349c7d0"} 12:02:20 [12:02:20.188] WARN: aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time 12:02:20 [12:02:20.191] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750939965 12:02:20 [12:02:20.394] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:02:20 [12:02:20.394] WARN: foundation:test-date-provider Time set to 2025-06-26T12:12:45.000Z {"offset":624606,"timeMs":1750939965000} 12:02:20 [12:02:20.763] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2296513210000121s {"duration":0.2296513210000121,"rate":1377967.253234234,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 12:02:20 [12:02:20.795] INFO: sequencer Built block 11 for slot 15 with 1 txs and 0 messages. 1167430.590123412 mana/s {"blockHash":"0x1157ed7e4b8d8c47b0eab3c0ba70599b621474ab7b41d028e60493cfdb692c1c","globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750939964,"version":2896790463},"txHashes":["0x23ae28f2ea2509147a30f72d94f2fc4940ee2d3998dcd6ad5a96e4054349c7d0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":270.9188269999868,"publicProcessDuration":229.840606999991,"rollupCircuitsDuration":264.00022699998226,"txCount":1,"blockNumber":11,"blockTimestamp":1750939964,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:02:21 [12:02:21.010] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:02:21 [12:02:21.020] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 12:02:21 [12:02:21.020] WARN: foundation:test-date-provider Time set to 2025-06-26T12:12:57.000Z {"offset":635980,"timeMs":1750939977000} 12:02:21 [12:02:21.052] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750940000 12:02:21 [12:02:21.052] WARN: foundation:test-date-provider Time set to 2025-06-26T12:13:20.000Z {"offset":658948,"timeMs":1750940000000} 12:02:21 [12:02:21.052] INFO: aztecjs:utils:watcher Slot 15 was filled, jumped to next slot 12:02:21 [12:02:21.202] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3f4481c96076d4c37f9c9b65819f63e0e35e5707 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 11 12:02:21 [12:02:21.203] INFO: aztecjs:cheat_codes Proven tip moved: 10 -> 11. Pending tip: 11. 12:02:21 [12:02:21.276] INFO: archiver Downloaded L2 block 11 {"blockHash":"0x1157ed7e4b8d8c47b0eab3c0ba70599b621474ab7b41d028e60493cfdb692c1c","blockNumber":11,"txCount":1,"globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750939964,"version":2896790463},"archiveRoot":"0x01553f2103ee7819d6ea15ba46b8e1116e1a55c79b3716c3e838c6c25f18d2a5","archiveNextLeafIndex":12} 12:02:21 [12:02:21.278] INFO: archiver Updated proven chain to block 11 {"provenBlockNumber":11} 12:02:21 [12:02:21.623] INFO: world_state World state updated with L2 block 11 {"eventName":"l2-block-handled","duration":7.3426240000117105,"unfinalisedBlockNumber":11,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":11,"blockTimestamp":1750939964,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:02:22 Contract deployed at 0x1d4a6b30802a854ee217c1f2f6bc49246622ede5f6d1e2eff755cea9e8749b88 12:02:22 Contract partial address 0x0bbba7c3c40f2f1bedbfbaab63fdccbec2457afda5c6f3374fd8fdf08fd6dd98 12:02:22 Contract init hash 0x298d3de06520eb9a18e22474266814ffb63d93ec096db44516a76a9dd9bfe1e5 12:02:22 Deployment tx hash: 0x23ae28f2ea2509147a30f72d94f2fc4940ee2d3998dcd6ad5a96e4054349c7d0 12:02:22 Deployment salt: 0x134bd2dc5f2780ac6d2cdfbf424ace2fb2a0168b77b9d594de17789dfe4c224d 12:02:22 Deployment fee: 982553760 12:02:22 Contract stored in database with alias last 12:02:23 Sending kill to pid 451 12:02:23 Sending kill to aztec-start-017250e1