Daily Usenet report for news.niel.me

Feb 11 04:15:01 -- Feb 12 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 11 11:34:33 rpi-studio innd: filter: Valid Cancel-Key xH06wZ9gkm3zY51LxWyPjTjV20s= found. target=<s03083$2sr$1@dont-email.me>
Feb 11 17:14:08 rpi-studio innd: filter: Valid Cancel-Key DS0jQkRSqsuvxBpwRNE3ollnm7Q= found. target=<87czx6a8gu.fsf@doppelsaurus.mobileactivedefense.com>
Feb 11 23:39:10 rpi-studio innd: filter: Valid Cancel-Key URc14ORbbkl1/U6NQzIIcCv1+vs= found. target=<i8lpnfFqv4U1@mid.individual.net>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4989 45.2%823.6 KB 49.1%
nnrpd 2455 22.2%250.8 KB 15.0%
innd 2152 19.5%361.2 KB 21.6%
innfeed 1415 12.8%237.2 KB 14.2%
nocem 30 0.3%3.1 KB 0.2%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11042 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19369 62.6%
Negative hits 6643 21.5%
Do not exist 4898 15.8%
Cache misses 7 0.0%
TOTAL: 4 30917 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.029 0.0%19 0.000 1.526 6.000
article cancel00:00:00.010 0.0%47 0.000 0.213 1.000
article cleanup00:00:00.099 0.0%4888 0.000 0.020 0.222
article logging00:00:00.374 0.0%4935 0.000 0.076 0.214
article parse00:00:00.830 0.0%8670 0.000 0.096 0.280
article write00:00:04.709 0.0%4483 0.091 1.050 48.571
artlog/artcncl00:00:00.004 0.0%42 0.000 0.095 0.500
artlog/artcncl/perl00:00:00.002 0.0%19 0.000 0.105 1.000
data move00:00:00.095 0.0%35076 0.000 0.003 0.017
hisgrep/artcncl00:00:00.000 0.0%24 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%19 0.000 0.053 1.000
hisgrep/perl00:00:00.002 0.0%20 0.000 0.100 1.000
hishave/artcncl00:00:00.001 0.0%47 0.000 0.021 1.000
hishave/artcncl/perl00:00:00.000 0.0%19 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.494 0.0%30922 0.000 0.016 0.053
history sync00:00:00.052 0.0%407 0.000 0.128 1.000
history write00:00:01.060 0.0%4888 0.000 0.217 0.660
hiswrite/artcncl00:00:00.005 0.0%23 0.000 0.217 1.000
idle24:00:25.367 99.9%35464 1314.879 2436.989 10534.175
nntp read00:00:01.193 0.0%34664 0.000 0.034 0.082
overview write00:00:02.679 0.0%4483 0.091 0.598 4.833
perl filter00:00:21.356 0.0%4888 3.216 4.369 8.967
python filter00:00:00.014 0.0%4890 0.000 0.003 0.042
site send00:00:01.335 0.0%8995 0.000 0.148 0.455
TOTAL: 24:01:11.26224:00:59.711100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.051 0.0%4458 0.000 0.011 0.111
article prepare00:00:00.000 0.0%380 0.000 0.000 0.000
article read00:00:00.012 0.0%77 0.000 0.156 4.000
backlog stats00:00:00.115 0.0%62788 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.865 0.0%35000 0.000 0.025 0.077
data write00:00:02.337 0.0%30418 0.035 0.077 0.139
idle23:49:58.683100.0%62788 758.441 1366.482 4610.152
status file00:00:00.541 0.0%184 1.000 2.940 11.273
TOTAL: 23:50:05.75723:50:02.604100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:20:17.216 98.3%1765 19.400 689.641 8614.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.168 0.0%5028 0.000 0.033 0.273
readart00:00:00.032 0.0%109 0.000 0.294 1.200
TOTAL: 00:20:37.69700:20:17.416 98.4%----

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 1 4664 3279 1296 89 70%25:56:55
2news.nntp4.net 5 4511 660 3637 214 14%23:27:26
3feed-out.gegeweb.org 2 3359 433 2926 0 12%23:59:57
4usenet.pasdenom.info 3 2409 107 2302 0 4%23:58:16
5i2pn.org 1 4695 62 4522 111 1%22:34:27
6gegeweb-out.news.tnetconsulting.net 1 4473 45 4409 19 1%23:59:55
7localhost 32 2 2 0 0 100%00:00:00
TOTAL: 7 45 24113 4588 19092 433 19%143:56:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org11.3 MB0.0 KB359.4 KB11.7 MB 97%3.6 KB
2news.nntp4.net3.4 MB0.0 KB614.4 KB4.0 MB 84%4.7 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%3.2 KB
4gegeweb-out.news.tnetconsulting.net251.3 KB0.0 KB68.9 KB320.1 KB 78%5.0 KB
5usenet.pasdenom.info244.5 KB0.0 KB0.0 KB244.5 KB100%2.3 KB
6i2pn.org124.4 KB0.0 KB272.4 KB396.9 KB 31%2.3 KB
7localhost3.2 KB0.0 KB0.0 KB3.2 KB100%1.6 KB
TOTAL: 716.7 MB0.0 KB1.3 MB18.0 MB 92%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 11 04:15:01 - 04:59:59 77 1.7% 0.03346.3 KB 2.0% 0.13
Feb 11 05:00:00 - 05:59:59 72 1.6% 0.02205.7 KB 1.2% 0.06
Feb 11 06:00:00 - 06:59:59 92 2.1% 0.03355.1 KB 2.1% 0.10
Feb 11 07:00:00 - 07:59:59 95 2.1% 0.03341.9 KB 2.0% 0.09
Feb 11 08:00:00 - 08:59:59 88 2.0% 0.02302.9 KB 1.8% 0.08
Feb 11 09:00:00 - 09:59:59 132 2.9% 0.04344.2 KB 2.0% 0.10
Feb 11 10:00:00 - 10:59:59 137 3.1% 0.04422.8 KB 2.5% 0.12
Feb 11 11:00:00 - 11:59:59 183 4.1% 0.05562.9 KB 3.3% 0.16
Feb 11 12:00:00 - 12:59:59 159 3.5% 0.04481.3 KB 2.8% 0.13
Feb 11 13:00:00 - 13:59:59 196 4.4% 0.051.0 MB 6.1% 0.29
Feb 11 14:00:00 - 14:59:59 193 4.3% 0.05552.6 KB 3.2% 0.15
Feb 11 15:00:00 - 15:59:59 261 5.8% 0.07987.7 KB 5.8% 0.27
Feb 11 16:00:00 - 16:59:59 281 6.3% 0.08924.7 KB 5.4% 0.26
Feb 11 17:00:00 - 17:59:59 240 5.4% 0.07806.5 KB 4.7% 0.22
Feb 11 18:00:00 - 18:59:59 265 5.9% 0.07870.9 KB 5.1% 0.24
Feb 11 19:00:00 - 19:59:59 269 6.0% 0.07869.3 KB 5.1% 0.24
Feb 11 20:00:00 - 20:59:59 264 5.9% 0.07839.9 KB 4.9% 0.23
Feb 11 21:00:00 - 21:59:59 200 4.5% 0.06696.0 KB 4.1% 0.19
Feb 11 22:00:00 - 22:59:59 234 5.2% 0.07956.9 KB 5.6% 0.27
Feb 11 23:00:00 - 23:59:59 230 5.1% 0.061.0 MB 6.1% 0.29
Feb 12 00:00:00 - 00:59:59 219 4.9% 0.06830.3 KB 4.8% 0.23
Feb 12 01:00:00 - 01:59:59 225 5.0% 0.061.9 MB 11.1% 0.53
Feb 12 02:00:00 - 02:59:59 159 3.5% 0.04496.3 KB 2.9% 0.14
Feb 12 03:00:00 - 03:59:59 168 3.8% 0.05790.1 KB 4.6% 0.22
Feb 12 04:00:00 - 04:15:01 41 0.9% 0.05169.5 KB 1.0% 0.19
TOTAL: 24:00:00 4480 100.0% 0.0516.7 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 230 0 0 0 0 0 0 0 230
2news-out.aioe.org 130 1 0 0 0 0 0 0 129
3i2pn.org 71 0 0 0 0 0 0 0 71
4gegeweb-out.news.tnetconsulting.net 17 0 0 0 0 0 0 0 17
TOTAL: 4 448 1 0 0 0 0 0 0 447

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 120
Too many newsgroups 115
EMP (phn nph) 78
EMP (phl) 65
EMP (md5) 20
HTML Multipart 2
Cancel of non-existing ID <60252c91$0$21616$426a74cc@news.free.fr> 1
TOTAL: 7 401

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1501515
nocem@aioe.org1001313
TOTAL: 22502828

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 44
news.nntp4.net 2
TOTAL: 2 46
TOTAL: 1 46

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 8429 35 4378 6 0 0 0%23:59:57
2news.tnetconsulting.net 7989 34 4445 1 0 3 0%23:59:57
3news.nntp4.net 3991 6 3778 0 0 0 0%23:59:42
4news.pasdenom.info 4997 4 3901 3 0 2 0%23:59:57
5news.gegeweb.org 4072 4 3925 0 0 0 0%23:59:57
6news.aioe.org 1337 2 1141 0 0 0 0%23:32:28
TOTAL: 6 30815 85 21568 10 0 5 0%143:31:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net197.1 KB0.8 KB198.0 KB0.0 KB/s5.7 KB23:59:57
2i2pn.org181.8 KB14.3 KB196.1 KB0.0 KB/s4.8 KB23:59:57
3news.nntp4.net13.1 KB0.0 KB13.1 KB0.0 KB/s2.2 KB23:59:42
4news.gegeweb.org7.5 KB0.0 KB7.5 KB0.0 KB/s1.9 KB23:59:57
5news.pasdenom.info7.5 KB7.3 KB14.8 KB0.0 KB/s2.1 KB23:59:57
6news.aioe.org3.3 KB0.0 KB3.3 KB0.0 KB/s1.6 KB23:32:28
TOTAL: 6410.2 KB22.5 KB432.7 KB0.0 KB/s4.6 KB143:31:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 11 72246.5 KB 21 2 000:19:35
TOTAL: 1 11 72246.5 KB 21 2 000:20:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 11 72246.5 KB 21 2 000:19:35
2*.208-100-26.static.steadfastdns.net 10 00.0 KB 0 0 000:00:03
3*.w90-2.abo.wanadoo.fr 2 00.0 KB 0 0 000:00:04
4*.gegeweb.eu 288 00.0 KB 0 0 000:00:40
5unresolved 5 00.0 KB 0 0 000:00:11
6*.security.ipip.net 1 00.0 KB 0 0 000:00:01
TOTAL: 6 317 72246.5 KB 21 2 000:20:37

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mbp-gniel.niel.me 0.482 0.456 0.00000:19:35
mail.gegeweb.eu 7.946 8.452 2.50500:00:40
192.241.197.146 0.043 0.017 0.00000:00:09
amontsouris-654-1-96-85.w90-2.abo.wanadoo.fr 0.083 0.027 0.00000:00:04
ip237.208-100-26.static.steadfastdns.net 0.213 0.129 0.00000:00:03
88.165.5.23 0.090 0.132 0.00000:00:02
scan-141.security.ipip.net 0.031 0.021 0.00000:00:01
TOTAL: 7 8.888 9.234 2.50500:20:37

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
ip237.208-100-26.static.steadfastdns.net 10
88.165.5.23 4
amontsouris-654-1-96-85.w90-2.abo.wanadoo.fr 2
scan-141.security.ipip.net 1
192.241.197.146 1
TOTAL: 6 306

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
Host: 185.73.232.189:119 1
Connection: close 1
GET / HTTP/1.1 1
TOTAL: 4 4

Newsgroup request counts (by category):

CategoryCountPct
1fr 62 86.1%
2grisbi 8 11.1%
3news 2 2.8%
TOTAL: 3 72100.0%

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

NewsgroupCount
1fr.comp.os.mac-os.x 24
2fr.usenet.documents 24
3fr.usenet.forums.evolution 9
4grisbi.bugsreports 5
5grisbi.devel 2
6news.software.nntp 2
7fr.comp.sys.mac.communication 2
8fr.comp.lang.c 1
9fr.comp.mail 1
10fr.usenet.divers 1
11grisbi.test 1
TOTAL: 11 72
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me