news.bbs.nz daily logs

Sep 14 23:58:02 -- Sep 15 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124110 60.8%9.6 MB 38.1%
innd 33275 16.3%5.2 MB 20.9%
innfeed 24715 12.1%5.0 MB 19.9%
inn 20467 10.0%5.1 MB 20.1%
cnfsstat 1440 0.7%258.4 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 204008 100.0%25.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 265145 49.2%
Positive hits 253353 47.0%
Do not exist 19835 3.7%
Cache misses 180 0.0%
TOTAL: 4 538513 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.287 0.0%65 0.000 4.415 40.000
article cleanup00:00:00.174 0.0%20056 0.000 0.009 0.041
article logging00:00:00.493 0.0%20426 0.000 0.024 0.115
article parse00:00:00.603 0.0%57459 0.000 0.010 0.035
article write00:00:01.365 0.0%16523 0.017 0.083 0.552
artlog/artcncl00:00:00.001 0.0%65 0.000 0.015 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.376 0.0%518360 0.000 0.001 0.003
hisgrep/artcncl00:00:00.001 0.0%62 0.000 0.016 0.333
hishave/artcncl00:00:00.000 0.0%65 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.040 0.0%542853 0.001 0.017 0.727
history sync00:00:00.015 0.0%378 0.000 0.040 0.500
history write00:00:06.240 0.0%19985 0.000 0.312 19.850
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:57:42.094 99.8%527827 89.335 163.429 455.576
nntp read00:00:04.296 0.0%530799 0.003 0.008 0.019
overview write00:00:39.613 0.0%16523 0.000 2.397 80.983
perl filter00:00:36.743 0.0%19976 1.069 1.839 8.383
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.999 0.0%33046 0.000 0.030 0.144
TOTAL: 24:00:50.11723:59:22.340 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.051 0.0%22637 0.000 0.002 0.026
article prepare00:00:00.001 0.0%8460 0.000 0.000 0.008
article read00:00:00.222 0.0%1922 0.000 0.116 6.174
backlog stats00:00:00.546 0.0%285524 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.182 0.0%237282 0.002 0.009 0.018
data write00:00:02.789 0.0%225114 0.005 0.012 0.033
idle24:06:20.887100.0%285524 160.470 303.936 755.292
status file00:00:03.435 0.0%1914 0.500 1.795 62.417
TOTAL: 24:06:48.14624:06:30.113100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle18:45:09.885 98.6%129700 0.000 520.508163965.545
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.129 0.0%306849 0.000 0.007 0.333
readart00:00:00.631 0.0%6766 0.000 0.093 17.000
TOTAL: 19:01:08.61518:45:12.645 98.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 4 32508 3753 28523 232 11%45:21:55
2news.snarked.org 39 18689 2675 14605 1409 14%36:10:52
3bbsnz-out.feed.uzoreto.com 1127 26167 2548 22684 935 9%95:11:50
4feeder.eternal-september.org 6 19629 2301 17209 119 11%26:15:14
5news-out.mixmin.net 2 18195 1373 16474 348 7%24:30:57
6news-out.aioe.org 3 15801 1272 14514 15 8%22:58:30
7news.redatomik.org 3 16245 731 15476 38 4%24:08:57
8news.albasani.net 1 27152 680 26285 187 2%39:49:22
9newsfeed.neva.ru 149 10946 586 10192 168 5%71:49:38
10csiph.com 1 17086 188 16895 3 1%23:59:55
11news.freedyn.net 4 23464 146 23261 57 0%31:13:21
12news.swapon.de 10 1456 115 1340 1 7%29:31:52
13news.samoylyk.net 1 17336 62 17270 4 0%23:59:57
14agency-nz-out.news.mb-net.net 5 18048 50 17988 10 0%23:33:22
15feeder.awxg.com 2 15193 16 15173 4 0%23:59:51
16localhost 11 10 10 0 0 100%00:00:00
TOTAL: 16 1368 277925 16506 257889 3530 5%542:35:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net16.8 MB86.1 KB1.1 MB18.0 MB 93%4.6 KB
2bbsnz-out.feed.uzoreto.com8.1 MB38.0 KB5.7 MB13.8 MB 58%4.1 KB
3news.snarked.org8.1 MB18.3 KB11.0 MB19.1 MB 42%4.8 KB
4feeder.eternal-september.org5.9 MB22.6 KB496.1 KB6.4 MB 92%2.7 KB
5news-out.mixmin.net4.1 MB7.8 KB717.0 KB4.8 MB 85%2.9 KB
6news.albasani.net3.7 MB19.9 KB428.8 KB4.1 MB 89%4.8 KB
7news-out.aioe.org3.3 MB7.9 KB118.8 KB3.4 MB 96%2.7 KB
8news.redatomik.org2.4 MB22.0 KB155.8 KB2.6 MB 93%3.4 KB
9newsfeed.neva.ru1.6 MB3.1 KB1.0 MB2.7 MB 60%3.6 KB
10csiph.com491.2 KB4.5 KB5.4 KB501.1 KB 98%2.6 KB
11news.swapon.de373.2 KB0.0 KB0.7 KB373.9 KB 99%3.2 KB
12news.freedyn.net356.9 KB486.8 KB609.2 KB1.4 MB 24%7.2 KB
13news.samoylyk.net176.5 KB8.8 KB15.8 KB201.1 KB 87%3.0 KB
14agency-nz-out.news.mb-net.net148.3 KB2.8 KB35.6 KB186.7 KB 79%3.1 KB
15feeder.awxg.com47.7 KB8.8 KB8.8 KB65.3 KB 72%3.3 KB
16localhost22.6 KB0.0 KB0.0 KB22.6 KB100%2.3 KB
TOTAL: 1655.5 MB737.5 KB21.4 MB77.5 MB 71%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 14 23:58:02 - 23:59:59 22 0.1% 0.1947.9 KB 0.1% 0.41
Sep 15 00:00:00 - 00:59:59 893 5.4% 0.252.2 MB 3.9% 0.61
Sep 15 01:00:00 - 01:59:59 996 6.0% 0.283.9 MB 7.1% 1.11
Sep 15 02:00:00 - 02:59:59 1063 6.4% 0.302.9 MB 5.2% 0.82
Sep 15 03:00:00 - 03:59:59 982 5.9% 0.273.9 MB 7.1% 1.12
Sep 15 04:00:00 - 04:59:59 1025 6.2% 0.284.2 MB 7.6% 1.19
Sep 15 05:00:00 - 05:59:59 1107 6.7% 0.313.5 MB 6.3% 0.98
Sep 15 06:00:00 - 06:59:59 979 5.9% 0.273.2 MB 5.8% 0.91
Sep 15 07:00:00 - 07:59:59 787 4.8% 0.222.1 MB 3.8% 0.60
Sep 15 08:00:00 - 08:59:59 735 4.4% 0.202.8 MB 5.1% 0.80
Sep 15 09:00:00 - 09:59:59 830 5.0% 0.232.5 MB 4.5% 0.71
Sep 15 10:00:00 - 10:59:59 575 3.5% 0.161.8 MB 3.3% 0.52
Sep 15 11:00:00 - 11:59:59 556 3.4% 0.152.2 MB 4.0% 0.63
Sep 15 12:00:00 - 12:59:59 440 2.7% 0.121.4 MB 2.6% 0.40
Sep 15 13:00:00 - 13:59:59 399 2.4% 0.111.3 MB 2.4% 0.37
Sep 15 14:00:00 - 14:59:59 285 1.7% 0.081.4 MB 2.5% 0.39
Sep 15 15:00:00 - 15:59:59 339 2.1% 0.091.1 MB 1.9% 0.30
Sep 15 16:00:00 - 16:59:59 324 2.0% 0.091.5 MB 2.7% 0.42
Sep 15 17:00:00 - 17:59:59 360 2.2% 0.101.2 MB 2.1% 0.34
Sep 15 18:00:00 - 18:59:59 456 2.8% 0.131.8 MB 3.2% 0.50
Sep 15 19:00:00 - 19:59:59 609 3.7% 0.172.1 MB 3.9% 0.61
Sep 15 20:00:00 - 20:59:59 674 4.1% 0.192.1 MB 3.8% 0.60
Sep 15 21:00:00 - 21:59:59 751 4.5% 0.212.2 MB 3.9% 0.62
Sep 15 22:00:00 - 22:59:59 675 4.1% 0.192.0 MB 3.6% 0.56
Sep 15 23:00:00 - 23:58:01 656 4.0% 0.192.0 MB 3.7% 0.60
TOTAL: 23:59:59 16518 100.0% 0.1955.2 MB 100.0% 0.65
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.4 GB 56.9% 0 0.26 2352.17
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.8 GB 65.6% 0 0.31 1965.72
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB361.2 MB 0.7% 0 0.0230085.47
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 GB27.0 GB 54.0% 0 0.52 1169.31
TOTAL: 10-500.0 GB88.6 GB 17.7% 1 0.36-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1466 1 0 3 0 0 0 0 1462
2bbsnz-out.feed.uzoreto.com 935 23 0 9 0 0 0 0 903
3news-out.mixmin.net 377 0 0 3 0 0 0 0 374
4news.albasani.net 314 0 0 4 0 0 0 0 310
5bbs-nz-out.news.weretis.net 312 36 0 13 0 0 0 0 263
6newsfeed.neva.ru 168 10 0 1 0 0 0 0 157
7feeder.eternal-september.org 119 0 0 5 0 0 0 0 114
8news.redatomik.org 66 0 0 4 0 0 0 0 62
9news.freedyn.net 46 1 0 4 0 0 0 0 41
10news.swapon.de 34 0 0 0 0 0 0 0 34
11news-out.aioe.org 22 7 0 4 0 0 0 0 11
12agency-nz-out.news.mb-net.net 11 1 0 4 0 0 0 0 6
13feeder.awxg.com 6 0 0 5 0 0 0 0 1
14news.samoylyk.net 6 0 0 3 0 0 0 0 3
15csiph.com 5 0 0 4 0 0 0 0 1
TOTAL: 15 3887 79 0 66 0 0 0 0 3742

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 11
gmane.linux.alsa.devel 10
mozilla.dev.ui-alerts 7
mozilla.dev.platform 6
alt.fan.snuffles 5
fido7.ru.android 4
mozilla.support.seamonkey 4
it.annunci.varie 3
it.annunci.commerciali 3
it.annunci.immobiliari 3
mozilla.compatibility 2
mozilla.governance 2
mozilla.dev.security.policy 2
nemo.bavardages 2
alt.sex.girl 1
eagle.support.ger 1
alt.sex.erotica.market.places 1
alt.religion.christian.romman-catholic 1
demos.local.statistics 1
mozilla.test 1
TOTAL: 29 79

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2808
EMP (phn path) 331
EMP (phl) 69
Too many newsgroups 47
Binary: non-binary distribution 45
Binary: misplaced par2 19
EMP (phn nph) 17
User-issued cancel 13
User-issued spam cancel 7
Binary Image: misplaced jpg 2
MI5 Filter 1
Binary: misplaced 026 1
Binary: misplaced 007 1
Binary: misplaced 235 1
Too many newsgroups (low_xpost) 1
TOTAL: 15 3363

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 7
news.albasani.net 2
TOTAL: 2 9
Including strange strings
news.albasani.net 148
bbs-nz-out.news.weretis.net 88
news-out.mixmin.net 55
news.swapon.de 33
news.redatomik.org 31
news-out.aioe.org 5
news.snarked.org 3
bbsnz-out.feed.uzoreto.com 2
feeder.eternal-september.org 2
newsfeed.neva.ru 2
TOTAL: 11 370
TOTAL: 2 379

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14994 914 14068 10 2 0 6%23:59:48
2awxg 15957 48 15904 2 0 0 0%23:59:31
3news.freedyn.net 16513 40 16357 1 0 119 0%23:59:47
4aioe 14030 14 13934 0 0 0 0%23:59:48
5news.snarked.org 13752 12 13625 0 0 37 0%23:59:48
6mb-net.net 16499 11 16452 0 0 1 0%23:59:48
7news.redatomik.org 15778 11 15740 0 0 3 0%23:59:44
8csiph.com 16376 10 16321 0 0 0 0%23:59:47
9weretis.net 12400 10 12377 0 0 0 0%23:59:40
10eternal-september 14071 10 13914 9 0 156 0%23:59:47
11news-in.mixmin.net 14958 10 14937 0 0 0 0%23:59:45
12news.samoylyk.net 14978 9 14948 0 0 23 0%23:59:47
13neva.ru 15527 7 15515 3 0 0 0%23:59:48
14news.uzoreto.com 13912 4 13895 6 0 4 0%23:59:34
15news.albasani.net 17370 4 14608 873 0 5646 0%23:59:33
16news.swapon.de 1152 0 1152 0 0 2 0%23:38:41
TOTAL: 16 228267 1114 223747 904 2 5991 0%383:34:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org8.8 MB27.7 KB8.9 MB0.1 KB/s9.8 KB23:59:48
2awxg106.6 KB10.3 KB116.9 KB0.0 KB/s2.3 KB23:59:31
3news.freedyn.net75.5 KB3.8 KB79.3 KB0.0 KB/s1.9 KB23:59:47
4aioe33.3 KB0.0 KB33.3 KB0.0 KB/s2.4 KB23:59:48
5news.redatomik.org29.5 KB0.0 KB29.5 KB0.0 KB/s2.7 KB23:59:44
6news.snarked.org25.3 KB0.0 KB25.3 KB0.0 KB/s2.1 KB23:59:48
7mb-net.net25.2 KB0.0 KB25.2 KB0.0 KB/s2.3 KB23:59:48
8csiph.com22.6 KB0.0 KB22.6 KB0.0 KB/s2.3 KB23:59:47
9weretis.net22.6 KB0.0 KB22.6 KB0.0 KB/s2.3 KB23:59:40
10eternal-september22.6 KB73.5 KB96.1 KB0.0 KB/s5.1 KB23:59:47
11news-in.mixmin.net22.6 KB0.0 KB22.6 KB0.0 KB/s2.3 KB23:59:45
12news.samoylyk.net21.6 KB0.0 KB21.6 KB0.0 KB/s2.4 KB23:59:47
13neva.ru10.9 KB11.7 KB22.6 KB0.0 KB/s2.3 KB23:59:48
14news.uzoreto.com5.2 KB17.4 KB22.6 KB0.0 KB/s2.3 KB23:59:34
15news.albasani.net4.6 KB3.6 MB3.6 MB0.0 KB/s4.2 KB23:59:33
16news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:38:41
TOTAL: 169.3 MB3.8 MB13.0 MB0.0 KB/s6.6 KB383:34:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 398 530118.4 MB 3030 10 000:15:31
2vorlon.activateit.net.au 24 9311.3 MB 122 0 000:04:58
3121.99.149.122 5 36.8 KB 2 0 201:03:23
TOTAL: 3 427 623519.6 MB 3154 10 219:01:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 398 530118.4 MB 3030 10 000:15:31
2*.activateit.net.au 24 9311.3 MB 122 0 000:04:58
3unresolved 21 36.8 KB 2 0 201:17:54
4*.cpe.cableone.net 2 00.0 KB 0 0 017:22:35
TOTAL: 4 445 623519.6 MB 3154 10 219:01:01

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.196 0.088 0.00917:22:35
121.99.149.122 0.412 0.144 0.00001:03:23
agency.bbs.nz 29.552 6.896 0.00000:15:31
118.149.140.187 0.612 0.040 0.00000:09:11
118.149.250.227 0.292 0.052 0.00000:05:08
vorlon.activateit.net.au 1.552 0.440 0.11200:04:58
192.241.202.43 0.060 0.004 0.00000:00:09
? 1.652 0.192 0.00000:00:02
71.6.199.23 0.048 0.012 0.00000:00:00
TOTAL: 9 34.376 7.868 0.12119:01:01

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.140.187 9
118.149.250.227 5
160-3-245-118.cpe.cableone.net 2
192.241.202.43 1
71.6.199.23 1
TOTAL: 5 18

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
121.99.149.122 4 2
TOTAL: 1 4 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 2734 43.8%
2uk 607 9.7%
3soc 599 9.6%
4sci 570 9.1%
5comp 477 7.7%
6linux 442 7.1%
7alt 358 5.7%
8talk 163 2.6%
9misc 146 2.3%
10news 75 1.2%
11microsoft 30 0.5%
12mozilla 16 0.3%
13humanities 12 0.2%
14nz 4 0.1%
15aus 2 0.0%
TOTAL: 15 6235100.0%

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

