news.bbs.nz daily logs

Oct 14 23:58:02 -- Oct 15 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 163179 67.7%13.2 MB 46.4%
innd 31438 13.0%5.1 MB 18.1%
innfeed 24604 10.2%4.9 MB 17.3%
inn 20482 8.5%4.9 MB 17.4%
cnfsstat 1440 0.6%256.3 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 241144 100.0%28.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 251319 48.3%
Positive hits 248772 47.8%
Do not exist 19710 3.8%
Cache misses 171 0.0%
TOTAL: 4 519972 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.265 0.0%56 0.000 4.732 28.000
article cleanup00:00:00.183 0.0%20017 0.000 0.009 0.049
article logging00:00:00.636 0.0%20429 0.000 0.031 0.719
article parse00:00:00.644 0.0%60157 0.000 0.011 0.035
article write00:00:01.155 0.0%15916 0.000 0.073 0.536
artlog/artcncl00:00:00.000 0.0%56 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.455 0.0%501415 0.000 0.001 0.012
hisgrep/artcncl00:00:00.002 0.0%55 0.000 0.036 1.000
hishave/artcncl00:00:00.000 0.0%56 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.313 0.0%524132 0.002 0.018 1.309
history sync00:00:00.007 0.0%363 0.000 0.019 0.500
history write00:00:05.902 0.0%19855 0.000 0.297 23.977
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:48.891 99.8%511248 109.536 168.742 429.938
nntp read00:00:03.919 0.0%513280 0.003 0.008 0.043
overview write00:00:40.034 0.0%15916 0.053 2.515 75.667
perl filter00:00:36.667 0.0%19855 1.079 1.847 12.313
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.851 0.0%31832 0.000 0.027 0.155
TOTAL: 24:00:46.51223:59:28.924 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%20778 0.000 0.003 0.042
article prepare00:00:00.003 0.0%5504 0.000 0.001 0.025
article read00:00:00.244 0.0%1254 0.000 0.195 20.000
backlog stats00:00:00.467 0.0%278987 0.000 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.931 0.0%229452 0.002 0.008 0.016
data write00:00:02.609 0.0%216824 0.005 0.012 0.020
idle23:55:18.203100.0%278987 185.507 308.682 753.909
status file00:00:04.683 0.0%1885 0.300 2.484 57.417
TOTAL: 23:55:45.20723:55:28.197100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.002 0.0%7 0.200 0.286 0.500
idle61:21:00.973 99.6%403429 0.000 547.459 75271.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.936 0.0%1194886 0.000 0.008 0.200
readart00:04:44.422 0.1%260318 0.000 1.093 29.000
TOTAL: 61:34:53.52161:25:55.333 99.8%----

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 24 19367 3246 13874 2247 16%28:23:26
2bbs-nz-out.news.weretis.net 3 32218 3123 28945 150 9%47:16:18
3bbsnz-out.feed.uzoreto.com 576 24088 2112 21416 560 8%47:29:08
4feeder.eternal-september.org 4 17994 1882 15939 173 10%24:19:02
5news.albasani.net 1 18904 1610 16909 385 8%23:49:43
6news-out.mixmin.net 1 15986 1003 14619 364 6%23:07:16
7newsfeed.neva.ru 146 16363 970 15251 142 5%71:44:43
8news.redatomik.org 2 15199 642 14514 43 4%23:59:37
9news-out.aioe.org 2 14202 518 13663 21 3%22:08:05
10news.swapon.de 5 1495 267 1228 0 17%21:56:26
11csiph.com 1 15174 163 15003 8 1%23:59:55
12agency-nz-out.news.mb-net.net 4 18407 75 18316 16 0%23:17:05
13news.samoylyk.net 2 15236 54 15167 15 0%24:53:45
14news.freedyn.net 2 19461 27 19405 29 0%24:19:36
15feeder.awxg.com 2 13396 21 13368 7 0%23:59:53
16localhost 5 4 4 0 0 100%00:00:01
17news.ausics.org 1 50065 1 50061 3 0%83:25:42
TOTAL: 17 781 307559 15718 287678 4163 5%538:09:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net11.5 MB163.7 KB852.0 KB12.5 MB 92%3.9 KB
2news.snarked.org11.0 MB77.3 KB21.7 MB32.7 MB 33%6.1 KB
3bbsnz-out.feed.uzoreto.com6.1 MB9.2 KB4.5 MB10.5 MB 57%4.0 KB
4feeder.eternal-september.org5.0 MB78.9 KB503.0 KB5.5 MB 89%2.8 KB
5news.albasani.net4.4 MB396.4 KB1.0 MB5.8 MB 76%3.0 KB
6news-out.mixmin.net3.1 MB27.0 KB835.0 KB3.9 MB 78%3.0 KB
7newsfeed.neva.ru2.2 MB16.7 KB672.9 KB2.9 MB 76%2.7 KB
8news.redatomik.org1.9 MB79.3 KB149.6 KB2.2 MB 89%3.2 KB
9news-out.aioe.org1.7 MB30.4 KB84.2 KB1.9 MB 93%3.5 KB
10news.swapon.de667.8 KB0.0 KB0.0 KB667.8 KB100%2.5 KB
11news.freedyn.net437.5 KB81.4 KB113.7 KB632.7 KB 69%11.3 KB
12csiph.com410.2 KB18.3 KB18.3 KB446.8 KB 91%2.6 KB
13agency-nz-out.news.mb-net.net190.6 KB63.3 KB83.8 KB337.7 KB 56%3.7 KB
14news.samoylyk.net131.9 KB686.9 KB686.9 KB1.5 MB 8%21.8 KB
15feeder.awxg.com102.6 KB65.7 KB65.7 KB233.9 KB 43%8.4 KB
16localhost6.2 KB0.0 KB0.0 KB6.2 KB100%1.6 KB
17news.ausics.org2.4 KB20.1 KB20.1 KB42.6 KB 5%10.7 KB
TOTAL: 1748.9 MB1.8 MB31.1 MB81.8 MB 59%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 14 23:58:02 - 23:59:59 16 0.1% 0.1429.0 KB 0.1% 0.25
Oct 15 00:00:00 - 00:59:59 765 4.8% 0.212.1 MB 4.3% 0.60
Oct 15 01:00:00 - 01:59:59 736 4.6% 0.202.0 MB 4.1% 0.57
Oct 15 02:00:00 - 02:59:59 780 4.9% 0.222.5 MB 5.1% 0.72
Oct 15 03:00:00 - 03:59:59 834 5.2% 0.232.3 MB 4.7% 0.66
Oct 15 04:00:00 - 04:59:59 851 5.3% 0.243.0 MB 6.1% 0.86
Oct 15 05:00:00 - 05:59:59 891 5.6% 0.252.6 MB 5.3% 0.74
Oct 15 06:00:00 - 06:59:59 920 5.8% 0.262.4 MB 4.8% 0.67
Oct 15 07:00:00 - 07:59:59 915 5.8% 0.252.7 MB 5.5% 0.77
Oct 15 08:00:00 - 08:59:59 829 5.2% 0.232.4 MB 5.0% 0.70
Oct 15 09:00:00 - 09:59:59 842 5.3% 0.232.9 MB 5.8% 0.82
Oct 15 10:00:00 - 10:59:59 738 4.6% 0.202.3 MB 4.6% 0.64
Oct 15 11:00:00 - 11:59:59 594 3.7% 0.171.8 MB 3.6% 0.50
Oct 15 12:00:00 - 12:59:59 495 3.1% 0.141.9 MB 3.9% 0.54
Oct 15 13:00:00 - 13:59:59 393 2.5% 0.111.3 MB 2.6% 0.36
Oct 15 14:00:00 - 14:59:59 333 2.1% 0.091.3 MB 2.6% 0.36
Oct 15 15:00:00 - 15:59:59 326 2.0% 0.091.0 MB 2.0% 0.28
Oct 15 16:00:00 - 16:59:59 324 2.0% 0.091015.3 KB 2.0% 0.28
Oct 15 17:00:00 - 17:59:59 421 2.6% 0.122.4 MB 4.8% 0.68
Oct 15 18:00:00 - 18:59:59 435 2.7% 0.121.5 MB 3.0% 0.42
Oct 15 19:00:00 - 19:59:59 623 3.9% 0.172.0 MB 4.0% 0.57
Oct 15 20:00:00 - 20:59:59 642 4.0% 0.181.7 MB 3.3% 0.47
Oct 15 21:00:00 - 21:59:59 648 4.1% 0.181.8 MB 3.5% 0.50
Oct 15 22:00:00 - 22:59:59 746 4.7% 0.212.0 MB 4.1% 0.58
Oct 15 23:00:00 - 23:58:01 813 5.1% 0.232.6 MB 5.3% 0.77
TOTAL: 23:59:59 15910 100.0% 0.1849.4 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB29.1 GB 58.3% 0 0.28 2193.65
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB33.5 GB 67.0% 0 0.24 2541.24
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB364.7 MB 0.7% 0 0.0232000.00
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 GB28.4 GB 56.7% 0 0.53 1151.26
TOTAL: 10-500.0 GB91.3 GB 18.3% 1 0.34-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2262 1 0 11 0 0 0 0 2250
2bbsnz-out.feed.uzoreto.com 567 24 0 4 6 0 0 0 533
3news.albasani.net 486 0 0 16 0 0 0 0 470
4news-out.mixmin.net 431 0 0 14 0 0 0 0 417
5bbs-nz-out.news.weretis.net 240 64 0 29 0 0 0 0 147
6newsfeed.neva.ru 145 14 0 7 0 0 0 0 124
7feeder.eternal-september.org 127 0 0 14 0 0 0 0 113
8news.swapon.de 106 0 0 0 0 0 0 0 106
9news.redatomik.org 62 0 0 9 0 0 0 0 53
10news-out.aioe.org 23 9 0 13 0 0 0 0 1
11news.freedyn.net 21 1 0 8 0 0 0 0 12
12agency-nz-out.news.mb-net.net 19 3 0 9 0 0 0 0 7
13csiph.com 11 0 0 11 0 0 0 0 0
14news.samoylyk.net 9 0 0 9 0 0 0 0 0
15feeder.awxg.com 7 0 0 7 0 0 0 0 0
TOTAL: 15 4516 116 0 161 6 0 0 0 4233

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 22
gmane.linux.alsa.devel 22
it.annunci.commerciali 10
it.annunci.varie 6
it.annunci.immobiliari 6
mozilla.dev.ui-alerts 5
mozilla.support.bugzilla 5
gmane.comp.gis.openstreetmap.imports 4
mozilla.dev.security.policy 4
eagle.suggest.eng 3
mozilla.dev.platform 3
mozilla.dev.l10n 3
mozilla.dev.apps.seamonkey 3
gmane.linux.bios.flashrom 2
mozilla.support.seamonkey 2
mozilla.test 2
alt.fr.os.windows.7 1
al.christnet.bible 1
mozilla.governance 1
south-wales.test 1
TOTAL: 30 116

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.rec.gry.szachy 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3193
EMP (phn path) 347
User-issued cancel 80
EMP (phl) 66
Too many newsgroups 52
EMP (phn nph) 24
Binary: misplaced par2 16
Binary: non-binary distribution 14
User-issued spam cancel 6
Binary Image: misplaced jpg 4
Binary: misplaced rar 3
Binary: misplaced 002 2
Binary: misplaced 235 1
Too many newsgroups (meow) 1
Binary: misplaced 300 1
Binary: misplaced JPG 1
Binary: misplaced 107 1
Binary: misplaced 073 1
Binary: misplaced 236 1
Binary: misplaced 152 1
TOTAL: 25 3820

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.albasani.net 117
news.swapon.de 106
bbs-nz-out.news.weretis.net 82
news-out.mixmin.net 69
news.redatomik.org 24
bbsnz-out.feed.uzoreto.com 6
newsfeed.neva.ru 3
news.snarked.org 2
agency-nz-out.news.mb-net.net 1
feeder.eternal-september.org 1
TOTAL: 11 412
TOTAL: 1 412

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 14614 755 13827 32 0 5 5%23:59:48
2awxg 15550 43 15497 1 0 0 0%23:59:48
3news.snarked.org 12605 8 12494 3 0 52 0%23:59:48
4aioe 13841 6 13698 0 0 0 0%23:59:47
5csiph.com 15854 5 15726 1 0 0 0%23:59:42
6eternal-september 13752 5 13716 0 0 0 0%23:59:36
7neva.ru 14553 4 14534 0 0 0 0%23:59:48
8weretis.net 12507 4 12367 4 0 0 0%23:59:48
9news.samoylyk.net 14646 4 14565 0 0 88 0%23:59:48
10mb-net.net 15857 4 15818 0 0 0 0%23:59:48
11news.freedyn.net 15963 4 15869 0 0 0 0%23:59:48
12news.redatomik.org 15247 4 15161 0 0 4 0%23:59:48
13news-in.mixmin.net 14361 3 14324 0 0 67 0%23:59:48
14news.albasani.net 15900 2 13886 383 0 4692 0%23:59:48
15news.uzoreto.com 13708 2 13683 3 0 0 0%23:59:46
16news.swapon.de 1361 0 1350 0 0 10 0%23:26:32
TOTAL: 16 220319 853 216515 427 0 4918 0%383:23:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.2 MB164.5 KB4.3 MB0.1 KB/s5.7 KB23:59:48
2awxg107.8 KB2.9 KB110.7 KB0.0 KB/s2.5 KB23:59:48
3news.snarked.org13.6 KB8.4 KB22.0 KB0.0 KB/s2.0 KB23:59:48
4eternal-september11.3 KB0.0 KB11.3 KB0.0 KB/s2.3 KB23:59:36
5aioe11.0 KB0.0 KB11.0 KB0.0 KB/s1.8 KB23:59:47
6csiph.com9.1 KB2.1 KB11.2 KB0.0 KB/s1.9 KB23:59:42
7neva.ru6.2 KB0.0 KB6.2 KB0.0 KB/s1.6 KB23:59:48
8weretis.net6.2 KB5.4 KB11.6 KB0.0 KB/s1.4 KB23:59:48
9news.samoylyk.net6.2 KB0.0 KB6.2 KB0.0 KB/s1.6 KB23:59:48
10mb-net.net6.2 KB0.0 KB6.2 KB0.0 KB/s1.6 KB23:59:48
11news.freedyn.net6.2 KB0.0 KB6.2 KB0.0 KB/s1.6 KB23:59:48
12news.redatomik.org6.2 KB0.0 KB6.2 KB0.0 KB/s1.6 KB23:59:48
13news-in.mixmin.net4.8 KB0.0 KB4.8 KB0.0 KB/s1.6 KB23:59:48
14news.albasani.net3.8 KB1.3 MB1.3 MB0.0 KB/s3.3 KB23:59:48
15news.uzoreto.com2.6 KB5.3 KB7.9 KB0.0 KB/s1.6 KB23:59:46
16news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:26:32
TOTAL: 164.4 MB1.4 MB5.8 MB0.0 KB/s4.7 KB383:23:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 387 534619.4 MB 2964 5 000:15:37
2vorlon.activateit.net.au 24 8251.1 MB 136 0 000:04:30
3160-3-236-103.cpe.cableone.net 3 56342.5 KB 3 0 031:54:30
4amigacity.xyz 72 2962.2 KB 20 0 28800:13:44
560.234.68.122 8 1333.5 KB 2 0 000:30:29
TOTAL: 5 494134915204.9 MB 3126 5 28861:34:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 387 534619.4 MB 2964 5 000:15:37
2*.activateit.net.au 24 8251.1 MB 136 0 000:04:30
3*.cpe.cableone.net 3 56342.5 KB 3 0 031:54:30
4*.xyz 72 2962.2 KB 20 0 28800:13:44
5unresolved 14 1333.5 KB 2 0 000:37:26
TOTAL: 5 500134915204.9 MB 3126 5 28861:34:46

