version 4.0.7.1
[ric-plt/e2.git] / RIC-E2-TERMINATION / sctpThread.cpp
1 // Copyright 2019 AT&T Intellectual Property
2 // Copyright 2019 Nokia
3 //
4 // Licensed under the Apache License, Version 2.0 (the "License");
5 // you may not use this file except in compliance with the License.
6 // You may obtain a copy of the License at
7 //
8 //      http://www.apache.org/licenses/LICENSE-2.0
9 //
10 // Unless required by applicable law or agreed to in writing, software
11 // distributed under the License is distributed on an "AS IS" BASIS,
12 // WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
13 // See the License for the specific language governing permissions and
14 // limitations under the License.
15
16 //  This source code is part of the near-RT RIC (RAN Intelligent Controller)
17 //  platform project (RICP).
18
19 // TODO: High-level file comment.
20
21
22
23 #include <3rdparty/oranE2/RANfunctions-List.h>
24 #include "sctpThread.h"
25 #include "BuildRunName.h"
26
27 #include "3rdparty/oranE2SM/E2SM-gNB-NRT-RANfunction-Definition.h"
28 #include "BuildXml.h"
29 #include "pugixml/src/pugixml.hpp"
30
31 using namespace std;
32 //using namespace std::placeholders;
33 using namespace boost::filesystem;
34
35 //#ifdef __cplusplus
36 //extern "C"
37 //{
38 //#endif
39
40 // need to expose without the include of gcov
41 extern "C" void __gcov_flush(void);
42
43 static void catch_function(int signal) {
44     __gcov_flush();
45     exit(signal);
46 }
47
48
49 BOOST_LOG_INLINE_GLOBAL_LOGGER_DEFAULT(my_logger, src::logger_mt)
50
51 boost::shared_ptr<sinks::synchronous_sink<sinks::text_file_backend>> boostLogger;
52 double cpuClock = 0.0;
53 bool jsonTrace = true;
54
55 void init_log() {
56     mdclog_attr_t *attr;
57     mdclog_attr_init(&attr);
58     mdclog_attr_set_ident(attr, "E2Terminator");
59     mdclog_init(attr);
60     mdclog_attr_destroy(attr);
61 }
62 auto start_time = std::chrono::high_resolution_clock::now();
63 typedef std::chrono::duration<double, std::ratio<1,1>> seconds_t;
64
65 double age() {
66     return seconds_t(std::chrono::high_resolution_clock::now() - start_time).count();
67 }
68
69 double approx_CPU_MHz(unsigned sleeptime) {
70     using namespace std::chrono_literals;
71     uint32_t aux = 0;
72     uint64_t cycles_start = rdtscp(aux);
73     double time_start = age();
74     std::this_thread::sleep_for(sleeptime * 1ms);
75     uint64_t elapsed_cycles = rdtscp(aux) - cycles_start;
76     double elapsed_time = age() - time_start;
77     return elapsed_cycles / elapsed_time;
78 }
79
80 //std::atomic<int64_t> rmrCounter{0};
81 std::atomic<int64_t> num_of_messages{0};
82 std::atomic<int64_t> num_of_XAPP_messages{0};
83 static long transactionCounter = 0;
84
85 int buildListeningPort(sctp_params_t &sctpParams) {
86     sctpParams.listenFD = socket (AF_INET6, SOCK_STREAM, IPPROTO_SCTP);
87     struct sockaddr_in6 servaddr {};
88     servaddr.sin6_family = AF_INET6;
89     servaddr.sin6_addr   = in6addr_any;
90     servaddr.sin6_port = htons(sctpParams.sctpPort);
91     if (bind(sctpParams.listenFD, (SA *)&servaddr, sizeof(servaddr)) < 0 ) {
92         mdclog_write(MDCLOG_ERR, "Error binding. %s\n", strerror(errno));
93         return -1;
94     }
95     if (setSocketNoBlocking(sctpParams.listenFD) == -1) {
96         //mdclog_write(MDCLOG_ERR, "Error binding. %s", strerror(errno));
97         return -1;
98     }
99     if (mdclog_level_get() >= MDCLOG_DEBUG) {
100         struct sockaddr_in6 cliaddr {};
101         socklen_t len = sizeof(cliaddr);
102         getsockname(sctpParams.listenFD, (SA *)&cliaddr, &len);
103         char buff[1024] {};
104         inet_ntop(AF_INET6, &cliaddr.sin6_addr, buff, sizeof(buff));
105         mdclog_write(MDCLOG_DEBUG, "My address: %s, port %d\n", buff, htons(cliaddr.sin6_port));
106     }
107
108     if (listen(sctpParams.listenFD, SOMAXCONN) < 0) {
109         mdclog_write(MDCLOG_ERR, "Error listening. %s\n", strerror(errno));
110         return -1;
111     }
112     struct epoll_event event {};
113     event.events = EPOLLIN | EPOLLET;
114     event.data.fd = sctpParams.listenFD;
115
116     // add listening port to epoll
117     if (epoll_ctl(sctpParams.epoll_fd, EPOLL_CTL_ADD, sctpParams.listenFD, &event)) {
118         printf("Failed to add descriptor to epoll\n");
119         mdclog_write(MDCLOG_ERR, "Failed to add descriptor to epoll. %s\n", strerror(errno));
120         return -1;
121     }
122
123     return 0;
124 }
125
126 int buildConfiguration(sctp_params_t &sctpParams) {
127     path p = (sctpParams.configFilePath + "/" + sctpParams.configFileName).c_str();
128     if (exists(p)) {
129         const int size = 2048;
130         auto fileSize = file_size(p);
131         if (fileSize > size) {
132             mdclog_write(MDCLOG_ERR, "File %s larger than %d", p.string().c_str(), size);
133             return -1;
134         }
135     } else {
136         mdclog_write(MDCLOG_ERR, "Configuration File %s not exists", p.string().c_str());
137         return -1;
138     }
139
140     ReadConfigFile conf;
141     if (conf.openConfigFile(p.string()) == -1) {
142         mdclog_write(MDCLOG_ERR, "Filed to open config file %s, %s",
143                      p.string().c_str(), strerror(errno));
144         return -1;
145     }
146     int rmrPort = conf.getIntValue("nano");
147     if (rmrPort == -1) {
148         mdclog_write(MDCLOG_ERR, "illigal RMR port ");
149         return -1;
150     }
151     sctpParams.rmrPort = (uint16_t)rmrPort;
152     snprintf(sctpParams.rmrAddress, sizeof(sctpParams.rmrAddress), "%d", (int) (sctpParams.rmrPort));
153
154     auto tmpStr = conf.getStringValue("loglevel");
155     if (tmpStr.length() == 0) {
156         mdclog_write(MDCLOG_ERR, "illigal loglevel. Set loglevel to MDCLOG_INFO");
157         tmpStr = "info";
158     }
159     transform(tmpStr.begin(), tmpStr.end(), tmpStr.begin(), ::tolower);
160
161     if ((tmpStr.compare("debug")) == 0) {
162         sctpParams.logLevel = MDCLOG_DEBUG;
163     } else if ((tmpStr.compare("info")) == 0) {
164         sctpParams.logLevel = MDCLOG_INFO;
165     } else if ((tmpStr.compare("warning")) == 0) {
166         sctpParams.logLevel = MDCLOG_WARN;
167     } else if ((tmpStr.compare("error")) == 0) {
168         sctpParams.logLevel = MDCLOG_ERR;
169     } else {
170         mdclog_write(MDCLOG_ERR, "illigal loglevel = %s. Set loglevel to MDCLOG_INFO", tmpStr.c_str());
171         sctpParams.logLevel = MDCLOG_INFO;
172     }
173     mdclog_level_set(sctpParams.logLevel);
174
175     tmpStr = conf.getStringValue("volume");
176     if (tmpStr.length() == 0) {
177         mdclog_write(MDCLOG_ERR, "illigal volume.");
178         return -1;
179     }
180
181     char tmpLogFilespec[VOLUME_URL_SIZE];
182     tmpLogFilespec[0] = 0;
183     sctpParams.volume[0] = 0;
184     snprintf(sctpParams.volume, VOLUME_URL_SIZE, "%s", tmpStr.c_str());
185     // copy the name to temp file as well
186     snprintf(tmpLogFilespec, VOLUME_URL_SIZE, "%s", tmpStr.c_str());
187
188
189     // define the file name in the tmp directory under the volume
190     strcat(tmpLogFilespec,"/tmp/E2Term_%Y-%m-%d_%H-%M-%S.%N.tmpStr");
191
192     sctpParams.myIP = conf.getStringValue("local-ip");
193     if (sctpParams.myIP.length() == 0) {
194         mdclog_write(MDCLOG_ERR, "illigal local-ip.");
195         return -1;
196     }
197
198     int sctpPort = conf.getIntValue("sctp-port");
199     if (sctpPort == -1) {
200         mdclog_write(MDCLOG_ERR, "illigal SCTP port ");
201         return -1;
202     }
203     sctpParams.sctpPort = (uint16_t)sctpPort;
204
205     sctpParams.fqdn = conf.getStringValue("external-fqdn");
206     if (sctpParams.fqdn.length() == 0) {
207         mdclog_write(MDCLOG_ERR, "illigal external-fqdn");
208         return -1;
209     }
210
211     std::string pod = conf.getStringValue("pod_name");
212     if (pod.length() == 0) {
213         mdclog_write(MDCLOG_ERR, "illigal pod_name in config file");
214         return -1;
215     }
216     auto *podName = getenv(pod.c_str());
217     if (podName == nullptr) {
218         mdclog_write(MDCLOG_ERR, "illigal pod_name or environment varible not exists : %s", pod.c_str());
219         return -1;
220
221     } else {
222         sctpParams.podName.assign(podName);
223         if (sctpParams.podName.length() == 0) {
224             mdclog_write(MDCLOG_ERR, "illigal pod_name");
225             return -1;
226         }
227     }
228
229     tmpStr = conf.getStringValue("trace");
230     transform(tmpStr.begin(), tmpStr.end(), tmpStr.begin(), ::tolower);
231     if ((tmpStr.compare("start")) == 0) {
232         mdclog_write(MDCLOG_INFO, "Trace set to: start");
233         sctpParams.trace = true;
234     } else if ((tmpStr.compare("stop")) == 0) {
235         mdclog_write(MDCLOG_INFO, "Trace set to: stop");
236         sctpParams.trace = false;
237     }
238     jsonTrace = sctpParams.trace;
239
240     sctpParams.ka_message_length = snprintf(sctpParams.ka_message, KA_MESSAGE_SIZE, "{\"address\": \"%s:%d\","
241                                                                                     "\"fqdn\": \"%s\","
242                                                                                     "\"pod_name\": \"%s\"}",
243                                             (const char *)sctpParams.myIP.c_str(),
244                                             sctpParams.rmrPort,
245                                             sctpParams.fqdn.c_str(),
246                                             sctpParams.podName.c_str());
247
248     if (mdclog_level_get() >= MDCLOG_INFO) {
249         mdclog_mdc_add("RMR Port", to_string(sctpParams.rmrPort).c_str());
250         mdclog_mdc_add("LogLevel", to_string(sctpParams.logLevel).c_str());
251         mdclog_mdc_add("volume", sctpParams.volume);
252         mdclog_mdc_add("tmpLogFilespec", tmpLogFilespec);
253         mdclog_mdc_add("my ip", sctpParams.myIP.c_str());
254         mdclog_mdc_add("pod name", sctpParams.podName.c_str());
255
256         mdclog_write(MDCLOG_INFO, "running parameters for instance : %s", sctpParams.ka_message);
257     }
258     mdclog_mdc_clean();
259
260     // Files written to the current working directory
261     boostLogger = logging::add_file_log(
262             keywords::file_name = tmpLogFilespec, // to temp directory
263             keywords::rotation_size = 10 * 1024 * 1024,
264             keywords::time_based_rotation = sinks::file::rotation_at_time_interval(posix_time::hours(1)),
265             keywords::format = "%Message%"
266             //keywords::format = "[%TimeStamp%]: %Message%" // use each tmpStr with time stamp
267     );
268
269     // Setup a destination folder for collecting rotated (closed) files --since the same volumn can use rename()
270     boostLogger->locked_backend()->set_file_collector(sinks::file::make_collector(
271             keywords::target = sctpParams.volume
272     ));
273
274     // Upon restart, scan the directory for files matching the file_name pattern
275     boostLogger->locked_backend()->scan_for_files();
276
277     // Enable auto-flushing after each tmpStr record written
278     if (mdclog_level_get() >= MDCLOG_DEBUG) {
279         boostLogger->locked_backend()->auto_flush(true);
280     }
281
282     return 0;
283 }
284
285
286
287 int main(const int argc, char **argv) {
288     sctp_params_t sctpParams;
289
290     {
291         std::random_device device{};
292         std::mt19937 generator(device());
293         std::uniform_int_distribution<long> distribution(1, (long) 1e12);
294         transactionCounter = distribution(generator);
295     }
296
297 //    uint64_t st = 0;
298 //    uint32_t aux1 = 0;
299 //   st = rdtscp(aux1);
300
301     unsigned num_cpus = std::thread::hardware_concurrency();
302     init_log();
303     mdclog_level_set(MDCLOG_INFO);
304
305     if (std::signal(SIGINT, catch_function) == SIG_ERR) {
306         mdclog_write(MDCLOG_ERR, "Error initializing SIGINT");
307         exit(1);
308     }
309     if (std::signal(SIGABRT, catch_function)== SIG_ERR) {
310         mdclog_write(MDCLOG_ERR, "Error initializing SIGABRT");
311         exit(1);
312     }
313     if (std::signal(SIGTERM, catch_function)== SIG_ERR) {
314         mdclog_write(MDCLOG_ERR, "Error initializing SIGTERM");
315         exit(1);
316     }
317
318     cpuClock = approx_CPU_MHz(100);
319
320     mdclog_write(MDCLOG_DEBUG, "CPU speed %11.11f", cpuClock);
321
322     auto result = parse(argc, argv, sctpParams);
323
324     if (buildConfiguration(sctpParams) != 0) {
325         exit(-1);
326     }
327
328     // start epoll
329     sctpParams.epoll_fd = epoll_create1(0);
330     if (sctpParams.epoll_fd == -1) {
331         mdclog_write(MDCLOG_ERR, "failed to open epoll descriptor");
332         exit(-1);
333     }
334
335     getRmrContext(sctpParams);
336     if (sctpParams.rmrCtx == nullptr) {
337         close(sctpParams.epoll_fd);
338         exit(-1);
339     }
340
341     if (buildInotify(sctpParams) == -1) {
342         close(sctpParams.rmrListenFd);
343         rmr_close(sctpParams.rmrCtx);
344         close(sctpParams.epoll_fd);
345         exit(-1);
346     }
347
348     if (buildListeningPort(sctpParams) != 0) {
349         close(sctpParams.rmrListenFd);
350         rmr_close(sctpParams.rmrCtx);
351         close(sctpParams.epoll_fd);
352         exit(-1);
353     }
354
355     sctpParams.sctpMap = new mapWrapper();
356
357     std::vector<std::thread> threads(num_cpus);
358 //    std::vector<std::thread> threads;
359
360     num_cpus = 1;
361     for (unsigned int i = 0; i < num_cpus; i++) {
362         threads[i] = std::thread(listener, &sctpParams);
363
364         cpu_set_t cpuset;
365         CPU_ZERO(&cpuset);
366         CPU_SET(i, &cpuset);
367         int rc = pthread_setaffinity_np(threads[i].native_handle(), sizeof(cpu_set_t), &cpuset);
368         if (rc != 0) {
369             mdclog_write(MDCLOG_ERR, "Error calling pthread_setaffinity_np: %d", rc);
370         }
371     }
372
373     auto statFlag = false;
374     auto statThread = std::thread(statColectorThread, (void *)&statFlag);
375
376     //loop over term_init until first message from xApp
377     handleTermInit(sctpParams);
378
379     for (auto &t : threads) {
380         t.join();
381     }
382
383     statFlag = true;
384     statThread.join();
385
386     return 0;
387 }
388
389 void handleTermInit(sctp_params_t &sctpParams) {
390     sendTermInit(sctpParams);
391     //send to e2 manager init of e2 term
392     //E2_TERM_INIT
393
394     int count = 0;
395     while (true) {
396         auto xappMessages = num_of_XAPP_messages.load(std::memory_order_acquire);
397         if (xappMessages > 0) {
398             if (mdclog_level_get() >=  MDCLOG_INFO) {
399                 mdclog_write(MDCLOG_INFO, "Got a message from some appliction, stop sending E2_TERM_INIT");
400             }
401             return;
402         }
403         usleep(100000);
404         count++;
405         if (count % 1000 == 0) {
406             mdclog_write(MDCLOG_ERR, "GOT No messages from any xApp");
407             sendTermInit(sctpParams);
408         }
409     }
410 }
411
412 void sendTermInit(sctp_params_t &sctpParams) {
413     rmr_mbuf_t *msg = rmr_alloc_msg(sctpParams.rmrCtx, sctpParams.ka_message_length);
414     auto count = 0;
415     while (true) {
416         msg->mtype = E2_TERM_INIT;
417         msg->state = 0;
418         rmr_bytes2payload(msg, (unsigned char *)sctpParams.ka_message, sctpParams.ka_message_length);
419         static unsigned char tx[32];
420         auto txLen = snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
421         rmr_bytes2xact(msg, tx, txLen);
422         msg = rmr_send_msg(sctpParams.rmrCtx, msg);
423         if (msg == nullptr) {
424             msg = rmr_alloc_msg(sctpParams.rmrCtx, sctpParams.ka_message_length);
425         } else if (msg->state == 0) {
426             rmr_free_msg(msg);
427             if (mdclog_level_get() >=  MDCLOG_INFO) {
428                 mdclog_write(MDCLOG_INFO, "E2_TERM_INIT succsesfuly sent ");
429             }
430             return;
431         } else {
432             if (count % 100 == 0) {
433                 mdclog_write(MDCLOG_ERR, "Error sending E2_TERM_INIT cause : %s ", translateRmrErrorMessages(msg->state).c_str());
434             }
435             sleep(1);
436         }
437         count++;
438     }
439 }
440
441 /**
442  *
443  * @param argc
444  * @param argv
445  * @param sctpParams
446  * @return
447  */
448 cxxopts::ParseResult parse(int argc, char *argv[], sctp_params_t &sctpParams) {
449     cxxopts::Options options(argv[0], "e2 term help");
450     options.positional_help("[optional args]").show_positional_help();
451     options.allow_unrecognised_options().add_options()
452             ("p,path", "config file path", cxxopts::value<std::string>(sctpParams.configFilePath)->default_value("config"))
453             ("f,file", "config file name", cxxopts::value<std::string>(sctpParams.configFileName)->default_value("config.conf"))
454             ("h,help", "Print help");
455
456     auto result = options.parse(argc, argv);
457
458     if (result.count("help")) {
459         std::cout << options.help({""}) << std::endl;
460         exit(0);
461     }
462     return result;
463 }
464
465 /**
466  *
467  * @param sctpParams
468  * @return -1 failed 0 success
469  */
470 int buildInotify(sctp_params_t &sctpParams) {
471     sctpParams.inotifyFD = inotify_init1(IN_NONBLOCK);
472     if (sctpParams.inotifyFD == -1) {
473         mdclog_write(MDCLOG_ERR, "Failed to init inotify (inotify_init1) %s", strerror(errno));
474         close(sctpParams.rmrListenFd);
475         rmr_close(sctpParams.rmrCtx);
476         close(sctpParams.epoll_fd);
477         return -1;
478     }
479
480     sctpParams.inotifyWD = inotify_add_watch(sctpParams.inotifyFD,
481                                              (const char *)sctpParams.configFilePath.c_str(),
482                                              (unsigned)IN_OPEN | (unsigned)IN_CLOSE_WRITE | (unsigned)IN_CLOSE_NOWRITE); //IN_CLOSE = (IN_CLOSE_WRITE | IN_CLOSE_NOWRITE)
483     if (sctpParams.inotifyWD == -1) {
484         mdclog_write(MDCLOG_ERR, "Failed to add directory : %s to  inotify (inotify_add_watch) %s",
485                      sctpParams.configFilePath.c_str(),
486                      strerror(errno));
487         close(sctpParams.inotifyFD);
488         return -1;
489     }
490
491     struct epoll_event event{};
492     event.events = (EPOLLIN);
493     event.data.fd = sctpParams.inotifyFD;
494     // add listening RMR FD to epoll
495     if (epoll_ctl(sctpParams.epoll_fd, EPOLL_CTL_ADD, sctpParams.inotifyFD, &event)) {
496         mdclog_write(MDCLOG_ERR, "Failed to add inotify FD to epoll");
497         close(sctpParams.inotifyFD);
498         return -1;
499     }
500     return 0;
501 }
502
503 /**
504  *
505  * @param args
506  * @return
507  */
508 void listener(sctp_params_t *params) {
509     int num_of_SCTP_messages = 0;
510     auto totalTime = 0.0;
511     mdclog_mdc_clean();
512     mdclog_level_set(params->logLevel);
513
514     std::thread::id this_id = std::this_thread::get_id();
515     //save cout
516     streambuf *oldCout = cout.rdbuf();
517     ostringstream memCout;
518     // create new cout
519     cout.rdbuf(memCout.rdbuf());
520     cout << this_id;
521     //return to the normal cout
522     cout.rdbuf(oldCout);
523
524     char tid[32];
525     memcpy(tid, memCout.str().c_str(), memCout.str().length() < 32 ? memCout.str().length() : 31);
526     tid[memCout.str().length()] = 0;
527     mdclog_mdc_add("thread id", tid);
528
529     if (mdclog_level_get() >= MDCLOG_DEBUG) {
530         mdclog_write(MDCLOG_DEBUG, "started thread number %s", tid);
531     }
532
533
534     RmrMessagesBuffer_t rmrMessageBuffer{};
535     //create and init RMR
536     rmrMessageBuffer.rmrCtx = params->rmrCtx;
537
538     auto *events = (struct epoll_event *) calloc(MAXEVENTS, sizeof(struct epoll_event));
539     struct timespec end{0, 0};
540     struct timespec start{0, 0};
541
542     rmrMessageBuffer.rcvMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
543     rmrMessageBuffer.sendMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
544
545     memcpy(rmrMessageBuffer.ka_message, params->ka_message, params->ka_message_length);
546     rmrMessageBuffer.ka_message_len = params->ka_message_length;
547     rmrMessageBuffer.ka_message[rmrMessageBuffer.ka_message_len] = 0;
548
549     if (mdclog_level_get() >= MDCLOG_DEBUG) {
550         mdclog_write(MDCLOG_DEBUG, "keep alive message is : %s", rmrMessageBuffer.ka_message);
551     }
552
553     ReportingMessages_t message {};
554
555 //    for (int i = 0; i < MAX_RMR_BUFF_ARRY; i++) {
556 //        rmrMessageBuffer.rcvBufferedMessages[i] = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
557 //        rmrMessageBuffer.sendBufferedMessages[i] = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
558 //    }
559
560     message.statCollector = StatCollector::GetInstance();
561
562     while (true) {
563         if (mdclog_level_get() >= MDCLOG_DEBUG) {
564             mdclog_write(MDCLOG_DEBUG, "Start EPOLL Wait");
565         }
566         auto numOfEvents = epoll_wait(params->epoll_fd, events, MAXEVENTS, -1);
567         if (numOfEvents < 0 && errno == EINTR) {
568             if (mdclog_level_get() >= MDCLOG_DEBUG) {
569                 mdclog_write(MDCLOG_DEBUG, "got EINTR : %s", strerror(errno));
570             }
571             continue;
572         }
573         if (numOfEvents < 0) {
574             mdclog_write(MDCLOG_ERR, "Epoll wait failed, errno = %s", strerror(errno));
575             return;
576         }
577         for (auto i = 0; i < numOfEvents; i++) {
578             if (mdclog_level_get() >= MDCLOG_DEBUG) {
579                 mdclog_write(MDCLOG_DEBUG, "handling epoll event %d out of %d", i + 1, numOfEvents);
580             }
581             clock_gettime(CLOCK_MONOTONIC, &message.message.time);
582             start.tv_sec = message.message.time.tv_sec;
583             start.tv_nsec = message.message.time.tv_nsec;
584
585
586             if ((events[i].events & EPOLLERR) || (events[i].events & EPOLLHUP)) {
587                 handlepoll_error(events[i], message, rmrMessageBuffer, params);
588             } else if (events[i].events & EPOLLOUT) {
589                 handleEinprogressMessages(events[i], message, rmrMessageBuffer, params);
590             } else if (params->listenFD == events[i].data.fd) {
591                 if (mdclog_level_get() >= MDCLOG_INFO) {
592                     mdclog_write(MDCLOG_INFO, "New connection request from sctp network\n");
593                 }
594                 // new connection is requested from RAN  start build connection
595                 while (true) {
596                     struct sockaddr in_addr {};
597                     socklen_t in_len;
598                     char hostBuff[NI_MAXHOST];
599                     char portBuff[NI_MAXSERV];
600
601                     in_len = sizeof(in_addr);
602                     auto *peerInfo = (ConnectedCU_t *)calloc(1, sizeof(ConnectedCU_t));
603                     peerInfo->sctpParams = params;
604                     peerInfo->fileDescriptor = accept(params->listenFD, &in_addr, &in_len);
605                     if (peerInfo->fileDescriptor == -1) {
606                         if ((errno == EAGAIN) || (errno == EWOULDBLOCK)) {
607                             /* We have processed all incoming connections. */
608                             break;
609                         } else {
610                             mdclog_write(MDCLOG_ERR, "Accept error, errno = %s", strerror(errno));
611                             break;
612                         }
613                     }
614                     if (setSocketNoBlocking(peerInfo->fileDescriptor) == -1) {
615                         mdclog_write(MDCLOG_ERR, "setSocketNoBlocking failed to set new connection %s on port %s\n", hostBuff, portBuff);
616                         close(peerInfo->fileDescriptor);
617                         break;
618                     }
619                     auto  ans = getnameinfo(&in_addr, in_len,
620                                             peerInfo->hostName, NI_MAXHOST,
621                                             peerInfo->portNumber, NI_MAXSERV, (unsigned )((unsigned int)NI_NUMERICHOST | (unsigned int)NI_NUMERICSERV));
622                     if (ans < 0) {
623                         mdclog_write(MDCLOG_ERR, "Failed to get info on connection request. %s\n", strerror(errno));
624                         close(peerInfo->fileDescriptor);
625                         break;
626                     }
627                     if (mdclog_level_get() >= MDCLOG_DEBUG) {
628                         mdclog_write(MDCLOG_DEBUG, "Accepted connection on descriptor %d (host=%s, port=%s)\n", peerInfo->fileDescriptor, peerInfo->hostName, peerInfo->portNumber);
629                     }
630                     peerInfo->isConnected = false;
631                     peerInfo->gotSetup = false;
632                     if (addToEpoll(params->epoll_fd,
633                                    peerInfo,
634                                    (EPOLLIN | EPOLLET),
635                                    params->sctpMap, nullptr,
636                                    0) != 0) {
637                         break;
638                     }
639                     break;
640                 }
641             } else if (params->rmrListenFd == events[i].data.fd) {
642                 // got message from XAPP
643                 num_of_XAPP_messages.fetch_add(1, std::memory_order_release);
644                 num_of_messages.fetch_add(1, std::memory_order_release);
645                 if (mdclog_level_get() >= MDCLOG_DEBUG) {
646                     mdclog_write(MDCLOG_DEBUG, "new message from RMR");
647                 }
648                 if (receiveXappMessages(params->sctpMap,
649                                         rmrMessageBuffer,
650                                         message.message.time) != 0) {
651                     mdclog_write(MDCLOG_ERR, "Error handling Xapp message");
652                 }
653             } else if (params->inotifyFD == events[i].data.fd) {
654                 mdclog_write(MDCLOG_INFO, "Got event from inotify (configuration update)");
655                 handleConfigChange(params);
656             } else {
657                 /* We RMR_ERR_RETRY have data on the fd waiting to be read. Read and display it.
658                  * We must read whatever data is available completely, as we are running
659                  *  in edge-triggered mode and won't get a notification again for the same data. */
660                 num_of_messages.fetch_add(1, std::memory_order_release);
661                 if (mdclog_level_get() >= MDCLOG_DEBUG) {
662                     mdclog_write(MDCLOG_DEBUG, "new message from SCTP, epoll flags are : %0x", events[i].events);
663                 }
664                 receiveDataFromSctp(&events[i],
665                                     params->sctpMap,
666                                     num_of_SCTP_messages,
667                                     rmrMessageBuffer,
668                                     message.message.time);
669             }
670
671             clock_gettime(CLOCK_MONOTONIC, &end);
672             if (mdclog_level_get() >= MDCLOG_INFO) {
673                 totalTime += ((end.tv_sec + 1.0e-9 * end.tv_nsec) -
674                               ((double) start.tv_sec + 1.0e-9 * start.tv_nsec));
675             }
676             if (mdclog_level_get() >= MDCLOG_DEBUG) {
677                 mdclog_write(MDCLOG_DEBUG, "message handling is %ld seconds %ld nanoseconds",
678                              end.tv_sec - start.tv_sec,
679                              end.tv_nsec - start.tv_nsec);
680             }
681         }
682     }
683 }
684
685 /**
686  *
687  * @param sctpParams
688  */
689 void handleConfigChange(sctp_params_t *sctpParams) {
690     char buf[4096] __attribute__ ((aligned(__alignof__(struct inotify_event))));
691     const struct inotify_event *event;
692     char *ptr;
693
694     path p = (sctpParams->configFilePath + "/" + sctpParams->configFileName).c_str();
695     auto endlessLoop = true;
696     while (endlessLoop) {
697         auto len = read(sctpParams->inotifyFD, buf, sizeof buf);
698         if (len == -1) {
699             if (errno != EAGAIN) {
700                 mdclog_write(MDCLOG_ERR, "read %s ", strerror(errno));
701                 endlessLoop = false;
702                 continue;
703             }
704             else {
705                 endlessLoop = false;
706                 continue;
707             }
708         }
709
710         for (ptr = buf; ptr < buf + len; ptr += sizeof(struct inotify_event) + event->len) {
711             event = (const struct inotify_event *)ptr;
712             if (event->mask & (uint32_t)IN_ISDIR) {
713                 continue;
714             }
715
716             // the directory name
717             if (sctpParams->inotifyWD == event->wd) {
718                 // not the directory
719             }
720             if (event->len) {
721                 auto  retVal = strcmp(sctpParams->configFileName.c_str(), event->name);
722                 if (retVal != 0) {
723                     continue;
724                 }
725             }
726             // only the file we want
727             if (event->mask & (uint32_t)IN_CLOSE_WRITE) {
728                 if (mdclog_level_get() >= MDCLOG_INFO) {
729                     mdclog_write(MDCLOG_INFO, "Configuration file changed");
730                 }
731                 if (exists(p)) {
732                     const int size = 2048;
733                     auto fileSize = file_size(p);
734                     if (fileSize > size) {
735                         mdclog_write(MDCLOG_ERR, "File %s larger than %d", p.string().c_str(), size);
736                         return;
737                     }
738                 } else {
739                     mdclog_write(MDCLOG_ERR, "Configuration File %s not exists", p.string().c_str());
740                     return;
741                 }
742
743                 ReadConfigFile conf;
744                 if (conf.openConfigFile(p.string()) == -1) {
745                     mdclog_write(MDCLOG_ERR, "Filed to open config file %s, %s",
746                                  p.string().c_str(), strerror(errno));
747                     return;
748                 }
749
750                 auto tmpStr = conf.getStringValue("loglevel");
751                 if (tmpStr.length() == 0) {
752                     mdclog_write(MDCLOG_ERR, "illigal loglevel. Set loglevel to MDCLOG_INFO");
753                     tmpStr = "info";
754                 }
755                 transform(tmpStr.begin(), tmpStr.end(), tmpStr.begin(), ::tolower);
756
757                 if ((tmpStr.compare("debug")) == 0) {
758                     mdclog_write(MDCLOG_INFO, "Log level set to MDCLOG_DEBUG");
759                     sctpParams->logLevel = MDCLOG_DEBUG;
760                 } else if ((tmpStr.compare("info")) == 0) {
761                     mdclog_write(MDCLOG_INFO, "Log level set to MDCLOG_INFO");
762                     sctpParams->logLevel = MDCLOG_INFO;
763                 } else if ((tmpStr.compare("warning")) == 0) {
764                     mdclog_write(MDCLOG_INFO, "Log level set to MDCLOG_WARN");
765                     sctpParams->logLevel = MDCLOG_WARN;
766                 } else if ((tmpStr.compare("error")) == 0) {
767                     mdclog_write(MDCLOG_INFO, "Log level set to MDCLOG_ERR");
768                     sctpParams->logLevel = MDCLOG_ERR;
769                 } else {
770                     mdclog_write(MDCLOG_ERR, "illigal loglevel = %s. Set loglevel to MDCLOG_INFO", tmpStr.c_str());
771                     sctpParams->logLevel = MDCLOG_INFO;
772                 }
773                 mdclog_level_set(sctpParams->logLevel);
774
775
776                 tmpStr = conf.getStringValue("trace");
777                 if (tmpStr.length() == 0) {
778                     mdclog_write(MDCLOG_ERR, "illigal trace. Set trace to stop");
779                     tmpStr = "stop";
780                 }
781
782                 transform(tmpStr.begin(), tmpStr.end(), tmpStr.begin(), ::tolower);
783                 if ((tmpStr.compare("start")) == 0) {
784                     mdclog_write(MDCLOG_INFO, "Trace set to: start");
785                     sctpParams->trace = true;
786                 } else if ((tmpStr.compare("stop")) == 0) {
787                     mdclog_write(MDCLOG_INFO, "Trace set to: stop");
788                     sctpParams->trace = false;
789                 } else {
790                     mdclog_write(MDCLOG_ERR, "Trace was set to wrong value %s, set to stop", tmpStr.c_str());
791                     sctpParams->trace = false;
792                 }
793                 jsonTrace = sctpParams->trace;
794                 endlessLoop = false;
795             }
796         }
797     }
798 }
799
800 /**
801  *
802  * @param event
803  * @param message
804  * @param rmrMessageBuffer
805  * @param params
806  */
807 void handleEinprogressMessages(struct epoll_event &event,
808                                ReportingMessages_t &message,
809                                RmrMessagesBuffer_t &rmrMessageBuffer,
810                                sctp_params_t *params) {
811     auto *peerInfo = (ConnectedCU_t *)event.data.ptr;
812     memcpy(message.message.enodbName, peerInfo->enodbName, sizeof(peerInfo->enodbName));
813
814     mdclog_write(MDCLOG_INFO, "file descriptor %d got EPOLLOUT", peerInfo->fileDescriptor);
815     auto retVal = 0;
816     socklen_t retValLen = 0;
817     auto rc = getsockopt(peerInfo->fileDescriptor, SOL_SOCKET, SO_ERROR, &retVal, &retValLen);
818     if (rc != 0 || retVal != 0) {
819         if (rc != 0) {
820             rmrMessageBuffer.sendMessage->len = snprintf((char *)rmrMessageBuffer.sendMessage->payload, 256,
821                                                          "%s|Failed SCTP Connection, after EINPROGRESS the getsockopt%s",
822                                                          peerInfo->enodbName, strerror(errno));
823         } else if (retVal != 0) {
824             rmrMessageBuffer.sendMessage->len = snprintf((char *)rmrMessageBuffer.sendMessage->payload, 256,
825                                                          "%s|Failed SCTP Connection after EINPROGRESS, SO_ERROR",
826                                                          peerInfo->enodbName);
827         }
828
829         message.message.asndata = rmrMessageBuffer.sendMessage->payload;
830         message.message.asnLength = rmrMessageBuffer.sendMessage->len;
831         mdclog_write(MDCLOG_ERR, "%s", rmrMessageBuffer.sendMessage->payload);
832         message.message.direction = 'N';
833         if (sendRequestToXapp(message, RIC_SCTP_CONNECTION_FAILURE, rmrMessageBuffer) != 0) {
834             mdclog_write(MDCLOG_ERR, "SCTP_CONNECTION_FAIL message failed to send to xAPP");
835         }
836         memset(peerInfo->asnData, 0, peerInfo->asnLength);
837         peerInfo->asnLength = 0;
838         peerInfo->mtype = 0;
839         return;
840     }
841
842     peerInfo->isConnected = true;
843
844     if (modifyToEpoll(params->epoll_fd, peerInfo, (EPOLLIN | EPOLLET), params->sctpMap, peerInfo->enodbName,
845                       peerInfo->mtype) != 0) {
846         mdclog_write(MDCLOG_ERR, "epoll_ctl EPOLL_CTL_MOD");
847         return;
848     }
849
850     message.message.asndata = (unsigned char *)peerInfo->asnData;
851     message.message.asnLength = peerInfo->asnLength;
852     message.message.messageType = peerInfo->mtype;
853     memcpy(message.message.enodbName, peerInfo->enodbName, sizeof(peerInfo->enodbName));
854     num_of_messages.fetch_add(1, std::memory_order_release);
855     if (mdclog_level_get() >= MDCLOG_DEBUG) {
856         mdclog_write(MDCLOG_DEBUG, "send the delayed SETUP/ENDC SETUP to sctp for %s",
857                      message.message.enodbName);
858     }
859     if (sendSctpMsg(peerInfo, message, params->sctpMap) != 0) {
860         if (mdclog_level_get() >= MDCLOG_DEBUG) {
861             mdclog_write(MDCLOG_DEBUG, "Error write to SCTP  %s %d", __func__, __LINE__);
862         }
863         return;
864     }
865
866     memset(peerInfo->asnData, 0, peerInfo->asnLength);
867     peerInfo->asnLength = 0;
868     peerInfo->mtype = 0;
869 }
870
871
872 void handlepoll_error(struct epoll_event &event,
873                       ReportingMessages_t &message,
874                       RmrMessagesBuffer_t &rmrMessageBuffer,
875                       sctp_params_t *params) {
876     if (event.data.fd != params->rmrListenFd) {
877         auto *peerInfo = (ConnectedCU_t *)event.data.ptr;
878         mdclog_write(MDCLOG_ERR, "epoll error, events %0x on fd %d, RAN NAME : %s",
879                      event.events, peerInfo->fileDescriptor, peerInfo->enodbName);
880
881         rmrMessageBuffer.sendMessage->len = snprintf((char *)rmrMessageBuffer.sendMessage->payload, 256,
882                                                      "%s|Failed SCTP Connection",
883                                                      peerInfo->enodbName);
884         message.message.asndata = rmrMessageBuffer.sendMessage->payload;
885         message.message.asnLength = rmrMessageBuffer.sendMessage->len;
886
887         memcpy(message.message.enodbName, peerInfo->enodbName, sizeof(peerInfo->enodbName));
888         message.message.direction = 'N';
889         if (sendRequestToXapp(message, RIC_SCTP_CONNECTION_FAILURE, rmrMessageBuffer) != 0) {
890             mdclog_write(MDCLOG_ERR, "SCTP_CONNECTION_FAIL message failed to send to xAPP");
891         }
892
893         close(peerInfo->fileDescriptor);
894         params->sctpMap->erase(peerInfo->enodbName);
895         cleanHashEntry((ConnectedCU_t *) event.data.ptr, params->sctpMap);
896     } else {
897         mdclog_write(MDCLOG_ERR, "epoll error, events %0x on RMR FD", event.events);
898     }
899 }
900 /**
901  *
902  * @param socket
903  * @return
904  */
905 int setSocketNoBlocking(int socket) {
906     auto flags = fcntl(socket, F_GETFL, 0);
907
908     if (flags == -1) {
909         mdclog_mdc_add("func", "fcntl");
910         mdclog_write(MDCLOG_ERR, "%s, %s", __FUNCTION__, strerror(errno));
911         mdclog_mdc_clean();
912         return -1;
913     }
914
915     flags = (unsigned) flags | (unsigned) O_NONBLOCK;
916     if (fcntl(socket, F_SETFL, flags) == -1) {
917         mdclog_mdc_add("func", "fcntl");
918         mdclog_write(MDCLOG_ERR, "%s, %s", __FUNCTION__, strerror(errno));
919         mdclog_mdc_clean();
920         return -1;
921     }
922
923     return 0;
924 }
925
926 /**
927  *
928  * @param val
929  * @param m
930  */
931 void cleanHashEntry(ConnectedCU_t *val, Sctp_Map_t *m) {
932     char *dummy;
933     auto port = (uint16_t) strtol(val->portNumber, &dummy, 10);
934     char searchBuff[2048]{};
935
936     snprintf(searchBuff, sizeof searchBuff, "host:%s:%d", val->hostName, port);
937     m->erase(searchBuff);
938
939     m->erase(val->enodbName);
940     free(val);
941 }
942
943 /**
944  *
945  * @param fd file discriptor
946  * @param data the asn data to send
947  * @param len  length of the data
948  * @param enodbName the enodbName as in the map for printing purpose
949  * @param m map host information
950  * @param mtype message number
951  * @return 0 success, anegative number on fail
952  */
953 int sendSctpMsg(ConnectedCU_t *peerInfo, ReportingMessages_t &message, Sctp_Map_t *m) {
954     auto loglevel = mdclog_level_get();
955     int fd = peerInfo->fileDescriptor;
956     if (loglevel >= MDCLOG_DEBUG) {
957         mdclog_write(MDCLOG_DEBUG, "Send SCTP message for CU %s, %s",
958                      message.message.enodbName, __FUNCTION__);
959     }
960
961     while (true) {
962         if (send(fd,message.message.asndata, message.message.asnLength,MSG_NOSIGNAL) < 0) {
963             if (errno == EINTR) {
964                 continue;
965             }
966             mdclog_write(MDCLOG_ERR, "error writing to CU a message, %s ", strerror(errno));
967             if (!peerInfo->isConnected) {
968                 mdclog_write(MDCLOG_ERR, "connection to CU %s is still in progress.", message.message.enodbName);
969                 return -1;
970             }
971             cleanHashEntry(peerInfo, m);
972             close(fd);
973             char key[MAX_ENODB_NAME_SIZE * 2];
974             snprintf(key, MAX_ENODB_NAME_SIZE * 2, "msg:%s|%d", message.message.enodbName,
975                      message.message.messageType);
976             if (loglevel >= MDCLOG_DEBUG) {
977                 mdclog_write(MDCLOG_DEBUG, "remove key = %s from %s at line %d", key, __FUNCTION__, __LINE__);
978             }
979             auto tmp = m->find(key);
980             if (tmp) {
981                 free(tmp);
982             }
983             m->erase(key);
984             return -1;
985         }
986         // TODO remove stat update
987         //message.statCollector->incSentMessage(string(message.message.enodbName));
988         message.message.direction = 'D';
989         // send report.buffer of size
990         buildJsonMessage(message);
991
992         if (loglevel >= MDCLOG_DEBUG) {
993             mdclog_write(MDCLOG_DEBUG,
994                          "SCTP message for CU %s sent from %s",
995                          message.message.enodbName,
996                          __FUNCTION__);
997         }
998         return 0;
999     }
1000 }
1001
1002 /**
1003  *
1004  * @param message
1005  * @param rmrMessageBuffer
1006  */
1007 void getRequestMetaData(ReportingMessages_t &message, RmrMessagesBuffer_t &rmrMessageBuffer) {
1008     rmr_get_meid(rmrMessageBuffer.rcvMessage, (unsigned char *) (message.message.enodbName));
1009
1010     message.message.asndata = rmrMessageBuffer.rcvMessage->payload;
1011     message.message.asnLength = rmrMessageBuffer.rcvMessage->len;
1012
1013     if (mdclog_level_get() >= MDCLOG_DEBUG) {
1014         mdclog_write(MDCLOG_DEBUG, "Message from Xapp RAN name = %s message length = %ld",
1015                      message.message.enodbName, (unsigned long) message.message.asnLength);
1016     }
1017 }
1018
1019
1020
1021 /**
1022  *
1023  * @param events
1024  * @param sctpMap
1025  * @param numOfMessages
1026  * @param rmrMessageBuffer
1027  * @param ts
1028  * @return
1029  */
1030 int receiveDataFromSctp(struct epoll_event *events,
1031                         Sctp_Map_t *sctpMap,
1032                         int &numOfMessages,
1033                         RmrMessagesBuffer_t &rmrMessageBuffer,
1034                         struct timespec &ts) {
1035     /* We have data on the fd waiting to be read. Read and display it.
1036  * We must read whatever data is available completely, as we are running
1037  *  in edge-triggered mode and won't get a notification again for the same data. */
1038     ReportingMessages_t message {};
1039     auto done = 0;
1040     auto loglevel = mdclog_level_get();
1041
1042     // get the identity of the interface
1043     message.peerInfo = (ConnectedCU_t *)events->data.ptr;
1044
1045     message.statCollector = StatCollector::GetInstance();
1046     struct timespec start{0, 0};
1047     struct timespec decodestart{0, 0};
1048     struct timespec end{0, 0};
1049
1050     E2AP_PDU_t *pdu = nullptr;
1051
1052
1053     while (true) {
1054         if (loglevel >= MDCLOG_DEBUG) {
1055             mdclog_write(MDCLOG_DEBUG, "Start Read from SCTP %d fd", message.peerInfo->fileDescriptor);
1056             clock_gettime(CLOCK_MONOTONIC, &start);
1057         }
1058         // read the buffer directly to rmr payload
1059         message.message.asndata = rmrMessageBuffer.sendMessage->payload;
1060         message.message.asnLength = rmrMessageBuffer.sendMessage->len =
1061                 read(message.peerInfo->fileDescriptor, rmrMessageBuffer.sendMessage->payload, RECEIVE_SCTP_BUFFER_SIZE);
1062
1063         if (loglevel >= MDCLOG_DEBUG) {
1064             mdclog_write(MDCLOG_DEBUG, "Finish Read from SCTP %d fd message length = %ld",
1065                          message.peerInfo->fileDescriptor, message.message.asnLength);
1066         }
1067
1068         memcpy(message.message.enodbName, message.peerInfo->enodbName, sizeof(message.peerInfo->enodbName));
1069         message.statCollector->incRecvMessage(string(message.message.enodbName));
1070         message.message.direction = 'U';
1071         message.message.time.tv_nsec = ts.tv_nsec;
1072         message.message.time.tv_sec = ts.tv_sec;
1073
1074         if (message.message.asnLength < 0) {
1075             if (errno == EINTR) {
1076                 continue;
1077             }
1078             /* If errno == EAGAIN, that means we have read all
1079                data. So goReportingMessages_t back to the main loop. */
1080             if (errno != EAGAIN) {
1081                 mdclog_write(MDCLOG_ERR, "Read error, %s ", strerror(errno));
1082                 done = 1;
1083             } else if (loglevel >= MDCLOG_DEBUG) {
1084                 mdclog_write(MDCLOG_DEBUG, "EAGAIN - descriptor = %d", message.peerInfo->fileDescriptor);
1085             }
1086             break;
1087         } else if (message.message.asnLength == 0) {
1088             /* End of file. The remote has closed the connection. */
1089             if (loglevel >= MDCLOG_INFO) {
1090                 mdclog_write(MDCLOG_INFO, "END of File Closed connection - descriptor = %d",
1091                              message.peerInfo->fileDescriptor);
1092             }
1093             done = 1;
1094             break;
1095         }
1096
1097         if (loglevel >= MDCLOG_DEBUG) {
1098             char printBuffer[4096]{};
1099             char *tmp = printBuffer;
1100             for (size_t i = 0; i < (size_t)message.message.asnLength; ++i) {
1101                 snprintf(tmp, 3, "%02x", message.message.asndata[i]);
1102                 tmp += 2;
1103             }
1104             printBuffer[message.message.asnLength] = 0;
1105             clock_gettime(CLOCK_MONOTONIC, &end);
1106             mdclog_write(MDCLOG_DEBUG, "Before Encoding E2AP PDU for : %s, Read time is : %ld seconds, %ld nanoseconds",
1107                          message.peerInfo->enodbName, end.tv_sec - start.tv_sec, end.tv_nsec - start.tv_nsec);
1108             mdclog_write(MDCLOG_DEBUG, "PDU buffer length = %ld, data =  : %s", message.message.asnLength,
1109                          printBuffer);
1110             clock_gettime(CLOCK_MONOTONIC, &decodestart);
1111         }
1112
1113         auto rval = asn_decode(nullptr, ATS_ALIGNED_BASIC_PER, &asn_DEF_E2AP_PDU, (void **) &pdu,
1114                           message.message.asndata, message.message.asnLength);
1115         if (rval.code != RC_OK) {
1116             mdclog_write(MDCLOG_ERR, "Error %d Decoding (unpack) E2AP PDU from RAN : %s", rval.code,
1117                          message.peerInfo->enodbName);
1118             //todo may need reset to pdu
1119             break;
1120         }
1121
1122         if (loglevel >= MDCLOG_DEBUG) {
1123             clock_gettime(CLOCK_MONOTONIC, &end);
1124             mdclog_write(MDCLOG_DEBUG, "After Encoding E2AP PDU for : %s, Read time is : %ld seconds, %ld nanoseconds",
1125                          message.peerInfo->enodbName, end.tv_sec - decodestart.tv_sec, end.tv_nsec - decodestart.tv_nsec);
1126             char *printBuffer;
1127             size_t size;
1128             FILE *stream = open_memstream(&printBuffer, &size);
1129             asn_fprint(stream, &asn_DEF_E2AP_PDU, pdu);
1130             mdclog_write(MDCLOG_DEBUG, "Encoding E2AP PDU past : %s", printBuffer);
1131             clock_gettime(CLOCK_MONOTONIC, &decodestart);
1132         }
1133
1134         switch (pdu->present) {
1135             case E2AP_PDU_PR_initiatingMessage: {//initiating message
1136                 asnInitiatingRequest(pdu, sctpMap,message, rmrMessageBuffer);
1137                 break;
1138             }
1139             case E2AP_PDU_PR_successfulOutcome: { //successful outcome
1140                 asnSuccsesfulMsg(pdu, sctpMap, message,  rmrMessageBuffer);
1141                 break;
1142             }
1143             case E2AP_PDU_PR_unsuccessfulOutcome: { //Unsuccessful Outcome
1144                 asnUnSuccsesfulMsg(pdu, sctpMap, message, rmrMessageBuffer);
1145                 break;
1146             }
1147             default:
1148                 mdclog_write(MDCLOG_ERR, "Unknown index %d in E2AP PDU", pdu->present);
1149                 break;
1150         }
1151         if (loglevel >= MDCLOG_DEBUG) {
1152             clock_gettime(CLOCK_MONOTONIC, &end);
1153             mdclog_write(MDCLOG_DEBUG,
1154                          "After processing message and sent to rmr for : %s, Read time is : %ld seconds, %ld nanoseconds",
1155                          message.peerInfo->enodbName, end.tv_sec - decodestart.tv_sec, end.tv_nsec - decodestart.tv_nsec);
1156         }
1157         numOfMessages++;
1158         if (pdu != nullptr) {
1159             ASN_STRUCT_RESET(asn_DEF_E2AP_PDU, pdu);
1160             //ASN_STRUCT_FREE(asn_DEF_E2AP_PDU, pdu);
1161             //pdu = nullptr;
1162         }
1163     }
1164
1165     if (done) {
1166         if (loglevel >= MDCLOG_INFO) {
1167             mdclog_write(MDCLOG_INFO, "Closed connection - descriptor = %d", message.peerInfo->fileDescriptor);
1168         }
1169         message.message.asnLength = rmrMessageBuffer.sendMessage->len =
1170                 snprintf((char *)rmrMessageBuffer.sendMessage->payload,
1171                          256,
1172                          "%s|CU disconnected unexpectedly",
1173                          message.peerInfo->enodbName);
1174         message.message.asndata = rmrMessageBuffer.sendMessage->payload;
1175
1176         if (sendRequestToXapp(message,
1177                               RIC_SCTP_CONNECTION_FAILURE,
1178                               rmrMessageBuffer) != 0) {
1179             mdclog_write(MDCLOG_ERR, "SCTP_CONNECTION_FAIL message failed to send to xAPP");
1180         }
1181
1182         /* Closing descriptor make epoll remove it from the set of descriptors which are monitored. */
1183         close(message.peerInfo->fileDescriptor);
1184         cleanHashEntry((ConnectedCU_t *) events->data.ptr, sctpMap);
1185     }
1186     if (loglevel >= MDCLOG_DEBUG) {
1187         clock_gettime(CLOCK_MONOTONIC, &end);
1188         mdclog_write(MDCLOG_DEBUG, "from receive SCTP to send RMR time is %ld seconds and %ld nanoseconds",
1189                      end.tv_sec - start.tv_sec, end.tv_nsec - start.tv_nsec);
1190
1191     }
1192     return 0;
1193 }
1194
1195 static void buildAndsendSetupRequest(ReportingMessages_t &message,
1196                                      RmrMessagesBuffer_t &rmrMessageBuffer,
1197                                      E2AP_PDU_t *pdu,
1198                                      vector<string> &repValues) {
1199     auto logLevel = mdclog_level_get();
1200
1201     // now we can send the data to e2Mgr
1202     auto buffer_size = RECEIVE_SCTP_BUFFER_SIZE * 2;
1203
1204     auto *rmrMsg = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, buffer_size);
1205     // add addrees to message
1206
1207
1208     // unsigned char *buffer = &rmrMsg->payload[j];
1209     unsigned char buffer[RECEIVE_SCTP_BUFFER_SIZE * 2];
1210     // encode to xml
1211     auto er = asn_encode_to_buffer(nullptr, ATS_BASIC_XER, &asn_DEF_E2AP_PDU, pdu, buffer, buffer_size);
1212     if (er.encoded == -1) {
1213         mdclog_write(MDCLOG_ERR, "encoding of %s failed, %s", asn_DEF_E2AP_PDU.name, strerror(errno));
1214     } else if (er.encoded > (ssize_t) buffer_size) {
1215         mdclog_write(MDCLOG_ERR, "Buffer of size %d is to small for %s, at %s line %d",
1216                      (int) buffer_size,
1217                      asn_DEF_E2AP_PDU.name, __func__, __LINE__);
1218     } else {
1219
1220         buildXmlData(repValues, buffer);
1221         // we have the XML
1222         rmrMsg->len = snprintf((char *)rmrMsg->payload, RECEIVE_SCTP_BUFFER_SIZE * 2, "%s:%d|%s",
1223                                message.peerInfo->sctpParams->myIP.c_str(),
1224                                message.peerInfo->sctpParams->rmrPort,
1225                                buffer);
1226         if (logLevel >= MDCLOG_DEBUG) {
1227             mdclog_write(MDCLOG_DEBUG, "Setup request of size %d :\n %s\n", rmrMsg->len, rmrMsg->payload);
1228         }
1229         // send to RMR
1230         message.message.messageType = rmrMsg->mtype = RIC_E2_SETUP_REQ;
1231         rmrMsg->state = 0;
1232         rmr_bytes2meid(rmrMsg, (unsigned char *) message.message.enodbName, strlen(message.message.enodbName));
1233
1234         static unsigned char tx[32];
1235         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1236         rmr_bytes2xact(rmrMsg, tx, strlen((const char *) tx));
1237
1238         rmrMsg = rmr_send_msg(rmrMessageBuffer.rmrCtx, rmrMsg);
1239         if (rmrMsg == nullptr) {
1240             mdclog_write(MDCLOG_ERR, "RMR failed to send returned nullptr");
1241         } else if (rmrMsg->state != 0) {
1242             char meid[RMR_MAX_MEID]{};
1243             if (rmrMsg->state == RMR_ERR_RETRY) {
1244                 usleep(5);
1245                 rmrMsg->state = 0;
1246                 mdclog_write(MDCLOG_INFO, "RETRY sending Message %d to Xapp from %s",
1247                              rmrMsg->mtype, rmr_get_meid(rmrMsg, (unsigned char *) meid));
1248                 rmrMsg = rmr_send_msg(rmrMessageBuffer.rmrCtx, rmrMsg);
1249                 if (rmrMsg == nullptr) {
1250                     mdclog_write(MDCLOG_ERR, "RMR failed send returned nullptr");
1251                 } else if (rmrMsg->state != 0) {
1252                     mdclog_write(MDCLOG_ERR,
1253                                  "RMR Retry failed %s sending request %d to Xapp from %s",
1254                                  translateRmrErrorMessages(rmrMsg->state).c_str(),
1255                                  rmrMsg->mtype,
1256                                  rmr_get_meid(rmrMsg, (unsigned char *) meid));
1257                 }
1258             } else {
1259                 mdclog_write(MDCLOG_ERR, "RMR failed: %s. sending request %d to Xapp from %s",
1260                              translateRmrErrorMessages(rmrMsg->state).c_str(),
1261                              rmrMsg->mtype,
1262                              rmr_get_meid(rmrMsg, (unsigned char *) meid));
1263             }
1264         }
1265         message.peerInfo->gotSetup = true;
1266         buildJsonMessage(message);
1267         if (rmrMsg != nullptr) {
1268             rmr_free_msg(rmrMsg);
1269         }
1270     }
1271
1272 }
1273
1274
1275
1276
1277 int collectSetupRequestData(E2AP_PDU_t *pdu,
1278                             Sctp_Map_t *sctpMap,
1279                             ReportingMessages_t &message,
1280                             vector <string> &runFunDEFXML_v) {
1281     auto index = 0;
1282     memset(message.peerInfo->enodbName, 0 , MAX_ENODB_NAME_SIZE);
1283     for (auto i = 0; i < pdu->choice.initiatingMessage->value.choice.E2setupRequest.protocolIEs.list.count; i++) {
1284         auto *ie = pdu->choice.initiatingMessage->value.choice.E2setupRequest.protocolIEs.list.array[i];
1285         if (ie->id == ProtocolIE_ID_id_GlobalE2node_ID) {
1286             // get the ran name for meid
1287             if (ie->value.present == E2setupRequestIEs__value_PR_GlobalE2node_ID) {
1288                 if (buildRanName(message.peerInfo->enodbName, ie) < 0) {
1289                     mdclog_write(MDCLOG_ERR, "Bad param in E2setupRequestIEs GlobalE2node_ID.\n");
1290                     // no mesage will be sent
1291                     return -1;
1292                 }
1293                 memcpy(message.message.enodbName, message.peerInfo->enodbName, strlen(message.peerInfo->enodbName));
1294                 sctpMap->setkey(message.message.enodbName, message.peerInfo);
1295             }
1296         }
1297         // reformat RANFUNCTION Definition to XML
1298         if (ie->id == ProtocolIE_ID_id_RANfunctionsAdded) {
1299             if (ie->value.present == E2setupRequestIEs__value_PR_RANfunctions_List) {
1300                 if (mdclog_level_get() >= MDCLOG_DEBUG) {
1301                     mdclog_write(MDCLOG_DEBUG, "Run function list have %d entries and size %d",
1302                                  ie->value.choice.RANfunctions_List.list.count,
1303                                  ie->value.choice.RANfunctions_List.list.size);
1304                 }
1305                 for (auto j = 0; j < ie->value.choice.RANfunctions_List.list.count; j++) {
1306                     auto *raNfunctionItemIEs = (RANfunction_ItemIEs_t *)ie->value.choice.RANfunctions_List.list.array[j];
1307                     if (raNfunctionItemIEs->id == ProtocolIE_ID_id_RANfunction_Item &&
1308                         (raNfunctionItemIEs->value.present == RANfunction_ItemIEs__value_PR_RANfunction_Item)) {
1309                         // encode to xml
1310                         E2SM_gNB_NRT_RANfunction_Definition_t *ranFunDef = nullptr;
1311                         auto rval = asn_decode(nullptr, ATS_ALIGNED_BASIC_PER,
1312                                                &asn_DEF_E2SM_gNB_NRT_RANfunction_Definition,
1313                                                (void **)&ranFunDef,
1314                                                raNfunctionItemIEs->value.choice.RANfunction_Item.ranFunctionDefinition.buf,
1315                                                raNfunctionItemIEs->value.choice.RANfunction_Item.ranFunctionDefinition.size);
1316                         if (rval.code != RC_OK) {
1317                             mdclog_write(MDCLOG_ERR, "Error %d Decoding (unpack) E2SM message from : %s",
1318                                          rval.code,
1319                                          asn_DEF_E2SM_gNB_NRT_RANfunction_Definition.name);
1320                             return -1;
1321                         }
1322
1323 //                        if (mdclog_level_get() >= MDCLOG_DEBUG) {
1324 //                            char *printBuffer;
1325 //                            size_t size;
1326 //                            FILE *stream = open_memstream(&printBuffer, &size);
1327 //                            asn_fprint(stream, &asn_DEF_E2SM_gNB_NRT_RANfunction_Definition, ranFunDef);
1328 //                            mdclog_write(MDCLOG_DEBUG, "Encoding E2SM %s PDU past : %s",
1329 //                                         asn_DEF_E2SM_gNB_NRT_RANfunction_Definition.name,
1330 //                                         printBuffer);
1331 //                        }
1332                         auto xml_buffer_size = RECEIVE_SCTP_BUFFER_SIZE * 2;
1333                         unsigned char xml_buffer[RECEIVE_SCTP_BUFFER_SIZE * 2];
1334                         // encode to xml
1335                         auto er = asn_encode_to_buffer(nullptr,
1336                                                   ATS_BASIC_XER,
1337                                                   &asn_DEF_E2SM_gNB_NRT_RANfunction_Definition,
1338                                                   ranFunDef,
1339                                                   xml_buffer,
1340                                                   xml_buffer_size);
1341                         if (er.encoded == -1) {
1342                             mdclog_write(MDCLOG_ERR, "encoding of %s failed, %s",
1343                                          asn_DEF_E2SM_gNB_NRT_RANfunction_Definition.name,
1344                                          strerror(errno));
1345                         } else if (er.encoded > (ssize_t)xml_buffer_size) {
1346                             mdclog_write(MDCLOG_ERR, "Buffer of size %d is to small for %s, at %s line %d",
1347                                          (int) xml_buffer_size,
1348                                          asn_DEF_E2SM_gNB_NRT_RANfunction_Definition.name, __func__, __LINE__);
1349                         } else {
1350                             if (mdclog_level_get() >= MDCLOG_DEBUG) {
1351                                 mdclog_write(MDCLOG_DEBUG, "Encoding E2SM %s PDU number %d : %s",
1352                                              asn_DEF_E2SM_gNB_NRT_RANfunction_Definition.name,
1353                                              index++,
1354                                              xml_buffer);
1355                             }
1356                             string runFuncs = (char *)(xml_buffer);
1357                             runFunDEFXML_v.emplace_back(runFuncs);
1358                         }
1359
1360                     }
1361                 }
1362             }
1363         }
1364     }
1365     if (mdclog_level_get() >= MDCLOG_DEBUG) {
1366         mdclog_write(MDCLOG_DEBUG, "Run function vector have %ld entries",
1367                      runFunDEFXML_v.size());
1368     }
1369     return 0;
1370 }
1371 /**
1372  *
1373  * @param pdu
1374  * @param message
1375  * @param rmrMessageBuffer
1376  */
1377 void asnInitiatingRequest(E2AP_PDU_t *pdu,
1378                           Sctp_Map_t *sctpMap,
1379                           ReportingMessages_t &message,
1380                           RmrMessagesBuffer_t &rmrMessageBuffer) {
1381     auto logLevel = mdclog_level_get();
1382     auto procedureCode = ((InitiatingMessage_t *) pdu->choice.initiatingMessage)->procedureCode;
1383     if (logLevel >= MDCLOG_DEBUG) {
1384         mdclog_write(MDCLOG_DEBUG, "Initiating message %ld\n", procedureCode);
1385     }
1386     switch (procedureCode) {
1387         case ProcedureCode_id_E2setup: {
1388             if (logLevel >= MDCLOG_DEBUG) {
1389                 mdclog_write(MDCLOG_DEBUG, "Got E2setup\n");
1390             }
1391
1392             // first get the message as XML buffer
1393             auto setup_xml_buffer_size = RECEIVE_SCTP_BUFFER_SIZE * 2;
1394             unsigned char setup_xml_buffer[RECEIVE_SCTP_BUFFER_SIZE * 2];
1395             //unsigned char *tmp_buff_cursor = setup_xml_buffer;
1396
1397             auto er = asn_encode_to_buffer(nullptr, ATS_BASIC_XER, &asn_DEF_E2AP_PDU, pdu, setup_xml_buffer, setup_xml_buffer_size);
1398             if (er.encoded == -1) {
1399                 mdclog_write(MDCLOG_ERR, "encoding of %s failed, %s", asn_DEF_E2AP_PDU.name, strerror(errno));
1400             } else if (er.encoded > (ssize_t) setup_xml_buffer_size) {
1401                 mdclog_write(MDCLOG_ERR, "Buffer of size %d is to small for %s, at %s line %d",
1402                              (int)setup_xml_buffer_size,
1403                              asn_DEF_E2AP_PDU.name, __func__, __LINE__);
1404             }
1405             std::string xmlString(setup_xml_buffer_size,  setup_xml_buffer_size + er.encoded);
1406
1407             vector <string> runFunDEFXML_v;
1408             runFunDEFXML_v.clear();
1409
1410             auto ret = collectSetupRequestData(pdu, sctpMap,  message, runFunDEFXML_v);
1411             if (ret != 0) {
1412                 break;
1413             }
1414
1415             //build all parts and send the XML (need to copy the XML with the header to the rmrMessageBuffer payload
1416             //TODO replace with new function
1417             buildAndsendSetupRequest(message, rmrMessageBuffer, pdu, runFunDEFXML_v);
1418             break;
1419         }
1420         case ProcedureCode_id_ErrorIndication: {
1421             if (logLevel >= MDCLOG_DEBUG) {
1422                 mdclog_write(MDCLOG_DEBUG, "Got ErrorIndication %s", message.message.enodbName);
1423             }
1424             if (sendRequestToXapp(message, RIC_ERROR_INDICATION, rmrMessageBuffer) != 0) {
1425                 mdclog_write(MDCLOG_ERR, "RIC_ERROR_INDICATION failed to send to xAPP");
1426             }
1427             break;
1428         }
1429         case ProcedureCode_id_Reset: {
1430             if (logLevel >= MDCLOG_DEBUG) {
1431                 mdclog_write(MDCLOG_DEBUG, "Got Reset %s", message.message.enodbName);
1432             }
1433             if (sendRequestToXapp(message, RIC_X2_RESET, rmrMessageBuffer) != 0) {
1434                 mdclog_write(MDCLOG_ERR, "RIC_X2_RESET message failed to send to xAPP");
1435             }
1436             break;
1437         }
1438         case ProcedureCode_id_RICcontrol: {
1439             if (logLevel >= MDCLOG_DEBUG) {
1440                 mdclog_write(MDCLOG_DEBUG, "Got RICcontrol %s", message.message.enodbName);
1441             }
1442             break;
1443         }
1444         case ProcedureCode_id_RICindication: {
1445             if (logLevel >= MDCLOG_DEBUG) {
1446                 mdclog_write(MDCLOG_DEBUG, "Got RICindication %s", message.message.enodbName);
1447             }
1448             for (auto i = 0; i < pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.count; i++) {
1449                 auto messageSent = false;
1450                 RICindication_IEs_t *ie = pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.array[i];
1451                 if (logLevel >= MDCLOG_DEBUG) {
1452                     mdclog_write(MDCLOG_DEBUG, "ie type (ProtocolIE_ID) = %ld", ie->id);
1453                 }
1454                 if (ie->id == ProtocolIE_ID_id_RICrequestID) {
1455                     if (logLevel >= MDCLOG_DEBUG) {
1456                         mdclog_write(MDCLOG_DEBUG, "Got RIC requestId entry, ie type (ProtocolIE_ID) = %ld", ie->id);
1457                     }
1458                     if (ie->value.present == RICindication_IEs__value_PR_RICrequestID) {
1459                         static unsigned char tx[32];
1460                         message.message.messageType = rmrMessageBuffer.sendMessage->mtype = RIC_INDICATION;
1461                         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1462                         rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, strlen((const char *) tx));
1463                         rmr_bytes2meid(rmrMessageBuffer.sendMessage,
1464                                        (unsigned char *)message.message.enodbName,
1465                                        strlen(message.message.enodbName));
1466                         rmrMessageBuffer.sendMessage->state = 0;
1467                         rmrMessageBuffer.sendMessage->sub_id = (int)ie->value.choice.RICrequestID.ricInstanceID;
1468
1469                         //ie->value.choice.RICrequestID.ricInstanceID;
1470                         if (mdclog_level_get() >= MDCLOG_DEBUG) {
1471                             mdclog_write(MDCLOG_DEBUG, "sub id = %d, mtype = %d, ric instance id %ld, requestor id = %ld",
1472                                          rmrMessageBuffer.sendMessage->sub_id,
1473                                          rmrMessageBuffer.sendMessage->mtype,
1474                                          ie->value.choice.RICrequestID.ricInstanceID,
1475                                          ie->value.choice.RICrequestID.ricRequestorID);
1476                         }
1477                         sendRmrMessage(rmrMessageBuffer, message);
1478                         messageSent = true;
1479                     } else {
1480                         mdclog_write(MDCLOG_ERR, "RIC request id missing illigal request");
1481                     }
1482                 }
1483                 if (messageSent) {
1484                     break;
1485                 }
1486             }
1487             break;
1488         }
1489         case ProcedureCode_id_RICserviceQuery: {
1490             if (logLevel >= MDCLOG_DEBUG) {
1491                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceQuery %s", message.message.enodbName);
1492             }
1493             break;
1494         }
1495         case ProcedureCode_id_RICserviceUpdate: {
1496             if (logLevel >= MDCLOG_DEBUG) {
1497                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceUpdate %s", message.message.enodbName);
1498             }
1499             if (sendRequestToXapp(message, RIC_SERVICE_UPDATE, rmrMessageBuffer) != 0) {
1500                 mdclog_write(MDCLOG_ERR, "RIC_SERVICE_UPDATE message failed to send to xAPP");
1501             }
1502             break;
1503         }
1504         case ProcedureCode_id_RICsubscription: {
1505             if (logLevel >= MDCLOG_DEBUG) {
1506                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscription %s", message.message.enodbName);
1507             }
1508             break;
1509         }
1510         case ProcedureCode_id_RICsubscriptionDelete: {
1511             if (logLevel >= MDCLOG_DEBUG) {
1512                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscriptionDelete %s", message.message.enodbName);
1513             }
1514             break;
1515         }
1516         default: {
1517             mdclog_write(MDCLOG_ERR, "Undefined or not supported message = %ld", procedureCode);
1518             message.message.messageType = 0; // no RMR message type yet
1519
1520             buildJsonMessage(message);
1521
1522             break;
1523         }
1524     }
1525 }
1526
1527 /**
1528  *
1529  * @param pdu
1530  * @param message
1531  * @param rmrMessageBuffer
1532  */
1533 void asnSuccsesfulMsg(E2AP_PDU_t *pdu,
1534                       Sctp_Map_t *sctpMap,
1535                       ReportingMessages_t &message,
1536                       RmrMessagesBuffer_t &rmrMessageBuffer) {
1537     auto procedureCode = pdu->choice.successfulOutcome->procedureCode;
1538     auto logLevel = mdclog_level_get();
1539     if (logLevel >= MDCLOG_INFO) {
1540         mdclog_write(MDCLOG_INFO, "Successful Outcome %ld", procedureCode);
1541     }
1542     switch (procedureCode) {
1543         case ProcedureCode_id_E2setup: {
1544             if (logLevel >= MDCLOG_DEBUG) {
1545                 mdclog_write(MDCLOG_DEBUG, "Got E2setup\n");
1546             }
1547             break;
1548         }
1549         case ProcedureCode_id_ErrorIndication: {
1550             if (logLevel >= MDCLOG_DEBUG) {
1551                 mdclog_write(MDCLOG_DEBUG, "Got ErrorIndication %s", message.message.enodbName);
1552             }
1553             if (sendRequestToXapp(message, RIC_ERROR_INDICATION, rmrMessageBuffer) != 0) {
1554                 mdclog_write(MDCLOG_ERR, "RIC_ERROR_INDICATION failed to send to xAPP");
1555             }
1556             break;
1557         }
1558         case ProcedureCode_id_Reset: {
1559             if (logLevel >= MDCLOG_DEBUG) {
1560                 mdclog_write(MDCLOG_DEBUG, "Got Reset %s", message.message.enodbName);
1561             }
1562             if (sendRequestToXapp(message, RIC_X2_RESET, rmrMessageBuffer) != 0) {
1563                 mdclog_write(MDCLOG_ERR, "RIC_X2_RESET message failed to send to xAPP");
1564             }
1565             break;
1566         }
1567         case ProcedureCode_id_RICcontrol: {
1568             if (logLevel >= MDCLOG_DEBUG) {
1569                 mdclog_write(MDCLOG_DEBUG, "Got RICcontrol %s", message.message.enodbName);
1570             }
1571             for (auto i = 0;
1572                  i < pdu->choice.successfulOutcome->value.choice.RICcontrolAcknowledge.protocolIEs.list.count; i++) {
1573                 auto messageSent = false;
1574                 RICcontrolAcknowledge_IEs_t *ie = pdu->choice.successfulOutcome->value.choice.RICcontrolAcknowledge.protocolIEs.list.array[i];
1575                 if (mdclog_level_get() >= MDCLOG_DEBUG) {
1576                     mdclog_write(MDCLOG_DEBUG, "ie type (ProtocolIE_ID) = %ld", ie->id);
1577                 }
1578                 if (ie->id == ProtocolIE_ID_id_RICrequestID) {
1579                     if (mdclog_level_get() >= MDCLOG_DEBUG) {
1580                         mdclog_write(MDCLOG_DEBUG, "Got RIC requestId entry, ie type (ProtocolIE_ID) = %ld", ie->id);
1581                     }
1582                     if (ie->value.present == RICcontrolAcknowledge_IEs__value_PR_RICrequestID) {
1583                         message.message.messageType = rmrMessageBuffer.sendMessage->mtype = RIC_CONTROL_ACK;
1584                         rmrMessageBuffer.sendMessage->state = 0;
1585                         rmrMessageBuffer.sendMessage->sub_id = (int) ie->value.choice.RICrequestID.ricRequestorID;
1586                         static unsigned char tx[32];
1587                         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1588                         rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, strlen((const char *) tx));
1589                         rmr_bytes2meid(rmrMessageBuffer.sendMessage,
1590                                        (unsigned char *)message.message.enodbName,
1591                                        strlen(message.message.enodbName));
1592
1593                         sendRmrMessage(rmrMessageBuffer, message);
1594                         messageSent = true;
1595                     } else {
1596                         mdclog_write(MDCLOG_ERR, "RIC request id missing illigal request");
1597                     }
1598                 }
1599                 if (messageSent) {
1600                     break;
1601                 }
1602             }
1603
1604             break;
1605         }
1606         case ProcedureCode_id_RICindication: {
1607             if (logLevel >= MDCLOG_DEBUG) {
1608                 mdclog_write(MDCLOG_DEBUG, "Got RICindication %s", message.message.enodbName);
1609             }
1610             for (auto i = 0; i < pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.count; i++) {
1611                 auto messageSent = false;
1612                 RICindication_IEs_t *ie = pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.array[i];
1613                 if (logLevel >= MDCLOG_DEBUG) {
1614                     mdclog_write(MDCLOG_DEBUG, "ie type (ProtocolIE_ID) = %ld", ie->id);
1615                 }
1616                 if (ie->id == ProtocolIE_ID_id_RICrequestID) {
1617                     if (logLevel >= MDCLOG_DEBUG) {
1618                         mdclog_write(MDCLOG_DEBUG, "Got RIC requestId entry, ie type (ProtocolIE_ID) = %ld", ie->id);
1619                     }
1620                     if (ie->value.present == RICindication_IEs__value_PR_RICrequestID) {
1621                         static unsigned char tx[32];
1622                         message.message.messageType = rmrMessageBuffer.sendMessage->mtype = RIC_INDICATION;
1623                         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1624                         rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, strlen((const char *) tx));
1625                         rmr_bytes2meid(rmrMessageBuffer.sendMessage,
1626                                        (unsigned char *)message.message.enodbName,
1627                                        strlen(message.message.enodbName));
1628                         rmrMessageBuffer.sendMessage->state = 0;
1629                         rmrMessageBuffer.sendMessage->sub_id = (int) ie->value.choice.RICrequestID.ricRequestorID;
1630                         if (mdclog_level_get() >= MDCLOG_DEBUG) {
1631                             mdclog_write(MDCLOG_DEBUG, "RIC sub id = %d, message type = %d",
1632                                          rmrMessageBuffer.sendMessage->sub_id,
1633                                          rmrMessageBuffer.sendMessage->mtype);
1634                         }
1635                         sendRmrMessage(rmrMessageBuffer, message);
1636                         messageSent = true;
1637                     } else {
1638                         mdclog_write(MDCLOG_ERR, "RIC request id missing illigal request");
1639                     }
1640                 }
1641                 if (messageSent) {
1642                     break;
1643                 }
1644             }
1645             break;
1646         }
1647         case ProcedureCode_id_RICserviceQuery: {
1648             if (logLevel >= MDCLOG_DEBUG) {
1649                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceQuery %s", message.message.enodbName);
1650             }
1651             break;
1652         }
1653         case ProcedureCode_id_RICserviceUpdate: {
1654             if (logLevel >= MDCLOG_DEBUG) {
1655                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceUpdate %s", message.message.enodbName);
1656             }
1657             if (sendRequestToXapp(message, RIC_SERVICE_UPDATE, rmrMessageBuffer) != 0) {
1658                 mdclog_write(MDCLOG_ERR, "RIC_SERVICE_UPDATE message failed to send to xAPP");
1659             }
1660             break;
1661         }
1662         case ProcedureCode_id_RICsubscription: {
1663             if (logLevel >= MDCLOG_DEBUG) {
1664                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscription %s", message.message.enodbName);
1665             }
1666             if (sendRequestToXapp(message, RIC_SUB_RESP, rmrMessageBuffer) != 0) {
1667                 mdclog_write(MDCLOG_ERR, "Subscription successful message failed to send to xAPP");
1668             }
1669             break;
1670         }
1671         case ProcedureCode_id_RICsubscriptionDelete: {
1672             if (logLevel >= MDCLOG_DEBUG) {
1673                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscriptionDelete %s", message.message.enodbName);
1674             }
1675             if (sendRequestToXapp(message, RIC_SUB_DEL_RESP, rmrMessageBuffer) != 0) {
1676                 mdclog_write(MDCLOG_ERR, "Subscription delete successful message failed to send to xAPP");
1677             }
1678             break;
1679         }
1680         default: {
1681             mdclog_write(MDCLOG_WARN, "Undefined or not supported message = %ld", procedureCode);
1682             message.message.messageType = 0; // no RMR message type yet
1683             buildJsonMessage(message);
1684
1685             break;
1686         }
1687     }
1688 }
1689
1690 /**
1691  *
1692  * @param pdu
1693  * @param message
1694  * @param rmrMessageBuffer
1695  */
1696 void asnUnSuccsesfulMsg(E2AP_PDU_t *pdu,
1697                         Sctp_Map_t *sctpMap,
1698                         ReportingMessages_t &message,
1699                         RmrMessagesBuffer_t &rmrMessageBuffer) {
1700     auto procedureCode = pdu->choice.unsuccessfulOutcome->procedureCode;
1701     auto logLevel = mdclog_level_get();
1702     if (logLevel >= MDCLOG_INFO) {
1703         mdclog_write(MDCLOG_INFO, "Unsuccessful Outcome %ld", procedureCode);
1704     }
1705     switch (procedureCode) {
1706         case ProcedureCode_id_E2setup: {
1707             if (logLevel >= MDCLOG_DEBUG) {
1708                 mdclog_write(MDCLOG_DEBUG, "Got E2setup\n");
1709             }
1710             break;
1711         }
1712         case ProcedureCode_id_ErrorIndication: {
1713             if (logLevel >= MDCLOG_DEBUG) {
1714                 mdclog_write(MDCLOG_DEBUG, "Got ErrorIndication %s", message.message.enodbName);
1715             }
1716             if (sendRequestToXapp(message, RIC_ERROR_INDICATION, rmrMessageBuffer) != 0) {
1717                 mdclog_write(MDCLOG_ERR, "RIC_ERROR_INDICATION failed to send to xAPP");
1718             }
1719             break;
1720         }
1721         case ProcedureCode_id_Reset: {
1722             if (logLevel >= MDCLOG_DEBUG) {
1723                 mdclog_write(MDCLOG_DEBUG, "Got Reset %s", message.message.enodbName);
1724             }
1725             if (sendRequestToXapp(message, RIC_X2_RESET, rmrMessageBuffer) != 0) {
1726                 mdclog_write(MDCLOG_ERR, "RIC_X2_RESET message failed to send to xAPP");
1727             }
1728             break;
1729         }
1730         case ProcedureCode_id_RICcontrol: {
1731             if (logLevel >= MDCLOG_DEBUG) {
1732                 mdclog_write(MDCLOG_DEBUG, "Got RICcontrol %s", message.message.enodbName);
1733             }
1734             for (int i = 0;
1735                  i < pdu->choice.unsuccessfulOutcome->value.choice.RICcontrolFailure.protocolIEs.list.count; i++) {
1736                 auto messageSent = false;
1737                 RICcontrolFailure_IEs_t *ie = pdu->choice.unsuccessfulOutcome->value.choice.RICcontrolFailure.protocolIEs.list.array[i];
1738                 if (logLevel >= MDCLOG_DEBUG) {
1739                     mdclog_write(MDCLOG_DEBUG, "ie type (ProtocolIE_ID) = %ld", ie->id);
1740                 }
1741                 if (ie->id == ProtocolIE_ID_id_RICrequestID) {
1742                     if (logLevel >= MDCLOG_DEBUG) {
1743                         mdclog_write(MDCLOG_DEBUG, "Got RIC requestId entry, ie type (ProtocolIE_ID) = %ld", ie->id);
1744                     }
1745                     if (ie->value.present == RICcontrolFailure_IEs__value_PR_RICrequestID) {
1746                         message.message.messageType = rmrMessageBuffer.sendMessage->mtype = RIC_CONTROL_FAILURE;
1747                         rmrMessageBuffer.sendMessage->state = 0;
1748                         rmrMessageBuffer.sendMessage->sub_id = (int) ie->value.choice.RICrequestID.ricRequestorID;
1749                         static unsigned char tx[32];
1750                         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1751                         rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, strlen((const char *) tx));
1752                         rmr_bytes2meid(rmrMessageBuffer.sendMessage, (unsigned char *) message.message.enodbName,
1753                                        strlen(message.message.enodbName));
1754                         sendRmrMessage(rmrMessageBuffer, message);
1755                         messageSent = true;
1756                     } else {
1757                         mdclog_write(MDCLOG_ERR, "RIC request id missing illigal request");
1758                     }
1759                 }
1760                 if (messageSent) {
1761                     break;
1762                 }
1763             }
1764             break;
1765         }
1766         case ProcedureCode_id_RICindication: {
1767             if (logLevel >= MDCLOG_DEBUG) {
1768                 mdclog_write(MDCLOG_DEBUG, "Got RICindication %s", message.message.enodbName);
1769             }
1770             for (auto i = 0; i < pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.count; i++) {
1771                 auto messageSent = false;
1772                 RICindication_IEs_t *ie = pdu->choice.initiatingMessage->value.choice.RICindication.protocolIEs.list.array[i];
1773                 if (logLevel >= MDCLOG_DEBUG) {
1774                     mdclog_write(MDCLOG_DEBUG, "ie type (ProtocolIE_ID) = %ld", ie->id);
1775                 }
1776                 if (ie->id == ProtocolIE_ID_id_RICrequestID) {
1777                     if (logLevel >= MDCLOG_DEBUG) {
1778                         mdclog_write(MDCLOG_DEBUG, "Got RIC requestId entry, ie type (ProtocolIE_ID) = %ld", ie->id);
1779                     }
1780                     if (ie->value.present == RICindication_IEs__value_PR_RICrequestID) {
1781                         static unsigned char tx[32];
1782                         message.message.messageType = rmrMessageBuffer.sendMessage->mtype = RIC_INDICATION;
1783                         snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1784                         rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, strlen((const char *) tx));
1785                         rmr_bytes2meid(rmrMessageBuffer.sendMessage,
1786                                        (unsigned char *)message.message.enodbName,
1787                                        strlen(message.message.enodbName));
1788                         rmrMessageBuffer.sendMessage->state = 0;
1789                         rmrMessageBuffer.sendMessage->sub_id = (int) ie->value.choice.RICrequestID.ricRequestorID;
1790                         if (mdclog_level_get() >= MDCLOG_DEBUG) {
1791                             mdclog_write(MDCLOG_DEBUG, "RIC sub id = %d, message type = %d",
1792                                          rmrMessageBuffer.sendMessage->sub_id,
1793                                          rmrMessageBuffer.sendMessage->mtype);
1794                         }
1795                         sendRmrMessage(rmrMessageBuffer, message);
1796                         messageSent = true;
1797                     } else {
1798                         mdclog_write(MDCLOG_ERR, "RIC request id missing illigal request");
1799                     }
1800                 }
1801                 if (messageSent) {
1802                     break;
1803                 }
1804             }
1805             break;
1806         }
1807         case ProcedureCode_id_RICserviceQuery: {
1808             if (logLevel >= MDCLOG_DEBUG) {
1809                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceQuery %s", message.message.enodbName);
1810             }
1811             break;
1812         }
1813         case ProcedureCode_id_RICserviceUpdate: {
1814             if (logLevel >= MDCLOG_DEBUG) {
1815                 mdclog_write(MDCLOG_DEBUG, "Got RICserviceUpdate %s", message.message.enodbName);
1816             }
1817             if (sendRequestToXapp(message, RIC_SERVICE_UPDATE, rmrMessageBuffer) != 0) {
1818                 mdclog_write(MDCLOG_ERR, "RIC_SERVICE_UPDATE message failed to send to xAPP");
1819             }
1820             break;
1821         }
1822         case ProcedureCode_id_RICsubscription: {
1823             if (logLevel >= MDCLOG_DEBUG) {
1824                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscription %s", message.message.enodbName);
1825             }
1826             if (sendRequestToXapp(message, RIC_SUB_FAILURE, rmrMessageBuffer) != 0) {
1827                 mdclog_write(MDCLOG_ERR, "Subscription unsuccessful message failed to send to xAPP");
1828             }
1829             break;
1830         }
1831         case ProcedureCode_id_RICsubscriptionDelete: {
1832             if (logLevel >= MDCLOG_DEBUG) {
1833                 mdclog_write(MDCLOG_DEBUG, "Got RICsubscriptionDelete %s", message.message.enodbName);
1834             }
1835             if (sendRequestToXapp(message, RIC_SUB_DEL_FAILURE, rmrMessageBuffer) != 0) {
1836                 mdclog_write(MDCLOG_ERR, "Subscription Delete unsuccessful message failed to send to xAPP");
1837             }
1838             break;
1839         }
1840         default: {
1841             mdclog_write(MDCLOG_WARN, "Undefined or not supported message = %ld", procedureCode);
1842             message.message.messageType = 0; // no RMR message type yet
1843
1844             buildJsonMessage(message);
1845
1846             break;
1847         }
1848     }
1849 }
1850
1851 /**
1852  *
1853  * @param message
1854  * @param requestId
1855  * @param rmrMmessageBuffer
1856  * @return
1857  */
1858 int sendRequestToXapp(ReportingMessages_t &message,
1859                       int requestId,
1860                       RmrMessagesBuffer_t &rmrMmessageBuffer) {
1861     rmr_bytes2meid(rmrMmessageBuffer.sendMessage,
1862                    (unsigned char *)message.message.enodbName,
1863                    strlen(message.message.enodbName));
1864     message.message.messageType = rmrMmessageBuffer.sendMessage->mtype = requestId;
1865     rmrMmessageBuffer.sendMessage->state = 0;
1866     static unsigned char tx[32];
1867     snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
1868     rmr_bytes2xact(rmrMmessageBuffer.sendMessage, tx, strlen((const char *) tx));
1869
1870     auto rc = sendRmrMessage(rmrMmessageBuffer, message);
1871     return rc;
1872 }
1873
1874
1875 void getRmrContext(sctp_params_t &pSctpParams) {
1876     pSctpParams.rmrCtx = nullptr;
1877     pSctpParams.rmrCtx = rmr_init(pSctpParams.rmrAddress, RECEIVE_XAPP_BUFFER_SIZE, RMRFL_NONE);
1878     if (pSctpParams.rmrCtx == nullptr) {
1879         mdclog_write(MDCLOG_ERR, "Failed to initialize RMR");
1880         return;
1881     }
1882
1883     rmr_set_stimeout(pSctpParams.rmrCtx, 0);    // disable retries for any send operation
1884     // we need to find that routing table exist and we can run
1885     if (mdclog_level_get() >= MDCLOG_INFO) {
1886         mdclog_write(MDCLOG_INFO, "We are after RMR INIT wait for RMR_Ready");
1887     }
1888     int rmrReady = 0;
1889     int count = 0;
1890     while (!rmrReady) {
1891         if ((rmrReady = rmr_ready(pSctpParams.rmrCtx)) == 0) {
1892             sleep(1);
1893         }
1894         count++;
1895         if (count % 60 == 0) {
1896             mdclog_write(MDCLOG_INFO, "waiting to RMR ready state for %d seconds", count);
1897         }
1898     }
1899     if (mdclog_level_get() >= MDCLOG_INFO) {
1900         mdclog_write(MDCLOG_INFO, "RMR running");
1901     }
1902     rmr_init_trace(pSctpParams.rmrCtx, 200);
1903     // get the RMR fd for the epoll
1904     pSctpParams.rmrListenFd = rmr_get_rcvfd(pSctpParams.rmrCtx);
1905     struct epoll_event event{};
1906     // add RMR fd to epoll
1907     event.events = (EPOLLIN);
1908     event.data.fd = pSctpParams.rmrListenFd;
1909     // add listening RMR FD to epoll
1910     if (epoll_ctl(pSctpParams.epoll_fd, EPOLL_CTL_ADD, pSctpParams.rmrListenFd, &event)) {
1911         mdclog_write(MDCLOG_ERR, "Failed to add RMR descriptor to epoll");
1912         close(pSctpParams.rmrListenFd);
1913         rmr_close(pSctpParams.rmrCtx);
1914         pSctpParams.rmrCtx = nullptr;
1915     }
1916 }
1917
1918 int BuildPERSetupResponseMessaeFromXML(ReportingMessages_t &message, RmrMessagesBuffer_t &rmrMessageBuffer) {
1919     E2AP_PDU_t *pdu;
1920
1921     if (mdclog_level_get() >= MDCLOG_DEBUG) {
1922         mdclog_write(MDCLOG_DEBUG, "got xml setup response \n %s\n", rmrMessageBuffer.rcvMessage->payload);
1923     }
1924     auto rval = asn_decode(nullptr, ATS_BASIC_XER, &asn_DEF_E2AP_PDU, (void **) &pdu,
1925                            rmrMessageBuffer.rcvMessage->payload, rmrMessageBuffer.rcvMessage->len);
1926     if (rval.code != RC_OK) {
1927         mdclog_write(MDCLOG_ERR, "Error %d Decoding (unpack) setup response  from E2MGR : %s",
1928                      rval.code,
1929                      message.message.enodbName);
1930         return -1;
1931     }
1932
1933     int buff_size = RECEIVE_XAPP_BUFFER_SIZE;
1934     auto er = asn_encode_to_buffer(nullptr, ATS_ALIGNED_BASIC_PER, &asn_DEF_E2AP_PDU, pdu,
1935                                    rmrMessageBuffer.rcvMessage->payload, buff_size);
1936     if (er.encoded == -1) {
1937         mdclog_write(MDCLOG_ERR, "encoding of %s failed, %s", asn_DEF_E2AP_PDU.name, strerror(errno));
1938         return -1;
1939     } else if (er.encoded > (ssize_t)buff_size) {
1940         mdclog_write(MDCLOG_ERR, "Buffer of size %d is to small for %s, at %s line %d",
1941                      (int)rmrMessageBuffer.rcvMessage->len,
1942                      asn_DEF_E2AP_PDU.name,
1943                      __func__,
1944                      __LINE__);
1945         return -1;
1946     }
1947     rmrMessageBuffer.rcvMessage->len = er.encoded;
1948     return 0;
1949 }
1950
1951 /**
1952  *
1953  * @param sctpMap
1954  * @param rmrMessageBuffer
1955  * @param ts
1956  * @return
1957  */
1958 int receiveXappMessages(Sctp_Map_t *sctpMap,
1959                         RmrMessagesBuffer_t &rmrMessageBuffer,
1960                         struct timespec &ts) {
1961     if (rmrMessageBuffer.rcvMessage == nullptr) {
1962         //we have error
1963         mdclog_write(MDCLOG_ERR, "RMR Allocation message, %s", strerror(errno));
1964         return -1;
1965     }
1966
1967     if (mdclog_level_get() >= MDCLOG_DEBUG) {
1968         mdclog_write(MDCLOG_DEBUG, "Call to rmr_rcv_msg");
1969     }
1970     rmrMessageBuffer.rcvMessage = rmr_rcv_msg(rmrMessageBuffer.rmrCtx, rmrMessageBuffer.rcvMessage);
1971     if (rmrMessageBuffer.rcvMessage == nullptr) {
1972         mdclog_write(MDCLOG_ERR, "RMR Receving message with null pointer, Realloc rmr mesage buffer");
1973         rmrMessageBuffer.rcvMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
1974         return -2;
1975     }
1976     ReportingMessages_t message;
1977     message.message.direction = 'D';
1978     message.message.time.tv_nsec = ts.tv_nsec;
1979     message.message.time.tv_sec = ts.tv_sec;
1980
1981     // get message payload
1982     //auto msgData = msg->payload;
1983     if (rmrMessageBuffer.rcvMessage->state != 0) {
1984         mdclog_write(MDCLOG_ERR, "RMR Receving message with stat = %d", rmrMessageBuffer.rcvMessage->state);
1985         return -1;
1986     }
1987     rmr_get_meid(rmrMessageBuffer.rcvMessage, (unsigned char *)message.message.enodbName);
1988     switch (rmrMessageBuffer.rcvMessage->mtype) {
1989         case RIC_E2_SETUP_RESP : {
1990             if (BuildPERSetupResponseMessaeFromXML(message, rmrMessageBuffer) != 0) {
1991                 break;
1992             }
1993
1994             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
1995                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_E2_SETUP_RESP");
1996                 return -6;
1997             }
1998             break;
1999         }
2000         case RIC_E2_SETUP_FAILURE : {
2001             if (BuildPERSetupResponseMessaeFromXML(message, rmrMessageBuffer) != 0) {
2002                 break;
2003             }
2004             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2005                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_E2_SETUP_FAILURE");
2006                 return -6;
2007             }
2008             break;
2009         }
2010         case RIC_ERROR_INDICATION: {
2011             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2012                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_ERROR_INDICATION");
2013                 return -6;
2014             }
2015             break;
2016         }
2017         case RIC_SUB_REQ: {
2018             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2019                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_SUB_REQ");
2020                 return -6;
2021             }
2022             break;
2023         }
2024         case RIC_SUB_DEL_REQ: {
2025             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2026                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_SUB_DEL_REQ");
2027                 return -6;
2028             }
2029             break;
2030         }
2031         case RIC_CONTROL_REQ: {
2032             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2033                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_CONTROL_REQ");
2034                 return -6;
2035             }
2036             break;
2037         }
2038         case RIC_SERVICE_QUERY: {
2039             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2040                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_SERVICE_QUERY");
2041                 return -6;
2042             }
2043             break;
2044         }
2045         case RIC_SERVICE_UPDATE_ACK: {
2046             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2047                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_SERVICE_UPDATE_ACK");
2048                 return -6;
2049             }
2050             break;
2051         }
2052         case RIC_SERVICE_UPDATE_FAILURE: {
2053             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2054                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_SERVICE_UPDATE_FAILURE");
2055                 return -6;
2056             }
2057             break;
2058         }
2059         case RIC_X2_RESET: {
2060             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2061                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_X2_RESET");
2062                 return -6;
2063             }
2064             break;
2065         }
2066         case RIC_X2_RESET_RESP: {
2067             if (sendDirectionalSctpMsg(rmrMessageBuffer, message, 0, sctpMap) != 0) {
2068                 mdclog_write(MDCLOG_ERR, "Failed to send RIC_X2_RESET_RESP");
2069                 return -6;
2070             }
2071             break;
2072         }
2073         case RIC_SCTP_CLEAR_ALL: {
2074             mdclog_write(MDCLOG_INFO, "RIC_SCTP_CLEAR_ALL");
2075             // loop on all keys and close socket and then erase all map.
2076             vector<char *> v;
2077             sctpMap->getKeys(v);
2078             for (auto const &iter : v) { //}; iter != sctpMap.end(); iter++) {
2079                 if (!boost::starts_with((string) (iter), "host:") && !boost::starts_with((string) (iter), "msg:")) {
2080                     auto *peerInfo = (ConnectedCU_t *) sctpMap->find(iter);
2081                     if (peerInfo == nullptr) {
2082                         continue;
2083                     }
2084                     close(peerInfo->fileDescriptor);
2085                     memcpy(message.message.enodbName, peerInfo->enodbName, sizeof(peerInfo->enodbName));
2086                     message.message.direction = 'D';
2087                     message.message.time.tv_nsec = ts.tv_nsec;
2088                     message.message.time.tv_sec = ts.tv_sec;
2089
2090                     message.message.asnLength = rmrMessageBuffer.sendMessage->len =
2091                             snprintf((char *)rmrMessageBuffer.sendMessage->payload,
2092                                      256,
2093                                      "%s|RIC_SCTP_CLEAR_ALL",
2094                                      peerInfo->enodbName);
2095                     message.message.asndata = rmrMessageBuffer.sendMessage->payload;
2096                     mdclog_write(MDCLOG_INFO, "%s", message.message.asndata);
2097                     if (sendRequestToXapp(message, RIC_SCTP_CONNECTION_FAILURE, rmrMessageBuffer) != 0) {
2098                         mdclog_write(MDCLOG_ERR, "SCTP_CONNECTION_FAIL message failed to send to xAPP");
2099                     }
2100                     free(peerInfo);
2101                 }
2102             }
2103
2104             sleep(1);
2105             sctpMap->clear();
2106             break;
2107         }
2108         case E2_TERM_KEEP_ALIVE_REQ: {
2109             // send message back
2110             rmr_bytes2payload(rmrMessageBuffer.sendMessage,
2111                               (unsigned char *)rmrMessageBuffer.ka_message,
2112                               rmrMessageBuffer.ka_message_len);
2113             rmrMessageBuffer.sendMessage->mtype = E2_TERM_KEEP_ALIVE_RESP;
2114             rmrMessageBuffer.sendMessage->state = 0;
2115             static unsigned char tx[32];
2116             auto txLen = snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
2117             rmr_bytes2xact(rmrMessageBuffer.sendMessage, tx, txLen);
2118             rmrMessageBuffer.sendMessage = rmr_send_msg(rmrMessageBuffer.rmrCtx, rmrMessageBuffer.sendMessage);
2119             if (rmrMessageBuffer.sendMessage == nullptr) {
2120                 rmrMessageBuffer.sendMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
2121                 mdclog_write(MDCLOG_ERR, "Failed to send E2_TERM_KEEP_ALIVE_RESP RMR message returned NULL");
2122             } else if (rmrMessageBuffer.sendMessage->state != 0)  {
2123                 mdclog_write(MDCLOG_ERR, "Failed to send E2_TERM_KEEP_ALIVE_RESP, on RMR state = %d ( %s)",
2124                              rmrMessageBuffer.sendMessage->state, translateRmrErrorMessages(rmrMessageBuffer.sendMessage->state).c_str());
2125             } else if (mdclog_level_get() >= MDCLOG_DEBUG) {
2126                 mdclog_write(MDCLOG_DEBUG, "Got Keep Alive Request send : %s", rmrMessageBuffer.ka_message);
2127             }
2128
2129             break;
2130         }
2131         default:
2132             mdclog_write(MDCLOG_WARN, "Message Type : %d is not seported", rmrMessageBuffer.rcvMessage->mtype);
2133             message.message.asndata = rmrMessageBuffer.rcvMessage->payload;
2134             message.message.asnLength = rmrMessageBuffer.rcvMessage->len;
2135             message.message.time.tv_nsec = ts.tv_nsec;
2136             message.message.time.tv_sec = ts.tv_sec;
2137             message.message.messageType = rmrMessageBuffer.rcvMessage->mtype;
2138
2139             buildJsonMessage(message);
2140
2141
2142             return -7;
2143     }
2144     if (mdclog_level_get() >= MDCLOG_DEBUG) {
2145         mdclog_write(MDCLOG_DEBUG, "EXIT OK from %s", __FUNCTION__);
2146     }
2147     return 0;
2148 }
2149
2150 /**
2151  * Send message to the CU that is not expecting for successful or unsuccessful results
2152  * @param messageBuffer
2153  * @param message
2154  * @param failedMsgId
2155  * @param sctpMap
2156  * @return
2157  */
2158 int sendDirectionalSctpMsg(RmrMessagesBuffer_t &messageBuffer,
2159                            ReportingMessages_t &message,
2160                            int failedMsgId,
2161                            Sctp_Map_t *sctpMap) {
2162
2163     getRequestMetaData(message, messageBuffer);
2164     if (mdclog_level_get() >= MDCLOG_INFO) {
2165         mdclog_write(MDCLOG_INFO, "send message to %s address", message.message.enodbName);
2166     }
2167
2168     auto rc = sendMessagetoCu(sctpMap, messageBuffer, message, failedMsgId);
2169     return rc;
2170 }
2171
2172 /**
2173  *
2174  * @param sctpMap
2175  * @param messageBuffer
2176  * @param message
2177  * @param failedMesgId
2178  * @return
2179  */
2180 int sendMessagetoCu(Sctp_Map_t *sctpMap,
2181                     RmrMessagesBuffer_t &messageBuffer,
2182                     ReportingMessages_t &message,
2183                     int failedMesgId) {
2184     auto *peerInfo = (ConnectedCU_t *) sctpMap->find(message.message.enodbName);
2185     if (peerInfo == nullptr) {
2186         if (failedMesgId != 0) {
2187             sendFailedSendingMessagetoXapp(messageBuffer, message, failedMesgId);
2188         } else {
2189             mdclog_write(MDCLOG_ERR, "Failed to send message no CU entry %s", message.message.enodbName);
2190         }
2191         return -1;
2192     }
2193
2194     // get the FD
2195     message.message.messageType = messageBuffer.rcvMessage->mtype;
2196     auto rc = sendSctpMsg(peerInfo, message, sctpMap);
2197     return rc;
2198 }
2199
2200 /**
2201  *
2202  * @param rmrCtx the rmr context to send and receive
2203  * @param msg the msg we got fromxApp
2204  * @param metaData data from xApp in ordered struct
2205  * @param failedMesgId the return message type error
2206  */
2207 void
2208 sendFailedSendingMessagetoXapp(RmrMessagesBuffer_t &rmrMessageBuffer, ReportingMessages_t &message, int failedMesgId) {
2209     rmr_mbuf_t *msg = rmrMessageBuffer.sendMessage;
2210     msg->len = snprintf((char *) msg->payload, 200, "the gNb/eNode name %s not found",
2211                         message.message.enodbName);
2212     if (mdclog_level_get() >= MDCLOG_INFO) {
2213         mdclog_write(MDCLOG_INFO, "%s", msg->payload);
2214     }
2215     msg->mtype = failedMesgId;
2216     msg->state = 0;
2217
2218     static unsigned char tx[32];
2219     snprintf((char *) tx, sizeof tx, "%15ld", transactionCounter++);
2220     rmr_bytes2xact(msg, tx, strlen((const char *) tx));
2221
2222     sendRmrMessage(rmrMessageBuffer, message);
2223 }
2224
2225
2226
2227 /**
2228  *
2229  * @param epoll_fd
2230  * @param peerInfo
2231  * @param events
2232  * @param sctpMap
2233  * @param enodbName
2234  * @param msgType
2235  * @return
2236  */
2237 int addToEpoll(int epoll_fd,
2238                ConnectedCU_t *peerInfo,
2239                uint32_t events,
2240                Sctp_Map_t *sctpMap,
2241                char *enodbName,
2242                int msgType) {
2243     // Add to Epol
2244     struct epoll_event event{};
2245     event.data.ptr = peerInfo;
2246     event.events = events;
2247     if (epoll_ctl(epoll_fd, EPOLL_CTL_ADD, peerInfo->fileDescriptor, &event) < 0) {
2248         if (mdclog_level_get() >= MDCLOG_DEBUG) {
2249             mdclog_write(MDCLOG_DEBUG, "epoll_ctl EPOLL_CTL_ADD (may chack not to quit here), %s, %s %d",
2250                          strerror(errno), __func__, __LINE__);
2251         }
2252         close(peerInfo->fileDescriptor);
2253         if (enodbName != nullptr) {
2254             cleanHashEntry(peerInfo, sctpMap);
2255             char key[MAX_ENODB_NAME_SIZE * 2];
2256             snprintf(key, MAX_ENODB_NAME_SIZE * 2, "msg:%s|%d", enodbName, msgType);
2257             if (mdclog_level_get() >= MDCLOG_DEBUG) {
2258                 mdclog_write(MDCLOG_DEBUG, "remove key = %s from %s at line %d", key, __FUNCTION__, __LINE__);
2259             }
2260             auto tmp = sctpMap->find(key);
2261             if (tmp) {
2262                 free(tmp);
2263                 sctpMap->erase(key);
2264             }
2265         } else {
2266             peerInfo->enodbName[0] = 0;
2267         }
2268         mdclog_write(MDCLOG_ERR, "epoll_ctl EPOLL_CTL_ADD (may chack not to quit here)");
2269         return -1;
2270     }
2271     return 0;
2272 }
2273
2274 /**
2275  *
2276  * @param epoll_fd
2277  * @param peerInfo
2278  * @param events
2279  * @param sctpMap
2280  * @param enodbName
2281  * @param msgType
2282  * @return
2283  */
2284 int modifyToEpoll(int epoll_fd,
2285                   ConnectedCU_t *peerInfo,
2286                   uint32_t events,
2287                   Sctp_Map_t *sctpMap,
2288                   char *enodbName,
2289                   int msgType) {
2290     // Add to Epol
2291     struct epoll_event event{};
2292     event.data.ptr = peerInfo;
2293     event.events = events;
2294     if (epoll_ctl(epoll_fd, EPOLL_CTL_MOD, peerInfo->fileDescriptor, &event) < 0) {
2295         if (mdclog_level_get() >= MDCLOG_DEBUG) {
2296             mdclog_write(MDCLOG_DEBUG, "epoll_ctl EPOLL_CTL_MOD (may chack not to quit here), %s, %s %d",
2297                          strerror(errno), __func__, __LINE__);
2298         }
2299         close(peerInfo->fileDescriptor);
2300         cleanHashEntry(peerInfo, sctpMap);
2301         char key[MAX_ENODB_NAME_SIZE * 2];
2302         snprintf(key, MAX_ENODB_NAME_SIZE * 2, "msg:%s|%d", enodbName, msgType);
2303         if (mdclog_level_get() >= MDCLOG_DEBUG) {
2304             mdclog_write(MDCLOG_DEBUG, "remove key = %s from %s at line %d", key, __FUNCTION__, __LINE__);
2305         }
2306         auto tmp = sctpMap->find(key);
2307         if (tmp) {
2308             free(tmp);
2309         }
2310         sctpMap->erase(key);
2311         mdclog_write(MDCLOG_ERR, "epoll_ctl EPOLL_CTL_ADD (may chack not to quit here)");
2312         return -1;
2313     }
2314     return 0;
2315 }
2316
2317
2318 int sendRmrMessage(RmrMessagesBuffer_t &rmrMessageBuffer, ReportingMessages_t &message) {
2319     buildJsonMessage(message);
2320
2321     rmrMessageBuffer.sendMessage = rmr_send_msg(rmrMessageBuffer.rmrCtx, rmrMessageBuffer.sendMessage);
2322
2323     if (rmrMessageBuffer.sendMessage == nullptr) {
2324         rmrMessageBuffer.sendMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
2325         mdclog_write(MDCLOG_ERR, "RMR failed send message returned with NULL pointer");
2326         return -1;
2327     }
2328
2329     if (rmrMessageBuffer.sendMessage->state != 0) {
2330         char meid[RMR_MAX_MEID]{};
2331         if (rmrMessageBuffer.sendMessage->state == RMR_ERR_RETRY) {
2332             usleep(5);
2333             rmrMessageBuffer.sendMessage->state = 0;
2334             mdclog_write(MDCLOG_INFO, "RETRY sending Message type %d to Xapp from %s",
2335                          rmrMessageBuffer.sendMessage->mtype,
2336                          rmr_get_meid(rmrMessageBuffer.sendMessage, (unsigned char *)meid));
2337             rmrMessageBuffer.sendMessage = rmr_send_msg(rmrMessageBuffer.rmrCtx, rmrMessageBuffer.sendMessage);
2338             if (rmrMessageBuffer.sendMessage == nullptr) {
2339                 mdclog_write(MDCLOG_ERR, "RMR failed send message returned with NULL pointer");
2340                 rmrMessageBuffer.sendMessage = rmr_alloc_msg(rmrMessageBuffer.rmrCtx, RECEIVE_XAPP_BUFFER_SIZE);
2341                 return -1;
2342             } else if (rmrMessageBuffer.sendMessage->state != 0) {
2343                 mdclog_write(MDCLOG_ERR,
2344                              "Message state %s while sending request %d to Xapp from %s after retry of 10 microseconds",
2345                              translateRmrErrorMessages(rmrMessageBuffer.sendMessage->state).c_str(),
2346                              rmrMessageBuffer.sendMessage->mtype,
2347                              rmr_get_meid(rmrMessageBuffer.sendMessage, (unsigned char *)meid));
2348                 auto rc = rmrMessageBuffer.sendMessage->state;
2349                 return rc;
2350             }
2351         } else {
2352             mdclog_write(MDCLOG_ERR, "Message state %s while sending request %d to Xapp from %s",
2353                          translateRmrErrorMessages(rmrMessageBuffer.sendMessage->state).c_str(),
2354                          rmrMessageBuffer.sendMessage->mtype,
2355                          rmr_get_meid(rmrMessageBuffer.sendMessage, (unsigned char *)meid));
2356             return rmrMessageBuffer.sendMessage->state;
2357         }
2358     }
2359     return 0;
2360 }
2361
2362 void buildJsonMessage(ReportingMessages_t &message) {
2363     if (jsonTrace) {
2364         message.outLen = sizeof(message.base64Data);
2365         base64::encode((const unsigned char *) message.message.asndata,
2366                        (const int) message.message.asnLength,
2367                        message.base64Data,
2368                        message.outLen);
2369         if (mdclog_level_get() >= MDCLOG_DEBUG) {
2370             mdclog_write(MDCLOG_DEBUG, "Tracing: ASN length = %d, base64 message length = %d ",
2371                          (int) message.message.asnLength,
2372                          (int) message.outLen);
2373         }
2374
2375         snprintf(message.buffer, sizeof(message.buffer),
2376                  "{\"header\": {\"ts\": \"%ld.%09ld\","
2377                  "\"ranName\": \"%s\","
2378                  "\"messageType\": %d,"
2379                  "\"direction\": \"%c\"},"
2380                  "\"base64Length\": %d,"
2381                  "\"asnBase64\": \"%s\"}",
2382                  message.message.time.tv_sec,
2383                  message.message.time.tv_nsec,
2384                  message.message.enodbName,
2385                  message.message.messageType,
2386                  message.message.direction,
2387                  (int) message.outLen,
2388                  message.base64Data);
2389         static src::logger_mt &lg = my_logger::get();
2390
2391         BOOST_LOG(lg) << message.buffer;
2392     }
2393 }
2394
2395
2396 /**
2397  * take RMR error code to string
2398  * @param state
2399  * @return
2400  */
2401 string translateRmrErrorMessages(int state) {
2402     string str = {};
2403     switch (state) {
2404         case RMR_OK:
2405             str = "RMR_OK - state is good";
2406             break;
2407         case RMR_ERR_BADARG:
2408             str = "RMR_ERR_BADARG - argument passd to function was unusable";
2409             break;
2410         case RMR_ERR_NOENDPT:
2411             str = "RMR_ERR_NOENDPT - send//call could not find an endpoint based on msg type";
2412             break;
2413         case RMR_ERR_EMPTY:
2414             str = "RMR_ERR_EMPTY - msg received had no payload; attempt to send an empty message";
2415             break;
2416         case RMR_ERR_NOHDR:
2417             str = "RMR_ERR_NOHDR - message didn't contain a valid header";
2418             break;
2419         case RMR_ERR_SENDFAILED:
2420             str = "RMR_ERR_SENDFAILED - send failed; errno has nano reason";
2421             break;
2422         case RMR_ERR_CALLFAILED:
2423             str = "RMR_ERR_CALLFAILED - unable to send call() message";
2424             break;
2425         case RMR_ERR_NOWHOPEN:
2426             str = "RMR_ERR_NOWHOPEN - no wormholes are open";
2427             break;
2428         case RMR_ERR_WHID:
2429             str = "RMR_ERR_WHID - wormhole id was invalid";
2430             break;
2431         case RMR_ERR_OVERFLOW:
2432             str = "RMR_ERR_OVERFLOW - operation would have busted through a buffer/field size";
2433             break;
2434         case RMR_ERR_RETRY:
2435             str = "RMR_ERR_RETRY - request (send/call/rts) failed, but caller should retry (EAGAIN for wrappers)";
2436             break;
2437         case RMR_ERR_RCVFAILED:
2438             str = "RMR_ERR_RCVFAILED - receive failed (hard error)";
2439             break;
2440         case RMR_ERR_TIMEOUT:
2441             str = "RMR_ERR_TIMEOUT - message processing call timed out";
2442             break;
2443         case RMR_ERR_UNSET:
2444             str = "RMR_ERR_UNSET - the message hasn't been populated with a transport buffer";
2445             break;
2446         case RMR_ERR_TRUNC:
2447             str = "RMR_ERR_TRUNC - received message likely truncated";
2448             break;
2449         case RMR_ERR_INITFAILED:
2450             str = "RMR_ERR_INITFAILED - initialisation of something (probably message) failed";
2451             break;
2452         case RMR_ERR_NOTSUPP:
2453             str = "RMR_ERR_NOTSUPP - the request is not supported, or RMr was not initialised for the request";
2454             break;
2455         default:
2456             char buf[128]{};
2457             snprintf(buf, sizeof buf, "UNDOCUMENTED RMR_ERR : %d", state);
2458             str = buf;
2459             break;
2460     }
2461     return str;
2462 }
2463
2464