Daily Usenet report

Feb 12 04:15:01 -- Feb 13 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Feb 12 04:18:00 newsfeed nnrpd[427720]: nms2.man.lodz.pl rejected Expiring process 427684
Feb 12 08:27:49 newsfeed nnrpd[439094]: SERVER perl filter not defined
Feb 12 08:28:25 newsfeed nnrpd[439116]: SERVER perl filter not defined
Feb 12 12:01:59 newsfeed nnrpd[448533]: SERVER perl filter not defined
Feb 12 12:04:59 newsfeed nnrpd[448722]: SERVER perl filter not defined
Feb 12 12:22:27 newsfeed innfeed[1428]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 12 12:22:27 newsfeed innfeed[1428]: SM: storage method 'cnfs' failed initialization
Feb 12 12:22:27 newsfeed innfeed[1428]: SM: one or more storage methods failed initialization
Feb 12 12:22:27 newsfeed innfeed[1428]: Storage manager initialization failed -- it is OK after a change in storage methods
Feb 12 12:22:27 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 12 12:22:27 newsfeed innd: SM: storage method 'cnfs' failed initialization
Feb 12 12:22:27 newsfeed innd: SM: one or more storage methods failed initialization
Feb 12 12:34:56 newsfeed nnrpd[2543]: SERVER perl filter not defined
Feb 12 15:39:13 newsfeed nnrpd[10898]: SERVER perl filter not defined
Feb 12 20:10:18 newsfeed overchan[1446]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 107931 90.6%12.5 MB 91.7%
nnrpd 7686 6.4%751.4 KB 5.4%
innd 1891 1.6%212.8 KB 1.5%
innfeed 1662 1.4%186.4 KB 1.3%
overchan 4 0.0%0.6 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 119177 100.0%13.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 105374 96.2%
Negative hits 2964 2.7%
Positive hits 1184 1.1%
Cache misses 21 0.0%
TOTAL: 4 109543 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.757 0.0%51 0.000 14.843 65.000
article cleanup00:00:00.782 0.0%106180 0.000 0.007 0.018
article logging00:00:02.830 0.0%106198 0.011 0.027 0.045
article parse00:00:04.721 0.0%412910 0.006 0.011 0.020
article write00:00:19.163 0.0%105607 0.071 0.181 0.785
artlog/artcncl00:00:00.000 0.0%51 0.000 0.000 0.000
data move00:00:00.804 0.0%588494 0.000 0.001 0.005
hisgrep/artcncl00:00:00.401 0.0%51 0.000 7.863 38.000
hishave/artcncl00:00:00.173 0.0%51 0.000 3.392 22.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:17:30.342 1.2%110031 3.863 9.546 16.050
history sync00:00:00.018 0.0%355 0.000 0.051 0.500
history write00:17:38.771 1.2%105754 5.052 10.012 15.022
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:02:18.182 97.3%497405 36.273 166.742 459.847
nntp read00:00:09.955 0.0%407874 0.016 0.024 0.038
overview write00:00:00.374 0.0%105607 0.000 0.004 0.017
perl filter00:02:14.027 0.2%105754 0.938 1.267 1.874
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.072 0.0%233492 0.007 0.017 0.030
TOTAL: 23:40:49.51223:40:25.372100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%22540 0.000 0.002 0.021
article prepare00:00:00.000 0.0%144 0.000 0.000 0.000
article read00:00:00.002 0.0%36 0.000 0.056 1.000
backlog stats00:00:00.032 0.0%65136 0.000 0.000 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.484 0.0%40289 0.000 0.012 0.033
data write00:00:00.831 0.0%17964 0.000 0.046 0.154
idle23:48:10.890100.0%65136 537.262 1315.569 3403.362
status file00:00:00.265 0.0%475 0.000 0.558 2.000
TOTAL: 23:48:13.78323:48:12.551100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:00:50.083 99.8%4233 0.000 1712.753300098.833
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.283 0.0%10194 0.000 0.028 2.850
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 02:01:06.70802:00:50.366 99.8%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 96 107174 106820 2 352 99%44:13:28
2news.icm.edu.pl 3 823 168 505 150 20%16:32:24
3localhost 7 6 6 0 0 100%00:00:00
TOTAL: 3 106 108003 106994 507 502 99%60:45:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.4 GB2.6 MB2.9 MB1.4 GB 99%13.3 KB
2news.icm.edu.pl2.0 MB1.4 MB1.6 MB5.1 MB 39%16.4 KB
3localhost8.6 KB0.0 KB0.0 KB8.6 KB100%1.4 KB
TOTAL: 31.4 GB4.0 MB4.5 MB1.4 GB 99%13.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 12 04:15:01 - 04:59:59 2839 2.6% 1.0529.2 MB 2.1% 11.08
Feb 12 05:00:00 - 05:59:59 3237 3.0% 0.9039.7 MB 2.8% 11.29
Feb 12 06:00:00 - 06:59:59 3353 3.1% 0.9334.9 MB 2.5% 9.93
Feb 12 07:00:00 - 07:59:59 4060 3.8% 1.1346.9 MB 3.4% 13.34
Feb 12 08:00:00 - 08:59:59 4315 4.0% 1.2048.0 MB 3.4% 13.64
Feb 12 09:00:00 - 09:59:59 3854 3.6% 1.0740.1 MB 2.9% 11.42
Feb 12 10:00:00 - 10:59:59 4500 4.2% 1.2537.7 MB 2.7% 10.73
Feb 12 11:00:00 - 11:59:59 4220 3.9% 1.1735.4 MB 2.5% 10.07
Feb 12 12:00:00 - 12:59:59 3800 3.5% 1.0689.2 MB 6.4% 25.38
Feb 12 13:00:00 - 13:59:59 3504 3.3% 0.9734.9 MB 2.5% 9.92
Feb 12 14:00:00 - 14:59:59 2694 2.5% 0.7527.9 MB 2.0% 7.95
Feb 12 15:00:00 - 15:59:59 3349 3.1% 0.9343.2 MB 3.1% 12.30
Feb 12 16:00:00 - 16:59:59 3280 3.1% 0.9132.6 MB 2.3% 9.28
Feb 12 17:00:00 - 17:59:59 5170 4.8% 1.4457.5 MB 4.1% 16.34
Feb 12 18:00:00 - 18:59:59 5484 5.1% 1.5279.8 MB 5.7% 22.71
Feb 12 19:00:00 - 19:59:59 5437 5.1% 1.5160.6 MB 4.3% 17.23
Feb 12 20:00:00 - 20:59:59 4901 4.6% 1.3656.9 MB 4.1% 16.19
Feb 12 21:00:00 - 21:59:59 6213 5.8% 1.73133.2 MB 9.5% 37.89
Feb 12 22:00:00 - 22:59:59 4256 4.0% 1.1865.9 MB 4.7% 18.76
Feb 12 23:00:00 - 23:59:59 4330 4.0% 1.2072.1 MB 5.2% 20.52
Feb 13 00:00:00 - 00:59:59 5546 5.2% 1.5483.7 MB 6.0% 23.80
Feb 13 01:00:00 - 01:59:59 5446 5.1% 1.5171.7 MB 5.1% 20.38
Feb 13 02:00:00 - 02:59:59 4985 4.6% 1.3873.1 MB 5.2% 20.79
Feb 13 03:00:00 - 03:59:59 6129 5.7% 1.7077.6 MB 5.6% 22.08
Feb 13 04:00:00 - 04:15:01 2382 2.2% 2.6424.7 MB 1.8% 28.06
TOTAL: 24:00:00 107284 100.0% 1.241.4 GB 100.0% 16.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 371 135 0 218 0 0 0 0 18
2news.icm.edu.pl 225 0 0 213 0 0 0 0 12
TOTAL: 2 596 135 0 431 0 0 0 0 30

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 29
fr.misc.actualite.covid19 27
uk.railway 22
comp.sys.raspberry-pi 8
alt.comp.software.firefox 8
it.comp.os.win.windows10 7
eternal-september.test 5
eternal-september.newusers 5
de.comp.lang.perl 5
eternal-september.talk 4
comp.mobile.android 4
de.comm.software.mailreader 3
de.rec.sf.startrek 2
hamburg.antifa 2
it.comp.virtualizzazione 1
rocksolid.nodes.help 1
grisbi.test 1
rocksolid.shared.i2p 1
TOTAL: 18 135

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17350 34 15448 2 0 0 0%23:49:28
2nask 0 0 0 0 0 18642 0%23:47:17
3okapi 0 0 0 0 0 654 0%23:47:17
4poznan 256 0 220 0 0 0 0%19:10:48
5panorama 0 0 0 0 0 23179 0%23:47:17
TOTAL: 5 17606 34 15668 2 0 42475 0%114:22:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm168.3 KB5.3 KB173.6 KB0.0 KB/s4.8 KB23:49:28
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:17
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:17
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s019:10:48
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:17
TOTAL: 5168.3 KB5.3 KB173.6 KB0.0 KB/s4.8 KB114:22:07
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.9 MB
okapi488.3 KB
TOTAL: 22.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 67.9 KB 3 0 000:00:08
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 293 67.9 KB 3 6 002:01:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1732 67.9 KB 3 6 001:00:23
2unresolved 104 00.0 KB 0 0 001:00:43
TOTAL: 21836 67.9 KB 3 6 002:01:06

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
176.105.139.10 0.014 0.021 0.00001:00:30
pc-tom.man.lodz.pl 0.005 0.021 0.00001:00:01
nms2.man.lodz.pl 5.771 7.969 0.00000:00:13
162.243.131.14 0.006 0.006 0.00000:00:09
web.man.lodz.pl 1.143 1.609 0.00000:00:08
80.111.142.213 0.028 0.020 0.00000:00:02
212.51.192.185 0.426 0.536 0.00000:00:01
isvcs01.man.lodz.pl 0.046 0.042 0.00000:00:00
194.165.16.72 0.005 0.005 0.00000:00:00
TOTAL: 9 7.444 10.229 0.00002:01:06

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1437
212.51.192.185 96
80.111.142.213 4
pc-tom.man.lodz.pl 2
176.105.139.10 2
194.165.16.72 1
162.243.131.14 1
TOTAL: 7 1543

NNRP unrecognized commands (by host):

SystemConn
194.165.16.72 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
176.105.139.10 2 0
pc-tom.man.lodz.pl 2 0
194.165.16.72 1 1
TOTAL: 3 5 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.pecet 6
TOTAL: 1 6