news.bbs.geek.nz daily logs

Jun 14 23:58:02 -- Jun 15 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 118089 56.7%9.7 MB 36.3%
inn 32855 15.8%7.1 MB 26.6%
innd 32416 15.6%5.2 MB 19.5%
innfeed 23535 11.3%4.5 MB 16.7%
cnfsstat 1440 0.7%253.1 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 208336 100.0%26.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 312176 48.5%
Positive hits 300533 46.7%
Do not exist 30553 4.7%
Cache misses 474 0.1%
TOTAL: 4 643736 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.326 0.0%173 0.000 1.884 44.000
article cleanup00:00:00.315 0.0%32236 0.000 0.010 0.032
article logging00:00:00.816 0.0%32678 0.000 0.025 0.061
article parse00:00:00.914 0.0%87261 0.000 0.010 0.026
article write00:00:01.846 0.0%23101 0.016 0.080 0.551
artlog/artcncl00:00:00.002 0.0%168 0.000 0.012 0.500
data move00:00:00.399 0.0%592618 0.000 0.001 0.007
hisgrep/artcncl00:00:00.001 0.0%172 0.000 0.006 0.500
hishave/artcncl00:00:00.001 0.0%173 0.000 0.006 0.071
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.731 0.0%651401 0.002 0.015 0.953
history sync00:00:00.049 0.0%309 0.000 0.159 14.500
history write00:00:08.700 0.0%30881 0.017 0.282 17.581
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:40.846 99.7%608326 81.367 141.702 33341.111
nntp read00:00:05.208 0.0%612698 0.003 0.009 0.019
overview write00:00:34.090 0.0%23101 0.072 1.476 36.600
perl filter00:00:56.589 0.1%30881 1.050 1.832 3.972
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.274 0.0%46202 0.003 0.028 0.084
TOTAL: 24:00:20.90823:58:41.107 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.072 0.0%41434 0.000 0.002 0.023
article prepare00:00:00.005 0.0%14296 0.000 0.000 0.016
article read00:00:00.244 0.0%3409 0.000 0.072 2.774
backlog stats00:00:00.626 0.0%346916 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.851 0.0%293425 0.003 0.010 0.019
data write00:00:03.078 0.0%283172 0.000 0.011 0.020
idle23:52:48.504 99.9%346916 121.698 247.808 1941.492
status file00:00:14.336 0.0%2072 0.500 6.919 346.412
TOTAL: 23:53:32.14823:53:09.716100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle34:17:30.089 94.8%136580 0.000 903.867 95538.413
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite01:48:51.112 5.0%3838495 0.000 1.701 2535.143
readart00:00:06.451 0.0%13089 0.000 0.493 22.000
TOTAL: 36:09:18.24936:06:27.652 99.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
1newsfeed.datemas.de 4 24290 6897 16474 919 28%24:44:04
2news.snarked.org 64 28069 6193 16884 4992 22%67:08:58
3news-out.aioe.org 4 22089 2239 19732 118 10%24:31:11
4feeder.eternal-september.org 112 28519 1983 26021 515 6%61:43:26
5csiph.com 3 22336 1610 20633 93 7%24:25:32
6newsfeed.neva.ru 147 18110 1509 16068 533 8%80:45:54
7news-out.mixmin.net 15 24253 1044 22540 669 4%28:18:49
8news.samoylyk.net 3 33185 589 32115 481 1%26:04:06
9news.albasani.net 3 24112 398 23364 350 1%24:58:20
10news.redatomik.org 1 23951 248 23610 93 1%28:16:23
11feeder.awxg.com 3 20366 128 20158 80 0%24:45:08
12news.freedyn.net 6 18962 91 18750 121 0%15:21:46
13news.swapon.de 4 2268 85 2152 31 3%33:10:43
14agency-nz-out.news.mb-net.net 21 24019 63 23834 122 0%30:52:23
15news.ausics.org 2 10827 4 10823 0 0%13:10:55
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 393 325356 23081 293158 9117 7%508:17:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org27.2 MB920.3 KB34.4 MB62.5 MB 43%5.7 KB
2newsfeed.datemas.de21.0 MB407.4 KB3.2 MB24.6 MB 85%3.2 KB
3feeder.eternal-september.org6.9 MB885.6 KB2.6 MB10.3 MB 66%4.2 KB
4news-out.aioe.org5.8 MB323.2 KB415.1 KB6.5 MB 88%2.8 KB
5news-out.mixmin.net4.7 MB616.0 KB1.7 MB7.0 MB 67%4.2 KB
6newsfeed.neva.ru4.6 MB239.5 KB2.3 MB7.1 MB 64%3.6 KB
7csiph.com4.2 MB441.4 KB460.3 KB5.1 MB 82%3.1 KB
8news.samoylyk.net2.6 MB838.8 KB2.8 MB6.2 MB 41%6.0 KB
9news.albasani.net1.6 MB797.6 KB1.3 MB3.6 MB 43%4.9 KB
10news.redatomik.org972.3 KB514.3 KB514.3 KB2.0 MB 48%5.9 KB
11news.freedyn.net817.1 KB519.8 KB767.3 KB2.1 MB 38%9.9 KB
12feeder.awxg.com399.8 KB378.6 KB380.8 KB1.1 MB 34%5.6 KB
13news.swapon.de276.8 KB58.3 KB68.7 KB403.8 KB 68%3.5 KB
14agency-nz-out.news.mb-net.net136.0 KB273.9 KB901.6 KB1.3 MB 10%7.1 KB
15news.ausics.org8.8 KB0.0 KB0.0 KB8.8 KB100%2.2 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1681.1 MB7.0 MB51.7 MB139.8 MB 58%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 14 23:58:02 - 23:59:59 20 0.1% 0.1736.3 KB 0.0% 0.31
Jun 15 00:00:00 - 00:59:59 1211 5.2% 0.343.3 MB 4.1% 0.95
Jun 15 01:00:00 - 01:59:59 1174 5.1% 0.334.2 MB 5.2% 1.19
Jun 15 02:00:00 - 02:59:59 1281 5.5% 0.364.8 MB 5.9% 1.36
Jun 15 03:00:00 - 03:59:59 1516 6.6% 0.426.1 MB 7.6% 1.74
Jun 15 04:00:00 - 04:59:59 1406 6.1% 0.394.3 MB 5.4% 1.23
Jun 15 05:00:00 - 05:59:59 1225 5.3% 0.343.2 MB 4.0% 0.92
Jun 15 06:00:00 - 06:59:59 1257 5.4% 0.354.9 MB 6.1% 1.39
Jun 15 07:00:00 - 07:59:59 1132 4.9% 0.313.9 MB 4.8% 1.10
Jun 15 08:00:00 - 08:59:59 1063 4.6% 0.304.1 MB 5.1% 1.18
Jun 15 09:00:00 - 09:59:59 989 4.3% 0.273.3 MB 4.1% 0.93
Jun 15 10:00:00 - 10:59:59 914 4.0% 0.253.7 MB 4.6% 1.06
Jun 15 11:00:00 - 11:59:59 750 3.2% 0.212.7 MB 3.4% 0.77
Jun 15 12:00:00 - 12:59:59 726 3.1% 0.202.0 MB 2.5% 0.57
Jun 15 13:00:00 - 13:59:59 501 2.2% 0.142.7 MB 3.4% 0.78
Jun 15 14:00:00 - 14:59:59 396 1.7% 0.111.7 MB 2.1% 0.47
Jun 15 15:00:00 - 15:59:59 468 2.0% 0.131.7 MB 2.1% 0.47
Jun 15 16:00:00 - 16:59:59 646 2.8% 0.183.5 MB 4.3% 0.99
Jun 15 17:00:00 - 17:59:59 564 2.4% 0.162.0 MB 2.5% 0.56
Jun 15 18:00:00 - 18:59:59 649 2.8% 0.182.3 MB 2.9% 0.66
Jun 15 19:00:00 - 19:59:59 839 3.6% 0.232.4 MB 3.0% 0.69
Jun 15 20:00:00 - 20:59:59 1012 4.4% 0.282.9 MB 3.6% 0.83
Jun 15 21:00:00 - 21:59:59 1085 4.7% 0.303.5 MB 4.4% 1.00
Jun 15 22:00:00 - 22:59:59 1155 5.0% 0.323.9 MB 4.9% 1.12
Jun 15 23:00:00 - 23:58:01 1116 4.8% 0.323.1 MB 3.8% 0.90
TOTAL: 23:59:59 23095 100.0% 0.2780.3 MB 100.0% 0.95
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.7 GB 35.4% 0 0.34 1769.34
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.6 GB 41.2% 0 0.41 1498.15
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB221.1 MB 0.4% 0 0.0511232.00
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 GB2.9 GB 5.8% 0 0.84 726.53
TOTAL: 10-500.0 GB41.4 GB 8.3% 1 0.53-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 4964 79 0 158 0 0 0 0 4727
2newsfeed.datemas.de 1224 255 0 95 0 0 0 0 874
3news-out.mixmin.net 725 0 0 118 0 0 0 0 607
4newsfeed.neva.ru 556 108 0 48 0 0 0 0 400
5feeder.eternal-september.org 534 0 0 194 0 0 0 0 340
6news.samoylyk.net 496 0 0 128 0 0 0 0 368
7news.albasani.net 346 4 0 105 0 0 0 0 237
8news.freedyn.net 162 9 0 74 0 0 0 0 79
9news-out.aioe.org 136 12 0 73 0 0 0 0 51
10agency-nz-out.news.mb-net.net 128 24 0 71 0 0 0 0 33
11csiph.com 104 0 0 99 0 0 0 0 5
12feeder.awxg.com 88 2 0 84 0 0 0 0 2
13news.redatomik.org 85 0 0 80 0 0 0 0 5
14news.swapon.de 38 0 0 19 0 0 0 0 19
15news.ausics.org 6 0 0 6 0 0 0 0 0
TOTAL: 15 9592 493 0 1352 0 0 0 0 7747

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 153
mpc.lists.freebsd.ports.bugs 55
it.annunci.varie 30
it.annunci.immobiliari 29
it.annunci.commerciali 29
mozilla.dev.platform 28
gmane.linux.alsa.devel 19
mozilla.support.seamonkey 18
gmane.linux.kernel.renesas-soc 17
mpc.lists.nanog 17
gmane.comp.gis.openstreetmap.tagging 16
mozilla.dev.ui-alerts 14
mozilla.dev.tree-management 10
mozilla.dev.telemetry-alerts 8
mozilla.dev.ports.os2 5
mozilla.tools.taskcluster 5
eagle.support.eng 4
mozilla.dev.apps.thunderbird 3
mozilla.dev.l10n.sr 3
mozilla.test 3
TOTAL: 40 493

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6334
EMP (phn path) 710
Too many newsgroups 83
Binary Image: misplaced jpg 83
EMP (phl) 46
Binary: non-binary distribution 35
User-issued cancel 8
EMP (phn nph) 3
TOTAL: 8 7302

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 291
news-out.mixmin.net 34
news.snarked.org 26
news.albasani.net 24
news-out.aioe.org 20
news.samoylyk.net 17
news.swapon.de 14
newsfeed.neva.ru 8
news.redatomik.org 5
feeder.eternal-september.org 3
TOTAL: 12 445
TOTAL: 1 445

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 21211 1766 19294 146 0 515 8%23:59:43
2awxg 22593 101 22458 2 0 547 0%23:59:42
3news.snarked.org 17021 13 16864 0 0 648 0%23:59:42
4news.freedyn.net 23104 3 22953 0 0 587 0%23:59:42
5mb-net.net 23036 2 22996 0 0 547 0%23:59:40
6neva.ru 20606 2 20600 1 0 458 0%23:59:42
7news.redatomik.org 22666 2 22663 0 0 537 0%23:59:42
8news.samoylyk.net 24735 1 24703 2 0 228 0%23:57:34
9csiph.com 21500 1 21462 0 0 529 0%23:59:42
10aioe 18976 1 18824 0 0 11 0%23:51:53
11news.albasani.net 23403 1 19816 1408 0 8317 0%23:59:42
12eternal-september 19370 1 19345 0 0 409 0%23:59:42
13news-in.mixmin.net 20534 0 20514 0 0 516 0%23:59:42
14newsfeed.datemas.de 16149 0 16128 0 0 602 0%23:59:42
15news.swapon.de 1940 0 1940 0 0 30 0%23:59:42
TOTAL: 15 296844 1894 290560 1559 0 14481 0%359:45:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.4 MB9.2 MB16.6 MB0.2 KB/s8.9 KB23:59:43
2awxg521.7 KB7.0 KB528.7 KB0.0 KB/s5.1 KB23:59:42
3news.snarked.org17.5 KB0.0 KB17.5 KB0.0 KB/s1.3 KB23:59:42
4aioe12.8 KB0.0 KB12.8 KB0.0 KB/s12.8 KB23:51:53
5neva.ru8.8 KB1.4 KB10.2 KB0.0 KB/s3.4 KB23:59:42
6news.redatomik.org8.2 KB0.0 KB8.2 KB0.0 KB/s4.1 KB23:59:42
7news.freedyn.net4.9 KB0.0 KB4.9 KB0.0 KB/s1.6 KB23:59:42
8mb-net.net2.6 KB0.0 KB2.6 KB0.0 KB/s1.3 KB23:59:40
9news.albasani.net2.0 KB4.4 MB4.4 MB0.1 KB/s3.2 KB23:59:42
10news.samoylyk.net1.4 KB3.6 KB5.1 KB0.0 KB/s1.7 KB23:57:34
11csiph.com1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:42
12eternal-september1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:42
13news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
14newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 158.0 MB13.7 MB21.6 MB0.0 KB/s6.4 KB359:45:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 360 693322.6 MB 3570 0 000:12:51
2mtrlpq2314w-lp140-04-70-53-246-1.dsl.bell.ca 336 15305.9 MB 1076 0 013:13:17
3kosh.activateit.net.au 23 12731.7 MB 170 0 000:05:24
4192.168.1.8 1 84868.6 KB 8 0 000:00:03
5203.118.151.117 1 34.1 KB 2 0 000:00:48
TOTAL: 5 721 982331.2 MB 4826 0 036:09:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 360 693322.6 MB 3570 0 000:12:51
2*.dsl.bell.ca 336 15305.9 MB 1076 0 013:13:17
3*.activateit.net.au 23 12731.7 MB 170 0 000:05:24
4unresolved 2 87872.7 KB 10 0 000:00:51
5*.cpe.cableone.net 2 00.0 KB 0 0 022:36:41
TOTAL: 5 723 982331.2 MB 4826 0 036:09:08

