Daily Usenet report for news.ripco.com

Dec 5 00:01:02 -- Dec 5 23:57:47

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Dec 5 00:08:04 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 07:51:11 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 08:11:33 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 10:31:31 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 12:42:28 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 12:49:01 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 12:57:45 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 16:53:17 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 17:10:45 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 20:22:51 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 20:33:54 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 21:39:32 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping
Dec 5 22:27:38 remote5bge0 overchan[19566]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18945 32.0%2.9 MB 32.1%
inn 18859 31.9%3.5 MB 38.7%
nnrpd 17702 29.9%1.9 MB 20.3%
innfeed 3614 6.1%825.3 KB 8.8%
overchan 13 0.0%1.9 KB 0.0%
controlchan 8 0.0%1.5 KB 0.0%
TOTAL: 6 59141 100.0%9.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 179170 50.3%
Do not exist 176848 49.7%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 356018 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%136 0.000 0.000 0.000
article cleanup00:00:00.522 0.0%37468 0.000 0.014 0.082
article logging00:00:00.866 0.0%37772 0.000 0.023 0.100
article parse00:00:01.498 0.0%99124 0.000 0.015 0.054
article write00:01:23.712 0.0%25668 1.187 3.261 62.571
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.416 0.0%350608 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:28.320 0.0%357724 0.002 0.079 0.764
history sync00:00:00.216 0.0%816 0.000 0.265 4.400
history write00:00:57.054 0.0%37470 0.026 1.523 7.639
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:55:32.258 99.8%390380 182.714 441.960 1393.295
nntp read00:00:02.958 0.0%389426 0.001 0.008 0.017
overview write00:00:00.294 0.0%25668 0.000 0.011 0.064
perl filter00:00:59.914 0.0%37468 1.308 1.599 4.458
python filter00:00:01.480 0.0%37470 0.000 0.039 0.104
site send00:00:02.554 0.0%76978 0.000 0.033 0.079
TOTAL: 48:02:19.10047:59:32.062 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.104 0.0%26290 0.000 0.004 0.027
article prepare00:00:00.008 0.0%19952 0.000 0.000 0.017
article read00:00:00.536 0.0%3768 0.000 0.142 7.889
backlog stats00:00:00.366 0.0%407296 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.118 0.0%252254 0.001 0.008 0.027
data write00:00:04.852 0.0%227304 0.009 0.021 0.065
idle47:52:57.374100.0%407296 204.930 423.224 1412.136
status file00:00:01.916 0.0%358 0.000 5.352 35.000
TOTAL: 47:53:26.70647:53:07.274100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:50:34.480 97.3%17974 8.000 569.405 26056.607
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.464 0.1%657526 0.000 0.010 1.000
readart00:00:20.010 0.2%2514 1.636 7.959 44.000
TOTAL: 02:55:23.88602:51:00.954 97.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder3.feed-ams.uzoreto.com 574 22080 8958 9514 3608 40%47:18:42
2ripco-out.feed.uzoreto.com 1148 47302 7244 35564 4494 15%94:48:34
3newsfeed.neva.ru 586 24598 4664 18052 1882 18%274:43:00
4news.snarked.org 44 23886 3124 20402 360 13%53:26:34
5ripco-out.news.tnetconsulting.net 2 20748 568 20130 50 2%35:13:38
6newsfeed.fu-berlin.de 2 10588 446 10116 26 4%44:04:18
7news-in.rahul.net 574 13488 122 13292 74 0%47:19:46
8news.lightlink.com 2 8596 52 8408 136 0%52:29:26
9ripco-out.feeder.erje.net 574 28338 30 27238 1070 0%47:16:22
10news.cmpublishers.com 52 7872 12 7856 4 0%44:53:48
11localhost 148 2 2 0 0 100%00:00:00
TOTAL: 11 3706 207498 25222 170572 11704 12%741:34:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com23.7 MB0.0 KB7.1 MB30.9 MB 76%2.5 KB
2ripco-out.feed.uzoreto.com19.5 MB0.0 KB8.8 MB28.3 MB 69%2.5 KB
3newsfeed.neva.ru16.8 MB0.0 KB4.8 MB21.7 MB 77%3.4 KB
4ripco-out.news.tnetconsulting.net12.4 MB0.0 KB1.1 MB13.6 MB 91%22.5 KB
5news.snarked.org9.3 MB0.0 KB1.1 MB10.4 MB 89%3.1 KB
6newsfeed.fu-berlin.de4.1 MB0.0 KB1.0 MB5.1 MB 79%11.1 KB
7news-in.rahul.net3.1 MB0.0 KB2.5 MB5.6 MB 54%29.2 KB
8news.lightlink.com702.1 KB0.0 KB5.2 MB5.9 MB 11%32.1 KB
9ripco-out.feeder.erje.net56.0 KB0.0 KB9.6 MB9.6 MB 0%9.0 KB
10news.cmpublishers.com37.3 KB0.0 KB6.3 KB43.6 KB 85%2.7 KB
11localhost3.2 KB0.0 KB0.0 KB3.2 KB100%1.6 KB
TOTAL: 1189.7 MB0.0 KB41.4 MB131.1 MB 68%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 5 00:01:02 - 00:59:59 218 1.7% 0.06620.1 KB 1.3% 0.18
Dec 5 01:00:00 - 01:59:59 329 2.6% 0.09920.1 KB 1.9% 0.26
Dec 5 02:00:00 - 02:59:59 448 3.5% 0.121.2 MB 2.5% 0.35
Dec 5 03:00:00 - 03:59:59 497 3.9% 0.141.5 MB 3.2% 0.44
Dec 5 04:00:00 - 04:59:59 552 4.3% 0.152.3 MB 4.8% 0.66
Dec 5 05:00:00 - 05:59:59 655 5.1% 0.182.8 MB 5.7% 0.79
Dec 5 06:00:00 - 06:59:59 540 4.2% 0.153.2 MB 6.6% 0.90
Dec 5 07:00:00 - 07:59:59 719 5.6% 0.203.9 MB 8.0% 1.10
Dec 5 08:00:00 - 08:59:59 765 6.0% 0.212.7 MB 5.6% 0.77
Dec 5 09:00:00 - 09:59:59 660 5.1% 0.181.9 MB 3.9% 0.54
Dec 5 10:00:00 - 10:59:59 769 6.0% 0.212.6 MB 5.3% 0.73
Dec 5 11:00:00 - 11:59:59 703 5.5% 0.202.3 MB 4.8% 0.66
Dec 5 12:00:00 - 12:59:59 708 5.5% 0.202.8 MB 5.7% 0.79
Dec 5 13:00:00 - 13:59:59 722 5.6% 0.202.1 MB 4.3% 0.59
Dec 5 14:00:00 - 14:59:59 792 6.2% 0.222.5 MB 5.2% 0.71
Dec 5 15:00:00 - 15:59:59 674 5.3% 0.192.8 MB 5.9% 0.81
Dec 5 16:00:00 - 16:59:59 599 4.7% 0.172.4 MB 5.1% 0.70
Dec 5 17:00:00 - 17:59:59 511 4.0% 0.141.8 MB 3.7% 0.51
Dec 5 18:00:00 - 18:59:59 395 3.1% 0.112.4 MB 5.0% 0.68
Dec 5 19:00:00 - 19:59:59 287 2.2% 0.08943.0 KB 1.9% 0.26
Dec 5 20:00:00 - 20:59:59 439 3.4% 0.121.3 MB 2.6% 0.36
Dec 5 21:00:00 - 21:59:59 360 2.8% 0.101.8 MB 3.7% 0.51
Dec 5 22:00:00 - 22:59:59 256 2.0% 0.07867.0 KB 1.7% 0.24
Dec 5 23:00:00 - 23:57:47 218 1.7% 0.06801.3 KB 1.6% 0.23
TOTAL: 23:56:45 12816 100.0% 0.1548.4 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2260 1646 0 0 3 0 0 0 611
2feeder3.feed-ams.uzoreto.com 1855 1227 0 0 0 0 0 0 628
3newsfeed.neva.ru 963 532 0 0 11 0 0 0 420
4ripco-out.feeder.erje.net 537 527 0 0 0 0 0 0 10
5news.snarked.org 181 98 0 0 1 0 0 0 82
6newsfeed.fu-berlin.de 84 0 0 0 0 0 0 0 84
7news.lightlink.com 76 0 0 0 0 0 0 0 76
8ripco-out.news.tnetconsulting.net 47 35 0 0 0 0 0 0 12
9news-in.rahul.net 37 1 0 0 0 0 0 0 36
10news.cmpublishers.com 3 0 0 0 0 0 0 0 3
TOTAL: 10 6043 4066 0 0 15 0 0 0 1962

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 3129
alt.binaries.ftd 294
alt.bestjobsusa.computer.jobs 38
it.tlc.cellulari.android 35
scinet.stats 32
alt.binaries.pictures.purebeauty 28
free.it.scienza.fisica 24
de.soc.arbeitslos 24
alt.binaries.pictures.rail 21
fido7.su.pol.news 20
aioe.news.assistenza 18
alt.jobs.jobsearch 15
scot.general 15
alt.binaries.3d.poser 14
free.willey 14
alt.binaries.pictures.earlmiller 14
alt.my.job.sucks 13
alt.binaries.pictures.scenic 13
alt.binaries.pictures.wallpaper 10
alt.binaries.e-book 9
TOTAL: 196 4066

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

