news.bbs.nz daily logs

Feb 12 23:58:01 -- Feb 13 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 128646 55.2%10.0 MB 34.2%
innfeed 49790 21.4%7.9 MB 27.2%
innd 29885 12.8%4.9 MB 16.8%
inn 23262 10.0%6.1 MB 20.9%
cnfsstat 1440 0.6%254.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 233024 100.0%29.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 247595 51.1%
Negative hits 214489 44.2%
Do not exist 22489 4.6%
Cache misses 412 0.1%
TOTAL: 4 484985 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.144 0.0%82 0.000 1.756 14.500
article cleanup00:00:00.220 0.0%22809 0.000 0.010 0.055
article logging00:00:00.603 0.0%23191 0.000 0.026 0.069
article parse00:00:00.793 0.0%69399 0.000 0.011 0.031
article write00:00:02.778 0.0%17773 0.017 0.156 7.401
artlog/artcncl00:00:00.001 0.0%73 0.000 0.014 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.529 0.0%448277 0.000 0.001 0.012
hisgrep/artcncl00:00:00.001 0.0%70 0.000 0.014 0.111
hishave/artcncl00:00:00.000 0.0%82 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.792 0.0%486836 0.001 0.018 0.956
history sync00:00:00.015 0.0%304 0.000 0.049 0.500
history write00:00:06.068 0.0%22548 0.007 0.269 15.491
hiswrite/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
idle23:57:18.665 99.8%464337 108.177 185.724 609.192
nntp read00:00:03.560 0.0%463877 0.002 0.008 0.029
overview write00:00:48.851 0.1%17773 0.058 2.749 99.654
perl filter00:00:47.722 0.1%22497 1.409 2.121 5.903
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.054 0.0%35546 0.004 0.030 0.106
TOTAL: 24:00:22.70923:59:19.796 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%26960 0.000 0.003 0.021
article prepare00:00:00.003 0.0%8702 0.000 0.000 0.036
article read00:00:00.167 0.0%1860 0.000 0.090 3.556
backlog stats00:00:00.388 0.0%334643 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.804 0.0%265854 0.001 0.007 0.012
data write00:00:04.566 0.0%252697 0.009 0.018 0.054
idle23:52:12.856 99.9%334643 157.007 256.790 542.460
status file00:01:19.261 0.1%10900 1.092 7.272 447.093
TOTAL: 23:53:58.76823:53:39.120100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:03:56.012 86.6%136144 0.000 28.176 44777.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:45.417 2.4%288188 0.000 0.366 22.195
readart00:00:01.330 0.0%7637 0.000 0.174 14.000
TOTAL: 01:13:51.02501:05:42.759 89.0%----

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
1bbs-nz-out.news.weretis.net 8 36923 3390 33106 427 9%49:07:17
2bbsnz-out.feed.uzoreto.com 863 30356 3290 24599 2467 10%71:20:29
3news.snarked.org 37 17040 3148 13627 265 18%35:07:17
4feeder.eternal-september.org 8 21826 2535 18785 506 11%26:19:18
5news.redatomik.org 4 17797 2077 15657 63 11%24:53:38
6news.albasani.net 1 19606 1959 16834 813 9%24:05:46
7news.freedyn.net 5 24505 731 23365 409 2%32:07:47
8csiph.com 1 17410 360 17034 16 2%23:59:55
9newsfeed.xs3.de 3 22005 263 21700 42 1%30:19:49
10news.swapon.de 7 1179 140 1037 2 11%22:53:24
11news.samoylyk.net 2 17430 90 17325 15 0%23:59:54
12i2pn.org 1 19484 80 19372 32 0%23:59:58
13localhost 3 2 2 0 0 100%00:00:00
14nut.utcc.utoronto.ca 1 17564 0 17563 1 0%23:49:58
TOTAL: 14 944 263127 18065 240004 5058 6%412:04:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.0 MB670.6 KB3.6 MB22.3 MB 80%6.0 KB
2news.snarked.org10.4 MB87.2 KB1.1 MB11.5 MB 89%3.5 KB
3bbsnz-out.feed.uzoreto.com9.3 MB446.8 KB14.5 MB24.2 MB 38%4.3 KB
4news.redatomik.org7.6 MB106.2 KB306.3 KB8.0 MB 94%3.8 KB
5news.albasani.net6.8 MB188.4 KB1.5 MB8.5 MB 80%3.1 KB
6feeder.eternal-september.org6.4 MB176.9 KB2.2 MB8.8 MB 72%3.0 KB
7news.freedyn.net2.4 MB747.8 KB1.4 MB4.6 MB 52%4.2 KB
8csiph.com1018.8 KB49.0 KB56.3 KB1.1 MB 90%3.0 KB
9newsfeed.xs3.de893.8 KB104.9 KB141.3 KB1.1 MB 78%3.7 KB
10news.swapon.de370.0 KB0.0 KB9.4 KB379.4 KB 97%2.7 KB
11news.samoylyk.net353.9 KB182.8 KB186.5 KB723.1 KB 48%6.9 KB
12i2pn.org241.8 KB130.2 KB154.6 KB526.6 KB 45%4.7 KB
13localhost4.0 KB0.0 KB0.0 KB4.0 KB100%2.0 KB
14nut.utcc.utoronto.ca0.0 KB0.0 KB2.5 KB2.5 KB 0%2.5 KB
TOTAL: 1463.7 MB2.8 MB25.2 MB91.7 MB 69%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 12 23:58:01 - 23:59:59 25 0.1% 0.2193.9 KB 0.1% 0.79
Feb 13 00:00:00 - 00:59:59 865 4.9% 0.242.4 MB 3.9% 0.68
Feb 13 01:00:00 - 01:59:59 821 4.6% 0.233.2 MB 5.1% 0.90
Feb 13 02:00:00 - 02:59:59 768 4.3% 0.212.0 MB 3.3% 0.57
Feb 13 03:00:00 - 03:59:59 959 5.4% 0.273.4 MB 5.5% 0.97
Feb 13 04:00:00 - 04:59:59 897 5.0% 0.252.6 MB 4.2% 0.75
Feb 13 05:00:00 - 05:59:59 1037 5.8% 0.294.2 MB 6.8% 1.21
Feb 13 06:00:00 - 06:59:59 1030 5.8% 0.293.4 MB 5.5% 0.96
Feb 13 07:00:00 - 07:59:59 1125 6.3% 0.313.5 MB 5.6% 0.98
Feb 13 08:00:00 - 08:59:59 1060 6.0% 0.294.0 MB 6.4% 1.13
Feb 13 09:00:00 - 09:59:59 921 5.2% 0.263.0 MB 4.8% 0.85
Feb 13 10:00:00 - 10:59:59 890 5.0% 0.254.0 MB 6.4% 1.13
Feb 13 11:00:00 - 11:59:59 762 4.3% 0.212.3 MB 3.8% 0.66
Feb 13 12:00:00 - 12:59:59 702 4.0% 0.202.6 MB 4.1% 0.73
Feb 13 13:00:00 - 13:59:59 585 3.3% 0.161.6 MB 2.6% 0.45
Feb 13 14:00:00 - 14:59:59 594 3.3% 0.171.9 MB 3.1% 0.55
Feb 13 15:00:00 - 15:59:59 407 2.3% 0.112.0 MB 3.2% 0.57
Feb 13 16:00:00 - 16:59:59 371 2.1% 0.101.6 MB 2.6% 0.46
Feb 13 17:00:00 - 17:59:59 330 1.9% 0.091.4 MB 2.3% 0.40
Feb 13 18:00:00 - 18:59:59 362 2.0% 0.101.7 MB 2.8% 0.49
Feb 13 19:00:00 - 19:59:59 461 2.6% 0.131.6 MB 2.6% 0.47
Feb 13 20:00:00 - 20:59:59 513 2.9% 0.142.0 MB 3.2% 0.57
Feb 13 21:00:00 - 21:59:59 693 3.9% 0.192.0 MB 3.2% 0.56
Feb 13 22:00:00 - 22:59:59 763 4.3% 0.212.3 MB 3.8% 0.67
Feb 13 23:00:00 - 23:58:01 829 4.7% 0.243.1 MB 5.0% 0.91
TOTAL: 24:00:00 17770 100.0% 0.2161.9 MB 100.0% 0.73
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB31.8 GB 63.5% 0 0.34 1782.17
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB36.4 GB 72.7% 0 0.36 1674.41
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB378.1 MB 0.7% 0 0.0413544.97
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 GB33.9 GB 67.8% 0 0.60 1011.35
TOTAL: 10-500.0 GB102.4 GB 20.5% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1bbsnz-out.feed.uzoreto.com 2477 58 0 17 0 0 0 0 2402
2news.albasani.net 946 0 0 25 0 0 0 0 921
3bbs-nz-out.news.weretis.net 519 185 0 52 0 0 0 0 282
4feeder.eternal-september.org 493 0 0 22 0 0 0 0 471
5news.freedyn.net 373 10 0 26 0 0 0 0 337
6news.snarked.org 267 4 0 21 0 0 0 0 242
7news.redatomik.org 162 0 0 22 0 0 0 0 140
8news.swapon.de 65 0 0 3 0 0 0 0 62
9i2pn.org 47 4 0 23 0 0 0 0 20
10newsfeed.xs3.de 34 0 0 19 0 0 0 0 15
11csiph.com 16 0 0 15 0 0 0 0 1
12news.samoylyk.net 14 0 0 13 0 0 0 0 1
13news.ausics.org 3 0 0 3 0 0 0 0 0
14nut.utcc.utoronto.ca 3 0 0 0 0 0 0 0 3
TOTAL: 14 5419 261 0 261 0 0 0 0 4897

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.i2p.planet 50
gmane.linux.alsa.devel 41
gmane.linux.kernel 36
alt.music.pink-floyd.publius 21
gmane.comp.gis.openstreetmap.tagging 14
rocksolid.feeds.indymedia.barcelona 10
mozilla.dev.ui-alerts 10
mozilla.support.seamonkey 9
gmane.comp.gis.openstreetmap.imports 8
mozilla.dev.privacy 6
fido7.ru.android 6
mozilla.dev.security.policy 5
rocksolid.feeds.indymedia.argentina 4
REC.ARTS.TV 4
alt.bianries.e-book.german 3
alt.test.misc 3
rocksolid.shared.test 3
gmane.comp.hardware.netbook.arm.sunxi 3
mozilla.dev.platform 3
mozilla.compatibility 2
TOTAL: 36 261

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3900
EMP (phn path) 263
EMP (phn nph) 116
Too many newsgroups 101
EMP (phl) 30
User-issued cancel 27
User-issued spam cancel 10
Binary: non-binary distribution 8
Too many newsgroups (meow) 7
Cancel for rejected article 2
TOTAL: 10 4464

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 5
news.albasani.net 2
TOTAL: 2 7
Bad Message-ID's offered
bbsnz-out.feed.uzoreto.com 1
TOTAL: 1 1
Including strange strings
news.albasani.net 131
news.redatomik.org 102
bbs-nz-out.news.weretis.net 72
news.swapon.de 58
bbsnz-out.feed.uzoreto.com 11
i2pn.org 3
feeder.eternal-september.org 2
newsfeed.xs3.de 1
news.snarked.org 1
news.freedyn.net 1
TOTAL: 10 382
TOTAL: 3 390

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16554 633 15909 12 0 0 3%24:00:15
2utnut 17768 416 17161 191 1 0 2%23:59:28
3newsfeed.xs3.de 17582 82 17433 19 0 184 0%24:00:36
4awxg 17370 40 17311 2 0 0 0%23:59:58
5i2pn.org 17703 11 17675 1 0 0 0%23:59:17
6news.snarked.org 14664 8 14537 2 0 41 0%23:59:51
7news.redatomik.org 15422 3 15413 0 0 6 0%23:58:56
8csiph.com 17445 2 17421 0 0 11 0%23:59:57
9neva.ru 16615 2 16612 0 0 0 0%23:59:28
10news.albasani.net 17576 2 14990 614 0 5526 0%23:59:16
11news.samoylyk.net 16502 2 16466 0 0 7 0%23:59:49
12eternal-september 14963 2 14942 0 0 0 0%23:59:04
13weretis.net 13905 2 13902 0 0 0 0%23:59:45
14news.freedyn.net 17112 1 17080 0 0 117 0%23:59:43
15mb-net.net 0 0 0 0 0 17763 0%23:59:16
16aioe 608 0 0 0 0 16156 0%23:59:31
17news-in.mixmin.net 2746 0 0 0 0 19723 0%24:00:11
18news.swapon.de 1178 0 1153 0 0 35 0%23:47:26
19news.uzoreto.com 14283 0 14270 2 0 0 0%23:59:42
TOTAL: 19 249996 1206 242275 843 1 59569 0%455:41:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org11.6 MB243.2 KB11.9 MB0.1 KB/s18.8 KB24:00:15
2utnut10.0 MB911.2 KB10.9 MB0.1 KB/s18.4 KB23:59:28
3newsfeed.xs3.de2.2 MB120.5 KB2.3 MB0.0 KB/s23.5 KB24:00:36
4awxg144.9 KB8.0 KB152.9 KB0.0 KB/s3.6 KB23:59:58
5i2pn.org30.5 KB8.0 KB38.6 KB0.0 KB/s3.2 KB23:59:17
6news.snarked.org29.2 KB7.6 KB36.8 KB0.0 KB/s3.7 KB23:59:51
7news.redatomik.org5.6 KB0.0 KB5.6 KB0.0 KB/s1.9 KB23:58:56
8csiph.com4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:57
9neva.ru4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:28
10news.albasani.net4.0 KB1.4 MB1.4 MB0.0 KB/s2.3 KB23:59:16
11news.samoylyk.net4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:49
12eternal-september4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:04
13weretis.net4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:45
14news.freedyn.net1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:43
15mb-net.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:16
16aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:31
17news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:11
18news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:26
19news.uzoreto.com0.0 KB4.0 KB4.0 KB0.0 KB/s2.0 KB23:59:42
TOTAL: 1924.1 MB2.7 MB26.7 MB0.0 KB/s13.4 KB455:41:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 386 579922.4 MB 3277 2 000:16:04
2vorlon.activateit.net.au 24 9591.3 MB 133 0 000:05:18
3amigacity.xyz 71 2476.3 MB 101 0 000:34:20
4192.168.1.9 1 153668.6 KB 6 0 000:00:09
5185.220.101.0 5 412.0 KB 2 0 000:05:02
6185.220.101.34 5 48.9 KB 2 0 000:06:05
TOTAL: 6 492 716630.7 MB 3521 2 001:13:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 386 579922.4 MB 3277 2 000:16:04
2*.activateit.net.au 24 9591.3 MB 133 0 000:05:18
3*.xyz 71 2476.3 MB 101 0 000:34:20
4unresolved 18 161689.5 KB 10 0 000:17:35
TOTAL: 4 499 716630.7 MB 3521 2 001:13:20

