news.bbs.geek.nz daily logs

Feb 20 23:58:01 -- Feb 21 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 135757 58.9%11.3 MB 39.8%
innfeed 40491 17.6%6.4 MB 22.7%
innd 26359 11.4%4.3 MB 15.2%
inn 26331 11.4%6.1 MB 21.4%
cnfsstat 1440 0.6%253.7 KB 0.9%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 230379 100.0%28.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 243986 46.3%
Positive hits 241340 45.8%
Do not exist 25246 4.8%
Cache misses 16434 3.1%
TOTAL: 4 527006 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.976 0.0%158 0.000 6.177 58.571
article cleanup00:00:00.212 0.0%25540 0.000 0.008 0.029
article logging00:00:00.697 0.0%26196 0.000 0.027 0.161
article parse00:00:00.754 0.0%59066 0.000 0.013 0.032
article write00:00:01.458 0.0%20399 0.000 0.071 0.932
artlog/artcncl00:00:00.003 0.0%157 0.000 0.019 1.000
data move00:00:00.317 0.0%480188 0.000 0.001 0.005
hisgrep/artcncl00:00:00.330 0.0%140 0.000 2.357 23.357
hishave/artcncl00:00:00.325 0.0%158 0.000 2.057 23.214
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.920 0.0%529372 0.001 0.015 1.199
history sync00:00:00.014 0.0%364 0.000 0.038 0.500
history write00:00:06.382 0.0%25389 0.019 0.251 11.284
hiswrite/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
idle23:58:09.467 99.8%490706 77.643 175.848 386.591
nntp read00:00:02.495 0.0%491120 0.002 0.005 0.011
overview write00:00:45.067 0.1%20399 0.067 2.209 74.323
perl filter00:00:48.239 0.1%25389 1.273 1.900 3.900
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.154 0.0%40798 0.007 0.053 0.132
TOTAL: 24:00:55.57324:00:06.810 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.076 0.0%30117 0.000 0.003 0.020
article prepare00:00:00.002 0.0%6478 0.000 0.000 0.012
article read00:00:00.694 0.0%1489 0.000 0.466 8.750
backlog stats00:00:00.214 0.0%328267 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.276 0.0%265438 0.001 0.005 0.012
data write00:00:01.887 0.0%249146 0.002 0.008 0.019
idle23:53:21.859 99.9%328267 118.044 261.988 540.823
status file00:00:58.783 0.1%8626 0.875 6.815 454.197
TOTAL: 23:54:40.47923:54:24.791100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle40:17:02.350 99.5%155229 0.000 934.248 74145.544
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:39.664 0.0%347054 0.000 0.114 1.730
readart00:00:04.205 0.0%17757 0.000 0.237 18.343
TOTAL: 40:29:02.63540:17:46.219 99.5%----

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 31 20299 4508 15274 517 22%31:35:52
2news-out.aioe.org 3 20116 3034 17027 55 15%24:36:32
3csiph.com 2 18626 2708 15898 20 14%22:28:58
4feeder.eternal-september.org 15 24073 2209 21229 635 9%21:33:38
5news.albasani.net 1 16738 2209 13952 577 13%16:44:57
6news-out.mixmin.net 6 22804 2138 20262 404 9%17:34:29
7newsfeed.datemas.de 3 22426 1507 20444 475 6%24:31:31
8newsfeed.neva.ru 146 13861 1304 10147 2410 9%72:48:00
9news.redatomik.org 1 19448 521 18880 47 2%23:59:34
10news.samoylyk.net 2 19065 171 18881 13 0%23:47:18
11news.swapon.de 4 1355 112 1241 2 8%11:13:11
12agency-nz-out.news.mb-net.net 7 23059 79 22939 41 0%16:39:27
13news.freedyn.net 2 19283 49 19202 32 0%20:45:12
14feeder.awxg.com 3 14204 32 14166 6 0%09:36:18
15localhost 2 1 1 0 0 100%00:00:00
16news.ausics.org 1 12118 0 12118 0 0%17:42:41
TOTAL: 16 229 267476 20582 241660 5234 7%355:37:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org15.3 MB146.5 KB2.3 MB17.8 MB 86%3.6 KB
2feeder.eternal-september.org8.3 MB374.1 KB3.6 MB12.3 MB 67%4.4 KB
3newsfeed.datemas.de7.9 MB75.3 KB3.0 MB11.0 MB 72%5.7 KB
4csiph.com7.8 MB1.5 KB73.9 KB7.9 MB 99%3.0 KB
5news-out.aioe.org7.8 MB41.3 KB138.9 KB8.0 MB 97%2.6 KB
6news.albasani.net7.6 MB37.7 KB1.1 MB8.8 MB 86%3.2 KB
7news-out.mixmin.net6.3 MB190.7 KB1015.3 KB7.5 MB 84%3.0 KB
8newsfeed.neva.ru3.3 MB64.8 KB7.2 MB10.5 MB 31%2.9 KB
9news.redatomik.org1.9 MB133.9 KB214.6 KB2.2 MB 84%4.0 KB
10news.freedyn.net1.4 MB108.4 KB185.3 KB1.7 MB 82%20.9 KB
11news.samoylyk.net909.9 KB13.7 KB354.5 KB1.2 MB 71%6.9 KB
12agency-nz-out.news.mb-net.net375.9 KB18.9 KB239.7 KB634.4 KB 59%5.3 KB
13news.swapon.de290.1 KB1.3 KB3.4 KB294.8 KB 98%2.6 KB
14feeder.awxg.com77.9 KB12.4 KB12.4 KB102.7 KB 75%2.7 KB
15localhost1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
16news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1669.3 MB1.2 MB19.4 MB89.9 MB 77%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 20 23:58:01 - 23:59:59 25 0.1% 0.2153.7 KB 0.1% 0.45
Feb 21 00:00:00 - 00:59:59 934 4.6% 0.262.4 MB 3.5% 0.68
Feb 21 01:00:00 - 01:59:59 839 4.1% 0.232.6 MB 3.8% 0.73
Feb 21 02:00:00 - 02:59:59 971 4.8% 0.273.0 MB 4.4% 0.85
Feb 21 03:00:00 - 03:59:59 957 4.7% 0.273.6 MB 5.3% 1.03
Feb 21 04:00:00 - 04:59:59 1166 5.7% 0.323.2 MB 4.7% 0.91
Feb 21 05:00:00 - 05:59:59 1205 5.9% 0.334.2 MB 6.3% 1.21
Feb 21 06:00:00 - 06:59:59 1233 6.1% 0.343.2 MB 4.7% 0.91
Feb 21 07:00:00 - 07:59:59 1212 5.9% 0.344.1 MB 6.1% 1.17
Feb 21 08:00:00 - 08:59:59 1070 5.3% 0.303.4 MB 5.1% 0.98
Feb 21 09:00:00 - 09:59:59 1039 5.1% 0.293.1 MB 4.6% 0.89
Feb 21 10:00:00 - 10:59:59 1141 5.6% 0.323.8 MB 5.6% 1.09
Feb 21 11:00:00 - 11:59:59 944 4.6% 0.263.9 MB 5.7% 1.11
Feb 21 12:00:00 - 12:59:59 699 3.4% 0.192.3 MB 3.4% 0.66
Feb 21 13:00:00 - 13:59:59 656 3.2% 0.182.7 MB 4.0% 0.77
Feb 21 14:00:00 - 14:59:59 528 2.6% 0.151.7 MB 2.4% 0.47
Feb 21 15:00:00 - 15:59:59 419 2.1% 0.121.1 MB 1.7% 0.32
Feb 21 16:00:00 - 16:59:59 494 2.4% 0.141.8 MB 2.6% 0.51
Feb 21 17:00:00 - 17:59:59 449 2.2% 0.122.5 MB 3.6% 0.70
Feb 21 18:00:00 - 18:59:59 598 2.9% 0.172.5 MB 3.7% 0.71
Feb 21 19:00:00 - 19:59:59 522 2.6% 0.141.9 MB 2.8% 0.54
Feb 21 20:00:00 - 20:59:59 678 3.3% 0.192.9 MB 4.3% 0.82
Feb 21 21:00:00 - 21:59:59 759 3.7% 0.212.3 MB 3.4% 0.65
Feb 21 22:00:00 - 22:59:59 896 4.4% 0.252.8 MB 4.1% 0.80
Feb 21 23:00:00 - 23:58:02 941 4.6% 0.272.8 MB 4.1% 0.82
TOTAL: 24:00:01 20375 100.0% 0.2467.9 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.8 GB 47.7% 0 0.32 1919.46
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.6 GB 55.3% 0 0.35 1723.59
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB294.8 MB 0.6% 0 0.0416059.07
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 GB17.0 GB 34.1% 0 0.64 949.02
TOTAL: 10-500.0 GB68.8 GB 13.8% 1 0.42-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2396 67 0 16 0 0 0 0 2313
2news.albasani.net 708 19 0 12 0 0 0 0 677
3feeder.eternal-september.org 660 0 0 20 0 0 0 0 640
4news-out.mixmin.net 660 0 0 23 0 0 0 0 637
5news.snarked.org 519 18 0 13 0 0 0 0 488
6newsfeed.datemas.de 497 88 0 11 0 0 0 0 398
7news.redatomik.org 102 0 0 16 0 0 0 0 86
8news-out.aioe.org 69 0 0 12 0 0 0 0 57
9news.swapon.de 68 0 0 1 0 0 0 0 67
10agency-nz-out.news.mb-net.net 45 15 0 8 0 0 0 0 22
11news.freedyn.net 26 3 0 4 0 0 0 0 19
12csiph.com 21 0 0 1 0 0 0 0 20
13news.samoylyk.net 19 0 0 7 0 0 0 0 12
14feeder.awxg.com 9 0 0 7 0 0 0 0 2
TOTAL: 14 5799 210 0 151 0 0 0 0 5438

