Parent Log: http://ci.aztec-labs.com/723f74eef7f0d56c Command: 851fca28d527869e aztec-up/scripts/run_test.sh bridge_and_claim Commit: https://github.com/AztecProtocol/aztec-packages/commit/812a53d5d7c2057744dbf808172864443b5de7af Env: REF_NAME=gh-readonly-queue/next/pr-14417-7a716b3fac2dc249573084a274291af7802ba659 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 26 13:36:11 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14417_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_ee64b3b6ca626708_next 13:36:11 Unable to find image 'aztecprotocol/dind:latest' locally 13:36:11 latest: Pulling from aztecprotocol/dind 13:36:11 afad30e59d72: Already exists 13:36:11 4e9c72eacf62: Pulling fs layer 13:36:11 1fdf475197e7: Pulling fs layer 13:36:11 5be0e287c3f8: Pulling fs layer 13:36:11 5be0e287c3f8: Download complete 13:36:12 1fdf475197e7: Verifying Checksum 13:36:12 1fdf475197e7: Download complete 13:36:12 4e9c72eacf62: Pull complete 13:36:16 1fdf475197e7: Pull complete 13:36:16 5be0e287c3f8: Pull complete 13:36:16 Digest: sha256:eb8cbe20d658f57df2ce0294b51023227430a6fe8b13b9ea103fd5f8c08c6f6b 13:36:16 Status: Image is up to date for aztecprotocol/dind:latest 13:36:17 Starting docker... 13:36:21 time="2025-06-26T13:36:17.469294604Z" level=info msg="Starting up" 13:36:21 time="2025-06-26T13:36:17.470402946Z" level=info msg="containerd not running, starting managed containerd" 13:36:21 time="2025-06-26T13:36:17.472031028Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=79 13:36:21 time="2025-06-26T13:36:17.501228094Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=1.7.25-1 13:36:21 time="2025-06-26T13:36:17.525845838Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.526166694Z" 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 13:36:21 time="2025-06-26T13:36:17.526196125Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 13:36:21 time="2025-06-26T13:36:17.526215955Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 13:36:21 time="2025-06-26T13:36:17.530889499Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 13:36:21 time="2025-06-26T13:36:17.530919730Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.530982111Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531083423Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531277267Z" 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 13:36:21 time="2025-06-26T13:36:17.531293597Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531312738Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531323788Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531368429Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531595663Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 13:36:21 time="2025-06-26T13:36:17.531708096Z" 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 13:36:21 time="2025-06-26T13:36:17.531723166Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 13:36:21 time="2025-06-26T13:36:17.531743566Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 13:36:21 time="2025-06-26T13:36:17.531791167Z" level=info msg="metadata content store policy set" policy=shared 13:36:21 time="2025-06-26T13:36:17.532054483Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 13:36:21 time="2025-06-26T13:36:17.532103974Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 13:36:21 time="2025-06-26T13:36:17.532121634Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 13:36:21 time="2025-06-26T13:36:17.532141354Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 13:36:21 time="2025-06-26T13:36:17.532162025Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 13:36:21 time="2025-06-26T13:36:17.532335478Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 13:36:21 time="2025-06-26T13:36:17.532768637Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 13:36:21 time="2025-06-26T13:36:17.533147915Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 13:36:21 time="2025-06-26T13:36:17.533166115Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 13:36:21 time="2025-06-26T13:36:17.533186935Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 13:36:21 time="2025-06-26T13:36:17.533203796Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533218156Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533230506Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533245587Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533261617Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533273737Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533285077Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533297288Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 13:36:21 time="2025-06-26T13:36:17.533330768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533346259Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533357499Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533377159Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533388859Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533404380Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533415120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533433220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533451251Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533479441Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533495622Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533505932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533517122Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533532402Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 13:36:21 time="2025-06-26T13:36:17.533560053Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533577283Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533586234Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 13:36:21 time="2025-06-26T13:36:17.533651875Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 13:36:21 time="2025-06-26T13:36:17.533671075Z" 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 13:36:21 time="2025-06-26T13:36:17.533679285Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 13:36:21 time="2025-06-26T13:36:17.533688356Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 13:36:21 time="2025-06-26T13:36:17.533696916Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 13:36:21 time="2025-06-26T13:36:17.533708456Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 13:36:21 time="2025-06-26T13:36:17.533721086Z" level=info msg="NRI interface is disabled by configuration." 13:36:21 time="2025-06-26T13:36:17.534056153Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock 13:36:21 time="2025-06-26T13:36:17.534168125Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc 13:36:21 time="2025-06-26T13:36:17.534266297Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock 13:36:21 time="2025-06-26T13:36:17.534287108Z" level=info msg="containerd successfully booted in 0.034177s" 13:36:21 time="2025-06-26T13:36:18.477790909Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" 13:36:21 time="2025-06-26T13:36:18.509240920Z" level=info msg="Loading containers: start." 13:36:21 time="2025-06-26T13:36:18.743728255Z" level=info msg="Loading containers: done." 13:36:21 time="2025-06-26T13:36:18.754197325Z" level=info msg="Docker daemon" commit=38b84dce32c45732606fe09ffebef8b29a783644 containerd-snapshotter=false storage-driver=overlay2 version=27.5.0-1 13:36:21 time="2025-06-26T13:36:18.754402609Z" level=info msg="Daemon has completed initialization" 13:36:21 time="2025-06-26T13:36:18.764733856Z" level=info msg="API listen on /var/run/docker.sock" 13:36:21 Loading image... 13:36:53 Loaded image: aztecprotocol/aztec:latest 13:36:54 Installing scripts in /home/ubuntu/.aztec/bin... 13:36:54 Installed: /home/ubuntu/.aztec/bin/.aztec-run 13:36:54 Installed: /home/ubuntu/.aztec/bin/aztec 13:36:54 Installed: /home/ubuntu/.aztec/bin/aztec-up 13:36:54 Installed: /home/ubuntu/.aztec/bin/aztec-nargo 13:36:54 Installed: /home/ubuntu/.aztec/bin/aztec-wallet 13:36:54 Done! 13:36:56 anvil Version: 1.2.3-nightly 13:36:56 Commit SHA: 99634144b6c9371982dcfc551a7975c5dbf9fad8 13:36:56 Build Timestamp: 2025-06-06T06:02:57.177433691Z (1749189777) 13:36:56 Build Profile: maxperf 13:37:01 13:37:01 _ 13:37:01 /\ | | 13:37:01 / \ ___| |_ ___ ___ 13:37:01 / /\ \ |_ / __/ _ \/ __| 13:37:01 / ____ \ / /| || __/ (__ 13:37:01 /_/___ \_\/___|\__\___|\___| 13:37:01 13:37:01 https://github.com/AztecProtocol 13:37:01 13:37:01 13:37:01 Setting up Aztec Sandbox 812a53d5d7c2057744dbf808172864443b5de7af, please stand by... 13:37:02 Setting up test accounts 13:37:03 [13:37:02.742] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-TRze5D/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 13:37:03 [13:37:02.831] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 13:37:03 [13:37:02.847] WARN: sandbox Set block interval to 12 13:37:03 [13:37:02.851] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:02.956] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:02.993] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.024] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.062] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.089] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.128] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.145] INFO: sandbox Waiting for 7 transactions to be mined... 13:37:03 [13:37:03.186] INFO: sandbox All transactions mined successfully 13:37:03 [13:37:03.222] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.272] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.322] INFO: sandbox Waiting for 9 transactions to be mined... 13:37:03 [13:37:03.358] INFO: sandbox All transactions mined successfully 13:37:03 [13:37:03.407] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.425] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.442] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.480] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.538] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.610] INFO: sandbox Waiting for 11 transactions to be mined... 13:37:03 [13:37:03.661] INFO: sandbox All transactions mined successfully 13:37:03 [13:37:03.681] INFO: sandbox Deploying contract with salt 0x0000000000000000000000000000000000000000000000000000000000002b18 13:37:03 [13:37:03.770] INFO: sandbox Waiting for 12 transactions to be mined... 13:37:03 [13:37:03.804] INFO: sandbox All transactions mined successfully 13:37:03 [13:37:03.819] INFO: sandbox Waiting for 12 transactions to be mined... 13:37:03 [13:37:03.849] INFO: sandbox All transactions mined successfully 13:37:03 [13:37:03.879] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0x19c003395bccafe5e9a9334d53187d06fe2e7e04","governanceAddress":"0x1e7492e13f86c9801844ec6526876546f6ebe940","governanceProposerAddress":"0x299929d42ca6905843f59be506672cc3e68a2a21","rollupAddress":"0x91714af62ce2441da3ae1db8b959f0e37efbfe52","inboxAddress":"0x0805373cf4347fa4180a63b97b3fc8b56cd7143d","outboxAddress":"0x009916d28a67983bb6c9017e4efacb81deb410c0","feeJuicePortalAddress":"0xc605113436fddf975b395e5c3cc65ffdd1a31de9","feeJuiceAddress":"0xee5d56025d7de65f5d788bbb2a01acf52eb7e9d2","stakingAssetAddress":"0x32aeae684b1c18a28fa8da4001311fb2d09f3ef1","rewardDistributorAddress":"0xbd412c5971339f816bbacef61d095d9ccd603be9","gseAddress":"0x0a92bc2d72537a3d580b28719117f5b1f1b3876a","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 13:37:03 [13:37:03.879] INFO: sandbox Handing over to governance 13:37:03 [13:37:03.895] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 13:37:03 [13:37:03.901] INFO: sandbox Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 13:37:03 [13:37:03.912] INFO: sandbox Deployed Multicall3 13:37:03 [13:37:03.924] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x91714aF62Ce2441DA3AE1Db8b959F0e37efbfE52 13:37:03 [13:37:03.925] INFO: telemetry:client Using NoopTelemetryClient 13:37:03 [13:37:03.925] INFO: blob-sink:client Creating local blob sink client. 13:37:03 [13:37:03.938] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:03 [13:37:03.938] WARN: foundation:test-date-provider Time set to 2025-06-26T13:42:08.000Z {"offset":304062,"timeMs":1750945328000} 13:37:04 [13:37:03.973] INFO: archiver:lmdb Starting data store with maxReaders 16 13:37:04 [13:37:04.310] INFO: archiver Starting archiver sync to rollup contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 from L1 block 20 to current L1 block 26 with hash 0x019e65ab59212f60e0bd08c9e10803108b8e5695acc3b847ba9cb2374a0e259d {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x695734bf60002cf49fc32bd54ae073efea7be7f66bf2317903b7c258ad744a72","l1BlockNumber":20}} 13:37:04 [13:37:04.331] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 13:37:04 [13:37:04.346] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-63KmFF/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 16 threads. 13:37:04 [13:37:04.413] INFO: world_state Created world state synchroniser with block history of 64 13:37:04 [13:37:04.413] WARN: node Aztec node is accepting fake proofs 13:37:04 [13:37:04.413] INFO: bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers 13:37:04 [13:37:04.504] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 13:37:04 [13:37:04.518] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 13:37:04 [13:37:04.528] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 13:37:04 [13:37:04.533] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 13:37:04 [13:37:04.546] INFO: world_state Started world state synchronizer from block 1 13:37:05 [13:37:04.554] INFO: p2p Starting p2p client from block 0 with empty mempools 13:37:05 [13:37:04.830] INFO: epoch-prune-watcher EpochPruneWatcher initialized 13:37:05 [13:37:04.904] INFO: slasher Starting Slasher client... 13:37:05 [13:37:04.930] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 13:37:05 [13:37:04.931] 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} 13:37:05 [13:37:04.934] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 13:37:05 [13:37:04.935] INFO: node Aztec Node version: 812a53d5d7c2057744dbf808172864443b5de7af 13:37:05 [13:37:04.935] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x91714af62ce2441da3ae1db8b959f0e37efbfe52","registryAddress":"0x19c003395bccafe5e9a9334d53187d06fe2e7e04","inboxAddress":"0x0805373cf4347fa4180a63b97b3fc8b56cd7143d","outboxAddress":"0x009916d28a67983bb6c9017e4efacb81deb410c0","feeJuiceAddress":"0xee5d56025d7de65f5d788bbb2a01acf52eb7e9d2","stakingAssetAddress":"0x32aeae684b1c18a28fa8da4001311fb2d09f3ef1","feeJuicePortalAddress":"0xc605113436fddf975b395e5c3cc65ffdd1a31de9","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xbd412c5971339f816bbacef61d095d9ccd603be9","governanceProposerAddress":"0x299929d42ca6905843f59be506672cc3e68a2a21","governanceAddress":"0x1e7492e13f86c9801844ec6526876546f6ebe940","slashFactoryAddress":"0x6ed40f28c27c393f46f2fbe3e5019475ae36c87d","feeAssetHandlerAddress":"0x7feab244b8bdb7923f4b3fb0e96359a98c442640","stakingAssetHandlerAddress":"0xf952e65686093a8ddee7cff1af3bdaff661dff02","gseAddress":"0x0a92bc2d72537a3d580b28719117f5b1f1b3876a","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 13:37:05 [13:37:04.942] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:37:05 Setting up funded test accounts... 13:37:05 [13:37:05.384] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:37:05 [13:37:05.450] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:05 [13:37:05.531] WARN: pxe:service No artifact found for contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf when looking for its metadata 13:37:05 [13:37:05.538] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf as part of deployment for 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:05 [13:37:05.763] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:09 [13:37:09.265] INFO: pxe:service Proving completed in 3457.6060880000005ms {"timings":{"total":3457.6060880000005,"sync":12.964139999998224,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":149.52852300000086,"oracles":{"callPrivateFunction":{"times":[1416.2513129999988,440.26433800000086,175.95323199999984]}}},{"functionName":"private_kernel_init","time":105.67368799999895},{"functionName":"ContractClassRegisterer:register","time":1396.444071,"oracles":{"loadCapsule":{"times":[49.96298299999944]},"notifyCreatedNullifier":{"times":[2.6297510000003967]},"debugLog":{"times":[0.627822999998898]},"notifyCreatedContractClassLog":{"times":[14.124311999999918]}}},{"functionName":"private_kernel_inner","time":152.684263000001},{"functionName":"SchnorrAccount:constructor","time":420.5765879999999,"oracles":{"getContractInstance":{"times":[2.5424389999989216]},"debugLog":{"times":[0.5533909999994648,0.23054400000000896]},"fetchTaggedLogs":{"times":[113.11251099999936]},"loadCapsule":{"times":[1.037609999999404,0.5374599999995553,1.2348739999997633,0.2699250000005122,0.3657970000003843,0.22299500000008265]},"bulkRetrieveLogs":{"times":[3.0271080000002257]},"validateEnqueuedNotesAndEvents":{"times":[2.989348000000973]},"notifyCreatedNullifier":{"times":[0.27168600000004517,0.2697759999991831]},"notifyCreatedNote":{"times":[0.4430579999989277]},"getRandomField":{"times":[0.2245439999987866,0.30104600000049686,0.09017200000016601,0.15823300000010931,0.0855520000004617,0.05989100000078906,0.051451000001179636,0.03882100000009814,0.05280099999981758,0.08719100000053004,0.04276100000060978]},"getIndexedTaggingSecretAsSender":{"times":[31.610429000000295]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.60289600000033]}}},{"functionName":"private_kernel_inner","time":156.1158489999998},{"functionName":"SchnorrAccount:entrypoint","time":164.53434199999901,"oracles":{"debugLog":{"times":[0.27796499999931257,0.1342530000001716,0.38483799999994517]},"fetchTaggedLogs":{"times":[48.444063999999344]},"loadCapsule":{"times":[0.31610600000021805,0.42049799999949755,0.2905560000017431,0.21378399999957765,0.2231049999991228,0.23157499999979336]},"bulkRetrieveLogs":{"times":[1.4762379999992845]},"validateEnqueuedNotesAndEvents":{"times":[2.3095439999997325]},"getNotes":{"times":[2.0231089999997494]},"getAuthWitness":{"times":[0.3141859999996086]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.072290999998586]}}},{"functionName":"private_kernel_inner","time":156.83410399999957},{"functionName":"private_kernel_reset","time":245.20138699999916},{"functionName":"private_kernel_tail","time":94.27056799999991}],"unaccounted":402.77856500000416}} 13:37:09 [13:37:09.379] INFO: node Received tx 0x186a186a25f468db607702da78c2cef76aba0364926d121cda88d53eae6303b8 {"txHash":"0x186a186a25f468db607702da78c2cef76aba0364926d121cda88d53eae6303b8"} 13:37:09 [13:37:09.379] INFO: pxe:service Sent transaction 0x186a186a25f468db607702da78c2cef76aba0364926d121cda88d53eae6303b8 13:37:09 [13:37:09.960] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.046042878000000204s {"duration":0.046042878000000204,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 13:37:10 [13:37:10.008] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x02ebb273857f9d390cb5a2cbf7846b3848eb059c88879255f0e8f4c972782120","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750945328,"version":2424982324},"txHashes":["0x186a186a25f468db607702da78c2cef76aba0364926d121cda88d53eae6303b8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":105.986683000001,"publicProcessDuration":46.74391099999957,"rollupCircuitsDuration":98.54710899999918,"txCount":1,"blockNumber":1,"blockTimestamp":1750945328,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:37:13 [13:37:13.027] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:13 [13:37:13.172] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:13 [13:37:13.172] WARN: foundation:test-date-provider Time set to 2025-06-26T13:42:20.000Z {"offset":306828,"timeMs":1750945340000} 13:37:13 [13:37:13.178] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 340282366920938463463374607431768211457 13:37:13 [13:37:13.180] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 13:37:13 [13:37:13.194] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945364 13:37:13 [13:37:13.194] WARN: foundation:test-date-provider Time set to 2025-06-26T13:42:44.000Z {"offset":330806,"timeMs":1750945364000} 13:37:13 [13:37:13.194] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 13:37:13 [13:37:13.514] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x02ebb273857f9d390cb5a2cbf7846b3848eb059c88879255f0e8f4c972782120","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750945328,"version":2424982324},"archiveRoot":"0x2a1f45b0f10a2c95a2118ebc7e235e0a3451951573a58845f210b3569a78824e","archiveNextLeafIndex":2} 13:37:13 [13:37:13.520] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 13:37:13 [13:37:13.682] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 13:37:13 [13:37:13.804] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:13 [13:37:13.846] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":14.584818999999698,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750945328,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:37:15 [13:37:15.325] INFO: pxe:service Proving completed in 1497.4144210000013ms {"timings":{"total":1497.4144210000013,"sync":19.93031300000075,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":68.53273399999671,"oracles":{"callPrivateFunction":{"times":[364.2207359999993,214.4373229999983]}}},{"functionName":"private_kernel_init","time":74.20380300000033},{"functionName":"SchnorrAccount:constructor","time":345.5750189999999,"oracles":{"getContractInstance":{"times":[12.671623000002]},"debugLog":{"times":[0.2891359999994165,0.12955299999885028]},"fetchTaggedLogs":{"times":[126.17814999999973]},"loadCapsule":{"times":[0.35973699999885866,0.2795049999986077,0.22364400000151363,0.2090840000018943,0.23561399999744026,0.18725400000039372]},"bulkRetrieveLogs":{"times":[2.8180039999970177]},"validateEnqueuedNotesAndEvents":{"times":[1.9128170000003593]},"notifyCreatedNullifier":{"times":[0.28140499999790336,0.25421499999720254]},"notifyCreatedNote":{"times":[0.14967299999989336]},"getRandomField":{"times":[0.19195299999773852,0.22192400000130874,0.06200100000205566,0.04880099999718368,0.047621000001527136,0.05532099999982165,0.04847199999858276,0.04715099999884842,0.12439200000153505,0.0660409999982221,0.07399100000111503]},"getIndexedTaggingSecretAsSender":{"times":[30.381322999997792]},"incrementAppTaggingSecretIndexAsSender":{"times":[20.559164000002056]}}},{"functionName":"private_kernel_inner","time":141.21884800000043},{"functionName":"SchnorrAccount:entrypoint","time":205.333208,"oracles":{"debugLog":{"times":[0.25431400000161375,0.11989200000243727,0.24256400000012945]},"fetchTaggedLogs":{"times":[67.4864639999978]},"loadCapsule":{"times":[0.17845300000044517,0.24700499999744352,0.1887929999975313,0.6784929999994347,0.9973189999982424,0.46901900000011665]},"bulkRetrieveLogs":{"times":[0.9895789999973204]},"validateEnqueuedNotesAndEvents":{"times":[8.294669000002614]},"getNotes":{"times":[1.7224029999997583]},"getAuthWitness":{"times":[0.21601400000145077]},"notifySetMinRevertibleSideEffectCounter":{"times":[2.7214329999987967]}}},{"functionName":"private_kernel_inner","time":137.37868399999934},{"functionName":"private_kernel_reset","time":194.27173599999878},{"functionName":"private_kernel_tail","time":76.97859700000117}],"unaccounted":233.9914790000039}} 13:37:15 [13:37:15.404] INFO: node Received tx 0x10a67b5b6038a83d183e9c610ab89eabdc2f7c6cc7a1107f10978116403c623e {"txHash":"0x10a67b5b6038a83d183e9c610ab89eabdc2f7c6cc7a1107f10978116403c623e"} 13:37:15 [13:37:15.404] INFO: pxe:service Sent transaction 0x10a67b5b6038a83d183e9c610ab89eabdc2f7c6cc7a1107f10978116403c623e 13:37:15 [13:37:15.974] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03482188799999858s {"duration":0.03482188799999858,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 13:37:16 [13:37:15.997] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0719f0f7f5c39cff9ee66dab4132db7a60a697f16aade9d1ff3a6ee94f7fe947","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750945364,"version":2424982324},"txHashes":["0x10a67b5b6038a83d183e9c610ab89eabdc2f7c6cc7a1107f10978116403c623e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.61465599999792,"publicProcessDuration":34.946460999999545,"rollupCircuitsDuration":63.09642999999778,"txCount":1,"blockNumber":2,"blockTimestamp":1750945364,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:16 [13:37:16.175] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:16 [13:37:16.256] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945400 13:37:16 [13:37:16.256] WARN: foundation:test-date-provider Time set to 2025-06-26T13:43:20.000Z {"offset":363744,"timeMs":1750945400000} 13:37:16 [13:37:16.256] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 13:37:16 [13:37:16.367] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 680564733841876926926749214863536422914 13:37:16 [13:37:16.369] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 13:37:16 [13:37:16.506] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0719f0f7f5c39cff9ee66dab4132db7a60a697f16aade9d1ff3a6ee94f7fe947","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750945364,"version":2424982324},"archiveRoot":"0x203add602f48d83178f7c5f32d57ce60454dd84c3cc55dc35332e265df1ebcec","archiveNextLeafIndex":3} 13:37:16 [13:37:16.508] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 13:37:16 [13:37:16.629] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 13:37:16 [13:37:16.754] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:16 [13:37:16.814] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.743637999999919,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750945364,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:18 [13:37:18.135] INFO: pxe:service Proving completed in 1349.0860960000027ms {"timings":{"total":1349.0860960000027,"sync":11.255325999998604,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":82.48084300000482,"oracles":{"callPrivateFunction":{"times":[319.33671400000094,199.4017440000025]}}},{"functionName":"private_kernel_init","time":57.39325100000133},{"functionName":"SchnorrAccount:constructor","time":308.3409329999995,"oracles":{"getContractInstance":{"times":[5.434095000000525]},"debugLog":{"times":[0.2936359999985143,0.12895299999945564]},"fetchTaggedLogs":{"times":[128.5921159999998]},"loadCapsule":{"times":[0.29720499999893946,0.24333499999920605,0.21188400000028196,0.23606500000096275,0.37419800000134273,0.20348400000148104]},"bulkRetrieveLogs":{"times":[2.456466999999975]},"validateEnqueuedNotesAndEvents":{"times":[2.172620999997889]},"notifyCreatedNullifier":{"times":[0.4030179999972461,0.3095659999999043]},"notifyCreatedNote":{"times":[0.18744300000253133]},"getRandomField":{"times":[0.2663350000002538,0.3617569999987609,0.06904199999917182,0.05896099999881699,0.04934100000173203,0.05346099999951548,0.05392099999880884,0.08639100000073086,0.07171199999720557,0.07023100000151317,0.07120200000281329]},"getIndexedTaggingSecretAsSender":{"times":[31.282110000000102]},"incrementAppTaggingSecretIndexAsSender":{"times":[18.47738499999832]}}},{"functionName":"private_kernel_inner","time":120.91368900000089},{"functionName":"SchnorrAccount:entrypoint","time":185.3193239999964,"oracles":{"debugLog":{"times":[0.19988399999783724,0.14796299999943585,0.19553399999858811]},"fetchTaggedLogs":{"times":[96.20025600000008]},"loadCapsule":{"times":[0.23867500000051223,0.23616499999843654,0.3142259999985981,0.14210300000195275,0.22209399999701418,0.19623399999909452]},"bulkRetrieveLogs":{"times":[1.466997999999876]},"validateEnqueuedNotesAndEvents":{"times":[1.5074800000002142]},"getNotes":{"times":[1.5322589999996126]},"getAuthWitness":{"times":[0.2371549999988929]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.45254799999747775]}}},{"functionName":"private_kernel_inner","time":145.1694349999998},{"functionName":"private_kernel_reset","time":188.26800000000003},{"functionName":"private_kernel_tail","time":84.89390800000183}],"unaccounted":165.05138699999952}} 13:37:18 [13:37:18.197] INFO: node Received tx 0x1872067a08e82e7bd2cbcf8d800d4d67c3879b5a4c0615b2f68d751f63b632a6 {"txHash":"0x1872067a08e82e7bd2cbcf8d800d4d67c3879b5a4c0615b2f68d751f63b632a6"} 13:37:18 [13:37:18.197] INFO: pxe:service Sent transaction 0x1872067a08e82e7bd2cbcf8d800d4d67c3879b5a4c0615b2f68d751f63b632a6 13:37:18 [13:37:18.775] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0292847920000022s {"duration":0.0292847920000022,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 13:37:18 [13:37:18.816] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x15783bfef3b2f3eebbfd6ca639a64ffbb86ae3da6b9d7a25f21620b67d3b4807","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750945400,"version":2424982324},"txHashes":["0x1872067a08e82e7bd2cbcf8d800d4d67c3879b5a4c0615b2f68d751f63b632a6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":86.48937900000237,"publicProcessDuration":29.41373400000157,"rollupCircuitsDuration":81.48514299999806,"txCount":1,"blockNumber":3,"blockTimestamp":1750945400,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:19 [13:37:19.063] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:19 [13:37:19.250] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:19 [13:37:19.250] WARN: foundation:test-date-provider Time set to 2025-06-26T13:43:32.000Z {"offset":372750,"timeMs":1750945412000} 13:37:19 [13:37:19.256] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1020847100762815390390123822295304634371 13:37:19 [13:37:19.258] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x15783bfef3b2f3eebbfd6ca639a64ffbb86ae3da6b9d7a25f21620b67d3b4807","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750945400,"version":2424982324},"archiveRoot":"0x16c1bbafbedbe5e578e9304b73ddd25c183e31881fde7c824122f8606297d81b","archiveNextLeafIndex":4} 13:37:19 [13:37:19.259] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 13:37:19 [13:37:19.262] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945436 13:37:19 [13:37:19.262] WARN: foundation:test-date-provider Time set to 2025-06-26T13:43:56.000Z {"offset":396738,"timeMs":1750945436000} 13:37:19 [13:37:19.262] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 13:37:19 Initial Accounts: 13:37:19 13:37:19 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:19 Partial Address: 0x094a6663324a8544a40feeacc00ceca29902f1e171ea9015b006dd08d155b962 13:37:19 Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 13:37:19 Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 13:37:19 Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 13:37:19 13:37:19 Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 13:37:19 13:37:19 Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 13:37:19 13:37:19 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 13:37:19 Partial Address: 0x2b84d2628da65fd311052223c692573fdd885b8656536fa5aae92743f0422302 13:37:19 Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 13:37:19 Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 13:37:19 Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 13:37:19 13:37:19 Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 13:37:19 13:37:19 Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 13:37:19 13:37:19 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 13:37:19 Partial Address: 0x0c66cb7f2e50aaf65f67688f65683ba06d1262cab4c413c12f0148f9f5541891 13:37:19 Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 13:37:19 Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 13:37:19 Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 13:37:19 13:37:19 Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 13:37:19 13:37:19 Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 13:37:19 13:37:19 13:37:20 [13:37:20.056] WARN: pxe:service No artifact found for contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 when looking for its metadata 13:37:20 [13:37:20.056] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 13:37:20 [13:37:20.059] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 as part of deployment for 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 13:37:20 [13:37:20.077] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 as part of deployment for 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 13:37:20 [13:37:20.300] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.998954999999114,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750945400,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:20 [13:37:20.303] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 13:37:21 [13:37:20.917] INFO: pxe:service Added contract Token at 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 13:37:21 [13:37:20.918] INFO: pxe:service Added contract FPC at 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 with class 0x11205ab5df5376b340e02b5bfc72283b88dce1cbff3c66d54544b617b3fc0e98 13:37:23 [13:37:23.158] INFO: pxe:service Proving completed in 2218.6168929999985ms {"timings":{"total":2218.6168929999985,"sync":6.698997999999847,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":201.31463099999382,"oracles":{"debugLog":{"times":[0.513200000001234,0.07058200000028592,0.06773200000316137,0.1168020000004617,0.08120200000121258,0.09281199999895762,0.05032000000210246,0.1087020000013581]},"fetchTaggedLogs":{"times":[62.508859000001394]},"loadCapsule":{"times":[0.21355300000141142,0.2022240000005695,0.22854399999778252,0.17702400000052876,0.16590400000131922,0.15939300000172807,0.1561230000006617,0.15182300000014948,0.8790169999992941,0.6749530000015511]},"getSharedSecret":{"times":[3.906025000000227]},"aes128Decrypt":{"times":[0.8368669999981648,0.4462390000007872]},"getPublicKeysAndPartialAddress":{"times":[2.040748999999778]},"getKeyValidationRequest":{"times":[2.394616000001406]},"storeCapsule":{"times":[0.3946369999976014,0.40283800000179326,0.17192400000203634]},"deleteCapsule":{"times":[0.2851359999986016]},"bulkRetrieveLogs":{"times":[0.714202999999543]},"validateEnqueuedNotesAndEvents":{"times":[5.896512999999686]},"getNotes":{"times":[1.6118310000019846]},"getAuthWitness":{"times":[0.14021300000240444]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.043110999999044]},"callPrivateFunction":{"times":[978.6376400000008,110.14639299999908]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3035759999984293]}}},{"functionName":"private_kernel_init","time":75.16033099999913},{"functionName":"ContractClassRegisterer:register","time":965.5565700000006,"oracles":{"loadCapsule":{"times":[3.5321980000007898]},"notifyCreatedNullifier":{"times":[0.4609089999976277]},"debugLog":{"times":[0.20871400000032736]},"notifyCreatedContractClassLog":{"times":[3.177811000001384]}}},{"functionName":"private_kernel_inner","time":113.56731799999761},{"functionName":"ContractInstanceDeployer:deploy","time":70.06331200000568,"oracles":{"storeInExecutionCache":{"times":[0.26468499999828055]},"callPrivateFunction":{"times":[43.55249600000025]},"notifyCreatedNullifier":{"times":[0.2663250000005064]},"debugLog":{"times":[0.14928299999883166]}}},{"functionName":"private_kernel_inner","time":98.06874099999914},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.22034899999926,"oracles":{}},{"functionName":"private_kernel_inner","time":101.12742000000071},{"functionName":"private_kernel_reset","time":166.0776850000002},{"functionName":"private_kernel_tail","time":77.50101599999834}],"unaccounted":311.26052200000413}} 13:37:23 [13:37:23.265] INFO: node Received tx 0x05b37b95d9b3999156807ac392ff12a2e1e6c46584837ea12c2cf79e731ad5cb {"txHash":"0x05b37b95d9b3999156807ac392ff12a2e1e6c46584837ea12c2cf79e731ad5cb"} 13:37:23 [13:37:23.265] INFO: pxe:service Sent transaction 0x05b37b95d9b3999156807ac392ff12a2e1e6c46584837ea12c2cf79e731ad5cb 13:37:26 [13:37:25.863] INFO: pxe:service Proving completed in 2703.623335ms {"timings":{"total":2703.623335,"sync":95.43345100000079,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":389.50859099999434,"oracles":{"debugLog":{"times":[0.13965300000199932,0.11002300000109244,0.11829199999920093,0.23441499999898952,0.17061399999874993,0.11666200000036042,0.08229199999914272,0.14127299999745446]},"fetchTaggedLogs":{"times":[142.50515299999824]},"loadCapsule":{"times":[0.15756300000066403,0.3225960000017949,0.5590110000011919,0.37994700000126613,0.21536399999968125,0.2969149999989895,0.27498500000001513,0.22623400000156835,0.24883500000214553,0.12336200000208919]},"getSharedSecret":{"times":[4.35402299999987]},"aes128Decrypt":{"times":[0.2873760000002221,0.8278350000000501]},"getPublicKeysAndPartialAddress":{"times":[2.0791100000024016]},"getKeyValidationRequest":{"times":[20.940222000001086]},"storeCapsule":{"times":[0.3286970000008296,0.832035999999789,0.2551339999990887]},"deleteCapsule":{"times":[0.2983859999985725]},"bulkRetrieveLogs":{"times":[1.331865000000107]},"validateEnqueuedNotesAndEvents":{"times":[82.9792320000015]},"getNotes":{"times":[2.7166719999986526]},"getAuthWitness":{"times":[0.18952400000125635]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06310100000337115]},"callPrivateFunction":{"times":[1022.2392260000015,183.7412140000015]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09304200000042329]}}},{"functionName":"private_kernel_init","time":79.17003900000054},{"functionName":"ContractClassRegisterer:register","time":1001.8401060000033,"oracles":{"loadCapsule":{"times":[1.9187669999992067]},"notifyCreatedNullifier":{"times":[0.8112660000006144]},"debugLog":{"times":[0.19253399999797693]},"notifyCreatedContractClassLog":{"times":[3.3043630000029225]}}},{"functionName":"private_kernel_inner","time":105.42814200000066},{"functionName":"ContractInstanceDeployer:deploy","time":83.65486400000009,"oracles":{"storeInExecutionCache":{"times":[0.12612200000148732]},"callPrivateFunction":{"times":[104.5053740000003]},"notifyCreatedNullifier":{"times":[0.40390800000022864]},"debugLog":{"times":[0.12040200000046752]}}},{"functionName":"private_kernel_inner","time":104.89713200000187},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":93.71283700000276,"oracles":{}},{"functionName":"private_kernel_inner","time":132.56897299999764},{"functionName":"private_kernel_reset","time":171.90857699999833},{"functionName":"private_kernel_tail","time":70.39669100000174}],"unaccounted":375.10393199999817}} 13:37:26 [13:37:25.958] INFO: node Received tx 0x287ba31effc0974d8effb36f5ce5a20acfdaa1d6c16b43a0b14a1c35878e3b9c {"txHash":"0x287ba31effc0974d8effb36f5ce5a20acfdaa1d6c16b43a0b14a1c35878e3b9c"} 13:37:26 [13:37:25.958] INFO: pxe:service Sent transaction 0x287ba31effc0974d8effb36f5ce5a20acfdaa1d6c16b43a0b14a1c35878e3b9c 13:37:26 [13:37:25.974] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.572604682000001s {"duration":2.572604682000001,"rate":123008.40553317468,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 13:37:26 [13:37:26.034] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 119627.41591988804 mana/s {"blockHash":"0x007f9834dd6fa0de9ebbafae85acafe623a1db69b837d941cc76ce70d5733977","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750945436,"version":2424982324},"txHashes":["0x05b37b95d9b3999156807ac392ff12a2e1e6c46584837ea12c2cf79e731ad5cb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2645.237695,"publicProcessDuration":2572.7206640000004,"rollupCircuitsDuration":2638.531626,"txCount":1,"blockNumber":4,"blockTimestamp":1750945436,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 13:37:26 [13:37:26.255] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:26 [13:37:26.302] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:26 [13:37:26.302] WARN: foundation:test-date-provider Time set to 2025-06-26T13:44:08.000Z {"offset":401698,"timeMs":1750945448000} 13:37:26 [13:37:26.303] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1361129467683753853853498429727072845828 13:37:26 [13:37:26.304] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 13:37:26 [13:37:26.451] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945472 13:37:26 [13:37:26.451] WARN: foundation:test-date-provider Time set to 2025-06-26T13:44:32.000Z {"offset":425549,"timeMs":1750945472000} 13:37:26 [13:37:26.451] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 13:37:26 [13:37:26.682] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x007f9834dd6fa0de9ebbafae85acafe623a1db69b837d941cc76ce70d5733977","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750945436,"version":2424982324},"archiveRoot":"0x18563d29a6b5cc7ac76e808360bb216fa1db6cad5a6787b6d9bfbb53e9a0cea4","archiveNextLeafIndex":5} 13:37:26 [13:37:26.689] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 13:37:26 [13:37:26.910] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":6.892033000000083,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750945436,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 13:37:27 [13:37:27.156] INFO: aztecjs:deploy_sent_tx Contract 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 successfully deployed. 13:37:27 [13:37:27.414] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.12279199499999958s {"duration":0.12279199499999958,"rate":324052.0687036654,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 13:37:27 [13:37:27.443] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 250653.68163303647 mana/s {"blockHash":"0x2a14c4a6e699b50b8ac1a57761e071bc773e512fac218639216ffe3698b97ae5","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750945472,"version":2424982324},"txHashes":["0x287ba31effc0974d8effb36f5ce5a20acfdaa1d6c16b43a0b14a1c35878e3b9c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":158.72075399999812,"publicProcessDuration":123.07527000000118,"rollupCircuitsDuration":153.83595100000093,"txCount":1,"blockNumber":5,"blockTimestamp":1750945472,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 13:37:27 [13:37:27.630] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:27 [13:37:27.767] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2a14c4a6e699b50b8ac1a57761e071bc773e512fac218639216ffe3698b97ae5","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750945472,"version":2424982324},"archiveRoot":"0x06234ec8dddd4ad788cd97648946cef930540dfd5b42b6fe75f42afebae1e38e","archiveNextLeafIndex":6} 13:37:27 [13:37:27.820] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:27 [13:37:27.820] WARN: foundation:test-date-provider Time set to 2025-06-26T13:44:44.000Z {"offset":436180,"timeMs":1750945484000} 13:37:27 [13:37:27.823] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 1701411834604692317316873037158841057285 13:37:27 [13:37:27.824] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 13:37:27 [13:37:27.831] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945508 13:37:27 [13:37:27.831] WARN: foundation:test-date-provider Time set to 2025-06-26T13:45:08.000Z {"offset":460169,"timeMs":1750945508000} 13:37:27 [13:37:27.831] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 13:37:27 [13:37:27.930] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":6.892543000001751,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750945472,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 13:37:28 BananaCoin: 0x2e329ba19c0b5b8a1a73f174da969b26868bee974f0be71d948feb3d9438f8c6 13:37:28 FPC: 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 13:37:28 [13:37:28.188] INFO: aztecjs:deploy_sent_tx Contract 0x1107c84edae4dfc000b3af5b4bf3bb1e13ee917baa2e7ad4d3f13221c865b936 successfully deployed. 13:37:28 [13:37:28.216] WARN: pxe:service No artifact found for contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 when looking for its metadata 13:37:28 [13:37:28.216] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 as part of deployment for 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 13:37:28 [13:37:28.370] INFO: pxe:service Added contract SponsoredFPC at 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 with class 0x057ba518651a898cd9ae2654bc9a3fbe8ff7e580282ecb366dfb237a0cd55524 13:37:28 [13:37:28.377] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 13:37:31 [13:37:30.843] INFO: pxe:service Proving completed in 2463.834063000002ms {"timings":{"total":2463.834063000002,"sync":11.37324499999886,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":61.31448799999998,"oracles":{"callPrivateFunction":{"times":[969.4340969999976,143.65889099999913,53.62120100000175]}}},{"functionName":"private_kernel_init","time":89.38876799999707},{"functionName":"ContractClassRegisterer:register","time":956.7948789999937,"oracles":{"loadCapsule":{"times":[2.264922000002116]},"notifyCreatedNullifier":{"times":[0.6103020000009565]},"debugLog":{"times":[0.17095400000107475]},"notifyCreatedContractClassLog":{"times":[3.592748000002757]}}},{"functionName":"private_kernel_inner","time":117.32809400000406},{"functionName":"ContractInstanceDeployer:deploy","time":75.22965900000418,"oracles":{"storeInExecutionCache":{"times":[0.167343000000983]},"callPrivateFunction":{"times":[69.80486699999892]},"notifyCreatedNullifier":{"times":[0.2249840000004042]},"debugLog":{"times":[0.09945100000186358]}}},{"functionName":"private_kernel_inner","time":127.638208999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":54.530439999995,"oracles":{}},{"functionName":"private_kernel_inner","time":128.6368980000043},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":46.446647000004305,"oracles":{"debugLog":{"times":[0.11576200000126846]}}},{"functionName":"private_kernel_inner","time":124.744494999999},{"functionName":"private_kernel_reset","time":211.15875600000436},{"functionName":"private_kernel_tail","time":97.29572599999665}],"unaccounted":361.95375900000363}} 13:37:31 [13:37:30.949] INFO: node Received tx 0x15e9ac7be832114a696fcd41a1adad8aa9fb0caafd86faa115e5fda468ecbdcc {"txHash":"0x15e9ac7be832114a696fcd41a1adad8aa9fb0caafd86faa115e5fda468ecbdcc"} 13:37:31 [13:37:30.949] INFO: pxe:service Sent transaction 0x15e9ac7be832114a696fcd41a1adad8aa9fb0caafd86faa115e5fda468ecbdcc 13:37:31 [13:37:31.013] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03152377500000148s {"duration":0.03152377500000148,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 13:37:31 [13:37:31.035] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ecba79dfb311ad9feb5f0b6d8ba96b6b7f06ddfcf33841e7bb3233561f8b7b6","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750945508,"version":2424982324},"txHashes":["0x15e9ac7be832114a696fcd41a1adad8aa9fb0caafd86faa115e5fda468ecbdcc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":62.50379899999825,"publicProcessDuration":31.7013980000047,"rollupCircuitsDuration":56.105718999999226,"txCount":1,"blockNumber":6,"blockTimestamp":1750945508,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:37:31 [13:37:31.249] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:31 [13:37:31.280] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:31 [13:37:31.280] WARN: foundation:test-date-provider Time set to 2025-06-26T13:45:20.000Z {"offset":468720,"timeMs":1750945520000} 13:37:31 [13:37:31.281] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2041694201525630780780247644590609268742 13:37:31 [13:37:31.282] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 13:37:31 [13:37:31.457] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945544 13:37:31 [13:37:31.457] WARN: foundation:test-date-provider Time set to 2025-06-26T13:45:44.000Z {"offset":492543,"timeMs":1750945544000} 13:37:31 [13:37:31.457] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 13:37:31 [13:37:31.521] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x1ecba79dfb311ad9feb5f0b6d8ba96b6b7f06ddfcf33841e7bb3233561f8b7b6","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750945508,"version":2424982324},"archiveRoot":"0x068b574b85b870795955d48932b411cb170dc2955eabfa7938b66831ecd64dc6","archiveNextLeafIndex":7} 13:37:31 [13:37:31.526] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 13:37:31 SponsoredFPC: 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 13:37:32 [13:37:31.885] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":7.120965000001888,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750945508,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:37:32 [13:37:31.971] INFO: aztecjs:deploy_sent_tx Contract 0x19b5539ca1b104d4c3705de94e4555c9630def411f025e023a13189d0c56f8f2 successfully deployed. 13:37:32 [13:37:31.979] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x1a5079b513266d78cf61cc98914d568e800982d8b2b9fe79c90f47ce27ffa2ec","l2ProtocolContractsTreeRoot":"0x00d0980697e140a074810b2bee11c5042763b87e95bfdbf2f28269c79e6abad6"} 13:37:35 Registering protocol contract aliases... 13:37:35 Data stored in database with alias contracts:AuthRegistry 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000001 13:37:35 Data stored in database with alias contracts:ContractInstanceDeployer 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000002 13:37:35 Data stored in database with alias contracts:ContractClassRegisterer 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000003 13:37:35 Data stored in database with alias contracts:MultiCallEntrypoint 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000004 13:37:35 Data stored in database with alias contracts:FeeJuice 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000005 13:37:35 Data stored in database with alias contracts:Router 13:37:35 Data stored in database with alias artifacts:0x0000000000000000000000000000000000000000000000000000000000000006 13:37:35 [13:37:35.256] INFO: wallet Using local PXE service 13:37:35 [13:37:35.258] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:37:35 [13:37:35.431] 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) 13:37:35 [13:37:35.435] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:37:36 [13:37:36.154] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:37:36 [13:37:36.512] INFO: pxe:service Added contract SchnorrAccount at 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:36 [13:37:36.516] INFO: pxe:service Added contract SchnorrAccount at 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:36 [13:37:36.530] INFO: pxe:service Added contract SchnorrAccount at 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:36 [13:37:36.633] INFO: pxe:service Registered account 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:36 [13:37:36.637] INFO: pxe:service Registered account 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 13:37:36 [13:37:36.640] INFO: pxe:service Registered account 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 13:37:36 Account stored in database with aliases last & test0 13:37:36 13:37:36 Test account: 13:37:36 Alias: test0 13:37:36 Address: 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:36 Secret key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 13:37:36 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 13:37:36 Account stored in database with aliases last & test1 13:37:36 13:37:36 Test account: 13:37:36 Alias: test1 13:37:36 Address: 0x2d2598a2b9b87b4837109a8375ec5e5f884614f96549c847bf5414e3bdef3413 13:37:36 Secret key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 13:37:36 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 13:37:36 Account stored in database with aliases last & test2 13:37:36 13:37:36 Test account: 13:37:36 Alias: test2 13:37:36 Address: 0x14de1550712d62b8e946b4a888c78d5d1cc9354e7f818a47ea63c39ce9d40fb1 13:37:36 Secret key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 13:37:36 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 13:37:36 13:37:36 3 test accounts imported to wallet db. 13:37:36 13:37:40 [13:37:40.179] INFO: wallet Using local PXE service 13:37:40 [13:37:40.181] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:37:40 [13:37:40.240] 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) 13:37:40 [13:37:40.252] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:37:41 13:37:41 New account: 13:37:41 13:37:41 Address: 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 13:37:41 Public key: 0x1918d9c66b2a12a39a20916f7f18bef9f7f55a9c1dbe4959a5f8674e64d126761ab38b9057f0c89c5ff0c3a998bf78a64a2cc0959346c7912459d1210a21be1d2e50f7563168ab677c8aa77ac038c2c2e71b541e9c9699634f59ecbb7ab539d613e628394e60bbbb0c046a35495a378c836a9222101080b415de8f847bda962f12841a9030550f35b329346c83114f8edd6528eca61b54c0d831fbeb7ed0af8f2e4a1464e16698f8a54f3a2036fa26810c1a706efd9cae45d679626545d21d2a149654e72882f3848f2c9c569747fbed5e4b0fb0c90984dc195ac82fa94b04f11e89663c97cd441eca29a99d55cc78574541a4034a5846acfcf9b7f1bc411f1b 13:37:41 Secret key: 0x29416f792092eb819af6de0ca4137424f69e9798c7f7f9aa919e0fb85e72f228 13:37:41 Partial address: 0x06870255314e44cb1ced8913c2d026e2617b06d02f36e20f0cd02e84cb3af025 13:37:41 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 13:37:41 Init hash: 0x1ec68d801603deff33b964f0103fbe046a110e476ff7316614fe76dbcba5e0c3 13:37:41 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 13:37:41 Account stored in database with aliases last & main 13:37:41 [13:37:40.950] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:37:41 [13:37:41.111] INFO: pxe:service Added contract SchnorrAccount at 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:37:41 [13:37:41.173] INFO: pxe:service Registered account 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 13:37:43 [13:37:43.866] INFO: wallet Using local PXE service 13:37:43 [13:37:43.868] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:37:44 [13:37:44.343] 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) 13:37:44 [13:37:44.345] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:37:45 Minted 1000000000000000000 fee juice on L1 and pushed to L2 portal 13:37:45 claimAmount=1000000000000000000,claimSecret=0x01d14688438e7b520eff246a7aefb5d25c4147c4bb881f62b212c8a6d41d5e53,messageHash=0x00e7064c9e36bc3c68a67b3a1d5ef810e958de7d5b150a42ffbf1499967f1626,messageLeafIndex=112 13:37:45 13:37:45 Note: You need to wait for two L2 blocks before pulling them from the L2 side 13:37:45 Pushed 1000000000000000000 fee juice for recipient 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8. Stack pointer 1 13:37:45 [13:37:45.114] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:37:45 [13:37:45.314] INFO: wallet Minting 1000000000000000000 tokens for 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 13:37:45 [13:37:45.335] INFO: wallet Approving 1000000000000000000 tokens for FeeJuice Portal (0xc605113436fddf975b395e5c3cc65ffdd1a31de9) 13:37:45 [13:37:45.374] INFO: wallet Sending L1 Fee Juice to L2 to be claimed publicly 13:37:45 [13:37:45.391] INFO: wallet Deposited to Aztec public successfully 13:37:46 [13:37:45.492] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:37:46 [13:37:45.492] WARN: foundation:test-date-provider Time set to 2025-06-26T13:46:20.000Z {"offset":514508,"timeMs":1750945580000} 13:37:46 [13:37:45.531] INFO: archiver Retrieved 1 new L1 to L2 messages up to message with index 112 for L2 block 8 {"lastMessage":{"index":112,"l1BlockHash":"0xb8ef5793f3bc89690af35e555ac0cc9c1a4c47a69cafe2f643ba91a3f0edd918","l1BlockNumber":41,"l2BlockNumber":8,"leaf":"0x00e7064c9e36bc3c68a67b3a1d5ef810e958de7d5b150a42ffbf1499967f1626","rollingHash":"0x60124f11761e70d7eb70e7a7fb912306"},"messageCount":1} 13:37:53 [13:37:53.077] INFO: wallet Using local PXE service 13:37:53 [13:37:53.078] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:37:53 [13:37:53.125] 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) 13:37:53 [13:37:53.130] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:37:54 [13:37:53.891] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:37:54 [13:37:53.958] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:37:54 [13:37:54.528] WARN: pxe:service No artifact found for contract class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 when looking for its metadata 13:37:55 [13:37:55.075] INFO: pxe:service Added contract Token at 0x10e0a13daacf738a6f0ff1dcb9411ec9dbc85668d747d8efd97573f9d36915dd with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 13:37:58 [13:37:57.608] INFO: pxe:service Proving completed in 2519.2675849999996ms {"timings":{"total":2519.2675849999996,"sync":367.93514600000026,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":736.3714410000002,"oracles":{"debugLog":{"times":[1.0158700000001772,0.20959399999992456,0.1950329999999667,0.28823499999998603,0.24459500000011758,0.14638300000024174,0.29653500000040367,0.2845560000005207]},"fetchTaggedLogs":{"times":[370.9048809999995]},"loadCapsule":{"times":[0.6025520000002871,0.32168600000022707,0.5062589999997726,0.3700069999995321,0.5046800000000076,0.5720209999999497,0.357876999999462,0.43369800000073155,0.5482499999998254,0.4414580000002388]},"getSharedSecret":{"times":[6.446810999999798]},"aes128Decrypt":{"times":[1.1576220000006288,0.9282869999997274]},"getPublicKeysAndPartialAddress":{"times":[2.5860380000003715]},"getKeyValidationRequest":{"times":[3.5523470000007364]},"storeCapsule":{"times":[2.5805579999996553,3.9444640000001527,4.9517329999998765]},"deleteCapsule":{"times":[3.9791340000001583]},"bulkRetrieveLogs":{"times":[11.01417599999968]},"validateEnqueuedNotesAndEvents":{"times":[28.14927700000044]},"getNotes":{"times":[5.451161999999385]},"getAuthWitness":{"times":[0.4313290000000052]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3854670000000624]},"callPrivateFunction":{"times":[126.5419179999999]},"notifyEnqueuedPublicFunctionCall":{"times":[0.22375499999998283]}}},{"functionName":"private_kernel_init","time":124.09076200000072},{"functionName":"ContractInstanceDeployer:deploy","time":65.65460899999925,"oracles":{"storeInExecutionCache":{"times":[0.34954600000037317]},"callPrivateFunction":{"times":[66.34951099999944]},"notifyCreatedNullifier":{"times":[0.5320300000003044]},"debugLog":{"times":[0.4202480000003561]}}},{"functionName":"private_kernel_inner","time":143.0647170000002},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":50.9283030000006,"oracles":{}},{"functionName":"private_kernel_inner","time":168.29957900000045},{"functionName":"private_kernel_reset","time":290.88433299999997},{"functionName":"private_kernel_tail","time":147.39421799999946}],"unaccounted":424.64447699999846}} 13:37:58 [13:37:57.726] INFO: pxe:service Sent transaction 0x268b0a67a8eb5224c224217f5988d2c130952c0e974cbf8c16cc76d6ebad6bff 13:37:58 [13:37:57.725] INFO: node Received tx 0x268b0a67a8eb5224c224217f5988d2c130952c0e974cbf8c16cc76d6ebad6bff {"txHash":"0x268b0a67a8eb5224c224217f5988d2c130952c0e974cbf8c16cc76d6ebad6bff"} 13:37:58 [13:37:58.411] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.22209212699999625s {"duration":0.22209212699999625,"rate":1424868.1584287107,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 13:37:58 [13:37:58.445] INFO: sequencer Built block 7 for slot 9 with 1 txs and 0 messages. 1201681.2966310312 mana/s {"blockHash":"0x0e17e3852cd888e60ba6a3591bf6c85c69125946aaebde794d647f0b550cc5b5","globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750945580,"version":2424982324},"txHashes":["0x268b0a67a8eb5224c224217f5988d2c130952c0e974cbf8c16cc76d6ebad6bff"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":263.27932700000383,"publicProcessDuration":222.2412289999993,"rollupCircuitsDuration":258.52714799999376,"txCount":1,"blockNumber":7,"blockTimestamp":1750945580,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:58 [13:37:58.664] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:37:58 [13:37:58.666] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945616 13:37:58 [13:37:58.666] WARN: foundation:test-date-provider Time set to 2025-06-26T13:46:56.000Z {"offset":537334,"timeMs":1750945616000} 13:37:58 [13:37:58.666] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 13:37:58 [13:37:58.701] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x0e17e3852cd888e60ba6a3591bf6c85c69125946aaebde794d647f0b550cc5b5","blockNumber":7,"txCount":1,"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750945580,"version":2424982324},"archiveRoot":"0x1b82dc083460f31ced3436f32c42124f298c5a882d656f7340e3a1feb751af1d","archiveNextLeafIndex":8} 13:37:58 [13:37:58.730] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2381976568446569244243622252022377480199 13:37:58 [13:37:58.731] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 13:37:58 [13:37:58.785] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":7.128444000001764,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750945580,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:37:59 Contract deployed at 0x10e0a13daacf738a6f0ff1dcb9411ec9dbc85668d747d8efd97573f9d36915dd 13:37:59 Contract partial address 0x2faac2d26a33901fe3f7c54044ab337d6e53d7bb53c917ec03372ab61348192e 13:37:59 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 13:37:59 Deployment tx hash: 0x268b0a67a8eb5224c224217f5988d2c130952c0e974cbf8c16cc76d6ebad6bff 13:37:59 Deployment salt: 0x251c56f6933ec73f42145e9eac0de1772fbe4352a7bb55ef1d550026431083b0 13:37:59 Deployment fee: 11073278880 13:37:59 Contract stored in database with alias last 13:37:59 [13:37:59.219] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 13:38:01 [13:38:01.913] INFO: wallet Using local PXE service 13:38:01 [13:38:01.914] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:38:02 [13:38:02.002] 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) 13:38:02 [13:38:02.005] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:38:03 [13:38:02.677] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:38:03 [13:38:02.752] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:38:04 [13:38:04.051] INFO: pxe:service Added contract Token at 0x0007cfacfb1bee9f03796e0aed8e5e438b4f05829969ab7b31ed1cf206f5ba66 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 13:38:06 [13:38:05.993] INFO: pxe:service Proving completed in 1929.9308739999997ms {"timings":{"total":1929.9308739999997,"sync":47.35341000000017,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":628.9176380000008,"oracles":{"debugLog":{"times":[0.9516279999998005,0.1727839999994103,0.1900129999994533,0.29303599999911967,0.15618300000005547,0.16750299999966956,0.16534299999966606,0.23300399999970978]},"fetchTaggedLogs":{"times":[298.3668209999996]},"loadCapsule":{"times":[0.46202900000025693,0.22905500000069878,0.573221000000558,0.23662400000011985,0.19793399999980466,0.22902499999963766,0.21594399999958114,0.26838599999973667,0.3823279999996885,0.28459599999951024]},"getSharedSecret":{"times":[5.115708999999697]},"aes128Decrypt":{"times":[1.238654000000679,0.9324980000001233]},"getPublicKeysAndPartialAddress":{"times":[2.232492999999522]},"getKeyValidationRequest":{"times":[2.5774899999996705]},"storeCapsule":{"times":[2.7352240000000165,2.2679239999997662,2.4166869999999108]},"deleteCapsule":{"times":[3.013679000000593]},"bulkRetrieveLogs":{"times":[6.480985999999575]},"validateEnqueuedNotesAndEvents":{"times":[21.33561499999996]},"getNotes":{"times":[4.9421259999999165]},"getAuthWitness":{"times":[0.501589999999851]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.275405000000319]},"callPrivateFunction":{"times":[160.73572500000046]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3420769999993354]}}},{"functionName":"private_kernel_init","time":114.88606399999935},{"functionName":"ContractInstanceDeployer:deploy","time":91.32679499999995,"oracles":{"storeInExecutionCache":{"times":[0.31090599999970436]},"callPrivateFunction":{"times":[77.88558499999999]},"notifyCreatedNullifier":{"times":[0.6453529999998864]},"debugLog":{"times":[0.38218700000015815]}}},{"functionName":"private_kernel_inner","time":157.7470569999996},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":54.033730999999534,"oracles":{}},{"functionName":"private_kernel_inner","time":124.5481319999999},{"functionName":"private_kernel_reset","time":250.37499800000023},{"functionName":"private_kernel_tail","time":88.62020299999949}],"unaccounted":372.12284600000066}} 13:38:06 [13:38:06.093] INFO: pxe:service Sent transaction 0x0aad223f1747760d821d26f5fe0836273929882188bfc9465f8ce652475e974d 13:38:06 [13:38:06.091] INFO: node Received tx 0x0aad223f1747760d821d26f5fe0836273929882188bfc9465f8ce652475e974d {"txHash":"0x0aad223f1747760d821d26f5fe0836273929882188bfc9465f8ce652475e974d"} 13:38:06 [13:38:06.647] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23209073199999694s {"duration":0.23209073199999694,"rate":1363484.0015929812,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 13:38:06 [13:38:06.679] INFO: sequencer Built block 8 for slot 10 with 1 txs and 1 messages. 1159340.0653814112 mana/s {"blockHash":"0x0087a103776ccadf87bdf9d451f60e7c9457294da53b8f80a14e7116c43feae0","globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750945616,"version":2424982324},"txHashes":["0x0aad223f1747760d821d26f5fe0836273929882188bfc9465f8ce652475e974d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":272.9164759999985,"publicProcessDuration":232.22765499999514,"rollupCircuitsDuration":268.0145909999992,"txCount":1,"blockNumber":8,"blockTimestamp":1750945616,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:06 [13:38:06.874] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:38:06 [13:38:06.915] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 2722258935367507707706996859454145691656 13:38:06 [13:38:06.916] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 13:38:06 [13:38:06.958] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x0087a103776ccadf87bdf9d451f60e7c9457294da53b8f80a14e7116c43feae0","blockNumber":8,"txCount":1,"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32570,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750945616,"version":2424982324},"archiveRoot":"0x2589b98c341b35255796d823a284c454d262617c40521f3f03c65f80e9627f25","archiveNextLeafIndex":9} 13:38:06 [13:38:06.963] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 13:38:07 [13:38:07.068] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:38:07 [13:38:07.068] WARN: foundation:test-date-provider Time set to 2025-06-26T13:47:08.000Z {"offset":540932,"timeMs":1750945628000} 13:38:07 [13:38:07.079] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945652 13:38:07 [13:38:07.079] WARN: foundation:test-date-provider Time set to 2025-06-26T13:47:32.000Z {"offset":564921,"timeMs":1750945652000} 13:38:07 [13:38:07.079] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 13:38:07 [13:38:07.128] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":8.297322000013082,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750945616,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:07 Contract deployed at 0x0007cfacfb1bee9f03796e0aed8e5e438b4f05829969ab7b31ed1cf206f5ba66 13:38:07 Contract partial address 0x145eebc56af08434d7b027e333c9ba16e988e99c845e3028e465fa139c4854d0 13:38:07 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 13:38:07 Deployment tx hash: 0x0aad223f1747760d821d26f5fe0836273929882188bfc9465f8ce652475e974d 13:38:07 Deployment salt: 0x0e5f7f9ded9c2fb30655e71601c5f71ecfbe67c32a68ae4d59e4cb48d4100663 13:38:07 Deployment fee: 11073278880 13:38:07 Contract stored in database with alias last 13:38:12 [13:38:11.805] INFO: wallet Using local PXE service 13:38:12 [13:38:11.807] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:38:12 [13:38:11.862] 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) 13:38:12 [13:38:11.864] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:38:12 [13:38:12.549] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:38:12 [13:38:12.619] INFO: wallet Using wallet with address 0x279acb41a60fcce801cec69b3c7b23691e34cd3adb0149af2373acc8e08b97d2 13:38:14 [13:38:13.906] INFO: pxe:service Added contract Token at 0x133542b17bd201d910bda88be6810f2315cf371b97626fa307e500ac476c4f79 with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 13:38:16 [13:38:16.181] INFO: node Received tx 0x29cf6071e2e0d6f08bca95eb4ca45c35149676950bfad76f835e56e3e0f922f8 {"txHash":"0x29cf6071e2e0d6f08bca95eb4ca45c35149676950bfad76f835e56e3e0f922f8"} 13:38:16 [13:38:16.074] INFO: pxe:service Proving completed in 2155.287116ms {"timings":{"total":2155.287116,"sync":61.79220200000009,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":668.7741630000005,"oracles":{"debugLog":{"times":[0.8672360000000481,0.14000299999952404,0.17870399999992514,0.37342699999953766,0.23138399999970716,0.14562300000034156,0.18726299999980256,0.2474449999999706]},"fetchTaggedLogs":{"times":[296.52386599999954]},"loadCapsule":{"times":[0.831836000000294,0.8505960000002233,0.435008999999809,2.492409000000407,0.8036360000005516,0.3224470000004658,0.3265369999999166,0.27656500000011874,0.3921169999994163,0.3130360000004657]},"getSharedSecret":{"times":[6.05732799999987]},"aes128Decrypt":{"times":[1.1490629999998418,0.943438000000242]},"getPublicKeysAndPartialAddress":{"times":[4.438516999999592]},"getKeyValidationRequest":{"times":[6.703400000000329]},"storeCapsule":{"times":[1.7519140000003972,2.70078199999989,1.2338140000001658]},"deleteCapsule":{"times":[1.5980409999992844]},"bulkRetrieveLogs":{"times":[7.605668000000151]},"validateEnqueuedNotesAndEvents":{"times":[24.790242999999464]},"getNotes":{"times":[7.00602600000002]},"getAuthWitness":{"times":[0.34080600000015693]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.31690600000001723]},"callPrivateFunction":{"times":[157.9557109999996]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3484259999995629]}}},{"functionName":"private_kernel_init","time":157.73867699999937},{"functionName":"ContractInstanceDeployer:deploy","time":85.12699599999996,"oracles":{"storeInExecutionCache":{"times":[0.3556570000000647]},"callPrivateFunction":{"times":[71.63402299999962]},"notifyCreatedNullifier":{"times":[0.7301939999997558]},"debugLog":{"times":[0.39349700000002485]}}},{"functionName":"private_kernel_inner","time":171.27026999999998},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":55.15127199999915,"oracles":{}},{"functionName":"private_kernel_inner","time":118.94143299999996},{"functionName":"private_kernel_reset","time":278.78538000000026},{"functionName":"private_kernel_tail","time":115.47669599999972}],"unaccounted":442.230027000001}} 13:38:16 [13:38:16.183] INFO: pxe:service Sent transaction 0x29cf6071e2e0d6f08bca95eb4ca45c35149676950bfad76f835e56e3e0f922f8 13:38:17 [13:38:16.954] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24025312300000223s {"duration":0.24025312300000223,"rate":1317160.8179261715,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 13:38:17 [13:38:16.981] INFO: sequencer Built block 9 for slot 11 with 1 txs and 0 messages. 1139142.9170938293 mana/s {"blockHash":"0x284788e0cfa30d40a5184cd517172e76d1dcbaeab4856dccaf41b2c5ec60dd85","globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750945652,"version":2424982324},"txHashes":["0x29cf6071e2e0d6f08bca95eb4ca45c35149676950bfad76f835e56e3e0f922f8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":277.73306800000137,"publicProcessDuration":240.39030499999353,"rollupCircuitsDuration":271.2760139999882,"txCount":1,"blockNumber":9,"blockTimestamp":1750945652,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:17 [13:38:17.200] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:38:17 [13:38:17.218] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:38:17 [13:38:17.218] WARN: foundation:test-date-provider Time set to 2025-06-26T13:47:44.000Z {"offset":566782,"timeMs":1750945664000} 13:38:17 [13:38:17.302] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x284788e0cfa30d40a5184cd517172e76d1dcbaeab4856dccaf41b2c5ec60dd85","blockNumber":9,"txCount":1,"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":11,"timestamp":1750945652,"version":2424982324},"archiveRoot":"0x14931da8454bad90358d965ea3b530644d9fdbd77d4fae34dc089f5de49489d6","archiveNextLeafIndex":10} 13:38:17 [13:38:17.389] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3062541302288446171170371466885913903113 13:38:17 [13:38:17.390] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 13:38:17 [13:38:17.406] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945688 13:38:17 [13:38:17.406] WARN: foundation:test-date-provider Time set to 2025-06-26T13:48:08.000Z {"offset":590594,"timeMs":1750945688000} 13:38:17 [13:38:17.406] INFO: aztecjs:utils:watcher Slot 11 was filled, jumped to next slot 13:38:17 [13:38:17.536] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":8.540594999998575,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750945652,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:18 [13:38:17.821] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 13:38:18 Contract deployed at 0x133542b17bd201d910bda88be6810f2315cf371b97626fa307e500ac476c4f79 13:38:18 Contract partial address 0x2033079cbef5acd6d75525e393a9a857b1c1508d4735ab15411e543a27c3a5b8 13:38:18 Contract init hash 0x296e695c341d0270a4528d038645c0bbc49c8af83cdfebe386c6a8a08e108864 13:38:18 Deployment tx hash: 0x29cf6071e2e0d6f08bca95eb4ca45c35149676950bfad76f835e56e3e0f922f8 13:38:18 Deployment salt: 0x0afe24c86af5a6c7fd5c2efbe7f45ad6863956cfc9ac1b5f19cd5bef746faf1b 13:38:18 Deployment fee: 985953600 13:38:18 Contract stored in database with alias last 13:38:21 [13:38:21.568] INFO: wallet Using local PXE service 13:38:21 [13:38:21.570] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:38:21 [13:38:21.634] 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) 13:38:21 [13:38:21.648] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:38:22 13:38:22 New account: 13:38:22 13:38:22 Address: 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 13:38:22 Public key: 0x1918d9c66b2a12a39a20916f7f18bef9f7f55a9c1dbe4959a5f8674e64d126761ab38b9057f0c89c5ff0c3a998bf78a64a2cc0959346c7912459d1210a21be1d2e50f7563168ab677c8aa77ac038c2c2e71b541e9c9699634f59ecbb7ab539d613e628394e60bbbb0c046a35495a378c836a9222101080b415de8f847bda962f12841a9030550f35b329346c83114f8edd6528eca61b54c0d831fbeb7ed0af8f2e4a1464e16698f8a54f3a2036fa26810c1a706efd9cae45d679626545d21d2a149654e72882f3848f2c9c569747fbed5e4b0fb0c90984dc195ac82fa94b04f11e89663c97cd441eca29a99d55cc78574541a4034a5846acfcf9b7f1bc411f1b 13:38:22 Secret key: 0x29416f792092eb819af6de0ca4137424f69e9798c7f7f9aa919e0fb85e72f228 13:38:22 Partial address: 0x06870255314e44cb1ced8913c2d026e2617b06d02f36e20f0cd02e84cb3af025 13:38:22 Salt: 0x0000000000000000000000000000000000000000000000000000000000000000 13:38:22 Init hash: 0x1ec68d801603deff33b964f0103fbe046a110e476ff7316614fe76dbcba5e0c3 13:38:22 Deployer: 0x0000000000000000000000000000000000000000000000000000000000000000 13:38:22 Retrieved 1000000000000000000 fee juice for recipient 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8. Stack pointer 0 13:38:22 Using Fee Juice for fee payments with claim for 1000000000000000000 tokens 13:38:22 [13:38:22.337] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:38:22 [13:38:22.528] INFO: pxe:service Registered account 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 13:38:22 [13:38:22.660] INFO: pxe:service Added contract SchnorrAccount at 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 with class 0x24d1c5d426b69cb3ef25e506779048ee37990fc536ff19459ee8ea5144c3daaf 13:38:27 [13:38:26.975] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 3025.7233269999997ms 13:38:27 [13:38:26.975] INFO: pxe:bb:native Generating Client IVC proof 13:38:28 [13:38:28.030] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR/ivc-inputs.msgpack 13:38:28 [13:38:28.031] INFO: pxe:bb:native bb - BB concurrency: undefined 13:38:28 [13:38:28.031] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR/ivc-inputs.msgpack -v --scheme client_ivc 13:38:28 [13:38:28.053] INFO: pxe:bb:native bb - bb command: prove (mem: 143.98 MiB) 13:38:28 [13:38:28.053] INFO: pxe:bb:native bb - Scheme is: client_ivc, num threads: 128 (mem: 143.98 MiB) 13:38:28 --scheme: client_ivc (mem: 143.98 MiB) 13:38:28 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR (mem: 143.98 MiB) 13:38:28 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR/ivc-inputs.msgpack (mem: 143.98 MiB) 13:38:28 --verbose: true (mem: 143.98 MiB) 13:38:29 [13:38:29.020] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 157.73 MiB) 13:38:29 [13:38:29.020] INFO: pxe:bb:native bb - using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 157.73 MiB) 13:38:29 [13:38:29.067] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 157.73 MiB) 13:38:29 [13:38:29.078] INFO: pxe:bb:native bb - ClientIVC: accumulating MultiCallEntrypoint:entrypoint (mem: 157.73 MiB) 13:38:29 Constructing DeciderProvingKey (mem: 157.73 MiB) 13:38:29 [13:38:29.085] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 157.73 MiB) 13:38:29 goblin ecc op : 4/1024 (mem: 157.73 MiB) 13:38:29 busread : 742/6000 (mem: 157.73 MiB) 13:38:29 lookups : 2/15000 (mem: 157.73 MiB) 13:38:29 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 157.73 MiB) 13:38:29 arithmetic : 4296/56000 (mem: 157.73 MiB) 13:38:29 delta range : 2030/18000 (mem: 157.73 MiB) 13:38:29 elliptic : 2/6000 (mem: 157.73 MiB) 13:38:29 auxiliary : 2420/26000 (mem: 157.73 MiB) 13:38:29 poseidon ext : 82/17000 13:38:29 [13:38:29.085] INFO: pxe:bb:native bb - (mem: 157.73 MiB) 13:38:29 poseidon int : 458/92000 (mem: 157.73 MiB) 13:38:29 overflow : 0/0 (mem: 157.73 MiB) 13:38:29 (mem: 157.73 MiB) 13:38:29 Total structured size: 242025 (mem: 157.73 MiB) 13:38:29 allocating polynomials object in proving key... (mem: 157.73 MiB) 13:38:29 [13:38:29.240] INFO: pxe:bb:native bb - populating trace... (mem: 435.66 MiB) 13:38:29 [13:38:29.251] INFO: pxe:bb:native bb - time to construct proving key: 173 ms. (mem: 444.66 MiB) 13:38:29 getting honk vk... precomputed?: 0x61b947fbff80 (mem: 444.66 MiB) 13:38:29 [13:38:29.251] INFO: pxe:bb:native bb - computing oink proof... (mem: 444.66 MiB) 13:38:29 [13:38:29.252] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 444.66 MiB) 13:38:29 [13:38:29.365] INFO: pxe:bb:native bb - oink proof constructed (mem: 450.66 MiB) 13:38:29 [13:38:29.452] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000c6b6b8b72743108df931296b565be3f9 (mem: 453.66 MiB) 13:38:29 [13:38:29.470] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 457.66 MiB) 13:38:29 Constructing DeciderProvingKey (mem: 457.66 MiB) 13:38:29 [13:38:29.475] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 457.66 MiB) 13:38:29 goblin ecc op : 56/1024 (mem: 457.66 MiB) 13:38:29 busread : 2529/6000 (mem: 457.66 MiB) 13:38:29 lookups : 2/15000 (mem: 457.66 MiB) 13:38:29 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 457.66 MiB) 13:38:29 arithmetic : 21160/56000 (mem: 457.66 MiB) 13:38:29 [13:38:29.475] INFO: pxe:bb:native bb - delta range : 3041/18000 (mem: 457.66 MiB) 13:38:29 elliptic : 340/6000 (mem: 457.66 MiB) 13:38:29 auxiliary : 799/26000 (mem: 457.66 MiB) 13:38:29 poseidon ext : 2022/17000 (mem: 457.66 MiB) 13:38:29 poseidon int : 11516/92000 (mem: 457.66 MiB) 13:38:29 overflow : 0/0 (mem: 457.66 MiB) 13:38:29 (mem: 457.66 MiB) 13:38:29 Total structured size: 242025 (mem: 457.66 MiB) 13:38:29 allocating polynomials object in proving key... (mem: 457.66 MiB) 13:38:29 [13:38:29.576] INFO: pxe:bb:native bb - populating trace... (mem: 670.66 MiB) 13:38:29 [13:38:29.605] INFO: pxe:bb:native bb - time to construct proving key: 135 ms. (mem: 685.66 MiB) 13:38:29 getting honk vk... precomputed?: 0x61b948f265c0 (mem: 685.66 MiB) 13:38:29 computing folding proof (mem: 685.66 MiB) 13:38:29 [13:38:29.606] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 685.66 MiB) 13:38:30 [13:38:29.874] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 707.66 MiB) 13:38:30 [13:38:29.944] INFO: pxe:bb:native bb - perturbator round (mem: 736.66 MiB) 13:38:30 [13:38:29.999] INFO: pxe:bb:native bb - combiner quotient round (mem: 768.66 MiB) 13:38:30 [13:38:30.110] INFO: pxe:bb:native bb - folded (mem: 768.66 MiB) 13:38:30 constructed folding proof (mem: 768.66 MiB) 13:38:30 [13:38:30.267] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:constructor (mem: 768.66 MiB) 13:38:30 Constructing DeciderProvingKey (mem: 768.66 MiB) 13:38:30 [13:38:30.273] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 768.66 MiB) 13:38:30 goblin ecc op : 4/1024 (mem: 768.66 MiB) 13:38:30 busread : 742/6000 (mem: 768.66 MiB) 13:38:30 lookups : 12218/15000 (mem: 768.66 MiB) 13:38:30 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 768.66 MiB) 13:38:30 arithmetic : 15035/56000 (mem: 768.66 MiB) 13:38:30 delta range : 2476/18000 (mem: 768.66 MiB) 13:38:30 elliptic : 1008/6000 (mem: 768.66 MiB) 13:38:30 auxiliary : 899/26000 (mem: 768.66 MiB) 13:38:30 poseidon ext : 132/17000 (mem: 768.66 MiB) 13:38:30 poseidon int : 743/92000 (mem: 768.66 MiB) 13:38:30 overflow : 0/0 (mem: 768.66 MiB) 13:38:30 (mem: 768.66 MiB) 13:38:30 Total structured size: 242025 (mem: 768.66 MiB) 13:38:30 allocating polynomials object in proving key... (mem: 768.66 MiB) 13:38:30 [13:38:30.306] INFO: pxe:bb:native bb - populating trace... (mem: 768.66 MiB) 13:38:30 [13:38:30.342] INFO: pxe:bb:native bb - time to construct proving key: 70 ms. (mem: 768.66 MiB) 13:38:30 getting honk vk... precomputed?: 0x61b947f51f00 (mem: 768.66 MiB) 13:38:30 computing folding proof (mem: 768.66 MiB) 13:38:30 vkey hash in Oink prover: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 768.66 MiB) 13:38:30 [13:38:30.578] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 768.66 MiB) 13:38:30 [13:38:30.636] INFO: pxe:bb:native bb - perturbator round (mem: 768.66 MiB) 13:38:30 [13:38:30.687] INFO: pxe:bb:native bb - combiner quotient round (mem: 768.66 MiB) 13:38:30 [13:38:30.819] INFO: pxe:bb:native bb - folded (mem: 768.66 MiB) 13:38:30 constructed folding proof (mem: 768.66 MiB) 13:38:31 [13:38:30.984] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 768.66 MiB) 13:38:31 [13:38:31.046] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000650858527cea559e5b0b9315276121b8 (mem: 768.66 MiB) 13:38:31 [13:38:31.099] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 768.66 MiB) 13:38:31 Constructing DeciderProvingKey (mem: 768.66 MiB) 13:38:31 [13:38:31.105] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 768.66 MiB) 13:38:31 goblin ecc op : 792/1024 (mem: 768.66 MiB) 13:38:31 busread : 4184/6000 (mem: 768.66 MiB) 13:38:31 lookups : 2/15000 (mem: 768.66 MiB) 13:38:31 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 768.66 MiB) 13:38:31 arithmetic : 43824/56000 (mem: 768.66 MiB) 13:38:31 delta range : 5034/18000 (mem: 768.66 MiB) 13:38:31 elliptic : 340/6000 (mem: 768.66 MiB) 13:38:31 [13:38:31.106] INFO: pxe:bb:native bb - auxiliary : 1399/26000 (mem: 768.66 MiB) 13:38:31 poseidon ext : 5682/17000 (mem: 768.66 MiB) 13:38:31 poseidon int : 32378/92000 (mem: 768.66 MiB) 13:38:31 overflow : 0/0 (mem: 768.66 MiB) 13:38:31 (mem: 768.66 MiB) 13:38:31 Total structured size: 242025 (mem: 768.66 MiB) 13:38:31 allocating polynomials object in proving key... (mem: 768.66 MiB) 13:38:31 [13:38:31.142] INFO: pxe:bb:native bb - populating trace... (mem: 768.66 MiB) 13:38:31 [13:38:31.189] INFO: pxe:bb:native bb - time to construct proving key: 89 ms. (mem: 768.66 MiB) 13:38:31 getting honk vk... precomputed?: 0x61b9486d1f80 (mem: 768.66 MiB) 13:38:31 [13:38:31.189] INFO: pxe:bb:native bb - computing folding proof (mem: 768.66 MiB) 13:38:31 [13:38:31.190] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 768.66 MiB) 13:38:31 [13:38:31.470] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 768.66 MiB) 13:38:31 [13:38:31.534] INFO: pxe:bb:native bb - perturbator round (mem: 775.44 MiB) 13:38:31 [13:38:31.611] INFO: pxe:bb:native bb - combiner quotient round (mem: 807.44 MiB) 13:38:31 [13:38:31.794] INFO: pxe:bb:native bb - folded (mem: 807.44 MiB) 13:38:31 constructed folding proof (mem: 807.44 MiB) 13:38:32 [13:38:31.968] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 807.44 MiB) 13:38:32 Constructing DeciderProvingKey (mem: 807.44 MiB) 13:38:32 [13:38:31.978] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 807.44 MiB) 13:38:32 goblin ecc op : 4/1024 (mem: 807.44 MiB) 13:38:32 busread : 742/6000 (mem: 807.44 MiB) 13:38:32 lookups : 2076/15000 13:38:32 [13:38:31.978] INFO: pxe:bb:native bb - (mem: 807.44 MiB) 13:38:32 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 807.44 MiB) 13:38:32 arithmetic : 9353/56000 (mem: 807.44 MiB) 13:38:32 delta range : 2977/18000 (mem: 807.44 MiB) 13:38:32 elliptic : 794/6000 (mem: 807.44 MiB) 13:38:32 auxiliary : 4528/26000 (mem: 807.44 MiB) 13:38:32 poseidon ext : 312/17000 (mem: 807.44 MiB) 13:38:32 poseidon int : 1769/92000 (mem: 807.44 MiB) 13:38:32 overflow : 0/0 (mem: 807.44 MiB) 13:38:32 (mem: 807.44 MiB) 13:38:32 Total structured size: 242025 (mem: 807.44 MiB) 13:38:32 allocating polynomials object in proving key... (mem: 807.44 MiB) 13:38:32 [13:38:32.058] INFO: pxe:bb:native bb - populating trace... (mem: 807.44 MiB) 13:38:32 [13:38:32.084] INFO: pxe:bb:native bb - time to construct proving key: 115 ms. (mem: 807.44 MiB) 13:38:32 getting honk vk... precomputed?: 0x61b947f32300 (mem: 807.44 MiB) 13:38:32 computing folding proof (mem: 807.44 MiB) 13:38:32 [13:38:32.085] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 807.44 MiB) 13:38:32 [13:38:32.298] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 807.44 MiB) 13:38:32 [13:38:32.387] INFO: pxe:bb:native bb - perturbator round (mem: 807.44 MiB) 13:38:32 [13:38:32.427] INFO: pxe:bb:native bb - combiner quotient round (mem: 807.44 MiB) 13:38:32 [13:38:32.532] INFO: pxe:bb:native bb - folded (mem: 807.44 MiB) 13:38:32 constructed folding proof (mem: 807.44 MiB) 13:38:32 [13:38:32.695] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 807.44 MiB) 13:38:32 [13:38:32.750] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 807.44 MiB) 13:38:32 [13:38:32.794] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 807.44 MiB) 13:38:32 Constructing DeciderProvingKey (mem: 807.44 MiB) 13:38:32 [13:38:32.802] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 807.44 MiB) 13:38:32 goblin ecc op : 792/1024 (mem: 807.44 MiB) 13:38:32 busread : 4184/6000 (mem: 807.44 MiB) 13:38:32 lookups : 2/15000 (mem: 807.44 MiB) 13:38:32 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 807.44 MiB) 13:38:32 arithmetic : 43824/56000 (mem: 807.44 MiB) 13:38:32 delta range : 5034/18000 (mem: 807.44 MiB) 13:38:32 elliptic : 340/6000 (mem: 807.44 MiB) 13:38:32 auxiliary : 1399/26000 (mem: 807.44 MiB) 13:38:32 poseidon ext : 5682/17000 (mem: 807.44 MiB) 13:38:32 poseidon int : 32378/92000 (mem: 807.44 MiB) 13:38:32 overflow : 0/0 (mem: 807.44 MiB) 13:38:32 (mem: 807.44 MiB) 13:38:32 Total structured size: 242025 (mem: 807.44 MiB) 13:38:32 allocating polynomials object in proving key... (mem: 807.44 MiB) 13:38:32 [13:38:32.843] INFO: pxe:bb:native bb - populating trace... (mem: 807.44 MiB) 13:38:32 [13:38:32.884] INFO: pxe:bb:native bb - time to construct proving key: 90 ms. (mem: 807.44 MiB) 13:38:32 getting honk vk... precomputed?: 0x61b94aba5b80 (mem: 807.44 MiB) 13:38:32 computing folding proof (mem: 807.44 MiB) 13:38:32 [13:38:32.885] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 807.44 MiB) 13:38:33 [13:38:33.185] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 807.44 MiB) 13:38:33 [13:38:33.251] INFO: pxe:bb:native bb - perturbator round (mem: 807.44 MiB) 13:38:33 [13:38:33.314] INFO: pxe:bb:native bb - combiner quotient round (mem: 810.07 MiB) 13:38:33 [13:38:33.408] INFO: pxe:bb:native bb - folded (mem: 810.07 MiB) 13:38:33 constructed folding proof (mem: 810.07 MiB) 13:38:33 [13:38:33.591] INFO: pxe:bb:native bb - ClientIVC: accumulating FeeJuice:claim (mem: 810.07 MiB) 13:38:33 Constructing DeciderProvingKey (mem: 810.07 MiB) 13:38:33 [13:38:33.595] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 810.07 MiB) 13:38:33 goblin ecc op : 4/1024 (mem: 810.07 MiB) 13:38:33 busread : 742/6000 (mem: 13:38:33 [13:38:33.596] INFO: pxe:bb:native bb - 810.07 MiB) 13:38:33 lookups : 17378/15000 (mem: 810.07 MiB) 13:38:33 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 810.07 MiB) 13:38:33 arithmetic : 13735/56000 (mem: 810.07 MiB) 13:38:33 delta range : 2547/18000 (mem: 810.07 MiB) 13:38:33 elliptic : 2/6000 (mem: 810.07 MiB) 13:38:33 auxiliary : 26/26000 (mem: 810.07 MiB) 13:38:33 poseidon ext : 452/17000 (mem: 810.07 MiB) 13:38:33 poseidon int : 2567/92000 (mem: 810.07 MiB) 13:38:33 overflow : 0/0 (mem: 810.07 MiB) 13:38:33 (mem: 810.07 MiB) 13:38:33 Total structured size: 242025 (mem: 810.07 MiB) 13:38:33 [13:38:33.596] INFO: pxe:bb:native bb - WARNING: Structured trace overflow mechanism in use. Performance may be degraded! (mem: 810.07 MiB) 13:38:33 Gate blocks summary: (actual gates / fixed capacity) (mem: 810.07 MiB) 13:38:33 [13:38:33.596] INFO: pxe:bb:native bb - goblin ecc op : 4/1024 (mem: 810.07 MiB) 13:38:33 busread : 742/6000 (mem: 810.07 MiB) 13:38:33 lookups : 15000/15000 (mem: 810.07 MiB) 13:38:33 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 810.07 MiB) 13:38:33 arithmetic : 13735/56000 (mem: 810.07 MiB) 13:38:33 delta range : 2547/18000 (mem: 810.07 MiB) 13:38:33 elliptic : 2/6000 (mem: 810.07 MiB) 13:38:33 auxiliary : 26/26000 13:38:33 [13:38:33.597] INFO: pxe:bb:native bb - (mem: 810.07 MiB) 13:38:33 poseidon ext : 452/17000 (mem: 810.07 MiB) 13:38:33 poseidon int : 2567/92000 (mem: 810.07 MiB) 13:38:33 overflow : 2379/2379 (mem: 810.07 MiB) 13:38:33 (mem: 810.07 MiB) 13:38:33 Total structured size: 244404 (mem: 810.07 MiB) 13:38:33 allocating polynomials object in proving key... (mem: 13:38:33 [13:38:33.597] INFO: pxe:bb:native bb - 810.07 MiB) 13:38:33 [13:38:33.642] INFO: pxe:bb:native bb - populating trace... (mem: 924.88 MiB) 13:38:33 [13:38:33.696] INFO: pxe:bb:native bb - time to construct proving key: 104 ms. (mem: 924.88 MiB) 13:38:33 getting honk vk... precomputed?: 0x61b9486bf780 (mem: 924.88 MiB) 13:38:33 computing folding proof (mem: 924.88 MiB) 13:38:33 [13:38:33.697] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 924.88 MiB) 13:38:33 [13:38:33.909] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 942.88 MiB) 13:38:34 [13:38:33.990] INFO: pxe:bb:native bb - perturbator round (mem: 957.88 MiB) 13:38:34 [13:38:34.064] INFO: pxe:bb:native bb - combiner quotient round (mem: 989.88 MiB) 13:38:34 [13:38:34.171] INFO: pxe:bb:native bb - folded (mem: 989.88 MiB) 13:38:34 constructed folding proof (mem: 989.88 MiB) 13:38:34 [13:38:34.324] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 989.88 MiB) 13:38:34 [13:38:34.379] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000074305cf411877c8c4337a8da8aed2edf (mem: 989.88 MiB) 13:38:34 [13:38:34.422] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 989.88 MiB) 13:38:34 Constructing DeciderProvingKey (mem: 989.88 MiB) 13:38:34 [13:38:34.429] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 989.88 MiB) 13:38:34 goblin ecc op : 792/1024 (mem: 989.88 MiB) 13:38:34 busread : 4184/6000 (mem: 989.88 MiB) 13:38:34 lookups : 2/15000 (mem: 989.88 MiB) 13:38:34 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 989.88 MiB) 13:38:34 arithmetic : 43824/56000 (mem: 989.88 MiB) 13:38:34 [13:38:34.429] INFO: pxe:bb:native bb - delta range : 5034/18000 (mem: 989.88 MiB) 13:38:34 elliptic : 340/6000 (mem: 989.88 MiB) 13:38:34 auxiliary : 1399/26000 (mem: 989.88 MiB) 13:38:34 poseidon ext : 5682/17000 (mem: 989.88 MiB) 13:38:34 poseidon int : 32378/92000 (mem: 989.88 MiB) 13:38:34 overflow : 0/0 (mem: 989.88 MiB) 13:38:34 (mem: 989.88 MiB) 13:38:34 Total structured size: 242025 (mem: 989.88 MiB) 13:38:34 allocating polynomials object in proving key... (mem: 989.88 MiB) 13:38:34 [13:38:34.462] INFO: pxe:bb:native bb - populating trace... (mem: 989.88 MiB) 13:38:34 [13:38:34.498] INFO: pxe:bb:native bb - time to construct proving key: 75 ms. (mem: 989.88 MiB) 13:38:34 getting honk vk... precomputed?: 0x61b949d0c5c0 (mem: 989.88 MiB) 13:38:34 computing folding proof (mem: 989.88 MiB) 13:38:34 [13:38:34.498] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 989.88 MiB) 13:38:35 [13:38:34.878] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 989.88 MiB) 13:38:35 [13:38:34.976] INFO: pxe:bb:native bb - perturbator round (mem: 989.88 MiB) 13:38:35 [13:38:35.055] INFO: pxe:bb:native bb - combiner quotient round (mem: 1009.55 MiB) 13:38:35 [13:38:35.179] INFO: pxe:bb:native bb - folded (mem: 1009.55 MiB) 13:38:35 constructed folding proof (mem: 1009.55 MiB) 13:38:35 [13:38:35.391] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 1009.55 MiB) 13:38:35 [13:38:35.453] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 1009.55 MiB) 13:38:35 Constructing DeciderProvingKey (mem: 1009.55 MiB) 13:38:35 [13:38:35.465] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1009.55 MiB) 13:38:35 goblin ecc op : 392/1024 (mem: 1009.55 MiB) 13:38:35 busread : 2347/6000 (mem: 1009.55 MiB) 13:38:35 lookups : 2/15000 (mem: 1009.55 MiB) 13:38:35 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 1009.55 MiB) 13:38:35 arithmetic : 36211/56000 (mem: 1009.55 MiB) 13:38:35 delta range : 4306/18000 (mem: 1009.55 MiB) 13:38:35 elliptic : 1274/6000 (mem: 1009.55 MiB) 13:38:35 auxiliary : 12562/26000 (mem: 1009.55 MiB) 13:38:35 poseidon ext : 6112/17000 (mem: 1009.55 MiB) 13:38:35 poseidon int : 34829/92000 (mem: 1009.55 MiB) 13:38:35 overflow : 0/0 (mem: 1009.55 MiB) 13:38:35 (mem: 1009.55 MiB) 13:38:35 Total structured size: 242025 (mem: 1009.55 MiB) 13:38:35 allocating polynomials object in proving key... (mem: 1009.55 MiB) 13:38:35 [13:38:35.511] INFO: pxe:bb:native bb - populating trace... (mem: 1009.55 MiB) 13:38:35 [13:38:35.570] INFO: pxe:bb:native bb - time to construct proving key: 122 ms. (mem: 1009.55 MiB) 13:38:35 getting honk vk... precomputed?: 0x61b9499da180 (mem: 1009.55 MiB) 13:38:35 computing folding proof (mem: 1009.55 MiB) 13:38:35 [13:38:35.570] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 1009.55 MiB) 13:38:36 [13:38:35.901] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1009.55 MiB) 13:38:36 [13:38:35.977] INFO: pxe:bb:native bb - perturbator round (mem: 1011.27 MiB) 13:38:36 [13:38:36.042] INFO: pxe:bb:native bb - combiner quotient round (mem: 1043.27 MiB) 13:38:36 [13:38:36.162] INFO: pxe:bb:native bb - folded (mem: 1043.27 MiB) 13:38:36 [13:38:36.163] INFO: pxe:bb:native bb - constructed folding proof (mem: 1043.27 MiB) 13:38:36 [13:38:36.307] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 1043.27 MiB) 13:38:36 [13:38:36.356] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 1043.27 MiB) 13:38:36 Constructing DeciderProvingKey (mem: 1043.27 MiB) 13:38:36 [13:38:36.373] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 1043.27 MiB) 13:38:36 goblin ecc op : 392/1024 (mem: 1043.27 MiB) 13:38:36 busread : 231/6000 (mem: 1043.27 MiB) 13:38:36 [13:38:36.373] INFO: pxe:bb:native bb - lookups : 2/15000 (mem: 1043.27 MiB) 13:38:36 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 1043.27 MiB) 13:38:36 arithmetic : 32332/56000 (mem: 1043.27 MiB) 13:38:36 delta range : 4412/18000 (mem: 1043.27 MiB) 13:38:36 elliptic : 2/6000 (mem: 1043.27 MiB) 13:38:36 auxiliary : 11868/26000 (mem: 1043.27 MiB) 13:38:36 poseidon ext : 2552/17000 (mem: 1043.27 MiB) 13:38:36 poseidon int : 14537/92000 (mem: 1043.27 MiB) 13:38:36 overflow : 0/0 (mem: 1043.27 MiB) 13:38:36 (mem: 1043.27 MiB) 13:38:36 Total structured size: 242025 (mem: 1043.27 MiB) 13:38:36 allocating polynomials object in proving key... (mem: 1043.27 MiB) 13:38:36 [13:38:36.414] INFO: pxe:bb:native bb - populating trace... (mem: 1043.27 MiB) 13:38:36 [13:38:36.477] INFO: pxe:bb:native bb - time to construct proving key: 120 ms. (mem: 1043.27 MiB) 13:38:36 getting honk vk... precomputed?: 0x61b948108c80 (mem: 1043.27 MiB) 13:38:36 computing folding proof (mem: 1043.27 MiB) 13:38:36 [13:38:36.477] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 1043.27 MiB) 13:38:36 [13:38:36.750] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 1043.27 MiB) 13:38:36 [13:38:36.844] INFO: pxe:bb:native bb - perturbator round (mem: 1043.27 MiB) 13:38:36 [13:38:36.926] INFO: pxe:bb:native bb - combiner quotient round (mem: 1043.27 MiB) 13:38:37 [13:38:37.022] INFO: pxe:bb:native bb - folded (mem: 1043.27 MiB) 13:38:37 [13:38:37.023] INFO: pxe:bb:native bb - constructed folding proof (mem: 1043.27 MiB) 13:38:37 [13:38:37.129] INFO: pxe:bb:native bb - Largest circuit: 97643 gates. Trace details: (mem: 1043.27 MiB) 13:38:37 Minimum required block sizes for structured trace: (mem: 1043.27 MiB) 13:38:37 [13:38:37.129] INFO: pxe:bb:native bb - (mem: 1043.27 MiB) 13:38:37 prove decider... (mem: 1043.27 MiB) 13:38:37 [13:38:37.129] INFO: pxe:bb:native bb - ecc_op : 792 13:38:37 busread : 4184 13:38:37 lookup : 15000 13:38:37 pub_inputs : 1859 13:38:37 arithmetic : 43824 13:38:37 delta_range : 5034 13:38:37 elliptic : 1274 13:38:37 aux : 12562 13:38:37 poseidon2_external : 6112 13:38:37 poseidon2_internal : 34829 13:38:37 overflow : 2379 13:38:37 [13:38:37.260] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1043.27 MiB) 13:38:37 [13:38:37.383] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1043.27 MiB) 13:38:38 [13:38:38.097] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1043.27 MiB) 13:38:38 [13:38:38.220] INFO: pxe:bb:native bb - computed opening proof (mem: 1043.27 MiB) 13:38:38 finished decider proving. (mem: 1043.27 MiB) 13:38:38 [13:38:38.231] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 1043.27 MiB) 13:38:38 [13:38:38.450] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 1043.27 MiB) 13:38:38 [13:38:38.456] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 1043.27 MiB) 13:38:38 [13:38:38.585] INFO: pxe:bb:native bb - populating trace... (mem: 1043.27 MiB) 13:38:38 [13:38:38.642] INFO: pxe:bb:native bb - time to construct proving key: 191 ms. (mem: 1043.27 MiB) 13:38:39 [13:38:39.079] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 1043.27 MiB) 13:38:39 [13:38:39.311] INFO: pxe:bb:native bb - created oink proof (mem: 1043.27 MiB) 13:38:39 [13:38:39.435] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1043.27 MiB) 13:38:39 [13:38:39.821] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 1043.27 MiB) 13:38:40 [13:38:40.261] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 1043.27 MiB) 13:38:40 [13:38:40.309] INFO: pxe:bb:native bb - computed opening proof (mem: 1043.27 MiB) 13:38:40 finished decider proving. (mem: 1043.27 MiB) 13:38:40 [13:38:40.309] INFO: pxe:bb:native bb - 13:38:40 [13:38:40.309] INFO: pxe:bb:native bb - Constructing a Goblin proof with num ultra ops = 3818 (mem: 1043.27 MiB) 13:38:40 [13:38:40.406] INFO: pxe:bb:native bb - prove eccvm... (mem: 1043.27 MiB) 13:38:40 [13:38:40.757] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 1043.27 MiB) 13:38:40 [13:38:40.765] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 1043.27 MiB) 13:38:42 [13:38:41.619] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1043.27 MiB) 13:38:43 [13:38:42.597] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 1043.27 MiB) 13:38:45 [13:38:44.658] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 1043.27 MiB) 13:38:45 prove translator... (mem: 1043.27 MiB) 13:38:45 [13:38:45.509] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 1054.35 MiB) 13:38:46 [13:38:46.492] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 1055.35 MiB) 13:38:47 [13:38:47.672] INFO: pxe:bb:native bb - computed opening proof (mem: 1055.35 MiB) 13:38:47 finished translator proving. (mem: 1055.35 MiB) 13:38:47 [13:38:47.672] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 1055.35 MiB) 13:38:47 [13:38:47.696] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 1055.35 MiB) 13:38:47 libra_evals_verified: 1 (mem: 1055.35 MiB) 13:38:47 pairing_check_verified: 1 (mem: 1055.35 MiB) 13:38:47 [13:38:47.697] INFO: pxe:bb:native bb - Mega verified: 1 (mem: 1055.35 MiB) 13:38:47 [13:38:47.778] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 1055.35 MiB) 13:38:47 batch opening verified?: 1 (mem: 1055.35 MiB) 13:38:47 eccvm consistency check verified?: 1 (mem: 1055.35 MiB) 13:38:47 translation masking consistency checked?: 1 (mem: 1055.35 MiB) 13:38:47 [13:38:47.797] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 1056.35 MiB) 13:38:47 eccvm verified?: 1 (mem: 1056.35 MiB) 13:38:47 accumulator construction_verified?: 1 (mem: 1056.35 MiB) 13:38:47 translation verified?: 1 (mem: 1056.35 MiB) 13:38:47 consistency verified?: 1 13:38:47 [13:38:47.797] INFO: pxe:bb:native bb - (mem: 1056.35 MiB) 13:38:47 Goblin verified: 1 (mem: 1056.35 MiB) 13:38:47 writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-Jz7qHR" (mem: 1056.35 MiB) 13:38:48 [13:38:48.002] INFO: pxe:bb:native Generated IVC proof {"duration":19970.158959,"eventName":"circuit-proving"} 13:38:48 [13:38:48.006] INFO: pxe:service Proving completed in 25262.993731000002ms {"timings":{"total":25262.993731000002,"sync":67.60200900000018,"proving":21030.065795000002,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":137.728928,"oracles":{"callPrivateFunction":{"times":[499.554384,525.6229189999999]}}},{"functionName":"private_kernel_init","time":262.2605789999998},{"functionName":"SchnorrAccount:constructor","time":478.42668499999945,"oracles":{"getContractInstance":{"times":[10.597684999999728]},"debugLog":{"times":[0.7064540000001216,0.14349300000003495]},"fetchTaggedLogs":{"times":[222.74094400000013]},"loadCapsule":{"times":[0.4586690000000999,0.23664400000006935,0.2973259999998845,0.38753700000006575,0.3082970000000387,0.2490549999997711]},"bulkRetrieveLogs":{"times":[7.294880999999805]},"validateEnqueuedNotesAndEvents":{"times":[6.656827999999678]},"notifyCreatedNullifier":{"times":[0.5416000000000167,0.35104599999976926]},"notifyCreatedNote":{"times":[0.4242080000003625]},"getRandomField":{"times":[0.44252800000003845,0.3350669999999809,0.09215099999983067,0.06911099999979342,0.2215439999999944,0.07701199999974051,0.06402099999968414,0.06281100000023798,0.09967200000028242,0.08971199999996315,0.05418099999997139]},"getIndexedTaggingSecretAsSender":{"times":[33.658162000000175]},"incrementAppTaggingSecretIndexAsSender":{"times":[16.507900000000063]}}},{"functionName":"private_kernel_inner","time":488.70104399999946},{"functionName":"SchnorrAccount:entrypoint","time":359.72659699999986,"oracles":{"debugLog":{"times":[0.21884399999999005,0.18827299999975367,0.35854699999981676]},"fetchTaggedLogs":{"times":[193.10943999999972]},"loadCapsule":{"times":[0.37689700000009907,0.25980500000014217,0.3941469999999754,0.45617900000024747,0.4222479999998541,0.2709949999998571]},"bulkRetrieveLogs":{"times":[7.485204999999951]},"validateEnqueuedNotesAndEvents":{"times":[5.489567000000079]},"getNotes":{"times":[5.613809000000401]},"getAuthWitness":{"times":[0.6713729999996758]},"callPrivateFunction":{"times":[162.18150100000003]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.269743999999264]}}},{"functionName":"private_kernel_inner","time":520.5984119999994},{"functionName":"FeeJuice:claim","time":151.585775,"oracles":{"getL1ToL2MembershipWitness":{"times":[30.422909999999774]},"notifyCreatedNullifier":{"times":[0.32881700000007186]},"storeInExecutionCache":{"times":[0.16848299999992378]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2583349999999882]}}},{"functionName":"private_kernel_inner","time":474.94663800000035},{"functionName":"private_kernel_reset","time":459.320025},{"functionName":"private_kernel_tail","time":430.6826920000003}],"unaccounted":401.3485519999995}} 13:38:48 13:38:48 Waiting for account contract deployment... 13:38:48 [13:38:48.124] INFO: node Received tx 0x03bafd7fd35be602613de4f052ca0882efc30293aff50ed660d92127bee246f8 {"txHash":"0x03bafd7fd35be602613de4f052ca0882efc30293aff50ed660d92127bee246f8"} 13:38:48 [13:38:48.126] INFO: pxe:service Sent transaction 0x03bafd7fd35be602613de4f052ca0882efc30293aff50ed660d92127bee246f8 13:38:54 [13:38:53.479] WARN: aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time 13:38:54 [13:38:53.483] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945725 13:38:54 [13:38:53.685] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:38:54 [13:38:53.685] WARN: foundation:test-date-provider Time set to 2025-06-26T13:48:45.000Z {"offset":591315,"timeMs":1750945725000} 13:38:54 [13:38:54.139] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08221080000000075s {"duration":0.08221080000000075,"rate":173018.63015564706,"totalPublicGas":{"daGas":1024,"l2Gas":14224},"totalBlockGas":{"daGas":13312,"l2Gas":40548},"totalSizeInBytes":1024} 13:38:54 [13:38:54.172] INFO: sequencer Built block 10 for slot 13 with 1 txs and 0 messages. 113941.64092432709 mana/s {"blockHash":"0x175be2c0f1363176bd4214bee8572d7766d253ab0ec5f2c1e42c44ae10c4c661","globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750945724,"version":2424982324},"txHashes":["0x03bafd7fd35be602613de4f052ca0882efc30293aff50ed660d92127bee246f8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":124.75497399999585,"publicProcessDuration":82.42430499999318,"rollupCircuitsDuration":116.89378600000055,"txCount":1,"blockNumber":10,"blockTimestamp":1750945724,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:54 [13:38:54.394] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:38:54 [13:38:54.430] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945760 13:38:54 [13:38:54.430] WARN: foundation:test-date-provider Time set to 2025-06-26T13:49:20.000Z {"offset":625570,"timeMs":1750945760000} 13:38:54 [13:38:54.430] INFO: aztecjs:utils:watcher Slot 13 was filled, jumped to next slot 13:38:54 [13:38:54.584] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3402823669209384634633746074317682114570 13:38:54 [13:38:54.585] INFO: aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10. 13:38:55 [13:38:54.919] INFO: archiver Downloaded L2 block 10 {"blockHash":"0x175be2c0f1363176bd4214bee8572d7766d253ab0ec5f2c1e42c44ae10c4c661","blockNumber":10,"txCount":1,"globalVariables":{"blockNumber":10,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":13,"timestamp":1750945724,"version":2424982324},"archiveRoot":"0x0800d2022bdc181690a8b227ada1e112d800901ec62f1e585a332333f33d210a","archiveNextLeafIndex":11} 13:38:55 [13:38:54.920] INFO: archiver Updated proven chain to block 10 {"provenBlockNumber":10} 13:38:55 Deploy tx hash: 0x03bafd7fd35be602613de4f052ca0882efc30293aff50ed660d92127bee246f8 13:38:55 Deploy tx fee: 117589200 13:38:55 [13:38:55.253] INFO: world_state World state updated with L2 block 10 {"eventName":"l2-block-handled","duration":20.00211100000888,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1750945724,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:38:59 [13:38:59.212] INFO: wallet Using local PXE service 13:38:59 [13:38:59.213] INFO: kv-store:lmdb-v2 Starting data store with maxReaders 16 13:38:59 [13:38:59.264] 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) 13:38:59 [13:38:59.266] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:39:00 [13:38:59.926] INFO: pxe:service Started PXE connected to chain 31337 version 2424982324 13:39:00 [13:38:59.978] INFO: wallet Using wallet with address 0x231f7b3e1598c5509089fbe357db3a0efd6da1cbe2e8f5bc979839219c4404b8 13:39:01 [13:39:01.190] INFO: pxe:service Added contract Token at 0x078c084815bda0acdd5823f0c919f2821e16961682048b81a03f179bbddf188a with class 0x02c7fef7a7ea5633921e7097b26192b5ddf7c8a63568e08cf5aac878e5ec5ee3 13:39:04 [13:39:03.952] INFO: pxe:private-kernel-execution-prover Private kernel witness generation took 2082.43307ms 13:39:04 [13:39:03.952] INFO: pxe:bb:native Generating Client IVC proof 13:39:04 [13:39:04.846] INFO: pxe:bb:native inputsPath /home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv/ivc-inputs.msgpack 13:39:04 [13:39:04.847] INFO: pxe:bb:native bb - BB concurrency: undefined 13:39:04 [13:39:04.847] INFO: pxe:bb:native bb - Executing BB with: /usr/src/barretenberg/cpp/build/bin/bb prove -o /home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv --ivc_inputs_path /home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv/ivc-inputs.msgpack -v --scheme client_ivc 13:39:04 [13:39:04.872] INFO: pxe:bb:native bb - bb command: prove (mem: 13:39:04 [13:39:04.872] INFO: pxe:bb:native bb - 179.26 MiB) 13:39:04 Scheme is: client_ivc, num threads: 128 (mem: 179.26 MiB) 13:39:04 --scheme: client_ivc (mem: 179.26 MiB) 13:39:04 --output_path: /home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv (mem: 179.26 MiB) 13:39:04 --ivc_inputs_path: /home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv/ivc-inputs.msgpack (mem: 179.26 MiB) 13:39:04 --verbose: true (mem: 179.26 MiB) 13:39:05 [13:39:05.512] INFO: pxe:bb:native bb - BN254 commitment key size: 262144 (mem: 179.26 MiB) 13:39:05 using cached bn254 crs with num points 33554433 at "/home/ubuntu/.bb-crs/bn254_g1.dat" (mem: 179.26 MiB) 13:39:05 [13:39:05.554] INFO: pxe:bb:native bb - Initialized BN254 CRS from memory with num points = 262145 (mem: 179.26 MiB) 13:39:05 [13:39:05.601] INFO: pxe:bb:native bb - ClientIVC: accumulating SchnorrAccount:entrypoint (mem: 179.26 MiB) 13:39:05 Constructing DeciderProvingKey (mem: 179.26 MiB) 13:39:05 [13:39:05.607] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 179.26 MiB) 13:39:05 goblin ecc op : 4/1024 (mem: 179.26 MiB) 13:39:05 busread : 742/6000 (mem: 179.26 MiB) 13:39:05 lookups : 2076/15000 (mem: 179.26 MiB) 13:39:05 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 179.26 MiB) 13:39:05 arithmetic : 9353/56000 (mem: 179.26 MiB) 13:39:05 [13:39:05.607] INFO: pxe:bb:native bb - delta range : 2977/18000 (mem: 179.26 MiB) 13:39:05 elliptic : 794/6000 (mem: 179.26 MiB) 13:39:05 auxiliary : 4528/26000 (mem: 179.26 MiB) 13:39:05 poseidon ext : 312/17000 (mem: 179.26 MiB) 13:39:05 poseidon int : 1769/92000 (mem: 179.26 MiB) 13:39:05 overflow : 0/0 (mem: 179.26 MiB) 13:39:05 (mem: 179.26 MiB) 13:39:05 Total structured size: 242025 (mem: 179.26 MiB) 13:39:05 allocating polynomials object in proving key... (mem: 179.26 MiB) 13:39:05 [13:39:05.723] INFO: pxe:bb:native bb - populating trace... (mem: 430.45 MiB) 13:39:05 [13:39:05.754] INFO: pxe:bb:native bb - time to construct proving key: 152 ms. (mem: 445.45 MiB) 13:39:05 getting honk vk... precomputed?: 0x587c719eb340 (mem: 445.45 MiB) 13:39:05 [13:39:05.754] INFO: pxe:bb:native bb - computing oink proof... (mem: 445.45 MiB) 13:39:05 [13:39:05.755] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 445.45 MiB) 13:39:05 [13:39:05.917] INFO: pxe:bb:native bb - oink proof constructed (mem: 473.45 MiB) 13:39:06 [13:39:05.994] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000425c4da6a7e56b4ff44b3ec1272579c0 (mem: 473.45 MiB) 13:39:06 [13:39:06.005] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_init (mem: 473.45 MiB) 13:39:06 Constructing DeciderProvingKey (mem: 473.45 MiB) 13:39:06 [13:39:06.008] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 473.45 MiB) 13:39:06 goblin ecc op : 56/1024 (mem: 473.45 MiB) 13:39:06 busread : 2529/6000 (mem: 473.45 MiB) 13:39:06 lookups : 2/15000 (mem: 473.45 MiB) 13:39:06 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 473.45 MiB) 13:39:06 arithmetic : 21160/56000 (mem: 473.45 MiB) 13:39:06 delta range : 3041/18000 (mem: 13:39:06 [13:39:06.009] INFO: pxe:bb:native bb - 473.45 MiB) 13:39:06 elliptic : 340/6000 (mem: 473.45 MiB) 13:39:06 auxiliary : 799/26000 (mem: 473.45 MiB) 13:39:06 poseidon ext : 2022/17000 (mem: 473.45 MiB) 13:39:06 poseidon int : 11516/92000 (mem: 473.45 MiB) 13:39:06 overflow : 0/0 (mem: 473.45 MiB) 13:39:06 (mem: 473.45 MiB) 13:39:06 Total structured size: 242025 (mem: 473.45 MiB) 13:39:06 allocating polynomials object in proving key... (mem: 473.45 MiB) 13:39:06 [13:39:06.053] INFO: pxe:bb:native bb - populating trace... (mem: 682.45 MiB) 13:39:06 [13:39:06.082] INFO: pxe:bb:native bb - time to construct proving key: 77 ms. (mem: 700.45 MiB) 13:39:06 getting honk vk... precomputed?: 0x587c72028a40 (mem: 700.45 MiB) 13:39:06 [13:39:06.082] INFO: pxe:bb:native bb - computing folding proof (mem: 700.45 MiB) 13:39:06 [13:39:06.083] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 700.45 MiB) 13:39:06 [13:39:06.240] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 700.45 MiB) 13:39:06 [13:39:06.315] INFO: pxe:bb:native bb - perturbator round (mem: 730.45 MiB) 13:39:06 [13:39:06.361] INFO: pxe:bb:native bb - combiner quotient round (mem: 764.45 MiB) 13:39:06 [13:39:06.428] INFO: pxe:bb:native bb - folded (mem: 764.45 MiB) 13:39:06 constructed folding proof (mem: 764.45 MiB) 13:39:06 [13:39:06.489] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractInstanceDeployer:deploy (mem: 764.45 MiB) 13:39:06 Constructing DeciderProvingKey (mem: 764.45 MiB) 13:39:06 [13:39:06.492] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 764.45 MiB) 13:39:06 goblin ecc op : 4/1024 (mem: 764.45 MiB) 13:39:06 [13:39:06.493] INFO: pxe:bb:native bb - busread : 742/6000 (mem: 764.45 MiB) 13:39:06 lookups : 2/15000 (mem: 764.45 MiB) 13:39:06 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 764.45 MiB) 13:39:06 arithmetic : 3656/56000 (mem: 764.45 MiB) 13:39:06 delta range : 1838/18000 (mem: 764.45 MiB) 13:39:06 elliptic : 340/6000 (mem: 764.45 MiB) 13:39:06 auxiliary : 187/26000 (mem: 764.45 MiB) 13:39:06 poseidon ext : 162/17000 (mem: 764.45 MiB) 13:39:06 poseidon int : 914/92000 (mem: 764.45 MiB) 13:39:06 overflow : 0/0 (mem: 764.45 MiB) 13:39:06 (mem: 764.45 MiB) 13:39:06 Total structured size: 242025 (mem: 764.45 13:39:06 [13:39:06.493] INFO: pxe:bb:native bb - MiB) 13:39:06 allocating polynomials object in proving key... (mem: 764.45 MiB) 13:39:06 [13:39:06.521] INFO: pxe:bb:native bb - populating trace... (mem: 764.45 MiB) 13:39:06 [13:39:06.529] INFO: pxe:bb:native bb - time to construct proving key: 39 ms. (mem: 764.45 MiB) 13:39:06 getting honk vk... precomputed?: 0x587c71a10400 (mem: 764.45 MiB) 13:39:06 computing folding proof (mem: 764.45 MiB) 13:39:06 [13:39:06.529] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 764.45 MiB) 13:39:06 [13:39:06.629] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 764.45 MiB) 13:39:06 [13:39:06.712] INFO: pxe:bb:native bb - perturbator round (mem: 764.45 MiB) 13:39:06 [13:39:06.764] INFO: pxe:bb:native bb - combiner quotient round (mem: 764.87 MiB) 13:39:06 [13:39:06.865] INFO: pxe:bb:native bb - folded (mem: 764.87 MiB) 13:39:06 [13:39:06.865] INFO: pxe:bb:native bb - constructed folding proof (mem: 764.87 MiB) 13:39:07 [13:39:07.008] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x000000000000000000000000000000003e4c135593b014880f63d8fe4a9fcad5 (mem: 764.87 MiB) 13:39:07 [13:39:07.081] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d0f9e87ab5f556ed788ba45ab88ade3a (mem: 764.87 MiB) 13:39:07 [13:39:07.135] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 764.87 MiB) 13:39:07 Constructing DeciderProvingKey (mem: 764.87 MiB) 13:39:07 [13:39:07.144] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 764.87 MiB) 13:39:07 goblin ecc op : 792/1024 (mem: 764.87 MiB) 13:39:07 busread : 4184/6000 (mem: 764.87 MiB) 13:39:07 lookups : 2/15000 (mem: 764.87 13:39:07 [13:39:07.144] INFO: pxe:bb:native bb - MiB) 13:39:07 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 764.87 MiB) 13:39:07 arithmetic : 43824/56000 (mem: 764.87 MiB) 13:39:07 delta range : 5034/18000 (mem: 764.87 MiB) 13:39:07 elliptic : 340/6000 (mem: 764.87 MiB) 13:39:07 auxiliary : 1399/26000 (mem: 764.87 MiB) 13:39:07 poseidon ext : 5682/17000 (mem: 764.87 MiB) 13:39:07 poseidon int : 32378/92000 (mem: 764.87 MiB) 13:39:07 overflow : 0/0 (mem: 764.87 MiB) 13:39:07 (mem: 764.87 MiB) 13:39:07 Total structured size: 242025 (mem: 764.87 MiB) 13:39:07 allocating polynomials object in proving key... (mem: 764.87 MiB) 13:39:07 [13:39:07.174] INFO: pxe:bb:native bb - populating trace... (mem: 764.87 MiB) 13:39:07 [13:39:07.219] INFO: pxe:bb:native bb - time to construct proving key: 84 ms. (mem: 764.87 MiB) 13:39:07 getting honk vk... precomputed?: 0x587c720b1580 (mem: 764.87 MiB) 13:39:07 computing folding proof (mem: 764.87 MiB) 13:39:07 [13:39:07.220] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 764.87 MiB) 13:39:07 [13:39:07.434] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 764.87 MiB) 13:39:07 [13:39:07.501] INFO: pxe:bb:native bb - perturbator round (mem: 764.87 MiB) 13:39:07 [13:39:07.586] INFO: pxe:bb:native bb - combiner quotient round (mem: 792.36 MiB) 13:39:07 [13:39:07.698] INFO: pxe:bb:native bb - folded (mem: 792.36 MiB) 13:39:07 constructed folding proof (mem: 792.36 MiB) 13:39:07 [13:39:07.762] INFO: pxe:bb:native bb - ClientIVC: accumulating ContractClassRegisterer:assert_class_id_is_registered (mem: 792.36 MiB) 13:39:07 Constructing DeciderProvingKey (mem: 792.36 MiB) 13:39:07 [13:39:07.764] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 792.36 MiB) 13:39:07 goblin ecc op : 4/1024 (mem: 792.36 MiB) 13:39:07 busread : 742/6000 (mem: 792.36 MiB) 13:39:07 lookups : 2/15000 (mem: 792.36 MiB) 13:39:07 pub inputs : 16/5000 (populated in decider pk constructor) (mem: 792.36 MiB) 13:39:07 arithmetic : 3287/56000 (mem: 792.36 MiB) 13:39:07 delta range : 1787/18000 (mem: 792.36 MiB) 13:39:07 elliptic : 2/6000 (mem: 792.36 MiB) 13:39:07 auxiliary : 26/26000 (mem: 792.36 MiB) 13:39:07 [13:39:07.765] INFO: pxe:bb:native bb - poseidon ext : 12/17000 (mem: 792.36 MiB) 13:39:07 poseidon int : 59/92000 (mem: 792.36 MiB) 13:39:07 overflow : 0/0 (mem: 792.36 MiB) 13:39:07 (mem: 792.36 MiB) 13:39:07 Total structured size: 242025 (mem: 792.36 MiB) 13:39:07 allocating polynomials object in proving key... (mem: 792.36 MiB) 13:39:07 [13:39:07.796] INFO: pxe:bb:native bb - populating trace... (mem: 792.36 MiB) 13:39:07 [13:39:07.805] INFO: pxe:bb:native bb - time to construct proving key: 43 ms. (mem: 792.36 MiB) 13:39:07 getting honk vk... precomputed?: 0x587c717d3ac0 (mem: 792.36 MiB) 13:39:07 computing folding proof (mem: 792.36 MiB) 13:39:07 [13:39:07.806] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 792.36 MiB) 13:39:07 [13:39:07.893] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 792.36 MiB) 13:39:07 [13:39:07.962] INFO: pxe:bb:native bb - perturbator round (mem: 792.36 MiB) 13:39:08 [13:39:08.010] INFO: pxe:bb:native bb - combiner quotient round (mem: 792.36 MiB) 13:39:08 [13:39:08.108] INFO: pxe:bb:native bb - folded (mem: 792.36 MiB) 13:39:08 constructed folding proof (mem: 792.36 MiB) 13:39:08 [13:39:08.266] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 792.36 MiB) 13:39:08 [13:39:08.334] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000089e9a733905917949daf0c71c2b6c009 (mem: 792.36 MiB) 13:39:08 [13:39:08.394] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_inner (mem: 792.36 MiB) 13:39:08 Constructing DeciderProvingKey (mem: 792.36 MiB) 13:39:08 [13:39:08.400] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 792.36 MiB) 13:39:08 goblin ecc op : 792/1024 (mem: 792.36 MiB) 13:39:08 busread : 4184/6000 (mem: 792.36 MiB) 13:39:08 lookups : 2/15000 (mem: 792.36 MiB) 13:39:08 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 792.36 MiB) 13:39:08 arithmetic : 43824/56000 (mem: 792.36 MiB) 13:39:08 delta range : 5034/18000 (mem: 792.36 MiB) 13:39:08 elliptic : 340/6000 (mem: 792.36 MiB) 13:39:08 [13:39:08.401] INFO: pxe:bb:native bb - auxiliary : 1399/26000 (mem: 792.36 MiB) 13:39:08 poseidon ext : 5682/17000 (mem: 792.36 MiB) 13:39:08 poseidon int : 32378/92000 (mem: 792.36 MiB) 13:39:08 overflow : 0/0 (mem: 792.36 MiB) 13:39:08 (mem: 792.36 MiB) 13:39:08 Total structured size: 242025 (mem: 792.36 MiB) 13:39:08 allocating polynomials object in proving key... (mem: 792.36 MiB) 13:39:08 [13:39:08.453] INFO: pxe:bb:native bb - populating trace... (mem: 792.36 MiB) 13:39:08 [13:39:08.498] INFO: pxe:bb:native bb - time to construct proving key: 104 ms. (mem: 792.36 MiB) 13:39:08 getting honk vk... precomputed?: 0x587c720b2340 (mem: 792.36 MiB) 13:39:08 computing folding proof (mem: 792.36 MiB) 13:39:08 [13:39:08.499] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 792.36 MiB) 13:39:08 [13:39:08.754] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 792.36 MiB) 13:39:08 [13:39:08.825] INFO: pxe:bb:native bb - perturbator round (mem: 792.36 MiB) 13:39:08 [13:39:08.888] INFO: pxe:bb:native bb - combiner quotient round (mem: 792.51 MiB) 13:39:09 [13:39:08.977] INFO: pxe:bb:native bb - folded (mem: 792.51 MiB) 13:39:09 constructed folding proof (mem: 792.51 MiB) 13:39:09 [13:39:09.183] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x0000000000000000000000000000000053f9bf3438049c3193b960021e202ce0 (mem: 792.51 MiB) 13:39:09 [13:39:09.248] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_reset (mem: 792.51 MiB) 13:39:09 Constructing DeciderProvingKey (mem: 792.51 MiB) 13:39:09 [13:39:09.266] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 792.51 MiB) 13:39:09 goblin ecc op : 392/1024 (mem: 792.51 MiB) 13:39:09 busread : 2347/6000 (mem: 792.51 MiB) 13:39:09 lookups : 2/15000 (mem: 792.51 MiB) 13:39:09 pub inputs : 32/5000 (populated in decider pk constructor) (mem: 792.51 MiB) 13:39:09 arithmetic : 36211/56000 (mem: 792.51 MiB) 13:39:09 delta range : 4306/18000 (mem: 792.51 MiB) 13:39:09 [13:39:09.266] INFO: pxe:bb:native bb - elliptic : 1274/6000 (mem: 792.51 MiB) 13:39:09 auxiliary : 12562/26000 (mem: 792.51 MiB) 13:39:09 poseidon ext : 6112/17000 (mem: 792.51 MiB) 13:39:09 poseidon int : 34829/92000 (mem: 792.51 MiB) 13:39:09 overflow : 0/0 (mem: 792.51 MiB) 13:39:09 (mem: 792.51 MiB) 13:39:09 Total structured size: 242025 (mem: 792.51 MiB) 13:39:09 allocating polynomials object in proving key... (mem: 792.51 MiB) 13:39:09 [13:39:09.315] INFO: pxe:bb:native bb - populating trace... (mem: 792.51 MiB) 13:39:09 [13:39:09.372] INFO: pxe:bb:native bb - time to construct proving key: 123 ms. (mem: 792.51 MiB) 13:39:09 getting honk vk... precomputed?: 0x587c72e7fac0 (mem: 792.51 MiB) 13:39:09 computing folding proof (mem: 792.51 MiB) 13:39:09 [13:39:09.372] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 792.51 MiB) 13:39:09 [13:39:09.712] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 792.51 MiB) 13:39:09 [13:39:09.799] INFO: pxe:bb:native bb - perturbator round (mem: 794.10 MiB) 13:39:09 [13:39:09.893] INFO: pxe:bb:native bb - combiner quotient round (mem: 826.10 MiB) 13:39:10 [13:39:10.001] INFO: pxe:bb:native bb - folded (mem: 826.10 MiB) 13:39:10 constructed folding proof (mem: 826.10 MiB) 13:39:10 [13:39:10.168] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000cda169831abb6aca766b838e9b768b49 (mem: 826.10 MiB) 13:39:10 [13:39:10.223] INFO: pxe:bb:native bb - ClientIVC: accumulating private_kernel_tail (mem: 826.10 MiB) 13:39:10 Constructing DeciderProvingKey (mem: 826.10 MiB) 13:39:10 [13:39:10.248] INFO: pxe:bb:native bb - Gate blocks summary: (actual gates / fixed capacity) (mem: 826.10 MiB) 13:39:10 goblin ecc op : 392/1024 (mem: 826.10 MiB) 13:39:10 busread : 231/6000 (mem: 826.10 MiB) 13:39:10 lookups : 2/15000 (mem: 826.10 MiB) 13:39:10 pub inputs : 1859/5000 (populated in decider pk constructor) (mem: 826.10 MiB) 13:39:10 arithmetic : 32332/56000 (mem: 826.10 MiB) 13:39:10 delta range : 4412/18000 (mem: 826.10 MiB) 13:39:10 elliptic : 2/6000 (mem: 826.10 MiB) 13:39:10 auxiliary : 11868/26000 (mem: 826.10 MiB) 13:39:10 poseidon ext : 2552/17000 (mem: 826.10 MiB) 13:39:10 poseidon int : 14537/92000 (mem: 826.10 MiB) 13:39:10 overflow : 0/0 (mem: 826.10 MiB) 13:39:10 (mem: 826.10 MiB) 13:39:10 Total structured size: 242025 (mem: 826.10 MiB) 13:39:10 allocating polynomials object in proving key... (mem: 826.10 MiB) 13:39:10 [13:39:10.293] INFO: pxe:bb:native bb - populating trace... (mem: 826.10 MiB) 13:39:10 [13:39:10.324] INFO: pxe:bb:native bb - time to construct proving key: 100 ms. (mem: 826.10 MiB) 13:39:10 getting honk vk... precomputed?: 0x587c72f679c0 (mem: 826.10 MiB) 13:39:10 computing folding proof (mem: 826.10 MiB) 13:39:10 [13:39:10.324] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 826.10 MiB) 13:39:10 [13:39:10.583] INFO: pxe:bb:native bb - oink prover on each incomplete key (mem: 826.10 MiB) 13:39:10 [13:39:10.652] INFO: pxe:bb:native bb - perturbator round (mem: 826.10 MiB) 13:39:10 [13:39:10.693] INFO: pxe:bb:native bb - combiner quotient round (mem: 826.10 MiB) 13:39:10 [13:39:10.813] INFO: pxe:bb:native bb - folded (mem: 826.10 MiB) 13:39:10 constructed folding proof (mem: 826.10 MiB) 13:39:10 [13:39:10.922] INFO: pxe:bb:native bb - Largest circuit: 97643 gates. Trace details: (mem: 826.10 MiB) 13:39:10 Minimum required block sizes for structured trace: (mem: 826.10 MiB) 13:39:10 [13:39:10.922] INFO: pxe:bb:native bb - (mem: 826.10 MiB) 13:39:10 prove decider... (mem: 826.10 MiB) 13:39:10 [13:39:10.922] INFO: pxe:bb:native bb - ecc_op : 792 13:39:10 busread : 4184 13:39:10 lookup : 2076 13:39:10 pub_inputs : 1859 13:39:10 arithmetic : 43824 13:39:10 delta_range : 5034 13:39:10 elliptic : 1274 13:39:10 aux : 12562 13:39:10 poseidon2_external : 6112 13:39:10 poseidon2_internal : 34829 13:39:10 overflow : 0 13:39:11 [13:39:10.997] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 826.10 MiB) 13:39:11 [13:39:11.091] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 826.10 MiB) 13:39:11 [13:39:11.592] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 826.10 MiB) 13:39:11 [13:39:11.677] INFO: pxe:bb:native bb - computed opening proof (mem: 826.10 MiB) 13:39:11 finished decider proving. (mem: 826.10 MiB) 13:39:11 [13:39:11.687] INFO: pxe:bb:native bb - vkey hash in Oink recursive verifier: 0x00000000000000000000000000000000d8261e82ddfdb3be69a02eee0fffb040 (mem: 826.10 MiB) 13:39:11 [13:39:11.830] INFO: pxe:bb:native bb - Constructing DeciderProvingKey (mem: 826.10 MiB) 13:39:11 [13:39:11.834] INFO: pxe:bb:native bb - allocating polynomials object in proving key... (mem: 826.10 MiB) 13:39:11 [13:39:11.883] INFO: pxe:bb:native bb - populating trace... (mem: 826.10 MiB) 13:39:11 [13:39:11.929] INFO: pxe:bb:native bb - time to construct proving key: 98 ms. (mem: 826.10 MiB) 13:39:12 [13:39:12.427] INFO: pxe:bb:native bb - vkey hash in Oink prover: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 826.10 MiB) 13:39:12 [13:39:12.787] INFO: pxe:bb:native bb - created oink proof (mem: 826.10 MiB) 13:39:12 [13:39:12.895] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 826.10 MiB) 13:39:13 [13:39:13.480] INFO: pxe:bb:native bb - completed 17 rounds of sumcheck (mem: 826.10 MiB) 13:39:14 [13:39:14.003] INFO: pxe:bb:native bb - executed multivariate-to-univariate reduction (mem: 826.10 MiB) 13:39:14 [13:39:14.058] INFO: pxe:bb:native bb - computed opening proof (mem: 826.10 MiB) 13:39:14 finished decider proving. (mem: 826.10 MiB) 13:39:14 Constructing a Goblin proof with num ultra ops = 3022 (mem: 826.10 MiB) 13:39:14 [13:39:14.131] INFO: pxe:bb:native bb - prove eccvm... (mem: 826.10 MiB) 13:39:14 [13:39:14.399] INFO: pxe:bb:native bb - using cached grumpkin crs with num points 262144 at: "/home/ubuntu/.bb-crs/grumpkin_g1.flat.dat" (mem: 826.10 MiB) 13:39:14 [13:39:14.409] INFO: pxe:bb:native bb - Initialized Grumpkin prover CRS from memory with num points = 65537 (mem: 826.10 MiB) 13:39:15 [13:39:15.415] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 826.10 MiB) 13:39:16 [13:39:16.469] INFO: pxe:bb:native bb - completed 16 rounds of sumcheck (mem: 826.10 MiB) 13:39:18 [13:39:18.586] INFO: pxe:bb:native bb - finished eccvm proving. (mem: 826.10 MiB) 13:39:18 prove translator... (mem: 826.10 MiB) 13:39:19 [13:39:19.505] INFO: pxe:bb:native bb - starting sumcheck rounds... (mem: 841.48 MiB) 13:39:20 [13:39:20.385] INFO: pxe:bb:native bb - completed 18 rounds of sumcheck (mem: 841.48 MiB) 13:39:21 [13:39:21.184] INFO: pxe:bb:native bb - computed opening proof (mem: 841.48 MiB) 13:39:21 [13:39:21.187] INFO: pxe:bb:native bb - finished translator proving. (mem: 841.48 MiB) 13:39:21 [13:39:21.188] INFO: pxe:bb:native bb - vkey hash in Oink verifier: 0x000000000000000000000000000000006a3edcbfe005f5ad8792643a097b1462 (mem: 841.48 MiB) 13:39:21 [13:39:21.208] INFO: pxe:bb:native bb - sumcheck_verified: 1 (mem: 841.48 MiB) 13:39:21 libra_evals_verified: 1 (mem: 841.48 MiB) 13:39:21 pairing_check_verified: 1 (mem: 841.48 MiB) 13:39:21 Mega verified: 1 (mem: 841.48 MiB) 13:39:21 [13:39:21.267] INFO: pxe:bb:native bb - eccvm sumcheck verified?: 1 (mem: 841.48 MiB) 13:39:21 batch opening verified?: 1 (mem: 841.48 MiB) 13:39:21 eccvm consistency check verified?: 1 (mem: 841.48 MiB) 13:39:21 translation masking consistency checked?: 1 (mem: 841.48 MiB) 13:39:21 [13:39:21.282] INFO: pxe:bb:native bb - merge verified?: 1 (mem: 842.48 MiB) 13:39:21 eccvm verified?: 1 (mem: 842.48 MiB) 13:39:21 accumulator construction_verified?: 1 (mem: 842.48 MiB) 13:39:21 translation verified?: 1 (mem: 842.48 MiB) 13:39:21 consistency verified?: 1 (mem: 842.48 MiB) 13:39:21 [13:39:21.282] INFO: pxe:bb:native bb - Goblin verified: 1 (mem: 842.48 MiB) 13:39:21 [13:39:21.282] INFO: pxe:bb:native bb - writing ClientIVC proof in directory "/home/ubuntu/.aztec/wallet/bb/tmp-VdOUWv" (mem: 842.48 MiB) 13:39:21 [13:39:21.440] INFO: pxe:bb:native Generated IVC proof {"duration":16592.690088,"eventName":"circuit-proving"} 13:39:21 [13:39:21.445] INFO: pxe:service Proving completed in 20242.622068999997ms {"timings":{"total":20242.622068999997,"sync":53.23710899999969,"proving":17492.493255999998,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":478.6364390000008,"oracles":{"debugLog":{"times":[1.1093219999997928,0.2230650000001333,0.19013400000039837,0.3716080000003785,0.2274940000006609,0.18711400000029244,0.2793249999995169,0.38806799999929353]},"fetchTaggedLogs":{"times":[163.59531400000014]},"loadCapsule":{"times":[0.45568900000034773,0.32574600000043574,0.5160809999997582,0.4284480000005715,0.3803070000003572,0.4450589999996737,0.32994700000017474,0.3219460000000254,0.4771499999997104,0.27695500000027096]},"getSharedSecret":{"times":[5.540452000000187]},"aes128Decrypt":{"times":[1.0707320000001346,1.0106109999996988]},"getPublicKeysAndPartialAddress":{"times":[4.102061999999933]},"getKeyValidationRequest":{"times":[3.1089019999999437]},"storeCapsule":{"times":[4.2139649999999165,4.390477999999348,2.349228000000039]},"deleteCapsule":{"times":[2.8417069999995874]},"bulkRetrieveLogs":{"times":[6.659922999999253]},"validateEnqueuedNotesAndEvents":{"times":[19.732826000000387]},"getNotes":{"times":[4.034791000000041]},"getAuthWitness":{"times":[0.4134680000006483]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.40659799999957613]},"callPrivateFunction":{"times":[128.82887599999958]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3008559999998397]}}},{"functionName":"private_kernel_init","time":207.70112899999913},{"functionName":"ContractInstanceDeployer:deploy","time":73.72819000000163,"oracles":{"storeInExecutionCache":{"times":[0.3476670000000013]},"callPrivateFunction":{"times":[67.51496499999939]},"notifyCreatedNullifier":{"times":[0.6001219999998284]},"debugLog":{"times":[0.4030880000000252]}}},{"functionName":"private_kernel_inner","time":417.05874200000017},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.82031899999856,"oracles":{}},{"functionName":"private_kernel_inner","time":379.09614899999997},{"functionName":"private_kernel_reset","time":433.17956500000037},{"functionName":"private_kernel_tail","time":339.1945190000006}],"unaccounted":323.4766520000012}} 13:39:21 [13:39:21.565] INFO: pxe:service Sent transaction 0x1e1a050151505a4bf949506c19e20ad41c35c2548a18492dd5bfd955db942b75 13:39:22 [13:39:21.564] INFO: node Received tx 0x1e1a050151505a4bf949506c19e20ad41c35c2548a18492dd5bfd955db942b75 {"txHash":"0x1e1a050151505a4bf949506c19e20ad41c35c2548a18492dd5bfd955db942b75"} 13:39:31 [13:39:30.522] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945796 13:39:31 [13:39:30.522] WARN: foundation:test-date-provider Time set to 2025-06-26T13:49:56.000Z {"offset":625478,"timeMs":1750945796000} 13:39:31 [13:39:30.522] INFO: aztecjs:utils:watcher Slot 14 was missed, jumped to next slot 13:39:31 [13:39:31.581] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.20135391100001288s {"duration":0.20135391100001288,"rate":1571620.826376597,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":19968,"l2Gas":339984},"totalSizeInBytes":1472} 13:39:31 [13:39:31.602] INFO: sequencer Built block 11 for slot 15 with 1 txs and 0 messages. 1379618.737174838 mana/s {"blockHash":"0x1bb88e0de2183b69494046a533d4c2653658a26204ae4c8e56625771e77f408a","globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750945796,"version":2424982324},"txHashes":["0x1e1a050151505a4bf949506c19e20ad41c35c2548a18492dd5bfd955db942b75"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":229.3051839999971,"publicProcessDuration":201.50684400001774,"rollupCircuitsDuration":223.91773499999545,"txCount":1,"blockNumber":11,"blockTimestamp":1750945796,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:39:31 [13:39:31.783] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:39:31 [13:39:31.786] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750945832 13:39:31 [13:39:31.786] WARN: foundation:test-date-provider Time set to 2025-06-26T13:50:32.000Z {"offset":660214,"timeMs":1750945832000} 13:39:31 [13:39:31.786] INFO: aztecjs:utils:watcher Slot 15 was filled, jumped to next slot 13:39:32 [13:39:31.976] WARN: ethereum:cheat_codes Set L1 storage for contract 0x91714af62ce2441da3ae1db8b959f0e37efbfe52 at 4226519774845294989066245638914502055781420935494253450203740607592046551905 to 3743106036130323098097120681749450326027 13:39:32 [13:39:31.977] INFO: aztecjs:cheat_codes Proven tip moved: 10 -> 11. Pending tip: 11. 13:39:32 [13:39:32.008] INFO: archiver Downloaded L2 block 11 {"blockHash":"0x1bb88e0de2183b69494046a533d4c2653658a26204ae4c8e56625771e77f408a","blockNumber":11,"txCount":1,"globalVariables":{"blockNumber":11,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":2900,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":15,"timestamp":1750945796,"version":2424982324},"archiveRoot":"0x184d4ee4b7e1fb1d3bb1d440ed26aaf8e425694e90a8daed22848c178220afe3","archiveNextLeafIndex":12} 13:39:32 [13:39:32.020] INFO: world_state World state updated with L2 block 11 {"eventName":"l2-block-handled","duration":6.3793080000032205,"unfinalisedBlockNumber":11,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":11,"blockTimestamp":1750945796,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 13:39:32 [13:39:32.518] INFO: archiver Updated proven chain to block 11 {"provenBlockNumber":11} 13:39:32 Contract deployed at 0x078c084815bda0acdd5823f0c919f2821e16961682048b81a03f179bbddf188a 13:39:32 Contract partial address 0x01d2037d12c5991a4d148d7b642e2a97d21f39ba72851436b5438aa894440e89 13:39:32 Contract init hash 0x180f185e2d6183143c720843651050cb5dedc0ba84a2828d723fc0436544b007 13:39:32 Deployment tx hash: 0x1e1a050151505a4bf949506c19e20ad41c35c2548a18492dd5bfd955db942b75 13:39:32 Deployment salt: 0x2ca899d6e31f4f2ddeaf422e6b3ec01f512933fb0fee03e7ef0244b863030de9 13:39:32 Deployment fee: 985953600 13:39:32 Contract stored in database with alias last 13:39:34 Sending kill to pid 449 13:39:34 Sending kill to aztec-start-04dfcdb2