Daily Usenet report

Jun 9 04:15:02 -- Jun 10 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Jun 9 09:46:40 newsfeed overchan[6507]: input line too long, skipping
Jun 9 13:44:21 newsfeed overchan[6507]: input line too long, skipping
Jun 9 13:44:36 newsfeed overchan[6507]: input line too long, skipping
Jun 9 16:24:16 newsfeed overchan[6507]: input line too long, skipping
Jun 9 16:42:33 newsfeed overchan[6507]: input line too long, skipping
Jun 9 17:06:11 newsfeed overchan[6507]: input line too long, skipping
Jun 9 17:22:55 newsfeed overchan[6507]: input line too long, skipping
Jun 9 17:33:09 newsfeed overchan[6507]: input line too long, skipping
Jun 9 17:53:13 newsfeed overchan[6507]: input line too long, skipping
Jun 9 19:52:32 newsfeed overchan[6507]: input line too long, skipping
Jun 9 19:59:33 newsfeed overchan[6507]: input line too long, skipping
Jun 9 20:31:30 newsfeed overchan[6507]: input line too long, skipping
Jun 9 20:34:30 newsfeed overchan[6507]: input line too long, skipping
Jun 9 20:39:54 newsfeed overchan[6507]: input line too long, skipping
Jun 9 23:41:54 newsfeed overchan[6507]: input line too long, skipping
Jun 9 23:42:45 newsfeed overchan[6507]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2626961 97.5%300.3 MB 97.1%
innfeed 45469 1.7%5.4 MB 1.7%
innd 17209 0.6%2.9 MB 1.0%
nnrpd 4899 0.2%526.3 KB 0.2%
overchan 17 0.0%2.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62694556 100.0%309.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2552041 71.4%
Negative hits 875407 24.5%
Positive hits 147734 4.1%
Cache misses 310 0.0%
TOTAL: 4 3575492 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.013 0.0%254 0.000 3.988 63.375
article cleanup00:00:32.907 0.0%2625773 0.008 0.013 0.018
article logging00:02:01.234 0.1%2626241 0.028 0.046 0.174
article parse00:44:29.387 3.1%139298977 0.008 0.019 0.031
article write00:15:46.137 1.1%2551548 0.166 0.371 0.632
artlog/artcncl00:00:00.010 0.0%252 0.000 0.040 0.500
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:04:45.164 0.3%155063882 0.001 0.002 0.003
hisgrep/artcncl00:00:00.300 0.0%144 0.000 2.083 22.875
hishave/artcncl00:00:00.035 0.0%254 0.000 0.138 1.625
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:58.679 2.2%3578413 0.080 0.519 2.556
history sync00:00:00.027 0.0%290 0.000 0.093 1.000
history write02:17:17.446 9.5%2553450 0.259 3.226 14.291
hiswrite/artcncl00:00:00.041 0.0%110 0.000 0.373 2.000
idle13:40:09.379 57.0%118770923 0.220 0.414 2.296
nntp read01:25:12.824 5.9%137739202 0.020 0.037 0.053
overview write00:00:12.624 0.0%2551548 0.003 0.005 0.007
perl filter04:15:59.348 17.8%2553446 3.326 6.015 8.372
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:26.499 0.4%5366766 0.038 0.061 0.089
TOTAL: 24:00:01.08423:22:53.054 97.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.378 0.0%566498 0.000 0.002 0.006
article prepare00:00:00.012 0.0%71596 0.000 0.000 0.009
article read00:01:02.088 0.1%14942 0.000 4.155 59.363
backlog stats00:00:00.950 0.0%1509871 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:14.685 0.0%934463 0.004 0.016 0.024
data write00:00:52.829 0.1%691048 0.032 0.076 0.393
idle23:49:05.468 99.8%1509871 25.223 56.790 768.819
status file00:00:15.792 0.0%16887 0.558 0.935 5.317
TOTAL: 23:52:11.19123:51:33.202100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:38.116 92.2%3139 0.000 50.371 9767.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.258 0.2%6893 0.000 0.037 1.333
readart00:00:00.001 0.0%12 0.000 0.083 0.500
TOTAL: 00:02:51.58300:02:38.375 92.3%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 378 25502862456919 26529 66838 96%328:29:41
2news.nask.pl 2 151404 94812 49198 7394 62%24:03:47
3news.icm.edu.pl 46 217 30 171 16 13%16:12:01
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 427 27019072551761 75898 74248 94%368:45:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl618.3 GB23.7 GB23.7 GB665.6 GB 92%276.6 KB
2news.nask.pl32.5 GB2.0 GB2.0 GB36.5 GB 89%374.5 KB
3news.icm.edu.pl645.3 KB0.0 KB1.1 MB1.7 MB 37%37.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4650.8 GB25.6 GB25.7 GB702.1 GB 92%280.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 9 04:15:02 - 04:59:59 45576 1.8% 16.8913.8 GB 2.1%5352.59
Jun 9 05:00:00 - 05:59:59 83202 3.3% 23.1123.2 GB 3.6%6747.54
Jun 9 06:00:00 - 06:59:59 80465 3.2% 22.3519.9 GB 3.1%5786.54
Jun 9 07:00:00 - 07:59:59 117903 4.6% 32.7530.4 GB 4.7%8866.01
Jun 9 08:00:00 - 08:59:59 114209 4.5% 31.7231.3 GB 4.8%9117.34
Jun 9 09:00:00 - 09:59:59 82595 3.2% 22.9423.0 GB 3.5%6690.95
Jun 9 10:00:00 - 10:59:59 71684 2.8% 19.9123.0 GB 3.5%6701.04
Jun 9 11:00:00 - 11:59:59 91184 3.6% 25.3326.5 GB 4.1%7731.43
Jun 9 12:00:00 - 12:59:59 140720 5.5% 39.0932.1 GB 4.9%9362.62
Jun 9 13:00:00 - 13:59:59 123011 4.8% 34.1722.8 GB 3.5%6626.42
Jun 9 14:00:00 - 14:59:59 138031 5.4% 38.3431.5 GB 4.8%9188.72
Jun 9 15:00:00 - 15:59:59 110539 4.3% 30.7132.2 GB 5.0%9391.97
Jun 9 16:00:00 - 16:59:59 107541 4.2% 29.8732.3 GB 5.0%9412.05
Jun 9 17:00:00 - 17:59:59 104189 4.1% 28.9428.7 GB 4.4%8361.59
Jun 9 18:00:00 - 18:59:59 89179 3.5% 24.7724.5 GB 3.8%7145.79
Jun 9 19:00:00 - 19:59:59 98564 3.9% 27.3827.5 GB 4.2%8023.17
Jun 9 20:00:00 - 20:59:59 133627 5.2% 37.1236.3 GB 5.6%10578.85
Jun 9 21:00:00 - 21:59:59 95135 3.7% 26.4325.4 GB 3.9%7405.84
Jun 9 22:00:00 - 22:59:59 96381 3.8% 26.7726.9 GB 4.1%7835.34
Jun 9 23:00:00 - 23:59:59 108451 4.2% 30.1329.8 GB 4.6%8676.49
Jun 10 00:00:00 - 00:59:59 174207 6.8% 48.3924.8 GB 3.8%7230.53
Jun 10 01:00:00 - 01:59:59 113537 4.4% 31.5425.7 GB 4.0%7493.73
Jun 10 02:00:00 - 02:59:59 119142 4.7% 33.0931.1 GB 4.8%9051.08
Jun 10 03:00:00 - 03:59:59 98227 3.8% 27.2924.6 GB 3.8%7172.82
Jun 10 04:00:00 - 04:15:02 14720 0.6% 16.323.0 GB 0.5%3506.62
TOTAL: 24:00:00 2552019 100.0% 29.54650.6 GB 100.0%7895.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 67146 132 0 66665 1 0 0 0 348
2news.nask.pl 7527 2 0 5656 5 0 0 0 1864
3news.icm.edu.pl 17 0 0 0 0 0 0 0 17
TOTAL: 3 74690 134 0 72321 6 0 0 0 2229

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 95
it.tlc.cellulari.android 21
it.comp.os.win.windows10 9
comp.mobile.android 5
it.comp.os.win.windows7 2
uk.rec.cycling.moderated 1
hr.ponuda.hardver.komponente 1
TOTAL: 7 134

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1551
Binary in non-binary group 82
EMP (phl) 69
Scoring filter (8) 19
Scoring filter (9) 17
Too many newsgroups 4
HTML post 4
Scoring filter (13) 3
Scoring filter (16) 3
Scoring filter (10) 2
EMP (fsl) 1
Scoring filter (18) 1
Scoring filter (11) 1
TOTAL: 13 1757

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 3
TOTAL: 1 3
Including strange strings
newsfeed.pionier.net.pl 302
news.nask.pl 165
news.icm.edu.pl 1
TOTAL: 3 468
TOTAL: 2 471

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 199936 8152 155598 8 0 1 4%23:59:58
2panorama 317017 2606 285332 223 8 278663 0%23:59:58
3icm 326037 1624 256709 5045 0 1 0%23:59:58
4poznan 11040 98 6944 7 0 0 0%23:59:58
5okapi 0 0 0 0 0 842 0%23:57:50
TOTAL: 5 854030 12480 704583 5283 8 279507 1%119:57:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.0 GB2.7 MB3.0 GB36.7 KB/s388.3 KB23:59:58
2panorama877.8 MB63.0 MB940.8 MB11.2 KB/s340.6 KB23:59:58
3icm542.1 MB1.9 GB2.4 GB29.1 KB/s376.5 KB23:59:58
4poznan749.5 KB40.3 KB789.8 KB0.0 KB/s7.5 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 54.4 GB1.9 GB6.3 GB15.4 KB/s374.0 KB119:57:42
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 288 1215.0 KB 5 0 000:00:25
TOTAL: 1 288 1215.0 KB 5 0 000:02:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 1215.0 KB 5 0 000:00:30
2*.static.corbina.ru 15 00.0 KB 0 0 000:02:10
3unresolved 1 00.0 KB 0 0 000:00:09
TOTAL: 3 688 1215.0 KB 5 0 000:02:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
0890788407.static.corbina.ru 0.084 0.300 0.00000:02:10
web.man.lodz.pl 1.564 5.020 0.00000:00:25
107.170.231.128 0.004 0.008 0.00000:00:09
mon.man.lodz.pl 1.272 5.088 0.00000:00:03
david.man.lodz.pl 0.384 1.768 0.00000:00:01
TOTAL: 5 3.308 12.184 0.00000:02:50

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
0890788407.static.corbina.ru 15
107.170.231.128 1
TOTAL: 4 400

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 12
TOTAL: 1 12