Daily Usenet report for paganini.linuxd.org

Sep 30 00:00:02 -- Oct 1 00:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 1 00:00:01 paganini overchan[22208]: 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 100820 63.1%12.4 MB 52.6%
inn 41031 25.7%8.8 MB 37.4%
innd 17456 10.9%2.3 MB 9.7%
nnrpd 453 0.3%63.1 KB 0.3%
nocem 67 0.0%11.3 KB 0.0%
controlchan 5 0.0%0.8 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 159834 100.0%23.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 107978 47.3%
Negative hits 79744 35.0%
Do not exist 40335 17.7%
Cache misses 71 0.0%
TOTAL: 4 228128 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.190 0.0%164 0.000 1.159 9.167
article cleanup00:00:00.283 0.0%40450 0.000 0.007 0.025
article logging00:00:00.375 0.0%40874 0.000 0.009 0.045
article parse00:00:01.172 0.0%95662 0.003 0.012 0.030
article write00:01:00.591 0.1%23067 0.114 2.627 25.398
artlog/artcncl00:00:00.001 0.0%164 0.000 0.006 0.056
data move00:00:00.163 0.0%253276 0.000 0.001 0.003
hisgrep/artcncl00:00:00.004 0.0%163 0.000 0.025 0.333
hishave/artcncl00:00:00.003 0.0%164 0.000 0.018 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.451 0.0%228693 0.014 0.059 1.558
history sync00:00:00.024 0.0%395 0.000 0.061 0.500
history write00:00:39.027 0.0%40450 0.051 0.965 3.817
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:23.294 99.7%251476 100.663 342.710 1507.874
nntp read00:00:02.103 0.0%257878 0.002 0.008 0.016
overview write00:00:23.964 0.0%23067 0.023 1.039 8.714
perl filter00:01:29.423 0.1%40450 1.085 2.211 3.877
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.541 0.0%69418 0.003 0.022 0.076
TOTAL: 24:01:01.32224:00:15.609 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.113 0.0%37476 0.000 0.003 0.015
article prepare00:00:00.003 0.0%16972 0.000 0.000 0.016
article read00:00:01.403 0.0%3129 0.000 0.448 13.974
backlog stats00:00:00.244 0.0%366001 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.520 0.0%198952 0.003 0.008 0.014
data write00:00:03.053 0.0%175961 0.008 0.017 0.032
idle23:42:30.261 99.3%366001 153.165 233.197 491.662
status file00:10:07.615 0.7%42127 8.136 14.423 107.135
TOTAL: 23:53:06.17123:52:44.212100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:17:27.415 99.9%398 28.000 29767.374600108.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.201 0.0%1036 0.000 0.194 3.537
readart00:00:00.067 0.0%1386 0.048 0.048 0.048
TOTAL: 03:17:42.86503:17:27.683 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 53888 18797 32413 2678 34%48:30:45
2newsfeed.neva.ru 145 85634 2399 68941 14294 2%71:57:52
3news.fcku.it 1 10066 2176 7613 277 21%25:32:52
4localhost 25 0 0 0 0 0%00:00:00
5nntp.pasdenom.info 1 0 0 0 0 0%00:10:00
TOTAL: 5 177 149588 23372 108967 17249 15%146:11:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net57.3 MB0.0 KB70.7 MB128.1 MB 44%6.1 KB
2newsfeed.neva.ru6.8 MB0.0 KB121.6 MB128.4 MB 5%7.9 KB
3news.fcku.it5.9 MB0.0 KB1.8 MB7.6 MB 76%3.2 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
5nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 570.0 MB0.0 KB194.1 MB264.1 MB 26%6.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 00:00:02 - 00:59:59 929 4.0% 0.263.1 MB 4.5% 0.87
Sep 30 01:00:00 - 01:59:59 747 3.2% 0.212.3 MB 3.3% 0.65
Sep 30 02:00:00 - 02:59:59 609 2.6% 0.172.1 MB 3.1% 0.61
Sep 30 03:00:00 - 03:59:59 614 2.7% 0.172.2 MB 3.2% 0.64
Sep 30 04:00:00 - 04:59:59 435 1.9% 0.121.7 MB 2.5% 0.50
Sep 30 05:00:00 - 05:59:59 559 2.4% 0.161.8 MB 2.7% 0.53
Sep 30 06:00:00 - 06:59:59 567 2.5% 0.162.0 MB 2.9% 0.57
Sep 30 07:00:00 - 07:59:59 550 2.4% 0.152.0 MB 2.8% 0.56
Sep 30 08:00:00 - 08:59:59 678 2.9% 0.192.1 MB 3.0% 0.59
Sep 30 09:00:00 - 09:59:59 1039 4.5% 0.293.0 MB 4.4% 0.86
Sep 30 10:00:00 - 10:59:59 1045 4.5% 0.292.8 MB 4.0% 0.79
Sep 30 11:00:00 - 11:59:59 1084 4.7% 0.303.0 MB 4.3% 0.84
Sep 30 12:00:00 - 12:59:59 976 4.2% 0.272.4 MB 3.5% 0.69
Sep 30 13:00:00 - 13:59:59 962 4.2% 0.272.5 MB 3.7% 0.72
Sep 30 14:00:00 - 14:59:59 1043 4.5% 0.292.9 MB 4.3% 0.84
Sep 30 15:00:00 - 15:59:59 1222 5.3% 0.343.7 MB 5.3% 1.04
Sep 30 16:00:00 - 16:59:59 1314 5.7% 0.363.8 MB 5.5% 1.07
Sep 30 17:00:00 - 17:59:59 1447 6.3% 0.404.0 MB 5.7% 1.12
Sep 30 18:00:00 - 18:59:59 1273 5.5% 0.353.3 MB 4.8% 0.95
Sep 30 19:00:00 - 19:59:59 1245 5.4% 0.353.2 MB 4.6% 0.91
Sep 30 20:00:00 - 20:59:59 1297 5.6% 0.364.6 MB 6.7% 1.31
Sep 30 21:00:00 - 21:59:59 1218 5.3% 0.344.0 MB 5.9% 1.15
Sep 30 22:00:00 - 22:59:59 1154 5.0% 0.323.1 MB 4.4% 0.87
Sep 30 23:00:00 - 23:59:59 1036 4.5% 0.293.3 MB 4.8% 0.94
Oct 1 00:00:00 - 00:00:01 5 0.0% 5.0011.9 KB 0.0% 11.88
TOTAL: 23:59:59 23048 100.0% 0.2769.0 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 14479 1154 0 0 0 0 0 013325
2linuxd-out.news.weretis.net 3062 674 0 0 0 0 0 0 2388
3news.fcku.it 273 8 0 0 0 0 0 0 265
TOTAL: 3 17814 1836 0 0 0 0 0 015978

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 572
lada.talk 223
fa.freebsd.cvs-all 97
lada.auto 75
ut.test 74
alt.survival 56
it.comp.os.win.windows10 44
alt.windows7.general 43
fa.netbsd.bugs 40
it-alt.sport.calcio.juventus 39
gmane.linux.alsa.devel 27
cakewalk.audio 21
fa.openbsd.source-changes 20
eagle.support.eng 18
mpc.lists.nanog 17
mozilla.dev.platform 17
mozilla.support.seamonkey 16
fa.freebsd.bugs 15
fa.openbsd.tech 15
mozilla.dev.security.policy 14
TOTAL: 137 1836

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12110
EMP (phn path) 2329
EMP (phl) 531
Binary Payload 316
EMP (phn nph) 167
Too many newsgroups 51
EMP (phr path) 28
User-issued cancel 10
Binary: non-binary distribution 5
HTML post 4
Binary Image: misplaced jpg 4
Too many newsgroups (low_xpost) 1
TOTAL: 12 15556

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 396
newsfeed.neva.ru 18
news.fcku.it 8
TOTAL: 3 422
TOTAL: 1 422

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 41825 1343 21569 111 0 423 3%23:57:37
2news.fcku.it 27268 648 19161 1240 0 29 2%23:59:42
3weretis.net 4718 407 3980 0 0 18 8%23:59:37
4neva.ru 31878 147 20141 355 0 22 0%23:59:42
5eternal-september 26530 5 19365 1 0 27 0%23:59:42
6vc89.vc.panix.com 2839 0 0 0 0 25886 0%23:59:42
7etla.org 0 0 0 0 0 23048 0%23:59:43
8news.mixmin.net 0 0 0 0 0 0 0%00:10:30
9news.albasani.net 2858 0 0 0 0 25126 0%23:59:42
10news.netfront.net 2746 0 0 0 0 25720 0%23:59:41
11news.stack.nl 2799 0 0 0 0 25811 0%23:59:42
12news.killfile.org 2847 0 0 0 0 25894 0%23:59:42
TOTAL: 12 146308 2550 84216 1707 0 152004 1%264:05:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info3.8 MB511.0 KB4.3 MB0.1 KB/s3.0 KB23:57:37
2news.fcku.it2.8 MB4.4 MB7.1 MB0.1 KB/s3.9 KB23:59:42
3weretis.net968.4 KB0.0 KB968.4 KB0.0 KB/s2.4 KB23:59:37
4neva.ru346.4 KB1.2 MB1.6 MB0.0 KB/s3.2 KB23:59:42
5eternal-september8.7 KB4.2 KB12.9 KB0.0 KB/s2.2 KB23:59:42
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
8news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:30
9news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:41
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 127.9 MB6.1 MB14.0 MB0.0 KB/s3.4 KB264:05:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 7 00.0 KB 0 0 001:00:38
2li121-238.members.linode.com 1 00.0 KB 0 0 000:00:01
3dslb-188-110-188-212.188.110.pools.vodafone-ip.de 111 00.0 KB 0 0 000:00:23
4196.52.22.56 1 00.0 KB 0 0 000:00:06
547.192.187.101 14 00.0 KB 0 0 002:16:31
TOTAL: 5 134 00.0 KB 0 0 003:17:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.members.linode.com 1 00.0 KB 0 0 000:00:01
2unresolved 15 00.0 KB 0 0 002:16:38
3*.188.110.pools.vodafone-ip.de 111 00.0 KB 0 0 000:00:23
4*.nielsenmedia.com 7 00.0 KB 0 0 001:00:38
TOTAL: 4 134 00.0 KB 0 0 003:17:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.192.187.101 0.872 0.052 0.00002:16:31
challenger.nielsenmedia.com 0.424 0.032 0.00001:00:38
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 5.780 0.388 0.00000:00:23
196.52.22.56 0.116 0.016 0.00000:00:06
li121-238.members.linode.com 0.052 0.008 0.00000:00:01
TOTAL: 5 7.244 0.496 0.00003:17:42

NNRP client timeouts [Top 20]:

SystemConnPeer
47.192.187.101 3 1
challenger.nielsenmedia.com 2 1
TOTAL: 2 5 3