news.bbs.geek.nz daily logs

Jan 23 23:58:01 -- Jan 24 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 136170 60.0%11.3 MB 39.8%
innd 33737 14.9%5.4 MB 18.9%
inn 32465 14.3%7.0 MB 24.6%
innfeed 23148 10.2%4.5 MB 15.8%
cnfsstat 1440 0.6%251.0 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 226961 100.0%28.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 303001 49.2%
Positive hits 281850 45.8%
Do not exist 30789 5.0%
Cache misses 276 0.0%
TOTAL: 4 615916 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.221 0.0%79 0.000 2.797 68.000
article cleanup00:00:00.270 0.0%31752 0.000 0.009 0.036
article logging00:00:00.790 0.0%32414 0.000 0.024 0.146
article parse00:00:01.016 0.0%88841 0.003 0.011 0.025
article write00:00:05.023 0.0%22087 0.022 0.227 16.092
artlog/artcncl00:00:00.000 0.0%78 0.000 0.000 0.000
data move00:00:00.548 0.0%600680 0.000 0.001 0.029
hisgrep/artcncl00:00:00.066 0.0%64 0.000 1.031 33.000
hishave/artcncl00:00:00.030 0.0%79 0.000 0.380 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.474 0.0%622359 0.001 0.017 0.939
history sync00:00:00.013 0.0%366 0.000 0.036 0.500
history write00:00:16.428 0.0%31057 0.010 0.529 37.810
hiswrite/artcncl00:00:00.001 0.0%15 0.000 0.067 0.143
idle23:57:11.436 99.7%617241 87.994 139.705 314.992
nntp read00:00:03.716 0.0%619211 0.003 0.006 0.025
overview write00:00:55.825 0.1%22087 0.101 2.528 97.798
perl filter00:00:56.466 0.1%31057 1.194 1.818 5.617
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.596 0.0%44174 0.008 0.036 0.160
TOTAL: 24:00:50.65223:59:43.919 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.085 0.0%29104 0.000 0.003 0.023
article prepare00:00:00.001 0.0%9742 0.000 0.000 0.017
article read00:00:00.220 0.0%2211 0.000 0.100 2.366
backlog stats00:00:00.326 0.0%353371 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.784 0.0%298384 0.001 0.006 0.012
data write00:00:03.069 0.0%278538 0.005 0.011 0.018
idle23:53:28.955 99.9%353371 156.405 243.396 535.417
status file00:00:18.630 0.0%1829 0.700 10.186 427.806
TOTAL: 23:54:13.98223:53:53.070100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle17:14:51.393 95.7%153310 0.000 405.005 61416.753
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:08:23.316 0.8%392945 0.000 1.281 12570.615
readart00:00:16.673 0.0%17082 0.000 0.976 21.899
TOTAL: 18:01:10.21817:23:31.382 96.5%----

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 42 19439 6241 12768 430 32%47:24:17
2news-out.aioe.org 3 22493 3336 18878 279 14%24:28:46
3news-out.mixmin.net 12 23751 2692 20348 711 11%26:57:04
4news.albasani.net 2 22801 2406 19643 752 10%24:28:36
5feeder.eternal-september.org 65 27892 2080 24487 1325 7%46:35:05
6csiph.com 4 19759 1525 18197 37 7%22:07:12
7newsfeed.datemas.de 3 24023 1176 22369 478 4%24:43:23
8newsfeed.neva.ru 152 21461 1170 14925 5366 5%80:58:55
9news.redatomik.org 1 16636 732 15855 49 4%17:36:44
10news.swapon.de 5 2205 211 1984 10 9%24:24:07
11news.freedyn.net 3 26879 124 26635 120 0%28:58:27
12news.samoylyk.net 1 18862 91 18730 41 0%19:00:50
13feeder.awxg.com 1 19156 89 19027 40 0%23:59:55
14agency-nz-out.news.mb-net.net 11 23387 71 23216 100 0%25:50:27
15localhost 2 1 1 0 0 100%00:00:00
16news.ausics.org 8 20828 0 20826 2 0%32:03:25
TOTAL: 16 315 309573 21945 277888 9740 7%469:37:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org24.8 MB246.2 KB2.6 MB27.6 MB 89%4.2 KB
2news.albasani.net10.4 MB2.2 MB3.3 MB15.9 MB 65%5.1 KB
3news-out.aioe.org8.1 MB103.9 KB578.0 KB8.8 MB 92%2.5 KB
4feeder.eternal-september.org8.1 MB1.8 MB5.9 MB15.9 MB 50%4.8 KB
5news-out.mixmin.net7.9 MB587.6 KB1.9 MB10.4 MB 76%3.1 KB
6newsfeed.datemas.de5.4 MB1.3 MB3.0 MB9.6 MB 56%5.9 KB
7csiph.com4.3 MB202.8 KB213.1 KB4.7 MB 91%3.1 KB
8newsfeed.neva.ru2.9 MB217.7 KB27.8 MB30.9 MB 9%4.8 KB
9news.redatomik.org1.6 MB128.7 KB141.2 KB1.9 MB 86%2.5 KB
10news.freedyn.net1.1 MB104.9 KB355.2 KB1.5 MB 70%6.3 KB
11news.samoylyk.net878.0 KB106.9 KB410.8 KB1.4 MB 62%10.6 KB
12news.swapon.de595.1 KB103.3 KB351.5 KB1.0 MB 56%4.8 KB
13agency-nz-out.news.mb-net.net268.1 KB235.0 KB492.4 KB995.5 KB 26%5.8 KB
14feeder.awxg.com237.4 KB124.6 KB194.4 KB556.4 KB 42%4.3 KB
15localhost5.7 KB0.0 KB0.0 KB5.7 KB100%5.7 KB
16news.ausics.org0.0 KB5.8 KB5.8 KB11.6 KB 0%5.8 KB
TOTAL: 1676.6 MB7.4 MB47.2 MB131.2 MB 58%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 23 23:58:01 - 23:59:59 29 0.1% 0.2464.8 KB 0.1% 0.54
Jan 24 00:00:00 - 00:59:59 1080 4.9% 0.302.9 MB 3.7% 0.82
Jan 24 01:00:00 - 01:59:59 993 4.5% 0.283.3 MB 4.2% 0.93
Jan 24 02:00:00 - 02:59:59 1086 4.9% 0.302.8 MB 3.6% 0.81
Jan 24 03:00:00 - 03:59:59 1046 4.7% 0.293.7 MB 4.8% 1.06
Jan 24 04:00:00 - 04:59:59 1202 5.4% 0.333.1 MB 4.0% 0.89
Jan 24 05:00:00 - 05:59:59 1234 5.6% 0.343.8 MB 4.9% 1.08
Jan 24 06:00:00 - 06:59:59 1336 6.1% 0.373.9 MB 5.1% 1.12
Jan 24 07:00:00 - 07:59:59 1273 5.8% 0.353.9 MB 5.0% 1.11
Jan 24 08:00:00 - 08:59:59 1243 5.6% 0.353.8 MB 4.9% 1.09
Jan 24 09:00:00 - 09:59:59 1174 5.3% 0.333.8 MB 4.8% 1.07
Jan 24 10:00:00 - 10:59:59 1023 4.6% 0.283.2 MB 4.1% 0.91
Jan 24 11:00:00 - 11:59:59 1016 4.6% 0.284.0 MB 5.1% 1.13
Jan 24 12:00:00 - 12:59:59 852 3.9% 0.243.5 MB 4.5% 1.00
Jan 24 13:00:00 - 13:59:59 633 2.9% 0.183.2 MB 4.1% 0.92
Jan 24 14:00:00 - 14:59:59 580 2.6% 0.162.1 MB 2.7% 0.59
Jan 24 15:00:00 - 15:59:59 567 2.6% 0.162.6 MB 3.3% 0.74
Jan 24 16:00:00 - 16:59:59 465 2.1% 0.132.1 MB 2.7% 0.59
Jan 24 17:00:00 - 17:59:59 456 2.1% 0.131.8 MB 2.4% 0.52
Jan 24 18:00:00 - 18:59:59 563 2.6% 0.164.5 MB 5.7% 1.27
Jan 24 19:00:00 - 19:59:59 558 2.5% 0.153.0 MB 3.9% 0.86
Jan 24 20:00:00 - 20:59:59 711 3.2% 0.203.0 MB 3.9% 0.86
Jan 24 21:00:00 - 21:59:59 856 3.9% 0.243.2 MB 4.1% 0.90
Jan 24 22:00:00 - 22:59:59 1008 4.6% 0.283.2 MB 4.1% 0.91
Jan 24 23:00:00 - 23:58:02 1072 4.9% 0.313.4 MB 4.3% 0.99
TOTAL: 24:00:01 22056 100.0% 0.2678.0 MB 100.0% 0.92
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.1 GB 46.3% 0 0.36 1694.93
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.8 GB 53.6% 0 0.42 1447.28
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB287.5 MB 0.6% 0 0.0319555.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 GB15.5 GB 31.0% 0 0.70 864.24
TOTAL: 10-500.0 GB65.8 GB 13.2% 1 0.48-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5407 52 0 49 0 0 0 0 5306
2feeder.eternal-september.org 1288 0 0 92 0 0 0 0 1196
3news.albasani.net 978 9 0 59 0 0 0 0 910
4news-out.mixmin.net 885 0 0 101 0 0 0 0 784
5newsfeed.datemas.de 482 145 0 53 0 0 0 0 284
6news.snarked.org 432 59 0 63 0 0 0 0 310
7news-out.aioe.org 325 6 0 43 0 0 0 0 276
8agency-nz-out.news.mb-net.net 123 33 0 47 0 0 0 0 43
9news.redatomik.org 122 0 0 54 0 0 0 0 68
10news.freedyn.net 112 2 0 25 0 0 0 0 85
11news.swapon.de 58 0 0 9 0 0 0 0 49
12news.samoylyk.net 45 0 0 42 0 0 0 0 3
13feeder.awxg.com 41 2 0 33 0 0 0 0 6
14csiph.com 33 0 0 28 0 0 0 0 5
TOTAL: 14 10331 308 0 698 0 0 0 0 9325

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.immobiliari 47
it.annunci.commerciali 43
it.annunci.varie 38
mpc.lists.nanog 25
mpc.lists.freebsd.gnome 18
isp.tech 16
gmane.comp.gis.openstreetmap.tagging 16
talk.wieslauf.points 12
mozilla.dev.security.policy 10
mpc.lists.freebsd.x11 9
gmane.linux.alsa.devel 8
mozilla.dev.l10n 7
mozilla.dev.ui-alerts 6
gmane.linux.kernel 5
south-wales.test 3
tambov.test 3
gmane.comp.gis.openstreetmap.imports 3
usc.forsale 3
mozilla.dev.builds 3
mpc.lists.freebsd.pf 2
TOTAL: 44 308

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7312
Binary: misplaced rar 448
EMP (phn path) 431
EMP (phn nph) 348
Too many newsgroups 68
User-issued cancel 30
HTML post 7
hierarchy violation - crosspost outside netscape 7
Too many newsgroups (low_xpost) 5
Binary: non-binary distribution 5
User-issued spam cancel 2
Too many newsgroups (meow) 2
Binary: misplaced 010 1
Binary: misplaced 212 1
Binary: misplaced par2 1
TOTAL: 15 8668

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 256
news-out.mixmin.net 181
news.redatomik.org 64
news-out.aioe.org 50
newsfeed.datemas.de 50
news.swapon.de 47
feeder.awxg.com 4
newsfeed.neva.ru 4
agency-nz-out.news.mb-net.net 1
TOTAL: 9 657
TOTAL: 1 657

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20418 1101 19276 41 0 0 5%23:59:46
2awxg 21602 118 21461 5 0 9 0%23:59:44
3eternal-september 18877 4 18846 0 0 0 0%23:59:44
4news.samoylyk.net 20422 1 20312 0 0 0 0%23:59:29
5news.freedyn.net 22118 1 21925 0 0 4 0%23:59:35
6news.redatomik.org 21432 1 21295 3 0 0 0%23:59:44
7mb-net.net 22000 1 21918 2 0 130 0%23:59:44
8news.snarked.org 15619 1 15567 1 0 0 0%23:59:44
9csiph.com 20453 1 20381 0 0 11 0%23:59:44
10news-in.mixmin.net 18240 1 18210 0 0 1 0%23:59:44
11news.albasani.net 21334 1 18271 1042 1 6849 0%23:59:44
12aioe 17535 1 17395 0 0 0 0%23:59:44
13neva.ru 20438 0 20411 1 0 0 0%23:59:44
14news.swapon.de 2086 0 2064 0 0 24 0%23:59:44
15newsfeed.datemas.de 20831 0 20738 0 0 128 0%23:59:44
TOTAL: 15 283405 1232 278070 1095 1 7156 0%359:55:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org13.7 MB4.1 MB17.8 MB0.2 KB/s16.0 KB23:59:46
2awxg391.5 KB29.1 KB420.6 KB0.0 KB/s3.4 KB23:59:44
3eternal-september15.6 KB0.0 KB15.6 KB0.0 KB/s3.9 KB23:59:44
4news.albasani.net15.1 KB4.2 MB4.2 MB0.0 KB/s4.1 KB23:59:44
5news.samoylyk.net5.7 KB0.0 KB5.7 KB0.0 KB/s5.7 KB23:59:29
6news.freedyn.net5.7 KB0.0 KB5.7 KB0.0 KB/s5.7 KB23:59:35
7news.snarked.org5.7 KB2.3 KB8.0 KB0.0 KB/s4.0 KB23:59:44
8csiph.com5.7 KB0.0 KB5.7 KB0.0 KB/s5.7 KB23:59:44
9news-in.mixmin.net5.7 KB0.0 KB5.7 KB0.0 KB/s5.7 KB23:59:44
10aioe5.7 KB0.0 KB5.7 KB0.0 KB/s5.7 KB23:59:44
11news.redatomik.org1.9 KB7.5 KB9.5 KB0.0 KB/s2.4 KB23:59:44
12mb-net.net1.3 KB3.8 KB5.1 KB0.0 KB/s1.7 KB23:59:44
13neva.ru0.0 KB5.7 KB5.7 KB0.0 KB/s5.7 KB23:59:44
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
15newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
TOTAL: 1514.1 MB8.3 MB22.5 MB0.0 KB/s9.9 KB359:55:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 863635.4 MB 1267 0 1602:20:59
2agency.bbs.geek.nz 385 682225.6 MB 3754 1 000:13:13
3vorlon.activateit.net.au 24 10931.5 MB 144 0 000:05:07
4121.99.151.89 4 23.1 KB 1 0 000:07:31
TOTAL: 4 421 1655362.5 MB 5166 1 1618:13:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 12 863635.4 MB 1267 0 1616:58:04
2*.bbs.geek.nz 385 682225.6 MB 3754 1 000:13:13
3*.activateit.net.au 24 10931.5 MB 144 0 000:05:07
4unresolved 12 23.1 KB 1 0 000:56:35
TOTAL: 4 433 1655362.5 MB 5166 1 1618:13:04

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 4
davidb 4
crash 2
TOTAL: 5 42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.180 0.076 0.02814:37:05
67-61-21-181.cpe.cableone.net 1.568 1.296 0.11602:20:59
118.149.214.134 0.120 0.016 0.00000:24:01
118.149.163.100 0.192 0.012 0.00000:14:17
agency.bbs.geek.nz 27.208 6.428 0.00000:13:13
118.149.141.174 0.128 0.004 0.00000:10:02
121.99.151.89 0.688 0.204 0.01000:07:31
vorlon.activateit.net.au 1.424 0.368 0.17400:05:07
60.234.68.122 0.104 0.016 0.00600:00:42
? 1.700 0.240 0.00000:00:02
TOTAL: 10 33.312 8.660 0.33418:13:04

