news.bbs.geek.nz daily logs

Jul 7 23:58:01 -- Jul 8 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 111265 55.8%8.9 MB 35.2%
innd 33380 16.7%5.3 MB 20.9%
inn 30055 15.1%6.3 MB 24.9%
innfeed 23199 11.6%4.6 MB 18.1%
cnfsstat 1440 0.7%249.6 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 199340 100.0%25.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 283860 48.6%
Positive hits 271604 46.5%
Do not exist 28266 4.8%
Cache misses 159 0.0%
TOTAL: 4 583889 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.176 0.0%139 0.000 1.266 18.000
article cleanup00:00:00.269 0.0%29498 0.000 0.009 0.031
article logging00:00:00.728 0.0%29938 0.000 0.024 0.064
article parse00:00:00.944 0.0%76791 0.000 0.012 0.038
article write00:00:02.565 0.0%20117 0.019 0.128 5.384
artlog/artcncl00:00:00.001 0.0%134 0.000 0.007 0.250
data move00:00:00.521 0.0%543745 0.000 0.001 0.013
hisgrep/artcncl00:00:00.004 0.0%132 0.000 0.030 0.333
hishave/artcncl00:00:00.000 0.0%139 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.116 0.0%585266 0.001 0.012 0.645
history sync00:00:00.115 0.0%305 0.000 0.377 34.000
history write00:00:08.288 0.0%28319 0.010 0.293 16.673
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle23:57:16.838 99.8%560910 89.902 153.745 359.274
nntp read00:00:03.243 0.0%562468 0.002 0.006 0.027
overview write00:00:40.604 0.0%20117 0.070 2.018 57.419
perl filter00:01:01.452 0.1%28319 1.476 2.170 9.045
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.163 0.0%40234 0.003 0.029 0.093
TOTAL: 24:00:22.92923:59:24.027 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.073 0.0%26965 0.000 0.003 0.016
article prepare00:00:00.003 0.0%9722 0.000 0.000 0.050
article read00:00:00.160 0.0%2238 0.000 0.071 5.667
backlog stats00:00:00.299 0.0%315600 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.530 0.0%262473 0.001 0.006 0.012
data write00:00:02.918 0.0%250419 0.007 0.012 0.020
idle23:53:54.585100.0%315600 154.428 272.606 543.907
status file00:00:14.204 0.0%1902 0.667 7.468 330.111
TOTAL: 23:54:31.40423:54:13.772100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:03:37.521 93.4%118008 0.000 672.984 81396.867
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.289 0.0%252037 0.000 0.005 0.200
readart00:00:02.006 0.0%8677 0.000 0.231 36.500
TOTAL: 23:37:14.07122:03:40.816 93.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.snarked.org 68 24875 5752 14024 5099 23%66:08:16
2newsfeed.datemas.de 2 20947 4215 16055 677 20%23:30:00
3news.albasani.net 1 24600 2950 20612 1038 11%27:10:27
4feeder.eternal-september.org 122 24489 1585 22469 435 6%68:00:20
5news.redatomik.org 1 18677 1246 17293 138 6%23:02:25
6csiph.com 1 20291 972 19235 84 4%23:45:15
7newsfeed.neva.ru 155 17112 966 15321 825 5%90:40:02
8news-out.mixmin.net 14 18764 716 17738 310 3%29:40:39
9news-out.aioe.org 1 16845 630 16129 86 3%17:05:13
10news.samoylyk.net 2 22656 219 22181 256 0%17:43:03
11feeder.awxg.com 1 19121 202 18830 89 1%23:59:57
12news.freedyn.net 2 23130 127 22881 122 0%24:18:16
13news.swapon.de 5 1424 76 1323 25 5%19:28:10
14agency-nz-out.news.mb-net.net 21 20686 36 20566 84 0%27:56:40
15localhost 2 1 1 0 0 100%00:00:00
TOTAL: 15 398 273618 19693 244657 9268 7%482:28:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.3 MB653.7 KB30.2 MB54.1 MB 43%5.1 KB
2newsfeed.datemas.de13.3 MB774.8 KB2.3 MB16.4 MB 81%3.4 KB
3news.albasani.net9.9 MB639.8 KB2.5 MB13.0 MB 76%3.3 KB
4feeder.eternal-september.org5.2 MB818.9 KB2.7 MB8.7 MB 59%4.4 KB
5news.redatomik.org3.6 MB416.6 KB458.8 KB4.5 MB 80%3.3 KB
6news-out.mixmin.net2.7 MB374.2 KB877.2 KB3.9 MB 68%3.9 KB
7newsfeed.neva.ru2.6 MB187.7 KB3.1 MB5.9 MB 44%3.4 KB
8csiph.com2.4 MB333.7 KB341.8 KB3.0 MB 78%2.9 KB
9news-out.aioe.org1.8 MB170.7 KB260.5 KB2.2 MB 80%3.1 KB
10news.samoylyk.net1.1 MB413.6 KB1.3 MB2.8 MB 40%6.0 KB
11news.freedyn.net1.1 MB443.7 KB645.3 KB2.2 MB 51%9.0 KB
12feeder.awxg.com619.4 KB297.6 KB312.7 KB1.2 MB 50%4.2 KB
13news.swapon.de197.0 KB89.3 KB90.1 KB376.5 KB 52%3.7 KB
14agency-nz-out.news.mb-net.net194.9 KB237.6 KB391.9 KB824.5 KB 23%6.9 KB
15localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
TOTAL: 1568.1 MB5.7 MB45.3 MB119.2 MB 57%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 7 23:58:01 - 23:59:59 22 0.1% 0.1849.5 KB 0.1% 0.42
Jul 8 00:00:00 - 00:59:59 1045 5.2% 0.293.6 MB 5.1% 1.01
Jul 8 01:00:00 - 01:59:59 1129 5.6% 0.314.2 MB 6.1% 1.21
Jul 8 02:00:00 - 02:59:59 1306 6.5% 0.365.0 MB 7.1% 1.41
Jul 8 03:00:00 - 03:59:59 1207 6.0% 0.344.1 MB 5.8% 1.15
Jul 8 04:00:00 - 04:59:59 1225 6.1% 0.343.5 MB 5.1% 1.00
Jul 8 05:00:00 - 05:59:59 1072 5.3% 0.303.4 MB 4.8% 0.96
Jul 8 06:00:00 - 06:59:59 977 4.9% 0.274.1 MB 6.0% 1.18
Jul 8 07:00:00 - 07:59:59 1219 6.1% 0.343.5 MB 5.1% 1.01
Jul 8 08:00:00 - 08:59:59 982 4.9% 0.273.8 MB 5.4% 1.07
Jul 8 09:00:00 - 09:59:59 1003 5.0% 0.283.6 MB 5.2% 1.03
Jul 8 10:00:00 - 10:59:59 684 3.4% 0.192.1 MB 3.1% 0.61
Jul 8 11:00:00 - 11:59:59 672 3.3% 0.191.9 MB 2.7% 0.54
Jul 8 12:00:00 - 12:59:59 559 2.8% 0.162.3 MB 3.4% 0.67
Jul 8 13:00:00 - 13:59:59 493 2.5% 0.141.6 MB 2.3% 0.45
Jul 8 14:00:00 - 14:59:59 407 2.0% 0.111.6 MB 2.3% 0.46
Jul 8 15:00:00 - 15:59:59 548 2.7% 0.151.4 MB 2.0% 0.40
Jul 8 16:00:00 - 16:59:59 486 2.4% 0.142.1 MB 3.1% 0.61
Jul 8 17:00:00 - 17:59:59 528 2.6% 0.152.1 MB 3.1% 0.61
Jul 8 18:00:00 - 18:59:59 573 2.9% 0.163.0 MB 4.3% 0.85
Jul 8 19:00:00 - 19:59:59 804 4.0% 0.223.4 MB 4.9% 0.97
Jul 8 20:00:00 - 20:59:59 753 3.7% 0.212.4 MB 3.5% 0.68
Jul 8 21:00:00 - 21:59:59 795 4.0% 0.222.2 MB 3.1% 0.61
Jul 8 22:00:00 - 22:59:59 828 4.1% 0.232.0 MB 2.9% 0.58
Jul 8 23:00:00 - 23:58:01 788 3.9% 0.232.5 MB 3.6% 0.74
TOTAL: 24:00:00 20105 100.0% 0.2369.6 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.2 GB 36.5% 0 0.36 1703.87
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.3 GB 42.6% 0 0.39 1570.71
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB226.5 MB 0.4% 0 0.0416296.30
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 GB4.3 GB 8.6% 0 0.68 895.59
TOTAL: 10-500.0 GB44.1 GB 8.8% 1 0.47-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5170 42 0 122 0 0 0 0 5006
2news.albasani.net 1165 0 0 102 0 0 0 0 1063
3newsfeed.datemas.de 841 162 0 97 0 0 0 0 582
4newsfeed.neva.ru 837 26 0 52 0 0 0 0 759
5feeder.eternal-september.org 450 0 0 147 0 0 0 0 303
6news.samoylyk.net 355 0 0 101 0 0 0 0 254
7news-out.mixmin.net 326 0 0 94 0 0 0 0 232
8news.redatomik.org 176 0 0 110 0 0 0 0 66
9news.freedyn.net 114 25 0 57 0 0 0 0 32
10feeder.awxg.com 89 2 0 83 0 0 0 0 4
11news-out.aioe.org 89 8 0 59 0 0 0 0 22
12agency-nz-out.news.mb-net.net 88 10 0 63 0 0 0 0 15
13csiph.com 65 0 0 62 0 0 0 0 3
14news.swapon.de 51 0 0 27 0 0 0 0 24
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 9818 275 0 1178 0 0 0 0 8365

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.commerciali 48
it.annunci.varie 45
it.annunci.immobiliari 42
mozilla.support.seamonkey 13
gmane.linux.alsa.devel 11
gmane.comp.gis.openstreetmap.imports 10
mpc.lists.nanog 8
mozilla.dev.l10n 7
mozilla.dev.platform 7
mozilla.dev.ui-alerts 6
mozilla.dev.mdc 4
gmane.linux.alsa.user 4
alt.penthouse.sex.femdom 4
mozilla.dev.l10n.sr 3
mozilla.dev.developer-tools 3
gmane.linux.kernel 3
gmane.comp.gis.openstreetmap.tagging 3
mpc.lists.freebsd.x11 3
mozilla.dev.security.policy 2
mozilla.community.german 2
TOTAL: 62 275

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7013
EMP (phn path) 655
EMP (phn nph) 99
Too many newsgroups 53
EMP (phl) 34
Too many newsgroups (low_xpost) 34
User-issued cancel 14
Binary: non-binary distribution 8
Binary: misplaced par2 3
Binary Image: misplaced jpg 3
HTML post 2
Binary: misplaced 024 1
Binary: misplaced 657 1
Binary: misplaced 002 1
Binary: misplaced 614 1
Binary: misplaced 023 1
Binary: misplaced 003 1
TOTAL: 17 7924

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 198
newsfeed.datemas.de 151
news.redatomik.org 31
news.swapon.de 23
news-out.mixmin.net 13
news.snarked.org 12
feeder.eternal-september.org 6
news-out.aioe.org 5
feeder.awxg.com 1
news.samoylyk.net 1
TOTAL: 10 441
TOTAL: 1 441

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18185 1013 17070 101 1 0 5%23:59:36
2awxg 19543 84 19426 9 0 55 0%23:59:41
3news.freedyn.net 20218 10 19957 6 0 121 0%23:59:46
4news.samoylyk.net 19808 9 17968 4 0 947 0%23:59:36
5csiph.com 19155 7 19044 0 0 82 0%23:59:46
6neva.ru 18469 5 18453 0 0 0 0%23:59:46
7aioe 17081 3 16979 1 0 30 0%23:59:46
8eternal-september 17195 2 17134 0 0 188 0%23:59:46
9mb-net.net 20081 2 20035 1 0 106 0%23:59:46
10news.redatomik.org 18454 2 18439 0 0 21 0%23:59:33
11news.snarked.org 14176 2 14080 0 0 3 0%23:59:46
12news.swapon.de 1773 1 1771 0 0 0 0%23:59:25
13newsfeed.datemas.de 15764 1 15754 0 0 91 0%23:59:46
14news-in.mixmin.net 17722 1 17705 0 0 33 0%23:59:46
15news.albasani.net 18595 0 15759 1079 2 5251 0%23:59:46
TOTAL: 15 256219 1142 249574 1201 3 6928 0%359:55:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.6 MB7.5 MB12.1 MB0.1 KB/s11.1 KB23:59:36
2awxg385.3 KB83.3 KB468.5 KB0.0 KB/s5.0 KB23:59:41
3news.redatomik.org101.4 KB0.0 KB101.4 KB0.0 KB/s50.7 KB23:59:33
4neva.ru31.9 KB0.0 KB31.9 KB0.0 KB/s6.4 KB23:59:46
5news.freedyn.net25.4 KB36.3 KB61.8 KB0.0 KB/s3.9 KB23:59:46
6news.samoylyk.net18.8 KB142.5 KB161.3 KB0.0 KB/s12.4 KB23:59:36
7csiph.com9.4 KB0.0 KB9.4 KB0.0 KB/s1.3 KB23:59:46
8aioe4.8 KB2.0 KB6.8 KB0.0 KB/s1.7 KB23:59:46
9mb-net.net4.4 KB6.1 KB10.5 KB0.0 KB/s3.5 KB23:59:46
10news.snarked.org2.3 KB0.0 KB2.3 KB0.0 KB/s1.2 KB23:59:46
11eternal-september2.3 KB0.0 KB2.3 KB0.0 KB/s1.1 KB23:59:46
12news.swapon.de1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:25
13newsfeed.datemas.de1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:46
14news-in.mixmin.net1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:46
15news.albasani.net0.0 KB4.0 MB4.0 MB0.0 KB/s3.8 KB23:59:46
TOTAL: 155.2 MB11.8 MB17.0 MB0.0 KB/s7.4 KB359:55:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 354 637621.3 MB 3441 1 000:12:20
2static-103-243-239-29.bal.ausnetservers.net.au 24 11331.7 MB 151 0 000:04:56
TOTAL: 2 378 750923.0 MB 3592 1 023:37:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 354 637621.3 MB 3441 1 000:12:20
2*.bal.ausnetservers.net.au 24 11331.7 MB 151 0 000:04:56
3unresolved 22 00.0 KB 0 0 001:32:28
4*.cpe.cableone.net 4 00.0 KB 0 0 021:47:16
TOTAL: 4 404 750923.0 MB 3592 1 023:37:07

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 4
TOTAL: 2 28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.188 0.068 0.00921:47:16
118.149.165.7 0.480 0.060 0.00000:36:40
118.149.144.234 0.404 0.064 0.00000:31:17
agency.bbs.geek.nz 25.084 5.964 0.00000:12:20
118.149.217.206 0.188 0.020 0.00000:11:15
118.149.151.172 0.120 0.012 0.00000:06:03
118.149.163.81 0.056 0.012 0.00000:05:01
static-103-243-239-29.bal.ausnetservers.net.au 1.352 0.400 0.16000:04:56
118.149.210.245 0.048 0.020 0.00000:02:10
? 2.196 0.280 0.00000:00:04
TOTAL: 10 30.116 6.900 0.16923:37:07

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.165.7 8
118.149.144.234 7
67-61-218-236.cpe.cableone.net 4
118.149.217.206 3
118.149.151.172 2
118.149.163.81 1
118.149.210.245 1
TOTAL: 7 26

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
agency.bbs.geek.nz 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3522 46.9%
2comp 1215 16.2%
3soc 886 11.8%
4sci 781 10.4%
5alt 407 5.4%
6misc 328 4.4%
7talk 118 1.6%
8news 111 1.5%
9uk 70 0.9%
10humanities 33 0.4%
11aus 21 0.3%
12nz 15 0.2%
13eternal-september 2 0.0%
TOTAL: 13 7509100.0%

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

