Daily Usenet report

Nov 16 04:15:02 -- Nov 17 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Nov 16 04:33:07 newsfeed overchan[28209]: input line too long, skipping
Nov 16 05:11:45 newsfeed overchan[28209]: input line too long, skipping
Nov 16 13:39:52 newsfeed pgpverify[18356]: pgpverify: verification failed
Nov 16 14:40:05 newsfeed overchan[28209]: input line too long, skipping
Nov 16 15:56:59 newsfeed overchan[28209]: input line too long, skipping
Nov 16 16:58:34 newsfeed overchan[28209]: input line too long, skipping
Nov 16 17:34:58 newsfeed overchan[28209]: input line too long, skipping
Nov 16 17:41:36 newsfeed overchan[28209]: input line too long, skipping
Nov 16 17:48:43 newsfeed overchan[28209]: input line too long, skipping
Nov 16 19:28:10 newsfeed overchan[28209]: input line too long, skipping
Nov 16 19:51:50 newsfeed overchan[28209]: input line too long, skipping
Nov 16 20:16:13 newsfeed overchan[28209]: input line too long, skipping
Nov 16 21:06:27 newsfeed overchan[28209]: input line too long, skipping
Nov 16 21:26:49 newsfeed overchan[28209]: input line too long, skipping
Nov 16 21:54:42 newsfeed overchan[28209]: input line too long, skipping
Nov 16 23:49:47 newsfeed overchan[28209]: input line too long, skipping
Nov 17 00:21:10 newsfeed overchan[28209]: input line too long, skipping
Nov 17 01:03:08 newsfeed overchan[28209]: input line too long, skipping
Nov 17 01:33:49 newsfeed overchan[28209]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 813527 93.1%88.1 MB 92.3%
innfeed 46257 5.3%5.4 MB 5.7%
innd 9727 1.1%1.5 MB 1.6%
nnrpd 4207 0.5%421.7 KB 0.4%
overchan 19 0.0%3.5 KB 0.0%
controlchan 12 0.0%2.8 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 873750 100.0%95.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 809275 99.7%
Negative hits 2226 0.3%
Positive hits 290 0.0%
Cache misses 19 0.0%
TOTAL: 4 811810 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.348 0.0%66 0.000 20.424 127.000
article cleanup00:00:10.965 0.0%813056 0.008 0.013 0.021
article logging00:00:38.918 0.0%813606 0.032 0.048 0.078
article parse00:19:17.879 1.3%46182399 0.017 0.025 0.034
article write00:07:51.136 0.5%812778 0.188 0.580 1.313
artlog/artcncl00:00:00.002 0.0%66 0.000 0.030 1.000
data move00:00:47.014 0.1%50919348 0.001 0.001 0.001
hisgrep/artcncl00:00:00.115 0.0%64 0.000 1.797 20.000
hishave/artcncl00:00:00.126 0.0%66 0.000 1.909 27.750
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:33.437 2.1%815799 0.212 2.247 9.855
history sync00:00:00.023 0.0%290 0.000 0.079 1.000
history write00:52:43.887 3.7%813022 0.392 3.892 13.378
hiswrite/artcncl00:00:00.020 0.0%2 0.000 10.000 20.000
idle20:06:15.675 83.8%45805820 0.967 1.580 1.982
nntp read00:32:21.269 2.2%45863751 0.030 0.042 0.053
overview write00:00:04.421 0.0%812778 0.003 0.005 0.009
perl filter01:11:09.926 4.9%813022 2.902 5.252 7.764
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:43.980 0.1%1639403 0.019 0.027 0.033
TOTAL: 24:00:04.44923:42:40.141 98.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.158 0.0%50193 0.000 0.003 0.014
article prepare00:00:00.001 0.0%1912 0.000 0.001 0.025
article read00:00:08.830 0.0%478 0.000 18.473 128.333
backlog stats00:00:00.101 0.0%115644 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.133 0.0%56781 0.004 0.020 0.049
data write00:00:02.649 0.0%43059 0.022 0.062 0.110
idle23:52:48.716 99.9%115644 518.829 743.391 1395.311
status file00:01:09.030 0.1%16947 0.893 4.073 118.823
TOTAL: 23:54:18.45323:54:10.618100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.716 71.4%3056 0.000 10.051 9655.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.421 1.0%6827 0.000 0.062 5.421
readart00:00:00.003 0.0%62 0.000 0.048 0.500
TOTAL: 00:00:43.04000:00:31.140 72.4%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 128 812870 812610 0 260 99%75:55:40
2news.icm.edu.pl 46 269 40 211 18 14%16:57:57
3localhost 1441 0 0 0 0 0%00:00:00
TOTAL: 3 1615 813139 812650 211 278 99%92:53:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl269.9 GB1.9 MB2.5 MB269.9 GB 99%348.2 KB
2news.icm.edu.pl1.8 MB0.0 KB770.3 KB2.6 MB 70%45.7 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3269.9 GB1.9 MB3.2 MB269.9 GB 99%348.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 16 04:15:02 - 04:59:59 20971 2.6% 7.777.9 GB 2.9%3066.06
Nov 16 05:00:00 - 05:59:59 35021 4.3% 9.7311.8 GB 4.4%3446.96
Nov 16 06:00:00 - 06:59:59 35357 4.4% 9.8211.5 GB 4.2%3335.12
Nov 16 07:00:00 - 07:59:59 29204 3.6% 8.1110.5 GB 3.9%3046.25
Nov 16 08:00:00 - 08:59:59 37157 4.6% 10.3210.8 GB 4.0%3132.34
Nov 16 09:00:00 - 09:59:59 36259 4.5% 10.0710.1 GB 3.7%2953.52
Nov 16 10:00:00 - 10:59:59 37603 4.6% 10.4510.6 GB 3.9%3088.36
Nov 16 11:00:00 - 11:59:59 36429 4.5% 10.1211.2 GB 4.1%3269.77
Nov 16 12:00:00 - 12:59:59 36172 4.5% 10.0510.8 GB 4.0%3132.79
Nov 16 13:00:00 - 13:59:59 36574 4.5% 10.1611.0 GB 4.0%3192.17
Nov 16 14:00:00 - 14:59:59 33678 4.1% 9.3611.5 GB 4.2%3343.74
Nov 16 15:00:00 - 15:59:59 26867 3.3% 7.4610.7 GB 4.0%3124.05
Nov 16 16:00:00 - 16:59:59 34429 4.2% 9.5611.7 GB 4.3%3397.60
Nov 16 17:00:00 - 17:59:59 32403 4.0% 9.0011.3 GB 4.2%3303.30
Nov 16 18:00:00 - 18:59:59 31831 3.9% 8.8411.0 GB 4.1%3214.84
Nov 16 19:00:00 - 19:59:59 31369 3.9% 8.7111.2 GB 4.2%3276.32
Nov 16 20:00:00 - 20:59:59 30078 3.7% 8.3611.2 GB 4.2%3276.74
Nov 16 21:00:00 - 21:59:59 25906 3.2% 7.2011.3 GB 4.2%3293.27
Nov 16 22:00:00 - 22:59:59 46713 5.7% 12.9812.5 GB 4.6%3635.18
Nov 16 23:00:00 - 23:59:59 75126 9.2% 20.8713.9 GB 5.1%4051.61
Nov 17 00:00:00 - 00:59:59 23765 2.9% 6.6011.4 GB 4.2%3317.57
Nov 17 01:00:00 - 01:59:59 22970 2.8% 6.3810.6 GB 3.9%3099.79
Nov 17 02:00:00 - 02:59:59 24004 3.0% 6.6711.4 GB 4.2%3314.71
Nov 17 03:00:00 - 03:59:59 26387 3.2% 7.3312.0 GB 4.4%3488.85
Nov 17 04:00:00 - 04:15:02 6361 0.8% 7.052.8 GB 1.0%3268.33
TOTAL: 24:00:00 812634 100.0% 9.41270.7 GB 100.0%3285.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 809 218 0 34 7 0 0 0 550
2news.icm.edu.pl 18 0 0 0 0 0 0 0 18
TOTAL: 2 827 218 0 34 7 0 0 0 568

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 118
it.tlc.cellulari.android 34
it.comp.os.win.windows10 21
comp.mobile.android 21
it.comp.os.win.windows7 18
de.rec.sf.startrek 4
comp.sys.raspberry-pi 1
it.comp.os.win.windows8 1
TOTAL: 8 218

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

