news.bbs.nz daily logs

Nov 30 23:58:02 -- Dec 1 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 129101 60.4%10.0 MB 37.8%
innd 35021 16.4%5.7 MB 21.5%
innfeed 26006 12.2%5.1 MB 19.4%
inn 22276 10.4%5.4 MB 20.4%
cnfsstat 1440 0.7%254.2 KB 0.9%
controlchan 5 0.0%0.8 KB 0.0%
TOTAL: 6 213849 100.0%26.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 279384 48.4%
Negative hits 276196 47.8%
Do not exist 21423 3.7%
Cache misses 332 0.1%
TOTAL: 4 577335 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.256 0.0%28 0.000 9.143 37.500
article cleanup00:00:00.225 0.0%21937 0.000 0.010 0.043
article logging00:00:00.576 0.0%22273 0.000 0.026 0.069
article parse00:00:00.668 0.0%69809 0.000 0.010 0.025
article write00:00:01.480 0.0%16857 0.016 0.088 1.103
artlog/artcncl00:00:00.001 0.0%28 0.000 0.036 0.100
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.539 0.0%542155 0.000 0.001 0.024
hisgrep/artcncl00:00:00.002 0.0%28 0.000 0.071 0.500
hishave/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.181 0.0%583559 0.003 0.023 1.009
history sync00:00:00.020 0.0%360 0.000 0.056 1.000
history write00:00:10.281 0.0%21657 0.000 0.475 22.980
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:13.098 99.7%554531 86.742 155.506 449.457
nntp read00:00:04.835 0.0%556405 0.002 0.009 0.026
overview write00:00:52.523 0.1%16857 0.068 3.116 98.599
perl filter00:00:38.701 0.0%21653 1.133 1.787 6.603
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.087 0.0%33715 0.000 0.032 0.173
TOTAL: 24:00:54.02923:59:17.473 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%21684 0.000 0.003 0.028
article prepare00:00:00.003 0.0%8204 0.000 0.000 0.028
article read00:00:00.179 0.0%1673 0.000 0.107 3.357
backlog stats00:00:00.695 0.0%310275 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.577 0.0%260172 0.005 0.010 0.019
data write00:00:02.994 0.0%246731 0.005 0.012 0.026
idle23:53:33.481100.0%310275 165.025 277.217 685.358
status file00:00:06.438 0.0%1863 0.500 3.456 157.364
TOTAL: 23:54:05.65223:53:46.423100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle28:19:26.518 91.4%136937 0.000 744.624 83755.521
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.087 0.0%288176 0.000 0.007 0.522
readart00:00:01.864 0.0%7650 0.000 0.244 26.500
TOTAL: 30:58:59.18628:19:30.469 91.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 7 36373 3689 32393 291 10%50:24:01
2news.snarked.org 40 21428 3172 15735 2521 14%33:39:03
3news-out.aioe.org 1 15981 2305 13638 38 14%22:28:59
4feeder.eternal-september.org 2 20072 2034 17844 194 10%24:50:57
5bbsnz-out.feed.uzoreto.com 864 28491 1752 26177 562 6%71:07:55
6news.redatomik.org 2 16558 1449 15034 75 8%24:12:47
7news-out.mixmin.net 2 19817 842 18408 567 4%25:52:13
8newsfeed.neva.ru 150 12047 697 10853 497 5%72:01:05
9news.albasani.net 1 18300 583 17518 199 3%23:49:43
10csiph.com 2 17546 212 17324 10 1%24:16:05
11news.swapon.de 8 1417 200 1217 0 14%25:45:47
12news.freedyn.net 2 19926 117 19717 92 0%24:13:14
13agency-nz-out.news.mb-net.net 4 18807 71 18704 32 0%24:12:59
14news.samoylyk.net 2 18888 53 18809 26 0%26:02:15
15localhost 9 8 8 0 0 100%00:00:00
16feeder.awxg.com 2 15711 7 15680 24 0%23:59:07
17nut.utcc.utoronto.ca 1 18971 0 18971 0 0%23:50:00
TOTAL: 17 1099 300341 17191 278022 5128 5%520:46:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net13.7 MB194.2 KB1.1 MB15.0 MB 91%3.9 KB
2news.snarked.org10.6 MB142.8 KB20.6 MB31.4 MB 33%5.6 KB
3feeder.eternal-september.org5.8 MB114.3 KB1.2 MB7.1 MB 82%3.3 KB
4news-out.aioe.org5.7 MB70.3 KB285.0 KB6.0 MB 94%2.6 KB
5bbsnz-out.feed.uzoreto.com4.9 MB24.1 KB5.5 MB10.4 MB 46%4.6 KB
6news.redatomik.org3.8 MB88.1 KB312.9 KB4.2 MB 90%2.8 KB
7news-out.mixmin.net3.1 MB61.1 KB1.1 MB4.3 MB 72%3.1 KB
8newsfeed.neva.ru1.9 MB178.4 KB9.3 MB11.3 MB 16%9.7 KB
9news.albasani.net1.6 MB82.6 KB444.1 KB2.1 MB 75%2.8 KB
10csiph.com550.9 KB19.6 KB36.6 KB607.1 KB 90%2.7 KB
11news.swapon.de530.3 KB0.0 KB0.0 KB530.3 KB100%2.7 KB
12news.freedyn.net358.3 KB81.1 KB964.7 KB1.4 MB 25%6.7 KB
13agency-nz-out.news.mb-net.net170.3 KB89.2 KB160.8 KB420.3 KB 40%4.1 KB
14news.samoylyk.net160.3 KB108.5 KB108.5 KB377.4 KB 42%4.8 KB
15feeder.awxg.com17.7 KB82.9 KB82.9 KB183.5 KB 9%5.9 KB
16localhost13.6 KB0.0 KB0.0 KB13.6 KB100%1.7 KB
17nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1752.9 MB1.3 MB41.2 MB95.3 MB 55%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 23:58:02 - 23:59:59 22 0.1% 0.1948.9 KB 0.1% 0.41
Dec 1 00:00:00 - 00:59:59 849 5.0% 0.242.5 MB 4.7% 0.71
Dec 1 01:00:00 - 01:59:59 872 5.2% 0.242.5 MB 4.8% 0.72
Dec 1 02:00:00 - 02:59:59 963 5.7% 0.273.1 MB 5.9% 0.88
Dec 1 03:00:00 - 03:59:59 1027 6.1% 0.293.0 MB 5.6% 0.84
Dec 1 04:00:00 - 04:59:59 1093 6.5% 0.302.8 MB 5.3% 0.79
Dec 1 05:00:00 - 05:59:59 1104 6.6% 0.313.1 MB 5.9% 0.88
Dec 1 06:00:00 - 06:59:59 1068 6.3% 0.303.1 MB 5.9% 0.89
Dec 1 07:00:00 - 07:59:59 926 5.5% 0.262.3 MB 4.5% 0.66
Dec 1 08:00:00 - 08:59:59 856 5.1% 0.242.8 MB 5.4% 0.80
Dec 1 09:00:00 - 09:59:59 793 4.7% 0.222.2 MB 4.2% 0.63
Dec 1 10:00:00 - 10:59:59 820 4.9% 0.232.8 MB 5.4% 0.81
Dec 1 11:00:00 - 11:59:59 710 4.2% 0.202.1 MB 4.0% 0.59
Dec 1 12:00:00 - 12:59:59 639 3.8% 0.182.1 MB 3.9% 0.59
Dec 1 13:00:00 - 13:59:59 559 3.3% 0.162.7 MB 5.2% 0.77
Dec 1 14:00:00 - 14:59:59 449 2.7% 0.121.4 MB 2.8% 0.41
Dec 1 15:00:00 - 15:59:59 307 1.8% 0.09865.7 KB 1.6% 0.24
Dec 1 16:00:00 - 16:59:59 404 2.4% 0.111.7 MB 3.3% 0.49
Dec 1 17:00:00 - 17:59:59 358 2.1% 0.101.6 MB 3.0% 0.45
Dec 1 18:00:00 - 18:59:59 364 2.2% 0.101.4 MB 2.6% 0.39
Dec 1 19:00:00 - 19:59:59 308 1.8% 0.091.0 MB 2.0% 0.29
Dec 1 20:00:00 - 20:59:59 407 2.4% 0.111.4 MB 2.6% 0.39
Dec 1 21:00:00 - 21:59:59 587 3.5% 0.161.8 MB 3.3% 0.50
Dec 1 22:00:00 - 22:59:59 634 3.8% 0.181.8 MB 3.4% 0.51
Dec 1 23:00:00 - 23:58:01 716 4.3% 0.212.4 MB 4.5% 0.69
TOTAL: 23:59:59 16835 100.0% 0.1952.4 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB30.1 GB 60.2% 0 0.28 2157.82
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB34.6 GB 69.2% 0 0.26 2344.07
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB369.8 MB 0.7% 0 0.0235555.56
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 GB30.5 GB 61.0% 0 0.53 1136.12
TOTAL: 10-500.0 GB95.6 GB 19.1% 1 0.36-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2511 2 0 19 0 0 0 0 2490
2bbsnz-out.feed.uzoreto.com 574 22 0 7 0 0 0 0 545
3news-out.mixmin.net 552 0 0 16 0 0 0 0 536
4newsfeed.neva.ru 491 12 0 27 0 0 0 0 452
5bbs-nz-out.news.weretis.net 363 59 0 53 0 0 0 0 251
6news.albasani.net 273 1 0 18 0 0 0 0 254
7feeder.eternal-september.org 190 0 0 26 0 0 0 0 164
8news.redatomik.org 164 0 0 17 0 0 0 0 147
9news.freedyn.net 84 0 0 16 0 0 0 0 68
10news.swapon.de 61 0 0 0 0 0 0 0 61
11news-out.aioe.org 61 19 0 13 0 0 0 0 29
12agency-nz-out.news.mb-net.net 31 5 0 16 0 0 0 0 10
13news.samoylyk.net 25 0 0 24 0 0 0 0 1
14feeder.awxg.com 24 0 0 23 0 0 0 0 1
15csiph.com 9 0 0 5 0 0 0 0 4
TOTAL: 15 5413 120 0 280 0 0 0 0 5013

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 22
mozilla.support.bugzilla 21
mozilla.dev.platform 17
alt.music.pink-floyd.publius 12
mozilla.dev.ui-alerts 7
mozilla.tools.taskcluster 5
mozilla.dev.l10n.web 4
gmane.linux.kernel 4
gmane.linux.alsa.devel 3
mozilla.dev.servo 2
mozilla.dev.builds 2
mozilla.apis 2
mozilla.test 2
mozilla.release.engineering 2
nyc.jobs 1
south-wales.test 1
alt.sex.telelphone 1
ms-news.pl.test 1
demos.local.statistics 1
gmane.linux.bios.flashrom 1
TOTAL: 29 120

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3790
EMP (phn path) 291
Binary: misplaced rar 278
EMP (phl) 109
Too many newsgroups 81
Binary: misplaced par2 40
EMP (phn nph) 34
Binary: non-binary distribution 24
User-issued cancel 21
User-issued spam cancel 5
Too many newsgroups (low_xpost) 1
Binary: misplaced nfo 1
HTML post 1
TOTAL: 13 4676

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 91
bbs-nz-out.news.weretis.net 82
news.swapon.de 61
news.albasani.net 28
news-out.mixmin.net 28
news-out.aioe.org 24
bbsnz-out.feed.uzoreto.com 9
news.snarked.org 3
newsfeed.neva.ru 3
feeder.eternal-september.org 2
TOTAL: 12 333
TOTAL: 1 333

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15366 607 14735 24 0 0 3%23:59:45
2utnut 16834 509 16088 237 0 0 3%23:59:47
3awxg 16365 41 16303 6 0 0 0%23:59:47
4weretis.net 13178 10 13006 0 0 81 0%23:59:47
5news.freedyn.net 16773 10 16707 0 0 0 0%23:59:47
6eternal-september 14594 9 14531 0 0 2 0%23:59:45
7aioe 13552 9 13442 0 0 0 0%23:59:47
8news.samoylyk.net 15400 8 15310 0 0 28 0%23:59:47
9csiph.com 16714 8 16626 0 0 0 0%23:59:43
10mb-net.net 16787 8 16744 0 0 0 0%23:59:46
11news.snarked.org 13659 8 13524 3 0 32 0%23:59:48
12news.redatomik.org 15368 8 15312 0 0 21 0%23:59:47
13neva.ru 15804 8 15793 0 0 0 0%23:59:47
14news-in.mixmin.net 15434 8 15411 0 0 0 0%23:59:43
15news.albasani.net 17498 3 15601 445 0 4737 0%23:59:47
16news.uzoreto.com 14755 3 14746 5 0 0 0%23:59:46
17news.swapon.de 1281 1 1279 0 0 0 0%23:51:35
TOTAL: 17 249362 1258 245158 720 0 4901 0%407:47:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1utnut5.0 MB900.9 KB5.9 MB0.1 KB/s8.1 KB23:59:47
2news.ausics.org3.3 MB303.1 KB3.6 MB0.0 KB/s5.8 KB23:59:45
3awxg117.3 KB27.4 KB144.7 KB0.0 KB/s3.1 KB23:59:47
4news.freedyn.net18.7 KB0.0 KB18.7 KB0.0 KB/s1.9 KB23:59:47
5aioe16.6 KB0.0 KB16.6 KB0.0 KB/s1.8 KB23:59:47
6eternal-september16.0 KB0.0 KB16.0 KB0.0 KB/s1.8 KB23:59:45
7weretis.net15.9 KB0.0 KB15.9 KB0.0 KB/s1.6 KB23:59:47
8news.samoylyk.net13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:47
9csiph.com13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:43
10mb-net.net13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:46
11news.redatomik.org13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:47
12neva.ru13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:47
13news-in.mixmin.net13.7 KB0.0 KB13.7 KB0.0 KB/s1.7 KB23:59:43
14news.snarked.org13.3 KB85.3 KB98.6 KB0.0 KB/s9.0 KB23:59:48
15news.uzoreto.com4.6 KB9.1 KB13.7 KB0.0 KB/s1.7 KB23:59:46
16news.albasani.net4.4 KB1.5 MB1.5 MB0.0 KB/s3.5 KB23:59:47
17news.swapon.de1.5 KB0.0 KB1.5 KB0.0 KB/s1.5 KB23:51:35
TOTAL: 178.6 MB2.8 MB11.4 MB0.0 KB/s5.9 KB407:47:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 543619.4 MB 3210 4 000:15:05
2vorlon.activateit.net.au 24 9221.3 MB 132 0 000:04:45
3amigacity.xyz 72 187365.9 KB 99 4 000:29:50
4drone.malloclabs.com 1 1541.8 KB 7 0 002:31:51
5160-3-236-103.cpe.cableone.net 2 33.7 KB 2 0 027:31:07
TOTAL: 5 486 656321.1 MB 3457 8 030:58:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 543619.4 MB 3210 4 000:15:05
2*.activateit.net.au 24 9221.3 MB 132 0 000:04:45
3*.xyz 72 187365.9 KB 99 4 000:29:50
4*.malloclabs.com 1 1541.8 KB 7 0 002:31:51
5*.cpe.cableone.net 2 33.7 KB 2 0 027:31:07
6unresolved 6 00.0 KB 0 0 000:06:09
TOTAL: 6 492 656321.1 MB 3457 8 030:58:51

