Daily Usenet report

Jul 13 03:00:05 -- Jul 14 03:00:05

Unknown entries from news log file:

First 50 / 19456 lines (0.3%)

Jul 13 03:00:31 twilightnode nnrpd[78059]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:00:31 twilightnode nnrpd[78059]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 res <anonymous>
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 no_post anonymous-read
Jul 13 03:00:31 twilightnode nnrpd[78059]: 81.2.118.99 noperm ihave without permission
Jul 13 03:01:11 twilightnode nnrpd[78085]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:01:11 twilightnode nnrpd[78085]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 res <anonymous>
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 no_post anonymous-read
Jul 13 03:01:11 twilightnode nnrpd[78085]: 81.2.118.99 noperm ihave without permission
Jul 13 03:01:18 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jul 13 03:01:52 twilightnode nnrpd[78140]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:01:52 twilightnode nnrpd[78140]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 res <anonymous>
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 no_post anonymous-read
Jul 13 03:01:52 twilightnode nnrpd[78140]: 81.2.118.99 noperm ihave without permission
Jul 13 03:02:32 twilightnode nnrpd[78287]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:02:32 twilightnode nnrpd[78287]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 res <anonymous>
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 no_post anonymous-read
Jul 13 03:02:32 twilightnode nnrpd[78287]: 81.2.118.99 noperm ihave without permission
Jul 13 03:03:12 twilightnode nnrpd[78289]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:03:12 twilightnode nnrpd[78289]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 res <anonymous>
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 no_post anonymous-read
Jul 13 03:03:12 twilightnode nnrpd[78289]: 81.2.118.99 noperm ihave without permission
Jul 13 03:03:52 twilightnode nnrpd[78295]: Reading access from /usr/local/news/etc/readers.conf
Jul 13 03:03:52 twilightnode nnrpd[78295]: Auth strategy 'localhost' does not match client. Removing.
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 res <anonymous>
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 no_match_user <anonymous> <localhost>
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 match_user <anonymous> <anonymous>
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 no_post anonymous-read
Jul 13 03:03:52 twilightnode nnrpd[78295]: 81.2.118.99 noperm ihave without permission
Jul 13 03:04:32 twilightnode nnrpd[78302]: Reading access from /usr/local/news/etc/readers.conf

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 28013 76.0%2.7 MB 68.5%
inn 6373 17.3%958.2 KB 23.7%
innfeed 1303 3.5%155.8 KB 3.9%
innd 1184 3.2%159.9 KB 4.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 36874 100.0%4.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11775 33.8%
Cache misses 9520 27.3%
Negative hits 7231 20.8%
Do not exist 6321 18.1%
TOTAL: 4 34847 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.007 0.0%2 1.000 3.500 6.000
article cleanup00:00:00.061 0.0%6347 0.000 0.010 0.167
article logging00:00:00.200 0.0%6362 0.000 0.031 0.167
article parse00:00:00.109 0.0%9910 0.000 0.011 0.077
article write00:00:03.674 0.0%4364 0.474 0.842 2.167
data move00:00:00.105 0.0%28541 0.000 0.004 0.042
hisgrep/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.445 0.0%34939 0.049 0.156 3.943
history sync00:00:00.062 0.0%420 0.000 0.148 1.000
history write00:00:03.104 0.0%6347 0.100 0.489 1.107
idle24:00:29.983100.0%32498 295.661 2659.548 9836.131
nntp read00:00:00.619 0.0%27292 0.000 0.023 0.165
overview write00:00:02.173 0.0%4364 0.200 0.498 2.895
perl filter00:00:10.613 0.0%6347 1.000 1.672 21.833
python filter00:00:00.883 0.0%6347 0.000 0.139 1.167
site send00:00:00.088 0.0%4357 0.000 0.020 0.167
TOTAL: 1724:00:57.127100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%95170 0.000 0.000 0.158
article prepare00:00:00.000 0.0%18820 0.000 0.000 0.000
article read00:00:01.617 0.0%4565 0.000 0.354 3.000
backlog stats00:00:00.040 0.0%82357 0.000 0.000 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.447 0.0%50579 0.000 0.009 0.048
data write00:00:00.607 0.0%46026 0.000 0.013 0.094
idle23:56:35.990 99.8%82357 15.139 1046.614 8572.043
status file00:00:00.138 0.0%264 0.000 0.523 10.000
TOTAL: 923:56:38.884 99.8%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:21:08.996100.0%7282 29.667 1657.374 10047.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.258 0.0%14663 0.000 0.018 0.833
TOTAL: 303:21:09.254100.0%----

Control commands to innd:

CommandNumber
flush 2
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 166

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 2 9631 3764 4667 1200 39%43:18:26
2newsfeed.endofthelinebbs.com 1 4802 347 3835 620 7%23:16:32
3news.sklaffkom.se 48 89 33 20 36 37%11:05:57
4news.tebibyte.org 2 3596 13 3559 24 0%00:01:00
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 78 18118 4157 12081 1880 22%77:41:55
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net11.7 MB0.0 KB3.7 MB15.5 MB 75%3.2 KB
2newsfeed.endofthelinebbs.com3.8 MB0.0 KB5.7 MB9.5 MB 40%10.1 KB
3news.sklaffkom.se71.9 KB0.0 KB98.2 KB170.1 KB 42%2.5 KB
4news.tebibyte.org34.2 KB0.0 KB54.1 KB88.3 KB 38%2.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 515.7 MB0.0 KB9.6 MB25.2 MB 62%4.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 13 03:00:05 - 03:59:59 86 2.0% 0.02395.4 KB 2.4% 0.11
Jul 13 04:00:00 - 04:59:59 81 1.9% 0.02307.4 KB 1.8% 0.09
Jul 13 05:00:00 - 05:59:59 94 2.2% 0.03410.4 KB 2.4% 0.11
Jul 13 06:00:00 - 06:59:59 147 3.4% 0.04485.3 KB 2.9% 0.13
Jul 13 07:00:00 - 07:59:59 150 3.4% 0.04465.2 KB 2.8% 0.13
Jul 13 08:00:00 - 08:59:59 240 5.5% 0.07954.4 KB 5.7% 0.27
Jul 13 09:00:00 - 09:59:59 213 4.9% 0.06563.4 KB 3.4% 0.16
Jul 13 10:00:00 - 10:59:59 223 5.1% 0.06629.3 KB 3.8% 0.17
Jul 13 11:00:00 - 11:59:59 223 5.1% 0.06797.0 KB 4.8% 0.22
Jul 13 12:00:00 - 12:59:59 212 4.9% 0.06800.4 KB 4.8% 0.22
Jul 13 13:00:00 - 13:59:59 223 5.1% 0.06756.2 KB 4.5% 0.21
Jul 13 14:00:00 - 14:59:59 201 4.6% 0.06720.5 KB 4.3% 0.20
Jul 13 15:00:00 - 15:59:59 249 5.7% 0.071.0 MB 6.3% 0.29
Jul 13 16:00:00 - 16:59:59 296 6.8% 0.081.2 MB 7.1% 0.33
Jul 13 17:00:00 - 17:59:59 233 5.3% 0.061.0 MB 6.1% 0.29
Jul 13 18:00:00 - 18:59:59 223 5.1% 0.061.1 MB 6.5% 0.30
Jul 13 19:00:00 - 19:59:59 205 4.7% 0.061022.2 KB 6.1% 0.28
Jul 13 20:00:00 - 20:59:59 192 4.4% 0.05552.1 KB 3.3% 0.15
Jul 13 21:00:00 - 21:59:59 155 3.6% 0.04450.0 KB 2.7% 0.12
Jul 13 22:00:00 - 22:59:59 182 4.2% 0.05753.4 KB 4.5% 0.21
Jul 13 23:00:00 - 23:59:59 164 3.8% 0.051.1 MB 7.0% 0.33
Jul 14 00:00:00 - 00:59:59 146 3.3% 0.04491.5 KB 2.9% 0.14
Jul 14 01:00:00 - 01:59:59 87 2.0% 0.02230.3 KB 1.4% 0.06
Jul 14 02:00:00 - 02:59:59 129 3.0% 0.04428.3 KB 2.6% 0.12
Jul 14 03:00:00 - 03:00:05 10 0.2% 2.0012.8 KB 0.1% 2.55
TOTAL: 24:00:00 4364 100.0% 0.0516.4 MB 100.0% 0.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1263 1173 0 0 0 0 0 0 90
2newsfeed.endofthelinebbs.com 643 327 0 0 0 0 0 0 316
3news.tebibyte.org 66 62 0 0 0 0 0 0 4
4news.sklaffkom.se 37 34 0 0 0 0 0 0 3
TOTAL: 4 2009 1596 0 0 0 0 0 0 413

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.stories.pedo 67
de.etc.finanz.banken+broker 50
alt.usage.english 44
fido7.ru.fidonet.today 38
de.etc.haushalt 35
fido7.ukrnews 33
alt.bestjobsusa.computer.jobs 32
alt.sex.pedophilia.gir 31
de.comp.hardware.netzwerke.misc 30
eternal-september.test 30
uk.legal.moderated 30
alt.sex.ped 29
linux.debian.maint.ocaml.maint 27
alt.checkmate 26
linux.debian.devel 26
it.hobby.cucina 25
it.discussioni.auto 22
pl.pregierz 22
hfx.general 21
alt.sex.prevost 20
TOTAL: 267 1596

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 320
EMP (phl) 56
User-issued cancel 8
HTML Multipart 5
Too many newsgroups 5
Too many newsgroups (meow) 4
TOTAL: 6 398

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 14
news.sklaffkom.se 1
TOTAL: 2 15
TOTAL: 1 15

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1sklaffkom.se 5054 678 2361 1318 0 2 13%23:58:53
2news.tebibyte.org 92097 482 89020 2172 0 3321 0%23:59:58
3newsfeed.endofthelinebbs.com 7637 21 3910 40 0 184 0%23:58:11
4weretis.net 470 0 467 0 0 0 0%20:14:42
TOTAL: 4 105258 1181 95758 3530 0 3507 1%92:11:44
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org1.1 MB29.7 MB30.7 MB0.4 KB/s11.9 KB23:59:58
2sklaffkom.se1.1 MB7.5 MB8.6 MB0.1 KB/s4.4 KB23:58:53
3newsfeed.endofthelinebbs.com51.9 KB200.6 KB252.4 KB0.0 KB/s4.1 KB23:58:11
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s020:14:42
TOTAL: 42.2 MB37.4 MB39.6 MB0.1 KB/s8.6 KB92:11:44
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1mailgate.tebibyte.org1213 00.0 KB 0 0 000:02:45
281.2.118.991201 00.0 KB 0 0 003:17:39
3118.26.104.93 3 00.0 KB 0 0 000:00:12
4187.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:09
5172-236-228-38.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
6123.245.85.186 1 00.0 KB 0 0 000:00:03
7124.88.113.194 1 00.0 KB 0 0 000:00:00
8147.185.132.16 1 00.0 KB 0 0 000:00:00
9171.108.182.229 1 00.0 KB 0 0 000:00:01
10193.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
11220.197.85.172 1 00.0 KB 0 0 000:00:05
12220.202.112.77 1 00.0 KB 0 0 000:00:00
1358.212.237.162 1 00.0 KB 0 0 000:00:03
1469.5.169.79 1 00.0 KB 0 0 000:00:00
1589.21.67.169 1 00.0 KB 0 0 000:00:00
16r4-189-bd.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 162433 00.0 KB 0 0 003:21:09

