news.bbs.geek.nz daily logs

Jul 6 23:58:02 -- Jul 7 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 95907 51.2%7.8 MB 31.1%
innd 34026 18.2%5.4 MB 21.8%
inn 32547 17.4%6.9 MB 27.8%
innfeed 23320 12.5%4.6 MB 18.3%
cnfsstat 1440 0.8%254.7 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 187241 100.0%24.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 308831 48.6%
Positive hits 295892 46.6%
Do not exist 30392 4.8%
Cache misses 236 0.0%
TOTAL: 4 635351 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.275 0.0%131 0.000 2.099 16.000
article cleanup00:00:00.309 0.0%31992 0.000 0.010 0.039
article logging00:00:00.759 0.0%32427 0.004 0.023 0.084
article parse00:00:00.979 0.0%85346 0.000 0.011 0.027
article write00:00:01.680 0.0%22094 0.015 0.076 0.615
artlog/artcncl00:00:00.002 0.0%119 0.000 0.017 0.333
data move00:00:00.764 0.0%577323 0.000 0.001 0.034
hisgrep/artcncl00:00:00.004 0.0%131 0.000 0.031 1.000
hishave/artcncl00:00:00.001 0.0%131 0.000 0.008 0.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.623 0.0%636936 0.001 0.015 0.545
history sync00:00:00.013 0.0%306 0.000 0.042 0.500
history write00:00:10.899 0.0%30464 0.013 0.358 16.592
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:02.588 99.8%599537 91.616 143.815 383.277
nntp read00:00:03.788 0.0%601469 0.002 0.006 0.021
overview write00:00:39.308 0.0%22094 0.047 1.779 29.291
perl filter00:01:09.744 0.1%30464 1.520 2.289 11.923
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.302 0.0%44188 0.005 0.029 0.092
TOTAL: 24:00:23.76223:59:22.038 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.071 0.0%29133 0.000 0.002 0.023
article prepare00:00:00.002 0.0%10550 0.000 0.000 0.015
article read00:00:00.218 0.0%2402 0.000 0.091 3.875
backlog stats00:00:00.325 0.0%345226 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.739 0.0%289951 0.002 0.006 0.011
data write00:00:03.056 0.0%274510 0.003 0.011 0.019
idle23:53:14.055 99.9%345226 153.848 249.095 563.352
status file00:00:25.595 0.0%1931 0.750 13.255 569.293
TOTAL: 23:54:02.61823:53:45.061100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:19:52.734 97.1%104273 0.000 805.508 75276.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.202 0.0%224855 0.000 0.005 0.333
readart00:00:03.436 0.0%8676 0.000 0.396 17.871
TOTAL: 24:02:07.68623:19:57.372 97.1%----

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 60 27386 6429 15433 5524 23%70:02:24
2news-out.aioe.org 5 18934 4935 13917 82 26%21:37:58
3newsfeed.datemas.de 4 24318 3688 19985 645 15%25:14:28
4news-out.mixmin.net 21 23131 1614 20781 736 6%35:34:17
5feeder.eternal-september.org 128 28951 1465 26990 496 5%73:56:15
6newsfeed.neva.ru 150 17268 1452 15047 769 8%97:01:36
7csiph.com 3 20140 946 19071 123 4%22:31:53
8news.redatomik.org 1 26814 439 26148 227 1%30:07:05
9news.albasani.net 1 19866 411 19134 321 2%21:01:30
10news.samoylyk.net 2 30846 280 30007 559 0%24:35:45
11feeder.awxg.com 1 19301 183 19029 89 0%23:59:57
12news.freedyn.net 2 24745 145 24443 157 0%24:07:58
13news.swapon.de 9 1927 89 1807 31 4%27:51:37
14agency-nz-out.news.mb-net.net 30 24553 52 24385 116 0%39:21:56
15localhost 7 6 5 0 1 83%00:00:00
TOTAL: 15 424 308186 22133 276177 9876 7%537:04:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org26.4 MB571.6 KB28.3 MB55.3 MB 47%4.7 KB
2news-out.aioe.org12.2 MB195.6 KB244.8 KB12.6 MB 96%2.6 KB
3newsfeed.datemas.de11.9 MB1.1 MB3.1 MB16.0 MB 74%3.8 KB
4feeder.eternal-september.org6.3 MB1.5 MB3.3 MB11.1 MB 56%5.8 KB
5news-out.mixmin.net6.2 MB547.4 KB1.8 MB8.5 MB 72%3.7 KB
6newsfeed.neva.ru3.5 MB401.1 KB2.7 MB6.5 MB 52%3.0 KB
7csiph.com2.6 MB463.7 KB497.3 KB3.5 MB 73%3.4 KB
8news.albasani.net2.2 MB1.1 MB1.7 MB5.0 MB 43%7.0 KB
9news.freedyn.net1.6 MB396.7 KB566.7 KB2.5 MB 62%8.5 KB
10news.redatomik.org1.5 MB607.7 KB778.0 KB2.9 MB 52%4.4 KB
11news.samoylyk.net1.1 MB1.3 MB5.3 MB7.7 MB 14%9.4 KB
12feeder.awxg.com591.9 KB420.6 KB424.8 KB1.4 MB 41%5.3 KB
13news.swapon.de229.8 KB68.0 KB70.2 KB367.9 KB 62%3.1 KB
14agency-nz-out.news.mb-net.net140.2 KB334.3 KB511.6 KB986.1 KB 14%5.9 KB
15localhost10.6 KB0.0 KB2.0 KB12.5 KB 84%2.1 KB
TOTAL: 1576.4 MB8.9 MB49.1 MB134.4 MB 56%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 6 23:58:02 - 23:59:59 33 0.1% 0.2874.2 KB 0.1% 0.63
Jul 7 00:00:00 - 00:59:59 1210 5.5% 0.343.8 MB 5.0% 1.07
Jul 7 01:00:00 - 01:59:59 1132 5.1% 0.313.7 MB 4.9% 1.05
Jul 7 02:00:00 - 02:59:59 1049 4.7% 0.293.7 MB 4.9% 1.05
Jul 7 03:00:00 - 03:59:59 1207 5.5% 0.344.2 MB 5.6% 1.20
Jul 7 04:00:00 - 04:59:59 1288 5.8% 0.363.6 MB 4.7% 1.02
Jul 7 05:00:00 - 05:59:59 1310 5.9% 0.363.6 MB 4.8% 1.02
Jul 7 06:00:00 - 06:59:59 1153 5.2% 0.325.2 MB 6.9% 1.48
Jul 7 07:00:00 - 07:59:59 1244 5.6% 0.354.2 MB 5.5% 1.19
Jul 7 08:00:00 - 08:59:59 1048 4.7% 0.293.9 MB 5.2% 1.11
Jul 7 09:00:00 - 09:59:59 1053 4.8% 0.294.6 MB 6.0% 1.30
Jul 7 10:00:00 - 10:59:59 796 3.6% 0.223.7 MB 4.8% 1.04
Jul 7 11:00:00 - 11:59:59 666 3.0% 0.182.0 MB 2.7% 0.57
Jul 7 12:00:00 - 12:59:59 594 2.7% 0.171.8 MB 2.3% 0.50
Jul 7 13:00:00 - 13:59:59 492 2.2% 0.141.8 MB 2.4% 0.51
Jul 7 14:00:00 - 14:59:59 532 2.4% 0.153.1 MB 4.1% 0.89
Jul 7 15:00:00 - 15:59:59 454 2.1% 0.132.1 MB 2.7% 0.59
Jul 7 16:00:00 - 16:59:59 556 2.5% 0.152.2 MB 3.0% 0.64
Jul 7 17:00:00 - 17:59:59 569 2.6% 0.161.8 MB 2.4% 0.51
Jul 7 18:00:00 - 18:59:59 699 3.2% 0.192.1 MB 2.8% 0.60
Jul 7 19:00:00 - 19:59:59 1003 4.5% 0.282.6 MB 3.5% 0.75
Jul 7 20:00:00 - 20:59:59 980 4.4% 0.272.8 MB 3.7% 0.80
Jul 7 21:00:00 - 21:59:59 1139 5.2% 0.323.8 MB 5.0% 1.07
Jul 7 22:00:00 - 22:59:59 978 4.4% 0.272.7 MB 3.6% 0.76
Jul 7 23:00:00 - 23:58:01 907 4.1% 0.262.8 MB 3.6% 0.81
TOTAL: 23:59:59 22092 100.0% 0.2675.7 MB 100.0% 0.90
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.2 GB 36.4% 0 0.31 1939.76
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.3 GB 42.6% 0 0.41 1484.83
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB226.3 MB 0.4% 0 0.0319145.30
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 GB4.3 GB 8.5% 0 0.78 775.34
TOTAL: 10-500.0 GB44.0 GB 8.8% 1 0.50-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5504 23 0 131 0 0 0 0 5350
2news-out.mixmin.net 833 0 0 139 0 0 0 0 694
3newsfeed.datemas.de 783 101 0 108 0 0 0 0 574
4newsfeed.neva.ru 767 19 0 95 0 0 0 0 653
5news.samoylyk.net 526 0 0 122 0 0 0 0 404
6feeder.eternal-september.org 501 0 0 199 1 0 0 0 301
7news.albasani.net 376 7 0 117 0 0 0 0 252
8news-out.aioe.org 250 0 0 77 0 0 0 0 173
9news.redatomik.org 202 0 0 101 0 0 0 0 101
10news.freedyn.net 162 3 0 88 0 0 0 0 71
11csiph.com 146 0 0 135 0 0 0 0 11
12agency-nz-out.news.mb-net.net 116 9 0 77 1 0 0 0 29
13feeder.awxg.com 105 0 0 98 0 0 0 0 7
14news.swapon.de 53 0 0 34 0 0 0 0 19
15news.ausics.org 9 0 0 8 0 0 0 0 1
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 10334 162 0 1529 2 0 0 0 8641

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.dev.platform 27
mozilla.support.seamonkey 20
mozilla.dev.security.policy 15
gmane.linux.alsa.devel 7
mozilla.dev.ui-alerts 6
fido7.ru.android 6
mozilla.support.bugzilla 6
gmane.linux.alsa.user 5
gmane.comp.gis.openstreetmap.tagging 5
alt.net.dn42.users 5
mozilla.compatibility 4
mozilla.dev.l10n 4
mpc.lists.freebsd.gnome 3
mozilla.dev.media 3
mpc.lists.nanog 3
mozilla.dev.servo 3
aus.politics.forum 3
gmane.linux.kernel.samsung-soc 2
al.christnet.bible 2
gmane.linux.kernel.stable 2
TOTAL: 49 162

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

