Daily Usenet report

Apr 3 15:00:03 -- Apr 4 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Apr 3 15:01:00 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15544 56.7%1.7 MB 58.0%
nnrpd 8678 31.6%838.0 KB 28.0%
innd 1883 6.9%251.3 KB 8.4%
innfeed 745 2.7%85.4 KB 2.9%
cnfsstat 576 2.1%80.4 KB 2.7%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 27429 100.0%2.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 26292 48.9%
Do not exist 15132 28.1%
Positive hits 12364 23.0%
Cache misses 6 0.0%
TOTAL: 4 53794 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.207 0.0%45 0.000 4.600 203.000
article cleanup00:00:00.097 0.0%15167 0.000 0.006 0.037
article logging00:00:00.574 0.0%15507 0.000 0.037 0.128
article parse00:00:00.288 0.0%31805 0.000 0.009 0.049
article write00:00:01.237 0.0%14437 0.000 0.086 2.388
artlog/artcncl00:00:00.001 0.0%44 0.000 0.023 0.100
data move00:00:00.054 0.0%69769 0.000 0.001 0.007
hisgrep/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%45 0.000 0.022 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:16.048 0.0%53943 0.000 0.297 4.977
history sync00:00:00.018 0.0%322 0.000 0.056 0.500
history write00:00:02.704 0.0%15167 0.000 0.178 8.347
hiswrite/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
idle23:59:46.093 99.9%69004 694.062 1251.900 4762.183
nntp read00:00:00.577 0.0%68811 0.000 0.008 0.025
overview write00:00:00.059 0.0%14437 0.000 0.004 0.026
perl filter00:00:18.423 0.0%15167 0.806 1.215 10.233
python filter00:00:00.503 0.0%15167 0.000 0.033 0.089
site send00:00:02.365 0.0%43130 0.032 0.055 0.099
TOTAL: 24:00:39.89924:00:29.249100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%14234 0.000 0.002 0.026
article prepare00:00:00.000 0.0%64 0.000 0.000 0.000
article read00:00:00.000 0.0%16 0.000 0.000 0.000
backlog stats00:00:00.028 0.0%47529 0.000 0.001 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.237 0.0%28413 0.000 0.008 0.031
data write00:00:00.464 0.0%14325 0.000 0.032 0.074
idle23:59:06.414100.0%47529 945.754 1816.710 4550.038
status file00:00:00.265 0.0%150 0.000 1.767 167.000
TOTAL: 23:59:08.71323:59:07.437100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:19:31.698 92.4%7270 152.800 161.169 1830.692
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.834 0.8%200611 0.000 0.049 0.273
readart00:00:00.014 0.0%21 0.000 0.667 2.000
TOTAL: 00:21:08.39000:19:41.546 93.2%----

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 5 12723 10687 1834 202 83%24:40:45
2news.nntp4.net 2 14980 3922 10537 521 26%23:55:36
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 8 27703 14609 12371 723 52%48:36:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org28.5 MB0.0 KB323.4 KB28.8 MB 98%2.7 KB
2news.nntp4.net11.8 MB0.0 KB1.6 MB13.4 MB 87%3.1 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 340.3 MB0.0 KB1.9 MB42.3 MB 95%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 3 15:00:03 - 15:59:59 862 6.0% 0.242.5 MB 6.2% 0.70
Apr 3 16:00:00 - 16:59:59 883 6.1% 0.252.4 MB 6.0% 0.68
Apr 3 17:00:00 - 17:59:59 770 5.3% 0.212.0 MB 5.1% 0.58
Apr 3 18:00:00 - 18:59:59 677 4.7% 0.191.8 MB 4.6% 0.52
Apr 3 19:00:00 - 19:59:59 823 5.7% 0.232.2 MB 5.4% 0.61
Apr 3 20:00:00 - 20:59:59 613 4.2% 0.172.0 MB 5.1% 0.58
Apr 3 21:00:00 - 21:59:59 520 3.6% 0.141.6 MB 4.1% 0.46
Apr 3 22:00:00 - 22:59:59 622 4.3% 0.172.1 MB 5.1% 0.58
Apr 3 23:00:00 - 23:59:59 465 3.2% 0.131.5 MB 3.8% 0.43
Apr 4 00:00:00 - 00:59:59 369 2.6% 0.101.3 MB 3.3% 0.38
Apr 4 01:00:00 - 01:59:59 460 3.2% 0.131.5 MB 3.7% 0.43
Apr 4 02:00:00 - 02:59:59 301 2.1% 0.081.0 MB 2.5% 0.28
Apr 4 03:00:00 - 03:59:59 263 1.8% 0.07990.2 KB 2.4% 0.28
Apr 4 04:00:00 - 04:59:59 273 1.9% 0.08959.7 KB 2.3% 0.27
Apr 4 05:00:00 - 05:59:59 285 2.0% 0.08840.3 KB 2.0% 0.23
Apr 4 06:00:00 - 06:59:59 427 3.0% 0.121.1 MB 2.8% 0.32
Apr 4 07:00:00 - 07:59:59 599 4.2% 0.171.6 MB 4.1% 0.47
Apr 4 08:00:00 - 08:59:59 728 5.0% 0.201.6 MB 3.9% 0.45
Apr 4 09:00:00 - 09:59:59 919 6.4% 0.261.9 MB 4.8% 0.55
Apr 4 10:00:00 - 10:59:59 727 5.0% 0.201.9 MB 4.6% 0.53
Apr 4 11:00:00 - 11:59:59 754 5.2% 0.211.7 MB 4.3% 0.49
Apr 4 12:00:00 - 12:59:59 696 4.8% 0.191.6 MB 3.9% 0.44
Apr 4 13:00:00 - 13:59:59 710 4.9% 0.202.2 MB 5.4% 0.62
Apr 4 14:00:00 - 14:59:59 678 4.7% 0.191.8 MB 4.5% 0.51
Apr 4 15:00:00 - 15:00:02 5 0.0% 2.5012.7 KB 0.0% 6.37
TOTAL: 23:59:59 14429 100.0% 0.1740.1 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB138.0 MB 13.5% 0 0.21 57.45
ONEDEFAULT1024.0 MB295.7 MB 28.9% 2 0.21 57.29
THREEDEFAULT1024.0 MB138.1 MB 13.5% 0 0.21 59.19
TWODEFAULT1024.0 MB138.7 MB 13.5% 0 0.21 57.52
TOTAL: 4-4.0 GB710.5 MB 17.3% 2 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 554 13 0 0 1 0 0 0 540
2news-out.aioe.org 517 0 0 0 0 0 0 0 517
TOTAL: 2 1071 13 0 0 1 0 0 0 1057

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 3
alt.computer.hardware 3
0.test 2
mozilla.dev.apps.seamonkey 1
alt.culture.underwear 1
panix.chat 1
alt.atari-jaguar 1
sk.politics 1
TOTAL: 8 13

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 269
EMP (phn path) 224
EMP (phl) 148
EMP (phn nph) 48
HTML Multipart 17
Too many newsgroups 5
Binary: misplaced binary 4
Scoring filter 1
TOTAL: 8 716

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 316
news.nntp4.net 25
TOTAL: 2 341
TOTAL: 1 341

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp4 10520 14 10476 0 0 0 0%23:59:53
2aioe 3810 1 3756 1 0 0 0%23:59:56
TOTAL: 2 14330 15 14232 1 0 0 0%47:59:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp443.8 KB0.0 KB43.8 KB0.0 KB/s3.1 KB23:59:53
2aioe1.6 KB1.6 KB3.2 KB0.0 KB/s1.6 KB23:59:56
TOTAL: 245.4 KB1.6 KB47.0 KB0.0 KB/s2.9 KB47:59:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1colo-vultr-2.gslin.com1440 1440.7 KB 14 0 000:19:59
2122-116-104-21.hinet-ip.hinet.net 2 715.3 KB 4 0 000:01:08
TOTAL: 21442 2156.1 KB 18 0 000:21:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gslin.com1440 1440.7 KB 14 0 000:19:59
2*.hinet-ip.hinet.net 2 715.3 KB 4 0 000:01:08
TOTAL: 21442 2156.1 KB 18 0 000:21:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
colo-vultr-2.gslin.com 1.530 3.235 0.00000:19:59
122-116-104-21.hinet-ip.hinet.net 0.376 1.214 0.00000:01:08
TOTAL: 2 1.906 4.449 0.00000:21:07

Newsgroup request counts (by category):

CategoryCountPct
1comp 19 90.5%
2tw 2 9.5%
TOTAL: 2 21100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1comp.lang.c 14
2comp.lang.perl.misc 3
3tw.bbs.talk 2
4comp.lang.python.announce 1
5comp.lang.php 1
TOTAL: 5 21