news.bbs.geek.nz daily logs

May 20 23:58:01 -- May 21 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 90743 51.4%7.3 MB 31.3%
innd 34321 19.4%5.4 MB 23.3%
inn 26837 15.2%5.8 MB 25.1%
innfeed 23255 13.2%4.5 MB 19.3%
cnfsstat 1440 0.8%254.1 KB 1.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 176597 100.0%23.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 262682 48.5%
Positive hits 236364 43.7%
Do not exist 25027 4.6%
Cache misses 17021 3.1%
TOTAL: 4 541094 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.173 0.0%167 0.000 1.036 13.600
article cleanup00:00:00.232 0.0%26148 0.000 0.009 0.033
article logging00:00:02.289 0.0%26690 0.000 0.086 9.713
article parse00:00:00.654 0.0%66688 0.000 0.010 0.027
article write00:00:01.305 0.0%18591 0.018 0.070 0.192
artlog/artcncl00:00:00.001 0.0%164 0.000 0.006 0.050
data move00:00:00.393 0.0%503561 0.000 0.001 0.008
hisgrep/artcncl00:00:00.000 0.0%162 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%167 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.045 0.0%541862 0.002 0.011 0.709
history sync00:00:00.022 0.0%375 0.000 0.059 0.667
history write00:00:04.511 0.0%25059 0.007 0.180 14.652
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:58:00.988 99.8%518582 97.546 166.379 636.670
nntp read00:00:03.797 0.0%522355 0.003 0.007 0.021
overview write00:00:32.539 0.0%18591 0.050 1.750 34.388
perl filter00:00:43.528 0.1%25059 1.000 1.737 4.980
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.920 0.0%37182 0.000 0.025 0.179
TOTAL: 24:00:56.02323:59:37.397 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.071 0.0%34557 0.000 0.002 0.017
article prepare00:00:00.010 0.0%68428 0.000 0.000 0.004
article read00:00:00.883 0.0%16745 0.000 0.053 0.850
backlog stats00:00:00.427 0.0%297752 0.000 0.001 0.004
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:02.007 0.0%248353 0.002 0.008 0.015
data write00:00:02.881 0.0%235808 0.006 0.012 0.028
idle23:53:59.990 99.9%297752 115.981 288.965 730.897
status file00:00:23.332 0.0%1919 0.500 12.158 529.050
TOTAL: 23:54:48.27123:54:29.601100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%4 0.000 0.000 0.000
idle29:07:31.332 97.8%97076 0.000 1080.095 86865.644
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.258 0.0%209108 0.000 0.006 1.000
readart00:00:00.993 0.0%7984 0.000 0.124 34.000
TOTAL: 29:47:31.87929:07:33.583 97.8%----

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 51 20472 5502 11205 3765 26%54:18:30
2news-out.aioe.org 1 18528 2999 15378 151 16%23:42:19
3news-out.mixmin.net 14 21163 2872 17217 1074 13%29:39:28
4feeder.eternal-september.org 88 24645 1855 22303 487 7%54:09:25
5newsfeed.neva.ru 160 17004 1104 15421 479 6%89:31:27
6newsfeed.datemas.de 2 25320 992 23909 419 3%30:41:29
7csiph.com 2 16643 976 15606 61 5%22:11:28
8news.albasani.net 1 10324 930 9023 371 9%09:12:28
9news.redatomik.org 1 17489 609 16794 86 3%23:53:47
10news.freedyn.net 3 22341 203 21934 204 0%25:22:51
11feeder.awxg.com 2 15589 124 15393 72 0%23:59:50
12news.samoylyk.net 6 32579 80 32350 149 0%13:31:36
13agency-nz-out.news.mb-net.net 22 20040 67 19867 106 0%36:48:03
14news.swapon.de 7 1179 58 1104 17 4%19:36:11
15localhost 2 1 1 0 0 100%00:00:00
16news.ausics.org 613 0 0 0 0 0%22:14:20
TOTAL: 16 975 263317 18372 237504 7441 6%478:53:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.4 MB687.9 KB22.1 MB42.2 MB 45%4.7 KB
2news-out.mixmin.net9.7 MB329.6 KB2.1 MB12.2 MB 79%3.2 KB
3feeder.eternal-september.org7.5 MB623.2 KB4.1 MB12.2 MB 61%5.4 KB
4news-out.aioe.org7.2 MB205.6 KB349.4 KB7.7 MB 92%2.5 KB
5newsfeed.datemas.de3.6 MB552.4 KB2.3 MB6.5 MB 55%4.7 KB
6csiph.com2.7 MB237.7 KB253.4 KB3.2 MB 84%3.1 KB
7news.albasani.net2.7 MB182.7 KB685.3 KB3.5 MB 75%2.8 KB
8newsfeed.neva.ru2.5 MB339.5 KB1.2 MB4.1 MB 61%2.7 KB
9news.redatomik.org1.6 MB359.1 KB366.9 KB2.4 MB 69%3.5 KB
10news.freedyn.net796.9 KB502.4 KB826.3 KB2.1 MB 37%5.2 KB
11news.samoylyk.net556.1 KB266.7 KB591.4 KB1.4 MB 39%6.2 KB
12feeder.awxg.com338.1 KB236.9 KB236.9 KB811.9 KB 41%4.1 KB
13agency-nz-out.news.mb-net.net210.6 KB262.1 KB426.3 KB899.0 KB 23%5.2 KB
14news.swapon.de151.6 KB79.7 KB79.7 KB311.1 KB 48%4.1 KB
15localhost0.9 KB0.0 KB0.0 KB0.9 KB100%0.9 KB
16news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1658.9 MB4.8 MB35.7 MB99.4 MB 59%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 20 23:58:01 - 23:59:59 24 0.1% 0.2090.2 KB 0.1% 0.76
May 21 00:00:00 - 00:59:59 906 4.9% 0.252.6 MB 4.4% 0.75
May 21 01:00:00 - 01:59:59 996 5.4% 0.284.2 MB 7.0% 1.19
May 21 02:00:00 - 02:59:59 953 5.1% 0.263.0 MB 5.0% 0.86
May 21 03:00:00 - 03:59:59 1003 5.4% 0.282.7 MB 4.5% 0.78
May 21 04:00:00 - 04:59:59 1072 5.8% 0.303.1 MB 5.2% 0.89
May 21 05:00:00 - 05:59:59 1133 6.1% 0.313.3 MB 5.5% 0.94
May 21 06:00:00 - 06:59:59 1020 5.5% 0.283.0 MB 5.0% 0.86
May 21 07:00:00 - 07:59:59 1000 5.4% 0.282.8 MB 4.6% 0.78
May 21 08:00:00 - 08:59:59 945 5.1% 0.262.6 MB 4.3% 0.73
May 21 09:00:00 - 09:59:59 864 4.7% 0.243.1 MB 5.2% 0.89
May 21 10:00:00 - 10:59:59 763 4.1% 0.213.1 MB 5.1% 0.88
May 21 11:00:00 - 11:59:59 630 3.4% 0.171.8 MB 3.0% 0.51
May 21 12:00:00 - 12:59:59 472 2.5% 0.131.4 MB 2.4% 0.41
May 21 13:00:00 - 13:59:59 385 2.1% 0.111.2 MB 1.9% 0.33
May 21 14:00:00 - 14:59:59 423 2.3% 0.121.5 MB 2.4% 0.42
May 21 15:00:00 - 15:59:59 388 2.1% 0.111.4 MB 2.3% 0.39
May 21 16:00:00 - 16:59:59 335 1.8% 0.091.4 MB 2.3% 0.39
May 21 17:00:00 - 17:59:59 482 2.6% 0.131.4 MB 2.3% 0.39
May 21 18:00:00 - 18:59:59 664 3.6% 0.182.8 MB 4.6% 0.79
May 21 19:00:00 - 19:59:59 678 3.6% 0.191.8 MB 3.0% 0.51
May 21 20:00:00 - 20:59:59 761 4.1% 0.212.8 MB 4.6% 0.79
May 21 21:00:00 - 21:59:59 800 4.3% 0.222.3 MB 3.8% 0.65
May 21 22:00:00 - 22:59:59 974 5.2% 0.273.6 MB 5.9% 1.02
May 21 23:00:00 - 23:58:01 905 4.9% 0.263.4 MB 5.6% 1.00
TOTAL: 24:00:00 18576 100.0% 0.2160.3 MB 100.0% 0.71
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.1 GB 34.1% 0 0.30 2053.73
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB19.9 GB 39.8% 0 0.29 2069.37
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB213.8 MB 0.4% 0 0.0323295.02
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 GB1.3 GB 2.7% 0 0.62 977.76
TOTAL: 10-500.0 GB38.5 GB 7.7% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 3814 75 0 95 0 0 0 0 3644
2news-out.mixmin.net 1317 0 0 84 0 0 0 0 1233
3news.albasani.net 553 2 0 86 0 0 0 0 465
4newsfeed.neva.ru 506 98 0 67 0 0 0 0 341
5feeder.eternal-september.org 499 0 0 121 0 0 0 0 378
6newsfeed.datemas.de 388 41 0 86 0 0 0 0 261
7news.samoylyk.net 230 0 0 117 0 0 0 0 113
8news-out.aioe.org 210 11 0 64 0 0 0 0 135
9news.freedyn.net 175 5 0 70 0 0 0 0 100
10news.redatomik.org 124 0 0 86 0 0 0 0 38
11agency-nz-out.news.mb-net.net 106 9 0 61 0 0 0 0 36
12feeder.awxg.com 70 0 0 69 0 0 0 0 1
13csiph.com 66 0 0 61 0 0 0 0 5
14news.swapon.de 39 0 0 22 0 0 0 0 17
TOTAL: 14 8097 241 0 1089 0 0 0 0 6767

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 108
mpc.lists.freebsd.ports.bugs 37
mpc.lists.freebsd.x11 13
mozilla.support.seamonkey 11
mpc.lists.freebsd.gecko 9
gmane.linux.alsa.devel 6
gmane.comp.gis.openstreetmap.tagging 5
mozilla.dev.security.policy 4
mpc.lists.freebsd.gnome 4
mozilla.test 3
mozilla.dev.platform 3
gmane.linux.alsa.user 3
demos.local.lists.cgp-russian 3
eagle.support.eng 3
mozilla.dev.l10n.sr 2
gmane.linux.kernel 2
usc.forsale 2
alt.penthouse.sex.femdom 2
aol.neighborhood.az.jobs 1
mozilla.dev.l10n 1
TOTAL: 39 241

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5289
EMP (phn path) 711
EMP (phl) 82
EMP (phn nph) 44
Too many newsgroups 41
User-issued cancel 24
HTML post 12
Binary: non-binary distribution 11
Binary Image: misplaced jpg 5
Too many newsgroups (meow) 5
User-issued spam cancel 2
Too many newsgroups (low_xpost) 1
TOTAL: 12 6227

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 245
news.albasani.net 104
news-out.aioe.org 59
newsfeed.datemas.de 36
news.redatomik.org 33
newsfeed.neva.ru 28
news.swapon.de 16
news.snarked.org 13
news.samoylyk.net 2
feeder.eternal-september.org 2
TOTAL: 12 540
TOTAL: 1 540

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16219 15243 0 952 0 0 93%23:59:47
2awxg 18072 66 17998 3 0 7 0%23:59:47
3news.samoylyk.net 25612 4 25585 0 18 517 0%23:57:40
4aioe 14809 3 14547 0 0 36 0%23:59:46
5news.snarked.org 12979 3 12934 0 0 1 0%23:59:40
6neva.ru 16913 2 16907 0 0 0 0%23:59:46
7news.freedyn.net 18547 2 18371 3 0 154 0%23:59:46
8news.albasani.net 19149 2 16387 753 0 5717 0%23:59:46
9mb-net.net 18508 1 18479 1 0 29 0%23:59:46
10news.redatomik.org 17671 1 17662 0 0 11 0%23:59:43
11news-in.mixmin.net 14908 1 14899 0 0 17 0%23:59:46
12newsfeed.datemas.de 17557 1 17553 0 0 29 0%23:59:45
13eternal-september 15542 1 15525 0 0 0 0%23:59:38
14csiph.com 17656 1 17569 0 0 37 0%23:59:46
15news.swapon.de 1423 0 1422 0 0 0 0%23:40:17
TOTAL: 15 245565 15331 225838 1712 18 6555 6%359:34:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org48.8 MB4.3 MB53.2 MB0.6 KB/s3.4 KB23:59:47
2awxg358.4 KB60.3 KB418.7 KB0.0 KB/s6.1 KB23:59:47
3news.snarked.org280.5 KB0.0 KB280.5 KB0.0 KB/s93.5 KB23:59:40
4news.samoylyk.net19.9 KB0.0 KB19.9 KB0.0 KB/s5.0 KB23:57:40
5aioe9.0 KB0.0 KB9.0 KB0.0 KB/s3.0 KB23:59:46
6neva.ru4.2 KB0.0 KB4.2 KB0.0 KB/s2.1 KB23:59:46
7news.albasani.net4.0 KB3.4 MB3.4 MB0.0 KB/s4.6 KB23:59:46
8news.freedyn.net2.2 KB24.8 KB27.1 KB0.0 KB/s5.4 KB23:59:46
9mb-net.net0.9 KB18.0 KB18.9 KB0.0 KB/s9.4 KB23:59:46
10news.redatomik.org0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:43
11news-in.mixmin.net0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:46
12newsfeed.datemas.de0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:45
13eternal-september0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:38
14csiph.com0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:17
TOTAL: 1549.5 MB7.8 MB57.3 MB0.0 KB/s3.4 KB359:34:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 321 566320.6 MB 2829 1 000:10:20
2kosh.activateit.net.au 24 10721.5 MB 138 0 000:05:07
3192.168.1.4 1 131830.9 KB 4 0 000:00:07
4192.168.1.8 1 1477.0 KB 4 0 000:00:00
560.234.244.55 5 1189.9 KB 1 0 000:13:40
667-61-218-236.cpe.cableone.net 3 17.8 KB 1 0 028:39:07
TOTAL: 6 355 689223.1 MB 2977 1 029:47:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 321 566320.6 MB 2829 1 000:10:20
2*.activateit.net.au 24 10721.5 MB 138 0 000:05:07
3unresolved 17 156997.7 KB 9 0 000:52:47
4*.cpe.cableone.net 3 17.8 KB 1 0 028:39:07
TOTAL: 4 365 689223.1 MB 2977 1 029:47:25

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 4
malcolmlewis 3
paulh 2
TOTAL: 4 33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.300 0.076 0.01328:39:07
118.149.163.106 0.300 0.040 0.00000:19:52
118.149.150.233 0.264 0.016 0.00000:18:59
60.234.244.55 0.392 0.028 0.01200:13:40
agency.bbs.geek.nz 23.424 5.128 0.00000:10:20
kosh.activateit.net.au 1.556 0.408 0.15000:05:07
192.168.1.4 0.120 0.028 0.00300:00:07
203.118.151.117 0.088 0.004 0.00000:00:06
? 1.664 0.168 0.00000:00:03
192.168.1.8 0.096 0.008 0.00300:00:00
TOTAL: 10 28.204 5.904 0.18129:47:25

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.163.106 5
118.149.150.233 4
203.118.151.117 1
TOTAL: 3 10

