shynuu / free5gc-cli

An interactive CLI for free5gc
Apache License 2.0
20 stars 14 forks source link

Sync up between subscriber module and gnb module #4

Open pragnyakiri opened 3 years ago

pragnyakiri commented 3 years ago

Hi,

I am loading the subscriber module and adding 3 users. When I type "user list", I get a list of 3 users that I added. I exit the module. Then I load gnb module, When I type "user list" here, it doesn't return anything. It is not showing any users in gnb module.

Am I missing something here ? Aren't subscriber and gnb modules synced up with each other ?

Thank you.

pragnyakiri commented 3 years ago

In fact, gNB module is not returning any list. (Attached screenshot) Screenshot 2020-12-16 at 3 14 40 PM What am I doing wrong ?

shynuu commented 3 years ago

Hi @pragnyakiri,

The user equipment is registering on the network but no PDU session seems to je established.

Can you please indicate me the following informations:

Also, can you paste CN AMF, SMF, UPF, NRF, AUSF log files please to check wether the procedures were triggered on the CN.

The modules are not sync, usually I launch 2 different instances of free5gc-cli, one to manage the subscriber on the same host than the CN and another in the gNB VM with UE as docker host. This however could be a feature to add in the future.

Thanks

pragnyakiri commented 3 years ago

Hi @Srajdax,

OS version : Ubuntu 20.04.1 LTS Golang version: go version go1.14.4 linux/amd64

