news.bbs.nz daily logs

Dec 3 23:58:02 -- Dec 4 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 129447 49.9%10.0 MB 32.0%
innd 57041 22.0%7.8 MB 25.0%
inn 45380 17.5%8.0 MB 25.7%
innfeed 26004 10.0%5.2 MB 16.6%
cnfsstat 1440 0.6%250.1 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 259313 100.0%31.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 478993 53.5%
Negative hits 368559 41.1%
Do not exist 44831 5.0%
Cache misses 3740 0.4%
TOTAL: 4 896123 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.068 0.0%28 0.000 2.429 16.000
article cleanup00:00:00.408 0.0%45000 0.000 0.009 0.062
article logging00:00:01.138 0.0%45367 0.000 0.025 0.079
article parse00:00:01.103 0.0%117616 0.000 0.009 0.025
article write00:00:05.329 0.0%18318 0.014 0.291 22.810
artlog/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.535 0.0%684912 0.000 0.001 0.005
hisgrep/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.475 0.0%899505 0.003 0.015 0.853
history sync00:00:00.022 0.0%374 0.000 0.059 0.500
history write00:00:13.434 0.0%44878 0.012 0.299 19.004
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:09.948 99.7%697150 40.176 123.603 390.508
nntp read00:00:07.074 0.0%701328 0.003 0.010 0.026
overview write00:00:48.499 0.1%18318 0.045 2.648 79.313
perl filter00:01:08.662 0.1%44874 0.778 1.530 7.821
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.067 0.0%36636 0.000 0.029 0.127
TOTAL: 24:00:47.02923:58:50.762 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%22903 0.000 0.002 0.020
article prepare00:00:00.002 0.0%11680 0.000 0.000 0.011
article read00:00:00.210 0.0%2403 0.000 0.087 2.370
backlog stats00:00:00.667 0.0%334106 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.832 0.0%280210 0.004 0.010 0.021
data write00:00:03.171 0.0%268357 0.005 0.012 0.024
idle23:55:07.410100.0%334106 120.150 257.725 672.362
status file00:00:03.806 0.0%1877 0.538 2.028 74.545
TOTAL: 23:55:37.18523:55:18.146100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle26:59:27.815 99.6%139495 0.000 696.568450208.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.958 0.0%347942 0.000 0.026 2.254
readart00:00:09.202 0.0%9787 0.000 0.940 21.500
TOTAL: 27:05:24.94526:59:45.975 99.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
1news.snarked.org 40 23292 3482 17227 2583 14%39:02:17
2bbs-nz-out.news.weretis.net 14 61972 3296 58424 252 5%50:16:25
3bbsnz-out.feed.uzoreto.com 866 58557 2234 51705 4618 3%71:08:11
4feeder.eternal-september.org 7 42228 2231 25382 14615 5%25:23:18
5news-out.aioe.org 3 19432 1924 17479 29 9%26:24:45
6news.albasani.net 5 19788 1653 17599 536 8%21:51:05
7news.redatomik.org 4 21787 1382 19372 1033 6%26:12:20
8news-out.mixmin.net 3 22575 903 21274 398 4%30:35:53
9newsfeed.neva.ru 145 53524 798 50507 2219 1%71:33:58
10csiph.com 2 18965 202 18753 10 1%27:47:32
11news.swapon.de 4 1538 176 1361 1 11%25:02:59
12news.freedyn.net 4 19869 102 19735 32 0%24:22:24
13news.samoylyk.net 2 17905 90 17807 8 0%24:54:11
14agency-nz-out.news.mb-net.net 7 25963 84 25854 25 0%27:59:46
15feeder.awxg.com 2 15699 5 15686 8 0%23:59:51
16localhost 3 2 2 0 0 100%00:00:00
17news.ausics.org 2 17029 0 17029 0 0%28:03:20
18nut.utcc.utoronto.ca 1 17227 0 17227 0 0%23:49:59
TOTAL: 18 1114 457352 18564 412421 26367 4%568:28:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net19.5 MB118.3 KB1.1 MB20.7 MB 94%6.0 KB
2bbsnz-out.feed.uzoreto.com13.2 MB3.9 KB7.2 MB20.3 MB 64%3.0 KB
3news.snarked.org11.0 MB87.8 KB17.8 MB28.9 MB 38%4.9 KB
4news.albasani.net9.4 MB61.4 KB945.1 KB10.4 MB 90%4.8 KB
5feeder.eternal-september.org8.5 MB263.7 KB18.4 MB27.1 MB 31%1.6 KB
6news-out.aioe.org4.8 MB32.0 KB191.7 KB5.0 MB 95%2.6 KB
7news-out.mixmin.net4.1 MB49.2 KB970.1 KB5.1 MB 80%4.0 KB
8news.redatomik.org4.0 MB209.2 KB1.5 MB5.7 MB 69%2.4 KB
9news.freedyn.net2.5 MB31.2 KB133.0 KB2.7 MB 94%20.5 KB
10newsfeed.neva.ru2.2 MB80.2 KB20.9 MB23.1 MB 9%7.9 KB
11news.samoylyk.net559.8 KB25.3 KB25.3 KB610.4 KB 91%6.2 KB
12csiph.com487.6 KB32.4 KB75.2 KB595.2 KB 81%2.8 KB
13news.swapon.de440.9 KB0.0 KB33.7 KB474.7 KB 92%2.7 KB
14agency-nz-out.news.mb-net.net354.1 KB81.8 KB125.2 KB561.0 KB 63%5.1 KB
15feeder.awxg.com10.8 KB38.0 KB38.0 KB86.8 KB 12%6.7 KB
16localhost2.4 KB0.0 KB0.0 KB2.4 KB100%1.2 KB
17news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
18nut.utcc.utoronto.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1880.9 MB1.1 MB69.3 MB151.3 MB 53%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 3 23:58:02 - 23:59:59 16 0.1% 0.1455.1 KB 0.1% 0.47
Dec 4 00:00:00 - 00:59:59 785 4.3% 0.222.6 MB 3.2% 0.73
Dec 4 01:00:00 - 01:59:59 831 4.5% 0.232.9 MB 3.6% 0.83
Dec 4 02:00:00 - 02:59:59 930 5.1% 0.262.3 MB 2.9% 0.66
Dec 4 03:00:00 - 03:59:59 970 5.3% 0.273.6 MB 4.5% 1.02
Dec 4 04:00:00 - 04:59:59 1135 6.2% 0.323.2 MB 3.9% 0.90
Dec 4 05:00:00 - 05:59:59 1160 6.3% 0.3214.3 MB 17.8% 4.06
Dec 4 06:00:00 - 06:59:59 1165 6.4% 0.324.2 MB 5.3% 1.21
Dec 4 07:00:00 - 07:59:59 1125 6.1% 0.313.7 MB 4.6% 1.05
Dec 4 08:00:00 - 08:59:59 986 5.4% 0.273.4 MB 4.2% 0.97
Dec 4 09:00:00 - 09:59:59 1090 6.0% 0.3010.2 MB 12.7% 2.89
Dec 4 10:00:00 - 10:59:59 904 4.9% 0.253.4 MB 4.2% 0.96
Dec 4 11:00:00 - 11:59:59 782 4.3% 0.222.7 MB 3.4% 0.78
Dec 4 12:00:00 - 12:59:59 659 3.6% 0.182.5 MB 3.1% 0.71
Dec 4 13:00:00 - 13:59:59 596 3.3% 0.172.0 MB 2.5% 0.56
Dec 4 14:00:00 - 14:59:59 444 2.4% 0.121.3 MB 1.7% 0.38
Dec 4 15:00:00 - 15:59:59 440 2.4% 0.121.9 MB 2.4% 0.55
Dec 4 16:00:00 - 16:59:59 376 2.1% 0.101.2 MB 1.5% 0.35
Dec 4 17:00:00 - 17:59:59 334 1.8% 0.091.9 MB 2.4% 0.54
Dec 4 18:00:00 - 18:59:59 350 1.9% 0.103.0 MB 3.7% 0.85
Dec 4 19:00:00 - 19:59:59 395 2.2% 0.111.6 MB 2.0% 0.45
Dec 4 20:00:00 - 20:59:59 570 3.1% 0.161.7 MB 2.2% 0.49
Dec 4 21:00:00 - 21:59:59 653 3.6% 0.181.6 MB 2.0% 0.45
Dec 4 22:00:00 - 22:59:59 825 4.5% 0.232.6 MB 3.2% 0.73
Dec 4 23:00:00 - 23:58:02 786 4.3% 0.232.4 MB 3.0% 0.71
TOTAL: 24:00:00 18307 100.0% 0.2180.2 MB 100.0% 0.95
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB30.2 GB 60.4% 0 0.30 2008.06
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB34.7 GB 69.3% 0 0.32 1919.25
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB369.9 MB 0.7% 0 0.0235555.56
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 GB30.7 GB 61.3% 0 0.81 747.84
TOTAL: 10-500.0 GB95.9 GB 19.2% 1 0.48-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder.eternal-september.org 14668 0 0 12 0 0 0 014656
2bbsnz-out.feed.uzoreto.com 4624 18 0 1 0 0 0 0 4605
3news.snarked.org 2542 3 0 8 0 0 0 0 2531
4newsfeed.neva.ru 2354 28 0 8 0 0 0 0 2318
5news.redatomik.org 1146 0 0 10 0 0 0 0 1136
6news.albasani.net 733 1 0 8 0 0 0 0 724
7news-out.mixmin.net 424 0 0 7 0 0 0 0 417
8bbs-nz-out.news.weretis.net 364 70 0 30 0 0 0 0 264
9news.swapon.de 54 0 0 0 0 0 0 0 54
10news.freedyn.net 52 1 0 6 0 0 0 0 45
11news-out.aioe.org 36 19 0 6 0 0 0 0 11
12agency-nz-out.news.mb-net.net 26 4 0 7 0 0 0 0 15
13news.samoylyk.net 9 0 0 9 0 0 0 0 0
14csiph.com 8 0 0 5 0 0 0 0 3
15feeder.awxg.com 5 0 0 5 0 0 0 0 0
TOTAL: 15 27045 144 0 122 0 0 0 026779

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.kernel 33
gmane.linux.alsa.devel 30
alt.music.pink-floyd.publius 28
mozilla.dev.security.policy 9
gmane.comp.gis.openstreetmap.tagging 6
mozilla.dev.ui-alerts 4
mozilla.support.seamonkey 3
gmane.comp.hardware.netbook.arm.sunxi 3
mozilla.dev.platform 3
alt.fr.os.windows.7 2
al.christnet.bible 2
gmane.linux.kernel.stable 2
dnet.ham 1
rec.travel.resorts.all 1
usenetserver.test 1
alt.fetish.panties 1
alt.religion.christian.romman-catholic 1
de.comm.ham 1
alt.sex.girl 1
ampr.bbs.agcw 1
TOTAL: 31 144

