news.bbs.geek.nz daily logs

Dec 30 23:58:02 -- Dec 31 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 121671 59.8%10.1 MB 39.3%
innd 30297 14.9%5.0 MB 19.3%
inn 27132 13.3%6.0 MB 23.3%
innfeed 22902 11.3%4.4 MB 17.2%
cnfsstat 1440 0.7%248.7 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 203443 100.0%25.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 256557 48.2%
Positive hits 250028 46.9%
Do not exist 25421 4.8%
Cache misses 633 0.1%
TOTAL: 4 532639 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.581 0.0%157 0.000 3.701 29.357
article cleanup00:00:00.252 0.0%26348 0.000 0.010 0.039
article logging00:00:00.845 0.0%26981 0.000 0.031 0.407
article parse00:00:00.942 0.0%89619 0.000 0.011 0.042
article write00:00:04.939 0.0%19413 0.000 0.254 22.921
artlog/artcncl00:00:00.001 0.0%150 0.000 0.007 1.000
data move00:00:00.486 0.0%533417 0.000 0.001 0.015
hisgrep/artcncl00:00:00.160 0.0%149 0.000 1.074 11.429
hishave/artcncl00:00:00.186 0.0%157 0.000 1.185 13.286
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.939 0.0%534629 0.001 0.015 0.584
history sync00:00:00.012 0.0%304 0.000 0.039 0.500
history write00:00:07.377 0.0%25514 0.012 0.289 14.032
hiswrite/artcncl00:00:00.006 0.0%8 0.000 0.750 6.000
idle23:57:20.284 99.8%547389 71.742 157.548 481.786
nntp read00:00:03.136 0.0%548667 0.002 0.006 0.031
overview write00:00:40.281 0.0%19413 0.043 2.075 71.232
perl filter00:00:50.029 0.1%25514 1.376 1.961 4.103
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.291 0.0%38826 0.008 0.033 0.153
TOTAL: 24:00:22.87423:59:18.747 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%23279 0.000 0.003 0.033
article prepare00:00:00.000 0.0%5628 0.000 0.000 0.000
article read00:00:00.177 0.0%1186 0.000 0.149 5.000
backlog stats00:00:00.273 0.0%309352 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.548 0.0%257395 0.002 0.006 0.015
data write00:00:02.904 0.0%242607 0.006 0.012 0.025
idle23:53:56.923 99.9%309352 162.193 278.120 731.809
status file00:00:20.148 0.0%1784 0.700 11.294 460.730
TOTAL: 23:54:44.91623:54:22.038100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%23 0.000 0.043 0.083
idle10:34:21.772 90.7%138614 0.000 274.588 72026.322
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:20.020 0.2%314953 0.000 0.254 3.463
readart00:00:02.992 0.0%19257 0.000 0.155 17.000
TOTAL: 11:39:13.36210:35:44.785 90.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 46 15830 5379 10178 273 33%41:21:54
2news-out.mixmin.net 7 20838 4568 15138 1132 21%25:40:52
3feeder.eternal-september.org 54 22512 2204 18850 1458 9%41:06:17
4news-out.aioe.org 2 18142 2149 15923 70 11%22:27:20
5newsfeed.neva.ru 145 15737 1118 12192 2427 7%83:48:02
6news.redatomik.org 1 18075 1048 16951 76 5%23:35:39
7csiph.com 2 21888 1029 20696 163 4%26:27:48
8newsfeed.datemas.de 4 21881 946 20659 276 4%26:41:55
9news.albasani.net 1 17941 451 17282 208 2%18:56:47
10news.swapon.de 3 2005 207 1789 9 10%22:39:14
11feeder.awxg.com 1 17019 121 16831 67 0%23:59:57
12agency-nz-out.news.mb-net.net 12 20850 86 20468 296 0%28:24:11
13news.samoylyk.net 3 25804 55 25397 352 0%24:09:00
14news.freedyn.net 1 21629 53 21509 67 0%23:08:20
15localhost 9 8 8 0 0 100%00:00:00
TOTAL: 15 291 260159 19422 233863 6874 7%432:27:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org18.7 MB248.8 KB1.0 MB20.0 MB 93%3.6 KB
2news-out.mixmin.net13.9 MB280.0 KB2.4 MB16.5 MB 84%3.0 KB
3feeder.eternal-september.org8.3 MB475.6 KB5.4 MB14.1 MB 58%3.9 KB
4newsfeed.datemas.de7.8 MB310.0 KB1000.5 KB9.1 MB 85%7.6 KB
5news-out.aioe.org5.5 MB103.7 KB159.4 KB5.7 MB 95%2.6 KB
6news.albasani.net4.4 MB188.1 KB470.6 KB5.1 MB 87%7.9 KB
7csiph.com3.1 MB179.8 KB500.5 KB3.8 MB 82%3.2 KB
8newsfeed.neva.ru2.7 MB340.2 KB14.2 MB17.3 MB 15%5.0 KB
9news.redatomik.org2.4 MB159.6 KB185.7 KB2.7 MB 87%2.5 KB
10news.freedyn.net670.2 KB137.7 KB232.7 KB1.0 MB 64%8.7 KB
11news.swapon.de662.7 KB18.0 KB24.7 KB705.5 KB 93%3.3 KB
12agency-nz-out.news.mb-net.net374.5 KB169.9 KB21.5 MB22.1 MB 1%59.2 KB
13feeder.awxg.com331.5 KB198.1 KB201.4 KB731.0 KB 45%3.9 KB
14news.samoylyk.net171.1 KB179.9 KB6.4 MB6.7 MB 2%16.9 KB
15localhost9.0 KB0.0 KB0.0 KB9.0 KB100%1.1 KB
TOTAL: 1568.9 MB2.9 MB53.6 MB125.5 MB 54%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 30 23:58:02 - 23:59:59 22 0.1% 0.1959.6 KB 0.1% 0.50
Dec 31 00:00:00 - 00:59:59 1026 5.3% 0.282.6 MB 3.8% 0.73
Dec 31 01:00:00 - 01:59:59 820 4.2% 0.232.4 MB 3.5% 0.67
Dec 31 02:00:00 - 02:59:59 946 4.9% 0.266.1 MB 8.9% 1.72
Dec 31 03:00:00 - 03:59:59 1058 5.4% 0.292.9 MB 4.2% 0.81
Dec 31 04:00:00 - 04:59:59 1085 5.6% 0.303.4 MB 5.0% 0.96
Dec 31 05:00:00 - 05:59:59 1082 5.6% 0.304.3 MB 6.3% 1.21
Dec 31 06:00:00 - 06:59:59 1236 6.4% 0.346.6 MB 9.8% 1.89
Dec 31 07:00:00 - 07:59:59 1278 6.6% 0.353.4 MB 5.0% 0.96
Dec 31 08:00:00 - 08:59:59 1199 6.2% 0.333.6 MB 5.3% 1.02
Dec 31 09:00:00 - 09:59:59 1064 5.5% 0.302.9 MB 4.3% 0.83
Dec 31 10:00:00 - 10:59:59 1079 5.6% 0.303.3 MB 4.8% 0.93
Dec 31 11:00:00 - 11:59:59 1038 5.3% 0.293.5 MB 5.1% 0.99
Dec 31 12:00:00 - 12:59:59 836 4.3% 0.232.6 MB 3.8% 0.73
Dec 31 13:00:00 - 13:59:59 655 3.4% 0.183.0 MB 4.5% 0.86
Dec 31 14:00:00 - 14:59:59 526 2.7% 0.151.6 MB 2.4% 0.46
Dec 31 15:00:00 - 15:59:59 435 2.2% 0.121.5 MB 2.2% 0.42
Dec 31 16:00:00 - 16:59:59 441 2.3% 0.121.5 MB 2.2% 0.43
Dec 31 17:00:00 - 17:59:59 357 1.8% 0.101.5 MB 2.2% 0.43
Dec 31 18:00:00 - 18:59:59 499 2.6% 0.141.8 MB 2.7% 0.53
Dec 31 19:00:00 - 19:59:59 353 1.8% 0.101.5 MB 2.2% 0.43
Dec 31 20:00:00 - 20:59:59 421 2.2% 0.121.6 MB 2.3% 0.44
Dec 31 21:00:00 - 21:59:59 527 2.7% 0.151.9 MB 2.9% 0.55
Dec 31 22:00:00 - 22:59:59 708 3.6% 0.202.1 MB 3.2% 0.61
Dec 31 23:00:00 - 23:58:01 727 3.7% 0.212.3 MB 3.4% 0.67
TOTAL: 23:59:59 19418 100.0% 0.2267.9 MB 100.0% 0.80
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.6 GB 45.1% 0 0.31 1932.42
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.1 GB 52.3% 0 0.32 1911.19
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB281.3 MB 0.5% 0 0.0511469.53
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.2 GB 28.4% 0 0.73 830.14
TOTAL: 10-500.0 GB63.2 GB 12.6% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2421 14 0 56 0 0 0 0 2351
2feeder.eternal-september.org 1531 0 0 140 0 0 0 0 1391
3news-out.mixmin.net 1478 0 0 76 0 0 0 0 1402
4news.samoylyk.net 375 0 0 60 0 0 0 0 315
5agency-nz-out.news.mb-net.net 317 12 0 60 0 0 0 0 245
6newsfeed.datemas.de 299 22 0 68 0 0 0 0 209
7news.snarked.org 261 21 0 59 0 0 0 0 181
8news.albasani.net 239 4 0 61 0 0 0 0 174
9news.redatomik.org 207 0 0 62 0 0 0 0 145
10csiph.com 151 0 0 41 0 0 0 0 110
11news-out.aioe.org 88 0 0 43 0 0 0 0 45
12news.freedyn.net 69 3 0 50 0 0 0 0 16
13news.swapon.de 65 0 0 5 0 0 0 0 60
14feeder.awxg.com 61 1 0 57 0 0 0 0 3
15news.ausics.org 2 0 0 1 0 0 0 0 1
TOTAL: 15 7564 77 0 839 0 0 0 0 6648

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.support.seamonkey 11
mpc.lists.nanog 8
gmane.linux.bios.flashrom 6
gmane.comp.gis.openstreetmap.tagging 6
mpc.lists.freebsd.x11 5
gmane.comp.gis.openstreetmap.imports 5
mpc.lists.freebsd.gecko 4
eagle.support.eng 4
ab.test 3
mozilla.dev.ui-alerts 3
south-wales.test 3
mozilla.dev.l10n.new-locales 2
alt.multimedia 2
mozilla.dev.apps.thunderbird 2
usc.forsale 1
alt.penthouse.sex.femdom 1
demos.local.statistics 1
mozilla.dev.l10n.sr 1
alt.forsale.seattle 1
mpc.lists.freebsd.office 1
TOTAL: 27 77

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4566
EMP (phn path) 449
EMP (phn nph) 358
Binary Image: misplaced jpg 252
Binary: misplaced rar 243
Too many newsgroups 69
EMP (phl) 27
Binary: non-binary distribution 21
User-issued cancel 14
Binary: misplaced par2 5
User-issued spam cancel 2
Too many newsgroups (meow) 2
Binary: misplaced 025 1
HTML post 1
Binary Image: misplaced png 1
Binary: misplaced 010 1
Binary: misplaced 016 1
Too many newsgroups (low_xpost) 1
Binary: misplaced 031 1
TOTAL: 19 6015

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 333
news.redatomik.org 133
news.swapon.de 57
newsfeed.datemas.de 49
news.albasani.net 31
news-out.aioe.org 20
news.snarked.org 4
newsfeed.neva.ru 2
news.samoylyk.net 1
feeder.eternal-september.org 1
TOTAL: 12 633
TOTAL: 1 633

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17684 840 16829 15 0 0 4%23:59:39
2awxg 18814 88 18711 0 0 6 0%23:59:43
3news.freedyn.net 19557 19 19342 3 0 2 0%23:59:28
4news.snarked.org 14090 12 13946 0 0 17 0%23:59:39
5csiph.com 18744 11 18449 0 0 0 0%23:59:32
6news.samoylyk.net 18013 10 17628 3 0 7 0%23:59:24
7news.redatomik.org 18351 8 18293 0 0 0 0%23:59:39
8news-in.mixmin.net 14273 8 14255 0 0 0 0%23:59:36
9mb-net.net 19317 8 19251 1 0 91 0%23:59:36
10eternal-september 16264 8 16239 0 0 0 0%23:59:27
11neva.ru 18084 8 18058 2 0 0 0%23:59:36
12aioe 15889 7 15795 0 0 0 0%23:59:36
13newsfeed.datemas.de 18391 6 18336 0 0 146 0%23:59:36
14news.albasani.net 15674 3 14434 300 0 7078 0%23:59:36
15news.swapon.de 1904 0 1903 0 0 0 0%23:50:39
TOTAL: 15 245049 1036 241469 324 0 7347 0%359:44:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org5.5 MB152.4 KB5.7 MB0.1 KB/s6.8 KB23:59:39
2awxg416.6 KB0.0 KB416.6 KB0.0 KB/s4.7 KB23:59:43
3news.freedyn.net40.1 KB13.3 KB53.5 KB0.0 KB/s2.4 KB23:59:28
4news.snarked.org18.8 KB0.0 KB18.8 KB0.0 KB/s1.6 KB23:59:39
5news.samoylyk.net16.6 KB11.5 KB28.1 KB0.0 KB/s2.2 KB23:59:24
6csiph.com16.0 KB0.0 KB16.0 KB0.0 KB/s1.5 KB23:59:32
7mb-net.net9.3 KB18.0 KB27.3 KB0.0 KB/s3.0 KB23:59:36
8news.redatomik.org9.1 KB0.0 KB9.1 KB0.0 KB/s1.1 KB23:59:39
9news-in.mixmin.net9.1 KB0.0 KB9.1 KB0.0 KB/s1.1 KB23:59:36
10eternal-september9.1 KB0.0 KB9.1 KB0.0 KB/s1.1 KB23:59:27
11neva.ru9.1 KB4.8 KB13.9 KB0.0 KB/s1.4 KB23:59:36
12aioe8.1 KB0.0 KB8.1 KB0.0 KB/s1.2 KB23:59:36
13newsfeed.datemas.de6.3 KB0.0 KB6.3 KB0.0 KB/s1.0 KB23:59:36
14news.albasani.net2.9 KB723.2 KB726.1 KB0.0 KB/s2.4 KB23:59:36
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:39
TOTAL: 156.1 MB923.2 KB7.0 MB0.0 KB/s5.3 KB359:44:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 844730.7 MB 1163 0 1603:11:34
2agency.bbs.geek.nz 343 734225.1 MB 3356 8 000:12:38
3vorlon.activateit.net.au 24 9611.3 MB 141 0 000:04:44
4192.168.1.7 5 222636.9 KB 6 0 000:00:06
558-6-92-131.dyn.iinet.net.au 7 41150.9 KB 1 0 000:05:06
TOTAL: 5 387 1701357.9 MB 4667 8 1611:51:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 12 844730.7 MB 1163 0 1610:14:11
2*.bbs.geek.nz 343 734225.1 MB 3356 8 000:12:38
3*.activateit.net.au 24 9611.3 MB 141 0 000:04:44
4unresolved 18 222636.9 KB 6 0 001:14:24
5*.dyn.iinet.net.au 7 41150.9 KB 1 0 000:05:06
TOTAL: 5 404 1701357.9 MB 4667 8 1611:51:08

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 6
paulh 5
malcolmlewis 4
TOTAL: 5 47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.192 0.036 0.00807:02:36
67-61-21-181.cpe.cableone.net 1.680 1.192 0.02303:11:34
118.149.229.19 0.352 0.056 0.00000:44:09
118.149.187.248 0.296 0.028 0.00000:20:06
agency.bbs.geek.nz 24.832 6.008 0.00000:12:38
118.149.175.24 0.120 0.020 0.00000:10:02
58-6-92-131.dyn.iinet.net.au 0.500 0.072 0.01800:05:06
vorlon.activateit.net.au 1.352 0.404 0.18700:04:44
192.168.1.7 0.336 0.080 0.01400:00:06
? 1.404 0.172 0.00000:00:02
TOTAL: 10 31.064 8.068 0.25011:51:08

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.187.248 6
118.149.229.19 5
67-60-219-146.cpe.cableone.net 4
118.149.175.24 2
TOTAL: 4 17

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
58-6-92-131.dyn.iinet.net.au 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
118.149.229.19 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5166 30.4%
2alt 2018 11.9%
3comp 1997 11.8%
4linux 1569 9.2%
5soc 1444 8.5%
6sci 1369 8.1%
7uk 1273 7.5%
8talk 855 5.0%
9misc 775 4.6%
10news 201 1.2%
11nz 148 0.9%
12mozilla 87 0.5%
13humanities 26 0.2%
14us 21 0.1%
15agency 18 0.1%
16microsoft 13 0.1%
17aus 6 0.0%
18eternal-september 4 0.0%
TOTAL: 18 16990100.0%

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

