news.bbs.geek.nz daily logs

Apr 7 23:58:02 -- Apr 8 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 134039 63.8%10.9 MB 42.7%
innd 29241 13.9%4.7 MB 18.5%
innfeed 23099 11.0%4.6 MB 18.1%
inn 22282 10.6%5.0 MB 19.7%
cnfsstat 1440 0.7%254.9 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 210102 100.0%25.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 224487 48.7%
Positive hits 214950 46.6%
Do not exist 21255 4.6%
Cache misses 181 0.0%
TOTAL: 4 460873 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.097 0.0%115 0.000 0.843 39.000
article cleanup00:00:00.196 0.0%21634 0.000 0.009 0.056
article logging00:00:00.553 0.0%22186 0.000 0.025 0.091
article parse00:00:00.781 0.0%79546 0.000 0.010 0.029
article write00:00:01.491 0.0%16506 0.000 0.090 1.595
artlog/artcncl00:00:00.001 0.0%110 0.000 0.009 0.067
data move00:00:00.389 0.0%478625 0.000 0.001 0.013
hisgrep/artcncl00:00:00.001 0.0%110 0.000 0.009 0.500
hishave/artcncl00:00:00.000 0.0%115 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.139 0.0%465838 0.001 0.017 0.998
history sync00:00:00.109 0.0%373 0.000 0.292 31.333
history write00:00:06.759 0.0%21460 0.000 0.315 18.957
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:57:45.781 99.8%489000 104.408 176.413 422.374
nntp read00:00:03.189 0.0%490342 0.003 0.007 0.021
overview write00:00:55.124 0.1%16506 0.017 3.340 200.254
perl filter00:00:42.617 0.0%21460 1.170 1.986 9.159
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.930 0.0%33012 0.003 0.028 0.134
TOTAL: 24:00:51.77823:59:46.157 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%22022 0.000 0.002 0.036
article prepare00:00:00.003 0.0%10674 0.000 0.000 0.036
article read00:00:00.222 0.0%2619 0.000 0.085 9.375
backlog stats00:00:00.267 0.0%269786 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.690 0.0%220519 0.002 0.008 0.019
data write00:00:02.601 0.0%207950 0.005 0.013 0.025
idle23:55:02.203100.0%269786 187.232 319.150 808.797
status file00:00:19.755 0.0%1830 0.500 10.795 449.289
TOTAL: 23:55:45.15623:55:26.788100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle32:32:10.108 96.8%147900 0.000 791.955 56880.935
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:02:12.513 0.1%322944 0.000 0.410 6.736
readart00:00:02.001 0.0%12725 0.000 0.157 7.810
TOTAL: 33:36:03.18932:34:24.622 96.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 36 21294 5721 12339 3234 26%36:02:20
2newsfeed.datemas.de 3 18834 2368 16031 435 12%26:19:02
3feeder.eternal-september.org 5 19736 1960 17589 187 9%25:14:41
4news.albasani.net 2 11449 1937 9174 338 16%13:14:51
5news-out.aioe.org 1 15628 1393 14199 36 8%22:49:09
6newsfeed.neva.ru 147 15179 937 13715 527 6%75:13:19
7news.redatomik.org 1 24594 628 23885 81 2%32:37:58
8news-out.mixmin.net 3 16806 594 15983 229 3%22:43:10
9csiph.com 2 12664 517 12135 12 4%18:35:19
10news.swapon.de 7 2196 123 2031 42 5%25:49:56
11feeder.awxg.com 2 14846 96 14735 15 0%24:53:12
12agency-nz-out.news.mb-net.net 4 16649 71 16556 22 0%23:04:49
13news.samoylyk.net 1 16883 45 16824 14 0%23:59:57
14news.freedyn.net 1 19719 11 19692 16 0%17:24:38
15localhost 2 1 1 0 0 100%00:00:00
16news.ausics.org 46 12387 0 12387 0 0%29:42:21
TOTAL: 16 263 238865 16402 217275 5188 6%417:44:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.3 MB267.1 KB53.1 MB72.7 MB 26%8.3 KB
2newsfeed.datemas.de9.0 MB221.2 KB1.7 MB10.9 MB 82%4.0 KB
3news.albasani.net7.1 MB195.0 KB776.5 KB8.0 MB 88%3.6 KB
4feeder.eternal-september.org6.9 MB244.0 KB1.0 MB8.2 MB 84%3.9 KB
5news-out.aioe.org3.3 MB16.0 KB135.5 KB3.4 MB 95%2.5 KB
6newsfeed.neva.ru2.3 MB131.2 KB1.7 MB4.2 MB 55%2.9 KB
7news-out.mixmin.net1.9 MB54.9 KB419.8 KB2.4 MB 80%2.9 KB
8news.redatomik.org1.6 MB226.4 KB293.3 KB2.1 MB 75%3.0 KB
9csiph.com1.5 MB35.9 KB35.9 KB1.6 MB 95%3.0 KB
10feeder.awxg.com378.3 KB35.6 KB78.3 KB492.2 KB 76%4.4 KB
11news.freedyn.net375.6 KB214.1 KB231.3 KB821.0 KB 45%30.4 KB
12news.swapon.de332.5 KB12.8 KB57.5 KB402.8 KB 82%2.4 KB
13news.samoylyk.net287.4 KB41.8 KB41.8 KB370.9 KB 77%6.3 KB
14agency-nz-out.news.mb-net.net236.7 KB13.8 KB210.7 KB461.1 KB 51%5.0 KB
15localhost0.8 KB0.0 KB0.0 KB0.8 KB100%0.8 KB
16news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1654.5 MB1.7 MB59.7 MB115.9 MB 47%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 7 23:58:02 - 23:59:59 36 0.2% 0.31121.1 KB 0.2% 1.03
Apr 8 00:00:00 - 00:59:59 799 4.8% 0.222.2 MB 4.0% 0.62
Apr 8 01:00:00 - 01:59:59 908 5.5% 0.252.8 MB 5.1% 0.79
Apr 8 02:00:00 - 02:59:59 889 5.4% 0.252.9 MB 5.2% 0.81
Apr 8 03:00:00 - 03:59:59 976 5.9% 0.272.8 MB 5.1% 0.80
Apr 8 04:00:00 - 04:59:59 945 5.7% 0.262.5 MB 4.5% 0.70
Apr 8 05:00:00 - 05:59:59 957 5.8% 0.272.7 MB 5.0% 0.78
Apr 8 06:00:00 - 06:59:59 1029 6.2% 0.293.1 MB 5.7% 0.89
Apr 8 07:00:00 - 07:59:59 1012 6.1% 0.282.9 MB 5.3% 0.82
Apr 8 08:00:00 - 08:59:59 744 4.5% 0.213.1 MB 5.7% 0.89
Apr 8 09:00:00 - 09:59:59 783 4.7% 0.225.8 MB 10.6% 1.65
Apr 8 10:00:00 - 10:59:59 673 4.1% 0.192.8 MB 5.2% 0.81
Apr 8 11:00:00 - 11:59:59 489 3.0% 0.141.7 MB 3.1% 0.48
Apr 8 12:00:00 - 12:59:59 419 2.5% 0.121.3 MB 2.5% 0.38
Apr 8 13:00:00 - 13:59:59 428 2.6% 0.121.2 MB 2.3% 0.35
Apr 8 14:00:00 - 14:59:59 405 2.5% 0.111.5 MB 2.8% 0.43
Apr 8 15:00:00 - 15:59:59 300 1.8% 0.081.5 MB 2.7% 0.41
Apr 8 16:00:00 - 16:59:59 358 2.2% 0.101.1 MB 2.0% 0.31
Apr 8 17:00:00 - 17:59:59 391 2.4% 0.111.1 MB 1.9% 0.30
Apr 8 18:00:00 - 18:59:59 458 2.8% 0.131.5 MB 2.7% 0.43
Apr 8 19:00:00 - 19:59:59 548 3.3% 0.151.8 MB 3.4% 0.52
Apr 8 20:00:00 - 20:59:59 768 4.7% 0.212.3 MB 4.3% 0.67
Apr 8 21:00:00 - 21:59:59 785 4.8% 0.222.3 MB 4.3% 0.67
Apr 8 22:00:00 - 22:59:59 716 4.3% 0.201.8 MB 3.2% 0.50
Apr 8 23:00:00 - 23:58:02 680 4.1% 0.201.7 MB 3.2% 0.51
TOTAL: 24:00:00 16496 100.0% 0.1954.7 MB 100.0% 0.65
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB24.9 GB 49.9% 0 0.28 2188.38
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB28.9 GB 57.8% 0 0.24 2543.99
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB314.4 MB 0.6% 0 0.0230093.17
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 GB19.4 GB 38.8% 0 0.56 1081.91
TOTAL: 10-500.0 GB73.5 GB 14.7% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 3158 25 0 34 0 0 0 0 3099
2newsfeed.datemas.de 599 30 0 14 0 0 0 0 555
3newsfeed.neva.ru 545 17 0 13 0 0 0 0 515
4news.albasani.net 512 9 0 9 0 0 0 0 494
5news-out.mixmin.net 282 0 0 15 0 0 0 0 267
6feeder.eternal-september.org 189 0 0 20 0 0 0 0 169
7news.redatomik.org 184 0 0 12 0 0 0 0 172
8news.freedyn.net 57 0 0 12 0 0 0 0 45
9news-out.aioe.org 46 11 0 7 0 0 0 0 28
10news.swapon.de 41 0 0 4 0 0 0 0 37
11agency-nz-out.news.mb-net.net 26 5 0 6 0 0 0 0 15
12feeder.awxg.com 16 0 0 7 0 0 0 0 9
13csiph.com 12 0 0 12 0 0 0 0 0
14news.samoylyk.net 10 0 0 9 0 0 0 0 1
TOTAL: 14 5677 97 0 174 0 0 0 0 5406

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 47
mpc.lists.freebsd.office 9
gmane.linux.alsa.devel 9
gmane.comp.gis.openstreetmap.tagging 4
mozilla.dev.ui-alerts 4
gmane.linux.kernel 4
south-wales.test 3
mpc.lists.freebsd.gecko 2
mpc.lists.freebsd.gnome 2
alt.religion.christian.romman-catholic 1
mpc.lists.freebsd.wireless 1
uw.psychology.psyc292 1
gmane.comp.gis.openstreetmap.imports 1
3do.bad-attitude 1
demos.local.statistics 1
mozilla.support.calendar 1
mozilla.support.seamonkey 1
gmane.comp.handhelds.openmoko.community 1
mpc.lists.freebsd.x11 1
alt.bestjobsusa.boston.jobs 1
TOTAL: 22 97

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3989
Binary: misplaced rar 425
EMP (phn path) 204
EMP (phn nph) 66
Too many newsgroups 39
Binary: misplaced par2 36
User-issued cancel 33
Too many newsgroups (meow) 24
EMP (phl) 21
Binary Image: misplaced jpg 2
Cancel for rejected article 2
HTML post 2
Too many newsgroups (low_xpost) 2
Binary: misplaced 307 1
Binary: misplaced 005 1
Binary: misplaced 003 1
Binary: misplaced sfv 1
Too many test groups in crosspost 1
Binary: misplaced par 1
Binary: non-binary distribution 1
TOTAL: 20 4852

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 179
newsfeed.datemas.de 169
news.redatomik.org 110
news.swapon.de 35
news-out.mixmin.net 30
news.snarked.org 11
news-out.aioe.org 8
feeder.awxg.com 6
newsfeed.neva.ru 4
news.samoylyk.net 1
TOTAL: 11 554
TOTAL: 1 554

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14766 1877 12781 68 1 1210 12%23:59:45
2awxg 16101 23 15992 2 0 6 0%23:59:44
3news.snarked.org 10788 8 10675 1 0 36 0%23:59:45
4news.freedyn.net 16592 4 16457 1 0 11 0%23:59:34
5aioe 13957 3 13912 1 0 0 0%23:59:42
6neva.ru 15336 1 15324 0 0 0 0%23:59:45
7news.redatomik.org 15799 1 15790 1 0 0 0%23:59:39
8csiph.com 15990 1 15905 1 0 10 0%23:59:45
9mb-net.net 16450 1 16386 1 0 56 0%23:59:45
10news.samoylyk.net 14797 0 14696 1 0 4 0%23:59:32
11news-in.mixmin.net 15265 0 15220 1 0 0 0%23:59:19
12newsfeed.datemas.de 14233 0 14136 1 0 0 0%23:59:27
13news.swapon.de 1465 0 1460 0 0 0 0%23:45:30
14eternal-september 14214 0 14180 1 0 7 0%23:59:31
15news.albasani.net 15604 0 13719 607 0 4234 0%23:59:45
TOTAL: 15 211357 1919 206633 687 1 5574 0%359:40:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.8 MB393.2 KB8.2 MB0.1 KB/s4.3 KB23:59:45
2awxg70.6 KB11.4 KB82.0 KB0.0 KB/s3.3 KB23:59:44
3aioe26.6 KB0.8 KB27.4 KB0.0 KB/s6.8 KB23:59:42
4news.snarked.org20.5 KB5.4 KB25.9 KB0.0 KB/s2.9 KB23:59:45
5news.freedyn.net5.1 KB0.8 KB5.9 KB0.0 KB/s1.2 KB23:59:34
6csiph.com2.5 KB0.8 KB3.3 KB0.0 KB/s1.6 KB23:59:45
7news.redatomik.org2.0 KB0.8 KB2.8 KB0.0 KB/s1.4 KB23:59:39
8neva.ru0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:59:45
9mb-net.net0.8 KB26.6 KB27.4 KB0.0 KB/s13.7 KB23:59:45
10news.samoylyk.net0.0 KB0.8 KB0.8 KB0.0 KB/s0.8 KB23:59:32
11news-in.mixmin.net0.0 KB0.8 KB0.8 KB0.0 KB/s0.8 KB23:59:19
12newsfeed.datemas.de0.0 KB0.8 KB0.8 KB0.0 KB/s0.8 KB23:59:27
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:30
14eternal-september0.0 KB0.8 KB0.8 KB0.0 KB/s0.8 KB23:59:31
15news.albasani.net0.0 KB2.7 MB2.7 MB0.0 KB/s4.5 KB23:59:45
TOTAL: 157.9 MB3.1 MB11.0 MB0.0 KB/s4.3 KB359:40:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-82-242.cpe.cableone.net 8 597424.6 MB 952 0 1601:31:45
2agency.bbs.geek.nz 208 369813.5 MB 1976 0 000:07:09
3agency.bbs.nz 168 16675.5 MB 1082 0 000:05:40
4vorlon.activateit.net.au 24 8251.0 MB 124 0 000:04:45
567-60-219-146.cpe.cableone.net 3 6109.8 KB 3 0 030:46:14
6192.168.1.38 4 11.9 KB 1 1 000:01:59
TOTAL: 6 415 1217144.8 MB 4138 1 1633:35:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 11 598024.7 MB 955 0 1632:17:59
2*.bbs.geek.nz 208 369813.5 MB 1976 0 000:07:09
3*.bbs.nz 168 16675.5 MB 1082 0 000:05:40
4*.activateit.net.au 24 8251.0 MB 124 0 000:04:45
5unresolved 17 11.9 KB 1 1 001:00:18
TOTAL: 5 428 1217144.8 MB 4138 1 1633:35:56

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
paulh 4
malcolmlewis 3
TOTAL: 4 39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.376 0.124 0.01230:46:14
67-61-82-242.cpe.cableone.net 1.560 1.072 0.04801:31:45
118.149.242.226 0.388 0.040 0.00000:30:08
202.174.187.54 0.368 0.052 0.00000:28:08
agency.bbs.geek.nz 14.924 3.524 0.00000:07:09
agency.bbs.nz 12.324 2.804 0.00000:05:40
vorlon.activateit.net.au 1.416 0.412 0.17400:04:45
192.168.1.38 0.312 0.044 0.00900:01:59
94.166.32.93 0.056 0.004 0.00000:00:02
? 1.672 0.232 0.00000:00:02
TOTAL: 10 33.396 8.308 0.24333:35:56

