Daily Usenet report for news.ripco.com

Jul 8 00:01:01 -- Jul 8 23:58:01

Unknown entries from news log file:

First 32 / 32 lines (100.0%)

Jul 8 04:27:42 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 05:50:29 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 06:25:00 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 06:30:24 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 06:34:06 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 06:40:14 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 06:48:19 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 07:03:52 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 07:08:47 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 07:50:41 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 08:03:46 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 08:21:49 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 09:59:51 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 10:11:06 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 12:16:30 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 12:20:34 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 12:23:10 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 13:34:38 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 13:40:58 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 13:47:46 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 13:48:35 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 14:04:32 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 14:06:18 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 14:07:55 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 15:46:07 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 15:56:21 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 16:01:13 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 16:31:03 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 16:38:35 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 17:02:58 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 19:51:14 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping
Jul 8 23:33:07 remote5bge0 overchan[16146]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19703 33.1%3.8 MB 41.1%
innd 18531 31.2%2.9 MB 30.6%
nnrpd 17558 29.5%1.8 MB 19.6%
innfeed 3644 6.1%827.0 KB 8.6%
overchan 32 0.1%4.3 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59470 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 185664 50.3%
Cache misses 183806 49.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 369470 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%216 0.000 0.000 0.000
article cleanup00:00:00.440 0.0%39230 0.000 0.011 0.044
article logging00:00:00.944 0.0%39530 0.000 0.024 0.225
article parse00:00:01.392 0.0%96802 0.000 0.014 0.047
article write00:02:00.270 0.1%29720 1.415 4.047 25.913
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.330 0.0%375180 0.000 0.001 0.006
hishave/artparse00: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:00:44.494 0.0%371222 0.002 0.120 1.728
history sync00:00:00.256 0.0%800 0.000 0.320 2.000
history write00:00:04.520 0.0%39238 0.000 0.115 1.707
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:55:21.468 99.8%412954 243.853 417.774 993.551
nntp read00:00:03.052 0.0%414418 0.002 0.007 0.015
overview write00:00:00.256 0.0%29720 0.000 0.009 0.061
perl filter00:01:06.744 0.0%39230 1.360 1.701 3.894
python filter00:00:01.434 0.0%39234 0.000 0.037 0.109
site send00:00:02.954 0.0%89152 0.006 0.033 0.066
TOTAL: 48:02:12.45247:59:28.554 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.110 0.0%29710 0.000 0.004 0.022
article prepare00:00:00.000 0.0%10600 0.000 0.000 0.000
article read00:00:00.442 0.0%1998 0.000 0.221 35.000
backlog stats00:00:00.256 0.0%452072 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.730 0.0%287438 0.001 0.006 0.015
data write00:00:04.556 0.0%257760 0.005 0.018 0.037
idle47:53:25.126100.0%452072 224.826 381.367 864.650
status file00:00:03.114 0.0%362 0.000 8.602 177.000
TOTAL: 47:53:54.93047:53:35.334100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:14:48.108 98.3%18296 8.667 638.834 29432.820
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.762 0.0%409600 0.000 0.012 1.000
readart00:00:21.354 0.2%2954 1.714 7.229 38.500
TOTAL: 03:18:13.25403:15:14.224 98.5%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 293
name 2
pause 2
paused 2
reserve 4
TOTAL: 9 313

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 35214 10078 20516 4620 28%94:38:48
2news.snarked.org 48 27750 6684 20374 692 24%54:05:16
3feeder3.feed-ams.uzoreto.com 574 16026 6008 8584 1434 37%47:19:36
4newsfeed.neva.ru 584 34194 5292 27136 1766 15%277:42:22
5ripco-out.news.tnetconsulting.net 6 22582 562 21970 50 2%33:37:20
6newsfeed.fu-berlin.de 2 3532 206 3326 0 5%16:13:42
7news.lightlink.com 2 7484 132 7290 62 1%43:52:52
8news-in.rahul.net 574 14878 76 14796 6 0%47:31:02
9ripco-out.feeder.erje.net 574 31460 22 30596 842 0%47:17:44
10news.cmpublishers.com 52 8600 8 8588 4 0%47:59:34
11localhost 150 4 4 0 0 100%00:00:02
TOTAL: 11 3714 201724 29072 163176 9476 14%710:18:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.3 MB0.0 KB8.9 MB34.2 MB 73%2.4 KB
2news.snarked.org19.4 MB0.0 KB1.9 MB21.3 MB 91%3.0 KB
3feeder3.feed-ams.uzoreto.com15.2 MB0.0 KB3.8 MB19.0 MB 79%2.6 KB
4newsfeed.neva.ru14.3 MB0.0 KB4.0 MB18.4 MB 78%2.7 KB
5ripco-out.news.tnetconsulting.net9.1 MB0.0 KB1004.2 KB10.1 MB 90%16.8 KB
6news.lightlink.com6.9 MB0.0 KB4.2 MB11.0 MB 62%58.3 KB
7newsfeed.fu-berlin.de1.4 MB0.0 KB0.0 KB1.4 MB100%6.9 KB
8news-in.rahul.net1.2 MB0.0 KB270.7 KB1.4 MB 81%18.0 KB
9ripco-out.feeder.erje.net314.5 KB0.0 KB5.6 MB5.9 MB 5%7.0 KB
10news.cmpublishers.com29.8 KB0.0 KB10.9 KB40.8 KB 73%3.4 KB
11localhost11.0 KB0.0 KB0.0 KB11.0 KB100%2.8 KB
TOTAL: 1193.1 MB0.0 KB29.6 MB122.7 MB 75%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 8 00:01:01 - 00:59:59 429 2.9% 0.121.1 MB 2.2% 0.32
Jul 8 01:00:00 - 01:59:59 493 3.3% 0.142.5 MB 4.8% 0.70
Jul 8 02:00:00 - 02:59:59 584 3.9% 0.161.6 MB 3.1% 0.45
Jul 8 03:00:00 - 03:59:59 627 4.2% 0.172.5 MB 4.8% 0.70
Jul 8 04:00:00 - 04:59:59 629 4.2% 0.172.1 MB 4.2% 0.60
Jul 8 05:00:00 - 05:59:59 709 4.8% 0.202.3 MB 4.6% 0.67
Jul 8 06:00:00 - 06:59:59 698 4.7% 0.192.4 MB 4.7% 0.68
Jul 8 07:00:00 - 07:59:59 715 4.8% 0.201.8 MB 3.5% 0.51
Jul 8 08:00:00 - 08:59:59 789 5.3% 0.223.0 MB 5.9% 0.85
Jul 8 09:00:00 - 09:59:59 923 6.2% 0.262.7 MB 5.4% 0.78
Jul 8 10:00:00 - 10:59:59 822 5.6% 0.232.9 MB 5.6% 0.82
Jul 8 11:00:00 - 11:59:59 871 5.9% 0.242.7 MB 5.3% 0.77
Jul 8 12:00:00 - 12:59:59 804 5.4% 0.223.5 MB 6.8% 0.99
Jul 8 13:00:00 - 13:59:59 746 5.0% 0.212.5 MB 4.8% 0.70
Jul 8 14:00:00 - 14:59:59 809 5.5% 0.222.7 MB 5.3% 0.78
Jul 8 15:00:00 - 15:59:59 771 5.2% 0.212.1 MB 4.2% 0.61
Jul 8 16:00:00 - 16:59:59 671 4.5% 0.192.2 MB 4.3% 0.62
Jul 8 17:00:00 - 17:59:59 666 4.5% 0.182.5 MB 4.8% 0.70
Jul 8 18:00:00 - 18:59:59 319 2.2% 0.092.1 MB 4.2% 0.61
Jul 8 19:00:00 - 19:59:59 322 2.2% 0.09995.6 KB 1.9% 0.28
Jul 8 20:00:00 - 20:59:59 364 2.5% 0.101.0 MB 2.0% 0.29
Jul 8 21:00:00 - 21:59:59 338 2.3% 0.09900.4 KB 1.7% 0.25
Jul 8 22:00:00 - 22:59:59 352 2.4% 0.101.4 MB 2.8% 0.41
Jul 8 23:00:00 - 23:58:01 356 2.4% 0.101.7 MB 3.2% 0.49
TOTAL: 23:57:00 14807 100.0% 0.1751.1 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2326 1676 0 0 8 0 0 0 642
2newsfeed.neva.ru 932 598 0 0 2 0 0 0 332
3feeder3.feed-ams.uzoreto.com 718 379 0 0 1 0 0 0 338
4ripco-out.feeder.erje.net 421 418 0 0 0 0 0 0 3
5news.snarked.org 345 208 0 0 1 0 0 0 136
6newsfeed.fu-berlin.de 92 0 0 0 0 0 0 0 92
7ripco-out.news.tnetconsulting.net 39 24 0 0 0 0 0 0 15
8news.lightlink.com 20 0 0 0 0 0 0 0 20
9news-in.rahul.net 3 0 0 0 0 0 0 0 3
TOTAL: 9 4896 3303 0 0 12 0 0 0 1581

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2448
alt.binaries.ftd 207
scot.general 43
fido7.su.pol.news 40
perl.cpan.uploads 33
scinet.stats 31
alt.binaries.pictures.scenic 26
it.comp.os.win.windows10 23
free.it.scienza.fisica 21
alt.binaries.3d.poser 20
alt.binaries.humor.skewed 19
alt.bestjobsusa.computer.jobs 19
alt.binaries.e-book 18
it.tlc.cellulari.android 17
uk.net.news.moderation 16
trollnet.cinema 14
free.willey 11
linux.debian.changes 11
alt.paranormal.spells 10
alt.jobs.jobsearch 10
TOTAL: 126 3303

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.praca.oferowana 4
fr.bienvenue 3
christnet.bible 2
alt.christnet.christnews 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 6 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1166
Too many newsgroups 1080
EMP (phl) 384
Binary in non-binary group 162
Scoring filter (8) 26
HTML post 14
Scoring filter (10) 10
Scoring filter (9) 10
Scoring filter (18) 4
Scoring filter (11) 4
TOTAL: 10 2860

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 28
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 2
TOTAL: 3 40
Including strange strings
newsfeed.fu-berlin.de 88
newsfeed.neva.ru 46
ripco-out.feed.uzoreto.com 14
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 149
No colon-space in header
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
TOTAL: 2 3
TOTAL: 3 192

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 23330 726 12846 36 0 0 3%47:39:30
2feeder.erje.net 34974 658 27288 442 0 16 1%47:40:32
3news.lightlink.com 10024 510 6238 6 0 0 5%47:33:44
4news.snarked.org 36936 32 22660 4 0 30 0%47:53:44
5news.tnetconsulting.net 43030 18 28660 4 0 26 0%47:40:00
6fu-berlin.de 27196 18 27176 0 0 0 0%47:40:08
7news.cmpublishers.com 42236 12 29036 124 0 20 0%47:40:20
8news.uzoreto.com 13418 12 13094 6 0 0 0%47:35:08
9newsfeed.neva.ru 24744 8 24236 10 0 0 0%47:40:06
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 255894 1994 191234 638 0 92 0%430:15:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net9.3 MB81.4 KB9.4 MB0.1 KB/s12.6 KB47:39:30
2news.lightlink.com3.3 MB33.3 KB3.3 MB0.0 KB/s6.6 KB47:33:44
3feeder.erje.net2.1 MB1.4 MB3.6 MB0.0 KB/s3.3 KB47:40:32
4news.snarked.org186.1 KB7.6 KB193.7 KB0.0 KB/s5.4 KB47:53:44
5news.tnetconsulting.net167.1 KB5.7 KB172.8 KB0.0 KB/s7.9 KB47:40:00
6newsfeed.neva.ru111.8 KB43.5 KB155.3 KB0.0 KB/s8.6 KB47:40:06
7fu-berlin.de97.3 KB0.0 KB97.3 KB0.0 KB/s5.4 KB47:40:08
8news.uzoreto.com94.9 KB33.8 KB128.7 KB0.0 KB/s7.1 KB47:35:08
9news.cmpublishers.com32.0 KB443.1 KB475.1 KB0.0 KB/s3.5 KB47:40:20
10remote6hme0.ripco.com0.0 KB38.4 KB38.4 KB0.0 KB/s6.4 KB01:12:06
TOTAL: 1015.4 MB2.1 MB17.5 MB0.0 KB/s6.8 KB430:15:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12903.4 MB 468 2 000:07:14
2shell3 12 3721.1 MB 30 2 003:09:38
TOTAL: 2 298 16624.5 MB 498 4 003:18:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12903.4 MB 468 2 000:07:14
2? 12 3721.1 MB 30 2 003:09:38
TOTAL: 2 298 16624.5 MB 498 4 003:16:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.162 5.628 0.00003:09:38
ftupet.com 47.360 21.722 0.00000:07:14
84-105-134-55.cable.dynamic.v4.ziggo.nl 6.460 1.748 0.00000:00:59
scan-141.security.ipip.net 0.200 0.052 0.00000:00:04
rrcs-70-61-57-36.central.biz.rr.com 2.164 0.604 0.00000:00:03
183.136.225.45 0.206 0.052 0.00000:00:00
TOTAL: 6 59.552 29.806 0.00003:18:00

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 64
rrcs-70-61-57-36.central.biz.rr.com 18
scan-141.security.ipip.net 2
183.136.225.45 2
TOTAL: 4 86

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1548 93.1%
2comp 50 3.0%
3sci 38 2.3%
4chi 8 0.5%
5alt 8 0.5%
6news 8 0.5%
7ba 2 0.1%
TOTAL: 7 1662100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1rec.arts.tv 838
2rec.food.cooking 534
3rec.bicycles.tech 158
4sci.electronics.repair 38
5comp.protocols.dns.bind 32
6comp.unix.bsd.freebsd.misc 10
7alt.stupidity 8
8rec.radio.broadcasting 6
9news.software.readers 6
10rec.puzzles 6
11rec.radio.swap 4
12comp.mail.sendmail 4
13chi.weather 4
14chi.general 4
15comp.sys.mac.system 4
16ba.internet 2
17rec.bicycles.misc 2
18news.admin.net-abuse.usenet 2
TOTAL: 18 1662