news.bbs.nz daily logs

Oct 9 23:58:02 -- Oct 10 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 126693 61.1%9.8 MB 38.1%
innd 31383 15.1%5.1 MB 19.9%
innfeed 24830 12.0%4.9 MB 19.2%
inn 22929 11.1%5.7 MB 21.9%
cnfsstat 1440 0.7%256.4 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 207276 100.0%25.8 MB100.0%

History cache:

ReasonCount%Count
Negative hits 299955 49.5%
Positive hits 284091 46.8%
Do not exist 22295 3.7%
Cache misses 173 0.0%
TOTAL: 4 606514 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.074 0.0%53 0.000 1.396 12.500
article cleanup00:00:00.217 0.0%22554 0.000 0.010 0.048
article logging00:00:00.579 0.0%22862 0.000 0.025 0.124
article parse00:00:00.666 0.0%64895 0.000 0.010 0.040
article write00:00:04.093 0.0%18469 0.014 0.222 19.815
artlog/artcncl00:00:00.000 0.0%53 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.598 0.0%575327 0.000 0.001 0.020
hisgrep/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%53 0.000 0.019 0.167
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.074 0.0%610075 0.001 0.017 0.800
history sync00:00:00.014 0.0%311 0.000 0.045 1.000
history write00:00:08.143 0.0%22416 0.000 0.363 25.096
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:01.469 99.8%585681 75.248 147.216 520.354
nntp read00:00:04.431 0.0%588454 0.002 0.008 0.030
overview write00:00:38.438 0.0%18469 0.000 2.081 47.689
perl filter00:00:44.199 0.1%22413 1.118 1.972 42.449
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.002 0.0%36938 0.000 0.027 0.250
TOTAL: 24:00:24.70223:58:53.998 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%25430 0.000 0.003 0.031
article prepare00:00:00.000 0.0%9064 0.000 0.000 0.000
article read00:00:00.119 0.0%2130 0.000 0.056 1.292
backlog stats00:00:00.528 0.0%318601 0.000 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.097 0.0%265521 0.003 0.008 0.016
data write00:00:03.031 0.0%250965 0.005 0.012 0.029
idle23:54:18.586100.0%318601 157.033 270.114 694.776
status file00:00:15.741 0.0%1948 0.400 8.081 813.182
TOTAL: 23:54:58.16023:54:40.167100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%9 0.000 0.000 0.000
idle36:16:14.651 99.7%134917 0.000 967.815101337.953
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.546 0.0%283688 0.000 0.005 0.250
readart00:00:03.653 0.0%7717 0.000 0.473 29.000
TOTAL: 36:22:06.65236:16:19.850 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
1bbs-nz-out.news.weretis.net 6 37863 4101 33373 389 10%47:08:14
2bbsnz-out.feed.uzoreto.com 576 27191 3389 22971 831 12%47:24:01
3news.snarked.org 32 21978 2787 17610 1581 12%32:03:39
4feeder.eternal-september.org 7 21062 2302 18552 208 10%24:52:09
5news-out.aioe.org 3 18107 1144 16922 41 6%23:28:48
6news.redatomik.org 3 14466 1041 13373 52 7%16:38:57
7newsfeed.neva.ru 146 13509 994 12310 205 7%72:14:56
8news.albasani.net 1 19235 951 17983 301 4%23:49:43
9news-out.mixmin.net 3 17849 856 16676 317 4%21:53:47
10csiph.com 1 18159 198 17948 13 1%23:59:55
11news.swapon.de 2 1620 152 1467 1 9%24:19:06
12agency-nz-out.news.mb-net.net 5 22042 71 21938 33 0%25:51:27
13news.samoylyk.net 4 19024 68 18932 24 0%26:52:25
14news.freedyn.net 2 20217 59 20126 32 0%23:53:40
15feeder.awxg.com 1 16306 33 16261 12 0%23:59:55
16localhost 4 3 3 0 0 100%00:00:01
TOTAL: 16 796 288631 18149 266442 4040 6%458:30:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1bbs-nz-out.news.weretis.net16.8 MB53.0 KB2.2 MB19.1 MB 88%4.4 KB
2news.snarked.org10.2 MB41.3 KB15.1 MB25.3 MB 40%5.9 KB
3bbsnz-out.feed.uzoreto.com8.4 MB3.7 KB4.1 MB12.5 MB 67%3.0 KB
4feeder.eternal-september.org6.2 MB59.1 KB587.0 KB6.8 MB 90%2.8 KB
5news-out.aioe.org3.0 MB16.9 KB357.3 KB3.3 MB 89%2.9 KB
6news.albasani.net3.0 MB19.1 KB565.5 KB3.5 MB 83%2.9 KB
7news.redatomik.org2.9 MB28.5 KB136.4 KB3.1 MB 94%2.9 KB
8news-out.mixmin.net2.9 MB38.5 KB711.7 KB3.6 MB 79%3.1 KB
9newsfeed.neva.ru2.8 MB27.9 KB1.6 MB4.4 MB 64%3.8 KB
10csiph.com476.3 KB55.8 KB55.8 KB587.8 KB 81%2.8 KB
11news.swapon.de418.0 KB2.6 KB2.6 KB423.2 KB 98%2.8 KB
12agency-nz-out.news.mb-net.net212.8 KB32.8 KB206.0 KB451.6 KB 47%4.3 KB
13news.samoylyk.net205.5 KB44.9 KB675.4 KB925.9 KB 22%10.1 KB
14news.freedyn.net172.3 KB23.9 KB289.0 KB485.2 KB 35%5.3 KB
15feeder.awxg.com153.8 KB56.1 KB56.1 KB266.1 KB 57%5.9 KB
16localhost3.7 KB0.0 KB0.0 KB3.7 KB100%1.2 KB
TOTAL: 1657.7 MB504.1 KB26.5 MB84.7 MB 68%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 9 23:58:02 - 23:59:59 19 0.1% 0.1654.9 KB 0.1% 0.47
Oct 10 00:00:00 - 00:59:59 822 4.4% 0.232.7 MB 4.6% 0.77
Oct 10 01:00:00 - 01:59:59 956 5.2% 0.272.4 MB 4.1% 0.69
Oct 10 02:00:00 - 02:59:59 1007 5.4% 0.282.9 MB 4.9% 0.81
Oct 10 03:00:00 - 03:59:59 1088 5.9% 0.303.0 MB 5.1% 0.86
Oct 10 04:00:00 - 04:59:59 1122 6.1% 0.313.9 MB 6.6% 1.10
Oct 10 05:00:00 - 05:59:59 1164 6.3% 0.323.8 MB 6.5% 1.09
Oct 10 06:00:00 - 06:59:59 1324 7.2% 0.374.2 MB 7.1% 1.18
Oct 10 07:00:00 - 07:59:59 1083 5.9% 0.303.7 MB 6.4% 1.06
Oct 10 08:00:00 - 08:59:59 1063 5.8% 0.303.2 MB 5.5% 0.92
Oct 10 09:00:00 - 09:59:59 872 4.7% 0.242.6 MB 4.4% 0.74
Oct 10 10:00:00 - 10:59:59 805 4.4% 0.222.9 MB 5.0% 0.84
Oct 10 11:00:00 - 11:59:59 555 3.0% 0.151.9 MB 3.2% 0.54
Oct 10 12:00:00 - 12:59:59 567 3.1% 0.162.4 MB 4.1% 0.69
Oct 10 13:00:00 - 13:59:59 427 2.3% 0.121.2 MB 2.0% 0.34
Oct 10 14:00:00 - 14:59:59 389 2.1% 0.111.3 MB 2.3% 0.38
Oct 10 15:00:00 - 15:59:59 345 1.9% 0.10927.2 KB 1.5% 0.26
Oct 10 16:00:00 - 16:59:59 351 1.9% 0.101.2 MB 2.0% 0.33
Oct 10 17:00:00 - 17:59:59 396 2.1% 0.111.6 MB 2.7% 0.45
Oct 10 18:00:00 - 18:59:59 655 3.5% 0.182.3 MB 3.9% 0.65
Oct 10 19:00:00 - 19:59:59 557 3.0% 0.151.7 MB 2.9% 0.47
Oct 10 20:00:00 - 20:59:59 650 3.5% 0.182.0 MB 3.4% 0.56
Oct 10 21:00:00 - 21:59:59 771 4.2% 0.212.3 MB 4.0% 0.66
Oct 10 22:00:00 - 22:59:59 789 4.3% 0.222.2 MB 3.8% 0.63
Oct 10 23:00:00 - 23:58:02 703 3.8% 0.202.1 MB 3.6% 0.62
TOTAL: 24:00:00 18480 100.0% 0.2158.6 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB29.0 GB 58.0% 0 0.29 2099.22
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB33.4 GB 66.8% 0 0.32 1924.11
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB364.3 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 GB28.1 GB 56.3% 0 0.66 917.79
TOTAL: 10-500.0 GB90.9 GB 18.2% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1579 7 0 9 0 0 0 0 1563
2bbsnz-out.feed.uzoreto.com 846 23 0 2 0 0 0 0 821
3bbs-nz-out.news.weretis.net 459 65 0 18 0 0 0 0 376
4news-out.mixmin.net 401 0 0 10 0 0 0 0 391
5news.albasani.net 359 0 0 8 0 0 0 0 351
6feeder.eternal-september.org 218 0 0 18 0 0 0 0 200
7newsfeed.neva.ru 208 22 0 7 0 0 0 0 179
8news.redatomik.org 112 0 0 8 0 0 0 0 104
9news-out.aioe.org 49 32 0 6 0 0 0 0 11
10news.swapon.de 42 0 0 0 0 0 0 0 42
11news.freedyn.net 37 1 0 7 0 0 0 0 29
12agency-nz-out.news.mb-net.net 30 12 0 5 0 0 0 0 13
13news.samoylyk.net 24 0 0 10 0 0 0 0 14
14feeder.awxg.com 14 0 0 12 0 0 0 0 2
15csiph.com 11 0 0 11 0 0 0 0 0
16news.ausics.org 7 0 0 7 0 0 0 0 0
TOTAL: 16 4396 162 0 138 0 0 0 0 4096

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.comp.gis.openstreetmap.tagging 45
gmane.linux.alsa.devel 18
mozilla.dev.security.policy 16
mozilla.dev.ui-alerts 9
gmane.linux.kernel 8
alt.music.pink-floyd.publius 7
gmane.comp.gis.openstreetmap.region.au 4
it.annunci.commerciali 3
alt.aviation 3
it.annunci.immobiliari 3
fr.rec.photo.numerique 3
mozilla.apis 3
it.annunci.varie 3
fido7.ru.android 3
mozilla.dev.planning 2
gmane.linux.kernel.stable 2
mozilla.support.bugzilla 2
alt.sex.girl 2
mozilla.dev.l10n.web 1
aol.buy.and.sell 1
TOTAL: 44 162

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2777
EMP (phn path) 520
Binary: non-binary distribution 101
EMP (phl) 97
User-issued cancel 76
EMP (phn nph) 66
Too many newsgroups 64
User-issued spam cancel 37
Binary: misplaced par2 34
Binary: misplaced 010 2
Binary: misplaced rar 2
Binary: misplaced PAR2 2
Binary Image: misplaced jpg 1
Too many newsgroups (meow) 1
Binary: misplaced zip 1
HTML Multipart without Text/Plain. 1
HTML post 1
Binary: misplaced 137 1
Binary Image: misplaced png 1
TOTAL: 19 3785

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 1
TOTAL: 1 1
Including strange strings
bbs-nz-out.news.weretis.net 66
news-out.mixmin.net 62
news.albasani.net 61
news.redatomik.org 45
news.swapon.de 42
bbsnz-out.feed.uzoreto.com 16
news-out.aioe.org 6
newsfeed.neva.ru 5
news.samoylyk.net 1
feeder.eternal-september.org 1
TOTAL: 13 308
TOTAL: 3 312

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 16715 930 15771 14 0 0 5%23:59:23
2news.samoylyk.net 16757 95 16558 2 0 186 0%23:59:48
3awxg 18207 28 18173 2 0 0 0%23:59:48
4news.snarked.org 15802 13 15626 2 0 138 0%23:59:48
5aioe 15813 5 15717 0 0 0 0%23:59:43
6weretis.net 14091 4 13956 5 0 0 0%23:59:48
7news.freedyn.net 18483 3 18405 0 0 1 0%23:59:44
8news-in.mixmin.net 17297 3 17278 1 0 0 0%23:59:42
9news.uzoreto.com 14957 3 14952 0 0 0 0%23:59:47
10news.redatomik.org 17278 3 17252 0 0 1 0%23:59:34
11eternal-september 15720 3 15689 0 0 0 0%23:59:48
12csiph.com 18340 3 18279 0 0 0 0%23:59:48
13mb-net.net 18466 2 18400 0 0 60 0%23:59:48
14neva.ru 17013 2 17010 0 0 0 0%23:59:48
15news.albasani.net 19726 0 16399 997 0 6626 0%23:59:48
16news.swapon.de 1443 0 1443 0 0 0 0%23:53:12
TOTAL: 16 256108 1097 250908 1023 0 7012 0%383:49:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.2 MB204.6 KB6.4 MB0.1 KB/s6.9 KB23:59:23
2news.samoylyk.net316.5 KB2.7 KB319.2 KB0.0 KB/s3.3 KB23:59:48
3awxg91.4 KB8.8 KB100.2 KB0.0 KB/s3.3 KB23:59:48
4news.snarked.org34.4 KB3.7 KB38.1 KB0.0 KB/s2.5 KB23:59:48
5aioe11.3 KB0.0 KB11.3 KB0.0 KB/s2.3 KB23:59:43
6weretis.net5.5 KB13.4 KB18.9 KB0.0 KB/s2.1 KB23:59:48
7news.freedyn.net3.7 KB0.0 KB3.7 KB0.0 KB/s1.2 KB23:59:44
8news-in.mixmin.net3.7 KB6.4 KB10.1 KB0.0 KB/s2.5 KB23:59:42
9news.uzoreto.com3.7 KB0.0 KB3.7 KB0.0 KB/s1.2 KB23:59:47
10news.redatomik.org3.7 KB0.0 KB3.7 KB0.0 KB/s1.2 KB23:59:34
11eternal-september3.7 KB0.0 KB3.7 KB0.0 KB/s1.2 KB23:59:48
12csiph.com3.7 KB0.0 KB3.7 KB0.0 KB/s1.2 KB23:59:48
13mb-net.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:48
14neva.ru2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:59:48
15news.albasani.net0.0 KB3.9 MB3.9 MB0.0 KB/s4.0 KB23:59:48
16news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:12
TOTAL: 166.7 MB4.1 MB10.8 MB0.0 KB/s5.2 KB383:49:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 386 582820.2 MB 3225 3 000:15:27
2vorlon.activateit.net.au 24 10801.4 MB 157 0 000:05:12
3amigacity.xyz 72 3380.1 KB 18 0 28800:12:28
460.234.68.122 6 1967.4 KB 1 0 000:20:22
TOTAL: 4 488 696021.8 MB 3401 3 28836:21:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 386 582820.2 MB 3225 3 000:15:27
2*.activateit.net.au 24 10801.4 MB 157 0 000:05:12
3*.xyz 72 3380.1 KB 18 0 28800:12:28
4unresolved 12 1967.4 KB 1 0 000:24:41
5*.cpe.cableone.net 1 00.0 KB 0 0 035:24:06
TOTAL: 5 495 696021.8 MB 3401 3 28836:21:58

