Daily Usenet report

May 30 04:15:06 -- May 31 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

May 30 09:59:12 newsfeed overchan[5288]: input line too long, skipping
May 30 10:00:08 newsfeed overchan[5288]: input line too long, skipping
May 30 10:04:46 newsfeed nnrpd[18673]: SERVER perl filter not defined
May 30 14:04:22 newsfeed overchan[5288]: input line too long, skipping
May 30 14:04:38 newsfeed overchan[5288]: input line too long, skipping
May 30 14:18:18 newsfeed nnrpd[28018]: SERVER perl filter not defined
May 30 15:34:05 newsfeed overchan[5288]: input line too long, skipping
May 30 15:54:23 newsfeed overchan[5288]: input line too long, skipping
May 30 16:01:59 newsfeed overchan[5288]: input line too long, skipping
May 30 18:25:26 newsfeed nnrpd[4640]: SERVER perl filter not defined
May 30 18:27:49 newsfeed nnrpd[4648]: SERVER perl filter not defined
May 30 20:39:34 newsfeed overchan[5288]: input line too long, skipping
May 30 21:12:44 newsfeed overchan[5288]: input line too long, skipping
May 30 21:13:15 newsfeed overchan[5288]: input line too long, skipping
May 30 22:45:14 newsfeed nnrpd[2794]: SERVER perl filter not defined
May 30 23:04:44 newsfeed nnrpd[31788]: SERVER perl filter not defined
May 31 01:57:29 newsfeed overchan[1550]: input line too long, skipping
May 31 01:57:50 newsfeed overchan[1550]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2759634 97.5%317.0 MB 97.1%
innfeed 45310 1.6%5.4 MB 1.6%
innd 21689 0.8%3.6 MB 1.1%
nnrpd 5014 0.2%534.6 KB 0.2%
overchan 13 0.0%1.8 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 62831662 100.0%326.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2658631 66.9%
Negative hits 1125382 28.3%
Positive hits 189585 4.8%
Cache misses 448 0.0%
TOTAL: 4 3974046 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.238 0.0%140 0.000 23.129 956.000
article cleanup00:00:32.909 0.0%2759435 0.009 0.012 0.015
article logging00:02:04.243 0.1%2760014 0.034 0.045 0.239
article parse00:45:51.264 3.2%91741083 0.017 0.030 0.041
article write00:17:13.502 1.2%2662322 0.177 0.388 0.601
artlog/artcncl00:00:01.468 0.0%140 0.000 10.486 734.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:04:25.031 0.3%107723462 0.001 0.002 0.003
hisgrep/artcncl00:00:00.361 0.0%140 0.000 2.579 15.000
hishave/artcncl00:00:00.064 0.0%140 0.000 0.457 1.357
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:39:53.059 2.8%3988364 0.123 0.600 1.734
history sync00:00:00.017 0.0%289 0.000 0.059 1.000
history write02:03:10.823 8.6%2665568 0.523 2.773 9.145
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle13:51:43.683 57.8%72484174 0.423 0.688 1.931
nntp read01:05:21.438 4.5%90273091 0.027 0.043 0.056
overview write00:00:13.555 0.0%2662322 0.003 0.005 0.008
perl filter04:36:48.295 19.2%2665566 3.513 6.231 8.200
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:58.003 0.4%5673021 0.043 0.063 0.077
TOTAL: 24:00:03.82923:33:20.953 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.566 0.0%681033 0.000 0.002 0.006
article prepare00:00:00.022 0.0%105708 0.000 0.000 0.028
article read00:00:34.468 0.0%22295 0.000 1.546 125.000
backlog stats00:00:01.221 0.0%1934970 0.000 0.001 0.001
callbacks00:00:00.000 0.0%5 0.000 0.000 0.000
data read00:00:19.092 0.0%1206622 0.010 0.016 0.022
data write00:01:07.156 0.1%893377 0.037 0.075 0.176
idle23:47:46.565 99.8%1934970 27.445 44.273 212.920
status file00:00:18.443 0.0%17317 0.664 1.065 8.603
TOTAL: 23:50:55.39723:50:08.533 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:14.637 90.2%3575 0.000 54.444 859.100
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.276 0.1%8171 0.000 0.034 0.667
readart00:00:02.978 1.4%375 0.000 7.941 9.860
TOTAL: 00:03:35.81200:03:17.891 91.7%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1064 26601602542569 29908 87683 95%478:22:42
2news.nask.pl 11 193486 117638 66635 9213 60%25:44:23
3news.icm.edu.pl 39 217 45 154 18 20%16:28:47
4localhost 7 6 6 0 0 100%00:00:01
TOTAL: 4 1121 28538692660258 96697 96914 93%520:35:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl625.8 GB30.8 GB30.9 GB687.5 GB 91%274.1 KB
2news.nask.pl39.8 GB2.4 GB2.4 GB44.6 GB 89%368.7 KB
3news.icm.edu.pl923.2 KB27.2 KB485.0 KB1.4 MB 64%22.8 KB
4localhost9.2 KB0.0 KB0.0 KB9.2 KB100%1.5 KB
TOTAL: 4665.6 GB33.2 GB33.3 GB732.1 GB 90%278.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 30 04:15:06 - 04:59:59 72093 2.7% 26.7621.9 GB 3.3%8538.88
May 30 05:00:00 - 05:59:59 104397 3.9% 29.0033.8 GB 5.1%9845.99
May 30 06:00:00 - 06:59:59 104986 3.9% 29.1632.1 GB 4.8%9341.48
May 30 07:00:00 - 07:59:59 122340 4.6% 33.9816.9 GB 2.5%4922.25
May 30 08:00:00 - 08:59:59 125879 4.7% 34.9724.2 GB 3.6%7047.72
May 30 09:00:00 - 09:59:59 111507 4.2% 30.9730.4 GB 4.6%8863.38
May 30 10:00:00 - 10:59:59 129917 4.9% 36.0936.5 GB 5.5%10643.07
May 30 11:00:00 - 11:59:59 125023 4.7% 34.7336.5 GB 5.5%10637.02
May 30 12:00:00 - 12:59:59 125462 4.7% 34.8535.7 GB 5.4%10397.50
May 30 13:00:00 - 13:59:59 90999 3.4% 25.2825.2 GB 3.8%7335.40
May 30 14:00:00 - 14:59:59 95276 3.6% 26.4726.4 GB 4.0%7700.19
May 30 15:00:00 - 15:59:59 87643 3.3% 24.3523.4 GB 3.5%6820.78
May 30 16:00:00 - 16:59:59 93589 3.5% 26.0024.9 GB 3.7%7248.44
May 30 17:00:00 - 17:59:59 81687 3.1% 22.6922.5 GB 3.4%6556.33
May 30 18:00:00 - 18:59:59 186886 7.0% 51.9130.1 GB 4.5%8760.73
May 30 19:00:00 - 19:59:59 175069 6.6% 48.6335.3 GB 5.3%10287.21
May 30 20:00:00 - 20:59:59 149141 5.6% 41.4332.5 GB 4.9%9454.70
May 30 21:00:00 - 21:59:59 72850 2.7% 20.2419.3 GB 2.9%5617.68
May 30 22:00:00 - 22:59:59 105300 4.0% 29.2525.1 GB 3.8%7300.36
May 30 23:00:00 - 23:59:59 106550 4.0% 29.6026.1 GB 3.9%7604.44
May 31 00:00:00 - 00:59:59 85655 3.2% 23.7922.4 GB 3.4%6523.46
May 31 01:00:00 - 01:59:59 99608 3.7% 27.6728.8 GB 4.3%8374.21
May 31 02:00:00 - 02:59:59 76405 2.9% 21.2221.1 GB 3.2%6145.58
May 31 03:00:00 - 03:59:59 102416 3.8% 28.4527.6 GB 4.1%8029.90
May 31 04:00:00 - 04:15:03 31298 1.2% 34.667.6 GB 1.1%8815.83
TOTAL: 23:59:57 2661976 100.0% 30.81666.2 GB 100.0%8086.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 88081 124 0 87024 1 0 0 0 932
2news.nask.pl 9418 18 0 6670 2 0 0 0 2728
3news.icm.edu.pl 19 0 0 2 0 0 0 0 17
TOTAL: 3 97518 142 0 93696 3 0 0 0 3677

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 79
it.tlc.cellulari.android 20
comp.mobile.android 19
it.comp.os.win.windows10 16
comp.mobile.ipad 4
it.politica.m5s 2
de.comp.lang.vbclassic 1
it.comp.os.win.windows7 1
TOTAL: 8 142

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2236
Binary in non-binary group 771
Scoring filter (8) 39
Scoring filter (9) 23
HTML post 14
Scoring filter (10) 5
Scoring filter (18) 3
EMP (phl) 1
Too many newsgroups 1
Scoring filter (11) 1
Scoring filter (16) 1
Scoring filter (12) 1
Scoring filter (13) 1
TOTAL: 13 3097

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 374
news.nask.pl 203
news.icm.edu.pl 1
TOTAL: 3 578
TOTAL: 1 578

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 271984 12564 209548 9 0 5 4%23:51:29
2panorama 354778 1412 324480 385 18 357373 0%23:58:56
3icm 419272 248 334096 11441 0 9 0%23:51:29
4poznan 12966 201 7893 21 0 0 1%23:51:29
5okapi 0 0 0 0 0 962 0%23:49:22
TOTAL: 51059000 14425 876017 11856 18 358349 1%119:22:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask4.6 GB3.0 MB4.6 GB55.7 KB/s380.7 KB23:51:29
2icm62.2 MB4.1 GB4.2 GB51.3 KB/s376.6 KB23:51:29
3panorama47.2 MB23.9 MB71.2 MB0.8 KB/s40.6 KB23:58:56
4poznan1.1 MB200.9 KB1.3 MB0.0 KB/s5.9 KB23:51:29
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:22
TOTAL: 54.7 GB4.2 GB8.8 GB21.6 KB/s352.5 KB119:22:45
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
TOTAL: 12.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ool-4578089a.dyn.optonline.net 1 152133.3 KB 4 0 000:00:47
2web.man.lodz.pl 288 6269.5 KB 25 0 000:00:20
30890788407.static.corbina.ru 16 69.2 KB 4 0 000:02:20
4isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:01
TOTAL: 4 311 220212.0 KB 33 6 000:03:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.optonline.net 1 152133.3 KB 4 0 000:00:47
2*.man.lodz.pl 678 6269.5 KB 25 6 000:00:26
3*.static.corbina.ru 16 69.2 KB 4 0 000:02:20
TOTAL: 3 695 220212.0 KB 33 6 000:03:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
0890788407.static.corbina.ru 0.120 0.264 0.00000:02:20
ool-4578089a.dyn.optonline.net 0.040 0.076 0.00000:00:47
web.man.lodz.pl 1.636 4.892 0.00000:00:20
mon.man.lodz.pl 1.296 4.076 0.00000:00:03
david.man.lodz.pl 0.448 1.284 0.00000:00:01
isvcs01.man.lodz.pl 0.076 0.108 0.00000:00:01
TOTAL: 6 3.616 10.700 0.00000:03:34

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1lodz 113 51.4%
2pl 62 28.2%
3lodman 41 18.6%
4lodzman 4 1.8%
TOTAL: 4 220100.0%

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

NewsgroupCount
1lodz.test 111
2pl.comp.pecet 44
3lodman.test 35
4pl.comp.os.ms-windows.winnt 18
5lodman.info 6
6lodzman.test 4
7lodz.ogloszenia 2
TOTAL: 7 220
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>