Daily Usenet report

Jun 30 04:15:02 -- Jul 1 04:15:02

Unknown entries from news log file:

First 23 / 23 lines (100.0%)

Jun 30 06:54:56 newsfeed overchan[891082]: input line too long, skipping
Jun 30 09:14:27 newsfeed overchan[891082]: input line too long, skipping
Jun 30 09:33:40 newsfeed overchan[891082]: input line too long, skipping
Jun 30 09:41:08 newsfeed overchan[891082]: input line too long, skipping
Jun 30 09:45:19 newsfeed overchan[891082]: input line too long, skipping
Jun 30 11:31:14 newsfeed innfeed[1447]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Jun 30 11:31:14 newsfeed innfeed[1447]: SM: storage method 'cnfs' failed initialization
Jun 30 11:31:14 newsfeed innfeed[1447]: SM: one or more storage methods failed initialization
Jun 30 11:31:14 newsfeed innfeed[1447]: Storage manager initialization failed -- it is OK after a change in storage methods
Jun 30 11:31:14 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Jun 30 11:31:14 newsfeed innd: SM: storage method 'cnfs' failed initialization
Jun 30 11:31:14 newsfeed innd: SM: one or more storage methods failed initialization
Jun 30 12:19:46 newsfeed overchan[1452]: input line too long, skipping
Jun 30 15:51:18 newsfeed overchan[1452]: input line too long, skipping
Jun 30 15:55:33 newsfeed nnrpd[13963]: SERVER perl filter not defined
Jun 30 15:57:22 newsfeed nnrpd[13982]: SERVER perl filter not defined
Jun 30 15:57:50 newsfeed nnrpd[13991]: SERVER perl filter not defined
Jun 30 16:22:57 newsfeed overchan[1452]: input line too long, skipping
Jun 30 17:35:23 newsfeed overchan[1452]: input line too long, skipping
Jun 30 18:20:56 newsfeed overchan[1452]: input line too long, skipping
Jun 30 19:48:08 newsfeed overchan[1452]: input line too long, skipping
Jun 30 20:44:14 newsfeed nnrpd[26601]: SERVER perl filter not defined
Jul 1 02:04:02 newsfeed pgpverify[41446]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 94642 89.4%10.6 MB 90.6%
nnrpd 7669 7.2%737.6 KB 6.2%
innd 2156 2.0%233.2 KB 1.9%
innfeed 1363 1.3%151.6 KB 1.3%
controlchan 24 0.0%5.4 KB 0.0%
overchan 13 0.0%1.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 105868 100.0%11.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 93844 98.8%
Negative hits 910 1.0%
Positive hits 227 0.2%
Cache misses 22 0.0%
TOTAL: 4 95003 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.677 0.0%49 0.000 13.816 47.000
article cleanup00:00:00.625 0.0%94029 0.000 0.007 0.018
article logging00:00:02.617 0.0%94345 0.013 0.028 0.224
article parse00:00:03.724 0.0%439185 0.003 0.008 0.015
article write00:00:15.856 0.0%93894 0.065 0.169 7.407
artlog/artcncl00:00:00.000 0.0%48 0.000 0.000 0.000
data move00:00:00.724 0.0%616076 0.000 0.001 0.005
hisgrep/artcncl00:00:00.210 0.0%49 0.000 4.286 18.000
hishave/artcncl00:00:00.094 0.0%49 0.000 1.918 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:07:50.717 0.5%95146 1.990 4.947 33.054
history sync00:00:00.022 0.0%387 0.000 0.057 1.000
history write00:09:34.712 0.7%94024 3.402 6.112 31.400
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:40:49.307 98.6%520815 30.931 163.684 480.504
nntp read00:00:08.262 0.0%434876 0.012 0.019 0.030
overview write00:00:00.351 0.0%93894 0.000 0.004 0.015
perl filter00:01:48.945 0.1%94024 0.869 1.159 1.744
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.213 0.0%197862 0.007 0.016 0.028
TOTAL: 24:01:00.63124:00:40.056100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%10007 0.000 0.002 0.033
article prepare00:00:00.000 0.0%124 0.000 0.000 0.000
article read00:00:00.002 0.0%31 0.000 0.065 0.250
backlog stats00:00:00.030 0.0%42741 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.255 0.0%22628 0.000 0.011 0.039
data write00:00:00.573 0.0%12818 0.000 0.045 0.122
idle23:48:23.802100.0%42741 1136.694 2005.189 4843.024
status file00:00:00.357 0.0%380 0.000 0.939 8.143
TOTAL: 23:48:26.20523:48:25.043100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.424 36.7%4201 0.000 2.719 1532.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.177 0.6%10140 0.000 0.017 0.500
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:00:31.12700:00:11.601 37.3%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 151
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 196

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 93 94194 94063 6 125 99%44:54:48
2news.icm.edu.pl 57 219 11 198 10 5%16:12:51
3localhost 5 4 4 0 0 100%00:00:00
TOTAL: 3 155 94417 94078 204 135 99%61:07:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.1 GB141.0 KB477.8 KB1.1 GB 99%12.5 KB
2news.icm.edu.pl776.1 KB0.0 KB172.7 KB948.8 KB 81%45.2 KB
3localhost6.5 KB0.0 KB0.0 KB6.5 KB100%1.6 KB
TOTAL: 31.1 GB141.0 KB650.6 KB1.1 GB 99%12.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 30 04:15:02 - 04:59:59 1169 1.2% 0.4317.3 MB 1.5% 6.58
Jun 30 05:00:00 - 05:59:59 1897 2.0% 0.5331.8 MB 2.8% 9.05
Jun 30 06:00:00 - 06:59:59 3393 3.6% 0.9445.3 MB 3.9% 12.88
Jun 30 07:00:00 - 07:59:59 2406 2.6% 0.6733.8 MB 2.9% 9.60
Jun 30 08:00:00 - 08:59:59 2247 2.4% 0.6231.7 MB 2.8% 9.02
Jun 30 09:00:00 - 09:59:59 2253 2.4% 0.6330.6 MB 2.7% 8.71
Jun 30 10:00:00 - 10:59:59 2902 3.1% 0.8136.8 MB 3.2% 10.45
Jun 30 11:00:00 - 11:59:59 4189 4.4% 1.1659.5 MB 5.2% 16.93
Jun 30 12:00:00 - 12:59:59 3671 3.9% 1.0249.8 MB 4.3% 14.15
Jun 30 13:00:00 - 13:59:59 3444 3.7% 0.9678.8 MB 6.8% 22.40
Jun 30 14:00:00 - 14:59:59 3517 3.7% 0.9872.4 MB 6.3% 20.59
Jun 30 15:00:00 - 15:59:59 3545 3.8% 0.9862.6 MB 5.4% 17.79
Jun 30 16:00:00 - 16:59:59 2496 2.7% 0.6937.7 MB 3.3% 10.74
Jun 30 17:00:00 - 17:59:59 4428 4.7% 1.2355.2 MB 4.8% 15.70
Jun 30 18:00:00 - 18:59:59 6232 6.6% 1.7357.6 MB 5.0% 16.39
Jun 30 19:00:00 - 19:59:59 6614 7.0% 1.8463.1 MB 5.5% 17.94
Jun 30 20:00:00 - 20:59:59 6613 7.0% 1.8455.3 MB 4.8% 15.72
Jun 30 21:00:00 - 21:59:59 6579 7.0% 1.8362.0 MB 5.4% 17.64
Jun 30 22:00:00 - 22:59:59 3496 3.7% 0.9729.2 MB 2.5% 8.31
Jun 30 23:00:00 - 23:59:59 3341 3.5% 0.9339.4 MB 3.4% 11.22
Jul 1 00:00:00 - 00:59:59 4441 4.7% 1.2350.9 MB 4.4% 14.47
Jul 1 01:00:00 - 01:59:59 4152 4.4% 1.1544.5 MB 3.9% 12.65
Jul 1 02:00:00 - 02:59:59 5692 6.0% 1.5856.8 MB 4.9% 16.15
Jul 1 03:00:00 - 03:59:59 4805 5.1% 1.3342.3 MB 3.7% 12.02
Jul 1 04:00:00 - 04:15:02 625 0.7% 0.697.2 MB 0.6% 8.22
TOTAL: 24:00:00 94147 100.0% 1.091.1 GB 100.0% 13.65
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 437 120 0 5 0 0 0 0 312
2news.icm.edu.pl 10 0 0 0 0 0 0 0 10
TOTAL: 2 447 120 0 5 0 0 0 0 322

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.comp.software.firefox 33
comp.mobile.android 30
alt.comp.software.seamonkey 21
uk.railway 11
comp.mobile.ipad 6
comp.sys.raspberry-pi 6
it.comp.os.win.windows10 5
nl.wetenschap.regulier 3
de.comm.software.mailreader 2
nl.actueel 1
de.rec.sf.startrek 1
it.tlc.cellulari.android 1
TOTAL: 12 120

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 6
Scoring filter (8) 4
TOTAL: 2 10

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 12589 11 9865 20 0 2 0%23:54:35
2nask 0 0 0 0 0 6611 0%23:58:44
3poznan 15 0 10 0 0 0 0%01:43:03
4okapi 0 0 0 0 0 645 0%23:51:01
5panorama 0 0 0 0 0 10029 0%23:51:01
TOTAL: 5 12604 11 9875 20 0 17287 0%97:18:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm50.2 KB394.4 KB444.5 KB0.0 KB/s14.3 KB23:54:35
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:44
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:43:03
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:01
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:01
TOTAL: 550.2 KB394.4 KB444.5 KB0.0 KB/s14.3 KB97:18:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 65.2 KB 3 0 000:00:08
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 65.2 KB 3 4 000:00:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1731 65.2 KB 3 4 000:00:23
2*.li.binaryedge.ninja 1 00.0 KB 0 0 000:00:01
3unresolved 105 00.0 KB 0 0 000:00:05
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 41838 65.2 KB 3 4 000:00:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 5.123 7.056 0.00000:00:14
web.man.lodz.pl 1.095 1.398 0.00000:00:08
80.111.142.213 0.024 0.027 0.00000:00:02
prod-jerry-se-scanners-eu-central-57.li.binaryedge.ninja 0.004 0.007 0.00000:00:01
212.51.192.185 0.420 0.470 0.00000:00:01
71.6.134.232 0.012 0.020 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.000 0.017 0.00000:00:00
194.165.16.72 0.006 0.006 0.00000:00:00
104.131.128.25 0.006 0.000 0.00000:00:00
isvcs01.man.lodz.pl 0.027 0.007 0.00000:00:00
TOTAL: 10 6.717 9.008 0.00000:00:31

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1439
212.51.192.185 96
80.111.142.213 4
71.6.134.232 3
prod-jerry-se-scanners-eu-central-57.li.binaryedge.ninja 1
104.131.128.25 1
scanner-06.ch1.censys-scanner.com 1
194.165.16.72 1
TOTAL: 8 1546

NNRP unrecognized commands (by host):

SystemConn
71.6.134.232 7
104.131.128.25 1
scanner-06.ch1.censys-scanner.com 1
194.165.16.72 1
TOTAL: 4 10

NNRP unrecognized commands (by command):

CommandCount
#003 1
Host: 212.191.2.21:119 1
#026#003#001 1
Accept-Encoding: gzip 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
#023#003#023#001#023#002#001 1
GET / HTTP/1.1 1
MGLNDD_212.191.2.21_119 1
Accept: */* 1
EHLO www.censys.io 1
TOTAL: 10 10

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.72 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

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