Daily Usenet report

Nov 14 04:15:02 -- Nov 19 04:15:02

Unknown entries from news log file:

First 43 / 43 lines (100.0%)

Nov 14 08:55:11 newsfeed nnrpd[10638]: SERVER perl filter not defined
Nov 14 12:24:01 newsfeed innfeed[998]: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Nov 14 12:24:01 newsfeed innfeed[998]: SM: storage method 'cnfs' failed initialization
Nov 14 12:24:01 newsfeed innfeed[998]: SM: one or more storage methods failed initialization
Nov 14 12:24:01 newsfeed innfeed[998]: Storage manager initialization failed -- it is OK after a change in storage methods
Nov 14 12:24:01 newsfeed innd: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Nov 14 12:24:01 newsfeed innd: SM: storage method 'cnfs' failed initialization
Nov 14 12:24:01 newsfeed innd: SM: one or more storage methods failed initialization
Nov 15 04:15:32 newsfeed rnews: cant open_remote: Connection refused
Nov 16 04:15:32 newsfeed rnews: cant open_remote: Connection refused
Nov 17 04:15:32 newsfeed rnews: cant open_remote: Connection refused
Nov 18 04:15:31 newsfeed rnews: cant open_remote: Connection refused
Nov 18 12:19:10 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:11 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:13 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:14 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:15 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:15 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:16 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:16 newsfeed overchan[1157]: message repeated 2 times: [ input line too long, skipping]
Nov 18 12:19:16 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:19:17 newsfeed overchan[1157]: input line too long, skipping
Nov 18 12:43:46 newsfeed nnrpd[11656]: SERVER perl filter not defined
Nov 18 12:46:53 newsfeed nnrpd[11802]: SERVER perl filter not defined
Nov 18 13:00:38 newsfeed overchan[1157]: input line too long, skipping
Nov 18 13:09:06 newsfeed innfeed[1035]: CNFS: no magic cookie found for cycbuff BUF03, initializing
Nov 18 13:09:06 newsfeed innfeed[1035]: CNFS: CNFSflushhead: attempted flush whilst read only
Nov 18 13:09:06 newsfeed innfeed[1035]: CNFS: CNFSshutdowncycbuff: flushing BUF03
Nov 18 13:09:06 newsfeed innfeed[1035]: CNFS: CNFSflushhead: attempted flush whilst read only
Nov 18 13:09:06 newsfeed innfeed[1035]: SM: storage method 'cnfs' failed initialization
Nov 18 13:09:06 newsfeed innfeed[1035]: SM: one or more storage methods failed initialization
Nov 18 13:09:06 newsfeed innfeed[1035]: Storage manager initialization failed -- it is OK after a change in storage methods
Nov 18 13:09:06 newsfeed innd: CNFS: no magic cookie found for cycbuff BUF03, initializing
Nov 18 13:09:06 newsfeed innd: CNFS: Mismatch 3: read BUF03 for cycbuff BUF04
Nov 18 13:09:06 newsfeed innd: SM: storage method 'cnfs' failed initialization
Nov 18 13:09:06 newsfeed innd: SM: one or more storage methods failed initialization
Nov 18 13:10:14 newsfeed overchan[1032]: input line too long, skipping
Nov 18 15:42:11 newsfeed overchan[1042]: input line too long, skipping
Nov 18 16:24:20 newsfeed nnrpd[8656]: SERVER perl filter not defined
Nov 18 16:26:37 newsfeed nnrpd[8749]: SERVER perl filter not defined
Nov 18 21:22:38 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:31 checkpoint seconds 7 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Nov 18 22:05:43 newsfeed nnrpd[20200]: SERVER perl filter not defined
Nov 19 01:36:11 newsfeed overchan[1042]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1254722 95.9%139.9 MB 95.5%
innfeed 40033 3.1%4.7 MB 3.2%
innd 8588 0.7%1.4 MB 1.0%
nnrpd 5070 0.4%543.9 KB 0.4%
overchan 17 0.0%1.8 KB 0.0%
controlchan 7 0.0%0.5 KB 0.0%
rnews 4 0.0%0.3 KB 0.0%
TOTAL: 71308441 100.0%146.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1230414 99.2%
Negative hits 9063 0.7%
Positive hits 265 0.0%
Cache misses 53 0.0%
TOTAL: 4 1239795 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.176 0.0%130 0.000 9.046 60.500
article cleanup00:00:13.998 0.0%1230999 0.003 0.011 0.018
article logging00:00:47.130 0.1%1231391 0.027 0.038 0.050
article parse00:13:44.234 0.9%33427855 0.015 0.025 0.037
article write00:05:58.199 0.4%1230728 0.119 0.291 0.751
artlog/artcncl00:00:00.001 0.0%130 0.000 0.008 0.143
data move00:00:35.286 0.0%39804343 0.001 0.001 0.002
hisgrep/artcncl00:00:00.415 0.0%120 0.000 3.458 60.000
hishave/artcncl00:00:00.099 0.0%130 0.000 0.762 3.571
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:20:53.041 1.4%1240263 0.041 1.010 12.993
history sync00:00:00.022 0.0%302 0.000 0.073 0.500
history write00:15:01.004 1.0%1230966 0.158 0.732 3.618
hiswrite/artcncl00:00:00.009 0.0%10 0.000 0.900 2.000
idle21:05:49.580 87.3%31396641 0.912 2.419 28546.857
nntp read00:22:37.515 1.6%32737971 0.029 0.041 0.060
overview write00:00:05.415 0.0%1230728 0.001 0.004 0.008
perl filter01:34:34.705 6.5%1230966 2.456 4.610 9.026
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:59.271 0.1%2476815 0.017 0.024 0.034
TOTAL: 24:10:14.94724:01:21.100 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.104 0.0%49571 0.000 0.002 0.024
article prepare00:00:00.003 0.0%6840 0.000 0.000 0.050
article read00:00:03.850 0.0%1709 0.000 2.253 44.800
backlog stats00:00:00.099 0.0%123993 0.000 0.001 0.005
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.968 0.0%61089 0.000 0.016 0.039
data write00:00:02.791 0.0%45805 0.019 0.061 0.111
idle24:03:40.183100.0%123993 353.638 698.589 2164.208
status file00:00:12.292 0.0%13982 0.000 0.879 1.542
TOTAL: 24:04:05.59124:04:00.290100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:22.092 63.9%3195 0.000 6.915 1184.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.211 0.6%7124 0.000 0.030 0.500
readart00:00:00.006 0.0%78 0.000 0.077 0.500
TOTAL: 00:00:34.55500:00:22.309 64.6%----

