news.bbs.geek.nz daily logs

Jun 24 23:58:01 -- Jun 25 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 99897 54.0%8.0 MB 33.7%
innd 32609 17.6%5.3 MB 22.4%
inn 27545 14.9%5.8 MB 24.4%
innfeed 23445 12.7%4.4 MB 18.4%
cnfsstat 1440 0.8%251.5 KB 1.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 184937 100.0%23.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 258398 49.1%
Positive hits 242157 46.0%
Do not exist 25587 4.9%
Cache misses 172 0.0%
TOTAL: 4 526314 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.131 0.0%139 0.000 0.942 17.000
article cleanup00:00:00.244 0.0%26889 0.000 0.009 0.042
article logging00:00:00.674 0.0%27438 0.000 0.025 0.055
article parse00:00:00.879 0.0%74404 0.000 0.012 0.031
article write00:00:02.653 0.0%18370 0.012 0.144 8.225
artlog/artcncl00:00:00.001 0.0%129 0.000 0.008 0.200
data move00:00:00.293 0.0%512529 0.000 0.001 0.006
hisgrep/artcncl00:00:00.001 0.0%135 0.000 0.007 0.077
hishave/artcncl00:00:00.001 0.0%139 0.000 0.007 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.558 0.0%535127 0.000 0.010 0.787
history sync00:00:00.032 0.0%359 0.000 0.089 11.000
history write00:00:05.732 0.0%25940 0.016 0.221 16.990
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:57:53.776 99.8%529132 96.917 163.048 506.771
nntp read00:00:02.977 0.0%530710 0.002 0.006 0.038
overview write00:00:32.504 0.0%18370 0.085 1.769 48.876
perl filter00:00:57.523 0.1%25940 1.544 2.218 10.065
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.127 0.0%36740 0.003 0.031 0.114
TOTAL: 24:00:51.41523:59:44.106 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%24734 0.000 0.002 0.038
article prepare00:00:00.000 0.0%8156 0.000 0.000 0.000
article read00:00:00.182 0.0%1697 0.000 0.107 7.500
backlog stats00:00:00.289 0.0%280521 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.341 0.0%231918 0.001 0.006 0.012
data write00:00:02.638 0.0%218978 0.006 0.012 0.024
idle23:53:28.058100.0%280521 182.499 306.601 774.654
status file00:00:18.171 0.0%1967 0.700 9.238 449.400
TOTAL: 23:54:05.87723:53:50.738100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%14 0.000 0.000 0.000
idle00:45:50.429 70.9%104480 0.000 26.325 75328.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.188 0.0%222340 0.000 0.005 0.250
readart00:00:01.586 0.0%6772 0.000 0.234 16.500
TOTAL: 01:04:37.79900:45:53.203 71.0%----

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
1news.snarked.org 54 21655 4349 12247 5059 20%56:55:13
2news.redatomik.org 1 16376 3360 12953 63 20%22:56:17
3news-out.aioe.org 3 18830 3134 15558 138 16%25:09:10
4csiph.com 2 18695 1996 16638 61 10%25:00:58
5news-out.mixmin.net 16 20587 1786 17768 1033 8%34:22:55
6feeder.eternal-september.org 72 22783 1098 21314 371 4%47:07:08
7newsfeed.neva.ru 151 16385 811 15149 425 4%83:29:06
8news.albasani.net 0 18536 627 17536 373 3%22:47:56
9newsfeed.datemas.de 3 22887 568 21940 379 2%27:46:10
10news.samoylyk.net 5 25039 143 24554 342 0%23:51:37
11news.swapon.de 9 2107 106 1978 23 5%30:48:48
12feeder.awxg.com 1 15460 92 15297 71 0%23:59:56
13news.freedyn.net 2 21189 92 20906 191 0%24:51:52
14agency-nz-out.news.mb-net.net 25 21522 53 21370 99 0%37:37:19
15localhost 20 19 19 0 0 100%00:00:00
TOTAL: 15 364 262070 18234 235208 8628 6%486:44:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.0 MB611.8 KB32.6 MB54.2 MB 38%5.9 KB
2news.redatomik.org8.3 MB395.0 KB405.6 KB9.1 MB 91%2.7 KB
3news-out.aioe.org7.9 MB166.4 KB301.8 KB8.4 MB 94%2.6 KB
4news-out.mixmin.net5.8 MB390.2 KB2.1 MB8.3 MB 69%3.0 KB
5csiph.com5.3 MB347.0 KB400.0 KB6.1 MB 87%3.0 KB
6feeder.eternal-september.org4.7 MB450.7 KB2.9 MB8.1 MB 58%5.6 KB
7newsfeed.datemas.de4.5 MB578.8 KB1.5 MB6.5 MB 68%7.0 KB
8news.albasani.net3.3 MB440.1 KB989.6 KB4.7 MB 70%4.8 KB
9newsfeed.neva.ru2.1 MB310.1 KB1.6 MB4.0 MB 52%3.4 KB
10news.freedyn.net1.7 MB278.5 KB660.4 KB2.6 MB 65%9.5 KB
11news.samoylyk.net867.6 KB587.0 KB2.3 MB3.7 MB 22%7.8 KB
12agency-nz-out.news.mb-net.net302.5 KB306.7 KB393.6 KB1002.8 KB 30%6.6 KB
13feeder.awxg.com291.5 KB359.9 KB359.9 KB1011.2 KB 28%6.2 KB
14news.swapon.de280.2 KB67.2 KB69.2 KB416.6 KB 67%3.2 KB
15localhost32.7 KB0.0 KB0.0 KB32.7 KB100%1.7 KB
TOTAL: 1566.3 MB5.2 MB46.5 MB118.0 MB 56%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 24 23:58:01 - 23:59:59 29 0.2% 0.2470.2 KB 0.1% 0.59
Jun 25 00:00:00 - 00:59:59 843 4.6% 0.232.1 MB 3.1% 0.60
Jun 25 01:00:00 - 01:59:59 867 4.7% 0.244.7 MB 7.0% 1.34
Jun 25 02:00:00 - 02:59:59 1091 5.9% 0.304.1 MB 6.1% 1.16
Jun 25 03:00:00 - 03:59:59 1020 5.6% 0.283.6 MB 5.4% 1.03
Jun 25 04:00:00 - 04:59:59 927 5.0% 0.262.6 MB 3.9% 0.74
Jun 25 05:00:00 - 05:59:59 992 5.4% 0.285.0 MB 7.5% 1.42
Jun 25 06:00:00 - 06:59:59 891 4.9% 0.253.8 MB 5.7% 1.08
Jun 25 07:00:00 - 07:59:59 957 5.2% 0.272.6 MB 3.8% 0.73
Jun 25 08:00:00 - 08:59:59 956 5.2% 0.273.4 MB 5.1% 0.97
Jun 25 09:00:00 - 09:59:59 801 4.4% 0.223.2 MB 4.8% 0.91
Jun 25 10:00:00 - 10:59:59 820 4.5% 0.232.6 MB 3.8% 0.73
Jun 25 11:00:00 - 11:59:59 644 3.5% 0.182.2 MB 3.3% 0.64
Jun 25 12:00:00 - 12:59:59 471 2.6% 0.131.8 MB 2.7% 0.52
Jun 25 13:00:00 - 13:59:59 556 3.0% 0.151.7 MB 2.5% 0.48
Jun 25 14:00:00 - 14:59:59 374 2.0% 0.101.8 MB 2.6% 0.50
Jun 25 15:00:00 - 15:59:59 413 2.2% 0.111.2 MB 1.8% 0.34
Jun 25 16:00:00 - 16:59:59 465 2.5% 0.132.8 MB 4.2% 0.80
Jun 25 17:00:00 - 17:59:59 399 2.2% 0.111.2 MB 1.8% 0.35
Jun 25 18:00:00 - 18:59:59 585 3.2% 0.162.4 MB 3.5% 0.67
Jun 25 19:00:00 - 19:59:59 666 3.6% 0.182.0 MB 3.0% 0.58
Jun 25 20:00:00 - 20:59:59 855 4.7% 0.242.6 MB 3.9% 0.74
Jun 25 21:00:00 - 21:59:59 906 4.9% 0.253.2 MB 4.7% 0.90
Jun 25 22:00:00 - 22:59:59 872 4.7% 0.242.8 MB 4.2% 0.81
Jun 25 23:00:00 - 23:58:01 961 5.2% 0.283.6 MB 5.4% 1.07
TOTAL: 24:00:00 18361 100.0% 0.2167.1 MB 100.0% 0.79
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.9 GB 35.8% 0 0.31 1986.18
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.9 GB 41.8% 0 0.37 1625.47
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB223.7 MB 0.4% 0 0.0415802.47
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 GB3.5 GB 7.1% 0 0.60 1004.22
TOTAL: 10-500.0 GB42.6 GB 8.5% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5078 55 0 101 0 0 0 0 4922
2news-out.mixmin.net 1120 0 0 96 0 0 0 0 1024
3newsfeed.neva.ru 430 58 0 59 0 0 0 0 313
4news.albasani.net 418 3 0 86 0 0 0 0 329
5feeder.eternal-september.org 393 0 0 120 0 0 0 0 273
6news.redatomik.org 345 0 0 57 0 0 0 0 288
7newsfeed.datemas.de 330 69 0 71 0 0 0 0 190
8news.samoylyk.net 310 0 0 77 0 0 0 0 233
9news.freedyn.net 194 8 0 60 0 0 0 0 126
10news-out.aioe.org 189 41 0 48 0 0 0 0 100
11agency-nz-out.news.mb-net.net 92 8 0 46 0 0 0 0 38
12feeder.awxg.com 60 0 0 60 0 0 0 0 0
13csiph.com 57 0 0 48 0 0 0 0 9
14news.swapon.de 36 0 0 16 0 0 0 0 20
15news.ausics.org 3 0 0 3 0 0 0 0 0
TOTAL: 15 9055 242 0 948 0 0 0 0 7865

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 144
mpc.lists.freebsd.ports.bugs 40
mozilla.support.seamonkey 16
fido7.ru.android 14
gmane.linux.alsa.devel 7
gmane.comp.gis.openstreetmap.geocoding 4
mpc.lists.nanog 3
mozilla.apis 2
alt.digicash.deadbeats 2
mozilla.dev.apps.seamonkey 2
alt.religion.christian.romman-catholic 1
demos.local.statistics 1
mozilla.dev.apps.thunderbird 1
mozilla.test 1
mozilla.release.engineering 1
alt.penthouse.sex.femdom 1
test.post 1
mozilla.dev.ui-alerts 1
TOTAL: 18 242

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6590
EMP (phn path) 486
EMP (phl) 119
Too many newsgroups 38
EMP (phn nph) 37
Binary: non-binary distribution 18
User-issued cancel 13
Binary Image: misplaced jpg 7
Binary: misplaced par2 5
HTML post 2
Binary: misplaced 003 2
Binary: misplaced 002 1
Binary: misplaced 010 1
Binary: misplaced 625 1
Binary: misplaced 586 1
Binary: misplaced 021 1
Binary: misplaced 009 1
Binary: misplaced 102 1
Binary: misplaced 023 1
TOTAL: 19 7325

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 282
news-out.mixmin.net 119
news-out.aioe.org 60
news.albasani.net 29
newsfeed.datemas.de 19
news.swapon.de 18
news.snarked.org 7
newsfeed.neva.ru 5
feeder.eternal-september.org 1
TOTAL: 9 540
TOTAL: 1 540

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15843 820 14911 112 0 0 5%23:59:46
2awxg 17768 86 17677 3 1 10 0%23:59:48
3news.snarked.org 14018 26 13936 2 0 0 0%23:59:23
4aioe 13627 22 13526 0 0 0 0%23:59:33
5mb-net.net 18268 22 18234 0 0 0 0%23:59:45
6csiph.com 16550 20 16488 0 0 0 0%23:59:47
7news.freedyn.net 18331 20 18219 1 0 8 0%23:59:41
8news.redatomik.org 14905 19 14866 0 0 0 0%23:59:47
9news-in.mixmin.net 15305 19 15273 0 0 0 0%23:59:47
10eternal-september 15545 13 15399 0 0 305 0%23:59:47
11news.albasani.net 18696 10 16338 717 1 5563 0%23:59:47
12newsfeed.datemas.de 17892 10 17776 1 0 390 0%23:59:47
13neva.ru 17200 7 17177 11 0 0 0%23:59:47
14news.samoylyk.net 7649 2 7602 0 0 8310 0%23:59:44
15news.swapon.de 1505 0 1505 0 0 0 0%23:35:28
TOTAL: 15 223102 1096 218927 847 2 14586 0%359:31:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.3 MB9.9 MB16.2 MB0.2 KB/s17.8 KB23:59:46
2news.snarked.org1.1 MB8.8 KB1.1 MB0.0 KB/s40.5 KB23:59:23
3awxg282.6 KB28.5 KB311.1 KB0.0 KB/s3.5 KB23:59:48
4mb-net.net64.0 KB0.0 KB64.0 KB0.0 KB/s2.9 KB23:59:45
5aioe38.8 KB0.0 KB38.8 KB0.0 KB/s1.8 KB23:59:33
6csiph.com34.4 KB0.0 KB34.4 KB0.0 KB/s1.7 KB23:59:47
7news.freedyn.net34.0 KB98.3 KB132.3 KB0.0 KB/s6.3 KB23:59:41
8news.redatomik.org32.7 KB0.0 KB32.7 KB0.0 KB/s1.7 KB23:59:47
9news-in.mixmin.net32.7 KB0.0 KB32.7 KB0.0 KB/s1.7 KB23:59:47
10eternal-september20.5 KB0.0 KB20.5 KB0.0 KB/s1.6 KB23:59:47
11newsfeed.datemas.de17.2 KB1.4 KB18.6 KB0.0 KB/s1.7 KB23:59:47
12neva.ru16.8 KB17.6 KB34.4 KB0.0 KB/s1.9 KB23:59:47
13news.albasani.net16.6 KB3.4 MB3.4 MB0.0 KB/s4.8 KB23:59:47
14news.samoylyk.net3.1 KB0.0 KB3.1 KB0.0 KB/s1.6 KB23:59:44
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:35:28
TOTAL: 157.9 MB13.4 MB21.4 MB0.0 KB/s11.3 KB359:31:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 368 497219.0 MB 2884 18 4600:10:59
2kosh.activateit.net.au 24 11381.6 MB 164 0 000:05:07
3192.168.1.7 1 112383.5 KB 4 0 000:00:05
460.234.244.55 9 2978.1 KB 1 1 000:30:32
567-61-218-236.cpe.cableone.net 1 00.0 KB 1 0 000:00:00
TOTAL: 5 403 625121.1 MB 3054 19 4601:04:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 368 497219.0 MB 2884 18 4600:10:59
2*.activateit.net.au 24 11381.6 MB 164 0 000:05:07
3unresolved 15 141461.6 KB 5 1 000:48:22
4*.cpe.cableone.net 1 00.0 KB 1 0 000:00:00
TOTAL: 4 408 625121.1 MB 3054 19 4601:04:31

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 6
malcolmlewis 1
paulh 1
TOTAL: 4 32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
60.234.244.55 0.628 0.072 0.01800:30:32
agency.bbs.geek.nz 25.704 5.732 0.00000:10:59
202.174.187.54 0.184 0.020 0.00000:10:31
118.149.186.214 0.136 0.012 0.00000:07:12
kosh.activateit.net.au 1.440 0.340 0.12000:05:07
192.168.1.7 0.096 0.032 0.00300:00:05
? 1.144 0.152 0.00000:00:01
TOTAL: 7 29.332 6.360 0.14101:04:31

