Daily Usenet report for paganini.linuxd.org

Jan 14 00:00:03 -- Jan 15 00:00:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jan 14 15:10:55 paganini overchan[30100]: input line too long, skipping
Jan 14 15:13:29 paganini overchan[30100]: input line too long, skipping
Jan 14 15:35:59 paganini overchan[30100]: input line too long, skipping
Jan 14 19:45:32 paganini overchan[30100]: input line too long, skipping
Jan 14 21:21:16 paganini overchan[30100]: input line too long, skipping
Jan 14 21:29:51 paganini overchan[30100]: input line too long, skipping
Jan 15 00:00:02 paganini overchan[19678]: 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 100130 67.2%12.4 MB 56.4%
inn 33696 22.6%7.5 MB 33.8%
innd 14592 9.8%2.1 MB 9.4%
nnrpd 524 0.4%72.4 KB 0.3%
nocem 31 0.0%4.9 KB 0.0%
overchan 8 0.0%1.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 148982 100.0%22.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 118954 55.4%
Negative hits 62656 29.2%
Do not exist 33067 15.4%
Cache misses 53 0.0%
TOTAL: 4 214730 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.241 0.0%109 0.000 2.211 102.000
article cleanup00:00:00.208 0.0%33056 0.000 0.006 0.025
article logging00:00:00.285 0.0%33597 0.000 0.008 0.027
article parse00:00:00.831 0.0%68239 0.000 0.012 0.032
article write00:00:53.516 0.1%19747 0.082 2.710 55.083
artlog/artcncl00:00:00.002 0.0%107 0.000 0.019 0.056
data move00:00:00.159 0.0%228067 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%109 0.000 0.028 1.000
hishave/artcncl00:00:00.000 0.0%109 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.972 0.0%215468 0.014 0.060 1.851
history sync00:00:00.627 0.0%295 0.000 2.125 302.500
history write00:00:30.404 0.0%33055 0.027 0.920 4.763
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:38.266 99.7%225189 229.591 382.782 1175.741
nntp read00:00:01.749 0.0%232981 0.003 0.008 0.015
overview write00:00:19.973 0.0%19747 0.000 1.011 4.671
perl filter00:01:09.433 0.1%33055 1.189 2.101 8.283
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.259 0.0%59441 0.000 0.021 0.054
TOTAL: 24:00:23.65223:59:49.928100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.096 0.0%34080 0.000 0.003 0.015
article prepare00:00:00.004 0.0%25300 0.000 0.000 0.008
article read00:00:00.634 0.0%5354 0.000 0.118 1.688
backlog stats00:00:00.189 0.0%331023 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.412 0.0%178445 0.003 0.008 0.015
data write00:00:02.822 0.0%158868 0.007 0.018 0.033
idle23:42:51.681 99.3%331023 170.105 257.903 564.633
status file00:09:45.522 0.7%41836 8.596 13.996 39.071
TOTAL: 23:53:05.21923:52:42.360100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle06:32:06.313 99.9%442 29.000 53226.952600129.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.017 0.0%1161 0.000 0.015 0.167
readart00:00:00.034 0.0%20 1.700 1.700 1.700
TOTAL: 06:32:28.21806:32:06.364 99.9%----

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 3 43237 17689 23644 1904 40%48:08:30
2newsfeed.neva.ru 142 73486 1773 60792 10921 2%72:14:28
3news.fcku.it 1 5654 213 5301 140 3%21:22:20
4nntp.pasdenom.info 3 34689 61 34106 522 0%24:51:54
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 174 157066 19736 123843 13487 12%166:37:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net58.9 MB0.0 KB10.9 MB69.8 MB 84%3.6 KB
2newsfeed.neva.ru5.1 MB0.0 KB80.4 MB85.5 MB 5%6.9 KB
3news.fcku.it920.3 KB0.0 KB2.5 MB3.4 MB 26%9.7 KB
4nntp.pasdenom.info139.8 KB56.7 KB3.0 MB3.1 MB 4%5.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 565.0 MB56.7 KB96.7 MB161.7 MB 40%5.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 14 00:00:03 - 00:59:59 814 4.1% 0.233.6 MB 5.6% 1.04
Jan 14 01:00:00 - 01:59:59 751 3.8% 0.212.2 MB 3.4% 0.63
Jan 14 02:00:00 - 02:59:59 604 3.1% 0.172.2 MB 3.5% 0.64
Jan 14 03:00:00 - 03:59:59 466 2.4% 0.133.9 MB 6.0% 1.10
Jan 14 04:00:00 - 04:59:59 434 2.2% 0.121.6 MB 2.4% 0.45
Jan 14 05:00:00 - 05:59:59 445 2.3% 0.122.9 MB 4.4% 0.82
Jan 14 06:00:00 - 06:59:59 342 1.7% 0.101.0 MB 1.5% 0.29
Jan 14 07:00:00 - 07:59:59 388 2.0% 0.111.3 MB 2.0% 0.36
Jan 14 08:00:00 - 08:59:59 607 3.1% 0.171.8 MB 2.7% 0.50
Jan 14 09:00:00 - 09:59:59 675 3.4% 0.191.9 MB 3.0% 0.55
Jan 14 10:00:00 - 10:59:59 897 4.5% 0.253.1 MB 4.7% 0.88
Jan 14 11:00:00 - 11:59:59 954 4.8% 0.273.1 MB 4.8% 0.89
Jan 14 12:00:00 - 12:59:59 933 4.7% 0.262.4 MB 3.7% 0.69
Jan 14 13:00:00 - 13:59:59 998 5.1% 0.284.1 MB 6.3% 1.15
Jan 14 14:00:00 - 14:59:59 1044 5.3% 0.292.8 MB 4.3% 0.79
Jan 14 15:00:00 - 15:59:59 918 4.6% 0.262.4 MB 3.7% 0.69
Jan 14 16:00:00 - 16:59:59 1000 5.1% 0.282.9 MB 4.5% 0.82
Jan 14 17:00:00 - 17:59:59 1198 6.1% 0.333.2 MB 4.9% 0.91
Jan 14 18:00:00 - 18:59:59 980 5.0% 0.273.0 MB 4.7% 0.86
Jan 14 19:00:00 - 19:59:59 1173 5.9% 0.333.4 MB 5.2% 0.96
Jan 14 20:00:00 - 20:59:59 980 5.0% 0.273.0 MB 4.6% 0.85
Jan 14 21:00:00 - 21:59:59 1102 5.6% 0.312.8 MB 4.3% 0.80
Jan 14 22:00:00 - 22:59:59 1080 5.5% 0.303.1 MB 4.8% 0.88
Jan 14 23:00:00 - 23:59:59 962 4.9% 0.273.2 MB 4.9% 0.90
Jan 15 00:00:00 - 00:00:02 3 0.0% 1.507.1 KB 0.0% 3.57
TOTAL: 23:59:59 19748 100.0% 0.2364.9 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10756 305 0 0 0 0 0 010451
2linuxd-out.news.weretis.net 2424 386 0 0 0 0 0 0 2038
3nntp.pasdenom.info 493 0 0 1 0 0 0 0 492
4news.fcku.it 168 0 0 0 0 0 0 0 168
TOTAL: 4 13841 691 0 1 0 0 0 013149

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 86
ut.test 86
it-alt.sport.calcio.juventus 48
lada.auto 42
spline.eisfair 38
alt.survival 31
gmane.linux.alsa.devel 24
lada.commerce 23
mpc.lists.freebsd.x11 21
cakewalk.audio 20
it.comp.os.win.windows10 19
mozilla.support.firefox 18
mpc.lists.freebsd.gnome 17
alt.computer.workshop 13
mpc.lists.nanog 12
alt.windows7.general 11
spline.eisfair.dev 10
mozilla.support.thunderbird 8
mozilla.test 8
it-alt.comp.software.openoffice 8
TOTAL: 89 691

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10135
EMP (phn path) 1382
EMP (phl) 625
EMP (phn nph) 180
EMP (phr path) 164
Too many newsgroups 94
Binary Payload 10
User-issued cancel 8
HTML post 4
Binary Image: misplaced jpg 2
Binary: non-binary distribution 2
TOTAL: 11 12606

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 519
newsfeed.neva.ru 24
TOTAL: 2 543
TOTAL: 1 543

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 26536 1646 15868 2002 0 87 6%23:59:43
2nntp.pasdenom.info 35667 1302 17092 1229 0 342 3%23:57:36
3eternal-september 21683 38 17101 2 0 14 0%23:59:34
4neva.ru 26563 35 17867 56 0 65 0%23:59:43
5weretis.net 2204 33 2042 0 0 4 1%23:56:11
6etla.org 0 0 0 0 0 19748 0%23:59:43
7news.killfile.org 2768 0 0 0 0 22515 0%23:59:43
8news.mixmin.net 0 0 0 0 0 0 0%00:10:00
9news.albasani.net 2854 0 0 0 0 21687 0%23:59:43
10news.stack.nl 2859 0 0 0 0 22559 0%23:59:43
11news.netfront.net 2729 0 0 0 0 22290 0%23:59:42
12vc89.vc.panix.com 2776 0 0 0 0 22523 0%23:59:43
TOTAL: 12 126639 3054 69970 3289 0 131834 2%264:01:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info5.3 MB2.1 MB7.3 MB0.1 KB/s3.0 KB23:57:36
2news.fcku.it4.9 MB6.3 MB11.2 MB0.1 KB/s3.1 KB23:59:43
3eternal-september184.0 KB20.8 KB204.8 KB0.0 KB/s5.1 KB23:59:34
4neva.ru102.6 KB484.5 KB587.1 KB0.0 KB/s6.5 KB23:59:43
5weretis.net46.3 KB0.0 KB46.3 KB0.0 KB/s1.4 KB23:56:11
6etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
7news.killfile.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:00
9news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
TOTAL: 1210.5 MB8.8 MB19.4 MB0.0 KB/s3.1 KB264:01:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 25 2062.5 KB 2 0 004:45:25
TOTAL: 1 25 2062.5 KB 2 0 006:32:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 25 2062.5 KB 2 0 004:45:25
2*.094.216.pools.vodafone-ip.de 111 00.0 KB 0 0 000:00:22
3*.drr02.clwr.fl.frontiernet.net 17 00.0 KB 0 0 001:46:40
TOTAL: 3 153 2062.5 KB 2 0 006:32:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 1.588 0.096 0.00004:45:25
47-192-187-101.drr02.clwr.fl.frontiernet.net 1.064 0.088 0.00001:46:40
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 5.936 0.384 0.00000:00:22
TOTAL: 3 8.588 0.568 0.00006:32:27

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 111
47-192-187-101.drr02.clwr.fl.frontiernet.net 17
TOTAL: 2 128

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 20100.0%
TOTAL: 1 20100.0%

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

NewsgroupCount
1comp.lang.awk 20
TOTAL: 1 20