Daily Usenet report

May 30 04:15:02 -- May 31 04:15:04

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

May 30 06:02:14 newsfeed overchan[26499]: input line too long, skipping
May 30 06:50:46 newsfeed overchan[26499]: input line too long, skipping
May 30 08:25:56 newsfeed overchan[26499]: input line too long, skipping
May 30 08:26:26 newsfeed overchan[26499]: input line too long, skipping
May 30 08:27:15 newsfeed overchan[26499]: input line too long, skipping
May 30 08:27:40 newsfeed overchan[26499]: input line too long, skipping
May 30 08:52:31 newsfeed overchan[26499]: input line too long, skipping
May 30 08:58:19 newsfeed overchan[26499]: input line too long, skipping
May 30 09:07:14 newsfeed overchan[26499]: input line too long, skipping
May 30 11:00:07 newsfeed nnrpd[10418]: SERVER perl filter not defined
May 30 12:29:43 newsfeed nnrpd[13798]: SERVER perl filter not defined
May 30 13:04:09 newsfeed nnrpd[15062]: SERVER perl filter not defined
May 30 14:45:52 newsfeed nnrpd[18933]: SERVER perl filter not defined
May 30 16:27:38 newsfeed nnrpd[22561]: SERVER perl filter not defined
May 30 17:12:36 newsfeed overchan[26499]: input line too long, skipping
May 30 17:29:37 newsfeed nnrpd[24941]: SERVER perl filter not defined
May 30 20:46:45 newsfeed overchan[26499]: input line too long, skipping
May 30 20:48:57 newsfeed overchan[26499]: input line too long, skipping
May 30 20:49:37 newsfeed overchan[26499]: input line too long, skipping
May 30 20:49:57 newsfeed overchan[26499]: input line too long, skipping
May 30 20:51:18 newsfeed overchan[26499]: input line too long, skipping
May 31 00:08:47 newsfeed nnrpd[7192]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2792460 97.3%324.5 MB 97.0%
innfeed 47518 1.7%5.6 MB 1.7%
innd 24757 0.9%3.9 MB 1.2%
nnrpd 4762 0.2%493.9 KB 0.1%
overchan 16 0.0%2.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62869514 100.0%334.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2770573 96.2%
Negative hits 96749 3.4%
Positive hits 13741 0.5%
Cache misses 119 0.0%
TOTAL: 4 2881182 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.687 0.0%224 0.000 11.996 405.500
article cleanup00:00:31.660 0.0%2793301 0.008 0.011 0.017
article logging00:01:39.227 0.1%2793937 0.025 0.036 0.124
article parse01:03:34.176 4.4%256347079 0.010 0.015 0.037
article write00:29:21.519 2.0%2784273 0.367 0.633 3.455
artlog/artcncl00:00:00.004 0.0%196 0.000 0.020 0.333
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:02:38.596 0.2%275034626 0.000 0.001 0.001
hisgrep/artcncl00:00:00.421 0.0%206 0.000 2.044 17.000
hishave/artcncl00:00:00.191 0.0%224 0.000 0.853 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:06.383 2.8%2901037 0.064 0.829 4.538
history sync00:00:00.011 0.0%290 0.000 0.038 1.000
history write01:43:04.474 7.2%2789752 0.201 2.217 7.562
hiswrite/artcncl00:00:00.062 0.0%18 0.000 3.444 6.750
idle13:01:33.586 54.3%180911047 0.166 0.259 0.442
nntp read01:17:37.635 5.4%254194390 0.012 0.018 0.033
overview write00:00:13.201 0.0%2784273 0.003 0.005 0.007
perl filter04:51:34.901 20.2%2789749 4.450 6.271 8.199
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:52.308 0.3%5615825 0.031 0.041 0.060
TOTAL: 24:00:02.24423:15:51.042 96.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.291 0.0%109916 0.000 0.003 0.016
article prepare00:00:00.027 0.0%107594 0.000 0.000 0.019
article read00:00:50.352 0.1%26878 0.000 1.873 277.833
backlog stats00:00:00.250 0.0%309387 0.000 0.001 0.003
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:03.303 0.0%165107 0.005 0.020 0.054
data write00:00:25.497 0.0%142776 0.016 0.179 0.451
idle23:52:16.166 99.9%309387 24.710 277.763 851.044
status file00:00:12.026 0.0%16419 0.492 0.732 1.292
TOTAL: 23:54:06.49723:53:47.912100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:16.253 55.7%3045 0.000 5.338 54.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.132 0.5%6658 0.000 0.020 0.500
readart00:00:00.002 0.0%18 0.000 0.111 0.500
TOTAL: 00:00:29.15400:00:16.387 56.2%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1181 27822942772156 6588 3550 99%431:37:40
2news.nask.pl 2 19117 10347 3304 5466 54%24:00:10
3news.icm.edu.pl 39 327 30 279 18 9%18:35:44
4localhost 8 7 7 0 0 100%00:00:00
TOTAL: 4 1230 28017452782540 10171 9034 99%474:13:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl924.8 GB44.4 MB61.6 MB924.9 GB 99%349.4 KB
2news.nask.pl72.8 MB520.9 KB32.7 MB106.0 MB 68%6.9 KB
3news.icm.edu.pl771.2 KB115.1 KB538.9 KB1.4 MB 54%29.7 KB
4localhost11.3 KB0.0 KB0.0 KB11.3 KB100%1.6 KB
TOTAL: 4924.9 GB45.0 MB94.7 MB925.0 GB 99%347.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 30 04:15:02 - 04:59:59 92753 3.3% 34.3832.0 GB 3.5%12437.79
May 30 05:00:00 - 05:59:59 103520 3.7% 28.7635.1 GB 3.8%10221.50
May 30 06:00:00 - 06:59:59 90211 3.2% 25.0631.1 GB 3.4%9069.50
May 30 07:00:00 - 07:59:59 93695 3.4% 26.0331.2 GB 3.4%9083.71
May 30 08:00:00 - 08:59:59 74601 2.7% 20.7225.5 GB 2.8%7422.49
May 30 09:00:00 - 09:59:59 95398 3.4% 26.5031.5 GB 3.4%9185.55
May 30 10:00:00 - 10:59:59 100507 3.6% 27.9232.8 GB 3.5%9552.59
May 30 11:00:00 - 11:59:59 114181 4.1% 31.7235.4 GB 3.8%10320.61
May 30 12:00:00 - 12:59:59 126673 4.6% 35.1940.3 GB 4.4%11751.37
May 30 13:00:00 - 13:59:59 123551 4.4% 34.3239.7 GB 4.3%11551.60
May 30 14:00:00 - 14:59:59 127599 4.6% 35.4441.1 GB 4.5%11982.31
May 30 15:00:00 - 15:59:59 127434 4.6% 35.4042.4 GB 4.6%12347.75
May 30 16:00:00 - 16:59:59 122887 4.4% 34.1441.4 GB 4.5%12072.27
May 30 17:00:00 - 17:59:59 128021 4.6% 35.5640.7 GB 4.4%11846.73
May 30 18:00:00 - 18:59:59 125860 4.5% 34.9641.3 GB 4.5%12042.49
May 30 19:00:00 - 19:59:59 123278 4.4% 34.2441.7 GB 4.5%12137.13
May 30 20:00:00 - 20:59:59 124280 4.5% 34.5241.5 GB 4.5%12092.03
May 30 21:00:00 - 21:59:59 121712 4.4% 33.8141.2 GB 4.5%11993.60
May 30 22:00:00 - 22:59:59 126521 4.5% 35.1442.9 GB 4.6%12483.35
May 30 23:00:00 - 23:59:59 131779 4.7% 36.6141.5 GB 4.5%12089.05
May 31 00:00:00 - 00:59:59 108130 3.9% 30.0435.7 GB 3.9%10412.88
May 31 01:00:00 - 01:59:59 126984 4.6% 35.2743.2 GB 4.7%12593.95
May 31 02:00:00 - 02:59:59 129442 4.7% 35.9644.0 GB 4.8%12822.50
May 31 03:00:00 - 03:59:59 114675 4.1% 31.8540.1 GB 4.3%11675.79
May 31 04:00:00 - 04:15:04 28897 1.0% 31.9710.6 GB 1.1%12307.06
TOTAL: 24:00:02 2782589 100.0% 32.21924.1 GB 100.0%11214.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 5713 13 0 212 4 0 0 0 5484
2newsfeed.pionier.net.pl 3944 55 0 3343 2 0 0 0 544
3news.icm.edu.pl 18 0 0 3 0 0 0 0 15
TOTAL: 3 9675 68 0 3558 6 0 0 0 6043

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 29
comp.sys.raspberry-pi 7
it.tlc.cellulari.android 6
comp.mobile.android 6
it.comp.os.win.windows10 5
de.comp.lang.vbclassic 3
uk.net.providers.gradwell 3
nl.comp.os.linux.techniek 3
nl.comp.sys.android 2
hr.alt.cellular.gsm.android 2
nl.wetenschap.regulier 1
hr.rec.glazba.hifi 1
TOTAL: 12 68

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) 4869
Binary in non-binary group 251
EMP (phl) 174
Scoring filter (8) 35
EMP (fsl) 18
Scoring filter (10) 13
Poison newsgroup 11
HTML post 10
Scoring filter (9) 10
Too many newsgroups 10
Scoring filter (11) 1
Scoring filter (19) 1
Scoring filter (12) 1
TOTAL: 13 5404

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 387
news.nask.pl 247
news.icm.edu.pl 2
TOTAL: 3 636
TOTAL: 1 636

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 53251 20088 21613 5009 0 0 37%24:00:00
2panorama 67256 618 39000 294 9 70236 0%24:00:00
3poznan 16031 292 9904 11 0 1 1%23:59:46
4nask 6899 12 4657 0 0 0 0%24:00:00
5okapi 0 0 0 0 0 2340 0%23:57:52
TOTAL: 5 143437 21010 75174 5314 9 72577 14%119:57:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.6 GB1.6 GB5.2 GB62.5 KB/s215.3 KB24:00:00
2panorama1.9 MB1.7 MB3.6 MB0.0 KB/s4.0 KB24:00:00
3poznan1.2 MB48.8 KB1.2 MB0.0 KB/s4.2 KB23:59:46
4nask24.2 KB0.0 KB24.2 KB0.0 KB/s2.0 KB24:00:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 53.6 GB1.6 GB5.2 GB12.5 KB/s205.5 KB119:57:38
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 288 1814.5 KB 9 0 000:00:21
2isvcs01.man.lodz.pl 7 00.0 KB 0 7 000:00:01
TOTAL: 2 295 1814.5 KB 9 7 000:00:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 675 1814.5 KB 9 7 000:00:28
TOTAL: 1 675 1814.5 KB 9 7 000:00:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.064 4.016 0.00000:00:21
mon.man.lodz.pl 0.952 4.108 0.00000:00:04
david.man.lodz.pl 0.380 1.224 0.00000:00:01
isvcs01.man.lodz.pl 0.036 0.120 0.00000:00:01
TOTAL: 4 2.432 9.468 0.00000:00:28

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 284
david.man.lodz.pl 96
TOTAL: 2 380

Newsgroup request counts (by category):

CategoryCountPct
1pl 18100.0%
TOTAL: 1 18100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 10
2pl.comp.pecet 8
TOTAL: 2 18