Daily Usenet report

Feb 24 04:15:02 -- Feb 25 04:15:03

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Feb 24 10:31:43 newsfeed nnrpd[19179]: SERVER perl filter not defined
Feb 24 11:36:08 newsfeed nnrpd[21590]: SERVER perl filter not defined
Feb 24 11:37:38 newsfeed nnrpd[21595]: SERVER perl filter not defined
Feb 24 13:05:13 newsfeed nnrpd[24525]: SERVER perl filter not defined
Feb 24 13:39:05 newsfeed nnrpd[25530]: SERVER perl filter not defined
Feb 24 13:43:59 newsfeed nnrpd[25755]: SERVER perl filter not defined
Feb 24 13:44:49 newsfeed nnrpd[25767]: SERVER perl filter not defined
Feb 24 13:45:14 newsfeed nnrpd[25818]: SERVER perl filter not defined
Feb 24 17:23:07 newsfeed nnrpd[393]: SERVER perl filter not defined
Feb 24 18:31:34 newsfeed nnrpd[2730]: SERVER perl filter not defined
Feb 24 23:42:43 newsfeed nnrpd[12997]: SERVER perl filter not defined
Feb 24 23:59:29 newsfeed nnrpd[13575]: SERVER perl filter not defined
Feb 25 00:00:55 newsfeed nnrpd[13660]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1423489 97.8%164.6 MB 97.4%
innd 12822 0.9%2.2 MB 1.3%
nnrpd 11452 0.8%1.2 MB 0.7%
innfeed 7345 0.5%1.1 MB 0.6%
TOTAL: 41455108 100.0%169.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1417138 94.2%
Positive hits 45734 3.0%
Negative hits 40467 2.7%
Cache misses 370 0.0%
TOTAL: 4 1503709 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:12.818 0.0%408 0.000 31.417 900.000
article cleanup00:00:21.598 0.0%1423274 0.002 0.015 0.035
article logging00:00:44.409 0.1%1423432 0.008 0.031 0.511
article parse00:49:37.987 3.4%165511979 0.009 0.018 0.105
article write00:12:37.571 0.9%1416181 0.281 0.535 1.812
artlog/artcncl00:00:00.008 0.0%394 0.000 0.020 1.000
artlog/artparse00:00:00.000 0.0%7 0.000 0.000 0.000
data move00:02:36.451 0.2%175053448 0.000 0.001 0.017
hisgrep/artcncl00:00:01.538 0.0%288 0.000 5.340 225.000
hishave/artcncl00:00:00.860 0.0%408 0.000 2.108 277.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:02:57.156 4.4%1504791 0.013 2.510 7.968
history sync00:00:00.012 0.0%290 0.000 0.041 2.000
history write02:38:35.615 11.0%1418380 2.298 6.709 32.863
hiswrite/artcncl00:00:00.558 0.0%120 0.000 4.650 150.000
idle14:01:43.952 58.4%140843041 0.144 0.359 2.238
nntp read00:58:50.817 4.1%164594361 0.013 0.021 0.059
overview write00:00:08.980 0.0%1416181 0.000 0.006 0.019
perl filter03:15:45.735 13.6%1418373 5.651 8.281 13.796
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:06.952 0.2%2878306 0.023 0.065 0.096
TOTAL: 24:00:17.15923:07:23.017 96.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.184 0.0%45936 0.000 0.004 0.143
article prepare00:00:00.017 0.0%66776 0.000 0.000 0.083
article read00:00:03.539 0.0%16241 0.000 0.218 14.280
backlog stats00:00:00.255 0.0%378694 0.000 0.001 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.438 0.0%218359 0.000 0.011 0.066
data write00:00:07.875 0.0%186140 0.000 0.042 2.871
idle23:59:38.017100.0%378694 0.000 228.094 9211.000
status file00:00:00.751 0.0%220 0.000 3.414 81.250
TOTAL: 24:00:01.14023:59:53.076100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle94:55:45.745 99.7%657453 0.000 519.803600055.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:16:19.029 0.3%1318150 0.000 0.743105258.556
readart00:00:01.973 0.0%894 0.000 2.207 24.625
TOTAL: 95:13:30.76095:12:06.747100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 404 14108581406093 423 4342 99%172:50:31
2news.task.gda.pl 12 32839 7223 24199 1417 21%44:54:56
3news.nask.pl 3 21860 4484 16066 1310 20%24:05:19
4localhost 14 13 13 0 0 100%00:00:00
5news.icm.edu.pl 32 301 1 270 30 0%18:58:06
TOTAL: 5 465 14658711417814 40958 7099 96%260:48:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl424.0 GB36.5 MB65.1 MB424.1 GB 99%315.3 KB
2news.nask.pl25.9 MB4.7 MB4.8 MB35.4 MB 73%6.3 KB
3news.task.gda.pl15.1 MB80.2 KB4.3 MB19.4 MB 77%2.3 KB
4news.icm.edu.pl63.9 KB0.0 KB474.6 KB538.5 KB 11%17.4 KB
5localhost21.7 KB0.0 KB0.0 KB21.7 KB100%1.7 KB
TOTAL: 5424.0 GB41.2 MB74.6 MB424.1 GB 99%312.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 24 04:15:02 - 04:59:59 57912 4.1% 21.4619.9 GB 4.7%7740.95
Feb 24 05:00:00 - 05:59:59 69106 4.9% 19.2016.5 GB 3.9%4809.67
Feb 24 06:00:00 - 06:59:59 37401 2.6% 10.3912.7 GB 3.0%3686.40
Feb 24 07:00:00 - 07:59:59 40560 2.9% 11.2714.3 GB 3.4%4162.31
Feb 24 08:00:00 - 08:59:59 42449 3.0% 11.7914.0 GB 3.3%4075.36
Feb 24 09:00:00 - 09:59:59 63136 4.5% 17.5415.8 GB 3.7%4614.95
Feb 24 10:00:00 - 10:59:59 55463 3.9% 15.4114.7 GB 3.5%4272.33
Feb 24 11:00:00 - 11:59:59 47897 3.4% 13.3014.6 GB 3.4%4255.67
Feb 24 12:00:00 - 12:59:59 47783 3.4% 13.2714.8 GB 3.5%4302.96
Feb 24 13:00:00 - 13:59:59 62051 4.4% 17.2419.7 GB 4.7%5740.35
Feb 24 14:00:00 - 14:59:59 61882 4.4% 17.1919.1 GB 4.5%5554.57
Feb 24 15:00:00 - 15:59:59 54858 3.9% 15.2415.6 GB 3.7%4529.40
Feb 24 16:00:00 - 16:59:59 73994 5.2% 20.5517.6 GB 4.1%5114.17
Feb 24 17:00:00 - 17:59:59 53355 3.8% 14.8216.5 GB 3.9%4815.58
Feb 24 18:00:00 - 18:59:59 55042 3.9% 15.2916.0 GB 3.8%4652.35
Feb 24 19:00:00 - 19:59:59 61237 4.3% 17.0116.3 GB 3.8%4738.80
Feb 24 20:00:00 - 20:59:59 55645 3.9% 15.4615.3 GB 3.6%4444.21
Feb 24 21:00:00 - 21:59:59 50867 3.6% 14.1313.9 GB 3.3%4061.10
Feb 24 22:00:00 - 22:59:59 52926 3.7% 14.7015.0 GB 3.5%4371.67
Feb 24 23:00:00 - 23:59:59 64166 4.5% 17.8218.9 GB 4.5%5501.77
Feb 25 00:00:00 - 00:59:59 60343 4.3% 16.7619.3 GB 4.6%5634.02
Feb 25 01:00:00 - 01:59:59 68699 4.9% 19.0824.1 GB 5.7%7021.06
Feb 25 02:00:00 - 02:59:59 68888 4.9% 19.1423.1 GB 5.5%6732.24
Feb 25 03:00:00 - 03:59:59 87409 6.2% 24.2828.4 GB 6.7%8263.51
Feb 25 04:00:00 - 04:15:03 22775 1.6% 25.227.7 GB 1.8%8952.52
TOTAL: 24:00:01 1415844 100.0% 16.39423.7 GB 100.0%5141.67
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4485 237 0 3568 5 0 0 0 675
2news.task.gda.pl 1418 1233 0 48 0 0 0 0 137
3news.nask.pl 1320 10 0 1280 6 0 0 0 24
4news.icm.edu.pl 30 0 0 0 0 0 0 0 30
TOTAL: 4 7253 1480 0 4896 11 0 0 0 866

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 142
mailing.freebsd.svn-ports-head 142
uk.railway 95
mailing.freebsd.current 77
alt.windows7.general 63
mailing.freebsd.ports-bugs 52
mailing.freebsd.svn-src-all 45
fa.freebsd.cvs-all 45
gmane.linux.alsa.devel 43
mailing.gcc.gcc-cvs 39
mozilla.dev.tree-management 38
mozilla.dev.gaia 36
mailing.openbsd.misc 35
mailing.unix.dovecot 33
mailing.freebsd.svn-src-head 32
mailing.unix.samba-technical 30
mailing.dragonflybsd.bugs 29
comp.mobile.android 29
mailing.postfix.users 26
mozilla.dev.platform 23
TOTAL: 89 1480

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

