news.bbs.nz daily logs

Apr 14 23:58:02 -- Apr 15 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 128996 57.7%10.0 MB 37.3%
innfeed 43502 19.4%7.1 MB 26.2%
innd 30085 13.4%4.8 MB 18.0%
inn 19718 8.8%4.8 MB 17.7%
cnfsstat 1440 0.6%253.8 KB 0.9%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 223742 100.0%27.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 225460 44.8%
Negative hits 218782 43.5%
Cache misses 40176 8.0%
Do not exist 19039 3.8%
TOTAL: 4 503457 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.230 0.0%84 0.000 2.738 28.000
article cleanup00:00:00.211 0.0%19218 0.000 0.011 0.046
article logging00:00:00.568 0.0%19488 0.000 0.029 0.294
article parse00:00:00.912 0.0%116954 0.000 0.008 0.024
article write00:00:01.712 0.0%15272 0.014 0.112 5.817
artlog/artcncl00:00:00.000 0.0%69 0.000 0.000 0.000
data move00:00:00.387 0.0%483578 0.000 0.001 0.008
hisgrep/artcncl00:00:00.001 0.0%79 0.000 0.013 0.250
hishave/artcncl00:00:00.000 0.0%84 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.680 0.0%505909 0.000 0.017 0.992
history sync00:00:00.026 0.0%366 0.000 0.071 0.500
history write00:00:05.215 0.0%19149 0.012 0.272 15.051
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:48:01.543 99.8%487520 79.211 175.750 486.802
nntp read00:00:04.348 0.0%489738 0.003 0.009 0.018
overview write00:00:39.324 0.0%15272 0.065 2.575 74.071
perl filter00:00:36.052 0.0%19143 0.922 1.883 14.208
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.839 0.0%30544 0.000 0.027 0.114
TOTAL: 23:50:54.35623:49:40.048 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.086 0.0%50873 0.000 0.002 0.031
article prepare00:00:00.000 0.0%4594 0.000 0.000 0.000
article read00:00:00.093 0.0%886 0.000 0.105 6.500
backlog stats00:00:00.568 0.0%293055 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.400 0.0%230864 0.003 0.010 0.019
data write00:00:06.340 0.0%218032 0.009 0.029 0.072
idle23:52:40.494 99.9%293055 77.306 293.325 749.402
status file00:01:11.725 0.1%8663 0.919 8.279 420.759
TOTAL: 23:54:18.22523:54:01.706100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%10 0.000 0.100 0.167
idle35:08:05.725 99.7%135656 0.000 932.401 95435.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:17.970 0.1%283383 0.000 0.275 6.442
readart00:00:01.763 0.0%5676 0.000 0.311 60.250
TOTAL: 35:15:08.54935:09:25.459 99.7%----

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.freedyn.net 3 18856 3469 13251 2136 18%23:50:10
2news.snarked.org 35 12979 2548 10339 92 19%32:23:53
3bbs-nz-out.news.weretis.net 4 33438 2423 30924 91 7%51:33:07
4feeder.eternal-september.org 3 18093 1944 16016 133 10%25:23:00
5bbsnz-out.feed.uzoreto.com 866 49988 1504 47893 591 3%71:27:19
6i2pn.org 2 12216 1362 10779 75 11%18:05:07
7newsfeed.neva.ru 146 8269 845 6682 742 10%71:41:19
8news-out.aioe.org 2 19159 622 18496 41 3%32:20:03
9csiph.com 1 14030 174 13854 2 1%23:26:29
10news.swapon.de 5 1575 171 1404 0 10%22:48:16
11newsfeed.xs3.de 2 14681 163 14497 21 1%23:59:25
12paganini.bofh.team 2 15895 89 15786 20 0%23:59:30
13localhost 9 8 8 0 0 100%00:00:00
14news.samoylyk.net 3 28991 2 28989 0 0%00:31:00
15nut.utcc.utoronto.ca 1 14396 0 14396 0 0%23:49:59
TOTAL: 15 1084 262574 15324 243306 3944 5%445:18:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org9.1 MB494.3 KB912.7 KB10.5 MB 86%5.2 KB
2news.freedyn.net8.9 MB516.8 KB104.5 MB114.0 MB 7%20.8 KB
3bbs-nz-out.news.weretis.net8.1 MB1.5 MB1.9 MB11.6 MB 70%4.7 KB
4news.snarked.org7.8 MB14.9 KB411.5 KB8.2 MB 94%3.2 KB
5i2pn.org4.1 MB498.3 KB642.1 KB5.2 MB 78%3.7 KB
6bbsnz-out.feed.uzoreto.com4.0 MB2.8 KB12.0 MB16.0 MB 25%7.8 KB
7newsfeed.neva.ru2.4 MB36.5 KB2.8 MB5.3 MB 46%3.4 KB
8news-out.aioe.org1.8 MB52.4 KB287.2 KB2.2 MB 84%3.4 KB
9newsfeed.xs3.de757.1 KB1003.0 KB1023.4 KB2.7 MB 27%15.1 KB
10csiph.com455.5 KB33.5 KB34.6 KB523.6 KB 86%3.0 KB
11news.swapon.de386.9 KB0.0 KB0.0 KB386.9 KB100%2.3 KB
12paganini.bofh.team193.8 KB505.0 KB1.1 MB1.7 MB 10%16.3 KB
13localhost15.4 KB0.0 KB0.0 KB15.4 KB100%1.9 KB
14news.samoylyk.net4.3 KB0.0 KB0.0 KB4.3 KB100%2.2 KB
15nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1548.1 MB4.6 MB125.5 MB178.3 MB 26%9.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 14 23:58:02 - 23:59:59 21 0.1% 0.1837.0 KB 0.1% 0.31
Apr 15 00:00:00 - 00:59:59 714 4.6% 0.201.7 MB 3.5% 0.48
Apr 15 01:00:00 - 01:59:59 707 4.6% 0.201.7 MB 3.6% 0.50
Apr 15 02:00:00 - 02:59:59 708 4.6% 0.202.0 MB 4.2% 0.57
Apr 15 03:00:00 - 03:59:59 834 5.4% 0.232.2 MB 4.7% 0.64
Apr 15 04:00:00 - 04:59:59 843 5.5% 0.232.1 MB 4.4% 0.61
Apr 15 05:00:00 - 05:59:59 780 5.1% 0.221.9 MB 4.0% 0.55
Apr 15 06:00:00 - 06:59:59 854 5.5% 0.244.6 MB 9.6% 1.32
Apr 15 07:00:00 - 07:59:59 785 5.1% 0.224.2 MB 8.8% 1.20
Apr 15 08:00:00 - 08:59:59 801 5.2% 0.222.6 MB 5.4% 0.74
Apr 15 09:00:00 - 09:59:59 648 4.2% 0.181.9 MB 4.0% 0.54
Apr 15 10:00:00 - 10:59:59 573 3.7% 0.161.7 MB 3.5% 0.48
Apr 15 11:00:00 - 11:59:59 466 3.0% 0.131.5 MB 3.1% 0.43
Apr 15 12:00:00 - 12:59:59 390 2.5% 0.111.5 MB 3.0% 0.41
Apr 15 13:00:00 - 13:59:59 358 2.3% 0.101.3 MB 2.7% 0.37
Apr 15 14:00:00 - 14:59:59 306 2.0% 0.091.0 MB 2.1% 0.29
Apr 15 15:00:00 - 15:59:59 277 1.8% 0.08883.6 KB 1.8% 0.25
Apr 15 16:00:00 - 16:59:59 325 2.1% 0.09960.4 KB 2.0% 0.27
Apr 15 17:00:00 - 17:59:59 471 3.1% 0.131.3 MB 2.8% 0.38
Apr 15 18:00:00 - 18:59:59 586 3.8% 0.161.6 MB 3.4% 0.47
Apr 15 19:00:00 - 19:59:59 725 4.7% 0.202.1 MB 4.4% 0.61
Apr 15 20:00:00 - 20:59:59 749 4.9% 0.212.0 MB 4.2% 0.58
Apr 15 21:00:00 - 21:59:59 732 4.8% 0.202.0 MB 4.1% 0.56
Apr 15 22:00:00 - 22:59:59 870 5.6% 0.242.5 MB 5.2% 0.72
Apr 15 23:00:00 - 23:58:02 885 5.7% 0.252.5 MB 5.3% 0.74
TOTAL: 24:00:00 15408 100.0% 0.1848.1 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB33.1 GB 66.2% 0 0.27 2230.77
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB37.8 GB 75.6% 0 0.22 2774.43
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB390.5 MB 0.8% 0 0.0321335.11
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 GB36.5 GB 73.0% 0 0.53 1154.72
TOTAL: 10-500.0 GB107.8 GB 21.6% 1 0.33-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.freedyn.net 2186 24 0 11 0 0 0 0 2151
2newsfeed.neva.ru 744 11 0 2 0 0 0 0 731
3bbsnz-out.feed.uzoreto.com 595 5 0 1 0 0 0 0 589
4bbs-nz-out.news.weretis.net 248 34 0 15 0 0 0 0 199
5feeder.eternal-september.org 128 0 0 3 0 0 0 0 125
6news.snarked.org 98 5 0 4 0 0 0 0 89
7i2pn.org 85 7 0 9 0 0 0 0 69
8news.swapon.de 67 0 0 0 0 0 0 0 67
9news-out.aioe.org 51 17 0 9 0 0 0 0 25
10newsfeed.xs3.de 19 0 0 9 0 0 0 0 10
11paganini.bofh.team 17 6 0 4 0 0 0 0 7
12csiph.com 3 0 0 2 0 0 0 0 1
TOTAL: 12 4241 109 0 69 0 0 0 0 4063

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 40
gmane.linux.alsa.devel 10
gmane.linux.kernel 10
al.christnet.bible 5
mozilla.support.seamonkey 5
de.alt.dateien.misc 4
gmane.linux.ports.arm.kernel 3
mozilla.dev.platform 3
gmane.comp.gis.openstreetmap.imports 2
rocksolid.shared.entertainment 2
mozilla.dev.tech.js-engine.internals 2
gmane.comp.video.dri.devel 2
alt.paranormal.spells 2
mozilla.dev.ui-alerts 2
alt.religion.christian.romman-catholic 1
rocksolid.shared.i2p 1
mozilla.dev.quality 1
alt.sex.girl.watc 1
alt.politics.conservative 1
mozilla.dev.security.policy 1
TOTAL: 31 109

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2747
Binary: misplaced rar 770
EMP (phl) 81
EMP (phn path) 77
Too many newsgroups 41
Binary Image: misplaced jpg 19
Binary: non-binary distribution 16
User-issued cancel 12
User-issued spam cancel 9
Too many newsgroups (low_xpost) 4
Binary: misplaced par2 2
Too many newsgroups (meow) 2
Binary: misplaced cst 1
Binary: misplaced bak 1
Binary: misplaced JPG 1
Binary: misplaced jbu 1
Binary: misplaced xml 1
TOTAL: 17 3785

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 1
TOTAL: 1 1
Including strange strings
bbs-nz-out.news.weretis.net 163
news.swapon.de 67
news.freedyn.net 15
news-out.aioe.org 12
feeder.eternal-september.org 5
bbsnz-out.feed.uzoreto.com 5
i2pn.org 3
newsfeed.neva.ru 1
TOTAL: 8 271
TOTAL: 2 272

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14217 468 13720 29 0 0 3%23:59:51
2utnut 15400 357 14894 149 0 0 2%23:59:49
3awxg 15101 39 15046 3 0 0 0%23:59:50
4news.snarked.org 12675 10 12592 1 0 57 0%23:59:51
5i2pn.org 14011 9 13997 0 0 0 0%23:59:51
6news.freedyn.net 11765 9 11744 0 0 0 0%23:59:49
7eternal-september 13284 9 13267 0 0 0 0%23:59:51
8neva.ru 14289 9 14278 0 0 0 0%23:59:51
9csiph.com 15281 9 15210 0 0 0 0%23:59:51
10aioe 13065 8 12995 0 0 0 0%23:59:27
11weretis.net 11396 8 11367 0 0 61 0%23:59:51
12paganini.bofh.team 15293 8 15265 0 0 47 0%23:59:50
13newsfeed.xs3.de 15267 7 15212 0 0 178 0%23:59:51
14news.uzoreto.com 13863 5 13835 3 0 82 0%23:59:51
15news.samoylyk.net 35366 1 35360 0 1 11170 0%23:57:46
16news.swapon.de 1638 1 1612 0 0 29 0%23:45:00
17news.albasani.net 2758 0 0 0 0 2758 0%23:59:51
TOTAL: 17 234669 957 230394 185 1 14382 0%407:40:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1utnut2.3 MB477.1 KB2.8 MB0.0 KB/s5.7 KB23:59:49
2news.ausics.org1.9 MB199.5 KB2.1 MB0.0 KB/s4.2 KB23:59:51
3awxg172.6 KB34.9 KB207.6 KB0.0 KB/s4.9 KB23:59:50
4news.snarked.org148.4 KB3.0 KB151.4 KB0.0 KB/s13.8 KB23:59:51
5i2pn.org17.2 KB0.0 KB17.2 KB0.0 KB/s1.9 KB23:59:51
6news.freedyn.net17.2 KB0.0 KB17.2 KB0.0 KB/s1.9 KB23:59:49
7eternal-september17.2 KB0.0 KB17.2 KB0.0 KB/s1.9 KB23:59:51
8neva.ru17.2 KB0.0 KB17.2 KB0.0 KB/s1.9 KB23:59:51
9csiph.com17.2 KB0.0 KB17.2 KB0.0 KB/s1.9 KB23:59:51
10weretis.net15.5 KB0.0 KB15.5 KB0.0 KB/s1.9 KB23:59:51
11aioe15.4 KB0.0 KB15.4 KB0.0 KB/s1.9 KB23:59:27
12paganini.bofh.team15.4 KB0.0 KB15.4 KB0.0 KB/s1.9 KB23:59:50
13newsfeed.xs3.de12.8 KB0.0 KB12.8 KB0.0 KB/s1.8 KB23:59:51
14news.uzoreto.com9.1 KB6.4 KB15.5 KB0.0 KB/s1.9 KB23:59:51
15news.swapon.de2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:45:00
16news.samoylyk.net1.5 KB0.0 KB1.5 KB0.0 KB/s1.5 KB23:57:46
17news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 174.7 MB720.9 KB5.4 MB0.0 KB/s4.8 KB407:40:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 391 446819.4 MB 2896 7 000:15:41
2vorlon.activateit.net.au 24 7341013.0 KB 104 0 000:04:24
3amigacity.xyz 71 3486.3 MB 109 0 000:31:43
4121.99.184.11 9 21166.1 KB 2 1 000:26:21
TOTAL: 4 495 557126.8 MB 3111 8 035:15:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 391 446819.4 MB 2896 7 000:15:41
2*.activateit.net.au 24 7341013.0 KB 104 0 000:04:24
3*.xyz 71 3486.3 MB 109 0 000:31:43
4unresolved 14 21166.1 KB 2 1 000:30:21
5*.sfj.corp.censys.io 1 00.0 KB 0 0 000:00:00
6*.cpe.cableone.net 1 00.0 KB 0 0 033:52:47
TOTAL: 6 502 557126.8 MB 3111 8 035:15:01

