eNB log

 nano@nano:~/openairinterface5g/myworkspace$ ./run.band7.tm1.sh
[sudo] nano 的密码：
# /dev/cpu_dma_latency set to 0us
log init done
Running with XFORMS!
num component carrier 1
WARNING: setting 'gtpu_log_level' not found in configuration file
WARNING: setting 'gtpu_log_verbosity' not found in configuration file
WARNING: setting 'udp_log_level' not found in configuration file
WARNING: setting 'udp_log_verbosity' not found in configuration file
WARNING: setting 'osa_log_level' not found in configuration file
WARNING: setting 'osa_log_verbosity' not found in configuration file

----------------------------------------------------------------------
 ENB CONFIG FILE CONTENT LOADED (TBC):
----------------------------------------------------------------------
ENB CONFIG for instance 0:

    eNB name:               eNB_Eurecom_LTEBox:
    eNB ID:                 3584:
    Cell type:              CELL_MACRO_ENB:
    TAC:                    1:
    MCC:                    208:
    MNC:                    92:

    node_function for CC 0:          eNodeB_3GPP:
    node_timing for CC 0:            synch_to_ext_device:
    node_synch_ref for CC 0:         0:
    eutra band for CC 0:             7:
    downlink freq for CC 0:          2660000000:
    uplink freq offset for CC 0:     -120000000:

    Cell ID for CC 0:    0:
    N_RB_DL for CC 0:    25:
    nb_antenna_ports for CC 0:    1:
    nb_antennas_tx for CC 0:    1:
    nb_antennas_rx for CC 0:    1:
    rach_numberOfRA_Preambles for CC 0:    15:
    rach_preamblesGroupAConfig for CC 0:    0:
    rach_powerRampingStep for CC 0:    2:
    rach_preambleInitialReceivedTargetPower for CC 0:    8:
    rach_preambleTransMax for CC 0:    6:
    rach_raResponseWindowSize for CC 0:    7:
    rach_macContentionResolutionTimer for CC 0:    5:
    rach_maxHARQ_Msg3Tx for CC 0:    4:
    bcch_modificationPeriodCoeff for CC 0:    0:
    pcch_defaultPagingCycle for CC 0:    2:
    pcch_nB for CC 0:    2:
    prach_root for CC 0:    0:
    prach_config_index for CC 0:    0:
    prach_high_speed for CC 0:    0:
    prach_zero_correlation for CC 0:    1:
    prach_freq_offset for CC 0:    2:
    pdsch_referenceSignalPower for CC 0:    -24:
    pdsch_p_b for CC 0:    0:
    pusch_n_SB for CC 0:    1:
    pusch_hoppingMode for CC 0:    0:
    pusch_hoppingOffset for CC 0:    0:
    pusch_enable64QAM for CC 0:    0:
    pusch_groupHoppingEnabled for CC 0:    1:
    pusch_groupAssignment for CC 0:    0:
    pusch_sequenceHoppingEnabled for CC 0:    0:
    pusch_nDMRS1 for CC 0:    1:
    pucch_delta_shift for CC 0:    0:
    pucch_nRB_CQI for CC 0:    1:
    pucch_nCS_AN for CC 0:    0:
    srs_enable for CC 0:    0:
    pusch_p0_Nominal for CC 0:    -90:
    pucch_p0_Nominal for CC 0:    -96:
    pusch_alpha for CC 0:    7:
    pucch_deltaF_Format1 for CC 0:    2:
    pucch_deltaF_Format1b for CC 0:    1:
    pucch_deltaF_Format2 for CC 0:    1:
    pucch_deltaF_Format2a for CC 0:    1:
    pucch_deltaF_Format2b for CC 0:    1:
    msg3_delta_Preamble for CC 0:    6:
    ul_CyclicPrefixLength for CC 0:    0:
    ue_TimersAndConstants_t300 for CC 0:    5:
    ue_TimersAndConstants_t301 for CC 0:    5:
    ue_TimersAndConstants_t310 for CC 0:    5:
    ue_TimersAndConstants_n310 for CC 0:    7:
    ue_TimersAndConstants_t311 for CC 0:    3:
    ue_TimersAndConstants_n311 for CC 0:    0:
    ue_TransmissionMode for CC 0:    0:

    Global log level:      info
    HW log level:          info
    PHY log level:         info
    MAC log level:         info
    RLC log level:         info
    PDCP log level:        info
    RRC log level:         info
    UDP log level:         info
    GTP log level:         info
    OSA log level:         info

