news.bbs.geek.nz daily logs

Jul 12 23:58:02 -- Jul 13 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 104355 54.2%8.4 MB 33.3%
innd 32705 17.0%5.3 MB 20.9%
inn 30879 16.0%6.7 MB 26.6%
innfeed 23289 12.1%4.6 MB 18.2%
cnfsstat 1440 0.7%250.3 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 192669 100.0%25.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 305009 49.9%
Positive hits 276934 45.3%
Do not exist 28825 4.7%
Cache misses 242 0.0%
TOTAL: 4 611010 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.127 0.0%109 0.000 1.165 34.000
article cleanup00:00:00.248 0.0%30375 0.000 0.008 0.042
article logging00:00:00.703 0.0%30786 0.000 0.023 0.124
article parse00:00:00.949 0.0%82923 0.000 0.011 0.035
article write00:00:01.639 0.0%21611 0.016 0.076 0.512
artlog/artcncl00:00:00.000 0.0%102 0.000 0.000 0.000
data move00:00:00.514 0.0%569339 0.000 0.001 0.016
hisgrep/artcncl00:00:00.002 0.0%99 0.000 0.020 0.500
hishave/artcncl00:00:00.000 0.0%109 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.813 0.0%619520 0.001 0.011 0.859
history sync00:00:00.013 0.0%316 0.000 0.041 0.667
history write00:00:06.671 0.0%29140 0.017 0.229 16.876
hiswrite/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
idle23:57:13.573 99.8%591829 92.369 145.707 378.281
nntp read00:00:03.502 0.0%593246 0.003 0.006 0.015
overview write00:00:42.269 0.0%21611 0.046 1.956 70.102
perl filter00:01:05.239 0.1%29140 1.429 2.239 15.908
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.380 0.0%43222 0.007 0.032 0.123
TOTAL: 24:00:26.45223:59:23.642 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%30535 0.000 0.002 0.024
article prepare00:00:00.002 0.0%9014 0.000 0.000 0.025
article read00:00:00.138 0.0%2081 0.000 0.066 1.500
backlog stats00:00:00.306 0.0%334029 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.681 0.0%279162 0.001 0.006 0.011
data write00:00:03.021 0.0%267572 0.005 0.011 0.027
idle23:53:18.933100.0%334029 161.711 257.459 564.950
status file00:00:04.941 0.0%1904 0.667 2.595 72.457
TOTAL: 23:53:44.99623:53:29.097100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%5 0.000 0.000 0.000
idle11:39:50.589 96.4%111135 0.000 377.834 75218.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.247 0.0%238808 0.000 0.005 0.500
readart00:00:02.364 0.0%8718 0.000 0.271 32.000
TOTAL: 12:06:07.13011:39:54.200 96.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 62 20875 6076 14089 710 29%64:32:01
2newsfeed.datemas.de 2 22731 4429 17573 729 19%24:03:42
3news.redatomik.org 1 18322 2233 15994 95 12%21:42:13
4news-out.aioe.org 5 28391 1881 26409 101 6%33:48:30
5news-out.mixmin.net 17 22477 1619 20205 653 7%30:57:24
6feeder.eternal-september.org 110 27479 1496 24582 1401 5%61:21:40
7newsfeed.neva.ru 149 13978 1131 9854 2993 8%88:18:31
8csiph.com 1 21228 1111 20028 89 5%23:57:48
9news.freedyn.net 3 24256 685 23198 373 2%24:16:55
10news.albasani.net 1 23353 212 22871 270 0%24:16:11
11news.samoylyk.net 3 30369 177 28879 1313 0%25:48:46
12feeder.awxg.com 1 19262 151 19021 90 0%23:59:56
13news.swapon.de 5 2413 121 2265 27 5%31:32:31
14agency-nz-out.news.mb-net.net 22 24290 61 24064 165 0%30:43:40
15localhost 2 1 1 0 0 100%00:00:01
TOTAL: 15 384 299425 21384 269032 9009 7%509:19:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org22.3 MB446.1 KB3.1 MB25.8 MB 86%3.9 KB
2newsfeed.datemas.de13.1 MB467.8 KB2.1 MB15.6 MB 83%3.1 KB
3feeder.eternal-september.org7.9 MB1.4 MB12.8 MB22.1 MB 35%7.8 KB
4news-out.mixmin.net5.9 MB558.9 KB1.7 MB8.2 MB 72%3.7 KB
5news.redatomik.org5.8 MB255.0 KB295.8 KB6.3 MB 91%2.8 KB
6news-out.aioe.org4.8 MB399.2 KB430.5 KB5.6 MB 85%2.9 KB
7newsfeed.neva.ru3.1 MB408.4 KB16.3 MB19.8 MB 15%4.9 KB
8news.freedyn.net3.0 MB727.6 KB1.4 MB5.0 MB 58%4.9 KB
9csiph.com2.8 MB338.2 KB357.2 KB3.5 MB 80%3.0 KB
10news.albasani.net1.8 MB478.8 KB854.8 KB3.1 MB 57%6.5 KB
11news.samoylyk.net1.1 MB507.9 KB5.9 MB7.5 MB 14%5.2 KB
12feeder.awxg.com454.2 KB336.3 KB338.6 KB1.1 MB 40%4.7 KB
13news.swapon.de302.8 KB87.1 KB89.8 KB479.8 KB 63%3.2 KB
14agency-nz-out.news.mb-net.net154.5 KB334.8 KB2.3 MB2.8 MB 5%12.8 KB
15localhost1.6 KB0.0 KB0.0 KB1.6 KB100%1.6 KB
TOTAL: 1572.4 MB6.7 MB48.0 MB127.0 MB 56%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 12 23:58:02 - 23:59:59 27 0.1% 0.2394.8 KB 0.1% 0.80
Jul 13 00:00:00 - 00:59:59 1123 5.2% 0.312.8 MB 3.8% 0.79
Jul 13 01:00:00 - 01:59:59 1207 5.6% 0.343.6 MB 4.9% 1.02
Jul 13 02:00:00 - 02:59:59 1296 6.0% 0.364.5 MB 6.1% 1.27
Jul 13 03:00:00 - 03:59:59 1385 6.4% 0.384.7 MB 6.4% 1.34
Jul 13 04:00:00 - 04:59:59 1186 5.5% 0.333.2 MB 4.3% 0.90
Jul 13 05:00:00 - 05:59:59 1142 5.3% 0.323.7 MB 5.0% 1.05
Jul 13 06:00:00 - 06:59:59 1146 5.3% 0.324.7 MB 6.4% 1.34
Jul 13 07:00:00 - 07:59:59 976 4.5% 0.272.8 MB 3.8% 0.80
Jul 13 08:00:00 - 08:59:59 966 4.5% 0.273.6 MB 4.9% 1.02
Jul 13 09:00:00 - 09:59:59 1113 5.2% 0.313.8 MB 5.1% 1.07
Jul 13 10:00:00 - 10:59:59 937 4.3% 0.263.9 MB 5.3% 1.12
Jul 13 11:00:00 - 11:59:59 687 3.2% 0.193.5 MB 4.7% 0.98
Jul 13 12:00:00 - 12:59:59 582 2.7% 0.161.9 MB 2.6% 0.54
Jul 13 13:00:00 - 13:59:59 548 2.5% 0.151.8 MB 2.4% 0.50
Jul 13 14:00:00 - 14:59:59 471 2.2% 0.131.5 MB 2.0% 0.42
Jul 13 15:00:00 - 15:59:59 424 2.0% 0.122.1 MB 2.8% 0.59
Jul 13 16:00:00 - 16:59:59 557 2.6% 0.152.6 MB 3.6% 0.74
Jul 13 17:00:00 - 17:59:59 478 2.2% 0.131.6 MB 2.1% 0.45
Jul 13 18:00:00 - 18:59:59 629 2.9% 0.171.9 MB 2.5% 0.53
Jul 13 19:00:00 - 19:59:59 877 4.1% 0.242.8 MB 3.9% 0.81
Jul 13 20:00:00 - 20:59:59 883 4.1% 0.253.1 MB 4.2% 0.88
Jul 13 21:00:00 - 21:59:59 1009 4.7% 0.283.7 MB 5.1% 1.07
Jul 13 22:00:00 - 22:59:59 1055 4.9% 0.292.9 MB 3.9% 0.83
Jul 13 23:00:00 - 23:58:01 907 4.2% 0.263.1 MB 4.1% 0.90
TOTAL: 23:59:59 21611 100.0% 0.2573.7 MB 100.0% 0.87
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.4 GB 36.8% 0 0.33 1818.60
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.4 GB 42.9% 0 0.40 1515.63
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB227.5 MB 0.4% 0 0.0322857.14
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.6 GB 9.2% 0 0.73 825.69
TOTAL: 10-500.0 GB44.7 GB 8.9% 1 0.49-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3006 48 0 75 0 0 0 0 2883
2feeder.eternal-september.org 1313 0 0 153 0 0 0 0 1160
3news.samoylyk.net 1162 0 0 112 0 0 0 0 1050
4newsfeed.datemas.de 854 110 0 108 0 0 0 0 636
5news-out.mixmin.net 778 0 0 109 0 0 0 0 669
6news.snarked.org 727 24 0 101 0 0 0 0 602
7news.freedyn.net 374 12 0 76 0 0 0 0 286
8news.albasani.net 285 2 0 99 0 0 0 0 184
9news.redatomik.org 175 0 0 81 0 0 0 0 94
10agency-nz-out.news.mb-net.net 155 14 0 72 3 0 0 0 66
11news-out.aioe.org 117 5 0 65 0 0 0 0 47
12csiph.com 88 0 0 83 0 0 0 0 5
13feeder.awxg.com 86 0 0 84 0 0 0 0 2
14news.swapon.de 41 0 0 20 0 0 0 0 21
15news.ausics.org 4 0 0 4 0 0 0 0 0
TOTAL: 15 9165 215 0 1242 3 0 0 0 7705

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 53
mozilla.support.seamonkey 22
mozilla.dev.platform 21
mozilla.dev.security.policy 12
gmane.linux.kernel 11
mozilla.dev.l10n 10
mozilla.support.bugzilla 7
mpc.lists.nanog 6
trollnet.cinema 6
mozilla.dev.apps.thunderbird 4
eagle.support.eng 3
mozilla.tools.l10n 3
mozilla.dev.l10n.sr 3
alt.digicash.deadbeats 3
mozilla.support.calendar 2
gmane.comp.gis.openstreetmap.imports 2
mozilla.dev.media 2
gmane.linux.kernel.clk 2
mozilla.governance 2
mozilla.tools 2
TOTAL: 52 215

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

