news.bbs.geek.nz daily logs

Oct 5 23:58:01 -- Oct 6 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 66044 43.5%5.4 MB 24.5%
innd 31344 20.6%5.2 MB 23.5%
inn 29838 19.7%6.6 MB 30.3%
innfeed 23139 15.2%4.5 MB 20.5%
cnfsstat 1440 0.9%253.7 KB 1.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 151806 100.0%21.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 282261 47.7%
Positive hits 281245 47.6%
Do not exist 27704 4.7%
Cache misses 191 0.0%
TOTAL: 4 591401 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.255 0.0%179 0.000 1.425 18.000
article cleanup00:00:00.291 0.0%29076 0.000 0.010 0.037
article logging00:00:00.795 0.0%29682 0.000 0.027 0.189
article parse00:00:01.001 0.0%90450 0.000 0.011 0.030
article write00:00:01.565 0.0%21497 0.011 0.073 0.484
artlog/artcncl00:00:00.000 0.0%176 0.000 0.000 0.000
data move00:00:00.462 0.0%576779 0.000 0.001 0.012
hisgrep/artcncl00:00:00.004 0.0%171 0.000 0.023 1.000
hishave/artcncl00:00:00.001 0.0%179 0.000 0.006 0.038
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.758 0.0%598619 0.001 0.011 0.839
history sync00:00:00.016 0.0%359 0.000 0.045 0.667
history write00:00:06.827 0.0%28000 0.011 0.244 15.324
hiswrite/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
idle23:57:47.181 99.8%594683 83.786 145.064 406.500
nntp read00:00:03.448 0.0%596989 0.002 0.006 0.019
overview write00:00:38.646 0.0%21497 0.049 1.798 56.253
perl filter00:00:56.030 0.1%28000 1.342 2.001 7.250
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.424 0.0%42994 0.007 0.033 0.138
TOTAL: 24:00:49.89323:59:44.704 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%26654 0.000 0.002 0.046
article prepare00:00:00.002 0.0%11134 0.000 0.000 0.021
article read00:00:00.133 0.0%2578 0.000 0.052 0.875
backlog stats00:00:00.311 0.0%342063 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.823 0.0%287781 0.000 0.006 0.012
data write00:00:03.034 0.0%272359 0.006 0.011 0.020
idle23:53:01.473100.0%342063 148.204 251.362 588.915
status file00:00:19.839 0.0%1900 0.700 10.442 361.972
TOTAL: 23:53:43.80923:53:26.680100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle10:57:17.023 97.0%78975 0.000 499.361 75235.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:24.576 0.2%186812 0.000 0.453 3.391
readart00:00:02.031 0.0%15251 0.000 0.133 46.857
TOTAL: 11:17:51.11210:58:43.630 97.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 50 20329 6569 13302 458 32%48:56:42
2news-out.mixmin.net 10 22694 3199 18425 1070 14%24:28:40
3newsfeed.datemas.de 2 23851 2174 21052 625 9%24:50:26
4feeder.eternal-september.org 103 25995 1982 22921 1092 7%57:07:22
5news-out.aioe.org 3 21444 1818 19441 185 8%23:57:20
6news.albasani.net 1 23209 1748 20798 663 7%24:00:16
7newsfeed.neva.ru 157 17805 1512 14008 2285 8%86:18:12
8news.redatomik.org 1 23537 1047 22406 84 4%28:19:19
9csiph.com 2 17319 689 16581 49 3%19:04:17
10news.swapon.de 3 1735 174 1555 6 10%23:56:11
11feeder.awxg.com 2 18802 124 18586 92 0%23:59:52
12agency-nz-out.news.mb-net.net 20 24919 111 24517 291 0%29:10:08
13news.samoylyk.net 2 27509 103 26792 614 0%24:32:26
14news.freedyn.net 2 24288 53 24149 86 0%23:59:46
15localhost 3 2 2 0 0 100%00:00:01
TOTAL: 15 361 293438 21305 264533 7600 7%462:40:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org25.5 MB306.6 KB1.8 MB27.6 MB 92%4.0 KB
2news-out.mixmin.net8.4 MB281.4 KB2.2 MB10.9 MB 77%2.6 KB
3feeder.eternal-september.org8.3 MB630.7 KB5.0 MB13.9 MB 59%4.6 KB
4newsfeed.datemas.de7.5 MB533.0 KB2.0 MB10.0 MB 74%3.7 KB
5news.albasani.net7.0 MB789.1 KB2.0 MB9.7 MB 71%4.1 KB
6news-out.aioe.org4.0 MB195.9 KB473.9 KB4.7 MB 86%2.4 KB
7newsfeed.neva.ru3.7 MB293.7 KB10.6 MB14.6 MB 25%3.9 KB
8news.redatomik.org2.8 MB426.9 KB435.6 KB3.6 MB 76%3.3 KB
9csiph.com1.9 MB134.9 KB137.5 KB2.2 MB 87%3.0 KB
10news.freedyn.net1.1 MB455.2 KB788.5 KB2.3 MB 47%16.9 KB
11news.swapon.de501.5 KB5.8 KB10.1 KB517.5 KB 96%2.9 KB
12agency-nz-out.news.mb-net.net450.4 KB474.6 KB13.0 MB13.9 MB 3%35.5 KB
13news.samoylyk.net386.7 KB506.7 KB17.1 MB17.9 MB 2%25.6 KB
14feeder.awxg.com348.7 KB291.5 KB316.2 KB956.5 KB 36%4.4 KB
15localhost2.7 KB0.0 KB0.0 KB2.7 KB100%1.3 KB
TOTAL: 1571.8 MB5.2 MB55.7 MB132.7 MB 54%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 5 23:58:01 - 23:59:59 28 0.1% 0.2462.0 KB 0.1% 0.52
Oct 6 00:00:00 - 00:59:59 933 4.3% 0.263.3 MB 4.6% 0.94
Oct 6 01:00:00 - 01:59:59 1105 5.1% 0.313.0 MB 4.2% 0.86
Oct 6 02:00:00 - 02:59:59 1186 5.5% 0.333.9 MB 5.4% 1.11
Oct 6 03:00:00 - 03:59:59 1229 5.7% 0.343.6 MB 5.0% 1.02
Oct 6 04:00:00 - 04:59:59 1248 5.8% 0.354.2 MB 5.8% 1.19
Oct 6 05:00:00 - 05:59:59 1318 6.1% 0.373.8 MB 5.3% 1.08
Oct 6 06:00:00 - 06:59:59 1458 6.8% 0.414.2 MB 5.8% 1.19
Oct 6 07:00:00 - 07:59:59 1212 5.6% 0.344.8 MB 6.6% 1.36
Oct 6 08:00:00 - 08:59:59 1108 5.2% 0.313.0 MB 4.1% 0.84
Oct 6 09:00:00 - 09:59:59 1079 5.0% 0.303.6 MB 5.1% 1.03
Oct 6 10:00:00 - 10:59:59 906 4.2% 0.253.6 MB 5.0% 1.03
Oct 6 11:00:00 - 11:59:59 768 3.6% 0.213.9 MB 5.4% 1.11
Oct 6 12:00:00 - 12:59:59 611 2.8% 0.171.9 MB 2.7% 0.55
Oct 6 13:00:00 - 13:59:59 529 2.5% 0.151.6 MB 2.2% 0.46
Oct 6 14:00:00 - 14:59:59 486 2.3% 0.142.4 MB 3.3% 0.68
Oct 6 15:00:00 - 15:59:59 441 2.1% 0.121.6 MB 2.3% 0.47
Oct 6 16:00:00 - 16:59:59 457 2.1% 0.131.8 MB 2.6% 0.53
Oct 6 17:00:00 - 17:59:59 448 2.1% 0.121.6 MB 2.2% 0.45
Oct 6 18:00:00 - 18:59:59 503 2.3% 0.142.2 MB 3.0% 0.62
Oct 6 19:00:00 - 19:59:59 631 2.9% 0.182.0 MB 2.8% 0.57
Oct 6 20:00:00 - 20:59:59 841 3.9% 0.232.4 MB 3.3% 0.68
Oct 6 21:00:00 - 21:59:59 897 4.2% 0.253.2 MB 4.4% 0.90
Oct 6 22:00:00 - 22:59:59 1026 4.8% 0.283.3 MB 4.6% 0.94
Oct 6 23:00:00 - 23:58:01 1035 4.8% 0.302.9 MB 4.0% 0.84
TOTAL: 24:00:00 21483 100.0% 0.2571.9 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.6 GB 41.1% 0 0.33 1835.96
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.8 GB 47.6% 0 0.37 1652.38
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB254.2 MB 0.5% 0 0.0416732.85
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 GB9.5 GB 19.0% 0 0.70 863.39
TOTAL: 10-500.0 GB54.1 GB 10.8% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2287 72 0 57 0 0 0 0 2158
2news-out.mixmin.net 1331 0 0 91 0 0 0 0 1240
3feeder.eternal-september.org 1094 0 0 146 0 0 0 0 948
4news.albasani.net 799 5 0 87 0 0 0 0 707
5newsfeed.datemas.de 699 188 0 97 0 0 0 0 414
6news.samoylyk.net 613 0 0 92 0 0 0 0 521
7news.snarked.org 467 77 0 79 0 0 0 0 311
8agency-nz-out.news.mb-net.net 273 27 0 85 0 0 0 0 161
9news-out.aioe.org 182 12 0 69 0 0 0 0 101
10news.redatomik.org 161 0 0 65 0 0 0 0 96
11feeder.awxg.com 86 0 0 75 0 0 0 0 11
12news.freedyn.net 80 2 0 63 0 0 0 0 15
13csiph.com 65 0 0 63 0 0 0 0 2
14news.swapon.de 36 0 0 3 0 0 0 0 33
15news.ausics.org 6 0 0 6 0 0 0 0 0
TOTAL: 15 8179 383 0 1078 0 0 0 0 6718

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 58
mpc.lists.freebsd.ports.bugs 54
it.annunci.varie 36
it.annunci.commerciali 35
it.annunci.immobiliari 35
gmane.linux.alsa.devel 23
mpc.lists.nanog 20
gmane.comp.gis.openstreetmap.tagging 17
mozilla.dev.platform 16
mozilla.dev.l10n.sr 13
eagle.support.ger 7
mozilla.test 7
mozilla.dev.servo 7
mpc.lists.freebsd.x11 5
fido7.ru.android 5
mozilla.dev.l10n 4
mozilla.dev.security.policy 4
argonet.cfc 4
gmane.linux.kernel 4
mozilla.support.bugzilla 3
TOTAL: 39 383

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4934
EMP (phn path) 490
Binary Image: misplaced jpg 377
EMP (phn nph) 218
Too many newsgroups 42
User-issued cancel 19
Binary: non-binary distribution 14
EMP (phl) 5
Poison newsgroup 4
Binary: misplaced PAR2 3
Too many newsgroups (low_xpost) 2
Binary: misplaced par2 2
Too many newsgroups (meow) 2
Binary: misplaced zip 1
Cancel for rejected article 1
Binary: misplaced 006 1
TOTAL: 16 6115

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 229
news.albasani.net 127
newsfeed.datemas.de 96
news.redatomik.org 92
news.swapon.de 30
news-out.aioe.org 11
newsfeed.neva.ru 8
feeder.awxg.com 5
news.samoylyk.net 3
agency-nz-out.news.mb-net.net 2
TOTAL: 10 603
TOTAL: 1 603

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19429 1697 17679 53 0 0 8%23:59:47
2awxg 21062 88 20925 0 0 9 0%23:59:47
3news.snarked.org 14770 16 14637 4 0 14 0%23:59:47
4news.freedyn.net 21734 16 21412 1 0 14 0%23:59:35
5eternal-september 18687 3 18507 0 0 0 0%23:59:44
6csiph.com 20723 2 20649 0 0 0 0%23:59:47
7aioe 18649 2 18540 0 0 0 0%23:59:46
8news.redatomik.org 20368 2 20348 0 0 0 0%23:59:47
9mb-net.net 21354 2 21310 0 0 0 0%23:59:47
10news-in.mixmin.net 17530 2 17517 0 0 0 0%23:59:46
11news.samoylyk.net 19390 2 19339 0 0 0 0%23:59:39
12neva.ru 19421 2 19404 0 0 0 0%23:59:47
13newsfeed.datemas.de 19399 1 19347 0 0 77 0%23:59:47
14news.swapon.de 1848 0 1848 0 0 0 0%23:58:06
15news.albasani.net 21057 0 18652 809 1 5195 0%23:59:47
TOTAL: 15 275421 1835 270114 867 1 5309 0%359:54:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org15.2 MB2.3 MB17.5 MB0.2 KB/s10.2 KB23:59:47
2news.snarked.org388.0 KB17.3 KB405.3 KB0.0 KB/s20.3 KB23:59:47
3awxg306.4 KB0.0 KB306.4 KB0.0 KB/s3.5 KB23:59:47
4news.freedyn.net34.4 KB5.0 KB39.4 KB0.0 KB/s2.3 KB23:59:35
5eternal-september4.2 KB0.0 KB4.2 KB0.0 KB/s1.4 KB23:59:44
6csiph.com2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:47
7aioe2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:46
8news.redatomik.org2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:47
9mb-net.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:47
10news-in.mixmin.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:46
11news.samoylyk.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:39
12neva.ru2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:47
13newsfeed.datemas.de1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:47
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:06
15news.albasani.net0.0 KB1.6 MB1.6 MB0.0 KB/s2.0 KB23:59:47
TOTAL: 1515.9 MB3.9 MB19.9 MB0.0 KB/s7.5 KB359:54:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 3 651924.8 MB 579 0 601:48:44
2agency.bbs.geek.nz 275 609021.6 MB 2579 2 000:08:13
3163.47.16.169 24 9081.3 MB 127 0 000:04:25
460.234.244.55 3 513.3 KB 1 0 000:15:22
TOTAL: 4 305 1352247.8 MB 3286 2 611:17:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 4 651924.8 MB 579 0 610:25:33
2*.bbs.geek.nz 275 609021.6 MB 2579 2 000:08:13
3unresolved 31 9131.3 MB 128 0 000:38:01
4*.dsl.bell.ca 35 00.0 KB 0 0 000:05:54
TOTAL: 4 345 1352247.8 MB 3286 2 611:17:46

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 3
bpanther 3
malcolmlewis 1
TOTAL: 4 31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.076 0.020 0.00308:36:49
67-61-21-181.cpe.cableone.net 0.820 0.664 0.00901:48:44
60.234.244.55 0.208 0.040 0.00900:15:22
118.149.240.184 0.180 0.020 0.00000:13:22
agency.bbs.geek.nz 18.704 3.864 0.00000:08:13
mtrlpq2314w-lp130-05-70-55-68-132.dsl.bell.ca 1.780 0.292 0.00000:05:54
118.149.215.35 0.052 0.016 0.00000:04:51
163.47.16.169 1.412 0.340 0.32600:04:25
? 1.224 0.124 0.00000:00:02
TOTAL: 9 24.456 5.380 0.34711:17:46

