chore(avm): logging changes

[fcarreiro]

Add gas logging and separate logging for instructions and memory.

[fcarreiro]

• chore(avm): logging changes #5537 👈
• feat(avm): integrate AVM with initializers #5469
• fix(avm): nullifier handling #5488
• feat(avm): contract instance opcode #5487
• feat(avm): add index to pedersen opcode #5486
• master

This stack of pull requests is managed by Graphite. Learn more about stacking.

Join @fcarreiro and the rest of your teammates on Graphite

[AztecBot]

Benchmark results

Metrics with a significant change:

• note_trial_decrypting_time_in_ms (32): 100 (+140%)

Detailed results

All benchmarks are run on txs on the Benchmarking contract on the repository. Each tx consists of a batch call to create_note and increment_balance, which guarantees that each tx has a private call, a nested private call, a public call, and a nested public call, as well as an emitted private note, an unencrypted log, and public storage read and write.

This benchmark source data is available in JSON format on S3 here.

Values are compared against data from master at commit d531b259 and shown if the difference exceeds 1%.

L2 block published to L1

Each column represents the number of txs on an L2 block published to L1.

Metric	8 txs	32 txs	64 txs
l1_rollup_calldata_size_in_bytes	676	676	676
l1_rollup_calldata_gas	6,412	6,412	6,412
l1_rollup_execution_gas	585,745	585,745	585,745
l2_block_processing_time_in_ms	1,285 (-7%)	4,821 (+2%)	9,508
note_successful_decrypting_time_in_ms	242 (+2%)	595 (-6%)	1,008 (-1%)
note_trial_decrypting_time_in_ms	45.0 (+17%)	⚠️ 100 (+140%)	29.9 (-24%)
l2_block_building_time_in_ms	11,988	43,161 (-1%)	85,042
l2_block_rollup_simulation_time_in_ms	7,165 (+1%)	24,338	47,153
l2_block_public_tx_process_time_in_ms	4,784 (-1%)	18,700 (-1%)	37,652

L2 chain processing

Each column represents the number of blocks on the L2 chain where each block has 16 txs.

Metric	5 blocks	10 blocks
node_history_sync_time_in_ms	14,323 (-1%)	27,325 (-2%)
note_history_successful_decrypting_time_in_ms	1,352 (+5%)	2,374 (-3%)
note_history_trial_decrypting_time_in_ms	73.3 (-42%)	84.6 (-21%)
node_database_size_in_bytes	18,600,016	34,959,440
pxe_database_size_in_bytes	29,859	59,414

Circuits stats

Stats on running time and I/O sizes collected for every circuit run across all benchmarks.

Circuit	circuit_simulation_time_in_ms	circuit_input_size_in_bytes	circuit_output_size_in_bytes
private-kernel-init	180	44,377	26,164
private-kernel-ordering	162 (+1%)	50,830	39,325
base-parity	4,222	128	311
root-parity	1,175 (+6%)	1,244	311
base-rollup	14,475	116,608	861
root-rollup	50.2 (+1%)	4,359	725
private-kernel-inner	219	71,744	26,164
public-kernel-app-logic	120 (+1%)	47,695	40,661
public-kernel-tail	164	53,372	13,269
merge-rollup	10.1 (-2%)	2,568	861
public-kernel-teardown	116 (-2%)	47,695	40,661
public-kernel-setup	116 (-2%)	47,695	40,661

Tree insertion stats

The duration to insert a fixed batch of leaves into each tree type.

