news.bbs.geek.nz daily logs

Dec 28 23:58:01 -- Dec 29 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 154647 64.8%12.8 MB 44.7%
innd 31213 13.1%5.0 MB 17.6%
inn 28435 11.9%6.2 MB 21.5%
innfeed 22857 9.6%4.4 MB 15.4%
cnfsstat 1440 0.6%250.9 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 238593 100.0%28.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 269465 48.7%
Positive hits 255578 46.2%
Do not exist 26577 4.8%
Cache misses 1687 0.3%
TOTAL: 4 553307 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.389 0.0%157 0.000 2.478 27.000
article cleanup00:00:00.280 0.0%27705 0.000 0.010 0.031
article logging00:00:00.789 0.0%28294 0.000 0.028 0.232
article parse00:00:00.822 0.0%68010 0.002 0.012 0.030
article write00:00:01.460 0.0%19621 0.015 0.074 1.041
artlog/artcncl00:00:00.002 0.0%148 0.000 0.014 1.000
data move00:00:00.459 0.0%525491 0.000 0.001 0.019
hisgrep/artcncl00:00:00.068 0.0%146 0.000 0.466 6.500
hishave/artcncl00:00:00.077 0.0%157 0.000 0.490 5.154
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.403 0.0%556167 0.001 0.015 0.905
history sync00:00:00.055 0.0%353 0.000 0.156 7.200
history write00:00:07.421 0.0%26708 0.009 0.278 15.735
hiswrite/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
idle23:58:01.900 99.8%543377 103.825 158.788 396.322
nntp read00:00:03.179 0.0%544506 0.002 0.006 0.025
overview write00:00:32.872 0.0%19621 0.057 1.675 40.203
perl filter00:00:52.093 0.1%26708 1.354 1.950 10.152
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.252 0.0%39242 0.004 0.032 0.136
TOTAL: 24:00:48.60423:59:51.521 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.061 0.0%27654 0.000 0.002 0.027
article prepare00:00:00.000 0.0%7186 0.000 0.000 0.000
article read00:00:00.171 0.0%1622 0.000 0.105 3.926
backlog stats00:00:00.299 0.0%312684 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.641 0.0%260780 0.002 0.006 0.015
data write00:00:02.882 0.0%244847 0.005 0.012 0.022
idle23:54:23.911 99.9%312684 158.184 275.242 675.021
status file00:00:20.147 0.0%1808 0.700 11.143 459.211
TOTAL: 23:55:08.39423:54:49.112100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle44:04:42.484 97.2%213083 0.000 744.698450268.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:27:29.213 1.0%542477 0.000 3.040 117.927
readart00:01:14.331 0.0%56485 0.000 1.316 15.833
TOTAL: 45:21:41.93044:33:26.028 98.2%----

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 36 15807 5268 10027 512 33%38:57:45
2news-out.mixmin.net 9 20030 3676 15446 908 18%25:00:48
3news-out.aioe.org 4 20624 2584 17864 176 12%25:09:45
4feeder.eternal-september.org 65 23045 1844 19626 1575 8%43:04:43
5news.redatomik.org 1 17506 1455 15976 75 8%23:11:41
6newsfeed.neva.ru 158 16921 1085 12728 3108 6%84:23:18
7csiph.com 2 19065 1075 17846 144 5%22:33:39
8newsfeed.datemas.de 2 18805 879 17616 310 4%21:27:08
9news.albasani.net 5 15845 709 14846 290 4%15:12:11
10news.swapon.de 5 1641 179 1450 12 10%24:46:45
11news.freedyn.net 2 24475 142 24222 111 0%29:44:15
12feeder.awxg.com 2 16942 116 16775 51 0%23:59:53
13agency-nz-out.news.mb-net.net 10 22670 93 22407 170 0%26:35:39
14news.samoylyk.net 2 20701 88 20306 307 0%17:34:38
15localhost 6 5 5 0 0 100%00:00:00
TOTAL: 15 309 254082 19198 227135 7749 7%421:42:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org17.0 MB286.6 KB2.2 MB19.4 MB 87%3.4 KB
2news-out.mixmin.net10.7 MB450.6 KB2.2 MB13.3 MB 80%3.0 KB
3newsfeed.datemas.de7.7 MB797.4 KB2.0 MB10.5 MB 73%9.0 KB
4feeder.eternal-september.org7.0 MB1.2 MB6.7 MB14.8 MB 47%4.4 KB
5news-out.aioe.org6.1 MB183.7 KB416.5 KB6.7 MB 91%2.5 KB
6news.redatomik.org3.6 MB192.3 KB213.2 KB4.0 MB 90%2.7 KB
7news.albasani.net3.4 MB142.0 KB681.4 KB4.2 MB 81%4.3 KB
8csiph.com3.0 MB194.8 KB434.5 KB3.6 MB 82%3.0 KB
9newsfeed.neva.ru2.8 MB189.7 KB9.9 MB12.9 MB 21%3.1 KB
10news.freedyn.net1.0 MB167.0 KB806.8 KB2.0 MB 51%7.9 KB
11news.samoylyk.net718.4 KB183.4 KB2.3 MB3.2 MB 22%8.2 KB
12news.swapon.de426.4 KB16.9 KB219.6 KB662.9 KB 64%3.5 KB
13feeder.awxg.com393.4 KB131.4 KB140.5 KB665.3 KB 59%4.0 KB
14agency-nz-out.news.mb-net.net285.6 KB268.0 KB1.8 MB2.4 MB 11%9.2 KB
15localhost7.6 KB0.0 KB0.0 KB7.6 KB100%1.5 KB
TOTAL: 1564.1 MB4.3 MB29.8 MB98.2 MB 65%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 28 23:58:01 - 23:59:59 26 0.1% 0.2254.2 KB 0.1% 0.46
Dec 29 00:00:00 - 00:59:59 879 4.5% 0.242.2 MB 3.5% 0.64
Dec 29 01:00:00 - 01:59:59 956 4.9% 0.273.2 MB 5.0% 0.91
Dec 29 02:00:00 - 02:59:59 910 4.6% 0.252.4 MB 3.7% 0.68
Dec 29 03:00:00 - 03:59:59 916 4.7% 0.253.5 MB 5.5% 1.00
Dec 29 04:00:00 - 04:59:59 1060 5.4% 0.293.5 MB 5.5% 1.00
Dec 29 05:00:00 - 05:59:59 1187 6.1% 0.334.1 MB 6.4% 1.17
Dec 29 06:00:00 - 06:59:59 1181 6.0% 0.332.9 MB 4.5% 0.83
Dec 29 07:00:00 - 07:59:59 1100 5.6% 0.313.0 MB 4.6% 0.85
Dec 29 08:00:00 - 08:59:59 1066 5.4% 0.303.7 MB 5.7% 1.04
Dec 29 09:00:00 - 09:59:59 1037 5.3% 0.293.0 MB 4.7% 0.86
Dec 29 10:00:00 - 10:59:59 1000 5.1% 0.283.1 MB 4.9% 0.89
Dec 29 11:00:00 - 11:59:59 860 4.4% 0.243.3 MB 5.1% 0.93
Dec 29 12:00:00 - 12:59:59 716 3.6% 0.203.0 MB 4.7% 0.86
Dec 29 13:00:00 - 13:59:59 704 3.6% 0.203.2 MB 5.0% 0.92
Dec 29 14:00:00 - 14:59:59 478 2.4% 0.131.5 MB 2.3% 0.41
Dec 29 15:00:00 - 15:59:59 403 2.1% 0.111.6 MB 2.5% 0.47
Dec 29 16:00:00 - 16:59:59 456 2.3% 0.132.3 MB 3.6% 0.66
Dec 29 17:00:00 - 17:59:59 496 2.5% 0.141.7 MB 2.7% 0.49
Dec 29 18:00:00 - 18:59:59 452 2.3% 0.132.1 MB 3.3% 0.60
Dec 29 19:00:00 - 19:59:59 460 2.3% 0.131.6 MB 2.4% 0.44
Dec 29 20:00:00 - 20:59:59 666 3.4% 0.182.5 MB 3.8% 0.70
Dec 29 21:00:00 - 21:59:59 765 3.9% 0.212.1 MB 3.2% 0.59
Dec 29 22:00:00 - 22:59:59 896 4.6% 0.252.4 MB 3.7% 0.68
Dec 29 23:00:00 - 23:58:01 947 4.8% 0.272.3 MB 3.6% 0.69
TOTAL: 24:00:00 19617 100.0% 0.2364.4 MB 100.0% 0.76
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB22.5 GB 45.0% 0 0.30 2055.07
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.1 GB 52.2% 0 0.35 1747.00
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB280.6 MB 0.5% 0 0.0321339.01
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.1 GB 28.2% 0 0.62 982.73
TOTAL: 10-500.0 GB63.0 GB 12.6% 1 0.41-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3150 51 0 54 0 0 0 0 3045
2feeder.eternal-september.org 1655 0 0 149 0 0 0 0 1506
3news-out.mixmin.net 1151 0 0 103 0 0 0 0 1048
4news.snarked.org 516 73 0 60 0 0 0 0 383
5news.samoylyk.net 385 0 0 94 0 0 0 0 291
6newsfeed.datemas.de 372 120 0 91 0 0 0 0 161
7news.redatomik.org 369 0 0 73 0 0 0 0 296
8news.albasani.net 361 3 0 61 1 0 0 0 296
9news-out.aioe.org 186 5 0 57 0 0 0 0 124
10agency-nz-out.news.mb-net.net 167 29 0 73 0 0 0 0 65
11csiph.com 148 0 0 56 0 0 0 0 92
12news.freedyn.net 110 2 0 58 0 0 0 0 50
13feeder.awxg.com 62 0 0 56 0 0 0 0 6
14news.swapon.de 35 0 0 8 0 0 0 0 27
15news.ausics.org 3 0 0 3 0 0 0 0 0
TOTAL: 15 8670 283 0 996 1 0 0 0 7390

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.nanog 71
it.annunci.commerciali 31
it.annunci.immobiliari 31
it.annunci.varie 29
mpc.lists.freebsd.ports.bugs 17
gmane.comp.gis.openstreetmap.tagging 14
mpc.lists.freebsd.x11 13
mozilla.support.seamonkey 7
gmane.linux.alsa.devel 6
alt.economics 5
gmane.linux.kernel 5
mozilla.dev.ui-alerts 5
eagle.support.eng 4
mozilla.dev.security.policy 3
gmane.linux.bios.flashrom 3
gmane.comp.gis.openstreetmap.imports 2
mozilla.test 2
davidegiuseppe1gmail.com 2
talk.wieslauf.points 2
mozilla.bugmasters 2
TOTAL: 43 283

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

