Daily Usenet report

Oct 15 04:15:02 -- Oct 16 04:15:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 15 09:43:44 newsfeed nnrpd[12257]: SERVER perl filter not defined
Oct 15 09:59:44 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:275 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 15097856 duplicate size 0 rejected size 0]
Oct 15 14:43:03 newsfeed overchan[350]: input line too long, skipping
Oct 15 15:57:05 newsfeed nnrpd[24662]: SERVER perl filter not defined
Oct 15 17:00:04 newsfeed pgpverify[26842]: pgpverify: verification failed
Oct 15 18:32:00 newsfeed overchan[350]: input line too long, skipping
Oct 15 18:42:41 newsfeed overchan[350]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2218471 97.2%248.4 MB 96.8%
innfeed 46912 2.1%5.5 MB 2.1%
innd 13107 0.6%2.3 MB 0.9%
nnrpd 4934 0.2%530.7 KB 0.2%
controlchan 4 0.0%0.5 KB 0.0%
overchan 4 0.0%0.6 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72283433 100.0%256.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2188248 99.7%
Negative hits 6417 0.3%
Positive hits 241 0.0%
Cache misses 79 0.0%
TOTAL: 4 2194985 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.785 0.0%155 0.000 17.968 344.000
article cleanup00:00:25.952 0.0%2256228 0.005 0.012 0.021
article logging00:01:21.106 0.1%2256642 0.029 0.036 0.062
article parse00:17:35.384 1.2%48693523 0.014 0.022 0.033
article write00:08:34.810 0.6%2255945 0.133 0.228 0.739
artlog/artcncl00:00:00.005 0.0%149 0.000 0.034 0.500
data move00:00:51.903 0.1%57866842 0.001 0.001 0.004
hisgrep/artcncl00:00:00.723 0.0%142 0.000 5.092 76.500
hishave/artcncl00:00:00.012 0.0%155 0.000 0.077 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:28.546 0.3%2263667 0.012 0.119 0.645
history sync00:00:00.020 0.0%305 0.000 0.066 0.500
history write00:20:10.632 1.4%2256208 0.092 0.537 3.943
hiswrite/artcncl00:00:00.001 0.0%13 0.000 0.077 1.000
idle19:12:46.601 80.0%43969946 0.546 1.573 114.535
nntp read00:31:30.903 2.2%46982848 0.033 0.040 0.053
overview write00:00:10.385 0.0%2255945 0.003 0.005 0.008
perl filter03:01:14.991 12.6%2256208 3.032 4.820 6.854
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:51.202 0.1%4527078 0.020 0.025 0.034
TOTAL: 24:00:14.16323:41:05.961 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.153 0.0%54146 0.000 0.003 0.015
article prepare00:00:00.003 0.0%4762 0.000 0.001 0.021
article read00:00:13.965 0.0%1183 0.000 11.805 362.333
backlog stats00:00:00.097 0.0%132574 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.196 0.0%64352 0.006 0.019 0.040
data write00:00:02.867 0.0%49211 0.027 0.058 0.103
idle23:53:59.121100.0%132574 393.850 648.989 1102.457
status file00:00:15.450 0.0%16822 0.642 0.918 6.192
TOTAL: 23:54:38.96823:54:32.852100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:26.966 87.2%3093 0.000 28.117 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.212 0.2%6931 0.000 0.031 0.579
readart00:00:00.005 0.0%68 0.000 0.074 1.500
TOTAL: 00:01:39.76300:01:27.183 87.4%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 279 22172022216938 0 264 99%110:48:31
2news.icm.edu.pl 43 193 15 159 19 7%15:07:02
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 325 22173972216955 159 283 99%125:55:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl282.8 GB604.9 KB1.2 MB282.8 GB 99%133.7 KB
2news.icm.edu.pl411.5 KB9.2 KB682.8 KB1.1 MB 37%32.5 KB
3localhost2.6 KB0.0 KB0.0 KB2.6 KB100%1.3 KB
TOTAL: 3282.8 GB614.2 KB1.8 MB282.8 GB 99%133.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 15 04:15:02 - 04:59:59 148513 6.7% 55.0510.7 GB 3.8%4163.47
Oct 15 05:00:00 - 05:59:59 190677 8.6% 52.9712.6 GB 4.4%3667.12
Oct 15 06:00:00 - 06:59:59 172874 7.8% 48.0211.4 GB 4.0%3320.78
Oct 15 07:00:00 - 07:59:59 29215 1.3% 8.121.8 GB 0.6% 512.81
Oct 15 08:00:00 - 08:59:59 31372 1.4% 8.714.3 GB 1.5%1260.27
Oct 15 09:00:00 - 09:59:59 39029 1.8% 10.846.0 GB 2.1%1750.00
Oct 15 10:00:00 - 10:59:59 31885 1.4% 8.865.4 GB 1.9%1562.47
Oct 15 11:00:00 - 11:59:59 43272 2.0% 12.025.0 GB 1.7%1449.12
Oct 15 12:00:00 - 12:59:59 127963 5.8% 35.5512.8 GB 4.5%3732.03
Oct 15 13:00:00 - 13:59:59 105201 4.7% 29.2210.2 GB 3.6%2976.63
Oct 15 14:00:00 - 14:59:59 142080 6.4% 39.4718.5 GB 6.5%5379.83
Oct 15 15:00:00 - 15:59:59 228989 10.3% 63.6125.6 GB 9.0%7450.29
Oct 15 16:00:00 - 16:59:59 225981 10.2% 62.7726.2 GB 9.2%7643.64
Oct 15 17:00:00 - 17:59:59 181438 8.2% 50.4024.9 GB 8.7%7242.13
Oct 15 18:00:00 - 18:59:59 58894 2.7% 16.3612.5 GB 4.4%3631.88
Oct 15 19:00:00 - 19:59:59 37409 1.7% 10.3911.5 GB 4.1%3356.47
Oct 15 20:00:00 - 20:59:59 91921 4.1% 25.5316.0 GB 5.6%4664.94
Oct 15 21:00:00 - 21:59:59 64973 2.9% 18.0515.7 GB 5.5%4563.78
Oct 15 22:00:00 - 22:59:59 69165 3.1% 19.2112.8 GB 4.5%3734.58
Oct 15 23:00:00 - 23:59:59 79555 3.6% 22.1015.1 GB 5.3%4397.40
Oct 16 00:00:00 - 00:59:59 46172 2.1% 12.838.8 GB 3.1%2554.42
Oct 16 01:00:00 - 01:59:59 21252 1.0% 5.902.3 GB 0.8% 674.97
Oct 16 02:00:00 - 02:59:59 16041 0.7% 4.463.9 GB 1.4%1139.34
Oct 16 03:00:00 - 03:59:59 24392 1.1% 6.787.4 GB 2.6%2164.72
Oct 16 04:00:00 - 04:15:01 9362 0.4% 10.393.1 GB 1.1%3598.18
TOTAL: 23:59:59 2217625 100.0% 25.67284.4 GB 100.0%3452.14
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 678 234 0 19 10 0 0 0 415
2news.icm.edu.pl 19 0 0 1 0 0 0 0 18
TOTAL: 2 697 234 0 20 10 0 0 0 433

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 151
it.comp.os.win.windows10 42
it.tlc.cellulari.android 18
it.comp.os.win.windows7 8
comp.sys.raspberry-pi 7
nl.comp.os.linux.techniek 2
comp.mobile.ipad 2
comp.mobile.android 1
it.discussioni.energia 1
it.comp.os.linux.ubuntu 1
de.comp.office-pakete.ms-office.outlook 1
TOTAL: 11 234

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

