news.bbs.geek.nz daily logs

Feb 5 23:58:02 -- Feb 6 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 137269 60.7%11.5 MB 40.7%
innd 32884 14.5%5.1 MB 18.1%
inn 30523 13.5%6.8 MB 24.1%
innfeed 24002 10.6%4.5 MB 16.1%
cnfsstat 1440 0.6%253.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 226119 100.0%28.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 288912 50.8%
Positive hits 247525 43.5%
Do not exist 28779 5.1%
Cache misses 3271 0.6%
TOTAL: 4 568487 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.406 0.0%146 0.000 2.781 20.375
article cleanup00:00:00.236 0.0%29881 0.000 0.008 0.046
article logging00:00:00.759 0.0%30460 0.000 0.025 0.062
article parse00:00:00.877 0.0%70961 0.000 0.012 0.026
article write00:00:01.589 0.0%21890 0.019 0.073 0.217
artlog/artcncl00:00:00.002 0.0%131 0.000 0.015 0.125
data move00:00:00.376 0.0%537346 0.000 0.001 0.009
hisgrep/artcncl00:00:00.177 0.0%133 0.000 1.331 11.667
hishave/artcncl00:00:00.136 0.0%146 0.000 0.932 8.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.643 0.0%575006 0.000 0.019 1.282
history sync00:00:00.042 0.0%355 0.000 0.118 10.000
history write00:00:09.664 0.0%29091 0.012 0.332 16.323
hiswrite/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
idle23:57:31.318 99.8%553579 90.546 155.807 427.865
nntp read00:00:03.209 0.0%553001 0.002 0.006 0.015
overview write00:00:41.933 0.0%21890 0.048 1.916 52.357
perl filter00:00:56.977 0.1%29084 1.325 1.959 10.582
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.470 0.0%43780 0.000 0.034 0.113
TOTAL: 24:00:47.70923:59:39.814 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.085 0.0%37568 0.000 0.002 0.011
article prepare00:00:00.002 0.0%10284 0.000 0.000 0.013
article read00:00:00.093 0.0%1977 0.000 0.047 0.500
backlog stats00:00:00.275 0.0%341642 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.658 0.0%285344 0.001 0.006 0.012
data write00:00:02.995 0.0%270395 0.004 0.011 0.020
idle23:52:58.464 99.9%341642 108.527 251.662 596.990
status file00:00:22.032 0.0%2106 0.800 10.462 466.154
TOTAL: 23:53:43.81023:53:25.604100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%8 0.000 0.000 0.000
idle24:08:26.413 96.5%168791 0.000 514.876 75095.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:19.946 0.0%349238 0.000 0.057 1.000
readart00:00:08.829 0.0%17912 0.000 0.493 31.000
TOTAL: 25:01:25.62824:08:55.188 96.5%----

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
1csiph.com 2 21911 5371 16485 55 24%24:28:40
2news-out.mixmin.net 12 22657 3862 17921 874 17%28:53:03
3news-out.aioe.org 5 22198 3477 18552 169 15%24:37:25
4feeder.eternal-september.org 106 26896 2251 22850 1795 8%67:28:56
5newsfeed.datemas.de 2 22310 1988 19688 634 8%24:14:22
6newsfeed.neva.ru 153 10245 1545 5090 3610 15%96:02:21
7news.albasani.net 2 23887 1405 22086 396 5%20:27:57
8news.redatomik.org 4 19676 1337 18255 84 6%19:20:10
9news.swapon.de 5 2226 251 1968 7 11%23:40:39
10news.samoylyk.net 23 21301 185 21054 62 0%22:40:30
11agency-nz-out.news.mb-net.net 20 22270 119 22044 107 0%31:47:46
12feeder.awxg.com 1 19830 113 19660 57 0%23:59:56
13localhost 903 902 61 840 1 6%00:00:00
14news.freedyn.net 1 19442 30 19351 61 0%19:58:37
15news.ausics.org 2 9342 1 9334 7 0%11:24:33
TOTAL: 15 1241 265093 21996 235178 7919 8%439:04:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph.com15.4 MB187.2 KB209.9 KB15.8 MB 97%3.0 KB
2news-out.mixmin.net11.7 MB539.0 KB2.3 MB14.5 MB 80%3.1 KB
3newsfeed.datemas.de9.7 MB338.9 KB9.7 MB19.7 MB 49%7.7 KB
4news-out.aioe.org8.8 MB141.7 KB416.6 KB9.4 MB 94%2.6 KB
5feeder.eternal-september.org7.7 MB759.1 KB5.9 MB14.3 MB 53%3.6 KB
6news.albasani.net6.1 MB395.8 KB1.3 MB7.8 MB 78%4.5 KB
7newsfeed.neva.ru4.0 MB205.3 KB13.9 MB18.1 MB 21%3.6 KB
8news.redatomik.org3.3 MB290.0 KB359.3 KB3.9 MB 83%2.8 KB
9news.samoylyk.net1.1 MB380.1 KB963.3 KB2.4 MB 45%10.0 KB
10agency-nz-out.news.mb-net.net1.0 MB460.4 KB832.5 KB2.3 MB 44%10.4 KB
11news.swapon.de671.6 KB12.5 KB15.1 KB699.2 KB 96%2.7 KB
12feeder.awxg.com347.4 KB169.1 KB179.6 KB696.1 KB 49%4.1 KB
13news.freedyn.net277.8 KB172.0 KB252.6 KB702.5 KB 39%7.7 KB
14localhost121.8 KB0.0 KB2.2 KB123.9 KB 98%2.0 KB
15news.ausics.org1.4 KB19.5 KB19.5 KB40.4 KB 3%5.0 KB
TOTAL: 1570.2 MB4.0 MB36.2 MB110.4 MB 63%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 5 23:58:02 - 23:59:59 29 0.1% 0.2575.7 KB 0.1% 0.64
Feb 6 00:00:00 - 00:59:59 1011 4.6% 0.282.8 MB 4.0% 0.81
Feb 6 01:00:00 - 01:59:59 1015 4.6% 0.283.1 MB 4.3% 0.87
Feb 6 02:00:00 - 02:59:59 1000 4.6% 0.282.8 MB 4.0% 0.81
Feb 6 03:00:00 - 03:59:59 1122 5.1% 0.314.2 MB 6.0% 1.20
Feb 6 04:00:00 - 04:59:59 1351 6.2% 0.383.5 MB 5.0% 1.01
Feb 6 05:00:00 - 05:59:59 1267 5.8% 0.354.2 MB 5.9% 1.20
Feb 6 06:00:00 - 06:59:59 1236 5.7% 0.343.3 MB 4.7% 0.94
Feb 6 07:00:00 - 07:59:59 1294 5.9% 0.364.1 MB 5.8% 1.18
Feb 6 08:00:00 - 08:59:59 1236 5.7% 0.344.6 MB 6.6% 1.32
Feb 6 09:00:00 - 09:59:59 1104 5.1% 0.313.4 MB 4.8% 0.96
Feb 6 10:00:00 - 10:59:59 1220 5.6% 0.343.4 MB 4.9% 0.98
Feb 6 11:00:00 - 11:59:59 1076 4.9% 0.303.0 MB 4.2% 0.85
Feb 6 12:00:00 - 12:59:59 824 3.8% 0.232.6 MB 3.7% 0.75
Feb 6 13:00:00 - 13:59:59 716 3.3% 0.202.7 MB 3.8% 0.76
Feb 6 14:00:00 - 14:59:59 563 2.6% 0.161.9 MB 2.7% 0.54
Feb 6 15:00:00 - 15:59:59 502 2.3% 0.143.1 MB 4.4% 0.88
Feb 6 16:00:00 - 16:59:59 401 1.8% 0.111.9 MB 2.6% 0.53
Feb 6 17:00:00 - 17:59:59 509 2.3% 0.142.2 MB 3.1% 0.62
Feb 6 18:00:00 - 18:59:59 585 2.7% 0.162.5 MB 3.6% 0.72
Feb 6 19:00:00 - 19:59:59 501 2.3% 0.141.8 MB 2.5% 0.51
Feb 6 20:00:00 - 20:59:59 591 2.7% 0.161.8 MB 2.6% 0.53
Feb 6 21:00:00 - 21:59:59 860 3.9% 0.242.5 MB 3.5% 0.71
Feb 6 22:00:00 - 22:59:59 878 4.0% 0.242.5 MB 3.6% 0.72
Feb 6 23:00:00 - 23:58:02 949 4.3% 0.272.6 MB 3.6% 0.76
TOTAL: 24:00:00 21840 100.0% 0.2570.8 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.5 GB 46.9% 0 0.32 1873.52
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.2 GB 54.4% 0 0.39 1542.48
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB290.6 MB 0.6% 0 0.0318436.21
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 GB16.2 GB 32.5% 0 0.67 907.59
TOTAL: 10-500.0 GB67.2 GB 13.4% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3638 75 0 47 0 0 0 0 3516
2feeder.eternal-september.org 1768 0 0 128 0 0 0 0 1640
3news-out.mixmin.net 1080 0 0 100 0 0 0 0 980
4newsfeed.datemas.de 700 199 0 70 0 0 0 0 431
5news.albasani.net 479 13 0 62 0 0 0 0 404
6news.redatomik.org 238 0 0 59 0 0 0 0 179
7news-out.aioe.org 189 14 0 47 0 0 0 0 128
8agency-nz-out.news.mb-net.net 130 39 0 59 0 0 0 0 32
9news.freedyn.net 70 6 0 38 0 0 0 0 26
10news.samoylyk.net 70 0 0 60 0 0 0 0 10
11feeder.awxg.com 68 3 0 60 0 0 0 0 5
12news.swapon.de 60 0 0 5 0 0 0 0 55
13csiph.com 55 0 0 47 0 0 0 0 8
14news.ausics.org 7 0 0 7 0 0 0 0 0
15localhost 1 0 0 0 0 0 0 0 1
TOTAL: 15 8553 349 0 789 0 0 0 0 7415

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.varie 60
it.annunci.commerciali 58
it.annunci.immobiliari 38
mpc.lists.freebsd.ports.bugs 34
mpc.lists.nanog 20
gmane.linux.alsa.devel 16
mozilla.dev.security.policy 12
mozilla.support.seamonkey 9
gmane.comp.gis.openstreetmap.tagging 9
eagle.support.eng 8
mozilla.dev.platform 8
gmane.linux.kernel.samsung-soc 6
mozilla.dev.ui-alerts 5
gmane.comp.gis.openstreetmap.imports 5
fido7.ru.android 4
gmane.linux.drivers.devicetree 4
mozilla.support.bugzilla 4
alt.net.dn42.users 3
gmane.linux.kernel 3
al.christnet.bible 3
TOTAL: 53 349

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6039
EMP (phn path) 205
EMP (phn nph) 160
Binary: misplaced rar 115
Binary: non-binary distribution 115
EMP (phl) 76
Too many newsgroups 61
User-issued cancel 37
Too many newsgroups (low_xpost) 5
Binary Image: misplaced png 3
HTML post 3
Binary: misplaced par2 2
Binary: misplaced 070 1
Binary: misplaced 027 1
Binary: misplaced 058 1
Binary: misplaced 005 1
Binary: misplaced sfv 1
Binary: misplaced 043 1
TOTAL: 18 6827

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.freedyn.net 7
TOTAL: 1 7
Including strange strings
news-out.mixmin.net 212
news.redatomik.org 148
news.albasani.net 69
newsfeed.datemas.de 60
news.swapon.de 54
news-out.aioe.org 25
newsfeed.neva.ru 8
news.samoylyk.net 2
feeder.eternal-september.org 1
feeder.awxg.com 1
TOTAL: 11 581
TOTAL: 2 588

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20194 731 19436 27 0 0 3%23:59:42
2awxg 21412 166 21232 4 0 22 0%23:59:47
3news.snarked.org 21484 51 21414 10 0 89 0%23:57:43
4news.samoylyk.net 20210 51 19973 0 0 1132 0%23:59:36
5news.freedyn.net 22040 49 21747 2 0 112 0%23:59:45
6aioe 17348 45 17200 1 0 11 0%23:59:45
7csiph.com 16643 41 16510 3 0 16 0%23:59:45
8neva.ru 19802 28 19737 30 0 0 0%23:59:45
9news-in.mixmin.net 17104 25 17020 0 0 71 0%23:59:45
10eternal-september 18531 25 18479 0 0 20 0%23:59:45
11mb-net.net 21733 21 21651 5 0 21 0%23:59:45
12news.redatomik.org 20608 12 20453 1 0 3140 0%23:59:45
13news.swapon.de 1862 8 1842 7 0 20 0%23:44:10
14newsfeed.datemas.de 19876 8 19767 2 0 100 0%23:59:45
15news.albasani.net 22815 0 20342 1134 0 9832 0%23:57:49
TOTAL: 15 281662 1261 276803 1226 0 14586 0%359:36:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.5 MB532.2 KB11.0 MB0.1 KB/s14.9 KB23:59:42
2awxg484.4 KB27.2 KB511.6 KB0.0 KB/s3.0 KB23:59:47
3news.samoylyk.net107.3 KB0.0 KB107.3 KB0.0 KB/s2.1 KB23:59:36
4csiph.com104.7 KB163.8 KB268.5 KB0.0 KB/s6.1 KB23:59:45
5news.snarked.org104.7 KB17.3 KB121.9 KB0.0 KB/s2.0 KB23:57:43
6aioe98.2 KB1.5 KB99.8 KB0.0 KB/s2.2 KB23:59:45
7news.freedyn.net93.4 KB7.9 KB101.4 KB0.0 KB/s2.0 KB23:59:45
8news-in.mixmin.net65.2 KB0.0 KB65.2 KB0.0 KB/s2.6 KB23:59:45
9eternal-september65.2 KB0.0 KB65.2 KB0.0 KB/s2.6 KB23:59:45
10mb-net.net58.5 KB8.2 KB66.7 KB0.0 KB/s2.6 KB23:59:45
11neva.ru46.2 KB72.6 KB118.8 KB0.0 KB/s2.0 KB23:59:45
12news.redatomik.org25.0 KB1.2 KB26.2 KB0.0 KB/s2.0 KB23:59:45
13newsfeed.datemas.de12.7 KB3.0 KB15.7 KB0.0 KB/s1.6 KB23:59:45
14news.swapon.de12.5 KB35.4 KB47.9 KB0.0 KB/s3.2 KB23:44:10
15news.albasani.net0.0 KB4.0 MB4.0 MB0.0 KB/s3.6 KB23:57:49
TOTAL: 1511.8 MB4.8 MB16.6 MB0.0 KB/s6.8 KB359:36:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 918730.0 MB 1222 3 1802:01:13
2agency.bbs.geek.nz 408 691522.2 MB 3617 58172800:15:35
3vorlon.activateit.net.au 24 10681.4 MB 144 0 000:05:07
460.234.68.122 13 1955.2 KB 2 0 000:33:36
567-60-219-146.cpe.cableone.net 2 14.6 KB 0 0 021:13:22
6121.99.150.80 2 00.0 KB 0 0 200:01:12
TOTAL: 6 457 1719053.6 MB 4985 61174825:01:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 10 918830.0 MB 1222 3 1823:14:35
2*.bbs.geek.nz 408 691522.2 MB 3617 58172800:15:35
3*.activateit.net.au 24 10681.4 MB 144 0 000:05:07
4unresolved 26 1955.2 KB 2 0 201:25:56
TOTAL: 4 468 1719053.6 MB 4985 61174825:01:18

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 11
bpanther 8
malcolmlewis 2
TOTAL: 4 45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.168 0.096 0.00621:13:22
67-61-21-181.cpe.cableone.net 1.688 1.272 0.02202:01:13
60.234.68.122 0.824 0.112 0.03100:33:36
118.149.156.174 0.312 0.028 0.00000:21:18
118.149.246.196 0.248 0.024 0.00000:19:45
agency.bbs.geek.nz 29.764 6.552 0.00000:15:35
118.149.131.241 0.140 0.000 0.00000:10:02
vorlon.activateit.net.au 1.352 0.400 0.19600:05:07
121.99.150.80 0.112 0.016 0.00000:01:12
? 1.728 0.176 0.00000:00:02
TOTAL: 10 36.336 8.676 0.25525:01:18

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.156.174 5
118.149.246.196 4
118.149.131.241 2
TOTAL: 3 11

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
121.99.150.80 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 5547 32.3%
2soc 2278 13.3%
3alt 2047 11.9%
4comp 1922 11.2%
5sci 1591 9.3%
6linux 1438 8.4%
7uk 1137 6.6%
8talk 649 3.8%
9news 213 1.2%
10misc 186 1.1%
11nz 35 0.2%
12microsoft 28 0.2%
13perl 22 0.1%
14mozilla 22 0.1%
15humanities 20 0.1%
16agency 11 0.1%
17aus 4 0.0%
18us 3 0.0%
TOTAL: 18 17153100.0%

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

