news.bbs.geek.nz daily logs

Dec 19 23:58:02 -- Dec 20 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 151414 64.6%12.5 MB 43.9%
innd 30611 13.1%5.0 MB 17.5%
inn 27711 11.8%6.2 MB 21.7%
innfeed 23087 9.9%4.6 MB 16.1%
cnfsstat 1440 0.6%250.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 234264 100.0%28.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 268976 48.9%
Positive hits 254906 46.3%
Do not exist 26019 4.7%
Cache misses 162 0.0%
TOTAL: 4 550063 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.440 0.0%150 0.000 2.933 33.000
article cleanup00:00:00.241 0.0%26921 0.000 0.009 0.029
article logging00:00:00.680 0.0%27579 0.000 0.025 0.054
article parse00:00:00.901 0.0%81086 0.000 0.011 0.047
article write00:00:01.813 0.0%20035 0.000 0.090 1.497
artlog/artcncl00:00:00.002 0.0%144 0.000 0.014 0.333
data move00:00:00.589 0.0%542162 0.000 0.001 0.014
hisgrep/artcncl00:00:00.112 0.0%138 0.000 0.812 7.786
hishave/artcncl00:00:00.104 0.0%150 0.000 0.693 7.429
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.842 0.0%551968 0.001 0.016 0.901
history sync00:00:00.012 0.0%371 0.000 0.032 0.500
history write00:00:10.253 0.0%26086 0.016 0.393 27.667
hiswrite/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
idle23:57:47.435 99.8%556722 68.742 154.956 578.876
nntp read00:00:03.460 0.0%558154 0.002 0.006 0.036
overview write00:00:43.130 0.0%20035 0.061 2.153 61.632
perl filter00:00:52.129 0.1%26086 1.363 1.998 6.264
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.372 0.0%40070 0.007 0.034 0.113
TOTAL: 24:00:53.15523:59:51.515 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.081 0.0%26142 0.000 0.003 0.022
article prepare00:00:00.002 0.0%8552 0.000 0.000 0.016
article read00:00:00.524 0.0%1902 0.000 0.275 17.292
backlog stats00:00:00.272 0.0%320512 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.575 0.0%268286 0.001 0.006 0.012
data write00:00:02.913 0.0%252660 0.005 0.012 0.027
idle23:53:38.711100.0%320512 134.747 268.379 731.966
status file00:00:17.457 0.0%1822 0.800 9.581 437.600
TOTAL: 23:54:17.98123:54:01.535100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%6 0.000 0.000 0.000
idle28:20:56.864 98.6%167729 0.000 608.463 75505.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:59.565 0.1%368901 0.000 0.161 1.749
readart00:00:01.880 0.0%15510 0.000 0.121 17.500
TOTAL: 28:45:10.18928:21:58.309 98.7%----

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 40 16264 5189 10725 350 31%49:29:49
2news-out.mixmin.net 17 20689 3821 16056 812 18%30:05:07
3news-out.aioe.org 1 20018 2931 16932 155 14%24:03:54
4feeder.eternal-september.org 20 25220 2659 21180 1381 10%32:19:36
5news.albasani.net 1 20477 1576 18429 472 7%23:14:09
6newsfeed.neva.ru 146 15082 1228 11185 2669 8%94:11:42
7csiph.com 2 19436 1063 18324 49 5%24:10:13
8newsfeed.datemas.de 2 21956 695 20893 368 3%25:09:40
9news.redatomik.org 1 16342 268 16023 51 1%19:33:23
10news.swapon.de 6 1809 230 1573 6 12%22:48:04
11feeder.awxg.com 2 17200 112 17036 52 0%23:59:55
12news.samoylyk.net 2 25490 109 24873 508 0%23:59:57
13agency-nz-out.news.mb-net.net 15 22701 102 22467 132 0%31:15:28
14news.freedyn.net 2 18089 36 18002 51 0%18:13:49
15localhost 3 2 2 0 0 100%00:00:00
TOTAL: 15 260 260775 20021 233698 7056 7%442:34:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org16.3 MB330.5 KB1.5 MB18.1 MB 89%3.4 KB
2feeder.eternal-september.org12.4 MB672.5 KB4.7 MB17.7 MB 69%4.5 KB
3newsfeed.datemas.de12.2 MB470.6 KB1.7 MB14.5 MB 84%13.9 KB
4news-out.mixmin.net11.9 MB379.2 KB2.3 MB14.7 MB 81%3.2 KB
5news.albasani.net10.4 MB485.8 KB1.3 MB12.1 MB 85%6.1 KB
6news-out.aioe.org7.2 MB175.5 KB370.2 KB7.7 MB 93%2.6 KB
7newsfeed.neva.ru3.0 MB304.5 KB18.8 MB22.1 MB 13%5.8 KB
8csiph.com2.8 MB262.5 KB265.9 KB3.3 MB 84%3.1 KB
9agency-nz-out.news.mb-net.net1.1 MB508.0 KB913.3 KB2.5 MB 43%10.8 KB
10news.samoylyk.net823.4 KB430.7 KB7.8 MB9.1 MB 8%15.0 KB
11news.redatomik.org655.0 KB377.3 KB380.4 KB1.4 MB 46%4.4 KB
12news.swapon.de566.2 KB5.5 KB100.9 KB672.6 KB 84%2.9 KB
13news.freedyn.net515.9 KB267.5 KB453.9 KB1.2 MB 41%14.2 KB
14feeder.awxg.com310.7 KB251.3 KB256.3 KB818.3 KB 37%5.0 KB
15localhost2.9 KB0.0 KB0.0 KB2.9 KB100%1.5 KB
TOTAL: 1580.1 MB4.8 MB41.0 MB125.9 MB 63%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 19 23:58:02 - 23:59:59 20 0.1% 0.1741.7 KB 0.1% 0.35
Dec 20 00:00:00 - 00:59:59 1037 5.2% 0.292.7 MB 3.4% 0.77
Dec 20 01:00:00 - 01:59:59 865 4.3% 0.242.8 MB 3.4% 0.79
Dec 20 02:00:00 - 02:59:59 987 4.9% 0.272.6 MB 3.2% 0.74
Dec 20 03:00:00 - 03:59:59 1054 5.3% 0.293.3 MB 4.1% 0.94
Dec 20 04:00:00 - 04:59:59 1293 6.5% 0.3617.8 MB 22.1% 5.05
Dec 20 05:00:00 - 05:59:59 1121 5.6% 0.313.3 MB 4.2% 0.95
Dec 20 06:00:00 - 06:59:59 1107 5.5% 0.313.0 MB 3.7% 0.85
Dec 20 07:00:00 - 07:59:59 1263 6.3% 0.356.2 MB 7.7% 1.76
Dec 20 08:00:00 - 08:59:59 1114 5.6% 0.314.3 MB 5.3% 1.21
Dec 20 09:00:00 - 09:59:59 1075 5.4% 0.303.2 MB 4.0% 0.91
Dec 20 10:00:00 - 10:59:59 1000 5.0% 0.283.2 MB 4.0% 0.92
Dec 20 11:00:00 - 11:59:59 907 4.5% 0.253.4 MB 4.2% 0.97
Dec 20 12:00:00 - 12:59:59 749 3.7% 0.213.1 MB 3.9% 0.90
Dec 20 13:00:00 - 13:59:59 556 2.8% 0.152.3 MB 2.9% 0.65
Dec 20 14:00:00 - 14:59:59 529 2.6% 0.151.5 MB 1.9% 0.43
Dec 20 15:00:00 - 15:59:59 440 2.2% 0.121.5 MB 1.9% 0.43
Dec 20 16:00:00 - 16:59:59 434 2.2% 0.121.4 MB 1.8% 0.40
Dec 20 17:00:00 - 17:59:59 381 1.9% 0.111.7 MB 2.1% 0.47
Dec 20 18:00:00 - 18:59:59 501 2.5% 0.142.1 MB 2.6% 0.59
Dec 20 19:00:00 - 19:59:59 504 2.5% 0.142.0 MB 2.5% 0.58
Dec 20 20:00:00 - 20:59:59 632 3.2% 0.182.0 MB 2.4% 0.56
Dec 20 21:00:00 - 21:59:59 782 3.9% 0.222.3 MB 2.9% 0.65
Dec 20 22:00:00 - 22:59:59 889 4.4% 0.252.3 MB 2.8% 0.65
Dec 20 23:00:00 - 23:58:02 782 3.9% 0.222.3 MB 2.8% 0.66
TOTAL: 24:00:00 20022 100.0% 0.2380.2 MB 100.0% 0.95
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.3 GB 44.6% 0 0.28 2156.01
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.9 GB 51.7% 0 0.34 1764.39
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB278.6 MB 0.5% 0 0.0320516.76
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 GB13.6 GB 27.3% 0 0.84 719.95
TOTAL: 10-500.0 GB62.1 GB 12.4% 1 0.47-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2669 41 0 51 0 0 0 0 2577
2feeder.eternal-september.org 1307 0 0 94 0 0 0 0 1213
3news-out.mixmin.net 1194 0 0 77 0 0 0 0 1117
4news.albasani.net 601 2 0 76 0 0 0 0 523
5news.samoylyk.net 462 0 0 71 0 0 0 0 391
6news.snarked.org 353 52 0 73 0 0 0 0 228
7newsfeed.datemas.de 329 73 0 69 0 0 0 0 187
8news-out.aioe.org 189 0 0 44 0 0 0 0 145
9agency-nz-out.news.mb-net.net 111 13 0 69 0 0 0 0 29
10news.swapon.de 80 0 0 4 0 0 0 0 76
11news.redatomik.org 80 0 0 57 0 0 0 0 23
12news.freedyn.net 63 3 0 49 0 0 0 0 11
13feeder.awxg.com 55 1 0 51 0 0 0 0 3
14csiph.com 48 0 0 46 0 0 0 0 2
15news.ausics.org 4 0 0 4 0 0 0 0 0
TOTAL: 15 7545 185 0 835 0 0 0 0 6525

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 44
mpc.lists.nanog 30
gmane.linux.kernel 16
mozilla.support.seamonkey 14
gmane.comp.gis.openstreetmap.tagging 13
nemo.abuse 10
mozilla.dev.l10n.sr 5
mozilla.governance 5
mpc.lists.freebsd.gnome 4
mozilla.dev.security.policy 4
mozilla.dev.telemetry-alerts 3
mozilla.compatibility 3
mozilla.dev.tech.crypto 3
demos.local.lists.cgp-russian 3
mpc.lists.freebsd.gecko 2
alt.penthouse.sex.femdom 2
fido7.ru.android 2
mozilla.dev.l10n 2
alt.bestjobsusa.healthcare.jobs 2
gmane.linux.kernel.clk 2
TOTAL: 35 185

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4626
EMP (phn path) 454
Binary: misplaced rar 383
EMP (phn nph) 312
Too many newsgroups 46
User-issued cancel 18
Too many newsgroups (low_xpost) 13
Binary: non-binary distribution 7
Cancel for rejected article 2
HTML post 2
Too many newsgroups (meow) 2
Angle-bracket bot 1
Binary: misplaced nzb 1
User-issued spam cancel 1
TOTAL: 14 5868

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 334
news.albasani.net 129
news.swapon.de 74
news-out.aioe.org 48
newsfeed.datemas.de 37
news.redatomik.org 21
newsfeed.neva.ru 6
feeder.awxg.com 3
news.snarked.org 3
agency-nz-out.news.mb-net.net 2
TOTAL: 10 657
TOTAL: 1 657

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18285 946 17296 43 0 0 5%23:59:48
2awxg 19495 138 19338 1 0 22 0%23:59:48
3news.freedyn.net 20183 19 19959 3 0 118 0%23:59:48
4aioe 16025 14 15939 1 0 21 0%23:59:34
5news.snarked.org 14813 8 14658 2 0 66 0%23:59:48
6csiph.com 19172 7 18958 1 0 52 0%23:59:44
7mb-net.net 19892 2 19840 0 0 37 0%23:59:48
8news.redatomik.org 19646 2 19619 0 0 17 0%23:59:44
9news.samoylyk.net 18205 2 18175 0 0 27 0%23:59:42
10eternal-september 17022 2 16974 0 0 63 0%23:59:48
11neva.ru 18384 2 18368 0 0 0 0%23:59:48
12news-in.mixmin.net 15100 2 15085 0 0 6 0%23:59:48
13news.swapon.de 1745 1 1741 0 0 5 0%23:45:44
14newsfeed.datemas.de 19200 1 19172 0 0 85 0%23:59:48
15news.albasani.net 19945 1 17449 859 0 5676 0%23:59:19
TOTAL: 15 257112 1147 252571 910 0 6195 0%359:41:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.1 MB874.5 KB13.0 MB0.2 KB/s13.4 KB23:59:48
2awxg622.6 KB5.8 KB628.4 KB0.0 KB/s4.5 KB23:59:48
3aioe39.8 KB1.4 KB41.2 KB0.0 KB/s2.7 KB23:59:34
4news.freedyn.net39.1 KB16.4 KB55.5 KB0.0 KB/s2.5 KB23:59:48
5news.snarked.org18.4 KB2.8 KB21.1 KB0.0 KB/s2.1 KB23:59:48
6csiph.com14.9 KB3.4 KB18.2 KB0.0 KB/s2.3 KB23:59:44
7mb-net.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:48
8news.redatomik.org2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:44
9news.samoylyk.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:42
10eternal-september2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:48
11neva.ru2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:48
12news-in.mixmin.net2.9 KB0.0 KB2.9 KB0.0 KB/s1.5 KB23:59:48
13news.swapon.de1.5 KB0.0 KB1.5 KB0.0 KB/s1.5 KB23:45:44
14news.albasani.net1.5 KB3.0 MB3.0 MB0.0 KB/s3.5 KB23:59:19
15newsfeed.datemas.de1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:48
TOTAL: 1512.9 MB3.9 MB16.7 MB0.0 KB/s8.3 KB359:41:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 728126.2 MB 1200 0 1602:03:52
2agency.bbs.geek.nz 387 688624.4 MB 4018 2 000:14:27
3vorlon.activateit.net.au 24 8721.2 MB 140 0 000:04:27
4192.168.1.9 1 84421.0 KB 7 0 000:00:03
560.234.244.55 5 1331.0 KB 1 0 000:20:34
667-60-219-146.cpe.cableone.net 1 13.6 KB 1 0 025:39:36
TOTAL: 6 426 1513752.3 MB 5367 2 1628:45:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 9 728226.2 MB 1201 0 1627:43:29
2*.bbs.geek.nz 387 688624.4 MB 4018 2 000:14:27
3*.activateit.net.au 24 8721.2 MB 140 0 000:04:27
4unresolved 11 97452.0 KB 8 0 000:42:36
5*.us-west-2.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 5 432 1513752.3 MB 5367 2 1628:45:03

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 4
malcolmlewis 1
paulh 1
TOTAL: 5 38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.204 0.072 0.00625:39:36
67-61-21-181.cpe.cableone.net 1.548 1.056 0.02202:03:52
60.234.244.55 0.344 0.048 0.00900:20:34
agency.bbs.geek.nz 28.328 7.044 0.00000:14:27
118.149.155.212 0.120 0.016 0.00000:09:59
118.149.169.212 0.124 0.016 0.00000:06:56
118.149.140.46 0.064 0.000 0.00000:05:01
vorlon.activateit.net.au 1.388 0.360 0.16700:04:27
192.168.1.9 0.116 0.008 0.00100:00:03
? 1.384 0.156 0.00000:00:02
ec2-54-244-188-183.us-west-2.compute.amazonaws.com 0.052 0.016 0.00000:00:00
TOTAL: 11 33.672 8.792 0.20528:45:03

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.169.212 2
118.149.155.212 2
ec2-54-244-188-183.us-west-2.compute.amazonaws.com 1
118.149.140.46 1
TOTAL: 4 6

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
67-60-219-146.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 4819 31.8%
2alt 1734 11.5%
3soc 1673 11.1%
4comp 1664 11.0%
5uk 1612 10.7%
6sci 1249 8.3%
7linux 1114 7.4%
8talk 666 4.4%
9misc 198 1.3%
10news 176 1.2%
11mozilla 89 0.6%
12nz 41 0.3%
13microsoft 41 0.3%
14aus 34 0.2%
15humanities 8 0.1%
16agency 7 0.0%
17us 4 0.0%
18eternal-september 2 0.0%
TOTAL: 18 15131100.0%

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

