news.bbs.nz daily logs

Oct 26 23:58:01 -- Oct 27 23:58:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 27 00:14:30 news nnrpd[7030]: agency.bbs.nz rejected Expiring process 7027

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135194 63.1%10.7 MB 41.2%
innd 32339 15.1%5.2 MB 20.0%
innfeed 24685 11.5%4.8 MB 18.6%
inn 20628 9.6%5.0 MB 19.3%
cnfsstat 1440 0.7%252.3 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 214287 100.0%26.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 261693 48.8%
Positive hits 254061 47.4%
Do not exist 19922 3.7%
Cache misses 296 0.1%
TOTAL: 4 535972 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.228 0.0%30 0.000 7.600 37.000
article cleanup00:00:00.190 0.0%20303 0.000 0.009 0.054
article logging00:00:00.513 0.0%20619 0.000 0.025 0.102
article parse00:00:00.595 0.0%57995 0.000 0.010 0.033
article write00:00:02.128 0.0%16215 0.000 0.131 7.142
artlog/artcncl00:00:00.001 0.0%30 0.000 0.033 0.111
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.657 0.0%511157 0.000 0.001 0.016
hisgrep/artcncl00:00:00.026 0.0%29 0.000 0.897 6.000
hishave/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.348 0.0%541823 0.002 0.017 0.797
history sync00:00:00.013 0.0%344 0.000 0.038 1.000
history write00:00:40.553 0.0%20100 0.000 2.018 20.525
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:58.282 99.7%521345 93.336 165.377 412.772
nntp read00:00:04.396 0.0%523435 0.002 0.008 0.070
overview write00:00:41.268 0.0%16215 0.020 2.545 71.170
perl filter00:00:36.754 0.0%20097 1.036 1.829 5.809
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.884 0.0%32430 0.000 0.027 0.357
TOTAL: 24:00:41.88723:59:15.836 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%21531 0.000 0.003 0.021
article prepare00:00:00.001 0.0%5688 0.000 0.000 0.036
article read00:00:00.252 0.0%1326 0.000 0.190 8.944
backlog stats00:00:00.455 0.0%282755 0.000 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.910 0.0%232647 0.003 0.008 0.014
data write00:00:02.578 0.0%220299 0.004 0.012 0.025
idle23:53:42.435 99.9%282755 185.388 304.230 643.696
status file00:00:24.553 0.0%1907 0.300 12.875 609.657
TOTAL: 23:54:32.51423:54:12.243100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle28:11:13.684 99.3%161404 0.000 628.694 90057.891
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.269 0.0%374320 0.000 0.006 0.800
readart00:00:01.765 0.0%7428 0.000 0.238 9.500
TOTAL: 28:22:17.58728:11:17.718 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 6 32465 3771 28359 335 11%46:52:38
2news.snarked.org 26 20623 3246 15339 2038 15%30:24:57
3bbsnz-out.feed.uzoreto.com 864 26857 2309 23953 595 8%71:18:00
4feeder.eternal-september.org 4 18709 2142 16309 258 11%24:36:13
5news-out.aioe.org 2 17457 1714 15677 66 9%25:38:24
6news-out.mixmin.net 2 17837 1093 16361 383 6%24:21:10
7newsfeed.neva.ru 146 13893 721 13047 125 5%72:20:23
8news.albasani.net 2 17691 535 16980 176 3%24:15:24
9news.redatomik.org 5 16945 434 16454 57 2%24:57:21
10csiph.com 2 16634 188 16422 24 1%23:59:54
11news.swapon.de 2 1312 102 1209 1 7%24:08:56
12agency-nz-out.news.mb-net.net 5 17921 84 17795 42 0%24:44:54
13news.samoylyk.net 2 17179 72 17080 27 0%23:59:53
14news.freedyn.net 2 18598 44 18529 25 0%24:07:21
15feeder.awxg.com 1 14887 20 14848 19 0%23:59:56
16localhost 3 2 2 0 0 100%00:00:00
17news.ausics.org 1 31573 0 31571 2 0%48:33:20
TOTAL: 17 1075 300583 16477 279933 4173 5%538:18:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net14.0 MB113.4 KB1.2 MB15.3 MB 91%3.8 KB
2news.snarked.org11.7 MB40.7 KB16.1 MB27.8 MB 42%5.4 KB
3bbsnz-out.feed.uzoreto.com6.4 MB15.3 KB3.8 MB10.2 MB 62%3.6 KB
4feeder.eternal-september.org5.8 MB331.4 KB1.4 MB7.5 MB 77%3.2 KB
5news-out.aioe.org4.1 MB105.4 KB483.5 KB4.7 MB 87%2.7 KB
6news-out.mixmin.net2.9 MB56.1 KB760.9 KB3.7 MB 78%2.5 KB
7news.albasani.net2.3 MB70.7 KB326.0 KB2.7 MB 85%3.8 KB
8newsfeed.neva.ru1.8 MB16.4 KB539.2 KB2.3 MB 76%2.8 KB
9news.redatomik.org1.4 MB54.4 KB316.7 KB1.8 MB 79%3.7 KB
10csiph.com476.2 KB58.0 KB66.9 KB601.1 KB 79%2.8 KB
11news.swapon.de279.9 KB0.0 KB0.7 KB280.6 KB 99%2.7 KB
12agency-nz-out.news.mb-net.net195.1 KB75.6 KB181.2 KB452.0 KB 43%3.6 KB
13news.samoylyk.net187.1 KB77.0 KB258.0 KB522.1 KB 35%5.3 KB
14news.freedyn.net149.5 KB62.0 KB338.1 KB549.6 KB 27%8.0 KB
15feeder.awxg.com56.8 KB72.7 KB72.7 KB202.2 KB 28%5.2 KB
16localhost2.9 KB0.0 KB0.0 KB2.9 KB100%1.5 KB
17news.ausics.org0.0 KB6.1 KB6.1 KB12.2 KB 0%6.1 KB
TOTAL: 1751.7 MB1.1 MB25.7 MB78.5 MB 65%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 26 23:58:01 - 23:59:59 24 0.1% 0.20238.2 KB 0.5% 2.00
Oct 27 00:00:00 - 00:59:59 725 4.5% 0.202.3 MB 4.5% 0.65
Oct 27 01:00:00 - 01:59:59 788 4.9% 0.222.0 MB 3.9% 0.56
Oct 27 02:00:00 - 02:59:59 874 5.4% 0.242.7 MB 5.3% 0.77
Oct 27 03:00:00 - 03:59:59 910 5.6% 0.252.3 MB 4.6% 0.66
Oct 27 04:00:00 - 04:59:59 933 5.8% 0.263.1 MB 6.1% 0.88
Oct 27 05:00:00 - 05:59:59 949 5.9% 0.262.3 MB 4.6% 0.66
Oct 27 06:00:00 - 06:59:59 1019 6.3% 0.283.3 MB 6.6% 0.95
Oct 27 07:00:00 - 07:59:59 1047 6.5% 0.293.3 MB 6.5% 0.94
Oct 27 08:00:00 - 08:59:59 940 5.8% 0.262.6 MB 5.2% 0.75
Oct 27 09:00:00 - 09:59:59 929 5.7% 0.262.9 MB 5.6% 0.81
Oct 27 10:00:00 - 10:59:59 872 5.4% 0.242.5 MB 4.9% 0.71
Oct 27 11:00:00 - 11:59:59 552 3.4% 0.151.7 MB 3.4% 0.49
Oct 27 12:00:00 - 12:59:59 461 2.8% 0.132.1 MB 4.2% 0.61
Oct 27 13:00:00 - 13:59:59 358 2.2% 0.101.2 MB 2.3% 0.34
Oct 27 14:00:00 - 14:59:59 376 2.3% 0.101.2 MB 2.4% 0.35
Oct 27 15:00:00 - 15:59:59 363 2.2% 0.101.2 MB 2.3% 0.34
Oct 27 16:00:00 - 16:59:59 302 1.9% 0.081.5 MB 3.0% 0.43
Oct 27 17:00:00 - 17:59:59 368 2.3% 0.101.8 MB 3.6% 0.52
Oct 27 18:00:00 - 18:59:59 373 2.3% 0.10926.0 KB 1.8% 0.26
Oct 27 19:00:00 - 19:59:59 470 2.9% 0.131.6 MB 3.2% 0.47
Oct 27 20:00:00 - 20:59:59 524 3.2% 0.151.8 MB 3.5% 0.50
Oct 27 21:00:00 - 21:59:59 674 4.2% 0.191.9 MB 3.7% 0.53
Oct 27 22:00:00 - 22:59:59 677 4.2% 0.192.4 MB 4.7% 0.67
Oct 27 23:00:00 - 23:58:01 689 4.3% 0.202.0 MB 3.9% 0.59
TOTAL: 24:00:00 16197 100.0% 0.1950.9 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB29.4 GB 58.7% 0 0.26 2362.20
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB33.8 GB 67.5% 0 0.29 2107.79
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB366.5 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 GB28.9 GB 57.8% 0 0.52 1175.76
TOTAL: 10-500.0 GB92.4 GB 18.5% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2015 13 0 12 0 0 0 0 1990
2bbsnz-out.feed.uzoreto.com 612 20 0 5 0 0 0 0 587
3news-out.mixmin.net 474 0 0 11 0 0 0 0 463
4bbs-nz-out.news.weretis.net 463 82 0 37 0 0 0 0 344
5feeder.eternal-september.org 251 0 0 15 0 0 0 0 236
6news.albasani.net 193 2 0 17 0 0 0 0 174
7newsfeed.neva.ru 124 17 0 4 0 0 0 0 103
8news-out.aioe.org 64 34 0 20 0 0 0 0 10
9news.redatomik.org 55 0 0 13 0 0 0 0 42
10agency-nz-out.news.mb-net.net 40 12 0 16 0 0 0 0 12
11news.swapon.de 29 0 0 0 0 0 0 0 29
12news.freedyn.net 24 1 0 9 0 0 0 0 14
13csiph.com 23 0 0 17 0 0 0 0 6
14news.samoylyk.net 20 0 0 16 0 0 0 0 4
15feeder.awxg.com 13 0 0 11 0 0 0 0 2
16news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 16 4401 181 0 204 0 0 0 0 4016

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 87
alt.music.pink-floyd.publius 16
mozilla.support.seamonkey 7
mozilla.governance 7
mozilla.dev.ui-alerts 5
mozilla.compatibility 5
eagle.support.ger 4
mozilla.test 4
gmane.linux.alsa.devel 4
eagle.announce.eng 4
alt.bestjobsusa.boston.jobs 3
it.annunci.commerciali 3
it.annunci.varie 3
it.annunci.immobiliari 3
1.test 3
alt.penthouse.sex.femdom 2
mozilla.dev.security.policy 2
gmane.comp.freedesktop.xorg.drivers.intel 1
rec.travel.resorts.all 1
gmane.linux.bios.flashrom 1
TOTAL: 36 181

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2798
EMP (phn path) 370
User-issued cancel 182
EMP (phl) 150
EMP (phn nph) 86
Too many newsgroups 56
User-issued spam cancel 18
Binary: non-binary distribution 14
Binary Image: misplaced jpg 13
Too many newsgroups (meow) 4
Binary: misplaced ARJ 1
Binary: misplaced 100 1
Binary: misplaced rar 1
Binary: misplaced 144 1
Binary: misplaced PAR2 1
HTML post 1
Binary: misplaced 235 1
TOTAL: 17 3698

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 2
TOTAL: 1 2
Including strange strings
bbs-nz-out.news.weretis.net 120
news-out.mixmin.net 70
news.snarked.org 43
news.swapon.de 29
bbsnz-out.feed.uzoreto.com 16
news.albasani.net 14
news-out.aioe.org 9
news.redatomik.org 7
feeder.awxg.com 2
newsfeed.neva.ru 2
TOTAL: 12 315
TOTAL: 3 319

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14861 672 14142 46 0 266 4%23:59:45
2awxg 15744 44 15682 1 0 0 0%23:59:37
3news.snarked.org 12980 9 12889 7 0 36 0%23:59:43
4weretis.net 12203 5 12095 2 0 0 0%23:59:14
5news.freedyn.net 16228 5 16142 2 0 0 0%23:59:45
6eternal-september 13765 3 13705 0 0 14 0%23:59:26
7aioe 13496 3 13395 0 0 0 0%23:59:45
8csiph.com 16076 3 15995 1 0 0 0%23:59:45
9news.redatomik.org 15756 2 15727 0 0 28 0%23:59:45
10neva.ru 15051 2 15042 0 0 0 0%23:59:36
11mb-net.net 16115 2 16090 0 0 0 0%23:59:32
12news.samoylyk.net 14895 2 14800 0 0 3 0%23:59:28
13news-in.mixmin.net 14856 2 14842 0 0 0 0%23:59:36
14news.albasani.net 16900 1 14857 519 0 5104 0%23:59:36
15news.swapon.de 1368 1 1366 0 0 0 0%23:52:12
16news.uzoreto.com 13741 1 13727 2 0 0 0%23:58:22
TOTAL: 16 224035 757 220496 580 0 5451 0%383:45:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.3 MB684.3 KB6.9 MB0.1 KB/s9.9 KB23:59:45
2awxg361.4 KB13.2 KB374.6 KB0.0 KB/s8.3 KB23:59:37
3news.snarked.org22.2 KB17.1 KB39.3 KB0.0 KB/s2.5 KB23:59:43
4news.freedyn.net11.1 KB27.8 KB38.9 KB0.0 KB/s5.6 KB23:59:45
5weretis.net7.6 KB2.5 KB10.1 KB0.0 KB/s1.4 KB23:59:14
6csiph.com7.5 KB4.1 KB11.6 KB0.0 KB/s2.9 KB23:59:45
7eternal-september7.0 KB0.0 KB7.0 KB0.0 KB/s2.3 KB23:59:26
8aioe5.4 KB0.0 KB5.4 KB0.0 KB/s1.8 KB23:59:45
9news.redatomik.org2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:45
10neva.ru2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:36
11mb-net.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:32
12news.samoylyk.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:28
13news-in.mixmin.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:36
14news.albasani.net1.8 KB2.6 MB2.6 MB0.0 KB/s5.1 KB23:59:36
15news.uzoreto.com1.7 KB2.9 KB4.6 KB0.0 KB/s1.5 KB23:58:22
16news.swapon.de1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:52:12
TOTAL: 166.7 MB3.3 MB10.0 MB0.0 KB/s7.7 KB383:45:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 700 536918.7 MB 2936 3 62800:20:15
2vorlon.activateit.net.au 24 9211.1 MB 134 0 000:04:59
3amigacity.xyz 71 1941.8 KB 12 0 28400:14:23
4121.98.127.111 1 23.8 KB 2 0 000:05:41
TOTAL: 4 796 631119.8 MB 3577 3 91228:22:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 700 536918.7 MB 2936 3 62800:20:15
2*.activateit.net.au 24 9211.1 MB 134 0 000:04:59
3*.xyz 71 1941.8 KB 12 0 28400:14:23
4unresolved 10 23.8 KB 2 0 000:14:30
5*.cpe.cableone.net 2 00.0 KB 0 0 027:27:59
TOTAL: 5 807 631119.8 MB 3577 3 91228:22:08

