update it

src/mme/emm_handler.c

@@ -115,6 +115,9 @@ void emm_handle_attach_request(
                     &attach_request->ms_network_capability,
                     sizeof(attach_request->ms_network_capability));
 
+            d_info("[NAS] Attach request : UE[%s] --> EMM", 
+                    ue->imsi_bcd);
+
             mme_s6a_send_air(ue);
             break;
         }
@@ -233,6 +236,9 @@ void emm_handle_authentication_response(
             ue->kasme, ue->knas_enc);
     mme_kdf_enb(ue->kasme, ue->ul_count.i32, ue->kenb);
 
+    d_info("[NAS] Security mode command : UE[%s] <-- EMM", 
+            ue->imsi_bcd);
+
     rv = nas_security_encode(&emmbuf, ue, &message);
     d_assert(rv == CORE_OK && emmbuf, return, "emm build error");
 
@@ -260,10 +266,15 @@ void emm_handle_lo_create_session(mme_bearer_t *bearer)
     d_assert(rv == CORE_OK && esmbuf, 
             return, "bearer build error");
 
+    d_info("[NAS] Activate default bearer context request : EMM <-- ESM[%d]",
+            bearer->ebi);
+
     rv = emm_build_attach_accept(&emmbuf, ue, esmbuf);
     d_assert(rv == CORE_OK && emmbuf, 
             pkbuf_free(esmbuf); return, "emm build error");
 
+    d_info("[NAS] Attach accept : UE[%s] <-- EMM", ue->imsi_bcd);
+
     rv = s1ap_build_initial_context_setup_request(&s1apbuf, bearer, emmbuf);
     d_assert(rv == CORE_OK && s1apbuf, 
             pkbuf_free(emmbuf); return, "s1ap build error");

src/mme/emm_sm.c

@@ -68,17 +68,15 @@ void emm_state_operational(fsm_t *s, event_t *e)
             {
                 case MME_EVT_EMM_UE_LO_AUTH_REQ:
                 {
+                     d_info("[NAS] Authentication request : UE[%s] <-- EMM",
+                             ue->imsi_bcd);
                     emm_handle_authentication_request(ue);
-                    d_info("[NAS] Authentication request : UE[%s] <-- EMM",
-                            ue->imsi_bcd);
                     break;
                 }
                 case MME_EVT_EMM_UE_LO_LOCATION_UPDATE:
                 {
                     mme_bearer_t *bearer = mme_bearer_first(ue);
 
-                    d_info("[NAS] Location update : EMM[%s] <-- HSS",
-                            ue->imsi_bcd);
                     while(bearer)
                     {
                         event_t e;
@@ -112,19 +110,12 @@ void emm_state_operational(fsm_t *s, event_t *e)
                 {
                     emm_handle_attach_request(
                             ue, &message->emm.attach_request);
-
-                    d_info("[NAS] Attach request : UE[%s] --> EMM", 
-                            ue->imsi_bcd);
-
                     break;
                 }
                 case NAS_AUTHENTICATION_RESPONSE:
                 {
                     emm_handle_authentication_response(
                             ue, &message->emm.authentication_response);
-
-                    d_info("[NAS] Security mode command : UE[%s] <-- EMM", 
-                            ue->imsi_bcd);
                     break;
                 }
                 case NAS_SECURITY_MODE_COMPLETE:

src/mme/esm_sm.c

@@ -57,9 +57,9 @@ void esm_state_operational(fsm_t *s, event_t *e)
             {
                 case MME_EVT_ESM_BEARER_LO_INFO_REQ:
                 {
-                    esm_handle_lo_information_request(bearer);
                     d_info("[NAS] ESM information request : "
                             "UE[%s] <--- ESM[%d]", ue->imsi_bcd, bearer->pti);
+                    esm_handle_lo_information_request(bearer);
                     break;
                 }
             }
@@ -96,10 +96,10 @@ void esm_state_operational(fsm_t *s, event_t *e)
                     /* FIXME : SGW Selection */
                     bearer->sgw = mme_sgw_first();
 
-                    esm_handle_information_response(
-                            bearer, &message->esm.esm_information_response);
                     d_info("[NAS] ESM information response : "
                             "UE[%s] --> ESM[%d]", ue->imsi_bcd, bearer->pti);
+                    esm_handle_information_response(
+                            bearer, &message->esm.esm_information_response);
                     break;
                 }
                 default:

src/mme/mme_s11_handler.c

@@ -74,6 +74,9 @@ void mme_s11_handle_create_session_response(
     bearer->sgw_s1u_teid = ntohl(sgw_s1u_teid->teid);
     bearer->sgw_s1u_addr = sgw_s1u_teid->ipv4_addr;
 
+    d_info("[GTP] Create Session Response : "
+            "MME[%d] <-- SGW[%d]", ue->mme_s11_teid, ue->sgw_s11_teid);
+
     event_set(&e, MME_EVT_EMM_BEARER_LO_CREATE_SESSION);
     event_set_param1(&e, (c_uintptr_t)bearer->index);
     mme_event_send(&e);

src/pgw/pgw_handler.c

@@ -191,6 +191,9 @@ void pgw_handle_create_session_request(
     bearer->sgw_s5u_teid = ntohl(sgw_s5u_teid->teid);
     bearer->sgw_s5u_addr = sgw_s5u_teid->ipv4_addr;
 
+    d_info("[GTP] Create Session Reqeust : "
+            "SGW[%d] --> PGW", sess->sgw_s5c_teid);
+
     /* Send Control Plane(UL) : PGW-S5C */
     memset(&pgw_s5c_teid, 0, sizeof(gtp_f_teid_t));
     pgw_s5c_teid.ipv4 = 1;

src/sgw/sgw_handler.c

@@ -90,6 +90,8 @@ void sgw_handle_create_session_request(
 
     d_assert(sgw_s5c_send_to_pgw(xact, type, 0, pkbuf) == CORE_OK, 
             return, "failed to send message");
+    d_info("[GTP] Create Session Reqeust : "
+            "MME[%d] --> SGW", sess->mme_s11_teid);
 }
 
 void sgw_handle_create_session_response(gtp_xact_t *xact, 
@@ -177,4 +179,6 @@ void sgw_handle_create_session_response(gtp_xact_t *xact,
     d_assert(sgw_s11_send_to_mme(
             xact, type, sess->mme_s11_teid, pkbuf) == CORE_OK, return, 
             "failed to send message");
+    d_info("[GTP] Create Session Response : "
+            "SGW[%d] <-- PGW[%d]", sess->sgw_s5c_teid, sess->pgw_s5c_teid);
 }

src/sgw/sgw_sm.c

@@ -79,6 +79,7 @@ void sgw_state_operational(fsm_t *s, event_t *e)
             {
                 sgw_handle_create_session_request(xact, type, &gtp_message);
                 pkbuf_free(pkbuf);
+
                 break;
             }