Daily Usenet report

Oct 20 03:00:05 -- Oct 21 03:00:05

Unknown entries from news log file:

First 50 / 4941 lines (1.0%)

Oct 20 03:01:17 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 20 03:01:59 twilightnode nnrpd[434488]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:01:59 twilightnode nnrpd[434488]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:01:59 twilightnode nnrpd[434488]: 174.96.78.81 res <anonymous>
Oct 20 03:01:59 twilightnode nnrpd[434488]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:01:59 twilightnode nnrpd[434488]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:01:59 twilightnode nnrpd[434488]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:01:59 twilightnode nnrpd[434488]: 174.96.78.81 no_post anonymous-read
Oct 20 03:02:00 twilightnode nnrpd[434489]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:02:00 twilightnode nnrpd[434489]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:02:00 twilightnode nnrpd[434489]: 174.96.78.81 res <anonymous>
Oct 20 03:02:00 twilightnode nnrpd[434489]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:02:00 twilightnode nnrpd[434489]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:02:00 twilightnode nnrpd[434489]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:02:00 twilightnode nnrpd[434489]: 174.96.78.81 no_post anonymous-read
Oct 20 03:31:17 twilightnode nnrpd[435880]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:31:17 twilightnode nnrpd[435880]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:31:17 twilightnode nnrpd[435880]: 174.96.78.81 res <anonymous>
Oct 20 03:31:17 twilightnode nnrpd[435880]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:31:17 twilightnode nnrpd[435880]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:31:17 twilightnode nnrpd[435880]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:31:17 twilightnode nnrpd[435880]: 174.96.78.81 no_post anonymous-read
Oct 20 03:31:17 twilightnode nnrpd[435881]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:31:17 twilightnode nnrpd[435881]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:31:17 twilightnode nnrpd[435881]: 174.96.78.81 res <anonymous>
Oct 20 03:31:17 twilightnode nnrpd[435881]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:31:17 twilightnode nnrpd[435881]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:31:17 twilightnode nnrpd[435881]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:31:17 twilightnode nnrpd[435881]: 174.96.78.81 no_post anonymous-read
Oct 20 03:31:55 twilightnode nnrpd[435888]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:31:55 twilightnode nnrpd[435888]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:31:55 twilightnode nnrpd[435888]: 174.96.78.81 res <anonymous>
Oct 20 03:31:55 twilightnode nnrpd[435888]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:31:55 twilightnode nnrpd[435888]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:31:55 twilightnode nnrpd[435888]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:31:55 twilightnode nnrpd[435888]: 174.96.78.81 no_post anonymous-read
Oct 20 03:31:55 twilightnode nnrpd[435889]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:31:55 twilightnode nnrpd[435889]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:31:55 twilightnode nnrpd[435889]: 174.96.78.81 res <anonymous>
Oct 20 03:31:55 twilightnode nnrpd[435889]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:31:55 twilightnode nnrpd[435889]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:31:55 twilightnode nnrpd[435889]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:31:55 twilightnode nnrpd[435889]: 174.96.78.81 no_post anonymous-read
Oct 20 03:34:49 twilightnode nnrpd[435914]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 03:34:49 twilightnode nnrpd[435914]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 03:34:49 twilightnode nnrpd[435914]: 174.96.78.81 res <anonymous>
Oct 20 03:34:49 twilightnode nnrpd[435914]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 03:34:49 twilightnode nnrpd[435914]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 03:34:49 twilightnode nnrpd[435914]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 03:34:49 twilightnode nnrpd[435914]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22418 64.4%2.0 MB 49.2%
inn 8132 23.4%1.4 MB 35.9%
innd 2921 8.4%397.8 KB 9.8%
innfeed 1333 3.8%209.3 KB 5.1%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 34806 100.0%4.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21561 51.4%
Negative hits 12026 28.6%
Do not exist 8063 19.2%
Cache misses 331 0.8%
TOTAL: 4 41981 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.041 0.0%15 1.000 2.733 12.000
article cleanup00:00:00.169 0.0%8101 0.000 0.021 0.083
article logging00:00:00.381 0.0%8120 0.000 0.047 0.222
article parse00:00:00.195 0.0%11466 0.000 0.017 0.200
article write00:00:09.975 0.0%6927 0.878 1.440 4.227
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.359 0.0%44000 0.000 0.008 0.056
hisgrep/artcncl00:00:00.010 0.0%15 0.000 0.667 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.850 0.0%42140 0.077 0.163 0.392
history sync00:00:00.077 0.0%401 0.000 0.192 1.000
history write00:00:04.961 0.0%8101 0.278 0.612 1.171
idle23:39:49.366 99.9%45368 870.541 1877.741 8957.687
nntp read00:00:01.322 0.0%43386 0.000 0.030 0.188
overview write00:00:07.635 0.0%6927 0.574 1.102 4.733
perl filter00:00:21.431 0.0%8101 1.163 2.645 11.765
python filter00:00:01.988 0.0%8101 0.059 0.245 1.588
site send00:00:00.535 0.0%13796 0.000 0.039 0.156
TOTAL: 1823:40:45.295100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.061 0.0%7670 0.000 0.008 0.154
article prepare00:00:00.005 0.0%28496 0.000 0.000 0.006
article read00:00:01.848 0.0%4773 0.111 0.387 1.700
backlog stats00:00:00.081 0.0%91136 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.108 0.0%51805 0.000 0.021 0.062
data write00:00:01.561 0.0%45244 0.005 0.035 0.113
idle23:37:22.273100.0%91136 256.731 933.136 4055.101
status file00:00:00.292 0.0%164 0.000 1.780 8.000
TOTAL: 923:37:27.229100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:59:27.199100.0%19214 68.000 185.656 10068.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.126 0.0%48844 0.000 0.023 1.500
readart00:00:00.411 0.0%723 0.000 0.568 2.000
TOTAL: 400:59:28.736100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 6 8460 4156 4286 18 49%36:58:02
2usenet.blueworldhosting.com 289 7975 1894 4974 1107 23%23:21:22
3news.tebibyte.org 3 2386 205 2181 0 8%11:03:12
4news.sklaffkom.se 47 177 170 7 0 96%15:25:48
5newsfeed.endofthelinebbs.com 2 2455 125 2316 14 5%13:06:31
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 372 21453 6550 13764 1139 30%99:54:55
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.4 MB0.0 KB73.1 KB13.4 MB 99%3.3 KB
2usenet.blueworldhosting.com10.7 MB0.0 KB2.1 MB12.8 MB 83%4.4 KB
3newsfeed.endofthelinebbs.com3.8 MB0.0 KB80.1 KB3.9 MB 97%28.7 KB
4news.tebibyte.org623.3 KB0.0 KB0.0 KB623.3 KB100%3.0 KB
5news.sklaffkom.se506.3 KB0.0 KB0.0 KB506.3 KB100%3.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 629.0 MB0.0 KB2.3 MB31.3 MB 92%4.2 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 03:00:05 - 03:59:59 123 1.8% 0.03669.2 KB 2.3% 0.19
Oct 20 04:00:00 - 04:59:59 144 2.1% 0.04847.2 KB 2.9% 0.24
Oct 20 05:00:00 - 05:59:59 103 1.5% 0.03735.0 KB 2.6% 0.20
Oct 20 06:00:00 - 06:59:59 110 1.6% 0.03491.7 KB 1.7% 0.14
Oct 20 07:00:00 - 07:59:59 138 2.0% 0.04558.3 KB 1.9% 0.16
Oct 20 08:00:00 - 08:59:59 177 2.6% 0.05817.2 KB 2.8% 0.23
Oct 20 09:00:00 - 09:59:59 265 3.8% 0.071.1 MB 4.0% 0.32
Oct 20 10:00:00 - 10:59:59 397 5.7% 0.111.5 MB 5.2% 0.42
Oct 20 11:00:00 - 11:59:59 272 3.9% 0.081.5 MB 5.3% 0.42
Oct 20 12:00:00 - 12:59:59 350 5.0% 0.101.7 MB 5.9% 0.47
Oct 20 13:00:00 - 13:59:59 297 4.3% 0.081.3 MB 4.6% 0.36
Oct 20 14:00:00 - 14:59:59 307 4.4% 0.091.1 MB 4.0% 0.32
Oct 20 15:00:00 - 15:59:59 429 6.2% 0.121.7 MB 6.0% 0.48
Oct 20 16:00:00 - 16:59:59 370 5.3% 0.101.1 MB 3.9% 0.31
Oct 20 17:00:00 - 17:59:59 354 5.1% 0.101.5 MB 5.2% 0.41
Oct 20 18:00:00 - 18:59:59 367 5.3% 0.101.3 MB 4.5% 0.36
Oct 20 19:00:00 - 19:59:59 417 6.0% 0.121.6 MB 5.5% 0.44
Oct 20 20:00:00 - 20:59:59 420 6.1% 0.121.5 MB 5.5% 0.44
Oct 20 21:00:00 - 21:59:59 414 6.0% 0.121.8 MB 6.4% 0.52
Oct 20 22:00:00 - 22:59:59 406 5.9% 0.111.4 MB 5.1% 0.41
Oct 20 23:00:00 - 23:59:59 383 5.5% 0.111.6 MB 5.6% 0.44
Oct 21 00:00:00 - 00:59:59 301 4.3% 0.081.1 MB 3.9% 0.31
Oct 21 01:00:00 - 01:59:59 227 3.3% 0.06783.3 KB 2.7% 0.22
Oct 21 02:00:00 - 02:59:59 164 2.4% 0.05674.3 KB 2.3% 0.19
Oct 21 03:00:00 - 03:00:05 1 0.0% 0.202.4 KB 0.0% 0.47
TOTAL: 24:00:00 6936 100.0% 0.0828.1 MB 100.0% 0.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1105 339 0 0 0 0 0 0 766
2twilightnode-out.news.weretis.net 46 16 0 0 0 0 0 0 30
3newsfeed.endofthelinebbs.com 45 4 0 0 0 0 0 0 41
TOTAL: 3 1196 359 0 0 0 0 0 0 837

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 18
hispagatos.mastodon.tag.hacking 14
alt.forsale.seattle 9
oc.forsale 6
dfw.forsale 5
hispagatos.test 3
alt.cellular.nokia 2
de.comm.technik.mobil 2
hispagatos.mastodon.tag.hackers 2
alt.autos.alfa-romeo 1
alt.bbs.files-announce 1
alt.pl.zbluzgaj 1
alt.test.9 1
atl.forsale 1
chico.forsale 1
chmurka.statystyki 1
fido.su.pol 1
harvard.forsale 1
van.forsale 1
TOTAL: 20 359

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 727
Too many newsgroups 83
User-issued cancel 5
HTML Multipart 2
TOTAL: 4 817

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 20
TOTAL: 1 20
TOTAL: 1 20

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 9957 2321 4778 159 0 48 23%23:42:30
2sklaffkom.se 7106 906 2368 3605 0 0 12%23:42:30
3newsfeed.endofthelinebbs.com 11902 77 6571 60 0 348 0%23:42:29
4usenet.blueworldhosting.com 8206 6 4843 0 0 27 0%23:42:27
5weretis.net 2617 0 2508 1 0 0 0%23:39:44
TOTAL: 5 39788 3310 21068 3825 0 423 8%118:29:40
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.3 MB1.4 MB7.7 MB0.1 KB/s3.2 KB23:42:30
2sklaffkom.se1.5 MB18.1 MB19.6 MB0.2 KB/s4.4 KB23:42:30
3newsfeed.endofthelinebbs.com231.2 KB169.2 KB400.3 KB0.0 KB/s2.9 KB23:42:29
4usenet.blueworldhosting.com12.8 KB0.0 KB12.8 KB0.0 KB/s2.1 KB23:42:27
5weretis.net0.0 KB73.0 KB73.0 KB0.0 KB/s73.0 KB23:39:44
TOTAL: 58.0 MB19.7 MB27.7 MB0.1 KB/s4.0 KB118:29:40
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 694 72327.6 MB 121 0 000:58:58
TOTAL: 1 694 72327.6 MB 121 0 000:58:58

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 701 72327.6 MB 121 0 000:59:23
2*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3*.infrawat.ch 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 5 705 72327.6 MB 121 0 000:59:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 7.120 17.506 0.00000:58:58
152.32.180.98 0.018 0.042 0.00000:00:14
20.46.255.16 0.006 0.022 0.00000:00:09
r4-232-e8.monitoring.internet-measurement.com 0.006 0.018 0.00000:00:01
197.186.132.66.censys-scanner.com 0.033 0.024 0.00000:00:01
147.185.133.195 0.008 0.011 0.00000:00:00
o018.scanner.modat.io 0.006 0.014 0.00000:00:00
31-14-254-118.infrawat.ch 0.007 0.010 0.00000:00:00
198.235.24.243 0.008 0.019 0.00000:00:00
86.38.187.171 0.010 0.023 0.00000:00:00
TOTAL: 10 7.222 17.689 0.00000:59:28