GroupsCount
pl.sci.historia 9
alt.genius.bill-palmer 1
bit.listserv.catholic 1
TOTAL: 3 11

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 537
EMP (fsl) 114
EMP (md5) 40
HTML post 9
Scoring filter (12) 1
TOTAL: 5 701

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 67964 10297 32252 3053 13 1 15%23:54:28
2panorama 54117 2606 42795 409 0 0 4%23:58:49
3nask 30194 112 17616 1 0 1 0%23:55:30
4poznan 14061 56 11552 10 0 0 0%24:01:35
5task 2077 16 1088 5 0 0 0%21:12:20
6okapi 0 0 0 0 0 2763 0%24:00:01
TOTAL: 6 168413 13087 105303 3478 13 2765 7%141:02:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm974.5 MB34.5 MB1009.0 MB12.0 KB/s77.4 KB23:54:28
2panorama16.7 MB1.7 MB18.4 MB0.2 KB/s6.3 KB23:58:49
3nask854.5 KB4.4 KB858.9 KB0.0 KB/s7.6 KB23:55:30
4poznan151.9 KB17.7 KB169.6 KB0.0 KB/s2.6 KB24:01:35
5task37.3 KB13.8 KB51.1 KB0.0 KB/s2.4 KB21:12:20
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 6992.2 MB36.3 MB1.0 GB2.1 KB/s63.6 KB141:02:43
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 604971.2 KB 288 0 006:45:29
2web.man.lodz.pl 288 130115.5 KB 57 0 000:00:27
3lze200.lze.lodz.pl 2 75140.6 KB 6 0 000:31:18
4212.191.78.190 311 71123.7 KB 24 1 047:29:58
5ip-176.105.135.22.tvsat364.lodz.pl 10 815.6 KB 5 0 003:09:20
6router2.cbmm.lodz.pl 1 47.0 KB 1 0 000:01:13
7212.51.203.199 3 11.4 KB 1 0 000:04:02
8pc-vicki.man.lodz.pl 1 191.4 KB 1 0 000:30:07
9isvcs01.man.lodz.pl 12 00.0 KB 0 12 000:00:01
TOTAL: 9 916 8941.4 MB 383 13 095:13:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 604971.2 KB 288 0 006:45:29
2*.man.lodz.pl 685 131206.9 KB 58 12 000:30:43
3*.lze.lodz.pl 2 75140.6 KB 6 0 000:31:18
4unresolved 314 72125.1 KB 25 1 047:34:01
5*.105.135.22.tvsat364.lodz.pl 10 815.6 KB 5 0 003:09:20
6*.cbmm.lodz.pl 1 47.0 KB 1 0 000:01:13
7*.pa.nsw.optusnet.com.au 135 00.0 KB 0 0 000:03:38
8*.ip.telfort.nl 2 00.0 KB 0 0 000:03:01
9*.wroclaw.mm.pl 34 00.0 KB 0 0 005:20:53
10*.4web.pl 48 00.0 KB 0 0 007:58:22
11*.191.14.62.static.jazztel.es 5 00.0 KB 0 0 014:20:38
12*.bydgoszcz.vectranet.pl 1 00.0 KB 0 0 000:00:40
13*.181.14.62.static.jazztel.es 6 00.0 KB 0 0 008:49:51
14*.toya.net.pl 67 00.0 KB 0 0 000:04:15
TOTAL: 141598 8941.4 MB 383 13 095:13:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.856 3.188 0.00047:29:58
154.191.14.62.static.jazztel.es 21.604 29.716 0.00014:20:38
159.181.14.62.static.jazztel.es 12.800 16.944 0.00008:49:51
net133-43.4web.pl 0.132 0.452 0.00007:58:22
vegas.cm.p.lodz.pl 0.636 2.896 0.00006:45:29
host-89-231-50-15.wroclaw.mm.pl 0.064 0.364 0.00005:20:53
ip-176.105.135.22.tvsat364.lodz.pl 0.008 0.128 0.00003:09:20
lze200.lze.lodz.pl 0.024 0.032 0.00000:31:18
pc-vicki.man.lodz.pl 0.004 0.012 0.00000:30:07
212.51.203.199 0.008 0.028 0.00000:04:02
pa49-181-247-34.pa.nsw.optusnet.com.au 0.340 1.316 0.00000:03:38
77-173-110-149.ip.telfort.nl 0.072 0.064 0.00000:03:01
staticline-31-182-64-89.toya.net.pl 0.004 0.008 0.00000:02:32
staticline41435.toya.net.pl 0.196 0.680 0.00000:01:42
router2.cbmm.lodz.pl 0.008 0.008 0.00000:01:13
031011150111.bydgoszcz.vectranet.pl 0.028 0.020 0.00000:00:40
web.man.lodz.pl 0.580 3.032 0.00000:00:27
mon.man.lodz.pl 0.656 2.968 0.00000:00:05
isvcs01.man.lodz.pl 0.052 0.164 0.00000:00:01
david.man.lodz.pl 0.192 0.988 0.00000:00:01
TOTAL: 20 38.264 63.008 0.00095:13:28

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
pa49-181-247-34.pa.nsw.optusnet.com.au 135
david.man.lodz.pl 96
staticline41435.toya.net.pl 66
net133-43.4web.pl 48
host-89-231-50-15.wroclaw.mm.pl 34
159.181.14.62.static.jazztel.es 6
154.191.14.62.static.jazztel.es 5
77-173-110-149.ip.telfort.nl 2
031011150111.bydgoszcz.vectranet.pl 1
staticline-31-182-64-89.toya.net.pl 1
TOTAL: 11 682

NNRP client timeouts [Top 20]:

SystemConnPeer
vegas.cm.p.lodz.pl 11 0
154.191.14.62.static.jazztel.es 4 2
ip-176.105.135.22.tvsat364.lodz.pl 3 0
159.181.14.62.static.jazztel.es 2 2
pc-vicki.man.lodz.pl 1 0
TOTAL: 5 21 6

Newsgroup request counts (by category):

CategoryCountPct
1lodman 604 67.6%
2pl 290 32.4%
TOTAL: 2 894100.0%

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

NewsgroupCount
1lodman.info 604
2pl.comp.pecet 93
3pl.comp.os.ms-windows.winnt 90
4pl.misc.kolej 37
5pl.comp.os.linux 16
6pl.rec.rowery 16
7pl.regionalne.warszawa 10
8pl.rec.kuchnia 8
9pl.soc.prawo 5
10pl.sci.chemia 4
11pl.misc.telefonia.gsm 3
12pl.comp.os.linux.sieci 3
13pl.soc.dzieci 2
14pl.sci.medycyna 1
15pl.misc.dieta 1
16pl.soc.dzieci.starsze 1
TOTAL: 16 894