Daily Usenet report

Jun 18 06:01:01 -- Jun 19 06:01:01

Unknown entries from news log file:

First 50 / 181 lines (27.6%)

Jun 18 06:02:15 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jun 18 20:00:06 kennel pgpverify[964831]: pgpverify: verification failed
Jun 18 20:00:10 kennel pgpverify[964959]: pgpverify: verification failed
Jun 18 20:01:14 kennel pgpverify[965269]: pgpverify: verification failed
Jun 18 20:01:16 kennel pgpverify[965277]: pgpverify: verification failed
Jun 18 20:02:16 kennel pgpverify[965921]: pgpverify: verification failed
Jun 18 20:02:19 kennel pgpverify[965929]: pgpverify: verification failed
Jun 18 20:03:18 kennel pgpverify[966236]: pgpverify: verification failed
Jun 18 20:03:20 kennel pgpverify[966245]: pgpverify: verification failed
Jun 18 20:04:20 kennel pgpverify[966627]: pgpverify: verification failed
Jun 18 20:04:22 kennel pgpverify[966637]: pgpverify: verification failed
Jun 18 20:05:22 kennel pgpverify[966942]: pgpverify: verification failed
Jun 18 20:05:24 kennel pgpverify[966952]: pgpverify: verification failed
Jun 18 20:06:25 kennel pgpverify[967337]: pgpverify: verification failed
Jun 18 20:06:26 kennel pgpverify[967345]: pgpverify: verification failed
Jun 18 20:07:26 kennel pgpverify[967653]: pgpverify: verification failed
Jun 18 20:07:29 kennel pgpverify[967662]: pgpverify: verification failed
Jun 18 20:08:28 kennel pgpverify[968030]: pgpverify: verification failed
Jun 18 20:08:30 kennel pgpverify[968040]: pgpverify: verification failed
Jun 18 20:09:30 kennel pgpverify[968561]: pgpverify: verification failed
Jun 18 20:09:31 kennel pgpverify[968570]: pgpverify: verification failed
Jun 18 20:10:31 kennel pgpverify[968957]: pgpverify: verification failed
Jun 18 20:10:33 kennel pgpverify[968965]: pgpverify: verification failed
Jun 18 20:11:35 kennel pgpverify[969270]: pgpverify: verification failed
Jun 18 20:11:37 kennel pgpverify[969279]: pgpverify: verification failed
Jun 18 20:12:37 kennel pgpverify[969669]: pgpverify: verification failed
Jun 18 20:12:39 kennel pgpverify[969677]: pgpverify: verification failed
Jun 18 20:13:39 kennel pgpverify[969981]: pgpverify: verification failed
Jun 18 20:13:40 kennel pgpverify[969989]: pgpverify: verification failed
Jun 18 20:14:41 kennel pgpverify[970362]: pgpverify: verification failed
Jun 18 20:14:43 kennel pgpverify[970490]: pgpverify: verification failed
Jun 18 20:15:44 kennel pgpverify[970801]: pgpverify: verification failed
Jun 18 20:15:45 kennel pgpverify[970810]: pgpverify: verification failed
Jun 18 20:16:46 kennel pgpverify[971190]: pgpverify: verification failed
Jun 18 20:16:47 kennel pgpverify[971198]: pgpverify: verification failed
Jun 18 20:17:48 kennel pgpverify[971763]: pgpverify: verification failed
Jun 18 20:17:49 kennel pgpverify[971771]: pgpverify: verification failed
Jun 18 20:18:49 kennel pgpverify[972306]: pgpverify: verification failed
Jun 18 20:18:50 kennel pgpverify[972314]: pgpverify: verification failed
Jun 18 20:19:52 kennel pgpverify[972637]: pgpverify: verification failed
Jun 18 20:19:54 kennel pgpverify[972645]: pgpverify: verification failed
Jun 18 20:20:54 kennel pgpverify[973048]: pgpverify: verification failed
Jun 18 20:20:56 kennel pgpverify[973056]: pgpverify: verification failed
Jun 18 20:21:55 kennel pgpverify[973353]: pgpverify: verification failed
Jun 18 20:21:56 kennel pgpverify[973361]: pgpverify: verification failed
Jun 18 20:22:57 kennel pgpverify[973732]: pgpverify: verification failed
Jun 18 20:22:59 kennel pgpverify[973740]: pgpverify: verification failed
Jun 18 20:24:01 kennel pgpverify[974132]: pgpverify: verification failed
Jun 18 20:24:02 kennel pgpverify[974142]: pgpverify: verification failed
Jun 18 20:25:02 kennel pgpverify[974463]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 429466 97.5%53.0 MB 97.1%
innd 9125 2.1%1.3 MB 2.5%
innfeed 1418 0.3%211.0 KB 0.4%
controlchan 181 0.0%12.9 KB 0.0%
pgpverify 180 0.0%24.7 KB 0.0%
cnfsstat 144 0.0%16.4 KB 0.0%
nnrpd 14 0.0%1.5 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 440529 100.0%54.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 652416 43.1%
Positive hits 430587 28.5%
Do not exist 419749 27.7%
Cache misses 10144 0.7%
TOTAL: 4 1512896 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.003 0.0%43 0.000 0.070 1.000
article cleanup00:00:04.783 0.0%428756 0.006 0.011 0.017
article logging00:00:17.270 0.0%428847 0.023 0.040 0.051
article parse00:00:27.209 0.0%1258511 0.010 0.022 0.030
article write00:00:32.068 0.0%345284 0.066 0.093 0.119
artlog/artparse00:00:00.024 0.0%603 0.000 0.040 1.000
data move00:00:05.020 0.0%1340390 0.001 0.004 0.009
hisgrep/artcncl00:00:00.001 0.0%43 0.000 0.023 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:17.040 0.0%1517544 0.002 0.011 0.242
history sync00:00:00.025 0.0%324 0.000 0.077 0.500
history write00:00:25.337 0.0%420670 0.045 0.060 0.086
idle23:55:09.245 99.6%1020083 39.732 84.414 138.730
nntp read00:00:41.240 0.0%1020426 0.019 0.040 0.056
overview write00:00:01.825 0.0%345284 0.001 0.005 0.010
perl filter00:00:21.758 0.0%420062 0.029 0.052 0.074
python filter00:00:21.465 0.0%420062 0.034 0.051 0.071
site send00:00:12.530 0.0%771795 0.010 0.016 0.097
TOTAL: 24:00:33.34123:58:56.843 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.298 0.0%81118 0.000 0.004 0.015
article prepare00:00:00.001 0.0%526 0.000 0.002 0.250
article read00:00:00.054 0.0%438 0.000 0.123 1.000
backlog stats00:00:00.247 0.0%247527 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.134 0.0%158730 0.008 0.026 0.058
data write00:00:03.551 0.0%97054 0.019 0.037 0.101
idle23:57:23.003100.0%247527 79.585 348.419 2034.302
status file00:00:00.217 0.0%268 0.000 0.810 10.750
TOTAL: 23:57:42.08823:57:31.505100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%3 0.000 0.000 0.000
TOTAL: 00:00:02.43900:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 167

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org00018000
TOTAL00018000

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 575 833580 337683 412682 83215 40%48:20:05
2hasname-out.news.weretis.net 207 12394 5160 7183 51 41%46:13:37
3usenet.blueworldhosting.com 717 8618 1757 6498 363 20%23:46:40
4news.nntp4.net 1 8463 627 7440 396 7%23:59:56
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 1501 863055 345227 433803 84025 40%142:20:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net3.5 GB94.7 MB761.8 MB4.3 GB 80%10.8 KB
2hasname-out.news.weretis.net14.8 MB1.3 KB78.1 KB14.8 MB 99%2.9 KB
3usenet.blueworldhosting.com3.9 MB0.0 KB1.9 MB5.7 MB 67%2.8 KB
4news.nntp4.net2.4 MB1.3 KB3.3 MB5.7 MB 42%5.7 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 53.5 GB94.7 MB767.0 MB4.3 GB 80%10.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 18 06:01:01 - 06:59:59 20309 5.9% 5.74210.2 MB 5.9% 60.82
Jun 18 07:00:00 - 07:59:59 11148 3.2% 3.10112.6 MB 3.1% 32.03
Jun 18 08:00:00 - 08:59:59 13836 4.0% 3.84141.0 MB 3.9% 40.12
Jun 18 09:00:00 - 09:59:59 12483 3.6% 3.47157.8 MB 4.4% 44.89
Jun 18 10:00:00 - 10:59:59 12911 3.7% 3.59160.7 MB 4.5% 45.70
Jun 18 11:00:00 - 11:59:59 16556 4.8% 4.60171.5 MB 4.8% 48.78
Jun 18 12:00:00 - 12:59:59 14050 4.1% 3.90163.2 MB 4.5% 46.41
Jun 18 13:00:00 - 13:59:59 11950 3.5% 3.32126.5 MB 3.5% 35.98
Jun 18 14:00:00 - 14:59:59 14767 4.3% 4.10151.7 MB 4.2% 43.15
Jun 18 15:00:00 - 15:59:59 12154 3.5% 3.38145.2 MB 4.0% 41.30
Jun 18 16:00:00 - 16:59:59 17317 5.0% 4.81180.5 MB 5.0% 51.33
Jun 18 17:00:00 - 17:59:59 15243 4.4% 4.23163.3 MB 4.5% 46.44
Jun 18 18:00:00 - 18:59:59 12098 3.5% 3.36132.5 MB 3.7% 37.68
Jun 18 19:00:00 - 19:59:59 15534 4.5% 4.32150.6 MB 4.2% 42.84
Jun 18 20:00:00 - 20:59:59 18134 5.3% 5.04158.2 MB 4.4% 44.99
Jun 18 21:00:00 - 21:59:59 14777 4.3% 4.10132.7 MB 3.7% 37.73
Jun 18 22:00:00 - 22:59:59 15715 4.6% 4.37140.7 MB 3.9% 40.03
Jun 18 23:00:00 - 23:59:59 17242 5.0% 4.79176.0 MB 4.9% 50.06
Jun 19 00:00:00 - 00:59:59 11274 3.3% 3.13119.3 MB 3.3% 33.93
Jun 19 01:00:00 - 01:59:59 11482 3.3% 3.19111.4 MB 3.1% 31.68
Jun 19 02:00:00 - 02:59:59 17336 5.0% 4.82190.5 MB 5.3% 54.19
Jun 19 03:00:00 - 03:59:59 17012 4.9% 4.73178.9 MB 5.0% 50.89
Jun 19 04:00:00 - 04:59:59 10943 3.2% 3.04105.3 MB 2.9% 29.95
Jun 19 05:00:00 - 05:59:59 10678 3.1% 2.97108.9 MB 3.0% 30.97
Jun 19 06:00:00 - 06:01:01 349 0.1% 5.723.2 MB 0.1% 53.42
TOTAL: 24:00:00 345298 100.0% 4.003.5 GB 100.0% 42.57
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB9.6 GB 95.8% 46 50.79 2.39
TOTAL: 1-10.0 GB9.6 GB 95.8% 46 50.79-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net 83298 73895 0 8697 6 0 0 0 700
2news.nntp4.net 431 392 0 1 0 8 0 0 30
3usenet.blueworldhosting.com 371 361 0 0 0 0 0 0 10
4hasname-out.news.weretis.net 68 50 0 1 0 0 0 0 17
TOTAL: 4 84168 74698 0 8699 6 8 0 0 757

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 11871
alt.binaries.font 4728
alt.binaries.noprobs 2970
alt.binaries.encrypted 2919
alt.binaries.ucc 2857
alt.binaries.cats 2692
alt.binaries.hunters 2527
alt.binaries.u-4all 1581
alt.binaries.ath 1086
alt.binaries.encryptnzb.kilo 958
alt.binaries.encryptnzb.hotel 939
alt.binaries.encryptnzb.india 936
alt.binaries.encryptnzb.juliet 929
alt.binaries.wtfnzb.foxtrot 926
alt.binaries.encryptnzb.alpha 924
alt.binaries.wtfnzb.kilo 921
alt.binaries.wtfnzb.golf 920
alt.binaries.encryptnzb.golf 917
alt.binaries.wtfnzb.beta 912
alt.binaries.wtfnzb.delta 909
TOTAL: 309 74698

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

