news.bbs.nz daily logs

Sep 4 23:58:01 -- Sep 5 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124300 59.6%9.6 MB 36.4%
innd 33346 16.0%5.3 MB 20.2%
innfeed 26589 12.8%5.2 MB 19.6%
inn 22795 10.9%6.0 MB 22.8%
cnfsstat 1440 0.7%250.8 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 208471 100.0%26.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 282938 48.4%
Negative hits 279834 47.8%
Do not exist 22029 3.8%
Cache misses 199 0.0%
TOTAL: 4 585000 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.103 0.0%79 0.000 1.304 18.500
article cleanup00:00:00.233 0.0%22374 0.000 0.010 0.041
article logging00:00:00.546 0.0%22739 0.000 0.024 0.068
article parse00:00:00.757 0.0%72418 0.000 0.010 0.028
article write00:00:01.352 0.0%18570 0.007 0.073 0.786
artlog/artcncl00:00:00.001 0.0%79 0.000 0.013 0.111
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.436 0.0%567037 0.000 0.001 0.014
hisgrep/artcncl00:00:00.000 0.0%75 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%79 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.189 0.0%589384 0.001 0.017 0.784
history sync00:00:00.015 0.0%365 0.000 0.041 1.000
history write00:00:07.889 0.0%22210 0.015 0.355 16.045
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:57:46.331 99.8%580235 87.854 148.675 423.760
nntp read00:00:03.721 0.0%581237 0.002 0.006 0.030
overview write00:00:40.077 0.0%18570 0.056 2.158 57.742
perl filter00:00:45.352 0.1%22210 1.349 2.042 7.712
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.938 0.0%37140 0.000 0.025 0.144
TOTAL: 24:00:45.22923:59:37.940 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%27109 0.000 0.002 0.020
article prepare00:00:00.003 0.0%12516 0.000 0.000 0.050
article read00:00:00.165 0.0%2914 0.000 0.057 2.600
backlog stats00:00:00.347 0.0%333493 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.746 0.0%268164 0.002 0.007 0.010
data write00:00:03.067 0.0%256720 0.005 0.012 0.024
idle23:53:46.153 99.9%333493 167.320 257.955 725.750
status file00:00:22.891 0.0%2062 0.900 11.101 354.000
TOTAL: 23:54:33.05623:54:14.437100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle31:59:35.369 99.6%130820 0.000 880.411 88721.666
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.531 0.0%275960 0.000 0.006 0.769
readart00:00:01.078 0.0%7337 0.000 0.147 2.321
TOTAL: 32:07:54.89531:59:37.978 99.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 8 38257 4060 33869 328 10%49:21:59
2news.snarked.org 28 20808 3430 15854 1524 16%30:34:48
3bbsnz-out.feed.uzoreto.com 1087 28461 2459 25169 833 8%95:29:54
4feeder.eternal-september.org 4 20174 1997 18061 116 9%23:52:26
5news-out.aioe.org 5 18402 1972 16384 46 10%24:01:25
6news-out.mixmin.net 3 19987 1532 17948 507 7%24:35:57
7newsfeed.neva.ru 150 11845 1211 10473 161 10%74:19:45
8news.redatomik.org 2 18135 772 17294 69 4%23:58:46
9news.albasani.net 1 18214 429 17639 146 2%22:50:13
10csiph.com 2 17434 226 17199 9 1%23:59:42
11news.swapon.de 4 1416 118 1298 0 8%22:16:29
12agency-nz-out.news.mb-net.net 7 21962 75 21858 29 0%26:14:54
13news.samoylyk.net 6 17658 51 17592 15 0%22:53:08
14feeder.awxg.com 1 15620 26 15585 9 0%23:59:56
15news.freedyn.net 1 20206 3 20199 4 0%24:15:54
16localhost 3 2 2 0 0 100%00:00:00
TOTAL: 16 1312 288581 18363 266422 3796 6%512:45:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net16.8 MB231.9 KB2.7 MB19.7 MB 85%4.6 KB
2news.snarked.org11.3 MB245.6 KB16.2 MB27.8 MB 40%5.7 KB
3bbsnz-out.feed.uzoreto.com8.2 MB96.1 KB9.6 MB17.9 MB 45%5.6 KB
4feeder.eternal-september.org5.5 MB67.5 KB493.3 KB6.0 MB 90%2.9 KB
5news-out.aioe.org5.0 MB41.9 KB351.1 KB5.4 MB 92%2.7 KB
6news-out.mixmin.net4.6 MB44.3 KB1.0 MB5.7 MB 81%2.9 KB
7newsfeed.neva.ru2.9 MB15.6 KB855.3 KB3.7 MB 77%2.8 KB
8news.redatomik.org2.7 MB145.0 KB263.2 KB3.1 MB 87%3.8 KB
9news.albasani.net1.5 MB263.4 KB587.8 KB2.4 MB 64%4.2 KB
10csiph.com571.9 KB24.0 KB30.1 KB626.1 KB 91%2.7 KB
11news.swapon.de338.8 KB0.0 KB0.0 KB338.8 KB100%2.9 KB
12news.samoylyk.net186.8 KB153.8 KB287.1 KB627.7 KB 29%9.5 KB
13agency-nz-out.news.mb-net.net186.3 KB111.1 KB160.3 KB457.7 KB 40%4.4 KB
14feeder.awxg.com80.1 KB29.4 KB88.1 KB197.6 KB 40%5.6 KB
15news.freedyn.net7.6 KB202.4 KB205.9 KB415.9 KB 1%59.4 KB
16localhost2.0 KB0.0 KB0.0 KB2.0 KB100%1.0 KB
TOTAL: 1659.9 MB1.6 MB32.7 MB94.3 MB 63%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 4 23:58:01 - 23:59:59 32 0.2% 0.27127.7 KB 0.2% 1.07
Sep 5 00:00:00 - 00:59:59 924 5.0% 0.262.4 MB 4.0% 0.70
Sep 5 01:00:00 - 01:59:59 1069 5.8% 0.304.0 MB 6.5% 1.12
Sep 5 02:00:00 - 02:59:59 1025 5.5% 0.282.9 MB 4.7% 0.81
Sep 5 03:00:00 - 03:59:59 1093 5.9% 0.304.3 MB 7.0% 1.21
Sep 5 04:00:00 - 04:59:59 1100 5.9% 0.314.9 MB 8.1% 1.40
Sep 5 05:00:00 - 05:59:59 1021 5.5% 0.282.7 MB 4.4% 0.76
Sep 5 06:00:00 - 06:59:59 960 5.2% 0.274.1 MB 6.7% 1.15
Sep 5 07:00:00 - 07:59:59 916 4.9% 0.252.4 MB 4.0% 0.69
Sep 5 08:00:00 - 08:59:59 855 4.6% 0.242.8 MB 4.7% 0.81
Sep 5 09:00:00 - 09:59:59 835 4.5% 0.233.0 MB 5.0% 0.86
Sep 5 10:00:00 - 10:59:59 677 3.6% 0.192.0 MB 3.3% 0.57
Sep 5 11:00:00 - 11:59:59 519 2.8% 0.141.8 MB 2.9% 0.51
Sep 5 12:00:00 - 12:59:59 463 2.5% 0.131.7 MB 2.7% 0.47
Sep 5 13:00:00 - 13:59:59 480 2.6% 0.131.3 MB 2.2% 0.38
Sep 5 14:00:00 - 14:59:59 383 2.1% 0.111.2 MB 1.9% 0.33
Sep 5 15:00:00 - 15:59:59 322 1.7% 0.091.4 MB 2.3% 0.40
Sep 5 16:00:00 - 16:59:59 518 2.8% 0.141.8 MB 2.9% 0.50
Sep 5 17:00:00 - 17:59:59 492 2.7% 0.141.6 MB 2.6% 0.44
Sep 5 18:00:00 - 18:59:59 782 4.2% 0.222.4 MB 4.0% 0.69
Sep 5 19:00:00 - 19:59:59 746 4.0% 0.212.3 MB 3.8% 0.66
Sep 5 20:00:00 - 20:59:59 830 4.5% 0.232.3 MB 3.9% 0.67
Sep 5 21:00:00 - 21:59:59 923 5.0% 0.262.5 MB 4.1% 0.70
Sep 5 22:00:00 - 22:59:59 778 4.2% 0.222.0 MB 3.3% 0.58
Sep 5 23:00:00 - 23:58:01 814 4.4% 0.233.0 MB 4.9% 0.87
TOTAL: 24:00:00 18557 100.0% 0.2160.7 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.2 GB 56.5% 0 0.27 2263.62
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.5 GB 65.1% 0 0.34 1789.77
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB359.7 MB 0.7% 0 0.0227826.09
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 GB26.5 GB 53.0% 0 0.62 985.11
TOTAL: 10-500.0 GB87.7 GB 17.5% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1554 2 0 13 0 0 0 0 1539
2bbsnz-out.feed.uzoreto.com 836 38 0 5 0 0 0 0 793
3news-out.mixmin.net 613 0 0 11 0 0 0 0 602
4bbs-nz-out.news.weretis.net 426 56 0 42 0 0 0 0 328
5news.albasani.net 198 0 0 13 0 0 0 0 185
6newsfeed.neva.ru 164 19 0 8 0 0 0 0 137
7feeder.eternal-september.org 119 0 0 17 0 0 0 0 102
8news.redatomik.org 100 0 0 12 0 0 0 0 88
9news-out.aioe.org 47 23 0 7 0 0 0 0 17
10news.swapon.de 41 0 0 0 0 0 0 0 41
11agency-nz-out.news.mb-net.net 24 2 0 8 0 0 0 0 14
12news.samoylyk.net 17 0 0 11 0 0 0 0 6
13feeder.awxg.com 10 0 0 8 0 0 0 0 2
14csiph.com 8 0 0 7 0 0 0 0 1
15news.freedyn.net 2 0 0 2 0 0 0 0 0
TOTAL: 15 4159 140 0 164 0 0 0 0 3855

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.support.seamonkey 31
gmane.linux.alsa.devel 18
gmane.linux.kernel 11
mozilla.dev.tech.js-engine.internals 10
mozilla.dev.platform 10
mozilla.dev.ui-alerts 9
gmane.comp.gis.openstreetmap.tagging 9
mozilla.dev.security.policy 5
it.annunci.varie 5
it.annunci.immobiliari 3
al.christnet.bible 3
it.annunci.commerciali 3
mozilla.test 2
mozilla.dev.fxos 2
alt.tv.Farscape 2
mozilla.tools.bmo 2
nyc.jobs 1
ntu-kpi.jobs 1
alt.fr.os.windows.7 1
mozilla.compatibility 1
TOTAL: 31 140

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2675
EMP (phn path) 494
EMP (phl) 136
User-issued cancel 53
Too many newsgroups 52
Binary: non-binary distribution 37
Binary: misplaced par2 25
Binary Image: misplaced jpg 6
User-issued spam cancel 3
Binary: misplaced rar 3
Binary Image: misplaced gif 1
Binary: misplaced 265 1
U2 violation - invalid distribution 1
HTML post 1
Binary: misplaced 012 1
Binary: misplaced 219 1
TOTAL: 16 3490

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 123
bbs-nz-out.news.weretis.net 106
news.swapon.de 41
news.albasani.net 39
news.redatomik.org 33
news-out.aioe.org 6
bbsnz-out.feed.uzoreto.com 4
news.snarked.org 4
newsfeed.neva.ru 4
news.samoylyk.net 2
TOTAL: 13 365
TOTAL: 1 365

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16950 1414 15493 43 0 3 8%23:59:39
2news.freedyn.net 24021 270 18102 182 0 68 1%23:59:46
3awxg 18052 43 18002 2 0 0 0%23:59:46
4news.snarked.org 15002 12 14873 20 0 52 0%23:59:46
5weretis.net 14241 6 14135 3 0 0 0%23:59:46
6news.samoylyk.net 17080 5 16895 0 0 473 0%23:59:46
7aioe 15627 4 15515 1 0 0 0%23:59:44
8eternal-september 16125 3 16095 0 0 0 0%23:59:46
9news.redatomik.org 17778 3 17760 0 0 6 0%23:59:46
10csiph.com 18370 3 18334 0 0 0 0%23:59:41
11news.albasani.net 20270 2 16658 964 0 7030 0%23:59:45
12news-in.mixmin.net 16740 2 16706 0 0 59 0%23:59:46
13mb-net.net 18571 2 18462 0 0 937 0%23:59:46
14neva.ru 16974 2 16965 1 0 0 0%23:59:46
15news.uzoreto.com 16059 1 16053 3 0 1 0%23:59:44
16news.swapon.de 1395 1 1393 0 0 0 0%23:53:37
17newsfeed.datemas.de 0 0 0 0 0 18557 0%23:59:47
TOTAL: 17 263255 1773 251441 1219 0 27186 0%407:49:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.2 MB330.2 KB12.5 MB0.1 KB/s8.8 KB23:59:39
2news.freedyn.net756.8 KB687.7 KB1.4 MB0.0 KB/s3.2 KB23:59:46
3awxg120.2 KB8.4 KB128.6 KB0.0 KB/s2.9 KB23:59:46
4news.snarked.org31.2 KB97.0 KB128.2 KB0.0 KB/s4.0 KB23:59:46
5aioe10.8 KB1.2 KB12.0 KB0.0 KB/s2.4 KB23:59:44
6news.samoylyk.net10.0 KB0.0 KB10.0 KB0.0 KB/s2.0 KB23:59:46
7weretis.net8.8 KB5.3 KB14.0 KB0.0 KB/s1.6 KB23:59:46
8eternal-september3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:46
9news.redatomik.org3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:46
10csiph.com3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:41
11news.albasani.net2.0 KB4.2 MB4.2 MB0.0 KB/s4.5 KB23:59:45
12news-in.mixmin.net2.0 KB0.0 KB2.0 KB0.0 KB/s1.0 KB23:59:46
13mb-net.net2.0 KB0.0 KB2.0 KB0.0 KB/s1.0 KB23:59:46
14neva.ru2.0 KB1.7 KB3.8 KB0.0 KB/s1.3 KB23:59:46
15news.uzoreto.com1.2 KB4.5 KB5.8 KB0.0 KB/s1.4 KB23:59:44
16news.swapon.de0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:53:37
17newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 1713.1 MB5.3 MB18.4 MB0.0 KB/s6.3 KB407:49:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 386 589720.5 MB 3402 2 000:14:52
2vorlon.activateit.net.au 24 7861.1 MB 125 0 000:04:26
3160-3-245-118.cpe.cableone.net 2 24.4 KB 3 0 031:41:21
TOTAL: 3 412 668521.6 MB 3530 2 032:07:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 386 589720.5 MB 3402 2 000:14:52
2*.activateit.net.au 24 7861.1 MB 125 0 000:04:26
3*.cpe.cableone.net 2 24.4 KB 3 0 031:41:21
4*.dyn.optonline.net 8 00.0 KB 0 0 000:00:07
5unresolved 7 00.0 KB 0 0 000:06:59
TOTAL: 5 427 668521.6 MB 3530 2 032:07:48

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 2
TOTAL: 2 26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.168 0.068 0.00631:41:21
agency.bbs.nz 27.440 6.412 0.00000:14:52
118.149.222.173 0.372 0.044 0.00000:05:57
vorlon.activateit.net.au 1.384 0.352 0.13000:04:26
118.149.249.97 0.060 0.004 0.00000:01:01
ool-4578089a.dyn.optonline.net 0.392 0.076 0.00000:00:07
? 1.320 0.124 0.00000:00:02
TOTAL: 7 31.136 7.080 0.13632:07:48

