Daily Usenet report

Oct 30 04:15:02 -- Oct 31 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 30 08:09:04 newsfeed nnrpd[2179]: SERVER perl filter not defined
Oct 30 11:50:18 newsfeed nnrpd[2934]: SERVER perl filter not defined
Oct 30 13:05:28 newsfeed nnrpd[14365]: SERVER perl filter not defined
Oct 30 13:28:00 newsfeed nnrpd[17629]: SERVER perl filter not defined
Oct 30 15:59:02 newsfeed overchan[31155]: input line too long, skipping
Oct 30 16:19:36 newsfeed overchan[31155]: input line too long, skipping
Oct 30 16:43:26 newsfeed overchan[31155]: input line too long, skipping
Oct 30 16:54:38 newsfeed overchan[31155]: input line too long, skipping
Oct 30 18:13:50 newsfeed nnrpd[28122]: unable to get certificate from '/etc/news/cert.pem'
Oct 30 18:13:50 newsfeed nnrpd[28122]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 610057 91.0%66.9 MB 90.2%
innfeed 47004 7.0%5.5 MB 7.4%
innd 9490 1.4%1.5 MB 2.0%
nnrpd 3500 0.5%326.7 KB 0.4%
overchan 5 0.0%0.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 670057 100.0%74.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 606578 99.4%
Negative hits 3362 0.6%
Positive hits 239 0.0%
Cache misses 32 0.0%
TOTAL: 4 610211 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.730 0.0%97 0.000 17.835 532.000
article cleanup00:00:02.821 0.0%610101 0.002 0.005 0.009
article logging00:00:10.176 0.0%610439 0.009 0.017 0.031
article parse00:07:16.971 0.5%141549238 0.002 0.003 0.005
article write00:03:22.381 0.2%609852 0.217 0.332 0.456
artlog/artcncl00:00:00.002 0.0%97 0.000 0.021 1.000
data move00:00:21.984 0.0%146742981 0.000 0.000 0.000
hisgrep/artcncl00:00:00.324 0.0%90 0.000 3.600 48.000
hishave/artcncl00:00:00.140 0.0%97 0.000 1.443 11.800
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:29:11.969 1.9%614098 0.167 2.853 15.250
history sync00:00:00.006 0.0%302 0.000 0.020 0.500
history write00:40:40.239 2.7%610074 0.348 4.000 15.216
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle22:50:12.866 91.3%141262675 0.366 0.582 1.206
nntp read00:14:17.329 1.0%141233754 0.004 0.006 0.008
overview write00:00:01.283 0.0%609852 0.000 0.002 0.004
perl filter00:24:48.569 1.7%610074 1.815 2.440 3.412
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.577 0.0%1230378 0.004 0.008 0.011
TOTAL: 25:00:05.92124:50:38.367 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.041 0.0%46499 0.000 0.001 0.008
article prepare00:00:00.001 0.0%6892 0.000 0.000 0.019
article read00:00:02.582 0.0%1723 0.000 1.499 19.500
backlog stats00:00:00.049 0.0%108916 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.268 0.0%51356 0.000 0.005 0.058
data write00:00:00.651 0.0%41158 0.000 0.016 0.053
idle24:54:11.143 99.9%108916 395.558 823.122 1317.925
status file00:01:03.741 0.1%18024 0.325 3.536 282.170
TOTAL: 24:55:20.90824:55:18.476100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:07.497 52.6%2908 0.000 2.578 152.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.043 0.3%6231 0.000 0.007 0.500
readart00:00:00.004 0.0%37 0.000 0.108 0.600
TOTAL: 00:00:14.25000:00:07.544 52.9%----

Control commands to INND:

CommandNumber
L 1
flush 28
flushlogs 2
go 2
logmode 2
mode 155
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 248 609487 609325 0 162 99%99:26:22
2news.icm.edu.pl 48 270 27 155 88 10%13:37:10
3localhost 1505 4 4 0 0 100%00:00:02
TOTAL: 3 1801 609761 609356 155 250 99%113:03:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl302.8 GB1.7 MB2.0 MB302.8 GB 99%520.9 KB
2news.icm.edu.pl1.6 MB0.0 KB6.2 MB7.8 MB 20%69.2 KB
3localhost6.7 KB0.0 KB0.0 KB6.7 KB100%1.7 KB
TOTAL: 3302.8 GB1.7 MB8.2 MB302.8 GB 99%520.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 30 04:15:02 - 04:59:59 17389 2.9% 6.459.6 GB 3.2%3743.04
Oct 30 05:00:00 - 05:59:59 22600 3.7% 6.2812.1 GB 4.0%3520.58
Oct 30 06:00:00 - 06:59:59 24090 4.0% 6.6912.8 GB 4.2%3720.46
Oct 30 07:00:00 - 07:59:59 25490 4.2% 7.0813.5 GB 4.4%3925.98
Oct 30 08:00:00 - 08:59:59 23127 3.8% 6.4212.0 GB 4.0%3502.35
Oct 30 09:00:00 - 09:59:59 23178 3.8% 6.4412.7 GB 4.2%3711.31
Oct 30 10:00:00 - 10:59:59 22950 3.8% 6.3811.0 GB 3.6%3191.67
Oct 30 11:00:00 - 11:59:59 20406 3.3% 5.6710.7 GB 3.5%3130.60
Oct 30 12:00:00 - 12:59:59 21065 3.5% 5.8511.3 GB 3.7%3284.09
Oct 30 13:00:00 - 13:59:59 21275 3.5% 5.9110.7 GB 3.5%3109.34
Oct 30 14:00:00 - 14:59:59 23683 3.9% 6.5811.5 GB 3.8%3362.12
Oct 30 15:00:00 - 15:59:59 27060 4.4% 7.5212.9 GB 4.3%3760.54
Oct 30 16:00:00 - 16:59:59 33764 5.5% 9.3813.7 GB 4.5%3994.12
Oct 30 17:00:00 - 17:59:59 28362 4.7% 7.8812.1 GB 4.0%3529.70
Oct 30 18:00:00 - 18:59:59 27223 4.5% 7.5612.2 GB 4.0%3546.27
Oct 30 19:00:00 - 19:59:59 27485 4.5% 7.6313.0 GB 4.3%3785.53
Oct 30 20:00:00 - 20:59:59 24310 4.0% 6.7511.8 GB 3.9%3433.87
Oct 30 21:00:00 - 21:59:59 23066 3.8% 6.4111.7 GB 3.9%3416.50
Oct 30 22:00:00 - 22:59:59 25628 4.2% 7.1212.3 GB 4.1%3584.57
Oct 30 23:00:00 - 23:59:59 24152 4.0% 6.7112.1 GB 4.0%3521.07
Oct 31 00:00:00 - 00:59:59 24470 4.0% 6.8012.5 GB 4.1%3631.04
Oct 31 01:00:00 - 01:59:59 25658 4.2% 7.1313.6 GB 4.5%3948.10
Oct 31 02:00:00 - 02:59:59 46486 7.6% 12.9124.4 GB 8.0%7094.03
Oct 31 03:00:00 - 03:59:59 20731 3.4% 5.7610.5 GB 3.4%3045.20
Oct 31 04:00:00 - 04:15:01 5725 0.9% 6.353.0 GB 1.0%3440.42
TOTAL: 23:59:59 609373 100.0% 7.05303.5 GB 100.0%3684.01
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 500 133 0 27 2 0 0 0 338
2news.icm.edu.pl 88 0 0 0 0 0 0 0 88
TOTAL: 2 588 133 0 27 2 0 0 0 426

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 62
comp.mobile.android 21
comp.sys.raspberry-pi 15
it.comp.os.win.windows10 9
alt.comp.software.seamonkey 8
comp.mobile.ipad 7
de.rec.sf.startrek 6
it.tlc.cellulari.android 2
alt.comp.software.firefox 2
it.comp.os.linux.ubuntu 1
TOTAL: 10 133

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

GroupsCount
pl.praca.oferowana 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 86
Binary in non-binary group 2
TOTAL: 2 88

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17346 1226 8973 185 0 0 7%25:06:49
2panorama 39396 55 9462 39 0 37054 0%24:59:57
3nask 0 0 0 0 0 7360 0%24:57:49
4okapi 0 0 0 0 0 682 0%24:57:49
5poznan 32 0 21 0 0 0 0%02:27:30
TOTAL: 5 56774 1281 18456 224 0 45096 2%102:29:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.3 MB33.0 MB37.4 MB0.4 KB/s27.1 KB25:06:49
2panorama149.3 KB156.9 KB306.2 KB0.0 KB/s3.3 KB24:59:57
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:57:49
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:57:49
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:27:30
TOTAL: 54.5 MB33.2 MB37.7 MB0.1 KB/s25.6 KB102:29:54
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 300 3229.4 KB 16 0 000:00:07
2212.90.61.180 2 46.7 KB 1 0 000:00:02
3isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 3 306 3636.1 KB 17 4 000:00:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 304 3229.4 KB 16 4 000:00:07
2unresolved 107 46.7 KB 1 0 000:00:06
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 412 3636.1 KB 17 4 000:00:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.765 1.195 0.00000:00:07
80.111.142.213 0.014 0.010 0.00000:00:02
212.90.61.180 0.030 0.022 0.00000:00:02
212.51.192.185 0.210 0.446 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.000 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.016 0.018 0.00000:00:00
185.156.72.10 0.000 0.005 0.00000:00:00
TOTAL: 7 1.035 1.702 0.00000:00:14

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 100
80.111.142.213 4
185.156.72.10 1
scanner-05.ch1.censys-scanner.com 1
TOTAL: 4 106

NNRP unrecognized commands (by host):

SystemConn
scanner-05.ch1.censys-scanner.com 1
185.156.72.10 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
#003 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
185.156.72.10 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 32 88.9%
2lodman 4 11.1%
TOTAL: 2 36100.0%

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

NewsgroupCount
1pl.comp.pecet 24
2pl.comp.os.ms-windows.winnt 8
3lodman.info 4
TOTAL: 3 36