NewsgroupCount
1rec.arts.tv 984
2alt.fan.rush-limbaugh 499
3rec.arts.drwho 495
4uk.radio.amateur 492
5rec.food.cooking 402
6uk.legal 363
7linux.debian.bugs.dist 362
8alt.atheism 352
9talk.origins 322
10soc.retirement 297
11uk.d-i-y 280
12soc.culture.polish 278
13rec.sport.football.college 274
14alt.comp.os.windows-10 260
15linux.debian.changes.devel 250
16comp.lang.python 228
17talk.politics.guns 224
18rec.sport.pro-wrestling 224
19rec.arts.sf.written 224
20sci.physics 194
21sci.electronics.design 188
22rec.sport.tennis 185
23news.lists.filters 159
24comp.lang.c++ 157
25comp.os.linux.advocacy 155
26rec.sport.golf 154
27sci.math 153
28rec.music.rock-pop-r+b.1950s 153
29rec.boats 148
30sci.physics.relativity 146
31soc.culture.usa 143
32soc.culture.israel 141
33soc.penpals 137
34rec.arts.movies.current-films 123
35uk.legal.moderated 119
36talk.politics.misc 110
37alt.test 110
38soc.culture.china 106
39uk.tech.digital-tv 105
40comp.lang.idl-pvwave 100
41alt.politics.trump 98
42sci.military.naval 97
43linux.debian.user 94
44rec.arts.sf.tv 94
45sci.med.cardiology 89
46uk.tech.broadcast 88
47rec.aquaria.marine.misc 88
48sci.logic 87
49uk.rec.driving 80
50rec.aviation.marketplace 80
51soc.culture.indian 76
52rec.aviation.soaring 76
53soc.culture.brazil 74
54misc.phone.mobile.iphone 73
55comp.sys.mac.advocacy 72
56alt.politics 71
57comp.lang.tcl 70
58rec.gambling.poker 70
59comp.sys.mac.apps 69
60rec.sport.soccer 69
61alt.bible 69
62comp.lang.fortran 66
63rec.sport.cricket 65
64comp.sys.raspberry-pi 65
65soc.history.what-if 65
66comp.lang.c 64
67comp.lang.forth 62
68soc.culture.vietnamese 58
69sci.lang 57
70comp.sys.mac.system 57
71linux.debian.bugs.rc 56
72linux.gentoo.user 52
73rec.crafts.metalworking 50
74rec.photo.digital 48
75sci.med.pharmacy 47
76rec.autos.sport.f1 45
77uk.rec.cycling 44
78rec.music.classical.recordings 44
79rec.bicycles.tech 42
80soc.genealogy.medieval 42
81linux.debian.l10n.french 42
82linux.debian.devel 41
83mozilla.support.firefox 40
84rec.games.pinball 40
85mozilla.general 40
86rec.woodworking 40
87sci.astro.amateur 39
88comp.os.linux.misc 39
89misc.survivalism 38
90comp.lang.java.programmer 36
91alt.recovery.aa 35
92alt.society.liberalism 35
93comp.sys.ibm.pc.games.action 34
94rec.radio.shortwave 34
95alt.conspiracy.jfk 34
96linux.debian.user.german 33
97comp.protocols.time.ntp 32
98soc.culture.singapore 31
99nz.general 31
100linux.gentoo.dev 30
TOTAL: 386 15131