Daily Usenet report for news.cmpublishers.com

Mar 15 00:00:04 -- Mar 16 00:00:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Mar 15 15:00:07 cs6 pgpverify[12239]: pgpverify: /usr/bin/gpg1: no such file
Mar 15 15:00:11 cs6 pgpverify[12259]: 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\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\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\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\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\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\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\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\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\x00d size 0
Mar 15 22:06:09 cs6 innfeed[3437]: news.snarked.org:0 connect: Network is unreachable
Mar 15 22:06:09 cs6 innfeed[3437]: news.ripco.com:0 connect: Network is unreachable
Mar 15 22:06:10 cs6 innfeed[3437]: weretis.net:0 connect: Network is unreachable
Mar 15 22:06:10 cs6 innfeed[3437]: CMU:0 connect: Network is unreachable
Mar 15 22:06:10 cs6 innfeed[3437]: bwh:0 connect: Network is unreachable
Mar 15 22:06:10 cs6 innfeed[3437]: news.samoylyk.net:0 connect: Network is unreachable
Mar 15 22:06:11 cs6 innfeed[3437]: TNet:0 connect: Network is unreachable
Mar 15 22:10:01 cs6 innd: tradspool: could not open /var/spool/news/articles/linux/debian/bugs/dist/825024: File exists
Mar 15 22:10:01 cs6 innd: tradspool: could not open /var/spool/news/articles/linux/debian/user/174451: File exists
Mar 15 22:40:04 cs6 innd: tradspool: could not open /var/spool/news/articles/linux/debian/bugs/dist/825025: File exists

Log entries by program:

