Daily Usenet report

Jul 1 15:00:06 -- Jul 2 15:00:17

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jul 1 15:02:47 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jul 1 20:30:10 colo-sc-1 pgpverify[3037]: pgpverify: verification failed
Jul 2 03:55:38 colo-sc-1 pgpverify[9310]: pgpverify: verification failed
Jul 1 20:37:17.67Jul 1 20:40:27.185 + hasname-out.news.weretis.net <EIpDI.2551$5S.2000@fx02.iad> 2089 overview! aioe nntp4 inpaths!

Log entries by program:

Program nameLines%LinesSize%Size
inn 15679 79.6%1.9 MB 77.3%
innd 2174 11.0%312.8 KB 12.4%
innfeed 1225 6.2%177.4 KB 7.0%
cnfsstat 572 2.9%78.5 KB 3.1%
controlchan 24 0.1%5.0 KB 0.2%
nnrpd 8 0.0%0.8 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 19685 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 48275 47.7%
Positive hits 37890 37.4%
Do not exist 14743 14.6%
Cache misses 333 0.3%
TOTAL: 4 101241 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:18.950 0.0%348 0.000 54.454 2608.000
article cleanup00:00:00.111 0.0%14896 0.000 0.007 0.054
article logging00:00:00.905 0.0%15241 0.000 0.059 2.834
article parse00:00:00.241 0.0%29532 0.000 0.008 0.029
article write00:00:05.016 0.0%14289 0.000 0.351 12.398
artlog/artcncl00:00:00.011 0.0%348 0.000 0.032 0.167
data move00:00:00.062 0.0%110757 0.000 0.001 0.005
hisgrep/artcncl00:00:00.007 0.0%347 0.000 0.020 0.024
hishave/artcncl00:00:10.090 0.0%348 0.000 28.994 616.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:57.123 0.9%101994 0.001 7.619 43.026
history sync00:00:00.010 0.0%383 0.000 0.026 0.667
history write00:00:03.513 0.0%14895 0.000 0.236 4.288
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:36:35.715 99.0%107572 366.461 790.129 1950.811
nntp read00:00:00.743 0.0%111466 0.000 0.007 0.020
overview write00:00:00.055 0.0%14289 0.000 0.004 0.024
perl filter00:00:27.053 0.0%14895 0.786 1.816 30.486
python filter00:00:00.393 0.0%14895 0.000 0.026 0.082
site send00:00:02.505 0.0%42869 0.027 0.058 0.114
TOTAL: 23:50:54.08523:50:42.503100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%14261 0.000 0.002 0.037
article prepare00:00:00.000 0.0%531 0.000 0.000 0.000
article read00:00:01.234 0.0%420 0.000 2.938 1036.000
backlog stats00:00:00.035 0.0%64848 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.347 0.0%43535 0.000 0.008 0.041
data write00:00:00.807 0.0%29742 0.000 0.027 0.066
idle23:47:31.270100.0%64848 481.207 1320.800 3004.861
status file00:00:05.450 0.0%247 0.000 22.065 505.500
TOTAL: 23:47:42.19723:47:39.174100.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%2 0.000 0.000 0.000
TOTAL: 00:00:04.25400:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 166

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
hun-mnt@news.sztaki.hu001101
moderator@dana.de001101
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 26287 9338 16889 60 35%47:49:48
2news-out.aioe.org 4 11741 3355 8383 3 28%23:01:52
3news.nntp4.net 4 13673 1299 11868 506 9%22:44:24
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 16 51701 13992 37140 569 27%93:36:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net28.9 MB0.0 KB262.6 KB29.2 MB 99%3.2 KB
2news-out.aioe.org8.9 MB2.3 KB12.5 KB9.0 MB 99%2.7 KB
3news.nntp4.net4.0 MB0.0 KB5.6 MB9.6 MB 41%5.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 441.8 MB2.3 KB5.8 MB47.7 MB 87%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 1 15:00:06 - 15:59:59 937 6.5% 0.263.2 MB 7.4% 0.90
Jul 1 16:00:00 - 16:59:59 793 5.5% 0.222.2 MB 5.2% 0.63
Jul 1 17:00:00 - 17:59:59 724 5.0% 0.202.0 MB 4.7% 0.58
Jul 1 18:00:00 - 18:59:59 749 5.2% 0.211.9 MB 4.4% 0.53
Jul 1 19:00:00 - 19:59:59 711 5.0% 0.201.9 MB 4.5% 0.55
Jul 1 20:00:00 - 20:59:59 724 5.0% 0.202.3 MB 5.3% 0.65
Jul 1 21:00:00 - 21:59:59 556 3.9% 0.151.6 MB 3.9% 0.47
Jul 1 22:00:00 - 22:59:59 600 4.2% 0.171.8 MB 4.2% 0.50
Jul 1 23:00:00 - 23:59:59 405 2.8% 0.111.4 MB 3.2% 0.39
Jul 2 00:00:00 - 00:59:59 300 2.1% 0.081.2 MB 2.7% 0.33
Jul 2 01:00:00 - 01:59:59 324 2.3% 0.091.1 MB 2.5% 0.31
Jul 2 02:00:00 - 02:59:59 298 2.1% 0.08869.6 KB 2.0% 0.24
Jul 2 03:00:00 - 03:59:59 335 2.3% 0.091.2 MB 2.8% 0.34
Jul 2 04:00:00 - 04:59:59 286 2.0% 0.08937.5 KB 2.1% 0.26
Jul 2 05:00:00 - 05:59:59 661 4.6% 0.182.7 MB 6.4% 0.77
Jul 2 06:00:00 - 06:59:59 457 3.2% 0.131.4 MB 3.2% 0.39
Jul 2 07:00:00 - 07:59:59 522 3.6% 0.141.4 MB 3.3% 0.40
Jul 2 08:00:00 - 08:59:59 615 4.3% 0.171.4 MB 3.4% 0.41
Jul 2 09:00:00 - 09:59:59 747 5.2% 0.211.9 MB 4.4% 0.53
Jul 2 10:00:00 - 10:59:59 694 4.8% 0.191.9 MB 4.5% 0.54
Jul 2 11:00:00 - 11:59:59 630 4.4% 0.171.7 MB 4.0% 0.48
Jul 2 12:00:00 - 12:59:59 669 4.7% 0.191.8 MB 4.3% 0.52
Jul 2 13:00:00 - 13:59:59 813 5.7% 0.232.4 MB 5.7% 0.69
Jul 2 14:00:00 - 14:59:59 791 5.5% 0.222.4 MB 5.7% 0.70
Jul 2 15:00:00 - 15:00:17 20 0.1% 1.1873.4 KB 0.2% 4.32
TOTAL: 24:00:11 14361 100.0% 0.1742.6 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB755.3 MB 73.8% 1 0.21 56.83
ONEDEFAULT1024.0 MB916.4 MB 89.5% 3 0.21 56.98
THREEDEFAULT1024.0 MB759.7 MB 74.2% 1 0.21 57.14
TWODEFAULT1024.0 MB756.5 MB 73.9% 1 0.21 57.30
TOTAL: 4-4.0 GB3.1 GB 77.8% 6 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 591 5 0 0 1 0 0 0 585
2hasname-out.news.weretis.net 328 18 0 0 0 0 0 0 310
3news-out.aioe.org 50 0 0 1 0 0 0 0 49
TOTAL: 3 969 23 0 1 1 0 0 0 944

