Daily Usenet report

Jan 15 04:15:02 -- Jan 16 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jan 15 10:16:41 newsfeed nnrpd[30451]: SERVER perl filter not defined
Jan 15 10:17:43 newsfeed nnrpd[30455]: SERVER perl filter not defined
Jan 15 11:11:05 newsfeed controlchan[2228]: control_checkgroups, ^.*$ !ka.lists #20140115 usenet@karlsruhe.org usenet@karlsruhe.org @03044255463035000000030FC0CF0000006B@, , , utf-8, news.task.gda.pl, mail, 1
Jan 15 11:11:05 newsfeed controlchan[2228]: control_checkgroups, ^.*$ !ka.lists #20140115 usenet@karlsruhe.org usenet@karlsruhe.org @03044255463035000000030FC0CF0000006B@, ^.*$, , utf-8, news.task.gda.pl, drop, -1
Jan 15 13:19:12 newsfeed nnrpd[4203]: SERVER perl filter not defined
Jan 15 13:21:35 newsfeed nnrpd[4275]: SERVER perl filter not defined
Jan 15 14:16:26 newsfeed nnrpd[5993]: SERVER perl filter not defined
Jan 15 17:00:05 newsfeed pgpverify[11462]: pgpverify: verification failed
Jan 15 23:36:02 newsfeed nnrpd[24681]: SERVER perl filter not defined
Jan 15 23:41:41 newsfeed nnrpd[24851]: SERVER perl filter not defined
Jan 16 00:35:51 newsfeed nnrpd[26597]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2343606 98.4%277.3 MB 98.1%
innd 18229 0.8%3.1 MB 1.1%
nnrpd 12255 0.5%1.3 MB 0.5%
innfeed 7153 0.3%1.1 MB 0.4%
controlchan 5 0.0%0.7 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 62381249 100.0%282.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2336012 95.3%
Negative hits 73927 3.0%
Positive hits 40933 1.7%
Cache misses 311 0.0%
TOTAL: 4 2451183 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:14.690 0.0%400 0.000 36.725 747.000
article cleanup00:00:31.686 0.0%2342185 0.001 0.014 0.026
article logging00:01:06.213 0.1%2342344 0.005 0.028 0.532
article parse01:09:16.118 4.8%174531984 0.003 0.024 0.072
article write00:17:30.354 1.2%2334254 0.185 0.450 1.373
artlog/artcncl00:00:00.010 0.0%397 0.000 0.025 1.000
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:03:05.554 0.2%188602017 0.000 0.001 0.032
hisgrep/artcncl00:00:01.430 0.0%358 0.000 3.994 248.000
hishave/artcncl00:00:01.190 0.0%400 0.000 2.975 51.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:15:01.011 9.4%2451354 1.127 3.305 8.427
history sync00:00:00.019 0.0%292 0.000 0.065 1.000
history write03:16:48.173 13.7%2336395 2.798 5.054 22.026
hiswrite/artcncl00:00:00.260 0.0%42 0.000 6.190 170.000
idle10:19:04.115 43.0%113830026 0.156 0.326 1.160
nntp read00:58:39.364 4.1%172723816 0.005 0.020 0.040
overview write00:00:14.859 0.0%2334254 0.000 0.006 0.020
perl filter04:50:44.730 20.2%2336389 2.973 7.467 9.809
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:51.039 0.3%4710744 0.022 0.062 0.264
TOTAL: 23:59:28.44023:17:10.815 97.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.160 0.0%42254 0.000 0.004 0.143
article prepare00:00:00.013 0.0%46592 0.000 0.000 0.083
article read00:00:01.301 0.0%11333 0.000 0.115 7.091
backlog stats00:00:00.234 0.0%324102 0.000 0.001 0.028
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.027 0.0%188223 0.000 0.011 0.091
data write00:00:05.650 0.0%163303 0.000 0.035 7.000
idle23:59:59.648100.0%324102 0.000 266.582 11238.000
status file00:00:01.096 0.0%223 0.000 4.915 96.000
TOTAL: 24:00:16.69624:00:10.129100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.041 0.0%23 1.200 1.783 5.667
idle96:35:23.852100.0%148071 0.000 2348.359600085.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.612 0.0%298808 0.000 0.019 6.467
readart00:00:01.283 0.0%558 0.000 2.299 20.000
TOTAL: 96:36:22.65196:35:30.788100.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
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 581 23284262320219 3017 5190 99%321:10:23
2news.nask.pl 2 18113 7785 8914 1414 42%23:46:58
3news.task.gda.pl 10 30974 7175 22511 1288 23%45:08:19
4localhost 10 9 9 0 0 100%00:00:01
5news.icm.edu.pl 36 354 4 325 25 1%20:36:12
TOTAL: 5 639 23778762335192 34767 7917 98%410:41:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl639.5 GB47.1 MB79.0 MB639.6 GB 99%288.4 KB
2news.nask.pl32.9 MB4.4 MB4.5 MB41.8 MB 78%4.7 KB
3news.task.gda.pl15.9 MB38.3 KB3.9 MB19.8 MB 80%2.4 KB
4news.icm.edu.pl84.1 KB12.9 KB631.1 KB728.2 KB 11%25.1 KB
5localhost12.3 KB0.0 KB0.0 KB12.3 KB100%1.4 KB
TOTAL: 5639.6 GB51.6 MB88.0 MB639.7 GB 99%286.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 15 04:15:02 - 04:59:59 75181 3.2% 27.8721.0 GB 3.3%8147.95
Jan 15 05:00:00 - 05:59:59 105564 4.5% 29.3230.1 GB 4.7%8773.75
Jan 15 06:00:00 - 06:59:59 104564 4.5% 29.0530.1 GB 4.7%8776.04
Jan 15 07:00:00 - 07:59:59 90196 3.9% 25.0525.3 GB 4.0%7368.14
Jan 15 08:00:00 - 08:59:59 101103 4.3% 28.0829.8 GB 4.7%8666.81
Jan 15 09:00:00 - 09:59:59 114395 4.9% 31.7831.6 GB 4.9%9189.61
Jan 15 10:00:00 - 10:59:59 112495 4.8% 31.2531.3 GB 4.9%9118.12
Jan 15 11:00:00 - 11:59:59 111966 4.8% 31.1028.6 GB 4.5%8317.33
Jan 15 12:00:00 - 12:59:59 108968 4.7% 30.2729.3 GB 4.6%8532.09
Jan 15 13:00:00 - 13:59:59 119642 5.1% 33.2332.4 GB 5.1%9437.16
Jan 15 14:00:00 - 14:59:59 96284 4.1% 26.7526.7 GB 4.2%7773.43
Jan 15 15:00:00 - 15:59:59 120248 5.1% 33.4033.1 GB 5.2%9630.68
Jan 15 16:00:00 - 16:59:59 118537 5.1% 32.9330.5 GB 4.8%8876.17
Jan 15 17:00:00 - 17:59:59 87327 3.7% 24.2622.5 GB 3.5%6567.85
Jan 15 18:00:00 - 18:59:59 91663 3.9% 25.4624.2 GB 3.8%7043.18
Jan 15 19:00:00 - 19:59:59 93991 4.0% 26.1126.2 GB 4.1%7633.49
Jan 15 20:00:00 - 20:59:59 68316 2.9% 18.9817.1 GB 2.7%4979.39
Jan 15 21:00:00 - 21:59:59 71565 3.1% 19.8818.1 GB 2.8%5285.56
Jan 15 22:00:00 - 22:59:59 72267 3.1% 20.0717.6 GB 2.8%5128.91
Jan 15 23:00:00 - 23:59:59 77775 3.3% 21.6019.3 GB 3.0%5626.47
Jan 16 00:00:00 - 00:59:59 92784 4.0% 25.7725.4 GB 4.0%7394.66
Jan 16 01:00:00 - 01:59:59 85897 3.7% 23.8626.6 GB 4.2%7755.73
Jan 16 02:00:00 - 02:59:59 94150 4.0% 26.1528.5 GB 4.5%8295.99
Jan 16 03:00:00 - 03:59:59 98841 4.2% 27.4628.3 GB 4.4%8256.21
Jan 16 04:00:00 - 04:15:02 21392 0.9% 23.726.3 GB 1.0%7307.20
TOTAL: 24:00:00 2335111 100.0% 27.03639.8 GB 100.0%7765.17
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5322 181 0 4405 4 0 0 0 732
2news.nask.pl 1440 14 0 1373 16 0 0 0 37
3news.task.gda.pl 1311 1102 0 19 0 0 0 0 190
4news.icm.edu.pl 25 0 0 1 0 0 0 0 24
TOTAL: 4 8098 1297 0 5798 20 0 0 0 983

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 164
mailing.freebsd.svn-ports-head 156
uk.railway 103
mailing.freebsd.ports-bugs 75
fr.usenet.abus.nocem 65
mailing.openbsd.misc 53
mailing.gcc.gcc-cvs 40
mozilla.dev.tree-management 39
mailing.database.pgsql-general 37
alt.windows7.general 32
mailing.freebsd.ports 28
mailing.openbsd.ports-changes 27
mailing.unix.samba-technical 26
mailing.unix.samba 26
mailing.freebsd.svn-src-all 24
fa.freebsd.cvs-all 23
mailing.unix.dovecot 22
it.comp.os.win.windows8 19
mailing.freebsd.kde 19
it.tlc.cellulari.android 17
TOTAL: 85 1297

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