Curious NNRP explorers [Top 20]:

SystemConn
152.32.180.98 3
147.185.133.195 1
197.186.132.66.censys-scanner.com 1
198.235.24.243 1
20.46.255.16 1
31-14-254-118.infrawat.ch 1
86.38.187.171 1
o018.scanner.modat.io 1
r4-232-e8.monitoring.internet-measurement.com 1
TOTAL: 9 11

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

SystemConn
152.32.180.98 2
197.186.132.66.censys-scanner.com 1
TOTAL: 2 3

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

CommandCount
#026#003#001 1
?#024 1
EHLO www.censys.io 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
31-14-254-118.infrawat.ch 1 1
TOTAL: 1 1 4

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

HierarchyCountPct
1microsoft 403 55.7%
2free 89 12.3%
3linux 71 9.8%
4alt 67 9.3%
5de 19 2.6%
6fr 16 2.2%
7it 9 1.2%
8uk 9 1.2%
9aus 7 1.0%
10cn 7 1.0%
11comp 5 0.7%
12lada 4 0.6%
13nl 3 0.4%
14sac 3 0.4%
15eternal-september 2 0.3%
16dk 1 0.1%
17ger 1 0.1%
18junk 1 0.1%
19muc 1 0.1%
20pl 1 0.1%
21rec 1 0.1%
22sci 1 0.1%
23sfnet 1 0.1%
24soc 1 0.1%
TOTAL: 24 723100.0%

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

