Daily Usenet report

Dec 1 15:00:02 -- Dec 2 15:00:04

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 1 15:01:17 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16271 76.7%1.9 MB 74.6%
innd 3107 14.6%424.5 KB 15.9%
innfeed 1215 5.7%168.9 KB 6.3%
cnfsstat 576 2.7%80.1 KB 3.0%
nnrpd 45 0.2%4.6 KB 0.2%
controlchan 2 0.0%0.1 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 21218 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 46746 45.7%
Positive hits 39823 38.9%
Do not exist 15467 15.1%
Cache misses 327 0.3%
TOTAL: 4 102363 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.048 0.0%345 0.000 20.429 397.333
article cleanup00:00:00.087 0.0%15655 0.000 0.006 0.033
article logging00:00:00.661 0.0%15963 0.000 0.041 0.817
article parse00:00:00.286 0.0%32880 0.000 0.009 0.032
article write00:00:08.729 0.0%14108 0.008 0.619 35.048
artlog/artcncl00:00:00.003 0.0%345 0.000 0.009 0.500
data move00:00:00.070 0.0%116664 0.000 0.001 0.005
hisgrep/artcncl00:00:00.009 0.0%342 0.000 0.026 3.000
hishave/artcncl00:00:02.313 0.0%345 0.000 6.704 95.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:22.761 0.4%103101 0.002 3.131 64.909
history sync00:00:00.013 0.0%402 0.000 0.032 0.500
history write00:00:03.556 0.0%15647 0.000 0.227 7.587
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:44:29.170 99.5%115464 314.825 740.224 2213.801
nntp read00:00:01.033 0.0%116645 0.000 0.009 0.017
overview write00:00:00.056 0.0%14108 0.000 0.004 0.024
perl filter00:00:25.563 0.0%15647 0.721 1.634 88.698
python filter00:00:00.468 0.0%15647 0.000 0.030 0.077
site send00:00:02.557 0.0%42324 0.030 0.060 0.111
TOTAL: 23:51:10.77223:50:44.383100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%14239 0.000 0.002 0.025
article prepare00:00:00.000 0.0%836 0.000 0.000 0.000
article read00:00:00.467 0.0%511 0.000 0.914 49.444
backlog stats00:00:00.047 0.0%71011 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.372 0.0%45387 0.000 0.008 0.021
data write00:00:01.014 0.0%31718 0.000 0.032 0.076
idle23:47:31.827100.0%71011 431.040 1206.177 2648.811
status file00:00:01.479 0.0%240 0.000 6.162 323.250
TOTAL: 23:47:37.95223:47:35.235100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.1%10 0.000 0.100 1.000
TOTAL: 00:00:01.26000:00:00.001 0.1%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 27672 8034 19148 490 29%48:55:36
2news-out.aioe.org 3 13092 5049 8033 10 38%22:43:28
3news.nntp4.net 3 14257 772 12547 938 5%21:54:10
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 14 55021 13855 39728 1438 25%93:33:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.6 MB8.8 KB814.5 KB28.4 MB 97%3.4 KB
2news-out.aioe.org13.9 MB11.4 KB24.1 KB13.9 MB 99%2.8 KB
3news.nntp4.net2.9 MB12.4 KB7.5 MB10.4 MB 28%6.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 444.4 MB32.6 KB8.3 MB52.7 MB 84%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 15:00:02 - 15:59:59 775 5.5% 0.221.9 MB 4.3% 0.55
Dec 1 16:00:00 - 16:59:59 769 5.5% 0.212.1 MB 4.6% 0.60
Dec 1 17:00:00 - 17:59:59 749 5.3% 0.212.4 MB 5.4% 0.69
Dec 1 18:00:00 - 18:59:59 695 4.9% 0.192.3 MB 5.1% 0.65
Dec 1 19:00:00 - 19:59:59 721 5.1% 0.202.4 MB 5.2% 0.67
Dec 1 20:00:00 - 20:59:59 609 4.3% 0.171.8 MB 4.0% 0.51
Dec 1 21:00:00 - 21:59:59 567 4.0% 0.161.9 MB 4.1% 0.53
Dec 1 22:00:00 - 22:59:59 512 3.6% 0.141.8 MB 3.9% 0.50
Dec 1 23:00:00 - 23:59:59 520 3.7% 0.142.2 MB 4.9% 0.63
Dec 2 00:00:00 - 00:59:59 363 2.6% 0.101.2 MB 2.7% 0.35
Dec 2 01:00:00 - 01:59:59 321 2.3% 0.091.3 MB 2.8% 0.36
Dec 2 02:00:00 - 02:59:59 411 2.9% 0.111.5 MB 3.3% 0.43
Dec 2 03:00:00 - 03:59:59 310 2.2% 0.091.3 MB 2.9% 0.37
Dec 2 04:00:00 - 04:59:59 310 2.2% 0.091.5 MB 3.4% 0.44
Dec 2 05:00:00 - 05:59:59 381 2.7% 0.111.3 MB 2.8% 0.36
Dec 2 06:00:00 - 06:59:59 673 4.8% 0.192.9 MB 6.4% 0.82
Dec 2 07:00:00 - 07:59:59 447 3.2% 0.121.4 MB 3.1% 0.39
Dec 2 08:00:00 - 08:59:59 622 4.4% 0.171.7 MB 3.7% 0.47
Dec 2 09:00:00 - 09:59:59 613 4.3% 0.171.9 MB 4.1% 0.53
Dec 2 10:00:00 - 10:59:59 676 4.8% 0.191.8 MB 4.1% 0.53
Dec 2 11:00:00 - 11:59:59 697 4.9% 0.191.7 MB 3.7% 0.47
Dec 2 12:00:00 - 12:59:59 659 4.7% 0.181.8 MB 4.0% 0.52
Dec 2 13:00:00 - 13:59:59 942 6.7% 0.263.3 MB 7.2% 0.93
Dec 2 14:00:00 - 14:59:59 765 5.4% 0.212.0 MB 4.5% 0.58
Dec 2 15:00:00 - 15:00:04 3 0.0% 0.759.5 KB 0.0% 2.38
TOTAL: 24:00:02 14110 100.0% 0.1645.3 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB277.6 MB 27.1% 4 0.22 55.23
ONEDEFAULT1024.0 MB440.4 MB 43.0% 6 0.22 56.10
THREEDEFAULT1024.0 MB279.3 MB 27.3% 4 0.22 54.89
TWODEFAULT1024.0 MB274.8 MB 26.8% 4 0.22 54.59
TOTAL: 4-4.0 GB1.2 GB 31.1% 18 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1041 15 0 4 1 0 0 0 1021
2hasname-out.news.weretis.net 705 9 0 1 0 0 0 0 695
3news-out.aioe.org 70 0 0 3 0 0 0 0 67
TOTAL: 3 1816 24 0 8 1 0 0 0 1783

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sports.hockey.nhl 7
alt.buttered.scones 5
alt.bestjobsusa.jobs.offered 2
alt.bestjobsusa.philly.jobs 2
alt.ads 1
alt.penthouse.sex.femdom 1
alt.math 1
alt.fetish.feet 1
biz.marketplace 1
ct.jobs 1
panix.chat.politics 1
can.forsale 1
TOTAL: 12 24

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 829
EMP (md5) 522
EMP (phn nph) 109
EMP (phl) 13
User-issued spam cancel 6
HTML Multipart 2
Binary: misplaced binary 1
Too many newsgroups 1
TOTAL: 8 1483

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 239
news-out.aioe.org 60
news.nntp4.net 2
TOTAL: 3 301
TOTAL: 1 301

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 406 406 0 0 0 0100%20:43:39
2aioe 10080 23 8838 2 0 25 0%23:47:24
3nntp4 14604 13 13258 0 0 149 0%23:47:24
4weretis 6256 1 5756 70 0 0 0%23:47:24
TOTAL: 4 31346 443 27852 72 0 174 1%92:05:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.8 MB0.0 KB1.8 MB0.0 KB/s4.6 KB20:43:39
2aioe96.0 KB4.8 KB100.8 KB0.0 KB/s4.0 KB23:47:24
3nntp469.0 KB0.0 KB69.0 KB0.0 KB/s5.3 KB23:47:24
4weretis1.3 KB551.7 KB553.1 KB0.0 KB/s7.8 KB23:47:24
TOTAL: 42.0 MB556.5 KB2.5 MB0.0 KB/s5.0 KB92:05:51
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.001 0.005 0.00000:00:01
refrigerator.census.shodan.io 0.001 0.004 0.00000:00:00
tor-exit-3.zbau.f3netze.de 0.001 0.003 0.00000:00:00
27.115.124.108 0.001 0.003 0.00000:00:00
104.152.52.133 0.001 0.002 0.00000:00:00
167.94.138.116 0.001 0.004 0.00000:00:00
27.115.124.74 0.001 0.002 0.00000:00:00
TOTAL: 7 0.007 0.023 0.00000:00:01

NNRP no permission clients:

SystemConn
167.94.138.116 2
news.nntp4.net 2
refrigerator.census.shodan.io 2
27.115.124.74 1
tor-exit-3.zbau.f3netze.de 1
104.152.52.133 1
27.115.124.108 1
TOTAL: 7 10