news.bbs.geek.nz daily logs

Jun 27 23:58:02 -- Jun 28 23:58:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jun 28 00:01:02 news nnrpd[8497]: 2607:f350:1:1225::1:4 noperm ihave without permission
Jun 28 00:04:20 news nnrpd[8501]: 2607:f350:1:1225::1:4 noperm ihave without permission
Jun 28 00:05:51 news nnrpd[8502]: 2607:f350:1:1225::1:4 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 107005 53.0%8.6 MB 33.0%
inn 35727 17.7%7.5 MB 28.7%
innd 34296 17.0%5.4 MB 20.8%
innfeed 23263 11.5%4.3 MB 16.5%
cnfsstat 1440 0.7%249.9 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 201732 100.0%26.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 299351 46.1%
Positive hits 284135 43.8%
Do not exist 33783 5.2%
Cache misses 31754 4.9%
TOTAL: 4 649023 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.136 0.0%151 0.000 0.901 25.000
article cleanup00:00:00.329 0.0%35033 0.000 0.009 0.029
article logging00:00:01.034 0.0%35607 0.004 0.029 0.829
article parse00:00:01.119 0.0%91068 0.003 0.012 0.028
article write00:00:01.595 0.0%23590 0.023 0.068 0.181
artlog/artcncl00:00:00.004 0.0%123 0.000 0.033 1.000
data move00:00:00.366 0.0%578621 0.000 0.001 0.006
hisgrep/artcncl00:00:00.000 0.0%151 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%151 0.000 0.007 0.053
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.374 0.0%655289 0.001 0.010 1.041
history sync00:00:00.020 0.0%350 0.000 0.057 0.667
history write00:00:08.004 0.0%34105 0.022 0.235 16.015
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:23.883 99.8%601102 73.219 143.476 405.145
nntp read00:00:03.387 0.0%602437 0.002 0.006 0.013
overview write00:00:36.008 0.0%23590 0.062 1.526 51.573
perl filter00:01:15.526 0.1%34105 1.509 2.215 16.935
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.778 0.0%47180 0.010 0.038 0.150
TOTAL: 24:00:43.47923:59:39.564 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%31615 0.000 0.002 0.014
article prepare00:00:00.002 0.0%10660 0.000 0.000 0.013
article read00:00:00.195 0.0%2404 0.000 0.081 1.706
backlog stats00:00:00.266 0.0%341720 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.661 0.0%284604 0.001 0.006 0.010
data write00:00:03.081 0.0%271758 0.005 0.011 0.021
idle23:52:42.952100.0%341720 155.699 251.560 586.691
status file00:00:14.468 0.0%1917 0.727 7.547 330.865
TOTAL: 23:53:19.03823:53:02.700100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%16 0.000 0.062 0.125
idle39:36:51.127 99.5%115801 0.000 1231.519 99980.765
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.290 0.0%248703 0.000 0.005 1.000
readart00:00:01.598 0.0%9053 0.000 0.177 17.000
TOTAL: 39:47:56.25839:36:54.016 99.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 52 57652 5306 45922 6424 9%53:18:21
2newsfeed.datemas.de 4 25213 5040 19123 1050 19%24:26:25
3news.redatomik.org 1 21582 4416 17086 80 20%23:31:48
4csiph.com 3 19675 2668 16945 62 13%21:02:47
5feeder.eternal-september.org 106 31225 1764 28807 654 5%66:56:29
6news-out.aioe.org 4 29593 1376 28088 129 4%33:03:04
7newsfeed.neva.ru 161 24598 1235 21664 1699 5%91:32:48
8news-out.mixmin.net 12 24553 1192 22614 747 4%30:07:51
9news.albasani.net 1 21214 148 20814 252 0%20:35:41
10feeder.awxg.com 2 20649 107 20458 84 0%23:58:22
11news.swapon.de 4 2111 105 1990 16 4%27:29:59
12news.freedyn.net 2 25963 80 25769 114 0%24:13:04
13agency-nz-out.news.mb-net.net 30 29227 60 29036 131 0%34:47:21
14localhost 12 11 11 0 0 100%00:00:00
TOTAL: 14 394 333266 23508 298316 11442 7%475:04:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.1 MB180.3 KB38.0 MB57.2 MB 33%5.0 KB
2newsfeed.datemas.de18.7 MB325.3 KB3.2 MB22.2 MB 84%3.7 KB
3news.redatomik.org11.3 MB254.2 KB274.2 KB11.8 MB 95%2.7 KB
4feeder.eternal-september.org8.1 MB526.7 KB5.8 MB14.5 MB 56%6.1 KB
5csiph.com6.7 MB215.2 KB247.6 KB7.1 MB 93%2.7 KB
6news-out.mixmin.net5.1 MB305.1 KB1.8 MB7.2 MB 70%3.8 KB
7newsfeed.neva.ru3.8 MB317.4 KB6.8 MB10.9 MB 34%3.8 KB
8news-out.aioe.org3.5 MB269.7 KB406.1 KB4.2 MB 84%2.8 KB
9news.albasani.net2.5 MB234.2 KB631.1 KB3.3 MB 74%8.5 KB
10news.freedyn.net1.8 MB130.3 KB309.4 KB2.2 MB 80%11.6 KB
11feeder.awxg.com402.9 KB288.1 KB357.8 KB1.0 MB 38%5.5 KB
12news.swapon.de285.7 KB36.8 KB36.8 KB359.3 KB 79%3.0 KB
13agency-nz-out.news.mb-net.net248.5 KB264.1 KB516.2 KB1.0 MB 24%5.4 KB
14localhost23.0 KB0.0 KB0.0 KB23.0 KB100%2.1 KB
TOTAL: 1481.4 MB3.3 MB58.4 MB143.0 MB 56%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 27 23:58:02 - 23:59:59 28 0.1% 0.2474.8 KB 0.1% 0.63
Jun 28 00:00:00 - 00:59:59 1002 4.2% 0.283.3 MB 4.0% 0.93
Jun 28 01:00:00 - 01:59:59 1320 5.6% 0.376.7 MB 8.3% 1.91
Jun 28 02:00:00 - 02:59:59 1332 5.6% 0.374.2 MB 5.1% 1.19
Jun 28 03:00:00 - 03:59:59 1463 6.2% 0.415.9 MB 7.3% 1.68
Jun 28 04:00:00 - 04:59:59 1369 5.8% 0.384.3 MB 5.3% 1.24
Jun 28 05:00:00 - 05:59:59 1304 5.5% 0.363.7 MB 4.5% 1.04
Jun 28 06:00:00 - 06:59:59 1277 5.4% 0.353.9 MB 4.9% 1.12
Jun 28 07:00:00 - 07:59:59 1343 5.7% 0.373.7 MB 4.6% 1.06
Jun 28 08:00:00 - 08:59:59 1293 5.5% 0.365.4 MB 6.7% 1.54
Jun 28 09:00:00 - 09:59:59 1141 4.8% 0.323.5 MB 4.3% 0.99
Jun 28 10:00:00 - 10:59:59 937 4.0% 0.263.3 MB 4.0% 0.93
Jun 28 11:00:00 - 11:59:59 761 3.2% 0.212.7 MB 3.4% 0.78
Jun 28 12:00:00 - 12:59:59 616 2.6% 0.172.3 MB 2.8% 0.65
Jun 28 13:00:00 - 13:59:59 551 2.3% 0.151.8 MB 2.2% 0.50
Jun 28 14:00:00 - 14:59:59 627 2.7% 0.172.3 MB 2.8% 0.65
Jun 28 15:00:00 - 15:59:59 433 1.8% 0.122.2 MB 2.8% 0.64
Jun 28 16:00:00 - 16:59:59 510 2.2% 0.142.2 MB 2.7% 0.62
Jun 28 17:00:00 - 17:59:59 531 2.3% 0.152.4 MB 3.0% 0.68
Jun 28 18:00:00 - 18:59:59 655 2.8% 0.182.4 MB 3.0% 0.69
Jun 28 19:00:00 - 19:59:59 834 3.5% 0.232.3 MB 2.8% 0.65
Jun 28 20:00:00 - 20:59:59 930 3.9% 0.262.8 MB 3.4% 0.79
Jun 28 21:00:00 - 21:59:59 1106 4.7% 0.313.1 MB 3.8% 0.88
Jun 28 22:00:00 - 22:59:59 1186 5.0% 0.333.4 MB 4.1% 0.96
Jun 28 23:00:00 - 23:58:01 1028 4.4% 0.303.4 MB 4.1% 0.99
TOTAL: 23:59:59 23577 100.0% 0.2781.2 MB 100.0% 0.96
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.0 GB 36.0% 0 0.35 1758.10
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.0 GB 42.0% 0 0.43 1406.68
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB224.6 MB 0.4% 0 0.0416510.88
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 GB3.7 GB 7.4% 0 0.78 774.53
TOTAL: 10-500.0 GB43.0 GB 8.6% 1 0.51-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 6465 19 0 63 0 0 0 0 6383
2newsfeed.neva.ru 1646 76 0 78 0 0 0 0 1492
3newsfeed.datemas.de 1219 206 0 90 0 0 0 0 923
4news-out.mixmin.net 785 0 0 84 0 0 0 0 701
5feeder.eternal-september.org 612 0 0 130 0 0 0 0 482
6news.redatomik.org 409 0 0 75 0 0 0 0 334
7news.albasani.net 312 0 0 75 0 0 0 0 237
8news-out.aioe.org 122 16 0 50 0 0 0 0 56
9news.freedyn.net 120 6 0 44 0 0 0 0 70
10agency-nz-out.news.mb-net.net 119 10 0 62 0 0 0 0 47
11feeder.awxg.com 93 2 0 89 0 0 0 0 2
12csiph.com 79 0 0 66 0 0 0 0 13
13news.swapon.de 42 0 0 20 0 0 0 0 22
14news.ausics.org 4 0 0 3 0 0 0 0 1
TOTAL: 14 12027 335 0 929 0 0 0 010763

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 110
it.annunci.immobiliari 27
mozilla.support.seamonkey 26
it.annunci.commerciali 25
it.annunci.varie 23
fido7.ru.android 20
mozilla.dev.security.policy 19
gmane.linux.alsa.devel 14
gmane.comp.gis.openstreetmap.imports 12
mozilla.dev.platform 6
mpc.lists.nanog 5
alt.biz.accounting 4
mozilla.dev.ui-alerts 4
alt.penthouse.sex.femdom 3
mozilla.dev.l10n.sr 3
mozilla.community.sweden 3
gmane.comp.gis.openstreetmap.tagging 2
eagle.support.eng 2
mozilla.dev.ports.os2 2
mozilla.dev.developer-tools 2
TOTAL: 41 335

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9018
EMP (phn path) 777
EMP (phl) 173
EMP (phn nph) 97
Too many newsgroups 33
Binary: non-binary distribution 26
User-issued cancel 17
Binary: misplaced par2 12
Too many newsgroups (low_xpost) 6
Binary Image: misplaced jpg 5
Binary: misplaced 003 3
User-issued spam cancel 2
Binary: misplaced 005 2
Binary: misplaced 010 2
Binary: misplaced 188 1
Binary: misplaced 573 1
Too many newsgroups (meow) 1
Binary: misplaced 558 1
Binary: misplaced 004 1
Binary: misplaced 023 1
TOTAL: 29 10188

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 324
newsfeed.datemas.de 177
news-out.mixmin.net 26
news.swapon.de 22
news.snarked.org 7
news-out.aioe.org 6
news.albasani.net 4
feeder.eternal-september.org 3
newsfeed.neva.ru 3
feeder.awxg.com 2
TOTAL: 11 575
TOTAL: 1 575

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 21813 1185 20480 147 0 1 5%23:59:45
2awxg 22915 83 22756 3 0 134 0%23:59:47
3news.snarked.org 18301 38 18081 23 0 125 0%23:57:43
4eternal-september 20166 18 19956 2 0 332 0%23:59:47
5news.freedyn.net 23733 16 23452 0 0 64 0%23:59:42
6aioe 19142 13 18932 0 0 1 0%23:59:37
7mb-net.net 23563 12 23478 0 0 245 0%23:59:47
8news-in.mixmin.net 21291 11 21264 0 0 0 0%23:59:47
9csiph.com 20949 11 20881 0 0 0 0%23:59:47
10news.redatomik.org 18976 11 18946 0 0 1 0%23:59:44
11news.albasani.net 23614 9 21048 983 0 6882 0%23:59:47
12newsfeed.datemas.de 18572 7 18501 0 0 354 0%23:59:47
13neva.ru 21767 6 21749 6 0 0 0%23:59:47
14news.swapon.de 2122 0 2121 0 0 0 0%23:59:44
15news.samoylyk.net 0 0 0 0 0 21813 0%23:57:40
TOTAL: 15 276924 1420 271645 1164 0 29952 0%359:52:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.3 MB10.3 MB17.7 MB0.2 KB/s13.6 KB23:59:45
2news.snarked.org681.7 KB44.7 KB726.5 KB0.0 KB/s11.9 KB23:57:43
3awxg310.7 KB21.4 KB332.1 KB0.0 KB/s3.9 KB23:59:47
4eternal-september43.9 KB5.9 KB49.8 KB0.0 KB/s2.5 KB23:59:47
5news.freedyn.net34.6 KB0.0 KB34.6 KB0.0 KB/s2.2 KB23:59:42
6mb-net.net29.9 KB0.0 KB29.9 KB0.0 KB/s2.5 KB23:59:47
7aioe27.8 KB0.0 KB27.8 KB0.0 KB/s2.1 KB23:59:37
8news-in.mixmin.net23.0 KB0.0 KB23.0 KB0.0 KB/s2.1 KB23:59:47
9csiph.com23.0 KB0.0 KB23.0 KB0.0 KB/s2.1 KB23:59:47
10news.redatomik.org23.0 KB0.0 KB23.0 KB0.0 KB/s2.1 KB23:59:44
11neva.ru20.4 KB8.7 KB29.1 KB0.0 KB/s2.4 KB23:59:47
12news.albasani.net20.3 KB3.2 MB3.3 MB0.0 KB/s3.4 KB23:59:47
13newsfeed.datemas.de13.7 KB0.0 KB13.7 KB0.0 KB/s2.0 KB23:59:47
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
15news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:40
TOTAL: 158.6 MB13.7 MB22.2 MB0.0 KB/s8.8 KB359:52:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 352 687923.4 MB 3485 11 1400:11:43
2kosh.activateit.net.au 24 12681.6 MB 166 0 000:05:28
360.234.244.55 6 43122.3 KB 1 0 000:09:32
TOTAL: 3 382 819025.2 MB 3652 11 1439:47:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 352 687923.4 MB 3485 11 1400:11:43
2*.activateit.net.au 24 12681.6 MB 166 0 000:05:28
3unresolved 8 43122.3 KB 1 0 000:19:34
4*.cpe.cableone.net 7 00.0 KB 0 0 039:10:59
5? 3 00.0 KB 0 0 000:00:04
TOTAL: 5 394 819025.2 MB 3652 11 1439:47:50

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 7
crash 6
TOTAL: 3 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.448 0.124 0.02139:10:59
agency.bbs.geek.nz 25.080 5.792 0.00000:11:43
60.234.244.55 0.452 0.052 0.01400:09:32
kosh.activateit.net.au 1.408 0.372 0.13200:05:28
118.149.138.55 0.060 0.016 0.00000:05:01
202.174.187.54 0.060 0.008 0.00000:05:01
2607:f350:1:1225::1:4 0.156 0.040 0.00000:00:02
? 1.172 0.112 0.00000:00:01
TOTAL: 8 28.836 6.516 0.16739:47:50

