## OAI PNF Log
###
```shell=
eric@mwnl-2nd:~/project/openairinterface5g/cmake_targets/ran_build/build$ sudo ./nr-softmodem -O ../../../../odu_at_oai/l2/mwnl/oai_pnf_conf/oaiL1.nfapi.usrpb210.conf --sa -E --gNBs.[0].min_rxtxtime 6 --continuous-tx --nfapi 1
[sudo] password for eric:
CMDLINE: "./nr-softmodem" "-O" "../../../../odu_at_oai/l2/mwnl/oai_pnf_conf/oaiL1.nfapi.usrpb210.conf" "--sa" "-E" "--gNBs.[0].min_rxtxtime" "6" "--continuous-tx" "--nfapi" "1"
[CONFIG] get parameters from libconfig ../../../../odu_at_oai/l2/mwnl/oai_pnf_conf/oaiL1.nfapi.usrpb210.conf , debug flags: 0x00000000
[LIBCONFIG] Path for include directive set to: ../../../../odu_at_oai/l2/mwnl/oai_pnf_conf
[CONFIG] function config_libconfig_init returned 0
[CONFIG] config module libconfig loaded
[LIBCONFIG] config: 1/1 parameters successfully set, (1 to default value)
[LIBCONFIG] log_config: 3/3 parameters successfully set, (1 to default value)
[LIBCONFIG] log_config: 55/55 parameters successfully set, (49 to default value)
[LIBCONFIG] log_config: 55/55 parameters successfully set, (55 to default value)
[LIBCONFIG] log_config: 16/16 parameters successfully set, (16 to default value)
[LIBCONFIG] log_config: 16/16 parameters successfully set, (16 to default value)
log init done
[HW] # /dev/cpu_dma_latency set to 2 us
Reading in command-line options
[LIBCONFIG] (root): 36/36 parameters successfully set, (32 to default value)
[LIBCONFIG] (root): 5/5 parameters successfully set, (4 to default value)
[ENB_APP] nfapi running mode: PNF
[GNB_APP] Getting GNBSParams
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] THREAD_STRUCT.[0]: 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] THREAD_STRUCT.[0]: 2/2 parameters successfully set, (0 to default value)
[CONFIG] parallel_conf is set to 0
[CONFIG] worker_conf is set to 1
Configuration: nb_rrc_inst 1, nb_nr_L1_inst 1, nb_ru 1
[LIBCONFIG] TTracer: 4/4 parameters successfully set, (4 to default value)
configuring for RAU/RRU
CPU Freq is 3.417727
[ITTI] Starting itti queue: TASK_UNKNOWN as task 0
[ITTI] Starting itti queue: TASK_TIMER as task 1
[ITTI] Starting itti queue: TASK_L2L1 as task 2
[ITTI] Starting itti queue: TASK_BM as task 3
[ITTI] Starting itti queue: TASK_PHY_ENB as task 4
[ITTI] Starting itti queue: TASK_MAC_ENB as task 5
[ITTI] Starting itti queue: TASK_MAC_GNB as task 6
[ITTI] Starting itti queue: TASK_RLC_ENB as task 7
[ITTI] Starting itti queue: TASK_RRC_ENB_NB_IoT as task 8
[ITTI] Starting itti queue: TASK_PDCP_ENB as task 9
[ITTI] Starting itti queue: TASK_PDCP_GNB as task 10
[ITTI] Starting itti queue: TASK_DATA_FORWARDING as task 11
[ITTI] Starting itti queue: TASK_END_MARKER as task 12
[ITTI] Starting itti queue: TASK_RRC_ENB as task 13
[ITTI] Starting itti queue: TASK_RRC_GNB as task 14
[ITTI] Starting itti queue: TASK_RAL_ENB as task 15
[ITTI] Starting itti queue: TASK_S1AP as task 16
[ITTI] Starting itti queue: TASK_NGAP as task 17
[ITTI] Starting itti queue: TASK_X2AP as task 18
[ITTI] Starting itti queue: TASK_M2AP_ENB as task 19
[ITTI] Starting itti queue: TASK_M2AP_MCE as task 20
[ITTI] Starting itti queue: TASK_M3AP as task 21
[ITTI] Starting itti queue: TASK_M3AP_MME as task 22
[ITTI] Starting itti queue: TASK_M3AP_MCE as task 23
[ITTI] Starting itti queue: TASK_SCTP as task 24
[ITTI] Starting itti queue: TASK_ENB_APP as task 25
[ITTI] Starting itti queue: TASK_GNB_APP as task 26
[ITTI] Starting itti queue: TASK_MCE_APP as task 27
[ITTI] Starting itti queue: TASK_MME_APP as task 28
[ITTI] Starting itti queue: TASK_FLEXRAN_AGENT as task 29
[ITTI] Starting itti queue: TASK_PHY_UE as task 30
[ITTI] Starting itti queue: TASK_MAC_UE as task 31
[ITTI] Starting itti queue: TASK_RLC_UE as task 32
[ITTI] Starting itti queue: TASK_PDCP_UE as task 33
[ITTI] Starting itti queue: TASK_RRC_UE as task 34
[ITTI] Starting itti queue: TASK_RRC_NRUE as task 35
[ITTI] Starting itti queue: TASK_NAS_UE as task 36
[ITTI] Starting itti queue: TASK_RAL_UE as task 37
[ITTI] Starting itti queue: TASK_GTPV1_U as task 38
[ITTI] Starting itti queue: TASK_CU_F1 as task 39
[ITTI] Starting itti queue: TASK_DU_F1 as task 40
[ITTI] Starting itti queue: TASK_RRC_UE_SIM as task 41
[ITTI] Starting itti queue: TASK_RRC_GNB_SIM as task 42
[ITTI] Starting itti queue: TASK_RRC_NSA_UE as task 43
[ITTI] Starting itti queue: TASK_RRC_NSA_NRUE as task 44
[ITTI] Starting itti queue: TASK_NAS_NRUE as task 45
[LIBCONFIG] opt: 3/3 parameters successfully set, (3 to default value)
[OPT] OPT disabled
[HW] Version: Branch: YC_develop Abrev. Hash: 61312ca6e2 Date: Fri Aug 12 05:33:12 2022 +0000
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[NR_PHY] PRB blacklist
[NR_PHY] RC.gNB = 0x55a7b3cb6e10
[LIBCONFIG] L1s.[0]: 15/15 parameters successfully set, (6 to default value)
[NR_PHY] RC.gNB[0] = 0x7efc849e4010
[NR_PHY] Copying 0 blacklisted PRB to L1 context
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_inst=1 this is because phy_init_RU() uses that to index and not RC.num_gNB - why the 2 similar variables?
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_CC[0]=1 for init_gNB_afterRU()
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_macrlc_inst:1 because used by mac_top_init_gNB()
configure_nr_nfapi_pnf() PNF
[ENB_APP] nfapi running mode: PNF
configure_nr_nfapi_pnf() VNF:127.0.0.1:62324 PNF_PHY[addr:127.0.0.2 UDP:tx_addr:127.0.0.1:50611 rx:32123]
Initializing northbound interface for L1
[PHY] l1_north_init_gNB() RC.nb_nr_L1_inst:1
[PHY] Installing callbacks for IF_Module - UL_indication
[MAC] Allocating shared L1/L2 interface structure for instance 0 @ 0x55a7b3cbb810
[PHY] l1_north_init_gNB() RC.gNB[0] installing callbacks
Read message unpack: 0 0 1 0 0 8 0 0
[PNF] pnf param request
Read message unpack: 0 0 1 2 0 26 0 0 16 3 0 14 0 2 0 1 0 0 0 0 0 0 0 0 0 0
[PNF] pnf config request
[PNF] pnf config request assigned phy_id 1 to phy_config_index 0
[PNF] Sent pnf_config_resp
Read message unpack: 0 0 1 4 0 8 0 0
Received NFAPI_PNF_START_REQUEST
[PNF] Sent NFAPI_PNF_START_RESP
Read message unpack: 0 1 0 0 0 8 0 0
[PNF] Received NFAPI_PARAM_REQUEST phy_id:1
TAG value :2
RUNNING pack_param_response
[PNF] Sent NFAPI_PNF_PARAM_RESPONSE phy_id:1 number_of_tlvs:62
[PNF] param request .. exit
Read message unpack: 0 1 0 2 2 236 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 2 2 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 2 2 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 2 2 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 2 2 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 34 16 1 0 2 0 20 16 2 0 4 0 33 24 248 16 4 0 2 0 106 16 5 0 2 0 1 16 6 0 2 0 20 16 7 0 4 0 26 254 120 16 9 0 2 0 106 16 10 0 2 0 1 16 12 0 2 0 1 16 13 0 1 0 16 14 0 4 0 0 0 0 16 16 0 1 1 16 18 0 1 30 16 19 0 1 0 16 20 0 1 1 16 41 0 1 88 16 21 0 2 0 0 16 23 0 2 0 0 16 24 0 1 4 16 27 0 1 1 16 29 0 2 0 24 16 31 0 1 2 16 32 0 1 0 16 33 0 4 0 0 6 0 16 34 0 4 0 0 0 1 1 0 0 4 127 0 0 1 1 2 0 2 197 179 1 31 0 1 3 1 32 0 1 10 1 30 0 1 30
[PNF] Received NFAPI_CONFIG_REQ phy_id:1
Timing window tag: 286
Phy_info:Timing window:30 NFAPI_CONFIG:timing_window:30
timing info mode:3
timing info period provided value:10
nr_config_request() NFAPI_NR_CONFIG_DL_BANDWIDTH_TAG N_RB_DL:20
[PNF] CONFIG_REQUEST[num_tlv:34] TLVs processed:6
[PNF] Simulating PHY CONFIG - DJP
DL frequency 2188160000: band 66, UL frequency 1788160000
[PHY] DL frequency 2188160000 Hz, UL frequency 1788160000 Hz: band 66, uldl offset -400000000 Hz
[PHY] Configuring MIB for instance 0, : (Nid_cell 1,DL freq 2188160000, UL freq 1788160000)
[PHY] Initializing frame parms for mu 1, N_RB 106, Ncp 0
[PHY] Init: N_RB_DL 106, first_carrier_offset 900, nb_prefix_samples 108,nb_prefix_samples0 132
[PHY] Doing symbol rotation calculation for gNB TX/RX, f0 2188160000.000000 Hz, Nsymb 28
[PHY] Symbol rotation 0/28 => tl 0.000000 (16383,-28378) (0.166667)
[PHY] Symbol rotation 1/28 => tl 0.000036 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 2/28 => tl 0.000072 (-32767,-1) (0.500000)
[PHY] Symbol rotation 3/28 => tl 0.000108 (-16384,28377) (0.666667)
[PHY] Symbol rotation 4/28 => tl 0.000143 (16383,28377) (0.833333)
[PHY] Symbol rotation 5/28 => tl 0.000179 (32767,-1) (0.000000)
[PHY] Symbol rotation 6/28 => tl 0.000215 (16383,-28378) (0.166667)
[PHY] Symbol rotation 7/28 => tl 0.000250 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 8/28 => tl 0.000286 (-32767,-1) (0.500000)
[PHY] Symbol rotation 9/28 => tl 0.000322 (-16384,28377) (0.666667)
[PHY] Symbol rotation 10/28 => tl 0.000357 (16383,28377) (0.833333)
[PHY] Symbol rotation 11/28 => tl 0.000393 (32767,0) (1.000000)
[PHY] Symbol rotation 12/28 => tl 0.000429 (16383,-28378) (0.166667)
[PHY] Symbol rotation 13/28 => tl 0.000464 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 14/28 => tl 0.000500 (16383,-28378) (0.166667)
[PHY] Symbol rotation 15/28 => tl 0.000536 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 16/28 => tl 0.000572 (-32767,-1) (0.500000)
[PHY] Symbol rotation 17/28 => tl 0.000608 (-16384,28377) (0.666667)
[PHY] Symbol rotation 18/28 => tl 0.000643 (16383,28377) (0.833333)
[PHY] Symbol rotation 19/28 => tl 0.000679 (32767,0) (1.000000)
[PHY] Symbol rotation 20/28 => tl 0.000715 (16383,-28378) (0.166667)
[PHY] Symbol rotation 21/28 => tl 0.000750 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 22/28 => tl 0.000786 (-32767,-1) (0.500000)
[PHY] Symbol rotation 23/28 => tl 0.000822 (-16384,28377) (0.666667)
[PHY] Symbol rotation 24/28 => tl 0.000857 (16383,28377) (0.833333)
[PHY] Symbol rotation 25/28 => tl 0.000893 (32767,0) (1.000000)
[PHY] Symbol rotation 26/28 => tl 0.000929 (16383,-28378) (0.166667)
[PHY] Symbol rotation 27/28 => tl 0.000964 (-16384,-28378) (0.333333)
[PHY] Doing symbol rotation calculation for gNB TX/RX, f0 1788160000.000000 Hz, Nsymb 28
[PHY] Symbol rotation 0/28 => tl 0.000000 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 1/28 => tl 0.000036 (-16384,28377) (0.666667)
[PHY] Symbol rotation 2/28 => tl 0.000072 (32767,-1) (0.000000)
[PHY] Symbol rotation 3/28 => tl 0.000108 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 4/28 => tl 0.000143 (-16384,28377) (0.666667)
[PHY] Symbol rotation 5/28 => tl 0.000179 (32767,-1) (0.000000)
[PHY] Symbol rotation 6/28 => tl 0.000215 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 7/28 => tl 0.000250 (-16384,28377) (0.666667)
[PHY] Symbol rotation 8/28 => tl 0.000286 (32767,0) (1.000000)
[PHY] Symbol rotation 9/28 => tl 0.000322 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 10/28 => tl 0.000357 (-16384,28377) (0.666667)
[PHY] Symbol rotation 11/28 => tl 0.000393 (32767,0) (1.000000)
[PHY] Symbol rotation 12/28 => tl 0.000429 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 13/28 => tl 0.000464 (-16384,28377) (0.666667)
[PHY] Symbol rotation 14/28 => tl 0.000500 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 15/28 => tl 0.000536 (-16384,28377) (0.666667)
[PHY] Symbol rotation 16/28 => tl 0.000572 (32767,0) (1.000000)
[PHY] Symbol rotation 17/28 => tl 0.000608 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 18/28 => tl 0.000643 (-16384,28377) (0.666667)
[PHY] Symbol rotation 19/28 => tl 0.000679 (32767,0) (1.000000)
[PHY] Symbol rotation 20/28 => tl 0.000715 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 21/28 => tl 0.000750 (-16384,28377) (0.666667)
[PHY] Symbol rotation 22/28 => tl 0.000786 (32767,0) (1.000000)
[PHY] Symbol rotation 23/28 => tl 0.000822 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 24/28 => tl 0.000857 (-16384,28377) (0.666667)
[PHY] Symbol rotation 25/28 => tl 0.000893 (32767,0) (1.000000)
[PHY] Symbol rotation 26/28 => tl 0.000929 (-16384,-28378) (0.333333)
[PHY] Symbol rotation 27/28 => tl 0.000964 (-16384,28377) (0.666667)
[PHY] Timeshift symbol rotation 0 => (32767,0) 0.000000
[PHY] Timeshift symbol rotation 1 => (32721,1742) -0.053178
[PHY] Timeshift symbol rotation 2 => (32582,3478) -0.106356
[PHY] Timeshift symbol rotation 3 => (32351,5205) -0.159534
[PHY] Timeshift symbol rotation 4 => (32028,6917) -0.212712
[PHY] Timeshift symbol rotation 5 => (31616,8610) -0.265890
[PHY] Timeshift symbol rotation 6 => (31113,10278) -0.319068
[PHY] Timeshift symbol rotation 7 => (30523,11918) -0.372246
[PHY] Timeshift symbol rotation 8 => (29846,13523) -0.425424
[PHY] Timeshift symbol rotation 9 => (29085,15090) -0.478602
[PHY] gNB 0 configured
[PHY] fp->scs=30000
[PHY] fp->ofdm_symbol_size=1536
[PHY] fp->nb_prefix_samples0=132
[PHY] fp->nb_prefix_samples=108
[PHY] fp->slots_per_subframe=2
[PHY] fp->samples_per_subframe_wCP=43008
[PHY] fp->samples_per_frame_wCP=430080
[PHY] fp->samples_per_subframe=46080
[PHY] fp->samples_per_frame=460800
[PHY] fp->dl_CarrierFreq=2188160000
[PHY] fp->ul_CarrierFreq=1788160000
[PNF] 1 vnf p7 127.0.0.1:50611 timing 30 3 10
[PNF] Sent NFAPI_PNF_CONFIG_RESPONSE phy_id:1
Read message unpack: 0 1 0 4 0 8 0 0
[PNF] Received NFAPI_START_REQ phy_id:1
[PNF] P7 remote:127.0.0.1:50611 local:127.0.0.2:32123
subframe_buffer_size configured using phy_info->timing_window:30
[PNF] Sending PNF_START_RESP
Sending NFAPI_START_RESPONSE config:0x55a7b3cb9590 phy_id:1
[ITTI] Created Posix thread TASK_SCTP
[LIBCONFIG] eNBs.[0]: 1/1 parameters successfully set, (1 to default value)
[LIBCONFIG] gNBs.[0]: 1/1 parameters successfully set, (1 to default value)
[X2AP] X2AP is disabled.
[LIBCONFIG] gNBs.[0].NETWORK_INTERFACES: 10/10 parameters successfully set, (3 to default value)
[PHY] l1_north_init_gNB() RC.nb_nr_L1_inst:1
[PHY] Installing callbacks for IF_Module - UL_indication
[PHY] l1_north_init_gNB() RC.gNB[0] installing callbacks
Calling sched_setscheduler(79)
[NGAP] Starting NGAP layer
[ITTI] Created Posix thread TASK_NGAP
[PHY] gNB_app_task() Task ready initialize structures
[ITTI] Created Posix thread TASK_GNB_APP
[NR_RRC] Creating NR RRC gNB Task
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[NR_PHY] PRB blacklist
[LIBCONFIG] L1s.[0]: 15/15 parameters successfully set, (6 to default value)
[NR_PHY] Copying 0 blacklisted PRB to L1 context
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_inst=1 this is because phy_init_RU() uses that to index and not RC.num_gNB - why the 2 similar variables?
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_CC[0]=1 for init_gNB_afterRU()
[PHY] RCconfig_NR_L1() NFAPI PNF mode - RC.nb_nr_macrlc_inst:1 because used by mac_top_init_gNB()
configure_nr_nfapi_pnf() PNF
[ENB_APP] nfapi running mode: PNF
configure_nr_nfapi_pnf() VNF:127.0.0.1:62324 PNF_PHY[addr:127.0.0.2 UDP:tx_addr:127.0.0.1:50611 rx:32123]
Initializing northbound interface for L1
[PHY] l1_north_init_gNB() RC.nb_nr_L1_inst:1
[PHY] Installing callbacks for IF_Module - UL_indication
[PHY] l1_north_init_gNB() RC.gNB[0] installing callbacks
[LIBCONFIG] MACRLCs.[0]: 33/33 parameters successfully set, (26 to default value)
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[LIBCONFIG] MACRLCs.[0]: 33/33 parameters successfully set, (26 to default value)
[MAC] [MAIN] Init function start:nb_nr_macrlc_inst=1
[NR_RRC] Entering main loop of NR_RRC message task
[ITTI] Created Posix thread TASK_RRC_GNB
Read message unpack: 0 0 1 0 0 8 0 0
[PNF] pnf param request
Read message unpack: 0 0 1 2 0 26 0 0 16 3 0 14 0 2 0 2 0 0 0 0 0 0 0 0 0 0
[PNF] pnf config request
[PNF] pnf config request assigned phy_id 2 to phy_config_index 0
[PNF] Sent pnf_config_resp
Read message unpack: 0 0 1 4 0 8 0 0
Received NFAPI_PNF_START_REQUEST
[PNF] Sent NFAPI_PNF_START_RESP
Read message unpack: 0 2 0 0 0 8 0 0
[PNF] Received NFAPI_PARAM_REQUEST phy_id:2
TAG value :2
RUNNING pack_param_response
[PNF] Sent NFAPI_PNF_PARAM_RESPONSE phy_id:2 number_of_tlvs:62
[PNF] param request .. exit
[ITTI] Created Posix thread TASK_GTPV1_U
NFAPI*** - mutex and cond created - will block shortly for completion of PNF connection
NFAPI MODE:PNF
START MAIN THREADS
RC.nb_nr_L1_inst:1
Initializing gNB threads single_thread_flag:1 wait_for_sync:0
[PHY] Initializing gNB 0 single_thread_flag:1
[PHY] Initializing gNB 0
[PHY] Registering with MAC interface module (before 0x55a7b3cbb810)
[PHY] Installing callbacks for IF_Module - UL_indication
[PHY] Registering with MAC interface module (after 0x55a7b3cbb810)
[PHY] Setting indication lists
[PHY] [nr-gnb.c] gNB structure allocated
wait_gNBs()
Waiting for gNB L1 instances to all get configured ... sleeping 50ms (nb_nr_sL1_inst 1)
[PHY] Installing callbacks for IF_Module - UL_indication
[NR_MAC] PUSCH Target 150, PUCCH Target 200, PUCCH Failure 10, PUSCH Failure 10
[PHY] gNB_app_task() RC.nb_nr_L1_inst:1
[PHY] l1_north_init_gNB() RC.nb_nr_L1_inst:1
[PHY] Installing callbacks for IF_Module - UL_indication
[PHY] l1_north_init_gNB() RC.gNB[0] installing callbacks
[GNB_APP] Allocating gNB_RRC_INST for 1 instances
[PHY] gNB_app_task() RC.nb_nr_inst:1 RC.nrrrc:0x7efc7800ce50
[PHY] gNB_app_task() Creating RRC instance RC.nrrrc[0]:0x7efc7800ce70 (1 of 1)
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[LIBCONFIG] gNBs.[0].pdcch_ConfigSIB1.[0]: 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].servingCellConfigCommon.[0]: 60/60 parameters successfully set, (9 to default value)
[RRC] Read in ServingCellConfigCommon (PhysCellId 0, ABSFREQSSB 641280, DLBand 78, ABSFREQPOINTA 640008, DLBW 106,RACH_TargetReceivedPower -96
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] NR band 78, duplex mode TDD, duplex spacing = 0 KHz
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] NR band 78, duplex mode TDD, duplex spacing = 0 KHz
[LIBCONFIG] gNBs.[0].servingCellConfigDedicated.[0]: 42/42 parameters successfully set, (21 to default value)
[RRC] Read in ServingCellConfigDedicated UL (FreqDensity_0 -1, FreqDensity_1 -1, TimeDensity_0 -1, TimeDensity_1 -1, TimeDensity_2 -1, RE offset -1, First_active_BWP_ID 1 SCS 1, LocationandBW 28875
[GNB_APP] DL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
[GNB_APP] DL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
[GNB_APP] DL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
[GNB_APP] UL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
[GNB_APP] UL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
[GNB_APP] UL PTRS frequencyDensity 1 not set. Assuming PTRS not present!
NRRRC 0: Southbound Transport local_mac
[NR_RRC] Setting node_type to ngran_gNB
[LIBCONFIG] gNBs.[0].plmn_list.[0]: 3/3 parameters successfully set, (0 to default value)
[GNB_APP] pdsch_AntennaPorts N1 1
[GNB_APP] pdsch_AntennaPorts N2 1
[GNB_APP] pdsch_AntennaPorts XP 1
[GNB_APP] pusch_AntennaPorts 1
[GNB_APP] minTXRXTIME 6
[GNB_APP] SIB1 TDA 1
[GNB_APP] Do CSI-RS 1
[GNB_APP] Do SRS 1
[GNB_APP] 256 QAM: may be on
[GNB_APP] SDAP layer is disabled
[LIBCONFIG] security: 4/4 parameters successfully set, (2 to default value)
[RRC] no preferred ciphering algorithm set in configuration file, applying default parameters (no security)
[RRC] no preferred integrity algorithm set in configuration file, applying default parameters (nia2)
[GNB_APP] RRC starting with node type 2
[GNB_APP] Sending configuration message to NR_RRC task
[PDCP] pdcp init,usegtp
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[NR_RRC] Received message NRRRC_CONFIGURATION_REQ
[NR_RRC] [gNB 0] Received NRRRC_CONFIGURATION_REQ : 0x7efc7800e550
[NR_RRC] [FRAME 00000][gNB][MOD 00][RNTI 0] Init...
[LIBCONFIG] gNBs.[0]: 27/27 parameters successfully set, (18 to default value)
[LIBCONFIG] gNBs.[0].plmn_list.[0]: 3/3 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].plmn_list.[0].snssaiList.[0]: 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].amf_ip_address.[0]: 4/4 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].SCTP: 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].NETWORK_INTERFACES: 10/10 parameters successfully set, (3 to default value)
[GNB_APP] default drx 0
[GTPU] Configuring GTPu
[LIBCONFIG] (root): 2/2 parameters successfully set, (0 to default value)
[LIBCONFIG] gNBs.[0].NETWORK_INTERFACES: 10/10 parameters successfully set, (3 to default value)
[GTPU] SA mode
[GTPU] Configuring GTPu address : 192.168.70.129 -> 8146a8c0
[GNB_APP] [gNB 0] gNB_app_register for instance 0
[GTPU] Initializing UDP for local address 192.168.70.129 with port 2152
[NGAP] Registered new gNB[0] and macro gNB id 3584
[NGAP] [gNB 0] check the amf registration state
[GTPU] bind: Address already in use
[GTPU] failed to bind socket: 192.168.70.129 2152
[GTPU] can't create GTP-U instance
[GTPU] Created gtpu instance id: -1
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] NR band 78, duplex mode TDD, duplex spacing = 0 KHz
[NR_RRC] [FRAME 00000][gNB][MOD 00][RNTI 0] Checking release
[NR_RRC] SIB1 freq: absoluteFrequencySSB 641280, absoluteFrequencyPointA 640008
[NR_RRC] SIB1 freq: absolute_diff 1272, 2*(absolute_diff/(12*2) - 10) 86
<SIB1>
<cellSelectionInfo>
<q-RxLevMin>-65</q-RxLevMin>
</cellSelectionInfo>
<cellAccessRelatedInfo>
<plmn-IdentityList>
<PLMN-IdentityInfo>
<plmn-IdentityList>
<PLMN-Identity>
<mcc>
<MCC-MNC-Digit>2</MCC-MNC-Digit>
<MCC-MNC-Digit>0</MCC-MNC-Digit>
<MCC-MNC-Digit>8</MCC-MNC-Digit>
</mcc>
<mnc>
<MCC-MNC-Digit>9</MCC-MNC-Digit>
<MCC-MNC-Digit>9</MCC-MNC-Digit>
</mnc>
</PLMN-Identity>
</plmn-IdentityList>
<trackingAreaCode>
000000000000000000000001
</trackingAreaCode>
<cellIdentity>
000000000000000000000000111000000000
</cellIdentity>
<cellReservedForOperatorUse><notReserved/></cellReservedForOperatorUse>
</PLMN-IdentityInfo>
</plmn-IdentityList>
</cellAccessRelatedInfo>
<servingCellConfigCommon>
<downlinkConfigCommon>
<frequencyInfoDL>
<frequencyBandList>
<NR-MultiBandInfo>
<freqBandIndicatorNR>78</freqBandIndicatorNR>
</NR-MultiBandInfo>
</frequencyBandList>
<offsetToPointA>86</offsetToPointA>
<scs-SpecificCarrierList>
<SCS-SpecificCarrier>
<offsetToCarrier>0</offsetToCarrier>
<subcarrierSpacing><kHz30/></subcarrierSpacing>
<carrierBandwidth>106</carrierBandwidth>
</SCS-SpecificCarrier>
</scs-SpecificCarrierList>
</frequencyInfoDL>
<initialDownlinkBWP>
<genericParameters>
<locationAndBandwidth>28875</locationAndBandwidth>
<subcarrierSpacing><kHz30/></subcarrierSpacing>
</genericParameters>
<pdcch-ConfigCommon>
<setup>
<controlResourceSetZero>12</controlResourceSetZero>
<searchSpaceZero>0</searchSpaceZero>
<commonSearchSpaceList>
<SearchSpace>
<searchSpaceId>1</searchSpaceId>
<controlResourceSetId>0</controlResourceSetId>
<monitoringSlotPeriodicityAndOffset>
<sl1></sl1>
</monitoringSlotPeriodicityAndOffset>
<monitoringSymbolsWithinSlot>
10000000000000
</monitoringSymbolsWithinSlot>
<nrofCandidates>
<aggregationLevel1><n0/></aggregationLevel1>
<aggregationLevel2><n0/></aggregationLevel2>
<aggregationLevel4><n2/></aggregationLevel4>
<aggregationLevel8><n0/></aggregationLevel8>
<aggregationLevel16><n0/></aggregationLevel16>
</nrofCandidates>
<searchSpaceType>
<common>
<dci-Format0-0-AndFormat1-0>
</dci-Format0-0-AndFormat1-0>
</common>
</searchSpaceType>
</SearchSpace>
<SearchSpace>
<searchSpaceId>5</searchSpaceId>
<controlResourceSetId>0</controlResourceSetId>
<monitoringSlotPeriodicityAndOffset>
<sl5>0</sl5>
</monitoringSlotPeriodicityAndOffset>
<duration>2</duration>
<monitoringSymbolsWithinSlot>
10000000000000
</monitoringSymbolsWithinSlot>
<nrofCandidates>
<aggregationLevel1><n0/></aggregationLevel1>
<aggregationLevel2><n0/></aggregationLevel2>
<aggregationLevel4><n4/></aggregationLevel4>
<aggregationLevel8><n2/></aggregationLevel8>
<aggregationLevel16><n1/></aggregationLevel16>
</nrofCandidates>
<searchSpaceType>
<common>
<dci-Format0-0-AndFormat1-0>
</dci-Format0-0-AndFormat1-0>
</common>
</searchSpaceType>
</SearchSpace>
<SearchSpace>
<searchSpaceId>7</searchSpaceId>
<controlResourceSetId>0</controlResourceSetId>
<monitoringSlotPeriodicityAndOffset>
<sl1></sl1>
</monitoringSlotPeriodicityAndOffset>
<monitoringSymbolsWithinSlot>
10000000000000
</monitoringSymbolsWithinSlot>
<nrofCandidates>
<aggregationLevel1><n0/></aggregationLevel1>
<aggregationLevel2><n0/></aggregationLevel2>
<aggregationLevel4><n4/></aggregationLevel4>
<aggregationLevel8><n2/></aggregationLevel8>
<aggregationLevel16><n1/></aggregationLevel16>
</nrofCandidates>
<searchSpaceType>
<common>
<dci-Format0-0-AndFormat1-0>
</dci-Format0-0-AndFormat1-0>
</common>
</searchSpaceType>
</SearchSpace>
</commonSearchSpaceList>
<searchSpaceSIB1>0</searchSpaceSIB1>
<searchSpaceOtherSystemInformation>7</searchSpaceOtherSystemInformation>
<pagingSearchSpace>5</pagingSearchSpace>
<ra-SearchSpace>1</ra-SearchSpace>
</setup>
</pdcch-ConfigCommon>
<pdsch-ConfigCommon>
<setup>
<pdsch-TimeDomainAllocationList>
<PDSCH-TimeDomainResourceAllocation>
<mappingType><typeA/></mappingType>
<startSymbolAndLength>40</startSymbolAndLength>
</PDSCH-TimeDomainResourceAllocation>
<PDSCH-TimeDomainResourceAllocation>
<mappingType><typeA/></mappingType>
<startSymbolAndLength>54</startSymbolAndLength>
</PDSCH-TimeDomainResourceAllocation>
<PDSCH-TimeDomainResourceAllocation>
<mappingType><typeA/></mappingType>
<startSymbolAndLength>57</startSymbolAndLength>
</PDSCH-TimeDomainResourceAllocation>
</pdsch-TimeDomainAllocationList>
</setup>
</pdsch-ConfigCommon>
</initialDownlinkBWP>
<bcch-Config>
<modificationPeriodCoeff><n2/></modificationPeriodCoeff>
</bcch-Config>
<pcch-Config>
<defaultPagingCycle><rf256/></defaultPagingCycle>
<nAndPagingFrameOffset>
<quarterT>1</quarterT>
</nAndPagingFrameOffset>
<ns><one/></ns>
<firstPDCCH-MonitoringOccasionOfPO>
<sCS120KHZoneT-SCS60KHZhalfT-SCS30KHZquarterT-SCS15KHZoneEighthT>
<INTEGER>0</INTEGER>
</sCS120KHZoneT-SCS60KHZhalfT-SCS30KHZquarterT-SCS15KHZoneEighthT>
</firstPDCCH-MonitoringOccasionOfPO>
</pcch-Config>
</downlinkConfigCommon>
<uplinkConfigCommon>
<frequencyInfoUL>
<scs-SpecificCarrierList>
<SCS-SpecificCarrier>
<offsetToCarrier>0</offsetToCarrier>
<subcarrierSpacing><kHz30/></subcarrierSpacing>
<carrierBandwidth>106</carrierBandwidth>
</SCS-SpecificCarrier>
</scs-SpecificCarrierList>
<p-Max>23</p-Max>
</frequencyInfoUL>
<initialUplinkBWP>
<genericParameters>
<locationAndBandwidth>28875</locationAndBandwidth>
<subcarrierSpacing><kHz30/></subcarrierSpacing>
</genericParameters>
<rach-ConfigCommon>
<setup>
<rach-ConfigGeneric>
<prach-ConfigurationIndex>98</prach-ConfigurationIndex>
<msg1-FDM><one/></msg1-FDM>
<msg1-FrequencyStart>0</msg1-FrequencyStart>
<zeroCorrelationZoneConfig>13</zeroCorrelationZoneConfig>
<preambleReceivedTargetPower>-96</preambleReceivedTargetPower>
<preambleTransMax><n10/></preambleTransMax>
<powerRampingStep><dB2/></powerRampingStep>
<ra-ResponseWindow><sl10/></ra-ResponseWindow>
</rach-ConfigGeneric>
<ssb-perRACH-OccasionAndCB-PreamblesPerSSB>
<one><n60/></one>
</ssb-perRACH-OccasionAndCB-PreamblesPerSSB>
<ra-ContentionResolutionTimer><sf64/></ra-ContentionResolutionTimer>
<rsrp-ThresholdSSB>19</rsrp-ThresholdSSB>
<prach-RootSequenceIndex>
<l139>1</l139>
</prach-RootSequenceIndex>
<msg1-SubcarrierSpacing><kHz30/></msg1-SubcarrierSpacing>
<restrictedSetConfig><unrestrictedSet/></restrictedSetConfig>
</setup>
</rach-ConfigCommon>
<pusch-ConfigCommon>
<setup>
<pusch-TimeDomainAllocationList>
<PUSCH-TimeDomainResourceAllocation>
<k2>6</k2>
<mappingType><typeB/></mappingType>
<startSymbolAndLength>41</startSymbolAndLength>
</PUSCH-TimeDomainResourceAllocation>
<PUSCH-TimeDomainResourceAllocation>
<k2>6</k2>
<mappingType><typeB/></mappingType>
<startSymbolAndLength>38</startSymbolAndLength>
</PUSCH-TimeDomainResourceAllocation>
<PUSCH-TimeDomainResourceAllocation>
<k2>7</k2>
<mappingType><typeB/></mappingType>
<startSymbolAndLength>38</startSymbolAndLength>
</PUSCH-TimeDomainResourceAllocation>
</pusch-TimeDomainAllocationList>
<msg3-DeltaPreamble>1</msg3-DeltaPreamble>
<p0-NominalWithGrant>-90</p0-NominalWithGrant>
</setup>
</pusch-ConfigCommon>
<pucch-ConfigCommon>
<setup>
<pucch-ResourceCommon>0</pucch-ResourceCommon>
<pucch-GroupHopping><neither/></pucch-GroupHopping>
<hoppingId>40</hoppingId>
<p0-nominal>-90</p0-nominal>
</setup>
</pucch-ConfigCommon>
</initialUplinkBWP>
<timeAlignmentTimerCommon><infinity/></timeAlignmentTimerCommon>
</uplinkConfigCommon>
<ssb-PositionsInBurst>
<inOneGroup>
10000000
</inOneGroup>
</ssb-PositionsInBurst>
<ssb-PeriodicityServingCell><ms20/></ssb-PeriodicityServingCell>
<tdd-UL-DL-ConfigurationCommon>
<referenceSubcarrierSpacing><kHz30/></referenceSubcarrierSpacing>
<pattern1>
<dl-UL-TransmissionPeriodicity><ms5/></dl-UL-TransmissionPeriodicity>
<nrofDownlinkSlots>7</nrofDownlinkSlots>
<nrofDownlinkSymbols>6</nrofDownlinkSymbols>
<nrofUplinkSlots>2</nrofUplinkSlots>
<nrofUplinkSymbols>4</nrofUplinkSymbols>
</pattern1>
</tdd-UL-DL-ConfigurationCommon>
<ss-PBCH-BlockPower>-25</ss-PBCH-BlockPower>
</servingCellConfigCommon>
<ue-TimersAndConstants>
<t300><ms400/></t300>
<t301><ms400/></t301>
<t310><ms2000/></t310>
<n310><n10/></n310>
<t311><ms3000/></t311>
<n311><n1/></n311>
<t319><ms400/></t319>
</ue-TimersAndConstants>
</SIB1>
[NR_RRC] do_SIB23_NR, size 9
[NR_RRC] Done init_NR_SI
[NR_MAC] Configuring common parameters from NR ServingCellConfig
[NR_MAC] config_common() dl_BandwidthP:40
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] Computing frequency (pointA 640008 => 3600120 KHz (freq_min 3300000 KHz, NR band 78 N_OFFs 620000))
[NR_MAC] config_common() dl_BandwidthP:40
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] Computing frequency (pointA 640008 => 3600120 KHz (freq_min 3300000 KHz, NR band 78 N_OFFs 620000))
[NR_MAC] NR band duplex spacing is 0 KHz (nr_bandtable[37].band = 78)
[NR_MAC] NR band 78, duplex mode TDD, duplex spacing = 0 KHz
[NR_MAC] Set RX antenna number to 1, Set TX antenna number to 1 (num ssb 1: 80000000,0)
[NR_MAC] Setting TDD configuration period to 6
[NR_MAC] TDD has been properly configurated
DL frequency 3619200000: band 48, UL frequency 3619200000
[PHY] DL frequency 3619200000 Hz, UL frequency 3619200000 Hz: band 48, uldl offset 0 Hz
[PHY] Configuring MIB for instance 0, : (Nid_cell 0,DL freq 3619200000, UL freq 3619200000)
[PHY] Initializing frame parms for mu 1, N_RB 106, Ncp 0
[PHY] Init: N_RB_DL 106, first_carrier_offset 900, nb_prefix_samples 108,nb_prefix_samples0 132
[PHY] Already gNB already configured, do nothing
[NR_MAC] In rrc_mac_config_req_gNB: slot 0 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 1 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 2 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 3 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 4 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 5 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 6 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 7 DL 1 UL 1
[NR_MAC] In rrc_mac_config_req_gNB: slot 8 DL 0 UL 1
[NR_MAC] In rrc_mac_config_req_gNB: slot 9 DL 0 UL 1
[NR_MAC] In rrc_mac_config_req_gNB: slot 10 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 11 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 12 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 13 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 14 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 15 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 16 DL 1 UL 0
[NR_MAC] In rrc_mac_config_req_gNB: slot 17 DL 1 UL 1
[NR_MAC] In rrc_mac_config_req_gNB: slot 18 DL 0 UL 1
[NR_MAC] In rrc_mac_config_req_gNB: slot 19 DL 0 UL 1
[NR_RRC] [FRAME 00000][gNB][MOD 00][RNTI 0] gNB:OPENAIR NR RRC IN....
gNB L1 are configured
About to Init RU threads RC.nb_RU:1
Initializing RU threads
configuring RU from file
[LIBCONFIG] RUs.[0]: 33/33 parameters successfully set, (25 to default value)
Set RU mask to 1
Creating RC.ru[0]:0x55a7b3cbe0f0
[PHY] Setting clock source to internal
[PHY] Setting time source to internal
Setting function for RU 0 to gNodeB_3GPP
[RU 0] Setting nr_flag 0, nr_band 7, nr_scs_for_raster 1
[PHY] number of L1 instances 1, number of RU 1, number of CPU cores 24
[PHY] DJP - delete code above this /home/eric/project/openairinterface5g/executables/nr-ru.c:1733
[PHY] Copying frame parms from gNB in RC to gNB 0 in ru 0 and frame_parms in ru
configuring ru_id 0 (start_rf 0x55a7b1545860)
[PHY] Starting ru_thread 0
[PHY] Initializing RU proc 0 (,synch_to_ext_device),
[PHY] Starting RU 0 (,synch_to_ext_device),
[PHY] Initializing frame parms for mu 1, N_RB 106, Ncp 0
[PHY] Init: N_RB_DL 106, first_carrier_offset 900, nb_prefix_samples 108,nb_prefix_samples0 132
[PHY] fp->scs=30000
[PHY] fp->ofdm_symbol_size=1536
[PHY] fp->nb_prefix_samples0=132
[PHY] fp->nb_prefix_samples=108
[PHY] fp->slots_per_subframe=2
[PHY] fp->samples_per_subframe_wCP=43008
[PHY] fp->samples_per_frame_wCP=430080
[PHY] fp->samples_per_subframe=46080
[PHY] fp->samples_per_frame=460800
[PHY] fp->dl_CarrierFreq=3619200000
[PHY] fp->ul_CarrierFreq=3619200000
[PHY] Channel 0: setting tx_gain offset 90, rx_gain offset 125, tx_freq 3619200000 Hz, rx_freq 3619200000 Hz, tune_offset 0 Hz
[PHY] Initializing RU signal buffers (if_south local RF) nb_tx 1, nb_rx 1
[PHY] [INIT] common.txdata[0] = 0x7efc84020040 (1844480 bytes,sf_extension 320)
[PHY] [INIT] common.txdata[0] = 0x7efc84020540
[PHY] nb_tx 1
[PHY] rxdata_7_5kHz[0] 0x7efc7c377040 for RU 0
[PHY] [INIT] common.txdata_BF= 0x7efc5c000b00 (8 bytes)
[PHY] txdataF_BF[0] 0x7efc7c1a7040 for RU 0
[PHY] rxdataF[0] 0x7efc7c152040 for RU 0
[PHY] init feptx thread 0
[PHY] init feptx thread 1
waiting for NFAPI PNF connection and population of global structure (main?)
[PHY] [INIT] nr_phy_init_RU() ru->num_gNB:1
[LIBCONFIG] device.recplay: 8/8 parameters successfully set, (8 to default value)
[LIBCONFIG] device: 1/1 parameters successfully set, (1 to default value)
[LIBCONFIG] loader: 2/2 parameters successfully set, (2 to default value)
[LIBCONFIG] loader.oai_device: 2/2 parameters successfully set, (1 to default value)
shlib_path liboai_device.so
[LOADER] library liboai_device.so successfully loaded
[HW] openair0_cfg[0].sdr_addrs == '(null)'
[HW] openair0_cfg[0].clock_source == '0' (internal = 0, external = 1)
[HW] UHD version 4.4.0.0-0ubuntu1~focal1 (4.4.0)
[INFO] [UHD] linux; GNU C++ version 9.4.0; Boost_107100; UHD_4.4.0.0-0ubuntu1~focal1
[HW] Found USRP b200
[INFO] [B200] Detected Device: B210
[INFO] [B200] Operating over USB 3.
[INFO] [B200] Initialize CODEC control...
[INFO] [B200] Initialize Radio control...
[INFO] [B200] Performing register loopback test...
[INFO] [B200] Register loopback test passed
[INFO] [B200] Performing register loopback test...
[INFO] [B200] Register loopback test passed
[INFO] [B200] Asking for clock rate 30.720000 MHz...
[INFO] [B200] Actually got clock rate 30.720000 MHz.
[HW] Setting clock source to internal
[HW] Setting time source to internal
-- Using calibration table: calib_table_b210_38
[INFO] [B200] Asking for clock rate 46.080000 MHz...
[INFO] [B200] Actually got clock rate 46.080000 MHz.
[HW] cal 0: freq 3500000000.000000, offset 44.000000, diff 119200000.000000
[HW] cal 1: freq 2660000000.000000, offset 49.800000, diff 959200000.000000
[HW] cal 2: freq 2300000000.000000, offset 51.000000, diff 1319200000.000000
[HW] cal 3: freq 1880000000.000000, offset 53.000000, diff 1739200000.000000
[HW] cal 4: freq 816000000.000000, offset 57.000000, diff 2803200000.000000
[HW] RX Gain too high, lower by 5.000000 dB
[HW] RX Gain 0 125.000000 (44.000000) => 81.000000 (max 76.000000)
[HW] USRP TX_GAIN:-0.25 gain_range:89.75 tx_gain:90.00
[HW] Actual master clock: 46.080000MHz...
[HW] Actual clock source internal...
[HW] Actual time source internal...
[HW] RF board max packet size 1916, size for 100µs jitter 4608
[HW] rx_max_num_samps 1916
[HW] setting rx channel 0
[HW] RX Channel 0
[HW] Actual RX sample rate: 46.080000MSps...
[HW] Actual RX frequency: 3.619200GHz...
[HW] Actual RX gain: 76.000000...
[HW] Actual RX bandwidth: 40.000000M...
[HW] Actual RX antenna: RX2...
[HW] TX Channel 0
[HW] Actual TX sample rate: 46.080000MSps...
[HW] Actual TX frequency: 3.619200GHz...
[HW] Actual TX gain: 0.000000...
[HW] Actual TX bandwidth: 40.000000M...
[HW] Actual TX antenna: TX/RX...
[HW] Actual TX packet size: 1916
[HW] Device timestamp: 2.167737...
[HW] [RAU] has loaded USRP B200 device.
setup_RU_buffers: frame_parms = 0x55a7b3cc19c0
[PHY] RU 0 Setting N_TA_offset to 600 samples (factor 1.500000, UL Freq 3600120, N_RB 106, mu 1)
[PHY] Signaling main thread that RU 0 is ready, sl_ahead 6
waiting for sync (ru_thread,-1/0x55a7b1fbb2b4,0x55a7b2d6c700,0x55a7b2bc17e0)
[PNF] waiting for OAI to be configured (eNB/RU)
[PNF] OAI eNB/RU configured
[PNF] About to call init_eNB_afterRU()
[PHY] init_eNB_afterRU() RC.nb_nr_inst:1
[PHY] RC.nb_nr_CC[inst:0]:0x7efc849e4010
[PHY] [gNB 0] phy_init_nr_gNB() About to wait for gNB to be configured
[LIBCONFIG] loader.dfts: 2/2 parameters successfully set, (1 to default value)
shlib_path libdfts.so
[LOADER] library libdfts.so successfully loaded
[LIBCONFIG] loader.ldpc: 2/2 parameters successfully set, (1 to default value)
shlib_path libldpc.so
[LOADER] library libldpc.so successfully loaded
[PHY] Initialise nr transport
[PHY] Allocating Transport Channel Buffers for PUCCH 0/16
[PHY] Allocating Transport Channel Buffers for PUCCH 1/16
[PHY] Allocating Transport Channel Buffers for PUCCH 2/16
[PHY] Allocating Transport Channel Buffers for PUCCH 3/16
[PHY] Allocating Transport Channel Buffers for PUCCH 4/16
[PHY] Allocating Transport Channel Buffers for PUCCH 5/16
[PHY] Allocating Transport Channel Buffers for PUCCH 6/16
[PHY] Allocating Transport Channel Buffers for PUCCH 7/16
[PHY] Allocating Transport Channel Buffers for PUCCH 8/16
[PHY] Allocating Transport Channel Buffers for PUCCH 9/16
[PHY] Allocating Transport Channel Buffers for PUCCH 10/16
[PHY] Allocating Transport Channel Buffers for PUCCH 11/16
[PHY] Allocating Transport Channel Buffers for PUCCH 12/16
[PHY] Allocating Transport Channel Buffers for PUCCH 13/16
[PHY] Allocating Transport Channel Buffers for PUCCH 14/16
[PHY] Allocating Transport Channel Buffers for PUCCH 15/16
[PHY] Allocating Transport Channel Buffers for SRS 0/16
[PHY] Allocating Transport Channel Buffers for SRS 1/16
[PHY] Allocating Transport Channel Buffers for SRS 2/16
[PHY] Allocating Transport Channel Buffers for SRS 3/16
[PHY] Allocating Transport Channel Buffers for SRS 4/16
[PHY] Allocating Transport Channel Buffers for SRS 5/16
[PHY] Allocating Transport Channel Buffers for SRS 6/16
[PHY] Allocating Transport Channel Buffers for SRS 7/16
[PHY] Allocating Transport Channel Buffers for SRS 8/16
[PHY] Allocating Transport Channel Buffers for SRS 9/16
[PHY] Allocating Transport Channel Buffers for SRS 10/16
[PHY] Allocating Transport Channel Buffers for SRS 11/16
[PHY] Allocating Transport Channel Buffers for SRS 12/16
[PHY] Allocating Transport Channel Buffers for SRS 13/16
[PHY] Allocating Transport Channel Buffers for SRS 14/16
[PHY] Allocating Transport Channel Buffers for SRS 15/16
[PHY] Allocating Transport Channel Buffers for ULSCH 0/8
[PHY] Allocating Transport Channel Buffers for ULSCH 1/8
[PHY] Allocating Transport Channel Buffers for ULSCH 2/8
[PHY] Allocating Transport Channel Buffers for ULSCH 3/8
[PHY] Allocating Transport Channel Buffers for ULSCH 4/8
[PHY] Allocating Transport Channel Buffers for ULSCH 5/8
[PHY] Allocating Transport Channel Buffers for ULSCH 6/8
[PHY] Allocating Transport Channel Buffers for ULSCH 7/8
[PHY] Mapping RX ports from 1 RUs to gNB 0
[PHY] gNB->num_RU:1
[PHY] Attaching RU 0 antenna 0 to gNB antenna 0
[PHY] Number of threads requested in config file: 4, Number of threads available on this machine: 24
create a thread for core -1
create a thread for core -1
create a thread for core -1
create a thread for core -1
[PHY] Allocating Transport Channel Buffers for DLSCH 0/8
[PHY] Allocating Transport Channel Buffers for DLSCH 1/8
[PHY] Allocating Transport Channel Buffers for DLSCH 2/8
[PHY] Allocating Transport Channel Buffers for DLSCH 3/8
[PHY] Allocating Transport Channel Buffers for DLSCH 4/8
[PHY] Allocating Transport Channel Buffers for DLSCH 5/8
[PHY] Allocating Transport Channel Buffers for DLSCH 6/8
[PHY] Allocating Transport Channel Buffers for DLSCH 7/8
[PHY] Allocating Transport Channel Buffers for DLSCH 0/8
[PHY] Allocating Transport Channel Buffers for DLSCH 1/8
[PHY] Allocating Transport Channel Buffers for DLSCH 2/8
[PHY] Allocating Transport Channel Buffers for DLSCH 3/8
[PHY] Allocating Transport Channel Buffers for DLSCH 4/8
[PHY] Allocating Transport Channel Buffers for DLSCH 5/8
[PHY] Allocating Transport Channel Buffers for DLSCH 6/8
[PHY] Allocating Transport Channel Buffers for DLSCH 7/8
waiting for sync (L1_stats_thread,-1/0x55a7b1fbb2b4,0x55a7b2d6c700,0x55a7b2bc17e0)
NFAPI: got sync (main?)
wait RUs
[PHY] Waiting for RUs to be configured ... RC.ru_mask:00
[PHY] RUs configured
ALL RUs READY!
RC.nb_RU:1
ALL RUs ready - init gNBs
NFAPI mode - DO NOT call init_gNB_afterRU()
ALL RUs ready - ALL gNBs ready
Sending sync to all threads
About to call end_configmodule() from main() /home/eric/project/openairinterface5g/executables/nr-softmodem.c:790
Called end_configmodule() from main() /home/eric/project/openairinterface5g/executables/nr-softmodem.c:795
TYPE <CTRL-C> TO TERMINATE
Entering ITTI signals handler
got sync (ru_thread)
got sync (L1_stats_thread)
[PHY] RU 0 rf device ready
[PHY] RU 0 RF started
sleep...
sleep...
sleep...
sleep...
sleep...
sleep...
sleep...
sleep...
sleep...
[MAC] [GNB] the NFAPI_MODE_PNF in rx_func is about to send slot_ind sfn : 0, slot : 0
[MWNL] pnf_p7_slot_ind
[MWNL] NR_UL_indication
[NFAPI PNF P7] p7_msg_sfn : 0, p7_msg_slot: 3
[NFAPI PNF P7] phy_sfn : 0, phy_slot : 7
[NFAPI PNF P7] The current_sfn_slot_dec : 7 <= recv_sfn_slot_dec + timing_window: 33
[NFAPI PNF] number of pdu is 0
[MAC] [GNB] the NFAPI_MODE_PNF in rx_func is about to send slot_ind sfn : 0, slot : 1
[MWNL] pnf_p7_slot_ind
[MWNL] NR_UL_indication
[NFAPI PNF P7] p7_msg_sfn : 0, p7_msg_slot: 3
[NFAPI PNF P7] phy_sfn : 0, phy_slot : 7
[NFAPI PNF P7] The current_sfn_slot_dec : 7 <= recv_sfn_slot_dec + timing_window: 33
[NFAPI PNF] number of pdu is 0
slot: 0, expected slot: 1
[MAC] [GNB] the NFAPI_MODE_PNF in rx_func is about to send slot_ind sfn : 0, slot : 2
[MWNL] pnf_p7_slot_ind
[MWNL] NR_UL_indication
[PHY] error, pull two msg, none is good
[PHY] order mistake
[NFAPI PNF P7] p7_msg_sfn : 0, p7_msg_slot: 3
[NFAPI PNF P7] phy_sfn : 0, phy_slot : 8
[NFAPI PNF P7] The current_sfn_slot_dec : 8 <= recv_sfn_slot_dec + timing_window: 33
[NFAPI PNF] number of pdu is 0
[MAC] [GNB] the NFAPI_MODE_PNF in rx_func is about to send slot_ind sfn : 0, slot : 3
[MWNL] pnf_p7_slot_ind
[MWNL] NR_UL_indication
[NFAPI PNF P7] p7_msg_sfn : 0, p7_msg_slot: 3
[NFAPI PNF P7] phy_sfn : 0, phy_slot : 9
[NFAPI PNF P7] The current_sfn_slot_dec : 9 <= recv_sfn_slot_dec + timing_window: 33
[NFAPI PNF] number of pdu is 0
U[PNF] waiting for OAI to be started
```