The following sample output illustrates a successful simulation test run.

# ** Warning: LAVMM access from port           0 while disabled.
#    Time: 5 ns  Scope: basic_avl_tb_top.dut.dr_top_inst.tennm_sm_hssi_pld_chnl_dp_sip_atom_mux_arbiter_ch0.gen_lavmm_a[0].lavmm_a_proc.pdrw_a File: ../eth_10g/n_channel_superset_2100/sim/intelfpga/tennm_sm_hssi_pld_chnl_dp_sip_atom_mux_arbiter.sv Line: 388
# DR_STATUS_L0: DR NIOSV is alive with DR Firmware (Buildtime: 2024-09-06 07:30:09)
# DR_STATUS_L1: dr_startup_initialization()
# DR_STATUS_L1: dr_mif_checksum():
# DR_STATUS_L1: dr_mif_checksum() done (cksum = 0xa1cc)
# DR_STATUS_L1: dr_load_profile(): next_id=0x1, next_id_act=1 (1=Active 0=Neutral), init_startup=1
# DR_STATUS_L2: dr_onehot_mux_select_set(): profile_id=1, enable=1
# DR_STATUS_L1: dr_load_profile() done (error = 0)
# DR_STATUS_L1: dr_startup_initialization() done
# DR_STATUS_L0: DR NIOS is ready
# DR_STATUS_L0: DR NIOS waiting for trigger
# ** Info: Check CSR status
#    Time: 5375 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 260
# ** Info: DR Controller state:          5
#    Time: 5520000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 270
# ** Info: Waiting for reset ack
#    Time: 6520000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 273
# ** Info: Reset deasserted
#    Time: 8335 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 277
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_global_mem_wrap_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected> -          15797000000 (MSG_INFO) wpulse has been set to 010
# [STATUS_FSM] (@t = 15890700000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R4, W3 
# [STATUS_FSM] (@t = 15890700000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R4, W3 
# [STATUS_FSM] (@t = 16125900000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# [STATUS_FSM] (@t = 16155300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S2, R0, W0 
# [STATUS_FSM] (@t = 16155300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S2, R0, W0 
# [STATUS_FSM] (@t = 16155300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# [STATUS_FSM] (@t = 18174006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S2, R0, W0
# [STATUS_FSM] (@t = 18206006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# [STATUS_FSM] (@t = 18206006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# [STATUS_FSM] (@t = 27246006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S2, R0, W0
# [STATUS_FSM] (@t = 27326006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R4, W3
# [STATUS_FSM] (@t = 32558006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R4, W3
# ** Info: TSE Tx ready
#    Time: 32665 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 285
# ** Info: TSE Rx locked to ref and data
#    Time: 38345 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 287
# ** Info: TSE Rx ready
#    Time: 38405 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 289
# ** Info: TSE LED link is up
#    Time: 39185 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 292
# ** Info: ** Info: Program TSE DUT soft CSR ....
#    Time: 39185 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 295
# ** Info: Register 0x210 value : 000001a0
#    Time: 39295000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 299
# ** Info: PCS Control Register Register 0x200 value : 00000140
#    Time: 39405000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 304
# ** Info: Register 0x210 value : 000001a0
#    Time: 39465000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 307
# ** Info: Register 0x8 value : 0000003b
#    Time: 39555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 312
# ** Info: Checking data of TSE
#    Time: 59555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 317
# ** Info: Test case passed
#    Time: 89555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 323
# ** Info: Starting DR sequence from TSE to ETH NOFEC MRIP
#    Time: 89555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 328
# ** Info: Reset ETHs
#    Time: 90555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 330
# ** Info: Reset TSE
#    Time: 90555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 334
# ** Info: Waiting for reset ack
#    Time: 90555000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 340
# [STATUS_FSM] (@t = 90718006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# [STATUS_FSM] (@t = 90766006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S2, R0, W0 TO S0, R0, W0
# ** Info: Write from and to profile
#    Time: 90775 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 342
# [STATUS_FSM] (@t = 90782006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# [STATUS_FSM] (@t = 90782006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# ** Info: Trigger DR
#    Time: 90805000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 345
# [STATUS_FSM] (@t = 90814006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S2, R0, W0 TO S0, R0, W0
# ** Info: Wait for DR Ack....
#    Time: 90845000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 347
# [STATUS_FSM] (@t = 92565900000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S2, R0, W0 TO S0, R0, W0
# DR_STATUS_L0: DR NIOS reconfiguration started 
# DR_STATUS_L1: dr_load_se** Info: Wait for DR Config to be done....
#    Time: 95205 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 351
# quence():
# DR_STATUS_L1: dr_load_profile(): next_id=0x1, next_id_act=0 (1=Active 0=Neutral), init_startup=0
# DR_STATUS_L2: dr_src_get_pause_grant(): ch_mask 0x1
# DR_STATUS_L2: dr_src_get_pause_grant() done
# DR_STATUS_L2: dr_onehot_mux_select_set(): profile_id=1, enable=0
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x47, num_ip_settings=29
# [STATUS_FSM] (@t = 100680300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# [STATUS_FSM] (@t = 100768500000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x89, num_ip_settings=3
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x1f3, num_ip_settings=14
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x211, num_ip_settings=2
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_profile() done (error = 0)
# DR_STATUS_L1: dr_load_profile(): next_id=0x2, next_id_act=1 (1=Active 0=Neutral), init_startup=0
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x47, num_ip_settings=29
# [STATUS_FSM] (@t = 171769500000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x92, num_ip_settings=47
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x15d, num_ip_settings=25
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x19d, num_ip_settings=3
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L2: dr_onehot_mux_select_set(): profile_id=0, enable=1
# DR_STATUS_L1: dr_load_profile() done (error = 0)
# DR_STATUS_L2: dr_src_release_pause_request(): 0x1
# DR_STATUS_L2: dr_src_release_pause_request() done
# DR_STATUS_L1: dr_load_sequence() done, iteration to final profile successfully finish (iter=3)
# DR_STATUS_L0: DR NIOS reconfiguration done
# DR_STATUS_L0: DR NIOS ready for next trigger
# DR_STATUS_L0: DR NIOS waiting for trigger
# ** Info: Check error status
#    Time: 363755 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 355
# ** Info: DR Controller state:          5
#    Time: 363900000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 364
# [STATUS_FSM] (@t = 364192500000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R1, W4 
# [STATUS_FSM] (@t = 364427700000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 366862006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S0, R0, W0 TO S2, R0, W0
# ** Info: Reset deasserted
#    Time: 368900000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 370
# ** Info: Waiting for reset ack
#    Time: 368900000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 372
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# [STATUS_FSM] (@t = 369646006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# ** Info: Reset ack asserted
#    Time: 369655 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 374
# [STATUS_FSM] (@t = 369694006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# ** Info: Writing into SIP MRIP reg
#    Time: 369705 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 380
# [STATUS_FSM] (@t = 369726006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R1, W4 
# [STATUS_FSM] (@t = 369870006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 376014006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R1, W4
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# [STATUS_FSM] (@t = 379166006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 384478006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R1, W4
# ** Info: ETH Tx ready
#    Time: 384615 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 384
# ** Info: ETH Rx ready
#    Time: 390325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 387
# ** Info: Checking data ETH NOFEC
#    Time: 400325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 391
# ** Info: Test case passed
#    Time: 430325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 397
# ** Info: Starting DR sequence from ETH NOFEC MRIP to ETH FEC MRIP
#    Time: 430325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 403
# ** Info: Reset ETHs
#    Time: 431325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 405
# ** Info: Reset TSE
#    Time: 431325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 409
# ** Info: Waiting for reset ack
#    Time: 431325 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 415
# [STATUS_FSM] (@t = 431502006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# [STATUS_FSM] (@t = 431550006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S2, R0, W0 TO S0, R0, W0
# ** Info: Write from and to profile
#    Time: 431555 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 417
# [STATUS_FSM] (@t = 431566006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# [STATUS_FSM] (@t = 431566006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# ** Info: Trigger DR
#    Time: 431585000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 420
# [STATUS_FSM] (@t = 431598006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S2, R0, W0 TO S0, R0, W0
# ** Info: Wait for DR Ack....
#    Time: 431625000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 422
# DR_STATUS_L0: DR NIOS reconfiguration started 
# DR_STATUS_L1: dr[STATUS_FSM] (@t = 433341300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S2, R0, W0 TO S0, R0, W0
# _load_se** Info: Wait for DR Config to be done....
#    Time: 433405 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 426
# quence():
# DR_STATUS_L1: dr_load_profile(): next_id=0x2, next_id_act=0 (1=Active 0=Neutral), init_startup=0
# DR_STATUS_L2: dr_src_get_pause_grant(): ch_mask 0x1
# DR_STATUS_L2: dr_src_get_pause_grant() done
# DR_STATUS_L2: dr_onehot_mux_select_set(): profile_id=0, enable=0
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x47, num_ip_settings=29
# [STATUS_FSM] (@t = 438927300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# [STATUS_FSM] (@t = 439015500000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x89, num_ip_settings=3
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x15d, num_ip_settings=25
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x197, num_ip_settings=2
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_profile() done (error = 0)
# DR_STATUS_L1: dr_load_profile(): next_id=0x3, next_id_act=1 (1=Active 0=Neutral), init_startup=0
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x47, num_ip_settings=29
# [STATUS_FSM] (@t = 517572300000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change to RESET
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x92, num_ip_settings=47
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x1a6, num_ip_settings=26
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L1: dr_load_ip_settings(): ch=0, ip_settings_ndx=0x1ea, num_ip_settings=3
# DR_STATUS_L1: dr_load_ip_settings() done
# DR_STATUS_L2: dr_onehot_mux_select_set(): profile_id=2, enable=1
# DR_STATUS_L1: dr_load_profile() done (error = 0)
# DR_STATUS_L2: dr_src_release_pause_request(): 0x1
# DR_STATUS_L2: dr_src_release_pause_request() done
# DR_STATUS_L1: dr_load_sequence() done, iteration to final profile successfully finish (iter=3)
# DR_STATUS_L0: DR NIOS reconfiguration done
# DR_STATUS_L0: DR NIOS ready for next trigger
# DR_STATUS_L0: DR NIOS waiting for trigger
# ** Info: Check error status
#    Time: 710925 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 430
# ** Info: DR Controller state:          5
#    Time: 711070000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 439
# ** Info: Reset deasserted
#    Time: 711070000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 445
# ** Info: Waiting for reset ack
#    Time: 711070000001 fs  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 447
# [STATUS_FSM] (@t = 711347700000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R1, W4 
# [STATUS_FSM] (@t = 711582900000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 714014006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S0, R0, W0 TO S2, R0, W0
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# ** Info: Reset ack asserted
#    Time: 716825 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 449
# [STATUS_FSM] (@t = 716830006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S0, R0, W0 
# ** Info: Writing into SIP MRIP reg
#    Time: 716875 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 454
# [STATUS_FSM] (@t = 716878006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S0, R0, W0
# [STATUS_FSM] (@t = 716910006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from RESET to S5, R1, W4 
# [STATUS_FSM] (@t = 717054006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) State change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 723166006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R1, W4
# rck0_per = 6400.000000
# fast_per = 6399.360000
# slow_per = 6400.640000
# rck0_per = 6400.000000
# [STATUS_FSM] (@t = 726350006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from S0, R0, W0 TO S2, R0, W0
# [STATUS_FSM] (@t = 731662006000) (basic_avl_tb_top.dut.dr_top_inst.tennm_ipfluxtop_uxtop_wrap_ch0_0.sf_rtl_ncrypt_inst.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>.<protected>) Finished state change from RESET to S5, R1, W4
# ** Info: ETH Tx ready
#    Time: 738555 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 458
# ** Info: ETH Rx ready
#    Time: 758395 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 461
# ** Info: Checking data of ETH FEC MRIP
#    Time: 768395 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 465
# ** Info: Test case passed
#    Time: 798395 ns  Scope: basic_avl_tb_top.tc File: ./basic_avl_tb_top.sv Line: 471
# ** Note: $finish    : ./basic_avl_tb_top.sv(475)
#    Time: 798395 ns  Iteration: 0  Instance: /basic_avl_tb_top