news.bbs.geek.nz daily logs

Sep 29 23:58:01 -- Sep 30 23:58:01

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 86308 51.0%7.0 MB 30.6%
innd 30902 18.3%5.1 MB 22.1%
inn 27283 16.1%6.0 MB 26.4%
innfeed 23295 13.8%4.5 MB 19.8%
cnfsstat 1440 0.9%256.7 KB 1.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 169229 100.0%22.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 260534 47.9%
Positive hits 256806 47.3%
Do not exist 25815 4.8%
Cache misses 212 0.0%
TOTAL: 4 543367 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.238 0.0%164 0.000 1.451 23.000
article cleanup00:00:00.265 0.0%26850 0.000 0.010 0.032
article logging00:00:00.657 0.0%27137 0.000 0.024 0.058
article parse00:00:00.902 0.0%77572 0.000 0.012 0.026
article write00:00:01.560 0.0%19659 0.014 0.079 1.211
artlog/artcncl00:00:00.002 0.0%162 0.000 0.012 0.100
data move00:00:00.379 0.0%511459 0.000 0.001 0.014
hisgrep/artcncl00:00:00.003 0.0%160 0.000 0.019 0.071
hishave/artcncl00:00:00.000 0.0%164 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.765 0.0%545237 0.001 0.011 0.510
history sync00:00:00.016 0.0%366 0.000 0.044 0.500
history write00:00:06.261 0.0%25884 0.018 0.242 14.085
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:57:55.388 99.8%528659 86.109 163.197 477.311
nntp read00:00:03.098 0.0%530124 0.003 0.006 0.015
overview write00:00:36.187 0.0%19659 0.056 1.841 41.148
perl filter00:00:57.781 0.1%25884 1.343 2.232 31.636
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.264 0.0%39318 0.004 0.032 0.127
TOTAL: 24:00:51.05423:59:49.766 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.094 0.0%41397 0.000 0.002 0.025
article prepare00:00:00.003 0.0%10702 0.000 0.000 0.008
article read00:00:00.324 0.0%2409 0.000 0.134 5.414
backlog stats00:00:00.310 0.0%325361 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.583 0.0%265709 0.001 0.006 0.014
data write00:00:02.892 0.0%253653 0.004 0.011 0.022
idle23:54:20.711100.0%325361 121.661 264.508 829.930
status file00:00:17.130 0.0%1948 0.714 8.794 386.611
TOTAL: 23:54:58.77423:54:43.047100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%34 0.000 0.029 0.050
idle19:05:15.905 97.7%100213 0.000 685.699 83273.960
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:02:41.150 0.2%231606 0.000 0.696 15.702
readart00:00:03.573 0.0%15817 0.000 0.226 48.619
TOTAL: 19:32:49.33319:08:00.629 97.9%----

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 40 17520 5109 12052 359 29%45:56:41
2newsfeed.datemas.de 4 20210 4169 15364 677 20%23:05:17
3news-out.mixmin.net 12 21338 3006 16958 1374 14%26:35:12
4feeder.eternal-september.org 78 23825 1867 21110 848 7%48:52:59
5news-out.aioe.org 1 15642 1434 14025 183 9%15:56:37
6newsfeed.neva.ru 149 15150 1426 11393 2331 9%82:10:22
7csiph.com 2 18030 907 17069 54 5%20:14:14
8news.redatomik.org 1 20659 713 19860 86 3%25:49:07
9news.albasani.net 2 21424 252 20960 212 1%23:42:10
10news.samoylyk.net 3 26302 206 25526 570 0%25:20:20
11feeder.awxg.com 1 18746 156 18509 81 0%23:59:57
12news.swapon.de 5 1611 134 1470 7 8%23:33:41
13news.freedyn.net 3 22541 69 22391 81 0%24:16:33
14agency-nz-out.news.mb-net.net 23 22962 63 22764 135 0%30:58:58
15localhost 11 10 9 0 1 90%00:00:00
TOTAL: 15 335 265970 19520 239451 6999 7%440:32:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.0 MB241.2 KB1.5 MB22.8 MB 92%4.3 KB
2newsfeed.datemas.de15.8 MB382.7 KB2.3 MB18.5 MB 85%3.9 KB
3news-out.mixmin.net9.4 MB479.8 KB3.0 MB12.8 MB 73%3.0 KB
4feeder.eternal-september.org8.8 MB623.1 KB3.2 MB12.6 MB 69%4.7 KB
5newsfeed.neva.ru3.9 MB278.8 KB9.9 MB14.1 MB 27%3.8 KB
6news-out.aioe.org3.3 MB195.1 KB465.4 KB4.0 MB 83%2.5 KB
7csiph.com2.5 MB227.2 KB234.2 KB3.0 MB 84%3.2 KB
8news.redatomik.org2.2 MB415.2 KB418.8 KB3.0 MB 73%3.9 KB
9news.albasani.net2.1 MB311.9 KB808.2 KB3.2 MB 65%7.0 KB
10news.samoylyk.net1.3 MB420.6 KB9.1 MB10.8 MB 11%14.2 KB
11news.freedyn.net746.7 KB353.8 KB568.7 KB1.6 MB 44%11.1 KB
12feeder.awxg.com529.5 KB451.4 KB465.1 KB1.4 MB 36%6.1 KB
13news.swapon.de358.7 KB12.1 KB87.6 KB458.4 KB 78%3.3 KB
14agency-nz-out.news.mb-net.net243.4 KB403.4 KB4.5 MB5.1 MB 4%26.6 KB
15localhost17.4 KB0.0 KB2.2 KB19.6 KB 88%2.0 KB
TOTAL: 1572.2 MB4.7 MB36.5 MB113.4 MB 63%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 29 23:58:01 - 23:59:59 30 0.2% 0.2574.1 KB 0.1% 0.62
Sep 30 00:00:00 - 00:59:59 856 4.4% 0.243.2 MB 4.4% 0.90
Sep 30 01:00:00 - 01:59:59 857 4.4% 0.242.2 MB 3.0% 0.62
Sep 30 02:00:00 - 02:59:59 1068 5.4% 0.303.5 MB 4.8% 0.99
Sep 30 03:00:00 - 03:59:59 1117 5.7% 0.313.4 MB 4.8% 0.97
Sep 30 04:00:00 - 04:59:59 1311 6.7% 0.365.2 MB 7.3% 1.49
Sep 30 05:00:00 - 05:59:59 1274 6.5% 0.353.8 MB 5.3% 1.09
Sep 30 06:00:00 - 06:59:59 1160 5.9% 0.323.6 MB 5.0% 1.02
Sep 30 07:00:00 - 07:59:59 1225 6.2% 0.345.0 MB 7.0% 1.43
Sep 30 08:00:00 - 08:59:59 1081 5.5% 0.303.0 MB 4.1% 0.85
Sep 30 09:00:00 - 09:59:59 1126 5.7% 0.313.4 MB 4.7% 0.97
Sep 30 10:00:00 - 10:59:59 1012 5.2% 0.284.0 MB 5.6% 1.15
Sep 30 11:00:00 - 11:59:59 780 4.0% 0.223.4 MB 4.7% 0.96
Sep 30 12:00:00 - 12:59:59 594 3.0% 0.172.2 MB 3.1% 0.62
Sep 30 13:00:00 - 13:59:59 437 2.2% 0.121.6 MB 2.2% 0.44
Sep 30 14:00:00 - 14:59:59 530 2.7% 0.152.5 MB 3.4% 0.70
Sep 30 15:00:00 - 15:59:59 439 2.2% 0.121.8 MB 2.5% 0.52
Sep 30 16:00:00 - 16:59:59 367 1.9% 0.101.3 MB 1.8% 0.37
Sep 30 17:00:00 - 17:59:59 337 1.7% 0.091.5 MB 2.1% 0.44
Sep 30 18:00:00 - 18:59:59 375 1.9% 0.102.1 MB 2.9% 0.60
Sep 30 19:00:00 - 19:59:59 523 2.7% 0.153.4 MB 4.7% 0.97
Sep 30 20:00:00 - 20:59:59 714 3.6% 0.203.9 MB 5.4% 1.11
Sep 30 21:00:00 - 21:59:59 816 4.2% 0.233.3 MB 4.6% 0.94
Sep 30 22:00:00 - 22:59:59 804 4.1% 0.222.4 MB 3.4% 0.69
Sep 30 23:00:00 - 23:58:01 812 4.1% 0.232.2 MB 3.0% 0.64
TOTAL: 24:00:00 19645 100.0% 0.2372.0 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB20.4 GB 40.8% 0 0.34 1762.30
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB23.6 GB 47.2% 0 0.33 1828.81
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB252.4 MB 0.5% 0 0.0417204.30
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 GB9.1 GB 18.3% 0 0.69 875.00
TOTAL: 10-500.0 GB53.4 GB 10.7% 1 0.45-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2391 104 0 55 0 0 0 0 2232
2news-out.mixmin.net 1536 0 0 97 0 0 0 0 1439
3feeder.eternal-september.org 883 0 0 152 0 0 0 0 731
4newsfeed.datemas.de 801 180 0 65 0 0 0 0 556
5news.samoylyk.net 607 0 0 83 0 0 0 0 524
6news.snarked.org 372 46 0 65 0 0 0 0 261
7news.albasani.net 239 3 0 68 0 0 0 0 168
8news-out.aioe.org 195 3 0 64 0 0 0 0 128
9agency-nz-out.news.mb-net.net 134 12 0 61 0 0 0 0 61
10news.freedyn.net 80 1 0 49 0 0 0 0 30
11news.redatomik.org 74 0 0 67 0 0 0 0 7
12feeder.awxg.com 68 1 0 63 0 0 0 0 4
13csiph.com 65 0 0 61 0 0 0 0 4
14news.swapon.de 26 0 0 3 0 0 0 0 23
15news.ausics.org 4 0 0 4 0 0 0 0 0
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 7476 350 0 957 0 0 0 0 6169

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 70
it.annunci.immobiliari 40
it.annunci.varie 37
it.annunci.commerciali 36
mpc.lists.freebsd.ports.bugs 35
gmane.comp.gis.openstreetmap.tagging 27
mpc.lists.nanog 19
mozilla.governance 10
mozilla.dev.security.policy 6
mpc.lists.freebsd.gecko 5
gmane.linux.kernel 5
mozilla.dev.platform 4
fido7.ru.android 4
mpc.lists.freebsd.x11 4
mozilla.support.seamonkey 4
gmane.linux.kernel.renesas-soc 3
al.christnet.bible 3
mozilla.dev.ui-alerts 2
ntu-kpi.misc.questions 2
mozilla.support.bugzilla 2
TOTAL: 49 350

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4999
EMP (phn path) 400
EMP (phn nph) 165
Binary Image: misplaced jpg 151
Too many newsgroups 48
Too many newsgroups (low_xpost) 34
EMP (phl) 33
Binary: non-binary distribution 28
User-issued cancel 15
HTML post 5
Cancel for rejected article 3
Too many newsgroups (meow) 1
Binary: misplaced torr 1
TOTAL: 13 5883

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 146
newsfeed.datemas.de 88
news.swapon.de 21
news.albasani.net 11
newsfeed.neva.ru 7
news.redatomik.org 5
news.snarked.org 2
news-out.aioe.org 2
feeder.awxg.com 2
news.samoylyk.net 1
TOTAL: 11 286
TOTAL: 1 286

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17551 1341 16144 65 1 0 7%23:59:47
2awxg 19106 76 19007 1 0 8 0%23:59:44
3news.snarked.org 33396 32 14228 7 0 15354 0%23:59:47
4news.freedyn.net 20706 25 19545 4 0 41 0%23:59:36
5eternal-september 17138 11 16953 1 0 137 0%23:59:47
6csiph.com 18813 10 18717 0 0 0 0%23:59:47
7mb-net.net 19630 9 19550 0 0 0 0%23:59:47
8news.redatomik.org 19011 9 18944 1 0 0 0%23:59:28
9aioe 16706 9 16560 0 0 1 0%23:59:47
10neva.ru 17862 9 17848 0 0 0 0%23:59:47
11news-in.mixmin.net 15987 9 15963 0 0 1 0%23:59:38
12news.samoylyk.net 17419 8 17373 1 0 0 0%23:59:25
13news.albasani.net 20594 6 17892 950 0 6090 0%23:59:47
14newsfeed.datemas.de 15359 2 15285 0 0 204 0%23:59:47
15news.swapon.de 1552 0 1551 0 0 0 0%23:53:39
TOTAL: 15 270830 1556 245560 1030 1 21836 0%359:49:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org14.6 MB2.6 MB17.2 MB0.2 KB/s12.5 KB23:59:47
2news.freedyn.net427.7 KB132.0 KB559.7 KB0.0 KB/s19.3 KB23:59:36
3awxg229.6 KB2.3 KB231.9 KB0.0 KB/s3.0 KB23:59:44
4news.snarked.org85.5 KB12.2 KB97.7 KB0.0 KB/s2.5 KB23:59:47
5eternal-september19.8 KB2.6 KB22.4 KB0.0 KB/s1.9 KB23:59:47
6csiph.com19.1 KB0.0 KB19.1 KB0.0 KB/s1.9 KB23:59:47
7mb-net.net17.4 KB0.0 KB17.4 KB0.0 KB/s1.9 KB23:59:47
8news.redatomik.org17.4 KB97.0 KB114.5 KB0.0 KB/s11.4 KB23:59:28
9aioe17.4 KB0.0 KB17.4 KB0.0 KB/s1.9 KB23:59:47
10neva.ru17.4 KB0.0 KB17.4 KB0.0 KB/s1.9 KB23:59:47
11news-in.mixmin.net17.4 KB0.0 KB17.4 KB0.0 KB/s1.9 KB23:59:38
12news.samoylyk.net15.2 KB1.3 KB16.6 KB0.0 KB/s1.8 KB23:59:25
13news.albasani.net11.7 KB3.5 MB3.5 MB0.0 KB/s3.8 KB23:59:47
14newsfeed.datemas.de2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:47
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:39
TOTAL: 1515.5 MB6.3 MB21.8 MB0.0 KB/s8.6 KB359:49:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 293 647827.9 MB 3027 6 000:09:54
267-61-21-181.cpe.cableone.net 4 629124.6 MB 645 3 1002:21:03
3163.47.16.169 24 11911.6 MB 139 0 000:05:19
4192.168.1.9 1 2752.7 MB 13 0 000:00:12
560.234.244.55 10 64163.1 KB 1 0 000:31:09
TOTAL: 5 332 1429956.9 MB 3825 9 1019:32:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 293 647827.9 MB 3027 6 000:09:54
2*.cpe.cableone.net 11 629124.6 MB 645 3 1018:22:51
3unresolved 40 15304.5 MB 153 0 000:59:55
TOTAL: 3 344 1429956.9 MB 3825 9 1019:32:44

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 6
malcolmlewis 4
bpanther 4
paulh 1
TOTAL: 5 39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.312 0.104 0.00716:01:48
67-61-21-181.cpe.cableone.net 0.888 0.720 0.01202:21:03
60.234.244.55 0.700 0.080 0.01800:31:09
118.149.237.225 0.256 0.024 0.00000:18:12
agency.bbs.geek.nz 20.444 4.848 0.00000:09:54
163.47.16.169 1.404 0.388 0.20300:05:19
118.149.202.64 0.064 0.004 0.00000:05:01
192.168.1.9 0.176 0.044 0.00300:00:12
? 1.304 0.124 0.00000:00:02
TOTAL: 9 25.548 6.336 0.24319:32:44

