Daily Usenet report

Oct 25 04:15:01 -- Oct 26 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Oct 25 13:31:54 newsfeed nnrpd[324178]: SERVER perl filter not defined
Oct 25 14:07:00 newsfeed nnrpd[325645]: SERVER perl filter not defined
Oct 25 16:02:40 newsfeed overchan[298914]: input line too long, skipping
Oct 25 16:08:38 newsfeed overchan[298914]: input line too long, skipping
Oct 25 16:40:34 newsfeed overchan[298914]: input line too long, skipping
Oct 25 17:20:15 newsfeed overchan[298914]: input line too long, skipping
Oct 25 17:24:04 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:19:42 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:21:41 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:23:12 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:28:26 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:39:36 newsfeed overchan[298914]: input line too long, skipping
Oct 25 19:48:39 newsfeed overchan[298914]: input line too long, skipping
Oct 25 21:35:44 newsfeed nnrpd[345394]: SERVER perl filter not defined
Oct 25 21:36:23 newsfeed nnrpd[345400]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 196782 89.8%22.8 MB 89.7%
innd 13003 5.9%1.7 MB 6.5%
nnrpd 7682 3.5%778.6 KB 3.0%
innfeed 1740 0.8%194.7 KB 0.7%
overchan 13 0.0%1.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 219221 100.0%25.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 196054 92.3%
Negative hits 13979 6.6%
Positive hits 2366 1.1%
Cache misses 27 0.0%
TOTAL: 4 212426 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.500 0.0%44 0.000 11.364 36.200
article cleanup00:00:01.409 0.0%197168 0.002 0.007 0.012
article logging00:00:04.616 0.0%197175 0.011 0.023 0.037
article parse00:00:08.843 0.0%741218 0.007 0.012 0.017
article write00:00:27.842 0.0%185702 0.057 0.150 0.992
artlog/artcncl00:00:00.001 0.0%44 0.000 0.023 0.500
data move00:00:01.183 0.0%1041831 0.000 0.001 0.003
hisgrep/artcncl00:00:00.204 0.0%44 0.000 4.636 17.000
hishave/artcncl00:00:00.086 0.0%44 0.000 1.955 6.400
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:32.562 0.9%213349 1.340 3.527 8.449
history sync00:00:00.019 0.0%304 0.000 0.062 0.500
history write00:13:57.822 1.0%196984 2.293 4.253 8.175
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:28:18.447 97.8%900526 24.161 93.832 307.547
nntp read00:00:16.595 0.0%742528 0.015 0.022 0.030
overview write00:00:00.599 0.0%185702 0.000 0.003 0.010
perl filter00:03:46.868 0.3%196984 0.721 1.152 1.865
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.448 0.0%400255 0.011 0.016 0.024
TOTAL: 24:00:25.71123:59:44.044100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%28802 0.000 0.002 0.010
article prepare00:00:00.000 0.0%696 0.000 0.000 0.000
article read00:00:00.006 0.0%174 0.000 0.034 1.000
backlog stats00:00:00.070 0.0%127642 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.654 0.0%70291 0.000 0.009 0.020
data write00:00:01.925 0.0%41418 0.013 0.046 0.106
idle23:54:23.568100.0%127642 353.836 674.257 1683.370
status file00:00:00.306 0.0%516 0.000 0.593 2.037
TOTAL: 23:54:28.56123:54:26.584100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.960 55.1%4224 0.000 4.962 9641.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.185 0.5%10231 0.000 0.018 0.500
readart00:00:00.002 0.0%34 0.000 0.059 0.500
TOTAL: 00:00:38.03900:00:21.147 55.6%----

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 60 185415 185044 36 335 99%47:08:19
2news.icm.edu.pl 1 13421 236 2104 11081 1%23:38:47
3localhost 5 4 4 0 0 100%00:00:00
TOTAL: 3 66 198840 185284 2140 11416 93%70:47:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.3 GB6.7 MB7.1 MB2.3 GB 99%13.0 KB
2news.icm.edu.pl10.7 MB247.8 KB173.4 MB184.4 MB 5%16.7 KB
3localhost6.0 KB0.0 KB0.0 KB6.0 KB100%1.5 KB
TOTAL: 32.3 GB6.9 MB180.5 MB2.5 GB 92%13.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 25 04:15:01 - 04:59:59 5612 3.0% 2.0846.8 MB 2.0% 17.74
Oct 25 05:00:00 - 05:59:59 8267 4.5% 2.3053.8 MB 2.3% 15.29
Oct 25 06:00:00 - 06:59:59 6990 3.8% 1.9451.2 MB 2.2% 14.56
Oct 25 07:00:00 - 07:59:59 7154 3.9% 1.9972.3 MB 3.1% 20.56
Oct 25 08:00:00 - 08:59:59 8613 4.6% 2.39104.1 MB 4.4% 29.62
Oct 25 09:00:00 - 09:59:59 9727 5.3% 2.70127.7 MB 5.4% 36.33
Oct 25 10:00:00 - 10:59:59 9018 4.9% 2.50109.3 MB 4.6% 31.09
Oct 25 11:00:00 - 11:59:59 8161 4.4% 2.2796.2 MB 4.1% 27.36
Oct 25 12:00:00 - 12:59:59 11421 6.2% 3.17137.8 MB 5.9% 39.19
Oct 25 13:00:00 - 13:59:59 12284 6.6% 3.41203.2 MB 8.6% 57.80
Oct 25 14:00:00 - 14:59:59 8566 4.6% 2.3883.4 MB 3.5% 23.72
Oct 25 15:00:00 - 15:59:59 9300 5.0% 2.58103.7 MB 4.4% 29.51
Oct 25 16:00:00 - 16:59:59 9579 5.2% 2.6693.6 MB 4.0% 26.62
Oct 25 17:00:00 - 17:59:59 7179 3.9% 1.9976.3 MB 3.2% 21.70
Oct 25 18:00:00 - 18:59:59 7577 4.1% 2.1093.0 MB 4.0% 26.46
Oct 25 19:00:00 - 19:59:59 6366 3.4% 1.7796.6 MB 4.1% 27.47
Oct 25 20:00:00 - 20:59:59 6201 3.3% 1.7295.9 MB 4.1% 27.29
Oct 25 21:00:00 - 21:59:59 6130 3.3% 1.7088.8 MB 3.8% 25.26
Oct 25 22:00:00 - 22:59:59 5851 3.2% 1.6391.9 MB 3.9% 26.13
Oct 25 23:00:00 - 23:59:59 6381 3.4% 1.77150.6 MB 6.4% 42.85
Oct 26 00:00:00 - 00:59:59 5333 2.9% 1.48127.6 MB 5.4% 36.30
Oct 26 01:00:00 - 01:59:59 6581 3.6% 1.8376.3 MB 3.2% 21.70
Oct 26 02:00:00 - 02:59:59 6826 3.7% 1.9074.0 MB 3.1% 21.04
Oct 26 03:00:00 - 03:59:59 4397 2.4% 1.2276.3 MB 3.2% 21.70
Oct 26 04:00:00 - 04:15:01 1757 0.9% 1.9521.3 MB 0.9% 24.16
TOTAL: 24:00:00 185271 100.0% 2.142.3 GB 100.0% 27.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 11124 0 0 17 0 0 0 011107
2newsfeed.pionier.net.pl 343 168 0 167 0 0 0 0 8
TOTAL: 2 11467 168 0 184 0 0 0 011115

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 34
it.comp.os.win.windows10 25
uk.railway 21
comp.sys.raspberry-pi 16
alt.comp.software.firefox 15
comp.mobile.android 15
eternal-september.newusers 12
eternal-september.support 7
alt.comp.software.seamonkey 5
fr.comp.os.android 5
eternal-september.test 3
comp.mobile.ipad 2
eternal-september.talk 2
de.comm.software.mailreader 2
eternal-september.grouprequests 1
rocksolid.spam 1
de.comp.office-pakete.ms-office.outlook 1
grisbi.test 1
TOTAL: 18 168

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11058
Scoring filter (8) 29
Scoring filter (11) 10
Scoring filter (9) 9
EMP (md5) 2
TOTAL: 5 11108

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 41115 160 28198 14 0 0 0%23:50:00
2poznan 297 0 229 0 0 0 0%18:32:59
3nask 0 0 0 0 0 23798 0%23:50:00
4panorama 0 0 0 0 0 28769 0%23:50:01
5okapi 0 0 0 0 0 634 0%23:50:01
TOTAL: 5 41412 160 28427 14 0 53201 0%113:53:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm680.6 KB52.4 KB733.0 KB0.0 KB/s4.2 KB23:50:00
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s018:32:59
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
TOTAL: 5680.6 KB52.4 KB733.0 KB0.0 KB/s4.2 KB113:53:01
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
okapi488.4 KB
TOTAL: 22.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3435.5 KB 16 0 000:00:09
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 3435.5 KB 16 4 000:00:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1733 3435.5 KB 16 4 000:00:22
2unresolved 103 00.0 KB 0 0 000:00:13
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 31837 3435.5 KB 16 4 000:00:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 5.222 8.362 0.00000:00:13
198.199.100.133 0.005 0.005 0.00000:00:09
web.man.lodz.pl 1.010 1.646 0.00000:00:09
80.111.142.213 0.025 0.017 0.00000:00:02
merciful.monitoring.internet-measurement.com 0.010 0.000 0.00000:00:01
212.51.192.185 0.348 0.580 0.00000:00:01
107.170.245.28 0.003 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.021 0.039 0.00000:00:00
80.66.88.215 0.006 0.006 0.00000:00:00
TOTAL: 9 6.650 10.664 0.00000:00:38

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1441
212.51.192.185 96
80.111.142.213 4
merciful.monitoring.internet-measurement.com 1
80.66.88.215 1
107.170.245.28 1
198.199.100.133 1
TOTAL: 7 1545

NNRP unrecognized commands (by host):

SystemConn
80.66.88.215 1
107.170.245.28 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
#003 1
MGLNDD_212.191.2.21_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.215 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 34100.0%
TOTAL: 1 34100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 30
2pl.comp.pecet 4
TOTAL: 2 34