news.bbs.geek.nz daily logs

Feb 9 23:58:01 -- Feb 10 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 149491 55.3%13.2 MB 40.8%
innd 67785 25.1%8.2 MB 25.3%
inn 28123 10.4%6.2 MB 19.3%
innfeed 23288 8.6%4.5 MB 13.8%
cnfsstat 1440 0.5%251.4 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 270128 100.0%32.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 271043 50.1%
Positive hits 243093 44.9%
Do not exist 26514 4.9%
Cache misses 582 0.1%
TOTAL: 4 541232 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.757 0.0%130 0.000 5.823 43.214
article cleanup00:00:00.231 0.0%27468 0.000 0.008 0.047
article logging00:00:00.900 0.0%28008 0.000 0.032 0.968
article parse00:00:00.833 0.0%64234 0.000 0.013 0.040
article write00:00:01.487 0.0%20190 0.014 0.074 0.338
artlog/artcncl00:00:00.002 0.0%129 0.000 0.016 0.500
data move00:00:00.312 0.0%513371 0.000 0.001 0.011
hisgrep/artcncl00:00:00.358 0.0%117 0.000 3.060 25.500
hishave/artcncl00:00:00.208 0.0%130 0.000 1.600 14.857
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.147 0.0%544496 0.000 0.015 0.700
history sync00:00:00.012 0.0%360 0.000 0.033 0.667
history write00:00:08.512 0.0%26614 0.021 0.320 17.580
hiswrite/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
idle23:57:30.528 99.8%550349 80.834 156.720 488.476
nntp read00:00:02.900 0.0%537993 0.002 0.005 0.020
overview write00:00:38.736 0.0%20190 0.000 1.919 41.280
perl filter00:00:54.350 0.1%26610 1.318 2.042 13.320
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.281 0.0%40380 0.006 0.032 0.133
TOTAL: 24:00:44.20223:59:29.554 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.069 0.0%26114 0.000 0.003 0.019
article prepare00:00:00.001 0.0%7968 0.000 0.000 0.023
article read00:00:00.199 0.0%1356 0.000 0.147 32.000
backlog stats00:00:00.267 0.0%304985 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.524 0.0%251909 0.000 0.006 0.012
data write00:00:02.823 0.0%233519 0.004 0.012 0.024
idle23:53:34.878 99.9%304985 178.545 282.030 654.319
status file00:00:21.462 0.0%1930 0.800 11.120 414.750
TOTAL: 23:54:20.47823:54:01.223100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%8 0.000 0.125 0.200
idle38:00:33.306 97.7%351211 0.000 389.604600219.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:26.424 0.1%381315 0.000 0.227 4.871
readart00:00:11.672 0.0%16499 0.000 0.707 40.556
TOTAL: 38:53:22.77838:02:11.403 97.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.albasani.net 1 24951 4085 20135 731 16%27:43:53
2newsfeed.datemas.de 2 19048 3567 15110 371 18%21:41:52
3news-out.aioe.org 2 20041 2972 16956 113 14%24:17:04
4csiph.com 2 17903 2556 15285 62 14%21:13:17
5feeder.eternal-september.org 78 24517 2547 20377 1593 10%60:02:59
6newsfeed.neva.ru 155 11864 1564 6699 3601 13%92:29:21
7news-out.mixmin.net 13 19596 1534 17578 484 7%25:27:13
8news.redatomik.org 1 20293 560 19638 95 2%24:33:56
9news.swapon.de 2 1928 269 1650 9 13%24:10:44
10news.samoylyk.net 2 18307 172 18064 71 0%19:57:42
11feeder.awxg.com 2 18334 150 18135 49 0%23:59:46
12agency-nz-out.news.mb-net.net 14 21924 81 21747 96 0%28:39:20
13localhost12672 12671 70 12600 1 0%00:00:01
14news.freedyn.net 1 18863 52 18765 46 0%20:03:08
15news.ausics.org 2 19998 1 19988 9 0%27:55:54
TOTAL: 1512949 270238 20180 242727 7331 7%442:16:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.albasani.net19.9 MB1.3 MB2.8 MB24.0 MB 83%5.1 KB
2newsfeed.datemas.de12.9 MB853.9 KB2.4 MB16.2 MB 79%4.2 KB
3feeder.eternal-september.org12.3 MB695.5 KB6.9 MB19.8 MB 61%4.9 KB
4csiph.com7.4 MB224.8 KB279.4 KB7.9 MB 93%3.1 KB
5news-out.aioe.org7.1 MB164.6 KB364.0 KB7.6 MB 93%2.5 KB
6news-out.mixmin.net5.5 MB562.8 KB1.3 MB7.4 MB 74%3.8 KB
7newsfeed.neva.ru4.5 MB336.9 KB14.4 MB19.2 MB 23%3.8 KB
8news.freedyn.net3.1 MB508.2 KB558.6 KB4.2 MB 74%43.5 KB
9news.redatomik.org2.1 MB592.0 KB643.1 KB3.3 MB 63%5.2 KB
10news.samoylyk.net1.6 MB719.6 KB1.1 MB3.5 MB 47%14.6 KB
11news.swapon.de708.6 KB27.1 KB111.1 KB846.7 KB 83%3.0 KB
12feeder.awxg.com425.3 KB237.7 KB239.8 KB902.8 KB 47%4.5 KB
13agency-nz-out.news.mb-net.net328.7 KB326.3 KB704.5 KB1.3 MB 24%7.7 KB
14localhost117.0 KB0.0 KB2.2 KB119.2 KB 98%1.7 KB
15news.ausics.org7.5 KB30.7 KB30.7 KB68.9 KB 10%6.9 KB
TOTAL: 1578.1 MB6.4 MB31.8 MB116.3 MB 67%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 9 23:58:01 - 23:59:59 27 0.1% 0.2362.1 KB 0.1% 0.52
Feb 10 00:00:00 - 00:59:59 969 4.8% 0.272.6 MB 3.8% 0.75
Feb 10 01:00:00 - 01:59:59 955 4.7% 0.272.7 MB 3.9% 0.78
Feb 10 02:00:00 - 02:59:59 1047 5.2% 0.292.6 MB 3.7% 0.73
Feb 10 03:00:00 - 03:59:59 1080 5.4% 0.303.0 MB 4.4% 0.87
Feb 10 04:00:00 - 04:59:59 1259 6.2% 0.353.7 MB 5.3% 1.06
Feb 10 05:00:00 - 05:59:59 1245 6.2% 0.355.6 MB 8.0% 1.58
Feb 10 06:00:00 - 06:59:59 1235 6.1% 0.343.9 MB 5.6% 1.11
Feb 10 07:00:00 - 07:59:59 1185 5.9% 0.333.7 MB 5.3% 1.06
Feb 10 08:00:00 - 08:59:59 1021 5.1% 0.283.5 MB 5.0% 1.00
Feb 10 09:00:00 - 09:59:59 1040 5.2% 0.293.0 MB 4.2% 0.84
Feb 10 10:00:00 - 10:59:59 1056 5.2% 0.293.8 MB 5.5% 1.09
Feb 10 11:00:00 - 11:59:59 890 4.4% 0.253.2 MB 4.6% 0.90
Feb 10 12:00:00 - 12:59:59 828 4.1% 0.232.6 MB 3.8% 0.75
Feb 10 13:00:00 - 13:59:59 673 3.3% 0.193.0 MB 4.3% 0.85
Feb 10 14:00:00 - 14:59:59 558 2.8% 0.152.6 MB 3.8% 0.75
Feb 10 15:00:00 - 15:59:59 403 2.0% 0.112.1 MB 3.0% 0.60
Feb 10 16:00:00 - 16:59:59 426 2.1% 0.122.8 MB 4.0% 0.79
Feb 10 17:00:00 - 17:59:59 409 2.0% 0.111.9 MB 2.7% 0.54
Feb 10 18:00:00 - 18:59:59 406 2.0% 0.112.1 MB 3.1% 0.61
Feb 10 19:00:00 - 19:59:59 375 1.9% 0.101.2 MB 1.7% 0.34
Feb 10 20:00:00 - 20:59:59 598 3.0% 0.172.6 MB 3.8% 0.75
Feb 10 21:00:00 - 21:59:59 820 4.1% 0.232.2 MB 3.1% 0.62
Feb 10 22:00:00 - 22:59:59 799 4.0% 0.222.6 MB 3.7% 0.74
Feb 10 23:00:00 - 23:58:02 875 4.3% 0.252.6 MB 3.7% 0.76
TOTAL: 24:00:01 20179 100.0% 0.2369.9 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB23.6 GB 47.1% 0 0.32 1924.24
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB27.3 GB 54.7% 0 0.38 1579.80
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB292.2 MB 0.6% 0 0.0416732.03
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 GB16.5 GB 32.9% 0 0.65 937.65
TOTAL: 10-500.0 GB67.7 GB 13.5% 1 0.44-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3562 51 0 65 0 0 0 0 3446
2feeder.eternal-september.org 1566 0 0 127 0 0 0 0 1439
3news.albasani.net 948 23 0 72 0 0 0 0 853
4news-out.mixmin.net 550 0 0 127 0 0 0 0 423
5newsfeed.datemas.de 529 44 0 74 0 0 0 0 411
6news-out.aioe.org 142 0 0 45 0 0 0 0 97
7news.redatomik.org 102 0 0 72 0 0 0 0 30
8agency-nz-out.news.mb-net.net 95 11 0 62 0 0 0 0 22
9news.samoylyk.net 83 0 0 69 0 0 0 0 14
10csiph.com 61 0 0 43 0 0 0 0 18
11news.freedyn.net 58 0 0 32 0 0 0 0 26
12news.swapon.de 58 0 0 8 0 0 0 0 50
13feeder.awxg.com 52 0 0 50 0 0 0 0 2
14news.ausics.org 8 0 0 8 0 0 0 0 0
15localhost 1 0 0 0 0 0 0 0 1
TOTAL: 15 7815 129 0 854 0 0 0 0 6832

