news.bbs.geek.nz daily logs

Jul 21 23:58:02 -- Jul 22 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 115850 58.1%9.3 MB 36.8%
innd 31422 15.8%5.2 MB 20.4%
inn 27594 13.8%6.1 MB 24.0%
innfeed 23066 11.6%4.5 MB 17.9%
cnfsstat 1440 0.7%253.8 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 199373 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 275081 49.3%
Positive hits 256510 46.0%
Do not exist 25754 4.6%
Cache misses 201 0.0%
TOTAL: 4 557546 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.227 0.0%106 0.000 2.142 15.000
article cleanup00:00:00.240 0.0%27051 0.000 0.009 0.038
article logging00:00:00.675 0.0%27518 0.000 0.025 0.079
article parse00:00:00.837 0.0%68234 0.000 0.012 0.034
article write00:00:01.414 0.0%19863 0.014 0.071 0.273
artlog/artcncl00:00:00.002 0.0%96 0.000 0.021 0.118
data move00:00:00.496 0.0%516998 0.000 0.001 0.009
hisgrep/artcncl00:00:00.001 0.0%101 0.000 0.010 1.000
hishave/artcncl00:00:00.000 0.0%106 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.598 0.0%558907 0.001 0.014 0.646
history sync00:00:00.018 0.0%382 0.000 0.047 1.000
history write00:00:08.227 0.0%25805 0.020 0.319 19.748
hiswrite/artcncl00:00:00.001 0.0%5 0.000 0.200 1.000
idle23:58:02.753 99.8%533494 91.501 161.731 407.618
nntp read00:00:03.187 0.0%534665 0.003 0.006 0.016
overview write00:00:42.366 0.0%19863 0.042 2.133 78.399
perl filter00:00:50.981 0.1%25805 1.250 1.976 4.600
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.214 0.0%39726 0.004 0.031 0.093
TOTAL: 24:00:55.19224:00:00.237 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.066 0.0%25845 0.000 0.003 0.024
article prepare00:00:00.000 0.0%8000 0.000 0.000 0.000
article read00:00:00.528 0.0%1815 0.000 0.291 12.375
backlog stats00:00:00.280 0.0%310932 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.550 0.0%258772 0.001 0.006 0.012
data write00:00:02.809 0.0%247173 0.006 0.011 0.023
idle23:53:58.293 99.9%310932 149.224 276.711 587.425
status file00:00:21.486 0.0%1856 0.750 11.577 536.139
TOTAL: 23:54:46.04523:54:25.012100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle14:22:53.767 92.3%123024 0.000 420.843 77156.047
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.410 0.0%262797 0.000 0.005 0.300
readart00:00:01.616 0.0%9163 0.000 0.176 20.327
TOTAL: 15:34:40.16014:22:56.793 92.3%----

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 64 18891 5718 12635 538 30%70:52:06
2newsfeed.datemas.de 2 21837 2993 17974 870 13%24:26:07
3news-out.aioe.org 2 18899 2002 16813 84 10%23:09:19
4feeder.eternal-september.org 112 26119 1940 22940 1239 7%75:30:58
5news-out.mixmin.net 20 21546 1829 18923 794 8%30:40:37
6news.redatomik.org 1 19038 1577 17369 92 8%24:09:24
7csiph.com 2 21052 1170 19787 95 5%25:01:45
8news.freedyn.net 3 21813 1104 20232 477 5%23:20:57
9newsfeed.neva.ru 159 12462 1079 9308 2075 8%93:48:33
10news.samoylyk.net 3 24280 276 23504 500 1%22:29:05
11feeder.awxg.com 2 18693 248 18361 84 1%23:59:55
12news.albasani.net 1 17309 163 16906 240 0%15:53:51
13news.swapon.de 8 1701 110 1568 23 6%27:37:07
14agency-nz-out.news.mb-net.net 25 23412 25 23273 114 0%42:05:34
15localhost 5 4 4 0 0 100%00:00:00
TOTAL: 15 409 267056 20238 239593 7225 7%523:05:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.6 MB410.9 KB1.8 MB21.8 MB 89%3.6 KB
2newsfeed.datemas.de10.8 MB974.2 KB3.9 MB15.6 MB 69%4.1 KB
3feeder.eternal-september.org7.7 MB853.9 KB10.2 MB18.8 MB 41%6.1 KB
4news-out.mixmin.net5.5 MB371.3 KB1.9 MB7.8 MB 70%3.0 KB
5news-out.aioe.org4.8 MB189.6 KB208.3 KB5.2 MB 92%2.6 KB
6news.freedyn.net4.1 MB713.1 KB1.6 MB6.4 MB 64%4.1 KB
7news.redatomik.org4.1 MB581.2 KB588.9 KB5.2 MB 78%3.2 KB
8csiph.com3.1 MB396.3 KB424.2 KB3.9 MB 79%3.2 KB
9newsfeed.neva.ru2.6 MB405.7 KB8.4 MB11.4 MB 22%3.7 KB
10news.samoylyk.net1.6 MB875.0 KB6.1 MB8.6 MB 18%11.3 KB
11news.albasani.net1.1 MB516.8 KB1.2 MB2.8 MB 38%7.0 KB
12feeder.awxg.com685.9 KB332.9 KB333.7 KB1.3 MB 50%4.1 KB
13news.swapon.de318.4 KB116.6 KB117.3 KB552.3 KB 57%4.2 KB
14agency-nz-out.news.mb-net.net81.4 KB435.0 KB725.1 KB1.2 MB 6%8.9 KB
15localhost6.4 KB0.0 KB0.0 KB6.4 KB100%1.6 KB
TOTAL: 1566.2 MB7.0 MB37.4 MB110.6 MB 59%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 21 23:58:02 - 23:59:59 29 0.1% 0.25199.5 KB 0.3% 1.69
Jul 22 00:00:00 - 00:59:59 1273 6.4% 0.353.0 MB 4.7% 0.87
Jul 22 01:00:00 - 01:59:59 1097 5.5% 0.303.4 MB 5.2% 0.97
Jul 22 02:00:00 - 02:59:59 1118 5.6% 0.313.2 MB 5.0% 0.92
Jul 22 03:00:00 - 03:59:59 1171 5.9% 0.333.5 MB 5.4% 1.00
Jul 22 04:00:00 - 04:59:59 1210 6.1% 0.343.1 MB 4.7% 0.87
Jul 22 05:00:00 - 05:59:59 1245 6.3% 0.353.5 MB 5.3% 0.99
Jul 22 06:00:00 - 06:59:59 992 5.0% 0.284.2 MB 6.5% 1.20
Jul 22 07:00:00 - 07:59:59 1088 5.5% 0.303.5 MB 5.4% 1.00
Jul 22 08:00:00 - 08:59:59 1112 5.6% 0.313.3 MB 5.0% 0.93
Jul 22 09:00:00 - 09:59:59 999 5.0% 0.284.9 MB 7.5% 1.40
Jul 22 10:00:00 - 10:59:59 757 3.8% 0.212.9 MB 4.4% 0.82
Jul 22 11:00:00 - 11:59:59 667 3.4% 0.192.4 MB 3.7% 0.68
Jul 22 12:00:00 - 12:59:59 552 2.8% 0.151.6 MB 2.4% 0.45
Jul 22 13:00:00 - 13:59:59 482 2.4% 0.131.7 MB 2.6% 0.48
Jul 22 14:00:00 - 14:59:59 530 2.7% 0.152.1 MB 3.2% 0.60
Jul 22 15:00:00 - 15:59:59 455 2.3% 0.131.6 MB 2.4% 0.45
Jul 22 16:00:00 - 16:59:59 516 2.6% 0.142.5 MB 3.9% 0.73
Jul 22 17:00:00 - 17:59:59 443 2.2% 0.122.2 MB 3.3% 0.62
Jul 22 18:00:00 - 18:59:59 576 2.9% 0.162.3 MB 3.5% 0.65
Jul 22 19:00:00 - 19:59:59 670 3.4% 0.192.0 MB 3.0% 0.56
Jul 22 20:00:00 - 20:59:59 697 3.5% 0.192.0 MB 3.0% 0.56
Jul 22 21:00:00 - 21:59:59 625 3.1% 0.172.0 MB 3.1% 0.57
Jul 22 22:00:00 - 22:59:59 806 4.1% 0.222.3 MB 3.5% 0.65
Jul 22 23:00:00 - 23:58:01 738 3.7% 0.212.0 MB 3.0% 0.58
TOTAL: 23:59:59 19848 100.0% 0.2365.3 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.6 GB 37.2% 0 0.29 2061.32
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.7 GB 43.4% 0 0.39 1553.10
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB229.3 MB 0.4% 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 GB5.1 GB 10.2% 0 0.59 1028.29
TOTAL: 10-500.0 GB45.7 GB 9.1% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2046 77 0 70 1 0 0 0 1898
2feeder.eternal-september.org 1158 0 0 157 0 0 0 0 1001
3newsfeed.datemas.de 1046 186 0 105 0 0 0 0 755
4news-out.mixmin.net 930 0 0 102 0 0 0 0 828
5news.snarked.org 547 42 0 101 0 0 0 0 404
6news.samoylyk.net 532 0 0 120 0 0 0 0 412
7news.freedyn.net 474 22 0 77 0 0 0 0 375
8news.albasani.net 320 4 0 118 0 0 0 0 198
9news.redatomik.org 171 0 0 83 0 0 0 0 88
10news-out.aioe.org 112 19 0 65 0 0 0 0 28
11agency-nz-out.news.mb-net.net 109 14 0 68 0 0 0 0 27
12feeder.awxg.com 90 1 0 85 0 0 0 0 4
13csiph.com 76 0 0 68 0 0 0 0 8
14news.swapon.de 32 0 0 20 0 0 0 0 12
15news.ausics.org 7 0 0 7 0 0 0 0 0
TOTAL: 15 7650 365 0 1246 1 0 0 0 6038

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 161
mozilla.support.seamonkey 22
alt.biology 18
mozilla.dev.l10n 15
mozilla.dev.platform 14
eagle.support.eng 12
mpc.lists.freebsd.ports.bugs 11
mozilla.dev.builds 10
mozilla.dev.apps.thunderbird 9
mozilla.dev.security.policy 9
gmane.comp.gis.openstreetmap.tagging 6
mozilla.release.engineering 5
mpc.lists.freebsd.office 4
af.philo 4
mozilla.test 4
mozilla.dev.planning 3
mpc.lists.nanog 3
usc.forsale 3
mpc.lists.freebsd.gnome 3
gmane.comp.hardware.netbook.arm.sunxi 3
TOTAL: 53 365

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4662
EMP (phn path) 566
EMP (phn nph) 155
EMP (phl) 62
Too many newsgroups 59
Too many newsgroups (low_xpost) 21
User-issued cancel 21
Too many newsgroups (meow) 7
Binary: misplaced par2 6
Binary: non-binary distribution 4
HTML post 3
Binary: misplaced rar 2
Binary Image: misplaced png 1
Binary: misplaced 002 1
Binary: misplaced 576 1
Binary Image: misplaced jpg 1
Binary: misplaced 727 1
TOTAL: 17 5573

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 181
news-out.mixmin.net 134
news.redatomik.org 86
news-out.aioe.org 23
news.swapon.de 11
news.snarked.org 11
newsfeed.neva.ru 6
feeder.awxg.com 4
news.albasani.net 4
feeder.eternal-september.org 2
TOTAL: 12 465
TOTAL: 1 465

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18215 844 17283 88 0 0 4%23:59:36
2awxg 19144 83 19044 3 1 39 0%23:59:43
3news.snarked.org 14176 12 14088 1 0 0 0%23:59:27
4news-in.mixmin.net 17306 8 17279 8 0 22 0%23:59:40
5news.freedyn.net 19097 7 18744 5 0 198 0%23:59:41
6neva.ru 18313 5 18297 1 0 0 0%23:59:41
7csiph.com 18766 4 18719 0 0 5 0%23:59:37
8news.redatomik.org 17947 3 17928 0 0 25 0%23:59:24
9eternal-september 16801 3 16703 0 0 361 0%23:59:41
10aioe 16108 3 15977 0 0 1 0%23:59:41
11news.samoylyk.net 17993 3 17968 0 0 38 0%23:59:21
12newsfeed.datemas.de 16662 2 16633 0 0 132 0%23:59:41
13mb-net.net 19857 2 19797 0 0 169 0%23:59:41
14news.swapon.de 1572 0 1571 0 0 0 0%23:57:34
15news.albasani.net 19606 0 17506 853 1 5145 0%23:59:41
TOTAL: 15 251563 979 247537 959 2 6135 0%359:52:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.7 MB7.4 MB12.1 MB0.1 KB/s13.3 KB23:59:36
2awxg319.8 KB9.9 KB329.7 KB0.0 KB/s3.8 KB23:59:43
3news.snarked.org77.7 KB3.6 KB81.4 KB0.0 KB/s6.3 KB23:59:27
4news-in.mixmin.net18.0 KB61.3 KB79.3 KB0.0 KB/s5.0 KB23:59:40
5eternal-september17.0 KB0.0 KB17.0 KB0.0 KB/s5.7 KB23:59:41
6neva.ru12.0 KB1.5 KB13.5 KB0.0 KB/s2.2 KB23:59:41
7news.freedyn.net11.9 KB6.2 KB18.1 KB0.0 KB/s1.5 KB23:59:41
8csiph.com6.4 KB0.0 KB6.4 KB0.0 KB/s1.6 KB23:59:37
9news.redatomik.org5.4 KB0.0 KB5.4 KB0.0 KB/s1.8 KB23:59:24
10aioe5.4 KB0.0 KB5.4 KB0.0 KB/s1.8 KB23:59:41
11news.samoylyk.net5.4 KB0.0 KB5.4 KB0.0 KB/s1.8 KB23:59:21
12mb-net.net3.1 KB0.0 KB3.1 KB0.0 KB/s1.6 KB23:59:41
13newsfeed.datemas.de2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:41
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:34
15news.albasani.net0.0 KB2.6 MB2.6 MB0.0 KB/s3.1 KB23:59:41
TOTAL: 155.2 MB10.1 MB15.3 MB0.0 KB/s8.1 KB359:52:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 373 642020.0 MB 3399 4 000:13:16
2163.47.16.169 24 14731.9 MB 155 0 000:07:04
360.234.244.55 7 923.9 KB 1 0 000:15:55
TOTAL: 3 404 790222.0 MB 3555 4 015:34:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 373 642020.0 MB 3399 4 000:13:16
2unresolved 47 14821.9 MB 156 0 001:33:39
3*.cpe.cableone.net 2 00.0 KB 0 0 013:47:35
TOTAL: 3 422 790222.0 MB 3555 4 015:34:33

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
malcolmlewis 2
TOTAL: 3 31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.188 0.060 0.00913:47:35
118.149.190.49 0.484 0.068 0.00000:37:22
118.149.186.232 0.252 0.016 0.00000:17:34
60.234.244.55 0.404 0.084 0.01400:15:55
202.174.187.54 0.228 0.044 0.00000:15:42
agency.bbs.geek.nz 26.136 6.252 0.00000:13:16
163.47.16.169 1.400 0.388 0.22700:07:04
? 1.356 0.140 0.00000:00:02
TOTAL: 8 30.448 7.052 0.25015:34:33

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.190.49 8
202.174.187.54 4
118.149.186.232 4
67-61-218-236.cpe.cableone.net 2
TOTAL: 4 18

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 3997 50.6%
2comp 1502 19.0%
3soc 830 10.5%
4sci 642 8.1%
5alt 356 4.5%
6misc 300 3.8%
7talk 174 2.2%
8news 54 0.7%
9humanities 19 0.2%
10agency 7 0.1%
11aus 7 0.1%
12uk 6 0.1%
13nz 6 0.1%
TOTAL: 13 7900100.0%

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

