[ERRO][UDR][DRepo] QueryAuthSubsDataProcedure err:
[ERRO][UDM][UEAU] Return from UDR QueryAuthSubsData error
[ERRO][AMF][GMM][AMF_UE_NGAP_ID:1] Nausf_UEAU Authenticate Request Failed: &{Type: Title: Status:500 Detail: Instance: Cause:AV_GENERATION_PROBLEM InvalidParams: }
I cloned the free5gc docker compose project and ran it, so core network is running fine
But when I run UE then I am getting following errors:
udr | 2023-06-07T04:56:03Z [ERRO][UDR][DRepo] QueryAuthSubsDataProcedure err:
udr | 2023-06-07T04:56:03Z [INFO][UDR][GIN] | 404 | 10.100.200.6 | GET | /nudr-dr/v1/subscription-data/imsi-208930000000001/authentication-data/authentication-subscription |
udm | 2023-06-07T04:56:03Z [ERRO][UDM][UEAU] Return from UDR QueryAuthSubsData error
udm | 2023-06-07T04:56:03Z [INFO][UDM][GIN] | 403 | 10.100.200.10 | POST | /nudm-ueau/v1/suci-0-208-93-0000-0-0-0000000001/security-information/generate-auth-data |
ausf | 2023-06-07T04:56:03Z [INFO][AUSF][UeAuthPost] 403 Forbidden
ausf | 2023-06-07T04:56:03Z [INFO][AUSF][GIN] | 500 | 10.100.200.7 | POST | /nausf-auth/v1/ue-authentications |
amf | 2023-06-07T04:56:03Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:1] Nausf_UEAU Authenticate Request Failed: &{Type: Title: Status:500 Detail: Instance: Cause:AV_GENERATION_PROBLEM InvalidParams:[]}
I have two docker compose files. In one docker compose file, there are all the network functions, and another docker file is for UE, I am running the UE using that docker compose file
I have attached all the configs and docker compose files.config_and_docker_compose_files.zip (16.9 KB)
Hello:
In fact, we have encountered similar problems before, please refer to the following website
opened 08:17AM - 09 Mar 22 UTC
closed 10:50PM - 28 Nov 22 UTC
Hi @abousselmi and @aligungr,
I have created 2 UPFs, one is connected to the DN… N1(60.60.0.0/16) the other is connected to the DNN2(10.10.0.0/16)
I did 2 experiments.
In the first one, I created 2 UEs(using UERANSIM), which are assigned to different UPFs. Both uesimtun0 interfaces are up. Their ips are 60.60.0.1 and 10.10.0.1. I can use both interfaces to ping 8.8.8.8. However the two interfaces cannot ping each other.
Then, I did the second one. In the second one, I created 3 UEs. Two of them are assigned to UPF1(DNN1: 60.60.0.1) and the last one is assigned to UPF2(DNN2: 10.10.0.1).
I received the following errors;
From SMF, everything looks good except the highlight errors. Does this error mean the problem is from configuration file?
**[signal SIGSEGV: segmentation violation code=0x1 addr=0x40 pc=0xb3433b]
goroutine 214 [running]:
github.com/free5gc/smf/context.(*SMContext).AllocateLocalSEIDForDataPath(0xc0000ee000, 0x0)
/go/src/free5gc/NFs/smf/context/sm_context.go:309 +0x8b
github.com/free5gc/smf/producer.AddPDUSessionAnchorAndULCL(0xc0000ee000, 0x2, 0xc00038dd20, 0x10, 0x10)
/go/src/free5gc/NFs/smf/producer/ulcl_procedure.go:23 +0x2c5
github.com/free5gc/smf/pfcp/handler.HandlePfcpSessionModificationResponse(0xc0004ecc70)
/go/src/free5gc/NFs/smf/pfcp/handler/handler.go:248 +0x6c4
github.com/free5gc/smf/pfcp.Dispatch(0xc0004ecc70)
/go/src/free5gc/NFs/smf/pfcp/dispatcher.go:45 +0x48a
created by github.com/free5gc/smf/pfcp/udp.Run.func1
/go/src/free5gc/NFs/smf/pfcp/udp/udp.go:44 +0x1d1**
2022-03-09T06:46:16Z [INFO][SMF][App] SMF version:
free5GC version: v3.0.6
build time: 2022-03-08T19:56:36Z
commit hash: 46644f0a
commit time: 2021-09-13T13:23:12Z
go version: go1.14.4 linux/amd64
2022-03-09T06:46:16Z [INFO][SMF][Init] SMF Log level is set to [info] level
2022-03-09T06:46:16Z [INFO][LIB][NAS] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][NAS] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][NGAP] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][NGAP] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][Aper] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][Aper] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][Path] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][Path] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][OAPI] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][OAPI] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][PFCP] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][PFCP] set report call : false
2022-03-09T06:46:16Z [INFO][SMF][CFG] SMF config version [1.0.2]
2022-03-09T06:46:16Z [INFO][SMF][CFG] UE-Routing config version [1.0.1]
2022-03-09T06:46:16Z [INFO][SMF][CTX] smfconfig Info: Version[1.0.2] Description[SMF initial local configuration]
2022-03-09T06:46:16Z [INFO][SMF][CTX] Endpoints: [upfb.free5gc.org]
2022-03-09T06:46:16Z [INFO][SMF][CTX] Endpoints: [upf2.free5gc.org]
2022-03-09T06:46:16Z [INFO][SMF][CTX] ue routing config Info: Version[1.0.1] Description[Routing information for UE]
2022-03-09T06:46:16Z [INFO][SMF][PduSess] In NewUEPreConfigPaths
2022-03-09T06:46:16Z [INFO][SMF][PduSess] In NewUEPreConfigPaths
2022-03-09T06:46:16Z [INFO][SMF][Init] Server started
2022-03-09T06:47:16Z [INFO][SMF][Init] SMF Registration to NRF {9dce9f09-8d85-4e59-988e-a2883ff8e784 SMF REGISTERED 0 0xc000388d00 0xc000388d40 [] [] [smf.free5gc.org] [] <nil> [] [] <nil> 0 0 0 area1 <nil> <nil> <nil> <nil> 0xc0003906c0 <nil> <nil> <nil> <nil> <nil> map[] <nil> false 0xc0003882c0 false false []}
2022-03-09T06:47:16Z [INFO][SMF][PFCP] Listen on 10.100.200.10:8805
2022-03-09T06:47:16Z [INFO][SMF][App] Send PFCP Association Request to UPF[upfb.free5gc.org](10.100.200.200)
2022-03-09T06:47:16Z [INFO][SMF][App] Send PFCP Association Request to UPF[upf2.free5gc.org](10.100.200.202)
2022-03-09T06:47:16Z [INFO][LIB][PFCP] Remove Request Transaction [1]
2022-03-09T06:47:16Z [INFO][SMF][PFCP] In HandlePfcpAssociationSetupResponse
2022-03-09T06:47:16Z [INFO][SMF][PFCP] Handle PFCP Association Setup Response with NodeID[10.100.200.200]
2022-03-09T06:47:16Z [INFO][SMF][PFCP] In HandlePfcpAssociationSetupResponse
2022-03-09T06:47:16Z [INFO][SMF][PFCP] Handle PFCP Association Setup Response with NodeID[10.100.200.202]
2022-03-09T06:47:16Z [INFO][LIB][PFCP] Remove Request Transaction [2]
2022-03-09T06:47:16Z [INFO][SMF][PFCP] UPF(10.100.200.200)[internet] setup association
2022-03-09T06:47:16Z [INFO][SMF][PFCP] UPF(10.100.200.202)[internet2] setup association
2022-03-09T06:51:10Z [INFO][SMF][PduSess] Recieve Create SM Context Request
2022-03-09T06:51:10Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextCreate
2022-03-09T06:51:10Z [INFO][SMF][PduSess] Send NF Discovery Serving UDM Successfully
2022-03-09T06:51:10Z [INFO][SMF][CTX] Allocated UE IP address: 60.60.0.1
2022-03-09T06:51:10Z [INFO][SMF][CTX] Selected UPF: BranchingUPF
2022-03-09T06:51:10Z [INFO][SMF][GSM] In HandlePDUSessionEstablishmentRequest
2022-03-09T06:51:10Z [INFO][NAS][Convert] ProtocolOrContainerList: [0xc00025d140 0xc00025d180]
2022-03-09T06:51:10Z [INFO][SMF][GSM] Protocol Configuration Options
2022-03-09T06:51:10Z [INFO][SMF][GSM] &{[0xc00025d140 0xc00025d180]}
2022-03-09T06:51:10Z [INFO][SMF][GSM] Didn't Implement container type IPAddressAllocationViaNASSignallingUL
2022-03-09T06:51:10Z [INFO][SMF][PduSess] PCF Selection for SMContext SUPI[imsi-208930000000003] PDUSessionID[1]
2022-03-09T06:51:10Z [INFO][SMF][PduSess] SUPI[imsi-208930000000003] has pre-config route
2022-03-09T06:51:10Z [INFO][SMF][Consumer] SendNFDiscoveryServingAMF ok
2022-03-09T06:51:10Z [INFO][SMF][GIN] | 201 | 10.100.200.102 | POST | /nsmf-pdusession/v1/sm-contexts |
2022-03-09T06:51:10Z [INFO][SMF][PFCP] In HandlePfcpSessionEstablishmentResponse
2022-03-09T06:51:10Z [INFO][LIB][PFCP] Remove Request Transaction [3]
&{200 Mbps 100 Mbps}
2022-03-09T06:51:10Z [INFO][SMF][PduSess] Recieve Update SM Context Request
2022-03-09T06:51:10Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextUpdate
2022-03-09T06:51:10Z [INFO][SMF][PFCP] In HandlePfcpSessionModificationResponse
2022-03-09T06:51:10Z [INFO][SMF][PduSess] [SMF] PFCP Modification Resonse Accept
2022-03-09T06:51:10Z [INFO][LIB][PFCP] Remove Request Transaction [4]
2022-03-09T06:51:10Z [INFO][SMF][PFCP] Add PSAAndULCL
panic: runtime error: invalid memory address or nil pointer dereference
**[signal SIGSEGV: segmentation violation code=0x1 addr=0x40 pc=0xb3433b]
goroutine 214 [running]:
github.com/free5gc/smf/context.(*SMContext).AllocateLocalSEIDForDataPath(0xc0000ee000, 0x0)
/go/src/free5gc/NFs/smf/context/sm_context.go:309 +0x8b
github.com/free5gc/smf/producer.AddPDUSessionAnchorAndULCL(0xc0000ee000, 0x2, 0xc00038dd20, 0x10, 0x10)
/go/src/free5gc/NFs/smf/producer/ulcl_procedure.go:23 +0x2c5
github.com/free5gc/smf/pfcp/handler.HandlePfcpSessionModificationResponse(0xc0004ecc70)
/go/src/free5gc/NFs/smf/pfcp/handler/handler.go:248 +0x6c4
github.com/free5gc/smf/pfcp.Dispatch(0xc0004ecc70)
/go/src/free5gc/NFs/smf/pfcp/dispatcher.go:45 +0x48a
created by github.com/free5gc/smf/pfcp/udp.Run.func1
/go/src/free5gc/NFs/smf/pfcp/udp/udp.go:44 +0x1d1**
From the AMF, the imsi-208930000000003(assigned to UPF1(DNN1:60.60.0.0)) seems good. I can use the uesimtun0 infeterface. However, it still shows the highlight error. The imsi-208930000000003 failed. I have no clue where the problem is.
**2022-03-09T06:51:10Z [ERRO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] SendUpdateSmContextN2Info[PDUSessionResourceSetupResponseTransfer] Error: server no response**
2022-03-09T06:46:16Z [INFO][AMF][App] amf
2022-03-09T06:46:16Z [INFO][AMF][App] AMF version:
free5GC version: v3.0.6
build time: 2022-03-08T19:56:06Z
commit hash: b3e99f97
commit time: 2021-09-24T09:44:32Z
go version: go1.14.4 linux/amd64
2022-03-09T06:46:16Z [INFO][AMF][Init] AMF Log level is set to [info] level
2022-03-09T06:46:16Z [INFO][LIB][NAS] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][NAS] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][NGAP] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][NGAP] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][FSM] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][FSM] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][Aper] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][Aper] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][Path] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][Path] set report call : false
2022-03-09T06:46:16Z [INFO][LIB][OAPI] set log level : info
2022-03-09T06:46:16Z [INFO][LIB][OAPI] set report call : false
2022-03-09T06:46:16Z [INFO][AMF][CFG] config version [1.0.2]
2022-03-09T06:46:16Z [INFO][AMF][Init] Server started
2022-03-09T06:46:16Z [INFO][AMF][Util] amfconfig Info: Version[1.0.2] Description[AMF initial local configuration]
2022-03-09T06:46:16Z [INFO][AMF][NGAP] Listen on 10.100.200.102:38412
2022-03-09T06:46:47Z [INFO][AMF][NGAP] [AMF] SCTP Accept from: 10.100.200.1:53492
2022-03-09T06:46:47Z [INFO][AMF][NGAP] Create a new NG connection for: 10.100.200.1:53492
2022-03-09T06:46:47Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle NG Setup request
2022-03-09T06:46:47Z [INFO][AMF][NGAP][10.100.200.1:53492] Send NG-Setup response
2022-03-09T06:47:03Z [INFO][AMF][NGAP] [AMF] SCTP Accept from: 10.100.200.11/10.0.0.1:54371
2022-03-09T06:47:03Z [INFO][AMF][NGAP] Create a new NG connection for: 10.100.200.11/10.0.0.1:54371
2022-03-09T06:47:03Z [INFO][AMF][NGAP][10.100.200.11/10.0.0.1:54371] Handle NG Setup request
2022-03-09T06:47:03Z [INFO][AMF][NGAP][10.100.200.11/10.0.0.1:54371] Send NG-Setup response
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Registration Request
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Authentication procedure
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Send Authentication Request
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Authentication Response
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Send Security Mode Command
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Handle Security Mode Complete
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Handle InitialRegistration
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] RequestedNssai - ServingSnssai: &{Sst:1 Sd:010203}, HomeSnssai: <nil>
2022-03-09T06:51:10Z [INFO][AMF][Comm] Handle AMF Status Change Subscribe Request
2022-03-09T06:51:10Z [INFO][AMF][Comm] new AMF Status Subscription[1]
2022-03-09T06:51:10Z [INFO][AMF][GIN] | 201 | 10.100.200.7 | POST | /namf-comm/v1/subscriptions |
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Send Registration Accept
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Send Initial Context Setup Request
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial Context Setup Response
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Handle Registration Complete
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Handle UL NAS Transport
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Transport 5GSM Message to SMF
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] Select SMF [snssai: {Sst:1 Sd:010203}, dnn: internet]
2022-03-09T06:51:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-208930000000003] create smContext[pduSessionID: 1] Success
2022-03-09T06:51:10Z [INFO][AMF][Producer] Handle N1N2 Message Transfer Request
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] Send PDU Session Resource Setup Request
2022-03-09T06:51:10Z [INFO][AMF][GIN] | 200 | 10.100.200.10 | POST | /namf-comm/v1/ue-contexts/imsi-208930000000003/n1-n2-messages |
2022-03-09T06:51:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle PDU Session Resource Setup Response
**2022-03-09T06:51:10Z [ERRO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:1] SendUpdateSmContextN2Info[PDUSessionResourceSetupResponseTransfer] Error: server no response**
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2] Handle Registration Request
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2] Authentication procedure
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2] Send Authentication Request
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Send Downlink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2] Handle Authentication Response
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Send Security Mode Command
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Send Downlink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle Security Mode Complete
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle InitialRegistration
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] RequestedNssai - ServingSnssai: &{Sst:1 Sd:112233}, HomeSnssai: <nil>
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Send Registration Accept
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Send Initial Context Setup Request
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial Context Setup Response
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle Registration Complete
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle UL NAS Transport
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Transport 5GSM Message to SMF
2022-03-09T06:51:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Select SMF [snssai: {Sst:1 Sd:112233}, dnn: internet2]
2022-03-09T06:51:20Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] CreateSmContextRequest Error: server no response
2022-03-09T06:51:30Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:51:30Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:3] Handle Registration Request
2022-03-09T06:51:30Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:3] Authentication procedure
2022-03-09T06:51:30Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:3] Send Authentication Request
2022-03-09T06:51:30Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:3] Send Downlink Nas Transport
2022-03-09T06:51:30Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:30Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:3] Uplink NAS Transport (RAN UE NGAP ID: 3)
2022-03-09T06:51:30Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:3] Handle Authentication Failure
2022-03-09T06:51:30Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:3] Authentication Failure 5GMM Cause: Synch Failure
2022-03-09T06:51:30Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:3] Nausf_UEAU Authenticate Request Error[Problem Detail: &{Type: Title: Status:500 Detail: Instance: Cause:AV_GENERATION_PROBLEM InvalidParams:[]}]
2022-03-09T06:51:37Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:37Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle UL NAS Transport
2022-03-09T06:51:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Transport 5GSM Message to SMF
2022-03-09T06:51:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Select SMF [snssai: {Sst:1 Sd:112233}, dnn: internet2]
2022-03-09T06:51:37Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] CreateSmContextRequest Error: server no response
2022-03-09T06:51:53Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:51:53Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:51:53Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle UL NAS Transport
2022-03-09T06:51:53Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Transport 5GSM Message to SMF
2022-03-09T06:51:53Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Select SMF [snssai: {Sst:1 Sd:112233}, dnn: internet2]
2022-03-09T06:52:20Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] CreateSmContextRequest Error: server no response
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:4] Handle Registration Request
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:4] Authentication procedure
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:4] Send Authentication Request
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:4] Send Downlink Nas Transport
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle UL NAS Transport
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Transport 5GSM Message to SMF
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Select SMF [snssai: {Sst:1 Sd:112233}, dnn: internet2]
2022-03-09T06:52:20Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] CreateSmContextRequest Error: server no response
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:5] Handle Registration Request
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:5] Authentication procedure
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:5] Send Authentication Request
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:5] Send Downlink Nas Transport
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:52:20Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:5] Uplink NAS Transport (RAN UE NGAP ID: 5)
2022-03-09T06:52:20Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:5] Handle Authentication Failure
2022-03-09T06:52:20Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:5] Authentication Failure 5GMM Cause: Synch Failure
2022-03-09T06:52:20Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:5] Nausf_UEAU Authenticate Request Error[Problem Detail: &{Type: Title: Status:500 Detail: Instance: Cause:AV_GENERATION_PROBLEM InvalidParams:[]}]
2022-03-09T06:52:25Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:52:25Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Uplink NAS Transport (RAN UE NGAP ID: 2)
2022-03-09T06:52:25Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Handle UL NAS Transport
2022-03-09T06:52:25Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Transport 5GSM Message to SMF
2022-03-09T06:52:25Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] Select SMF [snssai: {Sst:1 Sd:112233}, dnn: internet2]
2022-03-09T06:52:25Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:2][SUPI:imsi-208930000000004] create smContext[pduSessionID: 1] Success
2022-03-09T06:52:25Z [INFO][AMF][Producer] Handle N1N2 Message Transfer Request
2022-03-09T06:52:25Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] Send PDU Session Resource Setup Request
2022-03-09T06:52:25Z [INFO][AMF][GIN] | 200 | 10.100.200.10 | POST | /namf-comm/v1/ue-contexts/imsi-208930000000004/n1-n2-messages |
2022-03-09T06:52:25Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle PDU Session Resource Setup Response
2022-03-09T06:52:25Z [ERRO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:2] SendUpdateSmContextN2Info[PDUSessionResourceSetupResponseTransfer] Error: server no response
2022-03-09T06:52:26Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:4] T3560 expires, retransmit Authentication Request (retry: 1)
2022-03-09T06:52:26Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:4] Send Downlink Nas Transport
2022-03-09T06:52:32Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:4] T3560 expires, retransmit Authentication Request (retry: 2)
2022-03-09T06:52:32Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:4] Send Downlink Nas Transport
2022-03-09T06:52:38Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:4] T3560 expires, retransmit Authentication Request (retry: 3)
2022-03-09T06:52:38Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:4] Send Downlink Nas Transport
2022-03-09T06:52:44Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:4] T3560 expires, retransmit Authentication Request (retry: 4)
2022-03-09T06:52:44Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:4] Send Downlink Nas Transport
2022-03-09T06:52:45Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:52:45Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:6] Handle Registration Request
2022-03-09T06:52:45Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:6] Authentication procedure
2022-03-09T06:52:45Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:6] Send Authentication Request
2022-03-09T06:52:45Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:6] Send Downlink Nas Transport
2022-03-09T06:52:45Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Uplink Nas Transport
2022-03-09T06:52:45Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:6] Uplink NAS Transport (RAN UE NGAP ID: 6)
2022-03-09T06:52:45Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:6] Handle Authentication Failure
2022-03-09T06:52:45Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:6] Authentication Failure 5GMM Cause: Synch Failure
2022-03-09T06:52:45Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:6] Nausf_UEAU Authenticate Request Error[Problem Detail: &{Type: Title: Status:500 Detail: Instance: Cause:AV_GENERATION_PROBLEM InvalidParams:[]}]
2022-03-09T06:52:50Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:4] T3560 Expires 4 times, abort authentication procedure & ongoing 5GMM procedure
2022-03-09T06:53:10Z [INFO][AMF][NGAP][10.100.200.1:53492] Handle Initial UE Message
2022-03-09T06:53:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:7] Handle Registration Request
2022-03-09T06:53:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:7] Authentication procedure
2022-03-09T06:53:10Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:7] Send Authentication Request
2022-03-09T06:53:10Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:7] Send Downlink Nas Transport
2022-03-09T06:53:16Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:7] T3560 expires, retransmit Authentication Request (retry: 1)
2022-03-09T06:53:16Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:7] Send Downlink Nas Transport
2022-03-09T06:53:22Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:7] T3560 expires, retransmit Authentication Request (retry: 2)
2022-03-09T06:53:22Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:7] Send Downlink Nas Transport
2022-03-09T06:53:28Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:7] T3560 expires, retransmit Authentication Request (retry: 3)
2022-03-09T06:53:28Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:7] Send Downlink Nas Transport
2022-03-09T06:53:34Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:7] T3560 expires, retransmit Authentication Request (retry: 4)
2022-03-09T06:53:34Z [INFO][AMF][NGAP][10.100.200.1:53492][AMF_UE_NGAP_ID:7] Send Downlink Nas Transport
2022-03-09T06:53:40Z [WARN][AMF][GMM][AMF_UE_NGAP_ID:7] T3560 Expires 4 times, abort authentication procedure & ongoing 5GMM procedure
Please let me know if I didn't explain myself well.
I would appreciate any comments and advice.
Thank you in advance!
Wish you good luck.