news.bbs.nz daily logs

Apr 25 23:58:02 -- Apr 26 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 125441 61.4%9.8 MB 38.8%
innd 28020 13.7%4.6 MB 18.1%
inn 25582 12.5%6.0 MB 23.7%
innfeed 23703 11.6%4.7 MB 18.4%
cnfsstat 1440 0.7%253.9 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 204187 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 273881 50.6%
Positive hits 243055 44.9%
Do not exist 24274 4.5%
Cache misses 97 0.0%
TOTAL: 4 541307 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.164 0.0%251 0.000 0.653 6.000
article cleanup00:00:00.231 0.0%24578 0.000 0.009 0.043
article logging00:00:00.664 0.0%25119 0.000 0.026 0.058
article parse00:00:00.684 0.0%67633 0.000 0.010 0.030
article write00:00:01.536 0.0%19924 0.009 0.077 0.444
artlog/artcncl00:00:00.002 0.0%248 0.000 0.008 0.100
data move00:00:00.971 0.0%525709 0.000 0.002 0.119
hisgrep/artcncl00:00:00.004 0.0%242 0.000 0.017 0.333
hishave/artcncl00:00:00.000 0.0%251 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.381 0.0%542142 0.001 0.014 0.805
history sync00:00:00.023 0.0%369 0.000 0.062 0.667
history write00:00:05.778 0.0%24308 0.000 0.238 22.346
hiswrite/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
idle23:47:40.321 99.8%534346 76.331 160.309 454.344
nntp read00:00:04.256 0.0%536953 0.003 0.008 0.040
overview write00:00:37.063 0.0%19924 0.081 1.860 47.667
perl filter00:00:48.453 0.1%24300 1.151 1.994 23.759
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.971 0.0%39848 0.000 0.024 0.115
TOTAL: 23:50:56.79623:49:28.502 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.058 0.0%28653 0.000 0.002 0.033
article prepare00:00:00.001 0.0%9800 0.000 0.000 0.062
article read00:00:00.227 0.0%2304 0.000 0.099 16.500
backlog stats00:00:00.471 0.0%308804 0.000 0.002 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:02.489 0.0%258205 0.004 0.010 0.020
data write00:00:03.326 0.0%243265 0.005 0.014 0.036
idle23:54:37.652 99.9%308804 135.259 278.745 646.530
status file00:00:26.657 0.0%2030 0.462 13.132 541.190
TOTAL: 23:55:31.58823:55:10.881100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%16 0.000 0.000 0.000
idle46:56:03.908 98.7%139143 0.000 1214.318 76860.661
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:23.219 0.0%301271 0.000 0.077 6.155
readart00:00:02.529 0.0%10997 0.000 0.230 15.000
TOTAL: 47:32:14.11446:56:29.656 98.7%----

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
TOTAL: 11 169

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 31 15250 4557 9084 1609 29%38:41:00
2newsfeed.datemas.de 4 19771 3381 15703 687 17%22:34:39
3feeder.eternal-september.org 4 23509 2375 20658 476 10%25:31:35
4newsfeed.neva.ru 148 12830 2282 9412 1136 17%76:33:30
5csiph.com 3 25147 2264 22856 27 9%31:57:59
6news-out.aioe.org 2 20457 2173 18208 76 10%24:39:32
7news-out.mixmin.net 7 22280 1461 20402 417 6%27:46:40
8news.redatomik.org 1 21020 1301 19689 30 6%26:43:27
9news.albasani.net 1 19650 152 19442 56 0%23:35:01
10news.swapon.de 7 1753 138 1612 3 7%27:35:51
11agency-nz-out.news.mb-net.net 9 19928 110 19765 53 0%26:36:15
12feeder.awxg.com 2 15880 99 15752 29 0%23:59:50
13news.samoylyk.net 26 15297 59 15204 34 0%21:38:39
14news.freedyn.net 1 18905 30 18849 26 0%21:53:36
15localhost 7 6 6 0 0 100%00:00:00
16news.ausics.org 1 16048 0 16048 0 0%23:59:22
TOTAL: 16 254 267731 20388 242684 4659 7%443:46:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.3 MB266.2 KB17.8 MB35.3 MB 48%5.9 KB
2newsfeed.datemas.de10.4 MB77.8 KB2.6 MB13.0 MB 79%3.3 KB
3newsfeed.neva.ru7.7 MB76.4 KB3.9 MB11.7 MB 65%3.5 KB
4feeder.eternal-september.org6.9 MB121.5 KB1.1 MB8.1 MB 84%2.9 KB
5csiph.com6.3 MB99.4 KB104.5 KB6.5 MB 96%2.9 KB
6news-out.aioe.org5.6 MB33.6 KB300.8 KB6.0 MB 94%2.7 KB
7news-out.mixmin.net4.4 MB94.4 KB888.6 KB5.4 MB 82%2.9 KB
8news.redatomik.org3.4 MB99.9 KB107.6 KB3.6 MB 94%2.8 KB
9news.albasani.net1.2 MB76.1 KB166.0 KB1.4 MB 83%7.0 KB
10agency-nz-out.news.mb-net.net413.6 KB75.9 KB411.6 KB901.0 KB 45%5.5 KB
11news.swapon.de408.3 KB5.1 KB6.0 KB419.4 KB 97%3.0 KB
12feeder.awxg.com344.4 KB138.2 KB143.1 KB625.7 KB 55%4.9 KB
13news.samoylyk.net273.1 KB107.3 KB396.4 KB776.9 KB 35%8.4 KB
14news.freedyn.net191.4 KB77.8 KB117.9 KB387.1 KB 49%6.9 KB
15localhost7.5 KB0.0 KB0.0 KB7.5 KB100%1.2 KB
16news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1664.7 MB1.3 MB28.0 MB94.0 MB 68%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 25 23:58:02 - 23:59:59 21 0.1% 0.1856.1 KB 0.1% 0.48
Apr 26 00:00:00 - 00:59:59 801 4.0% 0.222.0 MB 3.2% 0.58
Apr 26 01:00:00 - 01:59:59 870 4.3% 0.243.0 MB 4.6% 0.85
Apr 26 02:00:00 - 02:59:59 1135 5.6% 0.323.2 MB 4.9% 0.90
Apr 26 03:00:00 - 03:59:59 1078 5.4% 0.303.8 MB 5.8% 1.07
Apr 26 04:00:00 - 04:59:59 989 4.9% 0.272.4 MB 3.7% 0.68
Apr 26 05:00:00 - 05:59:59 1024 5.1% 0.283.2 MB 4.9% 0.90
Apr 26 06:00:00 - 06:59:59 987 4.9% 0.273.3 MB 5.1% 0.94
Apr 26 07:00:00 - 07:59:59 961 4.8% 0.272.9 MB 4.4% 0.81
Apr 26 08:00:00 - 08:59:59 948 4.7% 0.262.9 MB 4.4% 0.81
Apr 26 09:00:00 - 09:59:59 930 4.6% 0.262.7 MB 4.2% 0.76
Apr 26 10:00:00 - 10:59:59 699 3.5% 0.192.6 MB 4.1% 0.75
Apr 26 11:00:00 - 11:59:59 505 2.5% 0.141.8 MB 2.8% 0.51
Apr 26 12:00:00 - 12:59:59 477 2.4% 0.131.7 MB 2.6% 0.48
Apr 26 13:00:00 - 13:59:59 445 2.2% 0.122.4 MB 3.8% 0.69
Apr 26 14:00:00 - 14:59:59 404 2.0% 0.111.4 MB 2.1% 0.38
Apr 26 15:00:00 - 15:59:59 454 2.3% 0.131.6 MB 2.5% 0.47
Apr 26 16:00:00 - 16:59:59 458 2.3% 0.131.3 MB 2.1% 0.38
Apr 26 17:00:00 - 17:59:59 841 4.2% 0.233.4 MB 5.2% 0.96
Apr 26 18:00:00 - 18:59:59 1393 6.9% 0.395.6 MB 8.7% 1.60
Apr 26 19:00:00 - 19:59:59 901 4.5% 0.252.6 MB 4.1% 0.75
Apr 26 20:00:00 - 20:59:59 935 4.7% 0.262.5 MB 3.9% 0.72
Apr 26 21:00:00 - 21:59:59 1020 5.1% 0.283.0 MB 4.6% 0.84
Apr 26 22:00:00 - 22:59:59 960 4.8% 0.272.4 MB 3.7% 0.68
Apr 26 23:00:00 - 23:58:01 865 4.3% 0.252.9 MB 4.5% 0.85
TOTAL: 23:59:59 20101 100.0% 0.2364.6 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB25.3 GB 50.7% 0 0.29 2117.19
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB29.3 GB 58.6% 0 0.34 1804.66
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB320.2 MB 0.6% 0 0.0415484.29
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 GB20.3 GB 40.5% 0 0.64 948.45
TOTAL: 10-500.0 GB75.2 GB 15.0% 1 0.40-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1590 103 0 30 0 0 0 0 1457
2newsfeed.neva.ru 1148 97 0 30 1 0 0 0 1020
3newsfeed.datemas.de 856 148 0 16 0 0 0 0 692
4news-out.mixmin.net 588 0 0 20 0 0 0 0 568
5feeder.eternal-september.org 478 0 0 25 0 0 0 0 453
6news.redatomik.org 150 0 0 21 0 0 0 0 129
7news-out.aioe.org 92 54 0 15 0 0 0 0 23
8news.freedyn.net 68 2 0 11 0 0 0 0 55
9agency-nz-out.news.mb-net.net 62 25 0 15 0 0 0 0 22
10news.albasani.net 60 2 0 17 0 0 0 0 41
11news.swapon.de 59 0 0 1 0 0 0 0 58
12news.samoylyk.net 36 0 0 28 0 0 0 0 8
13feeder.awxg.com 26 1 0 23 0 0 0 0 2
14csiph.com 18 0 0 17 0 0 0 0 1
15news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 15 5232 432 0 270 1 0 0 0 4529

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 63
gmane.linux.alsa.devel 63
it.annunci.immobiliari 44
it.annunci.commerciali 43
it.annunci.varie 43
gmane.linux.kernel 35
mozilla.dev.security.policy 22
mozilla.support.seamonkey 19
mpc.lists.nanog 13
mozilla.dev.platform 13
gmane.comp.gis.openstreetmap.tagging 12
nemo.abuse 8
mozilla.support.bugzilla 6
gmane.comp.gis.openstreetmap.imports 4
mozilla.dev.ui-alerts 3
gmane.linux.ports.arm.mediatek 3
mpc.lists.freebsd.wireless 3
south-wales.test 3
johnbhgolddiggers.com 2
mpc.lists.freebsd.x11 2
TOTAL: 45 432

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

