news.bbs.geek.nz daily logs

Oct 8 23:58:02 -- Oct 9 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 61676 42.0%5.0 MB 23.6%
innd 31789 21.6%5.2 MB 24.4%
inn 29007 19.7%6.3 MB 29.9%
innfeed 22979 15.6%4.4 MB 20.9%
cnfsstat 1440 1.0%254.3 KB 1.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 146892 100.0%21.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 268360 47.0%
Positive hits 264925 46.4%
Do not exist 27432 4.8%
Cache misses 10316 1.8%
TOTAL: 4 571033 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.072 0.0%150 0.000 0.480 17.000
article cleanup00:00:00.259 0.0%28476 0.000 0.009 0.051
article logging00:00:00.665 0.0%28903 0.000 0.023 0.126
article parse00:00:00.902 0.0%71700 0.000 0.013 0.031
article write00:00:03.795 0.0%20306 0.013 0.187 18.681
artlog/artcncl00:00:00.000 0.0%136 0.000 0.000 0.000
data move00:00:00.329 0.0%535193 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%148 0.000 0.020 1.000
hishave/artcncl00:00:00.000 0.0%150 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.179 0.0%575350 0.001 0.011 0.811
history sync00:00:00.009 0.0%364 0.000 0.025 0.500
history write00:00:06.415 0.0%27649 0.011 0.232 12.754
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:57:49.703 99.8%554790 72.510 155.500 416.399
nntp read00:00:03.414 0.0%556833 0.002 0.006 0.073
overview write00:00:45.548 0.1%20306 0.096 2.243 72.201
perl filter00:00:58.024 0.1%27649 1.407 2.099 15.846
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.332 0.0%40612 0.007 0.033 0.086
TOTAL: 24:00:53.98223:59:56.649 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.086 0.0%41354 0.000 0.002 0.016
article prepare00:00:00.002 0.0%12924 0.000 0.000 0.010
article read00:00:00.507 0.0%3000 0.000 0.169 17.000
backlog stats00:00:00.309 0.0%332324 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.629 0.0%274394 0.002 0.006 0.011
data write00:00:02.853 0.0%258048 0.003 0.011 0.019
idle23:53:11.948100.0%332324 110.610 258.759 593.370
status file00:00:12.434 0.0%1838 0.688 6.765 379.538
TOTAL: 23:53:54.70923:53:29.768100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle18:55:41.744 98.2%75055 0.000 907.891 75945.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:40.793 0.1%176653 0.000 0.231 2.233
readart00:00:02.251 0.0%15243 0.000 0.148 42.778
TOTAL: 19:16:36.57818:56:24.788 98.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 45 18789 6126 12209 454 32%46:40:04
2newsfeed.datemas.de 3 20613 3087 16922 604 14%22:42:11
3news-out.mixmin.net 11 23198 2821 18700 1677 12%28:15:00
4feeder.eternal-september.org 70 24619 1975 21471 1173 8%46:12:03
5news-out.aioe.org 4 22046 1682 20275 89 7%27:42:27
6newsfeed.neva.ru 151 17444 1518 13035 2891 8%83:23:30
7news.redatomik.org 1 19513 1483 17967 63 7%24:48:04
8csiph.com 3 18992 709 18234 49 3%24:08:39
9news.albasani.net 4 28528 336 27904 288 1%19:56:27
10news.freedyn.net 2 22766 153 22435 178 0%23:59:39
11news.swapon.de 5 1512 147 1360 5 9%21:01:09
12news.samoylyk.net 4 29695 108 28960 627 0%30:09:05
13feeder.awxg.com 2 15613 105 15475 33 0%23:59:48
14agency-nz-out.news.mb-net.net 24 22963 67 22738 158 0%31:11:14
15localhost 4 3 3 0 0 100%00:00:00
TOTAL: 15 333 286294 20320 257685 8289 7%454:09:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org22.2 MB197.0 KB2.1 MB24.5 MB 90%3.8 KB
2newsfeed.datemas.de11.5 MB184.5 KB1.9 MB13.5 MB 84%3.7 KB
3news-out.mixmin.net8.1 MB180.8 KB3.1 MB11.4 MB 71%2.6 KB
4feeder.eternal-september.org6.7 MB456.6 KB5.9 MB13.1 MB 51%4.3 KB
5news-out.aioe.org3.9 MB167.4 KB270.7 KB4.3 MB 90%2.5 KB
6newsfeed.neva.ru3.7 MB220.7 KB13.3 MB17.2 MB 21%4.0 KB
7news.redatomik.org3.6 MB177.6 KB182.4 KB4.0 MB 91%2.6 KB
8csiph.com1.9 MB156.6 KB160.2 KB2.2 MB 86%3.0 KB
9news.albasani.net1.7 MB141.4 KB608.4 KB2.4 MB 69%3.9 KB
10news.freedyn.net638.6 KB1.0 MB1.3 MB2.9 MB 21%9.1 KB
11news.samoylyk.net505.9 KB1.2 MB9.3 MB10.9 MB 4%15.2 KB
12agency-nz-out.news.mb-net.net432.6 KB174.3 KB524.3 KB1.1 MB 38%5.0 KB
13news.swapon.de392.0 KB22.8 KB22.8 KB437.7 KB 89%2.9 KB
14feeder.awxg.com294.3 KB112.1 KB112.7 KB519.2 KB 56%3.8 KB
15localhost3.5 KB0.0 KB0.0 KB3.5 KB100%1.2 KB
TOTAL: 1565.5 MB4.4 MB38.6 MB108.4 MB 60%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 8 23:58:02 - 23:59:59 26 0.1% 0.2278.3 KB 0.1% 0.66
Oct 9 00:00:00 - 00:59:59 810 4.0% 0.233.1 MB 4.7% 0.87
Oct 9 01:00:00 - 01:59:59 962 4.7% 0.273.1 MB 4.7% 0.89
Oct 9 02:00:00 - 02:59:59 877 4.3% 0.242.9 MB 4.4% 0.81
Oct 9 03:00:00 - 03:59:59 1070 5.3% 0.304.0 MB 6.1% 1.14
Oct 9 04:00:00 - 04:59:59 1243 6.1% 0.354.4 MB 6.8% 1.26
Oct 9 05:00:00 - 05:59:59 1326 6.5% 0.373.8 MB 5.8% 1.08
Oct 9 06:00:00 - 06:59:59 1125 5.5% 0.313.2 MB 4.8% 0.90
Oct 9 07:00:00 - 07:59:59 1145 5.6% 0.324.2 MB 6.5% 1.21
Oct 9 08:00:00 - 08:59:59 974 4.8% 0.273.0 MB 4.6% 0.87
Oct 9 09:00:00 - 09:59:59 1078 5.3% 0.303.8 MB 5.8% 1.09
Oct 9 10:00:00 - 10:59:59 982 4.8% 0.273.4 MB 5.1% 0.96
Oct 9 11:00:00 - 11:59:59 876 4.3% 0.242.9 MB 4.4% 0.81
Oct 9 12:00:00 - 12:59:59 661 3.3% 0.182.2 MB 3.3% 0.62
Oct 9 13:00:00 - 13:59:59 453 2.2% 0.131.5 MB 2.3% 0.43
Oct 9 14:00:00 - 14:59:59 491 2.4% 0.142.2 MB 3.4% 0.64
Oct 9 15:00:00 - 15:59:59 417 2.1% 0.121.3 MB 2.0% 0.37
Oct 9 16:00:00 - 16:59:59 386 1.9% 0.111.2 MB 1.8% 0.34
Oct 9 17:00:00 - 17:59:59 536 2.6% 0.151.8 MB 2.8% 0.52
Oct 9 18:00:00 - 18:59:59 522 2.6% 0.141.8 MB 2.7% 0.50
Oct 9 19:00:00 - 19:59:59 659 3.2% 0.181.8 MB 2.7% 0.51
Oct 9 20:00:00 - 20:59:59 882 4.3% 0.242.2 MB 3.3% 0.62
Oct 9 21:00:00 - 21:59:59 965 4.8% 0.272.4 MB 3.6% 0.68
Oct 9 22:00:00 - 22:59:59 926 4.6% 0.263.1 MB 4.8% 0.89
Oct 9 23:00:00 - 23:58:01 899 4.4% 0.262.2 MB 3.3% 0.64
TOTAL: 23:59:59 20291 100.0% 0.2365.6 MB 100.0% 0.78
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.6 GB 41.3% 0 0.30 2030.15
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.9 GB 47.7% 0 0.34 1783.19
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB255.2 MB 0.5% 0 0.0319047.62
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.7 GB 19.3% 0 0.67 910.89
TOTAL: 10-500.0 GB54.4 GB 10.9% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2853 108 0 49 0 0 0 0 2696
2news-out.mixmin.net 1790 0 0 67 0 0 0 0 1723
3feeder.eternal-september.org 1199 0 0 133 0 0 0 0 1066
4newsfeed.datemas.de 711 172 0 71 0 0 0 0 468
5news.samoylyk.net 509 0 0 80 0 0 0 0 429
6news.snarked.org 421 26 0 61 0 0 0 0 334
7news.albasani.net 344 2 0 57 0 0 0 0 285
8news.redatomik.org 192 0 0 57 0 0 0 0 135
9news.freedyn.net 180 7 0 58 0 0 0 0 115
10agency-nz-out.news.mb-net.net 162 26 0 61 3 0 0 0 72
11news-out.aioe.org 87 7 0 40 0 0 0 0 40
12csiph.com 50 0 0 49 0 0 0 0 1
13feeder.awxg.com 48 5 0 42 0 0 0 0 1
14news.swapon.de 31 0 0 5 0 0 0 0 26
15news.ausics.org 4 0 0 3 0 0 0 0 1
TOTAL: 15 8581 353 0 833 3 0 0 0 7392

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 63
mpc.lists.freebsd.ports.bugs 46
it.annunci.immobiliari 38
it.annunci.commerciali 37
it.annunci.varie 35
gmane.linux.alsa.devel 30
mozilla.dev.platform 15
mozilla.dev.l10n.sr 11
gmane.comp.gis.openstreetmap.tagging 9
mozilla.support.seamonkey 9
fido7.ru.android 5
mpc.lists.freebsd.gnome 4
mozilla.dev.ui-alerts 4
mozilla.dev.security.policy 3
gmane.linux.kernel 3
mpc.lists.freebsd.x11 3
gmane.linux.alsa.user 3
mpc.lists.freebsd.performance 3
mpc.lists.nanog 3
eagle.support.ger 3
TOTAL: 40 353

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

