Daily Usenet report for news.niel.me

Dec 30 04:15:01 -- Dec 31 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 15017 69.8%3.0 MB 76.2%
innd 2710 12.6%445.5 KB 10.9%
innfeed 1928 9.0%322.6 KB 7.9%
nnrpd 1842 8.6%204.1 KB 5.0%
nocem 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 21500 100.0%4.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 27836 43.9%
Negative hits 21054 33.2%
Do not exist 14459 22.8%
Cache misses 64 0.1%
TOTAL: 4 63413 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.291 0.0%218 0.000 1.335 5.000
article cancel00:00:00.032 0.0%220 0.000 0.145 1.000
article cleanup00:00:00.311 0.0%14579 0.000 0.021 0.068
article logging00:00:01.049 0.0%14580 0.000 0.072 0.152
article parse00:00:03.662 0.0%68875 0.025 0.053 0.105
article write00:00:11.313 0.0%13789 0.387 0.820 1.615
artlog/artcncl00:00:00.006 0.0%220 0.000 0.027 1.000
artlog/artcncl/perl00:00:00.018 0.0%218 0.000 0.083 1.000
data move00:00:01.483 0.0%132906 0.000 0.011 0.023
hisgrep/artcncl00:00:00.004 0.0%219 0.000 0.018 1.000
hisgrep/artcncl/perl00:00:00.010 0.0%218 0.000 0.046 1.000
hisgrep/perl00:00:00.061 0.0%233 0.000 0.262 1.000
hishave/artcncl00:00:00.001 0.0%220 0.000 0.005 0.333
hishave/artcncl/perl00:00:00.002 0.0%218 0.000 0.009 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.269 0.0%63407 0.002 0.020 0.042
history sync00:00:00.054 0.0%409 0.000 0.132 1.000
history write00:00:02.576 0.0%14579 0.067 0.177 0.323
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:59:08.185 99.9%117562 416.965 734.491 1982.221
nntp read00:00:03.437 0.0%117001 0.014 0.029 0.052
overview write00:00:05.034 0.0%13789 0.097 0.365 1.758
perl filter00:00:58.819 0.1%14579 2.694 4.035 6.327
python filter00:00:00.076 0.0%14579 0.000 0.005 0.081
site send00:00:03.648 0.0%28896 0.025 0.126 0.259
TOTAL: 24:01:03.60324:00:41.341100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.134 0.0%13888 0.000 0.010 0.056
article prepare00:00:00.025 0.0%6776 0.000 0.004 0.250
article read00:00:00.163 0.0%947 0.000 0.172 4.000
backlog stats00:00:01.077 0.0%227111 0.000 0.005 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.432 0.0%150729 0.011 0.023 0.041
data write00:00:06.184 0.0%116195 0.031 0.053 0.106
idle23:55:39.515100.0%227111 222.371 379.284 1198.230
status file00:00:00.450 0.0%193 1.000 2.332 8.000
TOTAL: 23:56:02.20323:55:50.980100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:10.269 43.4%1447 13.000 48.562 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.091 0.1%3253 0.000 0.028 0.273
TOTAL: 00:02:41.73300:01:10.360 43.5%----

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
1news.nntp4.net 2 13790 6281 6944 565 45%23:58:04
2news.glou.org 2 8045 5193 2681 171 64%25:32:40
3feed-out.gegeweb.org 3 3582 1204 2378 0 33%25:13:41
4usenet.pasdenom.info 1 3336 693 2625 18 20%28:10:13
5i2pn.org 1 3227 231 2996 0 7%20:54:59
6nntp.terraraq.uk 2 673 52 621 0 7%06:29:51
7gegeweb-out.news.tnetconsulting.net 2 743 34 699 10 4%07:15:18
8news.samoylyk.net 1 275 1 274 0 0%02:15:03
9localhost 26 0 0 0 0 0%00:00:00
TOTAL: 9 40 33671 13689 19218 764 40%139:49:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net66.4 MB0.0 KB3.2 MB69.6 MB 95%10.4 KB
2news.glou.org33.1 MB0.0 KB530.8 KB33.7 MB 98%6.4 KB
3feed-out.gegeweb.org5.8 MB0.0 KB0.0 KB5.8 MB100%4.9 KB
4usenet.pasdenom.info1.9 MB0.0 KB26.1 KB1.9 MB 98%2.8 KB
5i2pn.org1.9 MB0.0 KB0.0 KB1.9 MB100%8.2 KB
6nntp.terraraq.uk220.3 KB0.0 KB0.0 KB220.3 KB100%4.2 KB
7gegeweb-out.news.tnetconsulting.net83.4 KB0.0 KB192.3 KB275.7 KB 30%6.3 KB
8news.samoylyk.net4.0 KB0.0 KB0.0 KB4.0 KB100%4.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 9109.4 MB0.0 KB4.0 MB113.3 MB 96%8.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 30 04:15:01 - 04:59:59 440 3.2% 0.164.0 MB 3.7% 1.53
Dec 30 05:00:00 - 05:59:59 554 4.0% 0.155.1 MB 4.7% 1.46
Dec 30 06:00:00 - 06:59:59 549 4.0% 0.154.8 MB 4.4% 1.37
Dec 30 07:00:00 - 07:59:59 467 3.4% 0.133.7 MB 3.4% 1.05
Dec 30 08:00:00 - 08:59:59 306 2.2% 0.091.9 MB 1.7% 0.53
Dec 30 09:00:00 - 09:59:59 279 2.0% 0.082.1 MB 1.9% 0.59
Dec 30 10:00:00 - 10:59:59 306 2.2% 0.091.6 MB 1.5% 0.46
Dec 30 11:00:00 - 11:59:59 321 2.3% 0.091.8 MB 1.7% 0.52
Dec 30 12:00:00 - 12:59:59 307 2.2% 0.091.7 MB 1.5% 0.48
Dec 30 13:00:00 - 13:59:59 427 3.1% 0.122.7 MB 2.5% 0.77
Dec 30 14:00:00 - 14:59:59 416 3.0% 0.122.6 MB 2.4% 0.75
Dec 30 15:00:00 - 15:59:59 551 4.0% 0.154.7 MB 4.3% 1.34
Dec 30 16:00:00 - 16:59:59 806 5.8% 0.226.3 MB 5.8% 1.80
Dec 30 17:00:00 - 17:59:59 806 5.8% 0.226.7 MB 6.1% 1.91
Dec 30 18:00:00 - 18:59:59 671 4.9% 0.195.5 MB 5.0% 1.55
Dec 30 19:00:00 - 19:59:59 849 6.2% 0.246.3 MB 5.7% 1.79
Dec 30 20:00:00 - 20:59:59 763 5.5% 0.216.3 MB 5.7% 1.79
Dec 30 21:00:00 - 21:59:59 677 4.9% 0.195.5 MB 5.0% 1.56
Dec 30 22:00:00 - 22:59:59 649 4.7% 0.185.2 MB 4.8% 1.48
Dec 30 23:00:00 - 23:59:59 754 5.5% 0.215.7 MB 5.2% 1.63
Dec 31 00:00:00 - 00:59:59 728 5.3% 0.206.5 MB 6.0% 1.86
Dec 31 01:00:00 - 01:59:59 719 5.2% 0.206.2 MB 5.7% 1.76
Dec 31 02:00:00 - 02:59:59 650 4.7% 0.185.7 MB 5.2% 1.61
Dec 31 03:00:00 - 03:59:59 617 4.5% 0.175.5 MB 5.0% 1.57
Dec 31 04:00:00 - 04:15:01 175 1.3% 0.191.6 MB 1.4% 1.77
TOTAL: 24:00:00 13787 100.0% 0.16109.7 MB 100.0% 1.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 569 81 0 0 0 0 0 0 488
2news.glou.org 164 0 0 0 0 0 0 0 164
3gegeweb-out.news.tnetconsulting.net 46 0 0 0 0 0 0 0 46
4usenet.pasdenom.info 12 0 0 0 0 0 0 0 12
5nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 5 792 81 0 0 0 0 0 0 711

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.lettres.langue.allemande 42
fr.misc.gestion 39
TOTAL: 2 81

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 306
EMP (md5) 225
EMP (phn path) 81
Bad path (news.giganews.com.POSTED) 80
User-issued spam cancel 3
Cancel of non-existing ID <658ff2d0$0$7771$426a74cc@news.free.fr> 3
Cancel of <17a592bf06f88446$14199$3549207$68d9108e@news.vipernews.com> without Cancel-Key 1
Cancel of <mn.f2687e7c5bb47e77.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of <mn.f26f7e7ce08c2138.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of <mn.f2727e7c0951e4e9.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of <mn.f2b67e7c41f4d53c.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of <mn.f2b47e7c513a5be2.145333@zorro.eu.invalide> without Cancel-Key 1
Cancels abusifs 1
Cancel of <mn.f2bc7e7c2c3b0158.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of non-existing ID <658fd2ac$0$2990$426a74cc@news.free.fr> 1
Cancel of <mn.f27e7e7c5e8f7f77.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of <mn.f26a7e7c0dab99ab.145333@zorro.eu.invalide> without Cancel-Key 1
Cancel of non-existing ID <ump5bk$19l0v$1@dont-email.me> 1
TOTAL: 18 710

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1011
TOTAL: 11011

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
1news.nntp4.net 9594 215 7202 1 0 0 2%23:59:57
2news.gegeweb.org 14630 72 12551 0 0 0 0%23:59:57
3i2pn.org 21668 60 12995 410 0 46 0%23:59:53
4news.samoylyk.net 20035 28 13561 159 0 31 0%23:59:57
5nntp.terraraq.uk 14880 26 11871 408 0 5 0%23:59:57
6news.tnetconsulting.net 19397 16 13476 293 0 60 0%23:59:56
7news.pasdenom.info 15353 3 13271 3 0 0 0%23:59:55
8news.aioe.org 0 0 0 0 0 6727 0%23:59:56
TOTAL: 8 115557 420 84927 1274 0 6869 0%191:59:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net2.0 MB2.5 KB2.0 MB0.0 KB/s9.3 KB23:59:57
2news.gegeweb.org707.1 KB0.0 KB707.1 KB0.0 KB/s9.8 KB23:59:57
3i2pn.org178.9 KB3.4 MB3.6 MB0.0 KB/s7.9 KB23:59:53
4nntp.terraraq.uk160.9 KB3.6 MB3.7 MB0.0 KB/s8.8 KB23:59:57
5news.samoylyk.net72.5 KB1.3 MB1.4 MB0.0 KB/s7.4 KB23:59:57
6news.tnetconsulting.net35.9 KB2.5 MB2.5 MB0.0 KB/s8.4 KB23:59:56
7news.pasdenom.info5.4 KB20.0 KB25.4 KB0.0 KB/s4.2 KB23:59:55
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 83.1 MB10.8 MB13.9 MB0.0 KB/s8.4 KB191:59:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1plentiful.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:00
2lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
380.66.88.204 2 00.0 KB 0 0 000:00:00
4176.97.210.30 1 00.0 KB 0 0 000:00:01
591.240.118.73 1 00.0 KB 0 0 000:00:00
6107.170.252.15 1 00.0 KB 0 0 000:00:01
7glamorous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
8211.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
947.189.4.103 1 00.0 KB 0 0 000:00:05
10104.152.52.134 1 00.0 KB 0 0 000:00:11
11gracious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12172.104.238.162 1 00.0 KB 0 0 000:00:02
13poised.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
14189.79.154.197 3 00.0 KB 0 0 000:00:14
15223.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
16mail.gegeweb.eu 287 00.0 KB 0 0 000:01:50
TOTAL: 16 306 00.0 KB 0 0 000:02:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 11 00.0 KB 0 0 000:00:37
2*.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
3*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
4*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:06
5*.gegeweb.eu 287 00.0 KB 0 0 000:01:50
TOTAL: 5 306 00.0 KB 0 0 000:02:46

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.672 4.234 1.59600:01:50
189.79.154.197 0.146 0.099 0.00000:00:14
104.152.52.134 0.030 0.021 0.00000:00:11
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 0.032 0.020 0.00000:00:10
glamorous.monitoring.internet-measurement.com 0.043 0.019 0.00000:00:06
47.189.4.103 0.019 0.005 0.00000:00:05
172.104.238.162 0.025 0.029 0.00000:00:02
176.97.210.30 0.026 0.029 0.00000:00:01
107.170.252.15 0.016 0.008 0.00000:00:01
223.211.203.35.bc.googleusercontent.com 0.012 0.012 0.00000:00:01
80.66.88.204 0.051 0.024 0.00000:00:00
211.211.203.35.bc.googleusercontent.com 0.056 0.024 0.00000:00:00
91.240.118.73 0.054 0.004 0.00000:00:00
poised.monitoring.internet-measurement.com 0.045 0.013 0.00000:00:00
gracious.monitoring.internet-measurement.com 0.044 0.020 0.00000:00:00
plentiful.monitoring.internet-measurement.com 0.036 0.020 0.00000:00:00
TOTAL: 16 5.307 4.581 1.59600:02:46

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
189.79.154.197 5
176.97.210.30 3
223.211.203.35.bc.googleusercontent.com 3
211.211.203.35.bc.googleusercontent.com 3
80.66.88.204 1
107.170.252.15 1
TOTAL: 6 16

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 3
User-Agent: Expanse, a Palo Alto Network... 2
Host: 45.13.105.36:563 2
Connection: close 1
#003 1
Host: 45.13.105.36:119 1
Host: google.com:443 1
Accept-Language: en-US,en;q=0.9 1
User-Agent: Go-http-client/1.1 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
CONNECT google.com:443 HTTP/1.1 1
MGLNDD_45.13.105.36_119 1
TOTAL: 12 16

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.204 1 1
TOTAL: 1 1 2