|
|
The ``u'' and ``s'' symbols in the times represent user and system CPU usages in seconds, respectively. Those entries which are not applicable since the script does not perform or have any impact on the indicated function are identified with ``-na-.''
The Perl validation is the simple perl -c test which validates the Perl code (i.e., performs the Perl ``compile'' operation) which is affected by the size of the code being tested and the complexity of the code. The original script contains only a few active lines - the remaining being either blank or commented out.
The ``One line Post'' times come from a new article posted to the special test newsgroup that contained one line of text, which varied slightly in size, plus the normal article header records. The ``-s'' times are news server times for just the nnrpd program itself. The ``-u'' times represent the real-time measures of time from when the user initiates the posting action (i.e., presses the Post button, or equivalent), and the article is posted (as reported by the user's news client).
All ``/log'' entries represent the elapsed time observed for the particular function performed, reported as integer values. Logging is accomplished with the system logger command, where each log line is a seperate call to logger. Time values indicated as ``less than'' are strictly less than the value indicated. Values indicated as ``less than or equal to'' are predominantly less the the value indicated - there were a small number of observations that did equal the specified value.
``NNRPD write/log'' times represent the total elapsed time for filter _nnrpd.pl to write its entries to the log file after the user posts the article (i.e., presses the Post button, or equivalent), and filter _nnrpd.pl accepts it.
``LDAP search/log'' times are taken from an LDAP server log which show the total elapsed time for the LDAP server to accept a connection from the news server and process its LDAP search requests for the special newsgroup entry, return the data to the news server, and close the network connection.
``NNRPD reject/log" times are from the news server log which show the total elapsed time for the filter _nnrpd.pl ``hook'' to make its posting failure determination and write out its log lines.
The differences in log file writing times are affected by the throughput of the associated network and the speed of the associated servers, which is to be expected. The different environments, slower test, faster production, also represent a difference in the relative ``size'' of the servers (i.e., small versus medium). The amount of filter _nnrpd.pl logging appears to be the largest delay factor in this process, all other things being equal. It should be noted that filter _nnrpd.pl can operate without generating any log entries, but for administrative purposes, ten or so lines were normally logged.
Overall, while increasing news server system time for log writing, Perl ``hook'' processing, and external service (LDAP) processing, the amount of additional time for the LDAP-enhanced INN services is reasonable. Turn off all filter _nnrpd.pl logging and the additional time can be further reduced, making it neglible.