Daily Usenet report

Sep 23 04:15:02 -- Sep 24 04:15:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Sep 23 08:24:48 newsfeed nnrpd[6992]: SERVER perl filter not defined
Sep 23 12:41:46 newsfeed overchan[1447]: input line too long, skipping
Sep 23 14:53:00 newsfeed nnrpd[357]: SERVER perl filter not defined
Sep 23 16:29:25 newsfeed overchan[1447]: input line too long, skipping
Sep 23 16:44:53 newsfeed overchan[1447]: input line too long, skipping
Sep 23 16:46:45 newsfeed overchan[1447]: input line too long, skipping
Sep 23 16:50:50 newsfeed overchan[1447]: input line too long, skipping
Sep 23 16:53:50 newsfeed overchan[1447]: input line too long, skipping
Sep 23 16:56:57 newsfeed overchan[1447]: input line too long, skipping
Sep 23 17:08:38 newsfeed overchan[1447]: input line too long, skipping
Sep 23 20:33:56 newsfeed overchan[1447]: input line too long, skipping
Sep 23 21:35:02 newsfeed nnrpd[28641]: unable to get certificate from '/etc/news/cert.pem'
Sep 23 21:35:02 newsfeed nnrpd[28641]: 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 471649 92.5%52.0 MB 91.7%
innfeed 26357 5.2%3.1 MB 5.5%
innd 8689 1.7%1.3 MB 2.3%
nnrpd 3431 0.7%322.4 KB 0.6%
overchan 10 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 510137 100.0%56.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 469088 99.2%
Negative hits 3486 0.7%
Positive hits 317 0.1%
Cache misses 38 0.0%
TOTAL: 4 472929 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.157 0.0%77 0.000 15.026 138.000
article cleanup00:00:03.427 0.0%470428 0.005 0.007 0.011
article logging00:00:10.030 0.0%470873 0.012 0.021 0.029
article parse00:06:54.994 0.5%119768128 0.003 0.003 0.006
article write00:03:19.932 0.2%470223 0.298 0.425 1.750
artlog/artcncl00:00:00.001 0.0%77 0.000 0.013 0.500
data move00:00:34.400 0.0%123651227 0.000 0.000 0.000
hisgrep/artcncl00:00:00.166 0.0%76 0.000 2.184 13.000
hishave/artcncl00:00:00.066 0.0%77 0.000 0.857 4.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:33:39.587 2.3%474234 0.696 4.259 15.009
history sync00:00:00.005 0.0%291 0.000 0.017 0.500
history write00:26:58.737 1.9%470401 1.164 3.441 18.224
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle21:51:08.972 91.1%113011873 0.535 0.696 1.497
nntp read00:20:46.364 1.4%119441536 0.007 0.010 0.015
overview write00:00:01.301 0.0%470223 0.001 0.003 0.006
perl filter00:28:13.709 2.0%470401 2.860 3.601 4.188
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:10.674 0.0%952922 0.008 0.011 0.015
TOTAL: 24:00:01.39523:52:03.522 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%36556 0.000 0.001 0.016
article prepare00:00:00.000 0.0%744 0.000 0.000 0.000
article read00:00:01.336 0.0%185 0.000 7.222 165.000
backlog stats00:00:00.050 0.0%92306 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.356 0.0%45245 0.000 0.008 0.022
data write00:00:00.902 0.0%32905 0.000 0.027 0.075
idle23:55:48.473100.0%92306 605.213 933.292 3847.191
status file00:00:22.748 0.0%8519 0.000 2.670 114.967
TOTAL: 23:56:16.87423:56:13.910100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:44.137 95.1%2845 0.000 36.604 22006.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.060 0.1%6286 0.000 0.010 0.500
readart00:00:00.080 0.1%76 0.000 1.053 9.000
TOTAL: 00:01:49.53400:01:44.277 95.2%----

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 283 471154 470978 1 175 99%125:06:53
2news.icm.edu.pl 53 306 27 249 30 8%18:28:06
3localhost 1444 2 2 0 0 100%00:00:00
TOTAL: 3 1780 471462 471007 250 205 99%143:34:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl234.0 GB1.9 MB2.2 MB234.0 GB 99%520.7 KB
2news.icm.edu.pl1.8 MB0.0 KB881.5 KB2.6 MB 67%47.2 KB
3localhost3.4 KB0.0 KB0.0 KB3.4 KB100%1.7 KB
TOTAL: 3234.0 GB1.9 MB3.1 MB234.0 GB 99%520.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 23 04:15:02 - 04:59:59 8805 1.9% 3.264.4 GB 1.9%1692.50
Sep 23 05:00:00 - 05:59:59 15976 3.4% 4.448.7 GB 3.7%2526.14
Sep 23 06:00:00 - 06:59:59 24194 5.1% 6.7210.6 GB 4.5%3075.08
Sep 23 07:00:00 - 07:59:59 19197 4.1% 5.3310.5 GB 4.5%3050.97
Sep 23 08:00:00 - 08:59:59 18419 3.9% 5.129.8 GB 4.2%2861.08
Sep 23 09:00:00 - 09:59:59 18516 3.9% 5.149.7 GB 4.1%2813.04
Sep 23 10:00:00 - 10:59:59 16734 3.6% 4.657.8 GB 3.3%2272.03
Sep 23 11:00:00 - 11:59:59 15011 3.2% 4.177.3 GB 3.1%2131.87
Sep 23 12:00:00 - 12:59:59 17637 3.7% 4.909.1 GB 3.9%2664.01
Sep 23 13:00:00 - 13:59:59 18757 4.0% 5.219.7 GB 4.1%2816.44
Sep 23 14:00:00 - 14:59:59 23003 4.9% 6.3911.5 GB 4.9%3342.32
Sep 23 15:00:00 - 15:59:59 23200 4.9% 6.4411.4 GB 4.9%3330.46
Sep 23 16:00:00 - 16:59:59 23669 5.0% 6.5711.7 GB 5.0%3420.01
Sep 23 17:00:00 - 17:59:59 21957 4.7% 6.1010.4 GB 4.4%3021.58
Sep 23 18:00:00 - 18:59:59 19581 4.2% 5.449.4 GB 4.0%2750.53
Sep 23 19:00:00 - 19:59:59 19143 4.1% 5.329.5 GB 4.0%2758.93
Sep 23 20:00:00 - 20:59:59 20199 4.3% 5.6110.0 GB 4.3%2902.01
Sep 23 21:00:00 - 21:59:59 19309 4.1% 5.369.4 GB 4.0%2744.52
Sep 23 22:00:00 - 22:59:59 18815 4.0% 5.239.6 GB 4.1%2795.03
Sep 23 23:00:00 - 23:59:59 21106 4.5% 5.8610.4 GB 4.4%3024.97
Sep 24 00:00:00 - 00:59:59 22313 4.7% 6.2010.9 GB 4.7%3174.61
Sep 24 01:00:00 - 01:59:59 20262 4.3% 5.6310.6 GB 4.5%3090.44
Sep 24 02:00:00 - 02:59:59 19112 4.1% 5.319.5 GB 4.0%2757.99
Sep 24 03:00:00 - 03:59:59 20338 4.3% 5.659.7 GB 4.1%2821.94
Sep 24 04:00:00 - 04:15:01 5670 1.2% 6.292.6 GB 1.1%2994.82
TOTAL: 23:59:59 470923 100.0% 5.45234.0 GB 100.0%2840.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 619 141 0 27 7 0 0 0 444
2news.icm.edu.pl 30 0 0 0 0 0 0 0 30
TOTAL: 2 649 141 0 27 7 0 0 0 474

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 88
it.comp.os.win.windows10 22
alt.comp.software.firefox 16
it.comp.os.linux.ubuntu 4
de.comp.lang.vbclassic 3
it.tlc.cellulari.android 3
comp.mobile.android 3
alt.comp.software.seamonkey 1
de.comm.software.mailreader 1
TOTAL: 9 141

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

