Daily Usenet report for news.cmpublishers.com

Aug 1 00:00:05 -- Aug 2 00:00:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Aug 1 00:00:39 cs6 pgpverify[28107]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:34:20 cs6 pgpverify[26698]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:34:50 cs6 pgpverify[26713]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:35:19 cs6 pgpverify[26896]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:35:50 cs6 pgpverify[26918]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:36:20 cs6 pgpverify[26960]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:36:50 cs6 pgpverify[26976]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:37:20 cs6 pgpverify[27161]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:37:52 cs6 pgpverify[27219]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:38:20 cs6 pgpverify[27282]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:38:50 cs6 pgpverify[27384]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:39:20 cs6 pgpverify[27667]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:39:50 cs6 pgpverify[27687]: pgpverify: /usr/bin/gpg1: no such file
Aug 1 10:41:14 cs6 pgpverify[27923]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
innd 9977 47.5%1.1 MB 41.8%
inn 8395 40.0%1.2 MB 45.7%
innfeed 1874 8.9%255.7 KB 9.8%
nnrpd 703 3.3%67.5 KB 2.6%
controlchan 23 0.1%2.6 KB 0.1%
pgpverify 14 0.1%2.1 KB 0.1%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 20987 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 26415 48.6%
Negative hits 20196 37.1%
Do not exist 7741 14.2%
Cache misses 29 0.1%
TOTAL: 4 54381 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%0 0.000 0.000 0.000
article cleanup00:00:00.112 0.0%8373 0.000 0.013 0.046
article logging00:00:01.346 0.0%8410 0.031 0.160 2.934
article parse00:00:00.261 0.0%23460 0.007 0.011 0.022
article write00:00:52.663 0.1%2040 0.798 25.815 87.676
artlog/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.121 0.0%54194 0.001 0.002 0.004
hisgrep/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:33.206 0.1%55069 0.005 1.693 3.462
history sync00:00:00.089 0.0%305 0.000 0.292 3.333
history write00:01:22.208 0.1%7840 0.075 10.486 20.926
idle23:54:53.452 99.6%63353 861.867 1358.948 3020.656
nntp read00:00:00.673 0.0%61592 0.005 0.011 0.021
overview write00:00:46.994 0.1%2040 0.087 23.036 506.393
perl filter00:00:25.111 0.0%7839 2.309 3.203 7.076
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.341 0.0%8201 0.009 0.042 0.085
TOTAL: 24:00:11.48823:59:56.577100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%2009 0.000 0.010 0.070
article prepare00:00:00.002 0.0%652 0.000 0.003 0.062
article read00:00:00.059 0.0%159 0.000 0.371 37.000
backlog stats00:00:00.118 0.0%24833 0.000 0.005 0.019
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.165 0.0%13398 0.004 0.012 0.024
data write00:00:00.191 0.0%11135 0.005 0.017 0.051
idle23:01:43.174100.0%24833 2103.537 3338.428 6283.482
status file00:00:00.645 0.0%385 0.750 1.675 5.818
TOTAL: 23:02:03.07423:01:44.375100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.230 70.9%430 20.000 21.465 26.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.174 1.3%4098 0.000 0.042 1.000
TOTAL: 00:00:13.01300:00:09.404 72.3%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
control@eternal-september.org001001
control@usenet-fr.news.eu.org0001300
us-control@lists.killfile.org000100
TOTAL0021402

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cmpublishers-out.news.weretis.net 30 11561 1630 6170 3761 14%45:34:41
2usenet.blueworldhosting.com 711 3771 197 2941 633 5%38:56:28
3news.samoylyk.net 3 4660 60 4364 236 1%19:49:23
4news.snarked.org 138 2558 51 2251 256 1%128:48:42
5nntp.club.cc.cmu.edu 587 9956 47 8612 1297 0%102:47:06
6localhost 25 0 0 0 0 0%00:00:00
7cmpublishers-out.news.tnetconsulting.net 14 0 0 0 0 0%12:13:17
TOTAL: 7 1508 32506 1985 24338 6183 6%348:09:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cmpublishers-out.news.weretis.net5.4 MB839.0 KB11.4 MB17.6 MB 30%3.3 KB
2usenet.blueworldhosting.com940.2 KB185.9 KB2.7 MB3.8 MB 24%4.7 KB
3news.snarked.org329.8 KB580.1 KB2.0 MB2.9 MB 11%9.8 KB
4nntp.club.cc.cmu.edu208.6 KB681.3 KB3.9 MB4.8 MB 4%3.7 KB
5news.samoylyk.net181.9 KB610.8 KB1.3 MB2.0 MB 8%7.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
7cmpublishers-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 77.0 MB2.8 MB21.4 MB31.2 MB 22%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 1 00:00:05 - 00:59:59 55 2.7% 0.02265.2 KB 3.5% 0.07
Aug 1 01:00:00 - 01:59:59 31 1.5% 0.01234.8 KB 3.1% 0.07
Aug 1 02:00:00 - 02:59:59 32 1.6% 0.01140.7 KB 1.9% 0.04
Aug 1 03:00:00 - 03:59:59 44 2.2% 0.01237.4 KB 3.1% 0.07
Aug 1 04:00:00 - 04:59:59 52 2.5% 0.01398.5 KB 5.2% 0.11
Aug 1 05:00:00 - 05:59:59 48 2.3% 0.01166.7 KB 2.2% 0.05
Aug 1 06:00:00 - 06:59:59 80 3.9% 0.02626.6 KB 8.3% 0.17
Aug 1 07:00:00 - 07:59:59 104 5.1% 0.03382.0 KB 5.0% 0.11
Aug 1 08:00:00 - 08:59:59 103 5.0% 0.03203.3 KB 2.7% 0.06
Aug 1 09:00:00 - 09:59:59 98 4.8% 0.03194.4 KB 2.6% 0.05
Aug 1 10:00:00 - 10:59:59 98 4.8% 0.03268.4 KB 3.5% 0.07
Aug 1 11:00:00 - 11:59:59 59 2.9% 0.02230.3 KB 3.0% 0.06
Aug 1 12:00:00 - 12:59:59 98 4.8% 0.03207.7 KB 2.7% 0.06
Aug 1 13:00:00 - 13:59:59 138 6.8% 0.04345.2 KB 4.5% 0.10
Aug 1 14:00:00 - 14:59:59 156 7.6% 0.04391.9 KB 5.2% 0.11
Aug 1 15:00:00 - 15:59:59 91 4.5% 0.03212.6 KB 2.8% 0.06
Aug 1 16:00:00 - 16:59:59 59 2.9% 0.02121.5 KB 1.6% 0.03
Aug 1 17:00:00 - 17:59:59 82 4.0% 0.02296.1 KB 3.9% 0.08
Aug 1 18:00:00 - 18:59:59 132 6.5% 0.04323.3 KB 4.3% 0.09
Aug 1 19:00:00 - 19:59:59 96 4.7% 0.03251.9 KB 3.3% 0.07
Aug 1 20:00:00 - 20:59:59 82 4.0% 0.02255.7 KB 3.4% 0.07
Aug 1 21:00:00 - 21:59:59 95 4.6% 0.03343.8 KB 4.5% 0.10
Aug 1 22:00:00 - 22:59:59 146 7.1% 0.041.2 MB 16.7% 0.35
Aug 1 23:00:00 - 00:00:02 65 3.2% 0.02229.9 KB 3.0% 0.06
TOTAL: 23:59:57 2044 100.0% 0.027.4 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cmpublishers-out.news.weretis.net 3913 2984 0 239 0 0 0 0 690
2nntp.club.cc.cmu.edu 1295 360 0 106 0 0 0 0 829
3usenet.blueworldhosting.com 633 393 0 32 0 0 0 0 208
4news.samoylyk.net 256 110 0 116 0 0 0 0 30
5news.snarked.org 254 130 0 41 0 0 0 0 83
TOTAL: 5 6351 3977 0 534 0 0 0 0 1840

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test 350
alt.test.ping 288
free.pt 242
rocksolid.shared.test 216
alt.buddha.short.fat.guy 133
fido7.su.pol 112
it.test 104
fr.soc.politique 99
de.soc.politik.misc 91
aus.cars 86
alt.arts.poetry.comments 84
alt.computer.workshop 74
de.talk.tagesgeschehen 72
fr.soc.environnement 72
pl.soc.prawo 70
de.etc.fahrzeug.auto 66
rec.arts.drwho 55
nl.politiek 54
it.politica 54
linux.debian.bugs.rc 51
TOTAL: 366 3977

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 850
EMP (phn path) 665
User-issued cancel 184
Too many newsgroups 92
HTML Multipart 8
Scoring filter (8) 3
TOTAL: 6 1802

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
cmpublishers-out.news.weretis.net 33
nntp.club.cc.cmu.edu 3
news.samoylyk.net 1
TOTAL: 3 37
No colon-space in header
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 38

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1CMU 2645 95 1870 21 0 2 3%23:54:22
2news.samoylyk.net 2217 8 1917 34 0 25 0%23:54:12
3news.snarked.org 2232 4 1969 1 0 0 0%23:54:22
4TNet 2211 1 2030 0 0 1 0%23:54:21
5weretis.net 329 1 324 0 0 0 0%16:57:27
6news.ripco.com 0 0 0 0 0 2016 0%23:59:57
7bwh 1603 0 1521 0 0 2 0%23:53:29
8aioe 0 0 0 0 0 1865 0%23:59:57
TOTAL: 8 11237 109 9631 56 0 3911 0%184:28:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1CMU294.4 KB87.0 KB381.4 KB0.0 KB/s3.3 KB23:54:22
2news.snarked.org273.4 KB1.2 KB274.6 KB0.0 KB/s54.9 KB23:54:22
3news.samoylyk.net16.5 KB109.3 KB125.7 KB0.0 KB/s3.0 KB23:54:12
4TNet1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:54:21
5weretis.net1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB16:57:27
6news.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
7bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:29
8aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8587.8 KB197.5 KB785.3 KB0.0 KB/s4.8 KB184:28:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1cs6.cmpublishers.com 215 00.0 KB 0 0 000:00:11
TOTAL: 1 215 00.0 KB 0 0 000:00:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cmpublishers.com 215 00.0 KB 0 0 000:00:11
TOTAL: 1 215 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.932 0.00000:00:11
47.172.132.66.censys-scanner.com 0.019 0.019 0.00000:00:00
azpdcs8onqkt.stretchoid.com 0.009 0.012 0.00000:00:00
69.5.169.218 0.005 0.005 0.00000:00:00
71.6.134.231 0.013 0.019 0.00000:00:00
o059.scanner.modat.io 0.004 0.008 0.00000:00:00
o021.scanner.modat.io 0.012 0.000 0.00000:00:00
147.185.132.96 0.005 0.005 0.00000:00:00
194.164.107.4 0.000 0.011 0.00000:00:00
TOTAL: 9 1.400 1.011 0.00000:00:13

NNRP no permission clients:

SystemConn
71.6.134.231 3
47.172.132.66.censys-scanner.com 3
azpdcs8onqkt.stretchoid.com 2
o059.scanner.modat.io 1
o021.scanner.modat.io 1
147.185.132.96 1
69.5.169.218 1
194.164.107.4 1
TOTAL: 8 13