news.bbs.geek.nz daily logs

Aug 5 23:58:01 -- Aug 6 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 119857 59.1%9.6 MB 38.0%
innd 31837 15.7%5.3 MB 20.9%
inn 26372 13.0%5.7 MB 22.6%
innfeed 23133 11.4%4.4 MB 17.5%
cnfsstat 1440 0.7%257.1 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 202640 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 237615 48.0%
Negative hits 232971 47.0%
Do not exist 24633 5.0%
Cache misses 175 0.0%
TOTAL: 4 495394 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.212 0.0%134 0.000 1.582 30.500
article cleanup00:00:00.226 0.0%25709 0.000 0.009 0.039
article logging00:00:00.651 0.0%26135 0.000 0.025 0.054
article parse00:00:00.838 0.0%80078 0.000 0.010 0.030
article write00:00:03.030 0.0%18001 0.016 0.168 9.177
artlog/artcncl00:00:00.099 0.0%119 0.000 0.832 24.250
data move00:00:00.383 0.0%479719 0.000 0.001 0.007
hisgrep/artcncl00:00:00.001 0.0%129 0.000 0.008 1.000
hishave/artcncl00:00:00.000 0.0%134 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.032 0.0%495472 0.001 0.012 0.810
history sync00:00:00.111 0.0%364 0.000 0.305 33.333
history write00:00:07.290 0.0%24628 0.019 0.296 22.481
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:48:01.764 99.8%497835 55.302 172.109 452.252
nntp read00:00:02.997 0.0%500099 0.003 0.006 0.034
overview write00:00:40.433 0.0%18001 0.064 2.246 89.228
perl filter00:00:54.145 0.1%24628 1.320 2.199 8.974
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.343 0.0%36002 0.010 0.037 0.107
TOTAL: 23:50:57.23523:49:59.555 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%24473 0.000 0.003 0.026
article prepare00:00:00.002 0.0%18042 0.000 0.000 0.013
article read00:00:00.323 0.0%3968 0.000 0.081 6.938
backlog stats00:00:00.269 0.0%294872 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.377 0.0%242384 0.000 0.006 0.010
data write00:00:02.727 0.0%230420 0.004 0.012 0.021
idle23:53:37.772100.0%294872 190.979 291.712 578.151
status file00:00:10.768 0.0%1879 0.700 5.731 198.583
TOTAL: 23:54:09.30323:53:53.303100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle16:35:28.466 92.6%127317 0.000 469.132 86116.335
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.960 0.0%271883 0.000 0.007 0.608
readart00:00:03.172 0.0%9307 0.000 0.341 45.208
TOTAL: 17:55:02.62616:35:33.598 92.6%----

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 63 16211 5620 10250 341 34%52:52:33
2news-out.mixmin.net 25 18821 3733 13891 1197 19%28:58:52
3feeder.eternal-september.org 79 22057 1972 18771 1314 8%51:22:11
4news-out.aioe.org 2 17098 1546 15498 54 9%23:12:20
5newsfeed.datemas.de 2 18702 1254 17111 337 6%23:18:57
6newsfeed.neva.ru 152 18713 1156 14674 2883 6%90:14:11
7csiph.com 3 18015 741 17215 59 4%24:08:55
8news.redatomik.org 1 17997 544 17359 94 3%25:00:58
9news.albasani.net 1 20277 461 19576 240 2%24:50:30
10feeder.awxg.com 2 15792 249 15480 63 1%23:59:49
11news.swapon.de 9 1867 156 1679 32 8%25:51:36
12news.samoylyk.net 1 23296 141 22458 697 0%23:28:10
13agency-nz-out.news.mb-net.net 18 18844 71 18583 190 0%33:40:15
14news.freedyn.net 2 19201 42 19089 70 0%23:11:11
15localhost 42 41 27 14 0 65%00:00:00
TOTAL: 15 402 246932 17713 221648 7571 7%474:10:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org18.6 MB235.4 KB1.1 MB19.9 MB 93%3.4 KB
2news-out.mixmin.net11.3 MB369.4 KB2.6 MB14.2 MB 79%3.0 KB
3feeder.eternal-september.org6.3 MB433.4 KB15.0 MB21.7 MB 29%6.7 KB
4newsfeed.datemas.de4.8 MB359.4 KB1.1 MB6.3 MB 77%4.0 KB
5news-out.aioe.org4.0 MB148.5 KB220.6 KB4.3 MB 91%2.8 KB
6newsfeed.neva.ru3.4 MB251.7 KB14.1 MB17.7 MB 18%4.5 KB
7news.albasani.net1.9 MB426.5 KB746.2 KB3.0 MB 62%4.5 KB
8csiph.com1.8 MB186.5 KB186.5 KB2.2 MB 83%2.8 KB
9news.redatomik.org1.4 MB392.7 KB397.5 KB2.2 MB 65%3.6 KB
10feeder.awxg.com714.6 KB167.1 KB167.7 KB1.0 MB 68%3.4 KB
11news.samoylyk.net706.8 KB223.3 KB4.6 MB5.5 MB 12%6.8 KB
12news.swapon.de475.5 KB105.5 KB105.5 KB686.6 KB 69%3.7 KB
13agency-nz-out.news.mb-net.net218.9 KB170.7 KB11.5 MB11.9 MB 1%46.6 KB
14news.freedyn.net179.2 KB250.0 KB301.9 KB731.1 KB 24%6.5 KB
15localhost47.1 KB0.0 KB0.0 KB47.1 KB100%1.7 KB
TOTAL: 1555.7 MB3.6 MB52.0 MB111.4 MB 50%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 5 23:58:01 - 23:59:59 19 0.1% 0.1657.2 KB 0.1% 0.48
Aug 6 00:00:00 - 00:59:59 930 5.1% 0.263.1 MB 5.4% 0.87
Aug 6 01:00:00 - 01:59:59 975 5.4% 0.273.2 MB 5.6% 0.90
Aug 6 02:00:00 - 02:59:59 965 5.3% 0.272.7 MB 4.8% 0.78
Aug 6 03:00:00 - 03:59:59 1103 6.1% 0.313.4 MB 6.0% 0.97
Aug 6 04:00:00 - 04:59:59 1044 5.8% 0.293.6 MB 6.4% 1.04
Aug 6 05:00:00 - 05:59:59 1074 5.9% 0.303.1 MB 5.5% 0.88
Aug 6 06:00:00 - 06:59:59 888 4.9% 0.252.6 MB 4.6% 0.74
Aug 6 07:00:00 - 07:59:59 960 5.3% 0.272.7 MB 4.7% 0.77
Aug 6 08:00:00 - 08:59:59 897 5.0% 0.252.8 MB 5.0% 0.80
Aug 6 09:00:00 - 09:59:59 837 4.6% 0.232.9 MB 5.0% 0.81
Aug 6 10:00:00 - 10:59:59 702 3.9% 0.202.2 MB 3.9% 0.64
Aug 6 11:00:00 - 11:59:59 554 3.1% 0.151.5 MB 2.6% 0.42
Aug 6 12:00:00 - 12:59:59 495 2.7% 0.141.6 MB 2.8% 0.46
Aug 6 13:00:00 - 13:59:59 624 3.4% 0.171.8 MB 3.2% 0.51
Aug 6 14:00:00 - 14:59:59 436 2.4% 0.121.6 MB 2.8% 0.45
Aug 6 15:00:00 - 15:59:59 398 2.2% 0.111.9 MB 3.4% 0.54
Aug 6 16:00:00 - 16:59:59 452 2.5% 0.131.6 MB 2.9% 0.46
Aug 6 17:00:00 - 17:59:59 376 2.1% 0.101.2 MB 2.2% 0.35
Aug 6 18:00:00 - 18:59:59 488 2.7% 0.141.7 MB 2.9% 0.47
Aug 6 19:00:00 - 19:59:59 626 3.5% 0.171.8 MB 3.2% 0.51
Aug 6 20:00:00 - 20:59:59 763 4.2% 0.212.2 MB 3.9% 0.62
Aug 6 21:00:00 - 21:59:59 907 5.0% 0.252.9 MB 5.0% 0.81
Aug 6 22:00:00 - 22:59:59 811 4.5% 0.232.4 MB 4.3% 0.69
Aug 6 23:00:00 - 23:58:02 771 4.3% 0.222.2 MB 3.8% 0.64
TOTAL: 24:00:01 18095 100.0% 0.2156.7 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.0 GB 38.0% 0 0.27 2212.38
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.1 GB 44.2% 0 0.28 2159.04
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB232.9 MB 0.5% 0 0.0322222.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 GB6.0 GB 11.9% 0 0.59 1023.86
TOTAL: 10-500.0 GB47.3 GB 9.5% 1 0.37-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2861 116 0 56 0 0 0 0 2689
2news-out.mixmin.net 1543 0 0 104 0 0 0 0 1439
3feeder.eternal-september.org 1355 0 0 141 0 0 0 0 1214
4news.samoylyk.net 725 0 0 84 0 0 0 0 641
5newsfeed.datemas.de 399 72 0 97 0 0 0 0 230
6news.snarked.org 345 26 0 77 0 0 0 0 242
7news.albasani.net 276 3 0 98 0 0 0 0 175
8agency-nz-out.news.mb-net.net 196 8 0 64 0 0 0 0 124
9news.redatomik.org 100 0 0 89 0 0 0 0 11
10news.swapon.de 77 0 0 33 0 0 0 0 44
11news-out.aioe.org 77 4 0 57 0 0 0 0 16
12news.freedyn.net 72 1 0 56 0 0 0 0 15
13csiph.com 68 0 0 65 0 0 0 0 3
14feeder.awxg.com 64 0 0 60 0 0 0 0 4
TOTAL: 14 8158 230 0 1081 0 0 0 0 6847

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 137
mpc.lists.freebsd.ports.bugs 18
mozilla.support.seamonkey 9
gmane.comp.gis.openstreetmap.tagging 7
mpc.lists.freebsd.x11 7
gmane.linux.kernel 6
mozilla.dev.platform 4
mpc.lists.freebsd.gnome 4
mozilla.test 4
alt.bbs.files-announce 3
alt.bbs.files-distribution 3
mozilla.dev.l10n.sr 3
gmane.linux.alsa.devel 2
mozilla.dev.ui-alerts 2
alt.fr.os.windows.7 2
mpc.lists.freebsd.office 2
gmane.linux.bios.flashrom 1
alt.penthouse.sex.girls 1
th.pubnet.pc 1
mozilla.dev.apps.seamonkey 1
TOTAL: 33 230

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5629
EMP (phn path) 371
EMP (phn nph) 220
Binary Image: misplaced jpg 106
Too many newsgroups 30
User-issued cancel 23
Binary: non-binary distribution 21
EMP (phl) 9
MID-Bot 3
Too many newsgroups (low_xpost) 2
HTML post 2
Cancel for rejected article 1
User-issued spam cancel 1
TOTAL: 13 6418

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 278
newsfeed.datemas.de 45
news.swapon.de 44
news.albasani.net 22
news-out.aioe.org 12
news.redatomik.org 7
feeder.eternal-september.org 6
news.snarked.org 5
feeder.awxg.com 4
newsfeed.neva.ru 3
TOTAL: 11 429
TOTAL: 1 429

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16299 3154 13095 50 0 31 19%23:59:49
2awxg 17795 118 17598 4 0 70 0%23:59:41
3news.freedyn.net 18380 52 17983 9 0 172 0%23:59:46
4news.snarked.org 12458 42 12318 0 0 90 0%23:59:49
5news.redatomik.org 17460 42 17389 2 0 127 0%23:59:48
6mb-net.net 18108 28 17959 3 0 96 0%23:59:48
7news.samoylyk.net 16200 25 16131 2 0 43 0%23:59:48
8csiph.com 17441 25 17340 2 0 13 0%23:59:44
9news-in.mixmin.net 13900 25 13853 2 0 42 0%23:59:48
10aioe 15406 22 15283 2 0 48 0%23:59:48
11neva.ru 16623 21 16593 6 0 10 0%23:59:48
12newsfeed.datemas.de 16773 19 16684 0 0 395 0%23:59:48
13news.swapon.de 1790 18 1749 0 0 27 1%23:52:49
14eternal-september 15432 17 15166 0 0 433 0%23:59:48
15news.albasani.net 18607 11 16379 727 1 4887 0%23:59:45
TOTAL: 15 232672 3619 225520 809 1 6484 1%359:49:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.5 MB530.0 KB11.1 MB0.1 KB/s3.5 KB23:59:49
2awxg357.3 KB34.7 KB392.0 KB0.0 KB/s3.2 KB23:59:41
3news.freedyn.net127.7 KB22.3 KB150.0 KB0.0 KB/s2.5 KB23:59:46
4news.snarked.org90.4 KB0.0 KB90.4 KB0.0 KB/s2.2 KB23:59:49
5news.redatomik.org86.8 KB3.3 KB90.1 KB0.0 KB/s2.0 KB23:59:48
6mb-net.net50.4 KB7.1 KB57.5 KB0.0 KB/s1.9 KB23:59:48
7news.samoylyk.net43.9 KB3.3 KB47.2 KB0.0 KB/s1.7 KB23:59:48
8csiph.com43.9 KB3.3 KB47.2 KB0.0 KB/s1.7 KB23:59:44
9news-in.mixmin.net43.9 KB3.3 KB47.2 KB0.0 KB/s1.7 KB23:59:48
10aioe40.5 KB3.3 KB43.8 KB0.0 KB/s1.8 KB23:59:48
11newsfeed.datemas.de37.2 KB0.0 KB37.2 KB0.0 KB/s2.0 KB23:59:48
12neva.ru36.6 KB10.6 KB47.2 KB0.0 KB/s1.7 KB23:59:48
13news.swapon.de35.0 KB0.0 KB35.0 KB0.0 KB/s1.9 KB23:52:49
14eternal-september33.3 KB0.0 KB33.3 KB0.0 KB/s2.0 KB23:59:48
15news.albasani.net23.3 KB3.0 MB3.1 MB0.0 KB/s4.2 KB23:59:45
TOTAL: 1511.6 MB3.6 MB15.2 MB0.0 KB/s3.5 KB359:49:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 394 615118.7 MB 3284 25 16800:13:59
267-61-81-51.cpe.cableone.net 24 10533.1 MB 155 1 000:19:06
3163.47.16.169 24 9361.2 MB 140 0 000:04:37
4avon.news.bbs.geek.nz 3 67.7 KB 2 1 000:34:36
567-61-218-236.cpe.cableone.net 1 45.5 KB 2 0 015:58:46
6192.168.1.10 1 44.8 KB 2 0 000:00:00
TOTAL: 6 447 815423.0 MB 3585 27 16817:54:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 394 615118.7 MB 3284 25 16800:13:59
2*.cpe.cableone.net 25 10573.1 MB 157 1 016:17:53
3unresolved 34 9401.2 MB 142 0 000:48:24
4*.news.bbs.geek.nz 3 67.7 KB 2 1 000:34:36
TOTAL: 4 456 815423.0 MB 3585 27 16817:54:55

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 24
paulh 4
malcolmlewis 1
TOTAL: 4 53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.100 0.012 0.00315:58:46
avon.news.bbs.geek.nz 0.252 0.040 0.00900:34:36
118.149.180.143 0.232 0.032 0.00000:20:05
67-61-81-51.cpe.cableone.net 1.428 0.440 0.10000:19:06
agency.bbs.geek.nz 27.796 6.492 0.00000:13:59
118.149.137.225 0.120 0.012 0.00000:13:38
118.149.198.209 0.108 0.024 0.00000:09:53
163.47.16.169 1.460 0.320 0.28300:04:37
203.118.151.117 0.084 0.008 0.00000:00:08
? 1.420 0.096 0.00000:00:02
192.168.1.10 0.060 0.012 0.00300:00:00
TOTAL: 11 33.060 7.488 0.39817:54:55

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.180.143 4
118.149.198.209 2
118.149.137.225 2
203.118.151.117 1
TOTAL: 4 9

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 3527 43.3%
2comp 1389 17.0%
3alt 1268 15.6%
4soc 802 9.8%
5sci 609 7.5%
6misc 185 2.3%
7talk 149 1.8%
8news 87 1.1%
9uk 69 0.8%
10humanities 24 0.3%
11aus 19 0.2%
12agency 13 0.2%
13nz 12 0.1%
14eternal-september 1 0.0%
TOTAL: 14 8154100.0%

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