NNRP auth users [Top 20]:

UserConn
amigacity 71
amybbs 24
paulh 1
TOTAL: 3 96

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
amigacity.xyz 3.948 0.884 0.20900:34:20
agency.bbs.nz 27.588 6.412 0.00000:16:04
118.149.141.13 0.360 0.056 0.00000:06:07
185.220.101.34 0.396 0.060 0.00000:06:05
vorlon.activateit.net.au 1.436 0.312 0.11500:05:18
185.220.101.0 0.240 0.056 0.00000:05:02
185.220.101.44 0.056 0.004 0.00200:00:22
185.220.101.31 0.044 0.016 0.00000:00:10
192.168.1.9 0.124 0.016 0.00200:00:09
? 1.280 0.200 0.00000:00:01
TOTAL: 10 35.472 8.016 0.32801:13:43

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.141.13 6
185.220.101.31 1
TOTAL: 2 7

NNRP no permission clients:

SystemConn
185.220.101.44 1
TOTAL: 1 1

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2650 37.0%
2comp 857 12.0%
3soc 751 10.5%
4sci 640 8.9%
5alt 613 8.6%
6linux 574 8.0%
7uk 521 7.3%
8talk 292 4.1%
9misc 117 1.6%
10news 86 1.2%
11nz 35 0.5%
12mozilla 20 0.3%
13microsoft 7 0.1%
14humanities 3 0.0%
TOTAL: 14 7166100.0%

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

