Daily Usenet report for news.niel.me

Mar 14 04:15:01 -- Mar 15 04:15:02

Unknown entries from news log file:

First 50 / 2867 lines (1.7%)

Mar 14 04:15:08 rpi-studio nnrpd[7686]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:15:38 rpi-studio nnrpd[7842]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:16:09 rpi-studio nnrpd[7911]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:16:39 rpi-studio nnrpd[7918]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:17:10 rpi-studio nnrpd[7940]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:17:40 rpi-studio nnrpd[8090]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:18:10 rpi-studio nnrpd[8101]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:18:40 rpi-studio nnrpd[8108]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:19:10 rpi-studio nnrpd[8120]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:19:40 rpi-studio nnrpd[8129]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:20:10 rpi-studio nnrpd[8142]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:20:41 rpi-studio nnrpd[8156]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:21:11 rpi-studio nnrpd[8166]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:21:41 rpi-studio nnrpd[8174]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:22:11 rpi-studio nnrpd[8191]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:22:41 rpi-studio nnrpd[8200]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:23:11 rpi-studio nnrpd[8210]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:23:41 rpi-studio nnrpd[8225]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:24:11 rpi-studio nnrpd[8240]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:24:41 rpi-studio nnrpd[8255]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:25:11 rpi-studio nnrpd[8271]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:25:42 rpi-studio nnrpd[8283]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:26:12 rpi-studio nnrpd[8292]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:26:42 rpi-studio nnrpd[8308]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:27:12 rpi-studio nnrpd[8319]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:27:42 rpi-studio nnrpd[8467]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:28:12 rpi-studio nnrpd[8483]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:28:42 rpi-studio nnrpd[8490]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:29:12 rpi-studio nnrpd[8507]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:29:42 rpi-studio nnrpd[8515]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:30:12 rpi-studio nnrpd[8530]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:30:42 rpi-studio nnrpd[8543]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:31:12 rpi-studio nnrpd[8552]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:31:42 rpi-studio nnrpd[8560]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:32:12 rpi-studio nnrpd[8576]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:32:42 rpi-studio nnrpd[8583]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:33:12 rpi-studio nnrpd[8592]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:33:42 rpi-studio nnrpd[8599]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:34:12 rpi-studio nnrpd[8608]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:34:42 rpi-studio nnrpd[8617]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:35:12 rpi-studio nnrpd[8628]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:35:42 rpi-studio nnrpd[8645]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:36:12 rpi-studio nnrpd[8661]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:36:42 rpi-studio nnrpd[8673]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:37:12 rpi-studio nnrpd[8683]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:37:42 rpi-studio nnrpd[8839]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:38:12 rpi-studio nnrpd[8860]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:38:42 rpi-studio nnrpd[8870]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:39:12 rpi-studio nnrpd[8879]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 14 04:39:42 rpi-studio nnrpd[8887]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 19041 74.2%2.2 MB 66.9%
inn 2688 10.5%481.4 KB 14.3%
innd 2136 8.3%357.5 KB 10.7%
innfeed 1785 7.0%271.7 KB 8.1%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 25652 100.0%3.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12265 56.1%
Negative hits 6918 31.7%
Do not exist 2668 12.2%
Cache misses 2 0.0%
TOTAL: 4 21853 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%3 1.000 1.667 2.000
article cancel00:00:00.001 0.0%5 0.000 0.200 1.000
article cleanup00:00:00.067 0.0%2671 0.000 0.025 0.250
article logging00:00:00.215 0.0%2672 0.000 0.080 0.429
article parse00:00:00.418 0.0%6622 0.000 0.063 0.200
article write00:00:01.088 0.0%2205 0.000 0.493 1.500
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
data move00:00:00.122 0.0%24593 0.000 0.005 0.039
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
hisgrep/perl00:00:00.001 0.0%5 0.000 0.200 1.000
hishave/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.354 0.0%21878 0.000 0.016 0.060
history sync00:00:00.072 0.0%415 0.000 0.173 1.000
history write00:00:00.472 0.0%2670 0.000 0.177 0.625
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:50:34.883100.0%31820 965.807 2697.514 9841.836
nntp read00:00:00.757 0.0%25350 0.000 0.030 0.098
overview write00:00:00.670 0.0%2205 0.000 0.304 3.200
perl filter00:00:09.385 0.0%2670 1.750 3.515 9.000
python filter00:00:00.024 0.0%2670 0.000 0.009 0.400
site send00:00:00.934 0.0%4488 0.000 0.208 0.600
TOTAL: 23:51:04.59223:50:49.470100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%2293 0.000 0.008 0.125
article prepare00:00:00.000 0.0%440 0.000 0.000 0.000
article read00:00:00.029 0.0%104 0.000 0.279 4.000
backlog stats00:00:00.143 0.0%30372 0.000 0.005 0.029
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.443 0.0%16415 0.000 0.027 0.143
data write00:00:00.850 0.0%14621 0.000 0.058 0.130
idle23:59:33.846100.0%30372 1316.568 2843.864 9115.606
status file00:00:00.626 0.0%229 0.000 2.734 24.400
TOTAL: 23:59:39.28023:59:35.955100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:04.025 31.8%10050 7.500 18.311 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.784 0.1%20438 0.000 0.038 0.500
TOTAL: 00:09:39.57400:03:04.809 31.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 2633 832 1390 411 31%23:47:08
2feed-out.gegeweb.org 2 2223 612 1611 0 27%23:59:24
3gegeweb-out.news.tnetconsulting.net 2 1168 243 898 27 20%19:10:59
4i2pn.org 1 2096 158 1933 5 7%23:59:58
5nntp.terraraq.uk 4 2889 143 2741 5 4%42:58:22
6news.glou.org 2 2768 43 2697 28 1%38:37:38
7usenet.pasdenom.info 5 167 1 166 0 0%06:17:50
8news.samoylyk.net 1 8 0 8 0 0%00:08:51
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 44 13952 2032 11444 476 14%179:00:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.4 MB0.0 KB3.3 MB7.8 MB 57%6.4 KB
2feed-out.gegeweb.org1.8 MB0.0 KB0.0 KB1.8 MB100%3.1 KB
3gegeweb-out.news.tnetconsulting.net758.6 KB0.0 KB115.2 KB873.8 KB 86%3.2 KB
4nntp.terraraq.uk491.8 KB0.0 KB18.1 KB509.9 KB 96%3.4 KB
5i2pn.org377.8 KB0.0 KB9.7 KB387.4 KB 97%2.4 KB
6news.glou.org149.5 KB0.0 KB88.0 KB237.5 KB 62%3.3 KB
7usenet.pasdenom.info1.1 KB0.0 KB0.0 KB1.1 KB100%1.1 KB
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.0 MB0.0 KB3.6 MB11.6 MB 69%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 14 04:15:01 - 04:59:59 30 1.4% 0.01103.4 KB 1.1% 0.04
Mar 14 05:00:00 - 05:59:59 35 1.6% 0.01184.2 KB 2.0% 0.05
Mar 14 06:00:00 - 06:59:59 36 1.6% 0.01141.1 KB 1.6% 0.04
Mar 14 07:00:00 - 07:59:59 41 1.9% 0.01163.2 KB 1.8% 0.05
Mar 14 08:00:00 - 08:59:59 67 3.0% 0.02231.2 KB 2.6% 0.06
Mar 14 09:00:00 - 09:59:59 46 2.1% 0.01167.4 KB 1.9% 0.05
Mar 14 10:00:00 - 10:59:59 72 3.3% 0.02332.5 KB 3.7% 0.09
Mar 14 11:00:00 - 11:59:59 89 4.0% 0.02299.6 KB 3.3% 0.08
Mar 14 12:00:00 - 12:59:59 93 4.2% 0.03327.8 KB 3.6% 0.09
Mar 14 13:00:00 - 13:59:59 78 3.5% 0.02278.7 KB 3.1% 0.08
Mar 14 14:00:00 - 14:59:59 170 7.7% 0.05703.3 KB 7.8% 0.20
Mar 14 15:00:00 - 15:59:59 149 6.7% 0.04488.8 KB 5.4% 0.14
Mar 14 16:00:00 - 16:59:59 170 7.7% 0.05705.0 KB 7.8% 0.20
Mar 14 17:00:00 - 17:59:59 110 5.0% 0.03422.3 KB 4.7% 0.12
Mar 14 18:00:00 - 18:59:59 120 5.4% 0.03416.7 KB 4.6% 0.12
Mar 14 19:00:00 - 19:59:59 153 6.9% 0.04594.0 KB 6.6% 0.17
Mar 14 20:00:00 - 20:59:59 114 5.2% 0.03359.1 KB 4.0% 0.10
Mar 14 21:00:00 - 21:59:59 103 4.7% 0.031003.5 KB 11.1% 0.28
Mar 14 22:00:00 - 22:59:59 127 5.7% 0.04608.0 KB 6.7% 0.17
Mar 14 23:00:00 - 23:59:59 110 5.0% 0.03406.6 KB 4.5% 0.11
Mar 15 00:00:00 - 00:59:59 74 3.3% 0.02240.6 KB 2.7% 0.07
Mar 15 01:00:00 - 01:59:59 65 2.9% 0.02213.8 KB 2.4% 0.06
Mar 15 02:00:00 - 02:59:59 106 4.8% 0.03370.1 KB 4.1% 0.10
Mar 15 03:00:00 - 03:59:59 42 1.9% 0.01209.1 KB 2.3% 0.06
Mar 15 04:00:00 - 04:15:02 12 0.5% 0.0151.2 KB 0.6% 0.06
TOTAL: 24:00:01 2212 100.0% 0.038.8 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 412 267 0 0 0 0 0 0 145
2gegeweb-out.news.tnetconsulting.net 25 0 0 0 0 0 0 0 25
3news.glou.org 17 0 0 0 0 0 0 0 17
4i2pn.org 7 0 0 0 0 0 0 0 7
5nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
6usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
7news.samoylyk.net 1 0 0 1 0 0 0 0 0
TOTAL: 7 468 267 0 1 0 0 0 0 200

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 189
linux.kernel.git 77
news.test 1
TOTAL: 3 267

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 97
Bad path (news.giganews.com.POSTED) 63
EMP (md5) 37
Cancels abusifs 2
TOTAL: 4 199

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3200 17 2040 20 0 37 0%23:59:24
2news.tnetconsulting.net 3316 12 2176 21 0 33 0%23:58:45
3news.gegeweb.org 1723 9 1596 0 0 0 0%23:59:29
4news.samoylyk.net 2846 5 2050 25 0 11 0%23:59:37
5news.pasdenom.info 1588 1 1501 0 0 0 0%23:51:40
6news.nntp4.net 1398 0 1352 0 0 0 0%23:44:05
7news.aioe.org 0 0 0 0 0 1831 0%24:00:00
8nntp.terraraq.uk 1209 0 1167 0 0 0 0%23:46:43
TOTAL: 8 15280 44 11882 66 0 1912 0%191:19:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net48.2 KB109.9 KB158.0 KB0.0 KB/s4.8 KB23:58:45
2i2pn.org47.3 KB111.3 KB158.6 KB0.0 KB/s4.3 KB23:59:24
3news.gegeweb.org25.4 KB0.0 KB25.4 KB0.0 KB/s2.8 KB23:59:29
4news.samoylyk.net23.0 KB105.3 KB128.3 KB0.0 KB/s4.3 KB23:59:37
5news.pasdenom.info1.5 KB0.0 KB1.5 KB0.0 KB/s1.5 KB23:51:40
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:44:05
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:46:43
TOTAL: 8145.4 KB326.5 KB471.9 KB0.0 KB/s4.3 KB191:19:43
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1147.45.112.182 1 00.0 KB 0 0 000:00:00
2206.168.34.60 1 00.0 KB 0 0 000:00:30
3205.210.31.21 1 00.0 KB 0 0 000:00:10
4185.232.67.44 1 00.0 KB 0 0 000:00:01
5147.45.112.185 1 00.0 KB 0 0 000:00:01
62001:41d0:a:280::12866 00.0 KB 0 0 000:03:27
7205.210.31.32 1 00.0 KB 0 0 000:00:10
8206.168.34.210 1 00.0 KB 0 0 000:00:31
9206.168.34.125 1 00.0 KB 0 0 000:00:36
10147.185.133.136 1 00.0 KB 0 0 000:00:12
11206.168.34.49 1 00.0 KB 0 0 000:00:32
12161.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
13206.168.34.50 1 00.0 KB 0 0 000:00:32
14mail.gegeweb.eu 288 00.0 KB 0 0 000:01:26
15edinburgh.scan.bufferover.run 2 00.0 KB 0 0 000:00:02
16206.168.34.88 1 00.0 KB 0 0 000:00:42
1745.135.194.21 1 00.0 KB 0 0 000:00:00
18198.235.24.248 1 00.0 KB 0 0 000:00:00
19206.168.34.220 1 00.0 KB 0 0 000:00:34
TOTAL: 193172 00.0 KB 0 0 000:09:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:26
2*.scan.bufferover.run 2 00.0 KB 0 0 000:00:02
3unresolved 15 00.0 KB 0 0 000:04:37
4*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
5?2866 00.0 KB 0 0 000:03:27
TOTAL: 53172 00.0 KB 0 0 000:09:35

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.107 51.186 0.00000:03:27
mail.gegeweb.eu 4.888 4.115 1.82800:01:26
206.168.34.88 0.038 0.018 0.00000:00:42
206.168.34.125 0.037 0.025 0.00000:00:36
206.168.34.220 0.012 0.015 0.00000:00:34
206.168.34.49 0.037 0.020 0.00000:00:32
206.168.34.50 0.043 0.023 0.00000:00:32
206.168.34.210 0.034 0.030 0.00000:00:31
206.168.34.60 0.016 0.012 0.00000:00:30
147.185.133.136 0.067 0.025 0.00000:00:12
205.210.31.21 0.023 0.029 0.00000:00:10
205.210.31.32 0.027 0.019 0.00000:00:10
edinburgh.scan.bufferover.run 0.030 0.015 0.00000:00:02
185.232.67.44 0.030 0.022 0.00000:00:01
147.45.112.185 0.043 0.019 0.00000:00:01
161.150.216.162.bc.googleusercontent.com 0.029 0.011 0.00000:00:01
147.45.112.182 0.009 0.014 0.00000:00:00
45.135.194.21 0.024 0.024 0.00000:00:00
198.235.24.248 0.031 0.020 0.00000:00:00
TOTAL: 19 68.525 55.642 1.82800:09:35

NNRP unrecognized commands (by host):

SystemConn
edinburgh.scan.bufferover.run 10
147.185.133.136 4
161.150.216.162.bc.googleusercontent.com 4
185.232.67.44 1
147.45.112.182 1
TOTAL: 5 20

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Expanse, a Palo Alto Network... 2
À$À(À#À' 2
#026#003#001#001 2
Accept-Encoding: gzip 2
Host: 45.13.105.36:563 2
#003 2
#001 2
GET / HTTP/1.1 2
À#024 2
ÇpŠMýE-É#002-¿æ#031l9 1
#003#004#003#003#003#002#003#001#003 1
TOTAL: 11 20

NNRP client timeouts [Top 20]:

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