Daily Usenet report

Sep 22 15:00:01 -- Sep 23 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 16153 80.0%2.0 MB 77.7%
innd 2287 11.3%325.0 KB 12.6%
innfeed 1161 5.8%165.5 KB 6.4%
cnfsstat 576 2.9%86.0 KB 3.3%
nnrpd 8 0.0%0.7 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 20187 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 44913 44.0%
Positive hits 41566 40.7%
Do not exist 15641 15.3%
Cache misses 38 0.0%
TOTAL: 4 102158 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.471 0.0%58 0.000 25.362 150.800
article cleanup00:00:00.108 0.0%15711 0.000 0.007 0.036
article logging00:00:00.497 0.0%16099 0.000 0.031 0.089
article parse00:00:00.292 0.0%30694 0.000 0.010 0.032
article write00:00:02.109 0.0%15016 0.000 0.140 4.176
artlog/artcncl00:00:00.000 0.0%58 0.000 0.000 0.000
data move00:00:00.058 0.0%116156 0.000 0.000 0.004
hisgrep/artcncl00:00:00.002 0.0%58 0.000 0.034 1.000
hishave/artcncl00:00:00.020 0.0%58 0.000 0.345 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:32.645 0.0%102612 0.003 0.318 8.404
history sync00:00:00.025 0.0%406 0.000 0.062 0.667
history write00:00:02.403 0.0%15711 0.000 0.153 9.044
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:59:48.938 99.9%114835 370.293 752.288 2833.660
nntp read00:00:00.840 0.0%114770 0.000 0.007 0.015
overview write00:00:00.060 0.0%15016 0.000 0.004 0.036
perl filter00:00:20.102 0.0%15711 0.967 1.279 19.707
python filter00:00:00.515 0.0%15711 0.000 0.033 0.115
site send00:00:02.849 0.0%45048 0.022 0.063 0.105
TOTAL: 24:01:09.03424:00:52.934100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%14984 0.000 0.002 0.038
article prepare00:00:00.000 0.0%1012 0.000 0.000 0.000
article read00:00:00.031 0.0%600 0.000 0.052 1.000
backlog stats00:00:00.052 0.0%81759 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.442 0.0%50749 0.000 0.009 0.025
data write00:00:01.023 0.0%35919 0.000 0.028 0.073
idle23:57:59.133100.0%81759 520.182 1055.286 3165.865
status file00:00:00.607 0.0%216 0.000 2.810 112.500
TOTAL: 23:58:03.25323:58:01.320100.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%2 0.000 0.000 0.000
TOTAL: 00:00:00.57600: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 7 28097 10443 17542 112 37%48:51:12
2news-out.aioe.org 3 13665 3730 9930 5 27%23:38:04
3news.nntp4.net 2 17068 930 15515 623 5%25:39:42
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 58830 15103 42987 740 25%98:08:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net34.5 MB0.0 KB337.8 KB34.9 MB 99%3.4 KB
2news-out.aioe.org9.7 MB0.0 KB17.1 KB9.7 MB 99%2.7 KB
3news.nntp4.net2.5 MB0.0 KB8.6 MB11.1 MB 22%7.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 446.7 MB0.0 KB8.9 MB55.6 MB 83%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 15:00:01 - 15:59:59 949 6.3% 0.263.2 MB 6.9% 0.91
Sep 22 16:00:00 - 16:59:59 930 6.2% 0.262.5 MB 5.5% 0.72
Sep 22 17:00:00 - 17:59:59 792 5.3% 0.222.0 MB 4.4% 0.58
Sep 22 18:00:00 - 18:59:59 788 5.2% 0.222.7 MB 5.7% 0.76
Sep 22 19:00:00 - 19:59:59 734 4.9% 0.201.8 MB 4.0% 0.53
Sep 22 20:00:00 - 20:59:59 694 4.6% 0.192.1 MB 4.6% 0.60
Sep 22 21:00:00 - 21:59:59 577 3.8% 0.161.8 MB 4.0% 0.52
Sep 22 22:00:00 - 22:59:59 656 4.4% 0.182.4 MB 5.2% 0.69
Sep 22 23:00:00 - 23:59:59 435 2.9% 0.121.6 MB 3.4% 0.45
Sep 23 00:00:00 - 00:59:59 331 2.2% 0.091.6 MB 3.4% 0.45
Sep 23 01:00:00 - 01:59:59 357 2.4% 0.101.3 MB 2.9% 0.38
Sep 23 02:00:00 - 02:59:59 327 2.2% 0.091.4 MB 3.1% 0.40
Sep 23 03:00:00 - 03:59:59 253 1.7% 0.071022.7 KB 2.1% 0.28
Sep 23 04:00:00 - 04:59:59 348 2.3% 0.101.4 MB 3.1% 0.41
Sep 23 05:00:00 - 05:59:59 348 2.3% 0.10987.8 KB 2.1% 0.27
Sep 23 06:00:00 - 06:59:59 488 3.3% 0.141.6 MB 3.4% 0.45
Sep 23 07:00:00 - 07:59:59 613 4.1% 0.171.7 MB 3.7% 0.49
Sep 23 08:00:00 - 08:59:59 821 5.5% 0.232.4 MB 5.1% 0.67
Sep 23 09:00:00 - 09:59:59 809 5.4% 0.222.5 MB 5.3% 0.70
Sep 23 10:00:00 - 10:59:59 725 4.8% 0.202.3 MB 4.9% 0.65
Sep 23 11:00:00 - 11:59:59 651 4.3% 0.181.7 MB 3.6% 0.47
Sep 23 12:00:00 - 12:59:59 658 4.4% 0.181.7 MB 3.7% 0.49
Sep 23 13:00:00 - 13:59:59 881 5.9% 0.242.3 MB 5.0% 0.66
Sep 23 14:00:00 - 14:59:59 840 5.6% 0.232.3 MB 5.1% 0.67
Sep 23 15:00:00 - 15:00:02 6 0.0% 3.0015.0 KB 0.0% 7.48
TOTAL: 24:00:01 15011 100.0% 0.1746.5 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB116.0 MB 11.3% 3 0.23 52.64
ONEDEFAULT1024.0 MB278.0 MB 27.1% 5 0.23 52.91
THREEDEFAULT1024.0 MB119.0 MB 11.6% 3 0.23 53.10
TWODEFAULT1024.0 MB114.7 MB 11.2% 3 0.23 53.33
TOTAL: 4-4.0 GB627.7 MB 15.3% 14 0.23-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 583 10 0 0 1 0 0 0 572
2hasname-out.news.weretis.net 409 18 0 0 0 0 0 0 391
3news-out.aioe.org 92 0 0 0 0 0 0 0 92
TOTAL: 3 1084 28 0 0 1 0 0 0 1055

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 16
agency.chat 5
alt.bestjobsusa.jobs.offered 2
alt.bestjobsusa.philly.jobs 2
alt.alt.alt 1
comp.unix.advocacy 1
alt.ads 1
TOTAL: 7 28

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 392
EMP (phn path) 100
EMP (phn nph) 80
User-issued spam cancel 32
EMP (phl) 20
HTML Multipart 18
Scoring filter 10
HTML post 8
Too many newsgroups 5
Too many newsgroups (meow) 1
TOTAL: 10 666

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 297
news-out.aioe.org 87
news.nntp4.net 5
TOTAL: 3 389
TOTAL: 1 389

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 474 474 0 0 0 0100%21:08:39
2nntp4 16657 65 14168 0 0 0 0%23:59:55
3aioe 13386 43 10995 1 0 0 0%23:59:46
4weretis 4814 0 4567 26 0 1 0%23:57:24
TOTAL: 4 35331 582 29730 27 0 1 1%93:05:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.9 MB0.0 KB1.9 MB0.0 KB/s4.0 KB21:08:39
2nntp4307.8 KB0.0 KB307.8 KB0.0 KB/s4.7 KB23:59:55
3aioe206.8 KB1.2 KB208.0 KB0.0 KB/s4.7 KB23:59:46
4weretis0.0 KB111.5 KB111.5 KB0.0 KB/s4.3 KB23:57:24
TOTAL: 42.4 MB112.8 KB2.5 MB0.0 KB/s4.2 KB93:05:44
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.000 0.004 0.00000:00:00
85.ip-149-56-99.net 0.000 0.002 0.00000:00:00
TOTAL: 2 0.000 0.006 0.00000:00:00

NNRP no permission clients:

SystemConn
85.ip-149-56-99.net 1
news.nntp4.net 1
TOTAL: 2 2
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>