--------------------------------------------------------
Downlink frequency/ uplink offset of CC_id 0 set to 2660000000/-120000000
configuring for eNB
CPU Freq is 2.304217
[NETLINK] Error opening socket -1 (93:Protocol not supported)
[NETLINK]Opened socket with fd -1
[NETLINK] Error fcntl (9:Bad file descriptor)
reported resolution = 1 ns
[HW][I]Version: Branch: develop Abrev. Hash: 7580d021d Date: Tue Jun 6 17:59:32 2017 +0200
[PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 0, osf 1
lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512
[PHY][I][eNB 0] Initializing DL_FRAME_PARMS : N_RB_DL 25, PHICH Resource 1, PHICH Duration 0
[openair][LTE_PHY][INIT] common_vars->txdataF[0][0] = 0x7fb76a28e040 (286720 bytes)
[openair][LTE_PHY][INIT] common_vars->txdataF[0][5] = 0x7fb76a247040 (286720 bytes)
[openair][LTE_PHY][INIT] common_vars->txdata[0][0] = 0x7fb76a1fb040 (307200 bytes)
[openair][LTE_PHY][INIT] common_vars->rxdata[0][0] = 0x7fb76a1af040 (307200 bytes)
[openair][LTE_PHY][INIT] common_vars->rxdata_7_5kHz[0][0] = 0x5556df3bbd00 (61440 bytes)
[openair][LTE_PHY][INIT] prach_vars->rxsigF[0] = 0x5556df786a60
[openair][LTE_PHY][INIT] prach_vars->prach_ifft[0] = 0x5556df78cac0
[PHY][I]init eNB: Node Function 0
[PHY][I]init eNB: Nid_cell 0
[PHY][I]init eNB: frame_type 0,tdd_config 3
[PHY][I]init eNB: number of ue max 16 number of enb max 1 number of harq pid max 8
[PHY][I]init eNB: N_RB_DL 25
[PHY][I]init eNB: prach_config_index 0
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 0
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 0
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 1
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 1
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 2
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 2
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 3
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 3
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 4
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 4
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 5
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 5
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 6
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 6
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 7
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 7
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 8
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 8
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 9
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 9
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 10
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 10
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 11
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 11
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 12
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 12
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 13
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 13
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 14
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 14
[PHY][I]Allocating Transport Channel Buffers for DLSCH, UE 15
[PHY][I]Allocating Transport Channel Buffer for ULSCH, UE 15
CPU Freq is 2.304208
frame_parms->N_RB_DL=25
frame_parms->N_RB_UL=25
frame_parms->Nid_cell=0
frame_parms->Ncp=0
frame_parms->Ncp_UL=0
frame_parms->nushift=0
frame_parms->frame_type=0
frame_parms->tdd_config=3
frame_parms->tdd_config_S=0
frame_parms->mode1_flag=1
frame_parms->nb_antenna_ports_eNB=1
frame_parms->nb_antennas_tx=1
frame_parms->nb_antennas_rx=1
frame_parms->ofdm_symbol_size=512
frame_parms->nb_prefix_samples=36
frame_parms->nb_prefix_samples0=40
frame_parms->first_carrier_offset=362
frame_parms->samples_per_tti=7680
frame_parms->symbols_per_tti=14
HW: Configuring card 0, nb_antennas_tx/rx 1/1
Card 0, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 0, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 0, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 0, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 1, nb_antennas_tx/rx 1/1
Card 1, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 1, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 1, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 1, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 2, nb_antennas_tx/rx 1/1
Card 2, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 2, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 2, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 2, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 3, nb_antennas_tx/rx 1/1
Card 3, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 3, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 3, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 3, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 4, nb_antennas_tx/rx 1/1
Card 4, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 4, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 4, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 4, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 5, nb_antennas_tx/rx 1/1
Card 5, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 5, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 5, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 5, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 6, nb_antennas_tx/rx 1/1
Card 6, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 6, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 6, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 6, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
HW: Configuring card 7, nb_antennas_tx/rx 1/1
Card 7, channel 0, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 2660000000.000000, rx_freq 2540000000.000000
Card 7, channel 1, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 7, channel 2, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
Card 7, channel 3, Setting tx_gain 90.000000, rx_gain 125.000000, tx_freq 0.000000, rx_freq 0.000000
[HW][I]CPU Affinity of main() function is...  CPU_0  CPU_1  CPU_2  CPU_3
[PHY][I]Intializing L2
[MAC][I][l2_init] [MAIN] MAC_INIT_GLOBAL_PARAM IN...
[MAC][I][mac_init_global_param] [MAIN] CALLING RLC_MODULE_INIT...
[MAC][I][mac_init_global_param] [MAIN] RLC_MODULE_INIT OK, malloc16 for mac_rlc_xface...
[MAC][I][mac_init_global_param] [MAIN] malloc16 OK, mac_rlc_xface @ 0x5556e144b2c0
[MAC][I][mac_init_global_param] [MAIN] RLC interface setup and init
[PDCP][I]PDCP layer has been initialized
[MAC][I][mac_init_global_param] [MAIN] Init Global Param Done
[MAC][I][l2_init] [MAIN] init eNB MAC functions  
[MAC][I][l2_init] [MAIN] init UE MAC functions
[MAC][I][l2_init] [MAIN] PHY Frame configuration
[MAC][I][mac_top_init] [MAIN] Init function start:Nb_UE_INST=0
[MAC][I][mac_top_init] [MAIN] Init function start:Nb_eNB_INST=1
[MAC][I][mac_top_init] [MAIN] calling RRC
[RRC][I][eNB] handover active state is 0
[RRC][I][eNB] eMBMS active state is 0
[MAC][I][mac_top_init] [MAIN][INIT] Init function finished
[SCTP][I][sctp_eNB_task] Starting SCTP layer
[S1AP][I][s1ap_eNB_task] Starting S1AP layer
[UDP][I]Initializing UDP task interface
[UDP][I]Initializing UDP task interface: DONE
[GTPV1U][I]Initializing GTPU stack 0x5556ca25e800
ITTI tasks created
Wait for the ITTI initialize message
[ENB_APP][I][eNB_app_register] [eNB 0] eNB_app_register for instance 0
[S1AP][I][s1ap_eNB_handle_register_eNB] Registered new eNB[0] and macro eNB id 3584
[S1AP][I][s1ap_eNB_register_mme] [eNB 0] check the mme registration state
[SCTP][I][sctp_handle_new_association_req] Converted ipv4 address 127.0.0.20 to network type
[SCTP][I][sctp_handle_new_association_req] connectx assoc_id  1 in progress..., used 1 addresses
[SCTP][I][sctp_handle_new_association_req] Inserted new descriptor for sd 40 in list, nb elements 1, assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32769
[SCTP][I][sctp_eNB_read_from_socket] Client association changed: 0
[SCTP][I][sctp_get_peeraddresses] ----------------------
[SCTP][I][sctp_get_peeraddresses] Peer addresses:
[SCTP][I][sctp_get_peeraddresses]     - [127.0.0.20]
[SCTP][I][sctp_get_peeraddresses] ----------------------
[SCTP][I][sctp_get_sockinfo] ----------------------
[SCTP][I][sctp_get_sockinfo] SCTP Status:
[SCTP][I][sctp_get_sockinfo] assoc id .....: 1
[SCTP][I][sctp_get_sockinfo] state ........: 4
[SCTP][I][sctp_get_sockinfo] instrms ......: 2
[SCTP][I][sctp_get_sockinfo] outstrms .....: 2
[SCTP][I][sctp_get_sockinfo] fragmentation : 65484
[SCTP][I][sctp_get_sockinfo] pending data .: 0
[SCTP][I][sctp_get_sockinfo] unack data ...: 0
[SCTP][I][sctp_get_sockinfo] rwnd .........: 106496
[SCTP][I][sctp_get_sockinfo] peer info     :
[SCTP][I][sctp_get_sockinfo]     state ....: 2
[SCTP][I][sctp_get_sockinfo]     cwnd .....: 131064
[SCTP][I][sctp_get_sockinfo]     srtt .....: 0
[SCTP][I][sctp_get_sockinfo]     rto ......: 3000
[SCTP][I][sctp_get_sockinfo]     mtu ......: 65532
[SCTP][I][sctp_get_sockinfo] ----------------------
[SCTP][I][sctp_eNB_read_from_socket] Comm up notified for sd 40, assigned assoc_id 1
[S1AP][I][s1ap_eNB_generate_s1_setup_request] 3584 -> 00e000
[UDP][I]Initializing UDP for local address 127.0.0.10 with port 2152
[UDP][I]Inserting new descriptor for task 11, sd 41
[UDP][I]Initializing UDP for local address 127.0.0.10 with port 2152: DONE
[RRC][I][eNB 0] Received RRC_CONFIGURATION_REQ
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Init...
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Checking release
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Rel14 RRC detected, MBMS flag 0
[RRC][I][eNB 0] Configuration SIB2/3, MBMS = 0
[MAC][I][rrc_mac_config_req] [CONFIG][eNB 0/0] Configuring MAC/PHY
[MAC][I][rrc_mac_config_req] [CONFIG]SIB2/3 Contents (partial)
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.n_SB = 1
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.hoppingMode = 0
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.pusch_HoppingOffset = 0
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.enable64QAM = 0
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.groupHoppingEnabled = 1
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.groupAssignmentPUSCH = 0
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.sequenceHoppingEnabled = 0
[MAC][I][rrc_mac_config_req] [CONFIG]pusch_config_common.cyclicShift  = 1
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] OPENAIR RRC IN....
[SCTP][I][sctp_send_data] Successfully sent 59 bytes on stream 0 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] [1][40] Msg of length 27 received from port 36412, on stream 0, PPID 18
[S1AP][I][s1ap_decode_s1ap_s1setupresponseies] Decoding message S1ap_S1SetupResponseIEs (/home/nano/openairinterface5g/cmake_targets/lte_build_oai/build/CMakeFiles/R10.5/s1ap_decoder.c:3535)
[S1AP][I][s1ap_eNB_handle_s1_setup_response] servedGUMMEIs.list.count 1
[S1AP][I][s1ap_eNB_handle_s1_setup_response] servedPLMNs.list.count 1
[ENB_APP][I][eNB_app_task] [eNB 0] Received S1AP_REGISTER_ENB_CNF: associated MME 1
Scope thread created, ret=0
Scope thread has priority 2
Initializing eNB threads
[PHY][I]Initializing eNB 0 CC_id 0 : (eNodeB_3GPP,synch_to_ext_device)
linux; GNU C++ version 6.3.0 20170406; Boost_106200; UHD_003.010.001.001-79-g7ac01c7f