Unwanted newsgroups [Top 20]:

NewsgroupCount
gmane.linux.alsa.devel 53
mpc.lists.freebsd.ports.bugs 26
gmane.comp.gis.openstreetmap.tagging 18
mpc.lists.freebsd.office 12
mozilla.dev.apps.seamonkey 9
mozilla.support.seamonkey 9
ab.test 8
abo.test 7
mpc.lists.freebsd.gnome 7
mpc.lists.nanog 6
mozilla.dev.security.policy 6
mozilla.dev.ui-alerts 5
gmane.comp.gis.openstreetmap.region.hr 5
south-wales.test 3
phl.jobs 3
aol.neighborhood.tx.arlington.jobs 3
uk.people.siversurfers 2
mpc.lists.freebsd.x11 2
mozilla.community.sweden 2
mn.jobs 2
TOTAL: 38 210

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4101
EMP (phn nph) 216
EMP (phn path) 191
EMP (phl) 131
Binary: non-binary distribution 43
User-issued cancel 33
Too many newsgroups 27
Too many newsgroups (low_xpost) 11
Too many newsgroups (meow) 10
HTML post 8
Binary: misplaced par2 4
Binary: misplaced 262 1
Cancel for rejected article 1
Binary Image: misplaced png 1
Binary: misplaced 074 1
Binary: misplaced 237 1
Binary: misplaced rar 1
Binary Image: misplaced jpg 1
TOTAL: 18 4782

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 255
news.albasani.net 160
newsfeed.datemas.de 75
news.swapon.de 65
news.redatomik.org 55
news-out.aioe.org 26
newsfeed.neva.ru 6
news.samoylyk.net 4
agency-nz-out.news.mb-net.net 3
news.snarked.org 2
TOTAL: 13 656
TOTAL: 1 656

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18696 846 17825 25 0 0 4%23:59:46
2awxg 20097 114 19937 1 0 547 0%23:57:43
3news.freedyn.net 20603 5 20329 0 0 33 0%23:59:44
4news.redatomik.org 19842 2 19821 0 0 0 0%23:59:44
5news.samoylyk.net 19633 2 19537 0 0 106 0%23:57:43
6mb-net.net 21444 1 21385 0 0 84 0%23:57:50
7eternal-september 17947 1 17914 0 0 78 0%23:57:50
8newsfeed.datemas.de 19981 1 19884 0 0 83 0%23:57:49
9news.albasani.net 13784 1 12993 619 1 5424 0%23:57:50
10neva.ru 18766 1 18755 0 0 0 0%23:59:50
11csiph.com 17812 1 17743 0 0 0 0%23:59:50
12aioe 16503 1 16425 0 0 0 0%23:59:50
13news-in.mixmin.net 18299 1 18264 0 0 73 0%23:57:41
14news.swapon.de 1574 0 1574 0 0 5 0%23:44:40
15news.snarked.org 2750 0 0 0 0 18133 0%23:57:47
TOTAL: 15 247731 977 242386 645 1 24566 0%359:25:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.2 MB84.1 KB12.3 MB0.1 KB/s14.5 KB23:59:46
2awxg332.2 KB6.2 KB338.4 KB0.0 KB/s2.9 KB23:57:43
3news.freedyn.net9.4 KB0.0 KB9.4 KB0.0 KB/s1.9 KB23:59:44
4news.redatomik.org2.3 KB0.0 KB2.3 KB0.0 KB/s1.2 KB23:59:44
5news.samoylyk.net2.3 KB0.0 KB2.3 KB0.0 KB/s1.2 KB23:57:43
6mb-net.net1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:57:50
7eternal-september1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:57:50
8newsfeed.datemas.de1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:57:49
9news.albasani.net1.4 KB2.4 MB2.4 MB0.0 KB/s4.0 KB23:57:50
10neva.ru1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:50
11csiph.com1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:50
12aioe1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:50
13news-in.mixmin.net1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:57:41
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:44:40
15news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 1512.6 MB2.5 MB15.1 MB0.0 KB/s9.5 KB359:25:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 8 877129.8 MB 1224 0 1601:56:35
2agency.bbs.geek.nz 386 669222.5 MB 3319 1 000:11:39
3vorlon.activateit.net.au 24 12301.7 MB 138 0 000:05:39
467-60-219-146.cpe.cableone.net 2 925.7 KB 1 0 038:04:47
TOTAL: 4 420 1670254.0 MB 4682 1 1640:28:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 10 878029.8 MB 1225 0 1640:01:22
2*.bbs.geek.nz 386 669222.5 MB 3319 1 000:11:39
3*.activateit.net.au 24 12301.7 MB 138 0 000:05:39
4unresolved 3 00.0 KB 0 0 000:10:13
TOTAL: 4 423 1670254.0 MB 4682 1 1640:28:56