GroupsCount
it.scienza.astronomia 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3625
EMP (phn path) 115
Binary: non-binary distribution 47
Too many newsgroups 46
EMP (phn nph) 43
Binary Image: misplaced jpg 24
EMP (phl) 24
User-issued cancel 15
Binary: misplaced par2 14
Binary: misplaced rar 11
Too many newsgroups (meow) 2
Binary: misplaced 224 1
Binary: misplaced 066 1
Binary: misplaced 453 1
Binary: misplaced 096 1
Binary: misplaced 290 1
Binary: misplaced 015 1
HTML post 1
TOTAL: 18 3973

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.albasani.net 8
TOTAL: 1 8
Including strange strings
newsfeed.datemas.de 175
news-out.mixmin.net 160
news.redatomik.org 122
news.swapon.de 55
news-out.aioe.org 15
newsfeed.neva.ru 7
news.snarked.org 5
news.albasani.net 4
feeder.awxg.com 2
agency-nz-out.news.mb-net.net 1
TOTAL: 12 548
TOTAL: 2 556

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17722 582 17117 22 1 28 3%23:59:45
2awxg 19722 31 19685 2 0 0 0%23:59:40
3csiph.com 18260 26 17968 0 0 205 0%23:59:44
4news.freedyn.net 20220 8 20049 1 0 15 0%23:59:44
5news.samoylyk.net 17823 6 17629 0 0 1810 0%23:59:38
6aioe 16787 6 16701 0 0 0 0%23:59:24
7eternal-september 17485 6 17447 0 0 0 0%23:59:44
8news.redatomik.org 18712 6 18695 0 0 0 0%23:59:42
9news-in.mixmin.net 18086 6 18042 0 0 0 0%23:59:26
10newsfeed.datemas.de 16758 5 16675 0 0 82 0%23:59:43
11neva.ru 17232 5 17209 1 0 0 0%23:59:44
12mb-net.net 19947 5 19914 2 0 0 0%23:59:44
13news.albasani.net 21241 4 17886 1611 5 6430 0%23:59:44
14news.snarked.org 7907 3 7867 1 0 7667 0%23:59:44
15news.swapon.de 1550 1 1549 0 0 0 0%23:46:26
TOTAL: 15 249452 700 244433 1640 6 16237 0%359:41:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.7 MB317.9 KB5.0 MB0.1 KB/s8.5 KB23:59:45
2csiph.com110.2 KB0.0 KB110.2 KB0.0 KB/s4.2 KB23:59:44
3awxg71.4 KB7.8 KB79.1 KB0.0 KB/s2.4 KB23:59:40
4news.freedyn.net11.8 KB10.9 KB22.7 KB0.0 KB/s2.5 KB23:59:44
5news.samoylyk.net7.5 KB0.0 KB7.5 KB0.0 KB/s1.2 KB23:59:38
6aioe7.5 KB0.0 KB7.5 KB0.0 KB/s1.2 KB23:59:24
7eternal-september7.5 KB0.0 KB7.5 KB0.0 KB/s1.2 KB23:59:44
8news.redatomik.org7.5 KB0.0 KB7.5 KB0.0 KB/s1.2 KB23:59:42
9news-in.mixmin.net7.5 KB0.0 KB7.5 KB0.0 KB/s1.2 KB23:59:26
10mb-net.net7.3 KB2.9 KB10.1 KB0.0 KB/s1.4 KB23:59:44
11neva.ru6.2 KB1.2 KB7.5 KB0.0 KB/s1.2 KB23:59:44
12newsfeed.datemas.de6.1 KB0.0 KB6.1 KB0.0 KB/s1.2 KB23:59:43
13news.albasani.net4.7 KB7.1 MB7.1 MB0.1 KB/s4.5 KB23:59:44
14news.snarked.org4.1 KB1.5 KB5.6 KB0.0 KB/s1.4 KB23:59:44
15news.swapon.de1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:46:26
TOTAL: 155.0 MB7.5 MB12.4 MB0.0 KB/s5.4 KB359:41:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 381 616220.2 MB 3620 6 000:13:20
2184-155-237-130.cpe.cableone.net 8 303610.5 MB 560 0 1600:48:41
3vorlon.activateit.net.au 24 12351.6 MB 160 0 000:05:40
460.234.68.122 6 31128.7 KB 1 0 000:25:26
TOTAL: 4 419 1046432.5 MB 4341 6 1647:32:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 381 616220.2 MB 3620 6 000:13:20
2*.cpe.cableone.net 17 303610.5 MB 560 0 1646:12:59
3*.activateit.net.au 24 12351.6 MB 160 0 000:05:40
4unresolved 16 31128.7 KB 1 0 000:58:39
5*.news.bbs.nz 4 00.0 KB 0 0 000:00:53
6*.hsd1.or.comcast.net 24 00.0 KB 0 0 000:00:30
TOTAL: 6 466 1046432.5 MB 4341 6 1647:32:07

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 9
bpanther 8
crash 5
paulh 4
TOTAL: 5 50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.736 0.248 0.02545:24:17
184-155-237-130.cpe.cableone.net 1.368 0.756 0.01700:48:41
60.234.68.122 0.436 0.048 0.01300:25:26
118.149.157.199 0.308 0.048 0.00000:21:07
agency.bbs.nz 28.464 6.628 0.00000:13:20
118.149.199.92 0.180 0.028 0.00000:12:00
vorlon.activateit.net.au 1.548 0.388 0.20200:05:40
avon.news.bbs.nz 0.268 0.052 0.01100:00:53
c-73-11-56-74.hsd1.or.comcast.net 1.284 0.200 0.00000:00:30
? 1.764 0.212 0.00000:00:03
94.163.86.175 0.060 0.004 0.00000:00:02
94.163.165.137 0.040 0.016 0.00000:00:02
TOTAL: 12 36.456 8.628 0.26847:32:07