NewsgroupCount
1rec.arts.tv 1172
2rec.arts.drwho 418
3rec.sport.golf 248
4alt.test 237
5comp.lang.python 234
6rec.sport.tennis 214
7misc.test 192
8soc.culture.israel 180
9alt.comp.os.windows-10 166
10soc.retirement 163
11rec.arts.sf.written 160
12comp.lang.c 159
13comp.os.linux.advocacy 141
14soc.culture.polish 122
15sci.electronics.design 116
16sci.physics 116
17rec.photo.digital 108
18rec.food.cooking 107
19rec.sport.football.college 103
20rec.gambling.poker 102
21rec.bicycles.tech 90
22sci.physics.relativity 89
23news.lists.filters 88
24sci.military.naval 78
25comp.lang.c++ 76
26comp.sys.apple2 70
27rec.boats 66
28rec.arts.sf.fandom 65
29talk.politics.guns 62
30rec.arts.movies.current-films 60
31sci.math 51
32soc.culture.china 51
33comp.sys.raspberry-pi 51
34comp.sys.apple2.programmer 50
35soc.culture.cuba 49
36misc.survivalism 48
37rec.sport.pro-wrestling 47
38sci.med.pharmacy 44
39soc.culture.usa 43
40talk.politics.misc 42
41soc.culture.vietnamese 40
42sci.space.news 39
43uk.comp.homebuilt 39
44sci.logic 38
45misc.health.alternative 37
46comp.mobile.android 36
47rec.aviation.soaring 36
48rec.music.classical.recordings 34
49sci.astro.amateur 32
50soc.culture.indian 32
51sci.math.num-analysis 31
52rec.radio.shortwave 30
53soc.penpals 30
54rec.autos.tech 28
55soc.culture.singapore 28
56uk.radio.amateur 27
57rec.music.rock-pop-r+b.1960s 26
58comp.lang.forth 26
59comp.lang.java.programmer 25
60sci.math.symbolic 25
61rec.sport.soccer 25
62humanities.lit.authors.shakespeare 24
63comp.protocols.time.ntp 24
64comp.sys.mac.advocacy 24
65comp.soft-sys.sas 23
66soc.culture.romanian 23
67rec.arts.movies.past-films 22
68comp.sys.acorn.apps 21
69rec.autos.sport.f1 21
70sci.electronics.repair 20
71rec.music.beatles 20
72comp.soft-sys.math.scilab 19
73comp.soft-sys.matlab 19
74aus.computers 18
75sci.crypt 17
76misc.phone.mobile.iphone 17
77rec.radio.amateur.misc 16
78rec.arts.comics.strips 16
79comp.lang.ada 16
80comp.sys.acorn.networking 16
81comp.arch 15
82comp.os.vms 15
83sci.space.policy 15
84soc.genealogy.medieval 14
85comp.misc 14
86rec.music.dylan 14
87rec.outdoors.rv-travel 14
88sci.med.cardiology 13
89rec.crafts.metalworking 13
90comp.sys.cbm 12
91nz.general 12
92comp.sys.mac.system 12
93rec.arts.sf.science 12
94soc.culture.venezuela 11
95soc.culture.bulgaria 11
96comp.lang.lisp 10
97rec.radio.amateur.dx 10
98rec.radio.amateur.equipment 10
99news.admin.net-abuse.email 10
100soc.history.what-if 9
TOTAL: 289 7509