news.bbs.geek.nz daily logs

Jan 20 23:58:02 -- Jan 21 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135665 62.2%11.3 MB 42.2%
innd 31548 14.5%5.2 MB 19.4%
inn 26223 12.0%5.7 MB 21.1%
innfeed 23167 10.6%4.4 MB 16.3%
cnfsstat 1440 0.7%248.9 KB 0.9%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 218044 100.0%26.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 240673 49.1%
Positive hits 224914 45.9%
Do not exist 24430 5.0%
Cache misses 124 0.0%
TOTAL: 4 490141 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.313 0.0%69 0.000 4.536 68.333
article cleanup00:00:00.215 0.0%25624 0.000 0.008 0.049
article logging00:00:00.642 0.0%26214 0.000 0.024 0.075
article parse00:00:00.760 0.0%64289 0.000 0.012 0.031
article write00:00:01.362 0.0%17904 0.017 0.076 0.333
artlog/artcncl00:00:00.000 0.0%61 0.000 0.000 0.000
data move00:00:00.266 0.0%477998 0.000 0.001 0.007
hisgrep/artcncl00:00:00.107 0.0%67 0.000 1.597 35.667
hishave/artcncl00:00:00.038 0.0%69 0.000 0.551 12.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.203 0.0%497285 0.001 0.016 1.397
history sync00:00:00.035 0.0%366 0.000 0.096 3.600
history write00:00:06.921 0.0%24757 0.008 0.280 19.989
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:57:36.576 99.8%494667 88.359 174.373 556.192
nntp read00:00:03.136 0.0%495574 0.002 0.006 0.018
overview write00:00:50.204 0.1%17904 0.020 2.804 185.357
perl filter00:00:48.283 0.1%24757 1.377 1.950 9.386
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.188 0.0%35808 0.000 0.033 0.186
TOTAL: 24:00:50.32623:59:38.249 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.044 0.0%23653 0.000 0.002 0.023
article prepare00:00:00.002 0.0%6774 0.000 0.000 0.028
article read00:00:00.163 0.0%1413 0.000 0.115 3.059
backlog stats00:00:00.284 0.0%288928 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.499 0.0%238357 0.001 0.006 0.013
data write00:00:02.574 0.0%223655 0.005 0.012 0.022
idle23:53:25.061 99.9%288928 173.384 297.670 791.636
status file00:00:25.956 0.0%1871 0.800 13.873 652.629
TOTAL: 23:54:10.43723:53:55.583100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%16 0.000 0.000 0.000
idle30:21:12.865 96.5%151587 0.000 720.859361970.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:57.055 0.1%333131 0.000 0.171 1.810
readart00:00:12.325 0.0%14463 0.000 0.852 32.000
TOTAL: 31:27:51.81930:22:22.245 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 15052 4885 9908 259 32%47:08:22
2news-out.mixmin.net 14 19566 4389 13811 1366 22%30:35:20
3news-out.aioe.org 3 17572 2641 14655 276 15%24:36:18
4feeder.eternal-september.org 43 23497 2021 19998 1478 8%38:15:49
5csiph.com 2 17190 1058 16085 47 6%23:49:46
6newsfeed.neva.ru 153 15054 887 10696 3471 5%79:00:36
7newsfeed.datemas.de 3 19668 614 18828 226 3%24:54:20
8news.albasani.net 1 21517 542 20691 284 2%27:00:52
9news.redatomik.org 1 27790 311 27364 115 1%39:28:18
10news.swapon.de 9 1824 245 1570 9 13%24:21:31
11news.samoylyk.net 2 15946 122 15778 46 0%19:12:49
12agency-nz-out.news.mb-net.net 14 17777 67 17613 97 0%25:42:09
13feeder.awxg.com 2 15990 53 15889 48 0%24:01:41
14news.freedyn.net 6 18193 18 18130 45 0%20:17:03
15localhost 11 10 10 0 0 100%00:00:00
16news.ausics.org 7 20863 0 20861 2 0%37:16:48
TOTAL: 16 313 267509 17863 241877 7769 6%485:41:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.1 MB325.6 KB1.4 MB18.8 MB 90%3.7 KB
2news-out.mixmin.net12.5 MB285.6 KB2.5 MB15.3 MB 81%2.7 KB
3feeder.eternal-september.org8.9 MB442.1 KB4.9 MB14.3 MB 62%4.2 KB
4newsfeed.datemas.de8.2 MB195.3 KB1.2 MB9.6 MB 85%11.7 KB
5news.albasani.net7.9 MB191.1 KB548.5 KB8.7 MB 91%10.7 KB
6news-out.aioe.org6.5 MB154.8 KB597.3 KB7.2 MB 89%2.5 KB
7csiph.com3.0 MB115.7 KB124.7 KB3.2 MB 92%3.0 KB
8newsfeed.neva.ru2.2 MB173.7 KB9.5 MB11.9 MB 18%2.8 KB
9news.redatomik.org950.8 KB314.1 KB318.3 KB1.5 MB 60%3.7 KB
10news.swapon.de622.1 KB23.5 KB103.1 KB748.7 KB 83%2.9 KB
11news.samoylyk.net372.1 KB186.5 KB275.0 KB833.6 KB 44%5.0 KB
12news.freedyn.net238.8 KB86.6 KB116.1 KB441.5 KB 54%7.0 KB
13agency-nz-out.news.mb-net.net160.4 KB147.1 KB265.0 KB572.6 KB 28%3.5 KB
14feeder.awxg.com137.3 KB132.9 KB196.0 KB466.2 KB 29%4.6 KB
15localhost23.4 KB0.0 KB0.0 KB23.4 KB100%2.3 KB
16news.ausics.org0.0 KB4.0 KB4.0 KB8.1 KB 0%4.0 KB
TOTAL: 1668.7 MB2.7 MB22.0 MB93.4 MB 73%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 20 23:58:02 - 23:59:59 27 0.2% 0.2361.4 KB 0.1% 0.52
Jan 21 00:00:00 - 00:59:59 824 4.6% 0.232.1 MB 3.0% 0.61
Jan 21 01:00:00 - 01:59:59 822 4.6% 0.232.4 MB 3.3% 0.68
Jan 21 02:00:00 - 02:59:59 898 5.0% 0.252.6 MB 3.7% 0.75
Jan 21 03:00:00 - 03:59:59 1084 6.1% 0.304.0 MB 5.6% 1.13
Jan 21 04:00:00 - 04:59:59 962 5.4% 0.272.6 MB 3.7% 0.75
Jan 21 05:00:00 - 05:59:59 1013 5.7% 0.283.5 MB 4.9% 1.00
Jan 21 06:00:00 - 06:59:59 1152 6.4% 0.323.8 MB 5.4% 1.09
Jan 21 07:00:00 - 07:59:59 1028 5.8% 0.292.8 MB 4.0% 0.80
Jan 21 08:00:00 - 08:59:59 1056 5.9% 0.293.1 MB 4.3% 0.87
Jan 21 09:00:00 - 09:59:59 960 5.4% 0.272.7 MB 3.7% 0.76
Jan 21 10:00:00 - 10:59:59 939 5.3% 0.263.5 MB 4.9% 1.00
Jan 21 11:00:00 - 11:59:59 828 4.6% 0.232.5 MB 3.4% 0.70
Jan 21 12:00:00 - 12:59:59 649 3.6% 0.183.0 MB 4.3% 0.87
Jan 21 13:00:00 - 13:59:59 541 3.0% 0.151.9 MB 2.7% 0.54
Jan 21 14:00:00 - 14:59:59 494 2.8% 0.141.5 MB 2.1% 0.42
Jan 21 15:00:00 - 15:59:59 468 2.6% 0.131.3 MB 1.9% 0.38
Jan 21 16:00:00 - 16:59:59 345 1.9% 0.101.0 MB 1.4% 0.29
Jan 21 17:00:00 - 17:59:59 394 2.2% 0.111.1 MB 1.6% 0.32
Jan 21 18:00:00 - 18:59:59 298 1.7% 0.081.2 MB 1.6% 0.33
Jan 21 19:00:00 - 19:59:59 292 1.6% 0.081.1 MB 1.6% 0.32
Jan 21 20:00:00 - 20:59:59 454 2.5% 0.131.9 MB 2.7% 0.55
Jan 21 21:00:00 - 21:59:59 701 3.9% 0.1917.1 MB 24.0% 4.87
Jan 21 22:00:00 - 22:59:59 753 4.2% 0.212.0 MB 2.8% 0.57
Jan 21 23:00:00 - 23:58:01 885 5.0% 0.252.4 MB 3.3% 0.70
TOTAL: 23:59:59 17867 100.0% 0.2171.4 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.1 GB 46.1% 0 0.27 2211.18
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.7 GB 53.5% 0 0.30 1992.26
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB287.0 MB 0.6% 0 0.0317777.78
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.4 GB 30.7% 0 0.73 826.77
TOTAL: 10-500.0 GB65.4 GB 13.1% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3484 12 0 66 0 0 0 0 3406
2news-out.mixmin.net 1743 0 0 110 0 0 0 0 1633
3feeder.eternal-september.org 1411 0 0 89 0 0 0 0 1322
4news-out.aioe.org 338 0 0 54 0 0 0 0 284
5news.albasani.net 330 7 0 71 0 0 0 0 252
6news.snarked.org 279 13 0 68 0 0 0 0 198
7newsfeed.datemas.de 230 33 0 67 0 0 0 0 130
8agency-nz-out.news.mb-net.net 106 6 0 66 0 0 0 0 34
9news.redatomik.org 88 0 0 75 0 0 0 0 13
10news.swapon.de 66 0 0 8 0 0 0 0 58
11news.samoylyk.net 62 0 0 59 0 0 0 0 3
12feeder.awxg.com 54 0 0 49 0 0 0 0 5
13news.freedyn.net 53 1 0 37 0 0 0 0 15
14csiph.com 48 0 0 45 0 0 0 0 3
15news.ausics.org 3 0 0 3 0 0 0 0 0
TOTAL: 15 8295 72 0 867 0 0 0 0 7356

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 27
mpc.lists.nanog 7
mozilla.test 4
mozilla.support.seamonkey 4
gmane.linux.bios.flashrom 4
mozilla.dev.ui-alerts 3
south-wales.test 3
mozilla.support.calendar 2
mozilla.dev.security.policy 2
gmane.linux.alsa.devel 2
gmane.comp.gis.openstreetmap.imports 2
demos.local.statistics 1
mozilla.dev.quality 1
clari.web.local.colorado 1
mozilla.dev.l10n 1
isp.test 1
nemo.bavardages 1
gmane.comp.gis.openstreetmap.tagging 1
mpc.lists.freebsd.gnome 1
alt.religion.christian.romman-catholic 1
TOTAL: 23 72

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6054
EMP (phn path) 282
EMP (phn nph) 258
Too many newsgroups 83
EMP (phl) 29
User-issued cancel 25
Binary: non-binary distribution 13
HTML post 7
hierarchy violation - crosspost outside netscape 4
Too many newsgroups (low_xpost) 3
Binary: misplaced par2 1
Binary: misplaced 007 1
Binary: misplaced zip 1
Binary Image: misplaced jpg 1
Binary: misplaced 058 1
Binary Image: misplaced png 1
TOTAL: 16 6764

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 385
news-out.aioe.org 60
news.swapon.de 57
news.albasani.net 47
newsfeed.datemas.de 13
news.redatomik.org 10
newsfeed.neva.ru 8
news.snarked.org 5
feeder.eternal-september.org 2
news.samoylyk.net 2
TOTAL: 12 592
TOTAL: 1 592

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16001 839 15122 19 1 31 5%23:59:46
2awxg 17395 121 17255 1 0 11 0%23:59:42
3news.freedyn.net 17991 12 17821 0 0 0 0%23:59:45
4news-in.mixmin.net 12449 12 12394 1 0 90 0%23:59:46
5aioe 14266 11 14158 0 0 123 0%23:59:45
6news.samoylyk.net 15927 10 15860 0 0 237 0%23:59:37
7news.redatomik.org 17717 10 17619 0 0 0 0%23:59:46
8news.snarked.org 12684 10 12603 1 0 113 0%23:59:46
9csiph.com 16829 10 16782 0 0 0 0%23:59:46
10eternal-september 15295 9 15221 1 0 218 0%23:59:46
11neva.ru 16705 8 16677 2 0 0 0%23:59:46
12newsfeed.datemas.de 17299 8 17163 0 0 327 0%23:59:46
13mb-net.net 17823 6 17676 1 0 437 0%23:59:46
14news.albasani.net 17711 6 15984 542 0 4375 0%23:59:46
15news.swapon.de 1532 0 1532 0 0 0 0%23:32:26
TOTAL: 15 227624 1072 223867 568 1 5962 0%359:28:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.5 MB462.3 KB7.0 MB0.1 KB/s8.3 KB23:59:46
2awxg393.4 KB3.1 KB396.4 KB0.0 KB/s3.2 KB23:59:42
3news.freedyn.net31.0 KB0.0 KB31.0 KB0.0 KB/s2.6 KB23:59:45
4aioe27.4 KB0.0 KB27.4 KB0.0 KB/s2.5 KB23:59:45
5news-in.mixmin.net26.0 KB3.9 KB30.0 KB0.0 KB/s2.3 KB23:59:46
6news.samoylyk.net23.5 KB0.0 KB23.5 KB0.0 KB/s2.3 KB23:59:37
7news.redatomik.org23.5 KB0.0 KB23.5 KB0.0 KB/s2.3 KB23:59:46
8news.snarked.org23.5 KB1.3 KB24.8 KB0.0 KB/s2.3 KB23:59:46
9csiph.com23.5 KB0.0 KB23.5 KB0.0 KB/s2.3 KB23:59:46
10eternal-september19.7 KB5.3 KB25.0 KB0.0 KB/s2.5 KB23:59:46
11newsfeed.datemas.de18.0 KB0.0 KB18.0 KB0.0 KB/s2.3 KB23:59:46
12neva.ru14.5 KB8.9 KB23.5 KB0.0 KB/s2.3 KB23:59:46
13mb-net.net13.2 KB3.0 KB16.2 KB0.0 KB/s2.3 KB23:59:46
14news.albasani.net9.3 KB2.5 MB2.5 MB0.0 KB/s4.6 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:32:26
TOTAL: 157.2 MB2.9 MB10.1 MB0.0 KB/s6.3 KB359:28:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 752526.4 MB 1182 0 1602:05:37
2agency.bbs.geek.nz 399 544118.0 MB 3101 8 8800:13:02
3vorlon.activateit.net.au 24 9961.3 MB 116 0 000:04:52
460.234.68.122 17 32148.5 KB 3 2 002:01:02
567-60-219-146.cpe.cableone.net 3 411.2 KB 1 0 025:58:58
TOTAL: 5 451 1399845.9 MB 4403 10 10431:27:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 11 752926.4 MB 1183 0 1628:04:35
2*.bbs.geek.nz 399 544118.0 MB 3101 8 8800:13:02
3*.activateit.net.au 24 9961.3 MB 116 0 000:04:52
4unresolved 33 32148.5 KB 3 2 003:05:10
TOTAL: 4 467 1399845.9 MB 4403 10 10431:27:44

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 14
bpanther 8
malcolmlewis 3
TOTAL: 4 49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.336 0.080 0.01225:58:58
67-61-21-181.cpe.cableone.net 1.636 1.248 0.42602:05:37
60.234.68.122 1.148 0.180 0.04202:01:02
202.174.187.54 0.476 0.068 0.00000:32:28
118.149.213.224 0.304 0.032 0.00000:25:07
agency.bbs.geek.nz 28.400 6.516 0.00000:13:02
118.149.182.214 0.196 0.004 0.00000:06:32
vorlon.activateit.net.au 1.408 0.348 0.28600:04:52
? 2.380 0.288 0.00000:00:04
TOTAL: 9 36.284 8.764 0.76631:27:44

