TestNon3GPP
cd ~/free5gc
./test.sh TestNon3GPP TestDuplicateRegistration |& tee TestNon3GPPTestDuplicateRegistration.log
Result Screen
2021-04-23T02:53:15Z [INFO][UPF][Util] Config: /home/free5gc/free5gc/NFs/upf/build/config/upfcfg.test.yaml
2021-04-23T02:53:15Z [INFO][UPF][Util] UPF config version [1.0.0]
2021-04-23T02:53:15Z [INFO][UPF][Util] Set log level: info
2021-04-23T02:53:15Z [INFO][UPF][Util] DNN routes added, main routing table:
2021-04-23T02:53:15Z [INFO][UPF][Util] DstIp Gateway Iface Priority RtProto Type
2021-04-23T02:53:15Z [INFO][UPF][Util] 60.60.0.0 /24 0.0.0.0 upfgtp 0 static unicast
2021-04-23T02:53:15Z [INFO][UPF][Util] 10.200.200.0 /24 0.0.0.0 veth1 0 kernel unicast
2021-04-23T02:53:32Z [INFO][NRF][Init] NRF Log level is set to [info] level
2021-04-23T02:53:32Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:32Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:32Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:32Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:32Z [INFO][LIB][MonDB] set log level : info
2021-04-23T02:53:32Z [INFO][LIB][MonDB] set report call : false
2021-04-23T02:53:32Z [INFO][NRF][CFG] config version [1.0.0]
2021-04-23T02:53:32Z [INFO][NRF][Init] Server started
2021-04-23T02:53:32Z [INFO][NRF][Init] nrfconfig Info: Version[1.0.0] Description[NRF initial local configuration]
2021-04-23T02:53:32Z [INFO][NRF][Init] Binding addr: [127.0.0.10:8000]
2021-04-23T02:53:33Z [INFO][AMF][Init] AMF Log level is set to [info] level
2021-04-23T02:53:33Z [INFO][LIB][NAS] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][NAS] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][NGAP] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][NGAP] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][FSM] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][FSM] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][Aper] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Aper] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:33Z [INFO][AMF][CFG] config version [1.0.1]
2021-04-23T02:53:33Z [INFO][AMF][Init] Server started
2021-04-23T02:53:33Z [INFO][AMF][Util] amfconfig Info: Version[1.0.1] Description[AMF initial local configuration]
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:33Z [INFO][AMF][NGAP] Listen on 127.0.0.1:38412
2021-04-23T02:53:33Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/2a72aa6a-d1e1-4578-ac98-63251ddf4431
2021-04-23T02:53:33Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/2a72aa6a-d1e1-4578-ac98-63251ddf4431 |
2021-04-23T02:53:33Z [INFO][SMF][Init] SMF Log level is set to [info] level
2021-04-23T02:53:33Z [INFO][LIB][NAS] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][NAS] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][NGAP] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][NGAP] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][Aper] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Aper] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][PFCP] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][PFCP] set report call : false
2021-04-23T02:53:33Z [INFO][SMF][CFG] SMF config version [1.0.1]
2021-04-23T02:53:33Z [INFO][SMF][CFG] UE-Routing config version [1.0.1]
2021-04-23T02:53:33Z [INFO][SMF][CTX] smfconfig Info: Version[1.0.1] Description[SMF initial local configuration]
2021-04-23T02:53:33Z [INFO][SMF][CTX] Endpoints: [10.200.200.102]
2021-04-23T02:53:33Z [INFO][SMF][Init] Server started
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:33Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/a42c5c0a-fbae-4816-9191-b6d11cffd422
2021-04-23T02:53:33Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/a42c5c0a-fbae-4816-9191-b6d11cffd422 |
2021-04-23T02:53:33Z [INFO][SMF][Init] SMF Registration to NRF {a42c5c0a-fbae-4816-9191-b6d11cffd422 SMF REGISTERED 0 0xc00030a700 0xc00030a7a0 [] [] [127.0.0.2] [] <nil> [] [] <nil> 0 0 0 <nil> <nil> <nil> <nil> 0xc0002876c0 <nil> <nil> <nil> <nil> <nil> map[] <nil> false 0xc00030a320 false false []}
2021-04-23T02:53:33Z [INFO][SMF][PFCP] Listen on 10.200.200.1:8805
2021-04-23T02:53:33Z [INFO][SMF][App] Send PFCP Association Request to UPF[10.200.200.101]
2021-04-23T02:53:33Z [INFO][UPF][Util] [PFCP] Handle PFCP association setup request
2021-04-23T02:53:33Z [INFO][UPF][Util] [PFCP] Association Setup Response
2021-04-23T02:53:33Z [INFO][SMF][PFCP] In HandlePfcpAssociationSetupResponse
2021-04-23T02:53:33Z [INFO][SMF][PFCP] Handle PFCP Association Setup Response with NodeID[10.200.200.101]
2021-04-23T02:53:33Z [INFO][SMF][PFCP] UPF(10.200.200.101)[internet] setup association
2021-04-23T02:53:33Z [INFO][LIB][PFCP] Remove Request Transaction [1]
2021-04-23T02:53:33Z [INFO][UDR][Init] UDR Log level is set to [info] level
2021-04-23T02:53:33Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][MonDB] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][MonDB] set report call : false
2021-04-23T02:53:33Z [INFO][UDR][CFG] config version [1.0.0]
2021-04-23T02:53:33Z [INFO][UDR][Init] UDR Config Info: Version[1.0.0] Description[UDR initial local configuration]
2021-04-23T02:53:33Z [INFO][UDR][Init] Server started
2021-04-23T02:53:33Z [INFO][UDR][Util] udrconfig Info: Version[1.0.0] Description[UDR initial local configuration]
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:33Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/dc0e382f-7dd0-4c7b-b340-fc8356b2353e
2021-04-23T02:53:33Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/dc0e382f-7dd0-4c7b-b340-fc8356b2353e |
2021-04-23T02:53:33Z [INFO][PCF][Init] PCF Log level is set to [info] level
2021-04-23T02:53:33Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:33Z [INFO][PCF][CFG] config version [1.0.0]
2021-04-23T02:53:33Z [INFO][PCF][Init] Server started
2021-04-23T02:53:33Z [INFO][PCF][Util] pcfconfig Info: Version[1.0.0] Description[PCF initial local configuration]
2021/04/23 02:53:33 http2: server connection error from 127.0.0.1:45696: connection error: PROTOCOL_ERROR
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:33Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/f69f0662-c66a-4c00-9079-fd9e5aa9f32f
2021-04-23T02:53:33Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/f69f0662-c66a-4c00-9079-fd9e5aa9f32f |
2021-04-23T02:53:33Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:33Z [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 |
2021-04-23T02:53:33Z [INFO][UDM][Init] UDM Log level is set to [info] level
2021-04-23T02:53:33Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:33Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:33Z [INFO][UDM][CFG] config version [1.0.0]
2021-04-23T02:53:33Z [INFO][UDM][Init] UDM Config Info: Version[1.0.0] Description[UDM initial local configuration]
2021-04-23T02:53:33Z [INFO][UDM][Init] Server started
2021-04-23T02:53:33Z [INFO][UDM][Util] udmconfig Info: Version[1.0.0] Description[UDM initial local configuration]
2021/04/23 02:53:33 http2: server connection error from 127.0.0.1:45700: connection error: PROTOCOL_ERROR
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:33Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:33Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/e23de71e-ee41-49de-aaa6-34c8ece49d5e
2021-04-23T02:53:33Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/e23de71e-ee41-49de-aaa6-34c8ece49d5e |
2021-04-23T02:53:34Z [INFO][NSSF][Init] NSSF Log level is set to [info] level
2021-04-23T02:53:34Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:34Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:34Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:34Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:34Z [INFO][NSSF][CFG] config version [1.0.0]
2021-04-23T02:53:34Z [INFO][NSSF][Init] Server started
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:34Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/55998b1c-c422-4d2d-848c-d9a13fc95cf3
2021-04-23T02:53:34Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/55998b1c-c422-4d2d-848c-d9a13fc95cf3 |
2021-04-23T02:53:34Z [INFO][AUSF][Init] AUSF Log level is set to [info] level
2021-04-23T02:53:34Z [INFO][LIB][Path] set log level : info
2021-04-23T02:53:34Z [INFO][LIB][Path] set report call : false
2021-04-23T02:53:34Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:53:34Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:53:34Z [INFO][AUSF][CFG] config version [1.0.0]
2021-04-23T02:53:34Z [INFO][AUSF][Init] Server started
2021-04-23T02:53:34Z [INFO][AUSF][Init] ausfconfig Info: Version[1.0.0] Description[AUSF initial local configuration]
ausf context = &{{{0 0} {<nil>} map[] 0} {{0 0} {<nil>} map[] 0} 3db5bb65-6377-4482-96ac-87bf4b8d3dcc ausfGroup001 8000 127.0.0.9 127.0.0.9 http://127.0.0.9:8000 http http://127.0.0.10:8000 map[nausf-auth:{3db5bb65-6377-4482-96ac-87bf4b8d3dcc nausf-auth 0xc00000ffa0 http REGISTERED 0xc00000ff80 [] <nil> [] [] <nil> 0 0 0 <nil> <nil> }] [{208 93} {123 45}] 0xc00031ed20}
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:53:34Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:53:34Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/3db5bb65-6377-4482-96ac-87bf4b8d3dcc
2021-04-23T02:53:34Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/3db5bb65-6377-4482-96ac-87bf4b8d3dcc |
=== RUN TestDuplicateRegistration
2021-04-23T02:53:34Z [INFO][AMF][NGAP] [AMF] SCTP Accept from: 127.0.0.1:9487
2021-04-23T02:53:34Z [INFO][AMF][NGAP] Create a new NG connection for: 127.0.0.1:9487
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle NG Setup request
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487] Send NG-Setup response
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Initial UE Message
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Registration Request
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Authentication procedure
2021-04-23T02:53:34Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:34Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AMF&target-nf-type=AUSF |
2021-04-23T02:53:34Z [INFO][AUSF][UeAuthPost] HandleUeAuthPostRequest
2021-04-23T02:53:34Z [INFO][AUSF][UeAuthPost] Serving network authorized
2021-04-23T02:53:34Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:34Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AUSF&service-names=nudm-ueau&target-nf-type=UDM |
2021-04-23T02:53:34Z [INFO][UDM][UEAU] Handle GenerateAuthDataRequest
2021-04-23T02:53:34Z [INFO][LIB][3GPP] suciPart [suci 0 208 93 0 0 0 00007487]
2021-04-23T02:53:34Z [INFO][LIB][3GPP] scheme 0
2021-04-23T02:53:34Z [INFO][LIB][3GPP] SUPI type is IMSI
http://127.0.0.10:8000
2021-04-23T02:53:34Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:34Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:34Z [INFO][UDR][DRepo] Handle QueryAuthSubsData
2021-04-23T02:53:34Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-subscription |
2021-04-23T02:53:34Z [INFO][UDR][DRepo] Handle ModifyAuthentication
2021-04-23T02:53:34Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PATCH | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-subscription |
AUTN = 6c174b10dab18000729b64ead19c91bc
2021-04-23T02:53:34Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | POST | /nudm-ueau/v1/suci-0-208-93-0-0-0-00007487/security-information/generate-auth-data |
2021-04-23T02:53:34Z [INFO][AUSF][UeAuthPost] Add SuciSupiPair (suci-0-208-93-0-0-0-00007487, imsi-2089300007487) to map.
2021-04-23T02:53:34Z [INFO][AUSF][UeAuthPost] Use 5G AKA auth method
2021-04-23T02:53:34Z [INFO][AUSF][5gAkaAuth] XresStar = 3134663633333562316631353531303662393961653865623637396337653764
2021-04-23T02:53:34Z [INFO][AUSF][GIN] | 201 | 127.0.0.1 | POST | /nausf-auth/v1/ue-authentications |
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Send Authentication Request
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Authentication Response
2021-04-23T02:53:34Z [INFO][AUSF][5gAkaAuth] Auth5gAkaComfirmRequest
2021-04-23T02:53:34Z [INFO][AUSF][5gAkaAuth] res*: 3134663633333562316631353531303662393961653865623637396337653764
Xres*: 3134663633333562316631353531303662393961653865623637396337653764
2021-04-23T02:53:34Z [INFO][AUSF][5gAkaAuth] 5G AKA confirmation succeeded
2021-04-23T02:53:34Z [INFO][UDM][UEAU] Handle ConfirmAuthDataRequest
2021-04-23T02:53:34Z [INFO][UDR][DRepo] Handle CreateAuthenticationStatus
2021-04-23T02:53:34Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PUT | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-status |
2021-04-23T02:53:34Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | POST | /nudm-ueau/v1/imsi-2089300007487/auth-events |
2021-04-23T02:53:34Z [INFO][AUSF][GIN] | 200 | 127.0.0.1 | PUT | /nausf-auth/v1/ue-authentications/suci-0-208-93-0-0-0-00007487/5g-aka-confirmation |
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Send Security Mode Command
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
Security Header Type Integrity Protected With New 5g Nas Security Context
cmac value: 0x32ba6ddc
err <nil>
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:53:34Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle Security Mode Complete
2021-04-23T02:53:34Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle InitialRegistration
2021-04-23T02:53:35Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:35Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AMF&supi=imsi-2089300007487&target-nf-type=UDM |
2021-04-23T02:53:35Z [INFO][UDM][SDM] Handle GetNssai
2021-04-23T02:53:35Z [INFO][UDR][DRepo] Handle QueryAmData
2021-04-23T02:53:35Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/20893/provisioned-data/am-data?supported-features= |
2021-04-23T02:53:35Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/nssai?plmn-id=20893 |
2021-04-23T02:53:35Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:35Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AMF&supi=imsi-2089300007487&target-nf-type=UDM |
2021-04-23T02:53:35Z [INFO][UDM][UECM] Handle RegistrationAmf3gppAccess
2021-04-23T02:53:35Z [INFO][UDM][UECM] UEID: imsi-2089300007487
http://127.0.0.10:8000
2021-04-23T02:53:35Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:35Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:35Z [INFO][UDR][DRepo] Handle CreateAmfContext3gpp
2021-04-23T02:53:35Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PUT | /nudr-dr/v1/subscription-data/imsi-2089300007487/context-data/amf-3gpp-access |
2021-04-23T02:53:35Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | PUT | /nudm-uecm/v1/imsi-2089300007487/registrations/amf-3gpp-access |
2021-04-23T02:53:35Z [INFO][UDM][SDM] Handle GetAmData
2021-04-23T02:53:35Z [INFO][UDR][DRepo] Handle QueryAmData
2021-04-23T02:53:35Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/20893/provisioned-data/am-data?supported-features=20893 |
2021-04-23T02:53:35Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/am-data?plmn-id=20893 |
2021-04-23T02:53:35Z [INFO][UDM][SDM] Handle GetSmfSelectData
http://127.0.0.10:8000
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:36Z [INFO][UDR][DRepo] Handle QuerySmfSelectData
2021-04-23T02:53:36Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/20893/provisioned-data/smf-selection-subscription-data?supported-features= |
2021-04-23T02:53:36Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/smf-select-data?plmn-id=20893 |
2021-04-23T02:53:36Z [INFO][UDM][SDM] Handle GetUeContextInSmfData
http://127.0.0.10:8000
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:36Z [INFO][UDR][DRepo] Handle QuerySmfRegList
2021-04-23T02:53:36Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/context-data/smf-registrations?supported-features= |
2021-04-23T02:53:36Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/ue-context-in-smf-data |
2021-04-23T02:53:36Z [INFO][UDM][SDM] Handle Subscribe
http://127.0.0.10:8000
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:36Z [INFO][UDR][DRepo] Handle CreateSdmSubscriptions
2021-04-23T02:53:36Z [INFO][UDR][GIN] | 201 | 127.0.0.1 | POST | /nudr-dr/v1/subscription-data/imsi-2089300007487/context-data/sdm-subscriptions |
2021-04-23T02:53:36Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | POST | /nudm-sdm/v1/imsi-2089300007487/sdm-subscriptions |
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AMF&supi=imsi-2089300007487&target-nf-type=PCF |
2021-04-23T02:53:36Z [INFO][PCF][Ampolicy] Handle AM Policy Create Request
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=PCF&target-nf-type=UDR |
2021-04-23T02:53:36Z [INFO][UDR][DRepo] Handle PolicyDataUesUeIdAmDataGet
2021-04-23T02:53:36Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/policy-data/ues/imsi-2089300007487/am-data |
2021-04-23T02:53:36Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:36Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?guami=%7B%22plmnId%22%3A%7B%22mcc%22%3A%22208%22%2C%22mnc%22%3A%2293%22%7D%2C%22amfId%22%3A%22cafe00%22%7D&requester-nf-type=PCF&target-nf-type=AMF |
2021-04-23T02:53:36Z [INFO][AMF][Comm] Handle AMF Status Change Subscribe Request
2021-04-23T02:53:36Z [INFO][AMF][Comm] new AMF Status Subscription[1]
2021-04-23T02:53:36Z [INFO][AMF][GIN] | 201 | 127.0.0.1 | POST | /namf-comm/v1/subscriptions |
2021-04-23T02:53:36Z [INFO][PCF][GIN] | 201 | 127.0.0.1 | POST | /npcf-am-policy-control/v1/policies |
2021-04-23T02:53:36Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Send Registration Accept
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Initial Context Setup Request
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Initial Context Setup Response
2021-04-23T02:53:36Z [INFO][NAS][Message] Encode ExtendedProtocolConfigurationOptions in EncodePDUSessionEstablishmentRequest
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2021-04-23T02:53:36Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle Registration Complete
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:53:36Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2021-04-23T02:53:36Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle UL NAS Transport
2021-04-23T02:53:36Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Transport 5GSM Message to SMF
2021-04-23T02:53:36Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Select SMF [snssai: {Sst:1 Sd:010203}, dnn: internet]
2021-04-23T02:53:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:37Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=AMF&target-nf-type=NSSF |
2021-04-23T02:53:37Z [INFO][NSSF][NsSelect] Handle NSSelectionGet
2021-04-23T02:53:37Z [INFO][NSSF][GIN] | 200 | 127.0.0.1 | GET | /nnssf-nsselection/v1/network-slice-information?nf-id=2a72aa6a-d1e1-4578-ac98-63251ddf4431&nf-type=AMF&slice-info-request-for-pdu-session=%7B%22sNssai%22%3A%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D%2C%22roamingIndication%22%3A%22NON_ROAMING%22%7D |
2021-04-23T02:53:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:37Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?dnn=internet&requester-nf-type=AMF&service-names=nsmf-pdusession&snssais=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D&target-nf-type=SMF&target-plmn-list=%7B%22mcc%22%3A%22208%22%2C%22mnc%22%3A%2293%22%7D |
2021-04-23T02:53:37Z [INFO][SMF][PduSess] Recieve Create SM Context Request
2021-04-23T02:53:37Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextCreate
2021-04-23T02:53:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:37Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-type=UDM |
2021-04-23T02:53:37Z [INFO][SMF][PduSess] Send NF Discovery Serving UDM Successfully
2021-04-23T02:53:37Z [INFO][SMF][CTX] Allocated UE IP address: 60.60.0.1
2021-04-23T02:53:37Z [INFO][SMF][CTX] Selected UPF: UPF
2021-04-23T02:53:37Z [INFO][SMF][PduSess] UE[imsi-2089300007487] PDUSessionID[10] IP[60.60.0.1]
2021-04-23T02:53:37Z [INFO][UDM][SDM] Handle GetSmData
2021-04-23T02:53:37Z [INFO][UDM][SDM] getSmDataProcedure: SUPI[imsi-2089300007487] PLMNID[20893] DNN[internet] SNssai[{"sst":1,"sd":"010203"}]
2021-04-23T02:53:37Z [INFO][UDR][DRepo] Handle QuerySmData
2021-04-23T02:53:37Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/20893/provisioned-data/sm-data?single-nssai=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D |
2021-04-23T02:53:37Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/sm-data?dnn=internet&plmn-id=20893&single-nssai=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D |
2021-04-23T02:53:37Z [INFO][SMF][GSM] In HandlePDUSessionEstablishmentRequest
2021-04-23T02:53:37Z [INFO][NAS][Convert] ProtocolOrContainerList: [0xc00071bca0 0xc00071bce0 0xc00071bd20]
2021-04-23T02:53:37Z [INFO][SMF][GSM] Protocol Configuration Options
2021-04-23T02:53:37Z [INFO][SMF][GSM] &{[0xc00071bca0 0xc00071bce0 0xc00071bd20]}
2021-04-23T02:53:37Z [INFO][SMF][GSM] Didn't Implement container type IPAddressAllocationViaNASSignallingUL
2021-04-23T02:53:37Z [INFO][SMF][PduSess] PCF Selection for SMContext SUPI[imsi-2089300007487] PDUSessionID[10]
2021-04-23T02:53:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:37Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-type=PCF |
2021-04-23T02:53:37Z [INFO][PCF][SMpolicy] Handle CreateSmPolicy
2021-04-23T02:53:37Z [INFO][UDR][DRepo] Handle PolicyDataUesUeIdSmDataGet
2021-04-23T02:53:37Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/policy-data/ues/imsi-2089300007487/sm-data?dnn=internet&snssai=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D |
2021-04-23T02:53:37Z [INFO][PCF][GIN] | 201 | 127.0.0.1 | POST | /npcf-smpolicycontrol/v1/sm-policies |
2021-04-23T02:53:37Z [INFO][SMF][PduSess] SUPI[imsi-2089300007487] has no pre-config route
2021-04-23T02:53:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:37Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-instance-id=2a72aa6a-d1e1-4578-ac98-63251ddf4431&target-nf-type=AMF |
2021-04-23T02:53:37Z [INFO][SMF][Consumer] SendNFDiscoveryServingAMF ok
2021-04-23T02:53:37Z [INFO][SMF][GIN] | 201 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts |
2021-04-23T02:53:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] create smContext[pduSessionID: 10] Success
2021-04-23T02:53:37Z [INFO][UPF][Util] [PFCP] Handle PFCP session establishment request
2021-04-23T02:53:37Z [INFO][UPF][Util] [PFCP] Session Establishment Response
2021-04-23T02:53:37Z [INFO][SMF][PFCP] In HandlePfcpSessionEstablishmentResponse
&{1000 Kbps 1000 Kbps}
2021-04-23T02:53:37Z [INFO][LIB][PFCP] Remove Request Transaction [2]
2021-04-23T02:53:37Z [INFO][AMF][Producer] Handle N1N2 Message Transfer Request
2021-04-23T02:53:37Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send PDU Session Resource Setup Request
2021-04-23T02:53:37Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle PDU Session Resource Setup Response
2021-04-23T02:53:37Z [INFO][SMF][PduSess] Recieve Update SM Context Request
2021-04-23T02:53:37Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextUpdate
2021-04-23T02:53:37Z[33m [WARN][SMF][PduSess] SMContext[imsi-2089300007487-10] should be Active, but actual ModificationPending
2021-04-23T02:53:37Z [INFO][UPF][Util] [PFCP] Handle PFCP session modification request
2021-04-23T02:53:37Z [INFO][UPF][Util] [PFCP] Session Modification Response
2021-04-23T02:53:37Z [INFO][LIB][PFCP] Remove Request Transaction [3]
2021-04-23T02:53:37Z [INFO][SMF][PFCP] In HandlePfcpSessionModificationResponse
2021-04-23T02:53:37Z [INFO][SMF][PduSess] [SMF] PFCP Modification Resonse Accept
2021-04-23T02:53:37Z [INFO][SMF][PFCP] PFCP Session Modification Success[1]
2021-04-23T02:53:37Z [INFO][SMF][GIN] | 200 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts/urn:uuid:585ba360-d97a-4508-83f9-bbc1030c82f0/modify |
2021-04-23T02:53:37Z [INFO][AMF][GIN] | 200 | 127.0.0.1 | POST | /namf-comm/v1/ue-contexts/imsi-2089300007487/n1-n2-messages |
2021-04-23T02:53:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:53:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Uplink NAS Transport (RAN UE NGAP ID: 1)
2021-04-23T02:53:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle UL NAS Transport
2021-04-23T02:53:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Transport 5GSM Message to SMF
2021-04-23T02:53:38Z[33m [WARN][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Duplicated PDU session ID[10]
2021-04-23T02:53:38Z [INFO][SMF][PduSess] Recieve Update SM Context Request
2021-04-23T02:53:38Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextUpdate
2021-04-23T02:53:38Z [INFO][SMF][CTX] [SMF] Cause_REL_DUE_TO_DUPLICATE_SESSION_ID
2021-04-23T02:53:38Z [INFO][SMF][PduSess] Send PFCP Deletion from HandlePDUSessionSMContextUpdate
2021-04-23T02:53:38Z [INFO][UPF][Util] [PFCP] Handle PFCP session deletion request
2021-04-23T02:53:38Z [INFO][UPF][Util] [PFCP] Session Deletion Response
2021-04-23T02:53:38Z [INFO][LIB][PFCP] Remove Request Transaction [4]
2021-04-23T02:53:38Z [INFO][SMF][PFCP] Handle PFCP Session Deletion Response
2021-04-23T02:53:38Z [INFO][SMF][PFCP] PFCP Session Deletion Success[1]
2021-04-23T02:53:38Z [INFO][SMF][GIN] | 200 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts/urn:uuid:585ba360-d97a-4508-83f9-bbc1030c82f0/modify |
2021-04-23T02:53:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send PDU Session Resource Release Command
2021-04-23T02:53:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle PDU Session Resource Release Response
2021-04-23T02:53:38Z [INFO][SMF][PduSess] Recieve Update SM Context Request
2021-04-23T02:53:38Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextUpdate
2021-04-23T02:53:38Z [INFO][SMF][PduSess] [SMF] N2 PDUSession Release Complete
2021-04-23T02:53:38Z [INFO][SMF][PduSess] [SMF] Send Update SmContext Response
2021-04-23T02:53:38Z [INFO][SMF][PduSess] UE[imsi-2089300007487] PDUSessionID[10] Release IP[60.60.0.1]
2021-04-23T02:53:38Z [INFO][SMF][CTX] [SMF] Send SMContext Status Notification
2021-04-23T02:53:38Z [INFO][AMF][Producer] [AMF] Handle SmContext Status Notify
2021-04-23T02:53:38Z [INFO][AMF][GIN] | 204 | 127.0.0.1 | POST | /namf-callback/v1/smContextStatus/20893cafe0000000001/10 |
2021-04-23T02:53:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Select SMF [snssai: {Sst:1 Sd:010203}, dnn: internet]
2021-04-23T02:53:38Z [INFO][SMF][GIN] | 200 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts/urn:uuid:585ba360-d97a-4508-83f9-bbc1030c82f0/modify |
2021-04-23T02:53:38Z [INFO][NSSF][NsSelect] Handle NSSelectionGet
2021-04-23T02:53:38Z [INFO][NSSF][GIN] | 200 | 127.0.0.1 | GET | /nnssf-nsselection/v1/network-slice-information?nf-id=2a72aa6a-d1e1-4578-ac98-63251ddf4431&nf-type=AMF&slice-info-request-for-pdu-session=%7B%22sNssai%22%3A%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D%2C%22roamingIndication%22%3A%22NON_ROAMING%22%7D |
2021-04-23T02:53:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:38Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?dnn=internet&requester-nf-type=AMF&service-names=nsmf-pdusession&snssais=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D&target-nf-type=SMF&target-plmn-list=%7B%22mcc%22%3A%22208%22%2C%22mnc%22%3A%2293%22%7D |
2021-04-23T02:53:38Z [INFO][SMF][PduSess] Recieve Create SM Context Request
2021-04-23T02:53:38Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextCreate
2021-04-23T02:53:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:38Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-type=UDM |
2021-04-23T02:53:38Z [INFO][SMF][PduSess] Send NF Discovery Serving UDM Successfully
2021-04-23T02:53:38Z [INFO][SMF][CTX] Allocated UE IP address: 60.60.0.2
2021-04-23T02:53:38Z [INFO][SMF][CTX] Selected UPF: UPF
2021-04-23T02:53:38Z [INFO][SMF][PduSess] UE[imsi-2089300007487] PDUSessionID[10] IP[60.60.0.2]
2021-04-23T02:53:38Z [INFO][UDM][SDM] Handle GetSmData
2021-04-23T02:53:38Z [INFO][UDM][SDM] getSmDataProcedure: SUPI[imsi-2089300007487] PLMNID[20893] DNN[internet] SNssai[{"sst":1,"sd":"010203"}]
http://127.0.0.10:8000
2021-04-23T02:53:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:39Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=UDM&target-nf-type=UDR |
2021-04-23T02:53:39Z [INFO][UDR][DRepo] Handle QuerySmData
2021-04-23T02:53:39Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/20893/provisioned-data/sm-data?single-nssai=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D |
2021-04-23T02:53:39Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/sm-data?dnn=internet&plmn-id=20893&single-nssai=%7B%22sst%22%3A1%2C%22sd%22%3A%22010203%22%7D |
2021-04-23T02:53:39Z [INFO][SMF][GSM] In HandlePDUSessionEstablishmentRequest
2021-04-23T02:53:39Z [INFO][NAS][Convert] ProtocolOrContainerList: [0xc0006b4680 0xc0006b46c0 0xc0006b4700]
2021-04-23T02:53:39Z [INFO][SMF][GSM] Protocol Configuration Options
2021-04-23T02:53:39Z [INFO][SMF][GSM] &{[0xc0006b4680 0xc0006b46c0 0xc0006b4700]}
2021-04-23T02:53:39Z [INFO][SMF][GSM] Didn't Implement container type IPAddressAllocationViaNASSignallingUL
2021-04-23T02:53:39Z [INFO][SMF][PduSess] PCF Selection for SMContext SUPI[imsi-2089300007487] PDUSessionID[10]
2021-04-23T02:53:39Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:39Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-type=PCF |
2021-04-23T02:53:39Z [INFO][PCF][SMpolicy] Handle CreateSmPolicy
2021-04-23T02:53:39Z [INFO][PCF][GIN] | 201 | 127.0.0.1 | POST | /npcf-smpolicycontrol/v1/sm-policies |
2021-04-23T02:53:39Z [INFO][SMF][PduSess] SUPI[imsi-2089300007487] has no pre-config route
2021-04-23T02:53:39Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:53:39Z [INFO][NRF][GIN] | 200 | 127.0.0.1 | GET | /nnrf-disc/v1/nf-instances?requester-nf-type=SMF&target-nf-instance-id=2a72aa6a-d1e1-4578-ac98-63251ddf4431&target-nf-type=AMF |
2021-04-23T02:53:39Z [INFO][SMF][Consumer] SendNFDiscoveryServingAMF ok
2021-04-23T02:53:39Z [INFO][SMF][GIN] | 201 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts |
2021-04-23T02:53:39Z [INFO][UPF][Util] [PFCP] Handle PFCP session establishment request
2021-04-23T02:53:39Z [INFO][UPF][Util] [PFCP] Session Establishment Response
2021-04-23T02:53:39Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] create smContext[pduSessionID: 10] Success
2021-04-23T02:53:39Z [INFO][SMF][PFCP] In HandlePfcpSessionEstablishmentResponse
&{1000 Kbps 1000 Kbps}
2021-04-23T02:53:39Z [INFO][AMF][Producer] Handle N1N2 Message Transfer Request
2021-04-23T02:53:39Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send PDU Session Resource Setup Request
2021-04-23T02:53:39Z [INFO][LIB][PFCP] Remove Request Transaction [5]
2021-04-23T02:53:39Z [INFO][AMF][GIN] | 200 | 127.0.0.1 | POST | /namf-comm/v1/ue-contexts/imsi-2089300007487/n1-n2-messages |
2021-04-23T02:53:39Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle PDU Session Resource Setup Response
2021-04-23T02:53:39Z [INFO][SMF][PduSess] Recieve Update SM Context Request
2021-04-23T02:53:39Z [INFO][SMF][PduSess] In HandlePDUSessionSMContextUpdate
2021-04-23T02:53:39Z [INFO][UPF][Util] [PFCP] Handle PFCP session modification request
2021-04-23T02:53:39Z [INFO][UPF][Util] [PFCP] Session Modification Response
2021-04-23T02:53:39Z [INFO][LIB][PFCP] Remove Request Transaction [6]
2021-04-23T02:53:39Z [INFO][SMF][PFCP] In HandlePfcpSessionModificationResponse
2021-04-23T02:53:39Z [INFO][SMF][PduSess] [SMF] PFCP Modification Resonse Accept
2021-04-23T02:53:39Z [INFO][SMF][PFCP] PFCP Session Modification Success[2]
2021-04-23T02:53:39Z [INFO][SMF][GIN] | 200 | 127.0.0.1 | POST | /nsmf-pdusession/v1/sm-contexts/urn:uuid:2a15217a-dea2-4842-a8f3-407795883d6f/modify |
2021-04-23T02:53:41Z [INFO][NRF][Init] Terminating NRF...
2021-04-23T02:53:41Z [INFO][NRF][Init] NRF terminated
2021-04-23T02:53:41Z [INFO][AMF][Init] Terminating AMF...
2021-04-23T02:53:41Z [INFO][AMF][Consumer] [AMF] Send Deregister NFInstance
2021-04-23T02:53:41Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:41Z [INFO][AMF][NGAP] Handle SCTP Notification[addr: <nil>]
2021-04-23T02:53:41Z [INFO][AMF][NGAP][127.0.0.1:9487] SCTP_SHUTDOWN_EVENT notification, close the connection
2021-04-23T02:53:41Z [INFO][AMF][NGAP][127.0.0.1:9487] Remove RAN Context[ID: <PlmnID: {Mcc:208 Mnc:93}, GNbID: 000102>]
2021-04-23T02:53:41Z [INFO][AMF][NGAP] Handle SCTP Notification[addr: <nil>]
2021-04-23T02:53:41Z[33m [WARN][AMF][NGAP] RAN context has been removed[addr: <nil>]
2021-04-23T02:53:42Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/2a72aa6a-d1e1-4578-ac98-63251ddf4431 |
2021-04-23T02:53:42Z [INFO][AMF][Init] [AMF] Deregister from NRF successfully
2021-04-23T02:53:42Z [INFO][AMF][Init] Send AMF Status Indication to Notify RANs due to AMF terminating
2021-04-23T02:53:42Z [INFO][AMF][NGAP] Close SCTP server...
2021-04-23T02:53:42Z [INFO][AMF][NGAP] SCTP server closed
2021-04-23T02:53:42Z [INFO][AMF][Producer] [AMF] Send Amf Status Change Notify to http://127.0.0.7:8000/npcf-callback/v1/amfstatus
2021-04-23T02:53:42Z[33m [WARN][PCF][Callback] [PCF] Handle Amf Status Change Notify is not implemented.
2021-04-23T02:53:42Z [INFO][PCF][GIN] | 204 | 127.0.0.1 | POST | /npcf-callback/v1/amfstatus |
2021-04-23T02:53:42Z [INFO][AMF][Init] AMF terminated
2021-04-23T02:53:42Z [INFO][SMF][Init] Terminating SMF...
2021-04-23T02:53:42Z [INFO][SMF][Consumer] Send Deregister NFInstance
2021-04-23T02:53:42Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:43Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/a42c5c0a-fbae-4816-9191-b6d11cffd422 |
2021-04-23T02:53:43Z [INFO][SMF][Init] Deregister from NRF successfully
2021-04-23T02:53:43Z [INFO][UDR][Init] Terminating UDR...
2021-04-23T02:53:43Z [INFO][UDR][Consumer] Send Deregister NFInstance
2021-04-23T02:53:43Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:44Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/dc0e382f-7dd0-4c7b-b340-fc8356b2353e |
2021-04-23T02:53:44Z [INFO][UDR][Init] Deregister from NRF successfully
2021-04-23T02:53:44Z [INFO][UDR][Init] UDR terminated
2021-04-23T02:53:44Z [INFO][PCF][Init] Terminating PCF...
2021-04-23T02:53:44Z [INFO][PCF][Consumer] Send Deregister NFInstance
2021-04-23T02:53:44Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:45Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/f69f0662-c66a-4c00-9079-fd9e5aa9f32f |
2021-04-23T02:53:45Z [INFO][PCF][Init] Deregister from NRF successfully
2021-04-23T02:53:45Z [INFO][PCF][Init] PCF terminated
2021-04-23T02:53:45Z [INFO][UDM][Init] Terminating UDM...
2021-04-23T02:53:45Z [INFO][UDM][Consumer] Send Deregister NFInstance
2021-04-23T02:53:45Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:46Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/e23de71e-ee41-49de-aaa6-34c8ece49d5e |
2021-04-23T02:53:46Z [INFO][UDM][Init] Deregister from NRF successfully
2021-04-23T02:53:46Z [INFO][UDM][Init] UDM terminated
2021-04-23T02:53:46Z [INFO][NSSF][Init] Terminating NSSF...
2021-04-23T02:53:46Z [INFO][NSSF][App] Send Deregister NFInstance
2021-04-23T02:53:46Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:47Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/55998b1c-c422-4d2d-848c-d9a13fc95cf3 |
2021-04-23T02:53:47Z [INFO][NSSF][Init] Deregister from NRF successfully
2021-04-23T02:53:47Z [INFO][NSSF][Init] NSSF terminated
2021-04-23T02:53:47Z [INFO][AUSF][Init] Terminating AUSF...
2021-04-23T02:53:47Z [INFO][AUSF][App] Send Deregister NFInstance
2021-04-23T02:53:47Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:53:48Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/3db5bb65-6377-4482-96ac-87bf4b8d3dcc |
2021-04-23T02:53:48Z [INFO][AUSF][Init] Deregister from NRF successfully
2021-04-23T02:53:48Z [INFO][AUSF][Init] AUSF terminated
--- PASS: TestDuplicateRegistration (14.44s)
PASS
ok test 16.153s
2021-04-23T02:53:51Z [INFO][UPF][Util] Removing DNN routes
ls: cannot access '*sslkey.log': No such file or directory