Control commands to INND:

CommandNumber
L 1
flush 28
flushlogs 2
go 2
logmode 2
mode 168
name 13
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 224

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 296 12508231250679 1 143 99%109:50:51
2news.icm.edu.pl 64 953 661 162 130 69%17:01:24
3localhost 7 6 6 0 0 100%00:00:00
TOTAL: 3 367 12517821251346 163 273 99%126:52:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl253.8 GB595.4 KB886.2 KB253.8 GB 99%212.8 KB
2news.icm.edu.pl10.9 MB69.3 KB4.0 MB15.0 MB 72%19.5 KB
3localhost8.7 KB0.0 KB0.0 KB8.7 KB100%1.4 KB
TOTAL: 3253.9 GB664.6 KB4.9 MB253.9 GB 99%212.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 14 04:15:02 - 04:59:59 5969 0.5% 2.21426.8 MB 0.0% 161.98
Nov 14 05:00:00 - 05:59:59 75722 6.0% 21.035.4 GB 0.0%1580.24
Nov 14 06:00:00 - 06:59:59 104511 8.3% 29.039.0 GB 0.0%2621.69
Nov 14 07:00:00 - 07:59:59 49045 3.9% 13.6212.0 GB 0.0%3481.94
Nov 14 08:00:00 - 08:59:59 40553 3.2% 11.2610.6 GB 0.0%3097.16
Nov 14 09:00:00 - 09:59:59 107221 8.6% 29.7816.1 GB 0.0%4703.18
Nov 14 10:00:00 - 10:59:59 52970 4.2% 14.7113.4 GB 0.0%3900.96
Nov 14 11:00:00 - 11:59:59 46431 3.7% 12.9017.0 GB 0.0%4937.63
Nov 14 12:00:00 - 12:59:59 40808 3.3% 11.3410.4 GB 0.0%3018.73
Nov 14 13:00:00 - 13:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 14:00:00 - 14:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 15:00:00 - 15:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 16:00:00 - 16:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 17:00:00 - 17:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 18:00:00 - 18:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 19:00:00 - 19:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 20:00:00 - 20:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 21:00:00 - 21:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 14 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 01:00:00 - 01:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 03:00:00 - 03:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 04:00:00 - 04:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 05:00:00 - 05:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 06:00:00 - 06:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 07:00:00 - 07:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 09:00:00 - 09:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 10:00:00 - 10:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 11:00:00 - 11:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 18 12:00:00 - 12:59:59 29515 2.4% 8.2013.6 GB 201.6%3947.84
Nov 18 13:00:00 - 13:59:59 38097 3.0% 10.5814.2 GB 211.2%4136.59
Nov 18 14:00:00 - 14:59:59 45362 3.6% 12.609.0 GB 133.7%2618.88
Nov 18 15:00:00 - 15:59:59 26528 2.1% 7.377.0 GB 104.4%2043.95
Nov 18 16:00:00 - 16:59:59 37893 3.0% 10.5313.1 GB 195.1%3822.14
Nov 18 17:00:00 - 17:59:59 61238 4.9% 17.0117.5 GB 259.9%5090.99
Nov 18 18:00:00 - 18:59:59 71946 5.7% 19.9817.6 GB 261.1%5113.19
Nov 18 19:00:00 - 19:59:59 82734 6.6% 22.9820.0 GB 297.5%5826.69
Nov 18 20:00:00 - 20:59:59 39251 3.1% 10.907.0 GB 103.5%2027.23
Nov 18 21:00:00 - 21:59:59 71703 5.7% 19.924.3 GB 63.7%1247.83
Nov 18 22:00:00 - 22:59:59 28552 2.3% 7.931.1 GB 16.2% 316.36
Nov 18 23:00:00 - 23:59:59 42256 3.4% 11.747.1 GB 105.3%2062.02
Nov 19 00:00:00 - 00:59:59 31494 2.5% 8.756.3 GB 93.3%1827.74
Nov 19 01:00:00 - 01:59:59 37207 3.0% 10.347.1 GB 106.1%2078.26
Nov 19 02:00:00 - 02:59:59 35884 2.9% 9.976.7 GB 100.0%1958.63
Nov 19 03:00:00 - 03:59:59 43030 3.4% 11.957.3 GB 108.6%2126.98
Nov 19 04:00:00 - 04:15:02 8001 0.6% 8.871.8 GB 26.3%2054.69
TOTAL: 48:00:00 1253921 100.0% 7.266.7 GB 100.0% 40.80
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 528 112 0 29 3 0 0 0 384
2news.icm.edu.pl 142 0 0 5 0 0 0 0 137
TOTAL: 2 670 112 0 34 3 0 0 0 521

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 36
it.comp.os.win.windows10 36
it.tlc.cellulari.android 19
nl.comp.os.linux.techniek 5
comp.sys.raspberry-pi 3
uk.rec.cycling.moderated 3
comp.mobile.android 3
de.comm.software.mailreader 3
comp.sys.mac.vintage 1
de.comp.lang.php 1
comp.mobile.ipad 1
it.comp.os.win.windows7 1
TOTAL: 12 112

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

