Daily Usenet report for news.niel.me

Mar 30 04:15:01 -- Mar 31 04:15:01

Unknown entries from news log file:

First 50 / 2869 lines (1.7%)

Mar 30 04:15:10 rpi-studio nnrpd[21038]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:15:40 rpi-studio nnrpd[21075]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:16:11 rpi-studio nnrpd[21154]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:16:41 rpi-studio nnrpd[21166]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:17:11 rpi-studio nnrpd[21186]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:17:41 rpi-studio nnrpd[21193]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:18:11 rpi-studio nnrpd[21208]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:18:41 rpi-studio nnrpd[21217]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:19:11 rpi-studio nnrpd[21226]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:19:41 rpi-studio nnrpd[21242]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:20:12 rpi-studio nnrpd[21256]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:20:42 rpi-studio nnrpd[21264]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:21:12 rpi-studio nnrpd[21273]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:21:43 rpi-studio nnrpd[21280]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:22:13 rpi-studio nnrpd[21299]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:22:43 rpi-studio nnrpd[21320]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:23:13 rpi-studio nnrpd[21329]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:23:43 rpi-studio nnrpd[21336]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:24:13 rpi-studio nnrpd[21489]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:24:44 rpi-studio nnrpd[21496]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:25:14 rpi-studio nnrpd[21514]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:25:44 rpi-studio nnrpd[21521]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:26:15 rpi-studio nnrpd[21541]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:26:45 rpi-studio nnrpd[21552]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:27:15 rpi-studio nnrpd[21563]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:27:45 rpi-studio nnrpd[21575]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:28:15 rpi-studio nnrpd[21591]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:28:45 rpi-studio nnrpd[21603]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:29:16 rpi-studio nnrpd[21618]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:29:46 rpi-studio nnrpd[21626]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:30:16 rpi-studio nnrpd[21641]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:30:46 rpi-studio nnrpd[21655]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:31:17 rpi-studio nnrpd[21673]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:31:47 rpi-studio nnrpd[21687]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:32:18 rpi-studio nnrpd[21700]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:32:48 rpi-studio nnrpd[21707]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:33:18 rpi-studio nnrpd[21716]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:33:48 rpi-studio nnrpd[21723]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:34:19 rpi-studio nnrpd[21874]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:34:50 rpi-studio nnrpd[21893]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:35:20 rpi-studio nnrpd[21914]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:35:50 rpi-studio nnrpd[21921]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:36:20 rpi-studio nnrpd[21933]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:36:50 rpi-studio nnrpd[21942]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:37:20 rpi-studio nnrpd[21954]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:37:50 rpi-studio nnrpd[21967]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:38:21 rpi-studio nnrpd[21982]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:38:51 rpi-studio nnrpd[21995]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:39:22 rpi-studio nnrpd[22014]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 30 04:39:52 rpi-studio nnrpd[22029]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 20023 76.9%2.3 MB 69.6%
inn 2205 8.5%413.0 KB 12.3%
innd 2081 8.0%346.3 KB 10.3%
innfeed 1742 6.7%264.5 KB 7.9%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 26053 100.0%3.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10515 53.8%
Negative hits 6847 35.0%
Do not exist 2188 11.2%
Cache misses 3 0.0%
TOTAL: 4 19553 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%6 0.500 0.833 1.000
article cancel00:00:00.001 0.0%7 0.000 0.143 1.000
article cleanup00:00:00.054 0.0%2193 0.000 0.025 0.167
article logging00:00:00.189 0.0%2193 0.000 0.086 0.444
article parse00:00:00.338 0.0%5415 0.000 0.062 0.333
article write00:00:01.081 0.0%1992 0.000 0.543 1.667
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%6 0.000 0.333 1.000
data move00:00:00.147 0.0%21419 0.000 0.007 0.040
hisgrep/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.323 0.0%19582 0.000 0.016 0.065
history sync00:00:00.073 0.0%424 0.000 0.172 1.000
history write00:00:00.391 0.0%2193 0.000 0.178 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:34.451100.0%29190 1295.380 2961.098 8455.155
nntp read00:00:00.676 0.0%22420 0.000 0.030 0.090
overview write00:00:00.654 0.0%1992 0.000 0.328 3.000
perl filter00:00:13.266 0.0%2193 2.150 6.049 17.857
python filter00:00:00.017 0.0%2193 0.000 0.008 0.125
site send00:00:00.839 0.0%4032 0.000 0.208 0.625
TOTAL: 24:01:09.86124:00:52.507100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%1998 0.000 0.008 0.125
article prepare00:00:00.001 0.0%216 0.000 0.005 0.125
article read00:00:00.017 0.0%53 0.000 0.321 8.000
backlog stats00:00:00.140 0.0%27757 0.000 0.005 0.025
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.387 0.0%14618 0.000 0.026 0.111
data write00:00:00.739 0.0%12770 0.000 0.058 0.162
idle23:50:11.220100.0%27757 1271.231 3091.516 8130.000
status file00:00:04.985 0.0%210 1.000 23.738 88.000
TOTAL: 23:50:20.74923:50:17.504100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:16:23.128 94.2%24557 9.400 186.632 3057.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:15.476 0.3%77542 0.000 0.200 14.087
readart00:00:02.533 0.1%13594 0.000 0.186 1.000
TOTAL: 01:21:07.47601:16:41.137 94.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 2143 692 1301 150 32%23:45:23
2gegeweb-out.news.tnetconsulting.net 2 1449 352 1072 25 24%23:49:34
3feed-out.gegeweb.org 2 1959 352 1607 0 17%23:56:59
4news.samoylyk.net 1 1484 237 1247 0 15%18:28:30
5i2pn.org 2 2414 160 2253 1 6%25:54:33
6usenet.pasdenom.info 9 958 108 848 2 11%22:32:48
7news.glou.org 2 1990 89 1867 34 4%29:02:25
8nntp.terraraq.uk 6 1133 25 1108 0 2%20:46:08
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 51 13530 2015 11303 212 14%188:16:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.1 MB0.0 KB651.4 KB3.8 MB 83%4.6 KB
2news.samoylyk.net2.1 MB0.0 KB0.0 KB2.1 MB100%9.1 KB
3gegeweb-out.news.tnetconsulting.net1.1 MB0.0 KB84.2 KB1.2 MB 93%3.3 KB
4feed-out.gegeweb.org1.1 MB0.0 KB0.0 KB1.1 MB100%3.3 KB
5i2pn.org421.2 KB0.0 KB2.0 KB423.2 KB 99%2.6 KB
6usenet.pasdenom.info297.6 KB0.0 KB2.4 KB300.0 KB 99%2.7 KB
7news.glou.org291.9 KB0.0 KB103.2 KB395.1 KB 73%3.2 KB
8nntp.terraraq.uk94.7 KB0.0 KB0.0 KB94.7 KB100%3.8 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.6 MB0.0 KB843.1 KB9.4 MB 91%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 30 04:15:01 - 04:59:59 29 1.5% 0.01119.6 KB 1.4% 0.04
Mar 30 05:00:00 - 05:59:59 55 2.8% 0.02197.5 KB 2.3% 0.05
Mar 30 06:00:00 - 06:59:59 58 2.9% 0.02138.7 KB 1.6% 0.04
Mar 30 07:00:00 - 07:59:59 58 2.9% 0.02210.6 KB 2.4% 0.06
Mar 30 08:00:00 - 08:59:59 38 1.9% 0.01152.8 KB 1.7% 0.04
Mar 30 09:00:00 - 09:59:59 76 3.8% 0.02262.9 KB 3.0% 0.07
Mar 30 10:00:00 - 10:59:59 82 4.1% 0.02359.1 KB 4.1% 0.10
Mar 30 11:00:00 - 11:59:59 80 4.0% 0.02269.7 KB 3.1% 0.07
Mar 30 12:00:00 - 12:59:59 66 3.3% 0.021.1 MB 12.4% 0.30
Mar 30 13:00:00 - 13:59:59 71 3.6% 0.02274.9 KB 3.1% 0.08
Mar 30 14:00:00 - 14:59:59 67 3.4% 0.02294.7 KB 3.4% 0.08
Mar 30 15:00:00 - 15:59:59 119 6.0% 0.03438.4 KB 5.0% 0.12
Mar 30 16:00:00 - 16:59:59 129 6.5% 0.04465.7 KB 5.3% 0.13
Mar 30 17:00:00 - 17:59:59 88 4.4% 0.02356.9 KB 4.1% 0.10
Mar 30 18:00:00 - 18:59:59 117 5.9% 0.03391.8 KB 4.5% 0.11
Mar 30 19:00:00 - 19:59:59 102 5.1% 0.03344.1 KB 3.9% 0.10
Mar 30 20:00:00 - 20:59:59 134 6.7% 0.04567.8 KB 6.5% 0.16
Mar 30 21:00:00 - 21:59:59 99 5.0% 0.03326.7 KB 3.7% 0.09
Mar 30 22:00:00 - 22:59:59 111 5.6% 0.03475.6 KB 5.4% 0.13
Mar 30 23:00:00 - 23:59:59 120 6.0% 0.03462.3 KB 5.3% 0.13
Mar 31 00:00:00 - 00:59:59 74 3.7% 0.02370.7 KB 4.2% 0.10
Mar 31 01:00:00 - 01:59:59 78 3.9% 0.02539.1 KB 6.1% 0.15
Mar 31 02:00:00 - 02:59:59 65 3.3% 0.02271.6 KB 3.1% 0.08
Mar 31 03:00:00 - 03:59:59 62 3.1% 0.02333.7 KB 3.8% 0.09
Mar 31 04:00:00 - 04:15:01 13 0.7% 0.0159.7 KB 0.7% 0.07
TOTAL: 24:00:00 1991 100.0% 0.028.6 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 150 44 0 0 0 0 0 0 106
2gegeweb-out.news.tnetconsulting.net 25 0 0 0 0 0 0 0 25
3news.glou.org 18 0 0 0 0 0 0 0 18
4i2pn.org 6 0 0 0 0 0 0 0 6
5usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 5 201 44 0 0 0 0 0 0 157

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 21
linux.kernel.git 21
news.test 1
alt.fan.rush-limbaugh 1
TOTAL: 4 44

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 96
Bad path (news.giganews.com.POSTED) 54
EMP (phn path) 4
Cancels abusifs 2
HTML Multipart 1
TOTAL: 5 157

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2857 14 1842 17 0 5 0%23:59:57
2news.gegeweb.org 1750 8 1633 0 0 0 0%23:55:07
3news.tnetconsulting.net 3004 6 1975 5 0 11 0%23:59:57
4news.samoylyk.net 1429 2 1153 1 0 559 0%23:59:57
5nntp.terraraq.uk 1204 1 1148 0 0 1 0%23:55:05
6news.aioe.org 0 0 0 0 0 1673 0%24:00:00
7news.nntp4.net 1360 0 1290 0 0 0 0%23:58:28
8news.pasdenom.info 1534 0 1440 0 0 0 0%23:58:15
TOTAL: 8 13138 31 10481 23 0 2249 0%191:46:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org96.0 KB181.3 KB277.3 KB0.0 KB/s8.9 KB23:59:57
2news.gegeweb.org27.1 KB0.0 KB27.1 KB0.0 KB/s3.4 KB23:55:07
3news.tnetconsulting.net22.9 KB31.6 KB54.5 KB0.0 KB/s5.0 KB23:59:57
4news.samoylyk.net5.8 KB4.6 KB10.4 KB0.0 KB/s3.5 KB23:59:57
5nntp.terraraq.uk2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:55:05
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:28
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:15
TOTAL: 8154.7 KB217.5 KB372.1 KB0.0 KB/s6.9 KB191:46:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 8 1326128.3 MB 21 0 001:04:13
2104.219.236.22 44 246408.0 KB 14 0 000:07:13
3172.81.133.214 36 3853.7 KB 17 0 000:01:27
4172.81.132.30 34 3280.2 KB 15 0 000:01:15
5104.219.236.154 28 1122.2 KB 11 0 000:00:30
6172.81.133.216 12 620.4 KB 6 0 000:00:21
TOTAL: 6 162 1359428.8 MB 84 0 001:21:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 8 1326128.3 MB 21 0 001:04:13
2unresolved 169 333584.4 KB 63 0 000:11:34
3*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:39
5?2869 00.0 KB 0 0 000:03:24
6*.stretchoid.com 1 00.0 KB 0 0 000:00:01
7*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
TOTAL: 73341 1359428.8 MB 84 0 001:21:02

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 2.781 6.659 0.00001:04:13
104.219.236.22 1.224 0.987 0.00000:07:13
2001:41d0:a:280::1 63.321 49.664 0.00000:03:19
mail.gegeweb.eu 4.546 4.167 1.81200:01:39
172.81.133.214 1.078 0.878 0.00000:01:27
172.81.132.30 0.860 0.708 0.00000:01:15
45.227.253.13 0.148 0.090 0.00000:00:31
104.219.236.154 0.721 0.525 0.00000:00:30
172.81.133.216 0.299 0.278 0.00000:00:21
199.45.154.137 0.083 0.049 0.00000:00:05
2607:ff10:c8:594::4 0.024 0.028 0.00000:00:05
198.235.24.8 0.022 0.022 0.00000:00:03
flexible.monitoring.internet-measurement.com 0.016 0.016 0.00000:00:03
cute.monitoring.internet-measurement.com 0.041 0.022 0.00000:00:03
198.235.24.209 0.033 0.016 0.00000:00:02
147.185.132.197 0.054 0.029 0.00000:00:01
141.211.203.35.bc.googleusercontent.com 0.027 0.015 0.00000:00:01
azpdegs1jujz.stretchoid.com 0.009 0.014 0.00000:00:01
71.6.134.234 0.032 0.020 0.00000:00:01
194.165.16.164 0.032 0.028 0.00000:00:00
TOTAL: 24 75.456 64.283 1.81201:21:02

