news.bbs.geek.nz daily logs

Aug 18 23:58:01 -- Aug 19 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 136306 62.0%11.1 MB 41.6%
innd 30967 14.1%5.0 MB 18.6%
inn 29283 13.3%6.2 MB 23.1%
innfeed 21862 9.9%4.2 MB 15.7%
cnfsstat 1440 0.7%255.1 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 219859 100.0%26.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 288215 50.1%
Positive hits 258959 45.0%
Do not exist 27494 4.8%
Cache misses 295 0.1%
TOTAL: 4 574963 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.190 0.0%143 0.000 1.329 13.000
article cleanup00:00:00.274 0.0%28640 0.000 0.010 0.051
article logging00:00:00.704 0.0%29193 0.000 0.024 0.060
article parse00:00:00.836 0.0%71034 0.000 0.012 0.034
article write00:00:01.667 0.0%20913 0.012 0.080 0.541
artlog/artcncl00:00:00.001 0.0%140 0.000 0.007 0.333
data move00:00:00.364 0.0%532262 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%137 0.000 0.022 1.000
hishave/artcncl00:00:00.001 0.0%143 0.000 0.007 0.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.213 0.0%577094 0.002 0.014 0.555
history sync00:00:00.635 0.0%370 0.000 1.716 155.750
history write00:00:05.603 0.0%27577 0.000 0.203 10.815
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:57:34.537 99.8%544932 81.801 158.285 568.351
nntp read00:00:04.529 0.0%550433 0.003 0.008 0.024
overview write00:00:37.512 0.0%20913 0.045 1.794 35.125
perl filter00:00:51.972 0.1%27577 1.214 1.885 22.088
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.167 0.0%41826 0.000 0.028 0.117
TOTAL: 24:00:54.87623:59:28.208 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%28201 0.000 0.002 0.019
article prepare00:00:00.002 0.0%10240 0.000 0.000 0.013
article read00:00:00.308 0.0%2376 0.000 0.130 7.762
backlog stats00:00:00.514 0.0%297290 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.345 0.0%255825 0.002 0.009 0.019
data write00:00:02.892 0.0%244163 0.005 0.012 0.026
idle23:53:47.604100.0%297290 154.563 289.373 854.461
status file00:00:12.870 0.0%1947 0.467 6.610 577.929
TOTAL: 23:54:22.67923:54:06.594100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle18:32:31.312 95.4%147711 0.000 451.905 84405.842
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.938 0.0%320281 0.000 0.028 1.411
readart00:00:03.142 0.0%11664 0.000 0.269 42.357
TOTAL: 19:26:34.30818:32:43.392 95.4%----

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 40 22480 5794 15395 1291 25%35:50:03
2news.snarked.org 12 8817 2608 6013 196 29%17:01:27
3feeder.eternal-september.org 120 26855 2498 23091 1266 9%63:41:40
4csiph.com 4 24335 2169 22082 84 8%28:42:12
5news.redatomik.org 1 20465 1831 18549 85 8%24:38:15
6news-out.aioe.org 2 16250 1487 14710 53 9%16:21:26
7newsfeed.neva.ru 160 12734 1429 8447 2858 11%87:32:25
8newsfeed.datemas.de 2 24076 1329 22258 489 5%25:29:39
9news.albasani.net 1 23713 980 22281 452 4%25:01:15
10news.freedyn.net 4 23329 238 22958 133 1%23:52:15
11news.swapon.de 10 2347 228 2071 48 9%28:19:58
12news.samoylyk.net 1 24685 189 23992 504 0%22:09:34
13feeder.awxg.com 2 19431 180 19179 72 0%23:59:50
14agency-nz-out.news.mb-net.net 27 21126 61 20918 147 0%36:17:35
15news.ausics.org 2 18872 3 18862 7 0%24:47:43
16localhost 2 1 1 0 0 100%00:00:00
TOTAL: 16 390 289516 21025 260806 7685 7%483:45:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.mixmin.net16.4 MB297.6 KB2.7 MB19.4 MB 84%2.8 KB
2feeder.eternal-september.org10.1 MB682.6 KB5.3 MB16.1 MB 62%4.4 KB
3news.snarked.org9.0 MB146.0 KB973.3 KB10.1 MB 89%3.7 KB
4csiph.com6.0 MB239.1 KB264.6 KB6.5 MB 92%3.0 KB
5newsfeed.datemas.de5.3 MB424.2 KB1.9 MB7.6 MB 69%4.3 KB
6news.albasani.net4.8 MB477.2 KB1.3 MB6.5 MB 73%4.7 KB
7news.redatomik.org4.6 MB330.9 KB369.8 KB5.3 MB 87%2.8 KB
8newsfeed.neva.ru4.2 MB283.1 KB11.9 MB16.4 MB 25%3.9 KB
9news-out.aioe.org3.7 MB126.0 KB136.2 KB3.9 MB 93%2.6 KB
10news.samoylyk.net1.7 MB439.9 KB6.2 MB8.3 MB 20%12.3 KB
11news.freedyn.net1.5 MB260.9 KB415.9 KB2.2 MB 69%6.1 KB
12news.swapon.de636.0 KB72.5 KB103.1 KB811.7 KB 78%2.9 KB
13feeder.awxg.com463.5 KB261.8 KB267.4 KB992.8 KB 46%3.9 KB
14agency-nz-out.news.mb-net.net210.3 KB280.9 KB4.1 MB4.6 MB 4%22.6 KB
15news.ausics.org5.3 KB20.9 KB23.7 KB49.9 KB 10%5.0 KB
16localhost1.9 KB0.0 KB0.0 KB1.9 KB100%1.9 KB
TOTAL: 1668.6 MB4.2 MB36.1 MB108.9 MB 62%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 18 23:58:01 - 23:59:59 33 0.2% 0.2874.8 KB 0.1% 0.63
Aug 19 00:00:00 - 00:59:59 1065 5.1% 0.302.8 MB 4.1% 0.81
Aug 19 01:00:00 - 01:59:59 1372 6.6% 0.384.6 MB 6.7% 1.31
Aug 19 02:00:00 - 02:59:59 1293 6.2% 0.364.1 MB 6.0% 1.17
Aug 19 03:00:00 - 03:59:59 1399 6.7% 0.394.3 MB 6.3% 1.22
Aug 19 04:00:00 - 04:59:59 1240 5.9% 0.343.1 MB 4.5% 0.88
Aug 19 05:00:00 - 05:59:59 1188 5.7% 0.334.5 MB 6.5% 1.27
Aug 19 06:00:00 - 06:59:59 1135 5.4% 0.324.4 MB 6.4% 1.25
Aug 19 07:00:00 - 07:59:59 1022 4.9% 0.283.1 MB 4.5% 0.89
Aug 19 08:00:00 - 08:59:59 1032 4.9% 0.293.7 MB 5.4% 1.06
Aug 19 09:00:00 - 09:59:59 1032 4.9% 0.293.3 MB 4.8% 0.95
Aug 19 10:00:00 - 10:59:59 749 3.6% 0.212.3 MB 3.3% 0.64
Aug 19 11:00:00 - 11:59:59 599 2.9% 0.172.5 MB 3.6% 0.70
Aug 19 12:00:00 - 12:59:59 632 3.0% 0.182.4 MB 3.5% 0.68
Aug 19 13:00:00 - 13:59:59 422 2.0% 0.121.7 MB 2.4% 0.47
Aug 19 14:00:00 - 14:59:59 351 1.7% 0.101.2 MB 1.7% 0.34
Aug 19 15:00:00 - 15:59:59 503 2.4% 0.142.2 MB 3.2% 0.62
Aug 19 16:00:00 - 16:59:59 430 2.1% 0.121.8 MB 2.6% 0.51
Aug 19 17:00:00 - 17:59:59 475 2.3% 0.131.7 MB 2.5% 0.50
Aug 19 18:00:00 - 18:59:59 588 2.8% 0.161.6 MB 2.3% 0.44
Aug 19 19:00:00 - 19:59:59 768 3.7% 0.212.4 MB 3.5% 0.68
Aug 19 20:00:00 - 20:59:59 737 3.5% 0.202.3 MB 3.3% 0.64
Aug 19 21:00:00 - 21:59:59 883 4.2% 0.253.2 MB 4.6% 0.90
Aug 19 22:00:00 - 22:59:59 1016 4.9% 0.282.9 MB 4.2% 0.83
Aug 19 23:00:00 - 23:58:02 910 4.4% 0.262.7 MB 3.9% 0.79
TOTAL: 24:00:01 20874 100.0% 0.2468.7 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.3 GB 38.6% 0 0.28 2183.35
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.5 GB 44.9% 0 0.36 1676.47
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB237.5 MB 0.5% 0 0.0319399.81
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.7 GB 13.4% 0 0.69 876.19
TOTAL: 10-500.0 GB48.7 GB 9.7% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2896 108 0 74 0 0 0 0 2714
2news-out.mixmin.net 1656 0 0 88 0 0 0 0 1568
3feeder.eternal-september.org 1270 0 0 153 0 0 0 0 1117
4news.samoylyk.net 528 0 0 102 0 0 0 0 426
5newsfeed.datemas.de 509 103 0 106 0 0 0 0 300
6news.albasani.net 497 5 0 98 0 0 0 0 394
7news.snarked.org 195 12 0 29 0 0 0 0 154
8agency-nz-out.news.mb-net.net 160 12 0 66 0 0 0 0 82
9news.freedyn.net 137 5 0 65 0 0 0 0 67
10news.redatomik.org 131 0 0 71 0 0 0 0 60
11news.swapon.de 87 0 0 26 0 0 0 0 61
12news-out.aioe.org 77 8 0 58 0 0 0 0 11
13csiph.com 64 0 0 57 0 0 0 0 7
14feeder.awxg.com 63 1 0 58 0 0 0 0 4
15news.ausics.org 6 0 0 5 0 0 0 0 1
TOTAL: 15 8276 254 0 1056 0 0 0 0 6966

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 76
mozilla.dev.security.policy 31
gmane.linux.kernel 21
gmane.linux.alsa.devel 14
mozilla.support.seamonkey 12
gmane.comp.gis.openstreetmap.tagging 11
mozilla.dev.platform 9
mpc.lists.freebsd.gecko 7
gmane.comp.freedesktop.amd-gfx 5
mpc.lists.nanog 4
mpc.lists.freebsd.gnome 4
gmane.linux.drivers.devicetree 4
ab.test 4
mozilla.dev.ui-alerts 3
mpc.lists.freebsd.office 3
gmane.comp.video.dri.devel 2
mozilla.dev.apps.thunderbird 2
purdue.forsale 2
mozilla.dev.tech.crypto 2
mpc.lists.freebsd.x11 2
TOTAL: 50 254

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5309
EMP (phn path) 687
EMP (phn nph) 257
Too many newsgroups 75
Binary Image: misplaced jpg 33
User-issued cancel 21
Binary: non-binary distribution 8
HTML post 3
Too many newsgroups (meow) 3
Binary: misplaced 054 2
EMP (phl) 2
Binary: misplaced 015 2
Binary: misplaced 021 1
Binary: misplaced txt 1
Binary: misplaced 017 1
Binary: misplaced 008 1
Binary: misplaced 019 1
Too many newsgroups (low_xpost) 1
Binary: misplaced 031 1
Binary: misplaced 007 1
TOTAL: 23 6413

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 347
news.albasani.net 52
news.swapon.de 51
news.redatomik.org 49
newsfeed.datemas.de 27
news-out.aioe.org 9
feeder.eternal-september.org 6
newsfeed.neva.ru 5
feeder.awxg.com 3
news.samoylyk.net 2
TOTAL: 12 553
TOTAL: 1 553

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19024 1456 17536 31 1 35 7%23:59:50
2awxg 20338 62 20246 3 0 16 0%23:59:45
3news.freedyn.net 20996 19 20610 1 0 73 0%23:59:50
4newsfeed.datemas.de 19513 6 19485 0 0 57 0%23:59:50
5aioe 17424 4 17334 0 0 2 0%23:59:50
6news.samoylyk.net 18880 2 18863 1 0 0 0%23:59:50
7news.redatomik.org 19034 2 19018 0 0 0 0%23:59:50
8neva.ru 19156 1 19154 0 0 0 0%23:59:50
9csiph.com 18797 1 18719 0 0 0 0%23:59:50
10news-in.mixmin.net 14392 1 14382 0 0 0 0%23:59:50
11news.snarked.org 0 0 0 0 0 0 0%00:10:01
12mb-net.net 20831 0 20771 0 0 84 0%23:59:50
13news.swapon.de 1849 0 1849 0 0 0 0%23:41:54
14eternal-september 17509 0 17425 0 0 53 0%23:59:50
15news.albasani.net 21578 0 18342 854 1 7147 0%23:59:49
TOTAL: 15 249321 1554 243734 890 2 7467 0%335:49:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.2 MB1.6 MB11.8 MB0.1 KB/s8.1 KB23:59:50
2awxg214.9 KB25.9 KB240.7 KB0.0 KB/s3.7 KB23:59:45
3news.freedyn.net68.7 KB13.6 KB82.3 KB0.0 KB/s4.1 KB23:59:50
4newsfeed.datemas.de17.9 KB0.0 KB17.9 KB0.0 KB/s3.0 KB23:59:50
5news.redatomik.org10.0 KB0.0 KB10.0 KB0.0 KB/s5.0 KB23:59:50
6aioe8.2 KB0.0 KB8.2 KB0.0 KB/s2.1 KB23:59:50
7news.samoylyk.net7.6 KB53.6 KB61.2 KB0.0 KB/s20.4 KB23:59:50
8neva.ru2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:59:50
9csiph.com2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:59:50
10news-in.mixmin.net2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:59:50
11news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:01
12mb-net.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:41:54
14eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
15news.albasani.net0.0 KB3.3 MB3.3 MB0.0 KB/s3.9 KB23:59:49
TOTAL: 1510.5 MB5.0 MB15.5 MB0.0 KB/s6.5 KB335:49:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 384 597518.8 MB 3390 1 1400:12:22
267-61-21-181.cpe.cableone.net 25 401312.6 MB 1042 0 002:07:10
3163.47.16.169 24 9771.4 MB 138 0 000:04:43
TOTAL: 3 433 1096532.8 MB 4570 1 1419:26:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 384 597518.8 MB 3390 1 1400:12:22
2*.cpe.cableone.net 28 401312.6 MB 1042 0 018:16:48
3unresolved 36 9771.4 MB 138 0 000:57:12
TOTAL: 3 448 1096532.8 MB 4570 1 1419:26:27

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 23
malcolmlewis 3
TOTAL: 3 50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.300 0.076 0.00816:09:38
67-61-21-181.cpe.cableone.net 3.120 1.684 0.09002:07:10
118.149.236.78 0.296 0.048 0.00000:25:07
118.149.148.196 0.308 0.048 0.00000:22:11
agency.bbs.geek.nz 28.760 7.040 0.00000:12:22
118.149.209.216 0.056 0.020 0.00000:05:01
163.47.16.169 1.580 0.448 0.18600:04:43
203.118.151.117 0.076 0.016 0.00000:00:06
? 1.788 0.224 0.00000:00:03
TOTAL: 9 36.284 9.604 0.28419:26:27

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.148.196 5
118.149.236.78 5
67-61-218-236.cpe.cableone.net 3
203.118.151.117 1
118.149.209.216 1
TOTAL: 5 15

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-218-236.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 5635 51.4%
2comp 1602 14.6%
3alt 1198 10.9%
4soc 700 6.4%
5sci 604 5.5%
6misc 486 4.4%
7talk 288 2.6%
8uk 201 1.8%
9news 176 1.6%
10nz 33 0.3%
11aus 19 0.2%
12humanities 18 0.2%
13eternal-september 5 0.0%
TOTAL: 13 10965100.0%

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

