Daily Usenet report

Oct 14 04:15:01 -- Oct 15 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Oct 14 14:43:02 newsfeed nnrpd[526762]: SERVER perl filter not defined
Oct 14 14:43:14 newsfeed nnrpd[526764]: SERVER perl filter not defined
Oct 14 17:45:35 newsfeed overchan[498137]: input line too long, skipping
Oct 14 17:51:53 newsfeed overchan[498137]: input line too long, skipping
Oct 14 18:20:51 newsfeed overchan[498137]: input line too long, skipping
Oct 14 18:40:31 newsfeed overchan[498137]: input line too long, skipping
Oct 14 18:41:03 newsfeed overchan[498137]: input line too long, skipping
Oct 14 20:28:35 newsfeed overchan[498137]: input line too long, skipping
Oct 14 22:00:22 newsfeed nnrpd[546111]: SERVER perl filter not defined
Oct 14 22:02:12 newsfeed nnrpd[546129]: SERVER perl filter not defined
Oct 14 22:02:16 newsfeed nnrpd[546133]: SERVER perl filter not defined
Oct 14 23:01:02 newsfeed pgpverify[548761]: pgpverify: /usr/bin/gpg1: no such file
Oct 15 00:02:48 newsfeed nnrpd[551559]: SERVER perl filter not defined
Oct 15 01:02:46 newsfeed overchan[498137]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 170775 85.9%19.9 MB 85.7%
innd 18519 9.3%2.3 MB 10.1%
nnrpd 7684 3.9%779.8 KB 3.3%
innfeed 1787 0.9%218.9 KB 0.9%
controlchan 12 0.0%2.6 KB 0.0%
overchan 8 0.0%1.0 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 198786 100.0%23.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 169026 89.4%
Negative hits 18833 10.0%
Positive hits 1190 0.6%
Cache misses 4 0.0%
TOTAL: 4 189053 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.406 0.0%36 0.000 11.278 61.000
article cleanup00:00:01.164 0.0%169343 0.001 0.007 0.016
article logging00:00:03.830 0.0%169357 0.011 0.023 0.036
article parse00:00:07.761 0.0%993817 0.004 0.008 0.012
article write00:00:30.209 0.0%152574 0.080 0.198 0.845
artlog/artcncl00:00:00.000 0.0%36 0.000 0.000 0.000
data move00:00:01.035 0.0%1285960 0.000 0.001 0.002
hisgrep/artcncl00:00:00.060 0.0%21 0.000 2.857 27.000
hishave/artcncl00:00:00.114 0.0%36 0.000 3.167 8.167
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:16:58.564 1.2%189270 2.311 5.382 9.881
history sync00:00:00.013 0.0%307 0.000 0.042 0.500
history write00:16:59.603 1.2%169250 3.509 6.024 9.731
hiswrite/artcncl00:00:00.150 0.0%15 8.000 10.000 13.000
idle23:11:12.254 97.3%1138955 7.015 73.288 186.409
nntp read00:00:15.713 0.0%1004019 0.011 0.016 0.025
overview write00:00:00.523 0.0%152574 0.000 0.003 0.010
perl filter00:03:26.142 0.2%169250 0.884 1.218 1.866
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:05.266 0.0%330603 0.008 0.016 0.027
TOTAL: 23:50:24.53023:49:42.807100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%25529 0.000 0.002 0.015
article prepare00:00:00.000 0.0%320 0.000 0.000 0.000
article read00:00:00.002 0.0%80 0.000 0.025 0.500
backlog stats00:00:00.025 0.0%108509 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.534 0.0%60348 0.000 0.009 0.028
data write00:00:01.396 0.0%34877 0.011 0.040 0.090
idle23:55:27.035100.0%108509 412.795 793.732 2033.444
status file00:00:00.405 0.0%541 0.000 0.749 5.259
TOTAL: 23:55:31.15723:55:29.456100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.699 27.1%4220 0.000 2.535 1145.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.160 0.4%10160 0.000 0.016 0.500
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:00:39.53100:00:10.859 27.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newgroups-request@fido7.ru001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 94 154018 153649 83 286 99%49:54:41
2news.icm.edu.pl 2 17696 174 1006 16516 0%23:57:12
3localhost 7 6 6 0 0 100%00:00:00
TOTAL: 3 103 171720 153829 1089 16802 89%73:51:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.1 GB3.8 MB4.2 MB2.2 GB 99%14.7 KB
2news.icm.edu.pl12.9 MB293.2 KB177.8 MB191.0 MB 6%11.7 KB
3localhost8.8 KB0.0 KB0.0 KB8.8 KB100%1.5 KB
TOTAL: 32.2 GB4.1 MB182.1 MB2.3 GB 92%14.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 14 04:15:01 - 04:59:59 3549 2.3% 1.3145.9 MB 2.1% 17.40
Oct 14 05:00:00 - 05:59:59 5874 3.8% 1.6375.8 MB 3.4% 21.56
Oct 14 06:00:00 - 06:59:59 4792 3.1% 1.3361.7 MB 2.8% 17.56
Oct 14 07:00:00 - 07:59:59 3928 2.6% 1.0949.3 MB 2.2% 14.02
Oct 14 08:00:00 - 08:59:59 6180 4.0% 1.7286.5 MB 3.9% 24.61
Oct 14 09:00:00 - 09:59:59 6015 3.9% 1.6779.0 MB 3.6% 22.47
Oct 14 10:00:00 - 10:59:59 6640 4.3% 1.8480.4 MB 3.6% 22.86
Oct 14 11:00:00 - 11:59:59 6044 3.9% 1.6867.9 MB 3.1% 19.32
Oct 14 12:00:00 - 12:59:59 5125 3.3% 1.4281.1 MB 3.7% 23.06
Oct 14 13:00:00 - 13:59:59 9378 6.1% 2.60380.3 MB 17.2% 108.19
Oct 14 14:00:00 - 14:59:59 6135 4.0% 1.7086.9 MB 3.9% 24.72
Oct 14 15:00:00 - 15:59:59 5488 3.6% 1.5291.7 MB 4.2% 26.07
Oct 14 16:00:00 - 16:59:59 6244 4.1% 1.7389.1 MB 4.0% 25.35
Oct 14 17:00:00 - 17:59:59 6593 4.3% 1.8390.7 MB 4.1% 25.79
Oct 14 18:00:00 - 18:59:59 7813 5.1% 2.17100.5 MB 4.6% 28.58
Oct 14 19:00:00 - 19:59:59 7332 4.8% 2.04105.0 MB 4.8% 29.87
Oct 14 20:00:00 - 20:59:59 7230 4.7% 2.0199.8 MB 4.5% 28.39
Oct 14 21:00:00 - 21:59:59 9110 5.9% 2.53141.1 MB 6.4% 40.14
Oct 14 22:00:00 - 22:59:59 7364 4.8% 2.0598.1 MB 4.4% 27.90
Oct 14 23:00:00 - 23:59:59 6206 4.0% 1.7259.4 MB 2.7% 16.91
Oct 15 00:00:00 - 00:59:59 5298 3.4% 1.4750.8 MB 2.3% 14.44
Oct 15 01:00:00 - 01:59:59 6307 4.1% 1.7567.7 MB 3.1% 19.27
Oct 15 02:00:00 - 02:59:59 6608 4.3% 1.8454.9 MB 2.5% 15.61
Oct 15 03:00:00 - 03:59:59 6847 4.5% 1.9051.2 MB 2.3% 14.56
Oct 15 04:00:00 - 04:15:02 1745 1.1% 1.9312.8 MB 0.6% 14.49
TOTAL: 24:00:01 153845 100.0% 1.782.2 GB 100.0% 26.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 16593 0 0 14 0 0 0 016579
2newsfeed.pionier.net.pl 301 206 0 80 0 0 0 0 15
TOTAL: 2 16894 206 0 94 0 0 0 016594

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.misc.actualite.covid19 99
it.tlc.cellulari.android 15
uk.railway 15
comp.sys.raspberry-pi 14
it.discussioni.energia 11
it.comp.os.win.windows10 9
eternal-september.support 7
comp.mobile.android 7
alt.comp.software.firefox 6
eternal-september.test 4
eternal-september.grouprequests 3
fr.misc.automobile.electrique 3
aioe.test 2
rocksolid.shared.test 2
xs4all.general 2
fr.comp.lang.regexp 2
grisbi.devel 1
fido7.r50.crisis 1
grisbi.test 1
fido7.ru.microchip 1
TOTAL: 21 206

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 16517
Scoring filter (8) 29
Scoring filter (10) 20
Scoring filter (9) 9
Scoring filter (11) 3
Scoring filter (12) 1
EMP (md5) 1
TOTAL: 7 16580

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 34560 72 25204 8 0 0 0%23:59:59
2poznan 226 0 173 0 0 1 0%18:31:13
3okapi 0 0 0 0 0 544 0%23:57:49
4nask 0 0 0 0 0 21184 0%23:57:49
5panorama 0 0 0 0 0 25576 0%23:57:49
TOTAL: 5 34786 72 25377 8 0 47305 0%114:24:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm224.3 KB47.3 KB271.6 KB0.0 KB/s3.4 KB23:59:59
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s018:31:13
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
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: 5224.3 KB47.3 KB271.6 KB0.0 KB/s3.4 KB114:24:39
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.9 MB
TOTAL: 11.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 66.7 KB 3 0 000:00:08
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 295 66.7 KB 3 6 000:00:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1736 66.7 KB 3 6 000:00:23
2unresolved 105 00.0 KB 0 0 000:00:15
TOTAL: 21841 66.7 KB 3 6 000:00:39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 4.713 8.972 0.00000:00:14
194.165.16.37 0.000 0.008 0.00000:00:10
web.man.lodz.pl 0.967 1.721 0.00000:00:08
80.111.142.213 0.027 0.018 0.00000:00:02
208.100.26.232 0.016 0.011 0.00000:00:01
212.51.192.185 0.385 0.630 0.00000:00:01
198.199.102.108 0.000 0.005 0.00000:00:00
198.199.106.161 0.000 0.013 0.00000:00:00
isvcs01.man.lodz.pl 0.033 0.049 0.00000:00:00
TOTAL: 9 6.141 11.427 0.00000:00:39

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1441
212.51.192.185 96
80.111.142.213 4
208.100.26.232 2
198.199.106.161 1
198.199.102.108 1
194.165.16.37 1
TOTAL: 7 1546

NNRP unrecognized commands (by host):

SystemConn
198.199.106.161 1
198.199.102.108 1
194.165.16.37 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 6
TOTAL: 1 6