Daily Usenet report for news.niel.me

Mar 29 04:15:02 -- Mar 30 04:15:01

Unknown entries from news log file:

First 50 / 2749 lines (1.8%)

Mar 29 04:15:09 rpi-studio nnrpd[487]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:15:40 rpi-studio nnrpd[670]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:16:10 rpi-studio nnrpd[748]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:16:40 rpi-studio nnrpd[756]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:17:10 rpi-studio nnrpd[785]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:17:40 rpi-studio nnrpd[794]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:18:10 rpi-studio nnrpd[804]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:18:40 rpi-studio nnrpd[811]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:19:11 rpi-studio nnrpd[837]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:19:41 rpi-studio nnrpd[845]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:20:11 rpi-studio nnrpd[857]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:20:41 rpi-studio nnrpd[873]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:21:11 rpi-studio nnrpd[889]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:21:41 rpi-studio nnrpd[915]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:22:11 rpi-studio nnrpd[927]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:22:42 rpi-studio nnrpd[943]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:23:12 rpi-studio nnrpd[1093]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:23:42 rpi-studio nnrpd[1100]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:24:12 rpi-studio nnrpd[1109]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:24:42 rpi-studio nnrpd[1121]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:25:12 rpi-studio nnrpd[1132]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:25:43 rpi-studio nnrpd[1140]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:26:13 rpi-studio nnrpd[1152]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:26:43 rpi-studio nnrpd[1159]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:27:14 rpi-studio nnrpd[1169]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:27:44 rpi-studio nnrpd[1182]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:28:14 rpi-studio nnrpd[1191]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:28:44 rpi-studio nnrpd[1198]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:29:14 rpi-studio nnrpd[1207]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:29:44 rpi-studio nnrpd[1214]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:30:14 rpi-studio nnrpd[1238]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:30:44 rpi-studio nnrpd[1246]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:31:14 rpi-studio nnrpd[1255]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:31:44 rpi-studio nnrpd[1270]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:32:14 rpi-studio nnrpd[1308]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:32:44 rpi-studio nnrpd[1321]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:33:14 rpi-studio nnrpd[1471]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:33:44 rpi-studio nnrpd[1479]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:34:14 rpi-studio nnrpd[1493]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:34:44 rpi-studio nnrpd[1502]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:35:14 rpi-studio nnrpd[1514]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:35:44 rpi-studio nnrpd[1522]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:36:14 rpi-studio nnrpd[1531]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:36:44 rpi-studio nnrpd[1538]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:37:14 rpi-studio nnrpd[1547]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:37:45 rpi-studio nnrpd[1560]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:38:15 rpi-studio nnrpd[1571]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:38:45 rpi-studio nnrpd[1578]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:39:15 rpi-studio nnrpd[1596]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 29 04:39:45 rpi-studio nnrpd[1603]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 18949 75.1%2.2 MB 67.8%
inn 2509 9.9%462.4 KB 14.1%
innd 2015 8.0%337.3 KB 10.3%
innfeed 1746 6.9%259.2 KB 7.9%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 25221 100.0%3.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12424 55.9%
Negative hits 7319 32.9%
Do not exist 2489 11.2%
Cache misses 3 0.0%
TOTAL: 4 22235 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.009 0.0%8 1.000 1.125 2.000
article cancel00:00:00.002 0.0%8 0.000 0.250 1.000
article cleanup00:00:00.066 0.0%2497 0.000 0.026 0.250
article logging00:00:00.188 0.0%2497 0.000 0.075 0.333
article parse00:00:00.376 0.0%6506 0.000 0.058 0.207
article write00:00:01.303 0.0%2295 0.000 0.568 2.333
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 1.000
data move00:00:00.139 0.0%24517 0.000 0.006 0.043
hisgrep/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%8 0.000 0.125 1.000
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.343 0.0%22308 0.000 0.015 0.100
history sync00:00:00.043 0.0%405 0.000 0.106 0.667
history write00:00:00.425 0.0%2497 0.000 0.170 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:00:29.089100.0%31742 467.729 2609.448 9229.846
nntp read00:00:00.754 0.0%25567 0.000 0.029 0.066
overview write00:00:00.660 0.0%2295 0.000 0.288 3.400
perl filter00:00:12.740 0.0%2497 2.059 5.102 17.000
python filter00:00:00.016 0.0%2497 0.000 0.006 0.200
site send00:00:00.795 0.0%4672 0.000 0.170 0.667
TOTAL: 23:01:04.33723:00:46.950100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%2539 0.000 0.009 0.167
article prepare00:00:00.003 0.0%380 0.000 0.008 0.250
article read00:00:00.019 0.0%93 0.000 0.204 1.333
backlog stats00:00:00.163 0.0%31237 0.000 0.005 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.451 0.0%17096 0.000 0.026 0.086
data write00:00:00.803 0.0%15116 0.000 0.053 0.126
idle22:50:08.854100.0%31237 929.682 2631.778 7806.312
status file00:00:05.121 0.0%218 0.000 23.491 88.000
TOTAL: 22:50:18.93822:50:15.438100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:54:05.127 93.8%21115 0.000 153.688 7569.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.007 0.1%64900 0.000 0.046 1.000
readart00:00:01.975 0.1%11079 0.169 0.178 0.180
TOTAL: 00:57:40.99200:54:10.109 93.9%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 143
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 165

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 2433 728 1549 156 29%22:57:44
2news.samoylyk.net 2 3429 499 2930 0 14%32:51:27
3feed-out.gegeweb.org 2 2278 467 1808 3 20%22:59:26
4gegeweb-out.news.tnetconsulting.net 2 1118 242 859 17 21%18:23:23
5usenet.pasdenom.info 8 1260 174 1084 2 13%25:11:58
6nntp.terraraq.uk 3 2730 83 2639 8 3%41:31:17
7news.glou.org 3 132 6 124 2 4%04:16:15
8i2pn.org 1 122 6 116 0 4%02:14:58
9localhost 24 0 0 0 0 0%00:00:00
TOTAL: 9 47 13502 2205 11109 188 16%170:26:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net5.4 MB0.0 KB0.0 KB5.4 MB100%11.2 KB
2news.nntp4.net3.0 MB0.0 KB706.0 KB3.7 MB 81%4.3 KB
3feed-out.gegeweb.org1.5 MB0.0 KB8.6 KB1.5 MB 99%3.2 KB
4gegeweb-out.news.tnetconsulting.net785.3 KB0.0 KB52.1 KB837.4 KB 93%3.2 KB
5usenet.pasdenom.info444.0 KB0.0 KB2.4 KB446.4 KB 99%2.5 KB
6nntp.terraraq.uk252.4 KB0.0 KB32.6 KB285.0 KB 88%3.1 KB
7news.glou.org20.8 KB0.0 KB3.7 KB24.5 KB 84%3.1 KB
8i2pn.org13.1 KB0.0 KB0.0 KB13.1 KB100%2.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 911.4 MB0.0 KB805.5 KB12.2 MB 93%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 29 04:15:02 - 04:59:59 44 1.9% 0.02188.1 KB 0.0% 0.07
Mar 29 05:00:00 - 05:59:59 29 1.3% 0.01141.1 KB 1.6% 0.04
Mar 29 06:00:00 - 06:59:59 34 1.5% 0.01111.8 KB 1.3% 0.03
Mar 29 07:00:00 - 07:59:59 38 1.7% 0.01146.7 KB 1.7% 0.04
Mar 29 08:00:00 - 08:59:59 57 2.5% 0.02323.0 KB 3.7% 0.09
Mar 29 09:00:00 - 09:59:59 58 2.5% 0.02449.3 KB 5.1% 0.12
Mar 29 10:00:00 - 10:59:59 67 2.9% 0.02257.3 KB 2.9% 0.07
Mar 29 11:00:00 - 11:59:59 78 3.4% 0.02260.6 KB 3.0% 0.07
Mar 29 12:00:00 - 12:59:59 91 4.0% 0.03306.0 KB 3.5% 0.08
Mar 29 13:00:00 - 13:59:59 91 4.0% 0.03277.6 KB 3.1% 0.08
Mar 29 14:00:00 - 14:59:59 88 3.8% 0.02334.5 KB 3.8% 0.09
Mar 29 15:00:00 - 15:59:59 81 3.5% 0.02373.7 KB 4.2% 0.10
Mar 29 16:00:00 - 16:59:59 150 6.5% 0.04516.0 KB 5.9% 0.14
Mar 29 17:00:00 - 17:59:59 112 4.9% 0.03425.3 KB 4.8% 0.12
Mar 29 18:00:00 - 18:59:59 126 5.5% 0.04428.0 KB 4.9% 0.12
Mar 29 19:00:00 - 19:59:59 201 8.8% 0.06896.0 KB 10.2% 0.25
Mar 29 20:00:00 - 20:59:59 184 8.0% 0.05784.6 KB 8.9% 0.22
Mar 29 21:00:00 - 21:59:59 200 8.7% 0.062.7 MB 31.9% 0.78
Mar 29 22:00:00 - 22:59:59 186 8.1% 0.05632.4 KB 7.2% 0.18
Mar 29 23:00:00 - 23:59:59 147 6.4% 0.04583.4 KB 6.6% 0.16
Mar 30 00:00:00 - 00:59:59 103 4.5% 0.03382.1 KB 4.3% 0.11
Mar 30 01:00:00 - 01:59:59 62 2.7% 0.02205.2 KB 2.3% 0.06
Mar 30 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Mar 30 03:00:00 - 03:59:59 51 2.2% 0.01233.9 KB 2.7% 0.06
Mar 30 04:00:00 - 04:15:01 13 0.6% 0.0160.0 KB 0.7% 0.07
TOTAL: 23:59:59 2291 100.0% 0.038.6 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 156 56 0 0 0 0 0 0 100
2news.glou.org 24 0 0 0 0 0 0 0 24
3gegeweb-out.news.tnetconsulting.net 16 3 0 0 0 0 0 0 13
4feed-out.gegeweb.org 3 0 0 0 0 0 0 0 3
5usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
6i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 202 59 0 0 0 0 0 0 143

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 27
linux.kernel.git 26
soc.culture.iran 5
news.test 1
TOTAL: 4 59

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 91
Bad path (news.giganews.com.POSTED) 44
EMP (phn path) 5
Cancels abusifs 2
EMP (md5) 1
TOTAL: 5 143

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3406 23 2081 23 0 136 0%22:59:57
2news.gegeweb.org 1979 19 1803 0 0 2 0%22:52:49
3news.tnetconsulting.net 3537 9 2258 15 0 119 0%22:59:57
4nntp.terraraq.uk 1188 4 1125 0 0 0 0%22:49:19
5news.samoylyk.net 2337 2 1868 0 0 0 0%22:59:08
6news.aioe.org 0 0 0 0 0 1907 0%22:59:59
7news.pasdenom.info 1648 0 1553 1 0 0 0%22:55:40
8news.nntp4.net 1664 0 1551 0 0 0 0%22:48:55
TOTAL: 8 15759 57 12239 39 0 2164 0%183:25:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org121.3 KB147.0 KB268.4 KB0.0 KB/s5.8 KB22:59:57
2news.gegeweb.org49.9 KB0.0 KB49.9 KB0.0 KB/s2.6 KB22:52:49
3news.tnetconsulting.net21.7 KB60.9 KB82.7 KB0.0 KB/s3.4 KB22:59:57
4nntp.terraraq.uk11.6 KB0.0 KB11.6 KB0.0 KB/s2.9 KB22:49:19
5news.samoylyk.net5.8 KB0.0 KB5.8 KB0.0 KB/s2.9 KB22:59:08
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s022:59:59
7news.pasdenom.info0.0 KB5.2 KB5.2 KB0.0 KB/s5.2 KB22:55:40
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:48:55
TOTAL: 8210.5 KB213.2 KB423.7 KB0.0 KB/s4.4 KB183:25:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 6 1107952.0 MB 17 0 000:51:07
TOTAL: 1 6 1107952.0 MB 17 0 000:57:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 6 1107952.0 MB 17 0 000:51:07
2unresolved 97 00.0 KB 0 0 000:01:25
3*.150.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
4*.ip.linodeusercontent.com 47 00.0 KB 0 0 000:00:11
5*.gegeweb.eu 276 00.0 KB 0 0 000:01:30
6*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
7?2749 00.0 KB 0 0 000:03:15
TOTAL: 73179 1107952.0 MB 17 0 000:57:36

