Daily Usenet report

Dec 22 04:15:02 -- Dec 23 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Dec 22 05:08:23 newsfeed overchan[27656]: input line too long, skipping
Dec 22 08:30:05 newsfeed pgpverify[2679]: pgpverify: verification failed
Dec 22 08:30:48 newsfeed nnrpd[2813]: SERVER perl filter not defined
Dec 22 09:16:36 newsfeed pgpverify[9829]: pgpverify: verification failed
Dec 22 12:13:18 newsfeed nnrpd[4791]: SERVER perl filter not defined
Dec 22 16:36:52 newsfeed overchan[27656]: input line too long, skipping
Dec 22 16:58:32 newsfeed overchan[27656]: input line too long, skipping
Dec 22 17:07:12 newsfeed overchan[27656]: input line too long, skipping
Dec 22 18:46:22 newsfeed nnrpd[794]: SERVER perl filter not defined
Dec 22 19:10:41 newsfeed overchan[27656]: input line too long, skipping
Dec 22 19:32:48 newsfeed overchan[27656]: input line too long, skipping
Dec 22 19:54:01 newsfeed overchan[27656]: input line too long, skipping
Dec 22 20:59:56 newsfeed nnrpd[21347]: unable to get certificate from '/etc/news/cert.pem'
Dec 22 20:59:56 newsfeed nnrpd[21347]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Dec 22 21:05:27 newsfeed overchan[27656]: input line too long, skipping
Dec 22 21:09:30 newsfeed overchan[27656]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 820930 94.3%89.6 MB 93.6%
innfeed 34838 4.0%4.1 MB 4.3%
innd 10742 1.2%1.6 MB 1.7%
nnrpd 4210 0.5%423.7 KB 0.4%
controlchan 23 0.0%5.1 KB 0.0%
overchan 11 0.0%1.7 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 7 870756 100.0%95.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 816707 99.6%
Negative hits 2948 0.4%
Positive hits 189 0.0%
Cache misses 26 0.0%
TOTAL: 4 819870 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.120 0.0%67 0.000 16.716 128.000
article cleanup00:00:12.989 0.0%819434 0.011 0.016 0.023
article logging00:00:41.772 0.0%820019 0.041 0.051 0.064
article parse00:24:31.297 1.7%53288925 0.015 0.028 0.034
article write00:09:23.979 0.7%819203 0.233 0.688 1.062
artlog/artcncl00:00:00.000 0.0%66 0.000 0.000 0.000
data move00:01:03.419 0.1%58450508 0.001 0.001 0.001
hisgrep/artcncl00:00:00.171 0.0%67 0.000 2.552 18.000
hishave/artcncl00:00:00.009 0.0%67 0.000 0.134 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:18.680 0.6%822758 0.187 0.679 7.261
history sync00:00:00.033 0.0%290 0.000 0.114 1.000
history write00:08:48.638 0.6%819404 0.337 0.645 10.002
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle20:34:44.266 85.7%52615391 0.971 1.408 2.216
nntp read00:42:57.562 3.0%52920066 0.030 0.049 0.058
overview write00:00:04.784 0.0%819203 0.003 0.006 0.010
perl filter01:25:36.164 5.9%819404 3.838 6.268 8.344
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:48.728 0.1%1652778 0.024 0.029 0.035
TOTAL: 24:00:02.95323:38:13.611 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.127 0.0%44082 0.000 0.003 0.012
article prepare00:00:00.004 0.0%7426 0.000 0.001 0.062
article read00:00:15.331 0.0%1853 0.000 8.274 49.750
backlog stats00:00:00.121 0.0%111438 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.092 0.0%54867 0.000 0.020 0.047
data write00:00:02.987 0.0%40716 0.024 0.073 0.117
idle23:54:51.208 99.9%111438 495.183 772.548 1688.729
status file00:00:38.214 0.0%12478 0.828 3.063 222.097
TOTAL: 23:55:56.30523:55:49.084100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:39.986 76.2%3050 0.000 13.110 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.241 0.5%6709 0.000 0.036 0.500
readart00:00:00.001 0.0%20 0.000 0.050 0.500
TOTAL: 00:00:52.46000:00:40.228 76.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com001101
control@usenet-fr.news.eu.org001101
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 368 820297 820090 0 207 99%107:02:55
2news.icm.edu.pl 48 181 34 123 24 18%13:20:47
3localhost 1444 3 3 0 0 100%00:00:00
TOTAL: 3 1860 820481 820127 123 231 99%120:23:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl293.0 GB1.4 MB1.9 MB293.0 GB 99%374.6 KB
2news.icm.edu.pl1.5 MB62.0 KB610.6 KB2.2 MB 69%38.1 KB
3localhost4.2 KB0.0 KB0.0 KB4.2 KB100%1.4 KB
TOTAL: 3293.0 GB1.5 MB2.5 MB293.0 GB 99%374.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 22 04:15:02 - 04:59:59 14990 1.8% 5.567.4 GB 2.5%2890.74
Dec 22 05:00:00 - 05:59:59 19451 2.4% 5.409.8 GB 3.3%2852.14
Dec 22 06:00:00 - 06:59:59 22731 2.8% 6.3111.1 GB 3.8%3236.86
Dec 22 07:00:00 - 07:59:59 22458 2.7% 6.2411.2 GB 3.8%3265.81
Dec 22 08:00:00 - 08:59:59 25103 3.1% 6.9712.1 GB 4.1%3528.63
Dec 22 09:00:00 - 09:59:59 26540 3.2% 7.3712.1 GB 4.1%3511.98
Dec 22 10:00:00 - 10:59:59 24533 3.0% 6.8111.7 GB 4.0%3405.14
Dec 22 11:00:00 - 11:59:59 28742 3.5% 7.9812.3 GB 4.2%3594.89
Dec 22 12:00:00 - 12:59:59 29258 3.6% 8.1312.5 GB 4.2%3635.03
Dec 22 13:00:00 - 13:59:59 32388 3.9% 9.0012.1 GB 4.1%3519.12
Dec 22 14:00:00 - 14:59:59 31238 3.8% 8.6813.1 GB 4.4%3806.41
Dec 22 15:00:00 - 15:59:59 29951 3.7% 8.3213.1 GB 4.4%3806.66
Dec 22 16:00:00 - 16:59:59 34303 4.2% 9.5312.6 GB 4.3%3670.83
Dec 22 17:00:00 - 17:59:59 30738 3.7% 8.5410.7 GB 3.7%3125.20
Dec 22 18:00:00 - 18:59:59 37338 4.6% 10.3711.8 GB 4.0%3446.11
Dec 22 19:00:00 - 19:59:59 42482 5.2% 11.8012.5 GB 4.3%3642.03
Dec 22 20:00:00 - 20:59:59 131859 16.1% 36.6315.6 GB 5.3%4529.78
Dec 22 21:00:00 - 21:59:59 42730 5.2% 11.8712.7 GB 4.3%3703.69
Dec 22 22:00:00 - 22:59:59 33361 4.1% 9.2713.7 GB 4.7%4001.78
Dec 22 23:00:00 - 23:59:59 30255 3.7% 8.4013.2 GB 4.5%3833.97
Dec 23 00:00:00 - 00:59:59 31612 3.9% 8.7814.9 GB 5.1%4336.19
Dec 23 01:00:00 - 01:59:59 29263 3.6% 8.1312.0 GB 4.1%3507.64
Dec 23 02:00:00 - 02:59:59 31119 3.8% 8.6411.8 GB 4.0%3432.26
Dec 23 03:00:00 - 03:59:59 30384 3.7% 8.4411.0 GB 3.7%3200.05
Dec 23 04:00:00 - 04:15:02 7222 0.9% 8.012.7 GB 0.9%3173.95
TOTAL: 24:00:00 820049 100.0% 9.49293.7 GB 100.0%3564.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 791 172 0 27 8 0 0 0 584
2news.icm.edu.pl 24 0 0 3 0 0 0 0 21
TOTAL: 2 815 172 0 30 8 0 0 0 605

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 104
it.tlc.cellulari.android 34
it.comp.os.win.windows10 16
nl.comp.os.linux.techniek 6
comp.sys.raspberry-pi 4
comp.mobile.android 3
de.rec.sf.startrek 2
it.comp.os.linux.ubuntu 2
de.comp.lang.vbclassic 1
TOTAL: 9 172

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

