news.bbs.geek.nz daily logs

Jan 5 23:58:01 -- Jan 6 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 157047 64.5%13.1 MB 44.4%
innd 32299 13.3%5.2 MB 17.7%
inn 29469 12.1%6.4 MB 21.9%
innfeed 23109 9.5%4.4 MB 15.1%
cnfsstat 1440 0.6%252.6 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 243365 100.0%29.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 271085 48.0%
Positive hits 261148 46.2%
Do not exist 27900 4.9%
Cache misses 4826 0.9%
TOTAL: 4 564959 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.142 0.0%84 0.000 1.690 14.000
article cleanup00:00:00.233 0.0%28780 0.000 0.008 0.027
article logging00:00:00.799 0.0%29410 0.000 0.027 0.652
article parse00:00:00.918 0.0%81443 0.000 0.011 0.039
article write00:00:01.767 0.0%20538 0.011 0.086 2.225
artlog/artcncl00:00:00.002 0.0%83 0.000 0.024 0.125
data move00:00:00.373 0.0%551405 0.000 0.001 0.005
hisgrep/artcncl00:00:00.002 0.0%77 0.000 0.026 1.000
hishave/artcncl00:00:00.000 0.0%84 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.967 0.0%568963 0.001 0.010 0.767
history sync00:00:00.172 0.0%366 0.000 0.470 39.750
history write00:00:07.783 0.0%28082 0.017 0.277 24.295
hiswrite/artcncl00:00:00.001 0.0%7 0.000 0.143 0.500
idle23:57:54.619 99.8%566088 75.034 152.405 385.643
nntp read00:00:03.383 0.0%567249 0.001 0.006 0.016
overview write00:00:35.412 0.0%20538 0.057 1.724 40.649
perl filter00:00:52.552 0.1%28082 1.393 1.871 4.580
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.376 0.0%41076 0.008 0.033 0.090
TOTAL: 24:00:52.58623:59:45.501 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.066 0.0%27771 0.000 0.002 0.029
article prepare00:00:00.000 0.0%9322 0.000 0.000 0.000
article read00:00:00.464 0.0%2068 0.000 0.224 49.714
backlog stats00:00:00.297 0.0%332225 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.640 0.0%279141 0.002 0.006 0.012
data write00:00:02.888 0.0%257811 0.006 0.011 0.024
idle23:53:43.299100.0%332225 119.853 258.931 640.959
status file00:00:12.401 0.0%1840 0.667 6.740 220.262
TOTAL: 23:54:19.71723:54:01.055100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle20:32:51.550 99.6%175975 0.000 420.353 70880.294
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:03:00.893 0.2%392021 0.000 0.461 10.153
readart00:00:01.177 0.0%19060 0.000 0.062 10.154
TOTAL: 20:37:16.74820:35:53.620 99.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 41 22868 5356 17178 334 23%49:20:46
2news-out.mixmin.net 18 19424 3592 15008 824 18%30:55:30
3news-out.aioe.org 3 21038 3469 17476 93 16%26:17:26
4feeder.eternal-september.org 40 25297 2251 21390 1656 8%34:18:50
5newsfeed.datemas.de 3 28779 1498 26713 568 5%35:14:03
6csiph.com 2 18305 1401 16871 33 7%19:44:38
7newsfeed.neva.ru 148 19411 973 14605 3833 5%91:14:13
8news.albasani.net 1 22792 665 21743 384 2%24:44:17
9news.redatomik.org 1 10106 493 9586 27 4%10:09:17
10news.freedyn.net 3 28801 448 28116 237 1%31:45:34
11news.swapon.de 5 2367 305 2055 7 12%26:34:58
12feeder.awxg.com 2 18412 117 18235 60 0%24:49:01
13agency-nz-out.news.mb-net.net 19 22839 72 22600 167 0%31:02:10
14news.samoylyk.net 2 21089 65 20962 62 0%24:53:18
15news.ausics.org 2 56629 18 56605 6 0%79:19:34
16localhost 11 10 9 0 1 90%00:00:00
TOTAL: 16 301 338167 20732 309143 8292 6%540:23:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.2 MB261.0 KB1.3 MB18.7 MB 91%3.4 KB
2newsfeed.datemas.de14.2 MB715.6 KB2.8 MB17.7 MB 80%8.8 KB
3news-out.mixmin.net10.4 MB305.0 KB1.9 MB12.6 MB 82%2.9 KB
4feeder.eternal-september.org9.5 MB539.6 KB5.5 MB15.5 MB 61%4.1 KB
5news-out.aioe.org8.2 MB126.3 KB234.1 KB8.5 MB 95%2.5 KB
6news.albasani.net5.8 MB619.5 KB1.4 MB7.7 MB 74%7.5 KB
7csiph.com4.2 MB151.7 KB158.9 KB4.5 MB 93%3.2 KB
8news.freedyn.net3.1 MB314.6 KB3.8 MB7.2 MB 42%10.8 KB
9newsfeed.neva.ru2.4 MB117.1 KB23.0 MB25.5 MB 9%5.4 KB
10news.redatomik.org1.2 MB75.8 KB82.8 KB1.3 MB 88%2.6 KB
11news.swapon.de793.0 KB5.1 KB10.4 KB808.5 KB 98%2.6 KB
12feeder.awxg.com410.4 KB248.1 KB250.1 KB908.5 KB 45%5.1 KB
13news.samoylyk.net293.6 KB343.3 KB348.0 KB984.9 KB 29%7.8 KB
14agency-nz-out.news.mb-net.net282.5 KB223.8 KB4.4 MB4.9 MB 5%20.9 KB
15news.ausics.org59.2 KB13.6 KB15.0 KB87.8 KB 67%3.7 KB
16localhost15.3 KB0.0 KB2.2 KB17.4 KB 87%1.7 KB
TOTAL: 1677.8 MB4.0 MB45.2 MB126.9 MB 61%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 5 23:58:01 - 23:59:59 32 0.2% 0.2788.9 KB 0.1% 0.75
Jan 6 00:00:00 - 00:59:59 870 4.2% 0.242.5 MB 3.3% 0.72
Jan 6 01:00:00 - 01:59:59 914 4.5% 0.252.8 MB 3.6% 0.79
Jan 6 02:00:00 - 02:59:59 1029 5.0% 0.292.8 MB 3.7% 0.80
Jan 6 03:00:00 - 03:59:59 1065 5.2% 0.303.3 MB 4.4% 0.94
Jan 6 04:00:00 - 04:59:59 1220 5.9% 0.343.2 MB 4.2% 0.90
Jan 6 05:00:00 - 05:59:59 1368 6.7% 0.385.0 MB 6.6% 1.43
Jan 6 06:00:00 - 06:59:59 1153 5.6% 0.323.2 MB 4.3% 0.92
Jan 6 07:00:00 - 07:59:59 1274 6.2% 0.353.5 MB 4.7% 1.01
Jan 6 08:00:00 - 08:59:59 1172 5.7% 0.332.9 MB 3.8% 0.83
Jan 6 09:00:00 - 09:59:59 1159 5.7% 0.323.3 MB 4.4% 0.94
Jan 6 10:00:00 - 10:59:59 1107 5.4% 0.314.2 MB 5.6% 1.20
Jan 6 11:00:00 - 11:59:59 959 4.7% 0.274.7 MB 6.3% 1.35
Jan 6 12:00:00 - 12:59:59 950 4.6% 0.267.4 MB 9.7% 2.09
Jan 6 13:00:00 - 13:59:59 786 3.8% 0.224.7 MB 6.2% 1.33
Jan 6 14:00:00 - 14:59:59 568 2.8% 0.161.7 MB 2.2% 0.47
Jan 6 15:00:00 - 15:59:59 480 2.3% 0.132.5 MB 3.2% 0.70
Jan 6 16:00:00 - 16:59:59 460 2.2% 0.132.4 MB 3.2% 0.68
Jan 6 17:00:00 - 17:59:59 411 2.0% 0.112.6 MB 3.5% 0.74
Jan 6 18:00:00 - 18:59:59 351 1.7% 0.102.3 MB 3.0% 0.64
Jan 6 19:00:00 - 19:59:59 439 2.1% 0.121.6 MB 2.1% 0.46
Jan 6 20:00:00 - 20:59:59 503 2.5% 0.142.0 MB 2.7% 0.58
Jan 6 21:00:00 - 21:59:59 622 3.0% 0.171.7 MB 2.2% 0.47
Jan 6 22:00:00 - 22:59:59 865 4.2% 0.243.1 MB 4.1% 0.89
Jan 6 23:00:00 - 23:58:01 752 3.7% 0.222.2 MB 2.9% 0.66
TOTAL: 24:00:00 20509 100.0% 0.2475.7 MB 100.0% 0.90
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.7 GB 45.4% 0 0.35 1714.75
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.3 GB 52.6% 0 0.39 1557.24
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB282.6 MB 0.6% 0 0.0414222.22
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 GB14.5 GB 29.0% 0 0.69 884.01
TOTAL: 10-500.0 GB63.8 GB 12.8% 1 0.47-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3828 41 0 48 0 0 0 0 3739
2feeder.eternal-september.org 1661 0 0 74 0 0 0 0 1587
3news-out.mixmin.net 1196 0 0 58 0 0 0 0 1138
4newsfeed.datemas.de 590 129 0 63 0 0 0 0 398
5news.albasani.net 393 3 0 66 0 0 0 0 324
6news.snarked.org 341 36 0 63 0 0 0 0 242
7news.freedyn.net 189 17 0 46 0 0 0 0 126
8agency-nz-out.news.mb-net.net 182 28 0 50 0 0 0 0 104
9news-out.aioe.org 169 12 0 36 0 0 0 0 121
10news.redatomik.org 91 0 0 49 0 0 0 0 42
11news.swapon.de 80 0 0 1 0 0 0 0 79
12news.samoylyk.net 62 0 0 60 0 0 0 0 2
13feeder.awxg.com 53 1 0 51 0 0 0 0 1
14csiph.com 37 0 0 33 0 0 0 0 4
15news.ausics.org 4 0 0 2 0 0 0 0 2
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 8877 267 0 700 0 0 0 0 7910

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.commerciali 35
it.annunci.immobiliari 35
gmane.linux.alsa.devel 34
it.annunci.varie 32
mpc.lists.nanog 23
gmane.comp.gis.openstreetmap.tagging 12
mpc.lists.freebsd.gecko 11
gmane.linux.acpi.devel 10
mozilla.dev.platform 9
gmane.linux.kernel 8
mozilla.support.seamonkey 6
gmane.linux.bios.flashrom 5
aioe.helpdesk 5
gmane.linux.kernel.gpio 4
mozilla.support.bugzilla 3
south-wales.test 3
gmane.linux.drivers.devicetree 2
mozilla.tools.treeherder 2
demos.local.lists.cgp-russian 2
mozilla.dev.ui-alerts 2
TOTAL: 41 267

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5847
EMP (phn path) 465
Binary: misplaced rar 436
EMP (phn nph) 269
EMP (phl) 78
EMP (fsl) 56
Binary Image: misplaced jpg 49
Too many newsgroups 47
User-issued cancel 19
Binary: non-binary distribution 9
Binary: misplaced par2 8
Too many newsgroups (low_xpost) 1
TOTAL: 12 7284

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 327
news.swapon.de 75
news-out.aioe.org 75
newsfeed.datemas.de 68
news.redatomik.org 38
news.albasani.net 33
news.snarked.org 5
newsfeed.neva.ru 2
agency-nz-out.news.mb-net.net 1
feeder.eternal-september.org 1
TOTAL: 11 626
TOTAL: 1 626

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18857 1407 17406 41 3 0 7%23:59:45
2awxg 19930 99 19817 3 0 14 0%23:59:42
3news.freedyn.net 20158 11 20058 0 0 0 0%23:59:44
4news.samoylyk.net 19003 10 18789 0 0 169 0%23:59:45
5news.redatomik.org 19943 10 19858 1 0 3 0%23:59:45
6csiph.com 19185 9 19002 0 0 0 0%23:59:41
7news-in.mixmin.net 15642 9 15599 0 0 180 0%23:59:45
8aioe 15876 8 15768 0 0 0 0%23:59:43
9neva.ru 19239 8 19204 1 0 0 0%23:59:45
10eternal-september 17339 8 17273 0 0 207 0%23:59:45
11mb-net.net 20501 6 20382 0 0 829 0%23:59:45
12news.albasani.net 20329 5 18432 615 0 5362 0%23:59:24
13newsfeed.datemas.de 18965 5 18894 0 0 301 0%23:59:45
14news.snarked.org 14927 4 14851 2 0 260 0%23:59:45
15news.swapon.de 2242 0 2232 0 0 12 0%23:53:24
TOTAL: 15 262136 1599 257565 663 3 7337 0%359:49:23
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org15.1 MB684.8 KB15.7 MB0.2 KB/s11.1 KB23:59:45
2awxg301.3 KB14.7 KB316.1 KB0.0 KB/s3.1 KB23:59:42
3news.samoylyk.net57.5 KB0.0 KB57.5 KB0.0 KB/s5.8 KB23:59:45
4news.redatomik.org20.7 KB2.7 KB23.4 KB0.0 KB/s2.1 KB23:59:45
5news.freedyn.net17.8 KB0.0 KB17.8 KB0.0 KB/s1.6 KB23:59:44
6csiph.com15.3 KB0.0 KB15.3 KB0.0 KB/s1.7 KB23:59:41
7news-in.mixmin.net15.3 KB0.0 KB15.3 KB0.0 KB/s1.7 KB23:59:45
8eternal-september13.9 KB0.0 KB13.9 KB0.0 KB/s1.7 KB23:59:45
9neva.ru13.1 KB2.2 KB15.3 KB0.0 KB/s1.7 KB23:59:45
10aioe13.1 KB0.0 KB13.1 KB0.0 KB/s1.6 KB23:59:43
11mb-net.net8.6 KB0.0 KB8.6 KB0.0 KB/s1.4 KB23:59:45
12news.albasani.net7.3 KB1.9 MB1.9 MB0.0 KB/s3.2 KB23:59:24
13newsfeed.datemas.de7.3 KB0.0 KB7.3 KB0.0 KB/s1.5 KB23:59:45
14news.snarked.org6.8 KB3.4 KB10.2 KB0.0 KB/s1.7 KB23:59:45
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:24
TOTAL: 1515.6 MB2.6 MB18.2 MB0.0 KB/s8.2 KB359:49:23
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 9 894336.1 MB 1272 3 1804:44:02
2agency.bbs.geek.nz 399 820729.2 MB 4715 6 000:17:13
3vorlon.activateit.net.au 24 12921.6 MB 158 0 000:05:44
4203.47.169.71 2 16.4 KB 1 0 000:03:17
TOTAL: 4 434 1844366.9 MB 6146 9 1820:37:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 11 894336.1 MB 1272 3 1820:10:52
2*.bbs.geek.nz 399 820729.2 MB 4715 6 000:17:13
3*.activateit.net.au 24 12921.6 MB 158 0 000:05:44
4unresolved 2 16.4 KB 1 0 000:03:17
TOTAL: 4 436 1844366.9 MB 6146 9 1820:37:09

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 2
malcolmlewis 2
TOTAL: 4 36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.140 0.048 0.00615:26:49
67-61-21-181.cpe.cableone.net 1.576 1.352 0.02404:44:02
agency.bbs.geek.nz 28.780 7.332 0.00000:17:13
vorlon.activateit.net.au 1.404 0.388 0.21800:05:44
203.47.169.71 0.128 0.028 0.00500:03:17
? 1.000 0.212 0.00000:00:01
TOTAL: 6 33.028 9.360 0.25320:37:09