NNRP auth users [Top 20]:

UserConn
mailman 276
TOTAL: 1 276

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 2.150 5.531 0.00000:51:07
2001:41d0:a:280::1 61.709 48.413 0.00000:03:15
mail.gegeweb.eu 4.507 4.029 1.76700:01:30
45.227.253.13 0.043 0.049 0.00000:00:31
206.168.34.40 0.031 0.010 0.00000:00:17
104.156.155.32 2.280 0.953 0.00000:00:16
206.168.34.123 0.103 0.089 0.00000:00:14
172-105-246-139.ip.linodeusercontent.com 1.137 0.670 0.00000:00:11
sam.probe.onyphe.net 0.025 0.020 0.00000:00:02
205.210.31.13 0.026 0.026 0.00000:00:02
91.238.181.95 0.009 0.013 0.00000:00:01
219.150.216.162.bc.googleusercontent.com 0.064 0.028 0.00000:00:00
91.238.181.94 0.039 0.016 0.00000:00:00
20.168.0.47 0.021 0.025 0.00000:00:00
serrano.probe.onyphe.net 0.016 0.036 0.00000:00:00
120.150.216.162.bc.googleusercontent.com 0.028 0.012 0.00000:00:00
TOTAL: 16 72.188 59.920 1.76700:57:36