NNRP auth users [Top 20]:

UserConn
amigacity 71
amybbs 24
malcolmlewis 2
TOTAL: 3 97

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.160 0.084 0.00727:27:59
agency.bbs.nz 46.700 9.544 0.00000:20:15
amigacity.xyz 3.864 0.820 0.25900:14:23
118.149.138.177 0.572 0.072 0.00000:08:48
121.98.127.111 0.104 0.088 0.00000:05:41
vorlon.activateit.net.au 1.468 0.396 0.06300:04:59
? 0.572 0.056 0.00000:00:00
TOTAL: 7 53.440 11.060 0.32928:22:08

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.138.177 9
160-3-236-103.cpe.cableone.net 2
TOTAL: 2 11

NNRP client timeouts [Top 20]:

SystemConnPeer
agency.bbs.nz 44 44
TOTAL: 1 44 44

Newsgroup request counts (by category):

CategoryCountPct
1alt 166616 96.6%
2rec 2414 1.4%
3uk 755 0.4%
4soc 710 0.4%
5comp 616 0.4%
6linux 571 0.3%
7sci 493 0.3%
8talk 217 0.1%
9misc 93 0.1%
10mozilla 22 0.0%
11nz 19 0.0%
12news 18 0.0%
13microsoft 6 0.0%
14aus 3 0.0%
15humanities 1 0.0%
TOTAL: 15 172554100.0%

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

