news.bbs.nz daily logs

Feb 15 23:58:01 -- Feb 16 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 128409 55.9%9.9 MB 34.8%
innfeed 49916 21.7%8.0 MB 28.1%
innd 28988 12.6%4.7 MB 16.5%
inn 20816 9.1%5.6 MB 19.7%
cnfsstat 1440 0.6%256.0 KB 0.9%
controlchan 5 0.0%0.7 KB 0.0%
TOTAL: 6 229574 100.0%28.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 228258 51.1%
Negative hits 198271 44.4%
Do not exist 20092 4.5%
Cache misses 341 0.1%
TOTAL: 4 446962 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.076 0.0%43 0.000 1.767 13.000
article cleanup00:00:00.199 0.0%20586 0.000 0.010 0.042
article logging00:00:00.533 0.0%20898 0.000 0.026 0.094
article parse00:00:00.660 0.0%62864 0.000 0.010 0.032
article write00:00:01.316 0.0%16860 0.000 0.078 0.727
artlog/artcncl00:00:00.002 0.0%43 0.000 0.047 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.459 0.0%421155 0.000 0.001 0.019
hisgrep/artcncl00:00:00.001 0.0%33 0.000 0.030 0.100
hishave/artcncl00:00:00.001 0.0%43 0.000 0.023 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.102 0.0%453530 0.001 0.027 1.232
history sync00:00:00.024 0.0%377 0.000 0.064 1.000
history write00:00:08.929 0.0%20437 0.012 0.437 18.201
hiswrite/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
idle23:58:07.275 99.8%435412 116.346 198.174 661.345
nntp read00:00:03.251 0.0%434912 0.002 0.007 0.051
overview write00:00:45.569 0.1%16860 0.108 2.703 81.801
perl filter00:00:43.402 0.1%20418 1.428 2.126 6.381
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.948 0.0%33721 0.003 0.028 0.108
TOTAL: 24:00:58.38424:00:04.747 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.175 0.0%139696 0.000 0.001 0.014
article prepare00:00:00.001 0.0%8832 0.000 0.000 0.018
article read00:00:00.639 0.0%1927 0.000 0.332 2.571
backlog stats00:00:00.422 0.0%371245 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.811 0.0%288220 0.003 0.006 0.013
data write00:00:04.461 0.0%273946 0.005 0.016 0.057
idle23:52:08.979 99.8%371245 23.911 231.462 518.133
status file00:01:46.915 0.1%10880 1.105 9.827 604.505
TOTAL: 23:54:25.67023:54:03.403100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%2 0.500 0.500 0.500
idle01:04:38.205 80.7%135574 0.000 28.606 75296.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:30.397 1.9%285715 0.000 0.316 13.959
readart00:00:02.475 0.1%7488 0.000 0.331 24.250
TOTAL: 01:20:05.86801:06:11.078 82.6%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 8 33420 3811 29311 298 11%47:41:28
2bbsnz-out.feed.uzoreto.com 865 26985 2755 22327 1903 10%71:07:34
3news.snarked.org 36 15094 2497 12440 157 16%36:36:13
4feeder.eternal-september.org 2 19606 2481 16670 455 12%24:20:58
5news.redatomik.org 3 13230 2336 10846 48 17%17:41:24
6news.albasani.net 1 18459 985 17256 218 5%24:24:35
7news.freedyn.net 4 18835 955 17389 491 5%25:08:27
8csiph.com 2 17367 338 17021 8 1%23:59:56
9news-out.aioe.org 1 1238 185 1038 15 14%01:58:29
10newsfeed.xs3.de 2 17880 177 17679 24 0%23:59:26
11news.swapon.de 9 1167 127 1034 6 10%23:16:12
12news.samoylyk.net 1 17402 58 17332 12 0%23:59:57
13i2pn.org 2 19218 44 19137 37 0%23:59:49
14nut.utcc.utoronto.ca 1 17484 0 17484 0 0%23:50:00
15news.ausics.org 1 30638 0 30637 1 0%47:38:37
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 939 268023 16749 247601 3673 6%439:43:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.6 MB336.0 KB1.5 MB20.4 MB 91%5.1 KB
2bbsnz-out.feed.uzoreto.com8.6 MB123.4 KB14.3 MB23.0 MB 37%5.1 KB
3news.snarked.org7.6 MB37.3 KB579.8 KB8.2 MB 92%3.1 KB
4feeder.eternal-september.org7.2 MB36.2 KB1.9 MB9.2 MB 78%3.2 KB
5news.redatomik.org6.6 MB38.4 KB191.5 KB6.9 MB 96%2.9 KB
6news.albasani.net3.4 MB78.6 KB478.7 KB3.9 MB 86%3.3 KB
7news.freedyn.net2.8 MB42.5 KB946.9 KB3.7 MB 74%2.6 KB
8csiph.com894.0 KB50.2 KB54.0 KB998.3 KB 89%2.9 KB
9news-out.aioe.org548.9 KB3.0 KB54.1 KB606.1 KB 90%3.0 KB
10newsfeed.xs3.de548.0 KB26.7 KB84.9 KB659.7 KB 83%3.3 KB
11i2pn.org340.1 KB54.4 KB111.8 KB506.3 KB 67%6.3 KB
12news.swapon.de321.7 KB11.4 KB12.3 KB345.4 KB 93%2.6 KB
13news.samoylyk.net184.7 KB40.9 KB40.9 KB266.5 KB 69%3.8 KB
14nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
15news.ausics.org0.0 KB2.8 KB2.8 KB5.6 KB 0%5.6 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1657.5 MB881.9 KB20.2 MB78.5 MB 73%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 15 23:58:01 - 23:59:59 21 0.1% 0.1845.8 KB 0.1% 0.39
Feb 16 00:00:00 - 00:59:59 863 5.1% 0.242.8 MB 4.7% 0.78
Feb 16 01:00:00 - 01:59:59 852 5.1% 0.242.3 MB 4.0% 0.67
Feb 16 02:00:00 - 02:59:59 858 5.1% 0.242.2 MB 3.8% 0.63
Feb 16 03:00:00 - 03:59:59 933 5.6% 0.263.5 MB 6.0% 1.00
Feb 16 04:00:00 - 04:59:59 951 5.7% 0.262.9 MB 5.0% 0.82
Feb 16 05:00:00 - 05:59:59 1049 6.2% 0.294.2 MB 7.3% 1.21
Feb 16 06:00:00 - 06:59:59 1092 6.5% 0.303.5 MB 5.9% 0.98
Feb 16 07:00:00 - 07:59:59 1037 6.2% 0.293.3 MB 5.8% 0.95
Feb 16 08:00:00 - 08:59:59 981 5.8% 0.273.5 MB 6.1% 1.00
Feb 16 09:00:00 - 09:59:59 899 5.3% 0.252.7 MB 4.7% 0.78
Feb 16 10:00:00 - 10:59:59 796 4.7% 0.222.6 MB 4.5% 0.74
Feb 16 11:00:00 - 11:59:59 820 4.9% 0.232.3 MB 4.0% 0.66
Feb 16 12:00:00 - 12:59:59 644 3.8% 0.182.2 MB 3.9% 0.64
Feb 16 13:00:00 - 13:59:59 545 3.2% 0.151.7 MB 2.9% 0.47
Feb 16 14:00:00 - 14:59:59 421 2.5% 0.121.4 MB 2.4% 0.40
Feb 16 15:00:00 - 15:59:59 398 2.4% 0.112.6 MB 4.5% 0.74
Feb 16 16:00:00 - 16:59:59 394 2.3% 0.111.5 MB 2.5% 0.42
Feb 16 17:00:00 - 17:59:59 380 2.3% 0.112.2 MB 3.8% 0.63
Feb 16 18:00:00 - 18:59:59 306 1.8% 0.092.1 MB 3.6% 0.60
Feb 16 19:00:00 - 19:59:59 316 1.9% 0.091.0 MB 1.8% 0.29
Feb 16 20:00:00 - 20:59:59 499 3.0% 0.141.9 MB 3.4% 0.55
Feb 16 21:00:00 - 21:59:59 518 3.1% 0.141.5 MB 2.7% 0.44
Feb 16 22:00:00 - 22:59:59 552 3.3% 0.151.5 MB 2.7% 0.44
Feb 16 23:00:00 - 23:58:02 684 4.1% 0.202.3 MB 4.0% 0.68
TOTAL: 24:00:01 16809 100.0% 0.1958.0 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB31.8 GB 63.6% 0 0.30 2054.62
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB36.4 GB 72.9% 0 0.33 1855.96
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB378.5 MB 0.7% 0 0.0227659.43
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 GB34.0 GB 68.0% 0 0.52 1177.07
TOTAL: 10-500.0 GB102.7 GB 20.5% 1 0.37-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1bbsnz-out.feed.uzoreto.com 1900 19 0 12 0 0 0 0 1869
2news.freedyn.net 523 8 0 11 0 0 0 0 504
3feeder.eternal-september.org 442 0 0 12 0 0 0 0 430
4bbs-nz-out.news.weretis.net 349 110 0 27 0 0 0 0 212
5news.albasani.net 302 0 0 15 0 0 0 0 287
6news.redatomik.org 165 0 0 11 0 0 0 0 154
7news.snarked.org 151 2 0 12 0 0 0 0 137
8news.swapon.de 41 0 0 5 0 0 0 0 36
9i2pn.org 32 12 0 7 0 0 0 0 13
10newsfeed.xs3.de 24 0 0 8 0 0 0 0 16
11news-out.aioe.org 16 3 0 1 0 0 0 0 12
12news.samoylyk.net 11 0 0 11 0 0 0 0 0
13csiph.com 7 0 0 7 0 0 0 0 0
14news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 14 3964 154 0 140 0 0 0 0 3670

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 34
mozilla.support.seamonkey 20
alt.music.pink-floyd.publius 17
gmane.linux.kernel 15
gmane.comp.sysutils.ddrescue 10
mozilla.dev.platform 7
mozilla.dev.security.policy 7
rocksolid.shared.test 7
rocksolid.shared.i2p 5
mozilla.dev.ui-alerts 4
rocksolid.shared.tor 3
mozilla.dev.super-review 2
al.christnet.bible 2
mozilla.support.bugzilla 2
gmane.linux.ports.ppc.embedded 2
gmane.comp.audio.pulseaudio.general 1
testtest.com 1
gmane.comp.handhelds.openmoko.community 1
alt.penthouse.sex.femdom 1
soc.culture.india 1
TOTAL: 32 154

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2907
EMP (phn path) 163
Too many newsgroups 112
EMP (phn nph) 87
Too many newsgroups (low_xpost) 28
User-issued spam cancel 19
User-issued cancel 13
EMP (phl) 3
Too many newsgroups (meow) 3
Binary: non-binary distribution 3
TOTAL: 10 3338

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
bbsnz-out.feed.uzoreto.com 7
TOTAL: 1 7
Including strange strings
news.redatomik.org 113
news.albasani.net 104
bbs-nz-out.news.weretis.net 49
news.swapon.de 35
bbsnz-out.feed.uzoreto.com 11
newsfeed.xs3.de 1
TOTAL: 6 313
TOTAL: 2 320

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15536 617 14902 17 0 0 3%23:59:48
2utnut 16809 388 16188 233 0 0 2%23:59:47
3newsfeed.xs3.de 16681 62 16555 15 0 208 0%23:59:48
4awxg 16329 46 16278 1 0 0 0%23:59:43
5news.snarked.org 14350 6 14211 2 0 66 0%23:59:48
6news.samoylyk.net 15505 1 15484 0 0 31 0%23:59:48
7news.redatomik.org 14286 1 14281 0 0 3 0%23:59:48
8eternal-september 14041 1 14025 0 0 0 0%23:59:48
9i2pn.org 16788 1 16775 0 0 0 0%23:59:48
10csiph.com 16528 1 16487 0 0 0 0%23:59:30
11news.freedyn.net 15828 1 15821 0 0 0 0%23:59:48
12news.uzoreto.com 13626 0 13625 1 0 0 0%23:59:43
13news-in.mixmin.net 2747 0 0 0 0 18974 0%23:59:48
14neva.ru 15893 0 15890 1 0 0 0%23:59:48
15mb-net.net 0 0 0 0 0 16808 0%23:59:48
16news.albasani.net 17515 0 15131 509 0 5792 0%23:59:48
17weretis.net 12610 0 12586 0 0 58 0%23:59:48
18aioe 115210 0 114389 193 16 13947 0%23:59:48
19news.swapon.de 1063 0 1061 0 0 17 0%23:19:03
TOTAL: 19 351345 1125 343689 972 16 55904 0%455:14:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org9.9 MB117.1 KB10.0 MB0.1 KB/s16.1 KB23:59:48
2utnut8.9 MB945.5 KB9.8 MB0.1 KB/s16.2 KB23:59:47
3newsfeed.xs3.de1.6 MB918.2 KB2.5 MB0.0 KB/s33.6 KB23:59:48
4awxg226.9 KB3.7 KB230.7 KB0.0 KB/s4.9 KB23:59:43
5news.snarked.org15.9 KB3.7 KB19.6 KB0.0 KB/s2.4 KB23:59:48
6news.samoylyk.net3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:48
7news.redatomik.org3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:48
8eternal-september3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:48
9i2pn.org3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:48
10csiph.com3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:30
11news.freedyn.net3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:48
12news.uzoreto.com0.0 KB3.4 KB3.4 KB0.0 KB/s3.4 KB23:59:43
13news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
14neva.ru0.0 KB3.4 KB3.4 KB0.0 KB/s3.4 KB23:59:48
15mb-net.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
16news.albasani.net0.0 KB2.0 MB2.0 MB0.0 KB/s4.0 KB23:59:48
17weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
18aioe0.0 KB752.6 KB752.6 KB0.0 KB/s3.9 KB23:59:48
19news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:19:03
TOTAL: 1920.7 MB4.7 MB25.4 MB0.0 KB/s12.4 KB455:14:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 384 542020.6 MB 3039 0 000:14:11
2vorlon.activateit.net.au 24 10201.6 MB 119 0 000:05:06
3amigacity.xyz 71 2606.2 MB 104 0 000:33:05
4121.99.184.11 4 830.9 KB 1 0 000:15:15
TOTAL: 4 483 670828.3 MB 3263 0 001:19:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 384 542020.6 MB 3039 0 000:14:11
2*.activateit.net.au 24 10201.6 MB 119 0 000:05:06
3*.xyz 71 2606.2 MB 104 0 000:33:05
4unresolved 16 830.9 KB 1 0 000:27:31
5*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 5 496 670828.3 MB 3263 0 001:19:58