GroupsCount
clari.biz.industry.food 1
nz.politics.announce 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7189
EMP (phn path) 705
EMP (phn nph) 170
EMP (phl) 49
Too many newsgroups 29
Binary: non-binary distribution 21
User-issued cancel 17
Binary: misplaced par2 7
HTML post 4
Binary: misplaced 003 2
Binary Image: misplaced jpg 2
Poison newsgroup 2
Binary: misplaced com 1
Binary Image: misplaced gif 1
Too many newsgroups (low_xpost) 1
Binary: misplaced 021 1
User-issued spam cancel 1
Binary: misplaced 011 1
Binary: misplaced 007 1
Binary: misplaced 025 1
TOTAL: 20 8205

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 157
news-out.aioe.org 144
news-out.mixmin.net 70
news.swapon.de 19
news.snarked.org 15
news.albasani.net 13
news.redatomik.org 8
feeder.awxg.com 3
feeder.eternal-september.org 3
newsfeed.neva.ru 3
TOTAL: 11 436
TOTAL: 1 436

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20522 849 19560 112 1 0 4%23:59:46
2awxg 21574 66 21447 11 0 14 0%23:59:47
3news.freedyn.net 22211 32 21907 0 0 103 0%23:59:46
4news.samoylyk.net 20458 14 20229 29 0 44 0%23:59:39
5news.snarked.org 15667 12 15537 0 0 24 0%23:59:46
6csiph.com 21207 6 21073 0 0 101 0%23:59:43
7news.redatomik.org 21384 5 21370 0 0 0 0%23:59:46
8mb-net.net 22086 5 22009 0 0 72 0%23:59:46
9aioe 15132 5 15010 0 0 0 0%23:59:46
10news.albasani.net 22534 4 19132 1330 0 6584 0%23:59:45
11eternal-september 18405 4 18348 0 0 93 0%23:59:46
12neva.ru 19959 4 19927 1 0 0 0%23:59:46
13newsfeed.datemas.de 18529 3 18451 0 0 144 0%23:59:46
14news-in.mixmin.net 18403 2 18357 3 0 13 0%23:59:45
15news.swapon.de 1842 0 1822 0 0 25 0%23:56:46
TOTAL: 15 279913 1011 274179 1486 1 7217 0%359:53:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.2 MB9.1 MB13.3 MB0.2 KB/s14.2 KB23:59:46
2awxg212.1 KB112.9 KB325.1 KB0.0 KB/s4.2 KB23:59:47
3news.freedyn.net148.6 KB0.0 KB148.6 KB0.0 KB/s4.6 KB23:59:46
4news.samoylyk.net47.3 KB174.7 KB222.0 KB0.0 KB/s5.2 KB23:59:39
5news.snarked.org27.4 KB0.0 KB27.4 KB0.0 KB/s2.3 KB23:59:46
6csiph.com15.6 KB0.0 KB15.6 KB0.0 KB/s2.6 KB23:59:43
7mb-net.net13.7 KB0.0 KB13.7 KB0.0 KB/s2.7 KB23:59:46
8news.redatomik.org10.6 KB0.0 KB10.6 KB0.0 KB/s2.1 KB23:59:46
9aioe10.6 KB0.0 KB10.6 KB0.0 KB/s2.1 KB23:59:46
10eternal-september8.1 KB0.0 KB8.1 KB0.0 KB/s2.0 KB23:59:46
11neva.ru8.1 KB2.5 KB10.6 KB0.0 KB/s2.1 KB23:59:46
12news.albasani.net7.2 KB3.7 MB3.7 MB0.0 KB/s2.9 KB23:59:45
13newsfeed.datemas.de6.0 KB0.0 KB6.0 KB0.0 KB/s2.0 KB23:59:46
14news-in.mixmin.net4.6 KB6.0 KB10.6 KB0.0 KB/s2.1 KB23:59:45
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:46
TOTAL: 154.7 MB13.1 MB17.8 MB0.0 KB/s7.3 KB359:53:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 338 627920.6 MB 3337 4 200:10:37
2static-103-243-239-29.bal.ausnetservers.net.au 24 13821.9 MB 157 0 000:05:31
3192.168.1.8 1 44191.8 KB 2 0 000:00:03
460.234.244.55 5 1242.8 KB 1 1 000:21:27
TOTAL: 4 368 771722.7 MB 3497 5 224:14:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 338 627920.6 MB 3337 4 200:10:37
2*.bal.ausnetservers.net.au 24 13821.9 MB 157 0 000:05:31
3unresolved 14 56234.6 KB 3 1 001:14:39
4*.cpe.cableone.net 4 00.0 KB 0 0 022:43:12
TOTAL: 4 380 771722.7 MB 3497 5 224:14:04

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
malcolmlewis 4
paulh 1
TOTAL: 4 34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.344 0.120 0.01522:43:12
118.149.238.83 0.352 0.044 0.00000:40:01
60.234.244.55 0.320 0.064 0.01200:21:27
118.149.157.104 0.176 0.036 0.00000:13:07
agency.bbs.geek.nz 24.248 5.328 0.00000:10:37
static-103-243-239-29.bal.ausnetservers.net.au 1.420 0.404 0.16200:05:31
192.168.1.8 0.092 0.016 0.00300:00:03
? 1.528 0.140 0.00000:00:02
TOTAL: 8 28.480 6.152 0.19224:14:04

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.238.83 5
67-61-218-236.cpe.cableone.net 4
118.149.157.104 3
TOTAL: 3 12

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 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.238.83 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3464 44.9%
2comp 1186 15.4%
3soc 868 11.3%
4sci 772 10.0%
5alt 655 8.5%
6talk 282 3.7%
7misc 168 2.2%
8uk 111 1.4%
9nz 79 1.0%
10news 69 0.9%
11humanities 24 0.3%
12aus 20 0.3%
13agency 8 0.1%
14eternal-september 7 0.1%
TOTAL: 14 7713100.0%

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

