Daily Usenet report for news.niel.me

Mar 9 04:15:01 -- Mar 10 04:15:01

Unknown entries from news log file:

First 50 / 2046 lines (2.4%)

Mar 9 11:08:57 rpi-studio nnrpd[3103]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:09:27 rpi-studio nnrpd[3120]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:09:58 rpi-studio nnrpd[3133]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:10:28 rpi-studio nnrpd[3147]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:10:58 rpi-studio nnrpd[3154]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:11:11 rpi-studio nnrpd[3162]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:11:41 rpi-studio nnrpd[3172]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:12:11 rpi-studio nnrpd[3187]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:12:41 rpi-studio nnrpd[3342]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:13:11 rpi-studio nnrpd[3352]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:13:41 rpi-studio nnrpd[3360]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:14:11 rpi-studio nnrpd[3369]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:14:41 rpi-studio nnrpd[3376]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:15:11 rpi-studio nnrpd[3387]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:15:41 rpi-studio nnrpd[3401]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:16:11 rpi-studio nnrpd[3412]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:16:41 rpi-studio nnrpd[3425]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:17:11 rpi-studio nnrpd[3451]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:17:41 rpi-studio nnrpd[3464]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:18:11 rpi-studio nnrpd[3480]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:18:41 rpi-studio nnrpd[3487]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:19:12 rpi-studio nnrpd[3496]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:19:42 rpi-studio nnrpd[3504]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:20:12 rpi-studio nnrpd[3523]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:20:42 rpi-studio nnrpd[3535]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:21:12 rpi-studio nnrpd[3544]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:21:42 rpi-studio nnrpd[3551]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:22:12 rpi-studio nnrpd[3565]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:22:42 rpi-studio nnrpd[3718]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:23:12 rpi-studio nnrpd[3729]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:23:42 rpi-studio nnrpd[3743]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:24:12 rpi-studio nnrpd[3754]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:24:43 rpi-studio nnrpd[3762]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:25:13 rpi-studio nnrpd[3775]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:25:43 rpi-studio nnrpd[3787]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:26:14 rpi-studio nnrpd[3797]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:26:44 rpi-studio nnrpd[3809]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:27:15 rpi-studio nnrpd[3819]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:27:46 rpi-studio nnrpd[3838]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:28:17 rpi-studio nnrpd[3857]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:28:48 rpi-studio nnrpd[3866]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:29:19 rpi-studio nnrpd[3876]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:29:49 rpi-studio nnrpd[3894]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:30:19 rpi-studio nnrpd[3905]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:30:50 rpi-studio nnrpd[3912]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:31:20 rpi-studio nnrpd[3925]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:31:50 rpi-studio nnrpd[3939]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:32:20 rpi-studio nnrpd[3957]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:32:50 rpi-studio nnrpd[4105]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 9 11:33:20 rpi-studio nnrpd[4115]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14121 68.0%1.6 MB 60.0%
inn 2533 12.2%461.0 KB 16.5%
innd 2137 10.3%360.7 KB 12.9%
innfeed 1986 9.6%293.0 KB 10.5%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 20779 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12106 54.9%
Negative hits 7420 33.7%
Do not exist 2516 11.4%
Cache misses 1 0.0%
TOTAL: 4 22043 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.068 0.0%2520 0.000 0.027 0.200
article logging00:00:00.192 0.0%2520 0.000 0.076 0.500
article parse00:00:00.395 0.0%6996 0.000 0.056 1.000
article write00:00:01.038 0.0%2179 0.000 0.476 1.143
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.125 0.0%24335 0.000 0.005 0.029
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%4 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.347 0.0%22060 0.000 0.016 0.071
history sync00:00:00.055 0.0%415 0.000 0.133 0.667
history write00:00:00.404 0.0%2520 0.000 0.160 0.786
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:36.754100.0%30524 1145.681 2831.764 28619.619
nntp read00:00:00.811 0.0%25803 0.000 0.031 0.094
overview write00:00:00.644 0.0%2179 0.000 0.296 2.286
perl filter00:00:12.848 0.0%2520 1.958 5.098 19.600
python filter00:00:00.027 0.0%2520 0.000 0.011 0.333
site send00:00:00.867 0.0%4418 0.000 0.196 0.625
TOTAL: 24:01:09.38824:00:54.579100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%2283 0.000 0.008 0.111
article prepare00:00:00.004 0.0%532 0.000 0.008 0.250
article read00:00:00.026 0.0%127 0.000 0.205 8.000
backlog stats00:00:00.159 0.0%29505 0.000 0.005 0.034
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.447 0.0%16096 0.000 0.028 0.100
data write00:00:00.771 0.0%14202 0.000 0.054 0.143
idle23:49:51.131100.0%29505 1327.011 2907.681 10367.655
status file00:00:03.938 0.0%227 1.000 17.348 66.500
TOTAL: 23:50:00.29023:49:56.495100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:21.871 48.7%7594 7.500 18.682 10049.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.612 0.2%15555 0.000 0.039 0.500
TOTAL: 00:04:51.26800:02:22.483 48.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 2679 523 1829 327 19%26:04:42
2feed-out.gegeweb.org 3 2164 501 1663 0 23%23:55:19
3gegeweb-out.news.tnetconsulting.net 2 984 270 691 23 27%17:02:31
4news.samoylyk.net 2 1415 240 1174 1 16%16:34:56
5usenet.pasdenom.info 7 2276 219 2056 1 9%41:46:56
6i2pn.org 2 2305 201 2104 0 8%27:34:17
7nntp.terraraq.uk 5 2772 105 2665 2 3%43:04:05
8news.glou.org 3 1622 48 1550 24 2%25:48:50
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 51 16217 2107 13732 378 12%221:51:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.5 MB0.0 KB2.8 MB5.2 MB 46%6.3 KB
2feed-out.gegeweb.org1.7 MB0.0 KB0.0 KB1.7 MB100%3.5 KB
3news.samoylyk.net1.6 MB0.0 KB2.7 KB1.6 MB 99%6.6 KB
4gegeweb-out.news.tnetconsulting.net817.4 KB0.0 KB83.9 KB901.3 KB 90%3.1 KB
5nntp.terraraq.uk752.2 KB0.0 KB5.3 KB757.5 KB 99%7.1 KB
6usenet.pasdenom.info544.2 KB0.0 KB1.2 KB545.4 KB 99%2.5 KB
7i2pn.org464.3 KB0.0 KB0.0 KB464.3 KB100%2.3 KB
8news.glou.org219.6 KB0.0 KB80.4 KB300.0 KB 73%4.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.5 MB0.0 KB2.9 MB11.4 MB 74%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 9 04:15:01 - 04:59:59 46 2.1% 0.02235.0 KB 2.3% 0.09
Mar 9 05:00:00 - 05:59:59 48 2.2% 0.01171.8 KB 1.7% 0.05
Mar 9 06:00:00 - 06:59:59 36 1.6% 0.01119.1 KB 1.2% 0.03
Mar 9 07:00:00 - 07:59:59 42 1.9% 0.01156.7 KB 1.5% 0.04
Mar 9 08:00:00 - 08:59:59 26 1.2% 0.0179.6 KB 0.8% 0.02
Mar 9 09:00:00 - 09:59:59 52 2.4% 0.01167.3 KB 1.6% 0.05
Mar 9 10:00:00 - 10:59:59 110 5.0% 0.03489.5 KB 4.8% 0.14
Mar 9 11:00:00 - 11:59:59 107 4.9% 0.03706.9 KB 6.9% 0.20
Mar 9 12:00:00 - 12:59:59 98 4.5% 0.03319.4 KB 3.1% 0.09
Mar 9 13:00:00 - 13:59:59 98 4.5% 0.03404.2 KB 4.0% 0.11
Mar 9 14:00:00 - 14:59:59 114 5.2% 0.03426.6 KB 4.2% 0.12
Mar 9 15:00:00 - 15:59:59 92 4.2% 0.03310.3 KB 3.0% 0.09
Mar 9 16:00:00 - 16:59:59 117 5.4% 0.03764.8 KB 7.5% 0.21
Mar 9 17:00:00 - 17:59:59 135 6.2% 0.04839.3 KB 8.2% 0.23
Mar 9 18:00:00 - 18:59:59 123 5.6% 0.03694.7 KB 6.8% 0.19
Mar 9 19:00:00 - 19:59:59 176 8.1% 0.05865.7 KB 8.5% 0.24
Mar 9 20:00:00 - 20:59:59 115 5.3% 0.03541.3 KB 5.3% 0.15
Mar 9 21:00:00 - 21:59:59 140 6.4% 0.04773.0 KB 7.6% 0.21
Mar 9 22:00:00 - 22:59:59 141 6.5% 0.04460.8 KB 4.5% 0.13
Mar 9 23:00:00 - 23:59:59 102 4.7% 0.03477.9 KB 4.7% 0.13
Mar 10 00:00:00 - 00:59:59 104 4.8% 0.03563.3 KB 5.5% 0.16
Mar 10 01:00:00 - 01:59:59 51 2.3% 0.01194.7 KB 1.9% 0.05
Mar 10 02:00:00 - 02:59:59 53 2.4% 0.01156.6 KB 1.5% 0.04
Mar 10 03:00:00 - 03:59:59 45 2.1% 0.01245.9 KB 2.4% 0.07
Mar 10 04:00:00 - 04:15:01 13 0.6% 0.0160.4 KB 0.6% 0.07
TOTAL: 24:00:00 2184 100.0% 0.0310.0 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 284 170 0 0 0 0 0 0 114
2gegeweb-out.news.tnetconsulting.net 33 0 0 0 0 0 0 0 33
3news.glou.org 20 0 0 0 0 0 0 0 20
4i2pn.org 2 0 0 0 0 0 0 0 2
5nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 341 170 0 0 0 0 0 0 171

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 146
linux.kernel.git 23
news.test 1
TOTAL: 3 170

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 110
Bad path (news.giganews.com.POSTED) 59
HTML Multipart 1
Too many newsgroups (meow) 1
TOTAL: 4 171

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3074 76 1937 17 0 51 2%23:55:14
2news.gegeweb.org 1815 16 1663 0 0 0 0%23:55:15
3news.tnetconsulting.net 3221 6 2161 12 0 58 0%23:55:14
4news.nntp4.net 1780 0 1668 0 0 0 0%23:47:44
5news.pasdenom.info 1583 0 1481 0 0 0 0%23:53:58
6nntp.terraraq.uk 1231 0 1151 0 0 0 0%23:54:12
7news.aioe.org 0 0 0 0 0 1812 0%24:00:00
8news.samoylyk.net 2045 0 1691 6 0 0 0%24:05:08
TOTAL: 8 14749 98 11752 35 0 1921 0%191:26:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org289.6 KB83.0 KB372.5 KB0.0 KB/s4.0 KB23:55:14
2news.gegeweb.org32.0 KB0.0 KB32.0 KB0.0 KB/s2.0 KB23:55:15
3news.tnetconsulting.net13.8 KB45.1 KB58.9 KB0.0 KB/s3.3 KB23:55:14
4news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:44
5news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:58
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:12
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.samoylyk.net0.0 KB19.0 KB19.0 KB0.0 KB/s3.2 KB24:05:08
TOTAL: 8335.3 KB147.1 KB482.4 KB0.0 KB/s3.6 KB191:26:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mail.gegeweb.eu 288 00.0 KB 0 0 000:01:30
2brilliant.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
3instinctive.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
4price.probe.onyphe.net 1 00.0 KB 0 0 000:00:04
5gleeful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
620.168.6.41 1 00.0 KB 0 0 000:00:00
7azpdss5yjhg7.stretchoid.com 1 00.0 KB 0 0 000:00:09
8181.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
9contented.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
10185.243.96.117 2 00.0 KB 0 0 000:00:04
11147.45.112.182 1 00.0 KB 0 0 000:00:03
12198.235.24.216 1 00.0 KB 0 0 000:00:11
13206.168.34.94 1 00.0 KB 0 0 000:00:05
14199.45.155.76 3 00.0 KB 0 0 000:00:05
15purposeful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
16198.235.24.247 1 00.0 KB 0 0 000:00:10
17222.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
182001:41d0:a:280::12046 00.0 KB 0 0 000:02:14
19charitable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 192354 00.0 KB 0 0 000:04:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
2?2046 00.0 KB 0 0 000:02:14
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:30
4*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5unresolved 10 00.0 KB 0 0 000:00:39
6*.probe.onyphe.net 1 00.0 KB 0 0 000:00:04
7*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:07
8*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 82354 00.0 KB 0 0 000:04:48

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 44.982 35.854 0.00000:02:14
mail.gegeweb.eu 4.720 4.175 1.81700:01:30
198.235.24.216 0.021 0.021 0.00000:00:11
198.235.24.247 0.036 0.016 0.00000:00:10
azpdss5yjhg7.stretchoid.com 0.012 0.012 0.00000:00:09
199.45.155.76 0.081 0.055 0.00000:00:05
206.168.34.94 0.044 0.012 0.00000:00:05
185.243.96.117 0.052 0.030 0.00000:00:04
price.probe.onyphe.net 0.036 0.020 0.00000:00:04
brilliant.monitoring.internet-measurement.com 0.020 0.008 0.00000:00:03
instinctive.monitoring.internet-measurement.com 0.059 0.028 0.00000:00:03
147.45.112.182 0.023 0.027 0.00000:00:03
222.210.203.35.bc.googleusercontent.com 0.048 0.028 0.00000:00:00
181.150.216.162.bc.googleusercontent.com 0.061 0.019 0.00000:00:00
20.168.6.41 0.025 0.018 0.00000:00:00
charitable.monitoring.internet-measurement.com 0.050 0.013 0.00000:00:00
contented.monitoring.internet-measurement.com 0.036 0.020 0.00000:00:00
gleeful.monitoring.internet-measurement.com 0.036 0.028 0.00000:00:00
TOTAL: 18 50.342 40.384 1.81700:04:48

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
222.210.203.35.bc.googleusercontent.com 4
181.150.216.162.bc.googleusercontent.com 4
20.168.6.41 1
206.168.34.94 1
147.45.112.182 1
185.243.96.117 1
199.45.155.76 1
TOTAL: 7 13

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
Accept-Encoding: gzip 2
#003 2
Host: 45.13.105.36:563 2
EHLO www.censys.io 2
User-Agent: Expanse, a Palo Alto Network... 2
MGLNDD_45.13.105.36_119 1
TOTAL: 7 13

NNRP client timeouts [Top 20]:

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