news.bbs.geek.nz daily logs

Nov 28 23:58:01 -- Nov 29 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 154289 64.2%12.8 MB 43.9%
innd 32002 13.3%5.2 MB 17.9%
inn 29455 12.2%6.4 MB 22.1%
innfeed 23268 9.7%4.4 MB 15.2%
cnfsstat 1440 0.6%255.0 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 240455 100.0%29.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 286745 49.6%
Positive hits 263426 45.5%
Do not exist 27495 4.8%
Cache misses 751 0.1%
TOTAL: 4 578417 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.415 0.0%155 0.000 2.677 32.000
article cleanup00:00:00.254 0.0%28723 0.000 0.009 0.036
article logging00:00:01.299 0.0%29383 0.000 0.044 1.923
article parse00:00:00.969 0.0%83729 0.000 0.012 0.025
article write00:00:01.463 0.0%20557 0.011 0.071 0.388
artlog/artcncl00:00:00.005 0.0%137 0.000 0.036 0.250
data move00:00:00.505 0.0%564849 0.000 0.001 0.009
hisgrep/artcncl00:00:00.126 0.0%139 0.000 0.906 9.385
hishave/artcncl00:00:00.065 0.0%155 0.000 0.419 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.148 0.0%586538 0.001 0.016 1.197
history sync00:00:00.014 0.0%364 0.000 0.038 0.500
history write00:00:09.876 0.0%27906 0.019 0.354 23.865
hiswrite/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
idle23:57:40.618 99.8%580659 75.541 148.556 358.207
nntp read00:00:03.481 0.0%582088 0.002 0.006 0.022
overview write00:00:39.315 0.0%20557 0.057 1.912 63.655
perl filter00:00:51.142 0.1%27906 1.276 1.833 3.630
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.307 0.0%41114 0.005 0.032 0.085
TOTAL: 24:00:53.81723:59:40.002 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.086 0.0%31731 0.000 0.003 0.033
article prepare00:00:00.001 0.0%11808 0.000 0.000 0.021
article read00:00:00.163 0.0%2234 0.000 0.073 1.581
backlog stats00:00:00.301 0.0%325192 0.000 0.001 0.003
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.640 0.0%270895 0.002 0.006 0.011
data write00:00:02.863 0.0%256134 0.004 0.011 0.019
idle24:03:52.396100.0%325192 140.830 266.404 568.157
status file00:00:06.333 0.0%1955 0.615 3.239 112.343
TOTAL: 24:04:19.43024:04:03.783100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle26:55:41.455 98.7%170347 0.000 569.082 93515.152
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:30.574 0.0%423231 0.000 0.072 1.742
readart00:00:01.151 0.0%16261 0.000 0.071 34.000
TOTAL: 27:17:29.75526:56:13.180 98.7%----

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.snarked.org 39 15842 4719 10837 286 29%39:52:46
2news-out.mixmin.net 10 22315 3994 17037 1284 17%26:34:38
3newsfeed.datemas.de 3 21601 2422 18636 543 11%23:58:19
4news.redatomik.org 1 19275 2289 16771 215 11%23:30:47
5feeder.eternal-september.org 59 24735 1998 21353 1384 8%42:44:16
6news-out.aioe.org 4 20749 1597 19050 102 7%24:06:16
7newsfeed.neva.ru 153 14866 1483 10049 3334 9%84:12:55
8csiph.com 3 23350 1160 22138 52 4%29:59:24
9news.albasani.net 7 25971 266 25436 269 1%25:01:17
10news.swapon.de 3 1636 121 1509 6 7%22:58:00
11feeder.awxg.com 1 17426 103 17282 41 0%23:59:57
12agency-nz-out.news.mb-net.net 16 22385 100 22126 159 0%27:11:14
13news.samoylyk.net 1 25998 77 25575 346 0%23:59:56
14localhost 92 91 74 0 17 81%00:00:00
15news.freedyn.net 1 11902 20 11844 38 0%13:52:10
TOTAL: 15 393 268142 20423 239643 8076 7%432:01:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.datemas.de14.0 MB2.1 MB4.4 MB20.5 MB 68%7.1 KB
2news.snarked.org13.7 MB497.6 KB1.2 MB15.3 MB 89%3.1 KB
3news-out.mixmin.net11.9 MB175.7 KB2.7 MB14.7 MB 80%2.9 KB
4feeder.eternal-september.org8.1 MB2.5 MB7.7 MB18.4 MB 44%5.6 KB
5news.albasani.net6.3 MB753.2 KB1.3 MB8.3 MB 75%15.8 KB
6news.redatomik.org5.3 MB1.2 MB1.5 MB7.9 MB 66%3.2 KB
7news-out.aioe.org3.7 MB149.5 KB301.5 KB4.2 MB 89%2.5 KB
8newsfeed.neva.ru3.7 MB586.6 KB23.8 MB28.1 MB 13%6.0 KB
9csiph.com3.2 MB228.5 KB245.0 KB3.7 MB 87%3.1 KB
10agency-nz-out.news.mb-net.net529.3 KB345.7 KB992.6 KB1.8 MB 28%7.2 KB
11news.samoylyk.net452.5 KB2.2 MB5.8 MB8.4 MB 5%20.4 KB
12news.swapon.de306.7 KB0.0 KB9.3 KB316.0 KB 97%2.5 KB
13feeder.awxg.com305.6 KB110.9 KB202.5 KB619.0 KB 49%4.3 KB
14news.freedyn.net207.4 KB253.7 KB286.2 KB747.4 KB 27%12.9 KB
15localhost148.4 KB0.0 KB28.3 KB176.6 KB 83%1.9 KB
TOTAL: 1571.8 MB11.1 MB50.3 MB133.2 MB 53%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 28 23:58:01 - 23:59:59 19 0.1% 0.1643.2 KB 0.1% 0.36
Nov 29 00:00:00 - 00:59:59 993 4.8% 0.282.9 MB 4.0% 0.82
Nov 29 01:00:00 - 01:59:59 808 3.9% 0.222.7 MB 3.7% 0.76
Nov 29 02:00:00 - 02:59:59 943 4.6% 0.262.3 MB 3.1% 0.64
Nov 29 03:00:00 - 03:59:59 949 4.6% 0.263.3 MB 4.5% 0.94
Nov 29 04:00:00 - 04:59:59 1214 5.9% 0.343.3 MB 4.5% 0.93
Nov 29 05:00:00 - 05:59:59 1075 5.2% 0.303.5 MB 4.8% 1.00
Nov 29 06:00:00 - 06:59:59 1153 5.6% 0.324.0 MB 5.4% 1.13
Nov 29 07:00:00 - 07:59:59 1240 6.0% 0.345.5 MB 7.6% 1.57
Nov 29 08:00:00 - 08:59:59 1281 6.2% 0.363.5 MB 4.7% 0.98
Nov 29 09:00:00 - 09:59:59 1124 5.5% 0.313.1 MB 4.2% 0.88
Nov 29 10:00:00 - 10:59:59 1084 5.3% 0.303.7 MB 5.1% 1.06
Nov 29 11:00:00 - 11:59:59 987 4.8% 0.274.4 MB 6.1% 1.26
Nov 29 12:00:00 - 12:59:59 731 3.6% 0.203.1 MB 4.2% 0.88
Nov 29 13:00:00 - 13:59:59 659 3.2% 0.183.4 MB 4.6% 0.96
Nov 29 14:00:00 - 14:59:59 497 2.4% 0.141.5 MB 2.0% 0.41
Nov 29 15:00:00 - 15:59:59 399 1.9% 0.111.9 MB 2.6% 0.53
Nov 29 16:00:00 - 16:59:59 412 2.0% 0.112.3 MB 3.1% 0.65
Nov 29 17:00:00 - 17:59:59 410 2.0% 0.112.3 MB 3.2% 0.66
Nov 29 18:00:00 - 18:59:59 532 2.6% 0.152.5 MB 3.5% 0.72
Nov 29 19:00:00 - 19:59:59 499 2.4% 0.141.9 MB 2.6% 0.54
Nov 29 20:00:00 - 20:59:59 632 3.1% 0.182.5 MB 3.4% 0.70
Nov 29 21:00:00 - 21:59:59 880 4.3% 0.242.9 MB 4.0% 0.83
Nov 29 22:00:00 - 22:59:59 1096 5.3% 0.303.3 MB 4.5% 0.93
Nov 29 23:00:00 - 23:58:02 937 4.6% 0.273.3 MB 4.5% 0.97
TOTAL: 24:00:01 20554 100.0% 0.2472.9 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB21.8 GB 43.7% 0 0.29 2086.98
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.3 GB 50.6% 0 0.43 1423.09
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB272.7 MB 0.5% 0 0.0417166.72
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 GB12.5 GB 25.0% 0 0.68 887.52
TOTAL: 10-500.0 GB59.9 GB 12.0% 1 0.46-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3271 55 0 81 0 0 0 0 3135
2news-out.mixmin.net 1501 0 0 68 0 0 0 0 1433
3feeder.eternal-september.org 1375 0 0 138 0 0 0 0 1237
4newsfeed.datemas.de 683 189 0 50 0 0 0 0 444
5news.redatomik.org 503 0 0 41 0 0 0 0 462
6news.samoylyk.net 335 0 0 75 0 0 0 0 260
7news.snarked.org 289 39 0 61 0 0 0 0 189
8news.albasani.net 267 3 0 67 0 0 0 0 197
9agency-nz-out.news.mb-net.net 168 41 0 64 0 0 0 0 63
10news-out.aioe.org 129 6 0 41 0 0 0 0 82
11news.freedyn.net 92 6 0 54 0 0 0 0 32
12news.swapon.de 50 0 0 1 0 0 0 0 49
13feeder.awxg.com 42 1 0 34 0 0 0 0 7
14csiph.com 40 0 0 35 0 0 0 0 5
15localhost 17 0 0 0 0 0 0 0 17
16news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 16 8764 340 0 812 0 0 0 0 7612

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 58
gmane.comp.gis.openstreetmap.tagging 42
it.annunci.commerciali 30
it.annunci.immobiliari 20
mpc.lists.freebsd.gnome 19
it.annunci.varie 17
gmane.linux.kernel 14
mozilla.dev.platform 12
mpc.lists.freebsd.gecko 11
mozilla.test 11
mozilla.dev.security.policy 11
mpc.lists.freebsd.ports.bugs 10
mozilla.support.seamonkey 9
mpc.lists.freebsd.x11 9
ut.test 5
mozilla.dev.security 5
gmane.linux.drivers.devicetree 5
gmane.linux.kernel.iio 4
mozilla.dev.ui-alerts 4
mozilla.compatibility 4
TOTAL: 46 340

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5054
EMP (phn path) 748
Binary: misplaced rar 507
EMP (phn nph) 412
Too many newsgroups 65
EMP (phl) 46
Binary: non-binary distribution 45
User-issued cancel 34
Binary: misplaced PAR2 14
User-issued spam cancel 7
Too many newsgroups (low_xpost) 4
Binary Image: misplaced jpg 3
Binary: misplaced par2 3
HTML post 3
Too many newsgroups (meow) 2
Binary: misplaced 109 1
Cancel for rejected article 1
Binary: misplaced 051 1
Binary: misplaced txt 1
TOTAL: 19 6951

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 285
news-out.mixmin.net 214
newsfeed.datemas.de 90
news.swapon.de 47
news-out.aioe.org 9
news.albasani.net 7
newsfeed.neva.ru 6
feeder.awxg.com 2
feeder.eternal-september.org 1
TOTAL: 9 661
TOTAL: 1 661

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18734 1001 17565 166 2 0 5%23:59:49
2awxg 20048 177 19854 7 0 20 0%23:59:49
3csiph.com 19635 73 19478 2 0 0 0%23:59:49
4aioe 17389 53 17160 0 0 414 0%23:59:45
5neva.ru 18682 53 18596 12 0 0 0%23:59:49
6eternal-september 17825 37 17758 0 0 80 0%23:59:49
7news.freedyn.net 20725 34 20442 2 0 53 0%23:59:40
8news.redatomik.org 18183 28 18124 1 0 30 0%23:59:49
9news.samoylyk.net 18668 28 18617 0 0 34 0%23:59:49
10mb-net.net 20452 28 20386 0 0 32 0%23:59:43
11news.snarked.org 15553 26 15433 27 0 29 0%23:59:41
12news-in.mixmin.net 15844 17 15809 11 0 31 0%23:59:49
13news.albasani.net 21516 16 18654 1012 2 10022 0%23:59:49
14news.swapon.de 1729 2 1707 0 0 75 0%23:45:12
15newsfeed.datemas.de 18102 2 17998 1 0 449 0%23:59:49
TOTAL: 15 263085 1575 257581 1241 4 11269 0%359:42:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.9 MB10.5 MB14.4 MB0.2 KB/s12.7 KB23:59:49
2awxg568.1 KB25.1 KB593.3 KB0.0 KB/s3.2 KB23:59:49
3csiph.com147.0 KB879.4 KB1.0 MB0.0 KB/s13.7 KB23:59:49
4neva.ru113.0 KB21.1 KB134.0 KB0.0 KB/s2.1 KB23:59:49
5aioe99.4 KB0.0 KB99.4 KB0.0 KB/s1.9 KB23:59:45
6news.albasani.net97.9 KB3.2 MB3.3 MB0.0 KB/s3.3 KB23:59:49
7news.freedyn.net75.7 KB12.5 KB88.2 KB0.0 KB/s2.4 KB23:59:40
8eternal-september72.9 KB0.0 KB72.9 KB0.0 KB/s2.0 KB23:59:49
9news.samoylyk.net54.3 KB0.0 KB54.3 KB0.0 KB/s1.9 KB23:59:49
10mb-net.net54.3 KB0.0 KB54.3 KB0.0 KB/s1.9 KB23:59:43
11news.redatomik.org54.2 KB1.2 KB55.4 KB0.0 KB/s1.9 KB23:59:49
12news.snarked.org51.8 KB53.3 KB105.1 KB0.0 KB/s2.0 KB23:59:41
13news-in.mixmin.net29.7 KB24.6 KB54.3 KB0.0 KB/s1.9 KB23:59:49
14news.swapon.de4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:45:12
15newsfeed.datemas.de2.4 KB1.4 KB3.9 KB0.0 KB/s1.3 KB23:59:49
TOTAL: 155.3 MB14.8 MB20.1 MB0.0 KB/s7.3 KB359:42:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 10 714122.9 MB 1187 0 2002:15:20
2agency.bbs.geek.nz 401 695522.4 MB 3822 77 6200:14:42
3103.39.238.13 25 11471.5 MB 137 0 000:05:40
TOTAL: 3 436 1524346.7 MB 5146 77 8227:17:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 11 714122.9 MB 1187 0 2026:29:32
2*.bbs.geek.nz 401 695522.4 MB 3822 77 6200:14:42
3unresolved 33 11471.5 MB 137 0 000:33:04
TOTAL: 3 445 1524346.7 MB 5146 77 8227:17:22

