news.bbs.geek.nz daily logs

May 23 23:58:01 -- May 24 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 104200 52.9%8.4 MB 32.6%
inn 34867 17.7%7.4 MB 28.6%
innd 32901 16.7%5.2 MB 20.1%
innfeed 23609 12.0%4.5 MB 17.7%
cnfsstat 1440 0.7%253.0 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 197018 100.0%25.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 323070 49.4%
Positive hits 298962 45.7%
Do not exist 32052 4.9%
Cache misses 483 0.1%
TOTAL: 4 654567 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.296 0.0%185 0.000 1.600 31.000
article cleanup00:00:00.345 0.0%34379 0.000 0.010 0.040
article logging00:00:01.057 0.0%34809 0.000 0.030 0.315
article parse00:00:01.120 0.0%114122 0.000 0.010 0.027
article write00:00:01.754 0.0%23627 0.009 0.074 0.232
artlog/artcncl00:00:00.003 0.0%185 0.000 0.016 0.333
data move00:00:00.906 0.0%622184 0.000 0.001 0.029
hisgrep/artcncl00:00:00.012 0.0%175 0.000 0.069 10.000
hishave/artcncl00:00:00.000 0.0%185 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.840 0.0%668608 0.002 0.019 1.016
history sync00:00:00.014 0.0%361 0.000 0.039 0.500
history write00:00:18.512 0.0%32929 0.009 0.562 22.172
hiswrite/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
idle23:56:27.525 99.7%639983 26.282 134.672 377.787
nntp read00:00:06.406 0.0%645596 0.003 0.010 0.097
overview write00:00:39.521 0.0%23627 0.107 1.673 55.852
perl filter00:01:12.293 0.1%32929 1.186 2.195 13.690
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.251 0.0%47254 0.000 0.026 0.137
TOTAL: 24:00:50.26823:59:03.855 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.080 0.0%41123 0.000 0.002 0.018
article prepare00:00:00.019 0.0%91992 0.000 0.000 0.003
article read00:00:01.486 0.0%22331 0.008 0.067 2.283
backlog stats00:00:00.503 0.0%349382 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.347 0.0%296125 0.002 0.008 0.016
data write00:00:03.523 0.0%288122 0.006 0.012 0.022
idle23:52:56.699100.0%349382 100.392 246.082 566.684
status file00:00:07.636 0.0%2057 0.417 3.712 105.316
TOTAL: 23:53:30.30523:53:12.293100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%6 0.000 0.167 0.200
idle35:09:35.972 98.7%112127 0.000 1128.863 75104.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.376 0.0%239926 0.000 0.006 0.333
readart00:00:02.284 0.0%8178 0.000 0.279 57.038
TOTAL: 35:36:24.27435:09:39.633 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 59 29370 6792 17387 5191 23%64:01:33
2newsfeed.datemas.de 4 24770 5144 18938 688 20%23:56:07
3news.redatomik.org 1 24991 2241 22653 97 8%26:17:09
4feeder.eternal-september.org 112 33021 1968 29208 1845 5%64:59:55
5newsfeed.neva.ru 147 23555 1514 21336 705 6%85:32:39
6news.albasani.net 1 33839 1383 31832 624 4%35:46:38
7csiph.com 2 23774 1084 22614 76 4%24:37:01
8news.freedyn.net 3 26873 1079 25261 533 4%23:45:00
9news-out.mixmin.net 14 24014 1066 22612 336 4%27:24:58
10news-out.aioe.org 13 21136 861 20185 90 4%21:44:15
11news.samoylyk.net 6 31016 194 30478 344 0%24:13:12
12feeder.awxg.com 2 20883 117 20680 86 0%23:59:54
13news.swapon.de 6 1523 78 1430 15 5%22:06:36
14agency-nz-out.news.mb-net.net 20 26805 67 26584 154 0%35:17:01
15localhost 4 3 3 0 0 100%00:00:00
TOTAL: 15 394 345573 23591 311198 10784 6%503:41:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org24.5 MB906.4 KB37.2 MB62.5 MB 39%5.3 KB
2newsfeed.datemas.de16.0 MB387.7 KB2.2 MB18.6 MB 86%3.3 KB
3feeder.eternal-september.org7.3 MB2.9 MB45.3 MB55.5 MB 13%14.9 KB
4news.redatomik.org5.8 MB441.3 KB451.0 KB6.7 MB 86%2.9 KB
5news.albasani.net4.6 MB1.2 MB2.6 MB8.5 MB 54%4.3 KB
6news-out.mixmin.net4.4 MB435.4 KB1.1 MB5.9 MB 74%4.3 KB
7newsfeed.neva.ru4.2 MB335.2 KB3.7 MB8.1 MB 51%3.8 KB
8news.freedyn.net2.8 MB1.2 MB2.9 MB7.0 MB 40%4.4 KB
9csiph.com2.7 MB284.2 KB300.7 KB3.3 MB 82%2.9 KB
10news-out.aioe.org2.1 MB173.8 KB242.8 KB2.5 MB 83%2.7 KB
11news.samoylyk.net847.4 KB1.4 MB3.2 MB5.4 MB 15%10.3 KB
12feeder.awxg.com349.9 KB449.3 KB453.8 KB1.2 MB 27%6.2 KB
13agency-nz-out.news.mb-net.net216.0 KB564.0 KB1.5 MB2.2 MB 9%10.3 KB
14news.swapon.de199.2 KB48.8 KB50.1 KB298.2 KB 66%3.2 KB
15localhost7.5 KB0.0 KB0.0 KB7.5 KB100%2.5 KB
TOTAL: 1575.9 MB10.6 MB101.2 MB187.7 MB 40%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 23 23:58:01 - 23:59:59 36 0.2% 0.3077.2 KB 0.1% 0.65
May 24 00:00:00 - 00:59:59 1042 4.4% 0.292.6 MB 3.5% 0.75
May 24 01:00:00 - 01:59:59 1210 5.1% 0.343.4 MB 4.4% 0.96
May 24 02:00:00 - 02:59:59 1339 5.7% 0.374.4 MB 5.8% 1.26
May 24 03:00:00 - 03:59:59 1385 5.9% 0.384.4 MB 5.8% 1.26
May 24 04:00:00 - 04:59:59 1268 5.4% 0.353.4 MB 4.4% 0.95
May 24 05:00:00 - 05:59:59 1459 6.2% 0.414.6 MB 6.0% 1.31
May 24 06:00:00 - 06:59:59 1316 5.6% 0.375.0 MB 6.6% 1.42
May 24 07:00:00 - 07:59:59 1149 4.9% 0.323.9 MB 5.1% 1.10
May 24 08:00:00 - 08:59:59 1374 5.8% 0.384.0 MB 5.3% 1.15
May 24 09:00:00 - 09:59:59 1226 5.2% 0.343.9 MB 5.1% 1.10
May 24 10:00:00 - 10:59:59 977 4.1% 0.274.0 MB 5.2% 1.13
May 24 11:00:00 - 11:59:59 775 3.3% 0.223.3 MB 4.4% 0.95
May 24 12:00:00 - 12:59:59 531 2.3% 0.151.8 MB 2.3% 0.50
May 24 13:00:00 - 13:59:59 468 2.0% 0.131.3 MB 1.7% 0.37
May 24 14:00:00 - 14:59:59 458 1.9% 0.131.7 MB 2.3% 0.49
May 24 15:00:00 - 15:59:59 476 2.0% 0.131.5 MB 2.0% 0.43
May 24 16:00:00 - 16:59:59 530 2.2% 0.151.9 MB 2.5% 0.54
May 24 17:00:00 - 17:59:59 636 2.7% 0.182.1 MB 2.7% 0.59
May 24 18:00:00 - 18:59:59 747 3.2% 0.213.0 MB 3.9% 0.85
May 24 19:00:00 - 19:59:59 1015 4.3% 0.282.9 MB 3.8% 0.81
May 24 20:00:00 - 20:59:59 1056 4.5% 0.293.0 MB 4.0% 0.86
May 24 21:00:00 - 21:59:59 1142 4.8% 0.323.5 MB 4.5% 0.98
May 24 22:00:00 - 22:59:59 1019 4.3% 0.282.9 MB 3.9% 0.84
May 24 23:00:00 - 23:58:02 948 4.0% 0.273.5 MB 4.6% 1.02
TOTAL: 24:00:01 23582 100.0% 0.2776.0 MB 100.0% 0.90
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.1 GB 34.3% 0 0.30 2022.60
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.0 GB 40.0% 0 0.33 1812.53
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB214.6 MB 0.4% 0 0.0318888.89
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 GB1.5 GB 3.1% 0 0.86 704.59
TOTAL: 10-500.0 GB38.9 GB 7.8% 1 0.48-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5108 98 0 133 0 0 0 0 4877
2feeder.eternal-september.org 1839 0 0 242 0 0 0 0 1597
3newsfeed.datemas.de 871 170 0 97 0 0 0 0 604
4newsfeed.neva.ru 720 140 0 71 0 0 0 0 509
5news.albasani.net 647 4 0 99 0 0 0 0 544
6news.freedyn.net 547 21 0 110 0 0 0 0 416
7news-out.mixmin.net 359 0 0 107 0 0 0 0 252
8news.samoylyk.net 348 0 0 144 0 0 0 0 204
9news.redatomik.org 175 0 0 87 0 0 0 0 88
10agency-nz-out.news.mb-net.net 157 20 0 88 0 0 0 0 49
11news-out.aioe.org 112 8 0 66 0 0 0 0 38
12feeder.awxg.com 103 0 0 100 0 0 0 0 3
13csiph.com 83 0 0 80 0 0 0 0 3
14news.swapon.de 31 0 0 16 0 0 0 0 15
TOTAL: 14 11100 461 0 1440 0 0 0 0 9199

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 139
mpc.lists.freebsd.ports.bugs 58
gmane.linux.alsa.devel 43
it.annunci.varie 26
it.annunci.commerciali 26
mozilla.dev.platform 22
mpc.lists.nanog 17
mozilla.dev.security.policy 14
mpc.lists.freebsd.gnome 14
mozilla.dev.ui-alerts 14
gmane.comp.hardware.netbook.arm.sunxi 13
mozilla.dev.l10n 12
mpc.lists.freebsd.wireless 6
mozilla.dev.telemetry-alerts 4
eagle.support.eng 4
gmane.linux.kernel 3
mozilla.support.calendar 3
mozilla.dev.tech.crypto 3
mozilla.support.seamonkey 3
mozilla.support.bugzilla 2
TOTAL: 52 461

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6359
EMP (phn path) 1950
Binary Image: misplaced jpg 156
EMP (phl) 143
Binary: non-binary distribution 43
Too many newsgroups 42
EMP (phn nph) 41
User-issued cancel 23
HTML post 10
Too many newsgroups (meow) 2
Cancel for rejected article 1
Binary Image: misplaced png 1
TOTAL: 12 8771

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 175
news.albasani.net 96
news.redatomik.org 82
newsfeed.neva.ru 19
news-out.mixmin.net 15
news.swapon.de 14
news-out.aioe.org 9
news.snarked.org 9
news.freedyn.net 4
news.samoylyk.net 2
TOTAL: 12 428
TOTAL: 1 428

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 21618 20441 0 1157 0 0 94%23:59:50
2awxg 23060 91 22953 7 0 13 0%23:59:46
3aioe 19490 18 19273 1 0 138 0%23:59:40
4news.freedyn.net 22714 13 22491 0 0 45 0%23:59:48
5news.snarked.org 16579 5 16546 0 0 0 0%23:59:48
6csiph.com 22625 3 22572 0 0 0 0%23:59:48
7neva.ru 21280 3 21272 1 0 0 0%23:59:50
8news-in.mixmin.net 20768 3 20741 0 0 0 0%23:59:29
9news.samoylyk.net 23048 3 21386 2 0 8843 0%23:59:49
10newsfeed.datemas.de 18277 3 18272 0 0 0 0%23:59:48
11news.redatomik.org 21022 3 21016 0 0 0 0%23:59:50
12eternal-september 20037 2 19986 0 0 108 0%23:59:50
13mb-net.net 23518 2 23462 0 0 121 0%23:59:50
14news.albasani.net 23727 0 20059 1157 0 8353 0%23:59:50
15news.swapon.de 1826 0 1825 0 0 0 0%23:54:20
TOTAL: 15 299589 20590 271854 2325 0 17621 6%359:51:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org64.9 MB5.0 MB69.8 MB0.8 KB/s3.3 KB23:59:50
2awxg455.0 KB32.9 KB488.0 KB0.0 KB/s5.0 KB23:59:46
3news.freedyn.net57.2 KB0.0 KB57.2 KB0.0 KB/s4.4 KB23:59:48
4aioe46.0 KB2.3 KB48.4 KB0.0 KB/s2.5 KB23:59:40
5neva.ru15.1 KB2.0 KB17.1 KB0.0 KB/s4.3 KB23:59:50
6news.snarked.org12.4 KB0.0 KB12.4 KB0.0 KB/s2.5 KB23:59:48
7csiph.com7.5 KB0.0 KB7.5 KB0.0 KB/s2.5 KB23:59:48
8news-in.mixmin.net7.5 KB0.0 KB7.5 KB0.0 KB/s2.5 KB23:59:29
9news.samoylyk.net7.5 KB3.5 KB11.1 KB0.0 KB/s2.2 KB23:59:49
10newsfeed.datemas.de7.5 KB0.0 KB7.5 KB0.0 KB/s2.5 KB23:59:48
11news.redatomik.org7.5 KB0.0 KB7.5 KB0.0 KB/s2.5 KB23:59:50
12eternal-september4.6 KB0.0 KB4.6 KB0.0 KB/s2.3 KB23:59:50
13mb-net.net4.6 KB0.0 KB4.6 KB0.0 KB/s2.3 KB23:59:50
14news.albasani.net0.0 KB3.9 MB3.9 MB0.0 KB/s3.5 KB23:59:50
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:20
TOTAL: 1565.5 MB9.0 MB74.4 MB0.1 KB/s3.3 KB359:51:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 354 629919.0 MB 3413 3 000:11:21
2kosh.activateit.net.au 24 11101.4 MB 150 0 000:05:51
360.234.244.55 5 1539.5 KB 1 0 000:20:21
TOTAL: 3 383 742420.5 MB 3564 3 035:36:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 354 629919.0 MB 3413 3 000:11:21
2*.activateit.net.au 24 11101.4 MB 150 0 000:05:51
3unresolved 11 1539.5 KB 1 0 000:45:36
4*.cpe.cableone.net 4 00.0 KB 0 0 034:33:26
TOTAL: 4 393 742420.5 MB 3564 3 035:36:17