NNRP auth users [Top 20]:

UserConn
amybbs 24
bpanther 8
malcolmlewis 2
TOTAL: 3 34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.348 0.144 0.00938:04:47
67-61-21-181.cpe.cableone.net 1.688 1.148 0.05501:56:35
agency.bbs.geek.nz 27.832 6.268 0.00000:11:39
vorlon.activateit.net.au 1.360 0.412 0.18500:05:39
118.149.142.82 0.064 0.012 0.00000:05:02
118.149.230.59 0.060 0.008 0.00000:05:01
107.170.233.71 0.052 0.008 0.00000:00:09
? 0.900 0.120 0.00000:00:01
TOTAL: 8 32.304 8.120 0.24940:28:56

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.230.59 1
118.149.142.82 1
107.170.233.71 1
TOTAL: 3 3

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
agency.bbs.geek.nz 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 5237 31.4%
2soc 2104 12.6%
3alt 1912 11.5%
4sci 1889 11.3%
5comp 1369 8.2%
6uk 1309 7.8%
7linux 1277 7.6%
8talk 962 5.8%
9misc 255 1.5%
10news 219 1.3%
11nz 67 0.4%
12mozilla 57 0.3%
13perl 13 0.1%
14microsoft 10 0.1%
15humanities 10 0.1%
16aus 5 0.0%
17us 2 0.0%
TOTAL: 17 16697100.0%

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

