news.bbs.nz daily logs

Dec 6 23:58:02 -- Dec 7 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 129275 59.9%10.0 MB 37.4%
innd 35648 16.5%5.7 MB 21.2%
innfeed 26071 12.1%5.2 MB 19.5%
inn 23271 10.8%5.6 MB 20.9%
cnfsstat 1440 0.7%255.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 215706 100.0%26.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 287001 48.1%
Negative hits 286859 48.1%
Do not exist 22496 3.8%
Cache misses 539 0.1%
TOTAL: 4 596895 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.383 0.0%72 0.000 5.319 55.000
article cleanup00:00:00.253 0.0%22923 0.000 0.011 0.047
article logging00:00:00.638 0.0%23165 0.000 0.028 0.206
article parse00:00:00.710 0.0%86494 0.000 0.008 0.020
article write00:00:01.425 0.0%17315 0.014 0.082 1.173
artlog/artcncl00:00:00.003 0.0%72 0.000 0.042 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.528 0.0%569791 0.000 0.001 0.011
hisgrep/artcncl00:00:00.021 0.0%72 0.000 0.292 19.000
hishave/artcncl00:00:00.014 0.0%72 0.000 0.194 14.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.437 0.0%603171 0.003 0.017 0.715
history sync00:00:00.013 0.0%379 0.000 0.034 0.667
history write00:00:10.138 0.0%22724 0.010 0.446 28.014
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:13.210 99.7%580295 84.051 148.602 395.597
nntp read00:00:05.295 0.0%584203 0.004 0.009 0.035
overview write00:00:58.025 0.1%17315 0.036 3.351 152.160
perl filter00:00:43.833 0.1%22710 1.044 1.930 14.010
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.075 0.0%34630 0.000 0.031 0.229
TOTAL: 24:01:00.65923:59:26.001 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%22690 0.000 0.003 0.018
article prepare00:00:00.000 0.0%10346 0.000 0.000 0.000
article read00:00:00.234 0.0%2089 0.000 0.112 4.750
backlog stats00:00:00.699 0.0%314337 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.793 0.0%264640 0.003 0.011 0.020
data write00:00:03.039 0.0%253358 0.005 0.012 0.022
idle23:54:34.103100.0%314337 170.784 273.827 606.045
status file00:00:14.743 0.0%1879 0.500 7.846 295.806
TOTAL: 23:55:15.81623:54:55.676100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle24:07:35.962 99.6%136632 0.000 635.693 58886.125
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.911 0.0%286610 0.000 0.017 9.934
readart00:00:01.619 0.0%6594 0.000 0.246 16.000
TOTAL: 24:13:19.29424:07:42.492 99.6%----

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 35076 3525 31257 294 10%47:20:41
2news.snarked.org 36 22172 2981 16768 2423 13%34:16:23
3bbsnz-out.feed.uzoreto.com 864 28958 2792 25329 837 9%71:06:03
4feeder.eternal-september.org 3 20627 2265 18171 191 10%25:02:51
5news.albasani.net 1 18462 1422 16690 350 7%24:10:31
6news-out.aioe.org 3 19239 1220 17966 53 6%27:36:04
7news-out.mixmin.net 3 18637 1177 17010 450 6%24:12:21
8newsfeed.neva.ru 145 13174 862 11462 850 6%71:34:05
9news.redatomik.org 2 14265 588 13632 45 4%18:14:33
10news.freedyn.net 2 18081 156 17889 36 0%21:42:28
11news.swapon.de 5 1413 154 1257 2 10%24:30:11
12csiph.com 1 16617 131 16478 8 0%23:36:40
13agency-nz-out.news.mb-net.net 5 20102 97 19967 38 0%26:34:19
14news.samoylyk.net 3 18880 54 18801 25 0%29:41:16
15feeder.awxg.com 2 15280 11 15260 9 0%23:59:53
16localhost 5 4 4 0 0 100%00:00:00
17news.ausics.org 1 4240 2 4238 0 0%05:54:27
18nut.utcc.utoronto.ca 1 18062 0 18062 0 0%23:49:59
TOTAL: 18 1087 303289 17441 280237 5611 5%523:22:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net20.0 MB558.6 KB1.7 MB22.3 MB 89%6.0 KB
2news.snarked.org9.4 MB169.2 KB21.6 MB31.2 MB 30%5.9 KB
3bbsnz-out.feed.uzoreto.com9.3 MB121.4 KB3.3 MB12.7 MB 73%3.6 KB
4feeder.eternal-september.org6.8 MB361.4 KB1.1 MB8.2 MB 82%3.4 KB
5news.albasani.net5.8 MB454.6 KB1.0 MB7.2 MB 79%4.2 KB
6news-out.aioe.org3.5 MB20.4 KB426.0 KB4.0 MB 89%3.2 KB
7news-out.mixmin.net3.4 MB42.6 KB942.9 KB4.3 MB 77%2.7 KB
8news.redatomik.org2.1 MB238.3 KB534.5 KB2.9 MB 73%4.6 KB
9newsfeed.neva.ru2.0 MB267.6 KB21.1 MB23.4 MB 8%14.0 KB
10news.freedyn.net878.4 KB241.3 KB314.1 KB1.4 MB 61%7.5 KB
11news.swapon.de401.4 KB5.5 KB5.5 KB412.4 KB 97%2.6 KB
12csiph.com337.6 KB34.0 KB34.0 KB405.6 KB 83%2.9 KB
13agency-nz-out.news.mb-net.net273.3 KB237.8 KB464.6 KB975.7 KB 28%7.2 KB
14news.samoylyk.net178.7 KB847.5 KB847.5 KB1.8 MB 9%23.7 KB
15feeder.awxg.com26.2 KB29.9 KB29.9 KB86.0 KB 30%4.3 KB
16localhost10.9 KB0.0 KB0.0 KB10.9 KB100%2.7 KB
17news.ausics.org6.1 KB0.0 KB0.0 KB6.1 KB100%3.1 KB
18nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1864.3 MB3.5 MB53.3 MB121.2 MB 53%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 6 23:58:02 - 23:59:59 15 0.1% 0.1336.7 KB 0.1% 0.31
Dec 7 00:00:00 - 00:59:59 855 4.9% 0.243.6 MB 5.5% 1.02
Dec 7 01:00:00 - 01:59:59 858 4.9% 0.243.2 MB 4.9% 0.91
Dec 7 02:00:00 - 02:59:59 872 5.0% 0.242.6 MB 4.0% 0.75
Dec 7 03:00:00 - 03:59:59 878 5.1% 0.243.2 MB 4.9% 0.90
Dec 7 04:00:00 - 04:59:59 1013 5.8% 0.282.8 MB 4.4% 0.81
Dec 7 05:00:00 - 05:59:59 1096 6.3% 0.303.5 MB 5.4% 1.00
Dec 7 06:00:00 - 06:59:59 979 5.6% 0.273.5 MB 5.4% 1.00
Dec 7 07:00:00 - 07:59:59 986 5.7% 0.273.2 MB 4.8% 0.90
Dec 7 08:00:00 - 08:59:59 911 5.2% 0.256.0 MB 9.1% 1.69
Dec 7 09:00:00 - 09:59:59 909 5.2% 0.252.7 MB 4.2% 0.78
Dec 7 10:00:00 - 10:59:59 867 5.0% 0.242.6 MB 4.1% 0.75
Dec 7 11:00:00 - 11:59:59 706 4.1% 0.202.6 MB 3.9% 0.73
Dec 7 12:00:00 - 12:59:59 636 3.7% 0.182.5 MB 3.9% 0.72
Dec 7 13:00:00 - 13:59:59 532 3.1% 0.152.7 MB 4.2% 0.78
Dec 7 14:00:00 - 14:59:59 403 2.3% 0.111.5 MB 2.3% 0.43
Dec 7 15:00:00 - 15:59:59 358 2.1% 0.101.2 MB 1.8% 0.34
Dec 7 16:00:00 - 16:59:59 353 2.0% 0.101.2 MB 1.9% 0.35
Dec 7 17:00:00 - 17:59:59 408 2.4% 0.112.6 MB 4.0% 0.73
Dec 7 18:00:00 - 18:59:59 315 1.8% 0.091.7 MB 2.7% 0.50
Dec 7 19:00:00 - 19:59:59 452 2.6% 0.131.4 MB 2.2% 0.40
Dec 7 20:00:00 - 20:59:59 678 3.9% 0.192.6 MB 4.0% 0.74
Dec 7 21:00:00 - 21:59:59 547 3.2% 0.151.5 MB 2.3% 0.42
Dec 7 22:00:00 - 22:59:59 735 4.2% 0.202.1 MB 3.2% 0.58
Dec 7 23:00:00 - 23:58:02 993 5.7% 0.294.4 MB 6.7% 1.29
TOTAL: 24:00:00 17355 100.0% 0.2065.1 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB30.2 GB 60.5% 0 0.26 2314.46
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB34.7 GB 69.5% 0 0.35 1735.26
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB369.9 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 GB30.8 GB 61.6% 0 0.63 959.50
TOTAL: 10-500.0 GB96.2 GB 19.2% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2428 3 0 14 0 0 0 0 2411
2newsfeed.neva.ru 856 14 0 23 0 0 0 0 819
3bbsnz-out.feed.uzoreto.com 844 17 0 5 0 0 0 0 822
4news-out.mixmin.net 518 0 0 16 0 0 0 0 502
5news.albasani.net 435 4 0 13 0 0 0 0 418
6bbs-nz-out.news.weretis.net 321 86 0 32 0 0 0 0 203
7feeder.eternal-september.org 192 0 0 16 0 0 0 0 176
8news.redatomik.org 63 0 0 15 0 0 0 0 48
9news-out.aioe.org 54 38 0 5 0 0 0 0 11
10news.swapon.de 42 0 0 2 0 0 0 0 40
11agency-nz-out.news.mb-net.net 37 8 0 13 0 0 0 0 16
12news.samoylyk.net 20 0 0 20 0 0 0 0 0
13news.freedyn.net 17 0 0 9 0 0 0 0 8
14feeder.awxg.com 10 0 0 9 0 0 0 0 1
15csiph.com 7 0 0 7 0 0 0 0 0
TOTAL: 15 5844 170 0 199 0 0 0 0 5475

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 47
gmane.linux.alsa.devel 41
gmane.linux.kernel 18
alt.music.pink-floyd.publius 13
mozilla.dev.security.policy 7
mozilla.dev.ui-alerts 6
mozilla.dev.platform 6
south-wales.test 4
mozilla.apis 4
mozilla.dev.servo 3
alt.sex.girl 2
1.test 2
alt.net.dn42.users 2
mozilla.tools.pulse 1
alt.fr.os.windows.7 1
symantec.support.dos.nortonutilities.general 1
gmane.comp.gis.openstreetmap.imports 1
mindspring.discussion.general 1
nz.org.isocnz 1
mindspring.watercooler 1
TOTAL: 28 170

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3902
Binary: misplaced rar 653
EMP (phn path) 386
EMP (phn nph) 80
Too many newsgroups 75
Binary: misplaced par2 43
User-issued cancel 41
Binary: non-binary distribution 27
EMP (phl) 10
Binary: misplaced mp4 1
TOTAL: 10 5218

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 12
news.albasani.net 2
TOTAL: 2 14
Including strange strings
news.albasani.net 76
news-out.mixmin.net 69
news.swapon.de 40
bbs-nz-out.news.weretis.net 25
news.redatomik.org 10
bbsnz-out.feed.uzoreto.com 6
newsfeed.neva.ru 5
news.snarked.org 4
news-out.aioe.org 3
agency-nz-out.news.mb-net.net 2
TOTAL: 12 243
TOTAL: 2 257

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15863 816 15027 19 1 0 5%23:59:48
2utnut 17352 575 16538 239 0 0 3%23:59:49
3awxg 16912 60 16834 3 0 4 0%23:59:40
4aioe 14765 6 14673 0 0 5 0%23:59:32
5news.snarked.org 14387 6 14217 0 0 60 0%23:59:50
6weretis.net 13535 5 13448 2 0 3 0%23:59:47
7news-in.mixmin.net 15679 4 15666 1 0 4 0%23:59:43
8news.freedyn.net 17343 4 17279 0 0 24 0%23:59:50
9news.redatomik.org 16604 4 16584 0 0 3 0%23:59:50
10mb-net.net 17260 4 17228 0 0 19 0%23:59:49
11csiph.com 17289 4 17222 0 0 0 0%23:59:31
12news.samoylyk.net 15895 4 15811 0 0 54 0%23:59:50
13eternal-september 14804 4 14761 0 0 7 0%23:59:50
14neva.ru 16014 3 16005 1 0 0 0%23:59:50
15news.swapon.de 1314 3 1308 0 0 0 0%23:52:11
16news.albasani.net 17214 1 14991 727 0 5224 0%23:59:50
17news.uzoreto.com 14458 0 14449 3 0 2 0%23:59:45
TOTAL: 17 256688 1503 252041 995 1 5409 0%407:48:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1utnut16.1 MB874.5 KB17.0 MB0.2 KB/s21.4 KB23:59:49
2news.ausics.org14.0 MB1.1 MB15.1 MB0.2 KB/s18.6 KB23:59:48
3awxg164.0 KB19.7 KB183.7 KB0.0 KB/s2.9 KB23:59:40
4aioe15.8 KB0.0 KB15.8 KB0.0 KB/s2.6 KB23:59:32
5news.snarked.org13.7 KB0.0 KB13.7 KB0.0 KB/s2.3 KB23:59:50
6weretis.net13.0 KB3.4 KB16.4 KB0.0 KB/s2.3 KB23:59:47
7news-in.mixmin.net10.9 KB3.0 KB13.9 KB0.0 KB/s2.8 KB23:59:43
8news.freedyn.net10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:50
9news.redatomik.org10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:50
10mb-net.net10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:49
11csiph.com10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:31
12news.samoylyk.net10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:50
13eternal-september10.9 KB0.0 KB10.9 KB0.0 KB/s2.7 KB23:59:50
14news.swapon.de9.7 KB0.0 KB9.7 KB0.0 KB/s3.2 KB23:52:11
15neva.ru3.8 KB7.2 KB10.9 KB0.0 KB/s2.7 KB23:59:50
16news.albasani.net1.2 KB3.9 MB3.9 MB0.0 KB/s5.5 KB23:59:50
17news.uzoreto.com0.0 KB9.6 KB9.6 KB0.0 KB/s3.2 KB23:59:45
TOTAL: 1730.5 MB5.9 MB36.4 MB0.0 KB/s14.9 KB407:48:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 516521.3 MB 3005 6 000:13:39
2vorlon.activateit.net.au 24 7901.1 MB 120 0 000:04:24
3amigacity.xyz 71 2181.0 MB 120 0 000:35:21
4160-3-236-103.cpe.cableone.net 1 11.5 KB 1 0 023:15:37
TOTAL: 4 483 617423.3 MB 3450 6 024:13:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 516521.3 MB 3005 6 000:13:39
2*.activateit.net.au 24 7901.1 MB 120 0 000:04:24
3*.xyz 71 2181.0 MB 120 0 000:35:21
4*.cpe.cableone.net 1 11.5 KB 1 0 023:15:37
5unresolved 4 00.0 KB 0 0 000:04:06
TOTAL: 5 487 617423.3 MB 3450 6 024:13:12

