Daily Usenet report

Sep 13 15:00:01 -- Sep 14 15:00:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 13 15:01:00 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Sep 13 20:31:17 colo-sc-1 pgpverify[17282]: pgpverify: verification failed
Sep 13 20:31:27 colo-sc-1 pgpverify[17307]: pgpverify: verification failed
Sep 13 20:32:11 colo-sc-1 pgpverify[17393]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 13768 75.2%1.7 MB 72.5%
innd 2642 14.4%377.1 KB 16.0%
innfeed 1270 6.9%179.6 KB 7.6%
cnfsstat 576 3.1%82.0 KB 3.5%
nnrpd 46 0.3%5.0 KB 0.2%
controlchan 14 0.1%3.0 KB 0.1%
pgpverify 3 0.0%0.4 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 18320 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 34981 45.5%
Negative hits 28441 37.0%
Do not exist 13281 17.3%
Cache misses 233 0.3%
TOTAL: 4 76936 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.906 0.0%51 0.000 17.765 128.000
article cleanup00:00:00.093 0.0%13421 0.000 0.007 0.042
article logging00:00:00.424 0.0%13756 0.000 0.031 0.096
article parse00:00:00.222 0.0%22815 0.000 0.010 0.049
article write00:00:01.807 0.0%12134 0.000 0.149 22.000
artlog/artcncl00:00:00.000 0.0%51 0.000 0.000 0.000
data move00:00:00.039 0.0%85268 0.000 0.000 0.005
hisgrep/artcncl00:00:00.000 0.0%48 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%51 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.086 0.0%77681 0.000 0.027 1.472
history sync00:00:00.016 0.0%338 0.000 0.047 0.500
history write00:00:05.657 0.0%13421 0.000 0.422 12.189
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle24:00:06.586 99.9%85828 514.108 1006.741 3391.045
nntp read00:00:00.652 0.0%85675 0.000 0.008 0.017
overview write00:00:00.052 0.0%12134 0.000 0.004 0.038
perl filter00:00:14.517 0.0%13421 0.750 1.082 3.524
python filter00:00:00.406 0.0%13421 0.000 0.030 0.093
site send00:00:02.019 0.0%36405 0.021 0.055 0.107
TOTAL: 24:00:50.21624:00:35.482100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.034 0.0%12094 0.000 0.003 0.024
article prepare00:00:00.000 0.0%915 0.000 0.000 0.000
article read00:00:00.021 0.0%469 0.000 0.045 1.000
backlog stats00:00:00.057 0.0%78562 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.349 0.0%44762 0.000 0.008 0.028
data write00:00:00.888 0.0%32761 0.000 0.027 0.084
idle23:57:58.120100.0%78562 603.398 1098.217 3476.353
status file00:00:01.046 0.0%266 0.000 3.932 245.750
TOTAL: 23:58:02.43023:58:00.515100.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%11 0.000 0.000 0.000
TOTAL: 00:00:00.47500: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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001301
TOTAL001301

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 9 23676 8496 14571 609 35%48:08:29
2news-out.aioe.org 2 11905 3377 8523 5 28%23:57:04
3news.nntp4.net 2 16241 189 15306 746 1%29:29:32
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 14 51822 12062 38400 1360 23%101:35:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.6 MB0.0 KB1.3 MB27.9 MB 95%3.1 KB
2news-out.aioe.org8.0 MB0.0 KB11.3 KB8.0 MB 99%2.4 KB
3news.nntp4.net1.1 MB0.0 KB2.3 MB3.4 MB 31%3.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 435.6 MB0.0 KB3.6 MB39.3 MB 90%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 13 15:00:01 - 15:59:59 791 6.5% 0.222.3 MB 6.6% 0.67
Sep 13 16:00:00 - 16:59:59 621 5.1% 0.172.0 MB 5.6% 0.56
Sep 13 17:00:00 - 17:59:59 611 5.0% 0.171.8 MB 5.0% 0.50
Sep 13 18:00:00 - 18:59:59 672 5.5% 0.191.8 MB 5.2% 0.52
Sep 13 19:00:00 - 19:59:59 587 4.8% 0.161.8 MB 5.2% 0.52
Sep 13 20:00:00 - 20:59:59 565 4.7% 0.161.5 MB 4.4% 0.44
Sep 13 21:00:00 - 21:59:59 464 3.8% 0.131.5 MB 4.4% 0.44
Sep 13 22:00:00 - 22:59:59 380 3.1% 0.111.2 MB 3.4% 0.34
Sep 13 23:00:00 - 23:59:59 274 2.3% 0.081.0 MB 3.0% 0.30
Sep 14 00:00:00 - 00:59:59 293 2.4% 0.08968.7 KB 2.7% 0.27
Sep 14 01:00:00 - 01:59:59 264 2.2% 0.071.1 MB 3.0% 0.30
Sep 14 02:00:00 - 02:59:59 233 1.9% 0.06832.8 KB 2.3% 0.23
Sep 14 03:00:00 - 03:59:59 218 1.8% 0.06803.6 KB 2.2% 0.22
Sep 14 04:00:00 - 04:59:59 236 1.9% 0.07723.0 KB 2.0% 0.20
Sep 14 05:00:00 - 05:59:59 331 2.7% 0.091019.6 KB 2.8% 0.28
Sep 14 06:00:00 - 06:59:59 437 3.6% 0.121.1 MB 3.1% 0.31
Sep 14 07:00:00 - 07:59:59 561 4.6% 0.161.6 MB 4.5% 0.45
Sep 14 08:00:00 - 08:59:59 697 5.8% 0.191.8 MB 5.1% 0.51
Sep 14 09:00:00 - 09:59:59 570 4.7% 0.161.5 MB 4.3% 0.44
Sep 14 10:00:00 - 10:59:59 531 4.4% 0.151.3 MB 3.6% 0.36
Sep 14 11:00:00 - 11:59:59 657 5.4% 0.181.7 MB 4.7% 0.47
Sep 14 12:00:00 - 12:59:59 666 5.5% 0.181.8 MB 5.2% 0.52
Sep 14 13:00:00 - 13:59:59 707 5.8% 0.202.2 MB 6.1% 0.62
Sep 14 14:00:00 - 15:00:01 743 6.1% 0.212.0 MB 5.7% 0.57
TOTAL: 24:00:00 12109 100.0% 0.1435.4 MB 100.0% 0.42
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB704.0 MB 68.7% 8 0.18 68.85
ONEDEFAULT1024.0 MB881.3 MB 86.1% 10 0.18 69.22
THREEDEFAULT1024.0 MB717.2 MB 70.0% 8 0.18 68.66
TWODEFAULT1024.0 MB712.0 MB 69.5% 8 0.18 67.21
TOTAL: 4-4.0 GB2.9 GB 73.6% 34 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 881 3 0 0 0 0 0 0 878
2news.nntp4.net 661 15 0 0 1 0 0 0 645
3news-out.aioe.org 65 0 0 0 0 0 0 0 65
TOTAL: 3 1607 18 0 0 1 0 0 0 1588

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat 8
alt.culture 2
wolfsburg.test 2
panix.test 2
alt.2600.cracks 1
weblogic.developer.interest.workshop 1
alt.test.abc 1
clari.local.georgia.briefs 1
TOTAL: 8 18

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) 570
EMP (md5) 382
EMP (phl) 168
EMP (phn nph) 125
Scoring filter 5
HTML Multipart 2
Too many newsgroups (meow) 1
Too many newsgroups 1
Angle-bracket bot 1
TOTAL: 9 1255

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 272
news-out.aioe.org 60
news.nntp4.net 1
TOTAL: 3 333
TOTAL: 1 333

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 324 324 0 0 0 0100%20:07:17
2aioe 11573 120 8350 9 0 0 1%23:59:57
3nntp4 15400 11 11941 0 0 0 0%23:59:57
4weretis 4967 2 3557 6 0 0 0%23:59:57
TOTAL: 4 32264 457 23848 15 0 0 1%92:07:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.9 MB0.0 KB1.9 MB0.0 KB/s6.0 KB20:07:17
2aioe357.2 KB14.0 KB371.2 KB0.0 KB/s2.9 KB23:59:57
3nntp446.1 KB0.0 KB46.1 KB0.0 KB/s4.2 KB23:59:57
4weretis2.5 KB11.9 KB14.4 KB0.0 KB/s1.8 KB23:59:57
TOTAL: 42.3 MB25.9 KB2.3 MB0.0 KB/s5.0 KB92:07:08
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-ams-nl-gp1-wk118.internet-census.org 0.006 0.013 0.00000:00:00
107.172.214.60 0.001 0.001 0.00000:00:00
zl-ams-nl-gp1-wk118d.internet-census.org 0.000 0.002 0.00000:00:00
192.241.206.78 0.002 0.000 0.00000:00:00
TOTAL: 4 0.009 0.016 0.00000:00:00

NNRP no permission clients:

SystemConn
zl-ams-nl-gp1-wk118.internet-census.org 8
192.241.206.78 1
107.172.214.60 1
zl-ams-nl-gp1-wk118d.internet-census.org 1
TOTAL: 4 11