Daily Usenet report for paganini.linuxd.org

Jun 8 00:00:02 -- Jun 9 00:00:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jun 8 06:44:02 paganini overchan[26679]: input line too long, skipping
Jun 8 08:19:30 paganini overchan[26679]: input line too long, skipping
Jun 8 09:21:26 paganini overchan[26679]: input line too long, skipping
Jun 8 10:02:43 paganini overchan[26679]: input line too long, skipping
Jun 8 12:45:28 paganini overchan[26679]: input line too long, skipping
Jun 8 15:44:20 paganini overchan[26679]: input line too long, skipping
Jun 9 00:00:02 paganini overchan[11186]: 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 101317 51.3%12.6 MB 44.4%
nnrpd 57072 28.9%6.6 MB 23.1%
inn 30382 15.4%7.8 MB 27.4%
innd 8560 4.3%1.4 MB 5.0%
nocem 101 0.1%17.2 KB 0.1%
overchan 8 0.0%1.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 197441 100.0%28.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116994 58.7%
Negative hits 52451 26.3%
Do not exist 29685 14.9%
Cache misses 51 0.0%
TOTAL: 4 199181 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.567 0.0%191 0.000 2.969 51.000
article cleanup00:00:00.216 0.0%29795 0.000 0.007 0.028
article logging00:00:00.208 0.0%30201 0.000 0.007 0.024
article parse00:00:00.591 0.0%44083 0.000 0.013 0.035
article write00:00:54.973 0.1%22417 0.157 2.452 9.688
artlog/artcncl00:00:00.001 0.0%191 0.000 0.005 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.134 0.0%209424 0.000 0.001 0.003
hisgrep/artcncl00:00:00.003 0.0%187 0.000 0.016 0.500
hishave/artcncl00:00:00.000 0.0%191 0.000 0.000 0.000
hissync/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.064 0.0%199906 0.014 0.045 0.547
history sync00:00:00.054 0.0%303 0.000 0.178 21.000
history write00:00:36.547 0.0%29794 0.048 1.227 7.109
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:56:43.875 99.7%204221 239.055 422.111 1252.284
nntp read00:00:01.517 0.0%209519 0.002 0.007 0.015
overview write00:00:21.452 0.0%22417 0.021 0.957 3.979
perl filter00:00:53.615 0.1%29792 1.065 1.800 6.651
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.673 0.0%67597 0.003 0.025 0.148
TOTAL: 24:00:24.32523:59:44.490100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.095 0.0%38000 0.000 0.003 0.014
article prepare00:00:00.002 0.0%35796 0.000 0.000 0.004
article read00:00:04.063 0.0%7007 0.000 0.580 16.500
backlog stats00:00:00.261 0.0%348995 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.633 0.0%193328 0.002 0.008 0.016
data write00:00:03.090 0.0%171213 0.010 0.018 0.031
idle23:43:41.469 99.3%348995 166.726 244.764 433.885
status file00:09:32.759 0.7%42373 8.038 13.517 30.795
TOTAL: 23:53:40.90423:53:23.372100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:55:35.317 99.3%57850 38.623 57.655 91.628
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.998 0.0%117688 0.003 0.008 0.016
readart00:00:00.000 0.0%5 0.000 0.000 0.000
TOTAL: 00:55:57.50700:55:36.315 99.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 47693 19608 26643 1442 41%48:16:59
2newsfeed.neva.ru 145 69795 2467 61484 5844 3%72:13:15
3news.fcku.it 2 8658 308 8220 130 3%26:14:14
4nntp.pasdenom.info 2 22704 48 22599 57 0%23:59:06
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 148850 22431 118946 7473 15%170:43:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net69.2 MB0.0 KB6.2 MB75.3 MB 91%3.7 KB
2newsfeed.neva.ru7.4 MB10.8 KB24.3 MB31.7 MB 23%3.9 KB
3news.fcku.it1.0 MB0.0 KB1.4 MB2.5 MB 42%5.8 KB
4nntp.pasdenom.info98.7 KB0.0 KB177.1 KB275.8 KB 35%2.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 577.7 MB10.8 KB32.1 MB109.7 MB 70%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 8 00:00:02 - 00:59:59 737 3.3% 0.203.0 MB 3.8% 0.85
Jun 8 01:00:00 - 01:59:59 880 3.9% 0.243.4 MB 4.3% 0.95
Jun 8 02:00:00 - 02:59:59 695 3.1% 0.193.0 MB 3.8% 0.85
Jun 8 03:00:00 - 03:59:59 497 2.2% 0.142.1 MB 2.7% 0.60
Jun 8 04:00:00 - 04:59:59 575 2.6% 0.163.0 MB 3.8% 0.85
Jun 8 05:00:00 - 05:59:59 433 1.9% 0.122.4 MB 3.0% 0.67
Jun 8 06:00:00 - 06:59:59 516 2.3% 0.141.9 MB 2.4% 0.54
Jun 8 07:00:00 - 07:59:59 537 2.4% 0.152.0 MB 2.6% 0.58
Jun 8 08:00:00 - 08:59:59 666 3.0% 0.182.2 MB 2.9% 0.64
Jun 8 09:00:00 - 09:59:59 1033 4.6% 0.292.9 MB 3.7% 0.84
Jun 8 10:00:00 - 10:59:59 1038 4.6% 0.292.9 MB 3.7% 0.84
Jun 8 11:00:00 - 11:59:59 1101 4.9% 0.313.9 MB 5.0% 1.11
Jun 8 12:00:00 - 12:59:59 1057 4.7% 0.293.2 MB 4.1% 0.92
Jun 8 13:00:00 - 13:59:59 901 4.0% 0.252.9 MB 3.7% 0.83
Jun 8 14:00:00 - 14:59:59 1177 5.3% 0.333.1 MB 4.0% 0.89
Jun 8 15:00:00 - 15:59:59 1283 5.7% 0.364.8 MB 6.1% 1.36
Jun 8 16:00:00 - 16:59:59 1171 5.2% 0.333.8 MB 4.8% 1.07
Jun 8 17:00:00 - 17:59:59 1186 5.3% 0.333.7 MB 4.7% 1.04
Jun 8 18:00:00 - 18:59:59 1252 5.6% 0.353.8 MB 4.8% 1.08
Jun 8 19:00:00 - 19:59:59 1227 5.5% 0.343.4 MB 4.3% 0.97
Jun 8 20:00:00 - 20:59:59 1214 5.4% 0.344.4 MB 5.6% 1.24
Jun 8 21:00:00 - 21:59:59 1197 5.3% 0.333.5 MB 4.4% 0.99
Jun 8 22:00:00 - 22:59:59 1008 4.5% 0.284.9 MB 6.2% 1.39
Jun 8 23:00:00 - 23:59:59 1021 4.6% 0.284.3 MB 5.5% 1.22
Jun 9 00:00:00 - 00:00:02 13 0.1% 6.5052.1 KB 0.1% 26.07
TOTAL: 24:00:00 22415 100.0% 0.2678.5 MB 100.0% 0.93
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5814 271 0 1 0 0 0 0 5542
2linuxd-out.news.weretis.net 1829 536 0 0 0 0 0 0 1293
3news.fcku.it 127 8 0 0 0 0 0 0 119
4nntp.pasdenom.info 6 0 0 0 0 2 0 0 4
TOTAL: 4 7776 815 0 1 0 2 0 0 6958

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 124
gmane.linux.alsa.devel 74
it-alt.sport.calcio.juventus 62
lada.talk 51
lada.auto 44
it.comp.os.win.windows10 40
it.annunci.varie 34
it.annunci.immobiliari 32
it.annunci.commerciali 31
mozilla.support.seamonkey 28
mozilla.general 26
mozilla.dev.security.policy 25
alt.windows7.general 19
uk.radio.amateur.moderated 15
spline.eisfair 13
gmane.comp.gis.openstreetmap.tagging 12
mozilla.support.thunderbird 10
cakewalk.audio 7
alt.politics 7
gmane.linux.alsa.user 6
TOTAL: 93 815

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5597
EMP (phn path) 552
EMP (phl) 138
EMP (phn nph) 124
Too many newsgroups 52
User-issued cancel 48
Binary Payload 16
Binary Image: misplaced jpg 14
HTML post 4
Binary: non-binary distribution 4
Binary: misplaced rar 2
Too many newsgroups (low_xpost) 1
User-issued spam cancel 1
TOTAL: 13 6553

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 38236 3093 18265 911 0 899 8%23:53:55
2news.fcku.it 28599 1844 17353 2786 0 236 6%23:50:01
3weretis.net 3098 95 2721 0 0 14 3%23:52:12
4eternal-september 25145 22 19431 0 0 43 0%23:58:18
5neva.ru 27562 12 19654 155 0 204 0%23:50:01
6news.mixmin.net 0 0 0 0 0 0 0%00:10:00
7news.stack.nl 2857 0 0 0 0 25150 0%23:59:41
8news.killfile.org 2843 0 0 0 0 25242 0%23:59:33
9news.netfront.net 2760 0 0 0 0 25123 0%23:59:49
10vc89.vc.panix.com 2841 0 0 0 0 25240 0%23:59:33
11etla.org 0 0 0 0 0 22247 0%23:50:01
12news.albasani.net 2864 0 0 0 0 24504 0%23:59:21
TOTAL: 12 136805 5066 77424 3852 0 148902 3%263:22:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info11.0 MB2.0 MB13.0 MB0.2 KB/s3.3 KB23:53:55
2news.fcku.it5.5 MB8.9 MB14.4 MB0.2 KB/s3.2 KB23:50:01
3weretis.net211.0 KB0.0 KB211.0 KB0.0 KB/s2.2 KB23:52:12
4eternal-september88.8 KB0.0 KB88.8 KB0.0 KB/s4.0 KB23:58:18
5neva.ru81.6 KB704.1 KB785.7 KB0.0 KB/s4.7 KB23:50:01
6news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
7news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:41
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:33
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:33
11etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:21
TOTAL: 1216.9 MB11.6 MB28.4 MB0.0 KB/s3.3 KB263:22:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 103 512.0 KB 5 0 000:55:57
TOTAL: 1 103 512.0 KB 5 0 000:55:57

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 103 512.0 KB 5 0 000:55:57
TOTAL: 1 103 512.0 KB 5 0 000:55:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 11.140 2.668 0.00000:55:57
TOTAL: 1 11.140 2.668 0.00000:55:57

Newsgroup request counts (by category):

CategoryCountPct
1de 5100.0%
TOTAL: 1 5100.0%

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

NewsgroupCount
1de.soc.politik.misc 2
2de.sci.philosophie 1
3de.soc.umwelt 1
4de.soc.recht.arbeit+soziales 1
TOTAL: 4 5