news.bbs.nz daily logs

Aug 15 23:58:01 -- Aug 16 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124338 59.4%9.6 MB 36.2%
innd 35339 16.9%5.8 MB 21.7%
innfeed 26373 12.6%5.2 MB 19.6%
inn 21969 10.5%5.7 MB 21.5%
cnfsstat 1440 0.7%259.4 KB 1.0%
controlchan 5 0.0%0.7 KB 0.0%
TOTAL: 6 209464 100.0%26.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 296486 49.3%
Positive hits 283015 47.1%
Do not exist 21365 3.6%
Cache misses 191 0.0%
TOTAL: 4 601057 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.196 0.0%91 0.000 2.154 11.000
article cleanup00:00:00.204 0.0%21680 0.000 0.009 0.035
article logging00:00:00.560 0.0%21926 0.000 0.026 0.130
article parse00:00:00.785 0.0%73487 0.000 0.011 0.030
article write00:00:01.206 0.0%17398 0.000 0.069 0.427
artlog/artcncl00:00:00.001 0.0%88 0.000 0.011 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.544 0.0%589980 0.000 0.001 0.012
hisgrep/artcncl00:00:00.001 0.0%85 0.000 0.012 0.091
hishave/artcncl00:00:00.000 0.0%91 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.384 0.0%606794 0.002 0.014 0.642
history sync00:00:00.024 0.0%378 0.000 0.063 5.000
history write00:00:06.714 0.0%21537 0.012 0.312 17.275
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:57:54.248 99.8%603772 71.440 142.892 373.216
nntp read00:00:03.471 0.0%604823 0.003 0.006 0.016
overview write00:00:38.969 0.0%17398 0.044 2.240 43.374
perl filter00:00:46.877 0.1%21537 1.376 2.177 5.583
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.950 0.0%34797 0.000 0.027 0.139
TOTAL: 24:00:57.80523:59:43.134 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%24895 0.000 0.003 0.022
article prepare00:00:00.001 0.0%8802 0.000 0.000 0.009
article read00:00:00.389 0.0%2043 0.000 0.190 17.615
backlog stats00:00:00.321 0.0%320594 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.614 0.0%266053 0.002 0.006 0.014
data write00:00:03.044 0.0%253220 0.006 0.012 0.058
idle23:53:54.101100.0%320594 158.511 268.358 546.895
status file00:00:16.913 0.0%2004 0.833 8.440 365.111
TOTAL: 23:54:34.15823:54:16.448100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:31:37.151 94.2%129907 0.000 153.165 83456.247
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.083 0.0%298048 0.000 0.007 0.200
readart00:00:02.010 0.0%7467 0.000 0.269 12.000
TOTAL: 05:52:05.32205:31:41.244 94.2%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 23 21470 3589 15801 2080 16%27:53:03
2bbs-nz-out.news.weretis.net 4 37555 3504 33830 221 9%49:44:56
3feeder.eternal-september.org 5 20842 2111 18604 127 10%25:48:41
4bbsnz-out.feed.uzoreto.com 1123 27828 2073 24890 865 7%95:20:25
5news-out.aioe.org 2 16520 1682 14811 27 10%23:18:19
6news.redatomik.org 3 16971 1399 15488 84 8%25:02:41
7news-out.mixmin.net 4 17858 1226 16169 463 6%24:24:40
8newsfeed.neva.ru 143 11446 911 10325 210 7%72:00:24
9news.albasani.net 1 18623 562 17904 157 3%24:51:41
10newsfeed.datemas.de 2 18161 185 17923 53 1%24:08:35
11csiph.com 2 16754 163 16584 7 0%23:59:49
12news.swapon.de 5 1609 115 1493 1 7%23:27:35
13news.samoylyk.net 3 17789 63 17713 13 0%28:18:19
14agency-nz-out.news.mb-net.net 7 17850 44 17786 20 0%23:35:32
15news.freedyn.net 1 13630 34 13559 37 0%16:18:44
16feeder.awxg.com 1 14390 10 14372 8 0%23:59:56
17localhost 4 3 3 0 0 100%00:00:00
TOTAL: 17 1333 289299 17674 267252 4373 6%532:13:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.3 MB563.8 KB1.4 MB20.3 MB 90%5.6 KB
2bbsnz-out.feed.uzoreto.com13.4 MB134.8 KB5.9 MB19.4 MB 69%6.8 KB
3news.snarked.org12.1 MB141.6 KB15.3 MB27.6 MB 44%5.0 KB
4news.albasani.net7.6 MB289.8 KB641.8 KB8.5 MB 89%12.1 KB
5feeder.eternal-september.org5.8 MB572.7 KB1.1 MB7.4 MB 77%3.4 KB
6news-out.mixmin.net4.4 MB87.1 KB1.3 MB5.8 MB 76%3.5 KB
7news-out.aioe.org4.3 MB18.5 KB145.3 KB4.5 MB 96%2.7 KB
8news.redatomik.org4.1 MB143.6 KB404.5 KB4.6 MB 88%3.2 KB
9newsfeed.neva.ru2.3 MB104.1 KB1.3 MB3.7 MB 61%3.4 KB
10newsfeed.datemas.de1.6 MB258.6 KB601.0 KB2.5 MB 66%10.7 KB
11news.freedyn.net525.7 KB588.2 KB660.5 KB1.7 MB 29%25.0 KB
12csiph.com492.3 KB62.1 KB62.1 KB616.6 KB 79%3.6 KB
13news.swapon.de286.3 KB3.3 KB3.3 KB292.9 KB 97%2.5 KB
14news.samoylyk.net158.7 KB460.7 KB528.0 KB1.1 MB 13%15.1 KB
15agency-nz-out.news.mb-net.net117.2 KB95.5 KB128.3 KB341.0 KB 34%5.3 KB
16feeder.awxg.com28.0 KB51.3 KB51.3 KB130.6 KB 21%7.3 KB
17localhost3.8 KB0.0 KB0.0 KB3.8 KB100%1.3 KB
TOTAL: 1775.6 MB3.5 MB29.5 MB108.6 MB 69%5.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 15 23:58:01 - 23:59:59 35 0.2% 0.2981.4 KB 0.1% 0.68
Aug 16 00:00:00 - 00:59:59 854 4.9% 0.246.1 MB 8.5% 1.73
Aug 16 01:00:00 - 01:59:59 828 4.8% 0.233.0 MB 4.2% 0.86
Aug 16 02:00:00 - 02:59:59 992 5.7% 0.282.8 MB 3.8% 0.79
Aug 16 03:00:00 - 03:59:59 983 5.7% 0.273.6 MB 5.1% 1.03
Aug 16 04:00:00 - 04:59:59 1090 6.3% 0.3011.3 MB 15.7% 3.21
Aug 16 05:00:00 - 05:59:59 906 5.2% 0.252.9 MB 4.0% 0.82
Aug 16 06:00:00 - 06:59:59 891 5.1% 0.253.7 MB 5.1% 1.04
Aug 16 07:00:00 - 07:59:59 911 5.2% 0.252.8 MB 3.8% 0.79
Aug 16 08:00:00 - 08:59:59 826 4.8% 0.233.0 MB 4.2% 0.86
Aug 16 09:00:00 - 09:59:59 804 4.6% 0.223.5 MB 4.8% 0.99
Aug 16 10:00:00 - 10:59:59 600 3.5% 0.172.2 MB 3.0% 0.62
Aug 16 11:00:00 - 11:59:59 579 3.3% 0.162.7 MB 3.8% 0.78
Aug 16 12:00:00 - 12:59:59 421 2.4% 0.121.2 MB 1.7% 0.35
Aug 16 13:00:00 - 13:59:59 460 2.6% 0.132.0 MB 2.8% 0.58
Aug 16 14:00:00 - 14:59:59 405 2.3% 0.111.4 MB 1.9% 0.39
Aug 16 15:00:00 - 15:59:59 439 2.5% 0.122.6 MB 3.6% 0.73
Aug 16 16:00:00 - 16:59:59 394 2.3% 0.111.3 MB 1.8% 0.37
Aug 16 17:00:00 - 17:59:59 541 3.1% 0.151.7 MB 2.3% 0.47
Aug 16 18:00:00 - 18:59:59 643 3.7% 0.182.1 MB 2.9% 0.60
Aug 16 19:00:00 - 19:59:59 666 3.8% 0.182.0 MB 2.8% 0.58
Aug 16 20:00:00 - 20:59:59 761 4.4% 0.212.7 MB 3.8% 0.77
Aug 16 21:00:00 - 21:59:59 771 4.4% 0.212.2 MB 3.0% 0.62
Aug 16 22:00:00 - 22:59:59 759 4.4% 0.212.1 MB 2.9% 0.59
Aug 16 23:00:00 - 23:58:01 811 4.7% 0.233.2 MB 4.4% 0.93
TOTAL: 24:00:00 17370 100.0% 0.2072.0 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB27.8 GB 55.6% 0 0.31 1988.03
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.1 GB 64.1% 0 0.35 1730.85
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB356.0 MB 0.7% 0 0.0323703.70
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 GB25.6 GB 51.2% 0 0.64 955.28
TOTAL: 10-500.0 GB85.8 GB 17.2% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2063 11 0 5 0 0 0 0 2047
2bbsnz-out.feed.uzoreto.com 869 37 0 5 0 0 0 0 827
3news-out.mixmin.net 520 0 0 9 0 0 0 0 511
4bbs-nz-out.news.weretis.net 266 47 0 30 0 0 0 0 189
5newsfeed.neva.ru 209 17 0 17 0 0 0 0 175
6news.albasani.net 186 0 0 6 0 0 0 0 180
7news.redatomik.org 115 0 0 11 0 0 0 0 104
8feeder.eternal-september.org 114 0 0 9 0 0 0 0 105
9news.freedyn.net 36 2 0 12 0 0 0 0 22
10news-out.aioe.org 31 22 0 4 0 0 0 0 5
11newsfeed.datemas.de 31 6 0 6 0 0 0 0 19
12news.swapon.de 28 0 0 1 0 0 0 0 27
13agency-nz-out.news.mb-net.net 21 3 0 7 0 0 0 0 11
14news.samoylyk.net 10 0 0 8 0 0 0 0 2
15csiph.com 7 0 0 7 0 0 0 0 0
16feeder.awxg.com 5 0 0 5 0 0 0 0 0
TOTAL: 16 4511 145 0 142 0 0 0 0 4224

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 17
mozilla.dev.platform 14
mozilla.support.seamonkey 12
mozilla.dev.apps.thunderbird 9
gmane.comp.gis.openstreetmap.tagging 9
mozilla.dev.ui-alerts 9
mozilla.dev.security.policy 7
it.annunci.commerciali 6
usc.forsale 5
it.annunci.immobiliari 3
mozilla.tools.marionette 3
fido7.ru.android 3
mozilla.dev.l10n 3
it.annunci.varie 3
mn.jobs 3
mozilla.test 3
gmane.linux.kernel 3
mozilla.dev.tech.js-engine 2
mozilla.support.calendar 2
mozilla.dev.super-review 2
TOTAL: 42 145

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3498
EMP (phn path) 328
EMP (phl) 49
Too many newsgroups 24
Binary: non-binary distribution 24
User-issued cancel 22
Binary: misplaced par2 16
User-issued spam cancel 10
Binary: misplaced rar 4
Binary Image: misplaced jpg 3
Binary: misplaced 259 1
HTML post 1
TOTAL: 12 3980

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 80
bbs-nz-out.news.weretis.net 58
news.redatomik.org 30
news.swapon.de 27
news.albasani.net 24
news.snarked.org 7
news-out.aioe.org 5
newsfeed.datemas.de 4
newsfeed.neva.ru 4
bbsnz-out.feed.uzoreto.com 4
TOTAL: 11 244
TOTAL: 1 244

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15768 985 14759 24 0 0 6%23:59:47
2awxg 16732 37 16686 3 0 0 0%23:59:45
3mb-net.net 17325 9 17245 0 0 98 0%23:57:49
4weretis.net 13949 6 13760 6 0 0 0%23:59:37
5csiph.com 17240 6 17184 1 0 1 0%23:59:45
6news.snarked.org 13731 6 13624 5 0 31 0%23:59:46
7news.freedyn.net 17445 5 17319 0 0 0 0%23:59:46
8aioe 14584 4 14524 0 0 0 0%23:59:46
9news.uzoreto.com 15268 3 15257 0 0 0 0%23:59:30
10news-in.mixmin.net 15805 3 15788 0 0 0 0%23:59:41
11news.samoylyk.net 15826 3 15711 0 0 317 0%23:59:46
12news.redatomik.org 15874 3 15848 0 0 6 0%23:59:46
13eternal-september 15020 2 14959 0 0 71 0%23:59:46
14news.swapon.de 1609 2 1606 0 0 0 0%23:51:08
15newsfeed.datemas.de 17309 1 17195 2 0 82 0%23:59:46
16neva.ru 16033 0 16027 3 0 0 0%23:59:46
17news.albasani.net 19263 0 15665 929 1 6971 0%23:59:26
TOTAL: 17 258781 1075 253157 973 1 7577 0%407:44:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org11.3 MB194.5 KB11.5 MB0.1 KB/s11.6 KB23:59:47
2awxg108.4 KB67.6 KB176.0 KB0.0 KB/s4.4 KB23:59:45
3mb-net.net23.1 KB0.0 KB23.1 KB0.0 KB/s2.6 KB23:57:49
4csiph.com12.1 KB5.3 KB17.4 KB0.0 KB/s2.5 KB23:59:45
5news.snarked.org9.4 KB14.9 KB24.2 KB0.0 KB/s2.2 KB23:59:46
6weretis.net9.0 KB14.5 KB23.5 KB0.0 KB/s2.0 KB23:59:37
7news.freedyn.net7.2 KB0.0 KB7.2 KB0.0 KB/s1.4 KB23:59:46
8aioe6.6 KB0.0 KB6.6 KB0.0 KB/s1.7 KB23:59:46
9news.uzoreto.com3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:30
10news-in.mixmin.net3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:41
11news.samoylyk.net3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:46
12news.redatomik.org3.8 KB0.0 KB3.8 KB0.0 KB/s1.3 KB23:59:46
13news.swapon.de2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:51:08
14eternal-september2.3 KB0.0 KB2.3 KB0.0 KB/s1.1 KB23:59:46
15newsfeed.datemas.de0.9 KB3.1 KB4.0 KB0.0 KB/s1.3 KB23:59:46
16neva.ru0.0 KB3.8 KB3.8 KB0.0 KB/s1.3 KB23:59:46
17news.albasani.net0.0 KB5.1 MB5.1 MB0.1 KB/s5.6 KB23:59:26
TOTAL: 1711.5 MB5.4 MB16.9 MB0.0 KB/s8.4 KB407:44:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 593222.1 MB 3436 3 000:14:50
2vorlon.activateit.net.au 24 9991.5 MB 125 0 000:04:49
3160-3-245-118.cpe.cableone.net 1 427.1 KB 1 0 005:10:12
4121.99.149.229 2 21.8 KB 2 0 000:02:49
TOTAL: 4 414 693723.6 MB 3564 3 005:51:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 593222.1 MB 3436 3 000:14:50
2*.activateit.net.au 24 9991.5 MB 125 0 000:04:49
3*.cpe.cableone.net 1 427.1 KB 1 0 005:10:12
4unresolved 8 21.8 KB 2 0 000:22:05
TOTAL: 4 420 693723.6 MB 3564 3 005:51:58

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 1
TOTAL: 2 25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.080 0.036 0.00305:10:12
118.149.174.205 0.256 0.024 0.00000:19:11
agency.bbs.nz 28.492 6.200 0.00000:14:50
vorlon.activateit.net.au 1.420 0.324 0.13100:04:49
121.99.149.229 0.168 0.068 0.00000:02:49
94.161.59.192 0.120 0.008 0.00000:00:04
? 1.208 0.136 0.00000:00:01
TOTAL: 7 31.744 6.796 0.13405:51:58

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.174.205 4
94.161.59.192 2
TOTAL: 2 6

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2204 31.8%
2comp 846 12.2%
3uk 747 10.8%
4soc 738 10.6%
5sci 737 10.6%
6alt 575 8.3%
7linux 472 6.8%
8talk 252 3.6%
9misc 179 2.6%
10news 73 1.1%
11nz 41 0.6%
12mozilla 32 0.5%
13microsoft 32 0.5%
14humanities 8 0.1%
15agency 1 0.0%
TOTAL: 15 6937100.0%

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

