news.bbs.nz daily logs

Apr 28 23:58:02 -- Apr 29 23:58:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Apr 29 17:00:02 news controlchan[32163]: Unknown "block" control by robomod@news.nic.it

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 130318 64.7%10.2 MB 42.2%
innd 25581 12.7%4.3 MB 17.6%
innfeed 23130 11.5%4.5 MB 18.6%
inn 21064 10.5%5.0 MB 20.6%
cnfsstat 1440 0.7%252.2 KB 1.0%
controlchan 2 0.0%0.3 KB 0.0%
TOTAL: 6 201535 100.0%24.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 230383 52.4%
Positive hits 188995 43.0%
Do not exist 20114 4.6%
Cache misses 64 0.0%
TOTAL: 4 439556 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.133 0.0%233 0.000 0.571 52.000
article cleanup00:00:00.192 0.0%20243 0.000 0.009 0.045
article logging00:00:00.684 0.0%20811 0.000 0.033 0.726
article parse00:00:00.587 0.0%49799 0.000 0.012 0.037
article write00:00:01.131 0.0%16800 0.000 0.067 0.321
artlog/artcncl00:00:00.004 0.0%231 0.000 0.017 1.000
data move00:00:00.345 0.0%437205 0.000 0.001 0.017
hisgrep/artcncl00:00:00.002 0.0%135 0.000 0.015 0.500
hishave/artcncl00:00:00.000 0.0%233 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.522 0.0%441446 0.000 0.017 1.461
history sync00:00:00.020 0.0%375 0.000 0.053 0.500
history write00:00:05.318 0.0%20132 0.000 0.264 16.694
hiswrite/artcncl00:00:00.002 0.0%98 0.000 0.020 0.024
idle23:58:01.780 99.8%441248 117.694 195.540 701.859
nntp read00:00:03.055 0.0%441975 0.001 0.007 0.015
overview write00:00:43.279 0.1%16800 0.000 2.576 113.778
perl filter00:00:40.656 0.0%20129 1.116 2.020 38.644
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.898 0.0%33601 0.000 0.027 0.207
TOTAL: 24:00:50.71323:59:45.608 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%21386 0.000 0.002 0.021
article prepare00:00:00.000 0.0%4066 0.000 0.000 0.000
article read00:00:00.094 0.0%968 0.000 0.097 2.625
backlog stats00:00:00.345 0.0%254737 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.100 0.0%208349 0.003 0.010 0.017
data write00:00:02.725 0.0%194751 0.004 0.014 0.024
idle23:53:16.322 99.9%254737 217.940 337.589 959.678
status file00:00:18.463 0.0%1851 0.500 9.975 388.971
TOTAL: 23:53:59.59323:53:40.097100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%16 0.000 0.062 0.143
idle25:51:43.640 98.5%140117 0.000 664.471 75238.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:25.554 0.0%302213 0.000 0.085 3.899
readart00:00:02.758 0.0%10358 0.000 0.266 35.000
TOTAL: 26:15:11.94625:52:11.953 98.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
1csiph.com 2 15794 3576 12212 6 22%23:31:50
2feeder.eternal-september.org 8 19732 2416 16505 811 12%25:09:01
3news.albasani.net 2 16677 2349 13714 614 14%22:47:07
4news-out.aioe.org 2 15946 2240 13645 61 14%23:20:45
5news-out.mixmin.net 4 19093 1765 16818 510 9%27:11:15
6news.redatomik.org 1 16295 1707 14572 16 10%24:54:48
7newsfeed.neva.ru 153 5996 1189 3747 1060 19%74:26:27
8newsfeed.datemas.de 2 17177 1035 15839 303 6%23:20:03
9news.swapon.de 8 1432 178 1249 5 12%24:50:26
10feeder.awxg.com 2 14731 159 14561 11 1%23:59:55
11agency-nz-out.news.mb-net.net 7 19343 106 19172 65 0%26:36:02
12news.samoylyk.net 1 16565 96 16453 16 0%23:59:57
13news.freedyn.net 3 17921 22 17865 34 0%23:38:52
14localhost 2 1 1 0 0 100%00:00:00
TOTAL: 14 197 196703 16839 176352 3512 8%367:46:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph.com11.1 MB63.3 KB67.2 KB11.3 MB 98%3.2 KB
2feeder.eternal-september.org8.6 MB172.0 KB5.2 MB13.9 MB 61%4.4 KB
3news.albasani.net7.2 MB99.6 KB1.2 MB8.5 MB 84%2.9 KB
4news-out.aioe.org6.1 MB36.4 KB290.2 KB6.5 MB 95%2.9 KB
5news-out.mixmin.net5.6 MB56.9 KB885.6 KB6.5 MB 85%2.9 KB
6news.redatomik.org5.3 MB30.4 KB44.6 KB5.4 MB 98%3.2 KB
7newsfeed.datemas.de3.6 MB34.0 KB1.4 MB5.0 MB 72%3.8 KB
8newsfeed.neva.ru3.4 MB33.5 KB3.7 MB7.2 MB 48%3.3 KB
9news.samoylyk.net967.9 KB115.1 KB118.4 KB1.2 MB 80%10.7 KB
10agency-nz-out.news.mb-net.net745.9 KB287.2 KB599.2 KB1.6 MB 45%9.5 KB
11news.swapon.de543.6 KB1.9 KB15.5 KB561.0 KB 96%3.1 KB
12feeder.awxg.com426.2 KB46.6 KB79.1 KB551.9 KB 77%3.2 KB
13news.freedyn.net240.8 KB45.3 KB139.0 KB425.2 KB 56%7.6 KB
14localhost2.8 KB0.0 KB0.0 KB2.8 KB100%2.8 KB
TOTAL: 1453.9 MB1022.3 KB13.6 MB68.5 MB 78%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 28 23:58:02 - 23:59:59 24 0.1% 0.20111.2 KB 0.2% 0.94
Apr 29 00:00:00 - 00:59:59 824 4.9% 0.232.6 MB 4.9% 0.75
Apr 29 01:00:00 - 01:59:59 1061 6.3% 0.293.2 MB 6.0% 0.92
Apr 29 02:00:00 - 02:59:59 948 5.6% 0.262.8 MB 5.2% 0.79
Apr 29 03:00:00 - 03:59:59 976 5.8% 0.273.5 MB 6.5% 0.99
Apr 29 04:00:00 - 04:59:59 995 5.9% 0.282.9 MB 5.3% 0.81
Apr 29 05:00:00 - 05:59:59 944 5.6% 0.262.6 MB 4.8% 0.74
Apr 29 06:00:00 - 06:59:59 964 5.7% 0.273.5 MB 6.4% 0.98
Apr 29 07:00:00 - 07:59:59 949 5.6% 0.262.7 MB 5.0% 0.77
Apr 29 08:00:00 - 08:59:59 951 5.6% 0.262.9 MB 5.5% 0.84
Apr 29 09:00:00 - 09:59:59 844 5.0% 0.232.6 MB 4.9% 0.75
Apr 29 10:00:00 - 10:59:59 733 4.4% 0.202.4 MB 4.5% 0.68
Apr 29 11:00:00 - 11:59:59 563 3.3% 0.161.9 MB 3.6% 0.54
Apr 29 12:00:00 - 12:59:59 387 2.3% 0.111.3 MB 2.3% 0.36
Apr 29 13:00:00 - 13:59:59 341 2.0% 0.091.3 MB 2.4% 0.37
Apr 29 14:00:00 - 14:59:59 397 2.4% 0.111.6 MB 2.9% 0.44
Apr 29 15:00:00 - 15:59:59 299 1.8% 0.081.3 MB 2.4% 0.37
Apr 29 16:00:00 - 16:59:59 251 1.5% 0.071008.1 KB 1.8% 0.28
Apr 29 17:00:00 - 17:59:59 328 1.9% 0.091.1 MB 2.0% 0.31
Apr 29 18:00:00 - 18:59:59 455 2.7% 0.131.7 MB 3.1% 0.47
Apr 29 19:00:00 - 19:59:59 616 3.7% 0.171.6 MB 2.9% 0.45
Apr 29 20:00:00 - 20:59:59 677 4.0% 0.192.0 MB 3.8% 0.58
Apr 29 21:00:00 - 21:59:59 785 4.7% 0.222.3 MB 4.2% 0.65
Apr 29 22:00:00 - 22:59:59 733 4.4% 0.202.2 MB 4.1% 0.63
Apr 29 23:00:00 - 23:58:01 797 4.7% 0.232.8 MB 5.3% 0.84
TOTAL: 23:59:59 16842 100.0% 0.1953.9 MB 100.0% 0.64
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB25.4 GB 50.8% 0 0.27 2221.29
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB29.4 GB 58.7% 0 0.29 2067.28
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB321.2 MB 0.6% 0 0.07 8889.14
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.4 GB 40.8% 0 0.51 1200.33
TOTAL: 10-500.0 GB75.5 GB 15.1% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1051 23 0 9 0 0 0 0 1019
2news.albasani.net 819 3 0 10 0 0 0 0 806
3feeder.eternal-september.org 773 0 0 15 0 0 0 0 758
4news-out.mixmin.net 613 0 0 8 0 0 0 0 605
5newsfeed.datemas.de 380 34 0 7 0 0 0 0 339
6news.redatomik.org 92 0 0 7 0 0 0 0 85
7news-out.aioe.org 82 40 0 8 0 0 0 0 34
8agency-nz-out.news.mb-net.net 56 21 0 15 0 0 0 0 20
9news.swapon.de 47 0 0 1 0 0 0 0 46
10news.freedyn.net 39 0 0 6 0 0 0 0 33
11news.samoylyk.net 16 0 0 11 0 0 0 0 5
12feeder.awxg.com 13 1 0 8 0 0 0 0 4
13csiph.com 8 0 0 4 0 0 0 0 4
14news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 14 3991 122 0 111 0 0 0 0 3758

