news.bbs.nz daily logs

Apr 29 23:58:01 -- Apr 30 23:58:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 30 00:40:03 news controlchan[22184]: Unknown "block" control by robomod@news.nic.it
Apr 30 00:40:04 news controlchan[22184]: Unknown "block" control by robomod@news.nic.it
Apr 30 00:50:02 news controlchan[22184]: Unknown "block" control by robomod@news.nic.it

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 130360 63.7%10.2 MB 41.4%
innd 26840 13.1%4.4 MB 17.8%
innfeed 23227 11.3%4.5 MB 18.3%
inn 22803 11.1%5.3 MB 21.5%
cnfsstat 1440 0.7%250.9 KB 1.0%
controlchan 4 0.0%0.4 KB 0.0%
TOTAL: 6 204674 100.0%24.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 242503 52.1%
Positive hits 201057 43.2%
Do not exist 21634 4.6%
Cache misses 106 0.0%
TOTAL: 4 465300 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.141 0.0%146 0.000 0.966 17.000
article cleanup00:00:00.230 0.0%22109 0.000 0.010 0.041
article logging00:00:00.622 0.0%22710 0.000 0.027 0.081
article parse00:00:00.617 0.0%56445 0.000 0.011 0.032
article write00:00:01.377 0.0%17566 0.012 0.078 0.983
artlog/artcncl00:00:00.000 0.0%139 0.000 0.000 0.000
data move00:00:00.441 0.0%463493 0.000 0.001 0.015
hisgrep/artcncl00:00:00.000 0.0%139 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%146 0.000 0.007 0.077
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.376 0.0%471026 0.001 0.014 1.035
history sync00:00:00.020 0.0%373 0.000 0.054 0.500
history write00:00:04.298 0.0%21877 0.000 0.196 14.557
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle23:58:07.828 99.8%470045 102.836 183.574 499.424
nntp read00:00:03.363 0.0%470897 0.003 0.007 0.013
overview write00:00:41.958 0.0%17566 0.062 2.389 98.145
perl filter00:00:39.134 0.0%21874 1.110 1.789 7.829
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.864 0.0%35135 0.000 0.025 0.092
TOTAL: 24:00:56.50723:59:47.270 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%23366 0.000 0.002 0.023
article prepare00:00:00.000 0.0%3992 0.000 0.000 0.000
article read00:00:00.172 0.0%901 0.000 0.191 10.545
backlog stats00:00:00.385 0.0%261924 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.052 0.0%220330 0.002 0.009 0.021
data write00:00:02.711 0.0%203010 0.005 0.013 0.025
idle23:55:29.630100.0%261924 199.544 328.834 826.404
status file00:00:12.562 0.0%1883 0.400 6.671 276.750
TOTAL: 23:56:07.38423:55:47.560100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%23 0.000 0.000 0.000
idle22:49:52.866 98.5%141228 0.000 581.987 75337.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:14.615 0.0%305542 0.000 0.048 1.647
readart00:00:02.584 0.0%11472 0.000 0.225 15.000
TOTAL: 23:11:20.08722:50:10.065 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 3 18153 5090 13038 25 28%25:12:41
2news-out.mixmin.net 9 18971 3867 14297 807 20%28:08:03
3feeder.eternal-september.org 10 20318 2160 17304 854 10%26:12:35
4news-out.aioe.org 4 17850 2059 15626 165 11%24:20:09
5newsfeed.datemas.de 3 18565 2042 15969 554 10%23:59:09
6newsfeed.neva.ru 154 8413 1185 5366 1862 14%80:23:55
7news.redatomik.org 0 14294 582 13694 18 4%21:23:48
8news.swapon.de 3 1407 177 1227 3 12%22:51:15
9feeder.awxg.com 2 13969 100 13856 13 0%23:59:26
10agency-nz-out.news.mb-net.net 8 18851 88 18690 73 0%26:21:40
11news.albasani.net 1 18233 81 18092 60 0%23:34:59
12news.samoylyk.net 2 16079 79 15988 12 0%23:59:57
13news.freedyn.net 1 17851 51 17712 88 0%22:26:41
14localhost 8 7 6 0 1 85%00:00:00
TOTAL: 14 208 202961 17567 180859 4535 8%372:54:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph.com15.3 MB164.3 KB197.1 KB15.6 MB 97%3.1 KB
2news-out.mixmin.net10.4 MB97.8 KB1.4 MB12.0 MB 87%2.6 KB
3newsfeed.datemas.de7.1 MB483.1 KB2.1 MB9.6 MB 73%3.8 KB
4feeder.eternal-september.org6.5 MB140.4 KB10.7 MB17.3 MB 37%5.9 KB
5news-out.aioe.org5.2 MB69.4 KB628.4 KB5.9 MB 88%2.7 KB
6newsfeed.neva.ru3.5 MB140.1 KB5.8 MB9.5 MB 37%3.2 KB
7news.redatomik.org2.0 MB38.1 KB50.3 KB2.1 MB 95%3.6 KB
8news.albasani.net981.5 KB135.9 KB217.8 KB1.3 MB 73%9.5 KB
9news.freedyn.net827.7 KB26.7 KB278.2 KB1.1 MB 73%8.1 KB
10news.swapon.de550.8 KB10.8 KB13.6 KB575.2 KB 95%3.2 KB
11news.samoylyk.net510.7 KB29.4 KB592.7 KB1.1 MB 45%12.4 KB
12agency-nz-out.news.mb-net.net306.5 KB209.3 KB595.5 KB1.1 MB 27%6.9 KB
13feeder.awxg.com292.2 KB35.7 KB39.8 KB367.6 KB 79%3.3 KB
14localhost13.3 KB0.0 KB2.2 KB15.5 KB 86%2.2 KB
TOTAL: 1453.4 MB1.5 MB22.6 MB77.6 MB 68%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 29 23:58:01 - 23:59:59 21 0.1% 0.1850.5 KB 0.1% 0.42
Apr 30 00:00:00 - 00:59:59 742 4.2% 0.212.0 MB 3.7% 0.56
Apr 30 01:00:00 - 01:59:59 817 4.7% 0.232.2 MB 4.2% 0.63
Apr 30 02:00:00 - 02:59:59 902 5.1% 0.252.4 MB 4.5% 0.68
Apr 30 03:00:00 - 03:59:59 901 5.1% 0.252.8 MB 5.2% 0.79
Apr 30 04:00:00 - 04:59:59 974 5.6% 0.272.7 MB 5.1% 0.77
Apr 30 05:00:00 - 05:59:59 1046 6.0% 0.292.7 MB 5.1% 0.78
Apr 30 06:00:00 - 06:59:59 964 5.5% 0.272.9 MB 5.5% 0.84
Apr 30 07:00:00 - 07:59:59 977 5.6% 0.272.9 MB 5.4% 0.81
Apr 30 08:00:00 - 08:59:59 905 5.2% 0.253.6 MB 6.8% 1.02
Apr 30 09:00:00 - 09:59:59 732 4.2% 0.202.4 MB 4.5% 0.68
Apr 30 10:00:00 - 10:59:59 616 3.5% 0.171.9 MB 3.6% 0.54
Apr 30 11:00:00 - 11:59:59 693 4.0% 0.192.6 MB 4.9% 0.74
Apr 30 12:00:00 - 12:59:59 352 2.0% 0.101.1 MB 2.0% 0.30
Apr 30 13:00:00 - 13:59:59 372 2.1% 0.101.3 MB 2.4% 0.37
Apr 30 14:00:00 - 14:59:59 425 2.4% 0.121.4 MB 2.7% 0.41
Apr 30 15:00:00 - 15:59:59 376 2.1% 0.101.3 MB 2.5% 0.38
Apr 30 16:00:00 - 16:59:59 508 2.9% 0.142.0 MB 3.7% 0.56
Apr 30 17:00:00 - 17:59:59 560 3.2% 0.161.7 MB 3.3% 0.49
Apr 30 18:00:00 - 18:59:59 544 3.1% 0.151.6 MB 3.1% 0.47
Apr 30 19:00:00 - 19:59:59 706 4.0% 0.202.0 MB 3.8% 0.57
Apr 30 20:00:00 - 20:59:59 778 4.4% 0.222.1 MB 3.9% 0.59
Apr 30 21:00:00 - 21:59:59 915 5.2% 0.252.3 MB 4.3% 0.64
Apr 30 22:00:00 - 22:59:59 880 5.0% 0.242.4 MB 4.5% 0.67
Apr 30 23:00:00 - 23:58:01 823 4.7% 0.242.7 MB 5.1% 0.79
TOTAL: 24:00:00 17529 100.0% 0.2052.9 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB25.4 GB 50.9% 0 0.27 2258.19
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB29.4 GB 58.7% 0 0.26 2341.36
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB321.4 MB 0.6% 0 0.0322857.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.9% 0 0.55 1093.97
TOTAL: 10-500.0 GB75.6 GB 15.1% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1849 78 0 25 0 0 0 0 1746
2news-out.mixmin.net 1210 0 0 22 0 0 0 0 1188
3feeder.eternal-september.org 856 0 0 29 0 0 0 0 827
4newsfeed.datemas.de 632 44 0 19 0 0 0 0 569
5news-out.aioe.org 191 48 0 19 0 0 0 0 124
6news.freedyn.net 98 2 0 12 0 0 0 0 84
7news.albasani.net 72 2 0 17 0 0 0 0 53
8agency-nz-out.news.mb-net.net 71 11 0 20 0 0 0 0 40
9news.swapon.de 50 0 0 1 0 0 0 0 49
10news.redatomik.org 38 0 0 14 0 0 0 0 24
11csiph.com 26 0 0 20 0 0 0 0 6
12feeder.awxg.com 21 0 0 15 0 0 0 0 6
13news.samoylyk.net 18 0 0 17 0 0 0 0 1
14news.ausics.org 2 0 0 2 0 0 0 0 0
15localhost 1 0 0 0 0 0 0 0 1
TOTAL: 15 5135 185 0 232 0 0 0 0 4718

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.x11 35
gmane.linux.alsa.devel 30
gmane.comp.gis.openstreetmap.tagging 25
mozilla.support.seamonkey 15
mozilla.test 10
mpc.lists.freebsd.wireless 10
gmane.linux.kernel 10
mpc.lists.freebsd.gecko 7
mozilla.dev.platform 6
south-wales.test 3
mpc.lists.freebsd.gnome 3
eagle.support.eng 2
mozilla.support.calendar 2
mozilla.dev.ui-alerts 2
mozilla.dev.security.policy 2
mozilla.addons.chromebug 2
mozilla.support.bugzilla 2
a.business.internet 1
alt.sex.fencingo 1
mozilla.dev.quality 1
TOTAL: 36 185

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3719
EMP (phn path) 169
EMP (phn nph) 109
EMP (phl) 56
User-issued cancel 24
Too many newsgroups 20
Binary: non-binary distribution 7
Binary: misplaced par2 3
U2 violation - invalid distribution 1
Binary: misplaced 250 1
Binary Image: misplaced jpg 1
Too many newsgroups (meow) 1
User-issued spam cancel 1
Cancel for rejected article 1
Binary: misplaced 231 1
TOTAL: 15 4114

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.albasani.net 3
TOTAL: 1 3
Including strange strings
news-out.mixmin.net 416
newsfeed.datemas.de 79
news.swapon.de 43
news-out.aioe.org 21
news.redatomik.org 17
newsfeed.neva.ru 13
news.albasani.net 6
feeder.eternal-september.org 4
feeder.awxg.com 2
TOTAL: 9 601
TOTAL: 2 604

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 15899 280 15610 9 0 0 1%23:59:45
2awxg 17055 28 17023 3 0 31 0%23:59:40
3aioe 14344 9 14276 0 0 0 0%23:59:43
4news.freedyn.net 17605 7 17480 0 0 14 0%23:59:44
5csiph.com 12642 7 12528 1 0 0 0%23:59:44
6eternal-september 15021 6 14955 0 0 48 0%23:59:43
7news.redatomik.org 16795 6 16775 0 0 0 0%23:59:44
8neva.ru 16139 5 16125 1 0 0 0%23:59:44
9news-in.mixmin.net 13317 4 13245 1 0 88 0%23:59:44
10news.samoylyk.net 15901 3 15815 0 0 81 0%23:59:30
11mb-net.net 17490 3 17420 1 0 121 0%23:59:20
12news.albasani.net 18110 1 16089 539 0 5321 0%23:59:43
13news.snarked.org 0 0 0 0 0 17472 0%23:59:45
14news.swapon.de 1280 0 1270 0 0 10 0%23:56:15
15newsfeed.datemas.de 15682 0 15559 1 0 209 0%23:59:44
TOTAL: 15 207280 359 204170 556 0 23395 0%359:51:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org2.0 MB174.7 KB2.2 MB0.0 KB/s7.8 KB23:59:45
2awxg200.6 KB8.6 KB209.2 KB0.0 KB/s6.7 KB23:59:40
3aioe19.0 KB0.0 KB19.0 KB0.0 KB/s2.1 KB23:59:43
4news.freedyn.net16.8 KB0.0 KB16.8 KB0.0 KB/s2.4 KB23:59:44
5csiph.com14.6 KB15.2 KB29.8 KB0.0 KB/s3.7 KB23:59:44
6eternal-september13.3 KB0.0 KB13.3 KB0.0 KB/s2.2 KB23:59:43
7news.redatomik.org13.3 KB0.0 KB13.3 KB0.0 KB/s2.2 KB23:59:44
8neva.ru10.1 KB3.2 KB13.3 KB0.0 KB/s2.2 KB23:59:44
9news-in.mixmin.net9.9 KB2.0 KB11.9 KB0.0 KB/s2.4 KB23:59:44
10news.samoylyk.net6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:59:30
11mb-net.net6.7 KB2.1 KB8.8 KB0.0 KB/s2.2 KB23:59:20
12news.albasani.net3.2 KB2.2 MB2.2 MB0.0 KB/s4.2 KB23:59:43
13news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:15
15newsfeed.datemas.de0.0 KB2.0 KB2.0 KB0.0 KB/s2.0 KB23:59:44
TOTAL: 152.3 MB2.4 MB4.7 MB0.0 KB/s5.3 KB359:51:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 613120.0 MB 3428 2 000:13:20
2184-155-236-243.cpe.cableone.net 8 333711.6 MB 620 3 1800:50:58
3vorlon.activateit.net.au 24 10681.4 MB 137 0 000:05:07
460.234.68.122 6 49256.0 KB 1 0 000:25:45
567-60-219-146.cpe.cableone.net 7 23.2 KB 4 1 021:15:49
TOTAL: 5 432 1058733.4 MB 4190 6 1823:11:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 613120.0 MB 3428 2 000:13:20
2*.cpe.cableone.net 15 333911.6 MB 624 4 1822:06:48
3*.activateit.net.au 24 10681.4 MB 137 0 000:05:07
4unresolved 12 49256.0 KB 1 0 000:45:23
5*.hsd1.or.comcast.net 24 00.0 KB 0 0 000:00:32
TOTAL: 5 462 1058733.4 MB 4190 6 1823:11:13

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 7
crash 5
TOTAL: 4 44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.408 0.124 0.01621:15:49
184-155-236-243.cpe.cableone.net 1.316 0.736 0.01400:50:58
60.234.68.122 0.420 0.084 0.00700:25:45
agency.bbs.nz 29.468 6.920 0.00000:13:20
118.149.178.197 0.120 0.012 0.00000:09:27
vorlon.activateit.net.au 1.492 0.444 0.18400:05:07
118.149.249.236 0.052 0.020 0.00000:05:01
118.149.248.197 0.064 0.004 0.00000:05:01
c-73-11-56-74.hsd1.or.comcast.net 1.248 0.236 0.00000:00:32
94.166.109.28 0.056 0.004 0.00000:00:06
? 0.964 0.108 0.00000:00:01
TOTAL: 11 35.608 8.692 0.22123:11:13