Program nameLines%LinesSize%Size
innd 9464 47.8%1002.1 KB 41.6%
inn 7830 39.5%1.1 MB 46.8%
innfeed 1843 9.3%216.2 KB 9.0%
nnrpd 649 3.3%60.7 KB 2.5%
controlchan 9 0.0%0.9 KB 0.0%
nocem 2 0.0%0.2 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
TOTAL: 7 19799 100.0%2.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19526 49.1%
Negative hits 12737 32.0%
Do not exist 7315 18.4%
Cache misses 213 0.5%
TOTAL: 4 39791 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.146 0.0%3 0.000 48.667 77.000
article cleanup00:00:00.097 0.0%7410 0.003 0.013 0.029
article logging00:00:00.747 0.0%7448 0.039 0.100 0.642
article parse00:00:00.230 0.0%17597 0.004 0.013 0.023
article write00:00:57.096 0.1%1988 1.092 28.720 86.052
artlog/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:00:00.128 0.0%38790 0.001 0.003 0.011
hisgrep/artcncl00:00:00.035 0.0%3 0.000 11.667 18.000
hishave/artcncl00:00:00.013 0.0%3 0.000 4.333 7.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:35.726 0.1%40333 0.005 2.373 5.603
history sync00:00:00.103 0.0%276 0.000 0.373 2.083
history write00:01:21.489 0.1%7405 0.217 11.005 29.239
idle21:55:00.635 99.6%44713 1107.863 1764.602 3693.837
nntp read00:00:00.535 0.0%43230 0.004 0.012 0.033
overview write00:00:37.086 0.0%1985 0.707 18.683 147.039
perl filter00:00:21.272 0.0%7408 2.057 2.871 5.240
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.358 0.0%8021 0.010 0.045 0.116
TOTAL: 22:00:08.57121:59:55.696100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.012 0.0%2027 0.000 0.006 0.037
article prepare00:00:00.001 0.0%328 0.000 0.003 0.010
article read00:00:00.118 0.0%82 0.000 1.439 4.458
backlog stats00:00:00.082 0.0%22228 0.000 0.004 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.138 0.0%11258 0.000 0.012 0.030
data write00:00:00.154 0.0%9334 0.005 0.016 0.028
idle22:01:04.187100.0%22228 2486.062 3565.961 6636.236
status file00:00:00.704 0.0%375 1.000 1.877 16.667
TOTAL: 22:01:22.45622:01:05.396100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.860 80.4%412 20.000 21.505 28.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.137 1.2%3921 0.000 0.035 1.000
TOTAL: 00:00:11.02300:00:08.997 81.6%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000200
TOTAL000200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cmpublishers-out.news.weretis.net 6 11939 1850 6394 3695 15%45:06:04
2usenet.blueworldhosting.com 304 3469 131 2985 353 3%41:45:07
3news.snarked.org 143 2271 41 2156 74 1%130:40:47
4nntp.club.cc.cmu.edu 577 9999 30 8522 1447 0%94:05:30
5cmpublishers-out.news.tnetconsulting.net 80 0 0 0 0 0%68:15:24
6news.samoylyk.net 1 468 0 468 0 0%00:20:57
7localhost 25 0 0 0 0 0%00:00:00
TOTAL: 7 1136 28146 2052 20525 5569 7%380:13:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cmpublishers-out.news.weretis.net5.5 MB2.0 KB11.5 MB17.0 MB 32%3.1 KB
2usenet.blueworldhosting.com487.3 KB0.0 KB1.6 MB2.0 MB 23%4.3 KB
3news.snarked.org148.1 KB4.3 KB599.3 KB751.7 KB 19%6.5 KB
4nntp.club.cc.cmu.edu87.8 KB0.0 KB3.3 MB3.4 MB 2%2.3 KB
5cmpublishers-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
6news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 76.2 MB6.3 KB16.9 MB23.1 MB 26%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 15 00:00:04 - 00:59:59 74 3.6% 0.02239.4 KB 3.7% 0.07
Mar 15 01:00:00 - 01:59:59 44 2.1% 0.01117.1 KB 1.8% 0.03
Mar 15 02:00:00 - 02:59:59 73 3.5% 0.02332.7 KB 5.1% 0.09
Mar 15 03:00:00 - 03:59:59 39 1.9% 0.01112.8 KB 1.7% 0.03
Mar 15 04:00:00 - 04:59:59 63 3.0% 0.02238.6 KB 3.7% 0.07
Mar 15 05:00:00 - 05:59:59 36 1.7% 0.01125.7 KB 1.9% 0.03
Mar 15 06:00:00 - 06:59:59 46 2.2% 0.01140.3 KB 2.2% 0.04
Mar 15 07:00:00 - 07:59:59 67 3.2% 0.02171.1 KB 2.6% 0.05
Mar 15 08:00:00 - 08:59:59 78 3.8% 0.02153.4 KB 2.4% 0.04
Mar 15 09:00:00 - 09:59:59 160 7.7% 0.04364.4 KB 5.6% 0.10
Mar 15 10:00:00 - 10:59:59 136 6.6% 0.04312.5 KB 4.8% 0.09
Mar 15 11:00:00 - 11:59:59 108 5.2% 0.03222.0 KB 3.4% 0.06
Mar 15 12:00:00 - 12:59:59 87 4.2% 0.02211.3 KB 3.3% 0.06
Mar 15 13:00:00 - 13:59:59 98 4.7% 0.03297.9 KB 4.6% 0.08
Mar 15 14:00:00 - 14:59:59 116 5.6% 0.03347.9 KB 5.4% 0.10
Mar 15 15:00:00 - 15:59:59 123 5.9% 0.03635.6 KB 9.8% 0.18
Mar 15 16:00:00 - 16:59:59 102 4.9% 0.03307.6 KB 4.8% 0.09
Mar 15 17:00:00 - 17:59:59 71 3.4% 0.02166.8 KB 2.6% 0.05
Mar 15 18:00:00 - 18:59:59 117 5.6% 0.03447.1 KB 6.9% 0.12
Mar 15 19:00:00 - 19:59:59 104 5.0% 0.03452.0 KB 7.0% 0.13
Mar 15 20:00:00 - 20:59:59 133 6.4% 0.04401.4 KB 6.2% 0.11
Mar 15 21:00:00 - 21:59:59 29 1.4% 0.0183.2 KB 1.3% 0.02
Mar 15 22:00:00 - 22:59:59 127 6.1% 0.04409.4 KB 6.3% 0.11
Mar 15 23:00:00 - 00:00:01 40 1.9% 0.01174.3 KB 2.7% 0.05
TOTAL: 23:59:57 2071 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 3883 2836 0 1 0 0 0 0 1046
2nntp.club.cc.cmu.edu 1443 278 0 0 0 0 0 0 1165
3usenet.blueworldhosting.com 353 184 0 0 0 0 0 0 169
4news.snarked.org 76 46 0 1 0 0 0 0 29
5cmpublishers-out.news.weretis.neMar 1 0 0 0 0 0 0 0 1
TOTAL: 5 5756 3344 0 2 0 0 0 0 2410

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test 324
rocksolid.shared.test 212
free.pt 137
fr.soc.politique 85
uk.railway 83
alt.buddha.short.fat.guy 81
pl.soc.prawo 79
it.sport.calcio.milan 72
alt.arts.poetry.comments 71
de.soc.politik.misc 70
rec.arts.tv 61
nl.politiek 60
it.test 58
aus.cars 57
de.etc.sprache.deutsch 55
fido7.su.pol 52
fido7.ru.fidonet.today 51
free.willey 48
it.hobby.fai-da-te 41
linux.kernel.git 41
TOTAL: 306 3344

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1207
EMP (phn path) 1022
Too many newsgroups 95
User-issued cancel 29
HTML Multipart 9
Too many newsgroups (meow) 5
Scoring filter (10) 1
TOTAL: 7 2368

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
cmpublishers-out.news.weretis.net 35
nntp.club.cc.cmu.edu 6
TOTAL: 2 41
TOTAL: 1 41

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1CMU 2423 56 1963 26 0 4 2%23:14:08
2bwh 1705 0 1563 0 0 4 0%23:04:01
3news.ripco.com 0 0 0 0 0 2050 0%23:04:08
4weretis.net 175 0 175 0 0 4 0%10:53:07
5TNet 2330 0 2075 0 0 4 0%23:14:07
6news.samoylyk.net 0 0 0 0 0 2058 0%23:04:08
7news.snarked.org 2765 0 2041 0 0 0 0%23:14:08
8aioe 0 0 0 0 0 1952 0%23:04:06
TOTAL: 8 9398 56 7817 26 0 6076 0%172:51:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1CMU163.1 KB73.8 KB236.8 KB0.0 KB/s2.9 KB23:14:08
2bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:04:01
3news.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:04:08
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s010:53:07
5TNet0.0 KB0.0 KB0.0 KB0.0 KB/s023:14:07
6news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:04:08
7news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:14:08
8aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:04:06
TOTAL: 8163.1 KB73.8 KB236.8 KB0.0 KB/s2.9 KB172:51:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1cs6.cmpublishers.com 206 00.0 KB 0 0 000:00:09
TOTAL: 1 206 00.0 KB 0 0 000:00:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cmpublishers.com 206 00.0 KB 0 0 000:00:09
TOTAL: 1 206 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.195 1.008 0.00000:00:09
81.29.142.6 0.011 0.000 0.00000:00:00
44.34.168.206.censys-scanner.com 0.011 0.000 0.00000:00:00
fc3dbf78.tidalcoinage.internet-measurement.com 0.007 0.004 0.00000:00:00
azpdssljyx4k.stretchoid.com 0.015 0.007 0.00000:00:00
205.210.31.221 0.005 0.005 0.00000:00:00
198.235.24.243 0.011 0.000 0.00000:00:00
TOTAL: 7 1.255 1.024 0.00000:00:11

NNRP no permission clients:

SystemConn
azpdssljyx4k.stretchoid.com 2
81.29.142.6 1
fc3dbf78.tidalcoinage.internet-measurement.com 1
198.235.24.243 1
205.210.31.221 1
44.34.168.206.censys-scanner.com 1
TOTAL: 6 7