Curious NNRP server explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2868
mail.gegeweb.eu 288
45.227.253.13 6
199.45.154.137 3
azpdegs1jujz.stretchoid.com 1
2607:ff10:c8:594::4 1
141.211.203.35.bc.googleusercontent.com 1
audacious.monitoring.internet-measurement.com 1
elevated.monitoring.internet-measurement.com 1
147.185.132.197 1
198.235.24.8 1
71.6.134.234 1
88.214.25.125 1
cute.monitoring.internet-measurement.com 1
pristine.monitoring.internet-measurement.com 1
flexible.monitoring.internet-measurement.com 1
198.235.24.209 1
194.165.16.164 1
TOTAL: 18 3179

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.227.253.13 12
141.211.203.35.bc.googleusercontent.com 4
147.185.132.197 4
azpdegs1jujz.stretchoid.com 1
88.214.25.125 1
199.45.154.137 1
TOTAL: 6 23

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Host: 45.13.105.36:563 4
Accept-Encoding: deflate, gzip, identity 2
Accept-Encoding: gzip 2
Accept-Language: en-US;q=0.6,en;q=0.4 2
User-Agent: Mozilla/5.0 (Windows NT 5.1;... 2
Accept: text/html,application/xhtml+xml,... 2
User-Agent: Expanse, a Palo Alto Network... 2
#003 1
MGLNDD_45.13.105.36_119 1
EHLO www.censys.io 1
TOTAL: 11 23

NNRP client timeouts [Top 20]:

SystemConnPeer
199.45.154.137 1 2
88.214.25.125 1 1
TOTAL: 2 2 5

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 12329 90.7%
2local 1265 9.3%
TOTAL: 2 13594100.0%

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

NewsgroupCount
1grisbi.bugsreports 5695
2grisbi.user.french 2163
3grisbi.test 2153
4grisbi.devel 1859
5local.test 1137
6grisbi.cvs 288
7grisbi.user 160
8local.gegeweb.support 128
9grisbi.admin 11
TOTAL: 9 13594
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me