news.bbs.nz daily logs

Aug 4 23:58:01 -- Aug 5 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 127401 60.4%9.9 MB 37.8%
innd 35387 16.8%5.6 MB 21.2%
innfeed 26383 12.5%5.4 MB 20.4%
inn 20469 9.7%5.2 MB 19.6%
cnfsstat 1440 0.7%253.7 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 211081 100.0%26.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 262484 48.5%
Positive hits 258956 47.8%
Do not exist 19666 3.6%
Cache misses 261 0.0%
TOTAL: 4 541367 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.035 0.0%57 0.000 0.614 11.000
article cleanup00:00:00.159 0.0%20031 0.000 0.008 0.032
article logging00:00:00.608 0.0%20462 0.000 0.030 0.535
article parse00:00:00.673 0.0%64905 0.000 0.010 0.030
article write00:00:01.099 0.0%15563 0.009 0.071 0.276
artlog/artcncl00:00:00.002 0.0%57 0.000 0.035 0.200
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.301 0.0%526071 0.000 0.001 0.002
hisgrep/artcncl00:00:00.001 0.0%53 0.000 0.019 1.000
hishave/artcncl00:00:00.000 0.0%57 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.745 0.0%547211 0.001 0.012 0.787
history sync00:00:00.038 0.0%364 0.000 0.104 6.750
history write00:00:04.966 0.0%19841 0.008 0.250 19.906
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:58:16.483 99.8%537529 72.037 160.543 473.777
nntp read00:00:03.046 0.0%537807 0.002 0.006 0.013
overview write00:00:34.761 0.0%15563 0.059 2.234 52.385
perl filter00:00:41.430 0.0%19833 0.935 2.089 7.980
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.792 0.0%31126 0.000 0.025 0.082
TOTAL: 24:00:54.73023:59:51.139 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%22638 0.000 0.003 0.020
article prepare00:00:00.003 0.0%8740 0.000 0.000 0.028
article read00:00:00.431 0.0%1967 0.000 0.219 118.000
backlog stats00:00:00.248 0.0%285737 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.485 0.0%234929 0.000 0.006 0.012
data write00:00:02.797 0.0%225525 0.006 0.012 0.023
idle23:55:19.375100.0%285737 182.572 301.394 711.054
status file00:00:06.883 0.0%1988 0.900 3.462 188.000
TOTAL: 23:55:47.16123:55:31.279100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle08:43:34.089 90.3%134268 0.000 233.966 62637.076
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:24.144 0.1%337506 0.000 0.072 1.627
readart00:00:05.160 0.0%7223 0.000 0.714 22.292
TOTAL: 09:39:41.54508:44:03.393 90.4%----

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.snarked.org 30 17751 3124 13026 1601 17%29:23:53
2bbs-nz-out.news.weretis.net 5 31387 2343 28847 197 7%45:37:54
3feeder.eternal-september.org 8 18792 1857 16248 687 9%26:19:18
4news.redatomik.org 3 14995 1838 13030 127 12%23:59:22
5news-out.aioe.org 3 16047 1752 14258 37 10%25:05:08
6bbsnz-out.feed.uzoreto.com 1116 26185 1225 24267 693 4%95:22:17
7news.albasani.net 1 12545 911 11351 283 7%16:50:47
8news-out.mixmin.net 1 17104 758 15894 452 4%24:58:14
9newsfeed.neva.ru 142 11329 524 10686 119 4%71:46:28
10newsfeed.datemas.de 2 22199 496 21574 129 2%34:38:40
11csiph.com 1 15311 232 15070 9 1%23:59:54
12news.swapon.de 4 1570 95 1475 0 6%24:55:00
13agency-nz-out.news.mb-net.net 4 18086 64 18006 16 0%25:11:25
14news.samoylyk.net 1 15337 35 15291 11 0%23:59:57
15feeder.awxg.com 1 13450 21 13421 8 0%23:59:56
16news.freedyn.net 2 22460 5 22445 10 0%32:07:53
17localhost 5 4 4 0 0 100%00:00:00
18news.ausics.org 2 70976 1 70973 2 0%110:14:55
TOTAL: 18 1331 345528 15285 325862 4381 4%658:31:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net11.3 MB178.8 KB1.6 MB13.1 MB 86%5.3 KB
2news.snarked.org9.9 MB43.7 KB14.2 MB24.2 MB 40%5.2 KB
3bbsnz-out.feed.uzoreto.com5.8 MB51.8 KB8.4 MB14.2 MB 40%7.6 KB
4news.redatomik.org5.5 MB67.1 KB383.2 KB5.9 MB 92%3.1 KB
5feeder.eternal-september.org5.4 MB29.9 KB1.6 MB7.0 MB 77%2.8 KB
6news-out.aioe.org4.4 MB46.7 KB276.8 KB4.7 MB 93%2.7 KB
7news.albasani.net2.8 MB50.5 KB530.4 KB3.4 MB 83%2.9 KB
8news-out.mixmin.net2.8 MB43.0 KB1.1 MB4.0 MB 71%3.3 KB
9newsfeed.datemas.de1.8 MB645.3 KB2.3 MB4.8 MB 38%7.8 KB
10newsfeed.neva.ru1.5 MB17.4 KB466.5 KB2.0 MB 76%3.2 KB
11csiph.com829.3 KB39.0 KB39.0 KB907.3 KB 91%3.8 KB
12news.swapon.de282.7 KB0.0 KB0.0 KB282.7 KB100%3.0 KB
13agency-nz-out.news.mb-net.net167.8 KB23.6 KB57.0 KB248.3 KB 67%3.1 KB
14news.samoylyk.net99.0 KB40.3 KB199.5 KB338.8 KB 29%7.4 KB
15feeder.awxg.com49.8 KB28.3 KB29.2 KB107.3 KB 46%3.7 KB
16news.freedyn.net14.6 KB603.4 KB605.9 KB1.2 MB 1%81.6 KB
17localhost6.0 KB0.0 KB0.0 KB6.0 KB100%1.5 KB
18news.ausics.org2.6 KB10.8 KB10.8 KB24.1 KB 10%8.0 KB
TOTAL: 1852.6 MB1.9 MB31.8 MB86.3 MB 60%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 4 23:58:01 - 23:59:59 31 0.2% 0.2678.6 KB 0.1% 0.66
Aug 5 00:00:00 - 00:59:59 746 4.8% 0.212.0 MB 3.6% 0.56
Aug 5 01:00:00 - 01:59:59 837 5.4% 0.233.0 MB 5.5% 0.86
Aug 5 02:00:00 - 02:59:59 918 5.9% 0.262.8 MB 5.1% 0.79
Aug 5 03:00:00 - 03:59:59 913 5.9% 0.253.3 MB 6.1% 0.95
Aug 5 04:00:00 - 04:59:59 1040 6.7% 0.293.1 MB 5.7% 0.89
Aug 5 05:00:00 - 05:59:59 847 5.5% 0.242.4 MB 4.3% 0.67
Aug 5 06:00:00 - 06:59:59 784 5.1% 0.222.4 MB 4.3% 0.68
Aug 5 07:00:00 - 07:59:59 767 4.9% 0.212.5 MB 4.5% 0.70
Aug 5 08:00:00 - 08:59:59 684 4.4% 0.192.3 MB 4.2% 0.66
Aug 5 09:00:00 - 09:59:59 704 4.5% 0.202.5 MB 4.6% 0.71
Aug 5 10:00:00 - 10:59:59 471 3.0% 0.131.6 MB 2.9% 0.45
Aug 5 11:00:00 - 11:59:59 557 3.6% 0.151.9 MB 3.4% 0.53
Aug 5 12:00:00 - 12:59:59 423 2.7% 0.121.6 MB 2.9% 0.45
Aug 5 13:00:00 - 13:59:59 605 3.9% 0.172.3 MB 4.2% 0.65
Aug 5 14:00:00 - 14:59:59 389 2.5% 0.111.5 MB 2.8% 0.44
Aug 5 15:00:00 - 15:59:59 391 2.5% 0.111.4 MB 2.5% 0.39
Aug 5 16:00:00 - 16:59:59 312 2.0% 0.091.4 MB 2.6% 0.40
Aug 5 17:00:00 - 17:59:59 428 2.8% 0.121.5 MB 2.7% 0.41
Aug 5 18:00:00 - 18:59:59 519 3.3% 0.141.9 MB 3.4% 0.53
Aug 5 19:00:00 - 19:59:59 557 3.6% 0.151.8 MB 3.3% 0.51
Aug 5 20:00:00 - 20:59:59 539 3.5% 0.151.6 MB 2.9% 0.44
Aug 5 21:00:00 - 21:59:59 557 3.6% 0.151.7 MB 3.1% 0.48
Aug 5 22:00:00 - 22:59:59 703 4.5% 0.202.4 MB 4.4% 0.68
Aug 5 23:00:00 - 23:58:02 786 5.1% 0.235.9 MB 10.7% 1.72
TOTAL: 24:00:01 15508 100.0% 0.1854.6 MB 100.0% 0.65
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB27.5 GB 55.1% 0 0.26 2299.66
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB31.8 GB 63.5% 0 0.28 2192.21
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB353.5 MB 0.7% 0 0.0230089.32
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 GB25.1 GB 50.1% 0 0.52 1162.42
TOTAL: 10-500.0 GB84.7 GB 16.9% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1669 0 0 10 0 0 0 0 1659
2bbsnz-out.feed.uzoreto.com 697 12 0 25 0 0 0 0 660
3feeder.eternal-september.org 684 0 0 11 0 0 0 0 673
4news-out.mixmin.net 497 0 0 7 0 0 0 0 490
5news.albasani.net 421 0 0 12 0 0 0 0 409
6news.redatomik.org 349 0 0 12 0 0 0 0 337
7bbs-nz-out.news.weretis.net 227 21 0 40 0 0 0 0 166
8newsfeed.datemas.de 132 6 0 15 0 0 0 0 111
9newsfeed.neva.ru 121 15 0 5 0 0 0 0 101
10news-out.aioe.org 41 22 0 11 0 0 0 0 8
11news.samoylyk.net 16 0 0 14 0 0 0 0 2
12news.swapon.de 13 0 0 0 0 0 0 0 13
13agency-nz-out.news.mb-net.net 13 1 0 7 0 0 0 0 5
14news.freedyn.net 9 0 0 7 0 0 0 0 2
15csiph.com 8 0 0 8 0 0 0 0 0
16feeder.awxg.com 7 0 0 6 0 0 0 0 1
TOTAL: 16 4904 77 0 190 0 0 0 0 4637

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.kernel 14
gmane.comp.gis.openstreetmap.tagging 14
gmane.linux.alsa.devel 9
gmane.comp.gis.openstreetmap.imports 6
mozilla.support.seamonkey 5
trollnet.cinema 4
mozilla.dev.ui-alerts 3
mozilla.dev.platform 3
mozilla.test 2
gmane.linux.alsa.user 2
mozilla.dev.builds 2
alt.forsale.seattle 1
mozilla.dev.apps.thunderbird 1
demos.local.statistics 1
mozilla.mozillians 1
a.business.internet 1
alt.soc.penpals 1
a2i.ba.jobs.offered.hivol 1
alt.ete7 1
gmane.comp.handhelds.openmoko.community 1
TOTAL: 24 77

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3056
User-issued cancel 604
EMP (phn path) 300
EMP (phl) 122
Too many newsgroups 43
Binary: non-binary distribution 36
Binary: misplaced par2 17
Too many newsgroups (low_xpost) 10
User-issued spam cancel 5
Binary: misplaced rar 2
Binary Image: misplaced jpg 2
Too many newsgroups (meow) 1
TOTAL: 12 4198

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 8
TOTAL: 1 8
Including strange strings
news.redatomik.org 226
news.albasani.net 115
bbs-nz-out.news.weretis.net 24
newsfeed.datemas.de 23
news-out.mixmin.net 16
news.swapon.de 13
news-out.aioe.org 6
news.snarked.org 3
feeder.eternal-september.org 2
bbsnz-out.feed.uzoreto.com 2
TOTAL: 11 431
TOTAL: 2 439

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14100 1164 12902 34 0 25 8%23:59:49
2news.freedyn.net 15952 65 15424 14 0 172 0%23:59:45
3awxg 14912 56 14848 1 0 69 0%23:59:49
4news.redatomik.org 13620 11 13557 0 0 174 0%23:59:48
5mb-net.net 15468 10 15392 9 0 122 0%23:59:19
6weretis.net 12417 10 12268 5 0 27 0%23:59:48
7eternal-september 13482 6 13455 0 0 11 0%23:59:41
8news.samoylyk.net 14154 6 14064 0 0 95 0%23:59:40
9news.snarked.org 12227 6 12148 1 0 57 0%23:59:49
10csiph.com 15299 6 15255 0 0 37 0%23:59:44
11neva.ru 14773 5 14758 1 0 0 0%23:59:48
12news.uzoreto.com 14234 5 14228 1 0 74 0%23:59:47
13aioe 12764 4 12718 0 0 37 0%23:59:45
14news-in.mixmin.net 14384 4 14360 0 0 45 0%23:59:27
15newsfeed.datemas.de 15087 3 14953 1 0 271 0%23:59:48
16news.albasani.net 16752 2 13761 638 0 5933 0%23:59:48
17news.swapon.de 1484 1 1465 0 0 17 0%23:53:43
TOTAL: 17 231109 1364 225556 705 0 7166 0%407:49:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.3 MB189.7 KB7.5 MB0.1 KB/s6.4 KB23:59:49
2news.freedyn.net159.8 KB51.7 KB211.5 KB0.0 KB/s2.7 KB23:59:45
3awxg152.1 KB1.1 KB153.2 KB0.0 KB/s2.7 KB23:59:49
4news.redatomik.org26.5 KB0.0 KB26.5 KB0.0 KB/s2.4 KB23:59:48
5mb-net.net24.0 KB21.1 KB45.1 KB0.0 KB/s2.4 KB23:59:19
6weretis.net16.8 KB6.1 KB22.9 KB0.0 KB/s1.5 KB23:59:48
7eternal-september8.9 KB0.0 KB8.9 KB0.0 KB/s1.5 KB23:59:41
8news.samoylyk.net8.9 KB0.0 KB8.9 KB0.0 KB/s1.5 KB23:59:40
9news.snarked.org8.9 KB2.1 KB11.0 KB0.0 KB/s1.6 KB23:59:49
10csiph.com8.9 KB0.0 KB8.9 KB0.0 KB/s1.5 KB23:59:44
11news.uzoreto.com7.6 KB1.3 KB8.9 KB0.0 KB/s1.5 KB23:59:47
12neva.ru6.3 KB2.6 KB8.9 KB0.0 KB/s1.5 KB23:59:48
13aioe6.0 KB0.0 KB6.0 KB0.0 KB/s1.5 KB23:59:45
14news-in.mixmin.net6.0 KB0.0 KB6.0 KB0.0 KB/s1.5 KB23:59:27
15newsfeed.datemas.de3.3 KB1.3 KB4.6 KB0.0 KB/s1.2 KB23:59:48
16news.albasani.net2.0 KB3.5 MB3.5 MB0.0 KB/s5.6 KB23:59:48
17news.swapon.de0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:53:43
TOTAL: 177.7 MB3.7 MB11.5 MB0.0 KB/s5.7 KB407:49:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 412 495818.2 MB 3007 4 28800:17:16
2184-155-113-241.cpe.cableone.net 8 14795.8 MB 285 0 000:27:18
3vorlon.activateit.net.au 24 542799.9 KB 110 0 000:03:45
TOTAL: 3 444 697924.7 MB 3402 4 28809:39:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 412 495818.2 MB 3007 4 28800:17:16
2*.cpe.cableone.net 13 14795.8 MB 285 0 008:22:09
3*.activateit.net.au 24 542799.9 KB 110 0 000:03:45
4unresolved 13 00.0 KB 0 0 000:56:20
5*.dsl.bell.ca 1 00.0 KB 0 0 000:00:00
TOTAL: 5 463 697924.7 MB 3402 4 28809:39:34

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 5
TOTAL: 3 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
3-0-0-245-118.cpe.cableone.net 0.228 0.056 0.01107:54:50
118.149.183.239 0.364 0.048 0.00000:29:02
184-155-113-241.cpe.cableone.net 0.820 0.336 0.20900:27:18
118.149.175.206 0.304 0.036 0.00000:25:06
agency.bbs.nz 28.996 6.472 0.00000:17:16
vorlon.activateit.net.au 1.448 0.252 0.09200:03:45
121.99.149.132 0.196 0.132 0.00000:02:11
? 1.728 0.140 0.00000:00:02
mtrlpq2314w-lp130-02-70-24-220-130.dsl.bell.ca 0.052 0.004 0.00000:00:00
TOTAL: 9 34.136 7.476 0.31209:39:34

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.183.239 6
118.149.175.206 5
3-0-0-245-118.cpe.cableone.net 5
121.99.149.132 2
mtrlpq2314w-lp130-02-70-24-220-130.dsl.bell.ca 1
TOTAL: 5 19

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1694 24.3%
2linux 1102 15.8%
3soc 1094 15.7%
4sci 813 11.6%
5comp 554 7.9%
6uk 544 7.8%
7alt 468 6.7%
8misc 341 4.9%
9talk 226 3.2%
10news 63 0.9%
11mozilla 40 0.6%
12nz 25 0.4%
13humanities 6 0.1%
14microsoft 4 0.1%
15us 3 0.0%
16aus 2 0.0%
TOTAL: 16 6979100.0%

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

