news.bbs.geek.nz daily logs

Feb 8 23:58:01 -- Feb 9 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 149658 55.2%13.2 MB 40.6%
innd 67200 24.8%8.2 MB 25.0%
inn 28891 10.7%6.5 MB 19.9%
innfeed 23804 8.8%4.4 MB 13.6%
cnfsstat 1440 0.5%255.1 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 270994 100.0%32.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 290299 50.5%
Positive hits 256056 44.6%
Do not exist 27420 4.8%
Cache misses 549 0.1%
TOTAL: 4 574324 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.620 0.0%148 0.000 4.189 78.000
article cleanup00:00:00.242 0.0%28225 0.000 0.009 0.034
article logging00:00:01.102 0.0%28772 0.000 0.038 1.523
article parse00:00:00.943 0.0%79736 0.000 0.012 0.033
article write00:00:02.517 0.0%21390 0.014 0.118 7.765
artlog/artcncl00:00:00.003 0.0%141 0.000 0.021 0.500
data move00:00:00.504 0.0%565691 0.000 0.001 0.020
hisgrep/artcncl00:00:00.217 0.0%135 0.000 1.607 58.500
hishave/artcncl00:00:00.149 0.0%148 0.000 1.007 10.643
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.826 0.0%578031 0.001 0.017 1.113
history sync00:00:00.011 0.0%353 0.000 0.031 0.500
history write00:00:08.948 0.0%27584 0.023 0.324 15.742
hiswrite/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
idle23:57:20.816 99.8%601262 63.836 143.433 407.448
nntp read00:00:03.230 0.0%589028 0.003 0.005 0.020
overview write00:00:47.278 0.1%21390 0.083 2.210 76.318
perl filter00:01:00.289 0.1%27581 1.290 2.186 25.446
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.414 0.0%42780 0.007 0.033 0.110
TOTAL: 24:00:42.58223:59:38.109 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.058 0.0%28859 0.000 0.002 0.019
article prepare00:00:00.002 0.0%9244 0.000 0.000 0.019
article read00:00:00.722 0.0%1615 0.000 0.447 39.182
backlog stats00:00:00.302 0.0%325606 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.615 0.0%271279 0.001 0.006 0.012
data write00:00:03.115 0.0%255369 0.003 0.012 0.061
idle23:53:14.490 99.9%325606 148.960 264.106 752.815
status file00:00:20.216 0.0%2050 0.778 9.861 411.267
TOTAL: 23:54:01.64023:53:40.520100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle13:50:41.850 96.7%351653 0.000 141.736 88943.243
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:26.739 0.2%382143 0.000 0.227 7.423
readart00:00:13.901 0.0%17318 0.000 0.803 12.450
TOTAL: 14:19:02.07513:52:22.490 96.9%----

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
1csiph.com 3 20874 5449 15338 87 26%23:54:57
2newsfeed.datemas.de 5 26357 3425 22046 886 12%27:51:35
3news-out.aioe.org 2 20710 3072 17470 168 14%23:52:06
4feeder.eternal-september.org 53 24486 2910 20124 1452 11%38:51:24
5news-out.mixmin.net 14 22338 2082 19706 550 9%28:27:40
6news.albasani.net 1 18427 1447 16606 374 7%20:17:39
7newsfeed.neva.ru 156 10156 1337 5878 2941 13%89:40:27
8news.redatomik.org 1 21054 488 20490 76 2%24:33:56
9news.freedyn.net 3 27549 371 27034 144 1%27:56:07
10news.swapon.de 9 1786 219 1563 4 12%26:03:24
11news.samoylyk.net 17 21741 157 21523 61 0%26:00:46
12agency-nz-out.news.mb-net.net 15 27789 115 27516 158 0%35:42:55
13feeder.awxg.com 2 18866 102 18727 37 0%23:59:54
14localhost12671 12670 70 12600 0 0%00:00:01
15news.ausics.org 2 17866 0 17866 0 0%22:52:52
TOTAL: 1512954 292669 21244 264487 6938 7%440:05:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.datemas.de21.5 MB413.9 KB3.5 MB25.5 MB 84%6.1 KB
2csiph.com15.4 MB77.0 KB281.7 KB15.8 MB 97%2.9 KB
3feeder.eternal-september.org10.6 MB666.5 KB5.8 MB17.0 MB 62%4.0 KB
4news-out.aioe.org7.6 MB61.7 KB371.2 KB8.0 MB 94%2.5 KB
5news-out.mixmin.net7.1 MB416.9 KB1.5 MB9.0 MB 79%3.5 KB
6news.albasani.net5.9 MB417.9 KB1.1 MB7.4 MB 79%4.2 KB
7newsfeed.neva.ru3.7 MB270.2 KB22.2 MB26.1 MB 14%6.3 KB
8news.freedyn.net2.6 MB270.6 KB511.4 KB3.4 MB 77%6.7 KB
9news.redatomik.org1.8 MB224.4 KB262.4 KB2.3 MB 79%4.1 KB
10news.samoylyk.net1.0 MB388.5 KB515.8 KB1.9 MB 54%9.1 KB
11agency-nz-out.news.mb-net.net683.5 KB343.8 KB2.4 MB3.4 MB 19%12.8 KB
12news.swapon.de536.2 KB93.0 KB93.0 KB722.2 KB 74%3.2 KB
13feeder.awxg.com401.7 KB138.4 KB144.7 KB684.8 KB 58%4.9 KB
14localhost180.9 KB0.0 KB0.0 KB180.9 KB100%2.6 KB
15news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1579.1 MB3.7 MB38.6 MB121.4 MB 65%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 8 23:58:01 - 23:59:59 29 0.1% 0.2464.7 KB 0.1% 0.54
Feb 9 00:00:00 - 00:59:59 1000 4.7% 0.282.8 MB 3.2% 0.80
Feb 9 01:00:00 - 01:59:59 953 4.5% 0.264.3 MB 4.9% 1.22
Feb 9 02:00:00 - 02:59:59 1044 4.9% 0.292.8 MB 3.1% 0.79
Feb 9 03:00:00 - 03:59:59 1048 4.9% 0.293.2 MB 3.6% 0.90
Feb 9 04:00:00 - 04:59:59 1258 5.9% 0.354.0 MB 4.5% 1.13
Feb 9 05:00:00 - 05:59:59 1181 5.5% 0.333.9 MB 4.4% 1.11
Feb 9 06:00:00 - 06:59:59 1285 6.0% 0.363.4 MB 3.9% 0.98
Feb 9 07:00:00 - 07:59:59 1338 6.3% 0.373.6 MB 4.1% 1.02
Feb 9 08:00:00 - 08:59:59 1138 5.3% 0.324.3 MB 4.9% 1.23
Feb 9 09:00:00 - 09:59:59 1268 5.9% 0.353.8 MB 4.3% 1.09
Feb 9 10:00:00 - 10:59:59 1050 4.9% 0.295.2 MB 6.0% 1.49
Feb 9 11:00:00 - 11:59:59 900 4.2% 0.253.5 MB 4.0% 1.00
Feb 9 12:00:00 - 12:59:59 656 3.1% 0.182.3 MB 2.6% 0.65
Feb 9 13:00:00 - 13:59:59 624 2.9% 0.172.2 MB 2.4% 0.61
Feb 9 14:00:00 - 14:59:59 537 2.5% 0.151.9 MB 2.2% 0.55
Feb 9 15:00:00 - 15:59:59 479 2.2% 0.132.7 MB 3.1% 0.77
Feb 9 16:00:00 - 16:59:59 417 2.0% 0.122.3 MB 2.6% 0.66
Feb 9 17:00:00 - 17:59:59 383 1.8% 0.111.5 MB 1.7% 0.43
Feb 9 18:00:00 - 18:59:59 464 2.2% 0.132.0 MB 2.3% 0.57
Feb 9 19:00:00 - 19:59:59 543 2.5% 0.152.4 MB 2.7% 0.67
Feb 9 20:00:00 - 20:59:59 653 3.1% 0.182.3 MB 2.7% 0.67
Feb 9 21:00:00 - 21:59:59 917 4.3% 0.253.1 MB 3.5% 0.87
Feb 9 22:00:00 - 22:59:59 1017 4.8% 0.282.8 MB 3.2% 0.79
Feb 9 23:00:00 - 23:58:01 1194 5.6% 0.3417.7 MB 20.1% 5.21
TOTAL: 24:00:00 21376 100.0% 0.2588.1 MB 100.0% 1.04
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.5 GB 47.1% 0 0.32 1911.62
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.3 GB 54.6% 0 0.37 1632.02
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB292.0 MB 0.6% 0 0.0319393.94
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 GB16.4 GB 32.8% 0 0.91 669.61
TOTAL: 10-500.0 GB67.6 GB 13.5% 1 0.52-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2974 48 0 70 0 0 0 0 2856
2feeder.eternal-september.org 1473 0 0 104 0 0 0 0 1369
3newsfeed.datemas.de 949 189 0 42 0 0 0 0 718
4news-out.mixmin.net 720 0 0 102 0 0 0 0 618
5news.albasani.net 485 9 0 63 0 0 0 0 413
6news-out.aioe.org 200 3 0 24 0 0 0 0 173
7news.freedyn.net 128 10 0 42 0 0 0 0 76
8agency-nz-out.news.mb-net.net 127 30 0 48 0 0 0 0 49
9news.redatomik.org 98 0 0 52 0 0 0 0 46
10csiph.com 89 0 0 22 0 0 0 0 67
11news.samoylyk.net 51 0 0 38 0 0 0 0 13
12news.swapon.de 48 0 0 4 0 0 0 0 44
13feeder.awxg.com 31 1 0 29 0 0 0 0 1
14news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 14 7374 290 0 641 0 0 0 0 6443

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.varie 26
it.annunci.immobiliari 26
it.annunci.commerciali 23
gmane.comp.gis.openstreetmap.tagging 22
mozilla.dev.security.policy 15
mozilla.support.seamonkey 14
gmane.linux.kernel 12
mozilla.support.bugzilla 11
gmane.linux.alsa.devel 11
mozilla.dev.platform 10
mozilla.dev.l10n.web 8
mozilla.dev.ui-alerts 7
mpc.lists.nanog 7
mozilla.dev.apps.seamonkey 6
gmane.comp.sysutils.ddrescue 6
mozilla.support.calendar 5
gmane.linux.drivers.devicetree 5
mozilla.moss 4
mpc.lists.freebsd.gnome 4
aol.neighborhood.tx.arlington.jobs 4
TOTAL: 62 290

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4964
Binary: misplaced rar 459
EMP (phn path) 189
EMP (phn nph) 116
User-issued cancel 75
Too many newsgroups 25
EMP (phl) 25
Binary: non-binary distribution 12
Too many newsgroups (meow) 10
Cancel for rejected article 5
HTML post 4
Binary Image: misplaced png 4
Binary: misplaced 086 2
Binary Image: misplaced jpg 1
Binary: misplaced 018 1
TOTAL: 15 5892

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.freedyn.net 3
TOTAL: 1 3
Including strange strings
newsfeed.datemas.de 176
news-out.mixmin.net 160
news.albasani.net 86
news-out.aioe.org 52
news.swapon.de 44
news.redatomik.org 19
newsfeed.neva.ru 5
feeder.eternal-september.org 2
news.samoylyk.net 2
agency-nz-out.news.mb-net.net 1
TOTAL: 11 548
TOTAL: 2 551

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19663 589 19050 24 0 0 2%23:59:41
2awxg 20900 156 20727 6 0 18 0%23:59:35
3csiph.com 16071 72 15920 1 0 5 0%23:59:43
4aioe 16987 69 16807 0 0 0 0%23:59:43
5news.samoylyk.net 19682 44 19454 0 0 688 0%23:59:37
6eternal-september 17598 40 17534 4 0 37 0%23:59:42
7news.freedyn.net 21067 38 20941 0 0 62 0%23:59:43
8neva.ru 19392 30 19311 40 0 0 0%23:59:43
9news.redatomik.org 20880 30 20818 3 0 22 0%23:59:41
10mb-net.net 21213 28 21136 9 0 28 0%23:59:43
11news-in.mixmin.net 17776 28 17717 0 0 29 0%23:59:43
12news.swapon.de 1658 24 1595 0 0 74 1%23:30:33
13news.albasani.net 20229 13 17610 953 0 6195 0%23:59:03
14newsfeed.datemas.de 18017 9 17887 0 0 340 0%23:59:43
15news.snarked.org 9778 1 9774 0 0 10159 0%23:57:46
TOTAL: 15 260911 1171 256281 1040 0 17657 0%359:23:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.6 MB722.5 KB13.3 MB0.2 KB/s22.3 KB23:59:41
2eternal-september454.1 KB202.2 KB656.3 KB0.0 KB/s14.9 KB23:59:42
3awxg391.0 KB29.7 KB420.7 KB0.0 KB/s2.6 KB23:59:35
4news.freedyn.net135.2 KB0.0 KB135.2 KB0.0 KB/s3.6 KB23:59:43
5neva.ru122.5 KB58.7 KB181.1 KB0.0 KB/s2.6 KB23:59:43
6csiph.com116.7 KB75.3 KB192.0 KB0.0 KB/s2.6 KB23:59:43
7aioe105.8 KB0.0 KB105.8 KB0.0 KB/s1.5 KB23:59:43
8news.samoylyk.net68.0 KB0.0 KB68.0 KB0.0 KB/s1.5 KB23:59:37
9news.redatomik.org53.7 KB3.9 KB57.6 KB0.0 KB/s1.7 KB23:59:41
10news-in.mixmin.net42.5 KB0.0 KB42.5 KB0.0 KB/s1.5 KB23:59:43
11mb-net.net40.1 KB14.7 KB54.8 KB0.0 KB/s1.5 KB23:59:43
12news.swapon.de37.7 KB0.0 KB37.7 KB0.0 KB/s1.6 KB23:30:33
13news.albasani.net20.8 KB3.2 MB3.2 MB0.0 KB/s3.4 KB23:59:03
14newsfeed.datemas.de12.7 KB0.0 KB12.7 KB0.0 KB/s1.4 KB23:59:43
15news.snarked.org1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:57:46
TOTAL: 1514.2 MB4.3 MB18.5 MB0.0 KB/s8.6 KB359:23:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 850330.7 MB 1260 0 1601:54:53
2agency.bbs.geek.nz 408 663624.5 MB 3582 702668800:22:51
3vorlon.activateit.net.au 24 13211.7 MB 151 0 000:05:53
TOTAL: 3 440 1646056.9 MB 4993 702670414:18:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 13 850330.7 MB 1260 0 1613:14:50
2*.bbs.geek.nz 408 663624.5 MB 3582 702668800:22:51
3*.activateit.net.au 24 13211.7 MB 151 0 000:05:53
4unresolved 9 00.0 KB 0 0 000:35:16
5*.us-west-1.compute.amazonaws.com 2 00.0 KB 0 0 000:00:00
TOTAL: 5 456 1646056.9 MB 4993 702670414:18:55

