news.bbs.geek.nz daily logs

Sep 16 23:58:01 -- Sep 17 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 145062 64.3%12.0 MB 44.0%
innd 30579 13.5%5.0 MB 18.3%
inn 25515 11.3%5.6 MB 20.5%
innfeed 23113 10.2%4.4 MB 16.3%
cnfsstat 1440 0.6%252.8 KB 0.9%
controlchan 5 0.0%0.6 KB 0.0%
TOTAL: 6 225714 100.0%27.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 236677 48.2%
Positive hits 230500 46.9%
Do not exist 23889 4.9%
Cache misses 166 0.0%
TOTAL: 4 491232 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.153 0.0%146 0.000 1.048 13.000
article cleanup00:00:00.213 0.0%24959 0.000 0.009 0.044
article logging00:00:00.597 0.0%25384 0.000 0.024 0.068
article parse00:00:00.803 0.0%65896 0.000 0.012 0.030
article write00:00:01.306 0.0%17859 0.000 0.073 0.357
artlog/artcncl00:00:00.002 0.0%137 0.000 0.015 0.083
data move00:00:00.320 0.0%465370 0.000 0.001 0.013
hisgrep/artcncl00:00:00.001 0.0%137 0.000 0.007 0.056
hishave/artcncl00:00:00.000 0.0%146 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.601 0.0%492303 0.001 0.011 0.728
history sync00:00:00.012 0.0%301 0.000 0.040 0.500
history write00:00:05.499 0.0%23919 0.000 0.230 15.519
hiswrite/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
idle23:57:51.881 99.8%481896 108.643 179.026 553.212
nntp read00:00:02.936 0.0%483513 0.002 0.006 0.027
overview write00:00:33.147 0.0%17859 0.080 1.856 50.307
perl filter00:00:48.620 0.1%23919 1.463 2.033 5.787
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.145 0.0%35719 0.000 0.032 0.132
TOTAL: 24:00:22.44123:59:32.236 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.483 0.0%411335 0.000 0.001 0.029
article prepare00:00:00.000 0.0%8184 0.000 0.000 0.000
article read00:00:00.161 0.0%1874 0.000 0.086 6.250
backlog stats00:00:00.436 0.0%446624 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.041 0.0%328588 0.001 0.006 0.011
data write00:00:03.050 0.0%314254 0.004 0.010 0.023
idle23:53:06.374 99.9%446624 51.526 192.525 862.358
status file00:00:29.612 0.0%1856 0.700 15.955 562.378
TOTAL: 23:54:06.09323:53:42.157100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:08:44.229 97.5%158138 0.000 526.908 95323.035
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:57.925 0.1%344878 0.000 0.168 2.656
readart00:00:02.938 0.0%12838 0.000 0.229 39.368
TOTAL: 23:44:56.46823:09:45.092 97.5%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 34 13159 4693 8148 318 35%37:44:06
2news-out.mixmin.net 18 19512 2911 15638 963 14%31:42:29
3news.albasani.net 1 20829 1857 18290 682 8%25:42:26
4news-out.aioe.org 3 15509 1693 13768 48 10%22:21:44
5feeder.eternal-september.org 85 22272 1663 19512 1097 7%57:43:42
6newsfeed.datemas.de 3 19411 1327 17733 351 6%26:32:11
7news.redatomik.org 2 17470 1283 15916 271 7%24:12:20
8newsfeed.neva.ru 146 14773 1054 11067 2652 7%80:48:46
9csiph.com 2 17344 844 16433 67 4%24:07:24
10feeder.awxg.com 1 15554 154 15339 61 0%23:59:56
11news.samoylyk.net 2 25417 145 24752 520 0%26:04:49
12news.swapon.de 9 1763 102 1636 25 5%24:45:51
13news.freedyn.net 2 20383 79 20221 83 0%24:27:24
14agency-nz-out.news.mb-net.net 22 20557 53 20403 101 0%38:30:33
15localhost 1 0 0 0 0 0%00:00:00
TOTAL: 15 331 243953 17858 218856 7239 7%468:43:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.6 MB317.7 KB1.2 MB19.1 MB 92%3.9 KB
2news-out.mixmin.net7.9 MB283.8 KB2.1 MB10.3 MB 77%2.7 KB
3news.albasani.net7.9 MB516.6 KB1.6 MB10.0 MB 78%4.0 KB
4feeder.eternal-september.org6.6 MB641.7 KB6.1 MB13.3 MB 49%4.9 KB
5newsfeed.datemas.de6.3 MB505.4 KB1.3 MB8.1 MB 78%4.9 KB
6news-out.aioe.org4.1 MB136.7 KB138.9 KB4.4 MB 93%2.6 KB
7news.redatomik.org3.1 MB304.5 KB799.6 KB4.2 MB 74%2.7 KB
8newsfeed.neva.ru2.7 MB314.0 KB13.6 MB16.6 MB 16%4.6 KB
9csiph.com2.5 MB237.8 KB242.4 KB2.9 MB 84%3.3 KB
10news.samoylyk.net893.8 KB507.7 KB8.1 MB9.5 MB 9%14.6 KB
11news.freedyn.net490.9 KB238.9 KB359.7 KB1.1 MB 45%6.7 KB
12feeder.awxg.com430.6 KB243.1 KB251.4 KB925.2 KB 46%4.3 KB
13news.swapon.de241.9 KB56.8 KB63.7 KB362.4 KB 66%2.9 KB
14agency-nz-out.news.mb-net.net188.9 KB320.3 KB911.1 KB1.4 MB 13%9.2 KB
15localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1560.9 MB4.5 MB36.6 MB102.0 MB 59%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 16 23:58:01 - 23:59:59 28 0.2% 0.2476.1 KB 0.1% 0.64
Sep 17 00:00:00 - 00:59:59 913 5.1% 0.252.6 MB 4.3% 0.73
Sep 17 01:00:00 - 01:59:59 980 5.5% 0.273.6 MB 5.9% 1.01
Sep 17 02:00:00 - 02:59:59 1096 6.1% 0.303.3 MB 5.5% 0.95
Sep 17 03:00:00 - 03:59:59 1011 5.7% 0.283.1 MB 5.2% 0.89
Sep 17 04:00:00 - 04:59:59 987 5.5% 0.272.8 MB 4.7% 0.80
Sep 17 05:00:00 - 05:59:59 950 5.3% 0.263.0 MB 5.0% 0.87
Sep 17 06:00:00 - 06:59:59 962 5.4% 0.273.4 MB 5.6% 0.97
Sep 17 07:00:00 - 07:59:59 1008 5.6% 0.283.0 MB 5.0% 0.85
Sep 17 08:00:00 - 08:59:59 977 5.5% 0.273.2 MB 5.3% 0.92
Sep 17 09:00:00 - 09:59:59 785 4.4% 0.223.2 MB 5.4% 0.92
Sep 17 10:00:00 - 10:59:59 743 4.2% 0.212.4 MB 4.0% 0.68
Sep 17 11:00:00 - 11:59:59 651 3.6% 0.182.1 MB 3.6% 0.61
Sep 17 12:00:00 - 12:59:59 565 3.2% 0.161.6 MB 2.7% 0.46
Sep 17 13:00:00 - 13:59:59 514 2.9% 0.143.0 MB 4.9% 0.85
Sep 17 14:00:00 - 14:59:59 439 2.5% 0.122.2 MB 3.6% 0.63
Sep 17 15:00:00 - 15:59:59 347 1.9% 0.101.6 MB 2.7% 0.46
Sep 17 16:00:00 - 16:59:59 359 2.0% 0.101.6 MB 2.7% 0.46
Sep 17 17:00:00 - 17:59:59 301 1.7% 0.08964.8 KB 1.6% 0.27
Sep 17 18:00:00 - 18:59:59 477 2.7% 0.131.4 MB 2.4% 0.41
Sep 17 19:00:00 - 19:59:59 589 3.3% 0.161.8 MB 2.9% 0.51
Sep 17 20:00:00 - 20:59:59 666 3.7% 0.181.8 MB 3.0% 0.52
Sep 17 21:00:00 - 21:59:59 788 4.4% 0.222.4 MB 4.0% 0.68
Sep 17 22:00:00 - 22:59:59 886 5.0% 0.253.7 MB 6.1% 1.05
Sep 17 23:00:00 - 23:58:01 836 4.7% 0.242.4 MB 3.9% 0.70
TOTAL: 24:00:00 17858 100.0% 0.2160.4 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.1 GB 40.1% 0 0.32 1897.80
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.3 GB 46.5% 0 0.34 1790.86
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB247.6 MB 0.5% 0 0.0610158.73
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 GB8.4 GB 16.8% 0 0.61 1000.56
TOTAL: 10-500.0 GB52.0 GB 10.4% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2670 35 0 71 0 0 0 0 2564
2news-out.mixmin.net 1098 0 0 77 0 0 0 0 1021
3feeder.eternal-september.org 1045 0 0 149 0 0 0 0 896
4news.albasani.net 733 12 0 102 0 0 0 0 619
5news.samoylyk.net 477 0 0 99 0 0 0 0 378
6newsfeed.datemas.de 382 58 0 93 0 0 0 0 231
7news.redatomik.org 368 0 0 64 0 0 0 0 304
8news.snarked.org 314 9 0 67 0 0 0 0 238
9agency-nz-out.news.mb-net.net 100 12 0 59 0 0 0 0 29
10news.freedyn.net 85 5 0 49 0 0 0 0 31
11news-out.aioe.org 71 0 0 58 0 0 0 0 13
12csiph.com 65 0 0 62 0 0 0 0 3
13feeder.awxg.com 64 0 0 60 0 0 0 0 4
14news.swapon.de 42 0 0 25 0 0 0 0 17
15news.ausics.org 6 0 0 5 0 0 0 0 1
TOTAL: 15 7520 131 0 1040 0 0 0 0 6349

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 24
gmane.comp.gis.openstreetmap.tagging 20
mozilla.support.seamonkey 14
ut.test 12
mozilla.dev.ui-alerts 10
mozilla.dev.l10n.sr 8
ab.test 6
mozilla.dev.telemetry-alerts 6
mpc.lists.nanog 4
mpc.lists.freebsd.gnome 4
mozilla.dev.platform 3
mozilla.community.belgium 3
mpc.lists.freebsd.gecko 2
0.test 2
gmane.linux.bios.flashrom 2
mpc.lists.freebsd.x11 1
fido.ger.musik 1
mozilla.community.india 1
a.bsu.religion 1
south-wales.test 1
TOTAL: 26 131

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5050
EMP (phn path) 496
EMP (phn nph) 203
Too many newsgroups (low_xpost) 37
Too many newsgroups 34
Binary Image: misplaced jpg 31
User-issued cancel 16
Binary: non-binary distribution 12
Binary: misplaced 014 6
EMP (phl) 5
Binary: misplaced 013 3
Binary: misplaced 012 3
Binary: misplaced 006 3
Binary: misplaced 016 3
Binary: misplaced par2 3
Binary: misplaced 015 2
Binary: misplaced 025 2
Binary: misplaced 008 2
Binary: misplaced 019 2
Binary: misplaced 047 1
TOTAL: 30 5924

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 169
news.redatomik.org 99
news.albasani.net 66
newsfeed.datemas.de 41
news.swapon.de 16
newsfeed.neva.ru 12
news-out.aioe.org 11
feeder.eternal-september.org 5
agency-nz-out.news.mb-net.net 2
news.snarked.org 2
TOTAL: 12 425
TOTAL: 1 425

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16096 1094 14953 49 0 0 6%23:59:43
2awxg 17497 107 17347 6 0 8 0%23:59:42
3news.redatomik.org 17381 10 16405 35 2 28 0%23:59:42
4eternal-september 15444 3 15323 0 0 128 0%23:59:42
5news.freedyn.net 17917 1 17771 5 0 9 0%23:59:42
6news.snarked.org 426833 1 9390 2 0 406763 0%23:59:42
7aioe 15009 1 14838 0 0 0 0%23:59:42
8mb-net.net 17872 1 17766 0 0 3 0%23:59:42
9newsfeed.datemas.de 16596 0 16525 0 0 2 0%23:59:39
10csiph.com 17065 0 16997 0 0 0 0%23:59:42
11neva.ru 16530 0 16528 0 0 0 0%23:59:42
12news-in.mixmin.net 14367 0 14344 0 0 0 0%23:59:41
13news.swapon.de 1721 0 1721 0 0 2 0%23:38:05
14news.albasani.net 17244 0 14950 656 0 4632 0%23:59:41
15news.samoylyk.net 16033 0 15969 0 0 2 0%23:59:33
TOTAL: 15 643605 1218 220827 753 2 411577 0%359:33:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org9.9 MB3.1 MB13.0 MB0.2 KB/s11.6 KB23:59:43
2awxg367.8 KB44.5 KB412.3 KB0.0 KB/s3.6 KB23:59:42
3news.snarked.org195.6 KB72.9 KB268.4 KB0.0 KB/s89.5 KB23:59:42
4news.redatomik.org17.2 KB259.5 KB276.7 KB0.0 KB/s6.1 KB23:59:42
5aioe13.0 KB0.0 KB13.0 KB0.0 KB/s13.0 KB23:59:42
6news.freedyn.net6.6 KB48.4 KB55.0 KB0.0 KB/s9.2 KB23:59:42
7eternal-september5.0 KB0.0 KB5.0 KB0.0 KB/s1.7 KB23:59:42
8mb-net.net1.9 KB0.0 KB1.9 KB0.0 KB/s1.9 KB23:59:42
9newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:39
10csiph.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
11neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
12news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:41
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:38:05
14news.albasani.net0.0 KB2.6 MB2.6 MB0.0 KB/s4.0 KB23:59:41
15news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:33
TOTAL: 1510.5 MB6.1 MB16.5 MB0.0 KB/s8.6 KB359:33:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 23 583321.3 MB 1587 0 003:01:13
2agency.bbs.geek.nz 376 551420.8 MB 3250 0 000:11:29
3163.47.16.169 24 9351.3 MB 130 0 000:04:30
467-60-219-146.cpe.cableone.net 2 11.3 KB 1 0 019:53:38
TOTAL: 4 425 1228343.4 MB 4968 0 023:44:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 25 583421.3 MB 1588 0 022:54:52
2*.bbs.geek.nz 376 551420.8 MB 3250 0 000:11:29
3unresolved 35 9351.3 MB 130 0 000:38:25
TOTAL: 3 436 1228343.4 MB 4968 0 023:44:49

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 23
malcolmlewis 2
TOTAL: 3 49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.160 0.036 0.03419:53:38
67-61-21-181.cpe.cableone.net 3.136 1.852 0.07003:01:13
118.149.186.16 0.292 0.048 0.00000:16:45
agency.bbs.geek.nz 26.504 6.244 0.00000:11:29
118.149.171.233 0.184 0.012 0.00000:11:23
118.149.172.17 0.124 0.012 0.00000:05:44
163.47.16.169 1.404 0.332 0.15100:04:30
? 1.380 0.160 0.00000:00:02
71.6.146.185 0.052 0.008 0.00000:00:00
TOTAL: 9 33.236 8.704 0.25523:44:49

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.186.16 5
118.149.171.233 3
118.149.172.17 2
71.6.146.185 1
TOTAL: 4 11

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 4889 39.8%
2comp 1506 12.3%
3sci 1365 11.1%
4soc 1364 11.1%
5alt 1332 10.8%
6talk 666 5.4%
7misc 665 5.4%
8uk 199 1.6%
9news 193 1.6%
10mozilla 40 0.3%
11humanities 24 0.2%
12nz 15 0.1%
13aus 14 0.1%
14eternal-september 11 0.1%
TOTAL: 14 12283100.0%

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

