Daily Usenet report for news.niel.me

Feb 21 04:15:01 -- Feb 22 04:15:01

Unknown entries from news log file:

First 50 / 93 lines (53.8%)

Feb 21 04:15:09 rpi-studio nnrpd[6898]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:15:40 rpi-studio nnrpd[6933]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:16:10 rpi-studio nnrpd[7005]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:16:40 rpi-studio nnrpd[7020]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:17:10 rpi-studio nnrpd[7039]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:17:40 rpi-studio nnrpd[7052]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:18:11 rpi-studio nnrpd[7062]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:18:41 rpi-studio nnrpd[7070]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:19:11 rpi-studio nnrpd[7079]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:19:41 rpi-studio nnrpd[7087]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:20:13 rpi-studio nnrpd[7098]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:20:43 rpi-studio nnrpd[7105]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:21:13 rpi-studio nnrpd[7124]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:21:43 rpi-studio nnrpd[7141]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:22:13 rpi-studio nnrpd[7151]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:22:43 rpi-studio nnrpd[7163]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:23:13 rpi-studio nnrpd[7172]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:23:43 rpi-studio nnrpd[7184]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:24:14 rpi-studio nnrpd[7193]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:24:44 rpi-studio nnrpd[7206]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:25:20 rpi-studio nnrpd[7229]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:25:50 rpi-studio nnrpd[7384]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:26:20 rpi-studio nnrpd[7399]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:26:50 rpi-studio nnrpd[7407]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:27:20 rpi-studio nnrpd[7417]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:27:50 rpi-studio nnrpd[7424]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:28:20 rpi-studio nnrpd[7446]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:28:50 rpi-studio nnrpd[7453]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:29:20 rpi-studio nnrpd[7462]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:29:50 rpi-studio nnrpd[7473]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:30:20 rpi-studio nnrpd[7507]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:30:51 rpi-studio nnrpd[7515]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:31:21 rpi-studio nnrpd[7526]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:31:51 rpi-studio nnrpd[7535]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:32:21 rpi-studio nnrpd[7551]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:32:51 rpi-studio nnrpd[7558]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:33:21 rpi-studio nnrpd[7567]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:33:51 rpi-studio nnrpd[7586]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:34:21 rpi-studio nnrpd[7595]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:34:51 rpi-studio nnrpd[7602]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:35:21 rpi-studio nnrpd[7614]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:35:51 rpi-studio nnrpd[7778]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:36:21 rpi-studio nnrpd[7792]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:36:51 rpi-studio nnrpd[7801]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:37:21 rpi-studio nnrpd[7817]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:37:51 rpi-studio nnrpd[7831]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:38:21 rpi-studio nnrpd[7845]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:38:51 rpi-studio nnrpd[7852]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:39:21 rpi-studio nnrpd[7861]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:39:51 rpi-studio nnrpd[7869]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 2859 29.9%332.7 KB 22.5%
inn 2833 29.6%515.2 KB 34.8%
innd 2078 21.7%367.0 KB 24.8%
innfeed 1785 18.7%266.6 KB 18.0%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 9557 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12965 55.7%
Negative hits 7414 31.8%
Do not exist 2814 12.1%
Cache misses 86 0.4%
TOTAL: 4 23279 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.006 0.0%6 0.000 1.000 2.000
article cancel00:00:00.000 0.0%7 0.000 0.000 0.000
article cleanup00:00:00.061 0.0%2821 0.000 0.022 0.167
article logging00:00:00.190 0.0%2821 0.000 0.067 0.407
article parse00:00:00.509 0.0%9099 0.000 0.056 0.429
article write00:00:01.183 0.0%2375 0.125 0.498 1.125
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.166 0.0%26360 0.000 0.006 0.022
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.001 0.0%7 0.000 0.143 1.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.360 0.0%23338 0.000 0.015 0.073
history sync00:00:00.052 0.0%405 0.000 0.128 0.667
history write00:00:00.475 0.0%2821 0.000 0.168 0.938
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:55.659100.0%29290 278.007 2951.712 12773.957
nntp read00:00:00.678 0.0%28019 0.000 0.024 0.068
overview write00:00:00.733 0.0%2375 0.000 0.309 5.750
perl filter00:00:09.328 0.0%2821 1.257 3.307 9.200
python filter00:00:00.014 0.0%2821 0.000 0.005 0.083
site send00:00:01.003 0.0%4840 0.000 0.207 0.583
TOTAL: 24:01:19.04924:01:10.418100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%3813 0.000 0.006 0.250
article prepare00:00:00.000 0.0%604 0.000 0.000 0.000
article read00:00:00.021 0.0%147 0.000 0.143 3.000
backlog stats00:00:00.170 0.0%30745 0.000 0.006 0.024
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.361 0.0%16602 0.000 0.022 0.087
data write00:00:00.786 0.0%14524 0.000 0.054 0.138
idle23:49:59.004100.0%30745 652.614 2790.665 8008.560
status file00:00:02.480 0.0%243 0.000 10.206 74.000
TOTAL: 23:50:07.66923:50:02.845100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:05:16.126 96.7%22436 9.600 495.459 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.882 0.0%85253 0.000 0.046 0.667
readart00:00:03.008 0.0%19969 0.139 0.151 0.181
TOTAL: 03:11:32.33303:05:23.016 96.8%----

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
1feed-out.gegeweb.org 3 2314 655 1659 0 28%23:59:47
2news.samoylyk.net 2 2203 445 1757 1 20%23:42:05
3gegeweb-out.news.tnetconsulting.net 2 1519 390 1101 28 25%21:32:30
4news.nntp4.net 15 2396 224 1833 339 9%09:59:27
5usenet.pasdenom.info 6 2052 214 1836 2 10%37:58:01
6i2pn.org 1 1775 208 1565 2 11%19:45:04
7news.glou.org 3 2674 69 2560 45 2%40:02:37
8nntp.terraraq.uk 3 2127 53 2074 0 2%30:52:38
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 60 17060 2258 14385 417 13%207:52:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net4.1 MB0.0 KB2.7 KB4.1 MB 99%9.5 KB
2feed-out.gegeweb.org2.2 MB0.0 KB0.0 KB2.2 MB100%3.4 KB
3gegeweb-out.news.tnetconsulting.net1.1 MB0.0 KB87.7 KB1.2 MB 92%2.9 KB
4news.nntp4.net1.0 MB0.0 KB3.4 MB4.4 MB 23%8.1 KB
5usenet.pasdenom.info534.4 KB0.0 KB2.4 KB536.8 KB 99%2.5 KB
6i2pn.org473.4 KB0.0 KB5.6 KB479.0 KB 98%2.3 KB
7news.glou.org289.1 KB0.0 KB138.8 KB427.9 KB 67%3.8 KB
8nntp.terraraq.uk155.5 KB0.0 KB0.0 KB155.5 KB100%2.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.9 MB0.0 KB3.6 MB13.5 MB 73%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 04:15:01 - 04:59:59 18 0.8% 0.0150.0 KB 0.4% 0.02
Feb 21 05:00:00 - 05:59:59 32 1.3% 0.01135.4 KB 1.0% 0.04
Feb 21 06:00:00 - 06:59:59 53 2.2% 0.01175.9 KB 1.3% 0.05
Feb 21 07:00:00 - 07:59:59 50 2.1% 0.01196.4 KB 1.5% 0.05
Feb 21 08:00:00 - 08:59:59 43 1.8% 0.01139.9 KB 1.1% 0.04
Feb 21 09:00:00 - 09:59:59 63 2.7% 0.02277.6 KB 2.1% 0.08
Feb 21 10:00:00 - 10:59:59 125 5.3% 0.03500.2 KB 3.8% 0.14
Feb 21 11:00:00 - 11:59:59 101 4.3% 0.03381.4 KB 2.9% 0.11
Feb 21 12:00:00 - 12:59:59 103 4.3% 0.03797.4 KB 6.1% 0.22
Feb 21 13:00:00 - 13:59:59 114 4.8% 0.03553.9 KB 4.2% 0.15
Feb 21 14:00:00 - 14:59:59 125 5.3% 0.03396.6 KB 3.0% 0.11
Feb 21 15:00:00 - 15:59:59 97 4.1% 0.03393.4 KB 3.0% 0.11
Feb 21 16:00:00 - 16:59:59 130 5.5% 0.041.0 MB 8.0% 0.29
Feb 21 17:00:00 - 17:59:59 131 5.5% 0.04612.2 KB 4.7% 0.17
Feb 21 18:00:00 - 18:59:59 110 4.6% 0.03612.6 KB 4.7% 0.17
Feb 21 19:00:00 - 19:59:59 130 5.5% 0.04791.6 KB 6.0% 0.22
Feb 21 20:00:00 - 20:59:59 135 5.7% 0.04467.8 KB 3.6% 0.13
Feb 21 21:00:00 - 21:59:59 91 3.8% 0.03272.9 KB 2.1% 0.08
Feb 21 22:00:00 - 22:59:59 160 6.7% 0.04487.1 KB 3.7% 0.14
Feb 21 23:00:00 - 23:59:59 106 4.5% 0.03429.7 KB 3.3% 0.12
Feb 22 00:00:00 - 00:59:59 194 8.2% 0.053.3 MB 25.4% 0.93
Feb 22 01:00:00 - 01:59:59 94 4.0% 0.03384.1 KB 2.9% 0.11
Feb 22 02:00:00 - 02:59:59 79 3.3% 0.02303.7 KB 2.3% 0.08
Feb 22 03:00:00 - 03:59:59 55 2.3% 0.02261.4 KB 2.0% 0.07
Feb 22 04:00:00 - 04:15:01 34 1.4% 0.04126.4 KB 1.0% 0.14
TOTAL: 24:00:00 2373 100.0% 0.0312.8 MB 100.0% 0.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 379 304 0 0 0 0 0 0 75
2gegeweb-out.news.tnetconsulting.net 32 0 0 0 0 0 0 0 32
3news.glou.org 32 0 0 0 0 0 0 0 32
4i2pn.org 3 0 0 0 0 0 0 0 3
5usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 5 447 304 0 0 0 0 0 0 143

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 246
linux.kernel.git 55
soc.culture.russia 2
alt.slack 1
TOTAL: 4 304

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 71
Bad path (news.giganews.com.POSTED) 67
hierarchy violation - crosspost outside sdnet 2
HTML Multipart 1
Cancels abusifs 1
EMP (md5) 1
TOTAL: 6 143

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3102 92 1979 4 0 118 2%23:55:11
2news.gegeweb.org 1869 34 1679 0 0 0 1%23:59:05
3news.tnetconsulting.net 3541 9 2352 7 0 139 0%23:59:56
4news.samoylyk.net 2233 1 1801 2 0 12 0%23:59:23
5news.pasdenom.info 1733 1 1580 0 0 0 0%23:57:10
6nntp.terraraq.uk 1305 1 1244 0 0 0 0%23:57:41
7news.aioe.org 0 0 0 0 0 2040 0%23:59:59
8news.nntp4.net 2117 0 2067 0 0 1179 0%23:55:40
TOTAL: 8 15900 138 12702 13 0 3488 0%191:44:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org506.2 KB34.8 KB541.0 KB0.0 KB/s5.6 KB23:55:11
2news.gegeweb.org78.9 KB0.0 KB78.9 KB0.0 KB/s2.3 KB23:59:05
3news.tnetconsulting.net33.3 KB18.8 KB52.1 KB0.0 KB/s3.3 KB23:59:56
4nntp.terraraq.uk2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:57:41
5news.samoylyk.net2.7 KB36.1 KB38.8 KB0.0 KB/s12.9 KB23:59:23
6news.pasdenom.info2.6 KB0.0 KB2.6 KB0.0 KB/s2.6 KB23:57:10
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:40
TOTAL: 8626.7 KB89.7 KB716.4 KB0.0 KB/s4.7 KB191:44:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 22 1996940.4 MB 31 0 003:04:26
TOTAL: 1 22 1996940.4 MB 31 0 003:11:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 22 1996940.4 MB 31 0 003:04:26
2unresolved 13 00.0 KB 0 0 000:03:56
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:08
4? 93 00.0 KB 0 0 000:00:21
5*.stretchoid.com 1 00.0 KB 0 0 000:00:00
6*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
7*.ip.linodeusercontent.com 108 00.0 KB 0 0 000:00:24
8*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
TOTAL: 8 528 1996940.4 MB 31 0 003:11:31

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 3.441 8.369 0.00003:04:26
mail.gegeweb.eu 4.377 3.860 1.58300:02:08
206.168.34.66 0.019 0.009 0.00000:00:34
206.168.34.63 0.019 0.010 0.00000:00:32
206.168.34.116 0.039 0.021 0.00000:00:32
206.168.34.126 0.033 0.021 0.00000:00:31
206.168.34.36 0.016 0.011 0.00000:00:31
206.168.34.78 0.012 0.016 0.00000:00:31
172-105-246-139.ip.linodeusercontent.com 2.755 1.457 0.00000:00:24
2001:41d0:a:280::1 1.513 1.260 0.00000:00:15
147.185.133.73 0.067 0.012 0.00000:00:12
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.029 0.020 0.00000:00:10
205.210.31.174 0.022 0.026 0.00000:00:10
147.185.132.46 0.025 0.021 0.00000:00:10
206.168.34.201 0.039 0.026 0.00000:00:08
2607:ff10:c8:594::4 0.034 0.013 0.00000:00:05
196.211.203.35.bc.googleusercontent.com 0.052 0.026 0.00000:00:01
145.211.203.35.bc.googleusercontent.com 0.024 0.016 0.00000:00:00
199.45.154.121 0.074 0.039 0.00000:00:00
azpdsg42.stretchoid.com 0.013 0.009 0.00000:00:00
TOTAL: 20 12.603 15.242 1.58303:11:31

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
172-105-246-139.ip.linodeusercontent.com 108
2001:41d0:a:280::1 92
199.45.154.121 3
206.168.34.66 1
azpdsg42.stretchoid.com 1
206.168.34.201 1
206.168.34.36 1
196.211.203.35.bc.googleusercontent.com 1
147.185.133.73 1
205.210.31.174 1
147.185.132.46 1
2607:ff10:c8:594::4 1
206.168.34.126 1
206.168.34.63 1
145.211.203.35.bc.googleusercontent.com 1
206.168.34.78 1
206.168.34.116 1
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1
TOTAL: 19 506

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
196.211.203.35.bc.googleusercontent.com 4
145.211.203.35.bc.googleusercontent.com 4
147.185.133.73 4
azpdsg42.stretchoid.com 1
206.168.34.201 1
TOTAL: 5 14

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 3
GET / HTTP/1.1 3
Accept-Encoding: gzip 3
User-Agent: Expanse, a Palo Alto Network... 3
MGLNDD_45.13.105.36_119 1
EHLO www.censys.io 1
TOTAL: 6 14

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 19422 97.3%
2local 547 2.7%
TOTAL: 2 19969100.0%

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

NewsgroupCount
1grisbi.bugsreports 10232
2grisbi.test 5850
3grisbi.user.french 2350
4grisbi.devel 897
5local.test 525
6grisbi.cvs 56
7grisbi.user 37
8local.gegeweb.support 22
TOTAL: 8 19969