Daily Usenet report for news.niel.me

Mar 31 04:15:01 -- Apr 1 04:15:01

Unknown entries from news log file:

First 50 / 2865 lines (1.7%)

Mar 31 04:15:10 rpi-studio nnrpd[11601]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:15:40 rpi-studio nnrpd[11642]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:16:11 rpi-studio nnrpd[11714]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:16:41 rpi-studio nnrpd[11723]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:17:11 rpi-studio nnrpd[11751]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:17:41 rpi-studio nnrpd[11778]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:18:11 rpi-studio nnrpd[11788]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:18:41 rpi-studio nnrpd[11800]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:19:11 rpi-studio nnrpd[11816]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:19:41 rpi-studio nnrpd[11832]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:20:11 rpi-studio nnrpd[11843]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:20:41 rpi-studio nnrpd[11850]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:21:11 rpi-studio nnrpd[11861]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:21:41 rpi-studio nnrpd[11871]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:22:11 rpi-studio nnrpd[11886]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:22:41 rpi-studio nnrpd[11896]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:23:11 rpi-studio nnrpd[11913]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:23:41 rpi-studio nnrpd[11920]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:24:11 rpi-studio nnrpd[11929]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:24:41 rpi-studio nnrpd[11936]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:25:11 rpi-studio nnrpd[11949]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:25:41 rpi-studio nnrpd[12104]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:26:11 rpi-studio nnrpd[12114]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:26:41 rpi-studio nnrpd[12130]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:27:12 rpi-studio nnrpd[12145]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:27:42 rpi-studio nnrpd[12154]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:28:12 rpi-studio nnrpd[12168]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:28:42 rpi-studio nnrpd[12180]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:29:12 rpi-studio nnrpd[12189]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:29:42 rpi-studio nnrpd[12206]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:30:12 rpi-studio nnrpd[12221]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:30:42 rpi-studio nnrpd[12235]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:31:12 rpi-studio nnrpd[12245]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:31:42 rpi-studio nnrpd[12252]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:32:13 rpi-studio nnrpd[12264]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:32:43 rpi-studio nnrpd[12273]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:33:13 rpi-studio nnrpd[12282]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:33:43 rpi-studio nnrpd[12290]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:34:13 rpi-studio nnrpd[12299]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:34:43 rpi-studio nnrpd[12306]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:35:13 rpi-studio nnrpd[12459]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:35:43 rpi-studio nnrpd[12487]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:36:13 rpi-studio nnrpd[12497]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:36:43 rpi-studio nnrpd[12507]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:37:13 rpi-studio nnrpd[12524]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:37:43 rpi-studio nnrpd[12535]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:38:13 rpi-studio nnrpd[12551]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:38:43 rpi-studio nnrpd[12564]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:39:13 rpi-studio nnrpd[12573]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 31 04:39:43 rpi-studio nnrpd[12591]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 19112 75.0%2.2 MB 68.1%
inn 2554 10.0%474.2 KB 14.3%
innd 1986 7.8%325.8 KB 9.8%
innfeed 1816 7.1%260.1 KB 7.8%
controlchan 6 0.0%1.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 25475 100.0%3.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12241 52.8%
Negative hits 7579 32.7%
Do not exist 2543 11.0%
Cache misses 810 3.5%
TOTAL: 4 23173 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.003 0.0%4 0.000 0.750 1.000
article cancel00:00:00.001 0.0%4 0.000 0.250 1.000
article cleanup00:00:00.062 0.0%2544 0.000 0.024 0.200
article logging00:00:00.214 0.0%2544 0.000 0.084 0.364
article parse00:00:00.355 0.0%6201 0.000 0.057 0.500
article write00:00:01.140 0.0%2190 0.000 0.521 1.333
artlog/artcncl00:00:00.001 0.0%4 0.000 0.250 1.000
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.138 0.0%24179 0.000 0.006 0.043
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.377 0.0%23175 0.000 0.016 0.053
history sync00:00:00.079 0.0%415 0.000 0.190 0.667
history write00:00:00.450 0.0%2544 0.000 0.177 0.517
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:33.382100.0%31112 602.469 2758.851 9522.937
nntp read00:00:00.814 0.0%24750 0.000 0.033 0.086
overview write00:00:00.693 0.0%2190 0.000 0.316 4.200
perl filter00:00:14.182 0.0%2544 2.345 5.575 17.000
python filter00:00:00.018 0.0%2544 0.000 0.007 0.100
site send00:00:01.023 0.0%4466 0.000 0.229 0.524
TOTAL: 23:51:10.31923:50:52.932100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%4849 0.000 0.009 0.182
article prepare00:00:00.001 0.0%292 0.000 0.003 0.083
article read00:00:00.020 0.0%71 0.000 0.282 7.000
backlog stats00:00:00.133 0.0%28285 0.000 0.005 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.454 0.0%15101 0.000 0.030 0.100
data write00:00:00.715 0.0%13099 0.000 0.055 0.143
idle23:51:46.346100.0%28285 442.017 3037.170 10193.627
status file00:00:06.536 0.0%256 1.000 25.531 87.000
TOTAL: 23:51:58.19223:51:54.250100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:04:06.092 56.0%10041 9.400 24.509 8199.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.762 0.2%20443 0.000 0.037 0.500
TOTAL: 00:07:19.51300:04:06.854 56.2%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 2532 889 1329 314 35%24:12:05
2gegeweb-out.news.tnetconsulting.net 2 1795 589 1180 26 32%29:04:34
3feed-out.gegeweb.org 4 2249 400 1849 0 17%25:08:43
4i2pn.org 2 3996 224 3764 8 5%44:00:00
5usenet.pasdenom.info 5 1249 178 1070 1 14%24:57:53
6nntp.terraraq.uk 3 1658 81 1572 5 4%27:39:07
7news.glou.org 3 2699 81 2605 13 3%37:23:40
8news.samoylyk.net 3 2751 24 2727 0 0%03:38:36
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 49 18929 2466 16096 367 13%216:04:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.0 MB0.0 KB2.8 MB6.8 MB 58%5.8 KB
2gegeweb-out.news.tnetconsulting.net2.0 MB0.0 KB96.1 KB2.1 MB 95%3.6 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%3.7 KB
4i2pn.org594.5 KB0.0 KB13.6 KB608.0 KB 97%2.6 KB
5news.glou.org581.9 KB0.0 KB37.2 KB619.1 KB 93%6.6 KB
6usenet.pasdenom.info429.2 KB0.0 KB1.2 KB430.3 KB 99%2.4 KB
7nntp.terraraq.uk222.5 KB0.0 KB8.5 KB231.0 KB 96%2.7 KB
8news.samoylyk.net209.8 KB0.0 KB0.0 KB209.8 KB100%8.7 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.5 MB0.0 KB2.9 MB12.4 MB 76%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 31 04:15:01 - 04:59:59 34 1.6% 0.01184.6 KB 2.1% 0.07
Mar 31 05:00:00 - 05:59:59 48 2.2% 0.01196.4 KB 2.2% 0.05
Mar 31 06:00:00 - 06:59:59 46 2.1% 0.01123.2 KB 1.4% 0.03
Mar 31 07:00:00 - 07:59:59 39 1.8% 0.01138.5 KB 1.6% 0.04
Mar 31 08:00:00 - 08:59:59 81 3.7% 0.02314.0 KB 3.6% 0.09
Mar 31 09:00:00 - 09:59:59 62 2.8% 0.02423.8 KB 4.9% 0.12
Mar 31 10:00:00 - 10:59:59 83 3.8% 0.02318.4 KB 3.6% 0.09
Mar 31 11:00:00 - 11:59:59 86 3.9% 0.02328.7 KB 3.8% 0.09
Mar 31 12:00:00 - 12:59:59 104 4.7% 0.03326.8 KB 3.7% 0.09
Mar 31 13:00:00 - 13:59:59 113 5.2% 0.03409.4 KB 4.7% 0.11
Mar 31 14:00:00 - 14:59:59 108 4.9% 0.03339.8 KB 3.9% 0.09
Mar 31 15:00:00 - 15:59:59 142 6.5% 0.04504.1 KB 5.8% 0.14
Mar 31 16:00:00 - 16:59:59 129 5.9% 0.04441.2 KB 5.1% 0.12
Mar 31 17:00:00 - 17:59:59 120 5.5% 0.03401.1 KB 4.6% 0.11
Mar 31 18:00:00 - 18:59:59 84 3.8% 0.02302.9 KB 3.5% 0.08
Mar 31 19:00:00 - 19:59:59 117 5.3% 0.03346.9 KB 4.0% 0.10
Mar 31 20:00:00 - 20:59:59 138 6.3% 0.04813.6 KB 9.3% 0.23
Mar 31 21:00:00 - 21:59:59 104 4.7% 0.03321.1 KB 3.7% 0.09
Mar 31 22:00:00 - 22:59:59 119 5.4% 0.03388.8 KB 4.5% 0.11
Mar 31 23:00:00 - 23:59:59 120 5.5% 0.03433.6 KB 5.0% 0.12
Apr 1 00:00:00 - 00:59:59 126 5.7% 0.04939.1 KB 10.8% 0.26
Apr 1 01:00:00 - 01:59:59 88 4.0% 0.02295.5 KB 3.4% 0.08
Apr 1 02:00:00 - 02:59:59 48 2.2% 0.01188.7 KB 2.2% 0.05
Apr 1 03:00:00 - 03:59:59 49 2.2% 0.01237.5 KB 2.7% 0.07
Apr 1 04:00:00 - 04:15:01 4 0.2% 0.0015.9 KB 0.2% 0.02
TOTAL: 24:00:00 2192 100.0% 0.038.5 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 314 202 0 0 0 0 0 0 112
2gegeweb-out.news.tnetconsulting.net 25 0 0 0 0 0 0 0 25
3news.glou.org 7 0 0 0 0 0 0 0 7
4nntp.terraraq.uk 5 0 0 0 0 0 0 0 5
5i2pn.org 2 0 0 0 0 0 0 0 2
6usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 6 354 202 0 0 0 0 0 0 152

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 154
linux.kernel.git 46
news.test 1
soc.culture.russia 1
TOTAL: 4 202

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 82
Bad path (news.giganews.com.POSTED) 48
EMP (phn path) 20
Cancel of non-existing ID <vsdq94$13tm$1@dont-email.me> 1
Cancels abusifs 1
TOTAL: 5 152

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3092 37 2004 9 0 32 1%23:56:13
2news.gegeweb.org 1876 11 1788 0 0 0 0%23:54:48
3news.tnetconsulting.net 3257 8 2176 7 0 27 0%23:56:13
4nntp.terraraq.uk 1236 1 1183 0 0 0 0%23:52:16
5news.pasdenom.info 1707 0 1623 0 0 0 0%23:56:07
6news.samoylyk.net 2745 0 2723 0 0 2042 0%23:51:23
7news.aioe.org 0 0 0 0 0 1885 0%24:00:00
8news.nntp4.net 1367 0 1289 0 0 0 0%23:50:52
TOTAL: 8 15280 57 12786 16 0 3986 0%191:17:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org145.6 KB79.5 KB225.1 KB0.0 KB/s4.9 KB23:56:13
2news.gegeweb.org27.1 KB0.0 KB27.1 KB0.0 KB/s2.5 KB23:54:48
3news.tnetconsulting.net21.8 KB25.5 KB47.3 KB0.0 KB/s3.2 KB23:56:13
4nntp.terraraq.uk2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:52:16
5news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:07
6news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:23
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:52
TOTAL: 8197.5 KB105.0 KB302.5 KB0.0 KB/s4.1 KB191:17:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a06:4883:7000::7b 1 00.0 KB 0 0 000:00:04
22a06:4882:7000::7f 1 00.0 KB 0 0 000:00:02
3206.168.34.46 6 00.0 KB 0 0 000:00:04
4ec2-3-143-113-142.us-east-2.compute.amazonaws.com 6 00.0 KB 0 0 000:00:11
52a06:4882:d000::fc 1 00.0 KB 0 0 000:00:00
6147.185.133.101 1 00.0 KB 0 0 000:00:10
7mail.gegeweb.eu 288 00.0 KB 0 0 000:01:41
82a06:4883:d000::dc 1 00.0 KB 0 0 000:00:00
9198.235.24.122 1 00.0 KB 0 0 000:00:03
102a06:4882:7000::79 1 00.0 KB 0 0 000:00:03
11205.210.31.213 1 00.0 KB 0 0 000:00:01
12azpdsshab2op.stretchoid.com 1 00.0 KB 0 0 000:00:09
13229.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
14206.168.34.203 3 00.0 KB 0 0 000:00:04
15194.165.16.165 1 00.0 KB 0 0 000:00:02
162a06:4883:d000::f3 1 00.0 KB 0 0 000:00:00
1791.238.181.94 1 00.0 KB 0 0 000:00:00
182a06:4883:7000::86 1 00.0 KB 0 0 000:00:03
192001:41d0:a:280::12865 00.0 KB 0 0 000:04:26
TOTAL: 193182 00.0 KB 0 0 000:07:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 1 00.0 KB 0 0 000:00:09
2*.us-east-2.compute.amazonaws.com 6 00.0 KB 0 0 000:00:11
3?2872 00.0 KB 0 0 000:04:42
4unresolved 14 00.0 KB 0 0 000:00:28
5*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
6*.gegeweb.eu 288 00.0 KB 0 0 000:01:41
TOTAL: 63182 00.0 KB 0 0 000:07:15

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2001:41d0:a:280::1 63.115 49.773 0.00000:04:26
mail.gegeweb.eu 4.782 4.134 1.80900:01:41
ec2-3-143-113-142.us-east-2.compute.amazonaws.com 0.150 0.077 0.00000:00:11
147.185.133.101 0.074 0.016 0.00000:00:10
azpdsshab2op.stretchoid.com 0.011 0.011 0.00000:00:09
206.168.34.46 0.120 0.063 0.00000:00:04
206.168.34.203 0.058 0.056 0.00000:00:04
2a06:4883:7000::7b 0.056 0.017 0.00000:00:04
2a06:4882:7000::79 0.044 0.017 0.00000:00:03
198.235.24.122 0.007 0.015 0.00000:00:03
2a06:4883:7000::86 0.051 0.008 0.00000:00:03
2a06:4882:7000::7f 0.023 0.023 0.00000:00:02
194.165.16.165 0.014 0.010 0.00000:00:02
205.210.31.213 0.030 0.013 0.00000:00:01
229.149.216.162.bc.googleusercontent.com 0.060 0.015 0.00000:00:01
2a06:4883:d000::dc 0.020 0.008 0.00000:00:00
2a06:4883:d000::f3 0.015 0.012 0.00000:00:00
2a06:4882:d000::fc 0.040 0.024 0.00000:00:00
91.238.181.94 0.018 0.009 0.00000:00:00
TOTAL: 19 68.688 54.301 1.80900:07:15

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2a06:4883:7000::7b 6
ec2-3-143-113-142.us-east-2.compute.amazonaws.com 5
147.185.133.101 4
229.149.216.162.bc.googleusercontent.com 4
194.165.16.165 1
TOTAL: 5 20

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept-Encoding: gzip 4
Host: 45.13.105.36:563 3
User-Agent: Expanse, a Palo Alto Network... 2
Accept: */* 2
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 1
#003 1
Connection: close 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
TOTAL: 10 20

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.165 1 1
TOTAL: 1 1 3
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me