news.bbs.geek.nz daily logs

Dec 3 23:58:01 -- Dec 4 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 146194 62.6%12.0 MB 42.0%
innd 32355 13.9%5.2 MB 18.2%
inn 30363 13.0%6.6 MB 23.0%
innfeed 23141 9.9%4.5 MB 15.9%
cnfsstat 1440 0.6%250.1 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 233494 100.0%28.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 296169 50.3%
Positive hits 263388 44.8%
Do not exist 28550 4.9%
Cache misses 128 0.0%
TOTAL: 4 588235 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.517 0.0%126 0.000 4.103 24.118
article cleanup00:00:00.301 0.0%29507 0.000 0.010 0.030
article logging00:00:00.712 0.0%30248 0.000 0.024 0.074
article parse00:00:00.907 0.0%73524 0.000 0.012 0.034
article write00:00:01.848 0.0%20696 0.011 0.089 1.870
artlog/artcncl00:00:00.002 0.0%122 0.000 0.016 0.200
data move00:00:00.501 0.0%563090 0.000 0.001 0.027
hisgrep/artcncl00:00:00.230 0.0%120 0.000 1.917 13.353
hishave/artcncl00:00:00.120 0.0%126 0.000 0.952 7.059
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.716 0.0%591459 0.000 0.011 0.628
history sync00:00:00.014 0.0%344 0.000 0.041 1.000
history write00:00:07.472 0.0%28673 0.019 0.261 14.473
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:57:46.684 99.8%577329 89.538 149.424 399.480
nntp read00:00:03.431 0.0%579352 0.003 0.006 0.020
overview write00:00:42.094 0.0%20696 0.082 2.034 60.821
perl filter00:00:54.511 0.1%28673 1.401 1.901 5.529
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.344 0.0%41392 0.003 0.032 0.109
TOTAL: 24:00:44.88723:59:47.404 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.070 0.0%26739 0.000 0.003 0.021
article prepare00:00:00.002 0.0%8068 0.000 0.000 0.042
article read00:00:00.155 0.0%1757 0.000 0.088 6.100
backlog stats00:00:00.311 0.0%329266 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.664 0.0%276265 0.001 0.006 0.010
data write00:00:03.045 0.0%261020 0.006 0.012 0.020
idle23:54:07.576100.0%329266 157.255 261.331 641.452
status file00:00:07.682 0.0%1834 0.750 4.189 242.667
TOTAL: 23:54:34.93423:54:20.505100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle53:06:20.384 99.1%173365 0.000 1102.762 81618.215
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:06:23.069 0.2%400896 0.000 0.956 5.562
readart00:00:18.070 0.0%26366 0.000 0.685 4.375
TOTAL: 53:34:47.74353:13:01.523 99.3%----

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 49 16316 5177 10792 347 31%46:27:28
2news-out.mixmin.net 19 22669 3306 18147 1216 14%29:24:49
3feeder.eternal-september.org 39 24082 2245 20505 1332 9%32:55:01
4newsfeed.datemas.de 4 21926 2158 19195 573 9%25:15:53
5news-out.aioe.org 3 21253 2112 19064 77 9%26:56:14
6news.albasani.net 1 18475 1964 15888 623 10%19:48:08
7news.redatomik.org 1 20827 1655 19114 58 7%25:54:33
8newsfeed.neva.ru 147 13859 1022 9154 3683 7%79:30:41
9csiph.com 3 18678 491 18145 42 2%24:08:53
10feeder.awxg.com 2 16338 155 16142 41 0%23:59:52
11news.swapon.de 1 1914 151 1758 5 7%22:33:26
12news.freedyn.net 3 32584 110 32366 108 0%34:53:16
13news.samoylyk.net 1 25522 65 24971 486 0%23:59:55
14agency-nz-out.news.mb-net.net 14 20839 63 20652 124 0%27:38:08
15localhost 2 1 1 0 0 100%00:00:00
TOTAL: 15 289 275283 20675 245893 8715 7%443:26:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.0 MB217.4 KB1.3 MB18.4 MB 91%3.4 KB
2newsfeed.datemas.de13.0 MB1.1 MB2.4 MB16.4 MB 79%6.2 KB
3news-out.mixmin.net10.3 MB370.0 KB2.9 MB13.5 MB 76%3.1 KB
4feeder.eternal-september.org8.0 MB404.2 KB4.8 MB13.2 MB 60%3.8 KB
5news.albasani.net6.8 MB1.6 MB2.8 MB11.3 MB 60%4.5 KB
6news-out.aioe.org4.9 MB131.5 KB217.6 KB5.2 MB 93%2.4 KB
7news.redatomik.org3.7 MB1.6 MB1.7 MB7.0 MB 52%4.2 KB
8newsfeed.neva.ru2.9 MB262.5 KB11.0 MB14.1 MB 20%3.1 KB
9csiph.com1.4 MB163.9 KB169.2 KB1.7 MB 80%3.2 KB
10news.freedyn.net1.3 MB205.2 KB361.4 KB1.8 MB 69%8.5 KB
11feeder.awxg.com534.6 KB139.6 KB140.2 KB814.5 KB 65%4.2 KB
12news.swapon.de367.4 KB19.0 KB20.0 KB406.4 KB 90%2.6 KB
13news.samoylyk.net325.3 KB264.4 KB7.7 MB8.3 MB 3%15.4 KB
14agency-nz-out.news.mb-net.net263.7 KB175.4 KB503.0 KB942.1 KB 27%5.0 KB
15localhost0.7 KB0.0 KB0.0 KB0.7 KB100%0.7 KB
TOTAL: 1570.6 MB6.6 MB35.8 MB113.0 MB 62%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 3 23:58:01 - 23:59:59 27 0.1% 0.2357.9 KB 0.1% 0.49
Dec 4 00:00:00 - 00:59:59 783 3.8% 0.222.1 MB 3.0% 0.59
Dec 4 01:00:00 - 01:59:59 838 4.0% 0.232.5 MB 3.6% 0.71
Dec 4 02:00:00 - 02:59:59 964 4.7% 0.272.5 MB 3.6% 0.73
Dec 4 03:00:00 - 03:59:59 1072 5.2% 0.303.8 MB 5.5% 1.09
Dec 4 04:00:00 - 04:59:59 1196 5.8% 0.333.3 MB 4.6% 0.93
Dec 4 05:00:00 - 05:59:59 1222 5.9% 0.344.1 MB 5.9% 1.17
Dec 4 06:00:00 - 06:59:59 1162 5.6% 0.323.4 MB 4.9% 0.97
Dec 4 07:00:00 - 07:59:59 1387 6.7% 0.394.0 MB 5.7% 1.13
Dec 4 08:00:00 - 08:59:59 1214 5.9% 0.344.0 MB 5.7% 1.13
Dec 4 09:00:00 - 09:59:59 1121 5.4% 0.313.2 MB 4.5% 0.90
Dec 4 10:00:00 - 10:59:59 1022 4.9% 0.285.2 MB 7.4% 1.47
Dec 4 11:00:00 - 11:59:59 807 3.9% 0.222.5 MB 3.6% 0.71
Dec 4 12:00:00 - 12:59:59 824 4.0% 0.232.7 MB 3.8% 0.76
Dec 4 13:00:00 - 13:59:59 575 2.8% 0.162.0 MB 2.8% 0.57
Dec 4 14:00:00 - 14:59:59 546 2.6% 0.152.1 MB 3.1% 0.61
Dec 4 15:00:00 - 15:59:59 436 2.1% 0.122.0 MB 2.8% 0.56
Dec 4 16:00:00 - 16:59:59 478 2.3% 0.134.1 MB 5.9% 1.18
Dec 4 17:00:00 - 17:59:59 417 2.0% 0.121.5 MB 2.1% 0.43
Dec 4 18:00:00 - 18:59:59 480 2.3% 0.131.6 MB 2.3% 0.46
Dec 4 19:00:00 - 19:59:59 520 2.5% 0.142.1 MB 3.0% 0.61
Dec 4 20:00:00 - 20:59:59 611 3.0% 0.172.1 MB 3.0% 0.60
Dec 4 21:00:00 - 21:59:59 900 4.3% 0.252.9 MB 4.2% 0.84
Dec 4 22:00:00 - 22:59:59 1002 4.8% 0.282.9 MB 4.1% 0.82
Dec 4 23:00:00 - 23:58:02 1088 5.3% 0.313.4 MB 4.9% 1.01
TOTAL: 24:00:01 20692 100.0% 0.2470.2 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB21.9 GB 43.9% 0 0.28 2138.98
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.4 GB 50.9% 0 0.34 1789.17
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB274.0 MB 0.5% 0 0.0416000.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 GB12.8 GB 25.6% 0 0.75 810.85
TOTAL: 10-500.0 GB60.4 GB 12.1% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3700 48 0 66 0 0 0 0 3586
2feeder.eternal-september.org 1386 0 0 114 0 0 0 0 1272
3news-out.mixmin.net 1362 0 0 91 0 0 0 0 1271
4news.albasani.net 851 10 0 59 0 0 0 0 782
5newsfeed.datemas.de 683 191 0 67 0 0 0 0 425
6news.samoylyk.net 484 0 0 86 0 0 0 0 398
7news.snarked.org 340 60 0 62 0 0 0 0 218
8news.redatomik.org 280 0 0 47 0 0 0 0 233
9agency-nz-out.news.mb-net.net 156 32 0 62 0 0 0 0 62
10news-out.aioe.org 89 19 0 39 0 0 0 0 31
11news.freedyn.net 85 12 0 50 0 0 0 0 23
12feeder.awxg.com 48 1 0 45 0 0 0 0 2
13csiph.com 44 0 0 41 0 0 0 0 3
14news.swapon.de 40 0 0 4 0 0 0 0 36
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 9550 373 0 835 0 0 0 0 8342

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 49
it.annunci.commerciali 38
mozilla.support.seamonkey 38
it.annunci.varie 37
gmane.linux.alsa.devel 37
it.annunci.immobiliari 36
nemo.bavardages 26
mpc.lists.nanog 17
ut.test 16
mozilla.test 11
gmane.linux.kernel 7
gmane.linux.kernel.stable 5
mpc.lists.freebsd.gecko 4
gmane.comp.gis.openstreetmap.legal 4
south-wales.test 3
mozilla.dev.ui-alerts 3
mozilla.dev.tech.layout 3
mpc.lists.freebsd.office 3
gmane.linux.drivers.devicetree 2
gmane.linux.ports.arm.kernel 2
TOTAL: 45 373

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6905
EMP (phn path) 575
Too many newsgroups 41
User-issued cancel 29
User-issued spam cancel 18
EMP (phn nph) 14
HTML post 11
Cancel for rejected article 3
Binary Image: misplaced jpg 2
U2 violation - invalid distribution 1
HTML file attachment 1
Too many newsgroups (low_xpost) 1
Binary: non-binary distribution 1
Binary: misplaced 002 1
TOTAL: 14 7603

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 227
news.albasani.net 175
news-out.mixmin.net 174
newsfeed.datemas.de 101
news.swapon.de 35
news-out.aioe.org 16
newsfeed.neva.ru 3
feeder.awxg.com 2
news.snarked.org 2
agency-nz-out.news.mb-net.net 2
TOTAL: 12 739
TOTAL: 1 739

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18520 686 17753 79 2 0 3%23:59:50
2awxg 20277 150 20096 6 0 8 0%23:59:50
3csiph.com 20830 25 20141 0 0 17 0%23:59:50
4aioe 17461 14 17341 0 0 0 0%23:59:50
5news.snarked.org 15347 6 15217 7 0 38 0%23:59:50
6news.freedyn.net 20690 3 20615 1 0 1 0%23:59:50
7news.redatomik.org 19157 3 19119 0 0 0 0%23:59:50
8news.samoylyk.net 18498 2 18451 0 0 0 0%23:59:44
9eternal-september 17771 2 17734 0 0 0 0%23:59:48
10neva.ru 19406 2 19398 0 0 0 0%23:59:50
11news.albasani.net 20342 2 17444 927 2 5963 0%23:59:50
12news-in.mixmin.net 16445 1 16434 0 0 0 0%23:59:50
13mb-net.net 20635 1 20580 0 0 137 0%23:59:50
14newsfeed.datemas.de 18459 1 18435 0 0 124 0%23:59:50
15news.swapon.de 1924 0 1924 0 0 0 0%23:50:51
TOTAL: 15 265762 898 260682 1020 4 6288 0%359:48:23
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.8 MB5.1 MB9.9 MB0.1 KB/s13.2 KB23:59:50
2awxg634.3 KB30.3 KB664.6 KB0.0 KB/s4.3 KB23:59:50
3csiph.com54.7 KB0.0 KB54.7 KB0.0 KB/s2.2 KB23:59:50
4aioe42.4 KB0.0 KB42.4 KB0.0 KB/s3.0 KB23:59:50
5news.snarked.org9.6 KB12.8 KB22.4 KB0.0 KB/s1.7 KB23:59:50
6news.freedyn.net7.7 KB7.1 KB14.8 KB0.0 KB/s3.7 KB23:59:50
7news.redatomik.org5.4 KB0.0 KB5.4 KB0.0 KB/s1.8 KB23:59:50
8news.albasani.net3.1 KB3.9 MB3.9 MB0.0 KB/s4.3 KB23:59:50
9news.samoylyk.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:44
10eternal-september2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:48
11neva.ru2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:50
12news-in.mixmin.net0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:59:50
13mb-net.net0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:59:50
14newsfeed.datemas.de0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:59:50
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:51
TOTAL: 155.5 MB9.1 MB14.6 MB0.0 KB/s7.8 KB359:48:23
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 1821475.9 MB 853 0 1603:45:42
2agency.bbs.geek.nz 385 673623.8 MB 3995 1 000:13:44
3103.39.238.13 24 9371.2 MB 149 0 000:05:04
467-60-219-146.cpe.cableone.net 1 11.0 KB 0 0 049:07:47
560.234.244.55 2 11.6 KB 1 0 000:02:10
TOTAL: 5 420 25889100.9 MB 4998 1 1653:34:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 9 1821575.9 MB 853 0 1652:53:30
2*.bbs.geek.nz 385 673623.8 MB 3995 1 000:13:44
3unresolved 31 9381.2 MB 150 0 000:27:23
TOTAL: 3 425 25889100.9 MB 4998 1 1653:34:40

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 2
malcolmlewis 1
TOTAL: 4 35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.188 0.080 0.00349:07:47
67-61-21-181.cpe.cableone.net 1.624 2.392 0.02403:45:42
agency.bbs.geek.nz 27.832 6.984 0.00000:13:44
118.149.141.177 0.132 0.008 0.00000:10:03
118.149.234.160 0.120 0.016 0.00000:10:03
103.39.238.13 1.404 0.364 0.18300:05:04
60.234.244.55 0.140 0.012 0.00600:02:10
94.160.216.141 0.048 0.012 0.00000:00:02
? 1.368 0.176 0.00000:00:02
TOTAL: 9 32.856 10.044 0.21653:34:40

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.234.160 2
118.149.141.177 2
94.160.216.141 1
TOTAL: 3 5