NewsgroupCount
1rec.sport.tennis 796
2rec.arts.tv 713
3alt.atheism 626
4rec.arts.drwho 509
5comp.os.linux.advocacy 414
6comp.lang.python 251
7sci.physics 246
8rec.arts.sf.written 232
9alt.comp.os.windows-10 222
10soc.retirement 207
11comp.sys.mac.system 160
12rec.food.cooking 133
13soc.culture.israel 126
14alt.support.diabetes 108
15rec.boats 106
16rec.photo.digital 102
17comp.lang.c 93
18soc.culture.polish 92
19misc.survivalism 86
20soc.culture.singapore 86
21sci.physics.relativity 78
22sci.math 71
23news.lists.filters 70
24misc.health.alternative 70
25alt.bible 69
26alt.politics 67
27comp.ai.philosophy 66
28sci.electronics.design 61
29soc.culture.china 60
30rec.sport.football.college 58
31rec.radio.amateur.homebrew 58
32rec.bicycles.tech 58
33rec.sport.pro-wrestling 56
34rec.sport.soccer 56
35alt.recovery.aa 54
36comp.sys.mac.advocacy 53
37talk.politics.misc 52
38uk.radio.amateur 52
39rec.outdoors.rv-travel 50
40talk.politics.guns 50
41alt.test 47
42rec.arts.poems 44
43talk.origins 44
44rec.arts.movies.current-films 42
45rec.woodworking 41
46comp.lang.forth 39
47soc.culture.indian 36
48comp.lang.c++ 36
49comp.protocols.time.ntp 32
50rec.radio.amateur.misc 31
51rec.sport.cricket 28
52alt.tv.days-of-our-lives 25
53rec.arts.movies.past-films 24
54comp.sys.apple2 24
55soc.culture.romanian 23
56alt.astronomy 23
57sci.logic 22
58sci.military.naval 22
59soc.genealogy.britain 21
60humanities.lit.authors.shakespeare 21
61soc.culture.vietnamese 21
62comp.soft-sys.math.scilab 20
63comp.soft-sys.sas 20
64rec.sport.golf 20
65rec.gambling.lottery 19
66rec.gambling.poker 19
67misc.legal 18
68comp.os.vms 18
69rec.music.dylan 18
70comp.lang.ada 17
71comp.arch 16
72sci.anthropology.paleo 15
73rec.games.pinball 15
74sci.electronics.repair 15
75rec.games.trivia 14
76rec.aviation.soaring 14
77rec.music.classical.recordings 14
78alt.2600 14
79soc.culture.bulgaria 14
80rec.audio.opinion 13
81soc.culture.jewish 13
82rec.arts.disney.parks 13
83agency.test 13
84comp.arch.embedded 12
85rec.radio.shortwave 12
86sci.math.symbolic 12
87nz.general 12
88soc.penpals 12
89rec.music.rock-pop-r+b.1950s 12
90comp.sys.mac.apps 12
91uk.comp.homebuilt 11
92sci.med.cardiology 11
93comp.soft-sys.matlab 11
94rec.gardens.edible 11
95news.groups.questions 10
96sci.astro.amateur 10
97rec.games.video.sony 10
98soc.culture.usa 9
99rec.radio.amateur.dx 8
100soc.genealogy.medieval 8
TOTAL: 270 8154