Daily Usenet report for news.ripco.com

Feb 21 00:01:01 -- Feb 21 23:57:39

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Feb 21 08:36:24 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 09:14:45 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 09:28:37 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 11:52:42 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 11:54:02 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 12:51:31 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 13:00:05 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 13:13:18 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 13:15:00 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 13:38:00 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 16:36:43 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping
Feb 21 21:41:32 remote5bge0 overchan[1062]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 17152 32.4%1.8 MB 22.1%
innd 16283 30.7%2.5 MB 31.5%
inn 16243 30.7%3.0 MB 37.4%
innfeed 3302 6.2%744.6 KB 9.0%
overchan 12 0.0%1.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 52994 100.0%8.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 153536 54.1%
Do not exist 130222 45.9%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 283758 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%22 0.000 0.000 0.000
article cleanup00:00:00.424 0.0%32270 0.000 0.013 0.070
article logging00:00:00.722 0.0%32566 0.000 0.022 0.195
article parse00:00:01.688 0.0%100236 0.000 0.017 0.039
article write00:01:24.834 0.0%22642 1.400 3.747 166.765
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.354 0.0%312220 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:02.646 0.0%284648 0.002 0.009 0.021
history sync00:00:00.234 0.0%790 0.000 0.296 2.000
history write00:00:03.474 0.0%32266 0.000 0.108 3.571
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:16.788 99.8%343248 309.549 502.951 1618.124
nntp read00:00:02.994 0.0%341282 0.003 0.009 0.018
overview write00:00:00.200 0.0%22642 0.000 0.009 0.047
perl filter00:00:52.782 0.0%32264 1.229 1.636 3.241
python filter00:00:01.204 0.0%32266 0.000 0.037 0.179
site send00:00:01.708 0.0%67850 0.007 0.025 0.050
TOTAL: 48:02:09.31247:59:50.052 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.224 0.0%22426 0.000 0.010 0.047
article prepare00:00:00.004 0.0%14592 0.000 0.000 0.025
article read00:00:00.380 0.0%2542 0.000 0.149 74.000
backlog stats00:00:00.218 0.0%337204 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.028 0.0%207436 0.000 0.010 0.020
data write00:00:03.656 0.0%185048 0.005 0.020 0.049
idle47:35:11.756100.0%337204 295.204 508.036 1778.828
status file00:00:01.570 0.0%348 0.000 4.511 35.000
TOTAL: 47:35:38.69447:35:19.836100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:04:25.980 97.5%17750 17.903 420.619 30092.727
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.274 0.1%399686 0.000 0.011 0.056
readart00:00:18.608 0.2%2506 0.925 7.425 81.000
TOTAL: 02:07:36.62202:04:48.862 97.8%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1150 25222 7588 14966 2668 30%94:32:40
2feeder3.feed-ams.uzoreto.com 574 18518 6584 8536 3398 35%47:19:52
3news.snarked.org 60 23958 3738 19892 328 15%51:50:36
4newsfeed.neva.ru 592 40688 3164 36336 1188 7%278:40:24
5newsfeed.fu-berlin.de 4 9824 570 9246 8 5%41:24:16
6ripco-out.news.tnetconsulting.net 2 28010 522 27362 126 1%52:47:42
7news.lightlink.com 2 10752 328 9632 792 3%67:28:50
8ripco-out.feeder.erje.net 574 25302 72 24124 1106 0%47:18:02
9news.cmpublishers.com 50 7728 26 7678 24 0%48:00:04
10localhost 148 2 2 0 0 100%00:00:04
TOTAL: 10 3156 190004 22594 157772 9638 11%729:22:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com19.5 MB0.0 KB5.6 MB25.0 MB 77%2.5 KB
2feeder3.feed-ams.uzoreto.com16.9 MB0.0 KB6.7 MB23.6 MB 71%2.4 KB
3ripco-out.news.tnetconsulting.net14.2 MB0.0 KB1.1 MB15.3 MB 92%24.2 KB
4news.snarked.org11.0 MB0.0 KB1.3 MB12.3 MB 89%3.1 KB
5news.lightlink.com10.3 MB0.0 KB62.3 MB72.6 MB 14%66.4 KB
6newsfeed.neva.ru10.2 MB11.5 KB3.7 MB14.0 MB 73%3.3 KB
7newsfeed.fu-berlin.de7.4 MB0.0 KB16.1 KB7.5 MB 99%13.2 KB
8ripco-out.feeder.erje.net231.0 KB0.0 KB9.2 MB9.4 MB 2%8.2 KB
9news.cmpublishers.com94.3 KB0.0 KB55.6 KB149.9 KB 62%3.0 KB
10localhost3.9 KB0.0 KB0.0 KB3.9 KB100%2.0 KB
TOTAL: 1089.9 MB11.5 KB90.0 MB179.9 MB 49%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 00:01:01 - 00:59:59 204 1.8% 0.06586.8 KB 1.2% 0.17
Feb 21 01:00:00 - 01:59:59 311 2.8% 0.091.1 MB 2.4% 0.32
Feb 21 02:00:00 - 02:59:59 380 3.4% 0.111.4 MB 3.0% 0.40
Feb 21 03:00:00 - 03:59:59 423 3.7% 0.121.2 MB 2.6% 0.35
Feb 21 04:00:00 - 04:59:59 535 4.7% 0.153.0 MB 6.4% 0.86
Feb 21 05:00:00 - 05:59:59 474 4.2% 0.131.7 MB 3.5% 0.47
Feb 21 06:00:00 - 06:59:59 510 4.5% 0.141.5 MB 3.1% 0.41
Feb 21 07:00:00 - 07:59:59 432 3.8% 0.121.1 MB 2.4% 0.32
Feb 21 08:00:00 - 08:59:59 615 5.4% 0.172.3 MB 4.8% 0.64
Feb 21 09:00:00 - 09:59:59 616 5.5% 0.171.8 MB 3.8% 0.51
Feb 21 10:00:00 - 10:59:59 748 6.6% 0.212.4 MB 5.1% 0.69
Feb 21 11:00:00 - 11:59:59 685 6.1% 0.192.4 MB 5.0% 0.67
Feb 21 12:00:00 - 12:59:59 680 6.0% 0.192.1 MB 4.4% 0.59
Feb 21 13:00:00 - 13:59:59 600 5.3% 0.172.3 MB 4.8% 0.65
Feb 21 14:00:00 - 14:59:59 565 5.0% 0.162.3 MB 4.9% 0.65
Feb 21 15:00:00 - 15:59:59 580 5.1% 0.161.6 MB 3.4% 0.46
Feb 21 16:00:00 - 16:59:59 545 4.8% 0.152.2 MB 4.8% 0.64
Feb 21 17:00:00 - 17:59:59 503 4.5% 0.145.6 MB 11.9% 1.60
Feb 21 18:00:00 - 18:59:59 424 3.8% 0.122.0 MB 4.2% 0.57
Feb 21 19:00:00 - 19:59:59 387 3.4% 0.112.4 MB 5.0% 0.68
Feb 21 20:00:00 - 20:59:59 251 2.2% 0.071.3 MB 2.8% 0.38
Feb 21 21:00:00 - 21:59:59 300 2.7% 0.081.8 MB 3.8% 0.51
Feb 21 22:00:00 - 22:59:59 210 1.9% 0.06906.2 KB 1.9% 0.25
Feb 21 23:00:00 - 23:57:39 314 2.8% 0.092.2 MB 4.6% 0.65
TOTAL: 23:56:38 11292 100.0% 0.1347.2 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1700 1320 0 0 0 0 0 0 380
2ripco-out.feed.uzoreto.com 1341 915 0 0 1 0 0 0 425
3newsfeed.neva.ru 613 310 0 2 0 0 0 0 301
4ripco-out.feeder.erje.net 553 549 0 0 0 0 0 0 4
5news.lightlink.com 371 1 0 0 0 0 0 0 370
6news.snarked.org 164 67 0 0 0 0 0 0 97
7newsfeed.fu-berlin.de 122 0 0 0 0 0 0 0 122
8ripco-out.news.tnetconsulting.net 76 56 0 0 0 0 0 0 20
9news.cmpublishers.com 11 3 0 0 0 0 0 0 8
TOTAL: 9 4951 3221 0 2 1 0 0 0 1727

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2440
alt.binaries.ftd 290
fr.misc.actualite.covid19 35
scinet.stats 27
alt.binaries.pictures.wallpaper 19
linux.debian.ports.arm 19
alt.binaries.pictures.scenic 17
alt.binaries.e-book 17
alt.binaries.pictures.purebeauty 16
fido7.su.pol.news 16
it.tlc.cellulari.android 14
alt.binaries.mac.osx.apps 13
scot.general 12
alt.binaries.pictures.earlmiller 12
alt.binaries.pictures.rail 11
alt.binaries.test.yenc 11
it.comp.os.win.windows10 11
free.it.scienza.fisica 10
alt.idiot.alex-cain 10
panix.chat.politics 9
TOTAL: 127 3221

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1492
EMP (md5) 764
EMP (fsl) 552
Binary in non-binary group 190
EMP (phl) 136
Scoring filter (8) 16
Scoring filter (9) 6
Scoring filter (11) 4
Scoring filter (10) 4
Too many test groups in crosspost 2
TOTAL: 10 3166

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 114
newsfeed.neva.ru 25
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 147
TOTAL: 2 165

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 23970 1414 18604 484 0 0 5%47:40:04
2news.lightlink.com 8778 860 4888 6 0 0 9%47:34:12
3fu-berlin.de 20074 76 19998 0 0 0 0%47:40:04
4news.uzoreto.com 8190 74 7558 186 0 0 0%47:40:04
5news.tnetconsulting.net 35048 40 21846 0 0 0 0%47:41:16
6news.snarked.org 31212 38 18286 16 0 6 0%47:43:54
7newsfeed.neva.ru 19772 30 19138 42 0 0 0%47:40:06
8news.cmpublishers.com 35058 20 21560 362 0 2 0%47:34:56
9remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:08
TOTAL: 9 182108 2552 131878 1102 0 8 1%382:26:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net4.4 MB1.4 MB5.8 MB0.0 KB/s3.1 KB47:40:04
2news.lightlink.com3.9 MB55.7 KB3.9 MB0.0 KB/s4.6 KB47:34:12
3news.tnetconsulting.net255.4 KB0.0 KB255.4 KB0.0 KB/s6.4 KB47:41:16
4news.snarked.org251.3 KB28.1 KB279.4 KB0.0 KB/s5.2 KB47:43:54
5fu-berlin.de240.2 KB0.0 KB240.2 KB0.0 KB/s3.2 KB47:40:04
6news.uzoreto.com237.9 KB531.6 KB769.5 KB0.0 KB/s3.0 KB47:40:04
7newsfeed.neva.ru229.4 KB116.0 KB345.4 KB0.0 KB/s4.8 KB47:40:06
8news.cmpublishers.com85.9 KB1.1 MB1.2 MB0.0 KB/s3.1 KB47:34:56
9remote6hme0.ripco.com0.0 KB30.7 KB30.7 KB0.0 KB/s5.1 KB01:12:08
TOTAL: 99.6 MB3.2 MB12.8 MB0.0 KB/s3.6 KB382:26:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11563.3 MB 390 2 000:08:30
2shell3.ripco.com 6 192690.9 KB 30 0 001:58:56
TOTAL: 2 292 13483.9 MB 420 2 002:07:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11563.3 MB 390 2 000:08:30
2*.ripco.com 6 192690.9 KB 30 0 001:58:56
TOTAL: 2 292 13483.9 MB 420 2 002:07:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.240 1.802 0.00001:58:56
ftupet.com 46.698 21.266 0.00000:08:30
scanner-09.ch1.censys-scanner.com 0.200 0.050 0.00000:00:00
? 0.198 0.038 0.00000:00:00
TOTAL: 4 49.336 23.156 0.00002:07:27

NNRP no permission clients:

SystemConn
scanner-09.ch1.censys-scanner.com 2
TOTAL: 1 2

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3.ripco.com 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1292 95.8%
2news 16 1.2%
3comp 10 0.7%
4chi 10 0.7%
5alt 8 0.6%
6sci 8 0.6%
7misc 2 0.1%
8houston 2 0.1%
TOTAL: 8 1348100.0%

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

NewsgroupCount
1rec.arts.tv 698
2rec.food.cooking 566
3rec.bicycles.tech 20
4comp.sys.mac.system 10
5chi.weather 10
6sci.electronics.repair 8
7news.admin.net-abuse.usenet 6
8alt.tasteless 4
9rec.radio.broadcasting 4
10alt.games.warcraft 4
11news.admin.net-abuse.email 4
12houston.general 2
13rec.radio.swap 2
14misc.consumers.frugal-living 2
15news.admin.net-abuse.misc 2
16news.software.nntp 2
17news.lists.misc 2
18rec.radio.shortwave 2
TOTAL: 18 1348