Curious NNRP server explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2749
mail.gegeweb.eu 276
104.156.155.32 85
172-105-246-139.ip.linodeusercontent.com 47
206.168.34.123 4
45.227.253.13 3
serrano.probe.onyphe.net 1
91.238.181.95 1
91.238.181.94 1
20.168.0.47 1
219.150.216.162.bc.googleusercontent.com 1
sam.probe.onyphe.net 1
205.210.31.13 1
120.150.216.162.bc.googleusercontent.com 1
206.168.34.40 1
TOTAL: 15 3173

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.227.253.13 12
120.150.216.162.bc.googleusercontent.com 4
219.150.216.162.bc.googleusercontent.com 4
serrano.probe.onyphe.net 2
91.238.181.95 1
206.168.34.40 1
20.168.0.47 1
TOTAL: 7 25

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept-Encoding: deflate, gzip, identity 2
Host: 45.13.105.36:119 2
Accept: text/html,application/xhtml+xml,... 2
User-Agent: Expanse, a Palo Alto Network... 2
User-Agent: Mozilla/5.0 (Windows NT 5.1;... 2
Accept-Encoding: gzip 2
Host: 45.13.105.36:563 2
Accept-Language: en-US;q=0.6,en;q=0.4 2
EHLO www.censys.io 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
#003 1
#026#003#003#001¥#001 1
MGLNDD_45.13.105.36_119 1
TOTAL: 14 25

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.95 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 9663 87.2%
2local 1416 12.8%
TOTAL: 2 11079100.0%

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

NewsgroupCount
1grisbi.test 3561
2grisbi.user.french 3428
3grisbi.devel 2000
4local.test 1230
5grisbi.cvs 288
6grisbi.bugsreports 200
7local.gegeweb.support 186
8grisbi.user 180
9grisbi.admin 6
TOTAL: 9 11079