news.bbs.geek.nz daily logs

Aug 6 23:58:02 -- Aug 7 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 103051 55.9%8.3 MB 34.4%
innd 29823 16.2%4.9 MB 20.2%
inn 26925 14.6%6.1 MB 25.2%
innfeed 23187 12.6%4.6 MB 19.1%
cnfsstat 1440 0.8%255.6 KB 1.0%
controlchan 5 0.0%0.9 KB 0.0%
TOTAL: 6 184431 100.0%24.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 257732 48.5%
Negative hits 248500 46.8%
Do not exist 24643 4.6%
Cache misses 155 0.0%
TOTAL: 4 531030 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.145 0.0%172 0.000 0.843 18.000
article cleanup00:00:00.231 0.0%26203 0.000 0.009 0.037
article logging00:00:00.725 0.0%26750 0.000 0.027 0.422
article parse00:00:00.902 0.0%78733 0.003 0.011 0.027
article write00:00:03.258 0.0%20043 0.017 0.163 17.514
artlog/artcncl00:00:00.000 0.0%164 0.000 0.000 0.000
data move00:00:00.482 0.0%504451 0.000 0.001 0.015
hisgrep/artcncl00:00:00.002 0.0%168 0.000 0.012 0.250
hishave/artcncl00:00:00.000 0.0%172 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.186 0.0%535903 0.001 0.010 1.277
history sync00:00:00.012 0.0%367 0.000 0.033 0.500
history write00:00:04.498 0.0%24866 0.020 0.181 17.347
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:57:58.296 99.8%521415 97.078 165.470 455.860
nntp read00:00:03.257 0.0%523648 0.002 0.006 0.026
overview write00:00:41.620 0.0%20043 0.084 2.077 135.790
perl filter00:00:52.205 0.1%24866 1.291 2.099 5.620
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.356 0.0%40089 0.009 0.034 0.089
TOTAL: 24:00:46.78023:59:52.175 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.077 0.0%26643 0.000 0.003 0.023
article prepare00:00:00.002 0.0%16222 0.000 0.000 0.013
article read00:00:00.359 0.0%3814 0.000 0.094 7.941
backlog stats00:00:00.298 0.0%320978 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.576 0.0%266466 0.001 0.006 0.011
data write00:00:02.780 0.0%256309 0.004 0.011 0.019
idle23:53:47.054100.0%320978 173.763 268.015 537.495
status file00:00:06.742 0.0%1852 0.800 3.640 133.735
TOTAL: 23:54:13.56023:53:58.888100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%23 0.000 0.000 0.000
idle09:09:44.461 96.9%110815 0.000 297.653 75250.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.715 0.0%239871 0.000 0.041 10.697
readart00:00:03.502 0.0%9952 0.000 0.352 45.000
TOTAL: 09:27:05.10709:09:57.678 97.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control-redatomik@redatomik.org201003
TOTAL201003

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 63 19113 5853 12965 295 30%70:28:19
2news-out.mixmin.net 24 22581 4089 17362 1130 18%40:50:06
3feeder.eternal-september.org 54 23686 2800 19933 953 11%45:26:43
4newsfeed.datemas.de 3 22050 1761 19761 528 7%24:49:33
5news-out.aioe.org 5 20729 1446 19172 111 6%25:36:45
6newsfeed.neva.ru 163 17567 1331 14474 1762 7%94:36:40
7csiph.com 4 22183 1074 21001 108 4%29:21:36
8news.albasani.net 1 21163 750 20015 398 3%24:02:15
9news.redatomik.org 3 20244 569 19550 125 2%25:34:42
10feeder.awxg.com 2 16226 298 15849 79 1%23:59:32
11news.samoylyk.net 3 23257 232 22577 448 0%24:42:29
12news.swapon.de 8 1893 209 1655 29 11%26:26:05
13news.freedyn.net 3 22510 202 22176 132 0%24:35:11
14agency-nz-out.news.mb-net.net 26 21567 108 21247 212 0%36:13:14
15localhost 8 7 6 0 1 85%00:00:00
TOTAL: 15 370 274776 20728 247737 6311 7%516:43:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org20.1 MB479.1 KB1.3 MB21.9 MB 91%3.6 KB
2news-out.mixmin.net13.1 MB497.3 KB2.8 MB16.4 MB 79%3.2 KB
3feeder.eternal-september.org10.6 MB685.8 KB12.2 MB23.5 MB 45%6.4 KB
4newsfeed.datemas.de8.0 MB1.0 MB3.3 MB12.4 MB 64%5.5 KB
5news-out.aioe.org4.0 MB279.8 KB356.8 KB4.6 MB 86%3.0 KB
6news.albasani.net3.7 MB436.7 KB1010.9 KB5.2 MB 72%4.6 KB
7newsfeed.neva.ru3.7 MB350.2 KB7.8 MB11.8 MB 31%3.9 KB
8csiph.com2.6 MB410.5 KB425.3 KB3.5 MB 76%3.0 KB
9news.samoylyk.net1.5 MB493.8 KB5.5 MB7.5 MB 20%11.4 KB
10news.redatomik.org1.5 MB324.6 KB377.8 KB2.1 MB 68%3.2 KB
11news.freedyn.net943.2 KB434.5 KB1.0 MB2.3 MB 39%7.2 KB
12feeder.awxg.com869.8 KB309.9 KB314.0 KB1.5 MB 58%4.0 KB
13news.swapon.de572.2 KB68.7 KB135.8 KB776.6 KB 73%3.3 KB
14agency-nz-out.news.mb-net.net374.5 KB271.6 KB5.6 MB6.2 MB 5%19.9 KB
15localhost10.9 KB0.0 KB2.2 KB13.1 KB 83%1.9 KB
TOTAL: 1571.5 MB6.0 MB42.2 MB119.7 MB 59%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 6 23:58:02 - 23:59:59 21 0.1% 0.1849.2 KB 0.1% 0.42
Aug 7 00:00:00 - 00:59:59 903 4.5% 0.252.3 MB 3.3% 0.66
Aug 7 01:00:00 - 01:59:59 980 4.9% 0.272.9 MB 4.1% 0.82
Aug 7 02:00:00 - 02:59:59 1064 5.3% 0.303.6 MB 5.1% 1.01
Aug 7 03:00:00 - 03:59:59 943 4.7% 0.263.2 MB 4.5% 0.90
Aug 7 04:00:00 - 04:59:59 971 4.8% 0.273.8 MB 5.5% 1.09
Aug 7 05:00:00 - 05:59:59 1225 6.1% 0.343.5 MB 5.0% 1.00
Aug 7 06:00:00 - 06:59:59 1070 5.3% 0.303.5 MB 5.1% 1.01
Aug 7 07:00:00 - 07:59:59 1111 5.5% 0.313.0 MB 4.3% 0.85
Aug 7 08:00:00 - 08:59:59 957 4.8% 0.272.8 MB 4.0% 0.79
Aug 7 09:00:00 - 09:59:59 864 4.3% 0.242.9 MB 4.1% 0.81
Aug 7 10:00:00 - 10:59:59 897 4.5% 0.254.5 MB 6.4% 1.27
Aug 7 11:00:00 - 11:59:59 652 3.2% 0.184.3 MB 6.2% 1.23
Aug 7 12:00:00 - 12:59:59 624 3.1% 0.172.7 MB 3.9% 0.78
Aug 7 13:00:00 - 13:59:59 460 2.3% 0.131.5 MB 2.2% 0.43
Aug 7 14:00:00 - 14:59:59 523 2.6% 0.152.4 MB 3.4% 0.68
Aug 7 15:00:00 - 15:59:59 412 2.1% 0.111.6 MB 2.3% 0.45
Aug 7 16:00:00 - 16:59:59 604 3.0% 0.174.2 MB 6.0% 1.20
Aug 7 17:00:00 - 17:59:59 578 2.9% 0.161.9 MB 2.7% 0.53
Aug 7 18:00:00 - 18:59:59 741 3.7% 0.212.4 MB 3.4% 0.68
Aug 7 19:00:00 - 19:59:59 907 4.5% 0.252.7 MB 3.8% 0.77
Aug 7 20:00:00 - 20:59:59 946 4.7% 0.262.7 MB 3.8% 0.75
Aug 7 21:00:00 - 21:59:59 818 4.1% 0.232.3 MB 3.2% 0.65
Aug 7 22:00:00 - 22:59:59 918 4.6% 0.262.8 MB 4.0% 0.79
Aug 7 23:00:00 - 23:58:01 876 4.4% 0.252.5 MB 3.6% 0.74
TOTAL: 23:59:59 20065 100.0% 0.2369.9 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.0 GB 38.0% 0 0.32 1875.02
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.1 GB 44.2% 0 0.30 2004.41
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB233.2 MB 0.5% 0 0.0319753.09
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 GB6.0 GB 12.1% 0 0.71 860.16
TOTAL: 10-500.0 GB47.4 GB 9.5% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1769 135 0 91 0 0 0 0 1543
2news-out.mixmin.net 1313 0 0 116 0 0 0 0 1197
3feeder.eternal-september.org 914 0 0 136 0 0 0 0 778
4newsfeed.datemas.de 596 208 0 125 0 0 0 0 263
5news.samoylyk.net 436 0 0 128 0 0 0 0 308
6news.albasani.net 416 1 0 114 0 0 0 0 301
7news.snarked.org 295 29 0 102 0 0 0 0 164
8agency-nz-out.news.mb-net.net 220 37 0 81 0 0 0 0 102
9news.redatomik.org 164 2 0 89 0 0 0 0 73
10news.freedyn.net 137 8 0 79 0 0 0 0 50
11news.swapon.de 129 0 0 29 0 0 0 0 100
12news-out.aioe.org 111 25 0 71 0 0 0 0 15
13csiph.com 100 0 0 95 0 0 0 0 5
14feeder.awxg.com 92 2 0 80 0 0 0 0 10
15news.ausics.org 3 0 0 2 0 0 0 0 1
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 6696 447 0 1338 0 0 0 0 4911

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 156
it.annunci.commerciali 45
it.annunci.varie 38
it.annunci.immobiliari 37
gmane.linux.alsa.devel 21
gmane.linux.kernel 20
gmane.comp.gis.openstreetmap.tagging 16
mozilla.support.seamonkey 14
mozilla.dev.l10n 9
mozilla.dev.security.policy 8
fido7.ru.android 8
gmane.comp.emulators.xen.devel 7
mozilla.dev.platform 6
mpc.lists.freebsd.gnome 5
mozilla.test 5
mozilla.dev.ui-alerts 4
mpc.lists.nanog 4
gmane.linux.kernel.input 4
gmane.linux.bios.flashrom 2
mpc.lists.freebsd.office 2
TOTAL: 50 447

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3451
EMP (phn path) 504
EMP (phn nph) 246
Binary Image: misplaced jpg 57
Too many newsgroups 39
Binary: non-binary distribution 28
EMP (phl) 23
User-issued cancel 9
HTML post 3
Cancel for rejected article 2
Binary: misplaced 665 1
TOTAL: 11 4363

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 259
news.swapon.de 98
newsfeed.datemas.de 81
news.albasani.net 42
news.redatomik.org 25
newsfeed.neva.ru 12
news-out.aioe.org 10
news.snarked.org 8
feeder.awxg.com 6
news.samoylyk.net 4
TOTAL: 12 548
TOTAL: 1 548

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18505 2835 15549 121 0 11 15%23:59:23
2awxg 19889 103 19439 3 0 6 0%23:59:49
3csiph.com 19166 19 19031 1 0 0 0%23:59:48
4news.snarked.org 14336 18 14196 1 0 32 0%23:59:49
5news.freedyn.net 20185 13 19858 1 0 105 0%23:59:49
6aioe 16658 9 16552 1 0 0 0%23:59:49
7news.redatomik.org 19448 8 19405 0 0 9 0%23:59:49
8news.samoylyk.net 18365 6 18283 0 0 24 0%23:59:48
9neva.ru 18393 6 18374 0 0 0 0%23:59:49
10eternal-september 16814 6 16611 1 0 166 0%23:59:49
11news-in.mixmin.net 15719 6 15679 0 0 18 0%23:59:48
12newsfeed.datemas.de 18400 3 18364 0 0 104 0%23:59:49
13mb-net.net 20037 3 19910 0 0 189 0%23:59:49
14news.albasani.net 20619 3 18326 799 1 6048 0%23:59:49
15news.swapon.de 1936 1 1933 0 0 0 0%23:57:47
TOTAL: 15 258470 3039 251510 928 1 6712 1%359:54:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.3 MB6.2 MB16.5 MB0.2 KB/s5.7 KB23:59:23
2news.snarked.org1.8 MB2.1 KB1.8 MB0.0 KB/s98.1 KB23:59:49
3awxg374.5 KB18.2 KB392.7 KB0.0 KB/s3.7 KB23:59:49
4csiph.com62.6 KB1.5 KB64.1 KB0.0 KB/s3.2 KB23:59:48
5news.freedyn.net35.9 KB1.5 KB37.5 KB0.0 KB/s2.7 KB23:59:49
6news.redatomik.org21.5 KB0.0 KB21.5 KB0.0 KB/s2.7 KB23:59:49
7aioe21.2 KB5.6 KB26.8 KB0.0 KB/s2.7 KB23:59:49
8news.samoylyk.net10.9 KB0.0 KB10.9 KB0.0 KB/s1.8 KB23:59:48
9neva.ru10.9 KB0.0 KB10.9 KB0.0 KB/s1.8 KB23:59:49
10news-in.mixmin.net10.9 KB0.0 KB10.9 KB0.0 KB/s1.8 KB23:59:48
11eternal-september9.0 KB20.7 KB29.7 KB0.0 KB/s4.2 KB23:59:49
12news.albasani.net6.2 KB3.0 MB3.0 MB0.0 KB/s3.8 KB23:59:49
13newsfeed.datemas.de4.3 KB0.0 KB4.3 KB0.0 KB/s1.4 KB23:59:49
14mb-net.net4.3 KB0.0 KB4.3 KB0.0 KB/s1.4 KB23:59:49
15news.swapon.de1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:57:47
TOTAL: 1512.7 MB9.2 MB21.9 MB0.0 KB/s5.6 KB359:54:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 342 632521.6 MB 3265 3 1000:10:56
2163.47.16.169 24 11061.4 MB 136 0 000:04:58
367-61-81-51.cpe.cableone.net 25 10983.4 MB 189 3 200:25:53
460.234.244.55 8 39129.9 KB 1 0 000:30:39
567-61-218-236.cpe.cableone.net 3 36.1 KB 3 0 007:58:32
TOTAL: 5 402 857126.5 MB 3594 6 1209:26:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 342 632521.6 MB 3265 3 1000:10:56
2unresolved 36 11451.6 MB 137 0 000:51:34
3*.cpe.cableone.net 28 11013.4 MB 192 3 208:24:25
TOTAL: 3 406 857126.5 MB 3594 6 1209:26:58

