Daily Usenet report

Mar 15 04:15:02 -- Mar 16 04:15:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Mar 15 15:13:28 newsfeed nnrpd[636949]: SERVER perl filter not defined
Mar 15 15:14:49 newsfeed nnrpd[636980]: SERVER perl filter not defined
Mar 15 15:19:19 newsfeed overchan[607042]: input line too long, skipping
Mar 15 16:00:06 newsfeed pgpverify[639175]: pgpverify: /usr/bin/gpg1: no such file
Mar 15 16:00:07 newsfeed pgpverify[639187]: pgpverify: /usr/bin/gpg1: no such file
Mar 15 16:10:26 newsfeed overchan[607042]: input line too long, skipping
Mar 15 17:16:35 newsfeed overchan[607042]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 868594 95.9%94.8 MB 95.4%
innfeed 23055 2.5%2.7 MB 2.7%
nnrpd 7980 0.9%881.1 KB 0.9%
innd 6531 0.7%1.0 MB 1.0%
controlchan 23 0.0%4.8 KB 0.0%
overchan 4 0.0%0.7 KB 0.0%
pgpverify 2 0.0%0.5 KB 0.0%
TOTAL: 7 906189 100.0%99.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 864600 99.7%
Negative hits 2659 0.3%
Positive hits 306 0.0%
Cache misses 31 0.0%
TOTAL: 4 867596 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.689 0.0%62 0.000 11.113 80.500
article cleanup00:00:03.240 0.0%866823 0.002 0.004 0.009
article logging00:00:12.071 0.0%867178 0.009 0.014 0.024
article parse00:05:31.403 0.4%141909569 0.002 0.002 0.003
article write00:03:44.510 0.3%866606 0.143 0.259 0.391
artlog/artcncl00:00:00.000 0.0%62 0.000 0.000 0.000
data move00:00:24.306 0.0%147781606 0.000 0.000 0.000
hisgrep/artcncl00:00:00.161 0.0%62 0.000 2.597 29.000
hishave/artcncl00:00:00.023 0.0%62 0.000 0.371 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:14:39.586 1.0%869866 0.087 1.011 14.158
history sync00:00:00.007 0.0%290 0.000 0.024 0.500
history write00:22:46.239 1.6%866776 0.155 1.576 12.576
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:25:51.936 93.5%141451550 0.340 0.571 0.842
nntp read00:13:56.437 1.0%141469672 0.005 0.006 0.007
overview write00:00:01.624 0.0%866606 0.001 0.002 0.003
perl filter00:24:23.055 1.7%866776 1.324 1.688 2.149
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:14.039 0.0%1742891 0.006 0.008 0.011
TOTAL: 24:00:02.44223:51:49.326 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%28240 0.000 0.001 0.014
article prepare00:00:00.003 0.0%3624 0.000 0.001 0.025
article read00:00:08.432 0.0%930 0.000 9.067 41.000
backlog stats00:00:00.029 0.0%76632 0.000 0.000 0.006
callbacks00:00:00.000 0.0%26 0.000 0.000 0.000
data read00:00:00.214 0.0%36696 0.000 0.006 0.034
data write00:00:00.602 0.0%27178 0.000 0.022 0.072
idle23:56:33.622100.0%76632 708.309 1124.773 2982.698
status file00:00:08.101 0.0%7452 0.186 1.087 39.354
TOTAL: 23:56:52.62323:56:51.029100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:17:52.645 98.1%4471 0.000 239.912 29367.643
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.170 0.0%10954 0.000 0.016 0.500
readart00:00:02.713 0.2%711 0.000 3.816 3.883
TOTAL: 00:18:13.91400:17:55.528 98.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
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 344 868180 867990 0 190 99%102:28:29
2news.icm.edu.pl 42 300 50 223 27 16%16:27:29
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 389 868482 868042 223 217 99%118:55:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl297.8 GB3.0 MB3.5 MB297.8 GB 99%359.7 KB
2news.icm.edu.pl3.3 MB55.8 KB1020.7 KB4.3 MB 75%57.7 KB
3localhost2.9 KB0.0 KB0.0 KB2.9 KB100%1.5 KB
TOTAL: 3297.8 GB3.1 MB4.5 MB297.8 GB 99%359.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 15 04:15:02 - 04:59:59 25164 2.9% 9.3310.4 GB 3.5%4027.49
Mar 15 05:00:00 - 05:59:59 29077 3.4% 8.0812.5 GB 4.2%3647.59
Mar 15 06:00:00 - 06:59:59 26565 3.1% 7.3812.9 GB 4.3%3766.34
Mar 15 07:00:00 - 07:59:59 29938 3.4% 8.3212.1 GB 4.0%3519.30
Mar 15 08:00:00 - 08:59:59 28738 3.3% 7.9811.0 GB 3.7%3199.59
Mar 15 09:00:00 - 09:59:59 27765 3.2% 7.7111.4 GB 3.8%3309.94
Mar 15 10:00:00 - 10:59:59 34185 3.9% 9.5011.7 GB 3.9%3410.69
Mar 15 11:00:00 - 11:59:59 30903 3.6% 8.5811.7 GB 3.9%3408.50
Mar 15 12:00:00 - 12:59:59 32237 3.7% 8.9513.3 GB 4.5%3881.63
Mar 15 13:00:00 - 13:59:59 29320 3.4% 8.1412.6 GB 4.2%3674.97
Mar 15 14:00:00 - 14:59:59 33929 3.9% 9.4212.2 GB 4.1%3549.11
Mar 15 15:00:00 - 15:59:59 28373 3.3% 7.8812.4 GB 4.2%3620.60
Mar 15 16:00:00 - 16:59:59 45566 5.2% 12.6612.2 GB 4.1%3551.47
Mar 15 17:00:00 - 17:59:59 38503 4.4% 10.7012.1 GB 4.0%3511.77
Mar 15 18:00:00 - 18:59:59 33019 3.8% 9.1711.9 GB 4.0%3462.52
Mar 15 19:00:00 - 19:59:59 33727 3.9% 9.3711.3 GB 3.8%3291.23
Mar 15 20:00:00 - 20:59:59 39765 4.6% 11.0511.2 GB 3.8%3273.16
Mar 15 21:00:00 - 21:59:59 36489 4.2% 10.1411.1 GB 3.7%3227.20
Mar 15 22:00:00 - 22:59:59 43079 5.0% 11.9710.8 GB 3.6%3147.72
Mar 15 23:00:00 - 23:59:59 35420 4.1% 9.8411.2 GB 3.7%3252.22
Mar 16 00:00:00 - 00:59:59 41843 4.8% 11.6212.2 GB 4.1%3564.85
Mar 16 01:00:00 - 01:59:59 53348 6.1% 14.8215.6 GB 5.2%4546.23
Mar 16 02:00:00 - 02:59:59 58804 6.8% 16.3317.3 GB 5.8%5052.04
Mar 16 03:00:00 - 03:59:59 36758 4.2% 10.2113.2 GB 4.4%3842.96
Mar 16 04:00:00 - 04:15:01 15445 1.8% 17.144.0 GB 1.4%4701.03
TOTAL: 23:59:59 867960 100.0% 10.05298.4 GB 100.0%3621.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 544 137 0 42 11 0 0 0 354
2news.icm.edu.pl 28 0 0 5 0 0 0 0 23
TOTAL: 2 572 137 0 47 11 0 0 0 377

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 64
it.comp.os.win.windows10 27
comp.sys.raspberry-pi 14
alt.comp.software.firefox 13
comp.mobile.android 10
de.comm.provider.telefonie 3
nl.comp.sys.android 2
alt.comp.software.seamonkey 1
nl.comp.os.linux.techniek 1
it.tlc.cellulari.android 1
de.comp.lang.vbclassic 1
TOTAL: 11 137

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

