news.bbs.geek.nz daily logs

Aug 27 23:58:02 -- Aug 28 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 128459 60.5%10.6 MB 40.0%
innd 31164 14.7%5.0 MB 18.9%
inn 27794 13.1%6.2 MB 23.1%
innfeed 23417 11.0%4.5 MB 17.1%
cnfsstat 1440 0.7%248.2 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 212275 100.0%26.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 261894 47.7%
Negative hits 260615 47.5%
Do not exist 25830 4.7%
Cache misses 263 0.0%
TOTAL: 4 548602 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.131 0.0%187 0.000 0.701 16.000
article cleanup00:00:00.255 0.0%27177 0.000 0.009 0.043
article logging00:00:00.801 0.0%27633 0.000 0.029 0.554
article parse00:00:00.827 0.0%67739 0.000 0.012 0.027
article write00:00:04.177 0.0%20006 0.010 0.209 17.607
artlog/artcncl00:00:00.000 0.0%173 0.000 0.000 0.000
data move00:00:00.376 0.0%504418 0.000 0.001 0.010
hisgrep/artcncl00:00:00.002 0.0%182 0.000 0.011 0.100
hishave/artcncl00:00:00.000 0.0%187 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.867 0.0%552269 0.001 0.012 0.573
history sync00:00:00.026 0.0%372 0.000 0.070 0.667
history write00:00:05.463 0.0%25976 0.011 0.210 11.113
hiswrite/artcncl00:00:00.001 0.0%5 0.000 0.200 1.000
idle23:57:40.538 99.8%519668 102.979 165.992 396.421
nntp read00:00:04.758 0.0%523875 0.004 0.009 0.020
overview write00:00:37.678 0.0%20006 0.055 1.883 34.460
perl filter00:00:55.201 0.1%25976 0.947 2.125 28.324
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.263 0.0%40012 0.004 0.032 0.202
TOTAL: 24:00:56.87123:59:38.364 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%27781 0.000 0.002 0.017
article prepare00:00:00.002 0.0%9748 0.000 0.000 0.021
article read00:00:00.281 0.0%2142 0.000 0.131 6.000
backlog stats00:00:00.566 0.0%305552 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.493 0.0%260866 0.003 0.010 0.018
data write00:00:03.029 0.0%250998 0.004 0.012 0.025
idle23:54:03.372100.0%305552 168.697 281.600 587.402
status file00:00:05.935 0.0%1979 0.500 2.999 93.343
TOTAL: 23:54:34.26123:54:15.737100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle19:04:12.783 96.2%141894 0.000 483.831 79873.240
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:22.303 0.1%405123 0.000 0.203 0.789
readart00:00:03.113 0.0%13590 0.000 0.229 47.080
TOTAL: 19:48:54.94119:05:38.199 96.4%----

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 56 19354 5851 13054 449 30%57:45:32
2newsfeed.datemas.de 3 22123 3069 18204 850 13%25:00:26
3news.redatomik.org 1 18509 2215 16194 100 11%23:46:50
4news-out.aioe.org 1 19150 1850 17225 75 9%23:25:29
5feeder.eternal-september.org 111 24549 1776 21660 1113 7%64:59:14
6news-out.mixmin.net 17 21320 1719 18869 732 8%29:05:18
7newsfeed.neva.ru 156 16496 1053 13161 2282 6%88:47:53
8news.albasani.net 1 17649 1036 16066 547 5%20:37:38
9csiph.com 3 20911 736 20099 76 3%28:10:17
10news.samoylyk.net 1 29551 278 28662 611 0%30:49:58
11news.swapon.de 11 2059 124 1896 39 6%31:15:24
12feeder.awxg.com 1 15598 85 15447 66 0%23:59:57
13news.freedyn.net 2 20671 66 20482 123 0%22:48:29
14agency-nz-out.news.mb-net.net 27 21308 34 21162 112 0%38:30:58
15localhost 6 5 4 0 1 80%00:00:00
TOTAL: 15 397 269253 19896 242181 7176 7%509:03:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.6 MB323.7 KB2.1 MB24.0 MB 89%3.9 KB
2newsfeed.datemas.de11.0 MB469.0 KB2.4 MB13.8 MB 79%3.6 KB
3feeder.eternal-september.org6.7 MB707.0 KB6.3 MB13.8 MB 49%4.9 KB
4news-out.mixmin.net6.4 MB364.1 KB1.9 MB8.6 MB 74%3.6 KB
5news.redatomik.org5.4 MB309.2 KB324.0 KB6.0 MB 89%2.7 KB
6news-out.aioe.org4.8 MB177.4 KB208.1 KB5.2 MB 92%2.8 KB
7news.albasani.net3.9 MB270.5 KB1.1 MB5.3 MB 73%3.4 KB
8newsfeed.neva.ru3.2 MB333.1 KB10.5 MB14.0 MB 22%4.3 KB
9csiph.com2.2 MB285.0 KB302.9 KB2.8 MB 79%3.5 KB
10news.samoylyk.net1.1 MB1.1 MB9.0 MB11.3 MB 10%13.0 KB
11news.freedyn.net783.9 KB223.0 KB432.1 KB1.4 MB 54%7.6 KB
12news.swapon.de334.1 KB141.9 KB357.5 KB833.4 KB 40%5.1 KB
13feeder.awxg.com280.3 KB204.0 KB206.3 KB690.7 KB 40%4.6 KB
14agency-nz-out.news.mb-net.net100.2 KB206.1 KB472.1 KB778.3 KB 12%5.3 KB
15localhost8.0 KB0.0 KB2.2 KB10.1 KB 78%2.0 KB
TOTAL: 1567.8 MB5.0 MB35.6 MB108.5 MB 62%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 27 23:58:02 - 23:59:59 25 0.1% 0.2181.8 KB 0.1% 0.69
Aug 28 00:00:00 - 00:59:59 909 4.5% 0.252.9 MB 4.2% 0.81
Aug 28 01:00:00 - 01:59:59 1026 5.1% 0.283.2 MB 4.7% 0.91
Aug 28 02:00:00 - 02:59:59 981 4.9% 0.273.0 MB 4.4% 0.86
Aug 28 03:00:00 - 03:59:59 1116 5.6% 0.314.4 MB 6.5% 1.26
Aug 28 04:00:00 - 04:59:59 1049 5.2% 0.293.3 MB 4.8% 0.93
Aug 28 05:00:00 - 05:59:59 1067 5.3% 0.303.5 MB 5.2% 1.01
Aug 28 06:00:00 - 06:59:59 1069 5.3% 0.304.4 MB 6.4% 1.25
Aug 28 07:00:00 - 07:59:59 999 5.0% 0.283.3 MB 4.8% 0.93
Aug 28 08:00:00 - 08:59:59 1015 5.1% 0.283.6 MB 5.2% 1.01
Aug 28 09:00:00 - 09:59:59 830 4.2% 0.232.8 MB 4.1% 0.80
Aug 28 10:00:00 - 10:59:59 708 3.5% 0.202.7 MB 4.0% 0.77
Aug 28 11:00:00 - 11:59:59 645 3.2% 0.182.5 MB 3.6% 0.71
Aug 28 12:00:00 - 12:59:59 511 2.6% 0.141.5 MB 2.2% 0.43
Aug 28 13:00:00 - 13:59:59 481 2.4% 0.132.0 MB 3.0% 0.58
Aug 28 14:00:00 - 14:59:59 381 1.9% 0.111.2 MB 1.8% 0.34
Aug 28 15:00:00 - 15:59:59 408 2.0% 0.111.6 MB 2.4% 0.46
Aug 28 16:00:00 - 16:59:59 521 2.6% 0.141.7 MB 2.5% 0.48
Aug 28 17:00:00 - 17:59:59 529 2.6% 0.152.0 MB 2.9% 0.56
Aug 28 18:00:00 - 18:59:59 784 3.9% 0.223.1 MB 4.5% 0.87
Aug 28 19:00:00 - 19:59:59 863 4.3% 0.242.5 MB 3.7% 0.71
Aug 28 20:00:00 - 20:59:59 1112 5.6% 0.313.5 MB 5.1% 0.99
Aug 28 21:00:00 - 21:59:59 1016 5.1% 0.282.8 MB 4.1% 0.80
Aug 28 22:00:00 - 22:59:59 968 4.8% 0.273.2 MB 4.7% 0.92
Aug 28 23:00:00 - 23:58:01 987 4.9% 0.283.7 MB 5.3% 1.07
TOTAL: 23:59:59 20000 100.0% 0.2368.4 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB19.5 GB 39.1% 0 0.28 2153.09
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB22.7 GB 45.4% 0 0.32 1907.84
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB241.9 MB 0.5% 0 0.0415609.76
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 GB7.2 GB 14.4% 0 0.73 830.91
TOTAL: 10-500.0 GB49.7 GB 9.9% 1 0.43-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2305 78 0 72 0 0 0 0 2155
2feeder.eternal-september.org 1143 0 0 176 0 0 0 0 967
3newsfeed.datemas.de 914 227 0 103 0 0 0 0 584
4news-out.mixmin.net 818 0 0 82 0 0 0 0 736
5news.albasani.net 650 10 0 100 0 0 0 0 540
6news.samoylyk.net 491 0 0 121 0 0 0 0 370
7news.snarked.org 456 33 0 85 0 0 0 0 338
8news.redatomik.org 270 0 0 98 0 0 0 0 172
9news.freedyn.net 143 11 0 63 0 0 0 0 69
10agency-nz-out.news.mb-net.net 119 26 0 58 2 0 0 0 33
11news-out.aioe.org 91 10 0 62 0 0 0 0 19
12feeder.awxg.com 75 0 0 73 0 0 0 0 2
13csiph.com 74 0 0 72 0 0 0 0 2
14news.swapon.de 68 0 0 30 0 0 0 0 38
15news.ausics.org 3 0 0 3 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 7621 395 0 1198 2 0 0 0 6026

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 91
it.annunci.immobiliari 46
it.annunci.varie 38
it.annunci.commerciali 33
gmane.linux.alsa.devel 32
mozilla.support.seamonkey 22
mpc.lists.freebsd.ports.bugs 15
gmane.comp.gis.openstreetmap.tagging 14
mpc.lists.freebsd.gnome 10
mpc.lists.freebsd.x11 8
test.post 8
gmane.linux.kernel 7
fido7.ru.android 7
alt.bbs.files-announce 5
mozilla.dev.security.policy 4
mozilla.dev.apps.seamonkey 4
mozilla.dev.ports.os2 4
alt.bbs.files-distribution 4
mozilla.dev.platform 3
mpc.lists.nanog 3
TOTAL: 47 395

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

