Daily Usenet report

Nov 5 04:15:03 -- Nov 6 04:15:02

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Nov 5 10:08:54 newsfeed nnrpd[10852]: SERVER perl filter not defined
Nov 5 13:33:40 newsfeed nnrpd[17618]: SERVER perl filter not defined
Nov 5 13:38:53 newsfeed nnrpd[17852]: SERVER perl filter not defined
Nov 5 13:52:00 newsfeed nnrpd[18233]: SERVER perl filter not defined
Nov 5 14:25:08 newsfeed nnrpd[19343]: SERVER perl filter not defined
Nov 5 14:37:25 newsfeed nnrpd[19714]: SERVER perl filter not defined
Nov 5 14:49:41 newsfeed nnrpd[20247]: SERVER perl filter not defined
Nov 5 15:03:09 newsfeed pgpverify[20699]: pgpverify: verification failed
Nov 5 15:44:54 newsfeed nnrpd[22025]: SERVER perl filter not defined
Nov 5 15:46:38 newsfeed nnrpd[22069]: SERVER perl filter not defined
Nov 5 15:47:15 newsfeed nnrpd[22071]: SERVER perl filter not defined
Nov 5 16:23:51 newsfeed nnrpd[23358]: SERVER perl filter not defined
Nov 5 16:48:36 newsfeed nnrpd[24246]: SERVER perl filter not defined
Nov 5 16:56:09 newsfeed nnrpd[24388]: SERVER perl filter not defined
Nov 5 20:30:28 newsfeed overchan[31704]: input line too long, skipping
Nov 6 00:24:47 newsfeed overchan[31704]: input line too long, skipping
Nov 6 00:36:18 newsfeed overchan[31704]: input line too long, skipping
Nov 6 00:53:58 newsfeed overchan[31704]: input line too long, skipping
Nov 6 00:57:46 newsfeed overchan[31704]: input line too long, skipping
Nov 6 01:46:00 newsfeed overchan[31704]: input line too long, skipping
Nov 6 03:32:20 newsfeed overchan[31704]: input line too long, skipping
Nov 6 04:11:16 newsfeed overchan[31704]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1537379 98.2%179.0 MB 97.8%
innd 14042 0.9%2.3 MB 1.3%
nnrpd 7713 0.5%833.0 KB 0.4%
innfeed 6476 0.4%969.4 KB 0.5%
overchan 8 0.0%1.4 KB 0.0%
controlchan 3 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 71565622 100.0%183.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1532056 96.2%
Negative hits 40951 2.6%
Positive hits 19204 1.2%
Cache misses 123 0.0%
TOTAL: 4 1592334 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.931 0.0%286 0.000 24.234 513.000
article cleanup00:00:25.731 0.0%1537246 0.004 0.017 0.042
article logging00:00:40.751 0.0%1537368 0.007 0.027 0.269
article parse00:55:33.793 3.9%147203243 0.006 0.023 0.042
article write00:17:33.918 1.2%1531988 0.311 0.688 3.133
artlog/artcncl00:00:00.004 0.0%285 0.000 0.014 1.000
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:02:14.181 0.2%156889507 0.000 0.001 0.002
hisgrep/artcncl00:00:01.027 0.0%262 0.000 3.920 18.000
hishave/artcncl00:00:00.450 0.0%286 0.000 1.573 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:29:25.263 6.2%1592878 0.014 3.368 11.434
history sync00:00:00.011 0.0%292 0.000 0.038 1.000
history write03:09:31.703 13.2%1532728 0.345 7.419 24.351
hiswrite/artcncl00:00:00.121 0.0%24 0.000 5.042 31.000
idle13:05:32.073 54.5%103532282 0.189 0.455 11.641
nntp read00:52:42.951 3.7%145968959 0.008 0.022 0.034
overview write00:00:09.628 0.0%1531988 0.000 0.006 0.016
perl filter03:23:57.513 14.2%1532725 4.509 7.984 10.916
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:52.362 0.2%3119772 0.015 0.055 0.089
TOTAL: 24:00:22.46623:20:48.411 97.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.184 0.0%55798 0.000 0.003 0.125
article prepare00:00:00.009 0.0%26244 0.000 0.000 0.250
article read00:00:00.790 0.0%6460 0.000 0.122 1.500
backlog stats00:00:00.163 0.0%301503 0.000 0.001 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.876 0.0%193278 0.000 0.010 2.000
data write00:00:06.403 0.0%145382 0.000 0.044 2.625
idle23:59:10.090100.0%301503 0.000 286.399 20100.000
status file00:00:00.485 0.0%190 0.000 2.553 86.750
TOTAL: 23:59:26.04423:59:20.000100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle14:27:28.725 99.9%55042 0.000 945.618209975.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.916 0.0%112644 0.000 0.017 0.667
readart00:00:03.040 0.0%788 0.000 3.858 249.000
TOTAL: 14:27:57.16814:27:33.681100.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet.org.uk000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 626 15311821525961 1575 3646 99%280:04:14
2news.nask.pl 2 19397 5156 12741 1500 26%23:50:42
3news.icm.edu.pl 36 379 53 203 123 13%17:30:31
4localhost 14 13 13 0 0 100%00:00:00
TOTAL: 4 678 15509711531183 14519 5269 98%321:25:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl468.7 GB18.2 MB54.6 MB468.7 GB 99%321.3 KB
2news.nask.pl24.7 MB4.1 MB4.2 MB33.0 MB 74%5.1 KB
3news.icm.edu.pl1.7 MB260.9 KB7.4 MB9.4 MB 17%54.6 KB
4localhost26.6 KB0.0 KB0.0 KB26.6 KB100%2.0 KB
TOTAL: 4468.7 GB22.6 MB66.3 MB468.8 GB 99%319.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 5 04:15:03 - 04:59:59 40224 2.6% 14.9112.2 GB 2.6%4725.74
Nov 5 05:00:00 - 05:59:59 52507 3.4% 14.5916.6 GB 3.5%4826.55
Nov 5 06:00:00 - 06:59:59 46430 3.0% 12.9015.4 GB 3.3%4488.72
Nov 5 07:00:00 - 07:59:59 41233 2.7% 11.4514.2 GB 3.0%4124.70
Nov 5 08:00:00 - 08:59:59 49498 3.2% 13.7515.9 GB 3.4%4637.57
Nov 5 09:00:00 - 09:59:59 53885 3.5% 14.9717.9 GB 3.8%5208.89
Nov 5 10:00:00 - 10:59:59 77081 5.0% 21.4122.8 GB 4.9%6652.94
Nov 5 11:00:00 - 11:59:59 64634 4.2% 17.9522.8 GB 4.9%6651.61
Nov 5 12:00:00 - 12:59:59 66003 4.3% 18.3321.7 GB 4.6%6306.58
Nov 5 13:00:00 - 13:59:59 67439 4.4% 18.7322.5 GB 4.8%6547.55
Nov 5 14:00:00 - 14:59:59 60629 4.0% 16.8418.5 GB 3.9%5382.26
Nov 5 15:00:00 - 15:59:59 61208 4.0% 17.0015.4 GB 3.3%4492.42
Nov 5 16:00:00 - 16:59:59 77877 5.1% 21.6319.0 GB 4.1%5526.84
Nov 5 17:00:00 - 17:59:59 71113 4.6% 19.7521.3 GB 4.5%6203.42
Nov 5 18:00:00 - 18:59:59 78557 5.1% 21.8224.2 GB 5.2%7037.55
Nov 5 19:00:00 - 19:59:59 81251 5.3% 22.5723.2 GB 4.9%6745.12
Nov 5 20:00:00 - 20:59:59 68222 4.5% 18.9521.5 GB 4.6%6261.29
Nov 5 21:00:00 - 21:59:59 52195 3.4% 14.5016.2 GB 3.5%4729.97
Nov 5 22:00:00 - 22:59:59 72086 4.7% 20.0220.4 GB 4.4%5942.53
Nov 5 23:00:00 - 23:59:59 84842 5.5% 23.5722.7 GB 4.9%6622.63
Nov 6 00:00:00 - 00:59:59 49818 3.3% 13.8413.9 GB 3.0%4043.68
Nov 6 01:00:00 - 01:59:59 71166 4.6% 19.7722.1 GB 4.7%6429.21
Nov 6 02:00:00 - 02:59:59 70365 4.6% 19.5522.3 GB 4.8%6504.35
Nov 6 03:00:00 - 03:59:59 61928 4.0% 17.2021.6 GB 4.6%6293.18
Nov 6 04:00:00 - 04:15:02 11524 0.8% 12.784.3 GB 0.9%5019.66
TOTAL: 23:59:59 1531715 100.0% 17.73468.5 GB 100.0%5685.80
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3739 181 0 3049 1 0 0 0 508
2news.nask.pl 1518 32 0 1460 2 0 0 0 24
3news.icm.edu.pl 122 0 0 8 0 0 0 0 114
TOTAL: 3 5379 213 0 4517 3 0 0 0 646

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 113
alt.sex.telephones 24
it.comp.os.win.windows7 20
comp.mobile.android 9
hr.ponuda.hardver.komponente 6
comp.mobile.ipad 5
it.comp.os.win.windows8 5
hr.alt.cellular.gsm.android 4
it.comp.os.linux.ubuntu 4
it.tlc.cellulari.android 3
de.comm.provider.telefonie 3
hr.alt.cellular.gsm.iphone 3
it.comp.virtualizzazione 2
comp.sys.raspberry-pi 2
hr.rec.glazba.hifi 2
nl.comp.sys.android 2
uk.rec.cycling.moderated 2
de.comp.lang.php 1
it.tlc.cellulari.iphone 1
de.comp.lang.perl 1
TOTAL: 21 213

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

