Daily Usenet report for news.niel.me

Mar 13 04:15:01 -- Mar 14 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4442 35.3%756.2 KB 40.9%
nnrpd 3959 31.5%420.5 KB 22.7%
innd 2563 20.4%420.0 KB 22.7%
innfeed 1599 12.7%250.4 KB 13.5%
nocem 23 0.2%2.3 KB 0.1%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 12587 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19728 64.2%
Negative hits 6605 21.5%
Do not exist 4382 14.3%
Cache misses 5 0.0%
TOTAL: 4 30720 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.021 0.0%11 1.000 1.909 4.000
article cancel00:00:00.013 0.0%90 0.000 0.144 1.000
article cleanup00:00:00.082 0.0%4310 0.000 0.019 0.154
article logging00:00:00.317 0.0%4323 0.000 0.073 0.263
article parse00:00:00.891 0.0%8785 0.000 0.101 0.250
article write00:00:02.466 0.0%3659 0.200 0.674 4.625
artlog/artcncl00:00:00.001 0.0%89 0.000 0.011 0.015
artlog/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
data move00:00:00.107 0.0%35644 0.000 0.003 0.016
hisgrep/artcncl00:00:00.001 0.0%13 0.000 0.077 1.000
hisgrep/artcncl/perl00:00:00.003 0.0%11 0.000 0.273 1.000
hisgrep/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%90 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.499 0.0%30649 0.000 0.016 0.043
history sync00:00:00.058 0.0%398 0.000 0.146 2.667
history write00:00:00.949 0.0%4310 0.000 0.220 0.800
hiswrite/artcncl00:00:00.010 0.0%77 0.000 0.130 0.333
idle23:50:25.744100.0%35858 1123.708 2393.489 17148.943
nntp read00:00:01.229 0.0%35147 0.000 0.035 0.120
overview write00:00:02.627 0.0%3659 0.000 0.718 7.200
perl filter00:00:20.813 0.0%4310 3.121 4.829 10.000
python filter00:00:00.006 0.0%4312 0.000 0.001 0.050
site send00:00:01.203 0.0%7337 0.000 0.164 0.446
TOTAL: 23:51:08.18823:50:57.040100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.042 0.0%3720 0.000 0.011 0.143
article prepare00:00:00.002 0.0%1636 0.000 0.001 0.050
article read00:00:00.044 0.0%320 0.000 0.138 5.000
backlog stats00:00:00.120 0.0%56743 0.000 0.002 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.763 0.0%31933 0.000 0.024 0.067
data write00:00:02.097 0.0%28122 0.031 0.075 0.152
idle23:59:42.396100.0%56743 887.497 1522.345 5314.788
status file00:00:00.451 0.0%192 1.000 2.349 8.000
TOTAL: 23:59:48.71823:59:45.915100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%4 0.000 0.250 0.500
idle00:33:36.934 99.0%2189 6.400 921.395 44977.238
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.228 0.0%11028 0.000 0.021 0.182
readart00:00:00.062 0.0%83 0.000 0.747 3.000
TOTAL: 00:33:57.51500:33:37.225 99.0%----

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 3701 2500 1083 118 67%23:38:52
2feed-out.gegeweb.org 3 2716 492 2224 0 18%23:59:05
3news.nntp4.net 3 3799 178 3539 82 4%22:00:36
4nntp.terraraq.uk 2 1916 132 1591 193 6%15:43:27
5usenet.pasdenom.info 4 2672 118 2554 0 4%24:42:34
6i2pn.org 2 4355 110 4135 110 2%23:59:56
7gegeweb-out.news.tnetconsulting.net 2 4476 85 4346 45 1%26:42:09
8localhost 34 2 2 0 0 100%00:00:01
TOTAL: 8 52 23637 3617 19472 548 15%160:46:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org9.6 MB0.0 KB364.7 KB10.0 MB 96%3.9 KB
2news.nntp4.net2.0 MB0.0 KB1.0 MB3.0 MB 65%11.9 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%2.9 KB
4nntp.terraraq.uk1.2 MB0.0 KB1.7 MB2.9 MB 42%9.0 KB
5gegeweb-out.news.tnetconsulting.net1.2 MB0.0 KB299.8 KB1.5 MB 79%11.5 KB
6i2pn.org306.2 KB0.0 KB272.5 KB578.7 KB 52%2.6 KB
7usenet.pasdenom.info260.0 KB0.0 KB0.0 KB260.0 KB100%2.2 KB
8localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 816.0 MB0.0 KB3.6 MB19.6 MB 81%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 13 04:15:01 - 04:59:59 70 1.9% 0.03364.7 KB 2.1% 0.14
Mar 13 05:00:00 - 05:59:59 83 2.3% 0.02232.0 KB 1.4% 0.06
Mar 13 06:00:00 - 06:59:59 84 2.3% 0.02265.0 KB 1.5% 0.07
Mar 13 07:00:00 - 07:59:59 117 3.2% 0.03396.6 KB 2.3% 0.11
Mar 13 08:00:00 - 08:59:59 75 2.0% 0.02367.5 KB 2.1% 0.10
Mar 13 09:00:00 - 09:59:59 104 2.8% 0.03472.4 KB 2.8% 0.13
Mar 13 10:00:00 - 10:59:59 128 3.5% 0.04701.3 KB 4.1% 0.19
Mar 13 11:00:00 - 11:59:59 155 4.2% 0.04561.9 KB 3.3% 0.16
Mar 13 12:00:00 - 12:59:59 154 4.2% 0.04446.8 KB 2.6% 0.12
Mar 13 13:00:00 - 13:59:59 121 3.3% 0.03497.5 KB 2.9% 0.14
Mar 13 14:00:00 - 14:59:59 125 3.4% 0.03684.6 KB 4.0% 0.19
Mar 13 15:00:00 - 15:59:59 180 4.9% 0.05773.8 KB 4.5% 0.21
Mar 13 16:00:00 - 16:59:59 187 5.1% 0.051.3 MB 7.8% 0.37
Mar 13 17:00:00 - 17:59:59 216 5.9% 0.06891.8 KB 5.2% 0.25
Mar 13 18:00:00 - 18:59:59 220 6.0% 0.06761.4 KB 4.5% 0.21
Mar 13 19:00:00 - 19:59:59 213 5.8% 0.061.1 MB 6.6% 0.31
Mar 13 20:00:00 - 20:59:59 210 5.7% 0.06807.5 KB 4.7% 0.22
Mar 13 21:00:00 - 21:59:59 166 4.5% 0.05610.7 KB 3.6% 0.17
Mar 13 22:00:00 - 22:59:59 214 5.8% 0.061.2 MB 7.4% 0.35
Mar 13 23:00:00 - 23:59:59 200 5.4% 0.06976.0 KB 5.7% 0.27
Mar 14 00:00:00 - 00:59:59 204 5.5% 0.061.2 MB 7.1% 0.34
Mar 14 01:00:00 - 01:59:59 179 4.9% 0.05765.4 KB 4.5% 0.21
Mar 14 02:00:00 - 02:59:59 126 3.4% 0.04919.8 KB 5.4% 0.26
Mar 14 03:00:00 - 03:59:59 110 3.0% 0.03439.0 KB 2.6% 0.12
Mar 14 04:00:00 - 04:15:01 37 1.0% 0.04230.9 KB 1.4% 0.26
TOTAL: 24:00:00 3678 100.0% 0.0416.7 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 278 0 0 0 0 0 0 0 278
2news-out.aioe.org 128 2 0 0 0 0 0 0 126
3news.nntp4.net 112 0 0 0 0 0 0 0 112
4i2pn.org 112 0 0 0 0 0 0 0 112
5gegeweb-out.news.tnetconsulting.net 34 0 0 0 0 0 0 0 34
TOTAL: 5 664 2 0 0 0 0 0 0 662

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 175
Bad path (news.giganews.com.POSTED) 122
EMP (phl) 119
EMP (phn nph) 103
EMP (md5) 68
EMP (phn path) 54
Cancel for rejected article 4
Cancel of non-existing ID <uRY2I.34892$6V1.29744@fx47.iad> 1
Cancel of non-existing ID <552651ea-d360-4c84-9c4b-c8abbe60d3ban@googlegroups.com> 1
Too many newsgroups (low_xpost) 1
Cancel of non-existing ID <s2ivam$re9$1@dont-email.me> 1
TOTAL: 11 649

