Daily Usenet report for news.niel.me

Sep 3 04:15:02 -- Sep 4 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 6483 46.4%1.2 MB 52.2%
innd 3936 28.2%571.0 KB 25.3%
nnrpd 1781 12.7%193.2 KB 8.6%
innfeed 1748 12.5%310.7 KB 13.8%
nocem 32 0.2%3.5 KB 0.2%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 13981 100.0%2.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 28335 55.1%
Negative hits 16681 32.4%
Do not exist 6445 12.5%
Cache misses 7 0.0%
TOTAL: 4 51468 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.008 0.0%8 0.000 1.000 2.000
article cancel00:00:00.012 0.0%72 0.000 0.167 1.000
article cleanup00:00:00.127 0.0%6438 0.000 0.020 0.103
article logging00:00:00.445 0.0%6438 0.000 0.069 0.188
article parse00:00:01.707 0.0%30751 0.000 0.056 0.163
article write00:00:02.395 0.0%4474 0.250 0.535 1.111
artlog/artcncl00:00:00.005 0.0%57 0.000 0.088 1.000
artlog/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 1.000
data move00:00:00.440 0.0%76502 0.000 0.006 0.018
hisgrep/artcncl00:00:00.000 0.0%23 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 1.000
hisgrep/perl00:00:00.002 0.0%28 0.000 0.071 1.000
hishave/artcncl00:00:00.002 0.0%72 0.000 0.028 0.083
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.804 0.0%51621 0.000 0.016 0.036
history sync00:00:00.051 0.0%371 0.000 0.137 1.000
history write00:00:01.279 0.0%6435 0.038 0.199 0.538
hiswrite/artcncl00:00:00.004 0.0%49 0.000 0.082 0.250
idle24:00:01.299 99.9%75946 435.785 1137.668 4169.118
nntp read00:00:02.060 0.0%75314 0.007 0.027 0.059
overview write00:00:01.291 0.0%4474 0.040 0.289 1.750
perl filter00:00:32.443 0.0%6435 2.667 5.042 8.086
python filter00:00:00.028 0.0%6435 0.000 0.004 0.056
site send00:00:01.613 0.0%9098 0.020 0.177 0.636
TOTAL: 24:01:01.77324:00:46.017100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.034 0.0%4534 0.000 0.007 0.071
article prepare00:00:00.004 0.0%1128 0.000 0.004 0.083
article read00:00:00.033 0.0%195 0.000 0.169 1.000
backlog stats00:00:00.341 0.0%68144 0.000 0.005 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.003 0.0%44049 0.000 0.023 0.058
data write00:00:01.801 0.0%34120 0.020 0.053 0.090
idle23:58:52.327100.0%68144 546.163 1266.910 3977.076
status file00:00:00.599 0.0%199 1.000 3.010 13.000
TOTAL: 23:59:00.14623:58:56.142100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.027 25.5%1462 10.400 19.170 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.101 0.1%3226 0.000 0.031 0.273
TOTAL: 00:01:49.70200:00:28.128 25.6%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1gegeweb-out.news.tnetconsulting.net 2 5280 1438 3822 20 27%29:39:22
2feed-out.gegeweb.org 2 1980 1037 941 2 52%23:58:16
3news.glou.org 2 6252 848 4863 541 13%31:29:14
4i2pn.org 1 5342 760 4027 555 14%23:00:10
5news.nntp4.net 1 5521 336 4521 664 6%20:13:55
6usenet.pasdenom.info 2 2386 156 2218 12 6%23:58:27
7nntp.terraraq.uk 2 4424 81 4298 45 1%20:21:22
8news.samoylyk.net 2 4307 19 4281 7 0%22:48:53
9localhost 28 0 0 0 0 0%00:00:00
TOTAL: 9 42 35492 4675 28971 1846 13%195:29:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net12.6 MB52.5 KB257.5 KB12.9 MB 97%9.1 KB
2news.glou.org8.8 MB52.5 KB6.2 MB15.1 MB 58%11.1 KB
3feed-out.gegeweb.org6.7 MB0.0 KB2.8 KB6.7 MB 99%6.6 KB
4i2pn.org3.4 MB0.0 KB5.9 MB9.3 MB 36%7.2 KB
5news.nntp4.net2.3 MB0.0 KB6.1 MB8.3 MB 27%8.5 KB
6usenet.pasdenom.info501.7 KB0.0 KB19.1 KB520.8 KB 96%3.1 KB
7nntp.terraraq.uk368.5 KB0.0 KB440.9 KB809.4 KB 45%6.4 KB
8news.samoylyk.net189.4 KB52.4 KB63.9 KB305.8 KB 61%11.8 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 934.8 MB157.4 KB18.9 MB53.9 MB 64%8.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 3 04:15:02 - 04:59:59 115 2.6% 0.041.1 MB 3.3% 0.42
Sep 3 05:00:00 - 05:59:59 124 2.8% 0.03847.3 KB 2.5% 0.24
Sep 3 06:00:00 - 06:59:59 143 3.2% 0.041.3 MB 3.8% 0.36
Sep 3 07:00:00 - 07:59:59 138 3.1% 0.041.8 MB 5.4% 0.51
Sep 3 08:00:00 - 08:59:59 118 2.6% 0.031.7 MB 5.2% 0.49
Sep 3 09:00:00 - 09:59:59 143 3.2% 0.04747.1 KB 2.2% 0.21
Sep 3 10:00:00 - 10:59:59 155 3.5% 0.04894.7 KB 2.6% 0.25
Sep 3 11:00:00 - 11:59:59 216 4.8% 0.061.1 MB 3.4% 0.33
Sep 3 12:00:00 - 12:59:59 177 4.0% 0.051.4 MB 4.3% 0.41
Sep 3 13:00:00 - 13:59:59 136 3.0% 0.041.2 MB 3.6% 0.34
Sep 3 14:00:00 - 14:59:59 166 3.7% 0.051.2 MB 3.6% 0.34
Sep 3 15:00:00 - 15:59:59 176 3.9% 0.05822.8 KB 2.4% 0.23
Sep 3 16:00:00 - 16:59:59 253 5.7% 0.072.1 MB 6.4% 0.61
Sep 3 17:00:00 - 17:59:59 186 4.2% 0.051.0 MB 3.0% 0.29
Sep 3 18:00:00 - 18:59:59 340 7.6% 0.092.3 MB 7.0% 0.66
Sep 3 19:00:00 - 19:59:59 371 8.3% 0.102.0 MB 5.9% 0.56
Sep 3 20:00:00 - 20:59:59 240 5.4% 0.072.8 MB 8.3% 0.79
Sep 3 21:00:00 - 21:59:59 266 5.9% 0.072.6 MB 7.9% 0.75
Sep 3 22:00:00 - 22:59:59 206 4.6% 0.061.3 MB 3.8% 0.36
Sep 3 23:00:00 - 23:59:59 237 5.3% 0.071.0 MB 3.1% 0.30
Sep 4 00:00:00 - 00:59:59 188 4.2% 0.051.8 MB 5.5% 0.52
Sep 4 01:00:00 - 01:59:59 119 2.7% 0.03694.2 KB 2.0% 0.19
Sep 4 02:00:00 - 02:59:59 123 2.7% 0.03688.6 KB 2.0% 0.19
Sep 4 03:00:00 - 03:59:59 91 2.0% 0.03656.5 KB 1.9% 0.18
Sep 4 04:00:00 - 04:15:01 48 1.1% 0.05256.1 KB 0.8% 0.28
TOTAL: 23:59:59 4475 100.0% 0.0533.3 MB 100.0% 0.40
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 805 0 0 0 0 0 0 0 805
2i2pn.org 570 0 0 0 0 0 0 0 570
3news.glou.org 477 0 0 1 0 0 0 0 476
4nntp.terraraq.uk 55 0 0 0 0 0 0 0 55
5gegeweb-out.news.tnetconsulting.net 18 0 0 1 0 0 0 0 17
6usenet.pasdenom.info 8 0 0 0 0 0 0 0 8
7news.samoylyk.net 7 0 0 1 0 0 0 0 6
8feed-out.gegeweb.org 3 0 0 0 0 0 0 0 3
TOTAL: 8 1943 0 0 3 0 0 0 0 1940

