Daily Usenet report

May 25 04:15:02 -- May 26 04:15:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

May 25 08:54:55 newsfeed nnrpd[12421]: SERVER perl filter not defined
May 25 08:56:15 newsfeed nnrpd[12466]: SERVER perl filter not defined
May 25 09:08:12 newsfeed nnrpd[13025]: SERVER perl filter not defined
May 25 10:41:49 newsfeed overchan[1502]: input line too long, skipping
May 25 11:23:51 newsfeed nnrpd[17923]: SERVER perl filter not defined
May 25 11:27:39 newsfeed nnrpd[17984]: SERVER perl filter not defined
May 25 15:58:33 newsfeed nnrpd[28107]: SERVER perl filter not defined
May 25 17:13:46 newsfeed overchan[1502]: input line too long, skipping
May 25 17:37:28 newsfeed overchan[1502]: input line too long, skipping
May 25 17:43:19 newsfeed overchan[1502]: input line too long, skipping
May 25 18:07:35 newsfeed overchan[1502]: input line too long, skipping
May 25 18:11:17 newsfeed overchan[1502]: input line too long, skipping
May 25 18:25:03 newsfeed overchan[1502]: input line too long, skipping
May 25 21:37:47 newsfeed overchan[1502]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2567932 97.2%292.7 MB 96.8%
innfeed 49327 1.9%5.9 MB 1.9%
innd 19055 0.7%3.2 MB 1.1%
nnrpd 5000 0.2%536.7 KB 0.2%
overchan 9 0.0%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62641324 100.0%302.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2516486 89.5%
Negative hits 232780 8.3%
Positive hits 62469 2.2%
Cache misses 139 0.0%
TOTAL: 4 2811874 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.837 0.0%160 0.000 17.731 646.000
article cleanup00:00:32.205 0.0%2565875 0.008 0.013 0.017
article logging00:01:47.826 0.1%2566614 0.030 0.042 0.077
article parse00:47:20.907 3.3%90086617 0.020 0.032 0.045
article write00:19:28.661 1.4%2520242 0.226 0.464 0.761
artlog/artcncl00:00:00.006 0.0%160 0.000 0.037 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:39.815 0.3%105087890 0.001 0.002 0.004
hisgrep/artcncl00:00:00.505 0.0%156 0.000 3.237 42.000
hishave/artcncl00:00:00.113 0.0%160 0.000 0.706 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:43:37.907 3.0%2819142 0.053 0.929 5.152
history sync00:00:00.023 0.0%290 0.000 0.079 0.500
history write02:01:59.963 8.5%2523148 0.355 2.901 7.807
hiswrite/artcncl00:00:00.005 0.0%4 0.000 1.250 1.667
idle13:50:25.659 57.7%71557149 0.438 0.696 2.344
nntp read01:06:29.823 4.6%88365412 0.025 0.045 0.065
overview write00:00:13.661 0.0%2520242 0.004 0.005 0.008
perl filter04:29:45.273 18.7%2523147 4.450 6.415 8.038
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:19.644 0.4%5131413 0.034 0.062 0.087
TOTAL: 24:00:04.87223:30:44.833 98.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.540 0.0%242790 0.000 0.002 0.006
article prepare00:00:00.010 0.0%31520 0.000 0.000 0.007
article read00:01:05.990 0.1%7595 0.000 8.689 268.000
backlog stats00:00:00.351 0.0%543371 0.000 0.001 0.003
callbacks00:00:00.000 0.0%8 0.000 0.000 0.000
data read00:00:04.879 0.0%323508 0.005 0.015 0.026
data write00:00:13.218 0.0%234529 0.019 0.056 0.110
idle23:49:48.790 99.9%543371 7.429 157.883 343.714
status file00:00:16.688 0.0%16441 0.000 1.015 2.000
TOTAL: 23:51:49.02223:51:30.466100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:27.777 91.2%3245 0.000 45.540 862.100
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.281 0.2%7187 0.000 0.039 0.737
readart00:00:00.067 0.0%74 0.000 0.905 14.500
TOTAL: 00:02:42.02800:02:28.125 91.4%----

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 651 25212882469142 9678 42468 97%329:09:19
2news.nask.pl 6 65494 52394 9953 3147 79%24:23:06
3news.icm.edu.pl 36 307 53 226 28 17%19:01:56
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 700 25870952521595 19857 45643 97%372:34:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl679.2 GB14.7 GB14.8 GB708.7 GB 95%295.9 KB
2news.nask.pl15.7 GB64.3 MB86.8 MB15.8 GB 99%298.6 KB
3news.icm.edu.pl838.3 KB0.0 KB1.9 MB2.7 MB 29%34.6 KB
4localhost8.5 KB0.0 KB0.0 KB8.5 KB100%1.4 KB
TOTAL: 4694.8 GB14.8 GB14.8 GB724.5 GB 95%295.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 04:15:02 - 04:59:59 78322 3.1% 29.0323.9 GB 3.4%9283.29
May 25 05:00:00 - 05:59:59 97377 3.9% 27.0531.2 GB 4.5%9084.94
May 25 06:00:00 - 06:59:59 107147 4.2% 29.7631.8 GB 4.6%9276.95
May 25 07:00:00 - 07:59:59 91500 3.6% 25.4228.9 GB 4.2%8413.66
May 25 08:00:00 - 08:59:59 104771 4.2% 29.1032.0 GB 4.6%9334.86
May 25 09:00:00 - 09:59:59 120111 4.8% 33.3637.3 GB 5.4%10863.64
May 25 10:00:00 - 10:59:59 113473 4.5% 31.5236.9 GB 5.3%10738.11
May 25 11:00:00 - 11:59:59 99597 4.0% 27.6731.8 GB 4.6%9275.29
May 25 12:00:00 - 12:59:59 94788 3.8% 26.3329.6 GB 4.3%8630.13
May 25 13:00:00 - 13:59:59 117843 4.7% 32.7335.6 GB 5.1%10376.16
May 25 14:00:00 - 14:59:59 98756 3.9% 27.4328.8 GB 4.1%8392.99
May 25 15:00:00 - 15:59:59 55759 2.2% 15.4916.9 GB 2.4%4931.71
May 25 16:00:00 - 16:59:59 78802 3.1% 21.8923.9 GB 3.4%6967.70
May 25 17:00:00 - 17:59:59 89168 3.5% 24.7725.9 GB 3.7%7541.32
May 25 18:00:00 - 18:59:59 82349 3.3% 22.8722.2 GB 3.2%6466.65
May 25 19:00:00 - 19:59:59 124946 5.0% 34.7133.4 GB 4.8%9736.93
May 25 20:00:00 - 20:59:59 154301 6.1% 42.8633.5 GB 4.8%9754.69
May 25 21:00:00 - 21:59:59 141166 5.6% 39.2126.1 GB 3.7%7588.08
May 25 22:00:00 - 22:59:59 82447 3.3% 22.9018.5 GB 2.7%5391.08
May 25 23:00:00 - 23:59:59 117428 4.7% 32.6226.2 GB 3.8%7624.98
May 26 00:00:00 - 00:59:59 101104 4.0% 28.0823.7 GB 3.4%6903.02
May 26 01:00:00 - 01:59:59 111588 4.4% 31.0031.2 GB 4.5%9074.27
May 26 02:00:00 - 02:59:59 119363 4.7% 33.1626.2 GB 3.8%7633.40
May 26 03:00:00 - 03:59:59 109854 4.4% 30.5231.5 GB 4.5%9165.12
May 26 04:00:00 - 04:15:03 29439 1.2% 32.608.2 GB 1.2%9539.85
TOTAL: 24:00:01 2521399 100.0% 29.18695.3 GB 100.0%8438.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 42949 67 0 42320 0 0 0 0 562
2news.nask.pl 3397 9 0 417 4 0 0 0 2967
3news.icm.edu.pl 31 0 0 0 0 0 0 0 31
TOTAL: 3 46377 76 0 42737 4 0 0 0 3560

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 47
it.tlc.cellulari.android 8
comp.mobile.android 8
it.comp.os.win.windows10 7
comp.sys.raspberry-pi 3
it.politica.m5s 1
uk.rec.cycling.moderated 1
de.rec.sf.startrek 1
TOTAL: 8 76

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2538
Binary in non-binary group 138
EMP (phl) 51
Scoring filter (8) 37
Scoring filter (9) 29
EMP (fsl) 9
HTML post 4
Scoring filter (18) 4
Too many newsgroups 4
Scoring filter (11) 2
Scoring filter (13) 1
Scoring filter (12) 1
Scoring filter (16) 1
Scoring filter (10) 1
Scoring filter (14) 1
TOTAL: 15 2821

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Including strange strings
newsfeed.pionier.net.pl 485
news.nask.pl 250
news.icm.edu.pl 3
TOTAL: 3 738
TOTAL: 2 739

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 158940 3026 125699 2897 28 111540 1%23:59:57
2nask 34302 948 26171 2 0 1 2%23:59:51
3poznan 13924 231 8472 19 0 0 1%23:59:56
4icm 100759 39 85568 415 0 1 0%23:59:57
5okapi 0 0 0 0 0 910 0%23:57:50
TOTAL: 5 307925 4244 245910 3333 28 112452 1%119:57:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask333.8 MB391.8 KB334.1 MB4.0 KB/s360.2 KB23:59:51
2icm10.4 MB146.6 MB157.0 MB1.9 KB/s354.1 KB23:59:57
3panorama8.2 MB16.0 MB24.2 MB0.3 KB/s4.2 KB23:59:57
4poznan1.3 MB204.4 KB1.5 MB0.0 KB/s6.3 KB23:59:56
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 5353.6 MB163.2 MB516.9 MB1.2 KB/s69.9 KB119:57:31
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6259.7 KB 31 0 000:00:23
20890788407.static.corbina.ru 15 68.5 KB 3 0 000:02:11
3isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 3 309 6868.2 KB 34 6 000:02:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 678 6259.7 KB 31 6 000:00:29
2*.static.corbina.ru 15 68.5 KB 3 0 000:02:11
TOTAL: 2 693 6868.2 KB 34 6 000:02:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
0890788407.static.corbina.ru 0.096 0.328 0.00000:02:11
web.man.lodz.pl 1.624 5.900 0.00000:00:23
mon.man.lodz.pl 1.452 5.424 0.00000:00:03
david.man.lodz.pl 0.428 1.756 0.00000:00:01
isvcs01.man.lodz.pl 0.048 0.156 0.00000:00:00
TOTAL: 5 3.648 13.564 0.00000:02:41

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 62 91.2%
2lodman 6 8.8%
TOTAL: 2 68100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 34
2pl.comp.pecet 28
3lodman.info 6
TOTAL: 3 68