Daily Usenet report

Aug 23 04:15:01 -- Aug 24 04:15:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Aug 23 04:27:40 newsfeed overchan[371952]: input line too long, skipping
Aug 23 10:44:55 newsfeed overchan[371952]: input line too long, skipping
Aug 23 10:53:16 newsfeed overchan[371952]: input line too long, skipping
Aug 23 11:08:20 newsfeed overchan[371952]: input line too long, skipping
Aug 23 11:39:28 newsfeed overchan[371952]: input line too long, skipping
Aug 23 11:43:45 newsfeed overchan[371952]: input line too long, skipping
Aug 23 14:42:08 newsfeed nnrpd[400914]: SERVER perl filter not defined
Aug 23 14:45:37 newsfeed nnrpd[401044]: SERVER perl filter not defined
Aug 23 15:50:17 newsfeed overchan[371952]: input line too long, skipping
Aug 23 16:05:59 newsfeed overchan[371952]: input line too long, skipping
Aug 23 16:32:49 newsfeed overchan[371952]: input line too long, skipping
Aug 23 16:58:17 newsfeed overchan[371952]: input line too long, skipping
Aug 23 17:01:43 newsfeed overchan[371952]: input line too long, skipping
Aug 23 17:52:22 newsfeed overchan[371952]: input line too long, skipping
Aug 23 18:44:12 newsfeed overchan[371952]: input line too long, skipping
Aug 23 21:14:33 newsfeed overchan[371952]: input line too long, skipping
Aug 23 21:46:53 newsfeed overchan[371952]: input line too long, skipping
Aug 23 21:54:48 newsfeed overchan[371952]: input line too long, skipping
Aug 24 02:53:10 newsfeed overchan[371952]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 150764 93.3%16.8 MB 93.8%
nnrpd 7655 4.7%763.1 KB 4.2%
innd 1882 1.2%222.4 KB 1.2%
innfeed 1324 0.8%148.4 KB 0.8%
overchan 18 0.0%1.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 161644 100.0%17.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 149777 98.6%
Negative hits 1577 1.0%
Positive hits 450 0.3%
Cache misses 31 0.0%
TOTAL: 4 151835 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.759 0.0%68 0.000 11.162 60.000
article cleanup00:00:01.014 0.0%150730 0.000 0.007 0.013
article logging00:00:03.661 0.0%150995 0.013 0.024 0.042
article parse00:00:05.734 0.0%767069 0.001 0.007 0.012
article write00:00:20.962 0.0%150614 0.060 0.139 1.236
artlog/artcncl00:00:00.002 0.0%68 0.000 0.029 1.000
data move00:00:01.086 0.0%1078764 0.000 0.001 0.003
hisgrep/artcncl00:00:00.323 0.0%68 0.000 4.750 17.375
hishave/artcncl00:00:00.050 0.0%68 0.000 0.735 4.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:26.282 0.4%152708 0.643 2.137 25.725
history sync00:00:00.014 0.0%301 0.000 0.047 0.500
history write00:11:18.421 0.8%150718 2.133 4.501 37.884
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:39:24.417 98.5%899776 15.578 94.651 305.459
nntp read00:00:13.169 0.0%760524 0.008 0.017 0.029
overview write00:00:00.552 0.0%150614 0.000 0.004 0.011
perl filter00:02:47.602 0.2%150718 0.655 1.112 1.484
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.765 0.0%313305 0.006 0.015 0.022
TOTAL: 24:00:22.77023:59:48.813100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%12069 0.000 0.003 0.040
article prepare00:00:00.000 0.0%156 0.000 0.000 0.000
article read00:00:00.004 0.0%39 0.000 0.103 1.000
backlog stats00:00:00.031 0.0%57018 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.298 0.0%29587 0.000 0.010 0.029
data write00:00:00.813 0.0%17626 0.000 0.046 0.106
idle23:59:04.954100.0%57018 838.026 1514.346 3226.624
status file00:00:03.096 0.0%352 0.000 8.795 162.000
TOTAL: 23:59:10.24823:59:09.227100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.405 38.9%4201 0.000 2.715 1860.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.170 0.6%10191 0.000 0.017 0.500
readart00:00:00.001 0.0%30 0.000 0.033 0.500
TOTAL: 00:00:29.29100:00:11.576 39.5%----

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 78 150188 150084 4 100 99%43:14:41
2news.icm.edu.pl 37 433 17 400 16 3%20:16:30
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 118 150623 150103 404 116 99%63:31:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.0 GB300.4 KB507.4 KB2.0 GB 99%13.7 KB
2news.icm.edu.pl750.3 KB8.4 KB329.0 KB1.1 MB 68%33.0 KB
3localhost2.7 KB0.0 KB0.0 KB2.7 KB100%1.3 KB
TOTAL: 32.0 GB308.8 KB836.4 KB2.0 GB 99%13.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 23 04:15:01 - 04:59:59 2559 1.7% 0.9536.3 MB 1.8% 13.77
Aug 23 05:00:00 - 05:59:59 5723 3.8% 1.5988.8 MB 4.4% 25.25
Aug 23 06:00:00 - 06:59:59 5722 3.8% 1.59134.1 MB 6.6% 38.13
Aug 23 07:00:00 - 07:59:59 4318 2.9% 1.2057.5 MB 2.8% 16.35
Aug 23 08:00:00 - 08:59:59 3805 2.5% 1.0644.8 MB 2.2% 12.74
Aug 23 09:00:00 - 09:59:59 4003 2.7% 1.1141.7 MB 2.1% 11.86
Aug 23 10:00:00 - 10:59:59 8691 5.8% 2.4163.4 MB 3.1% 18.03
Aug 23 11:00:00 - 11:59:59 6365 4.2% 1.7785.7 MB 4.2% 24.37
Aug 23 12:00:00 - 12:59:59 6313 4.2% 1.75120.6 MB 6.0% 34.29
Aug 23 13:00:00 - 13:59:59 4525 3.0% 1.2655.1 MB 2.7% 15.68
Aug 23 14:00:00 - 14:59:59 4311 2.9% 1.2044.8 MB 2.2% 12.73
Aug 23 15:00:00 - 15:59:59 4580 3.0% 1.2754.5 MB 2.7% 15.49
Aug 23 16:00:00 - 16:59:59 4659 3.1% 1.2951.8 MB 2.6% 14.73
Aug 23 17:00:00 - 17:59:59 9439 6.3% 2.62102.3 MB 5.1% 29.09
Aug 23 18:00:00 - 18:59:59 4921 3.3% 1.3743.7 MB 2.2% 12.44
Aug 23 19:00:00 - 19:59:59 4698 3.1% 1.3055.7 MB 2.8% 15.85
Aug 23 20:00:00 - 20:59:59 6004 4.0% 1.6765.7 MB 3.3% 18.69
Aug 23 21:00:00 - 21:59:59 8067 5.4% 2.24118.6 MB 5.9% 33.73
Aug 23 22:00:00 - 22:59:59 7662 5.1% 2.13106.5 MB 5.3% 30.30
Aug 23 23:00:00 - 23:59:59 7941 5.3% 2.21149.5 MB 7.4% 42.52
Aug 24 00:00:00 - 00:59:59 8380 5.6% 2.33107.7 MB 5.3% 30.64
Aug 24 01:00:00 - 01:59:59 8327 5.5% 2.31127.6 MB 6.3% 36.30
Aug 24 02:00:00 - 02:59:59 9046 6.0% 2.51111.7 MB 5.5% 31.78
Aug 24 03:00:00 - 03:59:59 8455 5.6% 2.35118.8 MB 5.9% 33.78
Aug 24 04:00:00 - 04:15:01 1799 1.2% 2.0032.9 MB 1.6% 37.45
TOTAL: 24:00:00 150313 100.0% 1.742.0 GB 100.0% 23.94
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 367 88 0 11 1 0 0 0 267
2news.icm.edu.pl 16 0 0 1 0 0 0 0 15
TOTAL: 2 383 88 0 12 1 0 0 0 282

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 45
comp.sys.raspberry-pi 10
comp.mobile.android 10
de.comp.lang.vbclassic 8
alt.comp.software.firefox 6
it.comp.os.win.windows10 3
nl.comp.os.linux.techniek 2
de.comp.office-pakete.ms-office.excel 2
alt.comp.software.seamonkey 1
it.tlc.cellulari.android 1
TOTAL: 10 88

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

