news.bbs.geek.nz daily logs

Aug 21 23:58:01 -- Aug 22 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135957 61.0%11.2 MB 40.7%
innd 32376 14.5%5.2 MB 18.9%
inn 31028 13.9%6.6 MB 24.1%
innfeed 22119 9.9%4.3 MB 15.5%
cnfsstat 1440 0.6%251.3 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 222921 100.0%27.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 291263 48.0%
Positive hits 285615 47.1%
Do not exist 28997 4.8%
Cache misses 534 0.1%
TOTAL: 4 606409 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.216 0.0%164 0.000 1.317 17.000
article cleanup00:00:00.323 0.0%30359 0.000 0.011 0.040
article logging00:00:00.760 0.0%30880 0.000 0.025 0.101
article parse00:00:00.957 0.0%89834 0.000 0.011 0.037
article write00:00:01.814 0.0%21828 0.014 0.083 1.258
artlog/artcncl00:00:00.000 0.0%158 0.000 0.000 0.000
data move00:00:00.328 0.0%571292 0.000 0.001 0.002
hisgrep/artcncl00:00:00.002 0.0%163 0.000 0.012 0.067
hishave/artcncl00:00:00.000 0.0%164 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.601 0.0%610716 0.002 0.012 0.855
history sync00:00:00.017 0.0%371 0.000 0.046 1.000
history write00:00:07.525 0.0%29201 0.000 0.258 19.909
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:20.867 99.8%584564 49.375 147.530 381.863
nntp read00:00:04.944 0.0%590895 0.004 0.008 0.017
overview write00:00:38.993 0.0%21828 0.065 1.786 52.567
perl filter00:00:56.186 0.1%29201 1.116 1.924 6.678
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.329 0.0%43656 0.005 0.030 0.105
TOTAL: 24:00:56.28723:59:21.862 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.069 0.0%32833 0.000 0.002 0.014
article prepare00:00:00.003 0.0%14232 0.000 0.000 0.012
article read00:00:00.274 0.0%3344 0.000 0.082 2.043
backlog stats00:00:00.607 0.0%322867 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.561 0.0%273176 0.004 0.009 0.019
data write00:00:03.021 0.0%261976 0.005 0.012 0.024
idle23:54:25.847 99.9%322867 138.033 266.567 599.366
status file00:00:15.662 0.0%1976 0.538 7.926 298.417
TOTAL: 23:55:10.22423:54:48.044100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle36:41:57.501 98.2%150953 0.000 875.223 51738.436
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:34.166 0.0%331001 0.000 0.103 3.225
readart00:00:04.267 0.0%13628 0.000 0.313 31.429
TOTAL: 37:23:15.59236:42:35.934 98.2%----

Control commands to INND:

CommandNumber
L 1
begin 1
flush 4
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 12 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 51 20540 6627 13403 510 32%59:38:27
2news-out.mixmin.net 7 24560 4930 18085 1545 20%26:58:53
3feeder.eternal-september.org 105 27358 2414 23404 1540 8%64:12:45
4news-out.aioe.org 2 20896 2192 18612 92 10%23:33:50
5newsfeed.datemas.de 3 22354 1262 20563 529 5%23:25:35
6newsfeed.neva.ru 151 18855 1238 14819 2798 6%84:03:06
7news.redatomik.org 1 19551 971 18484 96 4%22:55:08
8csiph.com 3 20110 914 19135 61 4%22:52:16
9news.albasani.net 4 25049 528 24161 360 2%25:13:37
10news.samoylyk.net 3 34295 382 33342 571 1%32:37:45
11news.swapon.de 9 2465 190 2238 37 7%30:28:38
12feeder.awxg.com 3 24083 176 23815 92 0%31:59:47
13news.freedyn.net 3 24611 128 24342 141 0%24:18:04
14agency-nz-out.news.mb-net.net 23 25280 82 24919 279 0%33:05:27
15localhost 5 4 4 0 0 100%00:00:00
TOTAL: 15 373 310011 22038 279322 8651 7%505:23:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org26.7 MB406.6 KB2.1 MB29.2 MB 91%4.2 KB
2news-out.mixmin.net14.9 MB396.4 KB3.2 MB18.5 MB 80%2.9 KB
3feeder.eternal-september.org13.1 MB691.2 KB9.7 MB23.5 MB 55%6.1 KB
4newsfeed.datemas.de5.8 MB1.3 MB2.4 MB9.5 MB 60%5.5 KB
5news-out.aioe.org5.7 MB212.0 KB351.3 KB6.3 MB 91%2.8 KB
6newsfeed.neva.ru3.6 MB330.1 KB12.8 MB16.7 MB 21%4.2 KB
7news.albasani.net2.9 MB1.3 MB2.1 MB6.3 MB 45%7.3 KB
8csiph.com2.6 MB282.4 KB289.0 KB3.2 MB 82%3.3 KB
9news.redatomik.org2.6 MB619.6 KB629.0 KB3.8 MB 67%3.7 KB
10news.samoylyk.net2.2 MB1.3 MB4.0 MB7.5 MB 28%8.0 KB
11news.freedyn.net1.4 MB1.2 MB1.5 MB4.0 MB 33%15.3 KB
12news.swapon.de774.0 KB86.8 KB153.3 KB1014.1 KB 76%4.5 KB
13feeder.awxg.com572.8 KB339.8 KB347.0 KB1.2 MB 45%4.7 KB
14agency-nz-out.news.mb-net.net523.8 KB530.9 KB12.3 MB13.4 MB 3%37.9 KB
15localhost5.6 KB0.0 KB0.0 KB5.6 KB100%1.4 KB
TOTAL: 1583.1 MB9.0 MB51.9 MB144.0 MB 57%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 21 23:58:01 - 23:59:59 30 0.1% 0.2559.6 KB 0.1% 0.50
Aug 22 00:00:00 - 00:59:59 1146 5.3% 0.323.0 MB 3.7% 0.87
Aug 22 01:00:00 - 01:59:59 1176 5.4% 0.334.3 MB 5.3% 1.22
Aug 22 02:00:00 - 02:59:59 1312 6.0% 0.364.0 MB 4.9% 1.15
Aug 22 03:00:00 - 03:59:59 1293 5.9% 0.365.8 MB 7.1% 1.66
Aug 22 04:00:00 - 04:59:59 1326 6.1% 0.374.1 MB 5.1% 1.18
Aug 22 05:00:00 - 05:59:59 1238 5.7% 0.344.2 MB 5.2% 1.20
Aug 22 06:00:00 - 06:59:59 1168 5.4% 0.324.1 MB 5.0% 1.17
Aug 22 07:00:00 - 07:59:59 1199 5.5% 0.334.7 MB 5.8% 1.35
Aug 22 08:00:00 - 08:59:59 1027 4.7% 0.293.3 MB 4.0% 0.94
Aug 22 09:00:00 - 09:59:59 988 4.5% 0.276.4 MB 7.8% 1.81
Aug 22 10:00:00 - 10:59:59 973 4.5% 0.275.6 MB 6.9% 1.61
Aug 22 11:00:00 - 11:59:59 808 3.7% 0.223.0 MB 3.6% 0.85
Aug 22 12:00:00 - 12:59:59 647 3.0% 0.184.3 MB 5.2% 1.21
Aug 22 13:00:00 - 13:59:59 415 1.9% 0.121.6 MB 1.9% 0.45
Aug 22 14:00:00 - 14:59:59 404 1.9% 0.111.6 MB 2.0% 0.47
Aug 22 15:00:00 - 15:59:59 472 2.2% 0.132.0 MB 2.4% 0.56
Aug 22 16:00:00 - 16:59:59 473 2.2% 0.132.0 MB 2.5% 0.58
Aug 22 17:00:00 - 17:59:59 505 2.3% 0.142.1 MB 2.6% 0.61
Aug 22 18:00:00 - 18:59:59 576 2.6% 0.162.2 MB 2.7% 0.63
Aug 22 19:00:00 - 19:59:59 783 3.6% 0.222.3 MB 2.8% 0.65
Aug 22 20:00:00 - 20:59:59 1015 4.7% 0.283.0 MB 3.6% 0.85
Aug 22 21:00:00 - 21:59:59 933 4.3% 0.262.7 MB 3.2% 0.75
Aug 22 22:00:00 - 22:59:59 953 4.4% 0.262.6 MB 3.2% 0.74
Aug 22 23:00:00 - 23:58:01 923 4.2% 0.272.8 MB 3.4% 0.82
TOTAL: 24:00:00 21783 100.0% 0.2581.9 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.4 GB 38.8% 0 0.34 1765.29
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.5 GB 45.1% 0 0.39 1571.01
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB238.3 MB 0.5% 0 0.0417204.30
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 GB6.9 GB 13.7% 0 0.80 754.48
TOTAL: 10-500.0 GB49.0 GB 9.8% 1 0.50-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2876 106 0 67 0 0 0 0 2703
2news-out.mixmin.net 1828 0 0 106 0 0 0 0 1722
3feeder.eternal-september.org 1625 0 0 162 0 0 0 0 1463
4newsfeed.datemas.de 591 192 0 95 0 0 0 0 304
5news.snarked.org 511 43 0 82 0 0 0 0 386
6news.samoylyk.net 454 0 0 107 0 0 0 0 347
7news.albasani.net 379 0 0 92 0 0 0 0 287
8agency-nz-out.news.mb-net.net 275 50 0 78 0 0 0 0 147
9news.freedyn.net 130 10 0 56 0 0 0 0 64
10news.redatomik.org 126 0 0 89 0 0 0 0 37
11news-out.aioe.org 92 18 0 61 0 0 0 0 13
12news.swapon.de 69 0 0 29 0 0 0 0 40
13feeder.awxg.com 68 2 0 63 0 0 0 0 3
14csiph.com 61 0 0 59 0 0 0 0 2
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 9087 421 0 1148 0 0 0 0 7518

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 82
it.annunci.commerciali 60
it.annunci.immobiliari 55
it.annunci.varie 50
gmane.linux.alsa.devel 41
gmane.linux.kernel 17
mozilla.dev.platform 12
mpc.lists.nanog 12
gmane.comp.gis.openstreetmap.tagging 10
mpc.lists.freebsd.gnome 6
mozilla.dev.ui-alerts 5
alt.bbs.files-distribution 4
alt.bbs.files-announce 4
mozilla.dev.apps.calendar 4
mozilla.support.bugzilla 4
mozilla.compatibility 3
gmane.linux.drivers.devicetree 3
mozilla.dev.ports.os2 3
mozilla.dev.developer-tools 3
mozilla.dev.l10n.web 3
TOTAL: 50 421

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5882
EMP (phn path) 724
EMP (phn nph) 157
Binary Image: misplaced jpg 105
Too many newsgroups 60
Too many newsgroups (low_xpost) 31
User-issued cancel 19
Binary: non-binary distribution 13
HTML post 4
HTML file attachment 1
TOTAL: 10 6996

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 318
newsfeed.datemas.de 58
news.albasani.net 47
news.swapon.de 38
news.redatomik.org 31
news-out.aioe.org 10
feeder.eternal-september.org 5
newsfeed.neva.ru 5
news.samoylyk.net 4
feeder.awxg.com 3
TOTAL: 12 522
TOTAL: 1 522

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19982 2162 17769 51 0 19 10%23:59:40
2awxg 21160 69 21074 4 0 11 0%23:58:56
3news.freedyn.net 22036 15 21631 1 0 89 0%23:59:11
4news.samoylyk.net 21573 7 19653 16 0 951 0%23:59:24
5mb-net.net 21769 5 21648 0 0 218 0%23:58:51
6csiph.com 21026 5 20868 0 0 0 0%23:59:11
7news.redatomik.org 20752 4 20703 0 0 5 0%23:58:41
8news-in.mixmin.net 16293 4 16275 0 0 68 0%23:59:11
9eternal-september 18383 4 18354 0 0 1 0%23:59:11
10aioe 17616 4 17500 0 0 10 0%23:58:36
11newsfeed.datemas.de 20451 3 20432 1 0 48 0%23:59:11
12news.albasani.net 22976 2 19457 1072 0 9680 0%23:58:56
13news.swapon.de 2213 2 2211 0 0 0 0%23:58:57
14news.snarked.org 2812 2 2806 0 0 0 0%04:07:05
15neva.ru 20208 0 20198 4 0 0 0%23:59:11
TOTAL: 15 269250 2288 260579 1149 0 11100 0%339:54:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org20.2 MB1.5 MB21.7 MB0.3 KB/s10.0 KB23:59:40
2awxg300.8 KB15.0 KB315.8 KB0.0 KB/s4.3 KB23:58:56
3news.freedyn.net62.5 KB4.1 KB66.6 KB0.0 KB/s4.2 KB23:59:11
4news.samoylyk.net16.4 KB127.9 KB144.3 KB0.0 KB/s6.3 KB23:59:24
5csiph.com10.1 KB0.0 KB10.1 KB0.0 KB/s2.0 KB23:59:11
6mb-net.net6.9 KB0.0 KB6.9 KB0.0 KB/s1.4 KB23:58:51
7news.redatomik.org5.6 KB0.0 KB5.6 KB0.0 KB/s1.4 KB23:58:41
8news-in.mixmin.net5.6 KB0.0 KB5.6 KB0.0 KB/s1.4 KB23:59:11
9eternal-september5.6 KB0.0 KB5.6 KB0.0 KB/s1.4 KB23:59:11
10aioe5.6 KB0.0 KB5.6 KB0.0 KB/s1.4 KB23:58:36
11newsfeed.datemas.de4.7 KB0.9 KB5.6 KB0.0 KB/s1.4 KB23:59:11
12news.swapon.de3.8 KB0.0 KB3.8 KB0.0 KB/s1.9 KB23:58:57
13news.albasani.net2.2 KB4.0 MB4.1 MB0.0 KB/s3.9 KB23:58:56
14news.snarked.org1.8 KB0.0 KB1.8 KB0.0 KB/s0.9 KB04:07:05
15neva.ru0.0 KB5.6 KB5.6 KB0.0 KB/s1.4 KB23:59:11
TOTAL: 1520.6 MB5.7 MB26.3 MB0.0 KB/s7.8 KB339:54:12
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 376 652623.9 MB 3538 2 1400:12:34
267-61-21-181.cpe.cableone.net 25 496017.5 MB 1263 0 002:42:41
3163.47.16.169 24 11851.6 MB 140 0 000:05:12
4news.bbs.geek.nz 1 54101.5 KB 11 2 000:19:03
567-61-218-236.cpe.cableone.net 6 23.2 KB 0 0 033:43:15
TOTAL: 5 432 1272743.2 MB 4952 4 1437:23:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 377 658024.0 MB 3549 4 1400:31:37
2*.cpe.cableone.net 31 496217.5 MB 1263 0 036:25:57
3unresolved 29 11851.6 MB 140 0 000:25:26
4*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:02
5*.binaryedge.ninja 1 00.0 KB 0 0 000:00:02
TOTAL: 5 440 1272743.2 MB 4952 4 1437:23:08

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 23
malcolmlewis 6
paulh 1
TOTAL: 4 54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.464 0.192 0.01633:43:15
67-61-21-181.cpe.cableone.net 3.780 1.924 0.09302:42:41
news.bbs.geek.nz 0.168 0.044 0.00200:19:03
agency.bbs.geek.nz 28.404 6.692 0.00000:12:34
118.149.152.102 0.112 0.020 0.00000:10:03
163.47.16.169 1.552 0.480 0.32100:05:12
118.149.188.63 0.060 0.012 0.00000:05:01
202.174.187.54 0.060 0.008 0.00000:05:01
203.118.151.117 0.084 0.012 0.00000:00:06
ip232.208-100-26.static.steadfastdns.net 0.104 0.012 0.00000:00:02
min-extra-grab-13-de-prod.binaryedge.ninja 0.044 0.016 0.00000:00:02
? 1.140 0.168 0.00000:00:02
TOTAL: 12 35.972 9.580 0.43237:23:08

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.152.102 2
ip232.208-100-26.static.steadfastdns.net 2
202.174.187.54 1
203.118.151.117 1
min-extra-grab-13-de-prod.binaryedge.ninja 1
118.149.188.63 1
TOTAL: 6 8

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 6027 47.4%
2comp 2652 20.8%
3alt 1331 10.5%
4sci 896 7.0%
5soc 629 4.9%
6misc 450 3.5%
7uk 232 1.8%
8news 211 1.7%
9talk 161 1.3%
10nz 77 0.6%
11humanities 36 0.3%
12aus 15 0.1%
13eternal-september 6 0.0%
14agency 2 0.0%
TOTAL: 14 12725100.0%

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