NNRP auth users [Top 20]:

UserConn
amigacity 71
amybbs 24
crash 8
malcolmlewis 1
TOTAL: 4 104

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-233-17.cpe.cableone.net 0.160 0.068 0.00333:52:47
amigacity.xyz 4.220 1.056 0.26900:31:43
121.99.184.11 0.628 0.080 0.02200:26:21
agency.bbs.nz 29.084 6.804 0.00000:15:41
vorlon.activateit.net.au 1.536 0.336 0.06600:04:24
118.149.143.191 0.272 0.024 0.00000:03:59
? 1.248 0.172 0.00000:00:01
worker-18.sfj.corp.censys.io 0.064 0.004 0.00000:00:00
141.98.80.42 0.064 0.004 0.00000:00:00
TOTAL: 9 37.276 8.548 0.36035:15:01

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.143.191 4
160-3-233-17.cpe.cableone.net 1
141.98.80.42 1
worker-18.sfj.corp.censys.io 1
TOTAL: 4 7

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
121.99.184.11 2
141.98.80.42 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
#003 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.corp.censys.io 1 1
141.98.80.42 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 2263 40.7%
2soc 591 10.6%
3sci 553 9.9%
4linux 486 8.7%
5uk 456 8.2%
6comp 446 8.0%
7alt 350 6.3%
8talk 153 2.8%
9misc 118 2.1%
10news 56 1.0%
11mozilla 48 0.9%
12nz 13 0.2%
13agency 11 0.2%
14microsoft 11 0.2%
15humanities 3 0.1%
16aus 3 0.1%
TOTAL: 16 5561100.0%

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

