news.bbs.nz daily logs

Sep 25 23:58:01 -- Sep 26 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 127025 56.5%9.9 MB 35.5%
innfeed 40143 17.9%6.7 MB 24.2%
innd 32341 14.4%5.2 MB 18.7%
inn 23709 10.6%5.7 MB 20.7%
cnfsstat 1440 0.6%250.1 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 224659 100.0%27.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 307990 50.4%
Positive hits 279318 45.7%
Do not exist 22879 3.7%
Cache misses 607 0.1%
TOTAL: 4 610794 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.115 0.0%57 0.000 2.018 33.000
article cleanup00:00:00.247 0.0%23272 0.000 0.011 0.036
article logging00:00:00.644 0.0%23657 0.000 0.027 0.663
article parse00:00:00.643 0.0%61306 0.000 0.010 0.029
article write00:00:07.656 0.0%18465 0.000 0.415 47.580
artlog/artcncl00:00:00.001 0.0%57 0.000 0.018 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.461 0.0%577392 0.000 0.001 0.012
hisgrep/artcncl00:00:00.001 0.0%57 0.000 0.018 0.333
hishave/artcncl00:00:00.000 0.0%57 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.301 0.0%615693 0.002 0.015 0.655
history sync00:00:00.021 0.0%370 0.000 0.057 0.667
history write00:00:06.028 0.0%23035 0.006 0.262 15.611
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:30.233 99.8%585595 87.640 147.286 498.448
nntp read00:00:04.977 0.0%591010 0.004 0.008 0.028
overview write00:00:43.085 0.0%18465 0.042 2.333 60.565
perl filter00:00:38.221 0.0%23033 0.948 1.659 5.801
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.190 0.0%36930 0.000 0.032 0.194
TOTAL: 24:01:02.25623:59:22.824 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%49242 0.000 0.002 0.013
article prepare00:00:00.001 0.0%8880 0.000 0.000 0.007
article read00:00:00.290 0.0%2072 0.000 0.140 14.800
backlog stats00:00:00.695 0.0%311883 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.836 0.0%256110 0.005 0.011 0.024
data write00:00:05.847 0.0%242942 0.004 0.024 0.066
idle23:51:32.893 99.8%311883 102.617 275.401 779.931
status file00:02:37.981 0.2%8233 0.462 19.189 534.130
TOTAL: 23:54:40.35723:54:20.627100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%3 0.000 0.000 0.000
idle08:58:31.528 98.2%134216 0.000 240.743 75132.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.068 0.0%283477 0.000 0.007 0.200
readart00:00:00.728 0.0%8627 0.000 0.084 16.500
TOTAL: 09:08:25.94808:58:34.324 98.2%----

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
1bbs-nz-out.news.weretis.net 11 37377 4712 32260 405 12%48:58:54
2news.snarked.org 35 23238 2954 17986 2298 12%40:05:09
3news-out.aioe.org 2 18610 2546 16019 45 13%24:34:59
4bbsnz-out.feed.uzoreto.com 574 28190 2384 25033 773 8%47:00:36
5feeder.eternal-september.org 4 20392 1985 18265 142 9%23:52:55
6news-out.mixmin.net 5 25063 1356 23160 547 5%24:51:37
7news.redatomik.org 3 18249 867 17325 57 4%24:08:47
8newsfeed.neva.ru 146 8572 713 7545 314 8%71:39:22
9news.albasani.net 1 18877 412 18303 162 2%23:30:01
10csiph.com 2 17694 245 17439 10 1%23:59:46
11news.swapon.de 10 1406 99 1303 4 7%24:15:44
12agency-nz-out.news.mb-net.net 6 21971 85 21854 32 0%26:54:42
13news.freedyn.net 2 19681 51 19599 31 0%23:47:25
14news.samoylyk.net 2 17693 48 17636 9 0%23:59:46
15feeder.awxg.com 1 15491 21 15463 7 0%17:56:28
16news.ausics.org 1 141950 6 141943 1 0%222:18:25
17localhost 7 6 6 0 0 100%00:00:00
TOTAL: 17 812 434460 18490 411133 4837 4%691:54:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net19.8 MB209.8 KB1.5 MB21.5 MB 92%4.3 KB
2news.snarked.org9.7 MB84.7 KB13.2 MB23.0 MB 42%4.5 KB
3bbsnz-out.feed.uzoreto.com7.3 MB38.5 KB3.5 MB10.8 MB 67%3.5 KB
4news-out.aioe.org6.6 MB37.7 KB319.8 KB6.9 MB 94%2.7 KB
5feeder.eternal-september.org5.1 MB149.3 KB471.3 KB5.7 MB 89%2.7 KB
6news-out.mixmin.net4.0 MB53.3 KB1.1 MB5.2 MB 77%2.8 KB
7news.redatomik.org2.9 MB124.3 KB303.9 KB3.3 MB 87%3.7 KB
8news.albasani.net2.2 MB134.5 KB467.3 KB2.7 MB 78%4.9 KB
9newsfeed.neva.ru1.7 MB51.2 KB1.2 MB2.9 MB 57%2.9 KB
10csiph.com771.4 KB29.1 KB29.1 KB829.5 KB 92%3.3 KB
11news.swapon.de265.6 KB10.8 KB10.8 KB287.3 KB 92%2.8 KB
12agency-nz-out.news.mb-net.net234.7 KB136.4 KB199.8 KB570.9 KB 41%4.9 KB
13news.freedyn.net168.0 KB93.7 KB145.4 KB407.1 KB 41%5.0 KB
14news.samoylyk.net152.0 KB109.0 KB116.9 KB377.9 KB 40%6.6 KB
15feeder.awxg.com102.7 KB26.2 KB26.2 KB155.0 KB 66%5.5 KB
16news.ausics.org15.9 KB1.9 KB1.9 KB19.7 KB 80%2.8 KB
17localhost14.0 KB0.0 KB0.0 KB14.0 KB100%2.3 KB
TOTAL: 1760.8 MB1.3 MB22.5 MB84.6 MB 71%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 25 23:58:01 - 23:59:59 28 0.2% 0.2479.3 KB 0.1% 0.67
Sep 26 00:00:00 - 00:59:59 846 4.6% 0.232.1 MB 3.5% 0.61
Sep 26 01:00:00 - 01:59:59 1029 5.6% 0.294.1 MB 6.7% 1.17
Sep 26 02:00:00 - 02:59:59 1059 5.7% 0.293.1 MB 5.1% 0.89
Sep 26 03:00:00 - 03:59:59 1090 5.9% 0.303.9 MB 6.3% 1.10
Sep 26 04:00:00 - 04:59:59 1072 5.8% 0.303.8 MB 6.2% 1.08
Sep 26 05:00:00 - 05:59:59 866 4.7% 0.242.8 MB 4.7% 0.81
Sep 26 06:00:00 - 06:59:59 991 5.4% 0.283.7 MB 6.1% 1.06
Sep 26 07:00:00 - 07:59:59 901 4.9% 0.252.6 MB 4.2% 0.73
Sep 26 08:00:00 - 08:59:59 927 5.0% 0.262.8 MB 4.6% 0.80
Sep 26 09:00:00 - 09:59:59 794 4.3% 0.222.9 MB 4.8% 0.83
Sep 26 10:00:00 - 10:59:59 644 3.5% 0.182.6 MB 4.3% 0.74
Sep 26 11:00:00 - 11:59:59 605 3.3% 0.172.1 MB 3.5% 0.61
Sep 26 12:00:00 - 12:59:59 507 2.7% 0.141.8 MB 2.9% 0.51
Sep 26 13:00:00 - 13:59:59 440 2.4% 0.121.7 MB 2.7% 0.48
Sep 26 14:00:00 - 14:59:59 396 2.1% 0.111.3 MB 2.1% 0.36
Sep 26 15:00:00 - 15:59:59 345 1.9% 0.101.7 MB 2.7% 0.47
Sep 26 16:00:00 - 16:59:59 278 1.5% 0.081.6 MB 2.7% 0.46
Sep 26 17:00:00 - 17:59:59 497 2.7% 0.141.6 MB 2.6% 0.45
Sep 26 18:00:00 - 18:59:59 529 2.9% 0.151.8 MB 3.0% 0.52
Sep 26 19:00:00 - 19:59:59 681 3.7% 0.191.8 MB 2.9% 0.51
Sep 26 20:00:00 - 20:59:59 952 5.2% 0.262.4 MB 4.0% 0.69
Sep 26 21:00:00 - 21:59:59 948 5.1% 0.262.5 MB 4.1% 0.72
Sep 26 22:00:00 - 22:59:59 1149 6.2% 0.322.8 MB 4.6% 0.80
Sep 26 23:00:00 - 23:58:01 900 4.9% 0.263.4 MB 5.6% 1.00
TOTAL: 24:00:00 18474 100.0% 0.2161.1 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.7 GB 57.4% 0 0.32 1921.26
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB33.1 GB 66.1% 0 0.33 1835.82
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB362.5 MB 0.7% 0 0.0232824.71
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 GB27.5 GB 55.0% 0 0.56 1089.38
TOTAL: 10-500.0 GB89.6 GB 17.9% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2234 12 0 19 0 0 0 0 2203
2bbsnz-out.feed.uzoreto.com 774 18 0 15 0 0 0 0 741
3news-out.mixmin.net 622 0 0 14 0 0 0 0 608
4bbs-nz-out.news.weretis.net 557 54 0 40 0 0 0 0 463
5newsfeed.neva.ru 321 10 0 13 0 0 0 0 298
6news.albasani.net 208 1 0 18 0 0 0 0 189
7feeder.eternal-september.org 145 0 0 20 1 0 0 0 124
8news.redatomik.org 109 0 0 17 0 0 0 0 92
9news-out.aioe.org 65 27 0 12 0 0 0 0 26
10news.freedyn.net 46 2 0 8 0 0 0 0 36
11news.swapon.de 28 0 0 4 0 0 0 0 24
12agency-nz-out.news.mb-net.net 27 4 0 13 0 0 0 0 10
13feeder.awxg.com 17 0 0 15 0 0 0 0 2
14csiph.com 15 0 0 15 0 0 0 0 0
15news.samoylyk.net 10 0 0 9 0 0 0 0 1
TOTAL: 15 5178 128 0 232 1 0 0 0 4817

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 16
gmane.linux.alsa.devel 15
gmane.linux.kernel 10
mozilla.support.seamonkey 9
mozilla.dev.platform 8
alt.music.pink-floyd.publius 6
alt.bestjobsusa.colorado.jobs 5
mozilla.dev.apps.thunderbird 5
mozilla.dev.ui-alerts 5
mozilla.dev.security.policy 5
eagle.support.ger 4
mozilla.apis 3
mozilla.community.india 3
it.annunci.commerciali 3
it.annunci.immobiliari 3
it.annunci.varie 3
al.christnet.bible 3
alt.sex.girl 2
mozilla.support.bugzilla 2
gmane.linux.alsa.user 2
TOTAL: 34 128

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