GroupsCount
nz.politics.announce 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6069
EMP (phn path) 598
EMP (phn nph) 192
Too many newsgroups 39
EMP (phl) 32
Binary: non-binary distribution 15
User-issued cancel 10
HTML post 2
Too many newsgroups (low_xpost) 1
Binary: misplaced cst 1
Too many newsgroups (meow) 1
Cancel for rejected article 1
TOTAL: 12 6961

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 135
news.redatomik.org 131
newsfeed.datemas.de 105
news.swapon.de 26
news.albasani.net 20
news-out.aioe.org 7
newsfeed.neva.ru 2
news.samoylyk.net 1
feeder.eternal-september.org 1
agency-nz-out.news.mb-net.net 1
TOTAL: 12 431
TOTAL: 1 431

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17825 1749 16018 58 0 0 9%23:59:37
2awxg 19810 119 19665 1 0 13 0%23:59:33
3news.snarked.org 21769 35 13879 18 0 5296 0%23:59:33
4news.albasani.net 27317 15 24917 1141 0 8383 0%23:57:48
5news.freedyn.net 20455 8 20126 0 0 25 0%23:59:36
6csiph.com 19585 5 19521 0 0 0 0%23:59:37
7aioe 17517 3 17384 0 0 0 0%23:59:33
8news.redatomik.org 18897 3 18868 0 0 0 0%23:59:28
9news-in.mixmin.net 16884 3 16868 0 0 0 0%23:59:37
10news.samoylyk.net 17816 3 17727 0 0 48 0%23:59:36
11newsfeed.datemas.de 17538 3 17492 0 0 10 0%23:59:37
12neva.ru 18387 2 18376 1 0 0 0%23:59:37
13mb-net.net 20259 1 20188 0 0 180 0%23:59:37
14eternal-september 17497 1 17428 0 0 173 0%23:59:37
15news.swapon.de 1564 0 1564 0 0 0 0%23:42:02
TOTAL: 15 273120 1950 260021 1219 0 14128 0%359:34:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org11.7 MB1.8 MB13.5 MB0.2 KB/s7.7 KB23:59:37
2awxg559.2 KB3.7 KB563.0 KB0.0 KB/s4.7 KB23:59:33
3news.snarked.org69.3 KB39.9 KB109.2 KB0.0 KB/s2.1 KB23:59:33
4news.albasani.net30.4 KB4.2 MB4.3 MB0.1 KB/s3.8 KB23:57:48
5news.freedyn.net15.4 KB0.0 KB15.4 KB0.0 KB/s1.9 KB23:59:36
6csiph.com9.4 KB0.0 KB9.4 KB0.0 KB/s1.9 KB23:59:37
7aioe3.5 KB0.0 KB3.5 KB0.0 KB/s1.2 KB23:59:33
8news.redatomik.org3.5 KB0.0 KB3.5 KB0.0 KB/s1.2 KB23:59:28
9news-in.mixmin.net3.5 KB0.0 KB3.5 KB0.0 KB/s1.2 KB23:59:37
10news.samoylyk.net3.5 KB0.0 KB3.5 KB0.0 KB/s1.2 KB23:59:36
11newsfeed.datemas.de3.5 KB0.0 KB3.5 KB0.0 KB/s1.2 KB23:59:37
12neva.ru2.2 KB1.4 KB3.5 KB0.0 KB/s1.2 KB23:59:37
13mb-net.net1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:37
14eternal-september1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:37
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:02
TOTAL: 1512.4 MB6.1 MB18.5 MB0.0 KB/s6.0 KB359:34:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 146 592521.8 MB 2101 3 000:07:13
267-61-21-181.cpe.cableone.net 3 528218.5 MB 501 0 601:07:24
3163.47.16.169 24 12881.8 MB 122 0 000:05:28
460.234.244.55 4 34.8 KB 2 0 000:15:57
TOTAL: 4 177 1249842.1 MB 2726 3 619:16:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 146 592521.8 MB 2101 3 000:07:13
2*.cpe.cableone.net 5 528218.5 MB 501 0 618:28:07
3unresolved 33 12911.8 MB 124 0 000:41:12
TOTAL: 3 184 1249842.1 MB 2726 3 619:16:33

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 3
bpanther 3
malcolmlewis 2
TOTAL: 4 32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.160 0.068 0.00617:20:43
67-61-21-181.cpe.cableone.net 0.672 0.572 0.00901:07:24
60.234.244.55 0.280 0.032 0.00900:15:57
118.149.233.174 0.192 0.012 0.00000:15:04
agency.bbs.geek.nz 10.948 3.036 0.00000:07:13
163.47.16.169 1.404 0.392 0.41800:05:28
118.149.239.149 0.052 0.016 0.00000:04:32
159.203.244.188 0.056 0.004 0.00000:00:09
? 0.408 0.056 0.00000:00:00
TOTAL: 9 14.172 4.188 0.44219:16:33

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.233.174 3
67-60-219-146.cpe.cableone.net 2
159.203.244.188 1
118.149.239.149 1
TOTAL: 4 7

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 5875 47.0%
2soc 1442 11.5%
3sci 1441 11.5%
4comp 1402 11.2%
5alt 1179 9.4%
6talk 466 3.7%
7uk 236 1.9%
8misc 173 1.4%
9news 155 1.2%
10humanities 48 0.4%
11mozilla 40 0.3%
12nz 29 0.2%
13aus 9 0.1%
14agency 3 0.0%
TOTAL: 14 12498100.0%

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

