Daily Usenet report for paganini.linuxd.org

Apr 9 00:00:06 -- Apr 10 00:00:03

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 9 22:36:21 paganini overchan[4542]: input line too long, skipping
Apr 10 00:00:03 paganini overchan[16335]: 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 101363 45.5%12.4 MB 41.7%
nnrpd 64889 29.1%7.5 MB 25.1%
inn 36632 16.4%7.3 MB 24.5%
innd 19717 8.9%2.6 MB 8.7%
nocem 97 0.0%16.0 KB 0.1%
overchan 3 0.0%0.3 KB 0.0%
TOTAL: 6 222701 100.0%29.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 94595 45.8%
Negative hits 76027 36.8%
Do not exist 35633 17.3%
Cache misses 71 0.0%
TOTAL: 4 206326 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.731 0.0%199 0.000 3.673 37.000
article cleanup00:00:00.267 0.0%35848 0.000 0.007 0.028
article logging00:00:00.349 0.0%36169 0.000 0.010 0.030
article parse00:00:01.119 0.0%89791 0.000 0.012 0.046
article write00:00:48.095 0.1%17654 0.154 2.724 22.305
artlog/artcncl00:00:00.003 0.0%199 0.000 0.015 1.000
data move00:00:00.269 0.0%223754 0.000 0.001 0.184
hisgrep/artcncl00:00:00.044 0.0%197 0.000 0.223 6.000
hishave/artcncl00:00:00.010 0.0%199 0.000 0.050 9.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.447 0.0%207406 0.014 0.050 0.477
history sync00:00:00.028 0.0%389 0.000 0.072 0.667
history write00:00:28.173 0.0%35847 0.049 0.786 2.843
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:47:15.384 99.7%225628 217.356 379.542 1310.352
nntp read00:00:01.790 0.0%233746 0.002 0.008 0.061
overview write00:00:21.158 0.0%17654 0.022 1.198 12.339
perl filter00:01:27.728 0.1%35846 1.147 2.447 5.410
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.986 0.0%53172 0.000 0.019 0.113
TOTAL: 23:51:05.15323:50:36.581100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.081 0.0%31971 0.000 0.003 0.020
article prepare00:00:00.005 0.0%35592 0.000 0.000 0.013
article read00:00:01.821 0.0%6902 0.000 0.264 5.000
backlog stats00:00:00.191 0.0%299086 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.236 0.0%162480 0.002 0.008 0.020
data write00:00:02.667 0.0%144877 0.009 0.018 0.036
idle23:43:19.792 99.3%299086 194.690 285.536 534.774
status file00:10:00.820 0.7%42382 8.603 14.176 41.752
TOTAL: 23:53:36.73323:53:26.613100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:56:09.599 99.6%65595 36.352 161.134600187.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.091 0.0%133320 0.000 0.023 8.164
readart00:00:24.705 0.2%31722 0.000 0.779 1.611
TOTAL: 02:56:57.26402:56:37.395 99.8%----

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 3 37643 14951 21242 1450 39%48:16:57
2newsfeed.neva.ru 145 70958 1761 52659 16538 2%71:55:10
3news.fcku.it 1 5826 957 4522 347 16%23:06:24
4nntp.pasdenom.info 2 16801 23 16761 17 0%23:56:40
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 176 131228 17692 95184 18352 13%167:15:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net50.2 MB16.1 KB10.7 MB61.0 MB 82%3.8 KB
2news.fcku.it5.3 MB0.0 KB4.5 MB9.8 MB 54%7.7 KB
3newsfeed.neva.ru4.8 MB0.0 KB142.2 MB147.0 MB 3%8.2 KB
4nntp.pasdenom.info63.9 KB0.0 KB733.2 KB797.1 KB 8%19.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 560.4 MB16.1 KB158.1 MB218.5 MB 27%6.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 9 00:00:06 - 00:59:59 613 3.4% 0.174.3 MB 7.1% 1.21
Apr 9 01:00:00 - 01:59:59 597 3.4% 0.172.6 MB 4.3% 0.74
Apr 9 02:00:00 - 02:59:59 518 2.9% 0.142.4 MB 4.0% 0.68
Apr 9 03:00:00 - 03:59:59 387 2.2% 0.111.3 MB 2.1% 0.36
Apr 9 04:00:00 - 04:59:59 389 2.2% 0.111.5 MB 2.4% 0.42
Apr 9 05:00:00 - 05:59:59 376 2.1% 0.101.8 MB 3.0% 0.51
Apr 9 06:00:00 - 06:59:59 410 2.3% 0.111.5 MB 2.5% 0.43
Apr 9 07:00:00 - 07:59:59 339 1.9% 0.09933.3 KB 1.5% 0.26
Apr 9 08:00:00 - 08:59:59 515 2.9% 0.142.5 MB 4.1% 0.70
Apr 9 09:00:00 - 09:59:59 674 3.8% 0.192.7 MB 4.5% 0.77
Apr 9 10:00:00 - 10:59:59 835 4.7% 0.232.2 MB 3.7% 0.63
Apr 9 11:00:00 - 11:59:59 812 4.6% 0.232.2 MB 3.6% 0.61
Apr 9 12:00:00 - 12:59:59 799 4.5% 0.222.4 MB 4.1% 0.70
Apr 9 13:00:00 - 13:59:59 779 4.4% 0.222.7 MB 4.5% 0.78
Apr 9 14:00:00 - 14:59:59 760 4.3% 0.212.1 MB 3.5% 0.60
Apr 9 15:00:00 - 15:59:59 835 4.7% 0.232.2 MB 3.6% 0.62
Apr 9 16:00:00 - 16:59:59 931 5.2% 0.263.4 MB 5.7% 0.98
Apr 9 17:00:00 - 17:59:59 855 4.8% 0.242.3 MB 3.8% 0.65
Apr 9 18:00:00 - 18:59:59 1041 5.9% 0.292.7 MB 4.5% 0.77
Apr 9 19:00:00 - 19:59:59 1034 5.8% 0.293.8 MB 6.4% 1.09
Apr 9 20:00:00 - 20:59:59 1174 6.6% 0.333.2 MB 5.3% 0.91
Apr 9 21:00:00 - 21:59:59 1164 6.5% 0.323.5 MB 5.9% 1.00
Apr 9 22:00:00 - 22:59:59 1034 5.8% 0.293.3 MB 5.5% 0.94
Apr 9 23:00:00 - 23:59:59 909 5.1% 0.252.7 MB 4.5% 0.78
Apr 10 00:00:00 - 00:00:03 6 0.0% 2.0016.0 KB 0.0% 5.33
TOTAL: 23:59:57 17786 100.0% 0.2160.3 MB 100.0% 0.71
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 16493 277 0 0 0 0 0 016216
2linuxd-out.news.weretis.net 1764 307 0 1 0 0 0 0 1456
3news.fcku.it 380 19 0 0 0 0 0 0 361
4nntp.pasdenom.info 10 1 0 0 0 1 0 0 8
TOTAL: 4 18647 604 0 1 0 1 0 018041

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 126
alt.survival 55
lada.talk 50
lada.auto 41
mozilla.support.thunderbird 28
mozilla.support.firefox 26
it.comp.os.win.windows10 23
mpc.lists.freebsd.ports.bugs 18
alt.2600 16
it-alt.sport.calcio.juventus 14
mozilla.test 14
mozilla.support.seamonkey 12
mpc.lists.freebsd.gnome 10
gmane.comp.bacula.user 9
it-alt.comp.software.mozilla 8
alt.net.dn42.users 8
alt.philosophy 7
gmane.linux.alsa.devel 6
mozilla.general 6
oesterreich.tratsch 5
TOTAL: 90 604

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 16307
EMP (phn path) 1204
Too many newsgroups 93
EMP (phn nph) 44
User-issued cancel 34
Binary Payload 24
Binary: non-binary distribution 5
Too many newsgroups (low_xpost) 3
EMP (phl) 2
User-issued spam cancel 2
Binary: misplaced par2 1
Binary: misplaced cmd 1
TOTAL: 12 17720

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 29028 3536 13074 1070 0 150 12%23:57:45
2news.fcku.it 19914 1628 12857 2287 0 18 8%23:59:42
3weretis.net 3058 146 2685 0 0 4 4%23:59:53
4eternal-september 19674 49 15338 3 0 2 0%23:59:53
5neva.ru 23257 17 15753 215 0 18 0%23:59:53
6etla.org 0 0 0 0 0 17786 0%23:59:53
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.killfile.org 2837 0 0 0 0 20622 0%23:59:52
9news.albasani.net 2859 0 0 0 0 20002 0%23:59:53
10news.stack.nl 2858 0 0 0 0 20586 0%23:59:53
11vc89.vc.panix.com 2839 0 0 0 0 20624 0%23:59:52
12news.netfront.net 2776 0 0 0 0 20529 0%23:59:52
TOTAL: 12 109100 5376 59707 3575 0 120341 4%264:06:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info11.4 MB2.1 MB13.6 MB0.2 KB/s3.0 KB23:57:45
2news.fcku.it4.5 MB6.8 MB11.3 MB0.1 KB/s2.9 KB23:59:42
3weretis.net246.1 KB0.0 KB246.1 KB0.0 KB/s1.7 KB23:59:53
4eternal-september161.1 KB9.4 KB170.5 KB0.0 KB/s3.3 KB23:59:53
5neva.ru136.2 KB733.2 KB869.3 KB0.0 KB/s3.7 KB23:59:53
6etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
9news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
11vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
12news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 1216.5 MB9.6 MB26.1 MB0.0 KB/s3.0 KB264:06:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
171.94.21.184 2 11.1 KB 1 0 000:00:28
2dslb-092-073-008-096.092.073.pools.vodafone-ip.de 79 12.1 KB 1 0 000:34:01
TOTAL: 2 81 23.2 KB 2 0 002:56:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.092.073.pools.vodafone-ip.de 79 12.1 KB 1 0 000:34:01
2unresolved 4 11.1 KB 1 0 000:00:47
3*.shodan.io 1 00.0 KB 0 0 000:00:01
4*.drr02.clwr.fl.frontiernet.net 4 00.0 KB 0 0 002:02:34
5*.094.217.pools.vodafone-ip.de 39 00.0 KB 0 0 000:19:21
6*.hsd1.ca.comcast.net 1 00.0 KB 0 0 000:00:10
TOTAL: 6 128 23.2 KB 2 0 002:56:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.220 0.012 0.00002:02:34
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 8.208 2.112 0.00000:34:01
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 4.200 0.996 0.00000:19:21
71.94.21.184 0.580 0.596 0.00000:00:28
125.64.94.200 0.048 0.008 0.00000:00:14
c-67-181-92-188.hsd1.ca.comcast.net 0.184 0.112 0.00000:00:10
196.52.20.233 0.056 0.004 0.00000:00:04
census12.shodan.io 0.056 0.000 0.00000:00:01
TOTAL: 8 13.552 3.840 0.00002:56:56

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 39
47-192-187-101.drr02.clwr.fl.frontiernet.net 4
c-67-181-92-188.hsd1.ca.comcast.net 1
census12.shodan.io 1
196.52.20.233 1
125.64.94.200 1
TOTAL: 6 47

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 1 50.0%
2alt 1 50.0%
TOTAL: 2 2100.0%

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

NewsgroupCount
1de.sci.informatik.ki 1
2alt.test 1
TOTAL: 2 2