GroupsCount
pl.praca.oferowana 11
TOTAL: 1 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13
Binary in non-binary group 6
Scoring filter (8) 1
Too many newsgroups (low_xpost) 1
Excessively crossposted test article 1
TOTAL: 5 22

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 354
news.icm.edu.pl 1
TOTAL: 2 355
TOTAL: 1 355

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15771 311 9219 9 0 0 1%23:59:57
2panorama 18704 153 6203 145 48 21740 0%23:59:57
3okapi 0 0 0 0 0 534 0%23:57:47
4poznan 27 0 24 0 0 0 0%02:35:18
5nask 0 0 0 0 0 6523 0%23:57:47
TOTAL: 5 34502 464 15446 154 48 28797 1%98:30:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.3 MB33.6 KB1.4 MB0.0 KB/s4.4 KB23:59:57
2panorama469.8 KB1.8 MB2.3 MB0.0 KB/s7.8 KB23:59:57
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:35:18
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 51.8 MB1.8 MB3.6 MB0.0 KB/s6.0 KB98:30:46
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 294 88.3 KB 4 0 000:00:09
2apl214.neoplus.adsl.tpnet.pl 2 33.6 KB 2 0 100:14:07
3178.218.114.238 24 22.9 KB 1 0 000:03:27
446.219.192.81 3 22.9 KB 1 0 000:00:02
5isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 5 325 1517.8 KB 8 2 100:18:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1735 88.3 KB 4 2 000:00:22
2unresolved 129 45.9 KB 2 0 000:03:43
3*.neoplus.adsl.tpnet.pl 2 33.6 KB 2 0 100:14:07
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
5*.census.shodan.io 1 00.0 KB 0 0 000:00:00
TOTAL: 51868 1517.8 KB 8 2 100:18:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
apl214.neoplus.adsl.tpnet.pl 0.150 0.062 0.00000:14:07
178.218.114.238 0.046 0.302 0.00000:03:27
nms1.man.lodz.pl 2.124 17.194 0.00000:00:13
104.152.52.236 0.003 0.017 0.00000:00:10
web.man.lodz.pl 0.574 3.528 0.00000:00:09
46.219.192.81 0.038 0.041 0.00000:00:02
80.111.142.213 0.007 0.050 0.00000:00:02
212.51.192.185 0.151 1.123 0.00000:00:01
scanner-29.ch1.censys-scanner.com 0.004 0.018 0.00000:00:00
cloud.census.shodan.io 0.000 0.012 0.00000:00:00
162.243.146.15 0.004 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.003 0.026 0.00000:00:00
TOTAL: 12 3.104 22.381 0.00000:18:14

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1439
212.51.192.185 96
80.111.142.213 4
104.152.52.236 1
162.243.146.15 1
cloud.census.shodan.io 1
scanner-29.ch1.censys-scanner.com 1
TOTAL: 7 1543

NNRP unrecognized commands (by host):

SystemConn
scanner-29.ch1.censys-scanner.com 1
162.243.146.15 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
apl214.neoplus.adsl.tpnet.pl 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 8 53.3%
2lodman 7 46.7%
TOTAL: 2 15100.0%

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

NewsgroupCount
1lodman.info 6
2pl.comp.pecet 6
3pl.comp.os.ms-windows.winnt 2
4lodman.test 1
TOTAL: 4 15