Daily Usenet report

Sep 23 04:15:01 -- Sep 24 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Sep 23 09:22:40 newsfeed nnrpd[196567]: SERVER perl filter not defined
Sep 23 09:24:24 newsfeed nnrpd[196728]: SERVER perl filter not defined
Sep 23 14:55:30 newsfeed overchan[182614]: input line too long, skipping
Sep 23 14:59:24 newsfeed overchan[182614]: input line too long, skipping
Sep 23 16:04:40 newsfeed overchan[182614]: input line too long, skipping
Sep 23 19:08:36 newsfeed overchan[182614]: input line too long, skipping
Sep 23 19:44:55 newsfeed overchan[182614]: input line too long, skipping
Sep 24 00:43:19 newsfeed overchan[182614]: input line too long, skipping
Sep 24 00:45:07 newsfeed overchan[182614]: input line too long, skipping
Sep 24 00:45:41 newsfeed overchan[182614]: input line too long, skipping
Sep 24 00:46:26 newsfeed overchan[182614]: input line too long, skipping
Sep 24 01:34:12 newsfeed overchan[182614]: input line too long, skipping
Sep 24 01:34:31 newsfeed overchan[182614]: input line too long, skipping
Sep 24 01:37:56 newsfeed overchan[182614]: input line too long, skipping
Sep 24 01:38:11 newsfeed overchan[182614]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 123587 91.7%14.0 MB 92.5%
nnrpd 7626 5.7%757.8 KB 4.9%
innd 2134 1.6%251.1 KB 1.6%
innfeed 1351 1.0%151.8 KB 1.0%
overchan 15 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 134714 100.0%15.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 123007 97.4%
Negative hits 2441 1.9%
Positive hits 754 0.6%
Cache misses 45 0.0%
TOTAL: 4 126247 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.812 0.0%62 0.000 13.097 29.400
article cleanup00:00:00.860 0.0%123439 0.000 0.007 0.014
article logging00:00:02.972 0.0%123443 0.014 0.024 0.040
article parse00:00:04.516 0.0%601082 0.004 0.008 0.014
article write00:00:20.249 0.0%122871 0.053 0.165 2.835
artlog/artcncl00:00:00.001 0.0%60 0.000 0.017 0.500
data move00:00:00.775 0.0%785717 0.000 0.001 0.004
hisgrep/artcncl00:00:00.355 0.0%59 0.000 6.017 14.500
hishave/artcncl00:00:00.169 0.0%62 0.000 2.726 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:16:14.878 1.1%126583 4.275 7.701 12.039
history sync00:00:00.014 0.0%308 0.000 0.045 0.500
history write00:16:06.296 1.1%123401 5.172 7.831 12.350
hiswrite/artcncl00:00:00.029 0.0%3 5.000 9.667 15.000
idle23:24:27.811 97.5%704347 20.660 119.640 285.420
nntp read00:00:10.116 0.0%595304 0.009 0.017 0.026
overview write00:00:00.425 0.0%122871 0.000 0.003 0.012
perl filter00:02:21.414 0.2%123401 0.749 1.146 1.932
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.002 0.0%255826 0.009 0.016 0.028
TOTAL: 24:00:23.40123:59:55.694100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%10084 0.000 0.002 0.022
article prepare00:00:00.000 0.0%80 0.000 0.000 0.000
article read00:00:00.002 0.0%20 0.000 0.100 1.000
backlog stats00:00:00.027 0.0%42511 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.190 0.0%22493 0.000 0.008 0.028
data write00:00:00.562 0.0%12599 0.000 0.045 0.143
idle23:59:54.643100.0%42511 1088.269 2032.289 4183.833
status file00:00:00.207 0.0%349 0.000 0.593 2.000
TOTAL: 23:59:56.45723:59:55.652100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.244 37.1%4184 0.000 2.448 181.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.163 0.6%10114 0.000 0.016 0.500
readart00:00:00.001 0.0%12 0.000 0.083 0.500
TOTAL: 00:00:27.59000:00:10.408 37.7%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 74 123007 122908 14 85 99%43:21:12
2news.icm.edu.pl 14 1383 31 719 633 2%24:30:40
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 91 124392 122941 733 718 98%67:51:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.3 GB433.5 KB559.8 KB1.3 GB 99%11.4 KB
2news.icm.edu.pl1.2 MB201.2 KB7.8 MB9.2 MB 12%14.2 KB
3localhost2.5 KB0.0 KB0.0 KB2.5 KB100%1.2 KB
TOTAL: 31.3 GB634.8 KB8.4 MB1.3 GB 99%11.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 23 04:15:01 - 04:59:59 3974 3.2% 1.4744.8 MB 3.3% 16.99
Sep 23 05:00:00 - 05:59:59 5060 4.1% 1.4180.7 MB 5.9% 22.94
Sep 23 06:00:00 - 06:59:59 4319 3.5% 1.2034.1 MB 2.5% 9.69
Sep 23 07:00:00 - 07:59:59 5080 4.1% 1.4145.1 MB 3.3% 12.82
Sep 23 08:00:00 - 08:59:59 5966 4.9% 1.6680.7 MB 5.9% 22.97
Sep 23 09:00:00 - 09:59:59 5400 4.4% 1.5051.3 MB 3.7% 14.60
Sep 23 10:00:00 - 10:59:59 4958 4.0% 1.3856.8 MB 4.1% 16.17
Sep 23 11:00:00 - 11:59:59 5270 4.3% 1.4648.8 MB 3.6% 13.88
Sep 23 12:00:00 - 12:59:59 5881 4.8% 1.6357.6 MB 4.2% 16.39
Sep 23 13:00:00 - 13:59:59 5872 4.8% 1.63119.5 MB 8.7% 33.99
Sep 23 14:00:00 - 14:59:59 6478 5.3% 1.8081.8 MB 6.0% 23.28
Sep 23 15:00:00 - 15:59:59 6610 5.4% 1.8450.4 MB 3.7% 14.33
Sep 23 16:00:00 - 16:59:59 4865 4.0% 1.3536.6 MB 2.7% 10.41
Sep 23 17:00:00 - 17:59:59 5908 4.8% 1.6446.8 MB 3.4% 13.30
Sep 23 18:00:00 - 18:59:59 5353 4.4% 1.4978.3 MB 5.7% 22.27
Sep 23 19:00:00 - 19:59:59 4127 3.4% 1.1531.6 MB 2.3% 9.00
Sep 23 20:00:00 - 20:59:59 4274 3.5% 1.1989.5 MB 6.5% 25.47
Sep 23 21:00:00 - 21:59:59 3632 3.0% 1.0138.8 MB 2.8% 11.04
Sep 23 22:00:00 - 22:59:59 4889 4.0% 1.3673.8 MB 5.4% 21.00
Sep 23 23:00:00 - 23:59:59 4521 3.7% 1.2638.5 MB 2.8% 10.95
Sep 24 00:00:00 - 00:59:59 3858 3.1% 1.0738.8 MB 2.8% 11.04
Sep 24 01:00:00 - 01:59:59 5263 4.3% 1.4651.7 MB 3.8% 14.72
Sep 24 02:00:00 - 02:59:59 5019 4.1% 1.3947.1 MB 3.4% 13.40
Sep 24 03:00:00 - 03:59:59 5024 4.1% 1.4040.2 MB 2.9% 11.42
Sep 24 04:00:00 - 04:15:01 1354 1.1% 1.5010.3 MB 0.7% 11.68
TOTAL: 24:00:00 122955 100.0% 1.421.3 GB 100.0% 16.28
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 483 0 0 14 0 0 0 0 469
2newsfeed.pionier.net.pl 89 61 0 24 0 0 0 0 4
TOTAL: 2 572 61 0 38 0 0 0 0 473

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 22
it.tlc.cellulari.android 9
nl.comp.os.linux.techniek 9
alt.comp.software.seamonkey 7
alt.comp.software.firefox 5
comp.mobile.android 4
it.comp.os.win.windows10 4
it.tlc.cellulari.iphone 1
TOTAL: 8 61

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 440
Scoring filter (8) 15
EMP (md5) 6
Scoring filter (9) 5
Scoring filter (12) 1
Scoring filter (16) 1
Scoring filter (13) 1
TOTAL: 7 469

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 12440 15 9609 5 0 3 0%24:09:45
2panorama 0 0 0 0 0 10122 0%24:05:34
3okapi 0 0 0 0 0 650 0%24:05:34
4poznan 44 0 30 0 0 0 0%02:43:08
5nask 0 0 0 0 0 6779 0%24:05:34
TOTAL: 5 12484 15 9639 5 0 17554 0%99:09:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm48.6 KB27.6 KB76.2 KB0.0 KB/s3.8 KB24:09:45
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:43:08
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:34
TOTAL: 548.6 KB27.6 KB76.2 KB0.0 KB/s3.8 KB99:09:35
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
okapi488.4 KB
TOTAL: 21.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 1211.0 KB 6 0 000:00:08
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 291 1211.0 KB 6 2 000:00:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1718 1211.0 KB 6 2 000:00:22
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 103 00.0 KB 0 0 000:00:04
4*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 41823 1211.0 KB 6 2 000:00:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms1.man.lodz.pl 4.772 7.838 0.00000:00:14
web.man.lodz.pl 0.936 1.521 0.00000:00:08
80.111.142.213 0.011 0.026 0.00000:00:02
212.51.192.185 0.340 0.527 0.00000:00:01
scanner-27.ch1.censys-scanner.com 0.013 0.004 0.00000:00:00
104.131.144.7 0.003 0.003 0.00000:00:00
39.210.203.35.bc.googleusercontent.com 0.000 0.006 0.00000:00:00
45.227.254.8 0.000 0.010 0.00000:00:00
62.122.184.32 0.004 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.009 0.022 0.00000:00:00
TOTAL: 10 6.088 9.965 0.00000:00:27

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1427
212.51.192.185 96
80.111.142.213 4
104.131.144.7 1
scanner-27.ch1.censys-scanner.com 1
39.210.203.35.bc.googleusercontent.com 1
62.122.184.32 1
45.227.254.8 1
TOTAL: 8 1532

NNRP unrecognized commands (by host):

SystemConn
39.210.203.35.bc.googleusercontent.com 3
104.131.144.7 1
45.227.254.8 1
scanner-27.ch1.censys-scanner.com 1
62.122.184.32 1
TOTAL: 5 7

NNRP unrecognized commands (by command):

CommandCount
#003 2
Host: 212.191.2.21:119 1
GET / HTTP/1.1 1
EHLO www.censys.io 1
MGLNDD_212.191.2.21_119 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 6 7

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.8 1 1
62.122.184.32 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 10
2pl.comp.pecet 2
TOTAL: 2 12