Unwanted newsgroups [Top 20]:

NewsgroupCount
mozilla.support.seamonkey 22
gmane.linux.alsa.devel 22
gmane.comp.gis.openstreetmap.tagging 9
mozilla.test 7
mozilla.support.bugzilla 6
gmane.linux.ports.arm.kernel 6
mozilla.addons.chromebug 6
mpc.lists.freebsd.wireless 5
mpc.lists.freebsd.x11 4
south-wales.test 3
nemo.abuse 2
gmane.linux.kernel.stable 2
mozilla.dev.ui-alerts 2
mpc.lists.nanog 2
mozilla.support.calendar 2
alt.fr.os.windows.7 2
mozilla.dev.l10n 1
alt.religion.christian.romman-catholic 1
alt.sex.doom.with-soundo 1
alt.sex.doom.with-so 1
TOTAL: 36 122

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2738
EMP (phn path) 220
EMP (phn nph) 113
Too many newsgroups 48
EMP (phl) 32
User-issued cancel 18
Binary Image: misplaced jpg 5
Binary: non-binary distribution 3
MI5 Filter 2
Binary: misplaced rar 2
Binary: misplaced nzb 1
Too many newsgroups (meow) 1
Binary: misplaced 011 1
Binary: misplaced 004 1
Binary: misplaced zip 1
TOTAL: 15 3186

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.albasani.net 3
TOTAL: 1 3
Including strange strings
news.albasani.net 247
news-out.mixmin.net 113
news.redatomik.org 76
newsfeed.datemas.de 55
news.swapon.de 45
news-out.aioe.org 21
newsfeed.neva.ru 6
feeder.awxg.com 3
news.samoylyk.net 2
csiph.com 1
TOTAL: 10 569
TOTAL: 2 572

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15081 307 14761 13 0 0 2%23:59:37
2awxg 16256 18 16237 0 0 0 0%23:59:40
3news.freedyn.net 16919 8 16801 0 0 13 0%23:59:29
4csiph.com 13605 3 13057 0 0 10 0%23:59:40
5aioe 13426 2 13364 0 0 0 0%23:59:23
6news.samoylyk.net 15067 1 14998 0 0 0 0%23:59:32
7news.redatomik.org 15175 1 15157 0 0 0 0%23:59:36
8news-in.mixmin.net 14699 1 14667 0 0 0 0%23:59:40
9eternal-september 14019 1 14003 0 0 0 0%23:59:39
10mb-net.net 16697 1 16647 0 0 61 0%23:59:40
11news.albasani.net 15653 0 13684 594 1 4611 0%23:59:40
12neva.ru 15341 0 15336 1 0 0 0%23:59:40
13news.snarked.org 0 0 0 0 0 16711 0%23:59:44
14newsfeed.datemas.de 15471 0 15401 0 0 61 0%23:59:40
15news.swapon.de 1335 0 1326 0 0 9 0%23:49:12
TOTAL: 15 198744 343 195439 608 1 21476 0%359:43:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org3.4 MB201.1 KB3.6 MB0.0 KB/s11.6 KB23:59:37
2awxg62.1 KB0.0 KB62.1 KB0.0 KB/s3.5 KB23:59:40
3news.freedyn.net46.6 KB0.0 KB46.6 KB0.0 KB/s5.8 KB23:59:29
4csiph.com6.1 KB0.0 KB6.1 KB0.0 KB/s2.0 KB23:59:40
5aioe5.1 KB0.0 KB5.1 KB0.0 KB/s2.6 KB23:59:23
6mb-net.net4.2 KB0.0 KB4.2 KB0.0 KB/s4.2 KB23:59:40
7news.samoylyk.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:59:32
8news.redatomik.org2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:59:36
9news-in.mixmin.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:59:40
10eternal-september2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:59:39
11news.albasani.net0.0 KB2.5 MB2.5 MB0.0 KB/s4.2 KB23:59:40
12neva.ru0.0 KB2.8 KB2.8 KB0.0 KB/s2.8 KB23:59:40
13news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
14newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:40
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:12
TOTAL: 153.6 MB2.7 MB6.2 MB0.0 KB/s6.7 KB359:43:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 385 559219.7 MB 3350 1 000:12:17
2184-155-236-243.cpe.cableone.net 8 305111.3 MB 546 0 1600:47:59
3vorlon.activateit.net.au 25 8781.2 MB 154 0 000:04:48
4192.168.1.7 1 214671.5 KB 7 0 000:00:06
560.234.68.122 15 37145.4 KB 3 0 000:51:34
TOTAL: 5 434 977232.9 MB 4060 1 1626:15:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 385 559219.7 MB 3350 1 000:12:17
2*.cpe.cableone.net 11 305111.3 MB 546 0 1624:44:25
3*.activateit.net.au 25 8781.2 MB 154 0 000:04:48
4unresolved 21 251816.9 KB 10 0 001:11:48
5*.news.bbs.nz 4 00.0 KB 0 0 000:01:08
6*.hsd1.or.comcast.net 24 00.0 KB 0 0 000:00:34
TOTAL: 6 470 977232.9 MB 4060 1 1626:15:05

