news.bbs.geek.nz daily logs

Jul 14 23:58:01 -- Jul 15 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 112874 56.4%9.0 MB 35.3%
innd 32586 16.3%5.4 MB 21.0%
inn 30009 15.0%6.5 MB 25.3%
innfeed 23164 11.6%4.5 MB 17.4%
cnfsstat 1440 0.7%249.9 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 200074 100.0%25.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 299461 50.1%
Positive hits 269715 45.1%
Do not exist 27942 4.7%
Cache misses 320 0.1%
TOTAL: 4 597438 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.274 0.0%118 0.000 2.322 17.000
article cleanup00:00:00.271 0.0%29455 0.000 0.009 0.026
article logging00:00:00.719 0.0%29911 0.000 0.024 0.067
article parse00:00:00.926 0.0%79213 0.003 0.012 0.030
article write00:00:01.565 0.0%20779 0.017 0.075 0.349
artlog/artcncl00:00:00.000 0.0%110 0.000 0.000 0.000
data move00:00:00.643 0.0%557759 0.000 0.001 0.017
hisgrep/artcncl00:00:00.002 0.0%118 0.000 0.017 0.500
hishave/artcncl00:00:00.001 0.0%118 0.000 0.008 0.067
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.110 0.0%602597 0.001 0.012 0.756
history sync00:00:00.009 0.0%365 0.000 0.025 0.500
history write00:00:05.989 0.0%28180 0.011 0.213 11.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:26.352 99.8%579455 81.362 148.840 360.988
nntp read00:00:03.610 0.0%580702 0.003 0.006 0.032
overview write00:00:48.048 0.1%20779 0.053 2.312 94.781
perl filter00:01:06.080 0.1%28180 1.347 2.345 22.794
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.268 0.0%41558 0.004 0.031 0.101
TOTAL: 24:00:48.39323:59:42.867 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%27386 0.000 0.002 0.040
article prepare00:00:00.001 0.0%8012 0.000 0.000 0.023
article read00:00:00.102 0.0%1832 0.000 0.056 8.500
backlog stats00:00:00.286 0.0%323638 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.556 0.0%270420 0.001 0.006 0.010
data write00:00:02.957 0.0%258790 0.005 0.011 0.019
idle23:53:55.344100.0%323638 159.983 265.838 586.987
status file00:00:07.401 0.0%1868 0.700 3.962 157.909
TOTAL: 23:54:21.96723:54:07.712100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%7 0.000 0.000 0.000
idle29:53:45.388 96.3%121046 0.000 889.128 75102.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.302 0.0%258908 0.000 0.005 0.333
readart00:00:02.953 0.0%8787 0.000 0.336 38.043
TOTAL: 31:02:48.44529:53:49.643 96.3%----

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 55 19842 6318 13005 519 31%63:09:19
2news.redatomik.org 1 19737 3970 15668 99 20%24:11:27
3newsfeed.datemas.de 1 18539 3036 14683 820 16%19:34:47
4feeder.eternal-september.org 104 27023 1821 23756 1446 6%64:07:06
5news-out.mixmin.net 14 23753 1172 21860 721 4%29:10:53
6newsfeed.neva.ru 153 12402 984 9059 2359 7%87:01:32
7news-out.aioe.org 2 27727 975 26625 127 3%33:35:02
8news.albasani.net 1 20389 911 18784 694 4%21:41:17
9csiph.com 2 17280 677 16537 66 3%18:44:01
10news.freedyn.net 3 23936 382 23206 348 1%24:00:16
11news.samoylyk.net 2 28901 211 27708 982 0%25:18:47
12feeder.awxg.com 1 19223 165 18978 80 0%23:59:57
13news.swapon.de 5 1683 63 1601 19 3%23:58:33
14agency-nz-out.news.mb-net.net 29 21827 43 21636 148 0%31:07:43
15localhost 3 2 2 0 0 100%00:00:00
TOTAL: 15 376 282264 20730 253106 8428 7%489:40:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.3 MB510.4 KB2.1 MB23.9 MB 89%3.6 KB
2newsfeed.datemas.de10.4 MB504.9 KB2.2 MB13.1 MB 79%3.5 KB
3news.redatomik.org9.1 MB523.8 KB541.6 KB10.1 MB 89%2.5 KB
4feeder.eternal-september.org7.8 MB916.7 KB12.8 MB21.4 MB 36%6.7 KB
5news-out.mixmin.net5.1 MB624.4 KB2.1 MB7.8 MB 65%4.2 KB
6news.albasani.net3.5 MB598.3 KB1.8 MB5.9 MB 59%3.8 KB
7newsfeed.neva.ru2.9 MB204.0 KB12.2 MB15.4 MB 19%4.7 KB
8news-out.aioe.org2.8 MB327.5 KB370.0 KB3.5 MB 80%3.3 KB
9csiph.com1.9 MB272.5 KB282.0 KB2.5 MB 78%3.4 KB
10news.freedyn.net1.8 MB452.7 KB1.1 MB3.3 MB 53%4.7 KB
11news.samoylyk.net1.2 MB666.0 KB8.2 MB10.0 MB 11%8.6 KB
12feeder.awxg.com491.3 KB296.2 KB298.2 KB1.1 MB 45%4.4 KB
13agency-nz-out.news.mb-net.net261.9 KB319.9 KB1.3 MB1.9 MB 13%10.0 KB
14news.swapon.de171.1 KB51.9 KB51.9 KB274.9 KB 62%3.4 KB
15localhost3.5 KB0.0 KB0.0 KB3.5 KB100%1.7 KB
TOTAL: 1568.6 MB6.1 MB45.3 MB120.0 MB 57%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 14 23:58:01 - 23:59:59 20 0.1% 0.1747.4 KB 0.1% 0.40
Jul 15 00:00:00 - 00:59:59 1103 5.3% 0.313.3 MB 4.7% 0.93
Jul 15 01:00:00 - 01:59:59 1165 5.6% 0.324.5 MB 6.6% 1.29
Jul 15 02:00:00 - 02:59:59 1344 6.5% 0.374.2 MB 6.1% 1.20
Jul 15 03:00:00 - 03:59:59 1271 6.1% 0.354.3 MB 6.2% 1.22
Jul 15 04:00:00 - 04:59:59 1181 5.7% 0.333.2 MB 4.6% 0.91
Jul 15 05:00:00 - 05:59:59 1305 6.3% 0.364.6 MB 6.8% 1.32
Jul 15 06:00:00 - 06:59:59 1163 5.6% 0.323.9 MB 5.7% 1.11
Jul 15 07:00:00 - 07:59:59 1125 5.4% 0.313.0 MB 4.4% 0.86
Jul 15 08:00:00 - 08:59:59 1013 4.9% 0.284.6 MB 6.6% 1.30
Jul 15 09:00:00 - 09:59:59 1030 5.0% 0.294.0 MB 5.8% 1.14
Jul 15 10:00:00 - 10:59:59 744 3.6% 0.212.6 MB 3.7% 0.73
Jul 15 11:00:00 - 11:59:59 691 3.3% 0.192.0 MB 2.9% 0.57
Jul 15 12:00:00 - 12:59:59 615 3.0% 0.172.0 MB 3.0% 0.58
Jul 15 13:00:00 - 13:59:59 651 3.1% 0.182.3 MB 3.3% 0.64
Jul 15 14:00:00 - 14:59:59 424 2.0% 0.121.4 MB 2.1% 0.41
Jul 15 15:00:00 - 15:59:59 428 2.1% 0.121.8 MB 2.6% 0.50
Jul 15 16:00:00 - 16:59:59 453 2.2% 0.132.0 MB 3.0% 0.58
Jul 15 17:00:00 - 17:59:59 440 2.1% 0.121.8 MB 2.6% 0.50
Jul 15 18:00:00 - 18:59:59 656 3.2% 0.181.9 MB 2.8% 0.55
Jul 15 19:00:00 - 19:59:59 734 3.5% 0.202.0 MB 3.0% 0.58
Jul 15 20:00:00 - 20:59:59 785 3.8% 0.222.1 MB 3.1% 0.60
Jul 15 21:00:00 - 21:59:59 786 3.8% 0.222.2 MB 3.2% 0.62
Jul 15 22:00:00 - 22:59:59 826 4.0% 0.232.5 MB 3.7% 0.72
Jul 15 23:00:00 - 23:58:01 825 4.0% 0.242.4 MB 3.5% 0.72
TOTAL: 24:00:00 20778 100.0% 0.2468.8 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.4 GB 36.9% 0 0.34 1806.65
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.5 GB 43.0% 0 0.35 1736.31
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB227.9 MB 0.4% 0 0.0235555.56
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 GB4.7 GB 9.4% 0 0.67 905.26
TOTAL: 10-500.0 GB44.9 GB 9.0% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2383 76 0 46 0 0 0 0 2261
2feeder.eternal-september.org 1469 0 0 157 0 0 0 0 1312
3newsfeed.datemas.de 1038 188 0 107 0 0 0 0 743
4news.samoylyk.net 953 0 0 108 0 0 0 0 845
5news-out.mixmin.net 812 0 0 126 0 0 0 0 686
6news.albasani.net 806 3 0 115 0 0 0 0 688
7news.snarked.org 526 43 0 113 0 0 0 0 370
8news.freedyn.net 349 31 0 66 0 0 0 0 252
9news.redatomik.org 276 0 0 81 0 0 0 0 195
10agency-nz-out.news.mb-net.net 178 17 0 76 1 0 0 0 84
11news-out.aioe.org 114 22 0 71 0 0 0 0 21
12csiph.com 86 0 0 81 0 0 0 0 5
13feeder.awxg.com 84 1 0 82 0 0 0 0 1
14news.swapon.de 37 0 0 24 0 0 0 0 13
15news.ausics.org 10 0 0 10 0 0 0 0 0
TOTAL: 15 9121 381 0 1263 1 0 0 0 7476

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 113
it.annunci.commerciali 39
it.annunci.immobiliari 38
it.annunci.varie 37
mpc.lists.nanog 23
gmane.comp.gis.openstreetmap.tagging 23
mozilla.support.seamonkey 17
gmane.linux.alsa.devel 12
mozilla.dev.security.policy 11
mozilla.dev.ui-alerts 6
mpc.lists.freebsd.x11 5
mozilla.dev.platform 5
mozilla.dev.webdev 4
mozilla.dev.l10n 3
mozilla.test 3
eagle.support.ger 3
eagle.support.eng 3
demos.local.lists.cgp-russian 2
mozilla.apis 2
gmane.linux.kernel 2
TOTAL: 44 381

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

