news.bbs.geek.nz daily logs

Jul 29 23:58:01 -- Jul 30 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 114740 58.6%9.2 MB 37.1%
innd 30568 15.6%5.0 MB 20.3%
inn 25971 13.3%5.7 MB 23.2%
innfeed 22984 11.7%4.6 MB 18.4%
cnfsstat 1440 0.7%253.2 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 195704 100.0%24.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 244519 48.0%
Negative hits 240199 47.2%
Do not exist 23980 4.7%
Cache misses 199 0.0%
TOTAL: 4 508897 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.162 0.0%166 0.000 0.976 30.000
article cleanup00:00:00.239 0.0%25296 0.000 0.009 0.031
article logging00:00:00.769 0.0%25825 0.000 0.030 0.353
article parse00:00:00.764 0.0%66994 0.000 0.011 0.026
article write00:00:01.672 0.0%18544 0.022 0.090 2.395
artlog/artcncl00:00:00.002 0.0%155 0.000 0.013 0.182
data move00:00:00.395 0.0%485045 0.000 0.001 0.007
hisgrep/artcncl00:00:00.004 0.0%152 0.000 0.026 1.000
hishave/artcncl00:00:00.000 0.0%166 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.602 0.0%511782 0.001 0.009 0.485
history sync00:00:00.012 0.0%370 0.000 0.032 0.667
history write00:00:05.256 0.0%24116 0.012 0.218 11.033
hiswrite/artcncl00:00:00.003 0.0%14 0.000 0.214 1.000
idle23:58:23.907 99.8%506072 104.997 170.537 471.255
nntp read00:00:03.157 0.0%507622 0.003 0.006 0.020
overview write00:00:35.731 0.0%18544 0.053 1.927 57.044
perl filter00:00:49.216 0.1%24116 1.370 2.041 3.738
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.207 0.0%37088 0.006 0.033 0.122
TOTAL: 24:00:59.20224:00:07.098 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%23155 0.000 0.002 0.026
article prepare00:00:00.002 0.0%13518 0.000 0.000 0.009
article read00:00:00.366 0.0%3135 0.000 0.117 9.000
backlog stats00:00:00.241 0.0%302115 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.452 0.0%249962 0.001 0.006 0.010
data write00:00:02.771 0.0%235405 0.005 0.012 0.019
idle23:54:20.962100.0%302115 175.961 284.862 675.362
status file00:00:07.118 0.0%1819 0.700 3.913 131.500
TOTAL: 23:54:49.12323:54:32.961100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.002 0.0%39 0.000 0.051 0.143
idle01:01:18.343 54.8%121061 0.000 30.384 75290.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.439 0.0%259456 0.000 0.006 0.333
readart00:00:02.496 0.0%9234 0.000 0.270 21.359
TOTAL: 01:51:47.04201:01:22.280 54.9%----

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 53 17010 5783 10702 525 33%52:30:14
2news-out.mixmin.net 15 20556 3478 15885 1193 16%27:37:04
3feeder.eternal-september.org 72 22001 2168 18868 965 9%49:54:53
4news.redatomik.org 1 11794 1757 9974 63 14%14:03:12
5news-out.aioe.org 2 25177 1158 23873 146 4%33:35:02
6newsfeed.neva.ru 148 17063 1053 14164 1846 6%89:54:54
7news.albasani.net 1 18862 1015 17485 362 5%22:36:42
8csiph.com 3 18421 753 17591 77 4%24:08:55
9news.freedyn.net 2 20766 412 20121 233 1%23:54:34
10feeder.awxg.com 2 16476 272 16119 85 1%23:59:56
11agency-nz-out.news.mb-net.net 21 20627 166 20276 185 0%33:49:08
12news.swapon.de 4 1929 160 1728 41 8%25:18:10
13newsfeed.datemas.de 2 20213 131 19886 196 0%23:59:27
14news.samoylyk.net 1 19243 128 18474 641 0%19:57:32
15localhost 8 7 7 0 0 100%00:00:00
TOTAL: 15 335 250145 18441 225146 6558 7%465:19:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.3 MB285.0 KB2.1 MB21.7 MB 89%3.5 KB
2news-out.mixmin.net10.3 MB409.0 KB2.5 MB13.2 MB 78%2.9 KB
3feeder.eternal-september.org6.9 MB976.3 KB8.1 MB15.9 MB 43%5.2 KB
4news.albasani.net4.3 MB554.6 KB1.0 MB5.8 MB 73%4.3 KB
5news.redatomik.org4.2 MB283.7 KB288.3 KB4.8 MB 88%2.7 KB
6news-out.aioe.org3.4 MB266.9 KB409.7 KB4.0 MB 83%3.2 KB
7newsfeed.neva.ru3.0 MB284.0 KB9.6 MB12.8 MB 23%4.5 KB
8csiph.com2.0 MB281.9 KB306.9 KB2.6 MB 77%3.2 KB
9news.freedyn.net1.6 MB341.6 KB738.0 KB2.6 MB 60%4.2 KB
10news.samoylyk.net1.2 MB281.2 KB5.0 MB6.5 MB 18%8.6 KB
11newsfeed.datemas.de862.4 KB1.3 MB1.8 MB3.9 MB 21%12.4 KB
12feeder.awxg.com761.7 KB381.8 KB413.3 KB1.5 MB 48%4.4 KB
13agency-nz-out.news.mb-net.net430.8 KB437.7 KB787.0 KB1.6 MB 26%4.7 KB
14news.swapon.de429.8 KB165.0 KB165.0 KB759.8 KB 56%3.8 KB
15localhost10.2 KB0.0 KB0.0 KB10.2 KB100%1.5 KB
TOTAL: 1558.6 MB6.2 MB33.0 MB97.8 MB 59%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 29 23:58:01 - 23:59:59 27 0.1% 0.2370.7 KB 0.1% 0.59
Jul 30 00:00:00 - 00:59:59 754 4.1% 0.212.0 MB 3.4% 0.57
Jul 30 01:00:00 - 01:59:59 1086 5.9% 0.303.5 MB 5.9% 0.99
Jul 30 02:00:00 - 02:59:59 1078 5.8% 0.303.7 MB 6.3% 1.06
Jul 30 03:00:00 - 03:59:59 1108 6.0% 0.313.8 MB 6.4% 1.08
Jul 30 04:00:00 - 04:59:59 1084 5.8% 0.303.1 MB 5.3% 0.89
Jul 30 05:00:00 - 05:59:59 932 5.0% 0.262.6 MB 4.3% 0.73
Jul 30 06:00:00 - 06:59:59 932 5.0% 0.262.9 MB 4.9% 0.82
Jul 30 07:00:00 - 07:59:59 1041 5.6% 0.293.1 MB 5.2% 0.87
Jul 30 08:00:00 - 08:59:59 1018 5.5% 0.283.2 MB 5.4% 0.90
Jul 30 09:00:00 - 09:59:59 891 4.8% 0.253.9 MB 6.6% 1.11
Jul 30 10:00:00 - 10:59:59 729 3.9% 0.202.1 MB 3.5% 0.59
Jul 30 11:00:00 - 11:59:59 600 3.2% 0.172.0 MB 3.3% 0.56
Jul 30 12:00:00 - 12:59:59 502 2.7% 0.142.2 MB 3.7% 0.62
Jul 30 13:00:00 - 13:59:59 560 3.0% 0.161.8 MB 3.0% 0.51
Jul 30 14:00:00 - 14:59:59 527 2.8% 0.151.8 MB 3.1% 0.52
Jul 30 15:00:00 - 15:59:59 438 2.4% 0.121.7 MB 2.8% 0.47
Jul 30 16:00:00 - 16:59:59 428 2.3% 0.121.5 MB 2.5% 0.42
Jul 30 17:00:00 - 17:59:59 415 2.2% 0.121.4 MB 2.4% 0.39
Jul 30 18:00:00 - 18:59:59 520 2.8% 0.141.8 MB 3.1% 0.52
Jul 30 19:00:00 - 19:59:59 606 3.3% 0.171.9 MB 3.3% 0.55
Jul 30 20:00:00 - 20:59:59 740 4.0% 0.212.1 MB 3.5% 0.58
Jul 30 21:00:00 - 21:59:59 819 4.4% 0.232.2 MB 3.7% 0.62
Jul 30 22:00:00 - 22:59:59 858 4.6% 0.242.4 MB 4.0% 0.67
Jul 30 23:00:00 - 23:58:02 852 4.6% 0.242.4 MB 4.1% 0.70
TOTAL: 24:00:01 18545 100.0% 0.2158.8 MB 100.0% 0.70
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.8 GB 37.6% 0 0.30 2020.11
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.9 GB 43.8% 0 0.30 2007.67
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB231.2 MB 0.5% 0 0.0320180.18
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.6 GB 11.1% 0 0.58 1052.04
TOTAL: 10-500.0 GB46.5 GB 9.3% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1877 91 0 56 0 0 0 0 1730
2news-out.mixmin.net 1445 0 0 96 0 0 0 0 1349
3feeder.eternal-september.org 1010 0 0 145 0 0 0 0 865
4news.samoylyk.net 727 0 0 99 0 0 0 0 628
5news.snarked.org 535 21 0 81 0 0 0 0 433
6news.albasani.net 470 4 0 111 0 0 0 0 355
7news.freedyn.net 238 3 0 65 0 0 0 0 170
8news.redatomik.org 234 0 0 94 0 0 0 0 140
9agency-nz-out.news.mb-net.net 188 29 0 84 0 0 0 0 75
10newsfeed.datemas.de 182 22 0 105 0 0 0 0 55
11news-out.aioe.org 121 2 0 60 0 0 0 0 59
12news.swapon.de 86 0 0 43 0 0 0 0 43
13feeder.awxg.com 79 1 0 69 0 0 0 0 9
14csiph.com 76 0 0 69 0 0 0 0 7
15news.ausics.org 3 0 0 3 0 0 0 0 0
TOTAL: 15 7271 173 0 1180 0 0 0 0 5918

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 80
gmane.comp.hardware.netbook.arm.sunxi 12
eagle.support.eng 10
mpc.lists.freebsd.ports.bugs 10
gmane.comp.gis.openstreetmap.tagging 10
gmane.linux.alsa.devel 6
mozilla.dev.l10n.sr 4
mozilla.dev.l10n 4
mozilla.dev.security.policy 4
mozilla.support.seamonkey 3
alt.fr.os.windows.7 2
0.test 2
albasani.test 2
mozilla.community.india 2
mozilla.apis 2
mpc.lists.freebsd.gnome 2
mozilla.release.engineering 2
demos.local.statistics 1
mozilla.wishlist 1
gmane.linux.bios.flashrom 1
TOTAL: 33 173

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4468
EMP (phn path) 661
EMP (phn nph) 169
Too many newsgroups 52
User-issued cancel 18
Binary: non-binary distribution 15
HTML post 4
Cancel for rejected article 2
Too many newsgroups (meow) 1
U2 violation - invalid distribution 1
PFM bot misc 1
TOTAL: 11 5392

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 256
news.redatomik.org 90
news.albasani.net 76
news.swapon.de 43
news-out.aioe.org 16
newsfeed.neva.ru 12
news.snarked.org 8
agency-nz-out.news.mb-net.net 6
feeder.awxg.com 6
news.samoylyk.net 5
TOTAL: 13 526
TOTAL: 1 526

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16679 2312 14303 63 1 0 13%23:59:38
2awxg 18024 73 17940 2 0 9 0%23:59:39
3news.freedyn.net 18289 10 18109 3 0 14 0%23:59:36
4news.snarked.org 12762 9 12651 1 0 108 0%23:59:48
5aioe 15514 8 15421 0 0 0 0%23:59:48
6news.redatomik.org 16703 8 16673 1 0 0 0%23:59:48
7news.samoylyk.net 16558 7 16526 0 0 0 0%23:59:47
8eternal-september 15438 7 15392 0 0 0 0%23:59:48
9csiph.com 17936 7 17830 0 0 0 0%23:59:48
10mb-net.net 18389 7 18339 0 0 0 0%23:59:47
11news-in.mixmin.net 14759 7 14731 0 0 0 0%23:59:45
12news.albasani.net 18459 6 16404 795 0 4489 0%23:59:40
13newsfeed.datemas.de 18315 3 18293 4 0 0 0%23:59:48
14neva.ru 17326 2 17315 5 0 0 0%23:59:48
15news.swapon.de 1885 0 1884 0 0 0 0%23:54:36
TOTAL: 15 237036 2466 231811 874 1 4620 1%359:51:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.2 MB1.0 MB8.2 MB0.1 KB/s3.6 KB23:59:38
2awxg320.4 KB67.6 KB388.0 KB0.0 KB/s5.2 KB23:59:39
3news.snarked.org16.1 KB1.3 KB17.5 KB0.0 KB/s1.7 KB23:59:48
4news.redatomik.org15.9 KB1.2 KB17.1 KB0.0 KB/s1.9 KB23:59:48
5news.freedyn.net15.3 KB44.4 KB59.7 KB0.0 KB/s4.6 KB23:59:36
6aioe11.9 KB0.0 KB11.9 KB0.0 KB/s1.5 KB23:59:48
7news.samoylyk.net10.3 KB0.0 KB10.3 KB0.0 KB/s1.5 KB23:59:47
8eternal-september10.3 KB0.0 KB10.3 KB0.0 KB/s1.5 KB23:59:48
9csiph.com10.3 KB0.0 KB10.3 KB0.0 KB/s1.5 KB23:59:48
10mb-net.net10.3 KB0.0 KB10.3 KB0.0 KB/s1.5 KB23:59:47
11news-in.mixmin.net10.3 KB0.0 KB10.3 KB0.0 KB/s1.5 KB23:59:45
12news.albasani.net8.8 KB3.1 MB3.1 MB0.0 KB/s4.0 KB23:59:40
13newsfeed.datemas.de5.1 KB5.2 KB10.3 KB0.0 KB/s1.5 KB23:59:48
14neva.ru3.4 KB6.9 KB10.3 KB0.0 KB/s1.5 KB23:59:48
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:36
TOTAL: 157.6 MB4.2 MB11.9 MB0.0 KB/s3.6 KB359:51:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 372 596920.1 MB 3234 7 000:11:54
2163.47.16.169 24 14052.1 MB 134 0 000:05:43
367-61-81-51.cpe.cableone.net 25 7172.1 MB 78 0 000:13:29
4mic1062344.lnk.telstra.net 10 64298.5 KB 1 0 000:31:13
TOTAL: 4 431 815524.6 MB 3448 7 001:51:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 372 596920.1 MB 3234 7 000:11:54
2unresolved 37 14052.1 MB 134 0 000:55:00
3*.cpe.cableone.net 25 7172.1 MB 79 0 000:13:29
4*.lnk.telstra.net 10 64298.5 KB 1 0 000:31:13
TOTAL: 4 444 815524.6 MB 3448 7 001:51:40

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 7
TOTAL: 2 31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mic1062344.lnk.telstra.net 0.700 0.072 0.02000:31:13
118.149.252.165 0.292 0.052 0.00000:25:08
202.174.187.54 0.304 0.036 0.00000:13:59
67-61-81-51.cpe.cableone.net 1.380 0.360 0.00000:13:29
agency.bbs.geek.nz 26.768 6.108 0.00000:11:54
118.149.132.144 0.116 0.024 0.00000:10:02
163.47.16.169 1.356 0.432 0.14800:05:43
203.118.151.117 0.084 0.012 0.00000:00:06
? 1.320 0.224 0.00000:00:02
TOTAL: 9 32.320 7.320 0.16801:51:40

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.252.165 5
202.174.187.54 5
118.149.132.144 2
203.118.151.117 1
TOTAL: 4 13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
mic1062344.lnk.telstra.net 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 3649 44.9%
2comp 1374 16.9%
3alt 1097 13.5%
4soc 777 9.6%
5sci 501 6.2%
6misc 235 2.9%
7talk 234 2.9%
8news 99 1.2%
9uk 46 0.6%
10nz 32 0.4%
11humanities 27 0.3%
12agency 25 0.3%
13aus 18 0.2%
14eternal-september 4 0.0%
TOTAL: 14 8118100.0%

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