NewsgroupCount
1rec.arts.tv 1096
2comp.lang.python 432
3alt.comp.os.windows-10 375
4rec.arts.drwho 349
5rec.sport.tennis 277
6rec.arts.sf.written 231
7soc.culture.israel 225
8sci.physics 165
9alt.home.repair 163
10rec.sport.golf 158
11talk.politics.guns 152
12soc.culture.polish 127
13rec.food.cooking 117
14sci.electronics.design 115
15comp.os.linux.advocacy 107
16soc.retirement 106
17rec.arts.sf.fandom 100
18rec.sport.football.college 96
19talk.origins 85
20rec.bicycles.tech 79
21rec.gambling.poker 78
22comp.lang.c 75
23sci.physics.relativity 72
24nz.general 72
25rec.photo.digital 72
26rec.sport.pro-wrestling 70
27soc.penpals 70
28misc.survivalism 70
29uk.radio.amateur 67
30comp.sys.apple2 66
31rec.autos.tech 62
32sci.logic 59
33sci.med.pharmacy 58
34rec.outdoors.rv-travel 56
35misc.phone.mobile.iphone 50
36soc.culture.china 49
37alt.test 48
38alt.os.linux.ubuntu 48
39rec.autos.sport.f1 48
40sci.math 47
41rec.boats 44
42sci.electronics.repair 42
43soc.culture.indian 42
44rec.arts.movies.current-films 40
45sci.military.naval 40
46news.lists.filters 40
47comp.protocols.time.ntp 37
48sci.space.policy 36
49uk.comp.homebuilt 36
50soc.culture.vietnamese 35
51talk.politics.misc 34
52rec.music.classical.recordings 32
53soc.culture.singapore 31
54comp.lang.c++ 31
55rec.aviation.soaring 28
56comp.sys.acorn.apps 28
57comp.os.vms 27
58rec.arts.comics.strips 26
59comp.sys.apple2.programmer 26
60comp.mobile.ipad 25
61soc.culture.brazil 25
62sci.astro.amateur 24
63soc.culture.usa 24
64comp.mobile.android 22
65comp.lang.forth 21
66sci.math.symbolic 21
67comp.soft-sys.sas 20
68sci.math.num-analysis 19
69comp.soft-sys.matlab 19
70comp.arch 18
71misc.health.alternative 17
72sci.med.psychobiology 17
73comp.sys.acorn.networking 16
74comp.misc 16
75rec.games.pinball 16
76rec.arts.sf.science 16
77rec.woodworking 16
78rec.sport.cricket 16
79news.admin.net-abuse.email 15
80comp.sys.mac.vintage 14
81comp.soft-sys.math.scilab 14
82rec.games.video.sony 14
83humanities.lit.authors.shakespeare 13
84soc.culture.bulgaria 13
85comp.lang.lisp 13
86rec.radio.amateur.dx 13
87soc.culture.japan 12
88rec.music.artists.kiss 12
89rec.music.dylan 12
90rec.sport.soccer 12
91comp.sys.mac.system 12
92soc.genealogy.medieval 12
93rec.crafts.metalworking 11
94aus.computers 11
95soc.genealogy.jewish 11
96rec.radio.amateur.equipment 11
97comp.lang.fortran 10
98rec.arts.tv.uk.coronation-st 10
99rec.radio.shortwave 10
100sci.anthropology.paleo 10
TOTAL: 311 7713