news.bbs.geek.nz daily logs

Feb 23 23:58:01 -- Feb 24 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 115927 53.8%9.7 MB 35.1%
innfeed 41356 19.2%6.6 MB 23.8%
innd 29935 13.9%4.9 MB 17.8%
inn 26973 12.5%6.1 MB 22.3%
cnfsstat 1440 0.7%252.6 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 215632 100.0%27.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 273259 49.8%
Positive hits 249443 45.5%
Do not exist 25492 4.6%
Cache misses 170 0.0%
TOTAL: 4 548364 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.927 0.0%543 0.000 1.707 47.688
article cleanup00:00:00.238 0.0%25718 0.000 0.009 0.028
article logging00:00:00.633 0.0%26302 0.000 0.024 0.058
article parse00:00:00.838 0.0%78479 0.000 0.011 0.022
article write00:00:02.340 0.0%19855 0.000 0.118 5.647
artlog/artcncl00:00:00.007 0.0%511 0.000 0.014 0.500
data move00:00:00.511 0.0%542639 0.000 0.001 0.012
hisgrep/artcncl00:00:00.480 0.0%539 0.000 0.891 29.688
hishave/artcncl00:00:00.214 0.0%543 0.000 0.394 13.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.884 0.0%548772 0.001 0.016 0.907
history sync00:00:00.012 0.0%366 0.000 0.033 0.500
history write00:00:06.003 0.0%25521 0.011 0.235 13.521
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:47:39.847 99.8%555297 91.691 154.260 372.122
nntp read00:00:03.245 0.0%556434 0.002 0.006 0.029
overview write00:00:48.290 0.1%19855 0.037 2.432 121.120
perl filter00:00:49.726 0.1%25521 1.457 1.948 6.814
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.279 0.0%39710 0.004 0.032 0.101
TOTAL: 23:50:53.28623:49:43.474 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.064 0.0%29239 0.000 0.002 0.022
article prepare00:00:00.000 0.0%7790 0.000 0.000 0.000
article read00:00:00.123 0.0%1758 0.000 0.070 3.000
backlog stats00:00:00.301 0.0%320959 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.756 0.0%260057 0.002 0.007 0.016
data write00:00:04.035 0.0%245415 0.007 0.016 0.038
idle23:51:49.451 99.8%320959 165.063 267.665 564.145
status file00:01:43.792 0.1%8920 1.047 11.636 973.929
TOTAL: 23:53:59.42323:53:39.522100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle21:10:31.513 97.4%134168 0.000 568.180151674.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:12.522 0.0%304262 0.000 0.041 1.000
readart00:00:02.868 0.0%18023 0.000 0.159 16.000
TOTAL: 21:44:41.51221:10:46.903 97.4%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 35 17430 5491 11715 224 31%37:04:41
2feeder.eternal-september.org 5 23418 3236 18553 1629 13%24:51:58
3news-out.mixmin.net 7 20030 3218 16170 642 16%27:54:33
4news-out.aioe.org 6 20410 3083 17128 199 15%25:18:36
5news.albasani.net 1 21396 1217 19795 384 5%24:10:19
6newsfeed.neva.ru 147 15310 1082 11835 2393 7%75:59:38
7csiph.com 3 17076 875 16153 48 5%19:03:52
8newsfeed.datemas.de 3 20266 640 19418 208 3%23:25:10
9news.swapon.de 5 1828 456 1371 1 24%24:11:32
10news.redatomik.org 1 19065 265 18768 32 1%23:59:34
11news.samoylyk.net 13 20357 149 20191 17 0%23:50:21
12agency-nz-out.news.mb-net.net 7 22116 125 21938 53 0%26:10:44
13feeder.awxg.com 2 17519 108 17395 16 0%23:59:38
14news.freedyn.net 1 20502 36 20443 23 0%19:38:13
15news.ausics.org 2 10450 1 10449 0 0%16:05:55
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 239 267173 19982 241322 5869 7%415:44:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org18.8 MB98.6 KB2.0 MB20.9 MB 90%3.7 KB
2feeder.eternal-september.org10.6 MB150.2 KB5.6 MB16.4 MB 64%3.4 KB
3news-out.mixmin.net9.3 MB127.5 KB1.3 MB10.7 MB 86%2.8 KB
4news-out.aioe.org7.3 MB50.2 KB471.6 KB7.8 MB 93%2.4 KB
5news.albasani.net5.8 MB167.2 KB925.2 KB6.9 MB 84%4.4 KB
6newsfeed.datemas.de5.4 MB125.6 KB3.4 MB8.9 MB 60%10.7 KB
7newsfeed.neva.ru2.9 MB60.6 KB23.6 MB26.6 MB 10%7.8 KB
8csiph.com2.8 MB115.9 KB177.9 KB3.1 MB 90%3.4 KB
9news.swapon.de1.2 MB0.0 KB0.7 KB1.2 MB 99%2.7 KB
10news.samoylyk.net1019.9 KB78.8 KB160.8 KB1.2 MB 80%7.6 KB
11news.redatomik.org764.6 KB158.7 KB195.6 KB1.1 MB 68%3.8 KB
12agency-nz-out.news.mb-net.net540.0 KB129.5 KB531.5 KB1.2 MB 44%6.7 KB
13feeder.awxg.com355.9 KB69.0 KB108.8 KB533.8 KB 66%4.3 KB
14news.freedyn.net189.7 KB51.7 KB219.0 KB460.3 KB 41%7.8 KB
15news.ausics.org1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1667.0 MB1.4 MB38.5 MB106.8 MB 62%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 23 23:58:01 - 23:59:59 27 0.1% 0.2366.5 KB 0.1% 0.56
Feb 24 00:00:00 - 00:59:59 989 5.0% 0.272.9 MB 4.3% 0.82
Feb 24 01:00:00 - 01:59:59 954 4.8% 0.273.2 MB 4.8% 0.92
Feb 24 02:00:00 - 02:59:59 1103 5.5% 0.313.2 MB 4.7% 0.90
Feb 24 03:00:00 - 03:59:59 1128 5.6% 0.313.6 MB 5.4% 1.02
Feb 24 04:00:00 - 04:59:59 1144 5.7% 0.324.0 MB 6.0% 1.14
Feb 24 05:00:00 - 05:59:59 1257 6.3% 0.354.4 MB 6.6% 1.26
Feb 24 06:00:00 - 06:59:59 1261 6.3% 0.353.4 MB 5.1% 0.97
Feb 24 07:00:00 - 07:59:59 1138 5.7% 0.323.2 MB 4.7% 0.90
Feb 24 08:00:00 - 08:59:59 970 4.9% 0.273.3 MB 4.9% 0.94
Feb 24 09:00:00 - 09:59:59 991 5.0% 0.283.0 MB 4.5% 0.86
Feb 24 10:00:00 - 10:59:59 1013 5.1% 0.283.4 MB 5.1% 0.97
Feb 24 11:00:00 - 11:59:59 994 5.0% 0.283.4 MB 5.0% 0.96
Feb 24 12:00:00 - 12:59:59 733 3.7% 0.202.9 MB 4.4% 0.84
Feb 24 13:00:00 - 13:59:59 633 3.2% 0.182.6 MB 3.9% 0.74
Feb 24 14:00:00 - 14:59:59 533 2.7% 0.151.9 MB 2.8% 0.54
Feb 24 15:00:00 - 15:59:59 398 2.0% 0.111.9 MB 2.8% 0.54
Feb 24 16:00:00 - 16:59:59 524 2.6% 0.152.3 MB 3.4% 0.65
Feb 24 17:00:00 - 17:59:59 408 2.0% 0.111.8 MB 2.7% 0.51
Feb 24 18:00:00 - 18:59:59 433 2.2% 0.121.7 MB 2.6% 0.50
Feb 24 19:00:00 - 19:59:59 429 2.1% 0.121.4 MB 2.1% 0.39
Feb 24 20:00:00 - 20:59:59 547 2.7% 0.152.0 MB 3.0% 0.57
Feb 24 21:00:00 - 21:59:59 812 4.1% 0.232.7 MB 4.0% 0.75
Feb 24 22:00:00 - 22:59:59 817 4.1% 0.232.6 MB 3.9% 0.75
Feb 24 23:00:00 - 23:58:01 738 3.7% 0.212.1 MB 3.1% 0.62
TOTAL: 24:00:00 19974 100.0% 0.2366.9 MB 100.0% 0.79
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.9 GB 47.8% 0 0.32 1918.26
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.8 GB 55.5% 0 0.35 1723.13
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB299.8 MB 0.6% 0 0.0513432.35
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 GB17.2 GB 34.4% 0 0.62 974.65
TOTAL: 10-500.0 GB69.2 GB 13.8% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2400 26 0 9 0 0 0 0 2365
2feeder.eternal-september.org 1632 0 0 15 0 0 0 0 1617
3news-out.mixmin.net 841 0 0 25 0 0 0 0 816
4news.albasani.net 529 6 0 21 0 0 0 0 502
5newsfeed.datemas.de 243 85 0 10 0 0 0 0 148
6news-out.aioe.org 236 3 0 14 0 0 0 0 219
7news.snarked.org 225 38 0 21 0 0 0 0 166
8news.swapon.de 173 0 0 0 0 0 0 0 173
9news.redatomik.org 52 0 0 18 0 0 0 0 34
10agency-nz-out.news.mb-net.net 52 14 0 12 0 0 0 0 26
11csiph.com 43 0 0 18 0 0 0 0 25
12news.freedyn.net 22 2 0 9 0 0 0 0 11
13news.samoylyk.net 22 0 0 14 0 0 0 0 8
14feeder.awxg.com 16 0 0 10 0 0 0 0 6
15news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 15 6488 174 0 198 0 0 0 0 6116

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.support.seamonkey 36
mpc.lists.freebsd.gnome 26
gmane.linux.alsa.devel 25
mozilla.support.bugzilla 10
mpc.lists.freebsd.office 9
gmane.comp.handhelds.openphoenux.user 8
mozilla.dev.ui-alerts 6
gmane.comp.gis.openstreetmap.tagging 5
mozilla.test 5
eagle.support.eng 5
south-wales.test 3
mozilla.dev.media 3
mozilla.dev.l10n 3
mpc.lists.nanog 2
mozilla.dev.developer-tools 2
alt.fr.os.windows.7 2
it.annunci.varie 2
it.annunci.commerciali 2
comp.lang.c-programming 2
gmane.linux.ports.arm.kernel 1
TOTAL: 37 174

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4270
Binary: misplaced rar 572
EMP (phn path) 341
EMP (phn nph) 115
EMP (phl) 96
Binary: non-binary distribution 47
User-issued cancel 21
EMP (fsl) 21
Too many newsgroups 21
Too many newsgroups (low_xpost) 10
HTML post 6
Binary: misplaced par2 3
Too many newsgroups (meow) 2
Binary: misplaced xlsx 1
Binary: misplaced arj 1
Cancel for rejected article 1
TOTAL: 16 5528

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 190
news.swapon.de 172
news.albasani.net 121
news-out.aioe.org 43
newsfeed.datemas.de 28
news.redatomik.org 20
news.samoylyk.net 7
newsfeed.neva.ru 3
feeder.awxg.com 2
csiph.com 1
TOTAL: 11 588
TOTAL: 1 588

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18172 975 17138 39 0 59 5%23:58:50
2awxg 19523 140 19372 2 0 0 0%23:59:26
3csiph.com 19044 14 18973 4 1 0 0%23:59:28
4news.freedyn.net 20116 8 19923 1 0 19 0%23:58:36
5neva.ru 18713 1 18637 1 0 0 0%23:59:26
6aioe 15651 1 15543 0 0 218 0%23:58:39
7news-in.mixmin.net 15826 0 15808 0 0 0 0%23:59:26
8news.swapon.de 1619 0 1618 0 0 0 0%23:33:31
9eternal-september 16336 0 16308 0 0 6 0%23:59:26
10news.samoylyk.net 18111 0 18016 0 0 548 0%23:58:49
11mb-net.net 19842 0 19782 0 0 72 0%23:59:33
12news.redatomik.org 19685 0 19670 0 0 0 0%23:59:26
13news.snarked.org 2747 0 0 0 0 17010 0%23:59:43
14newsfeed.datemas.de 19310 0 19248 0 0 0 0%23:59:26
15news.albasani.net 19361 0 17213 703 2 5749 0%23:59:39
TOTAL: 15 244056 1139 237249 750 3 23681 0%359:23:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.9 MB353.7 KB11.2 MB0.1 KB/s11.4 KB23:58:50
2awxg997.6 KB6.9 KB1004.5 KB0.0 KB/s7.1 KB23:59:26
3csiph.com36.4 KB250.4 KB286.8 KB0.0 KB/s15.9 KB23:59:28
4news.freedyn.net20.0 KB10.1 KB30.1 KB0.0 KB/s3.3 KB23:58:36
5aioe2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:58:39
6neva.ru1.6 KB33.9 KB35.5 KB0.0 KB/s17.7 KB23:59:26
7news-in.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:26
8news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:33:31
9eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:26
10news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:49
11mb-net.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:33
12news.redatomik.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:26
13news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
14newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:26
15news.albasani.net0.0 KB3.6 MB3.6 MB0.0 KB/s5.3 KB23:59:39
TOTAL: 1511.9 MB4.3 MB16.2 MB0.0 KB/s8.8 KB359:23:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 9 902931.6 MB 1193 0 1602:29:04
2agency.bbs.geek.nz 352 653622.5 MB 3186 0 000:11:54
3vorlon.activateit.net.au 24 9651.5 MB 131 0 000:04:47
467-60-219-146.cpe.cableone.net 5 23.1 KB 2 0 018:26:01
TOTAL: 4 390 1653255.6 MB 4512 0 1621:44:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 14 903131.6 MB 1195 0 1620:55:06
2*.bbs.geek.nz 352 653622.5 MB 3186 0 000:11:54
3*.activateit.net.au 24 9651.5 MB 131 0 000:04:47
4unresolved 7 00.0 KB 0 0 000:32:44
TOTAL: 4 397 1653255.6 MB 4512 0 1621:44:35

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 5
TOTAL: 3 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.352 0.080 0.01218:26:01
67-61-21-181.cpe.cableone.net 1.720 1.276 0.04902:29:04
118.149.207.229 0.184 0.020 0.00000:15:04
agency.bbs.geek.nz 25.344 5.352 0.00000:11:54
118.149.254.236 0.124 0.012 0.00000:08:14
118.149.211.210 0.056 0.016 0.00000:05:01
vorlon.activateit.net.au 1.352 0.408 0.17700:04:47
118.149.163.85 0.068 0.000 0.00000:04:24
? 1.816 0.180 0.00000:00:02
TOTAL: 9 31.016 7.344 0.23821:44:35

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.207.229 3
118.149.254.236 2
118.149.211.210 1
118.149.163.85 1
TOTAL: 4 7

