Daily Usenet report

Nov 20 04:15:02 -- Nov 21 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Nov 20 10:16:28 newsfeed nnrpd[30148]: SERVER perl filter not defined
Nov 20 14:30:10 newsfeed pgpverify[4986]: pgpverify: verification failed
Nov 20 16:15:55 newsfeed overchan[6565]: input line too long, skipping
Nov 20 16:32:02 newsfeed overchan[6565]: input line too long, skipping
Nov 20 16:38:08 newsfeed nnrpd[24573]: unable to get certificate from '/etc/news/cert.pem'
Nov 20 16:38:08 newsfeed nnrpd[24573]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Nov 20 17:07:44 newsfeed overchan[6565]: input line too long, skipping
Nov 20 17:35:12 newsfeed overchan[6565]: input line too long, skipping
Nov 20 17:51:47 newsfeed overchan[6565]: input line too long, skipping
Nov 20 17:51:54 newsfeed overchan[6565]: input line too long, skipping
Nov 20 18:49:42 newsfeed nnrpd[12790]: SERVER perl filter not defined
Nov 20 19:04:09 newsfeed overchan[6565]: input line too long, skipping
Nov 20 21:43:02 newsfeed overchan[6565]: input line too long, skipping
Nov 20 21:52:58 newsfeed overchan[6565]: input line too long, skipping
Nov 20 22:23:57 newsfeed pgpverify[13257]: pgpverify: verification failed
Nov 20 22:54:16 newsfeed overchan[6565]: input line too long, skipping
Nov 21 01:44:51 newsfeed overchan[6565]: input line too long, skipping
Nov 21 02:31:50 newsfeed overchan[6565]: input line too long, skipping
Nov 21 03:00:36 newsfeed overchan[6565]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 680448 92.5%74.5 MB 91.9%
innfeed 41770 5.7%4.8 MB 5.9%
innd 8966 1.2%1.4 MB 1.7%
nnrpd 4236 0.6%423.5 KB 0.5%
controlchan 23 0.0%5.4 KB 0.0%
overchan 14 0.0%2.0 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
TOTAL: 7 735459 100.0%81.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 674207 99.4%
Negative hits 3590 0.5%
Positive hits 265 0.0%
Cache misses 20 0.0%
TOTAL: 4 678082 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.678 0.0%73 0.000 9.288 110.000
article cleanup00:00:09.806 0.0%675069 0.008 0.015 0.021
article logging00:00:32.665 0.0%675517 0.040 0.048 0.092
article parse00:17:48.996 1.2%48018362 0.010 0.022 0.031
article write00:07:14.892 0.5%674765 0.395 0.645 1.036
artlog/artcncl00:00:00.003 0.0%72 0.000 0.042 1.000
data move00:00:41.837 0.0%52575583 0.001 0.001 0.001
hisgrep/artcncl00:00:00.133 0.0%71 0.000 1.873 23.000
hishave/artcncl00:00:00.060 0.0%73 0.000 0.822 10.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:30.424 2.1%679320 0.439 2.694 10.003
history sync00:00:00.021 0.0%287 0.000 0.073 0.500
history write00:50:54.282 3.6%675044 0.694 4.525 13.772
hiswrite/artcncl00:00:00.017 0.0%2 0.000 8.500 17.000
idle20:16:48.257 85.1%47697969 1.301 1.531 2.252
nntp read00:30:52.696 2.2%47704789 0.020 0.039 0.051
overview write00:00:03.686 0.0%674765 0.002 0.005 0.009
perl filter01:02:25.993 4.4%675044 3.470 5.549 7.465
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:36.574 0.0%1363382 0.020 0.027 0.034
TOTAL: 23:50:03.63123:38:41.020 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.106 0.0%48450 0.000 0.002 0.009
article prepare00:00:00.000 0.0%1980 0.000 0.000 0.000
article read00:00:03.474 0.0%495 0.000 7.018 655.000
backlog stats00:00:00.104 0.0%117217 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.991 0.0%57802 0.003 0.017 0.039
data write00:00:02.536 0.0%43995 0.018 0.058 0.098
idle23:54:31.616 99.9%117217 488.928 734.293 1469.771
status file00:01:01.573 0.1%17186 0.691 3.583 191.346
TOTAL: 23:55:47.36423:55:40.400100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:41.103 77.9%3037 0.000 13.534 8845.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.245 0.5%6681 0.000 0.037 1.895
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:00:52.78200:00:41.348 78.3%----

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
control@usenet-fr.news.eu.org001101
grisbi-control@grisbi.org001101
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 95 679618 679381 0 237 99%66:35:53
2news.icm.edu.pl 42 285 44 187 54 15%15:13:25
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1580 679905 679427 187 291 99%81:49:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl271.2 GB1011.6 KB1.6 MB271.2 GB 99%418.5 KB
2news.icm.edu.pl1.4 MB48.8 KB1.7 MB3.2 MB 44%33.6 KB
3localhost2.9 KB0.0 KB0.0 KB2.9 KB100%1.4 KB
TOTAL: 3271.2 GB1.0 MB3.4 MB271.2 GB 99%418.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 20 04:15:02 - 04:59:59 15656 2.3% 5.807.9 GB 2.9%3086.33
Nov 20 05:00:00 - 05:59:59 21296 3.1% 5.9210.4 GB 3.8%3039.62
Nov 20 06:00:00 - 06:59:59 22972 3.4% 6.3810.5 GB 3.9%3052.91
Nov 20 07:00:00 - 07:59:59 21731 3.2% 6.0410.6 GB 3.9%3080.71
Nov 20 08:00:00 - 08:59:59 29588 4.4% 8.2210.9 GB 4.0%3175.36
Nov 20 09:00:00 - 09:59:59 31305 4.6% 8.7011.2 GB 4.1%3262.69
Nov 20 10:00:00 - 10:59:59 29100 4.3% 8.0811.1 GB 4.1%3228.87
Nov 20 11:00:00 - 11:59:59 29002 4.3% 8.0611.5 GB 4.2%3347.73
Nov 20 12:00:00 - 12:59:59 33779 5.0% 9.3811.5 GB 4.2%3360.17
Nov 20 13:00:00 - 13:59:59 30049 4.4% 8.3511.7 GB 4.3%3421.81
Nov 20 14:00:00 - 14:59:59 30605 4.5% 8.5011.2 GB 4.1%3265.79
Nov 20 15:00:00 - 15:59:59 33681 5.0% 9.3611.2 GB 4.1%3255.00
Nov 20 16:00:00 - 16:59:59 30347 4.5% 8.4311.2 GB 4.1%3273.21
Nov 20 17:00:00 - 17:59:59 25692 3.8% 7.1410.5 GB 3.9%3059.62
Nov 20 18:00:00 - 18:59:59 28230 4.2% 7.8410.8 GB 4.0%3133.06
Nov 20 19:00:00 - 19:59:59 28607 4.2% 7.9511.4 GB 4.2%3310.38
Nov 20 20:00:00 - 20:59:59 28903 4.3% 8.0312.9 GB 4.8%3770.02
Nov 20 21:00:00 - 21:59:59 30661 4.5% 8.5212.3 GB 4.5%3587.84
Nov 20 22:00:00 - 22:59:59 28784 4.2% 8.0012.7 GB 4.7%3709.45
Nov 20 23:00:00 - 23:59:59 27847 4.1% 7.7412.0 GB 4.4%3503.85
Nov 21 00:00:00 - 00:59:59 31004 4.6% 8.6112.1 GB 4.4%3521.07
Nov 21 01:00:00 - 01:59:59 28470 4.2% 7.9111.9 GB 4.4%3466.92
Nov 21 02:00:00 - 02:59:59 28131 4.1% 7.8111.5 GB 4.2%3336.18
Nov 21 03:00:00 - 03:59:59 26603 3.9% 7.3910.0 GB 3.7%2906.12
Nov 21 04:00:00 - 04:15:02 7580 1.1% 8.402.9 GB 1.1%3403.78
TOTAL: 24:00:00 679623 100.0% 7.87272.0 GB 100.0%3301.43
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 685 195 0 22 16 0 0 0 452
2news.icm.edu.pl 68 0 0 3 0 0 0 0 65
TOTAL: 2 753 195 0 25 16 0 0 0 517

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 127
comp.mobile.android 19
comp.sys.raspberry-pi 18
it.comp.os.win.windows10 17
it.tlc.cellulari.android 5
it.comp.os.win.windows7 4
it.comp.os.linux.ubuntu 3
de.rec.sf.startrek 2
TOTAL: 8 195

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