GroupsCount
pl.sci.matematyka 11
pl.sci.historia 8
bit.listserv.catholic 1
TOTAL: 3 20

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 610
EMP (fsl) 154
EMP (md5) 32
HTML post 16
Scoring filter (9) 5
Scoring filter (12) 1
TOTAL: 6 818

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 65565 4677 35114 2180 5 8 7%24:00:01
2panorama 44912 3664 37903 680 0 0 8%24:01:29
3task 2218 261 1018 10 0 0 11%21:23:15
4poznan 17999 107 14821 39 0 0 0%24:02:33
5nask 17436 21 11286 0 0 0 0%24:00:26
6okapi 0 0 0 0 0 3071 0%24:00:03
TOTAL: 6 148130 8730 100142 2909 5 3079 5%141:27:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm650.8 MB181.0 MB831.7 MB9.9 KB/s124.2 KB24:00:01
2panorama16.0 MB2.2 MB18.2 MB0.2 KB/s4.3 KB24:01:29
3poznan747.3 KB334.8 KB1.1 MB0.0 KB/s7.4 KB24:02:33
4task558.0 KB17.6 KB575.7 KB0.0 KB/s2.1 KB21:23:15
5nask53.1 KB0.0 KB53.1 KB0.0 KB/s2.5 KB24:00:26
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:03
TOTAL: 6668.1 MB183.5 MB851.6 MB1.7 KB/s74.9 KB141:27:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 338503.7 KB 288 0 000:00:11
2web.man.lodz.pl 288 9295.0 KB 40 0 000:00:29
3212.191.78.190 317 82168.5 KB 33 4 047:29:19
4lze200.lze.lodz.pl 6 2236.5 KB 5 0 001:15:24
5ip-176.105.135.22.tvsat364.lodz.pl 3 1016.0 KB 2 0 001:16:23
6cot155.neoplus.adsl.tpnet.pl 50 710.1 KB 5 0 8003:32:34
7aely246.neoplus.adsl.tpnet.pl 11 45.8 KB 4 0 200:18:53
8router2.cbmm.lodz.pl 4 34.4 KB 3 0 000:01:24
9kujawiak.man.lodz.pl 5 00.0 KB 0 5 000:00:01
TOTAL: 9 972 558840.1 KB 380 9 8296:36:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 338503.7 KB 288 0 000:00:11
2*.man.lodz.pl 678 9295.0 KB 40 5 000:30:37
3unresolved 317 82168.5 KB 33 4 047:29:19
4*.lze.lodz.pl 6 2236.5 KB 5 0 001:15:24
5*.neoplus.adsl.tpnet.pl 61 1115.9 KB 9 0 8203:51:28
6*.105.135.22.tvsat364.lodz.pl 3 1016.0 KB 2 0 001:16:23
7*.cbmm.lodz.pl 4 34.4 KB 3 0 000:01:24
8*.pa.nsw.optusnet.com.au 232 00.0 KB 0 0 000:10:41
9*.4web.pl 48 00.0 KB 0 0 007:42:19
10*.wroclaw.mm.pl 58 00.0 KB 0 0 009:11:37
11*.191.14.62.static.jazztel.es 9 00.0 KB 0 0 025:06:31
12*.toya.net.pl 69 00.0 KB 0 0 000:00:20
TOTAL: 121773 558840.1 KB 380 9 8296:36:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.752 3.596 0.00047:29:19
202.191.14.62.static.jazztel.es 7.784 11.128 0.00025:06:31
host-89-231-50-15.wroclaw.mm.pl 0.100 0.684 0.00009:11:37
net133-43.4web.pl 0.092 0.552 0.00007:42:19
cot155.neoplus.adsl.tpnet.pl 0.272 0.588 0.00003:32:34
ip-176.105.135.22.tvsat364.lodz.pl 0.012 0.036 0.00001:16:23
lze200.lze.lodz.pl 0.008 0.052 0.00001:15:24
pc-vicki.man.lodz.pl 0.004 0.012 0.00000:30:00
aely246.neoplus.adsl.tpnet.pl 0.048 0.132 0.00000:18:53
pa49-181-246-190.pa.nsw.optusnet.com.au 0.440 2.712 0.00000:10:41
router2.cbmm.lodz.pl 0.008 0.052 0.00000:01:24
web.man.lodz.pl 0.608 3.368 0.00000:00:29
staticline41435.toya.net.pl 0.184 0.804 0.00000:00:20
vegas.cm.p.lodz.pl 0.556 3.452 0.00000:00:11
mon.man.lodz.pl 0.604 3.704 0.00000:00:05
david.man.lodz.pl 0.228 1.044 0.00000:00:01
kujawiak.man.lodz.pl 0.016 0.064 0.00000:00:01
TOTAL: 17 11.716 31.980 0.00096:36:20

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
pa49-181-246-190.pa.nsw.optusnet.com.au 232
david.man.lodz.pl 96
staticline41435.toya.net.pl 69
host-89-231-50-15.wroclaw.mm.pl 58
net133-43.4web.pl 48
202.191.14.62.static.jazztel.es 9
pc-vicki.man.lodz.pl 1
TOTAL: 8 801

NNRP client timeouts [Top 20]:

SystemConnPeer
cot155.neoplus.adsl.tpnet.pl 5 0
ip-176.105.135.22.tvsat364.lodz.pl 2 0
lze200.lze.lodz.pl 1 0
pc-vicki.man.lodz.pl 1 0
202.191.14.62.static.jazztel.es 1 0
TOTAL: 5 10 2

Newsgroup request counts (by category):

CategoryCountPct
1lodman 349 62.5%
2pl 208 37.3%
3alt 1 0.2%
TOTAL: 3 558100.0%

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

NewsgroupCount
1lodman.info 349
2pl.comp.pecet 61
3pl.comp.os.ms-windows.winnt 39
4pl.soc.prawo 31
5pl.misc.kolej 27
6pl.comp.os.linux 20
7pl.regionalne.lodz 12
8pl.rec.rowery 10
9pl.rec.kuchnia 5
10pl.regionalne.warszawa 2
11alt.pl.praca.oferowana 1
12pl.sci.chemia 1
TOTAL: 12 558