NNRP auth users [Top 20]:

UserConn
amigacity 72
amybbs 24
malcolmlewis 2
kiwidrew 1
TOTAL: 4 99

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.284 0.072 0.00827:31:07
drone.malloclabs.com 0.116 0.056 0.00102:31:51
amigacity.xyz 4.504 1.032 0.27000:29:50
agency.bbs.nz 29.440 6.844 0.00000:15:05
vorlon.activateit.net.au 1.520 0.420 0.08400:04:45
118.149.162.210 0.256 0.032 0.00000:04:05
118.149.231.70 0.136 0.020 0.00000:02:04
? 1.424 0.144 0.00000:00:02
TOTAL: 8 37.680 8.620 0.36330:58:51

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.162.210 4
118.149.231.70 2
TOTAL: 2 6

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
drone.malloclabs.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 239644 97.5%
2rec 2446 1.0%
3soc 786 0.3%
4sci 730 0.3%
5comp 621 0.3%
6uk 520 0.2%
7linux 494 0.2%
8talk 374 0.2%
9misc 145 0.1%
10microsoft 30 0.0%
11news 25 0.0%
12mozilla 16 0.0%
13nz 13 0.0%
14humanities 12 0.0%
15aus 10 0.0%
TOTAL: 15 245866100.0%

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

