news.bbs.geek.nz daily logs

Sep 21 23:58:01 -- Sep 22 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 107688 53.4%8.8 MB 33.4%
innd 33109 16.4%5.4 MB 20.6%
inn 31731 15.7%6.9 MB 26.2%
innfeed 27615 13.7%4.9 MB 18.8%
cnfsstat 1440 0.7%250.2 KB 0.9%
controlchan 5 0.0%0.6 KB 0.0%
TOTAL: 6 201588 100.0%26.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 290896 48.1%
Positive hits 283459 46.9%
Do not exist 29843 4.9%
Cache misses 225 0.0%
TOTAL: 4 604423 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.351 0.0%226 0.000 1.553 15.500
article cleanup00:00:00.295 0.0%31039 0.000 0.010 0.032
article logging00:00:00.774 0.0%31571 0.000 0.025 0.062
article parse00:00:01.052 0.0%87749 0.003 0.012 0.033
article write00:00:01.649 0.0%21826 0.018 0.076 0.601
artlog/artcncl00:00:00.001 0.0%222 0.000 0.005 0.500
data move00:00:00.385 0.0%567030 0.000 0.001 0.006
hisgrep/artcncl00:00:00.002 0.0%139 0.000 0.014 0.500
hishave/artcncl00:00:00.000 0.0%226 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.825 0.0%613133 0.001 0.011 1.015
history sync00:00:00.011 0.0%356 0.000 0.031 0.500
history write00:00:05.974 0.0%30136 0.017 0.198 17.412
hiswrite/artcncl00:00:00.001 0.0%87 0.000 0.011 0.012
idle23:57:46.454 99.8%591529 85.918 145.836 380.935
nntp read00:00:03.511 0.0%593778 0.003 0.006 0.018
overview write00:00:36.425 0.0%21826 0.047 1.669 44.944
perl filter00:01:02.964 0.1%30136 1.495 2.089 3.984
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.632 0.0%43653 0.006 0.037 0.114
TOTAL: 24:00:49.32323:59:48.306 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.097 0.0%40915 0.000 0.002 0.022
article prepare00:00:00.002 0.0%11682 0.000 0.000 0.023
article read00:00:00.259 0.0%2618 0.000 0.099 3.152
backlog stats00:00:00.326 0.0%348896 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.702 0.0%287303 0.002 0.006 0.013
data write00:00:03.153 0.0%274953 0.006 0.011 0.021
idle23:53:00.115 99.9%348896 122.711 246.435 564.939
status file00:00:22.473 0.0%3577 0.727 6.283 434.250
TOTAL: 23:53:48.58323:53:28.127100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%8 0.000 0.000 0.000
idle13:26:45.321 94.8%120941 0.000 400.239 95773.681
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:53.873 0.1%271332 0.000 0.199 1.860
readart00:00:04.284 0.0%14732 0.000 0.291 36.588
TOTAL: 14:10:40.12313:27:43.478 95.0%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 42 20012 6333 13165 514 31%44:51:19
2newsfeed.datemas.de 2 23489 2412 20594 483 10%24:23:10
3news-out.mixmin.net 17 23544 2349 20519 676 9%29:55:58
4news-out.aioe.org 1 19676 2247 17366 63 11%22:48:53
5news.redatomik.org 1 21252 1988 18791 473 9%23:42:36
6news.albasani.net 1 22169 1820 19916 433 8%23:19:01
7feeder.eternal-september.org 98 26720 1798 23394 1528 6%55:55:15
8newsfeed.neva.ru 143 19576 1440 14159 3977 7%86:11:15
9csiph.com 4 21457 502 20918 37 2%25:08:54
10news.samoylyk.net 3 37275 278 36276 721 0%32:55:46
11news.swapon.de 5 2982 258 2717 7 8%41:01:32
12feeder.awxg.com 1 19297 123 19129 45 0%23:59:56
13news.freedyn.net 2 23778 111 23546 121 0%23:36:09
14agency-nz-out.news.mb-net.net 18 27224 107 26975 142 0%33:57:11
15localhost 10 9 8 0 1 88%00:00:00
TOTAL: 15 348 308460 21774 277465 9221 7%491:46:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org22.1 MB388.4 KB2.4 MB24.9 MB 88%3.7 KB
2newsfeed.datemas.de9.6 MB1.4 MB3.9 MB14.9 MB 64%5.3 KB
3feeder.eternal-september.org8.5 MB552.5 KB9.8 MB18.8 MB 45%5.8 KB
4news-out.mixmin.net7.7 MB308.8 KB1.5 MB9.5 MB 81%3.2 KB
5news.albasani.net6.6 MB988.5 KB2.4 MB9.9 MB 66%4.5 KB
6news-out.aioe.org5.7 MB109.3 KB187.0 KB5.9 MB 95%2.6 KB
7news.redatomik.org5.2 MB432.8 KB1.3 MB6.9 MB 74%2.9 KB
8newsfeed.neva.ru4.0 MB266.6 KB19.1 MB23.4 MB 17%4.4 KB
9csiph.com1.4 MB96.9 KB98.0 KB1.6 MB 88%3.1 KB
10news.samoylyk.net1.2 MB1.6 MB10.4 MB13.2 MB 9%13.5 KB
11news.freedyn.net965.6 KB1.3 MB1.7 MB3.9 MB 23%17.4 KB
12news.swapon.de651.0 KB16.1 KB84.0 KB751.1 KB 86%2.8 KB
13feeder.awxg.com405.1 KB194.0 KB202.2 KB801.3 KB 50%4.8 KB
14agency-nz-out.news.mb-net.net230.0 KB451.3 KB1.9 MB2.6 MB 8%10.7 KB
15localhost21.9 KB0.0 KB2.2 KB24.1 KB 90%2.7 KB
TOTAL: 1574.2 MB8.1 MB54.9 MB137.1 MB 54%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 21 23:58:01 - 23:59:59 36 0.2% 0.3093.0 KB 0.1% 0.78
Sep 22 00:00:00 - 00:59:59 1139 5.2% 0.323.1 MB 4.2% 0.88
Sep 22 01:00:00 - 01:59:59 1097 5.0% 0.303.7 MB 5.0% 1.06
Sep 22 02:00:00 - 02:59:59 1295 5.9% 0.363.8 MB 5.1% 1.08
Sep 22 03:00:00 - 03:59:59 1323 6.1% 0.374.5 MB 6.1% 1.29
Sep 22 04:00:00 - 04:59:59 1250 5.7% 0.353.6 MB 4.9% 1.02
Sep 22 05:00:00 - 05:59:59 1438 6.6% 0.405.2 MB 7.0% 1.48
Sep 22 06:00:00 - 06:59:59 1132 5.2% 0.314.2 MB 5.6% 1.19
Sep 22 07:00:00 - 07:59:59 966 4.4% 0.272.7 MB 3.7% 0.78
Sep 22 08:00:00 - 08:59:59 1099 5.0% 0.314.4 MB 6.0% 1.26
Sep 22 09:00:00 - 09:59:59 1078 4.9% 0.303.9 MB 5.2% 1.11
Sep 22 10:00:00 - 10:59:59 889 4.1% 0.254.4 MB 5.9% 1.24
Sep 22 11:00:00 - 11:59:59 668 3.1% 0.192.4 MB 3.2% 0.68
Sep 22 12:00:00 - 12:59:59 539 2.5% 0.152.2 MB 3.0% 0.63
Sep 22 13:00:00 - 13:59:59 506 2.3% 0.142.0 MB 2.8% 0.58
Sep 22 14:00:00 - 14:59:59 444 2.0% 0.122.0 MB 2.8% 0.58
Sep 22 15:00:00 - 15:59:59 477 2.2% 0.132.2 MB 3.0% 0.63
Sep 22 16:00:00 - 16:59:59 526 2.4% 0.152.2 MB 3.0% 0.64
Sep 22 17:00:00 - 17:59:59 483 2.2% 0.131.5 MB 2.1% 0.43
Sep 22 18:00:00 - 18:59:59 663 3.0% 0.182.1 MB 2.9% 0.61
Sep 22 19:00:00 - 19:59:59 790 3.6% 0.222.2 MB 2.9% 0.62
Sep 22 20:00:00 - 20:59:59 939 4.3% 0.262.8 MB 3.8% 0.81
Sep 22 21:00:00 - 21:59:59 1020 4.7% 0.283.2 MB 4.4% 0.92
Sep 22 22:00:00 - 22:59:59 1033 4.7% 0.292.9 MB 3.9% 0.82
Sep 22 23:00:00 - 23:58:02 975 4.5% 0.282.5 MB 3.4% 0.74
TOTAL: 24:00:01 21805 100.0% 0.2574.1 MB 100.0% 0.88
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.2 GB 40.4% 0 0.34 1806.67
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.4 GB 46.8% 0 0.36 1687.40
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB249.2 MB 0.5% 0 0.07 8707.48
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 GB8.7 GB 17.4% 0 0.73 829.12
TOTAL: 10-500.0 GB52.5 GB 10.5% 1 0.47-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3974 70 0 56 1 0 0 0 3847
2feeder.eternal-september.org 1534 0 0 130 0 0 0 0 1404
3news-out.mixmin.net 773 0 0 81 0 0 0 0 692
4news.redatomik.org 644 0 0 68 0 0 0 0 576
5news.samoylyk.net 627 0 0 70 0 0 0 0 557
6news.albasani.net 602 6 0 73 0 0 0 0 523
7newsfeed.datemas.de 562 197 0 75 0 0 0 0 290
8news.snarked.org 520 56 0 74 0 0 0 0 390
9agency-nz-out.news.mb-net.net 135 29 0 63 0 0 0 0 43
10news.freedyn.net 125 5 0 58 0 0 0 0 62
11news-out.aioe.org 76 27 0 40 0 0 0 0 9
12feeder.awxg.com 55 1 0 52 0 0 0 0 2
13csiph.com 45 0 0 43 0 0 0 0 2
14news.swapon.de 30 0 0 5 0 0 0 0 25
15news.ausics.org 1 0 0 1 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 9704 391 0 889 1 0 0 0 8423

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.commerciali 56
it.annunci.immobiliari 53
it.annunci.varie 41
ut.test 26
mpc.lists.freebsd.ports.bugs 25
mpc.lists.nanog 22
gmane.linux.kernel 18
gmane.linux.alsa.devel 16
mozilla.dev.platform 14
mozilla.dev.security.policy 12
gmane.comp.gis.openstreetmap.tagging 11
mpc.lists.freebsd.x11 9
mozilla.dev.l10n 7
mpc.lists.freebsd.gnome 6
mozilla.governance 6
mpc.lists.freebsd.office 6
ab.test 6
mozilla.dev.l10n.sr 5
mozilla.support.seamonkey 5
mozilla.dev.ui-alerts 5
TOTAL: 43 391

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6883
EMP (phn path) 482
EMP (phn nph) 301
Binary Image: misplaced jpg 116
Too many newsgroups 39
Binary: non-binary distribution 23
User-issued cancel 14
EMP (phl) 12
Too many newsgroups (low_xpost) 8
Cancel for rejected article 4
HTML post 3
TOTAL: 11 7885

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 169
news.albasani.net 139
news-out.mixmin.net 109
newsfeed.datemas.de 75
news.swapon.de 24
news-out.aioe.org 8
newsfeed.neva.ru 6
news.samoylyk.net 3
feeder.eternal-september.org 2
news.snarked.org 2
TOTAL: 11 538
TOTAL: 1 538

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20136 1385 18693 57 1 1 6%23:59:46
2awxg 21245 125 21097 3 0 17 0%23:59:46
3news.freedyn.net 22089 25 21667 2 0 68 0%23:59:46
4news.snarked.org 29071 16 15123 0 0 10473 0%23:59:46
5csiph.com 21493 10 21208 0 0 16 0%23:59:38
6news.redatomik.org 19599 8 19580 1 0 5 0%23:59:46
7news.samoylyk.net 19963 8 19926 0 0 0 0%23:59:38
8news-in.mixmin.net 18742 8 18728 0 0 0 0%23:59:44
9neva.ru 19828 6 19817 2 0 0 0%23:59:46
10mb-net.net 17082 4 16313 2 0 6032 0%23:59:46
11news.albasani.net 21601 4 18584 1131 0 7192 0%23:59:46
12aioe 17923 3 17781 5 0 0 0%23:59:39
13eternal-september 19067 2 18955 1 0 270 0%23:59:46
14newsfeed.datemas.de 19322 1 19214 0 0 479 0%23:59:46
15news.swapon.de 1589 0 1589 0 0 0 0%23:51:02
TOTAL: 15 288750 1605 268275 1204 1 24553 0%359:47:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.1 MB1.8 MB13.9 MB0.2 KB/s9.9 KB23:59:46
2awxg633.3 KB15.8 KB649.0 KB0.0 KB/s5.1 KB23:59:46
3news.freedyn.net78.6 KB8.2 KB86.8 KB0.0 KB/s3.2 KB23:59:46
4news.snarked.org36.0 KB0.0 KB36.0 KB0.0 KB/s2.2 KB23:59:46
5csiph.com25.5 KB0.0 KB25.5 KB0.0 KB/s2.6 KB23:59:38
6news.redatomik.org21.9 KB2.9 KB24.9 KB0.0 KB/s2.8 KB23:59:46
7news.samoylyk.net21.9 KB0.0 KB21.9 KB0.0 KB/s2.7 KB23:59:38
8news-in.mixmin.net21.9 KB0.0 KB21.9 KB0.0 KB/s2.7 KB23:59:44
9neva.ru15.3 KB6.6 KB21.9 KB0.0 KB/s2.7 KB23:59:46
10news.albasani.net11.1 KB4.2 MB4.3 MB0.1 KB/s3.8 KB23:59:46
11mb-net.net10.2 KB6.9 KB17.1 KB0.0 KB/s2.9 KB23:59:46
12eternal-september6.7 KB4.4 KB11.1 KB0.0 KB/s3.7 KB23:59:46
13aioe6.7 KB15.3 KB21.9 KB0.0 KB/s2.7 KB23:59:39
14newsfeed.datemas.de4.4 KB0.0 KB4.4 KB0.0 KB/s4.4 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:02
TOTAL: 1513.0 MB6.1 MB19.0 MB0.0 KB/s6.9 KB359:47:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 344 648723.2 MB 3358 0 000:11:26
267-61-21-181.cpe.cableone.net 7 624822.3 MB 757 3 1401:45:23
3163.47.16.169 24 8771.2 MB 123 0 000:04:20
460.234.244.55 20 2270.9 KB 4 5 001:08:17
TOTAL: 4 395 1363446.8 MB 4242 8 1414:10:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 344 648723.2 MB 3358 0 000:11:26
2*.cpe.cableone.net 9 624822.3 MB 757 3 1412:04:26
3unresolved 53 8991.3 MB 127 5 001:54:37
TOTAL: 3 406 1363446.8 MB 4242 8 1414:10:33

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 18
bpanther 7
malcolmlewis 2
TOTAL: 4 51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.104 0.060 0.00610:19:03
67-61-21-181.cpe.cableone.net 1.316 0.816 0.02101:45:23
60.234.244.55 1.312 0.192 0.05301:08:17
118.149.232.166 0.372 0.040 0.00000:31:46
agency.bbs.geek.nz 25.256 5.476 0.00000:11:26
118.149.168.50 0.112 0.024 0.00000:10:02
163.47.16.169 1.388 0.336 0.47700:04:20
45.55.10.148 0.048 0.012 0.00000:00:09
? 1.676 0.192 0.00000:00:02
TOTAL: 9 31.584 7.148 0.55714:10:33

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.232.166 6
67-60-219-146.cpe.cableone.net 2
118.149.168.50 2
45.55.10.148 1
TOTAL: 4 11

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 4
TOTAL: 1 4