GroupsCount
free.shqip.kulture 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5903
EMP (phn path) 521
EMP (phn nph) 250
Binary: misplaced rar 26
Binary Image: misplaced jpg 24
Too many newsgroups 21
User-issued cancel 12
EMP (phl) 10
Binary: misplaced PAR2 10
Binary: non-binary distribution 10
Cancel for rejected article 4
Too many newsgroups (meow) 2
Binary: misplaced par2 2
Binary: misplaced 028 1
Binary: misplaced nfo 1
User-issued spam cancel 1
Binary: misplaced com 1
Binary: misplaced 104 1
TOTAL: 18 6800

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 285
news-out.mixmin.net 182
news.albasani.net 47
newsfeed.datemas.de 25
news.swapon.de 23
news-out.aioe.org 18
feeder.awxg.com 4
newsfeed.neva.ru 3
news.snarked.org 2
agency-nz-out.news.mb-net.net 1
TOTAL: 10 590
TOTAL: 1 590

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17999 739 17234 26 0 0 4%23:59:45
2news.albasani.net 19262 189 17567 624 13 8008 0%23:59:45
3awxg 18965 73 18872 0 0 11 0%23:59:35
4aioe 15901 28 15754 1 0 0 0%23:59:43
5news.freedyn.net 19620 8 19467 1 0 0 0%23:59:37
6news.redatomik.org 18037 6 17995 0 0 0 0%23:59:44
7news.snarked.org 14181 6 14101 6 0 4 0%23:59:42
8csiph.com 18596 5 18476 1 0 37 0%23:59:45
9news.samoylyk.net 17895 5 17880 0 0 1 0%23:59:35
10newsfeed.datemas.de 18708 5 18686 0 0 0 0%23:59:45
11eternal-september 16798 5 16780 0 0 0 0%23:59:41
12mb-net.net 19545 4 19492 0 0 60 0%23:59:45
13news-in.mixmin.net 15126 4 15104 1 0 3 0%23:59:30
14neva.ru 18214 3 18197 2 0 0 0%23:59:45
15news.swapon.de 1552 0 1552 0 0 0 0%23:26:18
TOTAL: 15 250399 1080 247157 662 13 8124 0%359:21:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.1 MB558.7 KB10.7 MB0.1 KB/s14.3 KB23:59:45
2news.albasani.net1.1 MB1.3 MB2.4 MB0.0 KB/s3.0 KB23:59:45
3awxg285.5 KB0.0 KB285.5 KB0.0 KB/s3.9 KB23:59:35
4aioe98.0 KB2.1 KB100.1 KB0.0 KB/s3.5 KB23:59:43
5news.freedyn.net16.7 KB5.6 KB22.2 KB0.0 KB/s2.5 KB23:59:37
6news.redatomik.org10.9 KB0.0 KB10.9 KB0.0 KB/s1.8 KB23:59:44
7news.snarked.org9.5 KB14.7 KB24.2 KB0.0 KB/s2.0 KB23:59:42
8csiph.com7.6 KB1.4 KB9.1 KB0.0 KB/s1.5 KB23:59:45
9news.samoylyk.net7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:59:35
10newsfeed.datemas.de7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:59:45
11eternal-september7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:59:41
12mb-net.net5.7 KB0.0 KB5.7 KB0.0 KB/s1.4 KB23:59:45
13news-in.mixmin.net5.7 KB1.9 KB7.6 KB0.0 KB/s1.5 KB23:59:30
14neva.ru5.2 KB2.4 KB7.6 KB0.0 KB/s1.5 KB23:59:45
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:26:18
TOTAL: 1511.7 MB1.9 MB13.5 MB0.0 KB/s7.9 KB359:21:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 15 45840169.4 MB 1545 0 2215:18:45
2agency.bbs.geek.nz 381 775826.0 MB 4241 5 000:14:18
3vorlon.activateit.net.au 24 14142.0 MB 151 0 000:05:54
4192.168.1.9 5 2321.0 MB 9 0 000:00:11
TOTAL: 4 425 55244198.4 MB 5946 5 2245:21:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 15 45840169.4 MB 1545 0 2243:44:34
2*.bbs.geek.nz 381 775826.0 MB 4241 5 000:14:18
3*.activateit.net.au 24 14142.0 MB 151 0 000:05:54
4unresolved 16 2321.0 MB 9 0 001:16:45
TOTAL: 4 436 55244198.4 MB 5946 5 2245:21:34

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 10
paulh 5
TOTAL: 3 39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.096 0.088 0.00328:25:49
67-61-21-181.cpe.cableone.net 4.328 6.404 0.03815:18:45
90.216.54.52 0.056 0.004 0.00000:30:01
118.149.218.197 0.360 0.060 0.00000:28:02
118.149.247.125 0.220 0.048 0.00000:18:29
agency.bbs.geek.nz 27.888 7.080 0.00000:14:18
vorlon.activateit.net.au 1.432 0.372 0.20400:05:54
192.168.1.9 0.352 0.080 0.01500:00:11
? 1.432 0.188 0.00000:00:02
TOTAL: 9 36.164 14.324 0.26045:21:34

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.218.197 6
118.149.247.125 4
90.216.54.52 1
TOTAL: 3 11

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
67-61-21-181.cpe.cableone.net 3 0
90.216.54.52 1 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 8124 22.1%
2sci 7375 20.0%
3soc 5945 16.1%
4uk 4629 12.6%
5talk 4428 12.0%
6alt 2090 5.7%
7comp 1798 4.9%
8linux 1347 3.7%
9misc 604 1.6%
10news 223 0.6%
11mozilla 76 0.2%
12nz 53 0.1%
13us 36 0.1%
14microsoft 36 0.1%
15newsguy 24 0.1%
16fido7 14 0.0%
17aus 13 0.0%
18humanities 6 0.0%
19gnu 2 0.0%
20free 1 0.0%
21fidonet 1 0.0%
22eternal-september 1 0.0%
23fido 1 0.0%
TOTAL: 23 36827100.0%

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

