Daily Usenet Report

Dec 11 00:01:02 -- Dec 12 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Dec 11 00:06:09 www innd: message repeated 2 times: [ ctlinnd command s]
Dec 11 16:18:45 www nnrpd[3451253]: unable to get certificates from '/news/etc/cert.pem'
Dec 11 16:18:45 www nnrpd[3451253]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 11823 66.0%3.2 MB 76.9%
innd 3736 20.8%534.9 KB 12.7%
innfeed 2344 13.1%436.1 KB 10.4%
nnrpd 17 0.1%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 17921 100.0%4.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 84311 56.4%
Negative hits 53557 35.8%
Do not exist 11552 7.7%
Cache misses 21 0.0%
TOTAL: 4 149441 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.071 0.0%30 0.000 2.367 5.000
article cleanup00:00:00.224 0.0%11576 0.000 0.019 0.159
article logging00:00:00.537 0.0%11798 0.000 0.046 0.242
article parse00:00:00.363 0.0%18564 0.000 0.020 0.263
article write00:00:10.451 0.0%9978 0.450 1.047 2.679
artlog/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
data move00:00:00.181 0.0%153174 0.000 0.001 0.007
hisgrep/artcncl00:00:00.009 0.0%30 0.000 0.300 0.800
hishave/artcncl00:00:00.005 0.0%30 0.000 0.167 0.600
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.153 0.0%149770 0.004 0.041 0.091
history sync00:00:00.065 0.0%397 0.000 0.164 2.667
history write00:00:05.925 0.0%11576 0.045 0.512 0.938
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:43.249 99.8%150754 308.734 572.610 2512.381
nntp read00:00:05.811 0.0%151395 0.022 0.038 0.105
overview write00:00:06.596 0.0%9978 0.217 0.661 5.515
perl filter00:00:32.954 0.0%11576 2.029 2.847 5.470
python filter00:00:01.987 0.0%11576 0.078 0.172 0.455
site send00:00:03.734 0.0%19956 0.034 0.187 0.556
TOTAL: 24:01:06.52423:59:58.315 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.101 0.0%10188 0.000 0.010 0.107
article prepare00:00:00.005 0.0%28612 0.000 0.000 0.010
article read00:00:01.246 0.0%4565 0.080 0.273 2.826
backlog stats00:00:00.484 0.0%212103 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.581 0.0%140825 0.011 0.033 0.059
data write00:00:19.031 0.0%132127 0.083 0.144 0.226
idle23:55:18.846100.0%212103 219.769 406.024 1222.198
status file00:00:00.209 0.0%200 0.000 1.045 3.000
TOTAL: 23:55:53.86823:55:44.503100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:01.490 63.9%7 38.000 212.857 1088.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%13 0.000 0.077 0.500
TOTAL: 00:00:02.33100:00:01.491 64.0%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 18406 5769 12212 425 31%45:34:12
2usenet.blueworldhosting.com 10 11354 3076 7768 510 27%24:26:37
3newsfeed.xs3.de 1 9134 551 8576 7 6%23:59:56
4outgoing.news.lysator.liu.se 2 11309 499 10324 486 4%23:59:30
5news.samoylyk.net 1 9428 53 9374 1 0%23:59:51
6glockenspiel.complete.org 2 9669 27 9642 0 0%23:59:38
7news.bbs.nz 1 6622 11 6611 0 0%17:48:55
8news.netfront.net 1 11606 1 11428 177 0%23:42:27
9eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
10news.furie.org.uk 1 5165 0 5165 0 0%23:59:56
11localhost 25 0 0 0 0 0%00:00:00
12news.nk.ca 2 0 0 0 0 0%00:20:02
TOTAL: 12 51 92693 9987 81100 1606 10%232:01:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com20.5 MB0.0 KB1.3 MB21.8 MB 94%6.2 KB
2endofthelinebbs-out.news.weretis.net20.1 MB0.0 KB735.4 KB20.8 MB 96%3.4 KB
3newsfeed.xs3.de2.3 MB0.0 KB13.1 KB2.3 MB 99%4.2 KB
4outgoing.news.lysator.liu.se927.7 KB0.0 KB1000.5 KB1.9 MB 48%2.0 KB
5news.samoylyk.net588.1 KB0.0 KB1.2 KB589.3 KB 99%10.9 KB
6glockenspiel.complete.org250.9 KB0.0 KB0.0 KB250.9 KB100%9.3 KB
7news.bbs.nz32.2 KB0.0 KB0.0 KB32.2 KB100%2.9 KB
8news.netfront.net7.0 KB0.0 KB634.7 KB641.7 KB 1%3.6 KB
9eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10news.furie.org.uk0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1244.7 MB0.0 KB3.6 MB48.3 MB 92%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 11 00:01:02 - 00:59:59 197 2.0% 0.061.6 MB 3.7% 0.47
Dec 11 01:00:00 - 01:59:59 249 2.5% 0.071.4 MB 3.2% 0.40
Dec 11 02:00:00 - 02:59:59 501 5.0% 0.141.5 MB 3.3% 0.42
Dec 11 03:00:00 - 03:59:59 451 4.5% 0.131.4 MB 3.2% 0.40
Dec 11 04:00:00 - 04:59:59 537 5.4% 0.151.4 MB 3.1% 0.39
Dec 11 05:00:00 - 05:59:59 525 5.3% 0.151.6 MB 3.6% 0.45
Dec 11 06:00:00 - 06:59:59 429 4.3% 0.121.4 MB 3.2% 0.40
Dec 11 07:00:00 - 07:59:59 468 4.7% 0.131.6 MB 3.7% 0.47
Dec 11 08:00:00 - 08:59:59 488 4.9% 0.141.7 MB 3.8% 0.47
Dec 11 09:00:00 - 09:59:59 556 5.6% 0.152.9 MB 6.5% 0.81
Dec 11 10:00:00 - 10:59:59 602 6.0% 0.173.4 MB 7.6% 0.96
Dec 11 11:00:00 - 11:59:59 656 6.6% 0.182.4 MB 5.5% 0.70
Dec 11 12:00:00 - 12:59:59 617 6.2% 0.172.5 MB 5.6% 0.70
Dec 11 13:00:00 - 13:59:59 633 6.3% 0.182.7 MB 6.2% 0.78
Dec 11 14:00:00 - 14:59:59 602 6.0% 0.173.7 MB 8.4% 1.06
Dec 11 15:00:00 - 15:59:59 401 4.0% 0.111.2 MB 2.7% 0.34
Dec 11 16:00:00 - 16:59:59 425 4.3% 0.121.7 MB 3.8% 0.48
Dec 11 17:00:00 - 17:59:59 375 3.8% 0.101.4 MB 3.3% 0.41
Dec 11 18:00:00 - 18:59:59 308 3.1% 0.092.1 MB 4.8% 0.60
Dec 11 19:00:00 - 19:59:59 223 2.2% 0.061.2 MB 2.7% 0.34
Dec 11 20:00:00 - 20:59:59 163 1.6% 0.052.0 MB 4.4% 0.56
Dec 11 21:00:00 - 21:59:59 150 1.5% 0.04912.0 KB 2.0% 0.25
Dec 11 22:00:00 - 22:59:59 174 1.7% 0.051.1 MB 2.6% 0.32
Dec 11 23:00:00 - 23:59:59 239 2.4% 0.071.5 MB 3.4% 0.43
Dec 12 00:00:00 - 00:01:01 4 0.0% 0.0710.4 KB 0.0% 0.17
TOTAL: 23:59:59 9973 100.0% 0.1244.4 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 629 0 0 0 0 0 0 0 629
2usenet.blueworldhosting.com 518 15 0 0 2 0 0 0 501
3outgoing.news.lysator.liu.se 506 0 0 0 0 0 0 0 506
4news.netfront.net 146 0 0 0 0 0 0 0 146
5newsfeed.xs3.de 20 0 0 0 0 0 0 0 20
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 1820 15 0 0 2 0 0 0 1803

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
gun.general 3
t-netz.wrestling.wwf 1
rocksolid.feeds.tech 1
panix.chat 1
fr.education.superieur 1
ee.arvutid 1
alt.tall-women.admirers 1
test 1
TOTAL: 9 15

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

