Daily Usenet report

May 10 15:00:01 -- May 11 15:00:02

Unknown entries from news log file:

First 50 / 727 lines (6.9%)

May 10 15:00:46 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 10 15:02:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:04:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:06:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:08:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:10:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:12:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:14:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:16:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:18:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:20:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:22:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:24:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:26:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:28:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:32:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:34:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:36:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:38:05 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 10 15:40:29 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:42:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:44:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:46:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:48:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:50:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:52:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:54:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:56:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 15:58:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:00:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:02:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:04:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:06:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:08:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:10:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:12:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:14:05 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:16:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:18:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:20:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:22:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:24:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:26:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:28:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:32:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:34:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:36:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 10 16:38:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12997 63.5%1.7 MB 65.7%
innd 4776 23.3%563.3 KB 20.8%
innfeed 1462 7.1%184.6 KB 6.8%
cnfsstat 1152 5.6%171.6 KB 6.3%
nnrpd 86 0.4%8.7 KB 0.3%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 20475 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 27938 45.5%
Positive hits 20706 33.8%
Do not exist 12695 20.7%
Cache misses 12 0.0%
TOTAL: 4 61351 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.023 0.0%44 0.000 0.523 2.250
article cleanup00:00:00.081 0.0%12801 0.000 0.006 0.057
article logging00:00:00.311 0.0%12977 0.000 0.024 0.100
article parse00:00:00.203 0.0%24896 0.000 0.008 0.027
article write00:00:02.315 0.0%10947 0.000 0.211 22.037
artlog/artcncl00:00:00.001 0.0%43 0.000 0.023 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.052 0.0%74905 0.000 0.001 0.007
hisgrep/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%44 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.991 0.0%61823 0.000 0.048 1.862
history sync00:00:00.025 0.0%404 0.000 0.062 1.000
history write00:00:01.614 0.0%12801 0.000 0.126 5.938
hiswrite/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
idle24:00:34.528100.0%85702 540.164 1008.547 3080.421
nntp read00:00:00.516 0.0%72683 0.000 0.007 0.028
overview write00:00:00.032 0.0%10947 0.000 0.003 0.029
perl filter00:00:14.091 0.0%12801 0.814 1.101 1.897
python filter00:00:00.349 0.0%12801 0.000 0.027 0.104
site send00:00:01.679 0.0%32841 0.017 0.051 0.127
TOTAL: 24:01:05.98824:00:58.811100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%10883 0.000 0.003 0.034
article prepare00:00:00.000 0.0%384 0.000 0.000 0.000
article read00:00:00.013 0.0%327 0.000 0.040 1.000
backlog stats00:00:00.058 0.0%59555 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.270 0.0%35086 0.000 0.008 0.042
data write00:00:00.627 0.0%24307 0.000 0.026 0.110
idle23:49:54.344100.0%59555 878.420 1440.590 3847.571
status file00:00:00.083 0.0%289 0.000 0.287 4.000
TOTAL: 23:50:01.98023:49:55.425100.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.1%18 0.000 0.056 1.000
TOTAL: 00:00:01.15800:00:00.001 0.1%----

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 21352 9623 10985 744 45%48:16:32
2news.nntp4.net 4 12200 1446 9650 1104 11%23:54:53
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 10 33552 11069 20635 1848 32%72:11:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net36.4 MB0.0 KB3.9 MB40.3 MB 90%4.0 KB
2news.nntp4.net3.9 MB0.0 KB3.6 MB7.6 MB 52%3.0 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 340.3 MB0.0 KB7.5 MB47.8 MB 84%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 10 15:00:01 - 15:59:59 603 5.5% 0.172.0 MB 5.0% 0.57
May 10 16:00:00 - 16:59:59 566 5.2% 0.161.8 MB 4.6% 0.52
May 10 17:00:00 - 17:59:59 620 5.7% 0.171.9 MB 4.8% 0.55
May 10 18:00:00 - 18:59:59 564 5.2% 0.162.3 MB 5.8% 0.66
May 10 19:00:00 - 19:59:59 492 4.5% 0.141.8 MB 4.5% 0.51
May 10 20:00:00 - 20:59:59 599 5.5% 0.172.2 MB 5.6% 0.63
May 10 21:00:00 - 21:59:59 444 4.1% 0.121.9 MB 4.9% 0.55
May 10 22:00:00 - 22:59:59 401 3.7% 0.112.1 MB 5.2% 0.59
May 10 23:00:00 - 23:59:59 361 3.3% 0.101.6 MB 4.0% 0.45
May 11 00:00:00 - 00:59:59 291 2.7% 0.081.5 MB 3.8% 0.43
May 11 01:00:00 - 01:59:59 251 2.3% 0.07894.3 KB 2.2% 0.25
May 11 02:00:00 - 02:59:59 169 1.5% 0.05657.4 KB 1.6% 0.18
May 11 03:00:00 - 03:59:59 214 2.0% 0.06786.4 KB 1.9% 0.22
May 11 04:00:00 - 04:59:59 201 1.8% 0.06758.4 KB 1.9% 0.21
May 11 05:00:00 - 05:59:59 296 2.7% 0.081.1 MB 2.8% 0.32
May 11 06:00:00 - 06:59:59 390 3.6% 0.111.4 MB 3.5% 0.40
May 11 07:00:00 - 07:59:59 477 4.4% 0.131.5 MB 3.8% 0.43
May 11 08:00:00 - 08:59:59 606 5.5% 0.171.9 MB 4.9% 0.55
May 11 09:00:00 - 09:59:59 629 5.7% 0.172.1 MB 5.1% 0.58
May 11 10:00:00 - 10:59:59 569 5.2% 0.162.2 MB 5.4% 0.61
May 11 11:00:00 - 11:59:59 608 5.6% 0.172.1 MB 5.3% 0.60
May 11 12:00:00 - 12:59:59 506 4.6% 0.141.7 MB 4.3% 0.49
May 11 13:00:00 - 13:59:59 583 5.3% 0.161.9 MB 4.8% 0.55
May 11 14:00:00 - 15:00:02 500 4.6% 0.141.7 MB 4.4% 0.49
TOTAL: 24:00:01 10940 100.0% 0.1339.9 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
EIGHTBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FIVEBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FOURDEFAULT1024.0 MB270.8 MB 26.4% 21 0.18 66.03
ONEDEFAULT1024.0 MB433.7 MB 42.4% 23 0.18 66.20
SEVENBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
SIXBIG4.0 GB2.9 GB 72.8% 1 0.00 0.00
THREEDEFAULT1024.0 MB278.9 MB 27.2% 21 0.18 65.61
TWODEFAULT1024.0 MB264.8 MB 25.9% 21 0.18 67.97
TOTAL: 8-20.0 GB12.8 GB 64.2% 90 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1113 3 0 0 1 0 0 0 1109
2hasname-out.news.weretis.net 901 3 0 0 0 0 0 0 898
TOTAL: 2 2014 6 0 0 1 0 0 0 2007

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.os.windows-vista 2
de.comm.geraete.mobil 1
aol.neighborhood.ca.fresno.marketplace 1
bburg.forsale 1
alt.penthouse.sex.femdom 1
TOTAL: 5 6

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) 936
EMP (md5) 707
EMP (phl) 100
EMP (phn nph) 57
Too many newsgroups (meow) 16
Scoring filter 8
HTML Multipart 6
TOTAL: 7 1830