Unwanted newsgroups [Top 20]:

NewsgroupCount
mpc.lists.freebsd.ports.bugs 44
mozilla.dev.platform 14
gmane.linux.alsa.devel 10
mozilla.dev.ui-alerts 7
mozilla.test 6
mpc.lists.nanog 4
south-wales.test 4
mozilla.support.seamonkey 4
mpc.lists.freebsd.office 4
af.annonces 3
mozilla.dev.apps.seamonkey 3
mozilla.dev.security.policy 3
mpc.lists.freebsd.gnome 3
mpc.lists.freebsd.x11 3
gmane.linux.kernel 3
al.christnet.bible 2
biz.marketplace 1
mozilla.support.calendar 1
mozilla.tools.marionette 1
mpc.lists.freebsd.pf 1
TOTAL: 28 129

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5755
EMP (phn path) 228
Binary: misplaced rar 99
EMP (phn nph) 58
Binary: non-binary distribution 55
Too many newsgroups 28
User-issued cancel 20
EMP (phl) 18
Too many newsgroups (meow) 7
HTML post 6
Cancel for rejected article 4
Binary Image: misplaced png 2
Binary: misplaced par2 2
Binary: misplaced 049 1
Binary: misplaced 047 1
Binary: misplaced nfo 1
Binary: misplaced 048 1
Angle-bracket bot 1
TOTAL: 18 6287

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.freedyn.net 4
TOTAL: 1 4
Including strange strings
news.albasani.net 239
newsfeed.datemas.de 148
news-out.mixmin.net 50
news.swapon.de 48
news-out.aioe.org 27
news.redatomik.org 12
newsfeed.neva.ru 10
news.samoylyk.net 3
feeder.awxg.com 2
feeder.eternal-september.org 2
TOTAL: 10 541
TOTAL: 2 545

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 18683 483 18191 9 0 0 2%23:59:36
2awxg 19792 160 19615 12 1 11 0%23:59:45
3csiph.com 17927 81 17431 4 1 15 0%23:59:44
4aioe 16184 55 16022 1 0 13 0%23:59:43
5neva.ru 18145 35 18071 34 0 0 0%23:59:44
6news.redatomik.org 19667 28 19596 6 0 26 0%23:59:43
7news.freedyn.net 20288 27 20108 1 0 48 0%23:59:34
8mb-net.net 20120 22 20053 7 0 32 0%23:59:40
9news.samoylyk.net 18620 17 18508 9 0 263 0%23:59:34
10eternal-september 16546 12 16497 14 0 36 0%23:59:44
11news-in.mixmin.net 16910 11 16870 15 0 35 0%23:59:40
12newsfeed.datemas.de 16636 4 16550 15 0 85 0%23:59:44
13news.albasani.net 17308 1 14561 804 0 5496 0%23:59:44
14news.swapon.de 1730 0 1710 0 0 66 0%23:57:28
15news.snarked.org 0 0 0 0 0 20079 0%23:57:44
TOTAL: 15 238556 936 233783 931 2 26205 0%359:51:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org12.9 MB266.2 KB13.2 MB0.2 KB/s27.4 KB23:59:36
2awxg410.7 KB76.0 KB486.7 KB0.0 KB/s2.8 KB23:59:45
3csiph.com155.3 KB95.0 KB250.3 KB0.0 KB/s2.9 KB23:59:44
4aioe88.0 KB1.1 KB89.1 KB0.0 KB/s1.6 KB23:59:43
5neva.ru55.5 KB60.5 KB116.0 KB0.0 KB/s1.7 KB23:59:44
6news.freedyn.net53.7 KB1.1 KB54.8 KB0.0 KB/s2.0 KB23:59:34
7news.redatomik.org51.0 KB11.5 KB62.4 KB0.0 KB/s1.8 KB23:59:43
8mb-net.net40.3 KB14.0 KB54.4 KB0.0 KB/s1.9 KB23:59:40
9news.samoylyk.net33.6 KB12.4 KB46.0 KB0.0 KB/s1.8 KB23:59:34
10eternal-september25.8 KB20.2 KB46.0 KB0.0 KB/s1.8 KB23:59:44
11news-in.mixmin.net24.3 KB21.7 KB46.0 KB0.0 KB/s1.8 KB23:59:40
12newsfeed.datemas.de7.6 KB26.5 KB34.1 KB0.0 KB/s1.8 KB23:59:44
13news.albasani.net1.0 KB2.7 MB2.7 MB0.0 KB/s3.4 KB23:59:44
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:28
15news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:44
TOTAL: 1513.8 MB3.3 MB17.1 MB0.0 KB/s9.4 KB359:51:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
167-61-21-181.cpe.cableone.net 9 804829.8 MB 1252 3 1802:25:47
2agency.bbs.geek.nz 408 623423.6 MB 3396 652668800:23:03
3vorlon.activateit.net.au 24 12281.5 MB 146 0 000:05:44
4192.168.1.9 3 3251.1 MB 15 1 000:00:14
560.234.68.122 11 1641.4 KB 2 1 000:34:48
6gps.mdwainwright.ca 3 22.8 KB 1 0 001:30:13
7118.149.192.2 8 11.1 KB 1 0 000:33:19
TOTAL: 7 466 1585456.0 MB 4813 702670638:53:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cpe.cableone.net 9 804829.8 MB 1252 3 1835:29:42
2*.bbs.geek.nz 408 623423.6 MB 3396 652668800:23:03
3*.activateit.net.au 24 12281.5 MB 146 0 000:05:44
4unresolved 27 3421.2 MB 18 2 001:24:26
5*.mdwainwright.ca 3 22.8 KB 1 0 001:30:13
6*.lightspeed.gdrpmi.sbcglobal.net 1 00.0 KB 0 0 000:00:03
TOTAL: 6 472 1585456.0 MB 4813 702670638:53:15

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 8
bpanther 8
paulh 3
TOTAL: 4 43

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-60-219-146.cpe.cableone.net 0.128 0.048 0.00333:03:54
67-61-21-181.cpe.cableone.net 1.624 1.220 0.02202:25:47
gps.mdwainwright.ca 0.152 0.024 0.00001:30:13
60.234.68.122 0.732 0.120 0.02100:34:48
118.149.192.2 0.476 0.060 0.00000:33:19
agency.bbs.geek.nz 33.540 9.560 0.00000:23:03
118.149.249.146 0.240 0.040 0.00000:15:55
vorlon.activateit.net.au 1.440 0.336 0.23300:05:44
192.168.1.9 0.264 0.068 0.00900:00:14
107.170.231.126 0.048 0.016 0.00000:00:09
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 0.052 0.008 0.00000:00:03
? 1.704 0.264 0.00000:00:02
TOTAL: 12 40.400 11.764 0.28838:53:15

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.249.146 4
99-44-179-2.lightspeed.gdrpmi.sbcglobal.net 1
107.170.231.126 1
TOTAL: 3 6

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.68.122 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
gps.mdwainwright.ca 3 0
67-61-21-181.cpe.cableone.net 1 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 4578 28.8%
2alt 2125 13.4%
3comp 1848 11.6%
4soc 1768 11.1%
5sci 1583 10.0%
6uk 1337 8.4%
7linux 1276 8.0%
8talk 686 4.3%
9misc 264 1.7%
10news 164 1.0%
11mozilla 99 0.6%
12nz 93 0.6%
13microsoft 29 0.2%
14agency 17 0.1%
15humanities 14 0.1%
16perl 13 0.1%
17aus 2 0.0%
18us 1 0.0%
TOTAL: 18 15897100.0%

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