NNRP auth users [Top 20]:

UserConn
amigacity 72
amybbs 24
crash 4
malcolmlewis 1
TOTAL: 4 101

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
160-3-236-103.cpe.cableone.net 0.188 0.120 0.03235:24:06
60.234.68.122 0.440 0.032 0.01100:20:22
agency.bbs.nz 28.792 6.368 0.00000:15:27
amigacity.xyz 3.948 0.832 0.33100:12:28
vorlon.activateit.net.au 1.500 0.412 0.05400:05:12
118.149.213.99 0.116 0.024 0.00000:02:03
118.149.170.158 0.144 0.000 0.00000:02:02
107.170.198.249 0.060 0.004 0.00000:00:09
94.162.64.60 0.052 0.012 0.00000:00:02
? 1.100 0.148 0.00000:00:01
TOTAL: 10 36.340 7.952 0.42836:21:58

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.213.99 2
118.149.170.158 2
107.170.198.249 1
94.162.64.60 1
160-3-236-103.cpe.cableone.net 1
TOTAL: 5 7

NNRP gethostbyaddr failures [Top 20]:

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

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 2658 38.2%
2soc 840 12.1%
3uk 765 11.0%
4comp 715 10.3%
5sci 662 9.5%
6linux 591 8.5%
7alt 311 4.5%
8talk 182 2.6%
9misc 101 1.5%
10news 48 0.7%
11nz 20 0.3%
12microsoft 18 0.3%
13mozilla 17 0.2%
14agency 10 0.1%
15humanities 7 0.1%
16aus 6 0.1%
TOTAL: 16 6951100.0%

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

