2023-06-15 14:21:25,543 INFO [decode.py:639] Decoding started
2023-06-15 14:21:25,544 INFO [decode.py:645] Device: cuda:0
2023-06-15 14:21:27,123 INFO [lexicon.py:168] Loading pre-compiled data/lang_char/Linv.pt
2023-06-15 14:21:27,371 INFO [decode.py:656] {'best_train_loss': inf, 'best_valid_loss': inf, 'best_train_epoch': -1, 'best_valid_epoch': -1, 'batch_idx_train': 0, 'log_interval': 50, 'reset_interval': 200, 'valid_interval': 3000, 'feature_dim': 80, 'subsampling_factor': 4, 'warm_step': 2000, 'env_info': {'k2-version': '1.24.1', 'k2-build-type': 'Release', 'k2-with-cuda': True, 'k2-git-sha1': 'c51a0b9684442a88ee37f3ce0af686a04b66855b', 'k2-git-date': 'Mon May 1 21:38:03 2023', 'lhotse-version': '1.14.0.dev+git.0f812851.dirty', 'torch-version': '1.10.0+cu102', 'torch-cuda-available': True, 'torch-cuda-version': '10.2', 'python-version': '3.8', 'icefall-git-branch': 'zipformer_wenetspeech', 'icefall-git-sha1': '28d3f6d-dirty', 'icefall-git-date': 'Thu Jun 15 10:30:34 2023', 'icefall-path': '/star-kw/kangwei/code/icefall_wenetspeech', 'k2-path': '/ceph-hw/kangwei/code/k2_release/k2/k2/python/k2/__init__.py', 'lhotse-path': '/ceph-hw/kangwei/dev_tools/anaconda3/envs/rnnt2/lib/python3.8/site-packages/lhotse-1.14.0.dev0+git.0f812851.dirty-py3.8.egg/lhotse/__init__.py', 'hostname': 'de-74279-k2-train-10-0221105906-5745685d6b-t8zzx', 'IP address': '10.177.57.19'}, 'epoch': 10, 'iter': 0, 'avg': 2, 'use_averaged_model': True, 'exp_dir': PosixPath('zipformer/exp_L_causal_context_2'), 'lang_dir': PosixPath('data/lang_char'), 'decoding_method': 'modified_beam_search', 'beam_size': 4, 'beam': 20.0, 'ngram_lm_scale': 0.01, 'max_contexts': 8, 'max_states': 64, 'context_size': 2, 'max_sym_per_frame': 1, 'num_paths': 200, 'nbest_scale': 0.5, 'blank_penalty': 1.5, 'num_encoder_layers': '2,2,3,4,3,2', 'downsampling_factor': '1,2,4,8,4,2', 'feedforward_dim': '512,768,1024,1536,1024,768', 'num_heads': '4,4,4,8,4,4', 'encoder_dim': '192,256,384,512,384,256', 'query_head_dim': '32', 'value_head_dim': '12', 'pos_head_dim': '4', 'pos_dim': 48, 'encoder_unmasked_dim': '192,192,256,256,256,192', 'cnn_module_kernel': '31,31,15,15,15,31', 'decoder_dim': 512, 'joiner_dim': 512, 'causal': True, 'chunk_size': '16', 'left_context_frames': '128', 'manifest_dir': PosixPath('data/fbank'), 'max_duration': 1000, 'bucketing_sampler': True, 'num_buckets': 30, 'concatenate_cuts': False, 'duration_factor': 1.0, 'gap': 1.0, 'on_the_fly_feats': False, 'shuffle': True, 'return_cuts': True, 'num_workers': 2, 'enable_spec_aug': True, 'spec_aug_time_warp_factor': 80, 'enable_musan': True, 'training_subset': 'L', 'res_dir': PosixPath('zipformer/exp_L_causal_context_2/modified_beam_search'), 'suffix': 'epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model', 'blank_id': 0, 'vocab_size': 5537}
2023-06-15 14:21:27,371 INFO [decode.py:658] About to create model
2023-06-15 14:21:28,015 INFO [decode.py:725] Calculating the averaged model over epoch range from 8 (excluded) to 10
2023-06-15 14:21:39,344 INFO [decode.py:756] Number of model parameters: 76441818
2023-06-15 14:21:39,345 INFO [asr_datamodule.py:398] About to get dev cuts
2023-06-15 14:21:39,359 INFO [asr_datamodule.py:336] About to create dev dataset
2023-06-15 14:21:39,908 INFO [asr_datamodule.py:354] About to create dev dataloader
2023-06-15 14:21:39,909 INFO [asr_datamodule.py:403] About to get TEST_NET cuts
2023-06-15 14:21:39,913 INFO [asr_datamodule.py:367] About to create test dataset
2023-06-15 14:21:39,963 WARNING [decode.py:765] Exclude cut with ID TEST_NET_Y0000000004_0ub4ZzdHzBc_S00023 from decoding, num_frames : 8.
2023-06-15 14:21:40,469 INFO [asr_datamodule.py:408] About to get TEST_MEETING cuts
2023-06-15 14:21:40,474 INFO [asr_datamodule.py:367] About to create test dataset
2023-06-15 14:21:50,652 INFO [decode.py:536] batch 0/?, cuts processed until now is 130
2023-06-15 14:23:44,155 INFO [zipformer.py:1728] name=None, attn_weights_entropy = tensor([1.7348, 1.1421, 1.9772, 1.5748], device='cuda:0')
2023-06-15 14:24:32,063 INFO [decode.py:536] batch 20/?, cuts processed until now is 3192
2023-06-15 14:27:11,810 INFO [decode.py:536] batch 40/?, cuts processed until now is 6421
2023-06-15 14:29:10,849 INFO [zipformer.py:1728] name=None, attn_weights_entropy = tensor([1.3900, 1.4301, 1.6911, 1.8398, 1.2862, 1.6697, 1.6898, 1.8092],
       device='cuda:0')
