Daily Usenet report for news.niel.me

Feb 5 04:15:02 -- Feb 6 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 6257 35.1%838.0 KB 32.7%
inn 5331 29.9%908.1 KB 35.4%
innd 3854 21.6%557.6 KB 21.7%
nnrpd 2382 13.4%261.6 KB 10.2%
nocem 13 0.1%1.1 KB 0.0%
controlchan 3 0.0%0.1 KB 0.0%
TOTAL: 6 17840 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24171 55.6%
Negative hits 9948 22.9%
Do not exist 5116 11.8%
Cache misses 4208 9.7%
TOTAL: 4 43443 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.047 0.0%25 0.000 1.880 11.000
article cancel00:00:00.006 0.0%33 0.000 0.182 1.000
article cleanup00:00:00.097 0.0%5259 0.000 0.018 0.133
article logging00:00:00.415 0.0%5274 0.000 0.079 0.225
article parse00:00:00.855 0.0%9987 0.000 0.086 0.316
article write00:00:03.015 0.0%4503 0.250 0.670 2.107
artlog/artcncl00:00:00.001 0.0%33 0.000 0.030 1.000
artlog/artcncl/perl00:00:00.001 0.0%25 0.000 0.040 1.000
data move00:00:00.108 0.0%44270 0.000 0.002 0.023
hisgrep/artcncl00:00:00.002 0.0%29 0.000 0.069 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%25 0.000 0.040 1.000
hisgrep/perl00:00:00.003 0.0%30 0.000 0.100 0.667
hishave/artcncl00:00:00.000 0.0%33 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%25 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.589 0.0%48063 0.000 0.012 0.045
history sync00:00:00.048 0.0%414 0.000 0.116 1.667
history write00:00:01.077 0.0%5259 0.029 0.205 0.571
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle24:00:19.979 99.9%45621 352.301 1894.303 28591.952
nntp read00:00:01.386 0.0%44897 0.000 0.031 0.065
overview write00:00:02.882 0.0%4503 0.103 0.640 8.207
perl filter00:00:23.244 0.0%5259 2.520 4.420 10.975
python filter00:00:00.008 0.0%5262 0.000 0.002 0.071
site send00:00:01.353 0.0%9061 0.000 0.149 0.478
TOTAL: 24:01:15.19924:00:55.117100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.050 0.0%5440 0.000 0.009 0.069
article prepare00:00:00.000 0.0%900 0.000 0.000 0.000
article read00:00:00.049 0.0%202 0.000 0.243 8.000
backlog stats00:00:00.135 0.0%62549 0.000 0.002 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.931 0.0%36522 0.000 0.025 0.063
data write00:00:02.077 0.0%32077 0.022 0.065 0.135
idle23:37:18.426100.0%62549 613.432 1359.549 4270.531
status file00:00:08.091 0.0%2636 0.000 3.069 33.462
TOTAL: 23:37:35.87223:37:29.759100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:00:15.384 1.4%1153 11.750 13.343 77.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.139 0.0%4428 0.000 0.031 0.250
readart00:00:01.143 0.1%139 1.042 8.223 11.663
TOTAL: 00:18:49.83900:00:16.666 1.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 10
reserve 2
TOTAL: 11 178

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 4289 2353 1842 94 54%22:54:43
2i2pn.org 2 4411 1259 3049 103 28%24:26:28
3feed-out.gegeweb.org 289 3140 329 2811 0 10%24:36:56
4nntp.terraraq.uk 3 6868 146 6571 151 2%15:23:56
5usenet.pasdenom.info 3 3161 115 3043 3 3%24:06:19
6gegeweb-out.news.tnetconsulting.net 3 4836 41 4786 9 0%24:37:37
7news.nntp4.net 3 5349 19 5172 158 0%07:37:45
8localhost 33 3 3 0 0 100%00:00:00
TOTAL: 8 338 32057 4265 27274 518 13%143:43:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.1 MB0.0 KB251.1 KB7.3 MB 96%3.1 KB
2i2pn.org5.5 MB0.0 KB323.8 KB5.8 MB 94%4.4 KB
3gegeweb-out.news.tnetconsulting.net1.0 MB0.0 KB30.8 KB1.0 MB 97%21.4 KB
4feed-out.gegeweb.org897.9 KB0.0 KB0.0 KB897.9 KB100%2.7 KB
5nntp.terraraq.uk676.4 KB0.0 KB592.5 KB1.2 MB 53%4.3 KB
6usenet.pasdenom.info254.6 KB0.0 KB4.3 KB259.0 KB 98%2.2 KB
7news.nntp4.net195.2 KB0.0 KB2.3 MB2.5 MB 7%14.7 KB
8localhost5.2 KB0.0 KB0.0 KB5.2 KB100%1.7 KB
TOTAL: 815.6 MB0.0 KB3.5 MB19.1 MB 81%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 5 04:15:02 - 04:59:59 113 2.5% 0.04498.2 KB 2.9% 0.18
Feb 5 05:00:00 - 05:59:59 106 2.4% 0.03333.0 KB 1.9% 0.09
Feb 5 06:00:00 - 06:59:59 108 2.4% 0.03422.8 KB 2.4% 0.12
Feb 5 07:00:00 - 07:59:59 159 3.5% 0.04473.2 KB 2.7% 0.13
Feb 5 08:00:00 - 08:59:59 103 2.3% 0.03442.9 KB 2.5% 0.12
Feb 5 09:00:00 - 09:59:59 102 2.3% 0.03439.2 KB 2.5% 0.12
Feb 5 10:00:00 - 10:59:59 126 2.8% 0.04475.2 KB 2.7% 0.13
Feb 5 11:00:00 - 11:59:59 211 4.7% 0.06871.7 KB 5.0% 0.24
Feb 5 12:00:00 - 12:59:59 139 3.1% 0.04415.6 KB 2.4% 0.12
Feb 5 13:00:00 - 13:59:59 141 3.1% 0.04444.7 KB 2.6% 0.12
Feb 5 14:00:00 - 14:59:59 188 4.2% 0.051.3 MB 7.5% 0.36
Feb 5 15:00:00 - 15:59:59 189 4.2% 0.05532.3 KB 3.1% 0.15
Feb 5 16:00:00 - 16:59:59 244 5.4% 0.07796.6 KB 4.6% 0.22
Feb 5 17:00:00 - 17:59:59 233 5.2% 0.06686.0 KB 3.9% 0.19
Feb 5 18:00:00 - 18:59:59 280 6.2% 0.08852.7 KB 4.9% 0.24
Feb 5 19:00:00 - 19:59:59 246 5.5% 0.071.3 MB 7.6% 0.37
Feb 5 20:00:00 - 20:59:59 318 7.1% 0.091.1 MB 6.3% 0.30
Feb 5 21:00:00 - 21:59:59 290 6.4% 0.08905.5 KB 5.2% 0.25
Feb 5 22:00:00 - 22:59:59 241 5.4% 0.07699.4 KB 4.0% 0.19
Feb 5 23:00:00 - 23:59:59 298 6.6% 0.081.1 MB 6.5% 0.31
Feb 6 00:00:00 - 00:59:59 195 4.3% 0.05689.4 KB 4.0% 0.19
Feb 6 01:00:00 - 01:59:59 163 3.6% 0.051.1 MB 6.5% 0.32
Feb 6 02:00:00 - 02:59:59 127 2.8% 0.04507.0 KB 2.9% 0.14
Feb 6 03:00:00 - 03:59:59 151 3.4% 0.04785.7 KB 4.5% 0.22
Feb 6 04:00:00 - 04:15:01 31 0.7% 0.03126.3 KB 0.7% 0.14
TOTAL: 23:59:59 4502 100.0% 0.0517.0 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 292 0 0 0 0 0 0 0 292
2nntp.terraraq.uk 251 0 0 0 0 0 0 0 251
3news-out.aioe.org 111 3 0 0 0 0 0 0 108
4i2pn.org 109 0 0 0 0 0 0 0 109
5gegeweb-out.news.tnetconsulting.net 4 0 0 0 0 0 0 0 4
6usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 771 3 0 0 0 0 0 0 768

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.survival 2
news.test 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 247
Too many newsgroups 200
EMP (phn nph) 127
Bad path (news.giganews.com.POSTED) 118
EMP (phn path) 37
User-issued spam cancel 16
EMP (phl) 3
Cancel of <nnd$2fef4f8f$2fcd803a@5fb1b114c43470b5> without Cancel-Key 1
Cancel of <stlg4a$fjg$1@dont-email.me> without Cancel-Key 1
Cancel of non-existing ID <0b1a1b82-439f-4c1e-908a-d612003ac2cen@googlegroups.com> 1
Cancel of <nnd$5e672d1d$1cce83c4@5fb1b114c43470b5> without Cancel-Key 1
Cancel of non-existing ID <oIDLJ.7770$Lbb6.2244@fx45.iad> 1
TOTAL: 12 753

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com8088
TOTAL: 18088

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6139 96 3106 2 0 94 1%23:51:44
2news.gegeweb.org 4575 21 4070 81 0 21 0%23:59:50
3news.tnetconsulting.net 7478 19 4481 0 0 96 0%23:59:41
4news.nntp4.net 4789 4 4453 0 0 4 0%23:59:40
5news.pasdenom.info 4093 3 4035 0 0 0 0%23:59:40
6news.aioe.org 804 0 0 0 0 2249 0%23:53:14
7nntp.terraraq.uk 3258 0 3162 0 0 0 0%23:59:40
TOTAL: 7 31136 143 23307 83 0 2464 0%167:43:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org215.7 KB8.1 KB223.8 KB0.0 KB/s2.3 KB23:51:44
2news.gegeweb.org97.1 KB463.3 KB560.4 KB0.0 KB/s5.5 KB23:59:50
3news.tnetconsulting.net51.4 KB0.0 KB51.4 KB0.0 KB/s2.7 KB23:59:41
4news.nntp4.net8.6 KB0.0 KB8.6 KB0.0 KB/s2.1 KB23:59:40
5news.pasdenom.info5.2 KB0.0 KB5.2 KB0.0 KB/s1.7 KB23:59:40
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:14
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:40
TOTAL: 7378.0 KB471.4 KB849.4 KB0.0 KB/s3.8 KB167:43:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:5098:c283:b1e9:3eef 9 53106.3 KB 13 2 000:13:14
22a0e:e701:1154:0:4982:54d4:56cb:add 1 2132.9 KB 3 1 000:04:55
TOTAL: 2 10 74139.3 KB 16 3 000:18:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 10 74139.3 KB 16 3 000:18:10
2*.gegeweb.eu 286 00.0 KB 0 0 000:00:36
3unresolved 4 00.0 KB 0 0 000:00:02
TOTAL: 3 300 74139.3 KB 16 3 000:18:49