GroupsCount
pl.sci.historia 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 396
EMP (md5) 118
Scoring filter (8) 5
HTML post 2
TOTAL: 4 521

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 57240 2191 53372 244 0 0 3%24:00:13
2icm 41638 1606 32420 1932 0 9 3%24:04:16
3poznan 7028 53 4826 30 0 0 0%23:55:01
4nask 27240 45 16918 465 0 0 0%23:51:58
5okapi 0 0 0 0 0 2737 0%24:00:01
TOTAL: 5 133146 3895 107536 2671 0 2746 2%119:51:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm348.9 MB540.6 MB889.5 MB10.5 KB/s257.5 KB24:04:16
2panorama12.0 MB836.0 KB12.8 MB0.2 KB/s5.4 KB24:00:13
3nask320.7 KB128.0 MB128.3 MB1.5 KB/s257.6 KB23:51:58
4poznan302.2 KB64.4 KB366.5 KB0.0 KB/s4.4 KB23:55:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 5361.5 MB669.5 MB1.0 GB2.4 KB/s160.8 KB119:51:29
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 434719.3 KB 288 0 000:00:07
2lze200.lze.lodz.pl 11 233445.9 KB 11 0 001:46:32
3web.man.lodz.pl 288 80171.1 KB 37 0 000:00:26
4pc-212-51-218-225.p.lodz.pl 73 4178.5 KB 13 0 010:35:20
5isvcs01.man.lodz.pl 13 00.0 KB 0 13 000:00:01
TOTAL: 5 673 7881.4 MB 349 13 014:27:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 434719.3 KB 288 0 000:00:07
2*.lze.lodz.pl 11 233445.9 KB 11 0 001:46:32
3*.man.lodz.pl 685 80171.1 KB 37 13 000:00:33
4*.p.lodz.pl 73 4178.5 KB 13 0 010:35:20
5*.cust.tele2.ee 1 00.0 KB 0 0 000:00:00
6*.191.14.62.static.jazztel.es 4 00.0 KB 0 0 002:02:21
7*.elsnet.pl 17 00.0 KB 0 0 000:02:56
8*.toya.net.pl 55 00.0 KB 0 0 000:00:04
TOTAL: 81134 7881.4 MB 349 13 014:27:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.265 0.883 0.00010:35:20
251.191.14.62.static.jazztel.es 1.992 3.282 0.00002:02:21
lze200.lze.lodz.pl 0.065 0.194 0.00001:46:32
host227.elsnet.pl 0.051 0.186 0.00000:02:56
web.man.lodz.pl 1.099 3.883 0.00000:00:26
pc-skrzep2.cm.p.lodz.pl 1.042 3.783 0.00000:00:07
mon.man.lodz.pl 0.940 3.733 0.00000:00:04
staticline41435.toya.net.pl 0.181 0.731 0.00000:00:04
isvcs01.man.lodz.pl 0.083 0.189 0.00000:00:01
david.man.lodz.pl 0.273 1.203 0.00000:00:01
m83-187-132-172.cust.tele2.ee 0.003 0.014 0.00000:00:00
? 0.000 0.043 0.00000:00:00
TOTAL: 12 5.994 18.124 0.00014:27:56

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 55
host227.elsnet.pl 17
251.191.14.62.static.jazztel.es 4
m83-187-132-172.cust.tele2.ee 1
TOTAL: 6 461

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
lze200.lze.lodz.pl 3 2
251.191.14.62.static.jazztel.es 1 1
TOTAL: 2 4 3

Newsgroup request counts (by category):

CategoryCountPct
1lodman 434 55.1%
2pl 352 44.7%
3alt 2 0.3%
TOTAL: 3 788100.0%

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

NewsgroupCount
1lodman.info 434
2pl.rec.kuchnia 177
3pl.comp.pecet 66
4pl.comp.os.ms-windows.winnt 42
5pl.misc.elektronika 28
6pl.misc.kolej 13
7pl.rec.dom 12
8pl.misc.telefonia.gsm 9
9pl.regionalne.lodz 3
10alt.pl.comp.os.linux.newbie 2
11pl.internet.polip 2
TOTAL: 11 788