NNRP auth users [Top 20]:

UserConn
amigacity 71
amybbs 24
crash 3
TOTAL: 3 98

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
amigacity.xyz 3.844 1.004 0.32600:33:05
121.99.184.11 0.252 0.052 0.00900:15:15
agency.bbs.nz 27.292 6.512 0.00000:14:11
118.149.221.103 0.700 0.112 0.00000:12:15
vorlon.activateit.net.au 1.376 0.368 0.08300:05:06
? 1.424 0.132 0.00000:00:01
scan-141.security.ipip.net 0.052 0.004 0.00000:00:00
TOTAL: 7 34.940 8.184 0.41801:19:58

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.221.103 12
scan-141.security.ipip.net 1
TOTAL: 2 13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
121.99.184.11 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
XFEATURE COMPRESS GZIP TERMINATOR 1
Host: 219.89.83.33:119 1
TOTAL: 5 5

Newsgroup request counts (by category):

CategoryCountPct
1rec 2926 43.6%
2sci 701 10.5%
3soc 651 9.7%
4comp 536 8.0%
5linux 497 7.4%
6uk 467 7.0%
7talk 367 5.5%
8alt 308 4.6%
9misc 132 2.0%
10news 48 0.7%
11aus 15 0.2%
12nz 14 0.2%
13mozilla 14 0.2%
14microsoft 13 0.2%
15humanities 11 0.2%
16agency 6 0.1%
TOTAL: 16 6706100.0%

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

