Daily Usenet report for paganini.linuxd.org

May 21 00:00:03 -- May 22 00:00:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

May 21 16:46:17 paganini overchan[3343]: input line too long, skipping
May 21 21:26:25 paganini overchan[3343]: input line too long, skipping
May 22 00:00:01 paganini overchan[22303]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 101465 49.9%12.6 MB 44.3%
nnrpd 65987 32.4%7.6 MB 26.8%
inn 27018 13.3%6.7 MB 23.7%
innd 8890 4.4%1.5 MB 5.1%
nocem 55 0.0%9.8 KB 0.0%
overchan 4 0.0%0.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 203420 100.0%28.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 100431 57.9%
Negative hits 46712 26.9%
Do not exist 26315 15.2%
Cache misses 58 0.0%
TOTAL: 4 173516 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.327 0.0%133 0.000 2.459 25.000
article cleanup00:00:00.192 0.0%26415 0.000 0.007 0.032
article logging00:00:00.217 0.0%26883 0.000 0.008 0.044
article parse00:00:00.573 0.0%41924 0.000 0.014 0.053
article write00:00:44.448 0.1%18918 0.130 2.350 12.432
artlog/artcncl00:00:00.001 0.0%133 0.000 0.008 0.250
data move00:00:00.122 0.0%182751 0.000 0.001 0.004
hisgrep/artcncl00:00:00.002 0.0%133 0.000 0.015 0.111
hishave/artcncl00:00:00.001 0.0%133 0.000 0.008 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:16.196 0.0%174117 0.014 0.093 6.423
history sync00:00:00.031 0.0%398 0.000 0.078 1.000
history write00:00:25.001 0.0%26413 0.030 0.947 4.383
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:03.676 99.8%176943 190.994 487.635 2014.433
nntp read00:00:01.423 0.0%183122 0.000 0.008 0.018
overview write00:00:17.143 0.0%18918 0.000 0.906 5.975
perl filter00:00:48.158 0.1%26413 1.043 1.823 6.158
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.334 0.0%57148 0.000 0.023 0.224
TOTAL: 24:01:06.05624:00:38.845100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%33455 0.000 0.003 0.018
article prepare00:00:00.004 0.0%32608 0.000 0.000 0.004
article read00:00:02.344 0.0%6492 0.000 0.361 22.759
backlog stats00:00:00.188 0.0%312164 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.465 0.0%170083 0.002 0.009 0.020
data write00:00:02.749 0.0%151294 0.007 0.018 0.044
idle23:43:09.672 99.2%312164 178.012 273.541 488.513
status file00:10:10.602 0.7%42420 9.490 14.394 27.379
TOTAL: 23:53:55.56423:53:27.115100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:34:27.899 99.9%66734 37.420 246.769360350.600
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.148 0.0%135509 0.000 0.008 0.045
readart00:00:00.018 0.0%23 0.000 0.783 3.400
TOTAL: 04:34:49.02604:34:29.065 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 3 41660 15821 24420 1419 37%48:54:28
2newsfeed.neva.ru 142 61821 2305 53761 5755 3%71:57:44
3news.fcku.it 1 6209 986 4899 324 15%23:48:56
4nntp.pasdenom.info 2 17224 19 17200 5 0%24:06:04
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 173 126914 19131 100280 7503 15%168:47:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net52.1 MB0.0 KB7.4 MB59.5 MB 87%3.5 KB
2newsfeed.neva.ru7.4 MB3.3 KB25.3 MB32.6 MB 22%4.1 KB
3news.fcku.it4.1 MB0.0 KB3.1 MB7.1 MB 57%5.6 KB
4nntp.pasdenom.info44.3 KB0.0 KB14.4 KB58.7 KB 75%2.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 563.6 MB3.3 KB35.7 MB99.3 MB 64%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 21 00:00:03 - 00:59:59 748 4.0% 0.213.0 MB 4.8% 0.85
May 21 01:00:00 - 01:59:59 622 3.3% 0.171.8 MB 2.8% 0.50
May 21 02:00:00 - 02:59:59 469 2.5% 0.131.4 MB 2.3% 0.41
May 21 03:00:00 - 03:59:59 380 2.0% 0.111.1 MB 1.8% 0.33
May 21 04:00:00 - 04:59:59 412 2.2% 0.111.4 MB 2.3% 0.41
May 21 05:00:00 - 05:59:59 382 2.0% 0.111.4 MB 2.2% 0.39
May 21 06:00:00 - 06:59:59 331 1.7% 0.091.3 MB 2.1% 0.38
May 21 07:00:00 - 07:59:59 475 2.5% 0.131.4 MB 2.2% 0.39
May 21 08:00:00 - 08:59:59 651 3.4% 0.182.7 MB 4.3% 0.77
May 21 09:00:00 - 09:59:59 662 3.5% 0.181.8 MB 2.8% 0.51
May 21 10:00:00 - 10:59:59 754 4.0% 0.212.8 MB 4.4% 0.78
May 21 11:00:00 - 11:59:59 782 4.1% 0.222.3 MB 3.6% 0.64
May 21 12:00:00 - 12:59:59 957 5.1% 0.273.5 MB 5.6% 1.00
May 21 13:00:00 - 13:59:59 924 4.9% 0.263.5 MB 5.5% 0.98
May 21 14:00:00 - 14:59:59 932 4.9% 0.263.0 MB 4.8% 0.86
May 21 15:00:00 - 15:59:59 852 4.5% 0.242.9 MB 4.6% 0.81
May 21 16:00:00 - 16:59:59 956 5.1% 0.273.1 MB 4.9% 0.87
May 21 17:00:00 - 17:59:59 1048 5.5% 0.293.5 MB 5.6% 0.99
May 21 18:00:00 - 18:59:59 1046 5.5% 0.293.1 MB 4.9% 0.88
May 21 19:00:00 - 19:59:59 1150 6.1% 0.322.8 MB 4.5% 0.80
May 21 20:00:00 - 20:59:59 1154 6.1% 0.323.5 MB 5.5% 0.99
May 21 21:00:00 - 21:59:59 1101 5.8% 0.314.0 MB 6.4% 1.14
May 21 22:00:00 - 22:59:59 1094 5.8% 0.304.6 MB 7.3% 1.30
May 21 23:00:00 - 23:59:59 1018 5.4% 0.282.9 MB 4.7% 0.84
May 22 00:00:00 - 00:00:01 16 0.1% 16.0043.5 KB 0.1% 43.53
TOTAL: 23:59:58 18916 100.0% 0.2262.7 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5769 216 0 2 0 0 0 0 5551
2linuxd-out.news.weretis.net 1832 291 0 0 0 0 0 0 1541
3news.fcku.it 345 53 0 0 0 0 0 0 292
4nntp.pasdenom.info 7 0 0 0 0 0 0 0 7
TOTAL: 4 7953 560 0 2 0 0 0 0 7391

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 99
lada.talk 78
ut.test 48
mpc.lists.freebsd.ports.bugs 27
gmane.comp.gis.openstreetmap.tagging 20
spline.eisfair 19
cakewalk.audio 18
it.comp.os.win.windows10 18
gmane.linux.drivers.video-input-infrastructure 16
mozilla.support.seamonkey 11
alt.survival 11
gmane.linux.alsa.devel 11
mpc.lists.freebsd.gecko 10
mpc.lists.freebsd.x11 9
alt.philosophy 9
alt.politics 8
mozilla.support.firefox 8
uk.radio.amateur.moderated 7
spline.eisfair.dev 7
lada.commerce 7
TOTAL: 86 560

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5274
EMP (phn path) 1371
EMP (phl) 92
EMP (phn nph) 61
Too many newsgroups 43
Binary Payload 34
User-issued cancel 27
HTML post 13
Binary Image: misplaced jpg 3
Binary: non-binary distribution 2
HTML file attachment 1
User-issued spam cancel 1
Too many newsgroups (low_xpost) 1
TOTAL: 13 6923

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 427
newsfeed.neva.ru 37
news.fcku.it 4
TOTAL: 3 468
TOTAL: 1 468

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 31765 3198 14527 1121 0 364 10%23:57:38
2news.fcku.it 21801 1414 14430 2114 0 68 6%23:59:45
3weretis.net 3675 123 3178 0 0 57 3%23:59:45
4neva.ru 24087 42 16408 164 0 25 0%23:59:45
5eternal-september 21114 16 16419 0 0 17 0%23:59:29
6news.killfile.org 2848 0 0 0 0 21763 0%23:59:45
7news.netfront.net 2769 0 0 0 0 21618 0%23:59:44
8news.albasani.net 2865 0 0 0 0 21126 0%23:59:45
9news.stack.nl 2859 0 0 0 0 21716 0%23:59:45
10etla.org 0 0 0 0 0 18916 0%23:59:45
11news.mixmin.net 0 0 0 0 0 0 0%00:10:00
12vc89.vc.panix.com 2841 0 0 0 0 21756 0%23:59:45
TOTAL: 12 116624 4793 64962 3399 0 127426 4%264:04:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info11.4 MB2.9 MB14.3 MB0.2 KB/s3.4 KB23:57:38
2news.fcku.it3.9 MB6.3 MB10.2 MB0.1 KB/s3.0 KB23:59:45
3weretis.net581.8 KB0.0 KB581.8 KB0.0 KB/s4.7 KB23:59:45
4neva.ru311.7 KB1.0 MB1.3 MB0.0 KB/s6.5 KB23:59:45
5eternal-september53.1 KB0.0 KB53.1 KB0.0 KB/s3.3 KB23:59:29
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
9news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
11news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
TOTAL: 1216.2 MB10.2 MB26.4 MB0.0 KB/s3.3 KB264:04:51
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147-192-187-101.drr02.clwr.fl.frontiernet.net 4 1132.3 KB 3 0 002:03:53
2challenger.nielsenmedia.com 3 1028.3 KB 3 0 001:30:37
3dslb-088-067-084-037.088.067.pools.vodafone-ip.de 119 22.0 KB 2 0 001:00:17
TOTAL: 3 126 2362.5 KB 8 0 004:34:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.drr02.clwr.fl.frontiernet.net 4 1132.3 KB 3 0 002:03:53
2*.nielsenmedia.com 3 1028.3 KB 3 0 001:30:37
3*.088.067.pools.vodafone-ip.de 119 22.0 KB 2 0 001:00:17
TOTAL: 3 126 2362.5 KB 8 0 004:34:48

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.316 0.028 0.00002:03:53
challenger.nielsenmedia.com 0.240 0.024 0.00001:30:37
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 12.788 3.020 0.00001:00:17
TOTAL: 3 13.344 3.072 0.00004:34:48

NNRP client timeouts [Top 20]:

SystemConnPeer
47-192-187-101.drr02.clwr.fl.frontiernet.net 4 0
challenger.nielsenmedia.com 3 0
TOTAL: 2 7 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 21 91.3%
2alt 2 8.7%
TOTAL: 2 23100.0%

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

NewsgroupCount
1comp.lang.awk 21
2alt.test 2
TOTAL: 2 23