news.bbs.geek.nz daily logs

Sep 28 23:58:02 -- Sep 29 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 65779 43.6%5.4 MB 24.6%
innd 30622 20.3%5.0 MB 23.0%
inn 29646 19.7%6.7 MB 30.5%
innfeed 23233 15.4%4.6 MB 20.8%
cnfsstat 1440 1.0%255.3 KB 1.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 150721 100.0%21.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 283732 47.7%
Positive hits 282874 47.6%
Do not exist 27806 4.7%
Cache misses 413 0.1%
TOTAL: 4 594825 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.455 0.0%237 0.000 1.920 17.500
article cleanup00:00:00.252 0.0%29020 0.000 0.009 0.033
article logging00:00:00.730 0.0%29465 0.000 0.025 0.077
article parse00:00:00.949 0.0%82373 0.000 0.012 0.031
article write00:00:01.577 0.0%22056 0.011 0.071 0.282
artlog/artcncl00:00:00.001 0.0%185 0.000 0.005 0.111
data move00:00:00.359 0.0%555599 0.000 0.001 0.011
hisgrep/artcncl00:00:00.004 0.0%233 0.000 0.017 1.000
hishave/artcncl00:00:00.001 0.0%237 0.000 0.004 0.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.465 0.0%596727 0.000 0.011 0.576
history sync00:00:00.015 0.0%363 0.000 0.041 0.500
history write00:00:06.100 0.0%27866 0.000 0.219 12.699
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:56:14.967 99.7%572472 96.404 150.531 390.981
nntp read00:00:03.311 0.0%575197 0.002 0.006 0.029
overview write00:00:35.293 0.0%22056 0.074 1.600 31.626
perl filter00:02:41.630 0.2%27866 1.376 5.800 362.054
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.484 0.0%44112 0.003 0.034 0.127
TOTAL: 24:00:51.95823:59:53.593 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.104 0.0%52299 0.000 0.002 0.020
article prepare00:00:00.002 0.0%12512 0.000 0.000 0.008
article read00:00:00.278 0.0%2900 0.000 0.096 4.259
backlog stats00:00:00.347 0.0%364730 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.845 0.0%301142 0.001 0.006 0.013
data write00:00:03.195 0.0%286863 0.006 0.011 0.022
idle23:52:31.142100.0%364730 88.577 235.657 585.360
status file00:00:09.419 0.0%1912 0.667 4.926 172.622
TOTAL: 23:53:06.95023:52:46.332100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle29:40:52.384 99.0%81641 0.000 1308.808 63217.129
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:46.522 0.1%195239 0.000 0.546 4.357
readart00:00:03.526 0.0%17382 0.000 0.203 46.394
TOTAL: 29:58:25.87329:42:42.432 99.1%----

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 45 20183 6028 13789 366 29%49:52:22
2newsfeed.datemas.de 2 23795 3972 19188 635 16%24:42:15
3news-out.mixmin.net 14 23806 2455 20498 853 10%29:42:43
4feeder.eternal-september.org 91 26936 2024 23856 1056 7%54:12:47
5news-out.aioe.org 4 21190 1933 19110 147 9%24:08:25
6newsfeed.neva.ru 149 17790 1788 13513 2489 10%85:45:01
7news.albasani.net 2 25320 1438 23359 523 5%25:09:14
8csiph.com 3 19360 964 18335 61 4%22:40:02
9news.redatomik.org 0 18611 930 17611 70 4%21:54:00
10news.samoylyk.net 2 27112 245 26294 573 0%24:46:21
11news.swapon.de 5 1532 155 1371 6 10%23:41:25
12feeder.awxg.com 1 18678 116 18485 77 0%23:59:57
13agency-nz-out.news.mb-net.net 15 27593 98 27329 166 0%34:22:26
14news.freedyn.net 3 24686 65 24540 81 0%24:35:30
15localhost 5 4 4 0 0 100%00:00:00
TOTAL: 15 341 296596 22215 267278 7103 7%469:32:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.7 MB548.2 KB2.1 MB26.3 MB 90%4.2 KB
2newsfeed.datemas.de15.3 MB1.7 MB4.1 MB21.1 MB 72%4.7 KB
3feeder.eternal-september.org8.6 MB807.2 KB6.1 MB15.6 MB 55%5.2 KB
4news-out.mixmin.net8.4 MB422.9 KB1.9 MB10.7 MB 78%3.3 KB
5news.albasani.net6.5 MB669.2 KB1.7 MB8.8 MB 73%4.6 KB
6newsfeed.neva.ru5.5 MB564.3 KB13.1 MB19.2 MB 28%4.6 KB
7news-out.aioe.org4.3 MB324.2 KB517.1 KB5.1 MB 83%2.5 KB
8csiph.com2.7 MB329.6 KB330.8 KB3.4 MB 80%3.4 KB
9news.redatomik.org2.5 MB462.5 KB470.0 KB3.4 MB 73%3.5 KB
10news.samoylyk.net1.6 MB917.3 KB11.9 MB14.4 MB 10%18.0 KB
11news.freedyn.net1.3 MB571.3 KB685.8 KB2.6 MB 51%17.9 KB
12agency-nz-out.news.mb-net.net464.8 KB887.4 KB1.6 MB3.0 MB 15%11.5 KB
13feeder.awxg.com459.1 KB235.4 KB241.1 KB935.7 KB 49%4.8 KB
14news.swapon.de435.5 KB12.7 KB163.7 KB611.9 KB 71%3.8 KB
15localhost4.3 KB0.0 KB0.0 KB4.3 KB100%1.1 KB
TOTAL: 1581.7 MB8.3 MB44.9 MB135.0 MB 60%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 23:58:02 - 23:59:59 32 0.1% 0.27102.7 KB 0.1% 0.87
Sep 29 00:00:00 - 00:59:59 852 3.9% 0.242.9 MB 3.6% 0.83
Sep 29 01:00:00 - 01:59:59 1070 4.9% 0.303.2 MB 3.9% 0.90
Sep 29 02:00:00 - 02:59:59 1196 5.4% 0.334.0 MB 5.0% 1.15
Sep 29 03:00:00 - 03:59:59 1248 5.7% 0.353.4 MB 4.2% 0.97
Sep 29 04:00:00 - 04:59:59 1167 5.3% 0.323.6 MB 4.5% 1.03
Sep 29 05:00:00 - 05:59:59 1341 6.1% 0.373.7 MB 4.5% 1.05
Sep 29 06:00:00 - 06:59:59 1271 5.8% 0.353.9 MB 4.8% 1.12
Sep 29 07:00:00 - 07:59:59 1218 5.5% 0.345.3 MB 6.5% 1.50
Sep 29 08:00:00 - 08:59:59 1169 5.3% 0.323.9 MB 4.8% 1.12
Sep 29 09:00:00 - 09:59:59 1051 4.8% 0.294.6 MB 5.7% 1.32
Sep 29 10:00:00 - 10:59:59 984 4.5% 0.274.0 MB 4.9% 1.12
Sep 29 11:00:00 - 11:59:59 892 4.0% 0.253.0 MB 3.7% 0.86
Sep 29 12:00:00 - 12:59:59 686 3.1% 0.192.9 MB 3.5% 0.81
Sep 29 13:00:00 - 13:59:59 487 2.2% 0.142.2 MB 2.8% 0.64
Sep 29 14:00:00 - 14:59:59 473 2.1% 0.132.5 MB 3.1% 0.72
Sep 29 15:00:00 - 15:59:59 449 2.0% 0.121.8 MB 2.2% 0.50
Sep 29 16:00:00 - 16:59:59 614 2.8% 0.173.0 MB 3.7% 0.86
Sep 29 17:00:00 - 17:59:59 606 2.7% 0.174.7 MB 5.7% 1.33
Sep 29 18:00:00 - 18:59:59 578 2.6% 0.162.5 MB 3.1% 0.72
Sep 29 19:00:00 - 19:59:59 550 2.5% 0.151.9 MB 2.4% 0.54
Sep 29 20:00:00 - 20:59:59 940 4.3% 0.263.2 MB 4.0% 0.91
Sep 29 21:00:00 - 21:59:59 1013 4.6% 0.283.9 MB 4.8% 1.10
Sep 29 22:00:00 - 22:59:59 1113 5.0% 0.313.4 MB 4.2% 0.97
Sep 29 23:00:00 - 23:58:01 1048 4.8% 0.303.6 MB 4.4% 1.04
TOTAL: 23:59:59 22048 100.0% 0.2681.2 MB 100.0% 0.96
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.4 GB 40.7% 0 0.35 1736.98
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.6 GB 47.2% 0 0.43 1423.56
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB252.1 MB 0.5% 0 0.0416842.60
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 GB9.1 GB 18.2% 0 0.78 781.23
TOTAL: 10-500.0 GB53.3 GB 10.7% 1 0.49-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2483 109 0 80 0 0 0 0 2294
2feeder.eternal-september.org 1037 0 0 140 0 0 0 0 897
3news-out.mixmin.net 967 0 0 97 0 0 0 0 870
4newsfeed.datemas.de 779 151 0 98 0 0 0 0 530
5news.albasani.net 567 5 0 98 0 0 0 0 464
6news.samoylyk.net 502 0 0 106 0 0 0 0 396
7news.snarked.org 368 44 0 86 0 0 0 0 238
8news-out.aioe.org 163 6 0 64 0 0 0 0 93
9agency-nz-out.news.mb-net.net 147 27 0 102 0 0 0 0 18
10news.redatomik.org 120 0 0 78 0 0 0 0 42
11feeder.awxg.com 86 1 0 80 0 0 0 0 5
12news.freedyn.net 82 3 0 52 0 0 0 0 27
13csiph.com 68 0 0 66 0 0 0 0 2
14news.swapon.de 35 0 0 7 0 0 0 0 28
15news.ausics.org 9 0 0 9 0 0 0 0 0
TOTAL: 15 7413 346 0 1163 0 0 0 0 5904

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 87
it.annunci.immobiliari 32
it.annunci.varie 28
mpc.lists.freebsd.ports.bugs 25
gmane.comp.gis.openstreetmap.tagging 20
mpc.lists.nanog 15
gmane.linux.kernel.renesas-soc 15
gmane.linux.kernel 12
mozilla.dev.security.policy 11
mpc.lists.freebsd.gecko 11
mozilla.dev.tech.js-engine.internals 8
mozilla.dev.platform 7
mpc.lists.freebsd.gnome 7
gmane.linux.alsa.devel 6
it.annunci.commerciali 6
mozilla.dev.ui-alerts 5
mozilla.support.seamonkey 5
mozilla.tools.taskcluster 5
bit.listserv.apar-l 4
mozilla.dev.media 3
TOTAL: 48 346

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4635
EMP (phn path) 366
EMP (phn nph) 256
Too many newsgroups 44
EMP (phl) 38
User-issued cancel 25
EMP (fsl) 20
Binary: non-binary distribution 20
Too many newsgroups (low_xpost) 18
HTML post 5
Binary: misplaced par2 4
Too many newsgroups (meow) 4
Binary Image: misplaced jpg 4
U2 violation - invalid distribution 3
Cancel for rejected article 2
Binary: misplaced sfv 1
Binary: misplaced 198 1
Binary: misplaced 074 1
Binary: misplaced 013 1
Binary: misplaced 064 1
TOTAL: 30 5459

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 152
news-out.mixmin.net 140
news.albasani.net 66
news.redatomik.org 38
news.swapon.de 25
news-out.aioe.org 7
newsfeed.neva.ru 6
feeder.eternal-september.org 3
feeder.awxg.com 3
news.samoylyk.net 3
TOTAL: 12 445
TOTAL: 1 445

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20275 1617 18561 97 0 0 7%23:59:45
2awxg 21490 84 21332 4 0 11 0%23:59:40
3news.snarked.org 43645 50 15759 13 0 23310 0%23:59:43
4news.freedyn.net 22508 10 21970 2 0 44 0%23:59:38
5news.redatomik.org 21119 7 20999 21 0 9 0%23:59:43
6news.albasani.net 22300 6 19339 1079 0 6847 0%23:59:43
7csiph.com 21098 5 20942 1 0 0 0%23:59:43
8aioe 18520 4 18368 0 0 11 0%23:59:34
9news.samoylyk.net 20173 4 20035 5 0 0 0%23:59:35
10news-in.mixmin.net 18906 3 18891 0 0 0 0%23:59:43
11eternal-september 19365 3 19113 0 0 111 0%23:59:43
12mb-net.net 22011 3 21914 1 0 1 0%23:59:42
13newsfeed.datemas.de 18130 3 18114 0 0 0 0%23:59:41
14neva.ru 19730 3 19721 1 0 0 0%23:59:43
15news.swapon.de 1554 0 1553 0 0 0 0%23:31:55
TOTAL: 15 310824 1802 276611 1224 0 30344 0%359:27:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org19.0 MB2.3 MB21.4 MB0.3 KB/s12.8 KB23:59:45
2awxg351.0 KB27.3 KB378.2 KB0.0 KB/s4.3 KB23:59:40
3news.snarked.org108.9 KB39.0 KB147.9 KB0.0 KB/s2.3 KB23:59:43
4news.redatomik.org37.9 KB417.0 KB454.9 KB0.0 KB/s16.2 KB23:59:43
5news.freedyn.net32.1 KB27.8 KB59.9 KB0.0 KB/s5.0 KB23:59:38
6news.albasani.net11.3 KB4.2 MB4.2 MB0.1 KB/s4.0 KB23:59:43
7csiph.com5.9 KB2.1 KB8.0 KB0.0 KB/s1.3 KB23:59:43
8aioe5.8 KB0.0 KB5.8 KB0.0 KB/s1.4 KB23:59:34
9news.samoylyk.net5.3 KB11.6 KB17.0 KB0.0 KB/s1.9 KB23:59:35
10news-in.mixmin.net3.4 KB0.0 KB3.4 KB0.0 KB/s1.1 KB23:59:43
11eternal-september3.4 KB0.0 KB3.4 KB0.0 KB/s1.1 KB23:59:43
12mb-net.net3.4 KB30.1 KB33.5 KB0.0 KB/s8.4 KB23:59:42
13newsfeed.datemas.de3.4 KB0.0 KB3.4 KB0.0 KB/s1.1 KB23:59:41
14neva.ru3.0 KB1.3 KB4.4 KB0.0 KB/s1.1 KB23:59:43
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:31:55
TOTAL: 1519.6 MB7.1 MB26.7 MB0.0 KB/s9.0 KB359:27:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 4 701424.5 MB 666 0 802:19:52
2agency.bbs.geek.nz 260 666322.6 MB 2605 4 000:08:09
3163.47.16.169 24 12911.9 MB 152 0 000:05:25
TOTAL: 3 288 1496849.0 MB 3423 4 829:58:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 4 701424.5 MB 666 0 829:29:51
2*.bbs.geek.nz 260 666322.6 MB 2605 4 000:08:09
3unresolved 36 12911.9 MB 152 0 000:20:18
TOTAL: 3 300 1496849.0 MB 3423 4 829:58:21

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 4
TOTAL: 2 28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.124 0.052 0.00327:09:58
67-61-21-181.cpe.cableone.net 0.940 0.780 0.01202:19:52
118.149.165.148 0.116 0.024 0.00000:10:02
agency.bbs.geek.nz 17.956 3.916 0.00000:08:09
163.47.16.169 1.408 0.372 0.41000:05:25
118.149.190.158 0.052 0.016 0.00000:03:56
164.52.0.134 0.408 0.060 0.00000:00:43
122.114.26.185 0.048 0.012 0.00000:00:10
? 0.988 0.076 0.00000:00:01
TOTAL: 9 22.040 5.308 0.42529:58:21

