news.bbs.nz daily logs

Mar 25 23:58:02 -- Mar 26 23:58:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Mar 26 23:40:03 news controlchan[25006]: Multiple control headers in article <xFRER-2km-13@gated-at.bofh.it>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 129514 56.6%10.0 MB 35.1%
innfeed 44869 19.6%7.4 MB 25.9%
innd 31412 13.7%5.0 MB 17.5%
inn 21671 9.5%5.9 MB 20.7%
cnfsstat 1440 0.6%254.3 KB 0.9%
controlchan 2 0.0%0.3 KB 0.0%
TOTAL: 6 228908 100.0%28.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 257412 47.2%
Positive hits 250893 46.0%
Do not exist 20796 3.8%
Cache misses 16342 3.0%
TOTAL: 4 545443 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.084 0.0%98 0.000 0.857 13.000
article cleanup00:00:00.198 0.0%20983 0.000 0.009 0.039
article logging00:00:00.561 0.0%21411 0.000 0.026 0.126
article parse00:00:00.705 0.0%65614 0.000 0.011 0.025
article write00:00:01.512 0.0%17409 0.012 0.087 0.979
artlog/artcncl00:00:00.000 0.0%85 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.527 0.0%489182 0.000 0.001 0.012
hisgrep/artcncl00:00:00.000 0.0%87 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%98 0.000 0.010 0.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.591 0.0%548446 0.001 0.019 1.023
history sync00:00:00.013 0.0%376 0.000 0.035 1.000
history write00:00:06.792 0.0%20891 0.012 0.325 21.312
hiswrite/artcncl00:00:00.015 0.0%11 0.000 1.364 4.500
idle23:47:49.552 99.8%501114 99.430 170.958 439.683
nntp read00:00:03.117 0.0%500765 0.003 0.006 0.023
overview write00:00:41.925 0.0%17409 0.084 2.408 68.110
perl filter00:00:45.420 0.1%20853 1.401 2.178 8.975
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.971 0.0%34819 0.004 0.028 0.090
TOTAL: 23:50:47.27323:49:41.984 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%20363 0.000 0.002 0.015
article prepare00:00:00.000 0.0%6032 0.000 0.000 0.000
article read00:00:00.108 0.0%1242 0.000 0.087 4.455
backlog stats00:00:00.357 0.0%328151 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.790 0.0%265139 0.002 0.007 0.011
data write00:00:04.127 0.0%249962 0.006 0.017 0.044
idle23:52:46.171 99.9%328151 170.054 261.971 593.039
status file00:01:28.395 0.1%8619 1.138 10.256 511.443
TOTAL: 23:54:41.09123:54:20.996100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%9 0.000 0.000 0.000
idle01:08:11.914 14.4%135903 0.000 30.109 54799.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:30.292 0.3%288020 0.000 0.313 16.330
readart00:00:01.189 0.0%7319 0.000 0.162 29.000
TOTAL: 07:53:25.59601:09:43.395 14.7%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1bbs-nz-out.news.weretis.net 4 37524 4012 33209 303 10%50:06:06
2news-out.aioe.org 3 17512 2497 14959 56 14%25:13:55
3news.snarked.org 32 14608 2309 12107 192 15%29:52:18
4news.redatomik.org 4 17091 2248 14761 82 13%24:26:55
5feeder.eternal-september.org 4 19554 2019 17138 397 10%24:26:17
6bbsnz-out.feed.uzoreto.com 864 33495 1947 30039 1509 5%71:11:14
7newsfeed.neva.ru 149 9353 897 7583 873 9%72:04:11
8i2pn.org 3 22428 880 21503 45 3%30:03:23
9newsfeed.xs3.de 2 17227 248 16893 86 1%23:23:10
10csiph.com 2 16980 233 16727 20 1%23:59:53
11news.swapon.de 3 1662 157 1500 5 9%22:44:18
12paganini.bofh.team 1 18343 101 18220 22 0%22:23:41
13news.samoylyk.net 1 40985 40 40943 2 0%19:34:10
14localhost 6 5 5 0 0 100%00:00:01
15news.freedyn.net 146 19397 0 19372 25 0%00:38:45
16nut.utcc.utoronto.ca 1 16448 0 16448 0 0%23:50:00
TOTAL: 16 1225 302612 17593 281402 3617 5%463:58:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net18.5 MB102.0 KB2.5 MB21.2 MB 87%5.0 KB
2news.snarked.org7.4 MB22.8 KB1.5 MB8.9 MB 83%3.6 KB
3news-out.aioe.org6.4 MB18.3 KB430.4 KB6.8 MB 93%2.7 KB
4news.redatomik.org6.2 MB18.1 KB164.7 KB6.4 MB 97%2.8 KB
5bbsnz-out.feed.uzoreto.com5.7 MB231.0 KB14.4 MB20.3 MB 28%6.0 KB
6feeder.eternal-september.org5.5 MB22.5 KB2.2 MB7.8 MB 70%3.3 KB
7i2pn.org4.5 MB31.2 KB120.7 KB4.7 MB 96%5.2 KB
8newsfeed.neva.ru2.5 MB8.5 KB3.5 MB6.0 MB 41%3.4 KB
9newsfeed.xs3.de1.1 MB34.5 KB139.1 KB1.3 MB 87%4.0 KB
10csiph.com542.1 KB23.4 KB41.2 KB606.7 KB 89%2.4 KB
11news.swapon.de383.6 KB2.2 KB168.0 KB553.8 KB 69%3.4 KB
12paganini.bofh.team235.0 KB14.7 KB969.5 KB1.2 MB 19%9.9 KB
13news.samoylyk.net110.0 KB4.0 KB4.0 KB117.9 KB 93%2.8 KB
14localhost29.5 KB0.0 KB0.0 KB29.5 KB100%5.9 KB
15news.freedyn.net0.0 KB0.0 KB2.6 MB2.6 MB 0%105.3 KB
16nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1659.2 MB533.2 KB28.7 MB88.4 MB 66%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 25 23:58:02 - 23:59:59 30 0.2% 0.2566.0 KB 0.1% 0.56
Mar 26 00:00:00 - 00:59:59 861 4.9% 0.242.5 MB 4.3% 0.72
Mar 26 01:00:00 - 01:59:59 801 4.6% 0.222.8 MB 4.7% 0.78
Mar 26 02:00:00 - 02:59:59 918 5.2% 0.262.6 MB 4.4% 0.73
Mar 26 03:00:00 - 03:59:59 998 5.7% 0.283.4 MB 5.8% 0.97
Mar 26 04:00:00 - 04:59:59 1005 5.7% 0.283.3 MB 5.6% 0.94
Mar 26 05:00:00 - 05:59:59 974 5.5% 0.273.3 MB 5.6% 0.94
Mar 26 06:00:00 - 06:59:59 933 5.3% 0.263.9 MB 6.7% 1.12
Mar 26 07:00:00 - 07:59:59 1062 6.0% 0.292.9 MB 5.0% 0.83
Mar 26 08:00:00 - 08:59:59 1064 6.1% 0.304.6 MB 7.7% 1.30
Mar 26 09:00:00 - 09:59:59 820 4.7% 0.232.8 MB 4.8% 0.80
Mar 26 10:00:00 - 10:59:59 836 4.8% 0.232.3 MB 3.9% 0.66
Mar 26 11:00:00 - 11:59:59 716 4.1% 0.202.6 MB 4.4% 0.74
Mar 26 12:00:00 - 12:59:59 569 3.2% 0.161.6 MB 2.8% 0.46
Mar 26 13:00:00 - 13:59:59 506 2.9% 0.141.5 MB 2.6% 0.43
Mar 26 14:00:00 - 14:59:59 429 2.4% 0.121.2 MB 2.1% 0.35
Mar 26 15:00:00 - 15:59:59 437 2.5% 0.122.0 MB 3.3% 0.56
Mar 26 16:00:00 - 16:59:59 419 2.4% 0.122.1 MB 3.6% 0.59
Mar 26 17:00:00 - 17:59:59 304 1.7% 0.08988.7 KB 1.6% 0.27
Mar 26 18:00:00 - 18:59:59 361 2.1% 0.101.2 MB 2.0% 0.33
Mar 26 19:00:00 - 19:59:59 506 2.9% 0.141.4 MB 2.4% 0.40
Mar 26 20:00:00 - 20:59:59 523 3.0% 0.151.5 MB 2.6% 0.44
Mar 26 21:00:00 - 21:59:59 798 4.5% 0.222.2 MB 3.7% 0.62
Mar 26 22:00:00 - 22:59:59 852 4.9% 0.242.2 MB 3.8% 0.63
Mar 26 23:00:00 - 23:58:02 835 4.8% 0.243.9 MB 6.6% 1.14
TOTAL: 24:00:00 17557 100.0% 0.2058.8 MB 100.0% 0.70
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB32.7 GB 65.3% 0 0.28 2154.05
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB37.4 GB 74.8% 0 0.31 1937.38
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB387.4 MB 0.8% 0 0.0413487.36
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 GB35.6 GB 71.2% 0 0.58 1053.90
TOTAL: 10-500.0 GB106.1 GB 21.2% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1bbsnz-out.feed.uzoreto.com 1513 20 0 9 0 0 0 0 1484
2newsfeed.neva.ru 873 27 0 4 0 0 0 0 842
3feeder.eternal-september.org 401 0 0 8 0 0 0 0 393
4news.redatomik.org 395 0 0 7 0 0 0 0 388
5bbs-nz-out.news.weretis.net 325 69 0 18 0 0 0 0 238
6news.snarked.org 201 10 0 8 0 0 0 0 183
7newsfeed.xs3.de 86 0 0 9 0 0 0 0 77
8news-out.aioe.org 77 41 0 6 0 0 0 0 30
9news.swapon.de 54 0 0 1 0 0 0 0 53
10i2pn.org 38 2 0 7 0 0 0 0 29
11news.freedyn.net 25 0 0 0 0 0 0 0 25
12paganini.bofh.team 20 9 0 6 0 0 0 0 5
13csiph.com 16 0 0 6 0 0 0 0 10
14news.samoylyk.net 4 0 0 3 0 0 0 0 1
TOTAL: 14 4028 178 0 92 0 0 0 0 3758

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 30
gmane.linux.kernel 26
gmane.comp.gis.openstreetmap.tagging 24
mozilla.dev.security.policy 13
mozilla.dev.servo 10
mozilla.dev.platform 7
gmane.linux.kernel.stable 7
mozilla.test 6
mozilla.dev.ui-alerts 5
de.alt.dateien.misc 4
mozilla.support.seamonkey 4
mozilla.governance 3
mozilla.compatibility 3
alt.music.pink-floyd.publius 3
alt.anybod 2
gmane.comp.gis.openstreetmap.geocoding 2
gmane.comp.video.dri.devel 1
ampr.bbs.agcw 1
mozilla.dev.l10n 1
dnet.ham 1
TOTAL: 45 178

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2848
EMP (phn path) 181
Too many newsgroups 70
EMP (phn nph) 68
EMP (phl) 55
Binary: misplaced rar 25
User-issued cancel 18
Binary: non-binary distribution 16
User-issued spam cancel 5
Cancel for rejected article 2
Binary: misplaced nzb 1
TOTAL: 11 3289

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
bbsnz-out.feed.uzoreto.com 1
TOTAL: 1 1
Including strange strings
news.redatomik.org 315
news.swapon.de 49
bbs-nz-out.news.weretis.net 36
news-out.aioe.org 22
bbsnz-out.feed.uzoreto.com 5
news.samoylyk.net 1
i2pn.org 1
newsfeed.neva.ru 1
TOTAL: 8 430
TOTAL: 2 431

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16260 713 15525 21 1 13 4%24:00:05
2utnut 17557 471 16866 219 1 0 2%23:59:54
3awxg 17225 39 17179 3 0 0 0%24:00:15
4paganini.bofh.team 17398 5 17391 0 0 1 0%24:00:06
5news.snarked.org 15023 5 14970 4 0 9 0%24:00:32
6neva.ru 16233 4 16226 1 0 0 0%24:00:13
7weretis.net 12699 4 12674 0 0 44 0%24:00:21
8i2pn.org 16660 4 16652 2 0 0 0%24:00:13
9news.samoylyk.net 16231 3 16207 2 0 12 0%24:00:07
10news.redatomik.org 15182 3 15176 2 0 5 0%24:00:00
11csiph.com 17336 3 17316 2 0 0 0%24:00:31
12aioe 14276 3 14218 2 0 0 0%23:59:48
13eternal-september 15151 3 15141 2 0 0 0%24:00:11
14newsfeed.xs3.de 17260 2 17235 2 0 56 0%24:00:13
15news.swapon.de 1589 1 1588 0 0 0 0%23:36:22
16news.freedyn.net 0 0 0 0 0 17544 0%24:00:01
17news.uzoreto.com 15152 0 15144 5 0 0 0%24:00:33
18news.albasani.net 2755 0 0 0 0 2756 0%24:00:13
TOTAL: 18 243987 1263 239508 267 2 20440 0%431:39:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org10.3 MB177.7 KB10.5 MB0.1 KB/s14.6 KB24:00:05
2utnut10.3 MB1.0 MB11.3 MB0.1 KB/s16.7 KB23:59:54
3awxg166.2 KB14.0 KB180.2 KB0.0 KB/s4.3 KB24:00:15
4news.snarked.org30.7 KB9.2 KB39.9 KB0.0 KB/s4.4 KB24:00:32
5i2pn.org29.8 KB1.5 KB31.4 KB0.0 KB/s5.2 KB24:00:13
6paganini.bofh.team29.5 KB0.0 KB29.5 KB0.0 KB/s5.9 KB24:00:06
7news.samoylyk.net28.0 KB1.5 KB29.5 KB0.0 KB/s5.9 KB24:00:07
8news.redatomik.org28.0 KB1.5 KB29.5 KB0.0 KB/s5.9 KB24:00:00
9csiph.com28.0 KB1.5 KB29.5 KB0.0 KB/s5.9 KB24:00:31
10aioe28.0 KB1.5 KB29.5 KB0.0 KB/s5.9 KB23:59:48
11eternal-september28.0 KB1.5 KB29.5 KB0.0 KB/s5.9 KB24:00:11
12neva.ru4.0 KB25.4 KB29.5 KB0.0 KB/s5.9 KB24:00:13
13weretis.net4.0 KB0.0 KB4.0 KB0.0 KB/s1.0 KB24:00:21
14newsfeed.xs3.de2.5 KB1.5 KB4.0 KB0.0 KB/s1.0 KB24:00:13
15news.swapon.de1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:36:22
16news.freedyn.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
17news.uzoreto.com0.0 KB29.5 KB29.5 KB0.0 KB/s5.9 KB24:00:33
18news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:13
TOTAL: 1821.0 MB1.3 MB22.2 MB0.0 KB/s14.9 KB431:39:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 553619.5 MB 3254 3 000:14:40
2vorlon.activateit.net.au 24 9781.4 MB 142 0 000:05:08
3amigacity.xyz 70 2396.2 MB 93 0 000:32:06
4121.99.184.11 8 1658.3 KB 3 1 000:19:05
5avon.news.bbs.nz 16 33.4 KB 3 1 006:34:57
6118.149.164.69 9 21.5 KB 0 0 000:07:08
TOTAL: 6 514 677427.2 MB 3495 5 007:53:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 553619.5 MB 3254 3 000:14:40
2*.activateit.net.au 24 9781.4 MB 142 0 000:05:08
3*.xyz 70 2396.2 MB 93 0 000:32:06
4unresolved 18 1859.8 KB 3 1 000:26:23
5*.news.bbs.nz 16 33.4 KB 3 1 006:34:57
TOTAL: 5 515 677427.2 MB 3495 5 007:53:18

