news.bbs.geek.nz daily logs

Jan 29 23:58:02 -- Jan 30 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135867 61.0%11.3 MB 40.3%
innd 31783 14.3%5.1 MB 18.4%
inn 30490 13.7%6.8 MB 24.3%
innfeed 23150 10.4%4.5 MB 16.2%
cnfsstat 1440 0.6%254.4 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 222731 100.0%28.0 MB100.0%

History cache:

ReasonCount%Count
Negative hits 302534 49.7%
Positive hits 278007 45.6%
Do not exist 28540 4.7%
Cache misses 139 0.0%
TOTAL: 4 609220 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.264 0.0%94 0.000 2.809 38.667
article cleanup00:00:00.257 0.0%29801 0.000 0.009 0.030
article logging00:00:00.784 0.0%30383 0.000 0.026 0.142
article parse00:00:00.896 0.0%74660 0.000 0.012 0.036
article write00:00:01.661 0.0%22055 0.015 0.075 0.511
artlog/artcncl00:00:00.000 0.0%94 0.000 0.000 0.000
data move00:00:00.372 0.0%584734 0.000 0.001 0.009
hisgrep/artcncl00:00:00.050 0.0%82 0.000 0.610 16.000
hishave/artcncl00:00:00.029 0.0%94 0.000 0.309 9.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.838 0.0%614984 0.000 0.016 1.001
history sync00:00:00.016 0.0%374 0.000 0.043 0.667
history write00:00:08.031 0.0%28760 0.012 0.279 16.066
hiswrite/artcncl00:00:00.002 0.0%12 0.000 0.167 0.500
idle23:57:48.893 99.8%600522 75.657 143.657 371.301
nntp read00:00:03.335 0.0%601830 0.002 0.006 0.016
overview write00:00:42.030 0.0%22055 0.060 1.906 57.123
perl filter00:00:54.415 0.1%28756 1.355 1.892 4.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.536 0.0%44110 0.003 0.035 0.101
TOTAL: 24:00:56.26723:59:52.409 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.064 0.0%28599 0.000 0.002 0.013
article prepare00:00:00.004 0.0%9612 0.000 0.000 0.011
article read00:00:00.255 0.0%2081 0.000 0.123 4.542
backlog stats00:00:00.287 0.0%350063 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.776 0.0%294774 0.000 0.006 0.010
data write00:00:03.184 0.0%277282 0.005 0.011 0.022
idle23:53:59.691100.0%350063 147.513 245.783 561.548
status file00:00:13.865 0.0%1860 0.600 7.454 316.114
TOTAL: 23:54:37.29123:54:19.126100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle25:20:15.604 97.8%152739 0.000 597.199 85906.190
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:19.306 0.0%341082 0.000 0.057 2.667
readart00:00:13.643 0.0%16946 0.000 0.805 18.329
TOTAL: 25:54:03.44825:20:48.553 97.9%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 48 20890 5900 14469 521 28%44:30:18
2news-out.mixmin.net 14 24336 4015 19387 934 16%28:41:52
3news-out.aioe.org 3 21050 3483 17386 181 16%23:06:11
4feeder.eternal-september.org 88 27142 2529 22788 1825 9%55:29:44
5newsfeed.datemas.de 3 22847 1483 20835 529 6%23:22:43
6newsfeed.neva.ru 160 14979 1461 10823 2695 9%88:20:37
7csiph.com 3 23445 1408 21957 80 6%25:50:12
8news.albasani.net 1 21939 775 20883 281 3%22:21:40
9news.redatomik.org 4 22217 475 21562 180 2%25:23:35
10news.swapon.de 4 1814 201 1602 11 11%23:38:44
11news.freedyn.net 3 20942 143 20654 145 0%17:47:09
12news.samoylyk.net 4 20985 119 20804 62 0%25:06:10
13feeder.awxg.com 2 18808 116 18626 66 0%23:59:26
14agency-nz-out.news.mb-net.net 19 23346 90 23141 115 0%31:11:32
15localhost 7 6 5 0 1 83%00:00:00
16news.ausics.org 4 34144 1 34138 5 0%33:28:32
TOTAL: 16 367 318890 22204 289055 7631 6%492:18:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.7 MB311.1 KB3.2 MB25.2 MB 85%4.0 KB
2news-out.mixmin.net11.8 MB527.4 KB2.2 MB14.5 MB 81%3.0 KB
3feeder.eternal-september.org9.1 MB478.1 KB6.9 MB16.5 MB 55%3.9 KB
4news-out.aioe.org8.7 MB215.4 KB453.1 KB9.3 MB 93%2.6 KB
5newsfeed.datemas.de6.5 MB359.2 KB2.5 MB9.4 MB 69%4.8 KB
6news.albasani.net4.7 MB272.1 KB758.2 KB5.7 MB 82%5.5 KB
7csiph.com4.1 MB323.8 KB356.0 KB4.8 MB 86%3.3 KB
8newsfeed.neva.ru3.4 MB257.0 KB9.5 MB13.1 MB 25%3.2 KB
9news.redatomik.org1.2 MB338.8 KB520.3 KB2.0 MB 58%3.2 KB
10news.freedyn.net1.0 MB207.5 KB741.4 KB1.9 MB 52%6.9 KB
11news.samoylyk.net851.6 KB284.4 KB409.0 KB1.5 MB 55%8.5 KB
12news.swapon.de484.6 KB12.3 KB197.6 KB694.4 KB 69%3.3 KB
13agency-nz-out.news.mb-net.net484.3 KB324.1 KB527.7 KB1.3 MB 36%6.5 KB
14feeder.awxg.com397.4 KB407.2 KB450.2 KB1.2 MB 31%6.9 KB
15localhost9.8 KB0.0 KB2.2 KB12.0 KB 81%2.0 KB
16news.ausics.org2.2 KB82.9 KB84.9 KB170.1 KB 1%28.3 KB
TOTAL: 1674.3 MB4.3 MB28.8 MB107.3 MB 69%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 29 23:58:02 - 23:59:59 26 0.1% 0.2268.4 KB 0.1% 0.58
Jan 30 00:00:00 - 00:59:59 993 4.5% 0.283.4 MB 4.4% 0.96
Jan 30 01:00:00 - 01:59:59 1005 4.6% 0.283.3 MB 4.3% 0.94
Jan 30 02:00:00 - 02:59:59 1010 4.6% 0.282.6 MB 3.4% 0.73
Jan 30 03:00:00 - 03:59:59 1008 4.6% 0.283.7 MB 4.9% 1.05
Jan 30 04:00:00 - 04:59:59 1105 5.0% 0.312.9 MB 3.8% 0.82
Jan 30 05:00:00 - 05:59:59 1375 6.2% 0.385.1 MB 6.8% 1.46
Jan 30 06:00:00 - 06:59:59 1378 6.3% 0.384.8 MB 6.3% 1.37
Jan 30 07:00:00 - 07:59:59 1460 6.6% 0.414.1 MB 5.4% 1.16
Jan 30 08:00:00 - 08:59:59 1261 5.7% 0.354.0 MB 5.3% 1.15
Jan 30 09:00:00 - 09:59:59 1171 5.3% 0.333.3 MB 4.3% 0.93
Jan 30 10:00:00 - 10:59:59 1150 5.2% 0.323.5 MB 4.6% 0.98
Jan 30 11:00:00 - 11:59:59 970 4.4% 0.273.8 MB 5.0% 1.08
Jan 30 12:00:00 - 12:59:59 779 3.5% 0.223.1 MB 4.1% 0.87
Jan 30 13:00:00 - 13:59:59 662 3.0% 0.183.0 MB 3.9% 0.85
Jan 30 14:00:00 - 14:59:59 587 2.7% 0.162.5 MB 3.3% 0.71
Jan 30 15:00:00 - 15:59:59 516 2.3% 0.142.6 MB 3.5% 0.75
Jan 30 16:00:00 - 16:59:59 469 2.1% 0.132.1 MB 2.8% 0.59
Jan 30 17:00:00 - 17:59:59 467 2.1% 0.132.0 MB 2.7% 0.58
Jan 30 18:00:00 - 18:59:59 519 2.4% 0.141.8 MB 2.4% 0.51
Jan 30 19:00:00 - 19:59:59 572 2.6% 0.162.1 MB 2.8% 0.60
Jan 30 20:00:00 - 20:59:59 755 3.4% 0.212.6 MB 3.5% 0.75
Jan 30 21:00:00 - 21:59:59 976 4.4% 0.272.7 MB 3.6% 0.78
Jan 30 22:00:00 - 22:59:59 939 4.3% 0.263.4 MB 4.5% 0.97
Jan 30 23:00:00 - 23:58:01 890 4.0% 0.263.3 MB 4.3% 0.96
TOTAL: 23:59:59 22043 100.0% 0.2675.7 MB 100.0% 0.90
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.3 GB 46.6% 0 0.33 1816.32
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.0 GB 54.0% 0 0.38 1603.21
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB288.9 MB 0.6% 0 0.0317779.01
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 GB15.9 GB 31.7% 0 0.74 815.80
TOTAL: 10-500.0 GB66.5 GB 13.3% 1 0.47-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2736 73 0 60 0 0 0 0 2603
2feeder.eternal-september.org 1839 0 0 117 0 0 0 0 1722
3news-out.mixmin.net 1260 0 0 130 0 0 0 0 1130
4newsfeed.datemas.de 592 142 0 86 0 0 0 0 364
5news.snarked.org 528 62 0 79 0 0 0 0 387
6news.albasani.net 332 2 0 71 0 0 0 0 259
7news-out.aioe.org 255 10 0 54 0 0 0 0 191
8news.redatomik.org 232 0 0 104 0 0 0 0 128
9agency-nz-out.news.mb-net.net 145 26 0 70 0 0 0 0 49
10news.freedyn.net 144 11 0 64 0 0 0 0 69
11feeder.awxg.com 80 0 0 74 0 0 0 0 6
12csiph.com 78 0 0 61 0 0 0 0 17
13news.samoylyk.net 76 0 0 66 0 0 0 0 10
14news.swapon.de 50 0 0 8 0 0 0 0 42
15news.ausics.org 5 0 0 4 0 0 0 0 1
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 8353 326 0 1048 0 0 0 0 6979

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.commerciali 54
it.annunci.immobiliari 54
it.annunci.varie 46
mpc.lists.freebsd.ports.bugs 20
gmane.linux.alsa.devel 19
gmane.linux.kernel 10
mozilla.dev.security.policy 9
mpc.lists.freebsd.gecko 9
mozilla.support.seamonkey 7
mozilla.dev.ui-alerts 6
mpc.lists.freebsd.gnome 6
talk.religion.spirituality 5
mozilla.community.balkans 5
mozilla.dev.servo 5
mozilla.dev.platform 4
alt.biniaries.erotica.wet-n-messy 4
gmane.linux.alsa.user 4
mozilla.support.calendar 3
gmane.linux.drivers.devicetree 3
south-wales.test 3
TOTAL: 58 326

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5424
EMP (phn nph) 379
EMP (phn path) 261
EMP (phl) 87
Binary: misplaced rar 59
Too many newsgroups 59
User-issued cancel 50
Too many newsgroups (low_xpost) 30
Binary: non-binary distribution 18
Binary Image: misplaced png 6
Binary: misplaced par2 5
Binary: misplaced 010 4
Binary: misplaced 011 4
Binary: misplaced 009 1
Binary Image: misplaced jpg 1
Binary: misplaced 012 1
Cancel for rejected article 1
Binary: misplaced zip 1
TOTAL: 18 6391

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.freedyn.net 4
TOTAL: 1 4
Including strange strings
news-out.mixmin.net 323
news-out.aioe.org 73
news.redatomik.org 48
news.albasani.net 46
newsfeed.datemas.de 39
news.swapon.de 36
newsfeed.neva.ru 6
news.samoylyk.net 4
feeder.awxg.com 3
feeder.eternal-september.org 2
TOTAL: 12 584
TOTAL: 2 588

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20136 1022 19092 22 0 0 5%23:59:47
2awxg 21552 187 21333 1 0 12 0%23:59:40
3aioe 17230 10 17135 0 0 0 0%23:59:45
4news.redatomik.org 21783 6 21520 0 0 13 0%23:59:46
5news.freedyn.net 21956 6 21887 0 0 0 0%23:59:46
6eternal-september 18491 5 18474 0 0 0 0%23:59:39
7newsfeed.datemas.de 20542 5 20484 0 0 0 0%23:59:46
8csiph.com 20776 5 20672 1 0 0 0%23:59:46
9news-in.mixmin.net 17119 5 17096 0 0 0 0%23:59:42
10mb-net.net 21950 5 21895 0 0 0 0%23:59:43
11news.samoylyk.net 20114 5 20030 0 0 53 0%23:59:38
12neva.ru 20093 5 20075 0 0 0 0%23:59:46
13news.snarked.org 15900 4 15860 1 0 0 0%23:59:46
14news.albasani.net 22528 2 19589 1003 0 6641 0%23:59:46
15news.swapon.de 1773 0 1770 0 0 1 0%23:50:40
TOTAL: 15 281943 1272 276912 1028 0 6720 0%359:46:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org13.8 MB368.9 KB14.2 MB0.2 KB/s13.9 KB23:59:47
2awxg548.7 KB4.7 KB553.4 KB0.0 KB/s2.9 KB23:59:40
3aioe22.2 KB0.0 KB22.2 KB0.0 KB/s2.2 KB23:59:45
4news.freedyn.net11.6 KB0.0 KB11.6 KB0.0 KB/s1.9 KB23:59:46
5news.redatomik.org11.0 KB0.0 KB11.0 KB0.0 KB/s1.8 KB23:59:46
6eternal-september9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:39
7newsfeed.datemas.de9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:46
8csiph.com9.8 KB1.2 KB11.0 KB0.0 KB/s1.8 KB23:59:46
9news-in.mixmin.net9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:42
10mb-net.net9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:43
11news.samoylyk.net9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:38
12neva.ru9.8 KB0.0 KB9.8 KB0.0 KB/s2.0 KB23:59:46
13news.snarked.org7.6 KB2.2 KB9.8 KB0.0 KB/s2.0 KB23:59:46
14news.albasani.net3.5 KB3.9 MB3.9 MB0.0 KB/s4.0 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:40
TOTAL: 1514.5 MB4.3 MB18.8 MB0.0 KB/s8.4 KB359:46:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 857229.2 MB 1208 3 1801:55:59
2agency.bbs.geek.nz 387 649722.6 MB 3380 2 000:11:49
3vorlon.activateit.net.au 23 11421.6 MB 157 0 000:05:20
4103.39.238.13 1 610.9 KB 2 0 000:00:16
5115-189-85-57.mobile.spark.co.nz 3 23.7 KB 1 0 000:02:40
TOTAL: 5 422 1621953.4 MB 4748 5 1826:06:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 9 857229.2 MB 1208 3 1825:01:58
2*.bbs.geek.nz 387 649722.6 MB 3380 2 000:11:49
3*.activateit.net.au 23 11421.6 MB 157 0 000:05:20
4unresolved 7 610.9 KB 2 0 000:44:09
5*.mobile.spark.co.nz 3 23.7 KB 1 0 000:02:40
TOTAL: 5 429 1621953.4 MB 4748 5 1826:06:00

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 2
malcolmlewis 1
TOTAL: 4 35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.092 0.048 0.00323:05:58
67-61-21-181.cpe.cableone.net 1.668 1.248 0.13201:55:59
118.149.179.61 0.284 0.052 0.00000:35:03
agency.bbs.geek.nz 27.924 6.104 0.00000:11:49
vorlon.activateit.net.au 1.360 0.360 0.60700:05:20
118.149.195.51 0.056 0.012 0.00000:05:01
118.149.243.39 0.064 0.004 0.00000:03:48
115-189-85-57.mobile.spark.co.nz 0.176 0.032 0.00600:02:40
103.39.238.13 0.048 0.020 0.00300:00:16
? 0.912 0.160 0.00000:00:01
TOTAL: 10 32.584 8.040 0.75126:06:00

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.179.61 4
118.149.195.51 1
118.149.243.39 1
67-60-219-146.cpe.cableone.net 1
TOTAL: 4 7

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
115-189-85-57.mobile.spark.co.nz 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
118.149.179.61 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5579 34.4%
2soc 2224 13.7%
3alt 1886 11.6%
4comp 1436 8.9%
5sci 1268 7.8%
6uk 1237 7.6%
7linux 1218 7.5%
8talk 628 3.9%
9misc 367 2.3%
10news 198 1.2%
11mozilla 84 0.5%
12nz 27 0.2%
13microsoft 27 0.2%
14humanities 16 0.1%
15perl 12 0.1%
16us 6 0.0%
17aus 4 0.0%
18agency 2 0.0%
TOTAL: 18 16219100.0%

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