NewsgroupCount
1rec.arts.tv 551
2rec.games.miniatures.misc 284
3rec.arts.drwho 263
4alt.comp.os.windows-10 237
5rec.food.cooking 188
6linux.debian.bugs.dist 174
7uk.d-i-y 166
8sci.electronics.design 153
9comp.os.linux.advocacy 120
10rec.arts.sf.written 108
11soc.culture.polish 105
12rec.sport.football.college 92
13soc.retirement 91
14linux.debian.devel.release 80
15sci.physics 79
16soc.culture.china 78
17sci.math 74
18talk.origins 70
19rec.sport.tennis 69
20uk.legal.moderated 68
21uk.legal 68
22uk.radio.amateur 60
23sci.physics.relativity 55
24comp.lang.forth 52
25linux.debian.changes.devel 51
26soc.culture.israel 50
27news.lists.filters 50
28rec.sport.golf 49
29rec.gambling.poker 47
30linux.debian.bugs.rc 44
31rec.music.rock-pop-r+b.1950s 43
32talk.politics.guns 43
33rec.sport.soccer 40
34rec.boats 36
35comp.os.linux.misc 36
36soc.penpals 35
37linux.debian.user 35
38alt.bbs.synchronet 35
39sci.logic 35
40rec.photo.digital 33
41uk.tech.digital-tv 33
42sci.lang 30
43rec.audio.opinion 29
44rec.sport.pro-wrestling 29
45uk.comp.sys.mac 28
46rec.outdoors.rv-travel 28
47sci.med.cardiology 27
48mozilla.general 27
49rec.bicycles.tech 27
50misc.survivalism 26
51comp.lang.tcl 25
52misc.invest.stocks 25
53comp.lang.c++ 24
54talk.politics.misc 23
55rec.music.dylan 23
56sci.anthropology.paleo 21
57alt.politics.trump 19
58soc.history.war.misc 19
59comp.lang.c 18
60misc.news.internet.discuss 17
61soc.culture.filipino 17
62rec.crafts.metalworking 17
63rec.autos.sport.f1 17
64mozilla.support.thunderbird 16
65alt.conspiracy.jfk 16
66rec.games.pinball 16
67sci.electronics.repair 16
68rec.arts.sf.tv 15
69sci.electronics.basics 15
70alt.test 15
71alt.conspiracy 14
72comp.lang.python 14
73soc.culture.british 14
74misc.invest.misc 14
75soc.genealogy.britain 14
76comp.os.msdos.misc 14
77soc.culture.indian 14
78rec.music.classical.recordings 14
79rec.radio.amateur.misc 13
80sci.astro.amateur 13
81rec.nude 13
82rec.skiing.alpine 13
83nz.general 13
84rec.arts.comics.strips 12
85rec.games.trivia 12
86linux.debian.devel 12
87misc.phone.mobile.iphone 11
88linux.debian.ports.powerpc 11
89sci.med.pharmacy 11
90soc.culture.usa 11
91agency.test 11
92sci.military.naval 11
93rec.aviation.soaring 10
94comp.os.vms 10
95alt.os.linux.ubuntu 10
96linux.debian.user.french 10
97rec.games.corewar 10
98soc.history 10
99comp.sys.mac.system 10
100uk.rec.cycling 9
TOTAL: 311 5561