news.bbs.nz daily logs

Apr 24 23:58:01 -- Apr 25 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 127278 61.9%9.9 MB 39.4%
innd 28581 13.9%4.7 MB 18.7%
inn 24658 12.0%5.7 MB 22.7%
innfeed 23781 11.6%4.6 MB 18.3%
cnfsstat 1440 0.7%255.7 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 205739 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 265132 49.6%
Positive hits 245972 46.0%
Do not exist 23591 4.4%
Cache misses 115 0.0%
TOTAL: 4 534810 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.118 0.0%188 0.000 0.628 31.000
article cleanup00:00:00.222 0.0%23933 0.000 0.009 0.049
article logging00:00:00.587 0.0%24508 0.000 0.024 0.077
article parse00:00:00.779 0.0%80184 0.000 0.010 0.021
article write00:00:01.532 0.0%19139 0.007 0.080 0.951
artlog/artcncl00:00:00.002 0.0%186 0.000 0.011 0.333
data move00:00:00.549 0.0%538865 0.000 0.001 0.011
hisgrep/artcncl00:00:00.003 0.0%186 0.000 0.016 0.100
hishave/artcncl00:00:00.001 0.0%188 0.000 0.005 0.067
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.104 0.0%537332 0.000 0.013 0.547
history sync00:00:00.022 0.0%375 0.000 0.059 1.000
history write00:00:04.775 0.0%23689 0.011 0.202 12.875
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:57:35.946 99.8%549386 93.168 157.004 371.571
nntp read00:00:04.137 0.0%551311 0.003 0.008 0.018
overview write00:00:45.763 0.1%19139 0.034 2.391 83.361
perl filter00:00:44.412 0.1%23689 0.973 1.875 20.807
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.917 0.0%38278 0.000 0.024 0.153
TOTAL: 24:00:54.35323:59:26.869 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.074 0.0%26922 0.000 0.003 0.028
article prepare00:00:00.003 0.0%7180 0.000 0.000 0.042
article read00:00:00.209 0.0%1683 0.000 0.124 5.938
backlog stats00:00:00.504 0.0%306345 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.447 0.0%254804 0.005 0.010 0.017
data write00:00:03.185 0.0%240567 0.004 0.013 0.023
idle23:53:35.103 99.9%306345 177.249 280.779 679.247
status file00:00:18.328 0.0%2017 0.500 9.087 462.088
TOTAL: 23:54:23.91723:53:59.853100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.002 0.0%14 0.000 0.143 0.400
idle34:03:44.330 97.4%137762 0.000 890.117 78018.806
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.266 0.0%298473 0.000 0.028 0.510
readart00:00:03.353 0.0%11122 0.000 0.301 24.833
TOTAL: 34:57:17.22234:03:55.951 97.5%----

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 32 22685 6620 13262 2803 29%33:28:53
2newsfeed.datemas.de 3 22805 3471 18811 523 15%27:14:22
3news-out.aioe.org 2 18001 2918 14995 88 16%22:44:00
4feeder.eternal-september.org 9 21257 2224 18743 290 10%24:43:33
5newsfeed.neva.ru 149 14684 1290 12853 541 8%76:19:44
6csiph.com 1 14809 611 14183 15 4%17:56:46
7news-out.mixmin.net 2 20571 592 19635 344 2%24:07:34
8news.redatomik.org 1 19378 501 18854 23 2%24:54:48
9news.swapon.de 2 1559 162 1394 3 10%19:08:10
10agency-nz-out.news.mb-net.net 7 21028 117 20857 54 0%24:51:59
11news.samoylyk.net 18 22436 113 22288 35 0%28:31:46
12feeder.awxg.com 2 17850 104 17719 27 0%23:59:49
13news.albasani.net 2 19565 53 19486 26 0%23:35:00
14news.freedyn.net 3 22136 29 22089 18 0%26:09:07
15localhost 6 5 5 0 0 100%00:00:00
16news.ausics.org 1 17980 3 17977 0 0%24:00:53
TOTAL: 16 240 276749 18813 253146 4790 6%421:46:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.0 MB257.8 KB43.2 MB66.4 MB 34%7.2 KB
2newsfeed.datemas.de9.3 MB130.9 KB3.8 MB13.2 MB 70%3.4 KB
3news-out.aioe.org6.8 MB73.0 KB559.4 KB7.4 MB 91%2.5 KB
4feeder.eternal-september.org5.7 MB137.8 KB976.0 KB6.7 MB 83%2.7 KB
5newsfeed.neva.ru2.7 MB41.4 KB1.7 MB4.4 MB 61%2.5 KB
6news-out.mixmin.net1.8 MB173.9 KB861.4 KB2.9 MB 64%3.1 KB
7csiph.com1.7 MB91.0 KB91.0 KB1.9 MB 90%3.1 KB
8news.redatomik.org1.7 MB92.1 KB102.6 KB1.9 MB 89%3.6 KB
9news.samoylyk.net468.0 KB66.4 KB653.7 KB1.2 MB 39%8.0 KB
10news.swapon.de413.6 KB0.0 KB3.7 KB417.3 KB 99%2.5 KB
11news.albasani.net359.5 KB143.2 KB160.2 KB663.0 KB 54%8.4 KB
12agency-nz-out.news.mb-net.net337.4 KB81.6 KB522.0 KB941.0 KB 35%5.5 KB
13feeder.awxg.com286.5 KB135.3 KB141.7 KB563.5 KB 50%4.3 KB
14news.freedyn.net276.4 KB123.5 KB160.7 KB560.5 KB 49%11.9 KB
15localhost11.8 KB0.0 KB0.0 KB11.8 KB100%2.4 KB
16news.ausics.org8.0 KB0.0 KB0.0 KB8.0 KB100%2.7 KB
TOTAL: 1654.9 MB1.5 MB52.8 MB109.1 MB 50%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 24 23:58:01 - 23:59:59 19 0.1% 0.1639.1 KB 0.1% 0.33
Apr 25 00:00:00 - 00:59:59 1103 5.8% 0.312.9 MB 5.2% 0.82
Apr 25 01:00:00 - 01:59:59 1057 5.5% 0.292.8 MB 5.1% 0.80
Apr 25 02:00:00 - 02:59:59 1013 5.3% 0.282.6 MB 4.6% 0.73
Apr 25 03:00:00 - 03:59:59 1150 6.0% 0.322.9 MB 5.2% 0.82
Apr 25 04:00:00 - 04:59:59 1011 5.3% 0.282.7 MB 4.9% 0.78
Apr 25 05:00:00 - 05:59:59 1154 6.0% 0.323.1 MB 5.7% 0.89
Apr 25 06:00:00 - 06:59:59 1048 5.5% 0.293.4 MB 6.1% 0.97
Apr 25 07:00:00 - 07:59:59 1037 5.4% 0.292.7 MB 4.9% 0.77
Apr 25 08:00:00 - 08:59:59 997 5.2% 0.283.5 MB 6.2% 0.98
Apr 25 09:00:00 - 09:59:59 898 4.7% 0.253.2 MB 5.8% 0.91
Apr 25 10:00:00 - 10:59:59 698 3.7% 0.192.3 MB 4.1% 0.65
Apr 25 11:00:00 - 11:59:59 547 2.9% 0.151.7 MB 3.0% 0.47
Apr 25 12:00:00 - 12:59:59 451 2.4% 0.131.5 MB 2.7% 0.43
Apr 25 13:00:00 - 13:59:59 422 2.2% 0.121.2 MB 2.2% 0.35
Apr 25 14:00:00 - 14:59:59 415 2.2% 0.121.5 MB 2.8% 0.43
Apr 25 15:00:00 - 15:59:59 376 2.0% 0.101.6 MB 2.8% 0.45
Apr 25 16:00:00 - 16:59:59 444 2.3% 0.121.3 MB 2.4% 0.37
Apr 25 17:00:00 - 17:59:59 613 3.2% 0.171.5 MB 2.7% 0.43
Apr 25 18:00:00 - 18:59:59 608 3.2% 0.171.7 MB 3.0% 0.48
Apr 25 19:00:00 - 19:59:59 804 4.2% 0.222.3 MB 4.2% 0.66
Apr 25 20:00:00 - 20:59:59 858 4.5% 0.242.2 MB 3.9% 0.62
Apr 25 21:00:00 - 21:59:59 759 4.0% 0.212.1 MB 3.8% 0.59
Apr 25 22:00:00 - 22:59:59 807 4.2% 0.222.1 MB 3.8% 0.59
Apr 25 23:00:00 - 23:58:02 814 4.3% 0.232.7 MB 4.8% 0.78
TOTAL: 24:00:01 19103 100.0% 0.2255.5 MB 100.0% 0.66
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB25.3 GB 50.6% 0 0.26 2307.21
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB29.3 GB 58.5% 0 0.31 1945.99
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB319.6 MB 0.6% 0 0.0322010.58
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 GB20.2 GB 40.4% 0 0.57 1065.04
TOTAL: 10-500.0 GB75.1 GB 15.0% 1 0.36-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2823 139 0 27 0 0 0 0 2657
2newsfeed.datemas.de 898 62 0 20 0 0 0 0 816
3newsfeed.neva.ru 547 39 0 20 0 0 0 0 488
4news-out.mixmin.net 388 0 0 27 0 0 0 0 361
5feeder.eternal-september.org 297 0 0 25 0 0 0 0 272
6news-out.aioe.org 154 58 0 13 0 0 0 0 83
7news.swapon.de 50 0 0 1 0 0 0 0 49
8agency-nz-out.news.mb-net.net 49 19 0 11 0 0 0 0 19
9news.redatomik.org 41 0 0 13 0 0 0 0 28
10news.samoylyk.net 29 0 0 22 0 0 0 0 7
11feeder.awxg.com 28 1 0 22 0 0 0 0 5
12news.albasani.net 27 3 0 15 0 0 0 0 9
13csiph.com 22 0 0 21 0 0 0 0 1
14news.freedyn.net 16 2 0 7 0 0 0 0 7
TOTAL: 14 5369 323 0 244 0 0 0 0 4802

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 105
mpc.lists.freebsd.ports.bugs 37
gmane.linux.kernel 27
mpc.lists.nanog 26
mozilla.dev.security.policy 15
mozilla.test 12
mozilla.support.seamonkey 11
gmane.comp.gis.openstreetmap.tagging 10
mozilla.dev.platform 9
gmane.linux.alsa.user 8
gmane.linux.ports.arm.mediatek 6
mozilla.dev.l10n.new-locales 5
mozilla.support.bugzilla 5
mozilla.dev.ui-alerts 4
mpc.lists.freebsd.gnome 3
nemo.abuse 3
alt.bestjobsusa.colorado.jobs 3
mozilla.dev.l10n.web 3
south-wales.test 3
eagle.support.eng 2
TOTAL: 40 323

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3597
Binary: misplaced rar 350
EMP (phn path) 70
Binary: non-binary distribution 54
Too many newsgroups 39
User-issued cancel 32
Binary: misplaced par2 30
EMP (phn nph) 22
EMP (phl) 20
HTML post 5
Binary Image: misplaced jpg 2
Too many newsgroups (low_xpost) 2
Binary: misplaced zip 1
Binary: misplaced 273 1
Too many newsgroups (meow) 1
Binary: misplaced 008 1
Binary: misplaced JPG 1
TOTAL: 17 4228

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 375
news-out.aioe.org 63
news.swapon.de 46
news-out.mixmin.net 42
news.redatomik.org 23
news.snarked.org 10
newsfeed.neva.ru 7
feeder.awxg.com 5
feeder.eternal-september.org 2
news.albasani.net 1
TOTAL: 10 574
TOTAL: 1 574

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17812 911 16872 29 0 47 5%23:59:41
2awxg 18788 41 18741 0 0 0 0%23:59:39
3news.snarked.org 12393 16 12255 1 0 64 0%23:59:39
4news.freedyn.net 19239 9 19059 0 0 10 0%23:59:39
5aioe 15176 8 15071 0 0 150 0%23:59:39
6news.redatomik.org 18373 7 18352 0 0 0 0%23:59:39
7neva.ru 17435 5 17417 1 0 0 0%23:59:39
8eternal-september 16419 5 16389 0 0 169 0%23:59:39
9csiph.com 18524 5 18382 0 0 4 0%23:59:39
10news-in.mixmin.net 17857 5 17824 0 0 0 0%23:59:36
11news.samoylyk.net 17883 4 17710 0 0 1024 0%23:59:31
12news.albasani.net 19451 3 17362 653 4 6019 0%23:59:39
13mb-net.net 19050 3 18939 0 0 296 0%23:59:39
14newsfeed.datemas.de 15793 2 15687 2 0 195 0%23:59:39
15news.swapon.de 1601 0 1600 0 0 0 0%23:48:18
TOTAL: 15 245794 1024 241660 686 4 7978 0%359:43:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.8 MB313.2 KB5.1 MB0.1 KB/s5.5 KB23:59:41
2awxg211.0 KB0.0 KB211.0 KB0.0 KB/s5.1 KB23:59:39
3news.snarked.org39.6 KB3.4 KB43.0 KB0.0 KB/s2.5 KB23:59:39
4news.freedyn.net36.4 KB0.0 KB36.4 KB0.0 KB/s4.0 KB23:59:39
5aioe17.2 KB0.0 KB17.2 KB0.0 KB/s2.1 KB23:59:39
6news.redatomik.org15.9 KB0.0 KB15.9 KB0.0 KB/s2.3 KB23:59:39
7eternal-september11.9 KB0.0 KB11.9 KB0.0 KB/s2.4 KB23:59:39
8csiph.com11.9 KB0.0 KB11.9 KB0.0 KB/s2.4 KB23:59:39
9news-in.mixmin.net11.9 KB0.0 KB11.9 KB0.0 KB/s2.4 KB23:59:36
10news.samoylyk.net10.3 KB0.0 KB10.3 KB0.0 KB/s2.6 KB23:59:31
11neva.ru9.0 KB4.0 KB13.0 KB0.0 KB/s2.2 KB23:59:39
12news.albasani.net8.7 KB2.2 MB2.2 MB0.0 KB/s3.4 KB23:59:39
13mb-net.net7.3 KB0.0 KB7.3 KB0.0 KB/s2.4 KB23:59:39
14newsfeed.datemas.de5.6 KB3.1 KB8.7 KB0.0 KB/s2.2 KB23:59:39
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:18
TOTAL: 155.1 MB2.5 MB7.6 MB0.0 KB/s4.6 KB359:43:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 386 593918.2 MB 3467 4 000:14:13
267-61-82-242.cpe.cableone.net 1 27988.7 MB 149 0 200:25:38
3vorlon.activateit.net.au 24 9991.3 MB 149 0 000:05:02
4184-155-237-130.cpe.cableone.net 2 9723.3 MB 166 0 400:13:30
560.234.68.122 11 27115.4 KB 2 1 000:45:36
667-60-219-146.cpe.cableone.net 4 11.9 KB 1 0 032:20:46
TOTAL: 6 428 1073631.6 MB 3934 5 634:57:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 386 593918.2 MB 3467 4 000:14:13
2*.cpe.cableone.net 7 377112.0 MB 316 0 632:59:55
3*.activateit.net.au 24 9991.3 MB 149 0 000:05:02
4unresolved 23 27115.4 KB 2 1 001:37:22
5*.hsd1.or.comcast.net 24 00.0 KB 0 0 000:00:32
TOTAL: 5 464 1073631.6 MB 3934 5 634:57:10

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 10
malcolmlewis 4
bpanther 3
TOTAL: 4 41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.248 0.112 0.00732:20:46
60.234.68.122 0.736 0.108 0.02800:45:36
118.149.187.47 0.424 0.044 0.00000:35:09
67-61-82-242.cpe.cableone.net 0.240 0.368 0.00300:25:38
118.149.239.116 0.244 0.028 0.00000:16:33
agency.bbs.nz 28.844 6.844 0.00000:14:13
184-155-237-130.cpe.cableone.net 0.304 0.176 0.00600:13:30
vorlon.activateit.net.au 1.464 0.416 0.17500:05:02
c-73-11-56-74.hsd1.or.comcast.net 1.252 0.224 0.00000:00:32
? 1.660 0.212 0.00000:00:02
94.162.201.30 0.048 0.012 0.00000:00:02
TOTAL: 11 35.464 8.544 0.21934:57:10