Curious NNRP server explorers [Top 20]:

SystemConn
67-60-219-146.cpe.cableone.net 4
118.149.163.100 3
60.234.68.122 2
118.149.141.174 2
118.149.214.134 1
TOTAL: 5 12

NNRP gethostbyaddr failures [Top 20]:

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
121.99.151.89 1 1
67-60-219-146.cpe.cableone.net 1 0
118.149.214.134 1 1
TOTAL: 3 3 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 5158 31.2%
2comp 2090 12.6%
3alt 1890 11.4%
4sci 1689 10.2%
5soc 1668 10.1%
6linux 1355 8.2%
7uk 1267 7.7%
8talk 674 4.1%
9misc 346 2.1%
10news 205 1.2%
11mozilla 122 0.7%
12microsoft 52 0.3%
13perl 18 0.1%
14nz 7 0.0%
15humanities 6 0.0%
16aus 6 0.0%
TOTAL: 16 16553100.0%

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

NewsgroupCount
1rec.arts.tv 834
2rec.sport.tennis 649
3linux.debian.bugs.dist 617
4uk.d-i-y 565
5rec.arts.sf.written 459
6sci.physics 449
7alt.atheism 429
8alt.fan.rush-limbaugh 376
9talk.politics.guns 352
10sci.physics.relativity 335
11rec.arts.drwho 333
12soc.culture.polish 283
13rec.boats 278
14alt.comp.os.windows-10 272
15soc.retirement 252
16comp.lang.python 250
17uk.legal 242
18rec.food.cooking 233
19rec.sport.football.college 224
20alt.bible.prophecy 209
21comp.mobile.android 189
22misc.phone.mobile.iphone 185
23sci.electronics.design 184
24soc.culture.israel 184
25talk.origins 169
26linux.debian.changes.devel 168
27news.lists.filters 166
28linux.debian.bugs.rc 164
29comp.lang.c 146
30comp.lang.c++ 141
31comp.mobile.ipad 140
32sci.logic 139
33talk.politics.misc 132
34rec.woodworking 129
35alt.politics.trump 127
36comp.os.linux.advocacy 126
37rec.sport.golf 124
38soc.culture.brazil 115
39comp.lang.tcl 114
40rec.gambling.poker 114
41comp.os.vms 113
42soc.culture.china 112
43uk.radio.amateur 108
44sci.math 107
45rec.sport.pro-wrestling 104
46comp.arch 99
47rec.drugs.cannabis 98
48soc.genealogy.britain 95
49uk.legal.moderated 92
50alt.conspiracy 91
51rec.outdoors.rv-travel 89
52rec.music.dylan 89
53rec.aquaria.marine.misc 88
54rec.aviation.marketplace 88
55linux.debian.user 85
56sci.crypt 84
57uk.tech.digital-tv 84
58rec.crafts.metalworking 77
59comp.sys.apple2 72
60rec.music.classical.recordings 71
61alt.politics 68
62soc.culture.usa 68
63rec.games.backgammon 67
64sci.electronics.repair 66
65rec.aviation.soaring 66
66comp.lang.forth 65
67alt.test 65
68comp.protocols.time.ntp 64
69uk.rec.cycling 62
70sci.med.cardiology 61
71rec.photo.digital 61
72rec.games.pinball 60
73soc.culture.indian 54
74mozilla.support.firefox 54
75rec.radio.shortwave 54
76comp.sys.raspberry-pi 53
77soc.culture.vietnamese 52
78soc.penpals 50
79soc.history 50
80sci.math.num-analysis 50
81sci.military.naval 50
82soc.culture.bengali 49
83comp.lang.ada 46
84rec.arts.tv.soaps.cbs 46
85rec.sport.cricket 45
86mozilla.general 45
87soc.culture.singapore 44
88misc.survivalism 43
89misc.invest.stocks 43
90alt.astronomy 42
91rec.arts.movies.current-films 40
92rec.music.makers.guitar.jazz 40
93comp.lang.javascript 40
94alt.recovery.aa 40
95uk.comp.sys.mac 39
96linux.debian.user.spanish 39
97comp.sys.mac.system 38
98rec.sport.soccer 37
99rec.games.trivia 36
100linux.debian.user.german 36
TOTAL: 370 16553