Daily Usenet report

May 5 15:00:08 -- May 6 15:00:08

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 16555 80.8%1.8 MB 77.2%
innd 2327 11.4%316.9 KB 13.3%
innfeed 1034 5.0%135.9 KB 5.7%
cnfsstat 576 2.8%90.8 KB 3.8%
nnrpd 4 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 20497 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 27703 49.2%
Do not exist 15880 28.2%
Positive hits 12635 22.5%
Cache misses 34 0.1%
TOTAL: 4 56252 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.341 0.0%87 0.000 118.862 748.000
article cleanup00:00:00.112 0.0%16070 0.000 0.007 0.073
article logging00:00:00.515 0.0%16485 0.000 0.031 0.105
article parse00:00:00.289 0.0%33397 0.000 0.009 0.031
article write00:00:05.619 0.0%15192 0.000 0.370 16.866
artlog/artcncl00:00:00.002 0.0%86 0.000 0.023 0.111
data move00:00:00.111 0.0%72524 0.000 0.002 0.014
hisgrep/artcncl00:00:02.719 0.0%86 0.000 31.616 748.000
hishave/artcncl00:00:02.044 0.0%87 0.000 23.494 188.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:24.499 0.9%56789 0.000 13.110 87.002
history sync00:00:01.271 0.0%403 0.000 3.154 255.333
history write00:00:21.836 0.0%16049 0.000 1.361 36.109
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:46:58.139 99.0%71501 671.445 1197.440 3876.955
nntp read00:00:00.640 0.0%71506 0.000 0.009 0.029
overview write00:00:00.038 0.0%15192 0.000 0.003 0.030
perl filter00:00:28.920 0.0%16049 0.481 1.802 15.706
python filter00:00:00.477 0.0%16049 0.000 0.030 0.087
site send00:00:02.595 0.0%45342 0.024 0.057 0.105
TOTAL: 24:01:02.43424:00:40.167100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%14904 0.000 0.002 0.028
article prepare00:00:00.000 0.0%590 0.000 0.000 0.000
article read00:00:00.025 0.0%581 0.000 0.043 0.500
backlog stats00:00:00.036 0.0%51851 0.000 0.001 0.019
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.295 0.0%31028 0.000 0.010 0.043
data write00:00:00.568 0.0%16183 0.000 0.035 0.093
idle23:58:05.399100.0%51851 841.078 1664.103 4249.803
status file00:00:04.992 0.0%214 0.000 23.327 675.000
TOTAL: 23:58:12.67823:58:11.351100.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%1 0.000 0.000 0.000
TOTAL: 00:00:00.21700: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
1news-out.aioe.org 4 12881 10802 2048 31 83%24:15:45
2news.nntp4.net 3 16189 4467 10878 844 27%24:25:40
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 8 29070 15269 12926 875 52%48:41:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org29.2 MB35.7 KB66.2 KB29.3 MB 99%2.8 KB
2news.nntp4.net12.9 MB10.3 KB2.1 MB15.0 MB 86%2.9 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 342.1 MB46.0 KB2.1 MB44.3 MB 95%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 5 15:00:08 - 15:59:59 1066 7.0% 0.302.6 MB 6.1% 0.73
May 5 16:00:00 - 16:59:59 960 6.3% 0.272.3 MB 5.5% 0.65
May 5 17:00:00 - 17:59:59 865 5.7% 0.242.2 MB 5.2% 0.62
May 5 18:00:00 - 18:59:59 755 5.0% 0.212.1 MB 5.1% 0.60
May 5 19:00:00 - 19:59:59 724 4.8% 0.202.1 MB 5.0% 0.59
May 5 20:00:00 - 20:59:59 785 5.2% 0.222.3 MB 5.5% 0.65
May 5 21:00:00 - 21:59:59 580 3.8% 0.161.6 MB 3.8% 0.45
May 5 22:00:00 - 22:59:59 489 3.2% 0.141.5 MB 3.7% 0.44
May 5 23:00:00 - 23:59:59 398 2.6% 0.111.4 MB 3.3% 0.39
May 6 00:00:00 - 00:59:59 298 2.0% 0.081.1 MB 2.7% 0.32
May 6 01:00:00 - 01:59:59 287 1.9% 0.08976.4 KB 2.3% 0.27
May 6 02:00:00 - 02:59:59 268 1.8% 0.07984.4 KB 2.3% 0.27
May 6 03:00:00 - 03:59:59 244 1.6% 0.07812.3 KB 1.9% 0.23
May 6 04:00:00 - 04:59:59 283 1.9% 0.081.2 MB 2.8% 0.34
May 6 05:00:00 - 05:59:59 377 2.5% 0.101.4 MB 3.3% 0.39
May 6 06:00:00 - 06:59:59 438 2.9% 0.121.3 MB 3.1% 0.36
May 6 07:00:00 - 07:59:59 578 3.8% 0.161.6 MB 3.9% 0.47
May 6 08:00:00 - 08:59:59 754 5.0% 0.211.7 MB 4.2% 0.50
May 6 09:00:00 - 09:59:59 839 5.5% 0.232.0 MB 4.7% 0.56
May 6 10:00:00 - 10:59:59 831 5.5% 0.232.1 MB 5.0% 0.60
May 6 11:00:00 - 11:59:59 753 5.0% 0.212.2 MB 5.3% 0.63
May 6 12:00:00 - 12:59:59 815 5.4% 0.232.2 MB 5.2% 0.62
May 6 13:00:00 - 13:59:59 890 5.9% 0.252.0 MB 4.8% 0.57
May 6 14:00:00 - 14:59:59 869 5.7% 0.242.2 MB 5.2% 0.62
May 6 15:00:00 - 15:00:08 16 0.1% 2.0046.6 KB 0.1% 5.83
TOTAL: 24:00:00 15162 100.0% 0.1841.8 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB750.4 MB 73.3% 0 0.22 55.63
ONEDEFAULT1024.0 MB909.3 MB 88.8% 2 0.22 55.78
THREEDEFAULT1024.0 MB752.8 MB 73.5% 0 0.22 54.09
TWODEFAULT1024.0 MB753.4 MB 73.6% 0 0.22 55.51
TOTAL: 4-4.0 GB3.1 GB 77.3% 2 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 936 22 0 5 1 0 0 0 908
2news-out.aioe.org 371 0 0 16 0 0 0 0 355
TOTAL: 2 1307 22 0 21 1 0 0 0 1263

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.hardware 9
alt.blah 6
carleton.art-history 2
alt.wanted 1
alt.flame.right-wing-conservatives 1
alt.sex.servicesa 1
vic.general 1
alt.aliens.imprisoned 1
TOTAL: 8 22

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 252
User-issued spam cancel 251
EMP (phn nph) 172
EMP (phn path) 97
EMP (phl) 70
HTML Multipart 4
Binary: misplaced binary 1
Scoring filter 1
TOTAL: 8 848

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 340
news.nntp4.net 75
TOTAL: 2 415
TOTAL: 1 415

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 579 578 0 0 0 3 99%21:13:28
2aioe 4167 1 4113 2 0 0 0%23:59:54
3nntp4 10819 0 10812 0 0 0 0%23:59:56
TOTAL: 3 15565 579 14925 2 0 3 3%69:13:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.4 MB0.0 KB2.4 MB0.0 KB/s4.3 KB21:13:28
2aioe1.9 KB5.0 KB6.9 KB0.0 KB/s2.3 KB23:59:54
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 32.4 MB5.0 KB2.4 MB0.0 KB/s4.3 KB69:13:18
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-07.ch1.censys-scanner.com 0.000 0.003 0.00000:00:00
TOTAL: 1 0.000 0.003 0.00000:00:00

NNRP no permission clients:

SystemConn
scanner-07.ch1.censys-scanner.com 1
TOTAL: 1 1