Daily Usenet report

May 16 04:15:02 -- May 17 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

May 16 08:52:20 newsfeed nnrpd[10050]: SERVER perl filter not defined
May 16 09:40:01 newsfeed nnrpd[11703]: SERVER perl filter not defined
May 16 09:50:25 newsfeed nnrpd[12084]: SERVER perl filter not defined
May 16 10:08:50 newsfeed nnrpd[12721]: SERVER perl filter not defined
May 16 12:49:25 newsfeed nnrpd[18232]: SERVER perl filter not defined
May 16 12:50:07 newsfeed nnrpd[18293]: SERVER perl filter not defined
May 16 12:52:17 newsfeed nnrpd[18321]: SERVER perl filter not defined
May 16 12:52:37 newsfeed nnrpd[18327]: SERVER perl filter not defined
May 16 12:56:06 newsfeed nnrpd[18546]: SERVER perl filter not defined
May 16 15:37:56 newsfeed nnrpd[24154]: SERVER perl filter not defined
May 16 15:38:04 newsfeed nnrpd[24155]: SERVER perl filter not defined
May 16 15:38:15 newsfeed nnrpd[24156]: SERVER perl filter not defined
May 16 15:52:06 newsfeed nnrpd[24579]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2728631 97.0%313.9 MB 96.6%
innfeed 46121 1.6%5.5 MB 1.7%
innd 32758 1.2%5.1 MB 1.6%
nnrpd 5244 0.2%562.1 KB 0.2%
TOTAL: 42812754 100.0%325.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2678227 87.4%
Negative hits 185539 6.1%
Positive hits 162936 5.3%
Cache misses 36855 1.2%
TOTAL: 4 3063557 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:08.279 0.0%221 0.000 37.462 2023.000
article cleanup00:00:38.052 0.0%2728839 0.005 0.014 0.027
article logging00:01:34.277 0.1%2729451 0.016 0.035 1.094
article parse01:20:48.439 5.6%173688712 0.012 0.028 0.077
article write00:32:45.113 2.3%2666189 0.385 0.737 4.986
artlog/artcncl00:00:00.005 0.0%202 0.000 0.025 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:03:15.329 0.2%191433833 0.000 0.001 0.004
hisgrep/artcncl00:00:00.814 0.0%194 0.000 4.196 283.000
hishave/artcncl00:00:00.167 0.0%221 0.000 0.756 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:37:42.734 2.6%3065014 0.018 0.738 20.181
history sync00:00:00.020 0.0%292 0.000 0.068 1.000
history write00:51:04.674 3.5%2679730 0.239 1.144 34.246
hiswrite/artcncl00:00:00.035 0.0%27 0.000 1.296 12.000
idle11:56:20.046 49.7%123164528 0.137 0.349 1.314
nntp read01:09:51.418 4.9%171708700 0.015 0.024 0.045
overview write00:00:16.025 0.0%2666189 0.001 0.006 0.014
perl filter06:36:18.530 27.5%2679728 4.226 8.873 13.185
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:17.153 0.4%5690956 0.034 0.056 0.097
TOTAL: 24:00:15.40323:16:01.110 96.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:02.418 0.0%965430 0.000 0.003 0.030
article prepare00:00:00.426 0.0%1430374 0.000 0.000 0.050
article read01:14:27.535 5.2%355347 0.000 12.572 215.333
backlog stats00:00:02.544 0.0%3892208 0.000 0.001 0.008
callbacks00:00:00.000 0.0%16 0.000 0.000 0.000
data read00:00:19.657 0.0%1521818 0.000 0.013 0.040
data write00:04:25.344 0.3%2480367 0.000 0.107 0.447
idle22:39:41.158 94.4%3892208 1.989 20.960 542.099
status file00:00:13.830 0.0%16138 0.250 0.857 43.833
TOTAL: 24:00:23.00823:59:12.912 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:07:19.017 99.9%22294 0.000 665.606450155.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.912 0.0%45766 0.000 0.020 0.500
readart00:00:06.124 0.0%273 0.000 22.432 65.375
TOTAL: 04:07:41.30704:07:26.053 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 608 26677862612459 6347 48980 97%287:42:39
2news.nask.pl 6 210303 52745 143903 13655 25%18:28:50
3news.icm.edu.pl 38 309 88 213 8 28%18:29:15
4localhost 14 13 13 0 0 100%00:00:00
TOTAL: 4 666 28784112665305 150463 62643 92%324:40:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl874.5 GB16.5 GB16.7 GB907.7 GB 96%357.6 KB
2news.nask.pl17.1 GB284.6 MB432.4 MB17.8 GB 96%280.5 KB
3news.icm.edu.pl2.6 MB17.3 KB159.8 KB2.8 MB 93%30.1 KB
4localhost19.9 KB0.0 KB0.0 KB19.9 KB100%1.5 KB
TOTAL: 4891.6 GB16.8 GB17.1 GB925.4 GB 96%355.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 16 04:15:02 - 04:59:59 68393 2.6% 25.3528.5 GB 3.2%11072.72
May 16 05:00:00 - 05:59:59 100880 3.8% 28.0239.1 GB 4.4%11398.58
May 16 06:00:00 - 06:59:59 109393 4.1% 30.3939.0 GB 4.4%11360.96
May 16 07:00:00 - 07:59:59 110939 4.2% 30.8239.0 GB 4.4%11371.97
May 16 08:00:00 - 08:59:59 104836 3.9% 29.1239.2 GB 4.4%11406.18
May 16 09:00:00 - 09:59:59 113931 4.3% 31.6539.8 GB 4.5%11586.69
May 16 10:00:00 - 10:59:59 114524 4.3% 31.8139.6 GB 4.4%11523.24
May 16 11:00:00 - 11:59:59 120475 4.5% 33.4740.3 GB 4.5%11731.96
May 16 12:00:00 - 12:59:59 116720 4.4% 32.4239.1 GB 4.4%11391.85
May 16 13:00:00 - 13:59:59 115338 4.3% 32.0437.3 GB 4.2%10863.25
May 16 14:00:00 - 14:59:59 116138 4.4% 32.2638.5 GB 4.3%11206.67
May 16 15:00:00 - 15:59:59 126346 4.7% 35.1038.5 GB 4.3%11204.49
May 16 16:00:00 - 16:59:59 126957 4.8% 35.2739.5 GB 4.4%11511.07
May 16 17:00:00 - 17:59:59 108281 4.1% 30.0837.8 GB 4.2%11005.90
May 16 18:00:00 - 18:59:59 112264 4.2% 31.1835.9 GB 4.0%10450.13
May 16 19:00:00 - 19:59:59 131090 4.9% 36.4139.1 GB 4.4%11387.33
May 16 20:00:00 - 20:59:59 131319 4.9% 36.4840.2 GB 4.5%11704.12
May 16 21:00:00 - 21:59:59 119909 4.5% 33.3138.2 GB 4.3%11113.05
May 16 22:00:00 - 22:59:59 116306 4.4% 32.3140.6 GB 4.6%11820.02
May 16 23:00:00 - 23:59:59 109055 4.1% 30.2934.9 GB 3.9%10156.81
May 17 00:00:00 - 00:59:59 91898 3.4% 25.5328.0 GB 3.1%8143.07
May 17 01:00:00 - 01:59:59 110478 4.1% 30.6935.1 GB 3.9%10237.32
May 17 02:00:00 - 02:59:59 109404 4.1% 30.3934.3 GB 3.8%9983.92
May 17 03:00:00 - 03:59:59 64885 2.4% 18.0224.1 GB 2.7%7026.61
May 17 04:00:00 - 04:15:02 15401 0.6% 17.075.8 GB 0.6%6730.90
TOTAL: 24:00:00 2665160 100.0% 30.85891.2 GB 100.0%10815.42
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 49506 234 0 47887 5 0 0 0 1380
2news.nask.pl 13753 1 0 1222 11 0 0 012519
3news.icm.edu.pl 10 0 0 2 0 0 0 0 8
TOTAL: 3 63269 235 0 49111 16 0 0 013907

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 104
it.comp.os.win.windows10 68
it.tlc.cellulari.android 35
it.comp.os.win.windows8 13
comp.mobile.android 5
hr.ponuda.hardver.komponente 5
it.comp.os.win.windows7 3
it.discussioni.energia 1
de.comp.lang.vbclassic 1
TOTAL: 9 235

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

