news.bbs.nz daily logs

Sep 22 23:58:01 -- Sep 23 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124076 61.7%9.6 MB 39.2%
innd 31480 15.6%5.1 MB 20.6%
innfeed 24673 12.3%5.0 MB 20.2%
inn 19535 9.7%4.7 MB 19.1%
cnfsstat 1440 0.7%250.7 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 201205 100.0%24.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 252587 50.7%
Positive hits 226557 45.5%
Do not exist 18721 3.8%
Cache misses 171 0.0%
TOTAL: 4 498036 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.121 0.0%30 0.000 4.033 32.000
article cleanup00:00:00.312 0.0%18939 0.000 0.016 0.745
article logging00:00:00.558 0.0%19348 0.000 0.029 0.319
article parse00:00:00.555 0.0%53072 0.000 0.010 0.030
article write00:00:01.859 0.0%14919 0.000 0.125 6.942
artlog/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.533 0.0%483547 0.000 0.001 0.013
hisgrep/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.741 0.0%500122 0.002 0.019 1.320
history sync00:00:00.056 0.0%368 0.000 0.152 8.000
history write00:00:06.540 0.0%18794 0.000 0.348 30.175
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:47:08.155 99.7%489069 105.338 175.084 561.436
nntp read00:00:04.378 0.0%493024 0.004 0.009 0.048
overview write00:00:39.937 0.0%14919 0.047 2.677 101.466
perl filter00:00:43.429 0.1%18794 1.028 2.311 72.985
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.157 0.0%29838 0.000 0.039 0.165
TOTAL: 23:50:50.87423:48:57.331 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%20338 0.000 0.002 0.018
article prepare00:00:00.002 0.0%6316 0.000 0.000 0.023
article read00:00:00.121 0.0%1377 0.000 0.088 6.200
backlog stats00:00:00.539 0.0%259621 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.255 0.0%224145 0.003 0.010 0.019
data write00:00:02.643 0.0%203932 0.004 0.013 0.022
idle23:54:55.224100.0%259621 198.411 331.619 910.130
status file00:00:07.319 0.0%1869 0.300 3.916 121.029
TOTAL: 23:55:25.91323:55:08.148100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%13 0.000 0.077 1.000
idle37:21:35.895 99.4%130447 0.000 1031.039 56912.516
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.616 0.0%331198 0.000 0.020 0.571
readart00:00:01.614 0.0%6240 0.000 0.259 13.500
TOTAL: 37:34:37.24237:21:44.126 99.4%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 169

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 6 33315 3443 29502 370 10%50:52:28
2news.snarked.org 27 18376 2188 14451 1737 11%31:55:04
3news-out.aioe.org 2 13720 1894 11794 32 13%22:11:21
4feeder.eternal-september.org 8 18162 1759 16293 110 9%26:07:35
5news.albasani.net 1 13103 1687 10896 520 12%19:30:14
6bbsnz-out.feed.uzoreto.com 576 22042 1566 19821 655 7%47:24:44
7news.redatomik.org 3 15113 1031 14026 56 6%23:59:42
8news-out.mixmin.net 2 19398 645 18356 397 3%27:06:28
9newsfeed.neva.ru 143 6506 454 5948 104 6%71:54:58
10csiph.com 1 15578 156 15417 5 1%23:59:54
11news.swapon.de 8 1557 92 1464 1 5%23:08:49
12agency-nz-out.news.mb-net.net 7 19824 58 19747 19 0%28:24:42
13news.samoylyk.net 1 15638 50 15579 9 0%23:59:56
14news.freedyn.net 2 17630 29 17581 20 0%23:40:41
15feeder.awxg.com 2 13482 11 13468 3 0%23:59:52
16localhost 11 10 10 0 0 100%00:00:00
TOTAL: 16 800 243454 15073 224343 4038 6%468:16:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net16.8 MB111.5 KB1.2 MB18.1 MB 92%4.9 KB
2news.snarked.org7.1 MB48.1 KB14.5 MB21.6 MB 32%5.6 KB
3news-out.aioe.org5.0 MB25.0 KB319.5 KB5.3 MB 93%2.8 KB
4feeder.eternal-september.org4.7 MB22.7 KB496.9 KB5.2 MB 90%2.8 KB
5news.albasani.net4.6 MB46.8 KB1015.4 KB5.6 MB 81%2.6 KB
6bbsnz-out.feed.uzoreto.com4.5 MB23.4 KB4.2 MB8.7 MB 51%4.0 KB
7news.redatomik.org2.8 MB48.4 KB151.4 KB3.0 MB 93%2.9 KB
8news-out.mixmin.net2.6 MB30.7 KB1.0 MB3.7 MB 70%3.6 KB
9newsfeed.neva.ru1.2 MB12.1 KB500.4 KB1.7 MB 71%3.2 KB
10csiph.com420.8 KB22.2 KB23.8 KB466.8 KB 90%2.9 KB
11news.swapon.de319.2 KB0.0 KB2.1 KB321.2 KB 99%3.5 KB
12agency-nz-out.news.mb-net.net190.4 KB68.8 KB102.4 KB361.5 KB 52%4.7 KB
13news.samoylyk.net157.7 KB63.8 KB63.8 KB285.2 KB 55%4.8 KB
14news.freedyn.net103.1 KB9.7 KB43.5 KB156.3 KB 65%3.2 KB
15feeder.awxg.com36.9 KB10.6 KB10.6 KB58.1 KB 63%4.1 KB
16localhost18.6 KB0.0 KB0.0 KB18.6 KB100%1.9 KB
TOTAL: 1650.5 MB543.9 KB23.5 MB74.6 MB 67%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 23:58:01 - 23:59:59 21 0.1% 0.1842.7 KB 0.1% 0.36
Sep 23 00:00:00 - 00:59:59 767 5.1% 0.212.3 MB 4.5% 0.64
Sep 23 01:00:00 - 01:59:59 884 5.9% 0.253.8 MB 7.5% 1.07
Sep 23 02:00:00 - 02:59:59 836 5.6% 0.232.4 MB 4.8% 0.69
Sep 23 03:00:00 - 03:59:59 880 5.9% 0.243.2 MB 6.4% 0.91
Sep 23 04:00:00 - 04:59:59 872 5.8% 0.242.9 MB 5.9% 0.83
Sep 23 05:00:00 - 05:59:59 891 5.9% 0.252.5 MB 5.0% 0.72
Sep 23 06:00:00 - 06:59:59 929 6.2% 0.263.1 MB 6.3% 0.90
Sep 23 07:00:00 - 07:59:59 780 5.2% 0.222.5 MB 5.0% 0.72
Sep 23 08:00:00 - 08:59:59 789 5.2% 0.222.9 MB 5.9% 0.83
Sep 23 09:00:00 - 09:59:59 635 4.2% 0.182.1 MB 4.2% 0.59
Sep 23 10:00:00 - 10:59:59 563 3.7% 0.161.6 MB 3.2% 0.45
Sep 23 11:00:00 - 11:59:59 517 3.4% 0.141.5 MB 3.0% 0.43
Sep 23 12:00:00 - 12:59:59 349 2.3% 0.101.1 MB 2.2% 0.31
Sep 23 13:00:00 - 13:59:59 344 2.3% 0.101.2 MB 2.4% 0.34
Sep 23 14:00:00 - 14:59:59 333 2.2% 0.091.5 MB 3.0% 0.42
Sep 23 15:00:00 - 15:59:59 271 1.8% 0.081.1 MB 2.2% 0.31
Sep 23 16:00:00 - 16:59:59 308 2.0% 0.091.1 MB 2.1% 0.30
Sep 23 17:00:00 - 17:59:59 312 2.1% 0.091.5 MB 2.9% 0.41
Sep 23 18:00:00 - 18:59:59 488 3.2% 0.141.9 MB 3.7% 0.53
Sep 23 19:00:00 - 19:59:59 563 3.7% 0.161.7 MB 3.5% 0.50
Sep 23 20:00:00 - 20:59:59 681 4.5% 0.192.1 MB 4.2% 0.60
Sep 23 21:00:00 - 21:59:59 757 5.0% 0.212.4 MB 4.7% 0.67
Sep 23 22:00:00 - 22:59:59 611 4.1% 0.171.6 MB 3.3% 0.47
Sep 23 23:00:00 - 23:58:01 654 4.3% 0.192.0 MB 4.1% 0.60
TOTAL: 24:00:00 15035 100.0% 0.1750.0 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.6 GB 57.2% 0 0.26 2359.50
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB33.0 GB 66.0% 0 0.29 2078.94
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB362.1 MB 0.7% 0 0.0235570.35
BUFF06BIN50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF07BIN50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF08CTCALL50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF09CTCALL50.0 GB1.6 MB 0.0% 1 0.00 0.00
BUFF10CTCALL50.0 GB27.3 GB 54.7% 0 0.49 1244.93
TOTAL: 10-500.0 GB89.3 GB 17.9% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1744 2 0 11 0 0 0 0 1731
2news.albasani.net 718 0 0 16 0 0 0 0 702
3bbsnz-out.feed.uzoreto.com 664 4 0 8 0 0 0 0 652
4bbs-nz-out.news.weretis.net 415 41 0 20 0 0 0 0 354
5news-out.mixmin.net 390 0 0 13 0 0 0 0 377
6news.redatomik.org 178 0 0 10 0 0 0 0 168
7feeder.eternal-september.org 105 0 0 9 0 0 0 0 96
8newsfeed.neva.ru 104 2 0 4 0 0 0 0 98
9news-out.aioe.org 50 21 0 12 0 0 0 0 17
10news.freedyn.net 32 0 0 7 0 0 0 0 25
11news.swapon.de 23 0 0 0 0 0 0 0 23
12agency-nz-out.news.mb-net.net 18 1 0 9 0 0 0 0 8
13news.samoylyk.net 15 0 0 14 0 0 0 0 1
14csiph.com 8 0 0 7 0 0 0 0 1
15feeder.awxg.com 6 0 0 5 0 0 0 0 1
TOTAL: 15 4470 71 0 145 0 0 0 0 4254

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 30
mozilla.support.seamonkey 5
alt.advanced.placed.or.honors.chemistry.2 4
gmane.linux.alsa.devel 3
nyc.jobs 3
al.christnet.bible 3
mozilla.dev.ui-alerts 3
fido7.ru.android 2
mozilla.dev.platform 2
a2i.ba.jobs.offered.hivol 1
clari.local.florida.briefs 1
alt.sex.girl 1
alt.religion.christian.romman-catholic 1
usc.forsale 1
nemo.test 1
demos.local.statistics 1
alt.penthouse.sex.femdom 1
mozilla.mozillians 1
a.business.internet 1
nemo.dev.passerelle 1
TOTAL: 25 71

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3076
EMP (phn path) 509
EMP (phl) 87
User-issued cancel 44
Too many newsgroups 40
EMP (phn nph) 34
Binary: non-binary distribution 15
User-issued spam cancel 10
Binary: misplaced par2 9
Binary Image: misplaced jpg 7
Binary: misplaced rar 2
Binary: misplaced 269 1
Binary: misplaced 009 1
Binary: misplaced 040 1
Binary: misplaced JPG 1
Binary: misplaced 019 1
Binary: misplaced 027 1
TOTAL: 17 3839

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 173
news.redatomik.org 124
bbs-nz-out.news.weretis.net 51
news.swapon.de 22
news-out.mixmin.net 21
news-out.aioe.org 12
bbsnz-out.feed.uzoreto.com 8
news.snarked.org 2
feeder.eternal-september.org 1
feeder.awxg.com 1
TOTAL: 10 415
TOTAL: 1 415

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 13150 588 12557 5 0 0 4%23:59:40
2awxg 14633 35 14596 0 0 0 0%23:59:49
3news.freedyn.net 15051 13 14995 0 0 1 0%23:59:48
4news.snarked.org 12811 13 12732 3 0 16 0%23:59:46
5news.samoylyk.net 13327 12 13090 5 0 0 0%23:59:42
6aioe 12330 12 12240 1 0 0 0%23:59:35
7weretis.net 11278 10 11263 0 0 0 0%23:59:43
8news.redatomik.org 14014 10 13922 2 0 4 0%23:59:48
9neva.ru 14370 10 14359 0 0 0 0%23:59:49
10eternal-september 12972 10 12955 0 0 0 0%23:59:47
11csiph.com 14908 10 14870 0 0 0 0%23:59:41
12news-in.mixmin.net 14045 10 14020 0 0 4 0%23:59:47
13mb-net.net 15010 7 14958 2 0 61 0%23:59:49
14news.albasani.net 14885 4 12500 697 0 5298 0%23:59:49
15news.swapon.de 1411 3 1401 0 0 7 0%23:51:04
16news.uzoreto.com 13289 2 13277 8 0 0 0%23:59:48
TOTAL: 16 207484 749 203735 723 0 5391 0%383:47:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.9 MB14.2 KB6.9 MB0.1 KB/s12.0 KB23:59:40
2news.snarked.org329.0 KB6.3 KB335.3 KB0.0 KB/s21.0 KB23:59:46
3awxg92.8 KB0.0 KB92.8 KB0.0 KB/s2.7 KB23:59:49
4news.freedyn.net27.8 KB0.0 KB27.8 KB0.0 KB/s2.1 KB23:59:48
5aioe24.2 KB1.4 KB25.7 KB0.0 KB/s2.0 KB23:59:35
6news.samoylyk.net21.7 KB101.4 KB123.2 KB0.0 KB/s7.2 KB23:59:42
7weretis.net18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:43
8news.redatomik.org18.7 KB109.0 KB127.7 KB0.0 KB/s10.6 KB23:59:48
9neva.ru18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:49
10eternal-september18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:47
11csiph.com18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:41
12news-in.mixmin.net18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:47
13mb-net.net11.2 KB5.8 KB17.0 KB0.0 KB/s1.9 KB23:59:49
14news.albasani.net4.5 KB5.1 MB5.1 MB0.1 KB/s7.4 KB23:59:49
15news.swapon.de3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:51:04
16news.uzoreto.com2.8 KB15.8 KB18.7 KB0.0 KB/s1.9 KB23:59:48
TOTAL: 167.5 MB5.3 MB12.9 MB0.0 KB/s8.9 KB383:47:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 390 481217.0 MB 2861 10 000:15:40
2vorlon.activateit.net.au 24 7171020.1 KB 129 0 000:04:12
3192.168.1.7 4 96323.6 KB 9 0 000:00:04
4160-3-245-118.cpe.cableone.net 1 64409.2 KB 2 0 037:00:25
5121.99.151.197 1 239.7 KB 2 0 000:02:14
TOTAL: 5 420 569118.8 MB 3003 10 037:34:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 390 481217.0 MB 2861 10 000:15:40
2*.activateit.net.au 24 7171020.1 KB 129 0 000:04:12
3unresolved 18 98363.2 KB 11 0 000:13:41
4*.cpe.cableone.net 1 64409.2 KB 2 0 037:00:25
5*.dip0.t-ipconnect.de 25 00.0 KB 0 0 000:00:27
TOTAL: 5 458 569118.8 MB 3003 10 037:34:30

