news.bbs.geek.nz daily logs

Jul 19 23:58:01 -- Jul 20 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 103624 54.3%8.3 MB 33.0%
innd 31223 16.4%5.1 MB 20.3%
inn 31116 16.3%7.0 MB 27.8%
innfeed 23311 12.2%4.5 MB 17.9%
cnfsstat 1440 0.8%247.7 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 190715 100.0%25.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 314064 49.3%
Positive hits 293387 46.1%
Do not exist 29277 4.6%
Cache misses 321 0.1%
TOTAL: 4 637049 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.125 0.0%162 0.000 0.772 18.000
article cleanup00:00:00.278 0.0%30526 0.000 0.009 0.036
article logging00:00:00.774 0.0%30976 0.004 0.025 0.128
article parse00:00:00.957 0.0%81113 0.000 0.012 0.030
article write00:00:01.765 0.0%23033 0.018 0.077 0.458
artlog/artcncl00:00:00.004 0.0%157 0.000 0.025 0.500
data move00:00:00.485 0.0%579800 0.000 0.001 0.011
hisgrep/artcncl00:00:00.004 0.0%150 0.000 0.027 1.000
hishave/artcncl00:00:00.000 0.0%162 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.947 0.0%639989 0.001 0.011 0.484
history sync00:00:00.011 0.0%347 0.000 0.032 0.500
history write00:00:08.431 0.0%29372 0.005 0.287 19.393
hiswrite/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
idle23:57:38.904 99.8%598645 96.382 144.090 344.598
nntp read00:00:03.313 0.0%600590 0.002 0.006 0.015
overview write00:00:39.258 0.0%23033 0.065 1.704 42.541
perl filter00:01:00.878 0.1%29372 1.455 2.073 3.730
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.668 0.0%46066 0.003 0.036 0.114
TOTAL: 24:00:42.65323:59:43.802 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%38855 0.000 0.002 0.024
article prepare00:00:00.001 0.0%10156 0.000 0.000 0.014
article read00:00:00.691 0.0%2296 0.000 0.301 21.808
backlog stats00:00:00.307 0.0%345894 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.698 0.0%289581 0.002 0.006 0.011
data write00:00:03.136 0.0%280846 0.004 0.011 0.019
idle23:52:56.877100.0%345894 113.622 248.564 653.050
status file00:00:08.779 0.0%1964 0.769 4.470 162.325
TOTAL: 23:53:27.54123:53:11.573100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle27:21:44.016 97.8%112248 0.000 877.557 62851.040
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.291 0.0%241869 0.000 0.005 1.800
readart00:00:02.764 0.0%9915 0.000 0.279 20.207
TOTAL: 27:59:27.06327:21:48.071 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 48 21505 6499 14593 413 30%53:11:46
2news-out.aioe.org 2 22109 4722 17285 102 21%23:46:24
3news-out.mixmin.net 9 24941 1879 22402 660 7%28:10:31
4feeder.eternal-september.org 83 27349 1783 24278 1288 6%53:54:54
5news.redatomik.org 1 26218 1587 24521 110 6%28:31:25
6news.albasani.net 1 24500 1559 22404 537 6%24:28:39
7newsfeed.neva.ru 155 14858 1372 10956 2530 9%85:16:26
8csiph.com 2 24082 1354 22642 86 5%25:32:12
9news.freedyn.net 2 24919 1144 23317 458 4%23:50:08
10newsfeed.datemas.de 2 20443 398 19796 249 1%21:09:52
11news.samoylyk.net 3 24605 281 23585 739 1%22:02:09
12feeder.awxg.com 2 20242 219 19927 96 1%23:59:56
13news.swapon.de 5 1466 80 1371 15 5%23:07:48
14agency-nz-out.news.mb-net.net 19 26033 47 25869 117 0%31:59:02
15localhost 9 8 7 1 0 87%00:00:00
TOTAL: 15 343 303278 22931 272947 7400 7%469:01:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.3 MB371.0 KB1.7 MB25.4 MB 91%3.8 KB
2news-out.aioe.org11.1 MB153.1 KB283.9 KB11.6 MB 96%2.5 KB
3feeder.eternal-september.org10.4 MB832.5 KB9.4 MB20.6 MB 50%6.9 KB
4news-out.mixmin.net7.4 MB542.5 KB2.1 MB10.1 MB 73%4.1 KB
5news.albasani.net6.5 MB797.8 KB1.9 MB9.1 MB 71%4.5 KB
6news.redatomik.org4.4 MB497.9 KB515.6 KB5.4 MB 81%3.2 KB
7news.freedyn.net4.3 MB265.3 KB1.3 MB5.9 MB 73%3.7 KB
8newsfeed.neva.ru4.2 MB331.6 KB11.4 MB15.8 MB 26%4.2 KB
9csiph.com3.6 MB438.8 KB460.1 KB4.4 MB 80%3.1 KB
10newsfeed.datemas.de2.1 MB436.4 KB1.5 MB4.0 MB 51%6.4 KB
11news.samoylyk.net2.1 MB337.9 KB5.1 MB7.5 MB 27%7.5 KB
12feeder.awxg.com663.6 KB379.3 KB386.8 KB1.4 MB 46%4.5 KB
13news.swapon.de217.1 KB70.8 KB70.8 KB358.7 KB 60%3.8 KB
14agency-nz-out.news.mb-net.net132.1 KB274.7 KB673.6 KB1.1 MB 12%6.6 KB
15localhost10.4 KB0.0 KB0.0 KB10.4 KB100%1.5 KB
TOTAL: 1580.3 MB5.6 MB36.7 MB122.6 MB 65%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 19 23:58:01 - 23:59:59 33 0.1% 0.2875.8 KB 0.1% 0.64
Jul 20 00:00:00 - 00:59:59 1085 4.7% 0.302.9 MB 3.6% 0.83
Jul 20 01:00:00 - 01:59:59 1099 4.8% 0.314.0 MB 4.9% 1.15
Jul 20 02:00:00 - 02:59:59 1297 5.6% 0.364.8 MB 5.9% 1.38
Jul 20 03:00:00 - 03:59:59 1388 6.0% 0.394.6 MB 5.6% 1.30
Jul 20 04:00:00 - 04:59:59 1120 4.9% 0.314.1 MB 5.0% 1.17
Jul 20 05:00:00 - 05:59:59 1164 5.1% 0.323.4 MB 4.2% 0.98
Jul 20 06:00:00 - 06:59:59 1210 5.3% 0.344.6 MB 5.7% 1.32
Jul 20 07:00:00 - 07:59:59 1036 4.5% 0.293.0 MB 3.6% 0.84
Jul 20 08:00:00 - 08:59:59 1225 5.3% 0.343.8 MB 4.7% 1.09
Jul 20 09:00:00 - 09:59:59 1045 4.5% 0.293.7 MB 4.6% 1.06
Jul 20 10:00:00 - 10:59:59 814 3.5% 0.233.2 MB 3.9% 0.91
Jul 20 11:00:00 - 11:59:59 682 3.0% 0.192.3 MB 2.8% 0.64
Jul 20 12:00:00 - 12:59:59 686 3.0% 0.192.1 MB 2.6% 0.60
Jul 20 13:00:00 - 13:59:59 584 2.5% 0.162.7 MB 3.3% 0.77
Jul 20 14:00:00 - 14:59:59 515 2.2% 0.142.7 MB 3.3% 0.77
Jul 20 15:00:00 - 15:59:59 524 2.3% 0.152.6 MB 3.2% 0.75
Jul 20 16:00:00 - 16:59:59 558 2.4% 0.152.9 MB 3.5% 0.82
Jul 20 17:00:00 - 17:59:59 580 2.5% 0.162.7 MB 3.3% 0.77
Jul 20 18:00:00 - 18:59:59 647 2.8% 0.183.3 MB 4.1% 0.95
Jul 20 19:00:00 - 19:59:59 1050 4.6% 0.293.3 MB 4.0% 0.93
Jul 20 20:00:00 - 20:59:59 1146 5.0% 0.323.2 MB 4.0% 0.92
Jul 20 21:00:00 - 21:59:59 1256 5.5% 0.354.2 MB 5.2% 1.20
Jul 20 22:00:00 - 22:59:59 1177 5.1% 0.333.1 MB 3.8% 0.88
Jul 20 23:00:00 - 23:58:01 1087 4.7% 0.314.1 MB 5.0% 1.21
TOTAL: 24:00:00 23008 100.0% 0.2781.6 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.6 GB 37.1% 0 0.33 1848.51
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.6 GB 43.3% 0 0.45 1342.69
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB228.8 MB 0.4% 0 0.0319498.21
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 GB5.0 GB 10.0% 0 0.78 773.22
TOTAL: 10-500.0 GB45.4 GB 9.1% 1 0.50-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2524 88 0 71 0 0 0 0 2365
2feeder.eternal-september.org 1330 0 0 157 0 0 0 0 1173
3news.samoylyk.net 840 0 0 101 0 0 0 0 739
4news-out.mixmin.net 712 0 0 112 0 0 0 0 600
5news.albasani.net 619 1 0 90 0 0 0 0 528
6news.freedyn.net 448 25 0 65 0 0 0 0 358
7news.snarked.org 446 31 0 96 0 0 0 0 319
8newsfeed.datemas.de 309 103 0 94 0 0 0 0 112
9news-out.aioe.org 215 29 0 52 0 0 0 0 134
10news.redatomik.org 195 0 0 83 0 0 0 0 112
11agency-nz-out.news.mb-net.net 110 14 0 66 3 0 0 0 27
12feeder.awxg.com 85 1 0 81 0 0 0 0 3
13csiph.com 77 0 0 73 0 0 0 0 4
14news.swapon.de 41 0 0 21 0 0 0 0 20
15news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 15 7952 292 0 1163 3 0 0 0 6494

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 133
mozilla.dev.security.policy 19
gmane.linux.alsa.devel 18
mozilla.dev.platform 17
mozilla.support.seamonkey 16
mozilla.dev.l10n 7
alt.biology 7
gmane.linux.kernel 5
mozilla.dev.ui-alerts 5
mozilla.test 5
mozilla.support.bugzilla 4
mpc.lists.freebsd.gnome 4
fido7.ru.android 4
mozilla.release.engineering 3
mozilla.apis 2
gmane.comp.gis.openstreetmap.tagging 2
mozilla.dev.apps.seamonkey 2
REC.SPORT.DISC 2
purdue.forsale 2
mozilla.community.india 2
TOTAL: 52 292

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

