Daily Usenet report

Apr 30 04:15:02 -- May 1 04:15:04

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Apr 30 05:08:32 newsfeed overchan[31030]: input line too long, skipping
Apr 30 08:37:05 newsfeed nnrpd[9290]: SERVER perl filter not defined
Apr 30 10:44:59 newsfeed overchan[31030]: input line too long, skipping
Apr 30 11:38:29 newsfeed nnrpd[16083]: SERVER perl filter not defined
Apr 30 11:39:12 newsfeed nnrpd[16101]: SERVER perl filter not defined
Apr 30 11:40:08 newsfeed nnrpd[16147]: SERVER perl filter not defined
Apr 30 12:33:48 newsfeed nnrpd[18220]: SERVER perl filter not defined
Apr 30 16:28:54 newsfeed overchan[31030]: input line too long, skipping
Apr 30 16:35:04 newsfeed overchan[31030]: input line too long, skipping
Apr 30 18:47:38 newsfeed overchan[31030]: input line too long, skipping
Apr 30 20:19:05 newsfeed overchan[31030]: input line too long, skipping
Apr 30 20:26:28 newsfeed overchan[31030]: input line too long, skipping
Apr 30 21:20:05 newsfeed overchan[31030]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2516032 97.9%287.8 MB 97.6%
innfeed 29201 1.1%3.5 MB 1.2%
innd 18861 0.7%3.0 MB 1.0%
nnrpd 4822 0.2%512.5 KB 0.2%
overchan 9 0.0%1.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62568926 100.0%294.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2498953 96.5%
Negative hits 78903 3.0%
Positive hits 10456 0.4%
Cache misses 100 0.0%
TOTAL: 4 2588412 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.012 0.0%161 0.000 12.497 170.500
article cleanup00:00:30.249 0.0%2514885 0.007 0.012 0.017
article logging00:01:41.664 0.1%2515467 0.023 0.040 0.077
article parse00:45:53.151 3.2%91681288 0.017 0.030 0.046
article write00:19:00.016 1.3%2508324 0.166 0.454 0.814
artlog/artcncl00:00:00.004 0.0%160 0.000 0.025 1.000
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:03:44.342 0.3%106485443 0.001 0.002 0.004
hisgrep/artcncl00:00:00.942 0.0%156 0.000 6.038 112.250
hishave/artcncl00:00:00.169 0.0%161 0.000 1.050 17.750
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:52:04.803 3.6%2601485 0.027 1.201 6.186
history sync00:00:00.013 0.0%292 0.000 0.045 0.500
history write02:28:50.920 10.3%2510782 0.218 3.557 9.577
hiswrite/artcncl00:00:00.102 0.0%5 0.000 20.400 73.000
idle13:54:34.369 58.0%70323861 0.491 0.712 1.949
nntp read01:00:42.773 4.2%89819435 0.027 0.041 0.068
overview write00:00:12.360 0.0%2508324 0.003 0.005 0.008
perl filter04:08:16.474 17.2%2510774 3.356 5.933 8.615
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:42.851 0.3%5036791 0.035 0.056 0.078
TOTAL: 24:00:05.96723:40:17.214 98.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.117 0.0%44984 0.000 0.003 0.015
article prepare00:00:00.001 0.0%5644 0.000 0.000 0.011
article read00:00:29.681 0.0%1412 0.000 21.021 449.250
backlog stats00:00:00.128 0.0%143605 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:01.274 0.0%77296 0.004 0.016 0.034
data write00:00:02.894 0.0%57336 0.016 0.050 0.124
idle23:54:15.279 99.9%143605 407.707 599.250 1212.118
status file00:00:10.156 0.0%9603 0.450 1.058 16.517
TOTAL: 23:55:11.41523:54:59.530100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle06:19:31.226 99.9%177958 0.000 127.958302234.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.634 0.0%356782 0.000 0.027 0.667
readart00:00:01.553 0.0%263 0.000 5.905 9.907
TOTAL: 06:20:05.39506:19:42.413 99.9%----

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 817 25090922500254 4167 4671 99%399:02:30
2news.nask.pl 2 12454 8575 1978 1901 68%23:57:41
3news.icm.edu.pl 49 207 14 191 2 6%15:36:11
4localhost 6 5 5 0 0 100%00:00:00
TOTAL: 4 874 25217582508848 6336 6574 99%438:36:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl761.0 GB15.9 MB138.9 MB761.1 GB 99%318.6 KB
2news.nask.pl31.3 MB665.5 KB16.9 MB48.8 MB 64%4.8 KB
3news.icm.edu.pl339.3 KB0.0 KB66.0 KB405.3 KB 83%25.3 KB
4localhost6.6 KB0.0 KB0.0 KB6.6 KB100%1.3 KB
TOTAL: 4761.0 GB16.5 MB155.8 MB761.2 GB 99%317.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 30 04:15:02 - 04:59:59 56221 2.2% 20.8421.4 GB 2.8%8311.68
Apr 30 05:00:00 - 05:59:59 79021 3.1% 21.9528.3 GB 3.7%8256.95
Apr 30 06:00:00 - 06:59:59 83012 3.3% 23.0630.8 GB 4.0%8968.73
Apr 30 07:00:00 - 07:59:59 75119 3.0% 20.8728.4 GB 3.7%8284.54
Apr 30 08:00:00 - 08:59:59 86320 3.4% 23.9831.6 GB 4.2%9205.54
Apr 30 09:00:00 - 09:59:59 96765 3.9% 26.8835.5 GB 4.7%10335.52
Apr 30 10:00:00 - 10:59:59 98700 3.9% 27.4235.2 GB 4.6%10245.21
Apr 30 11:00:00 - 11:59:59 140648 5.6% 39.0734.7 GB 4.6%10102.68
Apr 30 12:00:00 - 12:59:59 121625 4.8% 33.7835.7 GB 4.7%10411.73
Apr 30 13:00:00 - 13:59:59 89696 3.6% 24.9227.0 GB 3.6%7870.76
Apr 30 14:00:00 - 14:59:59 108888 4.3% 30.2535.4 GB 4.6%10299.25
Apr 30 15:00:00 - 15:59:59 145793 5.8% 40.5035.3 GB 4.6%10284.97
Apr 30 16:00:00 - 16:59:59 113557 4.5% 31.5435.8 GB 4.7%10427.53
Apr 30 17:00:00 - 17:59:59 99156 4.0% 27.5437.2 GB 4.9%10830.95
Apr 30 18:00:00 - 18:59:59 116927 4.7% 32.4839.3 GB 5.2%11436.10
Apr 30 19:00:00 - 19:59:59 111757 4.5% 31.0437.0 GB 4.9%10790.63
Apr 30 20:00:00 - 20:59:59 113489 4.5% 31.5238.4 GB 5.0%11173.58
Apr 30 21:00:00 - 21:59:59 93181 3.7% 25.8831.4 GB 4.1%9151.39
Apr 30 22:00:00 - 22:59:59 99087 3.9% 27.5231.4 GB 4.1%9146.55
Apr 30 23:00:00 - 23:59:59 164034 6.5% 45.5629.8 GB 3.9%8692.86
May 1 00:00:00 - 00:59:59 109345 4.4% 30.3724.0 GB 3.2%6987.23
May 1 01:00:00 - 01:59:59 111653 4.5% 31.0120.5 GB 2.7%5971.84
May 1 02:00:00 - 02:59:59 103601 4.1% 28.7828.9 GB 3.8%8420.60
May 1 03:00:00 - 03:59:59 71533 2.9% 19.8721.5 GB 2.8%6260.21
May 1 04:00:00 - 04:15:04 19618 0.8% 21.706.4 GB 0.8%7464.77
TOTAL: 24:00:02 2508746 100.0% 29.04761.0 GB 100.0%9235.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5075 140 0 3868 3 0 0 0 1064
2news.nask.pl 2049 14 0 239 3 0 0 0 1793
3news.icm.edu.pl 2 0 0 0 0 0 0 0 2
TOTAL: 3 7126 154 0 4107 6 0 0 0 2859

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 60
it.comp.os.win.windows10 42
it.tlc.cellulari.android 25
comp.sys.raspberry-pi 18
uk.rec.cycling.moderated 4
comp.mobile.android 1
it.comp.os.win.windows7 1
de.rec.sf.startrek 1
de.comm.software.mailreader 1
it.comp.os.win.windows8 1
TOTAL: 10 154

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