GroupsCount
pl.sci.matematyka 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11
Binary in non-binary group 4
TOTAL: 2 15

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17519 27 11869 10 0 0 0%23:59:55
2poznan 25 2 15 0 0 0 8%02:26:05
3panorama 0 0 0 0 0 12070 0%23:57:47
4okapi 0 0 0 0 0 712 0%23:57:47
5nask 0 0 0 0 0 7870 0%23:57:47
TOTAL: 5 17544 29 11884 10 0 20652 0%98:19:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm86.9 KB23.8 KB110.7 KB0.0 KB/s3.0 KB23:59:55
2poznan20.9 KB0.0 KB20.9 KB0.0 KB/s10.4 KB02:26:05
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 5107.7 KB23.8 KB131.5 KB0.0 KB/s3.4 KB98:19:21
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3041.9 KB 14 0 000:00:09
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 3041.9 KB 14 2 000:00:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1730 3041.9 KB 14 2 000:00:23
2unresolved 102 00.0 KB 0 0 000:00:03
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 31833 3041.9 KB 14 2 000:00:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 4.958 7.832 0.00000:00:14
web.man.lodz.pl 0.996 1.574 0.00000:00:09
80.111.142.213 0.013 0.035 0.00000:00:02
pretty.monitoring.internet-measurement.com 0.005 0.005 0.00000:00:01
212.51.192.185 0.323 0.540 0.00000:00:01
92.118.39.242 0.000 0.007 0.00000:00:00
192.241.204.82 0.000 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.021 0.00000:00:00
TOTAL: 8 6.307 10.023 0.00000:00:29

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
92.118.39.242 1
192.241.204.82 1
pretty.monitoring.internet-measurement.com 1
TOTAL: 6 1543

NNRP unrecognized commands (by host):

SystemConn
192.241.204.82 1
92.118.39.242 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.0 1
MGLNDD_212.191.2.21_119 1
TOTAL: 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 30100.0%
TOTAL: 1 30100.0%

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

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