Curious NNRP server explorers [Top 20]:

SystemConn
ool-4578089a.dyn.optonline.net 8
118.149.222.173 6
118.149.249.97 1
TOTAL: 3 15

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2311 34.6%
2soc 872 13.0%
3uk 747 11.2%
4comp 687 10.3%
5sci 646 9.7%
6linux 628 9.4%
7alt 277 4.1%
8talk 180 2.7%
9misc 170 2.5%
10news 68 1.0%
11mozilla 51 0.8%
12microsoft 25 0.4%
13nz 14 0.2%
14humanities 11 0.2%
TOTAL: 14 6687100.0%

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

NewsgroupCount
1rec.arts.tv 550
2uk.d-i-y 414
3rec.arts.drwho 234
4linux.debian.changes.devel 227
5rec.food.cooking 187
6uk.legal 186
7rec.sport.football.college 178
8rec.sport.tennis 177
9linux.debian.bugs.dist 161
10soc.penpals 150
11rec.arts.sf.written 148
12comp.os.linux.advocacy 132
13rec.gambling.poker 124
14comp.lang.c 120
15soc.culture.polish 114
16sci.physics 111
17soc.retirement 109
18sci.electronics.design 97
19comp.lang.python 91
20sci.physics.relativity 91
21alt.comp.os.windows-10 88
22soc.culture.china 85
23misc.survivalism 85
24talk.origins 79
25alt.politics.trump 76
26linux.debian.bugs.rc 69
27soc.culture.israel 69
28linux.debian.user 65
29sci.math 63
30news.lists.filters 62
31rec.drugs.cannabis 62
32sci.logic 60
33talk.politics.guns 58
34rec.autos.sport.f1 50
35sci.med.cardiology 50
36rec.music.classical.recordings 47
37rec.boats 45
38soc.culture.indian 44
39misc.invest.stocks 41
40rec.aviation.soaring 40
41rec.sport.pro-wrestling 40
42comp.os.vms 39
43uk.tech.digital-tv 38
44comp.sys.raspberry-pi 38
45sci.military.naval 36
46soc.culture.usa 35
47comp.lang.forth 33
48soc.culture.brazil 32
49alt.conspiracy 32
50mozilla.support.thunderbird 32
51rec.outdoors.rv-travel 31
52rec.sport.golf 30
53uk.legal.moderated 29
54sci.bio.paleontology 28
55alt.test 28
56alt.conspiracy.jfk 27
57uk.radio.amateur 27
58rec.crafts.metalworking 26
59sci.med.pharmacy 25
60soc.genealogy.medieval 24
61talk.politics.misc 23
62sci.lang 22
63sci.anthropology.paleo 22
64soc.history.living 21
65rec.photo.digital 19
66rec.woodworking 18
67comp.lang.tcl 18
68microsoft.public.windowsxp.general 17
69rec.arts.poems 17
70rec.bicycles.tech 16
71mozilla.support.firefox 16
72comp.mobile.android 16
73misc.phone.mobile.iphone 15
74talk.bizarre 15
75comp.lang.c++ 15
76uk.comp.homebuilt 15
77rec.sport.billiard 15
78nz.general 14
79linux.debian.kernel 14
80soc.culture.quebec 14
81soc.history 14
82soc.genealogy.britain 14
83rec.games.pinball 13
84uk.rec.cycling 13
85uk.comp.sys.mac 13
86comp.arch 13
87comp.os.linux.misc 13
88rec.games.backgammon 12
89rec.arts.sf.fandom 12
90comp.sys.apple2 12
91comp.ai.philosophy 12
92soc.culture.german 12
93soc.culture.greek 10
94soc.culture.netherlands 10
95rec.nude 10
96rec.arts.comics.strips 10
97alt.collecting.juke-boxes 10
98rec.music.rock-pop-r+b.1950s 10
99rec.food.restaurants 9
100rec.radio.amateur.antenna 9
TOTAL: 336 6687