NNRP auth users [Top 20]:

UserConn
bpanther 25
amybbs 24
crash 6
malcolmlewis 3
TOTAL: 4 58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.116 0.056 0.00607:58:32
60.234.244.55 0.580 0.064 0.01800:30:39
67-61-81-51.cpe.cableone.net 1.552 0.456 0.14400:25:53
118.149.226.178 0.248 0.028 0.00000:15:56
agency.bbs.geek.nz 24.300 5.540 0.00000:10:56
163.47.16.169 1.412 0.332 0.18800:04:58
? 1.332 0.188 0.00000:00:02
TOTAL: 7 29.540 6.664 0.35609:26:58

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.226.178 4
TOTAL: 1 4

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3370 39.4%
2comp 1593 18.6%
3alt 1403 16.4%
4soc 695 8.1%
5sci 625 7.3%
6misc 386 4.5%
7talk 198 2.3%
8news 152 1.8%
9uk 54 0.6%
10nz 34 0.4%
11agency 17 0.2%
12humanities 14 0.2%
13aus 7 0.1%
14eternal-september 1 0.0%
TOTAL: 14 8549100.0%

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

NewsgroupCount
1rec.arts.tv 889
2alt.atheism 677
3comp.os.linux.advocacy 499
4rec.arts.drwho 479
5rec.sport.tennis 366
6misc.survivalism 331
7alt.comp.os.windows-10 325
8rec.arts.sf.written 245
9rec.food.cooking 224
10comp.lang.c 216
11sci.physics.relativity 160
12comp.lang.python 142
13soc.retirement 135
14sci.physics 128
15rec.boats 124
16news.lists.filters 122
17soc.culture.israel 96
18sci.math 91
19comp.lang.forth 90
20comp.sys.mac.system 78
21alt.test 74
22alt.bible 74
23alt.politics 73
24soc.culture.singapore 73
25rec.photo.digital 72
26rec.outdoors.rv-travel 71
27comp.sys.mac.advocacy 68
28talk.origins 68
29talk.politics.guns 65
30soc.culture.polish 63
31rec.bicycles.tech 63
32rec.sport.pro-wrestling 58
33alt.recovery.aa 58
34talk.politics.misc 57
35soc.culture.china 56
36sci.electronics.design 54
37comp.arch 52
38rec.arts.comics.strips 52
39alt.support.diabetes 47
40rec.radio.amateur.homebrew 46
41sci.logic 46
42rec.arts.sf.fandom 40
43comp.arch.embedded 38
44soc.culture.vietnamese 37
45comp.ai.philosophy 36
46comp.lang.c++ 36
47nz.general 34
48rec.music.classical.recordings 34
49comp.protocols.time.ntp 33
50rec.sport.soccer 32
51sci.military.naval 31
52comp.arch.fpga 30
53soc.culture.romanian 28
54comp.soft-sys.sas 27
55rec.games.pinball 27
56rec.music.dylan 27
57sci.math.num-analysis 25
58rec.sport.football.college 24
59comp.sys.apple2 24
60uk.comp.homebuilt 23
61rec.arts.movies.current-films 22
62rec.radio.shortwave 22
63soc.culture.jewish 21
64uk.radio.amateur 21
65soc.men 20
66comp.os.vms 20
67soc.culture.indian 20
68rec.games.backgammon 20
69rec.sport.cricket 20
70comp.soft-sys.math.scilab 20
71rec.gambling.poker 19
72misc.health.alternative 19
73alt.os.linux.ubuntu 19
74rec.aviation.soaring 19
75soc.genealogy.medieval 18
76rec.radio.amateur.misc 18
77rec.arts.movies.past-films 18
78soc.culture.brazil 17
79agency.test 17
80soc.history.what-if 16
81comp.soft-sys.matlab 16
82rec.woodworking 16
83soc.culture.usa 15
84misc.immigration.usa 15
85rec.boats.paddle 15
86rec.radio.amateur.antenna 14
87rec.games.roguelike.nethack 13
88rec.audio.opinion 13
89soc.penpals 13
90misc.legal 13
91rec.crafts.metalworking 12
92news.software.readers 12
93comp.mobile.android 12
94rec.arts.poems 11
95rec.gardens 11
96rec.arts.disney.parks 11
97sci.electronics.repair 11
98humanities.lit.authors.shakespeare 11
99rec.music.rock-pop-r+b.1950s 10
100rec.games.frp.dnd 10
TOTAL: 304 8549