Daily Usenet report

Sep 25 04:15:01 -- Sep 26 04:15:01

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Sep 25 11:10:51 newsfeed nnrpd[330139]: SERVER perl filter not defined
Sep 25 11:30:45 newsfeed overchan[310941]: input line too long, skipping
Sep 25 11:42:37 newsfeed overchan[310941]: input line too long, skipping
Sep 25 11:43:04 newsfeed overchan[310941]: input line too long, skipping
Sep 25 12:21:20 newsfeed pgpverify[333762]: pgpverify: /usr/bin/gpg1: no such file
Sep 25 12:21:30 newsfeed pgpverify[333774]: pgpverify: /usr/bin/gpg1: no such file
Sep 25 12:21:46 newsfeed pgpverify[333783]: pgpverify: /usr/bin/gpg1: no such file
Sep 25 12:22:06 newsfeed pgpverify[333803]: pgpverify: /usr/bin/gpg1: no such file
Sep 25 15:42:52 newsfeed nnrpd[342231]: SERVER perl filter not defined
Sep 25 17:01:01 newsfeed overchan[310941]: input line too long, skipping
Sep 25 17:02:06 newsfeed nnrpd[345525]: SERVER perl filter not defined
Sep 25 17:02:08 newsfeed overchan[310941]: input line too long, skipping
Sep 25 17:03:33 newsfeed overchan[310941]: input line too long, skipping
Sep 25 19:08:06 newsfeed overchan[310941]: input line too long, skipping
Sep 25 20:41:11 newsfeed overchan[310941]: input line too long, skipping
Sep 25 21:48:27 newsfeed overchan[310941]: input line too long, skipping
Sep 26 01:39:34 newsfeed overchan[310941]: input line too long, skipping
Sep 26 01:39:50 newsfeed overchan[310941]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 121603 91.9%14.0 MB 92.6%
nnrpd 7101 5.4%707.8 KB 4.6%
innd 2293 1.7%270.7 KB 1.8%
innfeed 1348 1.0%153.6 KB 1.0%
controlchan 15 0.0%3.0 KB 0.0%
overchan 12 0.0%1.3 KB 0.0%
pgpverify 4 0.0%0.6 KB 0.0%
TOTAL: 7 132376 100.0%15.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 121340 97.1%
Negative hits 2913 2.3%
Positive hits 663 0.5%
Cache misses 32 0.0%
TOTAL: 4 124948 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.355 0.0%52 0.000 26.058 46.000
article cleanup00:00:00.826 0.0%121537 0.000 0.007 0.029
article logging00:00:03.002 0.0%121548 0.014 0.025 0.041
article parse00:00:04.872 0.0%649684 0.003 0.007 0.015
article write00:00:18.197 0.0%120814 0.048 0.151 0.860
artlog/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
data move00:00:00.736 0.0%852391 0.000 0.001 0.004
hisgrep/artcncl00:00:00.616 0.0%50 0.000 12.320 25.750
hishave/artcncl00:00:00.215 0.0%52 0.000 4.135 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:09.263 0.8%125092 1.597 5.830 12.363
history sync00:00:00.013 0.0%304 0.000 0.043 0.500
history write00:16:18.832 1.1%121509 3.326 8.056 12.269
hiswrite/artcncl00:00:00.018 0.0%2 0.000 9.000 18.000
idle23:28:15.611 97.8%756731 12.021 111.659 301.470
nntp read00:00:11.064 0.0%646636 0.010 0.017 0.029
overview write00:00:00.422 0.0%120814 0.000 0.003 0.009
perl filter00:02:26.262 0.2%121509 0.787 1.204 1.907
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.949 0.0%253694 0.009 0.016 0.029
TOTAL: 24:00:23.06823:59:55.253100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%12061 0.000 0.002 0.024
article prepare00:00:00.000 0.0%92 0.000 0.000 0.000
article read00:00:00.003 0.0%23 0.000 0.130 0.500
backlog stats00:00:00.028 0.0%49768 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.290 0.0%26898 0.000 0.011 0.034
data write00:00:00.617 0.0%14999 0.000 0.041 0.119
idle23:59:48.505100.0%49768 918.920 1735.824 3935.248
status file00:00:00.203 0.0%356 0.000 0.570 1.593
TOTAL: 23:59:50.60523:59:49.668100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:33.102 61.4%4013 0.000 8.249 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.161 0.3%9626 0.000 0.017 0.500
readart00:00:00.000 0.0%18 0.000 0.000 0.000
TOTAL: 00:00:53.93400:00:33.263 61.7%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001401
TOTAL001401

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 84 120740 120655 2 83 99%42:52:01
2news.icm.edu.pl 12 1381 31 650 700 2%24:22:23
3localhost 4 3 3 0 0 100%00:00:00
TOTAL: 3 100 122124 120689 652 783 98%67:14:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.6 GB389.1 KB573.8 KB1.6 GB 99%13.5 KB
2news.icm.edu.pl521.5 KB84.7 KB9.6 MB10.2 MB 4%14.3 KB
3localhost4.3 KB0.0 KB0.0 KB4.3 KB100%1.4 KB
TOTAL: 31.6 GB473.9 KB10.2 MB1.6 GB 99%13.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 25 04:15:01 - 04:59:59 2522 2.1% 0.9320.9 MB 1.3% 7.93
Sep 25 05:00:00 - 05:59:59 3909 3.2% 1.0931.5 MB 2.0% 8.95
Sep 25 06:00:00 - 06:59:59 4261 3.5% 1.1833.7 MB 2.1% 9.59
Sep 25 07:00:00 - 07:59:59 4114 3.4% 1.1431.5 MB 2.0% 8.96
Sep 25 08:00:00 - 08:59:59 4609 3.8% 1.2836.1 MB 2.3% 10.26
Sep 25 09:00:00 - 09:59:59 4567 3.8% 1.2738.9 MB 2.4% 11.06
Sep 25 10:00:00 - 10:59:59 3283 2.7% 0.9136.0 MB 2.3% 10.24
Sep 25 11:00:00 - 11:59:59 3773 3.1% 1.0543.8 MB 2.7% 12.46
Sep 25 12:00:00 - 12:59:59 4451 3.7% 1.2451.5 MB 3.2% 14.64
Sep 25 13:00:00 - 13:59:59 5749 4.8% 1.60114.6 MB 7.2% 32.59
Sep 25 14:00:00 - 14:59:59 4539 3.8% 1.2668.6 MB 4.3% 19.50
Sep 25 15:00:00 - 15:59:59 5564 4.6% 1.5563.4 MB 4.0% 18.02
Sep 25 16:00:00 - 16:59:59 5901 4.9% 1.64117.5 MB 7.4% 33.43
Sep 25 17:00:00 - 17:59:59 4736 3.9% 1.3249.1 MB 3.1% 13.97
Sep 25 18:00:00 - 18:59:59 3929 3.3% 1.0936.3 MB 2.3% 10.32
Sep 25 19:00:00 - 19:59:59 5035 4.2% 1.4053.1 MB 3.3% 15.10
Sep 25 20:00:00 - 20:59:59 4128 3.4% 1.1539.8 MB 2.5% 11.31
Sep 25 21:00:00 - 21:59:59 5270 4.4% 1.4659.6 MB 3.7% 16.96
Sep 25 22:00:00 - 22:59:59 7324 6.1% 2.0348.0 MB 3.0% 13.66
Sep 25 23:00:00 - 23:59:59 6575 5.4% 1.83175.9 MB 11.0% 50.04
Sep 26 00:00:00 - 00:59:59 7706 6.4% 2.14149.5 MB 9.4% 42.54
Sep 26 01:00:00 - 01:59:59 5617 4.6% 1.5699.8 MB 6.3% 28.39
Sep 26 02:00:00 - 02:59:59 5939 4.9% 1.65100.9 MB 6.3% 28.71
Sep 26 03:00:00 - 03:59:59 6091 5.0% 1.6980.8 MB 5.1% 22.98
Sep 26 04:00:00 - 04:15:01 1226 1.0% 1.3612.5 MB 0.8% 14.17
TOTAL: 24:00:00 120818 100.0% 1.401.6 GB 100.0% 18.88
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 639 0 0 8 0 0 0 0 631
2newsfeed.pionier.net.pl 94 62 0 20 0 0 0 0 12
TOTAL: 2 733 62 0 28 0 0 0 0 643

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 29
it.tlc.cellulari.android 10
comp.mobile.android 8
alt.comp.software.seamonkey 6
it.comp.os.win.windows10 5
nl.comp.os.linux.techniek 1
alt.comp.software.firefox 1
comp.mobile.ipad 1
comp.sys.raspberry-pi 1
TOTAL: 9 62

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 619
EMP (md5) 6
Scoring filter (9) 4
Scoring filter (8) 3
TOTAL: 4 632

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 14789 15 11484 8 0 1 0%23:59:39
2okapi 0 0 0 0 0 836 0%23:57:49
3poznan 34 0 27 0 0 2 0%03:06:33
4nask 0 0 0 0 0 7890 0%23:57:49
5panorama 0 0 0 0 0 12062 0%23:57:49
TOTAL: 5 14823 15 11511 8 0 20791 0%98:59:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm70.0 KB23.1 KB93.1 KB0.0 KB/s4.0 KB23:59:39
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:06:33
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 570.0 KB23.1 KB93.1 KB0.0 KB/s4.0 KB98:59:39
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1815.7 KB 9 0 000:00:10
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 1815.7 KB 9 3 000:00:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1544 1815.7 KB 9 3 000:00:25
2*.internet-census.org 1 00.0 KB 0 0 000:00:10
3unresolved 103 00.0 KB 0 0 000:00:14
4*.shodan.io 1 00.0 KB 0 0 000:00:03
TOTAL: 41649 1815.7 KB 9 3 000:00:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-lax-us-gp1-wk133.internet-census.org 0.004 0.004 0.00000:00:10
45.79.44.78 0.000 0.015 0.00000:00:10
web.man.lodz.pl 0.926 1.518 0.00000:00:10
nms2.man.lodz.pl 2.932 4.663 0.00000:00:09
nms1.man.lodz.pl 1.204 2.046 0.00000:00:05
census12.shodan.io 0.006 0.006 0.00000:00:03
80.111.142.213 0.025 0.027 0.00000:00:02
212.51.192.185 0.330 0.504 0.00000:00:01
192.241.205.21 0.004 0.004 0.00000:00:00
isvcs01.man.lodz.pl 0.013 0.019 0.00000:00:00
185.73.124.50 0.000 0.009 0.00000:00:00
TOTAL: 11 5.444 8.815 0.00000:00:54

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 868
nms1.man.lodz.pl 385
212.51.192.185 96
80.111.142.213 4
census12.shodan.io 1
zl-lax-us-gp1-wk133.internet-census.org 1
45.79.44.78 1
185.73.124.50 1
192.241.205.21 1
TOTAL: 9 1358

NNRP unrecognized commands (by host):

SystemConn
185.73.124.50 1
192.241.205.21 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
#003 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
185.73.124.50 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 18100.0%
TOTAL: 1 18100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 14
2pl.comp.pecet 4
TOTAL: 2 18
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>