GroupsCount
pl.praca.oferowana 7
TOTAL: 1 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 23
Binary in non-binary group 6
Too many newsgroups 1
TOTAL: 3 30

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19894 113 12028 5 0 2 0%24:04:27
2panorama 24412 0 10464 33 0 26145 0%24:02:19
3poznan 32 0 22 0 0 0 0%03:19:46
4okapi 0 0 0 0 0 950 0%24:00:10
5nask 0 0 0 0 0 8383 0%24:00:10
TOTAL: 5 44338 113 22514 38 0 35480 0%99:26:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm454.8 KB15.1 KB469.9 KB0.0 KB/s4.0 KB24:04:27
2panorama0.0 KB157.7 KB157.7 KB0.0 KB/s4.8 KB24:02:19
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:19:46
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:10
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:10
TOTAL: 5454.8 KB172.8 KB627.6 KB0.0 KB/s4.2 KB99:26:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6056.4 KB 22 0 000:00:10
2212.90.61.180 3 1322.7 KB 2 0 000:00:04
3195.164.146.186 2 11.7 KB 1 0 000:01:29
4isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 4 295 7480.9 KB 25 2 000:01:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 290 6056.4 KB 22 2 000:00:10
2unresolved 112 1424.4 KB 3 0 000:01:38
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 403 7480.9 KB 25 2 000:01:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195.164.146.186 0.005 0.009 0.00000:01:29
web.man.lodz.pl 0.965 1.158 0.00000:00:10
212.90.61.180 0.048 0.017 0.00000:00:04
80.111.142.213 0.010 0.023 0.00000:00:02
159.203.23.81 0.016 0.028 0.00000:00:01
212.51.192.185 0.258 0.358 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.009 0.000 0.00000:00:00
isvcs01.man.lodz.pl 0.011 0.010 0.00000:00:00
TOTAL: 8 1.322 1.603 0.00000:01:49

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
159.203.23.81 7
80.111.142.213 4
scanner-26.ch1.censys-scanner.com 1
TOTAL: 4 108

NNRP unrecognized commands (by host):

SystemConn
159.203.23.81 36
scanner-26.ch1.censys-scanner.com 1
TOTAL: 2 37

NNRP unrecognized commands (by command):

CommandCount
Connection: keep-alive 6
Accept: */* 6
Accept-Encoding: gzip, deflate 6
Host: 212.191.2.21:119 6
User-Agent: Mozilla/5.0 (Windows NT 10.0... 5
GET /system_api.php HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
User-Agent: Roku/DVP-9.10 (289.10E04111A... 1
EHLO www.censys.io 1
GET /flu/403.html HTTP/1.1 1
GET /streaming/clients_live.php HTTP/1.1 1
GET /c/version.js HTTP/1.1 1
TOTAL: 13 37

Newsgroup request counts (by category):

CategoryCountPct
1pl 60 81.1%
2lodman 14 18.9%
TOTAL: 2 74100.0%

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

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