Daily Usenet report

Jul 15 04:15:02 -- Jul 16 04:15:01

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Jul 15 09:21:24 newsfeed nnrpd[973394]: SERVER perl filter not defined
Jul 15 11:50:35 newsfeed overchan[959243]: input line too long, skipping
Jul 15 11:58:21 newsfeed overchan[959243]: input line too long, skipping
Jul 15 13:14:22 newsfeed overchan[959243]: input line too long, skipping
Jul 15 15:28:56 newsfeed overchan[959243]: input line too long, skipping
Jul 15 15:31:07 newsfeed overchan[959243]: input line too long, skipping
Jul 15 15:33:07 newsfeed overchan[959243]: input line too long, skipping
Jul 15 15:38:00 newsfeed overchan[959243]: input line too long, skipping
Jul 15 16:00:53 newsfeed overchan[959243]: input line too long, skipping
Jul 15 16:06:27 newsfeed overchan[959243]: input line too long, skipping
Jul 15 16:08:06 newsfeed overchan[959243]: input line too long, skipping
Jul 15 17:00:04 newsfeed pgpverify[993839]: pgpverify: /usr/bin/gpg1: no such file
Jul 15 17:00:05 newsfeed pgpverify[993852]: pgpverify: /usr/bin/gpg1: no such file
Jul 15 19:35:56 newsfeed overchan[959243]: input line too long, skipping
Jul 15 21:20:25 newsfeed nnrpd[1005390]: SERVER perl filter not defined
Jul 15 21:26:16 newsfeed overchan[959243]: input line too long, skipping
Jul 15 21:34:22 newsfeed overchan[959243]: input line too long, skipping
Jul 15 21:46:29 newsfeed overchan[959243]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 99233 90.0%11.2 MB 91.1%
nnrpd 7677 7.0%743.9 KB 5.9%
innd 1998 1.8%230.7 KB 1.8%
innfeed 1269 1.2%136.7 KB 1.1%
controlchan 23 0.0%4.9 KB 0.0%
overchan 15 0.0%1.8 KB 0.0%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 7 110217 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 98642 98.7%
Negative hits 1022 1.0%
Positive hits 223 0.2%
Cache misses 22 0.0%
TOTAL: 4 99909 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.766 0.0%41 0.000 18.683 72.000
article cleanup00:00:00.403 0.0%98822 0.000 0.004 0.033
article logging00:00:01.572 0.0%99182 0.000 0.016 0.042
article parse00:00:01.800 0.0%592263 0.001 0.003 0.006
article write00:00:14.327 0.0%98735 0.039 0.145 3.025
artlog/artcncl00:00:00.001 0.0%41 0.000 0.024 0.200
data move00:00:00.438 0.0%790597 0.000 0.001 0.002
hisgrep/artcncl00:00:00.187 0.0%39 0.000 4.795 24.000
hishave/artcncl00:00:00.200 0.0%41 0.000 4.878 20.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:03.008 0.8%100048 3.630 7.227 50.333
history sync00:00:00.021 0.0%386 0.000 0.054 0.500
history write00:08:48.913 0.6%98819 2.999 5.352 27.119
hiswrite/artcncl00:00:00.013 0.0%2 6.500 6.500 6.500
idle23:37:54.335 98.4%663434 24.192 128.233 421.826
nntp read00:00:05.014 0.0%581185 0.005 0.009 0.015
overview write00:00:00.190 0.0%98735 0.000 0.002 0.007
perl filter00:01:19.591 0.1%98819 0.458 0.805 1.320
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.040 0.0%207588 0.003 0.010 0.018
TOTAL: 24:01:04.60324:00:32.819100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%10121 0.000 0.002 0.038
article prepare00:00:00.000 0.0%84 0.000 0.000 0.000
article read00:00:00.000 0.0%21 0.000 0.000 0.000
backlog stats00:00:00.023 0.0%44948 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.165 0.0%23501 0.000 0.007 0.031
data write00:00:00.358 0.0%13558 0.000 0.026 0.082
idle23:59:55.905100.0%44948 1070.730 1922.130 5134.504
status file00:00:00.169 0.0%326 0.000 0.518 4.000
TOTAL: 23:59:57.28023:59:56.639100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:04.848 88.3%4197 0.000 29.747 34666.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.132 0.1%10184 0.000 0.013 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:02:21.33300:02:04.980 88.4%----

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
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 65 98938 98861 2 75 99%39:32:39
2news.icm.edu.pl 54 220 6 201 13 2%15:06:37
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 122 99160 98869 203 88 99%54:39:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.3 GB63.6 KB260.9 KB1.3 GB 99%13.7 KB
2news.icm.edu.pl380.4 KB0.0 KB239.4 KB619.9 KB 61%32.6 KB
3localhost2.8 KB0.0 KB0.0 KB2.8 KB100%1.4 KB
TOTAL: 31.3 GB63.6 KB500.4 KB1.3 GB 99%13.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 15 04:15:02 - 04:59:59 1463 1.5% 0.5419.6 MB 1.5% 7.42
Jul 15 05:00:00 - 05:59:59 1676 1.7% 0.4720.3 MB 1.5% 5.77
Jul 15 06:00:00 - 06:59:59 1514 1.5% 0.4222.3 MB 1.7% 6.33
Jul 15 07:00:00 - 07:59:59 2069 2.1% 0.5726.4 MB 2.0% 7.52
Jul 15 08:00:00 - 08:59:59 2503 2.5% 0.7034.9 MB 2.6% 9.92
Jul 15 09:00:00 - 09:59:59 4186 4.2% 1.1679.4 MB 6.0% 22.58
Jul 15 10:00:00 - 10:59:59 3600 3.6% 1.0052.2 MB 3.9% 14.84
Jul 15 11:00:00 - 11:59:59 3311 3.4% 0.9241.7 MB 3.2% 11.86
Jul 15 12:00:00 - 12:59:59 3715 3.8% 1.0345.1 MB 3.4% 12.82
Jul 15 13:00:00 - 13:59:59 4237 4.3% 1.18106.5 MB 8.1% 30.29
Jul 15 14:00:00 - 14:59:59 4036 4.1% 1.1260.1 MB 4.5% 17.10
Jul 15 15:00:00 - 15:59:59 4070 4.1% 1.1355.2 MB 4.2% 15.71
Jul 15 16:00:00 - 16:59:59 5963 6.0% 1.6668.7 MB 5.2% 19.54
Jul 15 17:00:00 - 17:59:59 3430 3.5% 0.9547.3 MB 3.6% 13.45
Jul 15 18:00:00 - 18:59:59 4439 4.5% 1.2361.6 MB 4.7% 17.52
Jul 15 19:00:00 - 19:59:59 4105 4.2% 1.1464.9 MB 4.9% 18.45
Jul 15 20:00:00 - 20:59:59 11310 11.5% 3.1488.6 MB 6.7% 25.20
Jul 15 21:00:00 - 21:59:59 3520 3.6% 0.9853.1 MB 4.0% 15.11
Jul 15 22:00:00 - 22:59:59 5838 5.9% 1.6276.3 MB 5.8% 21.70
Jul 15 23:00:00 - 23:59:59 6550 6.6% 1.8277.7 MB 5.9% 22.11
Jul 16 00:00:00 - 00:59:59 4484 4.5% 1.2547.8 MB 3.6% 13.61
Jul 16 01:00:00 - 01:59:59 4694 4.8% 1.3074.4 MB 5.6% 21.16
Jul 16 02:00:00 - 02:59:59 4749 4.8% 1.3256.4 MB 4.3% 16.05
Jul 16 03:00:00 - 03:59:59 2746 2.8% 0.7635.1 MB 2.7% 9.99
Jul 16 04:00:00 - 04:15:01 539 0.5% 0.606.1 MB 0.5% 6.95
TOTAL: 23:59:59 98747 100.0% 1.141.3 GB 100.0% 15.66
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 432 70 0 3 0 0 0 0 359
2news.icm.edu.pl 13 0 0 0 0 0 0 0 13
TOTAL: 2 445 70 0 3 0 0 0 0 372

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.comp.os.win.windows10 17
comp.mobile.android 17
alt.comp.software.firefox 15
de.comp.lang.php 9
uk.railway 9
de.comm.provider.telefonie 2
de.rec.sf.startrek 1
TOTAL: 7 70

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 12
Scoring filter (9) 1
TOTAL: 2 13

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 13470 21 10003 1 0 0 0%24:02:46
2nask 0 0 0 0 0 7211 0%23:57:49
3poznan 8 0 6 0 0 0 0%01:09:02
4panorama 0 0 0 0 0 10125 0%23:57:49
5okapi 0 0 0 0 0 1061 0%23:57:49
TOTAL: 5 13478 21 10009 1 0 18397 0%97:05:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm174.3 KB2.0 KB176.3 KB0.0 KB/s8.0 KB24:02:46
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:09:02
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
TOTAL: 5174.3 KB2.0 KB176.3 KB0.0 KB/s8.0 KB97:05:15
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 45.6 KB 2 0 000:00:08
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 292 45.6 KB 2 2 000:02:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1732 45.6 KB 2 2 000:00:21
2*.ostrowiec-sw.vectranet.pl 1 00.0 KB 0 0 000:01:44
3*.internet-census.org 1 00.0 KB 0 0 000:00:10
4unresolved 106 00.0 KB 0 0 000:00:05
5*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 51841 45.6 KB 2 2 000:02:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
078088237165.ostrowiec-sw.vectranet.pl 0.014 0.014 0.00000:01:44
nms2.man.lodz.pl 2.341 20.198 0.00000:00:12
sh-ams-nl-gp1-wk116.internet-census.org 0.004 0.012 0.00000:00:10
web.man.lodz.pl 0.468 4.276 0.00000:00:08
80.111.142.213 0.008 0.057 0.00000:00:02
120.210.0.35 0.001 0.015 0.00000:00:01
212.51.192.185 0.148 1.343 0.00000:00:00
71.6.134.231 0.004 0.048 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.007 0.010 0.00000:00:00
192.241.217.13 0.006 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.007 0.032 0.00000:00:00
45.227.254.55 0.000 0.016 0.00000:00:00
TOTAL: 12 3.008 26.031 0.00000:02:21

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
71.6.134.231 3
sh-ams-nl-gp1-wk116.internet-census.org 1
scanner-07.ch1.censys-scanner.com 1
45.227.254.55 1
120.210.0.35 1
192.241.217.13 1
078088237165.ostrowiec-sw.vectranet.pl 1
TOTAL: 10 1549

NNRP unrecognized commands (by host):

SystemConn
71.6.134.231 8
45.227.254.55 1
scanner-07.ch1.censys-scanner.com 1
192.241.217.13 1
TOTAL: 4 11

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
#023#003#023#001#023#002#001 1
#026#003#001 1
#024¤j3T2#0279^ü#017#011þ š#037«#017a#001ÍåjŠ½ÑÛk#014TL±rò‹q#027#014Œ©... 1
#003 1
EHLO www.censys.io 1
MGLNDD_212.191.2.21_119 1
GET / HTTP/1.1 1
Accept-Encoding: gzip 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept: */* 1
TOTAL: 11 11

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.55 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.comp.pecet 4
TOTAL: 1 4