NNRP auth users [Top 20]:

UserConn
amybbs 25
bpanther 10
malcolmlewis 1
TOTAL: 3 36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.092 0.044 0.00324:14:12
67-61-21-181.cpe.cableone.net 1.796 1.156 0.02702:15:20
118.149.161.54 0.224 0.036 0.00000:17:18
agency.bbs.geek.nz 28.800 7.236 0.00000:14:42
118.148.141.3 0.256 0.036 0.00000:07:43
103.39.238.13 1.428 0.436 0.17400:05:40
118.149.183.253 0.064 0.008 0.00000:02:20
94.167.36.206 0.052 0.008 0.00000:00:02
? 1.336 0.216 0.00000:00:02
TOTAL: 9 34.048 9.176 0.20427:17:22

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.161.54 4
118.148.141.3 2
118.149.183.253 1
67-60-219-146.cpe.cableone.net 1
94.167.36.206 1
TOTAL: 5 9

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 5226 34.3%
2alt 1801 11.8%
3comp 1728 11.3%
4soc 1492 9.8%
5linux 1261 8.3%
6uk 1258 8.3%
7sci 1183 7.8%
8talk 619 4.1%
9misc 276 1.8%
10news 190 1.2%
11mozilla 86 0.6%
12microsoft 60 0.4%
13humanities 22 0.1%
14nz 20 0.1%
15aus 11 0.1%
16eternal-september 5 0.0%
17us 5 0.0%
TOTAL: 17 15243100.0%

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

