Daily Usenet report

Jan 8 04:15:02 -- Jan 9 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Jan 8 12:07:34 newsfeed nnrpd[26939]: SERVER perl filter not defined
Jan 8 12:21:25 newsfeed nnrpd[27363]: SERVER perl filter not defined
Jan 8 14:11:26 newsfeed innfeed[991]: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Jan 8 14:11:26 newsfeed innfeed[991]: SM: storage method 'cnfs' failed initialization
Jan 8 14:11:26 newsfeed innfeed[991]: SM: one or more storage methods failed initialization
Jan 8 14:11:26 newsfeed innfeed[991]: Storage manager initialization failed -- it is OK after a change in storage methods
Jan 8 14:11:26 newsfeed innd: CNFS: Mismatch 3: read BUF05 for cycbuff BUF03
Jan 8 14:11:26 newsfeed innd: SM: storage method 'cnfs' failed initialization
Jan 8 14:11:26 newsfeed innd: SM: one or more storage methods failed initialization
Jan 8 14:36:49 newsfeed overchan[1010]: input line too long, skipping
Jan 9 02:32:33 newsfeed overchan[1010]: input line too long, skipping
Jan 9 02:35:30 newsfeed overchan[1010]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 807325 93.5%89.5 MB 92.9%
innfeed 44232 5.1%5.2 MB 5.4%
innd 7185 0.8%1.2 MB 1.2%
nnrpd 4892 0.6%525.9 KB 0.5%
overchan 6 0.0%0.8 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 863643 100.0%96.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 804219 98.5%
Negative hits 12329 1.5%
Positive hits 209 0.0%
Cache misses 31 0.0%
TOTAL: 4 816788 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.769 0.0%173 0.000 4.445 39.000
article cleanup00:00:07.225 0.0%806571 0.003 0.009 0.016
article logging00:00:27.928 0.0%807045 0.028 0.035 0.052
article parse00:03:32.802 0.2%13007261 0.012 0.016 0.021
article write00:02:12.645 0.2%806342 0.102 0.165 2.103
artlog/artcncl00:00:00.003 0.0%173 0.000 0.017 0.500
data move00:00:15.134 0.0%16777835 0.001 0.001 0.002
hisgrep/artcncl00:00:00.188 0.0%85 0.000 2.212 17.000
hishave/artcncl00:00:00.144 0.0%173 0.000 0.832 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:58.389 2.8%819094 0.310 3.001 11.814
history sync00:00:00.023 0.0%342 0.000 0.067 0.500
history write00:42:38.066 3.0%806566 0.692 3.172 9.104
hiswrite/artcncl00:00:00.083 0.0%88 0.000 0.943 8.000
idle21:32:08.523 89.7%12841330 1.087 6.037 68.111
nntp read00:06:45.325 0.5%12768455 0.026 0.032 0.041
overview write00:00:03.209 0.0%806342 0.001 0.004 0.007
perl filter00:46:08.619 3.2%806566 1.789 3.433 6.894
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:34.705 0.0%1627370 0.016 0.021 0.030
TOTAL: 24:00:42.49123:55:53.780 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.121 0.0%50661 0.000 0.002 0.013
article prepare00:00:00.001 0.0%7714 0.000 0.000 0.010
article read00:00:28.572 0.0%1923 0.000 14.858 194.900
backlog stats00:00:00.096 0.0%124572 0.000 0.001 0.005
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.931 0.0%61165 0.000 0.015 0.038
data write00:00:02.554 0.0%46615 0.026 0.055 0.109
idle23:53:55.896 99.9%124572 426.405 690.652 1367.749
status file00:00:11.182 0.0%16530 0.442 0.676 1.085
TOTAL: 23:54:44.45023:54:39.353100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:16.000 66.2%3076 0.000 5.202 1539.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.187 0.8%6854 0.000 0.027 0.500
readart00:00:00.002 0.0%60 0.000 0.033 0.500
TOTAL: 00:00:24.16700:00:16.189 67.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 523 805974 805791 1 182 99%159:23:44
2news.icm.edu.pl 46 203 4 152 47 1%13:37:30
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 572 806179 805797 153 229 99%173:01:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl66.7 GB146.2 KB576.9 KB66.7 GB 99%86.8 KB
2news.icm.edu.pl91.3 KB11.2 KB1.9 MB2.0 MB 4%40.1 KB
3localhost2.4 KB0.0 KB0.0 KB2.4 KB100%1.2 KB
TOTAL: 366.7 GB157.4 KB2.5 MB66.7 GB 99%86.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 8 04:15:02 - 04:59:59 12344 1.5% 4.58915.1 MB 1.3% 347.31
Jan 8 05:00:00 - 05:59:59 12113 1.5% 3.36909.0 MB 1.3% 258.57
Jan 8 06:00:00 - 06:59:59 13884 1.7% 3.861017.9 MB 1.5% 289.53
Jan 8 07:00:00 - 07:59:59 27388 3.4% 7.611.9 GB 2.8% 543.61
Jan 8 08:00:00 - 08:59:59 23186 2.9% 6.441.5 GB 2.3% 448.34
Jan 8 09:00:00 - 09:59:59 24371 3.0% 6.771.6 GB 2.4% 470.39
Jan 8 10:00:00 - 10:59:59 68391 8.5% 19.004.3 GB 6.4%1248.64
Jan 8 11:00:00 - 11:59:59 121764 15.1% 33.827.6 GB 11.4%2227.03
Jan 8 12:00:00 - 12:59:59 45874 5.7% 12.742.9 GB 4.4% 852.58
Jan 8 13:00:00 - 13:59:59 77199 9.6% 21.444.8 GB 7.2%1401.56
Jan 8 14:00:00 - 14:59:59 52129 6.5% 14.482.9 GB 4.4% 858.13
Jan 8 15:00:00 - 15:59:59 17697 2.2% 4.921018.4 MB 1.5% 289.67
Jan 8 16:00:00 - 16:59:59 13619 1.7% 3.78792.5 MB 1.2% 225.42
Jan 8 17:00:00 - 17:59:59 11395 1.4% 3.17403.7 MB 0.6% 114.83
Jan 8 18:00:00 - 18:59:59 13740 1.7% 3.82736.5 MB 1.1% 209.50
Jan 8 19:00:00 - 19:59:59 24450 3.0% 6.791.3 GB 2.0% 383.17
Jan 8 20:00:00 - 20:59:59 19485 2.4% 5.411.1 GB 1.6% 319.49
Jan 8 21:00:00 - 21:59:59 18465 2.3% 5.131012.4 MB 1.5% 287.98
Jan 8 22:00:00 - 22:59:59 44910 5.6% 12.473.3 GB 5.0% 965.94
Jan 8 23:00:00 - 23:59:59 53911 6.7% 14.988.5 GB 12.8%2484.01
Jan 9 00:00:00 - 00:59:59 49551 6.1% 13.7610.0 GB 15.0%2924.21
Jan 9 01:00:00 - 01:59:59 16932 2.1% 4.704.9 GB 7.4%1431.30
Jan 9 02:00:00 - 02:59:59 28759 3.6% 7.991.7 GB 2.6% 508.13
Jan 9 03:00:00 - 03:59:59 11781 1.5% 3.27593.7 MB 0.9% 168.87
Jan 9 04:00:00 - 04:15:02 3111 0.4% 3.451.0 GB 1.6%1205.03
TOTAL: 24:00:00 806449 100.0% 9.3366.9 GB 100.0% 811.38
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 656 178 0 4 1 0 0 0 473
2news.icm.edu.pl 47 0 0 1 0 0 0 0 46
TOTAL: 2 703 178 0 5 1 0 0 0 519

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 124
it.comp.os.win.windows10 23
it.tlc.cellulari.android 15
comp.mobile.android 8
comp.sys.raspberry-pi 3
de.rec.sf.startrek 2
de.comm.software.mailreader 2
uk.rec.cycling.moderated 1
TOTAL: 8 178

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

