news.bbs.geek.nz daily logs

Nov 24 23:58:01 -- Nov 25 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 147440 64.1%12.1 MB 44.4%
innd 31463 13.7%5.0 MB 18.4%
inn 26375 11.5%5.5 MB 20.1%
innfeed 23287 10.1%4.4 MB 16.2%
cnfsstat 1440 0.6%250.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 230006 100.0%27.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 230802 50.1%
Positive hits 205297 44.5%
Do not exist 24848 5.4%
Cache misses 169 0.0%
TOTAL: 4 461116 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.546 0.0%137 0.000 3.985 27.857
article cleanup00:00:00.261 0.0%25569 0.000 0.010 0.039
article logging00:00:00.689 0.0%26115 0.000 0.026 0.360
article parse00:00:00.822 0.0%75655 0.000 0.011 0.035
article write00:00:01.314 0.0%16617 0.022 0.079 0.860
artlog/artcncl00:00:00.001 0.0%132 0.000 0.008 1.000
data move00:00:00.386 0.0%455286 0.000 0.001 0.030
hisgrep/artcncl00:00:00.221 0.0%129 0.000 1.713 15.714
hishave/artcncl00:00:00.141 0.0%137 0.000 1.029 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.535 0.0%462062 0.000 0.021 1.090
history sync00:00:00.013 0.0%371 0.000 0.035 0.500
history write00:00:08.430 0.0%24894 0.000 0.339 14.667
hiswrite/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
idle23:48:08.322 99.8%469641 96.805 182.455 525.878
nntp read00:00:02.783 0.0%470819 0.002 0.006 0.022
overview write00:00:35.093 0.0%16617 0.091 2.112 48.750
perl filter00:00:48.977 0.1%24894 1.420 1.967 4.365
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.132 0.0%33234 0.004 0.034 0.103
TOTAL: 23:50:58.31023:49:58.666 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%22415 0.000 0.002 0.020
article prepare00:00:00.000 0.0%8244 0.000 0.000 0.000
article read00:00:00.382 0.0%1845 0.000 0.207 10.333
backlog stats00:00:00.276 0.0%259630 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.280 0.0%210364 0.000 0.006 0.010
data write00:00:02.347 0.0%198074 0.005 0.012 0.024
idle23:54:24.540100.0%259630 176.355 331.489 998.203
status file00:00:07.314 0.0%1933 0.700 3.784 118.629
TOTAL: 23:54:49.60523:54:36.192100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle14:32:59.354 97.0%160312 0.000 326.734 75266.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:34.253 0.1%347466 0.000 0.099 1.323
readart00:00:02.013 0.0%12576 0.000 0.160 29.000
TOTAL: 15:00:12.32314:33:35.620 97.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-out.mixmin.net 13 19190 4267 13835 1088 22%29:41:23
2news.snarked.org 44 12887 4068 8512 307 31%46:42:06
3csiph.com 3 18567 1524 16997 46 8%25:56:09
4newsfeed.datemas.de 3 17039 1453 15102 484 8%23:28:26
5news.redatomik.org 1 17603 1321 16010 272 7%25:13:31
6newsfeed.neva.ru 149 15505 1221 9093 5191 7%89:16:12
7news-out.aioe.org 2 15043 1017 13987 39 6%22:56:18
8news.albasani.net 1 18489 769 17373 347 4%23:27:19
9feeder.eternal-september.org 9 6152 554 5204 394 9%08:32:48
10agency-nz-out.news.mb-net.net 21 19155 158 18817 180 0%29:20:20
11news.swapon.de 11 1348 142 1196 10 10%24:48:30
12feeder.awxg.com 1 15697 134 15506 57 0%23:59:56
13news.samoylyk.net 5 20691 64 20110 517 0%17:41:33
14news.freedyn.net 1 9889 15 9857 17 0%12:18:19
15news.ausics.org 1 67736 13 67716 7 0%89:59:08
16localhost 10 9 4 0 5 44%00:00:00
TOTAL: 16 275 275000 16724 249315 8961 6%493:21:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org13.9 MB224.4 KB1.4 MB15.5 MB 89%3.6 KB
2news-out.mixmin.net13.1 MB314.8 KB2.4 MB15.9 MB 82%3.0 KB
3newsfeed.datemas.de10.0 MB1.3 MB2.6 MB13.9 MB 72%7.3 KB
4news.albasani.net4.7 MB1.4 MB2.1 MB8.2 MB 57%7.5 KB
5csiph.com4.4 MB151.5 KB233.2 KB4.8 MB 92%3.1 KB
6newsfeed.neva.ru3.5 MB378.4 KB28.4 MB32.2 MB 10%5.1 KB
7news.redatomik.org3.1 MB1.2 MB1.7 MB6.0 MB 52%3.8 KB
8news-out.aioe.org2.3 MB107.9 KB140.0 KB2.6 MB 90%2.5 KB
9feeder.eternal-september.org2.0 MB200.6 KB1.2 MB3.3 MB 58%3.6 KB
10agency-nz-out.news.mb-net.net886.2 KB394.2 KB2.0 MB3.3 MB 26%9.9 KB
11feeder.awxg.com416.4 KB205.9 KB271.9 KB894.1 KB 46%4.7 KB
12news.swapon.de380.3 KB19.1 KB184.8 KB584.3 KB 65%3.8 KB
13news.samoylyk.net210.2 KB246.2 KB13.9 MB14.4 MB 1%25.3 KB
14news.freedyn.net128.3 KB129.9 KB145.5 KB403.6 KB 31%12.6 KB
15news.ausics.org26.0 KB68.9 KB73.2 KB168.0 KB 15%8.4 KB
16localhost7.7 KB0.0 KB10.8 KB18.6 KB 41%2.1 KB
TOTAL: 1659.0 MB6.2 MB56.8 MB122.0 MB 48%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 24 23:58:01 - 23:59:59 19 0.1% 0.1655.2 KB 0.1% 0.46
Nov 25 00:00:00 - 00:59:59 891 5.3% 0.252.4 MB 4.0% 0.69
Nov 25 01:00:00 - 01:59:59 818 4.9% 0.233.0 MB 5.1% 0.86
Nov 25 02:00:00 - 02:59:59 978 5.8% 0.272.6 MB 4.3% 0.73
Nov 25 03:00:00 - 03:59:59 1087 6.5% 0.303.5 MB 5.8% 0.99
Nov 25 04:00:00 - 04:59:59 1090 6.5% 0.303.3 MB 5.4% 0.93
Nov 25 05:00:00 - 05:59:59 960 5.7% 0.274.1 MB 6.8% 1.16
Nov 25 06:00:00 - 06:59:59 950 5.7% 0.262.5 MB 4.1% 0.71
Nov 25 07:00:00 - 07:59:59 942 5.6% 0.263.4 MB 5.6% 0.95
Nov 25 08:00:00 - 08:59:59 913 5.5% 0.254.2 MB 7.0% 1.19
Nov 25 09:00:00 - 09:59:59 890 5.3% 0.252.7 MB 4.4% 0.76
Nov 25 10:00:00 - 10:59:59 909 5.4% 0.253.8 MB 6.4% 1.09
Nov 25 11:00:00 - 11:59:59 700 4.2% 0.192.8 MB 4.6% 0.79
Nov 25 12:00:00 - 12:59:59 622 3.7% 0.172.7 MB 4.4% 0.76
Nov 25 13:00:00 - 13:59:59 470 2.8% 0.131.7 MB 2.8% 0.47
Nov 25 14:00:00 - 14:59:59 330 2.0% 0.091.3 MB 2.1% 0.37
Nov 25 15:00:00 - 15:59:59 371 2.2% 0.101.6 MB 2.6% 0.44
Nov 25 16:00:00 - 16:59:59 416 2.5% 0.122.2 MB 3.7% 0.62
Nov 25 17:00:00 - 17:59:59 358 2.1% 0.101.7 MB 2.8% 0.47
Nov 25 18:00:00 - 18:59:59 288 1.7% 0.081.9 MB 3.2% 0.55
Nov 25 19:00:00 - 19:59:59 316 1.9% 0.091.1 MB 1.9% 0.32
Nov 25 20:00:00 - 20:59:59 467 2.8% 0.131.6 MB 2.7% 0.45
Nov 25 21:00:00 - 21:59:59 567 3.4% 0.161.8 MB 2.9% 0.50
Nov 25 22:00:00 - 22:59:59 712 4.3% 0.202.1 MB 3.5% 0.60
Nov 25 23:00:00 - 23:58:02 656 3.9% 0.192.2 MB 3.7% 0.65
TOTAL: 24:00:01 16720 100.0% 0.1959.9 MB 100.0% 0.71
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB21.7 GB 43.5% 0 0.26 2333.88
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.2 GB 50.4% 0 0.34 1764.51
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB271.6 MB 0.5% 0 0.0417009.75
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 GB12.2 GB 24.5% 0 0.56 1075.16
TOTAL: 10-500.0 GB59.4 GB 11.9% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5152 84 0 67 1 0 0 0 5000
2news-out.mixmin.net 1309 0 0 73 0 0 0 0 1236
3newsfeed.datemas.de 540 163 0 65 0 0 0 0 312
4news.samoylyk.net 497 0 0 55 0 0 0 0 442
5news.redatomik.org 453 0 0 50 0 0 0 0 403
6news.albasani.net 426 3 0 65 0 0 0 0 358
7feeder.eternal-september.org 373 0 0 32 0 0 0 0 341
8news.snarked.org 322 13 0 68 0 0 0 0 241
9agency-nz-out.news.mb-net.net 183 30 0 66 3 0 0 0 84
10news.freedyn.net 80 9 0 33 0 0 0 0 38
11news-out.aioe.org 52 2 0 32 0 0 0 0 18
12news.swapon.de 46 0 0 2 0 0 0 0 44
13feeder.awxg.com 44 2 0 37 0 0 0 0 5
14csiph.com 41 0 0 25 0 0 0 0 16
15localhost 5 0 0 0 0 0 0 0 5
TOTAL: 15 9523 306 0 670 4 0 0 0 8543

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 61
gmane.linux.alsa.devel 48
mpc.lists.freebsd.ports.bugs 32
it.annunci.immobiliari 29
it.annunci.commerciali 28
it.annunci.varie 27
mozilla.dev.security.policy 16
mozilla.test 7
mozilla.dev.platform 6
mozilla.support.seamonkey 5
talk.wieslauf.points 5
gmane.comp.gis.openstreetmap.tagging 4
mpc.lists.freebsd.geom 3
mozilla.dev.ui-alerts 3
mindspring.discussion 2
gmane.linux.ports.arm.msm 2
msn.forums.gardening.pests 2
msn.forums.homeandgarden.gardening.landscape 2
gmane.linux.alsa.user 2
gmane.linux.kernel 2
TOTAL: 40 306

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

