Daily Usenet report

Oct 21 04:15:01 -- Oct 22 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Oct 21 04:19:19 newsfeed overchan[5283]: input line too long, skipping
Oct 21 11:08:14 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:209 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13516800 duplicate size 0 rejected size 0]
Oct 21 11:15:02 newsfeed nnrpd[20248]: SERVER perl filter not defined
Oct 21 11:18:28 newsfeed nnrpd[20257]: SERVER perl filter not defined
Oct 21 11:53:19 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:209 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13516800 duplicate size 0 rejected size 0]
Oct 21 13:08:47 newsfeed nnrpd[23973]: SERVER perl filter not defined
Oct 21 14:39:14 newsfeed nnrpd[26967]: SERVER perl filter not defined
Oct 21 14:55:51 newsfeed nnrpd[27583]: SERVER perl filter not defined
Oct 21 15:00:59 newsfeed nnrpd[27702]: SERVER perl filter not defined
Oct 21 16:23:38 newsfeed overchan[5283]: input line too long, skipping
Oct 21 16:30:08 newsfeed overchan[5283]: input line too long, skipping
Oct 21 19:54:00 newsfeed nnrpd[5003]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1834799 96.8%208.4 MB 96.5%
innfeed 44534 2.3%5.2 MB 2.4%
innd 10881 0.6%1.9 MB 0.9%
nnrpd 4985 0.3%538.2 KB 0.2%
overchan 4 0.0%0.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 61895204 100.0%216.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1810394 99.4%
Negative hits 10656 0.6%
Positive hits 303 0.0%
Cache misses 27 0.0%
TOTAL: 4 1821380 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.231 0.0%150 0.000 14.873 247.500
article cleanup00:00:20.090 0.0%1824448 0.004 0.011 0.015
article logging00:01:04.824 0.1%1824872 0.028 0.036 0.058
article parse00:15:24.337 1.1%46759047 0.012 0.020 0.029
article write00:07:15.659 0.5%1824232 0.120 0.239 0.553
artlog/artcncl00:00:00.006 0.0%150 0.000 0.040 0.333
data move00:00:46.081 0.1%54949333 0.001 0.001 0.002
hisgrep/artcncl00:00:00.132 0.0%145 0.000 0.910 20.000
hishave/artcncl00:00:00.003 0.0%150 0.000 0.020 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:09.071 0.2%1835309 0.028 0.103 0.409
history sync00:00:00.016 0.0%300 0.000 0.053 0.500
history write00:42:30.665 3.0%1824423 0.126 1.398 11.458
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle19:41:29.430 82.0%43766638 0.581 1.620 83.779
nntp read00:28:49.309 2.0%45477061 0.029 0.038 0.047
overview write00:00:08.426 0.0%1824232 0.002 0.005 0.010
perl filter02:20:42.852 9.8%1824423 2.414 4.628 6.858
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:25.428 0.1%3663724 0.017 0.023 0.029
TOTAL: 24:00:10.65323:43:08.560 98.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.118 0.0%52052 0.000 0.002 0.009
article prepare00:00:00.000 0.0%7292 0.000 0.000 0.000
article read00:00:12.715 0.0%1820 0.000 6.986 191.833
backlog stats00:00:00.097 0.0%131101 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.178 0.0%64123 0.003 0.018 0.040
data write00:00:02.827 0.0%48879 0.036 0.058 0.127
idle23:53:41.690100.0%131101 386.868 656.148 1130.704
status file00:00:12.713 0.0%16948 0.517 0.750 2.736
TOTAL: 23:54:17.18023:54:11.338100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:17.962 51.6%3098 0.000 25.165 7717.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.271 0.2%6837 0.000 0.040 2.105
readart00:00:00.000 0.0%24 0.000 0.000 0.000
TOTAL: 00:02:31.07800:01:18.233 51.8%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 200 18334271833216 0 211 99%93:25:59
2news.icm.edu.pl 43 184 18 161 5 9%14:06:15
3localhost 8 7 7 0 0 100%00:00:00
TOTAL: 3 251 18336181833241 161 216 99%107:32:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl268.4 GB1.1 MB1.4 MB268.4 GB 99%153.5 KB
2news.icm.edu.pl708.2 KB8.7 KB78.2 KB795.0 KB 89%34.6 KB
3localhost10.2 KB0.0 KB0.0 KB10.2 KB100%1.5 KB
TOTAL: 3268.4 GB1.1 MB1.5 MB268.4 GB 99%153.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 21 04:15:01 - 04:59:59 54066 2.9% 20.033.0 GB 1.1%1181.88
Oct 21 05:00:00 - 05:59:59 26895 1.5% 7.471.5 GB 0.6% 440.45
Oct 21 06:00:00 - 06:59:59 28873 1.6% 8.021.7 GB 0.6% 493.28
Oct 21 07:00:00 - 07:59:59 29305 1.6% 8.141.7 GB 0.6% 506.29
Oct 21 08:00:00 - 08:59:59 29990 1.6% 8.331.8 GB 0.7% 514.08
Oct 21 09:00:00 - 09:59:59 18227 1.0% 5.061.0 GB 0.4% 293.05
Oct 21 10:00:00 - 10:59:59 144875 7.9% 40.248.9 GB 3.3%2596.65
Oct 21 11:00:00 - 11:59:59 285928 15.6% 79.4217.7 GB 6.6%5145.97
Oct 21 12:00:00 - 12:59:59 77345 4.2% 21.4813.7 GB 5.1%3997.60
Oct 21 13:00:00 - 13:59:59 86449 4.7% 24.0110.2 GB 3.8%2980.42
Oct 21 14:00:00 - 14:59:59 88798 4.8% 24.6715.0 GB 5.6%4376.80
Oct 21 15:00:00 - 15:59:59 52862 2.9% 14.6814.0 GB 5.2%4069.78
Oct 21 16:00:00 - 16:59:59 66140 3.6% 18.3712.2 GB 4.5%3542.44
Oct 21 17:00:00 - 17:59:59 64667 3.5% 17.9614.9 GB 5.5%4354.50
Oct 21 18:00:00 - 18:59:59 40327 2.2% 11.2012.1 GB 4.5%3533.91
Oct 21 19:00:00 - 19:59:59 52556 2.9% 14.6016.8 GB 6.2%4880.26
Oct 21 20:00:00 - 20:59:59 77352 4.2% 21.4917.0 GB 6.3%4939.38
Oct 21 21:00:00 - 21:59:59 61807 3.4% 17.1715.2 GB 5.7%4436.54
Oct 21 22:00:00 - 22:59:59 102115 5.6% 28.3716.1 GB 6.0%4699.89
Oct 21 23:00:00 - 23:59:59 104053 5.7% 28.9016.5 GB 6.1%4808.11
Oct 22 00:00:00 - 00:59:59 87250 4.8% 24.2415.3 GB 5.7%4445.39
Oct 22 01:00:00 - 01:59:59 96365 5.3% 26.7712.6 GB 4.7%3667.68
Oct 22 02:00:00 - 02:59:59 66149 3.6% 18.3712.1 GB 4.5%3513.90
Oct 22 03:00:00 - 03:59:59 63239 3.4% 17.5714.2 GB 5.3%4141.26
Oct 22 04:00:00 - 04:15:02 28376 1.5% 31.464.1 GB 1.5%4791.63
TOTAL: 24:00:01 1834009 100.0% 21.23269.4 GB 100.0%3269.31
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 634 186 0 24 1 0 0 0 423
2news.icm.edu.pl 5 0 0 1 0 0 0 0 4
TOTAL: 2 639 186 0 25 1 0 0 0 427

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 97
it.tlc.cellulari.android 51
it.comp.os.win.windows10 23
comp.sys.raspberry-pi 5
it.comp.os.win.windows7 4
de.comp.lang.php 2
uk.rec.cycling.moderated 2
de.comm.software.mailreader 1
comp.mobile.android 1
TOTAL: 9 186

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