NewsgroupCount
1rec.arts.tv 662
2rec.sport.tennis 238
3rec.arts.drwho 236
4uk.d-i-y 236
5rec.arts.sf.tv 219
6rec.food.cooking 196
7rec.sport.football.college 172
8uk.legal 170
9rec.boats 168
10alt.comp.os.windows-10 152
11linux.debian.bugs.dist 118
12sci.physics 114
13rec.sport.pro-wrestling 106
14uk.radio.amateur 104
15sci.physics.relativity 101
16rec.arts.sf.written 95
17linux.debian.changes.devel 89
18comp.os.linux.advocacy 85
19sci.math 83
20rec.gambling.poker 82
21soc.culture.polish 78
22talk.politics.guns 78
23soc.culture.china 75
24alt.politics.trump 74
25linux.debian.bugs.rc 73
26soc.retirement 67
27sci.electronics.design 64
28rec.drugs.cannabis 59
29sci.logic 51
30comp.lang.python 50
31rec.photo.digital 50
32talk.origins 48
33misc.survivalism 46
34linux.debian.user 46
35soc.culture.israel 45
36sci.med.cardiology 43
37comp.lang.c++ 42
38news.lists.filters 42
39alt.conspiracy.jfk 42
40comp.lang.c 39
41rec.sport.golf 35
42soc.culture.greek 32
43linux.gentoo.dev 32
44rec.aviation.soaring 31
45soc.penpals 31
46alt.test 29
47rec.bicycles.tech 29
48misc.health.alternative 28
49misc.invest.stocks 28
50rec.arts.sf.fandom 28
51talk.politics.misc 27
52soc.culture.brazil 26
53uk.legal.moderated 25
54comp.sys.apple2 25
55microsoft.public.windowsxp.general 23
56rec.outdoors.rv-travel 23
57comp.lang.forth 22
58soc.culture.indian 22
59alt.os.linux.ubuntu 22
60linux.debian.devel.release 22
61comp.lang.fortran 22
62comp.sys.raspberry-pi 22
63uk.tech.digital-tv 21
64soc.genealogy.britain 20
65uk.comp.sys.mac 19
66sci.astro.amateur 19
67sci.med.pharmacy 19
68rec.music.classical.recordings 18
69comp.arch.embedded 17
70rec.sport.soccer 17
71news.admin.net-abuse.email 17
72soc.genealogy.medieval 17
73misc.phone.mobile.iphone 17
74soc.history 15
75rec.music.rock-pop-r+b.1950s 15
76alt.bbs.mystic 15
77soc.culture.usa 15
78comp.arch 14
79sci.bio.paleontology 13
80mozilla.general 13
81sci.military.naval 13
82soc.history.living 12
83rec.audio.opinion 12
84rec.arts.movies.current-films 12
85alt.conspiracy 12
86rec.autos.sport.f1 12
87soc.genealogy.nordic 11
88rec.pets.cats.community 11
89soc.history.medieval 10
90comp.lang.prolog 10
91rec.sport.billiard 10
92soc.culture.netherlands 10
93comp.lang.tcl 10
94humanities.lit.authors.shakespeare 9
95sci.electronics.basics 9
96comp.sys.mac.advocacy 9
97rec.puzzles.crosswords 9
98soc.culture.bulgaria 9
99comp.sys.mac.apps 9
100rec.radio.shortwave 9
TOTAL: 318 6235