Daily Usenet report

Dec 23 15:00:02 -- Dec 24 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 23 15:01:06 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16538 73.3%2.0 MB 71.1%
innd 4114 18.2%561.5 KB 19.7%
innfeed 1208 5.4%158.5 KB 5.6%
cnfsstat 576 2.6%88.8 KB 3.1%
nnrpd 114 0.5%11.9 KB 0.4%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 22552 100.0%2.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 44686 43.9%
Positive hits 40942 40.2%
Do not exist 16050 15.8%
Cache misses 49 0.0%
TOTAL: 4 101727 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.050 0.0%65 0.000 31.538 165.417
article cleanup00:00:00.095 0.0%16177 0.000 0.006 0.059
article logging00:00:00.450 0.0%16519 0.000 0.027 0.079
article parse00:00:00.239 0.0%29427 0.000 0.008 0.031
article write00:00:03.225 0.0%13476 0.000 0.239 18.383
artlog/artcncl00:00:00.001 0.0%64 0.000 0.016 0.333
data move00:00:00.049 0.0%113370 0.000 0.000 0.006
hisgrep/artcncl00:00:00.001 0.0%60 0.000 0.017 1.000
hishave/artcncl00:00:00.000 0.0%65 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:22.106 0.0%102490 0.000 0.216 10.053
history sync00:00:00.017 0.0%349 0.000 0.049 0.500
history write00:00:04.195 0.0%16177 0.000 0.259 15.958
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:59:40.043 99.9%113528 398.611 760.870 2716.186
nntp read00:00:00.847 0.0%113535 0.000 0.007 0.019
overview write00:00:00.047 0.0%13476 0.000 0.003 0.025
perl filter00:00:18.949 0.0%16177 0.793 1.171 9.149
python filter00:00:00.405 0.0%16177 0.000 0.025 0.075
site send00:00:02.393 0.0%40427 0.021 0.059 0.122
TOTAL: 24:00:52.72724:00:35.112100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%13422 0.000 0.002 0.029
article prepare00:00:00.000 0.0%918 0.000 0.000 0.000
article read00:00:00.305 0.0%517 0.000 0.590 72.250
backlog stats00:00:00.037 0.0%78096 0.000 0.000 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.369 0.0%46820 0.000 0.008 0.025
data write00:00:00.908 0.0%33660 0.000 0.027 0.073
idle23:58:01.110100.0%78096 614.095 1104.808 2595.389
status file00:00:01.838 0.0%231 0.000 7.957 389.250
TOTAL: 23:58:06.65823:58:04.595100.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%25 0.000 0.000 0.000
TOTAL: 00:00:01.75900: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 5 27586 7711 18434 1441 27%47:35:05
2news-out.aioe.org 4 13027 5220 7794 13 40%23:54:04
3news.nntp4.net 2 17093 347 15431 1315 2%24:59:43
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 57706 13278 41659 2769 23%96:28:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.4 MB0.0 KB3.3 MB29.7 MB 88%3.3 KB
2news-out.aioe.org13.6 MB0.0 KB23.8 KB13.7 MB 99%2.7 KB
3news.nntp4.net1.0 MB0.0 KB3.3 MB4.4 MB 23%2.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 441.1 MB0.0 KB6.7 MB47.8 MB 86%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 23 15:00:02 - 15:59:59 732 5.4% 0.201.9 MB 4.7% 0.55
Dec 23 16:00:00 - 16:59:59 827 6.2% 0.232.5 MB 5.9% 0.70
Dec 23 17:00:00 - 17:59:59 798 5.9% 0.222.5 MB 6.0% 0.70
Dec 23 18:00:00 - 18:59:59 713 5.3% 0.202.1 MB 5.0% 0.59
Dec 23 19:00:00 - 19:59:59 677 5.0% 0.192.4 MB 5.7% 0.68
Dec 23 20:00:00 - 20:59:59 666 5.0% 0.182.0 MB 4.9% 0.58
Dec 23 21:00:00 - 21:59:59 645 4.8% 0.182.3 MB 5.5% 0.65
Dec 23 22:00:00 - 22:59:59 593 4.4% 0.161.8 MB 4.3% 0.51
Dec 23 23:00:00 - 23:59:59 575 4.3% 0.162.2 MB 5.4% 0.63
Dec 24 00:00:00 - 00:59:59 421 3.1% 0.121.5 MB 3.6% 0.43
Dec 24 01:00:00 - 01:59:59 381 2.8% 0.111.5 MB 3.6% 0.42
Dec 24 02:00:00 - 02:59:59 326 2.4% 0.091.1 MB 2.6% 0.30
Dec 24 03:00:00 - 03:59:59 276 2.1% 0.08828.0 KB 2.0% 0.23
Dec 24 04:00:00 - 04:59:59 206 1.5% 0.06854.4 KB 2.0% 0.24
Dec 24 05:00:00 - 05:59:59 309 2.3% 0.09994.8 KB 2.4% 0.28
Dec 24 06:00:00 - 06:59:59 273 2.0% 0.08740.4 KB 1.7% 0.21
Dec 24 07:00:00 - 07:59:59 438 3.3% 0.121.2 MB 3.0% 0.35
Dec 24 08:00:00 - 08:59:59 594 4.4% 0.171.8 MB 4.3% 0.50
Dec 24 09:00:00 - 09:59:59 655 4.9% 0.181.8 MB 4.3% 0.51
Dec 24 10:00:00 - 10:59:59 663 4.9% 0.182.2 MB 5.3% 0.62
Dec 24 11:00:00 - 11:59:59 709 5.3% 0.201.9 MB 4.7% 0.55
Dec 24 12:00:00 - 12:59:59 641 4.8% 0.181.8 MB 4.2% 0.50
Dec 24 13:00:00 - 13:59:59 601 4.5% 0.171.7 MB 4.0% 0.47
Dec 24 14:00:00 - 14:59:59 718 5.3% 0.201.9 MB 4.7% 0.55
Dec 24 15:00:00 - 15:00:01 1 0.0% 1.001.8 KB 0.0% 1.80
TOTAL: 23:59:59 13438 100.0% 0.1641.3 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB655.0 MB 64.0% 4 0.20 60.35
ONEDEFAULT1024.0 MB819.5 MB 80.0% 6 0.20 59.47
THREEDEFAULT1024.0 MB661.8 MB 64.6% 4 0.20 60.42
TWODEFAULT1024.0 MB654.3 MB 63.9% 4 0.20 59.57
TOTAL: 4-4.0 GB2.7 GB 68.1% 18 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 1709 0 0 0 0 0 0 0 1709
2news.nntp4.net 1225 0 0 0 1 0 0 0 1224
3news-out.aioe.org 102 0 0 0 0 0 0 0 102
TOTAL: 3 3036 0 0 0 1 0 0 0 3035

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) 2102
EMP (md5) 424
EMP (phn nph) 121
EMP (phl) 29
Too many newsgroups 7
User-issued spam cancel 6
HTML Multipart 2
HTML post 1
Binary: misplaced binary 1
Scoring filter 1
TOTAL: 10 2694

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 252
news-out.aioe.org 89
TOTAL: 2 341
TOTAL: 1 341

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 390 390 0 0 0 0100%20:47:01
2aioe 10919 88 7917 4 0 0 0%23:59:39
3nntp4 16165 5 13097 0 0 3 0%23:59:50
4weretis 5679 0 5615 35 0 0 0%23:59:56
TOTAL: 4 33153 483 26629 39 0 3 1%92:46:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.5 MB0.0 KB1.5 MB0.0 KB/s3.8 KB20:47:01
2aioe385.8 KB12.0 KB397.8 KB0.0 KB/s4.3 KB23:59:39
3nntp413.7 KB0.0 KB13.7 KB0.0 KB/s2.7 KB23:59:50
4weretis0.0 KB135.9 KB135.9 KB0.0 KB/s3.9 KB23:59:56
TOTAL: 41.8 MB148.0 KB2.0 MB0.0 KB/s3.9 KB92:46:26
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.002 0.004 0.00000:00:01
188.166.78.111 0.003 0.015 0.00000:00:00
sh-ams-nl-gp1-wk116.internet-census.org 0.005 0.013 0.00000:00:00
185.220.101.154 0.002 0.002 0.00000:00:00
tor-exit-15.zbau.f3netze.de 0.000 0.003 0.00000:00:00
5.188.206.138 0.000 0.005 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.001 0.002 0.00000:00:00
43.131.91.178 0.000 0.003 0.00000:00:00
223.71.167.165 0.002 0.003 0.00000:00:00
TOTAL: 9 0.015 0.050 0.00000:00:01

NNRP no permission clients:

SystemConn
188.166.78.111 8
sh-ams-nl-gp1-wk116.internet-census.org 7
223.71.167.165 2
5.188.206.138 2
news.nntp4.net 2
scanner-08.ch1.censys-scanner.com 1
tor-exit-15.zbau.f3netze.de 1
185.220.101.154 1
43.131.91.178 1
TOTAL: 9 25