news.bbs.geek.nz daily logs

May 29 23:58:02 -- May 30 23:58:04

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 140210 60.9%12.5 MB 42.6%
inn 33325 14.5%7.2 MB 24.6%
innd 31856 13.8%5.1 MB 17.3%
innfeed 23347 10.1%4.3 MB 14.6%
cnfsstat 1440 0.6%249.9 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 230179 100.0%29.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 301096 48.6%
Negative hits 287435 46.4%
Do not exist 31163 5.0%
Cache misses 415 0.1%
TOTAL: 4 620109 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.602 0.0%174 0.000 3.460 346.000
article cleanup00:00:00.304 0.0%32757 0.000 0.009 0.028
article logging00:00:01.471 0.0%33190 0.000 0.044 2.804
article parse00:00:01.235 0.0%128966 0.003 0.010 0.027
article write00:00:14.198 0.0%23098 0.022 0.615 40.333
artlog/artcncl00:00:00.000 0.0%170 0.000 0.000 0.000
data move00:00:00.569 0.0%627474 0.000 0.001 0.012
hisgrep/artcncl00:00:00.143 0.0%168 0.000 0.851 25.000
hishave/artcncl00:00:00.016 0.0%174 0.000 0.092 16.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:41.809 0.0%623150 0.001 0.067 4.177
history sync00:00:00.301 0.0%306 0.000 0.984 141.000
history write00:02:48.802 0.2%31279 0.024 5.397 70.326
hiswrite/artcncl00:00:00.017 0.0%6 0.000 2.833 8.000
idle23:51:58.648 99.4%651089 15.537 131.961 401.659
nntp read00:00:05.112 0.0%651082 0.003 0.008 0.031
overview write00:01:06.749 0.1%23098 0.116 2.890 78.640
perl filter00:01:16.762 0.1%31279 1.251 2.454 82.614
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.096 0.0%46196 0.000 0.024 0.082
TOTAL: 24:00:25.34823:58:17.834 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.085 0.0%31902 0.000 0.003 0.017
article prepare00:00:00.002 0.0%5224 0.000 0.000 0.125
article read00:00:04.582 0.0%1240 0.000 3.695 223.800
backlog stats00:00:00.508 0.0%328944 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.189 0.0%278881 0.003 0.008 0.016
data write00:00:02.885 0.0%266205 0.005 0.011 0.024
idle23:52:39.678 99.9%328944 155.109 261.320 669.104
status file00:00:49.094 0.1%1910 0.300 25.704 1358.417
TOTAL: 23:53:57.94123:53:39.023100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle87:03:03.997 94.4%627178 0.000 499.673 75230.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:15:37.935 0.3%1540221 0.000 0.609 22.251
readart04:14:43.973 4.6%504426 0.000 30.300 175.086
TOTAL: 92:15:17.96191:33:25.905 99.2%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 146
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 54 27800 7307 15285 5208 26%60:29:42
2news-out.mixmin.net 31 24668 5786 17724 1158 23%35:49:44
3feeder.eternal-september.org 118 31745 3336 27568 841 10%66:49:24
4news-out.aioe.org 4 16187 1849 14205 133 11%15:24:53
5newsfeed.neva.ru 156 30865 1809 28305 751 5%94:09:34
6csiph.com 2 22562 916 21555 91 4%24:08:37
7newsfeed.datemas.de 2 22097 427 21391 279 1%21:45:49
8feeder.awxg.com 2 20680 298 20275 107 1%23:59:53
9agency-nz-out.news.mb-net.net 27 25604 284 25102 218 1%35:25:15
10news.albasani.net 1 29832 255 29364 213 0%29:39:22
11news.samoylyk.net 2 35458 248 34773 437 0%28:22:57
12news.redatomik.org 1 24482 242 24117 123 0%27:08:54
13news.swapon.de 7 1677 226 1425 26 13%23:54:24
14news.freedyn.net 2 25758 76 25542 140 0%24:25:51
15localhost 3 2 2 0 0 100%00:00:00
TOTAL: 15 412 339417 23061 306631 9725 6%511:34:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org28.7 MB557.8 KB33.7 MB63.0 MB 45%5.2 KB
2news-out.mixmin.net16.7 MB505.6 KB2.6 MB19.8 MB 84%2.9 KB
3feeder.eternal-september.org11.7 MB789.3 KB57.7 MB70.2 MB 16%17.2 KB
4news-out.aioe.org4.6 MB300.5 KB389.5 KB5.2 MB 87%2.7 KB
5newsfeed.neva.ru4.5 MB343.1 KB3.0 MB7.8 MB 57%3.1 KB
6csiph.com2.4 MB299.8 KB351.1 KB3.0 MB 78%3.1 KB
7newsfeed.datemas.de2.0 MB1.3 MB2.4 MB5.7 MB 34%8.2 KB
8news.albasani.net1.3 MB463.9 KB642.4 KB2.3 MB 53%5.1 KB
9news.samoylyk.net1.1 MB616.1 KB3.3 MB5.0 MB 21%7.4 KB
10feeder.awxg.com916.7 KB351.7 KB365.3 KB1.6 MB 56%4.0 KB
11agency-nz-out.news.mb-net.net779.2 KB289.9 KB850.1 KB1.9 MB 40%3.8 KB
12news.redatomik.org773.5 KB480.1 KB480.1 KB1.7 MB 44%4.8 KB
13news.swapon.de580.9 KB79.0 KB102.8 KB762.6 KB 76%3.0 KB
14news.freedyn.net249.9 KB464.6 KB562.6 KB1.2 MB 19%5.9 KB
15localhost3.9 KB0.0 KB0.0 KB3.9 KB100%2.0 KB
TOTAL: 1576.1 MB6.7 MB106.4 MB189.1 MB 40%5.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 29 23:58:02 - 23:59:59 29 0.1% 0.25143.0 KB 0.2% 1.21
May 30 00:00:00 - 00:59:59 1166 5.1% 0.324.2 MB 5.5% 1.20
May 30 01:00:00 - 01:59:59 1232 5.3% 0.344.1 MB 5.4% 1.17
May 30 02:00:00 - 02:59:59 1245 5.4% 0.353.8 MB 4.9% 1.07
May 30 03:00:00 - 03:59:59 1497 6.5% 0.424.3 MB 5.6% 1.21
May 30 04:00:00 - 04:59:59 1347 5.8% 0.373.8 MB 5.0% 1.09
May 30 05:00:00 - 05:59:59 1216 5.3% 0.343.7 MB 4.8% 1.05
May 30 06:00:00 - 06:59:59 1337 5.8% 0.374.8 MB 6.3% 1.37
May 30 07:00:00 - 07:59:59 1242 5.4% 0.343.7 MB 4.9% 1.06
May 30 08:00:00 - 08:59:59 1253 5.4% 0.354.2 MB 5.5% 1.19
May 30 09:00:00 - 09:59:59 1124 4.9% 0.315.7 MB 7.5% 1.62
May 30 10:00:00 - 10:59:59 820 3.6% 0.233.2 MB 4.2% 0.90
May 30 11:00:00 - 11:59:59 606 2.6% 0.172.1 MB 2.7% 0.59
May 30 12:00:00 - 12:59:59 611 2.6% 0.171.6 MB 2.1% 0.45
May 30 13:00:00 - 13:59:59 531 2.3% 0.151.8 MB 2.4% 0.52
May 30 14:00:00 - 14:59:59 435 1.9% 0.121.3 MB 1.8% 0.38
May 30 15:00:00 - 15:59:59 441 1.9% 0.121.4 MB 1.9% 0.41
May 30 16:00:00 - 16:59:59 687 3.0% 0.192.9 MB 3.8% 0.83
May 30 17:00:00 - 17:59:59 473 2.1% 0.131.6 MB 2.1% 0.45
May 30 18:00:00 - 18:59:59 659 2.9% 0.182.1 MB 2.7% 0.59
May 30 19:00:00 - 19:59:59 945 4.1% 0.262.9 MB 3.8% 0.83
May 30 20:00:00 - 20:59:59 1008 4.4% 0.283.3 MB 4.3% 0.94
May 30 21:00:00 - 21:59:59 1113 4.8% 0.313.8 MB 5.0% 1.07
May 30 22:00:00 - 22:59:59 1117 4.8% 0.313.0 MB 3.9% 0.86
May 30 23:00:00 - 23:58:04 938 4.1% 0.272.8 MB 3.7% 0.82
TOTAL: 24:00:02 23072 100.0% 0.2776.2 MB 100.0% 0.90
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB17.3 GB 34.6% 0 0.34 1776.51
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB20.1 GB 40.3% 0 0.37 1636.85
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB216.3 MB 0.4% 0 0.0413763.44
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 GB1.9 GB 3.8% 0 0.84 718.21
TOTAL: 10-500.0 GB39.6 GB 7.9% 1 0.51-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 5178 58 0 104 0 0 0 0 5016
2news-out.mixmin.net 1453 0 0 117 0 0 0 0 1336
3feeder.eternal-september.org 843 0 0 177 0 0 0 0 666
4newsfeed.neva.ru 774 180 0 83 0 0 0 0 511
5news.samoylyk.net 386 0 0 130 0 0 0 0 256
6newsfeed.datemas.de 329 110 0 134 0 0 0 0 85
7agency-nz-out.news.mb-net.net 217 78 0 90 0 0 0 0 49
8news.albasani.net 192 4 0 117 0 0 0 0 71
9news-out.aioe.org 182 14 0 110 0 0 0 0 58
10news.freedyn.net 146 13 0 105 0 0 0 0 28
11news.redatomik.org 115 0 0 113 0 0 0 0 2
12feeder.awxg.com 98 3 0 90 0 0 0 0 5
13csiph.com 91 0 0 84 0 0 0 0 7
14news.swapon.de 79 0 0 23 0 0 0 0 56
TOTAL: 14 10083 460 0 1477 0 0 0 0 8146

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 172
mpc.lists.freebsd.ports.bugs 52
it.annunci.immobiliari 33
mozilla.support.seamonkey 32
it.annunci.varie 30
it.annunci.commerciali 29
gmane.linux.alsa.devel 21
gmane.linux.kernel 5
mozilla.dev.ui-alerts 5
al.christnet.bible 4
mpc.lists.freebsd.gecko 4
gmane.comp.gis.openstreetmap.region.au 4
mozilla.community.india 3
gmane.linux.kernel.renesas-soc 3
mozilla.dev.telemetry-alerts 3
mozilla.dev.fxos 3
mozilla.dev.l10n 3
eagle.support.eng 3
gmane.linux.kernel.janitors 2
gmane.linux.kernel.gpio 2
TOTAL: 62 460

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6575
EMP (phn path) 523
Binary Image: misplaced jpg 277
EMP (phl) 188
Binary: non-binary distribution 46
User-issued cancel 43
Too many newsgroups 41
HTML post 9
Binary: misplaced JPG 4
User-issued spam cancel 3
EMP (phn nph) 2
Too many newsgroups (meow) 1
TOTAL: 12 7712

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.mixmin.net 294
news.swapon.de 54
news-out.aioe.org 21
newsfeed.neva.ru 18
news.albasani.net 12
newsfeed.datemas.de 10
news.snarked.org 10
feeder.awxg.com 5
feeder.eternal-september.org 3
news.samoylyk.net 3
TOTAL: 12 434
TOTAL: 1 434

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1awxg 22512 71 22428 8 0 8 0%23:59:49
2news.snarked.org 15760 6 15642 0 0 36 0%23:59:50
3news.freedyn.net 23200 5 22982 0 0 23 0%23:59:50
4news.samoylyk.net 20927 3 20854 3 0 0 0%23:59:49
5news.redatomik.org 22707 2 22693 0 0 0 0%23:59:48
6aioe 19192 2 19018 1 0 4 0%23:59:50
7mb-net.net 22855 2 22771 0 0 74 0%23:59:50
8csiph.com 22265 2 22146 0 0 0 0%23:59:50
9news-in.mixmin.net 16612 2 16598 0 0 0 0%23:59:50
10eternal-september 18585 2 18547 0 0 0 0%23:59:47
11neva.ru 20769 1 20761 1 0 0 0%23:59:50
12news.swapon.de 1578 0 1576 0 0 0 0%23:57:35
13newsfeed.datemas.de 22587 0 22536 0 0 206 0%23:59:50
14news.ausics.org 0 0 0 0 0 21071 0%23:57:44
15news.albasani.net 24274 0 20894 1052 0 8672 0%23:59:41
TOTAL: 15 273823 98 269446 1065 0 30094 0%359:52:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1awxg403.4 KB99.9 KB503.3 KB0.0 KB/s6.4 KB23:59:49
2news.freedyn.net32.6 KB0.0 KB32.6 KB0.0 KB/s6.5 KB23:59:50
3news.snarked.org12.8 KB0.0 KB12.8 KB0.0 KB/s2.1 KB23:59:50
4news.samoylyk.net6.4 KB5.9 KB12.3 KB0.0 KB/s2.0 KB23:59:49
5mb-net.net4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:50
6news.redatomik.org3.9 KB0.0 KB3.9 KB0.0 KB/s2.0 KB23:59:48
7aioe3.9 KB1.4 KB5.3 KB0.0 KB/s1.8 KB23:59:50
8csiph.com3.9 KB0.0 KB3.9 KB0.0 KB/s2.0 KB23:59:50
9news-in.mixmin.net3.9 KB0.0 KB3.9 KB0.0 KB/s2.0 KB23:59:50
10eternal-september3.9 KB0.0 KB3.9 KB0.0 KB/s2.0 KB23:59:47
11neva.ru1.6 KB2.3 KB3.9 KB0.0 KB/s2.0 KB23:59:50
12news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:35
13newsfeed.datemas.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
14news.ausics.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:44
15news.albasani.net0.0 KB3.8 MB3.8 MB0.0 KB/s3.7 KB23:59:41
TOTAL: 15480.4 KB3.9 MB4.4 MB0.0 KB/s3.9 KB359:52:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-06-70-55-72-104.dsl.bell.ca52611348801.0 GB 1950 0 076:00:02
2agency.bbs.geek.nz 353 658021.0 MB 3550 1 000:12:15
3kosh.activateit.net.au 24 9541.3 MB 161 0 000:04:54
4192.168.1.7 2 1740.5 KB 4 0 000:00:01
560.234.244.55 5 917.9 KB 1 1 000:20:17
667-61-218-236.cpe.cableone.net 3 25.5 KB 2 0 015:06:17
TOTAL: 656481424421.1 GB 5668 2 092:13:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca52611348801.0 GB 1950 0 076:00:02
2*.bbs.geek.nz 353 658021.0 MB 3550 1 000:12:15
3*.activateit.net.au 24 9541.3 MB 161 0 000:04:54
4unresolved 13 2658.4 KB 5 1 000:49:40
5*.cpe.cableone.net 3 25.5 KB 2 0 015:06:17
TOTAL: 556541424421.1 GB 5668 2 092:13:12