NewsgroupCount
1alt.religion.buddhism.nichiren 30099
2alt.religion.christian 19089
3alt.religion.vaisnava 10218
4alt.rush-limbaugh 10045
5alt.religion.scientology 9397
6alt.religion.mormon 8822
7alt.religion.christian.east-orthodox 7952
8alt.religion.eckankar 7647
9alt.religion.kibology 6625
10alt.running.out.of.newsgroup.names 4722
11alt.religion.christian.baptist 4173
12alt.religion.christian.biblestudy 3459
13alt.religion.islam 3451
14alt.home.repair 3195
15alt.religion.christian.episcopal 1961
16alt.religion.christian.pentecostal 1820
17alt.religion.hindu 1662
18alt.revisionism 1651
19alt.religion.clergy 1485
20alt.religion.christian.adventist 1284
21alt.religion.christian.last-days 1283
22alt.religion.rabbet 1099
23alt.religion.christian.roman-catholic 1066
24alt.politics.org.un 1050
25alt.religion.christian.plymouth.brethren 997
26alt.global-warming 894
27alt.politics.uk 846
28alt.humor.puns 780
29rec.arts.tv 712
30alt.romance 628
31alt.religion.jehovahs-witn 622
32alt.religion.christian.greek-catholic 613
33alt.politics.economics 597
34alt.religion.christian.presbyterian 595
35alt.religion.islam.shia 584
36alt.religion.shamanism 576
37alt.religion.sabbath-keeper 508
38alt.religion.end-times.prophecies 504
39alt.religion.druid 454
40alt.recovery.aa 434
41alt.gossip.celebrities 422
42alt.religion.unification 415
43alt.religion.wicca 385
44alt.life.sucks 384
45uk.d-i-y 361
46alt.politics.republicans 340
47alt.politics.democrats 332
48rec.arts.drwho 318
49alt.religion.w-w-church-god 304
50alt.guitar.amps 289
51alt.religion.christian.greek-orthodox 279
52alt.rock-n-roll.acdc 253
53alt.messianic 245
54alt.horror 239
55alt.law-enforcement 233
56alt.prophecies.nostradamus 226
57rec.arts.sf.written 217
58alt.religion.buddhism.tibetan 214
59alt.religion.christian.ywam 202
60linux.debian.bugs.dist 198
61alt.politics.immigration 197
62alt.os.linux.ubuntu 183
63rec.food.cooking 179
64alt.religion.scientology.xenu 174
65alt.politics.liberalism 165
66alt.obituaries 159
67comp.os.linux.advocacy 157
68rec.sport.pro-wrestling 149
69alt.religion.christian-teen 146
70alt.religion.christian.lutheran 140
71uk.legal 138
72alt.os.linux 136
73alt.religion.goddess 134
74alt.politics.elections 133
75alt.retail.grocery 132
76alt.philosophy.taoism 132
77alt.guns 131
78sci.physics 129
79alt.religion.satanism 128
80alt.religion.simpsons 125
81alt.os.linux.debian 125
82talk.origins 123
83alt.religion.gods 122
84alt.journalism 121
85alt.comp.os.windows-10 121
86alt.politics.usa.republican 118
87alt.religion.christian.20-something 116
88uk.tech.digital-tv 115
89alt.politics.media 112
90linux.debian.bugs.rc 111
91comp.lang.c 111
92alt.religion.spiritualism 110
93alt.privacy.anon-server.stats 109
94alt.politics.trump 107
95alt.happy.valley 106
96alt.religion.gay-les-bi-tran 104
97rec.boats 103
98linux.debian.changes.devel 103
99alt.religion.christian.russian-orthodox 101
100alt.revenge 101
TOTAL: 764 172554