Daily Usenet report for news.niel.me

Apr 6 04:15:02 -- Apr 7 04:15:01

Unknown entries from news log file:

First 50 / 288 lines (17.4%)

Apr 6 04:16:15 rpi-studio nnrpd[1727]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:21:15 rpi-studio nnrpd[1860]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:26:16 rpi-studio nnrpd[2097]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:31:16 rpi-studio nnrpd[2213]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:36:16 rpi-studio nnrpd[2467]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:41:16 rpi-studio nnrpd[2582]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:46:16 rpi-studio nnrpd[2839]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:51:16 rpi-studio nnrpd[2937]: rasp.pasdenom.info noperm ihave without permission
Apr 6 04:56:16 rpi-studio nnrpd[3217]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:01:16 rpi-studio nnrpd[3324]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:06:16 rpi-studio nnrpd[3588]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:11:16 rpi-studio nnrpd[3690]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:16:16 rpi-studio nnrpd[3968]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:21:16 rpi-studio nnrpd[4086]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:26:16 rpi-studio nnrpd[4346]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:31:16 rpi-studio nnrpd[4450]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:36:16 rpi-studio nnrpd[4715]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:41:16 rpi-studio nnrpd[4830]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:46:16 rpi-studio nnrpd[5081]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:51:16 rpi-studio nnrpd[5209]: rasp.pasdenom.info noperm ihave without permission
Apr 6 05:56:16 rpi-studio nnrpd[5451]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:01:16 rpi-studio nnrpd[5590]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:06:16 rpi-studio nnrpd[5852]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:11:16 rpi-studio nnrpd[5970]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:15:08 rpi-studio nnrpd[6203]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:20:08 rpi-studio nnrpd[6332]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:25:08 rpi-studio nnrpd[6592]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:30:08 rpi-studio nnrpd[6707]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:35:09 rpi-studio nnrpd[6966]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:40:09 rpi-studio nnrpd[7070]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:45:09 rpi-studio nnrpd[7369]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:50:09 rpi-studio nnrpd[7513]: rasp.pasdenom.info noperm ihave without permission
Apr 6 06:55:09 rpi-studio nnrpd[7763]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:00:09 rpi-studio nnrpd[7865]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:05:09 rpi-studio nnrpd[8140]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:10:09 rpi-studio nnrpd[8244]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:15:09 rpi-studio nnrpd[8495]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:20:09 rpi-studio nnrpd[8618]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:25:09 rpi-studio nnrpd[8879]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:30:09 rpi-studio nnrpd[8987]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:35:09 rpi-studio nnrpd[9228]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:40:09 rpi-studio nnrpd[9341]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:45:09 rpi-studio nnrpd[9589]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:50:09 rpi-studio nnrpd[9695]: rasp.pasdenom.info noperm ihave without permission
Apr 6 07:55:09 rpi-studio nnrpd[9940]: rasp.pasdenom.info noperm ihave without permission
Apr 6 08:00:09 rpi-studio nnrpd[10107]: rasp.pasdenom.info noperm ihave without permission
Apr 6 08:05:09 rpi-studio nnrpd[10375]: rasp.pasdenom.info noperm ihave without permission
Apr 6 08:10:09 rpi-studio nnrpd[10489]: rasp.pasdenom.info noperm ihave without permission
Apr 6 08:15:09 rpi-studio nnrpd[10739]: rasp.pasdenom.info noperm ihave without permission
Apr 6 08:20:09 rpi-studio nnrpd[10860]: rasp.pasdenom.info noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 3171 34.0%356.8 KB 25.4%
inn 2391 25.6%444.5 KB 31.7%
innd 1943 20.8%334.4 KB 23.8%
innfeed 1818 19.5%267.0 KB 19.0%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 9325 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11025 54.7%
Negative hits 6683 33.1%
Do not exist 2385 11.8%
Cache misses 70 0.3%
TOTAL: 4 20163 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%1 1.000 1.000 1.000
article cancel00:00:00.000 0.0%1 0.000 0.000 0.000
article cleanup00:00:00.054 0.0%2389 0.000 0.023 0.500
article logging00:00:00.184 0.0%2391 0.000 0.077 0.500
article parse00:00:00.332 0.0%5816 0.000 0.057 0.250
article write00:00:01.044 0.0%2163 0.000 0.483 1.500
artlog/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.110 0.0%21455 0.000 0.005 0.034
hisgrep/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%1 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%1 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.310 0.0%20192 0.000 0.015 0.045
history sync00:00:00.051 0.0%362 0.000 0.141 1.000
history write00:00:00.376 0.0%2389 0.000 0.157 0.722
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:38.902100.0%24096 1096.960 3587.272 27301.773
nntp read00:00:00.652 0.0%22734 0.000 0.029 0.333
overview write00:00:00.677 0.0%2163 0.000 0.313 2.545
perl filter00:00:11.674 0.0%2389 2.194 4.887 22.500
python filter00:00:00.015 0.0%2389 0.000 0.006 0.100
site send00:00:00.789 0.0%4388 0.000 0.180 0.450
TOTAL: 24:01:04.36224:00:55.171100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%3418 0.000 0.008 0.125
article prepare00:00:00.001 0.0%308 0.000 0.003 0.250
article read00:00:00.015 0.0%71 0.000 0.211 1.000
backlog stats00:00:00.163 0.0%28782 0.000 0.006 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.435 0.0%15289 0.000 0.028 0.091
data write00:00:00.715 0.0%13316 0.000 0.054 0.111
idle23:59:46.258100.0%28782 789.393 3001.399 8238.918
status file00:00:05.351 0.0%261 1.000 20.502 85.000
TOTAL: 23:59:56.49523:59:52.966100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:35.744 36.2%2888 0.000 74.704 9229.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.269 0.0%7167 0.000 0.038 0.500
readart00:00:00.081 0.0%500 0.000 0.162 0.174
TOTAL: 00:09:55.31700:03:36.094 36.3%----

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 1976 796 1041 139 40%19:32:23
2feed-out.gegeweb.org 3 2170 444 1726 0 20%23:58:49
3gegeweb-out.news.tnetconsulting.net 1 1479 388 1069 22 26%23:13:48
4news.samoylyk.net 6 2030 284 1745 1 13%24:53:49
5i2pn.org 2 2791 206 2584 1 7%32:43:26
6nntp.terraraq.uk 5 2625 131 2489 5 4%41:49:53
7news.glou.org 2 1568 88 1474 6 5%23:15:03
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 47 14639 2337 12128 174 15%189:27:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.1 MB0.0 KB645.1 KB4.7 MB 86%5.2 KB
2news.samoylyk.net2.2 MB0.0 KB17.3 KB2.2 MB 99%8.1 KB
3gegeweb-out.news.tnetconsulting.net1.3 MB0.0 KB82.2 KB1.4 MB 94%3.4 KB
4feed-out.gegeweb.org1.2 MB0.0 KB0.0 KB1.2 MB100%2.8 KB
5nntp.terraraq.uk686.7 KB0.0 KB11.5 KB698.3 KB 98%5.1 KB
6i2pn.org518.6 KB0.0 KB1.6 KB520.2 KB 99%2.5 KB
7news.glou.org323.9 KB0.0 KB12.0 KB335.9 KB 96%3.6 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 810.3 MB0.0 KB769.7 KB11.1 MB 93%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 6 04:15:02 - 04:59:59 47 2.2% 0.02192.5 KB 2.0% 0.07
Apr 6 05:00:00 - 05:59:59 55 2.5% 0.02229.1 KB 2.4% 0.06
Apr 6 06:00:00 - 06:59:59 26 1.2% 0.0196.0 KB 1.0% 0.03
Apr 6 07:00:00 - 07:59:59 58 2.7% 0.02266.9 KB 2.8% 0.07
Apr 6 08:00:00 - 08:59:59 64 3.0% 0.02301.0 KB 3.1% 0.08
Apr 6 09:00:00 - 09:59:59 65 3.0% 0.02217.3 KB 2.3% 0.06
Apr 6 10:00:00 - 10:59:59 95 4.4% 0.03503.9 KB 5.2% 0.14
Apr 6 11:00:00 - 11:59:59 89 4.1% 0.02679.0 KB 7.0% 0.19
Apr 6 12:00:00 - 12:59:59 90 4.2% 0.03272.2 KB 2.8% 0.08
Apr 6 13:00:00 - 13:59:59 87 4.0% 0.02421.8 KB 4.4% 0.12
Apr 6 14:00:00 - 14:59:59 95 4.4% 0.03406.9 KB 4.2% 0.11
Apr 6 15:00:00 - 15:59:59 120 5.6% 0.03599.6 KB 6.2% 0.17
Apr 6 16:00:00 - 16:59:59 121 5.6% 0.03486.0 KB 5.0% 0.13
Apr 6 17:00:00 - 17:59:59 139 6.4% 0.04866.9 KB 9.0% 0.24
Apr 6 18:00:00 - 18:59:59 159 7.4% 0.04757.5 KB 7.9% 0.21
Apr 6 19:00:00 - 19:59:59 120 5.6% 0.03418.9 KB 4.3% 0.12
Apr 6 20:00:00 - 20:59:59 116 5.4% 0.03576.4 KB 6.0% 0.16
Apr 6 21:00:00 - 21:59:59 136 6.3% 0.04665.8 KB 6.9% 0.18
Apr 6 22:00:00 - 22:59:59 120 5.6% 0.03405.3 KB 4.2% 0.11
Apr 6 23:00:00 - 23:59:59 75 3.5% 0.02324.4 KB 3.4% 0.09
Apr 7 00:00:00 - 00:59:59 87 4.0% 0.02271.5 KB 2.8% 0.08
Apr 7 01:00:00 - 01:59:59 77 3.6% 0.02314.6 KB 3.3% 0.09
Apr 7 02:00:00 - 02:59:59 66 3.1% 0.02206.1 KB 2.1% 0.06
Apr 7 03:00:00 - 03:59:59 40 1.9% 0.01114.2 KB 1.2% 0.03
Apr 7 04:00:00 - 04:15:01 14 0.6% 0.0237.4 KB 0.4% 0.04
TOTAL: 23:59:59 2161 100.0% 0.039.4 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 171 59 0 0 0 0 0 0 112
2gegeweb-out.news.tnetconsulting.net 39 0 0 0 0 0 0 0 39
3news.glou.org 8 0 0 0 0 0 0 0 8
4nntp.terraraq.uk 7 0 0 0 0 0 0 0 7
5news.samoylyk.net 1 0 0 0 0 0 0 0 1
6feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
7i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 228 59 0 0 0 0 0 0 169

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 32
linux.kernel.git 26
news.test 1
TOTAL: 3 59

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 94
Bad path (news.giganews.com.POSTED) 72
HTML Multipart 1
TOTAL: 3 167

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
nntp.terraraq.uk 1
TOTAL: 2 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3116 34 2010 1 0 25 1%23:59:16
2news.gegeweb.org 1866 16 1721 0 0 0 0%23:58:04
3news.tnetconsulting.net 3275 6 2132 15 0 30 0%23:59:17
4news.nntp4.net 1320 5 1236 0 0 0 0%23:58:33
5nntp.terraraq.uk 1211 0 1131 0 0 1 0%23:49:22
6news.pasdenom.info 1608 0 1525 0 0 0 0%23:56:38
7news.aioe.org 0 0 0 0 0 1883 0%23:59:59
8news.samoylyk.net 2145 0 1984 0 0 1199 0%23:57:08
TOTAL: 8 14541 61 11739 16 0 3138 0%191:38:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org185.9 KB4.7 KB190.6 KB0.0 KB/s5.4 KB23:59:16
2news.gegeweb.org36.4 KB0.0 KB36.4 KB0.0 KB/s2.3 KB23:58:04
3news.nntp4.net29.2 KB0.0 KB29.2 KB0.0 KB/s5.8 KB23:58:33
4news.tnetconsulting.net16.4 KB113.8 KB130.3 KB0.0 KB/s6.2 KB23:59:17
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:22
6news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:38
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:08
TOTAL: 8267.9 KB118.5 KB386.4 KB0.0 KB/s5.0 KB191:38:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 26 500346.7 KB 3 0 000:02:52
TOTAL: 1 26 500346.7 KB 3 0 000:09:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 26 500346.7 KB 3 0 000:02:52
2unresolved 19 00.0 KB 0 0 000:04:48
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:37
4*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6*.pasdenom.info 288 00.0 KB 0 0 000:00:18
7? 7 00.0 KB 0 0 000:00:13
TOTAL: 7 630 500346.7 KB 3 0 000:09:54

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.573 0.703 0.00000:02:52
mail.gegeweb.eu 4.851 4.256 1.89600:01:37
206.168.34.42 0.051 0.035 0.00000:01:03
206.168.34.195 0.033 0.031 0.00000:00:39
206.168.34.58 0.016 0.016 0.00000:00:34
206.168.34.74 0.035 0.030 0.00000:00:32
206.168.34.197 0.020 0.010 0.00000:00:31
206.168.34.43 0.027 0.013 0.00000:00:31
112.115.155.115 0.008 0.017 0.00000:00:28
rasp.pasdenom.info 6.516 5.252 0.00000:00:18
20.29.36.72 0.029 0.021 0.00000:00:09
2a06:4882:1000::2 0.034 0.007 0.00000:00:04
205.210.31.151 0.033 0.017 0.00000:00:03
58.59.233.159 0.016 0.010 0.00000:00:03
2a06:4882:1000::f 0.037 0.016 0.00000:00:03
2a06:4883:b000::cc 0.016 0.009 0.00000:00:03
101.67.138.234 0.034 0.019 0.00000:00:02
198.235.24.239 0.024 0.028 0.00000:00:02
2a06:4883:b000::d5 0.018 0.004 0.00000:00:01
effusive.monitoring.internet-measurement.com 0.026 0.022 0.00000:00:01
TOTAL: 30 12.733 10.707 1.89600:09:54

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
rasp.pasdenom.info 288
206.168.34.42 2
2a06:4882:1000::2 1
58.59.233.159 1
206.168.34.43 1
98.149.216.162.bc.googleusercontent.com 1
effusive.monitoring.internet-measurement.com 1
198.235.24.239 1
2a06:4882:b000::cd 1
2a06:4883:b000::cc 1
2a06:4883:b000::d5 1
20.29.36.72 1
88.214.25.123 1
206.168.34.195 1
194.165.16.163 1
124.31.105.255 1
206.168.34.197 1
147.185.132.227 1
2a06:4882:b000::d1 1
TOTAL: 29 604

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2a06:4883:b000::cc 6
147.185.132.227 4
98.149.216.162.bc.googleusercontent.com 4
124.31.105.255 3
123.245.84.31 3
88.214.25.123 1
91.238.181.94 1
58.59.233.159 1
TOTAL: 8 23

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept-Encoding: gzip 3
Host: 45.13.105.36:563 2
User-Agent: Expanse, a Palo Alto Network... 2
Accept: */* 2
#003 2
#026#003#001 1
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 1
Connection: close 1
#023#001#023#002#023#003#001 1
Host: 45.13.105.36:119 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
À#024 1
USER anonymous 1
TOTAL: 14 23

NNRP client timeouts [Top 20]:

SystemConnPeer
88.214.25.123 1 1
91.238.181.94 1 1
TOTAL: 2 2 4

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 500100.0%
TOTAL: 1 500100.0%

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

NewsgroupCount
1grisbi.test 500
TOTAL: 1 500