Daily Usenet report

May 6 04:15:02 -- May 7 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

May 6 04:23:56 newsfeed overchan[5016]: input line too long, skipping
May 6 04:25:35 newsfeed overchan[5016]: input line too long, skipping
May 6 04:29:21 newsfeed overchan[5016]: input line too long, skipping
May 6 13:21:21 newsfeed overchan[5016]: input line too long, skipping
May 6 14:07:28 newsfeed overchan[5016]: input line too long, skipping
May 6 14:14:29 newsfeed overchan[5016]: input line too long, skipping
May 6 14:22:12 newsfeed overchan[5016]: input line too long, skipping
May 6 18:20:21 newsfeed overchan[5016]: input line too long, skipping
May 6 20:20:15 newsfeed overchan[5016]: input line too long, skipping
May 6 22:24:00 newsfeed overchan[5016]: input line too long, skipping
May 6 23:19:11 newsfeed overchan[5016]: input line too long, skipping
May 6 23:20:21 newsfeed overchan[5016]: input line too long, skipping
May 6 23:23:33 newsfeed overchan[5016]: input line too long, skipping
May 7 00:20:10 newsfeed nnrpd[18559]: SERVER perl filter not defined
May 7 00:34:03 newsfeed nnrpd[18993]: SERVER perl filter not defined
May 7 02:30:42 newsfeed overchan[5016]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2364120 97.1%272.9 MB 96.8%
innfeed 47548 2.0%5.6 MB 2.0%
innd 17367 0.7%2.9 MB 1.0%
nnrpd 4959 0.2%527.7 KB 0.2%
overchan 15 0.0%2.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62434010 100.0%281.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2356338 96.4%
Negative hits 77713 3.2%
Positive hits 9112 0.4%
Cache misses 89 0.0%
TOTAL: 4 2443252 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.436 0.0%181 0.000 7.934 107.000
article cleanup00:00:31.994 0.0%2362472 0.009 0.014 0.019
article logging00:01:51.708 0.1%2363012 0.032 0.047 0.107
article parse00:48:28.208 3.4%87851809 0.019 0.033 0.052
article write00:19:41.471 1.4%2358520 0.243 0.501 0.823
artlog/artcncl00:00:00.003 0.0%180 0.000 0.017 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:13.891 0.2%102317573 0.001 0.001 0.003
hisgrep/artcncl00:00:00.282 0.0%174 0.000 1.621 19.000
hishave/artcncl00:00:00.108 0.0%181 0.000 0.597 4.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:03:43.826 4.4%2447781 0.072 1.562 8.205
history sync00:00:00.021 0.0%290 0.000 0.072 0.500
history write01:22:32.167 5.7%2360816 0.867 2.098 3.719
hiswrite/artcncl00:00:00.022 0.0%7 0.000 3.143 5.333
idle14:34:16.771 60.7%68325894 0.550 0.768 1.549
nntp read00:59:20.684 4.1%86092484 0.026 0.041 0.066
overview write00:00:12.759 0.0%2358520 0.003 0.005 0.007
perl filter04:15:34.593 17.7%2360801 3.988 6.496 8.981
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:58.128 0.3%4733839 0.044 0.063 0.092
TOTAL: 24:00:01.58023:33:28.072 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.151 0.0%57389 0.000 0.003 0.015
article prepare00:00:00.004 0.0%9724 0.000 0.000 0.017
article read00:00:58.380 0.1%2471 0.000 23.626 372.000
backlog stats00:00:00.125 0.0%154406 0.000 0.001 0.004
callbacks00:00:00.000 0.0%40 0.000 0.000 0.000
data read00:00:01.430 0.0%79332 0.002 0.018 0.043
data write00:00:04.638 0.0%63625 0.015 0.073 0.293
idle23:52:38.683 99.9%154406 235.932 556.706 1055.247
status file00:00:14.113 0.0%16740 0.475 0.843 2.847
TOTAL: 23:54:14.89223:53:57.524100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:02:57.815 99.7%93836 0.000 116.989 54861.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.055 0.1%188359 0.000 0.037 2.000
readart00:00:00.056 0.0%45 0.000 1.244 14.333
TOTAL: 03:03:27.71803:03:04.926 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 672 23597982351477 5762 2559 99%310:07:09
2news.nask.pl 2 10286 7458 1443 1385 72%24:03:36
3news.icm.edu.pl 48 276 23 232 21 8%15:08:55
4localhost 3 2 2 0 0 100%00:00:00
TOTAL: 4 725 23703622358960 7437 3965 99%349:19:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl760.1 GB8.9 MB156.9 MB760.3 GB 99%338.7 KB
2news.nask.pl28.6 MB369.3 KB14.6 MB43.5 MB 65%5.0 KB
3news.icm.edu.pl742.1 KB0.0 KB832.0 KB1.5 MB 47%35.8 KB
4localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 4760.1 GB9.3 MB172.2 MB760.3 GB 99%337.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 6 04:15:02 - 04:59:59 56484 2.4% 20.9420.5 GB 2.7%7965.40
May 6 05:00:00 - 05:59:59 68004 2.9% 18.8927.0 GB 3.6%7870.29
May 6 06:00:00 - 06:59:59 99198 4.2% 27.5529.9 GB 3.9%8700.74
May 6 07:00:00 - 07:59:59 83609 3.5% 23.2229.6 GB 3.9%8612.00
May 6 08:00:00 - 08:59:59 105965 4.5% 29.4330.5 GB 4.0%8891.63
May 6 09:00:00 - 09:59:59 114559 4.9% 31.8228.7 GB 3.8%8353.76
May 6 10:00:00 - 10:59:59 86512 3.7% 24.0330.0 GB 4.0%8752.10
May 6 11:00:00 - 11:59:59 108041 4.6% 30.0130.2 GB 4.0%8801.23
May 6 12:00:00 - 12:59:59 101974 4.3% 28.3332.4 GB 4.3%9442.06
May 6 13:00:00 - 13:59:59 94383 4.0% 26.2233.2 GB 4.4%9677.29
May 6 14:00:00 - 14:59:59 84424 3.6% 23.4529.4 GB 3.9%8548.85
May 6 15:00:00 - 15:59:59 93049 3.9% 25.8532.8 GB 4.3%9562.17
May 6 16:00:00 - 16:59:59 117328 5.0% 32.5940.2 GB 5.3%11700.64
May 6 17:00:00 - 17:59:59 103332 4.4% 28.7036.8 GB 4.8%10704.24
May 6 18:00:00 - 18:59:59 90676 3.8% 25.1933.7 GB 4.4%9803.71
May 6 19:00:00 - 19:59:59 105770 4.5% 29.3837.7 GB 5.0%10992.84
May 6 20:00:00 - 20:59:59 93109 3.9% 25.8633.1 GB 4.4%9640.74
May 6 21:00:00 - 21:59:59 118725 5.0% 32.9839.1 GB 5.1%11392.59
May 6 22:00:00 - 22:59:59 118092 5.0% 32.8035.1 GB 4.6%10215.35
May 6 23:00:00 - 23:59:59 121876 5.2% 33.8531.6 GB 4.2%9205.80
May 7 00:00:00 - 00:59:59 104044 4.4% 28.9027.9 GB 3.7%8127.45
May 7 01:00:00 - 01:59:59 104490 4.4% 29.0229.6 GB 3.9%8622.10
May 7 02:00:00 - 02:59:59 89192 3.8% 24.7828.8 GB 3.8%8388.92
May 7 03:00:00 - 03:59:59 74447 3.2% 20.6825.5 GB 3.4%7436.25
May 7 04:00:00 - 04:15:02 22165 0.9% 24.576.8 GB 0.9%7960.62
TOTAL: 24:00:00 2359448 100.0% 27.31760.1 GB 100.0%9225.29
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2922 132 0 1529 0 0 0 0 1261
2news.nask.pl 1552 31 0 138 1 0 0 0 1382
3news.icm.edu.pl 18 0 0 0 0 0 0 0 18
TOTAL: 3 4492 163 0 1667 1 0 0 0 2661

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 84
it.tlc.cellulari.android 22
it.comp.os.win.windows10 19
comp.mobile.android 18
comp.mobile.ipad 9
comp.sys.raspberry-pi 8
it.politica.m5s 2
it.comp.os.win.windows7 1
TOTAL: 8 163

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1032
Binary in non-binary group 987
Scoring filter (8) 29
Scoring filter (9) 17
Scoring filter (10) 10
Poison newsgroup 10
EMP (phl) 8
EMP (fsl) 5
Scoring filter (18) 3
Too many newsgroups 3
Scoring filter (16) 2
Scoring filter (11) 1
TOTAL: 12 2107

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 15
TOTAL: 1 15
Including strange strings
newsfeed.pionier.net.pl 361
news.nask.pl 177
news.icm.edu.pl 1
TOTAL: 3 539
TOTAL: 2 554

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 44144 526 15464 169 90 41307 1%23:59:58
2poznan 12424 120 7354 6 0 0 0%23:59:55
3icm 21908 39 14917 998 0 0 0%23:59:58
4nask 3085 8 2066 0 0 0 0%23:59:58
5okapi 0 0 0 0 0 1043 0%23:57:51
TOTAL: 5 81561 693 39801 1173 90 42350 0%119:57:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm9.4 MB352.5 MB361.9 MB4.3 KB/s357.3 KB23:59:58
2panorama1.7 MB1.4 MB3.1 MB0.0 KB/s4.5 KB23:59:58
3poznan450.2 KB24.0 KB474.2 KB0.0 KB/s3.8 KB23:59:55
4nask92.5 KB0.0 KB92.5 KB0.0 KB/s11.6 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 511.6 MB353.9 MB365.5 MB0.9 KB/s200.6 KB119:57:40
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3634.4 KB 14 0 000:00:28
291.189.0.122 6 54.4 KB 2 0 200:14:25
30890788407.static.corbina.ru 11 23.0 KB 1 0 000:01:36
4isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:02
TOTAL: 4 307 4341.8 KB 17 2 203:03:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 674 3634.4 KB 14 2 000:00:35
2unresolved 12 54.4 KB 2 0 203:01:15
3*.static.corbina.ru 11 23.0 KB 1 0 000:01:36
TOTAL: 3 697 4341.8 KB 17 2 203:03:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89.38.40.54 6.244 10.952 0.00002:46:39
91.189.0.122 0.044 0.116 0.00000:14:25
0890788407.static.corbina.ru 0.064 0.184 0.00000:01:36
web.man.lodz.pl 1.720 5.712 0.00000:00:28
107.170.193.152 0.000 0.028 0.00000:00:09
mon.man.lodz.pl 1.356 5.680 0.00000:00:03
isvcs01.man.lodz.pl 0.016 0.028 0.00000:00:02
david.man.lodz.pl 0.472 2.076 0.00000:00:01
146.0.77.146 0.000 0.012 0.00000:00:00
TOTAL: 9 9.916 24.788 0.00003:03:26

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
89.38.40.54 4
107.170.193.152 1
146.0.77.146 1
TOTAL: 5 390

NNRP unrecognized commands (by host):

SystemConn
146.0.77.146 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
146.0.77.146 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 36 83.7%
2lodz 5 11.6%
3lodman 2 4.7%
TOTAL: 3 43100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 24
2pl.comp.pecet 12
3lodz.test 5
4lodman.info 2
TOTAL: 4 43
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>