news.bbs.nz daily logs

Sep 2 23:58:02 -- Sep 3 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 124147 60.3%9.6 MB 37.3%
innd 33519 16.3%5.3 MB 20.7%
innfeed 26372 12.8%5.2 MB 20.1%
inn 20414 9.9%5.4 MB 20.9%
cnfsstat 1440 0.7%254.3 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 205893 100.0%25.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 271236 49.0%
Positive hits 262275 47.4%
Do not exist 19847 3.6%
Cache misses 207 0.0%
TOTAL: 4 553565 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.145 0.0%69 0.000 2.101 30.000
article cleanup00:00:00.180 0.0%20185 0.000 0.009 0.036
article logging00:00:00.520 0.0%20361 0.000 0.026 0.145
article parse00:00:00.675 0.0%64823 0.000 0.010 0.028
article write00:00:01.922 0.0%16687 0.015 0.115 6.009
artlog/artcncl00:00:00.001 0.0%69 0.000 0.014 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.435 0.0%543007 0.000 0.001 0.013
hisgrep/artcncl00:00:00.000 0.0%68 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%69 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.035 0.0%558894 0.001 0.013 0.682
history sync00:00:00.107 0.0%372 0.000 0.288 23.000
history write00:00:04.489 0.0%20007 0.013 0.224 16.422
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:58:05.959 99.8%554761 81.238 155.537 544.767
nntp read00:00:03.491 0.0%555165 0.002 0.006 0.024
overview write00:00:39.820 0.0%16687 0.079 2.386 65.638
perl filter00:00:40.599 0.0%20007 1.367 2.029 5.350
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.887 0.0%33374 0.006 0.027 0.090
TOTAL: 24:00:55.08323:59:46.265 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%23840 0.000 0.002 0.017
article prepare00:00:00.001 0.0%7812 0.000 0.000 0.042
article read00:00:00.470 0.0%1844 0.000 0.255 27.538
backlog stats00:00:00.314 0.0%298074 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.533 0.0%245279 0.000 0.006 0.014
data write00:00:02.888 0.0%232891 0.006 0.012 0.023
idle23:54:51.731 99.9%298074 171.588 288.827 801.179
status file00:00:26.388 0.0%2004 0.750 13.168 601.474
TOTAL: 23:55:41.07423:55:23.381100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%6 0.000 0.000 0.000
idle02:25:34.725 96.4%128941 0.000 67.742 75359.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.484 0.0%270920 0.000 0.005 0.200
readart00:00:01.010 0.0%6503 0.000 0.155 20.500
TOTAL: 02:31:00.81002:25:37.219 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
1bbs-nz-out.news.weretis.net 6 36415 4858 31287 270 13%50:31:56
2bbsnz-out.feed.uzoreto.com 1106 25931 2710 22227 994 10%95:21:02
3news.snarked.org 36 19871 2656 15811 1404 13%35:25:00
4feeder.eternal-september.org 5 20509 2070 18312 127 10%26:28:47
5news-out.aioe.org 3 15922 1598 14299 25 10%24:30:16
6news-out.mixmin.net 3 17923 1236 16216 471 6%24:18:47
7newsfeed.neva.ru 144 10266 851 9309 106 8%71:00:06
8news.redatomik.org 4 16385 300 16049 36 1%24:02:20
9news.albasani.net 1 8053 218 7712 123 2%11:28:24
10csiph.com 1 15445 193 15249 3 1%23:59:56
11news.swapon.de 4 1468 119 1346 3 8%24:28:37
12news.samoylyk.net 4 20880 70 20790 20 0%33:11:20
13agency-nz-out.news.mb-net.net 7 18235 52 18165 18 0%25:09:51
14newsfeed.datemas.de 0 14542 24 14505 13 0%20:49:48
15feeder.awxg.com 1 13543 11 13523 9 0%23:59:56
16news.freedyn.net 2 20240 11 20213 16 0%26:22:30
17localhost 3 2 2 0 0 100%00:00:00
18news.ausics.org 2 65666 2 65661 3 0%107:07:25
TOTAL: 18 1332 341296 16981 320674 3641 4%648:16:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net21.3 MB268.3 KB1.2 MB22.8 MB 93%4.5 KB
2news.snarked.org8.6 MB261.7 KB14.9 MB23.8 MB 36%6.0 KB
3bbsnz-out.feed.uzoreto.com8.1 MB6.2 KB10.4 MB18.5 MB 43%5.1 KB
4feeder.eternal-september.org5.7 MB145.2 KB617.5 KB6.4 MB 88%3.0 KB
5news-out.aioe.org4.0 MB22.8 KB158.4 KB4.2 MB 95%2.6 KB
6news-out.mixmin.net3.8 MB43.4 KB994.2 KB4.8 MB 78%2.9 KB
7newsfeed.neva.ru1.9 MB11.6 KB537.3 KB2.5 MB 78%2.7 KB
8news.redatomik.org1.5 MB40.9 KB110.4 KB1.6 MB 90%5.0 KB
9news.albasani.net685.5 KB10.8 KB254.6 KB950.9 KB 72%2.8 KB
10csiph.com557.9 KB10.7 KB10.7 KB579.2 KB 96%3.0 KB
11news.swapon.de374.3 KB6.9 KB11.2 KB392.3 KB 95%3.2 KB
12news.samoylyk.net254.7 KB59.0 KB60.9 KB374.5 KB 67%4.2 KB
13agency-nz-out.news.mb-net.net141.1 KB24.7 KB56.4 KB222.1 KB 63%3.2 KB
14newsfeed.datemas.de59.4 KB23.1 KB39.8 KB122.3 KB 48%3.3 KB
15feeder.awxg.com31.7 KB24.3 KB24.3 KB80.2 KB 39%4.0 KB
16news.freedyn.net30.5 KB18.5 KB43.9 KB92.9 KB 32%3.4 KB
17news.ausics.org4.6 KB67.0 KB67.0 KB138.5 KB 3%27.7 KB
18localhost2.2 KB0.0 KB0.0 KB2.2 KB100%1.1 KB
TOTAL: 1857.1 MB1.0 MB29.4 MB87.4 MB 65%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 2 23:58:02 - 23:59:59 23 0.1% 0.1955.4 KB 0.1% 0.47
Sep 3 00:00:00 - 00:59:59 660 4.0% 0.181.7 MB 3.0% 0.48
Sep 3 01:00:00 - 01:59:59 707 4.2% 0.202.3 MB 4.1% 0.66
Sep 3 02:00:00 - 02:59:59 870 5.2% 0.242.4 MB 4.2% 0.67
Sep 3 03:00:00 - 03:59:59 841 5.0% 0.232.5 MB 4.4% 0.71
Sep 3 04:00:00 - 04:59:59 1037 6.2% 0.293.6 MB 6.4% 1.02
Sep 3 05:00:00 - 05:59:59 1042 6.3% 0.294.3 MB 7.6% 1.21
Sep 3 06:00:00 - 06:59:59 872 5.2% 0.242.7 MB 4.9% 0.78
Sep 3 07:00:00 - 07:59:59 948 5.7% 0.262.9 MB 5.1% 0.82
Sep 3 08:00:00 - 08:59:59 876 5.3% 0.243.3 MB 5.9% 0.94
Sep 3 09:00:00 - 09:59:59 742 4.5% 0.212.4 MB 4.3% 0.69
Sep 3 10:00:00 - 10:59:59 681 4.1% 0.192.3 MB 4.2% 0.66
Sep 3 11:00:00 - 11:59:59 553 3.3% 0.151.6 MB 2.8% 0.44
Sep 3 12:00:00 - 12:59:59 404 2.4% 0.111.5 MB 2.7% 0.43
Sep 3 13:00:00 - 13:59:59 364 2.2% 0.101.6 MB 2.8% 0.45
Sep 3 14:00:00 - 14:59:59 351 2.1% 0.101.8 MB 3.2% 0.52
Sep 3 15:00:00 - 15:59:59 327 2.0% 0.091.6 MB 2.8% 0.44
Sep 3 16:00:00 - 16:59:59 427 2.6% 0.122.0 MB 3.6% 0.57
Sep 3 17:00:00 - 17:59:59 453 2.7% 0.131.6 MB 2.9% 0.46
Sep 3 18:00:00 - 18:59:59 586 3.5% 0.162.3 MB 4.1% 0.66
Sep 3 19:00:00 - 19:59:59 704 4.2% 0.201.8 MB 3.2% 0.52
Sep 3 20:00:00 - 20:59:59 781 4.7% 0.222.2 MB 3.9% 0.63
Sep 3 21:00:00 - 21:59:59 818 4.9% 0.232.6 MB 4.7% 0.75
Sep 3 22:00:00 - 22:59:59 813 4.9% 0.232.1 MB 3.7% 0.59
Sep 3 23:00:00 - 23:58:01 788 4.7% 0.233.0 MB 5.4% 0.89
TOTAL: 23:59:59 16668 100.0% 0.1956.2 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB28.2 GB 56.4% 0 0.27 2241.02
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB32.5 GB 65.0% 0 0.27 2246.40
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB359.4 MB 0.7% 0 0.0323703.70
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 GB26.4 GB 52.8% 0 0.56 1082.38
TOTAL: 10-500.0 GB87.5 GB 17.5% 1 0.36-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1327 7 0 13 0 0 0 0 1307
2bbsnz-out.feed.uzoreto.com 1001 31 0 2 0 0 0 0 968
3news-out.mixmin.net 515 0 0 15 0 0 0 0 500
4bbs-nz-out.news.weretis.net 305 65 0 45 0 0 0 0 195
5feeder.eternal-september.org 121 0 0 11 0 0 0 0 110
6news.albasani.net 108 0 0 15 0 0 0 0 93
7newsfeed.neva.ru 107 19 0 6 0 0 0 0 82
8news.redatomik.org 45 0 0 15 0 0 0 0 30
9news-out.aioe.org 39 18 0 10 0 0 0 0 11
10news.swapon.de 34 0 0 0 0 0 0 0 34
11agency-nz-out.news.mb-net.net 24 2 0 11 0 0 0 0 11
12news.samoylyk.net 17 0 0 16 0 0 0 0 1
13news.freedyn.net 15 0 0 7 0 0 0 0 8
14feeder.awxg.com 8 0 0 8 0 0 0 0 0
15newsfeed.datemas.de 6 0 0 0 0 0 0 0 6
16csiph.com 5 0 0 4 0 0 0 0 1
TOTAL: 16 3677 142 0 178 0 0 0 0 3357

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 47
gmane.linux.alsa.devel 24
mozilla.support.seamonkey 17
fido7.ru.android 5
gmane.linux.kernel 5
mozilla.dev.servo 3
it.annunci.commerciali 3
mozilla.test 3
it.annunci.immobiliari 3
it.annunci.varie 3
gmane.linux.alsa.user 3
lyrics.wanted 2
mozilla.dev.ui-alerts 2
mozilla.compatibility 2
mozilla.dev.apps.thunderbird 2
alt.fan.snuffles 2
mozilla.dev.l10n 2
demos.local.statistics 1
alt.christnet.eucharist 1
mozilla.apis 1
TOTAL: 31 142

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2439
EMP (phn path) 394
EMP (phl) 150
EMP (phn nph) 63
Too many newsgroups 48
User-issued cancel 46
Binary: misplaced par2 25
Binary: non-binary distribution 4
User-issued spam cancel 4
Binary: misplaced rar 3
Too many newsgroups (meow) 1
HTML file attachment 1
Binary Image: misplaced jpg 1
HTML post 1
TOTAL: 14 3180

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
bbs-nz-out.news.weretis.net 54
news-out.mixmin.net 53
news.swapon.de 32
news-out.aioe.org 11
news.redatomik.org 9
news.albasani.net 6
bbsnz-out.feed.uzoreto.com 5
news.snarked.org 3
feeder.eternal-september.org 2
newsfeed.datemas.de 1
TOTAL: 11 177
TOTAL: 1 177

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15114 1016 14075 23 0 0 6%23:59:47
2awxg 16130 34 16089 2 0 0 0%23:59:40
3news.snarked.org 13957 20 13826 1 0 41 0%23:59:46
4news.freedyn.net 16865 10 16649 0 0 29 0%23:59:46
5news.samoylyk.net 15212 4 15073 0 0 70 0%23:59:46
6weretis.net 11987 3 11830 2 0 1 0%23:59:46
7news.redatomik.org 16366 3 16344 0 0 10 0%23:59:46
8aioe 14058 3 13973 0 0 0 0%23:59:39
9csiph.com 16497 2 16463 0 0 0 0%23:59:46
10neva.ru 15490 2 15476 0 0 0 0%23:59:46
11eternal-september 14420 2 14393 0 0 0 0%23:59:46
12news-in.mixmin.net 15162 2 15149 0 0 0 0%23:59:46
13mb-net.net 16633 2 16601 0 0 0 0%23:59:42
14newsfeed.datemas.de 6435 1 6304 1 0 10873 0%23:59:46
15news.swapon.de 1389 0 1387 0 0 0 0%23:42:28
16news.uzoreto.com 13900 0 13897 2 0 0 0%23:59:32
17news.albasani.net 18376 0 15321 688 0 6558 0%23:59:45
TOTAL: 17 237991 1104 232850 719 0 17582 0%407:38:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org9.0 MB476.3 KB9.5 MB0.1 KB/s9.4 KB23:59:47
2awxg130.7 KB10.5 KB141.2 KB0.0 KB/s3.9 KB23:59:40
3news.snarked.org38.7 KB2.3 KB41.0 KB0.0 KB/s2.0 KB23:59:46
4news.freedyn.net18.4 KB0.0 KB18.4 KB0.0 KB/s1.8 KB23:59:46
5news.samoylyk.net5.9 KB0.0 KB5.9 KB0.0 KB/s1.5 KB23:59:46
6news.redatomik.org4.6 KB0.0 KB4.6 KB0.0 KB/s1.5 KB23:59:46
7weretis.net3.4 KB5.5 KB8.9 KB0.0 KB/s1.8 KB23:59:46
8aioe3.3 KB0.0 KB3.3 KB0.0 KB/s1.1 KB23:59:39
9csiph.com2.2 KB0.0 KB2.2 KB0.0 KB/s1.1 KB23:59:46
10neva.ru2.2 KB0.0 KB2.2 KB0.0 KB/s1.1 KB23:59:46
11eternal-september2.2 KB0.0 KB2.2 KB0.0 KB/s1.1 KB23:59:46
12news-in.mixmin.net2.2 KB0.0 KB2.2 KB0.0 KB/s1.1 KB23:59:46
13mb-net.net2.2 KB0.0 KB2.2 KB0.0 KB/s1.1 KB23:59:42
14newsfeed.datemas.de1.5 KB3.0 KB4.5 KB0.0 KB/s2.2 KB23:59:46
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:28
16news.uzoreto.com0.0 KB2.2 KB2.2 KB0.0 KB/s1.1 KB23:59:32
17news.albasani.net0.0 KB3.6 MB3.6 MB0.0 KB/s5.4 KB23:59:45
TOTAL: 179.2 MB4.1 MB13.4 MB0.0 KB/s7.5 KB407:38:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 404 516019.1 MB 3089 2 8000:16:37
2vorlon.activateit.net.au 24 10081.4 MB 133 0 000:04:58
360.234.68.122 8 1431.6 KB 2 0 000:21:29
TOTAL: 3 436 618220.5 MB 3224 2 8002:30:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 404 516019.1 MB 3089 2 8000:16:37
2*.activateit.net.au 24 10081.4 MB 133 0 000:04:58
3unresolved 14 1431.6 KB 2 0 000:25:48
4*.cpe.cableone.net 2 00.0 KB 0 0 001:43:27
TOTAL: 4 444 618220.5 MB 3224 2 8002:30:54

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 7
malcolmlewis 2
TOTAL: 3 33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-245-118.cpe.cableone.net 0.064 0.012 0.00301:43:27
60.234.68.122 0.572 0.052 0.02100:21:29
agency.bbs.nz 28.504 6.476 0.00000:16:37
vorlon.activateit.net.au 1.396 0.372 0.12600:04:58
118.149.133.157 0.240 0.032 0.00000:04:05
107.170.211.238 0.048 0.012 0.00000:00:09
94.167.18.64 0.048 0.012 0.00000:00:02
? 1.256 0.180 0.00000:00:01
TOTAL: 8 32.128 7.148 0.15002:30:54

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.133.157 4
160-3-245-118.cpe.cableone.net 2
94.167.18.64 1
107.170.211.238 1
TOTAL: 4 8