GroupsCount
pl.praca.oferowana 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 3
EMP (md5) 1
TOTAL: 2 4

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25301 797 14248 95 0 1 3%23:59:59
2panorama 41049 399 12477 130 2 39104 0%23:59:59
3nask 0 0 0 0 0 9933 0%23:57:51
4poznan 22 0 13 0 0 0 0%01:40:49
5okapi 0 0 0 0 0 958 0%23:57:51
TOTAL: 5 66372 1196 26738 225 2 49996 1%97:36:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.5 MB2.6 MB5.0 MB0.1 KB/s5.8 KB23:59:59
2panorama1.1 MB538.5 KB1.7 MB0.0 KB/s3.2 KB23:59:59
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:40:49
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 53.6 MB3.1 MB6.7 MB0.0 KB/s4.8 KB97:36:29
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2427.9 KB 10 0 000:00:16
2isvcs01.man.lodz.pl 7 00.0 KB 0 7 000:00:00
TOTAL: 2 295 2427.9 KB 10 7 000:02:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 583 2427.9 KB 10 7 000:00:20
2*.hsd1.mn.comcast.net 1 00.0 KB 0 0 000:00:31
3unresolved 110 00.0 KB 0 0 000:01:37
4*.binaryedge.ninja 1 00.0 KB 0 0 000:00:01
TOTAL: 4 695 2427.9 KB 10 7 000:02:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
164.52.24.176 0.020 0.080 0.00000:00:57
c-66-41-0-252.hsd1.mn.comcast.net 0.004 0.012 0.00000:00:31
77.81.29.47 0.000 0.016 0.00000:00:30
web.man.lodz.pl 1.436 4.888 0.00000:00:16
80.111.142.213 0.016 0.060 0.00000:00:07
mon.man.lodz.pl 1.284 4.892 0.00000:00:03
min-li-ustx-10-08-38477-z-prod.binaryedge.ninja 0.000 0.012 0.00000:00:01
212.51.192.185 0.388 1.444 0.00000:00:00
122.228.19.79 0.008 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.040 0.148 0.00000:00:00
TOTAL: 10 3.196 11.560 0.00000:02:30

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
164.52.24.176 8
80.111.142.213 4
c-66-41-0-252.hsd1.mn.comcast.net 1
min-li-ustx-10-08-38477-z-prod.binaryedge.ninja 1
77.81.29.47 1
122.228.19.79 1
TOTAL: 8 400

NNRP unrecognized commands (by host):

SystemConn
c-66-41-0-252.hsd1.mn.comcast.net 10
77.81.29.47 10
164.52.24.176 6
122.228.19.79 5
TOTAL: 4 31

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 3
Connection: close 2
Authorization: Basic YWRtaW46ezEyMjEzQkQ... 2
Accept-Language: en-us 2
GET / HTTP/1.1 2
Cache-Control: max-age=0 2
Content-Type: text/xml 2
User-Agent: ApiTool 2
Accept-Encoding: identity 2
Content-Length: 586 2
#026#003#001#001"#001 1
Host: 212.191.2.21:119 1
Connection: keep-alive 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
À/À+À'À#À#023À 1
fox a 1 -1 fox hello 1
Host: 212.191.2.21 1
Host: 52.169.4.129 1
@RSYNCD: 29 1
W 1
TOTAL: 20 31

Newsgroup request counts (by category):

CategoryCountPct
1pl 24100.0%
TOTAL: 1 24100.0%

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

NewsgroupCount
1pl.comp.pecet 16
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 24