TestDeregistration
cd ~/free5gc
./test.sh TestDeregistration|& tee testDereg.log
Result Screen
2021-04-23T02:45:31Z [INFO][UPF][Util] Config: /home/free5gc/free5gc/NFs/upf/build/config/upfcfg.test.yaml
2021-04-23T02:45:31Z [INFO][UPF][Util] UPF config version [1.0.0]
2021-04-23T02:45:31Z [INFO][UPF][Util] Set log level: info
2021-04-23T02:45:31Z [INFO][UPF][Util] DNN routes added, main routing table:
2021-04-23T02:45:31Z [INFO][UPF][Util] DstIp Gateway Iface Priority RtProto Type
2021-04-23T02:45:31Z [INFO][UPF][Util] 60.60.0.0 /24 0.0.0.0 upfgtp 0 static unicast
2021-04-23T02:45:31Z [INFO][UPF][Util] 10.200.200.0 /24 0.0.0.0 veth1 0 kernel unicast
2021-04-23T02:45:36Z [INFO][NRF][Init] NRF Log level is set to [info] level
2021-04-23T02:45:36Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][MonDB] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][MonDB] set report call : false
2021-04-23T02:45:36Z [INFO][NRF][CFG] config version [1.0.0]
2021-04-23T02:45:36Z [INFO][NRF][Init] Server started
2021-04-23T02:45:36Z [INFO][NRF][Init] nrfconfig Info: Version[1.0.0] Description[NRF initial local configuration]
2021-04-23T02:45:36Z [INFO][NRF][Init] Binding addr: [127.0.0.10:8000]
2021-04-23T02:45:36Z [INFO][AMF][Init] AMF Log level is set to [info] level
2021-04-23T02:45:36Z [INFO][LIB][NAS] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][NAS] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][NGAP] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][NGAP] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][FSM] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][FSM] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][Aper] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Aper] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:36Z [INFO][AMF][CFG] config version [1.0.1]
2021-04-23T02:45:36Z [INFO][AMF][Init] Server started
2021-04-23T02:45:36Z [INFO][AMF][Util] amfconfig Info: Version[1.0.1] Description[AMF initial local configuration]
2021-04-23T02:45:36Z [INFO][AMF][NGAP] Listen on 127.0.0.1:38412
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:36Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/d1447a5e-21f5-45af-91f7-675ecc183cb2
2021-04-23T02:45:36Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/d1447a5e-21f5-45af-91f7-675ecc183cb2 |
2021-04-23T02:45:36Z [INFO][SMF][Init] SMF Log level is set to [info] level
2021-04-23T02:45:36Z [INFO][LIB][NAS] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][NAS] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][NGAP] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][NGAP] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][Aper] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Aper] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][PFCP] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][PFCP] set report call : false
2021-04-23T02:45:36Z [INFO][SMF][CFG] SMF config version [1.0.1]
2021-04-23T02:45:36Z [INFO][SMF][CFG] UE-Routing config version [1.0.1]
2021-04-23T02:45:36Z [INFO][SMF][CTX] smfconfig Info: Version[1.0.1] Description[SMF initial local configuration]
2021-04-23T02:45:36Z [INFO][SMF][CTX] Endpoints: [10.200.200.102]
2021-04-23T02:45:36Z [INFO][SMF][Init] Server started
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:36Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/c882d7f0-4752-4cd2-a037-ab78a40b3246
2021-04-23T02:45:36Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/c882d7f0-4752-4cd2-a037-ab78a40b3246 |
2021-04-23T02:45:36Z [INFO][SMF][Init] SMF Registration to NRF {c882d7f0-4752-4cd2-a037-ab78a40b3246 SMF REGISTERED 0 0xc0004ff980 0xc0004ff9c0 [] [] [127.0.0.2] [] <nil> [] [] <nil> 0 0 0 <nil> <nil> <nil> <nil> 0xc000367500 <nil> <nil> <nil> <nil> <nil> map[] <nil> false 0xc0004ff800 false false []}
2021-04-23T02:45:36Z [INFO][SMF][PFCP] Listen on 10.200.200.1:8805
2021-04-23T02:45:36Z [INFO][SMF][App] Send PFCP Association Request to UPF[10.200.200.101]
2021-04-23T02:45:36Z [INFO][UPF][Util] [PFCP] Handle PFCP association setup request
2021-04-23T02:45:36Z [INFO][UPF][Util] [PFCP] Association Setup Response
2021-04-23T02:45:36Z [INFO][LIB][PFCP] Remove Request Transaction [1]
2021-04-23T02:45:36Z [INFO][SMF][PFCP] In HandlePfcpAssociationSetupResponse
2021-04-23T02:45:36Z [INFO][SMF][PFCP] Handle PFCP Association Setup Response with NodeID[10.200.200.101]
2021-04-23T02:45:36Z [INFO][SMF][PFCP] UPF(10.200.200.101)[internet] setup association
2021-04-23T02:45:36Z [INFO][UDR][Init] UDR Log level is set to [info] level
2021-04-23T02:45:36Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:36Z [INFO][LIB][MonDB] set log level : info
2021-04-23T02:45:36Z [INFO][LIB][MonDB] set report call : false
2021-04-23T02:45:36Z [INFO][UDR][CFG] config version [1.0.0]
2021-04-23T02:45:36Z [INFO][UDR][Init] UDR Config Info: Version[1.0.0] Description[UDR initial local configuration]
2021-04-23T02:45:36Z [INFO][UDR][Init] Server started
2021-04-23T02:45:36Z [INFO][UDR][Util] udrconfig Info: Version[1.0.0] Description[UDR initial local configuration]
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:36Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:36Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/084c2105-c178-4f5b-94b9-a9ee52a34791
2021-04-23T02:45:36Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/084c2105-c178-4f5b-94b9-a9ee52a34791 |
2021-04-23T02:45:37Z [INFO][PCF][Init] PCF Log level is set to [info] level
2021-04-23T02:45:37Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:37Z [INFO][PCF][CFG] config version [1.0.0]
2021-04-23T02:45:37Z [INFO][PCF][Init] Server started
2021-04-23T02:45:37Z [INFO][PCF][Util] pcfconfig Info: Version[1.0.0] Description[PCF initial local configuration]
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:37Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/5c9d4fef-adc5-4258-b2a3-01e3baa69534
2021-04-23T02:45:37Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/5c9d4fef-adc5-4258-b2a3-01e3baa69534 |
2021-04-23T02:45:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:37Z [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:45:37Z [INFO][UDM][Init] UDM Log level is set to [info] level
2021-04-23T02:45:37Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:37Z [INFO][UDM][CFG] config version [1.0.0]
2021-04-23T02:45:37Z [INFO][UDM][Init] UDM Config Info: Version[1.0.0] Description[UDM initial local configuration]
2021-04-23T02:45:37Z [INFO][UDM][Init] Server started
2021-04-23T02:45:37Z [INFO][UDM][Util] udmconfig Info: Version[1.0.0] Description[UDM initial local configuration]
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:37Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/ef148b8d-bdd6-4004-9a69-84af85dc74fb
2021-04-23T02:45:37Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/ef148b8d-bdd6-4004-9a69-84af85dc74fb |
2021-04-23T02:45:37Z [INFO][NSSF][Init] NSSF Log level is set to [info] level
2021-04-23T02:45:37Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:37Z [INFO][NSSF][CFG] config version [1.0.0]
2021-04-23T02:45:37Z [INFO][NSSF][Init] Server started
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:37Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/b2c96131-7a10-4b6d-aae5-b6fccadc82c7
2021-04-23T02:45:37Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/b2c96131-7a10-4b6d-aae5-b6fccadc82c7 |
2021-04-23T02:45:37Z [INFO][AUSF][Init] AUSF Log level is set to [info] level
2021-04-23T02:45:37Z [INFO][LIB][Path] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][Path] set report call : false
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set log level : info
2021-04-23T02:45:37Z [INFO][LIB][OAPI] set report call : false
2021-04-23T02:45:37Z [INFO][AUSF][CFG] config version [1.0.0]
2021-04-23T02:45:37Z [INFO][AUSF][Init] Server started
2021-04-23T02:45:37Z [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} 4c05515b-8dab-408c-b123-30b0e0bbadb4 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:{4c05515b-8dab-408c-b123-30b0e0bbadb4 nausf-auth 0xc00067ae20 http REGISTERED 0xc00067ae00 [] <nil> [] [] <nil> 0 0 0 <nil> <nil> }] [{208 93} {123 45}] 0xc000396320}
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Handle NFRegisterRequest
2021-04-23T02:45:37Z [INFO][NRF][MGMT] urilist update
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Create NF Profile
2021-04-23T02:45:37Z [INFO][NRF][MGMT] Location header: http://127.0.0.10:8000/nnrf-nfm/v1/nf-instances/4c05515b-8dab-408c-b123-30b0e0bbadb4
2021-04-23T02:45:37Z [INFO][NRF][GIN] | 201 | 127.0.0.1 | PUT | /nnrf-nfm/v1/nf-instances/4c05515b-8dab-408c-b123-30b0e0bbadb4 |
=== RUN TestDeregistration
2021-04-23T02:45:37Z [INFO][AMF][NGAP] [AMF] SCTP Accept from: 127.0.0.1:9487
2021-04-23T02:45:37Z [INFO][AMF][NGAP] Create a new NG connection for: 127.0.0.1:9487
2021-04-23T02:45:37Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle NG Setup request
2021-04-23T02:45:37Z [INFO][AMF][NGAP][127.0.0.1:9487] Send NG-Setup response
2021-04-23T02:45:37Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Initial UE Message
2021-04-23T02:45:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Registration Request
2021-04-23T02:45:37Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Authentication procedure
2021-04-23T02:45:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:37Z [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:45:37Z [INFO][AUSF][UeAuthPost] HandleUeAuthPostRequest
2021-04-23T02:45:37Z [INFO][AUSF][UeAuthPost] Serving network authorized
2021-04-23T02:45:37Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][UEAU] Handle GenerateAuthDataRequest
2021-04-23T02:45:38Z [INFO][LIB][3GPP] suciPart [suci 0 208 93 0 0 0 00007487]
2021-04-23T02:45:38Z [INFO][LIB][3GPP] scheme 0
2021-04-23T02:45:38Z [INFO][LIB][3GPP] SUPI type is IMSI
http://127.0.0.10:8000
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle QueryAuthSubsData
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-subscription |
2021-04-23T02:45:38Z [INFO][UDR][DRepo] Handle ModifyAuthentication
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PATCH | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-subscription |
AUTN = 56daa146724f8000cf163310c42b8095
2021-04-23T02:45:38Z [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:45:38Z [INFO][AUSF][UeAuthPost] Add SuciSupiPair (suci-0-208-93-0-0-0-00007487, imsi-2089300007487) to map.
2021-04-23T02:45:38Z [INFO][AUSF][UeAuthPost] Use 5G AKA auth method
2021-04-23T02:45:38Z [INFO][AUSF][5gAkaAuth] XresStar = 3638646461376564376439393537313035313064643139346236333836343238
2021-04-23T02:45:38Z [INFO][AUSF][GIN] | 201 | 127.0.0.1 | POST | /nausf-auth/v1/ue-authentications |
2021-04-23T02:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Send Authentication Request
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:45: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:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1] Handle Authentication Response
2021-04-23T02:45:38Z [INFO][AUSF][5gAkaAuth] Auth5gAkaComfirmRequest
2021-04-23T02:45:38Z [INFO][AUSF][5gAkaAuth] res*: 3638646461376564376439393537313035313064643139346236333836343238
Xres*: 3638646461376564376439393537313035313064643139346236333836343238
2021-04-23T02:45:38Z [INFO][AUSF][5gAkaAuth] 5G AKA confirmation succeeded
2021-04-23T02:45:38Z [INFO][UDM][UEAU] Handle ConfirmAuthDataRequest
2021-04-23T02:45:38Z [INFO][UDR][DRepo] Handle CreateAuthenticationStatus
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PUT | /nudr-dr/v1/subscription-data/imsi-2089300007487/authentication-data/authentication-status |
2021-04-23T02:45:38Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | POST | /nudm-ueau/v1/imsi-2089300007487/auth-events |
2021-04-23T02:45:38Z [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:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Send Security Mode Command
2021-04-23T02:45:38Z [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: 0x738d0ca6
err <nil>
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:45: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:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle Security Mode Complete
2021-04-23T02:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle InitialRegistration
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][SDM] Handle GetNssai
2021-04-23T02:45:38Z [INFO][UDR][DRepo] Handle QueryAmData
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/nssai?plmn-id=20893 |
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][UECM] Handle RegistrationAmf3gppAccess
2021-04-23T02:45:38Z [INFO][UDM][UECM] UEID: imsi-2089300007487
http://127.0.0.10:8000
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle CreateAmfContext3gpp
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 204 | 127.0.0.1 | PUT | /nudr-dr/v1/subscription-data/imsi-2089300007487/context-data/amf-3gpp-access |
2021-04-23T02:45:38Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | PUT | /nudm-uecm/v1/imsi-2089300007487/registrations/amf-3gpp-access |
2021-04-23T02:45:38Z [INFO][UDM][SDM] Handle GetAmData
2021-04-23T02:45:38Z [INFO][UDR][DRepo] Handle QueryAmData
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/am-data?plmn-id=20893 |
2021-04-23T02:45:38Z [INFO][UDM][SDM] Handle GetSmfSelectData
http://127.0.0.10:8000
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle QuerySmfSelectData
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/smf-select-data?plmn-id=20893 |
2021-04-23T02:45:38Z [INFO][UDM][SDM] Handle GetUeContextInSmfData
http://127.0.0.10:8000
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle QuerySmfRegList
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDM][GIN] | 200 | 127.0.0.1 | GET | /nudm-sdm/v1/imsi-2089300007487/ue-context-in-smf-data |
2021-04-23T02:45:38Z [INFO][UDM][SDM] Handle Subscribe
http://127.0.0.10:8000
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle CreateSdmSubscriptions
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 201 | 127.0.0.1 | POST | /nudr-dr/v1/subscription-data/imsi-2089300007487/context-data/sdm-subscriptions |
2021-04-23T02:45:38Z [INFO][UDM][GIN] | 201 | 127.0.0.1 | POST | /nudm-sdm/v1/imsi-2089300007487/sdm-subscriptions |
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][PCF][Ampolicy] Handle AM Policy Create Request
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][UDR][DRepo] Handle PolicyDataUesUeIdAmDataGet
2021-04-23T02:45:38Z [INFO][UDR][GIN] | 200 | 127.0.0.1 | GET | /nudr-dr/v1/policy-data/ues/imsi-2089300007487/am-data |
2021-04-23T02:45:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
2021-04-23T02:45:38Z [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:45:38Z [INFO][AMF][Comm] Handle AMF Status Change Subscribe Request
2021-04-23T02:45:38Z [INFO][AMF][Comm] new AMF Status Subscription[1]
2021-04-23T02:45:38Z [INFO][AMF][GIN] | 201 | 127.0.0.1 | POST | /namf-comm/v1/subscriptions |
2021-04-23T02:45:38Z [INFO][PCF][GIN] | 201 | 127.0.0.1 | POST | /npcf-am-policy-control/v1/policies |
2021-04-23T02:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Send Registration Accept
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Initial Context Setup Request
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Initial Context Setup Response
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:45: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:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle Registration Complete
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle Uplink Nas Transport
2021-04-23T02:45: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:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Handle Deregistration Request(UE Originating)
2021-04-23T02:45:38Z [INFO][PCF][Ampolicy] Handle AM Policy Association Delete
2021-04-23T02:45:38Z [INFO][PCF][GIN] | 204 | 127.0.0.1 | DELETE | /npcf-am-policy-control/v1/policies/imsi-2089300007487-1 |
2021-04-23T02:45:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:1][SUPI:imsi-2089300007487] Send Deregistration Accept
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send Downlink Nas Transport
2021-04-23T02:45:38Z [INFO][AMF][NGAP][127.0.0.1:9487][AMF_UE_NGAP_ID:1] Send UE Context Release Command
2021-04-23T02:45:39Z [INFO][AMF][NGAP][127.0.0.1:9487] Handle UE Context Release Complete
2021-04-23T02:45:39Z [INFO][AMF][NGAP][127.0.0.1:9487] Release UE[imsi-2089300007487] Context : Release Ue Context
2021-04-23T02:45:39Z [INFO][NRF][Init] Terminating NRF...
2021-04-23T02:45:39Z [INFO][NRF][Init] NRF terminated
2021-04-23T02:45:39Z [INFO][AMF][Init] Terminating AMF...
2021-04-23T02:45:39Z [INFO][AMF][Consumer] [AMF] Send Deregister NFInstance
2021-04-23T02:45:39Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:39Z [INFO][AMF][NGAP] Handle SCTP Notification[addr: <nil>]
2021-04-23T02:45:39Z [INFO][AMF][NGAP][127.0.0.1:9487] SCTP_SHUTDOWN_EVENT notification, close the connection
2021-04-23T02:45:39Z [INFO][AMF][NGAP][127.0.0.1:9487] Remove RAN Context[ID: <PlmnID: {Mcc:208 Mnc:93}, GNbID: 000102>]
2021-04-23T02:45:39Z [INFO][AMF][NGAP] Handle SCTP Notification[addr: <nil>]
2021-04-23T02:45:39Z[33m [WARN][AMF][NGAP] RAN context has been removed[addr: <nil>]
2021-04-23T02:45:40Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/d1447a5e-21f5-45af-91f7-675ecc183cb2 |
2021-04-23T02:45:40Z [INFO][AMF][Init] [AMF] Deregister from NRF successfully
2021-04-23T02:45:40Z [INFO][AMF][Init] Send AMF Status Indication to Notify RANs due to AMF terminating
2021-04-23T02:45:40Z [INFO][AMF][NGAP] Close SCTP server...
2021-04-23T02:45:40Z [INFO][AMF][NGAP] SCTP server closed
2021-04-23T02:45:40Z [INFO][AMF][Producer] [AMF] Send Amf Status Change Notify to http://127.0.0.7:8000/npcf-callback/v1/amfstatus
2021-04-23T02:45:40Z[33m [WARN][PCF][Callback] [PCF] Handle Amf Status Change Notify is not implemented.
2021-04-23T02:45:40Z [INFO][PCF][GIN] | 204 | 127.0.0.1 | POST | /npcf-callback/v1/amfstatus |
2021-04-23T02:45:40Z [INFO][AMF][Init] AMF terminated
2021-04-23T02:45:40Z [INFO][SMF][Init] Terminating SMF...
2021-04-23T02:45:40Z [INFO][SMF][Consumer] Send Deregister NFInstance
2021-04-23T02:45:40Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:41Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/c882d7f0-4752-4cd2-a037-ab78a40b3246 |
2021-04-23T02:45:41Z [INFO][SMF][Init] Deregister from NRF successfully
2021-04-23T02:45:41Z [INFO][UDR][Init] Terminating UDR...
2021-04-23T02:45:41Z [INFO][UDR][Consumer] Send Deregister NFInstance
2021-04-23T02:45:41Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:42Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/084c2105-c178-4f5b-94b9-a9ee52a34791 |
2021-04-23T02:45:42Z [INFO][UDR][Init] Deregister from NRF successfully
2021-04-23T02:45:42Z [INFO][UDR][Init] UDR terminated
2021-04-23T02:45:42Z [INFO][PCF][Init] Terminating PCF...
2021-04-23T02:45:42Z [INFO][PCF][Consumer] Send Deregister NFInstance
2021-04-23T02:45:42Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:43Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/5c9d4fef-adc5-4258-b2a3-01e3baa69534 |
2021-04-23T02:45:43Z [INFO][PCF][Init] Deregister from NRF successfully
2021-04-23T02:45:43Z [INFO][PCF][Init] PCF terminated
2021-04-23T02:45:43Z [INFO][UDM][Init] Terminating UDM...
2021-04-23T02:45:43Z [INFO][UDM][Consumer] Send Deregister NFInstance
2021-04-23T02:45:43Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:44Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/ef148b8d-bdd6-4004-9a69-84af85dc74fb |
2021-04-23T02:45:44Z [INFO][UDM][Init] Deregister from NRF successfully
2021-04-23T02:45:44Z [INFO][UDM][Init] UDM terminated
2021-04-23T02:45:44Z [INFO][NSSF][Init] Terminating NSSF...
2021-04-23T02:45:44Z [INFO][NSSF][App] Send Deregister NFInstance
2021-04-23T02:45:44Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:45Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/b2c96131-7a10-4b6d-aae5-b6fccadc82c7 |
2021-04-23T02:45:45Z [INFO][NSSF][Init] Deregister from NRF successfully
2021-04-23T02:45:45Z [INFO][NSSF][Init] NSSF terminated
2021-04-23T02:45:45Z [INFO][AUSF][Init] Terminating AUSF...
2021-04-23T02:45:45Z [INFO][AUSF][App] Send Deregister NFInstance
2021-04-23T02:45:45Z [INFO][NRF][MGMT] Handle NFDeregisterRequest
2021-04-23T02:45:46Z [INFO][NRF][GIN] | 204 | 127.0.0.1 | DELETE | /nnrf-nfm/v1/nf-instances/4c05515b-8dab-408c-b123-30b0e0bbadb4 |
2021-04-23T02:45:46Z [INFO][AUSF][Init] Deregister from NRF successfully
2021-04-23T02:45:46Z [INFO][AUSF][Init] AUSF terminated
--- PASS: TestDeregistration (8.56s)
PASS
ok test 10.223s
2021-04-23T02:45:49Z [INFO][UPF][Util] Removing DNN routes
ls: cannot access '*sslkey.log': No such file or directory