news.bbs.geek.nz daily logs

Jun 30 23:58:02 -- Jul 1 23:58:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 1 23:40:03 news controlchan[8918]: Multiple control headers in article <tYoUO-2x5-17@gated-at.bofh.it>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 101683 55.1%8.2 MB 34.3%
innd 30115 16.3%4.8 MB 20.1%
inn 28150 15.3%6.2 MB 25.8%
innfeed 23162 12.5%4.5 MB 18.7%
cnfsstat 1440 0.8%250.4 KB 1.0%
controlchan 10 0.0%1.5 KB 0.0%
TOTAL: 6 184560 100.0%23.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 257350 49.4%
Positive hits 237047 45.5%
Do not exist 26632 5.1%
Cache misses 260 0.0%
TOTAL: 4 521289 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.290 0.0%149 0.000 1.946 16.667
article cleanup00:00:00.267 0.0%27632 0.000 0.010 0.031
article logging00:00:00.722 0.0%28059 0.000 0.026 0.070
article parse00:00:00.826 0.0%70009 0.000 0.012 0.030
article write00:00:01.496 0.0%19960 0.017 0.075 0.249
artlog/artcncl00:00:00.004 0.0%140 0.000 0.029 1.000
data move00:00:00.346 0.0%491470 0.000 0.001 0.015
hisgrep/artcncl00:00:00.003 0.0%146 0.000 0.021 0.077
hishave/artcncl00:00:00.000 0.0%149 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.200 0.0%525924 0.000 0.016 0.851
history sync00:00:00.010 0.0%369 0.000 0.027 0.500
history write00:00:08.578 0.0%26875 0.016 0.319 16.171
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:57:47.026 99.8%506069 104.753 170.465 477.087
nntp read00:00:02.816 0.0%506769 0.002 0.006 0.015
overview write00:00:35.766 0.0%19960 0.038 1.792 36.974
perl filter00:01:01.226 0.1%26875 1.370 2.278 25.580
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.279 0.0%39923 0.008 0.032 0.123
TOTAL: 24:00:48.76223:59:48.855 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.073 0.0%26392 0.000 0.003 0.023
article prepare00:00:00.001 0.0%7856 0.000 0.000 0.016
article read00:00:00.328 0.0%1837 0.000 0.179 8.333
backlog stats00:00:00.240 0.0%294707 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.360 0.0%243819 0.001 0.006 0.013
data write00:00:02.688 0.0%231534 0.005 0.012 0.025
idle23:53:23.799 99.9%294707 172.075 291.828 769.042
status file00:00:26.726 0.0%1886 0.727 14.171 613.150
TOTAL: 23:54:12.23423:53:55.215100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle15:19:12.333 92.7%108223 0.000 509.617 75196.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.256 0.0%232749 0.000 0.005 0.333
readart00:00:01.207 0.0%8210 0.000 0.147 3.500
TOTAL: 16:31:25.56415:19:14.796 92.7%----

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
moderator@dana.de001011
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL002022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 61 24088 4991 15194 3903 20%60:15:14
2newsfeed.datemas.de 3 18154 3132 14518 504 17%20:58:40
3news.albasani.net 1 29631 2367 26581 683 7%34:32:02
4feeder.eternal-september.org 25 23395 2262 20446 687 9%30:16:43
5csiph.com 1 20577 2071 18453 53 10%24:54:05
6news.redatomik.org 1 25355 1332 23948 75 5%32:50:27
7news-out.aioe.org 2 14786 1200 13555 31 8%15:45:56
8news-out.mixmin.net 24 21959 986 20518 455 4%35:06:38
9newsfeed.neva.ru 156 14630 874 12832 924 5%92:12:34
10news.freedyn.net 3 21883 494 21091 298 2%23:40:12
11feeder.awxg.com 1 18855 190 18609 56 1%23:59:57
12news.swapon.de 9 1461 60 1390 11 4%18:23:16
13agency-nz-out.news.mb-net.net 22 19593 28 19476 89 0%32:12:59
14localhost 2 1 1 0 0 100%00:00:00
TOTAL: 14 311 254368 19988 226611 7769 7%445:08:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org22.8 MB367.1 KB21.8 MB44.9 MB 50%5.2 KB
2newsfeed.datemas.de10.4 MB267.0 KB1.2 MB11.9 MB 87%3.3 KB
3news.albasani.net7.9 MB352.1 KB1.7 MB9.9 MB 79%3.3 KB
4feeder.eternal-september.org7.7 MB437.5 KB3.3 MB11.4 MB 67%4.0 KB
5csiph.com5.4 MB237.5 KB255.9 KB5.9 MB 91%2.9 KB
6news-out.mixmin.net3.9 MB339.8 KB1.2 MB5.4 MB 72%3.8 KB
7news.redatomik.org3.5 MB257.2 KB259.1 KB4.0 MB 87%2.9 KB
8news-out.aioe.org2.9 MB85.7 KB101.3 KB3.1 MB 94%2.6 KB
9newsfeed.neva.ru2.6 MB258.9 KB2.9 MB5.7 MB 45%3.3 KB
10news.freedyn.net2.2 MB147.9 KB748.7 KB3.0 MB 71%3.9 KB
11feeder.awxg.com573.2 KB225.6 KB228.3 KB1.0 MB 55%4.2 KB
12news.swapon.de144.3 KB19.5 KB20.1 KB183.9 KB 78%2.6 KB
13agency-nz-out.news.mb-net.net65.4 KB239.6 KB831.6 KB1.1 MB 5%9.7 KB
14localhost9.8 KB0.0 KB0.0 KB9.8 KB100%9.8 KB
TOTAL: 1470.1 MB3.2 MB34.3 MB107.6 MB 65%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 30 23:58:02 - 23:59:59 32 0.2% 0.27171.2 KB 0.2% 1.45
Jul 1 00:00:00 - 00:59:59 1030 5.2% 0.293.4 MB 4.9% 0.96
Jul 1 01:00:00 - 01:59:59 1076 5.4% 0.303.7 MB 5.3% 1.05
Jul 1 02:00:00 - 02:59:59 1212 6.1% 0.343.9 MB 5.7% 1.12
Jul 1 03:00:00 - 03:59:59 1209 6.1% 0.343.6 MB 5.2% 1.02
Jul 1 04:00:00 - 04:59:59 1092 5.5% 0.303.0 MB 4.4% 0.86
Jul 1 05:00:00 - 05:59:59 1101 5.5% 0.313.9 MB 5.6% 1.11
Jul 1 06:00:00 - 06:59:59 1114 5.6% 0.316.1 MB 8.8% 1.73
Jul 1 07:00:00 - 07:59:59 1106 5.5% 0.313.2 MB 4.7% 0.92
Jul 1 08:00:00 - 08:59:59 1050 5.3% 0.293.8 MB 5.4% 1.07
Jul 1 09:00:00 - 09:59:59 953 4.8% 0.263.0 MB 4.4% 0.87
Jul 1 10:00:00 - 10:59:59 854 4.3% 0.243.3 MB 4.8% 0.94
Jul 1 11:00:00 - 11:59:59 684 3.4% 0.193.0 MB 4.3% 0.85
Jul 1 12:00:00 - 12:59:59 602 3.0% 0.171.9 MB 2.8% 0.54
Jul 1 13:00:00 - 13:59:59 413 2.1% 0.111.4 MB 2.1% 0.41
Jul 1 14:00:00 - 14:59:59 370 1.9% 0.101.7 MB 2.5% 0.48
Jul 1 15:00:00 - 15:59:59 419 2.1% 0.121.3 MB 1.9% 0.38
Jul 1 16:00:00 - 16:59:59 399 2.0% 0.111.8 MB 2.6% 0.51
Jul 1 17:00:00 - 17:59:59 430 2.2% 0.121.9 MB 2.7% 0.53
Jul 1 18:00:00 - 18:59:59 649 3.3% 0.182.8 MB 4.1% 0.81
Jul 1 19:00:00 - 19:59:59 701 3.5% 0.192.4 MB 3.5% 0.69
Jul 1 20:00:00 - 20:59:59 817 4.1% 0.232.1 MB 3.1% 0.60
Jul 1 21:00:00 - 21:59:59 821 4.1% 0.232.8 MB 4.1% 0.81
Jul 1 22:00:00 - 22:59:59 965 4.8% 0.272.5 MB 3.6% 0.71
Jul 1 23:00:00 - 23:58:01 829 4.2% 0.242.4 MB 3.5% 0.72
TOTAL: 23:59:59 19928 100.0% 0.2369.4 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.1 GB 36.2% 0 0.32 1874.24
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.1 GB 42.2% 0 0.37 1635.90
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB225.4 MB 0.4% 0 0.0415645.49
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 GB3.9 GB 7.8% 0 0.65 936.42
TOTAL: 10-500.0 GB43.3 GB 8.7% 1 0.44-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 3878 71 0 85 0 0 0 0 3722
2newsfeed.neva.ru 920 88 0 71 0 0 0 0 761
3news.albasani.net 795 7 0 58 0 0 0 0 730
4feeder.eternal-september.org 714 0 0 103 0 0 0 0 611
5newsfeed.datemas.de 646 208 0 69 0 0 0 0 369
6news-out.mixmin.net 440 0 0 69 0 0 0 0 371
7news.freedyn.net 292 12 0 40 0 0 0 0 240
8news.redatomik.org 106 0 0 53 0 0 0 0 53
9agency-nz-out.news.mb-net.net 96 18 0 55 0 0 0 0 23
10feeder.awxg.com 55 2 0 51 0 0 0 0 2
11csiph.com 54 0 0 50 0 0 0 0 4
12news-out.aioe.org 49 12 0 32 0 0 0 0 5
13news.swapon.de 31 0 0 17 0 0 0 0 14
14news.ausics.org 6 1 0 5 0 0 0 0 0
TOTAL: 14 8082 419 0 758 0 0 0 0 6905

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 109
gmane.linux.alsa.devel 39
it.annunci.immobiliari 37
it.annunci.commerciali 36
it.annunci.varie 32
mpc.lists.freebsd.ports.bugs 21
mpc.lists.freebsd.gnome 14
gmane.linux.kernel 11
mozilla.dev.l10n 8
fido7.ru.android 8
mpc.lists.freebsd.x11 7
mozilla.apis 6
mozilla.dev.ui-alerts 6
mozilla.release.engineering 5
gmane.linux.kernel.input 5
0.test 5
mozilla.dev.l10n.sr 5
mpc.lists.freebsd.gecko 4
mozilla.dev.servo 4
mpc.lists.nanog 4
TOTAL: 48 419

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5585
EMP (phn path) 577
EMP (phl) 148
Too many newsgroups 56
EMP (phn nph) 49
Too many newsgroups (low_xpost) 18
Binary: non-binary distribution 15
HTML post 13
User-issued cancel 10
Binary Image: misplaced jpg 2
HTML Multipart without Text/Plain. 1
User-issued spam cancel 1
MID-Bot 1
TOTAL: 13 6476

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 170
newsfeed.datemas.de 113
news.redatomik.org 52
news-out.mixmin.net 35
news.snarked.org 33
news.swapon.de 13
news-out.aioe.org 5
newsfeed.neva.ru 4
feeder.awxg.com 2
feeder.eternal-september.org 2
TOTAL: 10 429
TOTAL: 1 429

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18118 849 17144 125 0 0 4%23:59:29
2awxg 19380 77 19289 0 0 11 0%23:59:44
3news.snarked.org 15069 30 14867 36 0 620 0%23:59:46
4csiph.com 17943 20 17873 0 0 0 0%23:59:46
5news.freedyn.net 19614 11 19426 0 0 18 0%23:59:46
6news.albasani.net 18424 2 16341 744 0 5330 0%23:59:46
7news-in.mixmin.net 17891 1 17878 0 0 0 0%23:59:46
8neva.ru 18679 1 18673 1 0 0 0%23:59:46
9news.redatomik.org 18413 1 18401 0 0 0 0%23:59:43
10aioe 16692 1 16563 0 0 7 0%23:59:44
11newsfeed.datemas.de 16715 0 16713 1 0 0 0%23:59:45
12news.swapon.de 1766 0 1766 0 0 0 0%23:42:57
13mb-net.net 19951 0 19886 1 0 445 0%23:59:46
14news.samoylyk.net 0 0 0 0 0 18118 0%23:57:39
15eternal-september 16860 0 16815 0 0 61 0%23:59:46
TOTAL: 15 235515 993 231635 908 0 24610 0%359:37:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org5.0 MB9.3 MB14.3 MB0.2 KB/s15.0 KB23:59:29
2awxg263.2 KB0.0 KB263.2 KB0.0 KB/s3.4 KB23:59:44
3news.snarked.org161.3 KB172.2 KB333.5 KB0.0 KB/s5.1 KB23:59:46
4csiph.com41.7 KB0.0 KB41.7 KB0.0 KB/s2.1 KB23:59:46
5news.freedyn.net37.2 KB0.0 KB37.2 KB0.0 KB/s3.4 KB23:59:46
6news.albasani.net12.2 KB2.7 MB2.7 MB0.0 KB/s3.7 KB23:59:46
7news-in.mixmin.net9.8 KB0.0 KB9.8 KB0.0 KB/s9.8 KB23:59:46
8news.redatomik.org9.8 KB0.0 KB9.8 KB0.0 KB/s9.8 KB23:59:43
9aioe9.8 KB0.0 KB9.8 KB0.0 KB/s9.8 KB23:59:44
10neva.ru5.8 KB9.8 KB15.7 KB0.0 KB/s7.8 KB23:59:46
11newsfeed.datemas.de0.0 KB9.8 KB9.8 KB0.0 KB/s9.8 KB23:59:45
12news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:57
13mb-net.net0.0 KB9.8 KB9.8 KB0.0 KB/s9.8 KB23:59:46
14news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:39
15eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
TOTAL: 155.5 MB12.2 MB17.7 MB0.0 KB/s9.5 KB359:37:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 320 617322.2 MB 3457 0 000:11:11
2kosh.activateit.net.au 24 12941.8 MB 156 0 000:05:35
3192.168.1.8 1 104450.9 KB 4 0 000:00:06
460.234.244.55 6 729.5 KB 1 1 000:15:11
567-61-218-236.cpe.cableone.net 1 12.0 KB 3 0 014:48:02
TOTAL: 5 352 757924.5 MB 3621 1 016:31:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 320 617322.2 MB 3457 0 000:11:11
2*.activateit.net.au 24 12941.8 MB 156 0 000:05:35
3unresolved 22 111480.4 KB 5 1 001:26:27
4*.cpe.cableone.net 1 12.0 KB 3 0 014:48:02
TOTAL: 4 367 757924.5 MB 3621 1 016:31:19

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 4
malcolmlewis 1
paulh 1
TOTAL: 4 30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.124 0.028 0.00314:48:02
118.149.155.74 0.548 0.072 0.00000:41:59
60.234.244.55 0.340 0.060 0.00900:15:11
118.149.235.229 0.188 0.016 0.00000:15:07
agency.bbs.geek.nz 23.056 5.392 0.00000:11:11
118.149.207.136 0.120 0.008 0.00000:09:01
kosh.activateit.net.au 1.408 0.400 0.15900:05:35
118.149.160.52 0.060 0.004 0.00000:05:01
192.168.1.8 0.096 0.036 0.00300:00:06
? 1.636 0.192 0.00000:00:02
TOTAL: 10 27.576 6.208 0.17416:31:19

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.155.74 9
118.149.235.229 3
118.149.207.136 2
118.149.160.52 1
TOTAL: 4 15

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 3480 45.9%
2comp 1270 16.7%
3soc 865 11.4%
4sci 738 9.7%
5alt 661 8.7%
6talk 158 2.1%
7misc 133 1.8%
8nz 126 1.7%
9news 67 0.9%
10uk 38 0.5%
11humanities 21 0.3%
12aus 19 0.3%
13agency 7 0.1%
TOTAL: 13 7583100.0%

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

