Daily Usenet report

Jan 19 04:15:02 -- Jan 20 04:15:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jan 19 08:42:32 newsfeed nnrpd[5432]: SERVER perl filter not defined
Jan 19 10:06:48 newsfeed nnrpd[18623]: SERVER perl filter not defined
Jan 19 13:24:38 newsfeed nnrpd[16489]: SERVER perl filter not defined
Jan 19 13:26:08 newsfeed nnrpd[16902]: SERVER perl filter not defined
Jan 19 13:27:30 newsfeed nnrpd[17128]: SERVER perl filter not defined
Jan 19 14:34:09 newsfeed overchan[28448]: input line too long, skipping
Jan 19 19:09:12 newsfeed nnrpd[4811]: unable to get certificate from '/etc/news/cert.pem'
Jan 19 19:09:12 newsfeed nnrpd[4811]: 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 669393 91.7%73.0 MB 90.8%
innfeed 47326 6.5%5.6 MB 6.9%
innd 9045 1.2%1.4 MB 1.8%
nnrpd 4209 0.6%425.6 KB 0.5%
overchan 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 729976 100.0%80.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 666889 99.7%
Negative hits 1923 0.3%
Positive hits 259 0.0%
Cache misses 22 0.0%
TOTAL: 4 669093 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.989 0.0%85 0.000 11.635 191.000
article cleanup00:00:09.159 0.0%668735 0.009 0.014 0.019
article logging00:00:31.342 0.0%669329 0.039 0.047 0.062
article parse00:20:23.111 1.4%71144282 0.011 0.017 0.021
article write00:07:16.872 0.5%668537 0.419 0.653 0.981
artlog/artcncl00:00:00.000 0.0%84 0.000 0.000 0.000
data move00:00:55.548 0.1%75629822 0.001 0.001 0.001
hisgrep/artcncl00:00:00.105 0.0%83 0.000 1.265 19.000
hishave/artcncl00:00:00.023 0.0%85 0.000 0.271 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:16:26.695 1.1%671171 0.390 1.470 8.288
history sync00:00:00.034 0.0%293 0.000 0.116 1.000
history write00:20:43.305 1.4%668718 0.468 1.859 5.871
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle20:55:05.298 87.2%70917672 0.651 1.062 2.021
nntp read00:40:02.226 2.8%70875380 0.023 0.034 0.040
overview write00:00:03.293 0.0%668537 0.003 0.005 0.008
perl filter01:04:49.680 4.5%668718 3.969 5.817 8.075
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:35.726 0.0%1357536 0.021 0.026 0.031
TOTAL: 24:00:07.15323:47:03.406 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.162 0.0%63297 0.000 0.003 0.011
article prepare00:00:00.004 0.0%29482 0.000 0.000 0.001
article read00:00:15.359 0.0%7366 0.000 2.085 254.000
backlog stats00:00:00.122 0.0%158805 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.487 0.0%80791 0.003 0.018 0.039
data write00:00:03.633 0.0%60568 0.032 0.060 0.097
idle23:52:10.372 99.9%158805 81.878 541.106 1182.256
status file00:00:44.562 0.1%16836 0.600 2.647 96.324
TOTAL: 23:53:22.40623:53:15.701100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.293 61.6%3056 0.000 6.640 321.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.215 0.7%6702 0.000 0.032 1.211
readart00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:00:32.96900:00:20.508 62.2%----

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 116 668472 668352 0 120 99%70:11:52
2news.icm.edu.pl 47 303 24 201 78 7%17:19:13
3localhost 1446 5 5 0 0 100%00:00:00
TOTAL: 3 1609 668780 668381 201 198 99%87:31:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl262.4 GB815.0 KB1.1 MB262.4 GB 99%411.6 KB
2news.icm.edu.pl980.8 KB8.8 KB1.5 MB2.4 MB 39%24.5 KB
3localhost6.9 KB0.0 KB0.0 KB6.9 KB100%1.4 KB
TOTAL: 3262.4 GB823.8 KB2.6 MB262.4 GB 99%411.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 19 04:15:02 - 04:59:59 20539 3.1% 7.616.5 GB 2.5%2540.83
Jan 19 05:00:00 - 05:59:59 30896 4.6% 8.5810.9 GB 4.1%3163.90
Jan 19 06:00:00 - 06:59:59 33161 5.0% 9.2110.3 GB 3.9%2997.66
Jan 19 07:00:00 - 07:59:59 26168 3.9% 7.2711.1 GB 4.2%3220.49
Jan 19 08:00:00 - 08:59:59 23647 3.5% 6.5711.7 GB 4.5%3420.24
Jan 19 09:00:00 - 09:59:59 25767 3.9% 7.1612.2 GB 4.7%3567.98
Jan 19 10:00:00 - 10:59:59 23959 3.6% 6.6610.3 GB 3.9%3000.23
Jan 19 11:00:00 - 11:59:59 37514 5.6% 10.4211.2 GB 4.3%3273.99
Jan 19 12:00:00 - 12:59:59 35247 5.3% 9.7912.7 GB 4.8%3689.66
Jan 19 13:00:00 - 13:59:59 27133 4.1% 7.5412.2 GB 4.6%3564.19
Jan 19 14:00:00 - 14:59:59 23976 3.6% 6.6610.7 GB 4.1%3127.79
Jan 19 15:00:00 - 15:59:59 31271 4.7% 8.6911.9 GB 4.5%3469.38
Jan 19 16:00:00 - 16:59:59 28516 4.3% 7.9211.7 GB 4.4%3403.66
Jan 19 17:00:00 - 17:59:59 29497 4.4% 8.1911.6 GB 4.4%3373.74
Jan 19 18:00:00 - 18:59:59 24798 3.7% 6.8911.4 GB 4.3%3312.13
Jan 19 19:00:00 - 19:59:59 26811 4.0% 7.4510.4 GB 4.0%3035.85
Jan 19 20:00:00 - 20:59:59 24102 3.6% 6.7010.5 GB 4.0%3071.80
Jan 19 21:00:00 - 21:59:59 31542 4.7% 8.7611.2 GB 4.2%3253.79
Jan 19 22:00:00 - 22:59:59 30825 4.6% 8.5611.2 GB 4.3%3261.33
Jan 19 23:00:00 - 23:59:59 27891 4.2% 7.759.8 GB 3.7%2858.98
Jan 20 00:00:00 - 00:59:59 25357 3.8% 7.0410.2 GB 3.9%2967.26
Jan 20 01:00:00 - 01:59:59 23689 3.5% 6.5810.1 GB 3.8%2943.33
Jan 20 02:00:00 - 02:59:59 22733 3.4% 6.319.8 GB 3.7%2862.67
Jan 20 03:00:00 - 03:59:59 25229 3.8% 7.0110.4 GB 3.9%3024.19
Jan 20 04:00:00 - 04:15:03 8249 1.2% 9.143.0 GB 1.2%3537.00
TOTAL: 24:00:01 668517 100.0% 7.74263.2 GB 100.0%3193.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 713 97 0 16 4 0 0 0 596
2news.icm.edu.pl 79 0 0 1 0 0 0 0 78
TOTAL: 2 792 97 0 17 4 0 0 0 674

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 37
it.tlc.cellulari.android 29
comp.sys.raspberry-pi 15
comp.mobile.android 10
it.comp.os.win.windows10 5
nl.comp.os.linux.techniek 1
TOTAL: 6 97

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