INND Perl filter [Top 20]:

ReasonCount
User-issued cancel 21096
EMP (md5) 4128
Binary: misplaced rar 664
EMP (phn path) 357
Too many newsgroups 71
EMP (phl) 61
Binary: misplaced par2 18
Binary: non-binary distribution 9
Binary: misplaced mp4 2
Too many newsgroups (low_xpost) 1
Binary Image: misplaced gif 1
TOTAL: 11 26408

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
bbsnz-out.feed.uzoreto.com 3
TOTAL: 1 3
Bad Message-ID's offered
bbsnz-out.feed.uzoreto.com 3
TOTAL: 1 3
Including strange strings
news.albasani.net 175
news-out.mixmin.net 55
news.swapon.de 53
news.redatomik.org 39
bbs-nz-out.news.weretis.net 20
news-out.aioe.org 11
bbsnz-out.feed.uzoreto.com 9
news.snarked.org 3
feeder.eternal-september.org 2
TOTAL: 9 367
TOTAL: 3 373

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16588 865 15702 21 0 0 5%23:59:49
2utnut 18307 771 17204 332 0 0 4%23:59:49
3awxg 17734 53 17647 6 0 0 0%23:59:44
4news.freedyn.net 18457 25 18138 29 0 18 0%23:59:49
5news.snarked.org 14839 15 14658 1 0 97 0%23:59:39
6mb-net.net 18411 14 18128 25 0 62 0%23:59:49
7aioe 15113 5 15048 0 0 0 0%23:59:45
8news.redatomik.org 16982 5 16829 5 0 55 0%23:59:44
9weretis.net 14718 4 14626 3 0 1 0%23:59:46
10csiph.com 18151 2 18108 0 0 0 0%23:59:49
11news.samoylyk.net 16582 2 16518 0 0 32 0%23:59:34
12neva.ru 16939 2 16921 1 0 0 0%23:59:49
13news-in.mixmin.net 16780 2 16766 0 0 0 0%23:59:49
14eternal-september 15684 2 15638 0 0 0 0%23:59:39
15news.uzoreto.com 15835 1 15832 2 0 0 0%23:59:40
16news.albasani.net 17779 0 15801 650 0 4394 0%23:59:49
17news.swapon.de 1402 0 1400 0 0 0 0%23:50:24
TOTAL: 17 270301 1768 264964 1075 0 4659 0%407:46:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1utnut27.7 MB1.3 MB29.0 MB0.3 KB/s26.9 KB23:59:49
2news.ausics.org11.4 MB178.6 KB11.6 MB0.1 KB/s13.4 KB23:59:49
3awxg179.3 KB56.7 KB236.1 KB0.0 KB/s4.0 KB23:59:44
4news.redatomik.org136.8 KB331.0 KB467.8 KB0.0 KB/s46.8 KB23:59:44
5news.freedyn.net55.2 KB257.2 KB312.5 KB0.0 KB/s5.8 KB23:59:49
6mb-net.net31.8 KB73.3 KB105.1 KB0.0 KB/s2.7 KB23:59:49
7news.snarked.org24.2 KB2.5 KB26.7 KB0.0 KB/s1.7 KB23:59:39
8weretis.net19.6 KB5.2 KB24.8 KB0.0 KB/s3.5 KB23:59:46
9aioe11.7 KB0.0 KB11.7 KB0.0 KB/s2.3 KB23:59:45
10news.uzoreto.com5.9 KB2.4 KB8.3 KB0.0 KB/s2.8 KB23:59:40
11csiph.com2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:49
12news.samoylyk.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:34
13neva.ru2.4 KB1.9 KB4.3 KB0.0 KB/s1.4 KB23:59:49
14news-in.mixmin.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:49
15eternal-september2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:39
16news.albasani.net0.0 KB2.5 MB2.5 MB0.0 KB/s4.0 KB23:59:49
17news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:24
TOTAL: 1739.6 MB4.7 MB44.3 MB0.0 KB/s15.9 KB407:46:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 386 590423.5 MB 3292 2 000:14:22
2ool-4578089a.dyn.optonline.net 12 19998.4 MB 64 0 004:42:02
3vorlon.activateit.net.au 24 8641.2 MB 121 0 000:04:38
4amigacity.xyz 72 202426.8 KB 111 1 000:30:09
5160-3-236-103.cpe.cableone.net 5 946.0 KB 3 0 021:29:56
TOTAL: 5 499 897833.6 MB 3591 3 027:05:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 386 590423.5 MB 3292 2 000:14:22
2*.dyn.optonline.net 12 19998.4 MB 64 0 004:42:02
3*.activateit.net.au 24 8641.2 MB 121 0 000:04:38
4*.xyz 72 202426.8 KB 111 1 000:30:09
5*.cpe.cableone.net 5 946.0 KB 3 0 021:29:56
6unresolved 4 00.0 KB 0 0 000:04:06
TOTAL: 6 503 897833.6 MB 3591 3 027:05:17