Curious NNRP server explorers [Top 20]:

SystemConn
67-61-218-236.cpe.cableone.net 7
2607:f350:1:1225::1:4 3
118.149.138.55 1
202.174.187.54 1
TOTAL: 4 12

NNRP gethostbyaddr failures [Top 20]:

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

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-61-218-236.cpe.cableone.net 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 3773 46.2%
2comp 1483 18.1%
3soc 1004 12.3%
4alt 781 9.6%
5sci 629 7.7%
6uk 122 1.5%
7misc 121 1.5%
8talk 113 1.4%
9news 59 0.7%
10agency 27 0.3%
11nz 24 0.3%
12aus 20 0.2%
13humanities 17 0.2%
14eternal-september 1 0.0%
TOTAL: 14 8174100.0%

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

NewsgroupCount
1rec.arts.tv 607
2rec.arts.drwho 449
3comp.os.linux.advocacy 437
4rec.sport.tennis 430
5alt.comp.os.windows-10 420
6comp.lang.c 258
7alt.home.repair 256
8rec.sport.golf 218
9comp.lang.python 205
10rec.food.cooking 189
11rec.sport.football.college 180
12soc.culture.polish 168
13soc.retirement 167
14rec.arts.sf.tv 167
15rec.arts.sf.written 164
16rec.sport.pro-wrestling 158
17sci.electronics.design 144
18rec.boats 130
19soc.penpals 122
20sci.physics 116
21sci.math 111
22uk.radio.amateur 104
23soc.culture.israel 102
24rec.autos.sport.f1 78
25soc.culture.china 76
26rec.audio.opinion 72
27rec.photo.digital 70
28rec.bicycles.tech 68
29rec.crafts.metalworking 66
30misc.survivalism 60
31rec.gambling.poker 58
32soc.culture.usa 53
33comp.mobile.android 52
34comp.lang.c++ 51
35news.lists.filters 51
36rec.outdoors.rv-travel 51
37alt.test 47
38sci.math.num-analysis 46
39rec.music.dylan 45
40soc.culture.singapore 44
41soc.culture.cuba 44
42comp.os.vms 42
43rec.radio.shortwave 40
44rec.games.trivia 39
45soc.culture.vietnamese 37
46comp.sys.apple2 37
47rec.aviation.soaring 37
48soc.culture.indian 34
49talk.origins 33
50comp.lang.forth 31
51talk.politics.misc 30
52sci.physics.relativity 30
53rec.sport.soccer 30
54alt.bbs.mystic 30
55rec.boats.paddle 29
56rec.games.pinball 29
57sci.military.naval 29
58rec.arts.movies.current-films 28
59comp.sys.mac.advocacy 28
60talk.politics.guns 27
61agency.test 27
62misc.health.alternative 26
63sci.logic 26
64nz.general 24
65comp.sys.mac.apps 24
66comp.lang.awk 23
67rec.arts.movies.past-films 22
68comp.lang.asm.x86 21
69comp.soft-sys.matlab 20
70rec.music.classical.recordings 20
71comp.unix.programmer 19
72sci.med.pharmacy 19
73aus.aviation 18
74rec.woodworking 18
75rec.audio.pro 18
76soc.genealogy.medieval 18
77comp.sys.acorn.apps 18
78comp.lang.fortran 17
79rec.arts.tv.uk.coronation-st 16
80sci.crypt 16
81soc.culture.venezuela 15
82sci.physics.electromag 15
83rec.radio.amateur.misc 15
84rec.autos.tech 14
85rec.skiing.alpine 14
86rec.music.classical.guitar 14
87soc.culture.brazil 14
88comp.lang.ada 13
89comp.os.linux.misc 13
90comp.databases.ms-access 12
91comp.sys.mac.system 12
92humanities.lit.authors.shakespeare 12
93comp.lang.php 12
94rec.radio.amateur.dx 12
95rec.music.rock-pop-r+b.1950s 12
96sci.astro.amateur 12
97soc.women 12
98rec.arts.comics.strips 12
99soc.genealogy.jewish 11
100uk.comp.homebuilt 10
TOTAL: 281 8174