Daily Usenet report

Jul 11 04:15:02 -- Jul 12 04:15:03

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Jul 11 06:42:57 newsfeed overchan[21818]: input line too long, skipping
Jul 11 08:06:33 newsfeed nnrpd[31133]: SERVER perl filter not defined
Jul 11 08:52:18 newsfeed nnrpd[404]: SERVER perl filter not defined
Jul 11 08:54:19 newsfeed nnrpd[421]: SERVER perl filter not defined
Jul 11 09:13:08 newsfeed nnrpd[1219]: SERVER perl filter not defined
Jul 11 11:56:46 newsfeed nnrpd[7304]: SERVER perl filter not defined
Jul 11 11:56:58 newsfeed nnrpd[7305]: SERVER perl filter not defined
Jul 11 12:17:50 newsfeed nnrpd[8071]: SERVER perl filter not defined
Jul 11 12:39:13 newsfeed nnrpd[8816]: SERVER perl filter not defined
Jul 11 12:51:56 newsfeed overchan[21818]: input line too long, skipping
Jul 11 13:04:04 newsfeed nnrpd[9834]: SERVER perl filter not defined
Jul 11 13:04:53 newsfeed nnrpd[9846]: SERVER perl filter not defined
Jul 11 15:15:27 newsfeed nnrpd[15003]: SERVER perl filter not defined
Jul 11 15:15:43 newsfeed nnrpd[15004]: SERVER perl filter not defined
Jul 11 15:32:16 newsfeed nnrpd[15671]: SERVER perl filter not defined
Jul 11 15:55:00 newsfeed overchan[21818]: input line too long, skipping
Jul 11 16:31:59 newsfeed nnrpd[17922]: SERVER perl filter not defined
Jul 11 16:33:11 newsfeed nnrpd[17923]: SERVER perl filter not defined
Jul 11 16:38:53 newsfeed nnrpd[18053]: SERVER perl filter not defined
Jul 11 19:03:07 newsfeed nnrpd[23565]: SERVER perl filter not defined
Jul 11 19:34:50 newsfeed nnrpd[24700]: SERVER perl filter not defined
Jul 11 22:55:54 newsfeed nnrpd[32275]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2450628 97.2%288.7 MB 96.9%
innfeed 46030 1.8%5.4 MB 1.8%
innd 20138 0.8%3.2 MB 1.1%
nnrpd 4885 0.2%519.9 KB 0.2%
overchan 4 0.0%0.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62521686 100.0%297.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2428817 97.4%
Negative hits 51104 2.0%
Positive hits 14085 0.6%
Cache misses 126 0.0%
TOTAL: 4 2494132 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.494 0.0%216 0.000 16.176 127.000
article cleanup00:00:34.188 0.0%2447596 0.010 0.014 0.020
article logging00:01:28.422 0.1%2448269 0.028 0.036 0.116
article parse01:01:57.588 4.3%209632835 0.011 0.018 0.027
article write00:22:32.704 1.6%2439393 0.389 0.555 1.039
artlog/artcncl00:00:00.004 0.0%213 0.000 0.019 0.111
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:00.848 0.2%225796518 0.001 0.001 0.002
hisgrep/artcncl00:00:01.117 0.0%212 0.000 5.269 94.333
hishave/artcncl00:00:00.013 0.0%216 0.000 0.060 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:12.465 0.2%2509944 0.030 0.077 0.210
history sync00:00:00.010 0.0%290 0.000 0.034 0.500
history write02:01:20.876 8.4%2443120 0.245 2.980 12.448
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle13:28:15.767 56.1%154456426 0.217 0.314 0.722
nntp read01:15:44.924 5.3%207760770 0.016 0.022 0.035
overview write00:00:12.778 0.0%2439393 0.004 0.005 0.008
perl filter04:53:41.332 20.4%2443120 5.934 7.213 9.753
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:46.165 0.3%4904003 0.037 0.046 0.067
TOTAL: 24:00:01.43123:15:52.695 96.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.177 0.0%69443 0.000 0.003 0.014
article prepare00:00:00.005 0.0%13968 0.000 0.000 0.016
article read00:00:28.413 0.0%3482 0.000 8.160 296.800
backlog stats00:00:00.166 0.0%206669 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.955 0.0%110280 0.005 0.018 0.047
data write00:00:06.033 0.0%87410 0.018 0.069 0.333
idle23:52:37.608 99.9%206669 159.914 415.919 780.070
status file00:00:13.980 0.0%16583 0.607 0.843 1.300
TOTAL: 23:53:40.31623:53:28.337100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:07:59.273 97.2%6930 0.000 69.159 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.382 0.1%14344 0.000 0.027 0.500
readart00:00:00.000 0.0%14 0.000 0.000 0.000
TOTAL: 00:08:13.06400:07:59.655 97.3%----

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 918 24412972435008 1869 4420 99%379:47:30
2news.nask.pl 2 17628 6394 7458 3776 36%24:06:16
3news.icm.edu.pl 49 339 27 290 22 7%17:33:14
4localhost 20 19 19 0 0 100%00:00:00
TOTAL: 4 989 24592832441448 9617 8218 99%421:27:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl816.7 GB28.7 MB40.3 MB816.8 GB 99%351.1 KB
2news.nask.pl35.4 MB977.4 KB29.0 MB65.4 MB 54%6.6 KB
3news.icm.edu.pl1.1 MB27.6 KB386.0 KB1.5 MB 72%30.5 KB
4localhost33.8 KB0.0 KB0.0 KB33.8 KB100%1.8 KB
TOTAL: 4816.7 GB29.7 MB69.7 MB816.8 GB 99%349.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 11 04:15:02 - 04:59:59 69647 2.9% 25.8126.2 GB 3.2%10177.62
Jul 11 05:00:00 - 05:59:59 106959 4.4% 29.7138.8 GB 4.8%11310.62
Jul 11 06:00:00 - 06:59:59 108683 4.5% 30.1939.0 GB 4.8%11359.34
Jul 11 07:00:00 - 07:59:59 114844 4.7% 31.9040.3 GB 4.9%11724.28
Jul 11 08:00:00 - 08:59:59 112923 4.6% 31.3737.1 GB 4.5%10808.60
Jul 11 09:00:00 - 09:59:59 106066 4.3% 29.4633.1 GB 4.1%9638.18
Jul 11 10:00:00 - 10:59:59 128573 5.3% 35.7138.8 GB 4.7%11289.49
Jul 11 11:00:00 - 11:59:59 134554 5.5% 37.3841.4 GB 5.1%12049.61
Jul 11 12:00:00 - 12:59:59 132275 5.4% 36.7440.7 GB 5.0%11849.72
Jul 11 13:00:00 - 13:59:59 129984 5.3% 36.1140.1 GB 4.9%11688.04
Jul 11 14:00:00 - 14:59:59 130455 5.3% 36.2439.6 GB 4.8%11524.04
Jul 11 15:00:00 - 15:59:59 135648 5.6% 37.6841.7 GB 5.1%12143.69
Jul 11 16:00:00 - 16:59:59 119634 4.9% 33.2340.2 GB 4.9%11718.51
Jul 11 17:00:00 - 17:59:59 97630 4.0% 27.1235.3 GB 4.3%10276.83
Jul 11 18:00:00 - 18:59:59 109740 4.5% 30.4838.5 GB 4.7%11227.00
Jul 11 19:00:00 - 19:59:59 111000 4.5% 30.8336.7 GB 4.5%10677.74
Jul 11 20:00:00 - 20:59:59 55431 2.3% 15.4020.4 GB 2.5%5950.07
Jul 11 21:00:00 - 21:59:59 45113 1.8% 12.5314.1 GB 1.7%4117.18
Jul 11 22:00:00 - 22:59:59 44988 1.8% 12.5014.6 GB 1.8%4263.19
Jul 11 23:00:00 - 23:59:59 46136 1.9% 12.8217.2 GB 2.1%5010.36
Jul 12 00:00:00 - 00:59:59 65437 2.7% 18.1822.9 GB 2.8%6669.88
Jul 12 01:00:00 - 01:59:59 90194 3.7% 25.0535.1 GB 4.3%10224.98
Jul 12 02:00:00 - 02:59:59 108615 4.4% 30.1738.2 GB 4.7%11115.21
Jul 12 03:00:00 - 03:59:59 109058 4.5% 30.2936.9 GB 4.5%10742.09
Jul 12 04:00:00 - 04:15:03 27963 1.1% 30.979.3 GB 1.1%10781.17
TOTAL: 24:00:01 2441550 100.0% 28.26816.1 GB 100.0%9904.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4956 213 0 4110 4 0 0 0 629
2news.nask.pl 3884 40 0 363 4 0 0 0 3477
3news.icm.edu.pl 25 0 0 3 0 0 0 0 22
TOTAL: 3 8865 253 0 4476 8 0 0 0 4128

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 99
comp.sys.raspberry-pi 37
comp.mobile.ipad 36
comp.mobile.android 24
it.tlc.cellulari.android 21
it.comp.os.win.windows10 18
it.comp.os.win.windows7 10
nl.comp.os.linux.techniek 3
alt.sex.telephones 2
it.comp.os.linux.ubuntu 2
de.comp.lang.php 1
TOTAL: 11 253

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

