Daily Usenet report for news.ripco.com

Nov 11 00:01:01 -- Nov 11 23:58:00

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Nov 11 07:00:00 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 09:14:08 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 09:29:44 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 09:46:02 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 12:55:09 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 20:21:31 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 21:49:19 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping
Nov 11 22:35:24 remote5bge0 overchan[6383]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19443 33.1%3.8 MB 40.9%
innd 18334 31.2%2.9 MB 31.1%
nnrpd 17245 29.3%1.8 MB 19.4%
innfeed 3738 6.4%799.4 KB 8.5%
overchan 8 0.0%1.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 58770 100.0%9.2 MB100.0%

History cache:

ReasonCount%Count
Cache misses 172318 50.4%
Do not exist 169402 49.6%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 341720 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%62 0.000 0.000 0.000
article cleanup00:00:00.488 0.0%38642 0.000 0.013 0.057
article logging00:00:00.886 0.0%38948 0.000 0.023 0.333
article parse00:00:02.046 0.0%118168 0.000 0.017 0.040
article write00:01:34.438 0.1%29740 1.744 3.175 61.646
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.554 0.0%379672 0.000 0.001 0.005
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:03.148 0.0%342576 0.001 0.009 0.019
history sync00:00:00.234 0.0%800 0.000 0.292 5.750
history write00:00:03.884 0.0%38636 0.018 0.101 4.977
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:31.446 99.8%413458 250.268 417.434 1175.334
nntp read00:00:03.730 0.0%412264 0.002 0.009 0.021
overview write00:00:00.308 0.0%29740 0.000 0.010 0.064
perl filter00:01:09.876 0.0%38634 1.187 1.809 4.923
python filter00:00:01.582 0.0%38640 0.000 0.041 0.098
site send00:00:02.170 0.0%89134 0.007 0.024 0.054
TOTAL: 48:02:11.02447:59:34.790 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.518 0.0%42724 0.000 0.012 0.061
article prepare00:00:00.038 0.0%78280 0.000 0.000 0.012
article read00:00:20.330 0.0%17676 0.000 1.150 9.250
backlog stats00:00:00.314 0.0%449534 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.032 0.0%281844 0.001 0.011 0.023
data write00:00:05.208 0.0%252610 0.010 0.021 0.035
idle47:52:57.560100.0%449534 132.077 383.458 1041.736
status file00:00:02.132 0.0%398 0.000 5.357 39.000
TOTAL: 47:53:52.31247:53:29.132100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:29:01.682 96.4%17840 8.000 299.422 16497.028
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.868 0.1%568240 0.000 0.010 0.059
readart00:00:19.160 0.3%2008 3.250 9.542 36.500
TOTAL: 01:32:20.95401:29:26.710 96.9%----

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 35196 12976 17946 4274 36%94:39:20
2news.snarked.org 44 25588 5472 19802 314 21%52:42:26
3newsfeed.neva.ru 566 32688 5348 26382 958 16%274:30:32
4feeder3.feed-ams.uzoreto.com 574 13246 4222 7710 1314 31%47:20:02
5ripco-out.news.tnetconsulting.net 2 36678 614 35976 88 1%53:59:06
6newsfeed.fu-berlin.de 2 13562 516 13034 12 3%47:28:50
7news-in.rahul.net 574 14042 166 13836 40 1%47:20:02
8ripco-out.feeder.erje.net 576 30698 94 29672 932 0%47:18:50
9news.lightlink.com 4 5166 40 4256 870 0%34:05:30
10news.cmpublishers.com 38 6218 14 6200 4 0%31:54:32
11localhost 152 6 6 0 0 100%00:00:00
TOTAL: 11 3678 213088 29468 174814 8806 13%731:19:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com31.8 MB29.3 KB8.3 MB40.1 MB 79%2.4 KB
2news.snarked.org16.1 MB0.0 KB1.0 MB17.1 MB 94%3.0 KB
3newsfeed.neva.ru15.2 MB70.3 KB2.6 MB17.9 MB 84%2.9 KB
4feeder3.feed-ams.uzoreto.com10.5 MB0.0 KB2.6 MB13.1 MB 80%2.4 KB
5ripco-out.news.tnetconsulting.net9.0 MB5.9 KB2.5 MB11.5 MB 78%16.8 KB
6news-in.rahul.net6.3 MB0.0 KB1.7 MB8.0 MB 78%39.9 KB
7newsfeed.fu-berlin.de5.7 MB0.0 KB29.1 KB5.8 MB 99%11.2 KB
8news.lightlink.com3.5 MB0.0 KB94.5 MB98.0 MB 3%110.3 KB
9ripco-out.feeder.erje.net232.0 KB0.0 KB8.5 MB8.7 MB 2%8.7 KB
10news.cmpublishers.com48.9 KB0.0 KB14.3 KB63.3 KB 77%3.5 KB
11localhost11.2 KB0.0 KB0.0 KB11.2 KB100%1.9 KB
TOTAL: 1198.5 MB105.5 KB121.7 MB220.3 MB 44%5.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 11 00:01:01 - 00:59:59 316 2.1% 0.091.3 MB 2.6% 0.38
Nov 11 01:00:00 - 01:59:59 454 3.1% 0.132.7 MB 5.3% 0.76
Nov 11 02:00:00 - 02:59:59 693 4.7% 0.191.7 MB 3.3% 0.47
Nov 11 03:00:00 - 03:59:59 745 5.0% 0.212.1 MB 4.1% 0.59
Nov 11 04:00:00 - 04:59:59 736 5.0% 0.202.0 MB 4.0% 0.57
Nov 11 05:00:00 - 05:59:59 732 4.9% 0.201.9 MB 3.7% 0.53
Nov 11 06:00:00 - 06:59:59 700 4.7% 0.193.1 MB 6.1% 0.88
Nov 11 07:00:00 - 07:59:59 786 5.3% 0.223.5 MB 6.8% 0.98
Nov 11 08:00:00 - 08:59:59 870 5.9% 0.242.7 MB 5.4% 0.78
Nov 11 09:00:00 - 09:59:59 856 5.8% 0.242.3 MB 4.6% 0.67
Nov 11 10:00:00 - 10:59:59 923 6.2% 0.262.8 MB 5.5% 0.79
Nov 11 11:00:00 - 11:59:59 849 5.7% 0.242.7 MB 5.3% 0.77
Nov 11 12:00:00 - 12:59:59 760 5.1% 0.212.0 MB 3.9% 0.56
Nov 11 13:00:00 - 13:59:59 834 5.6% 0.233.7 MB 7.3% 1.05
Nov 11 14:00:00 - 14:59:59 715 4.8% 0.202.1 MB 4.2% 0.61
Nov 11 15:00:00 - 15:59:59 669 4.5% 0.192.2 MB 4.3% 0.62
Nov 11 16:00:00 - 16:59:59 633 4.3% 0.181.8 MB 3.6% 0.52
Nov 11 17:00:00 - 17:59:59 539 3.6% 0.151.8 MB 3.5% 0.51
Nov 11 18:00:00 - 18:59:59 465 3.1% 0.132.3 MB 4.5% 0.65
Nov 11 19:00:00 - 19:59:59 324 2.2% 0.091.0 MB 2.0% 0.30
Nov 11 20:00:00 - 20:59:59 335 2.3% 0.091.0 MB 2.0% 0.28
Nov 11 21:00:00 - 21:59:59 318 2.1% 0.09891.1 KB 1.7% 0.25
Nov 11 22:00:00 - 22:59:59 283 1.9% 0.08878.2 KB 1.7% 0.24
Nov 11 23:00:00 - 23:58:00 310 2.1% 0.092.4 MB 4.7% 0.71
TOTAL: 23:56:59 14845 100.0% 0.1750.7 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2145 1548 0 1 9 0 0 0 587
2feeder3.feed-ams.uzoreto.com 660 457 0 0 5 0 0 0 198
3newsfeed.neva.ru 532 319 0 3 2 0 0 0 208
4news.lightlink.com 476 0 0 0 0 0 0 0 476
5ripco-out.feeder.erje.net 466 464 0 0 0 0 0 0 2
6news.snarked.org 158 85 0 0 1 0 0 0 72
7newsfeed.fu-berlin.de 109 0 0 0 1 0 0 0 108
8ripco-out.news.tnetconsulting.net 31 11 0 0 0 0 0 0 20
9news-in.rahul.net 20 0 0 0 0 0 0 0 20
10news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 10 4598 2885 0 4 18 0 0 0 1691

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1958
alt.binaries.ftd 270
it.tlc.cellulari.android 57
nntp4.test3 42
nntp4.test 36
alt.bestjobsusa.computer.jobs 34
fido7.su.pol.news 33
scot.general 33
scinet.stats 31
alt.testing 29
alt.binaries.e-book 17
aioe.news.helpdesk 17
free.it.scienza.fisica 17
alt.my.job.sucks 15
alt.jobs.jobsearch 15
it.comp.os.win.windows10 12
alt.binaries.pictures.earlmiller 12
alt.binaries.nospam.breasts.natural 12
alt.binaries.pictures.scenic 12
alt.binaries.pictures.erotica.transexual.action 11
TOTAL: 115 2885

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

