Daily Usenet report for news.niel.me

Sep 28 04:15:01 -- Sep 29 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 2320 28.1%427.8 KB 32.4%
innd 2271 27.5%405.6 KB 30.8%
nnrpd 1892 22.9%204.3 KB 15.5%
innfeed 1785 21.6%280.3 KB 21.3%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 8270 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12453 61.3%
Negative hits 5574 27.4%
Do not exist 2285 11.2%
Cache misses 1 0.0%
TOTAL: 4 20313 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.021 0.0%13 0.000 1.615 3.000
article cancel00:00:00.000 0.0%13 0.000 0.000 0.000
article cleanup00:00:00.063 0.0%2293 0.000 0.027 0.333
article logging00:00:00.181 0.0%2294 0.000 0.079 0.400
article parse00:00:00.339 0.0%4673 0.000 0.073 0.400
article write00:00:01.034 0.0%1991 0.000 0.519 2.000
artlog/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 0.500
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.116 0.0%20984 0.000 0.006 0.048
hisgrep/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%23 0.000 0.087 1.000
hishave/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.324 0.0%20369 0.000 0.016 0.061
history sync00:00:00.061 0.0%395 0.000 0.154 1.000
history write00:00:00.459 0.0%2293 0.000 0.200 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:53.218100.0%23203 1532.163 3725.950 37520.125
nntp read00:00:00.612 0.0%22420 0.000 0.027 0.083
overview write00:00:00.721 0.0%1991 0.000 0.362 4.000
perl filter00:00:09.038 0.0%2293 1.500 3.942 10.000
python filter00:00:00.014 0.0%2293 0.000 0.006 0.105
site send00:00:00.816 0.0%4020 0.000 0.203 0.533
TOTAL: 24:01:14.29624:01:07.020100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%2043 0.000 0.008 0.111
article prepare00:00:00.001 0.0%460 0.000 0.002 0.125
article read00:00:00.022 0.0%106 0.000 0.208 5.000
backlog stats00:00:00.191 0.0%31486 0.000 0.006 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.432 0.0%16332 0.000 0.026 0.115
data write00:00:00.879 0.0%14509 0.000 0.061 0.174
idle23:59:47.158100.0%31486 952.041 2743.669 8968.403
status file00:00:00.554 0.0%247 0.000 2.243 7.000
TOTAL: 23:59:55.05423:59:49.253100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:01.105 17.9%1464 0.000 41.738 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.134 0.0%3526 0.000 0.038 0.500
readart00:00:00.047 0.0%605 0.078 0.078 0.078
TOTAL: 00:05:41.42200:01:01.286 18.0%----

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
1feed-out.gegeweb.org 4 1960 1020 940 0 52%23:52:47
2gegeweb-out.news.tnetconsulting.net 3 1661 211 1408 42 12%22:38:56
3usenet.pasdenom.info 8 2424 207 2168 49 8%41:04:12
4i2pn.org 2 1890 203 1687 0 10%20:29:44
5news.nntp4.net 2 2727 190 2327 210 6%27:50:20
6news.glou.org 2 1709 89 1533 87 5%23:56:04
7news.samoylyk.net 3 1024 74 949 1 7%14:35:52
8nntp.terraraq.uk 4 1837 40 1797 0 2%25:22:44
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 53 15232 2034 12809 389 13%199:50:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.0 MB0.0 KB0.0 KB3.0 MB100%3.1 KB
2news.samoylyk.net864.6 KB0.0 KB24.5 KB889.1 KB 97%11.9 KB
3gegeweb-out.news.tnetconsulting.net846.9 KB0.0 KB221.6 KB1.0 MB 79%4.2 KB
4i2pn.org556.0 KB0.0 KB0.0 KB556.0 KB100%2.7 KB
5news.nntp4.net516.3 KB0.0 KB952.5 KB1.4 MB 35%3.7 KB
6usenet.pasdenom.info482.4 KB0.0 KB59.2 KB541.6 KB 89%2.1 KB
7nntp.terraraq.uk336.3 KB0.0 KB0.0 KB336.3 KB100%8.4 KB
8news.glou.org310.0 KB0.0 KB213.4 KB523.3 KB 59%3.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 96.9 MB0.0 KB1.4 MB8.3 MB 82%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 04:15:01 - 04:59:59 35 1.8% 0.01145.3 KB 2.1% 0.05
Sep 28 05:00:00 - 05:59:59 22 1.1% 0.01119.8 KB 1.7% 0.03
Sep 28 06:00:00 - 06:59:59 42 2.1% 0.01122.8 KB 1.8% 0.03
Sep 28 07:00:00 - 07:59:59 42 2.1% 0.01110.1 KB 1.6% 0.03
Sep 28 08:00:00 - 08:59:59 37 1.9% 0.0196.6 KB 1.4% 0.03
Sep 28 09:00:00 - 09:59:59 79 4.0% 0.02331.8 KB 4.7% 0.09
Sep 28 10:00:00 - 10:59:59 99 5.0% 0.03727.1 KB 10.4% 0.20
Sep 28 11:00:00 - 11:59:59 88 4.4% 0.02256.2 KB 3.7% 0.07
Sep 28 12:00:00 - 12:59:59 96 4.8% 0.03409.7 KB 5.9% 0.11
Sep 28 13:00:00 - 13:59:59 100 5.0% 0.03279.0 KB 4.0% 0.08
Sep 28 14:00:00 - 14:59:59 91 4.6% 0.03242.2 KB 3.5% 0.07
Sep 28 15:00:00 - 15:59:59 117 5.9% 0.03356.0 KB 5.1% 0.10
Sep 28 16:00:00 - 16:59:59 115 5.8% 0.03319.0 KB 4.6% 0.09
Sep 28 17:00:00 - 17:59:59 77 3.9% 0.02284.2 KB 4.1% 0.08
Sep 28 18:00:00 - 18:59:59 98 4.9% 0.03296.6 KB 4.2% 0.08
Sep 28 19:00:00 - 19:59:59 142 7.1% 0.04456.6 KB 6.5% 0.13
Sep 28 20:00:00 - 20:59:59 102 5.1% 0.03292.5 KB 4.2% 0.08
Sep 28 21:00:00 - 21:59:59 110 5.5% 0.03386.0 KB 5.5% 0.11
Sep 28 22:00:00 - 22:59:59 94 4.7% 0.03275.4 KB 3.9% 0.08
Sep 28 23:00:00 - 23:59:59 138 6.9% 0.04458.5 KB 6.6% 0.13
Sep 29 00:00:00 - 00:59:59 100 5.0% 0.03366.5 KB 5.2% 0.10
Sep 29 01:00:00 - 01:59:59 61 3.1% 0.02271.2 KB 3.9% 0.08
Sep 29 02:00:00 - 02:59:59 57 2.9% 0.02239.1 KB 3.4% 0.07
Sep 29 03:00:00 - 03:59:59 35 1.8% 0.0193.3 KB 1.3% 0.03
Sep 29 04:00:00 - 04:15:02 14 0.7% 0.0264.2 KB 0.9% 0.07
TOTAL: 24:00:01 1991 100.0% 0.026.8 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 153 0 0 0 0 0 0 0 153
2news.glou.org 87 0 0 0 0 0 0 0 87
3gegeweb-out.news.tnetconsulting.net 42 0 0 0 0 0 0 0 42
4usenet.pasdenom.info 20 0 0 0 0 0 0 0 20
5i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 5 303 0 0 0 0 0 0 0 303

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 146
EMP (phn path) 97
Bad path (news.giganews.com.POSTED) 44
Cancels abusifs 3
Cancel of <d0d9338615dc71f31eaa2dbe552e0bf57d446a5d@i2pn2.org> without Cancel-Key 1
Cancel of <66cfba6765edc3eb2a63ad3203d0c6fe4f93fc60@i2pn2.org> without Cancel-Key 1
Too many newsgroups (meow) 1
Cancel of <c5d9238ee6494ef1bf914d01ccff21d2f7707821@i2pn2.org> without Cancel-Key 1
Cancel of <80339038f69deba1bdaa8dcb8ac6a9406d56b690@i2pn2.org> without Cancel-Key 1
Cancel of <fcb515443463dae63bb3635cb302c8e2929899e5@i2pn2.org> without Cancel-Key 1
Cancel of <f5b54932016a9934e6c6443dc7f8214e7ddc08d0@i2pn2.org> without Cancel-Key 1
Cancel of <e86dcc424181c09369ad697ea79a50d5daeec0dc@i2pn2.org> without Cancel-Key 1
EMP (md5) 1
Cancel of <e216d20cea9979793199635853e4d6d4fa368ac6@i2pn2.org> without Cancel-Key 1
Cancel of <d98b7e5fa6cb73f4ce122c09c494bc820503ed48@i2pn2.org> without Cancel-Key 1
Cancel of <aa81ab16ec3844250b10d9a609863ed42fcb4191@i2pn2.org> without Cancel-Key 1
TOTAL: 16 302

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
gegeweb-out.news.tnetconsulting.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3004 44 1733 10 0 23 1%23:53:26
2news.gegeweb.org 1076 42 946 0 0 0 3%23:16:24
3news.tnetconsulting.net 3313 4 1972 12 0 3 0%23:56:05
4news.samoylyk.net 2187 3 1822 0 0 25 0%23:56:01
5news.aioe.org 0 0 0 0 0 1622 0%24:00:01
6news.nntp4.net 1926 0 1813 0 0 2 0%23:56:01
7nntp.terraraq.uk 1269 0 1199 0 0 0 0%23:55:07
8news.pasdenom.info 1824 0 1614 0 0 0 0%23:56:05
TOTAL: 8 14599 93 11099 22 0 1675 0%190:49:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org163.9 KB0.0 KB163.9 KB0.0 KB/s3.9 KB23:16:24
2i2pn.org114.4 KB57.1 KB171.6 KB0.0 KB/s3.2 KB23:53:26
3news.tnetconsulting.net17.4 KB29.8 KB47.2 KB0.0 KB/s2.9 KB23:56:05
4news.samoylyk.net11.6 KB0.0 KB11.6 KB0.0 KB/s3.9 KB23:56:01
5news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:01
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:07
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:05
TOTAL: 8307.3 KB86.9 KB394.2 KB0.0 KB/s3.4 KB190:49:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:8dd8:5a7d:9560:b106 1 626.7 KB 5 0 000:02:26
TOTAL: 1 1 626.7 KB 5 0 000:05:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 626.7 KB 5 0 000:02:31
2*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:12
3*.149.216.162.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*.subs.proxad.net 2 00.0 KB 0 0 000:00:00
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
7*.gegeweb.eu 288 00.0 KB 0 0 000:01:40
8unresolved 8 00.0 KB 0 0 000:01:09
TOTAL: 8 307 626.7 KB 5 0 000:05:40

