Daily Usenet report

Apr 30 04:15:01 -- May 1 04:15:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Apr 30 12:12:44 newsfeed nnrpd[296132]: SERVER perl filter not defined
Apr 30 12:12:44 newsfeed nnrpd[296132]: SERVER perl filter not defined
Apr 30 12:32:32 newsfeed nnrpd[298342]: SERVER perl filter not defined
Apr 30 12:32:32 newsfeed nnrpd[298342]: SERVER perl filter not defined
Apr 30 12:33:57 newsfeed nnrpd[298609]: SERVER perl filter not defined
Apr 30 12:33:57 newsfeed nnrpd[298609]: SERVER perl filter not defined
Apr 30 14:42:46 newsfeed nnrpd[316715]: SERVER perl filter not defined
Apr 30 14:42:46 newsfeed nnrpd[316715]: SERVER perl filter not defined
Apr 30 14:43:04 newsfeed nnrpd[316717]: SERVER perl filter not defined
Apr 30 14:43:04 newsfeed nnrpd[316717]: SERVER perl filter not defined
Apr 30 14:43:31 newsfeed nnrpd[316720]: SERVER perl filter not defined
Apr 30 14:43:31 newsfeed nnrpd[316720]: SERVER perl filter not defined
May 1 00:34:59 newsfeed nnrpd[388347]: SERVER perl filter not defined
May 1 00:34:59 newsfeed nnrpd[388347]: SERVER perl filter not defined
May 1 00:42:30 newsfeed nnrpd[389420]: SERVER perl filter not defined
May 1 00:42:30 newsfeed nnrpd[389420]: SERVER perl filter not defined
May 1 01:00:06 newsfeed nnrpd[391389]: SERVER perl filter not defined
May 1 01:00:06 newsfeed nnrpd[391389]: SERVER perl filter not defined
May 1 02:04:02 newsfeed pgpverify[399135]: pgpverify: /usr/bin/gpg1: no such file
May 1 02:04:02 newsfeed pgpverify[399135]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 264981 82.6%29.0 MB 84.9%
innd 37834 11.8%3.4 MB 10.1%
nnrpd 16596 5.2%1.6 MB 4.5%
innfeed 1312 0.4%160.2 KB 0.5%
controlchan 44 0.0%10.7 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 320771 100.0%34.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 527354 99.9%
Negative hits 446 0.1%
Cache misses 238 0.0%
Positive hits 100 0.0%
TOTAL: 4 528138 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.386 0.0%478 0.000 0.808 32.000
article cleanup00:00:02.798 0.0%531500 0.001 0.005 0.013
article logging00:00:10.318 0.0%531536 0.009 0.019 0.044
article parse00:00:24.268 0.0%1529600 0.009 0.016 0.024
article write00:02:11.688 0.1%531466 0.184 0.248 0.656
artlog/artcncl00:00:00.002 0.0%260 0.000 0.008 0.059
data move00:00:01.660 0.0%2158132 0.000 0.001 0.002
hisgrep/artcncl00:00:00.088 0.0%738 0.000 0.119 0.600
hishave/artcncl00:00:00.000 0.0%260 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:29.114 0.0%532004 0.002 0.055 0.530
history sync00:00:00.042 0.0%786 0.000 0.053 0.667
history write00:00:50.416 0.0%531480 0.034 0.095 0.429
idle47:47:28.030 99.5%1742114 52.612 98.758 219.159
nntp read00:00:23.164 0.0%1394170 0.011 0.017 0.024
overview write00:00:01.452 0.0%531466 0.000 0.003 0.006
perl filter00:08:38.432 0.3%531480 0.673 0.975 1.328
python filter00:00:00.138 0.0%531498 0.000 0.000 0.002
site send00:00:12.564 0.0%1075714 0.006 0.012 0.019
TOTAL: 48:01:57.01248:00:54.560100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%12774 0.000 0.002 0.053
article prepare00:00:00.000 0.0%512 0.000 0.000 0.000
article read00:00:00.004 0.0%128 0.000 0.031 1.000
backlog stats00:00:00.016 0.0%80366 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.418 0.0%37090 0.000 0.011 0.060
data write00:00:01.266 0.0%24168 0.000 0.052 0.155
idle47:58:45.042100.0%80366 910.471 2149.230 8706.514
status file00:00:00.098 0.0%344 0.000 0.285 1.000
TOTAL: 47:58:47.72247:58:46.874100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:15.710 67.3%9060 0.000 8.357 3522.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.376 0.3%30330 0.000 0.012 0.500
readart00:00:00.000 0.0%8 0.000 0.000 0.000
TOTAL: 00:01:52.47600:01:16.086 67.6%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 300
name 6
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 390

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org002002
us-control@lists.killfile.org000200
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 88 529744 529726 2 16 99%58:04:22
2news.icm.edu.pl 44 92 18 56 18 19%11:18:44
3localhost 20 18 18 0 0 100%00:00:00
TOTAL: 3 152 529854 529762 58 34 99%69:23:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl4.6 GB317.2 KB0.0 KB4.6 GB 99%9.2 KB
2news.icm.edu.pl514.4 KB73.0 KB487.8 KB1.1 MB 47%29.9 KB
3localhost29.2 KB0.0 KB0.0 KB29.2 KB100%1.6 KB
TOTAL: 34.6 GB390.2 KB487.8 KB4.6 GB 99%9.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 30 04:15:01 - 04:59:59 7397 2.8% 2.7473.0 MB 3.1% 27.68
Apr 30 05:00:00 - 05:59:59 8765 3.3% 2.4389.0 MB 3.8% 25.33
Apr 30 06:00:00 - 06:59:59 10729 4.1% 2.9892.7 MB 3.9% 26.38
Apr 30 07:00:00 - 07:59:59 11650 4.4% 3.24109.3 MB 4.6% 31.08
Apr 30 08:00:00 - 08:59:59 10258 3.9% 2.8594.4 MB 4.0% 26.85
Apr 30 09:00:00 - 09:59:59 12824 4.8% 3.56107.6 MB 4.5% 30.60
Apr 30 10:00:00 - 10:59:59 13472 5.1% 3.74125.5 MB 5.3% 35.71
Apr 30 11:00:00 - 11:59:59 12796 4.8% 3.55112.9 MB 4.8% 32.10
Apr 30 12:00:00 - 12:59:59 12565 4.7% 3.49113.5 MB 4.8% 32.30
Apr 30 13:00:00 - 13:59:59 14588 5.5% 4.05153.1 MB 6.5% 43.54
Apr 30 14:00:00 - 14:59:59 13675 5.2% 3.80133.4 MB 5.6% 37.95
Apr 30 15:00:00 - 15:59:59 13100 4.9% 3.64126.6 MB 5.3% 36.02
Apr 30 16:00:00 - 16:59:59 13940 5.3% 3.87115.8 MB 4.9% 32.94
Apr 30 17:00:00 - 17:59:59 12859 4.9% 3.57102.8 MB 4.3% 29.24
Apr 30 18:00:00 - 18:59:59 11632 4.4% 3.2390.7 MB 3.8% 25.80
Apr 30 19:00:00 - 19:59:59 9683 3.7% 2.6979.7 MB 3.4% 22.66
Apr 30 20:00:00 - 20:59:59 10183 3.8% 2.8380.6 MB 3.4% 22.92
Apr 30 21:00:00 - 21:59:59 11563 4.4% 3.2190.4 MB 3.8% 25.70
Apr 30 22:00:00 - 22:59:59 10188 3.8% 2.8388.8 MB 3.7% 25.25
Apr 30 23:00:00 - 23:59:59 9552 3.6% 2.6585.5 MB 3.6% 24.31
May 1 00:00:00 - 00:59:59 9764 3.7% 2.7188.7 MB 3.7% 25.24
May 1 01:00:00 - 01:59:59 7833 3.0% 2.1869.9 MB 3.0% 19.89
May 1 02:00:00 - 02:59:59 7302 2.8% 2.0364.8 MB 2.7% 18.43
May 1 03:00:00 - 03:59:59 6105 2.3% 1.7060.5 MB 2.6% 17.21
May 1 04:00:00 - 04:15:01 2393 0.9% 2.6619.8 MB 0.8% 22.46
TOTAL: 24:00:00 264816 100.0% 3.062.3 GB 100.0% 28.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 26 0 0 8 0 0 0 0 18
2news.icm.edu.pl 9 0 0 2 0 0 0 0 7
TOTAL: 2 35 0 0 10 0 0 0 0 25

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 12
EMP (md5) 2
TOTAL: 2 14

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 18
TOTAL: 1 18
TOTAL: 1 18

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24266 76 12636 52 0 0 0%47:59:56
2poznan 30 0 18 0 0 0 0%03:00:56
TOTAL: 2 24296 76 12654 52 0 0 0%51:00:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm183.0 KB695.7 KB878.6 KB0.0 KB/s6.9 KB47:59:56
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:00:56
TOTAL: 2183.0 KB695.7 KB878.6 KB0.0 KB/s6.9 KB51:00:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.16.2.4 576 815.4 KB 4 0 000:00:34
2isvcs01.man.lodz.pl 18 00.0 KB 0 18 000:00:00
TOTAL: 2 594 815.4 KB 4 18 000:01:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 796 815.4 KB 4 0 000:01:20
2*.man.lodz.pl2898 00.0 KB 0 18 000:00:31
TOTAL: 23694 815.4 KB 4 18 000:01:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 2.318 4.228 0.00000:00:34
nms1.man.lodz.pl 10.806 19.894 0.00000:00:30
167.94.138.44 0.118 0.058 0.00000:00:22
198.235.24.193 0.006 0.008 0.00000:00:07
167.94.145.101 0.126 0.050 0.00000:00:06
80.111.142.213 0.042 0.078 0.00000:00:05
212.51.192.185 0.756 1.374 0.00000:00:02
203.55.131.3 0.008 0.018 0.00000:00:01
isvcs01.man.lodz.pl 0.126 0.152 0.00000:00:00
198.235.24.54 0.008 0.020 0.00000:00:00
20.168.122.18 0.006 0.008 0.00000:00:00
TOTAL: 11 14.320 25.888 0.00000:01:52

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
212.51.192.185 192
80.111.142.213 8
167.94.145.101 6
167.94.138.44 6
198.235.24.193 2
203.55.131.3 2
198.235.24.54 2
20.168.122.18 2
TOTAL: 9 3100

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
167.94.145.101 2
167.94.138.44 2
20.168.122.18 2
TOTAL: 3 6

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
EHLO www.censys.io 4
MGLNDD_212.191.2.21_119 2
TOTAL: 2 6

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.44 2 4
167.94.145.101 2 4
TOTAL: 2 4 12

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1pl 8100.0%
TOTAL: 1 8100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1pl.comp.os.ms-windows.winnt 8
TOTAL: 1 8
innreport from INN 2.7.2 (20240212 prerelease) based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then