Below is the log I get on the console, when I try to register a new user from gnb module. 2020-12-18T14:00:24+05:30 [INFO][NAS][Message] set log level : info 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Handle NFRegisterRequest 2020-12-18T14:00:24+05:30 [INFO][NAS][Message] set report call : false 2020-12-18T14:00:24+05:30 [INFO][LIB][FSM] set log level : info 2020-12-18T14:00:24+05:30 [INFO][LIB][FSM] set report call : false 2020-12-18T14:00:24+05:30 [INFO][LIB][NGAP] set log level : info 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Handle NFRegisterRequest 2020-12-18T14:00:24+05:30 [INFO][LIB][NGAP] set report call : false 2020-12-18T14:00:24+05:30 [INFO][OAPI][NamfComm] set log level : info 2020-12-18T14:00:24+05:30 [INFO][OAPI][NamfComm] set report call : false 2020-12-18T14:00:24+05:30 [INFO][OAPI][NamfEvent] set log level : info 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] urilist update 2020-12-18T14:00:24+05:30 [INFO][OAPI][NamfEvent] set report call : false 2020-12-18T14:00:24+05:30 [INFO][OAPI][NsmfPDUSess] set log level : info 2020-12-18T14:00:24+05:30 [INFO][OAPI][NsmfPDUSess] set report call : false 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][OAPI][NudrDataRepo] set log level : info 2020-12-18T14:00:24+05:30 [INFO][OAPI][NudrDataRepo] set report call : false 2020-12-18T14:00:24+05:30 [INFO][LIB][OAPI] set log level : info 2020-12-18T14:00:24+05:30 [INFO][LIB][OAPI] set report call : false 2020-12-18T14:00:24+05:30 [INFO][LIB][Aper] set log level : info 2020-12-18T14:00:24+05:30 [INFO][LIB][Aper] set report call : false 2020-12-18T14:00:24+05:30 [INFO][CommonTest][Comm] set log level : info 2020-12-18T14:00:24+05:30 [INFO][CommonTest][Comm] set report call : false 2020-12-18T14:00:24+05:30 [INFO][N3IWF][Init] Successfully initialize configuration config/n3iwfcfg.conf 2020-12-18T14:00:24+05:30 [INFO][N3IWF][Init] Log level is set to [info] level 2020-12-18T14:00:24+05:30 [INFO][N3IWF][Init] Server started 2020-12-18T14:00:24+05:30 [WARN][N3IWF][Context] No private key file path specified, load default key file... 2020-12-18T14:00:24+05:30 [WARN][N3IWF][Context] Parse PKCS8 private key failed: x509: failed to parse private key (use ParsePKCS1PrivateKey instead for this key format) 2020-12-18T14:00:24+05:30 [INFO][N3IWF][Context] Parse using PKCS1... 2020-12-18T14:00:24+05:30 [WARN][N3IWF][Context] No certificate authority file path specified, load default CA certificate... 2020-12-18T14:00:24+05:30 [WARN][N3IWF][Context] No certificate file path specified, load default certificate... 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] urilist update 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/6e425f67-b0a3-4a14-9a4b-710d872902fe 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/6e425f67-b0a3-4a14-9a4b-710d872902fe | 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/c09f76f5-60d4-4487-ab1a-165d11f270ea 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/c09f76f5-60d4-4487-ab1a-165d11f270ea | 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/c34a6282-df6d-47e2-ae25-11cabe7ab430 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/c34a6282-df6d-47e2-ae25-11cabe7ab430 | 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] urilist update 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] urilist update 2020-12-18T14:00:24+05:30 [INFO][NRF][Discovery] Handle NFDiscoveryRequest 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Create NF Profile 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/486f9632-758f-4378-bae3-e16d0bca6024 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/49aaf306-2cac-4a6a-b8ce-d50801ee108a 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/15ba2af0-4d96-43b9-8573-75a2d9cbfd05 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/486f9632-758f-4378-bae3-e16d0bca6024 | 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/15ba2af0-4d96-43b9-8573-75a2d9cbfd05 | 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/49aaf306-2cac-4a6a-b8ce-d50801ee108a | 2020-12-18T14:00:24+05:30 [INFO][NRF][Management] Location header: http://127.0.0.1:29510/nnrf-nfm/v1/nf-instances/b06441fe-a0fb-4db6-8a6a-30d3b6ee0fcb 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/b06441fe-a0fb-4db6-8a6a-30d3b6ee0fcb | 2020-12-18T14:00:24+05:30 [INFO][SMF][Init] SMF Registration to NRF {b06441fe-a0fb-4db6-8a6a-30d3b6ee0fcb SMF REGISTERED 0 0xc0003c61e0 [] [] [127.0.0.1] [] [] [] 0 0 0 0xc00038a140 map[] false 0xc0003c6060 false false []} 2020-12-18T14:00:24+05:30 [INFO][SMF][Pfcp] Listen on 127.0.0.1:8805 2020-12-18T14:00:24+05:30 [INFO][SMF][App] Send PFCP Association Request to UPF[127.0.0.8] 2020-12-18T14:00:24+05:30 [INFO][UPF][Util] [PFCP] Handle PFCP association setup request 2020-12-18T14:00:24+05:30 [INFO][UPF][Util] [PFCP] Association Setup Response 2020-12-18T14:00:24+05:30 [INFO][SMF][Pfcp] In HandlePfcpAssociationSetupResponse 2020-12-18T14:00:24+05:30 [INFO][SMF][Pfcp] UPF(127.0.0.8)[internet] setup association 2020-12-18T14:00:24+05:30 [INFO][LIB][PFCP] Remove Request Transaction [1] 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=PCF&target-nf-type=AMF | 2020-12-18T14:00:24+05:30 [INFO][AMF][Comm] Handle AMF Status Change Subscribe Request 2020-12-18T14:00:24+05:30 [INFO][AMF][Comm] new AMF Status Subscription[1] 2020-12-18T14:00:24+05:30 [INFO][AMF][GIN] | 201 | 127.0.0.1 | POST | /namf-comm/v1/subscriptions | 2020-12-18T14:00:24+05:30 [INFO][NRF][Discovery] Handle NFDiscoveryRequest 2020-12-18T14:00:24+05:30 [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=PCF&service-names=nudr-dr&target-nf-type=UDR | 2020-12-18T14:01:58+05:30 [INFO][AMF][NGAP] [AMF] SCTP Accept from: 127.0.0.1:9487 2020-12-18T14:01:58+05:30 [INFO][AMF][NGAP] Create a new NG connection for: 127.0.0.1:9487 2020-12-18T14:01:58+05:30 [INFO][AMF][NGAP] [AMF] NG Setup request 2020-12-18T14:01:58+05:30 [INFO][AMF][NGAP] [AMF] Send NG-Setup response 2020-12-18T14:04:01+05:30 [INFO][AMF][NGAP] [AMF] NG Setup request 2020-12-18T14:04:01+05:30 [INFO][AMF][NGAP] [AMF] Send NG-Setup response


So the request of registering a new user is reaching the core network, isn't it ?

Thanks, Pradnya

shynuu commented 3 years ago

The output does not show that the user is registered on the network,

Maybe check that you are reaching the correct CN and try the following fix:

Flush the free5gc mongo database using the database module. After that restart your 5G CN, load the user into the DB and start the gNB module.