Daily Usenet report

Sep 28 15:00:04 -- Sep 29 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 28 15:01:13 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15538 75.3%1.9 MB 73.5%
innd 3272 15.9%450.7 KB 17.2%
innfeed 1223 5.9%156.5 KB 6.0%
cnfsstat 576 2.8%84.0 KB 3.2%
nnrpd 18 0.1%1.8 KB 0.1%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 20630 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 36568 44.4%
Positive hits 30477 37.0%
Do not exist 15219 18.5%
Cache misses 14 0.0%
TOTAL: 4 82278 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.319 0.0%31 0.000 74.806 2281.000
article cleanup00:00:00.123 0.0%15355 0.000 0.008 0.047
article logging00:00:00.449 0.0%15521 0.000 0.029 0.100
article parse00:00:00.300 0.0%27201 0.000 0.011 0.042
article write00:00:02.153 0.0%13363 0.000 0.161 4.385
artlog/artcncl00:00:00.000 0.0%29 0.000 0.000 0.000
data move00:00:00.053 0.0%92958 0.000 0.001 0.004
hisgrep/artcncl00:00:00.000 0.0%29 0.000 0.000 0.000
hishave/artcncl00:00:01.784 0.0%31 0.000 57.548 1774.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:26.669 0.1%82856 0.000 1.046 33.803
history sync00:00:00.018 0.0%355 0.000 0.051 0.500
history write00:00:05.256 0.0%15355 0.000 0.342 11.000
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:41.801 99.8%91716 310.541 941.186 3227.527
nntp read00:00:00.732 0.0%91833 0.000 0.008 0.023
overview write00:00:00.045 0.0%13363 0.000 0.003 0.049
perl filter00:00:18.118 0.0%15355 0.836 1.180 6.000
python filter00:00:00.466 0.0%15355 0.000 0.030 0.104
site send00:00:02.274 0.0%40089 0.019 0.057 0.091
TOTAL: 24:00:57.15224:00:42.560100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%23302 0.000 0.001 0.027
article prepare00:00:00.000 0.0%717 0.000 0.000 0.000
article read00:00:00.024 0.0%567 0.000 0.042 0.500
backlog stats00:00:00.040 0.0%65633 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.246 0.0%38455 0.000 0.006 0.022
data write00:00:00.729 0.0%25342 0.000 0.029 0.121
idle23:49:51.735100.0%65633 127.993 1307.143 4001.033
status file00:00:00.707 0.0%245 0.000 2.886 158.000
TOTAL: 23:49:55.92823:49:53.511100.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.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:00.56200:00:00.000 0.0%----

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 5 26651 11003 14890 758 41%48:58:43
2news.nntp4.net 1 15051 1344 12472 1235 8%23:54:17
3news-out.aioe.org 2 4486 1200 3286 0 26%06:50:11
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 9 46188 13547 30648 1993 29%79:43:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net36.0 MB0.0 KB1.3 MB37.4 MB 96%3.3 KB
2news.nntp4.net3.6 MB0.0 KB7.5 MB11.1 MB 32%4.4 KB
3news-out.aioe.org2.9 MB0.0 KB0.0 KB2.9 MB100%2.5 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 442.5 MB0.0 KB8.8 MB51.3 MB 82%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 15:00:04 - 15:59:59 658 4.9% 0.181.9 MB 4.5% 0.54
Sep 28 16:00:00 - 16:59:59 653 4.9% 0.181.8 MB 4.3% 0.52
Sep 28 17:00:00 - 17:59:59 676 5.1% 0.192.4 MB 5.7% 0.68
Sep 28 18:00:00 - 18:59:59 904 6.8% 0.252.5 MB 5.9% 0.71
Sep 28 19:00:00 - 19:59:59 697 5.2% 0.192.0 MB 4.7% 0.56
Sep 28 20:00:00 - 20:59:59 559 4.2% 0.161.5 MB 3.5% 0.42
Sep 28 21:00:00 - 21:59:59 585 4.4% 0.162.1 MB 5.0% 0.60
Sep 28 22:00:00 - 22:59:59 385 2.9% 0.111.5 MB 3.5% 0.42
Sep 28 23:00:00 - 23:59:59 451 3.4% 0.131.8 MB 4.4% 0.52
Sep 29 00:00:00 - 00:59:59 310 2.3% 0.091.1 MB 2.6% 0.31
Sep 29 01:00:00 - 01:59:59 358 2.7% 0.101.9 MB 4.4% 0.53
Sep 29 02:00:00 - 02:59:59 284 2.1% 0.081.2 MB 3.0% 0.35
Sep 29 03:00:00 - 03:59:59 260 1.9% 0.07851.4 KB 2.0% 0.24
Sep 29 04:00:00 - 04:59:59 265 2.0% 0.071010.1 KB 2.3% 0.28
Sep 29 05:00:00 - 05:59:59 303 2.3% 0.08969.9 KB 2.3% 0.27
Sep 29 06:00:00 - 06:59:59 354 2.6% 0.101.1 MB 2.6% 0.32
Sep 29 07:00:00 - 07:59:59 567 4.2% 0.161.5 MB 3.6% 0.43
Sep 29 08:00:00 - 08:59:59 741 5.5% 0.211.9 MB 4.6% 0.54
Sep 29 09:00:00 - 09:59:59 666 5.0% 0.182.1 MB 5.0% 0.60
Sep 29 10:00:00 - 10:59:59 642 4.8% 0.181.7 MB 4.0% 0.48
Sep 29 11:00:00 - 11:59:59 620 4.6% 0.171.7 MB 4.0% 0.47
Sep 29 12:00:00 - 12:59:59 764 5.7% 0.212.5 MB 5.9% 0.70
Sep 29 13:00:00 - 13:59:59 856 6.4% 0.242.3 MB 5.6% 0.66
Sep 29 14:00:00 - 14:59:59 823 6.2% 0.232.7 MB 6.5% 0.78
Sep 29 15:00:00 - 15:00:01 1 0.0% 1.002.4 KB 0.0% 2.36
TOTAL: 23:59:57 13382 100.0% 0.1542.0 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB216.6 MB 21.2% 3 0.21 58.54
ONEDEFAULT1024.0 MB378.7 MB 37.0% 5 0.21 58.51
THREEDEFAULT1024.0 MB219.3 MB 21.4% 3 0.20 60.97
TWODEFAULT1024.0 MB214.2 MB 20.9% 3 0.21 59.02
TOTAL: 4-4.0 GB1.0 GB 25.1% 14 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1223 6 0 0 1 0 0 0 1216
2hasname-out.news.weretis.net 890 8 0 0 0 0 0 0 882
3news-out.aioe.org 15 0 0 0 0 0 0 0 15
TOTAL: 3 2128 14 0 0 1 0 0 0 2113

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.math 4
alt.bestjobsusa.philly.jobs 2
alt.bestjobsusa.jobs.offered 2
yu.forum 2
wolfsburg.test 1
alt.bestjobsusa.dallas.jobs 1
alt.bestjobsusa.chicago.jobs 1
alt.bestjobsusa.florida.jobs 1
TOTAL: 8 14

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) 1241
EMP (md5) 461
EMP (phn nph) 180
EMP (phl) 20
Too many newsgroups 17
User-issued spam cancel 13
HTML Multipart 9
Scoring filter 4
HTML post 1
Binary: misplaced binary 1
TOTAL: 10 1947

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 147
news-out.aioe.org 15
news.nntp4.net 4
TOTAL: 3 166
TOTAL: 1 166

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 530 530 0 0 0 0100%21:50:04
2aioe 14414 26 13890 3 0 8077 0%23:57:47
3nntp4 14713 0 12042 0 0 1 0%23:59:52
4weretis 2722 0 2581 21 0 0 0%23:31:38
TOTAL: 4 32379 556 28513 24 0 8078 1%93:19:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.3 MB0.0 KB2.3 MB0.0 KB/s4.4 KB21:50:04
2aioe217.5 KB4.9 KB222.5 KB0.0 KB/s7.7 KB23:57:47
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
4weretis0.0 KB106.7 KB106.7 KB0.0 KB/s5.1 KB23:31:38
TOTAL: 42.5 MB111.7 KB2.6 MB0.0 KB/s4.6 KB93:19:21
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.000 0.003 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.002 0.002 0.00000:00:00
178.17.174.14 0.000 0.002 0.00000:00:00
23.129.64.131 0.000 0.002 0.00000:00:00
TOTAL: 4 0.002 0.009 0.00000:00:00

NNRP no permission clients:

SystemConn
scanner-21.ch1.censys-scanner.com 1
23.129.64.131 1
news.nntp4.net 1
178.17.174.14 1
TOTAL: 4 4