news.bbs.geek.nz daily logs

Jul 25 23:58:02 -- Jul 26 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 98863 53.0%7.9 MB 32.0%
innd 31725 17.0%5.2 MB 21.0%
inn 31221 16.7%6.9 MB 27.7%
innfeed 23346 12.5%4.5 MB 18.3%
cnfsstat 1440 0.8%250.5 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 186596 100.0%24.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 312748 49.4%
Positive hits 290886 46.0%
Do not exist 29094 4.6%
Cache misses 282 0.0%
TOTAL: 4 633010 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.111 0.0%120 0.000 0.925 14.000
article cleanup00:00:00.259 0.0%30620 0.000 0.008 0.033
article logging00:00:00.822 0.0%31176 0.000 0.026 0.327
article parse00:00:00.897 0.0%74924 0.000 0.012 0.030
article write00:00:04.359 0.0%22593 0.015 0.193 11.803
artlog/artcncl00:00:00.002 0.0%113 0.000 0.018 0.143
data move00:00:00.598 0.0%575201 0.000 0.001 0.010
hisgrep/artcncl00:00:00.003 0.0%108 0.000 0.028 1.000
hishave/artcncl00:00:00.000 0.0%120 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.261 0.0%641951 0.001 0.014 1.067
history sync00:00:00.197 0.0%331 0.000 0.595 43.250
history write00:00:07.824 0.0%29436 0.022 0.266 18.511
hiswrite/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
idle23:57:18.567 99.8%593247 82.761 145.367 412.796
nntp read00:00:03.386 0.0%594916 0.003 0.006 0.013
overview write00:00:50.263 0.1%22593 0.062 2.225 98.987
perl filter00:00:59.790 0.1%29436 1.328 2.031 5.483
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.301 0.0%45186 0.006 0.029 0.108
TOTAL: 24:00:37.60523:59:37.640 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.082 0.0%30592 0.000 0.003 0.051
article prepare00:00:00.003 0.0%9852 0.000 0.000 0.010
article read00:00:00.203 0.0%2185 0.000 0.093 2.857
backlog stats00:00:00.350 0.0%346933 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.760 0.0%291431 0.001 0.006 0.011
data write00:00:03.074 0.0%280464 0.004 0.011 0.020
idle23:52:31.084100.0%346933 136.207 247.745 549.133
status file00:00:16.843 0.0%1953 0.750 8.624 416.200
TOTAL: 23:53:11.60523:52:53.399100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%6 0.000 0.000 0.000
idle32:06:52.765 98.2%106188 0.000 1088.755 94138.073
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.245 0.0%229033 0.000 0.005 0.333
readart00:00:03.373 0.0%8790 0.000 0.384 36.673
TOTAL: 32:42:49.76432:06:57.383 98.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 54 21305 6370 14443 492 29%59:51:47
2news.redatomik.org 2 20267 5583 14573 111 27%22:54:05
3newsfeed.datemas.de 3 24543 3385 20435 723 13%24:32:35
4news-out.mixmin.net 23 24997 1682 22087 1228 6%30:26:27
5newsfeed.neva.ru 154 13312 1495 9630 2187 11%88:50:23
6feeder.eternal-september.org 91 27859 1436 25079 1344 5%58:58:45
7news-out.aioe.org 2 16797 832 15716 249 4%15:47:02
8csiph.com 4 16444 610 15758 76 3%17:29:25
9news.samoylyk.net 1 43553 297 42435 821 0%25:51:10
10news.albasani.net 1 22416 209 21946 261 0%22:28:44
11feeder.awxg.com 2 20247 178 19966 103 0%23:59:53
12news.swapon.de 7 1717 120 1583 14 6%17:23:43
13news.freedyn.net 2 25411 103 25067 241 0%24:09:00
14agency-nz-out.news.mb-net.net 22 24921 50 24739 132 0%30:01:42
15localhost 10 9 8 0 1 88%00:00:00
TOTAL: 15 378 303798 22358 273457 7983 7%462:44:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.8 MB307.9 KB1.5 MB23.7 MB 92%3.5 KB
2news.redatomik.org14.1 MB289.7 KB333.9 KB14.7 MB 95%2.6 KB
3newsfeed.datemas.de10.9 MB389.8 KB2.1 MB13.4 MB 81%3.3 KB
4news-out.mixmin.net7.1 MB481.1 KB2.9 MB10.5 MB 67%3.7 KB
5feeder.eternal-september.org5.7 MB537.4 KB10.2 MB16.4 MB 34%6.1 KB
6newsfeed.neva.ru4.3 MB424.6 KB9.7 MB14.5 MB 29%4.0 KB
7news-out.aioe.org2.5 MB185.7 KB650.0 KB3.3 MB 75%3.1 KB
8csiph.com1.9 MB279.3 KB299.2 KB2.5 MB 77%3.7 KB
9news.samoylyk.net1.5 MB458.2 KB4.5 MB6.4 MB 23%5.8 KB
10news.albasani.net721.0 KB304.2 KB724.4 KB1.7 MB 41%3.7 KB
11feeder.awxg.com613.9 KB340.3 KB391.2 KB1.3 MB 45%4.8 KB
12news.freedyn.net556.4 KB281.5 KB800.6 KB1.6 MB 33%4.8 KB
13news.swapon.de313.2 KB41.6 KB41.6 KB396.5 KB 78%3.0 KB
14agency-nz-out.news.mb-net.net171.6 KB284.1 KB788.9 KB1.2 MB 13%6.8 KB
15localhost12.4 KB0.0 KB2.0 KB14.4 KB 86%1.6 KB
TOTAL: 1572.2 MB4.5 MB34.8 MB111.5 MB 64%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 25 23:58:02 - 23:59:59 26 0.1% 0.2243.3 KB 0.1% 0.37
Jul 26 00:00:00 - 00:59:59 1095 4.9% 0.302.8 MB 3.9% 0.80
Jul 26 01:00:00 - 01:59:59 1137 5.0% 0.323.3 MB 4.6% 0.95
Jul 26 02:00:00 - 02:59:59 1330 5.9% 0.374.0 MB 5.5% 1.15
Jul 26 03:00:00 - 03:59:59 1508 6.7% 0.424.8 MB 6.5% 1.35
Jul 26 04:00:00 - 04:59:59 1253 5.6% 0.353.9 MB 5.3% 1.10
Jul 26 05:00:00 - 05:59:59 1206 5.3% 0.343.8 MB 5.2% 1.07
Jul 26 06:00:00 - 06:59:59 1170 5.2% 0.334.0 MB 5.5% 1.13
Jul 26 07:00:00 - 07:59:59 1170 5.2% 0.333.9 MB 5.4% 1.12
Jul 26 08:00:00 - 08:59:59 1390 6.2% 0.394.9 MB 6.7% 1.39
Jul 26 09:00:00 - 09:59:59 1140 5.1% 0.323.8 MB 5.3% 1.09
Jul 26 10:00:00 - 10:59:59 872 3.9% 0.243.3 MB 4.5% 0.94
Jul 26 11:00:00 - 11:59:59 666 3.0% 0.182.9 MB 4.0% 0.84
Jul 26 12:00:00 - 12:59:59 570 2.5% 0.161.9 MB 2.6% 0.53
Jul 26 13:00:00 - 13:59:59 514 2.3% 0.142.3 MB 3.1% 0.64
Jul 26 14:00:00 - 14:59:59 469 2.1% 0.132.5 MB 3.5% 0.72
Jul 26 15:00:00 - 15:59:59 423 1.9% 0.121.5 MB 2.1% 0.43
Jul 26 16:00:00 - 16:59:59 464 2.1% 0.131.6 MB 2.3% 0.47
Jul 26 17:00:00 - 17:59:59 520 2.3% 0.141.7 MB 2.4% 0.50
Jul 26 18:00:00 - 18:59:59 697 3.1% 0.192.2 MB 3.0% 0.62
Jul 26 19:00:00 - 19:59:59 799 3.5% 0.222.2 MB 3.0% 0.62
Jul 26 20:00:00 - 20:59:59 1125 5.0% 0.313.0 MB 4.1% 0.86
Jul 26 21:00:00 - 21:59:59 1027 4.6% 0.292.9 MB 3.9% 0.82
Jul 26 22:00:00 - 22:59:59 1051 4.7% 0.292.7 MB 3.7% 0.77
Jul 26 23:00:00 - 23:58:01 943 4.2% 0.272.8 MB 3.8% 0.82
TOTAL: 23:59:59 22565 100.0% 0.2672.8 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.7 GB 37.4% 0 0.34 1807.83
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.8 GB 43.6% 0 0.33 1848.01
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB230.0 MB 0.4% 0 0.0610457.52
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.3 GB 10.7% 0 0.79 766.08
TOTAL: 10-500.0 GB46.1 GB 9.2% 1 0.49-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2186 122 0 69 0 0 0 0 1995
2feeder.eternal-september.org 1332 0 0 143 0 0 0 0 1189
3news-out.mixmin.net 1270 0 0 117 0 0 0 0 1153
4newsfeed.datemas.de 898 250 0 95 0 0 0 0 553
5news.samoylyk.net 780 0 0 106 0 0 0 0 674
6news.snarked.org 514 30 0 99 0 0 0 0 385
7news.redatomik.org 368 0 0 83 0 0 0 0 285
8news.albasani.net 291 0 0 80 0 0 0 0 211
9news-out.aioe.org 287 21 0 64 0 0 0 0 202
10news.freedyn.net 244 19 0 55 0 0 0 0 170
11agency-nz-out.news.mb-net.net 122 22 0 63 0 0 0 0 37
12feeder.awxg.com 100 3 0 81 0 0 0 0 16
13csiph.com 95 0 0 88 0 0 0 0 7
14news.swapon.de 52 0 0 19 0 0 0 0 33
15news.ausics.org 3 0 0 3 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 8543 467 0 1165 0 0 0 0 6911

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 115
mozilla.dev.l10n 42
it.annunci.commerciali 36
mozilla.support.seamonkey 36
it.annunci.immobiliari 36
it.annunci.varie 34
gmane.linux.alsa.devel 28
mozilla.dev.platform 25
gmane.linux.kernel 24
mozilla.dev.security.policy 14
gmane.comp.gis.openstreetmap.tagging 6
mozilla.dev.servo 6
de.comp.lang.perl.misc 5
mozilla.dev.ui-alerts 5
mpc.lists.nanog 4
mozilla.support.calendar 3
gmane.linux.drivers.devicetree 3
mozilla.dev.apps.seamonkey 3
mozilla.dev.l10n.sr 2
gmane.comp.hardware.netbook.arm.sunxi 2
TOTAL: 53 467

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5202
EMP (phn path) 893
EMP (phn nph) 158
Too many newsgroups 51
User-issued cancel 19
Binary: non-binary distribution 9
Too many newsgroups (meow) 8
Too many newsgroups (low_xpost) 7
Cancel for rejected article 6
HTML post 1
Binary: misplaced ARJ 1
U2 violation - invalid distribution 1
TOTAL: 12 6356

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 253
newsfeed.datemas.de 174
news-out.mixmin.net 48
news.swapon.de 33
news.snarked.org 14
news-out.aioe.org 11
newsfeed.neva.ru 8
news.albasani.net 7
news.samoylyk.net 5
feeder.awxg.com 1
TOTAL: 11 555
TOTAL: 1 555

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20913 901 19970 42 0 0 4%23:59:45
2awxg 21979 120 21842 6 0 12 0%23:59:42
3mb-net.net 22501 17 22438 1 0 0 0%23:59:46
4news.freedyn.net 22787 11 22422 0 0 228 0%23:59:46
5news.snarked.org 16163 11 16071 0 0 2 0%23:59:37
6neva.ru 20522 9 20506 0 0 0 0%23:59:46
7csiph.com 21954 9 21798 0 0 3 0%23:59:37
8aioe 18515 8 18336 0 0 6 0%23:59:43
9news.samoylyk.net 20677 8 20614 4 0 30 0%23:59:32
10news-in.mixmin.net 20010 8 19985 0 0 0 0%23:59:46
11eternal-september 19119 8 19086 1 0 0 0%23:59:42
12news.redatomik.org 16919 7 16902 0 0 0 0%23:59:44
13newsfeed.datemas.de 19102 5 19050 0 0 141 0%23:59:46
14news.albasani.net 22790 3 19697 1163 0 7696 0%23:59:46
15news.swapon.de 2174 0 2174 0 0 0 0%23:50:07
TOTAL: 15 286125 1125 280891 1217 0 8118 0%359:46:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org5.7 MB1.4 MB7.1 MB0.1 KB/s7.7 KB23:59:45
2awxg505.4 KB29.9 KB535.3 KB0.0 KB/s4.2 KB23:59:42
3mb-net.net87.0 KB80.6 KB167.6 KB0.0 KB/s9.3 KB23:59:46
4news.freedyn.net76.8 KB0.0 KB76.8 KB0.0 KB/s7.0 KB23:59:46
5neva.ru41.6 KB0.0 KB41.6 KB0.0 KB/s4.6 KB23:59:46
6news.snarked.org23.1 KB0.0 KB23.1 KB0.0 KB/s2.1 KB23:59:37
7csiph.com14.7 KB0.0 KB14.7 KB0.0 KB/s1.6 KB23:59:37
8aioe12.5 KB0.0 KB12.5 KB0.0 KB/s1.6 KB23:59:43
9news.samoylyk.net12.5 KB7.6 KB20.0 KB0.0 KB/s1.7 KB23:59:32
10news-in.mixmin.net12.5 KB0.0 KB12.5 KB0.0 KB/s1.6 KB23:59:46
11eternal-september12.5 KB2.6 KB15.1 KB0.0 KB/s1.7 KB23:59:42
12news.redatomik.org11.3 KB0.0 KB11.3 KB0.0 KB/s1.6 KB23:59:44
13news.albasani.net7.7 KB3.6 MB3.6 MB0.0 KB/s3.2 KB23:59:46
14newsfeed.datemas.de6.6 KB0.0 KB6.6 KB0.0 KB/s1.3 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:07
TOTAL: 156.5 MB5.1 MB11.6 MB0.0 KB/s5.1 KB359:46:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 331 644921.7 MB 3461 6 200:10:52
2163.47.16.169 24 13181.7 MB 164 0 000:05:39
3192.168.1.10 1 53185.9 KB 7 0 000:00:01
460.234.244.55 6 1532.3 KB 1 1 000:25:18
567-61-218-236.cpe.cableone.net 1 11.4 KB 2 0 031:25:54
TOTAL: 5 363 783623.6 MB 3635 7 232:42:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 331 644921.7 MB 3461 6 200:10:52
2unresolved 40 13862.0 MB 172 1 001:05:54
3*.cpe.cableone.net 1 11.4 KB 2 0 031:25:54
TOTAL: 3 372 783623.6 MB 3635 7 232:42:43

