Daily Usenet report

Sep 12 04:15:02 -- Sep 13 04:15:01

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Sep 12 07:11:41 newsfeed overchan[24971]: input line too long, skipping
Sep 12 08:27:24 newsfeed overchan[24971]: input line too long, skipping
Sep 12 09:34:24 newsfeed overchan[24971]: input line too long, skipping
Sep 12 14:01:29 newsfeed overchan[24971]: input line too long, skipping
Sep 12 14:25:15 newsfeed overchan[24971]: input line too long, skipping
Sep 12 16:18:38 newsfeed overchan[24971]: input line too long, skipping
Sep 12 16:34:36 newsfeed overchan[24971]: input line too long, skipping
Sep 12 17:17:14 newsfeed overchan[24971]: input line too long, skipping
Sep 12 17:32:21 newsfeed overchan[24971]: input line too long, skipping
Sep 12 17:43:44 newsfeed overchan[24971]: input line too long, skipping
Sep 12 18:16:36 newsfeed overchan[24971]: input line too long, skipping
Sep 12 18:28:27 newsfeed overchan[24971]: input line too long, skipping
Sep 12 20:18:33 newsfeed overchan[24971]: input line too long, skipping
Sep 12 20:41:32 newsfeed overchan[24971]: input line too long, skipping
Sep 12 20:43:31 newsfeed overchan[24971]: input line too long, skipping
Sep 12 22:13:06 newsfeed overchan[24971]: input line too long, skipping
Sep 13 00:19:55 newsfeed overchan[24971]: input line too long, skipping
Sep 13 03:09:16 newsfeed overchan[24971]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 550771 93.1%60.2 MB 92.3%
innfeed 28235 4.8%3.3 MB 5.1%
innd 8558 1.4%1.3 MB 2.0%
nnrpd 4274 0.7%417.8 KB 0.6%
overchan 19 0.0%3.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 591858 100.0%65.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 546654 99.6%
Negative hits 2059 0.4%
Positive hits 222 0.0%
Cache misses 27 0.0%
TOTAL: 4 548962 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.222 0.0%59 0.000 20.712 280.000
article cleanup00:00:08.092 0.0%550210 0.010 0.015 0.021
article logging00:00:28.404 0.0%550694 0.041 0.052 0.074
article parse00:15:32.521 1.1%25781417 0.023 0.036 0.042
article write00:07:02.052 0.5%549863 0.641 0.768 1.105
artlog/artcncl00:00:00.002 0.0%59 0.000 0.034 0.500
data move00:00:26.592 0.0%29751420 0.001 0.001 0.001
hisgrep/artcncl00:00:00.491 0.0%58 0.000 8.466 248.000
hishave/artcncl00:00:00.114 0.0%59 0.000 1.932 13.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:32:15.104 2.2%552716 0.475 3.501 16.016
history sync00:00:00.031 0.0%290 0.000 0.107 1.000
history write00:16:18.877 1.1%550181 0.560 1.779 8.526
hiswrite/artcncl00:00:00.002 0.0%1 2.000 2.000 2.000
idle21:15:47.854 88.6%25640488 1.633 2.985 5.562
nntp read00:21:15.474 1.5%25546592 0.042 0.050 0.057
overview write00:00:03.262 0.0%549863 0.003 0.006 0.010
perl filter00:59:42.186 4.1%550181 5.488 6.511 7.962
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:31.759 0.0%1112070 0.024 0.029 0.034
TOTAL: 24:00:07.10323:49:34.039 99.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.122 0.0%47317 0.000 0.003 0.015
article prepare00:00:00.000 0.0%5108 0.000 0.000 0.000
article read00:00:09.945 0.0%1276 0.000 7.794 99.167
backlog stats00:00:00.092 0.0%104414 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.005 0.0%51611 0.000 0.019 0.048
data write00:00:02.270 0.0%39385 0.014 0.058 0.138
idle23:54:19.748 99.9%104414 37.004 824.217 1881.834
status file00:00:48.080 0.1%9211 0.800 5.220 135.908
TOTAL: 23:55:25.72823:55:21.262100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:14.485 99.2%3097 0.000 605.258900046.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.286 0.0%6874 0.000 0.042 1.053
readart00:00:00.002 0.0%36 0.000 0.056 0.500
TOTAL: 00:31:29.09300:31:14.773 99.2%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 154 550044 549761 0 283 99%87:17:42
2news.icm.edu.pl 45 267 41 162 64 15%14:05:47
3localhost 1440 0 0 0 0 0%00:00:00
TOTAL: 3 1639 550311 549802 162 347 99%101:23:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl243.2 GB1.4 MB2.1 MB243.2 GB 99%463.6 KB
2news.icm.edu.pl1.5 MB21.9 KB4.5 MB6.0 MB 24%58.7 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3243.2 GB1.5 MB6.6 MB243.2 GB 99%463.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 12 04:15:02 - 04:59:59 17225 3.1% 6.388.3 GB 3.4%3213.28
Sep 12 05:00:00 - 05:59:59 23404 4.3% 6.5011.1 GB 4.6%3240.93
Sep 12 06:00:00 - 06:59:59 20675 3.8% 5.749.5 GB 3.9%2764.86
Sep 12 07:00:00 - 07:59:59 21140 3.8% 5.8710.3 GB 4.2%2986.52
Sep 12 08:00:00 - 08:59:59 22434 4.1% 6.2310.4 GB 4.3%3037.65
Sep 12 09:00:00 - 09:59:59 21575 3.9% 5.9910.0 GB 4.1%2924.31
Sep 12 10:00:00 - 10:59:59 20408 3.7% 5.6710.3 GB 4.2%3013.92
Sep 12 11:00:00 - 11:59:59 20776 3.8% 5.7710.3 GB 4.2%2997.49
Sep 12 12:00:00 - 12:59:59 21069 3.8% 5.859.7 GB 4.0%2818.58
Sep 12 13:00:00 - 13:59:59 25920 4.7% 7.2010.7 GB 4.4%3118.13
Sep 12 14:00:00 - 14:59:59 25621 4.7% 7.1211.2 GB 4.6%3262.89
Sep 12 15:00:00 - 15:59:59 22829 4.2% 6.349.8 GB 4.0%2856.93
Sep 12 16:00:00 - 16:59:59 26507 4.8% 7.3610.7 GB 4.4%3115.53
Sep 12 17:00:00 - 17:59:59 25627 4.7% 7.1210.5 GB 4.3%3068.99
Sep 12 18:00:00 - 18:59:59 24865 4.5% 6.9110.1 GB 4.1%2943.69
Sep 12 19:00:00 - 19:59:59 24759 4.5% 6.8810.0 GB 4.1%2926.46
Sep 12 20:00:00 - 20:59:59 23704 4.3% 6.5810.1 GB 4.1%2941.25
Sep 12 21:00:00 - 21:59:59 24700 4.5% 6.8610.9 GB 4.5%3164.34
Sep 12 22:00:00 - 22:59:59 21971 4.0% 6.109.3 GB 3.8%2697.17
Sep 12 23:00:00 - 23:59:59 19799 3.6% 5.509.5 GB 3.9%2774.34
Sep 13 00:00:00 - 00:59:59 22515 4.1% 6.259.7 GB 4.0%2825.32
Sep 13 01:00:00 - 01:59:59 21831 4.0% 6.069.8 GB 4.0%2853.17
Sep 13 02:00:00 - 02:59:59 22601 4.1% 6.289.8 GB 4.0%2852.91
Sep 13 03:00:00 - 03:59:59 22482 4.1% 6.259.2 GB 3.8%2690.82
Sep 13 04:00:00 - 04:15:01 5444 1.0% 6.042.5 GB 1.0%2880.73
TOTAL: 23:59:59 549881 100.0% 6.36243.8 GB 100.0%2958.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 767 237 0 27 19 0 0 0 484
2news.icm.edu.pl 64 0 0 2 0 0 0 0 62
TOTAL: 2 831 237 0 29 19 0 0 0 546

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 159
comp.sys.raspberry-pi 40
comp.mobile.android 11
it.tlc.cellulari.android 9
it.comp.os.win.windows10 9
de.comp.office-pakete.ms-office.excel 7
de.rec.sf.startrek 2
TOTAL: 7 237

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

