news.bbs.geek.nz daily logs

Nov 22 23:58:02 -- Nov 23 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 145827 62.0%12.0 MB 41.5%
innd 33182 14.1%5.3 MB 18.3%
inn 31607 13.4%6.8 MB 23.5%
innfeed 23314 9.9%4.6 MB 15.8%
cnfsstat 1440 0.6%248.5 KB 0.8%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 235371 100.0%28.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 307814 50.2%
Positive hits 275634 44.9%
Do not exist 29842 4.9%
Cache misses 228 0.0%
TOTAL: 4 613518 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.886 0.0%150 0.000 5.907 49.769
article cleanup00:00:00.317 0.0%30853 0.000 0.010 0.038
article logging00:00:00.834 0.0%31492 0.000 0.026 0.137
article parse00:00:00.928 0.0%80294 0.000 0.012 0.028
article write00:00:01.646 0.0%21338 0.020 0.077 0.577
artlog/artcncl00:00:00.001 0.0%139 0.000 0.007 0.500
data move00:00:00.358 0.0%586258 0.000 0.001 0.007
hisgrep/artcncl00:00:00.515 0.0%149 0.000 3.456 39.462
hishave/artcncl00:00:00.100 0.0%150 0.000 0.667 7.692
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.729 0.0%615919 0.001 0.014 0.705
history sync00:00:00.009 0.0%357 0.000 0.025 0.667
history write00:00:09.373 0.0%29955 0.000 0.313 16.391
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:36.034 99.8%601159 84.149 143.483 376.364
nntp read00:00:03.318 0.0%603159 0.003 0.006 0.020
overview write00:00:45.982 0.1%21338 0.026 2.155 87.890
perl filter00:00:59.057 0.1%29955 1.251 1.972 11.175
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.348 0.0%42676 0.007 0.032 0.100
TOTAL: 24:00:49.09023:59:49.435 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.076 0.0%28657 0.000 0.003 0.031
article prepare00:00:00.002 0.0%10528 0.000 0.000 0.016
article read00:00:00.324 0.0%2360 0.000 0.137 4.548
backlog stats00:00:00.280 0.0%339261 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.722 0.0%284377 0.000 0.006 0.012
data write00:00:03.125 0.0%269723 0.006 0.012 0.017
idle23:53:28.759100.0%339261 144.896 253.518 593.623
status file00:00:09.406 0.0%1944 0.636 4.838 170.690
TOTAL: 23:54:04.03023:53:43.694100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle32:07:25.958 99.0%164194 0.000 704.325 57640.711
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:23.107 0.1%364841 0.000 0.228 16.679
readart00:00:03.977 0.0%17710 0.000 0.225 13.609
TOTAL: 32:26:35.20532:08:53.042 99.1%----

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 40 16589 4707 11583 299 28%46:17:12
2newsfeed.datemas.de 2 23358 3560 18991 807 15%25:13:09
3news-out.aioe.org 3 21060 2447 18487 126 11%23:59:46
4news-out.mixmin.net 9 22623 2249 19549 825 9%26:06:47
5feeder.eternal-september.org 75 26457 2018 22758 1681 7%47:44:49
6news.redatomik.org 1 19180 1615 17508 57 8%23:00:54
7newsfeed.neva.ru 154 15262 1479 9623 4160 9%79:25:32
8news.albasani.net 1 23759 1365 21743 651 5%24:41:23
9csiph.com 2 19817 1108 18671 38 5%22:59:14
10news.swapon.de 2 1727 207 1511 9 11%22:00:15
11agency-nz-out.news.mb-net.net 19 24894 110 24647 137 0%35:56:45
12feeder.awxg.com 1 18489 89 18349 51 0%23:59:57
13news.samoylyk.net 2 25053 68 24575 410 0%19:44:15
14news.freedyn.net 1 13406 17 13359 30 0%14:29:27
15localhost 1 0 0 0 0 0%00:00:00
TOTAL: 15 313 271674 21039 241354 9281 7%435:39:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.datemas.de17.6 MB406.7 KB2.9 MB20.9 MB 84%4.9 KB
2news.snarked.org14.4 MB225.1 KB957.6 KB15.5 MB 92%3.2 KB
3feeder.eternal-september.org7.2 MB678.9 KB6.1 MB14.0 MB 51%3.9 KB
4news-out.mixmin.net6.9 MB246.8 KB1.8 MB8.9 MB 77%2.9 KB
5news.albasani.net6.4 MB900.3 KB2.3 MB9.5 MB 66%4.8 KB
6news-out.aioe.org5.4 MB137.5 KB311.3 KB5.8 MB 92%2.3 KB
7news.redatomik.org3.7 MB295.4 KB307.4 KB4.3 MB 86%2.6 KB
8newsfeed.neva.ru3.7 MB348.5 KB24.8 MB28.8 MB 12%5.2 KB
9csiph.com3.2 MB134.4 KB190.5 KB3.5 MB 90%3.1 KB
10agency-nz-out.news.mb-net.net522.2 KB198.0 KB774.6 KB1.5 MB 34%6.1 KB
11news.swapon.de517.0 KB13.4 KB351.0 KB881.4 KB 58%4.1 KB
12news.samoylyk.net374.3 KB741.6 KB5.6 MB6.7 MB 5%14.3 KB
13feeder.awxg.com247.6 KB158.5 KB166.0 KB572.1 KB 43%4.1 KB
14news.freedyn.net236.5 KB138.3 KB163.0 KB537.8 KB 43%11.4 KB
15localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1570.2 MB4.5 MB46.6 MB121.3 MB 57%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 22 23:58:02 - 23:59:59 24 0.1% 0.2052.6 KB 0.1% 0.45
Nov 23 00:00:00 - 00:59:59 909 4.3% 0.252.3 MB 3.2% 0.65
Nov 23 01:00:00 - 01:59:59 897 4.2% 0.253.2 MB 4.4% 0.90
Nov 23 02:00:00 - 02:59:59 1004 4.7% 0.282.6 MB 3.6% 0.74
Nov 23 03:00:00 - 03:59:59 1111 5.2% 0.313.3 MB 4.5% 0.93
Nov 23 04:00:00 - 04:59:59 1171 5.5% 0.333.7 MB 5.1% 1.05
Nov 23 05:00:00 - 05:59:59 1445 6.8% 0.405.0 MB 6.9% 1.41
Nov 23 06:00:00 - 06:59:59 1182 5.5% 0.333.1 MB 4.3% 0.88
Nov 23 07:00:00 - 07:59:59 1210 5.7% 0.343.7 MB 5.1% 1.05
Nov 23 08:00:00 - 08:59:59 1208 5.7% 0.345.1 MB 7.1% 1.46
Nov 23 09:00:00 - 09:59:59 1218 5.7% 0.343.8 MB 5.3% 1.08
Nov 23 10:00:00 - 10:59:59 1067 5.0% 0.304.9 MB 6.8% 1.39
Nov 23 11:00:00 - 11:59:59 1018 4.8% 0.283.5 MB 4.9% 1.00
Nov 23 12:00:00 - 12:59:59 737 3.5% 0.202.8 MB 3.9% 0.80
Nov 23 13:00:00 - 13:59:59 709 3.3% 0.202.2 MB 3.0% 0.61
Nov 23 14:00:00 - 14:59:59 454 2.1% 0.131.7 MB 2.3% 0.47
Nov 23 15:00:00 - 15:59:59 488 2.3% 0.141.6 MB 2.2% 0.45
Nov 23 16:00:00 - 16:59:59 467 2.2% 0.131.6 MB 2.2% 0.45
Nov 23 17:00:00 - 17:59:59 412 1.9% 0.112.6 MB 3.6% 0.74
Nov 23 18:00:00 - 18:59:59 457 2.1% 0.132.6 MB 3.6% 0.73
Nov 23 19:00:00 - 19:59:59 489 2.3% 0.141.9 MB 2.7% 0.55
Nov 23 20:00:00 - 20:59:59 724 3.4% 0.202.3 MB 3.2% 0.66
Nov 23 21:00:00 - 21:59:59 904 4.2% 0.252.4 MB 3.4% 0.70
Nov 23 22:00:00 - 22:59:59 958 4.5% 0.272.9 MB 4.0% 0.82
Nov 23 23:00:00 - 23:58:02 1063 5.0% 0.313.4 MB 4.7% 0.99
TOTAL: 24:00:00 21326 100.0% 0.2572.1 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB21.7 GB 43.4% 0 0.31 1977.77
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB25.1 GB 50.3% 0 0.39 1560.10
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB271.1 MB 0.5% 0 0.0417004.83
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.1 GB 24.3% 0 0.70 872.41
TOTAL: 10-500.0 GB59.3 GB 11.9% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 4282 96 0 51 0 0 0 0 4135
2feeder.eternal-september.org 1668 0 0 166 0 0 0 0 1502
3newsfeed.datemas.de 943 251 0 71 0 0 0 0 621
4news-out.mixmin.net 908 0 0 92 0 0 0 0 816
5news.albasani.net 760 13 0 81 0 0 0 0 666
6news.samoylyk.net 488 0 0 70 0 0 0 0 418
7news.snarked.org 310 33 0 69 0 0 0 0 208
8news.redatomik.org 277 0 0 54 0 0 0 0 223
9news-out.aioe.org 137 9 0 42 0 0 0 0 86
10agency-nz-out.news.mb-net.net 133 31 0 65 0 0 0 0 37
11news.freedyn.net 82 7 0 48 0 0 0 0 27
12feeder.awxg.com 56 0 0 49 0 0 0 0 7
13news.swapon.de 52 0 0 2 0 0 0 0 50
14csiph.com 45 0 0 37 0 0 0 0 8
15news.ausics.org 1 0 0 1 0 0 0 0 0
TOTAL: 15 10142 440 0 898 0 0 0 0 8804

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 70
gmane.linux.alsa.devel 51
it.annunci.commerciali 36
it.annunci.varie 35
it.annunci.immobiliari 35
mozilla.dev.security.policy 29
mpc.lists.freebsd.ports.bugs 28
gmane.linux.kernel.clk 16
mozilla.support.seamonkey 14
mozilla.dev.platform 13
mpc.lists.nanog 13
mpc.lists.freebsd.gecko 12
gmane.linux.kernel 10
gmane.comp.gis.openstreetmap.tagging 8
mozilla.dev.l10n.sr 6
mozilla.tools.taskcluster 6
mozilla.dev.ui-alerts 5
mozilla.dev.tech.crypto 4
mozilla.support.bugzilla 4
nemo.test 4
TOTAL: 47 440

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6739
EMP (phn path) 505
Binary: misplaced rar 433
EMP (phn nph) 350
Too many newsgroups 55
Binary: non-binary distribution 30
EMP (phl) 23
User-issued cancel 14
HTML post 9
Too many newsgroups (low_xpost) 3
Cancel for rejected article 1
Binary: misplaced 033 1
Binary: misplaced 028 1
Binary: misplaced 009 1
TOTAL: 14 8165

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 222
newsfeed.datemas.de 126
news.albasani.net 103
news-out.mixmin.net 102
news.swapon.de 45
news-out.aioe.org 15
newsfeed.neva.ru 10
news.snarked.org 6
feeder.awxg.com 4
agency-nz-out.news.mb-net.net 4
TOTAL: 12 639
TOTAL: 1 639

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19474 990 18343 141 0 0 5%23:59:40
2awxg 21162 135 20663 3 0 11 0%23:59:44
3eternal-september 18849 13 18245 3 0 9 0%23:59:44
4news.freedyn.net 21409 7 21239 4 0 10 0%23:59:42
5news.snarked.org 16466 5 16402 6 0 6 0%23:59:35
6mb-net.net 21203 2 21168 0 0 0 0%23:59:44
7news.albasani.net 22181 1 18519 1186 0 7359 0%23:59:44
8news.redatomik.org 19571 0 19546 2 0 0 0%23:59:44
9news.samoylyk.net 19456 0 19402 0 0 0 0%23:59:43
10news.swapon.de 1710 0 1710 0 0 0 0%23:40:09
11neva.ru 19327 0 19322 0 0 0 0%23:59:44
12csiph.com 20288 0 20182 0 0 1 0%23:59:43
13news-in.mixmin.net 18388 0 18373 0 0 0 0%23:59:44
14aioe 17912 0 17739 0 0 0 0%23:59:44
15newsfeed.datemas.de 17772 0 17763 0 0 0 0%23:59:44
TOTAL: 15 275168 1153 268616 1345 0 7396 0%359:36:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.8 MB10.2 MB14.9 MB0.2 KB/s13.5 KB23:59:40
2awxg586.7 KB12.0 KB598.7 KB0.0 KB/s4.3 KB23:59:44
3eternal-september34.1 KB21.9 KB56.0 KB0.0 KB/s3.5 KB23:59:44
4news.snarked.org19.7 KB12.7 KB32.4 KB0.0 KB/s2.9 KB23:59:35
5news.freedyn.net13.5 KB27.0 KB40.5 KB0.0 KB/s3.7 KB23:59:42
6mb-net.net4.5 KB0.0 KB4.5 KB0.0 KB/s2.2 KB23:59:44
7news.albasani.net2.4 KB4.2 MB4.2 MB0.1 KB/s3.6 KB23:59:44
8news.redatomik.org0.0 KB2.4 KB2.4 KB0.0 KB/s1.2 KB23:59:44
9news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
10news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:09
11neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
12csiph.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
13news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
14aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
15newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
TOTAL: 155.4 MB14.5 MB19.9 MB0.0 KB/s8.1 KB359:36:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 5 949333.4 MB 769 0 803:16:00
2agency.bbs.geek.nz 384 687024.5 MB 4086 0 000:43:43
3163.47.16.169 24 720970.1 KB 116 0 000:04:11
467-60-219-146.cpe.cableone.net 2 26.6 KB 2 0 028:05:51
TOTAL: 4 415 1708558.8 MB 4973 0 832:26:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 7 949533.4 MB 771 0 831:21:51
2*.bbs.geek.nz 384 687024.5 MB 4086 0 000:43:43
3unresolved 31 720970.1 KB 116 0 000:20:28
TOTAL: 3 422 1708558.8 MB 4973 0 832:26:27

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 4
malcolmlewis 2
TOTAL: 3 30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.260 0.072 0.00928:05:51
67-61-21-181.cpe.cableone.net 1.140 1.148 0.01203:16:00
agency.bbs.geek.nz 27.900 7.108 0.00000:43:43
118.149.152.30 0.176 0.020 0.00000:11:59
118.149.185.61 0.052 0.016 0.00000:04:11
163.47.16.169 1.400 0.328 0.20600:04:11
? 1.292 0.184 0.00000:00:24
94.164.45.164 0.096 0.028 0.00000:00:04
185.100.87.250 0.056 0.008 0.00000:00:01
TOTAL: 9 32.372 8.912 0.22732:26:27

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.152.30 3
94.164.45.164 2
185.100.87.250 1
118.149.185.61 1
TOTAL: 4 7

