news.bbs.geek.nz daily logs

Sep 24 23:58:02 -- Sep 25 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 85676 50.8%7.0 MB 30.2%
innd 30573 18.1%5.1 MB 22.0%
inn 27897 16.5%6.3 MB 27.3%
innfeed 23105 13.7%4.5 MB 19.5%
cnfsstat 1440 0.9%251.4 KB 1.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 168692 100.0%23.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 266814 47.9%
Negative hits 264061 47.4%
Do not exist 26229 4.7%
Cache misses 279 0.1%
TOTAL: 4 557383 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.187 0.0%147 0.000 1.272 14.000
article cleanup00:00:00.264 0.0%27313 0.000 0.010 0.031
article logging00:00:01.135 0.0%27777 0.005 0.041 2.013
article parse00:00:00.850 0.0%72366 0.000 0.012 0.030
article write00:00:02.181 0.0%20762 0.013 0.105 7.089
artlog/artcncl00:00:00.001 0.0%143 0.000 0.007 0.500
data move00:00:00.376 0.0%518663 0.000 0.001 0.011
hisgrep/artcncl00:00:00.001 0.0%144 0.000 0.007 0.067
hishave/artcncl00:00:00.001 0.0%147 0.000 0.007 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.181 0.0%561412 0.001 0.011 1.118
history sync00:00:00.016 0.0%370 0.000 0.043 0.500
history write00:00:05.724 0.0%26435 0.013 0.217 14.544
hiswrite/artcncl00:00:00.001 0.0%3 0.000 0.333 1.000
idle23:57:59.413 99.8%538381 87.613 160.257 430.767
nntp read00:00:02.970 0.0%540058 0.001 0.005 0.014
overview write00:00:40.182 0.0%20762 0.057 1.935 114.956
perl filter00:00:53.743 0.1%26435 1.389 2.033 8.959
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.343 0.0%41524 0.006 0.032 0.115
TOTAL: 24:00:51.91823:59:54.569 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.087 0.0%47786 0.000 0.002 0.015
article prepare00:00:00.001 0.0%9924 0.000 0.000 0.023
article read00:00:00.488 0.0%2256 0.000 0.216 32.500
backlog stats00:00:00.302 0.0%345672 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.698 0.0%284122 0.001 0.006 0.011
data write00:00:03.140 0.0%272028 0.003 0.012 0.098
idle24:03:26.132 99.9%345672 101.229 250.544 575.752
status file00:00:25.281 0.0%1884 0.769 13.419 503.306
TOTAL: 24:04:15.47424:03:57.129100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%9 0.000 0.000 0.000
idle16:37:55.229 94.6%99469 0.000 601.949365666.600
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:02:08.902 0.2%229335 0.000 0.562 4.697
readart00:00:02.442 0.0%16244 0.000 0.150 45.889
TOTAL: 17:35:22.61816:40:06.573 94.8%----

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 48 19362 6293 12667 402 32%52:55:18
2newsfeed.datemas.de 4 21757 3838 17342 577 17%25:15:16
3news-out.mixmin.net 19 22307 2537 18913 857 11%31:56:18
4news.redatomik.org 1 19665 2166 17396 103 11%24:13:27
5feeder.eternal-september.org 79 24459 2132 21300 1027 8%49:28:30
6news-out.aioe.org 4 20027 1155 18805 67 5%25:32:40
7newsfeed.neva.ru 154 16319 1103 12702 2514 6%89:05:29
8csiph.com 2 19331 713 18568 50 3%24:09:02
9news.albasani.net 2 22704 319 22110 275 1%25:59:18
10news.samoylyk.net 3 31001 217 30127 657 0%32:08:20
11news.swapon.de 3 2076 154 1919 3 7%24:01:22
12news.freedyn.net 2 21348 125 21116 107 0%23:59:45
13feeder.awxg.com 2 16638 118 16459 61 0%23:59:50
14agency-nz-out.news.mb-net.net 23 22786 69 22610 107 0%33:19:55
15localhost 6 5 5 0 0 100%00:00:01
TOTAL: 15 352 279785 20944 252034 6807 7%486:04:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.4 MB236.2 KB1.5 MB23.1 MB 92%3.5 KB
2newsfeed.datemas.de12.2 MB355.8 KB1.6 MB14.1 MB 86%3.3 KB
3news-out.mixmin.net8.4 MB265.7 KB2.0 MB10.6 MB 79%3.2 KB
4feeder.eternal-september.org7.6 MB590.0 KB4.8 MB13.0 MB 58%4.2 KB
5news.redatomik.org5.2 MB199.8 KB296.2 KB5.7 MB 91%2.6 KB
6news.albasani.net3.2 MB619.6 KB1.1 MB4.9 MB 64%8.5 KB
7newsfeed.neva.ru3.2 MB231.6 KB11.3 MB14.7 MB 21%4.2 KB
8news-out.aioe.org2.8 MB187.4 KB316.3 KB3.2 MB 84%2.7 KB
9csiph.com1.9 MB201.4 KB201.4 KB2.3 MB 83%3.1 KB
10news.samoylyk.net1.2 MB667.7 KB13.7 MB15.5 MB 7%18.2 KB
11news.freedyn.net987.7 KB417.3 KB996.4 KB2.3 MB 41%10.4 KB
12news.swapon.de418.8 KB7.5 KB7.5 KB433.8 KB 96%2.8 KB
13feeder.awxg.com383.6 KB230.1 KB232.9 KB846.6 KB 45%4.7 KB
14agency-nz-out.news.mb-net.net180.9 KB229.4 KB778.5 KB1.2 MB 15%6.8 KB
15localhost7.2 KB0.0 KB0.0 KB7.2 KB100%1.4 KB
TOTAL: 1568.9 MB4.3 MB38.7 MB111.9 MB 61%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 23:58:02 - 23:59:59 18 0.1% 0.1533.8 KB 0.0% 0.29
Sep 25 00:00:00 - 00:59:59 759 3.7% 0.212.1 MB 3.2% 0.60
Sep 25 01:00:00 - 01:59:59 954 4.6% 0.272.7 MB 4.1% 0.78
Sep 25 02:00:00 - 02:59:59 941 4.5% 0.262.6 MB 4.0% 0.75
Sep 25 03:00:00 - 03:59:59 1003 4.8% 0.282.8 MB 4.2% 0.80
Sep 25 04:00:00 - 04:59:59 1149 5.5% 0.324.1 MB 6.2% 1.17
Sep 25 05:00:00 - 05:59:59 1035 5.0% 0.293.4 MB 5.1% 0.95
Sep 25 06:00:00 - 06:59:59 1168 5.6% 0.323.8 MB 5.7% 1.08
Sep 25 07:00:00 - 07:59:59 1178 5.7% 0.333.7 MB 5.6% 1.06
Sep 25 08:00:00 - 08:59:59 1210 5.8% 0.344.0 MB 6.0% 1.13
Sep 25 09:00:00 - 09:59:59 1233 5.9% 0.344.1 MB 6.1% 1.15
Sep 25 10:00:00 - 10:59:59 1093 5.3% 0.303.3 MB 4.9% 0.93
Sep 25 11:00:00 - 11:59:59 821 4.0% 0.233.3 MB 5.0% 0.94
Sep 25 12:00:00 - 12:59:59 736 3.5% 0.202.4 MB 3.7% 0.69
Sep 25 13:00:00 - 13:59:59 568 2.7% 0.161.9 MB 2.8% 0.53
Sep 25 14:00:00 - 14:59:59 573 2.8% 0.162.3 MB 3.5% 0.65
Sep 25 15:00:00 - 15:59:59 452 2.2% 0.131.9 MB 2.9% 0.55
Sep 25 16:00:00 - 16:59:59 450 2.2% 0.122.2 MB 3.3% 0.61
Sep 25 17:00:00 - 17:59:59 490 2.4% 0.141.7 MB 2.6% 0.49
Sep 25 18:00:00 - 18:59:59 556 2.7% 0.151.7 MB 2.6% 0.49
Sep 25 19:00:00 - 19:59:59 614 3.0% 0.171.7 MB 2.5% 0.47
Sep 25 20:00:00 - 20:59:59 855 4.1% 0.242.5 MB 3.8% 0.72
Sep 25 21:00:00 - 21:59:59 957 4.6% 0.273.0 MB 4.5% 0.86
Sep 25 22:00:00 - 22:59:59 927 4.5% 0.262.3 MB 3.5% 0.65
Sep 25 23:00:00 - 23:58:01 1023 4.9% 0.292.7 MB 4.1% 0.81
TOTAL: 23:59:59 20763 100.0% 0.2466.2 MB 100.0% 0.78
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.3 GB 40.5% 0 0.33 1829.49
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.5 GB 47.0% 0 0.33 1850.35
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB250.2 MB 0.5% 0 0.0319916.41
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 GB8.8 GB 17.7% 0 0.65 934.85
TOTAL: 10-500.0 GB52.8 GB 10.6% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2452 46 0 48 0 0 0 0 2358
2feeder.eternal-september.org 1005 0 0 139 0 0 0 0 866
3news-out.mixmin.net 949 0 0 76 0 0 0 0 873
4newsfeed.datemas.de 725 175 0 74 0 0 0 0 476
5news.samoylyk.net 530 0 0 80 0 0 0 0 450
6news.snarked.org 398 39 0 68 0 0 0 0 291
7news.albasani.net 265 2 0 86 0 0 0 0 177
8news.redatomik.org 225 0 0 63 0 0 0 0 162
9news.freedyn.net 118 10 0 45 0 0 0 0 63
10agency-nz-out.news.mb-net.net 110 14 0 61 0 0 0 0 35
11news-out.aioe.org 71 17 0 46 0 0 0 0 8
12feeder.awxg.com 69 3 0 66 0 0 0 0 0
13csiph.com 37 0 0 37 0 0 0 0 0
14news.swapon.de 32 0 0 4 0 0 0 0 28
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 6988 306 0 895 0 0 0 0 5787

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 61
it.annunci.commerciali 46
it.annunci.immobiliari 44
it.annunci.varie 40
mpc.lists.freebsd.office 20
mpc.lists.freebsd.ports.bugs 15
mpc.lists.nanog 11
gmane.comp.gis.openstreetmap.tagging 11
mozilla.support.seamonkey 9
gmane.linux.alsa.devel 7
mozilla.dev.ui-alerts 4
mozilla.support.bugzilla 3
eagle.support.ger 3
mozilla.dev.platform 3
mpc.lists.freebsd.gnome 2
al.christnet.bible 2
albasani.usenet-friends 2
easynews.general 2
mozilla.community.india 2
mozilla.apis 1
TOTAL: 38 306

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4600
EMP (phn path) 344
EMP (phn nph) 162
Binary Image: misplaced jpg 114
Too many newsgroups 40
User-issued cancel 12
Too many newsgroups (low_xpost) 11
Binary: non-binary distribution 8
Binary: misplaced par2 7
HTML post 7
Cancel for rejected article 3
Binary: misplaced 023 2
Binary: misplaced 078 1
Binary: misplaced 045 1
Binary: misplaced 034 1
Binary: misplaced 057 1
Binary: misplaced 043 1
Binary: misplaced 024 1
Binary: misplaced 027 1
Binary: misplaced 068 1
TOTAL: 25 5323

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 162
news-out.mixmin.net 137
news.redatomik.org 116
news.swapon.de 28
news.albasani.net 8
news-out.aioe.org 4
newsfeed.neva.ru 4
agency-nz-out.news.mb-net.net 2
news.snarked.org 2
news.samoylyk.net 1
TOTAL: 10 464
TOTAL: 1 464

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19069 1353 17655 61 0 0 7%23:59:44
2awxg 20165 103 20031 2 0 5 0%23:59:46
3news.snarked.org 40164 45 14353 14 0 21088 0%23:59:44
4aioe 17605 17 17473 2 0 2 0%23:59:44
5csiph.com 20670 15 20147 0 0 34 0%23:59:40
6news.freedyn.net 20935 7 20627 4 0 34 0%23:59:44
7mb-net.net 20771 7 20652 0 0 2 0%23:59:44
8news.samoylyk.net 18967 6 18875 0 0 0 0%23:59:33
9news-in.mixmin.net 17725 5 17688 0 0 0 0%23:59:43
10news.redatomik.org 18579 5 18556 0 0 0 0%23:59:40
11neva.ru 19357 5 19337 0 0 0 0%23:59:44
12news.albasani.net 21130 4 19028 760 0 5578 0%23:59:44
13eternal-september 17833 3 17672 1 0 132 0%23:59:44
14newsfeed.datemas.de 17038 3 16936 0 0 127 0%23:59:44
15news.swapon.de 1933 2 1930 0 0 0 0%23:53:10
TOTAL: 15 291941 1580 260960 844 0 27002 0%359:49:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org9.1 MB1.6 MB10.8 MB0.1 KB/s7.8 KB23:59:44
2awxg444.2 KB7.2 KB451.4 KB0.0 KB/s4.3 KB23:59:46
3news.snarked.org135.3 KB35.5 KB170.7 KB0.0 KB/s2.9 KB23:59:44
4news.albasani.net99.7 KB3.2 MB3.3 MB0.0 KB/s4.4 KB23:59:44
5aioe56.8 KB7.7 KB64.5 KB0.0 KB/s3.4 KB23:59:44
6csiph.com36.7 KB0.0 KB36.7 KB0.0 KB/s2.4 KB23:59:40
7news.freedyn.net15.8 KB24.9 KB40.7 KB0.0 KB/s3.7 KB23:59:44
8mb-net.net12.1 KB0.0 KB12.1 KB0.0 KB/s1.7 KB23:59:44
9news.samoylyk.net9.3 KB0.0 KB9.3 KB0.0 KB/s1.6 KB23:59:33
10news-in.mixmin.net7.2 KB0.0 KB7.2 KB0.0 KB/s1.4 KB23:59:43
11news.redatomik.org7.2 KB0.0 KB7.2 KB0.0 KB/s1.4 KB23:59:40
12neva.ru7.2 KB0.0 KB7.2 KB0.0 KB/s1.4 KB23:59:44
13eternal-september4.1 KB5.7 KB9.8 KB0.0 KB/s2.4 KB23:59:44
14newsfeed.datemas.de4.1 KB0.0 KB4.1 KB0.0 KB/s1.4 KB23:59:44
15news.swapon.de3.2 KB0.0 KB3.2 KB0.0 KB/s1.6 KB23:53:10
TOTAL: 1510.0 MB4.9 MB14.9 MB0.0 KB/s6.3 KB359:49:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 298 683122.5 MB 3001 5 000:09:54
267-61-21-181.cpe.cableone.net 4 636521.5 MB 494 0 602:47:40
3163.47.16.169 24 11081.7 MB 123 0 000:04:52
460.234.244.55 5 1732.8 KB 1 0 000:25:24
TOTAL: 4 331 1432145.7 MB 3619 5 617:47:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 298 683122.5 MB 3001 5 000:09:54
2*.cpe.cableone.net 6 636521.5 MB 494 0 616:00:43
3unresolved 42 11251.7 MB 124 0 001:36:40
TOTAL: 3 346 1432145.7 MB 3619 5 617:47:20

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 5
bpanther 3
malcolmlewis 2
TOTAL: 4 34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.092 0.016 0.02113:13:03
67-61-21-181.cpe.cableone.net 0.704 0.764 0.00902:47:40
118.149.159.64 0.292 0.044 0.00000:35:56
60.234.244.55 0.400 0.032 0.01300:25:24
118.149.139.19 0.248 0.020 0.00000:16:15
202.174.187.54 0.180 0.020 0.00000:11:21
agency.bbs.geek.nz 21.480 4.760 0.00000:09:54
163.47.16.169 1.380 0.372 0.48500:04:52
118.149.184.25 0.124 0.004 0.00000:02:50
? 1.532 0.188 0.00000:00:02
TOTAL: 10 26.432 6.220 0.52817:47:20

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.159.64 4
118.149.139.19 4
202.174.187.54 3
118.149.184.25 2
67-60-219-146.cpe.cableone.net 2
TOTAL: 5 15