GroupsCount
pl.praca.oferowana 12
alt.christnet.religion 1
alt.penthouse.sex.fetish.tickling 1
bit.listserv.catholic 1
TOTAL: 4 15

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2044
Too many newsgroups 1372
Binary in non-binary group 90
EMP (phl) 50
Scoring filter (8) 18
Scoring filter (9) 16
Scoring filter (10) 16
Scoring filter (13) 4
HTML post 4
Poison newsgroup 2
Scoring filter (12) 2
Scoring filter (11) 2
TOTAL: 12 3620

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 67
feeder3.feed-ams.uzoreto.com 48
newsfeed.neva.ru 25
ripco-out.feed.uzoreto.com 11
TOTAL: 4 151
No colon-space in header
ripco-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 3 170

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 27542 1410 22078 620 0 4 5%47:40:04
2news.lightlink.com 9634 766 5030 68 0 0 7%47:43:30
3rahul.net 20524 738 10600 6 0 0 3%47:33:48
4news.cmpublishers.com 38974 122 24068 954 0 268 0%47:40:04
5news.tnetconsulting.net 37820 54 24694 6 0 104 0%47:40:04
6fu-berlin.de 22752 42 22708 0 0 0 0%47:35:44
7news.snarked.org 36346 28 21924 40 0 304 0%47:40:04
8news.uzoreto.com 9054 28 8780 28 0 0 0%47:44:58
9newsfeed.neva.ru 21338 22 20824 14 0 0 0%47:47:00
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 223990 3210 160706 1742 0 680 1%430:17:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net7.1 MB96.7 KB7.1 MB0.0 KB/s9.8 KB47:33:48
2news.lightlink.com5.6 MB560.6 KB6.1 MB0.0 KB/s7.5 KB47:43:30
3feeder.erje.net4.3 MB1.9 MB6.1 MB0.0 KB/s3.1 KB47:40:04
4news.cmpublishers.com537.4 KB3.2 MB3.8 MB0.0 KB/s3.6 KB47:40:04
5fu-berlin.de213.8 KB0.0 KB213.8 KB0.0 KB/s5.1 KB47:35:44
6news.tnetconsulting.net161.0 KB15.7 KB176.7 KB0.0 KB/s2.9 KB47:40:04
7news.uzoreto.com160.9 KB84.2 KB245.0 KB0.0 KB/s4.4 KB47:44:58
8news.snarked.org147.8 KB141.8 KB289.6 KB0.0 KB/s4.3 KB47:40:04
9newsfeed.neva.ru98.4 KB135.3 KB233.7 KB0.0 KB/s6.5 KB47:47:00
10remote6hme0.ripco.com0.0 KB21.3 KB21.3 KB0.0 KB/s3.5 KB01:12:06
TOTAL: 1018.2 MB6.1 MB24.3 MB0.0 KB/s5.0 KB430:17:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10983.5 MB 458 2 000:08:43
2shell3.ripco.com 6 316887.3 KB 32 0 002:45:03
TOTAL: 2 292 14144.3 MB 490 2 002:55:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10983.5 MB 458 2 000:08:43
2*.ripco.com 6 316887.3 KB 32 0 002:45:03
TOTAL: 2 292 14144.3 MB 490 2 002:53:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.832 2.142 0.00002:45:03
ftupet.com 47.568 21.518 0.00000:08:43
84-105-134-55.cable.dynamic.v4.ziggo.nl 12.960 3.510 0.00000:01:21
71.73.49.117 0.200 0.052 0.00000:00:00
scanner-04.ch1.censys-scanner.com 0.200 0.046 0.00000:00:00
TOTAL: 5 63.760 27.268 0.00002:55:08

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 128
scanner-04.ch1.censys-scanner.com 2
71.73.49.117 2
TOTAL: 3 132

Newsgroup request counts (by category):

CategoryCountPct
1rec 1258 89.0%
2comp 62 4.4%
3misc 42 3.0%
4sci 30 2.1%
5news 8 0.6%
6chi 8 0.6%
7alt 6 0.4%
TOTAL: 7 1414100.0%

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

NewsgroupCount
1rec.arts.tv 684
2rec.food.cooking 442
3rec.bicycles.tech 114
4comp.mobile.ipad 42
5misc.phone.mobile.iphone 42
6sci.electronics.repair 30
7comp.sys.mac.apps 16
8rec.gardens.edible 12
9chi.weather 6
10alt.online-service.comcast 4
11news.admin.net-abuse.email 4
12rec.outdoors.rv-travel 4
13comp.sys.mac.system 4
14rec.audio.high-end 2
15news.admin.misc 2
16alt.internet.wireless 2
17chi.general 2
18news.admin.hierarchies 2
TOTAL: 18 1414