GroupsCount
nz.politics.announce 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6266
EMP (phn path) 662
EMP (phn nph) 206
Too many newsgroups 72
EMP (phl) 38
Too many newsgroups (low_xpost) 13
User-issued cancel 12
Binary: non-binary distribution 7
HTML post 6
Binary: misplaced txt 4
Cancel for rejected article 4
Binary Image: misplaced jpg 1
TOTAL: 12 7291

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 128
news-out.mixmin.net 107
news.redatomik.org 70
news-out.aioe.org 38
news.albasani.net 19
news.swapon.de 19
news.snarked.org 18
newsfeed.neva.ru 10
feeder.awxg.com 2
news.freedyn.net 1
TOTAL: 12 414
TOTAL: 1 414

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19946 778 19065 102 1 0 3%23:59:46
2awxg 21063 92 20950 1 0 9 0%23:59:48
3news.freedyn.net 21330 15 20899 1 0 64 0%23:59:45
4news.snarked.org 15448 14 15298 10 0 11 0%23:59:48
5csiph.com 20677 7 20487 1 0 8 0%23:59:42
6aioe 17042 2 16955 0 0 0 0%23:59:48
7news-in.mixmin.net 18693 1 18676 0 0 1 0%23:59:48
8neva.ru 19987 1 19980 0 0 1 0%23:59:48
9mb-net.net 21568 1 21514 0 0 3 0%23:59:48
10news.redatomik.org 19242 1 19226 1 0 1 0%23:59:48
11news.albasani.net 22458 0 19390 1125 0 6685 0%23:59:48
12news.swapon.de 2052 0 2052 0 0 0 0%23:59:35
13newsfeed.datemas.de 17218 0 17188 0 0 111 0%23:59:48
14eternal-september 18086 0 18040 0 0 116 0%23:59:48
15news.samoylyk.net 19854 0 19782 0 0 2204 0%23:59:47
TOTAL: 15 274664 912 269502 1241 1 9214 0%359:56:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org5.4 MB8.6 MB13.9 MB0.2 KB/s16.2 KB23:59:46
2awxg436.5 KB6.7 KB443.1 KB0.0 KB/s4.8 KB23:59:48
3news.freedyn.net49.9 KB10.7 KB60.6 KB0.0 KB/s3.8 KB23:59:45
4news.snarked.org30.3 KB30.6 KB60.9 KB0.0 KB/s2.5 KB23:59:48
5csiph.com18.8 KB445.1 KB463.9 KB0.0 KB/s58.0 KB23:59:42
6aioe2.9 KB0.0 KB2.9 KB0.0 KB/s1.4 KB23:59:48
7news-in.mixmin.net1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:48
8neva.ru1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:48
9mb-net.net1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:48
10news.redatomik.org1.6 KB33.1 KB34.7 KB0.0 KB/s17.3 KB23:59:48
11news.albasani.net0.0 KB3.7 MB3.7 MB0.0 KB/s3.3 KB23:59:48
12news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:35
13newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
14eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
15news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 155.9 MB12.8 MB18.7 MB0.0 KB/s8.9 KB359:56:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 352 680120.8 MB 3610 0 000:11:30
2163.47.16.169 24 10631.4 MB 135 0 000:04:58
360.234.244.55 6 1225.0 KB 1 1 000:20:30
467-61-218-236.cpe.cableone.net 3 00.0 KB 1 0 011:03:45
TOTAL: 4 385 787622.2 MB 3747 1 012:06:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 352 680120.8 MB 3610 0 000:11:30
2unresolved 36 10751.4 MB 136 1 000:50:18
3*.cpe.cableone.net 3 00.0 KB 1 0 011:03:45
TOTAL: 3 391 787622.2 MB 3747 1 012:06:00

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
malcolmlewis 3
TOTAL: 3 32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.180 0.052 0.00911:03:45
60.234.244.55 0.416 0.064 0.01300:20:30
118.149.215.22 0.200 0.012 0.00000:15:06
agency.bbs.geek.nz 25.148 5.848 0.00000:11:30
118.149.158.1 0.124 0.012 0.00000:09:42
163.47.16.169 1.348 0.400 0.19300:04:58
? 2.060 0.216 0.00000:00:26
185.100.87.250 0.060 0.008 0.00000:00:01
TOTAL: 8 29.536 6.612 0.21512:06:00

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.215.22 3
118.149.158.1 2
185.100.87.250 1
TOTAL: 3 6

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
67-61-218-236.cpe.cableone.net 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3466 44.0%
2comp 1635 20.8%
3soc 952 12.1%
4sci 696 8.8%
5alt 567 7.2%
6talk 201 2.6%
7news 133 1.7%
8misc 87 1.1%
9nz 60 0.8%
10uk 39 0.5%
11aus 17 0.2%
12humanities 12 0.2%
13agency 7 0.1%
TOTAL: 13 7872100.0%

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