GroupsCount
pl.praca.oferowana 8
pl.sci.matematyka 5
pl.sci.historia 1
bit.listserv.catholic 1
christnet.theology 1
TOTAL: 5 16

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9564
Binary in non-binary group 1904
EMP (phl) 639
Scoring filter (8) 455
PFM bot misc 260
Poison newsgroup 173
Scoring filter (9) 130
Scoring filter (10) 32
Scoring filter (12) 27
Scoring filter (11) 26
EMP (fsl) 20
HTML post 19
Scoring filter (13) 11
Scoring filter (14) 9
Scoring filter (18) 5
Scoring filter (15) 4
Adult group ECP 3
Scoring filter (19) 3
Attached HTML file 2
Scoring filter (17) 2
TOTAL: 24 13292

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 557664 303677 177136 502 43 93266 54%23:53:31
2icm 410820 25930 305993 21755 0 427 6%24:03:34
3panorama 317034 3413 285396 1036 34 358044 1%24:00:04
4poznan 11687 639 6899 338 0 0 5%20:46:33
5okapi 0 0 0 0 0 2970 0%24:00:06
TOTAL: 51297205 333659 775424 23631 77 454707 25%116:43:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask108.5 GB178.3 MB108.7 GB1.3 MB/s374.7 KB23:53:31
2icm4.5 GB6.2 GB10.7 GB129.1 KB/s234.5 KB24:03:34
3panorama270.3 MB35.1 MB305.4 MB3.6 KB/s70.3 KB24:00:04
4poznan109.4 MB7.1 MB116.5 MB1.6 KB/s122.1 KB20:46:33
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:06
TOTAL: 5113.4 GB6.4 GB119.8 GB298.9 KB/s351.5 KB116:43:48
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama8.1 MB
okapi488.3 KB
TOTAL: 28.6 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-212-51-218-225.p.lodz.pl 11 192394.7 KB 5 0 002:55:29
2web.man.lodz.pl 288 6658.9 KB 30 0 000:00:25
3pc-vicki.man.lodz.pl 1 15.5 KB 1 0 000:30:06
4isvcs01.man.lodz.pl 13 00.0 KB 0 13 000:00:01
TOTAL: 4 313 259459.1 KB 36 13 004:07:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.p.lodz.pl 11 192394.7 KB 5 0 002:55:29
2*.man.lodz.pl 686 6764.3 KB 31 13 000:30:37
3*.toya.net.pl 67 00.0 KB 0 0 000:00:05
4unresolved 5 00.0 KB 0 0 000:41:28
TOTAL: 4 769 259459.1 KB 36 13 004:07:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.071 0.232 0.00002:55:29
185.48.194.153 1.073 1.621 0.00000:41:12
pc-vicki.man.lodz.pl 0.005 0.015 0.00000:30:06
web.man.lodz.pl 0.951 4.205 0.00000:00:25
212.51.203.199 0.009 0.019 0.00000:00:13
staticline41435.toya.net.pl 0.223 0.939 0.00000:00:05
mon.man.lodz.pl 0.934 3.681 0.00000:00:03
isvcs01.man.lodz.pl 0.070 0.239 0.00000:00:01
199.189.26.20 0.007 0.014 0.00000:00:01
david.man.lodz.pl 0.307 1.217 0.00000:00:01
TOTAL: 10 3.650 12.182 0.00004:07:41

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 67
185.48.194.153 2
212.51.203.199 2
199.189.26.20 1
TOTAL: 6 456

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-212-51-218-225.p.lodz.pl 3 1
pc-vicki.man.lodz.pl 1 0
TOTAL: 2 4 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 259100.0%
TOTAL: 1 259100.0%

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

NewsgroupCount
1pl.misc.elektronika 132
2pl.misc.kolej 60
3pl.comp.pecet 56
4pl.comp.os.ms-windows.winnt 10
5pl.sci.medycyna 1
TOTAL: 5 259