NNRP auth users [Top 20]:

UserConn
amigacity 72
amybbs 24
crash 6
malcolmlewis 3
TOTAL: 4 105

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.412 0.128 0.00931:54:30
ool-4578089a.dyn.optonline.net 15.388 36.960 0.00028:28:56
60.234.68.122 0.528 0.076 0.01900:30:29
agency.bbs.nz 29.216 6.708 0.00000:15:37
amigacity.xyz 4.016 0.796 0.25700:13:44
118.149.138.177 0.360 0.052 0.00000:06:56
vorlon.activateit.net.au 1.460 0.384 0.07000:04:30
? 0.984 0.116 0.00000:00:01
TOTAL: 8 52.364 45.220 0.35561:34:46

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.138.177 6
TOTAL: 1 6

NNRP gethostbyaddr failures [Top 20]:

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
ool-4578089a.dyn.optonline.net 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 118770 95.2%
2rec 2421 1.9%
3uk 700 0.6%
4soc 692 0.6%
5sci 660 0.5%
6comp 620 0.5%
7linux 463 0.4%
8talk 236 0.2%
9misc 96 0.1%
10news 40 0.0%
11mozilla 26 0.0%
12nz 12 0.0%
13agency 11 0.0%
14aus 5 0.0%
15microsoft 2 0.0%
16humanities 2 0.0%
TOTAL: 16 124756100.0%

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