-- Loading firmware image: /usr/share/uhd/images/usrp_b200_fw.hex...
[PHY][I]Checking for USRPs : UHD 003.010.001.001-79-g7ac01c7f (3.10.1)
[PHY][I]Found USRP B200
-- Detected Device: B210
-- Loading FPGA image: /usr/share/uhd/images/usrp_b210_fpga.bin... done
-- Operating over USB 3.
-- Detecting internal GPSDO.... No GPSDO found
-- Initialize CODEC control...
-- Initialize Radio control...
-- Performing register loopback test... pass
-- Performing register loopback test... pass
-- Performing CODEC loopback test... pass
-- Performing CODEC loopback test... pass
-- Setting master clock rate selection to 'automatic'.
-- Asking for clock rate 16.000000 MHz...
-- Actually got clock rate 16.000000 MHz.
-- Performing timer loopback test... pass
-- Performing timer loopback test... pass
-- Setting master clock rate selection to 'manual'.
-- Asking for clock rate 30.720000 MHz...
-- Actually got clock rate 30.720000 MHz.
-- Performing timer loopback test... pass
-- Performing timer loopback test... pass
[PHY][I]cal 0: freq 3500000000.000000, offset 44.000000, diff 960000000.000000
[PHY][I]cal 1: freq 2660000000.000000, offset 49.800000, diff 120000000.000000
[PHY][I]cal 2: freq 2300000000.000000, offset 51.000000, diff 240000000.000000
[PHY][I]cal 3: freq 1880000000.000000, offset 53.000000, diff 660000000.000000
[PHY][I]cal 4: freq 816000000.000000, offset 57.000000, diff 1724000000.000000
[PHY][I]RX Gain 0 125.000000 (55.800000) => 69.200000 (max 76.000000)
[PHY][I]Actual master clock: 30.720000MHz...
[PHY][I]RF board max packet size 3836, size for 100µs jitter 768
[PHY][I]rx_max_num_samps 768
[PHY][I]RX Channel 0
[PHY][I]  Actual RX sample rate: 7.680000MSps...
[PHY][I]  Actual RX frequency: 2.540000GHz...
[PHY][I]  Actual RX gain: 69.000000...
[PHY][I]  Actual RX bandwidth: 20.000000M...
[PHY][I]  Actual RX antenna: RX2...
[PHY][I]TX Channel 0
[PHY][I]  Actual TX sample rate: 7.680000MSps...
[PHY][I]  Actual TX frequency: 2.660000GHz...
[PHY][I]  Actual TX gain: 89.750000...
[PHY][I]  Actual TX bandwidth: 20.000000M...
[PHY][I]  Actual TX antenna: TX/RX...
[PHY][I]Device timestamp: 0.000226...
[RRH] has loaded USRP B200 device.
setup_eNB_buffers: frame_parms = 0x7fb76a2d5788
[PHY][I]Initializing eNB 0 CC_id 0 (eNodeB_3GPP,synch_to_ext_device),
[HW][I][SCHED][eNB] eNB_thread_single started on CPU 0 TID 14983, sched_policy = SCHED_FIFO , priority = 99, CPU Affinity= CPU_0 CPU_1 CPU_2 CPU_3
waiting for sync (eNB_thread_single)
Creating te_thread
[PHY][I]thread te created id=14986[HW][I][SCHED][eNB] eNB_thread_prach started on CPU 1 TID 14987, sched_policy = SCHED_FIFO , priority = 99, CPU Affinity= CPU_0 CPU_1 CPU_2 CPU_3
[HW][I][SCHED][eNB] eNB_thread_synch started on CPU 0 TID 14988, sched_policy = SCHED_FIFO , priority = 99, CPU Affinity= CPU_0 CPU_1 CPU_2 CPU_3
waiting for sync (eNB_thread_synch)
Setting eNB buffer to all-RX
Sending sync to all threads
TYPE <CTRL-C> TO TERMINATE
Entering ITTI signals handler
got sync (eNB_thread_single)
got sync (eNB_thread_synch)
[PHY][I][eNB 0][RAPROC] Frame 523 Terminating ra_proc for harq 4, UE 0
[MAC][I][rx_sdu] [eNB 0][RAPROC] CC_id 0 Frame 523, Received CCCH:  5e.26.b4.b9.28.e6, Terminating RA procedure for UE rnti d26d
[MAC][I][rx_sdu] [eNB 0][RAPROC] CC_id 0 Frame 523 CCCH: Received Msg3: length 6, offset 3
MAC: new UE id 0 rnti d26d
[MAC][I][rx_sdu] [eNB 0][RAPROC] CC_id 0 Frame 523 Added user with rnti d26d => UE 0
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 0, UE 0: not configured, skipping UE scheduling
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received RRC_MAC_CCCH_DATA_IND
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Accept new connection from UE random UE identity (0x8e924b6be2000000) MME code 0 TMSI 0 cause 3
[MAC][I][rrc_mac_config_req] [CONFIG][eNB 0/0] Configuring MAC/PHY for UE 0 (d26d)
[PHY][I]phy_config_dedicated_eNB: physicalConfigDedicated=0x7fb730003290
[PHY][I]Transmission Mode (phy_config_dedicated_eNB) 1
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] [RAPROC] Logical Channel DL-CCCH, Generating RRCConnectionSetup (bytes 25)
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d]CALLING RLC CONFIG SRB1 (rbid 1)
[PDCP][N][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB 01]  Action ADD  LCID 1 (SRB id 1) configured with SN size 5 bits and RLC AM
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] [SRB 1] rrc_rlc_add_rlc  SRB
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01][CONFIGURE] max_retx_threshold 4 poll_pdu 4 poll_byte 65535 t_poll_retransmit 80 t_reordering 35 t_status_prohibit 0
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 1, UE 0: not configured, skipping UE scheduling
[PHY][I][eNB 0] Sent physicalConfigDedicated=0x7fb730003290 for UE 0
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 2, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 3, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 4, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_RA] [eNB 0][RAPROC] CC_id 0 Frame 524, subframeP 5: Generating Msg4 with RRC Piggyback (RA proc 0, RNTI d26d)
[MAC][I][schedule_RA] [eNB 0][RAPROC] CC_id 0 Frame 524 subframeP 5 Msg4 : TBS 41, sdu_len 25, msg4_header 8, msg4_padding 0, msg4_post_padding 7
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 5, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 6, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 7, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 8, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_ulsch_rnti] [eNB 0] frame 524 subfarme 9, UE 0: not configured, skipping UE scheduling
[MAC][I][schedule_RA] [eNB 0][RAPROC] CC_id 0 Frame 525, subframeP 0: Checking if Msg4 was acknowledged:
MAC: msg4 acknowledged for rnti d26d fsf 525/0, let's configure it
[MAC][I][schedule_RA] [eNB 0][RAPROC] CC_id 0 Frame 525, subframeP 0 : Msg4 acknowledged
[MAC][I][schedule_ulsch_rnti] [eNB 0][PUSCH 6/d26d] CC_id 0 Frame 525 subframeP 0 Scheduled UE 0 (mcs 10, first rb 1, nb_rb 6, rb_table_index 5, TBS 129, harq_pid 6)
[MAC][I][rx_sdu] [eNB 0] CC_id 0 MAC CE_LCID 29 : ul_total_buffer = 0 (lcg increment 0)
[RRC][N][eNB 0] Frame 525: received a DCCH 1 message on SRB 1 with Size 84 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] [RAPROC] Logical Channel UL-DCCH, processing RRCConnectionSetupComplete from UE (SRB1 Active)
[S1AP][I][rrc_eNB_send_S1AP_NAS_FIRST_REQ] [eNB 0] Build S1AP_NAS_FIRST_REQ adding in s_TMSI: GUMMEI mme_code 1 mme_group_id 4 ue d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] UE State = RRC_CONNECTED
[S1AP][I][s1ap_eNB_handle_nas_first_req] Found usable eNB_ue_s1ap_id: 0x06692d 420141(10)
[S1AP][I][s1ap_eNB_handle_nas_first_req] GUMMEI_ID_PRESENT
[SCTP][I][sctp_send_data] Successfully sent 137 bytes on stream 1 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] [1][40] Msg of length 29 received from port 36412, on stream 1, PPID 18
[S1AP][I][s1ap_decode_s1ap_downlinknastransporties] Decoding message S1ap_DownlinkNASTransportIEs (/home/nano/openairinterface5g/cmake_targets/lte_build_oai/build/CMakeFiles/R10.5/s1ap_decoder.c:3150)
[RRC][I][eNB 0] Received S1AP_DOWNLINK_NAS: ue_initial_id 1, eNB_ue_s1ap_id 420141
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 0, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 11 Bytes,  NB SDU 1 current_sdu_index=0 next_sdu_index=1 conf 0 mui 0 vtA 0 vtS 0
[RRC][N][eNB 0] Frame 527: received a DCCH 1 message on SRB 1 with Size 20 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[MAC][I][schedule_ue_spec] [eNB 0][DLSCH] Frame 528 Generate header for UE_id 0 on CC_id 0: sdu_length_total 2, num_sdus 1, sdu_lengths[0] 2, sdu_lcids[0] 1 => payload offset 5,timing advance value : 1, padding 2,post_padding 0,(mcs 1, TBS 7, nb_rb 2),header_dcch 1, header_dtch 0
[SCTP][I][sctp_send_data] Successfully sent 65 bytes on stream 1 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] [1][40] Msg of length 62 received from port 36412, on stream 1, PPID 18
[S1AP][I][s1ap_decode_s1ap_downlinknastransporties] Decoding message S1ap_DownlinkNASTransportIEs (/home/nano/openairinterface5g/cmake_targets/lte_build_oai/build/CMakeFiles/R10.5/s1ap_decoder.c:3150)
[RRC][I][eNB 0] Received S1AP_DOWNLINK_NAS: ue_initial_id 1, eNB_ue_s1ap_id 420141
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 0, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 44 Bytes,  NB SDU 2 current_sdu_index=1 next_sdu_index=2 conf 0 mui 0 vtA 1 vtS 1
[RRC][N][eNB 0] Frame 549: received a DCCH 1 message on SRB 1 with Size 20 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[SCTP][I][sctp_send_data] Successfully sent 65 bytes on stream 1 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] [1][40] Msg of length 39 received from port 36412, on stream 1, PPID 18
[S1AP][I][s1ap_decode_s1ap_downlinknastransporties] Decoding message S1ap_DownlinkNASTransportIEs (/home/nano/openairinterface5g/cmake_targets/lte_build_oai/build/CMakeFiles/R10.5/s1ap_decoder.c:3150)
[RRC][I][eNB 0] Received S1AP_DOWNLINK_NAS: ue_initial_id 1, eNB_ue_s1ap_id 420141
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 0, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 21 Bytes,  NB SDU 3 current_sdu_index=2 next_sdu_index=3 conf 0 mui 0 vtA 2 vtS 2
[RRC][N][eNB 0] Frame 551: received a DCCH 1 message on SRB 1 with Size 11 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[SCTP][I][sctp_send_data] Successfully sent 56 bytes on stream 1 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] [1][40] Msg of length 191 received from port 36412, on stream 1, PPID 18
[S1AP][I][s1ap_decode_s1ap_initialcontextsetuprequesties] Decoding message S1ap_InitialContextSetupRequestIEs (/home/nano/openairinterface5g/cmake_targets/lte_build_oai/build/CMakeFiles/R10.5/s1ap_decoder.c:1003)
[S1AP][I][s1ap_eNB_handle_initial_context_request] Received NAS message with the E_RAB setup procedure
[RRC][I][eNB 0] Received S1AP_INITIAL_CONTEXT_SETUP_REQ: ue_initial_id 1, eNB_ue_s1ap_id 420141, nb_of_e_rabs 1
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] rrc_eNB_process_GTPV1U_CREATE_TUNNEL_RESP tunnel (3396329693, 3396329693) bearer UE context index 0, msg index 0, id 5, gtp addr len 4
[RRC][I][eNB 0][UE d26d] Selected security algorithms (0x7fb740007d30): 0, 2, changed
[RRC][I][eNB 0][UE d26d] Saved security key F75DA0CC69B92810FE4A9B01D79831FC41ED79A603F60D632691227D899AC09F