NNRP gethostbyaddr failures [Top 20]:

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

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 2930 42.5%
2soc 897 13.0%
3comp 817 11.9%
4alt 718 10.4%
5sci 586 8.5%
6misc 352 5.1%
7talk 227 3.3%
8nz 144 2.1%
9uk 101 1.5%
10news 96 1.4%
11aus 8 0.1%
12agency 7 0.1%
13humanities 4 0.1%
14eternal-september 1 0.0%
TOTAL: 14 6888100.0%

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

NewsgroupCount
1rec.arts.tv 794
2rec.arts.drwho 524
3alt.home.repair 317
4alt.test 222
5rec.sport.tennis 215
6soc.retirement 200
7misc.test 192
8rec.arts.sf.written 190
9comp.lang.python 162
10alt.comp.os.windows-10 129
11comp.os.linux.advocacy 124
12soc.culture.israel 119
13misc.survivalism 116
14nz.general 116
15talk.politics.guns 108
16rec.gambling.poker 101
17rec.food.cooking 99
18sci.physics.relativity 94
19sci.math 89
20soc.culture.polish 86
21rec.photo.digital 82
22sci.physics 81
23rec.sport.pro-wrestling 78
24sci.electronics.design 77
25talk.politics.misc 72
26uk.radio.amateur 72
27rec.audio.opinion 69
28news.lists.filters 67
29rec.sport.football.college 61
30comp.lang.forth 54
31soc.culture.brazil 54
32sci.logic 48
33rec.sport.soccer 48
34comp.lang.c 45
35soc.culture.china 43
36comp.mobile.android 43
37comp.sys.mac.system 42
38rec.boats 41
39talk.origins 40
40soc.culture.african.american 39
41sci.military.naval 39
42soc.culture.usa 36
43rec.outdoors.rv-travel 36
44soc.culture.cuba 35
45rec.crafts.metalworking 35
46sci.math.num-analysis 35
47comp.sys.apple2 34
48soc.culture.singapore 33
49rec.radio.shortwave 32
50rec.games.pinball 31
51comp.sys.acorn.apps 30
52comp.lang.c++ 29
53rec.nude 27
54rec.sport.golf 27
55soc.culture.indian 27
56soc.culture.romanian 27
57alt.books.reviews 27
58soc.culture.venezuela 26
59nz.comp 26
60soc.history.medieval 24
61rec.arts.movies.current-films 24
62rec.autos.sport.f1 24
63soc.history.what-if 24
64misc.health.alternative 23
65soc.men 21
66sci.electronics.repair 21
67uk.comp.homebuilt 19
68comp.lang.fortran 19
69rec.bicycles.tech 19
70rec.aviation.soaring 18
71soc.culture.vietnamese 18
72rec.radio.amateur.misc 18
73sci.lang 18
74rec.music.rock-pop-r+b.1950s 16
75sci.space.policy 16
76rec.music.dylan 16
77rec.arts.tv.uk.coronation-st 16
78rec.games.roguelike.nethack 15
79comp.lang.ada 15
80comp.soft-sys.matlab 15
81comp.sys.raspberry-pi 14
82comp.soft-sys.sas 14
83comp.soft-sys.math.scilab 14
84rec.music.classical.recordings 13
85soc.genealogy.medieval 12
86comp.lang.cobol 12
87sci.anthropology.paleo 12
88rec.arts.movies.past-films 12
89rec.radio.amateur.policy 11
90misc.health.diabetes 11
91comp.sys.apple2.programmer 10
92comp.sys.mac.advocacy 10
93rec.music.artists.kiss 10
94rec.arts.sf.tv 10
95rec.games.trivia 10
96uk.tech.broadcast 10
97sci.crypt 10
98soc.culture.turkish 9
99rec.music.classical.guitar 9
100alt.bbs.ads 8
TOTAL: 290 6888