Daily Usenet report for news.niel.me

Aug 10 04:15:01 -- Aug 11 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4632 39.6%805.4 KB 44.4%
innd 3557 30.4%512.9 KB 28.2%
nnrpd 1936 16.5%209.7 KB 11.5%
innfeed 1567 13.4%286.1 KB 15.8%
nocem 14 0.1%1.4 KB 0.1%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11707 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23854 67.4%
Negative hits 7001 19.8%
Do not exist 4549 12.8%
Cache misses 2 0.0%
TOTAL: 4 35406 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.022 0.0%18 0.000 1.222 6.000
article cancel00:00:00.009 0.0%28 0.000 0.321 1.000
article cleanup00:00:00.085 0.0%4562 0.000 0.019 0.100
article logging00:00:00.364 0.0%4594 0.000 0.079 0.222
article parse00:00:00.840 0.0%7744 0.000 0.108 0.265
article write00:00:03.486 0.0%4008 0.211 0.870 27.095
artlog/artcncl00:00:00.005 0.0%27 0.000 0.185 1.000
artlog/artcncl/perl00:00:00.001 0.0%18 0.000 0.056 1.000
data move00:00:00.101 0.0%38952 0.000 0.003 0.014
hisgrep/artcncl00:00:00.001 0.0%23 0.000 0.043 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%18 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%21 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%28 0.000 0.036 1.000
hishave/artcncl/perl00:00:00.000 0.0%18 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.537 0.0%35496 0.000 0.015 0.038
history sync00:00:00.193 0.0%411 0.000 0.470 52.333
history write00:00:01.011 0.0%4562 0.000 0.222 0.638
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle24:00:28.270 99.9%39480 995.613 2189.166 6817.807
nntp read00:00:01.291 0.0%38835 0.006 0.033 0.063
overview write00:00:02.542 0.0%4008 0.000 0.634 6.556
perl filter00:00:22.041 0.0%4562 3.477 4.831 12.095
python filter00:00:00.017 0.0%7685 0.000 0.002 0.031
site send00:00:01.124 0.0%8029 0.000 0.140 0.500
TOTAL: 24:01:15.98424:01:01.941100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%4008 0.000 0.012 0.143
article prepare00:00:00.001 0.0%2016 0.000 0.000 0.050
article read00:00:00.077 0.0%464 0.000 0.166 8.000
backlog stats00:00:00.133 0.0%58885 0.000 0.002 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.750 0.0%33854 0.000 0.022 0.083
data write00:00:02.162 0.0%29811 0.029 0.073 0.136
idle23:52:18.135100.0%58885 800.368 1459.423 4773.992
status file00:00:00.421 0.0%173 1.000 2.434 7.000
TOTAL: 23:52:25.19123:52:21.728100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:39.673 76.3%1234 19.500 275.262 11380.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.192 0.0%3093 0.000 0.062 0.480
readart00:00:00.023 0.0%14 1.000 1.643 4.000
TOTAL: 00:07:25.04800:05:39.888 76.4%----

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-out.aioe.org 1 3944 2084 1744 116 52%22:34:19
2usenet.pasdenom.info 4 6207 1070 5125 12 17%46:47:52
3nntp.terraraq.uk 1 3733 305 3105 323 8%23:44:01
4feed-out.gegeweb.org 290 2812 203 2607 2 7%23:53:13
5news.nntp4.net 2 4856 181 4547 128 3%27:48:28
6i2pn.org 1 4123 66 4052 5 1%23:59:57
7gegeweb-out.news.tnetconsulting.net 1 3964 41 3890 33 1%23:57:15
8localhost 30 0 0 0 0 0%00:00:01
TOTAL: 8 330 29639 3950 25070 619 13%192:45:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.3 MB0.0 KB391.8 KB6.7 MB 94%3.1 KB
2nntp.terraraq.uk6.1 MB0.0 KB1.6 MB7.8 MB 78%12.6 KB
3usenet.pasdenom.info2.6 MB0.0 KB32.8 KB2.6 MB 98%2.5 KB
4news.nntp4.net2.1 MB0.0 KB594.3 KB2.6 MB 78%8.8 KB
5feed-out.gegeweb.org932.6 KB0.0 KB3.9 KB936.5 KB 99%4.6 KB
6i2pn.org255.6 KB0.0 KB16.0 KB271.6 KB 94%3.8 KB
7gegeweb-out.news.tnetconsulting.net137.0 KB0.0 KB154.0 KB291.0 KB 47%3.9 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 818.3 MB0.0 KB2.8 MB21.1 MB 86%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 10 04:15:01 - 04:59:59 76 1.9% 0.031.2 MB 6.7% 0.45
Aug 10 05:00:00 - 05:59:59 105 2.6% 0.03975.3 KB 5.4% 0.27
Aug 10 06:00:00 - 06:59:59 86 2.1% 0.02611.6 KB 3.4% 0.17
Aug 10 07:00:00 - 07:59:59 111 2.8% 0.03338.2 KB 1.9% 0.09
Aug 10 08:00:00 - 08:59:59 117 2.9% 0.03362.0 KB 2.0% 0.10
Aug 10 09:00:00 - 09:59:59 154 3.9% 0.041.4 MB 7.6% 0.38
Aug 10 10:00:00 - 10:59:59 108 2.7% 0.03308.1 KB 1.7% 0.09
Aug 10 11:00:00 - 11:59:59 130 3.2% 0.04693.1 KB 3.8% 0.19
Aug 10 12:00:00 - 12:59:59 174 4.3% 0.05494.9 KB 2.7% 0.14
Aug 10 13:00:00 - 13:59:59 182 4.5% 0.05666.7 KB 3.7% 0.19
Aug 10 14:00:00 - 14:59:59 179 4.5% 0.051.6 MB 9.2% 0.46
Aug 10 15:00:00 - 15:59:59 193 4.8% 0.05530.9 KB 2.9% 0.15
Aug 10 16:00:00 - 16:59:59 231 5.8% 0.06681.0 KB 3.7% 0.19
Aug 10 17:00:00 - 17:59:59 232 5.8% 0.06809.0 KB 4.5% 0.22
Aug 10 18:00:00 - 18:59:59 216 5.4% 0.061003.5 KB 5.5% 0.28
Aug 10 19:00:00 - 19:59:59 221 5.5% 0.06653.7 KB 3.6% 0.18
Aug 10 20:00:00 - 20:59:59 194 4.9% 0.05620.3 KB 3.4% 0.17
Aug 10 21:00:00 - 21:59:59 271 6.8% 0.08900.6 KB 5.0% 0.25
Aug 10 22:00:00 - 22:59:59 235 5.9% 0.071.6 MB 8.8% 0.44
Aug 10 23:00:00 - 23:59:59 216 5.4% 0.06879.4 KB 4.8% 0.24
Aug 11 00:00:00 - 00:59:59 183 4.6% 0.05481.2 KB 2.6% 0.13
Aug 11 01:00:00 - 01:59:59 128 3.2% 0.04429.2 KB 2.4% 0.12
Aug 11 02:00:00 - 02:59:59 123 3.1% 0.03437.2 KB 2.4% 0.12
Aug 11 03:00:00 - 03:59:59 113 2.8% 0.03385.5 KB 2.1% 0.11
Aug 11 04:00:00 - 04:15:01 22 0.5% 0.0255.6 KB 0.3% 0.06
TOTAL: 24:00:00 4000 100.0% 0.0517.7 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 264 0 0 0 0 0 0 0 264
2news-out.aioe.org 151 2 0 0 0 0 0 0 149
3news.nntp4.net 109 0 0 0 0 0 0 0 109
4gegeweb-out.news.tnetconsulting.net 38 0 0 0 0 0 0 0 38
5usenet.pasdenom.info 15 0 0 0 0 0 0 0 15
6i2pn.org 7 0 0 0 0 0 0 0 7
7feed-out.gegeweb.org 3 0 0 0 0 0 0 0 3
TOTAL: 7 587 2 0 0 0 0 0 0 585

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 277
EMP (phn nph) 123
Bad path (news.giganews.com.POSTED) 122
EMP (md5) 13
EMP (phl) 9
User-issued spam cancel 5
Cancel of non-existing ID <6112dd46$0$12678$426a74cc@news.free.fr> 1
Cancel of non-existing ID <inf54rF3fa2U1@mid.individual.net> 1
Too many newsgroups (meow) 1
TOTAL: 9 552

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com9099
TOTAL: 19099

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 24
nntp.terraraq.uk 3
usenet.pasdenom.info 3
news.nntp4.net 2
feed-out.gegeweb.org 1
TOTAL: 5 33
TOTAL: 1 33

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6812 354 3457 72 0 6 5%23:57:42
2nntp.terraraq.uk 2878 38 2569 0 0 0 1%23:59:53
3news.tnetconsulting.net 7165 19 3973 6 0 10 0%23:59:56
4news.gegeweb.org 3901 13 3785 0 0 0 0%23:59:56
5news.pasdenom.info 2712 2 2642 0 0 3 0%23:58:14
6news.aioe.org 1572 1 1458 0 0 0 0%23:58:58
7news.nntp4.net 4427 0 3836 2 0 0 0%23:58:29
TOTAL: 7 29467 427 21720 80 0 19 1%167:53:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org768.4 KB145.9 KB914.2 KB0.0 KB/s2.1 KB23:57:42
2nntp.terraraq.uk106.9 KB0.0 KB106.9 KB0.0 KB/s2.8 KB23:59:53
3news.tnetconsulting.net76.9 KB19.8 KB96.7 KB0.0 KB/s3.9 KB23:59:56
4news.gegeweb.org50.2 KB0.0 KB50.2 KB0.0 KB/s3.9 KB23:59:56
5news.pasdenom.info4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:58:14
6news.aioe.org1.9 KB0.0 KB1.9 KB0.0 KB/s1.9 KB23:58:58
7news.nntp4.net0.0 KB2.9 KB2.9 KB0.0 KB/s1.5 KB23:58:29
TOTAL: 71008.3 KB168.6 KB1.1 MB0.0 KB/s2.3 KB167:53:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 3 1328.0 KB 8 0 000:05:13
TOTAL: 1 3 1328.0 KB 8 0 000:07:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 1328.0 KB 8 0 000:05:13
2unresolved 2 00.0 KB 0 0 000:00:02
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:04
4*.security.ipip.net 1 00.0 KB 0 0 000:00:01
5*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 5 296 1328.0 KB 8 0 000:07:24

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.162 0.119 0.00000:05:13
sys.gegeweb.eu 8.216 8.802 2.90200:02:04
23.129.64.131 0.021 0.031 0.00000:00:02
scanner-04.ch1.censys-scanner.com 0.041 0.025 0.00000:00:01
scan-141.security.ipip.net 0.038 0.019 0.00000:00:01
88.165.5.23 0.024 0.036 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.031 0.031 0.00000:00:00
TOTAL: 7 8.533 9.063 2.90200:07:24

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
scan-141.security.ipip.net 1
scanner-21.ch1.censys-scanner.com 1
scanner-04.ch1.censys-scanner.com 1
23.129.64.131 1
88.165.5.23 1
TOTAL: 6 293

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

CommandCount
Connection: close 1
Host: 185.73.232.189:119 1
User-Agent: HTTP Banner Detection (https... 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 9 69.2%
2news 3 23.1%
3grisbi 1 7.7%
TOTAL: 3 13100.0%

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

NewsgroupCount
1fr.comp.usenet.lecteurs-de-news 4
2fr.misc.bavardages.linux 3
3grisbi.test 1
4news.admin.peering 1
5news.admin.hierarchies 1
6news.software.nntp 1
7fr.usenet.forums.evolution 1
8fr.rec.sport.cyclisme 1
TOTAL: 8 13