news.bbs.geek.nz daily logs

Aug 2 23:58:02 -- Aug 3 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 111854 56.1%9.0 MB 34.8%
innd 31450 15.8%5.2 MB 20.2%
inn 31274 15.7%7.0 MB 26.9%
innfeed 23275 11.7%4.4 MB 17.1%
cnfsstat 1440 0.7%250.1 KB 0.9%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 199294 100.0%25.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 300941 47.9%
Positive hits 297593 47.4%
Do not exist 29253 4.7%
Cache misses 301 0.0%
TOTAL: 4 628088 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.167 0.0%164 0.000 1.018 16.000
article cleanup00:00:00.276 0.0%30574 0.000 0.009 0.033
article logging00:00:00.787 0.0%31129 0.000 0.025 0.109
article parse00:00:00.908 0.0%80563 0.000 0.011 0.027
article write00:00:01.911 0.0%22789 0.016 0.084 1.137
artlog/artcncl00:00:00.001 0.0%152 0.000 0.007 0.083
data move00:00:00.492 0.0%580368 0.000 0.001 0.013
hisgrep/artcncl00:00:00.002 0.0%146 0.000 0.014 0.091
hishave/artcncl00:00:00.001 0.0%164 0.000 0.006 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.011 0.0%629692 0.001 0.013 0.637
history sync00:00:00.013 0.0%315 0.000 0.041 0.500
history write00:00:08.776 0.0%29316 0.024 0.299 17.357
hiswrite/artcncl00:00:00.001 0.0%18 0.000 0.056 0.091
idle23:57:04.798 99.8%599169 78.350 143.907 344.160
nntp read00:00:03.415 0.0%601398 0.002 0.006 0.018
overview write00:00:44.678 0.1%22789 0.061 1.961 68.877
perl filter00:00:59.239 0.1%29316 1.426 2.021 3.881
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.615 0.0%45578 0.002 0.035 0.145
TOTAL: 24:00:24.79923:59:15.091 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.083 0.0%29604 0.000 0.003 0.019
article prepare00:00:00.001 0.0%14698 0.000 0.000 0.017
article read00:00:00.208 0.0%3422 0.000 0.061 1.304
backlog stats00:00:00.347 0.0%353574 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%296434 0.001 0.006 0.010
data write00:00:03.213 0.0%283711 0.006 0.011 0.018
idle24:03:02.560100.0%353574 139.880 244.878 562.360
status file00:00:05.707 0.0%1952 0.769 2.924 92.865
TOTAL: 24:03:30.01624:03:13.817100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%4 0.000 0.000 0.000
idle72:53:14.995 99.3%123435 0.000 2125.775 80283.484
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:26.136 0.0%266290 0.000 0.098 30.766
readart00:00:02.198 0.0%10494 0.000 0.209 32.000
TOTAL: 73:24:51.35972:53:43.329 99.3%----

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 62 21527 6506 14592 429 30%64:08:58
2news-out.mixmin.net 18 24968 4498 19219 1251 18%28:18:41
3newsfeed.datemas.de 3 23649 3474 19428 747 14%23:52:34
4feeder.eternal-september.org 98 27989 2127 24706 1156 7%59:42:45
5newsfeed.neva.ru 154 18721 1417 15007 2297 7%91:03:11
6news.redatomik.org 1 21325 1229 19958 138 5%23:21:12
7news-out.aioe.org 2 24943 1129 23725 89 4%26:34:00
8csiph.com 3 27534 994 26450 90 3%30:51:41
9feeder.awxg.com 2 20462 376 20004 82 1%23:59:56
10news.freedyn.net 3 25732 356 25143 233 1%24:40:18
11news.samoylyk.net 2 30798 318 29593 887 1%26:21:17
12news.swapon.de 7 2577 242 2297 38 9%29:10:41
13news.albasani.net 1 33506 224 33006 276 0%36:12:39
14agency-nz-out.news.mb-net.net 22 25789 147 25425 217 0%34:16:28
15localhost 29 28 7 21 0 25%00:00:00
TOTAL: 15 407 329548 23044 298574 7930 6%522:34:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.5 MB426.5 KB2.1 MB26.1 MB 90%3.8 KB
2news-out.mixmin.net13.5 MB489.3 KB3.2 MB17.2 MB 78%3.1 KB
3newsfeed.datemas.de12.4 MB363.7 KB2.5 MB15.2 MB 81%3.7 KB
4feeder.eternal-september.org9.1 MB876.8 KB6.9 MB16.8 MB 53%5.2 KB
5newsfeed.neva.ru3.9 MB319.3 KB10.1 MB14.3 MB 27%4.0 KB
6news.redatomik.org3.3 MB290.4 KB408.1 KB4.0 MB 82%3.0 KB
7news-out.aioe.org3.0 MB232.0 KB277.9 KB3.5 MB 85%3.0 KB
8csiph.com2.6 MB318.2 KB359.9 KB3.2 MB 79%3.0 KB
9news.albasani.net2.5 MB1.1 MB1.4 MB5.0 MB 50%10.2 KB
10news.samoylyk.net2.0 MB672.5 KB5.9 MB8.6 MB 23%7.3 KB
11news.freedyn.net1.5 MB372.7 KB743.8 KB2.6 MB 57%4.5 KB
12feeder.awxg.com1.1 MB412.0 KB426.3 KB2.0 MB 58%4.4 KB
13news.swapon.de693.0 KB165.8 KB167.7 KB1.0 MB 67%3.7 KB
14agency-nz-out.news.mb-net.net463.9 KB466.0 KB1.2 MB2.2 MB 21%6.0 KB
15localhost11.5 KB0.0 KB0.0 KB11.5 KB100%1.6 KB
TOTAL: 1579.6 MB6.4 MB35.7 MB121.6 MB 65%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 2 23:58:02 - 23:59:59 24 0.1% 0.2045.2 KB 0.1% 0.38
Aug 3 00:00:00 - 00:59:59 1040 4.6% 0.292.8 MB 3.6% 0.79
Aug 3 01:00:00 - 01:59:59 1372 6.0% 0.384.9 MB 6.3% 1.39
Aug 3 02:00:00 - 02:59:59 1219 5.4% 0.344.3 MB 5.5% 1.21
Aug 3 03:00:00 - 03:59:59 1355 5.9% 0.384.9 MB 6.3% 1.40
Aug 3 04:00:00 - 04:59:59 1420 6.2% 0.394.1 MB 5.2% 1.16
Aug 3 05:00:00 - 05:59:59 1348 5.9% 0.374.3 MB 5.5% 1.22
Aug 3 06:00:00 - 06:59:59 1154 5.1% 0.324.3 MB 5.6% 1.23
Aug 3 07:00:00 - 07:59:59 1199 5.3% 0.333.3 MB 4.3% 0.95
Aug 3 08:00:00 - 08:59:59 1218 5.3% 0.343.9 MB 5.0% 1.11
Aug 3 09:00:00 - 09:59:59 1021 4.5% 0.283.4 MB 4.4% 0.97
Aug 3 10:00:00 - 10:59:59 872 3.8% 0.243.5 MB 4.5% 0.99
Aug 3 11:00:00 - 11:59:59 718 3.2% 0.202.9 MB 3.7% 0.82
Aug 3 12:00:00 - 12:59:59 630 2.8% 0.172.0 MB 2.6% 0.58
Aug 3 13:00:00 - 13:59:59 529 2.3% 0.151.5 MB 2.0% 0.44
Aug 3 14:00:00 - 14:59:59 528 2.3% 0.151.9 MB 2.5% 0.55
Aug 3 15:00:00 - 15:59:59 497 2.2% 0.142.2 MB 2.8% 0.63
Aug 3 16:00:00 - 16:59:59 567 2.5% 0.162.5 MB 3.2% 0.71
Aug 3 17:00:00 - 17:59:59 601 2.6% 0.172.3 MB 3.0% 0.66
Aug 3 18:00:00 - 18:59:59 668 2.9% 0.192.9 MB 3.7% 0.82
Aug 3 19:00:00 - 19:59:59 876 3.8% 0.242.7 MB 3.5% 0.78
Aug 3 20:00:00 - 20:59:59 968 4.2% 0.273.9 MB 5.0% 1.10
Aug 3 21:00:00 - 21:59:59 867 3.8% 0.243.0 MB 3.8% 0.85
Aug 3 22:00:00 - 22:59:59 1103 4.8% 0.313.5 MB 4.4% 0.98
Aug 3 23:00:00 - 23:58:01 988 4.3% 0.282.9 MB 3.8% 0.87
TOTAL: 23:59:59 22782 100.0% 0.2678.1 MB 100.0% 0.93
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.9 GB 37.8% 0 0.34 1784.57
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.0 GB 44.0% 0 0.40 1527.34
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB232.1 MB 0.5% 0 0.0512800.00
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.8 GB 11.6% 0 0.80 758.51
TOTAL: 10-500.0 GB47.0 GB 9.4% 1 0.51-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2300 135 0 63 1 0 0 0 2101
2news-out.mixmin.net 1530 0 0 112 0 0 0 0 1418
3feeder.eternal-september.org 1160 0 0 157 0 0 0 0 1003
4newsfeed.datemas.de 863 300 0 104 0 0 0 0 459
5news.samoylyk.net 805 0 0 118 0 0 0 0 687
6news.snarked.org 449 29 0 96 0 0 0 0 324
7news.albasani.net 243 0 0 103 0 0 0 0 140
8news.freedyn.net 236 12 0 66 0 0 0 0 158
9agency-nz-out.news.mb-net.net 218 37 0 99 1 0 0 0 81
10news.redatomik.org 181 0 0 84 0 0 0 0 97
11news-out.aioe.org 92 15 0 65 0 0 0 0 12
12feeder.awxg.com 91 4 0 81 0 0 0 0 6
13news.swapon.de 85 0 0 35 0 0 0 0 50
14csiph.com 81 0 0 69 0 0 0 0 12
15news.ausics.org 6 0 0 6 0 0 0 0 0
TOTAL: 15 8340 532 0 1258 2 0 0 0 6548

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 191
it.annunci.commerciali 41
it.annunci.varie 40
it.annunci.immobiliari 39
gmane.linux.alsa.devel 35
mozilla.support.seamonkey 30
mozilla.dev.platform 29
mozilla.dev.security.policy 26
gmane.linux.kernel 9
mozilla.dev.apps.seamonkey 9
fido7.ru.android 9
mpc.lists.nanog 7
alt.fr.os.windows.7 6
mpc.lists.freebsd.office 5
mpc.lists.freebsd.gnome 5
mozilla.dev.ports.os2 5
mozilla.dev.ui-alerts 5
mozilla.test 4
gmane.comp.gis.openstreetmap.tagging 3
mozilla.dev.l10n 3
TOTAL: 42 532

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

