Daily Usenet report

Oct 28 04:15:03 -- Oct 29 04:15:03

Unknown entries from news log file:

First 24 / 24 lines (100.0%)

Oct 28 06:55:25 newsfeed overchan[7963]: input line too long, skipping
Oct 28 07:09:26 newsfeed overchan[7963]: input line too long, skipping
Oct 28 07:10:24 newsfeed overchan[7963]: input line too long, skipping
Oct 28 07:12:06 newsfeed overchan[7963]: input line too long, skipping
Oct 28 08:42:39 newsfeed nnrpd[17863]: SERVER perl filter not defined
Oct 28 09:16:29 newsfeed overchan[7963]: input line too long, skipping
Oct 28 09:19:14 newsfeed overchan[7963]: input line too long, skipping
Oct 28 11:23:14 newsfeed overchan[7963]: input line too long, skipping
Oct 28 12:48:34 newsfeed nnrpd[26427]: SERVER perl filter not defined
Oct 28 13:39:08 newsfeed nnrpd[28192]: SERVER perl filter not defined
Oct 28 14:15:25 newsfeed nnrpd[29522]: SERVER perl filter not defined
Oct 28 14:16:18 newsfeed nnrpd[29528]: SERVER perl filter not defined
Oct 28 14:17:11 newsfeed nnrpd[29539]: SERVER perl filter not defined
Oct 28 14:17:49 newsfeed nnrpd[29551]: SERVER perl filter not defined
Oct 28 15:40:33 newsfeed overchan[7963]: input line too long, skipping
Oct 28 18:25:40 newsfeed overchan[7963]: input line too long, skipping
Oct 28 20:55:02 newsfeed nnrpd[11600]: SERVER perl filter not defined
Oct 28 21:54:07 newsfeed overchan[7963]: input line too long, skipping
Oct 28 21:56:32 newsfeed overchan[7963]: input line too long, skipping
Oct 29 01:08:29 newsfeed overchan[7963]: input line too long, skipping
Oct 29 01:17:01 newsfeed overchan[7963]: input line too long, skipping
Oct 29 01:41:36 newsfeed overchan[7963]: input line too long, skipping
Oct 29 02:02:36 newsfeed overchan[7963]: input line too long, skipping
Oct 29 02:04:36 newsfeed overchan[7963]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2706710 98.1%313.4 MB 97.9%
innfeed 28632 1.0%3.4 MB 1.1%
innd 17716 0.6%2.9 MB 0.9%
nnrpd 4933 0.2%524.4 KB 0.2%
overchan 17 0.0%3.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62758009 100.0%320.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2681644 95.7%
Negative hits 65765 2.3%
Positive hits 52859 1.9%
Cache misses 574 0.0%
TOTAL: 4 2800842 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.753 0.0%69 0.000 54.391 447.000
article cleanup00:00:39.386 0.0%2709220 0.011 0.015 0.019
article logging00:02:26.984 0.2%2709672 0.037 0.054 0.146
article parse00:55:06.714 3.8%79770113 0.019 0.041 0.061
article write00:21:47.599 1.5%2702221 0.323 0.484 0.710
artlog/artcncl00:00:00.004 0.0%69 0.000 0.058 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:59.816 0.3%93920910 0.001 0.003 0.004
hisgrep/artcncl00:00:00.782 0.0%69 0.000 11.333 61.000
hishave/artcncl00:00:00.374 0.0%69 0.000 5.420 29.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:42:35.643 11.3%2825025 1.169 3.453 8.601
history sync00:00:00.017 0.0%290 0.000 0.059 1.000
history write04:59:14.901 20.8%2703991 3.667 6.640 12.541
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle07:33:14.541 31.5%47430328 0.099 0.573 1.369
nntp read01:15:00.664 5.2%77614376 0.037 0.058 0.079
overview write00:00:16.014 0.0%2702221 0.004 0.006 0.008
perl filter05:29:21.432 22.9%2703990 5.481 7.308 10.325
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:53.818 0.5%5532474 0.050 0.075 0.112
TOTAL: 24:00:02.96823:30:42.442 98.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.904 0.0%244789 0.000 0.004 0.017
article prepare00:00:00.088 0.0%317828 0.000 0.000 0.001
article read00:01:15.584 0.1%68524 0.000 1.103 61.333
backlog stats00:00:01.316 0.0%1117239 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:12.563 0.0%492269 0.007 0.026 0.121
data write00:04:11.062 0.3%649133 0.034 0.387 0.596
idle23:47:55.610 99.5%1117239 16.059 76.685 2164.853
status file00:00:13.175 0.0%10150 0.783 1.298 6.750
TOTAL: 23:54:30.53923:53:50.302100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:07.856 88.2%3115 0.000 41.045 27039.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.386 0.3%6922 0.000 0.056 1.333
readart00:00:00.102 0.1%74 0.000 1.378 42.500
TOTAL: 00:02:25.01600:02:08.344 88.5%----

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 479 26980272693894 1378 2755 99%524:34:33
2news.nask.pl 2 54038 5083 44775 4180 9%24:06:01
3news.icm.edu.pl 47 208 35 133 40 16%14:21:52
4localhost 9 8 8 0 0 100%00:00:01
TOTAL: 4 537 27522812699020 46286 6975 98%563:02:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl760.8 GB71.5 MB93.6 MB760.9 GB 99%295.9 KB
2news.nask.pl610.9 MB441.7 MB453.2 MB1.5 GB 40%166.5 KB
3news.icm.edu.pl780.5 KB105.6 KB2.6 MB3.4 MB 22%46.8 KB
4localhost12.5 KB0.0 KB0.0 KB12.5 KB100%1.6 KB
TOTAL: 4761.4 GB513.3 MB549.3 MB762.4 GB 99%295.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 28 04:15:03 - 04:59:59 87661 3.2% 32.5025.8 GB 3.4%10015.22
Oct 28 05:00:00 - 05:59:59 110326 4.1% 30.6536.2 GB 4.8%10543.71
Oct 28 06:00:00 - 06:59:59 85125 3.2% 23.6528.9 GB 3.8%8431.81
Oct 28 07:00:00 - 07:59:59 100284 3.7% 27.8630.6 GB 4.0%8898.92
Oct 28 08:00:00 - 08:59:59 82427 3.1% 22.9027.8 GB 3.7%8107.51
Oct 28 09:00:00 - 09:59:59 93372 3.5% 25.9424.6 GB 3.2%7170.95
Oct 28 10:00:00 - 10:59:59 130817 4.8% 36.3434.7 GB 4.6%10116.65
Oct 28 11:00:00 - 11:59:59 148880 5.5% 41.3638.3 GB 5.0%11145.83
Oct 28 12:00:00 - 12:59:59 123575 4.6% 34.3331.3 GB 4.1%9115.42
Oct 28 13:00:00 - 13:59:59 122873 4.6% 34.1335.3 GB 4.6%10286.80
Oct 28 14:00:00 - 14:59:59 163741 6.1% 45.4836.8 GB 4.8%10704.38
Oct 28 15:00:00 - 15:59:59 135142 5.0% 37.5429.9 GB 3.9%8719.23
Oct 28 16:00:00 - 16:59:59 134453 5.0% 37.3529.9 GB 3.9%8722.15
Oct 28 17:00:00 - 17:59:59 114889 4.3% 31.9130.2 GB 4.0%8805.96
Oct 28 18:00:00 - 18:59:59 129962 4.8% 36.1037.5 GB 4.9%10917.50
Oct 28 19:00:00 - 19:59:59 116961 4.3% 32.4936.8 GB 4.8%10727.19
Oct 28 20:00:00 - 20:59:59 118213 4.4% 32.8440.4 GB 5.3%11767.85
Oct 28 21:00:00 - 21:59:59 120416 4.5% 33.4536.1 GB 4.7%10514.41
Oct 28 22:00:00 - 22:59:59 95749 3.5% 26.6024.1 GB 3.2%7021.62
Oct 28 23:00:00 - 23:59:59 91471 3.4% 25.4126.9 GB 3.5%7827.80
Oct 29 00:00:00 - 00:59:59 90934 3.4% 25.2625.5 GB 3.4%7438.66
Oct 29 01:00:00 - 01:59:59 85445 3.2% 23.7326.2 GB 3.4%7625.37
Oct 29 02:00:00 - 02:59:59 82565 3.1% 22.9324.1 GB 3.2%7017.08
Oct 29 03:00:00 - 03:59:59 106621 4.0% 29.6234.3 GB 4.5%9986.86
Oct 29 04:00:00 - 04:15:03 27279 1.0% 30.219.1 GB 1.2%10568.83
TOTAL: 24:00:00 2699181 100.0% 31.24761.4 GB 100.0%9240.32
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4314 7 0 2753 1 0 0 0 1553
2newsfeed.pionier.net.pl 3105 118 0 2479 0 0 0 0 508
3news.icm.edu.pl 41 0 0 9 0 0 0 0 32
TOTAL: 3 7460 125 0 5241 1 0 0 0 2093

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 85
comp.mobile.android 17
it.comp.os.win.windows10 9
it.tlc.cellulari.android 8
de.comp.lang.vbclassic 2
it.comp.os.win.windows7 2
it.comp.os.win.windows8 1
hr.ponuda.hardver.komponente 1
TOTAL: 8 125

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1375
Binary in non-binary group 164
EMP (phl) 54
Scoring filter (16) 19
Scoring filter (9) 10
Scoring filter (10) 6
Scoring filter (8) 5
EMP (fsl) 3
Scoring filter (11) 2
Too many newsgroups 1
Scoring filter (18) 1
TOTAL: 11 1640

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 348
news.nask.pl 103
news.icm.edu.pl 1
TOTAL: 3 452
TOTAL: 1 452

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 151967 67045 51539 131 0 1336 44%23:59:57
2panorama 124027 1532 105481 97 2 139734 1%23:59:58
3icm 147846 39 117463 11889 0 1 0%23:59:58
4poznan 5325 28 3861 7 0 0 0%23:59:58
5okapi 0 0 0 0 0 1159 0%23:57:51
TOTAL: 5 429165 68644 278344 12124 2 142230 15%119:57:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask32.0 GB51.5 MB32.1 GB389.5 KB/s501.0 KB23:59:57
2panorama619.9 MB28.5 MB648.4 MB7.7 KB/s407.6 KB23:59:58
3icm4.4 MB5.5 GB5.6 GB67.4 KB/s488.1 KB23:59:58
4poznan106.3 KB53.5 KB159.8 KB0.0 KB/s4.6 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 532.7 GB5.6 GB38.3 GB92.9 KB/s497.0 KB119:57:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 7480.3 KB 33 0 000:00:26
2isvcs01.man.lodz.pl 8 00.0 KB 0 8 000:00:02
TOTAL: 2 296 7480.3 KB 33 8 000:02:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 584 7480.3 KB 33 8 000:00:33
2unresolved 97 00.0 KB 0 0 000:01:50
TOTAL: 2 681 7480.3 KB 33 8 000:02:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195.230.113.30 0.032 0.028 0.00000:01:48
web.man.lodz.pl 1.780 5.956 0.00000:00:26
mon.man.lodz.pl 1.532 5.644 0.00000:00:04
isvcs01.man.lodz.pl 0.060 0.168 0.00000:00:02
212.51.192.185 0.584 2.040 0.00000:00:01
TOTAL: 5 3.988 13.836 0.00000:02:23

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
195.230.113.30 1
TOTAL: 3 385

Newsgroup request counts (by category):

CategoryCountPct
1pl 74100.0%
TOTAL: 1 74100.0%

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

NewsgroupCount
1pl.comp.pecet 62
2pl.comp.os.ms-windows.winnt 12
TOTAL: 2 74