GroupsCount
nz.politics.announce 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5929
EMP (phn path) 640
EMP (phl) 160
EMP (phn nph) 145
Too many newsgroups 67
User-issued cancel 37
Too many newsgroups (low_xpost) 11
Binary: non-binary distribution 10
Binary: misplaced par2 4
Binary: misplaced PAR2 4
Poison newsgroup 2
User-issued spam cancel 2
Binary: misplaced 019 1
Binary Image: misplaced png 1
Binary: misplaced 017 1
Binary: misplaced 022 1
Binary Image: misplaced jpg 1
Binary: misplaced 020 1
Binary: misplaced 016 1
Binary: misplaced 010 1
TOTAL: 20 7019

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 181
newsfeed.datemas.de 139
news-out.mixmin.net 54
news.albasani.net 35
news.swapon.de 13
news.snarked.org 9
newsfeed.neva.ru 9
news-out.aioe.org 7
feeder.eternal-september.org 5
agency-nz-out.news.mb-net.net 2
TOTAL: 13 457
TOTAL: 1 457

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18909 707 18115 87 0 0 3%23:59:49
2awxg 19984 101 19872 6 0 9 0%23:59:48
3news.freedyn.net 20637 13 20388 0 0 27 0%23:59:49
4newsfeed.datemas.de 17602 2 17591 0 0 0 0%23:59:45
5eternal-september 17588 2 17533 0 0 108 0%23:59:49
6news.redatomik.org 16755 2 16729 0 0 0 0%23:59:49
7news.samoylyk.net 18723 2 18685 0 0 121 0%23:59:48
8csiph.com 20077 2 20012 0 0 0 0%23:59:49
9news.snarked.org 14467 2 14344 2 0 14 0%23:59:49
10aioe 16826 2 16704 0 0 2 0%23:59:49
11neva.ru 19436 2 19427 0 0 0 0%23:59:49
12mb-net.net 20760 2 20708 0 0 6 0%23:59:45
13news-in.mixmin.net 18717 2 18696 0 0 0 0%23:59:49
14news.albasani.net 21218 0 18425 973 0 6399 0%23:59:49
15news.swapon.de 1748 0 1748 0 0 0 0%23:59:49
TOTAL: 15 263447 841 258977 1068 0 6686 0%359:57:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.8 MB7.0 MB10.8 MB0.1 KB/s13.9 KB23:59:49
2awxg374.3 KB28.7 KB403.0 KB0.0 KB/s3.8 KB23:59:48
3news.freedyn.net38.1 KB0.0 KB38.1 KB0.0 KB/s2.9 KB23:59:49
4newsfeed.datemas.de3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:45
5eternal-september3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
6news.redatomik.org3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
7news.samoylyk.net3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:48
8csiph.com3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
9news.snarked.org3.5 KB2.3 KB5.7 KB0.0 KB/s1.4 KB23:59:49
10aioe3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
11neva.ru3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
12mb-net.net3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:45
13news-in.mixmin.net3.5 KB0.0 KB3.5 KB0.0 KB/s1.7 KB23:59:49
14news.albasani.net0.0 KB3.2 MB3.2 MB0.0 KB/s3.4 KB23:59:49
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
TOTAL: 154.2 MB10.2 MB14.4 MB0.0 KB/s7.7 KB359:57:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 369 675722.9 MB 3795 1 000:12:01
2163.47.16.169 24 11341.5 MB 152 0 000:05:22
360.234.244.55 7 1430.7 KB 1 1 000:23:12
467-61-218-236.cpe.cableone.net 2 23.6 KB 2 0 029:14:06
TOTAL: 4 402 790724.4 MB 3950 2 031:02:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 369 675722.9 MB 3795 1 000:12:01
2unresolved 44 11481.6 MB 153 1 001:36:30
3*.cpe.cableone.net 2 23.6 KB 2 0 029:14:06
TOTAL: 3 415 790724.4 MB 3950 2 031:02:41

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
malcolmlewis 2
TOTAL: 3 31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.172 0.096 0.00629:14:06
118.149.231.133 0.676 0.072 0.00000:58:01
60.234.244.55 0.496 0.048 0.01500:23:12
agency.bbs.geek.nz 26.396 6.112 0.00000:12:01
163.47.16.169 1.444 0.320 0.13400:05:22
118.149.181.54 0.056 0.012 0.00000:05:01
118.149.236.6 0.064 0.000 0.00000:04:52
? 1.680 0.156 0.00000:00:02
TOTAL: 8 30.984 6.816 0.15531:02:41

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.231.133 11
118.149.236.6 1
118.149.181.54 1
TOTAL: 3 13