NNRP auth users [Top 20]:

UserConn
amigacity 70
amybbs 24
paulh 16
crash 7
TOTAL: 4 117

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
avon.news.bbs.nz 1.132 0.168 0.08906:34:57
amigacity.xyz 3.720 1.056 0.33600:32:06
121.99.184.11 0.524 0.084 0.01900:19:05
agency.bbs.nz 27.728 6.412 0.00000:14:40
118.149.164.69 0.524 0.096 0.00000:07:08
vorlon.activateit.net.au 1.324 0.444 0.09100:05:08
107.170.196.14 0.048 0.012 0.00000:00:09
? 1.092 0.128 0.00000:00:01
TOTAL: 8 36.092 8.400 0.53507:53:18

Curious NNRP server explorers [Top 20]:

SystemConn
107.170.196.14 1
TOTAL: 1 1

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
121.99.184.11 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 2523 37.3%
2comp 989 14.6%
3uk 675 10.0%
4soc 654 9.7%
5sci 587 8.7%
6linux 422 6.2%
7alt 393 5.8%
8talk 257 3.8%
9misc 92 1.4%
10news 92 1.4%
11mozilla 38 0.6%
12agency 11 0.2%
13nz 11 0.2%
14humanities 10 0.1%
15microsoft 8 0.1%
16aus 4 0.1%
TOTAL: 16 6766100.0%

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