NNRP auth users [Top 20]:

UserConn
amybbs 23
malcolmlewis 2
paulh 1
TOTAL: 3 26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.232 0.068 0.00922:36:41
mtrlpq2314w-lp140-04-70-53-246-1.dsl.bell.ca 40.896 11.152 0.00013:13:17
agency.bbs.geek.nz 27.452 6.904 0.00000:12:51
kosh.activateit.net.au 1.528 0.492 0.20100:05:24
203.118.151.117 0.092 0.016 0.00000:00:48
192.168.1.8 0.128 0.036 0.00200:00:03
? 1.004 0.160 0.00000:00:01
TOTAL: 7 71.332 18.828 0.21236:09:08

Curious NNRP server explorers [Top 20]:

SystemConn
67-61-218-236.cpe.cableone.net 2
TOTAL: 1 2

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp140-04-70-53-246-1.dsl.bell.ca 14 14
67-61-218-236.cpe.cableone.net 1 0
TOTAL: 2 15 14

Newsgroup request counts (by category):

CategoryCountPct
1rec 3717 37.8%
2comp 1652 16.8%
3soc 1341 13.7%
4alt 1004 10.2%
5sci 934 9.5%
6misc 561 5.7%
7talk 246 2.5%
8uk 186 1.9%
9news 96 1.0%
10nz 63 0.6%
11aus 14 0.1%
12humanities 8 0.1%
13fr 1 0.0%
TOTAL: 13 9823100.0%

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

