Daily Usenet report

Nov 16 04:15:01 -- Nov 17 04:15:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Nov 16 10:11:51 newsfeed nnrpd[26069]: SERVER perl filter not defined
Nov 16 15:58:14 newsfeed nnrpd[13068]: SERVER perl filter not defined
Nov 16 16:02:54 newsfeed overchan[1681]: input line too long, skipping
Nov 16 16:23:59 newsfeed nnrpd[16780]: SERVER perl filter not defined
Nov 16 16:34:59 newsfeed overchan[1681]: input line too long, skipping
Nov 16 16:37:53 newsfeed overchan[1681]: input line too long, skipping
Nov 16 17:32:10 newsfeed overchan[1681]: input line too long, skipping
Nov 16 17:56:31 newsfeed overchan[1681]: input line too long, skipping
Nov 16 18:14:31 newsfeed overchan[1681]: input line too long, skipping
Nov 16 22:34:28 newsfeed nnrpd[4959]: SERVER perl filter not defined
Nov 16 23:00:58 newsfeed nnrpd[9044]: unable to get certificate from '/etc/news/cert.pem'
Nov 16 23:00:58 newsfeed nnrpd[9044]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Nov 17 01:47:55 newsfeed nnrpd[1553]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 540467 89.9%59.2 MB 88.8%
innfeed 49105 8.2%5.8 MB 8.7%
innd 8487 1.4%1.3 MB 2.0%
nnrpd 3398 0.6%320.8 KB 0.5%
overchan 8 0.0%1.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 601466 100.0%66.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 536230 98.9%
Negative hits 5491 1.0%
Positive hits 207 0.0%
Cache misses 24 0.0%
TOTAL: 4 541952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.881 0.0%86 0.000 10.244 38.167
article cleanup00:00:02.837 0.0%540414 0.002 0.005 0.009
article logging00:00:09.673 0.0%540723 0.010 0.018 0.230
article parse00:07:10.756 0.5%107370188 0.003 0.004 0.006
article write00:03:30.826 0.2%540262 0.217 0.390 3.573
artlog/artcncl00:00:00.001 0.0%85 0.000 0.012 0.167
data move00:00:19.187 0.0%111777313 0.000 0.000 0.000
hisgrep/artcncl00:00:00.104 0.0%85 0.000 1.224 10.500
hishave/artcncl00:00:00.065 0.0%86 0.000 0.756 3.692
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:25:59.283 1.8%546045 0.110 2.856 31.882
history sync00:00:00.003 0.0%300 0.000 0.010 0.500
history write00:44:34.166 3.1%540400 0.344 4.948 54.801
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle21:54:44.309 91.3%107108693 0.299 0.736200189.000
nntp read00:11:57.703 0.8%107087610 0.006 0.007 0.009
overview write00:00:01.126 0.0%540262 0.000 0.002 0.004
perl filter00:24:02.656 1.7%540400 2.214 2.670 3.526
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:08.884 0.0%1092489 0.006 0.008 0.013
TOTAL: 24:00:07.82123:52:42.460 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.054 0.0%48958 0.000 0.001 0.008
article prepare00:00:00.001 0.0%9286 0.000 0.000 0.019
article read00:00:23.740 0.0%2322 0.000 10.224 1616.800
backlog stats00:00:00.044 0.0%114310 0.000 0.000 0.003
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.325 0.0%54484 0.000 0.006 0.043
data write00:00:00.847 0.0%42795 0.000 0.020 0.078
idle23:44:35.050 99.3%114310 360.181 747.748 8362.917
status file00:09:54.132 0.7%16811 0.275 35.342 1672.519
TOTAL: 23:54:56.53123:54:54.193100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.884 19.2%2798 0.000 11.038 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.050 0.0%5955 0.000 0.008 0.500
readart00:00:00.002 0.0%38 0.000 0.053 0.500
TOTAL: 00:02:41.09000:00:30.936 19.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 173 539978 539851 0 127 99%91:17:57
2news.icm.edu.pl 42 188 28 134 26 14%14:30:49
3localhost 1389 5 5 0 0 100%00:00:02
TOTAL: 3 1604 540171 539884 134 153 99%105:48:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl251.6 GB2.2 MB2.4 MB251.6 GB 99%488.6 KB
2news.icm.edu.pl1.4 MB0.0 KB642.3 KB2.0 MB 68%37.6 KB
3localhost9.4 KB0.0 KB0.0 KB9.4 KB100%1.9 KB
TOTAL: 3251.6 GB2.2 MB3.1 MB251.6 GB 99%488.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 16 04:15:01 - 04:59:59 21017 3.9% 7.798.6 GB 3.4%3352.67
Nov 16 05:00:00 - 05:59:59 26932 5.0% 7.4810.8 GB 4.3%3134.40
Nov 16 06:00:00 - 06:59:59 24993 4.6% 6.9410.1 GB 4.0%2952.92
Nov 16 07:00:00 - 07:59:59 25736 4.8% 7.1510.5 GB 4.2%3059.74
Nov 16 08:00:00 - 08:59:59 22614 4.2% 6.2811.0 GB 4.4%3197.38
Nov 16 09:00:00 - 09:59:59 22815 4.2% 6.3411.3 GB 4.5%3294.46
Nov 16 10:00:00 - 10:59:59 22277 4.1% 6.1911.6 GB 4.6%3381.19
Nov 16 11:00:00 - 11:59:59 22770 4.2% 6.3311.1 GB 4.4%3247.67
Nov 16 12:00:00 - 12:59:59 21236 3.9% 5.9010.0 GB 4.0%2911.05
Nov 16 13:00:00 - 13:59:59 28210 5.2% 7.8410.7 GB 4.3%3127.53
Nov 16 14:00:00 - 14:59:59 23025 4.3% 6.4010.9 GB 4.3%3176.28
Nov 16 15:00:00 - 15:59:59 20495 3.8% 5.6910.0 GB 4.0%2903.33
Nov 16 16:00:00 - 16:59:59 22015 4.1% 6.1210.4 GB 4.1%3022.19
Nov 16 17:00:00 - 17:59:59 19276 3.6% 5.358.6 GB 3.4%2495.20
Nov 16 18:00:00 - 18:59:59 23642 4.4% 6.5710.0 GB 4.0%2918.36
Nov 16 19:00:00 - 19:59:59 20211 3.7% 5.619.6 GB 3.8%2807.12
Nov 16 20:00:00 - 20:59:59 21850 4.0% 6.0710.8 GB 4.3%3158.28
Nov 16 21:00:00 - 21:59:59 17248 3.2% 4.798.8 GB 3.5%2556.52
Nov 16 22:00:00 - 22:59:59 16959 3.1% 4.718.2 GB 3.3%2390.71
Nov 16 23:00:00 - 23:59:59 20922 3.9% 5.819.9 GB 3.9%2881.03
Nov 17 00:00:00 - 00:59:59 25443 4.7% 7.0712.9 GB 5.1%3764.10
Nov 17 01:00:00 - 01:59:59 23289 4.3% 6.4712.1 GB 4.8%3517.57
Nov 17 02:00:00 - 02:59:59 20557 3.8% 5.7110.3 GB 4.1%3014.03
Nov 17 03:00:00 - 03:59:59 21071 3.9% 5.8510.9 GB 4.3%3178.35
Nov 17 04:00:00 - 04:15:01 5317 1.0% 5.902.6 GB 1.0%3066.11
TOTAL: 24:00:00 539920 100.0% 6.25251.9 GB 100.0%3057.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 436 99 0 15 13 0 0 0 309
2news.icm.edu.pl 26 0 0 0 0 0 0 0 26
TOTAL: 2 462 99 0 15 13 0 0 0 335

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 34
it.tlc.cellulari.android 23
alt.comp.software.seamonkey 15
comp.mobile.android 10
it.comp.os.win.windows10 6
comp.sys.raspberry-pi 4
alt.comp.software.firefox 2
nl.comp.os.linux.techniek 2
de.comp.lang.vbclassic 2
it.discussioni.energia 1
TOTAL: 10 99

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

