Daily Usenet report for news.niel.me

Sep 21 04:15:01 -- Sep 22 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 2353 28.9%446.8 KB 34.0%
nnrpd 2055 25.2%232.0 KB 17.6%
innd 1944 23.9%360.5 KB 27.4%
innfeed 1789 22.0%275.2 KB 20.9%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 8143 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11824 59.4%
Negative hits 5690 28.6%
Do not exist 2325 11.7%
Cache misses 81 0.4%
TOTAL: 4 19920 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%8 1.000 1.375 2.000
article cancel00:00:00.004 0.0%8 0.000 0.500 1.000
article cleanup00:00:00.049 0.0%2328 0.000 0.021 0.250
article logging00:00:00.173 0.0%2331 0.000 0.074 0.333
article parse00:00:00.345 0.0%4899 0.000 0.070 0.333
article write00:00:01.183 0.0%2188 0.000 0.541 1.444
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%8 0.000 0.250 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.115 0.0%19865 0.000 0.006 0.040
hisgrep/artcncl00:00:00.001 0.0%8 0.000 0.125 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%26 0.000 0.038 1.000
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
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.308 0.0%19927 0.000 0.015 0.115
history sync00:00:00.065 0.0%393 0.000 0.165 1.000
history write00:00:00.403 0.0%2327 0.000 0.173 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:47.749100.0%22122 758.796 3907.773 25039.417
nntp read00:00:00.505 0.0%21184 0.000 0.024 0.111
overview write00:00:00.704 0.0%2188 0.000 0.322 7.400
perl filter00:00:08.294 0.0%2327 1.800 3.564 8.500
python filter00:00:00.013 0.0%2327 0.000 0.006 0.091
site send00:00:00.996 0.0%4420 0.000 0.225 0.733
TOTAL: 24:01:08.41724:01:00.921100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%2375 0.000 0.010 0.125
article prepare00:00:00.004 0.0%576 0.000 0.007 0.250
article read00:00:00.032 0.0%140 0.000 0.229 1.000
backlog stats00:00:00.188 0.0%31844 0.000 0.006 0.022
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.443 0.0%16813 0.000 0.026 0.118
data write00:00:00.894 0.0%15068 0.000 0.059 0.167
idle23:57:39.894100.0%31844 955.406 2708.827 7705.513
status file00:00:00.498 0.0%240 0.000 2.075 7.000
TOTAL: 23:57:46.47123:57:41.976100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:31.710 22.8%1591 0.000 57.643 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.106 0.0%3685 0.000 0.029 1.000
readart00:00:00.014 0.0%63 0.222 0.222 0.222
TOTAL: 00:06:42.89600:01:31.830 22.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 3 2121 1154 967 0 54%23:59:09
2news.samoylyk.net 2 4165 300 3863 2 7%44:11:25
3gegeweb-out.news.tnetconsulting.net 2 1682 270 1388 24 16%22:43:14
4i2pn.org 2 2792 270 2521 1 9%33:17:00
5news.nntp4.net 2 2235 251 1918 66 11%24:06:21
6news.glou.org 5 234 17 213 4 7%08:04:30
7nntp.terraraq.uk 2 191 3 187 1 1%04:12:31
8localhost 25 0 0 0 0 0%00:00:00
9usenet.pasdenom.info 7 83 0 82 1 0%04:13:40
TOTAL: 9 50 13503 2265 11139 99 16%164:47:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.9 MB0.0 KB0.0 KB3.9 MB100%3.4 KB
2news.samoylyk.net1.6 MB0.0 KB2.1 KB1.6 MB 99%5.5 KB
3news.nntp4.net1.2 MB4.0 KB174.1 KB1.4 MB 87%4.4 KB
4gegeweb-out.news.tnetconsulting.net999.7 KB0.0 KB80.6 KB1.1 MB 92%3.7 KB
5i2pn.org850.5 KB0.0 KB1.3 KB851.7 KB 99%3.1 KB
6news.glou.org151.8 KB0.0 KB11.7 KB163.6 KB 92%7.8 KB
7nntp.terraraq.uk4.2 KB0.0 KB1.3 KB5.5 KB 76%1.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9usenet.pasdenom.info0.0 KB0.0 KB2.6 KB2.6 KB 0%2.6 KB
TOTAL: 98.6 MB4.0 KB273.7 KB8.9 MB 96%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 21 04:15:01 - 04:59:59 80 3.6% 0.03848.4 KB 10.2% 0.31
Sep 21 05:00:00 - 05:59:59 44 2.0% 0.01160.3 KB 1.9% 0.04
Sep 21 06:00:00 - 06:59:59 36 1.6% 0.01227.8 KB 2.7% 0.06
Sep 21 07:00:00 - 07:59:59 29 1.3% 0.01117.6 KB 1.4% 0.03
Sep 21 08:00:00 - 08:59:59 42 1.9% 0.01131.8 KB 1.6% 0.04
Sep 21 09:00:00 - 09:59:59 53 2.4% 0.01266.3 KB 3.2% 0.07
Sep 21 10:00:00 - 10:59:59 67 3.1% 0.02207.8 KB 2.5% 0.06
Sep 21 11:00:00 - 11:59:59 84 3.8% 0.02230.2 KB 2.8% 0.06
Sep 21 12:00:00 - 12:59:59 124 5.7% 0.03427.6 KB 5.1% 0.12
Sep 21 13:00:00 - 13:59:59 72 3.3% 0.02224.0 KB 2.7% 0.06
Sep 21 14:00:00 - 14:59:59 111 5.1% 0.03493.5 KB 5.9% 0.14
Sep 21 15:00:00 - 15:59:59 118 5.4% 0.03336.5 KB 4.0% 0.09
Sep 21 16:00:00 - 16:59:59 103 4.7% 0.03320.1 KB 3.8% 0.09
Sep 21 17:00:00 - 17:59:59 130 5.9% 0.04400.4 KB 4.8% 0.11
Sep 21 18:00:00 - 18:59:59 140 6.4% 0.04535.0 KB 6.4% 0.15
Sep 21 19:00:00 - 19:59:59 99 4.5% 0.03291.0 KB 3.5% 0.08
Sep 21 20:00:00 - 20:59:59 156 7.1% 0.04539.1 KB 6.5% 0.15
Sep 21 21:00:00 - 21:59:59 144 6.6% 0.04515.7 KB 6.2% 0.14
Sep 21 22:00:00 - 22:59:59 92 4.2% 0.03451.3 KB 5.4% 0.13
Sep 21 23:00:00 - 23:59:59 112 5.1% 0.03383.1 KB 4.6% 0.11
Sep 22 00:00:00 - 00:59:59 132 6.0% 0.04430.7 KB 5.2% 0.12
Sep 22 01:00:00 - 01:59:59 67 3.1% 0.02262.7 KB 3.1% 0.07
Sep 22 02:00:00 - 02:59:59 73 3.3% 0.02229.8 KB 2.8% 0.06
Sep 22 03:00:00 - 03:59:59 64 2.9% 0.02248.3 KB 3.0% 0.07
Sep 22 04:00:00 - 04:15:01 22 1.0% 0.0261.0 KB 0.7% 0.07
TOTAL: 24:00:00 2194 100.0% 0.038.1 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 67 0 0 1 0 0 0 0 66
2gegeweb-out.news.tnetconsulting.net 32 0 0 0 0 0 0 0 32
3usenet.pasdenom.info 21 0 0 0 0 0 0 0 21
4news.glou.org 13 0 0 0 0 0 0 0 13
5nntp.terraraq.uk 5 0 0 0 0 0 0 0 5
6news.samoylyk.net 2 0 0 0 0 0 0 0 2
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
8i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 8 143 0 0 1 0 0 0 0 142

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 48
Bad path (news.giganews.com.POSTED) 38
EMP (phn path) 27
EMP (md5) 5
Cancel for rejected article 2
Cancel of <ddb589e1875642addecbae772a5c858dd92c9e79@i2pn2.org> without Cancel-Key 1
Cancel of <1b4ea3b39254210573d2221991db5167f6126a62@i2pn2.org> without Cancel-Key 1
Cancel of <bc938f2987fa2b03e4693f4c3638fc5a26a5dec3@i2pn2.org> without Cancel-Key 1
Cancel of <2d26f7275eb5527cfd34ca335a873aa036d31f7e@i2pn2.org> without Cancel-Key 1
Cancel of <5e754dc0f2bb9dc20dc1a9613fafdd3ffb8d035a@i2pn2.org> without Cancel-Key 1
Cancel of <38585540fbc906622f23fe28645f5146881422cd@i2pn2.org> without Cancel-Key 1
Cancel of <1c0708e58f49f2b72078050d87c7cb378a48ee80@i2pn2.org> without Cancel-Key 1
Cancel of non-existing ID <vcn560$osq$1@cabale.usenet-fr.net> 1
Cancel of <bce78c204f0235299f89ee6e4628e0d4cebcd4e1@i2pn2.org> without Cancel-Key 1
Cancel of <50540e5ef630ec87894f1a1298f0bfad352046ff@i2pn2.org> without Cancel-Key 1
Cancel of <5bb73ff1eb212c9c22628ff908ffd2a008e559aa@i2pn2.org> without Cancel-Key 1
Cancel of <64fb025167d0f9ad0b7d93e9944e92973a7c17bc@i2pn2.org> without Cancel-Key 1
Cancel of <4e49850ede07e6dd65b156eda6b692ba874c4c3d@i2pn2.org> without Cancel-Key 1
Cancel of <7fab102ac8b458db1cd504c834fc25646ed7c43c@i2pn2.org> without Cancel-Key 1
Cancel of <3bb4c26366ecf64d884514dd9fc67081ffa4f4e8@i2pn2.org> without Cancel-Key 1
TOTAL: 24 139

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 2
nntp.terraraq.uk 1
TOTAL: 2 3
TOTAL: 1 3

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3242 58 1895 1 0 88 1%23:59:57
2news.gegeweb.org 1065 29 983 0 0 0 2%23:39:51
3news.samoylyk.net 2515 15 1952 30 0 49 0%23:59:57
4news.nntp4.net 2073 2 1934 1 0 8 0%23:59:58
5nntp.terraraq.uk 1214 1 1191 1 0 1 0%23:54:33
6news.tnetconsulting.net 3573 1 2185 5 0 41 0%23:59:57
7news.aioe.org 0 0 0 0 0 1831 0%24:00:00
8news.pasdenom.info 1745 0 1632 0 0 0 0%23:54:54
TOTAL: 8 15427 106 11772 38 0 2018 0%191:29:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org216.0 KB4.6 KB220.7 KB0.0 KB/s3.7 KB23:59:57
2news.gegeweb.org106.9 KB0.0 KB106.9 KB0.0 KB/s3.7 KB23:39:51
3news.samoylyk.net87.3 KB217.1 KB304.4 KB0.0 KB/s6.8 KB23:59:57
4news.nntp4.net5.1 KB8.5 KB13.6 KB0.0 KB/s4.5 KB23:59:58
5news.tnetconsulting.net4.4 KB25.0 KB29.4 KB0.0 KB/s4.9 KB23:59:57
6nntp.terraraq.uk2.7 KB1.9 KB4.6 KB0.0 KB/s2.3 KB23:54:33
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:54
TOTAL: 8422.5 KB257.1 KB679.6 KB0.0 KB/s4.7 KB191:29:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 2 63123.2 KB 7 0 000:00:24
TOTAL: 1 2 63123.2 KB 7 0 000:06:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 16 63123.2 KB 7 0 000:04:14
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:00
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:05
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
7*.ip.linodeusercontent.com 59 00.0 KB 0 0 000:00:14
TOTAL: 7 371 63123.2 KB 7 0 000:06:42

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 5.089 4.227 1.69900:02:00
206.168.34.123 0.093 0.036 0.00000:01:09
206.168.34.48 0.033 0.033 0.00000:00:35
206.168.34.60 0.014 0.014 0.00000:00:30
206.168.34.50 0.044 0.020 0.00000:00:30
206.168.34.52 0.037 0.029 0.00000:00:30
69.10.48.174 0.055 0.068 0.00000:00:24
172-105-246-139.ip.linodeusercontent.com 1.545 0.773 0.00000:00:14
198.235.24.185 0.011 0.011 0.00000:00:10
198.235.24.14 0.021 0.012 0.00000:00:10
104.152.52.151 0.005 0.019 0.00000:00:10
harmonious.monitoring.internet-measurement.com 0.038 0.004 0.00000:00:05
server-0-3.survey.inspici.com 0.027 0.023 0.00000:00:04
108.210.203.35.bc.googleusercontent.com 0.068 0.020 0.00000:00:01
147.185.132.197 0.031 0.009 0.00000:00:01
80.66.76.130 0.046 0.015 0.00000:00:00
azpdeg66.stretchoid.com 0.028 0.024 0.00000:00:00
194.165.16.72 0.038 0.023 0.00000:00:00
104.152.52.133 0.030 0.021 0.00000:00:00
91.238.181.22 0.025 0.025 0.00000:00:00
TOTAL: 23 7.359 5.473 1.69900:06:42

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
172-105-246-139.ip.linodeusercontent.com 59
206.168.34.123 2
azpdeg66.stretchoid.com 1
206.168.34.50 1
104.152.52.133 1
server-0-3.survey.inspici.com 1
104.152.52.151 1
206.168.34.48 1
harmonious.monitoring.internet-measurement.com 1
amazing.monitoring.internet-measurement.com 1
194.165.16.72 1
tranquil.monitoring.internet-measurement.com 1
dignified.monitoring.internet-measurement.com 1
108.210.203.35.bc.googleusercontent.com 1
147.185.132.197 1
198.235.24.14 1
80.66.76.130 1
198.235.24.185 1
91.238.181.22 1
TOTAL: 23 369

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.132.197 4
108.210.203.35.bc.googleusercontent.com 4
azpdeg66.stretchoid.com 1
91.238.181.22 1
TOTAL: 4 10

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 2
GET / HTTP/1.1 2
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
#003 1
MGLNDD_45.13.105.36_119 1
TOTAL: 6 10

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.22 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 53 84.1%
2local 10 15.9%
TOTAL: 2 63100.0%

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

NewsgroupCount
1grisbi.user.french 10
2local.test 10
3grisbi.bugsreports 10
4grisbi.cvs 10
5grisbi.test 10
6grisbi.devel 10
7grisbi.user 3
TOTAL: 7 63
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me