Daily Usenet report

Feb 28 04:15:01 -- Mar 1 04:15:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Feb 28 07:27:58 newsfeed nnrpd[11664]: SERVER perl filter not defined
Feb 28 07:28:50 newsfeed nnrpd[11917]: SERVER perl filter not defined
Feb 28 09:15:54 newsfeed nnrpd[28254]: SERVER perl filter not defined
Feb 28 10:21:18 newsfeed overchan[14626]: input line too long, skipping
Feb 28 10:43:04 newsfeed nnrpd[9460]: unable to get certificate from '/etc/news/cert.pem'
Feb 28 10:43:04 newsfeed nnrpd[9460]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Feb 28 15:31:34 newsfeed overchan[14626]: input line too long, skipping
Feb 28 15:48:46 newsfeed overchan[14626]: input line too long, skipping
Feb 28 15:50:33 newsfeed overchan[14626]: input line too long, skipping
Feb 28 15:55:01 newsfeed overchan[14626]: input line too long, skipping
Feb 28 15:56:30 newsfeed overchan[14626]: input line too long, skipping
Feb 28 19:34:19 newsfeed overchan[14626]: input line too long, skipping
Feb 28 19:36:29 newsfeed overchan[14626]: input line too long, skipping
Feb 28 19:38:56 newsfeed overchan[14626]: input line too long, skipping
Feb 28 20:34:29 newsfeed nnrpd[32271]: SERVER perl filter not defined
Mar 1 01:04:03 newsfeed pgpverify[7917]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 670776 94.3%75.1 MB 93.8%
innfeed 27743 3.9%3.2 MB 4.1%
innd 9218 1.3%1.4 MB 1.8%
nnrpd 3397 0.5%318.6 KB 0.4%
controlchan 12 0.0%2.7 KB 0.0%
overchan 10 0.0%1.8 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 711157 100.0%80.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 666768 99.4%
Negative hits 2907 0.4%
Cache misses 558 0.1%
Positive hits 234 0.0%
TOTAL: 4 670467 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:19.024 0.0%624 0.000 30.487 69.500
article cleanup00:00:03.626 0.0%670314 0.003 0.005 0.011
article logging00:00:12.201 0.0%670670 0.014 0.018 0.025
article parse00:06:48.906 0.5%116471377 0.003 0.004 0.005
article write00:03:13.425 0.2%670163 0.158 0.289 0.418
artlog/artcncl00:00:00.007 0.0%618 0.000 0.011 0.018
data move00:00:24.352 0.0%121444279 0.000 0.000 0.000
hisgrep/artcncl00:00:08.359 0.0%611 0.000 13.681 23.000
hishave/artcncl00:00:00.403 0.0%624 0.000 0.646 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:44.477 0.9%673751 0.283 1.135 5.148
history sync00:00:00.007 0.0%292 0.000 0.024 0.500
history write00:18:32.535 1.3%670304 0.520 1.660 5.874
hiswrite/artcncl00:00:00.022 0.0%13 0.000 1.692 5.250
idle22:30:36.038 93.8%116407682 0.568 0.696 1.072
nntp read00:12:29.281 0.9%116178964 0.006 0.006 0.008
overview write00:00:01.579 0.0%670163 0.001 0.002 0.005
perl filter00:26:48.598 1.9%670304 1.686 2.400 3.599
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:12.034 0.0%1353915 0.007 0.009 0.013
TOTAL: 24:00:07.93223:52:34.874 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%38029 0.000 0.001 0.010
article prepare00:00:00.001 0.0%13266 0.000 0.000 0.017
article read00:00:05.196 0.0%3317 0.000 1.566 20.421
backlog stats00:00:00.073 0.0%107592 0.000 0.001 0.006
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.360 0.0%52505 0.000 0.007 0.044
data write00:00:00.828 0.0%39168 0.000 0.021 0.056
idle23:54:12.771 99.9%107592 277.173 799.806 1649.833
status file00:00:45.075 0.1%9327 0.203 4.833 272.447
TOTAL: 23:55:06.36323:55:04.357100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:34.622 80.1%2789 0.000 12.414 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.039 0.1%5931 0.000 0.007 0.500
readart00:00:00.001 0.0%36 0.000 0.028 0.500
TOTAL: 00:00:43.22500:00:34.662 80.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 216 669729 669590 0 139 99%89:14:43
2news.icm.edu.pl 54 208 16 180 12 7%15:20:35
3localhost 1377 4 4 0 0 100%00:00:00
TOTAL: 3 1647 669941 669610 180 151 99%104:35:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl264.3 GB337.6 KB747.6 KB264.3 GB 99%413.8 KB
2news.icm.edu.pl239.5 KB0.0 KB203.4 KB442.9 KB 54%15.8 KB
3localhost6.0 KB0.0 KB0.0 KB6.0 KB100%1.5 KB
TOTAL: 3264.3 GB337.6 KB951.0 KB264.3 GB 99%413.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 28 04:15:01 - 04:59:59 19450 2.9% 7.219.3 GB 3.5%3616.25
Feb 28 05:00:00 - 05:59:59 26040 3.9% 7.2312.0 GB 4.5%3489.22
Feb 28 06:00:00 - 06:59:59 25059 3.7% 6.9610.7 GB 4.0%3102.19
Feb 28 07:00:00 - 07:59:59 24010 3.6% 6.6711.4 GB 4.3%3319.89
Feb 28 08:00:00 - 08:59:59 23592 3.5% 6.559.8 GB 3.7%2849.38
Feb 28 09:00:00 - 09:59:59 28306 4.2% 7.8611.4 GB 4.3%3331.50
Feb 28 10:00:00 - 10:59:59 25658 3.8% 7.1310.5 GB 4.0%3061.84
Feb 28 11:00:00 - 11:59:59 27448 4.1% 7.6210.5 GB 4.0%3070.91
Feb 28 12:00:00 - 12:59:59 36974 5.5% 10.2710.4 GB 3.9%3038.12
Feb 28 13:00:00 - 13:59:59 25807 3.9% 7.1711.1 GB 4.2%3235.63
Feb 28 14:00:00 - 14:59:59 28197 4.2% 7.8310.9 GB 4.1%3183.53
Feb 28 15:00:00 - 15:59:59 28754 4.3% 7.9910.8 GB 4.1%3143.57
Feb 28 16:00:00 - 16:59:59 28021 4.2% 7.7811.4 GB 4.3%3315.58
Feb 28 17:00:00 - 17:59:59 30589 4.6% 8.5011.9 GB 4.5%3476.75
Feb 28 18:00:00 - 18:59:59 34057 5.1% 9.4611.0 GB 4.2%3206.58
Feb 28 19:00:00 - 19:59:59 40959 6.1% 11.3812.1 GB 4.6%3535.86
Feb 28 20:00:00 - 20:59:59 26598 4.0% 7.3911.3 GB 4.3%3289.98
Feb 28 21:00:00 - 21:59:59 27080 4.0% 7.5212.7 GB 4.8%3695.96
Feb 28 22:00:00 - 22:59:59 26904 4.0% 7.4711.8 GB 4.5%3443.43
Feb 28 23:00:00 - 23:59:59 26099 3.9% 7.2511.1 GB 4.2%3218.89
Mar 1 00:00:00 - 00:59:59 25823 3.9% 7.179.6 GB 3.6%2802.58
Mar 1 01:00:00 - 01:59:59 22126 3.3% 6.159.9 GB 3.7%2888.76
Mar 1 02:00:00 - 02:59:59 36694 5.5% 10.1911.4 GB 4.3%3310.61
Mar 1 03:00:00 - 03:59:59 20428 3.1% 5.679.6 GB 3.6%2794.23
Mar 1 04:00:00 - 04:15:01 4977 0.7% 5.522.3 GB 0.9%2708.85
TOTAL: 24:00:00 669650 100.0% 7.75265.0 GB 100.0%3216.42
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 495 126 0 10 3 0 0 0 356
2news.icm.edu.pl 12 0 0 0 0 0 0 0 12
TOTAL: 2 507 126 0 10 3 0 0 0 368

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 37
comp.sys.raspberry-pi 21
nl.comp.os.linux.techniek 14
comp.mobile.android 12
it.tlc.cellulari.android 10
it.comp.os.win.windows10 10
de.rec.sf.startrek 7
alt.comp.software.seamonkey 7
alt.comp.software.firefox 3
de.comp.lang.vbclassic 2
comp.mobile.ipad 1
de.comm.provider.telefonie 1
de.rec.kunst 1
TOTAL: 13 126

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

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 9
Too many newsgroups 2
EMP (md5) 1
TOTAL: 3 12

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 22576 2867 10267 186 0 0 12%24:09:53
2panorama 25149 79 9725 39 1 28317 0%23:59:57
3poznan 20 1 15 0 0 0 5%02:08:21
4okapi 0 0 0 0 0 772 0%24:05:35
5nask 0 0 0 0 0 8485 0%24:05:35
TOTAL: 5 47745 2947 20007 225 1 37574 6%98:29:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm8.9 MB6.9 MB15.7 MB0.2 KB/s5.3 KB24:09:53
2panorama212.2 KB124.0 KB336.2 KB0.0 KB/s2.8 KB23:59:57
3poznan8.5 KB0.0 KB8.5 KB0.0 KB/s8.5 KB02:08:21
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
TOTAL: 59.1 MB7.0 MB16.0 MB0.0 KB/s5.2 KB98:29:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 295 3632.2 KB 16 0 000:00:09
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 299 3632.2 KB 16 4 000:00:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 299 3632.2 KB 16 4 000:00:09
2unresolved 104 00.0 KB 0 0 000:00:33
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 404 3632.2 KB 16 4 000:00:43

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
23.225.163.214 0.008 0.003 0.00000:00:20
web.man.lodz.pl 0.730 1.107 0.00000:00:09
23.129.64.211 0.000 0.005 0.00000:00:07
23.129.64.217 0.004 0.008 0.00000:00:02
80.111.142.213 0.009 0.015 0.00000:00:02
212.51.192.185 0.203 0.363 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.002 0.005 0.00000:00:00
isvcs01.man.lodz.pl 0.014 0.023 0.00000:00:00
TOTAL: 8 0.970 1.529 0.00000:00:43

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
23.225.163.214 2
23.129.64.217 1
scanner-05.ch1.censys-scanner.com 1
23.129.64.211 1
TOTAL: 6 105

NNRP unrecognized commands (by host):

SystemConn
23.225.163.214 2
scanner-05.ch1.censys-scanner.com 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
#001 1
#026#003#001 1
EHLO www.censys.io 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
23.225.163.214 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.pecet 34
2pl.comp.os.ms-windows.winnt 2
TOTAL: 2 36