Curious NNRP server explorers [Top 20]:

SystemConn
202.174.187.54 8
118.149.213.224 5
118.149.182.214 3
TOTAL: 3 16

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
60.234.68.122 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 4713 33.7%
2alt 1920 13.7%
3soc 1619 11.6%
4sci 1496 10.7%
5comp 1086 7.8%
6uk 1052 7.5%
7linux 1001 7.2%
8talk 608 4.3%
9misc 200 1.4%
10news 126 0.9%
11mozilla 51 0.4%
12nz 41 0.3%
13microsoft 18 0.1%
14agency 16 0.1%
15perl 12 0.1%
16aus 10 0.1%
17us 8 0.1%
18humanities 2 0.0%
TOTAL: 18 13979100.0%

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

NewsgroupCount
1rec.arts.tv 1325
2uk.d-i-y 496
3alt.atheism 467
4rec.food.cooking 399
5soc.retirement 395
6rec.sport.tennis 371
7rec.arts.drwho 365
8talk.politics.guns 327
9linux.debian.bugs.dist 326
10sci.physics 322
11alt.fan.rush-limbaugh 317
12soc.culture.polish 310
13linux.debian.changes.devel 256
14rec.sport.football.college 240
15alt.bible.prophecy 218
16sci.physics.relativity 215
17uk.legal 213
18sci.electronics.design 189
19sci.math 163
20sci.logic 161
21rec.boats 157
22alt.politics.trump 151
23soc.culture.china 150
24talk.politics.misc 145
25alt.comp.os.windows-10 121
26comp.lang.python 118
27talk.origins 116
28rec.sport.golf 114
29linux.debian.bugs.rc 111
30rec.radio.shortwave 109
31sci.med.cardiology 109
32soc.culture.israel 104
33soc.penpals 104
34soc.culture.indian 103
35rec.sport.pro-wrestling 101
36news.lists.filters 93
37rec.gambling.poker 91
38comp.lang.c++ 91
39alt.support.diabetes 88
40rec.aviation.marketplace 88
41rec.aquaria.marine.misc 88
42alt.conspiracy 86
43comp.os.linux.misc 83
44rec.woodworking 82
45misc.health.alternative 81
46alt.bible 79
47rec.music.classical.recordings 76
48rec.arts.sf.written 74
49comp.lang.c 73
50alt.politics 73
51comp.os.linux.advocacy 68
52soc.culture.singapore 66
53soc.culture.usa 66
54comp.arch 65
55comp.sys.apple2 63
56linux.debian.user 62
57uk.radio.amateur 60
58alt.test 58
59rec.radio.amateur.misc 56
60comp.mobile.ipad 56
61rec.crafts.metalworking 55
62sci.military.naval 53
63uk.rec.cars.maintenance 52
64rec.drugs.cannabis 51
65linux.debian.user.french 50
66alt.recovery.aa 49
67soc.genealogy.medieval 48
68rec.outdoors.rv-travel 47
69sci.lang 47
70rec.games.pinball 45
71sci.math.num-analysis 44
72sci.crypt 43
73uk.rec.driving 43
74comp.mobile.android 43
75uk.rec.cycling 43
76rec.arts.tv.uk.coronation-st 42
77rec.photo.digital 41
78soc.culture.vietnamese 40
79uk.legal.moderated 39
80rec.aviation.soaring 39
81rec.music.dylan 39
82comp.sys.mac.apps 38
83nz.general 38
84misc.survivalism 38
85alt.astronomy 38
86uk.comp.sys.mac 37
87comp.sys.raspberry-pi 35
88rec.music.rock-pop-r+b.1950s 35
89rec.arts.sf.fandom 34
90comp.lang.ada 34
91comp.lang.forth 32
92rec.arts.movies.past-films 32
93rec.music.beatles 31
94linux.debian.user.german 31
95rec.bicycles.tech 30
96alt.bbs.mystic 29
97uk.tech.digital-tv 28
98misc.phone.mobile.iphone 28
99rec.music.hip-hop 25
100rec.sport.cricket 25
TOTAL: 370 13979