news.bbs.nz daily logs

May 3 23:58:02 -- May 4 23:58:02

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 130001 63.1%10.2 MB 40.7%
innd 27076 13.1%4.5 MB 17.9%
inn 24168 11.7%5.6 MB 22.4%
innfeed 23464 11.4%4.5 MB 18.0%
cnfsstat 1440 0.7%256.1 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 206150 100.0%24.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 256116 52.5%
Positive hits 208439 42.7%
Do not exist 23118 4.7%
Cache misses 98 0.0%
TOTAL: 4 487771 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.209 0.0%169 0.000 1.237 14.000
article cleanup00:00:00.238 0.0%23490 0.000 0.010 0.040
article logging00:00:00.637 0.0%23991 0.000 0.027 0.162
article parse00:00:00.732 0.0%59963 0.000 0.012 0.030
article write00:00:01.388 0.0%18525 0.013 0.075 0.412
artlog/artcncl00:00:00.002 0.0%169 0.000 0.012 1.000
data move00:00:00.328 0.0%480882 0.000 0.001 0.002
hisgrep/artcncl00:00:00.002 0.0%158 0.000 0.013 0.071
hishave/artcncl00:00:00.001 0.0%169 0.000 0.006 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.157 0.0%490508 0.002 0.017 0.686
history sync00:00:00.047 0.0%347 0.000 0.135 8.750
history write00:00:06.666 0.0%23222 0.011 0.287 14.165
hiswrite/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
idle23:57:32.219 99.8%486423 111.092 177.319 450.780
nntp read00:00:04.045 0.0%487841 0.002 0.008 0.015
overview write00:00:42.870 0.0%18525 0.054 2.314 56.312
perl filter00:00:41.213 0.0%23220 1.095 1.775 3.489
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.127 0.0%37050 0.000 0.030 0.171
TOTAL: 24:00:42.74123:59:19.881 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%25811 0.000 0.002 0.019
article prepare00:00:00.000 0.0%5822 0.000 0.000 0.000
article read00:00:00.141 0.0%1338 0.000 0.105 3.591
backlog stats00:00:00.506 0.0%271922 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.403 0.0%228411 0.005 0.011 0.020
data write00:00:03.065 0.0%214166 0.003 0.014 0.033
idle23:54:27.717 99.9%271922 189.504 316.516 743.332
status file00:00:21.837 0.0%1936 0.400 11.279 432.316
TOTAL: 23:55:15.81023:54:55.728100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:04:48.212 98.9%166603 0.000 477.112 44180.452
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:12.444 0.0%460569 0.000 0.027 1.000
readart00:01:24.963 0.1%36395 0.000 2.334 19.000
TOTAL: 22:19:58.08522:06:25.619 99.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph.com 6 18558 4601 13940 17 24%25:16:16
2news-out.mixmin.net 6 18737 4244 14043 450 22%27:28:03
3newsfeed.datemas.de 3 19877 3142 15968 767 15%24:14:36
4feeder.eternal-september.org 19 21150 2219 17561 1370 10%28:46:18
5newsfeed.neva.ru 155 6831 1406 3545 1880 20%78:40:02
6news-out.aioe.org 5 23820 1213 22518 89 5%32:52:22
7news.redatomik.org 0 17451 924 16451 76 5%23:30:22
8news.albasani.net 1 18628 495 18022 111 2%23:34:59
9news.swapon.de 5 1484 202 1275 7 13%21:06:15
10feeder.awxg.com 2 16481 154 16300 27 0%23:59:56
11agency-nz-out.news.mb-net.net 8 18688 93 18512 83 0%26:02:27
12news.samoylyk.net 13 19812 83 19689 40 0%27:18:44
13news.freedyn.net 1 19644 55 19532 57 0%23:10:43
14localhost 5 4 4 0 0 100%00:00:00
TOTAL: 14 229 221165 18835 197356 4974 8%386:01:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph.com13.1 MB64.2 KB74.3 KB13.2 MB 98%2.9 KB
2news-out.mixmin.net12.2 MB110.2 KB927.8 KB13.2 MB 92%2.9 KB
3newsfeed.datemas.de11.5 MB464.4 KB2.7 MB14.6 MB 78%3.8 KB
4feeder.eternal-september.org8.7 MB790.8 KB7.8 MB17.3 MB 50%4.9 KB
5newsfeed.neva.ru3.9 MB66.7 KB6.9 MB10.9 MB 35%3.4 KB
6news-out.aioe.org3.3 MB83.4 KB474.8 KB3.8 MB 85%3.0 KB
7news.redatomik.org3.2 MB128.0 KB241.7 KB3.5 MB 89%3.6 KB
8news.albasani.net2.7 MB107.4 KB272.5 KB3.1 MB 88%5.2 KB
9news.freedyn.net902.6 KB323.5 KB951.1 KB2.1 MB 41%19.4 KB
10news.swapon.de838.9 KB6.9 KB19.2 KB865.0 KB 96%4.1 KB
11feeder.awxg.com531.0 KB157.5 KB166.1 KB854.6 KB 62%4.7 KB
12news.samoylyk.net331.2 KB337.4 KB1018.3 KB1.6 MB 19%13.7 KB
13agency-nz-out.news.mb-net.net213.6 KB135.9 KB864.9 KB1.2 MB 17%6.9 KB
14localhost5.0 KB0.0 KB0.0 KB5.0 KB100%1.3 KB
TOTAL: 1461.3 MB2.7 MB22.3 MB86.3 MB 70%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 23:58:02 - 23:59:59 34 0.2% 0.2971.1 KB 0.1% 0.60
May 4 00:00:00 - 00:59:59 990 5.3% 0.282.8 MB 4.6% 0.80
May 4 01:00:00 - 01:59:59 990 5.3% 0.283.4 MB 5.6% 0.96
May 4 02:00:00 - 02:59:59 983 5.3% 0.272.7 MB 4.4% 0.76
May 4 03:00:00 - 03:59:59 975 5.3% 0.273.4 MB 5.6% 0.96
May 4 04:00:00 - 04:59:59 980 5.3% 0.273.0 MB 4.9% 0.85
May 4 05:00:00 - 05:59:59 1123 6.1% 0.313.3 MB 5.5% 0.95
May 4 06:00:00 - 06:59:59 920 5.0% 0.263.6 MB 5.9% 1.01
May 4 07:00:00 - 07:59:59 968 5.2% 0.272.8 MB 4.7% 0.80
May 4 08:00:00 - 08:59:59 953 5.1% 0.263.2 MB 5.4% 0.92
May 4 09:00:00 - 09:59:59 868 4.7% 0.242.5 MB 4.1% 0.71
May 4 10:00:00 - 10:59:59 676 3.6% 0.192.8 MB 4.6% 0.79
May 4 11:00:00 - 11:59:59 646 3.5% 0.182.4 MB 4.0% 0.69
May 4 12:00:00 - 12:59:59 501 2.7% 0.142.4 MB 4.0% 0.69
May 4 13:00:00 - 13:59:59 412 2.2% 0.111.4 MB 2.4% 0.41
May 4 14:00:00 - 14:59:59 391 2.1% 0.111.2 MB 2.0% 0.34
May 4 15:00:00 - 15:59:59 385 2.1% 0.111.6 MB 2.7% 0.47
May 4 16:00:00 - 16:59:59 506 2.7% 0.142.2 MB 3.7% 0.64
May 4 17:00:00 - 17:59:59 438 2.4% 0.121.3 MB 2.2% 0.37
May 4 18:00:00 - 18:59:59 760 4.1% 0.212.6 MB 4.3% 0.74
May 4 19:00:00 - 19:59:59 812 4.4% 0.232.4 MB 3.9% 0.68
May 4 20:00:00 - 20:59:59 775 4.2% 0.221.9 MB 3.1% 0.53
May 4 21:00:00 - 21:59:59 884 4.8% 0.252.7 MB 4.4% 0.76
May 4 22:00:00 - 22:59:59 801 4.3% 0.222.0 MB 3.3% 0.57
May 4 23:00:00 - 23:58:02 761 4.1% 0.222.7 MB 4.5% 0.81
TOTAL: 24:00:00 18532 100.0% 0.2160.5 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUFF01BIG850.0 GB25.5 GB 51.0% 0 0.29 2108.00
BUFF02BIG850.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF03ALT50.0 GB29.5 GB 58.9% 0 0.33 1831.94
BUFF04ALT50.0 GB1.6 MB 0.0% 0 0.00 0.00
BUFF05BIN50.0 GB322.5 MB 0.6% 0 0.0318888.89
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 GB20.6 GB 41.3% 0 0.60 1010.70
TOTAL: 10-500.0 GB75.9 GB 15.2% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1896 93 0 18 0 0 0 0 1785
2feeder.eternal-september.org 1371 0 0 38 0 0 0 0 1333
3newsfeed.datemas.de 879 195 0 31 0 0 0 0 653
4news-out.mixmin.net 683 0 0 23 0 0 0 0 660
5news.redatomik.org 124 0 0 23 0 0 0 0 101
6news.albasani.net 116 1 0 25 0 0 0 0 90
7agency-nz-out.news.mb-net.net 108 50 0 16 0 0 0 0 42
8news-out.aioe.org 76 38 0 15 0 0 0 0 23
9news.swapon.de 63 0 0 3 0 0 0 0 60
10news.freedyn.net 57 8 0 14 0 0 0 0 35
11news.samoylyk.net 40 0 0 22 0 0 0 0 18
12feeder.awxg.com 34 2 0 25 0 0 0 0 7
13csiph.com 17 0 0 13 0 0 0 0 4
14news.ausics.org 2 0 0 2 0 0 0 0 0
TOTAL: 14 5466 387 0 268 0 0 0 0 4811

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.annunci.immobiliari 52
it.annunci.varie 46
it.annunci.commerciali 45
gmane.comp.gis.openstreetmap.tagging 44
mpc.lists.freebsd.ports.bugs 34
gmane.linux.kernel 31
gmane.linux.alsa.devel 21
mozilla.dev.platform 16
mozilla.support.seamonkey 8
mpc.lists.freebsd.x11 8
mpc.lists.freebsd.gnome 7
mozilla.dev.ui-alerts 5
mozilla.dev.security.policy 5
mpc.lists.nanog 5
mpc.lists.freebsd.wireless 5
mozilla.test 4
mozilla.dev.l10n 4
alt.fr.os.windows.7 4
gmane.comp.hardware.netbook.arm.sunxi 4
mpc.lists.freebsd.gecko 3
TOTAL: 44 387

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4013
EMP (phn path) 96
EMP (phn nph) 81
Too many newsgroups 40
Binary: non-binary distribution 39
User-issued cancel 15
EMP (phl) 10
HTML post 5
Binary: misplaced par2 4
Too many newsgroups (low_xpost) 2
Binary: misplaced com 1
Cancel for rejected article 1
Binary Image: misplaced jpg 1
TOTAL: 13 4308

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
news.albasani.net 2
TOTAL: 1 2
Including strange strings
news-out.mixmin.net 241
newsfeed.datemas.de 121
news.swapon.de 54
news.redatomik.org 44
news.albasani.net 13
newsfeed.neva.ru 11
news-out.aioe.org 8
feeder.awxg.com 7
feeder.eternal-september.org 1
agency-nz-out.news.mb-net.net 1
TOTAL: 10 501
TOTAL: 2 503

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.ausics.org 17095 355 16727 13 0 0 2%23:59:44
2awxg 18113 39 18069 0 1 0 0%23:59:41
3news.freedyn.net 18622 8 18469 2 0 13 0%23:59:45
4news-in.mixmin.net 14059 7 14007 0 0 0 0%23:59:45
5eternal-september 15774 6 15716 0 0 15 0%23:59:41
6mb-net.net 18442 5 18396 0 0 0 0%23:59:38
7aioe 15609 5 15557 0 0 0 0%23:59:41
8news.redatomik.org 17453 5 17441 2 0 0 0%23:59:39
9news.swapon.de 1537 4 1530 0 0 0 0%23:42:43
10csiph.com 14117 4 13994 0 0 50 0%23:59:46
11news.samoylyk.net 17149 4 17019 2 0 1516 0%23:59:45
12news.albasani.net 19322 4 16814 893 0 5661 0%23:59:45
13neva.ru 16807 2 16793 2 0 0 0%23:59:45
14news.snarked.org 0 0 0 0 0 18458 0%23:59:46
15newsfeed.datemas.de 15463 0 15372 1 0 93 0%23:59:45
TOTAL: 15 219562 448 215904 915 1 25806 0%359:38:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.ausics.org6.3 MB449.9 KB6.8 MB0.1 KB/s18.9 KB23:59:44
2awxg286.9 KB0.0 KB286.9 KB0.0 KB/s7.4 KB23:59:41
3news-in.mixmin.net13.8 KB0.0 KB13.8 KB0.0 KB/s2.0 KB23:59:45
4news.freedyn.net12.5 KB201.5 KB214.0 KB0.0 KB/s21.4 KB23:59:45
5eternal-september12.0 KB0.0 KB12.0 KB0.0 KB/s2.0 KB23:59:41
6news.redatomik.org8.7 KB6.4 KB15.1 KB0.0 KB/s2.2 KB23:59:39
7aioe7.5 KB0.0 KB7.5 KB0.0 KB/s1.5 KB23:59:41
8mb-net.net6.8 KB0.0 KB6.8 KB0.0 KB/s1.4 KB23:59:38
9news.swapon.de5.0 KB0.0 KB5.0 KB0.0 KB/s1.3 KB23:42:43
10csiph.com5.0 KB0.0 KB5.0 KB0.0 KB/s1.3 KB23:59:46
11news.samoylyk.net5.0 KB12.6 KB17.6 KB0.0 KB/s2.9 KB23:59:45
12news.albasani.net5.0 KB3.3 MB3.3 MB0.0 KB/s3.8 KB23:59:45
13neva.ru2.3 KB2.7 KB5.0 KB0.0 KB/s1.3 KB23:59:45
14news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
15newsfeed.datemas.de0.0 KB8.3 KB8.3 KB0.0 KB/s8.3 KB23:59:45
TOTAL: 156.7 MB4.0 MB10.7 MB0.0 KB/s8.0 KB359:38:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1agency.bbs.nz 385 583420.0 MB 3493 4 000:13:56
2184-155-113-241.cpe.cableone.net 8 298410.2 MB 586 0 1600:47:03
30890788407.static.corbina.ru 2 265623.0 MB 21 0 003:00:00
4vorlon.activateit.net.au 24 13241.8 MB 159 0 000:05:48
567-60-219-146.cpe.cableone.net 2 13.4 KB 0 0 018:00:36
TOTAL: 5 421 1279954.9 MB 4259 4 1622:19:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.bbs.nz 385 583420.0 MB 3493 4 000:13:56
2*.cpe.cableone.net 10 298510.2 MB 586 0 1618:47:40
3*.static.corbina.ru 2 265623.0 MB 21 0 003:00:00
4*.activateit.net.au 24 13241.8 MB 159 0 000:05:48
5*.ip25.fastwebnet.it 1 00.0 KB 0 0 000:00:04
6*.hsd1.or.comcast.net 24 00.0 KB 0 0 000:00:31
7unresolved 3 00.0 KB 0 0 000:11:47
TOTAL: 7 449 1279954.9 MB 4259 4 1622:19:51

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.180 0.112 0.09518:00:36
0890788407.static.corbina.ru 2.128 5.940 0.00003:00:00
184-155-113-241.cpe.cableone.net 1.368 0.836 0.02500:47:03
agency.bbs.nz 29.764 7.148 0.00000:13:56
118.149.207.78 0.212 0.028 0.00000:11:47
vorlon.activateit.net.au 1.716 0.460 0.17800:05:48
c-73-11-56-74.hsd1.or.comcast.net 1.332 0.200 0.00000:00:31
93-62-250-82.ip25.fastwebnet.it 0.216 0.024 0.00000:00:04
? 1.252 0.124 0.00000:00:02
TOTAL: 9 38.168 14.872 0.29822:19:51