GroupsCount
fr.sci.geosciences 10
pl.praca.oferowana 5
alt.penthouse.sex.sissy.slut 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 5 18

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 944
EMP (fsl) 900
Too many newsgroups 896
EMP (phl) 148
Binary in non-binary group 120
Scoring filter (8) 24
Scoring filter (9) 20
HTML post 12
Scoring filter (10) 10
Scoring filter (11) 2
TOTAL: 10 3076

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
ripco-out.feed.uzoreto.com 2
TOTAL: 2 20
Including strange strings
newsfeed.fu-berlin.de 94
newsfeed.neva.ru 48
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 2
TOTAL: 4 153
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 174

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 32360 2368 24880 952 0 6 7%47:40:00
2news.lightlink.com 11106 1844 4604 356 0 0 16%47:40:00
3news.cmpublishers.com 37216 1682 16450 11136 0 12958 4%47:46:18
4rahul.net 23250 946 12132 18 0 2 4%47:40:00
5fu-berlin.de 26802 46 26756 0 0 0 0%47:40:00
6news.uzoreto.com 12278 30 11806 68 0 0 0%47:36:16
7news.snarked.org 39524 30 23592 8 0 32 0%47:35:22
8newsfeed.neva.ru 24796 18 24138 18 0 0 0%47:40:04
9news.tnetconsulting.net 45300 18 28892 4 0 52 0%47:49:24
10remote6hme0.ripco.com 12 6 0 6 0 0 50%02:01:52
TOTAL: 10 252644 6988 173250 12566 0 13050 2%431:09:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.5 MB1.5 MB9.0 MB0.1 KB/s4.2 KB47:40:00
2feeder.erje.net7.0 MB2.2 MB9.1 MB0.1 KB/s2.8 KB47:40:00
3news.cmpublishers.com5.2 MB27.1 MB32.3 MB0.2 KB/s2.6 KB47:46:18
4rahul.net4.9 MB190.9 KB5.1 MB0.0 KB/s5.4 KB47:40:00
5fu-berlin.de162.6 KB0.0 KB162.6 KB0.0 KB/s3.5 KB47:40:00
6news.uzoreto.com108.5 KB208.1 KB316.6 KB0.0 KB/s3.2 KB47:36:16
7news.snarked.org96.7 KB10.2 KB107.0 KB0.0 KB/s2.8 KB47:35:22
8newsfeed.neva.ru70.4 KB80.0 KB150.4 KB0.0 KB/s4.2 KB47:40:04
9news.tnetconsulting.net69.3 KB11.0 KB80.3 KB0.0 KB/s3.6 KB47:49:24
10remote6hme0.ripco.com10.6 KB19.9 KB30.6 KB0.0 KB/s2.5 KB02:01:52
TOTAL: 1025.0 MB31.4 MB56.4 MB0.0 KB/s3.0 KB431:09:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8722.7 MB 418 4 000:08:45
2shell3.ripco.com 12 260666.6 KB 20 2 001:23:20
TOTAL: 2 298 11323.3 MB 438 6 001:32:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8722.7 MB 418 4 000:08:45
2*.ripco.com 12 260666.6 KB 20 2 001:23:20
TOTAL: 2 298 11323.3 MB 438 6 001:32:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.226 2.008 0.00001:23:20
ftupet.com 46.704 21.446 0.00000:08:45
? 3.410 0.860 0.00000:00:04
183.136.225.45 0.200 0.048 0.00000:00:00
TOTAL: 4 53.540 24.362 0.00001:32:10

NNRP no permission clients:

SystemConn
183.136.225.45 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 1068 94.3%
2alt 18 1.6%
3comp 14 1.2%
4sci 14 1.2%
5misc 10 0.9%
6chi 8 0.7%
TOTAL: 6 1132100.0%

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

NewsgroupCount
1rec.arts.tv 608
2rec.food.cooking 342
3rec.bicycles.tech 116
4sci.electronics.repair 14
5comp.sys.mac.system 10
6misc.phone.mobile.iphone 10
7alt.stupidity 8
8chi.weather 4
9alt.free.newsservers 4
10chi.eats 4
11alt.online-service.comcast 4
12comp.unix.bsd.freebsd.misc 2
13comp.mobile.ipad 2
14rec.radio.swap 2
15alt.satellite.gps.garmin 2
TOTAL: 15 1132