NewsgroupCount
1rec.arts.tv 905
2rec.arts.drwho 332
3rec.sport.tennis 326
4comp.lang.python 319
5alt.comp.os.windows-10 311
6comp.os.linux.advocacy 274
7rec.arts.sf.written 265
8alt.home.repair 234
9soc.culture.israel 167
10rec.food.cooking 165
11soc.culture.polish 157
12soc.retirement 128
13rec.sport.football.college 124
14rec.sport.pro-wrestling 117
15sci.electronics.design 102
16sci.physics 102
17nz.general 101
18rec.boats 100
19rec.sport.golf 96
20rec.bicycles.tech 88
21rec.photo.digital 84
22sci.physics.relativity 81
23comp.lang.c 81
24rec.gambling.poker 80
25rec.arts.movies.past-films 76
26sci.logic 66
27sci.military.naval 60
28alt.os.linux.ubuntu 58
29sci.math 56
30talk.origins 54
31rec.arts.sf.tv 54
32talk.politics.misc 53
33news.lists.filters 50
34rec.arts.movies.current-films 50
35misc.survivalism 48
36soc.penpals 47
37talk.politics.guns 47
38comp.mobile.android 46
39soc.culture.china 45
40soc.culture.indian 42
41sci.lang 41
42comp.sys.mac.system 40
43comp.sys.acorn.programmer 40
44soc.culture.cuba 39
45comp.sys.mac.apps 38
46rec.autos.sport.f1 36
47sci.electronics.repair 35
48misc.health.alternative 35
49rec.radio.shortwave 34
50rec.aviation.soaring 33
51comp.os.linux.misc 33
52sci.space.news 33
53alt.test 31
54comp.sys.mac.advocacy 30
55uk.radio.amateur 30
56sci.astro.amateur 28
57comp.lang.ada 28
58rec.boats.paddle 27
59soc.culture.vietnamese 27
60comp.lang.forth 27
61sci.med.pharmacy 27
62comp.soft-sys.matlab 27
63rec.music.classical.recordings 26
64soc.culture.singapore 26
65soc.culture.bulgaria 26
66rec.woodworking 23
67nz.comp 23
68sci.crypt 22
69rec.puzzles 20
70comp.os.vms 20
71rec.music.dylan 19
72rec.radio.amateur.misc 19
73rec.arts.comics.strips 18
74comp.sys.apple2.programmer 18
75soc.history.medieval 17
76misc.phone.mobile.iphone 17
77comp.lang.java.programmer 17
78comp.soft-sys.math.scilab 17
79rec.games.trivia 16
80soc.culture.brazil 16
81comp.soft-sys.sas 16
82comp.lang.lisp 16
83rec.outdoors.rv-travel 15
84soc.men 15
85rec.skiing.alpine 14
86rec.sport.soccer 12
87comp.unix.programmer 12
88rec.puzzles.crosswords 12
89rec.radio.amateur.dx 12
90comp.arch 12
91rec.games.pinball 12
92humanities.lit.authors.shakespeare 12
93rec.crafts.metalworking 12
94comp.sys.raspberry-pi 12
95soc.culture.romanian 12
96soc.culture.usa 11
97misc.invest.stocks 10
98rec.games.video.sony 10
99comp.sys.apple2 10
100rec.arts.tv.soaps.cbs 10
TOTAL: 317 7583