news.bbs.geek.nz daily logs

Jan 12 23:58:02 -- Jan 13 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 149782 64.3%12.4 MB 43.7%
innd 30220 13.0%5.0 MB 17.6%
inn 28092 12.1%6.3 MB 22.1%
innfeed 23286 10.0%4.5 MB 15.7%
cnfsstat 1440 0.6%249.5 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 232821 100.0%28.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 272168 48.4%
Positive hits 263312 46.8%
Do not exist 26529 4.7%
Cache misses 293 0.1%
TOTAL: 4 562302 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.133 0.0%84 0.000 1.583 14.000
article cleanup00:00:00.223 0.0%27442 0.000 0.008 0.038
article logging00:00:00.713 0.0%28023 0.000 0.025 0.073
article parse00:00:00.871 0.0%72129 0.002 0.012 0.027
article write00:00:01.559 0.0%20629 0.016 0.076 0.409
artlog/artcncl00:00:00.001 0.0%81 0.000 0.012 1.000
data move00:00:00.392 0.0%546744 0.000 0.001 0.027
hisgrep/artcncl00:00:00.001 0.0%70 0.000 0.014 0.500
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:08.963 0.0%566086 0.002 0.016 0.871
history sync00:00:00.059 0.0%349 0.000 0.169 13.667
history write00:00:06.341 0.0%26680 0.020 0.238 11.051
hiswrite/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
idle23:57:42.280 99.8%560814 73.837 153.816 463.556
nntp read00:00:03.273 0.0%562238 0.003 0.006 0.015
overview write00:00:51.693 0.1%20629 0.068 2.506 93.304
perl filter00:00:50.679 0.1%26680 1.364 1.900 4.418
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.333 0.0%41258 0.000 0.032 0.123
TOTAL: 24:00:46.62323:59:48.514 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.066 0.0%28630 0.000 0.002 0.017
article prepare00:00:00.001 0.0%13974 0.000 0.000 0.000
article read00:00:00.239 0.0%3243 0.000 0.074 5.429
backlog stats00:00:00.318 0.0%328919 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.702 0.0%273979 0.001 0.006 0.013
data write00:00:02.900 0.0%257770 0.006 0.011 0.022
idle23:53:31.589 99.9%328919 164.599 261.498 692.414
prepart/cb00:00:00.000 0.0%4 0.000 0.000 0.000
readart/cb00:00:00.000 0.0%1 0.000 0.000 0.000
status file00:00:21.079 0.0%1904 0.667 11.071 530.743
TOTAL: 23:54:21.00623:53:57.894100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle16:48:55.952 95.8%167843 0.000 360.670 66482.461
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:03.213 0.1%374476 0.000 0.169 3.085
readart00:00:01.956 0.0%18419 0.000 0.106 32.400
TOTAL: 17:32:47.63416:50:01.121 95.9%----

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 32 18275 5943 11954 378 32%36:37:53
2news-out.mixmin.net 8 22541 3600 17619 1322 15%25:59:43
3newsfeed.datemas.de 2 24587 3217 20794 576 13%27:40:53
4news-out.aioe.org 1 20768 2083 18565 120 10%24:24:45
5feeder.eternal-september.org 64 25211 2008 22272 931 7%43:55:30
6csiph.com 3 19520 1137 18341 42 5%23:12:00
7newsfeed.neva.ru 150 16881 1127 13147 2607 6%78:12:26
8news.albasani.net 1 23995 959 22564 472 3%26:29:33
9news.redatomik.org 1 22216 534 21452 230 2%26:59:28
10news.swapon.de 3 1739 189 1545 5 10%25:10:43
11feeder.awxg.com 2 18908 105 18760 43 0%23:59:25
12agency-nz-out.news.mb-net.net 9 21253 100 20960 193 0%26:07:01
13news.freedyn.net 2 22189 39 22102 48 0%20:10:33
14news.ausics.org 9 137829 23 137785 21 0%181:12:18
15news.samoylyk.net 2 21731 14 21673 44 0%23:59:52
16localhost 5 4 3 0 1 75%00:00:01
TOTAL: 16 294 417647 21081 389533 7033 5%614:12:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.5 MB161.9 KB2.2 MB21.9 MB 89%3.5 KB
2newsfeed.datemas.de13.2 MB277.8 KB2.9 MB16.4 MB 80%4.4 KB
3news-out.mixmin.net10.5 MB515.8 KB3.4 MB14.5 MB 72%3.0 KB
4feeder.eternal-september.org8.7 MB620.2 KB3.6 MB12.9 MB 67%4.5 KB
5news.albasani.net6.3 MB776.1 KB1.7 MB8.7 MB 72%6.2 KB
6news-out.aioe.org5.2 MB127.7 KB314.3 KB5.6 MB 92%2.6 KB
7csiph.com3.1 MB113.3 KB122.5 KB3.3 MB 93%2.9 KB
8newsfeed.neva.ru2.8 MB122.2 KB8.6 MB11.5 MB 24%3.1 KB
9news.redatomik.org2.6 MB212.3 KB482.8 KB3.3 MB 79%4.5 KB
10news.freedyn.net745.4 KB84.0 KB120.9 KB950.4 KB 78%10.9 KB
11agency-nz-out.news.mb-net.net615.8 KB226.1 KB6.7 MB7.5 MB 7%26.4 KB
12news.swapon.de452.2 KB7.4 KB43.9 KB503.5 KB 89%2.6 KB
13feeder.awxg.com363.3 KB112.2 KB118.2 KB593.8 KB 61%4.0 KB
14news.ausics.org66.8 KB50.9 KB83.4 KB201.2 KB 33%4.6 KB
15news.samoylyk.net29.2 KB695.1 KB696.2 KB1.4 MB 2%24.5 KB
16localhost6.7 KB0.0 KB2.2 KB8.8 KB 75%2.2 KB
TOTAL: 1674.1 MB4.0 MB31.0 MB109.1 MB 67%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 12 23:58:02 - 23:59:59 28 0.1% 0.2461.8 KB 0.1% 0.52
Jan 13 00:00:00 - 00:59:59 976 4.7% 0.272.4 MB 3.4% 0.69
Jan 13 01:00:00 - 01:59:59 909 4.4% 0.253.5 MB 4.9% 0.99
Jan 13 02:00:00 - 02:59:59 1164 5.6% 0.322.9 MB 4.0% 0.82
Jan 13 03:00:00 - 03:59:59 1140 5.5% 0.324.6 MB 6.5% 1.32
Jan 13 04:00:00 - 04:59:59 1158 5.6% 0.323.5 MB 4.9% 1.01
Jan 13 05:00:00 - 05:59:59 1233 6.0% 0.344.4 MB 6.2% 1.26
Jan 13 06:00:00 - 06:59:59 1273 6.2% 0.353.6 MB 5.0% 1.01
Jan 13 07:00:00 - 07:59:59 1286 6.2% 0.364.3 MB 6.0% 1.23
Jan 13 08:00:00 - 08:59:59 1183 5.7% 0.334.0 MB 5.6% 1.14
Jan 13 09:00:00 - 09:59:59 1126 5.5% 0.313.5 MB 4.9% 0.99
Jan 13 10:00:00 - 10:59:59 1120 5.4% 0.313.8 MB 5.4% 1.09
Jan 13 11:00:00 - 11:59:59 953 4.6% 0.263.0 MB 4.2% 0.86
Jan 13 12:00:00 - 12:59:59 814 3.9% 0.233.7 MB 5.2% 1.06
Jan 13 13:00:00 - 13:59:59 658 3.2% 0.183.4 MB 4.7% 0.96
Jan 13 14:00:00 - 14:59:59 615 3.0% 0.171.7 MB 2.4% 0.50
Jan 13 15:00:00 - 15:59:59 441 2.1% 0.124.0 MB 5.6% 1.15
Jan 13 16:00:00 - 16:59:59 382 1.9% 0.111.3 MB 1.8% 0.37
Jan 13 17:00:00 - 17:59:59 403 2.0% 0.111.8 MB 2.5% 0.51
Jan 13 18:00:00 - 18:59:59 420 2.0% 0.121.5 MB 2.2% 0.44
Jan 13 19:00:00 - 19:59:59 512 2.5% 0.141.8 MB 2.5% 0.52
Jan 13 20:00:00 - 20:59:59 456 2.2% 0.132.1 MB 2.9% 0.60
Jan 13 21:00:00 - 21:59:59 820 4.0% 0.232.1 MB 3.0% 0.60
Jan 13 22:00:00 - 22:59:59 714 3.5% 0.202.2 MB 3.0% 0.62
Jan 13 23:00:00 - 23:58:01 829 4.0% 0.242.2 MB 3.0% 0.63
TOTAL: 23:59:59 20613 100.0% 0.2471.7 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.9 GB 45.7% 0 0.34 1768.77
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.5 GB 53.1% 0 0.38 1591.42
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB285.2 MB 0.6% 0 0.0415458.94
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.9 GB 29.8% 0 0.67 900.10
TOTAL: 10-500.0 GB64.6 GB 12.9% 1 0.46-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2558 48 0 39 0 0 0 0 2471
2news-out.mixmin.net 1545 0 0 130 0 0 0 0 1415
3feeder.eternal-september.org 920 0 0 115 0 0 0 0 805
4newsfeed.datemas.de 713 137 0 49 0 0 0 0 527
5news.albasani.net 520 6 0 60 0 0 0 0 454
6news.snarked.org 379 110 0 60 0 0 0 0 209
7news.redatomik.org 218 0 0 70 0 0 0 0 148
8agency-nz-out.news.mb-net.net 178 22 0 47 0 0 0 0 109
9news-out.aioe.org 153 16 0 39 0 0 0 0 98
10news.freedyn.net 53 0 0 29 0 0 0 0 24
11feeder.awxg.com 44 1 0 41 0 0 0 0 2
12csiph.com 42 0 0 38 0 0 0 0 4
13news.samoylyk.net 38 0 0 37 0 0 0 0 1
14news.swapon.de 35 0 0 3 0 0 0 0 32
15news.ausics.org 1 0 0 1 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 7398 340 0 758 0 0 0 0 6300

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.x11 39
gmane.comp.gis.openstreetmap.tagging 34
mpc.lists.freebsd.gnome 32
it.annunci.immobiliari 30
gmane.linux.alsa.devel 28
it.annunci.varie 24
it.annunci.commerciali 23
mozilla.dev.security.policy 18
mozilla.support.seamonkey 17
nemo.bavardages 11
mpc.lists.freebsd.office 11
mozilla.dev.platform 10
mpc.lists.nanog 7
gmane.comp.gis.openstreetmap.legal 6
gmane.linux.kernel 5
nemo.aide 5
gmane.linux.acpi.devel 5
mpc.lists.freebsd.gecko 4
mozilla.dev.ui-alerts 4
al.christnet.bible 2
TOTAL: 43 340

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4531
EMP (phn path) 572
EMP (phn nph) 272
Too many newsgroups 90
Binary Image: misplaced jpg 76
EMP (phl) 76
Binary: misplaced rar 32
User-issued cancel 25
Binary: non-binary distribution 20
HTML post 12
Binary: misplaced par2 2
Cancel for rejected article 2
U2 violation - invalid distribution 2
User-issued spam cancel 1
Binary: misplaced 002 1
Binary: misplaced 017 1
Binary: misplaced 019 1
TOTAL: 17 5716

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 244
newsfeed.datemas.de 170
news.albasani.net 82
news-out.aioe.org 33
news.swapon.de 31
news.redatomik.org 16
newsfeed.neva.ru 6
news.snarked.org 1
feeder.eternal-september.org 1
TOTAL: 9 584
TOTAL: 1 584

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18729 2192 16380 109 9 1384 11%23:59:38
2awxg 20102 142 19956 0 0 8 0%23:59:32
3news.freedyn.net 20840 13 20559 0 0 0 0%23:59:35
4aioe 17267 4 17160 0 0 0 0%23:59:36
5neva.ru 19138 3 19102 3 0 0 0%23:59:36
6news.samoylyk.net 19007 3 18673 2 0 7 0%23:59:36
7csiph.com 19524 3 19448 1 0 1 0%23:59:37
8news-in.mixmin.net 16164 3 16133 0 0 0 0%23:59:36
9news.redatomik.org 20234 3 20165 0 0 0 0%23:59:34
10news.snarked.org 14494 2 14446 1 0 0 0%23:59:25
11eternal-september 17755 2 17705 0 0 98 0%23:59:36
12newsfeed.datemas.de 17483 2 17387 0 0 104 0%23:59:36
13news.swapon.de 1570 0 1569 0 0 0 0%23:54:44
14news.albasani.net 20462 0 17614 899 0 6386 0%23:59:35
15mb-net.net 20551 0 20468 0 0 109 0%23:59:36
TOTAL: 15 263320 2372 256765 1015 9 8097 0%359:48:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org18.7 MB1.1 MB19.8 MB0.2 KB/s8.8 KB23:59:38
2awxg555.8 KB0.0 KB555.8 KB0.0 KB/s3.9 KB23:59:32
3news.freedyn.net30.9 KB0.0 KB30.9 KB0.0 KB/s2.4 KB23:59:35
4neva.ru9.1 KB7.3 KB16.4 KB0.0 KB/s2.7 KB23:59:36
5aioe8.6 KB0.0 KB8.6 KB0.0 KB/s2.2 KB23:59:36
6news.samoylyk.net6.7 KB12.8 KB19.4 KB0.0 KB/s3.9 KB23:59:36
7csiph.com6.7 KB100.5 KB107.1 KB0.0 KB/s26.8 KB23:59:37
8news-in.mixmin.net6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:36
9news.redatomik.org6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:34
10news.snarked.org4.5 KB2.2 KB6.7 KB0.0 KB/s2.2 KB23:59:25
11eternal-september4.4 KB0.0 KB4.4 KB0.0 KB/s2.2 KB23:59:36
12newsfeed.datemas.de4.4 KB0.0 KB4.4 KB0.0 KB/s2.2 KB23:59:36
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:44
14news.albasani.net0.0 KB3.7 MB3.7 MB0.0 KB/s4.2 KB23:59:35
15mb-net.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:36
TOTAL: 1519.3 MB5.0 MB24.3 MB0.0 KB/s7.3 KB359:48:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 868430.3 MB 1239 3 1802:16:12
2agency.bbs.geek.nz 360 791526.1 MB 4277 0 000:13:54
3vorlon.activateit.net.au 24 9261.2 MB 135 0 000:04:41
4192.168.1.9 1 121545.4 KB 7 0 000:00:06
TOTAL: 4 393 1764658.1 MB 5658 3 1817:44:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 10 868430.3 MB 1239 3 1816:32:24
2*.bbs.geek.nz 360 791526.1 MB 4277 0 000:13:54
3*.activateit.net.au 24 9261.2 MB 135 0 000:04:41
4unresolved 12 121545.4 KB 7 0 000:53:39
TOTAL: 4 406 1764658.1 MB 5658 3 1817:44:43

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 2
paulh 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.200 0.052 0.00914:16:12
67-61-21-181.cpe.cableone.net 1.680 1.200 0.02202:16:12
118.149.130.187 0.388 0.088 0.00000:44:11
agency.bbs.geek.nz 26.584 6.672 0.00000:13:54
118.149.139.175 0.308 0.028 0.00000:09:22
vorlon.activateit.net.au 1.424 0.340 0.20100:04:41
192.168.1.9 0.116 0.020 0.00300:00:06
? 1.436 0.192 0.00000:00:02
TOTAL: 8 32.136 8.592 0.23517:44:43

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.130.187 6
118.149.139.175 5
67-60-219-146.cpe.cableone.net 2
TOTAL: 3 13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
67-60-219-146.cpe.cableone.net 1 0
118.149.130.187 1 1
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 6401 36.3%
2alt 2170 12.3%
3soc 1973 11.2%
4comp 1671 9.5%
5sci 1450 8.2%
6uk 1335 7.6%
7linux 1073 6.1%
8talk 821 4.7%
9misc 327 1.9%
10news 228 1.3%
11mozilla 60 0.3%
12nz 47 0.3%
13microsoft 37 0.2%
14aus 32 0.2%
15perl 13 0.1%
16humanities 6 0.0%
17us 2 0.0%
TOTAL: 17 17646100.0%

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