GroupsCount
pl.praca.oferowana 5
pl.sci.matematyka 2
TOTAL: 2 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14
Binary in non-binary group 2
Too many newsgroups 2
EMP (fsl) 1
TOTAL: 4 19

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 549
TOTAL: 1 549
TOTAL: 1 549

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 40389 115 12197 42 0 37996 0%23:59:35
2icm 20697 64 13615 2 0 0 0%24:08:31
3nask 0 0 0 0 0 8987 0%23:50:02
4okapi 0 0 0 0 0 853 0%23:50:04
5poznan 36 0 26 0 0 0 0%02:50:37
TOTAL: 5 61122 179 25838 44 0 47836 0%98:38:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama432.9 KB234.6 KB667.5 KB0.0 KB/s4.3 KB23:59:35
2icm222.1 KB5.1 KB227.2 KB0.0 KB/s3.4 KB24:08:31
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:04
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:50:37
TOTAL: 5655.1 KB239.7 KB894.7 KB0.0 KB/s4.0 KB98:38:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6258.5 KB 30 0 000:00:24
TOTAL: 1 288 6258.5 KB 30 0 000:00:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 576 6258.5 KB 30 0 000:00:28
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3unresolved 101 00.0 KB 0 0 000:00:14
TOTAL: 3 678 6258.5 KB 30 0 000:00:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.810 3.883 0.00000:00:24
192.241.211.186 0.003 0.017 0.00000:00:09
mon.man.lodz.pl 1.437 2.854 0.00000:00:03
80.111.142.213 0.020 0.053 0.00000:00:03
212.51.192.185 0.514 0.895 0.00000:00:01
scan-141.security.ipip.net 0.000 0.018 0.00000:00:00
TOTAL: 6 3.784 7.720 0.00000:00:42

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
192.241.211.186 1
scan-141.security.ipip.net 1
TOTAL: 5 390

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
Connection: close 1
TOTAL: 4 4

Newsgroup request counts (by category):

CategoryCountPct
1pl 62100.0%
TOTAL: 1 62100.0%

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

NewsgroupCount
1pl.comp.pecet 32
2pl.comp.os.ms-windows.winnt 30
TOTAL: 2 62