NNRP auth users [Top 20]:

UserConn
amigacity 71
amybbs 24
malcolmlewis 1
TOTAL: 3 96

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.228 0.096 0.00623:15:37
amigacity.xyz 4.428 1.048 0.26300:35:21
agency.bbs.nz 29.944 7.136 0.00000:13:39
vorlon.activateit.net.au 1.664 0.380 0.07700:04:24
118.149.162.210 0.276 0.020 0.00000:04:06
? 1.024 0.132 0.00000:00:01
TOTAL: 6 37.564 8.812 0.34624:13:12

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.162.210 4
TOTAL: 1 4

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1bit 45957 36.1%
2be 34451 27.0%
3cam 14525 11.4%
4can 11834 9.3%
5ca 7114 5.6%
6bionet 4621 3.6%
7rec 2241 1.8%
8sci 662 0.5%
9comp 613 0.5%
10brasil 595 0.5%
11braunschweig 587 0.5%
12linux 584 0.5%
13soc 567 0.4%
14uk 518 0.4%
15alt 422 0.3%
16calgary 367 0.3%
17byu 361 0.3%
18talk 351 0.3%
19biz 330 0.3%
20bln 201 0.2%
21misc 129 0.1%
22blgtn 128 0.1%
23calstate 116 0.1%
24boulder 45 0.0%
25mozilla 26 0.0%
26bih 25 0.0%
27bne 25 0.0%
28nz 24 0.0%
29microsoft 18 0.0%
30br 15 0.0%
31news 12 0.0%
32belwue 8 0.0%
33aus 7 0.0%
TOTAL: 33 127479100.0%

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