Curious NNRP server explorers [Top 20]:

SystemConn
c-73-11-56-74.hsd1.or.comcast.net 24
118.149.207.78 3
93-62-250-82.ip25.fastwebnet.it 1
TOTAL: 3 28

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 2711 21.2%
2comp 1719 13.4%
3soc 1137 8.9%
4linux 1112 8.7%
5uk 1104 8.6%
624hoursupport 1078 8.4%
7sci 962 7.5%
8abg 763 6.0%
9alt 604 4.7%
10ab 564 4.4%
11misc 352 2.8%
123dfx 251 2.0%
13news 166 1.3%
14talk 153 1.2%
15mozilla 52 0.4%
16nz 36 0.3%
17microsoft 26 0.2%
18us 4 0.0%
19aus 2 0.0%
20humanities 2 0.0%
TOTAL: 20 12798100.0%

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

NewsgroupCount
124hoursupport.helpdesk 1078
2rec.arts.tv 826
3abg.test 751
4uk.d-i-y 590
5rec.arts.drwho 486
6ab.politics 471
7linux.debian.bugs.dist 397
8comp.os.linux.advocacy 380
9alt.comp.os.windows-10 347
10sci.physics 321
11comp.lang.c 275
123dfx.test 224
13linux.debian.changes.devel 217
14soc.retirement 210
15rec.arts.sf.written 209
16misc.survivalism 178
17uk.legal 168
18comp.lang.python 166
19news.lists.filters 158
20soc.culture.polish 148
21rec.gambling.poker 139
22rec.boats 132
23linux.debian.bugs.rc 124
24sci.electronics.design 121
25sci.physics.relativity 119
26talk.origins 99
27soc.culture.israel 91
28rec.sport.tennis 84
29soc.culture.china 83
30comp.lang.forth 80
31sci.med.cardiology 74
32alt.conspiracy.jfk 69
33soc.women 69
34ab.jobs 69
35uk.tech.digital-tv 68
36comp.ai.philosophy 68
37rec.food.cooking 65
38comp.lang.c++ 62
39uk.legal.moderated 62
40comp.lang.ada 60
41uk.tech.broadcast 58
42linux.debian.devel 58
43alt.politics.trump 56
44misc.invest.stocks 56
45soc.genealogy.britain 55
46soc.culture.indian 53
47sci.logic 52
48misc.health.alternative 51
49rec.drugs.cannabis 50
50comp.mobile.android 50
51comp.os.vms 48
52comp.sys.mac.advocacy 48
53comp.protocols.time.ntp 48
54soc.penpals 48
55rec.aviation.soaring 48
56rec.sport.soccer 47
57sci.math 45
58rec.music.classical.recordings 44
59comp.lang.fortran 43
60sci.military.naval 40
61uk.rec.cars.maintenance 40
62talk.politics.guns 40
63rec.sport.golf 39
64uk.radio.amateur 38
65linux.debian.user.german 38
66alt.test 36
67nz.general 36
68rec.sport.football.college 35
69linux.debian.kernel 34
70soc.history 33
71linux.debian.user.italian 32
72linux.debian.user 32
73rec.sport.pro-wrestling 32
74soc.culture.vietnamese 32
75alt.conspiracy 32
76sci.lang 31
77rec.photo.digital 31
78rec.bicycles.tech 31
79comp.sys.apple2 28
80comp.sys.mac.system 28
81soc.culture.usa 27
82mozilla.support.thunderbird 26
83comp.text.tex 26
84soc.culture.brazil 25
85rec.woodworking 25
86soc.history.war.us-revolution 24
87rec.humor 24
88ab.general 24
89uk.rec.cycling 24
90linux.gentoo.dev 24
91comp.lang.tcl 24
92soc.culture.singapore 23
93uk.rec.cycling.moderated 22
94soc.genealogy.medieval 22
95sci.anthropology.paleo 22
96rec.games.video.sony 21
97comp.protocols.dns.bind 21
98linux.debian.devel.release 21
99misc.phone.mobile.iphone 20
100linux.gentoo.user 20
TOTAL: 383 12798