news.bbs.geek.nz daily logs

Jan 24 23:58:02 -- Jan 25 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135996 60.8%11.3 MB 40.5%
innd 32313 14.5%5.2 MB 18.8%
inn 30641 13.7%6.7 MB 24.1%
innfeed 23170 10.4%4.4 MB 15.8%
cnfsstat 1440 0.6%248.5 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 223561 100.0%28.0 MB100.0%

History cache:

ReasonCount%Count
Negative hits 279687 47.8%
Positive hits 276362 47.2%
Do not exist 28720 4.9%
Cache misses 610 0.1%
TOTAL: 4 585379 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.321 0.0%88 0.000 3.648 35.500
article cleanup00:00:00.265 0.0%29938 0.000 0.009 0.030
article logging00:00:00.686 0.0%30553 0.000 0.022 0.085
article parse00:00:00.962 0.0%80351 0.000 0.012 0.032
article write00:00:02.162 0.0%21532 0.000 0.100 3.352
artlog/artcncl00:00:00.001 0.0%88 0.000 0.011 0.077
data move00:00:00.526 0.0%561111 0.000 0.001 0.011
hisgrep/artcncl00:00:00.018 0.0%72 0.000 0.250 8.000
hishave/artcncl00:00:00.028 0.0%88 0.000 0.318 14.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.532 0.0%589893 0.001 0.016 0.789
history sync00:00:00.012 0.0%360 0.000 0.033 0.667
history write00:00:10.663 0.0%28924 0.013 0.369 18.155
hiswrite/artcncl00:00:00.001 0.0%16 0.000 0.062 0.250
idle23:57:27.350 99.8%577802 87.816 149.268 400.139
nntp read00:00:03.367 0.0%579423 0.002 0.006 0.017
overview write00:00:42.909 0.0%21532 0.026 1.993 58.978
perl filter00:00:59.023 0.1%28924 1.365 2.041 18.392
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.624 0.0%43064 0.005 0.038 0.112
TOTAL: 24:00:46.50923:59:39.450 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.078 0.0%30745 0.000 0.003 0.023
article prepare00:00:00.000 0.0%8784 0.000 0.000 0.000
article read00:00:00.185 0.0%2028 0.000 0.091 2.621
backlog stats00:00:00.323 0.0%341191 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.676 0.0%285994 0.001 0.006 0.011
data write00:00:03.003 0.0%270051 0.002 0.011 0.020
idle23:53:22.540 99.9%341191 144.219 252.066 592.641
status file00:00:21.721 0.0%1862 0.700 11.665 457.538
TOTAL: 23:54:08.11623:53:49.526100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle30:59:53.002 97.6%153397 0.000 727.478 93999.365
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:32.442 0.1%343958 0.000 0.269 4.981
readart00:00:13.005 0.0%17273 0.000 0.753 20.412
TOTAL: 31:45:30.87031:01:38.449 97.7%----

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 52 19144 5615 13248 281 29%64:16:42
2news-out.aioe.org 3 21128 4279 16632 217 20%24:42:03
3news-out.mixmin.net 19 23873 3041 20020 812 12%31:50:32
4csiph.com 1 24052 2006 21974 72 8%27:16:37
5feeder.eternal-september.org 85 26634 1745 23559 1330 6%56:37:52
6news.albasani.net 2 24135 1684 21836 615 6%24:51:51
7newsfeed.datemas.de 2 21776 1433 19840 503 6%23:05:10
8newsfeed.neva.ru 155 20604 1058 15787 3759 5%92:44:49
9news.redatomik.org 3 22246 424 21646 176 1%24:27:22
10news.swapon.de 2 2038 243 1784 11 11%23:05:30
11feeder.awxg.com 1 19632 112 19462 58 0%23:59:56
12news.samoylyk.net 2 21545 100 21372 73 0%23:59:39
13agency-nz-out.news.mb-net.net 8 23900 90 23606 204 0%27:01:09
14news.freedyn.net 1 21968 38 21855 75 0%19:28:23
15localhost 2 1 1 0 0 100%00:00:00
16news.ausics.org 12 19254 0 19254 0 0%31:29:24
TOTAL: 16 350 311930 21869 281875 8186 7%518:56:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.8 MB274.2 KB1.7 MB25.8 MB 92%4.5 KB
2news-out.aioe.org10.8 MB194.7 KB590.8 KB11.6 MB 93%2.6 KB
3news.albasani.net10.7 MB391.4 KB2.0 MB13.1 MB 82%5.8 KB
4news-out.mixmin.net8.6 MB564.4 KB2.3 MB11.4 MB 75%3.0 KB
5feeder.eternal-september.org6.9 MB712.1 KB5.4 MB13.0 MB 53%4.3 KB
6newsfeed.datemas.de6.4 MB548.1 KB4.0 MB10.9 MB 58%5.7 KB
7csiph.com5.9 MB398.5 KB421.3 KB6.7 MB 88%3.3 KB
8newsfeed.neva.ru2.4 MB209.9 KB19.8 MB22.4 MB 10%4.8 KB
9news.redatomik.org1.6 MB2.8 MB3.0 MB7.4 MB 21%12.7 KB
10news.freedyn.net1.2 MB456.9 KB549.2 KB2.2 MB 55%19.9 KB
11news.samoylyk.net1017.3 KB2.3 MB2.3 MB5.6 MB 17%33.3 KB
12news.swapon.de681.4 KB122.3 KB123.4 KB927.1 KB 73%3.6 KB
13feeder.awxg.com578.0 KB174.6 KB230.8 KB983.5 KB 58%5.8 KB
14agency-nz-out.news.mb-net.net358.7 KB302.5 KB986.8 KB1.6 MB 21%5.6 KB
15localhost1.0 KB0.0 KB0.0 KB1.0 KB100%1.0 KB
16news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1681.0 MB9.4 MB43.3 MB133.6 MB 60%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 24 23:58:02 - 23:59:59 23 0.1% 0.1951.0 KB 0.1% 0.43
Jan 25 00:00:00 - 00:59:59 1076 5.0% 0.303.1 MB 4.0% 0.89
Jan 25 01:00:00 - 01:59:59 1015 4.7% 0.283.3 MB 4.3% 0.95
Jan 25 02:00:00 - 02:59:59 1061 4.9% 0.293.1 MB 3.9% 0.87
Jan 25 03:00:00 - 03:59:59 1172 5.4% 0.335.2 MB 6.6% 1.47
Jan 25 04:00:00 - 04:59:59 1176 5.5% 0.333.4 MB 4.3% 0.97
Jan 25 05:00:00 - 05:59:59 1264 5.9% 0.354.0 MB 5.1% 1.12
Jan 25 06:00:00 - 06:59:59 1232 5.7% 0.344.9 MB 6.2% 1.38
Jan 25 07:00:00 - 07:59:59 1226 5.7% 0.344.2 MB 5.4% 1.19
Jan 25 08:00:00 - 08:59:59 1290 6.0% 0.364.4 MB 5.7% 1.26
Jan 25 09:00:00 - 09:59:59 1187 5.5% 0.335.5 MB 7.0% 1.56
Jan 25 10:00:00 - 10:59:59 1131 5.3% 0.314.2 MB 5.3% 1.18
Jan 25 11:00:00 - 11:59:59 1008 4.7% 0.282.9 MB 3.7% 0.82
Jan 25 12:00:00 - 12:59:59 791 3.7% 0.223.3 MB 4.2% 0.93
Jan 25 13:00:00 - 13:59:59 607 2.8% 0.172.9 MB 3.8% 0.84
Jan 25 14:00:00 - 14:59:59 519 2.4% 0.141.5 MB 2.0% 0.44
Jan 25 15:00:00 - 15:59:59 457 2.1% 0.131.3 MB 1.7% 0.38
Jan 25 16:00:00 - 16:59:59 441 2.0% 0.122.6 MB 3.3% 0.73
Jan 25 17:00:00 - 17:59:59 410 1.9% 0.112.1 MB 2.7% 0.59
Jan 25 18:00:00 - 18:59:59 436 2.0% 0.121.9 MB 2.5% 0.55
Jan 25 19:00:00 - 19:59:59 542 2.5% 0.152.5 MB 3.1% 0.70
Jan 25 20:00:00 - 20:59:59 682 3.2% 0.193.6 MB 4.5% 1.01
Jan 25 21:00:00 - 21:59:59 931 4.3% 0.262.8 MB 3.6% 0.80
Jan 25 22:00:00 - 22:59:59 875 4.1% 0.242.5 MB 3.3% 0.72
Jan 25 23:00:00 - 23:58:02 978 4.5% 0.283.0 MB 3.8% 0.87
TOTAL: 24:00:00 21530 100.0% 0.2578.1 MB 100.0% 0.93
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.2 GB 46.3% 0 0.37 1647.61
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB26.9 GB 53.7% 0 0.41 1462.69
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB287.7 MB 0.6% 0 0.0318823.53
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 GB15.6 GB 31.2% 0 0.68 889.41
TOTAL: 10-500.0 GB65.9 GB 13.2% 1 0.48-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3827 43 0 53 1 0 0 0 3730
2feeder.eternal-september.org 1416 0 0 117 0 0 0 0 1299
3news-out.mixmin.net 1016 0 0 129 0 0 0 0 887
4news.albasani.net 749 4 0 91 0 0 0 0 654
5newsfeed.datemas.de 621 190 0 83 0 0 0 0 348
6news-out.aioe.org 326 15 0 50 0 0 0 0 261
7news.snarked.org 277 30 0 77 0 0 0 0 170
8news.redatomik.org 220 0 0 74 0 0 0 0 146
9agency-nz-out.news.mb-net.net 216 66 0 79 0 0 0 0 71
10news.freedyn.net 83 7 0 53 0 0 0 0 23
11news.samoylyk.net 75 0 0 70 0 0 0 0 5
12feeder.awxg.com 68 0 0 62 0 0 0 0 6
13csiph.com 68 0 0 63 0 0 0 0 5
14news.swapon.de 61 0 0 6 0 0 0 0 55
TOTAL: 14 9023 355 0 1007 1 0 0 0 7660

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.immobiliari 56
it.annunci.commerciali 53
it.annunci.varie 45
gmane.linux.alsa.devel 35
mozilla.dev.security.policy 30
mozilla.support.seamonkey 15
nemo.bavardages 11
gmane.comp.gis.openstreetmap.tagging 9
mpc.lists.nanog 7
gmane.linux.bios.flashrom 6
bremen.test 6
gmane.comp.hardware.netbook.arm.sunxi 6
mozilla.dev.ui-alerts 5
mozilla.dev.l10n 5
mpc.lists.freebsd.gnome 5
mozilla.dev.builds 5
mpc.lists.freebsd.x11 4
mozilla.dev.servo 4
mpc.lists.freebsd.office 4
al.christnet.bible 3
TOTAL: 52 355

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

