Daily Usenet report

Apr 16 04:15:02 -- Apr 17 04:15:01

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Apr 16 08:03:37 newsfeed overchan[10049]: input line too long, skipping
Apr 16 08:04:45 newsfeed overchan[10049]: input line too long, skipping
Apr 16 09:28:16 newsfeed overchan[10049]: input line too long, skipping
Apr 16 11:37:01 newsfeed nnrpd[1662]: SERVER perl filter not defined
Apr 16 12:56:32 newsfeed nnrpd[4539]: SERVER perl filter not defined
Apr 16 12:56:47 newsfeed nnrpd[4540]: SERVER perl filter not defined
Apr 16 12:58:12 newsfeed nnrpd[4706]: SERVER perl filter not defined
Apr 16 12:58:28 newsfeed nnrpd[4707]: SERVER perl filter not defined
Apr 16 13:45:20 newsfeed overchan[10049]: input line too long, skipping
Apr 16 14:06:15 newsfeed nnrpd[7092]: SERVER perl filter not defined
Apr 16 14:44:58 newsfeed nnrpd[8453]: SERVER perl filter not defined
Apr 16 16:21:52 newsfeed overchan[10049]: input line too long, skipping
Apr 16 16:25:29 newsfeed overchan[10049]: input line too long, skipping
Apr 16 19:42:15 newsfeed nnrpd[19312]: SERVER perl filter not defined
Apr 16 20:22:45 newsfeed overchan[10049]: input line too long, skipping
Apr 16 20:28:22 newsfeed overchan[10049]: input line too long, skipping
Apr 16 20:33:06 newsfeed nnrpd[21134]: SERVER perl filter not defined
Apr 16 20:39:32 newsfeed nnrpd[21401]: SERVER perl filter not defined
Apr 16 20:58:37 newsfeed overchan[10049]: input line too long, skipping
Apr 17 00:27:13 newsfeed overchan[10049]: input line too long, skipping
Apr 17 01:53:59 newsfeed overchan[10049]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3093863 97.7%341.2 MB 97.3%
innfeed 44034 1.4%5.2 MB 1.5%
innd 23800 0.8%3.8 MB 1.1%
nnrpd 5572 0.2%594.8 KB 0.2%
overchan 12 0.0%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63167282 100.0%350.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3075831 96.1%
Negative hits 113688 3.6%
Positive hits 10878 0.3%
Cache misses 100 0.0%
TOTAL: 4 3200497 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.143 0.0%182 0.000 22.764 1404.000
article cleanup00:00:35.280 0.0%3095774 0.008 0.011 0.015
article logging00:02:07.842 0.1%3096326 0.027 0.041 0.148
article parse00:36:11.048 2.5%84348134 0.017 0.026 0.036
article write00:15:45.497 1.1%3090883 0.162 0.306 0.451
artlog/artcncl00:00:00.002 0.0%179 0.000 0.011 0.071
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:09.979 0.2%99595288 0.001 0.002 0.006
hisgrep/artcncl00:00:01.143 0.0%177 0.000 6.458 743.000
hishave/artcncl00:00:00.088 0.0%182 0.000 0.484 12.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:26.009 2.8%3219921 0.024 0.753 5.046
history sync00:00:00.026 0.0%290 0.000 0.090 1.000
history write02:06:31.543 8.8%3093663 0.121 2.454 10.100
hiswrite/artcncl00:00:00.026 0.0%5 0.000 5.200 25.000
idle14:44:57.073 61.5%65789337 0.531 0.807 1.853
nntp read00:48:52.764 3.4%82037774 0.027 0.036 0.050
overview write00:00:14.985 0.0%3090883 0.003 0.005 0.029
perl filter04:08:20.007 17.2%3093663 2.741 4.816 6.511
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:26.245 0.4%6199748 0.037 0.053 0.067
TOTAL: 24:00:03.59623:32:43.700 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%55310 0.000 0.002 0.011
article prepare00:00:00.001 0.0%8662 0.000 0.000 0.007
article read00:00:26.295 0.0%2149 0.000 12.236 571.250
backlog stats00:00:00.113 0.0%159361 0.000 0.001 0.005
callbacks00:00:00.000 0.0%4 0.000 0.000 0.000
data read00:00:01.292 0.0%83997 0.005 0.015 0.037
data write00:00:03.112 0.0%66173 0.014 0.047 0.094
idle23:52:53.723 99.9%159361 325.175 539.490 1019.039
status file00:00:13.951 0.0%16501 0.549 0.845 3.921
TOTAL: 23:53:50.02623:53:38.599100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:44.735 94.0%4210 0.000 53.381 10039.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.298 0.1%9118 0.000 0.033 2.500
readart00:00:00.004 0.0%38 0.000 0.105 0.500
TOTAL: 00:03:58.98500:03:45.037 94.2%----

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 1281 30882013079098 6811 2292 99%446:00:51
2news.nask.pl 2 13230 8951 1691 2588 67%23:42:49
3news.icm.edu.pl 52 268 33 233 2 12%18:56:16
4localhost 11 10 10 0 0 100%00:00:00
TOTAL: 4 1346 31017093088092 8735 4882 99%488:39:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl672.0 GB14.9 MB36.2 MB672.0 GB 99%228.7 KB
2news.nask.pl31.6 MB337.3 KB24.0 MB56.0 MB 56%5.0 KB
3news.icm.edu.pl557.4 KB0.0 KB49.7 KB607.1 KB 91%17.3 KB
4localhost14.9 KB0.0 KB0.0 KB14.9 KB100%1.5 KB
TOTAL: 4672.0 GB15.2 MB60.3 MB672.1 GB 99%227.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 16 04:15:02 - 04:59:59 76667 2.5% 28.4219.9 GB 2.9%7722.21
Apr 16 05:00:00 - 05:59:59 123627 4.0% 34.3430.9 GB 4.6%9007.78
Apr 16 06:00:00 - 06:59:59 115590 3.7% 32.1131.1 GB 4.6%9052.54
Apr 16 07:00:00 - 07:59:59 95282 3.1% 26.4726.3 GB 3.9%7658.48
Apr 16 08:00:00 - 08:59:59 104345 3.4% 28.9824.6 GB 3.7%7176.23
Apr 16 09:00:00 - 09:59:59 137765 4.5% 38.2733.4 GB 5.0%9718.10
Apr 16 10:00:00 - 10:59:59 122494 4.0% 34.0329.8 GB 4.4%8679.42
Apr 16 11:00:00 - 11:59:59 97207 3.1% 27.0024.1 GB 3.6%7009.64
Apr 16 12:00:00 - 12:59:59 97777 3.2% 27.1625.1 GB 3.7%7297.46
Apr 16 13:00:00 - 13:59:59 117832 3.8% 32.7330.8 GB 4.6%8962.66
Apr 16 14:00:00 - 14:59:59 109746 3.6% 30.4826.8 GB 4.0%7814.57
Apr 16 15:00:00 - 15:59:59 110185 3.6% 30.6127.1 GB 4.0%7905.09
Apr 16 16:00:00 - 16:59:59 115423 3.7% 32.0626.7 GB 4.0%7789.21
Apr 16 17:00:00 - 17:59:59 93546 3.0% 25.9822.8 GB 3.4%6645.22
Apr 16 18:00:00 - 18:59:59 127897 4.1% 35.5327.3 GB 4.1%7955.11
Apr 16 19:00:00 - 19:59:59 133759 4.3% 37.1628.4 GB 4.2%8283.30
Apr 16 20:00:00 - 20:59:59 154844 5.0% 43.0130.7 GB 4.6%8947.55
Apr 16 21:00:00 - 21:59:59 153451 5.0% 42.6330.9 GB 4.6%8989.10
Apr 16 22:00:00 - 22:59:59 203990 6.6% 56.6634.8 GB 5.2%10130.41
Apr 16 23:00:00 - 23:59:59 172929 5.6% 48.0431.6 GB 4.7%9194.85
Apr 17 00:00:00 - 00:59:59 146088 4.7% 40.5821.1 GB 3.1%6135.86
Apr 17 01:00:00 - 01:59:59 188077 6.1% 52.2429.4 GB 4.4%8569.31
Apr 17 02:00:00 - 02:59:59 168362 5.5% 46.7729.5 GB 4.4%8594.14
Apr 17 03:00:00 - 03:59:59 100387 3.3% 27.8923.9 GB 3.5%6964.24
Apr 17 04:00:00 - 04:15:01 20972 0.7% 23.286.7 GB 1.0%7739.44
TOTAL: 23:59:59 3088242 100.0% 35.74673.6 GB 100.0%8175.29
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 2805 44 0 135 1 0 0 0 2625
2newsfeed.pionier.net.pl 2635 152 0 1977 0 0 0 0 506
3news.icm.edu.pl 2 0 0 0 0 0 0 0 2
TOTAL: 3 5442 196 0 2112 1 0 0 0 3133

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 77
it.tlc.cellulari.android 43
comp.mobile.android 20
it.comp.os.win.windows10 16
comp.mobile.ipad 12
comp.sys.raspberry-pi 11
uk.rec.cycling.moderated 4
de.rec.sf.startrek 3
it.comp.os.linux.ubuntu 3
de.comp.office-pakete.ms-office.outlook 3
de.comm.provider.telefonie 1
de.comp.lang.php 1
hr.sci.med 1
hr.alt.cellular.gsm.android 1
TOTAL: 14 196

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2195
Binary in non-binary group 311
Scoring filter (8) 23
Scoring filter (18) 15
EMP (phl) 11
Scoring filter (10) 7
Scoring filter (9) 5
Scoring filter (16) 5
Scoring filter (11) 4
EMP (fsl) 3
HTML post 1
Scoring filter (12) 1
TOTAL: 12 2581

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 343
news.nask.pl 209
TOTAL: 2 552
TOTAL: 1 552

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42644 887 14006 248 13 40360 2%23:59:57
2poznan 14878 316 8739 22 0 1 2%23:59:55
3icm 23585 33 17822 3 0 0 0%23:59:38
4nask 3740 4 2663 1 0 0 0%23:59:57
5okapi 0 0 0 0 0 1104 0%23:57:50
TOTAL: 5 84847 1240 43230 274 13 41465 1%119:57:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama2.8 MB757.6 KB3.5 MB0.0 KB/s3.2 KB23:59:57
2icm2.7 MB8.4 KB2.7 MB0.0 KB/s78.1 KB23:59:38
3poznan1.1 MB102.1 KB1.2 MB0.0 KB/s3.6 KB23:59:55
4nask6.1 KB80.1 KB86.1 KB0.0 KB/s17.2 KB23:59:57
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 56.6 MB948.1 KB7.5 MB0.0 KB/s5.1 KB119:57:17
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 289 3854.4 KB 17 0 000:00:21
2isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 2 299 3854.4 KB 17 10 000:03:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 683 3854.4 KB 17 10 000:00:26
2unresolved 2 00.0 KB 0 0 000:03:09
3*.versanet.de 184 00.0 KB 0 0 000:00:21
TOTAL: 3 869 3854.4 KB 17 10 000:03:58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.193.90 0.056 0.108 0.00000:03:09
i577ade0d.versanet.de 0.684 2.836 0.00000:00:21
web.man.lodz.pl 1.484 5.664 0.00000:00:21
mon.man.lodz.pl 1.192 4.896 0.00000:00:03
david.man.lodz.pl 0.360 1.496 0.00000:00:01
isvcs01.man.lodz.pl 0.076 0.200 0.00000:00:00
TOTAL: 6 3.852 15.200 0.00000:03:58

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
i577ade0d.versanet.de 184
david.man.lodz.pl 96
185.48.193.90 2
TOTAL: 4 570

NNRP client timeouts [Top 20]:

SystemConnPeer
185.48.193.90 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 24
2pl.comp.pecet 14
TOTAL: 2 38