news.bbs.geek.nz daily logs

Dec 12 23:58:01 -- Dec 13 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 147741 62.6%12.3 MB 42.6%
innd 34296 14.5%5.4 MB 18.7%
inn 29142 12.4%6.5 MB 22.5%
innfeed 23287 9.9%4.4 MB 15.3%
cnfsstat 1440 0.6%255.2 KB 0.9%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 235907 100.0%28.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 290190 49.5%
Positive hits 268243 45.8%
Do not exist 27199 4.6%
Cache misses 267 0.0%
TOTAL: 4 585899 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.467 0.0%172 0.000 2.715 22.357
article cleanup00:00:00.302 0.0%28325 0.000 0.011 0.042
article logging00:00:00.704 0.0%28882 0.000 0.024 0.132
article parse00:00:00.818 0.0%63886 0.000 0.013 0.030
article write00:00:05.236 0.0%21083 0.012 0.248 28.736
artlog/artcncl00:00:00.000 0.0%168 0.000 0.000 0.000
data move00:00:00.505 0.0%555523 0.000 0.001 0.010
hisgrep/artcncl00:00:00.162 0.0%171 0.000 0.947 11.286
hishave/artcncl00:00:00.127 0.0%172 0.000 0.738 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.340 0.0%591525 0.001 0.011 0.844
history sync00:00:00.011 0.0%370 0.000 0.030 0.500
history write00:00:05.608 0.0%27434 0.015 0.204 12.619
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:47.720 99.8%570209 87.643 151.291 446.567
nntp read00:00:03.303 0.0%571501 0.002 0.006 0.019
overview write00:00:45.219 0.1%21083 0.073 2.145 142.296
perl filter00:00:50.741 0.1%27434 1.406 1.850 22.129
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.334 0.0%42166 0.003 0.032 0.139
TOTAL: 24:00:51.12623:59:48.597 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.088 0.0%28576 0.000 0.003 0.020
article prepare00:00:00.002 0.0%10252 0.000 0.000 0.021
article read00:00:00.267 0.0%1976 0.000 0.135 4.846
backlog stats00:00:00.309 0.0%334989 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.643 0.0%280951 0.001 0.006 0.011
data write00:00:03.084 0.0%265351 0.005 0.012 0.022
idle23:52:56.430100.0%334989 156.674 256.654 650.793
status file00:00:07.359 0.0%1911 0.800 3.851 139.143
TOTAL: 23:53:25.32323:53:09.182100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:48:56.785 97.7%175302 0.000 468.544 40415.864
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:42.451 0.1%366841 0.000 0.116 2.628
readart00:00:02.546 0.0%16792 0.000 0.152 13.500
TOTAL: 23:20:59.13822:49:41.782 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 17291 5804 11097 390 33%48:19:05
2news-out.mixmin.net 9 22403 3884 17449 1070 17%26:31:04
3newsfeed.datemas.de 3 22460 3359 18487 614 14%25:19:32
4feeder.eternal-september.org 23 26354 2394 22372 1588 9%29:55:02
5news.redatomik.org 1 21922 1731 20126 65 7%26:33:02
6newsfeed.neva.ru 154 14225 1266 10515 2444 8%90:24:43
7csiph.com 2 19369 985 18333 51 5%22:40:34
8news-out.aioe.org 3 21114 965 20082 67 4%24:29:09
9news.freedyn.net 3 22867 193 22441 233 0%23:58:45
10news.swapon.de 6 1640 172 1465 3 10%22:56:44
11news.albasani.net 2 23452 162 23129 161 0%25:23:18
12news.samoylyk.net 3 26043 136 25470 437 0%25:06:27
13agency-nz-out.news.mb-net.net 26 22817 101 22566 150 0%33:35:03
14feeder.awxg.com 2 18237 99 18092 46 0%23:59:56
15localhost 1107 1106 48 1058 0 4%00:00:00
TOTAL: 15 1395 281300 21299 252682 7319 7%449:12:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org18.9 MB272.0 KB1.3 MB20.5 MB 92%3.4 KB
2newsfeed.datemas.de13.1 MB213.4 KB2.1 MB15.4 MB 84%4.0 KB
3news-out.mixmin.net10.8 MB222.3 KB2.6 MB13.7 MB 79%2.8 KB
4feeder.eternal-september.org6.8 MB318.7 KB3.9 MB11.1 MB 61%2.8 KB
5news.redatomik.org3.8 MB225.2 KB231.9 KB4.3 MB 89%2.4 KB
6newsfeed.neva.ru3.0 MB246.8 KB7.0 MB10.3 MB 29%2.8 KB
7csiph.com2.7 MB153.7 KB166.4 KB3.0 MB 89%3.0 KB
8news-out.aioe.org2.2 MB149.7 KB187.4 KB2.6 MB 87%2.5 KB
9news.freedyn.net1.1 MB169.5 KB927.3 KB2.2 MB 50%5.2 KB
10news.albasani.net656.0 KB275.2 KB442.7 KB1.3 MB 47%4.3 KB
11news.swapon.de523.3 KB2.1 KB6.2 KB531.6 KB 98%3.0 KB
12news.samoylyk.net513.1 KB240.4 KB4.2 MB4.9 MB 10%8.8 KB
13feeder.awxg.com332.0 KB140.3 KB145.6 KB617.9 KB 53%4.3 KB
14agency-nz-out.news.mb-net.net226.3 KB225.3 KB753.2 KB1.2 MB 18%4.8 KB
15localhost84.5 KB0.0 KB0.0 KB84.5 KB100%1.8 KB
TOTAL: 1564.8 MB2.8 MB24.0 MB91.6 MB 70%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 12 23:58:01 - 23:59:59 34 0.2% 0.2978.5 KB 0.1% 0.66
Dec 13 00:00:00 - 00:59:59 895 4.2% 0.252.5 MB 3.9% 0.70
Dec 13 01:00:00 - 01:59:59 986 4.7% 0.272.6 MB 4.1% 0.75
Dec 13 02:00:00 - 02:59:59 1072 5.1% 0.302.8 MB 4.4% 0.80
Dec 13 03:00:00 - 03:59:59 1015 4.8% 0.282.6 MB 4.1% 0.75
Dec 13 04:00:00 - 04:59:59 1222 5.8% 0.345.8 MB 9.0% 1.64
Dec 13 05:00:00 - 05:59:59 1228 5.8% 0.343.8 MB 5.9% 1.07
Dec 13 06:00:00 - 06:59:59 1194 5.7% 0.333.0 MB 4.6% 0.85
Dec 13 07:00:00 - 07:59:59 1276 6.1% 0.353.7 MB 5.8% 1.07
Dec 13 08:00:00 - 08:59:59 1228 5.8% 0.344.0 MB 6.3% 1.15
Dec 13 09:00:00 - 09:59:59 1162 5.5% 0.323.3 MB 5.1% 0.93
Dec 13 10:00:00 - 10:59:59 1156 5.5% 0.323.7 MB 5.8% 1.06
Dec 13 11:00:00 - 11:59:59 1082 5.1% 0.303.6 MB 5.6% 1.01
Dec 13 12:00:00 - 12:59:59 701 3.3% 0.192.4 MB 3.7% 0.68
Dec 13 13:00:00 - 13:59:59 579 2.7% 0.162.4 MB 3.7% 0.67
Dec 13 14:00:00 - 14:59:59 524 2.5% 0.151.7 MB 2.7% 0.49
Dec 13 15:00:00 - 15:59:59 424 2.0% 0.121.2 MB 1.8% 0.34
Dec 13 16:00:00 - 16:59:59 486 2.3% 0.141.3 MB 2.1% 0.38
Dec 13 17:00:00 - 17:59:59 484 2.3% 0.131.4 MB 2.1% 0.39
Dec 13 18:00:00 - 18:59:59 522 2.5% 0.141.8 MB 2.7% 0.50
Dec 13 19:00:00 - 19:59:59 487 2.3% 0.141.4 MB 2.2% 0.40
Dec 13 20:00:00 - 20:59:59 672 3.2% 0.191.9 MB 3.0% 0.54
Dec 13 21:00:00 - 21:59:59 818 3.9% 0.232.2 MB 3.4% 0.62
Dec 13 22:00:00 - 22:59:59 890 4.2% 0.252.3 MB 3.6% 0.66
Dec 13 23:00:00 - 23:58:01 949 4.5% 0.272.7 MB 4.1% 0.78
TOTAL: 24:00:00 21086 100.0% 0.2464.1 MB 100.0% 0.76
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.1 GB 44.3% 0 0.29 2091.60
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.7 GB 51.4% 0 0.32 1922.77
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB276.4 MB 0.5% 0 0.0322939.07
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 GB13.3 GB 26.5% 0 0.68 894.33
TOTAL: 10-500.0 GB61.4 GB 12.3% 1 0.41-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2465 51 0 82 0 0 0 0 2332
2feeder.eternal-september.org 1565 0 0 97 0 0 0 0 1468
3news-out.mixmin.net 1258 0 0 77 0 0 0 0 1181
4newsfeed.datemas.de 736 192 0 70 0 0 0 0 474
5news.samoylyk.net 466 0 0 87 0 0 0 0 379
6news.snarked.org 387 53 0 75 0 0 0 0 259
7news.redatomik.org 222 0 0 55 0 0 0 0 167
8news.freedyn.net 222 12 0 55 0 0 0 0 155
9agency-nz-out.news.mb-net.net 171 33 0 71 3 0 0 0 64
10news.albasani.net 162 1 0 73 0 0 0 0 88
11news-out.aioe.org 78 4 0 51 0 0 0 0 23
12news.swapon.de 60 0 0 2 0 0 0 0 58
13csiph.com 51 0 0 50 0 0 0 0 1
14feeder.awxg.com 44 0 0 42 0 0 0 0 2
15news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 15 7888 346 0 888 3 0 0 0 6651

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 42
it.annunci.immobiliari 42
it.annunci.commerciali 41
it.annunci.varie 39
mozilla.dev.security.policy 24
gmane.linux.kernel 21
mozilla.dev.l10n 17
mozilla.support.seamonkey 14
mpc.lists.freebsd.office 11
mpc.lists.nanog 10
mozilla.dev.ui-alerts 7
mpc.lists.freebsd.x11 6
mozilla.dev.media 6
mpc.lists.freebsd.gnome 5
mpc.lists.freebsd.geom 4
gmane.linux.drivers.devicetree 4
mozilla.dev.security 4
mozilla.dev.platform 3
gmane.comp.gis.openstreetmap.imports 3
mozilla.support.bugzilla 2
TOTAL: 54 346

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