NNRP gethostbyaddr failures [Top 20]:

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

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 5042 29.5%
2alt 2162 12.7%
3soc 1939 11.3%
4comp 1743 10.2%
5sci 1723 10.1%
6uk 1303 7.6%
7linux 1118 6.5%
8talk 971 5.7%
9misc 601 3.5%
10mozilla 203 1.2%
11news 176 1.0%
12microsoft 30 0.2%
13nz 24 0.1%
14aus 22 0.1%
15us 18 0.1%
16humanities 10 0.1%
TOTAL: 16 17085100.0%

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

NewsgroupCount
1rec.arts.tv 1240
2uk.d-i-y 699
3alt.atheism 612
4talk.politics.guns 512
5rec.food.cooking 504
6alt.fan.rush-limbaugh 449
7soc.retirement 442
8misc.survivalism 436
9sci.math 382
10rec.boats 339
11linux.debian.bugs.dist 337
12sci.physics 334
13comp.lang.c 330
14soc.culture.israel 314
15sci.physics.relativity 249
16uk.legal 233
17talk.politics.misc 224
18talk.origins 202
19rec.crafts.metalworking 195
20soc.culture.polish 190
21comp.os.linux.advocacy 187
22linux.debian.changes.devel 176
23rec.radio.shortwave 176
24sci.electronics.design 167
25alt.politics.trump 165
26rec.sport.tennis 159
27rec.sport.football.college 157
28rec.sport.pro-wrestling 155
29alt.politics 151
30rec.photo.digital 146
31news.lists.filters 140
32alt.comp.os.windows-10 134
33comp.sys.apple2 133
34rec.gambling.poker 131
35alt.test 126
36linux.debian.bugs.rc 123
37rec.sport.soccer 122
38mozilla.general 121
39uk.tech.digital-tv 118
40comp.lang.python 115
41rec.woodworking 110
42sci.lang 110
43rec.outdoors.rv-travel 109
44comp.lang.ada 104
45soc.culture.vietnamese 96
46alt.rush-limbaugh 95
47soc.penpals 94
48sci.electronics.repair 93
49rec.arts.sf.written 92
50rec.arts.tv.uk.coronation-st 92
51sci.logic 85
52linux.debian.user 85
53uk.radio.amateur 83
54soc.culture.singapore 83
55sci.military.naval 81
56rec.arts.drwho 81
57soc.culture.china 80
58soc.culture.indian 78
59comp.mobile.android 76
60rec.sport.golf 75
61comp.sys.raspberry-pi 72
62mozilla.support.firefox 71
63alt.conspiracy 70
64soc.culture.usa 66
65soc.culture.brazil 65
66sci.math.num-analysis 64
67rec.arts.movies.past-films 57
68alt.support.diabetes 56
69uk.legal.moderated 52
70rec.sport.cricket 52
71uk.comp.sys.mac 51
72alt.recovery.aa 51
73soc.culture.greek 50
74rec.aviation.soaring 49
75rec.music.rock-pop-r+b.1950s 49
76misc.phone.mobile.iphone 48
77linux.debian.devel 47
78rec.arts.sf.fandom 46
79rec.arts.poems 45
80rec.games.pinball 44
81linux.debian.user.german 43
82soc.history.what-if 43
83alt.os.linux.ubuntu 42
84soc.history.medieval 41
85rec.bicycles.tech 41
86comp.lang.fortran 41
87comp.lang.c++ 40
88rec.aquaria.marine.misc 40
89linux.gentoo.user 39
90rec.games.trivia 37
91soc.genealogy.medieval 37
92alt.bible 36
93rec.games.backgammon 34
94comp.lang.tcl 34
95comp.sys.mac.system 34
96rec.music.artists.kiss 34
97comp.arch 34
98soc.culture.netherlands 33
99alt.society.liberalism 33
100alt.tv.days-of-our-lives 32
TOTAL: 412 17085