Source code for stable_pretraining.module

import re
import types
from functools import partial

import lightning as pl
import torch
import torchmetrics
from loguru import logger as logging
from omegaconf import DictConfig
from tabulate import tabulate
from pathlib import Path
from prettytable import PrettyTable
from lightning.pytorch.core.optimizer import LightningOptimizer
from .optim import create_optimizer, create_scheduler
from typing import Any, Set
import time


[docs] class Module(pl.LightningModule): """PyTorch Lightning module using manual optimization with multi-optimizer support. Core usage - Provide a custom `forward(self, batch, stage)` via the `forward` argument at init. - During training, `forward` must return a dict with `state["loss"]` (a single joint loss). When multiple optimizers are configured, this joint loss is used for all optimizers. Optimizer configuration (`self.optim`) - Single optimizer: {"optimizer": str|dict|partial|Class, "scheduler": <see below>, "interval": "step"|"epoch", "frequency": int} - Optimizer accepted forms: * string name (e.g., "AdamW", "SGD") from torch.optim * dict: {"type": "AdamW", "lr": 1e-3, ...} * functools.partial: partial(torch.optim.AdamW, lr=1e-3) * optimizer class: torch.optim.AdamW - Multiple optimizers: { name: { "modules": "regex", # assign params by module-name pattern (children inherit) "optimizer": str|dict|partial|Class, # optimizer factory (same accepted forms as above) "scheduler": str|dict|partial|Class, # flexible scheduler config (see below) "interval": "step"|"epoch", # scheduler interval "frequency": int, # optimizer step frequency "monitor": str # (optional) for ReduceLROnPlateau; alternatively set inside scheduler dict }, ... } Parameter assignment (multi-optimizer) - Modules are matched by regex on their qualified name. Children inherit the parent's assignment unless they match a more specific pattern. Only direct parameters of each module are collected to avoid duplication. Schedulers (flexible) - Accepted forms: string name (e.g., "CosineAnnealingLR", "StepLR"), dict with {"type": "...", ...}, functools.partial, or a scheduler class. Smart defaults are applied when params are omitted for common schedulers (CosineAnnealingLR, OneCycleLR, StepLR, ExponentialLR, ReduceLROnPlateau, LinearLR, ConstantLR). For ReduceLROnPlateau, a `monitor` key is added (default: "val_loss"). You may specify `monitor` either alongside the optimizer config (top level) or inside the scheduler dict itself. - The resulting Lightning scheduler dict includes `interval` and `frequency` (or `scheduler_frequency`). Training loop behavior - Manual optimization (`automatic_optimization = False`). - Gradient accumulation: scales loss by 1/N where N = Trainer.accumulate_grad_batches and steps on the boundary. - Per-optimizer step frequency: each optimizer steps only when its frequency boundary is met (in addition to accumulation boundary). - Gradient clipping: uses Trainer's `gradient_clip_val` and `gradient_clip_algorithm` before each step. - Returns the `state` dict from `forward` unchanged for logging/inspection. """ def __init__(self, *args, forward: callable = None, hparams: dict = None, **kwargs): super().__init__() logging.info("Initializing Module configuration...") # Manual optimization to support multiple optimizers and custom stepping self.automatic_optimization = False self.callbacks_modules = torch.nn.ModuleDict() self.callbacks_metrics = torch.nn.ModuleDict() self._optimizer_index_to_name = {} self._optimizer_frequencies = {} self._optimizer_gradient_clip_val = {} self._optimizer_gradient_clip_algorithm = {} if len(args) > 0: raise ValueError( "Module does not accept positional arguments (*args). Please use keyword arguments instead (e.g., Module(forward=my_forward, hparams=my_hparams))." ) if hparams is None: logging.warning( "No hyperparameters provided - hyperparameter logging is disabled." ) else: logging.info("Saving provided hyperparameters.") self.save_hyperparameters(hparams) self.save_hyperparameters( {**self.hparams, "system.working_dir": str(Path().resolve())} ) logging.info("Setting custom forward method.") if forward is None: logging.warning( "You didn't pass a forward method" "This will fail unless you implemented your own Module class" ) elif not callable(forward): msg = "You passed a `forward' object that is not callable!" logging.warning(msg) raise ValueError(msg) else: setattr(self, "forward", types.MethodType(forward, self)) for key, value in kwargs.items(): logging.info(f"Setting attribute: self.{key} = {type(value)}") setattr(self, key, value) headers = ["Stage", "Inputs", "Metric"] if hasattr(self, "metrics"): stats = [] assert isinstance(self.metrics, torch.nn.ModuleDict) logging.info("Metrics:") for stage, metrics in self.metrics.items(): assert ( isinstance(metrics, torch.nn.ModuleDict) or isinstance(metrics, torch.nn.ModuleList) or isinstance(metrics, torchmetrics.Metric) ) for name, metric in metrics.items(): stats.append([stage, name, str(metric)]) logging.info(f"\n{tabulate(stats, headers, tablefmt='heavy_outline')}") else: self.metrics = dict(train={}, validate={}, test={}, predict={}) logging.info( "No metrics configuration provided - automatic metric tracking is disabled." )
[docs] def forward(self, *args, **kwargs): raise NotImplementedError("The forward() method must be implemented.")
[docs] def named_parameters( self, with_callbacks=True, prefix: str = "", recurse: bool = True ): """Override to globally exclude callback-related parameters. Excludes parameters that belong to ``self.callbacks_modules`` or ``self.callbacks_metrics``. This prevents accidental optimization of callback/metric internals, even if external code calls ``self.parameters()`` or ``self.named_parameters()`` directly. Args: with_callbacks (bool, optional): If False, excludes callback parameters. Defaults to True. prefix (str, optional): Prefix to prepend to parameter names. Defaults to "". recurse (bool, optional): If True, yields parameters of this module and all submodules. If False, yields only direct parameters. Defaults to True. Yields: tuple[str, torch.nn.Parameter]: Name and parameter pairs. """ if with_callbacks: logging.warning( "You are calling self.parameters which also gives callbacks " "parameters, to remove then, pass `with_callbacks=False`" ) for name, param in super().named_parameters(prefix=prefix, recurse=recurse): is_callback = name.startswith("callbacks_") if is_callback and not with_callbacks: continue yield name, param
[docs] def parameters(self, with_callbacks=True, recurse: bool = True): """Override to route through the filtered ``named_parameters`` implementation. Args: with_callbacks (bool, optional): If False, excludes callback parameters. Defaults to True. recurse (bool, optional): If True, yields parameters of this module and all submodules. If False, yields only direct parameters. Defaults to True. Yields: torch.nn.Parameter: Module parameters. """ for _, param in self.named_parameters(with_callbacks, recurse=recurse): yield param
[docs] def rescale_loss_for_grad_acc(self, loss): accum = max( int( getattr( self.trainer, "accumulate_grad_batches_", getattr(self.trainer, "accumulate_grad_batches", 1), ) ), 1, ) return loss / accum
[docs] def training_step(self, batch, batch_idx): """Manual optimization training step with support for multiple optimizers. Expected output from forward during training (stage="fit"): - state["loss"]: torch.Tensor - Single joint loss for all optimizers When multiple optimizers are configured, the same loss is used for all of them. Each optimizer updates its assigned parameters based on gradients from this joint loss. """ state = self(batch, stage="fit") # Resolve optimizers and schedulers (can be single or list) optimizers = self.optimizers() # there are NO optimizers either from main or callbacks, no need to stay here! if isinstance(optimizers, pl.pytorch.core.optimizer._MockOptimizer): return state elif not isinstance(optimizers, (list, tuple)): optimizers = [optimizers] schedulers = self.lr_schedulers() if schedulers is None: schedulers = [] elif not isinstance(schedulers, (list, tuple)): schedulers = [schedulers] if len(optimizers) != len(schedulers): raise ValueError( "We need as many schedulers as optimizers!" "if you don't want to use one, either use a " "ConstantLR, or return None" ) # Compute gradients once for the joint loss self.manual_backward(state["loss"]) zero_grad_opts = [] # Stepping and gradient clipping at accumulation boundary for idx, opt in enumerate(optimizers): name = self._optimizer_index_to_name[idx] # Honor per-optimizer frequency if available if (batch_idx + 1) % self._optimizer_frequencies[name] != 0: continue clip_val = self._optimizer_gradient_clip_val[name] clip_algo = self._optimizer_gradient_clip_algorithm[name] if clip_val is not None: self.clip_gradients( opt, gradient_clip_val=clip_val, gradient_clip_algorithm=clip_algo, ) if not isinstance(opt, LightningOptimizer): msg = ( "We received an optimizer that is not wrapped" "by lightning, make sure you define all your optimizers" f"in the configure_optimizers method! {opt}" ) logging.error(msg) raise ValueError(msg) opt.step() zero_grad_opts.append(opt) # Step its scheduler if it exists if schedulers[idx] is not None: schedulers[idx].step() # zero grad what's needed for opt in zero_grad_opts: opt.zero_grad(set_to_none=True) return state
[docs] def on_train_start(self): logging.info("Double checking optimizers!") optimizers = self.optimizers() if not isinstance(optimizers, (list, tuple)): optimizers = [optimizers] logging.info(f"`self.optimizers() gave us {len(optimizers)} optimizers") for i in range(len(optimizers)): # check if optimizer i is named and well setup if i not in self._optimizer_index_to_name: name = f"default_{i}" self._optimizer_index_to_name[i] = name name = self._optimizer_index_to_name[i] if name not in self._optimizer_gradient_clip_val: logging.warning(f"No clip val found for optimizer {name}") clip_val = getattr( self.trainer, "gradient_clip_val_", self.trainer.gradient_clip_val ) logging.warning(f"-> we will use the Trainer's value of {clip_val}") self._optimizer_gradient_clip_val[name] = clip_val if name not in self._optimizer_gradient_clip_algorithm: logging.warning(f"No clip algorithm found for optimizer {name}") clip_algo = getattr( self.trainer, "gradient_clip_algorithm_", self.trainer.gradient_clip_algorithm, ) logging.warning(f"-> we will use the Trainer's value of {clip_algo}") self._optimizer_gradient_clip_algorithm[name] = clip_algo if name not in self._optimizer_frequencies: freq = getattr(self.trainer, "accumulate_grad_batches", 1) freq = getattr(self.trainer, "accumulate_grad_batches_", freq) freq = max(int(freq), 1) # config priority freq = self.optim.get("frequency", freq) self._optimizer_frequencies[name] = int(freq) table = PrettyTable() # 2. Define the column headers. table.field_names = ["Opt. Index", "Opt. name", "opt", "clip val.", "clip alg."] for i in range(len(optimizers)): name = self._optimizer_index_to_name[i] row = [str(i), name, type(optimizers[i]).__name__] row.append(str(self._optimizer_gradient_clip_val[name])) row.append(str(self._optimizer_gradient_clip_algorithm[name])) table.add_row(row) logging.success( "We are done checking your optimizers! Here is the summary:\n{}", table )
[docs] def validation_step(self, batch, batch_idx): return self.forward(batch, stage="validate")
[docs] def test_step(self, batch, batch_idx): return self.forward(batch, stage="test")
[docs] def predict_step(self, batch, batch_idx): return self.forward(batch, stage="predict")
def _get_scheduler_name(self, scheduler_config, scheduler_instance=None): """Extract scheduler name from various config formats. Args: scheduler_config: Scheduler configuration (str, dict, partial, or class). scheduler_instance (optional): Instantiated scheduler instance. Defaults to None. Returns: str: Name of the scheduler. """ if isinstance(scheduler_config, str): return scheduler_config elif isinstance(scheduler_config, dict): return scheduler_config.get("type", "CosineAnnealingLR") elif hasattr(scheduler_config, "func"): # partial return scheduler_config.func.__name__ elif scheduler_instance: return scheduler_instance.__class__.__name__ else: return "Unknown" def _build_scheduler_config(self, scheduler, config, name=None): """Build scheduler config dict for Lightning. Args: scheduler: The instantiated scheduler. config (dict): Configuration dict containing interval, frequency, etc. name (str, optional): Name for the scheduler. Defaults to None. Returns: dict: Scheduler configuration dict compatible with Lightning. """ scheduler_dict = { "scheduler": scheduler, "interval": config.get("interval", "step"), "frequency": config.get("scheduler_frequency", config.get("frequency", 1)), } if name: scheduler_dict["name"] = name # Add monitor for ReduceLROnPlateau scheduler_cfg = config.get("scheduler", "CosineAnnealingLR") scheduler_name = self._get_scheduler_name(scheduler_cfg, scheduler) if scheduler_name == "ReduceLROnPlateau": # Prefer nested monitor inside scheduler dict, fallback to top-level nested_monitor = None if isinstance(scheduler_cfg, dict): nested_monitor = scheduler_cfg.get("monitor") scheduler_dict["monitor"] = nested_monitor or config.get( "monitor", "val_loss" ) return scheduler_dict def _collect_parameters_by_optimizer_groups(self, optim_items): """Assign modules and collect parameters per optimizer group defined by regex. Args: optim_items: list of (name, config) where config contains a "modules" regex describing group membership. Returns: params_by_name: dict[name, List[nn.Parameter]] modules_by_name: dict[name, List[str]] """ # Pre-compile regex with stable order from optim_items compiled = [ (name, re.compile(config["modules"])) for name, config in optim_items ] # Initialize containers params_by_name = {name: [] for name, _ in compiled} modules_by_name = {name: [] for name, _ in compiled} # Map module -> group index with inheritance module_to_group = {} for qual_name, module in self.named_modules(): if "callbacks_modules" in qual_name or "callbacks_metrics" in qual_name: continue # inherit parent's group if any if "." in qual_name: parent_name = qual_name.rsplit(".", 1)[0] group_idx = module_to_group.get(parent_name) else: group_idx = None # override if explicit match for idx, (_, regex) in enumerate(compiled): if regex.match(qual_name): group_idx = idx break module_to_group[qual_name] = group_idx if group_idx is not None: group_name = compiled[group_idx][0] # record module name modules_by_name[group_name].append(qual_name) # collect direct parameters only to avoid duplication direct_params = list(module.parameters(recurse=False)) if direct_params: params_by_name[group_name].extend(direct_params) # Logging summary rows = [] for group_name, config in optim_items: pattern = config.get("modules", "") tensors = params_by_name[group_name] num_tensors = len(tensors) num_elements = sum(int(p.numel()) for p in tensors) num_requires_grad = sum(int(p.requires_grad) for p in tensors) rows.append( [ group_name, pattern, len(modules_by_name[group_name]), num_tensors, num_elements, num_requires_grad, ] ) if rows: headers = [ "Optimizer", "Pattern", "Matched Modules", "Param Tensors", "Total Params", "RequiresGrad Tensors", ] logging.info( "\n" + tabulate(rows, headers=headers, tablefmt="heavy_outline") ) return params_by_name, modules_by_name
[docs] def configure_optimizers(self): """Configure optimizers and schedulers for manual optimization. Returns: dict or tuple: Optimizer configuration with optional learning rate scheduler. For single optimizer: Returns a dict with optimizer and lr_scheduler. For multiple optimizers: Returns a tuple of (optimizers, schedulers). Example: Multi-optimizer configuration with module pattern matching and schedulers: >>> # Simple single optimizer with scheduler >>> self.optim = { ... "optimizer": partial(torch.optim.AdamW, lr=1e-3), ... "scheduler": "CosineAnnealingLR", # Uses smart defaults ... "interval": "step", ... "frequency": 1, ... } >>> # Multi-optimizer with custom scheduler configs >>> self.optim = { ... "encoder_opt": { ... "modules": "encoder", # Matches 'encoder' and all children ... "optimizer": {"type": "AdamW", "lr": 1e-3}, ... "scheduler": { ... "type": "OneCycleLR", ... "max_lr": 1e-3, ... "total_steps": 10000, ... }, ... "interval": "step", ... "frequency": 1, ... }, ... "head_opt": { ... "modules": ".*head$", # Matches modules ending with 'head' ... "optimizer": "SGD", ... "scheduler": { ... "type": "ReduceLROnPlateau", ... "mode": "max", ... "patience": 5, ... "factor": 0.5, ... }, ... "monitor": "val_accuracy", # Required for ReduceLROnPlateau ... "interval": "epoch", ... "frequency": 2, ... }, ... } With model structure: - encoder -> encoder_opt (matches "encoder") - encoder.layer1 -> encoder_opt (inherits from parent) - encoder.layer1.conv -> encoder_opt (inherits from encoder.layer1) - classifier_head -> head_opt (matches ".*head$") - classifier_head.linear -> head_opt (inherits from parent) - decoder -> None (no match, no parameters collected) """ logging.info("Configuring optimizers and learning rate schedulers...") # Early exit for disabled optimization if hasattr(self, "optim") and not self.optim: logging.info("Optimization disabled - skipping optimizer configuration.") return None if not hasattr(self, "optim"): logging.info( "Using default optimization setup: AdamW optimizer with CosineAnnealingLR scheduler." ) self.optim = dict(optimizer=partial(torch.optim.AdamW)) elif isinstance(self.optim, partial): logging.info("Using user's partial optimizer.") self.optim = dict(optimizer=self.optim) # Single optimizer case optimizer_cfg = self.optim.get("optimizer") if isinstance(optimizer_cfg, (str, dict, DictConfig)) or hasattr( optimizer_cfg, "__call__" ): logging.info("Configuring single optimizer.") # Direct parameter extraction - use globally filtered parameters params = list(self.parameters(with_callbacks=False)) opt = create_optimizer(params, optimizer_cfg) # Create scheduler default = dict( type="CosineAnnealingLR", T_max=self.trainer.estimated_stepping_batches ) sched_config = self.optim.get("scheduler", default) sched = create_scheduler(opt, sched_config, module=self) sched_name = self._get_scheduler_name(sched_config, sched) logging.info( f"Configured {opt.__class__.__name__} optimizer with {sched_name} scheduler." ) # Build scheduler config dict for Lightning scheduler_dict = self._build_scheduler_config(sched, self.optim) # Return in list/dict style compatible with lr_schedulers() access return [opt], [scheduler_dict] # Multiple optimizers case - check once if not isinstance(self.optim, (dict, DictConfig)): raise ValueError( "Optimizer must be either a partial function or a dict of optimizer configs" ) # Verify all values are dicts optim_items = list(self.optim.items()) if not all(isinstance(v, (dict, DictConfig)) for _, v in optim_items): raise ValueError("For multiple optimizers, all config values must be dicts") logging.info( f"\tOptimizer specified by Dict with keys {[k for k, _ in optim_items]}... 🔧" ) # Build grouping with detailed logging params_by_name, modules_by_name = self._collect_parameters_by_optimizer_groups( optim_items ) # Build optimizers and schedulers optimizers = [] schedulers = [] for name, config in optim_items: params = params_by_name.get(name, []) if not params: logging.warning(f"No parameters matched for optimizer {name}") # skip registration when there are no parameters continue opt = create_optimizer(params, config["optimizer"]) optimizers.append(opt) sched_config = config.get("scheduler", "CosineAnnealingLR") scheduler = create_scheduler(opt, sched_config, module=self) sched_name = self._get_scheduler_name(sched_config, scheduler) # Build scheduler config dict for Lightning scheduler_dict = self._build_scheduler_config(scheduler, config, name) schedulers.append(scheduler_dict) logging.info( f"Configured optimizer '{name}' (modules={len(modules_by_name.get(name, []))}, " f"param_tensors={len(params)}, total_params={sum(int(p.numel()) for p in params)}) " f"with {sched_name} scheduler." ) # Track names and frequencies aligned to optimizer order self._optimizer_frequencies[name] = int(config.get("frequency", 1)) return optimizers, schedulers
[docs] def on_save_checkpoint(self, checkpoint): """Offload checkpoint tensors to CPU to reduce GPU memory usage during save. This method intercepts the checkpoint saving process and recursively moves all PyTorch tensors (model weights, optimizer states, scheduler states) from GPU to CPU before writing to disk. This prevents GPU OOM issues when checkpointing large models (e.g., 2B+ parameters with optimizer states). Args: checkpoint (dict): Lightning checkpoint dictionary containing: - state_dict: Model parameters (moved to CPU) - optimizer_states: Optimizer state dicts (moved to CPU) - lr_schedulers: LR scheduler states (moved to CPU) - Other keys: Custom objects, metadata (left unchanged) Behavior: - Processes standard Lightning checkpoint keys (state_dict, optimizer_states, lr_schedulers) - Recursively traverses dicts, lists, and tuples to find tensors - Moves all torch.Tensor objects to CPU - Skips custom objects (returns unchanged) - Logs GPU memory freed and processing time - Non-destructive: Checkpoint loading/resuming works normally Side Effects: - Modifies checkpoint dict in-place (tensors moved to CPU) - Temporarily increases CPU memory during offload - Adds ~2-5 seconds to checkpoint save time for 2B models - Frees ~8-12GB GPU memory for 2B model + optimizer states Custom Objects: Custom objects in the checkpoint are NOT modified and will be logged as warnings. These include: custom classes, numpy arrays, primitives, etc. They are safely skipped and preserved in the checkpoint. Raises: Exception: If tensor offload fails for any checkpoint key, logs error but allows checkpoint save to proceed (non-fatal). Example: For a 2B parameter model with AdamW optimizer: - Before: ~12GB GPU memory spike on rank 0 during checkpoint save - After: ~0.2GB GPU memory spike, ~10-12GB freed - Checkpoint save time: +2-3 seconds - Resume from checkpoint: Works normally, tensors auto-loaded to GPU Notes: - Only rank 0 saves checkpoints in DDP, so only rank 0 sees memory benefit - Does not affect checkpoint contents or ability to resume training - Safe for standard PyTorch/Lightning use cases - If using FSDP/DeepSpeed, consider strategy-specific checkpointing instead See Also: - PyTorch Lightning ModelCheckpoint callback - torch.Tensor.cpu() for device transfer behavior """ start_time = time.time() logging.info("=" * 60) logging.info("Starting checkpoint CPU offload") # Track skipped types skipped_types: Set[str] = set() # Log initial GPU memory if torch.cuda.is_available(): gpu_mem_before = torch.cuda.memory_allocated() / 1e9 logging.info(f"GPU memory before offload: {gpu_mem_before:.2f} GB") def safe_to_cpu(obj: Any, path: str = "root") -> Any: """Recursively move tensors to CPU, skip custom objects.""" if isinstance(obj, torch.Tensor): size_mb = obj.element_size() * obj.nelement() / 1e6 logging.debug( f"Moving tensor at '{path}': {tuple(obj.shape)} " f"({size_mb:.1f} MB) to CPU" ) return obj.cpu() elif isinstance(obj, dict): logging.trace(f"Processing dict at '{path}' with {len(obj)} keys") return {k: safe_to_cpu(v, f"{path}.{k}") for k, v in obj.items()} elif isinstance(obj, (list, tuple)): logging.trace( f"Processing {type(obj).__name__} at '{path}' with {len(obj)} items" ) result = [safe_to_cpu(v, f"{path}[{i}]") for i, v in enumerate(obj)] return tuple(result) if isinstance(obj, tuple) else result else: # Custom object - don't modify obj_type = type(obj).__name__ skipped_types.add(f"{obj_type} at '{path}'") logging.debug(f"Skipping custom object at '{path}': {obj_type}") return obj # Process each checkpoint component safe_keys = ["state_dict", "optimizer_states", "lr_schedulers"] processed_keys = [] for key in safe_keys: if key in checkpoint: logging.info(f"Processing checkpoint key: '{key}'") key_start = time.time() try: checkpoint[key] = safe_to_cpu(checkpoint[key], path=key) key_time = time.time() - key_start logging.success(f"✓ Completed '{key}' in {key_time:.2f}s") processed_keys.append(key) except Exception as e: logging.error(f"✗ Failed to process '{key}': {e}") logging.exception("Full traceback:") logging.warning(f"Checkpoint key '{key}' will remain on GPU") # Don't raise - allow checkpoint to proceed # Log skipped custom objects if skipped_types: logging.warning(f"Skipped {len(skipped_types)} custom object(s):") for obj_info in sorted(skipped_types): logging.warning(f" - {obj_info}") # Log other checkpoint keys (not processed) other_keys = set(checkpoint.keys()) - set(safe_keys) if other_keys: logging.info(f"Other checkpoint keys (not processed): {sorted(other_keys)}") # Log final GPU memory and timing if torch.cuda.is_available(): gpu_mem_after = torch.cuda.memory_allocated() / 1e9 mem_freed = gpu_mem_before - gpu_mem_after logging.info(f"GPU memory after offload: {gpu_mem_after:.2f} GB") if mem_freed > 0: logging.success(f"✓ GPU memory freed: {mem_freed:.2f} GB") else: logging.warning(f"No GPU memory freed (freed: {mem_freed:.2f} GB)") total_time = time.time() - start_time logging.success(f"Checkpoint CPU offload completed in {total_time:.2f}s") logging.info(f"Successfully processed keys: {processed_keys}") logging.info("=" * 60)