Daily Usenet report

Apr 5 15:00:01 -- Apr 6 15:00:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Apr 5 15:01:35 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Apr 5 20:00:04 colo-sc-1 pgpverify[5377]: pgpverify: verification failed
Apr 5 20:00:04 colo-sc-1 pgpverify[5389]: pgpverify: verification failed
Apr 5 20:01:04 colo-sc-1 pgpverify[5841]: pgpverify: verification failed
Apr 5 20:01:05 colo-sc-1 pgpverify[5857]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 17053 74.3%2.0 MB 72.0%
innd 4119 18.0%541.9 KB 19.0%
innfeed 1160 5.1%163.8 KB 5.8%
cnfsstat 576 2.5%87.1 KB 3.1%
nnrpd 24 0.1%2.5 KB 0.1%
controlchan 5 0.0%0.4 KB 0.0%
pgpverify 4 0.0%0.5 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 8 22942 100.0%2.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 45074 44.0%
Positive hits 40633 39.7%
Do not exist 16663 16.3%
Cache misses 29 0.0%
TOTAL: 4 102399 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.064 0.0%71 0.000 14.986 103.667
article cleanup00:00:00.095 0.0%16771 0.000 0.006 0.037
article logging00:00:01.453 0.0%16985 0.000 0.086 7.069
article parse00:00:00.260 0.0%34951 0.000 0.007 0.027
article write00:00:01.540 0.0%13791 0.000 0.112 5.193
artlog/artcncl00:00:00.001 0.0%69 0.000 0.014 1.000
data move00:00:00.053 0.0%116274 0.000 0.000 0.005
hisgrep/artcncl00:00:00.000 0.0%70 0.000 0.000 0.000
hishave/artcncl00:00:00.082 0.0%71 0.000 1.155 16.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:46.475 0.1%103001 0.000 1.034 38.409
history sync00:00:00.159 0.0%323 0.000 0.492 72.500
history write00:00:02.669 0.0%16771 0.000 0.159 8.220
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:58:09.357 99.8%117880 309.717 732.010 2543.182
nntp read00:00:00.816 0.0%118190 0.000 0.007 0.021
overview write00:00:00.046 0.0%13791 0.000 0.003 0.029
perl filter00:00:18.465 0.0%16771 0.829 1.101 4.839
python filter00:00:00.422 0.0%16771 0.000 0.025 0.072
site send00:00:02.576 0.0%41377 0.013 0.062 0.104
TOTAL: 24:00:40.18824:00:25.533100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%13782 0.000 0.002 0.024
article prepare00:00:00.000 0.0%872 0.000 0.000 0.000
article read00:00:00.153 0.0%755 0.000 0.203 7.438
backlog stats00:00:00.046 0.0%71286 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.367 0.0%45375 0.000 0.008 0.034
data write00:00:00.833 0.0%31845 0.000 0.026 0.082
idle23:58:51.715100.0%71286 610.251 1211.061 3450.885
status file00:00:00.707 0.0%203 0.000 3.483 409.000
TOTAL: 23:58:57.88123:58:53.848100.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%5 0.000 0.000 0.000
TOTAL: 00:00:00.09400: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
group-admin@isc.org000400
TOTAL000400

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 3 27256 8495 17793 968 31%47:49:20
2news-out.aioe.org 5 13048 4988 8053 7 38%23:56:59
3news.nntp4.net 1 16190 196 14024 1970 1%23:29:56
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 10 56494 13679 39870 2945 24%95:16:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.8 MB0.0 KB1.8 MB29.6 MB 94%3.2 KB
2news-out.aioe.org12.6 MB0.0 KB9.7 KB12.6 MB 99%2.6 KB
3news.nntp4.net598.0 KB0.0 KB11.4 MB12.0 MB 4%5.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 441.0 MB0.0 KB13.2 MB54.2 MB 75%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 5 15:00:01 - 15:59:59 769 5.6% 0.212.2 MB 5.4% 0.63
Apr 5 16:00:00 - 16:59:59 675 4.9% 0.191.9 MB 4.7% 0.55
Apr 5 17:00:00 - 17:59:59 685 5.0% 0.191.9 MB 4.7% 0.55
Apr 5 18:00:00 - 18:59:59 690 5.0% 0.192.4 MB 5.7% 0.67
Apr 5 19:00:00 - 19:59:59 741 5.4% 0.212.2 MB 5.4% 0.63
Apr 5 20:00:00 - 20:59:59 665 4.8% 0.181.9 MB 4.6% 0.54
Apr 5 21:00:00 - 21:59:59 489 3.5% 0.141.4 MB 3.4% 0.39
Apr 5 22:00:00 - 22:59:59 419 3.0% 0.121.3 MB 3.0% 0.36
Apr 5 23:00:00 - 23:59:59 487 3.5% 0.141.5 MB 3.5% 0.41
Apr 6 00:00:00 - 00:59:59 327 2.4% 0.091.1 MB 2.6% 0.30
Apr 6 01:00:00 - 01:59:59 375 2.7% 0.101.2 MB 3.0% 0.35
Apr 6 02:00:00 - 02:59:59 286 2.1% 0.08932.0 KB 2.2% 0.26
Apr 6 03:00:00 - 03:59:59 247 1.8% 0.07818.8 KB 1.9% 0.23
Apr 6 04:00:00 - 04:59:59 303 2.2% 0.081.1 MB 2.6% 0.31
Apr 6 05:00:00 - 05:59:59 307 2.2% 0.09869.7 KB 2.1% 0.24
Apr 6 06:00:00 - 06:59:59 455 3.3% 0.131.3 MB 3.1% 0.37
Apr 6 07:00:00 - 07:59:59 610 4.4% 0.171.5 MB 3.7% 0.44
Apr 6 08:00:00 - 08:59:59 701 5.1% 0.191.8 MB 4.4% 0.52
Apr 6 09:00:00 - 09:59:59 602 4.4% 0.171.7 MB 4.2% 0.50
Apr 6 10:00:00 - 10:59:59 787 5.7% 0.222.1 MB 5.0% 0.59
Apr 6 11:00:00 - 11:59:59 648 4.7% 0.181.6 MB 4.0% 0.47
Apr 6 12:00:00 - 12:59:59 874 6.3% 0.242.9 MB 7.1% 0.83
Apr 6 13:00:00 - 13:59:59 823 6.0% 0.233.3 MB 8.0% 0.93
Apr 6 14:00:00 - 14:59:59 829 6.0% 0.232.4 MB 5.7% 0.67
Apr 6 15:00:00 - 15:00:01 1 0.0% 1.003.6 KB 0.0% 3.63
TOTAL: 24:00:00 13795 100.0% 0.1641.3 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB377.6 MB 36.9% 6 0.20 59.75
ONEDEFAULT1024.0 MB549.0 MB 53.6% 8 0.20 60.24
THREEDEFAULT1024.0 MB386.0 MB 37.7% 6 0.21 58.58
TWODEFAULT1024.0 MB377.2 MB 36.8% 6 0.21 58.41
TOTAL: 4-4.0 GB1.7 GB 41.3% 26 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 2004 178 0 0 1 0 0 0 1825
2hasname-out.news.weretis.net 1125 2 0 0 0 0 0 0 1123
3news-out.aioe.org 60 1 0 0 0 0 0 0 59
TOTAL: 3 3189 181 0 0 1 0 0 0 3007