NewsgroupCount
1linux.debian.bugs.dist 363
2soc.retirement 336
3misc.survivalism 296
4rec.arts.tv 246
5sci.physics.relativity 245
6rec.arts.drwho 220
7alt.comp.os.windows-10 216
8linux.debian.changes.devel 209
9uk.d-i-y 194
10linux.debian.bugs.rc 167
11rec.food.cooking 161
12sci.physics 147
13soc.culture.polish 144
14rec.arts.sf.written 130
15soc.culture.china 130
16uk.legal 129
17talk.politics.guns 129
18comp.os.linux.advocacy 123
19comp.lang.c 113
20uk.radio.amateur 112
21sci.math 108
22alt.politics.trump 102
23rec.drugs.cannabis 85
24linux.debian.user 85
25sci.electronics.design 84
26rec.sport.tennis 81
27rec.boats 78
28rec.music.classical.recordings 73
29talk.origins 64
30soc.culture.israel 63
31alt.conspiracy.jfk 57
32rec.sport.pro-wrestling 57
33sci.logic 56
34soc.genealogy.britain 54
35rec.gambling.poker 52
36sci.med.cardiology 51
37soc.penpals 44
38news.lists.filters 42
39uk.legal.moderated 41
40comp.lang.c++ 36
41sci.lang 33
42soc.culture.indian 32
43alt.conspiracy 31
44talk.politics.misc 29
45rec.sport.football.college 28
46soc.history 26
47rec.outdoors.rv-travel 26
48rec.music.beatles 26
49linux.debian.user.german 26
50linux.debian.kernel 25
51nz.general 25
52rec.sport.golf 24
53comp.os.vms 23
54mozilla.support.thunderbird 22
55alt.test 22
56sci.military.naval 22
57uk.rec.cars.maintenance 22
58rec.music.rock-pop-r+b.1950s 21
59rec.arts.sf.tv 21
60uk.tech.digital-tv 20
61rec.nude 20
62soc.history.medieval 20
63linux.debian.devel 20
64soc.culture.brazil 20
65linux.gentoo.dev 20
66rec.sport.billiard 20
67alt.os.linux.ubuntu 19
68soc.culture.vietnamese 19
69rec.arts.sf.fandom 19
70soc.culture.greek 19
71comp.sys.apple2 19
72rec.music.dylan 18
73soc.genealogy.nordic 18
74comp.os.linux.misc 18
75linux.debian.devel.release 18
76linux.debian.l10n.german 17
77soc.culture.usa 17
78linux.debian.maint.emacsen 16
79comp.lang.ada 16
80rec.crafts.metalworking 15
81linux.debian.user.french 14
82soc.men 14
83comp.sys.cbm 14
84uk.tech.broadcast 14
85comp.programming 14
86linux.debian.changes 14
87comp.programming.threads 14
88rec.games.trivia 14
89linux.debian.maint.boot 13
90comp.sys.mac.apps 13
91linux.debian.devel.mentors 13
92misc.invest.stocks 12
93comp.ai.philosophy 12
94rec.aviation.soaring 12
95soc.culture.europe 12
96rec.autos.sport.f1 12
97rec.audio.opinion 12
98alt.bbs.mystic 11
99soc.genealogy.medieval 11
100sci.crypt 11
TOTAL: 310 6979