Daily Usenet report for news.cmpublishers.com

Nov 1 00:00:04 -- Nov 2 00:00:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 1 00:04:02 cs6 pgpverify[12588]: pgpverify: /usr/bin/gpg1: no such file
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00Nov 1 16:36:17 cs6 innd: SERVER descriptors 1023
Nov 1 16:36:28 cs6 innfeed[3387]: news.snarked.org:0 connect: Network is unreachable
Nov 1 16:36:29 cs6 innfeed[3387]: news.ripco.com:0 connect: Network is unreachable
Nov 1 16:36:36 cs6 innd: tradspool: could not open /var/spool/news/articles/free/usenet/3592527: File exists

Log entries by program:

Program nameLines%LinesSize%Size
inn 10592 45.5%1.5 MB 53.5%
innd 9686 41.6%1004.6 KB 35.0%
innfeed 2393 10.3%273.3 KB 9.5%
nnrpd 616 2.6%57.3 KB 2.0%
controlchan 9 0.0%1.3 KB 0.0%
nocem 2 0.0%0.3 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 23299 100.0%2.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 35470 50.6%
Negative hits 24709 35.2%
Do not exist 9804 14.0%
Cache misses 141 0.2%
TOTAL: 4 70124 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.280 0.0%1 280.000 280.000 280.000
article cleanup00:00:00.117 0.0%10477 0.000 0.011 0.026
article logging00:00:01.015 0.0%10508 0.031 0.097 1.076
article parse00:00:00.257 0.0%22306 0.002 0.012 0.019
article write00:01:23.888 0.1%2141 17.362 39.182 99.513
artlog/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.153 0.0%55098 0.001 0.003 0.005
hisgrep/artcncl00:00:00.042 0.0%1 42.000 42.000 42.000
hishave/artcncl00:00:00.017 0.0%1 17.000 17.000 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:14.405 0.2%74295 0.005 1.809 4.711
history sync00:00:00.060 0.0%278 0.000 0.216 1.769
history write00:02:09.425 0.2%10433 0.085 12.405 29.234
idle21:53:02.185 99.5%61895 898.417 1272.836 2175.476
nntp read00:00:00.691 0.0%62290 0.006 0.011 0.019
overview write00:00:33.640 0.0%2137 0.038 15.742 110.245
perl filter00:00:28.178 0.0%10437 1.818 2.700 6.377
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.353 0.0%8597 0.011 0.041 0.082
TOTAL: 22:00:11.16821:59:54.706100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.010 0.0%2192 0.000 0.005 0.021
article prepare00:00:00.003 0.0%456 0.000 0.007 0.036
article read00:00:00.032 0.0%114 0.000 0.281 2.250
backlog stats00:00:00.119 0.0%24993 0.000 0.005 0.017
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.175 0.0%13421 0.003 0.013 0.044
data write00:00:00.194 0.0%11812 0.004 0.016 0.033
idle22:00:41.362100.0%24993 1819.340 3170.542 6661.011
status file00:00:01.617 0.0%933 0.778 1.733 4.250
TOTAL: 22:00:57.50122:00:43.512100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.489 56.1%398 20.000 21.329 26.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.139 0.9%3785 0.000 0.037 0.421
TOTAL: 00:00:15.12900:00:08.628 57.0%----

Control commands to INND:

