Daily Usenet report

May 27 04:15:01 -- May 28 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

May 27 06:47:36 newsfeed overchan[1657947]: input line too long, skipping
May 27 11:42:49 newsfeed overchan[1657947]: input line too long, skipping
May 27 16:22:58 newsfeed overchan[1657947]: input line too long, skipping
May 27 17:16:07 newsfeed overchan[1657947]: input line too long, skipping
May 27 19:06:34 newsfeed overchan[1657947]: input line too long, skipping
May 27 19:44:02 newsfeed overchan[1657947]: input line too long, skipping
May 27 21:23:12 newsfeed innfeed[1544]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
May 27 21:23:12 newsfeed innfeed[1544]: SM: storage method 'cnfs' failed initialization
May 27 21:23:12 newsfeed innfeed[1544]: SM: one or more storage methods failed initialization
May 27 21:23:12 newsfeed innfeed[1544]: Storage manager initialization failed -- it is OK after a change in storage methods
May 27 21:23:12 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
May 27 21:23:12 newsfeed innd: SM: storage method 'cnfs' failed initialization
May 27 21:23:12 newsfeed innd: SM: one or more storage methods failed initialization
May 28 01:56:57 newsfeed nnrpd[14272]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 72923 68.6%8.8 MB 69.4%
innfeed 23744 22.3%2.8 MB 21.9%
nnrpd 7848 7.4%864.2 KB 6.7%
innd 1721 1.6%250.4 KB 1.9%
overchan 9 0.0%1.2 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 106248 100.0%12.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 71985 96.6%
Negative hits 2265 3.0%
Positive hits 248 0.3%
Cache misses 29 0.0%
TOTAL: 4 74527 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.948 0.0%55 0.000 17.236 54.000
article cleanup00:00:00.306 0.0%72180 0.000 0.004 0.030
article logging00:00:01.351 0.0%72458 0.000 0.019 0.042
article parse00:00:02.206 0.0%695390 0.000 0.003 0.013
article write00:00:11.932 0.0%72103 0.033 0.165 2.889
artlog/artcncl00:00:00.000 0.0%55 0.000 0.000 0.000
data move00:00:00.474 0.0%875430 0.000 0.001 0.004
hisgrep/artcncl00:00:00.334 0.0%54 0.000 6.185 26.000
hishave/artcncl00:00:00.278 0.0%55 0.000 5.055 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:10:51.434 0.8%74662 4.323 8.725 38.147
history sync00:00:00.007 0.0%322 0.000 0.022 0.500
history write00:10:49.275 0.8%72172 6.120 8.996 36.428
hiswrite/artcncl00:00:00.009 0.0%1 9.000 9.000 9.000
idle23:27:09.806 98.4%757222 11.766 111.499 1130.869
nntp read00:00:05.691 0.0%691930 0.004 0.008 0.026
overview write00:00:00.131 0.0%72103 0.000 0.002 0.010
perl filter00:00:57.483 0.1%72172 0.529 0.796 1.327
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.528 0.0%151935 0.003 0.010 0.033
TOTAL: 23:50:30.20223:50:13.193100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%28420 0.000 0.001 0.014
article prepare00:00:00.000 0.0%3250 0.000 0.000 0.000
article read00:00:13.876 0.0%817 2.857 16.984 94.667
backlog stats00:00:00.033 0.0%60086 0.000 0.001 0.005
callbacks00:00:00.000 0.0%7 0.000 0.000 0.000
data read00:00:00.190 0.0%29555 0.000 0.006 0.020
data write00:00:00.425 0.0%21999 0.000 0.019 0.060
idle23:47:50.299100.0%60086 812.030 1425.795 3331.022
status file00:00:08.750 0.0%7872 0.167 1.112 25.128
TOTAL: 23:48:15.25223:48:13.601100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:01:01.112 97.4%4244 0.000 862.656360094.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.128 0.0%10342 0.000 0.012 0.500
readart00:00:00.010 0.0%12 0.000 0.833 4.500
TOTAL: 01:02:39.67801:01:01.250 97.4%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 96 72280 72208 1 71 99%45:21:04
2news.icm.edu.pl 44 231 8 218 5 3%16:44:49
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 142 72512 72217 219 76 99%62:05:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.6 GB245.2 KB419.3 KB1.6 GB 99%23.1 KB
2news.icm.edu.pl424.7 KB46.5 KB64.8 KB536.0 KB 79%41.2 KB
3localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
TOTAL: 31.6 GB291.7 KB484.1 KB1.6 GB 99%23.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 27 04:15:01 - 04:59:59 1162 1.6% 0.4316.8 MB 1.0% 6.36
May 27 05:00:00 - 05:59:59 1315 1.8% 0.3719.3 MB 1.2% 5.49
May 27 06:00:00 - 06:59:59 1378 1.9% 0.3821.2 MB 1.3% 6.03
May 27 07:00:00 - 07:59:59 1436 2.0% 0.4020.4 MB 1.2% 5.81
May 27 08:00:00 - 08:59:59 2314 3.2% 0.6438.7 MB 2.4% 11.01
May 27 09:00:00 - 09:59:59 2153 3.0% 0.6045.9 MB 2.8% 13.06
May 27 10:00:00 - 10:59:59 2479 3.4% 0.6952.0 MB 3.2% 14.78
May 27 11:00:00 - 11:59:59 1885 2.6% 0.5230.4 MB 1.9% 8.66
May 27 12:00:00 - 12:59:59 3744 5.2% 1.0429.0 MB 1.8% 8.26
May 27 13:00:00 - 13:59:59 2978 4.1% 0.83117.3 MB 7.1% 33.35
May 27 14:00:00 - 14:59:59 3846 5.3% 1.07100.4 MB 6.1% 28.55
May 27 15:00:00 - 15:59:59 7751 10.7% 2.15279.8 MB 17.0% 79.58
May 27 16:00:00 - 16:59:59 3739 5.2% 1.0499.2 MB 6.0% 28.21
May 27 17:00:00 - 17:59:59 4324 6.0% 1.2086.9 MB 5.3% 24.72
May 27 18:00:00 - 18:59:59 5078 7.0% 1.41120.8 MB 7.4% 34.35
May 27 19:00:00 - 19:59:59 4173 5.8% 1.1668.6 MB 4.2% 19.53
May 27 20:00:00 - 20:59:59 2794 3.9% 0.7850.0 MB 3.0% 14.22
May 27 21:00:00 - 21:59:59 3262 4.5% 0.9184.6 MB 5.2% 24.08
May 27 22:00:00 - 22:59:59 2901 4.0% 0.8164.7 MB 3.9% 18.41
May 27 23:00:00 - 23:59:59 3552 4.9% 0.99105.9 MB 6.4% 30.12
May 28 00:00:00 - 00:59:59 3028 4.2% 0.8488.5 MB 5.4% 25.18
May 28 01:00:00 - 01:59:59 2307 3.2% 0.6433.7 MB 2.0% 9.57
May 28 02:00:00 - 02:59:59 2554 3.5% 0.7138.7 MB 2.4% 11.00
May 28 03:00:00 - 03:59:59 1796 2.5% 0.5024.4 MB 1.5% 6.94
May 28 04:00:00 - 04:15:01 563 0.8% 0.625.7 MB 0.3% 6.44
TOTAL: 24:00:00 72512 100.0% 0.841.6 GB 100.0% 19.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 350 67 0 5 0 0 0 0 278
2news.icm.edu.pl 6 0 0 3 0 0 0 0 3
TOTAL: 2 356 67 0 8 0 0 0 0 281

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 33
it.tlc.cellulari.android 10
comp.sys.raspberry-pi 7
comp.mobile.android 6
it.comp.os.win.windows10 4
alt.comp.software.seamonkey 3
de.comp.lang.perl 2
alt.comp.software.firefox 1
de.comm.provider.telefonie 1
TOTAL: 9 67

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 3
TOTAL: 1 3

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 21434 220 8142 215 13 19924 1%23:55:24
2icm 9308 9 7640 1 0 0 0%23:58:18
3poznan 12 0 6 0 0 0 0%01:20:31
4okapi 0 0 0 0 0 515 0%23:53:59
5nask 0 0 0 0 0 5686 0%23:53:58
TOTAL: 5 30754 229 15788 216 13 26125 0%97:02:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama690.7 KB2.6 MB3.2 MB0.0 KB/s7.6 KB23:55:24
2icm29.0 KB3.4 KB32.4 KB0.0 KB/s3.2 KB23:58:18
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:20:31
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:59
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:58
TOTAL: 5719.8 KB2.6 MB3.3 MB0.0 KB/s7.5 KB97:02:10
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 286 1217.5 KB 6 0 000:00:08
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 287 1217.5 KB 6 1 001:02:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1725 1217.5 KB 6 1 001:00:22
2unresolved 102 00.0 KB 0 0 000:00:14
3*.internet-census.org 1 00.0 KB 0 0 000:00:10
4*.ip.linodeusercontent.com 77 00.0 KB 0 0 000:01:53
TOTAL: 41905 1217.5 KB 6 1 001:02:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-tom.man.lodz.pl 0.007 0.008 0.00001:00:01
172-105-246-139.ip.linodeusercontent.com 0.224 0.476 0.00000:01:53
nms1.man.lodz.pl 2.652 7.530 0.00000:00:12
139.162.190.203 0.004 0.004 0.00000:00:10
sh-ams-nl-gp1-wk115.internet-census.org 0.004 0.004 0.00000:00:10
web.man.lodz.pl 0.587 1.648 0.00000:00:08
80.111.142.213 0.000 0.032 0.00000:00:02
212.51.192.185 0.163 0.504 0.00000:00:00
194.165.16.73 0.000 0.014 0.00000:00:00
isvcs01.man.lodz.pl 0.000 0.006 0.00000:00:00
TOTAL: 10 3.641 10.226 0.00001:02:40

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1436
212.51.192.185 96
172-105-246-139.ip.linodeusercontent.com 77
80.111.142.213 4
pc-tom.man.lodz.pl 2
sh-ams-nl-gp1-wk115.internet-census.org 1
194.165.16.73 1
139.162.190.203 1
TOTAL: 8 1618

NNRP unrecognized commands (by host):

SystemConn
194.165.16.73 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-tom.man.lodz.pl 2 0
194.165.16.73 1 1
TOTAL: 2 3 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.pecet 12
TOTAL: 1 12