Daily Usenet report for news.ripco.com

Sep 25 00:01:02 -- Sep 25 23:57:42

Unknown entries from news log file:

First 25 / 25 lines (100.0%)

Sep 25 00:02:00 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 00:08:01 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 00:34:01 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 01:47:27 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 07:52:11 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 08:38:32 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 09:41:03 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 09:49:57 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 10:08:18 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:03:47 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:12:43 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:43:58 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:48:43 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:50:52 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 13:57:21 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 14:04:48 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 14:23:22 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 15:59:46 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 16:04:45 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 16:06:41 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 16:22:20 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 17:32:37 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 20:57:06 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 23:12:30 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping
Sep 25 23:40:54 remote5bge0 overchan[3927]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19484 32.9%3.8 MB 41.1%
innd 18541 31.4%2.9 MB 31.2%
nnrpd 17330 29.3%1.8 MB 19.4%
innfeed 3755 6.3%778.3 KB 8.2%
overchan 25 0.0%3.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59137 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Cache misses 466232 71.5%
Do not exist 185732 28.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 651964 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%142 0.000 0.000 0.000
article cleanup00:00:00.480 0.0%38632 0.000 0.012 0.043
article logging00:00:00.838 0.0%39070 0.000 0.021 0.304
article parse00:00:01.364 0.0%96120 0.000 0.014 0.036
article write00:01:23.118 0.0%29432 1.409 2.824 29.371
artlog/artparse00:00:00.002 0.0%16 0.000 0.125 1.000
data move00:00:00.470 0.0%482242 0.000 0.001 0.007
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:04.676 0.0%653114 0.000 0.007 0.017
history sync00:00:00.182 0.0%786 0.000 0.232 1.500
history write00:00:04.778 0.0%38648 0.033 0.124 2.716
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:37.932 99.8%524680 62.379 328.958 1169.018
nntp read00:00:03.964 0.0%523990 0.003 0.008 0.016
overview write00:00:00.310 0.0%29432 0.000 0.011 0.066
perl filter00:00:57.472 0.0%38632 1.164 1.488 2.721
python filter00:00:01.492 0.0%38636 0.000 0.039 0.143
site send00:00:02.822 0.0%88244 0.000 0.032 0.074
TOTAL: 48:02:03.52247:59:19.900 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.884 0.0%482062 0.000 0.002 0.048
article prepare00:00:00.080 0.0%172132 0.000 0.000 0.025
article read00:04:31.388 0.2%42338 0.000 6.410 18.500
backlog stats00:00:00.384 0.0%637038 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.296 0.0%414870 0.001 0.006 0.018
data write00:00:06.704 0.0%383660 0.006 0.017 0.040
idle47:47:09.020 99.8%637038 15.228 270.045 1237.793
status file00:00:03.086 0.0%410 0.000 7.527 33.000
TOTAL: 47:52:18.08847:51:53.842100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:01:47.328 96.9%18538 0.333 588.377 23545.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.856 0.1%781472 0.000 0.011 0.053
readart00:00:22.278 0.2%2556 0.000 8.716 35.500
TOTAL: 03:07:38.31603:02:18.462 97.2%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1146 30406 12620 15140 2646 41%94:40:30
2feeder3.feed-ams.uzoreto.com 574 19916 7486 8568 3862 37%47:22:32
3newsfeed.neva.ru 608 20692 5636 13528 1528 27%275:18:12
4news.snarked.org 54 321270 1624 319538 108 0%45:19:48
5newsfeed.fu-berlin.de 4 20208 1116 19062 30 5%66:21:20
6ripco-out.news.tnetconsulting.net 10 28680 786 27824 70 2%42:25:44
7news.lightlink.com 2 10344 232 9872 240 2%52:29:26
8news-in.rahul.net 574 16070 176 15832 62 1%47:23:32
9ripco-out.feeder.erje.net 574 31162 62 30398 702 0%47:19:44
10news.cmpublishers.com 54 6416 12 6388 16 0%36:15:12
11localhost 150 4 4 0 0 100%00:00:04
TOTAL: 11 3750 505168 29754 466150 9264 5%754:56:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com32.2 MB0.0 KB6.3 MB38.6 MB 83%2.6 KB
2feeder3.feed-ams.uzoreto.com19.0 MB0.0 KB6.9 MB25.8 MB 73%2.3 KB
3newsfeed.neva.ru17.3 MB0.0 KB3.7 MB21.0 MB 82%3.0 KB
4ripco-out.news.tnetconsulting.net8.9 MB0.0 KB664.2 KB9.6 MB 93%11.4 KB
5newsfeed.fu-berlin.de6.7 MB0.0 KB202.3 KB6.9 MB 97%6.1 KB
6news.snarked.org4.7 MB0.0 KB289.7 KB5.0 MB 94%3.0 KB
7news-in.rahul.net3.0 MB0.0 KB3.3 MB6.3 MB 47%27.1 KB
8news.lightlink.com1.9 MB0.0 KB9.6 MB11.5 MB 16%25.0 KB
9ripco-out.feeder.erje.net166.6 KB0.0 KB4.5 MB4.6 MB 3%6.2 KB
10news.cmpublishers.com45.9 KB0.0 KB49.1 KB95.0 KB 48%3.4 KB
11localhost13.8 KB0.0 KB0.0 KB13.8 KB100%3.4 KB
TOTAL: 1193.9 MB0.0 KB35.5 MB129.4 MB 72%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 25 00:01:02 - 00:59:59 331 2.3% 0.092.4 MB 5.3% 0.71
Sep 25 01:00:00 - 01:59:59 473 3.2% 0.131.6 MB 3.5% 0.47
Sep 25 02:00:00 - 02:59:59 658 4.5% 0.181.6 MB 3.5% 0.47
Sep 25 03:00:00 - 03:59:59 696 4.7% 0.192.1 MB 4.4% 0.59
Sep 25 04:00:00 - 04:59:59 798 5.4% 0.222.1 MB 4.6% 0.61
Sep 25 05:00:00 - 05:59:59 694 4.7% 0.192.1 MB 4.4% 0.58
Sep 25 06:00:00 - 06:59:59 554 3.8% 0.151.7 MB 3.7% 0.49
Sep 25 07:00:00 - 07:59:59 735 5.0% 0.202.3 MB 5.0% 0.66
Sep 25 08:00:00 - 08:59:59 847 5.8% 0.242.4 MB 5.2% 0.69
Sep 25 09:00:00 - 09:59:59 858 5.8% 0.242.5 MB 5.4% 0.72
Sep 25 10:00:00 - 10:59:59 810 5.5% 0.232.5 MB 5.5% 0.72
Sep 25 11:00:00 - 11:59:59 797 5.4% 0.222.4 MB 5.2% 0.69
Sep 25 12:00:00 - 12:59:59 826 5.6% 0.232.6 MB 5.5% 0.73
Sep 25 13:00:00 - 13:59:59 803 5.5% 0.222.6 MB 5.5% 0.73
Sep 25 14:00:00 - 14:59:59 693 4.7% 0.192.2 MB 4.7% 0.63
Sep 25 15:00:00 - 15:59:59 698 4.8% 0.191.9 MB 4.2% 0.55
Sep 25 16:00:00 - 16:59:59 642 4.4% 0.182.5 MB 5.4% 0.72
Sep 25 17:00:00 - 17:59:59 538 3.7% 0.151.5 MB 3.3% 0.44
Sep 25 18:00:00 - 18:59:59 570 3.9% 0.161.5 MB 3.3% 0.44
Sep 25 19:00:00 - 19:59:59 332 2.3% 0.09922.9 KB 1.9% 0.26
Sep 25 20:00:00 - 20:59:59 333 2.3% 0.09980.0 KB 2.1% 0.27
Sep 25 21:00:00 - 21:59:59 289 2.0% 0.081.4 MB 3.1% 0.40
Sep 25 22:00:00 - 22:59:59 390 2.7% 0.111.2 MB 2.6% 0.34
Sep 25 23:00:00 - 23:57:42 307 2.1% 0.091.2 MB 2.5% 0.35
TOTAL: 23:56:40 14672 100.0% 0.1746.5 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1939 1564 0 0 3 0 0 0 372
2ripco-out.feed.uzoreto.com 1328 717 0 0 1 0 0 0 610
3newsfeed.neva.ru 812 434 0 0 2 0 0 0 376
4ripco-out.feeder.erje.net 350 350 0 0 0 0 0 0 0
5newsfeed.fu-berlin.de 151 0 0 0 0 0 0 0 151
6news.lightlink.com 98 4 0 0 0 0 0 0 94
7news.snarked.org 58 22 0 0 0 0 0 0 36
8ripco-out.news.tnetconsulting.net 38 10 0 0 0 0 0 0 28
9news-in.rahul.net 31 0 0 0 0 0 0 0 31
10news.cmpublishers.com 7 0 0 0 0 0 0 0 7
TOTAL: 10 4812 3101 0 0 6 0 0 0 1705

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2322
alt.binaries.ftd 134
fido7.su.pol.news 39
alt.bestjobsusa.computer.jobs 34
uk.net.news.moderation 34
alt.binaries.e-book 31
scinet.stats 27
de.soc.arbeitslos 23
free.willey 22
it.tlc.cellulari.android 20
panix.chat.politics 19
alt.binaries.pictures.scenic 17
alt.my.job.sucks 17
free.software 17
scot.general 15
alt.binaries.pictures.earlmiller 13
alt.binaries.3d.poser 13
alt.jobs.jobsearch 13
it.comp.os.win.windows10 10
at.jobs 10
TOTAL: 134 3101

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