GroupsCount
linux.debian.user 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5758
EMP (phn path) 503
EMP (phn nph) 299
Binary: misplaced rar 282
Too many newsgroups 59
EMP (fsl) 51
User-issued cancel 32
Binary: non-binary distribution 26
EMP (phl) 14
HTML post 6
User-issued spam cancel 5
Binary: misplaced par2 2
Binary: misplaced 002 1
hierarchy violation - crosspost outside netscape 1
Binary: misplaced 003 1
Too many newsgroups (low_xpost) 1
Cancel for rejected article 1
Binary: misplaced 212 1
U2 violation - invalid distribution 1
TOTAL: 19 7044

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 229
news.albasani.net 142
news-out.aioe.org 110
news.swapon.de 54
newsfeed.datemas.de 51
news.redatomik.org 23
news.samoylyk.net 4
feeder.awxg.com 1
newsfeed.neva.ru 1
news.snarked.org 1
TOTAL: 10 616
TOTAL: 1 616

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 20044 981 18949 34 0 238 4%23:59:47
2awxg 21141 100 21015 1 0 9 0%23:59:47
3news.freedyn.net 21709 13 21471 0 0 0 0%23:59:46
4news.redatomik.org 21217 3 21053 7 0 2509 0%23:59:46
5news-in.mixmin.net 17283 2 17254 0 0 0 0%23:59:46
6eternal-september 18451 2 18430 0 0 0 0%23:59:46
7aioe 16201 1 16083 0 0 0 0%23:59:45
8news.samoylyk.net 19984 1 19888 1 0 0 0%23:59:45
9mb-net.net 21469 1 21403 0 0 0 0%23:59:46
10neva.ru 20056 1 20032 0 0 0 0%23:59:46
11news.albasani.net 21786 1 18727 924 0 6536 0%23:59:46
12csiph.com 19758 1 19686 4 0 0 0%23:59:47
13newsfeed.datemas.de 20210 1 20135 0 0 1 0%23:59:36
14news.snarked.org 15535 1 15483 1 0 1 0%23:59:46
15news.swapon.de 2019 0 2019 0 0 0 0%23:59:46
TOTAL: 15 276863 1109 271628 972 0 9294 0%359:56:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org15.7 MB1.2 MB16.9 MB0.2 KB/s17.0 KB23:59:47
2awxg284.9 KB4.3 KB289.2 KB0.0 KB/s2.9 KB23:59:47
3news.freedyn.net44.0 KB0.0 KB44.0 KB0.0 KB/s3.4 KB23:59:46
4eternal-september4.2 KB0.0 KB4.2 KB0.0 KB/s2.1 KB23:59:46
5news.redatomik.org4.1 KB149.5 KB153.6 KB0.0 KB/s15.4 KB23:59:46
6news.albasani.net2.7 KB3.1 MB3.1 MB0.0 KB/s3.4 KB23:59:46
7news-in.mixmin.net2.6 KB0.0 KB2.6 KB0.0 KB/s1.3 KB23:59:46
8aioe1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:59:45
9news.samoylyk.net1.0 KB78.4 KB79.5 KB0.0 KB/s39.7 KB23:59:45
10mb-net.net1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:59:46
11neva.ru1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:59:46
12csiph.com1.0 KB1022.1 KB1023.2 KB0.0 KB/s204.6 KB23:59:47
13newsfeed.datemas.de1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:59:36
14news.snarked.org1.0 KB198.9 KB199.9 KB0.0 KB/s100.0 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
TOTAL: 1516.0 MB5.7 MB21.8 MB0.0 KB/s10.7 KB359:56:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 877732.0 MB 1238 0 1602:19:54
2agency.bbs.geek.nz 385 671225.4 MB 3712 1 000:12:55
3vorlon.activateit.net.au 24 9381.3 MB 129 0 000:04:43
4192.168.1.9 1 2472.0 MB 11 0 000:00:11
560.234.68.122 4 410.3 KB 2 0 000:08:10
TOTAL: 5 422 1667860.7 MB 5092 1 1631:57:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 9 877732.0 MB 1238 0 1630:36:56
2*.bbs.geek.nz 385 671225.4 MB 3712 1 000:12:55
3*.activateit.net.au 24 9381.3 MB 129 0 000:04:43
4unresolved 14 2512.0 MB 13 0 001:02:50
TOTAL: 4 432 1667860.7 MB 5092 1 1631:57:29

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
crash 3
paulh 1
malcolmlewis 1
TOTAL: 5 37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.188 0.032 0.00628:17:01
67-61-21-181.cpe.cableone.net 1.684 1.272 0.10402:19:54
118.149.156.242 0.332 0.060 0.00000:38:42
118.149.160.92 0.244 0.020 0.00000:15:45
agency.bbs.geek.nz 27.288 6.564 0.00000:12:55
60.234.68.122 0.264 0.036 0.00800:08:10
vorlon.activateit.net.au 1.344 0.400 0.40700:04:43
192.168.1.9 0.144 0.044 0.00300:00:11
? 1.784 0.204 0.00000:00:03
TOTAL: 9 33.272 8.632 0.52831:57:29

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.156.242 5
118.149.160.92 4
67-60-219-146.cpe.cableone.net 1
TOTAL: 3 10

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
118.149.156.242 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 4851 29.1%
2comp 2189 13.1%
3soc 2118 12.7%
4sci 1952 11.7%
5alt 1908 11.4%
6linux 1249 7.5%
7uk 1104 6.6%
8talk 694 4.2%
9misc 238 1.4%
10news 206 1.2%
11mozilla 57 0.3%
12nz 37 0.2%
13microsoft 28 0.2%
14humanities 16 0.1%
15perl 15 0.1%
16us 6 0.0%
17aus 6 0.0%
18agency 4 0.0%
TOTAL: 18 16678100.0%

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

