======================== START TIME: Tue Jul 2 14:30:03 UTC 2024 python3 version = Python 3.10.14 ======================== The token has not been saved to the git credentials helper. Pass `add_to_git_credential=True` in this function directly or `--add-to-git-credential` if using via `huggingface-cli` if you want to set the git credential as well. Token is valid (permission: write). Your token has been saved to /admin/home/ferdinand_mom/.cache/huggingface/token Login successful Already on 'bench_cluster' M examples/config_tiny_llama.py M examples/config_tiny_llama.yaml M examples/train_tiny_llama.sh M src/nanotron/models/llama.py M src/nanotron/trainer.py Your branch is up to date with 'origin/bench_cluster'. Job status: RUNNING W0702 14:30:07.084000 140214986860352 torch/distributed/run.py:757] W0702 14:30:07.084000 140214986860352 torch/distributed/run.py:757] ***************************************** W0702 14:30:07.084000 140214986860352 torch/distributed/run.py:757] Setting OMP_NUM_THREADS environment variable for each process to be 1 in default, to avoid your system being overloaded, please further tune the variable for optimal performance in your application as needed. W0702 14:30:07.084000 140214986860352 torch/distributed/run.py:757] ***************************************** W0702 14:30:11.705000 139813057132352 torch/distributed/run.py:757] W0702 14:30:11.705000 139813057132352 torch/distributed/run.py:757] ***************************************** W0702 14:30:11.705000 139813057132352 torch/distributed/run.py:757] Setting OMP_NUM_THREADS environment variable for each process to be 1 in default, to avoid your system being overloaded, please further tune the variable for optimal performance in your application as needed. W0702 14:30:11.705000 139813057132352 torch/distributed/run.py:757] ***************************************** [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Config: [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Config(general=GeneralArgs(project='bench_cluster', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: run='%date_%jobid', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: seed=42, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: step=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: consumed_train_samples=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: benchmark_csv_path=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: ignore_sanity_checks=True), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: parallelism=ParallelismArgs(dp=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pp=16, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tp=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pp_engine=, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tp_mode=, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tp_linear_async_communication=False, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: expert_parallel_size=1), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: model=ModelArgs(model_config=LlamaConfig(bos_token_id=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: eos_token_id=2, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hidden_act='silu', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hidden_size=2048, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: initializer_range=0.02, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: intermediate_size=4096, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: is_llama_config=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: max_position_embeddings=4096, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_attention_heads=32, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_hidden_layers=24, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_key_value_heads=32, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pad_token_id=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pretraining_tp=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rms_norm_eps=1e-05, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rope_scaling=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rope_theta=10000.0, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tie_word_embeddings=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: use_cache=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: vocab_size=50257), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: init_method=RandomInit(std=0.025), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: dtype=torch.bfloat16, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: make_vocab_size_divisible_by=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: ddp_bucket_cap_mb=25), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tokenizer=TokenizerArgs(tokenizer_name_or_path='openai-community/gpt2', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tokenizer_revision=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tokenizer_max_length=None), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: checkpoints=CheckpointsArgs(checkpoints_path=Path('/dev/null'), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: checkpoint_interval=100000, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: save_initial_state=False, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: resume_checkpoint_path=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: checkpoints_path_is_shared_file_system=False), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: logging=LoggingArgs(log_level='info', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: log_level_replica='info', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: iteration_step_info_interval=1), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tokens=TokensArgs(sequence_length=4096, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: train_steps=20, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: micro_batch_size=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: batch_accumulation_per_replica=1024, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: val_check_interval=-1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: limit_val_batches=0, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: limit_test_batches=0), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: optimizer=OptimizerArgs(optimizer_factory=AdamWOptimizerArgs(adam_eps=1e-08, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: adam_beta1=0.9, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: adam_beta2=0.95, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: torch_adam_is_fused=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: name='adamW'), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: zero_stage=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: weight_decay=0.01, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: clip_grad=1.0, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: accumulate_grad_in_fp32=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: learning_rate_scheduler=LRSchedulerArgs(learning_rate=0.0001, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lr_warmup_steps=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lr_warmup_style='linear', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lr_decay_style='linear', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lr_decay_steps=19, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lr_decay_starting_step=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: min_decay_lr=1e-05)), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: data_stages=[DatasetStageArgs(name='Training Stage', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: start_training_step=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: data=DataArgs(dataset=PretrainDatasetsArgs(hf_dataset_or_datasets='roneneldan/TinyStories', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hf_dataset_splits='train', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hf_dataset_config_name=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: dataset_processing_num_proc_per_process=64, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: dataset_overwrite_cache=False, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: text_column_name='text'), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: seed=42, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_loading_workers=32))], [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: profiler=ProfilerArgs(profiler_export_path=Path('/fsx/ferdinandmom/ferdinand-hf/bench_cluster/results/llama-1B/16_GPUS/dp-1_tp-1_pp-16_mbz-1')), [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: lighteval=None) [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Model Config: [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: LlamaConfig(bos_token_id=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: eos_token_id=2, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hidden_act='silu', [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: hidden_size=2048, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: initializer_range=0.02, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: intermediate_size=4096, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: is_llama_config=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: max_position_embeddings=4096, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_attention_heads=32, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_hidden_layers=24, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: num_key_value_heads=32, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pad_token_id=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: pretraining_tp=1, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rms_norm_eps=1e-05, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rope_scaling=None, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: rope_theta=10000.0, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: tie_word_embeddings=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: use_cache=True, [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: vocab_size=50257) [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Building model.. [default0]:07/02/2024 14:30:33 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Setting PP block ranks... [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Total number of parameters: 1.21G (2312.82MiB) [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Local number of parameters: 187M (356.33MiB) [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 358.34MiB. Peak allocated: 360.37MiB Peak reserved: 368.00MiB [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Parametrizing model parameters using StandardParametrizator [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=6|TP=0|ip-26-0-161-178]: Local number of parameters: 83.9M (160.02MiB) [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=6|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=6|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=1|TP=0|ip-26-0-161-178]: Local number of parameters: 83.9M (160.02MiB) [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=1|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=1|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=3|TP=0|ip-26-0-161-178]: Local number of parameters: 83.9M (160.02MiB) [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=3|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=3|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=7|TP=0|ip-26-0-161-178]: Local number of parameters: 83.9M (160.02MiB) [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=7|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=7|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=2|TP=0|ip-26-0-161-178]: Local number of parameters: 41.9M (80.01MiB) [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=2|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 81.02MiB. Peak allocated: 83.05MiB Peak reserved: 96.00MiB [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=2|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=5|TP=0|ip-26-0-161-178]: Local number of parameters: 41.9M (80.01MiB) [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=5|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 81.02MiB. Peak allocated: 83.05MiB Peak reserved: 96.00MiB [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=5|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=4|TP=0|ip-26-0-161-178]: Local number of parameters: 83.9M (160.02MiB) [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=4|TP=0|ip-26-0-161-178]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=4|TP=0|ip-26-0-161-178]: No checkpoint path provided. [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=12|TP=0|ip-26-0-167-177]: Local number of parameters: 83.9M (160.02MiB) [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=12|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default4]:07/02/2024 14:30:50 [INFO|DP=0|PP=12|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=8|TP=0|ip-26-0-167-177]: Local number of parameters: 41.9M (80.01MiB) [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=8|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 81.02MiB. Peak allocated: 83.05MiB Peak reserved: 96.00MiB [default0]:07/02/2024 14:30:50 [INFO|DP=0|PP=8|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=11|TP=0|ip-26-0-167-177]: Local number of parameters: 41.9M (80.01MiB) [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=11|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 81.02MiB. Peak allocated: 83.05MiB Peak reserved: 96.00MiB [default3]:07/02/2024 14:30:50 [INFO|DP=0|PP=11|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=14|TP=0|ip-26-0-167-177]: Local number of parameters: 103M (196.32MiB) [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=14|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 196.33MiB. Peak allocated: 196.34MiB Peak reserved: 200.00MiB [default6]:07/02/2024 14:30:50 [INFO|DP=0|PP=14|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=10|TP=0|ip-26-0-167-177]: Local number of parameters: 83.9M (160.02MiB) [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=10|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default2]:07/02/2024 14:30:50 [INFO|DP=0|PP=10|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: Local number of parameters: 0 (0.00MiB) [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=9|TP=0|ip-26-0-167-177]: Local number of parameters: 83.9M (160.02MiB) [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=9|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 0.01MiB. Peak allocated: 0.02MiB Peak reserved: 2.00MiB [default7]:07/02/2024 14:30:50 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default1]:07/02/2024 14:30:50 [INFO|DP=0|PP=9|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=13|TP=0|ip-26-0-167-177]: Local number of parameters: 83.9M (160.02MiB) [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=13|TP=0|ip-26-0-167-177]: [After model building] Memory usage: 162.03MiB. Peak allocated: 164.06MiB Peak reserved: 170.00MiB [default5]:07/02/2024 14:30:50 [INFO|DP=0|PP=13|TP=0|ip-26-0-167-177]: No checkpoint path provided. [default0]:07/02/2024 14:30:51 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [Optimizer Building] Using LearningRateForSP as learning rate [default0]:07/02/2024 14:30:51 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [ZeRO sharding] Size of optimizer params per rank: [default0]:07/02/2024 14:30:51 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [ZeRO sharding] DP Rank 0 has 187M out of 187M (100.00%) params' optimizer states [default0]:07/02/2024 14:30:52 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [Training Plan] Stage Training Stage has 19 remaining training steps and has consumed 0 samples [default0]:07/02/2024 14:30:52 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Using `datasets` library [default0]:07/02/2024 14:30:52 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Loading tokenizer from openai-community/gpt2 and transformers/hf_hub versions ('4.41.2', '0.23.4') [default0]:Repo card metadata block was not found. Setting CardData to empty. [default0]:07/02/2024 14:30:53 [WARNING|DP=0|PP=0|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [Training Plan] There are 1 training stages [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [Stage Training Stage] start from step 1 [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: [Start training] datetime: 2024-07-02 14:30:55.097214 | mbs: 1 | grad_accum: 1024 | global_batch_size: 1024 | sequence_length: 4096 | train_steps: 20 | start_iteration_step: 0 | consumed_train_samples: 0 [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Resuming training from stage Training Stage, it has trained for 0 samples and has 19 remaining train steps [default0]:07/02/2024 14:30:55 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 1783.67MiB. Peak allocated 1783.67MiB. Peak reserved: 1796.00MiB [default6]:07/02/2024 14:30:55 [WARNING|DP=0|PP=6|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default6]:Repo card metadata block was not found. Setting CardData to empty. [default3]:07/02/2024 14:30:55 [WARNING|DP=0|PP=11|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default5]:Repo card metadata block was not found. Setting CardData to empty. [default5]:07/02/2024 14:30:55 [WARNING|DP=0|PP=13|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default3]:Repo card metadata block was not found. Setting CardData to empty. [default1]:07/02/2024 14:30:55 [WARNING|DP=0|PP=1|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default4]:Repo card metadata block was not found. Setting CardData to empty. [default3]:07/02/2024 14:30:55 [WARNING|DP=0|PP=3|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default7]:07/02/2024 14:30:55 [WARNING|DP=0|PP=7|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default5]:07/02/2024 14:30:55 [WARNING|DP=0|PP=5|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default1]:Repo card metadata block was not found. Setting CardData to empty. [default4]:07/02/2024 14:30:55 [WARNING|DP=0|PP=4|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default7]:Repo card metadata block was not found. Setting CardData to empty. [default3]:Repo card metadata block was not found. Setting CardData to empty. [default5]:Repo card metadata block was not found. Setting CardData to empty. [default4]:Repo card metadata block was not found. Setting CardData to empty. [default4]:07/02/2024 14:30:55 [WARNING|DP=0|PP=12|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default0]:07/02/2024 14:30:55 [WARNING|DP=0|PP=8|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default6]:07/02/2024 14:30:55 [WARNING|DP=0|PP=14|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default2]:07/02/2024 14:30:55 [WARNING|DP=0|PP=10|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default2]:Repo card metadata block was not found. Setting CardData to empty. [default1]:Repo card metadata block was not found. Setting CardData to empty. [default1]:07/02/2024 14:30:55 [WARNING|DP=0|PP=9|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default0]:Repo card metadata block was not found. Setting CardData to empty. [default6]:Repo card metadata block was not found. Setting CardData to empty. [default2]:07/02/2024 14:30:55 [WARNING|DP=0|PP=2|TP=0|ip-26-0-161-178]: Repo card metadata block was not found. Setting CardData to empty. [default2]:Repo card metadata block was not found. Setting CardData to empty. [default7]:Repo card metadata block was not found. Setting CardData to empty. [default7]:07/02/2024 14:30:55 [WARNING|DP=0|PP=15|TP=0|ip-26-0-167-177]: Repo card metadata block was not found. Setting CardData to empty. [default6]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default6]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default5]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default5]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default4]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default4]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default3]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default3]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default2]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default2]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default1]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default1]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default0]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: Attempting to run cuBLAS, but there was no current CUDA context! Attempting to set the primary context... (Triggered internally at ../aten/src/ATen/cuda/CublasHandlePool.cpp:135.) [default0]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default0]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default0]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default7]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default7]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default6]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default6]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default5]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default5]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default4]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default4]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default3]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default3]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default2]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default2]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default1]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default1]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default0]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: Attempting to run cuBLAS, but there was no current CUDA context! Attempting to set the primary context... (Triggered internally at ../aten/src/ATen/cuda/CublasHandlePool.cpp:135.) [default0]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default0]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/autograd/graph.py:744: UserWarning: c10d::allreduce_: an autograd kernel was not registered to the Autograd key(s) but we are trying to backprop through it. This may lead to silently incorrect behavior. This behavior is deprecated and will be removed in a future version of PyTorch. If your operator is differentiable, please ensure you have registered an autograd kernel to the correct Autograd key (e.g. DispatchKey::Autograd, DispatchKey::CompositeImplicitAutograd). If your operator is not differentiable, or to squash this warning and use the previous behavior, please register torch::CppFunction::makeFallthrough() to DispatchKey::Autograd. (Triggered internally at ../torch/csrc/autograd/autograd_not_implemented_fallback.cpp:63.) [default0]: return Variable._execution_engine.run_backward( # Calls into the C++ engine to run the backward pass [default6]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/distributed/distributed_c10d.py:2261: UserWarning: torch.distributed.all_reduce_coalesced will be deprecated. If you must use it, please revisit our documentation later at https://pytorch.org/docs/master/distributed.html#collective-functions [default6]: warnings.warn( [default0]:07/02/2024 14:32:45 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 1848.71MiB. Peak allocated 11279.70MiB. Peak reserved: 11456.00MiB [default0]:/fsx/ferdinandmom/miniforge3/envs/env-bench-cluster/lib/python3.10/site-packages/torch/distributed/distributed_c10d.py:2261: UserWarning: torch.distributed.all_reduce_coalesced will be deprecated. If you must use it, please revisit our documentation later at https://pytorch.org/docs/master/distributed.html#collective-functions [default0]: warnings.warn( [default0]:07/02/2024 14:32:46 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 3274.04MiB. Peak reserved: 12244.00MiB [default7]:07/02/2024 14:32:46 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 1 / 20 | consumed_tokens: 4.19M | elapsed_time_per_iteration_ms: 105K | tokens_per_sec: 40K | tokens_per_sec_per_gpu: 2.5K | global_batch_size: 1.02K | lm_loss: 11.1 | lr: 0.0001 | model_tflops_per_gpu: 22.7 | hardware_tflops_per_gpu: 22.7 | grad_norm: 25.6 | cuda_memory_allocated: 571K | cuda_max_memory_reserved: 2.89G | hd_total_memory_tb: 312G | hd_used_memory_tb: 65.9G | hd_free_memory_tb: 246G [default0]:07/02/2024 14:33:36 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13040.00MiB [default0]:07/02/2024 14:33:36 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 3274.05MiB. Peak reserved: 13040.00MiB [default7]:07/02/2024 14:33:36 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 2 / 20 | consumed_tokens: 8.39M | elapsed_time_per_iteration_ms: 50.8K | tokens_per_sec: 82.5K | tokens_per_sec_per_gpu: 5.16K | global_batch_size: 1.02K | lm_loss: 11.1 | lr: 9.53e-05 | model_tflops_per_gpu: 46.8 | hardware_tflops_per_gpu: 46.8 | grad_norm: 25.9 | cuda_memory_allocated: 571K | cuda_max_memory_reserved: 2.89G | hd_total_memory_tb: 312G | hd_used_memory_tb: 65.9G | hd_free_memory_tb: 246G [default0]:07/02/2024 14:34:27 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:34:27 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 3 / 20 | consumed_tokens: 12.6M | elapsed_time_per_iteration_ms: 50.9K | tokens_per_sec: 82.3K | tokens_per_sec_per_gpu: 5.15K | global_batch_size: 1.02K | lm_loss: 9.9 | lr: 9.05e-05 | model_tflops_per_gpu: 46.7 | hardware_tflops_per_gpu: 46.7 | grad_norm: 40.4 | cuda_memory_allocated: 571K | cuda_max_memory_reserved: 2.89G | hd_total_memory_tb: 312G | hd_used_memory_tb: 65.9G | hd_free_memory_tb: 246G [default0]:STAGE:2024-07-02 14:34:27 157959:157959 ActivityProfilerController.cpp:314] Completed Stage: Warm Up [default0]:07/02/2024 14:34:27 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 3274.05MiB. Peak reserved: 13042.00MiB [default0]:07/02/2024 14:35:15 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default0]:07/02/2024 14:35:15 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 3274.05MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:35:15 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 4 / 20 | consumed_tokens: 16.8M | elapsed_time_per_iteration_ms: 47.8K | tokens_per_sec: 87.7K | tokens_per_sec_per_gpu: 5.48K | global_batch_size: 1.02K | lm_loss: 11.9 | lr: 8.58e-05 | model_tflops_per_gpu: 49.7 | hardware_tflops_per_gpu: 49.7 | grad_norm: 61.2 | cuda_memory_allocated: 571K | cuda_max_memory_reserved: 2.89G | hd_total_memory_tb: 312G | hd_used_memory_tb: 65.9G | hd_free_memory_tb: 246G [default0]:07/02/2024 14:36:02 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:36:02 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 5 / 20 | consumed_tokens: 21M | elapsed_time_per_iteration_ms: 46.6K | tokens_per_sec: 90.1K | tokens_per_sec_per_gpu: 5.63K | global_batch_size: 1.02K | lm_loss: 9.05 | lr: 8.11e-05 | model_tflops_per_gpu: 51.1 | hardware_tflops_per_gpu: 51.1 | grad_norm: 8.31 [default7]:07/02/2024 14:36:53 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 6 / 20 | consumed_tokens: 25.2M | elapsed_time_per_iteration_ms: 51.5K | tokens_per_sec: 81.5K | tokens_per_sec_per_gpu: 5.09K | global_batch_size: 1.02K | lm_loss: 8.86 | lr: 7.63e-05 | model_tflops_per_gpu: 46.2 | hardware_tflops_per_gpu: 46.2 | grad_norm: 6.63 [default0]:STAGE:2024-07-02 14:37:48 157959:157959 ActivityProfilerController.cpp:320] Completed Stage: Collection [default0]:STAGE:2024-07-02 14:37:54 157959:157959 ActivityProfilerController.cpp:324] Completed Stage: Post Processing [default0]:07/02/2024 14:44:43 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:45:47 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 7 / 20 | consumed_tokens: 29.4M | elapsed_time_per_iteration_ms: 534K | tokens_per_sec: 7.85K | tokens_per_sec_per_gpu: 491 | global_batch_size: 1.02K | lm_loss: 8.37 | lr: 7.16e-05 | model_tflops_per_gpu: 4.45 | hardware_tflops_per_gpu: 4.45 | grad_norm: 4.93 [default0]:07/02/2024 14:45:47 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:46:41 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 8 / 20 | consumed_tokens: 33.6M | elapsed_time_per_iteration_ms: 53.8K | tokens_per_sec: 78K | tokens_per_sec_per_gpu: 4.88K | global_batch_size: 1.02K | lm_loss: 7.97 | lr: 6.68e-05 | model_tflops_per_gpu: 44.2 | hardware_tflops_per_gpu: 44.2 | grad_norm: 3.13 [default0]:07/02/2024 14:46:41 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:47:29 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 9 / 20 | consumed_tokens: 37.7M | elapsed_time_per_iteration_ms: 47.5K | tokens_per_sec: 88.4K | tokens_per_sec_per_gpu: 5.52K | global_batch_size: 1.02K | lm_loss: 7.83 | lr: 6.21e-05 | model_tflops_per_gpu: 50.1 | hardware_tflops_per_gpu: 50.1 | grad_norm: 9.04 [default0]:07/02/2024 14:47:29 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:48:17 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 10 / 20 | consumed_tokens: 41.9M | elapsed_time_per_iteration_ms: 48K | tokens_per_sec: 87.3K | tokens_per_sec_per_gpu: 5.46K | global_batch_size: 1.02K | lm_loss: 7.62 | lr: 5.74e-05 | model_tflops_per_gpu: 49.5 | hardware_tflops_per_gpu: 49.5 | grad_norm: 5.09 [default0]:07/02/2024 14:48:17 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default0]:07/02/2024 14:49:05 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:49:05 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 11 / 20 | consumed_tokens: 46.1M | elapsed_time_per_iteration_ms: 47.9K | tokens_per_sec: 87.6K | tokens_per_sec_per_gpu: 5.47K | global_batch_size: 1.02K | lm_loss: 7.47 | lr: 5.26e-05 | model_tflops_per_gpu: 49.7 | hardware_tflops_per_gpu: 49.7 | grad_norm: 4.06 [default7]:07/02/2024 14:49:50 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 12 / 20 | consumed_tokens: 50.3M | elapsed_time_per_iteration_ms: 45.7K | tokens_per_sec: 91.7K | tokens_per_sec_per_gpu: 5.73K | global_batch_size: 1.02K | lm_loss: 7.34 | lr: 4.79e-05 | model_tflops_per_gpu: 52 | hardware_tflops_per_gpu: 52 | grad_norm: 3.12 [default0]:07/02/2024 14:49:50 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:50:38 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 13 / 20 | consumed_tokens: 54.5M | elapsed_time_per_iteration_ms: 48K | tokens_per_sec: 87.4K | tokens_per_sec_per_gpu: 5.46K | global_batch_size: 1.02K | lm_loss: 7.23 | lr: 4.32e-05 | model_tflops_per_gpu: 49.6 | hardware_tflops_per_gpu: 49.6 | grad_norm: 2.73 [default0]:07/02/2024 14:50:38 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:51:23 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 14 / 20 | consumed_tokens: 58.7M | elapsed_time_per_iteration_ms: 44.7K | tokens_per_sec: 93.8K | tokens_per_sec_per_gpu: 5.86K | global_batch_size: 1.02K | lm_loss: 7.14 | lr: 3.84e-05 | model_tflops_per_gpu: 53.2 | hardware_tflops_per_gpu: 53.2 | grad_norm: 2.33 [default0]:07/02/2024 14:51:23 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:52:09 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 15 / 20 | consumed_tokens: 62.9M | elapsed_time_per_iteration_ms: 46.2K | tokens_per_sec: 90.8K | tokens_per_sec_per_gpu: 5.68K | global_batch_size: 1.02K | lm_loss: 7.06 | lr: 3.37e-05 | model_tflops_per_gpu: 51.5 | hardware_tflops_per_gpu: 51.5 | grad_norm: 2.48 [default0]:07/02/2024 14:52:09 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default0]:07/02/2024 14:52:56 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:52:56 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 16 / 20 | consumed_tokens: 67.1M | elapsed_time_per_iteration_ms: 47K | tokens_per_sec: 89.2K | tokens_per_sec_per_gpu: 5.58K | global_batch_size: 1.02K | lm_loss: 6.98 | lr: 2.89e-05 | model_tflops_per_gpu: 50.6 | hardware_tflops_per_gpu: 50.6 | grad_norm: 2.66 [default0]:07/02/2024 14:53:42 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:53:42 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 17 / 20 | consumed_tokens: 71.3M | elapsed_time_per_iteration_ms: 46K | tokens_per_sec: 91.1K | tokens_per_sec_per_gpu: 5.69K | global_batch_size: 1.02K | lm_loss: 6.9 | lr: 2.42e-05 | model_tflops_per_gpu: 51.7 | hardware_tflops_per_gpu: 51.7 | grad_norm: 1.89 [default7]:07/02/2024 14:54:26 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 18 / 20 | consumed_tokens: 75.5M | elapsed_time_per_iteration_ms: 43.5K | tokens_per_sec: 96.4K | tokens_per_sec_per_gpu: 6.03K | global_batch_size: 1.02K | lm_loss: 6.84 | lr: 1.95e-05 | model_tflops_per_gpu: 54.7 | hardware_tflops_per_gpu: 54.7 | grad_norm: 1.61 [default0]:07/02/2024 14:54:26 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default0]:07/02/2024 14:55:13 [INFO|DP=0|PP=0|TP=0|ip-26-0-161-178]: Memory usage: 3274.04MiB. Peak allocated 12603.56MiB. Peak reserved: 13042.00MiB [default7]:07/02/2024 14:55:13 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 19 / 20 | consumed_tokens: 79.7M | elapsed_time_per_iteration_ms: 47.5K | tokens_per_sec: 88.2K | tokens_per_sec_per_gpu: 5.51K | global_batch_size: 1.02K | lm_loss: 6.8 | lr: 1.47e-05 | model_tflops_per_gpu: 50 | hardware_tflops_per_gpu: 50 | grad_norm: 1.85 [default7]:07/02/2024 14:55:58 [INFO|DP=0|PP=15|TP=0|ip-26-0-167-177]: iteration: 20 / 20 | consumed_tokens: 83.9M | elapsed_time_per_iteration_ms: 44.7K | tokens_per_sec: 93.9K | tokens_per_sec_per_gpu: 5.87K | global_batch_size: 1.02K | lm_loss: 6.76 | lr: 1e-05 | model_tflops_per_gpu: 53.2 | hardware_tflops_per_gpu: 53.2 | grad_norm: 1.81 Saved 1 csv files over 1 completed logs Processing file: /fsx/ferdinandmom/ferdinand-hf/bench_cluster/results/llama-1B/16_GPUS/dp-1_tp-1_pp-16_mbz-1/profiler/ip-26-0-161-178_157959.1719931391546523089.pt.trace.json Results written to /fsx/ferdinandmom/ferdinand-hf/bench_cluster/results/llama-1B/16_GPUS/dp-1_tp-1_pp-16_mbz-1/profiler.csv Consider using `hf_transfer` for faster uploads. This solution comes with some limitations. See https://huggingface.co/docs/huggingface_hub/hf_transfer for more details. ip-26-0-161-178_157959.1719931391546523089.pt.trace.json: 0%| | 0.00/13.4G [00:00