news.bbs.geek.nz daily logs

Jun 18 23:58:02 -- Jun 19 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 220242 71.6%18.9 MB 53.5%
innd 32194 10.5%5.2 MB 14.7%
inn 30204 9.8%6.5 MB 18.5%
innfeed 23444 7.6%4.4 MB 12.6%
cnfsstat 1440 0.5%251.6 KB 0.7%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 307526 100.0%35.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 287770 48.1%
Positive hits 281838 47.1%
Do not exist 28265 4.7%
Cache misses 367 0.1%
TOTAL: 4 598240 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.525 0.0%160 0.000 3.281 28.000
article cleanup00:00:00.290 0.0%29525 0.000 0.010 0.042
article logging00:00:01.352 0.0%30024 0.000 0.045 2.223
article parse00:00:00.809 0.0%75777 0.000 0.011 0.023
article write00:00:03.430 0.0%21109 0.014 0.162 2.571
artlog/artcncl00:00:00.002 0.0%160 0.000 0.013 0.056
data move00:00:00.518 0.0%555059 0.000 0.001 0.007
hisgrep/artcncl00:00:00.203 0.0%159 0.000 1.277 9.000
hishave/artcncl00:00:00.072 0.0%160 0.000 0.450 7.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:26.854 0.2%601903 0.002 0.344 1.274
history sync00:00:00.020 0.0%368 0.000 0.054 0.500
history write00:03:20.105 0.2%28422 0.029 7.040 37.874
hiswrite/artcncl00:00:00.015 0.0%1 15.000 15.000 15.000
idle23:49:48.841 99.2%562821 96.177 152.427 323.825
nntp read00:00:04.727 0.0%572989 0.004 0.008 0.024
overview write00:01:31.454 0.1%21109 0.318 4.332 70.617
perl filter00:00:55.940 0.1%28422 1.115 1.968 14.850
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.939 0.0%42218 0.000 0.022 0.090
TOTAL: 24:00:55.31423:59:16.096 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.083 0.0%31049 0.000 0.003 0.023
article prepare00:00:00.002 0.0%9438 0.000 0.000 0.021
article read00:00:00.279 0.0%1884 0.000 0.148 6.333
backlog stats00:00:00.570 0.0%319742 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.610 0.0%271233 0.004 0.010 0.017
data write00:00:02.950 0.0%261128 0.004 0.011 0.022
idle23:53:01.370 99.9%319742 159.577 268.909 534.837
status file00:00:32.000 0.0%1970 0.400 16.244 588.300
TOTAL: 23:54:00.04723:53:39.864100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%10 0.000 0.000 0.000
idle28:54:54.857 95.2%145066 0.000 717.569 83056.788
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.084 0.0%631367 0.000 0.016 0.333
readart01:24:24.923 4.6%2410440 0.000 2.101 32.000
TOTAL: 30:21:57.96530:19:29.864 99.9%----

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 47 25470 4722 15596 5152 18%49:27:47
2news.redatomik.org 1 19351 4164 15109 78 21%23:37:38
3newsfeed.datemas.de 2 22259 2612 19067 580 11%24:04:25
4csiph.com 2 21928 2539 19316 73 11%26:04:23
5news-out.aioe.org 3 21727 2194 19311 222 10%24:45:31
6feeder.eternal-september.org 104 25746 1547 23815 384 6%54:58:17
7news-out.mixmin.net 10 19939 1508 17814 617 7%27:43:39
8newsfeed.neva.ru 136 19226 888 17932 406 4%83:56:26
9news.albasani.net 1 16471 325 15917 229 1%16:23:36
10news.samoylyk.net 2 33439 215 32762 462 0%32:29:21
11news.freedyn.net 2 21429 137 21155 137 0%23:30:26
12feeder.awxg.com 1 16541 80 16390 71 0%23:59:56
13news.swapon.de 3 1576 74 1485 17 4%24:14:22
14agency-nz-out.news.mb-net.net 17 20217 55 20069 93 0%29:31:30
15localhost 22 21 21 0 0 100%00:00:00
TOTAL: 15 353 285340 21081 255738 8521 7%464:47:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.0 MB649.3 KB31.4 MB51.0 MB 37%5.3 KB
2newsfeed.datemas.de13.0 MB698.7 KB2.0 MB15.7 MB 82%5.0 KB
3news.redatomik.org10.0 MB352.1 KB356.4 KB10.7 MB 93%2.6 KB
4csiph.com6.6 MB337.5 KB349.9 KB7.3 MB 90%2.9 KB
5news-out.aioe.org5.8 MB284.9 KB611.1 KB6.7 MB 86%2.8 KB
6news-out.mixmin.net5.4 MB459.9 KB1.6 MB7.4 MB 72%3.6 KB
7feeder.eternal-september.org5.2 MB708.5 KB2.6 MB8.4 MB 61%4.5 KB
8news.albasani.net4.0 MB554.8 KB978.9 KB5.5 MB 72%10.2 KB
9news.freedyn.net3.3 MB253.7 KB505.4 KB4.0 MB 81%15.0 KB
10newsfeed.neva.ru2.6 MB285.9 KB1.8 MB4.7 MB 56%3.7 KB
11news.samoylyk.net1.8 MB1.0 MB3.0 MB5.8 MB 30%8.7 KB
12agency-nz-out.news.mb-net.net481.5 KB299.1 KB546.8 KB1.3 MB 36%9.0 KB
13feeder.awxg.com244.0 KB346.6 KB350.7 KB941.3 KB 25%6.2 KB
14news.swapon.de175.6 KB55.7 KB56.6 KB287.9 KB 60%3.2 KB
15localhost31.3 KB0.0 KB0.0 KB31.3 KB100%1.5 KB
TOTAL: 1577.6 MB6.2 MB46.0 MB129.7 MB 59%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 18 23:58:02 - 23:59:59 26 0.1% 0.2261.2 KB 0.1% 0.52
Jun 19 00:00:00 - 00:59:59 912 4.3% 0.252.7 MB 3.4% 0.77
Jun 19 01:00:00 - 01:59:59 932 4.4% 0.263.7 MB 4.7% 1.04
Jun 19 02:00:00 - 02:59:59 1009 4.8% 0.283.4 MB 4.3% 0.96
Jun 19 03:00:00 - 03:59:59 1015 4.8% 0.283.8 MB 4.9% 1.08
Jun 19 04:00:00 - 04:59:59 1182 5.6% 0.335.0 MB 6.4% 1.42
Jun 19 05:00:00 - 05:59:59 1070 5.1% 0.303.6 MB 4.6% 1.03
Jun 19 06:00:00 - 06:59:59 1164 5.5% 0.325.3 MB 6.8% 1.51
Jun 19 07:00:00 - 07:59:59 1150 5.4% 0.328.2 MB 10.5% 2.33
Jun 19 08:00:00 - 08:59:59 1114 5.3% 0.314.5 MB 5.7% 1.27
Jun 19 09:00:00 - 09:59:59 1038 4.9% 0.293.5 MB 4.5% 0.99
Jun 19 10:00:00 - 10:59:59 845 4.0% 0.232.4 MB 3.1% 0.70
Jun 19 11:00:00 - 11:59:59 600 2.8% 0.172.2 MB 2.8% 0.63
Jun 19 12:00:00 - 12:59:59 560 2.7% 0.161.5 MB 2.0% 0.43
Jun 19 13:00:00 - 13:59:59 495 2.3% 0.141.6 MB 2.0% 0.45
Jun 19 14:00:00 - 14:59:59 465 2.2% 0.131.6 MB 2.1% 0.46
Jun 19 15:00:00 - 15:59:59 523 2.5% 0.151.7 MB 2.2% 0.49
Jun 19 16:00:00 - 16:59:59 559 2.6% 0.162.2 MB 2.8% 0.63
Jun 19 17:00:00 - 17:59:59 630 3.0% 0.172.2 MB 2.8% 0.63
Jun 19 18:00:00 - 18:59:59 677 3.2% 0.192.6 MB 3.4% 0.75
Jun 19 19:00:00 - 19:59:59 789 3.7% 0.222.3 MB 3.0% 0.66
Jun 19 20:00:00 - 20:59:59 991 4.7% 0.282.9 MB 3.7% 0.83
Jun 19 21:00:00 - 21:59:59 1102 5.2% 0.313.8 MB 4.9% 1.09
Jun 19 22:00:00 - 22:59:59 1148 5.4% 0.323.4 MB 4.3% 0.96
Jun 19 23:00:00 - 23:58:02 1133 5.4% 0.334.0 MB 5.1% 1.18
TOTAL: 24:00:00 21129 100.0% 0.2478.2 MB 100.0% 0.93
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.8 GB 35.6% 0 0.31 1959.68
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.7 GB 41.5% 0 0.37 1660.55
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB222.1 MB 0.4% 0 0.0320512.82
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 GB3.1 GB 6.3% 0 0.80 760.98
TOTAL: 10-500.0 GB41.9 GB 8.4% 1 0.48-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5137 87 0 103 0 0 0 0 4947
2newsfeed.datemas.de 707 166 0 81 0 0 0 0 460
3news-out.mixmin.net 653 0 0 104 0 0 0 0 549
4newsfeed.neva.ru 406 62 0 67 0 0 0 0 277
5feeder.eternal-september.org 395 0 0 144 0 0 0 0 251
6news.samoylyk.net 375 0 0 115 0 0 0 0 260
7news.redatomik.org 322 0 0 75 0 0 0 0 247
8news.albasani.net 286 4 0 89 0 0 0 0 193
9news-out.aioe.org 231 41 0 65 0 0 0 0 125
10news.freedyn.net 134 6 0 43 0 0 0 0 85
11agency-nz-out.news.mb-net.net 94 6 0 61 1 0 0 0 26
12feeder.awxg.com 74 1 0 72 0 0 0 0 1
13csiph.com 67 0 0 62 0 0 0 0 5
14news.swapon.de 30 0 0 18 0 0 0 0 12
15news.ausics.org 4 0 0 4 0 0 0 0 0
TOTAL: 15 8915 373 0 1103 1 0 0 0 7438

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 100
mpc.lists.freebsd.ports.bugs 51
it.annunci.immobiliari 32
gmane.linux.alsa.devel 32
it.annunci.commerciali 31
it.annunci.varie 30
mpc.lists.freebsd.gecko 12
gmane.linux.kernel 9
mpc.lists.nanog 9
mozilla.dev.security.policy 9
gmane.comp.gis.openstreetmap.tagging 6
mpc.lists.freebsd.x11 6
mozilla.dev.telemetry-alerts 6
gmane.linux.kernel.input 5
eagle.support.eng 5
mozilla.dev.platform 3
test.post 3
mozilla.dev.ui-alerts 3
mozilla.dev.l10n.sr 3
mpc.lists.freebsd.gnome 2
TOTAL: 35 373

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
nz.politics.announce 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6211
EMP (phn path) 399
EMP (phl) 163
Too many newsgroups 66
EMP (phn nph) 65
Binary: non-binary distribution 19
User-issued cancel 8
Binary Image: misplaced jpg 4
HTML post 3
Too many newsgroups (low_xpost) 1
Cancel for rejected article 1
TOTAL: 11 6940

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 243
newsfeed.datemas.de 127
news-out.mixmin.net 65
news-out.aioe.org 21
news.swapon.de 12
news.albasani.net 10
news.snarked.org 8
feeder.eternal-september.org 4
news.samoylyk.net 4
newsfeed.neva.ru 3
TOTAL: 11 498
TOTAL: 1 498

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19396 849 18432 114 1 9 4%23:59:45
2awxg 20568 106 20440 11 0 8 0%23:59:46
3news.snarked.org 16395 33 16258 1 0 17 0%23:59:37
4news.freedyn.net 21249 28 20933 8 0 55 0%23:59:45
5mb-net.net 20994 22 20935 0 0 0 0%23:59:43
6csiph.com 18712 22 18630 0 0 0 0%23:59:45
7news-in.mixmin.net 18567 21 18535 0 0 0 0%23:59:45
8news.samoylyk.net 19244 21 19193 1 0 0 0%23:59:34
9news.redatomik.org 16899 21 16848 1 0 0 0%23:59:45
10aioe 16716 21 16601 0 0 0 0%23:59:45
11neva.ru 19633 17 19547 6 0 2354 0%23:59:45
12newsfeed.datemas.de 18485 15 18441 5 0 52 0%23:59:45
13news.albasani.net 21873 14 18801 898 0 7360 0%23:59:45
14eternal-september 17633 11 17563 0 0 164 0%23:59:45
15news.swapon.de 1818 0 1818 0 0 0 0%23:59:22
TOTAL: 15 268182 1201 262975 1045 1 10019 0%359:55:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.8 MB11.1 MB14.8 MB0.2 KB/s15.8 KB23:59:45
2news.snarked.org1.7 MB146.2 KB1.9 MB0.0 KB/s56.3 KB23:59:37
3awxg662.6 KB106.9 KB769.5 KB0.0 KB/s6.6 KB23:59:46
4news.freedyn.net76.4 KB96.8 KB173.2 KB0.0 KB/s4.8 KB23:59:45
5aioe34.6 KB0.0 KB34.6 KB0.0 KB/s1.6 KB23:59:45
6csiph.com33.2 KB0.0 KB33.2 KB0.0 KB/s1.5 KB23:59:45
7mb-net.net32.2 KB0.0 KB32.2 KB0.0 KB/s1.5 KB23:59:43
8news-in.mixmin.net32.0 KB0.0 KB32.0 KB0.0 KB/s1.5 KB23:59:45
9news.samoylyk.net30.4 KB99.9 KB130.3 KB0.0 KB/s5.9 KB23:59:34
10news.redatomik.org30.4 KB99.9 KB130.3 KB0.0 KB/s5.9 KB23:59:45
11neva.ru28.1 KB10.3 KB38.4 KB0.0 KB/s1.7 KB23:59:45
12news.albasani.net20.2 KB3.7 MB3.8 MB0.0 KB/s4.2 KB23:59:45
13newsfeed.datemas.de19.4 KB8.9 KB28.4 KB0.0 KB/s1.4 KB23:59:45
14eternal-september14.9 KB0.0 KB14.9 KB0.0 KB/s1.4 KB23:59:45
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:22
TOTAL: 156.5 MB15.3 MB21.8 MB0.0 KB/s10.0 KB359:55:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 387 600119.7 MB 3482 20 000:12:48
2kosh.activateit.net.au 24 13061.8 MB 168 0 000:05:34
3192.168.1.9 3 56287.0 KB 8 0 000:00:03
460.234.244.55 7 2068.5 KB 1 0 000:25:25
567-61-218-236.cpe.cableone.net 3 510.1 KB 3 2 025:27:37
TOTAL: 5 424 738821.9 MB 3662 22 030:21:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 387 600119.7 MB 3482 20 000:12:48
2*.activateit.net.au 24 13061.8 MB 168 0 000:05:34
3unresolved 10 76355.4 KB 9 0 000:25:28
4*.cpe.cableone.net 3 510.1 KB 3 2 025:27:37
5*.dyn.optonline.net 2 00.0 KB 0 0 004:10:20
TOTAL: 5 426 738821.9 MB 3662 22 030:21:51

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
malcolmlewis 3
paulh 3
TOTAL: 4 35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.252 0.112 0.00725:27:37
ool-457809ae.dyn.optonline.net 33.136 188.356 0.00004:10:20
60.234.244.55 0.496 0.088 0.01400:25:25
agency.bbs.geek.nz 30.100 7.064 0.00000:12:48
kosh.activateit.net.au 1.548 0.452 0.17100:05:34
192.168.1.9 0.260 0.068 0.00500:00:03
? 1.300 0.120 0.00000:00:02
TOTAL: 7 67.092 196.260 0.19730:21:51