Curious NNRP server explorers [Top 20]:

SystemConn
c-73-11-56-74.hsd1.or.comcast.net 24
118.149.187.47 7
118.149.239.116 4
94.162.201.30 1
TOTAL: 4 36

NNRP gethostbyaddr failures [Top 20]:

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

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
agency.bbs.nz 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 2563 23.9%
2soc 1626 15.2%
3comp 1491 13.9%
4linux 1358 12.7%
5uk 1263 11.8%
6sci 957 8.9%
7news 392 3.7%
8alt 316 2.9%
9misc 279 2.6%
10talk 234 2.2%
11mozilla 111 1.0%
12nz 58 0.5%
13microsoft 36 0.3%
14humanities 14 0.1%
15agency 13 0.1%
16aus 10 0.1%
17us 1 0.0%
TOTAL: 17 10722100.0%

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

NewsgroupCount
1uk.d-i-y 677
2rec.arts.tv 661
3linux.debian.bugs.dist 421
4rec.arts.drwho 365
5soc.retirement 332
6news.lists.filters 324
7uk.legal 305
8linux.debian.changes.devel 298
9comp.os.linux.advocacy 278
10linux.debian.bugs.rc 243
11sci.physics 223
12comp.lang.python 219
13sci.physics.relativity 219
14rec.arts.sf.written 212
15comp.lang.c 191
16rec.boats 178
17alt.comp.os.windows-10 147
18soc.culture.china 130
19misc.survivalism 128
20soc.culture.polish 123
21comp.sys.mac.system 120
22rec.food.cooking 115
23soc.genealogy.britain 109
24talk.origins 98
25soc.women 94
26rec.sport.pro-wrestling 92
27talk.politics.guns 89
28soc.culture.brazil 88
29rec.gambling.poker 88
30uk.radio.amateur 86
31linux.debian.user 85
32sci.electronics.design 84
33sci.logic 83
34rec.sport.football.college 80
35comp.lang.c++ 77
36soc.penpals 73
37soc.history 70
38linux.debian.devel 69
39soc.culture.usa 65
40rec.drugs.cannabis 64
41rec.sport.tennis 61
42nz.general 58
43linux.debian.maint.python 58
44rec.music.classical.recordings 57
45news.admin.net-abuse.email 54
46comp.os.vms 54
47sci.med.pharmacy 53
48rec.sport.golf 53
49sci.astro.amateur 52
50soc.history.what-if 50
51mozilla.support.thunderbird 49
52uk.tech.digital-tv 49
53sci.math.num-analysis 48
54soc.culture.indian 47
55rec.aviation.soaring 46
56soc.culture.israel 46
57sci.math 46
58sci.med.cardiology 45
59soc.genealogy.medieval 45
60mozilla.general 40
61uk.legal.moderated 38
62misc.phone.mobile.iphone 38
63uk.tech.broadcast 37
64comp.lang.asm.x86 37
65uk.comp.sys.mac 37
66soc.history.medieval 36
67misc.invest.stocks 36
68comp.unix.programmer 36
69comp.lang.tcl 35
70alt.test 34
71talk.politics.misc 33
72rec.bicycles.tech 33
73comp.protocols.time.ntp 32
74rec.sport.soccer 31
75rec.photo.digital 31
76comp.mobile.android 30
77alt.politics.trump 30
78rec.collecting.sport.basketball 29
79comp.sys.apple2 27
80alt.conspiracy 27
81rec.arts.sf.tv 26
82rec.music.beatles 26
83comp.sys.raspberry-pi 26
84linux.gentoo.user 26
85alt.bbs.synchronet 25
86comp.protocols.dns.bind 24
87microsoft.public.windowsxp.general 23
88alt.conspiracy.jfk 23
89soc.history.living 23
90rec.humor 22
91sci.electronics.repair 22
92mozilla.support.firefox 22
93comp.arch 21
94soc.culture.british 21
95soc.culture.australian 20
96misc.news.internet.discuss 20
97sci.lang 20
98soc.singles 18
99misc.health.alternative 18
100comp.sys.acorn.apps 18
TOTAL: 336 10722