NewsgroupCount
1rec.arts.tv 536
2alt.comp.os.windows-10 346
3uk.d-i-y 343
4rec.food.cooking 303
5comp.lang.c 297
6rec.arts.drwho 269
7uk.legal 213
8comp.os.linux.advocacy 172
9linux.debian.bugs.dist 172
10sci.physics 162
11talk.politics.guns 128
12rec.arts.sf.written 125
13sci.math 116
14alt.politics.trump 114
15soc.culture.polish 114
16rec.drugs.cannabis 110
17misc.survivalism 105
18soc.culture.china 102
19linux.debian.changes.devel 102
20sci.electronics.design 98
21rec.gambling.poker 94
22rec.sport.football.college 87
23sci.physics.relativity 82
24uk.legal.moderated 77
25comp.lang.python 76
26talk.origins 75
27sci.lang 61
28soc.culture.indian 60
29sci.logic 58
30news.lists.filters 57
31soc.penpals 57
32soc.retirement 56
33rec.sport.golf 56
34soc.culture.israel 54
35sci.med.cardiology 54
36uk.radio.amateur 54
37rec.boats 53
38linux.debian.bugs.rc 53
39rec.aviation.soaring 52
40rec.sport.pro-wrestling 51
41alt.conspiracy.jfk 47
42rec.music.dylan 46
43misc.invest.stocks 44
44rec.sport.tennis 42
45rec.music.classical.recordings 41
46linux.debian.user 39
47nz.general 35
48talk.politics.misc 33
49comp.ai.philosophy 30
50soc.history.living 28
51soc.culture.vietnamese 27
52comp.lang.tcl 26
53uk.tech.digital-tv 26
54soc.culture.usa 25
55microsoft.public.windowsxp.general 25
56alt.test 23
57comp.lang.prolog 22
58soc.genealogy.britain 22
59alt.os.linux.ubuntu 21
60linux.gentoo.user 21
61sci.electronics.repair 19
62mozilla.support.thunderbird 19
63sci.bio.paleontology 18
64rec.outdoors.rv-travel 18
65rec.crafts.metalworking 18
66rec.music.rock-pop-r+b.1950s 18
67soc.history 18
68alt.conspiracy 17
69comp.lang.javascript 17
70sci.military.naval 16
71rec.games.pinball 16
72rec.bicycles.tech 16
73sci.space.policy 15
74rec.sport.billiard 15
75comp.lang.fortran 15
76soc.culture.brazil 15
77comp.sys.acorn.misc 15
78soc.women 15
79uk.rec.cycling.moderated 13
80comp.lang.forth 12
81rec.gardens.edible 12
82rec.arts.movies.past-films 12
83soc.culture.german 11
84soc.genealogy.jewish 11
85soc.genealogy.medieval 11
86comp.os.vms 11
87comp.arch 11
88rec.sport.rowing 11
89rec.audio.opinion 11
90misc.news.internet.discuss 10
91linux.debian.devel 10
92uk.rec.cycling 9
93rec.photo.digital 9
94rec.arts.tv.soaps.cbs 9
95linux.debian.user.french 8
96soc.history.medieval 8
97comp.lang.ada 8
98comp.protocols.dns.bind 8
99rec.games.trivia 8
100rec.radio.amateur.misc 8
TOTAL: 328 6937