NNRP auth users [Top 20]:

UserConn
amybbs 24
crash 4
malcolmlewis 3
paulh 2
TOTAL: 4 33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-06-70-55-72-104.dsl.bell.ca 307.968 100.916 0.00076:00:02
67-61-218-236.cpe.cableone.net 0.120 0.084 0.00415:06:17
60.234.244.55 0.336 0.060 0.01400:20:17
118.149.202.112 0.184 0.020 0.00000:19:12
agency.bbs.geek.nz 26.032 5.388 0.00000:12:15
118.149.213.165 0.060 0.008 0.00000:05:01
202.174.187.54 0.056 0.004 0.00000:05:00
kosh.activateit.net.au 1.496 0.392 0.14900:04:54
203.118.151.117 0.052 0.008 0.00000:00:07
? 1.400 0.164 0.00000:00:02
192.168.1.7 0.124 0.024 0.00400:00:01
TOTAL: 11 337.828 107.068 0.17192:13:12

Curious NNRP server explorers [Top 20]:

SystemConn
118.149.202.112 3
118.149.213.165 1
203.118.151.117 1
202.174.187.54 1
TOTAL: 4 6

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

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp140-06-70-55-72-104.dsl.bell.ca 290 522
TOTAL: 1 290 522

Newsgroup request counts (by category):

