Daily Usenet report for news.niel.me

Mar 21 04:15:01 -- Mar 22 04:15:02

Unknown entries from news log file:

First 50 / 2869 lines (1.7%)

Mar 21 04:15:10 rpi-studio nnrpd[7136]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:15:41 rpi-studio nnrpd[7183]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:16:11 rpi-studio nnrpd[7265]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:16:41 rpi-studio nnrpd[7274]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:17:11 rpi-studio nnrpd[7305]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:17:41 rpi-studio nnrpd[7318]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:18:11 rpi-studio nnrpd[7328]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:18:42 rpi-studio nnrpd[7347]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:19:12 rpi-studio nnrpd[7368]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:19:42 rpi-studio nnrpd[7377]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:20:12 rpi-studio nnrpd[7396]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:20:42 rpi-studio nnrpd[7404]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:21:12 rpi-studio nnrpd[7413]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:21:43 rpi-studio nnrpd[7420]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:22:13 rpi-studio nnrpd[7430]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:22:43 rpi-studio nnrpd[7438]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:23:13 rpi-studio nnrpd[7448]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:23:43 rpi-studio nnrpd[7455]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:24:14 rpi-studio nnrpd[7464]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:24:44 rpi-studio nnrpd[7472]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:25:14 rpi-studio nnrpd[7625]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:25:44 rpi-studio nnrpd[7633]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:26:14 rpi-studio nnrpd[7642]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:26:44 rpi-studio nnrpd[7649]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:27:14 rpi-studio nnrpd[7674]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:27:44 rpi-studio nnrpd[7696]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:28:14 rpi-studio nnrpd[7707]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:28:44 rpi-studio nnrpd[7725]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:29:14 rpi-studio nnrpd[7740]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:29:44 rpi-studio nnrpd[7748]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:30:14 rpi-studio nnrpd[7772]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:30:44 rpi-studio nnrpd[7787]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:31:14 rpi-studio nnrpd[7804]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:31:44 rpi-studio nnrpd[7812]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:32:14 rpi-studio nnrpd[7823]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:32:44 rpi-studio nnrpd[7831]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:33:15 rpi-studio nnrpd[7843]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:33:45 rpi-studio nnrpd[7850]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:34:15 rpi-studio nnrpd[7859]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:34:45 rpi-studio nnrpd[7866]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:35:15 rpi-studio nnrpd[8020]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:35:45 rpi-studio nnrpd[8045]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:36:15 rpi-studio nnrpd[8055]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:36:45 rpi-studio nnrpd[8069]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:37:15 rpi-studio nnrpd[8078]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:37:45 rpi-studio nnrpd[8085]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:38:15 rpi-studio nnrpd[8096]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:38:45 rpi-studio nnrpd[8110]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:39:15 rpi-studio nnrpd[8126]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 21 04:39:45 rpi-studio nnrpd[8139]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 19040 74.5%2.2 MB 67.3%
inn 2610 10.2%485.0 KB 14.5%
innd 2134 8.4%358.3 KB 10.7%
innfeed 1756 6.9%253.2 KB 7.5%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 25542 100.0%3.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13361 55.8%
Negative hits 7973 33.3%
Do not exist 2595 10.8%
Cache misses 5 0.0%
TOTAL: 4 23934 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%5 0.000 1.000 2.000
article cancel00:00:00.000 0.0%6 0.000 0.000 0.000
article cleanup00:00:00.071 0.0%2598 0.000 0.027 0.167
article logging00:00:00.215 0.0%2598 0.000 0.083 0.273
article parse00:00:00.376 0.0%6633 0.000 0.057 0.194
article write00:00:01.175 0.0%2288 0.000 0.514 1.333
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 1.000
data move00:00:00.155 0.0%26065 0.000 0.006 0.027
hisgrep/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.401 0.0%23956 0.000 0.017 0.091
history sync00:00:00.057 0.0%419 0.000 0.136 0.667
history write00:00:00.440 0.0%2598 0.000 0.169 0.636
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:40.098100.0%33810 1283.936 2556.643 10178.407
nntp read00:00:00.804 0.0%27399 0.000 0.029 0.063
overview write00:00:00.722 0.0%2288 0.000 0.316 3.667
perl filter00:00:14.791 0.0%2598 2.182 5.693 33.000
python filter00:00:00.016 0.0%2598 0.000 0.006 0.250
site send00:00:00.934 0.0%4648 0.000 0.201 0.419
TOTAL: 24:01:17.76724:01:00.261100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%2479 0.000 0.009 0.143
article prepare00:00:00.002 0.0%376 0.000 0.005 0.250
article read00:00:00.020 0.0%91 0.000 0.220 8.000
backlog stats00:00:00.164 0.0%30630 0.000 0.005 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.438 0.0%17008 0.000 0.026 0.125
data write00:00:00.825 0.0%15092 0.000 0.055 0.143
idle23:59:41.773100.0%30630 1269.019 2820.169 10363.897
status file00:00:04.813 0.0%211 1.000 22.810 76.000
TOTAL: 23:59:51.57923:59:48.058100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:54.403 49.9%10053 9.600 17.348 9048.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.824 0.2%20426 0.000 0.040 0.364
TOTAL: 00:05:49.74300:02:55.227 50.1%----

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 2553 724 1580 249 28%23:49:02
2gegeweb-out.news.tnetconsulting.net 3 2135 556 1554 25 26%27:46:09
3feed-out.gegeweb.org 2 2243 490 1753 0 21%23:59:35
4news.samoylyk.net 3 2218 204 2014 0 9%22:46:36
5i2pn.org 2 1917 109 1805 3 5%23:57:10
6usenet.pasdenom.info 8 826 72 754 0 8%19:13:25
7news.glou.org 3 1660 58 1566 36 3%23:53:25
8nntp.terraraq.uk 3 1095 29 1061 5 2%19:36:05
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 51 14647 2242 12087 318 15%185:01:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.2 MB0.0 KB1.5 MB4.7 MB 68%5.0 KB
2gegeweb-out.news.tnetconsulting.net2.0 MB0.0 KB138.2 KB2.1 MB 93%3.8 KB
3feed-out.gegeweb.org1.7 MB0.0 KB0.0 KB1.7 MB100%3.6 KB
4news.samoylyk.net1.4 MB0.0 KB0.0 KB1.4 MB100%7.0 KB
5news.glou.org252.0 KB0.0 KB127.8 KB379.8 KB 66%4.0 KB
6i2pn.org235.7 KB0.0 KB6.3 KB242.0 KB 97%2.2 KB
7usenet.pasdenom.info170.7 KB0.0 KB0.0 KB170.7 KB100%2.4 KB
8nntp.terraraq.uk115.3 KB0.0 KB64.2 KB179.6 KB 64%5.3 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.1 MB0.0 KB1.8 MB10.9 MB 83%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 21 04:15:01 - 04:59:59 52 2.3% 0.02222.5 KB 2.2% 0.08
Mar 21 05:00:00 - 05:59:59 42 1.8% 0.01214.2 KB 2.1% 0.06
Mar 21 06:00:00 - 06:59:59 28 1.2% 0.01107.9 KB 1.1% 0.03
Mar 21 07:00:00 - 07:59:59 49 2.1% 0.01203.9 KB 2.0% 0.06
Mar 21 08:00:00 - 08:59:59 47 2.1% 0.01241.9 KB 2.4% 0.07
Mar 21 09:00:00 - 09:59:59 68 3.0% 0.02282.4 KB 2.8% 0.08
Mar 21 10:00:00 - 10:59:59 134 5.9% 0.04588.7 KB 5.9% 0.16
Mar 21 11:00:00 - 11:59:59 61 2.7% 0.02279.5 KB 2.8% 0.08
Mar 21 12:00:00 - 12:59:59 75 3.3% 0.02290.7 KB 2.9% 0.08
Mar 21 13:00:00 - 13:59:59 124 5.4% 0.03858.9 KB 8.6% 0.24
Mar 21 14:00:00 - 14:59:59 128 5.6% 0.04472.7 KB 4.7% 0.13
Mar 21 15:00:00 - 15:59:59 87 3.8% 0.02407.7 KB 4.1% 0.11
Mar 21 16:00:00 - 16:59:59 100 4.4% 0.03656.9 KB 6.6% 0.18
Mar 21 17:00:00 - 17:59:59 105 4.6% 0.03583.6 KB 5.8% 0.16
Mar 21 18:00:00 - 18:59:59 118 5.2% 0.03489.9 KB 4.9% 0.14
Mar 21 19:00:00 - 19:59:59 127 5.5% 0.04508.5 KB 5.1% 0.14
Mar 21 20:00:00 - 20:59:59 167 7.3% 0.05661.2 KB 6.6% 0.18
Mar 21 21:00:00 - 21:59:59 129 5.6% 0.04344.3 KB 3.4% 0.10
Mar 21 22:00:00 - 22:59:59 133 5.8% 0.04410.6 KB 4.1% 0.11
Mar 21 23:00:00 - 23:59:59 131 5.7% 0.04495.3 KB 4.9% 0.14
Mar 22 00:00:00 - 00:59:59 123 5.4% 0.03556.6 KB 5.6% 0.15
Mar 22 01:00:00 - 01:59:59 103 4.5% 0.03301.1 KB 3.0% 0.08
Mar 22 02:00:00 - 02:59:59 67 2.9% 0.02251.9 KB 2.5% 0.07
Mar 22 03:00:00 - 03:59:59 73 3.2% 0.02316.7 KB 3.2% 0.09
Mar 22 04:00:00 - 04:15:02 18 0.8% 0.02269.5 KB 2.7% 0.30
TOTAL: 24:00:01 2289 100.0% 0.039.8 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 249 133 0 0 0 0 0 0 116
2news.glou.org 36 0 0 0 0 0 0 0 36
3gegeweb-out.news.tnetconsulting.net 17 0 0 0 0 0 0 0 17
4nntp.terraraq.uk 6 0 0 0 0 0 0 0 6
5usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 5 310 133 0 0 0 0 0 0 177

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 100
linux.kernel.git 30
soc.culture.russia 1
soc.culture.iran 1
news.test 1
TOTAL: 5 133

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 110
Bad path (news.giganews.com.POSTED) 65
Cancels abusifs 2
TOTAL: 3 177

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3332 14 2272 1 0 59 0%23:58:27
2i2pn.org 3129 13 2073 32 0 67 0%23:58:14
3news.gegeweb.org 1898 12 1778 0 0 0 0%23:54:00
4news.samoylyk.net 2675 6 2017 16 0 64 0%23:59:28
5news.aioe.org 0 0 0 0 0 1911 0%24:00:01
6news.pasdenom.info 1711 0 1616 0 0 0 0%23:59:58
7nntp.terraraq.uk 1394 0 1344 0 0 0 0%23:52:24
8news.nntp4.net 1639 0 1535 0 0 0 0%23:59:58
TOTAL: 8 15778 45 12635 49 0 2101 0%191:42:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net79.4 KB2.3 KB81.8 KB0.0 KB/s5.5 KB23:58:27
2i2pn.org64.0 KB205.7 KB269.7 KB0.0 KB/s6.0 KB23:58:14
3news.gegeweb.org37.9 KB0.0 KB37.9 KB0.0 KB/s3.2 KB23:54:00
4news.samoylyk.net29.3 KB172.4 KB201.7 KB0.0 KB/s9.2 KB23:59:28
5news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
6news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:52:24
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
TOTAL: 8210.7 KB380.4 KB591.1 KB0.0 KB/s6.3 KB191:42:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:41d0:a:280::12868 00.0 KB 0 0 000:03:35
2198.235.24.81 1 00.0 KB 0 0 000:00:01
3147.185.132.59 1 00.0 KB 0 0 000:00:00
4independent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
591.238.181.92 2 00.0 KB 0 0 000:00:01
6azpdesvptadt.stretchoid.com 1 00.0 KB 0 0 000:00:09
7camden.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
8azpdcgv31rq4.stretchoid.com 1 00.0 KB 0 0 000:00:00
937.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
10147.185.132.106 1 00.0 KB 0 0 000:00:00
11mail.gegeweb.eu 288 00.0 KB 0 0 000:01:30
12198.235.24.39 1 00.0 KB 0 0 000:00:03
132a06:4882:3000::26 1 00.0 KB 0 0 000:00:02
14awesome.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
15zesty.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
16efficacious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
17brewer.probe.onyphe.net 1 00.0 KB 0 0 000:00:06
18flourishing.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 183173 00.0 KB 0 0 000:05:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 2 00.0 KB 0 0 000:00:10
2*.probe.onyphe.net 2 00.0 KB 0 0 000:00:10
3*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4unresolved 6 00.0 KB 0 0 000:00:07
5?2869 00.0 KB 0 0 000:03:38
6*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
7*.gegeweb.eu 288 00.0 KB 0 0 000:01:30
TOTAL: 73173 00.0 KB 0 0 000:05:45

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.260 51.032 0.00000:03:35
mail.gegeweb.eu 4.843 4.280 1.88800:01:30
azpdesvptadt.stretchoid.com 0.010 0.014 0.00000:00:09
brewer.probe.onyphe.net 0.055 0.023 0.00000:00:06
camden.probe.onyphe.net 0.024 0.020 0.00000:00:03
198.235.24.39 0.013 0.027 0.00000:00:03
independent.monitoring.internet-measurement.com 0.020 0.012 0.00000:00:03
efficacious.monitoring.internet-measurement.com 0.038 0.027 0.00000:00:03
2a06:4882:3000::26 0.013 0.009 0.00000:00:02
198.235.24.81 0.014 0.009 0.00000:00:01
91.238.181.92 0.044 0.032 0.00000:00:01
37.211.203.35.bc.googleusercontent.com 0.025 0.017 0.00000:00:01
azpdcgv31rq4.stretchoid.com 0.013 0.013 0.00000:00:00
147.185.132.59 0.071 0.016 0.00000:00:00
147.185.132.106 0.035 0.012 0.00000:00:00
zesty.monitoring.internet-measurement.com 0.014 0.014 0.00000:00:00
awesome.monitoring.internet-measurement.com 0.035 0.023 0.00000:00:00
flourishing.monitoring.internet-measurement.com 0.013 0.016 0.00000:00:00
TOTAL: 18 68.540 55.596 1.88800:05:45

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.132.59 4
37.211.203.35.bc.googleusercontent.com 4
azpdcgv31rq4.stretchoid.com 1
91.238.181.92 1
TOTAL: 4 10

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 2
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
GET / HTTP/1.1 2
#003 1
MGLNDD_45.13.105.36_119 1
TOTAL: 6 10

NNRP client timeouts [Top 20]:

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