Daily Usenet report for news.niel.me

Jan 1 04:15:02 -- Jan 2 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 1 12:01:34 rpi-studio innd: filter: No Cancel-Key[sha1:ad8nG438i/hXXpFG/m7e4uB85gI=] matches Cancel-Lock[sha1:TZ8iBdCXsOIJ8pJsaKxO5BGenmA=] target=<63b167e5$0$31541$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 3682 36.9%704.4 KB 42.5%
innd 2292 23.0%396.8 KB 23.9%
nnrpd 2278 22.8%247.8 KB 14.9%
innfeed 1726 17.3%308.6 KB 18.6%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 9980 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23801 63.5%
Negative hits 10047 26.8%
Do not exist 3602 9.6%
Cache misses 18 0.0%
TOTAL: 4 37468 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.046 0.0%27 0.500 1.704 4.000
article cancel00:00:00.002 0.0%28 0.000 0.071 1.000
article cleanup00:00:00.069 0.0%3617 0.000 0.019 0.143
article logging00:00:00.284 0.0%3633 0.000 0.078 0.500
article parse00:00:01.000 0.0%10976 0.000 0.091 0.500
article write00:00:02.325 0.0%3405 0.000 0.683 1.800
artlog/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.004 0.0%27 0.000 0.148 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.160 0.0%44265 0.000 0.004 0.024
hisgrep/artcncl00:00:00.001 0.0%27 0.000 0.037 0.333
hisgrep/artcncl/perl00:00:00.003 0.0%27 0.000 0.111 0.400
hisgrep/perl00:00:00.003 0.0%34 0.000 0.088 1.000
hishave/artcncl00:00:00.001 0.0%28 0.000 0.036 1.000
hishave/artcncl/perl00:00:00.000 0.0%27 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.522 0.0%37567 0.000 0.014 0.123
history sync00:00:00.048 0.0%410 0.000 0.117 1.000
history write00:00:00.894 0.0%3617 0.000 0.247 0.714
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:33.272100.0%44093 254.206 1960.249 30014.200
nntp read00:00:01.354 0.0%43676 0.000 0.031 0.080
overview write00:00:02.015 0.0%3405 0.053 0.592 4.889
perl filter00:00:17.904 0.0%3617 1.458 4.950 16.667
python filter00:00:00.007 0.0%3617 0.000 0.002 0.040
site send00:00:01.241 0.0%6889 0.000 0.180 0.500
TOTAL: 24:01:12.94024:01:01.155100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%3730 0.000 0.008 0.250
article prepare00:00:00.001 0.0%276 0.000 0.004 0.125
article read00:00:00.019 0.0%63 0.000 0.302 4.000
backlog stats00:00:00.124 0.0%47899 0.000 0.003 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.647 0.0%29095 0.000 0.022 0.105
data write00:00:01.420 0.0%25950 0.000 0.055 0.107
idle23:58:48.018100.0%47899 415.602 1802.293 8021.560
status file00:00:00.398 0.0%187 1.000 2.128 6.000
TOTAL: 23:58:54.09823:58:50.655100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:34.908 34.4%1447 11.600 24.124 10044.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.139 0.1%3473 0.000 0.040 1.000
readart00:00:00.004 0.0%7 0.571 0.571 0.571
TOTAL: 00:01:41.60200:00:35.051 34.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-out.aioe.org 2 3378 1433 1911 34 42%23:59:30
2i2pn.org 2 3540 1054 2386 100 29%25:35:41
3feed-out.gegeweb.org 3 2283 261 2022 0 11%23:58:39
4news.glou.org 2 2772 254 2498 20 9%23:57:57
5nntp.terraraq.uk 2 3377 117 3253 7 3%25:58:55
6news.samoylyk.net 2 3963 41 3922 0 1%28:29:32
7news.nntp4.net 1 733 32 684 17 4%05:47:22
8gegeweb-out.news.tnetconsulting.net 1 1065 22 1042 1 2%12:46:54
9usenet.pasdenom.info 3 647 21 626 0 3%10:22:53
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 43 21758 3235 18344 179 14%180:57:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.4 MB0.0 KB134.2 KB5.5 MB 97%3.9 KB
2i2pn.org4.5 MB0.0 KB369.4 KB4.8 MB 92%4.3 KB
3news.glou.org4.4 MB0.0 KB183.1 KB4.5 MB 96%17.0 KB
4news.samoylyk.net3.7 MB0.0 KB0.0 KB3.7 MB100%92.7 KB
5nntp.terraraq.uk1.3 MB0.0 KB29.7 KB1.3 MB 97%10.9 KB
6feed-out.gegeweb.org1.2 MB0.0 KB0.0 KB1.2 MB100%4.7 KB
7news.nntp4.net421.8 KB0.0 KB30.0 KB451.7 KB 93%9.2 KB
8gegeweb-out.news.tnetconsulting.net77.6 KB0.0 KB35.0 KB112.6 KB 68%4.9 KB
9usenet.pasdenom.info45.5 KB0.0 KB0.0 KB45.5 KB100%2.2 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1021.0 MB0.0 KB781.3 KB21.7 MB 96%6.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 1 04:15:02 - 04:59:59 63 1.9% 0.02455.9 KB 1.9% 0.17
Jan 1 05:00:00 - 05:59:59 52 1.5% 0.01132.8 KB 0.5% 0.04
Jan 1 06:00:00 - 06:59:59 45 1.3% 0.01165.8 KB 0.7% 0.05
Jan 1 07:00:00 - 07:59:59 57 1.7% 0.02195.1 KB 0.8% 0.05
Jan 1 08:00:00 - 08:59:59 70 2.1% 0.02413.6 KB 1.7% 0.11
Jan 1 09:00:00 - 09:59:59 66 1.9% 0.02275.2 KB 1.1% 0.08
Jan 1 10:00:00 - 10:59:59 86 2.5% 0.02413.9 KB 1.7% 0.11
Jan 1 11:00:00 - 11:59:59 72 2.1% 0.02311.5 KB 1.3% 0.09
Jan 1 12:00:00 - 12:59:59 129 3.8% 0.04550.2 KB 2.2% 0.15
Jan 1 13:00:00 - 13:59:59 128 3.8% 0.041.1 MB 4.7% 0.32
Jan 1 14:00:00 - 14:59:59 191 5.6% 0.052.2 MB 9.2% 0.63
Jan 1 15:00:00 - 15:59:59 325 9.6% 0.095.4 MB 22.4% 1.53
Jan 1 16:00:00 - 16:59:59 204 6.0% 0.061.7 MB 7.1% 0.49
Jan 1 17:00:00 - 17:59:59 164 4.8% 0.05792.6 KB 3.2% 0.22
Jan 1 18:00:00 - 18:59:59 194 5.7% 0.05770.0 KB 3.1% 0.21
Jan 1 19:00:00 - 19:59:59 218 6.4% 0.06852.4 KB 3.5% 0.24
Jan 1 20:00:00 - 20:59:59 263 7.7% 0.072.7 MB 11.4% 0.78
Jan 1 21:00:00 - 21:59:59 152 4.5% 0.04774.8 KB 3.1% 0.22
Jan 1 22:00:00 - 22:59:59 195 5.7% 0.05693.3 KB 2.8% 0.19
Jan 1 23:00:00 - 23:59:59 183 5.4% 0.05807.8 KB 3.3% 0.22
Jan 2 00:00:00 - 00:59:59 161 4.7% 0.04956.4 KB 3.9% 0.27
Jan 2 01:00:00 - 01:59:59 159 4.7% 0.04793.7 KB 3.2% 0.22
Jan 2 02:00:00 - 02:59:59 123 3.6% 0.03739.8 KB 3.0% 0.21
Jan 2 03:00:00 - 03:59:59 80 2.4% 0.02924.0 KB 3.8% 0.26
Jan 2 04:00:00 - 04:15:02 18 0.5% 0.0294.5 KB 0.4% 0.10
TOTAL: 24:00:00 3398 100.0% 0.0424.0 MB 100.0% 0.28
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 108 0 0 0 0 0 0 0 108
2news.nntp4.net 40 0 0 0 0 0 0 0 40
3news-out.aioe.org 39 1 0 0 0 0 0 0 38
4news.glou.org 20 0 0 0 0 0 0 0 20
5news.samoylyk.net 9 0 0 0 0 0 0 0 9
6nntp.terraraq.uk 7 0 0 0 0 0 0 0 7
7usenet.pasdenom.info 6 0 0 0 0 0 0 0 6
TOTAL: 7 229 1 0 0 0 0 0 0 228

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 92
Bad path (news.giganews.com.POSTED) 84
EMP (phl) 13
Too many newsgroups 13
Cancels abusifs 4
Cancel of non-existing ID <k15aamFuf3rU1@mid.individual.net> 2
Cancel of non-existing ID <k159hoFubi1U1@mid.individual.net> 2
No Cancel-Key matches Cancel-Lock. target=<63b167e5$0$31541$426a74cc@news.free.fr> 1
Cancel of non-existing ID <k10cjhF7bhmU1@mid.individual.net> 1
TOTAL: 9 212

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.samoylyk.net 9
news-out.aioe.org 5
usenet.pasdenom.info 1
news.nntp4.net 1
TOTAL: 4 16
TOTAL: 1 16

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4120 16 2296 1 0 168 0%23:59:49
2news.nntp4.net 3508 10 3288 0 0 0 0%23:59:29
3news.tnetconsulting.net 5259 6 3377 1 0 166 0%23:59:56
4news.gegeweb.org 3201 6 3109 19 0 0 0%23:59:01
5news.aioe.org 1449 2 1371 0 0 0 0%23:54:42
6nntp.terraraq.uk 2306 1 2052 6 0 0 0%23:55:49
7news.pasdenom.info 2818 0 2642 0 0 0 0%23:59:56
8news.samoylyk.net 3880 0 3354 1 0 0 0%23:59:20
TOTAL: 8 26541 41 21489 28 0 334 0%191:48:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org55.2 KB3.1 KB58.4 KB0.0 KB/s3.4 KB23:59:49
2news.nntp4.net51.7 KB0.0 KB51.7 KB0.0 KB/s5.2 KB23:59:29
3news.gegeweb.org41.5 KB20.4 KB61.9 KB0.0 KB/s2.5 KB23:59:01
4news.aioe.org27.3 KB0.0 KB27.3 KB0.0 KB/s13.7 KB23:54:42
5news.tnetconsulting.net13.2 KB3.1 KB16.3 KB0.0 KB/s2.3 KB23:59:56
6nntp.terraraq.uk3.1 KB575.2 KB578.3 KB0.0 KB/s82.6 KB23:55:49
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
8news.samoylyk.net0.0 KB3.1 KB3.1 KB0.0 KB/s3.1 KB23:59:20
TOTAL: 8192.1 KB605.0 KB797.1 KB0.0 KB/s11.6 KB191:48:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:8ca3:cee7:1243:e8bd 1 562.6 KB 5 0 000:00:26
TOTAL: 1 1 562.6 KB 5 0 000:01:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 562.6 KB 5 0 000:00:26
2unresolved 87 00.0 KB 0 0 000:00:30
3*.gegeweb.eu 288 00.0 KB 0 0 000:00:36
4*.monitoring.internet-measurement.com 10 00.0 KB 0 0 000:00:02
5*.tidalcoinage.internet-measurement.com 1 00.0 KB 0 0 000:00:05
TOTAL: 5 387 562.6 KB 5 0 000:01:40