NewsgroupCount
1rec.arts.tv 511
2alt.comp.os.windows-10 361
3talk.politics.guns 265
4rec.arts.sf.written 239
5rec.arts.drwho 238
6linux.debian.bugs.dist 217
7rec.games.miniatures.misc 213
8rec.food.cooking 207
9uk.d-i-y 194
10comp.lang.python 182
11rec.boats 150
12rec.sport.tennis 150
13sci.physics 129
14uk.legal 128
15linux.debian.changes.devel 127
16soc.culture.israel 125
17rec.sport.football.college 119
18rec.photo.digital 115
19soc.culture.polish 114
20sci.electronics.design 108
21rec.gambling.poker 106
22comp.lang.c 105
23alt.conspiracy.jfk 97
24alt.politics.trump 96
25comp.os.linux.advocacy 87
26soc.retirement 83
27uk.legal.moderated 81
28sci.math 78
29linux.debian.bugs.rc 78
30news.lists.filters 70
31comp.lang.c++ 68
32soc.culture.indian 67
33soc.penpals 66
34misc.survivalism 52
35sci.bio.paleontology 50
36sci.logic 48
37sci.physics.relativity 44
38rec.music.dylan 43
39soc.culture.china 43
40comp.os.vms 42
41linux.debian.user 42
42sci.med.cardiology 41
43rec.sport.golf 40
44comp.sys.raspberry-pi 36
45nz.general 35
46rec.bicycles.tech 35
47rec.sport.soccer 34
48uk.tech.broadcast 34
49alt.test 33
50soc.culture.brazil 31
51comp.mobile.android 30
52uk.comp.sys.mac 30
53rec.audio.opinion 29
54rec.sport.pro-wrestling 29
55rec.music.rock-pop-r+b.1950s 28
56soc.culture.greek 27
57uk.radio.amateur 26
58sci.electronics.repair 26
59comp.sys.ibm.ps2.hardware 26
60rec.aviation.soaring 25
61comp.sys.mac.system 25
62rec.outdoors.rv-travel 24
63sci.lang 21
64comp.lang.forth 21
65rec.games.trivia 20
66rec.arts.sf.tv 19
67linux.debian.kernel 19
68comp.sys.ibm.pc.games.action 19
69rec.games.backgammon 18
70soc.culture.usa 17
71rec.music.classical.recordings 17
72rec.radio.shortwave 16
73misc.invest.misc 16
74sci.electronics.basics 15
75uk.tech.digital-tv 15
76talk.politics.misc 14
77comp.arch 13
78soc.culture.netherlands 13
79soc.culture.bulgaria 13
80linux.debian.devel.release 13
81mozilla.support.thunderbird 12
82misc.phone.mobile.iphone 12
83sci.crypt 12
84soc.history.ancient 12
85sci.med.pharmacy 12
86soc.culture.german 11
87rec.gambling.lottery 11
88comp.lang.clipper.visual-objects 11
89misc.news.internet.discuss 11
90sci.research 10
91comp.sys.apple2 10
92soc.history.medieval 10
93rec.games.pinball 10
94linux.debian.maint.java 10
95soc.genealogy.benelux 9
96sci.archaeology 9
97misc.invest.stocks 9
98comp.ai.philosophy 9
99comp.sys.acorn.misc 9
100comp.protocols.dns.bind 9
TOTAL: 354 7166