GroupsCount
nz.politics.announce 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5353
EMP (phn path) 336
EMP (phn nph) 195
Too many newsgroups 73
Binary: non-binary distribution 30
User-issued cancel 17
EMP (phl) 9
Too many newsgroups (low_xpost) 9
Binary: misplaced par2 8
HTML post 4
Binary Image: misplaced png 2
Too many newsgroups (meow) 2
Cancel for rejected article 1
Angle-bracket bot 1
Binary: misplaced 692 1
Binary: misplaced 021 1
Binary: misplaced 039 1
Binary: misplaced 035 1
TOTAL: 18 6044

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 109
news.redatomik.org 106
news.albasani.net 94
news-out.mixmin.net 77
news.swapon.de 20
news.snarked.org 15
newsfeed.datemas.de 15
newsfeed.neva.ru 8
feeder.awxg.com 3
feeder.eternal-september.org 2
TOTAL: 11 450
TOTAL: 1 450

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 21408 1114 20150 144 0 10 5%23:59:49
2awxg 22217 101 22102 4 0 39 0%23:59:48
3news.freedyn.net 22222 13 21862 0 0 126 0%23:59:48
4news.snarked.org 16557 8 16360 6 0 78 0%23:59:49
5aioe 15898 7 15792 0 0 0 0%23:59:48
6csiph.com 21720 7 21651 1 0 12 0%23:59:47
7news.redatomik.org 21107 7 21086 0 0 23 0%23:59:47
8news-in.mixmin.net 19747 7 19720 0 0 21 0%23:59:45
9neva.ru 21054 7 21037 0 0 0 0%23:59:48
10newsfeed.datemas.de 22292 6 22260 0 0 110 0%23:59:48
11news.albasani.net 22715 6 20134 999 0 6580 0%23:59:48
12mb-net.net 22979 6 22916 0 0 38 0%23:59:45
13eternal-september 19427 5 19325 0 0 147 0%23:59:48
14news.samoylyk.net 21114 4 21069 0 0 8750 0%23:59:48
15news.swapon.de 1779 0 1778 0 0 0 0%23:59:42
TOTAL: 15 292236 1298 287242 1154 0 15934 0%359:56:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org5.0 MB11.0 MB16.0 MB0.2 KB/s13.0 KB23:59:49
2awxg346.5 KB21.8 KB368.3 KB0.0 KB/s3.5 KB23:59:48
3news.freedyn.net28.9 KB0.0 KB28.9 KB0.0 KB/s2.2 KB23:59:48
4news.snarked.org12.6 KB13.9 KB26.5 KB0.0 KB/s1.9 KB23:59:49
5aioe10.5 KB0.0 KB10.5 KB0.0 KB/s1.5 KB23:59:48
6csiph.com10.5 KB3.0 KB13.4 KB0.0 KB/s1.7 KB23:59:47
7news.redatomik.org10.5 KB0.0 KB10.5 KB0.0 KB/s1.5 KB23:59:47
8news-in.mixmin.net10.5 KB0.0 KB10.5 KB0.0 KB/s1.5 KB23:59:45
9neva.ru10.5 KB0.0 KB10.5 KB0.0 KB/s1.5 KB23:59:48
10news.albasani.net9.0 KB3.1 MB3.2 MB0.0 KB/s3.2 KB23:59:48
11newsfeed.datemas.de9.0 KB0.0 KB9.0 KB0.0 KB/s1.5 KB23:59:48
12mb-net.net9.0 KB0.0 KB9.0 KB0.0 KB/s1.5 KB23:59:45
13eternal-september7.5 KB0.0 KB7.5 KB0.0 KB/s1.5 KB23:59:48
14news.samoylyk.net6.3 KB0.0 KB6.3 KB0.0 KB/s1.6 KB23:59:48
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 155.5 MB14.1 MB19.6 MB0.0 KB/s8.2 KB359:56:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 350 689521.8 MB 3517 7 200:11:59
2163.47.16.169 24 13631.9 MB 159 0 000:06:12
367-61-218-236.cpe.cableone.net 3 22.7 KB 1 0 027:04:12
TOTAL: 3 377 826023.6 MB 3677 7 227:59:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 350 689521.8 MB 3517 7 200:11:59
2unresolved 34 13631.9 MB 159 0 000:43:06
3*.cpe.cableone.net 3 22.7 KB 1 0 027:04:12
TOTAL: 3 387 826023.6 MB 3677 7 227:59:20

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 3
TOTAL: 2 27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.300 0.084 0.01227:04:12
118.149.225.43 0.276 0.068 0.00000:24:30
118.149.212.114 0.196 0.008 0.00000:12:06
agency.bbs.geek.nz 25.148 5.900 0.00000:11:59
163.47.16.169 1.392 0.400 0.13700:06:12
45.55.7.136 0.044 0.016 0.00000:00:09
203.118.151.117 0.080 0.008 0.00000:00:07
? 1.100 0.152 0.00000:00:01
TOTAL: 8 28.536 6.636 0.14927:59:20

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.225.43 5
118.149.212.114 3
45.55.7.136 1
203.118.151.117 1
TOTAL: 4 10

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 3850 46.6%
2comp 1593 19.3%
3sci 767 9.3%
4soc 721 8.7%
5misc 401 4.9%
6alt 378 4.6%
7talk 266 3.2%
8news 121 1.5%
9uk 77 0.9%
10nz 60 0.7%
11humanities 15 0.2%
12aus 6 0.1%
13eternal-september 5 0.1%
TOTAL: 13 8260100.0%

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

