news.bbs.geek.nz daily logs

Jan 11 23:58:01 -- Jan 12 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 151741 63.9%12.6 MB 43.2%
innd 31146 13.1%5.1 MB 17.5%
inn 29997 12.6%6.6 MB 22.8%
innfeed 23188 9.8%4.5 MB 15.6%
cnfsstat 1440 0.6%251.9 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 237513 100.0%29.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 287421 48.8%
Positive hits 273225 46.4%
Do not exist 28222 4.8%
Cache misses 155 0.0%
TOTAL: 4 589023 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.116 0.0%149 0.000 0.779 9.000
article cleanup00:00:00.257 0.0%29274 0.000 0.009 0.032
article logging00:00:00.674 0.0%29863 0.000 0.023 0.100
article parse00:00:00.984 0.0%86210 0.002 0.011 0.028
article write00:00:03.541 0.0%21282 0.000 0.166 13.342
artlog/artcncl00:00:00.004 0.0%147 0.000 0.027 0.125
data move00:00:00.542 0.0%584524 0.000 0.001 0.033
hisgrep/artcncl00:00:00.001 0.0%123 0.000 0.008 0.111
hishave/artcncl00:00:00.000 0.0%149 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.277 0.0%593111 0.001 0.014 0.786
history sync00:00:00.229 0.0%362 0.000 0.633 54.250
history write00:00:06.717 0.0%28386 0.020 0.237 11.252
hiswrite/artcncl00:00:00.000 0.0%26 0.000 0.000 0.000
idle23:57:44.075 99.8%597689 78.865 144.329 392.468
nntp read00:00:03.959 0.0%599146 0.003 0.007 0.102
overview write00:00:38.571 0.0%21282 0.069 1.812 41.566
perl filter00:00:57.975 0.1%28386 1.361 2.042 22.727
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.432 0.0%42564 0.003 0.034 0.112
TOTAL: 24:00:53.87623:59:47.354 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.073 0.0%27750 0.000 0.003 0.027
article prepare00:00:00.001 0.0%9230 0.000 0.000 0.017
article read00:00:00.235 0.0%2046 0.000 0.115 4.000
backlog stats00:00:00.294 0.0%340087 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.659 0.0%284647 0.002 0.006 0.011
data write00:00:03.111 0.0%267527 0.005 0.012 0.044
idle23:53:45.827100.0%340087 160.660 252.952 511.739
status file00:00:06.273 0.0%1882 0.769 3.333 99.270
TOTAL: 23:54:13.31023:53:57.473100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle15:11:22.529 99.8%170337 0.000 321.026 40073.083
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:35.031 0.1%378706 0.000 0.093 2.291
readart00:00:03.378 0.0%17942 0.000 0.188 7.600
TOTAL: 15:13:21.28415:12:00.938 99.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 29 19020 6038 12669 313 31%35:56:03
2news-out.mixmin.net 6 23187 5219 16597 1371 22%24:22:30
3feeder.eternal-september.org 57 24266 2050 21105 1111 8%38:06:17
4news-out.aioe.org 5 20138 1736 18250 152 8%22:47:58
5newsfeed.datemas.de 4 20780 1586 18747 447 7%21:51:58
6newsfeed.neva.ru 149 17053 1160 12730 3163 6%79:49:46
7csiph.com 2 22085 1110 20919 56 5%25:37:23
8news.albasani.net 2 21400 592 20496 312 2%22:46:50
9news.redatomik.org 4 19129 534 18369 226 2%21:53:03
10news.freedyn.net 2 26413 327 25829 257 1%28:29:38
11news.swapon.de 6 1880 252 1622 6 13%32:19:01
12feeder.awxg.com 1 19151 176 18904 71 0%23:59:57
13agency-nz-out.news.mb-net.net 14 24406 122 23928 356 0%28:57:11
14news.samoylyk.net 2 21909 18 21837 54 0%23:59:46
15localhost 2 1 1 0 0 100%00:00:00
TOTAL: 15 285 280818 20921 252002 7895 7%430:57:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.7 MB154.1 KB1.5 MB21.3 MB 92%3.4 KB
2news-out.mixmin.net15.7 MB520.1 KB3.4 MB19.6 MB 80%3.0 KB
3newsfeed.datemas.de9.7 MB519.3 KB3.0 MB13.2 MB 73%6.6 KB
4feeder.eternal-september.org7.0 MB697.3 KB4.9 MB12.6 MB 55%4.1 KB
5news-out.aioe.org4.5 MB120.5 KB383.0 KB4.9 MB 90%2.7 KB
6news.albasani.net3.3 MB713.1 KB1.2 MB5.2 MB 63%5.9 KB
7csiph.com3.2 MB170.8 KB178.0 KB3.5 MB 90%3.1 KB
8newsfeed.neva.ru2.9 MB156.4 KB14.2 MB17.3 MB 16%4.1 KB
9news.freedyn.net2.0 MB288.8 KB6.9 MB9.2 MB 21%16.1 KB
10news.redatomik.org2.0 MB682.3 KB1.0 MB3.7 MB 53%4.9 KB
11news.swapon.de677.8 KB14.0 KB14.0 KB705.8 KB 96%2.7 KB
12feeder.awxg.com588.1 KB145.6 KB236.6 KB970.2 KB 60%3.9 KB
13agency-nz-out.news.mb-net.net296.6 KB398.4 KB16.0 MB16.6 MB 1%35.7 KB
14news.samoylyk.net38.4 KB98.9 KB783.0 KB920.4 KB 4%12.8 KB
15localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
TOTAL: 1571.3 MB4.6 MB53.7 MB129.6 MB 55%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 11 23:58:01 - 23:59:59 27 0.1% 0.2377.6 KB 0.1% 0.65
Jan 12 00:00:00 - 00:59:59 1031 4.8% 0.292.9 MB 3.9% 0.81
Jan 12 01:00:00 - 01:59:59 908 4.3% 0.253.0 MB 4.1% 0.84
Jan 12 02:00:00 - 02:59:59 1053 4.9% 0.293.5 MB 4.8% 1.00
Jan 12 03:00:00 - 03:59:59 1071 5.0% 0.303.9 MB 5.4% 1.12
Jan 12 04:00:00 - 04:59:59 1152 5.4% 0.323.1 MB 4.3% 0.89
Jan 12 05:00:00 - 05:59:59 1303 6.1% 0.364.6 MB 6.4% 1.32
Jan 12 06:00:00 - 06:59:59 1181 5.5% 0.333.3 MB 4.5% 0.93
Jan 12 07:00:00 - 07:59:59 1222 5.7% 0.343.8 MB 5.2% 1.08
Jan 12 08:00:00 - 08:59:59 1158 5.4% 0.324.2 MB 5.7% 1.19
Jan 12 09:00:00 - 09:59:59 1008 4.7% 0.282.8 MB 3.9% 0.80
Jan 12 10:00:00 - 10:59:59 1063 5.0% 0.303.6 MB 5.0% 1.04
Jan 12 11:00:00 - 11:59:59 911 4.3% 0.253.4 MB 4.6% 0.96
Jan 12 12:00:00 - 12:59:59 819 3.8% 0.233.5 MB 4.8% 1.00
Jan 12 13:00:00 - 13:59:59 719 3.4% 0.203.1 MB 4.3% 0.89
Jan 12 14:00:00 - 14:59:59 614 2.9% 0.172.1 MB 2.9% 0.60
Jan 12 15:00:00 - 15:59:59 480 2.3% 0.131.3 MB 1.8% 0.38
Jan 12 16:00:00 - 16:59:59 542 2.5% 0.153.2 MB 4.5% 0.92
Jan 12 17:00:00 - 17:59:59 440 2.1% 0.122.0 MB 2.7% 0.56
Jan 12 18:00:00 - 18:59:59 562 2.6% 0.162.4 MB 3.2% 0.67
Jan 12 19:00:00 - 19:59:59 577 2.7% 0.161.8 MB 2.5% 0.52
Jan 12 20:00:00 - 20:59:59 693 3.3% 0.192.6 MB 3.5% 0.73
Jan 12 21:00:00 - 21:59:59 891 4.2% 0.252.4 MB 3.4% 0.70
Jan 12 22:00:00 - 22:59:59 902 4.2% 0.253.4 MB 4.7% 0.96
Jan 12 23:00:00 - 23:58:02 953 4.5% 0.272.7 MB 3.7% 0.79
TOTAL: 24:00:01 21280 100.0% 0.2572.8 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.8 GB 45.7% 0 0.31 1943.86
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.5 GB 53.0% 0 0.40 1520.68
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB284.9 MB 0.6% 0 0.06 9609.61
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 GB14.9 GB 29.7% 0 0.69 884.79
TOTAL: 10-500.0 GB64.5 GB 12.9% 1 0.46-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3189 208 0 65 0 0 0 0 2916
2news-out.mixmin.net 1740 0 0 144 0 0 0 0 1596
3feeder.eternal-september.org 1128 0 0 116 0 0 0 0 1012
4newsfeed.datemas.de 521 214 0 51 0 0 0 0 256
5news.albasani.net 384 0 0 65 0 0 0 0 319
6agency-nz-out.news.mb-net.net 377 73 0 74 0 0 0 0 230
7news.snarked.org 315 95 0 60 0 0 0 0 160
8news.redatomik.org 291 0 0 78 0 0 0 0 213
9news.freedyn.net 232 61 0 46 0 0 0 0 125
10news-out.aioe.org 160 5 0 51 0 0 0 0 104
11feeder.awxg.com 63 7 0 44 0 0 0 0 12
12news.swapon.de 61 0 0 5 0 0 0 0 56
13csiph.com 54 0 0 50 0 0 0 0 4
14news.samoylyk.net 53 0 0 41 0 0 0 0 12
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 8570 663 0 892 0 0 0 0 7015

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 254
it.annunci.immobiliari 87
it.annunci.varie 80
it.annunci.commerciali 65
gmane.comp.gis.openstreetmap.tagging 31
mozilla.dev.platform 22
mpc.lists.freebsd.gnome 18
mpc.lists.freebsd.x11 16
mozilla.dev.security.policy 9
mpc.lists.freebsd.office 8
mpc.lists.nanog 6
nemo.test 6
mpc.lists.freebsd.gecko 5
mozilla.dev.tech.gfx 4
tnet.test 4
gmane.linux.kernel 4
mozilla.support.seamonkey 4
gmane.comp.gis.openstreetmap.legal 3
mozilla.governance 3
1.test 2
TOTAL: 44 663

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5045
EMP (phn path) 573
EMP (phn nph) 348
Binary Image: misplaced jpg 227
EMP (phl) 98
Too many newsgroups 50
Binary: misplaced rar 28
Too many newsgroups (low_xpost) 21
User-issued cancel 17
Binary: non-binary distribution 9
HTML post 5
Too many newsgroups (meow) 2
Binary: misplaced par2 1
Cancel for rejected article 1
User-issued spam cancel 1
TOTAL: 15 6426

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 365
newsfeed.datemas.de 75
news.swapon.de 55
news.redatomik.org 38
news.albasani.net 36
news-out.aioe.org 10
newsfeed.neva.ru 3
feeder.awxg.com 3
agency-nz-out.news.mb-net.net 2
news.snarked.org 2
TOTAL: 10 589
TOTAL: 1 589

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19446 970 18440 35 1 2 4%23:59:49
2awxg 20778 157 20591 3 0 126 0%23:59:48
3csiph.com 20349 19 20157 0 0 18 0%23:59:49
4news.freedyn.net 21152 3 20961 0 0 0 0%23:59:49
5news.albasani.net 21527 2 18649 1001 0 6033 0%23:59:49
6news.samoylyk.net 19855 2 19430 4 0 8 0%23:59:48
7mb-net.net 21179 2 21104 0 0 0 0%23:59:49
8aioe 17788 1 17676 0 0 101 0%23:59:49
9news.redatomik.org 20649 1 20594 0 0 241 0%23:59:49
10newsfeed.datemas.de 19726 1 19646 0 0 0 0%23:59:46
11news-in.mixmin.net 15440 1 15413 0 0 0 0%23:59:49
12eternal-september 18242 1 18205 1 0 0 0%23:59:49
13news.snarked.org 15042 1 14996 1 0 0 0%23:59:49
14news.swapon.de 1605 0 1604 0 0 0 0%23:55:51
15neva.ru 19763 0 19735 1 0 67 0%23:59:49
TOTAL: 15 272541 1161 267201 1046 1 6596 0%359:53:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org13.1 MB1001.0 KB14.1 MB0.2 KB/s14.4 KB23:59:49
2awxg486.2 KB11.3 KB497.5 KB0.0 KB/s3.1 KB23:59:48
3csiph.com83.5 KB0.0 KB83.5 KB0.0 KB/s4.4 KB23:59:49
4news.freedyn.net11.5 KB0.0 KB11.5 KB0.0 KB/s3.8 KB23:59:49
5news.albasani.net4.9 KB3.4 MB3.4 MB0.0 KB/s3.5 KB23:59:49
6mb-net.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:49
7news.samoylyk.net2.3 KB233.3 KB235.7 KB0.0 KB/s39.3 KB23:59:48
8aioe1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:49
9news.redatomik.org1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:49
10newsfeed.datemas.de1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:46
11news-in.mixmin.net1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:49
12eternal-september1.2 KB5.9 KB7.1 KB0.0 KB/s3.6 KB23:59:49
13news.snarked.org1.2 KB3.3 KB4.6 KB0.0 KB/s2.3 KB23:59:49
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:51
15neva.ru0.0 KB1.2 KB1.2 KB0.0 KB/s1.2 KB23:59:49
TOTAL: 1513.7 MB4.6 MB18.3 MB0.0 KB/s8.5 KB359:53:12
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 865029.6 MB 1262 0 1602:13:53
2agency.bbs.geek.nz 385 763825.2 MB 4348 1 000:13:55
3vorlon.activateit.net.au 24 10091.4 MB 148 0 000:04:56
4192.168.1.9 1 170878.2 KB 9 0 000:00:07
567-60-219-146.cpe.cableone.net 10 216.4 KB 2 0 012:40:16
TOTAL: 5 428 1746957.2 MB 5769 1 1615:13:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 18 865229.6 MB 1264 0 1614:54:10
2*.bbs.geek.nz 385 763825.2 MB 4348 1 000:13:55
3*.activateit.net.au 24 10091.4 MB 148 0 000:04:56
4unresolved 2 170878.2 KB 9 0 000:00:09
TOTAL: 4 429 1746957.2 MB 5769 1 1615:13:14

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 10
bpanther 8
paulh 1
TOTAL: 4 43

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.492 0.124 0.05312:40:16
67-61-21-181.cpe.cableone.net 1.664 1.220 0.02402:13:53
agency.bbs.geek.nz 28.912 7.192 0.00000:13:55
vorlon.activateit.net.au 1.352 0.424 0.41300:04:56
192.168.1.9 0.112 0.040 0.00300:00:07
? 1.012 0.128 0.00000:00:01
37.46.255.63 0.044 0.012 0.00000:00:01
TOTAL: 7 33.588 9.140 0.49315:13:14

