news.bbs.geek.nz daily logs

Jul 16 23:58:02 -- Jul 17 23:58:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 17 00:08:03 news nnrpd[2817]: 163.47.16.169 rejected Expiring process 2816

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 103690 55.0%8.3 MB 33.8%
innd 31334 16.6%5.2 MB 21.0%
inn 28661 15.2%6.4 MB 25.9%
innfeed 23272 12.4%4.5 MB 18.3%
cnfsstat 1440 0.8%251.6 KB 1.0%
controlchan 6 0.0%1.1 KB 0.0%
TOTAL: 6 188403 100.0%24.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 286652 49.0%
Positive hits 270810 46.3%
Do not exist 26775 4.6%
Cache misses 199 0.0%
TOTAL: 4 584436 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.090 0.0%104 0.000 0.865 16.000
article cleanup00:00:00.233 0.0%28150 0.000 0.008 0.035
article logging00:00:00.710 0.0%28560 0.000 0.025 0.056
article parse00:00:00.853 0.0%68483 0.000 0.012 0.027
article write00:00:01.674 0.0%21129 0.010 0.079 1.063
artlog/artcncl00:00:00.001 0.0%93 0.000 0.011 0.111
data move00:00:00.432 0.0%537111 0.000 0.001 0.009
hisgrep/artcncl00:00:00.001 0.0%104 0.000 0.010 0.125
hishave/artcncl00:00:00.000 0.0%104 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.068 0.0%588460 0.001 0.010 0.714
history sync00:00:00.014 0.0%367 0.000 0.038 0.500
history write00:00:05.465 0.0%26947 0.014 0.203 11.596
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:44.294 99.8%554294 94.917 155.629 356.958
nntp read00:00:03.236 0.0%555415 0.003 0.006 0.016
overview write00:00:45.366 0.1%21129 0.102 2.147 73.294
perl filter00:01:00.007 0.1%26947 1.488 2.227 14.623
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.167 0.0%42260 0.000 0.028 0.079
TOTAL: 24:00:50.35623:59:49.611 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.060 0.0%27497 0.000 0.002 0.016
article prepare00:00:00.002 0.0%8888 0.000 0.000 0.031
article read00:00:00.181 0.0%1941 0.000 0.093 2.714
backlog stats00:00:00.277 0.0%328634 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.638 0.0%274926 0.002 0.006 0.013
data write00:00:03.141 0.0%263129 0.006 0.012 0.018
idle23:53:13.655100.0%328634 169.086 261.670 528.150
status file00:00:18.423 0.0%1974 0.538 9.333 452.111
TOTAL: 23:53:55.58423:53:37.377100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle33:04:22.788 97.9%113593 0.000 1048.153 75185.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:24.697 0.0%295658 0.000 0.084 22.076
readart00:00:08.951 0.0%15755 0.000 0.568 16.000
TOTAL: 33:45:55.87033:04:56.436 98.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr001011
nl-admin@nic.surfnet.nl100011
TOTAL101022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 52 20234 6198 13647 389 30%61:11:01
2newsfeed.datemas.de 4 21972 5121 15911 940 23%23:46:03
3news.redatomik.org 1 19474 2978 16418 78 15%23:42:53
4news-out.aioe.org 3 22525 1803 20617 105 8%26:51:21
5csiph.com 5 22944 1296 21551 97 5%29:31:33
6feeder.eternal-september.org 127 26842 1039 24759 1044 3%73:20:10
7newsfeed.neva.ru 154 13023 936 9995 2092 7%98:10:41
8news-out.mixmin.net 21 21888 588 20886 414 2%30:10:21
9news.freedyn.net 2 22245 372 21463 410 1%23:39:29
10news.albasani.net 1 25899 352 25081 466 1%29:26:59
11news.samoylyk.net 2 26487 190 25488 809 0%25:31:11
12feeder.awxg.com 2 16496 145 16257 94 0%23:59:55
13news.swapon.de 6 1673 55 1597 21 3%28:06:45
14news.ausics.org 1 86824 44 86742 38 0%113:52:34
15agency-nz-out.news.mb-net.net 30 22134 32 21981 121 0%38:31:55
16localhost 13 12 11 0 1 91%00:00:00
TOTAL: 16 424 370672 21160 342393 7119 5%649:52:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.8 MB436.0 KB1.7 MB22.0 MB 90%3.4 KB
2newsfeed.datemas.de16.4 MB630.4 KB2.6 MB19.6 MB 83%3.3 KB
3news.redatomik.org7.5 MB428.7 KB441.8 KB8.3 MB 89%2.8 KB
4news-out.aioe.org4.7 MB289.9 KB419.5 KB5.4 MB 87%2.9 KB
5feeder.eternal-september.org4.5 MB811.0 KB8.5 MB13.8 MB 32%6.8 KB
6csiph.com3.5 MB340.6 KB357.6 KB4.1 MB 83%3.0 KB
7newsfeed.neva.ru2.8 MB326.4 KB10.2 MB13.3 MB 20%4.5 KB
8news-out.mixmin.net2.6 MB498.9 KB1.4 MB4.5 MB 58%4.6 KB
9news.freedyn.net1.9 MB324.3 KB1.5 MB3.7 MB 50%4.9 KB
10news.albasani.net1.3 MB682.2 KB1.4 MB3.4 MB 39%4.2 KB
11news.samoylyk.net1.2 MB464.8 KB4.6 MB6.2 MB 18%6.4 KB
12feeder.awxg.com489.6 KB509.4 KB511.8 KB1.5 MB 32%6.3 KB
13agency-nz-out.news.mb-net.net200.3 KB216.1 KB1.4 MB1.8 MB 11%11.9 KB
14news.swapon.de157.3 KB81.2 KB86.6 KB325.1 KB 48%4.3 KB
15news.ausics.org120.5 KB127.9 KB138.9 KB387.3 KB 31%4.7 KB
16localhost20.5 KB0.0 KB2.0 KB22.5 KB 91%1.9 KB
TOTAL: 1667.2 MB6.0 MB35.2 MB108.4 MB 61%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 16 23:58:02 - 23:59:59 18 0.1% 0.1541.2 KB 0.1% 0.35
Jul 17 00:00:00 - 00:59:59 860 4.1% 0.242.3 MB 3.4% 0.65
Jul 17 01:00:00 - 01:59:59 1066 5.0% 0.302.9 MB 4.3% 0.83
Jul 17 02:00:00 - 02:59:59 1238 5.9% 0.344.2 MB 6.2% 1.19
Jul 17 03:00:00 - 03:59:59 1128 5.3% 0.313.3 MB 4.9% 0.93
Jul 17 04:00:00 - 04:59:59 1108 5.2% 0.313.5 MB 5.2% 1.00
Jul 17 05:00:00 - 05:59:59 1078 5.1% 0.303.0 MB 4.5% 0.86
Jul 17 06:00:00 - 06:59:59 1162 5.5% 0.324.5 MB 6.6% 1.27
Jul 17 07:00:00 - 07:59:59 947 4.5% 0.262.8 MB 4.2% 0.80
Jul 17 08:00:00 - 08:59:59 1092 5.2% 0.303.4 MB 5.0% 0.96
Jul 17 09:00:00 - 09:59:59 930 4.4% 0.263.1 MB 4.6% 0.89
Jul 17 10:00:00 - 10:59:59 869 4.1% 0.242.7 MB 3.9% 0.76
Jul 17 11:00:00 - 11:59:59 665 3.1% 0.182.1 MB 3.1% 0.59
Jul 17 12:00:00 - 12:59:59 627 3.0% 0.171.8 MB 2.7% 0.52
Jul 17 13:00:00 - 13:59:59 452 2.1% 0.131.5 MB 2.1% 0.41
Jul 17 14:00:00 - 14:59:59 527 2.5% 0.151.8 MB 2.7% 0.51
Jul 17 15:00:00 - 15:59:59 427 2.0% 0.121.6 MB 2.4% 0.46
Jul 17 16:00:00 - 16:59:59 638 3.0% 0.182.4 MB 3.6% 0.70
Jul 17 17:00:00 - 17:59:59 650 3.1% 0.182.9 MB 4.3% 0.83
Jul 17 18:00:00 - 18:59:59 630 3.0% 0.171.9 MB 2.8% 0.54
Jul 17 19:00:00 - 19:59:59 876 4.1% 0.242.5 MB 3.8% 0.72
Jul 17 20:00:00 - 20:59:59 955 4.5% 0.272.8 MB 4.1% 0.79
Jul 17 21:00:00 - 21:59:59 1044 4.9% 0.293.4 MB 5.0% 0.96
Jul 17 22:00:00 - 22:59:59 1095 5.2% 0.303.4 MB 5.1% 0.98
Jul 17 23:00:00 - 23:58:01 1059 5.0% 0.303.7 MB 5.5% 1.10
TOTAL: 23:59:59 21141 100.0% 0.2467.6 MB 100.0% 0.80
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB18.5 GB 37.0% 0 0.34 1810.22
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB21.6 GB 43.1% 0 0.34 1783.69
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB228.1 MB 0.4% 0 0.0225858.59
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 GB4.8 GB 9.6% 0 0.65 926.51
TOTAL: 10-500.0 GB45.1 GB 9.0% 1 0.44-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2106 64 0 64 0 0 0 0 1978
2newsfeed.datemas.de 1154 179 0 80 0 0 0 0 895
3feeder.eternal-september.org 989 0 0 154 0 0 0 0 835
4news.samoylyk.net 858 0 0 126 0 0 0 0 732
5news.albasani.net 467 0 0 120 0 0 0 0 347
6news.freedyn.net 407 1 0 55 0 0 0 0 351
7news.snarked.org 395 40 0 104 0 0 0 0 251
8news-out.mixmin.net 392 0 0 102 0 0 0 0 290
9news.redatomik.org 208 0 0 78 0 0 0 0 130
10agency-nz-out.news.mb-net.net 119 10 0 55 0 0 0 0 54
11news-out.aioe.org 113 22 0 73 0 0 0 0 18
12feeder.awxg.com 97 1 0 94 0 0 0 0 2
13csiph.com 78 0 0 73 0 0 0 0 5
14news.swapon.de 31 0 0 17 0 0 0 0 14
15news.ausics.org 12 0 0 8 0 0 0 0 4
16localhost 1 0 0 0 0 0 0 0 1
TOTAL: 16 7427 317 0 1203 0 0 0 0 5907

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 52
it.annunci.commerciali 47
it.annunci.varie 44
it.annunci.immobiliari 43
gmane.linux.alsa.devel 18
mpc.lists.freebsd.office 17
mozilla.support.seamonkey 11
mpc.lists.freebsd.gnome 10
gmane.comp.gis.openstreetmap.tagging 9
mozilla.dev.l10n.sr 9
gmane.linux.kernel 8
mpc.lists.freebsd.x11 6
mozilla.dev.ui-alerts 6
mozilla.support.bugzilla 3
fido7.ru.android 3
usc.forsale 3
mpc.lists.nanog 3
mozilla.dev.platform 3
mpc.lists.freebsd.wireless 2
mozilla.tools.l10n 2
TOTAL: 37 317

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4417
EMP (phn path) 514
EMP (phn nph) 317
EMP (phl) 143
Too many newsgroups 38
Too many newsgroups (low_xpost) 20
User-issued cancel 17
Binary: non-binary distribution 15
HTML post 4
Too many newsgroups (meow) 4
Poison newsgroup 3
Binary Image: misplaced jpg 2
TOTAL: 12 5494

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.datemas.de 206
news.redatomik.org 125
news.albasani.net 26
news-out.aioe.org 14
news.swapon.de 13
news.snarked.org 11
news-out.mixmin.net 7
news.samoylyk.net 4
newsfeed.neva.ru 4
feeder.awxg.com 2
TOTAL: 11 413
TOTAL: 1 413

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 19460 913 18478 69 0 0 4%23:59:45
2awxg 20461 106 20346 2 0 8 0%23:59:45
3news.freedyn.net 21068 26 20742 0 0 28 0%23:59:44
4news.snarked.org 15119 23 14935 17 0 16 0%23:59:44
5csiph.com 20059 15 19881 0 0 4 0%23:59:44
6mb-net.net 21120 14 21063 1 0 1 0%23:59:40
7news.redatomik.org 18027 13 17976 1 0 0 0%23:59:43
8neva.ru 19805 12 19786 2 0 0 0%23:59:44
9news.samoylyk.net 19258 12 19202 5 0 0 0%23:59:30
10aioe 16858 11 16738 1 0 2 0%23:59:39
11news-in.mixmin.net 19700 10 19655 1 0 117 0%23:59:44
12newsfeed.datemas.de 15909 8 15857 1 0 92 0%23:59:44
13eternal-september 17842 6 17755 1 0 199 0%23:59:44
14news.albasani.net 21497 3 18997 864 0 6008 0%23:59:44
15news.swapon.de 1654 0 1654 0 0 0 0%23:56:18
TOTAL: 15 267837 1172 263065 965 0 6475 0%359:52:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org4.3 MB4.4 MB8.7 MB0.1 KB/s9.1 KB23:59:45
2awxg516.1 KB10.9 KB527.0 KB0.0 KB/s4.9 KB23:59:45
3news.freedyn.net104.1 KB0.0 KB104.1 KB0.0 KB/s4.0 KB23:59:44
4news.snarked.org52.8 KB46.6 KB99.4 KB0.0 KB/s2.5 KB23:59:44
5csiph.com40.6 KB0.0 KB40.6 KB0.0 KB/s2.7 KB23:59:44
6neva.ru33.8 KB2.3 KB36.1 KB0.0 KB/s2.6 KB23:59:44
7news.redatomik.org27.4 KB86.3 KB113.7 KB0.0 KB/s8.1 KB23:59:43
8mb-net.net25.5 KB1.2 KB26.8 KB0.0 KB/s1.8 KB23:59:40
9aioe22.4 KB1.2 KB23.6 KB0.0 KB/s2.0 KB23:59:39
10news.samoylyk.net22.1 KB106.2 KB128.3 KB0.0 KB/s7.5 KB23:59:30
11news-in.mixmin.net19.1 KB4.7 KB23.8 KB0.0 KB/s2.2 KB23:59:44
12newsfeed.datemas.de11.8 KB6.3 KB18.1 KB0.0 KB/s2.0 KB23:59:44
13eternal-september7.8 KB6.3 KB14.1 KB0.0 KB/s2.0 KB23:59:44
14news.albasani.net4.1 KB3.0 MB3.0 MB0.0 KB/s3.6 KB23:59:44
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:18
TOTAL: 155.1 MB7.7 MB12.9 MB0.0 KB/s6.2 KB359:52:12
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.geek.nz 349 720922.0 MB 3373 10 200:12:27
2163.47.16.169 24 15542.1 MB 180 0 000:06:38
360.234.244.55 11 1550.6 KB 3 1 000:26:24
TOTAL: 3 384 877824.1 MB 3556 11 233:45:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.geek.nz 349 720922.0 MB 3373 10 200:12:27
2unresolved 43 15692.1 MB 183 1 001:13:10
3*.cpe.cableone.net 4 00.0 KB 0 0 031:13:28
4*.dsl.bell.ca 2 00.0 KB 0 0 000:00:55
5*.barsoom.cc 2 00.0 KB 0 0 001:05:44
TOTAL: 5 400 877824.1 MB 3556 11 233:45:49

