Daily Usenet report

May 5 15:00:01 -- May 6 15:00:01

Unknown entries from news log file:

First 50 / 725 lines (6.9%)

May 5 15:01:20 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:01:25 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 5 15:03:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:05:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:07:24 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:09:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:11:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:13:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:15:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:17:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:19:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:21:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:23:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:25:20 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:27:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:29:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:31:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:33:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:35:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:37:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:39:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:41:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:43:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:45:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:47:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:49:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:51:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:53:21 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:55:20 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 15:57:20 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 5 15:59:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:01:20 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:03:19 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 5 16:05:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:07:20 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:09:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:11:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:13:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:15:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:17:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:19:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:21:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:23:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:25:22 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 5 16:27:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:29:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:31:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:33:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:35:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 5 16:37:19 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12352 61.6%1.7 MB 64.0%
innd 4934 24.6%582.5 KB 22.0%
innfeed 1514 7.6%187.8 KB 7.1%
cnfsstat 1152 5.7%173.6 KB 6.6%
nnrpd 85 0.4%8.9 KB 0.3%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 20038 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 25841 45.0%
Positive hits 19570 34.0%
Do not exist 12042 21.0%
Cache misses 23 0.0%
TOTAL: 4 57476 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.363 0.0%88 0.000 4.125 22.000
article cleanup00:00:00.073 0.0%12097 0.000 0.006 0.036
article logging00:00:00.297 0.0%12297 0.000 0.024 0.069
article parse00:00:00.234 0.0%25931 0.000 0.009 0.044
article write00:00:00.521 0.0%10089 0.000 0.052 1.000
artlog/artcncl00:00:00.001 0.0%86 0.000 0.012 0.027
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.040 0.0%72481 0.000 0.001 0.005
hisgrep/artcncl00:00:00.002 0.0%77 0.000 0.026 0.333
hishave/artcncl00:00:00.001 0.0%88 0.000 0.011 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.042 0.0%57731 0.000 0.174 1.823
history sync00:00:00.011 0.0%412 0.000 0.027 0.667
history write00:00:00.521 0.0%12097 0.000 0.043 0.638
hiswrite/artcncl00:00:00.001 0.0%11 0.000 0.091 0.250
idle24:00:31.219100.0%84713 599.198 1020.283 2284.768
nntp read00:00:00.494 0.0%70948 0.000 0.007 0.019
overview write00:00:00.027 0.0%10089 0.000 0.003 0.029
perl filter00:00:13.786 0.0%12097 0.781 1.140 2.387
python filter00:00:00.356 0.0%12097 0.000 0.029 0.108
site send00:00:01.576 0.0%30267 0.025 0.052 0.102
TOTAL: 24:01:05.96424:00:59.565100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%10049 0.000 0.002 0.050
article prepare00:00:00.000 0.0%260 0.000 0.000 0.000
article read00:00:00.010 0.0%242 0.000 0.041 1.000
backlog stats00:00:00.032 0.0%54217 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.221 0.0%31980 0.000 0.007 0.030
data write00:00:00.578 0.0%21989 0.000 0.026 0.119
idle23:57:43.894100.0%54217 865.146 1591.086 3510.251
status file00:00:00.178 0.0%325 0.000 0.548 24.250
TOTAL: 23:57:50.41223:57:44.934100.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%17 0.000 0.000 0.000
TOTAL: 00:00:01.22200: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 18991 8585 9675 731 45%45:57:53
2news.nntp4.net 2 11920 1253 9378 1289 10%23:49:42
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 8 30911 9838 19053 2020 31%69:47:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net36.5 MB0.0 KB4.0 MB40.5 MB 90%4.4 KB
2news.nntp4.net3.9 MB0.0 KB5.4 MB9.3 MB 42%3.8 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 340.4 MB0.0 KB9.4 MB49.8 MB 81%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 5 15:00:01 - 15:59:59 681 6.8% 0.192.3 MB 5.6% 0.66
May 5 16:00:00 - 16:59:59 697 6.9% 0.192.2 MB 5.3% 0.63
May 5 17:00:00 - 17:59:59 593 5.9% 0.161.9 MB 4.5% 0.54
May 5 18:00:00 - 18:59:59 521 5.2% 0.141.9 MB 4.5% 0.54
May 5 19:00:00 - 19:59:59 531 5.3% 0.152.0 MB 4.8% 0.57
May 5 20:00:00 - 20:59:59 518 5.1% 0.142.4 MB 5.8% 0.69
May 5 21:00:00 - 21:59:59 431 4.3% 0.121.6 MB 3.9% 0.46
May 5 22:00:00 - 22:59:59 389 3.9% 0.112.0 MB 4.9% 0.58
May 5 23:00:00 - 23:59:59 303 3.0% 0.081.2 MB 2.9% 0.35
May 6 00:00:00 - 00:59:59 232 2.3% 0.061.3 MB 3.0% 0.36
May 6 01:00:00 - 01:59:59 317 3.2% 0.091.6 MB 3.9% 0.46
May 6 02:00:00 - 02:59:59 264 2.6% 0.071.5 MB 3.5% 0.42
May 6 03:00:00 - 03:59:59 194 1.9% 0.051.5 MB 3.5% 0.42
May 6 04:00:00 - 04:59:59 219 2.2% 0.061.3 MB 3.1% 0.37
May 6 05:00:00 - 05:59:59 288 2.9% 0.082.1 MB 5.1% 0.61
May 6 06:00:00 - 06:59:59 330 3.3% 0.091.5 MB 3.7% 0.44
May 6 07:00:00 - 07:59:59 475 4.7% 0.132.3 MB 5.6% 0.67
May 6 08:00:00 - 08:59:59 475 4.7% 0.131.9 MB 4.5% 0.53
May 6 09:00:00 - 09:59:59 453 4.5% 0.131.3 MB 3.2% 0.38
May 6 10:00:00 - 10:59:59 338 3.4% 0.091.2 MB 3.0% 0.35
May 6 11:00:00 - 11:59:59 421 4.2% 0.121.4 MB 3.4% 0.41
May 6 12:00:00 - 12:59:59 465 4.6% 0.131.5 MB 3.6% 0.43
May 6 13:00:00 - 13:59:59 498 4.9% 0.141.6 MB 3.8% 0.46
May 6 14:00:00 - 15:00:01 429 4.3% 0.122.0 MB 4.7% 0.56
TOTAL: 24:00:00 10062 100.0% 0.1241.8 MB 100.0% 0.50
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 MB199.7 MB 19.5% 21 0.19 64.85
ONEDEFAULT1024.0 MB362.2 MB 35.4% 23 0.19 65.27
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 MB207.1 MB 20.2% 21 0.18 66.20
TWODEFAULT1024.0 MB193.4 MB 18.9% 21 0.18 67.26
TOTAL: 8-20.0 GB12.6 GB 62.8% 90 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1287 1 0 0 1 0 0 0 1285
2hasname-out.news.weretis.net 918 6 0 0 0 0 0 0 912
TOTAL: 2 2205 7 0 0 1 0 0 0 2197

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.dev.accessibility 3
lada.music 2
panix.chat.politics 1
de.comm.geraete.mobil 1
TOTAL: 4 7

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1067
EMP (phn path) 803
EMP (phn nph) 61
EMP (phl) 55
HTML Multipart 5
Scoring filter 4
Too many newsgroups (meow) 2
Binary: misplaced binary 1
TOTAL: 8 1998