Curious NNRP server explorers [Top 20]:

SystemConn
202.174.187.54 6
118.149.242.226 6
94.166.32.93 1
TOTAL: 3 13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
67-60-219-146.cpe.cableone.net 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3745 30.8%
2alt 1977 16.2%
3soc 1741 14.3%
4sci 1394 11.5%
5linux 1032 8.5%
6comp 925 7.6%
7misc 392 3.2%
8uk 387 3.2%
9talk 274 2.3%
10news 96 0.8%
11nz 79 0.6%
12humanities 52 0.4%
13mozilla 41 0.3%
14microsoft 18 0.1%
15aus 9 0.1%
16perl 7 0.1%
17agency 2 0.0%
TOTAL: 17 12171100.0%

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

NewsgroupCount
1rec.arts.tv 875
2alt.atheism 467
3rec.food.cooking 426
4soc.culture.china 409
5alt.fan.rush-limbaugh 360
6alt.comp.os.windows-10 349
7soc.culture.israel 328
8linux.debian.bugs.dist 299
9sci.electronics.design 280
10sci.physics 255
11rec.boats 246
12rec.arts.drwho 239
13linux.debian.changes.devel 238
14misc.survivalism 202
15rec.arts.sf.written 195
16uk.d-i-y 180
17sci.logic 174
18soc.retirement 162
19rec.sport.pro-wrestling 159
20alt.bible.prophecy 154
21sci.med.cardiology 151
22sci.physics.relativity 134
23linux.debian.bugs.rc 133
24soc.culture.brazil 131
25comp.lang.c 128
26talk.politics.guns 124
27soc.culture.polish 122
28rec.aquaria.marine.misc 120
29rec.crafts.metalworking 116
30soc.culture.usa 115
31rec.gambling.poker 110
32talk.origins 105
33rec.drugs.cannabis 104
34rec.outdoors.rv-travel 103
35comp.ai.philosophy 95
36uk.legal 94
37news.lists.filters 82
38alt.support.diabetes 80
39rec.aviation.marketplace 80
40rec.sport.tennis 78
41alt.politics.trump 75
42comp.os.vms 75
43rec.sport.football.college 75
44rec.music.classical.recordings 74
45sci.military.naval 70
46comp.os.linux.advocacy 69
47sci.crypt 65
48nz.general 64
49sci.math 64
50soc.genealogy.britain 58
51alt.test 56
52rec.aviation.soaring 56
53sci.lang 56
54soc.culture.indian 54
55alt.os.linux.ubuntu 54
56misc.health.alternative 53
57alt.conspiracy 50
58humanities.lit.authors.shakespeare 50
59rec.radio.shortwave 48
60alt.politics 46
61rec.woodworking 46
62uk.legal.moderated 46
63linux.debian.maint.boot 45
64comp.lang.python 44
65alt.rush-limbaugh 44
66soc.history.what-if 43
67comp.lang.ada 43
68comp.sys.apple2 42
69rec.games.backgammon 39
70comp.sys.mac.system 39
71rec.sport.soccer 36
72talk.politics.misc 36
73rec.arts.disney.parks 36
74misc.invest.stocks 36
75rec.games.pinball 36
76alt.society.liberalism 36
77uk.tech.digital-tv 36
78comp.sys.mac.apps 35
79soc.culture.europe 35
80linux.debian.user 34
81sci.electronics.repair 33
82alt.recovery.aa 33
83linux.debian.devel 32
84alt.bbs.synchronet 31
85soc.culture.greek 30
86rec.photo.digital 29
87comp.mail.eudora.ms-windows 28
88rec.autos.sport.f1 27
89misc.phone.mobile.iphone 26
90soc.genealogy.medieval 25
91sci.bio.paleontology 24
92comp.lang.c++ 24
93soc.culture.german 24
94rec.arts.comics.strips 23
95linux.gentoo.user 23
96linux.debian.devel.release 23
97linux.debian.kernel 23
98alt.conspiracy.jfk 23
99comp.lang.forth 22
100misc.health.diabetes 22
TOTAL: 362 12171