news.bbs.nz daily logs

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

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 160032 66.1%12.9 MB 44.7%
innd 33927 14.0%5.4 MB 18.6%
innfeed 24830 10.3%5.0 MB 17.3%
inn 21935 9.1%5.3 MB 18.5%
cnfsstat 1440 0.6%252.3 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 242165 100.0%28.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 278480 49.1%
Positive hits 267361 47.1%
Do not exist 21141 3.7%
Cache misses 171 0.0%
TOTAL: 4 567153 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.107 0.0%79 0.000 1.354 9.000
article cleanup00:00:00.203 0.0%21470 0.000 0.009 0.041
article logging00:00:00.517 0.0%21866 0.000 0.024 0.091
article parse00:00:00.644 0.0%59669 0.000 0.011 0.029
article write00:00:01.646 0.0%17280 0.019 0.095 2.600
artlog/artcncl00:00:00.000 0.0%79 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.485 0.0%540250 0.000 0.001 0.025
hisgrep/artcncl00:00:00.001 0.0%72 0.000 0.014 1.000
hishave/artcncl00:00:00.000 0.0%79 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.982 0.0%571571 0.002 0.014 0.723
history sync00:00:00.018 0.0%360 0.000 0.050 0.667
history write00:00:06.248 0.0%21289 0.007 0.293 20.061
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle23:57:25.857 99.8%550938 86.511 156.544 498.786
nntp read00:00:04.482 0.0%552838 0.003 0.008 0.020
overview write00:00:44.428 0.1%17280 0.059 2.571 88.362
perl filter00:00:38.486 0.0%21286 1.093 1.808 5.259
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.987 0.0%34560 0.000 0.029 0.127
TOTAL: 24:00:46.67323:59:12.091 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.060 0.0%24197 0.000 0.002 0.025
article prepare00:00:00.001 0.0%8476 0.000 0.000 0.006
article read00:00:00.391 0.0%1961 0.000 0.199 14.688
backlog stats00:00:00.538 0.0%290944 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.291 0.0%244924 0.002 0.009 0.016
data write00:00:02.958 0.0%233597 0.006 0.013 0.024
idle23:53:58.916100.0%290944 171.706 295.723 692.460
status file00:00:05.674 0.0%1939 0.500 2.926 187.000
TOTAL: 23:54:26.92523:54:10.829100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.002 0.0%33 0.000 0.061 0.167
idle158:39:20.325 99.5%1417666 0.000 402.888 93282.007
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:38.556 0.0%4323955 0.000 0.009 0.600
readart00:39:40.324 0.4%1278436 0.000 1.862 17.909
TOTAL: 159:26:15.061159:19:39.207 99.9%----

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 5 35328 4189 30859 280 11%48:14:00
2news.snarked.org 33 20842 2757 16151 1934 13%35:31:09
3bbsnz-out.feed.uzoreto.com 1125 28018 2235 24953 830 7%95:18:25
4feeder.eternal-september.org 9 19574 2002 17360 212 10%25:47:20
5news-out.aioe.org 2 18331 1959 16326 46 10%25:02:57
6news-out.mixmin.net 3 17829 1560 15846 423 8%23:21:33
7news.redatomik.org 7 17069 1107 15886 76 6%24:51:30
8newsfeed.neva.ru 151 13076 765 12092 219 5%71:48:19
9csiph.com 3 17440 186 17239 15 1%23:54:23
10news.albasani.net 1 10403 142 10196 65 1%10:37:21
11news.swapon.de 7 1274 115 1156 3 9%21:38:02
12agency-nz-out.news.mb-net.net 6 18686 80 18587 19 0%23:45:16
13feeder.awxg.com 3 15297 69 15219 9 0%23:58:30
14news.freedyn.net 5 15016 57 14931 28 0%20:06:22
15news.samoylyk.net 1 17475 32 17431 12 0%23:59:57
16news.ausics.org 5 74159 23 74127 9 0%116:15:08
17localhost 8 7 7 0 0 100%00:00:00
TOTAL: 17 1374 339824 17285 318359 4180 5%614:10:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.5 MB275.8 KB1.3 MB20.1 MB 92%4.6 KB
2news.snarked.org8.6 MB66.7 KB12.4 MB21.0 MB 40%4.6 KB
3bbsnz-out.feed.uzoreto.com6.7 MB23.9 KB3.2 MB10.0 MB 67%3.3 KB
4feeder.eternal-september.org5.4 MB801.6 KB1.5 MB7.7 MB 70%3.5 KB
5news-out.aioe.org4.8 MB12.5 KB303.0 KB5.1 MB 93%2.6 KB
6news-out.mixmin.net4.3 MB31.5 KB936.2 KB5.3 MB 82%2.7 KB
7news.redatomik.org3.3 MB797.1 KB970.1 KB5.1 MB 65%4.4 KB
8newsfeed.neva.ru1.8 MB109.2 KB1.0 MB3.0 MB 62%3.1 KB
9csiph.com510.9 KB42.3 KB47.2 KB600.4 KB 85%3.0 KB
10news.albasani.net470.0 KB33.7 KB178.2 KB681.9 KB 68%3.3 KB
11news.swapon.de310.2 KB4.1 KB5.6 KB319.9 KB 96%2.7 KB
12agency-nz-out.news.mb-net.net196.8 KB31.5 KB88.4 KB316.8 KB 62%3.2 KB
13feeder.awxg.com184.1 KB19.2 KB19.2 KB222.6 KB 82%2.9 KB
14news.freedyn.net154.4 KB11.6 KB155.9 KB321.9 KB 47%3.8 KB
15news.samoylyk.net80.6 KB40.7 KB80.5 KB201.8 KB 39%4.6 KB
16news.ausics.org48.8 KB52.6 KB58.2 KB159.6 KB 30%5.0 KB
17localhost11.0 KB0.0 KB0.0 KB11.0 KB100%1.6 KB
TOTAL: 1755.4 MB2.3 MB22.2 MB79.9 MB 69%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 13 23:58:01 - 23:59:59 34 0.2% 0.2975.5 KB 0.1% 0.63
Sep 14 00:00:00 - 00:59:59 883 5.1% 0.252.2 MB 3.9% 0.62
Sep 14 01:00:00 - 01:59:59 1018 5.9% 0.283.8 MB 6.8% 1.08
Sep 14 02:00:00 - 02:59:59 977 5.7% 0.272.7 MB 4.9% 0.78
Sep 14 03:00:00 - 03:59:59 1121 6.5% 0.314.2 MB 7.5% 1.20
Sep 14 04:00:00 - 04:59:59 1019 5.9% 0.283.4 MB 6.0% 0.96
Sep 14 05:00:00 - 05:59:59 993 5.7% 0.282.7 MB 4.8% 0.76
Sep 14 06:00:00 - 06:59:59 840 4.9% 0.233.2 MB 5.7% 0.91
Sep 14 07:00:00 - 07:59:59 795 4.6% 0.222.2 MB 3.9% 0.62
Sep 14 08:00:00 - 08:59:59 898 5.2% 0.253.2 MB 5.7% 0.90
Sep 14 09:00:00 - 09:59:59 810 4.7% 0.232.2 MB 3.9% 0.62
Sep 14 10:00:00 - 10:59:59 547 3.2% 0.152.3 MB 4.1% 0.66
Sep 14 11:00:00 - 11:59:59 444 2.6% 0.121.3 MB 2.4% 0.38
Sep 14 12:00:00 - 12:59:59 383 2.2% 0.111.2 MB 2.2% 0.35
Sep 14 13:00:00 - 13:59:59 340 2.0% 0.091.5 MB 2.6% 0.42
Sep 14 14:00:00 - 14:59:59 367 2.1% 0.101.4 MB 2.5% 0.40
Sep 14 15:00:00 - 15:59:59 437 2.5% 0.121.7 MB 3.0% 0.48
Sep 14 16:00:00 - 16:59:59 369 2.1% 0.101.3 MB 2.3% 0.36
Sep 14 17:00:00 - 17:59:59 384 2.2% 0.111.1 MB 1.9% 0.31
Sep 14 18:00:00 - 18:59:59 570 3.3% 0.161.9 MB 3.4% 0.55
Sep 14 19:00:00 - 19:59:59 857 5.0% 0.243.0 MB 5.4% 0.85
Sep 14 20:00:00 - 20:59:59 702 4.1% 0.202.3 MB 4.1% 0.65
Sep 14 21:00:00 - 21:59:59 944 5.5% 0.262.8 MB 5.1% 0.81
Sep 14 22:00:00 - 22:59:59 806 4.7% 0.222.4 MB 4.2% 0.67
Sep 14 23:00:00 - 23:58:02 735 4.3% 0.211.8 MB 3.2% 0.53
TOTAL: 24:00:01 17273 100.0% 0.2055.8 MB 100.0% 0.66
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.4 GB 56.8% 0 0.24 2479.05
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.8 GB 65.5% 0 0.31 1946.93
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB361.1 MB 0.7% 0 0.0226666.67
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.9 GB 53.9% 0 0.58 1046.70
TOTAL: 10-500.0 GB88.5 GB 17.7% 1 0.37-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1901 9 0 16 0 0 0 0 1876
2bbsnz-out.feed.uzoreto.com 845 32 0 8 0 0 0 0 805
3news-out.mixmin.net 543 0 0 14 0 0 0 0 529
4bbs-nz-out.news.weretis.net 433 66 0 23 0 0 0 0 344
5newsfeed.neva.ru 218 12 0 26 0 0 0 0 180
6feeder.eternal-september.org 213 0 0 17 0 0 0 0 196
7news.redatomik.org 152 0 0 17 0 0 0 0 135
8news.albasani.net 93 0 0 8 0 0 0 0 85
9news-out.aioe.org 48 21 0 4 0 0 0 0 23
10news.freedyn.net 41 0 0 6 0 0 0 0 35
11news.swapon.de 33 0 0 2 0 0 0 0 31
12agency-nz-out.news.mb-net.net 16 2 0 6 0 0 0 0 8
13csiph.com 15 0 0 12 0 0 0 0 3
14news.samoylyk.net 13 0 0 12 0 0 0 0 1
15feeder.awxg.com 10 0 0 9 0 0 0 0 1
16news.ausics.org 7 0 0 6 0 0 0 0 1
TOTAL: 16 4581 142 0 186 0 0 0 0 4253

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 20
mozilla.dev.platform 13
mozilla.dev.ui-alerts 10
gmane.linux.alsa.devel 8
it.annunci.commerciali 8
mozilla.support.seamonkey 7
it.annunci.immobiliari 6
it.annunci.varie 6
mozilla.support.bugzilla 6
gmane.linux.kernel.stable 5
usc.forsale 4
al.christnet.bible 4
mozilla.dev.security.policy 4
mozilla.tools.taskcluster 4
gmane.linux.kernel 4
mozilla.apis 3
fido7.ru.android 3
alt.fan.snuffles 3
gmane.linux.kernel.iommu 3
alt.aviation 2
TOTAL: 37 142

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3313
EMP (phn path) 319
EMP (phl) 57
User-issued spam cancel 46
Too many newsgroups 45
EMP (phn nph) 37
Binary: non-binary distribution 14
Binary: misplaced par2 11
User-issued cancel 8
Too many newsgroups (meow) 1
HTML post 1
Binary Image: misplaced png 1
Binary: misplaced rar 1
Too many newsgroups (low_xpost) 1
TOTAL: 14 3855

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 2
news.albasani.net 1
TOTAL: 2 3
Including strange strings
bbs-nz-out.news.weretis.net 148
news-out.mixmin.net 109
news.redatomik.org 74
news.swapon.de 30
bbsnz-out.feed.uzoreto.com 12
news.albasani.net 10
news-out.aioe.org 7
newsfeed.neva.ru 2
feeder.eternal-september.org 2
feeder.awxg.com 1
TOTAL: 10 395
TOTAL: 2 398

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15599 915 14661 23 0 108 5%23:59:51
2awxg 16821 49 16761 4 0 0 0%23:59:50
3news.snarked.org 14507 19 14394 1 0 65 0%23:59:41
4aioe 14455 11 14327 0 0 11 0%23:59:50
5news.freedyn.net 17237 9 17183 0 0 5 0%23:59:49
6news.redatomik.org 16139 8 16105 0 0 3 0%23:59:40
7csiph.com 17167 7 17096 0 0 0 0%23:59:47
8news-in.mixmin.net 15335 7 15320 0 0 0 0%23:59:50
9news.samoylyk.net 15592 7 15545 0 0 6 0%23:59:50
10mb-net.net 17215 7 17177 0 0 10 0%23:59:50
11eternal-september 14917 7 14900 1 0 1 0%23:59:38
12neva.ru 16126 7 16115 0 0 0 0%23:59:50
13weretis.net 12728 6 12689 0 0 48 0%23:59:50
14news.uzoreto.com 14995 2 14982 5 0 5 0%23:59:39
15news.albasani.net 18552 1 15545 909 0 6861 0%23:59:50
16news.swapon.de 1265 1 1260 0 0 6 0%23:40:16
TOTAL: 16 238650 1063 234060 943 0 7129 0%383:37:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org8.6 MB471.8 KB9.1 MB0.1 KB/s9.9 KB23:59:51
2awxg124.4 KB16.4 KB140.8 KB0.0 KB/s2.7 KB23:59:50
3news.snarked.org52.3 KB1.3 KB53.5 KB0.0 KB/s2.7 KB23:59:41
4aioe22.1 KB0.0 KB22.1 KB0.0 KB/s2.0 KB23:59:50
5news.freedyn.net14.6 KB0.0 KB14.6 KB0.0 KB/s1.6 KB23:59:49
6news.redatomik.org13.4 KB0.0 KB13.4 KB0.0 KB/s1.7 KB23:59:40
7csiph.com11.0 KB0.0 KB11.0 KB0.0 KB/s1.6 KB23:59:47
8news-in.mixmin.net11.0 KB0.0 KB11.0 KB0.0 KB/s1.6 KB23:59:50
9news.samoylyk.net11.0 KB0.0 KB11.0 KB0.0 KB/s1.6 KB23:59:50
10mb-net.net11.0 KB0.0 KB11.0 KB0.0 KB/s1.6 KB23:59:50
11eternal-september11.0 KB4.3 KB15.3 KB0.0 KB/s1.9 KB23:59:38
12neva.ru11.0 KB0.0 KB11.0 KB0.0 KB/s1.6 KB23:59:50
13weretis.net9.3 KB0.0 KB9.3 KB0.0 KB/s1.6 KB23:59:50
14news.uzoreto.com2.8 KB8.2 KB11.0 KB0.0 KB/s1.6 KB23:59:39
15news.albasani.net1.3 KB4.3 MB4.3 MB0.1 KB/s4.8 KB23:59:50
16news.swapon.de1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:40:16
TOTAL: 168.9 MB4.7 MB13.7 MB0.0 KB/s7.0 KB383:37:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 401 529417.5 MB 3144 7 000:15:08
2vorlon.activateit.net.au 24 7961012.9 KB 128 0 000:04:32
3otwbsc03.hicv.net 12 44109.1 KB 2 0 000:33:07
4121.99.148.206 4 1338.0 KB 5 0 001:03:52
TOTAL: 4 441666578899.9 MB 3293 7 0159:26:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 401 529417.5 MB 3144 7 000:15:08
2*.activateit.net.au 24 7961012.9 KB 128 0 000:04:32
3*.hicv.net 12 44109.1 KB 2 0 000:33:07
4unresolved 8 1338.0 KB 5 0 001:06:58
5*.cpe.cableone.net 5 00.0 KB 0 0 029:30:33
TOTAL: 5 450666578899.9 MB 3293 7 0159:26:08

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 8
malcolmlewis 5
TOTAL: 3 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ool-4578089a.dyn.optonline.net 84.016 201.596 0.000127:55:46
160-3-245-118.cpe.cableone.net 0.352 0.136 0.07529:30:33
121.99.148.206 0.328 0.116 0.00001:03:52
otwbsc03.hicv.net 0.800 0.132 0.02500:33:07
agency.bbs.nz 30.440 7.068 0.00000:15:08
vorlon.activateit.net.au 1.436 0.448 0.08800:04:32
118.149.250.227 0.204 0.016 0.00000:03:04
? 1.316 0.164 0.00000:00:02
94.165.251.6 0.048 0.016 0.00000:00:01
TOTAL: 9 118.940 209.692 0.188159:26:08