NNRP gethostbyaddr failures [Top 20]:

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

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 8782 33.9%
2linux 2799 10.8%
3soc 2779 10.7%
4sci 2586 10.0%
5uk 2528 9.8%
6talk 2071 8.0%
7alt 1758 6.8%
8comp 1297 5.0%
9news 414 1.6%
10misc 410 1.6%
11mozilla 323 1.2%
12humanities 54 0.2%
13microsoft 29 0.1%
14aus 25 0.1%
15nz 16 0.1%
16us 8 0.0%
17eternal-september 8 0.0%
18agency 1 0.0%
TOTAL: 18 25888100.0%

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

NewsgroupCount
1rec.arts.tv 1868
2uk.d-i-y 939
3talk.origins 833
4linux.debian.bugs.dist 801
5talk.politics.guns 725
6uk.legal 722
7rec.sport.football.college 702
8rec.arts.drwho 689
9rec.food.cooking 661
10soc.retirement 633
11sci.electronics.design 514
12sci.physics 469
13alt.atheism 442
14rec.sport.tennis 420
15linux.debian.changes.devel 397
16alt.comp.os.windows-10 396
17talk.politics.misc 366
18news.lists.filters 364
19uk.radio.amateur 359
20sci.math 350
21soc.culture.israel 334
22alt.fan.rush-limbaugh 325
23rec.sport.pro-wrestling 320
24rec.arts.sf.written 305
25rec.boats 292
26linux.debian.bugs.rc 282
27sci.physics.relativity 280
28linux.debian.devel.release 262
29soc.culture.polish 250
30soc.culture.usa 246
31rec.sport.soccer 212
32rec.sport.golf 204
33sci.military.naval 182
34sci.med.cardiology 167
35soc.culture.indian 167
36mozilla.general 166
37rec.outdoors.rv-travel 164
38soc.culture.china 161
39rec.music.classical.recordings 158
40rec.crafts.metalworking 157
41sci.logic 156
42comp.lang.c 155
43rec.aviation.soaring 154
44comp.sys.mac.apps 149
45linux.debian.user 149
46rec.gambling.poker 149
47rec.bicycles.tech 134
48misc.survivalism 134
49rec.radio.shortwave 133
50comp.lang.python 123
51linux.debian.devel 106
52mozilla.support.firefox 103
53rec.arts.sf.fandom 102
54linux.gentoo.user 100
55rec.arts.sf.tv 100
56soc.genealogy.medieval 100
57linux.debian.maint.boot 98
58soc.culture.singapore 97
59comp.os.linux.advocacy 96
60alt.politics.trump 95
61alt.test 95
62rec.skiing.alpine 91
63alt.politics 87
64uk.rec.cycling 87
65rec.sport.cricket 84
66soc.culture.vietnamese 84
67uk.comp.sys.mac 84
68rec.woodworking 82
69misc.health.alternative 78
70sci.astro.amateur 77
71linux.gentoo.dev 76
72comp.sys.mac.advocacy 76
73comp.sys.apple2 75
74rec.arts.movies.current-films 75
75uk.comp.homebuilt 74
76linux.debian.kernel 74
77rec.drugs.cannabis 74
78talk.rape 73
79uk.tech.digital-tv 71
80comp.lang.c++ 70
81rec.arts.movies.past-films 68
82rec.audio.opinion 66
83sci.electronics.basics 64
84rec.games.pinball 63
85soc.culture.brazil 60
86rec.photo.digital 59
87soc.culture.greek 55
88mozilla.support.thunderbird 54
89rec.radio.info 54
90uk.rec.driving 53
91comp.sys.mac.system 53
92sci.space.policy 52
93alt.recovery.aa 50
94rec.autos.sport.f1 49
95rec.music.rock-pop-r+b.1950s 46
96humanities.lit.authors.shakespeare 46
97soc.genealogy.benelux 46
98linux.debian.user.french 46
99rec.arts.tv.uk.coronation-st 46
100rec.radio.amateur.misc 45
TOTAL: 514 25888