Daily Usenet report

Jul 5 15:00:02 -- Jul 6 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 5 15:01:26 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12692 74.7%1.5 MB 72.1%
innd 2311 13.6%332.7 KB 15.2%
innfeed 1241 7.3%176.3 KB 8.1%
cnfsstat 576 3.4%84.8 KB 3.9%
nnrpd 158 0.9%15.7 KB 0.7%
controlchan 2 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 16981 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 31905 43.7%
Negative hits 28765 39.4%
Do not exist 12257 16.8%
Cache misses 27 0.0%
TOTAL: 4 72954 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.261 0.0%85 0.000 3.071 81.000
article cleanup00:00:00.084 0.0%12398 0.000 0.007 0.038
article logging00:00:00.370 0.0%12681 0.000 0.029 0.340
article parse00:00:00.213 0.0%27123 0.000 0.008 0.033
article write00:00:01.045 0.0%11470 0.000 0.091 4.840
artlog/artcncl00:00:00.001 0.0%85 0.000 0.012 0.500
data move00:00:00.062 0.0%84843 0.000 0.001 0.004
hisgrep/artcncl00:00:00.001 0.0%82 0.000 0.012 0.500
hishave/artcncl00:00:00.073 0.0%85 0.000 0.859 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:43.154 0.1%73621 0.001 1.401 17.544
history sync00:00:00.216 0.0%349 0.000 0.619 57.667
history write00:00:01.066 0.0%12381 0.000 0.086 3.617
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:58:28.224 99.8%86740 516.270 995.022 2929.620
nntp read00:00:00.622 0.0%86949 0.000 0.007 0.017
overview write00:00:00.042 0.0%11470 0.000 0.004 0.053
perl filter00:00:17.744 0.0%12381 0.811 1.433 36.320
python filter00:00:00.385 0.0%12381 0.000 0.031 0.098
site send00:00:01.564 0.0%34409 0.000 0.045 0.097
TOTAL: 24:00:46.70524:00:35.127100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%11364 0.000 0.002 0.033
article prepare00:00:00.001 0.0%1905 0.000 0.001 0.056
article read00:00:00.033 0.0%667 0.000 0.049 1.000
backlog stats00:00:00.041 0.0%71086 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.309 0.0%41036 0.000 0.008 0.036
data write00:00:00.834 0.0%29806 0.000 0.028 0.122
idle23:47:15.866100.0%71086 607.430 1204.680 2985.761
status file00:00:00.384 0.0%254 0.000 1.512 226.000
TOTAL: 23:47:32.04423:47:17.492100.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%32 0.000 0.031 1.000
TOTAL: 00:00:01.60400:00:00.001 0.1%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 20386 7498 12764 124 36%46:25:02
2news-out.aioe.org 5 11319 3487 7754 78 30%24:08:15
3news.nntp4.net 2 8038 97 7380 561 1%16:57:02
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 15 39743 11082 27898 763 27%87:30:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.1 MB46.0 KB309.0 KB25.4 MB 98%3.4 KB
2news-out.aioe.org8.6 MB14.6 KB164.2 KB8.7 MB 97%2.5 KB
3news.nntp4.net695.9 KB0.0 KB7.9 MB8.6 MB 7%13.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 434.3 MB60.7 KB8.4 MB42.7 MB 80%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 5 15:00:02 - 15:59:59 705 6.2% 0.202.0 MB 5.5% 0.56
Jul 5 16:00:00 - 16:59:59 737 6.5% 0.202.5 MB 7.1% 0.72
Jul 5 17:00:00 - 17:59:59 635 5.6% 0.181.7 MB 4.8% 0.48
Jul 5 18:00:00 - 18:59:59 532 4.7% 0.151.6 MB 4.6% 0.46
Jul 5 19:00:00 - 19:59:59 638 5.6% 0.182.0 MB 5.7% 0.58
Jul 5 20:00:00 - 20:59:59 541 4.7% 0.151.7 MB 4.8% 0.48
Jul 5 21:00:00 - 21:59:59 440 3.9% 0.121.6 MB 4.4% 0.45
Jul 5 22:00:00 - 22:59:59 387 3.4% 0.111.6 MB 4.4% 0.45
Jul 5 23:00:00 - 23:59:59 376 3.3% 0.101.3 MB 3.7% 0.37
Jul 6 00:00:00 - 00:59:59 286 2.5% 0.08880.4 KB 2.4% 0.24
Jul 6 01:00:00 - 01:59:59 226 2.0% 0.061.2 MB 3.4% 0.34
Jul 6 02:00:00 - 02:59:59 269 2.4% 0.071.0 MB 2.9% 0.29
Jul 6 03:00:00 - 03:59:59 249 2.2% 0.071.2 MB 3.3% 0.33
Jul 6 04:00:00 - 04:59:59 275 2.4% 0.08925.7 KB 2.5% 0.26
Jul 6 05:00:00 - 05:59:59 274 2.4% 0.08870.3 KB 2.4% 0.24
Jul 6 06:00:00 - 06:59:59 328 2.9% 0.09884.5 KB 2.4% 0.25
Jul 6 07:00:00 - 07:59:59 445 3.9% 0.121.2 MB 3.4% 0.34
Jul 6 08:00:00 - 08:59:59 494 4.3% 0.141.3 MB 3.6% 0.37
Jul 6 09:00:00 - 09:59:59 519 4.6% 0.141.5 MB 4.1% 0.42
Jul 6 10:00:00 - 10:59:59 586 5.1% 0.161.6 MB 4.5% 0.45
Jul 6 11:00:00 - 11:59:59 565 5.0% 0.161.7 MB 4.7% 0.48
Jul 6 12:00:00 - 12:59:59 525 4.6% 0.151.7 MB 4.7% 0.48
Jul 6 13:00:00 - 13:59:59 671 5.9% 0.192.0 MB 5.6% 0.57
Jul 6 14:00:00 - 15:00:02 702 6.2% 0.191.9 MB 5.3% 0.54
TOTAL: 24:00:00 11405 100.0% 0.1335.7 MB 100.0% 0.42
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB706.3 MB 69.0% 7 0.17 69.55
ONEDEFAULT1024.0 MB881.2 MB 86.1% 9 0.18 68.99
THREEDEFAULT1024.0 MB716.1 MB 69.9% 7 0.17 71.11
TWODEFAULT1024.0 MB711.6 MB 69.5% 7 0.17 69.84
TOTAL: 4-4.0 GB2.9 GB 73.6% 30 0.17-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 719 13 0 7 1 0 0 0 698
2hasname-out.news.weretis.net 363 2 0 9 0 0 0 0 352
3news-out.aioe.org 121 3 0 1 0 0 0 0 117
TOTAL: 3 1203 18 0 17 1 0 0 0 1167

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.infosystems.gemini 3
panix.chat.politics 3
gun.general 2
jobs.misc.jobs 2
alt.personals.sex 1
list.postfix.users 1
access1.announcements 1
alt.bestjobsusa.philly.jobs 1
alt.business.biz.newsgroup 1
wolfsburg.test 1
intel.motherboards.pentium_ii 1
3dfx.game 1
TOTAL: 12 18

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 658
EMP (phn path) 85
EMP (phl) 77
EMP (phn nph) 58
Scoring filter 9
HTML Multipart 2
TOTAL: 6 889

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 239
news-out.aioe.org 42
news.nntp4.net 3
TOTAL: 3 284
TOTAL: 1 284

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 285 285 0 0 0 0100%17:44:20
2nntp4 14549 208 11102 2 0 4 1%24:01:06
3aioe 10806 160 7613 29 0 34 1%24:05:15
4weretis 3852 0 3651 10 0 1 0%24:01:05
TOTAL: 4 29492 653 22366 41 0 39 2%89:51:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.1 MB0.0 KB1.1 MB0.0 KB/s4.1 KB17:44:20
2nntp4849.7 KB9.1 KB858.7 KB0.0 KB/s4.1 KB24:01:06
3aioe526.7 KB85.1 KB611.8 KB0.0 KB/s3.2 KB24:05:15
4weretis0.0 KB56.0 KB56.0 KB0.0 KB/s5.6 KB24:01:05
TOTAL: 42.5 MB150.1 KB2.6 MB0.0 KB/s3.9 KB89:51:46
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
88.80.186.144 0.020 0.051 0.00000:00:00
202.95.12.14 0.002 0.004 0.00000:00:00
ec2-3-101-39-138.us-west-1.compute.amazonaws.com 0.000 0.003 0.00000:00:00
192.241.207.17 0.000 0.003 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.000 0.003 0.00000:00:00
92.255.85.38 0.000 0.002 0.00000:00:00
TOTAL: 6 0.022 0.066 0.00000:00:01

NNRP no permission clients:

SystemConn
88.80.186.144 26
202.95.12.14 2
ec2-3-101-39-138.us-west-1.compute.amazonaws.com 1
192.241.207.17 1
scanner-26.ch1.censys-scanner.com 1
92.255.85.38 1
TOTAL: 6 32