Daily Usenet report

Jun 13 04:15:02 -- Jun 14 04:15:03

Unknown entries from news log file:

First 30 / 30 lines (100.0%)

Jun 13 10:05:14 newsfeed innfeed[1025]: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Jun 13 10:05:14 newsfeed innfeed[1025]: SM: storage method 'cnfs' failed initialization
Jun 13 10:05:14 newsfeed innfeed[1025]: SM: one or more storage methods failed initialization
Jun 13 10:05:14 newsfeed innfeed[1025]: Storage manager initialization failed -- it is OK after a change in storage methods
Jun 13 10:05:14 newsfeed innd: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Jun 13 10:05:14 newsfeed innd: SM: storage method 'cnfs' failed initialization
Jun 13 10:05:14 newsfeed innd: SM: one or more storage methods failed initialization
Jun 13 12:32:51 newsfeed nnrpd[5731]: SERVER perl filter not defined
Jun 13 13:03:14 newsfeed nnrpd[6898]: SERVER perl filter not defined
Jun 13 13:31:43 newsfeed overchan[1054]: input line too long, skipping
Jun 13 15:23:34 newsfeed overchan[1054]: input line too long, skipping
Jun 13 15:29:50 newsfeed overchan[1054]: input line too long, skipping
Jun 13 15:34:35 newsfeed overchan[1054]: input line too long, skipping
Jun 13 15:39:48 newsfeed overchan[1054]: input line too long, skipping
Jun 13 16:17:14 newsfeed overchan[1054]: input line too long, skipping
Jun 13 16:21:08 newsfeed overchan[1054]: input line too long, skipping
Jun 13 16:21:24 newsfeed overchan[1054]: input line too long, skipping
Jun 13 18:51:16 newsfeed nnrpd[20158]: SERVER perl filter not defined
Jun 13 18:57:57 newsfeed nnrpd[20283]: SERVER perl filter not defined
Jun 13 20:12:11 newsfeed overchan[1054]: input line too long, skipping
Jun 13 20:28:22 newsfeed overchan[1054]: input line too long, skipping
Jun 13 20:59:48 newsfeed overchan[1054]: input line too long, skipping
Jun 13 21:00:05 newsfeed overchan[1054]: input line too long, skipping
Jun 13 21:05:21 newsfeed nnrpd[25058]: SERVER perl filter not defined
Jun 13 21:27:48 newsfeed nnrpd[25809]: SERVER perl filter not defined
Jun 13 21:31:21 newsfeed nnrpd[26054]: SERVER perl filter not defined
Jun 13 21:33:24 newsfeed nnrpd[26079]: SERVER perl filter not defined
Jun 14 02:06:31 newsfeed nnrpd[11612]: SERVER perl filter not defined
Jun 14 02:07:51 newsfeed nnrpd[11619]: SERVER perl filter not defined
Jun 14 02:08:36 newsfeed nnrpd[11637]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2123896 97.4%242.0 MB 97.1%
innfeed 34009 1.6%4.0 MB 1.6%
innd 17333 0.8%2.8 MB 1.1%
nnrpd 4523 0.2%470.4 KB 0.2%
overchan 14 0.0%2.3 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 62179778 100.0%249.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2068657 62.3%
Negative hits 1087211 32.7%
Positive hits 163577 4.9%
Cache misses 1029 0.0%
TOTAL: 4 3320474 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.111 0.0%163 0.000 12.951 896.000
article cleanup00:00:27.827 0.0%2118442 0.008 0.013 0.019
article logging00:01:34.197 0.1%2119039 0.030 0.044 0.098
article parse00:41:15.717 3.1%96516099 0.008 0.026 0.038
article write00:14:50.128 1.1%2041484 0.260 0.436 0.692
artlog/artcncl00:00:00.003 0.0%161 0.000 0.019 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:29.916 0.3%109361016 0.000 0.002 0.004
hisgrep/artcncl00:00:00.398 0.0%152 0.000 2.618 16.000
hishave/artcncl00:00:00.084 0.0%163 0.000 0.515 5.556
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:59:11.949 4.4%3339628 0.126 1.064 8.708
history sync00:00:00.012 0.0%284 0.000 0.042 0.500
history write01:43:42.506 7.7%2043761 0.463 3.045 9.557
hiswrite/artcncl00:00:00.038 0.0%11 0.000 3.455 7.400
idle13:16:50.927 59.0%79839137 0.325 0.599 50063.000
nntp read01:06:27.720 4.9%95419727 0.022 0.042 0.063
overview write00:00:10.668 0.0%2041484 0.004 0.005 0.007
perl filter03:54:26.666 17.4%2043761 4.531 6.883 8.573
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:45.988 0.4%4395617 0.043 0.065 0.086
TOTAL: 22:30:10.35022:07:16.855 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.374 0.0%572440 0.000 0.002 0.006
article prepare00:00:00.015 0.0%61816 0.000 0.000 0.005
article read00:00:13.969 0.0%12962 0.056 1.078 50.353
backlog stats00:00:01.031 0.0%1655074 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:17.146 0.0%1067956 0.011 0.016 0.022
data write00:00:56.188 0.1%775557 0.035 0.072 0.218
idle22:18:29.537 99.8%1655074 32.172 48.523 267.308
status file00:00:12.626 0.0%14846 0.000 0.850 2.500
TOTAL: 22:20:55.62222:20:11.886 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:14.089 53.6%2888 0.000 4.878 30.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.242 0.9%6279 0.000 0.039 1.333
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:00:26.27300:00:14.331 54.5%----