GroupsCount
clari.usa.law.supreme 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3769
EMP (phn path) 456
Too many newsgroups 51
EMP (phn nph) 49
EMP (phl) 44
User-issued cancel 16
User-issued spam cancel 13
Binary: misplaced par2 12
Binary: non-binary distribution 9
Binary Image: misplaced jpg 2
HTML post 1
Binary: misplaced 304 1
Binary: misplaced 106 1
U2 violation - invalid distribution 1
Binary: misplaced 009 1
Binary: misplaced 079 1
Binary: misplaced 017 1
Binary: misplaced rar 1
Binary: misplaced 382 1
Binary: misplaced 002 1
TOTAL: 21 4432

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
bbs-nz-out.news.weretis.net 145
news-out.mixmin.net 107
news.redatomik.org 54
news.swapon.de 24
news-out.aioe.org 22
news.albasani.net 19
newsfeed.neva.ru 5
news.snarked.org 3
feeder.eternal-september.org 3
bbsnz-out.feed.uzoreto.com 1
TOTAL: 10 383
TOTAL: 1 383

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16865 885 15959 21 0 0 5%23:59:23
2awxg 17988 48 17926 4 0 0 0%23:59:24
3news.freedyn.net 18474 8 18400 0 0 3 0%23:59:31
4news.samoylyk.net 16841 6 16812 0 0 16 0%23:59:29
5news.snarked.org 15526 6 15431 0 0 52 0%23:59:44
6news.redatomik.org 17532 6 17511 0 0 7 0%23:59:47
7neva.ru 17294 6 17286 0 0 0 0%23:59:50
8eternal-september 15934 6 15917 0 0 0 0%23:59:50
9mb-net.net 18402 6 18385 0 0 4 0%23:59:44
10weretis.net 13411 6 13402 0 0 0 0%23:59:31
11csiph.com 18269 6 18217 0 0 0 0%23:59:15
12aioe 15636 5 14994 0 0 10217 0%23:59:50
13news-in.mixmin.net 19541 5 17807 0 0 12801 0%23:59:50
14news.albasani.net 19671 5 16418 1070 0 6718 0%23:59:42
15news.swapon.de 1469 3 1466 0 0 0 0%23:32:14
16news.uzoreto.com 15936 2 15915 4 0 22 0%23:59:07
TOTAL: 16 258789 1009 251846 1099 0 29840 0%383:26:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org11.4 MB81.5 KB11.5 MB0.1 KB/s13.0 KB23:59:23
2awxg114.7 KB14.5 KB129.2 KB0.0 KB/s2.5 KB23:59:24
3news.freedyn.net17.5 KB0.0 KB17.5 KB0.0 KB/s2.2 KB23:59:31
4news.samoylyk.net14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:29
5news.snarked.org14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:44
6news.redatomik.org14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:47
7neva.ru14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:50
8eternal-september14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:50
9mb-net.net14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:44
10weretis.net14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:31
11csiph.com14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB23:59:15
12aioe12.3 KB0.0 KB12.3 KB0.0 KB/s2.5 KB23:59:50
13news-in.mixmin.net12.3 KB0.0 KB12.3 KB0.0 KB/s2.5 KB23:59:50
14news.albasani.net11.3 KB4.1 MB4.1 MB0.0 KB/s3.9 KB23:59:42
15news.swapon.de10.0 KB0.0 KB10.0 KB0.0 KB/s3.3 KB23:32:14
16news.uzoreto.com2.7 KB11.3 KB14.0 KB0.0 KB/s2.3 KB23:59:07
TOTAL: 1611.7 MB4.2 MB15.9 MB0.0 KB/s7.7 KB383:26:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 622521.5 MB 3288 5 000:15:33
2vorlon.activateit.net.au 24 12211.8 MB 134 0 000:05:27
3160-3-245-118.cpe.cableone.net 2 43247.9 KB 1 0 007:55:50
4amigacity.xyz 70 3478.7 KB 19 0 28000:12:21
560.234.68.122 13 1121.5 KB 5 1 000:30:50
TOTAL: 5 496 753423.7 MB 3447 6 28009:08:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 622521.5 MB 3288 5 000:15:33
2*.activateit.net.au 24 12211.8 MB 134 0 000:05:27
3*.cpe.cableone.net 2 43247.9 KB 1 0 007:55:50
4*.xyz 70 3478.7 KB 19 0 28000:12:21
5unresolved 25 1121.5 KB 5 1 000:39:03
TOTAL: 5 508 753423.7 MB 3447 6 28009:08:18