NewsgroupCount
1rec.arts.tv 1041
2rec.sport.tennis 626
3rec.food.cooking 561
4uk.legal 461
5linux.debian.bugs.dist 441
6uk.d-i-y 425
7alt.atheism 397
8alt.fan.rush-limbaugh 396
9rec.arts.sf.written 383
10rec.arts.drwho 379
11sci.physics 305
12rec.drugs.cannabis 298
13soc.retirement 297
14soc.culture.israel 296
15talk.politics.guns 272
16comp.lang.python 260
17soc.culture.polish 251
18soc.culture.usa 221
19misc.survivalism 218
20alt.politics.trump 217
21talk.politics.misc 212
22linux.debian.changes.devel 209
23soc.culture.china 202
24comp.lang.c 197
25news.lists.filters 192
26alt.comp.os.windows-10 185
27rec.gambling.poker 184
28soc.culture.singapore 183
29sci.electronics.design 183
30sci.math 180
31rec.boats 161
32linux.debian.bugs.rc 156
33rec.sport.pro-wrestling 147
34rec.sport.golf 146
35sci.physics.relativity 144
36rec.sport.football.college 130
37alt.bible.prophecy 129
38comp.arch 125
39rec.music.classical.recordings 117
40linux.debian.user 113
41talk.origins 112
42sci.logic 111
43rec.outdoors.rv-travel 110
44rec.aviation.soaring 109
45uk.radio.amateur 105
46soc.culture.indian 104
47comp.lang.c++ 101
48comp.os.linux.advocacy 100
49uk.legal.moderated 98
50rec.aquaria.marine.misc 88
51sci.med.cardiology 85
52alt.politics 80
53rec.aviation.marketplace 80
54alt.conspiracy 75
55misc.phone.mobile.iphone 70
56rec.crafts.metalworking 70
57alt.test 65
58soc.culture.vietnamese 62
59rec.woodworking 60
60comp.sys.mac.system 56
61rec.arts.movies.current-films 55
62uk.tech.digital-tv 54
63linux.debian.user.german 54
64rec.photo.digital 52
65alt.recovery.aa 50
66comp.lang.tcl 48
67comp.protocols.time.ntp 48
68comp.sys.apple2 48
69soc.culture.europe 48
70soc.penpals 47
71alt.conspiracy.jfk 47
72soc.genealogy.britain 46
73rec.radio.shortwave 46
74rec.music.rock-pop-r+b.1950s 45
75linux.debian.maint.boot 44
76soc.culture.ukrainian 44
77comp.os.vms 43
78sci.lang 43
79sci.military.naval 43
80alt.support.diabetes 42
81mozilla.support.thunderbird 42
82rec.sport.soccer 41
83soc.culture.bulgaria 40
84soc.history.what-if 39
85soc.singles 39
86comp.lang.forth 37
87linux.debian.user.spanish 36
88soc.culture.brazil 36
89rec.bicycles.tech 35
90comp.lang.lisp 33
91rec.games.roguelike.nethack 32
92rec.games.pinball 32
93linux.gentoo.user 32
94rec.arts.tv.soaps.cbs 30
95soc.genealogy.medieval 30
96misc.invest.stocks 30
97sci.math.num-analysis 30
98comp.sys.mac.advocacy 29
99linux.gentoo.dev 29
100rec.music.dylan 28
TOTAL: 370 16219