Control commands to INND:

CommandNumber
L 1
flush 26
flushlogs 2
go 2
logmode 2
mode 144
name 5
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 190

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1023 20417501941489 31893 68368 95%377:26:35
2news.nask.pl 3 169838 101781 59328 8729 59%22:05:01
3news.icm.edu.pl 43 220 43 171 6 19%16:42:32
4localhost 12 11 11 0 0 100%00:00:00
TOTAL: 4 1081 22118192043324 91392 77103 92%416:14:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl511.5 GB24.7 GB24.7 GB560.8 GB 91%292.6 KB
2news.nask.pl35.1 GB2.3 GB2.4 GB39.7 GB 88%377.1 KB
3news.icm.edu.pl1002.6 KB0.0 KB103.6 KB1.1 MB 90%22.6 KB
4localhost15.1 KB0.0 KB0.0 KB15.1 KB100%1.4 KB
TOTAL: 4546.5 GB27.0 GB27.0 GB600.5 GB 91%297.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 13 04:15:02 - 04:59:59 31593 1.5% 11.719.3 GB 0.0%3603.97
Jun 13 05:00:00 - 05:59:59 69161 3.4% 19.2120.3 GB 5.5%5923.34
Jun 13 06:00:00 - 06:59:59 85612 4.2% 23.7823.7 GB 6.4%6902.48
Jun 13 07:00:00 - 07:59:59 90471 4.4% 25.1327.1 GB 7.3%7888.58
Jun 13 08:00:00 - 08:59:59 87822 4.3% 24.3925.0 GB 6.7%7279.36
Jun 13 09:00:00 - 09:59:59 127516 6.2% 35.4231.4 GB 8.5%9143.21
Jun 13 10:00:00 - 10:59:59 8067 0.4% 2.242.7 GB 0.7% 790.30
Jun 13 11:00:00 - 11:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 13 12:00:00 - 12:59:59 71445 3.5% 19.8518.9 GB 5.1%5517.24
Jun 13 13:00:00 - 13:59:59 133013 6.5% 36.9536.8 GB 9.9%10728.85
Jun 13 14:00:00 - 14:59:59 144463 7.1% 40.1336.9 GB 10.0%10760.53
Jun 13 15:00:00 - 15:59:59 83263 4.1% 23.1323.4 GB 6.3%6828.80
Jun 13 16:00:00 - 16:59:59 90512 4.4% 25.1425.2 GB 6.8%7327.43
Jun 13 17:00:00 - 17:59:59 102308 5.0% 28.4228.8 GB 7.8%8402.08
Jun 13 18:00:00 - 18:59:59 71747 3.5% 19.9320.2 GB 5.4%5871.71
Jun 13 19:00:00 - 19:59:59 65781 3.2% 18.2718.8 GB 5.1%5481.07
Jun 13 20:00:00 - 20:59:59 104347 5.1% 28.9923.9 GB 6.5%6974.25
Jun 13 21:00:00 - 21:59:59 112724 5.5% 31.3131.7 GB 8.6%9243.82
Jun 13 22:00:00 - 22:59:59 93285 4.6% 25.9126.7 GB 7.2%7767.39
Jun 13 23:00:00 - 23:59:59 111716 5.5% 31.0330.1 GB 8.1%8758.44
Jun 14 00:00:00 - 00:59:59 105656 5.2% 29.3517.8 GB 4.8%5185.19
Jun 14 01:00:00 - 01:59:59 90545 4.4% 25.1523.7 GB 6.4%6905.71
Jun 14 02:00:00 - 02:59:59 73393 3.6% 20.3919.2 GB 5.2%5599.23
Jun 14 03:00:00 - 03:59:59 76582 3.7% 21.2721.0 GB 5.7%6110.86
Jun 14 04:00:00 - 04:15:03 14922 0.7% 16.524.4 GB 1.2%5120.48
TOTAL: 24:00:01 2045944 100.0% 23.68371.0 GB 100.0%4502.42
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 68818 255 0 68155 0 0 0 0 408
2news.nask.pl 8958 19 0 6748 3 0 0 0 2188
3news.icm.edu.pl 15 0 0 0 0 0 0 0 15
TOTAL: 3 77791 274 0 74903 3 0 0 0 2611

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 106
it.tlc.cellulari.android 76
it.comp.os.win.windows10 38
comp.sys.raspberry-pi 23
nl.comp.os.linux.techniek 13
comp.mobile.android 10
it.politica.m5s 2
it.comp.os.win.windows7 2
it.comp.virtualizzazione 1
de.comp.lang.php 1
de.comp.lang.vbclassic 1
de.rec.sf.startrek 1
TOTAL: 12 274

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) 1769
Binary in non-binary group 133
Scoring filter (9) 30
EMP (phl) 24
Scoring filter (8) 18
Scoring filter (16) 11
Scoring filter (15) 5
Scoring filter (18) 4
Scoring filter (10) 4
Scoring filter (11) 3
EMP (fsl) 3
Scoring filter (14) 3
HTML post 2
Scoring filter (13) 1
Attached HTML file 1
TOTAL: 15 2011

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 366
news.nask.pl 226
news.icm.edu.pl 8
TOTAL: 3 600
TOTAL: 1 600

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 244255 8069 194622 13 0 3 3%21:56:45
2panorama 299037 1052 272563 106 2 306537 0%22:34:53
3icm 367561 169 302595 6003 0 10 0%21:56:45
4poznan 10947 116 7289 21 0 0 1%21:56:38
5okapi 0 0 0 0 0 1007 0%22:23:16
TOTAL: 5 921800 9406 777069 6143 2 307557 1%110:48:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.0 GB4.9 MB3.0 GB39.7 KB/s388.4 KB21:56:45
2panorama220.5 MB10.5 MB231.0 MB2.9 KB/s204.2 KB22:34:53
3icm21.1 MB2.2 GB2.2 GB29.7 KB/s380.0 KB21:56:45
4poznan856.4 KB117.7 KB974.1 KB0.0 KB/s7.1 KB21:56:38
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s022:23:16
TOTAL: 53.2 GB2.2 GB5.5 GB14.3 KB/s368.0 KB110:48:17
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 271 67.1 KB 3 0 000:00:19
2isvcs01.man.lodz.pl 11 00.0 KB 0 11 000:00:01
TOTAL: 2 282 67.1 KB 3 11 000:00:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 644 67.1 KB 3 11 000:00:25
TOTAL: 1 644 67.1 KB 3 11 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.580 4.072 0.00000:00:19
mon.man.lodz.pl 1.152 3.248 0.00000:00:03
david.man.lodz.pl 0.372 1.056 0.00000:00:01
isvcs01.man.lodz.pl 0.124 0.164 0.00000:00:01
TOTAL: 4 3.228 8.540 0.00000:00:25

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 272
david.man.lodz.pl 90
TOTAL: 2 362

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

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