NewsgroupCount
1rec.arts.tv 1061
2alt.comp.os.windows-10 495
3alt.atheism 466
4rec.sport.tennis 406
5rec.food.cooking 361
6sci.math 347
7comp.lang.python 297
8rec.arts.drwho 291
9misc.survivalism 287
10rec.arts.sf.written 276
11rec.sport.football.college 258
12comp.os.linux.advocacy 258
13soc.retirement 257
14talk.politics.guns 253
15talk.origins 252
16rec.aquaria.marine.misc 230
17soc.culture.israel 215
18sci.electronics.design 204
19rec.sport.pro-wrestling 201
20rec.photo.digital 199
21sci.physics.relativity 193
22sci.physics 181
23news.lists.filters 173
24talk.politics.misc 143
25misc.health.alternative 142
26rec.aviation.marketplace 138
27uk.radio.amateur 118
28comp.lang.c 118
29soc.culture.china 112
30misc.phone.mobile.iphone 106
31rec.bicycles.tech 104
32soc.culture.polish 98
33rec.outdoors.rv-travel 96
34rec.boats 96
35rec.gambling.poker 94
36sci.logic 91
37comp.sys.mac.apps 88
38rec.sport.soccer 87
39misc.transport.urban-transit 83
40rec.crafts.metalworking 82
41comp.sys.apple2 79
42soc.culture.indian 77
43alt.bible 77
44soc.culture.usa 73
45alt.politics 68
46soc.culture.singapore 68
47soc.penpals 66
48comp.os.vms 65
49sci.med.cardiology 64
50soc.culture.bulgaria 62
51alt.test 60
52alt.recovery.aa 60
53sci.military.naval 59
54rec.autos.tech 51
55rec.arts.movies.current-films 51
56comp.lang.ada 50
57sci.math.num-analysis 49
58comp.protocols.time.ntp 48
59rec.games.video.sony 48
60comp.lang.forth 46
61soc.history.what-if 46
62rec.music.dylan 45
63rec.gambling.lottery 42
64comp.mobile.android 42
65uk.comp.os.linux 41
66comp.protocols.dns.bind 40
67comp.lang.fortran 38
68rec.autos.sport.f1 38
69rec.sport.cricket 37
70alt.support.diabetes 37
71rec.arts.movies.past-films 37
72sci.astro.amateur 35
73rec.radio.amateur.misc 35
74rec.radio.shortwave 34
75comp.lang.c++ 32
76comp.soft-sys.sas 31
77rec.aviation.soaring 30
78comp.soft-sys.math.scilab 30
79rec.audio.pro 29
80soc.culture.turkish 28
81sci.med 28
82rec.music.classical.recordings 28
83soc.culture.romanian 28
84soc.women 27
85sci.electronics.repair 25
86soc.culture.quebec 24
87rec.woodworking 24
88uk.tech.broadcast 24
89comp.sys.acorn.networking 23
90sci.lang 23
91mozilla.general 23
92rec.pets 22
93soc.culture.irish 20
94comp.misc 18
95rec.radio.info 17
96uk.comp.homebuilt 16
97misc.invest.stocks 16
98soc.genealogy.medieval 16
99humanities.lit.authors.shakespeare 15
100rec.arts.comics.strips 15
TOTAL: 302 12283