NNRP auth users [Top 20]:

UserConn
amybbs 25
crash 12
bpanther 8
paulh 5
malcolmlewis 3
TOTAL: 5 53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.232 0.092 0.00423:56:25
60.234.68.122 1.104 0.120 0.03000:51:34
184-155-236-243.cpe.cableone.net 1.216 0.676 0.01800:47:59
agency.bbs.nz 28.636 6.836 0.00000:12:17
202.174.187.54 0.136 0.012 0.00000:10:02
118.149.136.116 0.076 0.004 0.00000:05:01
118.149.138.117 0.064 0.008 0.00000:05:00
vorlon.activateit.net.au 1.588 0.384 0.27700:04:48
avon.news.bbs.nz 0.256 0.060 0.01000:01:08
c-73-11-56-74.hsd1.or.comcast.net 1.228 0.260 0.00000:00:34
192.168.1.7 0.080 0.072 0.00300:00:06
? 1.228 0.156 0.00000:00:02
94.164.9.212 0.044 0.016 0.00000:00:01
TOTAL: 13 35.888 8.696 0.34226:15:05

Curious NNRP server explorers [Top 20]:

SystemConn
c-73-11-56-74.hsd1.or.comcast.net 24
avon.news.bbs.nz 4
67-60-219-146.cpe.cableone.net 3
202.174.187.54 2
118.149.138.117 1
118.149.136.116 1
94.164.9.212 1
TOTAL: 7 36

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 3
TOTAL: 1 3

