Daily Usenet report

Aug 16 04:15:03 -- Aug 17 04:15:02

Unknown entries from news log file:

First 39 / 39 lines (100.0%)

Aug 16 07:12:42 newsfeed overchan[29807]: input line too long, skipping
Aug 16 12:50:38 newsfeed overchan[29807]: input line too long, skipping
Aug 16 13:01:42 newsfeed innfeed[1055]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Aug 16 13:01:42 newsfeed innfeed[1055]: SM: storage method 'cnfs' failed initialization
Aug 16 13:01:42 newsfeed innfeed[1055]: SM: one or more storage methods failed initialization
Aug 16 13:01:42 newsfeed innfeed[1055]: Storage manager initialization failed -- it is OK after a change in storage methods
Aug 16 13:01:42 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Aug 16 13:01:42 newsfeed innd: SM: storage method 'cnfs' failed initialization
Aug 16 13:01:42 newsfeed innd: SM: one or more storage methods failed initialization
Aug 16 13:06:24 newsfeed innfeed[1019]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Aug 16 13:06:24 newsfeed innfeed[1019]: SM: storage method 'cnfs' failed initialization
Aug 16 13:06:24 newsfeed innfeed[1019]: SM: one or more storage methods failed initialization
Aug 16 13:06:24 newsfeed innfeed[1019]: Storage manager initialization failed -- it is OK after a change in storage methods
Aug 16 13:06:24 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Aug 16 13:06:24 newsfeed innd: SM: storage method 'cnfs' failed initialization
Aug 16 13:06:24 newsfeed innd: SM: one or more storage methods failed initialization
Aug 16 13:14:37 newsfeed innfeed[1010]: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Aug 16 13:14:37 newsfeed innfeed[1010]: SM: storage method 'cnfs' failed initialization
Aug 16 13:14:37 newsfeed innfeed[1010]: SM: one or more storage methods failed initialization
Aug 16 13:14:37 newsfeed innfeed[1010]: Storage manager initialization failed -- it is OK after a change in storage methods
Aug 16 13:14:37 newsfeed innd: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Aug 16 13:14:37 newsfeed innd: SM: storage method 'cnfs' failed initialization
Aug 16 13:14:37 newsfeed innd: SM: one or more storage methods failed initialization
Aug 16 14:16:06 newsfeed innfeed[4962]: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Aug 16 14:16:06 newsfeed innfeed[4962]: SM: storage method 'cnfs' failed initialization
Aug 16 14:16:06 newsfeed innfeed[4962]: SM: one or more storage methods failed initialization
Aug 16 14:16:06 newsfeed innfeed[4962]: Storage manager initialization failed -- it is OK after a change in storage methods
Aug 16 14:16:06 newsfeed innd: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Aug 16 14:16:06 newsfeed innd: SM: storage method 'cnfs' failed initialization
Aug 16 14:16:06 newsfeed innd: SM: one or more storage methods failed initialization
Aug 16 17:51:09 newsfeed overchan[5191]: input line too long, skipping
Aug 16 17:56:15 newsfeed overchan[5191]: input line too long, skipping
Aug 16 18:34:19 newsfeed overchan[5191]: input line too long, skipping
Aug 16 20:17:33 newsfeed overchan[5191]: input line too long, skipping
Aug 16 21:06:28 newsfeed overchan[5191]: input line too long, skipping
Aug 16 22:39:31 newsfeed overchan[5191]: input line too long, skipping
Aug 16 23:33:37 newsfeed overchan[5191]: input line too long, skipping
Aug 17 01:31:03 newsfeed overchan[5191]: input line too long, skipping
Aug 17 03:57:07 newsfeed overchan[5191]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1772616 96.7%199.7 MB 96.4%
innfeed 39426 2.2%4.6 MB 2.2%
innd 16090 0.9%2.5 MB 1.2%
nnrpd 4481 0.2%473.7 KB 0.2%
overchan 16 0.0%2.7 KB 0.0%
controlchan 6 0.0%0.4 KB 0.0%
TOTAL: 61832635 100.0%207.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1758699 90.2%
Positive hits 114940 5.9%
Negative hits 73039 3.7%
Cache misses 2787 0.1%
TOTAL: 4 1949465 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.265 0.0%114 0.000 11.096 305.000
article cleanup00:00:23.584 0.0%1750609 0.010 0.013 0.019
article logging00:01:23.650 0.1%1751229 0.034 0.048 0.152
article parse00:33:33.075 2.5%66561466 0.014 0.030 0.042
article write00:12:55.812 1.0%1744060 0.204 0.445 0.938
artlog/artcncl00:00:00.002 0.0%110 0.000 0.018 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:02:56.821 0.2%76536595 0.001 0.002 0.004
hisgrep/artcncl00:00:00.214 0.0%109 0.000 1.963 18.000
hishave/artcncl00:00:00.033 0.0%114 0.000 0.289 2.600
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:42:07.177 3.1%1957761 0.219 1.291 6.997
history sync00:00:00.016 0.0%274 0.000 0.058 1.000
history write01:22:03.563 6.1%1745900 0.364 2.820 10.196
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle15:02:35.600 66.9%55873928 0.516 0.969 60099.600
nntp read00:51:15.262 3.8%65471641 0.030 0.047 0.078
overview write00:00:09.751 0.0%1744060 0.004 0.006 0.008
perl filter03:18:39.166 14.7%1745898 3.473 6.827 9.834
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:48.081 0.3%3660555 0.044 0.062 0.095
TOTAL: 22:30:04.83722:11:53.072 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.037 0.0%361317 0.000 0.003 0.006
article prepare00:00:00.059 0.0%209856 0.000 0.000 0.013
article read00:05:43.322 0.4%50966 0.365 6.736 53.986
backlog stats00:00:01.341 0.0%1381616 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:11.813 0.0%651101 0.010 0.018 0.029
data write00:02:19.353 0.2%716627 0.044 0.194 0.389
idle22:21:16.292 99.3%1381616 29.690 58.248 587.665
status file00:00:16.076 0.0%16330 0.528 0.984 6.449
TOTAL: 22:30:35.78522:29:49.293 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:15.926 56.8%2848 0.000 5.592 29.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.258 0.9%6297 0.000 0.041 0.500
readart00:00:00.005 0.0%28 0.000 0.179 0.500
TOTAL: 00:00:28.05500:00:16.189 57.7%----