NNRP auth users [Top 20]:

UserConn
amybbs 24
paulh 4
malcolmlewis 1
TOTAL: 3 29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.328 0.176 0.00437:00:25
agency.bbs.nz 30.768 6.972 0.00000:15:40
118.149.208.168 0.668 0.084 0.00000:11:16
vorlon.activateit.net.au 1.552 0.388 0.12100:04:12
121.99.151.197 0.140 0.060 0.00000:02:14
p5489d596.dip0.t-ipconnect.de 1.520 0.188 0.00000:00:24
192.168.1.7 0.308 0.072 0.01800:00:04
94.160.232.118 0.048 0.020 0.00000:00:02
p5489d106.dip0.t-ipconnect.de 0.112 0.024 0.00000:00:02
? 1.636 0.196 0.00000:00:02
5.86.116.125 0.052 0.008 0.00000:00:02
TOTAL: 11 37.132 8.188 0.14337:34:30

Curious NNRP server explorers [Top 20]:

SystemConn
p5489d596.dip0.t-ipconnect.de 23
118.149.208.168 11
p5489d106.dip0.t-ipconnect.de 2
94.160.232.118 1
5.86.116.125 1
TOTAL: 5 38

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2109 37.1%
2comp 628 11.0%
3soc 606 10.7%
4sci 576 10.1%
5uk 505 8.9%
6linux 422 7.4%
7talk 284 5.0%
8alt 279 4.9%
9misc 107 1.9%
10nz 107 1.9%
11news 23 0.4%
12mozilla 20 0.4%
13humanities 12 0.2%
14aus 8 0.1%
15microsoft 4 0.1%
TOTAL: 15 5690100.0%

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

