Daily Usenet report

May 8 04:15:02 -- May 9 04:15:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

May 8 06:24:24 newsfeed nnrpd[1175]: SERVER perl filter not defined
May 8 06:25:45 newsfeed nnrpd[1648]: SERVER perl filter not defined
May 8 06:29:49 newsfeed nnrpd[1696]: SERVER perl filter not defined
May 8 08:41:06 newsfeed nnrpd[6489]: SERVER perl filter not defined
May 8 08:43:13 newsfeed nnrpd[6500]: SERVER perl filter not defined
May 8 12:21:01 newsfeed nnrpd[14053]: SERVER perl filter not defined
May 8 12:42:35 newsfeed nnrpd[14730]: SERVER perl filter not defined
May 8 13:25:43 newsfeed overchan[2339]: input line too long, skipping
May 8 15:10:12 newsfeed nnrpd[19881]: SERVER perl filter not defined
May 8 15:11:10 newsfeed nnrpd[19882]: SERVER perl filter not defined
May 8 15:11:43 newsfeed nnrpd[19883]: SERVER perl filter not defined
May 8 15:51:37 newsfeed nnrpd[21241]: SERVER perl filter not defined
May 8 16:10:48 newsfeed nnrpd[21941]: SERVER perl filter not defined
May 8 18:34:51 newsfeed nnrpd[26795]: SERVER perl filter not defined
May 8 19:50:06 newsfeed nnrpd[29491]: SERVER perl filter not defined
May 8 22:39:23 newsfeed nnrpd[2941]: SERVER perl filter not defined
May 8 22:40:11 newsfeed nnrpd[3000]: SERVER perl filter not defined
May 9 00:24:10 newsfeed nnrpd[6505]: SERVER perl filter not defined
May 9 00:30:39 newsfeed nnrpd[6805]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2059849 98.4%241.1 MB 98.1%
innd 17777 0.8%2.9 MB 1.2%
innfeed 7473 0.4%1.1 MB 0.4%
nnrpd 7212 0.3%786.2 KB 0.3%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 52092312 100.0%245.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2055220 98.1%
Negative hits 22539 1.1%
Positive hits 16936 0.8%
Cache misses 415 0.0%
TOTAL: 4 2095110 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.350 0.0%618 0.000 7.039 72.000
article cleanup00:00:24.096 0.0%2059384 0.003 0.012 0.031
article logging00:01:03.278 0.1%2059515 0.014 0.031 0.104
article parse00:43:55.360 3.0%96066270 0.018 0.027 0.046
article write00:20:56.745 1.5%2055219 0.385 0.611 2.038
artlog/artcncl00:00:00.010 0.0%604 0.000 0.017 0.111
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:22.674 0.1%108562214 0.000 0.001 0.002
hisgrep/artcncl00:00:01.071 0.0%476 0.000 2.250 31.000
hishave/artcncl00:00:00.044 0.0%618 0.000 0.071 2.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:45.480 0.4%2095397 0.026 0.165 3.399
history sync00:00:00.022 0.0%292 0.000 0.075 1.000
history write00:13:15.148 0.9%2055944 0.115 0.387 5.285
hiswrite/artcncl00:00:00.010 0.0%142 0.000 0.070 0.333
idle16:58:00.981 70.7%81106367 0.368 0.753 11.224
nntp read00:40:04.678 2.8%94571842 0.019 0.025 0.035
overview write00:00:13.981 0.0%2055219 0.000 0.007 0.019
perl filter04:24:08.198 18.3%2055944 5.684 7.708 14.184
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:17.420 0.3%4183564 0.041 0.062 0.177
TOTAL: 24:00:15.88323:33:33.546 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.276 0.0%74079 0.000 0.004 0.143
article prepare00:00:00.013 0.0%41258 0.000 0.000 0.062
article read00:00:01.510 0.0%10138 0.000 0.149 1.000
backlog stats00:00:00.250 0.0%420604 0.000 0.001 0.021
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.320 0.0%251906 0.000 0.013 1.000
data write00:00:09.622 0.0%185629 0.000 0.052 1.000
idle23:59:16.351100.0%420604 0.000 205.315 30099.000
status file00:00:00.160 0.0%202 0.000 0.792 2.000
TOTAL: 23:59:40.51823:59:31.502100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%16 0.062 0.062 0.062
idle03:15:14.063 99.7%110598 0.000 105.916 11005.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.790 0.0%223130 0.000 0.021 7.222
readart00:00:00.031 0.0%506 0.000 0.061 1.000
TOTAL: 03:15:45.11903:15:18.885 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 884 20549192050472 618 3829 99%201:04:04
2news.nask.pl 3 16962 4203 12450 309 24%23:42:56
3news.icm.edu.pl 45 263 27 200 36 10%17:13:25
4localhost 19 18 18 0 0 100%00:00:00
TOTAL: 4 951 20721622054720 13268 4174 99%242:00:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl581.1 GB15.3 MB266.4 MB581.4 GB 99%296.8 KB
2news.nask.pl22.9 MB1.0 MB1.2 MB25.0 MB 91%5.7 KB
3news.icm.edu.pl746.5 KB31.2 KB842.0 KB1.6 MB 46%25.7 KB
4localhost30.8 KB0.0 KB0.0 KB30.8 KB100%1.7 KB
TOTAL: 4581.1 GB16.4 MB268.4 MB581.4 GB 99%296.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 8 04:15:02 - 04:59:59 53392 2.6% 19.7916.7 GB 2.9%6490.95
May 8 05:00:00 - 05:59:59 51895 2.5% 14.4216.5 GB 2.8%4799.68
May 8 06:00:00 - 06:59:59 77905 3.8% 21.6424.8 GB 4.3%7211.35
May 8 07:00:00 - 07:59:59 66981 3.3% 18.6119.7 GB 3.4%5731.05
May 8 08:00:00 - 08:59:59 59770 2.9% 16.6017.4 GB 3.0%5070.73
May 8 09:00:00 - 09:59:59 52172 2.5% 14.4915.3 GB 2.6%4442.63
May 8 10:00:00 - 10:59:59 58116 2.8% 16.1416.0 GB 2.8%4650.86
May 8 11:00:00 - 11:59:59 121560 5.9% 33.7727.9 GB 4.8%8140.92
May 8 12:00:00 - 12:59:59 100922 4.9% 28.0327.6 GB 4.7%8026.49
May 8 13:00:00 - 13:59:59 102474 5.0% 28.4629.4 GB 5.1%8574.04
May 8 14:00:00 - 14:59:59 98658 4.8% 27.4128.4 GB 4.9%8274.97
May 8 15:00:00 - 15:59:59 96034 4.7% 26.6827.6 GB 4.8%8051.54
May 8 16:00:00 - 16:59:59 116050 5.6% 32.2427.8 GB 4.8%8092.24
May 8 17:00:00 - 17:59:59 106106 5.2% 29.4726.4 GB 4.6%7691.89
May 8 18:00:00 - 18:59:59 91241 4.4% 25.3424.4 GB 4.2%7098.82
May 8 19:00:00 - 19:59:59 83034 4.0% 23.0723.6 GB 4.1%6876.51
May 8 20:00:00 - 20:59:59 99143 4.8% 27.5427.8 GB 4.8%8095.28
May 8 21:00:00 - 21:59:59 95093 4.6% 26.4126.9 GB 4.6%7824.11
May 8 22:00:00 - 22:59:59 94023 4.6% 26.1228.4 GB 4.9%8263.21
May 8 23:00:00 - 23:59:59 94404 4.6% 26.2229.3 GB 5.1%8547.08
May 9 00:00:00 - 00:59:59 62032 3.0% 17.2318.0 GB 3.1%5249.48
May 9 01:00:00 - 01:59:59 65534 3.2% 18.2018.4 GB 3.2%5354.08
May 9 02:00:00 - 02:59:59 98254 4.8% 27.2929.1 GB 5.0%8478.62
May 9 03:00:00 - 03:59:59 87531 4.3% 24.3125.9 GB 4.5%7537.97
May 9 04:00:00 - 04:15:01 22625 1.1% 25.117.0 GB 1.2%8136.78
TOTAL: 23:59:59 2054949 100.0% 23.78580.2 GB 100.0%7041.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3931 160 0 3162 2 0 0 0 607
2news.nask.pl 329 18 0 276 5 0 0 0 30
3news.icm.edu.pl 36 0 0 2 0 0 0 0 34
TOTAL: 3 4296 178 0 3440 7 0 0 0 671

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 46
comp.mobile.ipad 28
comp.sys.raspberry-pi 25
de.comp.lang.php 11
nl.comp.sys.android 11
it.tlc.cellulari.android 10
comp.sys.mac.vintage 8
it.comp.os.linux.ubuntu 7
hr.rec.glazba.hifi 6
hr.alt.cellular.gsm.android 4
it.comp.os.win.windows8 4
uk.rec.cycling.moderated 3
hr.ponuda.hardver.komponente 3
it.tlc.cellulari.iphone 2
alt.sex.telephones 2
de.comp.lang.vbclassic 2
nl.wetenschap.regulier 2
it.comp.os.win.windows7 2
comp.mobile.android 1
hr.alt.cellular.gsm.iphone 1
TOTAL: 20 178

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

