Parent Log: http://ci.aztec-labs.com/202b4985e033a35a Command: 48926e4d3733730d aztec-up/scripts/run_test.sh bridge_and_claim Commit: https://github.com/AztecProtocol/aztec-packages/commit/13c9f60af5c2ea64e96c521ff1b514d2662d819e Env: REF_NAME=gh-readonly-queue/next/pr-15254-1bb4f0588a9dc5b1df622753aab1d907b3f12c7a CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Wed Jun 25 09:14:49 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15254_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_ee64b3b6ca626708_next 09:14:50 Unable to find image 'aztecprotocol/dind:latest' locally 09:14:50 latest: Pulling from aztecprotocol/dind 09:14:50 5b17151e9710: Already exists 09:14:50 b7d75b821e43: Already exists 09:14:50 822577fd7f29: Pulling fs layer 09:14:50 cc3dfb3518bf: Pulling fs layer 09:14:50 cc3dfb3518bf: Download complete 09:14:51 822577fd7f29: Pull complete 09:14:51 cc3dfb3518bf: Pull complete 09:14:51 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b 09:14:51 Status: Downloaded newer image for aztecprotocol/dind:latest 09:14:51 Starting docker... 09:14:56 time="2025-06-25T09:14:51.833151813Z" level=info msg="Starting up" 09:14:56 time="2025-06-25T09:14:51.834297018Z" level=info msg="containerd not running, starting managed containerd" 09:14:56 time="2025-06-25T09:14:51.835099128Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=87 09:14:56 time="2025-06-25T09:14:51.851789856Z" level=info msg="starting containerd" revision=753481ec61c7c8955a23d6ff7bc8e4daed455734 version=1.7.26-1 09:14:56 time="2025-06-25T09:14:51.865752118Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.865960084Z" 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 09:14:56 time="2025-06-25T09:14:51.865977296Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 09:14:56 time="2025-06-25T09:14:51.865990212Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 09:14:56 time="2025-06-25T09:14:51.873323785Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 09:14:56 time="2025-06-25T09:14:51.873345356Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873387901Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873395517Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873542960Z" 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 09:14:56 time="2025-06-25T09:14:51.873557034Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873567953Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873575044Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873605454Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873735006Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 09:14:56 time="2025-06-25T09:14:51.873795503Z" 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 09:14:56 time="2025-06-25T09:14:51.873803586Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 09:14:56 time="2025-06-25T09:14:51.873816178Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 09:14:56 time="2025-06-25T09:14:51.873838984Z" level=info msg="metadata content store policy set" policy=shared 09:14:56 time="2025-06-25T09:14:51.873977916Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 09:14:56 time="2025-06-25T09:14:51.874006501Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 09:14:56 time="2025-06-25T09:14:51.874017014Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 09:14:56 time="2025-06-25T09:14:51.874029009Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 09:14:56 time="2025-06-25T09:14:51.874041909Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 09:14:56 time="2025-06-25T09:14:51.874187327Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 09:14:56 time="2025-06-25T09:14:51.874373760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 09:14:56 time="2025-06-25T09:14:51.874496456Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 09:14:56 time="2025-06-25T09:14:51.874507060Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 09:14:56 time="2025-06-25T09:14:51.874517212Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 09:14:56 time="2025-06-25T09:14:51.874529650Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874538612Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874547954Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874563994Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874573960Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874584811Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874592662Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874601496Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 09:14:56 time="2025-06-25T09:14:51.874616966Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874625881Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874634165Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874643405Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874651790Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874660477Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874668209Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874678767Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874687357Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874697493Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874707097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874716518Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874725165Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874735169Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 09:14:56 time="2025-06-25T09:14:51.874750931Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874763044Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874770031Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 09:14:56 time="2025-06-25T09:14:51.874816368Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 09:14:56 time="2025-06-25T09:14:51.874830266Z" 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 09:14:56 time="2025-06-25T09:14:51.874837550Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 09:14:56 time="2025-06-25T09:14:51.874867748Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 09:14:56 time="2025-06-25T09:14:51.874874048Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 09:14:56 time="2025-06-25T09:14:51.874883037Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 09:14:56 time="2025-06-25T09:14:51.874891820Z" level=info msg="NRI interface is disabled by configuration." 09:14:56 time="2025-06-25T09:14:51.875102397Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock 09:14:56 time="2025-06-25T09:14:51.875181611Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc 09:14:56 time="2025-06-25T09:14:51.875236373Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock 09:14:56 time="2025-06-25T09:14:51.875252261Z" level=info msg="containerd successfully booted in 0.024124s" 09:14:56 time="2025-06-25T09:14:52.837633028Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" 09:14:56 time="2025-06-25T09:14:52.853023851Z" level=info msg="Loading containers: start." 09:14:56 time="2025-06-25T09:14:52.998339668Z" level=info msg="Loading containers: done." 09:14:56 time="2025-06-25T09:14:53.004759119Z" level=info msg="Docker daemon" commit=4c9b3b011ae4c30145a7b344c870bdda01b454e2 containerd-snapshotter=false storage-driver=overlay2 version=27.5.1-1 09:14:56 time="2025-06-25T09:14:53.004921438Z" level=info msg="Daemon has completed initialization" 09:14:56 time="2025-06-25T09:14:53.012196412Z" level=info msg="API listen on /var/run/docker.sock" 09:14:56 Loading image... 09:15:12 Loaded image: aztecprotocol/aztec:latest 09:15:12 Installing scripts in /home/ubuntu/.aztec/bin... 09:15:12 Installed: /home/ubuntu/.aztec/bin/.aztec-run 09:15:12 Installed: /home/ubuntu/.aztec/bin/aztec 09:15:12 Installed: /home/ubuntu/.aztec/bin/aztec-up 09:15:12 Installed: /home/ubuntu/.aztec/bin/aztec-nargo 09:15:12 Installed: /home/ubuntu/.aztec/bin/aztec-wallet 09:15:12 Done! 09:15:13 anvil Version: 1.2.3-dev 09:15:13 Commit SHA: 99634144b6c9371982dcfc551a7975c5dbf9fad8 09:15:13 Build Timestamp: 2025-06-06T06:03:36.170126309Z (1749189816) 09:15:13 Build Profile: maxperf 09:15:17 09:15:17 _ 09:15:17 /\ | | 09:15:17 / \ ___| |_ ___ ___ 09:15:17 / /\ \ |_ / __/ _ \/ __| 09:15:17 / ____ \ / /| || __/ (__ 09:15:17 /_/___ \_\/___|\__\___|\___| 09:15:17 09:15:17 https://github.com/AztecProtocol 09:15:17 09:15:17 09:15:17 Setting up Aztec Sandbox 13c9f60af5c2ea64e96c521ff1b514d2662d819e, please stand by... 09:15:17 Setting up test accounts 09:15:18 [09:15:17.876] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-5PWMK1/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 09:15:18 [09:15:17.931] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 09:15:18 [09:15:17.936] WARN: sandbox Set block interval to 12 09:15:18 [09:15:17.937] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:17.985] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.002] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.021] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.041] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.060] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.089] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.101] INFO: sandbox Waiting for 7 transactions to be mined... 09:15:18 [09:15:18.126] INFO: sandbox All transactions mined successfully 09:15:18 [09:15:18.144] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.168] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.197] INFO: sandbox Waiting for 9 transactions to be mined... 09:15:18 [09:15:18.219] INFO: sandbox All transactions mined successfully 09:15:18 [09:15:18.245] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.257] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.269] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.291] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.315] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.356] INFO: sandbox Waiting for 11 transactions to be mined... 09:15:18 [09:15:18.379] INFO: sandbox All transactions mined successfully 09:15:18 [09:15:18.392] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000001730 09:15:18 [09:15:18.442] INFO: sandbox Waiting for 12 transactions to be mined... 09:15:18 [09:15:18.466] INFO: sandbox All transactions mined successfully 09:15:18 [09:15:18.472] INFO: sandbox Waiting for 12 transactions to be mined... 09:15:18 [09:15:18.492] INFO: sandbox All transactions mined successfully 09:15:18 [09:15:18.505] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0x3db5c28e1e6c32b4a3b5a738b4b356c8f252f84d","governanceAddress":"0x2d48d6f969027fd651adc2ed02519d3658d712fc","governanceProposerAddress":"0x35184accba03f101f73b441b856407b4a407afd3","rollupAddress":"0x7813a13fcba4860e6412ac99d5be7c75a19d6dce","inboxAddress":"0x3f2b7402869edeeaa924fe4a3d9e66af6af63c5d","outboxAddress":"0x5a59afefa5738ea752b1389622e4e92417a99464","feeJuicePortalAddress":"0xd2da5cb6492f8a729b122a4c3531aa94a8704f1c","feeJuiceAddress":"0x4f51bf12ef1a4276c03c599b8e4118e79b4e7ef2","stakingAssetAddress":"0xccc05fd4c23eed3f52912d3c3e3b016cb75403aa","rewardDistributorAddress":"0x159ef7996da0f48bcd3979800c5037bac096308d","gseAddress":"0xf5a0125d5c45596ad61deaf445631096332385dd","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 09:15:18 [09:15:18.505] INFO: sandbox Handing over to governance 09:15:18 [09:15:18.513] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 09:15:18 [09:15:18.517] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 09:15:18 [09:15:18.522] INFO: sandbox Deployed Multicall3 09:15:18 [09:15:18.527] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x7813a13fcBA4860e6412aC99d5be7c75a19D6dce 09:15:18 [09:15:18.528] INFO: telemetry:client Using NoopTelemetryClient 09:15:18 [09:15:18.528] INFO: blob-sink:client Creating local blob sink client. 09:15:18 [09:15:18.535] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:18 [09:15:18.535] WARN: foundation:test-date-provider Time set to 2025-06-25T09:20:25.000Z {"offset":306465,"timeMs":1750843225000} 09:15:18 [09:15:18.553] INFO: archiver:lmdb Starting data store with maxReaders 16 09:15:18 [09:15:18.805] INFO: archiver Starting archiver sync to rollup contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce from L1 block 20 to current L1 block 26 with hash 0x99f791c79c516d8dac86ecef39d7a14f21fbddaed7c8c1e9292872cf571e7087 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x2a00f10846a4dede5297e39a0e66eae98007e2fbff313e7d6340223fb308b5ec","l1BlockNumber":20}} 09:15:18 [09:15:18.818] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:15:18 [09:15:18.825] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-uJ2fzc/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 09:15:18 [09:15:18.846] INFO: world_state Created world state synchroniser with block history of 64 09:15:18 [09:15:18.846] WARN: node Aztec node is accepting fake proofs 09:15:18 [09:15:18.846] INFO: bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers 09:15:18 [09:15:18.858] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:15:18 [09:15:18.859] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:15:18 [09:15:18.860] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:15:18 [09:15:18.861] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:15:18 [09:15:18.864] INFO: world_state Started world state synchronizer from block 1 09:15:19 [09:15:18.867] INFO: p2p Starting p2p client from block 0 with empty mempools 09:15:19 [09:15:19.050] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:15:19 [09:15:19.094] INFO: slasher Starting Slasher client... 09:15:19 [09:15:19.112] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:15:19 [09:15:19.112] 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} 09:15:19 [09:15:19.114] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:15:19 [09:15:19.114] INFO: node Aztec Node version: 13c9f60af5c2ea64e96c521ff1b514d2662d819e 09:15:19 [09:15:19.114] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x7813a13fcba4860e6412ac99d5be7c75a19d6dce","registryAddress":"0x3db5c28e1e6c32b4a3b5a738b4b356c8f252f84d","inboxAddress":"0x3f2b7402869edeeaa924fe4a3d9e66af6af63c5d","outboxAddress":"0x5a59afefa5738ea752b1389622e4e92417a99464","feeJuiceAddress":"0x4f51bf12ef1a4276c03c599b8e4118e79b4e7ef2","stakingAssetAddress":"0xccc05fd4c23eed3f52912d3c3e3b016cb75403aa","feeJuicePortalAddress":"0xd2da5cb6492f8a729b122a4c3531aa94a8704f1c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0x159ef7996da0f48bcd3979800c5037bac096308d","governanceProposerAddress":"0x35184accba03f101f73b441b856407b4a407afd3","governanceAddress":"0x2d48d6f969027fd651adc2ed02519d3658d712fc","slashFactoryAddress":"0x62a79c3323df15b67bcf5c7a3985d75486be2f2e","feeAssetHandlerAddress":"0x9c4c0caf24b1039653516dd9c4488271b18a8251","stakingAssetHandlerAddress":"0x153e97e7f45e2c3a9593c3fe014ec2c0d4780a2a","gseAddress":"0xf5a0125d5c45596ad61deaf445631096332385dd","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 09:15:19 [09:15:19.117] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:15:19 Setting up funded test accounts... 09:15:19 [09:15:19.409] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:15:19 [09:15:19.444] INFO: pxe:service Registered account 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:19 [09:15:19.499] WARN: pxe:service No artifact found for contract class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc when looking for its metadata 09:15:19 [09:15:19.499] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc as part of deployment for 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:19 [09:15:19.634] INFO: pxe:service Added contract SchnorrAccount at 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:22 [09:15:21.814] INFO: pxe:service Proving completed in 2148.6285769999995ms {"timings":{"total":2148.6285769999995,"sync":2.244826000000103,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":86.02548600000318,"oracles":{"callPrivateFunction":{"times":[884.5899950000003,191.78049800000008,110.58983499999977]}}},{"functionName":"private_kernel_init","time":88.28408200000013},{"functionName":"ContractClassRegisterer:register","time":870.0481209999989,"oracles":{"loadCapsule":{"times":[3.500307000000248]},"notifyCreatedNullifier":{"times":[0.5482879999999568]},"debugLog":{"times":[0.44437199999993027]},"notifyCreatedContractClassLog":{"times":[4.840718999999808]}}},{"functionName":"private_kernel_inner","time":115.61664099999962},{"functionName":"SchnorrAccount:constructor","time":184.67144899999948,"oracles":{"getContractInstance":{"times":[0.6623229999995601]},"debugLog":{"times":[0.18910499999947206,0.10327200000028824]},"fetchTaggedLogs":{"times":[27.458512999999584]},"loadCapsule":{"times":[0.32713200000034703,0.23953699999947276,0.2125080000005255,0.1931380000005447,0.42334699999992154,0.20979700000043522]},"bulkRetrieveLogs":{"times":[1.4687459999995554]},"validateEnqueuedNotesAndEvents":{"times":[1.4242670000003272]},"notifyCreatedNullifier":{"times":[0.21844400000009045,0.28008500000032654]},"notifyCreatedNote":{"times":[0.4033849999996164]},"getRandomField":{"times":[0.24266699999952834,0.18126800000027288,0.11234499999955005,0.26643700000022363,0.1172710000000734,0.09923100000014529,0.08659899999929621,0.07670799999959854,0.07903600000008737,0.09521100000074512,0.0764710000003106]},"getIndexedTaggingSecretAsSender":{"times":[13.396687999999813]},"incrementAppTaggingSecretIndexAsSender":{"times":[9.632189999999355]}}},{"functionName":"private_kernel_inner","time":104.1145749999996},{"functionName":"SchnorrAccount:entrypoint","time":103.76989099999992,"oracles":{"debugLog":{"times":[0.1794900000004418,0.10647599999992963,0.2865799999999581]},"fetchTaggedLogs":{"times":[26.04687399999966]},"loadCapsule":{"times":[0.23912399999971967,0.46512299999994866,0.2322889999995823,0.20118900000034046,0.14881599999989703,0.16288499999973283]},"bulkRetrieveLogs":{"times":[0.9520359999996799]},"validateEnqueuedNotesAndEvents":{"times":[1.0900840000003882]},"getNotes":{"times":[1.6243139999996856]},"getAuthWitness":{"times":[0.2925179999992906]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8376060000000507]}}},{"functionName":"private_kernel_inner","time":97.21978399999989},{"functionName":"private_kernel_reset","time":174.58489999999983},{"functionName":"private_kernel_tail","time":68.86250699999982}],"unaccounted":253.186314999999}} 09:15:22 [09:15:21.906] INFO: node Received tx 0x198585da69df6aa1b1d8366c3918133ef726bb50c751fd7d5e247aa38531538a {"txHash":"0x198585da69df6aa1b1d8366c3918133ef726bb50c751fd7d5e247aa38531538a"} 09:15:22 [09:15:21.906] INFO: pxe:service Sent transaction 0x198585da69df6aa1b1d8366c3918133ef726bb50c751fd7d5e247aa38531538a 09:15:22 [09:15:22.456] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03161002499999995s {"duration":0.03161002499999995,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:15:22 [09:15:22.484] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x18906ab50deb1e81baa70bddb2cce606a78bf6ef2b3c8a79968c5a02ba2ae139","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750843225,"version":2687597111},"txHashes":["0x198585da69df6aa1b1d8366c3918133ef726bb50c751fd7d5e247aa38531538a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.38742300000013,"publicProcessDuration":32.11271099999976,"rollupCircuitsDuration":62.07492999999886,"txCount":1,"blockNumber":1,"blockTimestamp":1750843225,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:15:25 [09:15:25.214] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:25 [09:15:25.223] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843261 09:15:25 [09:15:25.223] WARN: foundation:test-date-provider Time set to 2025-06-25T09:21:01.000Z {"offset":335777,"timeMs":1750843261000} 09:15:25 [09:15:25.223] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:15:25 [09:15:25.312] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:15:25 [09:15:25.314] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:15:25 [09:15:25.468] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x18906ab50deb1e81baa70bddb2cce606a78bf6ef2b3c8a79968c5a02ba2ae139","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750843225,"version":2687597111},"archiveRoot":"0x0764effa6a1cf3c0ffc665e42d93e3b35abf2d8c067395ba62acd78056e32995","archiveNextLeafIndex":2} 09:15:25 [09:15:25.471] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:15:25 [09:15:25.550] INFO: pxe:service Registered account 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 09:15:25 [09:15:25.640] INFO: pxe:service Added contract SchnorrAccount at 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:25 [09:15:25.688] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.681864000000132,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750843225,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:15:26 [09:15:26.708] INFO: pxe:service Proving completed in 1047.3631380000006ms {"timings":{"total":1047.3631380000006,"sync":12.463610000000699,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":62.74787900000047,"oracles":{"callPrivateFunction":{"times":[181.25644099999954,163.58966899999905]}}},{"functionName":"private_kernel_init","time":48.430333999998766},{"functionName":"SchnorrAccount:constructor","time":174.75353900000118,"oracles":{"getContractInstance":{"times":[1.6706279999998515]},"debugLog":{"times":[0.14767100000062783,0.10222500000054424]},"fetchTaggedLogs":{"times":[42.03316799999993]},"loadCapsule":{"times":[0.22677399999884074,0.22654700000020966,0.22343399999954272,0.29985499999929743,0.21726899999885063,0.19261899999946763]},"bulkRetrieveLogs":{"times":[2.4994020000012824]},"validateEnqueuedNotesAndEvents":{"times":[3.979577000000063]},"notifyCreatedNullifier":{"times":[0.24678099999982805,0.25285900000017136]},"notifyCreatedNote":{"times":[0.14204000000063388]},"getRandomField":{"times":[0.1295590000008815,0.1765479999994568,0.12099099999977625,0.09011899999859452,0.0830789999999979,0.06758499999887135,0.06965399999899091,0.05907699999988836,0.06364600000051723,0.06627500000104192,0.06943599999976868]},"getIndexedTaggingSecretAsSender":{"times":[22.940424999998868]},"incrementAppTaggingSecretIndexAsSender":{"times":[9.77834299999995]}}},{"functionName":"private_kernel_inner","time":105.87753899999916},{"functionName":"SchnorrAccount:entrypoint","time":153.82023599999957,"oracles":{"debugLog":{"times":[0.3715589999992517,0.1067879999991419,0.160345000000234]},"fetchTaggedLogs":{"times":[56.53512699999919]},"loadCapsule":{"times":[0.22407600000042294,0.2107400000004418,0.22349799999938114,0.25658999999905063,0.2027959999995801,0.14741700000013225]},"bulkRetrieveLogs":{"times":[2.898082000001523]},"validateEnqueuedNotesAndEvents":{"times":[2.1436670000002778]},"getNotes":{"times":[2.201199999999517]},"getAuthWitness":{"times":[0.17105799999990268]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3922760000004928]}}},{"functionName":"private_kernel_inner","time":97.39487699999881},{"functionName":"private_kernel_reset","time":170.69579200000044},{"functionName":"private_kernel_tail","time":66.87287400000059}],"unaccounted":154.30645800000093}} 09:15:26 [09:15:26.741] INFO: node Received tx 0x2442ee4d102be157c8fffb2f997aff0e62c5c0f14c40db8d5f9d3ec073f7caeb {"txHash":"0x2442ee4d102be157c8fffb2f997aff0e62c5c0f14c40db8d5f9d3ec073f7caeb"} 09:15:26 [09:15:26.741] INFO: pxe:service Sent transaction 0x2442ee4d102be157c8fffb2f997aff0e62c5c0f14c40db8d5f9d3ec073f7caeb 09:15:27 [09:15:27.275] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019461819000000106s {"duration":0.019461819000000106,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:15:27 [09:15:27.297] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e363bdb9d07893320db5f381a08457f2185d895f60b3475b3c5c7fe32bf7951","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750843261,"version":2687597111},"txHashes":["0x2442ee4d102be157c8fffb2f997aff0e62c5c0f14c40db8d5f9d3ec073f7caeb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":50.41442800000004,"publicProcessDuration":19.55581499999971,"rollupCircuitsDuration":45.61975200000052,"txCount":1,"blockNumber":2,"blockTimestamp":1750843261,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:27 [09:15:27.478] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:27 [09:15:27.535] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:27 [09:15:27.535] WARN: foundation:test-date-provider Time set to 2025-06-25T09:21:13.000Z {"offset":345465,"timeMs":1750843273000} 09:15:27 [09:15:27.539] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 09:15:27 [09:15:27.540] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 09:15:27 [09:15:27.579] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843297 09:15:27 [09:15:27.579] WARN: foundation:test-date-provider Time set to 2025-06-25T09:21:37.000Z {"offset":369421,"timeMs":1750843297000} 09:15:27 [09:15:27.579] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 09:15:27 [09:15:27.802] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0e363bdb9d07893320db5f381a08457f2185d895f60b3475b3c5c7fe32bf7951","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750843261,"version":2687597111},"archiveRoot":"0x2fb0c85e3c49ad19dd74fa0faab4a1addbcbd70ce015daa35705b713f9845799","archiveNextLeafIndex":3} 09:15:27 [09:15:27.803] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 09:15:27 [09:15:27.902] INFO: pxe:service Registered account 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab 09:15:28 [09:15:27.988] INFO: pxe:service Added contract SchnorrAccount at 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:28 [09:15:28.025] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":4.307168999999703,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750843261,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:29 [09:15:28.966] INFO: pxe:service Proving completed in 959.1520600000003ms {"timings":{"total":959.1520600000003,"sync":10.142807000000175,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":55.32173999999941,"oracles":{"callPrivateFunction":{"times":[154.07877800000097,139.9981399999997]}}},{"functionName":"private_kernel_init","time":46.979495999999926},{"functionName":"SchnorrAccount:constructor","time":147.67157099999895,"oracles":{"getContractInstance":{"times":[0.4608280000011291]},"debugLog":{"times":[0.12170299999888812,0.06934699999874283]},"fetchTaggedLogs":{"times":[41.39348799999971]},"loadCapsule":{"times":[0.16463000000112515,0.1447889999999461,0.1291220000002795,0.12009500000021944,0.11821799999961513,0.13459899999907066]},"bulkRetrieveLogs":{"times":[0.7111340000010387]},"validateEnqueuedNotesAndEvents":{"times":[0.9555330000002868]},"notifyCreatedNullifier":{"times":[0.19411200000104145,0.29563799999959883]},"notifyCreatedNote":{"times":[0.10210399999959918]},"getRandomField":{"times":[0.11173600000074657,0.14828300000044692,0.12215399999877263,0.08212000000094122,0.0815679999996064,0.06291299999975308,0.05098100000031991,0.06161999999858381,0.05101699999977427,0.05753999999978987,0.05884700000024168]},"getIndexedTaggingSecretAsSender":{"times":[13.78951700000107]},"incrementAppTaggingSecretIndexAsSender":{"times":[10.398836000000301]}}},{"functionName":"private_kernel_inner","time":102.78373900000042},{"functionName":"SchnorrAccount:entrypoint","time":131.83541500000138,"oracles":{"debugLog":{"times":[0.14490400000067893,0.0850060000011581,0.14132599999902595]},"fetchTaggedLogs":{"times":[58.92206900000019]},"loadCapsule":{"times":[0.16584900000088965,0.13723399999980757,0.1576629999999568,0.1299269999999524,0.1171329999997397,0.11834500000077242]},"bulkRetrieveLogs":{"times":[0.7312379999984842]},"validateEnqueuedNotesAndEvents":{"times":[0.8977739999991172]},"getNotes":{"times":[1.107495000000199]},"getAuthWitness":{"times":[0.14260800000010931]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.38362299999971583]}}},{"functionName":"private_kernel_inner","time":96.35659499999929},{"functionName":"private_kernel_reset","time":171.53245900000002},{"functionName":"private_kernel_tail","time":66.94250800000009}],"unaccounted":129.5857300000007}} 09:15:29 [09:15:28.998] INFO: node Received tx 0x0dfa635ce55dbb5939681e4f7b19d4a594f86510d7cb82156960ab2c10a10f38 {"txHash":"0x0dfa635ce55dbb5939681e4f7b19d4a594f86510d7cb82156960ab2c10a10f38"} 09:15:29 [09:15:28.998] INFO: pxe:service Sent transaction 0x0dfa635ce55dbb5939681e4f7b19d4a594f86510d7cb82156960ab2c10a10f38 09:15:29 [09:15:29.167] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.015225459999999658s {"duration":0.015225459999999658,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:15:29 [09:15:29.193] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1aa07f0f119a99e3c1063fcd06c247105b9d19563ff8c7e715615ad1523f6367","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750843297,"version":2687597111},"txHashes":["0x0dfa635ce55dbb5939681e4f7b19d4a594f86510d7cb82156960ab2c10a10f38"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.85454800000116,"publicProcessDuration":15.312004000001252,"rollupCircuitsDuration":42.273285000001124,"txCount":1,"blockNumber":3,"blockTimestamp":1750843297,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:29 [09:15:29.370] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:29 [09:15:29.388] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:29 [09:15:29.389] WARN: foundation:test-date-provider Time set to 2025-06-25T09:21:49.000Z {"offset":379612,"timeMs":1750843309000} 09:15:29 [09:15:29.392] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 09:15:29 [09:15:29.393] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 09:15:29 [09:15:29.440] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843333 09:15:29 [09:15:29.440] WARN: foundation:test-date-provider Time set to 2025-06-25T09:22:13.000Z {"offset":403560,"timeMs":1750843333000} 09:15:29 [09:15:29.440] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 09:15:29 Initial Accounts: 09:15:29 09:15:29 Address: 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:29 Partial Address: 0x03213efa5c71f14140e2f9d8dfff8c57f1469bf08de259e50fb29677c73b0557 09:15:29 Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 09:15:29 Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 09:15:29 Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 09:15:29 09:15:29 Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 09:15:29 09:15:29 Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 09:15:29 09:15:29 Address: 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 09:15:29 Partial Address: 0x06a45d1affaf6ab7d3bb58205eb9149330bc086fea16e70053e2999bea3a7cd5 09:15:29 Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 09:15:29 Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 09:15:29 Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 09:15:29 09:15:29 Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 09:15:29 09:15:29 Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 09:15:29 09:15:29 Address: 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab 09:15:29 Partial Address: 0x2d47cd00f125a60c5294ed4436e101e1acaec36678452917015bfc16bf75fd3e 09:15:29 Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 09:15:29 Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 09:15:29 Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 09:15:29 09:15:29 Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 09:15:29 09:15:29 Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 09:15:29 09:15:29 09:15:29 [09:15:29.529] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1aa07f0f119a99e3c1063fcd06c247105b9d19563ff8c7e715615ad1523f6367","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750843297,"version":2687597111},"archiveRoot":"0x0311b4ed2bc4f2253b92e62cd36e602091d4daee21236de4f39f4dd924697ef1","archiveNextLeafIndex":4} 09:15:29 [09:15:29.531] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 09:15:30 [09:15:30.127] WARN: pxe:service No artifact found for contract class 0x2968c5eec7684ca36d400813f5021e255a4b490cea302aa2abb133d91d5a68b4 when looking for its metadata 09:15:30 [09:15:30.127] WARN: pxe:service No artifact found for contract class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 when looking for its metadata 09:15:30 [09:15:30.131] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2968c5eec7684ca36d400813f5021e255a4b490cea302aa2abb133d91d5a68b4 as part of deployment for 0x1bab5e14e6517101fa803f7e0855a8233acf6ff954673d6436d3ebf0d763519a 09:15:30 [09:15:30.149] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 as part of deployment for 0x0c4e4f325ccc8f392177df57888155552cfd5aa34e3ebba227fbaf7399382e54 09:15:30 [09:15:30.339] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":4.154686000001675,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750843297,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:30 [09:15:30.784] INFO: pxe:service Added contract FPC at 0x1bab5e14e6517101fa803f7e0855a8233acf6ff954673d6436d3ebf0d763519a with class 0x2968c5eec7684ca36d400813f5021e255a4b490cea302aa2abb133d91d5a68b4 09:15:30 [09:15:30.786] INFO: pxe:service Added contract Token at 0x0c4e4f325ccc8f392177df57888155552cfd5aa34e3ebba227fbaf7399382e54 with class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 09:15:32 [09:15:32.700] INFO: pxe:service Proving completed in 1865.0268099999994ms {"timings":{"total":1865.0268099999994,"sync":25.342153999998118,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":167.5726539999996,"oracles":{"debugLog":{"times":[0.16634700000213343,0.08355999999912456,0.0895120000022871,0.14279200000237324,0.1328910000011092,0.11273499999879277,0.07586600000286126,0.159204999999929]},"fetchTaggedLogs":{"times":[48.304213999999774]},"loadCapsule":{"times":[0.17386199999964447,0.15208799999891198,0.22564499999862164,1.5301600000020699,0.17692499999975553,0.16217600000163657,0.12683599999945727,0.11547200000131852,0.11575299999822164,0.12726199999815435]},"getSharedSecret":{"times":[3.7369349999971746]},"aes128Decrypt":{"times":[0.9687139999987266,0.6668639999988955]},"getPublicKeysAndPartialAddress":{"times":[2.711131000000023]},"getKeyValidationRequest":{"times":[6.804425999998784]},"storeCapsule":{"times":[1.0845829999998386,0.2799700000032317,0.21591300000000047]},"deleteCapsule":{"times":[0.3700779999999213]},"bulkRetrieveLogs":{"times":[0.8215359999994689]},"validateEnqueuedNotesAndEvents":{"times":[3.983197999998083]},"getNotes":{"times":[1.6471270000001823]},"getAuthWitness":{"times":[0.17278499999883934]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04883200000040233]},"callPrivateFunction":{"times":[758.3894,85.44600400000127]},"notifyEnqueuedPublicFunctionCall":{"times":[0.24534700000003795]}}},{"functionName":"private_kernel_init","time":53.975814000001265},{"functionName":"ContractClassRegisterer:register","time":750.547502999998,"oracles":{"loadCapsule":{"times":[2.224925999998959]},"notifyCreatedNullifier":{"times":[0.27572499999951106]},"debugLog":{"times":[0.11859100000219769]},"notifyCreatedContractClassLog":{"times":[3.7433139999993728]}}},{"functionName":"private_kernel_inner","time":100.63742999999886},{"functionName":"ContractInstanceDeployer:deploy","time":58.351438000005146,"oracles":{"storeInExecutionCache":{"times":[0.219797000001563]},"callPrivateFunction":{"times":[31.579486999999062]},"notifyCreatedNullifier":{"times":[0.28519600000072387]},"debugLog":{"times":[0.13180900000224938]}}},{"functionName":"private_kernel_inner","time":99.10900200000106},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":20.14030399999683,"oracles":{}},{"functionName":"private_kernel_inner","time":99.966633},{"functionName":"private_kernel_reset","time":175.86596000000281},{"functionName":"private_kernel_tail","time":78.6465070000013}],"unaccounted":234.87141099999644}} 09:15:32 [09:15:32.798] INFO: node Received tx 0x0b51a625edf213616a867a29e7a3353757d5258de29122df7285442d5b2ff965 {"txHash":"0x0b51a625edf213616a867a29e7a3353757d5258de29122df7285442d5b2ff965"} 09:15:32 [09:15:32.799] INFO: pxe:service Sent transaction 0x0b51a625edf213616a867a29e7a3353757d5258de29122df7285442d5b2ff965 09:15:34 [09:15:34.639] INFO: pxe:service Proving completed in 1938.1867620000012ms {"timings":{"total":1938.1867620000012,"sync":86.4969170000004,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":160.8695019999941,"oracles":{"debugLog":{"times":[0.12673699999868404,0.07769699999698787,0.07610399999975925,0.13738000000012107,0.10046200000215322,0.06627799999841955,0.06826399999772548,0.13808799999969779]},"fetchTaggedLogs":{"times":[43.654123000000254]},"loadCapsule":{"times":[0.15487600000051316,0.14830799999981537,0.23607799999808776,0.16397199999846634,0.1385039999986475,0.11964699999953154,0.1316789999982575,0.10208300000158488,0.11086599999907776,0.09835499999826425]},"getSharedSecret":{"times":[3.5145809999994526]},"aes128Decrypt":{"times":[0.19746899999881862,0.5421930000011344]},"getPublicKeysAndPartialAddress":{"times":[1.0365920000003825]},"getKeyValidationRequest":{"times":[1.5196130000003905]},"storeCapsule":{"times":[0.27338400000007823,0.1722070000032545,0.16305900000224938]},"deleteCapsule":{"times":[0.172099999999773]},"bulkRetrieveLogs":{"times":[0.6472909999974945]},"validateEnqueuedNotesAndEvents":{"times":[2.75345500000185]},"getNotes":{"times":[1.5216810000019905]},"getAuthWitness":{"times":[0.17251099999703]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04784799999833922]},"callPrivateFunction":{"times":[757.1376310000014,90.08816500000103]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10988100000031409]}}},{"functionName":"private_kernel_init","time":47.50354000000152},{"functionName":"ContractClassRegisterer:register","time":749.5846180000008,"oracles":{"loadCapsule":{"times":[1.800108999999793]},"notifyCreatedNullifier":{"times":[0.3018080000001646]},"debugLog":{"times":[0.11496600000100443]},"notifyCreatedContractClassLog":{"times":[3.482919000001857]}}},{"functionName":"private_kernel_inner","time":100.77448300000106},{"functionName":"ContractInstanceDeployer:deploy","time":54.611354000000574,"oracles":{"storeInExecutionCache":{"times":[0.08128299999953015]},"callPrivateFunction":{"times":[35.755936000001384]},"notifyCreatedNullifier":{"times":[0.2652089999974123]},"debugLog":{"times":[0.13120399999752408]}}},{"functionName":"private_kernel_inner","time":98.5280559999992},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":26.797613999999157,"oracles":{}},{"functionName":"private_kernel_inner","time":100.22500500000024},{"functionName":"private_kernel_reset","time":173.29285199999867},{"functionName":"private_kernel_tail","time":78.25335399999676}],"unaccounted":261.24946700000874}} 09:15:34 [09:15:34.746] INFO: node Received tx 0x199576d9290f18c1cd17aab17f54144bda9982891741b775e952bffc3cd7e0ed {"txHash":"0x199576d9290f18c1cd17aab17f54144bda9982891741b775e952bffc3cd7e0ed"} 09:15:34 [09:15:34.746] INFO: pxe:service Sent transaction 0x199576d9290f18c1cd17aab17f54144bda9982891741b775e952bffc3cd7e0ed 09:15:34 [09:15:34.817] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.9959079469999997s {"duration":0.9959079469999997,"rate":39954.49591487195,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 09:15:34 [09:15:34.846] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 37528.467536840915 mana/s {"blockHash":"0x2f8776bc2af52d1332f79125882ceef8d6c8b241e20ef8f7e11eef80a22b165d","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750843333,"version":2687597111},"txHashes":["0x0b51a625edf213616a867a29e7a3353757d5258de29122df7285442d5b2ff965"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1060.2255299999997,"publicProcessDuration":996.0179129999997,"rollupCircuitsDuration":1053.7784429999992,"txCount":1,"blockNumber":4,"blockTimestamp":1750843333,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 09:15:35 [09:15:35.047] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:35 [09:15:35.074] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:35 [09:15:35.074] WARN: foundation:test-date-provider Time set to 2025-06-25T09:22:25.000Z {"offset":409926,"timeMs":1750843345000} 09:15:35 [09:15:35.099] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 09:15:35 [09:15:35.100] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 09:15:35 [09:15:35.149] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843369 09:15:35 [09:15:35.149] WARN: foundation:test-date-provider Time set to 2025-06-25T09:22:49.000Z {"offset":433851,"timeMs":1750843369000} 09:15:35 [09:15:35.149] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 09:15:35 [09:15:35.283] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x2f8776bc2af52d1332f79125882ceef8d6c8b241e20ef8f7e11eef80a22b165d","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750843333,"version":2687597111},"archiveRoot":"0x267c8dacd5f38e6c6551d70547d358150e1f622613e8f0c075f44999fc5f334e","archiveNextLeafIndex":5} 09:15:35 [09:15:35.285] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 09:15:35 [09:15:35.309] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":4.534577999998874,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750843333,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 09:15:35 [09:15:35.745] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.16625334899999872s {"duration":0.16625334899999872,"rate":1903432.3332638696,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 09:15:35 [09:15:35.794] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 1425762.3055023022 mana/s {"blockHash":"0x14da951bfaf01f9975244e389c138d36f6bbdbf1a5e881878cfd0ce19b48ffc4","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750843369,"version":2687597111},"txHashes":["0x199576d9290f18c1cd17aab17f54144bda9982891741b775e952bffc3cd7e0ed"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":221.92645400000038,"publicProcessDuration":166.75180900000123,"rollupCircuitsDuration":217.34026699999959,"txCount":1,"blockNumber":5,"blockTimestamp":1750843369,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:15:35 [09:15:35.931] INFO: aztecjs:deploy_sent_tx Contract 0x1bab5e14e6517101fa803f7e0855a8233acf6ff954673d6436d3ebf0d763519a successfully deployed. 09:15:36 [09:15:36.063] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:36 [09:15:36.114] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:36 [09:15:36.115] WARN: foundation:test-date-provider Time set to 2025-06-25T09:23:01.000Z {"offset":444886,"timeMs":1750843381000} 09:15:36 [09:15:36.135] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 09:15:36 [09:15:36.137] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 09:15:36 [09:15:36.268] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843405 09:15:36 [09:15:36.268] WARN: foundation:test-date-provider Time set to 2025-06-25T09:23:25.000Z {"offset":468732,"timeMs":1750843405000} 09:15:36 [09:15:36.268] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 09:15:36 [09:15:36.496] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x14da951bfaf01f9975244e389c138d36f6bbdbf1a5e881878cfd0ce19b48ffc4","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750843369,"version":2687597111},"archiveRoot":"0x0f995ced5800d4c5fe05ee8faaba421350d01ef9edcef0970996765781d0b5f3","archiveNextLeafIndex":6} 09:15:36 [09:15:36.501] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 09:15:36 BananaCoin: 0x0c4e4f325ccc8f392177df57888155552cfd5aa34e3ebba227fbaf7399382e54 09:15:36 FPC: 0x1bab5e14e6517101fa803f7e0855a8233acf6ff954673d6436d3ebf0d763519a 09:15:37 [09:15:36.795] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":4.694288999999117,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750843369,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:15:37 [09:15:36.960] INFO: aztecjs:deploy_sent_tx Contract 0x0c4e4f325ccc8f392177df57888155552cfd5aa34e3ebba227fbaf7399382e54 successfully deployed. 09:15:37 [09:15:36.986] WARN: pxe:service No artifact found for contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 when looking for its metadata 09:15:37 [09:15:36.988] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 as part of deployment for 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 09:15:37 [09:15:37.096] INFO: pxe:service Added contract SponsoredFPC at 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 with class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 09:15:39 [09:15:38.936] INFO: pxe:service Proving completed in 1818.9366029999983ms {"timings":{"total":1818.9366029999983,"sync":8.542997000000469,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":40.515625000007276,"oracles":{"callPrivateFunction":{"times":[756.1192139999985,84.80933800000275,15.129048999999213]}}},{"functionName":"private_kernel_init","time":50.09374899999966},{"functionName":"ContractClassRegisterer:register","time":747.9592069999999,"oracles":{"loadCapsule":{"times":[1.7652200000011362]},"notifyCreatedNullifier":{"times":[0.2779659999978321]},"debugLog":{"times":[0.10595500000272295]},"notifyCreatedContractClassLog":{"times":[3.449925999997504]}}},{"functionName":"private_kernel_inner","time":100.33741999999984},{"functionName":"ContractInstanceDeployer:deploy","time":51.90174599999955,"oracles":{"storeInExecutionCache":{"times":[0.07988100000147824]},"callPrivateFunction":{"times":[34.00199299999804]},"notifyCreatedNullifier":{"times":[0.2401220000028843]},"debugLog":{"times":[0.13867599999866798]}}},{"functionName":"private_kernel_inner","time":99.86040700000012},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.15753499999846,"oracles":{}},{"functionName":"private_kernel_inner","time":100.1133919999993},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":11.543484999998327,"oracles":{"debugLog":{"times":[0.11614800000097603]}}},{"functionName":"private_kernel_inner","time":95.31905199999892},{"functionName":"private_kernel_reset","time":169.31613500000094},{"functionName":"private_kernel_tail","time":67.49537299999793}],"unaccounted":248.78047999999762}} 09:15:39 [09:15:39.009] INFO: node Received tx 0x293b6bc3aeebaadfc7ac6b5e998a4889d8d2c24eedf3162c69e4e68d5fa7db40 {"txHash":"0x293b6bc3aeebaadfc7ac6b5e998a4889d8d2c24eedf3162c69e4e68d5fa7db40"} 09:15:39 [09:15:39.009] INFO: pxe:service Sent transaction 0x293b6bc3aeebaadfc7ac6b5e998a4889d8d2c24eedf3162c69e4e68d5fa7db40 09:15:39 [09:15:39.139] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.023490476999999375s {"duration":0.023490476999999375,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 09:15:39 [09:15:39.163] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2c0d5b647d66760740af6d2acd1253aa4d0a4053502fdb290d05b778244d2dec","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750843405,"version":2687597111},"txHashes":["0x293b6bc3aeebaadfc7ac6b5e998a4889d8d2c24eedf3162c69e4e68d5fa7db40"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":53.09133099999963,"publicProcessDuration":23.60864699999729,"rollupCircuitsDuration":48.466615000001184,"txCount":1,"blockNumber":6,"blockTimestamp":1750843405,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:15:39 [09:15:39.339] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:39 [09:15:39.359] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:39 [09:15:39.359] WARN: foundation:test-date-provider Time set to 2025-06-25T09:23:37.000Z {"offset":477641,"timeMs":1750843417000} 09:15:39 [09:15:39.363] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 09:15:39 [09:15:39.364] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 09:15:39 [09:15:39.427] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843441 09:15:39 [09:15:39.427] WARN: foundation:test-date-provider Time set to 2025-06-25T09:24:01.000Z {"offset":501573,"timeMs":1750843441000} 09:15:39 [09:15:39.427] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 09:15:39 [09:15:39.483] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x2c0d5b647d66760740af6d2acd1253aa4d0a4053502fdb290d05b778244d2dec","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750843405,"version":2687597111},"archiveRoot":"0x0a12d03db5d32b85f00b5faa66a2aaa2c50ae242074c46d6472cef14f3b6bad3","archiveNextLeafIndex":7} 09:15:39 [09:15:39.486] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 09:15:39 [09:15:39.501] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":4.282114000001457,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750843405,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:15:40 SponsoredFPC: 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 09:15:40 [09:15:40.018] INFO: aztecjs:deploy_sent_tx Contract 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 successfully deployed. 09:15:40 [09:15:40.022] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x0363c27526bec114970a086e1ff6c5b1d60ee5a30e0149c98777a44f01b8d25d","l2ProtocolContractsTreeRoot":"0x1739eebf180a05a4689f971f4f1d44a550a31bad946a06e28a0746d0db95bde0"} 09:15:41 Registering protocol contract aliases... 09:15:41 Data stored in database with alias contracts:AuthRegistry 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000001 09:15:41 Data stored in database with alias contracts:ContractInstanceDeployer 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000002 09:15:41 Data stored in database with alias contracts:ContractClassRegisterer 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000003 09:15:41 Data stored in database with alias contracts:MultiCallEntrypoint 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000004 09:15:41 Data stored in database with alias contracts:FeeJuice 09:15:41 [09:15:41.600] INFO: wallet Using local PXE service 09:15:41 [09:15:41.601] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000005 09:15:41 Data stored in database with alias contracts:Router 09:15:41 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000006 09:15:41 [09:15:41.740] 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) 09:15:41 [09:15:41.742] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:15:42 Account stored in database with aliases last & test0 09:15:42 09:15:42 Test account: 09:15:42 Alias: test0 09:15:42 Address: 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:42 Secret key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 09:15:42 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 09:15:42 Account stored in database with aliases last & test1 09:15:42 09:15:42 Test account: 09:15:42 Alias: test1 09:15:42 Address: 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 09:15:42 Secret key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 09:15:42 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 09:15:42 Account stored in database with aliases last & test2 09:15:42 09:15:42 Test account: 09:15:42 Alias: test2 09:15:42 Address: 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab 09:15:42 Secret key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 09:15:42 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 09:15:42 09:15:42 3 test accounts imported to wallet db. 09:15:42 09:15:42 [09:15:42.296] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:15:42 [09:15:42.595] INFO: pxe:service Added contract SchnorrAccount at 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:42 [09:15:42.599] INFO: pxe:service Added contract SchnorrAccount at 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:42 [09:15:42.613] INFO: pxe:service Added contract SchnorrAccount at 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:42 [09:15:42.690] INFO: pxe:service Registered account 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:42 [09:15:42.695] INFO: pxe:service Registered account 0x10a047cbdb7bfe7fb5f77a8ef0a38ad92805da3122fbaf644f1da92a3ec60de8 09:15:42 [09:15:42.701] INFO: pxe:service Registered account 0x0e852a7489e397d6ec2f7d9ea920e1e24bcce24428ed1b3e83c00350a1b907ab 09:15:44 [09:15:44.634] INFO: wallet Using local PXE service 09:15:44 [09:15:44.635] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:15:44 [09:15:44.679] 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) 09:15:44 [09:15:44.681] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:15:45 09:15:45 New account: 09:15:45 09:15:45 Address: 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf 09:15:45 Public key: 0x225ad6d41e110f6c09aa9a7b9fe22421d76e2f882e8f042a373e0ddbab650b8b27ec8cdb48ce24a8c67cc29da7144bc662411c4d06f74b9ab0a30769b96e7eaf2506aa3b3974adc3a60af9b8bb68c7bb97c546121f788539128f2826ac450ddd1afe1d6d71a1bd0abcfd677fe5788c37097cb3d05de136428098fd6dfc84c2b81c4b7351967009c9d89e36eed119947d23e0086586c21fc034b53a82f486b62b12377f98c3c8013bd3c62aacaafce1745426806484b7ad86cfa693bb1695e5e22c675f6d9eb53b6711948a336784c19beb28f4c43e9892747337611362e1004e22449bd7a577d68f7e34f9e3435ecaf9773477143d7a239dd4aad1aefd9d7cc3 09:15:45 Secret key: 0x2a83c1cf4487afd381956b831cef8f8427d20f224c4dac7d255489f965781f71 09:15:45 Partial address: 0x0f9ad3bdb1f0cd98bf477aa622e5cf2e17aa7392efbf511575447ec5eee39605 09:15:45 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 09:15:45 Init hash: 0x24a9284e2c3b7e180509bbebf7c9d41ade73df04500ac6d7c11084ec46778670 09:15:45 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 09:15:45 Account stored in database with aliases last & main 09:15:45 [09:15:45.228] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:15:45 [09:15:45.360] INFO: pxe:service Added contract SchnorrAccount at 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:15:45 [09:15:45.406] INFO: pxe:service Registered account 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf 09:15:47 [09:15:47.631] INFO: wallet Using local PXE service 09:15:47 [09:15:47.632] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:15:47 [09:15:47.944] 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) 09:15:47 [09:15:47.945] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:15:48 Minted 1000000000000000000 fee juice on L1 and pushed to L2 portal 09:15:48 claimAmount=1000000000000000000,claimSecret=0x2de6bc2b439f1e5ddd05b0e84db38996698288d63939fd2a9ea96b5757dbcfc5,messageHash=0x0011e56a3aa947e325159ab1dbec523515df2bb04151b7f80653d767d1c89176,messageLeafIndex=112 09:15:48 09:15:48 Note: You need to wait for two L2 blocks before pulling them from the L2 side 09:15:48 Pushed 1000000000000000000 fee juice for recipient 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf. Stack pointer 1 09:15:48 [09:15:48.490] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:15:48 [09:15:48.610] INFO: wallet Minting 1000000000000000000 tokens for 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 09:15:48 [09:15:48.633] INFO: wallet Approving 1000000000000000000 tokens for FeeJuice Portal (0xd2da5cb6492f8a729b122a4c3531aa94a8704f1c) 09:15:48 [09:15:48.654] INFO: wallet Sending L1 Fee Juice to L2 to be claimed publicly 09:15:48 [09:15:48.670] INFO: wallet Deposited to Aztec public successfully 09:15:49 [09:15:48.641] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:49 [09:15:48.641] WARN: foundation:test-date-provider Time set to 2025-06-25T09:24:13.000Z {"offset":504359,"timeMs":1750843453000} 09:15:49 [09:15:48.729] INFO: archiver Retrieved 1 new L1 to L2 messages up to message with index 112 for L2 block 8 {"lastMessage":{"index":112,"l1BlockHash":"0x5cb6205c0c388723a538212bd7f6abeb435b51a7d81124f6f01e94e691d6902c","l1BlockNumber":41,"l2BlockNumber":8,"leaf":"0x0011e56a3aa947e325159ab1dbec523515df2bb04151b7f80653d767d1c89176","rollingHash":"0x32808bab2c9f678901632f8a65911aeb"},"messageCount":1} 09:15:49 [09:15:48.844] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:15:49 [09:15:48.844] WARN: foundation:test-date-provider Time set to 2025-06-25T09:24:37.000Z {"offset":528156,"timeMs":1750843477000} 09:15:54 [09:15:54.815] INFO: wallet Using local PXE service 09:15:54 [09:15:54.816] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:15:54 [09:15:54.863] 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) 09:15:54 [09:15:54.864] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:15:55 [09:15:55.406] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:15:55 [09:15:55.462] INFO: wallet Using wallet with address 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:15:55 [09:15:55.859] WARN: pxe:service No artifact found for contract class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 when looking for its metadata 09:15:56 [09:15:56.200] INFO: pxe:service Added contract Token at 0x0ec09df514dfb80ca140d7431b6154e580f8db3918b70d776f739e83fbfc0855 with class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 09:15:58 [09:15:57.731] INFO: pxe:service Proving completed in 1522.8282760000002ms {"timings":{"total":1522.8282760000002,"sync":206.23759599999994,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":401.28759500000024,"oracles":{"debugLog":{"times":[0.5893449999998666,0.1592319999999745,0.12905799999998635,0.19931399999995847,0.16111499999988155,0.11615900000015245,0.1670550000003459,0.168721000000005]},"fetchTaggedLogs":{"times":[163.5213490000001]},"loadCapsule":{"times":[0.4301909999999225,0.2126170000001366,0.44154600000001665,0.30694099999982427,0.26338399999985995,0.2552509999995891,0.23753100000021732,0.26632999999992535,0.42809900000020207,0.2566959999999199]},"getSharedSecret":{"times":[4.24549799999977]},"aes128Decrypt":{"times":[0.9689840000000913,0.7586689999998271]},"getPublicKeysAndPartialAddress":{"times":[1.597407000000203]},"getKeyValidationRequest":{"times":[2.290671000000202]},"storeCapsule":{"times":[3.5756459999997787,3.1784059999999954,3.033817999999883]},"deleteCapsule":{"times":[3.3164029999998093]},"bulkRetrieveLogs":{"times":[6.537076999999954]},"validateEnqueuedNotesAndEvents":{"times":[23.35343499999999]},"getNotes":{"times":[2.855953000000227]},"getAuthWitness":{"times":[0.30622300000004543]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.28546400000004724]},"callPrivateFunction":{"times":[85.91342599999962]},"notifyEnqueuedPublicFunctionCall":{"times":[0.23522099999991042]}}},{"functionName":"private_kernel_init","time":88.32738800000016},{"functionName":"ContractInstanceDeployer:deploy","time":45.771029,"oracles":{"storeInExecutionCache":{"times":[0.23014199999988705]},"callPrivateFunction":{"times":[44.20573800000011]},"notifyCreatedNullifier":{"times":[0.4118449999996301]},"debugLog":{"times":[0.3973280000000159]}}},{"functionName":"private_kernel_inner","time":114.27974799999993},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.622859999999946,"oracles":{}},{"functionName":"private_kernel_inner","time":103.30669400000033},{"functionName":"private_kernel_reset","time":195.186279},{"functionName":"private_kernel_tail","time":80.77230300000065}],"unaccounted":254.036783999999}} 09:15:58 [09:15:57.813] INFO: pxe:service Sent transaction 0x167265e26132051dd1400ab189105f6d4c67f92c72df6e29b8852a3cd9046bf0 09:15:58 [09:15:57.812] INFO: node Received tx 0x167265e26132051dd1400ab189105f6d4c67f92c72df6e29b8852a3cd9046bf0 {"txHash":"0x167265e26132051dd1400ab189105f6d4c67f92c72df6e29b8852a3cd9046bf0"} 09:15:58 [09:15:57.953] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.12128813200000149s {"duration":0.12128813200000149,"rate":2609092.8665633677,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 09:15:58 [09:15:57.975] INFO: sequencer Built block 7 for slot 9 with 1 txs and 0 messages. 2118773.0535629876 mana/s {"blockHash":"0x1bc2d5220ac8242dc681ff091caf328f526c7288d0fd5db382bdb1cc4839df1d","globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750843477,"version":2687597111},"txHashes":["0x167265e26132051dd1400ab189105f6d4c67f92c72df6e29b8852a3cd9046bf0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":149.32082300000184,"publicProcessDuration":121.36856599999737,"rollupCircuitsDuration":144.753521000006,"txCount":1,"blockNumber":7,"blockTimestamp":1750843477,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:58 [09:15:58.151] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:15:58 [09:15:58.222] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843513 09:15:58 [09:15:58.222] WARN: foundation:test-date-provider Time set to 2025-06-25T09:25:13.000Z {"offset":554778,"timeMs":1750843513000} 09:15:58 [09:15:58.222] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 09:15:58 [09:15:58.345] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 09:15:58 [09:15:58.346] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 09:15:58 [09:15:58.470] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x1bc2d5220ac8242dc681ff091caf328f526c7288d0fd5db382bdb1cc4839df1d","blockNumber":7,"txCount":1,"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750843477,"version":2687597111},"archiveRoot":"0x2285a3325aa306fd552d47d1f9cae009167bf2e9fe1beeabf98660fd5d1231b5","archiveNextLeafIndex":8} 09:15:58 [09:15:58.471] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 09:15:58 [09:15:58.648] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":4.680255999999645,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750843477,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:15:59 Contract deployed at 0x0ec09df514dfb80ca140d7431b6154e580f8db3918b70d776f739e83fbfc0855 09:15:59 Contract partial address 0x16ec4f99c4d0536a9b39fc4009280b8032ae7b6cdae79d73f7941a3ad2be6fed 09:15:59 Contract init hash 0x1e3b5dd7e0333ed605d641184ac46ce9d43edf907bbb729935909bccc42ecb76 09:15:59 Deployment tx hash: 0x167265e26132051dd1400ab189105f6d4c67f92c72df6e29b8852a3cd9046bf0 09:15:59 Deployment salt: 0x01a729a16d279fb584a91dcb50e6c26b780f31bdd8f6bfbc32237b322eac3b07 09:15:59 Deployment fee: 11001882240 09:15:59 Contract stored in database with alias last 09:16:01 [09:16:01.797] INFO: wallet Using local PXE service 09:16:01 [09:16:01.799] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:16:01 [09:16:01.845] 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) 09:16:01 [09:16:01.848] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:16:02 [09:16:02.370] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:16:02 [09:16:02.425] INFO: wallet Using wallet with address 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:16:03 [09:16:03.327] INFO: pxe:service Added contract Token at 0x13e5c8c3f9d730c2210fb76d458b47c8f13cc8be2e2d3978be85669d6c33924b with class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 09:16:05 [09:16:04.675] INFO: pxe:service Proving completed in 1339.8966689999997ms {"timings":{"total":1339.8966689999997,"sync":38.86271399999987,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":369.7765720000002,"oracles":{"debugLog":{"times":[0.6769659999999931,0.17707100000006903,0.14863300000024537,0.23080799999979718,0.15801300000021,0.11315400000012232,0.15472799999997733,0.1829909999996744]},"fetchTaggedLogs":{"times":[146.3984049999999]},"loadCapsule":{"times":[0.4412800000000061,0.25840999999991254,0.5019090000000688,0.21848199999976714,0.19281499999988228,0.19519099999979517,0.16817900000023656,0.1824079999996684,0.37514899999996487,0.20506599999998798]},"getSharedSecret":{"times":[4.126280999999835]},"aes128Decrypt":{"times":[0.9589809999997669,0.721943999999894]},"getPublicKeysAndPartialAddress":{"times":[1.563148000000183]},"getKeyValidationRequest":{"times":[2.2959390000000894]},"storeCapsule":{"times":[2.3348080000000664,2.2278009999999995,2.1626870000000054]},"deleteCapsule":{"times":[2.375630999999885]},"bulkRetrieveLogs":{"times":[5.170001000000411]},"validateEnqueuedNotesAndEvents":{"times":[14.669444999999996]},"getNotes":{"times":[2.877042999999958]},"getAuthWitness":{"times":[0.29662099999995917]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.28844100000014805]},"callPrivateFunction":{"times":[90.5237930000003]},"notifyEnqueuedPublicFunctionCall":{"times":[0.21408500000006825]}}},{"functionName":"private_kernel_init","time":88.24437900000021},{"functionName":"ContractInstanceDeployer:deploy","time":49.70247600000039,"oracles":{"storeInExecutionCache":{"times":[0.20812500000010914]},"callPrivateFunction":{"times":[46.32499300000018]},"notifyCreatedNullifier":{"times":[0.41053899999997157]},"debugLog":{"times":[0.1770529999998871]}}},{"functionName":"private_kernel_inner","time":118.99223900000015},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.899901999999656,"oracles":{}},{"functionName":"private_kernel_inner","time":106.21939100000009},{"functionName":"private_kernel_reset","time":201.9777979999999},{"functionName":"private_kernel_tail","time":85.98608300000069}],"unaccounted":246.2351149999986}} 09:16:05 [09:16:04.749] INFO: pxe:service Sent transaction 0x0532e3fae928332dd4c11c3f2c72993f59da626ae13d102aa92d6e8df2003de1 09:16:05 [09:16:04.748] INFO: node Received tx 0x0532e3fae928332dd4c11c3f2c72993f59da626ae13d102aa92d6e8df2003de1 {"txHash":"0x0532e3fae928332dd4c11c3f2c72993f59da626ae13d102aa92d6e8df2003de1"} 09:16:05 [09:16:04.907] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10956867599999533s {"duration":0.10956867599999533,"rate":2888161.2113302667,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 09:16:05 [09:16:04.929] INFO: sequencer Built block 8 for slot 10 with 1 txs and 1 messages. 2308803.243688719 mana/s {"blockHash":"0x119722d3b3bf775cfe40683211d5b3ccd59a4d22d7ba675840bb1d7468a04221","globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750843513,"version":2687597111},"txHashes":["0x0532e3fae928332dd4c11c3f2c72993f59da626ae13d102aa92d6e8df2003de1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":137.0363989999969,"publicProcessDuration":109.64472200000455,"rollupCircuitsDuration":132.5161369999987,"txCount":1,"blockNumber":8,"blockTimestamp":1750843513,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:05 [09:16:05.101] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:16:05 [09:16:05.199] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:16:05 [09:16:05.199] WARN: foundation:test-date-provider Time set to 2025-06-25T09:25:25.000Z {"offset":559801,"timeMs":1750843525000} 09:16:05 [09:16:05.293] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 09:16:05 [09:16:05.294] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 09:16:05 [09:16:05.308] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843549 09:16:05 [09:16:05.308] WARN: foundation:test-date-provider Time set to 2025-06-25T09:25:49.000Z {"offset":583692,"timeMs":1750843549000} 09:16:05 [09:16:05.308] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 09:16:05 [09:16:05.635] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x119722d3b3bf775cfe40683211d5b3ccd59a4d22d7ba675840bb1d7468a04221","blockNumber":8,"txCount":1,"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32360,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750843513,"version":2687597111},"archiveRoot":"0x01edb94e5a7d5e84f09839020ea05afae01f843ac799f0d4009f4c8f2997bb06","archiveNextLeafIndex":9} 09:16:05 [09:16:05.636] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 09:16:05 [09:16:05.679] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":4.543728000004194,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750843513,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:05 Contract deployed at 0x13e5c8c3f9d730c2210fb76d458b47c8f13cc8be2e2d3978be85669d6c33924b 09:16:05 Contract partial address 0x12cdfd8984b2293e3e0e33eb03f5a0543bd3f472bce72db0d91cd99260b46cc7 09:16:05 Contract init hash 0x1e3b5dd7e0333ed605d641184ac46ce9d43edf907bbb729935909bccc42ecb76 09:16:05 Deployment tx hash: 0x0532e3fae928332dd4c11c3f2c72993f59da626ae13d102aa92d6e8df2003de1 09:16:05 Deployment salt: 0x12b70e7cce54f1549c546d69080a22ff814bc9531edbf05cf97d3cf15fdc87d1 09:16:05 Deployment fee: 11001882240 09:16:05 Contract stored in database with alias last 09:16:08 [09:16:08.694] INFO: wallet Using local PXE service 09:16:08 [09:16:08.696] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:16:08 [09:16:08.742] 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) 09:16:08 [09:16:08.744] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:16:09 [09:16:09.266] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:16:09 [09:16:09.321] INFO: wallet Using wallet with address 0x21a34b058db224440534b4b833c379e9c26bf0f4be529b95f915e7ed7a6b9959 09:16:10 [09:16:10.232] INFO: pxe:service Added contract Token at 0x030bb510e6919ef1fdaf8165334f5241b2aaf6df27457548d3203a11ca9032f3 with class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 09:16:11 [09:16:11.614] INFO: node Received tx 0x2810fac0bf1a7cde0494d3dccb0a7623d60e45cb666a976f7b67d24d731fcc57 {"txHash":"0x2810fac0bf1a7cde0494d3dccb0a7623d60e45cb666a976f7b67d24d731fcc57"} 09:16:11 [09:16:11.848] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.11538880500000231s {"duration":0.11538880500000231,"rate":2742484.4203906404,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 09:16:11 [09:16:11.874] INFO: sequencer Built block 9 for slot 11 with 1 txs and 0 messages. 2133426.8327268264 mana/s {"blockHash":"0x270a07d1de122b313ae3627256f649056c435af3778e5c86dca8cfc0ce4f2290","globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750843549,"version":2687597111},"txHashes":["0x2810fac0bf1a7cde0494d3dccb0a7623d60e45cb666a976f7b67d24d731fcc57"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":148.29936000000453,"publicProcessDuration":115.47434200000134,"rollupCircuitsDuration":142.967392999999,"txCount":1,"blockNumber":9,"blockTimestamp":1750843549,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:12 [09:16:12.042] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:16:12 [09:16:12.071] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:16:12 [09:16:12.071] WARN: foundation:test-date-provider Time set to 2025-06-25T09:26:01.000Z {"offset":588929,"timeMs":1750843561000} 09:16:12 [09:16:12.081] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843585 09:16:12 [09:16:12.081] WARN: foundation:test-date-provider Time set to 2025-06-25T09:26:25.000Z {"offset":612919,"timeMs":1750843585000} 09:16:12 [09:16:12.081] INFO: aztecjs:utils:watcher Slot 11 was filled, jumped to next slot 09:16:12 [09:16:12.235] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 09:16:12 [09:16:12.236] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 09:16:12 [09:16:12.273] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x270a07d1de122b313ae3627256f649056c435af3778e5c86dca8cfc0ce4f2290","blockNumber":9,"txCount":1,"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750843549,"version":2687597111},"archiveRoot":"0x2fca08ecb7c0c19e6e4c989b222a247c73715478268338927ed87c023d20a253","archiveNextLeafIndex":10} 09:16:12 [09:16:12.275] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 09:16:12 [09:16:11.543] INFO: pxe:service Proving completed in 1302.2086610000001ms {"timings":{"total":1302.2086610000001,"sync":42.75612799999999,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":356.22400700000026,"oracles":{"debugLog":{"times":[0.693384000000151,0.18747299999995448,0.1268249999998261,0.19032100000003993,0.14393599999993967,0.10925499999984822,0.1437700000001314,0.19016899999996895]},"fetchTaggedLogs":{"times":[139.9023269999998]},"loadCapsule":{"times":[0.39643599999999424,0.22338499999978012,0.5055999999999585,0.20937099999991915,0.2088789999997971,0.21298299999989467,0.18051399999967543,0.16060800000013842,0.3469470000000001,0.20662700000002587]},"getSharedSecret":{"times":[3.8092670000000908]},"aes128Decrypt":{"times":[0.9062690000000657,0.6921259999999165]},"getPublicKeysAndPartialAddress":{"times":[1.4587179999998625]},"getKeyValidationRequest":{"times":[2.074561000000358]},"storeCapsule":{"times":[2.400470999999925,2.9709609999999884,2.1600530000000617]},"deleteCapsule":{"times":[2.4377980000003845]},"bulkRetrieveLogs":{"times":[5.342071999999916]},"validateEnqueuedNotesAndEvents":{"times":[15.851832999999715]},"getNotes":{"times":[2.554975000000013]},"getAuthWitness":{"times":[0.2658019999998942]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.28747100000009596]},"callPrivateFunction":{"times":[90.04586699999982]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2306029999999737]}}},{"functionName":"private_kernel_init","time":85.36609700000008},{"functionName":"ContractInstanceDeployer:deploy","time":52.55015599999979,"oracles":{"storeInExecutionCache":{"times":[0.307894000000033]},"callPrivateFunction":{"times":[42.95253300000013]},"notifyCreatedNullifier":{"times":[0.3848969999999099]},"debugLog":{"times":[0.1611809999999423]}}},{"functionName":"private_kernel_inner","time":114.56352800000013},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.638433000000077,"oracles":{}},{"functionName":"private_kernel_inner","time":99.26131600000008},{"functionName":"private_kernel_reset","time":193.72038099999963},{"functionName":"private_kernel_tail","time":82.5118480000001}],"unaccounted":244.61676699999998}} 09:16:12 [09:16:11.616] INFO: pxe:service Sent transaction 0x2810fac0bf1a7cde0494d3dccb0a7623d60e45cb666a976f7b67d24d731fcc57 09:16:12 [09:16:12.636] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":5.031063000002177,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750843549,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:12 Contract deployed at 0x030bb510e6919ef1fdaf8165334f5241b2aaf6df27457548d3203a11ca9032f3 09:16:12 Contract partial address 0x0b77e0dea4ce9355d4347d656853c09aad4258acd25707f7cf133b012391ca47 09:16:12 Contract init hash 0x1e3b5dd7e0333ed605d641184ac46ce9d43edf907bbb729935909bccc42ecb76 09:16:12 Deployment tx hash: 0x2810fac0bf1a7cde0494d3dccb0a7623d60e45cb666a976f7b67d24d731fcc57 09:16:12 Deployment salt: 0x2484152eee5a2780d70b7c6fb7a8e90a458622e0bc34ee1880419c0d7b35c410 09:16:12 Deployment fee: 982553760 09:16:12 Contract stored in database with alias last 09:16:15 [09:16:15.676] INFO: wallet Using local PXE service 09:16:15 [09:16:15.678] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:16:15 [09:16:15.722] 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) 09:16:15 [09:16:15.724] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:16:16 09:16:16 New account: 09:16:16 09:16:16 Address: 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf 09:16:16 Public key: 0x225ad6d41e110f6c09aa9a7b9fe22421d76e2f882e8f042a373e0ddbab650b8b27ec8cdb48ce24a8c67cc29da7144bc662411c4d06f74b9ab0a30769b96e7eaf2506aa3b3974adc3a60af9b8bb68c7bb97c546121f788539128f2826ac450ddd1afe1d6d71a1bd0abcfd677fe5788c37097cb3d05de136428098fd6dfc84c2b81c4b7351967009c9d89e36eed119947d23e0086586c21fc034b53a82f486b62b12377f98c3c8013bd3c62aacaafce1745426806484b7ad86cfa693bb1695e5e22c675f6d9eb53b6711948a336784c19beb28f4c43e9892747337611362e1004e22449bd7a577d68f7e34f9e3435ecaf9773477143d7a239dd4aad1aefd9d7cc3 09:16:16 Secret key: 0x2a83c1cf4487afd381956b831cef8f8427d20f224c4dac7d255489f965781f71 09:16:16 Partial address: 0x0f9ad3bdb1f0cd98bf477aa622e5cf2e17aa7392efbf511575447ec5eee39605 09:16:16 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 09:16:16 Init hash: 0x24a9284e2c3b7e180509bbebf7c9d41ade73df04500ac6d7c11084ec46778670 09:16:16 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 09:16:16 Retrieved 1000000000000000000 fee juice for recipient 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf. Stack pointer 0 09:16:16 Using Fee Juice for fee payments with claim for 1000000000000000000 tokens 09:16:16 [09:16:16.253] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:16:16 [09:16:16.370] INFO: pxe:service Registered account 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf 09:16:16 [09:16:16.476] INFO: pxe:service Added contract SchnorrAccount at 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 09:16:19 [09:16:19.699] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2450.6529010000004ms 09:16:19 [09:16:19.699] INFO: pxe:bb:native Generating Client IVC proof 09:16:20 [09:16:20.781] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-suPBUP/ivc-inputs.msgpack 09:16:20 [09:16:20.781] INFO: pxe:bb:native bb - BB concurrency: undefined 09:16:20 [09:16:20.781] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-suPBUP --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-suPBUP/ivc-inputs.msgpack -v --scheme client_ivc 09:16:20 [09:16:20.795] INFO: pxe:bb:native bb - bb command: prove (mem: 143.61 MiB) 09:16:20 [09:16:20.795] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 64 (mem: 143.61 MiB) 09:16:20 --scheme: client_ivc (mem: 143.61 MiB) 09:16:20 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-suPBUP (mem: 143.61 MiB) 09:16:20 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-suPBUP/ivc-inputs.msgpack (mem: 143.61 MiB) 09:16:20 --verbose: true (mem: 143.61 MiB) 09:16:21 [09:16:21.511] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 153.24 MiB) 09:16:21 [09:16:21.511] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 153.24 MiB) 09:16:21 [09:16:21.546] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 153.24 MiB) 09:16:21 [09:16:21.551] INFO: pxe:bb:native bb - ClientIVC: accumulating MultiCallEntrypoint:entrypoint (mem: 153.24 MiB) 09:16:21 Constructing DeciderProvingKey (mem: 153.24 MiB) 09:16:21 [09:16:21.555] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 153.24 MiB) 09:16:21 goblin ecc op : 4/1024 (mem: 153.24 MiB) 09:16:21 busread : 742/6000 (mem: 153.24 MiB) 09:16:21 lookups : 2/15000 (mem: 153.24 MiB) 09:16:21 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 153.24 MiB) 09:16:21 arithmetic : 4296/56000 (mem: 153.24 MiB) 09:16:21 delta range : 2030/18000 (mem: 153.24 MiB) 09:16:21 [09:16:21.555] INFO: pxe:bb:native bb - 09:16:21 elliptic : 2/6000 (mem: 153.24 MiB) 09:16:21 auxiliary : 2420/26000 (mem: 153.24 MiB) 09:16:21 poseidon ext : 82/17000 (mem: 153.24 MiB) 09:16:21 poseidon int : 458/92000 (mem: 153.24 MiB) 09:16:21 overflow : 0/0 (mem: 153.24 MiB) 09:16:21 (mem: 153.24 MiB) 09:16:21 Total structured size: 242025 (mem: 153.24 MiB) 09:16:21 allocating polynomials object in proving key... (mem: 153.24 MiB) 09:16:21 [09:16:21.614] INFO: pxe:bb:native bb - populating trace... (mem: 387.14 MiB) 09:16:21 [09:16:21.620] INFO: pxe:bb:native bb - time to construct proving key: 68 ms. (mem: 396.14 MiB) 09:16:21 [09:16:21.630] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d577f50340 (mem: 396.14 MiB) 09:16:21 [09:16:21.630] INFO: pxe:bb:native bb - computing oink proof... (mem: 396.14 MiB) 09:16:21 [09:16:21.630] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 396.14 MiB) 09:16:21 [09:16:21.747] INFO: pxe:bb:native bb - oink proof constructed (mem: 403.14 MiB) 09:16:21 [09:16:21.768] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 404.64 MiB) 09:16:21 [09:16:21.778] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 409.14 MiB) 09:16:21 Constructing DeciderProvingKey (mem: 409.14 MiB) 09:16:21 [09:16:21.781] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 409.64 MiB) 09:16:21 goblin ecc op : 56/1024 09:16:21 [09:16:21.781] INFO: pxe:bb:native bb - (mem: 409.64 MiB) 09:16:21 busread : 2529/6000 (mem: 409.64 MiB) 09:16:21 lookups : 2/15000 (mem: 409.64 MiB) 09:16:21 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 409.64 MiB) 09:16:21 arithmetic : 21145/56000 (mem: 409.64 MiB) 09:16:21 delta range : 3034/18000 (mem: 409.64 MiB) 09:16:21 elliptic : 340/6000 (mem: 409.64 MiB) 09:16:21 auxiliary : 799/26000 (mem: 409.64 MiB) 09:16:21 poseidon ext : 2022/17000 (mem: 409.64 MiB) 09:16:21 poseidon int : 11516/92000 (mem: 409.64 MiB) 09:16:21 overflow : 0/0 (mem: 409.64 MiB) 09:16:21 (mem: 409.64 MiB) 09:16:21 Total structured size: 242025 (mem: 409.64 MiB) 09:16:21 allocating polynomials object in proving key... (mem: 409.64 MiB) 09:16:21 [09:16:21.834] INFO: pxe:bb:native bb - populating trace... (mem: 631.64 MiB) 09:16:21 [09:16:21.851] INFO: pxe:bb:native bb - time to construct proving key: 72 ms. (mem: 648.14 MiB) 09:16:21 [09:16:21.874] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d5796a1b80 (mem: 648.14 MiB) 09:16:21 computing folding proof (mem: 648.14 MiB) 09:16:21 [09:16:21.874] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000398959ae56eb9c01a92891da007bef4c (mem: 648.14 MiB) 09:16:22 [09:16:22.081] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 660.14 MiB) 09:16:22 [09:16:22.126] INFO: pxe:bb:native bb - perturbator round (mem: 689.64 MiB) 09:16:22 [09:16:22.171] INFO: pxe:bb:native bb - combiner quotient round (mem: 722.14 MiB) 09:16:22 [09:16:22.272] INFO: pxe:bb:native bb - folded (mem: 722.14 MiB) 09:16:22 constructed folding proof (mem: 722.14 MiB) 09:16:22 [09:16:22.314] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:constructor (mem: 722.14 MiB) 09:16:22 Constructing DeciderProvingKey (mem: 722.14 MiB) 09:16:22 [09:16:22.316] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 722.14 MiB) 09:16:22 [09:16:22.316] INFO: pxe:bb:native bb - goblin ecc op : 4/1024 (mem: 722.14 MiB) 09:16:22 busread : 742/6000 (mem: 722.14 MiB) 09:16:22 lookups : 12218/15000 (mem: 722.14 MiB) 09:16:22 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 722.14 MiB) 09:16:22 arithmetic : 15035/56000 (mem: 722.14 MiB) 09:16:22 delta range : 2476/18000 (mem: 722.14 MiB) 09:16:22 elliptic : 1008/6000 (mem: 722.14 MiB) 09:16:22 auxiliary : 899/26000 (mem: 722.14 MiB) 09:16:22 poseidon ext : 132/17000 (mem: 722.14 MiB) 09:16:22 poseidon int : 743/92000 (mem: 722.14 MiB) 09:16:22 overflow : 0/0 (mem: 722.14 MiB) 09:16:22 (mem: 722.14 MiB) 09:16:22 Total structured size: 242025 (mem: 722.14 MiB) 09:16:22 allocating polynomials object in proving key... (mem: 722.14 MiB) 09:16:22 [09:16:22.323] INFO: pxe:bb:native bb - populating trace... (mem: 722.14 MiB) 09:16:22 [09:16:22.346] INFO: pxe:bb:native bb - time to construct proving key: 32 ms. (mem: 722.14 MiB) 09:16:22 [09:16:22.370] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d577fc6200 (mem: 722.14 MiB) 09:16:22 computing folding proof (mem: 722.14 MiB) 09:16:22 [09:16:22.371] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 722.14 MiB) 09:16:22 [09:16:22.609] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 722.14 MiB) 09:16:22 [09:16:22.662] INFO: pxe:bb:native bb - perturbator round (mem: 722.14 MiB) 09:16:22 [09:16:22.712] INFO: pxe:bb:native bb - combiner quotient round (mem: 733.49 MiB) 09:16:22 [09:16:22.816] INFO: pxe:bb:native bb - folded (mem: 733.49 MiB) 09:16:22 constructed folding proof (mem: 733.49 MiB) 09:16:22 [09:16:22.850] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000398959ae56eb9c01a92891da007bef4c (mem: 733.49 MiB) 09:16:22 [09:16:22.891] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 733.49 MiB) 09:16:22 [09:16:22.930] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 733.49 MiB) 09:16:22 Constructing DeciderProvingKey (mem: 733.49 MiB) 09:16:22 [09:16:22.935] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 733.49 MiB) 09:16:22 goblin ecc op : 792/1024 (mem: 733.49 MiB) 09:16:22 busread : 4184/6000 (mem: 733.49 MiB) 09:16:22 lookups : 2/15000 (mem: 733.49 MiB) 09:16:22 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 733.49 MiB) 09:16:22 arithmetic : 43807/56000 (mem: 733.49 MiB) 09:16:22 delta range : 5025/18000 (mem: 733.49 MiB) 09:16:22 [09:16:22.935] INFO: pxe:bb:native bb - elliptic : 340/6000 (mem: 733.49 MiB) 09:16:22 auxiliary : 1399/26000 (mem: 733.49 MiB) 09:16:22 poseidon ext : 5682/17000 (mem: 733.49 MiB) 09:16:22 poseidon int : 32378/92000 (mem: 733.49 MiB) 09:16:22 overflow : 0/0 (mem: 733.49 MiB) 09:16:22 (mem: 733.49 MiB) 09:16:22 Total structured size: 242025 (mem: 733.49 MiB) 09:16:22 allocating polynomials object in proving key... (mem: 733.49 MiB) 09:16:22 [09:16:22.948] INFO: pxe:bb:native bb - populating trace... (mem: 733.49 MiB) 09:16:22 [09:16:22.982] INFO: pxe:bb:native bb - time to construct proving key: 51 ms. (mem: 733.49 MiB) 09:16:23 [09:16:23.074] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d577fe8a40 (mem: 733.49 MiB) 09:16:23 [09:16:23.074] INFO: pxe:bb:native bb - computing folding proof (mem: 733.49 MiB) 09:16:23 [09:16:23.074] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 733.49 MiB) 09:16:23 [09:16:23.419] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 733.49 MiB) 09:16:23 [09:16:23.470] INFO: pxe:bb:native bb - perturbator round (mem: 733.49 MiB) 09:16:23 [09:16:23.543] INFO: pxe:bb:native bb - combiner quotient round (mem: 761.53 MiB) 09:16:23 [09:16:23.608] INFO: pxe:bb:native bb - folded (mem: 761.53 MiB) 09:16:23 constructed folding proof (mem: 761.53 MiB) 09:16:23 [09:16:23.650] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 761.53 MiB) 09:16:23 Constructing DeciderProvingKey (mem: 761.53 MiB) 09:16:23 [09:16:23.655] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 761.53 MiB) 09:16:23 goblin ecc op : 4/1024 (mem: 761.53 MiB) 09:16:23 busread : 742/6000 (mem: 761.53 MiB) 09:16:23 lookups : 2076/15000 (mem: 761.53 MiB) 09:16:23 [09:16:23.655] INFO: pxe:bb:native bb - pub inputs : 16/5000 (populated in decider pk constructor) (mem: 761.53 MiB) 09:16:23 arithmetic : 9353/56000 (mem: 761.53 MiB) 09:16:23 delta range : 2977/18000 (mem: 761.53 MiB) 09:16:23 elliptic : 794/6000 (mem: 761.53 MiB) 09:16:23 auxiliary : 4528/26000 (mem: 761.53 MiB) 09:16:23 poseidon ext : 312/17000 (mem: 761.53 MiB) 09:16:23 poseidon int : 1769/92000 (mem: 761.53 MiB) 09:16:23 overflow : 0/0 (mem: 761.53 MiB) 09:16:23 (mem: 761.53 MiB) 09:16:23 Total structured size: 242025 (mem: 761.53 MiB) 09:16:23 allocating polynomials object in proving key... (mem: 761.53 MiB) 09:16:23 [09:16:23.668] INFO: pxe:bb:native bb - populating trace... (mem: 761.53 MiB) 09:16:23 [09:16:23.687] INFO: pxe:bb:native bb - time to construct proving key: 37 ms. (mem: 761.53 MiB) 09:16:23 [09:16:23.733] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d577fed840 (mem: 761.53 MiB) 09:16:23 computing folding proof (mem: 761.53 MiB) 09:16:23 [09:16:23.734] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 761.53 MiB) 09:16:24 [09:16:23.904] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 761.53 MiB) 09:16:24 [09:16:23.970] INFO: pxe:bb:native bb - perturbator round (mem: 761.53 MiB) 09:16:24 [09:16:24.033] INFO: pxe:bb:native bb - combiner quotient round (mem: 761.89 MiB) 09:16:24 [09:16:24.120] INFO: pxe:bb:native bb - folded (mem: 761.89 MiB) 09:16:24 constructed folding proof (mem: 761.89 MiB) 09:16:24 [09:16:24.153] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 761.89 MiB) 09:16:24 [09:16:24.194] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 761.89 MiB) 09:16:24 [09:16:24.233] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 761.89 MiB) 09:16:24 Constructing DeciderProvingKey (mem: 761.89 MiB) 09:16:24 [09:16:24.238] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 761.89 MiB) 09:16:24 [09:16:24.238] INFO: pxe:bb:native bb - goblin ecc op : 792/1024 (mem: 761.89 MiB) 09:16:24 busread : 4184/6000 (mem: 761.89 MiB) 09:16:24 lookups : 2/15000 (mem: 761.89 MiB) 09:16:24 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 761.89 MiB) 09:16:24 arithmetic : 43807/56000 (mem: 761.89 MiB) 09:16:24 delta range : 5025/18000 (mem: 761.89 MiB) 09:16:24 elliptic : 340/6000 (mem: 761.89 MiB) 09:16:24 auxiliary : 1399/26000 (mem: 761.89 MiB) 09:16:24 poseidon ext : 5682/17000 (mem: 761.89 MiB) 09:16:24 poseidon int : 32378/92000 (mem: 761.89 MiB) 09:16:24 overflow : 0/0 (mem: 761.89 MiB) 09:16:24 (mem: 761.89 MiB) 09:16:24 Total structured size: 242025 (mem: 761.89 MiB) 09:16:24 allocating polynomials object in proving key... (mem: 761.89 MiB) 09:16:24 [09:16:24.252] INFO: pxe:bb:native bb - populating trace... (mem: 761.89 MiB) 09:16:24 [09:16:24.281] INFO: pxe:bb:native bb - time to construct proving key: 47 ms. (mem: 761.89 MiB) 09:16:24 [09:16:24.329] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d578162ec0 (mem: 761.89 MiB) 09:16:24 computing folding proof (mem: 761.89 MiB) 09:16:24 [09:16:24.330] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 761.89 MiB) 09:16:24 [09:16:24.618] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 761.89 MiB) 09:16:24 [09:16:24.674] INFO: pxe:bb:native bb - perturbator round (mem: 761.89 MiB) 09:16:24 [09:16:24.734] INFO: pxe:bb:native bb - combiner quotient round (mem: 764.29 MiB) 09:16:24 [09:16:24.829] INFO: pxe:bb:native bb - folded (mem: 764.29 MiB) 09:16:24 constructed folding proof (mem: 764.29 MiB) 09:16:24 [09:16:24.877] INFO: pxe:bb:native bb - ClientIVC: accumulating FeeJuice:claim (mem: 764.29 MiB) 09:16:24 Constructing DeciderProvingKey (mem: 764.29 MiB) 09:16:24 [09:16:24.880] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 764.29 MiB) 09:16:24 goblin ecc op : 4/1024 (mem: 764.29 MiB) 09:16:24 busread : 742/6000 (mem: 764.29 MiB) 09:16:24 lookups : 17378/15000 (mem: 09:16:24 [09:16:24.880] INFO: pxe:bb:native bb - 764.29 MiB) 09:16:24 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 764.29 MiB) 09:16:24 arithmetic : 13735/56000 (mem: 764.29 MiB) 09:16:24 delta range : 2547/18000 (mem: 764.29 MiB) 09:16:24 elliptic : 2/6000 (mem: 764.29 MiB) 09:16:24 auxiliary : 26/26000 (mem: 764.29 MiB) 09:16:24 poseidon ext : 452/17000 (mem: 764.29 MiB) 09:16:24 poseidon int : 2567/92000 (mem: 764.29 MiB) 09:16:24 overflow : 0/0 (mem: 764.29 MiB) 09:16:24 (mem: 764.29 MiB) 09:16:24 Total structured size: 242025 (mem: 764.29 MiB) 09:16:24 [09:16:24.880] INFO: pxe:bb:native bb - WARNING: Structured trace overflow mechanism in use. Performance may be degraded! (mem: 764.29 MiB) 09:16:24 Gate blocks summary: (actual gates / fixed capacity) (mem: 09:16:24 [09:16:24.880] INFO: pxe:bb:native bb - 764.29 MiB) 09:16:24 goblin ecc op : 4/1024 (mem: 764.29 MiB) 09:16:24 busread : 742/6000 (mem: 764.29 MiB) 09:16:24 lookups : 15000/15000 (mem: 764.29 MiB) 09:16:24 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 764.29 MiB) 09:16:24 arithmetic : 13735/56000 (mem: 764.29 MiB) 09:16:24 delta range : 2547/18000 (mem: 764.29 MiB) 09:16:24 elliptic : 2/6000 (mem: 764.29 MiB) 09:16:24 auxiliary : 26/26000 (mem: 764.29 MiB) 09:16:24 poseidon ext : 452/17000 (mem: 764.29 MiB) 09:16:24 poseidon int : 2567/92000 (mem: 764.29 MiB) 09:16:24 overflow : 2379/2379 (mem: 764.29 MiB) 09:16:24 (mem: 764.29 MiB) 09:16:24 [09:16:24.881] INFO: pxe:bb:native bb - Total structured size: 244404 (mem: 764.29 MiB) 09:16:24 allocating polynomials object in proving key... (mem: 764.29 MiB) 09:16:24 [09:16:24.916] INFO: pxe:bb:native bb - populating trace... (mem: 879.40 MiB) 09:16:24 [09:16:24.951] INFO: pxe:bb:native bb - time to construct proving key: 73 ms. (mem: 879.40 MiB) 09:16:25 [09:16:24.994] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d57981e140 (mem: 879.40 MiB) 09:16:25 computing folding proof (mem: 879.40 MiB) 09:16:25 [09:16:24.995] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 879.40 MiB) 09:16:25 [09:16:25.202] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 898.40 MiB) 09:16:25 [09:16:25.257] INFO: pxe:bb:native bb - perturbator round (mem: 916.90 MiB) 09:16:25 [09:16:25.319] INFO: pxe:bb:native bb - combiner quotient round (mem: 916.90 MiB) 09:16:25 [09:16:25.396] INFO: pxe:bb:native bb - folded (mem: 916.90 MiB) 09:16:25 constructed folding proof (mem: 916.90 MiB) 09:16:25 [09:16:25.429] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 916.90 MiB) 09:16:25 [09:16:25.471] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 916.90 MiB) 09:16:25 [09:16:25.510] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 916.90 MiB) 09:16:25 Constructing DeciderProvingKey (mem: 916.90 MiB) 09:16:25 [09:16:25.514] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 916.90 MiB) 09:16:25 goblin ecc op : 792/1024 (mem: 916.90 MiB) 09:16:25 busread : 4184/6000 (mem: 916.90 MiB) 09:16:25 lookups : 2/15000 (mem: 916.90 MiB) 09:16:25 [09:16:25.515] INFO: pxe:bb:native bb - pub inputs : 32/5000 (populated in decider pk constructor) (mem: 916.90 MiB) 09:16:25 arithmetic : 43807/56000 (mem: 916.90 MiB) 09:16:25 delta range : 5025/18000 (mem: 916.90 MiB) 09:16:25 elliptic : 340/6000 (mem: 916.90 MiB) 09:16:25 auxiliary : 1399/26000 (mem: 916.90 MiB) 09:16:25 poseidon ext : 5682/17000 (mem: 916.90 MiB) 09:16:25 poseidon int : 32378/92000 (mem: 916.90 MiB) 09:16:25 overflow : 0/0 (mem: 916.90 MiB) 09:16:25 (mem: 916.90 MiB) 09:16:25 Total structured size: 242025 (mem: 916.90 MiB) 09:16:25 allocating polynomials object in proving key... (mem: 916.90 MiB) 09:16:25 [09:16:25.530] INFO: pxe:bb:native bb - populating trace... (mem: 916.90 MiB) 09:16:25 [09:16:25.557] INFO: pxe:bb:native bb - time to construct proving key: 47 ms. (mem: 916.90 MiB) 09:16:25 [09:16:25.607] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d5783f0f80 (mem: 916.90 MiB) 09:16:25 computing folding proof (mem: 916.90 MiB) 09:16:25 [09:16:25.607] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 916.90 MiB) 09:16:25 [09:16:25.860] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 917.40 MiB) 09:16:25 [09:16:25.916] INFO: pxe:bb:native bb - perturbator round (mem: 936.90 MiB) 09:16:25 [09:16:25.986] INFO: pxe:bb:native bb - combiner quotient round (mem: 968.90 MiB) 09:16:26 [09:16:26.065] INFO: pxe:bb:native bb - folded (mem: 968.90 MiB) 09:16:26 constructed folding proof (mem: 968.90 MiB) 09:16:26 [09:16:26.114] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 968.90 MiB) 09:16:26 [09:16:26.154] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 968.90 MiB) 09:16:26 Constructing DeciderProvingKey (mem: 968.90 MiB) 09:16:26 [09:16:26.162] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 968.90 MiB) 09:16:26 goblin ecc op : 392/1024 (mem: 968.90 MiB) 09:16:26 [09:16:26.162] INFO: pxe:bb:native bb - 09:16:26 busread : 2347/6000 (mem: 968.90 MiB) 09:16:26 lookups : 2/15000 (mem: 968.90 MiB) 09:16:26 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 968.90 MiB) 09:16:26 arithmetic : 36209/56000 (mem: 968.90 MiB) 09:16:26 delta range : 4306/18000 (mem: 968.90 MiB) 09:16:26 elliptic : 1274/6000 (mem: 968.90 MiB) 09:16:26 auxiliary : 12562/26000 (mem: 968.90 MiB) 09:16:26 poseidon ext : 6112/17000 (mem: 968.90 MiB) 09:16:26 poseidon int : 34829/92000 (mem: 968.90 MiB) 09:16:26 overflow : 0/0 (mem: 968.90 MiB) 09:16:26 (mem: 968.90 MiB) 09:16:26 Total structured size: 242025 (mem: 968.90 MiB) 09:16:26 allocating polynomials object in proving key... (mem: 968.90 MiB) 09:16:26 [09:16:26.177] INFO: pxe:bb:native bb - populating trace... (mem: 968.90 MiB) 09:16:26 [09:16:26.209] INFO: pxe:bb:native bb - time to construct proving key: 54 ms. (mem: 968.90 MiB) 09:16:26 [09:16:26.254] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d57a476600 (mem: 968.90 MiB) 09:16:26 computing folding proof (mem: 968.90 MiB) 09:16:26 [09:16:26.255] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c211ff9c7a9c97c80d116c907b808844 (mem: 968.90 MiB) 09:16:26 [09:16:26.511] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 968.90 MiB) 09:16:26 [09:16:26.575] INFO: pxe:bb:native bb - perturbator round (mem: 969.23 MiB) 09:16:26 [09:16:26.651] INFO: pxe:bb:native bb - combiner quotient round (mem: 1001.23 MiB) 09:16:26 [09:16:26.781] INFO: pxe:bb:native bb - folded (mem: 1001.23 MiB) 09:16:26 constructed folding proof (mem: 1001.23 MiB) 09:16:26 [09:16:26.804] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c211ff9c7a9c97c80d116c907b808844 (mem: 1001.23 MiB) 09:16:26 [09:16:26.844] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 1001.23 MiB) 09:16:26 Constructing DeciderProvingKey (mem: 1001.23 MiB) 09:16:26 [09:16:26.852] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1001.23 MiB) 09:16:26 goblin ecc op : 392/1024 (mem: 1001.23 MiB) 09:16:26 busread : 231/6000 (mem: 1001.23 MiB) 09:16:26 lookups : 2/15000 (mem: 1001.23 MiB) 09:16:26 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 09:16:26 [09:16:26.852] INFO: pxe:bb:native bb - 1001.23 MiB) 09:16:26 arithmetic : 32330/56000 (mem: 1001.23 MiB) 09:16:26 delta range : 4411/18000 (mem: 1001.23 MiB) 09:16:26 elliptic : 2/6000 (mem: 1001.23 MiB) 09:16:26 auxiliary : 11868/26000 (mem: 1001.23 MiB) 09:16:26 poseidon ext : 2552/17000 (mem: 1001.23 MiB) 09:16:26 poseidon int : 14537/92000 (mem: 1001.23 MiB) 09:16:26 overflow : 0/0 (mem: 1001.23 MiB) 09:16:26 (mem: 1001.23 MiB) 09:16:26 Total structured size: 242025 (mem: 1001.23 MiB) 09:16:26 allocating polynomials object in proving key... (mem: 1001.23 MiB) 09:16:26 [09:16:26.865] INFO: pxe:bb:native bb - populating trace... (mem: 1001.23 MiB) 09:16:26 [09:16:26.886] INFO: pxe:bb:native bb - time to construct proving key: 42 ms. (mem: 1001.23 MiB) 09:16:26 [09:16:26.939] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xc0d578088240 (mem: 1001.23 MiB) 09:16:26 computing folding proof (mem: 1001.23 MiB) 09:16:26 [09:16:26.940] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000004e5c65f357d227066d8ec7a7045e6c0 (mem: 1001.23 MiB) 09:16:27 [09:16:27.199] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1001.23 MiB) 09:16:27 [09:16:27.264] INFO: pxe:bb:native bb - perturbator round (mem: 1001.23 MiB) 09:16:27 [09:16:27.314] INFO: pxe:bb:native bb - combiner quotient round (mem: 1001.23 MiB) 09:16:27 [09:16:27.409] INFO: pxe:bb:native bb - folded (mem: 1001.23 MiB) 09:16:27 constructed folding proof (mem: 1001.23 MiB) 09:16:27 [09:16:27.413] INFO: pxe:bb:native bb - Largest circuit: 97641 gates. Trace details: (mem: 1001.23 MiB) 09:16:27 Minimum required block sizes for structured trace: (mem: 1001.23 MiB) 09:16:27 [09:16:27.414] INFO: pxe:bb:native bb - (mem: 1001.23 MiB) 09:16:27 prove decider... (mem: 1001.23 MiB) 09:16:27 [09:16:27.414] INFO: pxe:bb:native bb - ecc_op : 792 09:16:27 busread : 4184 09:16:27 lookup : 15000 09:16:27 pub_inputs : 1859 09:16:27 arithmetic : 43807 09:16:27 delta_range : 5025 09:16:27 elliptic : 1274 09:16:27 aux : 12562 09:16:27 poseidon2_external : 6112 09:16:27 poseidon2_internal : 34829 09:16:27 overflow : 2379 09:16:27 [09:16:27.456] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1001.23 MiB) 09:16:27 [09:16:27.575] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1001.23 MiB) 09:16:28 [09:16:27.973] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1001.23 MiB) 09:16:28 [09:16:28.073] INFO: pxe:bb:native bb - computed opening proof (mem: 1001.23 MiB) 09:16:28 finished decider proving. (mem: 1001.23 MiB) 09:16:28 [09:16:28.095] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000004e5c65f357d227066d8ec7a7045e6c0 (mem: 1001.23 MiB) 09:16:28 [09:16:28.194] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 1001.23 MiB) 09:16:28 [09:16:28.198] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 1001.23 MiB) 09:16:28 [09:16:28.214] INFO: pxe:bb:native bb - populating trace... (mem: 1001.23 MiB) 09:16:28 [09:16:28.250] INFO: pxe:bb:native bb - time to construct proving key: 55 ms. (mem: 1001.23 MiB) 09:16:28 [09:16:28.749] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000f18a0809f37bfdacae8e5ba8412d0553 (mem: 1001.23 MiB) 09:16:29 [09:16:29.144] INFO: pxe:bb:native bb - created oink proof (mem: 1001.23 MiB) 09:16:29 [09:16:29.178] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1001.23 MiB) 09:16:29 [09:16:29.336] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 1001.23 MiB) 09:16:29 [09:16:29.731] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1001.23 MiB) 09:16:29 [09:16:29.791] INFO: pxe:bb:native bb - computed opening proof (mem: 1001.23 MiB) 09:16:29 finished decider proving. (mem: 1001.23 MiB) 09:16:29 [09:16:29.797] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3818 (mem: 1001.23 MiB) 09:16:29 [09:16:29.870] INFO: pxe:bb:native bb - prove eccvm... (mem: 1001.23 MiB) 09:16:30 [09:16:30.055] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 1001.23 MiB) 09:16:30 [09:16:30.062] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 1001.23 MiB) 09:16:31 [09:16:31.105] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1001.23 MiB) 09:16:32 [09:16:31.872] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 1001.23 MiB) 09:16:34 [09:16:33.290] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 1001.23 MiB) 09:16:34 prove translator... (mem: 1001.23 MiB) 09:16:34 [09:16:33.821] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1001.23 MiB) 09:16:34 [09:16:34.402] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1001.23 MiB) 09:16:35 09:16:35 Waiting for account contract deployment... 09:16:35 [09:16:35.178] INFO: pxe:bb:native bb - computed opening proof (mem: 1001.23 MiB) 09:16:35 [09:16:35.178] INFO: pxe:bb:native bb - finished translator proving. (mem: 1001.23 MiB) 09:16:35 [09:16:35.179] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x00000000000000000000000000000000f18a0809f37bfdacae8e5ba8412d0553 (mem: 1001.23 MiB) 09:16:35 [09:16:35.204] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 1001.23 MiB) 09:16:35 libra_evals_verified: 1 (mem: 1001.23 MiB) 09:16:35 pairing_check_verified: 1 (mem: 1001.23 MiB) 09:16:35 Mega verified: 1 (mem: 1001.23 MiB) 09:16:35 [09:16:35.259] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 1001.23 MiB) 09:16:35 batch opening verified?: 1 (mem: 1001.23 MiB) 09:16:35 eccvm consistency check verified?: 1 (mem: 1001.23 MiB) 09:16:35 translation masking consistency checked?: 1 (mem: 1001.23 MiB) 09:16:35 [09:16:35.278] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 1001.23 MiB) 09:16:35 eccvm verified?: 1 (mem: 1001.23 MiB) 09:16:35 accumulator construction_verified?: 1 (mem: 1001.23 MiB) 09:16:35 translation verified?: 1 (mem: 1001.23 MiB) 09:16:35 consistency verified?: 1 (mem: 1001.23 MiB) 09:16:35 [09:16:35.278] INFO: pxe:bb:native bb - Goblin verified: 1 (mem: 1001.23 MiB) 09:16:35 [09:16:35.278] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-suPBUP" (mem: 1001.23 MiB) 09:16:35 [09:16:35.396] INFO: pxe:bb:native Generated IVC proof {"duration":14614.648392,"eventName":"circuit-proving"} 09:16:35 [09:16:35.400] INFO: pxe:service Proving completed in 18868.911895ms {"timings":{"total":18868.911895,"sync":40.38113800000019,"proving":15700.764159000002,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":100.04256900000064,"oracles":{"callPrivateFunction":{"times":[282.1416210000002,308.1524669999999]}}},{"functionName":"private_kernel_init","time":218.22566199999983},{"functionName":"SchnorrAccount:constructor","time":272.5251839999996,"oracles":{"getContractInstance":{"times":[0.7524240000002465]},"debugLog":{"times":[0.44532799999979034,0.17030100000010862]},"fetchTaggedLogs":{"times":[103.41030599999976]},"loadCapsule":{"times":[0.4898650000000089,0.23785999999972773,0.2064829999999347,0.24062599999979284,0.18307799999956842,0.22022800000013376]},"bulkRetrieveLogs":{"times":[6.153389999999945]},"validateEnqueuedNotesAndEvents":{"times":[5.5591269999999895]},"notifyCreatedNullifier":{"times":[0.4491499999999178,0.24529300000040166]},"notifyCreatedNote":{"times":[0.33373200000005454]},"getRandomField":{"times":[0.4175260000001799,0.19063899999991918,0.11649000000033993,0.11588500000016211,0.22398700000030658,0.09592299999985698,0.07546899999988455,0.07033300000011877,0.06562800000028801,0.08912299999974493,0.05885699999998906]},"getIndexedTaggingSecretAsSender":{"times":[17.03858799999989]},"incrementAppTaggingSecretIndexAsSender":{"times":[11.507356000000073]}}},{"functionName":"private_kernel_inner","time":417.9290460000002},{"functionName":"SchnorrAccount:entrypoint","time":204.3466540000004,"oracles":{"debugLog":{"times":[0.18103999999993903,0.11605000000008658,0.20896399999992354]},"fetchTaggedLogs":{"times":[84.53745700000036]},"loadCapsule":{"times":[0.23806599999988975,0.1833440000000337,0.3544350000001941,0.27440900000010515,0.2015240000000631,0.13829299999997602]},"bulkRetrieveLogs":{"times":[6.503727999999683]},"validateEnqueuedNotesAndEvents":{"times":[6.44253499999968]},"getNotes":{"times":[2.1617849999997816]},"getAuthWitness":{"times":[0.38299600000027567]},"callPrivateFunction":{"times":[98.63054599999987]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7994450000001052]}}},{"functionName":"private_kernel_inner","time":391.7025129999997},{"functionName":"FeeJuice:claim","time":93.21195599999965,"oracles":{"getL1ToL2MembershipWitness":{"times":[15.597819999999956]},"notifyCreatedNullifier":{"times":[0.27677799999992203]},"storeInExecutionCache":{"times":[0.17424800000026153]},"notifyEnqueuedPublicFunctionCall":{"times":[0.18335400000023583]}}},{"functionName":"private_kernel_inner","time":385.8021999999992},{"functionName":"private_kernel_reset","time":416.7443710000007},{"functionName":"private_kernel_tail","time":382.53709099999924}],"unaccounted":244.69935199999964}} 09:16:35 [09:16:35.472] INFO: pxe:service Sent transaction 0x00f1be0a512043ac95bea4ad9c2d0d75b4db5202432478feb81d879c2cbfb6af 09:16:35 [09:16:35.470] INFO: node Received tx 0x00f1be0a512043ac95bea4ad9c2d0d75b4db5202432478feb81d879c2cbfb6af {"txHash":"0x00f1be0a512043ac95bea4ad9c2d0d75b4db5202432478feb81d879c2cbfb6af"} 09:16:35 [09:16:35.607] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04451331300000311s {"duration":0.04451331300000311,"rate":319544.85167165624,"totalPublicGas":{"daGas":1024,"l2Gas":14224},"totalBlockGas":{"daGas":13312,"l2Gas":40548},"totalSizeInBytes":1024} 09:16:35 [09:16:35.631] INFO: sequencer Built block 10 for slot 12 with 1 txs and 0 messages. 189412.41337102812 mana/s {"blockHash":"0x25de2748cff5f3fbfbbfab970ef113246a8fc2ffb30043616514418bc8c3d9df","globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":12,"timestamp":1750843585,"version":2687597111},"txHashes":["0x00f1be0a512043ac95bea4ad9c2d0d75b4db5202432478feb81d879c2cbfb6af"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":75.04417899998953,"publicProcessDuration":44.603278999988106,"rollupCircuitsDuration":70.23222799999348,"txCount":1,"blockNumber":10,"blockTimestamp":1750843585,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:35 [09:16:35.799] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:16:35 [09:16:35.835] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843621 09:16:35 [09:16:35.835] WARN: foundation:test-date-provider Time set to 2025-06-25T09:27:01.000Z {"offset":625165,"timeMs":1750843621000} 09:16:35 [09:16:35.835] INFO: aztecjs:utils:watcher Slot 12 was filled, jumped to next slot 09:16:36 [09:16:35.992] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 10 09:16:36 [09:16:35.993] INFO: aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10. 09:16:36 [09:16:36.329] INFO: archiver Downloaded L2 block 10 {"blockHash":"0x25de2748cff5f3fbfbbfab970ef113246a8fc2ffb30043616514418bc8c3d9df","blockNumber":10,"txCount":1,"globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":12,"timestamp":1750843585,"version":2687597111},"archiveRoot":"0x160db480fecc2b7df90c68001e27487177b066884dca9cc25d32ba3bfef78924","archiveNextLeafIndex":11} 09:16:36 [09:16:36.330] INFO: archiver Updated proven chain to block 10 {"provenBlockNumber":10} 09:16:36 [09:16:36.427] INFO: world_state World state updated with L2 block 10 {"eventName":"l2-block-handled","duration":4.344404999996186,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1750843585,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:36 Deploy tx hash: 0x00f1be0a512043ac95bea4ad9c2d0d75b4db5202432478feb81d879c2cbfb6af 09:16:36 Deploy tx fee: 117183720 09:16:38 [09:16:38.695] INFO: wallet Using local PXE service 09:16:38 [09:16:38.697] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 09:16:38 [09:16:38.744] 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) 09:16:38 [09:16:38.747] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:16:39 [09:16:39.291] INFO: pxe:service Started PXE connected to chain 31337 version 2687597111 09:16:39 [09:16:39.347] INFO: wallet Using wallet with address 0x23d31e2b568bdce69e2232d18a2583f8e2dd41cb027bb103b122aad55fc2fbbf 09:16:40 [09:16:40.295] INFO: pxe:service Added contract Token at 0x300d9647848a69676a9cfc8605f0f57eaa2f9a7cc0ef4b4e3dd3a6ad712f6862 with class 0x30642d224a0f7351a15c91cc4ee6d506a5081a37f92e1465bc5d8aac973396b5 09:16:42 [09:16:42.820] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2010.5323550000003ms 09:16:42 [09:16:42.820] INFO: pxe:bb:native Generating Client IVC proof 09:16:43 [09:16:43.669] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0/ivc-inputs.msgpack 09:16:43 [09:16:43.669] INFO: pxe:bb:native bb - BB concurrency: undefined 09:16:43 [09:16:43.669] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0 --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0/ivc-inputs.msgpack -v --scheme client_ivc 09:16:43 [09:16:43.690] INFO: pxe:bb:native bb - bb command: prove (mem: 215.32 MiB) 09:16:43 Scheme is: client_ivc, num threads: 64 (mem: 215.32 MiB) 09:16:43 --scheme: client_ivc (mem: 215.32 MiB) 09:16:43 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0 (mem: 215.32 MiB) 09:16:43 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0/ivc-inputs.msgpack (mem: 215.32 MiB) 09:16:43 --verbose: true (mem: 215.32 MiB) 09:16:44 [09:16:44.257] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 215.32 MiB) 09:16:44 [09:16:44.257] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 215.32 MiB) 09:16:44 [09:16:44.296] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 215.32 MiB) 09:16:44 [09:16:44.338] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 215.32 MiB) 09:16:44 Constructing DeciderProvingKey (mem: 215.32 MiB) 09:16:44 [09:16:44.342] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 215.32 MiB) 09:16:44 goblin ecc op : 4/1024 (mem: 215.32 MiB) 09:16:44 busread : 742/6000 (mem: 215.32 MiB) 09:16:44 lookups : 2076/15000 (mem: 215.32 MiB) 09:16:44 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 215.32 MiB) 09:16:44 arithmetic : 9353/56000 09:16:44 [09:16:44.342] INFO: pxe:bb:native bb - (mem: 215.32 MiB) 09:16:44 delta range : 2977/18000 (mem: 215.32 MiB) 09:16:44 elliptic : 794/6000 (mem: 215.32 MiB) 09:16:44 auxiliary : 4528/26000 (mem: 215.32 MiB) 09:16:44 poseidon ext : 312/17000 (mem: 215.32 MiB) 09:16:44 poseidon int : 1769/92000 (mem: 215.32 MiB) 09:16:44 overflow : 0/0 (mem: 215.32 MiB) 09:16:44 (mem: 215.32 MiB) 09:16:44 Total structured size: 242025 (mem: 215.32 MiB) 09:16:44 allocating polynomials object in proving key... (mem: 215.32 MiB) 09:16:44 [09:16:44.437] INFO: pxe:bb:native bb - populating trace... (mem: 380.69 MiB) 09:16:44 [09:16:44.462] INFO: pxe:bb:native bb - time to construct proving key: 124 ms. (mem: 395.69 MiB) 09:16:44 [09:16:44.472] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe659fc3ab40 (mem: 395.69 MiB) 09:16:44 [09:16:44.472] INFO: pxe:bb:native bb - computing oink proof... (mem: 395.69 MiB) 09:16:44 [09:16:44.473] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 395.69 MiB) 09:16:44 [09:16:44.665] INFO: pxe:bb:native bb - oink proof constructed (mem: 417.69 MiB) 09:16:44 [09:16:44.688] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 417.69 MiB) 09:16:44 [09:16:44.696] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 418.19 MiB) 09:16:44 Constructing DeciderProvingKey (mem: 418.19 MiB) 09:16:44 [09:16:44.699] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 418.19 MiB) 09:16:44 goblin ecc op : 56/1024 (mem: 418.19 MiB) 09:16:44 busread : 2529/6000 (mem: 418.19 MiB) 09:16:44 lookups : 2/15000 (mem: 418.19 MiB) 09:16:44 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 418.19 MiB) 09:16:44 [09:16:44.699] INFO: pxe:bb:native bb - arithmetic : 21145/56000 (mem: 418.19 MiB) 09:16:44 delta range : 3034/18000 (mem: 418.19 MiB) 09:16:44 elliptic : 340/6000 (mem: 418.19 MiB) 09:16:44 auxiliary : 799/26000 (mem: 418.19 MiB) 09:16:44 poseidon ext : 2022/17000 (mem: 418.19 MiB) 09:16:44 poseidon int : 11516/92000 (mem: 418.19 MiB) 09:16:44 overflow : 0/0 (mem: 418.19 MiB) 09:16:44 (mem: 418.19 MiB) 09:16:44 Total structured size: 242025 (mem: 418.19 MiB) 09:16:44 allocating polynomials object in proving key... (mem: 418.19 MiB) 09:16:44 [09:16:44.739] INFO: pxe:bb:native bb - populating trace... (mem: 635.19 MiB) 09:16:44 [09:16:44.759] INFO: pxe:bb:native bb - time to construct proving key: 62 ms. (mem: 649.69 MiB) 09:16:44 [09:16:44.781] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe65a02781c0 (mem: 649.69 MiB) 09:16:44 computing folding proof (mem: 649.69 MiB) 09:16:44 [09:16:44.782] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000398959ae56eb9c01a92891da007bef4c (mem: 649.69 MiB) 09:16:45 [09:16:45.013] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 649.69 MiB) 09:16:45 [09:16:45.066] INFO: pxe:bb:native bb - perturbator round (mem: 680.69 MiB) 09:16:45 [09:16:45.114] INFO: pxe:bb:native bb - combiner quotient round (mem: 712.69 MiB) 09:16:45 [09:16:45.186] INFO: pxe:bb:native bb - folded (mem: 712.69 MiB) 09:16:45 constructed folding proof (mem: 712.69 MiB) 09:16:45 [09:16:45.191] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractInstanceDeployer:deploy (mem: 712.69 MiB) 09:16:45 Constructing DeciderProvingKey (mem: 712.69 MiB) 09:16:45 [09:16:45.193] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 712.69 MiB) 09:16:45 goblin ecc op : 4/1024 (mem: 712.69 MiB) 09:16:45 busread : 742/6000 (mem: 712.69 MiB) 09:16:45 lookups : 2/15000 (mem: 712.69 MiB) 09:16:45 [09:16:45.193] INFO: pxe:bb:native bb - pub inputs : 16/5000 (populated in decider pk constructor) (mem: 712.69 MiB) 09:16:45 arithmetic : 3656/56000 (mem: 712.69 MiB) 09:16:45 delta range : 1838/18000 (mem: 712.69 MiB) 09:16:45 elliptic : 340/6000 (mem: 712.69 MiB) 09:16:45 auxiliary : 187/26000 (mem: 712.69 MiB) 09:16:45 poseidon ext : 162/17000 (mem: 712.69 MiB) 09:16:45 poseidon int : 914/92000 (mem: 712.69 MiB) 09:16:45 overflow : 0/0 (mem: 712.69 MiB) 09:16:45 (mem: 712.69 MiB) 09:16:45 Total structured size: 242025 (mem: 712.69 MiB) 09:16:45 allocating polynomials object in proving key... (mem: 712.69 MiB) 09:16:45 [09:16:45.203] INFO: pxe:bb:native bb - populating trace... (mem: 712.69 MiB) 09:16:45 [09:16:45.208] INFO: pxe:bb:native bb - time to construct proving key: 16 ms. (mem: 712.69 MiB) 09:16:45 [09:16:45.234] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe659fc5fe00 (mem: 712.69 MiB) 09:16:45 computing folding proof (mem: 712.69 MiB) 09:16:45 [09:16:45.234] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 712.69 MiB) 09:16:45 [09:16:45.319] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 712.69 MiB) 09:16:45 [09:16:45.367] INFO: pxe:bb:native bb - perturbator round (mem: 712.69 MiB) 09:16:45 [09:16:45.428] INFO: pxe:bb:native bb - combiner quotient round (mem: 713.44 MiB) 09:16:45 [09:16:45.526] INFO: pxe:bb:native bb - folded (mem: 713.44 MiB) 09:16:45 constructed folding proof (mem: 713.44 MiB) 09:16:45 [09:16:45.556] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000398959ae56eb9c01a92891da007bef4c (mem: 713.44 MiB) 09:16:45 [09:16:45.598] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 713.44 MiB) 09:16:45 [09:16:45.637] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 713.44 MiB) 09:16:45 Constructing DeciderProvingKey (mem: 713.44 MiB) 09:16:45 [09:16:45.642] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 713.44 MiB) 09:16:45 goblin ecc op : 792/1024 (mem: 713.44 MiB) 09:16:45 busread : 4184/6000 (mem: 713.44 MiB) 09:16:45 lookups : 2/15000 (mem: 713.44 MiB) 09:16:45 [09:16:45.642] INFO: pxe:bb:native bb - pub inputs : 32/5000 (populated in decider pk constructor) (mem: 713.44 MiB) 09:16:45 arithmetic : 43807/56000 (mem: 713.44 MiB) 09:16:45 delta range : 5025/18000 (mem: 713.44 MiB) 09:16:45 elliptic : 340/6000 (mem: 713.44 MiB) 09:16:45 auxiliary : 1399/26000 (mem: 713.44 MiB) 09:16:45 poseidon ext : 5682/17000 (mem: 713.44 MiB) 09:16:45 poseidon int : 32378/92000 (mem: 713.44 MiB) 09:16:45 overflow : 0/0 (mem: 713.44 MiB) 09:16:45 (mem: 713.44 MiB) 09:16:45 Total structured size: 242025 (mem: 713.44 MiB) 09:16:45 allocating polynomials object in proving key... (mem: 713.44 MiB) 09:16:45 [09:16:45.654] INFO: pxe:bb:native bb - populating trace... (mem: 713.44 MiB) 09:16:45 [09:16:45.682] INFO: pxe:bb:native bb - time to construct proving key: 45 ms. (mem: 713.44 MiB) 09:16:45 [09:16:45.717] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe65a0300d40 (mem: 713.44 MiB) 09:16:45 computing folding proof (mem: 713.44 MiB) 09:16:45 [09:16:45.718] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 713.44 MiB) 09:16:46 [09:16:45.999] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 713.44 MiB) 09:16:46 [09:16:46.050] INFO: pxe:bb:native bb - perturbator round (mem: 716.48 MiB) 09:16:46 [09:16:46.104] INFO: pxe:bb:native bb - combiner quotient round (mem: 748.48 MiB) 09:16:46 [09:16:46.176] INFO: pxe:bb:native bb - folded (mem: 748.48 MiB) 09:16:46 constructed folding proof (mem: 748.48 MiB) 09:16:46 [09:16:46.180] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractClassRegisterer:assert_class_id_is_registered (mem: 748.48 MiB) 09:16:46 Constructing DeciderProvingKey (mem: 748.48 MiB) 09:16:46 [09:16:46.181] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 748.48 MiB) 09:16:46 goblin ecc op : 4/1024 (mem: 748.48 MiB) 09:16:46 [09:16:46.182] INFO: pxe:bb:native bb - busread : 742/6000 (mem: 748.48 MiB) 09:16:46 lookups : 2/15000 (mem: 748.48 MiB) 09:16:46 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 748.48 MiB) 09:16:46 arithmetic : 3287/56000 (mem: 748.48 MiB) 09:16:46 delta range : 1787/18000 (mem: 748.48 MiB) 09:16:46 elliptic : 2/6000 (mem: 748.48 MiB) 09:16:46 auxiliary : 26/26000 (mem: 748.48 MiB) 09:16:46 poseidon ext : 12/17000 (mem: 748.48 MiB) 09:16:46 poseidon int : 59/92000 (mem: 748.48 MiB) 09:16:46 overflow : 0/0 (mem: 748.48 MiB) 09:16:46 (mem: 748.48 MiB) 09:16:46 Total structured size: 242025 (mem: 748.48 MiB) 09:16:46 allocating polynomials object in proving key... (mem: 748.48 MiB) 09:16:46 [09:16:46.195] INFO: pxe:bb:native bb - populating trace... (mem: 748.48 MiB) 09:16:46 [09:16:46.199] INFO: pxe:bb:native bb - time to construct proving key: 19 ms. (mem: 748.48 MiB) 09:16:46 [09:16:46.238] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe659fa42d80 (mem: 748.48 MiB) 09:16:46 computing folding proof (mem: 748.48 MiB) 09:16:46 [09:16:46.238] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 748.48 MiB) 09:16:46 [09:16:46.306] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 748.48 MiB) 09:16:46 [09:16:46.360] INFO: pxe:bb:native bb - perturbator round (mem: 748.48 MiB) 09:16:46 [09:16:46.407] INFO: pxe:bb:native bb - combiner quotient round (mem: 748.48 MiB) 09:16:46 [09:16:46.487] INFO: pxe:bb:native bb - folded (mem: 748.48 MiB) 09:16:46 constructed folding proof (mem: 748.48 MiB) 09:16:46 [09:16:46.517] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 748.48 MiB) 09:16:46 [09:16:46.559] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 748.48 MiB) 09:16:46 [09:16:46.597] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 748.48 MiB) 09:16:46 Constructing DeciderProvingKey (mem: 748.48 MiB) 09:16:46 [09:16:46.602] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 748.48 MiB) 09:16:46 goblin ecc op : 792/1024 (mem: 748.48 MiB) 09:16:46 busread : 4184/6000 (mem: 748.48 MiB) 09:16:46 lookups : 2/15000 (mem: 748.48 MiB) 09:16:46 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 748.48 MiB) 09:16:46 arithmetic : 43807/56000 (mem: 748.48 MiB) 09:16:46 delta range : 5025/18000 (mem: 748.48 MiB) 09:16:46 [09:16:46.602] INFO: pxe:bb:native bb - elliptic : 340/6000 (mem: 748.48 MiB) 09:16:46 auxiliary : 1399/26000 (mem: 748.48 MiB) 09:16:46 poseidon ext : 5682/17000 (mem: 748.48 MiB) 09:16:46 poseidon int : 32378/92000 (mem: 748.48 MiB) 09:16:46 overflow : 0/0 (mem: 748.48 MiB) 09:16:46 (mem: 748.48 MiB) 09:16:46 Total structured size: 242025 (mem: 748.48 MiB) 09:16:46 allocating polynomials object in proving key... (mem: 748.48 MiB) 09:16:46 [09:16:46.616] INFO: pxe:bb:native bb - populating trace... (mem: 748.48 MiB) 09:16:46 [09:16:46.645] INFO: pxe:bb:native bb - time to construct proving key: 47 ms. (mem: 748.48 MiB) 09:16:46 [09:16:46.693] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe659fa43bc0 (mem: 748.48 MiB) 09:16:46 computing folding proof (mem: 748.48 MiB) 09:16:46 [09:16:46.693] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 748.48 MiB) 09:16:46 [09:16:46.975] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 748.48 MiB) 09:16:47 [09:16:47.036] INFO: pxe:bb:native bb - perturbator round (mem: 748.48 MiB) 09:16:47 [09:16:47.079] INFO: pxe:bb:native bb - combiner quotient round (mem: 748.48 MiB) 09:16:47 [09:16:47.159] INFO: pxe:bb:native bb - folded (mem: 748.48 MiB) 09:16:47 constructed folding proof (mem: 748.48 MiB) 09:16:47 [09:16:47.207] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e61488035ff3601c168c29a202d1c59 (mem: 748.48 MiB) 09:16:47 [09:16:47.247] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 748.48 MiB) 09:16:47 Constructing DeciderProvingKey (mem: 748.48 MiB) 09:16:47 [09:16:47.255] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 748.48 MiB) 09:16:47 goblin ecc op : 392/1024 (mem: 748.48 MiB) 09:16:47 busread : 2347/6000 (mem: 748.48 MiB) 09:16:47 lookups : 2/15000 (mem: 748.48 MiB) 09:16:47 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 748.48 MiB) 09:16:47 arithmetic : 36209/56000 (mem: 748.48 MiB) 09:16:47 delta range : 4306/18000 (mem: 09:16:47 [09:16:47.255] INFO: pxe:bb:native bb - 748.48 MiB) 09:16:47 elliptic : 1274/6000 (mem: 748.48 MiB) 09:16:47 auxiliary : 12562/26000 (mem: 748.48 MiB) 09:16:47 poseidon ext : 6112/17000 (mem: 748.48 MiB) 09:16:47 poseidon int : 34829/92000 (mem: 748.48 MiB) 09:16:47 overflow : 0/0 (mem: 748.48 MiB) 09:16:47 (mem: 748.48 MiB) 09:16:47 Total structured size: 242025 (mem: 748.48 MiB) 09:16:47 allocating polynomials object in proving key... (mem: 748.48 MiB) 09:16:47 [09:16:47.266] INFO: pxe:bb:native bb - populating trace... (mem: 748.48 MiB) 09:16:47 [09:16:47.300] INFO: pxe:bb:native bb - time to construct proving key: 52 ms. (mem: 748.48 MiB) 09:16:47 [09:16:47.339] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe65a1eeaf00 (mem: 748.48 MiB) 09:16:47 computing folding proof (mem: 748.48 MiB) 09:16:47 [09:16:47.339] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c211ff9c7a9c97c80d116c907b808844 (mem: 748.48 MiB) 09:16:47 [09:16:47.672] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 748.48 MiB) 09:16:47 [09:16:47.730] INFO: pxe:bb:native bb - perturbator round (mem: 748.48 MiB) 09:16:47 [09:16:47.802] INFO: pxe:bb:native bb - combiner quotient round (mem: 779.68 MiB) 09:16:47 [09:16:47.878] INFO: pxe:bb:native bb - folded (mem: 779.68 MiB) 09:16:47 constructed folding proof (mem: 779.68 MiB) 09:16:47 [09:16:47.901] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c211ff9c7a9c97c80d116c907b808844 (mem: 779.68 MiB) 09:16:47 [09:16:47.941] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 779.68 MiB) 09:16:47 Constructing DeciderProvingKey (mem: 779.68 MiB) 09:16:47 [09:16:47.948] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 779.68 MiB) 09:16:47 goblin ecc op : 392/1024 (mem: 779.68 MiB) 09:16:47 [09:16:47.949] INFO: pxe:bb:native bb - busread : 231/6000 (mem: 779.68 MiB) 09:16:47 lookups : 2/15000 (mem: 779.68 MiB) 09:16:47 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 779.68 MiB) 09:16:47 arithmetic : 32330/56000 (mem: 779.68 MiB) 09:16:47 delta range : 4411/18000 (mem: 779.68 MiB) 09:16:47 elliptic : 2/6000 (mem: 779.68 MiB) 09:16:47 auxiliary : 11868/26000 (mem: 779.68 MiB) 09:16:47 poseidon ext : 2552/17000 (mem: 779.68 MiB) 09:16:47 poseidon int : 14537/92000 (mem: 779.68 MiB) 09:16:47 overflow : 0/0 (mem: 779.68 MiB) 09:16:47 (mem: 779.68 MiB) 09:16:47 Total structured size: 242025 (mem: 779.68 MiB) 09:16:47 allocating polynomials object in proving key... (mem: 779.68 MiB) 09:16:47 [09:16:47.960] INFO: pxe:bb:native bb - populating trace... (mem: 779.68 MiB) 09:16:48 [09:16:47.986] INFO: pxe:bb:native bb - time to construct proving key: 45 ms. (mem: 779.68 MiB) 09:16:48 [09:16:48.041] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0xbe659ffa9e80 (mem: 779.68 MiB) 09:16:48 computing folding proof (mem: 779.68 MiB) 09:16:48 [09:16:48.042] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000004e5c65f357d227066d8ec7a7045e6c0 (mem: 779.68 MiB) 09:16:48 [09:16:48.350] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 779.68 MiB) 09:16:48 [09:16:48.404] INFO: pxe:bb:native bb - perturbator round (mem: 779.68 MiB) 09:16:48 [09:16:48.453] INFO: pxe:bb:native bb - combiner quotient round (mem: 779.68 MiB) 09:16:48 [09:16:48.547] INFO: pxe:bb:native bb - folded (mem: 779.68 MiB) 09:16:48 constructed folding proof (mem: 779.68 MiB) 09:16:48 [09:16:48.551] INFO: pxe:bb:native bb - Largest circuit: 97641 gates. Trace details: (mem: 779.68 MiB) 09:16:48 Minimum required block sizes for structured trace: (mem: 779.68 MiB) 09:16:48 [09:16:48.551] INFO: pxe:bb:native bb - (mem: 779.68 MiB) 09:16:48 prove decider... (mem: 779.68 MiB) 09:16:48 [09:16:48.551] INFO: pxe:bb:native bb - ecc_op : 792 09:16:48 busread : 4184 09:16:48 lookup : 2076 09:16:48 pub_inputs : 1859 09:16:48 arithmetic : 43807 09:16:48 delta_range : 5025 09:16:48 elliptic : 1274 09:16:48 aux : 12562 09:16:48 poseidon2_external : 6112 09:16:48 poseidon2_internal : 34829 09:16:48 overflow : 0 09:16:48 [09:16:48.608] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 779.68 MiB) 09:16:48 [09:16:48.680] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 779.68 MiB) 09:16:49 [09:16:49.142] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 779.68 MiB) 09:16:49 [09:16:49.226] INFO: pxe:bb:native bb - computed opening proof (mem: 779.68 MiB) 09:16:49 finished decider proving. (mem: 779.68 MiB) 09:16:49 [09:16:49.237] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000004e5c65f357d227066d8ec7a7045e6c0 (mem: 779.68 MiB) 09:16:49 [09:16:49.337] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 779.68 MiB) 09:16:49 [09:16:49.340] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 779.68 MiB) 09:16:49 [09:16:49.355] INFO: pxe:bb:native bb - populating trace... (mem: 779.68 MiB) 09:16:49 [09:16:49.395] INFO: pxe:bb:native bb - time to construct proving key: 57 ms. (mem: 779.68 MiB) 09:16:50 [09:16:49.982] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000f18a0809f37bfdacae8e5ba8412d0553 (mem: 779.68 MiB) 09:16:50 [09:16:50.348] INFO: pxe:bb:native bb - created oink proof (mem: 779.68 MiB) 09:16:50 [09:16:50.404] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 779.68 MiB) 09:16:50 [09:16:50.537] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 779.68 MiB) 09:16:51 [09:16:50.886] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 779.68 MiB) 09:16:51 [09:16:50.941] INFO: pxe:bb:native bb - computed opening proof (mem: 779.68 MiB) 09:16:51 finished decider proving. (mem: 779.68 MiB) 09:16:51 [09:16:50.941] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3022 (mem: 779.68 MiB) 09:16:51 [09:16:51.022] INFO: pxe:bb:native bb - prove eccvm... (mem: 779.68 MiB) 09:16:51 [09:16:51.197] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 779.68 MiB) 09:16:51 [09:16:51.204] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 779.68 MiB) 09:16:52 [09:16:52.160] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 779.68 MiB) 09:16:53 [09:16:52.928] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 779.68 MiB) 09:16:55 [09:16:54.582] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 779.68 MiB) 09:16:55 prove translator... (mem: 779.68 MiB) 09:16:55 [09:16:55.273] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 779.68 MiB) 09:16:55 [09:16:55.837] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 779.68 MiB) 09:16:56 [09:16:56.566] INFO: pxe:bb:native bb - computed opening proof (mem: 779.68 MiB) 09:16:56 [09:16:56.566] INFO: pxe:bb:native bb - finished translator proving. (mem: 779.68 MiB) 09:16:56 [09:16:56.567] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x00000000000000000000000000000000f18a0809f37bfdacae8e5ba8412d0553 (mem: 779.68 MiB) 09:16:56 [09:16:56.591] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 779.68 MiB) 09:16:56 libra_evals_verified: 1 (mem: 779.68 MiB) 09:16:56 pairing_check_verified: 1 (mem: 779.68 MiB) 09:16:56 Mega verified: 1 (mem: 779.68 MiB) 09:16:56 [09:16:56.640] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 779.68 MiB) 09:16:56 batch opening verified?: 1 (mem: 779.68 MiB) 09:16:56 eccvm consistency check verified?: 1 (mem: 779.68 MiB) 09:16:56 translation masking consistency checked?: 1 (mem: 779.68 MiB) 09:16:56 [09:16:56.658] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 779.68 MiB) 09:16:56 eccvm verified?: 1 (mem: 779.68 MiB) 09:16:56 accumulator construction_verified?: 1 (mem: 779.68 MiB) 09:16:56 translation verified?: 1 (mem: 779.68 MiB) 09:16:56 consistency verified?: 1 (mem: 779.68 MiB) 09:16:56 [09:16:56.658] INFO: pxe:bb:native bb - Goblin verified: 1 (mem: 779.68 MiB) 09:16:56 [09:16:56.658] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-Bw8eS0" (mem: 779.68 09:16:56 [09:16:56.658] INFO: pxe:bb:native bb - MiB) 09:16:56 [09:16:56.775] INFO: pxe:bb:native Generated IVC proof {"duration":13105.375925999999,"eventName":"circuit-proving"} 09:16:56 [09:16:56.778] INFO: pxe:service Proving completed in 16473.885483ms {"timings":{"total":16473.885483,"sync":42.60630200000014,"proving":13958.143756,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":370.3112460000002,"oracles":{"debugLog":{"times":[0.5890030000000479,0.20583200000010038,0.14232100000026549,0.3770489999997153,0.1873259999997572,0.15063299999974333,0.18804300000010699,0.2779249999998683]},"fetchTaggedLogs":{"times":[132.2439159999999]},"loadCapsule":{"times":[0.46554699999978766,0.3071310000000267,0.5297030000001541,0.3509740000004058,0.9471899999998641,0.3944019999999,0.3302590000002965,0.35313799999994444,0.5017320000001746,0.27749199999971097]},"getSharedSecret":{"times":[4.388065999999981]},"aes128Decrypt":{"times":[0.9730019999997239,0.7436029999998937]},"getPublicKeysAndPartialAddress":{"times":[4.5054879999997866]},"getKeyValidationRequest":{"times":[3.151542000000063]},"storeCapsule":{"times":[3.029443999999785,3.0901859999999033,3.872088000000076]},"deleteCapsule":{"times":[2.7097390000003543]},"bulkRetrieveLogs":{"times":[7.237792999999783]},"validateEnqueuedNotesAndEvents":{"times":[18.51996999999983]},"getNotes":{"times":[2.8133130000001074]},"getAuthWitness":{"times":[0.3206589999999778]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.2778160000002572]},"callPrivateFunction":{"times":[88.09909900000002]},"notifyEnqueuedPublicFunctionCall":{"times":[0.24794400000018868]}}},{"functionName":"private_kernel_init","time":208.70103199999994},{"functionName":"ContractInstanceDeployer:deploy","time":46.86700099999962,"oracles":{"storeInExecutionCache":{"times":[0.22521000000006097]},"callPrivateFunction":{"times":[45.72088500000018]},"notifyCreatedNullifier":{"times":[0.4109979999998359]},"debugLog":{"times":[0.24277099999972052]}}},{"functionName":"private_kernel_inner","time":401.0820239999998},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.98522300000013,"oracles":{}},{"functionName":"private_kernel_inner","time":377.1383879999994},{"functionName":"private_kernel_reset","time":409.9644819999994},{"functionName":"private_kernel_tail","time":366.15989699999955}],"unaccounted":258.9261320000005}} 09:16:56 [09:16:56.857] INFO: pxe:service Sent transaction 0x2236f7be1708c7ee1a77be4678427edbde4632e001afc56cf180302cbc6ef3cf 09:16:57 [09:16:56.856] INFO: node Received tx 0x2236f7be1708c7ee1a77be4678427edbde4632e001afc56cf180302cbc6ef3cf {"txHash":"0x2236f7be1708c7ee1a77be4678427edbde4632e001afc56cf180302cbc6ef3cf"} 09:16:57 [09:16:57.024] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.12902980200000458s {"duration":0.12902980200000458,"rate":2452549.683056855,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 09:16:57 [09:16:57.046] INFO: sequencer Built block 11 for slot 13 with 1 txs and 0 messages. 2009393.475730807 mana/s {"blockHash":"0x1d7cefb5d41b99a71e2e04a8e8ccf014576755588e3e6d91ef7315e2f1c5b404","globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750843621,"version":2687597111},"txHashes":["0x2236f7be1708c7ee1a77be4678427edbde4632e001afc56cf180302cbc6ef3cf"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":157.43940000000293,"publicProcessDuration":129.11102199999732,"rollupCircuitsDuration":152.63975199998822,"txCount":1,"blockNumber":11,"blockTimestamp":1750843621,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:57 [09:16:57.217] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:16:57 [09:16:57.267] WARN: ethereum:cheat_codes Set L1 storage for contract 0x7813a13fcba4860e6412ac99d5be7c75a19d6dce at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 11 09:16:57 [09:16:57.268] INFO: aztecjs:cheat_codes Proven tip moved: 10 -> 11. Pending tip: 11. 09:16:57 [09:16:57.417] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750843657 09:16:57 [09:16:57.417] WARN: foundation:test-date-provider Time set to 2025-06-25T09:27:37.000Z {"offset":639583,"timeMs":1750843657000} 09:16:57 [09:16:57.417] INFO: aztecjs:utils:watcher Slot 13 was filled, jumped to next slot 09:16:57 [09:16:57.451] INFO: archiver Downloaded L2 block 11 {"blockHash":"0x1d7cefb5d41b99a71e2e04a8e8ccf014576755588e3e6d91ef7315e2f1c5b404","blockNumber":11,"txCount":1,"globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2890,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750843621,"version":2687597111},"archiveRoot":"0x11fb12bf7b993c0ad6ea9a706641cec41b7471608dde4f158f4531fc46429af6","archiveNextLeafIndex":12} 09:16:57 [09:16:57.452] INFO: archiver Updated proven chain to block 11 {"provenBlockNumber":11} 09:16:57 [09:16:57.528] INFO: world_state World state updated with L2 block 11 {"eventName":"l2-block-handled","duration":4.942456000004313,"unfinalisedBlockNumber":11,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":11,"blockTimestamp":1750843621,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:16:58 Contract deployed at 0x300d9647848a69676a9cfc8605f0f57eaa2f9a7cc0ef4b4e3dd3a6ad712f6862 09:16:58 Contract partial address 0x270619271df81407bf257a88a68f5a958799e356ac109025174d683698e5a74f 09:16:58 Contract init hash 0x14620e39b834d0b89f5da4921ee298eca95eefa64fe3c2f5dac47558ba535105 09:16:58 Deployment tx hash: 0x2236f7be1708c7ee1a77be4678427edbde4632e001afc56cf180302cbc6ef3cf 09:16:58 Deployment salt: 0x1564f08b589553033e79ecb994061e3c78402a7b3d8fb29418dbed3660576eed 09:16:58 Deployment fee: 982553760 09:16:58 Contract stored in database with alias last 09:17:00 Sending kill to pid 454 09:17:00 Sending kill to aztec-start-06f81398