NewsgroupCount
1rec.arts.tv 1179
2uk.d-i-y 758
3comp.lang.python 608
4alt.atheism 524
5soc.culture.polish 430
6alt.fan.rush-limbaugh 425
7talk.politics.guns 387
8linux.debian.changes.devel 368
9sci.physics 333
10alt.comp.os.windows-10 323
11linux.debian.bugs.dist 296
12rec.food.cooking 269
13rec.arts.drwho 268
14sci.electronics.design 253
15rec.sport.football.college 243
16soc.retirement 227
17rec.arts.sf.written 224
18rec.drugs.cannabis 223
19soc.culture.israel 208
20sci.logic 198
21alt.bible.prophecy 191
22sci.physics.relativity 177
23uk.legal 171
24comp.lang.c 167
25talk.origins 157
26rec.sport.golf 154
27comp.sys.raspberry-pi 145
28misc.phone.mobile.iphone 143
29soc.culture.china 142
30linux.debian.bugs.rc 132
31rec.sport.tennis 127
32rec.outdoors.rv-travel 119
33rec.gambling.poker 116
34linux.debian.user 116
35news.lists.filters 115
36talk.politics.misc 110
37sci.math 109
38rec.aviation.soaring 104
39rec.aquaria.marine.misc 96
40nz.general 90
41sci.med.pharmacy 90
42comp.sys.apple2 90
43rec.arts.disney.parks 86
44uk.legal.moderated 86
45uk.radio.amateur 83
46comp.os.vms 82
47rec.aviation.marketplace 80
48sci.military.naval 77
49rec.arts.sf.tv 77
50alt.support.diabetes 73
51alt.politics.trump 73
52soc.singles 71
53soc.culture.singapore 70
54uk.comp.sys.mac 70
55rec.sport.soccer 66
56alt.test 65
57soc.culture.vietnamese 64
58rec.boats 63
59rec.humor 62
60rec.radio.shortwave 62
61sci.med.cardiology 61
62alt.politics 60
63comp.lang.forth 60
64comp.lang.ada 56
65uk.tech.digital-tv 54
66sci.math.num-analysis 53
67mozilla.support.firefox 52
68uk.rec.cycling 52
69alt.bible 52
70soc.history.what-if 51
71comp.lang.c++ 50
72soc.culture.usa 49
73comp.os.linux.advocacy 48
74soc.culture.indian 48
75rec.sport.pro-wrestling 48
76rec.audio.pro 48
77rec.bicycles.tech 48
78soc.penpals 48
79misc.health.alternative 47
80rec.games.pinball 47
81rec.games.backgammon 46
82alt.astronomy 46
83rec.autos.sport.f1 45
84rec.photo.digital 44
85sci.astro.amateur 43
86sci.lang 42
87alt.recovery.aa 41
88rec.crafts.metalworking 41
89sci.electronics.repair 41
90comp.protocols.time.ntp 40
91linux.debian.devel.release 37
92linux.debian.devel 36
93comp.lang.xharbour 36
94alt.conspiracy 34
95soc.culture.australian 34
96comp.os.linux.misc 34
97mozilla.support.thunderbird 34
98rec.arts.movies.current-films 32
99comp.protocols.dns.bind 32
100linux.gentoo.user 32
TOTAL: 394 15897