KeNB:f75da0cc69b92810fe4a9b01d79831fc41ed79a603f60d632691227d899ac09f

KRRCenc:2218bd4d732cea8ac01e28a25380ac3c10308d575c3ef116651160b4f2a4104d

KRRCint:eaa568fff81057bb82e98d9242f3bc1ff13d97a62fc6ef074f74ac690b2fb111
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Logical Channel DL-DCCH, Generate SecurityModeCommand (bytes 3)
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 0, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 8 Bytes,  NB SDU 4 current_sdu_index=3 next_sdu_index=4 conf 0 mui 0 vtA 3 vtS 3
[RRC][N][eNB 0] Frame 554: received a DCCH 1 message on SRB 1 with Size 2 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] received securityModeComplete on UL-DCCH 1 from UE
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Logical Channel DL-DCCH, Generate UECapabilityEnquiry (bytes 3)
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 1, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 8 Bytes,  NB SDU 5 current_sdu_index=4 next_sdu_index=5 conf 0 mui 1 vtA 4 vtS 4
[RRC][N][eNB 0] Frame 556: received a DCCH 1 message on SRB 1 with Size 26 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] received ueCapabilityInformation on UL-DCCH 1 from UE
[RRC][I]got UE capabilities for UE d26d
[RRC][I]RRCConnectionReconfiguration Encoded 1020 bits (128 bytes)
[RRC][I][eNB 0] Frame 0, Logical Channel DL-DCCH, Generate RRCConnectionReconfiguration (bytes 128, UE id d26d)
[SCTP][I][sctp_send_data] Successfully sent 53 bytes on stream 1 for assoc_id 1
[PDCP][I][FRAME 00000][eNB][MOD 00][RNTI d26d]Received RRC_DCCH_DATA_REQ from TASK_RRC_ENB: instance 0, rb_id 1, muiP 2, confirmP 0, mode 1
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 01] RLC_AM_DATA_REQ size 133 Bytes,  NB SDU 6 current_sdu_index=5 next_sdu_index=6 conf 0 mui 2 vtA 5 vtS 5
[RRC][N][eNB 0] Frame 559: received a DCCH 1 message on SRB 1 with Size 2 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 1 RRC_DCCH_DATA_IND
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] UE State = RRC_RECONFIGURED (default DRB, xid 1)
[PDCP][N][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB 02]  Action ADD  LCID 2 (SRB id 2) configured with SN size 5 bits and RLC AM
[PDCP][N][FRAME 00000][eNB][MOD 00][RNTI d26d][DRB 01]  Action ADD  LCID 3 (DRB id 1) configured with SN size 12 bits and RLC UM
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] [SRB 2] rrc_rlc_add_rlc  SRB
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d][SRB AM 02][CONFIGURE] max_retx_threshold 32 poll_pdu 8 poll_byte 16960 t_poll_retransmit 15 t_reordering 35 t_status_prohibit 10
[RLC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] [DRB 1] rrc_rlc_add_rlc  DRB
[RRC][I][eNB 0] Frame  0 CC 0 : SRB2 is now active
[RRC][I][eNB 0] Frame  0 : Logical Channel UL-DCCH, Received RRCConnectionReconfigurationComplete from UE rnti d26d, reconfiguring DRB 1/LCID 3
[RRC][I][eNB 0] Frame  0 : Logical Channel UL-DCCH, Received RRCConnectionReconfigurationComplete from UE 0, reconfiguring DRB 1/LCID 3
[MAC][I][rrc_mac_config_req] [CONFIG][eNB 0/0] Configuring MAC/PHY for UE 0 (d26d)
[PHY][I]phy_config_dedicated_eNB: physicalConfigDedicated=0x7fb730003290
[PHY][I]Transmission Mode (phy_config_dedicated_eNB) 1
[S1AP][I][s1ap_eNB_initial_ctxt_resp] initial_ctxt_resp_p: e_rab ID 5, enb_addr 127.0.0.10, SIZE 4
[SCTP][I][sctp_send_data] Successfully sent 40 bytes on stream 1 for assoc_id 1
[PHY][I][eNB 0] Sent physicalConfigDedicated=0x7fb730003290 for UE 0
[RRC][N][eNB 0] Frame 561: received a DCCH 2 message on SRB 2 with Size 16 from UE d26d
[RRC][I][FRAME 00000][eNB][MOD 00][RNTI d26d] Received on DCCH 2 RRC_DCCH_DATA_IND
[MAC][I][schedule_ue_spec] [eNB 0], Frame 562, DCCH1->DLSCH, CC_id 0, Requesting 185 bytes from RLC (RRC message)
[SCTP][I][sctp_send_data] Successfully sent 61 bytes on stream 1 for assoc_id 1
[SCTP][I][sctp_eNB_flush_sockets] Found data for descriptor 40
[SCTP][I][sctp_eNB_read_from_socket] Received notification for sd 40, type 32777
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]rx_rf: rfdevice timing drift of -1 samples (ts_off 31337346)
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 39 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
[PHY][I]UE 0 : rnti d26d
[MAC][I][eNB_dlsch_ulsch_scheduler] UE  rnti d26d : in synch, PHR 40 dB CQI 15
[RRC][I]UE rnti d26d failure timer 0/20000
Received SIGINT
closing all tasks
[UDP][W]Received TERMINATE_MESSAGE
^CExiting eNB_single thread
Uready_tasks 0
waiting for XFORMS thread
stopping MODEM threads
Killing eNB 0 processing threads
Exiting eNB thread PRACH