paulmataruso/osmo-hnodeb
1
0
Fork 0
mirror of https://gitea.osmocom.org/cellular-infrastructure/osmo-hnodeb.git synced 2025-10-23 08:22:16 +00:00
Code Issues Packages Projects Releases Wiki Activity

Use osmocom logging in non-main files

Browse Source 
Change-Id: I649b17803aeffd20354aa76dde61094959f08e43
This commit is contained in:
Pau Espin Pedrol
2021-10-28 18:05:28 +02:00
parent 9b5e3d46d0
commit 5b86a80193
7 changed files with 64 additions and 58 deletions
Download Patch File Download Diff File Expand all files Collapse all files

1
include/osmocom/hnodeb/hnodeb.h
View File

@@ -31,6 +31,7 @@ enum {
DHNBAP,
DRUA,
DRANAP,
DNAS,
};
extern const struct log_info hnb_log_info;

19
src/osmo-hnodeb/debug.c
View File

@@ -23,25 +23,30 @@
static const struct log_info_cat log_cat[] = {
[DMAIN] = {
.name = "DMAIN", .loglevel = LOGL_INFO, .enabled = 1,
.name = "DMAIN", .loglevel = LOGL_NOTICE, .enabled = 1,
.color = "",
.description = "Main program",
},
[DHNBAP] = {
.name = "DHNBAP", .loglevel = LOGL_DEBUG, .enabled = 1,
.color = "",
.name = "DHNBAP", .loglevel = LOGL_NOTICE, .enabled = 1,
.color = "\033[1;33m",
.description = "Home Node B Application Part",
},
[DRANAP] = {
.name = "RANAP", .loglevel = LOGL_DEBUG, .enabled = 1,
.color = "",
.name = "RANAP", .loglevel = LOGL_NOTICE, .enabled = 1,
.color = "\033[1;34m",
.description = "RAN Application Part",
},
[DRUA] = {
.name = "RUA", .loglevel = LOGL_DEBUG, .enabled = 1,
.color = "",
.name = "RUA", .loglevel = LOGL_NOTICE, .enabled = 1,
.color = "\033[1;35m",
.description = "RANAP User Adaptation",
},
[DNAS] = {
.name = "NAS", .loglevel = LOGL_NOTICE, .enabled = 1,
.color = "\033[1;32m",
.description = "Non-Access Stratum",
},
};
const struct log_info hnb_log_info = {

6
src/osmo-hnodeb/hnb.c
View File

@@ -89,11 +89,11 @@ static int hnb_iuh_read_cb(struct osmo_fd *fd)
switch (sinfo.sinfo_ppid) {
case IUH_PPI_HNBAP:
printf("HNBAP message received\n");
LOGP(DHNBAP, LOGL_INFO, "HNBAP message received\n");
rc = hnb_hnbap_rx(hnb, msg);
break;
case IUH_PPI_RUA:
printf("RUA message received\n");
LOGP(DRUA, LOGL_INFO, "RUA message received\n");
rc = hnb_rua_rx(hnb, msg);
break;
case IUH_PPI_SABP:
@@ -123,7 +123,7 @@ static int hnb_iuh_write_cb(struct osmo_fd *fd, struct msgb *msg)
};
int rc;
printf("Sending: %s\n", osmo_hexdump(msgb_data(msg), msgb_length(msg)));
LOGP(DMAIN, LOGL_DEBUG, "Sending: %s\n", osmo_hexdump(msgb_data(msg), msgb_length(msg)));
rc = sctp_send(fd->fd, msgb_data(msg), msgb_length(msg),
&sinfo, 0);
/* we don't need to msgb_free(), write_queue does this for us */

12
src/osmo-hnodeb/hnbap.c
View File

@@ -43,7 +43,7 @@ static int hnb_rx_hnb_register_acc(struct hnb *hnb, ANY_t *in)
}
hnb->rnc_id = accept.rnc_id;
printf("HNB Register accept with RNC ID %u\n", hnb->rnc_id);
LOGP(DHNBAP, LOGL_INFO, "HNB Register accept with RNC ID %u\n", hnb->rnc_id);
hnbap_free_hnbregisteraccepties(&accept);
return 0;
@@ -62,7 +62,7 @@ static int hnb_rx_ue_register_acc(struct hnb *hnb, ANY_t *in)
}
if (accept.uE_Identity.present != HNBAP_UE_Identity_PR_iMSI) {
printf("Wrong type in UE register accept\n");
LOGP(DHNBAP, LOGL_ERROR, "Wrong type in UE register accept\n");
return -1;
}
@@ -70,7 +70,7 @@ static int hnb_rx_ue_register_acc(struct hnb *hnb, ANY_t *in)
ranap_bcd_decode(imsi, sizeof(imsi), accept.uE_Identity.choice.iMSI.buf,
accept.uE_Identity.choice.iMSI.size);
printf("UE Register accept for IMSI %s, context %u\n", imsi, ctx_id);
LOGP(DHNBAP, LOGL_INFO, "UE Register accept for IMSI %s, context %u\n", imsi, ctx_id);
hnb->ctx_id = ctx_id;
hnbap_free_ueregisteraccepties(&accept);
@@ -93,7 +93,7 @@ int hnb_hnbap_rx(struct hnb *hnb, struct msgb *msg)
}
if (pdu->present != HNBAP_HNBAP_PDU_PR_successfulOutcome) {
printf("Unexpected HNBAP message received\n");
LOGP(DHNBAP, LOGL_ERROR, "Unexpected HNBAP message received\n");
}
switch (pdu->choice.successfulOutcome.procedureCode) {
@@ -183,7 +183,7 @@ void hnb_send_register_req(struct hnb *hnb)
memset(&request_out, 0, sizeof(request_out));
rc = hnbap_encode_hnbregisterrequesties(&request_out, &request);
if (rc < 0) {
printf("Could not encode HNB register request IEs\n");
LOGP(DHNBAP, LOGL_ERROR, "Could not encode HNB register request IEs\n");
}
msg = hnbap_generate_initiating_message(HNBAP_ProcedureCode_id_HNBRegister,
@@ -212,7 +212,7 @@ void hnb_send_deregister_req(struct hnb *hnb)
memset(&request_out, 0, sizeof(request_out));
rc = hnbap_encode_hnbde_registeries(&request_out, &request);
if (rc < 0) {
printf("Could not encode HNB deregister request IEs\n");
LOGP(DHNBAP, LOGL_ERROR, "Could not encode HNB deregister request IEs\n");
}
msg = hnbap_generate_initiating_message(HNBAP_ProcedureCode_id_HNBDe_Register,

36
src/osmo-hnodeb/nas.c
View File

@@ -87,7 +87,7 @@ static struct tlv_parsed *parse_mm(struct gsm48_hdr *gh, int len)
parse_res = tlv_parse(&tp, &gsm48_mm_att_tlvdef, &gh->data[0], len, 0, 0);
if (parse_res <= 0) {
uint8_t msg_type = gsm48_hdr_msg_type(gh);
printf("Error parsing MM message 0x%hhx: %d\n", msg_type, parse_res);
LOGP(DNAS, LOGL_ERROR, "Error parsing MM message 0x%hhx: %d\n", msg_type, parse_res);
return NULL;
}
@@ -96,14 +96,14 @@ static struct tlv_parsed *parse_mm(struct gsm48_hdr *gh, int len)
int hnb_nas_rx_lu_accept(struct gsm48_hdr *gh, int len, int *sent_tmsi)
{
printf(" :D Location Update Accept :D\n");
LOGP(DNAS, LOGL_INFO, " :D Location Update Accept :D\n");
struct gsm48_loc_area_id *lai;
lai = (struct gsm48_loc_area_id *)&gh->data[0];
struct osmo_location_area_id laid;
gsm48_decode_lai2(lai, &laid);
printf("LU: mcc %s mnc %s lac %hd\n",
LOGP(DNAS, LOGL_INFO, "LU: mcc %s mnc %s lac %hd\n",
osmo_mcc_name(laid.plmn.mcc), osmo_mnc_name(laid.plmn.mnc, laid.plmn.mnc_3_digits),
laid.lac);
@@ -113,7 +113,7 @@ int hnb_nas_rx_lu_accept(struct gsm48_hdr *gh, int len, int *sent_tmsi)
len -= (const char *)&gh->data[0] - (const char *)gh;
parse_res = tlv_parse(&tp, &gsm48_mm_att_tlvdef, &gh->data[0], len, 0, 0);
if (parse_res <= 0) {
printf("Error parsing Location Update Accept message: %d\n", parse_res);
LOGP(DNAS, LOGL_ERROR, "Error parsing Location Update Accept message: %d\n", parse_res);
return -1;
}
@@ -128,7 +128,7 @@ int hnb_nas_rx_lu_accept(struct gsm48_hdr *gh, int len, int *sent_tmsi)
void hnb_nas_rx_mm_info(struct gsm48_hdr *gh, int len)
{
printf(" :) MM Info :)\n");
LOGP(DNAS, LOGL_INFO, " :) MM Info :)\n");
struct tlv_parsed *tp = parse_mm(gh, len);
if (!tp)
return;
@@ -138,7 +138,7 @@ void hnb_nas_rx_mm_info(struct gsm48_hdr *gh, int len)
gsm_7bit_decode_n(name, 127,
TLVP_VAL(tp, GSM48_IE_NAME_SHORT)+1,
(TLVP_LEN(tp, GSM48_IE_NAME_SHORT)-1)*8/7);
printf("Info: Short Network Name: %s\n", name);
LOGP(DNAS, LOGL_INFO, "Info: Short Network Name: %s\n", name);
}
if (TLVP_PRESENT(tp, GSM48_IE_NAME_LONG)) {
@@ -146,7 +146,7 @@ void hnb_nas_rx_mm_info(struct gsm48_hdr *gh, int len)
gsm_7bit_decode_n(name, 127,
TLVP_VAL(tp, GSM48_IE_NAME_LONG)+1,
(TLVP_LEN(tp, GSM48_IE_NAME_LONG)-1)*8/7);
printf("Info: Long Network Name: %s\n", name);
LOGP(DNAS, LOGL_INFO, "Info: Long Network Name: %s\n", name);
}
}
@@ -158,11 +158,11 @@ static int hnb_nas_rx_auth_req(struct hnb *hnb, struct gsm48_hdr *gh,
len -= (const char *)&gh->data[0] - (const char *)gh;
if (len < sizeof(*ar)) {
printf("GSM48 Auth Req does not fit.\n");
LOGP(DNAS, LOGL_ERROR, "GSM48 Auth Req does not fit.\n");
return -1;
}
printf(" :) Authentication Request :)\n");
LOGP(DNAS, LOGL_INFO, " :) Authentication Request :)\n");
ar = (struct gsm48_auth_req*) &gh->data[0];
int seq = ar->key_seq;
@@ -183,9 +183,9 @@ static int hnb_nas_rx_auth_req(struct hnb *hnb, struct gsm48_hdr *gh,
memset(&vec, 0, sizeof(vec));
osmo_auth_gen_vec(&vec, &auth, ar->rand);
printf("seq %d rand %s",
LOGP(DNAS, LOGL_DEBUG, "seq %d rand %s",
seq, osmo_hexdump(ar->rand, sizeof(ar->rand)));
printf(" --> sres %s\n",
LOGP(DNAS, LOGL_DEBUG, " --> sres %s\n",
osmo_hexdump(vec.sres, 4));
return hnb_tx_dt(hnb, gen_nas_auth_resp(vec.sres));
@@ -197,7 +197,7 @@ static int hnb_nas_rx_mm(struct hnb *hnb, struct gsm48_hdr *gh, int len)
chan = hnb->cs.chan;
if (!chan) {
printf("hnb_nas_rx_mm(): No CS channel established yet.\n");
LOGP(DNAS, LOGL_ERROR, "hnb_nas_rx_mm(): No CS channel established yet.\n");
return -1;
}
@@ -219,7 +219,7 @@ static int hnb_nas_rx_mm(struct hnb *hnb, struct gsm48_hdr *gh, int len)
return 0;
case GSM48_MT_MM_LOC_UPD_REJECT:
printf("Received Location Update Reject\n");
LOGP(DNAS, LOGL_INFO, "Received Location Update Reject\n");
return 0;
case GSM48_MT_MM_INFO:
@@ -231,7 +231,7 @@ static int hnb_nas_rx_mm(struct hnb *hnb, struct gsm48_hdr *gh, int len)
return hnb_nas_rx_auth_req(hnb, gh, len);
default:
printf("04.08 message type not handled by hnb-test: 0x%x\n",
LOGP(DNAS, LOGL_INFO, "04.08 message type not handled by hnb-test: 0x%x\n",
msg_type);
return 0;
}
@@ -241,14 +241,14 @@ static int hnb_nas_rx_mm(struct hnb *hnb, struct gsm48_hdr *gh, int len)
void hnb_nas_rx_dtap(struct hnb *hnb, void *data, int len)
{
int rc;
printf("got %d bytes: %s\n", len, osmo_hexdump(data, len));
LOGP(DNAS, LOGL_INFO, "got %d bytes: %s\n", len, osmo_hexdump(data, len));
// nas_pdu == '05 08 12' ==> IMEI Identity request
// '05 04 0d' ==> LU reject
struct gsm48_hdr *gh = data;
if (len < sizeof(*gh)) {
printf("hnb_nas_rx_dtap(): NAS PDU is too short: %d. Ignoring.\n",
LOGP(DNAS, LOGL_ERROR, "hnb_nas_rx_dtap(): NAS PDU is too short: %d. Ignoring.\n",
len);
return;
}
@@ -258,10 +258,10 @@ void hnb_nas_rx_dtap(struct hnb *hnb, void *data, int len)
case GSM48_PDISC_MM:
rc = hnb_nas_rx_mm(hnb, gh, len);
if (rc != 0)
printf("Error receiving MM message: %d\n", rc);
LOGP(DNAS, LOGL_ERROR, "Error receiving MM message: %d\n", rc);
return;
default:
printf("04.08 discriminator not handled by hnb-test: %d\n",
LOGP(DNAS, LOGL_NOTICE, "04.08 discriminator not handled by hnb-test: %d\n",
pdisc);
return;
}

18
src/osmo-hnodeb/ranap.c
View File

@@ -35,7 +35,7 @@ static const char *printstr(OCTET_STRING_t *s)
}
#define PP(octet_string_t) \
printf(#octet_string_t " = %s\n",\
LOGP(DRANAP, LOGL_INFO, #octet_string_t " = %s\n",\
printstr(&octet_string_t))
void hnb_rua_dt_handle_ranap(struct hnb *hnb,
@@ -46,12 +46,12 @@ void hnb_rua_dt_handle_ranap(struct hnb *hnb,
RANAP_PermittedIntegrityProtectionAlgorithms_t *algs;
RANAP_IntegrityProtectionAlgorithm_t *first_alg;
printf("rx ranap_msg->procedureCode %d\n",
LOGP(DRANAP, LOGL_INFO, "rx ranap_msg->procedureCode %d\n",
ranap_msg->procedureCode);
switch (ranap_msg->procedureCode) {
case RANAP_ProcedureCode_id_DirectTransfer:
printf("rx DirectTransfer: presence = %hx\n",
LOGP(DRANAP, LOGL_INFO, "rx DirectTransfer: presence = %hx\n",
ranap_msg->msg.directTransferIEs.presenceMask);
PP(ranap_msg->msg.directTransferIEs.nas_pdu);
@@ -62,14 +62,14 @@ void hnb_rua_dt_handle_ranap(struct hnb *hnb,
return;
case RANAP_ProcedureCode_id_SecurityModeControl:
printf("rx SecurityModeControl: presence = %hx\n",
LOGP(DRANAP, LOGL_INFO, "rx SecurityModeControl: presence = %hx\n",
ranap_msg->msg.securityModeCommandIEs.presenceMask);
/* Just pick the first available IP alg, don't care about
* encryption (yet?) */
algs = &ranap_msg->msg.securityModeCommandIEs.integrityProtectionInformation.permittedAlgorithms;
if (algs->list.count < 1) {
printf("Security Mode Command: No permitted algorithms.\n");
LOGP(DRANAP, LOGL_INFO, "Security Mode Command: No permitted algorithms.\n");
return;
}
first_alg = *algs->list.array;
@@ -88,7 +88,7 @@ void hnb_rua_cl_handle_ranap(struct hnb *hnb,
{
char imsi[16];
printf("rx ranap_msg->procedureCode %d\n",
LOGP(DRANAP, LOGL_INFO, "rx ranap_msg->procedureCode %d\n",
ranap_msg->procedureCode);
switch (ranap_msg->procedureCode) {
@@ -99,7 +99,7 @@ void hnb_rua_cl_handle_ranap(struct hnb *hnb,
ranap_msg->msg.pagingIEs.permanentNAS_UE_ID.choice.iMSI.size);
} else imsi[0] = '\0';
printf("rx Paging: presence=%hx domain=%ld IMSI=%s\n",
LOGP(DRANAP, LOGL_INFO, "rx Paging: presence=%hx domain=%ld IMSI=%s\n",
ranap_msg->msg.pagingIEs.presenceMask,
ranap_msg->msg.pagingIEs.cN_DomainIndicator,
imsi
@@ -158,7 +158,7 @@ void hnb_tx_iu_release_compl(struct hnb *hnb)
void hnb_rx_secmode_cmd(struct hnb *hnb, long ip_alg)
{
printf(" :) Security Mode Command :)\n");
LOGP(DRANAP, LOGL_INFO, " :) Security Mode Command :)\n");
/* not caring about encryption yet, just pass 0 for No Encryption. */
hnb_tx_dt(hnb, ranap_new_msg_sec_mod_compl(ip_alg, 0));
}
@@ -170,6 +170,6 @@ void hnb_rx_iu_release(struct hnb *hnb)
void hnb_rx_paging(struct hnb *hnb, const char *imsi)
{
printf(" :) Paging Request for %s :)\n", imsi);
LOGP(DRANAP, LOGL_INFO, " :) Paging Request for %s :)\n", imsi);
/* TODO reply */
}

30
src/osmo-hnodeb/rua.c
View File

@@ -36,7 +36,7 @@ int hnb_tx_dt(struct hnb *hnb, struct msgb *txm)
chan = hnb->cs.chan;
if (!chan) {
printf("hnb_nas_tx_tmsi_realloc_compl(): No CS channel established yet.\n");
LOGP(DRUA, LOGL_INFO, "hnb_nas_tx_tmsi_realloc_compl(): No CS channel established yet.\n");
return -1;
}
@@ -52,7 +52,7 @@ static void hnb_rua_dt_handle(struct hnb *hnb, ANY_t *in)
rc = rua_decode_directtransferies(&ies, in);
if (rc < 0) {
printf("failed to decode RUA DT IEs\n");
LOGP(DRUA, LOGL_INFO, "failed to decode RUA DT IEs\n");
return;
}
@@ -69,7 +69,7 @@ static void hnb_rua_cl_handle(struct hnb *hnb, ANY_t *in)
rc = rua_decode_connectionlesstransferies(&ies, in);
if (rc < 0) {
printf("failed to decode RUA CL IEs\n");
LOGP(DRUA, LOGL_INFO, "failed to decode RUA CL IEs\n");
return;
}
@@ -94,45 +94,45 @@ int hnb_rua_rx(struct hnb *hnb, struct msgb *msg)
switch (pdu->present) {
case RUA_RUA_PDU_PR_successfulOutcome:
printf("RUA_RUA_PDU_PR_successfulOutcome\n");
LOGP(DRUA, LOGL_INFO, "RUA_RUA_PDU_PR_successfulOutcome\n");
break;
case RUA_RUA_PDU_PR_initiatingMessage:
printf("RUA_RUA_PDU_PR_initiatingMessage\n");
LOGP(DRUA, LOGL_INFO, "RUA_RUA_PDU_PR_initiatingMessage\n");
break;
case RUA_RUA_PDU_PR_NOTHING:
printf("RUA_RUA_PDU_PR_NOTHING\n");
LOGP(DRUA, LOGL_INFO, "RUA_RUA_PDU_PR_NOTHING\n");
break;
case RUA_RUA_PDU_PR_unsuccessfulOutcome:
printf("RUA_RUA_PDU_PR_unsuccessfulOutcome\n");
LOGP(DRUA, LOGL_INFO, "RUA_RUA_PDU_PR_unsuccessfulOutcome\n");
break;
default:
printf("Unexpected RUA message received\n");
LOGP(DRUA, LOGL_INFO, "Unexpected RUA message received\n");
break;
}
switch (pdu->choice.successfulOutcome.procedureCode) {
case RUA_ProcedureCode_id_ConnectionlessTransfer:
printf("RUA rx Connectionless Transfer\n");
LOGP(DRUA, LOGL_INFO, "RUA rx Connectionless Transfer\n");
hnb_rua_cl_handle(hnb, &pdu->choice.successfulOutcome.value);
break;
case RUA_ProcedureCode_id_Connect:
printf("RUA rx Connect\n");
LOGP(DRUA, LOGL_INFO, "RUA rx Connect\n");
break;
case RUA_ProcedureCode_id_DirectTransfer:
printf("RUA rx DirectTransfer\n");
LOGP(DRUA, LOGL_INFO, "RUA rx DirectTransfer\n");
hnb_rua_dt_handle(hnb, &pdu->choice.successfulOutcome.value);
break;
case RUA_ProcedureCode_id_Disconnect:
printf("RUA rx Disconnect\n");
LOGP(DRUA, LOGL_INFO, "RUA rx Disconnect\n");
break;
case RUA_ProcedureCode_id_ErrorIndication:
printf("RUA rx ErrorIndication\n");
LOGP(DRUA, LOGL_INFO, "RUA rx ErrorIndication\n");
break;
case RUA_ProcedureCode_id_privateMessage:
printf("RUA rx privateMessage\n");
LOGP(DRUA, LOGL_INFO, "RUA rx privateMessage\n");
break;
default:
printf("RUA rx unknown message\n");
LOGP(DRUA, LOGL_INFO, "RUA rx unknown message\n");
break;
}