NNRP auth users [Top 20]:

UserConn
amybbs 23
crash 7
malcolmlewis 4
TOTAL: 3 34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
67-61-218-236.cpe.cableone.net 0.348 0.132 0.01531:13:28
mail.barsoom.cc 0.128 0.052 0.00001:05:44
60.234.244.55 0.704 0.100 0.02100:26:24
118.149.153.189 0.312 0.040 0.00000:25:08
118.149.222.163 0.124 0.016 0.00000:14:47
agency.bbs.geek.nz 24.712 5.832 0.00000:12:27
163.47.16.169 1.404 0.388 0.11100:06:38
mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca 0.296 0.032 0.00000:00:55
46.11.20.28 0.088 0.256 0.00000:00:11
? 1.248 0.152 0.00000:00:02
TOTAL: 10 29.364 7.000 0.14733:45:49

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.153.189 5
67-61-218-236.cpe.cableone.net 4
118.149.222.163 2
mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca 2
mail.barsoom.cc 2
46.11.20.28 1
TOTAL: 6 16

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
60.234.244.55 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
mail.barsoom.cc 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 4588 52.3%
2comp 1123 12.8%
3sci 926 10.6%
4soc 881 10.0%
5alt 474 5.4%
6misc 313 3.6%
7talk 197 2.2%
8uk 138 1.6%
9news 48 0.5%
10nz 33 0.4%
11aus 28 0.3%
12humanities 14 0.2%
13agency 13 0.1%
TOTAL: 13 8776100.0%

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

