Daily Usenet report

Mar 22 16:26:19 -- Mar 23 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 22 16:26:54 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Mar 22 17:24:18 colo-sc-1 pgpverify[2435]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 58957 83.9%6.2 MB 83.8%
nnrpd 6789 9.7%657.9 KB 8.7%
innd 3708 5.3%466.6 KB 6.2%
innfeed 701 1.0%77.8 KB 1.0%
cnfsstat 136 0.2%18.1 KB 0.2%
controlchan 13 0.0%2.2 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 70306 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 57656 56.1%
Negative hits 32491 31.6%
Positive hits 11967 11.7%
Cache misses 580 0.6%
TOTAL: 4 102694 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.512 0.0%192 0.000 2.667 36.400
article cleanup00:00:00.323 0.0%57754 0.000 0.006 0.036
article logging00:00:01.898 0.0%58679 0.000 0.032 0.670
article parse00:00:00.806 0.0%121076 0.000 0.007 0.046
article write00:00:31.860 0.0%55018 0.000 0.579 11.480
artlog/artcncl00:00:00.001 0.0%187 0.000 0.005 0.008
data move00:00:00.076 0.0%122967 0.000 0.001 0.007
hisgrep/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
hishave/artcncl00:00:00.367 0.0%192 0.000 1.911 36.400
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:10.517 0.1%102502 0.000 0.688 11.800
history sync00:00:00.016 0.0%388 0.000 0.041 0.667
history write00:00:06.325 0.0%57447 0.000 0.110 7.310
hiswrite/artcncl00:00:00.001 0.0%140 0.000 0.007 0.008
idle22:17:43.577 99.8%116510 9.634 688.899 4223.620
nntp read00:00:01.179 0.0%119000 0.000 0.010 0.028
overview write00:00:00.165 0.0%55018 0.000 0.003 0.032
perl filter00:00:56.532 0.1%57446 0.886 0.984 7.672
python filter00:00:01.172 0.0%57447 0.000 0.020 0.100
site send00:00:05.608 0.0%157239 0.023 0.036 0.109
TOTAL: 22:21:01.85822:20:40.935100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.097 0.0%62304 0.000 0.002 0.024
article prepare00:00:00.000 0.0%8 0.000 0.000 0.000
article read00:00:00.000 0.0%1 0.000 0.000 0.000
backlog stats00:00:00.039 0.0%97059 0.000 0.000 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.432 0.0%70956 0.000 0.006 0.031
data write00:00:00.527 0.0%26141 0.000 0.020 0.077
idle22:19:20.605100.0%97059 12.111 827.956 5017.075
status file00:00:00.173 0.0%143 0.000 1.210 135.000
TOTAL: 22:19:27.58922:19:21.873100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:14:58.363 89.1%5448 152.750 164.898 3123.231
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.280 0.1%104849 0.000 0.012 0.222
readart00:00:00.044 0.0%8 0.000 5.500 43.000
TOTAL: 00:16:47.71800:14:59.687 89.3%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 138
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 157

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 8 56655 44069 10001 2585 77%20:56:52
2news-out.aioe.org 6 12436 10671 1656 109 85%22:03:07
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 16 69092 54741 11657 2694 79%42:59:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net123.6 MB626.9 KB7.5 MB131.7 MB 93%2.9 KB
2news-out.aioe.org29.2 MB125.6 KB262.3 KB29.6 MB 98%2.8 KB
3localhost1.0 KB0.0 KB0.0 KB1.0 KB100%1.0 KB
TOTAL: 3152.8 MB752.4 KB7.8 MB161.3 MB 94%2.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 22 16:26:19 - 16:59:59 380 0.7% 0.19923.9 KB 0.6% 0.46
Mar 22 17:00:00 - 17:59:59 41605 75.5% 11.56116.9 MB 75.9% 33.24
Mar 22 18:00:00 - 18:59:59 899 1.6% 0.252.2 MB 1.5% 0.64
Mar 22 19:00:00 - 19:59:59 789 1.4% 0.222.2 MB 1.5% 0.64
Mar 22 20:00:00 - 20:59:59 822 1.5% 0.232.2 MB 1.4% 0.62
Mar 22 21:00:00 - 21:59:59 757 1.4% 0.212.2 MB 1.5% 0.64
Mar 22 22:00:00 - 22:59:59 746 1.4% 0.212.4 MB 1.6% 0.69
Mar 22 23:00:00 - 23:59:59 481 0.9% 0.131.5 MB 1.0% 0.43
Mar 23 00:00:00 - 00:59:59 365 0.7% 0.101.1 MB 0.7% 0.31
Mar 23 01:00:00 - 01:59:59 366 0.7% 0.101.1 MB 0.7% 0.31
Mar 23 02:00:00 - 02:59:59 314 0.6% 0.091011.6 KB 0.6% 0.28
Mar 23 03:00:00 - 03:59:59 314 0.6% 0.091.1 MB 0.7% 0.32
Mar 23 04:00:00 - 04:59:59 274 0.5% 0.08793.8 KB 0.5% 0.22
Mar 23 05:00:00 - 05:59:59 318 0.6% 0.09961.7 KB 0.6% 0.27
Mar 23 06:00:00 - 06:59:59 340 0.6% 0.091.2 MB 0.8% 0.33
Mar 23 07:00:00 - 07:59:59 456 0.8% 0.131.2 MB 0.8% 0.35
Mar 23 08:00:00 - 08:59:59 754 1.4% 0.212.0 MB 1.3% 0.57
Mar 23 09:00:00 - 09:59:59 805 1.5% 0.222.0 MB 1.3% 0.57
Mar 23 10:00:00 - 10:59:59 893 1.6% 0.252.1 MB 1.4% 0.60
Mar 23 11:00:00 - 11:59:59 728 1.3% 0.201.8 MB 1.2% 0.52
Mar 23 12:00:00 - 12:59:59 804 1.5% 0.222.1 MB 1.4% 0.61
Mar 23 13:00:00 - 13:59:59 887 1.6% 0.252.2 MB 1.5% 0.64
Mar 23 14:00:00 - 15:00:01 1007 1.8% 0.282.6 MB 1.7% 0.73
TOTAL: 22:33:42 55104 100.0% 0.68153.9 MB 100.0% 1.94
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
ONEDEFAULT1024.0 MB797.9 MB 77.9% 1 3.43 3.54
TOTAL: 1-1024.0 MB797.9 MB 77.9% 1 3.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 3297 50 0 272 5 1 0 0 2969
2news-out.aioe.org 369 0 0 35 0 0 0 0 334
TOTAL: 2 3666 50 0 307 5 1 0 0 3303

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.hardware 14
mozilla.dev.apps.seamonkey 7
panix.chat.politics 6
list.postfix.users 3
mozilla.community.sweden 2
panix.test 2
panix.questions 1
borland.public.delphi.commandlinetools 1
0.test 1
alt.penthouse.sex.fetish.tickling 1
alt.canada.test 1
alt.sex.brunette 1
alt.sex.telephone.alt.sex.services 1
mozilla.dev.tech.svg 1
grk.comp.hardware 1
alt.new.cracks 1
alt.control.test 1
acs.test 1
alt.sex.telephone.alt 1
alt.sex.telephone.alt.sex.wanted 1
TOTAL: 22 50

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

