news.bbs.geek.nz daily logs

Dec 26 23:58:02 -- Dec 27 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 142446 63.8%11.7 MB 43.4%
innd 31387 14.1%5.1 MB 19.1%
inn 25075 11.2%5.4 MB 20.0%
innfeed 22968 10.3%4.5 MB 16.6%
cnfsstat 1440 0.6%253.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 223317 100.0%26.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 223313 48.3%
Positive hits 214500 46.4%
Do not exist 23316 5.0%
Cache misses 1591 0.3%
TOTAL: 4 462720 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.836 0.0%167 0.000 5.006 54.923
article cleanup00:00:00.217 0.0%24419 0.000 0.009 0.030
article logging00:00:00.641 0.0%24963 0.000 0.026 0.147
article parse00:00:00.889 0.0%86403 0.000 0.010 0.022
article write00:00:01.396 0.0%16849 0.012 0.083 1.374
artlog/artcncl00:00:00.003 0.0%126 0.000 0.024 0.250
data move00:00:00.342 0.0%470424 0.000 0.001 0.012
hisgrep/artcncl00:00:00.425 0.0%160 0.000 2.656 32.538
hishave/artcncl00:00:00.146 0.0%167 0.000 0.874 11.231
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.141 0.0%466702 0.001 0.015 0.812
history sync00:00:00.017 0.0%379 0.000 0.045 0.667
history write00:00:06.939 0.0%23504 0.011 0.295 15.301
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle23:58:20.185 99.8%486065 50.463 177.549 446.123
nntp read00:00:02.997 0.0%486849 0.001 0.006 0.020
overview write00:00:37.051 0.0%16849 0.101 2.199 58.840
perl filter00:00:44.279 0.1%23504 1.327 1.884 3.550
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.225 0.0%33698 0.008 0.036 0.098
TOTAL: 24:01:01.33424:00:04.729 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.054 0.0%22866 0.000 0.002 0.021
article prepare00:00:00.000 0.0%9176 0.000 0.000 0.000
article read00:00:00.223 0.0%2070 0.000 0.108 5.500
backlog stats00:00:00.240 0.0%284124 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.402 0.0%231850 0.001 0.006 0.012
data write00:00:02.472 0.0%211744 0.006 0.012 0.021
idle23:53:52.974100.0%284124 185.943 302.801 591.258
status file00:00:10.145 0.0%1829 0.750 5.547 208.053
TOTAL: 23:54:23.64323:54:07.510100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle02:09:19.582 64.4%151393 0.000 51.255235400.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:50.788 0.4%324702 0.000 0.156 6.864
readart00:00:00.956 0.0%11842 0.000 0.081 18.000
TOTAL: 03:20:44.87902:10:11.326 64.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-out.mixmin.net 6 17309 4252 12073 984 24%23:51:15
2news.snarked.org 36 11531 4011 7269 251 34%38:32:04
3news-out.aioe.org 4 12780 1927 10823 30 15%17:14:22
4feeder.eternal-september.org 69 21038 1906 17817 1315 9%46:13:52
5newsfeed.neva.ru 153 15499 1179 10619 3701 7%86:25:46
6csiph.com 2 15982 1047 14892 43 6%23:25:15
7newsfeed.datemas.de 1 18831 537 18043 251 2%25:09:49
8news.redatomik.org 1 16330 532 15706 92 3%27:06:22
9news.albasani.net 2 19176 440 18493 243 2%26:26:25
10news.freedyn.net 2 21512 206 21130 176 0%31:29:03
11news.swapon.de 10 1426 126 1296 4 8%23:32:53
12feeder.awxg.com 2 13389 109 13232 48 0%23:59:56
13agency-nz-out.news.mb-net.net 15 19303 79 19024 200 0%33:00:06
14news.samoylyk.net 3 24660 28 24333 299 0%30:46:05
15localhost 2 1 1 0 0 100%00:00:00
TOTAL: 15 308 228767 16380 204750 7637 7%457:13:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.mixmin.net12.6 MB414.9 KB2.4 MB15.4 MB 82%3.0 KB
2news.snarked.org12.6 MB158.7 KB881.4 KB13.7 MB 92%3.3 KB
3feeder.eternal-september.org7.9 MB692.9 KB5.4 MB13.9 MB 56%4.4 KB
4newsfeed.datemas.de6.4 MB426.5 KB1.2 MB8.0 MB 80%10.4 KB
5news-out.aioe.org5.0 MB94.5 KB94.5 KB5.2 MB 96%2.7 KB
6news.albasani.net3.4 MB567.5 KB889.1 KB4.8 MB 70%7.2 KB
7csiph.com3.0 MB193.5 KB196.8 KB3.4 MB 88%3.2 KB
8newsfeed.neva.ru2.6 MB458.1 KB31.4 MB34.5 MB 7%7.2 KB
9news.freedyn.net1.6 MB418.8 KB1.6 MB3.6 MB 44%9.8 KB
10news.redatomik.org1.1 MB350.5 KB363.7 KB1.8 MB 61%3.0 KB
11agency-nz-out.news.mb-net.net338.6 KB354.2 KB9.3 MB10.0 MB 3%36.7 KB
12news.swapon.de335.7 KB4.5 KB9.3 KB349.5 KB 96%2.7 KB
13feeder.awxg.com288.2 KB158.5 KB158.5 KB605.1 KB 47%3.9 KB
14news.samoylyk.net111.2 KB405.5 KB10.4 MB10.9 MB 0%34.1 KB
15localhost1.6 KB0.0 KB0.0 KB1.6 KB100%1.6 KB
TOTAL: 1557.4 MB4.6 MB64.2 MB126.2 MB 45%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 26 23:58:02 - 23:59:59 19 0.1% 0.1645.6 KB 0.1% 0.39
Dec 27 00:00:00 - 00:59:59 768 4.6% 0.211.8 MB 3.2% 0.52
Dec 27 01:00:00 - 01:59:59 711 4.2% 0.202.3 MB 4.0% 0.65
Dec 27 02:00:00 - 02:59:59 691 4.1% 0.191.9 MB 3.3% 0.55
Dec 27 03:00:00 - 03:59:59 789 4.7% 0.223.7 MB 6.4% 1.05
Dec 27 04:00:00 - 04:59:59 915 5.4% 0.252.6 MB 4.5% 0.74
Dec 27 05:00:00 - 05:59:59 830 4.9% 0.233.4 MB 5.8% 0.96
Dec 27 06:00:00 - 06:59:59 987 5.9% 0.273.5 MB 6.0% 0.98
Dec 27 07:00:00 - 07:59:59 1032 6.1% 0.293.1 MB 5.3% 0.87
Dec 27 08:00:00 - 08:59:59 945 5.6% 0.263.5 MB 6.1% 0.99
Dec 27 09:00:00 - 09:59:59 920 5.5% 0.263.0 MB 5.3% 0.86
Dec 27 10:00:00 - 10:59:59 913 5.4% 0.253.5 MB 6.1% 1.00
Dec 27 11:00:00 - 11:59:59 761 4.5% 0.213.2 MB 5.5% 0.90
Dec 27 12:00:00 - 12:59:59 662 3.9% 0.182.9 MB 5.1% 0.83
Dec 27 13:00:00 - 13:59:59 639 3.8% 0.182.6 MB 4.5% 0.74
Dec 27 14:00:00 - 14:59:59 567 3.4% 0.161.7 MB 2.9% 0.48
Dec 27 15:00:00 - 15:59:59 410 2.4% 0.111.7 MB 2.9% 0.48
Dec 27 16:00:00 - 16:59:59 401 2.4% 0.111.5 MB 2.6% 0.43
Dec 27 17:00:00 - 17:59:59 364 2.2% 0.101.4 MB 2.4% 0.40
Dec 27 18:00:00 - 18:59:59 391 2.3% 0.111.6 MB 2.7% 0.44
Dec 27 19:00:00 - 19:59:59 422 2.5% 0.121.3 MB 2.3% 0.38
Dec 27 20:00:00 - 20:59:59 575 3.4% 0.161.7 MB 2.9% 0.48
Dec 27 21:00:00 - 21:59:59 590 3.5% 0.161.5 MB 2.6% 0.43
Dec 27 22:00:00 - 22:59:59 859 5.1% 0.242.5 MB 4.3% 0.70
Dec 27 23:00:00 - 23:58:02 680 4.0% 0.201.8 MB 3.1% 0.53
TOTAL: 24:00:00 16841 100.0% 0.1957.7 MB 100.0% 0.68
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.5 GB 44.9% 0 0.32 1918.83
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.0 GB 52.1% 0 0.31 1947.71
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB280.1 MB 0.5% 0 0.0414222.22
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.0 GB 28.0% 0 0.51 1181.09
TOTAL: 10-500.0 GB62.8 GB 12.6% 1 0.37-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3683 45 0 73 0 0 0 0 3565
2news-out.mixmin.net 1391 0 0 100 0 0 0 0 1291
3feeder.eternal-september.org 1305 0 0 131 0 0 0 0 1174
4news.snarked.org 271 22 0 54 0 0 0 0 195
5news.albasani.net 259 6 0 80 0 0 0 0 173
6newsfeed.datemas.de 249 36 0 78 0 0 0 0 135
7news.samoylyk.net 228 0 0 46 0 0 0 0 182
8agency-nz-out.news.mb-net.net 198 16 0 68 0 0 0 0 114
9news.freedyn.net 155 7 0 51 0 0 0 0 97
10news.redatomik.org 137 0 0 76 0 0 0 0 61
11news-out.aioe.org 87 0 0 45 0 0 0 0 42
12feeder.awxg.com 64 0 0 61 0 0 0 0 3
13csiph.com 54 0 0 52 0 0 0 0 2
14news.swapon.de 26 0 0 2 0 0 0 0 24
15news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 15 8108 132 0 918 0 0 0 0 7058

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 36
mozilla.support.seamonkey 9
mpc.lists.freebsd.x11 8
mozilla.dev.l10n.sr 8
gmane.linux.kernel.clk 7
gmane.linux.alsa.devel 7
mpc.lists.nanog 7
south-wales.test 6
gmane.comp.gis.openstreetmap.tagging 5
mpc.lists.freebsd.gnome 4
mozilla.dev.ui-alerts 4
al.christnet.bible 3
mpc.lists.freebsd.gecko 3
mpc.lists.freebsd.wireless 3
gmane.linux.drivers.devicetree 2
demos.local.lists.cgp-russian 2
gi.7564gmail.com 2
mozilla.dev.servo 2
mozilla.tools.l10n 2
3do.bad-attitude 1
TOTAL: 31 132

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5141
Binary: misplaced rar 719
EMP (phn path) 347
Binary Image: misplaced jpg 129
EMP (phn nph) 103
Too many newsgroups 48
Binary: misplaced par2 7
EMP (phl) 5
HTML post 4
Binary: non-binary distribution 4
User-issued cancel 3
Binary: misplaced PAR2 2
Angle-bracket bot 1
Too many newsgroups (meow) 1
User-issued spam cancel 1
TOTAL: 15 6515

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 356
news.redatomik.org 55
news-out.aioe.org 41
news.albasani.net 35
news.swapon.de 22
newsfeed.datemas.de 16
newsfeed.neva.ru 6
agency-nz-out.news.mb-net.net 4
feeder.awxg.com 3
news.snarked.org 2
TOTAL: 12 543
TOTAL: 1 543

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15286 763 14494 29 0 0 4%23:59:41
2news.samoylyk.net 16380 343 14549 366 0 2172 2%23:59:46
3awxg 16036 124 15900 2 0 8 0%23:59:38
4news.snarked.org 12515 3 12429 3 0 0 0%23:59:47
5mb-net.net 16775 2 16743 0 0 0 0%23:59:47
6newsfeed.datemas.de 16243 1 16239 0 0 0 0%23:59:29
7csiph.com 15818 1 15760 0 0 0 0%23:59:47
8news-in.mixmin.net 11654 1 11642 0 0 0 0%23:59:47
9news.redatomik.org 16284 1 16260 0 0 0 0%23:59:47
10news.freedyn.net 16675 1 16628 0 0 0 0%23:59:47
11neva.ru 15393 1 15376 0 0 0 0%23:59:47
12news.albasani.net 16590 1 15093 596 0 3824 0%23:59:47
13aioe 13525 1 13461 0 0 0 0%23:59:44
14eternal-september 14249 0 14213 0 0 79 0%23:59:47
15news.swapon.de 1352 0 1352 0 0 0 0%23:08:48
TOTAL: 15 214775 1243 210139 996 0 6083 0%359:05:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org11.3 MB212.2 KB11.5 MB0.1 KB/s14.9 KB23:59:41
2news.samoylyk.net1.3 MB1.7 MB3.0 MB0.0 KB/s4.3 KB23:59:46
3awxg417.6 KB9.8 KB427.4 KB0.0 KB/s3.4 KB23:59:38
4news.snarked.org29.9 KB5.1 KB35.1 KB0.0 KB/s5.8 KB23:59:47
5news.albasani.net4.6 KB1.1 MB1.1 MB0.0 KB/s1.8 KB23:59:47
6mb-net.net4.2 KB0.0 KB4.2 KB0.0 KB/s2.1 KB23:59:47
7newsfeed.datemas.de1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:29
8csiph.com1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:47
9news-in.mixmin.net1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:47
10news.redatomik.org1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:47
11news.freedyn.net1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:47
12neva.ru1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:47
13aioe1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:44
14eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:08:48
TOTAL: 1513.0 MB3.0 MB16.0 MB0.0 KB/s7.3 KB359:05:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 385 661127.9 MB 3677 1 000:13:18
267-61-21-181.cpe.cableone.net 9 23918.7 MB 239 0 1601:33:34
3vorlon.activateit.net.au 24 14142.0 MB 157 0 000:05:47
443.228.220.203.dial.dynamic.acc01-seve-mub.comindico.com.au 7 613.0 KB 1 0 000:18:40
TOTAL: 4 425 1042238.6 MB 4074 1 1603:20:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 385 661127.9 MB 3677 1 000:13:18
2*.cpe.cableone.net 9 23918.7 MB 239 0 1601:33:34
3*.activateit.net.au 24 14142.0 MB 157 0 000:05:47
4*.228.220.203.dial.dynamic.acc01-seve-mub.comindico.com.au 7 613.0 KB 1 0 000:18:40
5unresolved 15 00.0 KB 0 0 001:09:13
TOTAL: 5 440 1042238.6 MB 4074 1 1603:20:37

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 5
TOTAL: 3 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-21-181.cpe.cableone.net 0.736 0.360 0.02401:33:34
118.149.201.197 0.580 0.096 0.00000:44:06
118.149.188.173 0.296 0.040 0.00000:25:07
43.228.220.203.dial.dynamic.acc01-seve-mub.comindico.com.au 0.412 0.068 0.01300:18:40
agency.bbs.geek.nz 27.812 6.968 0.00000:13:18
vorlon.activateit.net.au 1.372 0.428 0.16600:05:47
? 1.760 0.176 0.00000:00:02
TOTAL: 7 32.968 8.136 0.20303:20:37

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.201.197 10
118.149.188.173 5
TOTAL: 2 15

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
43.228.220.203.dial.dynamic.acc01-seve-mub.comindico.com.au 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-21-181.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 3703 35.5%
2alt 2628 25.2%
3comp 1209 11.6%
4uk 713 6.8%
5sci 548 5.3%
6soc 545 5.2%
7linux 543 5.2%
8talk 188 1.8%
9misc 156 1.5%
10news 58 0.6%
11mozilla 38 0.4%
12aus 34 0.3%
13microsoft 33 0.3%
14humanities 9 0.1%
15nz 8 0.1%
16agency 4 0.0%
17eternal-september 3 0.0%
TOTAL: 17 10420100.0%

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