NewsgroupCount
1alt.usage.english 238981
2rec.arts.tv 535
3rec.arts.drwho 357
4uk.d-i-y 268
5alt.usage.german 267
6talk.politics.guns 199
7rec.food.cooking 167
8rec.arts.sf.written 165
9linux.debian.bugs.dist 149
10alt.comp.os.windows-10 145
11rec.games.miniatures.misc 144
12sci.physics.relativity 129
13sci.electronics.design 123
14alt.politics.trump 122
15talk.origins 121
16uk.legal 116
17comp.os.linux.advocacy 112
18rec.sport.tennis 111
19comp.lang.c 108
20rec.sport.pro-wrestling 107
21comp.lang.python 100
22rec.sport.football.college 97
23sci.physics 96
24soc.culture.polish 95
25linux.debian.bugs.rc 87
26linux.debian.changes.devel 81
27sci.logic 80
28soc.retirement 79
29rec.boats 76
30soc.culture.israel 74
31misc.survivalism 69
32sci.math 65
33soc.history.living 62
34soc.culture.brazil 61
35soc.culture.indian 61
36sci.military.naval 59
37soc.culture.china 54
38rec.sport.golf 52
39comp.lang.prolog 48
40alt.usage.spanish 46
41rec.bicycles.tech 44
42rec.music.classical.recordings 43
43sci.lang 43
44soc.history.what-if 41
45rec.music.rock-pop-r+b.1950s 41
46sci.med.cardiology 39
47comp.lang.c++ 39
48rec.arts.sf.fandom 37
49rec.games.backgammon 32
50soc.culture.greek 30
51linux.debian.user 30
52rec.gambling.poker 29
53soc.culture.usa 27
54soc.penpals 26
55rec.outdoors.rv-travel 25
56comp.mobile.android 25
57sci.math.num-analysis 24
58talk.rape 24
59rec.sport.soccer 24
60rec.gambling.lottery 23
61uk.comp.sys.mac 23
62linux.debian.devel 23
63uk.legal.moderated 23
64uk.tech.broadcast 23
65uk.tech.digital-tv 22
66rec.aviation.soaring 22
67uk.radio.amateur 21
68microsoft.public.windowsxp.general 21
69soc.history 21
70comp.ai.philosophy 21
71talk.politics.misc 20
72linux.debian.user.french 20
73misc.immigration.usa 20
74soc.women 20
75rec.arts.tv.soaps.cbs 19
76rec.arts.sf.tv 19
77alt.test 18
78misc.health.diabetes 17
79rec.gambling.blackjack 17
80soc.culture.belgium 15
81linux.debian.l10n.german 15
82comp.unix.programmer 15
83alt.conspiracy.jfk 15
84rec.games.empire 14
85alt.os.linux.ubuntu 14
86comp.os.vms 14
87linux.debian.user.italian 14
88rec.autos.sport.f1 13
89alt.bbs.synchronet 13
90rec.audio.opinion 13
91comp.lang.forth 13
92sci.astro.amateur 13
93sci.med.pharmacy 12
94nz.general 12
95comp.theory 12
96rec.skiing.alpine 12
97rec.woodworking 11
98linux.debian.maint.emacsen 11
99news.software.readers 11
100rec.games.pinball 10
TOTAL: 340 245866