news.bbs.nz daily logs

Sep 5 23:58:01 -- Sep 6 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124759 59.5%9.7 MB 36.8%
innd 34771 16.6%5.4 MB 20.6%
innfeed 26411 12.6%5.1 MB 19.4%
inn 22250 10.6%5.9 MB 22.3%
cnfsstat 1450 0.7%256.2 KB 0.9%
controlchan 3 0.0%0.3 KB 0.0%
TOTAL: 6 209644 100.0%26.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 281462 48.3%
Positive hits 279521 47.9%
Do not exist 21558 3.7%
Cache misses 479 0.1%
TOTAL: 4 583020 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.526 0.0%86 0.000 6.116 161.000
article cleanup00:00:00.236 0.0%21868 0.000 0.011 0.049
article logging00:00:00.662 0.0%22169 0.000 0.030 0.232
article parse00:00:00.711 0.0%70226 0.000 0.010 0.028
article write00:00:03.872 0.0%18342 0.013 0.211 9.764
artlog/artcncl00:00:00.002 0.0%84 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.714 0.0%562052 0.000 0.001 0.038
hisgrep/artcncl00:00:00.264 0.0%85 0.000 3.106 126.000
hishave/artcncl00:00:00.051 0.0%86 0.000 0.593 22.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:32.841 0.0%586499 0.001 0.056 0.946
history sync00:00:00.011 0.0%374 0.000 0.029 0.500
history write00:00:27.650 0.0%21688 0.000 1.275 19.522
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:46:44.198 99.7%575157 81.756 148.836 456.420
nntp read00:00:03.720 0.0%576409 0.003 0.006 0.023
overview write00:01:05.476 0.1%18342 0.089 3.570 61.094
perl filter00:00:43.475 0.1%21686 1.302 2.005 6.111
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.933 0.0%36684 0.003 0.025 0.077
TOTAL: 23:50:57.46923:49:45.342 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.060 0.0%27686 0.000 0.002 0.030
article prepare00:00:00.001 0.0%12312 0.000 0.000 0.001
article read00:00:00.555 0.0%2416 0.000 0.230 19.000
backlog stats00:00:00.401 0.0%320332 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.832 0.0%261337 0.002 0.007 0.017
data write00:00:03.002 0.0%249575 0.006 0.012 0.023
idle23:43:17.986 99.9%320332 138.796 266.592 580.892
status file00:00:26.822 0.0%2054 0.667 13.058 438.692
TOTAL: 23:44:12.59323:43:50.659100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle13:26:41.128 99.5%134705 0.000 359.312 38882.541
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.524 0.0%276428 0.000 0.006 0.333
readart00:00:01.871 0.0%6883 0.000 0.272 4.789
TOTAL: 13:31:06.69313:26:44.523 99.5%----

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
shutdown 3
throttle 2
TOTAL: 13 174

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 9 39562 5199 34061 302 13%49:47:13
2news.snarked.org 36 21020 2942 16718 1360 13%33:54:39
3bbsnz-out.feed.uzoreto.com 1117 27588 2545 24189 854 9%94:27:35
4feeder.eternal-september.org 16 20581 2056 18429 96 9%26:14:19
5news-out.aioe.org 2 18488 1624 16845 19 8%23:44:38
6news-out.mixmin.net 4 17587 1314 15825 448 7%22:19:02
7newsfeed.neva.ru 141 12002 1152 10691 159 9%71:03:52
8news.redatomik.org 3 18076 714 17334 28 3%23:44:36
9news.albasani.net 2 19735 266 19373 96 1%24:45:05
10csiph.com 3 21814 236 21570 8 1%29:31:49
11news.swapon.de 7 1904 146 1758 0 7%29:52:12
12agency-nz-out.news.mb-net.net 5 19198 86 19088 24 0%23:22:04
13news.samoylyk.net 4 17511 56 17440 15 0%25:01:38
14localhost 498 497 53 444 0 10%00:00:00
15feeder.awxg.com 2 19969 25 19924 20 0%30:46:52
16news.freedyn.net 2 29588 13 29572 3 0%38:01:00
17news.ausics.org 1 50407 1 50391 15 0%81:27:56
TOTAL: 17 1852 355527 18428 333652 3447 5%628:04:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net21.4 MB1.0 MB1.9 MB24.3 MB 88%4.5 KB
2news.snarked.org8.9 MB79.1 KB15.0 MB24.0 MB 36%5.7 KB
3bbsnz-out.feed.uzoreto.com8.6 MB27.9 KB7.2 MB15.8 MB 54%4.8 KB
4feeder.eternal-september.org6.0 MB573.8 KB1.3 MB7.8 MB 76%3.7 KB
5news-out.mixmin.net4.4 MB15.1 KB884.4 KB5.3 MB 83%3.1 KB
6news-out.aioe.org4.2 MB21.0 KB124.8 KB4.3 MB 96%2.7 KB
7news.redatomik.org2.9 MB475.9 KB609.7 KB4.0 MB 73%5.5 KB
8newsfeed.neva.ru2.6 MB175.8 KB782.0 KB3.6 MB 73%2.8 KB
9news.albasani.net1.1 MB445.4 KB663.0 KB2.2 MB 51%6.3 KB
10csiph.com590.3 KB40.2 KB42.0 KB672.5 KB 87%2.8 KB
11news.swapon.de395.5 KB0.0 KB0.0 KB395.5 KB100%2.7 KB
12agency-nz-out.news.mb-net.net212.1 KB35.5 KB88.8 KB336.4 KB 63%3.1 KB
13news.samoylyk.net177.8 KB503.1 KB504.2 KB1.2 MB 15%16.7 KB
14localhost132.5 KB0.0 KB0.0 KB132.5 KB100%2.5 KB
15feeder.awxg.com59.9 KB83.2 KB198.0 KB341.1 KB 17%7.6 KB
16news.freedyn.net31.2 KB445.0 KB962.2 KB1.4 MB 2%89.9 KB
17news.ausics.org1.7 KB69.0 KB69.0 KB139.7 KB 1%8.7 KB
TOTAL: 1761.7 MB4.0 MB30.2 MB95.8 MB 64%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 23:58:01 - 23:59:59 19 0.1% 0.1662.1 KB 0.1% 0.52
Sep 6 00:00:00 - 00:59:59 1050 5.7% 0.292.8 MB 4.6% 0.81
Sep 6 01:00:00 - 01:59:59 966 5.3% 0.273.6 MB 5.8% 1.02
Sep 6 02:00:00 - 02:59:59 1002 5.5% 0.282.9 MB 4.7% 0.82
Sep 6 03:00:00 - 03:59:59 1193 6.5% 0.334.7 MB 7.6% 1.33
Sep 6 04:00:00 - 04:59:59 988 5.4% 0.273.8 MB 6.1% 1.07
Sep 6 05:00:00 - 05:59:59 975 5.3% 0.272.8 MB 4.5% 0.79
Sep 6 06:00:00 - 06:59:59 953 5.2% 0.263.2 MB 5.3% 0.92
Sep 6 07:00:00 - 07:59:59 1042 5.7% 0.293.4 MB 5.6% 0.97
Sep 6 08:00:00 - 08:59:59 1036 5.6% 0.293.2 MB 5.2% 0.91
Sep 6 09:00:00 - 09:59:59 798 4.4% 0.222.6 MB 4.3% 0.75
Sep 6 10:00:00 - 10:59:59 608 3.3% 0.172.1 MB 3.3% 0.58
Sep 6 11:00:00 - 11:59:59 503 2.7% 0.142.0 MB 3.2% 0.56
Sep 6 12:00:00 - 12:59:59 445 2.4% 0.121.9 MB 3.1% 0.54
Sep 6 13:00:00 - 13:59:59 407 2.2% 0.111.9 MB 3.1% 0.55
Sep 6 14:00:00 - 14:59:59 410 2.2% 0.111.4 MB 2.3% 0.41
Sep 6 15:00:00 - 15:59:59 400 2.2% 0.111.7 MB 2.8% 0.49
Sep 6 16:00:00 - 16:59:59 349 1.9% 0.101.6 MB 2.6% 0.45
Sep 6 17:00:00 - 17:59:59 533 2.9% 0.151.5 MB 2.4% 0.42
Sep 6 18:00:00 - 18:59:59 662 3.6% 0.181.8 MB 2.9% 0.50
Sep 6 19:00:00 - 19:59:59 645 3.5% 0.181.7 MB 2.8% 0.50
Sep 6 20:00:00 - 20:59:59 820 4.5% 0.233.0 MB 4.9% 0.86
Sep 6 21:00:00 - 21:59:59 880 4.8% 0.242.4 MB 4.0% 0.69
Sep 6 22:00:00 - 22:59:59 833 4.5% 0.232.5 MB 4.1% 0.72
Sep 6 23:00:00 - 23:58:01 822 4.5% 0.243.0 MB 4.8% 0.87
TOTAL: 24:00:00 18339 100.0% 0.2161.6 MB 100.0% 0.73
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.2 GB 56.5% 0 0.27 2281.00
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.6 GB 65.1% 0 0.36 1686.44
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB359.9 MB 0.7% 0 0.0230920.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 GB26.6 GB 53.1% 0 0.60 1003.87
TOTAL: 10-500.0 GB87.8 GB 17.6% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1429 6 0 21 0 0 0 0 1402
2bbsnz-out.feed.uzoreto.com 861 15 0 6 0 0 0 0 840
3news-out.mixmin.net 583 0 0 6 5 0 0 0 572
4bbs-nz-out.news.weretis.net 401 49 0 19 3 0 0 0 330
5newsfeed.neva.ru 164 14 0 32 0 0 0 0 118
6feeder.eternal-september.org 99 0 0 14 0 0 0 0 85
7news.albasani.net 86 0 0 2 0 0 0 0 84
8news.redatomik.org 44 0 0 9 1 0 0 0 34
9news.swapon.de 36 0 0 0 0 0 0 0 36
10news-out.aioe.org 32 14 0 5 0 0 0 0 13
11agency-nz-out.news.mb-net.net 24 3 0 8 0 0 0 0 13
12feeder.awxg.com 23 0 0 20 0 0 0 0 3
13news.ausics.org 18 0 0 15 0 0 0 0 3
14news.samoylyk.net 15 0 0 14 0 0 0 0 1
15csiph.com 9 0 0 7 0 0 0 0 2
16news.freedyn.net 3 0 0 2 0 0 0 0 1
TOTAL: 16 3827 101 0 180 9 0 0 0 3537

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 32
mozilla.support.seamonkey 10
gmane.comp.gis.openstreetmap.tagging 9
mozilla.dev.ui-alerts 7
it.annunci.varie 3
it.annunci.immobiliari 3
mozilla.dev.builds 3
gmane.linux.kernel 3
alt.politics.conservative 3
it.annunci.commerciali 3
alt.aviation 3
eagle.support.eng 2
alt.music.pink-floyd.publius 2
mozilla.dev.tech.js-engine.internals 2
alt.fr.os.windows.7 2
gmane.linux.alsa.user 2
mozilla.dev.telemetry-alerts 1
rec.food-cooking 1
alt.religion.christian.romman-catholic 1
mozilla.dev.tech.layout 1
TOTAL: 28 101

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