NewsgroupCount
1rec.arts.tv 1615
2rec.arts.drwho 586
3rec.food.cooking 573
4comp.lang.python 539
5alt.comp.os.windows-10 484
6rec.sport.tennis 439
7alt.atheism 412
8soc.retirement 356
9sci.physics.relativity 300
10sci.electronics.design 283
11sci.physics 262
12sci.math 246
13rec.sport.football.college 235
14rec.boats 207
15soc.culture.polish 202
16uk.radio.amateur 196
17talk.politics.guns 193
18soc.culture.indian 145
19rec.sport.soccer 144
20rec.photo.digital 140
21rec.arts.movies.current-films 132
22talk.origins 130
23rec.bicycles.tech 130
24news.lists.filters 124
25rec.sport.pro-wrestling 113
26comp.sys.mac.system 109
27rec.gambling.poker 108
28soc.culture.china 106
29talk.politics.misc 105
30soc.culture.usa 101
31rec.arts.sf.written 99
32misc.survivalism 98
33soc.culture.israel 86
34rec.crafts.metalworking 84
35rec.music.dylan 78
36comp.lang.c 75
37rec.arts.sf.fandom 73
38rec.sport.cricket 71
39soc.history.medieval 68
40rec.music.classical.recordings 63
41alt.politics 61
42sci.logic 61
43comp.protocols.time.ntp 55
44soc.culture.bulgaria 53
45rec.autos.sport.f1 51
46rec.aviation.soaring 51
47alt.test 50
48rec.arts.comics.strips 49
49comp.lang.fortran 47
50comp.os.linux.advocacy 45
51rec.outdoors.rv-travel 45
52sci.math.num-analysis 44
53comp.arch 41
54uk.comp.homebuilt 40
55comp.os.vms 40
56rec.pets.cats.community 40
57rec.sport.golf 39
58sci.electronics.repair 38
59comp.os.linux.misc 38
60rec.radio.shortwave 37
61alt.recovery.aa 37
62alt.bible 37
63rec.skiing.alpine 36
64sci.military.naval 35
65humanities.lit.authors.shakespeare 34
66comp.misc 34
67rec.arts.sf.tv 33
68soc.culture.japan 33
69comp.soft-sys.sas 31
70rec.aquaria.marine.misc 30
71soc.penpals 29
72comp.soft-sys.math.scilab 29
73soc.culture.vietnamese 28
74mozilla.support.firefox 28
75rec.games.pinball 28
76sci.environment 28
77sci.med.cardiology 27
78rec.radio.amateur.dx 27
79alt.astronomy 27
80rec.games.trivia 27
81rec.radio.amateur.misc 26
82comp.lang.forth 26
83misc.phone.mobile.iphone 25
84rec.arts.movies.past-films 24
85soc.genealogy.benelux 23
86rec.puzzles 23
87sci.astro.amateur 22
88soc.genealogy.britain 22
89comp.ai.philosophy 22
90rec.aviation.marketplace 21
91rec.woodworking 20
92alt.books.arthur-clarke 20
93comp.sys.apple2 19
94comp.os.cpm 19
95rec.music.classical.guitar 18
96soc.culture.african.american 18
97misc.invest.stocks 17
98comp.mobile.android 17
99rec.radio.info 17
100alt.support.diabetes 17
TOTAL: 322 12498