Daily Usenet report

Nov 10 04:15:01 -- Nov 11 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Nov 10 10:31:34 newsfeed nnrpd[396326]: SERVER perl filter not defined
Nov 10 10:32:05 newsfeed nnrpd[396334]: SERVER perl filter not defined
Nov 10 12:03:01 newsfeed nnrpd[400315]: SERVER perl filter not defined
Nov 10 12:04:03 newsfeed nnrpd[400326]: SERVER perl filter not defined
Nov 10 15:11:31 newsfeed overchan[379270]: input line too long, skipping
Nov 10 15:22:06 newsfeed overchan[379270]: input line too long, skipping
Nov 10 15:26:12 newsfeed overchan[379270]: input line too long, skipping
Nov 10 15:27:41 newsfeed overchan[379270]: input line too long, skipping
Nov 10 15:42:07 newsfeed overchan[379270]: input line too long, skipping
Nov 10 16:28:05 newsfeed overchan[379270]: input line too long, skipping
Nov 10 19:06:54 newsfeed overchan[379270]: input line too long, skipping
Nov 10 19:07:28 newsfeed overchan[379270]: input line too long, skipping
Nov 10 19:08:12 newsfeed overchan[379270]: input line too long, skipping
Nov 11 01:46:24 newsfeed overchan[379270]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 108657 85.4%12.9 MB 86.1%
innd 9356 7.4%1.2 MB 7.8%
nnrpd 7705 6.1%775.5 KB 5.1%
innfeed 1534 1.2%158.4 KB 1.0%
overchan 10 0.0%1.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 127263 100.0%15.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 107830 89.6%
Negative hits 9699 8.1%
Positive hits 2726 2.3%
Cache misses 29 0.0%
TOTAL: 4 120284 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.890 0.0%52 0.000 17.115 36.000
article cleanup00:00:00.820 0.0%108784 0.000 0.008 0.018
article logging00:00:02.705 0.0%108792 0.012 0.025 0.047
article parse00:00:04.440 0.0%411173 0.005 0.011 0.019
article write00:00:21.289 0.0%100657 0.074 0.212 2.233
artlog/artcncl00:00:00.001 0.0%46 0.000 0.022 0.500
data move00:00:00.861 0.0%605270 0.000 0.001 0.007
hisgrep/artcncl00:00:00.382 0.0%52 0.000 7.346 16.200
hishave/artcncl00:00:00.110 0.0%52 0.000 2.115 6.600
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:03.793 0.4%120854 1.580 3.010 6.679
history sync00:00:00.028 0.0%378 0.000 0.074 0.667
history write00:10:37.553 0.7%108402 4.329 5.881 10.672
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:41:04.930 98.6%512711 38.224 166.302 422.853
nntp read00:00:09.497 0.0%419003 0.014 0.023 0.036
overview write00:00:00.340 0.0%100657 0.000 0.003 0.010
perl filter00:02:00.520 0.1%108402 0.730 1.112 1.595
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.634 0.0%226032 0.008 0.016 0.026
TOTAL: 24:00:58.39924:00:31.793100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%24619 0.000 0.002 0.018
article prepare00:00:00.000 0.0%476 0.000 0.000 0.000
article read00:00:00.004 0.0%119 0.000 0.034 1.000
backlog stats00:00:00.049 0.0%104261 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.594 0.0%57826 0.000 0.010 0.023
data write00:00:01.518 0.0%33353 0.017 0.046 0.112
idle23:55:33.403100.0%104261 528.583 826.133 1521.987
status file00:00:00.220 0.0%393 0.000 0.560 1.355
TOTAL: 23:55:37.55323:55:35.844100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:09.077 99.1%4240 0.000 426.669900050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.161 0.0%10323 0.000 0.016 0.500
readart00:00:00.001 0.0%48 0.000 0.021 0.250
TOTAL: 00:30:26.18500:30:09.239 99.1%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 72 100605 100044 5 556 99%41:39:37
2news.icm.edu.pl 1 10048 350 2233 7465 3%23:20:01
3localhost 5 4 4 0 0 100%00:00:00
TOTAL: 3 78 110657 100398 2238 8021 90%64:59:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.3 GB4.9 MB5.5 MB1.3 GB 99%13.5 KB
2news.icm.edu.pl5.5 MB644.4 KB121.0 MB127.1 MB 4%16.6 KB
3localhost5.9 KB0.0 KB0.0 KB5.9 KB100%1.5 KB
TOTAL: 31.3 GB5.5 MB126.4 MB1.4 GB 90%13.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 10 04:15:01 - 04:59:59 2196 2.2% 0.8129.0 MB 2.2% 10.99
Nov 10 05:00:00 - 05:59:59 2805 2.8% 0.7834.8 MB 2.6% 9.90
Nov 10 06:00:00 - 06:59:59 3075 3.1% 0.8538.6 MB 2.9% 10.97
Nov 10 07:00:00 - 07:59:59 7126 7.1% 1.9866.7 MB 5.1% 18.97
Nov 10 08:00:00 - 08:59:59 6911 6.9% 1.9261.7 MB 4.7% 17.55
Nov 10 09:00:00 - 09:59:59 4101 4.1% 1.1447.5 MB 3.6% 13.52
Nov 10 10:00:00 - 10:59:59 3932 3.9% 1.0946.8 MB 3.5% 13.31
Nov 10 11:00:00 - 11:59:59 3855 3.8% 1.0746.1 MB 3.5% 13.12
Nov 10 12:00:00 - 12:59:59 4952 4.9% 1.3858.7 MB 4.5% 16.71
Nov 10 13:00:00 - 13:59:59 5189 5.2% 1.44123.7 MB 9.4% 35.20
Nov 10 14:00:00 - 14:59:59 4091 4.1% 1.1441.1 MB 3.1% 11.68
Nov 10 15:00:00 - 15:59:59 3531 3.5% 0.9842.4 MB 3.2% 12.05
Nov 10 16:00:00 - 16:59:59 4074 4.1% 1.1371.8 MB 5.4% 20.42
Nov 10 17:00:00 - 17:59:59 5209 5.2% 1.4580.6 MB 6.1% 22.92
Nov 10 18:00:00 - 18:59:59 6139 6.1% 1.71105.8 MB 8.0% 30.09
Nov 10 19:00:00 - 19:59:59 5217 5.2% 1.4561.7 MB 4.7% 17.55
Nov 10 20:00:00 - 20:59:59 4105 4.1% 1.1465.0 MB 4.9% 18.49
Nov 10 21:00:00 - 21:59:59 4429 4.4% 1.2374.2 MB 5.6% 21.09
Nov 10 22:00:00 - 22:59:59 3765 3.7% 1.0549.3 MB 3.7% 14.02
Nov 10 23:00:00 - 23:59:59 3538 3.5% 0.9830.4 MB 2.3% 8.64
Nov 11 00:00:00 - 00:59:59 3387 3.4% 0.9436.6 MB 2.8% 10.41
Nov 11 01:00:00 - 01:59:59 2539 2.5% 0.7128.4 MB 2.2% 8.08
Nov 11 02:00:00 - 02:59:59 2776 2.8% 0.7732.8 MB 2.5% 9.33
Nov 11 03:00:00 - 03:59:59 2878 2.9% 0.8037.0 MB 2.8% 10.52
Nov 11 04:00:00 - 04:15:01 655 0.7% 0.737.9 MB 0.6% 9.01
TOTAL: 24:00:00 100475 100.0% 1.161.3 GB 100.0% 15.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 7572 0 0 56 0 0 0 0 7516
2newsfeed.pionier.net.pl 564 230 0 324 1 0 0 0 9
TOTAL: 2 8136 230 0 380 1 0 0 0 7525

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 98
comp.mobile.android 29
fr.misc.actualite.covid19 24
it.comp.os.win.windows10 18
alt.comp.software.firefox 14
eternal-september.support 14
eternal-september.test 8
eternal-september.newusers 5
comp.sys.raspberry-pi 4
de.comm.software.mailreader 3
eternal-september.talk 2
de.comp.lang.vbclassic 2
comp.lang.go 2
it.eventi.covid19 1
grisbi.test 1
fido7.r50.crisis 1
fido7.ru.microchip 1
alt.comp.software.seamonkey 1
rocksolid.shared.test 1
it.comp.os.linux.ubuntu 1
TOTAL: 20 230

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
christnet.bible 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 7133
Scoring filter (9) 209
EMP (phl) 141
Scoring filter (8) 24
Scoring filter (10) 6
EMP (md5) 4
TOTAL: 6 7517

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 33110 107 24156 14 0 3 0%24:09:49
2poznan 408 2 342 0 0 0 0%20:47:44
3panorama 0 0 0 0 0 24830 0%24:05:35
4okapi 0 0 0 0 0 580 0%24:05:35
5nask 0 0 0 0 0 20414 0%24:05:35
TOTAL: 5 33518 109 24498 14 0 45827 0%117:14:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm427.7 KB86.1 KB513.8 KB0.0 KB/s4.2 KB24:09:49
2poznan20.2 KB0.0 KB20.2 KB0.0 KB/s10.1 KB20:47:44
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
TOTAL: 5447.9 KB86.1 KB534.0 KB0.0 KB/s4.3 KB117:14:18
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 288 4868.5 KB 22 0 000:00:08
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 4868.5 KB 22 4 000:30:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1733 4868.5 KB 22 4 000:00:22
2unresolved 104 00.0 KB 0 0 000:30:03
3*.a444.priv.bahnhof.se 1 00.0 KB 0 0 000:00:00
TOTAL: 31838 4868.5 KB 22 4 000:30:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
103.56.61.139 0.000 0.012 0.00000:30:00
nms2.man.lodz.pl 4.644 7.436 0.00000:00:13
web.man.lodz.pl 0.914 1.439 0.00000:00:08
80.111.142.213 0.025 0.023 0.00000:00:02
212.51.192.185 0.374 0.484 0.00000:00:01
198.199.104.60 0.006 0.000 0.00000:00:00
h-155-4-103-231.a444.priv.bahnhof.se 0.000 0.012 0.00000:00:00
45.129.14.9 0.001 0.014 0.00000:00:00
isvcs01.man.lodz.pl 0.004 0.034 0.00000:00:00
? 0.005 0.000 0.00000:00:00
TOTAL: 10 5.973 9.454 0.00000:30:26

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1441
212.51.192.185 96
80.111.142.213 4
45.129.14.9 2
h-155-4-103-231.a444.priv.bahnhof.se 1
103.56.61.139 1
198.199.104.60 1
TOTAL: 7 1546

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
45.129.14.9 2
198.199.104.60 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.129.14.9 2 2
103.56.61.139 1 0
TOTAL: 2 3 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 48100.0%
TOTAL: 1 48100.0%

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

NewsgroupCount
1pl.comp.pecet 42
2pl.comp.os.ms-windows.winnt 6
TOTAL: 2 48