NNRP auth users [Top 20]:

UserConn
mailman 288
gerald 1
TOTAL: 2 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 7.391 8.092 2.18300:00:36
2a0e:e701:1154:0:8ca3:cee7:1243:e8bd 0.054 0.043 0.00800:00:26
104.156.155.22 1.887 0.569 0.00000:00:16
104.152.52.159 0.024 0.024 0.00000:00:10
322ff827.tidalcoinage.internet-measurement.com 0.065 0.000 0.00000:00:05
162.62.33.200 0.032 0.022 0.00000:00:01
107.170.224.16 0.023 0.023 0.00000:00:01
admirable.monitoring.internet-measurement.com 0.047 0.012 0.00000:00:00
94.102.61.39 0.027 0.009 0.00000:00:00
dependable.monitoring.internet-measurement.com 0.045 0.011 0.00000:00:00
104.152.52.201 0.012 0.035 0.00000:00:00
146.0.75.2 0.020 0.030 0.00000:00:00
prominent.monitoring.internet-measurement.com 0.079 0.026 0.00000:00:00
acclaimed.monitoring.internet-measurement.com 0.012 0.012 0.00000:00:00
stupendous.monitoring.internet-measurement.com 0.025 0.000 0.00000:00:00
vivid.monitoring.internet-measurement.com 0.053 0.000 0.00000:00:00
adroit.monitoring.internet-measurement.com 0.057 0.000 0.00000:00:00
fresh.monitoring.internet-measurement.com 0.015 0.000 0.00000:00:00
kind.monitoring.internet-measurement.com 0.008 0.008 0.00000:00:00
lucid.monitoring.internet-measurement.com 0.015 0.000 0.00000:00:00
TOTAL: 20 9.891 8.916 2.19100:01:40

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
104.156.155.22 81
kind.monitoring.internet-measurement.com 1
dependable.monitoring.internet-measurement.com 1
162.62.33.200 1
fresh.monitoring.internet-measurement.com 1
94.102.61.39 1
acclaimed.monitoring.internet-measurement.com 1
vivid.monitoring.internet-measurement.com 1
stupendous.monitoring.internet-measurement.com 1
104.152.52.201 1
lucid.monitoring.internet-measurement.com 1
adroit.monitoring.internet-measurement.com 1
104.152.52.159 1
admirable.monitoring.internet-measurement.com 1
107.170.224.16 1
322ff827.tidalcoinage.internet-measurement.com 1
146.0.75.2 1
prominent.monitoring.internet-measurement.com 1
TOTAL: 19 386

NNRP unrecognized commands (by host):

SystemConn
162.62.33.200 3
107.170.224.16 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
À#024 1
#023#001#023#002#023#003#001 1
#026#003#001 1
MGLNDD_45.13.105.36_119 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
162.62.33.200 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 2 40.0%
2news 2 40.0%
3grisbi 1 20.0%
TOTAL: 3 5100.0%

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

NewsgroupCount
1news.admin.peering 1
2fr.usenet.forums.annonces 1
3grisbi.test 1
4news.admin.hierarchies 1
5fr.usenet.documents 1
TOTAL: 5 5