GroupsCount
pl.sci.matematyka 10
TOTAL: 1 10

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (9) 9
Scoring filter (8) 8
EMP (md5) 2
TOTAL: 3 19

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42242 458 13776 166 3 39891 1%23:59:57
2icm 25799 90 14998 1 0 2 0%23:59:53
3okapi 0 0 0 0 0 954 0%23:57:50
4nask 0 0 0 0 0 10100 0%23:57:49
5poznan 21 0 13 0 0 0 0%02:20:41
TOTAL: 5 68062 548 28787 167 3 50947 0%98:16:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.1 MB551.4 KB1.7 MB0.0 KB/s2.8 KB23:59:57
2icm283.3 KB3.5 KB286.8 KB0.0 KB/s3.2 KB23:59:53
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:20:41
TOTAL: 51.4 MB554.9 KB2.0 MB0.0 KB/s2.8 KB98:16:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6871.2 KB 29 0 000:00:15
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 6871.2 KB 29 2 000:01:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 6871.2 KB 29 2 000:00:18
2*.dhcp.mtpk.ca.charter.com 1 00.0 KB 0 0 000:00:10
3*.hinet-ip.hinet.net 1 00.0 KB 0 0 000:00:32
4unresolved 101 00.0 KB 0 0 000:00:37
5*.sfj.corp.censys.io 1 00.0 KB 0 0 000:00:00
TOTAL: 5 682 6871.2 KB 29 2 000:01:39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
201.103.12.105 0.000 0.012 0.00000:00:34
125-227-20-98.hinet-ip.hinet.net 0.004 0.020 0.00000:00:32
web.man.lodz.pl 1.348 4.236 0.00000:00:15
47-41-47-93.dhcp.mtpk.ca.charter.com 0.004 0.020 0.00000:00:10
mon.man.lodz.pl 1.392 4.132 0.00000:00:03
80.111.142.213 0.012 0.044 0.00000:00:02
212.51.192.185 0.384 1.340 0.00000:00:00
worker-18.sfj.corp.censys.io 0.008 0.016 0.00000:00:00
isvcs01.man.lodz.pl 0.020 0.036 0.00000:00:00
TOTAL: 9 3.172 9.856 0.00000:01:39

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
worker-18.sfj.corp.censys.io 1
125-227-20-98.hinet-ip.hinet.net 1
201.103.12.105 1
47-41-47-93.dhcp.mtpk.ca.charter.com 1
TOTAL: 7 392

NNRP unrecognized commands (by host):

SystemConn
125-227-20-98.hinet-ip.hinet.net 10
201.103.12.105 10
TOTAL: 2 20

NNRP unrecognized commands (by command):

CommandCount
User-Agent: ApiTool 2
Authorization: Basic YWRtaW46ezEyMjEzQkQ... 2
Content-Length: 586 2
Accept-Encoding: identity 2
Connection: close 2
Content-Type: text/xml 2
Host: 212.191.2.21 2
Cache-Control: max-age=0 2
Accept: */* 2
Accept-Language: en-us 2
TOTAL: 10 20

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.corp.censys.io 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 68100.0%
TOTAL: 1 68100.0%

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

NewsgroupCount
1pl.comp.pecet 46
2pl.comp.os.ms-windows.winnt 22
TOTAL: 2 68