NewsgroupCount
1rec.arts.tv 1039
2rec.arts.drwho 661
3alt.atheism 554
4uk.d-i-y 554
5alt.fan.rush-limbaugh 503
6talk.politics.guns 489
7comp.lang.python 482
8linux.debian.changes.devel 476
9linux.debian.bugs.dist 443
10misc.survivalism 384
11rec.food.cooking 308
12soc.culture.polish 305
13soc.retirement 298
14rec.arts.sf.written 298
15misc.phone.mobile.iphone 291
16rec.boats 275
17uk.legal 263
18talk.politics.misc 260
19rec.sport.football.college 248
20sci.electronics.design 241
21rec.sport.pro-wrestling 212
22sci.logic 195
23sci.physics 182
24rec.crafts.metalworking 179
25comp.os.linux.advocacy 175
26news.lists.filters 173
27alt.comp.os.windows-10 169
28comp.lang.c 168
29sci.military.naval 166
30comp.mobile.android 166
31comp.lang.idl-pvwave 165
32rec.radio.shortwave 158
33rec.gambling.poker 149
34comp.sys.mac.system 145
35nz.general 142
36alt.conspiracy.jfk 141
37soc.culture.china 139
38rec.music.classical.recordings 128
39sci.med.cardiology 121
40linux.debian.bugs.rc 119
41sci.math 118
42sci.physics.relativity 115
43linux.debian.maint.boot 114
44soc.culture.israel 110
45rec.sport.tennis 103
46rec.sport.cricket 102
47alt.recovery.aa 102
48talk.origins 99
49rec.woodworking 97
50comp.os.vms 96
51uk.comp.sys.mac 96
52rec.aquaria.marine.misc 88
53comp.mobile.ipad 86
54alt.politics.trump 86
55sci.crypt 85
56rec.aviation.marketplace 80
57alt.test 79
58soc.culture.singapore 76
59alt.politics 69
60alt.support.diabetes 66
61linux.gentoo.user 64
62soc.culture.indian 64
63uk.legal.moderated 63
64rec.bicycles.tech 61
65rec.sport.golf 59
66uk.rec.cars.maintenance 58
67soc.culture.brazil 58
68uk.tech.digital-tv 57
69linux.debian.devel 57
70alt.bible 55
71uk.radio.amateur 55
72rec.aviation.soaring 52
73rec.music.rock-pop-r+b.1950s 51
74soc.culture.usa 50
75rec.games.pinball 48
76comp.protocols.time.ntp 48
77comp.sys.raspberry-pi 46
78linux.debian.user.russian 46
79comp.lang.forth 45
80rec.music.dylan 45
81alt.astronomy 44
82uk.rec.driving 42
83soc.penpals 41
84uk.rec.cycling 40
85mozilla.general 40
86rec.arts.sf.tv 40
87rec.sport.soccer 39
88comp.sys.apple2 39
89soc.culture.vietnamese 38
90comp.lang.ada 36
91misc.health.alternative 35
92alt.bbs.mystic 32
93rec.outdoors.rv-travel 32
94soc.genealogy.britain 30
95sci.electronics.repair 30
96mozilla.support.thunderbird 30
97soc.history.what-if 29
98linux.debian.user.french 29
99rec.music.makers.guitar.jazz 28
100linux.gentoo.dev 28
TOTAL: 364 16990