Daily Usenet report

May 6 15:00:09 -- May 7 15:00:07

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 6 15:02:33 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16701 82.7%1.9 MB 79.5%
innd 1858 9.2%262.5 KB 10.8%
innfeed 1040 5.1%143.1 KB 5.9%
cnfsstat 576 2.9%90.9 KB 3.7%
nnrpd 16 0.1%1.7 KB 0.1%
overchan 2 0.0%0.3 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 7 20195 100.0%2.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 37103 47.4%
Positive hits 25236 32.2%
Do not exist 15940 20.3%
Cache misses 53 0.1%
TOTAL: 4 78332 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.035 0.0%76 0.000 66.250 1000.000
article cleanup00:00:00.097 0.0%16169 0.000 0.006 0.036
article logging00:00:00.576 0.0%16632 0.000 0.035 0.079
article parse00:00:00.282 0.0%31182 0.000 0.009 0.038
article write00:00:03.864 0.0%15611 0.000 0.248 7.122
artlog/artcncl00:00:00.001 0.0%76 0.000 0.013 0.091
data move00:00:00.058 0.0%91379 0.000 0.001 0.008
hisgrep/artcncl00:00:00.377 0.0%74 0.000 5.095 34.000
hishave/artcncl00:00:01.978 0.0%76 0.000 26.026 1000.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:07:29.390 0.5%78718 0.000 5.709 46.639
history sync00:00:00.025 0.0%368 0.000 0.068 1.000
history write00:00:08.115 0.0%16076 0.000 0.505 8.669
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:51:49.140 99.4%88705 449.004 968.481 5128.812
nntp read00:00:00.786 0.0%90597 0.000 0.009 0.027
overview write00:00:00.057 0.0%15611 0.000 0.004 0.029
perl filter00:00:23.815 0.0%16076 0.887 1.481 17.633
python filter00:00:00.458 0.0%16076 0.000 0.028 0.100
site send00:00:02.808 0.0%46718 0.028 0.060 0.124
TOTAL: 24:00:53.68824:00:06.862 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%15344 0.000 0.002 0.021
article prepare00:00:00.000 0.0%579 0.000 0.000 0.000
article read00:00:01.115 0.0%573 0.000 1.946 216.200
backlog stats00:00:00.035 0.0%57411 0.000 0.001 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.307 0.0%36062 0.000 0.009 0.040
data write00:00:00.730 0.0%20805 0.000 0.035 0.105
idle23:47:58.621100.0%57411 784.480 1492.373 4883.732
status file00:00:00.898 0.0%216 0.000 4.157 646.000
TOTAL: 23:48:03.92623:48:01.735100.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.98500: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
reload 2
reserve 2
TOTAL: 11 169

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 4 12970 8193 4748 29 63%24:17:39
2hasname-out.news.weretis.net 8 10112 4092 6002 18 40%16:36:51
3news.nntp4.net 2 15498 3104 11880 514 20%23:52:23
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 15 38580 15389 22630 561 39%64:46:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org22.7 MB72.8 KB91.2 KB22.9 MB 99%2.8 KB
2hasname-out.news.weretis.net11.2 MB4.1 KB32.3 KB11.2 MB 99%2.8 KB
3news.nntp4.net8.4 MB229.1 KB1.6 MB10.2 MB 82%2.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 442.2 MB305.9 KB1.7 MB44.3 MB 95%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 6 15:00:09 - 15:59:59 978 6.3% 0.272.7 MB 6.2% 0.76
May 6 16:00:00 - 16:59:59 1012 6.5% 0.282.8 MB 6.7% 0.81
May 6 17:00:00 - 17:59:59 924 5.9% 0.262.6 MB 6.0% 0.73
May 6 18:00:00 - 18:59:59 726 4.6% 0.202.0 MB 4.7% 0.57
May 6 19:00:00 - 19:59:59 655 4.2% 0.181.7 MB 4.1% 0.50
May 6 20:00:00 - 20:59:59 738 4.7% 0.202.1 MB 5.0% 0.61
May 6 21:00:00 - 21:59:59 625 4.0% 0.171.6 MB 3.8% 0.47
May 6 22:00:00 - 22:59:59 547 3.5% 0.151.6 MB 3.7% 0.46
May 6 23:00:00 - 23:59:59 446 2.9% 0.121.5 MB 3.5% 0.43
May 7 00:00:00 - 00:59:59 444 2.8% 0.121.8 MB 4.1% 0.50
May 7 01:00:00 - 01:59:59 324 2.1% 0.091.1 MB 2.7% 0.33
May 7 02:00:00 - 02:59:59 275 1.8% 0.08970.7 KB 2.2% 0.27
May 7 03:00:00 - 03:59:59 254 1.6% 0.07776.6 KB 1.8% 0.22
May 7 04:00:00 - 04:59:59 307 2.0% 0.09862.1 KB 2.0% 0.24
May 7 05:00:00 - 05:59:59 503 3.2% 0.141.1 MB 2.5% 0.31
May 7 06:00:00 - 06:59:59 473 3.0% 0.131.3 MB 3.0% 0.36
May 7 07:00:00 - 07:59:59 651 4.2% 0.181.5 MB 3.5% 0.43
May 7 08:00:00 - 08:59:59 796 5.1% 0.221.8 MB 4.2% 0.51
May 7 09:00:00 - 09:59:59 793 5.1% 0.221.9 MB 4.6% 0.55
May 7 10:00:00 - 10:59:59 693 4.4% 0.191.8 MB 4.2% 0.51
May 7 11:00:00 - 11:59:59 796 5.1% 0.222.1 MB 4.9% 0.59
May 7 12:00:00 - 12:59:59 768 4.9% 0.212.3 MB 5.3% 0.64
May 7 13:00:00 - 13:59:59 889 5.7% 0.252.4 MB 5.7% 0.69
May 7 14:00:00 - 14:59:59 987 6.3% 0.272.4 MB 5.6% 0.68
May 7 15:00:00 - 15:00:07 13 0.1% 1.8627.2 KB 0.1% 3.88
TOTAL: 23:59:58 15617 100.0% 0.1842.7 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB769.4 MB 75.1% 0 0.22 54.06
ONEDEFAULT1024.0 MB928.5 MB 90.7% 2 0.23 53.49
THREEDEFAULT1024.0 MB771.6 MB 75.4% 0 0.22 54.41
TWODEFAULT1024.0 MB772.3 MB 75.4% 0 0.22 54.35
TOTAL: 4-4.0 GB3.2 GB 79.1% 2 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 545 26 0 68 1 0 0 0 450
2news-out.aioe.org 262 0 0 24 0 0 0 0 238
3hasname-out.news.weretis.net 201 0 0 1 0 0 0 0 200
TOTAL: 3 1008 26 0 93 1 0 0 0 888

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.hardware 8
panix.chat 8
alt.blah 4
panix.test 3
alt.math 1
alt.ebook 1
alt.sports.hockey.nhl 1
TOTAL: 7 26

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 239
EMP (phl) 71
EMP (phn path) 62
User-issued spam cancel 44
HTML Multipart 5
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 7 424

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
hasname-out.news.weretis.net 1
TOTAL: 1 1
Including strange strings
news-out.aioe.org 233
hasname-out.news.weretis.net 173
news.nntp4.net 58
TOTAL: 3 464
TOTAL: 2 465

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 574 574 0 0 0 0100%20:49:50
2aioe 7337 2 7244 0 0 0 0%23:59:50
3nntp4 12467 0 12428 0 0 0 0%23:59:50
TOTAL: 3 20378 576 19672 0 0 0 2%68:49:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.6 MB0.0 KB2.6 MB0.0 KB/s4.6 KB20:49:50
2aioe4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:50
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
TOTAL: 32.6 MB0.0 KB2.6 MB0.0 KB/s4.6 KB68:49:30
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
srv1.nyc.us.weretis.net 0.002 0.006 0.00000:00:00
feeder8.news.weretis.net 0.003 0.000 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.001 0.002 0.00000:00:00
TOTAL: 3 0.006 0.008 0.00000:00:00

NNRP no permission clients:

SystemConn
srv1.nyc.us.weretis.net 2
feeder8.news.weretis.net 1
scanner-21.ch1.censys-scanner.com 1
TOTAL: 3 4