NNRP auth users [Top 20]:

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.108 0.052 0.00331:25:54
60.234.244.55 0.428 0.048 0.01600:25:18
202.174.187.54 0.232 0.040 0.00000:16:37
agency.bbs.geek.nz 23.764 5.424 0.00000:10:52
118.149.142.201 0.104 0.032 0.00000:10:03
118.149.128.0 0.124 0.020 0.00000:08:12
163.47.16.169 1.400 0.388 0.24800:05:39
? 1.392 0.172 0.00000:00:02
192.168.1.10 0.088 0.024 0.00300:00:01
125.212.217.214 0.052 0.004 0.00000:00:00
TOTAL: 10 27.692 6.204 0.27032:42:43

Curious NNRP server explorers [Top 20]:

SystemConn
202.174.187.54 4
118.149.142.201 2
118.149.128.0 2
125.212.217.214 1
TOTAL: 4 9

NNRP gethostbyaddr failures [Top 20]:

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

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 3573 45.6%
2comp 1523 19.4%
3soc 848 10.8%
4sci 807 10.3%
5alt 409 5.2%
6talk 220 2.8%
7misc 189 2.4%
8uk 76 1.0%
9news 68 0.9%
10nz 58 0.7%
11humanities 33 0.4%
12aus 18 0.2%
13agency 9 0.1%
TOTAL: 13 7831100.0%

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