Curious NNRP server explorers [Top 20]:

SystemConn
164.52.0.134 8
118.149.165.148 2
122.114.26.185 1
118.149.190.158 1
TOTAL: 4 12

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
164.52.0.134 7
TOTAL: 1 7

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
À/À+À'À#À#023À 1
#026#003#001#001"#001 1
Ø a\x7f-ÈÉMÖƒ, #010˜_æ#035é 1
NICK vldbrezyt 1
@RSYNCD: 29 1
USER test +iw test :Test Wuz Here 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
164.52.0.134 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 7079 47.3%
2comp 1947 13.0%
3sci 1576 10.5%
4soc 1528 10.2%
5alt 1433 9.6%
6talk 453 3.0%
7misc 327 2.2%
8uk 252 1.7%
9news 174 1.2%
10aus 84 0.6%
11mozilla 53 0.4%
12nz 24 0.2%
13humanities 21 0.1%
14eternal-september 17 0.1%
TOTAL: 14 14968100.0%

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

NewsgroupCount
1rec.arts.tv 1459
2rec.sport.golf 756
3rec.food.cooking 557
4alt.atheism 470
5rec.arts.drwho 449
6comp.lang.c 381
7alt.comp.os.windows-10 380
8sci.physics.relativity 337
9rec.boats 332
10comp.os.linux.advocacy 328
11soc.retirement 314
12rec.sport.tennis 314
13sci.math 295
14rec.arts.sf.written 286
15rec.photo.digital 276
16comp.lang.python 275
17sci.electronics.design 272
18rec.sport.football.college 267
19rec.gambling.poker 263
20rec.sport.soccer 259
21uk.radio.amateur 245
22rec.sport.pro-wrestling 221
23sci.physics 214
24talk.politics.guns 196
25alt.bible 184
26misc.survivalism 151
27news.lists.filters 146
28rec.bicycles.tech 144
29soc.culture.israel 141
30soc.culture.polish 140
31soc.culture.china 124
32talk.origins 122
33rec.arts.sf.tv 122
34soc.culture.indian 115
35talk.politics.misc 112
36rec.autos.sport.f1 95
37rec.music.classical.recordings 93
38soc.culture.usa 87
39comp.lang.c++ 87
40soc.culture.singapore 87
41aus.computers 81
42misc.health.alternative 79
43rec.arts.sf.fandom 78
44alt.os.linux.ubuntu 75
45rec.aviation.soaring 74
46comp.mobile.android 71
47soc.culture.brazil 68
48rec.arts.movies.current-films 66
49rec.music.dylan 66
50soc.culture.romanian 65
51alt.politics 64
52comp.sys.mac.system 59
53comp.sys.acorn.misc 58
54sci.astro.amateur 58
55rec.sport.cricket 57
56comp.os.vms 56
57sci.military.naval 55
58sci.logic 55
59rec.games.video.sony 54
60comp.sys.mac.advocacy 51
61alt.recovery.aa 50
62alt.books.reviews 50
63soc.history.what-if 50
64comp.lang.forth 49
65comp.sys.mac.apps 47
66comp.sys.apple2 44
67rec.arts.movies.past-films 43
68sci.med.pharmacy 43
69rec.audio.opinion 42
70rec.aquaria.marine.misc 40
71misc.phone.mobile.iphone 40
72rec.games.trivia 38
73soc.culture.bulgaria 38
74alt.support.diabetes 36
75comp.sys.acorn.apps 33
76alt.test 32
77sci.lang 32
78comp.protocols.time.ntp 32
79rec.outdoors.rv-travel 32
80sci.electronics.repair 31
81comp.arch 30
82mozilla.general 30
83soc.culture.vietnamese 30
84sci.med.cardiology 28
85alt.astronomy 28
86rec.radio.amateur.dx 27
87rec.crafts.metalworking 26
88alt.tv.days-of-our-lives 25
89soc.history.medieval 25
90comp.lang.javascript 24
91rec.aviation.marketplace 24
92nz.general 23
93rec.gambling.lottery 23
94rec.radio.shortwave 22
95soc.penpals 22
96comp.soft-sys.sas 22
97rec.arts.disney.parks 22
98comp.soft-sys.math.scilab 20
99rec.radio.info 19
100comp.lang.awk 18
TOTAL: 346 14968