Curious NNRP server explorers [Top 20]:

SystemConn
67-60-219-146.cpe.cableone.net 2
TOTAL: 1 2

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
203.47.169.71 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-21-181.cpe.cableone.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 6181 33.5%
2comp 2332 12.6%
3alt 2270 12.3%
4soc 1793 9.7%
5uk 1614 8.8%
6sci 1442 7.8%
7linux 1208 6.5%
8talk 724 3.9%
9misc 526 2.9%
10news 171 0.9%
11mozilla 112 0.6%
12aus 22 0.1%
13microsoft 19 0.1%
14humanities 10 0.1%
15eternal-september 5 0.0%
16fido7 4 0.0%
17us 4 0.0%
18nz 3 0.0%
19fido 1 0.0%
20agency 1 0.0%
21newsguy 1 0.0%
TOTAL: 21 18443100.0%

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

NewsgroupCount
1rec.arts.tv 1421
2alt.comp.os.windows-10 616
3uk.d-i-y 568
4rec.arts.drwho 547
5rec.food.cooking 540
6alt.fan.rush-limbaugh 448
7alt.atheism 387
8comp.lang.python 359
9uk.legal 357
10rec.sport.tennis 354
11soc.culture.polish 336
12linux.debian.bugs.dist 334
13rec.sport.golf 315
14sci.math 286
15talk.politics.guns 284
16rec.arts.sf.written 276
17misc.survivalism 274
18linux.debian.changes.devel 260
19talk.politics.misc 248
20rec.sport.football.college 247
21sci.electronics.design 226
22uk.radio.amateur 220
23rec.radio.shortwave 216
24soc.culture.israel 216
25rec.gambling.poker 205
26comp.lang.c 202
27sci.physics 189
28alt.politics.trump 188
29soc.retirement 182
30rec.boats 177
31talk.origins 174
32comp.lang.idl-pvwave 172
33comp.sys.mac.system 157
34rec.arts.sf.tv 152
35soc.culture.singapore 151
36sci.physics.relativity 151
37uk.comp.sys.mac 142
38rec.crafts.metalworking 141
39comp.os.linux.advocacy 137
40rec.sport.pro-wrestling 136
41sci.logic 128
42rec.photo.digital 128
43news.lists.filters 122
44soc.culture.china 119
45comp.sys.apple2 119
46soc.penpals 113
47comp.sys.mac.apps 109
48linux.debian.bugs.rc 108
49uk.rec.driving 108
50sci.med.cardiology 107
51soc.culture.usa 100
52soc.culture.brazil 94
53soc.culture.indian 91
54rec.aquaria.marine.misc 88
55comp.arch 86
56rec.music.classical.recordings 86
57linux.debian.user 84
58alt.politics 82
59misc.phone.mobile.iphone 82
60alt.test 82
61alt.os.linux.ubuntu 81
62rec.aviation.marketplace 80
63comp.os.vms 80
64uk.legal.moderated 77
65soc.history.what-if 74
66rec.aviation.soaring 72
67linux.gentoo.user 70
68sci.astro.amateur 69
69rec.arts.movies.past-films 69
70sci.crypt 64
71comp.protocols.time.ntp 64
72rec.outdoors.rv-travel 64
73misc.invest.stocks 62
74comp.lang.forth 60
75uk.rec.cycling 59
76comp.mobile.ipad 58
77mozilla.support.firefox 58
78comp.os.linux.misc 56
79linux.debian.user.french 56
80misc.health.alternative 53
81mozilla.general 52
82alt.bible 52
83rec.arts.movies.current-films 51
84linux.debian.kernel 46
85alt.conspiracy.jfk 46
86comp.lang.fortran 46
87soc.culture.vietnamese 46
88rec.sport.soccer 45
89linux.gentoo.dev 44
90rec.arts.sf.fandom 44
91alt.support.diabetes 42
92alt.recovery.aa 39
93comp.sys.acorn.apps 39
94comp.lang.ada 38
95rec.bicycles.tech 38
96rec.woodworking 38
97comp.soft-sys.math.scilab 38
98news.admin.net-abuse.email 38
99comp.lang.tcl 36
100comp.soft-sys.sas 36
TOTAL: 366 18443