news.bbs.geek.nz daily logs

Dec 8 23:58:01 -- Dec 9 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 179548 68.0%17.1 MB 51.8%
innd 33028 12.5%5.2 MB 15.7%
inn 26659 10.1%5.9 MB 17.9%
innfeed 23261 8.8%4.5 MB 13.8%
cnfsstat 1440 0.5%255.1 KB 0.8%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 263937 100.0%33.0 MB100.0%

History cache:

ReasonCount%Count
Negative hits 259595 49.5%
Positive hits 239602 45.7%
Do not exist 24860 4.7%
Cache misses 137 0.0%
TOTAL: 4 524194 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.505 0.0%166 0.000 3.042 28.000
article cleanup00:00:00.215 0.0%25935 0.000 0.008 0.057
article logging00:00:00.651 0.0%26519 0.000 0.025 0.077
article parse00:00:00.814 0.0%63953 0.000 0.013 0.036
article write00:00:01.571 0.0%19206 0.000 0.082 1.083
artlog/artcncl00:00:00.001 0.0%154 0.000 0.006 0.077
data move00:00:00.322 0.0%503820 0.000 0.001 0.014
hisgrep/artcncl00:00:00.173 0.0%147 0.000 1.177 13.231
hishave/artcncl00:00:00.166 0.0%166 0.000 1.000 12.769
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.957 0.0%528831 0.001 0.013 0.905
history sync00:00:00.009 0.0%311 0.000 0.029 0.500
history write00:00:08.133 0.0%25065 0.000 0.324 22.838
hiswrite/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
idle23:57:40.873 99.8%520072 85.474 165.863 616.078
nntp read00:00:02.923 0.0%520711 0.002 0.006 0.018
overview write00:00:37.031 0.0%19206 0.036 1.928 57.481
perl filter00:00:47.432 0.1%25065 1.376 1.892 6.694
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.116 0.0%38412 0.003 0.029 0.101
TOTAL: 24:00:22.05123:59:28.892 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.068 0.0%25534 0.000 0.003 0.026
article prepare00:00:00.003 0.0%16460 0.000 0.000 0.005
article read00:00:00.158 0.0%1985 0.000 0.080 3.077
backlog stats00:00:00.233 0.0%304576 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.492 0.0%256314 0.001 0.006 0.013
data write00:00:02.736 0.0%242531 0.003 0.011 0.021
idle23:54:08.465 99.9%304576 129.845 282.519 774.834
status file00:00:24.419 0.0%1934 0.733 12.626 586.056
TOTAL: 23:54:55.88923:54:37.574100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:00:05.616 95.1%547305 0.000 144.719 62195.665
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:25.849 0.0%464881 0.000 0.056 1.684
readart00:00:01.229 0.0%18645 0.000 0.066 5.500
TOTAL: 23:07:31.80522:00:32.694 95.2%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 41 14860 4829 9731 300 32%41:52:14
2news.albasani.net 1 20339 2605 17151 583 12%24:09:06
3news-out.mixmin.net 10 19718 2550 16511 657 12%26:04:28
4feeder.eternal-september.org 55 21215 1831 18455 929 8%39:49:56
5newsfeed.datemas.de 1 19001 1804 16857 340 9%22:10:39
6news-out.aioe.org 3 17030 1508 15397 125 8%19:03:01
7news.redatomik.org 1 18722 1126 17531 65 6%25:17:54
8newsfeed.neva.ru 146 13201 1119 9498 2584 8%80:12:46
9csiph.com 1 18823 962 17811 50 5%23:33:14
10localhost 1010 1009 225 506 278 22%00:00:00
11news.swapon.de 3 1823 166 1651 6 9%24:05:32
12feeder.awxg.com 2 16953 154 16760 39 0%23:59:51
13news.samoylyk.net 2 24390 108 23813 469 0%24:55:53
14agency-nz-out.news.mb-net.net 16 19358 79 19152 127 0%26:00:17
15news.freedyn.net 1 12366 24 12305 37 0%14:43:13
16news.ausics.org 2 26796 5 26790 1 0%27:38:43
TOTAL: 16 1295 265604 19095 239919 6590 7%443:36:47
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org15.2 MB191.5 KB1.4 MB16.8 MB 90%3.3 KB
2news.albasani.net8.8 MB475.4 KB1.5 MB10.7 MB 81%3.4 KB
3newsfeed.datemas.de7.9 MB361.9 KB1.4 MB9.6 MB 82%4.6 KB
4news-out.mixmin.net7.5 MB488.5 KB1.7 MB9.7 MB 77%3.1 KB
5feeder.eternal-september.org6.4 MB614.8 KB3.3 MB10.3 MB 61%3.8 KB
6news-out.aioe.org3.3 MB70.7 KB261.5 KB3.6 MB 91%2.3 KB
7newsfeed.neva.ru2.9 MB257.0 KB9.7 MB12.9 MB 22%3.6 KB
8csiph.com2.7 MB209.7 KB222.4 KB3.2 MB 86%3.2 KB
9news.redatomik.org2.7 MB213.7 KB223.6 KB3.1 MB 86%2.7 KB
10localhost689.3 KB0.0 KB522.4 KB1.2 MB 56%2.4 KB
11agency-nz-out.news.mb-net.net633.5 KB329.7 KB876.3 KB1.8 MB 34%8.9 KB
12feeder.awxg.com464.3 KB117.8 KB128.2 KB710.2 KB 65%3.7 KB
13news.swapon.de420.7 KB13.8 KB13.8 KB448.3 KB 93%2.6 KB
14news.freedyn.net369.7 KB75.8 KB84.3 KB529.8 KB 69%8.7 KB
15news.samoylyk.net360.4 KB355.9 KB8.2 MB8.9 MB 3%15.8 KB
16news.ausics.org12.9 KB1.9 KB1.9 KB16.6 KB 77%2.8 KB
TOTAL: 1660.3 MB3.7 MB29.5 MB93.5 MB 64%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 8 23:58:01 - 23:59:59 29 0.2% 0.2495.0 KB 0.2% 0.80
Dec 9 00:00:00 - 00:59:59 914 4.8% 0.252.5 MB 4.1% 0.70
Dec 9 01:00:00 - 01:59:59 864 4.5% 0.242.2 MB 3.7% 0.63
Dec 9 02:00:00 - 02:59:59 897 4.7% 0.252.3 MB 3.7% 0.64
Dec 9 03:00:00 - 03:59:59 1160 6.0% 0.324.0 MB 6.6% 1.13
Dec 9 04:00:00 - 04:59:59 983 5.1% 0.272.7 MB 4.5% 0.77
Dec 9 05:00:00 - 05:59:59 1209 6.3% 0.343.5 MB 5.9% 1.01
Dec 9 06:00:00 - 06:59:59 1138 5.9% 0.322.8 MB 4.7% 0.81
Dec 9 07:00:00 - 07:59:59 1277 6.6% 0.353.8 MB 6.4% 1.09
Dec 9 08:00:00 - 08:59:59 1176 6.1% 0.333.6 MB 6.0% 1.02
Dec 9 09:00:00 - 09:59:59 1007 5.2% 0.283.2 MB 5.3% 0.90
Dec 9 10:00:00 - 10:59:59 1078 5.6% 0.303.8 MB 6.4% 1.09
Dec 9 11:00:00 - 11:59:59 886 4.6% 0.252.9 MB 4.8% 0.82
Dec 9 12:00:00 - 12:59:59 678 3.5% 0.192.9 MB 4.8% 0.83
Dec 9 13:00:00 - 13:59:59 647 3.4% 0.182.3 MB 3.9% 0.66
Dec 9 14:00:00 - 14:59:59 729 3.8% 0.202.3 MB 3.9% 0.66
Dec 9 15:00:00 - 15:59:59 440 2.3% 0.121.5 MB 2.6% 0.44
Dec 9 16:00:00 - 16:59:59 399 2.1% 0.111.4 MB 2.3% 0.39
Dec 9 17:00:00 - 17:59:59 339 1.8% 0.091.1 MB 1.9% 0.33
Dec 9 18:00:00 - 18:59:59 345 1.8% 0.101.3 MB 2.2% 0.38
Dec 9 19:00:00 - 19:59:59 311 1.6% 0.091.2 MB 2.0% 0.34
Dec 9 20:00:00 - 20:59:59 486 2.5% 0.142.2 MB 3.7% 0.63
Dec 9 21:00:00 - 21:59:59 669 3.5% 0.191.8 MB 3.0% 0.51
Dec 9 22:00:00 - 22:59:59 730 3.8% 0.202.0 MB 3.4% 0.58
Dec 9 23:00:00 - 23:58:02 837 4.4% 0.242.6 MB 4.3% 0.77
TOTAL: 24:00:01 19228 100.0% 0.2260.2 MB 100.0% 0.71
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.1 GB 44.1% 0 0.33 1828.08
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.6 GB 51.2% 0 0.35 1722.65
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB275.5 MB 0.5% 0 0.0512190.48
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 GB13.1 GB 26.1% 0 0.60 1007.04
TOTAL: 10-500.0 GB61.0 GB 12.2% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2626 54 0 56 0 0 0 0 2516
2feeder.eternal-september.org 990 0 0 137 0 0 0 0 853
3news-out.mixmin.net 833 0 0 92 0 0 0 0 741
4news.albasani.net 765 11 0 58 0 0 0 0 696
5newsfeed.datemas.de 417 63 0 61 0 0 0 0 293
6news.samoylyk.net 397 0 0 69 0 0 0 0 328
7news.snarked.org 299 46 0 69 0 0 0 0 184
8localhost 278 0 0 0 0 0 0 0 278
9news.redatomik.org 200 0 0 60 0 0 0 0 140
10news-out.aioe.org 151 4 0 43 0 0 0 0 104
11agency-nz-out.news.mb-net.net 133 19 0 65 0 0 0 0 49
12news.freedyn.net 70 0 0 59 0 0 0 0 11
13csiph.com 50 0 0 48 0 0 0 0 2
14feeder.awxg.com 46 1 0 43 0 0 0 0 2
15news.swapon.de 20 0 0 5 0 0 0 0 15
16news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 16 7277 198 0 867 0 0 0 0 6212

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.nanog 23
ut.test 22
mpc.lists.freebsd.ports.bugs 21
gmane.linux.alsa.devel 19
mozilla.support.seamonkey 14
mpc.lists.freebsd.office 11
mozilla.dev.platform 9
gmane.comp.gis.openstreetmap.tagging 7
fido7.ru.android 6
mpc.lists.freebsd.x11 5
mpc.lists.freebsd.gnome 4
mozilla.dev.security.policy 4
gmane.linux.drivers.devicetree 4
mozilla.dev.ui-alerts 4
gmane.comp.freedesktop.xorg.drivers.intel 3
gmane.comp.sysutils.ddrescue 3
gmane.linux.kernel.iio 3
mozilla.dev.tech.crypto 3
mpc.lists.freebsd.gecko 3
gmane.linux.kernel.stable 2
TOTAL: 45 198

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4608
EMP (phn nph) 348
EMP (phn path) 241
EMP (phl) 158
Binary: misplaced rar 96
Too many newsgroups 77
User-issued cancel 39
Too many newsgroups (low_xpost) 35
Binary: non-binary distribution 11
Binary: misplaced PAR2 9
Binary: misplaced par2 4
HTML post 2
User-issued spam cancel 1
Cancel for rejected article 1
Angle-bracket bot 1
TOTAL: 15 5631

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 204
news-out.mixmin.net 135
news.redatomik.org 129
newsfeed.datemas.de 80
news.swapon.de 15
news-out.aioe.org 9
agency-nz-out.news.mb-net.net 4
newsfeed.neva.ru 3
news.samoylyk.net 1
feeder.awxg.com 1
TOTAL: 10 581
TOTAL: 1 581

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17393 1066 16244 83 0 0 6%23:59:47
2awxg 18790 350 18416 8 0 21 1%23:59:46
3csiph.com 18433 218 18059 6 0 2 1%23:59:46
4news.snarked.org 14316 173 14041 47 0 12 1%23:59:36
5news.samoylyk.net 17362 148 17137 4 0 107 0%23:59:34
6news.redatomik.org 18083 125 17930 0 0 68 0%23:59:46
7eternal-september 16570 118 16373 0 0 68 0%23:59:45
8mb-net.net 19159 113 18991 17 0 73 0%23:59:44
9news-in.mixmin.net 15699 87 15563 24 0 66 0%23:59:46
10news.freedyn.net 19356 78 19081 6 0 113 0%23:59:46
11news.swapon.de 1942 39 1864 0 0 180 2%23:53:14
12neva.ru 17765 30 17534 181 0 0 0%23:59:46
13aioe 16638 28 16306 183 0 17 0%23:59:42
14news.albasani.net 18291 20 15577 855 0 5482 0%23:59:46
15newsfeed.datemas.de 17454 10 17409 0 0 267 0%23:59:46
TOTAL: 15 247251 2603 240525 1414 0 6476 1%359:49:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.9 MB4.7 MB9.7 MB0.1 KB/s8.6 KB23:59:47
2awxg999.1 KB66.9 KB1.0 MB0.0 KB/s3.0 KB23:59:46
3news.snarked.org606.5 KB74.4 KB681.0 KB0.0 KB/s3.1 KB23:59:36
4news.samoylyk.net519.4 KB57.4 KB576.8 KB0.0 KB/s3.8 KB23:59:34
5csiph.com464.8 KB225.1 KB689.9 KB0.0 KB/s3.1 KB23:59:46
6eternal-september453.9 KB0.0 KB453.9 KB0.0 KB/s3.8 KB23:59:45
7mb-net.net449.0 KB28.0 KB477.0 KB0.0 KB/s3.7 KB23:59:44
8news.redatomik.org351.5 KB0.0 KB351.5 KB0.0 KB/s2.8 KB23:59:46
9news-in.mixmin.net255.7 KB193.0 KB448.8 KB0.0 KB/s4.0 KB23:59:46
10news.freedyn.net196.9 KB22.3 KB219.3 KB0.0 KB/s2.6 KB23:59:46
11news.swapon.de150.4 KB0.0 KB150.4 KB0.0 KB/s3.9 KB23:53:14
12neva.ru145.8 KB519.0 KB664.8 KB0.0 KB/s3.2 KB23:59:46
13aioe49.2 KB374.1 KB423.3 KB0.0 KB/s2.0 KB23:59:42
14news.albasani.net40.6 KB2.9 MB2.9 MB0.0 KB/s3.4 KB23:59:46
15newsfeed.datemas.de19.1 KB0.0 KB19.1 KB0.0 KB/s1.9 KB23:59:46
TOTAL: 159.5 MB9.1 MB18.6 MB0.0 KB/s4.8 KB359:49:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 808726.4 MB 1173 0 1602:19:39
2agency.bbs.geek.nz 393 761524.0 MB 4073 2456386400:32:23
3vorlon.activateit.net.au 24 15622.0 MB 156 0 000:06:15
4192.168.1.9 2 18113.6 KB 2 0 000:00:01
567-60-219-146.cpe.cableone.net 2 00.0 KB 1 0 019:03:24
TOTAL: 5 429 1728252.5 MB 5405 2456388023:07:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 10 808726.4 MB 1174 0 1621:23:04
2*.bbs.geek.nz 393 761524.0 MB 4073 2456386400:32:23
3*.activateit.net.au 24 15622.0 MB 156 0 000:06:15
4unresolved 16 18113.6 KB 2 0 001:05:37
TOTAL: 4 443 1728252.5 MB 5405 2456388023:07:24

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 2
paulh 2
TOTAL: 4 36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.132 0.080 0.00619:03:24
67-61-21-181.cpe.cableone.net 1.580 1.128 0.03002:19:39
118.149.246.70 0.536 0.072 0.00000:45:12
agency.bbs.geek.nz 32.176 11.716 0.00000:32:23
118.149.254.99 0.300 0.032 0.00000:20:23
vorlon.activateit.net.au 1.428 0.404 0.16600:06:15
? 1.556 0.168 0.00000:00:02
192.168.1.9 0.136 0.032 0.00600:00:01
TOTAL: 8 37.844 13.632 0.20823:07:24

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.246.70 9
118.149.254.99 5
TOTAL: 2 14

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 6643 38.4%
2comp 2366 13.7%
3alt 2177 12.6%
4soc 1447 8.4%
5uk 1426 8.3%
6sci 1052 6.1%
7linux 946 5.5%
8talk 613 3.5%
9news 203 1.2%
10mozilla 176 1.0%
11misc 169 1.0%
12nz 25 0.1%
13microsoft 18 0.1%
14eternal-september 11 0.1%
15humanities 6 0.0%
16aus 4 0.0%
17us 1 0.0%
TOTAL: 17 17283100.0%

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