NNRP auth users [Top 20]:

UserConn
amigacity 72
amybbs 24
malcolmlewis 5
TOTAL: 3 101

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.444 0.116 0.01521:29:56
ool-4578089a.dyn.optonline.net 0.952 0.612 0.00004:42:02
amigacity.xyz 4.328 1.132 0.28000:30:09
agency.bbs.nz 29.508 6.872 0.00000:14:22
vorlon.activateit.net.au 1.580 0.440 0.07000:04:38
118.149.162.210 0.232 0.044 0.00000:04:06
? 0.896 0.108 0.00000:00:01
TOTAL: 7 37.940 9.324 0.36527:05:17

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.162.210 4
TOTAL: 1 4

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1aus 119620 93.0%
2alt 2539 2.0%
3rec 2377 1.8%
4linux 809 0.6%
5soc 763 0.6%
6sci 740 0.6%
7comp 656 0.5%
8uk 573 0.4%
9talk 293 0.2%
10misc 135 0.1%
11aurora 52 0.0%
12nz 23 0.0%
13microsoft 23 0.0%
14mozilla 20 0.0%
15humanities 9 0.0%
16news 8 0.0%
TOTAL: 16 128640100.0%

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

NewsgroupCount
1aus.cars 99211
2aus.computers 17503
3aus.aviation 1286
4alt.sex.anal 1083
5alt.sex.teens 777
6rec.arts.tv 567
7aus.comms 540
8rec.arts.drwho 311
9alt.comp.os.windows-10 262
10linux.debian.bugs.dist 259
11aus.education 246
12uk.d-i-y 220
13linux.debian.changes.devel 208
14uk.legal 195
15rec.food.cooking 193
16talk.politics.guns 182
17alt.politics.trump 177
18aus.culture.lesbigay 152
19rec.games.miniatures.misc 144
20sci.physics.relativity 142
21comp.os.linux.advocacy 140
22rec.arts.sf.written 131
23rec.sport.football.college 130
24linux.debian.bugs.rc 124
25sci.physics 112
26soc.retirement 106
27soc.culture.polish 106
28aus.bushwalking 102
29talk.origins 91
30alt.sex.erotica.teen 88
31comp.lang.python 86
32aus.ads.jobs 84
33rec.sport.golf 83
34rec.sport.tennis 83
35sci.math 77
36rec.gambling.poker 76
37soc.penpals 76
38aus.ads.jobs.resumes 76
39misc.survivalism 70
40soc.culture.china 68
41comp.os.vms 65
42sci.military.naval 64
43sci.electronics.design 63
44soc.culture.israel 63
45aus.culture.true-blue 62
46aus.censorship 59
47aus.bicycle 57
48aurora.general 52
49alt.conspiracy.jfk 49
50aus.dvd 49
51rec.bicycles.tech 46
52rec.games.pinball 46
53soc.history.living 46
54sci.lang 44
55sci.logic 42
56linux.debian.user 40
57soc.culture.indian 38
58rec.autos.sport.f1 38
59alt.tinygirls 37
60rec.sport.pro-wrestling 37
61soc.culture.brazil 35
62rec.music.classical.recordings 35
63rec.boats 34
64sci.med.cardiology 34
65comp.sys.mac.system 34
66uk.radio.amateur 33
67rec.skiing.alpine 32
68rec.arts.sf.fandom 31
69soc.culture.usa 31
70uk.legal.moderated 29
71sci.med.pharmacy 29
72rec.music.rock-pop-r+b.1950s 27
73comp.lang.prolog 27
74sci.electronics.repair 27
75misc.health.diabetes 26
76linux.gentoo.user 26
77uk.tech.broadcast 26
78aus.audio-visual.home-cinema 25
79soc.genealogy.medieval 25
80uk.comp.sys.mac 23
81rec.outdoors.rv-travel 23
82soc.culture.greek 22
83rec.arts.sf.tv 21
84comp.lang.ada 21
85comp.lang.forth 20
86misc.invest.stocks 20
87rec.photo.digital 20
88comp.lang.c++ 20
89linux.debian.devel.release 19
90rec.sport.soccer 19
91sci.astro.amateur 18
92nz.comp 18
93comp.sys.ibm.ps2.hardware 17
94comp.arch.embedded 17
95aus.business 17
96alt.bbs.synchronet 17
97uk.tech.digital-tv 16
98rec.games.backgammon 16
99linux.debian.laptop 16
100talk.politics.misc 15
TOTAL: 370 128640