08. Epc mme 로그확인 방법 - netipark/t_lte GitHub Wiki
EPC MME 로그확인 방법
1. SSH 접속
User name : root
Passphrase : epc
2. screen 명령으로 로그화면 진입
# screen -r mme
3. Attach 결과 확인
14( 1423) 1:34:02 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
14( 1423) 1:34:02 INFO mme_s1ap_recv_INITIAL_UE_MESSAGE():54> Received an S1AP Initial UE Message
14( 1423) 1:34:02 INFO mme_session_find_by_enb_s1ap_id():332> Session index not found
14( 1423) 1:34:02 INFO mme_emm_ATTACH_REQUEST_process():1548> Processing EMM Attach Request
14( 1423) 1:34:02 INFO mme_emm_ATTACH_REQUEST_process():1609> Storing message
14( 1423) 1:34:02 INFO mme_emm_ATTACH_REQUEST_process():1616>
[15] Session EMM: [2:REGISTERED] => [0:DEREGISTERED]
14( 1423) 1:34:02 INFO mme_emm_ATTACH_REQUEST_process():1676>
[15] EPS Attach Type: [1:EPS-Attach] => [1:EPS-Attach]
14( 1423) 1:34:02 INFO mme_emm_ATTACH_REQUEST_process():1724> Attach Request with GUTI received, but not integrity protected
14( 1423) 1:34:02 INFO mme_sm():2886> Started SM
14( 1423) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [4:S1][0:NONE]
| Piggybacked: [1:NAS][43:PDN_connectivity_request]
| S1AP: [0:NONE]
+------------------
14( 1423) 1:34:02 INFO mme_sm_INITIAL_ATTACH():408> UE is not identified
14( 1423) 1:34:02 INFO mme_emm_IDENTITY_PROCEDURE_trigger():742>
[15] Session EMM: [0:DEREGISTERED] => [1:COMMON_PROCEDURE_INITIATED]
14( 1423) 1:34:02 INFO mme_emm_IDENTITY_REQUEST_prepare():693> Preparing the NAS Identity Request message
14( 1423) 1:34:02 INFO mme_emm_IDENTITY_REQUEST_prepare():721> Encoded the NAS Identity Request message
14( 1423) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():190> Preparing the S1AP Downlink NAS Transport message
14( 1423) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():218> Successfully sent the S1AP Downlink NAS Transport message
14( 1423) 1:34:02 INFO mme_s1ap_recv_INITIAL_UE_MESSAGE():164> Successfully processed the S1AP Initial UE Message message
14( 1423) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 1231 bytes
10( 1363) 1:34:02 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
10( 1363) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():247> Received an S1AP Uplink NAS Transport message
10( 1363) 1:34:02 INFO mme_emm_IDENTITY_RESPONSE_parse():799> Processing the NAS Identity Response message
10( 1363) 1:34:02 INFO mme_emm_IDENTITY_RESPONSE_parse():883> Successfully processed the NAS Identity Response message
10( 1363) 1:34:02 INFO mme_sm():2886> Started SM
10( 1363) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [1:NAS][14:Identity_response]
| NAS: [0:EMM_NONE]
+------------------
10( 1363) 1:34:02 INFO mme_sm_INITIAL_ATTACH():467> UE is not authenticated
10( 1363) 1:34:02 INFO mme_emm_AUTHENTICATION_PROCEDURE_trigger():181>
[15] Session EMM: [1:COMMON_PROCEDURE_INITIATED] => [1:COMMON_PROCEDURE_INITIATED]
10( 1363) 1:34:02 INFO mme_emm_AUTHENTICATION_PROCEDURE_trigger():197> Triggering EMM Authentication Procedure
10( 1363) 1:34:02 INFO mme_emm_AUTHENTICATION_PROCEDURE_trigger():207> Using Authentication Vector 3 (0 vectors remaining)
10( 1363) 1:34:02 INFO mme_emm_AUTHENTICATION_REQUEST_prepare():67> Preparing the NAS Authentication Request message
10( 1363) 1:34:02 INFO mme_emm_AUTHENTICATION_REQUEST_prepare():83> Encoded the NAS Authentication Request message
10( 1363) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():190> Preparing the S1AP Downlink NAS Transport message
10( 1363) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():218> Successfully sent the S1AP Downlink NAS Transport message
10( 1363) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():337> Successfully processed the S1AP Uplink NAS Transport message
10( 1363) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 1154 bytes
15( 1444) 1:34:02 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
15( 1444) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():247> Received an S1AP Uplink NAS Transport message
15( 1444) 1:34:02 INFO mme_emm_AUTHENTICATION_RESPONSE_parse():362> Processing the NAS Authentication Response message
15( 1444) 1:34:02 INFO mme_emm_AUTHENTICATION_RESPONSE_parse():411> Authentication successful. Proceeding with security mode command
15( 1444) 1:34:02 INFO mme_sm():2886> Started SM
15( 1444) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [1:NAS][6:Authentication_response]
| NAS: [0:EMM_NONE]
+------------------
15( 1444) 1:34:02 INFO mme_sm_INITIAL_ATTACH():513> Security Context is not active
15( 1444) 1:34:02 INFO mme_emm_SECURITY_MODE_PROCEDURE_trigger():514>
[15] Session EMM: [1:COMMON_PROCEDURE_INITIATED] => [1:COMMON_PROCEDURE_INITIATED]
15( 1444) 1:34:02 INFO mme_emm_SECURITY_MODE_COMMAND_prepare():451> Preparing the NAS Security Mode Command message
15( 1444) 1:34:02 INFO mme_emm_SECURITY_MODE_COMMAND_prepare():493> Encoded the NAS Security Mode Command message
15( 1444) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():190> Preparing the S1AP Downlink NAS Transport message
15( 1444) 1:34:02 INFO mme_s1ap_send_DOWNLINK_NAS_TRANSPORT():218> Successfully sent the S1AP Downlink NAS Transport message
15( 1444) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():337> Successfully processed the S1AP Uplink NAS Transport message
15( 1444) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 1154 bytes
13( 1407) 1:34:02 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
13( 1407) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():247> Received an S1AP Uplink NAS Transport message
13( 1407) 1:34:02 INFO mme_emm_SECURITY_MODE_COMPLETE_parse():578> Processing the NAS Security Mode Complete message
13( 1407) 1:34:02 INFO mme_emm_SECURITY_MODE_COMPLETE_parse():615> Successfully processed the NAS Security Mode Complete message
13( 1407) 1:34:02 INFO mme_sm():2886> Started SM
13( 1407) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [1:NAS][15:Security_mode_complete]
| NAS: [0:EMM_NONE]
+------------------
13( 1407) 1:34:02 INFO mme_sm_INITIAL_ATTACH():600> Retrieving APN configuration profile
13( 1407) 1:34:02 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():337> Successfully processed the S1AP Uplink NAS Transport message
13( 1407) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 771 bytes
11( 1378) 1:34:02 INFO mme_sm():2886> Started SM
11( 1378) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [3:DIAMETER][46:UPDATE_LOCATION_ANSWER]
| Diameter: [0:NONE]
+------------------
11( 1378) 1:34:02 INFO mme_selection_pgw():334> Looking for [default.apn.epc.mnc001.mcc001.3gppnetwork.org]
11( 1378) 1:34:02 INFO mme_gtpc_CREATE_SESSION_REQUEST_trigger():397> Preparing GTPC Create Session Request message
11( 1378) 1:34:02 INFO mme_gtpc_CREATE_SESSION_REQUEST_trigger():794> Successfully sent GTPC Create Session Request message
11( 1378) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 1122 bytes
10( 1363) 1:34:02 INFO gtp_message_receive():944> Received GTP-C message for SEQN [00236001] / TEID [0000000f] matching a previous request...
10( 1363) 1:34:02 INFO mme_gtpc_CREATE_SESSION_REQUEST_transaction_handler():89> Processing GTPC Create Session Response message
10( 1363) 1:34:02 INFO mme_gtpc_CREATE_SESSION_REQUEST_transaction_handler():343> Successfully processed the Create Session Request message
10( 1363) 1:34:02 INFO mme_sm_pdn_log_event():187>
+-------- PDN SM --
|Session with IMSI [901700000015958] index [15]
|PDN with APN [default.apn.epc.mnc001.mcc001.3gppnetwork.org] index [1914896385]
| State: [0:NONE]
| Event: [2:GTP][50:CREATE_SESSION]
| GTP: [0:GTPC_PROCEDURE_NONE]
+------------------
10( 1363) 1:34:02 INFO mme_sm():2886> Started SM
10( 1363) 1:34:02 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [8:ESM][0:NONE]
| Piggybacked: [2:GTP][50:CREATE_SESSION]
+------------------
10( 1363) 1:34:02 INFO mme_sm_INITIAL_ATTACH():661> [15] EPS Attach Type Check: [1:EPS-Attach] checked against [2:Combined-EPS-IMSI-Attach]
10( 1363) 1:34:02 INFO mme_emm_ATTACH_ACCEPT_prepare():359> Preparing the NAS Attach Accept message
10( 1363) 1:34:02 INFO mme_emm_ATTACH_ACCEPT_prepare():364> [15] EPS Attach Type is: [1:EPS-Attach]
10( 1363) 1:34:02 INFO mme_esm_ACTIVATE_DEFAULT_EPS_BEARER_CONTEXT_REQUEST_prepare():406> Preparing the NAS Activate Default EPS Bearer Context Request message
10( 1363) 1:34:02 INFO mme_esm_ACTIVATE_DEFAULT_EPS_BEARER_CONTEXT_REQUEST_prepare():504> Encoded the NAS Activate Default EPS Bearer Context Request message
10( 1363) 1:34:02 INFO mme_s1ap_send_INITIAL_CONTEXT_SETUP_REQUEST():189> Preparing the S1AP Initial Context Setup Request message
10( 1363) 1:34:02 INFO mme_s1ap_send_INITIAL_CONTEXT_SETUP_REQUEST():363> Successfully sent the S1AP Initial Context Setup Request messge
10( 1363) 1:34:02 INFO bin_encode_mme_session():606> Session encoded: 1150 bytes
15( 1444) 1:34:03 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
15( 1444) 1:34:03 INFO mme_s1ap_recv_UE_CAPABILITY_INFORMATION_INDICATION():447> Received an S1AP UE Capability Information Indication
15( 1444) 1:34:03 INFO bin_encode_mme_session():606> Session encoded: 1150 bytes
13( 1407) 1:34:03 INFO s1ap_decode_payload():365> Decoding message payload (successfulOutcome)!
11( 1378) 1:34:03 INFO s1ap_decode_payload():127> Decoding message payload (initiatingMessage)!
11( 1378) 1:34:03 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():247> Received an S1AP Uplink NAS Transport message
13( 1407) 1:34:03 INFO mme_s1ap_recv_INITIAL_CONTEXT_SETUP_RESPONSE():399> Received an S1AP Initial Context Setup Response message
11( 1378) 1:34:03 INFO mme_emm_ATTACH_COMPLETE_parse():502> Processing the NAS Attach Complete message
11( 1378) 1:34:03 INFO mme_emm_ATTACH_COMPLETE_parse():528>
[15] Session EMM: [1:COMMON_PROCEDURE_INITIATED] => [2:REGISTERED]
11( 1378) 1:34:03 INFO mme_esm_ACTIVATE_DEFAULT_EPS_BEARER_CONTEXT_ACCEPT_parse():51> Processing the NAS Activate Default EPS Bearer Context Accept message
11( 1378) 1:34:03 INFO mme_esm_ACTIVATE_DEFAULT_EPS_BEARER_CONTEXT_ACCEPT_parse():65>
[5] Bearer ESM: [0:BEARER_CONTEXT_INACTIVE] => [2:BEARER_CONTEXT_ACTIVE]
11( 1378) 1:34:03 INFO mme_esm_ACTIVATE_DEFAULT_EPS_BEARER_CONTEXT_ACCEPT_parse():74> Successfully processed the NAS Activate Default EPS Bearer Context Accept message
11( 1378) 1:34:03 INFO mme_emm_ATTACH_COMPLETE_parse():545> Successfully parsed the NAS Attach Complete message
11( 1378) 1:34:03 INFO mme_sm():2886> Started SM
11( 1378) 1:34:03 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [1:NAS][3:Attach_complete]
| Piggybacked: [1:NAS][26:Activate_default_EPS_bearer_context_accept]
| NAS: [0:EMM_NONE]
+------------------
11( 1378) 1:34:03 INFO mme_sm_INITIAL_ATTACH():661> [15] EPS Attach Type Check: [1:EPS-Attach] checked against [2:Combined-EPS-IMSI-Attach]
11( 1378) 1:34:03 INFO mme_s1ap_recv_UPLINK_NAS_TRANSPORT():337> Successfully processed the S1AP Uplink NAS Transport message
11( 1378) 1:34:03 INFO bin_encode_mme_session():606> Session encoded: 1150 bytes
13( 1407) 1:34:03 INFO mme_s1ap_recv_INITIAL_CONTEXT_SETUP_RESPONSE():485>
[5] Bearer ERAB: [0:INACTIVE] => [5:ACTIVE]
13( 1407) 1:34:03 INFO mme_s1ap_recv_INITIAL_CONTEXT_SETUP_RESPONSE():498> [15] Flag [MME_SM_FLAG2__S1_CONTEXT_ACTIVE] set to [ON]
13( 1407) 1:34:03 INFO mme_sm():2886> Started SM
13( 1407) 1:34:03 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [4:S1][77:INITIAL_CONTEXT_SETUP_COMPLETE]
| S1AP: [0:NONE]
+------------------
13( 1407) 1:34:03 INFO mme_sm_INITIAL_ATTACH():661> [15] EPS Attach Type Check: [1:EPS-Attach] checked against [2:Combined-EPS-IMSI-Attach]
13( 1407) 1:34:03 INFO mme_sm_INITIAL_ATTACH():681> Sending EMM Information
13( 1407) 1:34:03 INFO mme_sm_INITIAL_ATTACH():692> Updating S1-SGW Bearer
13( 1407) 1:34:03 INFO mme_gtpc_MODIFY_BEARER_REQUEST_send():329> Preparing GTPC Modify Bearer Request message
13( 1407) 1:34:03 INFO mme_gtpc_MODIFY_BEARER_REQUEST_send():534> Successfully sent GTPC Modify Bearer Request message
13( 1407) 1:34:03 INFO mme_s1ap_recv_INITIAL_CONTEXT_SETUP_RESPONSE():514> Successfully processed the S1AP Initial Context Setup Response message
13( 1407) 1:34:03 INFO bin_encode_mme_session():606> Session encoded: 1158 bytes
9( 1359) 1:34:03 INFO gtp_message_receive():944> Received GTP-C message for SEQN [00236002] / TEID [0000000f] matching a previous request...
9( 1359) 1:34:03 INFO mme_gtpc_MODIFY_BEARER_REQUEST_transaction_handler():106> Received a GTP-C Modify Bearer Response
9( 1359) 1:34:03 INFO mme_sm_pdn_log_event():187>
+-------- PDN SM --
|Session with IMSI [901700000015958] index [15]
|PDN with APN [default.apn.epc.mnc001.mcc001.3gppnetwork.org] index [1914896385]
| State: [0:NONE]
| Event: [2:GTP][51:MODIFY_BEARER]
| GTP: [0:GTPC_PROCEDURE_NONE]
+------------------
9( 1359) 1:34:03 INFO mme_sm():2886> Started SM
9( 1359) 1:34:03 INFO mme_sm_log_event():249>
+-------- SM --
|Session with IMSI [901700000015958] index [15]
| State: [1:INITIAL_ATTACH]
| Event: [8:ESM][0:NONE]
| Piggybacked: [2:GTP][51:MODIFY_BEARER]
+------------------
9( 1359) 1:34:03 INFO mme_sm_INITIAL_ATTACH():661> [15] EPS Attach Type Check: [1:EPS-Attach] checked against [2:Combined-EPS-IMSI-Attach]
9( 1359) 1:34:03 INFO mme_sm_INITIAL_ATTACH():681> Sending EMM Information
9( 1359) 1:34:03 INFO mme_sm_INITIAL_ATTACH():701>
[15] Session ECM: [1:IDLE] => [2:CONNECTED]
9( 1359) 1:34:03 INFO mme_sm_INITIAL_ATTACH():713> [15] Flag [MME_SM_FLAG2__CONTEXT_RELEASED] is [OFF]
9( 1359) 1:34:03 NOTI mme_sm_INITIAL_ATTACH():719> Attach procedure completed successfully [901700000015958]
9( 1359) 1:34:03 INFO mme_gtpc_MODIFY_BEARER_REQUEST_transaction_handler():281> Successfully processed GTPC Modify Bearer Response message
9( 1359) 1:34:03 INFO bin_encode_mme_session():606> Session encoded: 1089 bytes