GroupsCount
pl.sci.matematyka 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 42
Scoring filter (10) 2
Binary in non-binary group 2
TOTAL: 3 46

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 23045 535 14033 57 0 5 2%24:02:33
2panorama 41041 345 13023 347 1 37087 0%23:58:39
3okapi 0 0 0 0 0 1091 0%23:58:19
4poznan 7 0 4 0 0 0 0%00:58:06
5nask 0 0 0 0 0 9484 0%23:58:19
TOTAL: 5 64093 880 27060 404 1 47667 1%96:55:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.5 MB1.6 MB3.1 MB0.0 KB/s5.3 KB24:02:33
2panorama931.2 KB1.2 MB2.1 MB0.0 KB/s3.1 KB23:58:39
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:19
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:58:06
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:19
TOTAL: 52.4 MB2.8 MB5.2 MB0.0 KB/s4.1 KB96:55:56
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 288 6066.0 KB 24 0 000:00:14
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 6066.0 KB 24 2 000:00:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 577 6066.0 KB 24 2 000:00:17
2unresolved 100 00.0 KB 0 0 000:00:04
3*.security.ipip.net 1 00.0 KB 0 0 000:00:00
4*.binaryedge.ninja 1 00.0 KB 0 0 000:00:01
TOTAL: 4 679 6066.0 KB 24 2 000:00:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.192 2.328 0.00000:00:14
80.111.142.213 0.016 0.036 0.00000:00:03
mon.man.lodz.pl 0.948 1.972 0.00000:00:02
min-li-de-12-13-94169-z-prod.binaryedge.ninja 0.004 0.004 0.00000:00:01
212.51.192.185 0.420 0.604 0.00000:00:00
scan-141.security.ipip.net 0.000 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.016 0.00000:00:00
TOTAL: 7 2.592 4.972 0.00000:00:24

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 287
212.51.192.185 96
80.111.142.213 4
min-li-de-12-13-94169-z-prod.binaryedge.ninja 1
scan-141.security.ipip.net 1
TOTAL: 5 389

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 60100.0%
TOTAL: 1 60100.0%

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

NewsgroupCount
1pl.comp.pecet 32
2pl.comp.os.ms-windows.winnt 28
TOTAL: 2 60