GroupsCount
pl.praca.oferowana 2
pl.sci.matematyka 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 95
Binary in non-binary group 22
Scoring filter (8) 8
Too many newsgroups 1
TOTAL: 4 126

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 384
news.icm.edu.pl 11
TOTAL: 2 395
TOTAL: 1 395

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24352 648 13853 29 0 2 2%23:55:29
2panorama 37569 490 13555 138 2 36294 1%24:32:15
3poznan 199 0 185 0 0 0 0%04:45:40
4nask 0 0 0 0 0 10201 0%24:03:22
5okapi 0 0 0 0 0 1007 0%24:03:22
TOTAL: 5 62120 1138 27593 167 2 47504 1%101:20:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.7 MB213.3 KB1.9 MB0.0 KB/s2.9 KB23:55:29
2panorama1.4 MB522.1 KB1.9 MB0.0 KB/s3.2 KB24:32:15
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:45:40
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:03:22
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:03:22
TOTAL: 53.1 MB735.5 KB3.9 MB0.0 KB/s3.0 KB101:20:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 297 7878.5 KB 33 0 000:00:16
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 303 7878.5 KB 33 6 000:00:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 598 7878.5 KB 33 6 000:00:20
2*.sfj.corp.censys.io 1 00.0 KB 0 0 000:00:00
3*.security.ipip.net 1 00.0 KB 0 0 000:00:00
4unresolved 102 00.0 KB 0 0 000:00:12
TOTAL: 4 702 7878.5 KB 33 6 000:00:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.352 2.564 0.00000:00:16
80.111.142.213 0.012 0.032 0.00000:00:12
mon.man.lodz.pl 1.116 2.016 0.00000:00:02
212.51.192.185 0.428 0.648 0.00000:00:00
scan-141.security.ipip.net 0.000 0.004 0.00000:00:00
isvcs01.man.lodz.pl 0.044 0.044 0.00000:00:00
worker-18.sfj.corp.censys.io 0.004 0.008 0.00000:00:00
TOTAL: 7 2.956 5.316 0.00000:00:34

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 295
212.51.192.185 98
80.111.142.213 4
worker-18.sfj.corp.censys.io 1
scan-141.security.ipip.net 1
TOTAL: 5 399

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.corp.censys.io 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 78100.0%
TOTAL: 1 78100.0%

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

NewsgroupCount
1pl.comp.pecet 46
2pl.comp.os.ms-windows.winnt 32
TOTAL: 2 78
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>