Curious NNRP server explorers [Top 20]:

SystemConn
c-73-11-56-74.hsd1.or.comcast.net 24
67-60-219-146.cpe.cableone.net 9
118.149.157.199 5
avon.news.bbs.nz 4
118.149.199.92 3
94.163.165.137 1
94.163.86.175 1
TOTAL: 7 47

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 2668 25.5%
2soc 1651 15.8%
3comp 1398 13.4%
4uk 1331 12.7%
5linux 1040 10.0%
6sci 874 8.4%
7alt 477 4.6%
8news 333 3.2%
9talk 245 2.3%
10misc 216 2.1%
11mozilla 79 0.8%
12nz 62 0.6%
13microsoft 32 0.3%
14humanities 16 0.2%
15agency 15 0.1%
16aus 9 0.1%
17us 1 0.0%
18gnu 1 0.0%
TOTAL: 18 10448100.0%

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

NewsgroupCount
1rec.arts.tv 964
2uk.legal 463
3uk.d-i-y 459
4linux.debian.bugs.dist 377
5news.lists.filters 308
6comp.lang.c 306
7soc.retirement 265
8rec.arts.sf.written 229
9rec.arts.drwho 219
10rec.food.cooking 186
11comp.lang.python 181
12alt.comp.os.windows-10 178
13sci.physics 174
14linux.debian.changes.devel 168
15linux.debian.bugs.rc 165
16sci.physics.relativity 161
17comp.os.linux.advocacy 149
18soc.culture.polish 141
19soc.history 131
20soc.penpals 125
21uk.radio.amateur 124
22uk.tech.digital-tv 122
23rec.gambling.poker 116
24talk.origins 110
25soc.culture.china 105
26misc.survivalism 104
27rec.sport.football.college 100
28talk.politics.guns 100
29sci.electronics.design 96
30comp.sys.mac.system 95
31soc.genealogy.britain 94
32sci.logic 86
33alt.conspiracy 72
34soc.culture.israel 72
35rec.drugs.cannabis 70
36linux.debian.user 67
37sci.astro.amateur 64
38nz.general 62
39sci.med.cardiology 61
40alt.politics.trump 59
41comp.lang.ada 58
42uk.tech.broadcast 56
43rec.music.classical.recordings 55
44soc.culture.brazil 54
45rec.sport.tennis 54
46soc.genealogy.medieval 54
47sci.math 53
48rec.boats 51
49linux.debian.devel 49
50comp.sys.acorn.apps 48
51mozilla.support.thunderbird 48
52alt.test 47
53soc.culture.indian 46
54uk.comp.sys.mac 45
55rec.sport.golf 44
56comp.os.vms 43
57soc.women 43
58rec.photo.digital 43
59soc.history.what-if 42
60sci.lang 42
61soc.culture.usa 39
62rec.arts.sf.tv 38
63linux.debian.user.italian 36
64comp.sys.raspberry-pi 36
65comp.lang.tcl 36
66linux.gentoo.user 35
67alt.bbs.synchronet 35
68rec.sport.pro-wrestling 34
69comp.lang.fortran 34
70rec.sport.soccer 33
71alt.conspiracy.jfk 32
72soc.culture.bulgaria 31
73soc.culture.vietnamese 31
74rec.bicycles.tech 31
75sci.med.pharmacy 30
76rec.humor 29
77soc.singles 29
78misc.health.alternative 29
79comp.ai.philosophy 28
80talk.politics.misc 28
81soc.culture.singapore 27
82rec.music.rock-pop-r+b.1950s 26
83linux.debian.maint.boot 25
84rec.aviation.soaring 25
85mozilla.general 25
86uk.legal.moderated 24
87comp.databases.ingres 24
88comp.lang.javascript 24
89sci.crypt 24
90rec.arts.tv.soaps.cbs 22
91soc.culture.ukrainian 22
92sci.military.naval 21
93comp.lang.forth 20
94soc.history.medieval 20
95comp.protocols.dns.bind 20
96misc.news.internet.discuss 18
97comp.unix.shell 18
98soc.history.war.us-revolution 18
99rec.radio.amateur.misc 18
100rec.arts.movies.current-films 18
TOTAL: 350 10448