Daily Usenet report

Sep 6 04:15:02 -- Sep 7 04:15:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Sep 6 05:19:13 newsfeed nnrpd[39317]: SERVER perl filter not defined
Sep 6 09:30:58 newsfeed overchan[36281]: input line too long, skipping
Sep 6 10:08:33 newsfeed nnrpd[53121]: SERVER perl filter not defined
Sep 6 11:09:39 newsfeed overchan[36281]: input line too long, skipping
Sep 6 11:18:14 newsfeed nnrpd[55984]: SERVER perl filter not defined
Sep 6 13:04:41 newsfeed overchan[36281]: input line too long, skipping
Sep 6 13:05:16 newsfeed overchan[36281]: input line too long, skipping
Sep 6 13:05:47 newsfeed overchan[36281]: input line too long, skipping
Sep 6 15:59:30 newsfeed overchan[36281]: input line too long, skipping
Sep 6 16:09:51 newsfeed overchan[36281]: input line too long, skipping
Sep 6 16:11:20 newsfeed overchan[36281]: input line too long, skipping
Sep 6 16:21:28 newsfeed overchan[36281]: input line too long, skipping
Sep 6 17:00:25 newsfeed overchan[36281]: input line too long, skipping
Sep 6 19:12:47 newsfeed overchan[36281]: input line too long, skipping
Sep 6 20:35:10 newsfeed overchan[36281]: input line too long, skipping
Sep 6 20:53:18 newsfeed overchan[36281]: input line too long, skipping
Sep 6 20:55:03 newsfeed overchan[36281]: input line too long, skipping
Sep 6 20:56:12 newsfeed nnrpd[81265]: SERVER perl filter not defined
Sep 6 21:33:06 newsfeed overchan[36281]: input line too long, skipping
Sep 6 21:38:01 newsfeed overchan[36281]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 123387 91.8%13.9 MB 92.7%
nnrpd 7535 5.6%746.6 KB 4.9%
innd 1962 1.5%227.3 KB 1.5%
innfeed 1436 1.1%141.4 KB 0.9%
overchan 17 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 134338 100.0%15.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 122346 98.3%
Negative hits 1260 1.0%
Positive hits 890 0.7%
Cache misses 17 0.0%
TOTAL: 4 124513 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.601 0.0%52 0.000 11.558 41.500
article cleanup00:00:00.886 0.0%123261 0.001 0.007 0.021
article logging00:00:03.185 0.0%123267 0.009 0.026 0.046
article parse00:00:05.317 0.0%675415 0.002 0.008 0.015
article write00:00:23.762 0.0%123042 0.044 0.193 2.532
artlog/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
data move00:00:00.972 0.0%947598 0.000 0.001 0.003
hisgrep/artcncl00:00:00.167 0.0%40 0.000 4.175 15.500
hishave/artcncl00:00:00.082 0.0%52 0.000 1.577 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:42.502 0.6%125350 1.574 4.168 29.315
history sync00:00:00.014 0.0%373 0.000 0.038 0.500
history write00:11:18.663 0.8%123220 3.061 5.508 31.547
hiswrite/artcncl00:00:00.072 0.0%12 0.000 6.000 10.000
idle23:37:10.443 98.4%783254 18.691 108.560 330.669
nntp read00:00:12.114 0.0%670968 0.006 0.018 0.032
overview write00:00:00.466 0.0%123042 0.000 0.004 0.012
perl filter00:02:27.467 0.2%123220 0.603 1.197 1.707
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.106 0.0%257825 0.007 0.016 0.027
TOTAL: 24:00:56.78724:00:30.819100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%11754 0.000 0.003 0.041
article prepare00:00:00.000 0.0%168 0.000 0.000 0.000
article read00:00:00.002 0.0%42 0.000 0.048 1.000
backlog stats00:00:00.046 0.0%52894 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.348 0.0%27826 0.000 0.013 0.035
data write00:00:00.724 0.0%16214 0.000 0.045 0.124
idle23:58:45.046100.0%52894 1046.343 1632.039 3975.166
status file00:00:00.400 0.0%388 0.000 1.031 9.667
TOTAL: 23:58:47.48723:58:46.601100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.328 39.8%4152 0.000 2.728 1859.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.167 0.6%9982 0.000 0.017 0.500
TOTAL: 00:00:28.48600:00:11.495 40.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 57 123283 123163 0 120 99%38:15:06
2news.icm.edu.pl 12 972 53 820 99 5%22:56:18
3localhost 5 4 4 0 0 100%00:00:00
TOTAL: 3 74 124259 123220 820 219 99%61:11:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.7 GB704.4 KB908.8 KB1.7 GB 99%14.7 KB
2news.icm.edu.pl1014.2 KB121.1 KB1.8 MB3.0 MB 33%19.9 KB
3localhost7.6 KB0.0 KB0.0 KB7.6 KB100%1.9 KB
TOTAL: 31.7 GB825.5 KB2.7 MB1.7 GB 99%14.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 6 04:15:02 - 04:59:59 3982 3.2% 1.4846.0 MB 2.6% 17.45
Sep 6 05:00:00 - 05:59:59 4252 3.5% 1.1851.0 MB 2.9% 14.50
Sep 6 06:00:00 - 06:59:59 5078 4.1% 1.4163.5 MB 3.6% 18.07
Sep 6 07:00:00 - 07:59:59 4967 4.0% 1.3856.7 MB 3.2% 16.11
Sep 6 08:00:00 - 08:59:59 6291 5.1% 1.7562.7 MB 3.6% 17.84
Sep 6 09:00:00 - 09:59:59 5837 4.7% 1.6267.2 MB 3.8% 19.13
Sep 6 10:00:00 - 10:59:59 5225 4.2% 1.4567.6 MB 3.8% 19.23
Sep 6 11:00:00 - 11:59:59 6130 5.0% 1.7079.4 MB 4.5% 22.59
Sep 6 12:00:00 - 12:59:59 5407 4.4% 1.50110.3 MB 6.2% 31.37
Sep 6 13:00:00 - 13:59:59 6578 5.3% 1.83158.5 MB 9.0% 45.10
Sep 6 14:00:00 - 14:59:59 5258 4.3% 1.4672.4 MB 4.1% 20.59
Sep 6 15:00:00 - 15:59:59 5857 4.8% 1.6380.8 MB 4.6% 22.98
Sep 6 16:00:00 - 16:59:59 5788 4.7% 1.6183.3 MB 4.7% 23.68
Sep 6 17:00:00 - 17:59:59 6181 5.0% 1.7286.7 MB 4.9% 24.66
Sep 6 18:00:00 - 18:59:59 5554 4.5% 1.5474.2 MB 4.2% 21.12
Sep 6 19:00:00 - 19:59:59 4753 3.9% 1.3257.7 MB 3.3% 16.40
Sep 6 20:00:00 - 20:59:59 4100 3.3% 1.1449.3 MB 2.8% 14.02
Sep 6 21:00:00 - 21:59:59 3666 3.0% 1.0241.9 MB 2.4% 11.92
Sep 6 22:00:00 - 22:59:59 3318 2.7% 0.9233.2 MB 1.9% 9.45
Sep 6 23:00:00 - 23:59:59 3223 2.6% 0.9029.7 MB 1.7% 8.45
Sep 7 00:00:00 - 00:59:59 5541 4.5% 1.54131.1 MB 7.4% 37.30
Sep 7 01:00:00 - 01:59:59 5992 4.9% 1.66127.6 MB 7.2% 36.30
Sep 7 02:00:00 - 02:59:59 4256 3.5% 1.1857.8 MB 3.3% 16.44
Sep 7 03:00:00 - 03:59:59 4441 3.6% 1.2355.0 MB 3.1% 15.65
Sep 7 04:00:00 - 04:15:01 1435 1.2% 1.5922.4 MB 1.3% 25.45
TOTAL: 23:59:59 123110 100.0% 1.421.7 GB 100.0% 20.93
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 126 86 0 34 0 0 0 0 6
2news.icm.edu.pl 99 0 0 7 0 0 0 0 92
TOTAL: 2 225 86 0 41 0 0 0 0 98

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 45
comp.sys.raspberry-pi 20
alt.comp.software.seamonkey 6
it.comp.os.win.windows10 5
de.comm.software.mailreader 4
comp.mobile.android 2
it.discussioni.energia 1
nl.comp.os.linux.techniek 1
it.tlc.cellulari.android 1
de.comp.lang.vbclassic 1
TOTAL: 10 86

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 54
Scoring filter (9) 19
Scoring filter (8) 16
EMP (md5) 2
Scoring filter (10) 1
TOTAL: 5 92

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15971 24 11552 16 0 0 0%23:59:57
2poznan 67 2 51 0 0 0 2%05:42:33
3nask 0 0 0 0 0 8239 0%23:57:47
4panorama 0 0 0 0 0 11763 0%23:57:47
5okapi 0 0 0 0 0 756 0%23:57:47
TOTAL: 5 16038 26 11603 16 0 20758 0%101:35:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm61.4 KB118.9 KB180.3 KB0.0 KB/s4.5 KB23:59:57
2poznan22.8 KB0.0 KB22.8 KB0.0 KB/s11.4 KB05:42:33
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 584.2 KB118.9 KB203.1 KB0.0 KB/s4.8 KB101:35:51
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
180.111.142.213 4 00.0 KB 0 0 000:00:02
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
3web.man.lodz.pl 288 00.0 KB 0 0 000:00:09
4nms2.man.lodz.pl1404 00.0 KB 0 0 000:00:13
5appealing.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6194.165.16.73 1 00.0 KB 0 0 000:00:00
7212.51.192.185 96 00.0 KB 0 0 000:00:01
8162.243.128.53 1 00.0 KB 0 0 000:00:00
TOTAL: 81799 00.0 KB 0 4 000:00:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2unresolved 102 00.0 KB 0 0 000:00:03
3*.man.lodz.pl1696 00.0 KB 0 4 000:00:23
TOTAL: 31799 00.0 KB 0 4 000:00:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 5.049 6.839 0.00000:00:13
web.man.lodz.pl 1.016 1.432 0.00000:00:09
80.111.142.213 0.027 0.015 0.00000:00:02
appealing.monitoring.internet-measurement.com 0.000 0.011 0.00000:00:01
212.51.192.185 0.338 0.479 0.00000:00:01
isvcs01.man.lodz.pl 0.023 0.032 0.00000:00:00
162.243.128.53 0.005 0.000 0.00000:00:00
194.165.16.73 0.005 0.005 0.00000:00:00
TOTAL: 8 6.463 8.813 0.00000:00:28

NNRP unrecognized commands (by host):

SystemConn
162.243.128.53 1
194.165.16.73 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.73 1 1
TOTAL: 1 1 1