Daily Usenet report for news.niel.me

Jun 4 04:15:02 -- Jun 5 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4838 43.0%827.0 KB 47.1%
innd 2619 23.3%412.5 KB 23.5%
nnrpd 2140 19.0%240.3 KB 13.7%
innfeed 1655 14.7%274.1 KB 15.6%
nocem 9 0.1%1.0 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 11262 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24784 65.9%
Negative hits 8041 21.4%
Do not exist 4781 12.7%
Cache misses 3 0.0%
TOTAL: 4 37609 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.021 0.0%13 1.000 1.615 3.000
article cancel00:00:00.003 0.0%20 0.000 0.150 1.000
article cleanup00:00:00.095 0.0%4789 0.000 0.020 0.120
article logging00:00:00.407 0.0%4811 0.000 0.085 1.625
article parse00:00:00.845 0.0%7818 0.000 0.108 0.218
article write00:00:02.566 0.0%4018 0.133 0.639 2.000
artlog/artcncl00:00:00.000 0.0%20 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%13 0.000 0.154 1.000
data move00:00:00.107 0.0%40733 0.000 0.003 0.015
hisgrep/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 1.000
hisgrep/perl00:00:00.001 0.0%16 0.000 0.062 0.200
hishave/artcncl00:00:00.001 0.0%20 0.000 0.050 1.000
hishave/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.496 0.0%37686 0.000 0.013 0.037
history sync00:00:00.057 0.0%412 0.000 0.138 5.000
history write00:00:01.019 0.0%4789 0.000 0.213 0.688
hiswrite/artcncl00:00:00.002 0.0%7 0.000 0.286 0.500
idle24:00:26.757 99.9%40845 719.659 2115.969 8578.286
nntp read00:00:01.312 0.0%40422 0.008 0.032 0.076
overview write00:00:02.666 0.0%4018 0.107 0.664 8.222
perl filter00:00:22.895 0.0%4789 3.562 4.781 11.030
python filter00:00:00.017 0.0%7986 0.000 0.002 0.048
site send00:00:01.245 0.0%8047 0.000 0.155 0.500
TOTAL: 24:01:13.86024:01:00.516100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%4195 0.000 0.013 0.125
article prepare00:00:00.002 0.0%1180 0.000 0.002 0.125
article read00:00:00.040 0.0%248 0.000 0.161 6.000
backlog stats00:00:00.138 0.0%62902 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.803 0.0%35172 0.000 0.023 0.055
data write00:00:02.355 0.0%31187 0.009 0.076 0.144
idle23:58:54.486100.0%62902 534.835 1372.524 6676.122
status file00:00:00.498 0.0%195 1.000 2.554 7.000
TOTAL: 23:59:01.92123:58:58.375100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:15:02.503 97.9%1615 6.400 558.825 15084.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.141 0.0%4206 0.000 0.034 0.273
readart00:00:00.089 0.0%43 0.000 2.070 3.000
TOTAL: 00:15:21.49800:15:02.733 98.0%----

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 2 3824 1610 2155 59 42%25:59:38
2nntp.terraraq.uk 1 4355 747 3250 358 17%25:35:57
3usenet.pasdenom.info 6 6544 744 5797 3 11%48:47:55
4feed-out.gegeweb.org 2 2694 559 2135 0 20%23:59:48
5news.nntp4.net 1 3932 339 3314 279 8%21:04:15
6i2pn.org 3 4659 89 4531 39 1%26:48:40
7gegeweb-out.news.tnetconsulting.net 1 4016 7 4004 5 0%23:59:57
8localhost 27 0 0 0 0 0%00:00:00
TOTAL: 8 43 30024 4095 25186 743 13%196:16:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1nntp.terraraq.uk6.3 MB0.0 KB1.3 MB7.6 MB 82%7.1 KB
2news-out.aioe.org4.9 MB0.0 KB190.4 KB5.1 MB 96%3.1 KB
3news.nntp4.net2.3 MB0.0 KB806.5 KB3.1 MB 74%5.2 KB
4feed-out.gegeweb.org2.0 MB0.0 KB0.0 KB2.0 MB100%3.7 KB
5usenet.pasdenom.info1.9 MB0.0 KB6.4 KB1.9 MB 99%2.7 KB
6i2pn.org379.6 KB0.0 KB194.0 KB573.6 KB 66%4.5 KB
7gegeweb-out.news.tnetconsulting.net99.4 KB0.0 KB9.7 KB109.0 KB 91%9.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 818.0 MB0.0 KB2.5 MB20.5 MB 87%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 04:15:02 - 04:59:59 44 1.1% 0.02129.8 KB 0.7% 0.05
Jun 4 05:00:00 - 05:59:59 80 2.0% 0.02678.6 KB 3.8% 0.19
Jun 4 06:00:00 - 06:59:59 118 2.9% 0.03407.8 KB 2.3% 0.11
Jun 4 07:00:00 - 07:59:59 138 3.4% 0.04350.9 KB 2.0% 0.10
Jun 4 08:00:00 - 08:59:59 122 3.0% 0.03358.5 KB 2.0% 0.10
Jun 4 09:00:00 - 09:59:59 132 3.3% 0.04486.5 KB 2.7% 0.14
Jun 4 10:00:00 - 10:59:59 139 3.5% 0.04908.3 KB 5.1% 0.25
Jun 4 11:00:00 - 11:59:59 126 3.1% 0.04360.5 KB 2.0% 0.10
Jun 4 12:00:00 - 12:59:59 117 2.9% 0.03354.7 KB 2.0% 0.10
Jun 4 13:00:00 - 13:59:59 151 3.8% 0.04450.1 KB 2.5% 0.13
Jun 4 14:00:00 - 14:59:59 178 4.4% 0.05625.5 KB 3.5% 0.17
Jun 4 15:00:00 - 15:59:59 241 6.0% 0.07794.5 KB 4.4% 0.22
Jun 4 16:00:00 - 16:59:59 225 5.6% 0.06799.9 KB 4.5% 0.22
Jun 4 17:00:00 - 17:59:59 260 6.5% 0.07811.9 KB 4.5% 0.23
Jun 4 18:00:00 - 18:59:59 283 7.1% 0.08856.4 KB 4.8% 0.24
Jun 4 19:00:00 - 19:59:59 235 5.9% 0.07740.8 KB 4.1% 0.21
Jun 4 20:00:00 - 20:59:59 217 5.4% 0.06736.4 KB 4.1% 0.20
Jun 4 21:00:00 - 21:59:59 205 5.1% 0.061.3 MB 7.7% 0.38
Jun 4 22:00:00 - 22:59:59 207 5.2% 0.062.1 MB 12.3% 0.61
Jun 4 23:00:00 - 23:59:59 240 6.0% 0.071.2 MB 6.6% 0.33
Jun 5 00:00:00 - 00:59:59 222 5.5% 0.061.1 MB 6.4% 0.32
Jun 5 01:00:00 - 01:59:59 114 2.8% 0.03453.1 KB 2.5% 0.13
Jun 5 02:00:00 - 02:59:59 123 3.1% 0.031.4 MB 7.7% 0.38
Jun 5 03:00:00 - 03:59:59 84 2.1% 0.02243.9 KB 1.4% 0.07
Jun 5 04:00:00 - 04:15:01 11 0.3% 0.0160.2 KB 0.3% 0.07
TOTAL: 23:59:59 4012 100.0% 0.0517.5 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 355 1 0 0 0 0 0 0 354
2nntp.terraraq.uk 351 0 0 0 0 0 0 0 351
3news-out.aioe.org 72 1 0 0 0 0 0 0 71
4gegeweb-out.news.tnetconsulting.net 8 0 0 0 0 0 0 0 8
5usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
6i2pn.org 3 0 0 0 0 0 0 0 3
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 793 2 0 0 0 0 0 0 791

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 196
EMP (phn path) 173
EMP (phn nph) 160
Bad path (news.giganews.com.POSTED) 123
EMP (md5) 47
EMP (phl) 44
User-issued spam cancel 22
Cancel of non-existing ID <27164768-8ca9-4a84-82c1-18e563a276een@googlegroups.com> 1
Cancel of non-existing ID <2cfbd92d-ab6a-4a98-96a1-6775dc700d9dn@googlegroups.com> 1
Cancel of non-existing ID <60b9b419$0$12689$426a74cc@news.free.fr> 1
TOTAL: 10 768

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7077
TOTAL: 17077

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 16
nntp.terraraq.uk 6
feed-out.gegeweb.org 1
TOTAL: 3 23
TOTAL: 1 23

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7454 66 3726 113 0 32 0%23:59:56
2news.tnetconsulting.net 7006 63 3914 33 0 32 0%23:59:56
3news.pasdenom.info 4675 7 3058 1 0 38 0%23:59:56
4news.gegeweb.org 3603 6 3453 0 0 23 0%23:59:56
5news.nntp4.net 3756 4 3632 0 0 24 0%23:59:56
6news.aioe.org 1990 1 1795 0 0 0 0%23:54:46
7nntp.terraraq.uk 2730 1 2454 0 0 38 0%23:59:56
TOTAL: 7 31214 148 22032 147 0 187 0%167:54:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net234.4 KB77.6 KB312.1 KB0.0 KB/s3.3 KB23:59:56
2i2pn.org202.6 KB237.4 KB440.0 KB0.0 KB/s2.5 KB23:59:56
3news.gegeweb.org60.3 KB0.0 KB60.3 KB0.0 KB/s10.1 KB23:59:56
4news.pasdenom.info21.3 KB3.0 KB24.3 KB0.0 KB/s3.0 KB23:59:56
5news.nntp4.net16.1 KB0.0 KB16.1 KB0.0 KB/s4.0 KB23:59:56
6nntp.terraraq.uk14.0 KB0.0 KB14.0 KB0.0 KB/s14.0 KB23:59:56
7news.aioe.org1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:54:46
TOTAL: 7550.0 KB318.0 KB868.0 KB0.0 KB/s2.9 KB167:54:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 6 3592.2 KB 10 0 000:13:29
TOTAL: 1 6 3592.2 KB 10 0 000:15:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 6 3592.2 KB 10 0 000:13:29
2*.security.ipip.net 1 00.0 KB 0 0 000:00:02
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:03
4*.gegeweb.eu 289 00.0 KB 0 0 000:00:23
5*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
6unresolved 5 00.0 KB 0 0 000:01:11
TOTAL: 6 303 3592.2 KB 10 0 000:15:20