GroupsCount
pl.praca.oferowana 7
pl.sci.matematyka 6
TOTAL: 2 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11
Scoring filter (10) 10
Binary in non-binary group 4
Too many newsgroups 1
TOTAL: 4 26

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19538 1373 10166 53 0 89 7%23:56:12
2panorama 38661 353 10425 95 3 38138 0%24:00:11
3okapi 0 0 0 0 0 952 0%23:58:05
4poznan 26 0 22 0 0 0 0%02:44:54
5nask 0 0 0 0 0 7856 0%23:58:05
TOTAL: 5 58225 1726 20613 148 3 47035 2%98:37:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.4 MB147.7 KB4.5 MB0.1 KB/s3.2 KB23:56:12
2panorama1.3 MB348.9 KB1.6 MB0.0 KB/s3.7 KB24:00:11
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:05
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:44:54
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:05
TOTAL: 55.6 MB496.6 KB6.1 MB0.0 KB/s3.3 KB98:37:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 285 3851.0 KB 16 0 000:01:35
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 290 3851.0 KB 16 5 000:02:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 290 3851.0 KB 16 5 000:01:36
2*.internet-census.org 8 00.0 KB 0 0 000:00:05
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
4unresolved 103 00.0 KB 0 0 000:00:58
TOTAL: 4 403 3851.0 KB 16 5 000:02:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.705 1.291 0.00000:01:35
212.51.192.185 0.157 0.436 0.00000:00:34
212.191.2.18 0.000 0.007 0.00000:00:19
sh-ams-nl-gp1-wk116.internet-census.org 0.015 0.026 0.00000:00:05
80.111.142.213 0.013 0.017 0.00000:00:02
43.130.11.228 0.000 0.006 0.00000:00:01
185.156.72.10 0.000 0.012 0.00000:00:01
scanner-07.ch1.censys-scanner.com 0.013 0.005 0.00000:00:00
isvcs01.man.lodz.pl 0.015 0.030 0.00000:00:00
TOTAL: 9 0.918 1.830 0.00000:02:41

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 95
sh-ams-nl-gp1-wk116.internet-census.org 8
80.111.142.213 4
scanner-07.ch1.censys-scanner.com 2
185.156.72.10 2
43.130.11.228 1
212.191.2.18 1
TOTAL: 7 113

NNRP unrecognized commands (by host):

SystemConn
sh-ams-nl-gp1-wk116.internet-census.org 14
43.130.11.228 4
185.156.72.10 2
scanner-07.ch1.censys-scanner.com 1
TOTAL: 4 21

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 2
GET / HTTP/1.1 2
#026#003#001 2
#003 2
SSH-2.0-Go 1
€.#001 1
Host: localhost 1
User-Agent: curl/7.64.1 1
EHLO www.censys.io 1
À#011À#010À(À'À#024À#023À#022 1
À$À#À 1
À#007À#021 1
Host: 212.191.2.21:119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
/\‚ø#002Q•Å÷:À0m#035/żâ”\ÛE7y8ÿ 1
Accept-Encoding: gzip 1
#001 1
TOTAL: 17 21

NNRP client timeouts [Top 20]:

SystemConnPeer
185.156.72.10 2 2
43.130.11.228 1 1
TOTAL: 2 3 4

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.pecet 22
2pl.comp.os.ms-windows.winnt 16
TOTAL: 2 38