Daily Usenet report

Nov 29 04:15:01 -- Nov 30 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Nov 29 04:21:50 newsfeed nnrpd[4140294]: nms2.man.lodz.pl rejected Expiring process 4139892
Nov 29 08:56:37 newsfeed nnrpd[4175507]: SERVER perl filter not defined
Nov 29 08:57:27 newsfeed nnrpd[4175512]: SERVER perl filter not defined
Nov 29 09:01:36 newsfeed nnrpd[4176172]: SERVER perl filter not defined
Nov 29 10:07:58 newsfeed nnrpd[4184498]: SERVER perl filter not defined
Nov 29 10:10:52 newsfeed nnrpd[4184875]: SERVER perl filter not defined
Nov 29 15:48:26 newsfeed nnrpd[33685]: SERVER perl filter not defined
Nov 29 15:52:06 newsfeed nnrpd[34057]: SERVER perl filter not defined
Nov 29 17:53:00 newsfeed nnrpd[49189]: SERVER perl filter not defined
Nov 29 21:08:54 newsfeed nnrpd[73806]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 275953 95.8%32.1 MB 96.2%
nnrpd 7985 2.8%808.9 KB 2.4%
innd 2851 1.0%334.9 KB 1.0%
innfeed 1252 0.4%145.0 KB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 288042 100.0%33.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 274437 99.1%
Negative hits 2495 0.9%
Positive hits 43 0.0%
Cache misses 14 0.0%
TOTAL: 4 276989 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.786 0.0%58 0.000 30.793 73.400
article cleanup00:00:01.515 0.0%275834 0.001 0.005 0.017
article logging00:00:05.562 0.0%275871 0.013 0.020 0.039
article parse00:00:06.302 0.0%800169 0.004 0.008 0.012
article write00:00:19.457 0.0%275678 0.040 0.071 0.665
artlog/artcncl00:00:00.000 0.0%57 0.000 0.000 0.000
data move00:00:01.009 0.0%950828 0.000 0.001 0.003
hisgrep/artcncl00:00:00.400 0.0%20 0.000 20.000 35.900
hishave/artcncl00:00:00.580 0.0%58 0.000 10.000 22.800
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:37:05.412 2.6%278482 5.212 7.991 21.000
history sync00:00:00.024 0.0%391 0.000 0.061 0.667
history write00:37:36.916 2.6%275831 5.622 8.182 25.209
hiswrite/artcncl00:00:00.594 0.0%38 6.000 15.632 44.556
idle22:40:42.825 94.4%730413 41.296 111.776 212.619
nntp read00:00:09.119 0.0%647088 0.009 0.014 0.022
overview write00:00:00.672 0.0%275678 0.000 0.002 0.006
perl filter00:04:02.225 0.3%275831 0.643 0.878 1.206
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:08.810 0.0%656855 0.008 0.013 0.020
TOTAL: 24:01:03.31724:00:23.208100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.148 0.0%105346 0.000 0.001 0.010
article prepare00:00:00.000 0.0%280 0.000 0.000 0.000
article read00:00:00.002 0.0%70 0.000 0.029 1.000
backlog stats00:00:00.057 0.0%126762 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.980 0.0%113054 0.000 0.009 0.020
data write00:00:00.311 0.0%7909 0.000 0.039 0.200
idle23:56:54.357100.0%126762 182.526 680.128 3015.623
status file00:00:00.155 0.0%322 0.000 0.481 2.000
TOTAL: 23:56:57.86323:56:56.010100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:30.401 61.1%4388 0.000 20.602 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.165 0.1%10867 0.000 0.015 0.500
readart00:00:00.326 0.2%62 0.000 5.258 8.700
TOTAL: 00:02:27.86100:01:30.892 61.5%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 73 275806 275651 0 155 99%38:29:09
2localhost 10 9 9 0 0 100%00:00:00
3news.icm.edu.pl 26 39 3 35 1 7%04:58:23
TOTAL: 3 109 275854 275663 35 156 99%43:27:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.3 GB29.8 KB495.7 KB2.3 GB 99%8.7 KB
2news.icm.edu.pl29.7 KB0.0 KB12.2 KB42.0 KB 70%10.5 KB
3localhost12.3 KB0.0 KB0.0 KB12.3 KB100%1.4 KB
TOTAL: 32.3 GB29.8 KB507.9 KB2.3 GB 99%8.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 29 04:15:01 - 04:59:59 5720 2.1% 2.1248.6 MB 2.1% 18.44
Nov 29 05:00:00 - 05:59:59 6939 2.5% 1.9362.0 MB 2.7% 17.62
Nov 29 06:00:00 - 06:59:59 8941 3.2% 2.4866.5 MB 2.8% 18.91
Nov 29 07:00:00 - 07:59:59 8842 3.2% 2.4666.2 MB 2.8% 18.83
Nov 29 08:00:00 - 08:59:59 9865 3.6% 2.7479.9 MB 3.4% 22.72
Nov 29 09:00:00 - 09:59:59 10226 3.7% 2.8490.8 MB 3.9% 25.83
Nov 29 10:00:00 - 10:59:59 9791 3.6% 2.7293.0 MB 4.0% 26.45
Nov 29 11:00:00 - 11:59:59 9862 3.6% 2.74100.7 MB 4.3% 28.65
Nov 29 12:00:00 - 12:59:59 10081 3.7% 2.8093.6 MB 4.0% 26.64
Nov 29 13:00:00 - 13:59:59 12023 4.4% 3.34111.4 MB 4.8% 31.69
Nov 29 14:00:00 - 14:59:59 7367 2.7% 2.0576.4 MB 3.3% 21.72
Nov 29 15:00:00 - 15:59:59 8927 3.2% 2.4895.9 MB 4.1% 27.29
Nov 29 16:00:00 - 16:59:59 12263 4.4% 3.4199.4 MB 4.3% 28.28
Nov 29 17:00:00 - 17:59:59 12620 4.6% 3.5194.8 MB 4.1% 26.97
Nov 29 18:00:00 - 18:59:59 12023 4.4% 3.3498.6 MB 4.2% 28.06
Nov 29 19:00:00 - 19:59:59 13772 5.0% 3.83104.0 MB 4.4% 29.59
Nov 29 20:00:00 - 20:59:59 25490 9.2% 7.08181.6 MB 7.8% 51.66
Nov 29 21:00:00 - 21:59:59 23084 8.4% 6.41169.7 MB 7.3% 48.26
Nov 29 22:00:00 - 22:59:59 12776 4.6% 3.55131.7 MB 5.6% 37.47
Nov 29 23:00:00 - 23:59:59 13500 4.9% 3.75122.2 MB 5.2% 34.75
Nov 30 00:00:00 - 00:59:59 9808 3.6% 2.7281.4 MB 3.5% 23.15
Nov 30 01:00:00 - 01:59:59 9040 3.3% 2.5176.0 MB 3.2% 21.61
Nov 30 02:00:00 - 02:59:59 9580 3.5% 2.6679.4 MB 3.4% 22.58
Nov 30 03:00:00 - 03:59:59 11316 4.1% 3.1496.6 MB 4.1% 27.47
Nov 30 04:00:00 - 04:15:02 1847 0.7% 2.0517.3 MB 0.7% 19.59
TOTAL: 24:00:01 275703 100.0% 3.192.3 GB 100.0% 27.71
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 192 152 0 3 0 0 0 0 37
2news.icm.edu.pl 1 0 0 0 0 0 0 0 1
TOTAL: 2 193 152 0 3 0 0 0 0 38

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 59
alt.comp.software.firefox 24
comp.sys.raspberry-pi 16
it.tlc.cellulari.android 9
rocksolid.nodes.help 7
eternal-september.test 7
fr.misc.actualite.covid19 6
aioe.test.tor 4
comp.mobile.android 4
eternal-september.grouprequests 4
rocksolid.shared.test 3
grisbi.bugsreports 2
it.comp.os.win.windows10 2
fido7.r50.crisis 1
grisbi.user.french 1
uk.radio.amateur.moderated 1
grisbi.test 1
fido7.english-tutor 1
TOTAL: 18 152

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 7668 60 6507 10 0 0 0%23:51:31
2nask 0 0 0 0 0 102416 0%23:50:01
3panorama 0 0 0 0 0 105237 0%23:50:01
4poznan 3 0 3 0 0 0 0%00:40:00
5okapi 0 0 0 0 0 913 0%23:50:01
TOTAL: 5 7671 60 6510 10 0 208566 0%96:01:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm291.7 KB85.7 KB377.4 KB0.0 KB/s5.4 KB23:51:31
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:40:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
TOTAL: 5291.7 KB85.7 KB377.4 KB0.0 KB/s5.4 KB96:01:34
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama9.1 MB
TOTAL: 19.1 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.250.122.68 42 6037.6 KB 6 0 000:00:38
2web.man.lodz.pl 289 21.9 KB 1 0 000:00:07
3isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
TOTAL: 3 340 6239.6 KB 7 9 000:02:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 162 6037.6 KB 6 0 000:02:06
2*.man.lodz.pl1735 21.9 KB 1 9 000:00:19
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 41899 6239.6 KB 7 9 000:02:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
206.168.34.49 0.020 0.037 0.00000:00:45
162.250.122.68 0.083 0.369 0.00000:00:38
nms2.man.lodz.pl 2.996 10.031 0.00000:00:11
152.32.215.224 0.006 0.019 0.00000:00:10
205.210.31.87 0.000 0.008 0.00000:00:10
167.94.138.113 0.007 0.033 0.00000:00:08
web.man.lodz.pl 0.696 2.098 0.00000:00:07
162.142.125.197 0.004 0.026 0.00000:00:04
167.94.146.59 0.008 0.029 0.00000:00:03
80.111.142.213 0.109 0.033 0.00000:00:02
virtuous.monitoring.internet-measurement.com 0.000 0.009 0.00000:00:01
198.235.24.168 0.000 0.007 0.00000:00:01
212.51.192.185 0.206 0.672 0.00000:00:00
isvcs01.man.lodz.pl 0.026 0.083 0.00000:00:00
azpdcgc39.stretchoid.com 0.000 0.008 0.00000:00:00
203.55.131.5 0.000 0.008 0.00000:00:00
TOTAL: 16 4.161 13.470 0.00000:02:28

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1437
212.51.192.185 96
206.168.34.49 5
80.111.142.213 4
162.142.125.197 3
167.94.138.113 3
167.94.146.59 3
152.32.215.224 3
205.210.31.87 1
203.55.131.5 1
198.235.24.168 1
azpdcgc39.stretchoid.com 1
virtuous.monitoring.internet-measurement.com 1
TOTAL: 13 1559

NNRP unrecognized commands (by host):

SystemConn
206.168.34.49 4
152.32.215.224 2
167.94.146.59 1
azpdcgc39.stretchoid.com 1
162.142.125.197 1
167.94.138.113 1
TOTAL: 6 10

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 4
MGLNDD_212.191.2.21_119 1
À#024 1
GET / HTTP/1.1 1
#026#003#001#001#027#001 1
Host: 212.191.2.21:119 1
#026#003#001 1
TOTAL: 7 10

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.49 2 2
162.142.125.197 1 2
167.94.138.113 1 2
167.94.146.59 1 2
TOTAL: 4 5 9

Newsgroup request counts (by category):

CategoryCountPct
1lodman 60 96.8%
2pl 2 3.2%
TOTAL: 2 62100.0%

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

NewsgroupCount
1lodman.test 30
2lodman.info 30
3pl.comp.os.ms-windows.winnt 2
TOTAL: 3 62