NNRP gethostbyaddr failures [Top 20]:

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
118.149.159.64 1 1
67-61-21-181.cpe.cableone.net 1 0
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5610 39.2%
2sci 2080 14.5%
3comp 1935 13.5%
4soc 1573 11.0%
5alt 1177 8.2%
6talk 841 5.9%
7misc 716 5.0%
8news 122 0.9%
9uk 95 0.7%
10aus 53 0.4%
11nz 48 0.3%
12humanities 26 0.2%
13mozilla 20 0.1%
14agency 8 0.1%
15eternal-september 8 0.1%
TOTAL: 15 14312100.0%

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

NewsgroupCount
1rec.arts.tv 1359
2rec.arts.drwho 672
3comp.os.linux.advocacy 624
4misc.survivalism 600
5rec.sport.tennis 588
6rec.food.cooking 562
7sci.math 490
8talk.politics.guns 395
9alt.atheism 370
10soc.retirement 369
11sci.physics 363
12sci.physics.relativity 344
13alt.comp.os.windows-10 339
14comp.lang.python 326
15soc.culture.polish 273
16talk.politics.misc 252
17sci.electronics.design 234
18soc.culture.israel 223
19rec.sport.pro-wrestling 219
20sci.military.naval 216
21comp.lang.c 208
22rec.photo.digital 199
23rec.boats 191
24talk.origins 157
25soc.culture.singapore 146
26rec.sport.football.college 143
27rec.sport.golf 138
28rec.gambling.poker 120
29alt.bible 118
30rec.arts.sf.written 118
31news.lists.filters 115
32alt.politics 113
33sci.logic 87
34rec.bicycles.tech 85
35sci.lang 83
36rec.sport.soccer 82
37rec.autos.tech 81
38uk.radio.amateur 78
39soc.culture.usa 74
40comp.sys.mac.system 70
41alt.recovery.aa 69
42rec.radio.shortwave 67
43soc.culture.china 64
44comp.protocols.time.ntp 56
45soc.culture.indian 56
46rec.arts.sf.fandom 55
47comp.sys.acorn.misc 55
48comp.soft-sys.sas 53
49aus.computers 53
50rec.aviation.soaring 48
51alt.test 46
52comp.os.vms 46
53rec.crafts.metalworking 46
54misc.health.alternative 45
55rec.music.classical.recordings 45
56nz.general 44
57alt.os.linux.ubuntu 43
58comp.sys.apple2 43
59rec.music.dylan 41
60rec.outdoors.rv-travel 40
61soc.culture.vietnamese 40
62soc.history.what-if 39
63sci.electronics.repair 39
64soc.genealogy.medieval 38
65sci.space.policy 38
66comp.soft-sys.math.scilab 37
67rec.autos.sport.f1 37
68comp.lang.forth 34
69talk.bizarre 33
70comp.sys.mac.apps 32
71soc.women 32
72alt.support.diabetes 30
73rec.aquaria.marine.misc 30
74rec.music.classical.guitar 30
75soc.genealogy.benelux 28
76rec.arts.movies.current-films 28
77comp.arch 28
78rec.gambling.lottery 28
79rec.games.pinball 26
80rec.arts.comics.strips 24
81rec.audio.pro 24
82comp.sys.acorn.hardware 24
83humanities.lit.authors.shakespeare 24
84soc.penpals 24
85comp.soft-sys.matlab 23
86comp.lang.fortran 23
87soc.genealogy.jewish 22
88sci.astro.amateur 22
89rec.music.rock-pop-r+b.1950s 21
90sci.electronics.basics 21
91comp.misc 21
92soc.culture.african.american 20
93rec.arts.sf.tv 20
94comp.lang.c++ 20
95sci.astro 19
96rec.sport.rowing 18
97sci.anthropology.paleo 18
98comp.lang.javascript 18
99uk.tech.broadcast 17
100rec.games.trivia 17
TOTAL: 296 14312