Daily Usenet report for news.cmpublishers.com

Feb 21 00:00:04 -- Feb 22 00:00:04

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Feb 21 14:06:55 cs6 pgpverify[31548]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:07:25 cs6 pgpverify[31687]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:07:55 cs6 pgpverify[31855]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:08:25 cs6 pgpverify[31881]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:08:55 cs6 pgpverify[31912]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:09:25 cs6 pgpverify[31991]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:09:55 cs6 pgpverify[32160]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:10:25 cs6 pgpverify[32191]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:10:55 cs6 pgpverify[32231]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:11:26 cs6 pgpverify[32348]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 14:12:05 cs6 pgpverify[32559]: pgpverify: /usr/bin/gpg1: no such file
Feb 21 23:08:34 cs6 pgpverify[27451]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 9715 47.0%1.4 MB 53.9%
innd 8227 39.8%870.1 KB 33.3%
innfeed 1960 9.5%263.2 KB 10.1%
nnrpd 718 3.5%67.3 KB 2.6%
controlchan 17 0.1%1.7 KB 0.1%
pgpverify 12 0.1%1.9 KB 0.1%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 20650 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 37001 52.4%
Negative hits 24173 34.3%
Do not exist 9329 13.2%
Cache misses 55 0.1%
TOTAL: 4 70558 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.154 0.0%2 1.000 77.000 153.000
article cleanup00:00:00.120 0.0%9634 0.000 0.012 0.025
article logging00:00:01.342 0.0%9659 0.036 0.139 2.252
article parse00:00:00.237 0.0%19290 0.003 0.012 0.024
article write00:00:44.870 0.1%2175 0.275 20.630 68.946
artlog/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.151 0.0%59588 0.001 0.003 0.005
hisgrep/artcncl00:00:00.027 0.0%2 0.000 13.500 27.000
hishave/artcncl00:00:00.003 0.0%2 0.000 1.500 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:35.096 0.1%72894 0.008 1.305 3.160
history sync00:00:00.043 0.0%302 0.000 0.142 1.308
history write00:01:30.913 0.1%9634 0.084 9.437 27.116
idle23:53:55.052 99.6%64987 1016.149 1323.881 2191.475
nntp read00:00:00.720 0.0%64239 0.006 0.011 0.021
overview write00:01:44.325 0.1%2175 0.550 47.966 890.566
perl filter00:00:24.585 0.0%9634 1.984 2.552 5.390
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.431 0.0%8785 0.005 0.049 0.118
TOTAL: 24:00:09.75323:59:58.069100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%2095 0.000 0.007 0.036
article prepare00:00:00.001 0.0%400 0.000 0.003 0.050
article read00:00:00.110 0.0%100 0.000 1.100 32.333
backlog stats00:00:00.137 0.0%29675 0.000 0.005 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.181 0.0%15343 0.003 0.012 0.022
data write00:00:00.300 0.0%13312 0.006 0.023 0.136
idle23:01:27.381100.0%29675 1666.512 2793.172 6583.750
status file00:00:00.711 0.0%403 0.786 1.764 9.286
TOTAL: 23:01:33.22923:01:28.835100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.300 66.4%428 20.000 21.729 27.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.207 1.5%4084 0.000 0.051 1.000
TOTAL: 00:00:14.00600:00:09.507 67.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org0001100
nl-admin@nic.surfnet.nl000100
TOTAL0001200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cmpublishers-out.news.weretis.net 25 17616 2056 10014 5546 11%51:21:21
2news.samoylyk.net 2 9418 116 8414 888 1%27:44:44
3usenet.blueworldhosting.com 296 5717 92 5412 213 1%32:17:07
4nntp.club.cc.cmu.edu 572 12729 4 11617 1108 0%137:07:02
5news.snarked.org 122 4889 2 4867 20 0%117:02:46
6cmpublishers-out.news.tnetconsulting.net 29 0 0 0 0 0%28:14:48
7localhost 25 0 0 0 0 0%00:00:00
TOTAL: 7 1071 50369 2270 40324 7775 4%393:47:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cmpublishers-out.news.weretis.net5.7 MB0.0 KB11.8 MB17.4 MB 32%2.3 KB
2news.samoylyk.net609.8 KB0.0 KB2.2 MB2.8 MB 21%2.9 KB
3usenet.blueworldhosting.com364.2 KB0.0 KB752.3 KB1.1 MB 32%3.7 KB
4news.snarked.org42.8 KB0.0 KB25.1 KB67.9 KB 63%3.1 KB
5nntp.club.cc.cmu.edu5.1 KB0.0 KB2.2 MB2.2 MB 0%2.0 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: 76.7 MB0.0 KB16.9 MB23.6 MB 28%2.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 00:00:04 - 00:59:59 63 2.9% 0.02179.8 KB 2.8% 0.05
Feb 21 01:00:00 - 01:59:59 39 1.8% 0.01215.5 KB 3.4% 0.06
Feb 21 02:00:00 - 02:59:59 42 1.9% 0.01170.5 KB 2.7% 0.05
Feb 21 03:00:00 - 03:59:59 41 1.9% 0.01202.2 KB 3.2% 0.06
Feb 21 04:00:00 - 04:59:59 23 1.0% 0.01189.1 KB 3.0% 0.05
Feb 21 05:00:00 - 05:59:59 49 2.2% 0.01142.6 KB 2.3% 0.04
Feb 21 06:00:00 - 06:59:59 84 3.8% 0.02240.6 KB 3.8% 0.07
Feb 21 07:00:00 - 07:59:59 71 3.2% 0.02158.6 KB 2.5% 0.04
Feb 21 08:00:00 - 08:59:59 107 4.9% 0.03325.8 KB 5.1% 0.09
Feb 21 09:00:00 - 09:59:59 102 4.7% 0.03297.7 KB 4.7% 0.08
Feb 21 10:00:00 - 10:59:59 112 5.1% 0.03238.8 KB 3.8% 0.07
Feb 21 11:00:00 - 11:59:59 113 5.2% 0.03273.7 KB 4.3% 0.08
Feb 21 12:00:00 - 12:59:59 104 4.7% 0.03271.9 KB 4.3% 0.08
Feb 21 13:00:00 - 13:59:59 81 3.7% 0.02197.6 KB 3.1% 0.05
Feb 21 14:00:00 - 14:59:59 160 7.3% 0.04395.1 KB 6.2% 0.11
Feb 21 15:00:00 - 15:59:59 115 5.2% 0.03264.6 KB 4.2% 0.07
Feb 21 16:00:00 - 16:59:59 93 4.2% 0.03240.3 KB 3.8% 0.07
Feb 21 17:00:00 - 17:59:59 115 5.2% 0.03318.7 KB 5.0% 0.09
Feb 21 18:00:00 - 18:59:59 130 5.9% 0.04369.3 KB 5.8% 0.10
Feb 21 19:00:00 - 19:59:59 104 4.7% 0.03300.6 KB 4.7% 0.08
Feb 21 20:00:00 - 20:59:59 103 4.7% 0.03273.3 KB 4.3% 0.08
Feb 21 21:00:00 - 21:59:59 143 6.5% 0.04517.5 KB 8.2% 0.14
Feb 21 22:00:00 - 22:59:59 89 4.1% 0.02241.8 KB 3.8% 0.07
Feb 21 23:00:00 - 00:00:04 108 4.9% 0.03307.4 KB 4.9% 0.09
TOTAL: 24:00:00 2191 100.0% 0.036.2 MB 100.0% 0.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cmpublishers-out.news.weretis.net 5396 4934 0 0 0 0 0 0 462
2nntp.club.cc.cmu.edu 1113 210 0 0 0 0 0 0 903
3news.samoylyk.net 782 678 0 0 0 0 0 0 104
4usenet.blueworldhosting.com 211 128 0 0 0 0 0 0 83
5news.snarked.org 20 20 0 0 0 0 0 0 0
TOTAL: 5 7522 5970 0 0 0 0 0 0 1552

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.shared.test 2591
alt.test 342
fr.soc.politique 140
free.pt 138
ger.ct 90
uk.railway 87
it.test 76
alt.buddha.short.fat.guy 72
de.soc.recht.misc 70
alt.arts.poetry.comments 68
fr.rec.photo 67
alt.checkmate 62
rec.arts.tv 60
rec.arts.drwho 54
de.etc.sprache.deutsch 52
de.soc.politik.misc 49
nl.politiek 47
alt.slack 46
eternal-september.test 44
fido7.ru.home 42
TOTAL: 340 5970

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 907
EMP (phn path) 455
User-issued cancel 59
Too many newsgroups 58
Too many newsgroups (meow) 45
HTML Multipart 2
Scoring filter (9) 1
TOTAL: 7 1527

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
cmpublishers-out.news.weretis.net 25
TOTAL: 1 25
TOTAL: 1 25

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1CMU 3727 101 2080 0 0 11 2%23:53:50
2news.snarked.org 2943 2 2187 0 0 0 0%23:53:53
3bwh 2176 0 1911 0 0 0 0%23:53:34
4news.samoylyk.net 2050 0 2022 0 0 0 0%23:51:32
5news.ripco.com 0 0 0 0 0 2176 0%23:59:24
6weretis.net 202 0 199 0 0 0 0%15:22:12
7TNet 2590 0 2185 0 0 0 0%23:53:45
8aioe 0 0 0 0 0 2028 0%23:59:58
TOTAL: 8 13688 103 10584 0 0 4215 0%182:48:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1CMU193.1 KB0.0 KB193.1 KB0.0 KB/s1.9 KB23:53:50
2news.snarked.org5.2 KB0.0 KB5.2 KB0.0 KB/s2.6 KB23:53:53
3bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:34
4news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:32
5news.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:24
6weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s015:22:12
7TNet0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:45
8aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
TOTAL: 8198.3 KB0.0 KB198.3 KB0.0 KB/s1.9 KB182:48:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1cs6.cmpublishers.com 214 00.0 KB 0 0 000:00:11
TOTAL: 1 214 00.0 KB 0 0 000:00:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cmpublishers.com 214 00.0 KB 0 0 000:00:11
TOTAL: 1 214 00.0 KB 0 0 000:00:11

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
cs6.cmpublishers.com 1.333 0.866 0.00000:00:11
bean.probe.onyphe.net 0.004 0.007 0.00000:00:00
sh-chi-us-gp1-wk105c.internet-census.org 0.008 0.018 0.00000:00:00
23.95.197.205 0.004 0.007 0.00000:00:00
32.125.142.162.censys-scanner.com 0.005 0.005 0.00000:00:00
223.150.216.162.bc.googleusercontent.com 0.005 0.005 0.00000:00:00
georgiana.probe.onyphe.net 0.007 0.004 0.00000:00:00
sh-chi-us-gp1-wk105d.internet-census.org 0.015 0.007 0.00000:00:00
sh-chi-us-gp1-wk105b.internet-census.org 0.015 0.015 0.00000:00:00
147.185.132.192 0.005 0.005 0.00000:00:00
sh-chi-us-gp1-wk105a.internet-census.org 0.020 0.012 0.00000:00:00
23.95.197.221 0.004 0.007 0.00000:00:00
147.185.132.43 0.011 0.000 0.00000:00:00
TOTAL: 13 1.436 0.958 0.00000:00:14

NNRP no permission clients:

SystemConn
sh-chi-us-gp1-wk105a.internet-census.org 3
sh-chi-us-gp1-wk105b.internet-census.org 3
sh-chi-us-gp1-wk105d.internet-census.org 2
sh-chi-us-gp1-wk105c.internet-census.org 2
georgiana.probe.onyphe.net 1
147.185.132.192 1
32.125.142.162.censys-scanner.com 1
223.150.216.162.bc.googleusercontent.com 1
147.185.132.43 1
23.95.197.221 1
23.95.197.205 1
bean.probe.onyphe.net 1
TOTAL: 12 18