GroupsCount
pl.sci.matematyka 11
pl.praca.oferowana 8
TOTAL: 2 19

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 59
Scoring filter (11) 1
Binary in non-binary group 1
Too many newsgroups 1
TOTAL: 4 62

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18712 258 11943 10 0 0 1%23:59:50
2panorama 35390 69 19358 848 0 27232 0%23:59:55
3okapi 0 0 0 0 0 661 0%23:57:48
4nask 0 0 0 0 0 9086 0%23:57:48
5poznan 42 0 34 0 0 0 0%03:28:18
TOTAL: 5 54144 327 31335 858 0 36979 0%99:23:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm998.6 KB25.7 KB1.0 MB0.0 KB/s3.8 KB23:59:50
2panorama184.7 KB3.6 MB3.8 MB0.0 KB/s4.3 KB23:59:55
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:28:18
TOTAL: 51.2 MB3.7 MB4.8 MB0.0 KB/s4.2 KB99:23:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 3634.9 KB 18 0 000:00:23
TOTAL: 1 287 3634.9 KB 18 0 000:31:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 575 3634.9 KB 18 0 000:00:28
2*.bb.netbynet.ru 6 00.0 KB 0 0 000:00:53
3unresolved 105 00.0 KB 0 0 000:30:06
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 687 3634.9 KB 18 0 000:31:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
202.107.226.5 0.003 0.005 0.00000:30:00
ip-79-111-222-6.bb.netbynet.ru 0.053 0.065 0.00000:00:53
web.man.lodz.pl 1.637 3.267 0.00000:00:23
mon.man.lodz.pl 1.406 2.748 0.00000:00:04
80.111.142.213 0.033 0.032 0.00000:00:03
185.100.87.246 0.006 0.020 0.00000:00:01
212.51.192.185 0.504 0.838 0.00000:00:01
scan-141.security.ipip.net 0.008 0.012 0.00000:00:00
185.216.140.192 0.007 0.010 0.00000:00:00
195.54.161.216 0.004 0.014 0.00000:00:00
TOTAL: 10 3.661 7.011 0.00000:31:28

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
ip-79-111-222-6.bb.netbynet.ru 6
80.111.142.213 4
185.100.87.246 2
scan-141.security.ipip.net 1
195.54.161.216 1
185.216.140.192 1
202.107.226.5 1
TOTAL: 9 400

NNRP unrecognized commands (by host):

SystemConn
185.216.140.192 6
scan-141.security.ipip.net 4
195.54.161.216 1
202.107.226.5 1
TOTAL: 4 12

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 2
Connection: keep-alive 1
#003 1
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
User-Agent: python-requests/2.18.4 1
Accept-Encoding: gzip, deflate 1
GET /phpMyAdmin-3.0.0.0-all-languages/sc... 1
Accept: */* 1
GET / HTTP/1.0 1
TOTAL: 11 12

NNRP client timeouts [Top 20]:

SystemConnPeer
202.107.226.5 1 0
195.54.161.216 1 1
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 28
2pl.comp.pecet 8
TOTAL: 2 36