Daily Usenet report

Sep 19 04:15:02 -- Sep 20 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Sep 19 08:01:00 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13516800 duplicate size 0 rejected size 0]
Sep 19 11:08:51 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 11:11:11 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 11:16:16 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 11:37:28 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 12:07:58 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:241 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13443072 duplicate size 0 rejected size 0]
Sep 19 12:43:56 newsfeed overchan[18728]: input line too long, skipping
Sep 19 13:42:36 newsfeed innfeed[1514]: CNFS: CNFSflushhead: attempted flush whilst read only
Sep 19 13:42:36 newsfeed innfeed[1514]: CNFS: CNFSshutdowncycbuff: flushing BUF04
Sep 19 13:42:36 newsfeed innfeed[1514]: CNFS: CNFSflushhead: attempted flush whilst read only
Sep 19 13:42:36 newsfeed innfeed[1514]: SM: storage method 'cnfs' failed initialization
Sep 19 13:42:36 newsfeed innfeed[1514]: SM: one or more storage methods failed initialization
Sep 19 13:42:36 newsfeed innfeed[1514]: Storage manager initialization failed -- it is OK after a change in storage methods
Sep 19 13:53:10 newsfeed overchan[1524]: input line too long, skipping
Sep 19 17:13:29 newsfeed overchan[1524]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn4350227 98.4%480.3 MB 98.0%
innfeed 44712 1.0%5.2 MB 1.1%
innd 23203 0.5%4.0 MB 0.8%
nnrpd 4871 0.1%522.3 KB 0.1%
overchan 4 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 64423019 100.0%490.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 4307115 99.7%
Negative hits 12811 0.3%
Positive hits 241 0.0%
Cache misses 45 0.0%
TOTAL: 4 4320212 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.438 0.0%107 0.000 22.785 158.000
article cleanup00:00:53.459 0.1%4364816 0.010 0.012 0.017
article logging00:02:47.224 0.2%4365205 0.030 0.038 0.053
article parse00:25:03.777 1.7%50758077 0.020 0.030 0.040
article write00:13:54.236 1.0%4364608 0.133 0.191 0.482
artlog/artcncl00:00:00.005 0.0%106 0.000 0.047 1.000
data move00:01:16.394 0.1%63032810 0.001 0.001 0.003
hisgrep/artcncl00:00:00.370 0.0%103 0.000 3.592 24.462
hishave/artcncl00:00:00.006 0.0%107 0.000 0.056 0.400
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:35:18.444 2.5%4378117 0.022 0.484 5.488
history sync00:00:00.020 0.0%292 0.000 0.068 0.500
history write00:50:42.080 3.5%4364785 0.145 0.697 5.392
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle14:56:18.191 62.2%40044246 0.279 1.343 38.609
nntp read00:34:24.775 2.4%46920368 0.036 0.044 0.056
overview write00:00:20.395 0.0%4364608 0.002 0.005 0.007
perl filter05:53:21.557 24.5%4364785 3.649 4.857 12.579
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:41.015 0.3%8744093 0.016 0.025 0.036
TOTAL: 24:00:06.95023:38:04.386 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.134 0.0%52389 0.000 0.003 0.013
article prepare00:00:00.001 0.0%2372 0.000 0.000 0.083
article read00:00:03.232 0.0%593 0.000 5.450 157.000
backlog stats00:00:00.125 0.0%132183 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.214 0.0%64006 0.000 0.019 0.046
data write00:00:03.263 0.0%49172 0.027 0.066 0.111
idle23:53:41.595100.0%132183 453.894 650.777 1251.175
status file00:00:21.482 0.0%17337 0.725 1.239 7.070
TOTAL: 23:54:17.75423:54:11.046100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:15.977 64.2%3034 0.000 5.266 140.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.216 0.9%6718 0.000 0.032 0.667
readart00:00:00.002 0.0%29 0.000 0.069 0.500
TOTAL: 00:00:24.88400:00:16.195 65.1%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 150 43467974346601 0 196 99%106:17:10
2news.icm.edu.pl 42 194 26 155 13 13%14:51:50
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 193 43469914346627 155 209 99%121:09:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl401.1 GB1.3 MB1.7 MB401.1 GB 99%96.8 KB
2news.icm.edu.pl927.5 KB11.4 KB440.0 KB1.3 MB 67%35.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3401.1 GB1.4 MB2.2 MB401.2 GB 99%96.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 19 04:15:02 - 04:59:59 194709 4.5% 72.1712.2 GB 3.0%4748.72
Sep 19 05:00:00 - 05:59:59 321568 7.4% 89.3220.0 GB 5.0%5833.46
Sep 19 06:00:00 - 06:59:59 355459 8.2% 98.7422.2 GB 5.5%6463.37
Sep 19 07:00:00 - 07:59:59 308017 7.1% 85.5619.3 GB 4.8%5608.34
Sep 19 08:00:00 - 08:59:59 180907 4.2% 50.2513.3 GB 3.3%3869.73
Sep 19 09:00:00 - 09:59:59 69395 1.6% 19.284.7 GB 1.2%1376.04
Sep 19 10:00:00 - 10:59:59 147519 3.4% 40.9811.7 GB 2.9%3418.34
Sep 19 11:00:00 - 11:59:59 215605 5.0% 59.8913.6 GB 3.4%3970.34
Sep 19 12:00:00 - 12:59:59 208256 4.8% 57.8513.4 GB 3.3%3910.67
Sep 19 13:00:00 - 13:59:59 85888 2.0% 23.8615.3 GB 3.8%4458.13
Sep 19 14:00:00 - 14:59:59 196715 4.5% 54.6415.3 GB 3.8%4457.61
Sep 19 15:00:00 - 15:59:59 161669 3.7% 44.9114.2 GB 3.5%4143.32
Sep 19 16:00:00 - 16:59:59 138624 3.2% 38.5119.1 GB 4.7%5567.79
Sep 19 17:00:00 - 17:59:59 207297 4.8% 57.5822.6 GB 5.6%6573.37
Sep 19 18:00:00 - 18:59:59 328205 7.5% 91.1720.7 GB 5.1%6022.91
Sep 19 19:00:00 - 19:59:59 234856 5.4% 65.2419.7 GB 4.9%5732.24
Sep 19 20:00:00 - 20:59:59 81032 1.9% 22.5113.9 GB 3.4%4040.01
Sep 19 21:00:00 - 21:59:59 121015 2.8% 33.6214.7 GB 3.6%4286.07
Sep 19 22:00:00 - 22:59:59 100175 2.3% 27.8314.3 GB 3.5%4161.13
Sep 19 23:00:00 - 23:59:59 97654 2.2% 27.1324.6 GB 6.1%7159.01
Sep 20 00:00:00 - 00:59:59 87713 2.0% 24.3616.8 GB 4.2%4892.01
Sep 20 01:00:00 - 01:59:59 146212 3.4% 40.6118.9 GB 4.7%5497.88
Sep 20 02:00:00 - 02:59:59 139476 3.2% 38.7416.6 GB 4.1%4848.51
Sep 20 03:00:00 - 03:59:59 172135 4.0% 47.8220.3 GB 5.0%5909.98
Sep 20 04:00:00 - 04:15:02 49419 1.1% 54.796.1 GB 1.5%7046.50
TOTAL: 24:00:00 4349520 100.0% 50.34403.5 GB 100.0%4896.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 588 151 0 30 15 0 0 0 392
2news.icm.edu.pl 13 0 0 1 0 0 0 0 12
TOTAL: 2 601 151 0 31 15 0 0 0 404

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 79
it.tlc.cellulari.android 31
comp.mobile.android 12
comp.mobile.ipad 12
nl.comp.os.linux.techniek 9
it.comp.os.win.windows10 6
de.comp.lang.php 1
uk.rec.cycling.moderated 1
TOTAL: 8 151

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9
Binary in non-binary group 1
Scoring filter (8) 1
Scoring filter (14) 1
TOTAL: 4 12

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25992 360 14174 133 0 0 1%23:52:24
2panorama 41898 23 13208 27 0 39286 0%23:58:57
3poznan 27 0 20 0 0 0 0%02:55:59
4nask 0 0 0 0 0 9778 0%23:50:16
5okapi 0 0 0 0 0 965 0%23:50:16
TOTAL: 5 67917 383 27402 160 0 50029 0%98:27:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.0 MB5.6 MB6.7 MB0.1 KB/s13.9 KB23:52:24
2panorama136.4 KB98.5 KB235.0 KB0.0 KB/s4.7 KB23:58:57
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:55:59
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:16
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:16
TOTAL: 51.2 MB5.7 MB6.9 MB0.0 KB/s13.0 KB98:27:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 291 2825.3 KB 14 0 000:00:16
TOTAL: 1 291 2825.3 KB 14 0 000:00:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 2825.3 KB 14 0 000:00:20
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3unresolved 100 00.0 KB 0 0 000:00:03
TOTAL: 3 680 2825.3 KB 14 0 000:00:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.368 4.632 0.00000:00:16
mon.man.lodz.pl 1.344 4.376 0.00000:00:03
80.111.142.213 0.032 0.068 0.00000:00:02
212.51.192.185 0.380 1.380 0.00000:00:00
scan-141.security.ipip.net 0.004 0.016 0.00000:00:00
TOTAL: 5 3.128 10.472 0.00000:00:24

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 1
TOTAL: 4 389

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
Host: 212.191.2.21:119 1
TOTAL: 4 4

Newsgroup request counts (by category):

CategoryCountPct
1pl 28100.0%
TOTAL: 1 28100.0%

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

NewsgroupCount
1pl.comp.pecet 28
TOTAL: 1 28
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>