NewsgroupCount
1rec.arts.tv 388
2rec.arts.drwho 361
3uk.d-i-y 235
4rec.food.cooking 232
5talk.origins 218
6uk.legal 169
7alt.comp.os.windows-10 164
8rec.sport.football.college 150
9comp.os.linux.advocacy 146
10rec.sport.tennis 134
11rec.arts.sf.written 128
12linux.debian.bugs.dist 123
13sci.physics 111
14rec.drugs.cannabis 110
15soc.retirement 98
16soc.culture.china 97
17linux.debian.bugs.rc 96
18rec.sport.pro-wrestling 96
19soc.culture.polish 88
20sci.physics.relativity 84
21linux.debian.changes.devel 81
22comp.lang.python 75
23sci.math 72
24sci.electronics.design 72
25soc.culture.israel 70
26nz.comp 68
27rec.gambling.poker 62
28soc.culture.indian 59
29comp.sys.raspberry-pi 51
30sci.med.cardiology 51
31sci.logic 49
32linux.debian.user 46
33comp.lang.c 42
34misc.survivalism 40
35rec.boats 40
36comp.lang.c++ 39
37rec.arts.sf.fandom 38
38misc.phone.mobile.iphone 35
39uk.radio.amateur 35
40nz.general 34
41talk.politics.guns 34
42sci.lang 30
43alt.politics.trump 28
44sci.bio.paleontology 27
45comp.lang.forth 26
46uk.tech.digital-tv 26
47talk.politics.misc 25
48comp.arch.embedded 23
49rec.arts.tv.soaps.cbs 22
50comp.mobile.ipad 21
51rec.bicycles.tech 20
52soc.penpals 20
53rec.photo.digital 19
54soc.culture.bulgaria 19
55sci.military.naval 18
56rec.games.bridge 18
57comp.lang.javascript 18
58alt.test 18
59rec.music.classical.recordings 18
60sci.astro.amateur 18
61comp.os.vms 18
62alt.conspiracy 17
63comp.ai.philosophy 17
64rec.games.backgammon 17
65soc.culture.greek 17
66comp.sys.apple2 16
67rec.arts.sf.tv 16
68rec.audio.opinion 15
69rec.music.beatles 15
70alt.games.warcraft 14
71comp.sys.mac.system 14
72linux.debian.user.portuguese 14
73alt.conspiracy.jfk 13
74alt.os.linux.ubuntu 13
75soc.culture.brazil 13
76linux.debian.user.german 12
77soc.culture.usa 12
78rec.crafts.metalworking 11
79uk.rec.cycling 11
80soc.genealogy.medieval 10
81news.lists.filters 10
82rec.sport.billiard 10
83humanities.classics 10
84uk.legal.moderated 10
85comp.arch 10
86soc.genealogy.jewish 9
87rec.music.dylan 9
88soc.genealogy.britain 9
89mozilla.support.firefox 9
90misc.health.alternative 8
91uk.comp.homebuilt 8
92rec.aviation.soaring 8
93soc.history 8
94comp.lang.ada 8
95comp.unix.shell 8
96linux.debian.user.french 8
97soc.women 8
98linux.debian.l10n.french 8
99news.software.readers 8
100uk.comp.sys.mac 8
TOTAL: 280 5690