Daily Usenet report

Oct 14 04:15:01 -- Oct 15 04:15:02

Unknown entries from news log file:

First 23 / 23 lines (100.0%)

Oct 14 10:00:35 newsfeed nnrpd[1696]: SERVER perl filter not defined
Oct 14 10:45:46 newsfeed nnrpd[8356]: SERVER perl filter not defined
Oct 14 10:45:58 newsfeed nnrpd[8366]: SERVER perl filter not defined
Oct 14 11:26:48 newsfeed nnrpd[14548]: SERVER perl filter not defined
Oct 14 12:37:17 newsfeed nnrpd[25076]: SERVER perl filter not defined
Oct 14 12:38:35 newsfeed nnrpd[25382]: SERVER perl filter not defined
Oct 14 12:59:35 newsfeed nnrpd[28602]: SERVER perl filter not defined
Oct 14 13:01:11 newsfeed nnrpd[28826]: SERVER perl filter not defined
Oct 14 15:49:13 newsfeed overchan[14167]: input line too long, skipping
Oct 14 16:03:59 newsfeed overchan[14167]: input line too long, skipping
Oct 14 16:30:46 newsfeed nnrpd[27823]: SERVER perl filter not defined
Oct 14 16:32:13 newsfeed overchan[14167]: input line too long, skipping
Oct 14 16:35:08 newsfeed overchan[14167]: input line too long, skipping
Oct 14 16:40:06 newsfeed overchan[14167]: input line too long, skipping
Oct 14 16:56:11 newsfeed overchan[14167]: input line too long, skipping
Oct 14 17:10:05 newsfeed overchan[14167]: input line too long, skipping
Oct 14 19:44:39 newsfeed overchan[14167]: input line too long, skipping
Oct 14 19:48:29 newsfeed overchan[14167]: input line too long, skipping
Oct 14 23:12:10 newsfeed nnrpd[23067]: SERVER perl filter not defined
Oct 14 23:15:53 newsfeed nnrpd[23496]: unable to get certificate from '/etc/news/cert.pem'
Oct 14 23:15:53 newsfeed nnrpd[23496]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Oct 14 23:21:02 newsfeed nnrpd[24277]: unable to get certificate from '/etc/news/cert.pem'
Oct 14 23:21:02 newsfeed nnrpd[24277]: 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 493766 93.2%54.7 MB 92.5%
innfeed 24388 4.6%2.9 MB 4.9%
innd 8394 1.6%1.3 MB 2.1%
nnrpd 3391 0.6%319.0 KB 0.5%
overchan 11 0.0%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 529951 100.0%59.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 490398 99.2%
Negative hits 3539 0.7%
Positive hits 237 0.0%
Cache misses 54 0.0%
TOTAL: 4 494228 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.522 0.0%86 0.000 29.326 67.250
article cleanup00:00:02.572 0.0%493005 0.002 0.005 0.010
article logging00:00:08.429 0.0%493443 0.010 0.017 0.046
article parse00:06:01.606 0.4%100728540 0.003 0.004 0.006
article write00:02:44.850 0.2%492815 0.202 0.335 2.376
artlog/artcncl00:00:00.000 0.0%86 0.000 0.000 0.000
data move00:00:18.575 0.0%104619078 0.000 0.000 0.000
hisgrep/artcncl00:00:00.473 0.0%86 0.000 5.500 21.000
hishave/artcncl00:00:00.100 0.0%86 0.000 1.163 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:19:20.435 1.3%496782 0.326 2.336 7.329
history sync00:00:00.005 0.0%290 0.000 0.017 0.500
history write00:38:57.625 2.7%492977 1.171 4.742 13.007
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:15:04.462 92.7%98478757 0.509 0.813 1.760
nntp read00:10:51.691 0.8%100391134 0.005 0.006 0.010
overview write00:00:01.105 0.0%492815 0.001 0.002 0.004
perl filter00:20:19.240 1.4%492977 1.793 2.473 3.439
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.867 0.0%997675 0.005 0.008 0.013
TOTAL: 24:00:00.65823:54:01.557 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.033 0.0%35254 0.000 0.001 0.025
article prepare00:00:00.001 0.0%1304 0.000 0.001 0.050
article read00:00:00.327 0.0%326 0.000 1.003 36.000
backlog stats00:00:00.045 0.0%90882 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.236 0.0%44524 0.000 0.005 0.033
data write00:00:00.543 0.0%32728 0.000 0.017 0.058
idle23:56:23.778100.0%90882 598.702 948.304 2740.128
status file00:00:11.277 0.0%7872 0.000 1.433 45.840
TOTAL: 23:56:37.81123:56:36.240100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:07.449 57.3%2835 0.000 2.628 219.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.035 0.3%5932 0.000 0.006 0.167
readart00:00:00.001 0.0%24 0.000 0.042 0.500
TOTAL: 00:00:12.99700:00:07.485 57.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 188 492932 492760 0 172 99%108:07:15
2news.icm.edu.pl 43 203 19 167 17 9%14:27:24
3localhost 1451 10 10 0 0 100%00:00:00
TOTAL: 3 1682 493145 492789 167 189 99%122:34:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl228.4 GB1.4 MB1.9 MB228.4 GB 99%485.9 KB
2news.icm.edu.pl973.6 KB0.0 KB830.3 KB1.8 MB 53%50.1 KB
3localhost22.5 KB0.0 KB0.0 KB22.5 KB100%2.2 KB
TOTAL: 3228.4 GB1.4 MB2.7 MB228.4 GB 99%485.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 14 04:15:01 - 04:59:59 13810 2.8% 5.127.8 GB 3.4%3012.46
Oct 14 05:00:00 - 05:59:59 17533 3.6% 4.879.5 GB 4.2%2765.30
Oct 14 06:00:00 - 06:59:59 17152 3.5% 4.768.9 GB 3.9%2578.95
Oct 14 07:00:00 - 07:59:59 18627 3.8% 5.179.7 GB 4.3%2833.32
Oct 14 08:00:00 - 08:59:59 17867 3.6% 4.969.1 GB 4.0%2653.21
Oct 14 09:00:00 - 09:59:59 19780 4.0% 5.499.3 GB 4.1%2720.18
Oct 14 10:00:00 - 10:59:59 24513 5.0% 6.8110.2 GB 4.5%2967.69
Oct 14 11:00:00 - 11:59:59 20823 4.2% 5.7810.1 GB 4.4%2941.37
Oct 14 12:00:00 - 12:59:59 23158 4.7% 6.4311.2 GB 4.9%3264.56
Oct 14 13:00:00 - 13:59:59 22194 4.5% 6.1711.2 GB 4.9%3251.75
Oct 14 14:00:00 - 14:59:59 23806 4.8% 6.6111.8 GB 5.1%3428.07
Oct 14 15:00:00 - 15:59:59 21209 4.3% 5.8910.7 GB 4.7%3122.99
Oct 14 16:00:00 - 16:59:59 21735 4.4% 6.0410.8 GB 4.7%3158.70
Oct 14 17:00:00 - 17:59:59 24964 5.1% 6.9311.4 GB 5.0%3327.87
Oct 14 18:00:00 - 18:59:59 28902 5.9% 8.0311.1 GB 4.9%3240.20
Oct 14 19:00:00 - 19:59:59 20381 4.1% 5.668.9 GB 3.9%2600.14
Oct 14 20:00:00 - 20:59:59 22791 4.6% 6.339.8 GB 4.3%2851.09
Oct 14 21:00:00 - 21:59:59 23273 4.7% 6.4610.2 GB 4.4%2959.75
Oct 14 22:00:00 - 22:59:59 24371 4.9% 6.779.9 GB 4.3%2892.85
Oct 14 23:00:00 - 23:59:59 13615 2.8% 3.786.3 GB 2.7%1828.91
Oct 15 00:00:00 - 00:59:59 15995 3.2% 4.446.3 GB 2.8%1847.98
Oct 15 01:00:00 - 01:59:59 16499 3.3% 4.586.4 GB 2.8%1849.86
Oct 15 02:00:00 - 02:59:59 15654 3.2% 4.356.3 GB 2.8%1842.31
Oct 15 03:00:00 - 03:59:59 19528 4.0% 5.429.4 GB 4.1%2740.37
Oct 15 04:00:00 - 04:15:02 4877 1.0% 5.412.3 GB 1.0%2679.83
TOTAL: 24:00:01 493057 100.0% 5.71228.6 GB 100.0%2774.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 606 138 0 28 6 0 0 0 434
2news.icm.edu.pl 17 0 0 0 0 0 0 0 17
TOTAL: 2 623 138 0 28 6 0 0 0 451

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 71
it.comp.os.win.windows10 31
comp.mobile.android 11
alt.comp.software.firefox 8
it.tlc.cellulari.android 6
alt.comp.software.seamonkey 5
hr.rec.drustvene-igre 3
de.rec.sf.startrek 2
de.comp.lang.vbclassic 1
TOTAL: 9 138

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