GroupsCount
nz.politics.announce 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5084
EMP (phn path) 431
EMP (phn nph) 333
Binary: non-binary distribution 90
Too many newsgroups 45
User-issued cancel 33
Binary: misplaced rar 28
Too many newsgroups (meow) 10
Binary: misplaced PAR2 9
HTML post 8
Too many newsgroups (low_xpost) 6
Binary: misplaced asc 6
Binary: misplaced par2 4
Cancel for rejected article 2
Binary Image: misplaced png 1
Binary: misplaced 006 1
Binary: misplaced 081 1
Binary: misplaced 172 1
Binary Image: misplaced jpg 1
Binary: misplaced 003 1
TOTAL: 21 6096

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 195
news.redatomik.org 164
newsfeed.datemas.de 117
news.swapon.de 56
news-out.aioe.org 9
news.albasani.net 4
agency-nz-out.news.mb-net.net 3
newsfeed.neva.ru 3
news.samoylyk.net 3
feeder.awxg.com 1
TOTAL: 10 555
TOTAL: 1 555

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19501 847 18580 74 0 0 4%23:59:48
2awxg 20716 114 20578 6 0 12 0%23:59:41
3csiph.com 20258 48 20031 0 0 7 0%23:59:44
4news.freedyn.net 20961 37 20851 1 0 7 0%23:59:48
5aioe 18134 34 17996 0 0 5 0%23:59:42
6news.snarked.org 15530 32 15033 27 0 56 0%23:59:48
7news.redatomik.org 19374 29 19310 1 0 7 0%23:59:44
8news.samoylyk.net 19527 29 19346 2 0 66 0%23:59:47
9news-in.mixmin.net 16602 28 16518 0 0 113 0%23:59:48
10neva.ru 19433 27 19383 21 0 0 0%23:59:47
11mb-net.net 21049 21 20926 8 0 25 0%23:59:48
12eternal-september 18302 8 18184 0 0 350 0%23:59:48
13news.albasani.net 22005 7 19187 997 0 6344 0%23:59:48
14newsfeed.datemas.de 17907 7 17706 0 0 506 0%23:59:48
15news.swapon.de 1604 6 1560 0 0 50 0%23:28:03
TOTAL: 15 270903 1274 265189 1137 0 7548 0%359:24:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.7 MB4.0 MB7.7 MB0.1 KB/s8.5 KB23:59:48
2awxg337.1 KB22.8 KB359.9 KB0.0 KB/s3.0 KB23:59:41
3csiph.com84.6 KB0.0 KB84.6 KB0.0 KB/s1.8 KB23:59:44
4news.freedyn.net68.2 KB1.6 KB69.7 KB0.0 KB/s1.8 KB23:59:48
5news.snarked.org60.4 KB271.3 KB331.8 KB0.0 KB/s5.6 KB23:59:48
6aioe60.4 KB0.0 KB60.4 KB0.0 KB/s1.8 KB23:59:42
7news.redatomik.org51.4 KB7.4 KB58.8 KB0.0 KB/s2.0 KB23:59:44
8news.samoylyk.net51.4 KB5.2 KB56.6 KB0.0 KB/s1.8 KB23:59:47
9news-in.mixmin.net49.3 KB0.0 KB49.3 KB0.0 KB/s1.8 KB23:59:48
10neva.ru45.2 KB39.4 KB84.6 KB0.0 KB/s1.8 KB23:59:47
11mb-net.net38.5 KB12.9 KB51.4 KB0.0 KB/s1.8 KB23:59:48
12eternal-september12.1 KB0.0 KB12.1 KB0.0 KB/s1.5 KB23:59:48
13news.swapon.de11.4 KB0.0 KB11.4 KB0.0 KB/s1.9 KB23:28:03
14newsfeed.datemas.de8.6 KB0.0 KB8.6 KB0.0 KB/s1.2 KB23:59:48
15news.albasani.net8.3 KB3.0 MB3.0 MB0.0 KB/s3.1 KB23:59:48
TOTAL: 154.6 MB7.3 MB11.9 MB0.0 KB/s5.0 KB359:24:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 785325.4 MB 1223 0 1602:19:49
2agency.bbs.geek.nz 406 723123.8 MB 4001 49220800:16:48
3vorlon.activateit.net.au 24 9721.3 MB 143 0 000:04:46
467-60-219-146.cpe.cableone.net 8 611.7 KB 1 0 020:09:26
TOTAL: 4 446 1606250.5 MB 5368 49222423:20:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 16 785925.4 MB 1224 0 1622:29:15
2*.bbs.geek.nz 406 723123.8 MB 4001 49220800:16:48
3*.activateit.net.au 24 9721.3 MB 143 0 000:04:46
4unresolved 8 00.0 KB 0 0 000:29:58
TOTAL: 4 454 1606250.5 MB 5368 49222423:20:52

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 8
bpanther 8
TOTAL: 3 40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.500 0.148 0.02320:09:26
67-61-21-181.cpe.cableone.net 1.656 1.100 0.05202:19:49
118.149.177.80 0.308 0.044 0.00000:18:17
agency.bbs.geek.nz 30.304 7.324 0.00000:16:48
118.149.217.86 0.116 0.024 0.00000:06:39
118.149.234.68 0.072 0.000 0.00000:05:01
vorlon.activateit.net.au 1.428 0.336 0.14500:04:46
? 1.244 0.172 0.00000:00:02
TOTAL: 8 35.628 9.148 0.22023:20:52

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.177.80 5
118.149.217.86 2
118.149.234.68 1
TOTAL: 3 8

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 5569 34.7%
2soc 1790 11.1%
3alt 1757 10.9%
4comp 1711 10.7%
5uk 1379 8.6%
6sci 1343 8.4%
7linux 1129 7.0%
8talk 767 4.8%
9misc 268 1.7%
10news 152 0.9%
11mozilla 92 0.6%
12nz 50 0.3%
13microsoft 29 0.2%
14humanities 8 0.0%
15us 6 0.0%
16eternal-september 5 0.0%
17aus 2 0.0%
TOTAL: 17 16057100.0%

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