GroupsCount
nz.politics.announce 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4829
EMP (phn path) 496
EMP (phn nph) 135
User-issued cancel 36
Too many newsgroups 34
Cancel for rejected article 15
EMP (phl) 11
Binary: non-binary distribution 9
Binary Image: misplaced jpg 4
HTML post 2
Binary: misplaced 748 1
Binary: misplaced 515 1
TOTAL: 12 5573

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.redatomik.org 163
news-out.mixmin.net 93
newsfeed.datemas.de 76
news.albasani.net 59
news.swapon.de 31
news-out.aioe.org 13
newsfeed.neva.ru 8
news.snarked.org 5
feeder.eternal-september.org 4
feeder.awxg.com 1
TOTAL: 10 453
TOTAL: 1 453

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18283 1212 16978 93 0 0 6%23:59:47
2awxg 19609 132 19446 5 0 13 0%23:59:47
3news.redatomik.org 17629 9 17578 4 0 0 0%23:59:42
4news.freedyn.net 20327 8 19918 2 0 65 0%23:59:47
5mb-net.net 19957 6 19876 0 0 19 0%23:59:44
6csiph.com 19334 5 19229 0 0 0 0%23:59:47
7aioe 16213 5 16086 0 0 0 0%23:59:47
8news.samoylyk.net 18018 5 17979 0 0 4 0%23:59:47
9news.snarked.org 14174 5 14073 1 0 25 0%23:59:47
10news-in.mixmin.net 17639 4 17618 0 0 0 0%23:59:47
11newsfeed.datemas.de 16969 2 16941 0 0 74 0%23:59:47
12neva.ru 18599 2 18590 3 0 0 0%23:59:47
13eternal-september 17110 1 16997 0 0 222 0%23:59:47
14news.albasani.net 21057 1 17922 800 0 7413 0%23:59:46
15news.swapon.de 1719 0 1699 0 0 22 0%23:49:22
TOTAL: 15 256637 1397 250930 908 0 7857 0%359:46:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org7.3 MB4.8 MB12.1 MB0.1 KB/s9.5 KB23:59:47
2awxg1.0 MB24.0 KB1.0 MB0.0 KB/s7.7 KB23:59:47
3news.redatomik.org18.9 KB18.1 KB37.0 KB0.0 KB/s2.8 KB23:59:42
4news.freedyn.net17.9 KB28.3 KB46.1 KB0.0 KB/s4.6 KB23:59:47
5mb-net.net15.4 KB0.0 KB15.4 KB0.0 KB/s2.6 KB23:59:44
6aioe10.3 KB0.0 KB10.3 KB0.0 KB/s2.1 KB23:59:47
7csiph.com9.5 KB0.0 KB9.5 KB0.0 KB/s1.9 KB23:59:47
8news.samoylyk.net9.5 KB0.0 KB9.5 KB0.0 KB/s1.9 KB23:59:47
9news.snarked.org9.5 KB1.8 KB11.3 KB0.0 KB/s1.9 KB23:59:47
10news-in.mixmin.net8.0 KB0.0 KB8.0 KB0.0 KB/s2.0 KB23:59:47
11newsfeed.datemas.de2.8 KB0.0 KB2.8 KB0.0 KB/s1.4 KB23:59:47
12neva.ru2.8 KB6.7 KB9.5 KB0.0 KB/s1.9 KB23:59:47
13eternal-september1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:47
14news.albasani.net1.3 KB4.0 MB4.0 MB0.0 KB/s5.1 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:22
TOTAL: 158.4 MB8.9 MB17.3 MB0.0 KB/s7.7 KB359:46:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 21 595521.4 MB 1537 3 203:51:16
2agency.bbs.geek.nz 347 571319.8 MB 3102 1 600:10:57
3163.47.16.169 24 10191.5 MB 124 0 000:04:39
467-60-219-146.cpe.cableone.net 4 48.2 KB 4 0 014:58:38
TOTAL: 4 396 1269142.8 MB 4767 4 819:48:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 25 595921.4 MB 1541 3 218:49:54
2*.bbs.geek.nz 347 571319.8 MB 3102 1 600:10:57
3unresolved 33 10191.5 MB 124 0 000:47:53
TOTAL: 3 405 1269142.8 MB 4767 4 819:48:48

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 21
malcolmlewis 4
TOTAL: 3 49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.228 0.056 0.00714:58:38
67-61-21-181.cpe.cableone.net 3.964 2.324 0.07203:51:16
118.149.162.115 0.960 0.120 0.00000:21:52
118.149.203.59 0.208 0.024 0.00000:16:11
agency.bbs.geek.nz 26.292 6.124 0.00000:10:57
118.149.215.249 0.052 0.016 0.00000:05:03
163.47.16.169 1.584 0.484 0.35100:04:39
203.118.151.117 0.080 0.016 0.00000:00:06
? 1.436 0.184 0.00000:00:02
TOTAL: 9 34.804 9.348 0.43019:48:48

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.162.115 4
118.149.203.59 3
118.149.215.249 1
203.118.151.117 1
TOTAL: 4 9

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 5235 41.2%
2alt 1601 12.6%
3soc 1518 12.0%
4sci 1301 10.3%
5comp 1286 10.1%
6talk 605 4.8%
7misc 557 4.4%
8uk 238 1.9%
9news 238 1.9%
10nz 64 0.5%
11mozilla 27 0.2%
12aus 13 0.1%
13humanities 7 0.1%
14eternal-september 1 0.0%
TOTAL: 14 12691100.0%

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