GroupsCount
pl.praca.oferowana 4
pl.sci.matematyka 1
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1460
Binary in non-binary group 703
Scoring filter (8) 54
Scoring filter (9) 20
EMP (fsl) 14
Scoring filter (11) 5
Scoring filter (10) 3
Scoring filter (18) 3
Scoring filter (12) 2
Too many newsgroups 2
Scoring filter (13) 1
Scoring filter (14) 1
HTML post 1
TOTAL: 13 2269

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 4
TOTAL: 1 4
Including strange strings
newsfeed.pionier.net.pl 404
news.nask.pl 178
TOTAL: 2 582
TOTAL: 2 586

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 25718 506 9172 117 8 35286 1%23:59:55
2poznan 14109 325 8240 24 0 0 2%23:59:59
3icm 24313 27 17586 6 0 1 0%23:51:21
4nask 4261 6 3028 0 0 0 0%23:53:00
5okapi 0 0 0 0 0 1061 0%23:57:52
TOTAL: 5 68401 864 38026 147 8 36348 1%119:42:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm7.0 MB29.3 KB7.0 MB0.1 KB/s218.5 KB23:51:21
2panorama1.7 MB389.5 KB2.1 MB0.0 KB/s3.4 KB23:59:55
3poznan1.1 MB87.5 KB1.2 MB0.0 KB/s3.4 KB23:59:59
4nask15.1 KB0.0 KB15.1 KB0.0 KB/s2.5 KB23:53:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 59.8 MB506.3 KB10.3 MB0.0 KB/s10.4 KB119:42:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
10890788407.static.corbina.ru 2 120189.9 KB 2 0 000:00:44
2web.man.lodz.pl 288 2220.4 KB 9 0 000:00:22
3staticline-31-182-246-40.toya.net.pl 2 10.8 KB 1 0 000:38:41
4isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 4 297 143211.1 KB 12 5 006:20:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.static.corbina.ru 2 120189.9 KB 2 0 000:00:44
2*.man.lodz.pl 677 2220.4 KB 9 5 000:00:27
3*.toya.net.pl 2 10.8 KB 1 0 000:38:41
4unresolved 3 00.0 KB 0 0 005:40:10
TOTAL: 4 684 143211.1 KB 12 5 006:20:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.40.54 10.000 15.604 0.00005:40:10
staticline-31-182-246-40.toya.net.pl 0.056 0.044 0.00000:38:41
0890788407.static.corbina.ru 0.028 0.084 0.00000:00:44
web.man.lodz.pl 1.488 3.848 0.00000:00:22
mon.man.lodz.pl 1.152 3.068 0.00000:00:03
david.man.lodz.pl 0.356 1.060 0.00000:00:01
isvcs01.man.lodz.pl 0.032 0.044 0.00000:00:00
TOTAL: 7 13.112 23.752 0.00006:20:04

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
89.38.40.54 3
TOTAL: 3 387

NNRP client timeouts [Top 20]:

SystemConnPeer
staticline-31-182-246-40.toya.net.pl 1 0
89.38.40.54 1 1
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 120 83.9%
2pl 22 15.4%
3lodz 1 0.7%
TOTAL: 3 143100.0%

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

NewsgroupCount
1lodman.info 120
2pl.comp.pecet 12
3pl.comp.os.ms-windows.winnt 10
4lodz.test 1
TOTAL: 4 143