Daily Usenet report

Nov 10 04:15:02 -- Nov 11 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 10 13:45:20 newsfeed nnrpd[9351]: SERVER perl filter not defined
Nov 10 13:47:34 newsfeed nnrpd[9366]: SERVER perl filter not defined
Nov 10 20:48:21 newsfeed nnrpd[23915]: SERVER perl filter not defined
Nov 11 00:07:37 newsfeed nnrpd[30880]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2752544 97.2%320.9 MB 96.9%
innfeed 44545 1.6%5.3 MB 1.6%
innd 28186 1.0%4.6 MB 1.4%
nnrpd 5149 0.2%546.8 KB 0.2%
TOTAL: 42830424 100.0%331.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2745111 98.3%
Negative hits 29509 1.1%
Positive hits 17187 0.6%
Cache misses 112 0.0%
TOTAL: 4 2791919 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.869 0.0%212 0.000 22.967 655.000
article cleanup00:00:43.451 0.1%2752547 0.000 0.016 0.033
article logging00:01:17.477 0.1%2753058 0.015 0.028 0.498
article parse01:20:38.849 5.6%281876551 0.006 0.017 0.064
article write00:27:12.236 1.9%2741110 0.222 0.595 2.248
artlog/artcncl00:00:00.006 0.0%211 0.000 0.028 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:06:07.244 0.4%299509172 0.000 0.001 0.005
hisgrep/artcncl00:00:00.203 0.0%175 0.000 1.160 16.000
hishave/artcncl00:00:00.067 0.0%212 0.000 0.316 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:37:15.095 2.6%2795046 0.123 0.800 9.696
history sync00:00:00.015 0.0%295 0.000 0.051 1.000
history write00:51:10.692 3.6%2748234 0.206 1.117 21.681
hiswrite/artcncl00:00:00.022 0.0%37 0.000 0.595 11.000
idle12:17:07.376 51.2%193452165 0.079 0.229 20324.000
nntp read01:36:08.005 6.7%279687217 0.008 0.021 0.037
overview write00:00:14.855 0.0%2741110 0.000 0.005 0.012
perl filter05:33:18.977 23.1%2748234 3.922 7.277 10.192
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:57.450 0.3%5539948 0.029 0.054 0.089
TOTAL: 24:00:15.10222:56:16.889 95.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.296 0.0%98784 0.000 0.003 0.105
article prepare00:00:00.024 0.0%80798 0.000 0.000 0.083
article read00:01:25.034 0.1%20125 0.000 4.225 343.500
backlog stats00:00:00.216 0.0%291036 0.000 0.001 0.024
callbacks00:00:00.000 0.0%10 0.000 0.000 0.000
data read00:00:01.923 0.0%163793 0.000 0.012 0.183
data write00:00:12.567 0.0%108596 0.000 0.116 1.236
idle23:58:04.067 99.9%291036 98.634 296.472 6816.000
status file00:00:11.543 0.0%15293 0.167 0.755 11.000
TOTAL: 24:00:07.82223:59:55.670100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:49:19.398 99.4%50547 0.000 414.652450172.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.864 0.0%102165 0.000 0.018 2.000
readart00:00:00.961 0.0%200 0.000 4.805 16.286
TOTAL: 05:51:28.71105:49:22.223 99.4%----

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 1051 27471072735623 515 10969 99%321:54:20
2news.nask.pl 2 17163 4804 11900 459 27%23:46:14
3news.icm.edu.pl 44 282 38 231 13 13%18:34:42
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1102 27645562740469 12646 11441 99%364:15:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl817.7 GB15.6 MB1.5 GB819.3 GB 99%312.8 KB
2news.nask.pl17.0 MB1.2 MB1.5 MB19.7 MB 86%3.8 KB
3news.icm.edu.pl1.1 MB54.3 KB205.2 KB1.3 MB 80%26.8 KB
4localhost8.8 KB0.0 KB0.0 KB8.8 KB100%2.2 KB
TOTAL: 4817.7 GB16.9 MB1.5 GB819.3 GB 99%312.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 10 04:15:02 - 04:59:59 93441 3.4% 34.6328.1 GB 3.4%10919.68
Nov 10 05:00:00 - 05:59:59 123470 4.5% 34.3037.2 GB 4.6%10839.48
Nov 10 06:00:00 - 06:59:59 120905 4.4% 33.5837.6 GB 4.6%10941.81
Nov 10 07:00:00 - 07:59:59 116961 4.3% 32.4936.4 GB 4.5%10595.82
Nov 10 08:00:00 - 08:59:59 108205 3.9% 30.0633.9 GB 4.1%9874.12
Nov 10 09:00:00 - 09:59:59 99902 3.6% 27.7533.1 GB 4.1%9645.23
Nov 10 10:00:00 - 10:59:59 110962 4.0% 30.8234.7 GB 4.2%10112.60
Nov 10 11:00:00 - 11:59:59 126751 4.6% 35.2135.1 GB 4.3%10209.40
Nov 10 12:00:00 - 12:59:59 129331 4.7% 35.9335.4 GB 4.3%10297.94
Nov 10 13:00:00 - 13:59:59 142722 5.2% 39.6535.9 GB 4.4%10462.57
Nov 10 14:00:00 - 14:59:59 120230 4.4% 33.4034.8 GB 4.3%10150.70
Nov 10 15:00:00 - 15:59:59 118240 4.3% 32.8435.7 GB 4.4%10405.33
Nov 10 16:00:00 - 16:59:59 137439 5.0% 38.1837.7 GB 4.6%10989.82
Nov 10 17:00:00 - 17:59:59 118099 4.3% 32.8135.7 GB 4.4%10403.47
Nov 10 18:00:00 - 18:59:59 105584 3.9% 29.3332.3 GB 4.0%9411.92
Nov 10 19:00:00 - 19:59:59 96587 3.5% 26.8330.2 GB 3.7%8810.57
Nov 10 20:00:00 - 20:59:59 116436 4.2% 32.3435.3 GB 4.3%10284.46
Nov 10 21:00:00 - 21:59:59 126300 4.6% 35.0836.4 GB 4.4%10589.30
Nov 10 22:00:00 - 22:59:59 139821 5.1% 38.8437.7 GB 4.6%10992.96
Nov 10 23:00:00 - 23:59:59 111080 4.1% 30.8632.8 GB 4.0%9543.28
Nov 11 00:00:00 - 00:59:59 86826 3.2% 24.1227.1 GB 3.3%7882.94
Nov 11 01:00:00 - 01:59:59 90504 3.3% 25.1429.0 GB 3.5%8447.24
Nov 11 02:00:00 - 02:59:59 81277 3.0% 22.5827.3 GB 3.3%7961.44
Nov 11 03:00:00 - 03:59:59 94988 3.5% 26.3930.1 GB 3.7%8779.14
Nov 11 04:00:00 - 04:15:02 24325 0.9% 26.977.4 GB 0.9%8622.38
TOTAL: 24:00:00 2740386 100.0% 31.72817.0 GB 100.0%9915.65
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 11406 208 0 3907 2 0 0 0 7289
2news.nask.pl 525 11 0 402 39 0 0 0 73
3news.icm.edu.pl 16 0 0 4 0 0 0 0 12
TOTAL: 3 11947 219 0 4313 41 0 0 0 7374

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 67
it.comp.os.win.windows10 59
comp.mobile.android 36
it.tlc.cellulari.android 27
de.rec.sf.startrek 5
nl.comp.os.linux.techniek 4
it.comp.os.win.windows8 4
rec.arts.tv.x-factor 3
it.comp.os.win.windows7 3
alt.sex.telephone.alt.sex.wanted 2
hr.comp.os.linux.ubuntu 2
uk.rec.cycling.moderated 2
comp.mobile.ipad 2
de.comp.lang.php 1
de.comp.office-pakete.ms-office.excel 1
hr.ponuda.hardver.komponente 1
TOTAL: 16 219

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