Control commands to INND:

CommandNumber
L 1
flush 26
flushlogs 2
go 2
logmode 2
mode 143
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 187

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1238 17624241758040 2016 2368 99%327:55:31
2news.nask.pl 5 121673 5090 112391 4192 4%21:54:34
3news.icm.edu.pl 42 328 184 128 16 56%16:59:22
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 1286 18844251763314 114535 6576 93%366:49:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl472.8 GB48.0 MB50.5 MB472.9 GB 99%281.7 KB
2news.nask.pl64.7 MB500.2 MB508.7 MB1.0 GB 6%118.4 KB
3news.icm.edu.pl3.5 MB112.9 KB355.1 KB3.9 MB 88%20.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4472.8 GB548.3 MB559.5 MB473.9 GB 99%280.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 16 04:15:03 - 04:59:59 42196 2.4% 15.6514.6 GB 0.0%5678.80
Aug 16 05:00:00 - 05:59:59 64498 3.7% 17.9219.8 GB 32.5%5757.27
Aug 16 06:00:00 - 06:59:59 75925 4.3% 21.0923.4 GB 38.4%6814.96
Aug 16 07:00:00 - 07:59:59 21610 1.2% 6.008.2 GB 13.4%2379.23
Aug 16 08:00:00 - 08:59:59 68515 3.9% 19.0320.4 GB 33.5%5939.15
Aug 16 09:00:00 - 09:59:59 44370 2.5% 12.3215.7 GB 25.9%4584.36
Aug 16 10:00:00 - 10:59:59 62193 3.5% 17.2817.8 GB 29.2%5178.29
Aug 16 11:00:00 - 11:59:59 40518 2.3% 11.2612.7 GB 20.9%3708.11
Aug 16 12:00:00 - 12:59:59 52436 3.0% 14.5717.7 GB 29.1%5167.03
Aug 16 13:00:00 - 13:59:59 885 0.1% 0.25270.0 MB 0.4% 76.80
Aug 16 14:00:00 - 14:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Aug 16 15:00:00 - 15:59:59 90752 5.1% 25.2127.3 GB 44.9%7955.21
Aug 16 16:00:00 - 16:59:59 68872 3.9% 19.1321.4 GB 35.1%6220.76
Aug 16 17:00:00 - 17:59:59 113555 6.4% 31.5428.1 GB 46.2%8188.20
Aug 16 18:00:00 - 18:59:59 145975 8.3% 40.5531.5 GB 51.7%9173.50
Aug 16 19:00:00 - 19:59:59 118920 6.7% 33.0331.2 GB 51.3%9089.74
Aug 16 20:00:00 - 20:59:59 60077 3.4% 16.6917.6 GB 28.9%5124.28
Aug 16 21:00:00 - 21:59:59 76744 4.3% 21.3216.5 GB 27.1%4800.93
Aug 16 22:00:00 - 22:59:59 93819 5.3% 26.0623.4 GB 38.4%6809.76
Aug 16 23:00:00 - 23:59:59 66806 3.8% 18.5618.0 GB 29.6%5244.61
Aug 17 00:00:00 - 00:59:59 110658 6.3% 30.7418.4 GB 30.3%5373.46
Aug 17 01:00:00 - 01:59:59 125757 7.1% 34.9330.3 GB 49.7%8816.53
Aug 17 02:00:00 - 02:59:59 102731 5.8% 28.5425.5 GB 41.9%7428.58
Aug 17 03:00:00 - 03:59:59 90423 5.1% 25.1226.4 GB 43.4%7686.86
Aug 17 04:00:00 - 04:15:02 27003 1.5% 29.947.7 GB 12.6%8916.46
TOTAL: 23:59:59 1765238 100.0% 20.4360.9 GB 100.0% 738.83
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4426 3 0 2651 2 0 0 0 1770
2newsfeed.pionier.net.pl 2829 176 0 2122 1 0 0 0 530
3news.icm.edu.pl 13 0 0 3 0 0 0 0 10
TOTAL: 3 7268 179 0 4776 3 0 0 0 2310

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 101
it.tlc.cellulari.android 49
it.comp.os.win.windows10 12
comp.mobile.android 9
de.comp.lang.vbclassic 2
uk.rec.cycling.moderated 2
hr.ponuda.hardver.komponente 2
de.rec.sf.startrek 1
it.comp.os.win.windows7 1
TOTAL: 9 179

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