NewsgroupCount
1rec.arts.tv 778
2talk.politics.guns 336
3rec.arts.sf.written 257
4rec.arts.drwho 246
5rec.games.miniatures.misc 213
6uk.d-i-y 200
7rec.sport.pro-wrestling 180
8sci.electronics.design 175
9rec.food.cooking 165
10linux.debian.bugs.dist 154
11soc.culture.polish 146
12soc.retirement 130
13comp.lang.c 119
14rec.sport.tennis 110
15soc.culture.israel 110
16linux.debian.changes.devel 109
17alt.politics.trump 109
18rec.gambling.poker 104
19sci.physics 102
20rec.sport.football.college 100
21uk.legal 94
22alt.comp.os.windows-10 91
23uk.legal.moderated 80
24misc.survivalism 80
25rec.boats 76
26rec.bicycles.tech 72
27rec.sport.golf 67
28sci.math 66
29rec.music.rock-pop-r+b.1950s 65
30linux.debian.user 62
31comp.lang.python 61
32sci.physics.relativity 61
33sci.military.naval 60
34linux.debian.bugs.rc 53
35soc.culture.china 48
36comp.os.linux.advocacy 48
37rec.music.classical.recordings 44
38comp.lang.c++ 40
39rec.arts.poems 39
40sci.electronics.repair 39
41sci.bio.paleontology 39
42alt.conspiracy.jfk 38
43sci.astro.amateur 38
44comp.sys.mac.system 36
45news.lists.filters 33
46soc.penpals 33
47rec.audio.opinion 30
48soc.culture.usa 30
49sci.logic 26
50linux.debian.devel.release 26
51rec.music.dylan 26
52comp.lang.forth 24
53alt.test 23
54talk.politics.misc 22
55sci.med.cardiology 22
56rec.arts.tv.soaps.cbs 21
57alt.bbs.synchronet 20
58uk.tech.digital-tv 20
59soc.culture.indian 20
60rec.photo.digital 19
61rec.aviation.military.naval 18
62linux.debian.l10n.german 18
63rec.games.backgammon 18
64soc.culture.greek 18
65uk.tech.broadcast 18
66comp.mobile.android 17
67uk.radio.amateur 17
68uk.rec.cycling 15
69nz.general 14
70comp.sys.ibm.pc.games.action 14
71rec.games.pinball 14
72linux.debian.user.italian 14
73uk.comp.sys.mac 13
74comp.arch 13
75comp.os.cpm 13
76rec.arts.animation 12
77alt.conspiracy 12
78comp.lang.fortran 12
79mozilla.support.firefox 12
80rec.woodworking 12
81rec.arts.movies.current-films 11
82comp.lang.clipper.visual-objects 11
83misc.invest.stocks 11
84linux.debian.user.german 10
85rec.sport.soccer 10
86humanities.lit.authors.shakespeare 10
87rec.radio.amateur.misc 10
88sci.archaeology 10
89rec.radio.amateur.dx 10
90soc.history.medieval 10
91linux.debian.devel.mentors 10
92linux.debian.maint.ocaml.maint 9
93rec.music.gdead 9
94comp.lang.asm.x86 9
95comp.lang.prolog 9
96misc.phone.mobile.iphone 9
97comp.os.linux.misc 9
98rec.radio.shortwave 9
99sci.lang 9
100sci.anthropology.paleo 9
TOTAL: 316 6706