UERANSIM + AMF CreateSmContextRequest Error: server no response #65
Description
Hi Sir,
I am using UERAMSIM to do gnb and ue simulator.
The AMF side keep logging:
amf | 2022-03-17T06:04:09Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] CreateSmContextRequest Error: server no response
amf | 2022-03-17T06:04:22Z [INFO][AMF][NGAP][10.100.200.1:35206] Handle Uplink Nas Transport
amf | 2022-03-17T06:04:22Z [INFO][AMF][NGAP][10.100.200.1:35206][AMF_UE_NGAP_ID:84] Uplink NAS Transport (RAN UE NGAP ID: 84)
amf | 2022-03-17T06:04:22Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Handle UL NAS Transport
amf | 2022-03-17T06:04:22Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Transport 5GSM Message to SMF
amf | 2022-03-17T06:04:22Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Select SMF [snssai: {Sst:1 Sd:010203}, dnn: internet]
nssf | 2022-03-17T06:04:22Z [INFO][NSSF][NsSelect] Handle NSSelectionGet
nssf | 2022-03-17T06:04:22Z [INFO][NSSF][GIN] | 200 | 10.100.200.102 | GET | /nnssf-nsselection/v1/network-slice-information?nf-id=7a2473f2-99f6-4d3c-b3a7-4497d470a749&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 |
nrf | 2022-03-17T06:04:22Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
nrf | 2022-03-17T06:04:22Z [INFO][NRF][GIN] | 200 | 10.100.200.102 | GET | /nnrf-disc/v1/nf-instances?dnn=internet&preferred-locality=area1&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 |
amf | 2022-03-17T06:04:25Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] CreateSmContextRequest Error: server no response
mongodb | {"t":{"$date":"2022-03-17T06:04:26.988+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"WTCheckpointThread","msg":"WiredTiger message","attr":{"message":"[1647497066:988193][1:0x7fa4c3005700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 264, snapshot max: 264 snapshot count: 0, oldest timestamp: (0, 0) , meta checkpoint timestamp: (0, 0) base write gen: 15042"}}
amf | 2022-03-17T06:04:38Z [INFO][AMF][NGAP][10.100.200.1:35206] Handle Uplink Nas Transport
amf | 2022-03-17T06:04:38Z [INFO][AMF][NGAP][10.100.200.1:35206][AMF_UE_NGAP_ID:84] Uplink NAS Transport (RAN UE NGAP ID: 84)
amf | 2022-03-17T06:04:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Handle UL NAS Transport
amf | 2022-03-17T06:04:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Transport 5GSM Message to SMF
amf | 2022-03-17T06:04:38Z [INFO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] Select SMF [snssai: {Sst:1 Sd:010203}, dnn: internet]
nssf | 2022-03-17T06:04:38Z [INFO][NSSF][NsSelect] Handle NSSelectionGet
nssf | 2022-03-17T06:04:38Z [INFO][NSSF][GIN] | 200 | 10.100.200.102 | GET | /nnssf-nsselection/v1/network-slice-information?nf-id=7a2473f2-99f6-4d3c-b3a7-4497d470a749&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 |
nrf | 2022-03-17T06:04:38Z [INFO][NRF][DSCV] Handle NFDiscoveryRequest
nrf | 2022-03-17T06:04:38Z [INFO][NRF][GIN] | 200 | 10.100.200.102 | GET | /nnrf-disc/v1/nf-instances?dnn=internet&preferred-locality=area1&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 |
amf | 2022-03-17T06:04:41Z [ERRO][AMF][GMM][AMF_UE_NGAP_ID:84][SUPI:imsi-208930000000003] CreateSmContextRequest Error: server no response
Then the UE side keep logging：
UERANSIM v3.2.6
[2022-03-17 02:00:34.881] [nas] [info] UE switches to state [MM-DEREGISTERED/PLMN-SEARCH]
[2022-03-17 02:00:34.881] [rrc] [debug] New signal detected for cell[1], total [1] cells in coverage
[2022-03-17 02:00:34.881] [nas] [info] Selected plmn[208/93]
[2022-03-17 02:00:34.881] [rrc] [info] Selected cell plmn[208/93] tac[1] category[SUITABLE]
[2022-03-17 02:00:34.881] [nas] [info] UE switches to state [MM-DEREGISTERED/PS]
[2022-03-17 02:00:34.881] [nas] [info] UE switches to state [MM-DEREGISTERED/NORMAL-SERVICE]
[2022-03-17 02:00:34.881] [nas] [debug] Initial registration required due to [MM-DEREG-NORMAL-SERVICE]
[2022-03-17 02:00:34.881] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:00:34.881] [nas] [debug] Sending Initial Registration
[2022-03-17 02:00:34.881] [nas] [info] UE switches to state [MM-REGISTER-INITIATED]
[2022-03-17 02:00:34.881] [rrc] [debug] Sending RRC Setup Request
[2022-03-17 02:00:34.882] [rrc] [info] RRC connection established
[2022-03-17 02:00:34.882] [rrc] [info] UE switches to state [RRC-CONNECTED]
[2022-03-17 02:00:34.882] [nas] [info] UE switches to state [CM-CONNECTED]
[2022-03-17 02:00:34.920] [nas] [debug] Authentication Request received
[2022-03-17 02:00:34.937] [nas] [debug] Security Mode Command received
[2022-03-17 02:00:34.937] [nas] [debug] Selected integrity[2] ciphering[0]
[2022-03-17 02:00:35.008] [nas] [debug] Registration accept received
[2022-03-17 02:00:35.008] [nas] [info] UE switches to state [MM-REGISTERED/NORMAL-SERVICE]
[2022-03-17 02:00:35.009] [nas] [debug] Sending Registration Complete
[2022-03-17 02:00:35.009] [nas] [info] Initial Registration is successful
[2022-03-17 02:00:35.009] [nas] [debug] Sending PDU Session Establishment Request
[2022-03-17 02:00:35.009] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:00:51.898] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:00:51.898] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:01:07.914] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:01:07.914] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:01:23.930] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:01:23.930] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:01:39.946] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:01:39.946] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:01:55.962] [nas] [error] PDU Session Establishment procedure failure, no response from the network after 5 attempts
[2022-03-17 02:01:55.962] [nas] [debug] Aborting SM procedure for PTI[1], PSI[1]
[2022-03-17 02:01:56.355] [nas] [debug] Sending PDU Session Establishment Request
[2022-03-17 02:01:56.355] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:02:12.979] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:02:12.979] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:02:28.995] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:02:28.995] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:02:45.011] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:02:45.011] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:03:01.027] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:03:01.027] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:03:17.043] [nas] [error] PDU Session Establishment procedure failure, no response from the network after 5 attempts
[2022-03-17 02:03:17.043] [nas] [debug] Aborting SM procedure for PTI[1], PSI[1]
[2022-03-17 02:03:17.244] [nas] [debug] Sending PDU Session Establishment Request
[2022-03-17 02:03:17.244] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:03:34.060] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:03:34.060] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:03:50.076] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:03:50.076] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:04:06.092] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:04:06.092] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:04:22.108] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:04:22.108] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:04:38.124] [nas] [error] PDU Session Establishment procedure failure, no response from the network after 5 attempts
[2022-03-17 02:04:38.124] [nas] [debug] Aborting SM procedure for PTI[1], PSI[1]
[2022-03-17 02:04:38.202] [nas] [debug] Sending PDU Session Establishment Request
[2022-03-17 02:04:38.202] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:04:55.141] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:04:55.141] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:05:11.157] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:05:11.157] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:05:27.173] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:05:27.173] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
[2022-03-17 02:05:43.189] [nas] [warning] Retransmitting PDU Session Establishment Request due to T3580 expiry
[2022-03-17 02:05:43.189] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig]
Would you mind giving me some advice?
Thank you in advance.
Best,
Ziran