news.bbs.geek.nz daily logs

Oct 2 23:58:02 -- Oct 3 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 69155 44.9%5.6 MB 25.3%
innd 30287 19.7%5.0 MB 22.7%
inn 29864 19.4%6.8 MB 30.7%
innfeed 23155 15.0%4.5 MB 20.2%
cnfsstat 1440 0.9%255.0 KB 1.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 153902 100.0%22.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 294236 47.9%
Negative hits 291805 47.5%
Do not exist 27996 4.6%
Cache misses 308 0.1%
TOTAL: 4 614345 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.095 0.0%147 0.000 0.646 14.000
article cleanup00:00:00.246 0.0%28960 0.000 0.008 0.046
article logging00:00:00.720 0.0%29454 0.000 0.024 0.066
article parse00:00:00.921 0.0%78678 0.000 0.012 0.030
article write00:00:01.853 0.0%22481 0.010 0.082 1.240
artlog/artcncl00:00:00.003 0.0%139 0.000 0.022 1.000
data move00:00:00.279 0.0%579007 0.000 0.000 0.003
hisgrep/artcncl00:00:00.001 0.0%145 0.000 0.007 0.167
hishave/artcncl00:00:00.001 0.0%147 0.000 0.007 0.071
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.729 0.0%614447 0.001 0.011 0.770
history sync00:00:00.014 0.0%355 0.000 0.039 0.667
history write00:00:06.002 0.0%27996 0.018 0.214 16.071
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:47:55.716 99.8%593364 48.902 144.390 413.809
nntp read00:00:03.404 0.0%595659 0.002 0.006 0.013
overview write00:00:41.476 0.0%22481 0.030 1.845 75.250
perl filter00:00:53.132 0.1%27996 1.321 1.898 10.973
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.415 0.0%44962 0.008 0.031 0.144
TOTAL: 23:50:50.41123:49:52.007 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.114 0.0%49035 0.000 0.002 0.030
article prepare00:00:00.002 0.0%11224 0.000 0.000 0.011
article read00:00:00.230 0.0%2562 0.000 0.090 3.909
backlog stats00:00:00.296 0.0%374772 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.844 0.0%311441 0.002 0.006 0.011
data write00:00:03.476 0.0%294994 0.005 0.012 0.022
idle23:53:23.231 99.9%374772 53.364 229.481 602.159
status file00:00:19.344 0.0%1889 0.692 10.240 383.118
TOTAL: 23:54:07.26423:53:48.537100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle44:20:08.461 99.2%83065 0.000 1921.489 96709.252
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:23.950 0.1%193687 0.000 0.433 2.966
readart00:00:03.251 0.0%15136 0.000 0.215 35.639
TOTAL: 44:42:34.91144:21:35.662 99.2%----

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 39 21782 6555 14527 700 30%45:45:27
2news-out.mixmin.net 19 23920 3514 19164 1242 14%35:49:04
3feeder.eternal-september.org 64 26646 2381 23361 904 8%44:23:36
4news-out.aioe.org 4 21810 2293 19437 80 10%23:49:30
5news.albasani.net 4 25795 1783 23300 712 6%25:42:23
6newsfeed.neva.ru 147 17218 1713 13942 1563 9%87:21:45
7newsfeed.datemas.de 4 25340 1582 23253 505 6%25:43:01
8news.redatomik.org 1 21850 1250 20522 78 5%24:00:23
9csiph.com 2 22400 632 21714 54 2%24:59:56
10news.samoylyk.net 3 28331 212 27832 287 0%25:22:50
11news.swapon.de 6 1747 158 1585 4 9%28:10:58
12feeder.awxg.com 2 20454 118 20255 81 0%23:59:50
13news.freedyn.net 2 18339 109 18157 73 0%15:40:13
14agency-nz-out.news.mb-net.net 21 24854 85 24610 159 0%33:44:25
15localhost 5 4 3 0 1 75%00:00:00
TOTAL: 15 323 300490 22388 271659 6443 7%464:33:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.8 MB250.9 KB2.2 MB24.3 MB 89%3.4 KB
2feeder.eternal-september.org12.1 MB655.4 KB4.0 MB16.7 MB 72%5.2 KB
3news-out.mixmin.net9.5 MB284.1 KB2.3 MB12.1 MB 78%2.6 KB
4newsfeed.datemas.de8.2 MB498.4 KB1.8 MB10.5 MB 78%5.2 KB
5news.albasani.net7.3 MB1.3 MB2.6 MB11.2 MB 65%4.6 KB
6news-out.aioe.org5.1 MB150.1 KB195.3 KB5.4 MB 93%2.3 KB
7newsfeed.neva.ru5.0 MB184.6 KB6.4 MB11.5 MB 43%3.6 KB
8news.redatomik.org3.2 MB303.7 KB317.2 KB3.8 MB 83%2.9 KB
9csiph.com1.8 MB151.2 KB155.2 KB2.1 MB 85%3.1 KB
10news.samoylyk.net1.2 MB1.3 MB8.0 MB10.4 MB 11%21.4 KB
11news.freedyn.net771.0 KB959.8 KB1.2 MB2.9 MB 26%16.3 KB
12feeder.awxg.com374.1 KB329.6 KB368.8 KB1.0 MB 34%5.4 KB
13news.swapon.de355.1 KB12.9 KB12.9 KB380.9 KB 93%2.4 KB
14agency-nz-out.news.mb-net.net288.8 KB422.1 KB4.2 MB4.9 MB 5%20.7 KB
15localhost6.7 KB0.0 KB2.2 KB8.8 KB 75%2.2 KB
TOTAL: 1576.9 MB6.7 MB33.7 MB117.3 MB 65%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 2 23:58:02 - 23:59:59 25 0.1% 0.2155.0 KB 0.1% 0.47
Oct 3 00:00:00 - 00:59:59 1067 4.7% 0.303.3 MB 4.3% 0.95
Oct 3 01:00:00 - 01:59:59 1127 5.0% 0.312.8 MB 3.6% 0.79
Oct 3 02:00:00 - 02:59:59 1086 4.8% 0.302.8 MB 3.6% 0.79
Oct 3 03:00:00 - 03:59:59 1242 5.5% 0.343.1 MB 4.0% 0.89
Oct 3 04:00:00 - 04:59:59 1231 5.4% 0.344.2 MB 5.4% 1.19
Oct 3 05:00:00 - 05:59:59 1236 5.5% 0.344.1 MB 5.3% 1.16
Oct 3 06:00:00 - 06:59:59 1230 5.4% 0.344.0 MB 5.2% 1.15
Oct 3 07:00:00 - 07:59:59 1143 5.0% 0.323.8 MB 4.9% 1.08
Oct 3 08:00:00 - 08:59:59 1115 4.9% 0.314.2 MB 5.4% 1.19
Oct 3 09:00:00 - 09:59:59 1980 8.7% 0.558.6 MB 11.1% 2.45
Oct 3 10:00:00 - 10:59:59 1306 5.8% 0.365.1 MB 6.6% 1.45
Oct 3 11:00:00 - 11:59:59 959 4.2% 0.272.6 MB 3.4% 0.75
Oct 3 12:00:00 - 12:59:59 655 2.9% 0.183.7 MB 4.8% 1.06
Oct 3 13:00:00 - 13:59:59 590 2.6% 0.162.1 MB 2.8% 0.61
Oct 3 14:00:00 - 14:59:59 485 2.1% 0.131.7 MB 2.2% 0.48
Oct 3 15:00:00 - 15:59:59 428 1.9% 0.121.9 MB 2.5% 0.54
Oct 3 16:00:00 - 16:59:59 393 1.7% 0.111.9 MB 2.4% 0.54
Oct 3 17:00:00 - 17:59:59 499 2.2% 0.142.4 MB 3.1% 0.69
Oct 3 18:00:00 - 18:59:59 505 2.2% 0.142.4 MB 3.1% 0.68
Oct 3 19:00:00 - 19:59:59 685 3.0% 0.192.5 MB 3.2% 0.70
Oct 3 20:00:00 - 20:59:59 820 3.6% 0.232.1 MB 2.8% 0.61
Oct 3 21:00:00 - 21:59:59 926 4.1% 0.262.6 MB 3.4% 0.75
Oct 3 22:00:00 - 22:59:59 925 4.1% 0.262.5 MB 3.2% 0.70
Oct 3 23:00:00 - 23:58:01 1009 4.5% 0.293.1 MB 3.9% 0.90
TOTAL: 23:59:59 22667 100.0% 0.2677.7 MB 100.0% 0.92
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.5 GB 41.0% 0 0.33 1866.41
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.7 GB 47.4% 0 0.38 1602.56
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB253.1 MB 0.5% 0 0.0414222.22
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 GB9.3 GB 18.7% 0 0.81 748.78
TOTAL: 10-500.0 GB53.8 GB 10.8% 1 0.50-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1579 73 0 59 1 0 0 0 1446
2news-out.mixmin.net 1500 0 0 96 0 0 0 0 1404
3feeder.eternal-september.org 929 0 0 120 0 0 0 0 809
4news.albasani.net 849 6 0 88 0 0 0 0 755
5news.snarked.org 715 74 0 81 0 0 0 0 560
6newsfeed.datemas.de 515 186 0 90 0 0 0 0 239
7news.samoylyk.net 300 0 0 92 0 0 0 0 208
8agency-nz-out.news.mb-net.net 171 27 0 73 1 0 0 0 70
9news.redatomik.org 137 0 0 76 0 0 0 0 61
10news-out.aioe.org 96 17 0 57 0 0 0 0 22
11news.freedyn.net 91 3 0 44 0 0 0 0 44
12feeder.awxg.com 75 2 0 69 0 0 0 0 4
13csiph.com 55 0 0 54 0 0 0 0 1
14news.swapon.de 32 0 0 3 0 0 0 0 29
15news.ausics.org 2 0 0 2 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 7047 388 0 1004 2 0 0 0 5653

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.immobiliari 62
ut.test 46
it.annunci.commerciali 35
mpc.lists.freebsd.ports.bugs 33
it.annunci.varie 22
mpc.lists.nanog 20
mozilla.dev.platform 18
mozilla.support.seamonkey 15
mozilla.dev.l10n.sr 14
gmane.comp.gis.openstreetmap.tagging 13
gmane.linux.alsa.devel 12
mozilla.dev.security.policy 9
mozilla.test 7
gmane.linux.kernel 7
fido7.ru.android 6
mozilla.dev.developer-tools 5
mpc.lists.freebsd.x11 5
mozilla.dev.ui-alerts 5
mozilla.compatibility 4
alt.sex.torture 4
TOTAL: 51 388

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