NewsgroupCount
1rec.arts.tv 898
2rec.arts.drwho 647
3rec.sport.tennis 475
4comp.lang.python 324
5comp.os.linux.advocacy 318
6comp.lang.c 296
7misc.survivalism 294
8rec.arts.sf.written 279
9alt.comp.os.windows-10 237
10rec.food.cooking 194
11sci.physics 165
12sci.electronics.design 156
13rec.sport.football.college 155
14talk.politics.misc 118
15sci.med.pharmacy 117
16alt.test 113
17news.lists.filters 107
18soc.retirement 105
19soc.culture.china 98
20soc.culture.polish 86
21comp.sys.mac.system 84
22rec.gambling.poker 84
23talk.politics.guns 79
24soc.culture.singapore 73
25rec.audio.pro 71
26rec.sport.pro-wrestling 69
27soc.culture.israel 68
28comp.lang.c++ 67
29misc.test 65
30rec.boats 64
31sci.physics.relativity 60
32rec.arts.movies.current-films 60
33talk.origins 60
34uk.radio.amateur 59
35rec.sport.soccer 55
36rec.photo.digital 52
37rec.crafts.metalworking 51
38sci.math.num-analysis 49
39sci.math 48
40rec.arts.sf.fandom 47
41nz.general 46
42rec.arts.sf.tv 45
43soc.culture.indian 42
44rec.aviation.soaring 38
45rec.audio.opinion 37
46comp.sys.apple2 36
47rec.music.classical.recordings 35
48comp.sys.raspberry-pi 35
49soc.history.what-if 34
50rec.games.pinball 33
51comp.protocols.time.ntp 32
52rec.autos.sport.f1 31
53rec.outdoors.rv-travel 30
54sci.astro.amateur 28
55comp.lang.forth 27
56rec.games.video.sony 25
57comp.lang.asm.x86 24
58soc.culture.brazil 23
59sci.lang 22
60comp.sys.mac.advocacy 22
61rec.radio.shortwave 22
62comp.mobile.ipad 22
63soc.culture.usa 21
64comp.mobile.android 21
65soc.culture.vietnamese 20
66comp.sys.acorn.misc 20
67rec.autos.tech 20
68rec.games.trivia 20
69comp.soft-sys.sas 20
70comp.arch 19
71rec.bicycles.tech 19
72sci.logic 19
73comp.lang.lisp 18
74alt.bbs.mystic 18
75comp.soft-sys.math.scilab 17
76soc.genealogy.medieval 17
77comp.soft-sys.matlab 16
78rec.music.gdead 16
79soc.culture.romanian 15
80comp.os.linux.misc 15
81humanities.lit.authors.shakespeare 15
82rec.arts.tv.uk.coronation-st 14
83soc.penpals 14
84sci.electronics.repair 13
85rec.sport.golf 13
86comp.os.vms 13
87rec.woodworking 12
88rec.radio.amateur.misc 12
89sci.space.policy 12
90misc.health.alternative 12
91rec.arts.movies.past-films 12
92sci.anthropology.paleo 12
93comp.lang.ada 12
94soc.women 12
95rec.radio.amateur.dx 12
96rec.gardens.edible 10
97rec.arts.sf.science 10
98uk.comp.home-networking 10
99misc.news.internet.discuss 9
100comp.dsp 9
TOTAL: 294 8260