INND no permission servers:

SystemConn
199.102.165.10 770
TOTAL: 1 770

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 174
news.nntp4.net 25
TOTAL: 2 199
TOTAL: 1 199

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 236 236 0 0 0 0100%16:00:51
2blueworldhosting 9428 1 8263 0 0 1 0%23:59:51
3aioe 0 0 0 0 0 9887 0%23:59:53
4weretis 1200 0 1175 5 0 0 0%22:58:52
5nntp4 10736 0 8848 0 0 0 0%23:59:53
TOTAL: 5 21600 237 18286 5 0 9888 1%110:59:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom806.7 KB0.0 KB806.7 KB0.0 KB/s3.4 KB16:00:51
2blueworldhosting20.1 KB0.0 KB20.1 KB0.0 KB/s20.1 KB23:59:51
3aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
4weretis0.0 KB37.2 KB37.2 KB0.0 KB/s7.4 KB22:58:52
5nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 5826.8 KB37.2 KB864.0 KB0.0 KB/s3.6 KB110:59:20
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
71.6.134.237 0.001 0.008 0.00000:00:00
159.89.124.112 0.000 0.005 0.00000:00:00
147.182.247.10 0.005 0.001 0.00000:00:00
137.184.13.100 0.002 0.004 0.00000:00:00
147.182.241.81 0.001 0.003 0.00000:00:00
178.128.32.203 0.002 0.004 0.00000:00:00
107.170.251.21 0.001 0.001 0.00000:00:00
104.236.128.14 0.001 0.001 0.00000:00:00
104.152.52.202 0.000 0.003 0.00000:00:00
89.248.165.99 0.001 0.002 0.00000:00:00
TOTAL: 10 0.014 0.032 0.00000:00:01

NNRP no permission clients:

SystemConn
71.6.134.237 3
147.182.241.81 2
147.182.247.10 2
159.89.124.112 2
178.128.32.203 2
137.184.13.100 2
104.152.52.202 1
104.236.128.14 1
107.170.251.21 1
89.248.165.99 1
TOTAL: 10 17