GroupsCount
nz.politics.announce 3
linux.debian.user 1
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6629
EMP (phn path) 469
Binary: misplaced rar 440
EMP (phn nph) 317
EMP (phl) 46
Too many newsgroups 41
User-issued cancel 13
Binary: misplaced par2 6
Too many newsgroups (low_xpost) 6
Binary: non-binary distribution 6
User-issued spam cancel 6
HTML post 4
Binary Image: misplaced jpg 3
Too many newsgroups (meow) 1
TOTAL: 14 7987

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 222
news.redatomik.org 188
news.albasani.net 43
news.swapon.de 40
newsfeed.datemas.de 38
news-out.aioe.org 10
news.snarked.org 9
newsfeed.neva.ru 4
feeder.awxg.com 1
agency-nz-out.news.mb-net.net 1
TOTAL: 10 556
TOTAL: 1 556

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14964 902 13952 110 0 0 6%23:59:44
2awxg 16253 87 16155 4 0 10 0%23:59:50
3news.redatomik.org 15373 5 15344 0 0 8 0%23:59:50
4csiph.com 15364 5 15302 0 0 0 0%23:59:50
5neva.ru 15270 5 15252 0 0 0 0%23:59:50
6news.freedyn.net 16868 5 16633 0 0 1 0%23:59:50
7news.snarked.org 12441 5 12344 9 0 30 0%23:59:47
8news.samoylyk.net 14924 4 14897 0 0 154 0%23:59:49
9aioe 13921 4 13859 0 0 0 0%23:59:50
10eternal-september 4137 4 3843 4 0 12329 0%23:59:50
11mb-net.net 16536 4 16510 0 0 1 0%23:59:40
12news-in.mixmin.net 12061 4 12043 0 0 0 0%23:59:50
13newsfeed.datemas.de 15177 3 15146 0 0 61 0%23:59:50
14news.albasani.net 16997 1 14560 811 0 5386 0%23:59:50
15news.swapon.de 1153 0 1153 0 0 0 0%23:10:34
TOTAL: 15 201439 1038 196993 938 0 17980 0%359:07:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.8 MB8.6 MB12.4 MB0.1 KB/s12.5 KB23:59:44
2awxg418.1 KB20.6 KB438.7 KB0.0 KB/s4.8 KB23:59:50
3news.freedyn.net12.7 KB0.0 KB12.7 KB0.0 KB/s2.5 KB23:59:50
4news.snarked.org11.2 KB27.6 KB38.8 KB0.0 KB/s2.8 KB23:59:47
5csiph.com9.9 KB0.0 KB9.9 KB0.0 KB/s2.0 KB23:59:50
6neva.ru9.2 KB0.0 KB9.2 KB0.0 KB/s1.8 KB23:59:50
7news.redatomik.org9.1 KB0.0 KB9.1 KB0.0 KB/s1.8 KB23:59:50
8news.samoylyk.net7.7 KB0.0 KB7.7 KB0.0 KB/s1.9 KB23:59:49
9aioe7.7 KB0.0 KB7.7 KB0.0 KB/s1.9 KB23:59:50
10mb-net.net7.7 KB0.0 KB7.7 KB0.0 KB/s1.9 KB23:59:40
11news-in.mixmin.net7.7 KB0.0 KB7.7 KB0.0 KB/s1.9 KB23:59:50
12eternal-september7.5 KB8.0 KB15.5 KB0.0 KB/s1.9 KB23:59:50
13newsfeed.datemas.de5.5 KB0.0 KB5.5 KB0.0 KB/s1.8 KB23:59:50
14news.albasani.net1.1 KB2.9 MB2.9 MB0.0 KB/s3.7 KB23:59:50
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:10:34
TOTAL: 154.3 MB11.6 MB15.9 MB0.0 KB/s8.2 KB359:07:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 5 558219.9 MB 641 3 2001:33:55
2agency.bbs.geek.nz 385 544122.5 MB 3350 1 000:13:58
3vorlon.activateit.net.au 24 7821.2 MB 143 0 000:04:16
4163.47.16.169 14 534824.3 KB 87 0 000:02:41
560.234.244.55 5 22.5 KB 1 0 000:15:58
TOTAL: 5 433 1234144.3 MB 4222 4 2015:00:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 8 558219.9 MB 641 3 2013:57:38
2*.bbs.geek.nz 385 544122.5 MB 3350 1 000:13:58
3*.activateit.net.au 24 7821.2 MB 143 0 000:04:16
4unresolved 25 536826.9 KB 88 0 000:44:10
TOTAL: 4 442 1234144.3 MB 4222 4 2015:00:05