NNRP auth users [Top 20]:

UserConn
mailman 288
gerald 1
TOTAL: 2 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a0e:e701:1154:0:8dd8:5a7d:9560:b106 0.125 0.128 0.00900:02:26
mail.gegeweb.eu 5.082 4.453 1.71100:01:40
206.168.34.55 0.016 0.012 0.00000:00:31
147.185.133.185 0.026 0.028 0.00000:00:12
205.210.31.245 0.009 0.013 0.00000:00:10
87.251.75.136 0.027 0.024 0.00000:00:10
champion.monitoring.internet-measurement.com 0.059 0.047 0.00000:00:08
2607:ff10:c8:594::d 0.034 0.017 0.00000:00:04
server-0-3.survey.inspici.com 0.015 0.007 0.00000:00:04
198.235.24.203 0.033 0.017 0.00000:00:03
congratulated.monitoring.internet-measurement.com 0.010 0.013 0.00000:00:01
sunny.monitoring.internet-measurement.com 0.014 0.009 0.00000:00:01
208.149.216.162.bc.googleusercontent.com 0.059 0.024 0.00000:00:01
94.156.69.95 0.036 0.024 0.00000:00:00
91.238.181.21 0.029 0.021 0.00000:00:00
147.185.132.142 0.060 0.028 0.00000:00:00
azpdsgc22.stretchoid.com 0.020 0.032 0.00000:00:00
88-165-5-23.subs.proxad.net 0.052 0.047 0.00000:00:00
TOTAL: 18 5.706 4.944 1.72000:05:40

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
champion.monitoring.internet-measurement.com 2
88-165-5-23.subs.proxad.net 2
91.238.181.21 1
server-0-3.survey.inspici.com 1
206.168.34.55 1
congratulated.monitoring.internet-measurement.com 1
2607:ff10:c8:594::d 1
147.185.132.142 1
azpdsgc22.stretchoid.com 1
147.185.133.185 1
87.251.75.136 1
94.156.69.95 1
208.149.216.162.bc.googleusercontent.com 1
198.235.24.203 1
sunny.monitoring.internet-measurement.com 1
205.210.31.245 1
TOTAL: 17 306

NNRP unrecognized commands (by host):

SystemConn
147.185.133.185 4
208.149.216.162.bc.googleusercontent.com 4
147.185.132.142 4
azpdsgc22.stretchoid.com 1
91.238.181.21 1
TOTAL: 5 14

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.21 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1fr 5 83.3%
2local 1 16.7%
TOTAL: 2 6100.0%

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

NewsgroupCount
1fr.usenet.forums.annonces 2
2fr.usenet.forums.evolution 1
3fr.usenet.documents 1
4fr.usenet.distribution 1
5local.test 1
TOTAL: 5 6