NewsgroupCount
1rec.arts.tv 666
2uk.d-i-y 242
3rec.arts.drwho 215
4rec.games.miniatures.misc 210
5uk.legal 190
6comp.lang.c 187
7rec.gambling.poker 173
8rec.sport.football.college 166
9talk.politics.guns 151
10linux.debian.bugs.dist 146
11alt.comp.os.windows-10 144
12alt.politics.trump 143
13rec.arts.sf.written 135
14rec.food.cooking 131
15sci.electronics.design 131
16comp.lang.python 121
17rec.boats 110
18soc.culture.israel 102
19soc.culture.polish 96
20soc.culture.china 95
21comp.os.linux.advocacy 94
22uk.legal.moderated 93
23talk.origins 90
24sci.math 88
25news.lists.filters 85
26sci.physics 84
27comp.lang.c++ 78
28uk.radio.amateur 76
29soc.retirement 76
30comp.mobile.android 64
31rec.sport.pro-wrestling 64
32comp.sys.raspberry-pi 60
33rec.sport.tennis 60
34linux.debian.bugs.rc 57
35rec.audio.opinion 57
36linux.debian.changes.devel 56
37rec.bicycles.tech 55
38sci.physics.relativity 52
39soc.culture.usa 47
40sci.logic 45
41rec.photo.digital 44
42sci.med.pharmacy 43
43comp.os.vms 40
44linux.debian.user 38
45sci.lang 34
46alt.conspiracy.jfk 33
47uk.tech.broadcast 31
48sci.med.cardiology 30
49rec.aviation.soaring 30
50alt.test 29
51misc.survivalism 27
52sci.electronics.repair 27
53rec.sport.golf 26
54comp.arch 25
55rec.music.classical.recordings 24
56soc.culture.haiti 24
57rec.arts.sf.tv 24
58soc.culture.brazil 23
59comp.sys.mac.system 22
60comp.sys.apple2 21
61soc.penpals 21
62linux.debian.vote 21
63alt.conspiracy 20
64comp.lang.forth 20
65rec.music.dylan 19
66rec.music.filk 19
67soc.culture.german 18
68rec.arts.sf.fandom 17
69rec.sport.soccer 17
70misc.invest.misc 16
71uk.comp.sys.mac 16
72comp.lang.ada 16
73misc.news.internet.discuss 16
74linux.debian.l10n.french 16
75mozilla.general 15
76soc.culture.esperanto 15
77rec.music.rock-pop-r+b.1950s 15
78comp.sys.cbm 15
79linux.debian.user.french 14
80comp.ai.philosophy 14
81comp.lang.javascript 14
82alt.bbs.synchronet 13
83rec.audio.pro 13
84soc.history 13
85rec.sport.cricket 12
86linux.debian.devel.release 12
87mozilla.support.firefox 12
88comp.lang.tcl 12
89nz.general 11
90rec.games.pinball 11
91mozilla.support.thunderbird 11
92sci.military.naval 11
93comp.os.linux.misc 10
94rec.radio.shortwave 10
95rec.autos.sport.f1 10
96comp.lang.clipper.visual-objects 10
97agency.test 10
98soc.genealogy.medieval 10
99rec.gambling.lottery 10
100humanities.lit.authors.shakespeare 10
TOTAL: 328 6766