Curious NNRP server explorers [Top 20]:

SystemConn
c-73-11-56-74.hsd1.or.comcast.net 24
118.149.249.236 2
118.149.178.197 2
118.149.248.197 1
94.166.109.28 1
TOTAL: 5 30

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 2471 23.4%
2uk 1765 16.7%
3soc 1366 12.9%
4comp 1278 12.1%
5linux 1016 9.6%
6sci 924 8.7%
7alt 585 5.5%
8misc 387 3.7%
9news 337 3.2%
10talk 161 1.5%
11mozilla 105 1.0%
12nz 74 0.7%
13microsoft 42 0.4%
14agency 26 0.2%
15humanities 16 0.2%
16us 12 0.1%
17aus 4 0.0%
18free 1 0.0%
TOTAL: 18 10570100.0%

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

NewsgroupCount
1rec.arts.tv 695
2uk.d-i-y 628
3uk.legal 473
4rec.arts.drwho 384
5soc.retirement 328
6uk.radio.amateur 308
7linux.debian.bugs.dist 290
8linux.debian.changes.devel 287
9comp.os.linux.advocacy 286
10soc.penpals 224
11rec.arts.sf.written 211
12rec.sport.tennis 199
13alt.comp.os.windows-10 198
14sci.physics 183
15news.admin.net-abuse.email 178
16news.lists.filters 150
17uk.tech.digital-tv 147
18sci.med.cardiology 145
19misc.survivalism 144
20linux.debian.bugs.rc 134
21alt.comp.hardware 129
22comp.lang.python 118
23soc.culture.polish 117
24rec.food.cooking 116
25rec.gambling.poker 106
26sci.physics.relativity 100
27comp.lang.c 98
28soc.culture.usa 98
29uk.rec.cars.maintenance 87
30comp.lang.ada 86
31rec.boats 85
32comp.sys.raspberry-pi 78
33soc.culture.china 78
34alt.conspiracy 78
35talk.politics.guns 77
36sci.electronics.design 77
37nz.general 74
38comp.lang.c++ 73
39soc.culture.israel 69
40rec.drugs.cannabis 68
41sci.logic 67
42comp.sys.mac.system 67
43comp.os.vms 66
44linux.debian.user 66
45sci.lang 62
46sci.military.naval 59
47alt.politics.trump 59
48mozilla.support.firefox 58
49soc.genealogy.medieval 57
50misc.phone.mobile.iphone 57
51misc.health.alternative 54
52sci.astro.amateur 54
53talk.origins 53
54soc.history 52
55sci.math 42
56misc.taxes 42
57misc.invest.stocks 41
58soc.women 40
59rec.music.classical.recordings 36
60alt.books.reviews 35
61uk.rec.cycling 34
62rec.autos.sport.f1 34
63comp.protocols.time.ntp 32
64comp.lang.forth 32
65alt.test 32
66rec.sport.pro-wrestling 31
67rec.aviation.soaring 31
68sci.med.pharmacy 30
69soc.genealogy.britain 29
70mozilla.support.thunderbird 29
71rec.sport.soccer 29
72linux.debian.devel.mentors 28
73comp.lang.javascript 28
74microsoft.public.windowsxp.general 27
75linux.debian.kernel 27
76uk.legal.moderated 27
77rec.arts.sf.fandom 26
78rec.sport.football.college 26
79agency.test 26
80comp.lang.cobol 26
81talk.politics.misc 26
82rec.bicycles.tech 26
83sci.bio.paleontology 25
84rec.radio.amateur.misc 23
85comp.misc 23
86soc.culture.singapore 23
87comp.arch 22
88rec.games.backgammon 22
89rec.outdoors.rv-travel 22
90rec.games.trivia 21
91comp.text.tex 21
92soc.culture.brazil 20
93alt.conspiracy.jfk 20
94sci.crypt 20
95linux.debian.devel 19
96uk.comp.sys.mac 19
97rec.music.dylan 19
98mozilla.general 18
99soc.culture.indian 18
100comp.lang.fortran 16
TOTAL: 362 10570