NewsgroupCount
1rec.arts.tv 913
2comp.os.linux.advocacy 577
3sci.electronics.design 427
4rec.sport.tennis 409
5rec.arts.drwho 353
6comp.lang.python 290
7soc.culture.usa 257
8alt.home.repair 247
9alt.comp.os.windows-10 246
10soc.culture.romanian 235
11misc.health.alternative 233
12comp.lang.c 210
13rec.arts.sf.written 203
14rec.food.cooking 177
15alt.test 168
16soc.retirement 168
17rec.sport.golf 162
18alt.support.schizophrenia 150
19soc.culture.polish 147
20misc.survivalism 147
21rec.arts.disney.parks 143
22rec.sport.football.college 142
23rec.games.trivia 137
24misc.test 129
25rec.boats 119
26talk.politics.guns 108
27sci.physics 103
28sci.math 99
29rec.sport.pro-wrestling 95
30uk.radio.amateur 94
31soc.culture.israel 92
32soc.culture.china 92
33alt.life.sucks 85
34rec.bicycles.tech 83
35talk.origins 77
36sci.physics.relativity 69
37rec.gambling.poker 65
38nz.general 61
39rec.music.dylan 61
40uk.comp.sys.mac 60
41talk.politics.misc 59
42comp.lang.forth 58
43rec.audio.pro 56
44alt.fan.art-bell 55
45comp.lang.c++ 53
46rec.outdoors.rv-travel 47
47news.lists.filters 46
48comp.mobile.android 46
49sci.military.naval 43
50soc.culture.singapore 42
51soc.culture.indian 40
52soc.culture.vietnamese 32
53rec.sport.soccer 32
54soc.culture.cuba 31
55sci.logic 31
56sci.med.pharmacy 30
57comp.os.vms 28
58comp.soft-sys.matlab 28
59rec.music.classical.guitar 27
60uk.comp.homebuilt 26
61soc.penpals 26
62rec.photo.digital 26
63sci.astro.amateur 24
64rec.crafts.metalworking 24
65soc.culture.brazil 24
66rec.aviation.soaring 23
67news.answers 22
68rec.woodworking 21
69sci.crypt 21
70rec.autos.sport.f1 20
71rec.sport.cricket 20
72comp.lang.fortran 20
73rec.music.classical.recordings 20
74misc.health.diabetes 19
75comp.protocols.dns.bind 18
76rec.games.pinball 18
77alt.bbs.ads 18
78comp.arch 17
79soc.culture.bulgaria 17
80comp.lang.tcl 17
81soc.genealogy.benelux 17
82comp.soft-sys.sas 16
83comp.soft-sys.math.scilab 16
84rec.arts.sf.fandom 15
85comp.arch.embedded 15
86rec.music.beatles 14
87alt.os.linux.ubuntu 14
88sci.electronics.repair 14
89soc.culture.quebec 14
90rec.music.makers.guitar.jazz 13
91comp.lang.lisp 13
92rec.skiing.alpine 13
93comp.unix.solaris 13
94rec.nude 12
95rec.arts.tv.uk.coronation-st 12
96news.groups.questions 12
97rec.puzzles.crosswords 12
98comp.lang.idl-pvwave 12
99sci.physics.electromag 12
100rec.radio.shortwave 12
TOTAL: 316 9823