Daily Usenet report

Jun 3 04:15:02 -- Jun 4 04:15:11

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Jun 3 06:31:16 newsfeed overchan[17089]: input line too long, skipping
Jun 3 08:33:12 newsfeed nnrpd[25781]: SERVER perl filter not defined
Jun 3 13:26:43 newsfeed overchan[17089]: input line too long, skipping
Jun 3 13:49:18 newsfeed nnrpd[9947]: SERVER perl filter not defined
Jun 3 13:50:09 newsfeed nnrpd[10153]: SERVER perl filter not defined
Jun 3 17:11:09 newsfeed overchan[17089]: input line too long, skipping
Jun 3 17:13:14 newsfeed overchan[17089]: input line too long, skipping
Jun 3 17:20:53 newsfeed overchan[17089]: input line too long, skipping
Jun 3 17:23:39 newsfeed overchan[17089]: input line too long, skipping
Jun 3 18:37:25 newsfeed overchan[17089]: input line too long, skipping
Jun 3 19:07:40 newsfeed overchan[17089]: input line too long, skipping
Jun 3 19:10:55 newsfeed overchan[17089]: input line too long, skipping
Jun 3 19:14:58 newsfeed overchan[17089]: input line too long, skipping
Jun 3 19:36:21 newsfeed overchan[17089]: input line too long, skipping
Jun 3 19:54:35 newsfeed overchan[17089]: input line too long, skipping
Jun 3 20:09:33 newsfeed overchan[17089]: input line too long, skipping
Jun 3 21:39:51 newsfeed nnrpd[18041]: SERVER perl filter not defined
Jun 3 21:43:41 newsfeed nnrpd[18578]: SERVER perl filter not defined
Jun 4 01:15:44 newsfeed nnrpd[19131]: SERVER perl filter not defined
Jun 4 03:22:49 newsfeed nnrpd[6393]: unable to get certificate from '/etc/news/cert.pem'
Jun 4 03:22:49 newsfeed nnrpd[6393]: 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 679775 97.8%73.6 MB 97.5%
innd 9439 1.4%1.3 MB 1.7%
nnrpd 4294 0.6%422.2 KB 0.5%
innfeed 1392 0.2%179.5 KB 0.2%
overchan 14 0.0%2.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 694915 100.0%75.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 677677 99.1%
Negative hits 5956 0.9%
Positive hits 302 0.0%
Cache misses 43 0.0%
TOTAL: 4 683978 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.185 0.0%59 0.000 20.085 58.000
article cleanup00:00:09.346 0.0%678954 0.008 0.014 0.019
article logging00:00:45.476 0.1%679295 0.038 0.067 2.346
article parse00:18:28.042 1.3%33611925 0.022 0.033 0.052
article write00:11:04.924 0.8%678736 0.382 0.980 31.549
artlog/artcncl00:00:00.002 0.0%59 0.000 0.034 1.000
data move00:00:37.363 0.0%38012652 0.001 0.001 0.003
hisgrep/artcncl00:00:00.476 0.0%59 0.000 8.068 23.429
hishave/artcncl00:00:00.122 0.0%59 0.000 2.068 8.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:24:59.567 5.9%685291 0.416 7.441 444.271
history sync00:00:00.024 0.0%290 0.000 0.083 0.500
history write01:44:45.771 7.3%678881 0.649 9.259 404.835
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle18:36:19.371 77.5%32473456 0.297 2.063 2.964
nntp read00:24:37.927 1.7%33233161 0.032 0.044 0.069
overview write00:00:04.016 0.0%678736 0.003 0.006 0.011
perl filter01:08:19.136 4.7%678881 3.036 6.038 8.452
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:39.039 0.0%1383585 0.021 0.028 0.038
TOTAL: 24:00:12.16823:50:51.787 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.123 0.0%26048 0.000 0.005 0.029
article prepare00:00:00.002 0.0%7400 0.000 0.000 0.042
article read00:00:00.109 0.0%1850 0.000 0.059 0.333
backlog stats00:00:00.085 0.0%128220 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.309 0.0%68126 0.000 0.019 0.062
data write00:00:02.786 0.0%42270 0.031 0.066 0.132
idle23:50:27.312 99.7%128220 407.356 669.375 3947.759
status file00:03:41.665 0.3%358 0.000 619.176 31297.000
TOTAL: 23:55:10.98223:54:13.391 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.066 52.3%3086 0.000 9.095 705.111
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.249 0.5%6855 0.000 0.036 0.500
readart00:00:00.001 0.0%20 0.000 0.050 0.500
TOTAL: 00:00:53.70000:00:28.316 52.7%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 213 679363 679167 1 195 99%96:04:14
2news.icm.edu.pl 45 348 75 250 23 21%17:12:54
3localhost 1447 6 6 0 0 100%00:00:27
TOTAL: 3 1705 679717 679248 251 218 99%113:17:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl274.3 GB3.3 MB3.6 MB274.3 GB 99%423.3 KB
2news.icm.edu.pl2.8 MB143.6 KB489.8 KB3.4 MB 81%35.5 KB
3localhost8.6 KB0.0 KB0.0 KB8.6 KB100%1.4 KB
TOTAL: 3274.3 GB3.4 MB4.1 MB274.3 GB 99%423.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 3 04:15:02 - 04:59:59 17881 2.6% 6.638.6 GB 3.1%3347.53
Jun 3 05:00:00 - 05:59:59 24579 3.6% 6.8311.2 GB 4.1%3252.77
Jun 3 06:00:00 - 06:59:59 24354 3.6% 6.7611.3 GB 4.1%3303.85
Jun 3 07:00:00 - 07:59:59 17597 2.6% 4.897.9 GB 2.9%2308.20
Jun 3 08:00:00 - 08:59:59 22758 3.4% 6.3210.8 GB 3.9%3155.46
Jun 3 09:00:00 - 09:59:59 22787 3.4% 6.3310.3 GB 3.8%3004.13
Jun 3 10:00:00 - 10:59:59 24746 3.6% 6.8710.8 GB 3.9%3145.12
Jun 3 11:00:00 - 11:59:59 27572 4.1% 7.6612.6 GB 4.6%3658.87
Jun 3 12:00:00 - 12:59:59 28680 4.2% 7.9713.0 GB 4.7%3779.25
Jun 3 13:00:00 - 13:59:59 27712 4.1% 7.7012.6 GB 4.6%3665.19
Jun 3 14:00:00 - 14:59:59 29648 4.4% 8.2412.5 GB 4.5%3641.09
Jun 3 15:00:00 - 15:59:59 34437 5.1% 9.5711.7 GB 4.3%3420.19
Jun 3 16:00:00 - 16:59:59 35683 5.3% 9.9111.9 GB 4.3%3470.94
Jun 3 17:00:00 - 17:59:59 30441 4.5% 8.4612.0 GB 4.4%3488.56
Jun 3 18:00:00 - 18:59:59 29953 4.4% 8.3211.5 GB 4.2%3354.34
Jun 3 19:00:00 - 19:59:59 34893 5.1% 9.6913.3 GB 4.9%3885.11
Jun 3 20:00:00 - 20:59:59 38784 5.7% 10.7712.1 GB 4.4%3522.39
Jun 3 21:00:00 - 21:59:59 32561 4.8% 9.0413.5 GB 4.9%3917.77
Jun 3 22:00:00 - 22:59:59 28594 4.2% 7.9413.4 GB 4.9%3906.07
Jun 3 23:00:00 - 23:59:59 24402 3.6% 6.7811.9 GB 4.3%3470.81
Jun 4 00:00:00 - 00:59:59 22309 3.3% 6.2010.8 GB 3.9%3135.40
Jun 4 01:00:00 - 01:59:59 26169 3.9% 7.2713.0 GB 4.7%3785.09
Jun 4 02:00:00 - 02:59:59 28301 4.2% 7.869.0 GB 3.3%2607.35
Jun 4 03:00:00 - 03:59:59 34772 5.1% 9.667.5 GB 2.7%2174.20
Jun 4 04:00:00 - 04:15:11 9544 1.4% 10.481.8 GB 0.7%2111.80
TOTAL: 24:00:09 679157 100.0% 7.86275.0 GB 100.0%3336.96
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 536 124 0 67 4 0 0 0 341
2news.icm.edu.pl 23 0 0 6 0 0 0 0 17
TOTAL: 2 559 124 0 73 4 0 0 0 358

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 58
it.tlc.cellulari.android 26
alt.comp.software.firefox 13
it.comp.os.win.windows10 11
alt.comp.software.seamonkey 6
de.rec.sf.startrek 5
comp.mobile.android 3
de.comp.office-pakete.ms-office.outlook 1
comp.sys.raspberry-pi 1
TOTAL: 9 124

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12
Binary in non-binary group 2
Too many newsgroups 2
HTML post 1
TOTAL: 4 17

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 40378 1811 23771 40 0 1 4%23:51:27
2nask 0 0 0 0 0 22211 0%23:58:52
3poznan 39 0 29 0 0 0 0%03:59:29
4okapi 0 0 0 0 0 492 0%23:58:52
5panorama 0 0 0 0 0 26125 0%24:01:00
TOTAL: 5 40417 1811 23800 40 0 48829 4%99:49:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.4 MB106.0 KB4.5 MB0.1 KB/s2.5 KB23:51:27
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:52
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:59:29
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:52
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:01:00
TOTAL: 54.4 MB106.0 KB4.5 MB0.0 KB/s2.5 KB99:49:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2017.7 KB 10 0 000:00:39
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 294 2017.7 KB 10 6 000:00:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 582 2017.7 KB 10 6 000:00:44
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 109 00.0 KB 0 0 000:00:08
TOTAL: 3 692 2017.7 KB 10 6 000:00:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.913 3.702 0.00000:00:39
80.111.142.213 0.026 0.036 0.00000:00:05
mon.man.lodz.pl 1.576 2.998 0.00000:00:03
212.51.192.185 0.567 0.921 0.00000:00:02
143.198.162.199 0.064 0.085 0.00000:00:01
isvcs01.man.lodz.pl 0.038 0.071 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.017 0.005 0.00000:00:00
TOTAL: 7 4.201 7.818 0.00000:00:53

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
143.198.162.199 9
80.111.142.213 4
scanner-06.ch1.censys-scanner.com 1
TOTAL: 5 398

NNRP unrecognized commands (by host):

SystemConn
143.198.162.199 48
scanner-06.ch1.censys-scanner.com 1
TOTAL: 2 49

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 8
Connection: keep-alive 8
Accept-Encoding: gzip, deflate 8
Accept: */* 8
User-Agent: Mozilla/5.0 (Windows NT 10.0... 7
GET /system_api.php HTTP/1.1 2
EHLO www.censys.io 1
GET /streaming/clients_live.php HTTP/1.1 1
User-Agent: AlexaMediaPlayer/2.1.4676.0 ... 1
GET /stream/live.php HTTP/1.1 1
GET /c/version.js HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
GET /client_area/ HTTP/1.1 1
GET /stalker_portal/c/ HTTP/1.1 1
TOTAL: 14 49

Newsgroup request counts (by category):

CategoryCountPct
1pl 20100.0%
TOTAL: 1 20100.0%

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

NewsgroupCount
1pl.comp.pecet 14
2pl.comp.os.ms-windows.winnt 6
TOTAL: 2 20