NewsgroupCount
1rec.arts.tv 1145
2rec.sport.tennis 888
3rec.arts.drwho 609
4rec.arts.sf.written 416
5alt.comp.os.windows-10 393
6rec.food.cooking 323
7comp.lang.c 255
8misc.survivalism 240
9sci.electronics.design 196
10comp.os.linux.advocacy 193
11sci.physics 187
12comp.lang.python 174
13soc.retirement 127
14sci.physics.relativity 122
15soc.penpals 121
16uk.radio.amateur 113
17comp.sys.mac.system 104
18soc.culture.polish 104
19talk.politics.misc 102
20sci.logic 102
21rec.arts.sf.tv 97
22soc.culture.israel 89
23soc.culture.singapore 85
24talk.politics.guns 83
25comp.os.linux.misc 66
26rec.gambling.poker 59
27rec.sport.pro-wrestling 56
28soc.culture.china 56
29sci.electronics.repair 56
30rec.sport.soccer 55
31sci.math 54
32sci.space.policy 49
33rec.autos.tech 46
34rec.bicycles.tech 44
35rec.arts.comics.strips 40
36rec.crafts.metalworking 39
37soc.culture.usa 39
38misc.health.alternative 39
39rec.arts.sf.fandom 39
40rec.photo.digital 38
41rec.music.rock-pop-r+b.1950s 38
42rec.autos.sport.f1 37
43news.lists.filters 36
44sci.med.pharmacy 35
45rec.arts.movies.current-films 34
46rec.sport.football.college 33
47rec.arts.disney.parks 32
48rec.music.classical.recordings 32
49alt.test 31
50rec.radio.shortwave 31
51nz.general 30
52soc.culture.indian 27
53rec.arts.sf.science 27
54rec.games.video.sony 27
55comp.lang.misc 26
56sci.math.num-analysis 26
57uk.comp.homebuilt 25
58soc.culture.brazil 24
59comp.sys.mac.advocacy 24
60rec.sport.golf 24
61alt.bbs.mystic 23
62soc.culture.vietnamese 23
63soc.culture.cuba 22
64comp.protocols.time.ntp 21
65comp.soft-sys.matlab 21
66rec.arts.tv.uk.coronation-st 20
67rec.music.dylan 20
68rec.music.beatles 19
69soc.culture.bulgaria 19
70rec.boats 18
71rec.woodworking 18
72soc.history.what-if 17
73rec.radio.amateur.dx 17
74comp.soft-sys.sas 16
75rec.music.classical.guitar 16
76sci.military.naval 15
77sci.bio.paleontology 15
78comp.os.vms 15
79soc.veterans 15
80rec.sport.cricket 14
81comp.soft-sys.math.scilab 14
82comp.arch 13
83agency.test 13
84aus.sport.aussie-rules 13
85sci.crypt 13
86soc.culture.venezuela 12
87soc.history.medieval 12
88rec.arts.sf.movies 12
89rec.radio.amateur.misc 12
90rec.arts.movies.past-films 12
91rec.aviation.soaring 12
92soc.genealogy.medieval 11
93comp.mobile.android 11
94comp.text.tex 11
95comp.lang.lisp 10
96news.software.readers 10
97comp.misc 10
98rec.audio.pro 10
99comp.lang.ada 10
100misc.invest.stocks 10
TOTAL: 288 8776