CategoryCountPct
1rec 51615 22.6%
2soc 47819 20.9%
3comp 25535 11.2%
4alt 20813 9.1%
5sci 17983 7.9%
6uk 13141 5.7%
7linux 11299 4.9%
8misc 11259 4.9%
9aus 7787 3.4%
10can 5988 2.6%
11talk 4598 2.0%
12perl 3077 1.3%
13news 1864 0.8%
14cakewalk 1472 0.6%
15fa 1165 0.5%
16fr 1067 0.5%
17qc 944 0.4%
18ont 569 0.2%
19humanities 316 0.1%
20ca 258 0.1%
21dictator 83 0.0%
22nz 26 0.0%
23agency 7 0.0%
24relcom 3 0.0%
25us 1 0.0%
TOTAL: 25 228689100.0%

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

NewsgroupCount
1alt.fan.rush-limbaugh 3605
2misc.survivalism 3402
3alt.politics.usa 3009
4aus.politics 2934
5alt.atheism 2786
6rec.arts.tv 2751
7misc.health.alternative 2547
8alt.usenet.kooks 2537
9aus.tv 2393
10can.jobs 2266
11can.politics 2216
12alt.war.vietnam 2060
13sci.med.cardiology 1989
14rec.arts.drwho 1979
15soc.support.fat-acceptance 1973
16soc.women 1960
17soc.culture.african.american 1954
18soc.culture.greek 1941
19rec.crafts.metalworking 1929
20soc.genealogy.jewish 1908
21rec.arts.sf.tv 1869
22soc.culture.usa 1858
23soc.culture.china 1819
24uk.rec.cycling 1712
25alt.tv.american-idol 1708
26soc.culture.vietnamese 1688
27comp.mobile.android 1669
28alt.usage.english 1636
29rec.radio.amateur.misc 1605
30rec.arts.sf.written 1602
31soc.veterans 1587
32rec.radio.amateur.moderated 1567
33sci.physics 1565
34soc.culture.indian 1554
35rec.radio.info 1545
36soc.culture.israel 1511
37comp.sys.mac.system 1506
38talk.politics.guns 1484
39cakewalk.audio 1472
40sci.med.nutrition 1398
41sci.military.naval 1398
42soc.culture.japan 1383
43sci.skeptic 1370
44rec.radio.amateur.dx 1369
45uk.politics.misc 1344
46uk.rec.driving 1319
47soc.culture.canada 1260
48aus.legal 1236
49soc.culture.british 1222
50linux.debian.devel.release 1214
51aus.cars 1190
52linux.debian.maint.boot 1185
53rec.gambling.poker 1174
54rec.photo.digital 1173
55fa.linux.kernel 1165
56sci.electronics.design 1163
57misc.immigration.usa 1143
58uk.rec.drugs.cannabis 1138
59comp.lang.c 1114
60rec.sport.cricket 1088
61linux.debian.kernel 1085
62linux.debian.devel 1072
63uk.tech.digital-tv 1066
64comp.soft-sys.math.scilab 1051
65rec.arts.tv.news.oreilly-factor 1046
66rec.nude 1039
67soc.culture.bulgaria 1035
68comp.soft-sys.sas 1032
69rec.food.cooking 1006
70rec.music.rock-pop-r+b.1950s 993
71misc.phone.mobile.iphone 990
72rec.aviation.soaring 985
73rec.sport.pro-wrestling 983
74linux.debian.bugs.dist 972
75comp.os.linux.advocacy 968
76soc.culture.catalan 944
77qc.politique 942
78soc.retirement 939
79soc.penpals 933
80rec.music.classical.recordings 912
81sci.astro.amateur 907
82soc.culture.europe 907
83comp.sys.raspberry-pi 883
84rec.sport.soccer 882
85soc.culture.polish 879
86fr.soc.politique 868
87rec.sport.tennis 868
88rec.woodworking 860
89sci.logic 840
90soc.culture.magyar 826
91comp.sys.apple2 802
92uk.rec.sheds 789
93comp.sys.mac.advocacy 788
94alt.tv.law-and-order 787
95uk.legal 778
96soc.culture.brazil 774
97talk.politics.mideast 774
98rec.music.makers.guitar.jazz 762
99rec.arts.movies.past-films 751
100linux.debian.user.portuguese 743
TOTAL: 992 228689