Daily Usenet report

Oct 26 04:15:01 -- Oct 27 04:15:01

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Oct 26 09:23:45 newsfeed nnrpd[17501]: SERVER perl filter not defined
Oct 26 09:24:40 newsfeed nnrpd[17612]: SERVER perl filter not defined
Oct 26 12:31:55 newsfeed nnrpd[13257]: SERVER perl filter not defined
Oct 26 15:27:07 newsfeed nnrpd[7399]: unable to get certificate from '/etc/news/cert.pem'
Oct 26 15:27:07 newsfeed nnrpd[7399]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Oct 26 17:22:34 newsfeed overchan[2642]: input line too long, skipping
Oct 26 17:38:59 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:06:21 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:17:18 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:22:53 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:38:58 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:39:56 newsfeed overchan[2642]: input line too long, skipping
Oct 26 18:46:32 newsfeed overchan[2642]: input line too long, skipping
Oct 26 21:29:33 newsfeed overchan[2642]: input line too long, skipping
Oct 26 22:00:03 newsfeed pgpverify[3463]: pgpverify: verification failed
Oct 26 22:00:03 newsfeed controlchan[2640]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20211026200002$0ebe@isc.org>
Oct 26 22:00:03 newsfeed pgpverify[3471]: pgpverify: verification failed
Oct 26 22:00:03 newsfeed controlchan[2640]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20211026200002$3f78@isc.org>

Log entries by program:

Program nameLines%LinesSize%Size
inn 466258 89.0%51.0 MB 88.0%
innfeed 45966 8.8%5.4 MB 9.3%
innd 7996 1.5%1.2 MB 2.1%
nnrpd 3370 0.6%314.3 KB 0.5%
overchan 10 0.0%1.6 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 7 523605 100.0%57.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 462735 99.0%
Negative hits 4488 1.0%
Positive hits 261 0.1%
Cache misses 14 0.0%
TOTAL: 4 467498 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.522 0.0%60 0.000 8.700 170.000
article cleanup00:00:02.417 0.0%465619 0.002 0.005 0.010
article logging00:00:08.056 0.0%466071 0.010 0.017 0.026
article parse00:05:18.588 0.4%102726099 0.002 0.003 0.004
article write00:02:34.601 0.2%465349 0.186 0.332 0.560
artlog/artcncl00:00:00.002 0.0%59 0.000 0.034 0.500
data move00:00:17.784 0.0%106393224 0.000 0.000 0.000
hisgrep/artcncl00:00:00.094 0.0%59 0.000 1.593 15.667
hishave/artcncl00:00:00.036 0.0%60 0.000 0.600 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:20:53.476 1.5%470474 0.167 2.664 10.134
history sync00:00:00.009 0.0%290 0.000 0.031 1.000
history write00:03:37.364 0.3%465586 0.180 0.467 4.233
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:48:22.885 95.0%101783604 0.351 0.807 1.435
nntp read00:10:35.006 0.7%102416169 0.004 0.006 0.008
overview write00:00:01.145 0.0%465349 0.000 0.002 0.006
perl filter00:20:09.388 1.4%465586 1.823 2.598 3.627
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.651 0.0%942837 0.005 0.008 0.013
TOTAL: 24:00:00.92223:52:09.024 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%53463 0.000 0.001 0.008
article prepare00:00:00.000 0.0%14222 0.000 0.000 0.000
article read00:00:14.097 0.0%3551 0.000 3.970 40.364
backlog stats00:00:00.050 0.0%124139 0.000 0.000 0.006
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.355 0.0%59452 0.000 0.006 0.038
data write00:00:00.785 0.0%47616 0.000 0.016 0.042
idle23:54:08.850 99.9%124139 63.817 693.165 1386.240
status file00:00:32.803 0.0%16301 0.000 2.012 124.081
TOTAL: 23:54:59.53223:54:56.997100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:23:15.124 99.7%2807 0.000 497.016462990.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.044 0.0%6024 0.000 0.007 0.500
readart00:00:00.001 0.0%62 0.000 0.016 0.500
TOTAL: 00:23:19.50000:23:15.169 99.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 128 465867 465606 1 260 99%77:24:43
2news.icm.edu.pl 44 249 54 184 11 21%17:51:28
3localhost 1444 3 3 0 0 100%00:00:00
TOTAL: 3 1616 466119 465663 185 271 99%95:16:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl213.8 GB2.6 MB3.3 MB213.8 GB 99%481.1 KB
2news.icm.edu.pl2.8 MB0.0 KB285.7 KB3.1 MB 90%48.8 KB
3localhost5.0 KB0.0 KB0.0 KB5.0 KB100%1.7 KB
TOTAL: 3213.8 GB2.6 MB3.5 MB213.8 GB 99%481.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 26 04:15:01 - 04:59:59 15146 3.3% 5.618.0 GB 3.7%3106.21
Oct 26 05:00:00 - 05:59:59 20825 4.5% 5.7811.1 GB 5.2%3240.44
Oct 26 06:00:00 - 06:59:59 16229 3.5% 4.516.8 GB 3.2%1978.13
Oct 26 07:00:00 - 07:59:59 15450 3.3% 4.296.3 GB 3.0%1842.99
Oct 26 08:00:00 - 08:59:59 14313 3.1% 3.986.2 GB 2.9%1812.81
Oct 26 09:00:00 - 09:59:59 18757 4.0% 5.217.0 GB 3.3%2035.38
Oct 26 10:00:00 - 10:59:59 20395 4.4% 5.677.8 GB 3.6%2265.18
Oct 26 11:00:00 - 11:59:59 15018 3.2% 4.176.2 GB 2.9%1808.45
Oct 26 12:00:00 - 12:59:59 17793 3.8% 4.947.1 GB 3.3%2074.54
Oct 26 13:00:00 - 13:59:59 24559 5.3% 6.8211.4 GB 5.3%3327.77
Oct 26 14:00:00 - 14:59:59 21799 4.7% 6.0610.3 GB 4.8%3006.71
Oct 26 15:00:00 - 15:59:59 20059 4.3% 5.578.0 GB 3.7%2326.46
Oct 26 16:00:00 - 16:59:59 15507 3.3% 4.316.4 GB 3.0%1866.07
Oct 26 17:00:00 - 17:59:59 14076 3.0% 3.916.4 GB 3.0%1849.79
Oct 26 18:00:00 - 18:59:59 15810 3.4% 4.396.3 GB 2.9%1833.16
Oct 26 19:00:00 - 19:59:59 14049 3.0% 3.906.3 GB 2.9%1832.13
Oct 26 20:00:00 - 20:59:59 17974 3.9% 4.998.2 GB 3.8%2397.66
Oct 26 21:00:00 - 21:59:59 26317 5.7% 7.3113.2 GB 6.2%3840.03
Oct 26 22:00:00 - 22:59:59 25759 5.5% 7.1612.4 GB 5.8%3615.69
Oct 26 23:00:00 - 23:59:59 19677 4.2% 5.478.7 GB 4.1%2540.96
Oct 27 00:00:00 - 00:59:59 21262 4.6% 5.9110.2 GB 4.8%2981.82
Oct 27 01:00:00 - 01:59:59 25943 5.6% 7.2112.8 GB 6.0%3725.33
Oct 27 02:00:00 - 02:59:59 20772 4.5% 5.7711.5 GB 5.4%3345.31
Oct 27 03:00:00 - 03:59:59 22208 4.8% 6.1712.0 GB 5.6%3492.91
Oct 27 04:00:00 - 04:15:01 5780 1.2% 6.423.1 GB 1.5%3631.99
TOTAL: 24:00:00 465477 100.0% 5.39213.8 GB 100.0%2594.90
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 712 222 0 33 4 0 0 0 453
2news.icm.edu.pl 10 0 0 0 0 0 0 0 10
TOTAL: 2 722 222 0 33 4 0 0 0 463

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 85
comp.mobile.android 62
it.tlc.cellulari.android 31
it.comp.os.win.windows10 16
alt.comp.software.seamonkey 10
alt.comp.software.firefox 7
it.comp.os.win.windows7 6
de.comp.os.os2 2
de.rec.sf.startrek 2
it.discussioni.energia 1
TOTAL: 10 222

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 6
EMP (md5) 5
TOTAL: 2 11

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 20029 1141 10481 112 0 0 5%23:51:59
2panorama 44314 747 15448 1068 3 36210 1%23:58:43
3okapi 0 0 0 0 0 1108 0%23:57:48
4nask 0 0 0 0 0 8159 0%23:50:02
5poznan 37 0 27 0 0 0 0%03:14:54
TOTAL: 5 64380 1888 25956 1180 3 45477 2%98:53:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.6 MB12.8 MB16.4 MB0.2 KB/s13.4 KB23:51:59
2panorama2.4 MB4.8 MB7.3 MB0.1 KB/s4.1 KB23:58:43
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:14:54
TOTAL: 56.0 MB17.6 MB23.7 MB0.1 KB/s7.9 KB98:53:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6282.4 KB 27 0 000:00:06
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 6282.4 KB 27 3 000:23:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 291 6282.4 KB 27 3 000:00:06
2unresolved 102 00.0 KB 0 0 000:23:12
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 394 6282.4 KB 27 3 000:23:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
81.190.42.4 0.024 0.006 0.00000:23:09
web.man.lodz.pl 0.678 1.116 0.00000:00:06
80.111.142.213 0.006 0.019 0.00000:00:02
212.51.192.185 0.198 0.380 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.002 0.004 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.025 0.00000:00:00
146.0.77.172 0.005 0.000 0.00000:00:00
TOTAL: 7 0.925 1.550 0.00000:23:19

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
146.0.77.172 1
scanner-06.ch1.censys-scanner.com 1
81.190.42.4 1
TOTAL: 5 103

NNRP unrecognized commands (by host):

SystemConn
scanner-06.ch1.censys-scanner.com 1
146.0.77.172 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
#003 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
146.0.77.172 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 62100.0%
TOTAL: 1 62100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 56
2pl.comp.pecet 6
TOTAL: 2 62