GroupsCount
bit.listserv.catholic 4
alt.religion.psychedelic.moderated 1
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 951
EMP (phn path) 693
EMP (phl) 590
EMP (phn nph) 90
EMP (fsl) 14
Too many newsgroups 13
Scoring filter 9
Binary: misplaced binary 6
HTML Multipart 4
Too many newsgroups (meow) 3
HTML post 2
U2 violation - invalid distribution 1
TOTAL: 12 2376

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 667
news-out.aioe.org 260
TOTAL: 2 927
TOTAL: 1 927

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1aioe 36454 1 36384 0 0 15129 0%21:43:18
2nntp4 10889 1 10854 0 0 0 0%22:23:18
TOTAL: 2 47343 2 47238 0 0 15129 0%44:06:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1aioe1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB21:43:18
2nntp41.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB22:23:18
TOTAL: 22.1 KB0.0 KB2.1 KB0.0 KB/s1.0 KB44:06:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1colo-vultr-2.gslin.com1352 725.8 KB 7 0 000:15:37
2122-116-104-21.hinet-ip.hinet.net 2 10.7 KB 1 1 000:01:10
TOTAL: 21354 826.5 KB 8 1 000:16:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gslin.com1352 725.8 KB 7 0 000:15:37
2*.hinet-ip.hinet.net 2 10.7 KB 1 1 000:01:10
TOTAL: 21354 826.5 KB 8 1 000:16:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
colo-vultr-2.gslin.com 1.367 2.783 0.00000:15:37
122-116-104-21.hinet-ip.hinet.net 0.323 1.073 0.00000:01:10
TOTAL: 2 1.690 3.856 0.00000:16:47

Newsgroup request counts (by category):

CategoryCountPct
1comp 5 62.5%
2tw 3 37.5%
TOTAL: 2 8100.0%

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

NewsgroupCount
1comp.ai.philosophy 5
2tw.bbs.talk 3
TOTAL: 2 8