Daily Usenet report for news.niel.me

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 4602 43.5%792.1 KB 47.2%
innd 2468 23.3%410.7 KB 24.5%
nnrpd 1918 18.1%199.1 KB 11.9%
innfeed 1592 15.0%277.0 KB 16.5%
nocem 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 10583 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23829 67.2%
Negative hits 7130 20.1%
Do not exist 4514 12.7%
Cache misses 6 0.0%
TOTAL: 4 35479 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.024 0.0%20 0.857 1.200 3.000
article cancel00:00:00.007 0.0%24 0.000 0.292 1.000
article cleanup00:00:00.087 0.0%4522 0.000 0.019 0.167
article logging00:00:00.350 0.0%4562 0.000 0.077 0.200
article parse00:00:00.814 0.0%8205 0.000 0.099 0.286
article write00:00:02.806 0.0%3877 0.250 0.724 4.469
artlog/artcncl00:00:00.002 0.0%24 0.000 0.083 1.000
artlog/artcncl/perl00:00:00.001 0.0%20 0.000 0.050 1.000
data move00:00:00.110 0.0%39353 0.000 0.003 0.015
hisgrep/artcncl00:00:00.001 0.0%20 0.000 0.050 0.143
hisgrep/artcncl/perl00:00:00.001 0.0%20 0.000 0.050 1.000
hisgrep/perl00:00:00.004 0.0%30 0.000 0.133 1.000
hishave/artcncl00:00:00.000 0.0%24 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.512 0.0%35538 0.000 0.014 0.040
history sync00:00:00.061 0.0%413 0.000 0.148 1.000
history write00:00:01.160 0.0%4522 0.000 0.257 1.459
hiswrite/artcncl00:00:00.001 0.0%4 0.000 0.250 0.333
idle24:00:26.916 99.9%39558 766.917 2184.815 10719.089
nntp read00:00:01.337 0.0%38991 0.006 0.034 0.066
overview write00:00:02.930 0.0%3877 0.000 0.756 17.000
perl filter00:00:21.400 0.0%4522 3.513 4.732 10.800
python filter00:00:00.009 0.0%7606 0.000 0.001 0.032
site send00:00:01.072 0.0%7759 0.000 0.138 0.405
TOTAL: 24:01:11.95624:00:59.605100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%3991 0.000 0.011 0.143
article prepare00:00:00.004 0.0%1480 0.000 0.003 0.062
article read00:00:00.052 0.0%323 0.000 0.161 6.000
backlog stats00:00:00.121 0.0%62422 0.000 0.002 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.811 0.0%34473 0.000 0.024 0.055
data write00:00:02.328 0.0%30533 0.024 0.076 0.151
idle23:59:25.340100.0%62422 615.957 1383.572 5408.712
status file00:00:00.459 0.0%187 1.000 2.455 7.000
TOTAL: 23:59:32.77723:59:29.160100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:03.200 78.4%1524 0.000 41.470 1382.292
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.099 0.1%3575 0.000 0.028 0.273
readart00:00:00.010 0.0%6 1.000 1.667 2.333
TOTAL: 00:01:20.60400:01:03.309 78.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-out.aioe.org 1 3822 2148 1609 65 56%24:10:01
2usenet.pasdenom.info 9 6288 613 5673 2 9%48:42:20
3feed-out.gegeweb.org 3 2749 597 2152 0 21%23:59:21
4nntp.terraraq.uk 1 3565 398 2763 404 11%23:31:18
5news.nntp4.net 1 3919 101 3718 100 2%21:50:49
6i2pn.org 1 4355 60 4271 24 1%23:59:59
7gegeweb-out.news.tnetconsulting.net 2 3994 7 3963 24 0%23:59:34
8localhost 26 0 0 0 0 0%00:00:00
TOTAL: 8 44 28692 3924 24149 619 13%190:13:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.7 MB0.0 KB445.3 KB8.2 MB 94%3.8 KB
2nntp.terraraq.uk3.1 MB0.0 KB3.8 MB6.9 MB 45%8.8 KB
3feed-out.gegeweb.org1.5 MB0.0 KB0.0 KB1.5 MB100%2.6 KB
4usenet.pasdenom.info1.5 MB0.0 KB3.4 KB1.5 MB 99%2.5 KB
5news.nntp4.net1.3 MB0.0 KB609.5 KB1.9 MB 69%9.9 KB
6i2pn.org121.6 KB0.0 KB88.3 KB209.9 KB 57%2.5 KB
7gegeweb-out.news.tnetconsulting.net15.4 KB0.0 KB107.6 KB123.0 KB 12%4.0 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 815.3 MB0.0 KB5.0 MB20.3 MB 75%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 5 04:15:01 - 04:59:59 84 2.2% 0.03294.2 KB 1.9% 0.11
May 5 05:00:00 - 05:59:59 116 3.0% 0.03933.1 KB 6.0% 0.26
May 5 06:00:00 - 06:59:59 94 2.4% 0.03461.5 KB 3.0% 0.13
May 5 07:00:00 - 07:59:59 80 2.1% 0.02330.4 KB 2.1% 0.09
May 5 08:00:00 - 08:59:59 75 1.9% 0.02272.6 KB 1.8% 0.08
May 5 09:00:00 - 09:59:59 120 3.1% 0.03346.9 KB 2.2% 0.10
May 5 10:00:00 - 10:59:59 111 2.9% 0.03294.1 KB 1.9% 0.08
May 5 11:00:00 - 11:59:59 123 3.2% 0.03372.5 KB 2.4% 0.10
May 5 12:00:00 - 12:59:59 127 3.3% 0.04815.1 KB 5.3% 0.23
May 5 13:00:00 - 13:59:59 154 4.0% 0.04497.3 KB 3.2% 0.14
May 5 14:00:00 - 14:59:59 180 4.6% 0.05473.4 KB 3.1% 0.13
May 5 15:00:00 - 15:59:59 220 5.7% 0.06568.0 KB 3.7% 0.16
May 5 16:00:00 - 16:59:59 302 7.8% 0.081.2 MB 7.8% 0.34
May 5 17:00:00 - 17:59:59 244 6.3% 0.07729.5 KB 4.7% 0.20
May 5 18:00:00 - 18:59:59 209 5.4% 0.06582.7 KB 3.8% 0.16
May 5 19:00:00 - 19:59:59 231 6.0% 0.06709.9 KB 4.6% 0.20
May 5 20:00:00 - 20:59:59 218 5.6% 0.061.3 MB 8.3% 0.36
May 5 21:00:00 - 21:59:59 222 5.7% 0.061.1 MB 7.5% 0.32
May 5 22:00:00 - 22:59:59 278 7.2% 0.081019.7 KB 6.6% 0.28
May 5 23:00:00 - 23:59:59 179 4.6% 0.05639.1 KB 4.1% 0.18
May 6 00:00:00 - 00:59:59 151 3.9% 0.04700.5 KB 4.5% 0.19
May 6 01:00:00 - 01:59:59 138 3.6% 0.04627.7 KB 4.1% 0.17
May 6 02:00:00 - 02:59:59 100 2.6% 0.03566.9 KB 3.7% 0.16
May 6 03:00:00 - 03:59:59 90 2.3% 0.03371.7 KB 2.4% 0.10
May 6 04:00:00 - 04:15:02 27 0.7% 0.03184.8 KB 1.2% 0.20
TOTAL: 24:00:01 3873 100.0% 0.0415.1 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 388 0 0 0 0 0 0 0 388
2news.nntp4.net 146 0 0 0 0 0 0 0 146
3news-out.aioe.org 102 3 0 0 0 0 0 0 99
4gegeweb-out.news.tnetconsulting.net 26 0 0 0 0 0 0 0 26
5i2pn.org 18 0 0 0 0 0 0 0 18
6feed-out.gegeweb.org 3 0 0 0 0 0 0 0 3
7usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 7 685 3 0 0 0 0 0 0 682

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.fan.rush-limbaugh 2
news.test 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 208
EMP (phn nph) 149
Bad path (news.giganews.com.POSTED) 131
EMP (md5) 80
EMP (phl) 61
User-issued spam cancel 5
Cancel of <s6sm8t$r7o$11@dont-email.me> without Cancel-Key 1
Cancel of <s6salh$fva$5@dont-email.me> without Cancel-Key 1
Cancel of <s6slp7$r7o$1@dont-email.me> without Cancel-Key 1
Cancel of <s6t3ej$2uf$4@dont-email.me> without Cancel-Key 1
HTML Multipart 1
Cancel of <s6spaj$djl$4@dont-email.me> without Cancel-Key 1
Cancel of non-existing ID <7dfe5e86-9c05-459a-b1c5-bf248e477397n@googlegroups.com> 1
Cancel of non-existing ID <iffnbaFbjf2U1@mid.individual.net> 1
TOTAL: 14 642

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1011
TOTAL: 11011

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 37
feed-out.gegeweb.org 3
TOTAL: 2 40
TOTAL: 1 40

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7173 167 3561 65 0 1 2%23:59:57
2news.tnetconsulting.net 6985 46 3810 17 0 1 0%23:59:57
3news.pasdenom.info 4659 31 2882 38 0 117 0%23:59:57
4nntp.terraraq.uk 2582 3 2414 0 0 0 0%23:59:57
5news.nntp4.net 4088 3 3765 0 0 0 0%23:57:08
6news.gegeweb.org 3414 0 3291 0 0 0 0%23:59:02
7news.aioe.org 1482 0 1382 0 0 0 0%23:39:26
TOTAL: 7 30383 250 21105 120 0 119 0%167:35:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org368.7 KB134.6 KB503.3 KB0.0 KB/s2.2 KB23:59:57
2news.tnetconsulting.net132.6 KB44.7 KB177.3 KB0.0 KB/s2.8 KB23:59:57
3news.pasdenom.info74.2 KB96.1 KB170.3 KB0.0 KB/s2.5 KB23:59:57
4news.nntp4.net15.5 KB0.0 KB15.5 KB0.0 KB/s5.2 KB23:57:08
5nntp.terraraq.uk6.0 KB0.0 KB6.0 KB0.0 KB/s2.0 KB23:59:57
6news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:02
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:39:26
TOTAL: 7596.9 KB275.5 KB872.4 KB0.0 KB/s2.4 KB167:35:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.168.1.41 2 46.2 KB 4 0 000:00:45
TOTAL: 1 2 46.2 KB 4 0 000:01:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 8 46.2 KB 4 0 000:00:47
2*.us-west-1.compute.amazonaws.com 2 00.0 KB 0 0 000:00:01
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.w90-2.abo.wanadoo.fr 3 00.0 KB 0 0 000:00:06
5*.gegeweb.eu 289 00.0 KB 0 0 000:00:24
TOTAL: 5 303 46.2 KB 4 0 000:01: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
192.168.1.41 0.078 0.077 0.00000:00:45
mail.gegeweb.eu 8.184 8.599 3.09600:00:24
amontsouris-654-1-96-151.w90-2.abo.wanadoo.fr 0.070 0.100 0.00000:00:06
88.165.5.23 0.183 0.175 0.00000:00:01
ec2-52-53-214-15.us-west-1.compute.amazonaws.com 0.055 0.027 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.046 0.018 0.00000:00:00
ec2-13-57-35-83.us-west-1.compute.amazonaws.com 0.039 0.019 0.00000:00:00
TOTAL: 7 8.655 9.015 3.09600:01:20

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 289
88.165.5.23 6
amontsouris-654-1-96-151.w90-2.abo.wanadoo.fr 3
ec2-52-53-214-15.us-west-1.compute.amazonaws.com 1
ec2-13-57-35-83.us-west-1.compute.amazonaws.com 1
scanner-07.ch1.censys-scanner.com 1
TOTAL: 6 301

NNRP unrecognized commands (by host):

SystemConn
scanner-07.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 3 75.0%
2grisbi 1 25.0%
TOTAL: 2 4100.0%

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

NewsgroupCount
1fr.usenet.documents 2
2grisbi.test 1
3fr.misc.bavardages.dinosaures 1
TOTAL: 3 4