NewsgroupCount
1rec.arts.tv 1391
2comp.os.linux.advocacy 899
3alt.atheism 621
4rec.arts.drwho 618
5rec.food.cooking 594
6rec.sport.golf 425
7comp.lang.c 403
8rec.arts.sf.written 299
9misc.survivalism 279
10rec.gambling.poker 250
11uk.radio.amateur 218
12alt.comp.os.windows-10 213
13rec.sport.football.college 204
14comp.lang.python 196
15rec.boats 175
16sci.physics 172
17news.lists.filters 166
18soc.retirement 159
19rec.crafts.metalworking 142
20rec.sport.tennis 141
21rec.outdoors.rv-travel 138
22sci.electronics.design 126
23rec.sport.pro-wrestling 122
24comp.mobile.android 120
25rec.bicycles.tech 118
26sci.math 115
27rec.music.classical.recordings 112
28sci.military.naval 111
29sci.physics.relativity 110
30comp.sys.mac.advocacy 107
31rec.photo.digital 105
32alt.politics 105
33alt.bible 102
34rec.music.dylan 100
35rec.radio.shortwave 98
36rec.arts.sf.fandom 94
37comp.lang.c++ 86
38soc.culture.israel 70
39talk.politics.misc 70
40misc.health.alternative 69
41comp.os.linux.misc 68
42comp.arch 68
43nz.general 67
44talk.origins 66
45rec.arts.tv.uk.coronation-st 60
46sci.med.pharmacy 55
47alt.recovery.aa 54
48soc.culture.polish 54
49alt.test 54
50soc.penpals 53
51soc.culture.china 52
52comp.lang.ada 52
53comp.protocols.time.ntp 48
54rec.arts.comics.strips 48
55rec.music.rock-pop-r+b.1950s 47
56comp.soft-sys.sas 46
57sci.logic 46
58comp.sys.apple2 45
59rec.music.classical.guitar 44
60rec.puzzles.crosswords 41
61comp.lang.forth 40
62rec.arts.movies.current-films 37
63alt.support.diabetes 37
64rec.gambling.lottery 37
65rec.sport.soccer 35
66sci.astro.amateur 32
67soc.culture.vietnamese 32
68misc.phone.mobile.iphone 31
69comp.soft-sys.matlab 30
70rec.arts.disney.parks 30
71comp.lang.javascript 30
72humanities.lit.authors.shakespeare 30
73comp.soft-sys.math.scilab 30
74comp.lang.lisp 28
75comp.lang.tcl 28
76rec.woodworking 28
77soc.culture.indian 27
78comp.sys.acorn.apps 27
79comp.sys.apple2.programmer 27
80soc.culture.romanian 27
81alt.astronomy 26
82rec.audio.opinion 24
83rec.aviation.soaring 24
84rec.games.pinball 23
85alt.config 23
86sci.electronics.repair 23
87rec.games.backgammon 22
88rec.radio.amateur.dx 22
89rec.audio.pro 21
90soc.culture.brazil 20
91rec.drugs.cannabis 20
92alt.books.arthur-clarke 18
93rec.radio.amateur.misc 18
94soc.culture.singapore 18
95news.admin.net-abuse.email 18
96talk.politics.guns 18
97soc.culture.usa 18
98misc.news.internet.discuss 17
99comp.lang.xharbour 17
100sci.astro 16
TOTAL: 312 12725