Curious NNRP server explorers [Top 20]:

SystemConn
202.174.187.54 3
118.149.186.214 2
TOTAL: 2 5

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 2903 46.5%
2soc 817 13.1%
3comp 716 11.5%
4alt 630 10.1%
5sci 546 8.8%
6talk 157 2.5%
7misc 136 2.2%
8nz 134 2.1%
9uk 76 1.2%
10news 68 1.1%
11humanities 18 0.3%
12aus 18 0.3%
13agency 15 0.2%
14eternal-september 4 0.1%
TOTAL: 14 6238100.0%

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

NewsgroupCount
1rec.arts.tv 958
2rec.arts.drwho 375
3alt.comp.os.windows-10 298
4alt.home.repair 235
5comp.os.linux.advocacy 178
6rec.food.cooking 171
7rec.sport.tennis 146
8comp.lang.python 142
9rec.arts.sf.written 137
10soc.retirement 126
11soc.culture.polish 126
12nz.general 119
13soc.culture.israel 107
14sci.electronics.design 102
15sci.physics 102
16comp.lang.c 98
17rec.boats 96
18misc.survivalism 88
19sci.math 77
20soc.culture.usa 77
21talk.origins 74
22soc.culture.cuba 70
23rec.sport.golf 69
24rec.sport.pro-wrestling 65
25news.lists.filters 63
26soc.culture.china 57
27sci.physics.relativity 57
28uk.radio.amateur 56
29alt.bbs.mystic 54
30talk.politics.guns 51
31sci.logic 47
32rec.arts.movies.current-films 46
33soc.culture.indian 45
34rec.bicycles.tech 44
35rec.arts.comics.strips 43
36rec.woodworking 42
37rec.outdoors.rv-travel 40
38comp.mobile.android 39
39comp.lang.forth 37
40rec.sport.football.college 36
41rec.radio.amateur.misc 35
42rec.aviation.soaring 35
43comp.os.vms 35
44rec.radio.shortwave 32
45rec.photo.digital 30
46sci.space.policy 30
47rec.arts.sf.tv 28
48rec.skiing.alpine 28
49alt.test 27
50rec.gambling.poker 26
51rec.crafts.metalworking 26
52rec.music.classical.recordings 26
53soc.culture.singapore 25
54rec.games.pinball 24
55sci.military.naval 24
56soc.penpals 22
57rec.music.dylan 22
58rec.autos.sport.f1 22
59rec.autos.tech 22
60misc.health.alternative 20
61soc.culture.bulgaria 20
62rec.sport.soccer 20
63rec.games.trivia 18
64talk.politics.misc 18
65soc.genealogy.medieval 16
66soc.veterans 15
67sci.math.num-analysis 15
68soc.history.what-if 15
69comp.lang.c++ 15
70humanities.lit.authors.shakespeare 15
71agency.test 15
72comp.unix.shell 14
73rec.arts.tv.uk.coronation-st 14
74comp.lang.asm.x86 14
75comp.sys.apple2 14
76nz.comp 13
77rec.audio.opinion 13
78comp.soft-sys.matlab 12
79uk.comp.homebuilt 12
80comp.os.linux.misc 12
81sci.geo.earthquakes 12
82soc.culture.venezuela 11
83soc.genealogy.benelux 11
84sci.astro.amateur 10
85soc.men 10
86rec.arts.books.tolkien 10
87comp.sys.mac.apps 10
88rec.nude 10
89sci.physics.electromag 10
90comp.lang.ada 9
91comp.arch.embedded 9
92comp.sys.ibm.ps2.hardware 9
93rec.arts.movies.past-films 8
94aus.aviation 8
95rec.games.bridge 8
96alt.comp.os.windows-xp 8
97sci.electronics.basics 8
98misc.phone.mobile.iphone 8
99soc.history.medieval 8
100soc.culture.vietnamese 8
TOTAL: 260 6238