NewsgroupCount
1rec.arts.tv 1487
2rec.food.cooking 624
3linux.debian.bugs.dist 478
4alt.atheism 474
5comp.lang.python 450
6alt.fan.rush-limbaugh 420
7uk.d-i-y 393
8uk.legal 363
9rec.sport.football.college 348
10soc.retirement 345
11talk.origins 339
12sci.physics 302
13sci.math 290
14linux.debian.changes.devel 235
15uk.radio.amateur 219
16rec.sport.tennis 219
17rec.arts.sf.written 209
18rec.arts.drwho 206
19comp.lang.c 199
20soc.culture.vietnamese 190
21alt.comp.os.windows-10 188
22talk.politics.guns 188
23news.lists.filters 181
24sci.electronics.design 171
25rec.boats 171
26rec.sport.golf 147
27sci.physics.relativity 144
28soc.culture.israel 139
29comp.os.linux.advocacy 132
30alt.politics.trump 127
31soc.culture.china 123
32soc.culture.usa 119
33comp.os.vms 110
34uk.comp.sys.mac 107
35rec.sport.pro-wrestling 106
36misc.survivalism 102
37comp.lang.forth 100
38rec.aquaria.marine.misc 100
39rec.aviation.marketplace 100
40rec.radio.shortwave 97
41soc.culture.indian 95
42alt.politics 94
43rec.autos.sport.f1 93
44soc.culture.polish 91
45comp.lang.c++ 91
46linux.debian.user 86
47talk.politics.misc 82
48alt.test 82
49rec.outdoors.rv-travel 78
50linux.debian.devel.release 75
51rec.arts.sf.tv 75
52sci.logic 75
53linux.debian.bugs.rc 74
54rec.aviation.soaring 74
55alt.bible 69
56rec.sport.soccer 69
57rec.music.classical.recordings 69
58mozilla.general 66
59soc.culture.bulgaria 64
60rec.photo.digital 62
61sci.military.naval 61
62alt.recovery.aa 60
63rec.audio.opinion 56
64comp.lang.ada 54
65rec.bicycles.tech 54
66rec.gambling.poker 52
67uk.tech.broadcast 48
68uk.legal.moderated 48
69soc.history.what-if 46
70microsoft.public.windowsxp.general 45
71comp.protocols.time.ntp 45
72rec.games.trivia 44
73comp.lang.asm.x86 44
74rec.arts.movies.current-films 43
75rec.woodworking 40
76alt.support.diabetes 40
77linux.debian.maint.boot 40
78comp.mobile.android 40
79misc.invest.stocks 38
80uk.tech.digital-tv 37
81sci.med.cardiology 37
82alt.comp.hardware 36
83alt.os.linux.ubuntu 36
84misc.phone.mobile.iphone 35
85comp.sys.mac.system 35
86alt.society.liberalism 34
87misc.health.diabetes 34
88rec.arts.disney.parks 33
89rec.drugs.cannabis 31
90rec.crafts.metalworking 31
91uk.comp.homebuilt 31
92rec.arts.tv.uk.coronation-st 30
93comp.sys.apple2 30
94rec.arts.poems 30
95rec.puzzles.crosswords 29
96comp.lang.idl-pvwave 28
97alt.bbs.mystic 28
98soc.women 27
99rec.arts.movies.past-films 27
100linux.debian.user.french 27
TOTAL: 359 15243