INND Perl filter [Top 20]:

ReasonCount
EMP (phr nph) 757
EMP (md5) 679
EMP (phn nph) 177
Too many newsgroups 129
EMP (phn path) 85
Bad path (news.giganews.com.POSTED) 54
EMP (phl) 31
Binary: misplaced binary 5
Too many newsgroups (low_xpost) 3
Cancel of non-existing ID <178169904e7c3f70$716254$401217$a92e2ab9@news.vipernews.com> 1
Cancel of non-existing ID <17817c9fcc5ab1a2$316839$1701393$a92e2ab9@news.vipernews.com> 1
Cancel of <64f4d009$0$7449$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of non-existing ID <178169900f1c11b3$716250$401217$a92e2ab9@news.vipernews.com> 1
Cancel of non-existing ID <17817c9ff317b932$879745$2031818$a92e2ab9@news.vipernews.com> 1
Cancel of non-existing ID <51ec63e5-120a-45cb-99c3-32e8d5f03e3bn@googlegroups.com> 1
Cancel of non-existing ID <17813c172aa99c6f$872039$2031818$a92e2ab9@news.vipernews.com> 1
Cancel of non-existing ID <_F0JM.1047659$6Li6.787529@fx12.ams4> 1
Cancel of non-existing ID <32c59b0a-4028-49e7-bfec-d3136b61d909n@googlegroups.com> 1
Cancel of non-existing ID <_F0JM.1047658$6Li6.415584@fx12.ams4> 1
Cancel of <64f4d0d7$0$25952$426a74cc@news.free.fr> without Cancel-Key 1
TOTAL: 29 1940

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com2906464
TOTAL: 12906464

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 6438 59 4383 5 0 18 0%23:59:56
2nntp.terraraq.uk 3960 54 3393 3 0 3 1%23:59:56
3news.nntp4.net 4547 51 3991 0 0 4 1%23:59:41
4i2pn.org 5365 50 3587 2 0 32 0%23:59:56
5news.tnetconsulting.net 6185 42 4404 7 0 20 0%23:59:56
6news.pasdenom.info 4162 4 3976 2 0 0 0%23:59:52
7news.gegeweb.org 3537 3 3435 0 0 0 0%23:59:41
8news.aioe.org 0 0 0 0 0 3021 0%23:59:55
TOTAL: 8 34194 263 27169 19 0 3098 0%191:58:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net1.0 MB0.0 KB1.0 MB0.0 KB/s20.7 KB23:59:41
2nntp.terraraq.uk699.4 KB81.7 KB781.1 KB0.0 KB/s13.7 KB23:59:56
3news.samoylyk.net320.5 KB24.5 KB345.0 KB0.0 KB/s5.4 KB23:59:56
4i2pn.org247.6 KB9.3 KB257.0 KB0.0 KB/s4.9 KB23:59:56
5news.tnetconsulting.net213.3 KB24.4 KB237.7 KB0.0 KB/s4.9 KB23:59:56
6news.gegeweb.org22.2 KB0.0 KB22.2 KB0.0 KB/s7.4 KB23:59:41
7news.pasdenom.info9.4 KB7.7 KB17.1 KB0.0 KB/s2.8 KB23:59:52
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 82.5 MB147.6 KB2.7 MB0.0 KB/s9.6 KB191:58:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.243.134.45 1 00.0 KB 0 0 000:00:01
2mail.gegeweb.eu 288 00.0 KB 0 0 000:01:31
345.227.254.55 1 00.0 KB 0 0 000:00:00
445.227.254.49 1 00.0 KB 0 0 000:00:00
588.165.5.23 4 00.0 KB 0 0 000:00:01
6steadfast.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
7128.1.41.5 3 00.0 KB 0 0 000:00:10
TOTAL: 7 299 00.0 KB 0 0 000:01:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:31
2unresolved 10 00.0 KB 0 0 000:00:14
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 3 299 00.0 KB 0 0 000:01:49

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.291 3.964 1.53900:01:31
128.1.41.5 0.051 0.040 0.00000:00:10
steadfast.monitoring.internet-measurement.com 0.036 0.016 0.00000:00:02
162.243.134.45 0.024 0.028 0.00000:00:01
88.165.5.23 0.055 0.063 0.00000:00:01
45.227.254.55 0.042 0.015 0.00000:00:00
45.227.254.49 0.030 0.021 0.00000:00:00
TOTAL: 7 4.529 4.147 1.53900:01:49

NNRP unrecognized commands (by host):

SystemConn
128.1.41.5 2
45.227.254.49 1
162.243.134.45 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

CommandCount
#023#003#023#001#023#002#001 1
MGLNDD_45.13.105.36_119 1
#003 1
#026#003#001#001#011#001 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.49 1 1
TOTAL: 1 1 1