GroupsCount
pl.praca.oferowana 5
bit.listserv.catholic 1
TOTAL: 2 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1614
Too many newsgroups 878
EMP (phl) 278
Binary in non-binary group 104
Scoring filter (8) 30
Scoring filter (9) 20
Scoring filter (10) 12
HTML post 4
Scoring filter (11) 4
Scoring filter (12) 4
Scoring filter (18) 2
Scoring filter (17) 2
Scoring filter (15) 2
Scoring filter (14) 2
Scoring filter (13) 2
TOTAL: 15 2958

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
feeder3.feed-ams.uzoreto.com 2
ripco-out.feed.uzoreto.com 2
TOTAL: 3 26
Including strange strings
newsfeed.fu-berlin.de 146
newsfeed.neva.ru 52
feeder3.feed-ams.uzoreto.com 8
ripco-out.feed.uzoreto.com 6
news.snarked.org 4
ripco-out.news.tnetconsulting.net 2
TOTAL: 6 218
No colon-space in header
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 6
TOTAL: 3 250

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.snarked.org 458124 28946 364162 11094 14 65400 6%47:38:28
2news.lightlink.com 11724 678 7032 20 0 0 5%47:40:04
3feeder.erje.net 32450 608 26992 502 0 0 1%47:34:00
4rahul.net 24454 588 13606 10 0 0 2%47:40:04
5newsfeed.neva.ru 24296 26 23556 14 0 0 0%47:39:40
6fu-berlin.de 26350 26 26324 0 0 0 0%47:40:04
7news.cmpublishers.com 40016 22 28604 360 0 10572 0%47:45:02
8news.tnetconsulting.net 48670 18 28506 0 0 28 0%47:40:04
9news.uzoreto.com 8976 14 8760 20 0 0 0%47:33:40
10remote6hme0.ripco.com 14 8 0 6 0 0 57%01:32:08
TOTAL: 10 675074 30934 527542 12026 14 76000 4%430:23:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.snarked.org105.3 MB38.6 MB143.8 MB0.9 KB/s3.7 KB47:38:28
2rahul.net4.5 MB16.0 KB4.5 MB0.0 KB/s7.8 KB47:40:04
3news.lightlink.com3.4 MB202.9 KB3.6 MB0.0 KB/s5.3 KB47:40:04
4feeder.erje.net1.7 MB1.4 MB3.1 MB0.0 KB/s2.9 KB47:34:00
5fu-berlin.de97.2 KB0.0 KB97.2 KB0.0 KB/s3.7 KB47:40:04
6newsfeed.neva.ru92.5 KB31.7 KB124.2 KB0.0 KB/s3.1 KB47:39:40
7news.tnetconsulting.net89.1 KB0.0 KB89.1 KB0.0 KB/s5.0 KB47:40:04
8news.uzoreto.com53.3 KB49.7 KB103.0 KB0.0 KB/s3.0 KB47:33:40
9news.cmpublishers.com46.7 KB824.0 KB870.7 KB0.0 KB/s2.3 KB47:45:02
10remote6hme0.ripco.com14.6 KB19.9 KB34.6 KB0.0 KB/s2.5 KB01:32:08
TOTAL: 10115.3 MB41.1 MB156.4 MB0.1 KB/s3.7 KB430:23:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10002.5 MB 456 2 000:10:42
2shell3.ripco.com 30 5541.4 MB 66 2 002:56:45
TOTAL: 2 316 15544.0 MB 522 4 003:07:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10002.5 MB 456 2 000:10:42
2*.ripco.com 30 5541.4 MB 66 2 002:56:45
TOTAL: 2 316 15544.0 MB 522 4 003:07:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 6.304 7.148 0.00002:56:45
ftupet.com 47.342 21.130 0.00000:10:42
modemcable203.1-59-74.mc.videotron.ca 0.200 0.048 0.00000:00:00
192.241.235.112 0.200 0.052 0.00000:00:00
45.141.87.4 0.206 0.060 0.00000:00:00
TOTAL: 5 54.252 28.438 0.00003:07:28