Newsgroup request counts (by category):

CategoryCountPct
1rec 5531 40.6%
2sci 2071 15.2%
3comp 1844 13.5%
4soc 1525 11.2%
5alt 1010 7.4%
6talk 701 5.1%
7misc 340 2.5%
8news 206 1.5%
9uk 172 1.3%
10nz 71 0.5%
11aus 48 0.4%
12humanities 46 0.3%
13mozilla 30 0.2%
14eternal-september 17 0.1%
15agency 14 0.1%
TOTAL: 15 13626100.0%

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

NewsgroupCount
1rec.arts.tv 1148
2comp.os.linux.advocacy 621
3rec.food.cooking 574
4sci.math 441
5alt.atheism 431
6comp.lang.python 411
7rec.arts.sf.written 408
8soc.retirement 370
9rec.sport.tennis 337
10sci.physics 334
11sci.physics.relativity 318
12sci.electronics.design 296
13talk.politics.guns 289
14rec.boats 281
15rec.sport.football.college 262
16rec.sport.golf 261
17talk.origins 259
18soc.culture.polish 225
19soc.culture.israel 171
20rec.autos.tech 163
21news.lists.filters 161
22alt.comp.os.windows-10 159
23rec.sport.pro-wrestling 145
24misc.survivalism 142
25rec.arts.drwho 121
26alt.test 117
27sci.military.naval 114
28rec.photo.digital 112
29talk.politics.misc 112
30soc.culture.usa 103
31rec.bicycles.tech 103
32rec.arts.sf.tv 103
33sci.electronics.repair 100
34soc.culture.vietnamese 94
35soc.culture.china 91
36sci.med.pharmacy 87
37alt.bible 87
38soc.culture.indian 80
39sci.logic 79
40rec.sport.soccer 78
41misc.health.alternative 78
42rec.autos.sport.f1 78
43uk.radio.amateur 76
44comp.lang.c 75
45rec.arts.movies.current-films 73
46nz.general 70
47rec.music.dylan 67
48rec.gambling.poker 66
49soc.culture.singapore 65
50rec.radio.shortwave 65
51uk.tech.broadcast 62
52alt.politics 62
53rec.aviation.soaring 60
54rec.aquaria.marine.misc 60
55sci.astro.amateur 57
56comp.sys.apple2 57
57sci.math.num-analysis 54
58rec.crafts.metalworking 53
59comp.protocols.time.ntp 48
60comp.os.vms 47
61misc.phone.mobile.iphone 45
62rec.music.classical.guitar 45
63aus.computers 44
64humanities.lit.authors.shakespeare 44
65alt.recovery.aa 44
66soc.culture.brazil 44
67comp.lang.c++ 44
68soc.history.what-if 43
69rec.arts.sf.fandom 42
70soc.genealogy.medieval 41
71rec.games.pinball 37
72rec.audio.pro 36
73rec.puzzles.crosswords 36
74comp.sys.mac.advocacy 36
75comp.arch 36
76comp.soft-sys.math.scilab 34
77sci.energy 34
78comp.soft-sys.sas 34
79misc.invest.stocks 32
80comp.sys.raspberry-pi 32
81soc.penpals 32
82rec.games.backgammon 31
83rec.antiques.radio+phono 30
84rec.radio.amateur.misc 30
85rec.sport.cricket 30
86alt.support.diabetes 29
87rec.outdoors.rv-travel 28
88rec.sport.rowing 27
89rec.audio.opinion 26
90talk.euthanasia 26
91rec.music.classical.recordings 25
92news.answers 24
93rec.games.trivia 24
94comp.text.tex 23
95comp.lang.fortran 23
96uk.comp.os.linux 22
97soc.culture.romanian 22
98rec.games.video.sony 21
99rec.sport.rugby.league 21
100comp.programming 20
TOTAL: 327 13626