Unwanted newsgroups [Top 20]:

NewsgroupCount
muenster.test 15
chile.regiones.misc 3
alt.ufo 1
alt.electronics 1
braunschweig.test 1
jobs.misc 1
tnn.rec.dance 1
TOTAL: 7 23

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 533
EMP (phn path) 24
EMP (phl) 21
User-issued spam cancel 12
HTML Multipart 6
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 7 599

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 267
news-out.aioe.org 47
news.nntp4.net 31
TOTAL: 3 345
TOTAL: 1 345

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 385 385 0 0 0 0100%20:21:56
2aioe 10948 4 10703 0 0 1 0%23:50:23
3weretis 4909 0 4763 33 0 1 0%23:50:23
4nntp4 13116 0 12897 0 0 15 0%23:50:23
TOTAL: 4 29358 389 28363 33 0 17 1%91:53:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.3 MB0.0 KB1.3 MB0.0 KB/s3.4 KB20:21:56
2aioe9.3 KB0.0 KB9.3 KB0.0 KB/s2.3 KB23:50:23
3weretis0.0 KB218.8 KB218.8 KB0.0 KB/s6.6 KB23:50:23
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:50:23
TOTAL: 41.3 MB218.8 KB1.5 MB0.0 KB/s3.7 KB91:53:05
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.000 0.004 0.00000:00:03
tor-exit-14.zbau.f3netze.de 0.000 0.004 0.00000:00:00
TOTAL: 2 0.000 0.008 0.00000:00:04

NNRP no permission clients:

SystemConn
tor-exit-14.zbau.f3netze.de 1
news.nntp4.net 1
TOTAL: 2 2