NNRP auth users [Top 20]:

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.232 0.068 0.04011:19:57
67-61-21-181.cpe.cableone.net 1.628 1.144 0.02401:54:53
agency.bbs.geek.nz 33.376 9.460 0.00000:22:51
118.149.159.226 0.244 0.028 0.00000:20:07
60.234.68.122 0.156 0.024 0.00600:10:03
vorlon.activateit.net.au 1.392 0.408 0.48200:05:53
118.149.183.129 0.056 0.012 0.00000:04:46
121.99.151.164 0.048 0.012 0.00000:00:18
? 1.588 0.152 0.00000:00:02
ec2-54-183-220-137.us-west-1.compute.amazonaws.com 0.056 0.008 0.00000:00:00
ec2-54-67-73-20.us-west-1.compute.amazonaws.com 0.048 0.008 0.00000:00:00
TOTAL: 11 38.824 11.324 0.55214:18:55

Curious NNRP server explorers [Top 20]:

SystemConn
67-60-219-146.cpe.cableone.net 5
118.149.159.226 4
60.234.68.122 3
ec2-54-183-220-137.us-west-1.compute.amazonaws.com 1
121.99.151.164 1
ec2-54-67-73-20.us-west-1.compute.amazonaws.com 1
118.149.183.129 1
TOTAL: 7 16

