Daily Usenet report

Nov 1 15:00:02 -- Nov 2 15:00:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 1 15:01:14 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Nov 1 20:00:02 colo-sc-1 pgpverify[29327]: pgpverify: verification failed
Nov 1 20:00:02 colo-sc-1 controlchan[19802]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20211101200001$2726@isc.org>
Nov 1 20:00:03 colo-sc-1 pgpverify[29346]: pgpverify: verification failed
Nov 1 20:00:03 colo-sc-1 controlchan[19802]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20211101200002$0bfc@isc.org>

Log entries by program:

Program nameLines%LinesSize%Size
inn 16681 77.6%2.0 MB 75.2%
innd 3060 14.2%426.4 KB 15.5%
innfeed 1177 5.5%165.2 KB 6.0%
cnfsstat 576 2.7%88.8 KB 3.2%
nnrpd 4 0.0%0.4 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 8 21504 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 44183 43.7%
Positive hits 40666 40.2%
Do not exist 15900 15.7%
Cache misses 336 0.3%
TOTAL: 4 101085 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.138 0.0%330 0.000 6.479 75.000
article cleanup00:00:00.107 0.0%16008 0.000 0.007 0.038
article logging00:00:00.478 0.0%16348 0.000 0.029 0.121
article parse00:00:00.265 0.0%27790 0.000 0.010 0.033
article write00:00:02.210 0.0%14300 0.000 0.155 6.605
artlog/artcncl00:00:00.003 0.0%330 0.000 0.009 0.011
data move00:00:00.060 0.0%110347 0.000 0.001 0.004
hisgrep/artcncl00:00:00.007 0.0%327 0.000 0.021 0.025
hishave/artcncl00:00:00.284 0.0%330 0.000 0.861 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:30.700 0.0%101490 0.000 0.302 9.074
history sync00:00:00.261 0.0%331 0.000 0.789 122.500
history write00:00:03.433 0.0%16008 0.000 0.214 4.541
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:59:20.387 99.9%109786 289.856 786.625 2753.234
nntp read00:00:00.868 0.0%109821 0.000 0.008 0.018
overview write00:00:00.050 0.0%14300 0.000 0.003 0.029
perl filter00:00:20.523 0.0%16008 0.821 1.282 28.128
python filter00:00:00.415 0.0%16008 0.000 0.026 0.080
site send00:00:02.671 0.0%42901 0.016 0.062 0.113
TOTAL: 24:00:44.01424:00:24.860100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%14268 0.000 0.002 0.032
article prepare00:00:00.001 0.0%1065 0.000 0.001 0.040
article read00:00:00.044 0.0%721 0.000 0.061 1.000
backlog stats00:00:00.062 0.0%81391 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.434 0.0%49566 0.000 0.009 0.029
data write00:00:00.999 0.0%35536 0.000 0.028 0.071
idle23:58:35.814100.0%81391 413.142 1060.508 3261.125
status file00:00:02.044 0.0%216 0.000 9.463 346.800
TOTAL: 23:58:41.65823:58:39.430100.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.03200: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 27764 10691 16562 511 38%48:52:37
2news-out.aioe.org 3 13357 2941 10415 1 22%23:50:06
3news.nntp4.net 2 17296 735 15277 1284 4%26:10:17
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 58417 14367 42254 1796 24%98:53:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net35.2 MB0.0 KB998.0 KB36.2 MB 97%3.3 KB
2news-out.aioe.org7.9 MB0.0 KB1.2 KB7.9 MB 99%2.7 KB
3news.nntp4.net2.4 MB0.0 KB3.9 MB6.3 MB 38%3.2 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 445.5 MB0.0 KB4.9 MB50.4 MB 90%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 1 15:00:02 - 15:59:59 821 5.7% 0.232.6 MB 5.8% 0.74
Nov 1 16:00:00 - 16:59:59 871 6.1% 0.242.8 MB 6.3% 0.81
Nov 1 17:00:00 - 17:59:59 882 6.2% 0.242.5 MB 5.5% 0.70
Nov 1 18:00:00 - 18:59:59 729 5.1% 0.202.2 MB 4.9% 0.63
Nov 1 19:00:00 - 19:59:59 748 5.2% 0.212.3 MB 5.1% 0.66
Nov 1 20:00:00 - 20:59:59 767 5.4% 0.212.3 MB 5.1% 0.65
Nov 1 21:00:00 - 21:59:59 707 4.9% 0.202.3 MB 5.1% 0.66
Nov 1 22:00:00 - 22:59:59 637 4.5% 0.182.0 MB 4.5% 0.58
Nov 1 23:00:00 - 23:59:59 473 3.3% 0.131.5 MB 3.4% 0.43
Nov 2 00:00:00 - 00:59:59 519 3.6% 0.141.9 MB 4.3% 0.55
Nov 2 01:00:00 - 01:59:59 295 2.1% 0.081.3 MB 2.8% 0.36
Nov 2 02:00:00 - 02:59:59 241 1.7% 0.07773.6 KB 1.7% 0.21
Nov 2 03:00:00 - 03:59:59 227 1.6% 0.06922.8 KB 2.0% 0.26
Nov 2 04:00:00 - 04:59:59 207 1.4% 0.06735.9 KB 1.6% 0.20
Nov 2 05:00:00 - 05:59:59 287 2.0% 0.08894.9 KB 1.9% 0.25
Nov 2 06:00:00 - 06:59:59 633 4.4% 0.182.9 MB 6.5% 0.84
Nov 2 07:00:00 - 07:59:59 397 2.8% 0.111.0 MB 2.3% 0.30
Nov 2 08:00:00 - 08:59:59 649 4.5% 0.182.0 MB 4.4% 0.56
Nov 2 09:00:00 - 09:59:59 672 4.7% 0.191.9 MB 4.2% 0.53
Nov 2 10:00:00 - 10:59:59 568 4.0% 0.161.5 MB 3.3% 0.42
Nov 2 11:00:00 - 11:59:59 663 4.6% 0.181.8 MB 4.0% 0.52
Nov 2 12:00:00 - 12:59:59 746 5.2% 0.212.2 MB 4.9% 0.63
Nov 2 13:00:00 - 13:59:59 733 5.1% 0.202.0 MB 4.4% 0.56
Nov 2 14:00:00 - 14:59:59 815 5.7% 0.232.8 MB 6.1% 0.79
Nov 2 15:00:00 - 15:00:02 3 0.0% 1.505.7 KB 0.0% 2.85
TOTAL: 24:00:00 14290 100.0% 0.1745.1 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB797.0 MB 77.8% 3 0.22 56.40
ONEDEFAULT1024.0 MB958.6 MB 93.6% 5 0.22 56.00
THREEDEFAULT1024.0 MB800.6 MB 78.2% 3 0.22 54.61
TWODEFAULT1024.0 MB793.3 MB 77.5% 3 0.22 53.95
TOTAL: 4-4.0 GB3.3 GB 81.8% 14 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1206 5 0 0 1 0 0 0 1200
2hasname-out.news.weretis.net 825 11 0 0 0 0 0 0 814
3news-out.aioe.org 30 0 0 0 0 0 0 0 30
TOTAL: 3 2061 16 0 0 1 0 0 0 2044

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 6
rwth.general 1
comp.infosystems.gemini 1
alt.bestjobsusa.philly.jobs 1
alt.electronics 1
opennews.support 1
alt.atheist 1
alt.bestjobsusa.jobs.offered 1
list.postfix.users 1
alt.fun 1
panix.chat.politics 1
TOTAL: 11 16

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 752
EMP (md5) 747
EMP (phn nph) 111
User-issued spam cancel 36
EMP (phl) 30
Too many newsgroups 23
HTML Multipart 2
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 9 1704

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 310
news-out.aioe.org 29
news.nntp4.net 1
TOTAL: 3 340
TOTAL: 1 340

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 616 616 0 0 0 0100%21:03:45
2aioe 14120 50 11201 2 0 1 0%24:09:48
3nntp4 16550 4 13687 0 0 1 0%24:07:54
4weretis 3771 1 3582 57 0 0 0%24:00:40
TOTAL: 4 35057 671 28470 59 0 2 1%93:22:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.4 MB0.0 KB2.4 MB0.0 KB/s4.1 KB21:03:45
2aioe153.5 KB6.2 KB159.6 KB0.0 KB/s3.1 KB24:09:48
3nntp428.8 KB0.0 KB28.8 KB0.0 KB/s7.2 KB24:07:54
4weretis11.0 KB279.7 KB290.7 KB0.0 KB/s5.0 KB24:00:40
TOTAL: 42.6 MB285.8 KB2.9 MB0.0 KB/s4.1 KB93:22:07
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-26.ch1.censys-scanner.com 0.002 0.001 0.00000:00:00
TOTAL: 1 0.002 0.001 0.00000:00:00

NNRP no permission clients:

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