Daily Usenet report for news.niel.me

Jun 23 04:15:02 -- Jun 24 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 23 11:55:27 rpi-studio innd: filter: No Cancel-Key[sha1:WlSRZGpMYbHf8AoB46w3Gl6bGug=] matches Cancel-Lock[sha1:7yuelvHZjUtuxfciBS+gRzfx4jI=] target=<sav08u$8oj$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4765 45.8%839.9 KB 49.6%
innd 2338 22.5%400.5 KB 23.7%
nnrpd 1750 16.8%184.2 KB 10.9%
innfeed 1543 14.8%266.8 KB 15.8%
nocem 4 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 10401 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24981 68.1%
Negative hits 6990 19.1%
Do not exist 4679 12.8%
Cache misses 8 0.0%
TOTAL: 4 36658 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.036 0.0%32 0.000 1.125 4.000
article cancel00:00:00.004 0.0%35 0.000 0.114 1.000
article cleanup00:00:00.105 0.0%4695 0.000 0.022 0.111
article logging00:00:00.409 0.0%4707 0.000 0.087 0.765
article parse00:00:00.773 0.0%7789 0.000 0.099 0.286
article write00:00:02.615 0.0%4158 0.188 0.629 1.941
artlog/artcncl00:00:00.002 0.0%33 0.000 0.061 1.000
artlog/artcncl/perl00:00:00.001 0.0%32 0.000 0.031 1.000
data move00:00:00.108 0.0%40004 0.000 0.003 0.025
hisgrep/artcncl00:00:00.000 0.0%34 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.002 0.0%32 0.000 0.062 1.000
hisgrep/perl00:00:00.005 0.0%40 0.000 0.125 1.000
hishave/artcncl00:00:00.000 0.0%35 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%32 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.550 0.0%36725 0.000 0.015 0.039
history sync00:00:00.039 0.0%412 0.000 0.095 1.000
history write00:00:01.114 0.0%4694 0.000 0.237 3.485
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:23.086 99.9%40214 845.403 2149.080 6521.989
nntp read00:00:01.234 0.0%39658 0.000 0.031 0.067
overview write00:00:02.755 0.0%4158 0.115 0.663 6.200
perl filter00:00:22.013 0.0%4694 3.270 4.690 9.594
python filter00:00:00.014 0.0%7933 0.000 0.002 0.031
site send00:00:01.050 0.0%8323 0.000 0.126 0.475
TOTAL: 24:01:08.48924:00:55.915100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%4160 0.000 0.011 0.077
article prepare00:00:00.002 0.0%1692 0.000 0.001 0.021
article read00:00:00.059 0.0%331 0.000 0.178 3.500
backlog stats00:00:00.136 0.0%66564 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.886 0.0%37182 0.000 0.024 0.062
data write00:00:02.362 0.0%32930 0.035 0.072 0.116
idle23:59:45.671100.0%66564 579.010 1297.784 3478.653
status file00:00:00.424 0.0%167 1.000 2.539 9.000
TOTAL: 23:59:52.58423:59:49.587100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.542 34.1%1448 6.400 7.280 149.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.095 0.3%3188 0.000 0.030 0.273
TOTAL: 00:00:30.95100:00:10.637 34.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 4097 2164 1876 57 52%23:45:12
2usenet.pasdenom.info 4 6408 833 5570 5 12%47:37:27
3feed-out.gegeweb.org 2 2748 492 2255 1 17%23:59:51
4nntp.terraraq.uk 1 4079 472 3300 307 11%25:47:49
5news.nntp4.net 2 5940 207 5548 185 3%31:23:25
6i2pn.org 2 3953 44 3893 16 1%23:59:55
7gegeweb-out.news.tnetconsulting.net 2 3843 21 3801 21 0%23:59:55
8localhost 26 0 0 0 0 0%00:00:00
TOTAL: 8 40 31068 4233 26243 592 13%200:33:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.1 MB0.0 KB213.4 KB7.3 MB 97%3.4 KB
2nntp.terraraq.uk4.5 MB0.0 KB828.0 KB5.3 MB 84%7.0 KB
3news.nntp4.net3.9 MB0.0 KB462.0 KB4.4 MB 89%11.5 KB
4usenet.pasdenom.info2.3 MB12.3 KB20.9 KB2.3 MB 98%2.8 KB
5feed-out.gegeweb.org1.7 MB0.0 KB1.1 KB1.7 MB 99%3.5 KB
6i2pn.org219.5 KB0.0 KB52.1 KB271.5 KB 80%4.5 KB
7gegeweb-out.news.tnetconsulting.net72.3 KB0.0 KB70.6 KB142.9 KB 50%3.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 819.8 MB12.3 KB1.6 MB21.5 MB 92%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 23 04:15:02 - 04:59:59 96 2.3% 0.04275.1 KB 1.6% 0.10
Jun 23 05:00:00 - 05:59:59 97 2.3% 0.03401.2 KB 2.3% 0.11
Jun 23 06:00:00 - 06:59:59 140 3.4% 0.04575.8 KB 3.3% 0.16
Jun 23 07:00:00 - 07:59:59 105 2.5% 0.03423.3 KB 2.4% 0.12
Jun 23 08:00:00 - 08:59:59 116 2.8% 0.03319.8 KB 1.8% 0.09
Jun 23 09:00:00 - 09:59:59 87 2.1% 0.02348.3 KB 2.0% 0.10
Jun 23 10:00:00 - 10:59:59 182 4.4% 0.05532.8 KB 3.0% 0.15
Jun 23 11:00:00 - 11:59:59 101 2.4% 0.03376.0 KB 2.2% 0.10
Jun 23 12:00:00 - 12:59:59 163 3.9% 0.051.1 MB 6.2% 0.30
Jun 23 13:00:00 - 13:59:59 180 4.3% 0.05579.0 KB 3.3% 0.16
Jun 23 14:00:00 - 14:59:59 169 4.1% 0.05603.7 KB 3.5% 0.17
Jun 23 15:00:00 - 15:59:59 160 3.8% 0.04522.9 KB 3.0% 0.15
Jun 23 16:00:00 - 16:59:59 248 6.0% 0.07869.0 KB 5.0% 0.24
Jun 23 17:00:00 - 17:59:59 242 5.8% 0.071.4 MB 8.4% 0.41
Jun 23 18:00:00 - 18:59:59 271 6.5% 0.08884.4 KB 5.1% 0.25
Jun 23 19:00:00 - 19:59:59 248 6.0% 0.07949.0 KB 5.4% 0.26
Jun 23 20:00:00 - 20:59:59 244 5.9% 0.07894.3 KB 5.1% 0.25
Jun 23 21:00:00 - 21:59:59 226 5.4% 0.06782.2 KB 4.5% 0.22
Jun 23 22:00:00 - 22:59:59 189 4.5% 0.051.9 MB 11.2% 0.54
Jun 23 23:00:00 - 23:59:59 234 5.6% 0.07807.2 KB 4.6% 0.22
Jun 24 00:00:00 - 00:59:59 277 6.7% 0.081.4 MB 8.3% 0.40
Jun 24 01:00:00 - 01:59:59 123 3.0% 0.03420.0 KB 2.4% 0.12
Jun 24 02:00:00 - 02:59:59 131 3.2% 0.04502.4 KB 2.9% 0.14
Jun 24 03:00:00 - 03:59:59 112 2.7% 0.03396.4 KB 2.3% 0.11
Jun 24 04:00:00 - 04:15:01 15 0.4% 0.0266.3 KB 0.4% 0.07
TOTAL: 23:59:59 4156 100.0% 0.0517.1 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 277 0 0 0 0 0 0 0 277
2news.nntp4.net 135 1 0 0 0 0 0 0 134
3news-out.aioe.org 61 1 0 0 0 0 0 0 60
4gegeweb-out.news.tnetconsulting.net 52 0 0 0 0 0 0 0 52
5i2pn.org 11 0 0 0 0 0 0 0 11
6usenet.pasdenom.info 5 0 0 1 0 0 0 0 4
7feed-out.gegeweb.org 3 0 0 0 0 0 0 0 3
TOTAL: 7 544 2 0 1 0 0 0 0 541

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 215
Bad path (news.giganews.com.POSTED) 142
EMP (phn nph) 96
User-issued spam cancel 34
EMP (md5) 27
EMP (phl) 7
Cancel of <60d34e7b$0$23940$426a34cc@news.free.fr> without Cancel-Key 1
Cancel of non-existing ID <ijgisuFaot4U1@mid.individual.net> 1
Cancel of <sav08u$8oj$1@dont-email.me> without Cancel-Key 1
Cancel of <60d332cc$0$27426$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of <sav0q7$e7a8$1@pasdenom.info> without Cancel-Key 1
Cancel of <60d32cdd$0$21622$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of <sav177$f6$1@shakotay.alphanet.ch> without Cancel-Key 1
No Cancel-Key matches Cancel-Lock. target=<sav08u$8oj$1@dont-email.me> 1
TOTAL: 14 529

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3033
TOTAL: 13033

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 8
feed-out.gegeweb.org 2
nntp.terraraq.uk 2
TOTAL: 3 12
TOTAL: 1 12

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7601 162 3791 101 0 0 2%23:59:41
2news.tnetconsulting.net 6951 84 4034 33 0 0 1%23:59:51
3nntp.terraraq.uk 3074 18 2702 0 0 0 0%23:59:56
4news.pasdenom.info 4641 16 3029 2 0 4 0%23:59:57
5news.gegeweb.org 3783 6 3650 0 0 0 0%23:59:57
6news.nntp4.net 4918 1 4047 0 0 0 0%23:59:57
7news.aioe.org 1701 0 1545 0 0 0 0%23:58:56
TOTAL: 7 32669 287 22798 136 0 4 0%167:58:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org410.7 KB218.3 KB629.0 KB0.0 KB/s2.4 KB23:59:41
2news.tnetconsulting.net280.0 KB89.1 KB369.1 KB0.0 KB/s3.2 KB23:59:51
3nntp.terraraq.uk56.7 KB0.0 KB56.7 KB0.0 KB/s3.1 KB23:59:56
4news.pasdenom.info43.1 KB5.8 KB48.9 KB0.0 KB/s2.7 KB23:59:57
5news.gegeweb.org34.6 KB0.0 KB34.6 KB0.0 KB/s5.8 KB23:59:57
6news.nntp4.net1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:57
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:56
TOTAL: 7826.2 KB313.3 KB1.1 MB0.0 KB/s2.7 KB167:58:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.104.238.162 1 00.0 KB 0 0 000:00:02
288.165.5.23 2 00.0 KB 0 0 000:00:01
3mail.gegeweb.eu 288 00.0 KB 0 0 000:00:26
4scanner-21.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 292 00.0 KB 0 0 000:00:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:00:26
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 3 00.0 KB 0 0 000:00:03
TOTAL: 3 292 00.0 KB 0 0 000:00:30

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 8.149 9.103 3.07000:00:26
172.104.238.162 0.026 0.039 0.00000:00:02
88.165.5.23 0.054 0.065 0.00000:00:01
scanner-21.ch1.censys-scanner.com 0.012 0.050 0.00000:00:00
TOTAL: 4 8.241 9.257 3.07000:00:30

NNRP client timeouts [Top 20]:

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