Daily Usenet report for news.niel.me

Nov 6 04:15:02 -- Nov 7 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4873 40.4%828.3 KB 44.7%
innd 3640 30.2%545.2 KB 29.4%
nnrpd 1958 16.2%211.7 KB 11.4%
innfeed 1592 13.2%269.4 KB 14.5%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 12065 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22394 65.0%
Negative hits 7247 21.0%
Do not exist 4795 13.9%
Cache misses 18 0.1%
TOTAL: 4 34454 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.048 0.0%20 0.500 2.400 13.000
article cancel00:00:00.004 0.0%21 0.000 0.190 1.000
article cleanup00:00:00.105 0.0%4799 0.000 0.022 0.200
article logging00:00:00.377 0.0%4832 0.000 0.078 0.250
article parse00:00:00.859 0.0%8056 0.000 0.107 0.278
article write00:00:02.586 0.0%4093 0.188 0.632 2.524
artlog/artcncl00:00:00.000 0.0%21 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.003 0.0%20 0.000 0.150 1.000
data move00:00:00.103 0.0%37847 0.000 0.003 0.013
hisgrep/artcncl00:00:00.001 0.0%21 0.000 0.048 0.500
hisgrep/artcncl/perl00:00:00.001 0.0%20 0.000 0.050 0.500
hisgrep/perl00:00:00.002 0.0%26 0.000 0.077 1.000
hishave/artcncl00:00:00.000 0.0%21 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%20 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.475 0.0%34443 0.000 0.014 0.036
history sync00:00:00.049 0.0%397 0.000 0.123 2.000
history write00:00:01.110 0.0%4799 0.000 0.231 0.644
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:27.333 99.9%38590 965.754 2239.630 6985.686
nntp read00:00:01.239 0.0%37854 0.000 0.033 0.069
overview write00:00:02.620 0.0%4093 0.080 0.640 4.706
perl filter00:00:22.014 0.0%4799 2.630 4.587 12.227
python filter00:00:00.009 0.0%4800 0.000 0.002 0.040
site send00:00:01.195 0.0%8189 0.000 0.146 0.446
TOTAL: 24:01:13.10224:01:00.133100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%4232 0.000 0.011 0.100
article prepare00:00:00.001 0.0%632 0.000 0.002 0.083
article read00:00:00.034 0.0%143 0.000 0.238 8.000
backlog stats00:00:00.117 0.0%62349 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.833 0.0%35137 0.000 0.024 0.054
data write00:00:02.258 0.0%30927 0.039 0.073 0.141
idle23:57:13.189100.0%62349 648.114 1383.073 4314.685
status file00:00:00.434 0.0%173 1.000 2.509 9.000
TOTAL: 23:57:20.22823:57:16.914100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:09:56.802 84.4%1283 21.500 465.161 6313.405
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.184 0.0%3303 0.000 0.056 0.314
readart00:00:00.888 0.1%1566 0.138 0.567 3.000
TOTAL: 00:11:47.51300:09:57.874 84.5%----

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
1news-out.aioe.org 2 4014 2621 1276 117 65%22:16:30
2i2pn.org 2 4359 478 3810 71 10%25:02:23
3feed-out.gegeweb.org 290 2858 349 2480 29 12%23:56:14
4nntp.terraraq.uk 2 6058 306 5443 309 5%33:25:56
5news.nntp4.net 2 4289 254 3829 206 5%22:15:44
6usenet.pasdenom.info 2 2927 64 2858 5 2%22:16:28
7gegeweb-out.news.tnetconsulting.net 2 4128 12 4108 8 0%23:55:21
8localhost 26 1 1 0 0 100%00:00:00
TOTAL: 8 328 28634 4085 23804 745 14%173:08:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.9 MB0.0 KB393.9 KB8.3 MB 95%3.1 KB
2nntp.terraraq.uk3.6 MB0.0 KB2.6 MB6.2 MB 57%10.4 KB
3i2pn.org2.3 MB0.0 KB261.6 KB2.5 MB 89%4.8 KB
4news.nntp4.net1.7 MB0.0 KB514.5 KB2.2 MB 76%4.8 KB
5feed-out.gegeweb.org736.5 KB0.0 KB31.6 KB768.1 KB 95%2.0 KB
6gegeweb-out.news.tnetconsulting.net534.9 KB0.0 KB28.2 KB563.2 KB 94%28.2 KB
7usenet.pasdenom.info140.3 KB0.0 KB6.0 KB146.3 KB 95%2.1 KB
8localhost1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
TOTAL: 816.8 MB0.0 KB3.9 MB20.7 MB 81%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 6 04:15:02 - 04:59:59 88 2.2% 0.03836.3 KB 4.9% 0.31
Nov 6 05:00:00 - 05:59:59 106 2.6% 0.03715.7 KB 4.2% 0.20
Nov 6 06:00:00 - 06:59:59 92 2.2% 0.03386.6 KB 2.2% 0.11
Nov 6 07:00:00 - 07:59:59 142 3.5% 0.04512.2 KB 3.0% 0.14
Nov 6 08:00:00 - 08:59:59 79 1.9% 0.02264.7 KB 1.5% 0.07
Nov 6 09:00:00 - 09:59:59 109 2.7% 0.03447.5 KB 2.6% 0.12
Nov 6 10:00:00 - 10:59:59 117 2.9% 0.03411.4 KB 2.4% 0.11
Nov 6 11:00:00 - 11:59:59 126 3.1% 0.04550.5 KB 3.2% 0.15
Nov 6 12:00:00 - 12:59:59 158 3.9% 0.04643.0 KB 3.7% 0.18
Nov 6 13:00:00 - 13:59:59 202 4.9% 0.06599.2 KB 3.5% 0.17
Nov 6 14:00:00 - 14:59:59 182 4.4% 0.05645.7 KB 3.8% 0.18
Nov 6 15:00:00 - 15:59:59 228 5.6% 0.06797.9 KB 4.6% 0.22
Nov 6 16:00:00 - 16:59:59 189 4.6% 0.05871.6 KB 5.1% 0.24
Nov 6 17:00:00 - 17:59:59 232 5.7% 0.06916.7 KB 5.3% 0.25
Nov 6 18:00:00 - 18:59:59 308 7.5% 0.09851.4 KB 4.9% 0.24
Nov 6 19:00:00 - 19:59:59 253 6.2% 0.07758.5 KB 4.4% 0.21
Nov 6 20:00:00 - 20:59:59 229 5.6% 0.06875.8 KB 5.1% 0.24
Nov 6 21:00:00 - 21:59:59 257 6.3% 0.07992.5 KB 5.8% 0.28
Nov 6 22:00:00 - 22:59:59 203 5.0% 0.06632.8 KB 3.7% 0.18
Nov 6 23:00:00 - 23:59:59 205 5.0% 0.06991.9 KB 5.8% 0.28
Nov 7 00:00:00 - 00:59:59 150 3.7% 0.04571.8 KB 3.3% 0.16
Nov 7 01:00:00 - 01:59:59 144 3.5% 0.041.5 MB 9.1% 0.43
Nov 7 02:00:00 - 02:59:59 117 2.9% 0.03340.3 KB 2.0% 0.09
Nov 7 03:00:00 - 03:59:59 128 3.1% 0.04789.8 KB 4.6% 0.22
Nov 7 04:00:00 - 04:15:01 49 1.2% 0.05240.9 KB 1.4% 0.27
TOTAL: 23:59:59 4093 100.0% 0.0516.8 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 234 0 0 0 0 0 0 0 234
2news.nntp4.net 228 0 0 0 0 0 0 0 228
3news-out.aioe.org 155 2 0 0 0 0 0 0 153
4i2pn.org 71 0 0 0 0 0 0 0 71
5feed-out.gegeweb.org 29 0 0 0 0 0 0 0 29
6gegeweb-out.news.tnetconsulting.net 17 0 0 0 0 0 0 0 17
7usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
TOTAL: 7 739 2 0 0 0 0 0 0 737

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.divers 1
news.test 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 207
User-issued spam cancel 142
EMP (phn nph) 135
Bad path (news.giganews.com.POSTED) 122
EMP (md5) 92
Cancel of <sm6kh1$qm6$1@dont-email.me> without Cancel-Key 1
Cancel of non-existing ID <6186c4ca$0$28593$426a74cc@news.free.fr> 1
Cancel of <sm6bjn$jqm$3@dont-email.me> without Cancel-Key 1
Cancel of <sm6ock$nku$1@dont-email.me> without Cancel-Key 1
Cancel of <sm6bbj$jqm$1@dont-email.me> without Cancel-Key 1
Cancel of <sm6go3$trj$1@dont-email.me> without Cancel-Key 1
TOTAL: 11 704

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 32
news.nntp4.net 1
TOTAL: 2 33
TOTAL: 1 33

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6958 36 3550 13 0 74 0%23:59:29
2news.tnetconsulting.net 7514 33 4052 6 0 73 0%23:59:56
3news.gegeweb.org 3838 15 3671 33 0 0 0%23:59:56
4news.pasdenom.info 4731 10 3473 2 0 2 0%23:59:56
5news.aioe.org 1168 7 1094 1 0 0 0%23:46:59
6nntp.terraraq.uk 2597 1 2569 0 0 0 0%23:59:03
7news.nntp4.net 4463 1 3823 0 0 1 0%23:59:56
TOTAL: 7 31269 103 22232 55 0 150 0%167:45:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net170.1 KB14.8 KB185.0 KB0.0 KB/s4.7 KB23:59:56
2i2pn.org122.8 KB27.0 KB149.8 KB0.0 KB/s3.1 KB23:59:29
3news.gegeweb.org53.5 KB211.5 KB265.0 KB0.0 KB/s5.5 KB23:59:56
4news.pasdenom.info32.5 KB6.0 KB38.5 KB0.0 KB/s3.2 KB23:59:56
5nntp.terraraq.uk26.0 KB0.0 KB26.0 KB0.0 KB/s26.0 KB23:59:03
6news.aioe.org15.1 KB1.4 KB16.5 KB0.0 KB/s2.1 KB23:46:59
7news.nntp4.net1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:56
TOTAL: 7421.3 KB260.8 KB682.1 KB0.0 KB/s4.3 KB167:45:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 3 43130.4 KB 10 1 000:09:33
TOTAL: 1 3 43130.4 KB 10 1 000:11:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 43130.4 KB 10 1 000:09:33
2unresolved 6 00.0 KB 0 0 000:00:04
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:09
TOTAL: 3 297 43130.4 KB 10 1 000:11:46

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.285 0.807 0.00000:09:33
sys.gegeweb.eu 8.105 9.097 3.00600:02:09
88.165.5.23 0.143 0.164 0.00000:00:03
45.93.201.126 0.033 0.022 0.00000:00:00
TOTAL: 4 8.566 10.090 3.00600:11:46

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
88.165.5.23 5
45.93.201.126 1
TOTAL: 3 294

NNRP unrecognized commands (by host):

SystemConn
45.93.201.126 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
45.93.201.126 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 38 88.4%
2grisbi 3 7.0%
3comp 2 4.7%
TOTAL: 3 43100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 33
2comp.infosystems.gemini 2
3grisbi.bugsreports 2
4fr.usenet.distribution 2
5fr.comp.usenet.lecteurs-de-news 1
6fr.usenet.divers 1
7grisbi.test 1
8fr.comp.sys.mac.materiel 1
TOTAL: 8 43