GroupsCount
pl.praca.oferowana 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12
Binary in non-binary group 4
Scoring filter (9) 1
TOTAL: 3 17

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19588 177 11442 103 0 0 0%23:56:52
2panorama 23933 0 11054 24 0 24227 0%23:59:59
3nask 0 0 0 0 0 7756 0%23:57:50
4okapi 0 0 0 0 0 1007 0%23:57:50
5poznan 20 0 15 0 0 0 0%02:02:16
TOTAL: 5 43541 177 22511 127 0 32990 0%97:54:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm696.6 KB10.6 MB11.3 MB0.1 KB/s41.2 KB23:56:52
2panorama0.0 KB183.2 KB183.2 KB0.0 KB/s7.6 KB23:59:59
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:02:16
TOTAL: 5696.6 KB10.8 MB11.4 MB0.0 KB/s38.5 KB97:54:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2422.7 KB 11 0 000:00:07
2isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 2 298 2422.7 KB 11 10 000:00:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 298 2422.7 KB 11 10 000:00:07
2unresolved 101 00.0 KB 0 0 000:00:03
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 3 401 2422.7 KB 11 10 000:00:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.660 1.239 0.00000:00:07
80.111.142.213 0.016 0.010 0.00000:00:02
212.51.192.185 0.192 0.415 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.003 0.003 0.00000:00:00
isvcs01.man.lodz.pl 0.036 0.043 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.000 0.007 0.00000:00:00
79.124.62.106 0.005 0.000 0.00000:00:00
TOTAL: 7 0.912 1.717 0.00000:00:13

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
79.124.62.106 1
scanner-07.ch1.censys-scanner.com 1
scanner-09.ch1.censys-scanner.com 1
TOTAL: 5 103

NNRP unrecognized commands (by host):

SystemConn
79.124.62.106 1
scanner-07.ch1.censys-scanner.com 1
scanner-09.ch1.censys-scanner.com 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
79.124.62.106 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 24100.0%
TOTAL: 1 24100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 20
2pl.comp.pecet 4
TOTAL: 2 24