news.bbs.geek.nz daily logs

Aug 4 23:58:01 -- Aug 5 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 119467 57.5%9.6 MB 36.6%
innd 33440 16.1%5.4 MB 20.6%
inn 30050 14.5%6.5 MB 24.6%
innfeed 23457 11.3%4.5 MB 17.2%
cnfsstat 1440 0.7%253.8 KB 0.9%
controlchan 5 0.0%0.8 KB 0.0%
TOTAL: 6 207859 100.0%26.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 268139 48.0%
Negative hits 262069 46.9%
Do not exist 28175 5.0%
Cache misses 181 0.0%
TOTAL: 4 558564 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.239 0.0%147 0.000 1.626 30.000
article cleanup00:00:00.304 0.0%29396 0.000 0.010 0.033
article logging00:00:00.771 0.0%29923 0.000 0.026 0.277
article parse00:00:01.022 0.0%84609 0.000 0.012 0.030
article write00:00:01.635 0.0%20369 0.012 0.080 0.857
artlog/artcncl00:00:00.002 0.0%145 0.000 0.014 0.083
data move00:00:00.436 0.0%524273 0.000 0.001 0.007
hisgrep/artcncl00:00:00.000 0.0%147 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%147 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.468 0.0%559531 0.001 0.012 0.577
history sync00:00:00.010 0.0%364 0.000 0.027 0.500
history write00:00:06.078 0.0%28209 0.014 0.215 12.433
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:32.764 99.8%546435 68.829 157.846 469.611
nntp read00:00:03.232 0.0%548857 0.002 0.006 0.014
overview write00:00:51.072 0.1%20369 0.085 2.507 137.286
perl filter00:01:05.477 0.1%28209 1.431 2.321 23.379
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.529 0.0%40739 0.000 0.038 0.097
TOTAL: 24:00:50.42623:59:51.039 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.058 0.0%28423 0.000 0.002 0.014
article prepare00:00:00.003 0.0%20012 0.000 0.000 0.014
article read00:00:00.383 0.0%4220 0.000 0.091 3.262
backlog stats00:00:00.325 0.0%324822 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.576 0.0%268725 0.001 0.006 0.010
data write00:00:03.090 0.0%258286 0.005 0.012 0.023
idle23:54:31.760 99.9%324822 143.307 264.981 578.384
status file00:00:19.734 0.0%2009 0.600 9.823 323.500
TOTAL: 23:55:25.07023:54:56.929100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle24:20:22.124 95.1%127597 0.000 686.710 81998.317
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:32.015 0.1%533578 0.000 0.172 0.347
readart00:00:03.575 0.0%8682 0.000 0.412 24.395
TOTAL: 25:35:24.40724:21:57.714 95.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 57 17858 5988 11457 413 33%59:08:56
2news-out.mixmin.net 35 22210 4643 16207 1360 20%37:16:26
3feeder.eternal-september.org 108 26743 2333 22946 1464 8%66:17:17
4news-out.aioe.org 3 22816 1778 20945 93 7%26:42:39
5newsfeed.datemas.de 3 25086 1328 23162 596 5%27:01:27
6newsfeed.neva.ru 155 20688 1185 16318 3185 5%102:26:01
7news.redatomik.org 1 16669 1062 15518 89 6%20:20:31
8csiph.com 1 17447 734 16644 69 4%19:00:20
9news.albasani.net 1 22305 391 21598 316 1%24:03:57
10feeder.awxg.com 2 19040 255 18695 90 1%23:59:56
11news.samoylyk.net 2 31135 241 29791 1103 0%26:53:32
12news.swapon.de 14 2080 205 1848 27 9%32:48:03
13agency-nz-out.news.mb-net.net 25 22634 108 22288 238 0%37:44:31
14news.freedyn.net 2 23976 107 23717 152 0%24:28:15
15localhost 68 67 44 23 0 65%00:00:00
TOTAL: 15 477 290754 20402 261157 9195 7%528:11:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.3 MB308.2 KB1.9 MB25.5 MB 91%4.1 KB
2news-out.mixmin.net14.0 MB263.2 KB2.9 MB17.2 MB 81%2.9 KB
3feeder.eternal-september.org8.2 MB780.3 KB11.3 MB20.3 MB 40%5.5 KB
4newsfeed.datemas.de5.0 MB417.5 KB1.6 MB7.0 MB 71%3.7 KB
5news-out.aioe.org4.7 MB216.3 KB237.8 KB5.2 MB 91%2.8 KB
6newsfeed.neva.ru3.4 MB265.6 KB14.2 MB17.9 MB 19%4.2 KB
7news.albasani.net3.1 MB293.1 KB783.5 KB4.1 MB 74%6.0 KB
8news.redatomik.org2.6 MB289.8 KB364.5 KB3.2 MB 80%2.9 KB
9csiph.com1.9 MB218.5 KB233.5 KB2.3 MB 80%2.9 KB
10news.samoylyk.net1.1 MB358.6 KB6.9 MB8.3 MB 13%6.3 KB
11feeder.awxg.com766.8 KB284.9 KB295.5 KB1.3 MB 56%3.9 KB
12news.swapon.de583.3 KB57.3 KB61.7 KB702.3 KB 83%3.0 KB
13news.freedyn.net445.1 KB240.7 KB514.9 KB1.2 MB 37%4.6 KB
14agency-nz-out.news.mb-net.net303.5 KB251.2 KB8.4 MB9.0 MB 3%26.6 KB
15localhost70.5 KB0.0 KB0.0 KB70.5 KB100%1.6 KB
TOTAL: 1569.4 MB4.1 MB49.6 MB123.2 MB 56%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 4 23:58:01 - 23:59:59 34 0.2% 0.2977.0 KB 0.1% 0.65
Aug 5 00:00:00 - 00:59:59 1116 5.5% 0.313.2 MB 4.6% 0.90
Aug 5 01:00:00 - 01:59:59 1112 5.5% 0.313.5 MB 5.0% 0.99
Aug 5 02:00:00 - 02:59:59 1276 6.3% 0.353.9 MB 5.7% 1.12
Aug 5 03:00:00 - 03:59:59 1424 7.0% 0.404.6 MB 6.7% 1.31
Aug 5 04:00:00 - 04:59:59 1241 6.1% 0.344.2 MB 6.0% 1.18
Aug 5 05:00:00 - 05:59:59 1190 5.8% 0.333.7 MB 5.3% 1.05
Aug 5 06:00:00 - 06:59:59 1058 5.2% 0.294.1 MB 6.0% 1.17
Aug 5 07:00:00 - 07:59:59 1004 4.9% 0.282.9 MB 4.2% 0.83
Aug 5 08:00:00 - 08:59:59 1143 5.6% 0.327.2 MB 10.4% 2.04
Aug 5 09:00:00 - 09:59:59 914 4.5% 0.253.4 MB 4.9% 0.96
Aug 5 10:00:00 - 10:59:59 773 3.8% 0.212.7 MB 3.9% 0.76
Aug 5 11:00:00 - 11:59:59 763 3.7% 0.212.4 MB 3.5% 0.68
Aug 5 12:00:00 - 12:59:59 563 2.8% 0.161.8 MB 2.6% 0.50
Aug 5 13:00:00 - 13:59:59 488 2.4% 0.141.6 MB 2.3% 0.45
Aug 5 14:00:00 - 14:59:59 441 2.2% 0.121.5 MB 2.1% 0.42
Aug 5 15:00:00 - 15:59:59 426 2.1% 0.121.3 MB 1.9% 0.37
Aug 5 16:00:00 - 16:59:59 427 2.1% 0.121.5 MB 2.1% 0.42
Aug 5 17:00:00 - 17:59:59 472 2.3% 0.131.7 MB 2.4% 0.47
Aug 5 18:00:00 - 18:59:59 593 2.9% 0.162.5 MB 3.6% 0.71
Aug 5 19:00:00 - 19:59:59 684 3.4% 0.192.2 MB 3.1% 0.61
Aug 5 20:00:00 - 20:59:59 775 3.8% 0.222.1 MB 3.0% 0.59
Aug 5 21:00:00 - 21:59:59 801 3.9% 0.222.3 MB 3.3% 0.65
Aug 5 22:00:00 - 22:59:59 834 4.1% 0.232.5 MB 3.6% 0.71
Aug 5 23:00:00 - 23:58:01 802 3.9% 0.232.2 MB 3.3% 0.66
TOTAL: 24:00:00 20354 100.0% 0.2468.8 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.0 GB 37.9% 0 0.28 2163.95
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.1 GB 44.1% 0 0.32 1909.47
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB232.7 MB 0.5% 0 0.0417165.74
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 GB5.9 GB 11.8% 0 0.74 816.06
TOTAL: 10-500.0 GB47.2 GB 9.4% 1 0.44-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3191 136 0 74 0 0 0 0 2981
2news-out.mixmin.net 1689 0 0 90 0 0 0 0 1599
3feeder.eternal-september.org 1442 0 0 143 0 0 0 0 1299
4news.samoylyk.net 1049 0 0 103 0 0 0 0 946
5newsfeed.datemas.de 576 200 0 112 0 0 0 0 264
6news.snarked.org 440 34 0 97 0 0 0 0 309
7news.albasani.net 312 7 0 95 0 0 0 0 210
8agency-nz-out.news.mb-net.net 241 23 0 73 2 0 0 0 143
9news.redatomik.org 152 0 0 92 0 0 0 0 60
10news.freedyn.net 140 15 0 71 0 0 0 0 54
11news-out.aioe.org 91 9 0 70 0 0 0 0 12
12feeder.awxg.com 85 3 0 74 0 0 0 0 8
13csiph.com 68 0 0 64 0 0 0 0 4
14news.swapon.de 67 0 0 22 0 0 0 0 45
15news.ausics.org 8 0 0 7 0 0 0 0 1
TOTAL: 15 9551 427 0 1187 2 0 0 0 7935

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 154
mpc.lists.freebsd.ports.bugs 48
it.annunci.immobiliari 33
it.annunci.varie 33
it.annunci.commerciali 33
mozilla.support.seamonkey 20
mpc.lists.nanog 19
mozilla.dev.platform 6
fido7.ru.android 5
mozilla.dev.security.policy 4
mozilla.dev.l10n.sr 4
gmane.comp.gis.openstreetmap.tagging 4
mpc.lists.freebsd.gnome 3
al.christnet.bible 3
mozilla.support.calendar 3
gmane.linux.alsa.devel 3
gmane.linux.kernel 3
eagle.support.eng 3
mozilla.dev.l10n 3
mozilla.dev.ui-alerts 3
TOTAL: 54 427

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