Curious NNRP server explorers [Top 20]:

SystemConn
37.46.255.63 1
TOTAL: 1 1

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
37.46.255.63 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
37.46.255.63 1 1
agency.bbs.geek.nz 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 5871 33.6%
2alt 2201 12.6%
3comp 2086 11.9%
4soc 1834 10.5%
5sci 1496 8.6%
6uk 1274 7.3%
7linux 1052 6.0%
8talk 796 4.6%
9misc 339 1.9%
10news 238 1.4%
11nz 122 0.7%
12mozilla 64 0.4%
13microsoft 37 0.2%
14us 23 0.1%
15perl 15 0.1%
16aus 14 0.1%
17humanities 6 0.0%
18eternal-september 1 0.0%
TOTAL: 18 17469100.0%

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

NewsgroupCount
1rec.arts.tv 1139
2alt.fan.rush-limbaugh 558
3comp.lang.python 513
4rec.food.cooking 508
5alt.atheism 506
6rec.arts.drwho 486
7rec.sport.golf 435
8uk.legal 432
9uk.d-i-y 397
10linux.debian.bugs.dist 350
11talk.politics.misc 334
12rec.sport.tennis 323
13talk.politics.guns 293
14rec.arts.sf.written 278
15rec.gambling.poker 274
16soc.retirement 272
17rec.boats 264
18soc.culture.polish 254
19sci.electronics.design 239
20uk.radio.amateur 234
21alt.comp.os.windows-10 231
22sci.physics 228
23rec.sport.football.college 204
24news.lists.filters 197
25sci.physics.relativity 194
26comp.os.linux.advocacy 189
27comp.lang.idl-pvwave 186
28soc.culture.israel 184
29linux.debian.changes.devel 170
30soc.history.what-if 167
31soc.culture.china 164
32sci.math 162
33comp.mobile.android 160
34comp.lang.c 160
35comp.sys.mac.system 160
36alt.bible.prophecy 145
37comp.sys.apple2 144
38sci.logic 142
39talk.origins 140
40soc.culture.usa 130
41alt.politics.trump 129
42soc.culture.vietnamese 128
43rec.arts.sf.tv 121
44misc.phone.mobile.iphone 116
45alt.test 114
46alt.politics 113
47misc.survivalism 112
48nz.general 111
49linux.debian.bugs.rc 110
50sci.electronics.repair 109
51rec.sport.pro-wrestling 100
52linux.debian.user 98
53soc.penpals 94
54rec.bicycles.tech 92
55sci.edu 90
56rec.radio.shortwave 88
57rec.aquaria.marine.misc 88
58rec.arts.movies.past-films 84
59rec.aviation.marketplace 80
60soc.culture.singapore 79
61rec.sport.soccer 78
62sci.military.naval 71
63comp.lang.c++ 69
64uk.rec.driving 67
65rec.music.beatles 67
66soc.culture.brazil 65
67rec.music.classical.recordings 64
68rec.sport.cricket 63
69rec.crafts.metalworking 63
70sci.med.cardiology 57
71alt.bible 57
72uk.legal.moderated 57
73rec.photo.digital 56
74linux.gentoo.dev 54
75rec.music.makers.guitar.jazz 54
76rec.arts.comics.strips 51
77alt.recovery.aa 49
78comp.protocols.time.ntp 48
79comp.lang.forth 48
80rec.music.dylan 47
81sci.med.pharmacy 46
82comp.arch 44
83rec.outdoors.rv-travel 44
84comp.os.vms 42
85alt.conspiracy.jfk 40
86linux.debian.maint.boot 39
87rec.games.pinball 38
88alt.support.diabetes 37
89rec.games.trivia 36
90misc.invest.stocks 36
91soc.history 36
92comp.lang.ada 34
93rec.woodworking 32
94rec.drugs.cannabis 32
95alt.politics.usa 31
96alt.society.liberalism 31
97microsoft.public.windowsxp.general 30
98rec.arts.sf.fandom 30
99rec.arts.movies.current-films 30
100linux.debian.devel 28
TOTAL: 370 17469