news.bbs.geek.nz daily logs

Jan 1 23:58:01 -- Jan 2 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 144952 64.8%12.0 MB 43.9%
innd 29202 13.0%4.8 MB 17.5%
inn 25361 11.3%5.7 MB 20.8%
innfeed 22832 10.2%4.6 MB 16.8%
cnfsstat 1440 0.6%254.7 KB 0.9%
controlchan 9 0.0%1.5 KB 0.0%
TOTAL: 6 223796 100.0%27.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 242653 48.5%
Negative hits 233269 46.7%
Do not exist 23389 4.7%
Cache misses 600 0.1%
TOTAL: 4 499911 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.744 0.0%399 0.000 1.865 20.538
article cleanup00:00:00.201 0.0%24319 0.000 0.008 0.035
article logging00:00:00.597 0.0%24984 0.000 0.024 0.072
article parse00:00:00.726 0.0%69080 0.000 0.011 0.045
article write00:00:01.457 0.0%18413 0.000 0.079 0.552
artlog/artcncl00:00:00.005 0.0%393 0.000 0.013 0.500
data move00:00:00.300 0.0%484210 0.000 0.001 0.015
hisgrep/artcncl00:00:00.128 0.0%398 0.000 0.322 9.000
hishave/artcncl00:00:00.087 0.0%399 0.000 0.218 6.692
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.280 0.0%501106 0.001 0.017 0.908
history sync00:00:00.025 0.0%309 0.000 0.081 6.500
history write00:00:07.515 0.0%23453 0.013 0.320 18.225
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:25.649 99.8%499457 58.522 172.679 511.814
nntp read00:00:03.082 0.0%500710 0.002 0.006 0.036
overview write00:00:39.882 0.0%18413 0.082 2.166 51.084
perl filter00:00:46.659 0.1%23453 1.326 1.989 10.393
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.103 0.0%36828 0.006 0.030 0.106
TOTAL: 24:00:22.51223:59:16.440 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.058 0.0%24340 0.000 0.002 0.040
article prepare00:00:00.003 0.0%7176 0.000 0.000 0.023
article read00:00:00.332 0.0%1602 0.000 0.207 20.077
backlog stats00:00:00.290 0.0%311303 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.633 0.0%258338 0.002 0.006 0.012
data write00:00:02.649 0.0%233432 0.003 0.011 0.022
idle23:54:18.693100.0%311303 132.395 276.447 747.388
status file00:00:10.005 0.0%1773 0.750 5.643 165.878
TOTAL: 23:54:50.16623:54:33.663100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle24:40:15.759 93.5%161900 0.000 548.584 91010.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:02:25.815 0.2%359445 0.000 0.406 10.095
readart00:00:02.544 0.0%17329 0.000 0.147 24.548
TOTAL: 26:23:58.23824:42:44.118 93.6%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
hun-mnt@news.sztaki.hu001011
moderator@dana.de001011
TOTAL002022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 33 18111 5118 12309 684 28%40:06:26
2news-out.mixmin.net 15 19484 4664 13762 1058 23%28:44:42
3feeder.eternal-september.org 40 21943 2226 18714 1003 10%38:12:17
4news.redatomik.org 1 15125 1192 13879 54 7%20:55:22
5newsfeed.neva.ru 146 17169 1151 14251 1767 6%82:23:45
6newsfeed.datemas.de 3 19733 1143 18225 365 5%24:36:23
7csiph.com 2 17340 976 16304 60 5%24:08:59
8news-out.aioe.org 4 19493 730 18690 73 3%30:40:20
9news.albasani.net 3 24175 614 23228 333 2%32:01:01
10news.swapon.de 2 1770 157 1607 6 8%21:09:09
11news.freedyn.net 5 22368 134 22138 96 0%30:16:13
12agency-nz-out.news.mb-net.net 15 18972 82 18775 115 0%25:01:51
13feeder.awxg.com 2 14803 81 14691 31 0%23:59:51
14news.ausics.org 1 135334 45 135271 18 0%220:47:18
15news.samoylyk.net 1 21728 8 21494 226 0%23:59:56
16localhost 7 6 5 0 1 83%00:00:00
TOTAL: 16 280 387554 18326 363338 5890 4%667:03:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.2 MB229.7 KB2.5 MB22.0 MB 87%3.9 KB
2news-out.mixmin.net12.8 MB241.5 KB2.2 MB15.2 MB 84%2.7 KB
3feeder.eternal-september.org7.4 MB380.3 KB2.9 MB10.6 MB 69%3.4 KB
4news.albasani.net5.4 MB374.5 KB976.6 KB6.7 MB 80%7.3 KB
5newsfeed.datemas.de5.4 MB235.1 KB1.4 MB7.0 MB 76%4.8 KB
6newsfeed.neva.ru3.1 MB198.0 KB7.5 MB10.8 MB 28%3.8 KB
7csiph.com2.7 MB180.3 KB199.0 KB3.1 MB 87%3.0 KB
8news.redatomik.org2.7 MB133.3 KB137.2 KB2.9 MB 90%2.4 KB
9news-out.aioe.org2.1 MB203.1 KB250.2 KB2.6 MB 82%3.3 KB
10news.freedyn.net646.8 KB178.7 KB764.5 KB1.6 MB 40%6.9 KB
11agency-nz-out.news.mb-net.net550.6 KB185.1 KB420.3 KB1.1 MB 47%5.9 KB
12news.swapon.de424.6 KB13.9 KB13.9 KB452.4 KB 93%2.8 KB
13feeder.awxg.com197.6 KB91.1 KB123.9 KB412.6 KB 47%3.7 KB
14news.ausics.org162.1 KB61.4 KB64.3 KB287.7 KB 56%4.6 KB
15news.samoylyk.net14.9 KB184.2 KB5.6 MB5.8 MB 0%25.2 KB
16localhost8.8 KB0.0 KB2.2 KB11.0 KB 80%1.8 KB
TOTAL: 1662.8 MB2.8 MB24.9 MB90.5 MB 69%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 1 23:58:01 - 23:59:59 32 0.2% 0.2778.2 KB 0.1% 0.66
Jan 2 00:00:00 - 00:59:59 811 4.4% 0.232.2 MB 3.6% 0.62
Jan 2 01:00:00 - 01:59:59 879 4.8% 0.243.2 MB 5.3% 0.91
Jan 2 02:00:00 - 02:59:59 826 4.5% 0.231.9 MB 3.2% 0.54
Jan 2 03:00:00 - 03:59:59 840 4.6% 0.232.4 MB 3.9% 0.67
Jan 2 04:00:00 - 04:59:59 1002 5.4% 0.284.2 MB 6.9% 1.18
Jan 2 05:00:00 - 05:59:59 1101 6.0% 0.313.5 MB 5.8% 1.00
Jan 2 06:00:00 - 06:59:59 1105 6.0% 0.313.6 MB 6.0% 1.04
Jan 2 07:00:00 - 07:59:59 1081 5.9% 0.303.3 MB 5.6% 0.95
Jan 2 08:00:00 - 08:59:59 1130 6.1% 0.313.6 MB 6.0% 1.03
Jan 2 09:00:00 - 09:59:59 959 5.2% 0.272.9 MB 4.8% 0.81
Jan 2 10:00:00 - 10:59:59 1110 6.0% 0.313.5 MB 5.8% 1.00
Jan 2 11:00:00 - 11:59:59 822 4.5% 0.232.6 MB 4.3% 0.74
Jan 2 12:00:00 - 12:59:59 691 3.8% 0.192.0 MB 3.3% 0.57
Jan 2 13:00:00 - 13:59:59 632 3.4% 0.182.0 MB 3.4% 0.58
Jan 2 14:00:00 - 14:59:59 538 2.9% 0.151.5 MB 2.5% 0.44
Jan 2 15:00:00 - 15:59:59 448 2.4% 0.121.4 MB 2.3% 0.39
Jan 2 16:00:00 - 16:59:59 427 2.3% 0.121.8 MB 2.9% 0.50
Jan 2 17:00:00 - 17:59:59 313 1.7% 0.091.8 MB 3.0% 0.51
Jan 2 18:00:00 - 18:59:59 724 3.9% 0.204.0 MB 6.6% 1.14
Jan 2 19:00:00 - 19:59:59 340 1.8% 0.091.4 MB 2.4% 0.40
Jan 2 20:00:00 - 20:59:59 445 2.4% 0.121.3 MB 2.2% 0.38
Jan 2 21:00:00 - 21:59:59 594 3.2% 0.171.5 MB 2.5% 0.43
Jan 2 22:00:00 - 22:59:59 832 4.5% 0.232.4 MB 3.9% 0.68
Jan 2 23:00:00 - 23:58:01 723 3.9% 0.212.2 MB 3.6% 0.63
TOTAL: 24:00:00 18405 100.0% 0.2160.2 MB 100.0% 0.71
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.6 GB 45.2% 0 0.30 1997.94
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.2 GB 52.4% 0 0.33 1851.67
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB281.6 MB 0.5% 0 0.0322222.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.3 GB 28.6% 0 0.63 967.54
TOTAL: 10-500.0 GB63.4 GB 12.7% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1742 35 0 63 0 0 0 0 1644
2news-out.mixmin.net 1440 0 0 74 0 0 0 0 1366
3feeder.eternal-september.org 1014 0 0 129 0 0 0 0 885
4news.snarked.org 658 38 0 66 0 0 0 0 554
5newsfeed.datemas.de 385 121 0 75 1 0 0 0 188
6news.albasani.net 300 6 0 77 0 0 0 0 217
7news.samoylyk.net 255 0 0 43 0 0 0 0 212
8news.redatomik.org 219 0 0 56 0 0 0 0 163
9agency-nz-out.news.mb-net.net 205 34 0 71 0 0 0 0 100
10news-out.aioe.org 98 13 0 52 0 0 0 0 33
11news.freedyn.net 96 4 0 53 0 0 0 0 39
12csiph.com 58 0 0 52 0 0 0 0 6
13feeder.awxg.com 47 2 0 42 0 0 0 0 3
14news.swapon.de 42 0 0 6 0 0 0 0 36
15news.ausics.org 3 0 0 3 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 6563 253 0 862 1 0 0 0 5447

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.commerciali 43
it.annunci.immobiliari 41
it.annunci.varie 38
mozilla.support.seamonkey 26
gmane.linux.alsa.devel 14
nemo.abuse 9
mpc.lists.nanog 8
nemo.test2 6
gmane.linux.kernel 5
mozilla.dev.ui-alerts 5
south-wales.test 4
mpc.lists.freebsd.gnome 4
gmane.linux.drivers.devicetree 3
gmane.comp.gis.openstreetmap.tagging 3
mozilla.dev.l10n.sr 3
soc.support.depression 2
mozilla.dev.platform 2
mpc.lists.freebsd.office 2
mpc.lists.freebsd.gecko 2
mozilla.test 2
TOTAL: 50 253

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
free.shqip.kulture 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3612
EMP (phn path) 506
EMP (phn nph) 356
Too many newsgroups 83
Binary Image: misplaced jpg 83
Binary: misplaced rar 60
User-issued spam cancel 26
User-issued cancel 20
EMP (phl) 17
Binary: non-binary distribution 9
Binary: misplaced par2 5
Cancel for rejected article 2
Binary: misplaced 261 1
Too many newsgroups (meow) 1
U2 violation - invalid distribution 1
TOTAL: 15 4782

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 367
news.redatomik.org 161
newsfeed.datemas.de 40
news.albasani.net 38
news.swapon.de 35
news-out.aioe.org 16
feeder.awxg.com 2
agency-nz-out.news.mb-net.net 2
news.snarked.org 2
newsfeed.neva.ru 2
TOTAL: 10 665
TOTAL: 1 665

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16808 1101 15669 37 1 0 6%23:59:47
2awxg 17857 82 17761 5 0 13 0%23:59:48
3news.samoylyk.net 18417 41 16719 27 1 297 0%23:59:47
4news.freedyn.net 18454 39 18232 4 0 264 0%23:59:48
5mb-net.net 18456 19 18279 1 0 318 0%23:59:44
6news.redatomik.org 17214 13 17085 12 0 229 0%23:59:48
7news.albasani.net 18212 10 17053 326 0 4724 0%23:59:48
8aioe 15713 6 15581 0 0 46 0%23:59:48
9news-in.mixmin.net 13293 5 13274 0 0 20 0%23:59:48
10csiph.com 17478 5 17402 0 0 0 0%23:59:48
11eternal-september 15550 5 15508 0 0 30 0%23:59:42
12news.snarked.org 13228 4 13189 2 0 29 0%23:59:48
13newsfeed.datemas.de 17235 4 17227 0 0 8 0%23:59:48
14neva.ru 17030 3 17007 2 0 0 0%23:59:48
15news.swapon.de 2013 0 2012 0 0 0 0%23:54:01
TOTAL: 15 236958 1337 231998 416 2 5978 0%359:51:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.6 MB426.4 KB7.1 MB0.1 KB/s6.4 KB23:59:47
2awxg293.7 KB18.7 KB312.4 KB0.0 KB/s3.6 KB23:59:48
3news.freedyn.net193.9 KB33.8 KB227.7 KB0.0 KB/s5.3 KB23:59:48
4news.samoylyk.net161.4 KB301.7 KB463.1 KB0.0 KB/s6.8 KB23:59:47
5mb-net.net100.9 KB4.2 KB105.1 KB0.0 KB/s5.3 KB23:59:44
6news.redatomik.org48.1 KB53.9 KB102.0 KB0.0 KB/s4.1 KB23:59:48
7news.albasani.net20.1 KB745.1 KB765.3 KB0.0 KB/s2.3 KB23:59:48
8aioe10.2 KB0.0 KB10.2 KB0.0 KB/s1.7 KB23:59:48
9news-in.mixmin.net8.9 KB0.0 KB8.9 KB0.0 KB/s1.8 KB23:59:48
10csiph.com8.9 KB0.0 KB8.9 KB0.0 KB/s1.8 KB23:59:48
11eternal-september8.9 KB0.0 KB8.9 KB0.0 KB/s1.8 KB23:59:42
12news.snarked.org6.7 KB4.5 KB11.1 KB0.0 KB/s1.9 KB23:59:48
13newsfeed.datemas.de6.7 KB0.0 KB6.7 KB0.0 KB/s1.7 KB23:59:48
14neva.ru5.4 KB3.5 KB8.9 KB0.0 KB/s1.8 KB23:59:48
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:01
TOTAL: 157.5 MB1.6 MB9.1 MB0.0 KB/s5.3 KB359:51:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 9 829229.1 MB 1057 3 1604:34:03
2agency.bbs.geek.nz 378 699624.2 MB 3770 2 000:13:36
3vorlon.activateit.net.au 24 10091.5 MB 158 0 000:04:57
TOTAL: 3 411 1629754.8 MB 4985 5 1626:23:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 12 829229.1 MB 1057 3 1624:25:14
2*.bbs.geek.nz 378 699624.2 MB 3770 2 000:13:36
3*.activateit.net.au 24 10091.5 MB 158 0 000:04:57
4unresolved 21 00.0 KB 0 0 001:39:58
TOTAL: 4 435 1629754.8 MB 4985 5 1626:23:51

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 7
malcolmlewis 3
TOTAL: 3 34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.228 0.108 0.01219:51:11
67-61-21-181.cpe.cableone.net 1.680 1.092 0.02104:34:03
118.149.206.61 0.712 0.092 0.00000:51:10
118.149.224.104 0.476 0.060 0.00000:43:46
agency.bbs.geek.nz 27.600 6.972 0.00000:13:36
118.149.222.215 0.044 0.024 0.00000:05:01
vorlon.activateit.net.au 1.356 0.428 0.35300:04:57
? 2.156 0.248 0.00000:00:03
TOTAL: 8 34.252 9.024 0.38626:23:51

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.206.61 12
118.149.224.104 8
67-60-219-146.cpe.cableone.net 3
118.149.222.215 1
TOTAL: 4 24

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-21-181.cpe.cableone.net 1 0
agency.bbs.geek.nz 1 1
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5102 31.3%
2alt 1936 11.9%
3uk 1912 11.7%
4comp 1748 10.7%
5soc 1457 8.9%
6linux 1041 6.4%
7sci 1036 6.4%
8talk 1014 6.2%
9misc 627 3.8%
10news 187 1.1%
11mozilla 68 0.4%
12aus 45 0.3%
13nz 38 0.2%
14microsoft 36 0.2%
15humanities 32 0.2%
16newsguy 9 0.1%
17us 8 0.0%
18eternal-september 1 0.0%
TOTAL: 18 16297100.0%

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

