Daily Usenet report

May 12 15:00:02 -- May 13 15:00:02

Unknown entries from news log file:

First 50 / 710 lines (7.0%)

May 12 15:01:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:01:07 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 12 15:03:00 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 12 15:05:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:07:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:09:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:11:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:13:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:15:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:17:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:19:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:21:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:23:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:25:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:27:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:29:05 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:31:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:33:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:35:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:37:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:39:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:41:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:43:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:45:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:47:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:49:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:50:02 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:52:00 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 12 15:54:05 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:56:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 15:58:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:00:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:02:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:04:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:06:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:08:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:10:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:12:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:14:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:16:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:18:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:20:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:22:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:24:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:26:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:28:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:32:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:34:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 12 16:36:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12521 62.3%1.7 MB 64.7%
innd 4791 23.9%569.0 KB 21.4%
innfeed 1462 7.3%182.6 KB 6.9%
cnfsstat 1152 5.7%172.0 KB 6.5%
nnrpd 159 0.8%16.1 KB 0.6%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 20087 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 26253 45.0%
Positive hits 19896 34.1%
Do not exist 12190 20.9%
Cache misses 5 0.0%
TOTAL: 4 58344 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.016 0.0%46 0.000 0.348 3.333
article cleanup00:00:00.073 0.0%12254 0.000 0.006 0.039
article logging00:00:00.282 0.0%12477 0.000 0.023 0.091
article parse00:00:00.199 0.0%22593 0.000 0.009 0.038
article write00:00:00.476 0.0%10373 0.000 0.046 0.154
artlog/artcncl00:00:00.001 0.0%43 0.000 0.023 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.046 0.0%69807 0.000 0.001 0.005
hisgrep/artcncl00:00:00.000 0.0%35 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%46 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.329 0.0%58654 0.000 0.006 0.031
history sync00:00:00.012 0.0%413 0.000 0.029 0.667
history write00:00:00.606 0.0%12254 0.000 0.049 1.413
hiswrite/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
idle24:00:43.940100.0%81060 656.737 1066.419 2756.321
nntp read00:00:00.478 0.0%68319 0.000 0.007 0.025
overview write00:00:00.031 0.0%10373 0.000 0.003 0.032
perl filter00:00:12.650 0.0%12254 0.716 1.032 1.886
python filter00:00:00.291 0.0%12254 0.000 0.024 0.091
site send00:00:01.516 0.0%31119 0.007 0.049 0.112
TOTAL: 24:01:07.94724:01:00.946100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%10864 0.000 0.002 0.031
article prepare00:00:00.000 0.0%554 0.000 0.000 0.000
article read00:00:00.045 0.0%308 0.000 0.146 4.250
backlog stats00:00:00.041 0.0%57936 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.231 0.0%33510 0.000 0.007 0.021
data write00:00:00.638 0.0%23177 0.000 0.028 0.077
idle23:58:43.354100.0%57936 417.850 1489.978 4140.855
status file00:00:00.066 0.0%305 0.000 0.216 1.000
TOTAL: 23:58:50.06423:58:44.395100.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%32 0.000 0.031 1.000
TOTAL: 00:00:01.49700:00:00.001 0.1%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 4 20188 8920 10490 778 44%48:04:17
2news.nntp4.net 2 11736 1402 9267 1067 11%23:43:08
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 7 31924 10322 19757 1845 32%71:47:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net31.1 MB0.0 KB2.6 MB33.7 MB 92%3.6 KB
2news.nntp4.net3.5 MB0.0 KB3.7 MB7.2 MB 48%3.0 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 334.6 MB0.0 KB6.3 MB40.9 MB 84%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 12 15:00:02 - 15:59:59 457 4.4% 0.131.6 MB 4.5% 0.45
May 12 16:00:00 - 16:59:59 548 5.3% 0.151.5 MB 4.2% 0.42
May 12 17:00:00 - 17:59:59 588 5.7% 0.161.5 MB 4.4% 0.44
May 12 18:00:00 - 18:59:59 619 6.0% 0.172.3 MB 6.6% 0.66
May 12 19:00:00 - 19:59:59 545 5.3% 0.151.8 MB 5.0% 0.50
May 12 20:00:00 - 20:59:59 503 4.8% 0.141.8 MB 5.1% 0.51
May 12 21:00:00 - 21:59:59 393 3.8% 0.111.4 MB 4.0% 0.40
May 12 22:00:00 - 22:59:59 419 4.0% 0.121.6 MB 4.6% 0.46
May 12 23:00:00 - 23:59:59 328 3.2% 0.091.4 MB 3.9% 0.39
May 13 00:00:00 - 00:59:59 356 3.4% 0.101.6 MB 4.6% 0.45
May 13 01:00:00 - 01:59:59 218 2.1% 0.061.1 MB 3.1% 0.31
May 13 02:00:00 - 02:59:59 203 2.0% 0.06596.3 KB 1.7% 0.17
May 13 03:00:00 - 03:59:59 193 1.9% 0.051004.9 KB 2.8% 0.28
May 13 04:00:00 - 04:59:59 218 2.1% 0.06781.6 KB 2.2% 0.22
May 13 05:00:00 - 05:59:59 293 2.8% 0.081.1 MB 3.1% 0.30
May 13 06:00:00 - 06:59:59 428 4.1% 0.121.5 MB 4.3% 0.43
May 13 07:00:00 - 07:59:59 467 4.5% 0.131.8 MB 5.0% 0.50
May 13 08:00:00 - 08:59:59 581 5.6% 0.161.7 MB 4.8% 0.48
May 13 09:00:00 - 09:59:59 455 4.4% 0.131.1 MB 3.3% 0.33
May 13 10:00:00 - 10:59:59 551 5.3% 0.151.4 MB 3.9% 0.39
May 13 11:00:00 - 11:59:59 486 4.7% 0.141.8 MB 5.0% 0.50
May 13 12:00:00 - 12:59:59 442 4.3% 0.121.1 MB 3.3% 0.33
May 13 13:00:00 - 13:59:59 582 5.6% 0.162.0 MB 5.6% 0.56
May 13 14:00:00 - 15:00:02 506 4.9% 0.141.8 MB 5.3% 0.53
TOTAL: 24:00:00 10379 100.0% 0.1235.1 MB 100.0% 0.42
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 MB299.1 MB 29.2% 21 0.16 73.90
ONEDEFAULT1024.0 MB462.0 MB 45.1% 23 0.16 74.94
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 MB307.5 MB 30.0% 21 0.17 72.69
TWODEFAULT1024.0 MB293.3 MB 28.6% 21 0.17 73.26
TOTAL: 8-20.0 GB13.0 GB 64.8% 90 0.16-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1091 1 0 0 1 0 0 0 1089
2hasname-out.news.weretis.net 1008 0 0 0 0 0 0 0 1008
TOTAL: 2 2099 1 0 0 1 0 0 0 2097

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 1
TOTAL: 1 1

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) 1044
EMP (md5) 755
EMP (phl) 32
EMP (phn nph) 32
HTML Multipart 5
Binary: misplaced binary 5
Scoring filter 1
TOTAL: 7 1874