Curious NNRP server explorers [Top 20]:

SystemConn
67-60-219-146.cpe.cableone.net 7
118.149.237.225 4
118.149.202.64 1
TOTAL: 3 12

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 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 6155 43.1%
2comp 1919 13.5%
3sci 1840 12.9%
4soc 1451 10.2%
5alt 1342 9.4%
6talk 482 3.4%
7misc 377 2.6%
8news 330 2.3%
9nz 119 0.8%
10uk 79 0.6%
11mozilla 58 0.4%
12aus 42 0.3%
13humanities 36 0.3%
14agency 30 0.2%
15eternal-september 5 0.0%
TOTAL: 15 14265100.0%

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

NewsgroupCount
1rec.arts.tv 1814
2rec.food.cooking 600
3comp.lang.python 396
4sci.physics.relativity 388
5rec.arts.drwho 381
6sci.electronics.design 381
7alt.atheism 372
8comp.os.linux.advocacy 354
9rec.sport.golf 344
10soc.retirement 338
11rec.sport.tennis 322
12rec.sport.football.college 283
13comp.lang.c 261
14rec.sport.pro-wrestling 252
15sci.math 239
16talk.politics.guns 232
17sci.physics 229
18alt.comp.os.windows-10 221
19news.lists.filters 209
20misc.survivalism 195
21soc.culture.polish 178
22rec.photo.digital 176
23rec.gambling.poker 173
24alt.bible 170
25rec.boats 164
26soc.culture.israel 154
27sci.med.pharmacy 135
28rec.sport.soccer 129
29rec.arts.sf.tv 127
30misc.health.alternative 124
31talk.politics.misc 121
32soc.culture.china 120
33rec.arts.sf.written 115
34nz.general 113
35talk.origins 112
36rec.bicycles.tech 109
37alt.test 89
38sci.logic 86
39rec.aviation.soaring 84
40alt.politics 80
41uk.radio.amateur 79
42soc.culture.indian 79
43rec.autos.sport.f1 75
44comp.sys.acorn.misc 73
45soc.culture.romanian 71
46alt.recovery.aa 70
47rec.music.classical.recordings 69
48soc.culture.singapore 68
49alt.os.linux.ubuntu 65
50sci.astro.amateur 59
51comp.sys.apple2 58
52comp.lang.c++ 56
53news.software.readers 54
54soc.culture.vietnamese 54
55soc.culture.usa 54
56alt.support.diabetes 53
57rec.music.dylan 53
58comp.lang.forth 52
59rec.arts.movies.current-films 51
60sci.med.cardiology 49
61comp.protocols.time.ntp 48
62alt.bbs.mystic 45
63alt.books.reviews 45
64comp.mobile.android 44
65sci.math.num-analysis 44
66comp.lang.javascript 42
67misc.phone.mobile.iphone 41
68rec.aquaria.marine.misc 40
69rec.outdoors.rv-travel 40
70rec.sport.cricket 39
71sci.lang 39
72alt.astronomy 39
73comp.lang.lisp 39
74rec.arts.sf.fandom 39
75comp.unix.programmer 38
76rec.crafts.metalworking 36
77soc.genealogy.britain 36
78aus.computers 35
79soc.penpals 34
80rec.games.video.sony 34
81news.answers 33
82sci.military.naval 33
83alt.bbs.ads 32
84comp.soft-sys.sas 32
85mozilla.support.firefox 32
86agency.test 30
87comp.soft-sys.math.scilab 30
88humanities.lit.authors.shakespeare 28
89soc.history.what-if 28
90rec.audio.opinion 28
91comp.sys.mac.apps 27
92rec.audio.pro 26
93rec.radio.shortwave 26
94comp.sys.mac.system 25
95rec.radio.amateur.misc 25
96rec.arts.movies.past-films 24
97rec.aviation.marketplace 24
98rec.arts.tv.soaps.cbs 24
99rec.radio.info 21
100alt.tv.days-of-our-lives 21
TOTAL: 322 14265