NewsgroupCount
1talk.politics.guns 2520
2uk.d-i-y 1640
3rec.arts.tv 1423
4uk.legal 1396
5sci.physics 1305
6talk.politics.misc 1085
7sci.math 979
8sci.electronics.design 960
9soc.retirement 909
10rec.arts.drwho 856
11rec.sport.pro-wrestling 846
12sci.physics.relativity 842
13talk.origins 771
14soc.culture.polish 762
15sci.logic 744
16uk.radio.amateur 731
17rec.sport.tennis 724
18sci.military.naval 659
19soc.culture.china 602
20linux.debian.bugs.dist 558
21alt.fan.rush-limbaugh 543
22soc.culture.israel 536
23sci.med.cardiology 519
24rec.sport.golf 500
25soc.culture.indian 467
26rec.arts.sf.written 448
27alt.atheism 440
28soc.culture.usa 434
29misc.survivalism 427
30alt.comp.os.windows-10 361
31rec.food.cooking 357
32uk.tech.digital-tv 340
33comp.lang.c 318
34comp.lang.python 317
35soc.culture.singapore 310
36rec.gambling.poker 302
37sci.math.num-analysis 266
38linux.debian.changes.devel 260
39rec.arts.sf.tv 252
40rec.sport.soccer 236
41soc.culture.vietnamese 217
42soc.culture.brazil 213
43sci.electronics.repair 207
44sci.med.pharmacy 196
45rec.sport.football.college 196
46news.lists.filters 192
47rec.woodworking 184
48soc.culture.bulgaria 168
49soc.penpals 160
50comp.sys.mac.advocacy 155
51uk.rec.cycling 138
52sci.lang 138
53rec.radio.shortwave 135
54alt.politics.trump 122
55linux.debian.user 119
56rec.crafts.metalworking 116
57comp.sys.raspberry-pi 111
58rec.arts.movies.current-films 111
59rec.aquaria.marine.misc 110
60linux.debian.bugs.rc 110
61soc.genealogy.medieval 104
62soc.culture.romanian 102
63sci.crypt 102
64uk.comp.sys.mac 100
65rec.aviation.marketplace 100
66comp.os.linux.advocacy 98
67alt.conspiracy.jfk 94
68comp.lang.idl-pvwave 92
69soc.culture.greek 91
70rec.music.dylan 89
71soc.history.what-if 89
72alt.politics 86
73rec.music.classical.recordings 86
74alt.test 85
75rec.sport.cricket 83
76soc.culture.african.american 82
77comp.sys.mac.system 79
78sci.space.policy 78
79uk.rec.cars.maintenance 73
80comp.sys.mac.apps 72
81rec.boats 71
82uk.comp.homebuilt 71
83rec.aviation.soaring 70
84comp.lang.c++ 64
85linux.debian.devel 62
86soc.culture.netherlands 60
87rec.arts.tv.soaps.cbs 58
88rec.photo.digital 57
89soc.genealogy.britain 54
90comp.lang.forth 54
91uk.tech.broadcast 54
92soc.support.fat-acceptance 53
93nz.general 53
94misc.invest.stocks 52
95rec.autos.sport.f1 50
96alt.bible 50
97comp.protocols.time.ntp 48
98soc.culture.liberia 46
99sci.astro.amateur 46
100sci.astro 45
TOTAL: 439 36827