GroupsCount
christnet.evangelical 22
christnet.ethics 14
pl.sci.matematyka 3
pl.sci.historia 1
bit.listserv.catholic 1
TOTAL: 5 41

INND Perl filter [Top 20]:

ReasonCount
EMP (fsl) 6715
Binary in non-binary group 138
Too many newsgroups 4
EMP (md5) 4
Scoring filter (11) 1
HTML post 1
TOTAL: 6 6863

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 55626 7003 26399 8383 0 29 12%23:50:10
2panorama 50705 2401 21926 1022 25 73454 4%24:01:40
3poznan 7309 79 4709 32 0 0 1%23:54:43
4okapi 0 0 0 0 0 2702 0%24:00:01
5nask 0 0 0 0 0 12782 0%24:00:01
TOTAL: 5 113640 9483 53034 9437 25 88967 8%119:46:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm933.1 MB1.6 GB2.5 GB31.1 KB/s173.3 KB23:50:10
2panorama9.5 MB6.8 MB16.3 MB0.2 KB/s4.9 KB24:01:40
3poznan249.4 KB79.9 KB329.3 KB0.0 KB/s3.0 KB23:54:43
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 5942.9 MB1.6 GB2.6 GB6.2 KB/s141.9 KB119:46:35
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1auriga.rz.izeto.pl 1 76112.2 KB 1 0 000:11:49
2web.man.lodz.pl 288 6463.8 KB 27 0 000:00:28
3dmcs2.p.lodz.pl 10 4999.8 KB 6 0 001:24:19
4pc-212-51-218-225.p.lodz.pl 4 1123.7 KB 3 0 001:32:27
5isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 5 307 200299.6 KB 37 4 005:51:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.rz.izeto.pl 1 76112.2 KB 1 0 000:11:49
2*.man.lodz.pl 676 6463.8 KB 27 4 000:00:59
3*.p.lodz.pl 14 60123.5 KB 9 0 002:56:46
4*.elsnet.pl 2 00.0 KB 0 0 000:00:11
5*.toya.net.pl 49 00.0 KB 0 0 000:00:08
6unresolved 9 00.0 KB 0 0 002:41:33
TOTAL: 6 751 200299.6 KB 37 4 005:51:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.60 2.464 3.218 0.00002:40:04
pc-212-51-218-225.p.lodz.pl 0.011 0.046 0.00001:32:27
dmcs2.p.lodz.pl 0.027 0.119 0.00001:24:19
auriga.rz.izeto.pl 0.004 0.025 0.00000:11:49
212.191.2.11 0.005 0.036 0.00000:01:20
mon.man.lodz.pl 0.833 3.562 0.00000:00:29
web.man.lodz.pl 0.882 4.024 0.00000:00:28
host227.elsnet.pl 0.000 0.023 0.00000:00:11
212.51.203.199 0.000 0.037 0.00000:00:09
staticline41435.toya.net.pl 0.161 0.632 0.00000:00:08
david.man.lodz.pl 0.316 1.147 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.053 0.00000:00:00
? 0.004 0.009 0.00000:00:00
TOTAL: 13 4.719 12.931 0.00005:51:28

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 49
185.48.195.60 4
212.191.2.11 3
212.51.203.199 2
host227.elsnet.pl 2
TOTAL: 7 444

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-212-51-218-225.p.lodz.pl 3 0
185.48.195.60 3 0
TOTAL: 2 6 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 124 62.0%
2lodman 76 38.0%
TOTAL: 2 200100.0%

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

NewsgroupCount
1lodman.info 76
2pl.comp.pecet 44
3pl.misc.elektronika 43
4pl.comp.os.ms-windows.winnt 20
5pl.misc.kolej 17
TOTAL: 5 200