GroupsCount
sci.physics.research 1
perl.beginners 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 826
EMP (md5) 299
EMP (phl) 251
Too many newsgroups 151
EMP (phn nph) 45
HTML Multipart 5
Scoring filter 4
TOTAL: 7 1581

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 203
newsfeed.xs3.de 13
usenet.blueworldhosting.com 6
TOTAL: 3 222
TOTAL: 1 222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 13373 4398 5574 1 0 0 32%23:59:55
2nyheter.lysator.liu.se 9821 2450 7012 12 0 0 24%23:59:55
3news.furie.org.uk 7012 59 5235 3 0 0 0%23:59:52
4news.nk.ca 13033 50 9832 13 0 5 0%23:59:56
5news.quux.org 10385 29 9847 87 0 0 0%23:59:17
6news.bbs.nz 19612 25 9918 21 0 126 0%23:59:55
7usenet.blueworldhosting.com 7349 7 6863 0 0 86 0%23:59:56
8news.weretis.net 10022 2 9969 0 0 0 0%23:59:45
9news.tnetconsulting.net 10676 0 9970 0 0 7 0%23:59:54
10peer.alt119.net 0 0 0 0 0 9973 0%23:57:47
11newsfeed.xs3.de 11994 0 9423 0 0 0 0%23:59:35
12news.samoylyk.net 12514 0 9922 0 0 0 0%23:59:55
TOTAL: 12 125791 7020 93565 137 0 10197 5%287:55:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net24.3 MB1.3 KB24.4 MB0.3 KB/s5.7 KB23:59:55
2nyheter.lysator.liu.se16.5 MB226.8 KB16.7 MB0.2 KB/s7.0 KB23:59:55
3news.furie.org.uk4.1 MB95.5 KB4.2 MB0.0 KB/s68.8 KB23:59:52
4news.nk.ca432.5 KB81.0 KB513.5 KB0.0 KB/s8.2 KB23:59:56
5news.bbs.nz168.0 KB352.9 KB520.9 KB0.0 KB/s11.3 KB23:59:55
6news.quux.org141.4 KB624.4 KB765.7 KB0.0 KB/s6.6 KB23:59:17
7usenet.blueworldhosting.com18.6 KB0.0 KB18.6 KB0.0 KB/s2.7 KB23:59:56
8news.weretis.net4.3 KB0.0 KB4.3 KB0.0 KB/s2.1 KB23:59:45
9news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
10peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
11newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:35
12news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 1245.7 MB1.3 MB47.0 MB0.0 KB/s6.7 KB287:55:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1139-144-52-241.ip.linodeusercontent.com 5 00.0 KB 0 0 000:00:02
TOTAL: 1 5 00.0 KB 0 0 000:00:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ip.linodeusercontent.com 5 00.0 KB 0 0 000:00:02
TOTAL: 1 5 00.0 KB 0 0 000:00:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
139-144-52-241.ip.linodeusercontent.com 0.408 0.141 0.00000:00:02
TOTAL: 1 0.408 0.141 0.00000:00:02