Browse Source

cdp: remove level and function name from log messages

Victor Seva 7 months ago
parent
commit
e8389b36af

+ 37 - 58
src/modules/cdp/authstatemachine.c

@@ -79,8 +79,7 @@ int get_auth_session_state(AAAMessage *msg)
 	return get_4bytes(rc->data.s);
 
 error:
-	LM_DBG("get_auth_session_state(): no AAAMessage or Auth Session State not "
-		   "found\n");
+	LM_DBG("no AAAMessage or Auth Session State not found\n");
 	return STATE_MAINTAINED;
 }
 
@@ -281,9 +280,7 @@ int auth_client_statefull_sm_process(
 				Send_ASA(0, msg);
 				break;
 			default:
-				LM_ERR("auth_client_statefull_sm_process(): Received invalid "
-					   "event %d with no session!\n",
-						event);
+				LM_ERR("Received invalid event %d with no session!\n", event);
 		}
 		return rv;
 	}
@@ -293,7 +290,7 @@ int auth_client_statefull_sm_process(
 		(s->cb)(event, s);
 	LM_INFO("after callback of event %i\n", event);
 
-	//if (x && x->state && msg) LM_ERR("auth_client_statefull_sm_process [event %i] [state %i] endtoend %u hopbyhop %u\n",event,x->state,msg->endtoendId,msg->hopbyhopId);
+	//if (x && x->state && msg) LM_ERR("[event %i] [state %i] endtoend %u hopbyhop %u\n",event,x->state,msg->endtoendId,msg->hopbyhopId);
 
 	switch(x->state) {
 		case AUTH_ST_IDLE:
@@ -321,16 +318,15 @@ int auth_client_statefull_sm_process(
 				/* Just in case we have some lost sessions */
 				case AUTH_EV_SESSION_TIMEOUT:
 				case AUTH_EV_SESSION_GRACE_TIMEOUT:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "TIMEOUT - clean up session to avoid stale "
+					LM_ERR("Received TIMEOUT - clean up session to avoid stale "
 						   "sessions\n");
 					cdp_session_cleanup(s, msg);
 					s = 0;
 					break;
 
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!(data %p)\n",
+					LM_ERR("Received invalid event %d while in state %s!(data "
+						   "%p)\n",
 							event, auth_states[x->state], x->generic_data);
 			}
 			break;
@@ -368,8 +364,7 @@ int auth_client_statefull_sm_process(
 					break;
 
 				default:
-					LM_ERR("auth_client_stateless_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -397,15 +392,13 @@ int auth_client_statefull_sm_process(
 					break;
 
 				case AUTH_EV_SEND_ANS:
-					LM_DBG("auth_client_statefull_sm_process(): Sending "
-						   "answer while in state %s\n",
+					LM_DBG("Sending answer while in state %s\n",
 							auth_states[x->state]);
 					break;
 
 
 				case AUTH_EV_RECV_REQ:
-					LM_DBG("auth_client_statefull_sm_process(): Received "
-						   "request while in state %s\n",
+					LM_DBG("Received request while in state %s\n",
 							auth_states[x->state]);
 					break;
 
@@ -446,8 +439,7 @@ int auth_client_statefull_sm_process(
 					break;
 
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -481,15 +473,13 @@ int auth_client_statefull_sm_process(
 					break;
 
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
 		default:
-			LM_ERR("auth_client_statefull_sm_process(): Received event %d "
-				   "while in invalid state %d!\n",
-					event, x->state);
+			LM_ERR("Received event %d while in invalid state %d!\n", event,
+					x->state);
 	}
 	if(s) {
 		if(s->cb)
@@ -552,8 +542,7 @@ void auth_server_statefull_sm_process(
 					break;
 
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -600,8 +589,7 @@ void auth_server_statefull_sm_process(
 					s = 0;
 					break;
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -626,16 +614,14 @@ void auth_server_statefull_sm_process(
 					s = 0;
 					break;
 				default:
-					LM_ERR("auth_client_statefull_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
 
 		default:
-			LM_ERR("auth_client_statefull_sm_process(): Received event %d "
-				   "while in invalid state %d!\n",
-					event, x->state);
+			LM_ERR("Received event %d while in invalid state %d!\n", event,
+					x->state);
 	}
 	if(s) {
 		if(s->cb)
@@ -666,8 +652,7 @@ void auth_client_stateless_sm_process(
 					x->state = AUTH_ST_PENDING;
 					break;
 				default:
-					LM_ERR("auth_client_stateless_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -689,8 +674,7 @@ void auth_client_stateless_sm_process(
 					x->state = AUTH_ST_IDLE;
 					break;
 				default:
-					LM_ERR("auth_client_stateless_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
@@ -704,16 +688,14 @@ void auth_client_stateless_sm_process(
 					x->state = AUTH_ST_IDLE;
 					break;
 				default:
-					LM_ERR("auth_client_stateless_sm_process(): Received "
-						   "invalid event %d while in state %s!\n",
+					LM_ERR("Received invalid event %d while in state %s!\n",
 							event, auth_states[x->state]);
 			}
 			break;
 
 		default:
-			LM_ERR("auth_client_stateless_sm_process(): Received event %d "
-				   "while in invalid state %d!\n",
-					event, x->state);
+			LM_ERR("Received event %d while in invalid state %d!\n", event,
+					x->state);
 	}
 	if(s)
 		AAASessionsUnlock(s->hash);
@@ -740,12 +722,12 @@ void auth_server_stateless_sm_process(
 	   case AUTH_ST_IDLE:
 	   switch(event){
 	   default:
-	   LM_ERR("auth_server_stateless_sm_process(): Received invalid event %d while in state %s!\n",
+	   LM_ERR("Received invalid event %d while in state %s!\n",
 	   event,auth_state[x->state]);
 	   }
 	   break;
 	   default:
-	   LM_ERR("auth_server_stateless_sm_process(): Received event %d while in invalid state %d!\n",
+	   LM_ERR("Received event %d while in invalid state %d!\n",
 	   event,x->state);
 	   }
 	   */
@@ -769,17 +751,17 @@ int dup_routing_avps(AAAMessage *src, AAAMessage *dest)
 	/* Removed By Jason to facilitate use of Diameter clustering (MUX) in SLEE architecture (Realm-routing only) - TODO - check spec */
 	/*avp = AAAFindMatchingAVP(src,src->avpList.head,AVP_Origin_Host,0,AAA_FORWARD_SEARCH);
 	  if(avp && avp->data.s && avp->data.len) {
-	  LM_DBG("dup_routing_avps: Origin Host AVP present, duplicating %.*s\n",
+	  LM_DBG("Origin Host AVP present, duplicating %.*s\n",
 	  avp->data.len, avp->data.s);
 	  dest_host = avp->data;
 	  avp = AAACreateAVP(AVP_Destination_Host,AAA_AVP_FLAG_MANDATORY,0,
 	  dest_host.s,dest_host.len,AVP_DUPLICATE_DATA);
 	  if (!avp) {
-	  LM_ERR("dup_routing_avps: Failed creating Destination Host avp\n");
+	  LM_ERR("Failed creating Destination Host avp\n");
 	  goto error;
 	  }
 	  if (AAAAddAVPToMessage(dest,avp,dest->avpList.tail)!=AAA_ERR_SUCCESS) {
-	  LM_ERR("dup_routing_avps: Failed adding Destination Host avp to message\n");
+	  LM_ERR("Failed adding Destination Host avp to message\n");
 	  AAAFreeAVP(&avp);
 	  goto error;
 	  }
@@ -788,8 +770,8 @@ int dup_routing_avps(AAAMessage *src, AAAMessage *dest)
 	avp = AAAFindMatchingAVP(
 			src, src->avpList.head, AVP_Origin_Realm, 0, AAA_FORWARD_SEARCH);
 	if(avp && avp->data.s && avp->data.len) {
-		LM_DBG("dup_routing_avps: Origin Realm AVP present, duplicating %.*s\n",
-				avp->data.len, avp->data.s);
+		LM_DBG("Origin Realm AVP present, duplicating %.*s\n", avp->data.len,
+				avp->data.s);
 		dest_realm = avp->data;
 		avp2 = AAAFindMatchingAVP(src, src->avpList.head, AVP_Destination_Realm,
 				0, AAA_FORWARD_SEARCH);
@@ -797,14 +779,12 @@ int dup_routing_avps(AAAMessage *src, AAAMessage *dest)
 			avp = AAACreateAVP(AVP_Destination_Realm, AAA_AVP_FLAG_MANDATORY, 0,
 					dest_realm.s, dest_realm.len, AVP_DUPLICATE_DATA);
 			if(!avp) {
-				LM_ERR("dup_routing_avps: Failed creating Destination Realm "
-					   "avp\n");
+				LM_ERR("Failed creating Destination Realm avp\n");
 				goto error;
 			}
 			if(AAAAddAVPToMessage(dest, avp, dest->avpList.tail)
 					!= AAA_ERR_SUCCESS) {
-				LM_ERR("dup_routing_avps: Failed adding Destination Realm avp "
-					   "to message\n");
+				LM_ERR("Failed adding Destination Realm avp to message\n");
 				AAAFreeAVP(&avp);
 				goto error;
 			}
@@ -821,7 +801,7 @@ void Send_ASA(cdp_session_t *s, AAAMessage *msg)
 	AAAMessage *asa;
 	char x[4];
 	AAA_AVP *avp;
-	LM_INFO("Send_ASA():  sending ASA\n");
+	LM_INFO("sending ASA\n");
 	if(!s) {
 		//send an ASA for UNKNOWN_SESSION_ID - use AAASendMessage()
 		// msg is the ASR received
@@ -861,7 +841,7 @@ void Send_ASA(cdp_session_t *s, AAAMessage *msg)
 				LM_INFO("success sending ASA\n");
 			}
 		} else if(!AAASendMessage(asa, 0, 0)) {
-			LM_ERR("Send_ASA() : error sending ASA\n");
+			LM_ERR("error sending ASA\n");
 		}
 	}
 }
@@ -924,19 +904,18 @@ void Send_STR(cdp_session_t *s, AAAMessage *msg)
 	str = AAACreateRequest(s->application_id, IMS_STR, Flag_Proxyable, s);
 
 	if(!str) {
-		LM_ERR("Send_STR(): error creating STR!\n");
+		LM_ERR("error creating STR!\n");
 		return;
 	}
 	if(!dup_routing_avps(msg, str)) {
-		LM_ERR("Send_STR(): error duplicating routing AVPs!\n");
+		LM_ERR("error duplicating routing AVPs!\n");
 		AAAFreeMessage(&str);
 		return;
 	}
 	if(s->vendor_id != 0
 			&& !add_vendor_specific_application_id_group(
 					str, s->vendor_id, s->application_id)) {
-		LM_ERR("Send_STR(): error adding Vendor-Id-Specific-Application-Id "
-			   "Group!\n");
+		LM_ERR("error adding Vendor-Id-Specific-Application-Id Group!\n");
 		AAAFreeMessage(&str);
 		return;
 	}

+ 1 - 1
src/modules/cdp/common.c

@@ -49,6 +49,6 @@ int get_result_code(AAAMessage *msg)
 finish:
 	return rc;
 error:
-	LM_ERR("get_result_code(): no AAAMessage or Result Code not found\n");
+	LM_ERR("no AAAMessage or Result Code not found\n");
 	return -1;
 }

+ 3 - 3
src/modules/cdp/config.c

@@ -59,7 +59,7 @@ inline dp_config *new_dp_config()
 	memset(x, 0, sizeof(dp_config));
 	return x;
 error:
-	LM_ERR("%s(): failed to create new dp_config.\n", __FUNCTION__);
+	LM_ERR("failed to create new dp_config.\n");
 	return 0;
 }
 
@@ -77,7 +77,7 @@ inline routing_realm *new_routing_realm()
 	memset(x, 0, sizeof(routing_realm));
 	return x;
 error:
-	LM_ERR("%s(): failed to create new routing_realm.\n", __FUNCTION__);
+	LM_ERR("failed to create new routing_realm.\n");
 	return 0;
 }
 
@@ -95,7 +95,7 @@ inline routing_entry *new_routing_entry()
 	memset(x, 0, sizeof(routing_entry));
 	return x;
 error:
-	LM_ERR("%s(): failed to create new routing_entry.\n", __FUNCTION__);
+	LM_ERR("failed to create new routing_entry.\n");
 	return 0;
 }
 

+ 7 - 9
src/modules/cdp/configparser.c

@@ -118,13 +118,12 @@ xmlDocPtr parse_dp_config_file(char *filename)
 	parser_init();
 
 	if(!filename) {
-		LM_ERR("ERROR:parse_dp_config_file(): filename parameter is null\n");
+		LM_ERR("filename parameter is null\n");
 		goto error;
 	}
 	f = fopen(filename, "r");
 	if(!f) {
-		LM_ERR("ERROR:parse_dp_config_file(): Error opening <%s> file > %s\n",
-				filename, strerror(errno));
+		LM_ERR("Error opening <%s> file > %s\n", filename, strerror(errno));
 		goto error;
 	}
 	fclose(f);
@@ -152,7 +151,7 @@ xmlDocPtr parse_dp_config_str(str config_str)
 
 	char c = config_str.s[config_str.len];
 	if(!config_str.len) {
-		LM_ERR("ERROR:parse_dp_config_str(): empty string\n");
+		LM_ERR("empty string\n");
 		goto error;
 	}
 	parser_init();
@@ -162,9 +161,8 @@ xmlDocPtr parse_dp_config_str(str config_str)
 	config_str.s[config_str.len] = c;
 
 	if(!doc) {
-		LM_ERR("parse_dp_config_file():  This is not a valid XML string "
-			   "<%.*s>\n",
-				config_str.len, config_str.s);
+		LM_ERR("This is not a valid XML string <%.*s>\n", config_str.len,
+				config_str.s);
 		goto error;
 	}
 
@@ -194,7 +192,7 @@ dp_config *parse_dp_config(xmlDocPtr doc)
 
 	root = xmlDocGetRootElement(doc);
 	if(!root) {
-		LM_ERR("parse_dp_config():  Empty XML \n");
+		LM_ERR("Empty XML \n");
 		goto error;
 	}
 
@@ -202,7 +200,7 @@ dp_config *parse_dp_config(xmlDocPtr doc)
 	if(k > 12)
 		k = 12;
 	if(strncasecmp((char *)root->name, "DiameterPeer", k) != 0) {
-		LM_ERR("parse_dp_config(): XML Root is not <DiameterPeer>\n");
+		LM_ERR("XML Root is not <DiameterPeer>\n");
 		goto error;
 	}
 

+ 20 - 26
src/modules/cdp/diameter_avp.c

@@ -128,8 +128,8 @@ AAA_AVP *AAACreateAVP(AAA_AVPCode code, AAA_AVPFlag flags, AAAVendorId vendorId,
 
 	/* first check the params */
 	if(data == 0 || length == 0) {
-		LM_ERR("AAACreateAVP: NULL value received for"
-			   " param data/length (AVP Code %d, VendorId %d)!!\n",
+		LM_ERR("NULL value received for param data/length (AVP Code %d, "
+			   "VendorId %d)!!\n",
 				code, vendorId);
 		return 0;
 	}
@@ -164,7 +164,7 @@ AAA_AVP *AAACreateAVP(AAA_AVPCode code, AAA_AVPFlag flags, AAAVendorId vendorId,
 
 	return avp;
 error:
-	LM_ERR("AAACreateAVP: no more free memory!\n");
+	LM_ERR("no more free memory!\n");
 	return 0;
 }
 
@@ -183,8 +183,8 @@ AAAReturnCode AAAAddAVPToMessage(
 	AAA_AVP *avp_t;
 
 	if(!msg || !avp) {
-		LM_ERR("AAAAddAVPToMessage: param msg or avp passed null"
-			   " or *avpList=NULL and position!=NULL !!\n");
+		LM_ERR("param msg or avp passed null or *avpList=NULL and "
+			   "position!=NULL !!\n");
 		return AAA_ERR_PARAMETER;
 	}
 
@@ -203,8 +203,7 @@ AAAReturnCode AAAAddAVPToMessage(
 				avp_t = avp_t->next)
 			;
 		if(!avp_t) {
-			LM_ERR("AAAAddAVPToMessage: the \"position\" avp is not in"
-				   "\"msg\" message!!\n");
+			LM_ERR("the \"position\" avp is not in \"msg\" message!!\n");
 			return AAA_ERR_PARAMETER;
 		}
 		/* insert after position */
@@ -274,8 +273,7 @@ AAA_AVP *AAAFindMatchingAVP(AAAMessage *msg, AAA_AVP *startAvp,
 				avp_t = avp_t->next)
 			;
 		if(!avp_t) {
-			LM_ERR("AAAFindMatchingAVP: the \"position\" avp is not "
-				   "in \"avpList\" list!!\n");
+			LM_ERR("the \"position\" avp is not in \"avpList\" list!!\n");
 			goto error;
 		}
 		avp_t = startAvp;
@@ -311,8 +309,7 @@ AAAReturnCode AAARemoveAVPFromMessage(AAAMessage *msg, AAA_AVP *avp)
 
 	/* param check */
 	if(!msg || !avp) {
-		LM_ERR("AAARemoveAVPFromMessage: param AVP_LIST \"avpList\" or AVP "
-			   "\"avp\" passed null !!\n");
+		LM_ERR("param AVP_LIST \"avpList\" or AVP \"avp\" passed null !!\n");
 		return AAA_ERR_PARAMETER;
 	}
 
@@ -320,8 +317,7 @@ AAAReturnCode AAARemoveAVPFromMessage(AAAMessage *msg, AAA_AVP *avp)
 	for(avp_t = msg->avpList.head; avp_t && avp_t != avp; avp_t = avp_t->next)
 		;
 	if(!avp_t) {
-		LM_ERR("AAARemoveAVPFromMessage: the \"avp\" avp is not in "
-			   "\"avpList\" avp list!!\n");
+		LM_ERR("the \"avp\" avp is not in \"avpList\" avp list!!\n");
 		return AAA_ERR_PARAMETER;
 	}
 
@@ -373,7 +369,7 @@ AAAReturnCode AAAFreeAVP(AAA_AVP **avp)
 {
 	/* some checks */
 	if(!avp || !(*avp)) {
-		LM_ERR("AAAFreeAVP: param avp cannot be null!!\n");
+		LM_ERR("param avp cannot be null!!\n");
 		return AAA_ERR_PARAMETER;
 	}
 
@@ -449,8 +445,7 @@ char *AAAConvertAVPToString(AAA_AVP *avp, char *dest, unsigned int destLen)
 	int i;
 
 	if(!avp || !dest || !destLen) {
-		LM_ERR("AAAConvertAVPToString: param AVP, DEST or DESTLEN "
-			   "passed as null!!!\n");
+		LM_ERR("param AVP, DEST or DESTLEN passed as null!!!\n");
 		return 0;
 	}
 	l = snprintf(dest, destLen,
@@ -535,7 +530,7 @@ AAA_AVP *AAACloneAVP(AAA_AVP *avp, unsigned char clone_data)
 	/* clone the avp structure */
 	n_avp = (AAA_AVP *)shm_malloc(sizeof(AAA_AVP));
 	if(!n_avp) {
-		LM_ERR("clone_avp: cannot get free memory!!\n");
+		LM_ERR("cannot get free memory!!\n");
 		goto error;
 	}
 	memcpy(n_avp, avp, sizeof(AAA_AVP));
@@ -545,7 +540,7 @@ AAA_AVP *AAACloneAVP(AAA_AVP *avp, unsigned char clone_data)
 		/* clone the avp data */
 		n_avp->data.s = (char *)shm_malloc(avp->data.len);
 		if(!(n_avp->data.s)) {
-			LM_ERR("clone_avp: cannot get free memory!!\n");
+			LM_ERR("cannot get free memory!!\n");
 			shm_free(n_avp);
 			goto error;
 		}
@@ -607,7 +602,7 @@ str AAAGroupAVPS(AAA_AVP_LIST avps)
 	/* allocate some memory */
 	buf.s = (char *)shm_malloc(buf.len);
 	if(!buf.s) {
-		LM_ERR("hss3g_group_avps: no more free memory!\n");
+		LM_ERR("no more free memory!\n");
 		buf.len = 0;
 		return buf;
 	}
@@ -634,7 +629,7 @@ str AAAGroupAVPS(AAA_AVP_LIST avps)
 		p += to_32x_len(avp->data.len);
 	}
 	if((char *)p - buf.s != buf.len) {
-		LM_ERR("BUG:hss3g_group_avps: mismatch between len and buf!\n");
+		LM_ERR("BUG:mismatch between len and buf!\n");
 		shm_free(buf.s);
 		buf.s = 0;
 		buf.len = 0;
@@ -666,7 +661,7 @@ AAA_AVP_LIST AAAUngroupAVPS(str buf)
 	/* start decoding the AVPS */
 	while(ptr < buf.s + buf.len) {
 		if(ptr + AVP_HDR_SIZE(0x80) > buf.s + buf.len) {
-			LM_ERR("hss3g_ungroup_avps: source buffer to short!! "
+			LM_ERR("source buffer to short!! "
 				   "Cannot read the whole AVP header!\n");
 			goto error;
 		}
@@ -680,7 +675,7 @@ AAA_AVP_LIST AAAUngroupAVPS(str buf)
 		avp_len = get_3bytes(ptr);
 		ptr += AVP_LENGTH_SIZE;
 		if(avp_len < 1) {
-			LM_ERR("hss3g_ungroup_avps: invalid AVP len [%d]\n", avp_len);
+			LM_ERR("invalid AVP len [%d]\n", avp_len);
 			goto error;
 		}
 		/* avp vendor-ID */
@@ -693,7 +688,7 @@ AAA_AVP_LIST AAAUngroupAVPS(str buf)
 		avp_data_len = avp_len - AVP_HDR_SIZE(avp_flags);
 		/*check the data length */
 		if(buf.s + buf.len < ptr + avp_data_len) {
-			LM_ERR("hss3g_ungroup_avps: source buffer to short!! "
+			LM_ERR("source buffer to short!! "
 				   "Cannot read a whole data for AVP!\n");
 			goto error;
 		}
@@ -702,7 +697,7 @@ AAA_AVP_LIST AAAUngroupAVPS(str buf)
 		avp = AAACreateAVP(avp_code, avp_flags, avp_vendorID, ptr, avp_data_len,
 				AVP_DONT_FREE_DATA);
 		if(!avp) {
-			LM_ERR("hss3g_ungroup_avps: can't create avp for member of list\n");
+			LM_ERR("can't create avp for member of list\n");
 			goto error;
 		}
 
@@ -749,8 +744,7 @@ AAA_AVP *AAAFindMatchingAVPList(AAA_AVP_LIST avpList, AAA_AVP *startAvp,
 				avp_t = avp_t->next)
 			;
 		if(!avp_t) {
-			LM_ERR("ndMatchingAVP: the \"position\" avp is not "
-				   "in \"avpList\" list!!\n");
+			LM_ERR("the \"position\" avp is not in \"avpList\" list!!\n");
 			goto error;
 		}
 		avp_t = startAvp;

+ 17 - 31
src/modules/cdp/diameter_comm.c

@@ -70,7 +70,7 @@ int AAAAddRequestHandler(AAARequestHandler_f *f, void *param)
 {
 	handler *h = shm_malloc(sizeof(handler));
 	if(!h) {
-		LM_ERR("AAAAddRequestHandler: error allocating %ld bytes in shm\n",
+		LM_ERR("error allocating %ld bytes in shm\n",
 				(long int)sizeof(handler));
 		return 0;
 	}
@@ -99,7 +99,7 @@ int AAAAddResponseHandler(AAAResponseHandler_f *f, void *param)
 {
 	handler *h = shm_malloc(sizeof(handler));
 	if(!h) {
-		LM_ERR("AAAAddResponseHandler: error allocating %ld bytes in shm\n",
+		LM_ERR("error allocating %ld bytes in shm\n",
 				(long int)sizeof(handler));
 		return 0;
 	}
@@ -143,15 +143,13 @@ AAAReturnCode AAASendMessage(AAAMessage *message,
 		AAASessionsUnlock(cdp_session->hash);
 	}
 	if(!p) {
-		LM_ERR("AAASendMessage(): Can't find a suitable connected peer in the "
-			   "routing table.\n");
+		LM_ERR("Can't find a suitable connected peer in the routing table.\n");
 		goto error;
 	}
 	LM_DBG("Found diameter peer [%.*s] from routing table\n", p->fqdn.len,
 			p->fqdn.s);
 	if(p->state != I_Open && p->state != R_Open) {
-		LM_ERR("AAASendMessage(): Peer not connected to %.*s\n", p->fqdn.len,
-				p->fqdn.s);
+		LM_ERR("Peer not connected to %.*s\n", p->fqdn.len, p->fqdn.s);
 		goto error;
 	}
 	/* only add transaction following when required */
@@ -160,8 +158,7 @@ AAAReturnCode AAASendMessage(AAAMessage *message,
 			cdp_add_trans(message, callback_f, callback_param,
 					config->transaction_timeout, 1);
 		else
-			LM_ERR("AAASendMessage(): can't add transaction callback for "
-				   "answer.\n");
+			LM_ERR("can't add transaction callback for answer.\n");
 	}
 
 	//	if (!peer_send_msg(p,message))
@@ -190,13 +187,11 @@ AAAReturnCode AAASendMessageToPeer(AAAMessage *message, str *peer_id,
 	peer *p;
 	p = get_peer_by_fqdn(peer_id);
 	if(!p) {
-		LM_ERR("AAASendMessageToPeer(): Peer unknown %.*s\n", peer_id->len,
-				peer_id->s);
+		LM_ERR("Peer unknown %.*s\n", peer_id->len, peer_id->s);
 		goto error;
 	}
 	if(p->state != I_Open && p->state != R_Open) {
-		LM_ERR("AAASendMessageToPeer(): Peer not connected to %.*s\n",
-				peer_id->len, peer_id->s);
+		LM_ERR("Peer not connected to %.*s\n", peer_id->len, peer_id->s);
 		goto error;
 	}
 	/* only add transaction following when required */
@@ -205,8 +200,7 @@ AAAReturnCode AAASendMessageToPeer(AAAMessage *message, str *peer_id,
 			cdp_add_trans(message, callback_f, callback_param,
 					config->transaction_timeout, 1);
 		else
-			LM_ERR("AAASendMessageToPeer(): can't add transaction callback for "
-				   "answer.\n");
+			LM_ERR("can't add transaction callback for answer.\n");
 	}
 
 	p->last_selected = time(NULL);
@@ -235,8 +229,7 @@ void sendrecv_cb(
 		int is_timeout, void *param, AAAMessage *ans, long elapsed_msecs)
 {
 	if(sem_release((gen_sem_t *)param) < 0)
-		LM_ERR("sendrecv_cb(): Failed to unlock a transactional sendrecv! > "
-			   "%s\n",
+		LM_ERR("Failed to unlock a transactional sendrecv! > %s\n",
 				strerror(errno));
 }
 
@@ -266,13 +259,11 @@ AAAMessage *AAASendRecvMessage(AAAMessage *message)
 		AAASessionsUnlock(cdp_session->hash);
 	}
 	if(!p) {
-		LM_ERR("AAASendRecvMessage(): Can't find a suitable connected peer in "
-			   "the routing table.\n");
+		LM_ERR("Can't find a suitable connected peer in the routing table.\n");
 		goto error;
 	}
 	if(p->state != I_Open && p->state != R_Open) {
-		LM_ERR("AAASendRecvMessage(): Peer not connected to %.*s\n",
-				p->fqdn.len, p->fqdn.s);
+		LM_ERR("Peer not connected to %.*s\n", p->fqdn.len, p->fqdn.s);
 		goto error;
 	}
 
@@ -291,8 +282,7 @@ AAAMessage *AAASendRecvMessage(AAAMessage *message)
 		while(sem_get(sem) < 0) {
 			if(shutdownx && (*shutdownx))
 				goto error;
-			LM_WARN("AAASendRecvMessage(): interrupted by signal or something "
-					"> %s\n",
+			LM_WARN("interrupted by signal or something > %s\n",
 					strerror(errno));
 		}
 		sem_free(sem);
@@ -309,7 +299,7 @@ AAAMessage *AAASendRecvMessage(AAAMessage *message)
 		cdp_free_trans(t);
 		return ans;
 	} else {
-		LM_ERR("AAASendRecvMessage(): can't add wait for answer to answer.\n");
+		LM_ERR("can't add wait for answer to answer.\n");
 		goto error;
 	}
 
@@ -342,13 +332,11 @@ AAAMessage *AAASendRecvMessageToPeer(AAAMessage *message, str *peer_id)
 
 	p = get_peer_by_fqdn(peer_id);
 	if(!p) {
-		LM_ERR("AAASendRecvMessageToPeer(): Peer unknown %.*s\n", peer_id->len,
-				peer_id->s);
+		LM_ERR("Peer unknown %.*s\n", peer_id->len, peer_id->s);
 		goto error;
 	}
 	if(p->state != I_Open && p->state != R_Open) {
-		LM_ERR("AAASendRecvMessageToPeer(): Peer not connected to %.*s\n",
-				peer_id->len, peer_id->s);
+		LM_ERR("Peer not connected to %.*s\n", peer_id->len, peer_id->s);
 		goto error;
 	}
 
@@ -366,8 +354,7 @@ AAAMessage *AAASendRecvMessageToPeer(AAAMessage *message, str *peer_id)
 		while(sem_get(sem) < 0) {
 			if(shutdownx && (*shutdownx))
 				goto error;
-			LM_WARN("AAASendRecvMessageToPeer(): interrupted by signal or "
-					"something > %s\n",
+			LM_WARN("interrupted by signal or something > %s\n",
 					strerror(errno));
 		}
 
@@ -386,8 +373,7 @@ AAAMessage *AAASendRecvMessageToPeer(AAAMessage *message, str *peer_id)
 		cdp_free_trans(t);
 		return ans;
 	} else {
-		LM_ERR("AAASendRecvMessageToPeer(): can't add wait for answer to "
-			   "answer.\n");
+		LM_ERR("can't add wait for answer to answer.\n");
 		goto error;
 	}
 

+ 26 - 35
src/modules/cdp/diameter_msg.c

@@ -81,11 +81,11 @@ AAAReturnCode AAABuildMsgBuffer(AAAMessage *msg)
 		//LM_DBG("AVP code: %d, data %.*s\n", avp->code, avp->data.len, avp->data.s);
 	}
 
-	LM_DBG("AAABuildMsgBuffer(): len=%d\n", msg->buf.len);
+	LM_DBG("len=%d\n", msg->buf.len);
 	/* allocate some memory */
 	msg->buf.s = (char *)shm_malloc(msg->buf.len);
 	if(!msg->buf.s) {
-		LM_ERR("AAABuildMsgBuffer: no more free memory!\n");
+		LM_ERR("no more free memory!\n");
 		goto error;
 	}
 	memset(msg->buf.s, 0, msg->buf.len);
@@ -180,8 +180,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 				sessionId = &(request->sessionId->data);
 		} else {
 			if(commandCode != Code_DW)
-				LM_DBG("AAANewMessage: param session received null and it's a "
-					   "request!!\n");
+				LM_DBG("param session received null and it's a request!!\n");
 		}
 	} else {
 		sessionId = &(session->id);
@@ -190,7 +189,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 	/* allocated a new AAAMessage structure and set it to 0 */
 	msg = (AAAMessage *)shm_malloc(sizeof(AAAMessage));
 	if(!msg) {
-		LM_ERR("AAANewMessage: no more free memory!!\n");
+		LM_ERR("no more free memory!!\n");
 		goto error;
 	}
 	memset(msg, 0, sizeof(AAAMessage));
@@ -205,7 +204,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 		avp = AAACreateAVP(
 				263, 0, 0, sessionId->s, sessionId->len, AVP_DUPLICATE_DATA);
 		if(!avp || AAAAddAVPToMessage(msg, avp, 0) != AAA_ERR_SUCCESS) {
-			LM_ERR("AAANewMessage: cannot create/add Session-Id avp\n");
+			LM_ERR("cannot create/add Session-Id avp\n");
 			if(avp)
 				AAAFreeAVP(&avp);
 			goto error;
@@ -224,7 +223,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 	if(!avp
 			|| AAAAddAVPToMessage(msg, avp, msg->avpList.tail)
 					   != AAA_ERR_SUCCESS) {
-		LM_ERR("AAANewMessage: cannot create/add Origin-Host avp\n");
+		LM_ERR("cannot create/add Origin-Host avp\n");
 		if(avp)
 			AAAFreeAVP(&avp);
 		goto error;
@@ -236,7 +235,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 	if(!avp
 			|| AAAAddAVPToMessage(msg, avp, msg->avpList.tail)
 					   != AAA_ERR_SUCCESS) {
-		LM_ERR("AAANewMessage: cannot create/add Origin-Realm avp\n");
+		LM_ERR("cannot create/add Origin-Realm avp\n");
 		if(avp)
 			AAAFreeAVP(&avp);
 		goto error;
@@ -272,11 +271,11 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 			//avp = AAACreateAVP(AVP_Destination_Host,AAA_AVP_FLAG_MANDATORY,0,
 			//	dest_host.s,dest_host.len,AVP_DUPLICATE_DATA);
 			//if (!avp) {
-			//		LM_ERR("ERR:AAANewMessage: Failed creating Destination Host avp\n");
+			//		LM_ERR("Failed creating Destination Host avp\n");
 			//		goto error;
 			//	}
 			//	if (AAAAddAVPToMessage(msg,avp,msg->avpList.tail)!=AAA_ERR_SUCCESS) {
-			//		LM_ERR("ERR:AAANewMessage: Failed adding Destination Host avp to message\n");
+			//		LM_ERR("Failed adding Destination Host avp to message\n");
 			//		AAAFreeAVP(&avp);
 			//		goto error;
 			//	}
@@ -287,14 +286,12 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 			avp = AAACreateAVP(AVP_Destination_Realm, AAA_AVP_FLAG_MANDATORY, 0,
 					dest_realm.s, dest_realm.len, AVP_DUPLICATE_DATA);
 			if(!avp) {
-				LM_ERR("ERR:AAANewMessage: Failed creating Destination Realm "
-					   "avp\n");
+				LM_ERR("Failed creating Destination Realm avp\n");
 				goto error;
 			}
 			if(AAAAddAVPToMessage(msg, avp, msg->avpList.tail)
 					!= AAA_ERR_SUCCESS) {
-				LM_ERR("ERR:AAANewMessage: Failed adding Destination Realm avp "
-					   "to message\n");
+				LM_ERR("Failed adding Destination Realm avp to message\n");
 				AAAFreeAVP(&avp);
 				goto error;
 			}
@@ -315,7 +312,7 @@ AAAMessage *AAANewMessage(AAACommandCode commandCode,
 
 	return msg;
 error:
-	LM_ERR("AAANewMessage: failed to create a new AAA message!\n");
+	LM_ERR("failed to create a new AAA message!\n");
 	AAAFreeMessage(&msg);
 	return 0;
 }
@@ -347,11 +344,11 @@ AAAMessage *AAACreateRequest(AAAApplicationId app_id,
 			avp = AAACreateAVP(AVP_Destination_Host,AAA_AVP_FLAG_MANDATORY,0,
 			session->dest_host.s,session->dest_host.len,AVP_DUPLICATE_DATA);
 			if (!avp) {
-				LM_ERR("ERR:AAACreateRequest: Failed creating Destination Host avp\n");
+				LM_ERR("Failed creating Destination Host avp\n");
 				goto error;
 			}
 			if (AAAAddAVPToMessage(msg,avp,msg->avpList.tail)!=AAA_ERR_SUCCESS) {
-				LM_ERR("ERR:AAACreateRequest: Failed adding Destination Host avp to message\n");
+				LM_ERR("Failed adding Destination Host avp to message\n");
 				AAAFreeAVP(&avp);
 				goto error;
 			}
@@ -362,14 +359,12 @@ AAAMessage *AAACreateRequest(AAAApplicationId app_id,
 					session->dest_realm.s, session->dest_realm.len,
 					AVP_DUPLICATE_DATA);
 			if(!avp) {
-				LM_ERR("ERR:AAACreateRequest: Failed creating Destination "
-					   "Realm avp\n");
+				LM_ERR("Failed creating Destination Realm avp\n");
 				goto error;
 			}
 			if(AAAAddAVPToMessage(msg, avp, msg->avpList.tail)
 					!= AAA_ERR_SUCCESS) {
-				LM_ERR("ERR:AAACreateRequest: Failed adding Destination Realm "
-					   "avp to message\n");
+				LM_ERR("Failed adding Destination Realm avp to message\n");
 				AAAFreeAVP(&avp);
 				goto error;
 			}
@@ -426,8 +421,7 @@ AAAReturnCode AAAFreeAVPList(AAA_AVP_LIST *avpList)
  */
 AAAReturnCode AAAFreeMessage(AAAMessage **msg)
 {
-	LM_DBG("AAAFreeMessage: Freeing message (%p) %d\n", *msg,
-			(*msg)->commandCode);
+	LM_DBG("Freeing message (%p) %d\n", *msg, (*msg)->commandCode);
 	/* param check */
 	if(!msg || !(*msg))
 		goto done;
@@ -489,7 +483,7 @@ AAAMessage *AAATranslateMessage(
 
 	/* check the params */
 	if(!source || !sourceLen || sourceLen < AAA_MSG_HDR_SIZE) {
-		LM_ERR("AAATranslateMessage: invalid buffered received!\n");
+		LM_ERR("invalid buffered received!\n");
 		goto error;
 	}
 
@@ -501,7 +495,7 @@ AAAMessage *AAATranslateMessage(
 	/* alloc a new message structure */
 	msg = (AAAMessage *)shm_malloc(sizeof(AAAMessage));
 	if(!msg) {
-		LM_ERR("AAATranslateMessage: no more free memory!!\n");
+		LM_ERR("no more free memory!!\n");
 		goto error;
 	}
 	memset(msg, 0, sizeof(AAAMessage));
@@ -510,9 +504,7 @@ AAAMessage *AAATranslateMessage(
 	version = (unsigned char)*ptr;
 	ptr += VER_SIZE;
 	if(version != 1) {
-		LM_ERR("AAATranslateMessage: invalid version [%d]in "
-			   "AAA msg\n",
-				version);
+		LM_ERR("invalid version [%d]in AAA msg\n", version);
 		goto error;
 	}
 
@@ -520,9 +512,8 @@ AAAMessage *AAATranslateMessage(
 	msg_len = get_3bytes(ptr);
 	ptr += MESSAGE_LENGTH_SIZE;
 	if(msg_len > sourceLen) {
-		LM_ERR("AAATranslateMessage: AAA message len [%d] bigger than"
-			   " buffer len [%d]\n",
-				msg_len, sourceLen);
+		LM_ERR("AAA message len [%d] bigger than buffer len [%d]\n", msg_len,
+				sourceLen);
 		goto error;
 	}
 
@@ -549,7 +540,7 @@ AAAMessage *AAATranslateMessage(
 	/* start decoding the AVPS */
 	while(ptr < source + msg_len) {
 		if(ptr + AVP_HDR_SIZE(0x80) > source + msg_len) {
-			LM_ERR("AAATranslateMessage: source buffer to short!! "
+			LM_ERR("source buffer to short!! "
 				   "Cannot read the whole AVP header!\n");
 			goto error;
 		}
@@ -563,7 +554,7 @@ AAAMessage *AAATranslateMessage(
 		avp_len = get_3bytes(ptr);
 		ptr += AVP_LENGTH_SIZE;
 		if(avp_len < 1) {
-			LM_ERR("AAATranslateMessage: invalid AVP len [%d]\n", avp_len);
+			LM_ERR("invalid AVP len [%d]\n", avp_len);
 			goto error;
 		}
 		/* avp vendor-ID */
@@ -576,7 +567,7 @@ AAAMessage *AAATranslateMessage(
 		avp_data_len = avp_len - AVP_HDR_SIZE(avp_flags);
 		/*check the data length */
 		if(source + msg_len < ptr + avp_data_len) {
-			LM_ERR("AAATranslateMessage: source buffer to short!! "
+			LM_ERR("source buffer to short!! "
 				   "Cannot read a whole data for AVP!\n");
 			goto error;
 		}
@@ -604,7 +595,7 @@ AAAMessage *AAATranslateMessage(
 	//AAAPrintMessage( msg );
 	return msg;
 error:
-	LM_ERR("AAATranslateMessage: message conversion dropped!!\n");
+	LM_ERR("message conversion dropped!!\n");
 	AAAFreeMessage(&msg);
 	return 0;
 }

+ 17 - 30
src/modules/cdp/diameter_peer.c

@@ -87,8 +87,7 @@ int diameter_peer_init_real()
 	pid_list_t *i, *j;
 
 	if(!config) {
-		LM_ERR("diameter_peer_init_real(): Configuration was not parsed yet. "
-			   "Aborting...\n");
+		LM_ERR("Configuration was not parsed yet. Aborting...\n");
 		goto error;
 	}
 	log_dp_config(config);
@@ -192,8 +191,7 @@ int diameter_peer_init(char *cfg_filename)
 	xmlDocPtr doc = parse_dp_config_file(cfg_filename);
 	config = parse_dp_config(doc);
 	if(!config) {
-		LM_ERR("init_diameter_peer(): Error loading configuration file. "
-			   "Aborting...\n");
+		LM_ERR("Error loading configuration file. Aborting...\n");
 		goto error;
 	}
 
@@ -213,8 +211,7 @@ int diameter_peer_init_str(str config_str)
 	xmlDocPtr doc = parse_dp_config_str(config_str);
 	config = parse_dp_config(doc);
 	if(!config) {
-		LM_ERR("init_diameter_peer(): Error loading configuration file. "
-			   "Aborting...\n");
+		LM_ERR("Error loading configuration file. Aborting...\n");
 		goto error;
 	}
 
@@ -241,7 +238,7 @@ int diameter_peer_start(int blocking)
 	for(k = 0; k < config->workers; k++) {
 		pid = fork_process(1001 + k, "cdp_worker", 1);
 		if(pid == -1) {
-			LM_CRIT("init_diameter_peer(): Error on fork() for worker!\n");
+			LM_CRIT("Error on fork() for worker!\n");
 			return 0;
 		}
 		if(pid == 0) {
@@ -250,8 +247,7 @@ int diameter_peer_start(int blocking)
 			if(cfg_child_init())
 				return 0;
 			worker_process(k);
-			LM_CRIT("init_diameter_peer(): worker_process finished without "
-					"exit!\n");
+			LM_CRIT("worker_process finished without exit!\n");
 			exit(-1);
 		} else {
 			dp_add_pid(pid);
@@ -268,8 +264,7 @@ int diameter_peer_start(int blocking)
 	pid = fork_process(1001 + k, "cdp_receiver_peer_unknown", 1);
 
 	if(pid == -1) {
-		LM_CRIT("init_diameter_peer(): Error on fork() for unknown peer "
-				"receiver!\n");
+		LM_CRIT("Error on fork() for unknown peer receiver!\n");
 		return 0;
 	}
 	if(pid == 0) {
@@ -277,8 +272,7 @@ int diameter_peer_start(int blocking)
 		if(cfg_child_init())
 			return 0;
 		receiver_process(NULL);
-		LM_CRIT("init_diameter_peer(): receiver_process finished without "
-				"exit!\n");
+		LM_CRIT("receiver_process finished without exit!\n");
 		exit(-1);
 	} else {
 		dp_add_pid(pid);
@@ -289,8 +283,7 @@ int diameter_peer_start(int blocking)
 	for(p = peer_list->head, k = -1; p; p = p->next, k--) {
 		pid = fork_process(1001 + k, "cdp_receiver_peer", 1);
 		if(pid == -1) {
-			LM_CRIT("init_diameter_peer(): Error on fork() for peer "
-					"receiver!\n");
+			LM_CRIT("Error on fork() for peer receiver!\n");
 			return 0;
 		}
 		if(pid == 0) {
@@ -299,8 +292,7 @@ int diameter_peer_start(int blocking)
 			if(cfg_child_init())
 				return 0;
 			receiver_process(p);
-			LM_CRIT("init_diameter_peer(): receiver_process finished without "
-					"exit!\n");
+			LM_CRIT("receiver_process finished without exit!\n");
 			exit(-1);
 		} else {
 			dp_add_pid(pid);
@@ -313,15 +305,14 @@ int diameter_peer_start(int blocking)
 	pid = fork_process(1000, "cdp_acceptor", 1);
 
 	if(pid == -1) {
-		LM_CRIT("init_diameter_peer(): Error on fork() for acceptor!\n");
+		LM_CRIT("Error on fork() for acceptor!\n");
 		return 0;
 	}
 	if(pid == 0) {
 		if(cfg_child_init())
 			return 0;
 		acceptor_process(config);
-		LM_CRIT("init_diameter_peer(): acceptor_process finished without "
-				"exit!\n");
+		LM_CRIT("acceptor_process finished without exit!\n");
 		exit(-1);
 	} else {
 		dp_add_pid(pid);
@@ -336,15 +327,14 @@ int diameter_peer_start(int blocking)
 	} else {
 		pid = fork_process(1001, "cdp_timer", 1);
 		if(pid == -1) {
-			LM_CRIT("init_diameter_peer(): Error on fork() for timer!\n");
+			LM_CRIT("Error on fork() for timer!\n");
 			return 0;
 		}
 		if(pid == 0) {
 			if(cfg_child_init())
 				return 0;
 			timer_process(0);
-			LM_CRIT("init_diameter_peer(): timer_process finished without "
-					"exit!\n");
+			LM_CRIT("timer_process finished without exit!\n");
 			exit(-1);
 		} else {
 			dp_add_pid(pid);
@@ -378,16 +368,14 @@ void diameter_peer_destroy()
 	}
 
 	/* wait for all children to clean up nicely (acceptor, receiver, timer, workers) */
-	LM_INFO("destroy_diameter_peer(): Terminating all children...\n");
+	LM_INFO("Terminating all children...\n");
 	while(pid_list->tail) {
 		pid = dp_last_pid();
 		if(pid <= 0 || pid == getpid()) {
 			dp_del_pid(pid);
 			continue;
 		}
-		LM_INFO("destroy_diameter_peer(): Waiting for child [%d] to "
-				"terminate...\n",
-				pid);
+		LM_INFO("Waiting for child [%d] to terminate...\n", pid);
 		if(waitpid(pid, &status, 0) < 0) {
 			dp_del_pid(pid);
 			continue;
@@ -398,8 +386,7 @@ void diameter_peer_destroy()
 			dp_del_pid(pid);
 		}
 	}
-	LM_INFO("destroy_diameter_peer(): All processes terminated. Cleaning "
-			"up.\n");
+	LM_INFO("All processes terminated. Cleaning up.\n");
 
 	/* clean upt the timer */
 	timer_cdp_destroy();
@@ -439,5 +426,5 @@ void diameter_peer_destroy()
 	shm_free(handlers);
 
 	free_dp_config(config);
-	LM_CRIT("destroy_diameter_peer(): Bye Bye from C Diameter Peer test\n");
+	LM_CRIT("Bye Bye from C Diameter Peer test\n");
 }

+ 6 - 7
src/modules/cdp/peermanager.c

@@ -74,7 +74,7 @@ int peer_manager_init(dp_config *config)
 {
 	int i;
 	peer *p;
-	LM_DBG("peer_manager_init(): Peer Manager initialization...\n");
+	LM_DBG("Peer Manager initialization...\n");
 	peer_list = shm_malloc(sizeof(peer_list_t));
 	peer_list->head = 0;
 	peer_list->tail = 0;
@@ -132,7 +132,7 @@ void peer_manager_destroy()
 	shm_free(peer_list);
 	lock_destroy(peer_list_lock);
 	lock_dealloc((void *)peer_list_lock);
-	LM_DBG("peer_manager_init(): ...Peer Manager destroyed\n");
+	LM_DBG("Peer Manager destroyed\n");
 }
 
 /**
@@ -281,7 +281,7 @@ int peer_timer(time_t now, void *ptr)
 {
 	peer *p, *n;
 	int i;
-	LM_DBG("peer_timer(): taking care of peers...\n");
+	LM_DBG("taking care of peers...\n");
 	lock_get(peer_list_lock);
 	p = peer_list->head;
 	while(p) {
@@ -302,8 +302,7 @@ int peer_timer(time_t now, void *ptr)
 		}
 
 		if(p->activity + config->tc <= now) {
-			LM_DBG("peer_timer(): Peer %.*s State %d \n", p->fqdn.len,
-					p->fqdn.s, p->state);
+			LM_DBG("Peer %.*s State %d \n", p->fqdn.len, p->fqdn.s, p->state);
 			switch(p->state) {
 				/* initiating connection */
 				case Closed:
@@ -353,8 +352,8 @@ int peer_timer(time_t now, void *ptr)
 					/* ignored states */
 					/* unknown states */
 				default:
-					LM_ERR("peer_timer(): Peer %.*s inactive  in state %d\n",
-							p->fqdn.len, p->fqdn.s, p->state);
+					LM_ERR("Peer %.*s inactive  in state %d\n", p->fqdn.len,
+							p->fqdn.s, p->state);
 			}
 		}
 		lock_release(p->lock);

+ 29 - 32
src/modules/cdp/peerstatemachine.c

@@ -92,8 +92,8 @@ int sm_process(
 
 	if(!peer_locked)
 		lock_get(p->lock);
-	LM_DBG("sm_process(): Peer %.*s State %s Event %s\n", p->fqdn.len,
-			p->fqdn.s, dp_states[p->state], dp_events[event - 101]);
+	LM_DBG("Peer %.*s State %s Event %s\n", p->fqdn.len, p->fqdn.s,
+			dp_states[p->state], dp_events[event - 101]);
 
 	switch(p->state) {
 		case Closed:
@@ -126,7 +126,7 @@ int sm_process(
 					p->state = Closed;
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -165,7 +165,7 @@ int sm_process(
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -192,11 +192,11 @@ int sm_process(
 						p->state = Wait_Returns;
 						if(Elect(p, msg)) {
 							// won the election = > I_Disc(), R_Send_CEA()
-							LM_INFO("sm_process():Wait_I_CEA Win Elect \n");
+							LM_INFO("Wait_I_CEA Win Elect \n");
 							sm_process(p, Win_Election, msg, 1, sock);
 						} else {
 							// lost the election => wait for I_Recv_CEA, then R_Disc()
-							LM_INFO("sm_process():Wait_I_CEA Lose Elect \n");
+							LM_INFO("Wait_I_CEA Lose Elect \n");
 							p->r_cer = msg;
 							sm_process(p, I_Peer_Disc, 0, 1, p->I_sock);
 						}
@@ -221,7 +221,7 @@ int sm_process(
 					p->state = Closed;
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -235,18 +235,18 @@ int sm_process(
 						p->state = Wait_Returns;
 						if(Elect(p, p->r_cer)) {
 							// won the election = > I_Disc(), R_Send_CEA()
-							LM_INFO("sm_process():Wait_Conn_Ack_Elect Win "
+							LM_INFO("Wait_Conn_Ack_Elect Win "
 									"Elect \n");
 							sm_process(p, Win_Election, p->r_cer, 1, sock);
 							p->r_cer = 0;
 						} else {
 							// lost the election => wait for I_Recv_CEA, then R_Disc()
-							LM_INFO("sm_process():Wait_Conn_Ack_Elect Lose "
+							LM_INFO("Wait_Conn_Ack_Elect Lose "
 									"Elect \n");
 							AAAFreeMessage(&p->r_cer);
 						}
 					} else {
-						LM_ERR("sm_process():Wait_Conn_Ack_Elect, "
+						LM_ERR("Wait_Conn_Ack_Elect, "
 							   "I_Rcv_Conn_Ack, No R-CER ! \n");
 						p->state = Wait_I_CEA;
 					}
@@ -265,7 +265,7 @@ int sm_process(
 							//	p->state = R_Open; /* Or maybe I should disconnect it?*/
 						}
 					} else {
-						LM_ERR("sm_process():Wait_Conn_Ack_Elect, "
+						LM_ERR("Wait_Conn_Ack_Elect, "
 							   "I_Rcv_Conn_NAck No R-CER ! \n");
 					}
 					break;
@@ -286,7 +286,7 @@ int sm_process(
 					p->state = Closed;
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -296,7 +296,7 @@ int sm_process(
 			switch(event) {
 				case Win_Election:
 					/* this is the Win Election -> I is dropped, R is kept */
-					LM_INFO("sm_process():Wait_Returns Win Elect \n");
+					LM_INFO("Wait_Returns Win Elect \n");
 					I_Disc(p);
 					result_code = Process_CER(p, msg);
 					Snd_CEA(p, msg, result_code, p->R_sock);
@@ -320,13 +320,13 @@ int sm_process(
 							p->state = Closed;
 						}
 					} else {
-						LM_ERR("sm_process():Wait_Returns, I_Peer_Disc No "
+						LM_ERR("Wait_Returns, I_Peer_Disc No "
 							   "R-CER ! \n");
 					}
 					break;
 				case I_Rcv_CEA:
 					/* this is the Lost Election -> I is kept, R dropped */
-					LM_INFO("sm_process():Wait_Returns Lost Elect \n");
+					LM_INFO("Wait_Returns Lost Elect \n");
 					R_Disc(p);
 					result_code = Process_CEA(p, msg);
 					if(result_code >= 2000 && result_code < 3000)
@@ -355,7 +355,7 @@ int sm_process(
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -422,7 +422,7 @@ int sm_process(
 					log_peer_list();
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -488,7 +488,7 @@ int sm_process(
 					}
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -519,7 +519,7 @@ int sm_process(
 					p->state = Closed;
 					break;
 				default:
-					LM_ERR("sm_process(): In state %s invalid event %s\n",
+					LM_ERR("In state %s invalid event %s\n",
 							dp_states[p->state], dp_events[event - 101]);
 					goto error;
 			}
@@ -548,7 +548,7 @@ error:
  */
 peer_event_t I_Snd_Conn_Req(peer *p)
 {
-	LM_INFO("I_Snd_Conn_Req(): Peer %.*s \n", p->fqdn.len, p->fqdn.s);
+	LM_INFO("Peer %.*s \n", p->fqdn.len, p->fqdn.s);
 
 	if(p->I_sock > 0)
 		close(p->I_sock);
@@ -669,8 +669,7 @@ void I_Snd_CER(peer *p)
 	cer->endtoendId = next_endtoend();
 	addrlen = sizeof(addr_u);
 	if((ret = getsockname(p->I_sock, &(addr_u.addr), &addrlen)) == -1) {
-		LM_ERR("I_Snd_CER(): Error on finding local host address > %s\n",
-				strerror(errno));
+		LM_ERR("Error on finding local host address > %s\n", strerror(errno));
 		Cleanup(p, p->I_sock);
 		p->state = Closed;
 		AAAFreeMessage(&cer);
@@ -693,7 +692,7 @@ void I_Snd_CER(peer *p)
 						AAA_AVP_FLAG_MANDATORY, 0, x, 18);
 				break;
 			default:
-				LM_ERR("I_Snd_CER(): unknown address type with family %d\n",
+				LM_ERR("unknown address type with family %d\n",
 						addr_u.addr.sa_family);
 		}
 	}
@@ -796,7 +795,7 @@ void save_peer_applications(peer *p, AAAMessage *msg)
 	p->applications = shm_malloc(sizeof(app_config) * total_cnt);
 	p->applications_max = total_cnt;
 	if(!p->applications) {
-		LM_ERR("save_peer_applications(): Error allocating %ld bytes! No "
+		LM_ERR("Error allocating %ld bytes! No "
 			   "applications saved...\n",
 				(long int)(sizeof(app_config) * total_cnt));
 		return;
@@ -1145,8 +1144,7 @@ void Snd_CEA(peer *p, AAAMessage *cer, int result_code, int sock)
 
 	addrlen = sizeof(addr_u);
 	if(getsockname(sock, &(addr_u.addr), &addrlen) == -1) {
-		LM_ERR("Snd_CEA(): Error on finding local host address > %s\n",
-				strerror(errno));
+		LM_ERR("Error on finding local host address > %s\n", strerror(errno));
 	} else {
 		switch(addr_u.addr.sa_family) {
 			case AF_INET:
@@ -1163,7 +1161,7 @@ void Snd_CEA(peer *p, AAAMessage *cer, int result_code, int sock)
 						AAA_AVP_FLAG_MANDATORY, 0, x, 18);
 				break;
 			default:
-				LM_ERR("Snd_CEA(): unknown address type with family %d\n",
+				LM_ERR("unknown address type with family %d\n",
 						addr_u.addr.sa_family);
 		}
 	}
@@ -1241,9 +1239,8 @@ void Snd_Message(peer *p, AAAMessage *msg)
 	AAASession *session = 0;
 	int rcode;
 	int send_message_before_session_sm = 0;
-	LM_DBG("Snd_Message called to peer [%.*s] for %s with code %d \n",
-			p->fqdn.len, p->fqdn.s, is_req(msg) ? "request" : "response",
-			msg->commandCode);
+	LM_DBG("called to peer [%.*s] for %s with code %d \n", p->fqdn.len,
+			p->fqdn.s, is_req(msg) ? "request" : "response", msg->commandCode);
 	if(msg->sessionId)
 		session = cdp_get_session(msg->sessionId->data);
 
@@ -1421,10 +1418,10 @@ void Rcv_Process(peer *p, AAAMessage *msg)
 		}
 	}
 	if(!nput && !put_task(p, msg)) {
-		LM_ERR("Rcv_Process(): Queue refused task\n");
+		LM_ERR("Queue refused task\n");
 		AAAFreeMessage(&msg);
 	}
-	//if (msg) LM_ERR("Rcv_Process(): task added to queue command %d, flags %#1x endtoend %u hopbyhop %u\n",msg->commandCode,msg->flags,msg->endtoendId,msg->hopbyhopId);
+	//if (msg) LM_ERR("task added to queue command %d, flags %#1x endtoend %u hopbyhop %u\n",msg->commandCode,msg->flags,msg->endtoendId,msg->hopbyhopId);
 
 	//	AAAPrintMessage(msg);
 }

+ 78 - 100
src/modules/cdp/receiver.c

@@ -134,20 +134,18 @@ static int make_send_pipe(serviced_peer_t *sp)
 	sp->send_pipe_name.len = strlen(sp->send_pipe_name.s);
 
 	if(mkfifo(sp->send_pipe_name.s, 0666) < 0) {
-		LM_ERR("make_send_pipe(): FIFO make failed > %s\n", strerror(errno));
+		LM_ERR("FIFO make failed > %s\n", strerror(errno));
 		return 0;
 	}
 	sp->send_pipe_fd = open(sp->send_pipe_name.s, O_RDONLY | O_NDELAY);
 	if(sp->send_pipe_fd < 0) {
-		LM_ERR("receiver_init(): FIFO open for read failed > %s\n",
-				strerror(errno));
+		LM_ERR("FIFO open for read failed > %s\n", strerror(errno));
 		return 0;
 	}
 	// we open it for writing just to keep it alive - won't close when all other writers close it
 	sp->send_pipe_fd_out = open(sp->send_pipe_name.s, O_WRONLY);
 	if(sp->send_pipe_fd_out < 0) {
-		LM_ERR("receiver_init(): FIFO open for write (keep-alive) failed > "
-			   "%s\n",
+		LM_ERR("FIFO open for write (keep-alive) failed > %s\n",
 				strerror(errno));
 		return 0;
 	}
@@ -192,12 +190,12 @@ static void close_send_pipe(serviced_peer_t *sp)
 static serviced_peer_t *add_serviced_peer(peer *p)
 {
 	serviced_peer_t *sp;
-	LM_INFO("add_serviced_peer(): Adding serviced_peer_t to receiver for peer "
+	LM_INFO("Adding serviced_peer_t to receiver for peer "
 			"[%.*s]\n",
 			p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
 	sp = pkg_malloc(sizeof(serviced_peer_t));
 	if(!sp) {
-		LM_INFO("add_serviced_peer(): error allocating pkg mem\n");
+		LM_INFO("error allocating pkg mem\n");
 		return 0;
 	}
 	memset(sp, 0, sizeof(serviced_peer_t));
@@ -229,8 +227,8 @@ static void disconnect_serviced_peer(serviced_peer_t *sp, int locked)
 {
 	if(!sp)
 		return;
-	LM_INFO("drop_serviced_peer(): [%.*s] Disconnecting from peer \n",
-			sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0);
+	LM_INFO("[%.*s] Disconnecting from peer \n", sp->p ? sp->p->fqdn.len : 0,
+			sp->p ? sp->p->fqdn.s : 0);
 	if(sp->p) {
 		if(!locked)
 			lock_get(sp->p->lock);
@@ -257,8 +255,7 @@ static void drop_serviced_peer(serviced_peer_t *sp, int locked)
 {
 	if(!sp)
 		return;
-	LM_INFO("drop_serviced_peer(): Dropping serviced_peer_t from receiver for "
-			"peer [%.*s]\n",
+	LM_INFO("Dropping serviced_peer_t from receiver for peer [%.*s]\n",
 			sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0);
 
 	sp->p = 0;
@@ -333,8 +330,7 @@ again:
 		if(errno == EINTR)
 			goto again;
 		if((errno != EAGAIN) && (errno != EWOULDBLOCK)) {
-			LM_CRIT("send_fd: sendmsg failed on %d: %s\n", pipe_fd,
-					strerror(errno));
+			LM_CRIT("sendmsg failed on %d: %s\n", pipe_fd, strerror(errno));
 			return 0;
 		}
 	}
@@ -389,17 +385,16 @@ again:
 			goto again;
 		if((errno == EAGAIN) || (errno == EWOULDBLOCK))
 			goto error;
-		LM_CRIT("receive_fd: recvmsg on %d failed: %s\n", pipe_fd,
-				strerror(errno));
+		LM_CRIT("recvmsg on %d failed: %s\n", pipe_fd, strerror(errno));
 		goto error;
 	}
 	if(ret == 0) {
 		/* EOF */
-		LM_CRIT("receive_fd: EOF on %d\n", pipe_fd);
+		LM_CRIT("EOF on %d\n", pipe_fd);
 		goto error;
 	}
 	if(ret != sizeof(peer *)) {
-		LM_WARN("receive_fd: different number of bytes received than expected "
+		LM_WARN("different number of bytes received than expected "
 				"(%d from %ld)"
 				"trying to fix...\n",
 				ret, (long int)sizeof(peer *));
@@ -410,22 +405,21 @@ again:
 	cmsg = CMSG_FIRSTHDR(&msg);
 	if((cmsg != 0) && (cmsg->cmsg_len == CMSG_LEN(sizeof(new_fd)))) {
 		if(cmsg->cmsg_type != SCM_RIGHTS) {
-			LM_ERR("receive_fd: msg control type != SCM_RIGHTS\n");
+			LM_ERR("msg control type != SCM_RIGHTS\n");
 			goto error;
 		}
 		if(cmsg->cmsg_level != SOL_SOCKET) {
-			LM_ERR("receive_fd: msg level != SOL_SOCKET\n");
+			LM_ERR("msg level != SOL_SOCKET\n");
 			goto error;
 		}
 		tmp = (int *)CMSG_DATA(cmsg);
 		*fd = *tmp;
 	} else {
 		if(!cmsg)
-			LM_ERR("receive_fd: no descriptor passed, empty control message\n");
+			LM_ERR("no descriptor passed, empty control message\n");
 		else
-			LM_ERR("receive_fd: no descriptor passed, cmsg=%p,"
-				   "len=%d\n",
-					cmsg, (unsigned)cmsg->cmsg_len);
+			LM_ERR("no descriptor passed, cmsg=%p,len=%d\n", cmsg,
+					(unsigned)cmsg->cmsg_len);
 		*fd = -1;
 		*p = 0;
 		/* it's not really an error */
@@ -434,9 +428,7 @@ again:
 	if(msg.msg_accrightslen == sizeof(int)) {
 		*fd = new_fd;
 	} else {
-		LM_ERR("receive_fd: no descriptor passed,"
-			   " accrightslen=%d\n",
-				msg.msg_accrightslen);
+		LM_ERR("no descriptor passed, accrightslen=%d\n", msg.msg_accrightslen);
 		*fd = -1;
 	}
 #endif
@@ -457,8 +449,7 @@ int receiver_init(peer *p)
 			[2]; /**< pipe to pass file descriptors towards this process */
 
 	if(socketpair(AF_UNIX, SOCK_STREAM, 0, fd_exchange_pipe) < 0) {
-		LM_ERR("receiver_init(): socketpair(fd_exchanged_pipe) failed > %s\n",
-				strerror(errno));
+		LM_ERR("socketpair(fd_exchanged_pipe) failed > %s\n", strerror(errno));
 		return 0;
 	}
 	if(p) {
@@ -479,32 +470,31 @@ int receiver_init(peer *p)
  */
 void receiver_process(peer *p)
 {
-	LM_INFO("receiver_process(): [%.*s] Receiver process doing init on new "
+	LM_INFO("[%.*s] Receiver process doing init on new "
 			"process...\n",
 			p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
 	if(p)
 		if(!add_serviced_peer(p))
 			goto done;
 
-	LM_INFO("receiver_process(): [%.*s] Receiver process starting up...\n",
-			p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
+	LM_INFO("[%.*s] Receiver process starting up...\n", p ? p->fqdn.len : 0,
+			p ? p->fqdn.s : 0);
 
 	log_serviced_peers();
 
 	if(receive_loop(p) < 0) {
-		LM_INFO("receiver_process(): [%.*s] receive_loop() return -1 "
-				"(error)!\n",
+		LM_INFO("[%.*s] receive_loop() return -1 (error)!\n",
 				p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
 	}
 
 done:
 	if(!*shutdownx) {
-		LM_INFO("receiver_process(): [%.*s]... Receiver process cleaning-up - "
+		LM_INFO("[%.*s]... Receiver process cleaning-up - "
 				"should not happen unless shutting down!\n",
 				p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
 	}
-	LM_INFO("receiver_process(): [%.*s]... Receiver process cleaning-up.\n",
-			p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
+	LM_INFO("[%.*s]... Receiver process cleaning-up.\n", p ? p->fqdn.len : 0,
+			p ? p->fqdn.s : 0);
 
 	while(serviced_peers) {
 		disconnect_serviced_peer(serviced_peers, 0);
@@ -528,8 +518,8 @@ done:
 #endif
 #endif
 
-	LM_INFO("receiver_process(): [%.*s]... Receiver process finished.\n",
-			p ? p->fqdn.len : 0, p ? p->fqdn.s : 0);
+	LM_INFO("[%.*s]... Receiver process finished.\n", p ? p->fqdn.len : 0,
+			p ? p->fqdn.s : 0);
 	exit(0);
 }
 
@@ -591,9 +581,8 @@ static inline int do_receive(serviced_peer_t *sp)
 			break;
 
 		default:
-			LM_ERR("do_receive(): [%.*s] Unknown state %d\n",
-					sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0,
-					sp->state);
+			LM_ERR("[%.*s] Unknown state %d\n", sp->p ? sp->p->fqdn.len : 0,
+					sp->p ? sp->p->fqdn.s : 0, sp->state);
 			goto error_and_reset;
 	}
 
@@ -606,7 +595,7 @@ static inline int do_receive(serviced_peer_t *sp)
 		case Receiver_Waiting:
 			version = (unsigned char)(sp->buf[0]);
 			if(version != 1) {
-				LM_ERR("do_receive(): [%.*s] Received Unknown version [%d]\n",
+				LM_ERR("[%.*s] Received Unknown version [%d]\n",
 						sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0,
 						(unsigned char)sp->buf[0]);
 				goto error_and_reset;
@@ -621,7 +610,7 @@ static inline int do_receive(serviced_peer_t *sp)
 			if(sp->buf_len == DIAMETER_HEADER_LEN) {
 				sp->length = get_3bytes(sp->buf + 1);
 				if(sp->length > DP_MAX_MSG_LENGTH) {
-					LM_ERR("do_receive(): [%.*s] Msg too big [%d] bytes\n",
+					LM_ERR("[%.*s] Msg too big [%d] bytes\n",
 							sp->p ? sp->p->fqdn.len : 0,
 							sp->p ? sp->p->fqdn.s : 0, sp->length);
 					goto error_and_reset;
@@ -660,9 +649,8 @@ static inline int do_receive(serviced_peer_t *sp)
 			break;
 
 		default:
-			LM_ERR("do_receive(): [%.*s] Unknown state %d\n",
-					sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0,
-					sp->state);
+			LM_ERR("[%.*s] Unknown state %d\n", sp->p ? sp->p->fqdn.len : 0,
+					sp->p ? sp->p->fqdn.s : 0, sp->state);
 			goto error_and_reset;
 	}
 
@@ -781,7 +769,7 @@ int receive_loop(peer *original_peer)
 			if(n == -1) {
 				if(shutdownx && *shutdownx)
 					return 0;
-				LM_ERR("select_recv(): %s\n", strerror(errno));
+				LM_ERR("%s\n", strerror(errno));
 				for(sp = serviced_peers; sp; sp = sp2) {
 					sp2 = sp->next;
 					disconnect_serviced_peer(sp, 0);
@@ -794,15 +782,15 @@ int receive_loop(peer *original_peer)
 
 				if(FD_ISSET(fd_exchange_pipe_local, &rfds)) {
 					/* fd exchange */
-					LM_DBG("select_recv(): There is something on the fd "
+					LM_DBG("There is something on the fd "
 						   "exchange pipe\n");
 					p = 0;
 					fd = -1;
 					if(!receive_fd(fd_exchange_pipe_local, &fd, &p)) {
-						LM_ERR("select_recv(): Error reading from fd exchange "
+						LM_ERR("Error reading from fd exchange "
 							   "pipe\n");
 					} else {
-						LM_DBG("select_recv(): fd exchange pipe says fd [%d] "
+						LM_DBG("fd exchange pipe says fd [%d] "
 							   "for peer %p:[%.*s]\n",
 								fd, p, p ? p->fqdn.len : 0, p ? p->fqdn.s : "");
 						if(p) {
@@ -854,7 +842,7 @@ int receive_loop(peer *original_peer)
 
 				for(sp = serviced_peers; sp;) {
 					if(sp->tcp_socket >= 0 && FD_ISSET(sp->tcp_socket, &efds)) {
-						LM_INFO("select_recv(): [%.*s] Peer socket [%d] found "
+						LM_INFO("[%.*s] Peer socket [%d] found "
 								"on the exception list... dropping\n",
 								sp->p ? sp->p->fqdn.len : 0,
 								sp->p ? sp->p->fqdn.s : "", sp->tcp_socket);
@@ -863,13 +851,13 @@ int receive_loop(peer *original_peer)
 					if(sp->send_pipe_fd >= 0
 							&& FD_ISSET(sp->send_pipe_fd, &rfds)) {
 						/* send */
-						LM_DBG("select_recv(): There is something on the send "
+						LM_DBG("There is something on the send "
 							   "pipe\n");
 						cnt = read(
 								sp->send_pipe_fd, &msg, sizeof(AAAMessage *));
 						if(cnt == 0) {
 							//This is very stupid and might not work well - dropped messages... to be fixed
-							LM_INFO("select_recv(): ReOpening pipe for read. "
+							LM_INFO("ReOpening pipe for read. "
 									"This should not happen...\n");
 							close(sp->send_pipe_fd);
 							sp->send_pipe_fd = open(
@@ -878,14 +866,13 @@ int receive_loop(peer *original_peer)
 						}
 						if(cnt < sizeof(AAAMessage *)) {
 							if(cnt < 0)
-								LM_ERR("select_recv(): Error reading from send "
+								LM_ERR("Error reading from send "
 									   "pipe\n");
 							goto receive;
 						}
-						LM_DBG("select_recv(): Send pipe says [%p] %d\n", msg,
-								cnt);
+						LM_DBG("Send pipe says [%p] %d\n", msg, cnt);
 						if(sp->tcp_socket < 0) {
-							LM_ERR("select_recv(): got a signal to send "
+							LM_ERR("got a signal to send "
 								   "something, but the connection was not "
 								   "opened\n");
 						} else {
@@ -893,7 +880,7 @@ int receive_loop(peer *original_peer)
 									== -1) {
 								if(errno == EINTR)
 									continue;
-								LM_ERR("select_recv(): [%.*s] write on socket "
+								LM_ERR("[%.*s] write on socket "
 									   "[%d] returned error> %s... dropping\n",
 										sp->p ? sp->p->fqdn.len : 0,
 										sp->p ? sp->p->fqdn.s : "",
@@ -907,7 +894,7 @@ int receive_loop(peer *original_peer)
 							}
 
 							if(cnt != msg->buf.len) {
-								LM_ERR("select_recv(): [%.*s] write on socket "
+								LM_ERR("[%.*s] write on socket "
 									   "[%d] only wrote %d/%d bytes... "
 									   "dropping\n",
 										sp->p ? sp->p->fqdn.len : 0,
@@ -933,7 +920,7 @@ int receive_loop(peer *original_peer)
 						};
 
 						if(cnt <= 0) {
-							LM_INFO("select_recv(): [%.*s] read on socket [%d] "
+							LM_INFO("[%.*s] read on socket [%d] "
 									"returned %d > %s... dropping\n",
 									sp->p ? sp->p->fqdn.len : 0,
 									sp->p ? sp->p->fqdn.s : "", sp->tcp_socket,
@@ -992,8 +979,8 @@ int peer_connect(peer *p)
 	error = getaddrinfo(p->fqdn.s, buf, &hints, &res);
 
 	if(error != 0) {
-		LM_WARN("peer_connect(): Error opening connection to %.*s:%d >%s\n",
-				p->fqdn.len, p->fqdn.s, p->port, gai_strerror(error));
+		LM_WARN("Error opening connection to %.*s:%d >%s\n", p->fqdn.len,
+				p->fqdn.s, p->port, gai_strerror(error));
 		goto error;
 	}
 
@@ -1001,14 +988,13 @@ int peer_connect(peer *p)
 		if(getnameinfo(ainfo->ai_addr, ainfo->ai_addrlen, host, 256, serv, 256,
 				   NI_NUMERICHOST | NI_NUMERICSERV)
 				== 0) {
-			LM_INFO("peer_connect(): Trying to connect to %s port %s\n", host,
-					serv);
+			LM_INFO("Trying to connect to %s port %s\n", host, serv);
 		}
 
 		if((sock = socket(
 					ainfo->ai_family, ainfo->ai_socktype, ainfo->ai_protocol))
 				== -1) {
-			LM_ERR("peer_connect(): error creating client socket to %s port %s "
+			LM_ERR("error creating client socket to %s port %s "
 				   ">"
 				   " %s\n",
 					host, serv, strerror(errno));
@@ -1017,20 +1003,20 @@ int peer_connect(peer *p)
 
 		/* try to set the local socket used to connect to the peer */
 		if(p->src_addr.s && p->src_addr.len > 0) {
-			LM_DBG("peer_connect(): connecting to peer via src addr=%.*s\n",
-					p->src_addr.len, p->src_addr.s);
+			LM_DBG("connecting to peer via src addr=%.*s\n", p->src_addr.len,
+					p->src_addr.s);
 			memset(&hints, 0, sizeof(hints));
 			hints.ai_flags = AI_NUMERICHOST;
 			hints.ai_socktype = SOCK_STREAM;
 			error = getaddrinfo(p->src_addr.s, NULL, &hints, &sainfo);
 
 			if(error != 0) {
-				LM_ERR("peer_connect(): error getting client socket on "
+				LM_ERR("error getting client socket on "
 					   "%.*s:%s\n",
 						p->src_addr.len, p->src_addr.s, gai_strerror(error));
 			} else {
 				if(bind(sock, sainfo->ai_addr, sainfo->ai_addrlen)) {
-					LM_ERR("peer_connect(): error opening client socket on "
+					LM_ERR("error opening client socket on "
 						   "%.*s:%s\n",
 							p->src_addr.len, p->src_addr.s, strerror(errno));
 				}
@@ -1059,7 +1045,7 @@ int peer_connect(peer *p)
 						getsockopt(sock, SOL_SOCKET, SO_ERROR,
 								(void *)(&valopt), &lon);
 						if(valopt) {
-							LM_ERR("peer_connect(): Error opening connection "
+							LM_ERR("Error opening connection "
 								   "to to %s port %s >%s\n",
 									host, serv, strerror(valopt));
 							close(sock);
@@ -1067,7 +1053,7 @@ int peer_connect(peer *p)
 							continue;
 						}
 					} else {
-						LM_ERR("peer_connect(): Timeout or error opening "
+						LM_ERR("Timeout or error opening "
 							   "connection to to %s port %s >%s\n",
 								host, serv, strerror(errno));
 						close(sock);
@@ -1076,7 +1062,7 @@ int peer_connect(peer *p)
 					}
 				}
 			} else {
-				LM_ERR("peer_connect(): Error opening connection to to %s port "
+				LM_ERR("Error opening connection to to %s port "
 					   "%s >%s\n",
 						host, serv, strerror(errno));
 				close(sock);
@@ -1101,11 +1087,10 @@ int peer_connect(peer *p)
 			LM_ERR("could not set socket options\n");
 			goto error;
 		}
-		LM_INFO("peer_connect(): Peer %.*s:%d connected\n", p->fqdn.len,
-				p->fqdn.s, p->port);
+		LM_INFO("Peer %.*s:%d connected\n", p->fqdn.len, p->fqdn.s, p->port);
 
 		if(!send_fd(p->fd_exchange_pipe, sock, p)) {
-			LM_ERR("peer_connect(): [%.*s] Error sending fd to respective "
+			LM_ERR("[%.*s] Error sending fd to respective "
 				   "receiver\n",
 					p->fqdn.len, p->fqdn.s);
 			goto error;
@@ -1161,26 +1146,25 @@ int peer_send_msg(peer *p, AAAMessage *msg)
 	if(!AAABuildMsgBuffer(msg))
 		return 0;
 	if(!p->send_pipe_name.s) {
-		LM_ERR("peer_send_msg(): Peer %.*s has no attached send pipe\n",
-				p->fqdn.len, p->fqdn.s);
+		LM_ERR("Peer %.*s has no attached send pipe\n", p->fqdn.len, p->fqdn.s);
 		return 0;
 	}
 	fd = open(p->send_pipe_name.s, O_WRONLY);
 	if(fd < 0) {
-		LM_ERR("peer_send_msg(): Peer %.*s error on pipe open > %s\n",
-				p->fqdn.len, p->fqdn.s, strerror(errno));
+		LM_ERR("Peer %.*s error on pipe open > %s\n", p->fqdn.len, p->fqdn.s,
+				strerror(errno));
 		return 0;
 	}
-	LM_DBG("peer_send_msg(): Pipe push [%p]\n", msg);
+	LM_DBG("Pipe push [%p]\n", msg);
 	n = write(fd, &msg, sizeof(AAAMessage *));
 	if(n < 0) {
-		LM_ERR("peer_send_msg(): Peer %.*s error on pipe write > %s\n",
-				p->fqdn.len, p->fqdn.s, strerror(errno));
+		LM_ERR("Peer %.*s error on pipe write > %s\n", p->fqdn.len, p->fqdn.s,
+				strerror(errno));
 		close(fd);
 		return 0;
 	}
 	if(n != sizeof(AAAMessage *)) {
-		LM_ERR("peer_send_msg(): Peer %.*s error on pipe write > only %d bytes "
+		LM_ERR("Peer %.*s error on pipe write > only %d bytes "
 			   "written\n",
 				p->fqdn.len, p->fqdn.s, n);
 		close(fd);
@@ -1209,8 +1193,7 @@ int peer_send(peer *p, int sock, AAAMessage *msg, int locked)
 
 	if(!p || !msg || sock < 0)
 		return 0;
-	LM_DBG("peer_send(): [%.*s] sending direct message to peer\n", p->fqdn.len,
-			p->fqdn.s);
+	LM_DBG("[%.*s] sending direct message to peer\n", p->fqdn.len, p->fqdn.s);
 
 	if(!AAABuildMsgBuffer(msg))
 		return 0;
@@ -1221,7 +1204,7 @@ int peer_send(peer *p, int sock, AAAMessage *msg, int locked)
 	while((n = write(sock, msg->buf.s, msg->buf.len)) == -1) {
 		if(errno == EINTR)
 			continue;
-		LM_ERR("peer_send(): write returned error: %s\n", strerror(errno));
+		LM_ERR("write returned error: %s\n", strerror(errno));
 		if(p->I_sock == sock)
 			sm_process(p, I_Peer_Disc, 0, 1, p->I_sock);
 		if(p->R_sock == sock)
@@ -1233,7 +1216,7 @@ int peer_send(peer *p, int sock, AAAMessage *msg, int locked)
 	}
 
 	if(n != msg->buf.len) {
-		LM_ERR("peer_send(): only wrote %d/%d bytes\n", n, msg->buf.len);
+		LM_ERR("only wrote %d/%d bytes\n", n, msg->buf.len);
 		if(!locked)
 			lock_release(p->lock);
 		AAAFreeMessage(&msg);
@@ -1246,8 +1229,7 @@ int peer_send(peer *p, int sock, AAAMessage *msg, int locked)
 
 	/* now switch the peer processing to its dedicated process if this is not a dynamic peer */
 	if(!p->is_dynamic) {
-		LM_DBG("peer_send(): [%.*s] switching peer to own and dedicated "
-			   "receiver\n",
+		LM_DBG("[%.*s] switching peer to own and dedicated receiver\n",
 				p->fqdn.len, p->fqdn.s);
 		send_fd(p->fd_exchange_pipe, sock, p);
 		for(sp = serviced_peers; sp; sp = sp->next)
@@ -1271,9 +1253,8 @@ int peer_send(peer *p, int sock, AAAMessage *msg, int locked)
 void receive_message(AAAMessage *msg, serviced_peer_t *sp)
 {
 	AAA_AVP *avp1, *avp2;
-	LM_DBG("receive_message(): [%.*s] Recv msg %d\n",
-			sp->p ? sp->p->fqdn.len : 0, sp->p ? sp->p->fqdn.s : 0,
-			msg->commandCode);
+	LM_DBG("[%.*s] Recv msg %d\n", sp->p ? sp->p->fqdn.len : 0,
+			sp->p ? sp->p->fqdn.s : 0, msg->commandCode);
 
 	if(!sp->p) {
 		switch(msg->commandCode) {
@@ -1287,13 +1268,12 @@ void receive_message(AAAMessage *msg, serviced_peer_t *sp)
 						sp->p = get_peer_from_fqdn(avp1->data, avp2->data);
 					}
 					if(!sp->p) {
-						LM_ERR("receive_msg(): Received CER from unknown peer "
+						LM_ERR("Received CER from unknown peer "
 							   "(accept unknown=%d) -ignored\n",
 								config->accept_unknown_peers);
 						AAAFreeMessage(&msg);
 					} else {
-						LM_DBG("receive_message(): [%.*s] This receiver has no "
-							   "peer associated\n",
+						LM_DBG("[%.*s] This receiver has no peer associated\n",
 								sp->p ? sp->p->fqdn.len : 0,
 								sp->p ? sp->p->fqdn.s : 0);
 						//set_peer_pipe();
@@ -1301,14 +1281,12 @@ void receive_message(AAAMessage *msg, serviced_peer_t *sp)
 						sm_process(sp->p, R_Conn_CER, msg, 0, sp->tcp_socket);
 					}
 				} else {
-					LM_ERR("receive_msg(): Received CEA from an unknown peer "
-						   "-ignored\n");
+					LM_ERR("Received CEA from an unknown peer -ignored\n");
 					AAAFreeMessage(&msg);
 				}
 				break;
 			default:
-				LM_ERR("receive_msg(): Received non-CE from an unknown peer "
-					   "-ignored\n");
+				LM_ERR("Received non-CE from an unknown peer -ignored\n");
 				AAAFreeMessage(&msg);
 		}
 	} else {
@@ -1383,7 +1361,7 @@ void receive_message(AAAMessage *msg, serviced_peer_t *sp)
 				}
 				break;
 			default:
-				LM_ERR("receive_msg(): [%.*s] Received msg while peer in state "
+				LM_ERR("[%.*s] Received msg while peer in state "
 					   "%d -ignored\n",
 						sp->p->fqdn.len, sp->p->fqdn.s, sp->p->state);
 				AAAFreeMessage(&msg);

+ 4 - 4
src/modules/cdp/routing.c

@@ -200,7 +200,7 @@ peer *get_routing_peer_by_app_id(cdp_session_t *cdp_session,
 	routing_realm *rr = 0;
 
 	if(!config->r_table) {
-		LM_ERR("get_routing_peer(): Empty routing table.\n");
+		LM_ERR("Empty routing table.\n");
 		return 0;
 	}
 
@@ -219,7 +219,7 @@ peer *get_routing_peer_by_app_id(cdp_session_t *cdp_session,
 			if(p)
 				return p;
 			else
-				LM_WARN("get_routing_peer_by_app_id(): No connected Route peer "
+				LM_WARN("No connected Route peer "
 						"found for Realm <%.*s>. Trying DefaultRoutes "
 						"next...\n",
 						destination_realm.len, destination_realm.s);
@@ -231,7 +231,7 @@ peer *get_routing_peer_by_app_id(cdp_session_t *cdp_session,
 	p = get_first_connected_route(
 			cdp_session, config->r_table->routes, app_id, vendor_id);
 	if(!p) {
-		LM_WARN("get_routing_peer_by_app_id(): No connected DefaultRoute peer "
+		LM_WARN("No connected DefaultRoute peer "
 				"found for app_id %d and vendor_id %d.\n",
 				app_id, vendor_id);
 	}
@@ -272,7 +272,7 @@ peer *get_routing_peer(cdp_session_t *cdp_session, AAAMessage *m)
 	}
 
 	if(!config->r_table) {
-		LM_ERR("get_routing_peer(): Empty routing table.\n");
+		LM_ERR("Empty routing table.\n");
 		return 0;
 	}
 

+ 9 - 12
src/modules/cdp/session.c

@@ -80,9 +80,8 @@ inline void AAASessionsLock(unsigned int hash)
 	if(hash < sessions_hash_size) {
 		lock_get(sessions[hash].lock);
 	} else {
-		LM_ERR("AAASessionsLock: hash :%d out of range of sessions_hash_size: "
-			   "%d !\n",
-				hash, sessions_hash_size);
+		LM_ERR("hash :%d out of range of sessions_hash_size: %d !\n", hash,
+				sessions_hash_size);
 	}
 }
 
@@ -97,9 +96,8 @@ inline void AAASessionsUnlock(unsigned int hash)
 	if(hash < sessions_hash_size) {
 		lock_release(sessions[hash].lock);
 	} else {
-		LM_ERR("AAASessionsLock: hash :%d out of range of sessions_hash_size: "
-			   "%d !\n",
-				hash, sessions_hash_size);
+		LM_ERR("hash :%d out of range of sessions_hash_size: %d !\n", hash,
+				sessions_hash_size);
 	}
 }
 
@@ -115,7 +113,7 @@ void free_session(cdp_session_t *x)
 		switch(x->type) {
 			case UNKNOWN_SESSION:
 				if(x->u.generic_data) {
-					LM_ERR("free_session(): The session->u.generic_data should "
+					LM_ERR("The session->u.generic_data should "
 						   "be freed and reset before dropping the session!"
 						   "Possible memory leak!\n");
 				}
@@ -127,7 +125,7 @@ void free_session(cdp_session_t *x)
 			case ACCT_CC_CLIENT:
 				break;
 			default:
-				LM_ERR("free_session(): Unknown session type %d!\n", x->type);
+				LM_ERR("Unknown session type %d!\n", x->type);
 		}
 
 		if(x->dest_host.s)
@@ -343,9 +341,8 @@ void del_session(cdp_session_t *x)
 
 	hash = x->hash;
 	if(hash >= sessions_hash_size) {
-		LM_ERR("del_session: x->hash :%d out of range of sessions_hash_size: "
-			   "%d !\n",
-				hash, sessions_hash_size);
+		LM_ERR("x->hash :%d out of range of sessions_hash_size: %d !\n", hash,
+				sessions_hash_size);
 		return;
 	}
 
@@ -386,7 +383,7 @@ static int generate_session_id(str *id, unsigned int end_pad_len)
 	/* get some memory for it */
 	id->s = (char *)shm_malloc(id->len);
 	if(id->s == 0) {
-		LM_ERR("generate_session_id: no more free memory!\n");
+		LM_ERR("no more free memory!\n");
 		goto error;
 	}
 

+ 12 - 12
src/modules/cdp/tcp_accept.c

@@ -105,7 +105,7 @@ int create_socket(
 	if(bind_to.len) {
 		error = getaddrinfo(bind_to.s, buf, &hints, &res);
 		if(error != 0) {
-			LM_WARN("create_socket(): Error opening %.*s port %d while doing "
+			LM_WARN("Error opening %.*s port %d while doing "
 					"gethostbyname >%s\n",
 					bind_to.len, bind_to.s, listen_port, gai_strerror(error));
 			goto error;
@@ -113,7 +113,7 @@ int create_socket(
 	} else {
 		error = getaddrinfo(NULL, buf, &hints, &res);
 		if(error != 0) {
-			LM_WARN("create_socket(): Error opening ANY port %d while doing "
+			LM_WARN("Error opening ANY port %d while doing "
 					"gethostbyname >%s\n",
 					listen_port, gai_strerror(error));
 			goto error;
@@ -126,7 +126,7 @@ int create_socket(
 		if(getnameinfo(ainfo->ai_addr, ainfo->ai_addrlen, host, 256, serv, 256,
 				   NI_NUMERICHOST | NI_NUMERICSERV)
 				== 0) {
-			LM_WARN("create_socket(): Trying to open/bind/listen on %s port "
+			LM_WARN("Trying to open/bind/listen on %s port "
 					"%s\n",
 					host, serv);
 		}
@@ -134,7 +134,7 @@ int create_socket(
 		if((server_sock = socket(
 					ainfo->ai_family, ainfo->ai_socktype, ainfo->ai_protocol))
 				== -1) {
-			LM_ERR("create_socket(): error creating server socket on %s port "
+			LM_ERR("error creating server socket on %s port "
 				   "%s >"
 				   " %s\n",
 					host, serv, strerror(errno));
@@ -148,21 +148,21 @@ int create_socket(
 		}
 
 		if(bind(server_sock, ainfo->ai_addr, ainfo->ai_addrlen) == -1) {
-			LM_ERR("create_socket(): error binding on %s port %s >"
+			LM_ERR("error binding on %s port %s >"
 				   " %s\n",
 					host, serv, strerror(errno));
 			goto error;
 		}
 
 		if(listen(server_sock, 5) == -1) {
-			LM_ERR("create_socket(): error listening on %s port %s > %s\n",
-					host, serv, strerror(errno));
+			LM_ERR("error listening on %s port %s > %s\n", host, serv,
+					strerror(errno));
 			goto error;
 		}
 
 		*sock = server_sock;
 
-		LM_WARN("create_socket(): Successful socket open/bind/listen on %s "
+		LM_WARN("Successful socket open/bind/listen on %s "
 				"port %s\n",
 				host, serv);
 	}
@@ -193,10 +193,10 @@ inline static int accept_connection(int server_sock, int *new_sock)
 	*new_sock = accept(server_sock, (struct sockaddr *)&remote, &length);
 
 	if(*new_sock == -1) {
-		LM_ERR("accept_connection(): accept failed!\n");
+		LM_ERR("accept failed!\n");
 		goto error;
 	} else {
-		LM_INFO("accept_connection(): new tcp connection accepted!\n");
+		LM_INFO("new tcp connection accepted!\n");
 	}
 
 	receiver_send_socket(*new_sock, 0);
@@ -243,14 +243,14 @@ void accept_loop()
 		nready = select(max_sock + 1, &listen_set, 0, 0, &timeout);
 		if(nready == 0) {
 			if(debug_heavy)
-				LM_DBG("accept_loop(): No connection attempts\n");
+				LM_DBG("No connection attempts\n");
 			continue;
 		}
 		if(nready == -1) {
 			if(errno == EINTR) {
 				continue;
 			} else {
-				LM_ERR("accept_loop(): select fails: %s\n", strerror(errno));
+				LM_ERR("select fails: %s\n", strerror(errno));
 				sleep(2);
 				continue;
 			}

+ 1 - 2
src/modules/cdp/worker.c

@@ -373,8 +373,7 @@ void worker_process(int id)
 					tasks->end);
 			continue;
 		}
-		LM_DBG("worker_process(): [%d] got task Q(%d/%d)\n", id, tasks->start,
-				tasks->end);
+		LM_DBG("[%d] got task Q(%d/%d)\n", id, tasks->start, tasks->end);
 		r = is_req(t.msg);
 		for(cb = callbacks->head; cb; cb = cb->next)
 			(*(cb->cb))(t.p, t.msg, *(cb->ptr));