NewsgroupCount
1rec.arts.tv 781
2rec.sport.tennis 537
3alt.comp.os.windows-10 526
4rec.arts.drwho 351
5comp.lang.c 306
6comp.os.linux.advocacy 299
7rec.food.cooking 231
8comp.lang.python 200
9rec.sport.football.college 170
10soc.retirement 162
11comp.sys.mac.system 150
12sci.physics 131
13rec.sport.golf 123
14soc.culture.polish 118
15talk.politics.misc 111
16sci.electronics.design 110
17rec.bicycles.tech 109
18soc.culture.israel 100
19sci.physics.relativity 97
20rec.gambling.poker 91
21soc.culture.african.american 85
22talk.politics.guns 83
23rec.arts.movies.current-films 80
24rec.arts.sf.written 74
25comp.os.vms 67
26rec.boats 66
27news.admin.net-abuse.email 66
28rec.arts.sf.fandom 65
29comp.sys.apple2 64
30rec.photo.digital 56
31soc.culture.indian 56
32soc.culture.brazil 54
33news.lists.filters 53
34soc.culture.china 53
35soc.culture.cuba 52
36sci.logic 52
37sci.med.pharmacy 51
38nz.general 50
39sci.math 44
40rec.aviation.soaring 42
41rec.sport.pro-wrestling 41
42comp.lang.forth 40
43soc.culture.singapore 38
44comp.lang.c++ 38
45sci.math.num-analysis 37
46misc.survivalism 36
47comp.sys.mac.advocacy 34
48alt.test 34
49rec.music.dylan 32
50rec.crafts.metalworking 31
51rec.autos.sport.f1 30
52comp.lang.lisp 29
53uk.comp.homebuilt 29
54comp.sys.raspberry-pi 28
55comp.sys.apple2.programmer 28
56comp.protocols.time.ntp 26
57rec.audio.opinion 26
58rec.sport.soccer 26
59soc.culture.usa 25
60sci.math.symbolic 25
61rec.games.video.sony 25
62comp.lang.fortran 24
63soc.culture.vietnamese 24
64soc.culture.venezuela 24
65sci.military.naval 23
66rec.games.pinball 23
67rec.outdoors.rv-travel 22
68soc.history.what-if 22
69comp.lang.ada 21
70comp.soft-sys.matlab 21
71rec.music.rock-pop-r+b.1950s 21
72sci.astro.amateur 20
73comp.os.linux.misc 20
74rec.autos.tech 19
75rec.music.classical.recordings 19
76rec.woodworking 19
77soc.penpals 19
78sci.lang 19
79rec.skiing.alpine 19
80rec.arts.movies.past-films 18
81rec.arts.comics.strips 18
82misc.health.alternative 18
83comp.emulators.apple2 18
84rec.arts.tv.uk.coronation-st 17
85comp.lang.java.programmer 16
86comp.mobile.android 16
87rec.audio.pro 16
88comp.soft-sys.math.scilab 16
89rec.radio.shortwave 16
90rec.arts.sf.science 15
91comp.mobile.ipad 15
92comp.soft-sys.sas 15
93soc.culture.japan 14
94sci.space.policy 14
95rec.gardens.edible 13
96rec.music.rock-pop-r+b.1960s 13
97rec.arts.disney.parks 13
98soc.history.medieval 13
99rec.radio.amateur.misc 13
100comp.sys.acorn.networking 12
TOTAL: 290 7872