Newsgroup request counts (by category):

CategoryCountPct
1rec 2382 24.4%
2comp 1452 14.9%
3uk 1447 14.8%
4soc 1107 11.3%
5sci 1060 10.9%
6linux 862 8.8%
7alt 444 4.6%
8misc 281 2.9%
9news 222 2.3%
10nz 177 1.8%
11talk 171 1.8%
12mozilla 57 0.6%
13us 31 0.3%
14agency 21 0.2%
15microsoft 17 0.2%
16humanities 14 0.1%
17aus 11 0.1%
TOTAL: 17 9756100.0%

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

NewsgroupCount
1rec.arts.tv 468
2rec.arts.drwho 468
3uk.d-i-y 438
4uk.legal 381
5uk.radio.amateur 300
6linux.debian.changes.devel 291
7comp.os.linux.advocacy 272
8linux.debian.bugs.dist 252
9soc.retirement 250
10rec.gambling.poker 220
11comp.lang.python 213
12sci.physics 201
13linux.debian.bugs.rc 184
14news.lists.filters 180
15alt.comp.os.windows-10 178
16nz.general 169
17comp.lang.c 164
18sci.med.cardiology 160
19sci.military.naval 139
20rec.sport.tennis 133
21sci.physics.relativity 125
22alt.conspiracy 116
23misc.health.alternative 111
24uk.rec.cars.maintenance 109
25sci.electronics.design 108
26soc.culture.polish 107
27rec.arts.sf.written 106
28rec.food.cooking 104
29soc.genealogy.medieval 99
30soc.culture.israel 97
31rec.radio.amateur.misc 84
32rec.boats 83
33sci.astro.amateur 76
34soc.penpals 73
35comp.lang.c++ 72
36misc.invest.stocks 69
37talk.politics.guns 66
38comp.sys.raspberry-pi 66
39soc.culture.indian 61
40comp.lang.ada 60
41sci.logic 57
42comp.internet.services.google 56
43rec.drugs.cannabis 55
44uk.rec.cycling 53
45comp.os.vms 52
46soc.culture.china 51
47talk.origins 51
48uk.tech.digital-tv 48
49sci.lang 45
50soc.history 43
51talk.politics.misc 42
52misc.survivalism 42
53rec.music.dylan 41
54comp.lang.forth 40
55uk.tech.broadcast 40
56comp.sys.mac.apps 38
57rec.sport.pro-wrestling 38
58uk.comp.sys.mac 38
59alt.politics.trump 38
60comp.lang.fortran 37
61rec.aviation.soaring 37
62rec.photo.digital 37
63rec.sport.soccer 36
64sci.math 33
65comp.sys.mac.system 33
66comp.protocols.time.ntp 32
67rec.music.classical.recordings 32
68sci.bio.paleontology 31
69misc.phone.mobile.iphone 31
70rec.woodworking 31
71soc.culture.usa 29
72us.politics.elections 28
73comp.ai.philosophy 28
74rec.collecting.sport.basketball 27
75alt.test 26
76soc.history.medieval 26
77comp.programming 26
78alt.conspiracy.jfk 25
79alt.comp.hardware 24
80soc.genealogy.britain 24
81soc.culture.vietnamese 24
82news.admin.net-abuse.email 24
83mozilla.support.thunderbird 23
84rec.bicycles.tech 22
85mozilla.support.firefox 22
86rec.sport.football.college 22
87comp.programming.threads 22
88soc.women 21
89rec.arts.sf.fandom 21
90comp.arch 21
91agency.test 21
92rec.games.backgammon 21
93soc.history.what-if 20
94linux.debian.user.french 20
95sci.anthropology.paleo 20
96soc.culture.greek 19
97rec.sport.golf 19
98comp.sys.apple2 18
99comp.mobile.ipad 18
100rec.arts.sf.tv 18
TOTAL: 335 9756