Daily Usenet report

Jun 4 04:15:02 -- Jun 5 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Jun 4 06:50:36 newsfeed nnrpd[1353299]: SERVER perl filter not defined
Jun 4 11:54:51 newsfeed nnrpd[1366533]: SERVER perl filter not defined
Jun 4 11:56:02 newsfeed nnrpd[1366630]: SERVER perl filter not defined
Jun 4 21:21:08 newsfeed nnrpd[1391609]: SERVER perl filter not defined
Jun 4 21:24:58 newsfeed nnrpd[1391662]: SERVER perl filter not defined
Jun 4 21:29:40 newsfeed innfeed[1458]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Jun 4 21:29:40 newsfeed innfeed[1458]: SM: storage method 'cnfs' failed initialization
Jun 4 21:29:40 newsfeed innfeed[1458]: SM: one or more storage methods failed initialization
Jun 4 21:29:40 newsfeed innfeed[1458]: Storage manager initialization failed -- it is OK after a change in storage methods
Jun 4 21:29:40 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Jun 4 21:29:40 newsfeed innd: SM: storage method 'cnfs' failed initialization
Jun 4 21:29:40 newsfeed innd: SM: one or more storage methods failed initialization
Jun 4 21:54:40 newsfeed innfeed[1311]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF05
Jun 4 21:54:40 newsfeed innfeed[1311]: SM: storage method 'cnfs' failed initialization
Jun 4 21:54:40 newsfeed innfeed[1311]: SM: one or more storage methods failed initialization
Jun 4 21:54:40 newsfeed innfeed[1311]: Storage manager initialization failed -- it is OK after a change in storage methods
Jun 4 21:54:40 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF05
Jun 4 21:54:40 newsfeed innd: SM: storage method 'cnfs' failed initialization
Jun 4 21:54:40 newsfeed innd: SM: one or more storage methods failed initialization

Log entries by program:

Program nameLines%LinesSize%Size
inn 546450 97.6%60.4 MB 97.6%
nnrpd 7571 1.4%779.2 KB 1.2%
innd 4278 0.8%575.6 KB 0.9%
innfeed 1304 0.2%148.3 KB 0.2%
controlchan 4 0.0%0.3 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 559609 100.0%61.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 528363 99.7%
Negative hits 1745 0.3%
Positive hits 88 0.0%
Cache misses 18 0.0%
TOTAL: 4 530214 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.489 0.0%40 0.000 37.225 120.000
article cleanup00:00:02.983 0.0%529424 0.000 0.006 0.015
article logging00:00:10.844 0.0%529489 0.015 0.020 0.055
article parse00:00:24.056 0.0%2442514 0.007 0.010 0.015
article write00:00:38.170 0.0%529234 0.047 0.072 0.551
artlog/artcncl00:00:00.000 0.0%40 0.000 0.000 0.000
data move00:00:02.564 0.0%3400652 0.000 0.001 0.003
hisgrep/artcncl00:00:00.452 0.0%38 0.000 11.895 40.000
hishave/artcncl00:00:00.326 0.0%40 0.000 8.150 22.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:17:10.552 5.5%531228 4.835 8.717 22.589
history sync00:00:00.025 0.0%356 0.000 0.070 0.667
history write01:22:03.094 5.8%529412 5.679 9.299 21.073
hiswrite/artcncl00:00:00.010 0.0%2 5.000 5.000 5.000
idle20:37:44.947 87.7%2359228 2.549 31.478 413.116
nntp read00:00:34.081 0.0%2173041 0.010 0.016 0.026
overview write00:00:01.547 0.0%529234 0.001 0.003 0.010
perl filter00:10:24.467 0.7%529412 0.845 1.180 1.470
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:15.873 0.0%1088041 0.008 0.015 0.021
TOTAL: 23:30:53.29123:29:35.480 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.042 0.0%29270 0.000 0.001 0.019
article prepare00:00:00.000 0.0%20 0.000 0.000 0.000
article read00:00:00.000 0.0%5 0.000 0.000 0.000
backlog stats00:00:00.031 0.0%48107 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.379 0.0%35954 0.000 0.011 0.038
data write00:00:00.321 0.0%6896 0.000 0.047 0.190
idle23:19:03.190100.0%48107 487.114 1744.927 5717.610
status file00:00:00.263 0.0%366 0.000 0.719 13.000
TOTAL: 23:19:05.58223:19:04.226100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:14.373 45.3%4166 0.000 3.450 2956.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.194 0.6%10138 0.000 0.019 0.500
readart00:00:00.001 0.0%40 0.000 0.025 0.500
TOTAL: 00:00:31.74000:00:14.568 45.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 97 546303 546116 1 186 99%37:41:26
2news.icm.edu.pl 37 67 7 57 3 10%07:44:54
3localhost 6 5 5 0 0 100%00:00:00
TOTAL: 3 140 546375 546128 58 189 99%45:26:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl8.7 GB163.1 KB687.3 KB8.7 GB 99%16.7 KB
2news.icm.edu.pl233.2 KB37.4 KB37.4 KB308.1 KB 75%30.8 KB
3localhost7.4 KB0.0 KB0.0 KB7.4 KB100%1.5 KB
TOTAL: 38.7 GB200.5 KB724.8 KB8.7 GB 99%16.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 04:15:02 - 04:59:59 4378 0.8% 1.6242.0 MB 0.5% 15.95
Jun 4 05:00:00 - 05:59:59 6587 1.2% 1.8352.0 MB 0.6% 14.80
Jun 4 06:00:00 - 06:59:59 5542 1.0% 1.5454.4 MB 0.6% 15.48
Jun 4 07:00:00 - 07:59:59 6308 1.2% 1.7572.1 MB 0.8% 20.51
Jun 4 08:00:00 - 08:59:59 6976 1.3% 1.9465.1 MB 0.7% 18.51
Jun 4 09:00:00 - 09:59:59 8281 1.5% 2.3070.2 MB 0.8% 19.96
Jun 4 10:00:00 - 10:59:59 9432 1.7% 2.6276.0 MB 0.9% 21.62
Jun 4 11:00:00 - 11:59:59 8910 1.6% 2.4884.0 MB 0.9% 23.89
Jun 4 12:00:00 - 12:59:59 8124 1.5% 2.2675.3 MB 0.8% 21.43
Jun 4 13:00:00 - 13:59:59 7953 1.5% 2.2184.4 MB 0.9% 24.01
Jun 4 14:00:00 - 14:59:59 11177 2.0% 3.10116.8 MB 1.3% 33.23
Jun 4 15:00:00 - 15:59:59 9890 1.8% 2.7594.7 MB 1.1% 26.95
Jun 4 16:00:00 - 16:59:59 8260 1.5% 2.2968.0 MB 0.8% 19.34
Jun 4 17:00:00 - 17:59:59 10679 2.0% 2.9795.0 MB 1.1% 27.02
Jun 4 18:00:00 - 18:59:59 8031 1.5% 2.2377.2 MB 0.9% 21.95
Jun 4 19:00:00 - 19:59:59 8235 1.5% 2.2984.4 MB 0.9% 24.00
Jun 4 20:00:00 - 20:59:59 7313 1.3% 2.0384.0 MB 0.9% 23.89
Jun 4 21:00:00 - 21:59:59 4280 0.8% 1.1942.3 MB 0.5% 12.04
Jun 4 22:00:00 - 22:59:59 6560 1.2% 1.8254.7 MB 0.6% 15.57
Jun 4 23:00:00 - 23:59:59 6133 1.1% 1.7070.9 MB 0.8% 20.17
Jun 5 00:00:00 - 00:59:59 58029 10.6% 16.121023.8 MB 11.5% 291.23
Jun 5 01:00:00 - 01:59:59 101152 18.5% 28.101.9 GB 21.4% 542.43
Jun 5 02:00:00 - 02:59:59 104165 19.1% 28.932.0 GB 22.5% 571.39
Jun 5 03:00:00 - 03:59:59 102410 18.8% 28.451.9 GB 22.3% 565.28
Jun 5 04:00:00 - 04:15:02 27349 5.0% 30.32532.6 MB 6.0% 604.62
TOTAL: 24:00:00 546154 100.0% 6.328.7 GB 100.0% 105.76
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 252 173 0 9 5 0 0 0 65
2news.icm.edu.pl 4 0 0 3 0 0 0 0 1
TOTAL: 2 256 173 0 12 5 0 0 0 66

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 83
it.tlc.cellulari.android 20
comp.mobile.android 16
it.comp.os.win.windows10 13
eternal-september.test 9
fr.misc.actualite.covid19 7
alt.comp.software.seamonkey 6
eternal-september.support 5
it.discussioni.energia 5
eternal-september.talk 3
it.comp.os.linux.ubuntu 1
alt.comp.software.firefox 1
fr.rec.loisirs-creatifs 1
perl.cpan.testers.discuss 1
grisbi.test 1
de.comp.lang.vbclassic 1
TOTAL: 16 173

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