NewsgroupCount
1rec.arts.tv 1024
2rec.food.cooking 584
3alt.fan.rush-limbaugh 507
4rec.arts.sf.written 461
5rec.sport.golf 460
6uk.d-i-y 442
7uk.legal 408
8alt.comp.os.windows-10 387
9rec.sport.football.college 386
10alt.atheism 382
11rec.sport.tennis 371
12rec.arts.drwho 355
13rec.gambling.poker 332
14linux.debian.bugs.dist 328
15soc.retirement 326
16talk.politics.guns 312
17rec.boats 307
18talk.politics.misc 279
19sci.physics 278
20uk.radio.amateur 268
21rec.sport.pro-wrestling 234
22soc.culture.israel 232
23comp.lang.python 228
24sci.electronics.design 226
25talk.origins 197
26soc.history.what-if 188
27linux.debian.changes.devel 188
28sci.physics.relativity 172
29soc.culture.polish 168
30news.lists.filters 168
31comp.lang.idl-pvwave 162
32misc.survivalism 156
33comp.sys.apple2 153
34comp.lang.c++ 148
35comp.os.linux.advocacy 147
36alt.politics.trump 145
37soc.culture.china 138
38rec.radio.shortwave 131
39sci.math 124
40alt.politics 120
41sci.edu 116
42rec.photo.digital 112
43sci.logic 112
44linux.debian.user 106
45comp.sys.mac.system 103
46soc.culture.usa 102
47soc.culture.vietnamese 92
48soc.penpals 90
49soc.culture.indian 90
50rec.arts.sf.tv 89
51rec.woodworking 88
52rec.aquaria.marine.misc 88
53rec.sport.soccer 87
54soc.culture.singapore 84
55alt.bible.prophecy 82
56alt.recovery.aa 82
57sci.military.naval 80
58rec.aviation.marketplace 80
59linux.debian.bugs.rc 78
60rec.outdoors.rv-travel 78
61misc.health.alternative 75
62comp.lang.forth 74
63alt.test 72
64sci.med.cardiology 72
65comp.sys.acorn.misc 66
66rec.music.dylan 66
67rec.music.classical.recordings 64
68comp.sys.mac.apps 63
69soc.culture.brazil 62
70alt.os.linux.ubuntu 60
71rec.music.beatles 57
72alt.bible 53
73comp.mobile.android 52
74sci.astro.amateur 51
75comp.protocols.time.ntp 48
76comp.arch 48
77nz.general 47
78linux.debian.maint.boot 47
79rec.arts.sf.fandom 46
80uk.comp.sys.mac 46
81rec.bicycles.tech 46
82rec.arts.comics.strips 45
83soc.history 45
84linux.gentoo.dev 44
85uk.tech.digital-tv 44
86linux.gentoo.user 44
87rec.crafts.metalworking 42
88comp.lang.c 42
89rec.radio.amateur.misc 40
90soc.culture.greek 40
91alt.support.diabetes 40
92rec.arts.movies.current-films 39
93rec.music.gdead 38
94alt.society.liberalism 36
95misc.invest.stocks 36
96uk.legal.moderated 35
97soc.culture.netherlands 34
98soc.culture.bulgaria 34
99comp.sys.mac.advocacy 33
100alt.astronomy 33
TOTAL: 369 17646