NewsgroupCount
1alt.religion.christian.roman-catholic 118541
2rec.arts.tv 495
3rec.arts.drwho 453
4uk.d-i-y 431
5sci.physics 286
6rec.food.cooking 272
7comp.os.linux.advocacy 166
8talk.origins 160
9linux.debian.bugs.dist 153
10rec.sport.football.college 146
11alt.comp.os.windows-10 122
12rec.arts.sf.written 112
13linux.debian.changes.devel 112
14rec.sport.pro-wrestling 111
15uk.legal 109
16rec.sport.tennis 107
17soc.retirement 104
18sci.electronics.design 101
19soc.culture.polish 95
20rec.drugs.cannabis 79
21comp.lang.c++ 75
22comp.lang.python 73
23talk.politics.guns 68
24rec.boats 66
25rec.gambling.poker 64
26linux.debian.bugs.rc 60
27sci.physics.relativity 54
28sci.logic 54
29rec.radio.amateur.antenna 48
30sci.math 48
31uk.radio.amateur 46
32linux.debian.user 46
33soc.women 45
34uk.legal.moderated 45
35soc.culture.israel 44
36soc.men 40
37comp.mobile.android 37
38soc.culture.indian 37
39alt.politics.trump 37
40soc.culture.usa 34
41soc.genealogy.medieval 31
42soc.history.living 31
43rec.bicycles.tech 31
44news.lists.filters 28
45rec.music.classical.recordings 28
46comp.lang.c 25
47soc.culture.greek 25
48comp.arch 25
49sci.lang 24
50uk.tech.digital-tv 24
51linux.debian.user.french 24
52rec.arts.sf.tv 23
53rec.sport.soccer 23
54misc.phone.mobile.iphone 23
55rec.music.dylan 22
56soc.culture.brazil 22
57mozilla.support.firefox 21
58rec.photo.digital 21
59rec.arts.disney.parks 21
60alt.bbs.synchronet 20
61sci.med.pharmacy 20
62rec.puzzles.crosswords 19
63comp.lang.ada 19
64alt.test 19
65comp.sys.mac.system 18
66comp.sys.mac.advocacy 17
67rec.audio.pro 17
68rec.audio.opinion 17
69soc.culture.china 17
70misc.survivalism 17
71uk.comp.sys.mac 16
72soc.penpals 16
73misc.invest.misc 16
74rec.games.backgammon 16
75alt.conspiracy.jfk 15
76comp.sys.tandem 15
77sci.bio.paleontology 14
78soc.genealogy.britain 14
79sci.astro.amateur 14
80misc.invest.stocks 14
81uk.comp.homebuilt 13
82comp.os.vms 13
83rec.radio.amateur.misc 12
84nz.general 12
85rec.nude 12
86rec.arts.sf.fandom 12
87sci.military.naval 11
88rec.sport.cricket 11
89rec.games.pinball 11
90rec.aviation.military 11
91soc.history 10
92news.answers 10
93soc.culture.turkish 10
94soc.culture.african.american 9
95soc.culture.malaysia 9
96soc.history.medieval 9
97misc.news.internet.discuss 9
98comp.lang.cobol 9
99rec.autos.sport.f1 9
100rec.games.video.arcade.collecting 9
TOTAL: 303 124756