Unwanted newsgroups [Top 20]:

NewsgroupCount
0.test 175
wolfsburg.test 1
hr.rec.music.classical 1
comp.infosystems.gemini 1
alt.electronics 1
panix.chat.politics 1
alt.penthouse.sex.first-time 1
TOTAL: 7 181

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) 1452
EMP (md5) 715
Too many newsgroups 460
EMP (phn nph) 135
HTML Multipart 14
Scoring filter 6
User-issued spam cancel 3
EMP (phl) 3
Binary: misplaced binary 2
Too many newsgroups (meow) 2
HTML post 1
TOTAL: 11 2793

INND no permission servers:

SystemConn
87.251.67.97 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 159
news-out.aioe.org 53
news.nntp4.net 2
TOTAL: 3 214
TOTAL: 1 214

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 718 718 0 0 0 0100%21:22:41
2aioe 9928 19 8571 1 0 0 0%23:59:53
3nntp4 15026 4 13596 0 0 0 0%23:59:53
4weretis 5413 0 5218 15 0 0 0%23:59:42
TOTAL: 4 31085 741 27385 16 0 0 2%93:22:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.4 MB0.0 KB2.4 MB0.0 KB/s3.4 KB21:22:41
2aioe70.6 KB14.3 KB84.9 KB0.0 KB/s4.2 KB23:59:53
3nntp49.3 KB0.0 KB9.3 KB0.0 KB/s2.3 KB23:59:53
4weretis0.0 KB84.9 KB84.9 KB0.0 KB/s5.7 KB23:59:42
TOTAL: 42.4 MB99.2 KB2.5 MB0.0 KB/s3.4 KB93:22:09
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.214.227 0.001 0.002 0.00000:00:00
45.135.232.80 0.002 0.002 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.001 0.001 0.00000:00:00
104.152.52.189 0.000 0.002 0.00000:00:00
TOTAL: 4 0.004 0.007 0.00000:00:00

NNRP no permission clients:

SystemConn
45.135.232.80 2
scanner-26.ch1.censys-scanner.com 1
104.152.52.189 1
192.241.214.227 1
TOTAL: 4 5