2023-06-15 14:29:50,233 INFO [decode.py:536] batch 60/?, cuts processed until now is 10176
2023-06-15 14:30:13,769 INFO [zipformer.py:1728] name=None, attn_weights_entropy = tensor([3.0940, 1.5497, 3.0675, 2.0014], device='cuda:0')
2023-06-15 14:31:57,777 INFO [decode.py:536] batch 80/?, cuts processed until now is 13727
2023-06-15 14:32:05,376 INFO [decode.py:552] The transcripts are stored in zipformer/exp_L_causal_context_2/modified_beam_search/recogs-DEV-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:32:05,755 INFO [utils.py:562] [DEV-beam_size_4_blank_penalty_1.5] %WER 8.39% [27738 / 330498, 2808 ins, 9438 del, 15492 sub ]
2023-06-15 14:32:06,780 INFO [decode.py:565] Wrote detailed error stats to zipformer/exp_L_causal_context_2/modified_beam_search/errs-DEV-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:32:06,783 INFO [decode.py:581] 
For DEV, WER of different settings are:
beam_size_4_blank_penalty_1.5	8.39	best for DEV

2023-06-15 14:32:07,159 WARNING [decode.py:765] Exclude cut with ID TEST_NET_Y0000000004_0ub4ZzdHzBc_S00023 from decoding, num_frames : 8.
2023-06-15 14:32:16,721 INFO [decode.py:536] batch 0/?, cuts processed until now is 146
2023-06-15 14:33:49,867 INFO [zipformer.py:1728] name=None, attn_weights_entropy = tensor([1.7888, 1.5390, 1.4374, 1.2639, 1.4985, 1.4499, 1.6719, 1.4135],
       device='cuda:0')
2023-06-15 14:34:46,962 INFO [decode.py:536] batch 20/?, cuts processed until now is 4116
2023-06-15 14:37:30,776 INFO [decode.py:536] batch 40/?, cuts processed until now is 8601
2023-06-15 14:40:06,135 INFO [decode.py:536] batch 60/?, cuts processed until now is 14082
2023-06-15 14:42:41,729 INFO [decode.py:536] batch 80/?, cuts processed until now is 18750
2023-06-15 14:44:42,086 INFO [decode.py:536] batch 100/?, cuts processed until now is 24487
2023-06-15 14:44:57,856 INFO [decode.py:552] The transcripts are stored in zipformer/exp_L_causal_context_2/modified_beam_search/recogs-TEST_NET-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:44:58,382 INFO [utils.py:562] [TEST_NET-beam_size_4_blank_penalty_1.5] %WER 9.83% [40873 / 415746, 4362 ins, 7904 del, 28607 sub ]
2023-06-15 14:44:59,741 INFO [decode.py:565] Wrote detailed error stats to zipformer/exp_L_causal_context_2/modified_beam_search/errs-TEST_NET-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:44:59,744 INFO [decode.py:581] 
For TEST_NET, WER of different settings are:
beam_size_4_blank_penalty_1.5	9.83	best for TEST_NET

2023-06-15 14:45:09,117 INFO [decode.py:536] batch 0/?, cuts processed until now is 93
2023-06-15 14:47:21,098 INFO [zipformer.py:1728] name=None, attn_weights_entropy = tensor([1.3024, 2.8549, 1.6133, 2.8344], device='cuda:0')
2023-06-15 14:47:43,481 INFO [decode.py:536] batch 20/?, cuts processed until now is 2345
2023-06-15 14:50:21,820 INFO [decode.py:536] batch 40/?, cuts processed until now is 4929
2023-06-15 14:52:30,790 INFO [decode.py:536] batch 60/?, cuts processed until now is 7955
2023-06-15 14:53:01,575 INFO [decode.py:552] The transcripts are stored in zipformer/exp_L_causal_context_2/modified_beam_search/recogs-TEST_MEETING-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:53:01,852 INFO [utils.py:562] [TEST_MEETING-beam_size_4_blank_penalty_1.5] %WER 16.47% [36297 / 220385, 3637 ins, 12121 del, 20539 sub ]
2023-06-15 14:53:02,569 INFO [decode.py:565] Wrote detailed error stats to zipformer/exp_L_causal_context_2/modified_beam_search/errs-TEST_MEETING-beam_size_4_blank_penalty_1.5-epoch-10-avg-2-chunk-16-left-context-128-modified_beam_search-beam-size-4-blank-penalty-1.5-use-averaged-model.txt
2023-06-15 14:53:02,572 INFO [decode.py:581] 
For TEST_MEETING, WER of different settings are:
beam_size_4_blank_penalty_1.5	16.47	best for TEST_MEETING

2023-06-15 14:53:02,573 INFO [decode.py:801] Done!