NewsgroupCount
1microsoft.public.windowsxp.help_and_support 358
2free.usenet 60
3alt.anonymous.messages 45
4microsoft.public.windowsxp.general 45
5linux.kernel.netdev 44
6free.pt 28
7de.soc.politik.misc 12
8alt.fan.rush-limbaugh 8
9uk.current-events.terrorism 8
10alt.arts.poetry.comments 7
11fr.soc.politique 6
12linux.debian.changes.devel 6
13linux.kernel.git 6
14cn.comp 5
15linux.debian.bugs.rc 5
16aus.cars 4
17de.etc.fahrzeug.auto 4
18fr.rec.photo 4
19lada.talk 4
20linux.debian.bugs.dist 4
21aus.politics 3
22fr.sci.zetetique 3
23sac.politics 3
24alt.atheism 2
25cn.test 2
26comp.os.linux.misc 2
27eternal-september.test 2
28it.test 2
29linux.debian.maint.hams 2
30nl.politiek 2
31alt.checkmate 1
32alt.comp.software.firefox 1
33alt.jobs.offered 1
34alt.politics.republicans 1
35alt.recovery.aa 1
36comp.lang.forth 1
37comp.misc 1
38comp.sys.mac.advocacy 1
39de.sci.electronics 1
40de.talk.jokes 1
41de.talk.tagesgeschehen 1
42dk.politik 1
43fr.sci.electronique 1
44fr.sci.maths 1
45fr.soc.environnement 1
46free.it.ai.general 1
47ger.ct 1
48it.cultura.filosofia 1
49it.discussioni.auto 1
50it.hobby.cucina 1
51it.politica 1
52it.scienza.chimica 1
53it.sport.calcio.inter-fc 1
54it.sport.calcio.milan 1
55junk 1
56linux.debian.kernel 1
57linux.debian.maint.perl 1
58linux.debian.user.japanese 1
59linux.debian.user.spanish 1
60muc.lists.freebsd.ports 1
61nl.culinair 1
62pl.soc.prawo 1
63rec.arts.sf.written 1
64sci.electronics.design 1
65sfnet.keskustelu.varaventtiili 1
66soc.culture.usa 1
67uk.comp.os.linux 1
TOTAL: 67 723
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