NNRP gethostbyaddr failures [Top 20]:

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

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 4613 27.9%
2alt 1987 12.0%
3soc 1911 11.6%
4comp 1764 10.7%
5sci 1635 9.9%
6linux 1625 9.8%
7talk 1316 8.0%
8uk 1164 7.0%
9misc 291 1.8%
10news 89 0.5%
11nz 37 0.2%
12mozilla 34 0.2%
13humanities 29 0.2%
14perl 19 0.1%
15microsoft 17 0.1%
16agency 1 0.0%
TOTAL: 16 16532100.0%

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

NewsgroupCount
1rec.arts.tv 1052
2talk.politics.guns 862
3sci.physics 537
4linux.debian.bugs.dist 508
5comp.os.linux.advocacy 504
6soc.retirement 485
7alt.atheism 459
8alt.fan.rush-limbaugh 456
9uk.legal 404
10soc.culture.polish 389
11alt.comp.os.windows-10 376
12sci.electronics.design 369
13uk.d-i-y 361
14comp.lang.python 312
15talk.origins 309
16rec.gambling.poker 293
17rec.sport.tennis 275
18linux.debian.changes.devel 252
19rec.sport.golf 242
20rec.boats 234
21rec.sport.football.college 224
22sci.math 205
23rec.arts.sf.written 190
24linux.debian.user 179
25linux.debian.devel.release 174
26rec.food.cooking 167
27rec.arts.drwho 152
28misc.survivalism 149
29soc.culture.china 143
30soc.history.what-if 134
31talk.politics.misc 129
32rec.drugs.cannabis 128
33soc.culture.israel 126
34linux.debian.bugs.rc 124
35rec.radio.shortwave 114
36rec.aviation.soaring 112
37rec.outdoors.rv-travel 102
38rec.arts.sf.tv 100
39rec.sport.soccer 99
40uk.radio.amateur 97
41rec.aquaria.marine.misc 96
42sci.physics.relativity 96
43uk.tech.digital-tv 88
44comp.lang.forth 86
45alt.politics.trump 86
46sci.logic 84
47comp.sys.mac.system 84
48news.lists.filters 81
49uk.legal.moderated 81
50rec.aviation.marketplace 80
51rec.photo.digital 77
52soc.culture.singapore 77
53alt.bible.prophecy 76
54comp.sys.acorn.misc 72
55alt.conspiracy.jfk 68
56uk.comp.sys.mac 67
57rec.woodworking 65
58rec.games.pinball 65
59sci.lang 64
60alt.recovery.aa 63
61linux.debian.user.italian 62
62comp.lang.ada 61
63rec.sport.pro-wrestling 61
64rec.bicycles.tech 60
65rec.music.classical.recordings 59
66alt.test 56
67comp.sys.mac.apps 53
68sci.med.pharmacy 53
69linux.debian.devel 52
70alt.politics 48
71soc.culture.vietnamese 48
72soc.culture.usa 48
73linux.debian.changes 46
74comp.misc 45
75comp.protocols.time.ntp 45
76misc.phone.mobile.iphone 43
77alt.politics.usa 41
78sci.military.naval 41
79comp.sys.mac.advocacy 40
80nz.general 36
81alt.conspiracy 36
82sci.electronics.repair 35
83alt.astronomy 34
84rec.audio.pro 33
85linux.debian.maint.boot 32
86sci.med.cardiology 32
87linux.debian.user.french 32
88alt.os.linux.ubuntu 32
89soc.culture.bulgaria 31
90uk.rec.cars.maintenance 30
91rec.skiing.alpine 30
92alt.bible 30
93comp.lang.c 29
94alt.society.liberalism 29
95comp.lang.tcl 28
96misc.health.alternative 27
97soc.genealogy.britain 27
98rec.autos.tech 26
99humanities.lit.authors.shakespeare 26
100sci.crypt 26
TOTAL: 366 16532