Curious NNRP server explorers [Top 20]:

SystemConn
160-3-245-118.cpe.cableone.net 5
118.149.250.227 3
94.165.251.6 1
TOTAL: 3 9

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
otwbsc03.hicv.net 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
121.99.148.206 3 1
ool-4578089a.dyn.optonline.net 1 0
160-3-245-118.cpe.cableone.net 1 1
TOTAL: 3 5 2

Newsgroup request counts (by category):

CategoryCountPct
1alt 34144 85.4%
2rec 2298 5.7%
3sci 664 1.7%
4soc 657 1.6%
5uk 639 1.6%
6comp 620 1.6%
7linux 510 1.3%
8talk 151 0.4%
9misc 116 0.3%
10news 65 0.2%
11nz 31 0.1%
12agency 30 0.1%
13microsoft 22 0.1%
14humanities 19 0.0%
15mozilla 18 0.0%
TOTAL: 15 39984100.0%

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

NewsgroupCount
1alt.privacy.anon-server 21626
2alt.privacy.anon-server.stats 7931
3alt.prophecies.nostradamus 3121
4alt.pro-wrestling.wwf 558
5rec.arts.tv 461
6alt.privacy.spyware 391
7rec.arts.drwho 348
8rec.food.cooking 251
9uk.d-i-y 214
10uk.legal 207
11alt.private.investigator 190
12rec.sport.tennis 171
13rec.sport.football.college 167
14linux.debian.bugs.dist 155
15sci.physics.relativity 145
16sci.physics 140
17alt.comp.os.windows-10 128
18linux.debian.changes.devel 103
19soc.culture.china 98
20rec.drugs.cannabis 97
21rec.gambling.poker 96
22comp.lang.c 92
23comp.os.linux.advocacy 88
24rec.arts.sf.written 87
25sci.electronics.design 86
26linux.debian.bugs.rc 86
27rec.arts.sf.tv 84
28soc.penpals 71
29soc.retirement 69
30comp.lang.python 65
31talk.origins 64
32misc.survivalism 52
33sci.logic 51
34sci.math 51
35rec.boats 50
36uk.legal.moderated 50
37soc.culture.israel 49
38comp.lang.c++ 48
39soc.culture.polish 48
40soc.culture.brazil 47
41news.lists.filters 47
42rec.arts.sf.fandom 44
43uk.radio.amateur 44
44uk.tech.digital-tv 42
45alt.conspiracy.jfk 42
46talk.politics.guns 42
47comp.sys.raspberry-pi 40
48alt.politics.trump 38
49uk.comp.sys.mac 36
50sci.med.pharmacy 35
51linux.debian.user 34
52soc.culture.greek 33
53rec.sport.pro-wrestling 32
54soc.culture.indian 30
55talk.politics.misc 30
56rec.bicycles.tech 29
57alt.test 29
58sci.med.cardiology 29
59linux.gentoo.dev 28
60rec.music.classical.recordings 27
61rec.aviation.soaring 26
62nz.general 26
63comp.lang.forth 25
64alt.os.linux.ubuntu 25
65rec.photo.digital 24
66rec.sport.golf 24
67soc.culture.usa 24
68misc.invest.stocks 24
69rec.outdoors.rv-travel 22
70comp.os.vms 21
71sci.astro.amateur 21
72rec.radio.shortwave 19
73agency.test 19
74comp.sys.apple2 19
75linux.debian.user.french 19
76sci.anthropology.paleo 18
77sci.military.naval 18
78rec.autos.sport.f1 18
79comp.arch 17
80sci.lang 17
81rec.sport.billiard 16
82comp.misc 16
83linux.debian.devel 16
84humanities.lit.authors.shakespeare 16
85misc.phone.mobile.iphone 16
86uk.tech.broadcast 16
87linux.gentoo.user 16
88mozilla.support.firefox 15
89soc.history.living 15
90alt.bbs.mystic 15
91alt.projectmng 15
92rec.audio.pro 15
93soc.genealogy.medieval 14
94rec.sport.soccer 13
95soc.women 13
96soc.genealogy.britain 12
97soc.history.medieval 12
98comp.protocols.dns.bind 12
99comp.sys.mac.system 12
100comp.lang.perl.misc 11
TOTAL: 333 39984