Curious NNRP server explorers [Top 20]:

SystemConn
mtrlpq2314w-lp130-05-70-55-68-132.dsl.bell.ca 35
118.149.240.184 3
118.149.215.35 1
67-60-219-146.cpe.cableone.net 1
TOTAL: 4 40

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
agency.bbs.geek.nz 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5457 40.4%
2sci 1950 14.4%
3comp 1919 14.2%
4soc 1584 11.7%
5alt 1063 7.9%
6talk 622 4.6%
7misc 322 2.4%
8uk 264 2.0%
9news 227 1.7%
10humanities 77 0.6%
11mozilla 15 0.1%
12nz 10 0.1%
13eternal-september 6 0.0%
14agency 4 0.0%
15aus 1 0.0%
TOTAL: 15 13521100.0%

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

NewsgroupCount
1rec.arts.tv 1162
2comp.lang.python 567
3sci.physics.relativity 564
4rec.food.cooking 476
5alt.atheism 419
6sci.math 393
7rec.arts.drwho 373
8rec.sport.tennis 351
9sci.electronics.design 340
10rec.gambling.poker 290
11soc.retirement 283
12talk.politics.guns 266
13talk.origins 254
14rec.boats 243
15sci.physics 236
16rec.bicycles.tech 229
17uk.radio.amateur 216
18soc.culture.polish 208
19news.lists.filters 207
20alt.comp.os.windows-10 197
21soc.culture.israel 195
22rec.sport.football.college 193
23rec.sport.pro-wrestling 155
24soc.culture.china 150
25comp.os.linux.advocacy 144
26rec.sport.soccer 140
27rec.music.rock-pop-r+b.1950s 130
28rec.arts.sf.written 124
29misc.health.alternative 117
30comp.lang.c++ 115
31alt.bible 101
32rec.outdoors.rv-travel 100
33rec.sport.golf 100
34rec.crafts.metalworking 97
35comp.mobile.android 91
36talk.politics.misc 89
37soc.culture.usa 87
38sci.med.pharmacy 86
39rec.music.dylan 84
40rec.arts.sf.tv 84
41rec.music.classical.recordings 82
42alt.support.diabetes 77
43misc.phone.mobile.iphone 75
44rec.pets.cats.community 75
45soc.culture.indian 72
46rec.aviation.soaring 72
47rec.photo.digital 72
48comp.arch 69
49humanities.lit.authors.shakespeare 65
50alt.test 65
51soc.culture.bulgaria 63
52comp.lang.forth 63
53sci.med.cardiology 56
54soc.culture.vietnamese 56
55comp.protocols.time.ntp 56
56alt.recovery.aa 56
57comp.sys.mac.system 53
58rec.arts.sf.fandom 52
59comp.lang.c 50
60misc.survivalism 48
61rec.sport.cricket 45
62rec.music.classical.guitar 45
63soc.culture.romanian 45
64comp.soft-sys.sas 45
65soc.penpals 44
66rec.autos.sport.f1 44
67comp.lang.fortran 44
68alt.politics 42
69comp.sys.apple2 40
70sci.logic 37
71comp.soft-sys.math.scilab 36
72soc.history.what-if 36
73rec.audio.opinion 34
74comp.lang.lisp 34
75sci.math.num-analysis 34
76rec.radio.shortwave 33
77rec.arts.tv.uk.coronation-st 32
78comp.os.vms 31
79sci.astro.amateur 31
80comp.os.cpm 30
81rec.aquaria.marine.misc 30
82sci.military.naval 29
83sci.lang 29
84rec.arts.movies.current-films 29
85comp.mobile.ipad 26
86misc.health.diabetes 26
87alt.os.linux.ubuntu 26
88uk.comp.homebuilt 26
89soc.history.medieval 26
90alt.tv.days-of-our-lives 26
91comp.sys.acorn.hardware 26
92comp.unix.shell 24
93rec.arts.comics.strips 24
94soc.culture.brazil 24
95rec.radio.amateur.misc 24
96comp.lang.ada 22
97rec.games.pinball 22
98soc.genealogy.benelux 22
99uk.tech.broadcast 22
100misc.invest.stocks 22
TOTAL: 329 13521