GroupsCount
pl.praca.oferowana 7
bit.listserv.catholic 1
TOTAL: 2 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3026
Binary in non-binary group 222
EMP (phl) 155
Scoring filter (8) 34
Scoring filter (10) 6
Scoring filter (9) 6
HTML post 3
Too many newsgroups 2
Scoring filter (11) 1
TOTAL: 9 3455

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 537
news.nask.pl 133
news.icm.edu.pl 3
TOTAL: 3 673
TOTAL: 1 673

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 48917 465 20608 211 6 48478 0%23:59:58
2poznan 9562 174 6159 33 0 1 1%23:59:58
3icm 33406 98 21698 2110 0 0 0%23:59:58
4nask 14375 16 8559 2 0 1 0%23:59:56
5okapi 0 0 0 0 0 2398 0%23:57:51
TOTAL: 5 106260 753 57024 2356 6 50878 0%119:57:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.2 MB617.9 MB620.2 MB7.4 KB/s287.6 KB23:59:58
2panorama1.3 MB688.2 KB2.0 MB0.0 KB/s3.0 KB23:59:58
3poznan576.6 KB103.4 KB680.0 KB0.0 KB/s3.3 KB23:59:58
4nask32.1 KB7.0 KB39.1 KB0.0 KB/s2.2 KB23:59:56
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 54.1 MB618.7 MB622.9 MB1.5 KB/s205.1 KB119:57:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1411.0 KB 7 0 000:00:24
2isvcs01.man.lodz.pl 19 00.0 KB 0 19 000:00:02
TOTAL: 2 307 1411.0 KB 7 19 000:08:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 691 1411.0 KB 7 19 000:00:31
2unresolved 2 00.0 KB 0 0 000:07:38
3*.binaryedge.ninja 1 00.0 KB 0 0 000:00:01
TOTAL: 3 694 1411.0 KB 7 19 000:08:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.193.25 0.208 0.444 0.00000:07:38
web.man.lodz.pl 1.232 5.344 0.00000:00:24
mon.man.lodz.pl 1.088 4.744 0.00000:00:04
isvcs01.man.lodz.pl 0.108 0.372 0.00000:00:02
min-extra-grab-50-usnj-prod.binaryedge.ninja 0.008 0.016 0.00000:00:01
david.man.lodz.pl 0.392 1.708 0.00000:00:01
TOTAL: 6 3.036 12.628 0.00000:08:12

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
185.48.193.25 2
min-extra-grab-50-usnj-prod.binaryedge.ninja 1
TOTAL: 4 387

Newsgroup request counts (by category):

CategoryCountPct
1pl 14100.0%
TOTAL: 1 14100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 8
2pl.comp.pecet 6
TOTAL: 2 14