NNRP auth users [Top 20]:

UserConn
amybbs 24
malcolmlewis 4
crash 4
TOTAL: 3 32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.296 0.164 0.01434:33:26
60.234.244.55 0.396 0.056 0.01300:20:21
agency.bbs.geek.nz 25.552 6.120 0.00000:11:21
118.149.191.81 0.116 0.024 0.00000:10:04
202.174.187.54 0.112 0.020 0.00000:10:01
kosh.activateit.net.au 1.512 0.432 0.19100:05:51
118.149.196.215 0.056 0.016 0.00000:05:01
203.118.151.117 0.092 0.008 0.00000:00:06
? 1.264 0.164 0.00000:00:02
TOTAL: 9 29.396 7.004 0.21835:36:17

Curious NNRP server explorers [Top 20]:

SystemConn
67-61-218-236.cpe.cableone.net 4
202.174.187.54 2
118.149.191.81 2
203.118.151.117 1
118.149.196.215 1
TOTAL: 5 10

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 3428 46.2%
2comp 1233 16.6%
3sci 809 10.9%
4soc 758 10.2%
5alt 547 7.4%
6talk 163 2.2%
7news 159 2.1%
8misc 145 2.0%
9uk 130 1.8%
10humanities 13 0.2%
11eternal-september 11 0.1%
12nz 10 0.1%
13agency 9 0.1%
14aus 3 0.0%
TOTAL: 14 7418100.0%

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