NNRP auth users [Top 20]:

UserConn
amigacity 70
amybbs 24
crash 11
malcolmlewis 2
TOTAL: 4 107

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.192 0.048 0.00307:55:50
60.234.68.122 0.840 0.104 0.02600:30:50
agency.bbs.nz 30.528 7.568 0.00000:15:33
amigacity.xyz 4.244 0.780 0.19700:12:21
118.149.233.138 0.648 0.080 0.00000:07:58
vorlon.activateit.net.au 1.588 0.484 0.11700:05:27
107.170.204.210 0.052 0.012 0.00000:00:09
94.167.209.23 0.120 0.024 0.00000:00:04
? 1.136 0.088 0.00000:00:01
TOTAL: 9 39.348 9.188 0.34309:08:18

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.233.138 9
94.167.209.23 2
107.170.204.210 1
TOTAL: 3 12

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 5
TOTAL: 1 5

Newsgroup request counts (by category):

CategoryCountPct
1rec 3253 43.2%
2uk 748 9.9%
3comp 747 9.9%
4soc 700 9.3%
5sci 570 7.6%
6linux 450 6.0%
7alt 398 5.3%
8talk 332 4.4%
9misc 180 2.4%
10nz 51 0.7%
11news 47 0.6%
12microsoft 22 0.3%
13mozilla 15 0.2%
14agency 11 0.1%
15aus 5 0.1%
16humanities 4 0.1%
TOTAL: 16 7533100.0%

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