NNRP gethostbyaddr failures [Top 20]:

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

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 3835 48.5%
2comp 1310 16.6%
3soc 834 10.6%
4sci 790 10.0%
5alt 469 5.9%
6misc 273 3.5%
7talk 193 2.4%
8news 78 1.0%
9uk 45 0.6%
10nz 28 0.4%
11aus 21 0.3%
12humanities 13 0.2%
13agency 7 0.1%
14eternal-september 4 0.1%
TOTAL: 14 7900100.0%

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

NewsgroupCount
1rec.arts.tv 899
2rec.sport.tennis 426
3rec.arts.drwho 422
4alt.comp.os.windows-10 409
5comp.lang.python 244
6rec.arts.sf.written 237
7comp.os.linux.advocacy 215
8misc.survivalism 208
9sci.physics.relativity 172
10comp.lang.c 171
11sci.electronics.design 164
12rec.food.cooking 160
13rec.sport.golf 160
14sci.physics 139
15comp.sys.mac.system 124
16soc.culture.israel 123
17talk.politics.misc 123
18rec.sport.pro-wrestling 123
19rec.boats 123
20rec.bicycles.tech 107
21soc.retirement 106
22soc.culture.polish 91
23rec.photo.digital 90
24rec.gambling.poker 81
25soc.culture.china 74
26rec.sport.football.college 72
27rec.sport.soccer 68
28soc.culture.usa 68
29rec.arts.movies.current-films 66
30talk.politics.guns 65
31soc.penpals 59
32comp.sys.apple2 58
33rec.music.rock-pop-r+b.1950s 54
34rec.arts.sf.fandom 53
35rec.crafts.metalworking 50
36soc.culture.cuba 48
37comp.os.linux.misc 46
38sci.logic 44
39rec.boats.racing.power 44
40soc.culture.singapore 43
41rec.radio.shortwave 42
42soc.culture.indian 41
43sci.space.policy 41
44misc.health.alternative 37
45comp.arch 36
46sci.military.naval 35
47alt.test 35
48rec.arts.tv.uk.coronation-st 34
49rec.radio.amateur.misc 33
50comp.lang.forth 32
51rec.audio.opinion 31
52uk.radio.amateur 29
53comp.lang.misc 29
54sci.math 29
55comp.protocols.time.ntp 28
56sci.lang 27
57sci.math.num-analysis 26
58soc.culture.vietnamese 26
59rec.arts.sf.science 25
60rec.outdoors.rv-travel 25
61news.lists.filters 24
62comp.soft-sys.matlab 24
63rec.aviation.soaring 23
64comp.mobile.ipad 23
65rec.music.classical.guitar 23
66sci.med.pharmacy 22
67comp.unix.shell 21
68rec.arts.comics.strips 20
69nz.general 20
70rec.games.pinball 19
71comp.lang.java.programmer 19
72news.admin.net-abuse.email 19
73comp.misc 19
74rec.arts.tv.soaps.cbs 18
75rec.skiing.alpine 18
76rec.music.classical.recordings 18
77comp.sys.mac.advocacy 18
78alt.os.linux.ubuntu 18
79comp.lang.c++ 17
80soc.genealogy.medieval 17
81uk.comp.homebuilt 16
82comp.soft-sys.math.scilab 16
83soc.genealogy.benelux 16
84comp.soft-sys.sas 16
85soc.culture.venezuela 16
86sci.bio.paleontology 15
87news.admin.net-abuse.usenet 14
88rec.audio.pro 14
89rec.drugs.cannabis 14
90sci.astro.amateur 14
91rec.arts.sf.tv 13
92comp.arch.embedded 13
93news.software.readers 12
94rec.autos.tech 12
95comp.os.vms 12
96aus.electronics 12
97rec.woodworking 12
98rec.radio.amateur.homebrew 12
99rec.autos.sport.f1 11
100comp.lang.lisp 11
TOTAL: 287 7900