GroupsCount
alt.binaries.whitburn 6
TOTAL: 1 6

INND no permission servers:

SystemConn
103.193.138.76 30
206.168.34.69 1
45.134.26.50 1
TOTAL: 3 32

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
hasname-out.feeder.erje.net 8
TOTAL: 1 8
Including strange strings
hasname-out.feeder.erje.net 35
news.nntp4.net 30
hasname-out.news.weretis.net 17
usenet.blueworldhosting.com 9
TOTAL: 4 91
No colon-space in header field
hasname-out.feeder.erje.net 665
TOTAL: 1 665
TOTAL: 3 764

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 410 410 0 0 0 0100%21:01:54
2blueworldhosting 79793 7 79028 2 0 67 0%23:59:50
3weretis 2545 2 2439 18 0 0 0%23:50:50
4nntp4 7160 0 7158 0 0 14 0%23:59:52
5erje 7034 0 7028 0 0 36 0%23:59:49
TOTAL: 5 96942 419 95653 20 0 117 0%116:52:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.2 MB0.0 KB1.2 MB0.0 KB/s3.0 KB21:01:54
2blueworldhosting69.3 KB26.6 KB95.9 KB0.0 KB/s10.7 KB23:59:50
3weretis8.6 KB250.7 KB259.4 KB0.0 KB/s13.0 KB23:50:50
4erje0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
5nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 51.3 MB277.3 KB1.5 MB0.0 KB/s3.6 KB116:52:15
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
165.154.243.246 0.000 0.004 0.00000:00:01
light.monitoring.internet-measurement.com 0.001 0.004 0.00000:00:00
162.142.125.214 0.002 0.003 0.00000:00:00
TOTAL: 3 0.003 0.011 0.00000:00:02

NNRP no permission clients [Top 20]:

SystemConn
162.142.125.214 1
165.154.243.246 1
light.monitoring.internet-measurement.com 1
TOTAL: 3 3
innreport from INN 2.7.2 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then