news.bbs.geek.nz daily logs

Jun 5 23:58:01 -- Jun 6 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 99591 51.9%8.0 MB 31.6%
inn 33700 17.6%7.3 MB 28.9%
innd 33588 17.5%5.3 MB 21.0%
innfeed 23586 12.3%4.4 MB 17.5%
cnfsstat 1440 0.8%252.6 KB 1.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 191906 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 320560 49.8%
Negative hits 290528 45.2%
Do not exist 31690 4.9%
Cache misses 647 0.1%
TOTAL: 4 643425 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.119 0.0%187 0.000 0.636 12.333
article cleanup00:00:00.346 0.0%32964 0.000 0.010 0.037
article logging00:00:00.847 0.0%33519 0.000 0.025 0.398
article parse00:00:01.242 0.0%119485 0.002 0.010 0.028
article write00:00:01.744 0.0%23427 0.013 0.074 0.759
artlog/artcncl00:00:00.004 0.0%187 0.000 0.021 1.000
data move00:00:00.391 0.0%633657 0.000 0.001 0.002
hisgrep/artcncl00:00:00.002 0.0%181 0.000 0.011 0.333
hishave/artcncl00:00:00.000 0.0%187 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.155 0.0%647409 0.002 0.013 0.555
history sync00:00:00.022 0.0%310 0.000 0.071 1.000
history write00:00:06.927 0.0%31861 0.011 0.217 10.440
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:56:43.476 99.7%644034 57.561 133.849 330.483
nntp read00:00:05.676 0.0%649665 0.005 0.009 0.032
overview write00:00:41.778 0.0%23427 0.090 1.783 39.260
perl filter00:00:59.179 0.1%31859 1.179 1.858 6.058
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.382 0.0%46854 0.000 0.029 0.122
TOTAL: 24:00:24.91823:58:51.290 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.074 0.0%32432 0.000 0.002 0.023
article prepare00:00:00.010 0.0%30640 0.000 0.000 0.007
article read00:00:00.420 0.0%7214 0.000 0.058 1.034
backlog stats00:00:00.618 0.0%334142 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.691 0.0%279022 0.004 0.010 0.019
data write00:00:03.069 0.0%267511 0.006 0.011 0.026
idle23:52:49.052100.0%334142 143.679 257.283 562.440
status file00:00:15.767 0.0%2021 0.467 7.802 327.512
TOTAL: 23:53:30.22523:53:11.701100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%2 0.500 0.500 0.500
idle13:10:12.978 94.6%106941 0.000 443.356 80575.745
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.582 0.0%231028 0.000 0.007 0.333
readart00:00:01.624 0.0%9371 0.000 0.173 14.500
TOTAL: 13:55:00.27913:10:16.185 94.6%----

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 71 27578 6955 15196 5427 25%68:37:44
2feeder.eternal-september.org 64 30750 3423 26359 968 11%48:56:40
3news-out.mixmin.net 25 23445 2904 19831 710 12%36:35:48
4news.redatomik.org 1 16887 2075 14765 47 12%18:09:43
5newsfeed.neva.ru 161 33944 1706 31574 664 5%103:12:59
6newsfeed.datemas.de 3 25847 1448 24002 397 5%25:01:00
7news.albasani.net 2 33329 1440 31477 412 4%36:24:55
8news-out.aioe.org 3 23286 1297 21893 96 5%24:03:57
9csiph.com 2 25140 901 24175 64 3%27:38:28
10news.samoylyk.net 3 39055 370 38293 392 0%32:51:18
11news.freedyn.net 2 27158 228 26735 195 0%24:47:11
12news.swapon.de 12 1948 203 1721 24 10%30:29:45
13feeder.awxg.com 2 20335 195 20083 57 0%23:59:53
14agency-nz-out.news.mb-net.net 17 23164 87 22969 108 0%30:41:55
15localhost 7 6 6 0 0 100%00:00:00
TOTAL: 15 375 351872 23238 319073 9561 6%531:31:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org30.9 MB498.2 KB31.4 MB62.8 MB 49%5.2 KB
2feeder.eternal-september.org11.9 MB3.1 MB63.1 MB78.1 MB 15%18.2 KB
3news-out.mixmin.net9.2 MB267.4 KB1.6 MB11.0 MB 83%3.1 KB
4news.redatomik.org5.4 MB242.0 KB242.0 KB5.8 MB 91%2.8 KB
5newsfeed.datemas.de5.3 MB808.7 KB1.8 MB7.9 MB 66%4.4 KB
6news.albasani.net4.8 MB401.6 KB1.1 MB6.3 MB 76%3.5 KB
7newsfeed.neva.ru4.7 MB364.7 KB2.3 MB7.3 MB 63%3.2 KB
8news-out.aioe.org3.7 MB152.1 KB295.4 KB4.1 MB 89%3.0 KB
9csiph.com2.6 MB381.8 KB428.1 KB3.3 MB 76%3.6 KB
10news.samoylyk.net2.1 MB601.3 KB2.5 MB5.1 MB 40%6.9 KB
11news.freedyn.net794.2 KB441.9 KB1017.6 KB2.2 MB 35%5.3 KB
12news.swapon.de535.6 KB50.2 KB51.2 KB637.0 KB 84%2.8 KB
13feeder.awxg.com529.8 KB185.2 KB190.6 KB905.7 KB 58%3.6 KB
14agency-nz-out.news.mb-net.net391.3 KB273.9 KB598.9 KB1.2 MB 30%6.5 KB
15localhost9.8 KB0.0 KB0.0 KB9.8 KB100%1.6 KB
TOTAL: 1582.6 MB7.6 MB106.5 MB196.7 MB 41%6.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 5 23:58:01 - 23:59:59 26 0.1% 0.2261.9 KB 0.1% 0.52
Jun 6 00:00:00 - 00:59:59 1087 4.6% 0.302.8 MB 3.5% 0.81
Jun 6 01:00:00 - 01:59:59 1226 5.2% 0.344.1 MB 5.0% 1.16
Jun 6 02:00:00 - 02:59:59 1447 6.2% 0.404.5 MB 5.5% 1.29
Jun 6 03:00:00 - 03:59:59 1515 6.5% 0.429.0 MB 10.9% 2.55
Jun 6 04:00:00 - 04:59:59 1276 5.4% 0.353.6 MB 4.4% 1.02
Jun 6 05:00:00 - 05:59:59 1320 5.6% 0.375.2 MB 6.3% 1.47
Jun 6 06:00:00 - 06:59:59 1300 5.5% 0.364.2 MB 5.1% 1.20
Jun 6 07:00:00 - 07:59:59 1204 5.1% 0.333.7 MB 4.5% 1.05
Jun 6 08:00:00 - 08:59:59 1167 5.0% 0.324.3 MB 5.3% 1.23
Jun 6 09:00:00 - 09:59:59 966 4.1% 0.274.0 MB 4.9% 1.15
Jun 6 10:00:00 - 10:59:59 930 4.0% 0.263.4 MB 4.1% 0.97
Jun 6 11:00:00 - 11:59:59 710 3.0% 0.203.0 MB 3.6% 0.84
Jun 6 12:00:00 - 12:59:59 668 2.9% 0.192.5 MB 3.0% 0.70
Jun 6 13:00:00 - 13:59:59 576 2.5% 0.162.4 MB 2.9% 0.67
Jun 6 14:00:00 - 14:59:59 441 1.9% 0.121.5 MB 1.8% 0.43
Jun 6 15:00:00 - 15:59:59 477 2.0% 0.132.2 MB 2.7% 0.63
Jun 6 16:00:00 - 16:59:59 667 2.8% 0.192.9 MB 3.5% 0.82
Jun 6 17:00:00 - 17:59:59 508 2.2% 0.142.0 MB 2.5% 0.58
Jun 6 18:00:00 - 18:59:59 702 3.0% 0.202.0 MB 2.5% 0.58
Jun 6 19:00:00 - 19:59:59 977 4.2% 0.272.8 MB 3.5% 0.81
Jun 6 20:00:00 - 20:59:59 1062 4.5% 0.292.8 MB 3.4% 0.78
Jun 6 21:00:00 - 21:59:59 1112 4.7% 0.313.7 MB 4.6% 1.06
Jun 6 22:00:00 - 22:59:59 970 4.1% 0.272.5 MB 3.0% 0.70
Jun 6 23:00:00 - 23:58:02 1092 4.7% 0.312.9 MB 3.5% 0.85
TOTAL: 24:00:01 23426 100.0% 0.2782.1 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.5 GB 34.9% 0 0.33 1833.45
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.3 GB 40.7% 0 0.45 1345.11
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB218.1 MB 0.4% 0 0.0610570.57
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 GB2.3 GB 4.7% 0 0.83 728.87
TOTAL: 10-500.0 GB40.4 GB 8.1% 1 0.53-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5431 68 0 113 0 0 0 0 5250
2feeder.eternal-september.org 960 0 0 155 0 0 0 0 805
3news-out.mixmin.net 930 0 0 75 0 0 0 0 855
4newsfeed.neva.ru 710 75 0 80 0 0 0 0 555
5news.albasani.net 526 1 0 92 0 0 0 0 433
6newsfeed.datemas.de 426 158 0 85 0 0 0 0 183
7news.samoylyk.net 313 0 0 109 0 0 0 0 204
8news.freedyn.net 196 22 0 64 0 0 0 0 110
9news.redatomik.org 143 0 0 64 0 0 0 0 79
10agency-nz-out.news.mb-net.net 140 41 0 68 0 0 0 0 31
11news-out.aioe.org 115 11 0 48 0 0 0 0 56
12feeder.awxg.com 72 2 0 63 0 0 0 0 7
13csiph.com 69 0 0 65 0 0 0 0 4
14news.swapon.de 56 0 0 18 0 0 0 0 38
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 10089 378 0 1101 0 0 0 0 8610

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 89
mozilla.support.seamonkey 29
it.annunci.immobiliari 29
it.annunci.commerciali 28
it.annunci.varie 28
mpc.lists.freebsd.ports.bugs 17
mozilla.dev.security.policy 15
mpc.lists.nanog 15
gmane.linux.alsa.devel 14
mpc.lists.freebsd.gnome 13
mozilla.dev.ui-alerts 12
mozilla.support.calendar 7
mozilla.dev.platform 5
mozilla.tools.taskcluster 5
gmane.comp.hardware.netbook.arm.sunxi 4
gmane.linux.kernel.renesas-soc 4
mozilla.dev.ports.os2 4
eagle.support.eng 3
mpc.lists.freebsd.pf 3
mozilla.dev.mdc 3
TOTAL: 61 378

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6937
EMP (phn path) 555
EMP (phn nph) 139
Binary Image: misplaced jpg 127
Binary: misplaced JPG 95
EMP (phl) 91
Too many newsgroups 56
Binary: non-binary distribution 20
User-issued cancel 18
HTML post 6
EMP (fsl) 3
Too many newsgroups (low_xpost) 2
User-issued spam cancel 2
MI5 Filter 1
Binary: misplaced txt 1
Too many newsgroups (meow) 1
Binary: misplaced pdf 1
TOTAL: 17 8055

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 193
news.albasani.net 151
news.redatomik.org 77
news.swapon.de 38
newsfeed.datemas.de 30
newsfeed.neva.ru 27
news-out.aioe.org 12
news.snarked.org 10
feeder.eternal-september.org 7
feeder.awxg.com 4
TOTAL: 11 553
TOTAL: 1 553

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 21450 5678 15474 298 0 0 26%23:59:50
2awxg 22748 108 22607 5 0 17 0%23:59:48
3aioe 19810 18 19614 0 0 0 0%23:59:46
4news.snarked.org 16457 17 16252 7 0 124 0%23:59:50
5news.redatomik.org 21358 14 21267 2 0 11 0%23:59:49
6csiph.com 22641 12 22513 0 0 3 0%23:59:50
7news.freedyn.net 23382 12 23183 0 0 20 0%23:59:49
8news-in.mixmin.net 19416 11 19396 0 0 0 0%23:59:42
9neva.ru 21239 4 21203 11 0 5 0%23:59:49
10eternal-september 19203 4 19045 1 0 513 0%23:59:49
11newsfeed.datemas.de 21932 3 21802 0 0 558 0%23:59:49
12news.albasani.net 23835 2 20006 1300 0 7963 0%23:59:35
13mb-net.net 13833 2 13772 0 0 9461 0%23:59:49
14news.swapon.de 1490 0 1489 0 0 1 0%23:50:17
15news.samoylyk.net 1079 0 1058 0 0 20086 0%23:59:49
TOTAL: 15 269873 5885 258681 1624 0 38762 2%359:47:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org25.8 MB8.2 MB34.0 MB0.4 KB/s5.8 KB23:59:50
2awxg737.1 KB17.0 KB754.2 KB0.0 KB/s6.7 KB23:59:48
3news.redatomik.org95.0 KB49.6 KB144.6 KB0.0 KB/s9.0 KB23:59:49
4news.snarked.org64.2 KB28.0 KB92.2 KB0.0 KB/s3.8 KB23:59:50
5aioe54.6 KB0.0 KB54.6 KB0.0 KB/s3.0 KB23:59:46
6eternal-september52.7 KB2.9 KB55.5 KB0.0 KB/s11.1 KB23:59:49
7csiph.com44.8 KB0.0 KB44.8 KB0.0 KB/s3.7 KB23:59:50
8news.freedyn.net22.3 KB0.0 KB22.3 KB0.0 KB/s1.9 KB23:59:49
9news-in.mixmin.net20.9 KB0.0 KB20.9 KB0.0 KB/s1.9 KB23:59:42
10neva.ru20.3 KB20.9 KB41.2 KB0.0 KB/s2.7 KB23:59:49
11newsfeed.datemas.de5.8 KB0.0 KB5.8 KB0.0 KB/s1.9 KB23:59:49
12mb-net.net4.2 KB0.0 KB4.2 KB0.0 KB/s2.1 KB23:59:49
13news.albasani.net3.8 KB8.8 MB8.8 MB0.1 KB/s6.9 KB23:59:35
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:17
15news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
TOTAL: 1526.9 MB17.1 MB44.0 MB0.0 KB/s6.0 KB359:47:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 348 667620.1 MB 3418 5 6600:11:51
2kosh.activateit.net.au 24 14791.8 MB 162 0 000:06:25
3192.168.1.7 1 1325.8 KB 4 0 000:00:00
460.234.244.55 9 1036.3 KB 2 1 000:22:38
567-61-218-236.cpe.cableone.net 4 00.0 KB 1 0 012:30:16
TOTAL: 5 386 817822.0 MB 3587 6 6613:54:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 348 667620.1 MB 3418 5 6600:11:51
2*.activateit.net.au 24 14791.8 MB 162 0 000:06:25
3unresolved 20 2362.0 KB 6 1 001:06:17
4*.cpe.cableone.net 4 00.0 KB 1 0 012:30:16
TOTAL: 4 396 817822.0 MB 3587 6 6613:54:53

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 6
malcolmlewis 4
paulh 1
TOTAL: 4 35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.200 0.068 0.26412:30:16
118.149.152.67 0.316 0.032 0.00000:24:33
60.234.244.55 0.604 0.096 0.01400:22:38
202.174.187.54 0.172 0.028 0.00000:12:01
agency.bbs.geek.nz 26.420 5.924 0.00000:11:51
118.149.131.126 0.136 0.016 0.00000:07:03
kosh.activateit.net.au 1.560 0.412 0.08600:06:25
? 1.448 0.160 0.00000:00:02
192.168.1.7 0.100 0.008 0.00200:00:00
TOTAL: 9 30.956 6.744 0.36613:54:53

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.152.67 5
202.174.187.54 3
118.149.131.126 2
TOTAL: 3 10