NewsgroupCount
1rec.arts.tv 907
2rec.arts.drwho 472
3comp.os.linux.advocacy 399
4rec.sport.tennis 292
5alt.comp.os.windows-10 284
6alt.home.repair 203
7sci.electronics.design 177
8rec.arts.sf.written 162
9sci.math 151
10rec.boats 150
11comp.lang.python 147
12soc.culture.israel 138
13rec.food.cooking 138
14rec.sport.football.college 130
15soc.retirement 127
16sci.physics.relativity 124
17comp.lang.c 110
18soc.culture.polish 103
19uk.radio.amateur 90
20sci.med.pharmacy 88
21rec.sport.pro-wrestling 83
22rec.photo.digital 82
23talk.politics.guns 77
24news.lists.filters 77
25sci.physics 76
26misc.survivalism 75
27rec.sport.golf 66
28comp.mobile.android 66
29comp.sys.mac.system 64
30news.admin.net-abuse.email 60
31rec.gambling.poker 59
32rec.bicycles.tech 58
33rec.crafts.metalworking 55
34talk.origins 54
35rec.autos.sport.f1 51
36comp.lang.c++ 46
37rec.music.classical.recordings 46
38soc.culture.usa 45
39rec.sport.soccer 43
40rec.aviation.soaring 40
41sci.logic 39
42soc.culture.china 38
43alt.test 38
44rec.arts.movies.past-films 36
45uk.comp.homebuilt 36
46rec.woodworking 32
47rec.games.trivia 32
48soc.culture.indian 29
49comp.lang.forth 29
50rec.audio.opinion 29
51sci.military.naval 28
52comp.sys.mac.advocacy 28
53comp.sys.apple2 28
54soc.support.fat-acceptance 27
55rec.games.pinball 26
56rec.audio.pro 26
57rec.music.dylan 25
58soc.culture.brazil 25
59soc.culture.british 25
60rec.radio.shortwave 24
61comp.soft-sys.matlab 23
62sci.math.num-analysis 22
63soc.culture.vietnamese 21
64rec.radio.amateur.misc 20
65misc.health.alternative 20
66talk.politics.misc 20
67comp.lang.fortran 19
68comp.os.linux.misc 19
69soc.penpals 18
70rec.gardens.edible 18
71soc.culture.bulgaria 17
72news.groups.questions 16
73rec.arts.tv.uk.coronation-st 16
74comp.lang.javascript 16
75comp.soft-sys.sas 15
76rec.music.artists.kiss 15
77comp.soft-sys.math.scilab 15
78comp.sys.ibm.ps2.hardware 14
79soc.history.what-if 14
80rec.antiques.radio+phono 14
81rec.radio.amateur.policy 14
82soc.culture.turkish 14
83rec.arts.comics.strips 14
84rec.skiing.alpine 13
85soc.culture.singapore 13
86soc.history.medieval 12
87sci.astro 12
88rec.arts.sf.tv 12
89rec.games.backgammon 12
90rec.games.video.sony 12
91comp.arch.fpga 12
92rec.music.rock-pop-r+b.1950s 12
93comp.infosystems.www.authoring.stylesheets 11
94soc.culture.african.american 11
95rec.radio.amateur.dx 11
96sci.electronics.repair 11
97nz.general 10
98comp.sys.acorn.apps 10
99humanities.lit.authors.shakespeare 10
100sci.electronics.basics 10
TOTAL: 293 7418