NNRP auth users [Top 20]:

UserConn
amybbs 38
bpanther 5
crash 5
malcolmlewis 3
TOTAL: 4 51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.188 0.072 0.00712:23:42
67-61-21-181.cpe.cableone.net 0.940 0.848 0.01501:33:55
118.149.139.214 0.228 0.048 0.00000:20:17
60.234.244.55 0.312 0.052 0.01500:15:58
agency.bbs.geek.nz 27.800 6.828 0.00000:13:58
118.149.128.77 0.060 0.008 0.00000:05:02
vorlon.activateit.net.au 1.328 0.408 0.06800:04:16
163.47.16.169 0.804 0.208 0.12900:02:41
104.236.159.134 0.048 0.008 0.00000:00:09
? 1.372 0.208 0.00000:00:02
TOTAL: 10 33.080 8.688 0.23415:00:05

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.139.214 4
67-60-219-146.cpe.cableone.net 3
104.236.159.134 1
118.149.128.77 1
TOTAL: 4 9

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 4198 34.0%
2alt 1290 10.5%
3soc 1254 10.2%
4comp 1134 9.2%
5linux 1123 9.1%
6sci 1076 8.7%
7uk 883 7.2%
8talk 819 6.6%
9misc 269 2.2%
10news 147 1.2%
11mozilla 70 0.6%
12microsoft 21 0.2%
13aus 20 0.2%
14nz 18 0.1%
15humanities 11 0.1%
16eternal-september 4 0.0%
17us 2 0.0%
18agency 1 0.0%
TOTAL: 18 12340100.0%

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