NewsgroupCount
1rec.arts.tv 1020
2rec.food.cooking 531
3linux.debian.bugs.dist 478
4uk.d-i-y 471
5alt.fan.rush-limbaugh 457
6rec.arts.drwho 448
7soc.retirement 358
8rec.arts.sf.written 346
9uk.radio.amateur 331
10soc.culture.israel 330
11sci.physics 323
12comp.os.linux.advocacy 314
13uk.legal 306
14alt.atheism 303
15rec.gambling.poker 295
16rec.sport.football.college 283
17rec.boats 277
18comp.lang.python 270
19talk.origins 270
20rec.sport.tennis 260
21talk.politics.misc 225
22comp.lang.c 224
23talk.politics.guns 223
24rec.sport.pro-wrestling 215
25alt.comp.os.windows-10 212
26sci.math 211
27linux.debian.changes.devel 184
28sci.electronics.design 170
29soc.culture.polish 167
30alt.politics.trump 153
31linux.debian.bugs.rc 136
32sci.logic 132
33soc.culture.china 130
34news.lists.filters 130
35rec.outdoors.rv-travel 120
36soc.culture.indian 120
37alt.conspiracy.jfk 119
38misc.survivalism 118
39soc.culture.usa 103
40comp.lang.forth 101
41alt.politics 98
42rec.music.classical.recordings 97
43rec.skiing.alpine 93
44rec.sport.soccer 88
45rec.arts.movies.current-films 87
46uk.tech.digital-tv 83
47rec.aquaria.marine.misc 80
48rec.aviation.marketplace 80
49rec.bicycles.tech 79
50rec.music.rock-pop-r+b.1950s 76
51sci.med.cardiology 76
52sci.physics.relativity 73
53soc.culture.singapore 68
54comp.sys.mac.apps 66
55soc.penpals 64
56rec.drugs.cannabis 62
57alt.test 61
58sci.military.naval 60
59alt.bible 58
60rec.radio.shortwave 57
61rec.sport.golf 57
62linux.debian.user 57
63soc.culture.vietnamese 56
64comp.mobile.android 56
65rec.aviation.soaring 55
66rec.arts.sf.tv 55
67rec.arts.sf.fandom 52
68sci.electronics.repair 51
69soc.history.what-if 50
70misc.phone.mobile.iphone 49
71alt.support.diabetes 49
72soc.culture.greek 48
73comp.sys.apple2 48
74uk.rec.driving 48
75comp.sys.mac.advocacy 47
76uk.legal.moderated 46
77sci.med.pharmacy 46
78nz.general 44
79mozilla.support.firefox 43
80alt.recovery.aa 43
81rec.arts.comics.strips 40
82comp.lang.java.programmer 39
83rec.autos.tech 39
84comp.lang.idl-pvwave 39
85rec.crafts.metalworking 38
86rec.photo.digital 38
87misc.health.diabetes 38
88sci.lang 38
89comp.sys.mac.system 37
90comp.arch 37
91comp.lang.c++ 36
92sci.space.policy 36
93comp.lang.fortran 35
94rec.games.pinball 34
95comp.lang.ada 34
96soc.culture.brazil 34
97rec.woodworking 34
98linux.gentoo.user 33
99comp.lang.tcl 32
100alt.bbs.mystic 31
TOTAL: 375 16057