NewsgroupCount
1rec.arts.tv 1494
2rec.arts.drwho 691
3alt.fan.rush-limbaugh 673
4alt.atheism 634
5alt.comp.os.windows-10 530
6alt.politics.trump 278
7linux.debian.bugs.dist 235
8uk.legal 216
9uk.d-i-y 204
10comp.lang.c 188
11comp.os.linux.advocacy 184
12rec.food.cooking 161
13rec.arts.sf.written 160
14uk.radio.amateur 142
15rec.arts.sf.tv 130
16sci.physics 125
17rec.sport.tennis 120
18misc.survivalism 120
19rec.radio.shortwave 112
20alt.bible 99
21comp.mobile.android 95
22linux.debian.changes.devel 93
23soc.retirement 90
24talk.origins 87
25comp.lang.python 81
26sci.math 79
27comp.sys.mac.apps 68
28rec.photo.digital 64
29sci.electronics.design 64
30soc.culture.polish 64
31sci.physics.relativity 60
32talk.politics.guns 58
33news.lists.filters 57
34linux.debian.user 56
35comp.lang.fortran 56
36rec.gambling.poker 55
37rec.sport.cricket 54
38soc.culture.china 54
39comp.arch 53
40alt.politics 51
41rec.sport.pro-wrestling 50
42rec.sport.football.college 48
43linux.debian.bugs.rc 47
44alt.society.liberalism 47
45uk.rec.cycling 46
46comp.ai.philosophy 46
47comp.lang.idl-pvwave 45
48soc.culture.indian 44
49rec.aviation.soaring 44
50linux.debian.devel 43
51rec.music.classical.recordings 43
52sci.logic 43
53rec.sport.golf 42
54alt.test 41
55talk.politics.misc 40
56alt.recovery.aa 40
57sci.med.cardiology 38
58rec.sport.soccer 38
59alt.support.diabetes 36
60alt.conspiracy.jfk 36
61uk.legal.moderated 36
62rec.boats 35
63comp.lang.lisp 35
64sci.military.naval 34
65comp.sys.mac.advocacy 34
66soc.culture.vietnamese 33
67comp.sys.mac.system 32
68soc.culture.usa 31
69mozilla.general 30
70sci.math.num-analysis 28
71rec.outdoors.rv-travel 27
72soc.penpals 27
73soc.culture.singapore 27
74comp.lang.forth 27
75rec.arts.movies.current-films 27
76aus.electronics 25
77alt.os.linux.ubuntu 25
78uk.tech.digital-tv 25
79soc.culture.romanian 24
80rec.crafts.metalworking 23
81alt.rush-limbaugh 23
82alt.astronomy 22
83comp.sys.raspberry-pi 22
84comp.sys.apple2 22
85comp.lang.c++ 22
86soc.culture.israel 22
87rec.games.pinball 21
88alt.conspiracy 20
89microsoft.public.windowsxp.general 20
90comp.os.vms 18
91sci.crypt 17
92alt.alien.visitors 17
93comp.misc 16
94rec.music.dylan 16
95soc.culture.brazil 16
96comp.os.linux.misc 16
97comp.soft-sys.sas 15
98alt.politics.usa 15
99rec.aviation.student 15
100rec.arts.poems 14
TOTAL: 325 10420