Metric	1 leaves	16 leaves	64 leaves	128 leaves	512 leaves	1024 leaves	2048 leaves	4096 leaves	32 leaves
batch_insert_into_append_only_tree_16_depth_ms	10.2 (+1%)	16.2 (+1%)	N/A	N/A	N/A	N/A	N/A	N/A	N/A
batch_insert_into_append_only_tree_16_depth_hash_count	16.8	31.6	N/A	N/A	N/A	N/A	N/A	N/A	N/A
batch_insert_into_append_only_tree_16_depth_hash_ms	0.590 (+1%)	0.497 (+1%)	N/A	N/A	N/A	N/A	N/A	N/A	N/A
batch_insert_into_append_only_tree_32_depth_ms	N/A	N/A	46.0	72.9 (+1%)	233 (+1%)	449 (+1%)	871	1,739	N/A
batch_insert_into_append_only_tree_32_depth_hash_count	N/A	N/A	96.0	159	543	1,055	2,079	4,127	N/A
batch_insert_into_append_only_tree_32_depth_hash_ms	N/A	N/A	0.471	0.448 (+1%)	0.423 (+1%)	0.418	0.413	0.416	N/A
batch_insert_into_indexed_tree_20_depth_ms	N/A	N/A	54.5 (+1%)	107	341 (+1%)	663 (+1%)	1,310	2,612	N/A
batch_insert_into_indexed_tree_20_depth_hash_count	N/A	N/A	105	207	691	1,363	2,707	5,395	N/A
batch_insert_into_indexed_tree_20_depth_hash_ms	N/A	N/A	0.479	0.482	0.460 (+1%)	0.454	0.454	0.454	N/A
batch_insert_into_indexed_tree_40_depth_ms	N/A	N/A	N/A	N/A	N/A	N/A	N/A	N/A	61.5 (+1%)
batch_insert_into_indexed_tree_40_depth_hash_count	N/A	N/A	N/A	N/A	N/A	N/A	N/A	N/A	109
batch_insert_into_indexed_tree_40_depth_hash_ms	N/A	N/A	N/A	N/A	N/A	N/A	N/A	N/A	0.535

Miscellaneous

Transaction sizes based on how many contract classes are registered in the tx.

Metric	0 registered classes	1 registered classes
tx_size_in_bytes	40,548	501,142

Transaction size based on fee payment method

Metric	native fee payment method	fpc_public fee payment method	fpc_private fee payment method
tx_with_fee_size_in_bytes	905	1,161	1,377

Transaction processing duration by data writes.

Metric	0 new note hashes	1 new note hashes	2 new note hashes
tx_pxe_processing_time_ms	1,732 (+2%)	1,089 (+1%)	5,453 (+1%)

Metric	1 public data writes	2 public data writes	3 public data writes	4 public data writes	5 public data writes	8 public data writes
tx_sequencer_processing_time_ms	580 (+1%)	512 (-6%)	1,084 (+1%)	536 (+2%)	1,772 (+1%)	595 (+1%)

[socket-security]

New and removed dependencies detected. Learn more about Socket for GitHub ↗︎

Package	New capabilities	Transitives	Size	Publisher
npm/@types/estree@1.0.2	None	0	25.7 kB	types
npm/@types/express-serve-static-core@4.17.37	None	+4	3.99 MB	types
npm/@types/express@4.17.19	None	+4	3.95 MB	types
npm/@types/mime@1.3.3	None	0	4.09 kB	types
npm/@types/serve-static@1.15.3	None	+2	3.94 MB	types
npm/@webassemblyjs/ast@1.11.6	None	+5	341 kB	xtuc
npm/@webassemblyjs/wasm-parser@1.11.6	None	+7	329 kB	xtuc
npm/accepts@1.3.8	None	+3	268 kB	dougwilson
npm/follow-redirects@1.15.3	network	0	28.6 kB	rubenverborgh
npm/minimist@1.2.8	None	0	54.5 kB	ljharb
npm/obuf@1.1.2	None	0	19.1 kB	indutny
npm/parseurl@1.3.3	None	0	10.3 kB	dougwilson
npm/rc@1.2.8	environment, filesystem	+2	31.5 kB	dominictarr

🚮 Removed packages: npm/safe-buffer@5.2.1, npm/safer-buffer@2.1.2, npm/semver@7.5.4, npm/serialize-javascript@6.0.1, npm/shell-quote@1.8.1, npm/space-separated-tokens@1.1.5, npm/string-width@5.1.2, npm/strip-ansi@6.0.1, npm/style-to-object@0.3.0, npm/svgo@2.8.0, npm/tapable@2.2.1, npm/terser-webpack-plugin@5.3.9, npm/terser@5.21.0, npm/tslib@2.6.2, npm/typescript@4.9.5, npm/unified@9.2.2, npm/unist-builder@2.0.3, npm/unist-util-visit@2.0.3, npm/util-deprecate@1.0.2, npm/vfile-location@3.2.0, npm/webpack-sources@3.2.3, npm/xtend@4.0.2, npm/yaml@1.10.2

View full report↗︎

[socket-security]

👍 Dependency issues cleared. Learn more about Socket for GitHub ↗︎

This PR previously contained dependency changes with security issues that have been resolved, removed, or ignored.

View full report↗︎

[fcarreiro]

Closing in favor of https://app.graphite.dev/github/pr/AztecProtocol/aztec-packages/5622/chore-Reduce-log-verbosity-in-local-e2e-tests