INND no permission servers:

SystemConn
199.102.165.10 735
203.161.32.211 1
152.89.196.61 1
TOTAL: 3 737

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 210
news.nntp4.net 13
TOTAL: 2 223
TOTAL: 1 223

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 234 234 0 0 0 0100%15:36:20
2nntp4 10756 1 8948 0 0 0 0%23:59:53
3blueworldhosting 10739 0 8400 68 0 499 0%23:59:53
4weretis 1426 0 1388 10 0 0 0%23:13:40
5aioe 0 0 0 0 0 10283 0%23:59:53
TOTAL: 5 23155 235 18736 78 0 10782 1%110:49:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom819.9 KB0.0 KB819.9 KB0.0 KB/s3.5 KB15:36:20
2nntp42.1 KB0.0 KB2.1 KB0.0 KB/s2.1 KB23:59:53
3blueworldhosting0.0 KB216.0 KB216.0 KB0.0 KB/s3.2 KB23:59:53
4weretis0.0 KB41.2 KB41.2 KB0.0 KB/s4.1 KB23:13:40
5aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 5822.0 KB257.1 KB1.1 MB0.0 KB/s3.4 KB110:49:39
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
64.226.86.7 0.003 0.008 0.00000:00:00
134.209.95.237 0.004 0.001 0.00000:00:00
104.156.155.31 0.009 0.022 0.00000:00:00
157.245.222.108 0.001 0.003 0.00000:00:00
50.31.21.4 0.003 0.002 0.00000:00:00
178.128.32.203 0.000 0.004 0.00000:00:00
71.6.134.228 0.001 0.005 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.001 0.002 0.00000:00:00
80.66.77.238 0.001 0.001 0.00000:00:00
45.227.254.55 0.002 0.001 0.00000:00:00
TOTAL: 10 0.025 0.049 0.00000:00:01

NNRP no permission clients:

SystemConn
104.156.155.31 14
64.226.86.7 4
71.6.134.228 3
178.128.32.203 2
157.245.222.108 2
50.31.21.4 2
134.209.95.237 2
45.227.254.55 1
80.66.77.238 1
scanner-07.ch1.censys-scanner.com 1
TOTAL: 10 32