NewsgroupCount
1rec.arts.tv 882
2rec.arts.drwho 596
3uk.d-i-y 582
4alt.atheism 571
5alt.fan.rush-limbaugh 509
6linux.debian.changes.devel 490
7comp.lang.python 459
8rec.food.cooking 459
9rec.sport.tennis 456
10sci.physics 423
11linux.debian.bugs.dist 373
12soc.retirement 356
13rec.sport.football.college 333
14rec.gambling.poker 331
15sci.electronics.design 314
16rec.drugs.cannabis 307
17soc.culture.polish 295
18uk.legal 288
19soc.culture.israel 281
20talk.origins 267
21talk.politics.guns 235
22news.lists.filters 197
23sci.logic 191
24sci.math 182
25rec.sport.golf 172
26linux.debian.bugs.rc 171
27alt.comp.os.windows-10 171
28rec.music.rock-pop-r+b.1950s 164
29linux.debian.user 163
30alt.bible.prophecy 161
31comp.lang.c 152
32soc.culture.china 140
33comp.sys.mac.advocacy 140
34talk.politics.misc 132
35alt.politics.trump 118
36comp.sys.apple2 116
37sci.physics.relativity 108
38comp.lang.c++ 106
39soc.history 102
40soc.culture.singapore 102
41comp.os.linux.advocacy 101
42comp.sys.mac.apps 100
43rec.music.classical.recordings 97
44rec.radio.shortwave 96
45rec.aquaria.marine.misc 96
46soc.culture.indian 90
47sci.military.naval 89
48rec.outdoors.rv-travel 89
49rec.sport.pro-wrestling 88
50rec.arts.sf.written 88
51rec.woodworking 87
52uk.legal.moderated 86
53sci.med.cardiology 83
54soc.penpals 80
55rec.aviation.marketplace 80
56alt.politics 80
57soc.culture.usa 74
58rec.crafts.metalworking 73
59soc.culture.brazil 72
60rec.aviation.soaring 72
61comp.lang.forth 71
62alt.bible 71
63rec.arts.sf.fandom 69
64comp.sys.mac.system 67
65rec.autos.sport.f1 65
66rec.arts.movies.current-films 63
67alt.test 63
68alt.support.diabetes 62
69rec.sport.soccer 59
70alt.recovery.aa 57
71comp.os.vms 57
72linux.debian.maint.boot 55
73soc.genealogy.britain 54
74sci.electronics.repair 54
75comp.protocols.time.ntp 52
76misc.phone.mobile.iphone 46
77soc.history.what-if 44
78rec.boats 43
79rec.games.pinball 40
80rec.bicycles.tech 40
81misc.survivalism 40
82rec.humor 40
83sci.med.pharmacy 39
84comp.sys.raspberry-pi 39
85rec.photo.digital 37
86uk.radio.amateur 36
87soc.women 36
88linux.debian.user.french 35
89nz.general 35
90soc.culture.vietnamese 34
91soc.culture.australian 33
92rec.music.makers.guitar.jazz 32
93soc.culture.netherlands 31
94rec.arts.tv.uk.coronation-st 31
95comp.mobile.ipad 31
96comp.lang.apl 28
97soc.men 28
98comp.soft-sys.sas 28
99soc.culture.bulgaria 27
100comp.lang.javascript 27
TOTAL: 385 17153