Daily Usenet report for paganini.linuxd.org

Apr 22 00:00:05 -- Apr 23 00:00:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Apr 22 00:37:48 paganini overchan[9858]: input line too long, skipping
Apr 22 10:53:47 paganini overchan[9858]: input line too long, skipping
Apr 22 14:51:37 paganini overchan[9858]: input line too long, skipping
Apr 22 16:34:59 paganini overchan[9858]: input line too long, skipping
Apr 22 20:37:40 paganini overchan[9858]: input line too long, skipping
Apr 22 20:47:25 paganini overchan[9858]: input line too long, skipping
Apr 22 20:57:57 paganini overchan[9858]: input line too long, skipping
Apr 22 22:26:21 paganini overchan[9858]: input line too long, skipping
Apr 22 23:07:43 paganini overchan[9858]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 115504 48.4%14.2 MB 44.5%
nnrpd 67055 28.1%7.7 MB 24.2%
inn 36915 15.5%7.5 MB 23.5%
innd 18853 7.9%2.5 MB 7.8%
nocem 62 0.0%11.3 KB 0.0%
overchan 9 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 238399 100.0%31.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 103927 49.0%
Negative hits 71923 33.9%
Do not exist 35945 17.0%
Cache misses 87 0.0%
TOTAL: 4 211882 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.839 0.0%182 0.000 10.104 57.000
article cleanup00:00:00.244 0.0%36403 0.000 0.007 0.025
article logging00:00:00.553 0.0%36772 0.000 0.015 0.281
article parse00:00:00.950 0.0%86431 0.000 0.011 0.036
article write00:00:51.687 0.1%18857 0.107 2.741 58.224
artlog/artcncl00:00:00.002 0.0%182 0.000 0.011 0.500
data move00:00:00.326 0.0%232917 0.000 0.001 0.044
hisgrep/artcncl00:00:00.273 0.0%182 0.000 1.500 10.684
hishave/artcncl00:00:00.036 0.0%182 0.000 0.198 1.684
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.014 0.0%214654 0.014 0.061 1.971
history sync00:00:00.229 0.0%301 0.000 0.761 44.750
history write00:00:32.069 0.0%36403 0.031 0.881 12.455
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:18.153 99.7%231647 179.077 372.024 1138.449
nntp read00:00:01.980 0.0%240102 0.001 0.008 0.047
overview write00:00:20.265 0.0%18857 0.000 1.075 8.567
perl filter00:01:22.425 0.1%36403 1.056 2.264 4.355
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.970 0.0%56750 0.000 0.017 0.048
TOTAL: 24:00:21.85323:59:45.015100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%34956 0.000 0.003 0.025
article prepare00:00:00.003 0.0%19304 0.000 0.000 0.015
article read00:00:01.055 0.0%4383 0.000 0.241 8.750
backlog stats00:00:00.179 0.0%273210 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.118 0.0%144995 0.002 0.008 0.018
data write00:00:02.480 0.0%126276 0.006 0.020 0.034
idle23:42:14.959 99.2%273210 217.437 312.342 472.617
status file00:11:26.788 0.8%48444 9.029 14.177 31.707
TOTAL: 23:53:59.73323:53:46.694100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:55:15.145 99.6%67866 37.317 101.894600747.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.327 0.0%137868 0.000 0.010 0.017
readart00:00:00.000 0.0%5 0.000 0.000 0.000
TOTAL: 01:55:40.52601:55:16.472 99.7%----

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 4 41415 15924 23465 2026 38%47:52:31
2newsfeed.neva.ru 141 75512 1702 58624 15186 2%71:53:20
3news.fcku.it 2 5816 991 4601 224 17%22:27:30
4nntp.pasdenom.info 2 21036 50 20978 8 0%24:13:49
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 174 143779 18667 107668 17444 12%166:27:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net51.3 MB0.0 KB13.1 MB64.3 MB 79%3.7 KB
2newsfeed.neva.ru4.2 MB0.0 KB133.9 MB138.2 MB 3%8.4 KB
3news.fcku.it3.0 MB0.0 KB3.1 MB6.1 MB 48%5.1 KB
4nntp.pasdenom.info156.7 KB0.0 KB88.6 KB245.2 KB 63%4.2 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 558.6 MB0.0 KB150.2 MB208.8 MB 28%5.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 22 00:00:05 - 00:59:59 867 4.6% 0.242.8 MB 4.7% 0.80
Apr 22 01:00:00 - 01:59:59 639 3.4% 0.182.1 MB 3.5% 0.59
Apr 22 02:00:00 - 02:59:59 489 2.6% 0.141.6 MB 2.6% 0.44
Apr 22 03:00:00 - 03:59:59 356 1.9% 0.101.3 MB 2.3% 0.38
Apr 22 04:00:00 - 04:59:59 524 2.8% 0.153.0 MB 5.1% 0.85
Apr 22 05:00:00 - 05:59:59 350 1.9% 0.101.4 MB 2.4% 0.41
Apr 22 06:00:00 - 06:59:59 425 2.3% 0.121.2 MB 2.0% 0.34
Apr 22 07:00:00 - 07:59:59 452 2.4% 0.131.6 MB 2.7% 0.45
Apr 22 08:00:00 - 08:59:59 653 3.5% 0.182.2 MB 3.7% 0.62
Apr 22 09:00:00 - 09:59:59 764 4.1% 0.212.2 MB 3.7% 0.63
Apr 22 10:00:00 - 10:59:59 722 3.8% 0.201.9 MB 3.2% 0.54
Apr 22 11:00:00 - 11:59:59 840 4.5% 0.232.3 MB 3.9% 0.66
Apr 22 12:00:00 - 12:59:59 883 4.7% 0.252.3 MB 3.9% 0.66
Apr 22 13:00:00 - 13:59:59 926 4.9% 0.262.7 MB 4.6% 0.77
Apr 22 14:00:00 - 14:59:59 865 4.6% 0.242.4 MB 4.1% 0.70
Apr 22 15:00:00 - 15:59:59 906 4.8% 0.252.4 MB 4.1% 0.69
Apr 22 16:00:00 - 16:59:59 1056 5.6% 0.293.4 MB 5.8% 0.98
Apr 22 17:00:00 - 17:59:59 1165 6.2% 0.323.3 MB 5.6% 0.94
Apr 22 18:00:00 - 18:59:59 1116 5.9% 0.313.5 MB 5.9% 0.99
Apr 22 19:00:00 - 19:59:59 1093 5.8% 0.303.0 MB 5.1% 0.86
Apr 22 20:00:00 - 20:59:59 1052 5.6% 0.293.3 MB 5.6% 0.95
Apr 22 21:00:00 - 21:59:59 1017 5.4% 0.283.2 MB 5.4% 0.90
Apr 22 22:00:00 - 22:59:59 910 4.8% 0.253.7 MB 6.2% 1.04
Apr 22 23:00:00 - 23:59:59 719 3.8% 0.202.2 MB 3.7% 0.62
Apr 23 00:00:00 - 00:00:03 4 0.0% 1.3330.7 KB 0.1% 10.24
TOTAL: 23:59:58 18793 100.0% 0.2259.1 MB 100.0% 0.70
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15297 334 0 0 0 0 0 014963
2linuxd-out.news.weretis.net 2370 375 0 0 0 0 0 0 1995
3news.fcku.it 275 16 0 0 0 0 0 0 259
4nntp.pasdenom.info 16 1 0 0 0 0 0 0 15
TOTAL: 4 17958 726 0 0 0 0 0 017232

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 110
lada.talk 103
mpc.lists.freebsd.ports.bugs 33
it-alt.sport.calcio.juventus 32
alt.windows7.general 30
spline.eisfair 29
it.comp.os.win.windows10 25
spline.eisfair.dev 23
lada.kitchen 19
mozilla.support.seamonkey 17
lada.auto 17
mozilla.general 16
alt.politics.scorched-earth 15
alt.politics 14
mozilla.support.firefox 14
gmane.comp.gis.openstreetmap 14
mozilla.support.thunderbird 13
mpc.lists.freebsd.wireless 12
alt.survival 11
lada.commerce 11
TOTAL: 90 726

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14961
EMP (phn path) 1735
Too many newsgroups 41
EMP (phn nph) 40
User-issued cancel 33
Binary: non-binary distribution 16
Binary Payload 12
HTML post 8
EMP (phl) 6
User-issued spam cancel 4
Too many newsgroups (low_xpost) 4
Binary Image: misplaced jpg 2
Binary: misplaced ARJ 1
TOTAL: 13 16863

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 344
newsfeed.neva.ru 20
news.fcku.it 5
TOTAL: 3 369
TOTAL: 1 369

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 21563 1570 14079 2123 0 3 7%23:59:48
2nntp.pasdenom.info 7940 750 2759 92 0 17155 9%23:57:44
3neva.ru 24985 44 16821 234 0 12 0%23:59:51
4eternal-september 20921 19 16136 0 0 8 0%23:59:52
5weretis.net 220 6 205 0 0 2587 2%23:54:58
6news.killfile.org 2848 0 0 0 0 21640 0%23:59:51
7news.albasani.net 2865 0 0 0 0 20798 0%23:59:52
8vc89.vc.panix.com 2841 0 0 0 0 21633 0%23:59:51
9etla.org 0 0 0 0 0 18793 0%23:59:52
10news.netfront.net 2775 0 0 0 0 21510 0%23:59:51
11news.stack.nl 2858 0 0 0 0 21608 0%23:59:52
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 89816 2389 50000 2449 0 145747 2%264:01:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it4.4 MB6.3 MB10.8 MB0.1 KB/s3.0 KB23:59:48
2nntp.pasdenom.info2.4 MB315.4 KB2.7 MB0.0 KB/s3.3 KB23:57:44
3neva.ru97.1 KB634.5 KB731.7 KB0.0 KB/s2.6 KB23:59:51
4eternal-september77.9 KB0.0 KB77.9 KB0.0 KB/s4.1 KB23:59:52
5weretis.net10.3 KB0.0 KB10.3 KB0.0 KB/s1.7 KB23:54:58
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
7news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 127.0 MB7.2 MB14.2 MB0.0 KB/s3.0 KB264:01:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-094-217-142-075.094.217.pools.vodafone-ip.de 121 530.9 KB 5 0 000:55:37
TOTAL: 1 121 530.9 KB 5 0 001:55:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.094.217.pools.vodafone-ip.de 121 530.9 KB 5 0 000:55:37
2*.nielsenmedia.com 2 00.0 KB 0 0 001:00:02
3*.drr02.clwr.fl.frontiernet.net 1 00.0 KB 0 0 000:00:00
TOTAL: 3 124 530.9 KB 5 0 001:55:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.080 0.008 0.00001:00:02
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 12.700 3.296 0.00000:55:37
TOTAL: 2 12.780 3.304 0.00001:55:40

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 2
47-192-187-101.drr02.clwr.fl.frontiernet.net 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1de 5100.0%
TOTAL: 1 5100.0%

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

NewsgroupCount
1de.alt.folklore.ddr 1
2de.etc.finanz.banken+broker 1
3de.soc.weltanschauung.misc 1
4de.soc.umwelt 1
5de.soc.politik.misc 1
TOTAL: 5 5