GroupsCount
christnet.bible 5
TOTAL: 1 5

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 65
news.icm.edu.pl 1
TOTAL: 2 66
TOTAL: 1 66

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 6655 5 6045 0 0 0 0%23:20:03
2okapi 0 0 0 0 0 642 0%23:20:01
3nask 0 0 0 0 0 26890 0%23:20:03
4panorama 0 0 0 0 0 29469 0%23:20:01
5poznan 7 0 6 0 0 0 0%01:20:05
TOTAL: 5 6662 5 6051 0 0 57001 0%94:40:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm19.2 KB0.0 KB19.2 KB0.0 KB/s3.8 KB23:20:03
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:20:01
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:20:03
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:20:01
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:20:05
TOTAL: 519.2 KB0.0 KB19.2 KB0.0 KB/s3.8 KB94:40:13
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
TOTAL: 12.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 283 4045.1 KB 20 0 000:00:10
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 288 4045.1 KB 20 5 000:00:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1700 4045.1 KB 20 5 000:00:24
2unresolved 105 00.0 KB 0 0 000:00:08
TOTAL: 21805 4045.1 KB 20 5 000:00:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 3.901 11.731 0.00000:00:13
web.man.lodz.pl 0.802 2.289 0.00000:00:10
167.94.145.100 0.025 0.014 0.00000:00:03
80.111.142.213 0.015 0.032 0.00000:00:02
212.51.192.185 0.250 0.767 0.00000:00:01
206.168.34.47 0.009 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.030 0.054 0.00000:00:00
194.165.16.72 0.000 0.009 0.00000:00:00
107.170.247.15 0.007 0.010 0.00000:00:00
TOTAL: 9 5.039 14.916 0.00000:00:32

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1412
212.51.192.185 95
80.111.142.213 4
167.94.145.100 3
107.170.247.15 1
206.168.34.47 1
194.165.16.72 1
TOTAL: 7 1517

NNRP unrecognized commands (by host):

SystemConn
194.165.16.72 1
167.94.145.100 1
107.170.247.15 1
206.168.34.47 1
TOTAL: 4 4

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 2
#003 1
MGLNDD_212.191.2.21_119 1
TOTAL: 3 4

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.72 1 1
167.94.145.100 1 2
TOTAL: 2 2 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 40100.0%
TOTAL: 1 40100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 34
2pl.comp.pecet 6
TOTAL: 2 40