NewsgroupCount
1rec.arts.tv 1346
2soc.retirement 681
3rec.arts.drwho 642
4talk.politics.guns 549
5alt.atheism 543
6alt.fan.rush-limbaugh 495
7sci.physics 467
8uk.d-i-y 467
9linux.debian.bugs.dist 410
10sci.math 392
11uk.legal 383
12comp.lang.python 379
13linux.debian.changes.devel 345
14sci.electronics.design 287
15rec.boats 261
16rec.food.cooking 249
17rec.gambling.poker 242
18talk.origins 236
19soc.culture.polish 232
20rec.sport.golf 208
21rec.photo.digital 206
22news.lists.filters 203
23sci.physics.relativity 190
24rec.sport.tennis 183
25uk.radio.amateur 179
26comp.lang.c 167
27alt.comp.os.windows-10 162
28talk.politics.misc 147
29soc.culture.china 144
30rec.drugs.cannabis 129
31sci.logic 129
32soc.culture.israel 128
33soc.culture.singapore 118
34rec.arts.sf.written 117
35rec.aviation.soaring 115
36alt.politics.trump 113
37linux.debian.bugs.rc 111
38rec.sport.football.college 110
39misc.phone.mobile.iphone 106
40linux.debian.user 105
41rec.aquaria.marine.misc 96
42sci.astro.amateur 94
43sci.military.naval 94
44rec.crafts.metalworking 94
45alt.politics 93
46soc.culture.usa 92
47soc.history.what-if 91
48alt.bible.prophecy 91
49uk.tech.digital-tv 90
50rec.games.pinball 89
51rec.aviation.marketplace 80
52comp.lang.tcl 78
53rec.outdoors.rv-travel 76
54soc.history 73
55alt.conspiracy 70
56rec.woodworking 68
57comp.sys.mac.system 67
58rec.autos.tech 66
59rec.radio.shortwave 56
60rec.bicycles.tech 56
61nz.general 55
62rec.music.classical.recordings 53
63soc.culture.australian 53
64rec.sport.pro-wrestling 53
65uk.comp.sys.mac 52
66linux.debian.devel 52
67comp.os.linux.advocacy 51
68linux.debian.user.german 50
69soc.culture.vietnamese 50
70alt.test 49
71misc.survivalism 49
72comp.mobile.android 49
73alt.society.liberalism 46
74uk.legal.moderated 46
75sci.electronics.repair 45
76comp.sys.mac.apps 44
77misc.invest.stocks 42
78rec.sport.soccer 40
79comp.protocols.time.ntp 40
80alt.politics.usa 40
81comp.lang.java.programmer 38
82uk.rec.cars.maintenance 37
83rec.arts.sf.fandom 36
84comp.sys.mac.advocacy 35
85linux.debian.maint.boot 35
86sci.med.cardiology 35
87soc.penpals 34
88alt.bible 34
89comp.sys.raspberry-pi 33
90alt.support.diabetes 33
91sci.lang 33
92alt.recovery.aa 32
93mozilla.support.thunderbird 30
94soc.culture.indian 30
95comp.os.vms 29
96rec.arts.poems 29
97comp.sys.apple2 29
98rec.arts.disney.parks 28
99soc.culture.malaysia 28
100linux.debian.user.russian 26
TOTAL: 389 16697