GroupsCount
nz.politics.announce 1
uk.legal.moderated 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4949
EMP (phn path) 711
EMP (phn nph) 134
EMP (phl) 85
Too many newsgroups 43
Binary: non-binary distribution 29
User-issued cancel 21
HTML post 9
Cancel for rejected article 7
Too many newsgroups (low_xpost) 2
Binary Image: misplaced gif 1
User-issued spam cancel 1
MI5 Filter 1
TOTAL: 13 5993

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 292
newsfeed.datemas.de 110
news.swapon.de 49
news.redatomik.org 40
news.snarked.org 25
newsfeed.neva.ru 10
news-out.aioe.org 8
feeder.eternal-september.org 6
news.albasani.net 6
feeder.awxg.com 5
TOTAL: 12 555
TOTAL: 1 555

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20982 2211 18676 94 1 0 10%23:59:47
2awxg 22219 73 22129 5 0 13 0%23:59:48
3news.snarked.org 16318 28 16131 6 0 6 0%23:59:44
4news.freedyn.net 22657 27 22388 0 0 13 0%23:59:48
5csiph.com 22113 10 21840 2 0 11 0%23:59:48
6mb-net.net 22627 9 22571 0 0 0 0%23:59:47
7neva.ru 21073 7 21025 0 0 29 0%23:59:48
8aioe 19198 7 19004 9 0 13 0%23:59:46
9news-in.mixmin.net 17657 7 17613 0 0 13 0%23:59:32
10news.redatomik.org 21376 7 21344 0 0 0 0%23:59:43
11news.samoylyk.net 15504 6 15437 0 0 5248 0%23:59:48
12newsfeed.datemas.de 19303 5 19245 0 0 207 0%23:59:48
13eternal-september 19463 5 19345 0 0 252 0%23:59:48
14news.albasani.net 23422 4 20436 1069 0 6303 0%23:59:48
15news.swapon.de 2227 0 2226 0 0 0 0%23:45:45
TOTAL: 15 286139 2406 279410 1185 1 12108 0%359:42:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.0 MB4.9 MB16.9 MB0.2 KB/s7.5 KB23:59:47
2news.snarked.org1.8 MB222.2 KB2.0 MB0.0 KB/s59.5 KB23:59:44
3awxg288.5 KB25.0 KB313.5 KB0.0 KB/s4.0 KB23:59:48
4news.freedyn.net80.2 KB0.0 KB80.2 KB0.0 KB/s3.0 KB23:59:48
5csiph.com17.4 KB5.9 KB23.3 KB0.0 KB/s1.9 KB23:59:48
6mb-net.net15.5 KB0.0 KB15.5 KB0.0 KB/s1.7 KB23:59:47
7neva.ru11.5 KB0.0 KB11.5 KB0.0 KB/s1.6 KB23:59:48
8aioe11.5 KB15.6 KB27.1 KB0.0 KB/s1.7 KB23:59:46
9news-in.mixmin.net11.5 KB0.0 KB11.5 KB0.0 KB/s1.6 KB23:59:32
10news.redatomik.org11.5 KB0.0 KB11.5 KB0.0 KB/s1.6 KB23:59:43
11news.samoylyk.net10.3 KB0.0 KB10.3 KB0.0 KB/s1.7 KB23:59:48
12eternal-september8.7 KB0.0 KB8.7 KB0.0 KB/s1.7 KB23:59:48
13newsfeed.datemas.de7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:59:48
14news.albasani.net6.1 KB3.3 MB3.3 MB0.0 KB/s3.2 KB23:59:48
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:45
TOTAL: 1514.2 MB8.5 MB22.7 MB0.0 KB/s6.5 KB359:42:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 387 642121.1 MB 3469 6 25200:13:44
2163.47.16.169 24 11461.5 MB 158 0 000:05:12
367-61-81-51.cpe.cableone.net 24 10424.2 MB 142 0 000:19:47
4192.168.1.3 1 122505.5 KB 4 0 000:00:06
567-61-218-236.cpe.cableone.net 4 2658.8 KB 2 1 071:48:51
6mic1062344.lnk.telstra.net 12 924.1 KB 2 0 000:27:04
TOTAL: 6 452 876627.3 MB 3777 7 25273:24:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 387 642121.1 MB 3469 6 25200:13:44
2unresolved 33 12682.0 MB 162 0 000:35:10
3*.cpe.cableone.net 28 10684.2 MB 144 1 072:08:39
4*.lnk.telstra.net 12 924.1 KB 2 0 000:27:04
5*.lightspeed.gdrpmi.sbcglobal.net 1 00.0 KB 0 0 000:00:02
TOTAL: 5 461 876627.3 MB 3777 7 25273:24:44

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 24
crash 10
malcolmlewis 4
paulh 1
TOTAL: 5 63

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.452 0.180 0.01271:48:51
mic1062344.lnk.telstra.net 0.720 0.100 0.03000:27:04
67-61-81-51.cpe.cableone.net 1.432 0.396 0.08500:19:47
118.149.138.40 0.244 0.032 0.00000:16:44
agency.bbs.geek.nz 27.396 6.236 0.00000:13:44
118.149.153.50 0.116 0.024 0.00000:10:05
163.47.16.169 1.364 0.388 0.52200:05:12
202.174.187.54 0.052 0.008 0.00000:02:54
203.118.151.117 0.076 0.012 0.00000:00:07
192.168.1.3 0.092 0.040 0.00300:00:06
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 0.052 0.008 0.00000:00:02
? 1.556 0.204 0.00000:00:02
TOTAL: 12 33.552 7.628 0.65273:24:44

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.138.40 4
118.149.153.50 2
202.174.187.54 1
203.118.151.117 1
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 1
TOTAL: 5 9

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
mic1062344.lnk.telstra.net 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 5
TOTAL: 1 5

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-218-236.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 3228 36.8%
2comp 1695 19.3%
3alt 1397 15.9%
4soc 799 9.1%
5sci 729 8.3%
6misc 292 3.3%
7talk 228 2.6%
8nz 138 1.6%
9news 109 1.2%
10uk 91 1.0%
11humanities 23 0.3%
12aus 21 0.2%
13agency 11 0.1%
14eternal-september 3 0.0%
TOTAL: 14 8764100.0%

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