CommandNumber
flush 6
flushlogs 2
go 2
logmode 2
lowmark 1
mode 654
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 677

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
control@eternal-september.org001001
us-control@lists.killfile.org000100
TOTAL002102

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cmpublishers-out.news.weretis.net 4 17936 1724 10555 5657 9%44:02:59
2nntp.club.cc.cmu.edu 554 12318 156 10648 1514 1%134:22:05
3usenet.blueworldhosting.com 303 5692 105 5121 466 1%39:14:03
4news.samoylyk.net 4 6955 79 6399 477 1%18:25:42
5news.snarked.org 220 4823 39 4609 175 0%210:17:29
6cmpublishers-out.news.tnetconsulting.net 25 0 0 0 0 0%24:12:55
7localhost 24 0 0 0 0 0%00:00:01
TOTAL: 7 1134 47724 2103 37332 8289 4%470:35:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cmpublishers-out.news.weretis.net4.5 MB65.7 KB13.0 MB17.5 MB 25%2.4 KB
2news.samoylyk.net571.6 KB116.1 KB1.4 MB2.1 MB 26%3.9 KB
3usenet.blueworldhosting.com379.3 KB32.6 KB1.9 MB2.3 MB 15%4.2 KB
4nntp.club.cc.cmu.edu372.0 KB2.0 KB3.5 MB3.8 MB 9%2.3 KB
5news.snarked.org136.6 KB33.2 KB366.8 KB536.6 KB 25%2.5 KB
6cmpublishers-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 75.9 MB249.6 KB20.1 MB26.3 MB 22%2.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 1 00:00:04 - 00:59:59 66 3.1% 0.02304.8 KB 4.8% 0.08
Nov 1 01:00:00 - 01:59:59 49 2.3% 0.01232.0 KB 3.6% 0.06
Nov 1 02:00:00 - 02:59:59 39 1.8% 0.01127.3 KB 2.0% 0.04
Nov 1 03:00:00 - 03:59:59 34 1.6% 0.01189.9 KB 3.0% 0.05
Nov 1 04:00:00 - 04:59:59 26 1.2% 0.01172.6 KB 2.7% 0.05
Nov 1 05:00:00 - 05:59:59 47 2.2% 0.01157.7 KB 2.5% 0.04
Nov 1 06:00:00 - 06:59:59 61 2.8% 0.02168.2 KB 2.6% 0.05
Nov 1 07:00:00 - 07:59:59 81 3.8% 0.02303.9 KB 4.7% 0.08
Nov 1 08:00:00 - 08:59:59 108 5.0% 0.03218.4 KB 3.4% 0.06
Nov 1 09:00:00 - 09:59:59 146 6.8% 0.04261.7 KB 4.1% 0.07
Nov 1 10:00:00 - 10:59:59 156 7.3% 0.04304.3 KB 4.8% 0.08
Nov 1 11:00:00 - 11:59:59 124 5.8% 0.03335.9 KB 5.2% 0.09
Nov 1 12:00:00 - 12:59:59 95 4.4% 0.03184.3 KB 2.9% 0.05
Nov 1 13:00:00 - 13:59:59 143 6.7% 0.04607.8 KB 9.5% 0.17
Nov 1 14:00:00 - 14:59:59 127 5.9% 0.04347.2 KB 5.4% 0.10
Nov 1 15:00:00 - 15:59:59 19 0.9% 0.0135.1 KB 0.5% 0.01
Nov 1 16:00:00 - 16:59:59 206 9.6% 0.06566.0 KB 8.8% 0.16
Nov 1 17:00:00 - 17:59:59 96 4.5% 0.03220.1 KB 3.4% 0.06
Nov 1 18:00:00 - 18:59:59 96 4.5% 0.03267.8 KB 4.2% 0.07
Nov 1 19:00:00 - 19:59:59 116 5.4% 0.03323.1 KB 5.0% 0.09
Nov 1 20:00:00 - 20:59:59 92 4.3% 0.03228.9 KB 3.6% 0.06
Nov 1 21:00:00 - 21:59:59 83 3.9% 0.02445.1 KB 7.0% 0.12
Nov 1 22:00:00 - 22:59:59 82 3.8% 0.02245.4 KB 3.8% 0.07
Nov 1 23:00:00 - 00:00:01 58 2.7% 0.02152.4 KB 2.4% 0.04
TOTAL: 23:59:57 2150 100.0% 0.026.3 MB 100.0% 0.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cmpublishers-out.news.weretis.net 5796 5117 0 16 0 0 0 0 663
2nntp.club.cc.cmu.edu 1518 358 0 1 0 0 0 0 1159
3news.samoylyk.net 604 500 0 9 0 0 0 0 95
4usenet.blueworldhosting.com 465 272 0 3 0 0 0 0 190
5news.snarked.org 59 54 0 2 0 0 0 0 3
TOTAL: 5 8442 6301 0 31 0 0 0 0 2110

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.shared.test 2585
alt.test 301
comp.theory 214
free.pt 214
ger.ct 109
it.test 97
fido7.ru.military 86
fr.bio.medecine 82
nl.politiek 73
linux.debian.devel.release 70
fr.soc.politique 68
alt.buddha.short.fat.guy 63
alt.slack 57
alt.anonymous.messages 50
alt.checkmate 46
de.alt.folklore.computer 43
uk.railway 38
rec.arts.drwho 37
rec.arts.tv 37
it.hobby.fai-da-te 32
TOTAL: 471 6301

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1119
EMP (phn path) 413
User-issued cancel 398
Too many newsgroups 105
EMP (phn nph) 25
Too many newsgroups (meow) 8
HTML Multipart 5
Scoring filter (8) 4
Scoring filter (10) 2
Scoring filter (12) 1
Scoring filter (14) 1
TOTAL: 11 2081

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
cmpublishers-out.news.weretis.net 31
nntp.club.cc.cmu.edu 3
TOTAL: 2 34
TOTAL: 1 34

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1CMU 2801 105 1873 11 0 4 3%22:33:28
2news.freedyn.de 0 0 0 0 0 2127 0%22:23:32
3weretis.net 314 0 313 0 0 0 0%18:10:19
4news.snarked.org 2381 0 2147 0 0 28 0%22:33:41
5news.ripco.com 0 0 0 0 0 2112 0%22:23:45
6aioe 0 0 0 0 0 1937 0%22:33:47
7news.samoylyk.net 2031 0 1989 0 0 0 0%22:33:30
8bwh 1631 0 1594 0 0 44 0%22:26:19
9TNet 2220 0 2143 0 0 0 0%22:33:28
TOTAL: 9 11378 105 10059 11 0 6252 0%198:11:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1CMU205.3 KB27.5 KB232.8 KB0.0 KB/s2.0 KB22:33:28
2news.freedyn.de0.0 KB0.0 KB0.0 KB0.0 KB/s022:23:32
3weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s018:10:19
4news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s022:33:41
5news.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s022:23:45
6aioe0.0 KB0.0 KB0.0 KB0.0 KB/s022:33:47
7news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:33:30
8bwh0.0 KB0.0 KB0.0 KB0.0 KB/s022:26:19
9TNet0.0 KB0.0 KB0.0 KB0.0 KB/s022:33:28
TOTAL: 9205.3 KB27.5 KB232.8 KB0.0 KB/s2.0 KB198:11:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1cs6.cmpublishers.com 199 00.0 KB 0 0 000:00:09
TOTAL: 1 199 00.0 KB 0 0 000:00:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cmpublishers.com 199 00.0 KB 0 0 000:00:09
TOTAL: 1 199 00.0 KB 0 0 000:00:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
cs6.cmpublishers.com 1.239 0.814 0.00000:00:09
147.185.133.132 0.007 0.004 0.00000:00:04
beaming.monitoring.internet-measurement.com 0.007 0.007 0.00000:00:00
91.238.181.92 0.015 0.000 0.00000:00:00
198.235.24.125 0.005 0.005 0.00000:00:00
TOTAL: 5 1.273 0.830 0.00000:00:15

NNRP no permission clients:

SystemConn
beaming.monitoring.internet-measurement.com 1
147.185.133.132 1
198.235.24.125 1
91.238.181.92 1
TOTAL: 4 4