GroupsCount
nz.politics.announce 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6472
EMP (phn path) 630
EMP (phn nph) 91
Too many newsgroups 68
Binary Image: misplaced jpg 64
EMP (phl) 32
HTML post 14
User-issued cancel 14
Binary: non-binary distribution 8
Too many newsgroups (low_xpost) 5
Poison newsgroup 3
Cancel for rejected article 2
User-issued spam cancel 1
Binary: misplaced rar 1
Binary: misplaced 709 1
Binary: misplaced arj 1
UUencoded exe 1
U2 violation - invalid distribution 1
TOTAL: 18 7409

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 336
news.redatomik.org 46
news.swapon.de 42
newsfeed.datemas.de 38
news.snarked.org 21
news-out.aioe.org 12
news.albasani.net 11
feeder.eternal-september.org 8
feeder.awxg.com 6
newsfeed.neva.ru 3
TOTAL: 12 526
TOTAL: 1 526

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18286 3137 15051 96 2 0 17%23:59:33
2awxg 19816 134 19649 1 0 14 0%23:59:34
3news.freedyn.net 20550 51 20193 3 0 36 0%23:59:26
4news.snarked.org 14199 44 14045 5 0 0 0%23:59:22
5csiph.com 19591 41 19490 3 0 0 0%23:59:34
6news.redatomik.org 19102 41 19034 3 0 0 0%23:59:34
7news-in.mixmin.net 15277 40 15208 3 0 7 0%23:59:09
8news.samoylyk.net 18120 40 18047 3 0 60 0%23:59:34
9aioe 16734 40 16587 3 0 15 0%23:59:33
10mb-net.net 20493 40 20157 0 0 110 0%23:59:34
11neva.ru 18864 37 18816 7 0 0 0%23:59:34
12news.albasani.net 21381 25 18377 1010 0 5857 0%23:59:19
13newsfeed.datemas.de 19272 24 19040 8 0 909 0%23:59:34
14eternal-september 17552 20 17138 8 0 1045 0%23:59:34
15news.swapon.de 1822 17 1770 0 0 54 0%23:56:28
TOTAL: 15 261059 3731 252602 1153 2 8107 1%359:49:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org14.2 MB1.5 MB15.7 MB0.2 KB/s5.0 KB23:59:33
2awxg516.1 KB7.8 KB523.9 KB0.0 KB/s3.9 KB23:59:34
3news.snarked.org229.6 KB16.9 KB246.5 KB0.0 KB/s5.0 KB23:59:22
4news.freedyn.net87.5 KB3.8 KB91.3 KB0.0 KB/s1.7 KB23:59:26
5mb-net.net79.3 KB0.0 KB79.3 KB0.0 KB/s2.0 KB23:59:34
6csiph.com66.9 KB3.8 KB70.7 KB0.0 KB/s1.6 KB23:59:34
7news.redatomik.org66.9 KB3.8 KB70.7 KB0.0 KB/s1.6 KB23:59:34
8news-in.mixmin.net65.7 KB3.8 KB69.5 KB0.0 KB/s1.6 KB23:59:09
9news.samoylyk.net65.7 KB3.8 KB69.5 KB0.0 KB/s1.6 KB23:59:34
10aioe64.8 KB3.8 KB68.5 KB0.0 KB/s1.6 KB23:59:33
11neva.ru59.1 KB11.6 KB70.7 KB0.0 KB/s1.6 KB23:59:34
12news.albasani.net40.2 KB3.6 MB3.7 MB0.0 KB/s3.6 KB23:59:19
13newsfeed.datemas.de34.4 KB14.5 KB48.9 KB0.0 KB/s1.5 KB23:59:34
14news.swapon.de30.6 KB0.0 KB30.6 KB0.0 KB/s1.8 KB23:56:28
15eternal-september25.2 KB14.5 KB39.6 KB0.0 KB/s1.4 KB23:59:34
TOTAL: 1515.6 MB5.2 MB20.8 MB0.0 KB/s4.4 KB359:49:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 410 609218.7 MB 3552 39 27600:14:34
2163.47.16.169 24 10741.5 MB 177 0 000:05:01
367-61-81-51.cpe.cableone.net 28 9662.7 MB 173 1 000:26:59
4192.168.1.10 1 49173.1 KB 7 0 000:00:01
5192.168.1.3 1 41123.8 KB 3 1 000:00:02
6avon.news.bbs.geek.nz 4 1519.8 KB 6 3 000:42:56
767-61-218-236.cpe.cableone.net 1 514.6 KB 3 0 023:31:43
8118.149.199.39 3 22.5 KB 1 0 000:38:04
TOTAL: 8 472 824423.3 MB 3922 44 27625:49:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 410 609218.7 MB 3552 39 27600:14:34
2unresolved 31 11661.8 MB 188 1 000:48:21
3*.cpe.cableone.net 29 9712.7 MB 176 1 023:58:42
4*.news.bbs.geek.nz 4 1519.8 KB 6 3 000:42:56
5*.dyn.telefonica.de 1 00.0 KB 0 0 000:04:39
6*.census.shodan.io 1 00.0 KB 0 0 000:00:01
TOTAL: 6 476 824423.3 MB 3922 44 27625:49:17

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 24
paulh 6
malcolmlewis 1
TOTAL: 4 55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.152 0.056 0.00623:31:43
avon.news.bbs.geek.nz 0.484 0.060 0.01200:42:56
118.149.199.39 0.244 0.044 0.00000:38:04
67-61-81-51.cpe.cableone.net 1.764 0.360 0.08900:26:59
agency.bbs.geek.nz 28.936 6.904 0.00000:14:34
163.47.16.169 1.304 0.440 0.35000:05:01
118.149.255.86 0.060 0.012 0.00000:05:00
x50abd29c.dyn.telefonica.de 0.856 0.248 0.00000:04:39
45.55.21.141 0.048 0.016 0.00000:00:09
192.168.1.3 0.124 0.008 0.00300:00:02
192.168.1.10 0.104 0.008 0.00200:00:01
? 1.136 0.144 0.00000:00:01
dojo.census.shodan.io 0.052 0.008 0.00000:00:01
TOTAL: 13 35.264 8.308 0.46225:49:17

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.255.86 1
dojo.census.shodan.io 1
x50abd29c.dyn.telefonica.de 1
45.55.21.141 1
TOTAL: 4 4

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
118.149.199.39 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3025 36.7%
2comp 1705 20.7%
3alt 1228 14.9%
4soc 816 9.9%
5sci 618 7.5%
6misc 265 3.2%
7talk 150 1.8%
8news 129 1.6%
9uk 108 1.3%
10agency 84 1.0%
11nz 83 1.0%
12humanities 23 0.3%
13aus 8 0.1%
14eternal-september 1 0.0%
TOTAL: 14 8243100.0%

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