NewsgroupCount
1rec.arts.tv 1150
2uk.d-i-y 764
3talk.politics.guns 560
4linux.debian.bugs.dist 481
5comp.lang.python 435
6misc.survivalism 423
7uk.legal 418
8alt.fan.rush-limbaugh 413
9alt.atheism 399
10rec.arts.sf.written 395
11rec.food.cooking 385
12rec.sport.football.college 354
13alt.comp.os.windows-10 329
14uk.radio.amateur 297
15soc.culture.israel 295
16soc.culture.polish 275
17rec.arts.drwho 245
18talk.politics.misc 241
19uk.rec.driving 213
20sci.physics 193
21linux.debian.changes.devel 192
22comp.sys.mac.system 190
23soc.culture.indian 183
24soc.retirement 182
25rec.crafts.metalworking 176
26rec.sport.golf 170
27news.lists.filters 162
28rec.photo.digital 162
29talk.origins 160
30sci.physics.relativity 148
31sci.electronics.design 147
32rec.aviation.soaring 142
33soc.culture.china 140
34comp.lang.idl-pvwave 138
35comp.mobile.android 137
36misc.phone.mobile.iphone 129
37rec.boats 126
38comp.lang.c 116
39rec.sport.tennis 114
40alt.politics.trump 114
41rec.gambling.poker 102
42rec.radio.shortwave 101
43sci.math 98
44sci.military.naval 89
45rec.arts.sf.tv 85
46soc.penpals 81
47sci.logic 80
48alt.conspiracy.jfk 78
49rec.sport.soccer 78
50rec.aquaria.marine.misc 77
51linux.debian.bugs.rc 76
52rec.woodworking 74
53comp.sys.apple2 72
54comp.mobile.ipad 71
55rec.aviation.marketplace 70
56comp.sys.mac.advocacy 69
57alt.politics 67
58sci.med.cardiology 65
59rec.arts.sf.fandom 64
60alt.recovery.aa 64
61rec.outdoors.rv-travel 62
62linux.debian.user 62
63alt.bible 61
64linux.debian.devel 59
65rec.sport.pro-wrestling 57
66alt.conspiracy 54
67rec.arts.movies.current-films 54
68comp.lang.forth 52
69rec.music.classical.recordings 52
70uk.legal.moderated 50
71comp.os.vms 50
72uk.comp.sys.mac 49
73rec.bicycles.tech 48
74comp.protocols.time.ntp 48
75alt.books.reviews 47
76mozilla.general 46
77rec.music.dylan 46
78comp.lang.c++ 45
79alt.test 44
80comp.arch 44
81alt.society.liberalism 43
82sci.electronics.repair 41
83comp.soft-sys.sas 41
84soc.culture.usa 39
85alt.rush-limbaugh 38
86linux.debian.user.german 38
87alt.comp.hardware 36
88sci.crypt 36
89nz.general 36
90linux.debian.devel.mentors 34
91rec.music.rock-pop-r+b.1950s 33
92microsoft.public.windowsxp.general 32
93rec.audio.opinion 32
94uk.tech.broadcast 30
95comp.sys.apple2.programmer 30
96rec.arts.comics.strips 30
97rec.games.trivia 30
98rec.radio.amateur.misc 29
99rec.arts.comics.marvel.universe 29
100uk.music.charts 28
TOTAL: 362 16297