GroupsCount
pl.sci.matematyka 7
pl.praca.oferowana 1
TOTAL: 2 8

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 22661 550 13208 74 0 2 2%24:09:54
2panorama 31819 499 10613 179 3 32870 1%23:59:57
3poznan 25 0 21 0 0 0 0%02:14:56
4nask 0 0 0 0 0 9176 0%24:05:31
5okapi 0 0 0 0 0 955 0%24:05:31
TOTAL: 5 54505 1049 23842 253 3 43003 1%98:35:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.1 MB7.6 MB9.7 MB0.1 KB/s15.9 KB24:09:54
2panorama1.4 MB1.1 MB2.4 MB0.0 KB/s3.7 KB23:59:57
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:14:56
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:31
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:31
TOTAL: 53.4 MB8.7 MB12.1 MB0.0 KB/s9.5 KB98:35:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2020.9 KB 10 0 000:00:20
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 2020.9 KB 10 3 000:00:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 2020.9 KB 10 3 000:00:25
2*.sfj.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 102 00.0 KB 0 0 000:00:25
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 4 684 2020.9 KB 10 3 000:00:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.696 3.480 0.00000:00:20
142.93.90.191 0.010 0.007 0.00000:00:10
192.241.213.56 0.000 0.017 0.00000:00:09
80.111.142.213 0.018 0.045 0.00000:00:04
mon.man.lodz.pl 1.642 3.357 0.00000:00:04
212.51.192.185 0.593 1.087 0.00000:00:01
scanner-08.ch1.censys-scanner.com 0.013 0.030 0.00000:00:00
isvcs01.man.lodz.pl 0.028 0.056 0.00000:00:00
worker-18.sfj.censys-scanner.com 0.006 0.011 0.00000:00:00
TOTAL: 9 4.006 8.090 0.00000:00:52

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scanner-08.ch1.censys-scanner.com 2
worker-18.sfj.censys-scanner.com 1
192.241.213.56 1
142.93.90.191 1
TOTAL: 7 393

NNRP unrecognized commands (by host):

SystemConn
scanner-08.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.censys-scanner.com 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 20100.0%
TOTAL: 1 20100.0%

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

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