Daily Usenet report for news.niel.me

Mar 23 04:15:01 -- Mar 24 04:15:02

Unknown entries from news log file:

First 50 / 2867 lines (1.7%)

Mar 23 04:15:10 rpi-studio nnrpd[22288]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:15:40 rpi-studio nnrpd[22324]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:16:10 rpi-studio nnrpd[22403]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:16:40 rpi-studio nnrpd[22416]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:17:11 rpi-studio nnrpd[22578]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:17:41 rpi-studio nnrpd[22585]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:18:11 rpi-studio nnrpd[22600]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:18:41 rpi-studio nnrpd[22607]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:19:11 rpi-studio nnrpd[22618]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:19:41 rpi-studio nnrpd[22626]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:20:11 rpi-studio nnrpd[22639]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:20:41 rpi-studio nnrpd[22654]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:21:12 rpi-studio nnrpd[22664]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:21:43 rpi-studio nnrpd[22672]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:22:13 rpi-studio nnrpd[22686]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:22:43 rpi-studio nnrpd[22700]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:23:13 rpi-studio nnrpd[22709]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:23:44 rpi-studio nnrpd[22717]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:24:14 rpi-studio nnrpd[22728]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:24:44 rpi-studio nnrpd[22735]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:25:14 rpi-studio nnrpd[22752]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:25:44 rpi-studio nnrpd[22759]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:26:15 rpi-studio nnrpd[22783]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:26:45 rpi-studio nnrpd[22792]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:27:15 rpi-studio nnrpd[22949]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:27:45 rpi-studio nnrpd[22972]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:28:15 rpi-studio nnrpd[22981]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:28:45 rpi-studio nnrpd[22993]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:29:15 rpi-studio nnrpd[23003]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:29:46 rpi-studio nnrpd[23018]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:30:16 rpi-studio nnrpd[23034]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:30:46 rpi-studio nnrpd[23041]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:31:17 rpi-studio nnrpd[23050]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:31:47 rpi-studio nnrpd[23065]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:32:17 rpi-studio nnrpd[23078]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:32:47 rpi-studio nnrpd[23085]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:33:17 rpi-studio nnrpd[23095]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:33:47 rpi-studio nnrpd[23102]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:34:17 rpi-studio nnrpd[23112]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:34:48 rpi-studio nnrpd[23131]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:35:18 rpi-studio nnrpd[23145]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:35:48 rpi-studio nnrpd[23159]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:36:18 rpi-studio nnrpd[23168]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:36:48 rpi-studio nnrpd[23176]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:37:18 rpi-studio nnrpd[23326]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:37:48 rpi-studio nnrpd[23348]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:38:18 rpi-studio nnrpd[23359]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:38:49 rpi-studio nnrpd[23377]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:39:19 rpi-studio nnrpd[23392]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 23 04:39:50 rpi-studio nnrpd[23400]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 19152 75.2%2.2 MB 68.9%
inn 2407 9.4%446.5 KB 13.4%
innd 2071 8.1%345.2 KB 10.4%
innfeed 1845 7.2%239.6 KB 7.2%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 25477 100.0%3.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11700 55.6%
Negative hits 6963 33.1%
Do not exist 2392 11.4%
Cache misses 3 0.0%
TOTAL: 4 21058 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.004 0.0%4 0.000 1.000 2.000
article cancel00:00:00.000 0.0%4 0.000 0.000 0.000
article cleanup00:00:00.072 0.0%2393 0.000 0.030 0.167
article logging00:00:00.192 0.0%2393 0.000 0.080 0.400
article parse00:00:00.325 0.0%5562 0.000 0.058 0.188
article write00:00:01.090 0.0%2161 0.000 0.504 1.286
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.138 0.0%22745 0.000 0.006 0.053
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.352 0.0%21066 0.000 0.017 0.051
history sync00:00:00.066 0.0%408 0.000 0.162 1.000
history write00:00:00.436 0.0%2393 0.000 0.182 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:31.613100.0%30220 1439.830 2840.225 10532.386
nntp read00:00:00.780 0.0%23871 0.000 0.033 0.082
overview write00:00:00.645 0.0%2161 0.000 0.298 5.429
perl filter00:00:13.665 0.0%2393 2.067 5.710 27.500
python filter00:00:00.015 0.0%2393 0.000 0.006 0.143
site send00:00:00.947 0.0%4381 0.000 0.216 0.500
TOTAL: 23:51:07.39523:50:50.340100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%2287 0.000 0.012 0.118
article prepare00:00:00.004 0.0%744 0.000 0.005 0.250
article read00:00:00.036 0.0%171 0.000 0.211 8.000
backlog stats00:00:00.185 0.0%29013 0.000 0.006 0.038
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.464 0.0%15356 0.000 0.030 0.300
data write00:00:00.744 0.0%13573 0.000 0.055 0.188
idle23:58:04.995100.0%29013 1629.455 2974.011 8958.269
status file00:00:07.436 0.0%274 1.000 27.139 87.000
TOTAL: 23:58:17.38523:58:13.892100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:19:08.676 82.4%10248 9.600 112.088 90457.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.994 0.1%20954 0.000 0.095 16.476
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:23:14.00500:19:10.670 82.5%----

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 3 2353 911 1264 178 38%24:02:46
2feed-out.gegeweb.org 2 2180 501 1679 0 22%23:59:23
3gegeweb-out.news.tnetconsulting.net 1 3083 439 2596 48 14%40:39:52
4usenet.pasdenom.info 7 2493 253 2239 1 10%42:22:32
5i2pn.org 3 2228 139 2088 1 6%24:11:27
6nntp.terraraq.uk 5 3166 132 3026 8 4%42:17:10
7news.samoylyk.net 1 1803 47 1756 0 2%21:26:38
8news.glou.org 3 1598 25 1565 8 1%23:53:16
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 50 18904 2447 16213 244 12%242:53:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.6 MB0.0 KB923.9 KB5.5 MB 83%5.2 KB
2feed-out.gegeweb.org1.7 MB0.0 KB0.0 KB1.7 MB100%3.4 KB
3gegeweb-out.news.tnetconsulting.net1.7 MB0.0 KB197.2 KB1.9 MB 89%3.9 KB
4news.samoylyk.net733.7 KB0.0 KB0.0 KB733.7 KB100%15.6 KB
5usenet.pasdenom.info671.9 KB0.0 KB1.1 KB673.0 KB 99%2.6 KB
6i2pn.org349.4 KB0.0 KB1.8 KB351.2 KB 99%2.5 KB
7nntp.terraraq.uk300.1 KB0.0 KB39.5 KB339.6 KB 88%2.4 KB
8news.glou.org91.1 KB0.0 KB33.1 KB124.2 KB 73%3.8 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 910.0 MB0.0 KB1.2 MB11.2 MB 89%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 23 04:15:01 - 04:59:59 31 1.4% 0.0190.5 KB 1.0% 0.03
Mar 23 05:00:00 - 05:59:59 25 1.2% 0.0190.5 KB 1.0% 0.03
Mar 23 06:00:00 - 06:59:59 37 1.7% 0.01141.7 KB 1.6% 0.04
Mar 23 07:00:00 - 07:59:59 63 2.9% 0.02432.4 KB 4.7% 0.12
Mar 23 08:00:00 - 08:59:59 74 3.4% 0.02631.1 KB 6.9% 0.18
Mar 23 09:00:00 - 09:59:59 52 2.4% 0.01181.8 KB 2.0% 0.05
Mar 23 10:00:00 - 10:59:59 87 4.0% 0.02289.0 KB 3.2% 0.08
Mar 23 11:00:00 - 11:59:59 93 4.3% 0.03350.2 KB 3.8% 0.10
Mar 23 12:00:00 - 12:59:59 90 4.2% 0.03291.5 KB 3.2% 0.08
Mar 23 13:00:00 - 13:59:59 83 3.8% 0.02261.2 KB 2.9% 0.07
Mar 23 14:00:00 - 14:59:59 135 6.2% 0.04577.2 KB 6.3% 0.16
Mar 23 15:00:00 - 15:59:59 127 5.9% 0.04443.0 KB 4.9% 0.12
Mar 23 16:00:00 - 16:59:59 115 5.3% 0.03400.7 KB 4.4% 0.11
Mar 23 17:00:00 - 17:59:59 109 5.0% 0.03355.2 KB 3.9% 0.10
Mar 23 18:00:00 - 18:59:59 134 6.2% 0.04925.7 KB 10.2% 0.26
Mar 23 19:00:00 - 19:59:59 153 7.1% 0.04529.7 KB 5.8% 0.15
Mar 23 20:00:00 - 20:59:59 135 6.2% 0.04435.2 KB 4.8% 0.12
Mar 23 21:00:00 - 21:59:59 111 5.1% 0.03382.8 KB 4.2% 0.11
Mar 23 22:00:00 - 22:59:59 114 5.3% 0.03454.2 KB 5.0% 0.13
Mar 23 23:00:00 - 23:59:59 110 5.1% 0.03475.0 KB 5.2% 0.13
Mar 24 00:00:00 - 00:59:59 106 4.9% 0.03363.9 KB 4.0% 0.10
Mar 24 01:00:00 - 01:59:59 85 3.9% 0.02288.9 KB 3.2% 0.08
Mar 24 02:00:00 - 02:59:59 50 2.3% 0.01186.4 KB 2.0% 0.05
Mar 24 03:00:00 - 03:59:59 35 1.6% 0.01461.7 KB 5.1% 0.13
Mar 24 04:00:00 - 04:15:02 13 0.6% 0.0175.7 KB 0.8% 0.08
TOTAL: 24:00:01 2167 100.0% 0.038.9 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 178 72 0 0 0 0 0 0 106
2gegeweb-out.news.tnetconsulting.net 41 1 0 0 0 0 0 0 40
3news.glou.org 8 0 0 0 0 0 0 0 8
4nntp.terraraq.uk 3 0 0 0 0 0 0 0 3
5i2pn.org 1 0 0 0 0 0 0 0 1
6usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 6 232 73 0 0 0 0 0 0 159

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 51
linux.kernel.git 18
soc.culture.russia 1
soc.culture.iran 1
news.test 1
nl.actueel 1
TOTAL: 6 73

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 91
Bad path (news.giganews.com.POSTED) 62
HTML Multipart 3
Cancel of non-existing ID <vrohi4$20949$1@dont-email.me> 1
EMP (md5) 1
Cancels abusifs 1
TOTAL: 6 159

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3045 34 1994 14 0 50 1%23:59:49
2news.gegeweb.org 1734 12 1662 0 0 0 0%23:55:57
3news.tnetconsulting.net 3160 11 2129 21 0 37 0%23:59:06
4news.samoylyk.net 2011 3 1178 91 0 906 0%23:59:58
5news.aioe.org 0 0 0 0 0 1830 0%24:00:00
6news.pasdenom.info 1627 0 1523 0 0 0 0%23:50:22
7news.nntp4.net 1298 0 1222 0 0 0 0%23:33:13
8nntp.terraraq.uk 1137 0 1108 0 0 1 0%23:31:50
TOTAL: 8 14012 60 10816 126 0 2824 0%190:50:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org102.6 KB191.0 KB293.6 KB0.0 KB/s6.1 KB23:59:49
2news.gegeweb.org32.3 KB0.0 KB32.3 KB0.0 KB/s2.7 KB23:55:57
3news.tnetconsulting.net30.1 KB135.3 KB165.4 KB0.0 KB/s5.2 KB23:59:06
4news.samoylyk.net8.4 KB575.5 KB583.9 KB0.0 KB/s6.2 KB23:59:58
5news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
6news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:22
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:33:13
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:31:50
TOTAL: 8173.5 KB901.7 KB1.1 MB0.0 KB/s5.8 KB190:50:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 8 21.0 KB 1 0 000:16:30
TOTAL: 1 8 21.0 KB 1 0 000:23:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 8 21.0 KB 1 0 000:16:30
2*.monitoring.internet-measurement.com 7 00.0 KB 0 0 000:00:09
3unresolved 13 00.0 KB 0 0 000:01:27
4*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
5*.gegeweb.eu 288 00.0 KB 0 0 000:01:30
6?2873 00.0 KB 0 0 000:03:29
TOTAL: 63190 21.0 KB 1 0 000:23:09

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 0.419 0.332 0.00000:16:30
2001:41d0:a:280::1 63.751 51.017 0.00000:03:21
mail.gegeweb.eu 4.696 4.313 1.81800:01:30
206.168.34.217 0.023 0.009 0.00000:00:33
206.168.34.115 0.034 0.026 0.00000:00:32
199.45.155.83 0.285 0.109 0.00000:00:07
206.168.34.56 0.047 0.016 0.00000:00:06
205.210.31.137 0.018 0.004 0.00000:00:04
2a06:4882:9000::92 0.043 0.022 0.00000:00:04
helpful.monitoring.internet-measurement.com 0.053 0.008 0.00000:00:03
2a06:4882:9000::9f 0.032 0.024 0.00000:00:03
novel.monitoring.internet-measurement.com 0.032 0.008 0.00000:00:03
venerable.monitoring.internet-measurement.com 0.033 0.020 0.00000:00:01
198.235.24.203 0.032 0.014 0.00000:00:01
91.238.181.91 0.028 0.036 0.00000:00:01
151.211.203.35.bc.googleusercontent.com 0.029 0.011 0.00000:00:01
handsome.monitoring.internet-measurement.com 0.037 0.022 0.00000:00:00
2a06:4882:5000::6d 0.035 0.023 0.00000:00:00
2a06:4882:5000::5b 0.030 0.023 0.00000:00:00
cool.monitoring.internet-measurement.com 0.026 0.033 0.00000:00:00
TOTAL: 22 69.757 56.120 1.81800:23:09

Curious NNRP server explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2867
mail.gegeweb.eu 288
199.45.155.83 7
206.168.34.217 1
admired.monitoring.internet-measurement.com 1
2a06:4882:5000::6b 1
151.211.203.35.bc.googleusercontent.com 1
handsome.monitoring.internet-measurement.com 1
2a06:4882:5000::5b 1
2a06:4882:5000::6d 1
206.168.34.56 1
unparalleled.monitoring.internet-measurement.com 1
206.168.34.115 1
helpful.monitoring.internet-measurement.com 1
2a06:4882:5000::5c 1
91.238.181.91 1
venerable.monitoring.internet-measurement.com 1
198.235.24.203 1
2a06:4882:9000::9f 1
205.210.31.137 1
TOTAL: 23 3182

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
151.211.203.35.bc.googleusercontent.com 4
199.45.155.83 1
206.168.34.56 1
TOTAL: 3 6

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1local 2100.0%
TOTAL: 1 2100.0%

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

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