GroupsCount
pl.praca.oferowana 2
bit.listserv.catholic 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1553
Binary in non-binary group 72
Scoring filter (16) 22
Scoring filter (9) 12
Scoring filter (8) 12
Scoring filter (18) 6
Too many newsgroups 4
Scoring filter (10) 4
TOTAL: 8 1685

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 464
news.nask.pl 154
news.icm.edu.pl 5
TOTAL: 3 623
TOTAL: 1 623

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 231320 46719 115414 690 0 11687 20%22:00:19
2panorama 190881 336 163295 51 0 189524 0%22:43:23
3poznan 6995 147 5036 22 0 0 2%22:00:20
4icm 218617 40 168296 4977 0 1 0%22:00:18
5okapi 0 0 0 0 0 1147 0%22:35:36
TOTAL: 5 647813 47242 452041 5740 0 202359 7%111:19:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask28.9 GB433.1 MB29.3 GB387.7 KB/s647.9 KB22:00:19
2panorama41.1 MB10.0 MB51.1 MB0.6 KB/s135.3 KB22:43:23
3icm2.8 MB2.9 GB2.9 GB38.8 KB/s612.2 KB22:00:18
4poznan932.3 KB65.2 KB997.4 KB0.0 KB/s5.9 KB22:00:20
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s022:35:36
TOTAL: 528.9 GB3.4 GB32.3 GB84.4 KB/s638.7 KB111:19:56
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 273 2837.8 KB 13 0 000:00:22
TOTAL: 1 273 2837.8 KB 13 0 000:00:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 636 2837.8 KB 13 0 000:00:27
TOTAL: 1 636 2837.8 KB 13 0 000:00:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.496 3.984 0.00000:00:22
mon.man.lodz.pl 1.260 3.212 0.00000:00:03
david.man.lodz.pl 0.444 1.020 0.00000:00:01
TOTAL: 3 3.200 8.216 0.00000:00:27

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 272
david.man.lodz.pl 91
TOTAL: 2 363

Newsgroup request counts (by category):

CategoryCountPct
1pl 28100.0%
TOTAL: 1 28100.0%

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

NewsgroupCount
1pl.comp.pecet 24
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 28