NNRP connection statistics (by domain) [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1*.tebibyte.org1213 00.0 KB 0 0 000:02:45
2unresolved1213 00.0 KB 0 0 003:18:08
3*.66.censys-scanner.com 4 00.0 KB 0 0 000:00:12
4*.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 52433 00.0 KB 0 0 003:21:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
81.2.118.99 4.518 6.990 0.00003:17:39
mailgate.tebibyte.org 4.384 6.955 0.00000:02:45
118.26.104.93 0.010 0.017 0.00000:00:12
187.172.132.66.censys-scanner.com 0.040 0.017 0.00000:00:09
220.197.85.172 0.005 0.003 0.00000:00:05
123.245.85.186 0.005 0.002 0.00000:00:03
193.172.132.66.censys-scanner.com 0.023 0.012 0.00000:00:03
58.212.237.162 0.003 0.005 0.00000:00:03
r4-189-bd.monitoring.internet-measurement.com 0.004 0.003 0.00000:00:01
171.108.182.229 0.004 0.004 0.00000:00:01
172-236-228-38.ip.linodeusercontent.com 0.010 0.010 0.00000:00:00
220.202.112.77 0.002 0.005 0.00000:00:00
124.88.113.194 0.003 0.004 0.00000:00:00
147.185.132.16 0.005 0.002 0.00000:00:00
89.21.67.169 0.003 0.005 0.00000:00:00
69.5.169.79 0.005 0.004 0.00000:00:00
TOTAL: 16 9.024 14.038 0.00003:21:09

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
172-236-228-38.ip.linodeusercontent.com 8
220.202.112.77 6
58.212.237.162 5
171.108.182.229 4
123.245.85.186 3
118.26.104.93 2
187.172.132.66.censys-scanner.com 1
193.172.132.66.censys-scanner.com 1
220.197.85.172 1
TOTAL: 9 31

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
?#024 3
#001 2
#021? 2
#026#003#001#001 2
#026#003#001#005?#001 2
?#024#023#001#023#002#023#003#001 2
?$?(?#?' 2
EHLO www.censys.io 2
#010#013#006#001#006#002#006#003#005#001#005#002#005#003#004#001#004#002#004#003#003#001#003#002#003#003#002#001#002#002#002#003 1
#023k?{U#032?U?*?#022;#005#027?^mY?)f?`a?]?... 1
#026#003#001 1
#026#003#001#003S#001 1
%?G#0351?#003#027Z?c?R#016?(?Zt?@? 1
?#013?#014?#015?#016?#017?#020?#021?#022?#023?#024?#025?#026?#027?#030?#031?#032?#033?#034?#035?#036... 1
?,8?uZ<h?q?#0105?3A#024h?,^? ?}#{dX?P?#032... 1
AUTH TLS 1
Accept: */* 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
USER anonymous 1
TOTAL: 22 31

NNRP client timeouts [Top 20]:

SystemConnPeer
187.172.132.66.censys-scanner.com 1 2
220.197.85.172 1 1
220.202.112.77 1 1
69.5.169.79 1 1
TOTAL: 4 4 7
innreport from INN 2.7.3 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then