GroupsCount
pl.praca.oferowana 2
pl.sci.matematyka 2
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 57
Scoring filter (10) 11
Scoring filter (11) 4
Too many newsgroups 3
Binary in non-binary group 2
Scoring filter (8) 2
Scoring filter (9) 1
TOTAL: 7 80

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 46281 579 16771 1040 1 45172 1%23:59:58
2icm 29751 247 15041 4992 0 1 0%23:59:58
3nask 0 0 0 0 0 9360 0%23:57:48
4poznan 19 0 18 0 0 0 0%02:36:31
5okapi 0 0 0 0 0 1053 0%23:57:48
TOTAL: 5 76051 826 31830 6032 1 55586 1%98:32:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.5 MB1.6 MB3.1 MB0.0 KB/s2.0 KB23:59:58
2icm868.5 KB40.9 MB41.7 MB0.5 KB/s8.2 KB23:59:58
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:36:31
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 52.4 MB42.5 MB44.9 MB0.1 KB/s6.7 KB98:32:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1213.0 KB 6 0 000:00:20
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 293 1213.0 KB 6 5 000:00:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 1213.0 KB 6 5 000:00:25
2unresolved 100 00.0 KB 0 0 000:00:04
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 684 1213.0 KB 6 5 000:00:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.616 2.600 0.00000:00:20
mon.man.lodz.pl 1.455 2.338 0.00000:00:04
80.111.142.213 0.026 0.032 0.00000:00:03
scanner-04.ch1.censys-scanner.com 0.003 0.017 0.00000:00:01
212.51.192.185 0.478 0.818 0.00000:00:01
scan-141.security.ipip.net 0.003 0.013 0.00000:00:00
isvcs01.man.lodz.pl 0.066 0.051 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.009 0.000 0.00000:00:00
TOTAL: 8 3.656 5.869 0.00000:00:32

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scanner-21.ch1.censys-scanner.com 1
scan-141.security.ipip.net 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 12
TOTAL: 1 12