Daily Usenet report for paganini.linuxd.org

May 29 00:00:05 -- May 30 00:00:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

May 29 07:28:54 paganini overchan[27402]: input line too long, skipping
May 29 08:34:34 paganini overchan[27402]: input line too long, skipping
May 29 14:02:42 paganini overchan[27402]: input line too long, skipping
May 29 15:08:06 paganini overchan[27402]: input line too long, skipping
May 29 18:51:36 paganini overchan[27402]: input line too long, skipping
May 30 00:00:02 paganini overchan[7008]: 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 101457 59.0%12.6 MB 49.4%
inn 31571 18.3%7.8 MB 30.8%
nnrpd 29020 16.9%3.4 MB 13.3%
innd 9973 5.8%1.7 MB 6.5%
nocem 75 0.0%12.6 KB 0.0%
overchan 8 0.0%1.0 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 7 172105 100.0%25.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116112 57.7%
Negative hits 54217 26.9%
Do not exist 30930 15.4%
Cache misses 73 0.0%
TOTAL: 4 201332 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.368 0.0%176 0.000 2.091 25.500
article cleanup00:00:00.189 0.0%31038 0.000 0.006 0.021
article logging00:00:00.358 0.0%31440 0.000 0.011 0.384
article parse00:00:00.693 0.0%48892 0.000 0.014 0.035
article write00:00:49.976 0.1%22158 0.117 2.255 17.061
artlog/artcncl00:00:00.000 0.0%175 0.000 0.000 0.000
data move00:00:00.103 0.0%213697 0.000 0.000 0.003
hisgrep/artcncl00:00:00.000 0.0%175 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%176 0.000 0.006 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.541 0.0%201948 0.016 0.052 0.560
history sync00:00:00.111 0.0%409 0.000 0.271 14.000
history write00:00:36.734 0.0%31038 0.025 1.184 5.720
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:15.846 99.7%210922 219.483 408.852 1227.910
nntp read00:00:01.585 0.0%216300 0.003 0.007 0.052
overview write00:00:25.776 0.0%22158 0.012 1.163 8.878
perl filter00:01:00.581 0.1%31038 1.195 1.952 5.397
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.340 0.0%66670 0.000 0.020 0.049
TOTAL: 24:01:09.90224:00:24.202 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.094 0.0%36814 0.000 0.003 0.017
article prepare00:00:00.003 0.0%38100 0.000 0.000 0.005
article read00:00:05.072 0.0%7381 0.000 0.687 45.304
backlog stats00:00:00.231 0.0%350513 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.538 0.0%193269 0.001 0.008 0.019
data write00:00:02.965 0.0%171307 0.009 0.017 0.032
idle23:43:59.157 99.3%350513 162.343 243.755 438.723
status file00:09:37.835 0.7%42408 8.200 13.626 40.516
TOTAL: 23:54:09.25423:53:46.895100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:58:51.902 99.9%29381 86.962 365.267603497.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.556 0.0%59712 0.000 0.009 0.026
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 02:59:06.65602:58:52.458 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 4 46524 19576 26099 849 42%48:42:57
2newsfeed.neva.ru 143 71579 2375 61456 7748 3%71:46:26
3news.fcku.it 1 7657 292 7160 205 3%23:47:53
4nntp.pasdenom.info 2 16916 91 16812 13 0%23:40:44
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 175 142676 22334 111527 8815 15%167:58:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net64.9 MB0.0 KB3.0 MB67.9 MB 95%3.4 KB
2newsfeed.neva.ru6.1 MB0.0 KB36.5 MB42.6 MB 14%4.3 KB
3news.fcku.it1020.2 KB0.0 KB3.8 MB4.8 MB 20%9.9 KB
4nntp.pasdenom.info194.4 KB0.0 KB232.6 KB427.0 KB 45%4.1 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 572.2 MB0.0 KB43.6 MB115.8 MB 62%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 29 00:00:05 - 00:59:59 667 3.0% 0.191.9 MB 2.7% 0.55
May 29 01:00:00 - 01:59:59 571 2.6% 0.161.6 MB 2.2% 0.46
May 29 02:00:00 - 02:59:59 410 1.9% 0.111.2 MB 1.6% 0.33
May 29 03:00:00 - 03:59:59 431 1.9% 0.121.3 MB 1.9% 0.38
May 29 04:00:00 - 04:59:59 350 1.6% 0.101.8 MB 2.5% 0.52
May 29 05:00:00 - 05:59:59 415 1.9% 0.121.4 MB 2.0% 0.41
May 29 06:00:00 - 06:59:59 567 2.6% 0.161.9 MB 2.7% 0.55
May 29 07:00:00 - 07:59:59 592 2.7% 0.162.0 MB 2.8% 0.58
May 29 08:00:00 - 08:59:59 726 3.3% 0.202.2 MB 3.0% 0.63
May 29 09:00:00 - 09:59:59 907 4.1% 0.252.5 MB 3.5% 0.72
May 29 10:00:00 - 10:59:59 1007 4.5% 0.283.9 MB 5.4% 1.12
May 29 11:00:00 - 11:59:59 1229 5.6% 0.343.7 MB 5.1% 1.06
May 29 12:00:00 - 12:59:59 994 4.5% 0.282.7 MB 3.7% 0.76
May 29 13:00:00 - 13:59:59 908 4.1% 0.252.4 MB 3.3% 0.67
May 29 14:00:00 - 14:59:59 1147 5.2% 0.324.3 MB 5.9% 1.21
May 29 15:00:00 - 15:59:59 1191 5.4% 0.334.0 MB 5.6% 1.15
May 29 16:00:00 - 16:59:59 1217 5.5% 0.343.7 MB 5.1% 1.06
May 29 17:00:00 - 17:59:59 1474 6.7% 0.414.3 MB 5.9% 1.21
May 29 18:00:00 - 18:59:59 1313 5.9% 0.363.8 MB 5.2% 1.08
May 29 19:00:00 - 19:59:59 1186 5.4% 0.333.7 MB 5.0% 1.04
May 29 20:00:00 - 20:59:59 1298 5.9% 0.364.8 MB 6.5% 1.36
May 29 21:00:00 - 21:59:59 1183 5.3% 0.333.6 MB 4.9% 1.02
May 29 22:00:00 - 22:59:59 1233 5.6% 0.344.2 MB 5.7% 1.19
May 29 23:00:00 - 23:59:59 1113 5.0% 0.315.7 MB 7.8% 1.62
May 30 00:00:00 - 00:00:02 5 0.0% 2.5028.8 KB 0.0% 14.41
TOTAL: 23:59:57 22134 100.0% 0.2672.8 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7800 443 0 0 0 0 0 0 7357
2linuxd-out.news.weretis.net 1231 456 0 0 0 0 0 0 775
3news.fcku.it 226 2 0 0 0 0 0 0 224
4nntp.pasdenom.info 22 0 0 0 0 0 0 0 22
TOTAL: 4 9279 901 0 0 0 0 0 0 8378

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 149
lada.talk 148
it.comp.os.win.windows10 51
it-alt.sport.calcio.juventus 47
lada.auto 44
mpc.lists.freebsd.ports.bugs 37
it.annunci.immobiliari 33
it.annunci.varie 32
lada.photo 27
mozilla.support.seamonkey 24
lada.commerce 23
mozilla.support.thunderbird 21
it.annunci.commerciali 21
cakewalk.audio 12
alt.pl.nieruchomosci.gielda 12
spline.eisfair.dev 11
mozilla.support.firefox 11
spline.eisfair 11
free.it.religioni.scientology 8
oesterreich.tratsch 8
TOTAL: 112 901

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7356
EMP (phn path) 304
EMP (phl) 159
Too many newsgroups 48
User-issued cancel 36
Binary: non-binary distribution 36
Binary Payload 14
HTML post 8
EMP (phn nph) 8
Binary Image: misplaced jpg 3
User-issued spam cancel 3
TOTAL: 11 7975

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 375
newsfeed.neva.ru 25
news.fcku.it 3
TOTAL: 3 403
TOTAL: 1 403

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 37647 3347 17881 879 0 510 8%24:00:17
2news.fcku.it 28274 2303 16948 2685 0 97 8%24:09:29
3weretis.net 2930 113 2645 0 0 10 3%23:55:49
4eternal-september 25421 45 18935 0 0 12 0%24:09:33
5neva.ru 28053 33 19642 184 0 45 0%24:09:33
6news.killfile.org 2841 0 0 0 0 25003 0%24:00:11
7news.albasani.net 2866 0 0 0 0 24044 0%24:00:06
8etla.org 0 0 0 0 0 22271 0%24:09:33
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10news.netfront.net 2764 0 0 0 0 24869 0%23:59:51
11vc89.vc.panix.com 2841 0 0 0 0 25003 0%24:00:11
12news.stack.nl 2858 0 0 0 0 24903 0%23:59:53
TOTAL: 12 136495 5841 76051 3748 0 146767 4%264:44:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info12.2 MB2.0 MB14.2 MB0.2 KB/s3.4 KB24:00:17
2news.fcku.it6.6 MB8.1 MB14.7 MB0.2 KB/s3.0 KB24:09:29
3weretis.net143.0 KB0.0 KB143.0 KB0.0 KB/s1.3 KB23:55:49
4eternal-september137.7 KB0.0 KB137.7 KB0.0 KB/s3.1 KB24:09:33
5neva.ru127.1 KB583.1 KB710.1 KB0.0 KB/s3.3 KB24:09:33
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:11
7news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:06
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:33
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
11vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:11
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 1219.2 MB10.7 MB29.9 MB0.0 KB/s3.2 KB264:44:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 53 23.3 KB 2 0 001:26:28
TOTAL: 1 53 23.3 KB 2 0 002:59:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 53 23.3 KB 2 0 001:26:28
2*.drr02.clwr.fl.frontiernet.net 3 00.0 KB 0 0 001:32:38
TOTAL: 2 56 23.3 KB 2 0 002:59:06

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.152 0.020 0.00001:32:38
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 5.688 1.536 0.00001:26:28
TOTAL: 2 5.840 1.556 0.00002:59:06

Curious NNRP server explorers [Top 20]:

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

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1de.soc.politik.misc 1
2de.sci.electronics 1
TOTAL: 2 2