Daily Usenet report

Nov 19 06:01:01 -- Nov 20 06:01:01

Unknown entries from news log file:

First 40 / 40 lines (100.0%)

Nov 19 06:01:57 kennel innd: message repeated 2 times: [ ctlinnd command s]
Nov 19 10:49:26 kennel thermald[887]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
Nov 19 10:49:26 kennel thermald[887]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
Nov 19 10:49:26 kennel thermald[887]: sensor id 5 : No temp sysfs for reading raw temp
Nov 19 10:49:26 kennel thermald[887]: message repeated 2 times: [ sensor id 5 : No temp sysfs for reading raw temp]
Nov 19 10:49:26 kennel thermald[887]: Config file /etc/thermald/thermal-conf.xml does not exist
Nov 19 10:49:26 kennel thermald[887]: Config file /etc/thermald/thermal-conf.xml does not exist
Nov 19 10:49:26 kennel thermald[887]: Config file /etc/thermald/thermal-conf.xml does not exist
Nov 19 10:49:26 kennel thermald[887]: Polling mode is enabled: 4
Nov 19 10:50:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:51:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
Nov 19 10:51:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:52:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:52:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
Nov 19 10:53:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:54:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:55:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:56:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:56:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
Nov 19 10:57:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
Nov 19 10:57:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:58:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 10:59:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:00:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:01:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:01:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
Nov 19 11:02:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:02:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
Nov 19 11:03:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:04:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:05:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:06:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:06:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
Nov 19 11:07:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:07:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
Nov 19 11:08:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:09:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:10:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 19 11:11:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
Nov 19 11:11:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 512297 93.5%67.9 MB 93.7%
innfeed 20320 3.7%2.2 MB 3.1%
innd 15172 2.8%2.3 MB 3.2%
cnfsstat 145 0.0%26.0 KB 0.0%
nnrpd 60 0.0%6.5 KB 0.0%
thermald 8 0.0%0.8 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 548005 100.0%72.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 699595 41.6%
Do not exist 501334 29.8%
Positive hits 448223 26.7%
Cache misses 31218 1.9%
TOTAL: 4 1680370 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.025 0.0%100 0.000 0.250 2.000
article cleanup00:00:06.243 0.0%512805 0.006 0.012 0.017
article logging00:00:24.605 0.0%512943 0.027 0.048 0.063
article parse00:00:45.792 0.1%1897427 0.010 0.024 0.034
article write00:00:14.364 0.0%151715 0.035 0.095 0.160
artlog/artparse00:00:00.055 0.0%1130 0.000 0.049 0.333
data move00:00:14.165 0.0%1663868 0.001 0.009 0.017
hisgrep/artcncl00:00:00.018 0.0%100 0.000 0.180 2.000
hissync/artlog00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:35.165 0.2%1708374 0.002 0.091 4.169
history sync00:00:00.018 0.0%288 0.000 0.062 0.500
history write00:00:38.025 0.0%507306 0.036 0.075 0.166
idle23:48:24.285 99.1%1568415 12.291 54.644 3727.031
nntp read00:01:13.498 0.1%1573483 0.017 0.047 0.066
overview write00:00:00.776 0.0%151715 0.000 0.005 0.012
perl filter00:00:30.094 0.0%506192 0.033 0.059 0.078
python filter00:00:29.620 0.0%506192 0.025 0.059 0.072
site send00:00:06.246 0.0%390946 0.010 0.016 0.176
TOTAL: 24:00:40.68023:55:42.994 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.344 0.0%91231 0.000 0.004 0.077
article prepare00:00:00.001 0.0%2249 0.000 0.000 0.500
article read00:00:00.095 0.0%857 0.000 0.111 1.000
backlog stats00:00:00.299 0.0%276437 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.401 0.0%172327 0.000 0.026 0.088
data write00:00:03.781 0.0%105813 0.000 0.036 0.123
idle23:44:39.756100.0%276437 47.071 309.220 13057.674
status file00:00:11.362 0.0%8234 0.175 1.380 24.754
TOTAL: 23:45:16.42423:45:00.039100.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.002 0.1%13 0.000 0.154 1.000
TOTAL: 00:00:02.50100:00:00.002 0.1%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 48
reserve 2
throttle 10
TOTAL: 12 227

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 504 958193 141888 456098 360207 14%58:49:43
2hasname-out.news.weretis.net 7 16991 6560 10332 99 38%40:40:42
3news.nntp4.net 4 8036 1647 6093 296 20%20:10:27
4usenet.blueworldhosting.com 1211 8669 1216 7258 195 14%20:14:13
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 1727 991889 151311 479781 360797 15%139:55:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net1.6 GB103.9 MB6.2 GB7.9 GB 20%16.4 KB
2news.nntp4.net24.1 MB0.0 KB2.4 MB26.5 MB 90%14.0 KB
3hasname-out.news.weretis.net14.3 MB80.7 KB107.6 KB14.5 MB 98%2.2 KB
4usenet.blueworldhosting.com2.9 MB0.0 KB1.0 MB4.0 MB 73%2.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 51.6 GB104.0 MB6.2 GB7.9 GB 20%16.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 06:01:01 - 06:59:59 5356 3.5% 1.5158.7 MB 0.0% 16.99
Nov 19 07:00:00 - 07:59:59 6413 4.2% 1.7896.0 MB 0.0% 27.31
Nov 19 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 19 09:00:00 - 09:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 19 10:00:00 - 10:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 19 11:00:00 - 11:59:59 13235 8.8% 3.68173.9 MB 49.1% 49.47
Nov 19 12:00:00 - 12:59:59 11656 7.7% 3.24139.6 MB 39.4% 39.71
Nov 19 13:00:00 - 13:59:59 7335 4.9% 2.0472.1 MB 20.4% 20.52
Nov 19 14:00:00 - 14:59:59 8050 5.3% 2.2485.2 MB 24.1% 24.23
Nov 19 15:00:00 - 15:59:59 8760 5.8% 2.43103.1 MB 29.1% 29.34
Nov 19 16:00:00 - 16:59:59 7840 5.2% 2.1883.0 MB 23.4% 23.61
Nov 19 17:00:00 - 17:59:59 6975 4.6% 1.9470.5 MB 19.9% 20.04
Nov 19 18:00:00 - 18:59:59 7669 5.1% 2.1376.1 MB 21.5% 21.64
Nov 19 19:00:00 - 19:59:59 7084 4.7% 1.9776.3 MB 21.5% 21.70
Nov 19 20:00:00 - 20:59:59 6904 4.6% 1.9286.4 MB 24.4% 24.58
Nov 19 21:00:00 - 21:59:59 7987 5.3% 2.2283.5 MB 23.6% 23.77
Nov 19 22:00:00 - 22:59:59 9829 6.5% 2.7390.2 MB 25.5% 25.65
Nov 19 23:00:00 - 23:59:59 5307 3.5% 1.4758.7 MB 16.6% 16.71
Nov 20 00:00:00 - 00:59:59 6221 4.1% 1.7361.9 MB 17.5% 17.62
Nov 20 01:00:00 - 01:59:59 5288 3.5% 1.4758.4 MB 16.5% 16.60
Nov 20 02:00:00 - 02:59:59 6163 4.1% 1.7157.2 MB 16.1% 16.26
Nov 20 03:00:00 - 03:59:59 4044 2.7% 1.1246.4 MB 13.1% 13.20
Nov 20 04:00:00 - 04:59:59 5347 3.5% 1.4945.1 MB 12.7% 12.84
Nov 20 05:00:00 - 05:59:59 3709 2.5% 1.0340.3 MB 11.4% 11.46
Nov 20 06:00:00 - 06:01:01 11 0.0% 0.189.4 KB 0.0% 0.15
TOTAL: 24:00:00 151183 100.0% 1.75354.2 MB 100.0% 4.20
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB9.4 GB 93.5% 98 27.29 4.45
TOTAL: 1-10.0 GB9.4 GB 93.5% 98 27.29-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net360440352702 0 6567 15 0 0 0 1156
2news.nntp4.net 340 291 0 0 0 0 0 0 49
3usenet.blueworldhosting.com 216 192 0 0 2 0 0 0 22
4hasname-out.news.weretis.net 118 62 0 38 0 0 0 0 18
TOTAL: 4361114353247 0 6605 17 0 0 0 1245

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 305687
alt.binaries.encrypted 4659
alt.binaries.font 2204
alt.binaries.turkey 1190
alt.binaries.ucc 1116
alt.binaries.noprobs 1101
alt.binaries.wtfnzb.hotel 1053
alt.binaries.wtfnzb.beta 1037
alt.binaries.wtfnzb.lima 1017
alt.binaries.wtfnzb.india 1015
alt.binaries.wtfnzb.alpha 1014
alt.binaries.wtfnzb.charlie 1008
alt.binaries.wtfnzb.delta 1008
alt.binaries.wtfnzb.novemeber 1008
alt.binaries.wtfnzb.kilo 1006
alt.binaries.wtfnzb.bravo 998
alt.binaries.wtfnzb.golf 991
alt.binaries.wtfnzb.mike 990
alt.binaries.wtfnzb.foxtrot 986
alt.binaries.wtfnzb.echo 975
TOTAL: 210 353247

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