NewsgroupCount
1rec.arts.tv 1355
2rec.sport.tennis 638
3alt.atheism 583
4rec.arts.drwho 489
5alt.comp.os.windows-10 447
6soc.retirement 446
7misc.survivalism 370
8talk.politics.guns 316
9sci.electronics.design 298
10comp.os.linux.advocacy 285
11soc.culture.israel 248
12sci.physics 235
13news.lists.filters 228
14rec.food.cooking 227
15rec.photo.digital 218
16uk.radio.amateur 208
17sci.physics.relativity 177
18sci.math 171
19soc.culture.polish 170
20alt.politics 158
21comp.lang.python 156
22sci.logic 152
23talk.politics.misc 149
24rec.crafts.metalworking 144
25comp.lang.c 144
26soc.culture.china 144
27rec.arts.sf.written 129
28talk.origins 112
29comp.mobile.android 107
30rec.sport.football.college 106
31rec.aviation.marketplace 105
32rec.boats 104
33rec.music.rock-pop-r+b.1950s 96
34rec.gambling.poker 92
35rec.aquaria.marine.misc 90
36rec.sport.soccer 87
37misc.health.alternative 84
38alt.test 70
39rec.bicycles.tech 68
40rec.music.classical.recordings 67
41rec.autos.sport.f1 65
42soc.culture.romanian 65
43rec.arts.comics.strips 63
44alt.recovery.aa 63
45rec.games.trivia 63
46rec.arts.movies.current-films 63
47soc.culture.singapore 60
48nz.general 54
49rec.sport.pro-wrestling 53
50soc.culture.usa 52
51rec.arts.sf.fandom 52
52comp.lang.forth 52
53comp.sys.mac.system 51
54rec.music.dylan 51
55alt.os.linux.ubuntu 48
56rec.radio.shortwave 46
57sci.military.naval 45
58rec.sport.cricket 45
59rec.autos.marketplace 42
60rec.arts.tv.uk.coronation-st 42
61comp.lang.c++ 41
62rec.games.pinball 40
63alt.books.reviews 38
64rec.gambling.lottery 36
65comp.soft-sys.matlab 36
66soc.culture.indian 34
67rec.aviation.soaring 34
68alt.tv.days-of-our-lives 34
69comp.sys.apple2 33
70alt.astronomy 33
71rec.outdoors.rv-travel 33
72comp.sys.mac.apps 33
73rec.autos.tech 32
74rec.boats.paddle 32
75soc.culture.vietnamese 32
76rec.radio.amateur.misc 30
77comp.lang.fortran 30
78soc.genealogy.medieval 28
79alt.bible 28
80misc.transport.urban-transit 28
81rec.woodworking 28
82sci.med.cardiology 27
83uk.comp.homebuilt 27
84alt.support.diabetes 26
85sci.astro.amateur 25
86sci.math.num-analysis 24
87sci.archaeology 24
88sci.crypt 22
89soc.history.what-if 22
90soc.culture.african.american 21
91comp.lang.javascript 21
92comp.os.vms 20
93comp.mobile.ipad 20
94misc.phone.mobile.iphone 20
95soc.genealogy.benelux 20
96rec.arts.sf.tv 20
97rec.games.backgammon 19
98talk.euthanasia 18
99misc.immigration.usa 18
100mozilla.general 18
TOTAL: 305 12691