NewsgroupCount
1rec.arts.tv 1560
2alt.atheism 536
3comp.os.linux.advocacy 401
4rec.arts.drwho 317
5alt.comp.os.windows-10 278
6comp.lang.c 272
7comp.lang.python 194
8soc.retirement 188
9misc.survivalism 179
10rec.sport.tennis 168
11rec.food.cooking 167
12rec.sport.golf 158
13rec.arts.sf.written 134
14rec.boats 134
15soc.culture.polish 120
16sci.physics 113
17sci.electronics.design 94
18rec.photo.digital 92
19news.lists.filters 92
20soc.culture.china 92
21talk.politics.guns 92
22alt.politics 85
23rec.sport.football.college 83
24sci.math 73
25sci.physics.relativity 68
26talk.politics.misc 66
27soc.culture.singapore 65
28soc.culture.israel 64
29comp.sys.apple2 58
30rec.arts.movies.past-films 56
31talk.origins 56
32rec.bicycles.tech 53
33rec.gambling.poker 43
34comp.lang.c++ 42
35rec.audio.opinion 42
36comp.os.vms 40
37rec.sport.pro-wrestling 40
38alt.recovery.aa 40
39comp.os.linux.misc 35
40comp.mobile.android 35
41comp.lang.forth 34
42alt.test 33
43rec.sport.soccer 33
44nz.general 32
45sci.lang 31
46alt.2600 30
47sci.electronics.repair 30
48rec.crafts.metalworking 30
49rec.arts.sf.fandom 30
50alt.bbs.mystic 30
51rec.arts.movies.current-films 30
52misc.health.alternative 28
53uk.tech.broadcast 26
54soc.culture.indian 26
55rec.outdoors.rv-travel 26
56agency.test 25
57rec.music.rock-pop-r+b.1950s 24
58rec.autos.tech 24
59comp.protocols.time.ntp 24
60rec.gambling.lottery 23
61soc.culture.usa 23
62alt.books.reviews 23
63rec.music.classical.recordings 23
64rec.autos.sport.f1 22
65comp.lang.lisp 21
66humanities.lit.authors.shakespeare 21
67soc.genealogy.benelux 20
68comp.sys.raspberry-pi 20
69uk.radio.amateur 20
70soc.veterans 20
71rec.games.pinball 20
72comp.soft-sys.matlab 18
73comp.soft-sys.math.scilab 17
74comp.lang.fortran 16
75sci.military.naval 16
76rec.radio.shortwave 16
77comp.soft-sys.sas 15
78rec.radio.amateur.misc 15
79rec.arts.tv.uk.coronation-st 15
80rec.arts.sf.tv 15
81rec.audio.pro 15
82soc.culture.bulgaria 14
83comp.arch 14
84soc.culture.brazil 13
85soc.culture.vietnamese 13
86alt.tv.star-trek.tos 13
87rec.aviation.soaring 12
88rec.arts.comics.strips 12
89alt.comp.os.windows-xp 12
90soc.genealogy.medieval 11
91rec.music.dylan 11
92soc.culture.iranian 11
93rec.arts.books.childrens 10
94soc.culture.romanian 10
95rec.games.video.sony 10
96comp.mobile.ipad 10
97comp.lang.java.programmer 10
98rec.bicycles.racing 9
99aus.radio.amateur.misc 9
100comp.lang.misc 9
TOTAL: 280 8118