NewsgroupCount
1rec.arts.tv 1270
2alt.atheism 557
3rec.sport.football.college 476
4rec.food.cooking 459
5rec.sport.golf 399
6comp.lang.c 369
7comp.os.linux.advocacy 320
8rec.sport.tennis 316
9rec.gambling.poker 307
10rec.arts.sf.written 239
11misc.survivalism 214
12comp.lang.python 198
13soc.retirement 187
14rec.photo.digital 183
15alt.comp.os.windows-10 182
16sci.electronics.design 168
17news.lists.filters 161
18rec.arts.drwho 152
19sci.physics.relativity 144
20rec.sport.pro-wrestling 141
21uk.radio.amateur 139
22misc.health.alternative 138
23rec.boats 136
24talk.politics.guns 129
25rec.radio.shortwave 116
26rec.crafts.metalworking 115
27comp.lang.c++ 95
28soc.culture.polish 92
29rec.music.dylan 90
30comp.lang.forth 90
31talk.origins 88
32rec.sport.soccer 83
33alt.bible 81
34sci.physics 80
35soc.culture.israel 80
36rec.bicycles.tech 74
37alt.test 73
38rec.audio.opinion 72
39sci.math 70
40alt.politics 68
41rec.arts.movies.current-films 66
42soc.penpals 66
43alt.support.diabetes 65
44rec.outdoors.rv-travel 60
45alt.recovery.aa 60
46talk.politics.misc 58
47rec.arts.disney.parks 57
48rec.audio.pro 56
49misc.phone.mobile.iphone 54
50comp.sys.mac.apps 45
51rec.arts.sf.tv 44
52rec.music.classical.recordings 42
53rec.gambling.lottery 42
54rec.radio.amateur.dx 42
55comp.soft-sys.matlab 40
56comp.mobile.android 38
57rec.games.pinball 36
58soc.culture.singapore 36
59uk.tech.broadcast 34
60rec.arts.comics.strips 33
61nz.general 33
62comp.protocols.time.ntp 32
63rec.arts.sf.fandom 32
64sci.military.naval 31
65comp.lang.lisp 30
66comp.sys.apple2 30
67rec.aviation.soaring 30
68soc.culture.china 29
69uk.comp.homebuilt 28
70rec.radio.amateur.misc 27
71sci.space.news 27
72alt.os.linux.ubuntu 27
73soc.culture.usa 26
74misc.invest.stocks 26
75alt.books.arthur-clarke 24
76rec.woodworking 24
77rec.music.rock-pop-r+b.1950s 24
78comp.lang.java.programmer 23
79comp.lang.clipper.visual-objects 22
80comp.soft-sys.sas 22
81soc.culture.indian 22
82rec.autos.sport.f1 22
83soc.culture.vietnamese 21
84rec.sport.cricket 21
85comp.lang.javascript 20
86comp.soft-sys.math.scilab 20
87rec.puzzles.crosswords 19
88rec.music.gdead 18
89humanities.lit.authors.shakespeare 18
90comp.lang.ada 18
91misc.news.internet.discuss 18
92rec.games.trivia 17
93rec.radio.info 17
94comp.internet.services.google 16
95soc.genealogy.medieval 16
96soc.culture.romanian 16
97comp.os.vms 15
98alt.bbs.ads 15
99rec.arts.movies.local.indian 15
100rec.radio.amateur.moderated 14
TOTAL: 277 10965