Parent Log: http://ci.aztec-labs.com/9b1548acd97b5e1c Command: f6fa41634f6079f7 aztec-up/scripts/run_test.sh bridge_and_claim Commit: https://github.com/AztecProtocol/aztec-packages/commit/bd28eda782eb6f2e1e5c2101a27104b4ad8796b3 Env: REF_NAME=gh-readonly-queue/next/pr-15315-634f8607a18c02c1d6e9ab5f302821fa8fc0e833 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 26 16:33:19 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15315_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_ee64b3b6ca626708_next 16:33:19 Unable to find image 'aztecprotocol/dind:latest' locally 16:33:19 latest: Pulling from aztecprotocol/dind 16:33:19 afad30e59d72: Pulling fs layer 16:33:19 4e9c72eacf62: Pulling fs layer 16:33:19 1fdf475197e7: Pulling fs layer 16:33:19 5be0e287c3f8: Pulling fs layer 16:33:19 5be0e287c3f8: Download complete 16:33:19 4e9c72eacf62: Download complete 16:33:19 1fdf475197e7: Verifying Checksum 16:33:19 1fdf475197e7: Download complete 16:33:20 afad30e59d72: Pull complete 16:33:20 4e9c72eacf62: Pull complete 16:33:25 1fdf475197e7: Pull complete 16:33:25 5be0e287c3f8: Pull complete 16:33:25 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b 16:33:25 Status: Downloaded newer image for aztecprotocol/dind:latest 16:33:25 Starting docker... 16:33:30 time="2025-06-26T16:33:25.745532647Z" level=info msg="Starting up" 16:33:30 time="2025-06-26T16:33:25.746513977Z" level=info msg="containerd not running, starting managed containerd" 16:33:30 time="2025-06-26T16:33:25.748706584Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=81 16:33:30 time="2025-06-26T16:33:25.781878745Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=1.7.25-1 16:33:30 time="2025-06-26T16:33:25.798439004Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.798699030Z" 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 16:33:30 time="2025-06-26T16:33:25.798741433Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 16:33:30 time="2025-06-26T16:33:25.798755763Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 16:33:30 time="2025-06-26T16:33:25.802117472Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 16:33:30 time="2025-06-26T16:33:25.802146214Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802197547Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802206278Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802356767Z" 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 16:33:30 time="2025-06-26T16:33:25.802370578Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802383029Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802389959Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802440882Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802632194Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 16:33:30 time="2025-06-26T16:33:25.802753312Z" 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 16:33:30 time="2025-06-26T16:33:25.802763972Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 16:33:30 time="2025-06-26T16:33:25.802785834Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 16:33:30 time="2025-06-26T16:33:25.802813155Z" level=info msg="metadata content store policy set" policy=shared 16:33:30 time="2025-06-26T16:33:25.803038529Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 16:33:30 time="2025-06-26T16:33:25.803081952Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 16:33:30 time="2025-06-26T16:33:25.803133706Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 16:33:30 time="2025-06-26T16:33:25.803150576Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 16:33:30 time="2025-06-26T16:33:25.803168798Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 16:33:30 time="2025-06-26T16:33:25.803313037Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 16:33:30 time="2025-06-26T16:33:25.803565612Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 16:33:30 time="2025-06-26T16:33:25.803704981Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 16:33:30 time="2025-06-26T16:33:25.803724332Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 16:33:30 time="2025-06-26T16:33:25.803741343Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 16:33:30 time="2025-06-26T16:33:25.803757454Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803772425Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803786996Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803803127Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803820718Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803835019Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803849810Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803865201Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 16:33:30 time="2025-06-26T16:33:25.803896603Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.803914064Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.803930335Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.803947746Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.803962767Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.803978258Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804003909Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804021251Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804036022Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804053873Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804070404Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804085515Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804132848Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804151469Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 16:33:30 time="2025-06-26T16:33:25.804177620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804205982Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804221143Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 16:33:30 time="2025-06-26T16:33:25.804305418Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 16:33:30 time="2025-06-26T16:33:25.804325529Z" 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 16:33:30 time="2025-06-26T16:33:25.804337570Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 16:33:30 time="2025-06-26T16:33:25.804350971Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 16:33:30 time="2025-06-26T16:33:25.804361692Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 16:33:30 time="2025-06-26T16:33:25.804377303Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 16:33:30 time="2025-06-26T16:33:25.804391044Z" level=info msg="NRI interface is disabled by configuration." 16:33:30 time="2025-06-26T16:33:25.804701423Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock 16:33:30 time="2025-06-26T16:33:25.804805219Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc 16:33:30 time="2025-06-26T16:33:25.804911796Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock 16:33:30 time="2025-06-26T16:33:25.804944218Z" level=info msg="containerd successfully booted in 0.024220s" 16:33:30 time="2025-06-26T16:33:26.754945077Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" 16:33:30 time="2025-06-26T16:33:26.782885283Z" level=info msg="Loading containers: start." 16:33:30 time="2025-06-26T16:33:27.024707058Z" level=info msg="Loading containers: done." 16:33:30 time="2025-06-26T16:33:27.038954134Z" level=info msg="Docker daemon" commit=38b84dce32c45732606fe09ffebef8b29a783644 containerd-snapshotter=false storage-driver=overlay2 version=27.5.0-1 16:33:30 time="2025-06-26T16:33:27.039259853Z" level=info msg="Daemon has completed initialization" 16:33:30 time="2025-06-26T16:33:27.051346214Z" level=info msg="API listen on /var/run/docker.sock" 16:33:30 Loading image... 16:34:03 Loaded image: aztecprotocol/aztec:latest 16:34:04 Installing scripts in /home/ubuntu/.aztec/bin... 16:34:04 Installed: /home/ubuntu/.aztec/bin/.aztec-run 16:34:04 Installed: /home/ubuntu/.aztec/bin/aztec 16:34:04 Installed: /home/ubuntu/.aztec/bin/aztec-up 16:34:04 Installed: /home/ubuntu/.aztec/bin/aztec-nargo 16:34:04 Installed: /home/ubuntu/.aztec/bin/aztec-wallet 16:34:04 Done! 16:34:06 anvil Version: 1.2.3-nightly 16:34:06 Commit SHA: 99634144b6c9371982dcfc551a7975c5dbf9fad8 16:34:06 Build Timestamp: 2025-06-06T06:02:57.177433691Z (1749189777) 16:34:06 Build Profile: maxperf 16:34:12 16:34:12 _ 16:34:12 /\ | | 16:34:12 / \ ___| |_ ___ ___ 16:34:12 / /\ \ |_ / __/ _ \/ __| 16:34:12 / ____ \ / /| || __/ (__ 16:34:12 /_/___ \_\/___|\__\___|\___| 16:34:12 16:34:12 https://github.com/AztecProtocol 16:34:12 16:34:12 16:34:12 Setting up Aztec Sandbox bd28eda782eb6f2e1e5c2101a27104b4ad8796b3, please stand by... 16:34:12 Setting up test accounts 16:34:13 [16:34:12.922] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-fXfctN/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 16:34:13 [16:34:13.003] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 16:34:13 [16:34:13.009] WARN: sandbox Set block interval to 12 16:34:13 [16:34:13.011] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.070] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.098] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.125] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.151] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.177] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.215] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.236] INFO: sandbox Waiting for 7 transactions to be mined... 16:34:13 [16:34:13.311] INFO: sandbox All transactions mined successfully 16:34:13 [16:34:13.336] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.402] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.466] INFO: sandbox Waiting for 9 transactions to be mined... 16:34:13 [16:34:13.522] INFO: sandbox All transactions mined successfully 16:34:13 [16:34:13.565] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.583] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.602] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.635] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.702] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.765] INFO: sandbox Waiting for 11 transactions to be mined... 16:34:13 [16:34:13.806] INFO: sandbox All transactions mined successfully 16:34:13 [16:34:13.829] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000006f4e 16:34:13 [16:34:13.926] INFO: sandbox Waiting for 12 transactions to be mined... 16:34:13 [16:34:13.960] INFO: sandbox All transactions mined successfully 16:34:13 [16:34:13.976] INFO: sandbox Waiting for 12 transactions to be mined... 16:34:14 [16:34:14.008] INFO: sandbox All transactions mined successfully 16:34:14 [16:34:14.028] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0x848429a44b92a968c299b8fc4e0b76490ad904a6","governanceAddress":"0x9afe43710c0f9514b560b75e4c031d81a8c69f5b","governanceProposerAddress":"0x1ea19343d4e4b699c3db2888fec80e44fc1ee1c7","rollupAddress":"0xac9336e5b15c2d0f8df8ced01f538e65826e7f20","inboxAddress":"0x14f53de729f7050443fa0c4083097558e75998f8","outboxAddress":"0xf9bfad86b7da990bcf2cc2358a33f1cab3d136c2","feeJuicePortalAddress":"0x00f26a58474b119198759dbc34eaf18f6604a24a","feeJuiceAddress":"0x0302c4c80fdd1f9269b0bf3ac7d831a9e7ee735b","stakingAssetAddress":"0x551c2d5af66ba340f86b5cc182b9bd704afaf113","rewardDistributorAddress":"0x02892f8247233ded227bcc848c9c7bd2afc6d30f","gseAddress":"0xf170f28c21e712d93368994f7099c2ba96441ed3","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 16:34:14 [16:34:14.028] INFO: sandbox Handing over to governance 16:34:14 [16:34:14.044] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 16:34:14 [16:34:14.051] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 16:34:14 [16:34:14.058] INFO: sandbox Deployed Multicall3 16:34:14 [16:34:14.070] INFO: aztecjs:utils:watcher Watcher started for rollup at 0xAc9336e5B15c2d0F8Df8Ced01f538E65826E7f20 16:34:14 [16:34:14.071] INFO: telemetry:client Using NoopTelemetryClient 16:34:14 [16:34:14.072] INFO: blob-sink:client Creating local blob sink client. 16:34:14 [16:34:14.083] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:34:14 [16:34:14.083] WARN: foundation:test-date-provider Time set to 2025-06-26T16:39:18.000Z {"offset":303917,"timeMs":1750955958000} 16:34:14 [16:34:14.113] INFO: archiver:lmdb Starting data store with maxReaders 16 16:34:14 [16:34:14.589] INFO: archiver Starting archiver sync to rollup contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 from L1 block 20 to current L1 block 26 with hash 0x9d36bf73a5b488347ee2494f923bf266289de5623cdaf7af7b087e530dcb87a9 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x2a59aade9c5a5bd429e6cb244d19a1f6533c28530d6572327490c258d0edcaad","l1BlockNumber":20}} 16:34:14 [16:34:14.606] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:34:14 [16:34:14.617] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-y7sJ6F/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 16:34:14 [16:34:14.677] INFO: world_state Created world state synchroniser with block history of 64 16:34:14 [16:34:14.677] WARN: node Aztec node is accepting fake proofs 16:34:14 [16:34:14.678] INFO: bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers 16:34:14 [16:34:14.695] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:34:14 [16:34:14.700] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:34:14 [16:34:14.703] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:34:14 [16:34:14.707] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:34:14 [16:34:14.711] INFO: world_state Started world state synchronizer from block 1 16:34:15 [16:34:14.715] INFO: p2p Starting p2p client from block 0 with empty mempools 16:34:15 [16:34:15.015] INFO: epoch-prune-watcher EpochPruneWatcher initialized 16:34:15 [16:34:15.086] INFO: slasher Starting Slasher client... 16:34:15 [16:34:15.115] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:34:15 [16:34:15.116] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/usr/src/acvm","acvmBinaryPath":"/usr/src/noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true} 16:34:15 [16:34:15.123] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:34:15 [16:34:15.124] INFO: node Aztec Node version: bd28eda782eb6f2e1e5c2101a27104b4ad8796b3 16:34:15 [16:34:15.124] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0xac9336e5b15c2d0f8df8ced01f538e65826e7f20","registryAddress":"0x848429a44b92a968c299b8fc4e0b76490ad904a6","inboxAddress":"0x14f53de729f7050443fa0c4083097558e75998f8","outboxAddress":"0xf9bfad86b7da990bcf2cc2358a33f1cab3d136c2","feeJuiceAddress":"0x0302c4c80fdd1f9269b0bf3ac7d831a9e7ee735b","stakingAssetAddress":"0x551c2d5af66ba340f86b5cc182b9bd704afaf113","feeJuicePortalAddress":"0x00f26a58474b119198759dbc34eaf18f6604a24a","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0x02892f8247233ded227bcc848c9c7bd2afc6d30f","governanceProposerAddress":"0x1ea19343d4e4b699c3db2888fec80e44fc1ee1c7","governanceAddress":"0x9afe43710c0f9514b560b75e4c031d81a8c69f5b","slashFactoryAddress":"0x83b8db667d80be6fd8661c8fb3100be84879c86a","feeAssetHandlerAddress":"0x1d6524cfa18aea14854c46260c2a8e44c983871e","stakingAssetHandlerAddress":"0xd2830aba6bd8ff7f534506ffca5c0dcb64f74dd9","gseAddress":"0xf170f28c21e712d93368994f7099c2ba96441ed3","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 16:34:15 [16:34:15.130] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:34:15 Setting up funded test accounts... 16:34:15 [16:34:15.623] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:34:15 [16:34:15.690] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:34:15 [16:34:15.782] WARN: pxe:service No artifact found for contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf when looking for its metadata 16:34:15 [16:34:15.783] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf as part of deployment for 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:34:16 [16:34:15.939] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:20 [16:34:19.235] INFO: pxe:service Proving completed in 3245.254267999999ms {"timings":{"total":3245.254267999999,"sync":8.401933000001009,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":151.71092099999987,"oracles":{"callPrivateFunction":{"times":[1413.4409050000013,304.17064199999913,155.1706780000004]}}},{"functionName":"private_kernel_init","time":132.36468699999932},{"functionName":"ContractClassRegisterer:register","time":1387.2166020000004,"oracles":{"loadCapsule":{"times":[5.712226000001465]},"notifyCreatedNullifier":{"times":[0.9227370000007795]},"debugLog":{"times":[0.5621639999990293]},"notifyCreatedContractClassLog":{"times":[6.9159899999995105]}}},{"functionName":"private_kernel_inner","time":145.0140250000004},{"functionName":"SchnorrAccount:constructor","time":285.34534899999926,"oracles":{"getContractInstance":{"times":[1.1581920000007813]},"debugLog":{"times":[0.30457899999964866,0.15956999999980326]},"fetchTaggedLogs":{"times":[71.2952920000007]},"loadCapsule":{"times":[0.6406700000006822,0.3604620000005525,0.3715729999985342,0.3449720000007801,0.4607289999985369,0.26915700000063225]},"bulkRetrieveLogs":{"times":[5.2284249999993335]},"validateEnqueuedNotesAndEvents":{"times":[3.2011189999993803]},"notifyCreatedNullifier":{"times":[0.4306560000004538,0.40742499999942083]},"notifyCreatedNote":{"times":[0.7451270000001387]},"getRandomField":{"times":[0.42731600000115577,0.30998899999940477,0.08227500000066357,0.22060399999827496,0.12519799999972747,0.07051400000091235,0.0596239999995305,0.045912999999927706,0.05458399999952235,0.09136599999874306,0.04970399999911024]},"getIndexedTaggingSecretAsSender":{"times":[30.277976999999737]},"incrementAppTaggingSecretIndexAsSender":{"times":[17.483969000000798]}}},{"functionName":"private_kernel_inner","time":138.39714300000014},{"functionName":"SchnorrAccount:entrypoint","time":142.66724900000008,"oracles":{"debugLog":{"times":[0.3531520000015007,0.12991799999872455,0.4160759999995207]},"fetchTaggedLogs":{"times":[25.726292999999714]},"loadCapsule":{"times":[0.2925489999997808,0.47775000000001455,0.3569819999993342,0.2907279999999446,0.19638300000042364,0.20896299999913026]},"bulkRetrieveLogs":{"times":[1.3428930000009132]},"validateEnqueuedNotesAndEvents":{"times":[1.5491170000004786]},"getNotes":{"times":[2.16517500000009]},"getAuthWitness":{"times":[0.35604199999943376]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9682100000009086]}}},{"functionName":"private_kernel_inner","time":136.88323800000035},{"functionName":"private_kernel_reset","time":207.79335700000047},{"functionName":"private_kernel_tail","time":78.19631200000003}],"unaccounted":431.2634519999974}} 16:34:20 [16:34:19.359] INFO: node Received tx 0x00732b986dbbcb466d3df841c049eaaef2d65bbc0705d6cfb49b3a7ddfadcf8b {"txHash":"0x00732b986dbbcb466d3df841c049eaaef2d65bbc0705d6cfb49b3a7ddfadcf8b"} 16:34:20 [16:34:19.359] INFO: pxe:service Sent transaction 0x00732b986dbbcb466d3df841c049eaaef2d65bbc0705d6cfb49b3a7ddfadcf8b 16:34:20 [16:34:19.449] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.048152459999999335s {"duration":0.048152459999999335,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 16:34:20 [16:34:19.500] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x244ebcb94d0d6733c0c01612a25bbf0a1ddb6055387e497837bb52e010855474","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750955958,"version":846300445},"txHashes":["0x00732b986dbbcb466d3df841c049eaaef2d65bbc0705d6cfb49b3a7ddfadcf8b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":113.85099300000002,"publicProcessDuration":48.99310299999888,"rollupCircuitsDuration":103.73689299999933,"txCount":1,"blockNumber":1,"blockTimestamp":1750955958,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:34:23 [16:34:22.342] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:23 [16:34:22.388] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750955994 16:34:23 [16:34:22.388] WARN: foundation:test-date-provider Time set to 2025-06-26T16:39:54.000Z {"offset":331612,"timeMs":1750955994000} 16:34:23 [16:34:22.388] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:34:23 [16:34:22.434] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 340282366920938463463374607431768211457 16:34:23 [16:34:22.457] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:34:23 [16:34:22.477] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x244ebcb94d0d6733c0c01612a25bbf0a1ddb6055387e497837bb52e010855474","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750955958,"version":846300445},"archiveRoot":"0x27f69159eecc2e47e42e65b9213b37fa2529bb7ea5f44192f476f62f16871d00","archiveNextLeafIndex":2} 16:34:23 [16:34:22.603] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 16:34:23 [16:34:22.729] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:23 [16:34:22.787] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.8698309999999765,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750955958,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:34:23 [16:34:23.042] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:34:24 [16:34:24.060] INFO: pxe:service Proving completed in 1312.3473369999992ms {"timings":{"total":1312.3473369999992,"sync":20.67976799999815,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.84241500000644,"oracles":{"callPrivateFunction":{"times":[251.5446030000021,178.15938999999707]}}},{"functionName":"private_kernel_init","time":59.70425999999861},{"functionName":"SchnorrAccount:constructor","time":237.84709999999905,"oracles":{"getContractInstance":{"times":[7.705719999998109]},"debugLog":{"times":[0.26968699999997625,0.1097169999993639]},"fetchTaggedLogs":{"times":[65.57907700000214]},"loadCapsule":{"times":[0.2332539999988512,0.2072729999999865,0.17042099999889615,0.18831200000204262,0.17465099999753875,0.1755909999992582]},"bulkRetrieveLogs":{"times":[1.2673390000018117]},"validateEnqueuedNotesAndEvents":{"times":[2.0954300000012154]},"notifyCreatedNullifier":{"times":[0.360672999999224,0.31290900000021793]},"notifyCreatedNote":{"times":[0.1630600000025879]},"getRandomField":{"times":[0.2511750000012398,0.2469760000021779,0.03892199999972945,0.0404530000014347,0.0534029999980703,0.030832000000373228,0.05038299999796436,0.030861999999615364,0.0504030000010971,0.035132000000885455,0.04675199999837787]},"getIndexedTaggingSecretAsSender":{"times":[34.206841000002896]},"incrementAppTaggingSecretIndexAsSender":{"times":[17.68304200000057]}}},{"functionName":"private_kernel_inner","time":129.22219100000075},{"functionName":"SchnorrAccount:entrypoint","time":166.9447209999962,"oracles":{"debugLog":{"times":[0.32472000000052503,0.2264839999988908,0.2567459999991115]},"fetchTaggedLogs":{"times":[60.919645000001765]},"loadCapsule":{"times":[0.36737300000095274,2.185547000000952,0.45609800000238465,0.40003500000239,0.3311810000013793,0.21675300000060815]},"bulkRetrieveLogs":{"times":[2.2465200000006007]},"validateEnqueuedNotesAndEvents":{"times":[3.9380549999987124]},"getNotes":{"times":[1.6454420000009122]},"getAuthWitness":{"times":[0.16360999999960768]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.49771999999939]}}},{"functionName":"private_kernel_inner","time":116.23457199999757},{"functionName":"private_kernel_reset","time":187.61215900000025},{"functionName":"private_kernel_tail","time":81.89382299999852}],"unaccounted":236.3663280000037}} 16:34:24 [16:34:24.102] INFO: node Received tx 0x0eb2ece5dd0c9d3d6460b5a6b4d70d1545747ea0f4c9ec25e6dc4d569af59a64 {"txHash":"0x0eb2ece5dd0c9d3d6460b5a6b4d70d1545747ea0f4c9ec25e6dc4d569af59a64"} 16:34:24 [16:34:24.102] INFO: pxe:service Sent transaction 0x0eb2ece5dd0c9d3d6460b5a6b4d70d1545747ea0f4c9ec25e6dc4d569af59a64 16:34:24 [16:34:24.226] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02589248399999997s {"duration":0.02589248399999997,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 16:34:24 [16:34:24.264] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x20a7d4c2e022909dce1351744595d2f49562c5ec12ceb5feeec849d4a2e24efb","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750955994,"version":846300445},"txHashes":["0x0eb2ece5dd0c9d3d6460b5a6b4d70d1545747ea0f4c9ec25e6dc4d569af59a64"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":73.54928300000029,"publicProcessDuration":26.04149200000029,"rollupCircuitsDuration":66.39473700000235,"txCount":1,"blockNumber":2,"blockTimestamp":1750955994,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:34:24 [16:34:24.494] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:24 [16:34:24.510] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:34:24 [16:34:24.510] WARN: foundation:test-date-provider Time set to 2025-06-26T16:40:06.000Z {"offset":341490,"timeMs":1750956006000} 16:34:24 [16:34:24.517] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 680564733841876926926749214863536422914 16:34:24 [16:34:24.519] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:34:24 [16:34:24.522] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956030 16:34:24 [16:34:24.522] WARN: foundation:test-date-provider Time set to 2025-06-26T16:40:30.000Z {"offset":365478,"timeMs":1750956030000} 16:34:24 [16:34:24.522] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:34:24 [16:34:24.655] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x20a7d4c2e022909dce1351744595d2f49562c5ec12ceb5feeec849d4a2e24efb","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750955994,"version":846300445},"archiveRoot":"0x2c796f470c9755599ae05e735b1ee9af0aa7f00ab8c4c423782c697d6fec6338","archiveNextLeafIndex":3} 16:34:24 [16:34:24.658] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:34:24 [16:34:24.746] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.510222999997495,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750955994,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:34:24 [16:34:24.753] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 16:34:24 [16:34:24.892] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:26 [16:34:26.463] INFO: pxe:service Proving completed in 1559.7434609999982ms {"timings":{"total":1559.7434609999982,"sync":10.226378000003024,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":65.98997200000304,"oracles":{"callPrivateFunction":{"times":[316.1463169999988,327.33341500000097]}}},{"functionName":"private_kernel_init","time":56.643018999999185},{"functionName":"SchnorrAccount:constructor","time":304.2609279999997,"oracles":{"getContractInstance":{"times":[1.370335999999952]},"debugLog":{"times":[0.1487989999986894,0.13272800000049756]},"fetchTaggedLogs":{"times":[112.29135600000154]},"loadCapsule":{"times":[3.5163489999977173,1.2052149999981339,0.8751740000006976,0.2882279999976163,0.19206299999859766,0.1737509999984468]},"bulkRetrieveLogs":{"times":[1.908049999998184]},"validateEnqueuedNotesAndEvents":{"times":[4.243235000001732]},"notifyCreatedNullifier":{"times":[0.29334799999924144,0.37120299999878625]},"notifyCreatedNote":{"times":[0.11184700000012526]},"getRandomField":{"times":[0.2663060000013502,0.316370000000461,0.06960400000025402,0.09246600000187755,0.0535329999984242,0.09051499999986845,0.04646299999876646,0.08453499999814085,0.08555500000147731,0.06544399999984307,0.04803300000276067]},"getIndexedTaggingSecretAsSender":{"times":[41.25922999999966]},"incrementAppTaggingSecretIndexAsSender":{"times":[14.586248999999953]}}},{"functionName":"private_kernel_inner","time":152.4167669999988},{"functionName":"SchnorrAccount:entrypoint","time":308.7791679999973,"oracles":{"debugLog":{"times":[0.30447900000217487,0.14906899999914458,0.32097000000067055]},"fetchTaggedLogs":{"times":[118.74799799999892]},"loadCapsule":{"times":[0.3710129999999481,0.26308699999935925,0.23527500000272994,2.927123000001302,0.23368499999924097,0.7686680000006163]},"bulkRetrieveLogs":{"times":[3.3851209999993443]},"validateEnqueuedNotesAndEvents":{"times":[2.9691149999998743]},"getNotes":{"times":[2.7654230000007374]},"getAuthWitness":{"times":[0.1998730000013893]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.008523000000423]}}},{"functionName":"private_kernel_inner","time":114.38968699999896},{"functionName":"private_kernel_reset","time":240.02127499999915},{"functionName":"private_kernel_tail","time":101.22056599999996}],"unaccounted":205.7957009999991}} 16:34:26 [16:34:26.523] INFO: node Received tx 0x1e169955e9e21148a2ffbf5bc0588e7d244500a7f88943c6d3ef641a8ad240c7 {"txHash":"0x1e169955e9e21148a2ffbf5bc0588e7d244500a7f88943c6d3ef641a8ad240c7"} 16:34:26 [16:34:26.523] INFO: pxe:service Sent transaction 0x1e169955e9e21148a2ffbf5bc0588e7d244500a7f88943c6d3ef641a8ad240c7 16:34:27 [16:34:27.082] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02692805799999769s {"duration":0.02692805799999769,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 16:34:27 [16:34:27.107] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1c3481d017343f7cb6cab74093048022e065d56855b6030d825f80256e9249c9","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750956030,"version":846300445},"txHashes":["0x1e169955e9e21148a2ffbf5bc0588e7d244500a7f88943c6d3ef641a8ad240c7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":66.63305200000104,"publicProcessDuration":27.081216999999015,"rollupCircuitsDuration":55.44943499999863,"txCount":1,"blockNumber":3,"blockTimestamp":1750956030,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:34:27 [16:34:27.303] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:34:27 [16:34:27.303] WARN: foundation:test-date-provider Time set to 2025-06-26T16:40:42.000Z {"offset":374697,"timeMs":1750956042000} 16:34:27 [16:34:27.309] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:27 [16:34:27.315] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1020847100762815390390123822295304634371 16:34:27 [16:34:27.317] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:34:27 [16:34:27.372] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956066 16:34:27 [16:34:27.372] WARN: foundation:test-date-provider Time set to 2025-06-26T16:41:06.000Z {"offset":398628,"timeMs":1750956066000} 16:34:27 [16:34:27.372] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:34:27 [16:34:27.619] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1c3481d017343f7cb6cab74093048022e065d56855b6030d825f80256e9249c9","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750956030,"version":846300445},"archiveRoot":"0x27826d60e2e9c06ccef919100a76126d40e2b9018b58653195e5a18f347fcecf","archiveNextLeafIndex":4} 16:34:27 [16:34:27.621] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:34:27 Initial Accounts: 16:34:27 16:34:27 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:34:27 Partial Address: 0x094a6663324a8544a40feeacc00ceca29902f1e171ea9015b006dd08d155b962 16:34:27 Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 16:34:27 Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 16:34:27 Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 16:34:27 16:34:27 Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 16:34:27 16:34:27 Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 16:34:27 16:34:27 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 16:34:27 Partial Address: 0x2b84d2628da65fd311052223c692573fdd885b8656536fa5aae92743f0422302 16:34:27 Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 16:34:27 Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 16:34:27 Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 16:34:27 16:34:27 Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 16:34:27 16:34:27 Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 16:34:27 16:34:27 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 16:34:27 Partial Address: 0x0c66cb7f2e50aaf65f67688f65683ba06d1262cab4c413c12f0148f9f5541891 16:34:27 Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 16:34:27 Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 16:34:27 Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 16:34:27 16:34:27 Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 16:34:27 16:34:27 Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 16:34:27 16:34:27 16:34:28 [16:34:28.520] WARN: pxe:service No artifact found for contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 when looking for its metadata 16:34:28 [16:34:28.520] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 16:34:28 [16:34:28.524] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 as part of deployment for 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 16:34:28 [16:34:28.565] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 as part of deployment for 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 16:34:28 [16:34:28.885] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":13.132617999999638,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750956030,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:34:29 [16:34:29.689] INFO: pxe:service Added contract Token at 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 16:34:29 [16:34:29.691] INFO: pxe:service Added contract FPC at 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 with class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 16:34:33 [16:34:32.487] INFO: pxe:service Proving completed in 2760.6069610000013ms {"timings":{"total":2760.6069610000013,"sync":16.371979999999894,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":313.1495709999981,"oracles":{"debugLog":{"times":[0.5764359999993758,0.11744700000053854,0.13410900000235415,0.200302000001102,0.16384000000107335,0.13938899999993737,0.07868500000040513,0.21288300000014715]},"fetchTaggedLogs":{"times":[118.89822800000184]},"loadCapsule":{"times":[0.263386000002356,0.15921999999773107,0.31731999999828986,1.0758769999993092,0.6445999999996275,0.22470300000350107,0.35097200000018347,0.932278000000224,0.29924899999969057,0.32969999999841093]},"getSharedSecret":{"times":[8.574934000000212]},"aes128Decrypt":{"times":[1.4586810000000696,0.8220909999981814]},"getPublicKeysAndPartialAddress":{"times":[2.10410100000081]},"getKeyValidationRequest":{"times":[3.9380549999987124]},"storeCapsule":{"times":[0.9210280000006605,0.4210959999982151,0.2567659999986063]},"deleteCapsule":{"times":[0.544954000000871]},"bulkRetrieveLogs":{"times":[1.1479419999996026]},"validateEnqueuedNotesAndEvents":{"times":[10.054035999997723]},"getNotes":{"times":[5.680004000001645]},"getAuthWitness":{"times":[0.19358199999987846]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06809400000202004]},"callPrivateFunction":{"times":[1073.7635609999998,154.97266599999784]},"notifyEnqueuedPublicFunctionCall":{"times":[0.5022809999973106]}}},{"functionName":"private_kernel_init","time":64.63739700000224},{"functionName":"ContractClassRegisterer:register","time":1053.405612000006,"oracles":{"loadCapsule":{"times":[5.574386999996932]},"notifyCreatedNullifier":{"times":[1.1845439999997325]},"debugLog":{"times":[0.32005999999819323]},"notifyCreatedContractClassLog":{"times":[6.5189660000032745]}}},{"functionName":"private_kernel_inner","time":132.18742500000008},{"functionName":"ContractInstanceDeployer:deploy","time":105.17856399999437,"oracles":{"storeInExecutionCache":{"times":[0.3925840000010794]},"callPrivateFunction":{"times":[53.12844000000041]},"notifyCreatedNullifier":{"times":[0.5403430000005756]},"debugLog":{"times":[0.23575400000117952]}}},{"functionName":"private_kernel_inner","time":143.11170599999969},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.944039000001794,"oracles":{}},{"functionName":"private_kernel_inner","time":134.65869899999961},{"functionName":"private_kernel_reset","time":219.8952210000025},{"functionName":"private_kernel_tail","time":97.87531799999852}],"unaccounted":440.1914289999986}} 16:34:33 [16:34:32.627] INFO: node Received tx 0x27cbfe52aec05b47af033db5ffa6f3ccc68afc4a74aef0218544304805ba1504 {"txHash":"0x27cbfe52aec05b47af033db5ffa6f3ccc68afc4a74aef0218544304805ba1504"} 16:34:33 [16:34:32.627] INFO: pxe:service Sent transaction 0x27cbfe52aec05b47af033db5ffa6f3ccc68afc4a74aef0218544304805ba1504 16:34:35 [16:34:34.933] INFO: pxe:service Proving completed in 2443.768121000001ms {"timings":{"total":2443.768121000001,"sync":120.34954800000196,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":241.46520400000372,"oracles":{"debugLog":{"times":[0.16618000000016764,0.14611900000090827,0.0788250000005064,0.15739899999971385,0.12696800000048825,0.12495800000033341,0.07583500000328058,0.23390500000095926]},"fetchTaggedLogs":{"times":[68.965787000001]},"loadCapsule":{"times":[0.22061400000166032,0.1444889999984298,0.3993350000018836,0.24215600000025006,0.13544800000090618,0.18422199999986333,0.12648800000170013,0.11731699999654666,0.1365280000027269,0.11438700000144308]},"getSharedSecret":{"times":[4.194910999998683]},"aes128Decrypt":{"times":[0.3018889999984822,0.5844470000010915]},"getPublicKeysAndPartialAddress":{"times":[1.6842539999997825]},"getKeyValidationRequest":{"times":[1.776270000002114]},"storeCapsule":{"times":[0.3904849999998987,0.29303799999979674,0.2646069999973406]},"deleteCapsule":{"times":[0.2415949999995064]},"bulkRetrieveLogs":{"times":[0.8758249999991676]},"validateEnqueuedNotesAndEvents":{"times":[11.884081000000151]},"getNotes":{"times":[2.543459000000439]},"getAuthWitness":{"times":[0.2879480000010517]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09150600000066333]},"callPrivateFunction":{"times":[939.6289240000006,139.971501]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09740600000077393]}}},{"functionName":"private_kernel_init","time":62.11402099999759},{"functionName":"ContractClassRegisterer:register","time":922.3905899999991,"oracles":{"loadCapsule":{"times":[2.691608000000997]},"notifyCreatedNullifier":{"times":[1.7791109999998298]},"debugLog":{"times":[0.276676999998017]},"notifyCreatedContractClassLog":{"times":[6.637292999999772]}}},{"functionName":"private_kernel_inner","time":117.8071600000003},{"functionName":"ContractInstanceDeployer:deploy","time":83.22572599999694,"oracles":{"storeInExecutionCache":{"times":[0.13903900000150315]},"callPrivateFunction":{"times":[57.452400000001944]},"notifyCreatedNullifier":{"times":[0.33372099999905913]},"debugLog":{"times":[0.14718899999934365]}}},{"functionName":"private_kernel_inner","time":109.2508170000001},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":45.62959300000148,"oracles":{}},{"functionName":"private_kernel_inner","time":102.74261100000149},{"functionName":"private_kernel_reset","time":163.88280099999974},{"functionName":"private_kernel_tail","time":80.39802999999665}],"unaccounted":394.51202000000194}} 16:34:35 [16:34:35.039] INFO: node Received tx 0x09c138de3dab865048050bc341a54f842cf95c950eb8eec631dc75bde962f9dc {"txHash":"0x09c138de3dab865048050bc341a54f842cf95c950eb8eec631dc75bde962f9dc"} 16:34:35 [16:34:35.039] INFO: pxe:service Sent transaction 0x09c138de3dab865048050bc341a54f842cf95c950eb8eec631dc75bde962f9dc 16:34:35 [16:34:35.253] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.2755807060000006s {"duration":1.2755807060000006,"rate":248084.6554918022,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 16:34:35 [16:34:35.298] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 229631.46877682486 mana/s {"blockHash":"0x2ad7730d830b5549da32ae18647d404f4867c6016d9f12462966edb742598a53","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750956066,"version":846300445},"txHashes":["0x27cbfe52aec05b47af033db5ffa6f3ccc68afc4a74aef0218544304805ba1504"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1377.9942169999995,"publicProcessDuration":1275.7248749999999,"rollupCircuitsDuration":1359.1700029999993,"txCount":1,"blockNumber":4,"blockTimestamp":1750956066,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 16:34:35 [16:34:35.533] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:35 [16:34:35.577] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:34:35 [16:34:35.577] WARN: foundation:test-date-provider Time set to 2025-06-26T16:41:18.000Z {"offset":402423,"timeMs":1750956078000} 16:34:35 [16:34:35.579] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1361129467683753853853498429727072845828 16:34:35 [16:34:35.580] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 16:34:35 [16:34:35.796] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x2ad7730d830b5549da32ae18647d404f4867c6016d9f12462966edb742598a53","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750956066,"version":846300445},"archiveRoot":"0x071fb0b5cc7ff5486d7a18d7270fd03b42d1b72e753a6021980f8cf162da99cc","archiveNextLeafIndex":5} 16:34:35 [16:34:35.801] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956102 16:34:35 [16:34:35.801] WARN: foundation:test-date-provider Time set to 2025-06-26T16:41:42.000Z {"offset":426199,"timeMs":1750956102000} 16:34:35 [16:34:35.801] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 16:34:35 [16:34:35.802] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 16:34:36 [16:34:36.004] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":12.166777999998885,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750956066,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 16:34:36 [16:34:36.223] INFO: aztecjs:deploy_sent_tx Contract 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 successfully deployed. 16:34:37 [16:34:36.952] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.18423086899999908s {"duration":0.18423086899999908,"rate":215984.43418296095,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 16:34:37 [16:34:37.004] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 161748.0953349797 mana/s {"blockHash":"0x2a4a59950f5e06586a33455fdcbfb8b21f70e468bd04e0418ef5da270ba4dad8","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750956102,"version":846300445},"txHashes":["0x09c138de3dab865048050bc341a54f842cf95c950eb8eec631dc75bde962f9dc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":245.90289100000155,"publicProcessDuration":184.625043,"rollupCircuitsDuration":239.9988630000007,"txCount":1,"blockNumber":5,"blockTimestamp":1750956102,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 16:34:37 [16:34:37.302] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:37 [16:34:37.355] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956138 16:34:37 [16:34:37.355] WARN: foundation:test-date-provider Time set to 2025-06-26T16:42:18.000Z {"offset":460645,"timeMs":1750956138000} 16:34:37 [16:34:37.355] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 16:34:37 [16:34:37.430] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2a4a59950f5e06586a33455fdcbfb8b21f70e468bd04e0418ef5da270ba4dad8","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750956102,"version":846300445},"archiveRoot":"0x29495cb9ef96be10e5856e3f00f543436ba8e3a0e82ca2b779ab58411f4faa17","archiveNextLeafIndex":6} 16:34:37 [16:34:37.496] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1701411834604692317316873037158841057285 16:34:37 [16:34:37.498] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 16:34:37 [16:34:37.594] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":9.020042000000103,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750956102,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 16:34:38 [16:34:37.967] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 16:34:38 BananaCoin: 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 16:34:38 FPC: 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 16:34:38 [16:34:38.325] INFO: aztecjs:deploy_sent_tx Contract 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 successfully deployed. 16:34:38 [16:34:38.371] WARN: pxe:service No artifact found for contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 when looking for its metadata 16:34:38 [16:34:38.373] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 as part of deployment for 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 16:34:38 [16:34:38.523] INFO: pxe:service Added contract SponsoredFPC at 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 with class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 16:34:41 [16:34:41.092] INFO: pxe:service Proving completed in 2554.8114190000015ms {"timings":{"total":2554.8114190000015,"sync":24.147274999999354,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":80.07836899999165,"oracles":{"callPrivateFunction":{"times":[1071.9483889999974,147.74038499999733,39.90474600000016]}}},{"functionName":"private_kernel_init","time":61.492051000001084},{"functionName":"ContractClassRegisterer:register","time":1053.7728060000045,"oracles":{"loadCapsule":{"times":[1.980052999999316]},"notifyCreatedNullifier":{"times":[0.5523139999932027]},"debugLog":{"times":[0.14996899999823654]},"notifyCreatedContractClassLog":{"times":[6.75836100000015]}}},{"functionName":"private_kernel_inner","time":109.77297899999394},{"functionName":"ContractInstanceDeployer:deploy","time":80.14807299999666,"oracles":{"storeInExecutionCache":{"times":[0.1579889999993611]},"callPrivateFunction":{"times":[75.56952900000033]},"notifyCreatedNullifier":{"times":[0.33993099999497645]},"debugLog":{"times":[0.11969700000190642]}}},{"functionName":"private_kernel_inner","time":127.54812700000184},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":59.69122900000366,"oracles":{}},{"functionName":"private_kernel_inner","time":116.40005199999723},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":28.635134000003745,"oracles":{"debugLog":{"times":[0.22841499999776715]}}},{"functionName":"private_kernel_inner","time":126.14878899999894},{"functionName":"private_kernel_reset","time":217.53509399999894},{"functionName":"private_kernel_tail","time":95.80867900000158}],"unaccounted":373.63276200000837}} 16:34:41 [16:34:41.222] INFO: node Received tx 0x2145684301e0e729f0d682f271e7ad7e67722bf05565c38788d6ef83b55851de {"txHash":"0x2145684301e0e729f0d682f271e7ad7e67722bf05565c38788d6ef83b55851de"} 16:34:41 [16:34:41.222] INFO: pxe:service Sent transaction 0x2145684301e0e729f0d682f271e7ad7e67722bf05565c38788d6ef83b55851de 16:34:41 [16:34:41.311] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05507703200000105s {"duration":0.05507703200000105,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 16:34:41 [16:34:41.339] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1f16530ebfdb6718594e27e8115bc8051eac921f9393aa0bdab83f68325396d9","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750956138,"version":846300445},"txHashes":["0x2145684301e0e729f0d682f271e7ad7e67722bf05565c38788d6ef83b55851de"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":100.49263100000098,"publicProcessDuration":55.268713999998,"rollupCircuitsDuration":94.51672900000267,"txCount":1,"blockNumber":6,"blockTimestamp":1750956138,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:34:41 [16:34:41.541] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2041694201525630780780247644590609268742 16:34:41 [16:34:41.549] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:34:41 [16:34:41.552] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 16:34:41 [16:34:41.633] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956174 16:34:41 [16:34:41.633] WARN: foundation:test-date-provider Time set to 2025-06-26T16:42:54.000Z {"offset":492367,"timeMs":1750956174000} 16:34:41 [16:34:41.633] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 16:34:41 [16:34:41.798] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x1f16530ebfdb6718594e27e8115bc8051eac921f9393aa0bdab83f68325396d9","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750956138,"version":846300445},"archiveRoot":"0x1ab4e3a946164a3c9674e19bda487e1dce79166dc3d21dda7b42b8af8fd10f6b","archiveNextLeafIndex":7} 16:34:41 [16:34:41.801] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 16:34:42 [16:34:42.139] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":6.360617999998794,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750956138,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:34:42 SponsoredFPC: 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 16:34:42 [16:34:42.237] INFO: aztecjs:deploy_sent_tx Contract 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 successfully deployed. 16:34:42 [16:34:42.243] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x207addb63e0f0ccc8126943bdd8ac2c785f3c6d9741d442d2ea6d82889a6246e","l2ProtocolContractsTreeRoot":"0x00d0980697e140a074810b2bee11c5042763b87e95bfdbf2f28269c79e6abad6"} 16:34:45 Registering protocol contract aliases... 16:34:45 Data stored in database with alias contracts:AuthRegistry 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000001 16:34:45 Data stored in database with alias contracts:ContractInstanceDeployer 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000002 16:34:45 Data stored in database with alias contracts:ContractClassRegisterer 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000003 16:34:45 Data stored in database with alias contracts:MultiCallEntrypoint 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000004 16:34:45 Data stored in database with alias contracts:FeeJuice 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000005 16:34:45 Data stored in database with alias contracts:Router 16:34:45 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000006 16:34:45 [16:34:45.476] INFO: wallet Using local PXE service 16:34:45 [16:34:45.477] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:34:45 [16:34:45.631] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:34:45 [16:34:45.635] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:34:46 [16:34:46.392] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:34:46 [16:34:46.791] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:46 [16:34:46.795] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:46 [16:34:46.812] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:46 [16:34:46.923] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:34:46 [16:34:46.929] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 16:34:46 [16:34:46.936] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 16:34:46 Account stored in database with aliases last & test0 16:34:46 16:34:46 Test account: 16:34:46 Alias: test0 16:34:46 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:34:46 Secret key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 16:34:46 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 16:34:46 Account stored in database with aliases last & test1 16:34:46 Account stored in database with aliases last & test2 16:34:46 16:34:46 Test account: 16:34:46 Alias: test1 16:34:46 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 16:34:46 Secret key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 16:34:47 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 16:34:47 16:34:47 Test account: 16:34:47 Alias: test2 16:34:47 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 16:34:47 Secret key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 16:34:47 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 16:34:47 16:34:47 3 test accounts imported to wallet db. 16:34:47 16:34:50 [16:34:50.456] INFO: wallet Using local PXE service 16:34:50 [16:34:50.458] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:34:50 [16:34:50.509] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:34:50 [16:34:50.512] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:34:51 [16:34:51.194] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:34:51 16:34:51 New account: 16:34:51 16:34:51 Address: 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad 16:34:51 Public key: 0x0940a0a48cea553b73a8a33f9f5ee2e2b788f50bddac6b6b9aa05667625e7abd06f4cdaa9cf231359cd66983124b09d246729d844a7062b1a426544dbfe3b98421cd7bdf1f4393709dd62d7ce2f4eca22c8c6bf77d6a56b2a637a02c758a568c285bfb44cabf7e04e43d4ac6f91b3acce817cac300e6776c90d709523d6134c61273264de121fe05a9c7feb2e4645c72beb058faa7a3d1cc38bcd0adf9b39332221c659f38392b344cbe890073ab01b913e63f20721b2dec7aa8e53409ca8fe006ba6f2c4c5373b33d34dc1119c1d80e5fe289c9c2bd31c9da55f6ed26509b412d14078026a5c2be95606ce36bb4717a9cae1089a9949929d06b43233ec1e3f9 16:34:51 Secret key: 0x1b7c903bb71e0c6954b75774547c1258aa7da9e07b9309b3297bb532af53b44c 16:34:51 Partial address: 0x222c8e715cccd3ad7adffe5c706d8ab156b6474109badfcb2f5fb12f2e2be0af 16:34:51 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 16:34:51 Init hash: 0x061ab944b935fb5af12633a34dc11b0640a83261de5613b02928f38d6c906fea 16:34:51 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 16:34:51 [16:34:51.377] INFO: pxe:service Added contract SchnorrAccount at 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:34:51 [16:34:51.433] INFO: pxe:service Registered account 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad 16:34:51 Account stored in database with aliases last & main 16:34:54 [16:34:54.241] INFO: wallet Using local PXE service 16:34:54 [16:34:54.243] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:34:54 [16:34:54.705] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:34:54 [16:34:54.709] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:34:55 Minted 1000000000000000000 fee juice on L1 and pushed to L2 portal 16:34:55 claimAmount=1000000000000000000,claimSecret=0x265c86db02e75c97c58bce25b3afb1314fbc5628fb1d51b952821f7e073a20b5,messageHash=0x0018c41a1dee03548fa625dbb0512c6eb2d900b1bb928001f903f1389904d70a,messageLeafIndex=112 16:34:55 16:34:55 Note: You need to wait for two L2 blocks before pulling them from the L2 side 16:34:55 Pushed 1000000000000000000 fee juice for recipient 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad. Stack pointer 1 16:34:55 [16:34:55.395] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:34:55 [16:34:55.591] INFO: wallet Minting 1000000000000000000 tokens for 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:34:55 [16:34:55.617] INFO: wallet Approving 1000000000000000000 tokens for FeeJuice Portal (0x00f26a58474b119198759dbc34eaf18f6604a24a) 16:34:55 [16:34:55.654] INFO: wallet Sending L1 Fee Juice to L2 to be claimed publicly 16:34:55 [16:34:55.676] INFO: wallet Deposited to Aztec public successfully 16:34:56 [16:34:55.767] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:34:56 [16:34:55.768] WARN: foundation:test-date-provider Time set to 2025-06-26T16:43:30.000Z {"offset":514232,"timeMs":1750956210000} 16:34:56 [16:34:55.889] INFO: archiver Retrieved 1 new L1 to L2 messages up to message with index 112 for L2 block 8 {"lastMessage":{"index":112,"l1BlockHash":"0xadcac8215e6aa6ecb8bdbeb799217a00ac0f11bd7c0d600fdb4713163a44df16","l1BlockNumber":41,"l2BlockNumber":8,"leaf":"0x0018c41a1dee03548fa625dbb0512c6eb2d900b1bb928001f903f1389904d70a","rollingHash":"0x225df60b501df366eeb5bd48425796f7"},"messageCount":1} 16:35:03 [16:35:03.337] INFO: wallet Using local PXE service 16:35:03 [16:35:03.339] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:35:03 [16:35:03.404] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:35:03 [16:35:03.406] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:35:04 [16:35:04.101] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:35:04 [16:35:04.163] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:35:04 [16:35:04.725] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 16:35:05 [16:35:05.193] INFO: pxe:service Added contract Token at 0x259e413505028d2d89a5ee1ef9805aef2f205d263fa72fae65c92e3f8c9ab642 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 16:35:08 [16:35:07.466] INFO: pxe:service Proving completed in 2260.966222ms {"timings":{"total":2260.966222,"sync":349.7462049999999,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":679.0829780000013,"oracles":{"debugLog":{"times":[0.7811190000002171,0.19425199999932374,0.1563400000004549,0.3005480000001626,0.11135699999977078,0.08721599999989849,0.2750980000000709,0.2788170000003447]},"fetchTaggedLogs":{"times":[333.86171599999943]},"loadCapsule":{"times":[0.5627450000001772,0.2965889999995852,0.7218849999999293,0.2019430000000284,0.29588799999964976,1.7853220000006331,2.4815860000007888,0.432067000000643,0.5098420000003898,0.2865280000005441]},"getSharedSecret":{"times":[6.902632999999696]},"aes128Decrypt":{"times":[1.092757999999776,0.9775410000002012]},"getPublicKeysAndPartialAddress":{"times":[2.280504000000292]},"getKeyValidationRequest":{"times":[3.2301930000003267]},"storeCapsule":{"times":[2.353178000000298,3.3193179999998392,9.281692999999905]},"deleteCapsule":{"times":[3.2552540000006047]},"bulkRetrieveLogs":{"times":[14.719514000000345]},"validateEnqueuedNotesAndEvents":{"times":[26.319282000000385]},"getNotes":{"times":[3.771386999999777]},"getAuthWitness":{"times":[0.23848499999985506]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.34326099999998405]},"callPrivateFunction":{"times":[141.63787500000035]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3080390000004627]}}},{"functionName":"private_kernel_init","time":118.12894899999992},{"functionName":"ContractInstanceDeployer:deploy","time":66.52041699999882,"oracles":{"storeInExecutionCache":{"times":[0.3375710000000254]},"callPrivateFunction":{"times":[78.24777399999948]},"notifyCreatedNullifier":{"times":[0.6199190000006638]},"debugLog":{"times":[0.5135420000005979]}}},{"functionName":"private_kernel_inner","time":189.34391099999993},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":61.044584000000214,"oracles":{}},{"functionName":"private_kernel_inner","time":119.2374979999995},{"functionName":"private_kernel_reset","time":222.0544749999999},{"functionName":"private_kernel_tail","time":104.80671200000052}],"unaccounted":351.000493}} 16:35:08 [16:35:07.552] INFO: pxe:service Sent transaction 0x2216f75fedc4a44bacdc6690382bf1264d719ce15f18055a6dd55f1584bc6343 16:35:08 [16:35:07.550] INFO: node Received tx 0x2216f75fedc4a44bacdc6690382bf1264d719ce15f18055a6dd55f1584bc6343 {"txHash":"0x2216f75fedc4a44bacdc6690382bf1264d719ce15f18055a6dd55f1584bc6343"} 16:35:08 [16:35:08.373] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.28081973599999766s {"duration":0.28081973599999766,"rate":1126886.6088528857,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 16:35:08 [16:35:08.398] INFO: sequencer Built block 7 for slot 9 with 1 txs and 0 messages. 1008136.8088785943 mana/s {"blockHash":"0x0163ae87fd6f9a374a66562801893b6f19fd339c82500321be31db7bf752133d","globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750956210,"version":846300445},"txHashes":["0x2216f75fedc4a44bacdc6690382bf1264d719ce15f18055a6dd55f1584bc6343"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":313.82368800000404,"publicProcessDuration":281.0348689999955,"rollupCircuitsDuration":308.83900500000163,"txCount":1,"blockNumber":7,"blockTimestamp":1750956210,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:08 [16:35:08.615] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:35:08 [16:35:08.672] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2381976568446569244243622252022377480199 16:35:08 [16:35:08.674] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 16:35:08 [16:35:08.685] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956246 16:35:08 [16:35:08.686] WARN: foundation:test-date-provider Time set to 2025-06-26T16:44:06.000Z {"offset":537314,"timeMs":1750956246000} 16:35:08 [16:35:08.686] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 16:35:08 [16:35:08.913] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x0163ae87fd6f9a374a66562801893b6f19fd339c82500321be31db7bf752133d","blockNumber":7,"txCount":1,"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750956210,"version":846300445},"archiveRoot":"0x1521970a424ab553ff384b797e147d6cd1201440eda08f82169551e5070db4f1","archiveNextLeafIndex":8} 16:35:08 [16:35:08.916] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 16:35:09 [16:35:09.137] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":7.586715999997978,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750956210,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:09 Contract deployed at 0x259e413505028d2d89a5ee1ef9805aef2f205d263fa72fae65c92e3f8c9ab642 16:35:09 Contract partial address 0x04a04bc3baa47ab79bbb539e8c3e84eb72eb7b76e14f53a5874a2e7ddc42e6e9 16:35:09 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 16:35:09 Deployment tx hash: 0x2216f75fedc4a44bacdc6690382bf1264d719ce15f18055a6dd55f1584bc6343 16:35:09 Deployment salt: 0x1953b5e5f4319b8c249cf2af4a1df4841a12da5cb299cedc219432682ad6a7c8 16:35:09 Deployment fee: 11093677920 16:35:09 Contract stored in database with alias last 16:35:13 [16:35:13.424] INFO: wallet Using local PXE service 16:35:13 [16:35:13.425] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:35:13 [16:35:13.493] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:35:13 [16:35:13.497] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:35:14 [16:35:14.210] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:35:14 [16:35:14.299] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:35:15 [16:35:15.598] INFO: pxe:service Added contract Token at 0x180a6fb1cc13c50299444fa5b8082f93a11d5d86fe39fd85577e57a41a38671b with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 16:35:17 [16:35:17.625] INFO: pxe:service Proving completed in 2014.021546ms {"timings":{"total":2014.021546,"sync":51.908738000000085,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":654.2870000000012,"oracles":{"debugLog":{"times":[1.054352000000108,0.24469700000008743,0.2252760000001217,0.39226700000017445,0.2620889999998326,0.10511700000006385,0.21498499999961496,0.38768700000036915]},"fetchTaggedLogs":{"times":[306.4477960000004]},"loadCapsule":{"times":[0.6155119999993985,0.34026300000004994,0.7530619999997725,0.7896339999997508,0.32641200000034587,0.38010600000052364,0.3286529999995764,0.2567479999997886,0.3684349999994083,0.49771400000008725]},"getSharedSecret":{"times":[6.8108970000002955]},"aes128Decrypt":{"times":[1.337891000000127,1.0626430000002074]},"getPublicKeysAndPartialAddress":{"times":[2.8461050000005343]},"getKeyValidationRequest":{"times":[3.972523000000365]},"storeCapsule":{"times":[2.265835000000152,3.761657000000014,2.5022210000006453]},"deleteCapsule":{"times":[2.93286100000023]},"bulkRetrieveLogs":{"times":[6.143150999999307]},"validateEnqueuedNotesAndEvents":{"times":[35.42480799999976]},"getNotes":{"times":[8.347881999999117]},"getAuthWitness":{"times":[0.42939900000055786]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5394070000002102]},"callPrivateFunction":{"times":[204.01303499999995]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2633879999993951]}}},{"functionName":"private_kernel_init","time":97.43535900000006},{"functionName":"ContractInstanceDeployer:deploy","time":117.36124399999972,"oracles":{"storeInExecutionCache":{"times":[0.3020109999997658]},"callPrivateFunction":{"times":[99.17262800000026]},"notifyCreatedNullifier":{"times":[0.5032940000000963]},"debugLog":{"times":[0.34584300000005896]}}},{"functionName":"private_kernel_inner","time":149.99080200000026},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":74.93283699999938,"oracles":{}},{"functionName":"private_kernel_inner","time":135.03254599999946},{"functionName":"private_kernel_reset","time":257.4030040000007},{"functionName":"private_kernel_tail","time":115.91699600000084}],"unaccounted":359.7530199999983}} 16:35:17 [16:35:17.717] INFO: pxe:service Sent transaction 0x228776b38a077dbafd24fda8d9724bb84bd2d6a024045b7e814f53e0d997c6a2 16:35:18 [16:35:17.715] INFO: node Received tx 0x228776b38a077dbafd24fda8d9724bb84bd2d6a024045b7e814f53e0d997c6a2 {"txHash":"0x228776b38a077dbafd24fda8d9724bb84bd2d6a024045b7e814f53e0d997c6a2"} 16:35:18 [16:35:18.176] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23507132299999647s {"duration":0.23507132299999647,"rate":1346195.6820654161,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 16:35:18 [16:35:18.208] INFO: sequencer Built block 8 for slot 10 with 1 txs and 1 messages. 1143858.2354330008 mana/s {"blockHash":"0x2de69292bd31106f5397d4eb437619bba4d17c6780c1ae7ddafde33796bf16ba","globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750956246,"version":846300445},"txHashes":["0x228776b38a077dbafd24fda8d9724bb84bd2d6a024045b7e814f53e0d997c6a2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":276.59692000001087,"publicProcessDuration":235.30515000000014,"rollupCircuitsDuration":271.6077079999959,"txCount":1,"blockNumber":8,"blockTimestamp":1750956246,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:18 [16:35:18.411] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:35:18 [16:35:18.455] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2722258935367507707706996859454145691656 16:35:18 [16:35:18.456] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 16:35:18 [16:35:18.599] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:35:18 [16:35:18.599] WARN: foundation:test-date-provider Time set to 2025-06-26T16:44:18.000Z {"offset":539401,"timeMs":1750956258000} 16:35:18 [16:35:18.609] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956282 16:35:18 [16:35:18.609] WARN: foundation:test-date-provider Time set to 2025-06-26T16:44:42.000Z {"offset":563391,"timeMs":1750956282000} 16:35:18 [16:35:18.609] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 16:35:18 [16:35:18.834] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x2de69292bd31106f5397d4eb437619bba4d17c6780c1ae7ddafde33796bf16ba","blockNumber":8,"txCount":1,"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32630,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750956246,"version":846300445},"archiveRoot":"0x17d5232cb4ecc03ea9f6d96f1f26739abd1bc588d469df6ab46763ba247f0ed3","archiveNextLeafIndex":9} 16:35:18 [16:35:18.836] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 16:35:19 [16:35:19.264] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":10.518481000006432,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750956246,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:19 Contract deployed at 0x180a6fb1cc13c50299444fa5b8082f93a11d5d86fe39fd85577e57a41a38671b 16:35:19 Contract partial address 0x11e1375b98bf2d3087ae8d53f838ae516e7a2829cd9e7f9daf24fa9c9d737f17 16:35:19 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 16:35:19 Deployment tx hash: 0x228776b38a077dbafd24fda8d9724bb84bd2d6a024045b7e814f53e0d997c6a2 16:35:19 Deployment salt: 0x2a6891c43879dac4e5a76e153bca528fefac68973ce68d88d8b00bd9d323d257 16:35:19 Deployment fee: 11093677920 16:35:19 Contract stored in database with alias last 16:35:24 [16:35:24.266] INFO: wallet Using local PXE service 16:35:24 [16:35:24.268] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:35:24 [16:35:24.325] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:35:24 [16:35:24.327] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:35:25 [16:35:25.002] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:35:25 [16:35:25.089] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 16:35:27 [16:35:26.406] INFO: pxe:service Added contract Token at 0x1e08c0cacd8023dce04aee5d0d6ba3fe48a21ac55778e023401fb0e8bffdbbc2 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 16:35:29 [16:35:28.448] INFO: pxe:service Proving completed in 2027.1655449999998ms {"timings":{"total":2027.1655449999998,"sync":81.6457519999999,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":633.6748800000005,"oracles":{"debugLog":{"times":[1.1458819999998013,0.20572300000003452,0.21293299999979354,0.3025889999998981,0.2167139999992287,0.17001100000015867,0.20922299999983807,0.3095899999998437]},"fetchTaggedLogs":{"times":[269.92891600000075]},"loadCapsule":{"times":[0.476039000000128,0.3009780000002138,0.5857770000002347,0.31441999999969994,0.29104800000004616,0.3811540000006062,1.3086020000000644,3.7409639999996216,0.7127450000007229,0.48885100000006787]},"getSharedSecret":{"times":[7.223541000000296]},"aes128Decrypt":{"times":[1.3770559999993566,0.8964459999997416]},"getPublicKeysAndPartialAddress":{"times":[2.4321719999998095]},"getKeyValidationRequest":{"times":[3.5834539999996196]},"storeCapsule":{"times":[2.7605320000002393,2.8133459999999104,2.490686000000096]},"deleteCapsule":{"times":[2.9151220000003377]},"bulkRetrieveLogs":{"times":[16.052472000000307]},"validateEnqueuedNotesAndEvents":{"times":[35.624542000000474]},"getNotes":{"times":[3.829359000000295]},"getAuthWitness":{"times":[0.41566599999987375]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.38591399999950227]},"callPrivateFunction":{"times":[142.77714500000002]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3324910000001182]}}},{"functionName":"private_kernel_init","time":133.2731020000001},{"functionName":"ContractInstanceDeployer:deploy","time":75.03140100000019,"oracles":{"storeInExecutionCache":{"times":[0.22289399999954185]},"callPrivateFunction":{"times":[73.20370599999933]},"notifyCreatedNullifier":{"times":[0.5855060000003505]},"debugLog":{"times":[0.405945000000429]}}},{"functionName":"private_kernel_inner","time":160.6312680000001},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":55.52711299999919,"oracles":{}},{"functionName":"private_kernel_inner","time":134.408993},{"functionName":"private_kernel_reset","time":231.1466959999998},{"functionName":"private_kernel_tail","time":100.86480099999972}],"unaccounted":420.96153900000036}} 16:35:29 [16:35:28.536] INFO: pxe:service Sent transaction 0x200b9fc4eb04268f2e6258d94b1e22e5136e3953a296031508c29f8313c43dfd 16:35:29 [16:35:28.534] INFO: node Received tx 0x200b9fc4eb04268f2e6258d94b1e22e5136e3953a296031508c29f8313c43dfd {"txHash":"0x200b9fc4eb04268f2e6258d94b1e22e5136e3953a296031508c29f8313c43dfd"} 16:35:29 [16:35:28.965] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.22219014800000877s {"duration":0.22219014800000877,"rate":1424239.5661934908,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 16:35:29 [16:35:28.993] INFO: sequencer Built block 9 for slot 11 with 1 txs and 0 messages. 1222024.896086929 mana/s {"blockHash":"0x08681253afd955e46ec2e95d8589ac111c2bcad6b7656a3c707d22c29d653657","globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750956282,"version":846300445},"txHashes":["0x200b9fc4eb04268f2e6258d94b1e22e5136e3953a296031508c29f8313c43dfd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":258.9053270000004,"publicProcessDuration":222.34824799999478,"rollupCircuitsDuration":252.8207090000069,"txCount":1,"blockNumber":9,"blockTimestamp":1750956282,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:29 [16:35:29.203] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:35:29 [16:35:29.232] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3062541302288446171170371466885913903113 16:35:29 [16:35:29.234] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 16:35:29 [16:35:29.263] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956318 16:35:29 [16:35:29.264] WARN: foundation:test-date-provider Time set to 2025-06-26T16:45:18.000Z {"offset":588736,"timeMs":1750956318000} 16:35:29 [16:35:29.264] INFO: aztecjs:utils:watcher Slot 11 was filled, jumped to next slot 16:35:30 [16:35:29.879] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x08681253afd955e46ec2e95d8589ac111c2bcad6b7656a3c707d22c29d653657","blockNumber":9,"txCount":1,"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750956282,"version":846300445},"archiveRoot":"0x2c3f3e4879011036fd583966d5359483fa69918c1f6eb5625b78d250ef6ce7e1","archiveNextLeafIndex":10} 16:35:30 [16:35:29.880] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 16:35:30 [16:35:29.943] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":6.146422999998322,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750956282,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:35:30 Contract deployed at 0x1e08c0cacd8023dce04aee5d0d6ba3fe48a21ac55778e023401fb0e8bffdbbc2 16:35:30 Contract partial address 0x1bf7ccc2a21b29678c4c280e26be6dac5aa7f0f940b2e5705cb1109a7e0aced3 16:35:30 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 16:35:30 Deployment tx hash: 0x200b9fc4eb04268f2e6258d94b1e22e5136e3953a296031508c29f8313c43dfd 16:35:30 Deployment salt: 0x2e797c6b33527bc24ef18b6361cdde6ade4df60a227fab5db1b7302e92f0327b 16:35:30 Deployment fee: 985953600 16:35:30 Contract stored in database with alias last 16:35:34 [16:35:34.105] INFO: wallet Using local PXE service 16:35:34 [16:35:34.107] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:35:34 [16:35:34.173] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:35:34 [16:35:34.176] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:35:34 [16:35:34.854] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:35:34 16:35:34 New account: 16:35:34 16:35:34 Address: 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad 16:35:34 Public key: 0x0940a0a48cea553b73a8a33f9f5ee2e2b788f50bddac6b6b9aa05667625e7abd06f4cdaa9cf231359cd66983124b09d246729d844a7062b1a426544dbfe3b98421cd7bdf1f4393709dd62d7ce2f4eca22c8c6bf77d6a56b2a637a02c758a568c285bfb44cabf7e04e43d4ac6f91b3acce817cac300e6776c90d709523d6134c61273264de121fe05a9c7feb2e4645c72beb058faa7a3d1cc38bcd0adf9b39332221c659f38392b344cbe890073ab01b913e63f20721b2dec7aa8e53409ca8fe006ba6f2c4c5373b33d34dc1119c1d80e5fe289c9c2bd31c9da55f6ed26509b412d14078026a5c2be95606ce36bb4717a9cae1089a9949929d06b43233ec1e3f9 16:35:34 Secret key: 0x1b7c903bb71e0c6954b75774547c1258aa7da9e07b9309b3297bb532af53b44c 16:35:34 Partial address: 0x222c8e715cccd3ad7adffe5c706d8ab156b6474109badfcb2f5fb12f2e2be0af 16:35:34 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 16:35:34 Init hash: 0x061ab944b935fb5af12633a34dc11b0640a83261de5613b02928f38d6c906fea 16:35:34 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 16:35:34 Retrieved 1000000000000000000 fee juice for recipient 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad. Stack pointer 0 16:35:34 Using Fee Juice for fee payments with claim for 1000000000000000000 tokens 16:35:35 [16:35:35.041] INFO: pxe:service Registered account 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad 16:35:35 [16:35:35.175] INFO: pxe:service Added contract SchnorrAccount at 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 16:35:40 [16:35:39.258] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2951.502265ms 16:35:40 [16:35:39.258] INFO: pxe:bb:native Generating Client IVC proof 16:35:40 [16:35:40.486] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-k88ze9/ivc-inputs.msgpack 16:35:40 [16:35:40.487] INFO: pxe:bb:native bb - BB concurrency: undefined 16:35:40 [16:35:40.487] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-k88ze9 --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-k88ze9/ivc-inputs.msgpack -v --scheme client_ivc 16:35:40 [16:35:40.509] INFO: pxe:bb:native bb - bb command: prove (mem: 178.14 MiB) 16:35:40 [16:35:40.509] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 178.14 MiB) 16:35:40 --scheme: client_ivc (mem: 178.14 MiB) 16:35:40 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-k88ze9 (mem: 178.14 MiB) 16:35:40 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-k88ze9/ivc-inputs.msgpack (mem: 178.14 MiB) 16:35:40 --verbose: true (mem: 178.14 MiB) 16:35:41 [16:35:41.472] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 178.14 MiB) 16:35:41 [16:35:41.473] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 178.14 MiB) 16:35:41 [16:35:41.517] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 178.14 MiB) 16:35:41 [16:35:41.528] INFO: pxe:bb:native bb - ClientIVC: accumulating MultiCallEntrypoint:entrypoint (mem: 178.14 MiB) 16:35:41 Constructing DeciderProvingKey (mem: 178.14 MiB) 16:35:41 [16:35:41.533] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 178.14 MiB) 16:35:41 goblin ecc op : 4/1024 (mem: 178.14 MiB) 16:35:41 busread : 742/6000 (mem: 178.14 MiB) 16:35:41 lookups : 2/15000 (mem: 178.14 MiB) 16:35:41 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 178.14 MiB) 16:35:41 arithmetic : 4296/56000 (mem: 178.14 MiB) 16:35:41 delta range : 2030/18000 (mem: 178.14 MiB) 16:35:41 elliptic : 2/6000 (mem: 178.14 MiB) 16:35:41 auxiliary : 2420/26000 (mem: 178.14 MiB) 16:35:41 poseidon ext : 82/17000 (mem: 178.14 MiB) 16:35:41 poseidon int : 458/92000 (mem: 16:35:41 [16:35:41.533] INFO: pxe:bb:native bb - 178.14 MiB) 16:35:41 overflow : 0/0 (mem: 178.14 MiB) 16:35:41 (mem: 178.14 MiB) 16:35:41 Total structured size: 242025 (mem: 178.14 MiB) 16:35:41 allocating polynomials object in proving key... (mem: 178.14 MiB) 16:35:41 [16:35:41.723] INFO: pxe:bb:native bb - populating trace... (mem: 436.66 MiB) 16:35:41 [16:35:41.736] INFO: pxe:bb:native bb - time to construct proving key: 207 ms. (mem: 444.66 MiB) 16:35:41 getting honk vk... precomputed?: 0x6221e8cfa240 (mem: 444.66 MiB) 16:35:41 computing oink proof... (mem: 444.66 MiB) 16:35:41 [16:35:41.737] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 444.66 MiB) 16:35:41 [16:35:41.891] INFO: pxe:bb:native bb - oink proof constructed (mem: 451.66 MiB) 16:35:42 [16:35:41.980] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 451.66 MiB) 16:35:42 [16:35:41.997] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 454.66 MiB) 16:35:42 Constructing DeciderProvingKey (mem: 454.66 MiB) 16:35:42 [16:35:42.003] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 455.66 MiB) 16:35:42 goblin ecc op : 56/1024 (mem: 455.66 MiB) 16:35:42 busread : 2529/6000 (mem: 455.66 MiB) 16:35:42 lookups : 2/15000 (mem: 455.66 MiB) 16:35:42 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 455.66 MiB) 16:35:42 arithmetic : 21095/56000 (mem: 455.66 MiB) 16:35:42 delta range : 3041/18000 (mem: 455.66 MiB) 16:35:42 elliptic : 340/6000 (mem: 455.66 MiB) 16:35:42 auxiliary : 799/26000 (mem: 455.66 MiB) 16:35:42 poseidon ext : 1972/17000 (mem: 455.66 MiB) 16:35:42 poseidon int : 11231/92000 (mem: 455.66 MiB) 16:35:42 overflow : 0/0 (mem: 455.66 MiB) 16:35:42 (mem: 455.66 MiB) 16:35:42 Total structured size: 242025 (mem: 455.66 MiB) 16:35:42 allocating polynomials object in proving key... (mem: 455.66 MiB) 16:35:42 [16:35:42.074] INFO: pxe:bb:native bb - populating trace... (mem: 667.66 MiB) 16:35:42 [16:35:42.104] INFO: pxe:bb:native bb - time to construct proving key: 106 ms. (mem: 686.66 MiB) 16:35:42 getting honk vk... precomputed?: 0x6221ea38ad00 (mem: 686.66 MiB) 16:35:42 computing folding proof (mem: 686.66 MiB) 16:35:42 [16:35:42.104] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000005ad8710660b0adcbcf35b84c1fb79f5b (mem: 686.66 MiB) 16:35:42 [16:35:42.318] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 711.66 MiB) 16:35:42 [16:35:42.394] INFO: pxe:bb:native bb - perturbator round (mem: 740.66 MiB) 16:35:42 [16:35:42.444] INFO: pxe:bb:native bb - combiner quotient round (mem: 772.66 MiB) 16:35:42 [16:35:42.519] INFO: pxe:bb:native bb - folded (mem: 772.66 MiB) 16:35:42 constructed folding proof (mem: 772.66 MiB) 16:35:42 [16:35:42.649] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:constructor (mem: 772.66 MiB) 16:35:42 Constructing DeciderProvingKey (mem: 772.66 MiB) 16:35:42 [16:35:42.654] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 772.66 MiB) 16:35:42 goblin ecc op : 4/1024 (mem: 772.66 MiB) 16:35:42 busread : 742/6000 (mem: 772.66 MiB) 16:35:42 lookups : 12218/15000 (mem: 772.66 MiB) 16:35:42 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 772.66 MiB) 16:35:42 [16:35:42.654] INFO: pxe:bb:native bb - arithmetic : 15035/56000 (mem: 772.66 MiB) 16:35:42 delta range : 2476/18000 (mem: 772.66 MiB) 16:35:42 elliptic : 1008/6000 (mem: 772.66 MiB) 16:35:42 auxiliary : 899/26000 (mem: 772.66 MiB) 16:35:42 poseidon ext : 132/17000 (mem: 772.66 MiB) 16:35:42 poseidon int : 743/92000 (mem: 772.66 MiB) 16:35:42 overflow : 0/0 (mem: 772.66 MiB) 16:35:42 (mem: 772.66 MiB) 16:35:42 Total structured size: 242025 (mem: 772.66 MiB) 16:35:42 allocating polynomials object in proving key... (mem: 772.66 MiB) 16:35:42 [16:35:42.688] INFO: pxe:bb:native bb - populating trace... (mem: 772.66 MiB) 16:35:42 [16:35:42.725] INFO: pxe:bb:native bb - time to construct proving key: 76 ms. (mem: 772.66 MiB) 16:35:42 getting honk vk... precomputed?: 0x6221e8c8d040 (mem: 772.66 MiB) 16:35:42 computing folding proof (mem: 772.66 MiB) 16:35:42 [16:35:42.726] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 772.66 MiB) 16:35:42 [16:35:42.904] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 772.66 MiB) 16:35:42 [16:35:42.970] INFO: pxe:bb:native bb - perturbator round (mem: 772.66 MiB) 16:35:43 [16:35:43.023] INFO: pxe:bb:native bb - combiner quotient round (mem: 783.45 MiB) 16:35:43 [16:35:43.130] INFO: pxe:bb:native bb - folded (mem: 783.45 MiB) 16:35:43 constructed folding proof (mem: 783.45 MiB) 16:35:43 [16:35:43.258] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000005ad8710660b0adcbcf35b84c1fb79f5b (mem: 783.45 MiB) 16:35:43 [16:35:43.315] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 783.45 MiB) 16:35:43 [16:35:43.359] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 783.45 MiB) 16:35:43 Constructing DeciderProvingKey (mem: 783.45 MiB) 16:35:43 [16:35:43.366] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 783.45 MiB) 16:35:43 goblin ecc op : 792/1024 (mem: 783.45 MiB) 16:35:43 busread : 4184/6000 (mem: 783.45 MiB) 16:35:43 lookups : 2/15000 (mem: 783.45 MiB) 16:35:43 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 783.45 MiB) 16:35:43 arithmetic : 43694/56000 (mem: 783.45 MiB) 16:35:43 delta range : 5034/18000 (mem: 783.45 MiB) 16:35:43 elliptic : 340/6000 (mem: 783.45 MiB) 16:35:43 [16:35:43.367] INFO: pxe:bb:native bb - auxiliary : 1399/26000 (mem: 783.45 MiB) 16:35:43 poseidon ext : 5582/17000 (mem: 783.45 MiB) 16:35:43 poseidon int : 31808/92000 (mem: 783.45 MiB) 16:35:43 overflow : 0/0 (mem: 783.45 MiB) 16:35:43 (mem: 783.45 MiB) 16:35:43 Total structured size: 242025 (mem: 783.45 MiB) 16:35:43 allocating polynomials object in proving key... (mem: 783.45 MiB) 16:35:43 [16:35:43.395] INFO: pxe:bb:native bb - populating trace... (mem: 783.45 MiB) 16:35:43 [16:35:43.430] INFO: pxe:bb:native bb - time to construct proving key: 70 ms. (mem: 783.45 MiB) 16:35:43 getting honk vk... precomputed?: 0x6221e90e3ec0 (mem: 783.45 MiB) 16:35:43 computing folding proof (mem: 783.45 MiB) 16:35:43 [16:35:43.430] INFO: pxe:bb:native bb - 16:35:43 [16:35:43.430] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 783.45 MiB) 16:35:43 [16:35:43.652] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 783.45 MiB) 16:35:43 [16:35:43.723] INFO: pxe:bb:native bb - perturbator round (mem: 783.45 MiB) 16:35:43 [16:35:43.783] INFO: pxe:bb:native bb - combiner quotient round (mem: 810.47 MiB) 16:35:43 [16:35:43.901] INFO: pxe:bb:native bb - folded (mem: 810.47 MiB) 16:35:43 constructed folding proof (mem: 810.47 MiB) 16:35:44 [16:35:44.008] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 810.47 MiB) 16:35:44 Constructing DeciderProvingKey (mem: 810.47 MiB) 16:35:44 [16:35:44.014] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 810.47 MiB) 16:35:44 goblin ecc op : 4/1024 (mem: 810.47 MiB) 16:35:44 busread : 742/6000 (mem: 810.47 MiB) 16:35:44 lookups : 2076/15000 (mem: 810.47 MiB) 16:35:44 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 810.47 MiB) 16:35:44 arithmetic : 9353/56000 (mem: 810.47 MiB) 16:35:44 delta range : 2977/18000 (mem: 810.47 MiB) 16:35:44 elliptic : 794/6000 (mem: 810.47 MiB) 16:35:44 auxiliary : 4528/26000 (mem: 810.47 MiB) 16:35:44 poseidon ext : 312/17000 (mem: 810.47 MiB) 16:35:44 [16:35:44.014] INFO: pxe:bb:native bb - poseidon int : 1769/92000 (mem: 810.47 MiB) 16:35:44 overflow : 0/0 (mem: 810.47 MiB) 16:35:44 (mem: 810.47 MiB) 16:35:44 Total structured size: 242025 (mem: 810.47 MiB) 16:35:44 allocating polynomials object in proving key... (mem: 810.47 MiB) 16:35:44 [16:35:44.063] INFO: pxe:bb:native bb - populating trace... (mem: 810.47 MiB) 16:35:44 [16:35:44.106] INFO: pxe:bb:native bb - time to construct proving key: 98 ms. (mem: 810.47 MiB) 16:35:44 getting honk vk... precomputed?: 0x6221ea5c6640 (mem: 810.47 MiB) 16:35:44 computing folding proof (mem: 16:35:44 [16:35:44.107] INFO: pxe:bb:native bb - 810.47 MiB) 16:35:44 [16:35:44.107] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 810.47 MiB) 16:35:44 [16:35:44.293] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 810.47 MiB) 16:35:44 [16:35:44.355] INFO: pxe:bb:native bb - perturbator round (mem: 810.47 MiB) 16:35:44 [16:35:44.413] INFO: pxe:bb:native bb - combiner quotient round (mem: 811.20 MiB) 16:35:44 [16:35:44.493] INFO: pxe:bb:native bb - folded (mem: 811.20 MiB) 16:35:44 constructed folding proof (mem: 811.20 MiB) 16:35:44 [16:35:44.605] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 811.20 MiB) 16:35:44 [16:35:44.653] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 811.20 MiB) 16:35:44 [16:35:44.696] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 811.20 MiB) 16:35:44 Constructing DeciderProvingKey (mem: 811.20 MiB) 16:35:44 [16:35:44.704] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 811.20 MiB) 16:35:44 goblin ecc op : 792/1024 (mem: 811.20 MiB) 16:35:44 busread : 4184/6000 (mem: 811.20 MiB) 16:35:44 lookups : 2/15000 (mem: 811.20 MiB) 16:35:44 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 811.20 MiB) 16:35:44 arithmetic : 43694/56000 (mem: 811.20 MiB) 16:35:44 delta range : 5034/18000 (mem: 811.20 MiB) 16:35:44 elliptic : 340/6000 (mem: 811.20 MiB) 16:35:44 auxiliary : 1399/26000 (mem: 811.20 MiB) 16:35:44 poseidon ext : 5582/17000 (mem: 811.20 MiB) 16:35:44 poseidon int : 31808/92000 (mem: 811.20 MiB) 16:35:44 overflow : 0/0 (mem: 811.20 MiB) 16:35:44 (mem: 811.20 MiB) 16:35:44 Total structured size: 242025 (mem: 811.20 MiB) 16:35:44 allocating polynomials object in proving key... (mem: 811.20 MiB) 16:35:44 [16:35:44.739] INFO: pxe:bb:native bb - populating trace... (mem: 811.20 MiB) 16:35:44 [16:35:44.777] INFO: pxe:bb:native bb - time to construct proving key: 80 ms. (mem: 811.20 MiB) 16:35:44 getting honk vk... precomputed?: 0x6221e8c2b800 (mem: 811.20 MiB) 16:35:44 computing folding proof (mem: 811.20 MiB) 16:35:44 [16:35:44.778] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 811.20 MiB) 16:35:45 [16:35:45.049] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 811.20 MiB) 16:35:45 [16:35:45.109] INFO: pxe:bb:native bb - perturbator round (mem: 811.20 MiB) 16:35:45 [16:35:45.188] INFO: pxe:bb:native bb - combiner quotient round (mem: 813.34 MiB) 16:35:45 [16:35:45.319] INFO: pxe:bb:native bb - folded (mem: 813.34 MiB) 16:35:45 constructed folding proof (mem: 813.34 MiB) 16:35:45 [16:35:45.506] INFO: pxe:bb:native bb - ClientIVC: accumulating FeeJuice:claim (mem: 813.34 MiB) 16:35:45 Constructing DeciderProvingKey (mem: 813.34 MiB) 16:35:45 [16:35:45.509] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 813.34 MiB) 16:35:45 goblin ecc op : 4/1024 (mem: 813.34 MiB) 16:35:45 busread : 742/6000 (mem: 813.34 MiB) 16:35:45 lookups : 17378/15000 (mem: 813.34 MiB) 16:35:45 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 813.34 MiB) 16:35:45 [16:35:45.509] INFO: pxe:bb:native bb - arithmetic : 13735/56000 (mem: 813.34 MiB) 16:35:45 delta range : 2547/18000 (mem: 813.34 MiB) 16:35:45 elliptic : 2/6000 (mem: 813.34 MiB) 16:35:45 auxiliary : 26/26000 (mem: 813.34 MiB) 16:35:45 poseidon ext : 452/17000 (mem: 813.34 MiB) 16:35:45 poseidon int : 2567/92000 (mem: 813.34 MiB) 16:35:45 overflow : 0/0 (mem: 813.34 MiB) 16:35:45 (mem: 813.34 MiB) 16:35:45 Total structured size: 242025 (mem: 813.34 MiB) 16:35:45 [16:35:45.509] INFO: pxe:bb:native bb - WARNING: Structured trace overflow mechanism in use. Performance may be degraded! (mem: 813.34 MiB) 16:35:45 Gate blocks summary: (actual gates / fixed capacity) (mem: 813.34 MiB) 16:35:45 goblin ecc op : 4/1024 (mem: 813.34 MiB) 16:35:45 busread : 742/6000 (mem: 813.34 MiB) 16:35:45 lookups : 15000/15000 (mem: 813.34 MiB) 16:35:45 [16:35:45.509] INFO: pxe:bb:native bb - pub inputs : 16/5000 (populated in decider pk constructor) (mem: 813.34 MiB) 16:35:45 arithmetic : 13735/56000 (mem: 813.34 MiB) 16:35:45 delta range : 2547/18000 (mem: 813.34 MiB) 16:35:45 elliptic : 2/6000 (mem: 813.34 MiB) 16:35:45 auxiliary : 26/26000 (mem: 813.34 MiB) 16:35:45 poseidon ext : 452/17000 (mem: 813.34 MiB) 16:35:45 poseidon int : 2567/92000 (mem: 813.34 MiB) 16:35:45 overflow : 2379/2379 (mem: 813.34 MiB) 16:35:45 (mem: 813.34 MiB) 16:35:45 Total structured size: 244404 (mem: 813.34 MiB) 16:35:45 allocating polynomials object in proving key... (mem: 813.34 MiB) 16:35:45 [16:35:45.588] INFO: pxe:bb:native bb - populating trace... (mem: 927.58 MiB) 16:35:45 [16:35:45.633] INFO: pxe:bb:native bb - time to construct proving key: 126 ms. (mem: 927.58 MiB) 16:35:45 getting honk vk... precomputed?: 0x6221e93f8e00 (mem: 927.58 MiB) 16:35:45 computing folding proof (mem: 927.58 MiB) 16:35:45 [16:35:45.633] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 927.58 MiB) 16:35:45 [16:35:45.896] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 946.58 MiB) 16:35:45 [16:35:45.968] INFO: pxe:bb:native bb - perturbator round (mem: 961.58 MiB) 16:35:46 [16:35:46.045] INFO: pxe:bb:native bb - combiner quotient round (mem: 993.58 MiB) 16:35:46 [16:35:46.185] INFO: pxe:bb:native bb - folded (mem: 993.58 MiB) 16:35:46 constructed folding proof (mem: 993.58 MiB) 16:35:46 [16:35:46.336] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 993.58 MiB) 16:35:46 [16:35:46.397] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 993.58 MiB) 16:35:46 [16:35:46.465] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 993.58 MiB) 16:35:46 Constructing DeciderProvingKey (mem: 993.58 MiB) 16:35:46 [16:35:46.471] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 993.58 MiB) 16:35:46 goblin ecc op : 792/1024 (mem: 993.58 MiB) 16:35:46 busread : 4184/6000 (mem: 993.58 MiB) 16:35:46 lookups : 2/15000 (mem: 993.58 MiB) 16:35:46 [16:35:46.472] INFO: pxe:bb:native bb - pub inputs : 32/5000 (populated in decider pk constructor) (mem: 993.58 MiB) 16:35:46 arithmetic : 43694/56000 (mem: 993.58 MiB) 16:35:46 delta range : 5034/18000 (mem: 993.58 MiB) 16:35:46 elliptic : 340/6000 (mem: 993.58 MiB) 16:35:46 auxiliary : 1399/26000 (mem: 993.58 MiB) 16:35:46 poseidon ext : 5582/17000 (mem: 993.58 MiB) 16:35:46 poseidon int : 31808/92000 (mem: 993.58 MiB) 16:35:46 overflow : 0/0 (mem: 993.58 MiB) 16:35:46 (mem: 993.58 MiB) 16:35:46 Total structured size: 242025 (mem: 993.58 MiB) 16:35:46 allocating polynomials object in proving key... (mem: 993.58 MiB) 16:35:46 [16:35:46.511] INFO: pxe:bb:native bb - populating trace... (mem: 993.58 MiB) 16:35:46 [16:35:46.579] INFO: pxe:bb:native bb - time to construct proving key: 116 ms. (mem: 993.58 MiB) 16:35:46 [16:35:46.580] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x6221eaa05740 (mem: 993.58 MiB) 16:35:46 computing folding proof (mem: 993.58 MiB) 16:35:46 [16:35:46.580] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 993.58 MiB) 16:35:47 [16:35:46.916] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 993.58 MiB) 16:35:47 [16:35:46.998] INFO: pxe:bb:native bb - perturbator round (mem: 993.58 MiB) 16:35:47 [16:35:47.084] INFO: pxe:bb:native bb - combiner quotient round (mem: 1013.33 MiB) 16:35:47 [16:35:47.179] INFO: pxe:bb:native bb - folded (mem: 1013.33 MiB) 16:35:47 constructed folding proof (mem: 1013.33 MiB) 16:35:47 [16:35:47.335] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 1013.33 MiB) 16:35:47 [16:35:47.412] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 1013.33 MiB) 16:35:47 Constructing DeciderProvingKey (mem: 1013.33 MiB) 16:35:47 [16:35:47.439] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1013.33 MiB) 16:35:47 goblin ecc op : 392/1024 (mem: 1013.33 MiB) 16:35:47 busread : 2347/6000 (mem: 1013.33 MiB) 16:35:47 lookups : 2/15000 (mem: 1013.33 MiB) 16:35:47 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 1013.33 MiB) 16:35:47 arithmetic : 36146/56000 (mem: 1013.33 MiB) 16:35:47 delta range : 4306/18000 (mem: 1013.33 MiB) 16:35:47 elliptic : 1274/6000 (mem: 1013.33 MiB) 16:35:47 [16:35:47.440] INFO: pxe:bb:native bb - auxiliary : 12562/26000 (mem: 1013.33 MiB) 16:35:47 poseidon ext : 6062/17000 (mem: 1013.33 MiB) 16:35:47 poseidon int : 34544/92000 (mem: 1013.33 MiB) 16:35:47 overflow : 0/0 (mem: 1013.33 MiB) 16:35:47 (mem: 1013.33 MiB) 16:35:47 Total structured size: 242025 (mem: 1013.33 MiB) 16:35:47 allocating polynomials object in proving key... (mem: 1013.33 MiB) 16:35:47 [16:35:47.535] INFO: pxe:bb:native bb - populating trace... (mem: 1013.33 MiB) 16:35:47 [16:35:47.602] INFO: pxe:bb:native bb - time to construct proving key: 191 ms. (mem: 1013.33 MiB) 16:35:47 getting honk vk... precomputed?: 0x6221e8d6e780 (mem: 1013.33 MiB) 16:35:47 computing folding proof (mem: 1013.33 MiB) 16:35:47 [16:35:47.602] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000e7838a46e34d859186131f18f34c3499 (mem: 1013.33 MiB) 16:35:48 [16:35:47.912] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1013.33 MiB) 16:35:48 [16:35:48.006] INFO: pxe:bb:native bb - perturbator round (mem: 1013.33 MiB) 16:35:48 [16:35:48.105] INFO: pxe:bb:native bb - combiner quotient round (mem: 1044.53 MiB) 16:35:48 [16:35:48.284] INFO: pxe:bb:native bb - folded (mem: 1044.53 MiB) 16:35:48 constructed folding proof (mem: 1044.53 MiB) 16:35:48 [16:35:48.489] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000e7838a46e34d859186131f18f34c3499 (mem: 1044.53 MiB) 16:35:48 [16:35:48.549] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 1044.53 MiB) 16:35:48 Constructing DeciderProvingKey (mem: 1044.53 MiB) 16:35:48 [16:35:48.583] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1044.53 MiB) 16:35:48 goblin ecc op : 392/1024 (mem: 1044.53 MiB) 16:35:48 busread : 231/6000 (mem: 1044.53 MiB) 16:35:48 [16:35:48.584] INFO: pxe:bb:native bb - lookups : 2/15000 (mem: 1044.53 MiB) 16:35:48 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 1044.53 MiB) 16:35:48 arithmetic : 32267/56000 (mem: 1044.53 MiB) 16:35:48 delta range : 4412/18000 (mem: 1044.53 MiB) 16:35:48 elliptic : 2/6000 (mem: 1044.53 MiB) 16:35:48 auxiliary : 11868/26000 (mem: 1044.53 MiB) 16:35:48 poseidon ext : 2502/17000 (mem: 1044.53 MiB) 16:35:48 poseidon int : 14252/92000 (mem: 1044.53 MiB) 16:35:48 overflow : 0/0 (mem: 1044.53 MiB) 16:35:48 (mem: 1044.53 MiB) 16:35:48 Total structured size: 242025 (mem: 1044.53 MiB) 16:35:48 allocating polynomials object in proving key... (mem: 1044.53 MiB) 16:35:48 [16:35:48.620] INFO: pxe:bb:native bb - populating trace... (mem: 1044.53 MiB) 16:35:48 [16:35:48.673] INFO: pxe:bb:native bb - time to construct proving key: 123 ms. (mem: 1044.53 MiB) 16:35:48 getting honk vk... precomputed?: 0x6221ec618540 (mem: 1044.53 MiB) 16:35:48 computing folding proof (mem: 1044.53 16:35:48 [16:35:48.674] INFO: pxe:bb:native bb - MiB) 16:35:48 vkey hash in Oink prover: 0x0000000000000000000000000000000090fa82f152876a666266b077a296059c (mem: 1044.53 MiB) 16:35:48 [16:35:48.954] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1044.53 MiB) 16:35:49 [16:35:49.095] INFO: pxe:bb:native bb - perturbator round (mem: 1044.53 MiB) 16:35:49 [16:35:49.151] INFO: pxe:bb:native bb - combiner quotient round (mem: 1044.53 MiB) 16:35:49 [16:35:49.333] INFO: pxe:bb:native bb - folded (mem: 1044.53 MiB) 16:35:49 constructed folding proof (mem: 1044.53 MiB) 16:35:49 [16:35:49.424] INFO: pxe:bb:native bb - Largest circuit: 97243 gates. Trace details: (mem: 1044.53 MiB) 16:35:49 Minimum required block sizes for structured trace: (mem: 1044.53 MiB) 16:35:49 [16:35:49.424] INFO: pxe:bb:native bb - (mem: 1044.53 MiB) 16:35:49 prove decider... (mem: 1044.53 MiB) 16:35:49 [16:35:49.424] INFO: pxe:bb:native bb - ecc_op : 792 16:35:49 busread : 4184 16:35:49 lookup : 15000 16:35:49 pub_inputs : 1859 16:35:49 arithmetic : 43694 16:35:49 delta_range : 5034 16:35:49 elliptic : 1274 16:35:49 aux : 12562 16:35:49 poseidon2_external : 6062 16:35:49 poseidon2_internal : 34544 16:35:49 overflow : 2379 16:35:49 [16:35:49.525] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1044.53 MiB) 16:35:49 [16:35:49.623] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1044.53 MiB) 16:35:50 [16:35:50.178] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1044.53 MiB) 16:35:50 [16:35:50.270] INFO: pxe:bb:native bb - computed opening proof (mem: 1044.53 MiB) 16:35:50 finished decider proving. (mem: 1044.53 MiB) 16:35:50 [16:35:50.281] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000090fa82f152876a666266b077a296059c (mem: 1044.53 MiB) 16:35:50 [16:35:50.428] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 1044.53 MiB) 16:35:50 [16:35:50.432] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 1044.53 MiB) 16:35:50 [16:35:50.501] INFO: pxe:bb:native bb - populating trace... (mem: 1044.53 MiB) 16:35:50 [16:35:50.547] INFO: pxe:bb:native bb - time to construct proving key: 119 ms. (mem: 1044.53 MiB) 16:35:51 [16:35:51.097] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000424382df4103106ae7134d792abf50bb (mem: 1044.53 MiB) 16:35:51 [16:35:51.474] INFO: pxe:bb:native bb - created oink proof (mem: 1044.53 MiB) 16:35:51 [16:35:51.597] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1044.53 MiB) 16:35:52 [16:35:52.116] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 1044.53 MiB) 16:35:52 [16:35:52.640] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1044.53 MiB) 16:35:52 [16:35:52.705] INFO: pxe:bb:native bb - computed opening proof (mem: 1044.53 MiB) 16:35:52 finished decider proving. (mem: 1044.53 MiB) 16:35:52 [16:35:52.705] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3818 (mem: 1044.53 MiB) 16:35:52 [16:35:52.791] INFO: pxe:bb:native bb - prove eccvm... (mem: 1044.53 MiB) 16:35:53 [16:35:53.271] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 1044.53 MiB) 16:35:53 [16:35:53.280] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 1044.53 MiB) 16:35:54 [16:35:54.285] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1044.53 MiB) 16:35:55 [16:35:55.128] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 1044.53 MiB) 16:35:57 [16:35:57.106] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 1044.53 MiB) 16:35:57 prove translator... (mem: 1044.53 MiB) 16:35:58 [16:35:58.116] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1056.95 MiB) 16:35:59 [16:35:59.113] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1056.95 MiB) 16:36:00 [16:36:00.302] INFO: pxe:bb:native bb - computed opening proof (mem: 1056.95 MiB) 16:36:00 [16:36:00.306] INFO: pxe:bb:native bb - finished translator proving. (mem: 1056.95 MiB) 16:36:00 [16:36:00.306] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x00000000000000000000000000000000424382df4103106ae7134d792abf50bb (mem: 1056.95 MiB) 16:36:00 [16:36:00.329] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 1056.95 MiB) 16:36:00 libra_evals_verified: 1 (mem: 1056.95 MiB) 16:36:00 pairing_check_verified: 1 (mem: 1056.95 MiB) 16:36:00 Mega verified: 1 (mem: 1056.95 MiB) 16:36:00 [16:36:00.407] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 1056.95 MiB) 16:36:00 batch opening verified?: 1 (mem: 1056.95 MiB) 16:36:00 eccvm consistency check verified?: 1 (mem: 1056.95 MiB) 16:36:00 translation masking consistency checked?: 1 (mem: 1056.95 MiB) 16:36:00 [16:36:00.424] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 1057.95 MiB) 16:36:00 eccvm verified?: 1 (mem: 1057.95 MiB) 16:36:00 accumulator construction_verified?: 1 (mem: 1057.95 MiB) 16:36:00 translation verified?: 1 (mem: 1057.95 MiB) 16:36:00 consistency verified?: 1 (mem: 1057.95 MiB) 16:36:00 [16:36:00.424] INFO: pxe:bb:native bb - Goblin verified: 1 (mem: 1057.95 MiB) 16:36:00 writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-k88ze9" (mem: 1057.95 MiB) 16:36:00 [16:36:00.655] INFO: pxe:bb:native Generated IVC proof {"duration":20166.285955,"eventName":"circuit-proving"} 16:36:00 [16:36:00.660] INFO: pxe:service Proving completed in 25420.276312ms {"timings":{"total":25420.276312,"sync":64.50014499999997,"proving":21401.825319000003,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":136.98545400000012,"oracles":{"callPrivateFunction":{"times":[430.0756859999997,454.16282699999965]}}},{"functionName":"private_kernel_init","time":224.0759079999998},{"functionName":"SchnorrAccount:constructor","time":413.9227350000001,"oracles":{"getContractInstance":{"times":[0.9688700000001518]},"debugLog":{"times":[0.7446960000002036,0.1320780000000923]},"fetchTaggedLogs":{"times":[204.17387499999995]},"loadCapsule":{"times":[0.5018810000001395,0.2399849999997059,0.24118600000019796,4.292395999999826,0.43226700000013807,0.32986099999970975]},"bulkRetrieveLogs":{"times":[6.46235999999999]},"validateEnqueuedNotesAndEvents":{"times":[15.681330999999773]},"notifyCreatedNullifier":{"times":[0.7174439999998867,0.3093690000000606]},"notifyCreatedNote":{"times":[0.3586019999997916]},"getRandomField":{"times":[0.32902100000001155,0.27363699999978053,0.06168400000024121,0.051723999999921944,0.161160000000109,0.05733299999974406,0.040943000000424945,0.04336300000022675,0.045662999999876774,0.06614399999989473,0.035702000000128464]},"getIndexedTaggingSecretAsSender":{"times":[24.657756999999947]},"incrementAppTaggingSecretIndexAsSender":{"times":[12.348634999999831]}}},{"functionName":"private_kernel_inner","time":488.8261940000002},{"functionName":"SchnorrAccount:entrypoint","time":295.5306249999999,"oracles":{"debugLog":{"times":[0.3260099999997692,0.11895800000002055,0.22263299999985975]},"fetchTaggedLogs":{"times":[160.82391099999995]},"loadCapsule":{"times":[0.27465699999993376,0.18097100000022692,0.30603900000005524,0.28118799999992916,0.20840299999963463,0.18617100000028586]},"bulkRetrieveLogs":{"times":[5.795999000000393]},"validateEnqueuedNotesAndEvents":{"times":[5.9195370000002185]},"getNotes":{"times":[2.5346370000002025]},"getAuthWitness":{"times":[0.3160400000001573]},"callPrivateFunction":{"times":[151.2765089999998]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.802520000000186]}}},{"functionName":"private_kernel_inner","time":500.2447120000006},{"functionName":"FeeJuice:claim","time":144.84625000000005,"oracles":{"getL1ToL2MembershipWitness":{"times":[31.797789000000193]},"notifyCreatedNullifier":{"times":[0.6649809999998979]},"storeInExecutionCache":{"times":[0.35203199999978096]},"notifyEnqueuedPublicFunctionCall":{"times":[0.5312830000002577]}}},{"functionName":"private_kernel_inner","time":493.005263},{"functionName":"private_kernel_reset","time":449.39786300000014},{"functionName":"private_kernel_tail","time":409.1148780000003}],"unaccounted":398.0009659999996}} 16:36:00 16:36:00 Waiting for account contract deployment... 16:36:00 [16:36:00.775] INFO: pxe:service Sent transaction 0x2dad9bfe6e5a6effec766b3ac6fbf2413db878d324eede64d8c1d34a5b7c97fc 16:36:01 [16:36:00.773] INFO: node Received tx 0x2dad9bfe6e5a6effec766b3ac6fbf2413db878d324eede64d8c1d34a5b7c97fc {"txHash":"0x2dad9bfe6e5a6effec766b3ac6fbf2413db878d324eede64d8c1d34a5b7c97fc"} 16:36:06 [16:36:05.297] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956354 16:36:06 [16:36:05.298] WARN: foundation:test-date-provider Time set to 2025-06-26T16:45:54.000Z {"offset":588703,"timeMs":1750956354000} 16:36:06 [16:36:05.298] INFO: aztecjs:utils:watcher Slot 12 was missed, jumped to next slot 16:36:06 [16:36:05.688] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07329546499998832s {"duration":0.07329546499998832,"rate":194063.8482885983,"totalPublicGas":{"daGas":1024,"l2Gas":14224},"totalBlockGas":{"daGas":13312,"l2Gas":40548},"totalSizeInBytes":1024} 16:36:06 [16:36:05.717] INFO: sequencer Built block 10 for slot 13 with 1 txs and 0 messages. 129356.28360925204 mana/s {"blockHash":"0x2ef415387e7ae948be5b3bf3e4edd147bc2acb4ac6d0f05b2281cb91071cf96a","globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750956354,"version":846300445},"txHashes":["0x2dad9bfe6e5a6effec766b3ac6fbf2413db878d324eede64d8c1d34a5b7c97fc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":109.87458400000469,"publicProcessDuration":73.50265799999761,"rollupCircuitsDuration":104.8509989999875,"txCount":1,"blockNumber":10,"blockTimestamp":1750956354,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:36:06 [16:36:05.898] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:36:06 [16:36:05.923] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956390 16:36:06 [16:36:05.923] WARN: foundation:test-date-provider Time set to 2025-06-26T16:46:30.000Z {"offset":624077,"timeMs":1750956390000} 16:36:06 [16:36:05.923] INFO: aztecjs:utils:watcher Slot 13 was filled, jumped to next slot 16:36:06 [16:36:05.943] INFO: archiver Downloaded L2 block 10 {"blockHash":"0x2ef415387e7ae948be5b3bf3e4edd147bc2acb4ac6d0f05b2281cb91071cf96a","blockNumber":10,"txCount":1,"globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750956354,"version":846300445},"archiveRoot":"0x0564d463efc04dad1a0a88f64884acf7f3039b2b52cf4a00f520586fc387f0bf","archiveNextLeafIndex":11} 16:36:06 [16:36:06.093] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3402823669209384634633746074317682114570 16:36:06 [16:36:06.095] INFO: aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10. 16:36:06 [16:36:06.225] INFO: world_state World state updated with L2 block 10 {"eventName":"l2-block-handled","duration":6.923383000001195,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1750956354,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:36:06 [16:36:06.457] INFO: archiver Updated proven chain to block 10 {"provenBlockNumber":10} 16:36:06 Deploy tx hash: 0x2dad9bfe6e5a6effec766b3ac6fbf2413db878d324eede64d8c1d34a5b7c97fc 16:36:06 Deploy tx fee: 117589200 16:36:11 [16:36:10.842] INFO: wallet Using local PXE service 16:36:11 [16:36:10.844] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 16:36:11 [16:36:10.901] INFO: pxe:data:lmdb Creating pxe_data data store at directory /home/ubuntu/.aztec/wallet/pxe/pxe_data with map size 134217728 KB (LMDB v2) 16:36:11 [16:36:10.904] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:36:11 [16:36:11.545] INFO: pxe:service Started PXE connected to chain 31337 version 846300445 16:36:11 [16:36:11.601] INFO: wallet Using wallet with address 0x164377dfea9a29088af71e5f72caf8f59311db185de249b59c0aec892e8c97ad 16:36:13 [16:36:12.723] INFO: pxe:service Added contract Token at 0x1a0b4ea2742c19b30c03eb68115cfee73cdbf81a3ece713b16ae819df7c3f132 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 16:36:16 [16:36:15.712] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2215.5563299999994ms 16:36:16 [16:36:15.712] INFO: pxe:bb:native Generating Client IVC proof 16:36:16 [16:36:16.582] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-odUg2T/ivc-inputs.msgpack 16:36:16 [16:36:16.582] INFO: pxe:bb:native bb - BB concurrency: undefined 16:36:16 [16:36:16.582] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-odUg2T --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-odUg2T/ivc-inputs.msgpack -v --scheme client_ivc 16:36:16 [16:36:16.605] INFO: pxe:bb:native bb - bb command: prove (mem: 186.72 MiB) 16:36:16 [16:36:16.606] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 186.72 MiB) 16:36:16 --scheme: client_ivc (mem: 186.72 MiB) 16:36:16 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-odUg2T (mem: 186.72 MiB) 16:36:16 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-odUg2T/ivc-inputs.msgpack (mem: 186.72 MiB) 16:36:16 --verbose: true (mem: 186.72 MiB) 16:36:17 [16:36:17.354] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 186.72 MiB) 16:36:17 using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 186.72 MiB) 16:36:17 [16:36:17.402] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 186.72 MiB) 16:36:17 [16:36:17.455] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 186.72 MiB) 16:36:17 Constructing DeciderProvingKey (mem: 186.72 MiB) 16:36:17 [16:36:17.461] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 186.72 MiB) 16:36:17 goblin ecc op : 4/1024 (mem: 186.72 MiB) 16:36:17 busread : 742/6000 (mem: 186.72 MiB) 16:36:17 lookups : 2076/15000 (mem: 186.72 MiB) 16:36:17 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 186.72 MiB) 16:36:17 arithmetic : 9353/56000 (mem: 186.72 MiB) 16:36:17 delta range : 2977/18000 (mem: 186.72 MiB) 16:36:17 [16:36:17.462] INFO: pxe:bb:native bb - elliptic : 794/6000 (mem: 186.72 MiB) 16:36:17 auxiliary : 4528/26000 (mem: 186.72 MiB) 16:36:17 poseidon ext : 312/17000 (mem: 186.72 MiB) 16:36:17 poseidon int : 1769/92000 (mem: 186.72 MiB) 16:36:17 overflow : 0/0 (mem: 186.72 MiB) 16:36:17 (mem: 186.72 MiB) 16:36:17 Total structured size: 242025 (mem: 186.72 MiB) 16:36:17 allocating polynomials object in proving key... (mem: 186.72 MiB) 16:36:17 [16:36:17.618] INFO: pxe:bb:native bb - populating trace... (mem: 423.83 MiB) 16:36:17 [16:36:17.655] INFO: pxe:bb:native bb - time to construct proving key: 202 ms. (mem: 436.83 MiB) 16:36:17 getting honk vk... precomputed?: 0x652097849f40 (mem: 436.83 MiB) 16:36:17 [16:36:17.655] INFO: pxe:bb:native bb - computing oink proof... (mem: 436.83 MiB) 16:36:17 [16:36:17.655] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 436.83 MiB) 16:36:17 [16:36:17.844] INFO: pxe:bb:native bb - oink proof constructed (mem: 465.83 MiB) 16:36:17 [16:36:17.943] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 466.83 MiB) 16:36:17 [16:36:17.962] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 466.83 MiB) 16:36:17 Constructing DeciderProvingKey (mem: 466.83 MiB) 16:36:17 [16:36:17.967] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 466.83 MiB) 16:36:17 goblin ecc op : 56/1024 (mem: 466.83 MiB) 16:36:17 busread : 2529/6000 (mem: 466.83 MiB) 16:36:17 lookups : 2/15000 (mem: 466.83 MiB) 16:36:17 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 466.83 MiB) 16:36:17 arithmetic : 21095/56000 (mem: 466.83 MiB) 16:36:17 delta range : 3041/18000 (mem: 466.83 MiB) 16:36:17 elliptic : 340/6000 (mem: 466.83 MiB) 16:36:17 auxiliary : 799/26000 (mem: 466.83 MiB) 16:36:17 poseidon ext : 1972/17000 (mem: 466.83 MiB) 16:36:17 poseidon int : 11231/92000 (mem: 466.83 MiB) 16:36:17 overflow : 0/0 (mem: 466.83 MiB) 16:36:17 (mem: 466.83 MiB) 16:36:17 Total structured size: 242025 (mem: 466.83 MiB) 16:36:17 allocating polynomials object in proving key... (mem: 466.83 MiB) 16:36:18 [16:36:18.017] INFO: pxe:bb:native bb - populating trace... (mem: 679.83 MiB) 16:36:18 [16:36:18.043] INFO: pxe:bb:native bb - time to construct proving key: 81 ms. (mem: 692.83 MiB) 16:36:18 getting honk vk... precomputed?: 0x652097811900 (mem: 692.83 MiB) 16:36:18 computing folding proof (mem: 692.83 MiB) 16:36:18 [16:36:18.044] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000005ad8710660b0adcbcf35b84c1fb79f5b (mem: 692.83 MiB) 16:36:18 [16:36:18.250] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 692.83 MiB) 16:36:18 [16:36:18.325] INFO: pxe:bb:native bb - perturbator round (mem: 722.83 MiB) 16:36:18 [16:36:18.384] INFO: pxe:bb:native bb - combiner quotient round (mem: 755.83 MiB) 16:36:18 [16:36:18.477] INFO: pxe:bb:native bb - folded (mem: 755.83 MiB) 16:36:18 constructed folding proof (mem: 755.83 MiB) 16:36:18 [16:36:18.526] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractInstanceDeployer:deploy (mem: 755.83 MiB) 16:36:18 Constructing DeciderProvingKey (mem: 755.83 MiB) 16:36:18 [16:36:18.528] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 755.83 MiB) 16:36:18 goblin ecc op : 4/1024 (mem: 755.83 MiB) 16:36:18 busread : 742/6000 (mem: 755.83 MiB) 16:36:18 lookups : 2/15000 (mem: 755.83 MiB) 16:36:18 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 755.83 MiB) 16:36:18 arithmetic : 3656/56000 (mem: 755.83 MiB) 16:36:18 delta range : 1838/18000 (mem: 755.83 MiB) 16:36:18 [16:36:18.528] INFO: pxe:bb:native bb - elliptic : 340/6000 (mem: 755.83 MiB) 16:36:18 auxiliary : 187/26000 (mem: 755.83 MiB) 16:36:18 poseidon ext : 162/17000 (mem: 755.83 MiB) 16:36:18 poseidon int : 914/92000 (mem: 755.83 MiB) 16:36:18 overflow : 0/0 (mem: 755.83 MiB) 16:36:18 (mem: 755.83 MiB) 16:36:18 Total structured size: 242025 (mem: 755.83 MiB) 16:36:18 allocating polynomials object in proving key... (mem: 755.83 MiB) 16:36:18 [16:36:18.581] INFO: pxe:bb:native bb - populating trace... (mem: 755.83 MiB) 16:36:18 [16:36:18.589] INFO: pxe:bb:native bb - time to construct proving key: 62 ms. (mem: 755.83 MiB) 16:36:18 getting honk vk... precomputed?: 0x65209992cb40 (mem: 755.83 MiB) 16:36:18 computing folding proof (mem: 755.83 MiB) 16:36:18 [16:36:18.589] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 755.83 MiB) 16:36:18 [16:36:18.737] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 755.83 MiB) 16:36:18 [16:36:18.838] INFO: pxe:bb:native bb - perturbator round (mem: 755.83 MiB) 16:36:18 [16:36:18.893] INFO: pxe:bb:native bb - combiner quotient round (mem: 758.24 MiB) 16:36:19 [16:36:19.023] INFO: pxe:bb:native bb - folded (mem: 758.24 MiB) 16:36:19 [16:36:19.024] INFO: pxe:bb:native bb - constructed folding proof (mem: 758.24 MiB) 16:36:19 [16:36:19.176] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000005ad8710660b0adcbcf35b84c1fb79f5b (mem: 758.24 MiB) 16:36:19 [16:36:19.227] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 758.24 MiB) 16:36:19 [16:36:19.278] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 758.24 MiB) 16:36:19 Constructing DeciderProvingKey (mem: 758.24 MiB) 16:36:19 [16:36:19.285] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 758.24 MiB) 16:36:19 goblin ecc op : 792/1024 (mem: 758.24 MiB) 16:36:19 busread : 4184/6000 (mem: 758.24 MiB) 16:36:19 lookups : 2/15000 (mem: 758.24 MiB) 16:36:19 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 758.24 MiB) 16:36:19 [16:36:19.286] INFO: pxe:bb:native bb - arithmetic : 43694/56000 (mem: 758.24 MiB) 16:36:19 delta range : 5034/18000 (mem: 758.24 MiB) 16:36:19 elliptic : 340/6000 (mem: 758.24 MiB) 16:36:19 auxiliary : 1399/26000 (mem: 758.24 MiB) 16:36:19 poseidon ext : 5582/17000 (mem: 758.24 MiB) 16:36:19 poseidon int : 31808/92000 (mem: 758.24 MiB) 16:36:19 overflow : 0/0 (mem: 758.24 MiB) 16:36:19 (mem: 758.24 MiB) 16:36:19 Total structured size: 242025 (mem: 758.24 MiB) 16:36:19 allocating polynomials object in proving key... (mem: 758.24 MiB) 16:36:19 [16:36:19.315] INFO: pxe:bb:native bb - populating trace... (mem: 758.24 MiB) 16:36:19 [16:36:19.364] INFO: pxe:bb:native bb - time to construct proving key: 85 ms. (mem: 758.24 MiB) 16:36:19 getting honk vk... precomputed?: 0x652097e4f040 (mem: 758.24 MiB) 16:36:19 computing folding proof (mem: 758.24 MiB) 16:36:19 [16:36:19.365] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 758.24 MiB) 16:36:19 [16:36:19.642] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 758.24 MiB) 16:36:19 [16:36:19.713] INFO: pxe:bb:native bb - perturbator round (mem: 761.27 MiB) 16:36:19 [16:36:19.786] INFO: pxe:bb:native bb - combiner quotient round (mem: 793.27 MiB) 16:36:19 [16:36:19.878] INFO: pxe:bb:native bb - folded (mem: 793.27 MiB) 16:36:19 constructed folding proof (mem: 793.27 MiB) 16:36:19 [16:36:19.935] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractClassRegisterer:assert_class_id_is_registered (mem: 793.27 MiB) 16:36:19 Constructing DeciderProvingKey (mem: 793.27 MiB) 16:36:19 [16:36:19.937] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 793.27 MiB) 16:36:19 goblin ecc op : 4/1024 (mem: 793.27 MiB) 16:36:19 busread : 742/6000 (mem: 793.27 MiB) 16:36:19 lookups : 2/15000 (mem: 793.27 MiB) 16:36:19 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 793.27 MiB) 16:36:19 [16:36:19.937] INFO: pxe:bb:native bb - arithmetic : 3287/56000 (mem: 793.27 MiB) 16:36:19 delta range : 1787/18000 (mem: 793.27 MiB) 16:36:19 elliptic : 2/6000 (mem: 793.27 MiB) 16:36:19 auxiliary : 26/26000 (mem: 793.27 MiB) 16:36:19 poseidon ext : 12/17000 (mem: 793.27 MiB) 16:36:19 poseidon int : 59/92000 (mem: 793.27 MiB) 16:36:19 overflow : 0/0 (mem: 793.27 MiB) 16:36:19 (mem: 793.27 MiB) 16:36:19 Total structured size: 242025 (mem: 793.27 MiB) 16:36:19 allocating polynomials object in proving key... (mem: 793.27 MiB) 16:36:20 [16:36:19.988] INFO: pxe:bb:native bb - populating trace... (mem: 793.27 MiB) 16:36:20 [16:36:19.995] INFO: pxe:bb:native bb - time to construct proving key: 59 ms. (mem: 793.27 MiB) 16:36:20 [16:36:19.995] INFO: pxe:bb:native bb - getting honk vk... precomputed?: 0x652097836880 (mem: 793.27 MiB) 16:36:20 computing folding proof (mem: 793.27 MiB) 16:36:20 [16:36:19.996] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 793.27 MiB) 16:36:20 [16:36:20.102] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 793.27 MiB) 16:36:20 [16:36:20.200] INFO: pxe:bb:native bb - perturbator round (mem: 793.27 MiB) 16:36:20 [16:36:20.293] INFO: pxe:bb:native bb - combiner quotient round (mem: 793.27 MiB) 16:36:20 [16:36:20.427] INFO: pxe:bb:native bb - folded (mem: 793.27 MiB) 16:36:20 constructed folding proof (mem: 793.27 MiB) 16:36:20 [16:36:20.601] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 793.27 MiB) 16:36:20 [16:36:20.665] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 793.27 MiB) 16:36:20 [16:36:20.707] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 793.27 MiB) 16:36:20 Constructing DeciderProvingKey (mem: 793.27 MiB) 16:36:20 [16:36:20.714] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 793.27 MiB) 16:36:20 goblin ecc op : 792/1024 (mem: 793.27 MiB) 16:36:20 busread : 4184/6000 (mem: 793.27 MiB) 16:36:20 lookups : 2/15000 (mem: 793.27 MiB) 16:36:20 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 793.27 MiB) 16:36:20 arithmetic : 43694/56000 (mem: 793.27 MiB) 16:36:20 delta range : 5034/18000 (mem: 793.27 MiB) 16:36:20 elliptic : 340/6000 (mem: 793.27 MiB) 16:36:20 auxiliary : 1399/26000 (mem: 793.27 MiB) 16:36:20 poseidon ext : 5582/17000 (mem: 793.27 MiB) 16:36:20 poseidon int : 31808/92000 (mem: 793.27 MiB) 16:36:20 overflow : 0/0 (mem: 793.27 MiB) 16:36:20 (mem: 793.27 MiB) 16:36:20 Total structured size: 242025 (mem: 793.27 MiB) 16:36:20 allocating polynomials object in proving key... (mem: 793.27 MiB) 16:36:20 [16:36:20.788] INFO: pxe:bb:native bb - populating trace... (mem: 793.27 MiB) 16:36:20 [16:36:20.912] INFO: pxe:bb:native bb - time to construct proving key: 205 ms. (mem: 793.27 MiB) 16:36:20 getting honk vk... precomputed?: 0x652097ed7b40 (mem: 793.27 MiB) 16:36:20 computing folding proof (mem: 793.27 MiB) 16:36:20 [16:36:20.913] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 793.27 MiB) 16:36:21 [16:36:21.231] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 793.27 MiB) 16:36:21 [16:36:21.306] INFO: pxe:bb:native bb - perturbator round (mem: 793.27 MiB) 16:36:21 [16:36:21.385] INFO: pxe:bb:native bb - combiner quotient round (mem: 794.68 MiB) 16:36:21 [16:36:21.499] INFO: pxe:bb:native bb - folded (mem: 794.68 MiB) 16:36:21 constructed folding proof (mem: 794.68 MiB) 16:36:21 [16:36:21.702] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000004def83ad10541e8f723eacecff0a61ab (mem: 794.68 MiB) 16:36:21 [16:36:21.765] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 794.68 MiB) 16:36:21 Constructing DeciderProvingKey (mem: 794.68 MiB) 16:36:21 [16:36:21.780] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 794.68 MiB) 16:36:21 goblin ecc op : 392/1024 (mem: 794.68 MiB) 16:36:21 busread : 2347/6000 (mem: 794.68 MiB) 16:36:21 lookups : 2/15000 (mem: 794.68 MiB) 16:36:21 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 794.68 MiB) 16:36:21 arithmetic : 36146/56000 (mem: 794.68 MiB) 16:36:21 delta range : 4306/18000 (mem: 794.68 MiB) 16:36:21 elliptic : 1274/6000 (mem: 794.68 MiB) 16:36:21 auxiliary : 12562/26000 (mem: 794.68 MiB) 16:36:21 poseidon ext : 6062/17000 (mem: 794.68 MiB) 16:36:21 poseidon int : 34544/92000 (mem: 794.68 MiB) 16:36:21 overflow : 0/0 (mem: 794.68 MiB) 16:36:21 [16:36:21.780] INFO: pxe:bb:native bb - (mem: 794.68 MiB) 16:36:21 Total structured size: 242025 (mem: 794.68 MiB) 16:36:21 allocating polynomials object in proving key... (mem: 794.68 MiB) 16:36:21 [16:36:21.816] INFO: pxe:bb:native bb - populating trace... (mem: 794.68 MiB) 16:36:21 [16:36:21.878] INFO: pxe:bb:native bb - time to construct proving key: 115 ms. (mem: 794.68 MiB) 16:36:21 getting honk vk... precomputed?: 0x6520975fa080 (mem: 794.68 MiB) 16:36:21 computing folding proof (mem: 794.68 MiB) 16:36:21 [16:36:21.878] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000e7838a46e34d859186131f18f34c3499 (mem: 794.68 MiB) 16:36:22 [16:36:22.198] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 794.68 MiB) 16:36:22 [16:36:22.271] INFO: pxe:bb:native bb - perturbator round (mem: 794.68 MiB) 16:36:22 [16:36:22.334] INFO: pxe:bb:native bb - combiner quotient round (mem: 825.32 MiB) 16:36:22 [16:36:22.430] INFO: pxe:bb:native bb - folded (mem: 825.32 MiB) 16:36:22 constructed folding proof (mem: 825.32 MiB) 16:36:22 [16:36:22.565] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000e7838a46e34d859186131f18f34c3499 (mem: 825.32 MiB) 16:36:22 [16:36:22.609] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 825.32 MiB) 16:36:22 Constructing DeciderProvingKey (mem: 825.32 MiB) 16:36:22 [16:36:22.620] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 825.32 MiB) 16:36:22 goblin ecc op : 392/1024 (mem: 825.32 MiB) 16:36:22 busread : 231/6000 (mem: 825.32 MiB) 16:36:22 lookups : 2/15000 (mem: 825.32 MiB) 16:36:22 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 825.32 MiB) 16:36:22 arithmetic : 32267/56000 (mem: 825.32 MiB) 16:36:22 delta range : 4412/18000 (mem: 825.32 MiB) 16:36:22 elliptic : 2/6000 (mem: 825.32 MiB) 16:36:22 auxiliary : 11868/26000 (mem: 825.32 MiB) 16:36:22 [16:36:22.620] INFO: pxe:bb:native bb - poseidon ext : 2502/17000 (mem: 825.32 MiB) 16:36:22 poseidon int : 14252/92000 (mem: 825.32 MiB) 16:36:22 overflow : 0/0 (mem: 825.32 MiB) 16:36:22 (mem: 825.32 MiB) 16:36:22 Total structured size: 242025 (mem: 825.32 MiB) 16:36:22 allocating polynomials object in proving key... (mem: 825.32 MiB) 16:36:22 [16:36:22.669] INFO: pxe:bb:native bb - populating trace... (mem: 825.32 MiB) 16:36:22 [16:36:22.697] INFO: pxe:bb:native bb - time to construct proving key: 88 ms. (mem: 825.32 MiB) 16:36:22 getting honk vk... precomputed?: 0x652097b75400 (mem: 825.32 MiB) 16:36:22 computing folding proof (mem: 825.32 MiB) 16:36:22 [16:36:22.698] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000090fa82f152876a666266b077a296059c (mem: 825.32 MiB) 16:36:22 [16:36:22.921] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 825.32 MiB) 16:36:22 [16:36:22.986] INFO: pxe:bb:native bb - perturbator round (mem: 825.32 MiB) 16:36:23 [16:36:23.025] INFO: pxe:bb:native bb - combiner quotient round (mem: 825.32 MiB) 16:36:23 [16:36:23.120] INFO: pxe:bb:native bb - folded (mem: 825.32 MiB) 16:36:23 constructed folding proof (mem: 825.32 MiB) 16:36:23 [16:36:23.216] INFO: pxe:bb:native bb - Largest circuit: 97243 gates. Trace details: (mem: 825.32 MiB) 16:36:23 Minimum required block sizes for structured trace: (mem: 825.32 MiB) 16:36:23 [16:36:23.216] INFO: pxe:bb:native bb - (mem: 825.32 MiB) 16:36:23 prove decider... (mem: 825.32 MiB) 16:36:23 [16:36:23.216] INFO: pxe:bb:native bb - ecc_op : 792 16:36:23 busread : 4184 16:36:23 lookup : 2076 16:36:23 pub_inputs : 1859 16:36:23 arithmetic : 43694 16:36:23 delta_range : 5034 16:36:23 elliptic : 1274 16:36:23 aux : 12562 16:36:23 poseidon2_external : 6062 16:36:23 poseidon2_internal : 34544 16:36:23 overflow : 0 16:36:23 [16:36:23.309] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 825.32 MiB) 16:36:23 [16:36:23.403] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 825.32 MiB) 16:36:23 [16:36:23.922] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 825.32 MiB) 16:36:24 [16:36:24.004] INFO: pxe:bb:native bb - computed opening proof (mem: 825.32 MiB) 16:36:24 finished decider proving. (mem: 825.32 MiB) 16:36:24 [16:36:24.014] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000090fa82f152876a666266b077a296059c (mem: 825.32 MiB) 16:36:24 [16:36:24.173] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 825.32 MiB) 16:36:24 [16:36:24.178] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 825.32 MiB) 16:36:24 [16:36:24.219] INFO: pxe:bb:native bb - populating trace... (mem: 825.32 MiB) 16:36:24 [16:36:24.287] INFO: pxe:bb:native bb - time to construct proving key: 114 ms. (mem: 825.32 MiB) 16:36:24 [16:36:24.767] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000424382df4103106ae7134d792abf50bb (mem: 825.32 MiB) 16:36:25 [16:36:25.075] INFO: pxe:bb:native bb - created oink proof (mem: 825.32 MiB) 16:36:25 [16:36:25.207] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 825.32 MiB) 16:36:25 [16:36:25.592] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 825.32 MiB) 16:36:26 [16:36:26.021] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 825.32 MiB) 16:36:26 [16:36:26.078] INFO: pxe:bb:native bb - computed opening proof (mem: 825.32 MiB) 16:36:26 finished decider proving. (mem: 825.32 MiB) 16:36:26 Constructing a Goblin proof with num ultra ops = 3022 (mem: 825.32 MiB) 16:36:26 [16:36:26.160] INFO: pxe:bb:native bb - prove eccvm... (mem: 825.32 MiB) 16:36:26 [16:36:26.409] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 825.32 MiB) 16:36:26 [16:36:26.418] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 825.32 MiB) 16:36:27 [16:36:27.211] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 825.32 MiB) 16:36:28 [16:36:27.998] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 825.32 MiB) 16:36:30 [16:36:29.666] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 825.32 MiB) 16:36:30 prove translator... (mem: 825.32 MiB) 16:36:30 [16:36:30.605] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 825.32 MiB) 16:36:31 [16:36:31.662] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 825.32 MiB) 16:36:33 [16:36:33.229] INFO: node Received tx 0x13c5a03deac20b2588e2439d236c5ea256e2bf6c7a01b6228485802892df2e3b {"txHash":"0x13c5a03deac20b2588e2439d236c5ea256e2bf6c7a01b6228485802892df2e3b"} 16:36:33 [16:36:32.814] INFO: pxe:bb:native bb - computed opening proof (mem: 825.32 MiB) 16:36:33 finished translator proving. (mem: 825.32 MiB) 16:36:33 vkey hash in Oink verifier: 0x00000000000000000000000000000000424382df4103106ae7134d792abf50bb (mem: 825.32 MiB) 16:36:33 [16:36:32.835] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 825.32 MiB) 16:36:33 libra_evals_verified: 1 (mem: 825.32 MiB) 16:36:33 pairing_check_verified: 1 (mem: 825.32 MiB) 16:36:33 Mega verified: 1 (mem: 825.32 MiB) 16:36:33 [16:36:32.912] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 825.32 MiB) 16:36:33 batch opening verified?: 1 (mem: 825.32 MiB) 16:36:33 eccvm consistency check verified?: 1 (mem: 825.32 MiB) 16:36:33 translation masking consistency checked?: 1 (mem: 825.32 MiB) 16:36:33 [16:36:32.928] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 825.32 MiB) 16:36:33 eccvm verified?: 1 (mem: 825.32 MiB) 16:36:33 accumulator construction_verified?: 1 (mem: 825.32 MiB) 16:36:33 translation verified?: 1 (mem: 825.32 MiB) 16:36:33 consistency verified?: 1 (mem: 825.32 MiB) 16:36:33 Goblin verified: 1 (mem: 825.32 MiB) 16:36:33 [16:36:32.928] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-odUg2T" (mem: 825.32 MiB) 16:36:33 [16:36:33.110] INFO: pxe:bb:native Generated IVC proof {"duration":16525.868258,"eventName":"circuit-proving"} 16:36:33 [16:36:33.115] INFO: pxe:service Proving completed in 20382.093054ms {"timings":{"total":20382.093054,"sync":57.48575600000004,"proving":17402.200909,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":554.3300180000006,"oracles":{"debugLog":{"times":[1.1464120000000548,0.28374699999994846,0.3033290000003035,0.39997500000026776,0.26236599999992904,0.19926200000008976,0.3035290000002533,0.36651400000027934]},"fetchTaggedLogs":{"times":[184.3572519999998]},"loadCapsule":{"times":[0.5566250000001673,0.2911389999999301,0.6041479999998955,0.4050560000000587,0.3136500000000524,0.610327999999754,0.315900000000056,0.5069419999999809,0.5296629999998004,0.4665090000003147]},"getSharedSecret":{"times":[6.552639999999883]},"aes128Decrypt":{"times":[1.4184979999999996,1.2606390000000829]},"getPublicKeysAndPartialAddress":{"times":[6.467154999999821]},"getKeyValidationRequest":{"times":[3.4852179999998043]},"storeCapsule":{"times":[2.8668900000002395,2.701719000000139,3.8320699999999306]},"deleteCapsule":{"times":[3.834690000000137]},"bulkRetrieveLogs":{"times":[8.366873999999825]},"validateEnqueuedNotesAndEvents":{"times":[24.76515900000004]},"getNotes":{"times":[5.014833000000181]},"getAuthWitness":{"times":[0.4659990000000107]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.48157999999966705]},"callPrivateFunction":{"times":[141.37216399999988]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3440310000005411]}}},{"functionName":"private_kernel_init","time":195.0434610000002},{"functionName":"ContractInstanceDeployer:deploy","time":77.20760999999902,"oracles":{"storeInExecutionCache":{"times":[0.3975250000003143]},"callPrivateFunction":{"times":[75.02705400000013]},"notifyCreatedNullifier":{"times":[0.6056180000005043]},"debugLog":{"times":[0.41992599999957747]}}},{"functionName":"private_kernel_inner","time":421.6779489999999},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":52.59755000000041,"oracles":{}},{"functionName":"private_kernel_inner","time":432.79353399999945},{"functionName":"private_kernel_reset","time":470.80817300000035},{"functionName":"private_kernel_tail","time":384.777161}],"unaccounted":333.17093300000124}} 16:36:33 [16:36:33.231] INFO: pxe:service Sent transaction 0x13c5a03deac20b2588e2439d236c5ea256e2bf6c7a01b6228485802892df2e3b 16:36:42 [16:36:42.052] WARN: aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time 16:36:42 [16:36:42.054] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956427 16:36:42 [16:36:42.256] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:36:42 [16:36:42.256] WARN: foundation:test-date-provider Time set to 2025-06-26T16:47:07.000Z {"offset":624744,"timeMs":1750956427000} 16:36:43 [16:36:43.049] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.16580637599999318s {"duration":0.16580637599999318,"rate":1908563.5162788494,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 16:36:43 [16:36:43.072] INFO: sequencer Built block 11 for slot 15 with 1 txs and 0 messages. 1612958.0186302257 mana/s {"blockHash":"0x0a93a59271205dbb997a662b5bcf71ea6332b1ae28083c5fb85ad45f10d4e417","globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750956426,"version":846300445},"txHashes":["0x13c5a03deac20b2588e2439d236c5ea256e2bf6c7a01b6228485802892df2e3b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":196.15244299999904,"publicProcessDuration":165.93938399999752,"rollupCircuitsDuration":190.362821000017,"txCount":1,"blockNumber":11,"blockTimestamp":1750956426,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:36:43 [16:36:43.272] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:36:43 [16:36:43.272] WARN: foundation:test-date-provider Time set to 2025-06-26T16:47:19.000Z {"offset":635728,"timeMs":1750956439000} 16:36:43 [16:36:43.276] WARN: ethereum:cheat_codes Set L1 storage for contract 0xac9336e5b15c2d0f8df8ced01f538e65826e7f20 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3743106036130323098097120681749450326027 16:36:43 [16:36:43.279] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:36:43 [16:36:43.281] INFO: aztecjs:cheat_codes Proven tip moved: 10 -> 11. Pending tip: 11. 16:36:43 [16:36:43.316] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750956462 16:36:43 [16:36:43.316] WARN: foundation:test-date-provider Time set to 2025-06-26T16:47:42.000Z {"offset":658684,"timeMs":1750956462000} 16:36:43 [16:36:43.316] INFO: aztecjs:utils:watcher Slot 15 was filled, jumped to next slot 16:36:43 [16:36:43.538] INFO: archiver Downloaded L2 block 11 {"blockHash":"0x0a93a59271205dbb997a662b5bcf71ea6332b1ae28083c5fb85ad45f10d4e417","blockNumber":11,"txCount":1,"globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750956426,"version":846300445},"archiveRoot":"0x0c813dfd54c2ba19febf23cff327914f8b26cf72839ac1cd08725759b88ef5d3","archiveNextLeafIndex":12} 16:36:43 [16:36:43.540] INFO: archiver Updated proven chain to block 11 {"provenBlockNumber":11} 16:36:44 [16:36:43.889] INFO: world_state World state updated with L2 block 11 {"eventName":"l2-block-handled","duration":6.879060000006575,"unfinalisedBlockNumber":11,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":11,"blockTimestamp":1750956426,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:36:44 Contract deployed at 0x1a0b4ea2742c19b30c03eb68115cfee73cdbf81a3ece713b16ae819df7c3f132 16:36:44 Contract partial address 0x0cd726c635cb6ef34921167b899bd475e34bfd81345a41daf23d2889e33d27e1 16:36:44 Contract init hash 0x242e38e67b29d619e126d2617aa9f10654ec80899fed3cd1e3dbd78635076b50 16:36:44 Deployment tx hash: 0x13c5a03deac20b2588e2439d236c5ea256e2bf6c7a01b6228485802892df2e3b 16:36:44 Deployment salt: 0x20d86bf5a7606d9a7ec6d21e36b2b1a1c1b8638d966832a4ee422242056ea632 16:36:44 Deployment fee: 985953600 16:36:44 Contract stored in database with alias last 16:36:45 Sending kill to pid 441 16:36:45 Sending kill to aztec-start-0eb4e1dc