Daily Usenet report

Sep 30 04:15:01 -- Oct 1 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Sep 30 12:38:09 newsfeed overchan[634727]: input line too long, skipping
Sep 30 12:39:21 newsfeed overchan[634727]: input line too long, skipping
Sep 30 16:08:21 newsfeed overchan[634727]: input line too long, skipping
Sep 30 16:11:50 newsfeed overchan[634727]: input line too long, skipping
Sep 30 16:33:12 newsfeed overchan[634727]: input line too long, skipping
Sep 30 16:35:49 newsfeed overchan[634727]: input line too long, skipping
Sep 30 19:32:30 newsfeed overchan[634727]: input line too long, skipping
Oct 1 00:44:20 newsfeed overchan[634727]: input line too long, skipping
Oct 1 02:04:02 newsfeed pgpverify[692948]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 163139 93.6%18.8 MB 94.2%
nnrpd 7672 4.4%770.8 KB 3.8%
innd 2222 1.3%261.4 KB 1.3%
innfeed 1312 0.8%149.1 KB 0.7%
controlchan 22 0.0%5.3 KB 0.0%
overchan 9 0.0%1.0 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 174377 100.0%20.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 162441 96.8%
Negative hits 4495 2.7%
Positive hits 826 0.5%
Cache misses 19 0.0%
TOTAL: 4 167781 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.527 0.0%55 0.000 9.582 54.000
article cleanup00:00:01.101 0.0%163227 0.000 0.007 0.015
article logging00:00:03.752 0.0%163240 0.013 0.023 0.041
article parse00:00:07.237 0.0%956357 0.004 0.008 0.012
article write00:00:25.370 0.0%162747 0.054 0.156 1.369
artlog/artcncl00:00:00.001 0.0%55 0.000 0.018 0.100
data move00:00:01.065 0.0%1200894 0.000 0.001 0.003
hisgrep/artcncl00:00:00.232 0.0%54 0.000 4.296 23.000
hishave/artcncl00:00:00.076 0.0%55 0.000 1.382 14.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:14:57.216 1.0%168589 1.678 5.322 10.733
history sync00:00:00.018 0.0%312 0.000 0.058 0.500
history write00:20:19.611 1.4%163213 3.985 7.473 12.023
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:20:14.363 97.2%1059243 15.682 79.315 226.305
nntp read00:00:15.110 0.0%934480 0.011 0.016 0.025
overview write00:00:00.577 0.0%162747 0.000 0.004 0.011
perl filter00:03:16.984 0.2%163213 0.709 1.207 1.831
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:05.348 0.0%337908 0.009 0.016 0.024
TOTAL: 24:00:24.28223:59:48.588100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%12434 0.000 0.002 0.029
article prepare00:00:00.000 0.0%368 0.000 0.000 0.000
article read00:00:00.003 0.0%92 0.000 0.033 1.000
backlog stats00:00:00.024 0.0%50952 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.255 0.0%27515 0.000 0.009 0.033
data write00:00:00.677 0.0%15257 0.000 0.044 0.119
idle23:58:55.691100.0%50952 925.903 1694.451 5084.839
status file00:00:00.178 0.0%340 0.000 0.524 1.000
TOTAL: 23:58:57.72123:58:56.853100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:07:51.872 92.2%4196 0.000 112.458 24190.125
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.729 2.1%10157 0.000 1.056 270.759
TOTAL: 00:08:31.55200:08:02.601 94.3%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 77 162385 162274 0 111 99%48:53:58
2news.icm.edu.pl 14 1735 31 1257 447 1%27:51:40
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 92 164120 162305 1257 558 98%76:45:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.2 GB195.8 KB462.8 KB2.2 GB 99%14.4 KB
2news.icm.edu.pl734.0 KB59.5 KB7.3 MB8.1 MB 8%17.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 32.2 GB255.3 KB7.8 MB2.2 GB 99%14.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 04:15:01 - 04:59:59 3677 2.3% 1.3656.5 MB 2.5% 21.45
Sep 30 05:00:00 - 05:59:59 4752 2.9% 1.3270.9 MB 3.1% 20.17
Sep 30 06:00:00 - 06:59:59 4000 2.5% 1.1157.3 MB 2.5% 16.29
Sep 30 07:00:00 - 07:59:59 6973 4.3% 1.94142.3 MB 6.2% 40.47
Sep 30 08:00:00 - 08:59:59 5668 3.5% 1.5778.1 MB 3.4% 22.22
Sep 30 09:00:00 - 09:59:59 6040 3.7% 1.6888.8 MB 3.9% 25.26
Sep 30 10:00:00 - 10:59:59 6018 3.7% 1.6767.3 MB 2.9% 19.14
Sep 30 11:00:00 - 11:59:59 5766 3.5% 1.6078.2 MB 3.4% 22.23
Sep 30 12:00:00 - 12:59:59 5605 3.4% 1.5684.1 MB 3.6% 23.92
Sep 30 13:00:00 - 13:59:59 7128 4.4% 1.98174.2 MB 7.6% 49.55
Sep 30 14:00:00 - 14:59:59 5927 3.6% 1.6582.2 MB 3.6% 23.39
Sep 30 15:00:00 - 15:59:59 4594 2.8% 1.2870.0 MB 3.0% 19.90
Sep 30 16:00:00 - 16:59:59 4817 3.0% 1.3469.8 MB 3.0% 19.85
Sep 30 17:00:00 - 17:59:59 5682 3.5% 1.5871.6 MB 3.1% 20.37
Sep 30 18:00:00 - 18:59:59 7588 4.7% 2.1187.2 MB 3.8% 24.81
Sep 30 19:00:00 - 19:59:59 6563 4.0% 1.8295.1 MB 4.1% 27.05
Sep 30 20:00:00 - 20:59:59 7825 4.8% 2.17130.8 MB 5.7% 37.19
Sep 30 21:00:00 - 21:59:59 8799 5.4% 2.44114.2 MB 5.0% 32.49
Sep 30 22:00:00 - 22:59:59 7208 4.4% 2.00106.1 MB 4.6% 30.17
Sep 30 23:00:00 - 23:59:59 7013 4.3% 1.95115.1 MB 5.0% 32.75
Oct 1 00:00:00 - 00:59:59 5453 3.4% 1.51110.1 MB 4.8% 31.31
Oct 1 01:00:00 - 01:59:59 5958 3.7% 1.66103.9 MB 4.5% 29.55
Oct 1 02:00:00 - 02:59:59 21749 13.4% 6.04132.8 MB 5.8% 37.79
Oct 1 03:00:00 - 03:59:59 6853 4.2% 1.9099.8 MB 4.3% 28.40
Oct 1 04:00:00 - 04:15:02 936 0.6% 1.0417.8 MB 0.8% 20.21
TOTAL: 24:00:01 162592 100.0% 1.882.3 GB 100.0% 27.31
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 367 0 0 3 0 0 0 0 364
2newsfeed.pionier.net.pl 125 100 0 11 0 0 0 0 14
TOTAL: 2 492 100 0 14 0 0 0 0 378

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 44
comp.mobile.android 27
comp.sys.raspberry-pi 15
it.tlc.cellulari.android 3
it.comp.os.win.windows10 2
nl.comp.sys.android 1
nl.wetenschap.regulier 1
nl.gezondheid.alternatief-genezen 1
nl.actueel 1
nl.comp.os.linux.techniek 1
comp.mobile.ipad 1
de.rec.sf.startrek 1
nl.comp.3d-printen 1
de.comm.software.mailreader 1
TOTAL: 14 100

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 353
Scoring filter (8) 8
EMP (md5) 1
Scoring filter (11) 1
Scoring filter (9) 1
TOTAL: 5 364

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15119 73 11375 19 0 0 0%23:59:58
2panorama 0 0 0 0 0 12441 0%23:57:49
3okapi 0 0 0 0 0 508 0%23:57:49
4poznan 19 0 15 0 0 0 0%01:59:40
5nask 0 0 0 0 0 7959 0%23:57:49
TOTAL: 5 15138 73 11390 19 0 20908 0%97:53:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm292.6 KB53.2 KB345.8 KB0.0 KB/s3.8 KB23:59:58
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:59:40
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 5292.6 KB53.2 KB345.8 KB0.0 KB/s3.8 KB97:53:05
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1176.105.139.10 4 00.0 KB 0 0 000:06:59
2162.243.142.48 1 00.0 KB 0 0 000:00:00
3207.90.244.5 1 00.0 KB 0 0 000:00:03
4194.165.16.10 1 00.0 KB 0 0 000:00:10
5212.51.192.185 96 00.0 KB 0 0 000:00:01
6web.man.lodz.pl 288 00.0 KB 0 0 000:00:08
7nifty.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
871.6.134.235 3 00.0 KB 0 0 000:00:01
9nms2.man.lodz.pl1440 00.0 KB 0 0 000:00:14
1080.111.142.213 4 00.0 KB 0 0 000:00:02
11staticline-31-182-132-148.toya.net.pl 1 00.0 KB 0 0 000:00:48
TOTAL: 111840 00.0 KB 0 0 000:08:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.toya.net.pl 1 00.0 KB 0 0 000:00:48
2*.man.lodz.pl1728 00.0 KB 0 0 000:00:23
3unresolved 110 00.0 KB 0 0 000:07:17
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 41840 00.0 KB 0 0 000:08:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
176.105.139.10 0.047 0.032 0.00000:06:59
staticline-31-182-132-148.toya.net.pl 0.012 0.000 0.00000:00:48
nms2.man.lodz.pl 5.086 7.819 0.00000:00:14
194.165.16.10 0.007 0.007 0.00000:00:10
web.man.lodz.pl 1.024 1.560 0.00000:00:08
207.90.244.5 0.006 0.000 0.00000:00:03
80.111.142.213 0.021 0.031 0.00000:00:02
nifty.monitoring.internet-measurement.com 0.009 0.003 0.00000:00:02
212.51.192.185 0.332 0.567 0.00000:00:01
71.6.134.235 0.009 0.022 0.00000:00:01
162.243.142.48 0.000 0.008 0.00000:00:00
TOTAL: 11 6.553 10.049 0.00000:08:31

NNRP unrecognized commands (by host):

SystemConn
71.6.134.235 7
194.165.16.10 1
162.243.142.48 1
TOTAL: 3 9

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
#003 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
MGLNDD_212.191.2.21_119 1
#026#003#001 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
#023#003#023#001#023#002#001 1
Accept: */* 1
TOTAL: 9 9

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.10 1 1
TOTAL: 1 1 1