NNRP gethostbyaddr failures [Top 20]:

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

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 3971 48.6%
2comp 1164 14.2%
3soc 869 10.6%
4sci 772 9.4%
5alt 677 8.3%
6misc 186 2.3%
7news 178 2.2%
8talk 153 1.9%
9uk 132 1.6%
10aus 31 0.4%
11nz 26 0.3%
12agency 8 0.1%
13humanities 8 0.1%
14eternal-september 2 0.0%
TOTAL: 14 8177100.0%

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

NewsgroupCount
1rec.arts.tv 1209
2rec.arts.drwho 623
3alt.home.repair 337
4comp.os.linux.advocacy 278
5alt.comp.os.windows-10 269
6comp.lang.c 252
7rec.sport.tennis 236
8soc.retirement 184
9rec.photo.digital 170
10sci.physics 149
11sci.electronics.design 148
12rec.crafts.metalworking 145
13rec.sport.football.college 131
14uk.radio.amateur 126
15rec.food.cooking 125
16comp.lang.python 122
17misc.survivalism 122
18sci.physics.relativity 121
19soc.culture.israel 106
20news.lists.filters 94
21rec.boats 90
22soc.culture.china 89
23rec.music.dylan 88
24soc.penpals 78
25rec.sport.soccer 70
26rec.bicycles.tech 69
27rec.gambling.poker 64
28rec.sport.pro-wrestling 63
29sci.military.naval 62
30talk.origins 57
31soc.culture.polish 50
32rec.arts.sf.written 48
33sci.logic 47
34sci.math 45
35comp.sys.mac.advocacy 45
36comp.sys.mac.system 44
37talk.politics.guns 44
38soc.culture.singapore 43
39comp.lang.forth 43
40rec.outdoors.rv-travel 43
41rec.arts.comics.strips 42
42rec.radio.shortwave 42
43comp.lang.awk 41
44rec.arts.disney.parks 41
45news.admin.net-abuse.email 41
46rec.audio.pro 41
47talk.politics.misc 40
48soc.culture.cuba 38
49rec.music.classical.recordings 35
50comp.lang.c++ 34
51rec.sport.golf 34
52rec.games.pinball 32
53alt.test 32
54soc.culture.indian 31
55misc.health.alternative 31
56sci.med.pharmacy 31
57sci.crypt 30
58rec.games.trivia 30
59rec.aviation.soaring 30
60rec.arts.movies.current-films 30
61rec.arts.sf.fandom 29
62rec.music.beatles 28
63soc.genealogy.medieval 28
64comp.os.vms 28
65rec.autos.sport.f1 27
66aus.computers 25
67soc.culture.usa 25
68rec.music.artists.kiss 25
69rec.skiing.alpine 24
70rec.music.rock-pop-r+b.1950s 24
71soc.culture.vietnamese 24
72soc.history.what-if 23
73soc.women 22
74nz.general 22
75comp.soft-sys.sas 21
76alt.os.linux.ubuntu 20
77comp.mobile.android 20
78sci.astro.amateur 20
79rec.music.classical.guitar 20
80rec.audio.opinion 19
81comp.soft-sys.matlab 19
82comp.soft-sys.math.scilab 17
83rec.arts.books.tolkien 16
84sci.space.policy 16
85news.groups.questions 16
86rec.radio.amateur.dx 15
87alt.bbs.mystic 15
88sci.lang 15
89soc.culture.brazil 14
90comp.sys.apple2 14
91comp.sys.ibm.ps2.hardware 14
92news.software.readers 14
93comp.lang.fortran 13
94soc.culture.romanian 13
95soc.genealogy.benelux 13
96comp.lang.python.announce 12
97soc.culture.egyptian 11
98comp.protocols.dns.bind 11
99soc.veterans 11
100sci.electronics.basics 11
TOTAL: 305 8177