GroupsCount
netscape.public.mozilla.newsclips 9
TOTAL: 1 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2551
EMP (phn path) 452
EMP (phl) 96
Too many newsgroups 44
EMP (phn nph) 20
User-issued cancel 18
Binary: misplaced par2 18
Binary: non-binary distribution 17
User-issued spam cancel 5
Too many newsgroups (meow) 2
Binary Image: misplaced jpg 2
Binary: misplaced 006 2
Binary: misplaced rar 2
Binary: misplaced 012 1
Binary: misplaced 110 1
Binary: misplaced 217 1
Binary: misplaced 026 1
Binary: misplaced 138 1
TOTAL: 18 3234

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 118
news-out.mixmin.net 98
news.swapon.de 36
news.redatomik.org 15
news.albasani.net 8
bbsnz-out.feed.uzoreto.com 8
news-out.aioe.org 6
newsfeed.neva.ru 5
news.snarked.org 4
feeder.eternal-september.org 2
TOTAL: 11 301
TOTAL: 2 302

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16715 1150 15543 22 0 61 6%23:55:16
2news.freedyn.net 20994 162 18082 82 0 145 0%23:55:12
3awxg 17865 88 17772 2 0 66 0%23:55:12
4news.snarked.org 15439 50 15240 2 0 161 0%23:55:12
5csiph.com 18195 49 18086 1 0 62 0%23:55:12
6weretis.net 12953 46 12901 0 0 52 0%23:55:12
7aioe 15688 42 15574 0 0 41 0%23:55:10
8eternal-september 16047 36 15940 1 0 282 0%23:55:12
9news-in.mixmin.net 16564 36 16513 0 0 12 0%23:55:12
10news.samoylyk.net 16778 28 16636 1 0 396 0%23:55:12
11mb-net.net 18265 28 18212 0 0 67 0%23:55:12
12news.swapon.de 1512 28 1483 0 0 7 1%23:42:09
13neva.ru 16777 26 16723 17 0 72 0%23:55:12
14news.redatomik.org 17618 25 17566 3 0 67 0%23:55:12
15news.albasani.net 20397 4 16582 960 0 7956 0%23:53:26
16news.uzoreto.com 15745 3 15711 26 0 75 0%23:55:00
17newsfeed.datemas.de 0 0 0 0 0 16523 0%21:53:11
TOTAL: 17 257552 1801 248564 1117 0 26045 0%404:21:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.3 MB274.9 KB10.6 MB0.1 KB/s9.3 KB23:55:16
2news.freedyn.net590.7 KB359.1 KB949.8 KB0.0 KB/s3.9 KB23:55:12
3awxg248.4 KB6.8 KB255.2 KB0.0 KB/s2.8 KB23:55:12
4news.snarked.org127.4 KB3.8 KB131.2 KB0.0 KB/s2.5 KB23:55:12
5weretis.net121.7 KB0.0 KB121.7 KB0.0 KB/s2.6 KB23:55:12
6eternal-september105.4 KB25.2 KB130.6 KB0.0 KB/s3.5 KB23:55:12
7news-in.mixmin.net105.4 KB0.0 KB105.4 KB0.0 KB/s2.9 KB23:55:12
8aioe93.3 KB0.0 KB93.3 KB0.0 KB/s2.2 KB23:55:10
9news.samoylyk.net92.2 KB7.7 KB99.9 KB0.0 KB/s3.4 KB23:55:12
10mb-net.net92.2 KB0.0 KB92.2 KB0.0 KB/s3.3 KB23:55:12
11news.swapon.de92.2 KB0.0 KB92.2 KB0.0 KB/s3.3 KB23:42:09
12csiph.com86.2 KB41.2 KB127.4 KB0.0 KB/s2.5 KB23:55:12
13news.redatomik.org49.3 KB42.8 KB92.2 KB0.0 KB/s3.3 KB23:55:12
14neva.ru42.3 KB64.5 KB106.8 KB0.0 KB/s2.5 KB23:55:12
15news.albasani.net16.4 KB4.8 MB4.8 MB0.1 KB/s5.1 KB23:53:26
16news.uzoreto.com3.8 KB90.2 KB93.9 KB0.0 KB/s3.2 KB23:55:00
17newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s021:53:11
TOTAL: 1712.2 MB5.7 MB17.9 MB0.0 KB/s6.3 KB404:21:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 397 557719.7 MB 3273 57 91400:16:00
2vorlon.activateit.net.au 24 9281.3 MB 138 0 000:04:44
3160-3-245-118.cpe.cableone.net 3 35.6 KB 1 0 013:07:03
TOTAL: 3 424 650821.0 MB 3412 57 91413:31:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 397 557719.7 MB 3273 57 91400:16:00
2*.activateit.net.au 24 9281.3 MB 138 0 000:04:44
3*.cpe.cableone.net 3 35.6 KB 1 0 013:07:03
4unresolved 3 00.0 KB 0 0 000:03:04
5*.dyn.optonline.net 5 00.0 KB 0 0 000:00:05
TOTAL: 5 432 650821.0 MB 3412 57 91413:31:00

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 3
TOTAL: 2 27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.180 0.044 0.00413:07:03
agency.bbs.nz 28.824 6.732 0.00000:16:00
vorlon.activateit.net.au 1.404 0.344 0.21200:04:44
118.149.222.173 0.168 0.032 0.00000:03:04
ool-4578089a.dyn.optonline.net 0.264 0.032 0.00000:00:05
? 1.092 0.128 0.00000:00:01
TOTAL: 6 31.932 7.312 0.21613:31:00

