Daily Usenet report for news.ripco.com

Jul 10 00:01:01 -- Jul 10 23:57:56

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jul 10 05:09:58 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 05:44:55 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 06:24:45 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 06:49:00 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 07:09:17 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 10:12:55 remote5bge0 overchan[19995]: [ID 702911 news.error] input line too long, skipping
Jul 10 10:49:41 remote5bge0 innd: [ID 702911 news.error] SERVER exiting due to signal
Jul 10 12:41:13 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping
Jul 10 22:10:31 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping
Jul 10 22:16:16 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping
Jul 10 22:18:36 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping
Jul 10 22:21:53 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping
Jul 10 23:38:27 remote5bge0 overchan[3348]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 20612 33.4%3.1 MB 32.6%
inn 19440 31.5%3.8 MB 40.2%
nnrpd 17166 27.8%1.8 MB 18.6%
innfeed 4466 7.2%825.9 KB 8.5%
overchan 15 0.0%2.0 KB 0.0%
controlchan 9 0.0%0.8 KB 0.0%
TOTAL: 6 61708 100.0%9.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 176814 56.0%
Cache misses 138962 44.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 315776 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.434 0.0%38046 0.000 0.011 0.045
article logging00:00:00.654 0.0%38402 0.000 0.017 0.138
article parse00:00:01.274 0.0%92634 0.000 0.014 0.042
article write00:02:16.910 0.1%29394 1.667 4.658 54.240
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.274 0.0%311134 0.000 0.001 0.009
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:18.396 0.0%316592 0.000 0.058 2.864
history sync00:00:00.224 0.0%786 0.000 0.285 2.000
history write00:00:21.142 0.0%38054 0.015 0.556 21.474
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle46:55:49.104 99.8%353300 245.154 478.203 1295.147
nntp read00:00:02.496 0.0%352440 0.001 0.007 0.016
overview write00:00:00.308 0.0%29394 0.000 0.010 0.043
perl filter00:00:57.126 0.0%38044 1.085 1.502 2.426
python filter00:00:01.218 0.0%38052 0.000 0.032 0.102
site send00:00:02.244 0.0%88144 0.007 0.025 0.059
TOTAL: 47:02:10.37046:59:51.804 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.462 0.0%42896 0.000 0.011 0.078
article prepare00:00:00.002 0.0%3560 0.000 0.001 0.042
article read00:00:00.458 0.0%778 0.000 0.589 70.000
backlog stats00:00:00.210 0.0%307508 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.160 0.0%198222 0.000 0.011 0.044
data write00:00:03.234 0.0%169256 0.004 0.019 0.054
idle46:51:28.666100.0%307508 196.096 548.567 2339.380
status file00:00:03.306 0.0%506 1.000 6.534 221.000
TOTAL: 46:52:08.97646:51:38.498100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:36:50.712 98.2%18278 18.066 514.866 22239.860
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.982 0.1%1089220 0.000 0.010 0.077
readart00:00:22.974 0.2%2444 0.750 9.400 51.500
TOTAL: 02:39:46.91402:37:24.668 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
shutdown 7
TOTAL: 10 320

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1156 31137 11124 16619 3394 35%92:58:51
2feeder3.feed-ams.uzoreto.com 578 19205 8147 8690 2368 42%46:29:57
3newsfeed.neva.ru 564 26465 5720 19162 1583 21%266:51:11
4news.snarked.org 24 13632 2589 10631 412 18%27:44:14
5news-in.rahul.net 578 14590 544 13950 96 3%46:50:50
6ripco-out.news.tnetconsulting.net 2 15698 384 15273 41 2%26:53:22
7ripco-out.feeder.erje.net 578 31937 369 30702 866 1%46:38:20
8newsfeed.fu-berlin.de 10 5019 241 4770 8 4%22:02:24
9news.lightlink.com 2 8513 135 8332 46 1%46:25:47
10localhost 154 8 8 0 0 100%00:00:00
11news.cmpublishers.com 50 3086 2 3083 1 0%15:55:53
TOTAL: 11 3696 169290 29263 131212 8815 17%638:50:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com29.8 MB2.6 KB6.4 MB36.2 MB 82%2.6 KB
2feeder3.feed-ams.uzoreto.com19.4 MB0.0 KB4.2 MB23.5 MB 82%2.3 KB
3newsfeed.neva.ru16.1 MB0.0 KB5.5 MB21.7 MB 74%3.0 KB
4ripco-out.news.tnetconsulting.net11.7 MB0.0 KB1.7 MB13.5 MB 87%32.5 KB
5news.snarked.org7.2 MB0.0 KB1.2 MB8.4 MB 85%2.9 KB
6news-in.rahul.net4.8 MB0.0 KB3.6 MB8.3 MB 57%13.3 KB
7news.lightlink.com4.2 MB0.0 KB2.4 MB6.5 MB 63%36.9 KB
8newsfeed.fu-berlin.de2.4 MB0.0 KB26.7 KB2.5 MB 98%10.2 KB
9ripco-out.feeder.erje.net913.7 KB0.0 KB5.7 MB6.6 MB 13%5.5 KB
10localhost28.2 KB0.0 KB0.0 KB28.2 KB100%3.5 KB
11news.cmpublishers.com5.5 KB0.0 KB1.1 KB6.6 KB 83%2.2 KB
TOTAL: 1196.5 MB2.6 KB30.7 MB127.2 MB 75%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 10 00:01:01 - 00:59:59 381 2.6% 0.111.5 MB 3.1% 0.44
Jul 10 01:00:00 - 01:59:59 463 3.1% 0.131.3 MB 2.7% 0.37
Jul 10 02:00:00 - 02:59:59 610 4.1% 0.171.7 MB 3.5% 0.49
Jul 10 03:00:00 - 03:59:59 687 4.6% 0.191.9 MB 3.9% 0.54
Jul 10 04:00:00 - 04:59:59 679 4.6% 0.192.4 MB 4.8% 0.67
Jul 10 05:00:00 - 05:59:59 762 5.1% 0.212.4 MB 4.8% 0.68
Jul 10 06:00:00 - 06:59:59 727 4.9% 0.202.2 MB 4.5% 0.63
Jul 10 07:00:00 - 07:59:59 739 5.0% 0.212.4 MB 4.9% 0.69
Jul 10 08:00:00 - 08:59:59 794 5.3% 0.224.1 MB 8.4% 1.18
Jul 10 09:00:00 - 09:59:59 866 5.8% 0.242.8 MB 5.7% 0.80
Jul 10 10:00:00 - 10:59:59 774 5.2% 0.212.5 MB 5.1% 0.71
Jul 10 11:00:00 - 11:59:59 897 6.0% 0.252.6 MB 5.3% 0.74
Jul 10 12:00:00 - 12:59:59 886 6.0% 0.252.6 MB 5.2% 0.73
Jul 10 13:00:00 - 13:59:59 815 5.5% 0.232.4 MB 4.8% 0.68
Jul 10 14:00:00 - 14:59:59 714 4.8% 0.202.1 MB 4.2% 0.59
Jul 10 15:00:00 - 15:59:59 683 4.6% 0.192.2 MB 4.5% 0.64
Jul 10 16:00:00 - 16:59:59 611 4.1% 0.172.0 MB 4.0% 0.56
Jul 10 17:00:00 - 17:59:59 546 3.7% 0.152.0 MB 4.1% 0.58
Jul 10 18:00:00 - 18:59:59 546 3.7% 0.151.7 MB 3.5% 0.49
Jul 10 19:00:00 - 19:59:59 447 3.0% 0.121.4 MB 2.9% 0.41
Jul 10 20:00:00 - 20:59:59 327 2.2% 0.091.3 MB 2.5% 0.36
Jul 10 21:00:00 - 21:59:59 307 2.1% 0.091.1 MB 2.3% 0.32
Jul 10 22:00:00 - 22:59:59 335 2.3% 0.091.0 MB 2.1% 0.30
Jul 10 23:00:00 - 23:57:56 255 1.7% 0.071.6 MB 3.2% 0.46
TOTAL: 23:56:55 14851 100.0% 0.1749.3 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1709 1295 0 1 3 0 0 0 410
2feeder3.feed-ams.uzoreto.com 1192 1024 0 0 1 0 0 0 167
3newsfeed.neva.ru 836 497 0 0 1 0 0 0 338
4ripco-out.feeder.erje.net 435 432 0 0 0 0 0 0 3
5news.snarked.org 218 177 0 0 1 0 0 0 40
6newsfeed.fu-berlin.de 141 0 0 0 0 0 0 0 141
7news-in.rahul.net 49 0 0 0 0 0 0 0 49
8ripco-out.news.tnetconsulting.net 7 4 0 0 0 0 0 0 3
9news.cmpublishers.com 2 1 0 0 0 0 0 0 1
TOTAL: 9 4589 3430 0 1 6 0 0 0 1152

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2596
alt.binaries.ftd 198
de.soc.arbeitslos 75
fido7.su.pol.news 41
scot.general 35
uk.net.news.moderation 31
scinet.stats 30
perl.cpan.uploads 24
alt.binaries.pictures.erotica.vintage 22
it.tlc.cellulari.android 21
free.it.scienza.fisica 20
alt.binaries.e-book 17
alt.binaries.3d.poser 15
alt.bestjobsusa.computer.jobs 14
alt.binaries.pictures.scenic 13
linux.debian.changes 10
alt.binaries.mma 10
fr.comp.os.android 9
mozilla.dev.security.policy 8
alt.binaries.pictures.purebeauty 7
TOTAL: 136 3430

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

