Daily Usenet report for news.niel.me

Nov 15 04:15:01 -- Nov 16 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 15 17:00:04 rpi-studio pgpverify[5715]: pgpverify: verification failed
Nov 15 17:00:05 rpi-studio pgpverify[5730]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 4500 38.6%774.8 KB 43.2%
innd 3511 30.1%518.9 KB 29.0%
nnrpd 2080 17.8%221.8 KB 12.4%
innfeed 1558 13.4%273.6 KB 15.3%
controlchan 13 0.1%2.3 KB 0.1%
pgpverify 2 0.0%0.5 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 11665 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20880 65.4%
Negative hits 6557 20.5%
Do not exist 4443 13.9%
Cache misses 38 0.1%
TOTAL: 4 31918 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.024 0.0%5 2.000 4.800 6.500
article cancel00:00:00.008 0.0%8 0.000 1.000 2.000
article cleanup00:00:00.086 0.0%4446 0.000 0.019 0.100
article logging00:00:00.364 0.0%4468 0.000 0.081 0.259
article parse00:00:00.861 0.0%7514 0.000 0.115 0.333
article write00:00:02.448 0.0%3869 0.176 0.633 2.133
artlog/artcncl00:00:00.002 0.0%8 0.000 0.250 1.000
artlog/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
data move00:00:00.089 0.0%35011 0.000 0.003 0.016
hisgrep/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 0.500
hisgrep/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%8 0.000 0.125 0.333
hishave/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.483 0.0%31925 0.000 0.015 0.044
history sync00:00:00.178 0.0%409 0.000 0.435 61.000
history write00:00:00.926 0.0%4446 0.000 0.208 0.897
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:32.352 99.9%35796 889.866 2397.820 11765.078
nntp read00:00:01.135 0.0%35070 0.000 0.032 0.075
overview write00:00:02.855 0.0%3869 0.000 0.738 6.533
perl filter00:00:20.677 0.0%4446 2.762 4.651 10.478
python filter00:00:00.018 0.0%4453 0.000 0.004 0.083
site send00:00:01.221 0.0%7743 0.000 0.158 0.550
TOTAL: 23:51:15.69923:51:03.730100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.046 0.0%3955 0.000 0.012 0.091
article prepare00:00:00.001 0.0%852 0.000 0.001 0.125
article read00:00:00.026 0.0%167 0.000 0.156 8.000
backlog stats00:00:00.123 0.0%59298 0.000 0.002 0.017
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.843 0.0%33368 0.000 0.025 0.056
data write00:00:02.169 0.0%29388 0.031 0.074 0.124
idle23:58:39.264100.0%59298 653.416 1455.686 3975.020
status file00:00:00.399 0.0%167 1.000 2.389 17.000
TOTAL: 23:58:45.89623:58:42.871100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:24:09.948 93.0%1381 21.750 1049.926 12743.240
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.148 0.0%3739 0.000 0.040 0.500
readart00:00:00.083 0.0%168 0.453 0.494 0.569
TOTAL: 00:25:58.74700:24:10.179 93.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 1 3949 2281 1604 64 57%24:00:28
2i2pn.org 2 3904 723 3112 69 18%22:56:55
3feed-out.gegeweb.org 290 2621 342 2257 22 13%23:55:32
4nntp.terraraq.uk 2 4414 257 3830 327 5%26:43:29
5news.nntp4.net 1 4922 178 4530 214 3%26:38:10
6localhost 32 7 7 0 0 100%00:00:00
7gegeweb-out.news.tnetconsulting.net 2 3917 3 3907 7 0%23:57:14
8usenet.pasdenom.info 1 121 0 121 0 0%01:20:23
TOTAL: 8 331 23855 3791 19361 703 15%149:32:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.0 MB0.0 KB269.3 KB7.2 MB 96%3.2 KB
2nntp.terraraq.uk3.1 MB0.0 KB1.5 MB4.6 MB 66%8.0 KB
3i2pn.org2.8 MB0.0 KB377.2 KB3.2 MB 88%4.2 KB
4news.nntp4.net1.7 MB0.0 KB536.5 KB2.3 MB 76%5.9 KB
5feed-out.gegeweb.org979.6 KB0.0 KB23.7 KB1003.3 KB 97%2.8 KB
6gegeweb-out.news.tnetconsulting.net14.4 KB0.0 KB89.1 KB103.4 KB 13%10.3 KB
7localhost12.5 KB0.0 KB0.0 KB12.5 KB100%1.8 KB
8usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 815.6 MB0.0 KB2.8 MB18.4 MB 84%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 15 04:15:01 - 04:59:59 65 1.7% 0.02182.1 KB 1.1% 0.07
Nov 15 05:00:00 - 05:59:59 97 2.5% 0.03330.2 KB 2.0% 0.09
Nov 15 06:00:00 - 06:59:59 110 2.8% 0.03372.0 KB 2.2% 0.10
Nov 15 07:00:00 - 07:59:59 89 2.3% 0.02312.2 KB 1.9% 0.09
Nov 15 08:00:00 - 08:59:59 95 2.4% 0.03662.2 KB 4.0% 0.18
Nov 15 09:00:00 - 09:59:59 86 2.2% 0.02332.8 KB 2.0% 0.09
Nov 15 10:00:00 - 10:59:59 154 4.0% 0.04790.8 KB 4.7% 0.22
Nov 15 11:00:00 - 11:59:59 187 4.8% 0.05664.5 KB 4.0% 0.18
Nov 15 12:00:00 - 12:59:59 138 3.5% 0.04593.6 KB 3.5% 0.16
Nov 15 13:00:00 - 13:59:59 123 3.2% 0.03462.0 KB 2.8% 0.13
Nov 15 14:00:00 - 14:59:59 185 4.8% 0.05524.6 KB 3.1% 0.15
Nov 15 15:00:00 - 15:59:59 168 4.3% 0.05572.8 KB 3.4% 0.16
Nov 15 16:00:00 - 16:59:59 184 4.7% 0.05828.0 KB 4.9% 0.23
Nov 15 17:00:00 - 17:59:59 229 5.9% 0.061.1 MB 6.8% 0.32
Nov 15 18:00:00 - 18:59:59 265 6.8% 0.071.2 MB 7.1% 0.33
Nov 15 19:00:00 - 19:59:59 299 7.7% 0.081.0 MB 6.1% 0.28
Nov 15 20:00:00 - 20:59:59 206 5.3% 0.06598.9 KB 3.6% 0.17
Nov 15 21:00:00 - 21:59:59 227 5.8% 0.061.1 MB 6.5% 0.30
Nov 15 22:00:00 - 22:59:59 225 5.8% 0.061.4 MB 8.4% 0.39
Nov 15 23:00:00 - 23:59:59 165 4.2% 0.05640.9 KB 3.8% 0.18
Nov 16 00:00:00 - 00:59:59 169 4.3% 0.05511.6 KB 3.1% 0.14
Nov 16 01:00:00 - 01:59:59 145 3.7% 0.04514.2 KB 3.1% 0.14
Nov 16 02:00:00 - 02:59:59 133 3.4% 0.041.4 MB 8.4% 0.39
Nov 16 03:00:00 - 03:59:59 119 3.1% 0.03495.8 KB 3.0% 0.14
Nov 16 04:00:00 - 04:15:01 26 0.7% 0.0386.1 KB 0.5% 0.10
TOTAL: 24:00:00 3889 100.0% 0.0516.3 MB 100.0% 0.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 273 0 0 0 0 0 0 0 273
2news.nntp4.net 127 0 0 0 0 0 0 0 127
3news-out.aioe.org 93 6 0 0 0 0 0 0 87
4i2pn.org 79 0 0 0 0 0 0 0 79
5feed-out.gegeweb.org 22 0 0 0 0 0 0 0 22
6gegeweb-out.news.tnetconsulting.net 3 0 0 0 0 0 0 0 3
7usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 7 598 6 0 0 0 0 0 0 592

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.radio.talk 2
fr.petites-annonces.divers 2
news.test 1
fr.petites-annonces.informatique.materiel 1
TOTAL: 4 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 195
EMP (phn nph) 121
EMP (md5) 102
Bad path (news.giganews.com.POSTED) 89
User-issued spam cancel 56
EMP (phl) 5
Cancel of <mn.7ae27e5b471fe556.145333@Rotto.eu> without Cancel-Key 1
Cancel of <mn.7aeb7e5b750cd135.145333@Rotto.eu> without Cancel-Key 1
TOTAL: 8 570

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 22
TOTAL: 1 22
TOTAL: 1 22

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 5946 27 3027 24 0 43 0%23:59:57
2news.gegeweb.org 3630 19 3444 72 0 0 0%23:59:57
3news.tnetconsulting.net 6807 15 3866 6 0 26 0%23:59:30
4news.pasdenom.info 4657 10 3304 21 0 1 0%23:59:57
5news.nntp4.net 4443 8 3672 0 0 0 0%23:59:57
6news.aioe.org 1433 8 1318 0 0 0 0%23:58:26
7nntp.terraraq.uk 2579 3 2501 0 0 0 0%23:59:57
TOTAL: 7 29495 90 21132 123 0 70 0%167:57:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org107.6 KB44.4 KB152.0 KB0.0 KB/s3.0 KB23:59:57
2news.tnetconsulting.net68.8 KB40.4 KB109.2 KB0.0 KB/s5.2 KB23:59:30
3news.gegeweb.org49.3 KB249.6 KB298.8 KB0.0 KB/s3.3 KB23:59:57
4news.pasdenom.info35.1 KB1.2 MB1.2 MB0.0 KB/s41.1 KB23:59:57
5news.nntp4.net26.1 KB0.0 KB26.1 KB0.0 KB/s3.3 KB23:59:57
6news.aioe.org16.6 KB0.0 KB16.6 KB0.0 KB/s2.1 KB23:58:26
7nntp.terraraq.uk10.2 KB0.0 KB10.2 KB0.0 KB/s3.4 KB23:59:57
TOTAL: 7313.6 KB1.5 MB1.8 MB0.0 KB/s8.9 KB167:57:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 5 81326.9 KB 15 7 000:23:34
TOTAL: 1 5 81326.9 KB 15 7 000:25:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 5 81326.9 KB 15 7 000:23:34
2unresolved 4 00.0 KB 0 0 000:00:12
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:10
TOTAL: 3 297 81326.9 KB 15 7 000:25:58

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.327 0.283 0.00000:23:34
sys.gegeweb.eu 8.125 8.921 2.94000:02:10
138.197.103.140 0.030 0.030 0.00000:00:10
146.0.77.39 0.070 0.023 0.00000:00:01
88.165.5.23 0.061 0.060 0.00000:00:00
TOTAL: 5 8.613 9.317 2.94000:25:58

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
88.165.5.23 2
138.197.103.140 1
146.0.77.39 1
TOTAL: 4 292

Newsgroup request counts (by category):

CategoryCountPct
1fr 69 85.2%
2grisbi 9 11.1%
3news 3 3.7%
TOTAL: 3 81100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 49
2fr.usenet.distribution 14
3grisbi.bugsreports 6
4grisbi.test 3
5fr.comp.sys.mac 3
6news.admin.hierarchies 1
7fr.comp.usenet.lecteurs-de-news 1
8news.announce.newgroups 1
9news.admin.peering 1
10fr.comp.usenet.serveurs 1
11fr.comp.sys.raspberry-pi 1
TOTAL: 11 81