Curious NNRP server explorers [Top 20]:

SystemConn
ool-4578089a.dyn.optonline.net 5
118.149.222.173 3
TOTAL: 2 8

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2498 38.4%
2comp 851 13.1%
3soc 666 10.2%
4sci 575 8.8%
5uk 572 8.8%
6linux 556 8.5%
7alt 381 5.9%
8talk 150 2.3%
9misc 89 1.4%
10news 76 1.2%
11mozilla 40 0.6%
12nz 23 0.4%
13microsoft 17 0.3%
14humanities 10 0.2%
15aus 2 0.0%
TOTAL: 15 6506100.0%

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

NewsgroupCount
1rec.arts.tv 620
2rec.food.cooking 288
3rec.arts.drwho 280
4uk.d-i-y 258
5uk.legal 201
6comp.lang.python 196
7linux.debian.bugs.dist 180
8linux.debian.changes.devel 179
9rec.sport.tennis 169
10rec.sport.football.college 155
11comp.lang.c 137
12sci.physics 136
13comp.os.linux.advocacy 123
14alt.comp.os.windows-10 120
15sci.physics.relativity 93
16linux.debian.bugs.rc 91
17rec.drugs.cannabis 88
18alt.conspiracy.jfk 87
19soc.penpals 81
20soc.culture.china 77
21rec.outdoors.rv-travel 75
22sci.electronics.design 70
23rec.gambling.poker 68
24alt.politics.trump 67
25news.lists.filters 67
26rec.arts.sf.written 66
27sci.logic 66
28rec.sport.golf 66
29soc.retirement 64
30soc.culture.polish 62
31sci.math 59
32talk.origins 59
33rec.sport.pro-wrestling 59
34rec.boats 57
35talk.politics.guns 56
36soc.culture.israel 54
37rec.aviation.soaring 54
38rec.bicycles.tech 46
39comp.lang.c++ 45
40alt.conspiracy 44
41rec.music.classical.recordings 42
42rec.photo.digital 40
43misc.survivalism 38
44comp.sys.raspberry-pi 36
45comp.ai.philosophy 33
46rec.autos.sport.f1 33
47soc.culture.brazil 32
48soc.culture.indian 31
49uk.radio.amateur 31
50comp.mobile.android 30
51comp.sys.apple2 27
52uk.legal.moderated 27
53alt.test 26
54soc.culture.vietnamese 26
55nz.general 23
56sci.military.naval 22
57misc.invest.stocks 22
58soc.history.living 22
59comp.lang.forth 21
60talk.politics.misc 21
61sci.bio.paleontology 20
62soc.genealogy.medieval 20
63sci.med.cardiology 20
64soc.history 19
65sci.med.pharmacy 18
66mozilla.general 17
67soc.culture.usa 17
68mozilla.support.thunderbird 17
69linux.debian.user 16
70comp.lang.tcl 15
71comp.os.vms 15
72rec.crafts.metalworking 15
73sci.lang 15
74linux.debian.user.italian 14
75alt.os.linux.ubuntu 14
76rec.radio.shortwave 14
77soc.genealogy.britain 13
78soc.culture.greek 12
79rec.games.backgammon 12
80uk.rec.cycling.moderated 11
81comp.lang.fortran 11
82comp.sys.apple2.programmer 11
83comp.os.linux.misc 11
84rec.music.dylan 11
85humanities.lit.authors.shakespeare 10
86microsoft.public.windowsxp.general 10
87comp.lang.clipper.visual-objects 10
88soc.culture.german 10
89talk.bizarre 10
90rec.radio.amateur.misc 10
91rec.arts.sf.tv 10
92comp.sys.mac.system 10
93comp.sys.acorn.programmer 10
94rec.sport.billiard 10
95uk.rec.cycling 9
96uk.tech.digital-tv 9
97rec.games.pinball 9
98linux.gentoo.user 9
99alt.hacker 8
100rec.arts.tv.uk.coronation-st 8
TOTAL: 350 6506