GroupsCount
pl.praca.oferowana 3
fr.comp.securite 2
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 818
EMP (md5) 674
EMP (phl) 162
Binary in non-binary group 144
Scoring filter (8) 78
Scoring filter (9) 20
Scoring filter (10) 14
Scoring filter (11) 10
HTML post 6
Scoring filter (18) 2
Scoring filter (13) 2
Scoring filter (14) 2
TOTAL: 12 1932

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 2
TOTAL: 3 28
Including strange strings
newsfeed.fu-berlin.de 130
newsfeed.neva.ru 39
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 5
ripco-out.feeder.erje.net 2
TOTAL: 5 181
No colon-space in header
feeder3.feed-ams.uzoreto.com 3
ripco-out.feed.uzoreto.com 1
TOTAL: 2 4
TOTAL: 3 213

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 21074 368 12590 8 0 0 1%46:28:39
2news.lightlink.com 4387 156 2597 2 0 4378 3%46:28:36
3news.tnetconsulting.net 21147 44 14274 2 0 14072 0%46:28:35
4feeder.erje.net 29073 42 27052 86 0 0 0%46:28:37
5news.snarked.org 19802 34 11875 8 0 14012 0%46:28:37
6fu-berlin.de 26251 12 26239 0 0 372 0%46:39:35
7news.uzoreto.com 9492 9 9383 2 0 0 0%46:28:39
8newsfeed.neva.ru 11935 4 11747 2 0 11228 0%46:28:39
9remote6hme0.ripco.com 10 4 0 6 0 0 40%02:30:40
10news.cmpublishers.com 36152 2 28372 106 0 13200 0%46:35:58
TOTAL: 10 179323 675 144129 222 0 57262 0%421:06:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net8.5 MB19.0 KB8.5 MB0.1 KB/s23.1 KB46:28:39
2news.lightlink.com1.3 MB9.5 KB1.3 MB0.0 KB/s8.3 KB46:28:36
3feeder.erje.net135.7 KB237.5 KB373.2 KB0.0 KB/s2.9 KB46:28:37
4news.tnetconsulting.net112.4 KB12.1 KB124.5 KB0.0 KB/s2.7 KB46:28:35
5news.snarked.org105.3 KB22.2 KB127.4 KB0.0 KB/s3.0 KB46:28:37
6fu-berlin.de41.4 KB0.0 KB41.4 KB0.0 KB/s3.5 KB46:39:35
7news.uzoreto.com30.0 KB11.5 KB41.5 KB0.0 KB/s3.8 KB46:28:39
8remote6hme0.ripco.com19.8 KB25.7 KB45.5 KB0.0 KB/s4.5 KB02:30:40
9newsfeed.neva.ru7.4 KB11.5 KB18.9 KB0.0 KB/s3.1 KB46:28:39
10news.cmpublishers.com5.8 KB234.7 KB240.4 KB0.0 KB/s2.2 KB46:35:58
TOTAL: 1010.2 MB583.6 KB10.8 MB0.0 KB/s12.3 KB421:06:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 284 9462.5 MB 410 2 000:07:37
2shell3 26 5501.6 MB 46 6 002:31:58
TOTAL: 2 310 14964.1 MB 456 8 002:39:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 284 9462.5 MB 410 2 000:07:37
2? 26 5501.6 MB 46 6 002:31:58
TOTAL: 2 310 14964.1 MB 456 8 002:39:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 6.578 3.542 0.00002:31:58
ftupet.com 46.066 20.814 0.00000:07:37
scan-141.security.ipip.net 0.200 0.048 0.00000:00:00
TOTAL: 3 52.844 24.404 0.00002:39:37

NNRP no permission clients:

SystemConn
scan-141.security.ipip.net 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1314 87.8%
2comp 80 5.3%
3chi 58 3.9%
4alt 20 1.3%
5news 10 0.7%
6sci 8 0.5%
7misc 6 0.4%
TOTAL: 7 1496100.0%

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

NewsgroupCount
1rec.arts.tv 846
2rec.food.cooking 360
3rec.bicycles.tech 76
4chi.general 54
5comp.protocols.dns.bind 38
6comp.sys.mac.system 32
7rec.radio.broadcasting 12
8alt.stupidity 12
9rec.gardens.edible 10
10sci.electronics.repair 8
11news.software.readers 8
12rec.bicycles.misc 6
13comp.security.ssh 6
14misc.consumers.frugal-living 6
15alt.tv.sopranos 4
16comp.mail.sendmail 4
17chi.weather 4
18alt.autos.porsche.944 4
19rec.radio.swap 2
20news.admin.net-abuse.email 2
21rec.boats.paddle 2
TOTAL: 21 1496