Daily Usenet report

Jun 4 15:00:01 -- Jun 5 15:00:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jun 4 15:01:16 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jun 4 21:35:31 colo-sc-1 pgpverify[3163]: pgpverify: verification failed
Jun 4 21:36:27 colo-sc-1 pgpverify[3269]: pgpverify: verification failed
Jun 4 21:36:40 colo-sc-1 pgpverify[3299]: pgpverify: verification failed
Jun 4 21:36:53 colo-sc-1 pgpverify[3328]: pgpverify: verification failed
Jun 4 21:37:03 colo-sc-1 pgpverify[3354]: pgpverify: verification failed
Jun 4 21:38:05 colo-sc-1 pgpverify[3614]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 10997 73.4%1.3 MB 70.1%
innd 2061 13.8%301.8 KB 15.5%
innfeed 1279 8.5%184.9 KB 9.5%
cnfsstat 576 3.8%87.9 KB 4.5%
nnrpd 37 0.2%4.1 KB 0.2%
controlchan 17 0.1%3.2 KB 0.2%
pgpverify 6 0.0%0.7 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 14974 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 28487 42.2%
Negative hits 28237 41.8%
Do not exist 10751 15.9%
Cache misses 26 0.0%
TOTAL: 4 67501 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.785 0.0%54 0.000 14.537 74.900
article cleanup00:00:00.056 0.0%10804 0.000 0.005 0.053
article logging00:00:00.331 0.0%10935 0.000 0.030 0.095
article parse00:00:00.198 0.0%23957 0.000 0.008 0.043
article write00:00:01.019 0.0%10093 0.000 0.101 5.576
artlog/artcncl00:00:00.002 0.0%54 0.000 0.037 1.000
data move00:00:00.043 0.0%77221 0.000 0.001 0.008
hisgrep/artcncl00:00:00.001 0.0%52 0.000 0.019 1.000
hishave/artcncl00:00:00.000 0.0%54 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.250 0.0%67829 0.000 0.136 2.885
history sync00:00:00.010 0.0%330 0.000 0.030 1.000
history write00:00:02.424 0.0%10804 0.000 0.224 19.386
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle24:00:03.098100.0%78718 548.638 1097.628 3799.057
nntp read00:00:00.563 0.0%78591 0.000 0.007 0.025
overview write00:00:00.034 0.0%10093 0.000 0.003 0.045
perl filter00:00:12.583 0.0%10804 0.745 1.165 5.371
python filter00:00:00.297 0.0%10804 0.000 0.027 0.095
site send00:00:01.605 0.0%30285 0.016 0.053 0.101
TOTAL: 24:00:42.16124:00:32.299100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%10209 0.000 0.002 0.037
article prepare00:00:00.001 0.0%725 0.000 0.001 0.059
article read00:00:00.008 0.0%358 0.000 0.022 1.000
backlog stats00:00:00.044 0.0%58973 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.271 0.0%34566 0.000 0.008 0.025
data write00:00:00.664 0.0%24792 0.000 0.027 0.085
idle23:57:28.595100.0%58973 798.407 1462.510 3266.832
status file00:00:00.099 0.0%278 0.000 0.356 8.400
TOTAL: 23:57:31.35223:57:29.706100.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.001 0.2%9 0.000 0.111 1.000
TOTAL: 00:00:00.62800:00:00.001 0.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001601
TOTAL001601

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 14 18989 6900 11988 101 36%48:18:11
2news-out.aioe.org 1 10255 3123 7132 0 30%24:57:12
3news.nntp4.net 1 11023 189 10185 649 1%24:21:36
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 17 40267 10212 29305 750 25%97:36:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net21.5 MB0.0 KB174.9 KB21.7 MB 99%3.2 KB
2news-out.aioe.org7.6 MB0.0 KB0.0 KB7.6 MB100%2.5 KB
3news.nntp4.net617.0 KB0.0 KB9.1 MB9.7 MB 6%11.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 429.7 MB0.0 KB9.3 MB39.0 MB 76%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 15:00:01 - 15:59:59 561 5.6% 0.161.6 MB 5.4% 0.45
Jun 4 16:00:00 - 16:59:59 614 6.1% 0.171.8 MB 6.2% 0.52
Jun 4 17:00:00 - 17:59:59 536 5.3% 0.151.5 MB 4.9% 0.41
Jun 4 18:00:00 - 18:59:59 531 5.3% 0.151.4 MB 4.6% 0.39
Jun 4 19:00:00 - 19:59:59 581 5.8% 0.161.8 MB 6.2% 0.52
Jun 4 20:00:00 - 20:59:59 503 5.0% 0.141.4 MB 4.9% 0.41
Jun 4 21:00:00 - 21:59:59 402 4.0% 0.111.3 MB 4.5% 0.38
Jun 4 22:00:00 - 22:59:59 319 3.2% 0.091.1 MB 3.7% 0.31
Jun 4 23:00:00 - 23:59:59 279 2.8% 0.081.0 MB 3.5% 0.29
Jun 5 00:00:00 - 00:59:59 221 2.2% 0.061.1 MB 3.7% 0.31
Jun 5 01:00:00 - 01:59:59 439 4.3% 0.121.4 MB 4.6% 0.39
Jun 5 02:00:00 - 02:59:59 224 2.2% 0.06803.6 KB 2.7% 0.22
Jun 5 03:00:00 - 03:59:59 218 2.2% 0.06650.0 KB 2.2% 0.18
Jun 5 04:00:00 - 04:59:59 227 2.2% 0.06708.3 KB 2.3% 0.20
Jun 5 05:00:00 - 05:59:59 278 2.8% 0.08904.3 KB 3.0% 0.25
Jun 5 06:00:00 - 06:59:59 253 2.5% 0.07629.9 KB 2.1% 0.17
Jun 5 07:00:00 - 07:59:59 373 3.7% 0.101.1 MB 3.7% 0.31
Jun 5 08:00:00 - 08:59:59 476 4.7% 0.131.1 MB 3.7% 0.31
Jun 5 09:00:00 - 09:59:59 486 4.8% 0.141.4 MB 4.7% 0.39
Jun 5 10:00:00 - 10:59:59 525 5.2% 0.151.3 MB 4.5% 0.38
Jun 5 11:00:00 - 11:59:59 525 5.2% 0.151.3 MB 4.5% 0.38
Jun 5 12:00:00 - 12:59:59 501 5.0% 0.141.1 MB 3.9% 0.32
Jun 5 13:00:00 - 13:59:59 502 5.0% 0.141.2 MB 4.1% 0.35
Jun 5 14:00:00 - 15:00:01 528 5.2% 0.151.9 MB 6.3% 0.53
TOTAL: 24:00:00 10102 100.0% 0.1229.5 MB 100.0% 0.35
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB251.9 MB 24.6% 7 0.15 81.68
ONEDEFAULT1024.0 MB427.0 MB 41.7% 9 0.15 80.71
THREEDEFAULT1024.0 MB262.9 MB 25.7% 7 0.14 83.90
TWODEFAULT1024.0 MB254.5 MB 24.9% 7 0.15 82.01
TOTAL: 4-4.0 GB1.2 GB 29.2% 30 0.15-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 607 8 0 0 1 0 0 0 598
2hasname-out.news.weretis.net 210 4 0 0 0 0 0 0 206
3news-out.aioe.org 24 0 0 0 0 0 0 0 24
TOTAL: 3 841 12 0 0 1 0 0 0 828

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.math 3
free.it.satellite.dreambox 2
alive.school.college.spanish 1
alt.sex.female 1
comp.infosystems.gemini 1
americast.usa-today.money 1
alt.books.marketplace 1
wolfsburg.test 1
gun.general 1
TOTAL: 9 12

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 319
EMP (phn path) 189
EMP (phn nph) 150
EMP (phl) 34
HTML Multipart 4
Scoring filter 1
TOTAL: 6 697

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 107
news-out.aioe.org 24
TOTAL: 2 131
TOTAL: 1 131

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 249 249 0 0 0 0100%16:59:15
2aioe 8897 96 6818 13 0 0 1%23:59:57
3nntp4 12127 5 9909 1 0 134 0%23:59:42
4weretis 3250 1 3138 4 0 0 0%23:59:32
TOTAL: 4 24523 351 19865 18 0 134 1%88:58:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.2 MB0.0 KB1.2 MB0.0 KB/s5.0 KB16:59:15
2aioe306.0 KB33.5 KB339.4 KB0.0 KB/s3.1 KB23:59:57
3nntp410.3 KB2.7 KB13.0 KB0.0 KB/s2.2 KB23:59:42
4weretis2.9 KB41.5 KB44.4 KB0.0 KB/s8.9 KB23:59:32
TOTAL: 41.5 MB77.7 KB1.6 MB0.0 KB/s4.5 KB88:58:26
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-ams-nl-gp1-wk128.internet-census.org 0.007 0.009 0.00000:00:00
192.241.206.14 0.002 0.001 0.00000:00:00
zl-ams-nl-gp1-wk128e.internet-census.org 0.000 0.002 0.00000:00:00
TOTAL: 3 0.009 0.012 0.00000:00:00

NNRP no permission clients:

SystemConn
zl-ams-nl-gp1-wk128.internet-census.org 7
zl-ams-nl-gp1-wk128e.internet-census.org 1
192.241.206.14 1
TOTAL: 3 9