Daily Usenet report for news.niel.me

Mar 15 04:15:01 -- Mar 16 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 15 14:17:24 rpi-studio innd: filter: No Cancel-Key[sha1:3UUc1khlaTOEHxpyuoH9zlWYHrM=] matches Cancel-Lock[sha1:/5weYrKn0+AvMmAN6TaPkWk+ydI=] target=<6411c1c2$0$24800$426a74cc@news.free.fr>
Mar 15 16:00:06 rpi-studio pgpverify[20266]: pgpverify: verification failed
Mar 15 16:00:07 rpi-studio pgpverify[20281]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 4103 39.6%770.4 KB 45.5%
innd 2583 24.9%435.5 KB 25.7%
nnrpd 1916 18.5%208.2 KB 12.3%
innfeed 1739 16.8%276.0 KB 16.3%
controlchan 13 0.1%2.2 KB 0.1%
pgpverify 2 0.0%0.4 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 10357 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21491 60.3%
Negative hits 10123 28.4%
Do not exist 4016 11.3%
Cache misses 6 0.0%
TOTAL: 4 35636 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.067 0.0%30 1.000 2.233 8.500
article cancel00:00:00.007 0.0%30 0.000 0.233 1.000
article cleanup00:00:00.107 0.0%4028 0.000 0.027 0.130
article logging00:00:00.262 0.0%4040 0.000 0.065 0.250
article parse00:00:00.862 0.0%11266 0.000 0.077 0.198
article write00:00:05.458 0.0%3395 0.273 1.608 4.333
artlog/artcncl00:00:00.003 0.0%30 0.000 0.100 1.000
artlog/artcncl/perl00:00:00.006 0.0%30 0.000 0.200 1.000
data move00:00:00.130 0.0%41819 0.000 0.003 0.014
hisgrep/artcncl00:00:00.001 0.0%30 0.000 0.033 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%30 0.000 0.033 0.500
hisgrep/perl00:00:00.003 0.0%31 0.000 0.097 1.000
hishave/artcncl00:00:00.001 0.0%30 0.000 0.033 1.000
hishave/artcncl/perl00:00:00.000 0.0%30 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.424 0.0%35686 0.000 0.012 0.043
history sync00:00:00.047 0.0%407 0.000 0.115 1.000
history write00:00:00.890 0.0%4028 0.000 0.221 0.558
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:38.016 99.9%42969 539.614 2011.637 7058.271
nntp read00:00:01.342 0.0%42393 0.000 0.032 0.074
overview write00:00:01.993 0.0%3395 0.107 0.587 6.812
perl filter00:00:19.576 0.0%4028 2.529 4.860 9.371
python filter00:00:00.005 0.0%4028 0.000 0.001 0.083
site send00:00:01.466 0.0%6898 0.000 0.213 0.536
TOTAL: 24:01:21.39224:01:10.667100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%3470 0.000 0.009 0.125
article prepare00:00:00.001 0.0%288 0.000 0.003 0.042
article read00:00:00.020 0.0%63 0.000 0.317 8.000
backlog stats00:00:00.128 0.0%48292 0.000 0.003 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.689 0.0%28304 0.000 0.024 0.089
data write00:00:01.413 0.0%25092 0.000 0.056 0.121
idle23:57:28.821 99.9%48292 939.818 1785.986 4699.333
status file00:00:00.460 0.0%198 1.000 2.323 7.000
TOTAL: 23:58:57.21323:57:31.562 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:27.498 25.8%1482 11.400 18.555 1199.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.065 0.1%3397 0.000 0.019 1.000
TOTAL: 00:01:46.60400:00:27.563 25.9%----

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 4 2013 959 1053 1 47%23:57:22
2news.glou.org 2 3364 872 2424 68 25%24:10:41
3i2pn.org 2 5112 687 4268 157 13%32:23:40
4news.nntp4.net 1 3996 258 3437 301 6%24:16:23
5nntp.terraraq.uk 2 3317 213 3032 72 6%24:32:51
6usenet.pasdenom.info 1 2034 207 1822 5 10%21:36:55
7news.samoylyk.net 6 2610 164 2399 47 6%17:47:28
8gegeweb-out.news.tnetconsulting.net 2 3543 36 3479 28 1%23:59:31
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 45 25989 3396 21914 679 13%192:44:51

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.glou.org7.9 MB0.0 KB291.5 KB8.2 MB 96%8.9 KB
2news.samoylyk.net3.0 MB0.0 KB88.0 KB3.1 MB 97%15.0 KB
3feed-out.gegeweb.org2.9 MB0.0 KB60.8 KB3.0 MB 97%3.1 KB
4i2pn.org2.0 MB0.0 KB383.2 KB2.4 MB 84%2.9 KB
5nntp.terraraq.uk1.1 MB0.0 KB207.4 KB1.3 MB 84%4.7 KB
6news.nntp4.net1.0 MB0.0 KB846.0 KB1.9 MB 55%3.4 KB
7usenet.pasdenom.info490.2 KB2.7 KB8.4 KB501.3 KB 97%2.4 KB
8gegeweb-out.news.tnetconsulting.net116.9 KB1.8 KB74.6 KB193.2 KB 60%3.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 918.6 MB4.4 KB1.9 MB20.5 MB 90%5.1 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 15 04:15:01 - 04:59:59 52 1.5% 0.02211.7 KB 1.1% 0.08
Mar 15 05:00:00 - 05:59:59 68 2.0% 0.02313.2 KB 1.6% 0.09
Mar 15 06:00:00 - 06:59:59 87 2.6% 0.02267.7 KB 1.3% 0.07
Mar 15 07:00:00 - 07:59:59 141 4.1% 0.04575.8 KB 2.9% 0.16
Mar 15 08:00:00 - 08:59:59 102 3.0% 0.03873.1 KB 4.4% 0.24
Mar 15 09:00:00 - 09:59:59 124 3.6% 0.03509.3 KB 2.5% 0.14
Mar 15 10:00:00 - 10:59:59 104 3.1% 0.03674.0 KB 3.4% 0.19
Mar 15 11:00:00 - 11:59:59 109 3.2% 0.03443.8 KB 2.2% 0.12
Mar 15 12:00:00 - 12:59:59 154 4.5% 0.04854.9 KB 4.3% 0.24
Mar 15 13:00:00 - 13:59:59 145 4.3% 0.041005.8 KB 5.0% 0.28
Mar 15 14:00:00 - 14:59:59 172 5.1% 0.052.1 MB 10.8% 0.60
Mar 15 15:00:00 - 15:59:59 126 3.7% 0.04377.8 KB 1.9% 0.10
Mar 15 16:00:00 - 16:59:59 197 5.8% 0.051.2 MB 6.0% 0.34
Mar 15 17:00:00 - 17:59:59 160 4.7% 0.04571.1 KB 2.9% 0.16
Mar 15 18:00:00 - 18:59:59 183 5.4% 0.052.2 MB 11.1% 0.62
Mar 15 19:00:00 - 19:59:59 187 5.5% 0.05622.9 KB 3.1% 0.17
Mar 15 20:00:00 - 20:59:59 175 5.2% 0.05878.8 KB 4.4% 0.24
Mar 15 21:00:00 - 21:59:59 186 5.5% 0.05863.4 KB 4.3% 0.24
Mar 15 22:00:00 - 22:59:59 166 4.9% 0.05566.8 KB 2.8% 0.16
Mar 15 23:00:00 - 23:59:59 275 8.1% 0.081.8 MB 9.1% 0.51
Mar 16 00:00:00 - 00:59:59 141 4.1% 0.04930.8 KB 4.7% 0.26
Mar 16 01:00:00 - 01:59:59 116 3.4% 0.03720.3 KB 3.6% 0.20
Mar 16 02:00:00 - 02:59:59 111 3.3% 0.03448.9 KB 2.2% 0.12
Mar 16 03:00:00 - 03:59:59 69 2.0% 0.02262.6 KB 1.3% 0.07
Mar 16 04:00:00 - 04:15:01 48 1.4% 0.05602.4 KB 3.0% 0.67
TOTAL: 24:00:00 3398 100.0% 0.0419.5 MB 100.0% 0.23

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 262 1 0 0 0 0 0 0 261
2i2pn.org 124 0 0 0 0 0 0 0 124
3news.samoylyk.net 92 0 0 0 0 0 0 0 92
4nntp.terraraq.uk 73 0 0 0 0 0 0 0 73
5news.glou.org 68 0 0 0 0 0 0 0 68
6usenet.pasdenom.info 9 0 0 0 0 0 0 0 9
7gegeweb-out.news.tnetconsulting.net 9 1 0 0 0 0 0 0 8
8feed-out.gegeweb.org 8 0 0 0 0 0 0 0 8
TOTAL: 8 645 2 0 0 0 0 0 0 643

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.informatique.materiel 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 152
EMP (phl) 115
EMP (md5) 114
EMP (phn path) 89
EMP (phn nph) 84
Bad path (news.giganews.com.POSTED) 73
Too many newsgroups (meow) 1
Binary: misplaced binary 1
No Cancel-Key matches Cancel-Lock. target=<6411c1c2$0$24800$426a74cc@news.free.fr> 1
Too many newsgroups (low_xpost) 1
TOTAL: 10 631

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 7
news.samoylyk.net 4
nntp.terraraq.uk 1
TOTAL: 3 12
TOTAL: 1 12

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4776 23 2756 0 0 13 0%23:59:28
2news.tnetconsulting.net 5563 13 3378 1 0 16 0%23:59:28
3nntp.terraraq.uk 2482 13 2301 2 0 0 0%23:57:00
4news.gegeweb.org 2500 8 2414 5 0 0 0%23:59:28
5news.nntp4.net 3229 5 3077 0 0 44 0%24:00:00
6news.samoylyk.net 3554 1 3159 1 0 0 0%23:59:28
7news.pasdenom.info 3049 0 2961 0 0 0 0%23:59:28
8news.aioe.org 0 0 0 0 0 2577 0%23:59:28
TOTAL: 8 25153 63 20046 9 0 2650 0%191:53:48

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org50.7 KB0.0 KB50.7 KB0.0 KB/s2.2 KB23:59:28
2nntp.terraraq.uk44.2 KB196.3 KB240.4 KB0.0 KB/s16.0 KB23:57:00
3news.gegeweb.org30.7 KB20.1 KB50.8 KB0.0 KB/s3.9 KB23:59:28
4news.tnetconsulting.net30.7 KB4.4 KB35.1 KB0.0 KB/s2.5 KB23:59:28
5news.nntp4.net12.3 KB0.0 KB12.3 KB0.0 KB/s2.5 KB24:00:00
6news.samoylyk.net6.2 KB4.4 KB10.6 KB0.0 KB/s5.3 KB23:59:28
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:28
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:28
TOTAL: 8174.7 KB225.2 KB399.9 KB0.0 KB/s5.6 KB191:53:48

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1excellent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2mail.gegeweb.eu 288 00.0 KB 0 0 000:01:31
3139.59.104.144 8 00.0 KB 0 0 000:00:01
494.102.61.39 1 00.0 KB 0 0 000:00:00
546.219.192.81 2 00.0 KB 0 0 000:00:02
6bright.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7208.100.26.237 10 00.0 KB 0 0 000:00:04
8198.199.107.247 1 00.0 KB 0 0 000:00:00
TOTAL: 8 312 00.0 KB 0 0 000:01:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
2unresolved 22 00.0 KB 0 0 000:00:10
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:31
TOTAL: 3 312 00.0 KB 0 0 000:01:46

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.377 4.860 1.99900:01:31
208.100.26.237 0.257 0.159 0.00000:00:04
46.219.192.81 0.076 0.037 0.00000:00:02
139.59.104.144 0.231 0.147 0.00000:00:01
bright.monitoring.internet-measurement.com 0.028 0.019 0.00000:00:01
excellent.monitoring.internet-measurement.com 0.043 0.011 0.00000:00:01
198.199.107.247 0.011 0.033 0.00000:00:00
94.102.61.39 0.034 0.034 0.00000:00:00
TOTAL: 8 5.057 5.300 1.99900:01:46

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
139.59.104.144 42
198.199.107.247 1
TOTAL: 2 43

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:119 7
Accept: */* 7
Connection: keep-alive 7
Accept-Encoding: gzip, deflate 7
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
GET / HTTP/1.1 1
GET /flu/403.html HTTP/1.1 1
GET /system_api.php HTTP/1.1 1
User-Agent: AlexaMediaPlayer/2.1.4676.0 ... 1
MGLNDD_45.13.105.36_119 1
GET /c/version.js HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
GET /streaming/clients_live.php HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
TOTAL: 14 43