NewsgroupCount
1rec.arts.tv 880
2rec.arts.drwho 482
3comp.lang.c 368
4comp.os.linux.advocacy 344
5rec.arts.sf.written 329
6rec.sport.tennis 272
7alt.comp.os.windows-10 250
8rec.food.cooking 245
9comp.lang.python 235
10sci.physics 206
11soc.retirement 165
12sci.electronics.design 142
13misc.survivalism 141
14soc.culture.israel 135
15rec.sport.football.college 135
16rec.sport.golf 118
17talk.politics.guns 104
18rec.sport.pro-wrestling 100
19sci.physics.relativity 99
20comp.lang.c++ 90
21soc.culture.polish 88
22soc.culture.singapore 68
23uk.radio.amateur 68
24news.lists.filters 64
25talk.origins 64
26soc.penpals 64
27nz.general 58
28rec.arts.tv.uk.coronation-st 56
29comp.lang.forth 55
30sci.math.num-analysis 50
31rec.bicycles.tech 49
32sci.lang 48
33alt.test 48
34rec.arts.movies.past-films 46
35rec.music.classical.recordings 45
36rec.gambling.poker 44
37sci.med.pharmacy 44
38talk.politics.misc 43
39rec.music.dylan 40
40comp.sys.apple2 40
41rec.audio.pro 40
42sci.astro.amateur 40
43comp.protocols.time.ntp 40
44comp.os.vms 39
45sci.math 38
46soc.culture.china 38
47rec.boats 37
48soc.culture.indian 36
49soc.culture.vietnamese 34
50alt.comp.os.windows-xp 34
51rec.outdoors.rv-travel 34
52rec.radio.shortwave 34
53rec.arts.sf.tv 33
54soc.culture.african.american 32
55soc.women 31
56sci.logic 30
57alt.os.linux.ubuntu 30
58rec.sport.soccer 30
59soc.culture.usa 30
60rec.autos.tech 28
61rec.arts.movies.current-films 28
62rec.arts.sf.fandom 27
63soc.genealogy.medieval 26
64comp.mobile.android 26
65rec.games.trivia 26
66rec.audio.opinion 26
67comp.soft-sys.matlab 25
68rec.aviation.soaring 25
69rec.music.rock-pop-r+b.1950s 24
70rec.arts.disney.parks 23
71rec.radio.amateur.antenna 22
72sci.bio.paleontology 21
73comp.soft-sys.math.scilab 20
74comp.sys.mac.system 20
75comp.soft-sys.sas 20
76rec.games.pinball 19
77humanities.music.composers.wagner 18
78rec.radio.amateur.misc 18
79comp.arch 18
80sci.military.naval 18
81misc.phone.mobile.iphone 16
82comp.infosystems.www.authoring.stylesheets 15
83soc.genealogy.benelux 13
84rec.photo.digital 12
85rec.autos.sport.f1 12
86humanities.lit.authors.shakespeare 12
87alt.bbs.ads 12
88comp.mobile.ipad 11
89rec.gambling.lottery 11
90misc.health.alternative 11
91rec.music.classical.guitar 11
92comp.lang.fortran 11
93sci.electronics.repair 11
94soc.veterans 11
95comp.lang.lisp 10
96comp.misc 10
97rec.puzzles.crosswords 10
98soc.culture.brazil 9
99agency.test 9
100aus.radio.amateur.misc 9
TOTAL: 267 7831