GroupsCount
pl.sci.matematyka 9
pl.praca.oferowana 7
TOTAL: 2 16

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 57
Binary in non-binary group 8
Too many newsgroups 3
TOTAL: 3 68

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 21387 340 13252 26 0 1 1%23:55:56
2panorama 40477 11 11990 35 0 36556 0%24:00:10
3nask 0 0 0 0 0 9001 0%23:57:45
4okapi 0 0 0 0 0 935 0%23:50:00
5poznan 38 0 33 0 0 0 0%02:33:06
TOTAL: 5 61902 351 25275 61 0 46493 0%98:16:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.0 MB960.1 KB2.0 MB0.0 KB/s5.5 KB23:55:56
2panorama41.6 KB333.6 KB375.2 KB0.0 KB/s8.2 KB24:00:10
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:33:06
TOTAL: 51.1 MB1.3 MB2.3 MB0.0 KB/s5.8 KB98:16:57
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 295 69.4 KB 3 0 000:00:23
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 297 69.4 KB 3 2 000:00:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 585 69.4 KB 3 2 000:00:27
2*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
3unresolved 102 00.0 KB 0 0 000:00:22
4*.sfj.censys-scanner.com 3 00.0 KB 0 0 000:00:01
5*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 5 693 69.4 KB 3 2 000:00:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.484 2.673 0.00000:00:23
84.69.189.208 0.019 0.015 0.00000:00:17
80.111.142.213 0.022 0.042 0.00000:00:03
mon.man.lodz.pl 1.318 2.210 0.00000:00:03
worker-18.sfj.censys-scanner.com 0.015 0.020 0.00000:00:01
212.51.192.185 0.480 0.708 0.00000:00:01
scanner-06.ch1.censys-scanner.com 0.012 0.015 0.00000:00:00
scan-141.security.ipip.net 0.008 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.013 0.040 0.00000:00:00
94.232.42.169 0.005 0.005 0.00000:00:00
TOTAL: 10 3.376 5.736 0.00000:00:52

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.censys-scanner.com 3
scanner-06.ch1.censys-scanner.com 2
84.69.189.208 1
94.232.42.169 1
scan-141.security.ipip.net 1
TOTAL: 8 396

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-06.ch1.censys-scanner.com 1
94.232.42.169 1
TOTAL: 3 6

NNRP unrecognized commands (by command):

CommandCount
Connection: close 1
#003 1
Host: 212.191.2.21:119 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.censys-scanner.com 3 3
94.232.42.169 1 1
TOTAL: 2 4 5

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

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