NewsgroupCount
1rec.arts.tv 771
2rec.sport.tennis 608
3uk.d-i-y 538
4linux.debian.bugs.dist 528
5rec.arts.sf.written 504
6alt.fan.rush-limbaugh 487
7rec.food.cooking 424
8sci.physics 402
9alt.atheism 394
10soc.culture.polish 328
11sci.electronics.design 327
12soc.retirement 306
13talk.politics.guns 286
14comp.lang.python 276
15sci.physics.relativity 240
16rec.arts.drwho 231
17comp.os.vms 230
18linux.debian.changes.devel 227
19sci.logic 226
20talk.politics.misc 216
21comp.mobile.android 206
22soc.culture.israel 200
23soc.culture.china 199
24comp.os.linux.advocacy 193
25comp.lang.c 184
26sci.math 180
27talk.origins 172
28uk.legal 171
29rec.sport.football.college 169
30rec.music.classical.recordings 163
31soc.culture.usa 159
32rec.boats 156
33rec.gambling.poker 155
34news.lists.filters 153
35alt.bible.prophecy 131
36uk.rec.cars.maintenance 131
37linux.debian.bugs.rc 130
38alt.comp.os.windows-10 129
39rec.drugs.cannabis 128
40comp.mobile.ipad 123
41rec.outdoors.rv-travel 120
42alt.politics.trump 117
43alt.test 107
44alt.politics 104
45soc.genealogy.britain 102
46soc.history 99
47linux.debian.user 98
48comp.lang.ada 96
49alt.conspiracy 94
50sci.electronics.repair 90
51rec.aquaria.marine.misc 88
52comp.sys.raspberry-pi 88
53rec.aviation.marketplace 88
54rec.woodworking 83
55comp.lang.c++ 83
56misc.survivalism 82
57soc.culture.singapore 82
58comp.arch 80
59soc.culture.brazil 75
60rec.sport.pro-wrestling 75
61rec.sport.golf 74
62comp.lang.forth 71
63sci.astro.amateur 70
64soc.culture.vietnamese 70
65sci.med.cardiology 69
66comp.lang.tcl 68
67misc.phone.mobile.iphone 66
68rec.aviation.soaring 65
69soc.culture.indian 64
70sci.military.naval 64
71uk.legal.moderated 59
72soc.penpals 58
73rec.crafts.metalworking 57
74rec.music.rock-pop-r+b.1950s 56
75soc.history.what-if 54
76rec.games.pinball 52
77sci.math.num-analysis 52
78uk.radio.amateur 52
79rec.games.backgammon 52
80sci.crypt 51
81comp.lang.fortran 51
82linux.gentoo.user 50
83rec.bicycles.tech 50
84alt.astronomy 50
85uk.rec.driving 49
86comp.protocols.time.ntp 48
87soc.genealogy.medieval 46
88rec.radio.shortwave 45
89alt.recovery.aa 44
90rec.photo.digital 43
91alt.support.diabetes 41
92soc.genealogy.benelux 39
93sci.med.pharmacy 39
94comp.sys.apple2 39
95rec.arts.movies.current-films 37
96nz.general 37
97comp.sys.mac.system 37
98linux.debian.maint.boot 35
99rec.games.trivia 35
100rec.arts.tv.uk.coronation-st 35
TOTAL: 376 16678