news.bbs.nz daily logs

Sep 18 23:58:01 -- Sep 19 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 130272 61.0%10.1 MB 38.3%
innd 32658 15.3%5.2 MB 19.6%
innfeed 24777 11.6%5.0 MB 18.8%
inn 24426 11.4%5.9 MB 22.4%
cnfsstat 1440 0.7%254.6 KB 0.9%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 213574 100.0%26.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 318890 50.5%
Positive hits 288044 45.7%
Do not exist 23775 3.8%
Cache misses 196 0.0%
TOTAL: 4 630905 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.282 0.0%47 0.000 6.000 21.500
article cleanup00:00:00.235 0.0%24094 0.000 0.010 0.042
article logging00:00:00.584 0.0%24399 0.000 0.024 0.069
article parse00:00:00.751 0.0%71689 0.000 0.010 0.026
article write00:00:02.624 0.0%19053 0.000 0.138 9.035
artlog/artcncl00:00:00.000 0.0%47 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.417 0.0%608962 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%46 0.000 0.065 1.000
hishave/artcncl00:00:00.000 0.0%47 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.518 0.0%637491 0.002 0.018 0.936
history sync00:00:00.027 0.0%365 0.000 0.074 1.000
history write00:00:06.865 0.0%23995 0.015 0.286 16.576
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:06.584 99.7%619045 73.318 139.290 449.871
nntp read00:00:05.145 0.0%621707 0.004 0.008 0.025
overview write00:00:46.444 0.1%19053 0.048 2.438 70.160
perl filter00:00:44.891 0.1%23993 1.084 1.871 5.587
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.029 0.0%38106 0.000 0.027 0.154
TOTAL: 24:00:49.68023:59:07.399 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%30397 0.000 0.002 0.032
article prepare00:00:00.003 0.0%8224 0.000 0.000 0.050
article read00:00:00.196 0.0%1883 0.000 0.104 5.750
backlog stats00:00:00.612 0.0%316339 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.333 0.0%273838 0.003 0.009 0.015
data write00:00:03.256 0.0%259402 0.006 0.013 0.024
idle23:54:34.666100.0%316339 129.250 272.096 763.622
status file00:00:09.589 0.0%1876 0.538 5.111 173.769
TOTAL: 23:55:08.55623:54:50.710100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle13:23:04.947 99.4%135864 0.000 354.656 75269.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.480 0.0%336524 0.000 0.010 0.200
readart00:00:01.063 0.0%7460 0.000 0.142 12.800
TOTAL: 13:27:50.91813:23:09.490 99.4%----

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 10 45877 4926 40508 443 10%57:17:03
2news.snarked.org 35 24193 2653 18910 2630 10%40:51:06
3news-out.aioe.org 2 19789 2492 17235 62 12%25:46:13
4bbsnz-out.feed.uzoreto.com 576 27752 2476 24444 832 8%47:24:45
5feeder.eternal-september.org 6 21737 2407 19187 143 11%24:51:06
6news.redatomik.org 3 18913 1378 17483 52 7%24:00:28
7news.albasani.net 1 13857 792 12818 247 5%14:52:39
8news-out.mixmin.net 4 18010 776 16893 341 4%21:46:14
9newsfeed.neva.ru 144 10296 646 9443 207 6%72:12:36
10csiph.com 2 18724 223 18497 4 1%23:59:47
11news.swapon.de 4 1560 131 1429 0 8%23:42:25
12agency-nz-out.news.mb-net.net 6 18378 56 18306 16 0%21:33:12
13news.samoylyk.net 3 18867 55 18795 17 0%25:47:48
14news.freedyn.net 2 20823 33 20768 22 0%23:38:41
15feeder.awxg.com 2 16594 14 16570 10 0%23:59:43
16localhost 8 7 7 0 0 100%00:00:00
TOTAL: 16 808 295377 19065 271286 5026 6%471:43:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.0 MB45.5 KB3.4 MB21.5 MB 83%4.1 KB
2news.snarked.org9.4 MB83.4 KB24.7 MB34.1 MB 27%6.6 KB
3feeder.eternal-september.org6.7 MB82.9 KB860.1 KB7.6 MB 87%3.0 KB
4bbsnz-out.feed.uzoreto.com6.3 MB10.1 KB8.8 MB15.1 MB 41%4.7 KB
5news-out.aioe.org6.1 MB15.4 KB408.1 KB6.5 MB 93%2.6 KB
6news.redatomik.org4.2 MB21.5 KB192.8 KB4.4 MB 95%3.2 KB
7news-out.mixmin.net2.6 MB14.6 KB943.7 KB3.5 MB 73%3.2 KB
8news.albasani.net2.4 MB16.3 KB444.1 KB2.8 MB 83%2.8 KB
9newsfeed.neva.ru1.5 MB14.4 KB2.0 MB3.6 MB 42%4.3 KB
10csiph.com622.6 KB13.5 KB13.5 KB649.5 KB 95%2.9 KB
11news.swapon.de316.8 KB0.0 KB0.0 KB316.8 KB100%2.4 KB
12news.freedyn.net309.2 KB21.3 KB41.9 KB372.4 KB 83%6.8 KB
13news.samoylyk.net161.0 KB84.5 KB347.0 KB592.5 KB 27%8.2 KB
14agency-nz-out.news.mb-net.net160.6 KB16.1 KB70.2 KB246.8 KB 65%3.4 KB
15feeder.awxg.com74.8 KB88.3 KB88.3 KB251.4 KB 29%10.5 KB
16localhost12.2 KB0.0 KB0.0 KB12.2 KB100%1.7 KB
TOTAL: 1658.6 MB527.6 KB42.3 MB101.5 MB 57%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 18 23:58:01 - 23:59:59 27 0.1% 0.2383.3 KB 0.1% 0.70
Sep 19 00:00:00 - 00:59:59 982 5.2% 0.272.5 MB 4.3% 0.71
Sep 19 01:00:00 - 01:59:59 1017 5.3% 0.283.2 MB 5.5% 0.92
Sep 19 02:00:00 - 02:59:59 1107 5.8% 0.313.0 MB 5.1% 0.86
Sep 19 03:00:00 - 03:59:59 1055 5.5% 0.293.9 MB 6.6% 1.11
Sep 19 04:00:00 - 04:59:59 1208 6.3% 0.343.7 MB 6.4% 1.06
Sep 19 05:00:00 - 05:59:59 1189 6.2% 0.333.9 MB 6.7% 1.11
Sep 19 06:00:00 - 06:59:59 1064 5.6% 0.303.5 MB 6.0% 0.99
Sep 19 07:00:00 - 07:59:59 1038 5.5% 0.292.9 MB 4.9% 0.82
Sep 19 08:00:00 - 08:59:59 946 5.0% 0.263.2 MB 5.5% 0.92
Sep 19 09:00:00 - 09:59:59 848 4.5% 0.242.3 MB 3.9% 0.66
Sep 19 10:00:00 - 10:59:59 656 3.4% 0.181.9 MB 3.2% 0.54
Sep 19 11:00:00 - 11:59:59 548 2.9% 0.151.7 MB 2.8% 0.47
Sep 19 12:00:00 - 12:59:59 412 2.2% 0.111.3 MB 2.2% 0.36
Sep 19 13:00:00 - 13:59:59 364 1.9% 0.101.6 MB 2.8% 0.46
Sep 19 14:00:00 - 14:59:59 381 2.0% 0.112.0 MB 3.5% 0.58
Sep 19 15:00:00 - 15:59:59 407 2.1% 0.111.1 MB 1.9% 0.31
Sep 19 16:00:00 - 16:59:59 470 2.5% 0.131.7 MB 3.0% 0.49
Sep 19 17:00:00 - 17:59:59 502 2.6% 0.141.5 MB 2.6% 0.44
Sep 19 18:00:00 - 18:59:59 565 3.0% 0.161.8 MB 3.1% 0.51
Sep 19 19:00:00 - 19:59:59 742 3.9% 0.211.9 MB 3.2% 0.54
Sep 19 20:00:00 - 20:59:59 902 4.7% 0.252.3 MB 3.9% 0.65
Sep 19 21:00:00 - 21:59:59 963 5.1% 0.272.6 MB 4.4% 0.74
Sep 19 22:00:00 - 22:59:59 870 4.6% 0.242.4 MB 4.2% 0.69
Sep 19 23:00:00 - 23:58:01 765 4.0% 0.222.4 MB 4.2% 0.72
TOTAL: 24:00:00 19028 100.0% 0.2258.5 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.5 GB 57.1% 0 0.28 2194.51
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.9 GB 65.8% 0 0.29 2084.52
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB361.7 MB 0.7% 0 0.0235555.56
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.2 GB 54.3% 0 0.62 972.46
TOTAL: 10-500.0 GB88.9 GB 17.8% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2564 5 0 7 0 0 0 0 2552
2bbsnz-out.feed.uzoreto.com 840 26 0 4 2 0 0 0 808
3bbs-nz-out.news.weretis.net 486 49 0 14 0 0 0 0 423
4news-out.mixmin.net 395 0 0 5 0 0 0 0 390
5news.albasani.net 366 2 0 5 0 0 0 0 359
6newsfeed.neva.ru 208 28 0 5 0 0 0 0 175
7news.redatomik.org 157 0 0 8 0 0 0 0 149
8feeder.eternal-september.org 151 0 0 10 3 0 0 0 138
9news-out.aioe.org 69 49 0 6 0 0 0 0 14
10news.freedyn.net 34 1 0 6 0 0 0 0 27
11news.swapon.de 33 0 0 0 0 0 0 0 33
12agency-nz-out.news.mb-net.net 21 9 0 7 0 0 0 0 5
13news.samoylyk.net 14 0 0 8 0 0 0 0 6
14feeder.awxg.com 9 0 0 9 0 0 0 0 0
15csiph.com 4 0 0 4 0 0 0 0 0
TOTAL: 15 5351 169 0 98 5 0 0 0 5079

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 38
gmane.linux.alsa.devel 33
gmane.linux.kernel 17
mozilla.dev.ui-alerts 9
fido7.ru.android 7
mozilla.dev.platform 7
it.annunci.immobiliari 6
it.annunci.commerciali 6
it.annunci.varie 6
mozilla.support.seamonkey 4
gmane.linux.bios.flashrom 4
mozilla.support.bugzilla 3
gmane.comp.gis.openstreetmap.imports 3
mozilla.dev.security.policy 3
mozilla.dev.version-control 2
alt.aviation 2
trollnet.cinema 2
mozilla.dev.webdev 2
su.market 2
mozilla.tools.treeherder 2
TOTAL: 31 169

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
clari.usa.law.supreme 5
TOTAL: 1 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3879
EMP (phn path) 502
Binary: non-binary distribution 109
Too many newsgroups 78
User-issued cancel 71
EMP (phl) 60
Binary: misplaced par2 43
EMP (phn nph) 11
User-issued spam cancel 5
Binary: misplaced rar 3
Binary: misplaced 047 2
Binary Image: misplaced jpg 1
Binary: misplaced 237 1
HTML Multipart without Text/Plain. 1
Binary: misplaced 012 1
Binary: misplaced 104 1
TOTAL: 16 4768

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 2
TOTAL: 1 2
Bad Message-ID's offered
bbsnz-out.feed.uzoreto.com 1
TOTAL: 1 1
Including strange strings
news.redatomik.org 106
bbs-nz-out.news.weretis.net 60
news.albasani.net 53
news-out.mixmin.net 34
news.swapon.de 33
news-out.aioe.org 8
bbsnz-out.feed.uzoreto.com 7
news.snarked.org 5
feeder.eternal-september.org 1
agency-nz-out.news.mb-net.net 1
TOTAL: 10 308
TOTAL: 3 311

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17356 723 16623 11 0 0 4%24:00:45
2awxg 18596 45 18542 2 0 0 0%24:00:25
3news.freedyn.net 19080 11 18984 0 0 21 0%24:00:28
4csiph.com 18871 9 18810 0 0 0 0%24:00:11
5weretis.net 13795 7 13782 0 0 0 0%24:00:27
6news-in.mixmin.net 17890 7 17871 0 0 5 0%24:00:25
7news.redatomik.org 17610 7 17573 0 0 7 0%24:00:11
8eternal-september 16202 7 16154 0 0 28 0%23:59:50
9news.samoylyk.net 17360 7 17302 0 0 215 0%24:00:28
10news.snarked.org 16391 7 16299 0 0 27 0%24:00:06
11aioe 15634 7 15529 0 0 0 0%23:59:50
12neva.ru 17926 6 17918 1 0 0 0%24:00:25
13news.albasani.net 20191 5 16947 1062 0 6877 0%24:00:36
14news.swapon.de 1596 4 1585 0 0 7 0%23:52:23
15news.uzoreto.com 20469 2 20440 4 0 49 0%24:00:23
16mb-net.net 19030 2 18945 0 0 207 0%24:00:46
TOTAL: 16 267997 856 263304 1080 0 7443 0%383:57:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.5 MB47.9 KB6.6 MB0.1 KB/s9.1 KB24:00:45
2awxg141.3 KB6.1 KB147.4 KB0.0 KB/s3.1 KB24:00:25
3news.freedyn.net25.2 KB0.0 KB25.2 KB0.0 KB/s2.3 KB24:00:28
4csiph.com20.8 KB0.0 KB20.8 KB0.0 KB/s2.3 KB24:00:11
5weretis.net12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB24:00:27
6news-in.mixmin.net12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB24:00:25
7news.redatomik.org12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB24:00:11
8eternal-september12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB23:59:50
9news.samoylyk.net12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB24:00:28
10news.snarked.org12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB24:00:06
11aioe12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB23:59:50
12neva.ru9.4 KB2.8 KB12.2 KB0.0 KB/s1.7 KB24:00:25
13news.albasani.net8.8 KB5.0 MB5.0 MB0.1 KB/s4.8 KB24:00:36
14news.swapon.de7.3 KB0.0 KB7.3 KB0.0 KB/s1.8 KB23:52:23
15mb-net.net3.7 KB0.0 KB3.7 KB0.0 KB/s1.9 KB24:00:46
16news.uzoreto.com2.2 KB8.5 KB10.7 KB0.0 KB/s1.8 KB24:00:23
TOTAL: 166.8 MB5.1 MB11.9 MB0.0 KB/s6.3 KB383:57:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 403 585820.7 MB 3395 6 000:17:16
2vorlon.activateit.net.au 24 11851.5 MB 139 0 000:05:37
360.234.68.122 14 918.8 KB 4 1 000:31:21
4184.55.182.252 2 516.9 KB 2 0 000:02:43
TOTAL: 4 443 705722.3 MB 3837 7 013:27:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 403 585820.7 MB 3395 6 000:17:16
2*.activateit.net.au 24 11851.5 MB 139 0 000:05:37
3unresolved 19 1435.7 KB 6 1 000:37:09
4*.cpe.cableone.net 5 00.0 KB 0 0 012:27:38
TOTAL: 4 451 705722.3 MB 3837 7 013:27:43

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 11
malcolmlewis 5
TOTAL: 3 40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.336 0.092 0.01312:27:38
60.234.68.122 0.880 0.124 0.02900:31:21
agency.bbs.nz 29.752 6.884 0.00000:17:16
vorlon.activateit.net.au 1.572 0.512 0.12500:05:37
118.149.140.187 0.192 0.028 0.00000:03:05
184.55.182.252 0.272 0.056 0.00000:02:43
? 1.168 0.128 0.00000:00:01
TOTAL: 7 34.172 7.824 0.16713:27:43