NewsgroupCount
1alt.atheism 616
2rec.arts.tv 571
3comp.os.linux.advocacy 448
4comp.lang.c 447
5rec.arts.sf.written 383
6rec.arts.drwho 357
7alt.comp.os.windows-10 254
8rec.sport.golf 228
9comp.lang.python 214
10misc.survivalism 206
11rec.food.cooking 192
12rec.sport.tennis 188
13sci.physics 186
14soc.retirement 160
15sci.physics.relativity 123
16nz.general 119
17soc.culture.polish 118
18sci.math 112
19rec.sport.soccer 111
20alt.bible 105
21news.lists.filters 99
22soc.culture.china 96
23talk.origins 91
24alt.recovery.aa 91
25sci.electronics.design 85
26rec.sport.football.college 84
27soc.culture.israel 82
28alt.politics 77
29rec.sport.pro-wrestling 75
30rec.boats 73
31talk.politics.guns 72
32rec.arts.movies.current-films 68
33rec.music.rock-pop-r+b.1950s 68
34rec.arts.movies.past-films 66
35alt.support.diabetes 66
36rec.bicycles.tech 63
37talk.politics.misc 59
38soc.culture.singapore 59
39uk.radio.amateur 59
40soc.genealogy.medieval 57
41comp.lang.forth 54
42rec.audio.opinion 50
43rec.outdoors.rv-travel 48
44comp.sys.mac.system 46
45misc.health.alternative 46
46comp.lang.c++ 43
47rec.woodworking 42
48rec.gambling.poker 42
49rec.photo.digital 40
50alt.tv.days-of-our-lives 40
51soc.culture.vietnamese 33
52alt.test 33
53sci.logic 32
54rec.arts.tv.uk.coronation-st 30
55sci.military.naval 30
56comp.os.linux.misc 29
57rec.aviation.soaring 29
58comp.lang.fortran 28
59uk.comp.homebuilt 28
60rec.games.pinball 28
61comp.os.vms 27
62sci.lang 27
63sci.bio.paleontology 27
64rec.music.classical.recordings 26
65comp.sys.apple2 26
66soc.penpals 26
67alt.os.linux.suse 25
68comp.soft-sys.sas 24
69soc.culture.usa 24
70sci.electronics.repair 24
71alt.bbs.mystic 24
72comp.protocols.time.ntp 24
73comp.mobile.android 23
74rec.music.dylan 23
75sci.med.pharmacy 23
76comp.sys.mac.apps 22
77comp.lang.lisp 21
78comp.lang.ada 20
79humanities.lit.authors.shakespeare 19
80alt.os.linux.ubuntu 18
81comp.soft-sys.matlab 17
82alt.astronomy 17
83rec.gambling.lottery 16
84soc.culture.indian 16
85rec.arts.tv.soaps.cbs 16
86sci.astro.amateur 16
87aus.aviation 16
88soc.culture.brazil 15
89rec.sport.cricket 14
90rec.arts.comics.strips 14
91rec.arts.horror.movies 14
92comp.unix.shell 14
93soc.culture.jewish 14
94alt.2600 14
95rec.music.classical.guitar 13
96rec.aviation.student 12
97rec.games.trivia 12
98rec.audio.pro 12
99rec.radio.amateur.misc 12
100nz.test 11
TOTAL: 308 8764