INND no permission servers:

SystemConn
199.102.165.10 749
TOTAL: 1 749

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 169
news.nntp4.net 8
TOTAL: 2 177
TOTAL: 1 177

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 310 310 0 0 0 0100%16:00:02
2blueworldhosting 10997 3 8987 0 0 5 0%23:59:53
3nntp4 11267 0 9478 0 0 9 0%23:59:53
4aioe 0 0 0 0 0 10856 0%23:59:53
5weretis 1459 0 1413 16 0 0 0%23:02:14
TOTAL: 5 24033 313 19878 16 0 10870 1%111:01:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom914.7 KB0.0 KB914.7 KB0.0 KB/s3.0 KB16:00:02
2blueworldhosting20.9 KB0.0 KB20.9 KB0.0 KB/s7.0 KB23:59:53
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
4aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
5weretis0.0 KB90.1 KB90.1 KB0.0 KB/s5.6 KB23:02:14
TOTAL: 5935.6 KB90.1 KB1.0 MB0.0 KB/s3.1 KB111:01:55
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
agreeable.monitoring.internet-measurement.com 0.001 0.001 0.00000:00:00
164.92.106.15 0.000 0.004 0.00000:00:00
165.227.172.206 0.000 0.005 0.00000:00:00
137.184.13.100 0.003 0.002 0.00000:00:00
198.199.92.56 0.001 0.001 0.00000:00:00
139.59.170.85 0.003 0.002 0.00000:00:00
178.128.32.203 0.001 0.003 0.00000:00:00
107.170.245.13 0.000 0.002 0.00000:00:00
sh-chi-us-gd13-wk101.internet-census.org 0.002 0.001 0.00000:00:00
120.211.203.35.bc.googleusercontent.com 0.001 0.001 0.00000:00:00
scanner-25.ch1.censys-scanner.com 0.000 0.003 0.00000:00:00
45.227.254.48 0.001 0.001 0.00000:00:00
80.66.77.238 0.000 0.003 0.00000:00:00
TOTAL: 13 0.013 0.029 0.00000:00:01

NNRP no permission clients:

SystemConn
164.92.106.15 2
139.59.170.85 2
137.184.13.100 2
165.227.172.206 2
178.128.32.203 2
45.227.254.48 1
198.199.92.56 1
sh-chi-us-gd13-wk101.internet-census.org 1
107.170.245.13 1
80.66.77.238 1
scanner-25.ch1.censys-scanner.com 1
agreeable.monitoring.internet-measurement.com 1
120.211.203.35.bc.googleusercontent.com 1
TOTAL: 13 18