NewsgroupCount
1bit.listserv.ibm-main 38592
2be.politics 29789
3cam.misc 9236
4bit.listserv.vse-l 5276
5cam.transport 5238
6can.jobs 4791
7be.radio 4012
8can.general 3398
9ca.politics 3238
10bionet.jobs.wanted 2462
11bit.listserv.tsorexx 1448
12can.canet.stats 1174
13ca.environment 978
14ca.forsale 958
15ca.driving 748
16can.legal 634
17can.internet.highspeed 615
18can.consumers 497
19bionet.genome.arabidopsis 479
20rec.arts.tv 469
21can.community.military 412
22brasil.noticias 402
23ca.general 392
24byu.news 361
25be.test 350
26biz.test 329
27ca.news 327
28calgary.general 303
29braunschweig.kaufrausch 303
30bit.listserv.skeptic 280
31braunschweig.allgemeines 278
32rec.arts.drwho 253
33alt.comp.os.windows-10 248
34uk.d-i-y 242
35be.rec.motorcycles 235
36linux.debian.bugs.dist 218
37bionet.neuroscience 208
38bionet.biology.computational 206
39rec.food.cooking 199
40rec.arts.sf.written 197
41talk.politics.guns 194
42can.motss 173
43bionet.molbio.methds-reagnts 173
44bionet.plants 152
45sci.physics 152
46rec.sport.football.college 151
47ca.water 149
48rec.games.miniatures.misc 142
49sci.electronics.design 116
50bln.verkehr 113
51bionet.organisms.zebrafish 108
52soc.retirement 105
53bionet.drosophila 104
54bit.listserv.christia 104
55linux.debian.changes.devel 104
56uk.legal 100
57blgtn.government 96
58rec.sport.pro-wrestling 96
59bionet.announce 90
60linux.debian.bugs.rc 90
61ca.earthquakes 89
62talk.origins 88
63soc.culture.china 84
64alt.politics.trump 82
65bionet.maize 74
66bionet.molbio.bio-matrix 67
67calstate.news.misc 66
68comp.os.linux.advocacy 65
69soc.culture.polish 64
70can.military-brats 63
71misc.survivalism 62
72bit.listserv.openbsd-pf 61
73brasil.teste 58
74soc.history.living 58
75comp.lang.forth 57
76sci.math 56
77sci.physics.relativity 56
78sci.logic 55
79brasil.geral 55
80linux.debian.user 53
81talk.politics.misc 53
82bionet.general 53
83rec.sport.golf 53
84calgary.announce 52
85rec.sport.tennis 52
86comp.lang.python 51
87sci.lang 51
88ca.usenet 51
89cam.test 47
90bionet.molbio.genbank 47
91bit.listserv.umich.cssa 46
92brasil.politica 46
93ca.news.group 46
94ca.wanted 45
95calstate.cats.teaching 45
96comp.os.vms 45
97rec.music.classical.recordings 45
98uk.tech.digital-tv 44
99ca.unix 43
100soc.culture.brazil 42
TOTAL: 505 127479