GroupsCount
alt.binaries.whitburn 14
rec.sport.pro-wrestling.moderated 2
talk.origins 1
TOTAL: 3 17

INND no permission servers:

SystemConn
103.193.138.76 30
24.182.239.66 22
144.76.237.92 5
37.252.120.71 4
147.185.133.126 3
147.185.133.143 2
168.119.53.7 1
5.161.41.9 1
66.132.153.121 1
TOTAL: 9 69

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
hasname-out.feeder.erje.net 20
TOTAL: 1 20
Including strange strings
news.nntp4.net 49
hasname-out.feeder.erje.net 45
usenet.blueworldhosting.com 21
hasname-out.news.weretis.net 18
TOTAL: 4 133
No colon-space in header field
hasname-out.feeder.erje.net 1110
usenet.blueworldhosting.com 1
TOTAL: 2 1111
TOTAL: 3 1264

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 394 394 0 0 0 0100%18:01:54
2blueworldhosting 85850 7 85483 8 0 306 0%20:52:28
3erje 8866 1 8863 0 0 586 0%20:52:01
4weretis 3445 0 2973 448 0 278 0%20:47:49
5nntp4 2711 0 0 0 0 11294 0%23:57:07
TOTAL: 5 101266 402 97319 456 0 12464 0%104:31:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s3.6 KB18:01:54
2blueworldhosting45.0 KB38.7 KB83.7 KB0.0 KB/s5.6 KB20:52:28
3erje5.8 KB0.0 KB5.8 KB0.0 KB/s5.8 KB20:52:01
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:57:07
5weretis0.0 KB12.0 MB12.0 MB0.2 KB/s27.3 KB20:47:49
TOTAL: 51.4 MB12.0 MB13.4 MB0.0 KB/s16.0 KB104:31:19
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
85.208.84.66 0.001 0.001 0.00000:00:00
dublin.scan.bufferover.run 0.002 0.006 0.00000:00:00
exciting.monitoring.internet-measurement.com 0.000 0.002 0.00000:00:00
165.154.237.254 0.002 0.002 0.00000:00:00
199.45.154.154 0.006 0.009 0.00000:00:00
71.6.134.231 0.000 0.004 0.00000:00:00
azpdcsp0qeuh.stretchoid.com 0.003 0.005 0.00000:00:00
198.235.24.169 0.003 0.001 0.00000:00:00
198.235.24.109 0.002 0.003 0.00000:00:00
TOTAL: 9 0.019 0.033 0.00000:00:02

NNRP no permission clients [Top 20]:

SystemConn
199.45.154.154 3
azpdcsp0qeuh.stretchoid.com 2
dublin.scan.bufferover.run 2
165.154.237.254 1
198.235.24.109 1
198.235.24.169 1
71.6.134.231 1
85.208.84.66 1
exciting.monitoring.internet-measurement.com 1
TOTAL: 9 13