GroupsCount
nz.politics.announce 1
uk.legal.moderated 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4089
EMP (phn path) 486
EMP (phn nph) 355
Too many newsgroups 68
Binary Image: misplaced jpg 65
EMP (phl) 42
Binary: non-binary distribution 14
User-issued cancel 11
Too many newsgroups (meow) 4
Binary: misplaced 087 2
HTML post 2
Too many newsgroups (low_xpost) 2
Binary: misplaced 053 2
Binary: misplaced 035 1
Binary: misplaced 014 1
Binary: misplaced 067 1
Binary: misplaced 034 1
Binary: misplaced 083 1
Binary: misplaced par2 1
Binary: misplaced 042 1
TOTAL: 27 5156

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 215
news.albasani.net 143
news.redatomik.org 54
newsfeed.datemas.de 36
news.swapon.de 29
news-out.aioe.org 11
newsfeed.neva.ru 7
feeder.awxg.com 1
news.snarked.org 1
TOTAL: 9 497
TOTAL: 1 497

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20442 1465 18883 94 0 0 7%23:59:43
2awxg 22207 116 22051 2 0 10 0%23:59:46
3news.snarked.org 40576 39 15816 15 0 19858 0%23:59:43
4aioe 19245 12 19068 0 0 5 0%23:59:38
5news.freedyn.net 22782 10 22529 2 0 3 0%23:59:43
6news.samoylyk.net 20351 5 20255 6 0 15 0%23:59:37
7news.albasani.net 22082 3 19577 933 1 6241 0%23:59:02
8mb-net.net 22560 3 22505 0 0 0 0%23:59:42
9csiph.com 22288 3 22044 0 0 9 0%23:59:40
10news-in.mixmin.net 18263 3 18255 0 0 0 0%23:59:24
11eternal-september 19692 3 19481 3 0 260 0%23:59:43
12news.redatomik.org 21381 3 21335 1 0 0 0%23:59:35
13news.swapon.de 1524 0 1524 0 0 0 0%23:45:40
14newsfeed.datemas.de 21110 0 21060 0 0 85 0%23:59:43
15neva.ru 20352 0 20341 3 0 0 0%23:59:43
TOTAL: 15 314855 1665 284724 1059 1 26486 0%359:40:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.4 MB6.1 MB18.5 MB0.2 KB/s12.2 KB23:59:43
2news.snarked.org1.4 MB41.0 KB1.4 MB0.0 KB/s26.7 KB23:59:43
3awxg555.7 KB12.0 KB567.6 KB0.0 KB/s4.8 KB23:59:46
4aioe38.1 KB0.0 KB38.1 KB0.0 KB/s3.2 KB23:59:38
5news.freedyn.net27.7 KB9.3 KB37.0 KB0.0 KB/s3.1 KB23:59:43
6news.samoylyk.net11.0 KB13.6 KB24.7 KB0.0 KB/s2.2 KB23:59:37
7eternal-september6.9 KB5.4 KB12.2 KB0.0 KB/s2.0 KB23:59:43
8news.albasani.net6.7 KB3.3 MB3.3 MB0.0 KB/s3.7 KB23:59:02
9mb-net.net6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:42
10csiph.com6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:40
11news-in.mixmin.net6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:24
12news.redatomik.org6.7 KB2.6 KB9.3 KB0.0 KB/s2.3 KB23:59:35
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:40
14newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
15neva.ru0.0 KB6.7 KB6.7 KB0.0 KB/s2.2 KB23:59:43
TOTAL: 1514.5 MB9.5 MB24.0 MB0.0 KB/s9.0 KB359:40:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 272 600118.9 MB 2437 0 000:09:24
267-61-21-181.cpe.cableone.net 3 586920.5 MB 524 3 801:19:24
3163.47.16.169 24 10441.3 MB 140 0 000:04:58
467-60-219-146.cpe.cableone.net 3 113.7 KB 1 0 042:48:28
TOTAL: 4 302 1291540.7 MB 3102 3 844:42:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 272 600118.9 MB 2437 0 000:09:24
2*.cpe.cableone.net 6 587020.5 MB 525 3 844:07:53
3unresolved 29 10441.3 MB 140 0 000:25:09
TOTAL: 3 307 1291540.7 MB 3102 3 844:42:29

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 3
malcolmlewis 3
TOTAL: 3 30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.248 0.084 0.00942:48:28
67-61-21-181.cpe.cableone.net 0.684 0.700 0.07801:19:24
118.149.128.220 0.172 0.032 0.00000:15:05
agency.bbs.geek.nz 18.860 4.196 0.00000:09:24
118.149.162.131 0.060 0.008 0.00000:05:01
163.47.16.169 1.428 0.320 0.23600:04:58
125.212.217.215 0.052 0.008 0.00000:00:04
? 1.160 0.164 0.00000:00:02
TOTAL: 8 22.664 5.512 0.32344:42:29

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.128.220 3
125.212.217.215 1
118.149.162.131 1
TOTAL: 3 5

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 5862 45.4%
2sci 2042 15.8%
3soc 1416 11.0%
4comp 1342 10.4%
5alt 1080 8.4%
6talk 454 3.5%
7uk 250 1.9%
8misc 207 1.6%
9news 140 1.1%
10humanities 40 0.3%
11nz 31 0.2%
12eternal-september 23 0.2%
13mozilla 16 0.1%
14aus 12 0.1%
TOTAL: 14 12915100.0%

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

