oaisim crashes for TDD 5MHz (1eNB/1UE)
oaisim_noS1 crashes with TDD mode 5MHz (1 eNB/1 UE)
$OPENAIR_DIR/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1 -O $OPENAIR_TARGETS/PROJECTS/GENERIC-LTE-EPC/CONF/enb.band7.generic.oaisim.local_no_mme.conf -A AWGN -b1 -u1 -n100 -R 25 -x 1
$OPENAIR_DIR/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1 -O $OPENAIR_TARGETS/PROJECTS/GENERIC-LTE-EPC/CONF/enb.band7.generic.oaisim.local_no_mme.conf -A AWGN -b1 -u1 -n100 -R 25 -x 1 Log file is located here,
8bbcfbe5/log/010200/test.010200.oaisim_noS1.tdd.5MHz.TM1.run_1
Executing $OPENAIR_DIR/cmake_targets/tools/init_nas_nos1 module nasmesh already loaded: I remove it first loading nasmesh Executing $OPENAIR_DIR/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1 -O $OPENAIR_TARGETS/PROJECTS/GENERIC-LTE-EPC/CONF/enb.band7.generic.oaisim.local_no_mme.conf -A AWGN -b1 -u1 -n100 -R 25 -x 1 Linux nano 3.19.0-25-generic /mnt/sradio/TEST_RESULTS/develop/#26 (closed)~14.04.1-Ubuntu SMP Fri Jul 24 21:16:20 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux num component carrier 1ENB 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: 10:
eutra band for CC 0: 7:
downlink freq for CC 0: 2680000000:
uplink freq offset for CC 0: -120000000:
Cell ID for CC 0: 0:
N_RB_DL for CC 0: 25:
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: 1:
rach_preambleInitialReceivedTargetPower for CC 0: 10:
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: 0:
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: 0:
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: -108:
pucch_p0_Nominal for CC 0: -108:
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:
Global log level: trace
HW log level: info
PHY log level: trace
MAC log level: trace
RLC log level: trace
PDCP log level: trace
RRC log level: trace
UDP log level: debug
GTP log level: debug
OSA log level: debug
log init done
[ITTI][D] Memory pools statistics:
Pool: size, number, minimum, free, address space and memory used in Kbytes
0: 52, 11000, 11000, 11000, [0x7f8ea5f82010-0x7f8ea60389f0] 730
1: 100, 21000, 21000, 21000, [0x7f8ea200d010-0x7f8ea225fbb0] 2378
2: 1000, 10000, 10000, 10000, [0x7f8ea165c010-0x7f8ea200c790] 9921
3: 20052, 400, 400, 400, [0x7f8ea0eb4010-0x7f8ea165bc50] 7839
4: 30052, 100, 100, 100, [0x7f8ea0bd5010-0x7f8ea0eb3160] 2936
Pools memory 23806 Kbytes
[EMU][I]OCG log level 7, oai log level6
[34m[EMU][N]global log level is set to (info,6) with vebosity (medium, 0x15) and frequency 1
[0m[MAC][I]num groups is set to 1
[EMU][I][INIT] Starting NAS netlink interface
[NETLINK]Opened socket with fd 36
[EMU][I]Total number of UE 1 (first local 0 , num local 1, remote 0, relay 0) mobility STATIC
[EMU][I]Total number of eNB 1 (local 1, remote 0, relay 0) mobility STATIC
[PHY][I]init lte parms: Nid_cell 0, Frame type 0, N_RB_DL 25
[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
pcfich_reg : 0,12,25,37
Ngroup_PHICH 1 (phich_config_common.phich_resource 1,phich_config_common.phich_duration normal, NidCell 0,Ncp 0, frame_type 0), smallest pcfich REG 0, n0 46, n1 75 (first PHICH REG 0)
phich_reg :0 => 1,17,33
[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 7 number of harq pid max 8
[PHY][I]init eNB: N_RB_DL 25
[PHY][I]init eNB: Transmission mode 1
AFTER init: MAX_NUM_CCs 1, Nid_cell 0 frame_type 0,tdd_config 3
[EMU][I]UE 0 mode is initialized to 0
[MAC][I][MAIN] MAC_INIT_GLOBAL_PARAM IN...
[MAC][I][MAIN] CALLING RLC_MODULE_INIT...
[MAC][I][MAIN] RLC_MODULE_INIT OK, malloc16 for mac_rlc_xface...
[MAC][I][MAIN] malloc16 OK, mac_rlc_xface @ 0x19385d20
[MAC][I][MAIN] RLC interface setup and init
[PDCP][I]PDCP layer has been initialized
[MAC][I][MAIN] Init Global Param Done
[MAC][I][MAIN] init eNB MAC functions
[MAC][I][MAIN] init UE MAC functions
[MAC][I][MAIN] PHY Frame configuration
[MAC][I][MAIN] Init function start:Nb_UE_INST=1
[MAC][I][UE0] Applying default macMainConfig
[MAC][I][MAIN] Init function start:Nb_eNB_INST=1
[MAC][I][MAIN] calling RRC
[RRC][I]Allocating 408 bytes for UE_EUTRA_Capability
[PHY][I][RRC]UE Capability encoded, 15 bytes (120 bits)
[RRC][I][UE] eMBMS active state is 0
[RRC][I][eNB] handover active state is 0
[RRC][I][eNB] eMBMS active state is 0
[MAC][I][MAIN][INIT] Init function finished
[MAC][I][eNB 0] Frame 0: PHY Sync failure
AWGN: ricean_factor 0.000000
AWGN: ricean_factor 0.000000
[34m[EMU][N]>>>>>>>>>>>>>>>>>>>>>>>>>>> OAIEMU initialization done <<<<<<<<<<<<<<<<<<<<<<<<<<
[0m[EMU][I]TASK_L2L1 is READY [RRC][I][eNB 0] Received RRC_CONFIGURATION_REQ [EMU][I]TASK_L2L1 received INITIALIZE_MESSAGE in state L2L1_WAITTING [RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Init... [RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Checking release [PHY][I][eNB 0] Received PHY_CONFIGURATION_REQ [RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] Rel10 RRC detected, MBMS flag 0 [RRC][I][eNB 0] Configuration SIB2/3, MBMS = 0 [MAC][I][CONFIG][eNB 0/0] Configuring MAC/PHY [MAC][I][CONFIG]SIB2/3 Contents (partial) [MAC][I][CONFIG]pusch_config_common.n_SB = 1 [MAC][I][CONFIG]pusch_config_common.hoppingMode = 0 [MAC][I][CONFIG]pusch_config_common.pusch_HoppingOffset = 0 [MAC][I][CONFIG]pusch_config_common.enable64QAM = 0 [MAC][I][CONFIG]pusch_config_common.groupHoppingEnabled = 1 [MAC][I][CONFIG]pusch_config_common.groupAssignmentPUSCH = 0 [MAC][I][CONFIG]pusch_config_common.sequenceHoppingEnabled = 0 [MAC][I][CONFIG]pusch_config_common.cyclicShift = 0 [RRC][I][FRAME 00000][eNB][MOD 00][RNTI 0] OPENAIR RRC IN.... [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][UE0] Initial sync : Estimated PSS position 3880, Nid2 1 [PHY][I][UE0] Initial sync : Estimated power: 77 dB [PHY][I]Calling sss detection (FDD normal CP) [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][UE0] Initial sync: starting PBCH detection (rx_offset 552) [PHY][I][UE 0] RX RSSI -102 dBm, digital (54, 53) dB, linear (270688, 218816), avg rx power 56 dB (489504 lin), RX gain 155 dB [PHY][I][UE 0] N0 -110 dBm digital (72, 72) dB, linear (242990008, 335781344), avg noise power 0 dB (0 lin) [PHY][I]FDD Normal prefix: CellId 451 metric 9040, phase 3, flip 0, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 552) [PHY][I][UE 0] RX RSSI -102 dBm, digital (51, 51) dB, linear (148752, 175808), avg rx power 56 dB (485638 lin), RX gain 155 dB [PHY][I][UE 0] N0 -110 dBm digital (72, 72) dB, linear (242990008, 335781344), avg noise power 71 dB (13564953 lin) [PHY][I]FDD Extended prefix: CellId 382 metric 9124, phase 5, flip 0, pbch -1 [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]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][UE0] Initial sync: starting PBCH detection (rx_offset 71864) [PHY][I][UE 0] RX RSSI -96 dBm, digital (72, 72) dB, linear (26147936, 26165136), avg rx power 62 dB (1700343 lin), RX gain 155 dB [PHY][I][UE 0] N0 -110 dBm digital (72, 72) dB, linear (182664544, 170178004), avg noise power 71 dB (13247024 lin) [PHY][I]TDD Normal prefix: CellId 85 metric 4584, phase 6, flip 1, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 33192) [PHY][I][UE 0] RX RSSI -94 dBm, digital (72, 72) dB, linear (21673856, 23402896), avg rx power 64 dB (2716977 lin), RX gain 155 dB [PHY][I][UE 0] N0 -110 dBm digital (72, 72) dB, linear (182664544, 170178004), avg noise power 72 dB (21206294 lin) [PHY][I]TDD Extended prefix: CellId 91 metric 6620, phase 2, flip 0, pbch -1 [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][UE0] Initial sync : Estimated PSS position 4048, Nid2 0 [PHY][I][UE0] Initial sync : Estimated power: 77 dB [PHY][I]Calling sss detection (FDD normal CP) [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][UE0] Initial sync: starting PBCH detection (rx_offset 39120) [PHY][I][UE 0] RX RSSI -89 dBm, digital (48, 48) dB, linear (76848, 80048), avg rx power 64 dB (2656975 lin), RX gain 150 dB [PHY][I][UE 0] N0 -112 dBm digital (65, 66) dB, linear (37867644, 50102048), avg noise power 72 dB (20709271 lin) [PHY][I]FDD Normal prefix: CellId 198 metric 5808, phase 0, flip 1, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 720) [PHY][I][UE 0] RX RSSI -89 dBm, digital (48, 48) dB, linear (57472, 91200), avg rx power 64 dB (2598186 lin), RX gain 150 dB [PHY][I][UE 0] N0 -112 dBm digital (65, 66) dB, linear (37867644, 50102048), avg noise power 72 dB (22285687 lin) [PHY][I]FDD Extended prefix: CellId 81 metric 6263, phase 4, flip 0, pbch -1 [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]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][UE0] Initial sync: starting PBCH detection (rx_offset 33632) [PHY][I][UE 0] RX RSSI -88 dBm, digital (70, 71) dB, linear (11100880, 12261792), avg rx power 65 dB (3084853 lin), RX gain 150 dB [PHY][I][UE 0] N0 -105 dBm digital (72, 72) dB, linear (132649056, 150426296), avg noise power 72 dB (21763366 lin) [PHY][I]TDD Normal prefix: CellId 273 metric 6144, phase 3, flip 0, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 71760) [PHY][I][UE 0] RX RSSI -87 dBm, digital (72, 72) dB, linear (22414464, 24650208), avg rx power 66 dB (4115630 lin), RX gain 150 dB [PHY][I][UE 0] N0 -105 dBm digital (72, 72) dB, linear (132649056, 150426296), avg noise power 72 dB (27887865 lin) [PHY][I]TDD Extended prefix: CellId 30 metric 4486, phase 1, flip 1, pbch -1 [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][UE0] Initial sync : Estimated PSS position 3328, Nid2 0 [PHY][I][UE0] Initial sync : Estimated power: 71 dB [PHY][I]Calling sss detection (FDD normal CP) [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][UE0] Initial sync: starting PBCH detection (rx_offset 0) [PHY][I][UE 0] RX RSSI -84 dBm, digital (79, 79) dB, linear (99495040, 99360320), avg rx power 69 dB (8679842 lin), RX gain 150 dB [PHY][I][UE 0] N0 -134 dBm digital (43, 43) dB, linear (244468, 229444), avg noise power 72 dB (27234243 lin) [PHY][I]FDD Normal prefix: CellId 0 metric 56139, phase 3, flip 0, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 38400) [PHY][I][UE 0] RX RSSI -83 dBm, digital (75, 75) dB, linear (49787920, 49016432), avg rx power 70 dB (10792135 lin), RX gain 150 dB [PHY][I][UE 0] N0 -134 dBm digital (43, 43) dB, linear (244468, 229444), avg noise power 72 dB (26607047 lin) [PHY][I]FDD Extended prefix: CellId 306 metric 10331, phase 0, flip 1, pbch -1 [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]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][UE0] Initial sync: starting PBCH detection (rx_offset 32912) [PHY][I][UE 0] RX RSSI -83 dBm, digital (43, 43) dB, linear (18768, 22128), avg rx power 70 dB (10540152 lin), RX gain 150 dB [PHY][I][UE 0] N0 -139 dBm digital (33, 40) dB, linear (12796, 64212), avg noise power 72 dB (25983444 lin) [PHY][I]TDD Normal prefix: CellId 108 metric 143, phase 0, flip 0, pbch -1 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I]Initializing frame parms for N_RB_DL 25, Ncp 1, osf 1 lte_parms.c: Setting N_RB_DL to 25, ofdm_symbol_size 512 [PHY][I][UE0] Initial sync: starting PBCH detection (rx_offset 71040) [PHY][I][UE 0] RX RSSI -83 dBm, digital (56, 56) dB, linear (513088, 491712), avg rx power 70 dB (10316667 lin), RX gain 150 dB [PHY][I][UE 0] N0 -139 dBm digital (33, 40) dB, linear (12796, 64212), avg noise power 72 dB (25376261 lin) [PHY][I]TDD Extended prefix: CellId 222 metric 142, phase 0, flip 1, pbch -1 [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][UE0] Initial sync : Estimated PSS position 3328, Nid2 0 [PHY][I][UE0] Initial sync : Estimated power: 71 dB [PHY][I]Calling sss detection (FDD normal CP) [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][UE0] Initial sync: starting PBCH detection (rx_offset 0) [PHY][I][UE 0] RX RSSI -76 dBm, digital (79, 79) dB, linear (99755568, 99353888), avg rx power 72 dB (14741497 lin), RX gain 145 dB [PHY][I][UE 0] N0 -127 dBm digital (44, 46) dB, linear (310912, 485860), avg noise power 72 dB (24781504 lin) [PHY][I][UE0] Initial sync: pbch decoded sucessfully mode1_flag 1, tx_ant 1, frame 4, N_RB_DL 25, phich_duration 0, phich_resource 1/6! [PHY][I]FDD Normal prefix: CellId 0 metric 36814, phase 3, flip 0, pbch 0 [PHY][I][UE0] In synch, rx_offset 0 samples [PHY][I][UE0] Sending synch status to higher layers [RRC][I][FRAME 00000][ UE][MOD 00][RNTI 0] Init... [RRC][I][FRAME 00000][ UE][MOD 00][RNTI 0] OPENAIR RRC IN.... pcfich_reg : 0,12,25,37 Ngroup_PHICH 1 (phich_config_common.phich_resource 1,phich_config_common.phich_duration normal, NidCell 0,Ncp 0, frame_type 0), smallest pcfich REG 0, n0 46, n1 75 (first PHICH REG 0) phich_reg :0 => 1,17,33 [PHY][I][UE 0] Frame 4 RRC Measurements => rssi -69.2 dBm (dig 75.8 dB, gain 145), N0 -127 dBm, rsrp -94.0 dBm/RE, rsrq 9.0 dB [PHY][I][UE 0] Frame 4 MIB Information => FDD, NORMAL, NidCell 0, N_RB_DL 25, PHICH DURATION 0, PHICH RESOURCE 1/6, TX_ANT 1 [PHY][I][UE 0] frame 5, slot 1: Adjusting frame counter (PBCH ant_tx=1, frame_tx=5, phase 1). [RRC][I][UE 0] : Dumping SIB 1 [RRC][I]PLMN MCC 208, MNC 10, TAC 0x0001 [RRC][I]cellReservedForOperatorUse : raw:1 decoded:notReserved [RRC][I]Found SFR FR (name from internal table) [RRC][I]cellAccessRelatedInfo.cellIdentity : raw:3584 decoded:00.00.e0.00 [RRC][I]cellAccessRelatedInfo.cellBarred : raw:1 decoded:notBarred [RRC][I]cellAccessRelatedInfo.intraFreqReselection : raw:1 decoded:notAllowed [RRC][I]cellAccessRelatedInfo.csg_Indication : 0 [RRC][I]cellAccessRelatedInfo.csg_Identity : not defined [RRC][I]cellSelectionInfo.q_RxLevMin : -65 [RRC][I]cellSelectionInfo.q_RxLevMinOffset : not defined [RRC][I]p_Max : not defined [RRC][I]freqBandIndicator : 7 [RRC][I]si_Periodicity[0] : rf8 [RRC][I]siSchedulingInfoSIBType[0] : SIB3 [RRC][I]siWindowLength : 20ms [RRC][I]systemInfoValueTag : 0 [MAC][I][CONFIG][UE 0] Configuring MAC/PHY from eNB 0 [RRC][I][UE 0] Frame 9 Found SIB2 from eNB 0 [RRC][I]ac_BarringInfo : not defined [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.preambleInfo.numberOfRA_Preambles : raw:15 decoded:n64 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.preambleInfo.preamblesGroupAConfig : not defined [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.powerRampingParameters.powerRampingStep : raw:1 decoded:dB2 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.powerRampingParameters.preambleInitialReceivedTargetPower : raw:10 decoded:dBm-100 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.ra_SupervisionInfo.preambleTransMax : raw:6 decoded:n10 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.ra_SupervisionInfo.ra_ResponseWindowSize : raw:7 decoded:sf10 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.ra_SupervisionInfo.mac_ContentionResolutionTimer : raw:5 decoded:sf48 [RRC][I]radioResourceConfigCommon.rach_ConfigCommon.maxHARQ_Msg3Tx : 4 [RRC][I]radioResourceConfigCommon.bcch_Config.modificationPeriodCoeff : raw:0 decoded:n2 [RRC][I]radioResourceConfigCommon.pcch_Config.defaultPagingCycle : raw:2 decoded:rf64 [RRC][I]radioResourceConfigCommon.pcch_Config.nB : raw:2 decoded:oneT [RRC][I]radioResourceConfigCommon.prach_Config.rootSequenceIndex : 0 [RRC][I]radioResourceConfigCommon.prach_Config.prach_ConfigInfo.prach_ConfigIndex : 0 [RRC][I]radioResourceConfigCommon.prach_Config.prach_ConfigInfo.highSpeedFlag : 0 [RRC][I]radioResourceConfigCommon.prach_Config.prach_ConfigInfo.zeroCorrelationZoneConfig : 1 [RRC][I]radioResourceConfigCommon.prach_Config.prach_ConfigInfo.prach_FreqOffset : 2 [RRC][I]radioResourceConfigCommon.pdsch_ConfigCommon.referenceSignalPower : 0 [RRC][I]radioResourceConfigCommon.pdsch_ConfigCommon.p_b : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.pusch_ConfigBasic.n_SB : 1 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.pusch_ConfigBasic.hoppingMode : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.pusch_ConfigBasic.pusch_HoppingOffset : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.pusch_ConfigBasic.enable64QAM : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.ul_ReferenceSignalsPUSCH.groupHoppingEnabled : 1 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.ul_ReferenceSignalsPUSCH.groupAssignmentPUSCH : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.ul_ReferenceSignalsPUSCH.sequenceHoppingEnabled : 0 [RRC][I]radioResourceConfigCommon.pusch_ConfigCommon.ul_ReferenceSignalsPUSCH.cyclicShift : 0 [RRC][I]radioResourceConfigCommon.pucch_ConfigCommon.deltaPUCCH_Shift : 0 [RRC][I]radioResourceConfigCommon.pucch_ConfigCommon.nRB_CQI : 1 [RRC][I]radioResourceConfigCommon.pucch_ConfigCommon.nCS_AN : 0 [RRC][I]radioResourceConfigCommon.pucch_ConfigCommon.n1PUCCH_AN : 0 [RRC][I]radioResourceConfigCommon.soundingRS_UL_ConfigCommon.present : raw:1 decoded:release [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.p0_NominalPUSCH : -108 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.alpha : 7 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.p0_NominalPUCCH : -108 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaFList_PUCCH.deltaF_PUCCH_Format1 : 2 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaFList_PUCCH.deltaF_PUCCH_Format1b : 1 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaFList_PUCCH.deltaF_PUCCH_Format2 : 1 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaFList_PUCCH.deltaF_PUCCH_Format2a : 1 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaFList_PUCCH.deltaF_PUCCH_Format2b : 1 [RRC][I]radioResourceConfigCommon.uplinkPowerControlCommon.deltaPreambleMsg3 : 6 [RRC][I]radioResourceConfigCommon.ul_CyclicPrefixLength : 0 [RRC][I]ue_TimersAndConstants.t300 : 5 [RRC][I]ue_TimersAndConstants.t301 : 5 [RRC][I]ue_TimersAndConstants.t310 : 5 [RRC][I]ue_TimersAndConstants.n310 : 7 [RRC][I]ue_TimersAndConstants.t311 : 3 [RRC][I]ue_TimersAndConstants.n311 : 0 [RRC][I]freqInfo.ul_CarrierFreq : not defined [RRC][I]freqInfo.ul_Bandwidth : not defined [RRC][I]freqInfo.additionalSpectrumEmission : 1 [RRC][I]mbsfn_SubframeConfigList : not defined [RRC][I]timeAlignmentTimerCommon : 7 [RRC][I]lateNonCriticalExtension : not defined [RRC][I]ssac_BarringForMMTEL_Voice_r9 : not defined [RRC][I]ssac_BarringForMMTEL_Video_r9 : not defined [RRC][I]ac_BarringForCSFB_r10 : not defined [RRC][I][FRAME 00009][RRC_UE][MOD 00][][--- MAC_CONFIG_REQ (SIB2 params eNB 0) --->][MAC_UE][MOD 00][] [MAC][I][CONFIG][UE 0] Configuring MAC/PHY from eNB 0 [PHY][I][UE0] Frame 9: Applying radioResourceConfigCommon from eNB0 [RRC][I][UE 0] : Frame 9, Logical Channel UL-CCCH (SRB0), Generating RRCConnectionRequest (bytes 6, eNB 0) [RRC][I][UE 0] Received SIB1/SIB2/SIB3 Switching to RRC_SI_RECEIVED [RRC][I][UE 0] Frame 9 Found SIB3 from eNB 0 [RRC][I]Dumping SIB3 (see TS36.331 V8.21.0) [RRC][I]cellReselectionInfoCommon.q_Hyst : raw:4 decoded:4 dB [RRC][I]cellReselectionInfoCommon.speedStateReselectionPars : not defined [RRC][I]cellReselectionServingFreqInfo.s_NonIntraSearch : not defined [RRC][I]cellReselectionServingFreqInfo.threshServingLow : 31 [RRC][I]cellReselectionServingFreqInfo.cellReselectionPriority : 7 [RRC][I]intraFreqCellReselectionInfo.q_RxLevMin : -70 [RRC][I]intraFreqCellReselectionInfo.p_Max : not defined [RRC][I]intraFreqCellReselectionInfo.s_IntraSearch : 31 [RRC][I]intraFreqCellReselectionInfo.allowedMeasBandwidth : 0 [RRC][I]intraFreqCellReselectionInfo.presenceAntennaPort1 : 0 [RRC][I]intraFreqCellReselectionInfo.neighCellConfig : 0 [RRC][I]intraFreqCellReselectionInfo.t_ReselectionEUTRA : 1 [RRC][I]intraFreqCellReselectionInfo.t_ReselectionEUTRA_SF : not defined [RRC][I]SIStatus 7, SIcnt 1/1 [MAC][I]Received RRC_MAC_CCCH_DATA_REQ from TASK_RRC_UE: instance 1, frameP 10, eNB_index 0 [PHY][I][eNB 0/0][RAPROC] Frame 10, subframe 1 Initiating RA procedure (UE_id 0) with preamble 1, energy 64.3 dB, delay 0 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 10 Initiating RA procedure for preamble index 1 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 10 Generating RAR (41|00.00.03.4c.87.e7) for ra_idx 0, CRNTI 87e7,preamble 1/1,TIMING OFFSET 0 [PHY][I]UE_id 0 associated with rnti 87e7 [PHY][I]Initializing Po_PUCCH: p0_NominalPUCCH -108, gain 130 => 158 [PHY][I][eNB][RAPROC] generate_eNB_ulsch_params_from_rar: subframe 5 (harq_pid 7) [PHY][I][eNB][RAPROC] Frame 10 subframe 5, Activated Msg3 demodulation for UE 0 in frame 11, subframe 1 [MAC][I][eNB 0][RAPROC] Frame 10 Received RAR (41|00.00.03.4c.87.e7) for preamble 1/1 [MAC][I][UE 0][RAPROC] rar->Timing_Advance_Command 0 [MAC][I][UE 0][RAPROC] rar->t_crnti 87e7 Writing 76800 elements of type 1 to UEtxsig10.m Writing 76800 elements of type 1 to eNBtxsig10.m Writing 7168 elements of type 1 to eNBtxsigF10.m Writing 76800 elements of type 1 to UErxsig10.m Writing 76800 elements of type 1 to eNBrxsig10.m [PHY][I][UE 0][RAPROC] Frame 11, Subframe 1 next slot 2 Generating (RRCConnectionRequest) Msg3 (nb_rb 1, first_rb 1, round 0, rvidx 0) Msg3: 20.6.1f|51.3f.6.f3.60.46 [PHY][I][UE 0][RAPROC] frame 11, subframe 1: Msg3 Po_PUSCH -2 dBm (-10000,0,100*PL=9600,0,200) [MAC][I]Frame 11: Contention resolution timer 0/48 [MAC][I]Frame 11: Contention resolution timer 1/48 [PHY][I][eNB 0][PUSCH 7] Frame 11 subframe 1 ULSCH received, setting round to 0, PHICH ACK [PHY][I][eNB 0][PUSCH 7] frame 11 subframe 1 RNTI 87e7 RX power (41,0) RSSI (0,0) N0 (22,0) dB ACK (0,0), decoding iter 2 [PHY][I][eNB 0][RAPROC] Frame 11 Terminating ra_proc for harq 7, UE 0 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 11, Received CCCH: 51.3f.6.f3.60.46, Terminating RA procedure for UE rnti 87e7 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 11 CCCH: Received Msg3: length 6, offset 3 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 11 Added user with rnti 87e7 => UE 0 [RRC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7] Received RRC_MAC_CCCH_DATA_IND [RRC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7] Accept new connection from UE random UE identity (0x4366ff013000000) MME code 0 TMSI 0 cause 3 [MAC][I][CONFIG][eNB 0/0] Configuring MAC/PHY for UE 0 (87e7) [PHY][I]phy_config_dedicated_eNB: physicalConfigDedicated=0x7f8e6c0042d0 [RRC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7] [RAPROC] Logical Channel DL-CCCH, Generating RRCConnectionSetup (bytes 25) [RRC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7]CALLING RLC CONFIG SRB1 (rbid 1) [RLC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7] [SRB 1] rrc_rlc_add_rlc SRB [RLC][I][FRAME 00011][eNB][MOD 00][RNTI 87e7][SRB AM 01][CONFIGURE] max_retx_threshold 8 poll_pdu 4 poll_byte 10000 t_poll_retransmit 80 t_reordering 35 t_status_prohibit 0 [MAC][I]Frame 11: Contention resolution timer 2/48 [PHY][I][eNB 0] Frame 11: Sent physicalConfigDedicated=0x7f8e6c0042d0 for UE 0 [MAC][I]Frame 11: Contention resolution timer 3/48 [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 11, subframeP 5: Generating Msg4 with RRC Piggyback (RA proc 0, RNTI 87e7) [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 11 subframeP 5 Msg4 : TBS 41, sdu_len 25, msg4_header 8, msg4_padding 0, msg4_post_padding 7 [MAC][I]Frame 11: Contention resolution timer 4/48 [MAC][I]Frame 11: Contention resolution timer 5/48 [MAC][I][UE 0][RAPROC] Frame 11 : received contention resolution msg: 51.3f.6.f3.60.46, Terminating RA procedure [MAC][I][UE 0][RAPROC] Frame 11 : Clearing RA_active flag [MAC][I][UE 0][RAPROC] Frame 11 : Clearing contention resolution timer [PHY][I][UE 0][RAPROC] Frame 11 Random-access procedure succeeded [RRC][I][UE0][RAPROC] Frame 11 : Logical Channel DL-CCCH (SRB0), Received RRCConnectionSetup RNTI 87e7 [RLC][I][FRAME 00011][ UE][MOD 00][RNTI 87e7] [SRB 1] rrc_rlc_add_rlc SRB [RLC][I][FRAME 00011][ UE][MOD 00][RNTI 87e7][SRB AM 01][CONFIGURE] max_retx_threshold 8 poll_pdu 4 poll_byte 10000 t_poll_retransmit 80 t_reordering 35 t_status_prohibit 0 [RRC][I][UE 0], CONFIG_SRB1 1 corresponding to eNB_index 0 [MAC][I][CONFIG][UE 0] Configuring MAC/PHY from eNB 0 [MAC][I][CONFIG][UE 0] Applying RRC logicalChannelConfig from eNB0 [RRC][I][UE 0] State = RRC_CONNECTED (eNB 0) [RRC][I][UE 0][RAPROC] Frame 11 : Logical Channel UL-DCCH (SRB1), Generating RRCConnectionSetupComplete (bytes59, eNB 0) [RLC][I][FRAME 00011][ UE][MOD 00][RNTI 87e7][SRB AM 01] RLC_AM_DATA_REQ size 64 Bytes, NB SDU 1 current_sdu_index=0 next_sdu_index=1 conf 0 mui 0 n1_pucch_UE: subframe 5, nCCE 0 [PHY][I][UE 0][PDSCH 87e7] frame 11, subframe 9: Po_PUCCH -9 dBm : Po_NOMINAL_PUCCH -108 dBm, PL 96 dB, g_pucch 0 dB [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 12, subframeP 0: Checking if Msg4 was acknowledged: [MAC][I][eNB 0][RAPROC] CC_id 0 Frame 12, subframeP 0 : Msg4 acknowledged [PHY][I][UE 0][SR 87e7] frame 12, subframe 0: Po_PUCCH -10 dBm : Po_NOMINAL_PUCCH -108 dBm, PL 96 dB g_pucch 0 dB Writing 76800 elements of type 1 to UEtxsig11.m Writing 76800 elements of type 1 to eNBtxsig11.m Writing 7168 elements of type 1 to eNBtxsigF11.m Writing 76800 elements of type 1 to UErxsig11.m Writing 76800 elements of type 1 to eNBrxsig11.m [34m[RRC][N][eNB 0] Frame 12: received a DCCH 1 message on SRB 0 with Size 59 from UE 87e7 [0m[RRC][I][FRAME 00012][eNB][MOD 00][RNTI 87e7] Received on DCCH 1 RRC_DCCH_DATA_IND [RRC][I][FRAME 00012][eNB][MOD 00][RNTI 87e7] [RAPROC] Logical Channel UL-DCCH, processing RRCConnectionSetupComplete from UE [RRC][I][FRAME 00012][eNB][MOD 00][RNTI 87e7] Logical Channel DL-DCCH, Generate SecurityModeCommand (bytes 3) [RRC][I][FRAME 00012][eNB][MOD 00][RNTI 87e7] UE State = RRC_CONNECTED [RLC][I][FRAME 00012][eNB][MOD 00][RNTI 87e7][SRB AM 01] RLC_AM_DATA_REQ size 8 Bytes, NB SDU 1 current_sdu_index=0 next_sdu_index=1 conf 0 mui 0 [PHY][I]format1 TPC 2, dlsch0_harq->delta_PUCCH 1 n1_pucch_UE: subframe 7, nCCE 0 [PHY][I][UE 0][PDSCH 87e7] frame 13, subframe 1: Po_PUCCH -5 dBm : Po_NOMINAL_PUCCH -108 dBm, PL 98 dB, g_pucch 2 dB [34m[RRC][N][UE 0] Frame 13: received a DCCH 1 message on SRB 0 with Size 3 from eNB ??? [0m[RRC][I][UE 0] Received securityModeCommand (eNB 0) [RRC][I][UE 0] Frame 13: Receiving from SRB1 (DL-DCCH), Processing securityModeCommand (eNB 0) [RRC][I][UE 0] Security algorithm is set to eea0 [RRC][I][UE 0] Integrity protection algorithm is set to none [RRC][I][UE 0] Frame 13: Receiving from SRB1 (DL-DCCH), encoding securityModeComplete (eNB 0) [RLC][I][FRAME 00013][ UE][MOD 00][RNTI 87e7][SRB AM 01] RLC_AM_DATA_REQ size 7 Bytes, NB SDU 1 current_sdu_index=1 next_sdu_index=2 conf 0 mui 1 n1_pucch_UE: subframe 8, nCCE 0 [PHY][I][UE 0][PDSCH 87e7] frame 13, subframe 2: Po_PUCCH -5 dBm : Po_NOMINAL_PUCCH -108 dBm, PL 98 dB, g_pucch 2 dB n1_pucch_UE: subframe 9, nCCE 0 [PHY][I][UE 0][PDSCH 87e7] frame 13, subframe 3: Po_PUCCH -5 dBm : Po_NOMINAL_PUCCH -108 dBm, PL 98 dB, g_pucch 2 dB [34m[RRC][N][eNB 0] Frame 13: received a DCCH 1 message on SRB 0 with Size 2 from UE 87e7 [0m[RRC][I][FRAME 00013][eNB][MOD 00][RNTI 87e7] Received on DCCH 1 RRC_DCCH_DATA_IND [RRC][I][FRAME 00013][eNB][MOD 00][RNTI 87e7] received securityModeComplete on UL-DCCH 1 from UE [RRC][I][FRAME 00013][eNB][MOD 00][RNTI 87e7] Logical Channel DL-DCCH, Generate UECapabilityEnquiry (bytes 3) [RLC][I][FRAME 00013][eNB][MOD 00][RNTI 87e7][SRB AM 01] RLC_AM_DATA_REQ size 8 Bytes, NB SDU 2 current_sdu_index=1 next_sdu_index=2 conf 0 mui 1 [PHY][I]format1 TPC 2, dlsch0_harq->delta_PUCCH 1 /tmp/OAITestFrameWork-guptar/openairinterface5g/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1(exit_fun+0x16)[0x44d306] /tmp/OAITestFrameWork-guptar/openairinterface5g/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1(phy_procedures_UE_RX+0x2b25)[0x49c015] /tmp/OAITestFrameWork-guptar/openairinterface5g/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1(phy_procedures_UE_lte+0x2ba)[0x49c33a] /tmp/OAITestFrameWork-guptar/openairinterface5g/cmake_targets/oaisim_noS1_build_oai/build/oaisim_nos1(l2l1_task+0xa09)[0x465549] /lib/x86_64-linux-gnu/libpthread.so.0(+0x8182)[0x7f8ea58c7182] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7f8ea424147d] Error: . Exiting! Writing 14336 elements of type 1 to rxsigF0.m Writing 14336 elements of type 1 to rxsigF0_ext.m Writing 4200 elements of type 1 to dlsch00_ch0_ext.m Writing 3600 elements of type 1 to dlsch_rxF_comp0.m Writing 600 elements of type 0 to dlsch_rxF_llr.m Writing 3600 elements of type 1 to dlsch_mag1.m Writing 3600 elements of type 1 to dlsch_mag2.m </EXECUTION LOG Test Case = 010200.oaisim_noS1.tdd.5MHz.TM1, Run = 1 >