Daily Usenet report for news.niel.me

May 15 04:15:02 -- May 16 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 15 17:00:08 rpi-studio pgpverify[1351]: pgpverify: verification failed
May 15 17:00:17 rpi-studio pgpverify[1368]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 2435 29.7%443.8 KB 33.9%
innd 2229 27.2%401.9 KB 30.7%
innfeed 1759 21.5%274.1 KB 21.0%
nnrpd 1750 21.4%185.5 KB 14.2%
controlchan 13 0.2%2.3 KB 0.2%
pgpverify 2 0.0%0.3 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 7 8189 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13089 61.3%
Negative hits 5848 27.4%
Do not exist 2398 11.2%
Cache misses 8 0.0%
TOTAL: 4 21343 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.008 0.0%7 1.000 1.143 1.500
article cancel00:00:00.001 0.0%7 0.000 0.143 0.500
article cleanup00:00:00.047 0.0%2411 0.000 0.019 0.250
article logging00:00:00.158 0.0%2413 0.000 0.065 0.278
article parse00:00:00.291 0.0%7032 0.000 0.041 0.167
article write00:00:01.070 0.0%2102 0.000 0.509 2.200
artlog/artcncl00:00:00.001 0.0%7 0.000 0.143 0.500
artlog/artcncl/perl00:00:00.001 0.0%7 0.000 0.143 0.500
data move00:00:00.128 0.0%23954 0.000 0.005 0.031
hisgrep/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%8 0.000 0.125 0.500
hishave/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.331 0.0%21437 0.000 0.015 0.048
history sync00:00:00.048 0.0%401 0.000 0.120 1.000
history write00:00:00.366 0.0%2411 0.000 0.152 0.625
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:53.387100.0%26351 1197.786 3258.069 40056.200
nntp read00:00:00.638 0.0%25616 0.000 0.025 0.058
overview write00:00:00.755 0.0%2102 0.000 0.359 2.250
perl filter00:00:10.007 0.0%2411 2.170 4.151 13.000
python filter00:00:00.015 0.0%2411 0.000 0.006 0.111
site send00:00:00.685 0.0%4221 0.000 0.162 0.625
TOTAL: 23:51:15.30623:51:07.938100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%2107 0.000 0.009 0.200
article prepare00:00:00.003 0.0%984 0.000 0.003 0.250
article read00:00:00.049 0.0%232 0.000 0.211 1.000
backlog stats00:00:00.167 0.0%33476 0.000 0.005 0.033
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.431 0.0%17429 0.000 0.025 0.105
data write00:00:00.809 0.0%15640 0.000 0.052 0.130
idle23:49:51.756100.0%33476 948.179 2562.784 8228.082
status file00:00:00.523 0.0%228 1.000 2.294 9.000
TOTAL: 23:50:01.83923:49:53.756100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.148 26.1%1446 9.800 20.158 96.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.093 0.1%3185 0.000 0.029 0.273
TOTAL: 00:01:51.77200:00:29.241 26.2%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 2 2080 1026 1054 0 49%23:59:29
2news.nntp4.net 2 2063 319 1639 105 15%20:17:31
3gegeweb-out.news.tnetconsulting.net 2 1763 190 1534 39 10%23:34:55
4news.glou.org 3 1814 159 1522 133 8%22:32:31
5usenet.pasdenom.info 2 1207 123 1077 7 10%19:07:20
6nntp.terraraq.uk 3 1797 65 1731 1 3%22:30:15
7i2pn.org 1 385 29 356 0 7%05:29:53
8news.samoylyk.net 1 2214 20 2194 0 0%23:59:46
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 41 13323 1931 11107 285 14%161:31:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.7 MB0.0 KB0.0 KB3.7 MB100%3.7 KB
2news.nntp4.net1.6 MB0.0 KB1004.4 KB2.5 MB 61%6.1 KB
3news.glou.org696.8 KB0.0 KB386.9 KB1.1 MB 64%3.7 KB
4gegeweb-out.news.tnetconsulting.net634.6 KB0.0 KB248.4 KB883.1 KB 71%3.9 KB
5usenet.pasdenom.info296.8 KB0.0 KB8.3 KB305.1 KB 97%2.3 KB
6nntp.terraraq.uk213.7 KB0.0 KB1.4 KB215.0 KB 99%3.3 KB
7i2pn.org130.8 KB0.0 KB0.0 KB130.8 KB100%4.5 KB
8news.samoylyk.net108.5 KB0.0 KB0.0 KB108.5 KB100%5.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.3 MB0.0 KB1.6 MB8.9 MB 81%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 15 04:15:02 - 04:59:59 47 2.2% 0.02211.8 KB 2.4% 0.08
May 15 05:00:00 - 05:59:59 33 1.6% 0.01206.3 KB 2.4% 0.06
May 15 06:00:00 - 06:59:59 45 2.1% 0.01288.5 KB 3.3% 0.08
May 15 07:00:00 - 07:59:59 41 1.9% 0.01113.2 KB 1.3% 0.03
May 15 08:00:00 - 08:59:59 56 2.7% 0.02217.0 KB 2.5% 0.06
May 15 09:00:00 - 09:59:59 58 2.7% 0.02300.4 KB 3.4% 0.08
May 15 10:00:00 - 10:59:59 93 4.4% 0.03341.8 KB 3.9% 0.09
May 15 11:00:00 - 11:59:59 88 4.2% 0.02296.4 KB 3.4% 0.08
May 15 12:00:00 - 12:59:59 82 3.9% 0.02736.0 KB 8.4% 0.20
May 15 13:00:00 - 13:59:59 91 4.3% 0.03298.3 KB 3.4% 0.08
May 15 14:00:00 - 14:59:59 77 3.6% 0.02218.9 KB 2.5% 0.06
May 15 15:00:00 - 15:59:59 100 4.7% 0.03398.1 KB 4.6% 0.11
May 15 16:00:00 - 16:59:59 125 5.9% 0.03494.4 KB 5.7% 0.14
May 15 17:00:00 - 17:59:59 162 7.7% 0.04873.1 KB 10.0% 0.24
May 15 18:00:00 - 18:59:59 136 6.4% 0.04604.1 KB 6.9% 0.17
May 15 19:00:00 - 19:59:59 113 5.4% 0.03292.7 KB 3.3% 0.08
May 15 20:00:00 - 20:59:59 168 8.0% 0.05589.2 KB 6.7% 0.16
May 15 21:00:00 - 21:59:59 125 5.9% 0.03357.8 KB 4.1% 0.10
May 15 22:00:00 - 22:59:59 95 4.5% 0.03271.8 KB 3.1% 0.08
May 15 23:00:00 - 23:59:59 72 3.4% 0.02243.5 KB 2.8% 0.07
May 16 00:00:00 - 00:59:59 95 4.5% 0.03563.8 KB 6.4% 0.16
May 16 01:00:00 - 01:59:59 66 3.1% 0.02252.1 KB 2.9% 0.07
May 16 02:00:00 - 02:59:59 88 4.2% 0.02390.2 KB 4.5% 0.11
May 16 03:00:00 - 03:59:59 39 1.8% 0.01127.9 KB 1.5% 0.04
May 16 04:00:00 - 04:15:01 15 0.7% 0.0256.6 KB 0.6% 0.06
TOTAL: 23:59:59 2110 100.0% 0.028.5 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.glou.org 134 0 0 0 0 0 0 0 134
2news.nntp4.net 125 0 0 0 0 0 0 0 125
3gegeweb-out.news.tnetconsulting.net 39 0 0 0 0 0 0 0 39
4nntp.terraraq.uk 7 0 0 0 0 0 0 0 7
5usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
6i2pn.org 2 0 0 0 0 0 0 0 2
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 311 0 0 0 0 0 0 0 311

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 143
EMP (md5) 71
Bad path (news.giganews.com.POSTED) 47
Too many newsgroups 36
EMP (phl) 9
hierarchy violation - crosspost outside sdnet 1
Cancel for rejected article 1
Cancel of non-existing ID <v22q7r$107e2$1@dont-email.me> 1
TOTAL: 8 309

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
news.nntp4.net 1
TOTAL: 2 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3395 111 1818 49 0 4 3%23:59:54
2news.gegeweb.org 1130 59 1039 0 0 0 5%23:44:29
3news.samoylyk.net 2667 8 2085 0 0 0 0%23:59:54
4news.tnetconsulting.net 3547 6 2089 11 0 2 0%23:59:54
5news.nntp4.net 1764 1 1727 0 0 0 0%23:58:43
6news.aioe.org 0 0 0 0 0 1712 0%23:59:59
7nntp.terraraq.uk 1360 0 1242 0 0 0 0%23:58:33
8news.pasdenom.info 1859 0 1698 2 0 0 0%23:58:48
TOTAL: 8 15722 185 11698 62 0 1718 1%191:40:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org307.1 KB226.0 KB533.2 KB0.0 KB/s3.3 KB23:59:54
2news.gegeweb.org268.0 KB0.0 KB268.0 KB0.0 KB/s4.5 KB23:44:29
3news.samoylyk.net18.8 KB0.0 KB18.8 KB0.0 KB/s2.4 KB23:59:54
4news.tnetconsulting.net18.3 KB33.6 KB51.8 KB0.0 KB/s3.0 KB23:59:54
5news.nntp4.net3.1 KB0.0 KB3.1 KB0.0 KB/s3.1 KB23:58:43
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:33
8news.pasdenom.info0.0 KB11.1 KB11.1 KB0.0 KB/s5.5 KB23:58:48
TOTAL: 8615.4 KB270.6 KB886.0 KB0.0 KB/s3.6 KB191:40:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12607:ff10:c8:594::6 1 00.0 KB 0 0 000:00:01
280.66.76.130 1 00.0 KB 0 0 000:00:00
3mail.gegeweb.eu 288 00.0 KB 0 0 000:01:46
451.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
5192.241.200.65 1 00.0 KB 0 0 000:00:00
TOTAL: 5 292 00.0 KB 0 0 000:01:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:46
2*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
3? 1 00.0 KB 0 0 000:00:01
4unresolved 2 00.0 KB 0 0 000:00:01
TOTAL: 4 292 00.0 KB 0 0 000:01:51

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 4.228 4.132 1.50800:01:46
51.211.203.35.bc.googleusercontent.com 0.033 0.016 0.00000:00:01
2607:ff10:c8:594::6 0.037 0.016 0.00000:00:01
80.66.76.130 0.012 0.016 0.00000:00:00
192.241.200.65 0.037 0.016 0.00000:00:00
TOTAL: 5 4.347 4.196 1.50800:01:51

NNRP unrecognized commands (by host):

SystemConn
51.211.203.35.bc.googleusercontent.com 3
192.241.200.65 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Host: 45.13.105.36:119 1
User-Agent: Expanse, a Palo Alto Network... 1
MGLNDD_45.13.105.36_119 1
TOTAL: 4 4
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me