NewsgroupCount
1rec.arts.tv 700
2uk.d-i-y 374
3rec.arts.drwho 266
4rec.food.cooking 263
5rec.gambling.poker 212
6linux.debian.bugs.dist 207
7alt.comp.os.windows-10 198
8rec.arts.sf.written 195
9comp.lang.c 175
10uk.legal 156
11sci.physics 151
12rec.sport.football.college 147
13rec.boats 141
14linux.debian.changes.devel 120
15linux.debian.bugs.rc 120
16comp.lang.python 117
17uk.radio.amateur 110
18talk.origins 107
19soc.culture.polish 106
20soc.culture.israel 106
21soc.retirement 91
22sci.math 87
23comp.os.linux.advocacy 86
24rec.bicycles.tech 74
25soc.culture.brazil 72
26soc.culture.indian 66
27rec.drugs.cannabis 64
28soc.penpals 62
29talk.politics.guns 60
30sci.electronics.design 59
31sci.logic 56
32sci.physics.relativity 55
33rec.sport.tennis 54
34uk.legal.moderated 52
35rec.arts.sf.tv 50
36sci.med.pharmacy 47
37rec.sport.pro-wrestling 47
38sci.med.cardiology 41
39rec.aviation.soaring 41
40comp.mobile.android 40
41soc.culture.greek 37
42linux.debian.user 35
43comp.lang.c++ 34
44rec.autos.sport.f1 34
45linux.debian.devel.release 31
46sci.lang 30
47rec.outdoors.rv-travel 30
48soc.culture.usa 29
49soc.culture.china 29
50rec.photo.digital 27
51misc.phone.mobile.iphone 27
52misc.news.internet.discuss 27
53sci.bio.paleontology 27
54alt.bbs.synchronet 26
55comp.lang.forth 25
56soc.history.living 25
57sci.math.num-analysis 23
58news.admin.net-abuse.email 23
59alt.politics.trump 23
60uk.comp.sys.mac 23
61news.lists.filters 22
62soc.genealogy.britain 22
63comp.os.vms 21
64uk.tech.digital-tv 21
65sci.astro.amateur 21
66alt.conspiracy.jfk 20
67misc.survivalism 20
68nz.general 20
69rec.games.pinball 19
70alt.test 19
71rec.music.rock-pop-r+b.1950s 18
72linux.debian.user.german 17
73soc.genealogy.medieval 16
74comp.lang.prolog 15
75misc.health.diabetes 15
76comp.lang.tcl 15
77rec.games.backgammon 14
78comp.arch 14
79sci.anthropology.paleo 14
80sci.military.naval 14
81alt.os.linux.ubuntu 13
82comp.sys.apple2 13
83rec.arts.movies.current-films 13
84soc.history 12
85rec.audio.opinion 12
86comp.sys.mac.system 12
87rec.music.classical.recordings 12
88rec.sport.soccer 11
89soc.culture.japan 11
90comp.lang.fortran 11
91microsoft.public.windowsxp.general 11
92linux.debian.user.italian 11
93soc.culture.turkish 11
94comp.sys.raspberry-pi 10
95agency.test 10
96rec.woodworking 10
97comp.lang.javascript 10
98soc.history.medieval 10
99comp.databases.ingres 10
100rec.arts.theatre.musicals 9
TOTAL: 323 6951