GroupsCount
pl.sci.historia 5
pl.praca.oferowana 1
bit.listserv.catholic 1
TOTAL: 3 7

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 487
EMP (md5) 37
Scoring filter (9) 7
HTML post 7
Attached HTML file 1
Scoring filter (12) 1
TOTAL: 6 540

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 57484 5404 34145 605 1 962 9%24:04:14
2panorama 84920 3210 69412 457 0 0 3%24:03:16
3nask 26186 223 13840 364 0 0 0%23:58:26
4poznan 6403 69 4190 15 0 0 1%24:00:17
5okapi 0 0 0 0 0 2604 0%24:00:02
TOTAL: 5 174993 8906 121587 1441 1 3566 5%120:06:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1017.9 MB60.3 MB1.1 GB12.7 KB/s183.7 KB24:04:14
2panorama16.9 MB2.9 MB19.8 MB0.2 KB/s5.5 KB24:03:16
3poznan4.2 MB1.2 MB5.4 MB0.1 KB/s66.4 KB24:00:17
4nask2.5 MB87.2 MB89.7 MB1.1 KB/s156.4 KB23:58:26
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 51.0 GB151.6 MB1.2 GB2.8 KB/s118.1 KB120:06:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 464728.3 KB 288 0 000:00:07
2web.man.lodz.pl 288 4238.0 KB 18 0 000:00:28
3isvcs01.man.lodz.pl 18 00.0 KB 0 18 000:00:01
TOTAL: 3 594 506766.3 KB 306 18 003:15:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 464728.3 KB 288 0 000:00:07
2*.man.lodz.pl 690 4238.0 KB 18 18 000:00:35
3*.elsnet.pl 4 00.0 KB 0 0 000:00:17
4unresolved 3 00.0 KB 0 0 003:14:07
5*.sieradz.vectranet.pl 1 00.0 KB 0 0 000:00:33
6*.toya.net.pl 70 00.0 KB 0 0 000:00:04
TOTAL: 61056 506766.3 KB 306 18 003:15:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.41.242 6.621 8.635 0.00003:14:07
088156077175.sieradz.vectranet.pl 0.029 0.020 0.00000:00:33
web.man.lodz.pl 1.194 3.433 0.00000:00:28
host227.elsnet.pl 0.019 0.040 0.00000:00:17
pc-skrzep2.cm.p.lodz.pl 1.214 3.286 0.00000:00:07
staticline41435.toya.net.pl 0.274 0.831 0.00000:00:04
mon.man.lodz.pl 1.103 3.135 0.00000:00:03
isvcs01.man.lodz.pl 0.164 0.219 0.00000:00:01
david.man.lodz.pl 0.380 0.948 0.00000:00:01
87.190.248.85 0.027 0.023 0.00000:00:00
TOTAL: 10 11.025 20.570 0.00003:15:44

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 70
host227.elsnet.pl 4
89.38.41.242 2
088156077175.sieradz.vectranet.pl 1
87.190.248.85 1
TOTAL: 7 462

Newsgroup request counts (by category):

CategoryCountPct
1lodman 464 91.7%
2pl 42 8.3%
TOTAL: 2 506100.0%

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

NewsgroupCount
1lodman.info 464
2pl.comp.pecet 22
3pl.comp.os.ms-windows.winnt 20
TOTAL: 3 506