NewsgroupCount
1rec.arts.tv 1669
2rec.food.cooking 545
3sci.physics.relativity 513
4rec.sport.tennis 479
5sci.physics 435
6sci.math 417
7rec.sport.football.college 357
8alt.atheism 346
9sci.electronics.design 342
10rec.gambling.poker 337
11alt.comp.os.windows-10 301
12talk.politics.guns 285
13soc.retirement 248
14uk.radio.amateur 201
15rec.arts.drwho 192
16comp.lang.c++ 184
17rec.boats 174
18rec.outdoors.rv-travel 163
19comp.lang.python 156
20alt.bible 153
21rec.arts.sf.written 149
22soc.culture.polish 139
23rec.bicycles.tech 137
24comp.lang.c 134
25soc.culture.brazil 132
26news.lists.filters 120
27comp.os.linux.advocacy 107
28rec.sport.pro-wrestling 106
29soc.penpals 105
30rec.photo.digital 104
31rec.sport.soccer 100
32comp.os.vms 93
33talk.origins 90
34soc.culture.china 89
35soc.culture.indian 89
36soc.culture.usa 88
37rec.crafts.metalworking 85
38rec.aviation.soaring 80
39rec.music.dylan 75
40misc.survivalism 73
41misc.health.alternative 70
42soc.culture.israel 69
43comp.lang.ada 68
44alt.recovery.aa 67
45rec.autos.sport.f1 65
46comp.sys.mac.system 65
47alt.politics 65
48comp.sys.acorn.misc 63
49talk.politics.misc 61
50soc.culture.vietnamese 56
51soc.culture.singapore 55
52comp.sys.apple2 54
53soc.culture.bulgaria 54
54rec.sport.golf 52
55rec.arts.sf.tv 50
56comp.sys.mac.advocacy 49
57rec.games.video.sony 48
58rec.arts.movies.current-films 46
59comp.lang.forth 46
60rec.games.trivia 45
61rec.music.classical.recordings 45
62rec.arts.tv.uk.coronation-st 45
63uk.tech.broadcast 44
64alt.test 44
65rec.arts.disney.parks 37
66soc.history.medieval 36
67comp.arch 34
68sci.astro.amateur 34
69sci.med.cardiology 33
70soc.culture.japan 32
71rec.arts.comics.strips 32
72sci.logic 31
73soc.history.what-if 31
74rec.games.pinball 30
75rec.aquaria.marine.misc 30
76humanities.lit.authors.shakespeare 30
77sci.military.naval 30
78alt.support.diabetes 29
79comp.sys.acorn.apps 28
80rec.gardens.edible 28
81sci.lang 26
82soc.culture.quebec 26
83misc.invest.stocks 25
84soc.culture.african.american 25
85sci.space.policy 24
86rec.drugs.cannabis 24
87rec.puzzles.crosswords 24
88nz.general 23
89sci.med.pharmacy 22
90rec.gambling.lottery 22
91rec.skiing.alpine 22
92rec.audio.opinion 21
93sci.astro 21
94rec.music.artists.kiss 20
95sci.math.num-analysis 20
96sci.electronics.repair 20
97comp.lang.fortran 19
98alt.astronomy 19
99comp.lang.java.programmer 18
100soc.culture.belgium 18
TOTAL: 315 12915