NewsgroupCount
1rec.arts.tv 895
2rec.arts.drwho 549
3talk.origins 396
4linux.debian.bugs.dist 363
5rec.arts.sf.written 335
6alt.atheism 327
7sci.math 324
8rec.food.cooking 321
9comp.lang.python 318
10linux.debian.changes.devel 302
11uk.d-i-y 284
12soc.culture.israel 281
13comp.lang.c 270
14uk.legal 233
15talk.politics.guns 229
16soc.retirement 224
17alt.fan.rush-limbaugh 214
18uk.radio.amateur 198
19sci.physics 192
20rec.sport.tennis 186
21talk.politics.misc 179
22misc.survivalism 165
23soc.culture.polish 153
24alt.test 131
25sci.physics.relativity 130
26rec.sport.football.college 128
27alt.politics 115
28rec.arts.sf.tv 114
29news.lists.filters 114
30rec.boats 111
31sci.logic 104
32rec.sport.pro-wrestling 103
33rec.arts.movies.past-films 98
34linux.debian.bugs.rc 95
35sci.electronics.design 90
36rec.radio.shortwave 88
37rec.photo.digital 84
38alt.comp.os.windows-10 79
39soc.culture.china 78
40rec.games.pinball 75
41soc.culture.singapore 71
42uk.tech.digital-tv 67
43soc.culture.usa 66
44comp.lang.c++ 65
45rec.sport.soccer 63
46rec.aviation.soaring 63
47linux.debian.devel.release 61
48alt.conspiracy 60
49soc.culture.indian 60
50alt.politics.trump 59
51rec.music.classical.recordings 59
52comp.sys.mac.advocacy 58
53comp.mobile.android 58
54linux.debian.user 57
55uk.legal.moderated 56
56rec.crafts.metalworking 56
57rec.gambling.poker 54
58sci.military.naval 53
59rec.woodworking 50
60rec.arts.sf.fandom 50
61rec.aviation.marketplace 50
62rec.aquaria.marine.misc 50
63misc.phone.mobile.iphone 46
64soc.culture.vietnamese 44
65rec.music.dylan 44
66rec.arts.tv.uk.coronation-st 42
67rec.drugs.cannabis 41
68linux.gentoo.user 35
69sci.med.cardiology 34
70linux.gentoo.dev 34
71soc.culture.greek 34
72rec.music.rock-pop-r+b.1950s 34
73rec.audio.opinion 32
74mozilla.support.thunderbird 31
75sci.med.pharmacy 31
76rec.sport.golf 30
77soc.penpals 30
78rec.outdoors.rv-travel 30
79linux.debian.maint.boot 29
80rec.radio.amateur.misc 29
81mozilla.general 29
82alt.bible 29
83news.admin.net-abuse.email 28
84soc.genealogy.medieval 28
85alt.conspiracy.jfk 28
86rec.sport.cricket 27
87alt.support.diabetes 27
88alt.recovery.aa 26
89comp.lang.ada 26
90alt.games.warcraft 26
91alt.astronomy 24
92alt.bbs 23
93uk.comp.sys.mac 23
94rec.radio.amateur.dx 21
95comp.lang.idl-pvwave 21
96comp.sys.apple2 21
97sci.lang 20
98soc.culture.netherlands 20
99rec.arts.movies.current-films 19
100aus.computers 19
TOTAL: 358 12340