NNRP auth users [Top 20]:

UserConn
mailman 286
gerald 10
TOTAL: 2 296

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a0e:e701:1154:0:5098:c283:b1e9:3eef 0.805 0.187 0.08500:13:14
2a0e:e701:1154:0:4982:54d4:56cb:add 0.122 0.061 0.01500:04:55
sys.gegeweb.eu 8.360 7.248 2.59800:00:36
169.197.142.69 0.074 0.009 0.00000:00:01
88.165.5.23 0.105 0.067 0.00000:00:01
TOTAL: 5 9.466 7.572 2.69800:18:49

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 286
88.165.5.23 3
169.197.142.69 1
TOTAL: 3 290

Newsgroup request counts (by category):

CategoryCountPct
1fr 71 95.9%
2grisbi 3 4.1%
TOTAL: 2 74100.0%

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

NewsgroupCount
1fr.usenet.distribution 36
2fr.comp.usenet.serveurs 16
3fr.usenet.forums.evolution 8
4fr.usenet.divers 3
5grisbi.test 3
6fr.comp.lang.c 2
7fr.comp.lang.javascript 1
8fr.comp.lang.basic 1
9fr.comp.ordinosaures 1
10fr.comp.os.bsd 1
11fr.comp.lang.ruby 1
12fr.comp.lang.perl 1
TOTAL: 12 74