NewsgroupCount
1rec.arts.tv 594
2rec.arts.drwho 459
3alt.atheism 432
4comp.os.linux.advocacy 410
5comp.lang.python 374
6comp.lang.c 300
7soc.retirement 205
8alt.comp.os.windows-10 196
9rec.arts.sf.written 191
10rec.sport.tennis 164
11rec.food.cooking 163
12misc.survivalism 154
13rec.sport.golf 146
14sci.math 140
15sci.physics 135
16rec.sport.football.college 131
17soc.culture.israel 116
18sci.physics.relativity 106
19rec.boats 105
20alt.politics 105
21alt.support.diabetes 97
22alt.bbs.mystic 93
23soc.culture.polish 93
24news.lists.filters 93
25soc.culture.singapore 91
26agency.test 84
27alt.recovery.aa 80
28talk.politics.misc 78
29misc.health.alternative 78
30nz.general 74
31sci.electronics.design 74
32rec.gambling.poker 68
33rec.sport.soccer 64
34rec.photo.digital 60
35uk.radio.amateur 58
36rec.sport.pro-wrestling 57
37rec.arts.movies.current-films 56
38soc.culture.china 55
39rec.arts.movies.past-films 54
40comp.sys.mac.advocacy 53
41alt.os.linux.ubuntu 50
42soc.culture.indian 47
43comp.ai.philosophy 43
44alt.bible 43
45rec.radio.amateur.misc 43
46rec.outdoors.rv-travel 43
47comp.arch 42
48rec.aviation.soaring 41
49comp.lang.c++ 39
50alt.test 39
51comp.arch.fpga 36
52rec.bicycles.tech 34
53comp.protocols.time.ntp 34
54rec.arts.comics.strips 34
55talk.politics.guns 33
56uk.tech.broadcast 32
57rec.audio.opinion 32
58comp.lang.forth 31
59alt.astronomy 31
60rec.arts.poems 30
61talk.origins 29
62soc.genealogy.medieval 27
63soc.culture.usa 25
64rec.games.pinball 25
65sci.electronics.repair 25
66rec.crafts.metalworking 24
67rec.music.classical.recordings 23
68rec.music.dylan 23
69comp.soft-sys.sas 22
70soc.culture.brazil 21
71sci.med.pharmacy 21
72comp.soft-sys.math.scilab 20
73soc.penpals 20
74comp.os.linux.misc 19
75soc.men 19
76sci.logic 19
77comp.lang.ada 19
78rec.games.trivia 18
79sci.med.cardiology 18
80comp.sys.raspberry-pi 16
81comp.sys.mac.system 16
82soc.culture.vietnamese 16
83rec.games.video.sony 16
84humanities.lit.authors.shakespeare 15
85alt.books.arthur-clarke 15
86comp.lang.fortran 14
87rec.radio.amateur.homebrew 14
88rec.arts.sf.fandom 14
89rec.sport.cricket 14
90sci.military.naval 14
91rec.radio.amateur.dx 14
92rec.skiing.alpine 13
93rec.arts.sf.tv 13
94news.software.readers 13
95comp.sys.acorn.misc 12
96uk.comp.homebuilt 12
97soc.genealogy.britain 12
98comp.unix.shell 12
99rec.music.classical.guitar 11
100rec.pets.cats.community 11
TOTAL: 309 8243