Curious NNRP server explorers [Top 20]:

SystemConn
ool-457809ae.dyn.optonline.net 2
TOTAL: 1 2

NNRP gethostbyaddr failures [Top 20]:

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
ool-457809ae.dyn.optonline.net 2 2
67-61-218-236.cpe.cableone.net 1 1
TOTAL: 2 3 3

Newsgroup request counts (by category):

CategoryCountPct
1rec 3273 44.4%
2comp 1144 15.5%
3alt 825 11.2%
4soc 808 11.0%
5sci 558 7.6%
6misc 285 3.9%
7talk 198 2.7%
8news 99 1.3%
9nz 95 1.3%
10uk 56 0.8%
11humanities 13 0.2%
12aus 11 0.1%
13agency 10 0.1%
14eternal-september 1 0.0%
TOTAL: 14 7376100.0%

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

NewsgroupCount
1rec.arts.tv 781
2rec.arts.drwho 619
3alt.home.repair 337
4rec.sport.tennis 333
5comp.os.linux.advocacy 331
6alt.comp.os.windows-10 325
7comp.lang.c 259
8misc.survivalism 210
9rec.arts.sf.written 174
10soc.culture.polish 139
11rec.food.cooking 134
12soc.retirement 133
13sci.electronics.design 101
14rec.sport.soccer 100
15news.lists.filters 92
16rec.music.dylan 85
17sci.physics 81
18nz.general 81
19comp.mobile.android 79
20alt.bbs.mystic 77
21rec.sport.pro-wrestling 76
22talk.politics.misc 70
23rec.gambling.poker 68
24sci.physics.relativity 66
25rec.photo.digital 66
26soc.culture.israel 63
27talk.politics.guns 62
28talk.origins 60
29soc.culture.china 59
30soc.culture.singapore 58
31sci.math 56
32soc.culture.indian 55
33rec.boats 50
34rec.bicycles.tech 49
35rec.audio.pro 48
36soc.culture.cuba 47
37comp.lang.c++ 46
38sci.space.policy 46
39sci.logic 45
40alt.test 44
41comp.lang.python 42
42comp.lang.forth 41
43rec.arts.comics.strips 40
44rec.audio.opinion 39
45soc.penpals 39
46rec.sport.golf 38
47rec.radio.shortwave 38
48rec.music.rock-pop-r+b.1950s 36
49soc.culture.usa 34
50sci.military.naval 32
51comp.soft-sys.matlab 32
52rec.outdoors.rv-travel 32
53uk.radio.amateur 30
54comp.sys.apple2 28
55rec.sport.football.college 28
56rec.crafts.metalworking 26
57rec.arts.movies.current-films 26
58rec.games.pinball 26
59soc.culture.bulgaria 25
60rec.woodworking 24
61soc.culture.brazil 22
62uk.tech.broadcast 22
63rec.music.classical.guitar 22
64soc.culture.vietnamese 22
65rec.autos.sport.f1 21
66rec.aviation.soaring 21
67comp.os.vms 20
68misc.health.alternative 19
69comp.lang.ada 19
70comp.protocols.dns.bind 18
71comp.soft-sys.sas 17
72soc.culture.venezuela 17
73sci.med.pharmacy 17
74sci.lang 17
75comp.sys.mac.system 16
76comp.soft-sys.math.scilab 16
77rec.radio.amateur.dx 15
78misc.phone.mobile.iphone 15
79sci.math.num-analysis 14
80comp.sys.mac.advocacy 14
81alt.os.linux.ubuntu 14
82rec.games.trivia 14
83sci.geo.earthquakes 13
84rec.music.beatles 13
85comp.std.c 13
86misc.news.internet.discuss 13
87rec.radio.amateur.misc 12
88soc.men 12
89sci.crypt 12
90comp.misc 11
91comp.lang.perl.misc 11
92humanities.lit.authors.shakespeare 11
93rec.arts.disney.parks 11
94comp.arch.embedded 11
95soc.culture.jewish 10
96agency.test 10
97rec.arts.movies.past-films 10
98comp.sys.acorn.programmer 10
99rec.travel.europe 10
100comp.databases.xbase.fox 9
TOTAL: 279 7376