Daily Usenet report for news.niel.me

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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 16 10:48:25 rpi-studio innd: filter: No Cancel-Key[sha1:cGf2ipF+onl+GXTIVNhPWzgwcYs=#015#012#011sha1:fhfG6IJxToHr1zqgmRatyF/FwzU= sha256:LfSSHxD5FLg+k28nyI9p9P/YhC74irzhH4Rhs0YeMT8=] matches Cancel-Lock[sha1:4iW9PzbR/tD4TkKE9zxbewTXKZY= sha256:3Y9ddfblmQdGPmBWmc5liIguTa8SdHC/6EoeslI6KFI=] target=<uivf7c$k55$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 32172 69.6%5.9 MB 76.4%
innd 10332 22.3%1.3 MB 17.0%
innfeed 1951 4.2%336.1 KB 4.2%
nnrpd 1775 3.8%193.1 KB 2.4%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 46232 100.0%7.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 46179 38.6%
Positive hits 41310 34.6%
Do not exist 32036 26.8%
Cache misses 7 0.0%
TOTAL: 4 119532 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%16 0.500 1.062 3.000
article cancel00:00:00.005 0.0%17 0.000 0.294 4.000
article cleanup00:00:00.673 0.0%32175 0.000 0.021 0.051
article logging00:00:02.556 0.0%32176 0.038 0.079 0.131
article parse00:00:09.032 0.0%162845 0.027 0.055 0.091
article write00:00:25.448 0.0%23990 0.564 1.061 2.466
artlog/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%16 0.000 0.062 1.000
data move00:00:01.628 0.0%289282 0.001 0.006 0.012
hisgrep/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%17 0.000 0.059 0.500
hishave/artcncl00:00:00.001 0.0%17 0.000 0.059 1.000
hishave/artcncl/perl00:00:00.001 0.0%16 0.000 0.062 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.303 0.0%120055 0.006 0.019 0.030
history sync00:00:00.059 0.0%405 0.000 0.146 1.667
history write00:00:07.099 0.0%32175 0.140 0.221 0.330
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:07.002 99.7%250371 227.150 344.397 800.632
nntp read00:00:07.738 0.0%249894 0.020 0.031 0.048
overview write00:00:10.067 0.0%23990 0.155 0.420 16.113
perl filter00:02:06.429 0.1%32175 3.224 3.929 5.608
python filter00:00:00.135 0.0%32175 0.000 0.004 0.023
site send00:00:06.649 0.0%49384 0.037 0.135 0.289
TOTAL: 24:01:10.35624:00:26.844 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.258 0.0%23909 0.000 0.011 0.041
article prepare00:00:00.043 0.0%11912 0.000 0.004 0.045
article read00:00:00.408 0.0%2418 0.000 0.169 0.714
backlog stats00:00:01.715 0.0%376933 0.002 0.005 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.040 0.0%256198 0.014 0.024 0.038
data write00:00:10.474 0.0%200491 0.037 0.052 0.066
idle23:52:51.940100.0%376933 155.782 228.083 413.364
status file00:00:00.382 0.0%198 0.000 1.929 7.000
TOTAL: 23:53:29.19423:53:11.260100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:49.232 35.4%1447 19.500 34.023 1344.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.090 0.1%3192 0.000 0.028 0.182
TOTAL: 00:02:19.07100:00:49.322 35.5%----

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.nntp4.net 4 31358 12209 12599 6550 38%24:13:58
2news.glou.org 2 13794 6812 5825 1157 49%24:45:19
3gegeweb-out.news.tnetconsulting.net 27 10104 3100 6706 298 30%24:00:27
4feed-out.gegeweb.org 3 3429 1149 2280 0 33%23:59:26
5nntp.terraraq.uk 1 3863 275 3441 147 7%17:04:35
6usenet.pasdenom.info 1 2643 253 2382 8 9%23:11:26
7i2pn.org 1 373 29 344 0 7%02:49:55
8news.samoylyk.net 1 93 0 93 0 0%00:38:55
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 65 65657 23827 33670 8160 36%140:44:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net115.7 MB0.0 KB59.4 MB175.1 MB 66%9.6 KB
2news.glou.org55.2 MB0.0 KB7.1 MB62.3 MB 88%8.0 KB
3gegeweb-out.news.tnetconsulting.net24.3 MB0.0 KB1.1 MB25.4 MB 95%7.7 KB
4feed-out.gegeweb.org12.3 MB0.0 KB0.0 KB12.3 MB100%10.9 KB
5nntp.terraraq.uk2.0 MB0.0 KB1.1 MB3.0 MB 64%7.4 KB
6usenet.pasdenom.info882.8 KB0.0 KB14.1 KB896.8 KB 98%3.4 KB
7i2pn.org440.4 KB0.0 KB0.0 KB440.4 KB100%15.2 KB
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 9210.7 MB0.0 KB68.8 MB279.5 MB 75%8.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 16 04:15:01 - 04:59:59 731 3.0% 0.278.0 MB 3.8% 3.03
Nov 16 05:00:00 - 05:59:59 866 3.6% 0.249.3 MB 4.4% 2.66
Nov 16 06:00:00 - 06:59:59 991 4.1% 0.289.8 MB 4.6% 2.77
Nov 16 07:00:00 - 07:59:59 1214 5.1% 0.3412.6 MB 5.9% 3.58
Nov 16 08:00:00 - 08:59:59 1199 5.0% 0.3312.7 MB 6.0% 3.61
Nov 16 09:00:00 - 09:59:59 1242 5.2% 0.3413.4 MB 6.3% 3.80
Nov 16 10:00:00 - 10:59:59 1177 4.9% 0.339.7 MB 4.6% 2.75
Nov 16 11:00:00 - 11:59:59 1239 5.2% 0.3411.2 MB 5.3% 3.18
Nov 16 12:00:00 - 12:59:59 1039 4.3% 0.299.3 MB 4.4% 2.65
Nov 16 13:00:00 - 13:59:59 1235 5.2% 0.3411.2 MB 5.3% 3.18
Nov 16 14:00:00 - 14:59:59 1302 5.4% 0.3611.5 MB 5.4% 3.26
Nov 16 15:00:00 - 15:59:59 1274 5.3% 0.3512.2 MB 5.8% 3.48
Nov 16 16:00:00 - 16:59:59 1104 4.6% 0.3111.1 MB 5.2% 3.16
Nov 16 17:00:00 - 17:59:59 1040 4.3% 0.299.1 MB 4.3% 2.59
Nov 16 18:00:00 - 18:59:59 842 3.5% 0.236.8 MB 3.2% 1.93
Nov 16 19:00:00 - 19:59:59 836 3.5% 0.236.2 MB 2.9% 1.76
Nov 16 20:00:00 - 20:59:59 765 3.2% 0.214.8 MB 2.2% 1.36
Nov 16 21:00:00 - 21:59:59 720 3.0% 0.204.6 MB 2.2% 1.30
Nov 16 22:00:00 - 22:59:59 767 3.2% 0.213.9 MB 1.8% 1.11
Nov 16 23:00:00 - 23:59:59 763 3.2% 0.214.6 MB 2.1% 1.30
Nov 17 00:00:00 - 00:59:59 773 3.2% 0.215.3 MB 2.5% 1.52
Nov 17 01:00:00 - 01:59:59 851 3.6% 0.248.3 MB 3.9% 2.37
Nov 17 02:00:00 - 02:59:59 954 4.0% 0.279.0 MB 4.2% 2.55
Nov 17 03:00:00 - 03:59:59 830 3.5% 0.236.1 MB 2.9% 1.74
Nov 17 04:00:00 - 04:15:01 217 0.9% 0.241.4 MB 0.7% 1.58
TOTAL: 24:00:00 23971 100.0% 0.28211.8 MB 100.0% 2.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 6530 0 0 0 0 0 0 0 6530
2news.glou.org 1134 0 0 0 0 0 0 0 1134
3gegeweb-out.news.tnetconsulting.net 296 0 0 0 0 0 0 0 296
4nntp.terraraq.uk 198 0 0 0 0 0 0 0 198
5usenet.pasdenom.info 8 0 0 0 0 0 0 0 8
6i2pn.org 1 0 0 0 0 0 0 0 1
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 8168 0 0 0 0 0 0 0 8168

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7754
EMP (phl) 209
EMP (phn path) 101
Bad path (news.giganews.com.POSTED) 63
Too many newsgroups 36
Cancels abusifs 3
Too many newsgroups (meow) 1
TOTAL: 7 8167

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.terraraq.uk 26459 337 21100 1299 0 0 1%23:59:57
2i2pn.org 36468 219 22925 490 0 14 0%23:59:53
3news.nntp4.net 14627 217 11559 2 0 0 1%23:59:57
4news.tnetconsulting.net 37433 68 23830 72 0 3 0%23:59:55
5news.samoylyk.net 35355 27 23709 226 0 18 0%23:59:56
6news.pasdenom.info 25919 2 23594 21 0 0 0%23:59:57
7news.gegeweb.org 22995 1 22812 6 0 0 0%23:59:57
8news.aioe.org 0 0 0 0 0 5032 0%23:59:55
TOTAL: 8 199256 871 149529 2116 0 5067 0%191:59:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net3.0 MB3.6 KB3.0 MB0.0 KB/s14.0 KB23:59:57
2nntp.terraraq.uk2.2 MB12.0 MB14.2 MB0.2 KB/s8.9 KB23:59:57
3i2pn.org1.6 MB4.1 MB5.7 MB0.1 KB/s8.2 KB23:59:53
4news.tnetconsulting.net1.1 MB417.3 KB1.5 MB0.0 KB/s11.0 KB23:59:55
5news.samoylyk.net165.6 KB2.8 MB2.9 MB0.0 KB/s11.9 KB23:59:56
6news.pasdenom.info28.3 KB258.3 KB286.7 KB0.0 KB/s12.5 KB23:59:57
7news.gegeweb.org11.6 KB31.0 KB42.6 KB0.0 KB/s6.1 KB23:59:57
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 88.2 MB19.5 MB27.7 MB0.0 KB/s9.5 KB191:59:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1empathetic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2194.165.16.76 1 00.0 KB 0 0 000:00:01
3prod-boron-us-east-23.li.binaryedge.ninja 2 00.0 KB 0 0 000:00:03
4208.100.26.230 3 00.0 KB 0 0 000:00:13
5102.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6194.165.16.10 1 00.0 KB 0 0 000:00:01
7mail.gegeweb.eu 288 00.0 KB 0 0 000:01:56
TOTAL: 7 297 00.0 KB 0 0 000:02:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:56
2unresolved 5 00.0 KB 0 0 000:00:15
3*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.li.binaryedge.ninja 2 00.0 KB 0 0 000:00:03
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 5 297 00.0 KB 0 0 000:02:18

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.677 4.330 1.61400:01:56
208.100.26.230 0.122 0.053 0.00000:00:13
prod-boron-us-east-23.li.binaryedge.ninja 0.035 0.012 0.00000:00:03
empathetic.monitoring.internet-measurement.com 0.023 0.030 0.00000:00:01
194.165.16.10 0.022 0.033 0.00000:00:01
194.165.16.76 0.037 0.018 0.00000:00:01
102.150.216.162.bc.googleusercontent.com 0.032 0.022 0.00000:00:00
TOTAL: 7 4.948 4.498 1.61400:02:18

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
102.150.216.162.bc.googleusercontent.com 3
194.165.16.76 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:119 1
#003 1
User-Agent: Expanse, a Palo Alto Network... 1
GET / HTTP/1.1 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.76 1 1
TOTAL: 1 1 1
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me