Daily Usenet report for news.cmpublishers.com

May 25 00:00:03 -- May 26 00:00:04

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

May 25 17:15:04 cs6 pgpverify[13324]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:15:04 cs6 pgpverify[13332]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:15:08 cs6 pgpverify[13345]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:15:08 cs6 pgpverify[13353]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:02 cs6 pgpverify[15480]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:02 cs6 pgpverify[15488]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:04 cs6 pgpverify[15496]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:04 cs6 pgpverify[15504]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:04 cs6 pgpverify[15512]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:30:04 cs6 pgpverify[15520]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:45:02 cs6 pgpverify[17820]: pgpverify: /usr/bin/gpg1: no such file
May 25 17:45:02 cs6 controlchan[17526]: skipping newgroup y moderator@dana.de (pgpverify failed) in <newgroup-de.comm.internet.misc-20260525@dana.de>
May 25 18:00:07 cs6 pgpverify[20510]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
innd 12500 55.2%1.3 MB 49.9%
inn 7527 33.2%1.1 MB 39.8%
innfeed 1905 8.4%213.4 KB 7.7%
nnrpd 701 3.1%67.1 KB 2.4%
controlchan 14 0.1%1.1 KB 0.0%
pgpverify 12 0.1%1.4 KB 0.1%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 22660 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23798 38.8%
Negative hits 16900 27.6%
Cache misses 13248 21.6%
Do not exist 7347 12.0%
TOTAL: 4 61293 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.104 0.0%7477 0.000 0.014 0.029
article logging00:00:00.560 0.0%7530 0.040 0.074 0.273
article parse00:00:00.249 0.0%18280 0.005 0.014 0.025
article write00:00:40.830 0.0%2036 0.404 20.054 58.472
artlog/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.155 0.0%57769 0.001 0.003 0.007
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:02:45.093 0.2%62186 0.010 2.655 5.420
history sync00:00:00.134 0.0%306 0.000 0.438 2.083
history write00:01:15.079 0.1%7477 0.062 10.041 22.646
idle23:54:28.029 99.6%66390 333.381 1296.400 3403.225
nntp read00:00:00.802 0.0%64124 0.006 0.013 0.022
overview write00:00:24.949 0.0%2036 0.442 12.254 271.722
perl filter00:00:22.756 0.0%7477 2.133 3.043 11.462
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.337 0.0%8187 0.000 0.041 0.116
TOTAL: 24:00:13.10423:59:59.077100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.070 0.0%18113 0.000 0.004 0.025
article prepare00:00:00.004 0.0%1280 0.000 0.003 0.011
article read00:00:00.386 0.0%313 0.000 1.233 8.000
backlog stats00:00:00.318 0.0%39628 0.000 0.008 0.104
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.276 0.0%20771 0.005 0.013 0.023
data write00:00:00.238 0.0%18862 0.000 0.013 0.051
idle23:01:34.919100.0%39628 207.636 2091.827 6315.386
status file00:00:00.573 0.0%395 0.667 1.451 8.250
TOTAL: 23:01:42.21923:01:36.784100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.300 68.2%428 19.000 21.729 37.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.190 1.4%4079 0.000 0.047 1.000
TOTAL: 00:00:13.64100:00:09.490 69.6%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de0001100
TOTAL0001100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cmpublishers-out.news.weretis.net 18 11838 1855 6491 3492 15%47:35:57
2news.samoylyk.net 3 5920 130 5362 428 2%24:19:08
3usenet.blueworldhosting.com 1133 3121 54 2784 283 1%67:31:58
4news.snarked.org 191 14822 12 14804 6 0%184:58:35
5nntp.club.cc.cmu.edu 578 9273 9 8024 1240 0%127:59:53
6cmpublishers-out.news.tnetconsulting.net 26 0 0 0 0 0%25:12:59
7localhost 25 0 0 0 0 0%00:00:00
TOTAL: 7 1974 44974 2060 37465 5449 4%477:38:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cmpublishers-out.news.weretis.net5.0 MB0.0 KB10.3 MB15.4 MB 32%2.9 KB
2news.samoylyk.net470.7 KB0.0 KB1.7 MB2.2 MB 21%4.0 KB
3usenet.blueworldhosting.com180.0 KB0.0 KB993.4 KB1.1 MB 15%3.5 KB
4nntp.club.cc.cmu.edu37.7 KB0.0 KB3.7 MB3.8 MB 0%3.1 KB
5news.snarked.org33.7 KB0.0 KB20.7 KB54.4 KB 61%3.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: 75.7 MB0.0 KB16.7 MB22.5 MB 25%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 00:00:03 - 00:59:59 31 1.5% 0.01149.5 KB 2.6% 0.04
May 25 01:00:00 - 01:59:59 52 2.6% 0.01163.6 KB 2.8% 0.05
May 25 02:00:00 - 02:59:59 41 2.0% 0.01158.5 KB 2.7% 0.04
May 25 03:00:00 - 03:59:59 42 2.1% 0.01169.1 KB 2.9% 0.05
May 25 04:00:00 - 04:59:59 65 3.2% 0.02246.6 KB 4.2% 0.07
May 25 05:00:00 - 05:59:59 86 4.2% 0.02292.1 KB 5.0% 0.08
May 25 06:00:00 - 06:59:59 80 3.9% 0.02207.4 KB 3.6% 0.06
May 25 07:00:00 - 07:59:59 116 5.7% 0.03220.6 KB 3.8% 0.06
May 25 08:00:00 - 08:59:59 121 5.9% 0.03253.6 KB 4.4% 0.07
May 25 09:00:00 - 09:59:59 117 5.7% 0.03276.7 KB 4.8% 0.08
May 25 10:00:00 - 10:59:59 78 3.8% 0.02159.5 KB 2.7% 0.04
May 25 11:00:00 - 11:59:59 93 4.6% 0.03161.7 KB 2.8% 0.04
May 25 12:00:00 - 12:59:59 63 3.1% 0.02141.3 KB 2.4% 0.04
May 25 13:00:00 - 13:59:59 104 5.1% 0.03252.0 KB 4.3% 0.07
May 25 14:00:00 - 14:59:59 125 6.1% 0.03279.4 KB 4.8% 0.08
May 25 15:00:00 - 15:59:59 101 5.0% 0.03335.9 KB 5.8% 0.09
May 25 16:00:00 - 16:59:59 134 6.6% 0.04347.3 KB 6.0% 0.10
May 25 17:00:00 - 17:59:59 102 5.0% 0.03245.4 KB 4.2% 0.07
May 25 18:00:00 - 18:59:59 113 5.6% 0.03289.4 KB 5.0% 0.08
May 25 19:00:00 - 19:59:59 57 2.8% 0.02145.0 KB 2.5% 0.04
May 25 20:00:00 - 20:59:59 88 4.3% 0.02265.0 KB 4.6% 0.07
May 25 21:00:00 - 21:59:59 104 5.1% 0.03523.4 KB 9.0% 0.15
May 25 22:00:00 - 22:59:59 75 3.7% 0.02181.1 KB 3.1% 0.05
May 25 23:00:00 - 23:59:59 47 2.3% 0.01348.6 KB 6.0% 0.10
May 26 00:00:00 - 00:00:04 1 0.0% 0.255.6 KB 0.1% 1.41
TOTAL: 24:00:01 2036 100.0% 0.025.7 MB 100.0% 0.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cmpublishers-out.news.weretis.net 3532 3245 0 0 0 0 0 0 287
2nntp.club.cc.cmu.edu 1239 235 0 0 0 0 0 0 1004
3news.samoylyk.net 428 297 0 0 0 0 0 0 131
4usenet.blueworldhosting.com 286 159 0 0 0 0 0 0 127
5news.snarked.org 6 5 0 0 0 0 0 0 1
TOTAL: 5 5491 3941 0 0 0 0 0 0 1550

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test 308
rocksolid.shared.test 219
free.pt 170
alt.buddha.short.fat.guy 159
it.sport.calcio.milan 150
de.soc.politik.misc 142
fr.soc.politique 114
it.test 82
alt.arts.poetry.comments 80
de.talk.tagesgeschehen 73
sfnet.keskustelu.varaventtiili 63
lada.talk 63
fido7.ukrnews 56
linux.kernel.git 56
rec.arts.drwho 55
fr.rec.photo 52
alt.checkmate 50
nl.politiek 47
it-alt.sport.calcio.juventus 47
de.etc.fahrzeug.auto 46
TOTAL: 325 3941

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 936
EMP (phn path) 449
Too many newsgroups 96
User-issued cancel 9
HTML Multipart 6
HTML Image Tags 1
TOTAL: 6 1497

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1CMU 2691 168 1793 47 0 4 6%23:59:56
2news.snarked.org 16510 24 16359 85 0 1672 0%23:59:25
3TNet 2584 2 2014 0 0 1 0%23:58:30
4weretis.net 199 1 187 0 0 3 0%15:45:51
5news.ripco.com 0 0 0 0 0 2007 0%23:59:25
6news.samoylyk.net 1889 0 1859 2 0 0 0%23:59:43
7bwh 1759 0 1634 0 0 1 0%23:57:55
8aioe 0 0 0 0 0 1845 0%23:59:59
TOTAL: 8 25632 195 23846 134 0 5533 0%183:40:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.snarked.org1.3 MB286.3 KB1.6 MB0.0 KB/s14.7 KB23:59:25
2CMU451.3 KB182.1 KB633.4 KB0.0 KB/s2.9 KB23:59:56
3TNet4.1 KB0.0 KB4.1 KB0.0 KB/s2.0 KB23:58:30
4weretis.net2.1 KB0.0 KB2.1 KB0.0 KB/s2.1 KB15:45:51
5news.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:25
6news.samoylyk.net0.0 KB7.4 KB7.4 KB0.0 KB/s3.7 KB23:59:43
7bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:55
8aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
TOTAL: 81.7 MB475.8 KB2.2 MB0.0 KB/s6.8 KB183:40:44
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:13

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.395 0.879 0.00000:00:11
185.223.235.50 0.000 0.013 0.00000:00:00
89.21.67.161 0.004 0.007 0.00000:00:00
r5-209-d1.monitoring.internet-measurement.com 0.007 0.004 0.00000:00:00
110.195.132.66.censys-scanner.com 0.007 0.004 0.00000:00:00
89.21.67.152 0.011 0.000 0.00000:00:00
193.176.31.249 0.008 0.003 0.00000:00:00
rocco.probe.onyphe.net 0.009 0.002 0.00000:00:00
81.19.216.82 0.011 0.000 0.00000:00:00
89.21.67.157 0.004 0.007 0.00000:00:00
89.21.67.158 0.004 0.007 0.00000:00:00
jasmin.probe.onyphe.net 0.006 0.006 0.00000:00:00
azpdes7ac2ik.stretchoid.com 0.010 0.010 0.00000:00:00
TOTAL: 13 1.476 0.942 0.00000:00:13

NNRP no permission clients:

SystemConn
azpdes7ac2ik.stretchoid.com 2
185.223.235.50 1
89.21.67.158 1
81.19.216.82 1
110.195.132.66.censys-scanner.com 1
jasmin.probe.onyphe.net 1
89.21.67.161 1
r5-209-d1.monitoring.internet-measurement.com 1
89.21.67.157 1
89.21.67.152 1
193.176.31.249 1
rocco.probe.onyphe.net 1
TOTAL: 12 13