NewsgroupCount
1rec.arts.tv 1754
2comp.lang.python 629
3rec.arts.sf.written 579
4alt.fan.rush-limbaugh 502
5uk.d-i-y 466
6alt.comp.os.windows-10 462
7rec.sport.golf 429
8uk.legal 387
9rec.food.cooking 386
10linux.debian.bugs.dist 343
11alt.atheism 330
12soc.retirement 329
13rec.sport.football.college 303
14rec.arts.drwho 297
15rec.sport.tennis 286
16sci.electronics.design 248
17rec.arts.sf.tv 243
18comp.lang.c++ 236
19talk.origins 229
20talk.politics.guns 225
21rec.boats 222
22soc.culture.israel 208
23uk.radio.amateur 206
24soc.culture.polish 190
25comp.lang.c 176
26news.lists.filters 171
27sci.math 156
28sci.physics 148
29talk.politics.misc 135
30comp.os.vms 132
31linux.debian.changes.devel 130
32alt.politics.trump 128
33comp.sys.apple2 126
34alt.astronomy 125
35sci.physics.relativity 124
36soc.culture.china 123
37alt.test 122
38comp.os.linux.advocacy 120
39alt.politics 115
40rec.gambling.poker 114
41soc.culture.indian 112
42rec.photo.digital 111
43rec.woodworking 110
44rec.sport.pro-wrestling 108
45uk.tech.digital-tv 98
46rec.radio.shortwave 95
47rec.music.classical.recordings 94
48rec.audio.opinion 90
49comp.lang.perl.misc 90
50linux.debian.bugs.rc 90
51linux.debian.user 88
52soc.culture.usa 88
53rec.skiing.alpine 84
54alt.support.diabetes 80
55rec.aviation.soaring 80
56rec.aviation.marketplace 80
57mozilla.support.firefox 80
58rec.aquaria.marine.misc 80
59comp.lang.forth 78
60uk.comp.sys.mac 78
61rec.arts.poems 76
62comp.sys.mac.advocacy 75
63rec.bicycles.tech 74
64rec.sport.soccer 74
65comp.lang.java.programmer 74
66mozilla.general 70
67uk.legal.moderated 67
68sci.med.cardiology 66
69soc.culture.singapore 66
70sci.military.naval 65
71comp.sys.mac.system 63
72misc.phone.mobile.iphone 60
73sci.logic 58
74alt.recovery.aa 56
75linux.gentoo.user 56
76comp.mobile.android 56
77uk.rec.cycling 56
78rec.drugs.cannabis 54
79rec.outdoors.rv-travel 52
80alt.bible 50
81rec.arts.movies.current-films 48
82alt.politics.usa 43
83comp.lang.ada 42
84rec.radio.amateur.misc 42
85rec.music.rock-pop-r+b.1950s 39
86comp.lang.idl-pvwave 38
87sci.electronics.repair 38
88rec.music.makers.guitar.jazz 36
89soc.genealogy.medieval 36
90comp.sys.mac.apps 36
91rec.games.roguelike.nethack 36
92rec.games.pinball 35
93alt.tv.days-of-our-lives 34
94linux.debian.ports.sparc 33
95rec.autos.sport.f1 33
96alt.society.liberalism 33
97soc.culture.vietnamese 32
98comp.lang.tcl 32
99rec.crafts.metalworking 30
100rec.arts.comics.strips 30
TOTAL: 373 17283