Daily Usenet report for paganini.linuxd.org

Nov 27 00:00:01 -- Nov 28 00:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 28 00:00:02 paganini overchan[10161]: 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 101236 62.7%12.7 MB 54.2%
inn 39722 24.6%8.2 MB 34.9%
innd 19959 12.4%2.5 MB 10.6%
nnrpd 380 0.2%55.6 KB 0.2%
nocem 71 0.0%12.1 KB 0.1%
overchan 2 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 161371 100.0%23.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 138148 53.4%
Negative hits 81405 31.5%
Do not exist 39144 15.1%
Cache misses 96 0.0%
TOTAL: 4 258793 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.366 0.0%138 0.000 2.652 23.000
article cleanup00:00:00.257 0.0%39374 0.000 0.007 0.028
article logging00:00:00.341 0.0%39768 0.000 0.009 0.045
article parse00:00:01.112 0.0%92555 0.000 0.012 0.032
article write00:00:48.833 0.1%20625 0.086 2.368 22.897
artlog/artcncl00:00:00.002 0.0%135 0.000 0.015 0.083
data move00:00:00.158 0.0%253841 0.000 0.001 0.003
hisgrep/artcncl00:00:00.047 0.0%138 0.000 0.341 23.000
hishave/artcncl00:00:00.002 0.0%138 0.000 0.014 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.035 0.0%261138 0.012 0.042 0.537
history sync00:00:00.061 0.0%302 0.000 0.202 22.500
history write00:00:25.556 0.0%39373 0.018 0.649 3.864
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:23.284 99.7%252417 139.243 341.432 1666.250
nntp read00:00:02.135 0.0%263961 0.001 0.008 0.019
overview write00:00:17.773 0.0%20625 0.015 0.862 3.236
perl filter00:01:33.596 0.1%39373 0.944 2.377 5.563
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.210 0.0%62082 0.002 0.019 0.056
TOTAL: 24:00:22.14423:59:45.768100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.095 0.0%35329 0.000 0.003 0.014
article prepare00:00:00.003 0.0%14008 0.000 0.000 0.008
article read00:00:02.403 0.0%2822 0.000 0.852 23.359
backlog stats00:00:00.244 0.0%326786 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.416 0.0%178330 0.001 0.008 0.019
data write00:00:02.923 0.0%157759 0.008 0.019 0.036
idle23:43:43.554 99.3%326786 153.482 261.405 539.134
status file00:09:30.943 0.7%42325 8.120 13.489 25.007
TOTAL: 23:53:35.64223:53:21.581100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:40:07.289 99.9%359 31.333 36789.106601720.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.013 0.0%939 0.000 0.014 0.250
TOTAL: 03:40:21.35003:40:07.302 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 5 50416 17523 29575 3318 34%48:38:16
2newsfeed.neva.ru 144 83509 1874 66520 15115 2%71:47:09
3news.fcku.it 1 9279 1429 7586 264 15%25:24:24
4nntp.pasdenom.info 3 22214 35 22082 97 0%24:08:53
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 178 165418 20861 125763 18794 12%169:58:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net57.1 MB13.1 KB26.3 MB83.5 MB 68%4.1 KB
2newsfeed.neva.ru6.2 MB0.0 KB139.1 MB145.3 MB 4%8.8 KB
3news.fcku.it4.2 MB0.0 KB3.3 MB7.5 MB 55%4.5 KB
4nntp.pasdenom.info72.2 KB0.0 KB962.6 KB1.0 MB 6%7.8 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 567.6 MB13.1 KB169.7 MB237.3 MB 28%6.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 27 00:00:01 - 00:59:59 743 3.6% 0.212.2 MB 3.2% 0.62
Nov 27 01:00:00 - 01:59:59 763 3.7% 0.212.3 MB 3.4% 0.65
Nov 27 02:00:00 - 02:59:59 585 2.8% 0.162.5 MB 3.8% 0.72
Nov 27 03:00:00 - 03:59:59 494 2.4% 0.142.6 MB 3.9% 0.75
Nov 27 04:00:00 - 04:59:59 431 2.1% 0.121.4 MB 2.0% 0.39
Nov 27 05:00:00 - 05:59:59 480 2.3% 0.132.3 MB 3.4% 0.64
Nov 27 06:00:00 - 06:59:59 307 1.5% 0.09995.0 KB 1.5% 0.28
Nov 27 07:00:00 - 07:59:59 558 2.7% 0.154.0 MB 6.0% 1.14
Nov 27 08:00:00 - 08:59:59 494 2.4% 0.141.9 MB 2.9% 0.54
Nov 27 09:00:00 - 09:59:59 674 3.3% 0.192.2 MB 3.3% 0.63
Nov 27 10:00:00 - 10:59:59 828 4.0% 0.232.3 MB 3.5% 0.66
Nov 27 11:00:00 - 11:59:59 879 4.3% 0.242.4 MB 3.6% 0.69
Nov 27 12:00:00 - 12:59:59 909 4.4% 0.252.5 MB 3.7% 0.70
Nov 27 13:00:00 - 13:59:59 838 4.1% 0.232.2 MB 3.3% 0.63
Nov 27 14:00:00 - 14:59:59 891 4.3% 0.252.4 MB 3.6% 0.69
Nov 27 15:00:00 - 15:59:59 962 4.7% 0.272.5 MB 3.8% 0.72
Nov 27 16:00:00 - 16:59:59 1212 5.9% 0.343.1 MB 4.6% 0.88
Nov 27 17:00:00 - 17:59:59 1081 5.2% 0.302.8 MB 4.2% 0.79
Nov 27 18:00:00 - 18:59:59 1514 7.3% 0.423.8 MB 5.7% 1.07
Nov 27 19:00:00 - 19:59:59 1382 6.7% 0.385.2 MB 7.8% 1.48
Nov 27 20:00:00 - 20:59:59 1191 5.8% 0.334.4 MB 6.5% 1.24
Nov 27 21:00:00 - 21:59:59 1168 5.7% 0.324.2 MB 6.3% 1.20
Nov 27 22:00:00 - 22:59:59 1235 6.0% 0.343.4 MB 5.0% 0.96
Nov 27 23:00:00 - 23:59:59 983 4.8% 0.273.2 MB 4.8% 0.91
Nov 28 00:00:00 - 00:00:02 6 0.0% 3.0027.1 KB 0.0% 13.53
TOTAL: 24:00:01 20608 100.0% 0.2466.7 MB 100.0% 0.79
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15009 202 0 0 0 0 0 014807
2linuxd-out.news.weretis.net 3662 455 0 1 0 0 0 0 3206
3news.fcku.it 247 2 0 0 0 0 0 0 245
4nntp.pasdenom.info 61 1 0 0 0 0 0 0 60
TOTAL: 4 18979 660 0 1 0 0 0 018318

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 135
ut.test 91
lada.talk 50
spline.eisfair 28
alt.windows7.general 25
alt.survival 24
abg.test 23
mozilla.general 20
mozilla.support.seamonkey 14
mpc.lists.freebsd.office 14
nl.actueel 13
uk.radio.amateur.moderated 12
mozilla.support.firefox 12
lada.photo 10
mpc.lists.freebsd.x11 10
alt.2600 10
it.comp.os.win.windows10 9
alt.politics 9
gmane.comp.gis.openstreetmap.tagging 9
lada.auto 6
TOTAL: 89 660

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12411
EMP (phn path) 4432
EMP (phl) 704
EMP (phn nph) 190
User-issued cancel 98
Too many newsgroups 59
Binary Payload 21
Binary Image: misplaced jpg 6
Binary: non-binary distribution 2
HTML Multipart without Text/Plain. 1
TOTAL: 10 17924

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 370
news.fcku.it 13
newsfeed.neva.ru 11
TOTAL: 3 394
TOTAL: 1 394

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 36880 2263 18235 46 0 492 6%23:57:47
2weretis.net 3428 268 2991 0 0 26 7%23:59:16
3news.fcku.it 23680 260 18656 336 0 153 1%23:59:54
4neva.ru 26733 159 18400 169 0 20 0%23:59:54
5eternal-september 23268 11 17655 1 0 52 0%23:59:53
6vc89.vc.panix.com 2838 0 0 0 0 23445 0%23:59:54
7news.stack.nl 2856 0 0 0 0 23445 0%23:59:54
8news.mixmin.net 0 0 0 0 0 0 0%00:10:00
9news.netfront.net 2753 0 0 0 0 23300 0%23:59:53
10news.killfile.org 2848 0 0 0 0 23455 0%23:59:54
11etla.org 0 0 0 0 0 20608 0%23:59:54
12news.albasani.net 2855 0 0 0 0 22774 0%23:59:54
TOTAL: 12 128139 2961 75937 552 0 137770 2%264:06:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info5.2 MB74.1 KB5.3 MB0.1 KB/s2.4 KB23:57:47
2news.fcku.it1.0 MB1.5 MB2.6 MB0.0 KB/s4.4 KB23:59:54
3weretis.net491.0 KB0.0 KB491.0 KB0.0 KB/s1.8 KB23:59:16
4neva.ru358.4 KB396.1 KB754.5 KB0.0 KB/s2.3 KB23:59:54
5eternal-september36.0 KB3.1 KB39.1 KB0.0 KB/s3.3 KB23:59:53
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
7news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
8news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
10news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
11etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 127.1 MB2.0 MB9.1 MB0.0 KB/s2.7 KB264:06:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-188-110-188-212.188.110.pools.vodafone-ip.de 109 00.0 KB 0 0 000:00:21
247-192-187-101.drr02.clwr.fl.frontiernet.net 11 00.0 KB 0 0 003:39:59
TOTAL: 2 120 00.0 KB 0 0 003:40:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.188.110.pools.vodafone-ip.de 109 00.0 KB 0 0 000:00:21
2*.drr02.clwr.fl.frontiernet.net 11 00.0 KB 0 0 003:39:59
TOTAL: 2 120 00.0 KB 0 0 003:40:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.668 0.032 0.00003:39:59
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 5.756 0.392 0.00000:00:21
TOTAL: 2 6.424 0.424 0.00003:40:20

NNRP client timeouts [Top 20]:

SystemConnPeer
47-192-187-101.drr02.clwr.fl.frontiernet.net 7 0
TOTAL: 1 7 0