NNRP auth users [Top 20]:

UserConn
mailman 289
TOTAL: 1 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mbp-gniel.niel.me 0.236 0.207 0.00000:13:29
88.165.5.23 0.069 0.099 0.00000:01:11
mail.gegeweb.eu 7.999 8.747 3.06900:00:23
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.011 0.046 0.00000:00:10
scanner-21.ch1.censys-scanner.com 0.032 0.032 0.00000:00:03
scan-141.security.ipip.net 0.047 0.012 0.00000:00:02
45.146.166.156 0.062 0.035 0.00000:00:00
? 0.026 0.026 0.00000:00:00
TOTAL: 8 8.482 9.204 3.06900:15:20

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 289
88.165.5.23 3
45.146.166.156 2
scanner-21.ch1.censys-scanner.com 1
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1
scan-141.security.ipip.net 1
TOTAL: 6 297

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
45.146.166.156 2
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
#003 2
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Host: 185.73.232.189:119 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
45.146.166.156 2 2
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 2 3 3

Newsgroup request counts (by category):

CategoryCountPct
1fr 26 74.3%
2news 6 17.1%
3grisbi 2 5.7%
4comp 1 2.9%
TOTAL: 4 35100.0%

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

NewsgroupCount
1fr.comp.usenet.lecteurs-de-news 18
2fr.usenet.forums.evolution 6
3news.admin.peering 4
4news.software.nntp 2
5grisbi.test 2
6fr.comp.os.bsd 1
7fr.comp.sys.mac.programmation 1
8comp.sys.raspberry-pi 1
TOTAL: 8 35