Daily Usenet report for paganini.linuxd.org

Jun 16 00:00:02 -- Jun 17 00:00:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jun 16 05:41:38 paganini overchan[21747]: input line too long, skipping
Jun 16 05:48:05 paganini overchan[21747]: input line too long, skipping
Jun 16 05:56:59 paganini overchan[21747]: input line too long, skipping
Jun 16 06:47:27 paganini overchan[21747]: input line too long, skipping
Jun 16 08:11:56 paganini overchan[21747]: input line too long, skipping
Jun 17 00:00:02 paganini overchan[866]: 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 103850 58.6%12.9 MB 49.6%
nnrpd 32692 18.4%3.8 MB 14.5%
inn 30991 17.5%7.7 MB 29.6%
innd 9662 5.5%1.6 MB 6.3%
nocem 65 0.0%10.5 KB 0.0%
overchan 7 0.0%1.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 177268 100.0%26.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 114718 57.9%
Negative hits 53081 26.8%
Do not exist 30160 15.2%
Cache misses 80 0.0%
TOTAL: 4 198039 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.472 0.0%173 0.000 2.728 24.500
article cleanup00:00:00.198 0.0%30246 0.000 0.007 0.036
article logging00:00:00.544 0.0%30800 0.000 0.018 0.966
article parse00:00:00.609 0.0%45011 0.000 0.014 0.030
article write00:00:55.612 0.1%21699 0.120 2.563 21.356
artlog/artcncl00:00:00.001 0.0%161 0.000 0.006 0.032
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.144 0.0%207185 0.000 0.001 0.005
hisgrep/artcncl00:00:00.034 0.0%169 0.000 0.201 8.000
hishave/artcncl00:00:00.004 0.0%173 0.000 0.023 0.111
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:11.328 0.0%198599 0.016 0.057 0.482
history sync00:00:00.019 0.0%296 0.000 0.064 1.000
history write00:00:35.161 0.0%30244 0.024 1.163 7.292
hiswrite/artcncl00:00:00.001 0.0%4 0.000 0.250 0.500
idle23:56:17.838 99.7%203691 241.859 423.081 1180.179
nntp read00:00:01.544 0.0%209668 0.002 0.007 0.016
overview write00:00:20.082 0.0%21699 0.025 0.925 5.129
perl filter00:01:06.662 0.1%30242 1.024 2.204 16.713
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.355 0.0%65234 0.003 0.021 0.052
TOTAL: 24:00:23.36623:59:31.608 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.109 0.0%76575 0.000 0.001 0.010
article prepare00:00:00.007 0.0%37772 0.000 0.000 0.008
article read00:00:02.744 0.0%7543 0.000 0.364 11.389
backlog stats00:00:00.278 0.0%387867 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.720 0.0%210026 0.001 0.008 0.021
data write00:00:02.798 0.0%188466 0.006 0.015 0.031
idle23:42:36.785 99.3%387867 23.992 220.067 449.965
status file00:10:10.514 0.7%43416 8.184 14.062 46.887
TOTAL: 23:53:20.92723:52:54.955100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:28.096 99.5%33168 38.014 56.925 96.261
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.579 0.0%67536 0.003 0.009 0.018
readart00:00:00.003 0.0%23 0.000 0.130 0.500
TOTAL: 00:31:38.22700:31:28.678 99.5%----

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 4 45657 18872 25485 1300 41%48:00:14
2newsfeed.neva.ru 154 69393 2321 60208 6864 3%71:19:52
3news.fcku.it 2 7385 323 6754 308 4%21:01:00
4nntp.pasdenom.info 4 39088 141 38940 7 0%23:23:39
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 189 161523 21657 131387 8479 13%163:44:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net62.2 MB0.0 KB6.6 MB68.7 MB 90%3.5 KB
2newsfeed.neva.ru6.2 MB22.4 KB29.3 MB35.5 MB 17%4.0 KB
3news.fcku.it1.1 MB0.0 KB3.0 MB4.1 MB 27%6.6 KB
4nntp.pasdenom.info313.3 KB0.0 KB300.9 KB614.2 KB 51%4.2 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 569.8 MB22.4 KB39.1 MB108.9 MB 64%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 16 00:00:02 - 00:59:59 853 3.9% 0.243.1 MB 4.4% 0.88
Jun 16 01:00:00 - 01:59:59 610 2.8% 0.172.2 MB 3.0% 0.61
Jun 16 02:00:00 - 02:59:59 550 2.5% 0.151.6 MB 2.3% 0.46
Jun 16 03:00:00 - 03:59:59 407 1.9% 0.111.3 MB 1.9% 0.38
Jun 16 04:00:00 - 04:59:59 420 1.9% 0.121.3 MB 1.9% 0.38
Jun 16 05:00:00 - 05:59:59 456 2.1% 0.132.4 MB 3.3% 0.67
Jun 16 06:00:00 - 06:59:59 593 2.7% 0.162.7 MB 3.8% 0.76
Jun 16 07:00:00 - 07:59:59 496 2.3% 0.141.8 MB 2.6% 0.51
Jun 16 08:00:00 - 08:59:59 839 3.9% 0.232.7 MB 3.8% 0.77
Jun 16 09:00:00 - 09:59:59 1100 5.1% 0.313.0 MB 4.2% 0.84
Jun 16 10:00:00 - 10:59:59 1079 5.0% 0.303.2 MB 4.6% 0.92
Jun 16 11:00:00 - 11:59:59 983 4.5% 0.272.7 MB 3.8% 0.77
Jun 16 12:00:00 - 12:59:59 1045 4.8% 0.292.8 MB 4.0% 0.80
Jun 16 13:00:00 - 13:59:59 902 4.2% 0.252.9 MB 4.1% 0.83
Jun 16 14:00:00 - 14:59:59 1083 5.0% 0.303.1 MB 4.3% 0.87
Jun 16 15:00:00 - 15:59:59 1174 5.4% 0.333.5 MB 5.0% 1.00
Jun 16 16:00:00 - 16:59:59 1228 5.7% 0.343.8 MB 5.4% 1.08
Jun 16 17:00:00 - 17:59:59 1195 5.5% 0.333.5 MB 4.9% 0.98
Jun 16 18:00:00 - 18:59:59 1250 5.8% 0.353.7 MB 5.2% 1.05
Jun 16 19:00:00 - 19:59:59 1225 5.6% 0.344.0 MB 5.6% 1.13
Jun 16 20:00:00 - 20:59:59 1192 5.5% 0.334.4 MB 6.2% 1.25
Jun 16 21:00:00 - 21:59:59 1091 5.0% 0.303.1 MB 4.4% 0.89
Jun 16 22:00:00 - 22:59:59 985 4.5% 0.274.3 MB 6.1% 1.22
Jun 16 23:00:00 - 23:59:59 937 4.3% 0.263.5 MB 4.9% 0.99
Jun 17 00:00:00 - 00:00:02 22 0.1% 11.0081.6 KB 0.1% 40.81
TOTAL: 24:00:00 21715 100.0% 0.2570.5 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6933 396 0 2 2 0 0 0 6533
2linuxd-out.news.weretis.net 1849 517 0 0 0 0 0 0 1332
3news.fcku.it 310 5 0 0 1 0 0 0 304
4nntp.pasdenom.info 6 0 0 0 0 2 0 0 4
TOTAL: 4 9098 918 0 2 3 2 0 0 8173

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 148
lada.talk 147
it-alt.sport.calcio.juventus 56
it.comp.os.win.windows10 32
gmane.linux.alsa.devel 31
mozilla.dev.platform 26
lada.auto 25
it.annunci.commerciali 23
it.annunci.varie 23
it.annunci.immobiliari 23
gmane.linux.kernel 16
gmane.comp.gis.openstreetmap.tagging 14
mozilla.support.firefox 14
spline.eisfair 13
mozilla.support.seamonkey 13
mozilla.general 13
spline.eisfair.dev 12
lada.commerce 11
gmane.linux.ports.arm.kernel 11
lada.photo 11
TOTAL: 119 918

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.legal.moderated 2
alt.culture.china 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6712
EMP (phn path) 591
EMP (phn nph) 138
Too many newsgroups 76
EMP (phl) 61
Binary Payload 13
User-issued cancel 9
HTML post 8
Poison newsgroup 5
Binary Image: misplaced jpg 3
Binary: non-binary distribution 2
User-issued spam cancel 1
TOTAL: 12 7619

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 534
newsfeed.neva.ru 16
news.fcku.it 4
TOTAL: 3 554
TOTAL: 1 554

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 73466 2734 54856 1688 0 2783 3%23:57:37
2news.fcku.it 28254 1917 16687 2780 0 163 6%23:59:09
3weretis.net 2893 129 2637 0 0 36 4%23:57:24
4eternal-september 25295 27 18804 1 0 38 0%23:59:44
5neva.ru 27927 23 19184 186 0 58 0%23:59:42
6news.mixmin.net 0 0 0 0 0 0 0%00:10:00
7news.killfile.org 2844 0 0 0 0 24558 0%23:59:44
8etla.org 0 0 0 0 0 21715 0%23:59:44
9vc89.vc.panix.com 2842 0 0 0 0 24556 0%23:59:44
10news.albasani.net 2867 0 0 0 0 23579 0%23:59:44
11news.netfront.net 2756 0 0 0 0 24419 0%23:59:43
12news.stack.nl 2860 0 0 0 0 24479 0%23:59:44
TOTAL: 12 172004 4830 112168 4655 0 146384 2%264:01:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info9.2 MB3.3 MB12.5 MB0.1 KB/s2.9 KB23:57:37
2news.fcku.it5.4 MB8.6 MB14.0 MB0.2 KB/s3.1 KB23:59:09
3weretis.net270.9 KB0.0 KB270.9 KB0.0 KB/s2.1 KB23:57:24
4eternal-september129.0 KB2.1 KB131.1 KB0.0 KB/s4.7 KB23:59:44
5neva.ru109.9 KB730.7 KB840.5 KB0.0 KB/s4.0 KB23:59:42
6news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
7news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
10news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
TOTAL: 1215.1 MB12.6 MB27.8 MB0.0 KB/s3.0 KB264:01:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 59 2345.5 KB 3 0 000:31:38
TOTAL: 1 59 2345.5 KB 3 0 000:31:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 59 2345.5 KB 3 0 000:31:38
TOTAL: 1 59 2345.5 KB 3 0 000:31:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 6.408 1.448 0.00000:31:38
TOTAL: 1 6.408 1.448 0.00000:31:38

Newsgroup request counts (by category):

CategoryCountPct
1de 20 87.0%
2control 2 8.7%
3alt 1 4.3%
TOTAL: 3 23100.0%

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

NewsgroupCount
1de.talk.tagesgeschehen 20
2control.cancel 2
3alt.test 1
TOTAL: 3 23