NNRP no permission clients:

SystemConn
modemcable203.1-59-74.mc.videotron.ca 2
192.241.235.112 2
45.141.87.4 2
TOTAL: 3 6

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

Newsgroup request counts (by category):

CategoryCountPct
1rec 1320 84.9%
2alt 76 4.9%
3comp 50 3.2%
4rocksolid 34 2.2%
5misc 26 1.7%
6sci 20 1.3%
7chi 20 1.3%
8news 8 0.5%
TOTAL: 8 1554100.0%

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

NewsgroupCount
1rec.arts.tv 712
2rec.food.cooking 450
3rec.bicycles.tech 134
4alt.comp.os.windows-10 34
5comp.sys.apple2 24
6misc.phone.mobile.iphone 20
7sci.electronics.repair 20
8alt.stupidity 18
9chi.forsale 14
10rocksolid.nodes.announce 12
11rocksolid.shared.security 10
12comp.mobile.android 10
13rec.outdoors.rv-travel 10
14alt.free.newsservers 8
15comp.unix.solaris 8
16rocksolid.shared.hacking 6
17alt.security.alarms 6
18misc.consumers.frugal-living 6
19chi.weather 6
20rec.radio.shortwave 6
21rec.radio.broadcasting 6
22news.admin.net-abuse.email 6
23comp.sys.mac.system 4
24rocksolid.shared.linux 4
25news.admin.net-abuse.usenet 2
26alt.solaris.x86 2
27comp.security.ssh 2
28alt.video.digital-tv 2
29alt.troll.adam-h-kerman 2
30rocksolid.shared.offtopic 2
31alt.hvac 2
32comp.risks 2
33alt.tv.tech.hdtv 2
34rec.radio.swap 2
TOTAL: 34 1554