NNRP gethostbyaddr failures [Top 20]:

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

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2363 38.3%
2comp 781 12.6%
3soc 651 10.5%
4uk 561 9.1%
5sci 560 9.1%
6linux 444 7.2%
7alt 311 5.0%
8talk 177 2.9%
9misc 167 2.7%
10news 60 1.0%
11mozilla 56 0.9%
12microsoft 19 0.3%
13nz 11 0.2%
14agency 8 0.1%
15humanities 7 0.1%
TOTAL: 15 6176100.0%

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

NewsgroupCount
1rec.arts.tv 807
2rec.arts.drwho 277
3comp.lang.c 258
4uk.d-i-y 251
5uk.legal 176
6rec.food.cooking 157
7linux.debian.bugs.dist 156
8comp.os.linux.advocacy 133
9rec.sport.tennis 128
10sci.physics.relativity 120
11sci.physics 120
12comp.lang.c++ 114
13rec.gambling.poker 114
14soc.retirement 108
15misc.survivalism 103
16soc.culture.china 98
17linux.debian.changes.devel 93
18soc.culture.israel 92
19alt.politics.trump 89
20talk.politics.guns 88
21rec.arts.sf.written 87
22rec.sport.football.college 83
23alt.comp.os.windows-10 81
24soc.culture.polish 72
25rec.drugs.cannabis 68
26sci.electronics.design 65
27rec.autos.sport.f1 64
28sci.math 57
29uk.radio.amateur 55
30rec.aviation.soaring 53
31rec.sport.pro-wrestling 52
32sci.med.cardiology 50
33uk.legal.moderated 48
34talk.origins 47
35news.lists.filters 47
36alt.conspiracy 46
37linux.debian.bugs.rc 45
38rec.outdoors.rv-travel 45
39comp.os.vms 40
40soc.penpals 33
41linux.debian.user 33
42soc.genealogy.britain 33
43rec.music.classical.recordings 32
44talk.politics.misc 31
45alt.test 31
46comp.mobile.android 31
47linux.debian.devel.release 30
48rec.boats 30
49comp.lang.python 30
50rec.arts.poems 30
51soc.culture.usa 28
52sci.military.naval 27
53sci.logic 26
54comp.lang.forth 25
55rec.bicycles.tech 25
56mozilla.support.thunderbird 25
57rec.crafts.metalworking 24
58alt.conspiracy.jfk 22
59soc.culture.vietnamese 21
60sci.bio.paleontology 21
61mozilla.general 19
62rec.sport.golf 17
63rec.woodworking 17
64alt.bbs.wildcat 17
65rec.games.backgammon 16
66soc.culture.greek 16
67rec.music.beatles 16
68comp.lang.tcl 16
69sci.med.pharmacy 16
70alt.os.linux.ubuntu 15
71comp.arch 15
72misc.immigration.misc 14
73rec.sport.soccer 14
74soc.culture.brazil 14
75uk.comp.sys.mac 13
76linux.debian.devel 13
77soc.history.living 13
78soc.genealogy.jewish 13
79uk.tech.digital-tv 13
80comp.sys.apple2 12
81misc.phone.mobile.iphone 12
82comp.sys.mac.system 12
83mozilla.support.firefox 12
84sci.lang 11
85nz.general 11
86soc.history 11
87rec.games.roguelike.nethack 11
88soc.culture.quebec 10
89linux.debian.changes 10
90linux.debian.doc 9
91microsoft.public.windowsxp.general 9
92linux.debian.user.german 9
93rec.audio.opinion 9
94rec.music.rock-pop-r+b.1950s 9
95soc.culture.netherlands 9
96sci.research 8
97rec.arts.sf.fandom 8
98rec.radio.shortwave 8
99news.software.readers 8
100soc.culture.indian 8
TOTAL: 312 6176