NewsgroupCount
1rec.arts.tv 1198
2rec.arts.drwho 556
3comp.lang.c 405
4rec.arts.sf.written 351
5comp.lang.python 306
6comp.os.linux.advocacy 271
7rec.sport.tennis 261
8sci.electronics.design 215
9alt.comp.os.windows-10 175
10rec.food.cooking 174
11soc.culture.israel 162
12alt.test 161
13soc.retirement 148
14rec.sport.golf 138
15misc.test 128
16soc.culture.polish 118
17misc.survivalism 109
18rec.sport.football.college 104
19rec.sport.pro-wrestling 102
20sci.physics 98
21rec.gambling.poker 92
22soc.culture.china 90
23rec.arts.movies.current-films 84
24talk.politics.misc 79
25rec.autos.tech 76
26comp.sys.mac.system 70
27talk.politics.guns 66
28rec.audio.opinion 66
29rec.boats 64
30sci.math 58
31rec.sport.soccer 56
32sci.physics.relativity 56
33rec.bicycles.tech 52
34rec.music.rock-pop-r+b.1950s 44
35comp.lang.c++ 41
36news.lists.filters 40
37rec.arts.tv.uk.coronation-st 38
38sci.med.pharmacy 38
39sci.logic 33
40soc.genealogy.medieval 33
41misc.health.alternative 32
42comp.sys.apple2 32
43rec.outdoors.rv-travel 31
44comp.protocols.time.ntp 31
45rec.arts.sf.fandom 29
46sci.math.num-analysis 27
47rec.aviation.soaring 27
48soc.motss 27
49rec.crafts.metalworking 27
50soc.culture.usa 26
51rec.arts.comics.strips 26
52soc.women 26
53comp.mobile.android 25
54rec.radio.amateur.misc 25
55soc.history.what-if 24
56talk.origins 24
57comp.soft-sys.matlab 23
58rec.arts.movies.past-films 22
59comp.os.linux.misc 22
60comp.os.vms 22
61rec.games.video.sony 22
62soc.culture.singapore 20
63soc.culture.brazil 20
64soc.penpals 19
65comp.soft-sys.sas 19
66sci.electronics.repair 19
67comp.soft-sys.math.scilab 18
68comp.sys.mac.hardware.misc 18
69rec.photo.digital 18
70rec.autos.sport.f1 17
71misc.legal 17
72soc.culture.indian 16
73rec.music.classical.recordings 16
74humanities.lit.authors.shakespeare 15
75comp.arch 14
76comp.sys.acorn.misc 14
77rec.music.rock-pop-r+b.1960s 13
78rec.music.dylan 13
79comp.lang.forth 12
80comp.sys.mac.advocacy 12
81soc.genealogy.jewish 12
82rec.nude 12
83sci.astro.amateur 12
84alt.bbs.mystic 12
85rec.gambling.lottery 12
86comp.lang.lisp 11
87sci.electronics.basics 11
88soc.culture.romanian 11
89sci.military.naval 10
90rec.games.backgammon 10
91sci.anthropology.paleo 10
92rec.arts.sf.tv 10
93rec.radio.amateur.antenna 10
94sci.med.cardiology 10
95rec.radio.amateur.homebrew 10
96comp.mobile.ipad 10
97rec.games.trivia 10
98sci.geo.earthquakes 9
99comp.lang.misc 9
100comp.lang.prolog 9
TOTAL: 267 7900