NewsgroupCount
1rec.arts.tv 1117
2uk.d-i-y 395
3rec.food.cooking 283
4rec.sport.football.college 233
5rec.arts.drwho 219
6rec.sport.tennis 213
7rec.sport.pro-wrestling 210
8alt.comp.os.windows-10 197
9uk.legal 183
10talk.origins 166
11linux.debian.bugs.dist 161
12rec.arts.sf.written 137
13sci.physics.relativity 135
14comp.os.linux.advocacy 134
15talk.politics.guns 119
16soc.culture.polish 117
17comp.lang.c++ 116
18rec.gambling.poker 107
19rec.boats 105
20misc.survivalism 95
21soc.culture.israel 90
22linux.debian.changes.devel 87
23rec.drugs.cannabis 86
24sci.electronics.design 81
25comp.lang.python 78
26soc.culture.china 69
27alt.conspiracy.jfk 65
28sci.physics 65
29comp.lang.c 64
30linux.debian.bugs.rc 64
31soc.retirement 64
32sci.math 62
33soc.culture.indian 59
34rec.sport.golf 58
35soc.penpals 54
36uk.radio.amateur 54
37sci.med.cardiology 53
38rec.photo.digital 50
39linux.debian.user 49
40uk.legal.moderated 45
41nz.comp 43
42comp.lang.forth 39
43sci.logic 38
44rec.music.classical.recordings 36
45comp.sys.raspberry-pi 35
46rec.bicycles.tech 35
47news.lists.filters 33
48sci.med.pharmacy 30
49rec.outdoors.rv-travel 30
50soc.culture.greek 30
51alt.politics.trump 29
52talk.politics.misc 29
53soc.culture.brazil 29
54soc.genealogy.britain 27
55alt.books.reviews 26
56alt.bbs.synchronet 26
57comp.sys.mac.system 25
58comp.lang.javascript 24
59sci.lang 24
60misc.phone.mobile.iphone 23
61sci.astro.amateur 23
62rec.woodworking 22
63uk.comp.sys.mac 22
64misc.health.diabetes 21
65uk.tech.broadcast 21
66rec.audio.pro 21
67soc.culture.usa 20
68rec.sport.billiard 20
69comp.sys.apple2 20
70rec.audio.opinion 19
71alt.test 18
72misc.invest.stocks 18
73rec.aviation.soaring 16
74comp.os.vms 16
75sci.electronics.basics 16
76linux.debian.user.german 16
77alt.conspiracy 16
78comp.os.linux.misc 15
79alt.comp.hardware 15
80comp.mobile.android 14
81soc.genealogy.medieval 13
82rec.crafts.metalworking 13
83rec.arts.sf.fandom 12
84rec.sport.soccer 12
85comp.misc 11
86linux.gentoo.user 11
87soc.history 11
88soc.history.living 10
89comp.lang.ada 10
90soc.history.ancient 10
91rec.autos.sport.f1 10
92linux.debian.l10n.french 9
93rec.games.pinball 9
94linux.debian.devel 9
95sci.military.naval 9
96rec.music.classical.guitar 9
97uk.rec.cycling.moderated 9
98sci.electronics.repair 9
99nz.general 8
100microsoft.public.windowsxp.general 8
TOTAL: 336 7533