NNRP gethostbyaddr failures [Top 20]:

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

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.164 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5593 34.1%
2soc 2117 12.9%
3alt 1682 10.3%
4comp 1590 9.7%
5sci 1565 9.6%
6uk 1340 8.2%
7linux 1335 8.1%
8talk 569 3.5%
9misc 261 1.6%
10news 184 1.1%
11mozilla 88 0.5%
12microsoft 25 0.2%
13humanities 18 0.1%
14perl 14 0.1%
15nz 2 0.0%
TOTAL: 15 16383100.0%

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

NewsgroupCount
1rec.arts.tv 1177
2uk.d-i-y 742
3rec.arts.drwho 529
4comp.lang.python 486
5rec.food.cooking 460
6alt.fan.rush-limbaugh 378
7alt.atheism 366
8linux.debian.bugs.dist 340
9rec.sport.tennis 325
10sci.physics 322
11linux.debian.changes.devel 301
12sci.electronics.design 276
13soc.culture.polish 276
14rec.arts.sf.written 270
15alt.comp.os.windows-10 266
16uk.legal 243
17rec.gambling.poker 238
18talk.politics.guns 225
19soc.culture.china 223
20rec.sport.football.college 222
21rec.sport.golf 218
22sci.math 213
23soc.retirement 208
24rec.drugs.cannabis 190
25linux.debian.bugs.rc 184
26comp.lang.c 175
27talk.politics.misc 166
28news.lists.filters 160
29alt.bible.prophecy 156
30talk.origins 155
31sci.physics.relativity 148
32sci.logic 141
33soc.singles 133
34soc.culture.israel 131
35rec.aviation.soaring 119
36soc.culture.brazil 112
37alt.politics.trump 110
38rec.bicycles.tech 108
39rec.outdoors.rv-travel 104
40rec.photo.digital 103
41misc.phone.mobile.iphone 100
42rec.aquaria.marine.misc 96
43soc.culture.vietnamese 96
44rec.music.classical.recordings 91
45rec.boats 91
46linux.debian.user 89
47soc.genealogy.medieval 89
48sci.math.num-analysis 85
49soc.culture.singapore 85
50sci.med.cardiology 82
51soc.history.what-if 80
52uk.legal.moderated 80
53rec.aviation.marketplace 80
54soc.culture.usa 79
55rec.audio.pro 75
56rec.sport.soccer 75
57uk.tech.digital-tv 69
58soc.culture.indian 68
59alt.politics 68
60rec.radio.shortwave 67
61comp.lang.c++ 67
62sci.military.naval 66
63alt.test 66
64linux.gentoo.dev 65
65comp.protocols.time.ntp 64
66linux.gentoo.user 62
67rec.woodworking 60
68comp.os.vms 60
69comp.lang.forth 59
70comp.protocols.dns.bind 57
71comp.os.linux.advocacy 57
72uk.radio.amateur 55
73rec.games.pinball 55
74rec.music.rock-pop-r+b.1950s 53
75rec.arts.sf.tv 51
76comp.mobile.android 51
77mozilla.support.firefox 50
78comp.sys.apple2 49
79sci.med.pharmacy 48
80rec.crafts.metalworking 48
81alt.support.diabetes 48
82soc.culture.australian 46
83rec.humor 46
84uk.comp.sys.mac 45
85soc.women 44
86soc.culture.quebec 44
87sci.lang 42
88rec.arts.movies.current-films 42
89rec.sport.pro-wrestling 40
90comp.unix.shell 40
91misc.health.alternative 39
92alt.recovery.aa 38
93comp.arch 36
94misc.survivalism 35
95alt.bible 33
96rec.arts.tv.uk.coronation-st 33
97mozilla.general 32
98linux.debian.user.french 32
99rec.music.beatles 30
100rec.crafts.textiles.needlework 30
TOTAL: 375 16383