Curious NNRP server explorers [Top 20]:

SystemConn
160-3-245-118.cpe.cableone.net 5
118.149.140.187 3
TOTAL: 2 8

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 5
TOTAL: 1 5

NNRP client timeouts [Top 20]:

SystemConnPeer
160-3-245-118.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 120633 94.7%
2rec 2531 2.0%
3comp 1002 0.8%
4uk 731 0.6%
5sci 706 0.6%
6soc 680 0.5%
7linux 536 0.4%
8talk 297 0.2%
9misc 115 0.1%
10news 38 0.0%
11mozilla 31 0.0%
12agency 9 0.0%
13microsoft 8 0.0%
14humanities 7 0.0%
15nz 7 0.0%
16aus 2 0.0%
TOTAL: 16 127333100.0%

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

NewsgroupCount
1alt.philosophy.taoism 43782
2alt.os.linux.ubuntu 21037
3alt.pl.praca.oferowana 17453
4alt.philosophy.zen 9519
5alt.photography 3611
6alt.penthouse.sex.phone 3240
7alt.penthouse.sex.telephone 1981
8alt.pl.misc.samochody.gielda 1934
9alt.pl.allegro 1650
10alt.personals.phone 1387
11alt.philosophy.checkmate 1378
12alt.personals.misc 760
13rec.arts.tv 750
14alt.pl.dupa 657
15alt.penthouse.sex.masturbation 591
16alt.penpals.erotic 583
17alt.penthouse.sex.safe 556
18alt.penthouse.sex.masterbation 530
19alt.paranormal.spells.hexes.magic 503
20alt.philosophy.objectivism 490
21alt.penthouse.sex.fetish.wet-and-messy 463
22alt.penthouse.sex.services 434
23alt.penthouse.sex.tasteless 385
24alt.penthouse.sex.wanted 375
25alt.paranet.metaphysics 362
26uk.d-i-y 309
27alt.paranormal 299
28alt.personals.poly 293
29comp.lang.c++ 266
30alt.penthouse.sex.sissy 262
31rec.arts.sf.written 256
32rec.arts.drwho 252
33uk.legal 240
34alt.parenting.twins-triplets 230
35alt.pagan.contacts 225
36alt.penthouse.sex.voyeurism 223
37alt.penthouse.sex.wanted.escorts.ads 222
38linux.debian.bugs.dist 206
39alt.paranet.ufo 204
40rec.food.cooking 199
41talk.origins 197
42alt.periodismo 186
43alt.personals.fetish 174
44alt.party 174
45alt.pagan 168
46sci.physics 166
47alt.comp.os.windows-10 160
48comp.lang.c 156
49rec.sport.football.college 152
50alt.penthouse.sex.sissy.slut 147
51sci.electronics.design 146
52alt.personals.interracial 138
53alt.personals.gay 133
54linux.debian.changes.devel 131
55alt.pirate.radio 131
56sci.physics.relativity 125
57alt.pets.cats 122
58alt.personals 111
59alt.personals.motss 109
60rec.drugs.cannabis 108
61comp.os.linux.advocacy 107
62alt.pets.rabbits 103
63alt.os.windows-xp 98
64alt.pl.shemale 97
65alt.penpals.forty-plus-yrs 93
66alt.personals.bondage 92
67alt.pl.comp.os.hacking 90
68talk.politics.guns 86
69alt.pigwalk 83
70sci.logic 82
71alt.personals.montreal 81
72linux.debian.bugs.rc 79
73soc.culture.israel 79
74alt.philosophy.debate 78
75rec.sport.tennis 78
76comp.lang.python 76
77soc.culture.polish 75
78alt.politics.trump 74
79alt.personals.bi.pennsylvania 71
80soc.culture.china 71
81alt.philosophy.law 70
82alt.personals.calgary 67
83uk.radio.amateur 67
84rec.sport.pro-wrestling 67
85alt.out-of-body 67
86alt.pl.comp.os.windowsxp 64
87soc.retirement 63
88alt.pl.misc.samochody.peugeot 62
89rec.gambling.poker 60
90alt.personals.bi 60
91alt.conspiracy.jfk 52
92soc.culture.brazil 52
93misc.survivalism 47
94rec.boats 46
95comp.mobile.ipad 46
96alt.os.multics 46
97alt.pl.comp.os.linux.newbie 44
98alt.peeves 43
99alt.pets.rodents.rats 41
100rec.bicycles.tech 41
TOTAL: 612 127333