NoCeM on Spool:

IdGoodBadUniqueTotal
nocem@aioe.org1207575
bleachbot@httrack.com4044
TOTAL: 21607979

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 10
nntp.terraraq.uk 2
news.nntp4.net 1
TOTAL: 3 13
TOTAL: 1 13

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6751 201 3366 22 0 7 2%23:59:16
2news.tnetconsulting.net 6485 137 3528 12 0 7 2%23:59:52
3news.pasdenom.info 4182 18 3123 5 0 26 0%23:59:56
4news.nntp4.net 3701 5 3441 1 0 0 0%23:59:57
5news.gegeweb.org 3318 3 3184 0 0 0 0%23:59:57
6nntp.terraraq.uk 2523 1 2421 3 0 2 0%23:59:57
7news.aioe.org 1057 1 966 0 0 0 0%23:25:58
TOTAL: 7 28017 366 20029 43 0 42 1%167:24:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org544.9 KB41.8 KB586.7 KB0.0 KB/s2.6 KB23:59:16
2news.tnetconsulting.net500.9 KB21.9 KB522.8 KB0.0 KB/s3.5 KB23:59:52
3news.pasdenom.info54.4 KB20.1 KB74.5 KB0.0 KB/s3.2 KB23:59:56
4news.nntp4.net18.9 KB1.9 KB20.8 KB0.0 KB/s3.5 KB23:59:57
5news.gegeweb.org8.3 KB0.0 KB8.3 KB0.0 KB/s2.8 KB23:59:57
6nntp.terraraq.uk1.9 KB5.9 KB7.9 KB0.0 KB/s2.0 KB23:59:57
7news.aioe.org1.9 KB0.0 KB1.9 KB0.0 KB/s1.9 KB23:25:58
TOTAL: 71.1 MB91.6 KB1.2 MB0.0 KB/s3.0 KB167:24:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 24 55120.0 KB 29 1 000:27:51
22a03:4980:104:100:ed1c:8782:d6d8:211 14 913.8 KB 6 1 000:05:18
32a03:4980:104:100:4f64:6877:8eda:557f 2 12.5 KB 1 0 000:00:10
TOTAL: 3 40 65136.3 KB 36 2 000:33:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 24 55120.0 KB 29 1 000:27:51
2? 16 1016.3 KB 7 1 000:05:28
3*.gegeweb.eu 289 00.0 KB 0 0 000:00:24
4*.security.ipip.net 1 00.0 KB 0 0 000:00:01
5unresolved 2 00.0 KB 0 0 000:00:10
6*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 6 334 65136.3 KB 36 2 000:33:56

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.970 0.760 0.00000:27:51
2a03:4980:104:100:ed1c:8782:d6d8:211 0.581 0.562 0.00000:05:18
mail.gegeweb.eu 8.129 8.482 3.09000:00:24
2a03:4980:104:100:4f64:6877:8eda:557f 0.060 0.078 0.00000:00:10
192.241.220.251 0.030 0.030 0.00000:00:09
scan-141.security.ipip.net 0.035 0.023 0.00000:00:01
scanner-08.ch1.censys-scanner.com 0.066 0.033 0.00000:00:00
88.165.5.23 0.024 0.035 0.00000:00:00
TOTAL: 8 9.895 10.003 3.09000:33:56

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 289
scanner-08.ch1.censys-scanner.com 2
192.241.220.251 1
88.165.5.23 1
scan-141.security.ipip.net 1
TOTAL: 5 294

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1fr 51 78.5%
2news 7 10.8%
3local 6 9.2%
4grisbi 1 1.5%
TOTAL: 4 65100.0%

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

NewsgroupCount
1fr.comp.sys.raspberry-pi 16
2fr.comp.os.mac-os.x 13
3fr.usenet.divers 13
4local.test 6
5fr.comp.os.linux.configuration 6
6news.software.readers 6
7fr.usenet.forums.evolution 3
8news.answers 1
9grisbi.test 1
TOTAL: 9 65